2025-10-27 03:16:32,613 - INFO - Domain Default found not creating
2025-10-27 03:16:32,781 - INFO - Project ctest-TestSvcHC-99437539 not found, creating it
2025-10-27 03:16:33,315 - INFO - Created Project:ctest-TestSvcHC-99437539, ID : c9ac7390-e193-4b8b-9d93-9337d1127328
2025-10-27 03:16:34,865 - INFO - ================================================================================
2025-10-27 03:16:34,865 - INFO - STARTING TEST : test_svc_hc_basic
2025-10-27 03:16:36,179 - DEBUG - Nothing to compare xmpp stats {'10.0.0.130': {'10.20.0.25': '0', '10.20.0.17': '0'}, '10.0.0.131': {'10.20.0.17': '0', '10.20.0.14': '0'}} with
2025-10-27 03:16:36,179 - INFO - Initial checks done. Running the testcase now
2025-10-27 03:16:36,179 - INFO -
2025-10-27 03:16:36,913 - DEBUG - Response for create_network : {'network': {'id': '1e64abfd-f0bd-42e7-9c05-37ad71133b52', 'name': 'ctest-mgmt_vn-85978156', 'tenant_id': 'c9ac7390e1934b8b9d939337d1127328', 'project_id': 'c9ac7390e1934b8b9d939337d1127328', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-99437539', 'ctest-mgmt_vn-85978156'], 'port_security_enabled': True, 'description': ''}}
2025-10-27 03:16:37,258 - DEBUG - Response for create_subnet : {'subnet': {'id': '1577740b-c8d9-4f8d-baff-af53180117b9', 'name': '', 'tenant_id': 'c9ac7390e1934b8b9d939337d1127328', 'network_id': '1e64abfd-f0bd-42e7-9c05-37ad71133b52', 'ip_version': 4, 'cidr': '80.50.220.0/26', 'allocation_pools': [{'start': '80.50.220.2', 'end': '80.50.220.62'}], 'gateway_ip': '80.50.220.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '80.50.220.2', 'tags': [], 'project_id': 'c9ac7390e1934b8b9d939337d1127328'}}
2025-10-27 03:16:37,302 - INFO - Created VN ctest-mgmt_vn-85978156
2025-10-27 03:16:37,315 - DEBUG - VN ctest-mgmt_vn-85978156 UUID is 1e64abfd-f0bd-42e7-9c05-37ad71133b52
2025-10-27 03:16:37,450 - DEBUG - Requesting: http://10.0.0.249:8082/domains
2025-10-27 03:16:37,806 - DEBUG - Requesting: http://10.0.0.249:8082/domains
2025-10-27 03:16:37,841 - DEBUG - Requesting: http://10.0.0.249:8082/domain/8213efff-6224-4943-8f79-85cc33013f73
2025-10-27 03:16:37,861 - DEBUG - Requesting: http://10.0.0.249:8082/project/c9ac7390-e193-4b8b-9d93-9337d1127328
2025-10-27 03:16:37,961 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/1e64abfd-f0bd-42e7-9c05-37ad71133b52
2025-10-27 03:16:37,985 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/1e64abfd-f0bd-42e7-9c05-37ad71133b52
2025-10-27 03:16:38,005 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/9f3d71f0-f0a2-48a9-9e27-ff2119d281d8
2025-10-27 03:16:38,018 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/9f3d71f0-f0a2-48a9-9e27-ff2119d281d8
2025-10-27 03:16:38,029 - DEBUG - Requesting: http://10.0.0.249:8082/route-target/4be97753-bb72-4f87-941d-543620f2a7f1
2025-10-27 03:16:38,038 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-27 03:16:38,038 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/1e64abfd-f0bd-42e7-9c05-37ad71133b52
2025-10-27 03:16:38,049 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/9f3d71f0-f0a2-48a9-9e27-ff2119d281d8
2025-10-27 03:16:38,074 - INFO - Verified VN network id 15 for VN 1e64abfd-f0bd-42e7-9c05-37ad71133b52
2025-10-27 03:16:38,075 - INFO - Verifications in API Server for VN ctest-mgmt_vn-85978156 passed
2025-10-27 03:16:38,075 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/1e64abfd-f0bd-42e7-9c05-37ad71133b52
2025-10-27 03:16:38,085 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/9f3d71f0-f0a2-48a9-9e27-ff2119d281d8
2025-10-27 03:16:38,093 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/9f3d71f0-f0a2-48a9-9e27-ff2119d281d8
2025-10-27 03:16:38,102 - DEBUG - Requesting: http://10.0.0.249:8082/route-target/4be97753-bb72-4f87-941d-543620f2a7f1
2025-10-27 03:16:38,117 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-99437539:ctest-mgmt_vn-85978156', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-99437539', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2190064425962914535', 'uuid-lslong': '11242453262866266962'}, 'enable': 'true', 'created': '2025-10-27T03:16:36', 'last-modified': '2025-10-27T03:16:37', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.923971'}
2025-10-27 03:16:38,123 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-27 03:16:38,130 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-99437539:ctest-mgmt_vn-85978156', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-99437539', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2190064425962914535', 'uuid-lslong': '11242453262866266962'}, 'enable': 'true', 'created': '2025-10-27T03:16:36', 'last-modified': '2025-10-27T03:16:37', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.943891'}
2025-10-27 03:16:38,137 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-27 03:16:38,144 - DEBUG - Control-node 10.0.0.129 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-99437539:ctest-mgmt_vn-85978156', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-99437539', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2190064425962914535', 'uuid-lslong': '11242453262866266962'}, 'enable': 'true', 'created': '2025-10-27T03:16:36', 'last-modified': '2025-10-27T03:16:37', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.968458'}
2025-10-27 03:16:38,154 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-27 03:16:38,155 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-85978156 passed
2025-10-27 03:16:38,155 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-85978156 in API_Server ======
2025-10-27 03:16:38,155 - DEBUG - Requesting: http://10.0.0.249:8082/domains
2025-10-27 03:16:38,167 - DEBUG - Requesting: http://10.0.0.249:8082/domain/8213efff-6224-4943-8f79-85cc33013f73
2025-10-27 03:16:38,183 - DEBUG - Requesting: http://10.0.0.249:8082/project/c9ac7390-e193-4b8b-9d93-9337d1127328
2025-10-27 03:16:38,297 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/1e64abfd-f0bd-42e7-9c05-37ad71133b52
2025-10-27 03:16:38,312 - DEBUG - =>VN ctest-mgmt_vn-85978156 has no policy to be verified
2025-10-27 03:16:38,312 - DEBUG - Verifying the vn in opserver
2025-10-27 03:16:38,312 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-99437539:ctest-mgmt_vn-85978156 virtual network link through opserver 10.0.0.249
2025-10-27 03:16:38,312 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2025-10-27 03:16:38,722 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2025-10-27 03:16:38,797 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-99437539:ctest-mgmt_vn-85978156', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-99437539:ctest-mgmt_vn-85978156?flat'}
2025-10-27 03:16:38,797 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-99437539:ctest-mgmt_vn-85978156 virtual network link through opserver 10.0.0.33
2025-10-27 03:16:38,798 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2025-10-27 03:16:39,298 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2025-10-27 03:16:39,379 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-99437539:ctest-mgmt_vn-85978156', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-99437539:ctest-mgmt_vn-85978156?flat'}
2025-10-27 03:16:39,379 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-99437539:ctest-mgmt_vn-85978156 virtual network link through opserver 10.0.0.129
2025-10-27 03:16:39,379 - DEBUG - Requesting: http://10.0.0.129:8081/analytics/uves/virtual-networks
2025-10-27 03:16:39,733 - DEBUG - Requesting: http://10.0.0.129:8081/analytics/uves/virtual-networks
2025-10-27 03:16:39,807 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-99437539:ctest-mgmt_vn-85978156', 'href': 'http://10.0.0.129:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-99437539:ctest-mgmt_vn-85978156?flat'}
2025-10-27 03:16:39,807 - INFO - Validated that VN default-domain:ctest-TestSvcHC-99437539:ctest-mgmt_vn-85978156 is found in opserver
2025-10-27 03:16:39,839 - DEBUG - Do not have enough data to verify VN in agent
2025-10-27 03:16:39,851 - DEBUG - VRF ids for VN ctest-mgmt_vn-85978156: {}
2025-10-27 03:16:40,175 - DEBUG - Response for create_network : {'network': {'id': '5747b0ba-ac4a-4d1d-a33e-df0ae6021ca4', 'name': 'ctest-left_vn-84819120', 'tenant_id': 'c9ac7390e1934b8b9d939337d1127328', 'project_id': 'c9ac7390e1934b8b9d939337d1127328', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-99437539', 'ctest-left_vn-84819120'], 'port_security_enabled': True, 'description': ''}}
2025-10-27 03:16:40,451 - DEBUG - Response for create_subnet : {'subnet': {'id': '4f90856f-be25-4be9-ade6-68ebeef3dd8f', 'name': '', 'tenant_id': 'c9ac7390e1934b8b9d939337d1127328', 'network_id': '5747b0ba-ac4a-4d1d-a33e-df0ae6021ca4', 'ip_version': 4, 'cidr': '110.233.186.128/26', 'allocation_pools': [{'start': '110.233.186.130', 'end': '110.233.186.190'}], 'gateway_ip': '110.233.186.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '110.233.186.130', 'tags': [], 'project_id': 'c9ac7390e1934b8b9d939337d1127328'}}
2025-10-27 03:16:40,483 - INFO - Created VN ctest-left_vn-84819120
2025-10-27 03:16:40,497 - DEBUG - VN ctest-left_vn-84819120 UUID is 5747b0ba-ac4a-4d1d-a33e-df0ae6021ca4
2025-10-27 03:16:40,589 - DEBUG - Requesting: http://10.0.0.249:8082/domains
2025-10-27 03:16:40,597 - DEBUG - Requesting: http://10.0.0.249:8082/domain/8213efff-6224-4943-8f79-85cc33013f73
2025-10-27 03:16:40,611 - DEBUG - Requesting: http://10.0.0.249:8082/project/c9ac7390-e193-4b8b-9d93-9337d1127328
2025-10-27 03:16:40,722 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/5747b0ba-ac4a-4d1d-a33e-df0ae6021ca4
2025-10-27 03:16:40,741 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/5747b0ba-ac4a-4d1d-a33e-df0ae6021ca4
2025-10-27 03:16:40,753 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/bde29eae-178f-4425-816c-5f9d7dfe3cbb
2025-10-27 03:16:40,765 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/bde29eae-178f-4425-816c-5f9d7dfe3cbb
2025-10-27 03:16:40,774 - DEBUG - Requesting: http://10.0.0.249:8082/route-target/ec554c58-3870-4425-b1c6-e12d39ae6e51
2025-10-27 03:16:40,783 - DEBUG - Route Targets: ['target:64512:8000005']
2025-10-27 03:16:40,783 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/5747b0ba-ac4a-4d1d-a33e-df0ae6021ca4
2025-10-27 03:16:40,799 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/bde29eae-178f-4425-816c-5f9d7dfe3cbb
2025-10-27 03:16:40,827 - INFO - Verified VN network id 16 for VN 5747b0ba-ac4a-4d1d-a33e-df0ae6021ca4
2025-10-27 03:16:40,827 - INFO - Verifications in API Server for VN ctest-left_vn-84819120 passed
2025-10-27 03:16:40,828 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/5747b0ba-ac4a-4d1d-a33e-df0ae6021ca4
2025-10-27 03:16:40,838 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/bde29eae-178f-4425-816c-5f9d7dfe3cbb
2025-10-27 03:16:40,847 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/bde29eae-178f-4425-816c-5f9d7dfe3cbb
2025-10-27 03:16:40,857 - DEBUG - Requesting: http://10.0.0.249:8082/route-target/ec554c58-3870-4425-b1c6-e12d39ae6e51
2025-10-27 03:16:40,871 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-99437539:ctest-left_vn-84819120', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-99437539', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6289189720447143197', 'uuid-lslong': '11763084514639879332'}, 'enable': 'true', 'created': '2025-10-27T03:16:40', 'last-modified': '2025-10-27T03:16:40', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.474932'}
2025-10-27 03:16:40,883 - DEBUG - Route Targets: ['target:64512:8000005']
2025-10-27 03:16:40,890 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-99437539:ctest-left_vn-84819120', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-99437539', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6289189720447143197', 'uuid-lslong': '11763084514639879332'}, 'enable': 'true', 'created': '2025-10-27T03:16:40', 'last-modified': '2025-10-27T03:16:40', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.497707'}
2025-10-27 03:16:40,898 - DEBUG - Route Targets: ['target:64512:8000005']
2025-10-27 03:16:40,906 - DEBUG - Control-node 10.0.0.129 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-99437539:ctest-left_vn-84819120', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-99437539', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6289189720447143197', 'uuid-lslong': '11763084514639879332'}, 'enable': 'true', 'created': '2025-10-27T03:16:40', 'last-modified': '2025-10-27T03:16:40', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.512956'}
2025-10-27 03:16:40,914 - DEBUG - Route Targets: ['target:64512:8000005']
2025-10-27 03:16:40,915 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-84819120 passed
2025-10-27 03:16:40,915 - DEBUG - ====Verifying policy data for ctest-left_vn-84819120 in API_Server ======
2025-10-27 03:16:40,915 - DEBUG - Requesting: http://10.0.0.249:8082/domains
2025-10-27 03:16:40,923 - DEBUG - Requesting: http://10.0.0.249:8082/domain/8213efff-6224-4943-8f79-85cc33013f73
2025-10-27 03:16:40,937 - DEBUG - Requesting: http://10.0.0.249:8082/project/c9ac7390-e193-4b8b-9d93-9337d1127328
2025-10-27 03:16:41,075 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/5747b0ba-ac4a-4d1d-a33e-df0ae6021ca4
2025-10-27 03:16:41,098 - DEBUG - =>VN ctest-left_vn-84819120 has no policy to be verified
2025-10-27 03:16:41,099 - DEBUG - Verifying the vn in opserver
2025-10-27 03:16:41,099 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-99437539:ctest-left_vn-84819120 virtual network link through opserver 10.0.0.249
2025-10-27 03:16:41,099 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2025-10-27 03:16:41,179 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-99437539:ctest-left_vn-84819120', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-99437539:ctest-left_vn-84819120?flat'}
2025-10-27 03:16:41,179 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-99437539:ctest-left_vn-84819120 virtual network link through opserver 10.0.0.33
2025-10-27 03:16:41,179 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2025-10-27 03:16:41,248 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-99437539:ctest-left_vn-84819120', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-99437539:ctest-left_vn-84819120?flat'}
2025-10-27 03:16:41,249 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-99437539:ctest-left_vn-84819120 virtual network link through opserver 10.0.0.129
2025-10-27 03:16:41,249 - DEBUG - Requesting: http://10.0.0.129:8081/analytics/uves/virtual-networks
2025-10-27 03:16:41,321 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-99437539:ctest-left_vn-84819120', 'href': 'http://10.0.0.129:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-99437539:ctest-left_vn-84819120?flat'}
2025-10-27 03:16:41,321 - INFO - Validated that VN default-domain:ctest-TestSvcHC-99437539:ctest-left_vn-84819120 is found in opserver
2025-10-27 03:16:41,343 - DEBUG - Do not have enough data to verify VN in agent
2025-10-27 03:16:41,355 - DEBUG - VRF ids for VN ctest-left_vn-84819120: {}
2025-10-27 03:16:41,682 - DEBUG - Response for create_network : {'network': {'id': 'f1e592a0-f6d1-4e37-bdfd-ee6bc83ed71f', 'name': 'ctest-right_vn-68337061', 'tenant_id': 'c9ac7390e1934b8b9d939337d1127328', 'project_id': 'c9ac7390e1934b8b9d939337d1127328', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-99437539', 'ctest-right_vn-68337061'], 'port_security_enabled': True, 'description': ''}}
2025-10-27 03:16:41,973 - DEBUG - Response for create_subnet : {'subnet': {'id': 'd1a4f2c2-66e9-4a3f-961f-be16c73e5f4b', 'name': '', 'tenant_id': 'c9ac7390e1934b8b9d939337d1127328', 'network_id': 'f1e592a0-f6d1-4e37-bdfd-ee6bc83ed71f', 'ip_version': 4, 'cidr': '20.178.65.0/26', 'allocation_pools': [{'start': '20.178.65.2', 'end': '20.178.65.62'}], 'gateway_ip': '20.178.65.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '20.178.65.2', 'tags': [], 'project_id': 'c9ac7390e1934b8b9d939337d1127328'}}
2025-10-27 03:16:41,999 - INFO - Created VN ctest-right_vn-68337061
2025-10-27 03:16:42,013 - DEBUG - VN ctest-right_vn-68337061 UUID is f1e592a0-f6d1-4e37-bdfd-ee6bc83ed71f
2025-10-27 03:16:42,090 - DEBUG - Requesting: http://10.0.0.249:8082/domains
2025-10-27 03:16:42,097 - DEBUG - Requesting: http://10.0.0.249:8082/domain/8213efff-6224-4943-8f79-85cc33013f73
2025-10-27 03:16:42,110 - DEBUG - Requesting: http://10.0.0.249:8082/project/c9ac7390-e193-4b8b-9d93-9337d1127328
2025-10-27 03:16:42,207 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/f1e592a0-f6d1-4e37-bdfd-ee6bc83ed71f
2025-10-27 03:16:42,223 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/f1e592a0-f6d1-4e37-bdfd-ee6bc83ed71f
2025-10-27 03:16:42,238 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/821e02e4-6c10-4d13-a801-4d5779f546fd
2025-10-27 03:16:42,246 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/821e02e4-6c10-4d13-a801-4d5779f546fd
2025-10-27 03:16:42,254 - DEBUG - Requesting: http://10.0.0.249:8082/route-target/01e82650-3ea9-49ea-bc28-cd39acd6b95d
2025-10-27 03:16:42,261 - DEBUG - Route Targets: ['target:64512:8000006']
2025-10-27 03:16:42,261 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/f1e592a0-f6d1-4e37-bdfd-ee6bc83ed71f
2025-10-27 03:16:42,272 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/821e02e4-6c10-4d13-a801-4d5779f546fd
2025-10-27 03:16:42,291 - INFO - Verified VN network id 17 for VN f1e592a0-f6d1-4e37-bdfd-ee6bc83ed71f
2025-10-27 03:16:42,291 - INFO - Verifications in API Server for VN ctest-right_vn-68337061 passed
2025-10-27 03:16:42,291 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/f1e592a0-f6d1-4e37-bdfd-ee6bc83ed71f
2025-10-27 03:16:42,301 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/821e02e4-6c10-4d13-a801-4d5779f546fd
2025-10-27 03:16:42,311 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/821e02e4-6c10-4d13-a801-4d5779f546fd
2025-10-27 03:16:42,323 - DEBUG - Requesting: http://10.0.0.249:8082/route-target/01e82650-3ea9-49ea-bc28-cd39acd6b95d
2025-10-27 03:16:42,338 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-99437539:ctest-right_vn-68337061', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-99437539', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17430499152840707639', 'uuid-lslong': '13690360588964648735'}, 'enable': 'true', 'created': '2025-10-27T03:16:41', 'last-modified': '2025-10-27T03:16:41', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.424851'}
2025-10-27 03:16:42,345 - DEBUG - Route Targets: ['target:64512:8000006']
2025-10-27 03:16:42,350 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-99437539:ctest-right_vn-68337061', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-99437539', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17430499152840707639', 'uuid-lslong': '13690360588964648735'}, 'enable': 'true', 'created': '2025-10-27T03:16:41', 'last-modified': '2025-10-27T03:16:41', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.443804'}
2025-10-27 03:16:42,356 - DEBUG - Route Targets: ['target:64512:8000006']
2025-10-27 03:16:42,363 - DEBUG - Control-node 10.0.0.129 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-99437539:ctest-right_vn-68337061', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-99437539', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17430499152840707639', 'uuid-lslong': '13690360588964648735'}, 'enable': 'true', 'created': '2025-10-27T03:16:41', 'last-modified': '2025-10-27T03:16:41', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.459642'}
2025-10-27 03:16:42,368 - DEBUG - Route Targets: ['target:64512:8000006']
2025-10-27 03:16:42,368 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-68337061 passed
2025-10-27 03:16:42,369 - DEBUG - ====Verifying policy data for ctest-right_vn-68337061 in API_Server ======
2025-10-27 03:16:42,369 - DEBUG - Requesting: http://10.0.0.249:8082/domains
2025-10-27 03:16:42,375 - DEBUG - Requesting: http://10.0.0.249:8082/domain/8213efff-6224-4943-8f79-85cc33013f73
2025-10-27 03:16:42,386 - DEBUG - Requesting: http://10.0.0.249:8082/project/c9ac7390-e193-4b8b-9d93-9337d1127328
2025-10-27 03:16:42,490 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/f1e592a0-f6d1-4e37-bdfd-ee6bc83ed71f
2025-10-27 03:16:42,508 - DEBUG - =>VN ctest-right_vn-68337061 has no policy to be verified
2025-10-27 03:16:42,508 - DEBUG - Verifying the vn in opserver
2025-10-27 03:16:42,508 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-99437539:ctest-right_vn-68337061 virtual network link through opserver 10.0.0.249
2025-10-27 03:16:42,508 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2025-10-27 03:16:42,588 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-99437539:ctest-right_vn-68337061', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-99437539:ctest-right_vn-68337061?flat'}
2025-10-27 03:16:42,588 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-99437539:ctest-right_vn-68337061 virtual network link through opserver 10.0.0.33
2025-10-27 03:16:42,589 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2025-10-27 03:16:42,661 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-99437539:ctest-right_vn-68337061', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-99437539:ctest-right_vn-68337061?flat'}
2025-10-27 03:16:42,661 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-99437539:ctest-right_vn-68337061 virtual network link through opserver 10.0.0.129
2025-10-27 03:16:42,662 - DEBUG - Requesting: http://10.0.0.129:8081/analytics/uves/virtual-networks
2025-10-27 03:16:42,721 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-99437539:ctest-right_vn-68337061', 'href': 'http://10.0.0.129:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-99437539:ctest-right_vn-68337061?flat'}
2025-10-27 03:16:42,721 - INFO - Validated that VN default-domain:ctest-TestSvcHC-99437539:ctest-right_vn-68337061 is found in opserver
2025-10-27 03:16:42,743 - DEBUG - Do not have enough data to verify VN in agent
2025-10-27 03:16:42,754 - DEBUG - VRF ids for VN ctest-right_vn-68337061: {}
2025-10-27 03:16:42,818 - DEBUG - Services list from nova: [, , , ]
2025-10-27 03:16:43,904 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4489-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4489-2)
2025-10-27 03:16:45,263 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4489-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4489-1)
2025-10-27 03:16:45,263 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-57456520']
2025-10-27 03:16:45,556 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-57456520'] created succesfully
2025-10-27 03:16:45,967 - DEBUG - Image by name tiny_nat_fw not found
2025-10-27 03:16:45,967 - DEBUG - Installing image tiny_nat_fw
2025-10-27 03:16:45,967 - DEBUG - Image info {'name': 'tinycore-in-network-nat.qcow2.gz', 'webserver': '', 'location': '/images/tinycore/', 'username': 'tc', 'password': 'secret', 'type': 'os', 'flavor': 'contrail_flavor_tiny', 'params': '--container-format bare --disk-format vmdk --property vmware_disktype="sparse" --property vmware_adaptertype="ide" --property hypervisor_type=qemu', 'name_docker': 'phusion-baseimage-enablesshd', 'vmdk': 'service_chain_images/nat_service/tiny_nat_fw/tinycore-in-network-nat-flat.vmdk', 'shrinked_vmdk': "'no'"}
2025-10-27 03:16:45,967 - DEBUG - Image build path file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2025-10-27 03:16:45,967 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2025-10-27 03:16:45,967 - DEBUG - Unzip image
2025-10-27 03:16:45,967 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2025-10-27 03:16:45,996 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2025-10-27 03:16:45,997 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-57456520']
2025-10-27 03:16:46,097 - INFO - Service template: ['default-domain', 'ctest-service_template_1-57456520'] deleted successfully.
2025-10-27 03:16:46,097 - INFO - Skip interface_detach for VM ctest-right_vm-16002450 in state BUILD
2025-10-27 03:16:46,098 - INFO - Deleting VM ctest-right_vm-16002450
2025-10-27 03:16:46,163 - ERROR - VM ctest-right_vm-16002450 has failed to come up
2025-10-27 03:16:46,164 - ERROR - Nova failed to get host of the VM
2025-10-27 03:16:46,164 - ERROR - VM ctest-right_vm-16002450 has failed to come up
2025-10-27 03:16:46,164 - ERROR - Nova failed to get host of the VM
2025-10-27 03:16:46,260 - INFO - Skip interface_detach for VM ctest-left_vm-00114514 in state BUILD
2025-10-27 03:16:46,260 - INFO - Deleting VM ctest-left_vm-00114514
2025-10-27 03:16:46,260 - ERROR - VM ctest-left_vm-00114514 has failed to come up
2025-10-27 03:16:46,260 - ERROR - Nova failed to get host of the VM
2025-10-27 03:16:46,260 - ERROR - VM ctest-left_vm-00114514 has failed to come up
2025-10-27 03:16:46,260 - ERROR - Nova failed to get host of the VM
2025-10-27 03:16:46,344 - INFO - Deleting VN ctest-right_vn-68337061
2025-10-27 03:16:46,396 - DEBUG - VN f1e592a0-f6d1-4e37-bdfd-ee6bc83ed71f still in use: Unable to complete operation on network f1e592a0-f6d1-4e37-bdfd-ee6bc83ed71f. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-4b344ed2-541b-4b39-ba9f-9b8f9ff9a7d8']
2025-10-27 03:16:46,396 - WARNING - Deleting VN ctest-right_vn-68337061 failed..Will retry
2025-10-27 03:16:48,580 - DEBUG - Response for deleting network ()
2025-10-27 03:16:48,580 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/821e02e4-6c10-4d13-a801-4d5779f546fd
2025-10-27 03:16:48,595 - DEBUG - Response Code: 404
2025-10-27 03:16:48,595 - DEBUG - Requesting: http://10.0.0.249:8082/domains
2025-10-27 03:16:48,605 - DEBUG - Requesting: http://10.0.0.249:8082/domain/8213efff-6224-4943-8f79-85cc33013f73
2025-10-27 03:16:48,646 - DEBUG - Requesting: http://10.0.0.249:8082/project/c9ac7390-e193-4b8b-9d93-9337d1127328
2025-10-27 03:16:48,759 - INFO - Validated that VN ctest-right_vn-68337061 is not found in API Server
2025-10-27 03:16:48,775 - DEBUG - VN ctest-right_vn-68337061 is not present in Agent 10.0.0.130
2025-10-27 03:16:48,786 - DEBUG - VN ctest-right_vn-68337061 is not present in Agent 10.0.0.131
2025-10-27 03:16:48,786 - INFO - Validated that VN ctest-right_vn-68337061 is not in any agent
2025-10-27 03:16:48,822 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-68337061 info
2025-10-27 03:16:48,822 - INFO - Deleting VN ctest-left_vn-84819120
2025-10-27 03:16:48,986 - DEBUG - Response for deleting network ()
2025-10-27 03:16:48,986 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/bde29eae-178f-4425-816c-5f9d7dfe3cbb
2025-10-27 03:16:49,000 - DEBUG - Response Code: 404
2025-10-27 03:16:49,000 - DEBUG - Requesting: http://10.0.0.249:8082/domains
2025-10-27 03:16:49,008 - DEBUG - Requesting: http://10.0.0.249:8082/domain/8213efff-6224-4943-8f79-85cc33013f73
2025-10-27 03:16:49,032 - DEBUG - Requesting: http://10.0.0.249:8082/project/c9ac7390-e193-4b8b-9d93-9337d1127328
2025-10-27 03:16:49,127 - INFO - Validated that VN ctest-left_vn-84819120 is not found in API Server
2025-10-27 03:16:49,143 - DEBUG - VN ctest-left_vn-84819120 is not present in Agent 10.0.0.130
2025-10-27 03:16:49,155 - DEBUG - VN ctest-left_vn-84819120 is not present in Agent 10.0.0.131
2025-10-27 03:16:49,155 - INFO - Validated that VN ctest-left_vn-84819120 is not in any agent
2025-10-27 03:16:49,190 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-84819120 info
2025-10-27 03:16:49,191 - INFO - Deleting VN ctest-mgmt_vn-85978156
2025-10-27 03:16:49,340 - DEBUG - Response for deleting network ()
2025-10-27 03:16:49,340 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/9f3d71f0-f0a2-48a9-9e27-ff2119d281d8
2025-10-27 03:16:49,347 - DEBUG - Response Code: 404
2025-10-27 03:16:49,347 - DEBUG - Requesting: http://10.0.0.249:8082/domains
2025-10-27 03:16:49,354 - DEBUG - Requesting: http://10.0.0.249:8082/domain/8213efff-6224-4943-8f79-85cc33013f73
2025-10-27 03:16:49,406 - DEBUG - Requesting: http://10.0.0.249:8082/project/c9ac7390-e193-4b8b-9d93-9337d1127328
2025-10-27 03:16:49,493 - INFO - Validated that VN ctest-mgmt_vn-85978156 is not found in API Server
2025-10-27 03:16:49,505 - DEBUG - VN ctest-mgmt_vn-85978156 is not present in Agent 10.0.0.130
2025-10-27 03:16:49,515 - DEBUG - VN ctest-mgmt_vn-85978156 is not present in Agent 10.0.0.131
2025-10-27 03:16:49,515 - INFO - Validated that VN ctest-mgmt_vn-85978156 is not in any agent
2025-10-27 03:16:49,545 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-85978156 info
2025-10-27 03:16:50,826 - DEBUG - No XMPP flaps were noticed during the test
2025-10-27 03:16:50,826 - INFO -
2025-10-27 03:16:50,827 - INFO - END TEST : test_svc_hc_basic : SKIPPED[0:00:16]
2025-10-27 03:16:50,827 - INFO - --------------------------------------------------------------------------------
2025-10-27 03:16:50,834 - INFO - ================================================================================
2025-10-27 03:16:50,835 - INFO - STARTING TEST : test_svc_trans_segment_right_hc_fail_svm
2025-10-27 03:16:52,125 - DEBUG - Nothing to compare xmpp stats {'10.0.0.130': {'10.20.0.25': '0', '10.20.0.17': '0'}, '10.0.0.131': {'10.20.0.17': '0', '10.20.0.14': '0'}} with
2025-10-27 03:16:52,125 - INFO - Initial checks done. Running the testcase now
2025-10-27 03:16:52,126 - INFO -
2025-10-27 03:16:52,380 - DEBUG - Response for create_network : {'network': {'id': '558bf7a4-cb27-4c7f-9ecd-f785b9c77a3d', 'name': 'ctest-mgmt_vn-99940985', 'tenant_id': 'c9ac7390e1934b8b9d939337d1127328', 'project_id': 'c9ac7390e1934b8b9d939337d1127328', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-99437539', 'ctest-mgmt_vn-99940985'], 'port_security_enabled': True, 'description': ''}}
2025-10-27 03:16:52,652 - DEBUG - Response for create_subnet : {'subnet': {'id': 'ed137271-3483-4fff-8876-9fd424085343', 'name': '', 'tenant_id': 'c9ac7390e1934b8b9d939337d1127328', 'network_id': '558bf7a4-cb27-4c7f-9ecd-f785b9c77a3d', 'ip_version': 4, 'cidr': '106.181.33.192/26', 'allocation_pools': [{'start': '106.181.33.194', 'end': '106.181.33.254'}], 'gateway_ip': '106.181.33.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '106.181.33.194', 'tags': [], 'project_id': 'c9ac7390e1934b8b9d939337d1127328'}}
2025-10-27 03:16:52,677 - INFO - Created VN ctest-mgmt_vn-99940985
2025-10-27 03:16:52,694 - DEBUG - VN ctest-mgmt_vn-99940985 UUID is 558bf7a4-cb27-4c7f-9ecd-f785b9c77a3d
2025-10-27 03:16:52,780 - DEBUG - Requesting: http://10.0.0.249:8082/domains
2025-10-27 03:16:52,787 - DEBUG - Requesting: http://10.0.0.249:8082/domain/8213efff-6224-4943-8f79-85cc33013f73
2025-10-27 03:16:52,929 - DEBUG - Requesting: http://10.0.0.249:8082/project/c9ac7390-e193-4b8b-9d93-9337d1127328
2025-10-27 03:16:53,035 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/558bf7a4-cb27-4c7f-9ecd-f785b9c77a3d
2025-10-27 03:16:53,052 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/558bf7a4-cb27-4c7f-9ecd-f785b9c77a3d
2025-10-27 03:16:53,064 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/beb7d6ac-7017-43af-ad60-d1bb540d695f
2025-10-27 03:16:53,073 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/beb7d6ac-7017-43af-ad60-d1bb540d695f
2025-10-27 03:16:53,083 - DEBUG - Requesting: http://10.0.0.249:8082/route-target/803bb039-be7a-4187-bc39-55e3dbe5a20b
2025-10-27 03:16:53,091 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-27 03:16:53,092 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/558bf7a4-cb27-4c7f-9ecd-f785b9c77a3d
2025-10-27 03:16:53,106 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/beb7d6ac-7017-43af-ad60-d1bb540d695f
2025-10-27 03:16:53,127 - INFO - Verified VN network id 15 for VN 558bf7a4-cb27-4c7f-9ecd-f785b9c77a3d
2025-10-27 03:16:53,127 - INFO - Verifications in API Server for VN ctest-mgmt_vn-99940985 passed
2025-10-27 03:16:53,127 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/558bf7a4-cb27-4c7f-9ecd-f785b9c77a3d
2025-10-27 03:16:53,140 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/beb7d6ac-7017-43af-ad60-d1bb540d695f
2025-10-27 03:16:53,150 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/beb7d6ac-7017-43af-ad60-d1bb540d695f
2025-10-27 03:16:53,158 - DEBUG - Requesting: http://10.0.0.249:8082/route-target/803bb039-be7a-4187-bc39-55e3dbe5a20b
2025-10-27 03:16:53,173 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-99437539:ctest-mgmt_vn-99940985', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-99437539', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6164292802141703295', 'uuid-lslong': '11443074381937867325'}, 'enable': 'true', 'created': '2025-10-27T03:16:52', 'last-modified': '2025-10-27T03:16:52', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.579703'}
2025-10-27 03:16:53,180 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-27 03:16:53,186 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-99437539:ctest-mgmt_vn-99940985', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-99437539', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6164292802141703295', 'uuid-lslong': '11443074381937867325'}, 'enable': 'true', 'created': '2025-10-27T03:16:52', 'last-modified': '2025-10-27T03:16:52', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.591973'}
2025-10-27 03:16:53,192 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-27 03:16:53,198 - DEBUG - Control-node 10.0.0.129 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-99437539:ctest-mgmt_vn-99940985', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-99437539', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6164292802141703295', 'uuid-lslong': '11443074381937867325'}, 'enable': 'true', 'created': '2025-10-27T03:16:52', 'last-modified': '2025-10-27T03:16:52', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.609345'}
2025-10-27 03:16:53,206 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-27 03:16:53,206 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-99940985 passed
2025-10-27 03:16:53,206 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-99940985 in API_Server ======
2025-10-27 03:16:53,207 - DEBUG - Requesting: http://10.0.0.249:8082/domains
2025-10-27 03:16:53,217 - DEBUG - Requesting: http://10.0.0.249:8082/domain/8213efff-6224-4943-8f79-85cc33013f73
2025-10-27 03:16:53,232 - DEBUG - Requesting: http://10.0.0.249:8082/project/c9ac7390-e193-4b8b-9d93-9337d1127328
2025-10-27 03:16:53,326 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/558bf7a4-cb27-4c7f-9ecd-f785b9c77a3d
2025-10-27 03:16:53,338 - DEBUG - =>VN ctest-mgmt_vn-99940985 has no policy to be verified
2025-10-27 03:16:53,338 - DEBUG - Verifying the vn in opserver
2025-10-27 03:16:53,338 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-99437539:ctest-mgmt_vn-99940985 virtual network link through opserver 10.0.0.249
2025-10-27 03:16:53,338 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2025-10-27 03:16:53,351 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-99437539:ctest-mgmt_vn-99940985', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-99437539:ctest-mgmt_vn-99940985?flat'}
2025-10-27 03:16:53,351 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-99437539:ctest-mgmt_vn-99940985 virtual network link through opserver 10.0.0.33
2025-10-27 03:16:53,351 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2025-10-27 03:16:53,365 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-99437539:ctest-mgmt_vn-99940985', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-99437539:ctest-mgmt_vn-99940985?flat'}
2025-10-27 03:16:53,365 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-99437539:ctest-mgmt_vn-99940985 virtual network link through opserver 10.0.0.129
2025-10-27 03:16:53,365 - DEBUG - Requesting: http://10.0.0.129:8081/analytics/uves/virtual-networks
2025-10-27 03:16:53,378 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-99437539:ctest-mgmt_vn-99940985', 'href': 'http://10.0.0.129:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-99437539:ctest-mgmt_vn-99940985?flat'}
2025-10-27 03:16:53,378 - INFO - Validated that VN default-domain:ctest-TestSvcHC-99437539:ctest-mgmt_vn-99940985 is found in opserver
2025-10-27 03:16:53,399 - DEBUG - Do not have enough data to verify VN in agent
2025-10-27 03:16:53,409 - DEBUG - VRF ids for VN ctest-mgmt_vn-99940985: {}
2025-10-27 03:16:53,706 - DEBUG - Response for create_network : {'network': {'id': 'a7c08e51-a065-464c-aec7-e85bb19a31d7', 'name': 'ctest-left_vn-50999914', 'tenant_id': 'c9ac7390e1934b8b9d939337d1127328', 'project_id': 'c9ac7390e1934b8b9d939337d1127328', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-99437539', 'ctest-left_vn-50999914'], 'port_security_enabled': True, 'description': ''}}
2025-10-27 03:16:53,933 - DEBUG - Response for create_subnet : {'subnet': {'id': '6b4b9552-ba45-4455-8f61-f74ca6c3a7fd', 'name': '', 'tenant_id': 'c9ac7390e1934b8b9d939337d1127328', 'network_id': 'a7c08e51-a065-464c-aec7-e85bb19a31d7', 'ip_version': 4, 'cidr': '112.4.161.0/26', 'allocation_pools': [{'start': '112.4.161.2', 'end': '112.4.161.62'}], 'gateway_ip': '112.4.161.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '112.4.161.2', 'tags': [], 'project_id': 'c9ac7390e1934b8b9d939337d1127328'}}
2025-10-27 03:16:53,961 - INFO - Created VN ctest-left_vn-50999914
2025-10-27 03:16:53,973 - DEBUG - VN ctest-left_vn-50999914 UUID is a7c08e51-a065-464c-aec7-e85bb19a31d7
2025-10-27 03:16:54,063 - DEBUG - Requesting: http://10.0.0.249:8082/domains
2025-10-27 03:16:54,072 - DEBUG - Requesting: http://10.0.0.249:8082/domain/8213efff-6224-4943-8f79-85cc33013f73
2025-10-27 03:16:54,084 - DEBUG - Requesting: http://10.0.0.249:8082/project/c9ac7390-e193-4b8b-9d93-9337d1127328
2025-10-27 03:16:54,204 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/a7c08e51-a065-464c-aec7-e85bb19a31d7
2025-10-27 03:16:54,227 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/a7c08e51-a065-464c-aec7-e85bb19a31d7
2025-10-27 03:16:54,238 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/11f5c2a3-cfed-4110-a9f8-22137c3d4b56
2025-10-27 03:16:54,249 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/11f5c2a3-cfed-4110-a9f8-22137c3d4b56
2025-10-27 03:16:54,259 - DEBUG - Requesting: http://10.0.0.249:8082/route-target/babbf43c-1f75-487c-8311-08693e988f06
2025-10-27 03:16:54,275 - DEBUG - Route Targets: ['target:64512:8000005']
2025-10-27 03:16:54,276 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/a7c08e51-a065-464c-aec7-e85bb19a31d7
2025-10-27 03:16:54,287 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/11f5c2a3-cfed-4110-a9f8-22137c3d4b56
2025-10-27 03:16:54,307 - INFO - Verified VN network id 16 for VN a7c08e51-a065-464c-aec7-e85bb19a31d7
2025-10-27 03:16:54,307 - INFO - Verifications in API Server for VN ctest-left_vn-50999914 passed
2025-10-27 03:16:54,307 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/a7c08e51-a065-464c-aec7-e85bb19a31d7
2025-10-27 03:16:54,320 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/11f5c2a3-cfed-4110-a9f8-22137c3d4b56
2025-10-27 03:16:54,330 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/11f5c2a3-cfed-4110-a9f8-22137c3d4b56
2025-10-27 03:16:54,340 - DEBUG - Requesting: http://10.0.0.249:8082/route-target/babbf43c-1f75-487c-8311-08693e988f06
2025-10-27 03:16:54,352 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-99437539:ctest-left_vn-50999914', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-99437539', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12087817881096898124', 'uuid-lslong': '12594290363484221911'}, 'enable': 'true', 'created': '2025-10-27T03:16:53', 'last-modified': '2025-10-27T03:16:53', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.482168'}
2025-10-27 03:16:54,358 - DEBUG - Route Targets: ['target:64512:8000005']
2025-10-27 03:16:54,363 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-99437539:ctest-left_vn-50999914', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-99437539', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12087817881096898124', 'uuid-lslong': '12594290363484221911'}, 'enable': 'true', 'created': '2025-10-27T03:16:53', 'last-modified': '2025-10-27T03:16:53', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.495500'}
2025-10-27 03:16:54,369 - DEBUG - Route Targets: ['target:64512:8000005']
2025-10-27 03:16:54,375 - DEBUG - Control-node 10.0.0.129 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-99437539:ctest-left_vn-50999914', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-99437539', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12087817881096898124', 'uuid-lslong': '12594290363484221911'}, 'enable': 'true', 'created': '2025-10-27T03:16:53', 'last-modified': '2025-10-27T03:16:53', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.510199'}
2025-10-27 03:16:54,383 - DEBUG - Route Targets: ['target:64512:8000005']
2025-10-27 03:16:54,384 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-50999914 passed
2025-10-27 03:16:54,384 - DEBUG - ====Verifying policy data for ctest-left_vn-50999914 in API_Server ======
2025-10-27 03:16:54,384 - DEBUG - Requesting: http://10.0.0.249:8082/domains
2025-10-27 03:16:54,392 - DEBUG - Requesting: http://10.0.0.249:8082/domain/8213efff-6224-4943-8f79-85cc33013f73
2025-10-27 03:16:54,406 - DEBUG - Requesting: http://10.0.0.249:8082/project/c9ac7390-e193-4b8b-9d93-9337d1127328
2025-10-27 03:16:54,521 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/a7c08e51-a065-464c-aec7-e85bb19a31d7
2025-10-27 03:16:54,533 - DEBUG - =>VN ctest-left_vn-50999914 has no policy to be verified
2025-10-27 03:16:54,534 - DEBUG - Verifying the vn in opserver
2025-10-27 03:16:54,534 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-99437539:ctest-left_vn-50999914 virtual network link through opserver 10.0.0.249
2025-10-27 03:16:54,534 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2025-10-27 03:16:54,548 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-99437539:ctest-left_vn-50999914', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-99437539:ctest-left_vn-50999914?flat'}
2025-10-27 03:16:54,548 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-99437539:ctest-left_vn-50999914 virtual network link through opserver 10.0.0.33
2025-10-27 03:16:54,548 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2025-10-27 03:16:54,561 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-99437539:ctest-left_vn-50999914', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-99437539:ctest-left_vn-50999914?flat'}
2025-10-27 03:16:54,561 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-99437539:ctest-left_vn-50999914 virtual network link through opserver 10.0.0.129
2025-10-27 03:16:54,561 - DEBUG - Requesting: http://10.0.0.129:8081/analytics/uves/virtual-networks
2025-10-27 03:16:54,574 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-99437539:ctest-left_vn-50999914', 'href': 'http://10.0.0.129:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-99437539:ctest-left_vn-50999914?flat'}
2025-10-27 03:16:54,574 - INFO - Validated that VN default-domain:ctest-TestSvcHC-99437539:ctest-left_vn-50999914 is found in opserver
2025-10-27 03:16:54,599 - DEBUG - Do not have enough data to verify VN in agent
2025-10-27 03:16:54,610 - DEBUG - VRF ids for VN ctest-left_vn-50999914: {}
2025-10-27 03:16:54,873 - DEBUG - Response for create_network : {'network': {'id': 'f180a99f-f948-446c-85bf-07f211d15bdd', 'name': 'ctest-right_vn-79980215', 'tenant_id': 'c9ac7390e1934b8b9d939337d1127328', 'project_id': 'c9ac7390e1934b8b9d939337d1127328', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-99437539', 'ctest-right_vn-79980215'], 'port_security_enabled': True, 'description': ''}}
2025-10-27 03:16:55,128 - DEBUG - Response for create_subnet : {'subnet': {'id': 'eeec347c-6b6b-44e7-aa3f-616d1af6e766', 'name': '', 'tenant_id': 'c9ac7390e1934b8b9d939337d1127328', 'network_id': 'f180a99f-f948-446c-85bf-07f211d15bdd', 'ip_version': 4, 'cidr': '37.188.135.128/26', 'allocation_pools': [{'start': '37.188.135.130', 'end': '37.188.135.190'}], 'gateway_ip': '37.188.135.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '37.188.135.130', 'tags': [], 'project_id': 'c9ac7390e1934b8b9d939337d1127328'}}
2025-10-27 03:16:55,159 - INFO - Created VN ctest-right_vn-79980215
2025-10-27 03:16:55,171 - DEBUG - VN ctest-right_vn-79980215 UUID is f180a99f-f948-446c-85bf-07f211d15bdd
2025-10-27 03:16:55,248 - DEBUG - Requesting: http://10.0.0.249:8082/domains
2025-10-27 03:16:55,256 - DEBUG - Requesting: http://10.0.0.249:8082/domain/8213efff-6224-4943-8f79-85cc33013f73
2025-10-27 03:16:55,268 - DEBUG - Requesting: http://10.0.0.249:8082/project/c9ac7390-e193-4b8b-9d93-9337d1127328
2025-10-27 03:16:55,369 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/f180a99f-f948-446c-85bf-07f211d15bdd
2025-10-27 03:16:55,381 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/f180a99f-f948-446c-85bf-07f211d15bdd
2025-10-27 03:16:55,391 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/9a5fc160-c487-40b2-95fc-a06258996e1e
2025-10-27 03:16:55,398 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/9a5fc160-c487-40b2-95fc-a06258996e1e
2025-10-27 03:16:55,406 - DEBUG - Requesting: http://10.0.0.249:8082/route-target/5d79e551-9d46-42fd-80b3-c1c774396849
2025-10-27 03:16:55,414 - DEBUG - Route Targets: ['target:64512:8000006']
2025-10-27 03:16:55,414 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/f180a99f-f948-446c-85bf-07f211d15bdd
2025-10-27 03:16:55,425 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/9a5fc160-c487-40b2-95fc-a06258996e1e
2025-10-27 03:16:55,443 - INFO - Verified VN network id 17 for VN f180a99f-f948-446c-85bf-07f211d15bdd
2025-10-27 03:16:55,443 - INFO - Verifications in API Server for VN ctest-right_vn-79980215 passed
2025-10-27 03:16:55,444 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/f180a99f-f948-446c-85bf-07f211d15bdd
2025-10-27 03:16:55,456 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/9a5fc160-c487-40b2-95fc-a06258996e1e
2025-10-27 03:16:55,464 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/9a5fc160-c487-40b2-95fc-a06258996e1e
2025-10-27 03:16:55,472 - DEBUG - Requesting: http://10.0.0.249:8082/route-target/5d79e551-9d46-42fd-80b3-c1c774396849
2025-10-27 03:16:55,487 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-99437539:ctest-right_vn-79980215', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-99437539', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17402095464706753644', 'uuid-lslong': '9637430463858564061'}, 'enable': 'true', 'created': '2025-10-27T03:16:54', 'last-modified': '2025-10-27T03:16:55', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.402703'}
2025-10-27 03:16:55,493 - DEBUG - Route Targets: ['target:64512:8000006']
2025-10-27 03:16:55,499 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-99437539:ctest-right_vn-79980215', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-99437539', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17402095464706753644', 'uuid-lslong': '9637430463858564061'}, 'enable': 'true', 'created': '2025-10-27T03:16:54', 'last-modified': '2025-10-27T03:16:55', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.419754'}
2025-10-27 03:16:55,506 - DEBUG - Route Targets: ['target:64512:8000006']
2025-10-27 03:16:55,512 - DEBUG - Control-node 10.0.0.129 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-99437539:ctest-right_vn-79980215', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-99437539', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17402095464706753644', 'uuid-lslong': '9637430463858564061'}, 'enable': 'true', 'created': '2025-10-27T03:16:54', 'last-modified': '2025-10-27T03:16:55', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.432910'}
2025-10-27 03:16:55,518 - DEBUG - Route Targets: ['target:64512:8000006']
2025-10-27 03:16:55,518 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-79980215 passed
2025-10-27 03:16:55,519 - DEBUG - ====Verifying policy data for ctest-right_vn-79980215 in API_Server ======
2025-10-27 03:16:55,519 - DEBUG - Requesting: http://10.0.0.249:8082/domains
2025-10-27 03:16:55,525 - DEBUG - Requesting: http://10.0.0.249:8082/domain/8213efff-6224-4943-8f79-85cc33013f73
2025-10-27 03:16:55,537 - DEBUG - Requesting: http://10.0.0.249:8082/project/c9ac7390-e193-4b8b-9d93-9337d1127328
2025-10-27 03:16:55,638 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/f180a99f-f948-446c-85bf-07f211d15bdd
2025-10-27 03:16:55,658 - DEBUG - =>VN ctest-right_vn-79980215 has no policy to be verified
2025-10-27 03:16:55,658 - DEBUG - Verifying the vn in opserver
2025-10-27 03:16:55,658 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-99437539:ctest-right_vn-79980215 virtual network link through opserver 10.0.0.249
2025-10-27 03:16:55,658 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2025-10-27 03:16:55,670 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-99437539:ctest-right_vn-79980215', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-99437539:ctest-right_vn-79980215?flat'}
2025-10-27 03:16:55,670 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-99437539:ctest-right_vn-79980215 virtual network link through opserver 10.0.0.33
2025-10-27 03:16:55,670 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2025-10-27 03:16:55,684 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-99437539:ctest-right_vn-79980215', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-99437539:ctest-right_vn-79980215?flat'}
2025-10-27 03:16:55,684 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-99437539:ctest-right_vn-79980215 virtual network link through opserver 10.0.0.129
2025-10-27 03:16:55,684 - DEBUG - Requesting: http://10.0.0.129:8081/analytics/uves/virtual-networks
2025-10-27 03:16:55,699 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-99437539:ctest-right_vn-79980215', 'href': 'http://10.0.0.129:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-99437539:ctest-right_vn-79980215?flat'}
2025-10-27 03:16:55,699 - INFO - Validated that VN default-domain:ctest-TestSvcHC-99437539:ctest-right_vn-79980215 is found in opserver
2025-10-27 03:16:55,722 - DEBUG - Do not have enough data to verify VN in agent
2025-10-27 03:16:55,732 - DEBUG - VRF ids for VN ctest-right_vn-79980215: {}
2025-10-27 03:16:56,025 - DEBUG - Response for create_network : {'network': {'id': '8f1fffaa-1eca-4137-b265-c3badaaec26b', 'name': 'ctest-trans_left_vn-66643700', 'tenant_id': 'c9ac7390e1934b8b9d939337d1127328', 'project_id': 'c9ac7390e1934b8b9d939337d1127328', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-99437539', 'ctest-trans_left_vn-66643700'], 'port_security_enabled': True, 'description': ''}}
2025-10-27 03:16:56,298 - DEBUG - Response for create_subnet : {'subnet': {'id': '20f77bc2-4229-4f57-8873-4be020c28d1c', 'name': '', 'tenant_id': 'c9ac7390e1934b8b9d939337d1127328', 'network_id': '8f1fffaa-1eca-4137-b265-c3badaaec26b', 'ip_version': 4, 'cidr': '177.56.67.192/26', 'allocation_pools': [{'start': '177.56.67.194', 'end': '177.56.67.254'}], 'gateway_ip': '177.56.67.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '177.56.67.194', 'tags': [], 'project_id': 'c9ac7390e1934b8b9d939337d1127328'}}
2025-10-27 03:16:56,319 - INFO - Created VN ctest-trans_left_vn-66643700
2025-10-27 03:16:56,334 - DEBUG - VN ctest-trans_left_vn-66643700 UUID is 8f1fffaa-1eca-4137-b265-c3badaaec26b
2025-10-27 03:16:56,415 - DEBUG - Requesting: http://10.0.0.249:8082/domains
2025-10-27 03:16:56,422 - DEBUG - Requesting: http://10.0.0.249:8082/domain/8213efff-6224-4943-8f79-85cc33013f73
2025-10-27 03:16:56,436 - DEBUG - Requesting: http://10.0.0.249:8082/project/c9ac7390-e193-4b8b-9d93-9337d1127328
2025-10-27 03:16:56,530 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/8f1fffaa-1eca-4137-b265-c3badaaec26b
2025-10-27 03:16:56,544 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/8f1fffaa-1eca-4137-b265-c3badaaec26b
2025-10-27 03:16:56,555 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/8ee4cdf3-ab8f-47b4-b5c1-1b0b6572a8b5
2025-10-27 03:16:56,564 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/8ee4cdf3-ab8f-47b4-b5c1-1b0b6572a8b5
2025-10-27 03:16:56,572 - DEBUG - Requesting: http://10.0.0.249:8082/route-target/4f2e5f6c-10fe-4ad9-82a1-00949a9486de
2025-10-27 03:16:56,578 - DEBUG - Route Targets: ['target:64512:8000007']
2025-10-27 03:16:56,578 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/8f1fffaa-1eca-4137-b265-c3badaaec26b
2025-10-27 03:16:56,590 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/8ee4cdf3-ab8f-47b4-b5c1-1b0b6572a8b5
2025-10-27 03:16:56,606 - INFO - Verified VN network id 18 for VN 8f1fffaa-1eca-4137-b265-c3badaaec26b
2025-10-27 03:16:56,606 - INFO - Verifications in API Server for VN ctest-trans_left_vn-66643700 passed
2025-10-27 03:16:56,607 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/8f1fffaa-1eca-4137-b265-c3badaaec26b
2025-10-27 03:16:56,617 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/8ee4cdf3-ab8f-47b4-b5c1-1b0b6572a8b5
2025-10-27 03:16:56,626 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/8ee4cdf3-ab8f-47b4-b5c1-1b0b6572a8b5
2025-10-27 03:16:56,634 - DEBUG - Requesting: http://10.0.0.249:8082/route-target/4f2e5f6c-10fe-4ad9-82a1-00949a9486de
2025-10-27 03:16:56,647 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-99437539:ctest-trans_left_vn-66643700', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-99437539', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10313242777827819831', 'uuid-lslong': '12854895918699168363'}, 'enable': 'true', 'created': '2025-10-27T03:16:55', 'last-modified': '2025-10-27T03:16:56', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.412445'}
2025-10-27 03:16:56,654 - DEBUG - Route Targets: ['target:64512:8000007']
2025-10-27 03:16:56,660 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-99437539:ctest-trans_left_vn-66643700', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-99437539', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10313242777827819831', 'uuid-lslong': '12854895918699168363'}, 'enable': 'true', 'created': '2025-10-27T03:16:55', 'last-modified': '2025-10-27T03:16:56', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.423806'}
2025-10-27 03:16:56,665 - DEBUG - Route Targets: ['target:64512:8000007']
2025-10-27 03:16:56,670 - DEBUG - Control-node 10.0.0.129 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-99437539:ctest-trans_left_vn-66643700', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-99437539', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10313242777827819831', 'uuid-lslong': '12854895918699168363'}, 'enable': 'true', 'created': '2025-10-27T03:16:55', 'last-modified': '2025-10-27T03:16:56', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.438851'}
2025-10-27 03:16:56,675 - DEBUG - Route Targets: ['target:64512:8000007']
2025-10-27 03:16:56,675 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_left_vn-66643700 passed
2025-10-27 03:16:56,676 - DEBUG - ====Verifying policy data for ctest-trans_left_vn-66643700 in API_Server ======
2025-10-27 03:16:56,676 - DEBUG - Requesting: http://10.0.0.249:8082/domains
2025-10-27 03:16:56,682 - DEBUG - Requesting: http://10.0.0.249:8082/domain/8213efff-6224-4943-8f79-85cc33013f73
2025-10-27 03:16:56,694 - DEBUG - Requesting: http://10.0.0.249:8082/project/c9ac7390-e193-4b8b-9d93-9337d1127328
2025-10-27 03:16:56,789 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/8f1fffaa-1eca-4137-b265-c3badaaec26b
2025-10-27 03:16:56,802 - DEBUG - =>VN ctest-trans_left_vn-66643700 has no policy to be verified
2025-10-27 03:16:56,802 - DEBUG - Verifying the vn in opserver
2025-10-27 03:16:56,802 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-99437539:ctest-trans_left_vn-66643700 virtual network link through opserver 10.0.0.249
2025-10-27 03:16:56,802 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2025-10-27 03:16:56,817 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-99437539:ctest-trans_left_vn-66643700', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-99437539:ctest-trans_left_vn-66643700?flat'}
2025-10-27 03:16:56,817 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-99437539:ctest-trans_left_vn-66643700 virtual network link through opserver 10.0.0.33
2025-10-27 03:16:56,817 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2025-10-27 03:16:56,833 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-99437539:ctest-trans_left_vn-66643700', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-99437539:ctest-trans_left_vn-66643700?flat'}
2025-10-27 03:16:56,833 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-99437539:ctest-trans_left_vn-66643700 virtual network link through opserver 10.0.0.129
2025-10-27 03:16:56,833 - DEBUG - Requesting: http://10.0.0.129:8081/analytics/uves/virtual-networks
2025-10-27 03:16:56,847 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-99437539:ctest-trans_left_vn-66643700', 'href': 'http://10.0.0.129:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-99437539:ctest-trans_left_vn-66643700?flat'}
2025-10-27 03:16:56,847 - INFO - Validated that VN default-domain:ctest-TestSvcHC-99437539:ctest-trans_left_vn-66643700 is found in opserver
2025-10-27 03:16:56,871 - DEBUG - Do not have enough data to verify VN in agent
2025-10-27 03:16:56,882 - DEBUG - VRF ids for VN ctest-trans_left_vn-66643700: {}
2025-10-27 03:16:57,167 - DEBUG - Response for create_network : {'network': {'id': '517ea7f5-0e13-4990-a73a-d9c64ff9d961', 'name': 'ctest-trans_right_vn-55141768', 'tenant_id': 'c9ac7390e1934b8b9d939337d1127328', 'project_id': 'c9ac7390e1934b8b9d939337d1127328', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-99437539', 'ctest-trans_right_vn-55141768'], 'port_security_enabled': True, 'description': ''}}
2025-10-27 03:16:57,432 - DEBUG - Response for create_subnet : {'subnet': {'id': '8a3f9240-5c5f-4dbc-925a-f0d5dcc5b585', 'name': '', 'tenant_id': 'c9ac7390e1934b8b9d939337d1127328', 'network_id': '517ea7f5-0e13-4990-a73a-d9c64ff9d961', 'ip_version': 4, 'cidr': '78.236.49.192/26', 'allocation_pools': [{'start': '78.236.49.194', 'end': '78.236.49.254'}], 'gateway_ip': '78.236.49.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '78.236.49.194', 'tags': [], 'project_id': 'c9ac7390e1934b8b9d939337d1127328'}}
2025-10-27 03:16:57,457 - INFO - Created VN ctest-trans_right_vn-55141768
2025-10-27 03:16:57,470 - DEBUG - VN ctest-trans_right_vn-55141768 UUID is 517ea7f5-0e13-4990-a73a-d9c64ff9d961
2025-10-27 03:16:57,552 - DEBUG - Requesting: http://10.0.0.249:8082/domains
2025-10-27 03:16:57,561 - DEBUG - Requesting: http://10.0.0.249:8082/domain/8213efff-6224-4943-8f79-85cc33013f73
2025-10-27 03:16:57,574 - DEBUG - Requesting: http://10.0.0.249:8082/project/c9ac7390-e193-4b8b-9d93-9337d1127328
2025-10-27 03:16:57,666 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/517ea7f5-0e13-4990-a73a-d9c64ff9d961
2025-10-27 03:16:57,681 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/517ea7f5-0e13-4990-a73a-d9c64ff9d961
2025-10-27 03:16:57,691 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/a1eadd4c-e69e-4e4b-a5c0-3903653fce35
2025-10-27 03:16:57,702 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/a1eadd4c-e69e-4e4b-a5c0-3903653fce35
2025-10-27 03:16:57,710 - DEBUG - Requesting: http://10.0.0.249:8082/route-target/3fc4e3ae-83dd-48d7-b6c5-81066d2f4e87
2025-10-27 03:16:57,718 - DEBUG - Route Targets: ['target:64512:8000008']
2025-10-27 03:16:57,718 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/517ea7f5-0e13-4990-a73a-d9c64ff9d961
2025-10-27 03:16:57,733 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/a1eadd4c-e69e-4e4b-a5c0-3903653fce35
2025-10-27 03:16:57,748 - INFO - Verified VN network id 19 for VN 517ea7f5-0e13-4990-a73a-d9c64ff9d961
2025-10-27 03:16:57,748 - INFO - Verifications in API Server for VN ctest-trans_right_vn-55141768 passed
2025-10-27 03:16:57,749 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/517ea7f5-0e13-4990-a73a-d9c64ff9d961
2025-10-27 03:16:57,760 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/a1eadd4c-e69e-4e4b-a5c0-3903653fce35
2025-10-27 03:16:57,768 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/a1eadd4c-e69e-4e4b-a5c0-3903653fce35
2025-10-27 03:16:57,776 - DEBUG - Requesting: http://10.0.0.249:8082/route-target/3fc4e3ae-83dd-48d7-b6c5-81066d2f4e87
2025-10-27 03:16:57,788 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-99437539:ctest-trans_right_vn-55141768', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-99437539', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5872315635082676624', 'uuid-lslong': '12050183198751709537'}, 'enable': 'true', 'created': '2025-10-27T03:16:57', 'last-modified': '2025-10-27T03:16:57', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.410653'}
2025-10-27 03:16:57,794 - DEBUG - Route Targets: ['target:64512:8000008']
2025-10-27 03:16:57,800 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-99437539:ctest-trans_right_vn-55141768', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-99437539', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5872315635082676624', 'uuid-lslong': '12050183198751709537'}, 'enable': 'true', 'created': '2025-10-27T03:16:57', 'last-modified': '2025-10-27T03:16:57', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.428581'}
2025-10-27 03:16:57,805 - DEBUG - Route Targets: ['target:64512:8000008']
2025-10-27 03:16:57,811 - DEBUG - Control-node 10.0.0.129 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-99437539:ctest-trans_right_vn-55141768', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-99437539', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5872315635082676624', 'uuid-lslong': '12050183198751709537'}, 'enable': 'true', 'created': '2025-10-27T03:16:57', 'last-modified': '2025-10-27T03:16:57', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.434933'}
2025-10-27 03:16:57,816 - DEBUG - Route Targets: ['target:64512:8000008']
2025-10-27 03:16:57,816 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_right_vn-55141768 passed
2025-10-27 03:16:57,816 - DEBUG - ====Verifying policy data for ctest-trans_right_vn-55141768 in API_Server ======
2025-10-27 03:16:57,817 - DEBUG - Requesting: http://10.0.0.249:8082/domains
2025-10-27 03:16:57,824 - DEBUG - Requesting: http://10.0.0.249:8082/domain/8213efff-6224-4943-8f79-85cc33013f73
2025-10-27 03:16:57,836 - DEBUG - Requesting: http://10.0.0.249:8082/project/c9ac7390-e193-4b8b-9d93-9337d1127328
2025-10-27 03:16:57,934 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/517ea7f5-0e13-4990-a73a-d9c64ff9d961
2025-10-27 03:16:57,951 - DEBUG - =>VN ctest-trans_right_vn-55141768 has no policy to be verified
2025-10-27 03:16:57,951 - DEBUG - Verifying the vn in opserver
2025-10-27 03:16:57,951 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-99437539:ctest-trans_right_vn-55141768 virtual network link through opserver 10.0.0.249
2025-10-27 03:16:57,951 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2025-10-27 03:16:57,963 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-99437539:ctest-trans_right_vn-55141768', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-99437539:ctest-trans_right_vn-55141768?flat'}
2025-10-27 03:16:57,963 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-99437539:ctest-trans_right_vn-55141768 virtual network link through opserver 10.0.0.33
2025-10-27 03:16:57,963 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2025-10-27 03:16:57,977 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-99437539:ctest-trans_right_vn-55141768', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-99437539:ctest-trans_right_vn-55141768?flat'}
2025-10-27 03:16:57,977 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-99437539:ctest-trans_right_vn-55141768 virtual network link through opserver 10.0.0.129
2025-10-27 03:16:57,977 - DEBUG - Requesting: http://10.0.0.129:8081/analytics/uves/virtual-networks
2025-10-27 03:16:57,991 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-99437539:ctest-trans_right_vn-55141768', 'href': 'http://10.0.0.129:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-99437539:ctest-trans_right_vn-55141768?flat'}
2025-10-27 03:16:57,991 - INFO - Validated that VN default-domain:ctest-TestSvcHC-99437539:ctest-trans_right_vn-55141768 is found in opserver
2025-10-27 03:16:58,016 - DEBUG - Do not have enough data to verify VN in agent
2025-10-27 03:16:58,025 - DEBUG - VRF ids for VN ctest-trans_right_vn-55141768: {}
2025-10-27 03:16:59,082 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4489-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4489-1)
2025-10-27 03:17:00,694 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4489-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4489-2)
2025-10-27 03:17:00,695 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-27660797']
2025-10-27 03:17:00,992 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-27660797'] created succesfully
2025-10-27 03:17:01,320 - DEBUG - Image by name tiny_trans_fw not found
2025-10-27 03:17:01,321 - DEBUG - Installing image tiny_trans_fw
2025-10-27 03:17:01,321 - DEBUG - Image info {'name': 'tinycore-net-transparent-fw.qcow2.gz', 'webserver': '', 'location': '/images/tinycore/', 'username': 'tc', 'password': 'secret', 'type': 'os', 'flavor': 'contrail_flavor_tiny', 'params': '--container-format bare --disk-format vmdk --property vmware_disktype="sparse" --property vmware_adaptertype="ide" --property hypervisor_type=qemu', 'name_docker': 'phusion-baseimage-enablesshd'}
2025-10-27 03:17:01,321 - DEBUG - Image build path file:///contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2025-10-27 03:17:01,321 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2025-10-27 03:17:01,321 - DEBUG - Unzip image
2025-10-27 03:17:01,321 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2025-10-27 03:17:01,359 - INFO - image /contrail-test/images/tinycore-net-transparent-fw.qcow2 is not found
2025-10-27 03:17:01,360 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-27660797']
2025-10-27 03:17:01,478 - INFO - Service template: ['default-domain', 'ctest-service_template_1-27660797'] deleted successfully.
2025-10-27 03:17:01,478 - INFO - Skip interface_detach for VM ctest-right_vm-01839331 in state BUILD
2025-10-27 03:17:01,478 - INFO - Deleting VM ctest-right_vm-01839331
2025-10-27 03:17:01,478 - ERROR - VM ctest-right_vm-01839331 has failed to come up
2025-10-27 03:17:01,478 - ERROR - Nova failed to get host of the VM
2025-10-27 03:17:01,478 - ERROR - VM ctest-right_vm-01839331 has failed to come up
2025-10-27 03:17:01,478 - ERROR - Nova failed to get host of the VM
2025-10-27 03:17:01,622 - INFO - Skip interface_detach for VM ctest-left_vm-80526077 in state BUILD
2025-10-27 03:17:01,622 - INFO - Deleting VM ctest-left_vm-80526077
2025-10-27 03:17:01,623 - ERROR - VM ctest-left_vm-80526077 has failed to come up
2025-10-27 03:17:01,623 - ERROR - Nova failed to get host of the VM
2025-10-27 03:17:01,623 - ERROR - VM ctest-left_vm-80526077 has failed to come up
2025-10-27 03:17:01,623 - ERROR - Nova failed to get host of the VM
2025-10-27 03:17:01,727 - INFO - Deleting VN ctest-trans_right_vn-55141768
2025-10-27 03:17:01,907 - DEBUG - Response for deleting network ()
2025-10-27 03:17:01,907 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/a1eadd4c-e69e-4e4b-a5c0-3903653fce35
2025-10-27 03:17:01,915 - DEBUG - Response Code: 404
2025-10-27 03:17:01,916 - DEBUG - Requesting: http://10.0.0.249:8082/domains
2025-10-27 03:17:01,927 - DEBUG - Requesting: http://10.0.0.249:8082/domain/8213efff-6224-4943-8f79-85cc33013f73
2025-10-27 03:17:01,970 - DEBUG - Requesting: http://10.0.0.249:8082/project/c9ac7390-e193-4b8b-9d93-9337d1127328
2025-10-27 03:17:02,073 - INFO - Validated that VN ctest-trans_right_vn-55141768 is not found in API Server
2025-10-27 03:17:02,089 - DEBUG - VN ctest-trans_right_vn-55141768 is not present in Agent 10.0.0.130
2025-10-27 03:17:02,103 - DEBUG - VN ctest-trans_right_vn-55141768 is not present in Agent 10.0.0.131
2025-10-27 03:17:02,103 - INFO - Validated that VN ctest-trans_right_vn-55141768 is not in any agent
2025-10-27 03:17:02,139 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-trans_right_vn-55141768 info
2025-10-27 03:17:02,139 - INFO - Deleting VN ctest-trans_left_vn-66643700
2025-10-27 03:17:02,311 - DEBUG - Response for deleting network ()
2025-10-27 03:17:02,311 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/8ee4cdf3-ab8f-47b4-b5c1-1b0b6572a8b5
2025-10-27 03:17:02,318 - DEBUG - Response Code: 404
2025-10-27 03:17:02,318 - DEBUG - Requesting: http://10.0.0.249:8082/domains
2025-10-27 03:17:02,331 - DEBUG - Requesting: http://10.0.0.249:8082/domain/8213efff-6224-4943-8f79-85cc33013f73
2025-10-27 03:17:02,362 - DEBUG - Requesting: http://10.0.0.249:8082/project/c9ac7390-e193-4b8b-9d93-9337d1127328
2025-10-27 03:17:02,468 - INFO - Validated that VN ctest-trans_left_vn-66643700 is not found in API Server
2025-10-27 03:17:02,480 - DEBUG - VN ctest-trans_left_vn-66643700 is not present in Agent 10.0.0.130
2025-10-27 03:17:02,500 - DEBUG - VN ctest-trans_left_vn-66643700 is not present in Agent 10.0.0.131
2025-10-27 03:17:02,500 - INFO - Validated that VN ctest-trans_left_vn-66643700 is not in any agent
2025-10-27 03:17:02,542 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-trans_left_vn-66643700 info
2025-10-27 03:17:02,542 - INFO - Deleting VN ctest-right_vn-79980215
2025-10-27 03:17:02,616 - DEBUG - VN f180a99f-f948-446c-85bf-07f211d15bdd still in use: Unable to complete operation on network f180a99f-f948-446c-85bf-07f211d15bdd. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-9de481bc-84c3-458c-a36e-c9f77f78b9d3']
2025-10-27 03:17:02,616 - WARNING - Deleting VN ctest-right_vn-79980215 failed..Will retry
2025-10-27 03:17:04,811 - DEBUG - Response for deleting network ()
2025-10-27 03:17:04,812 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/9a5fc160-c487-40b2-95fc-a06258996e1e
2025-10-27 03:17:04,819 - DEBUG - Response Code: 404
2025-10-27 03:17:04,819 - DEBUG - Requesting: http://10.0.0.249:8082/domains
2025-10-27 03:17:04,839 - DEBUG - Requesting: http://10.0.0.249:8082/domain/8213efff-6224-4943-8f79-85cc33013f73
2025-10-27 03:17:04,856 - DEBUG - Requesting: http://10.0.0.249:8082/project/c9ac7390-e193-4b8b-9d93-9337d1127328
2025-10-27 03:17:04,943 - INFO - Validated that VN ctest-right_vn-79980215 is not found in API Server
2025-10-27 03:17:04,956 - DEBUG - VN ctest-right_vn-79980215 is not present in Agent 10.0.0.130
2025-10-27 03:17:04,966 - DEBUG - VN ctest-right_vn-79980215 is not present in Agent 10.0.0.131
2025-10-27 03:17:04,966 - INFO - Validated that VN ctest-right_vn-79980215 is not in any agent
2025-10-27 03:17:04,999 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-79980215 info
2025-10-27 03:17:04,999 - INFO - Deleting VN ctest-left_vn-50999914
2025-10-27 03:17:05,219 - DEBUG - Response for deleting network ()
2025-10-27 03:17:05,219 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/11f5c2a3-cfed-4110-a9f8-22137c3d4b56
2025-10-27 03:17:05,232 - DEBUG - Response Code: 404
2025-10-27 03:17:05,232 - DEBUG - Requesting: http://10.0.0.249:8082/domains
2025-10-27 03:17:05,244 - DEBUG - Requesting: http://10.0.0.249:8082/domain/8213efff-6224-4943-8f79-85cc33013f73
2025-10-27 03:17:05,264 - DEBUG - Requesting: http://10.0.0.249:8082/project/c9ac7390-e193-4b8b-9d93-9337d1127328
2025-10-27 03:17:05,365 - INFO - Validated that VN ctest-left_vn-50999914 is not found in API Server
2025-10-27 03:17:05,381 - DEBUG - VN ctest-left_vn-50999914 is not present in Agent 10.0.0.130
2025-10-27 03:17:05,391 - DEBUG - VN ctest-left_vn-50999914 is not present in Agent 10.0.0.131
2025-10-27 03:17:05,391 - INFO - Validated that VN ctest-left_vn-50999914 is not in any agent
2025-10-27 03:17:05,425 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-50999914 info
2025-10-27 03:17:05,425 - INFO - Deleting VN ctest-mgmt_vn-99940985
2025-10-27 03:17:05,591 - DEBUG - Response for deleting network ()
2025-10-27 03:17:05,591 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/beb7d6ac-7017-43af-ad60-d1bb540d695f
2025-10-27 03:17:05,599 - DEBUG - Response Code: 404
2025-10-27 03:17:05,599 - DEBUG - Requesting: http://10.0.0.249:8082/domains
2025-10-27 03:17:05,606 - DEBUG - Requesting: http://10.0.0.249:8082/domain/8213efff-6224-4943-8f79-85cc33013f73
2025-10-27 03:17:05,620 - DEBUG - Requesting: http://10.0.0.249:8082/project/c9ac7390-e193-4b8b-9d93-9337d1127328
2025-10-27 03:17:05,707 - INFO - Validated that VN ctest-mgmt_vn-99940985 is not found in API Server
2025-10-27 03:17:05,720 - DEBUG - VN ctest-mgmt_vn-99940985 is not present in Agent 10.0.0.130
2025-10-27 03:17:05,731 - DEBUG - VN ctest-mgmt_vn-99940985 is not present in Agent 10.0.0.131
2025-10-27 03:17:05,731 - INFO - Validated that VN ctest-mgmt_vn-99940985 is not in any agent
2025-10-27 03:17:05,763 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-99940985 info
2025-10-27 03:17:07,068 - DEBUG - No XMPP flaps were noticed during the test
2025-10-27 03:17:07,069 - INFO -
2025-10-27 03:17:07,069 - INFO - END TEST : test_svc_trans_segment_right_hc_fail_svm : SKIPPED[0:00:17]
2025-10-27 03:17:07,069 - INFO - --------------------------------------------------------------------------------
2025-10-27 03:17:07,844 - INFO - Deleted project: ctest-TestSvcHC-99437539, ID : c9ac7390-e193-4b8b-9d93-9337d1127328