2025-09-15 03:01:07,353 - INFO - Domain Default found not creating 2025-09-15 03:01:07,485 - INFO - Project ctest-TestSvcHC-18866783 not found, creating it 2025-09-15 03:01:07,971 - INFO - Created Project:ctest-TestSvcHC-18866783, ID : eb53b1a3-ea12-441c-8876-d6e981243169 2025-09-15 03:01:09,378 - INFO - ================================================================================ 2025-09-15 03:01:09,378 - INFO - STARTING TEST : test_svc_hc_basic 2025-09-15 03:01:10,652 - DEBUG - Nothing to compare xmpp stats {'10.0.0.19': {'10.20.0.14': '0', '10.20.0.25': '0'}, '10.0.0.137': {'10.20.0.25': '0', '10.20.0.14': '0'}} with 2025-09-15 03:01:10,653 - INFO - Initial checks done. Running the testcase now 2025-09-15 03:01:10,653 - INFO - 2025-09-15 03:01:11,329 - DEBUG - Response for create_network : {'network': {'id': '8d197322-8a02-4183-af65-19aefaf49471', 'name': 'ctest-mgmt_vn-09477089', 'tenant_id': 'eb53b1a3ea12441c8876d6e981243169', 'project_id': 'eb53b1a3ea12441c8876d6e981243169', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-18866783', 'ctest-mgmt_vn-09477089'], 'port_security_enabled': True, 'description': ''}} 2025-09-15 03:01:11,580 - DEBUG - Response for create_subnet : {'subnet': {'id': '068ea3d7-a4b8-4932-b920-46abfd8ba778', 'name': '', 'tenant_id': 'eb53b1a3ea12441c8876d6e981243169', 'network_id': '8d197322-8a02-4183-af65-19aefaf49471', 'ip_version': 4, 'cidr': '84.142.57.0/26', 'allocation_pools': [{'start': '84.142.57.2', 'end': '84.142.57.62'}], 'gateway_ip': '84.142.57.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '84.142.57.2', 'tags': [], 'project_id': 'eb53b1a3ea12441c8876d6e981243169'}} 2025-09-15 03:01:11,604 - INFO - Created VN ctest-mgmt_vn-09477089 2025-09-15 03:01:11,616 - DEBUG - VN ctest-mgmt_vn-09477089 UUID is 8d197322-8a02-4183-af65-19aefaf49471 2025-09-15 03:01:11,697 - DEBUG - Requesting: http://10.0.0.249:8082/domains 2025-09-15 03:01:11,996 - DEBUG - Requesting: http://10.0.0.249:8082/domains 2025-09-15 03:01:12,024 - DEBUG - Requesting: http://10.0.0.249:8082/domain/fb35da95-2d14-4bd5-8610-16128fba9774 2025-09-15 03:01:12,043 - DEBUG - Requesting: http://10.0.0.249:8082/project/eb53b1a3-ea12-441c-8876-d6e981243169 2025-09-15 03:01:12,150 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/8d197322-8a02-4183-af65-19aefaf49471 2025-09-15 03:01:12,163 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/8d197322-8a02-4183-af65-19aefaf49471 2025-09-15 03:01:12,172 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/711d1c86-314e-4578-8d67-2fd4f23ec259 2025-09-15 03:01:12,182 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/711d1c86-314e-4578-8d67-2fd4f23ec259 2025-09-15 03:01:12,188 - DEBUG - Requesting: http://10.0.0.249:8082/route-target/52fba40b-0092-430f-bc2d-25d1a94a3853 2025-09-15 03:01:12,199 - DEBUG - Route Targets: ['target:64512:8000004'] 2025-09-15 03:01:12,199 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/8d197322-8a02-4183-af65-19aefaf49471 2025-09-15 03:01:12,210 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/711d1c86-314e-4578-8d67-2fd4f23ec259 2025-09-15 03:01:12,226 - INFO - Verified VN network id 11 for VN 8d197322-8a02-4183-af65-19aefaf49471 2025-09-15 03:01:12,227 - INFO - Verifications in API Server for VN ctest-mgmt_vn-09477089 passed 2025-09-15 03:01:12,227 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/8d197322-8a02-4183-af65-19aefaf49471 2025-09-15 03:01:12,238 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/711d1c86-314e-4578-8d67-2fd4f23ec259 2025-09-15 03:01:12,247 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/711d1c86-314e-4578-8d67-2fd4f23ec259 2025-09-15 03:01:12,257 - DEBUG - Requesting: http://10.0.0.249:8082/route-target/52fba40b-0092-430f-bc2d-25d1a94a3853 2025-09-15 03:01:12,276 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-18866783:ctest-mgmt_vn-09477089', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-18866783', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10167284225947091331', 'uuid-lslong': '12638536168610501745'}, 'enable': 'true', 'created': '2025-09-15T03:01:11', 'last-modified': '2025-09-15T03:01:11', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.728530'} 2025-09-15 03:01:12,286 - DEBUG - Route Targets: ['target:64512:8000004'] 2025-09-15 03:01:12,292 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-18866783:ctest-mgmt_vn-09477089', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-18866783', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10167284225947091331', 'uuid-lslong': '12638536168610501745'}, 'enable': 'true', 'created': '2025-09-15T03:01:11', 'last-modified': '2025-09-15T03:01:11', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.755332'} 2025-09-15 03:01:12,298 - DEBUG - Route Targets: ['target:64512:8000004'] 2025-09-15 03:01:12,304 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-18866783:ctest-mgmt_vn-09477089', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-18866783', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10167284225947091331', 'uuid-lslong': '12638536168610501745'}, 'enable': 'true', 'created': '2025-09-15T03:01:11', 'last-modified': '2025-09-15T03:01:11', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.765935'} 2025-09-15 03:01:12,309 - DEBUG - Route Targets: ['target:64512:8000004'] 2025-09-15 03:01:12,309 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-09477089 passed 2025-09-15 03:01:12,309 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-09477089 in API_Server ====== 2025-09-15 03:01:12,309 - DEBUG - Requesting: http://10.0.0.249:8082/domains 2025-09-15 03:01:12,316 - DEBUG - Requesting: http://10.0.0.249:8082/domain/fb35da95-2d14-4bd5-8610-16128fba9774 2025-09-15 03:01:12,326 - DEBUG - Requesting: http://10.0.0.249:8082/project/eb53b1a3-ea12-441c-8876-d6e981243169 2025-09-15 03:01:12,438 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/8d197322-8a02-4183-af65-19aefaf49471 2025-09-15 03:01:12,452 - DEBUG - =>VN ctest-mgmt_vn-09477089 has no policy to be verified 2025-09-15 03:01:12,452 - DEBUG - Verifying the vn in opserver 2025-09-15 03:01:12,452 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-18866783:ctest-mgmt_vn-09477089 virtual network link through opserver 10.0.0.249 2025-09-15 03:01:12,452 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks 2025-09-15 03:01:12,775 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks 2025-09-15 03:01:12,831 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-18866783:ctest-mgmt_vn-09477089', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-18866783:ctest-mgmt_vn-09477089?flat'} 2025-09-15 03:01:12,831 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-18866783:ctest-mgmt_vn-09477089 virtual network link through opserver 10.0.0.27 2025-09-15 03:01:12,831 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks 2025-09-15 03:01:13,126 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks 2025-09-15 03:01:13,183 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-18866783:ctest-mgmt_vn-09477089', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-18866783:ctest-mgmt_vn-09477089?flat'} 2025-09-15 03:01:13,183 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-18866783:ctest-mgmt_vn-09477089 virtual network link through opserver 10.0.0.38 2025-09-15 03:01:13,183 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks 2025-09-15 03:01:13,481 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks 2025-09-15 03:01:13,537 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-18866783:ctest-mgmt_vn-09477089', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-18866783:ctest-mgmt_vn-09477089?flat'} 2025-09-15 03:01:13,537 - INFO - Validated that VN default-domain:ctest-TestSvcHC-18866783:ctest-mgmt_vn-09477089 is found in opserver 2025-09-15 03:01:13,557 - DEBUG - Do not have enough data to verify VN in agent 2025-09-15 03:01:13,565 - DEBUG - VRF ids for VN ctest-mgmt_vn-09477089: {} 2025-09-15 03:01:13,822 - DEBUG - Response for create_network : {'network': {'id': '98bde99d-8e6b-4566-8d86-b92496df54c8', 'name': 'ctest-left_vn-07647523', 'tenant_id': 'eb53b1a3ea12441c8876d6e981243169', 'project_id': 'eb53b1a3ea12441c8876d6e981243169', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-18866783', 'ctest-left_vn-07647523'], 'port_security_enabled': True, 'description': ''}} 2025-09-15 03:01:14,094 - DEBUG - Response for create_subnet : {'subnet': {'id': 'ba340eb1-2aa7-4f98-8b83-7ac6d3666867', 'name': '', 'tenant_id': 'eb53b1a3ea12441c8876d6e981243169', 'network_id': '98bde99d-8e6b-4566-8d86-b92496df54c8', 'ip_version': 4, 'cidr': '205.54.221.192/26', 'allocation_pools': [{'start': '205.54.221.194', 'end': '205.54.221.254'}], 'gateway_ip': '205.54.221.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '205.54.221.194', 'tags': [], 'project_id': 'eb53b1a3ea12441c8876d6e981243169'}} 2025-09-15 03:01:14,118 - INFO - Created VN ctest-left_vn-07647523 2025-09-15 03:01:14,130 - DEBUG - VN ctest-left_vn-07647523 UUID is 98bde99d-8e6b-4566-8d86-b92496df54c8 2025-09-15 03:01:14,199 - DEBUG - Requesting: http://10.0.0.249:8082/domains 2025-09-15 03:01:14,206 - DEBUG - Requesting: http://10.0.0.249:8082/domain/fb35da95-2d14-4bd5-8610-16128fba9774 2025-09-15 03:01:14,216 - DEBUG - Requesting: http://10.0.0.249:8082/project/eb53b1a3-ea12-441c-8876-d6e981243169 2025-09-15 03:01:14,315 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/98bde99d-8e6b-4566-8d86-b92496df54c8 2025-09-15 03:01:14,332 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/98bde99d-8e6b-4566-8d86-b92496df54c8 2025-09-15 03:01:14,343 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/5690c94c-9d9f-4c26-89d3-5e9796ed534e 2025-09-15 03:01:14,362 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/5690c94c-9d9f-4c26-89d3-5e9796ed534e 2025-09-15 03:01:14,377 - DEBUG - Route Targets: [] 2025-09-15 03:01:14,377 - DEBUG - RT names not yet present for VN ctest-left_vn-07647523 2025-09-15 03:01:19,378 - DEBUG - Requesting: http://10.0.0.249:8082/domains 2025-09-15 03:01:19,390 - DEBUG - Requesting: http://10.0.0.249:8082/domain/fb35da95-2d14-4bd5-8610-16128fba9774 2025-09-15 03:01:19,410 - DEBUG - Requesting: http://10.0.0.249:8082/project/eb53b1a3-ea12-441c-8876-d6e981243169 2025-09-15 03:01:19,498 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/98bde99d-8e6b-4566-8d86-b92496df54c8 2025-09-15 03:01:19,515 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/98bde99d-8e6b-4566-8d86-b92496df54c8 2025-09-15 03:01:19,530 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/5690c94c-9d9f-4c26-89d3-5e9796ed534e 2025-09-15 03:01:19,551 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/5690c94c-9d9f-4c26-89d3-5e9796ed534e 2025-09-15 03:01:19,566 - DEBUG - Requesting: http://10.0.0.249:8082/route-target/4ded419a-d5e5-462e-a759-9b4ec28952c5 2025-09-15 03:01:19,578 - DEBUG - Route Targets: ['target:64512:8000005'] 2025-09-15 03:01:19,578 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/98bde99d-8e6b-4566-8d86-b92496df54c8 2025-09-15 03:01:19,590 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/5690c94c-9d9f-4c26-89d3-5e9796ed534e 2025-09-15 03:01:19,611 - INFO - Verified VN network id 12 for VN 98bde99d-8e6b-4566-8d86-b92496df54c8 2025-09-15 03:01:19,612 - INFO - Verifications in API Server for VN ctest-left_vn-07647523 passed 2025-09-15 03:01:19,612 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/98bde99d-8e6b-4566-8d86-b92496df54c8 2025-09-15 03:01:19,625 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/5690c94c-9d9f-4c26-89d3-5e9796ed534e 2025-09-15 03:01:19,635 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/5690c94c-9d9f-4c26-89d3-5e9796ed534e 2025-09-15 03:01:19,644 - DEBUG - Requesting: http://10.0.0.249:8082/route-target/4ded419a-d5e5-462e-a759-9b4ec28952c5 2025-09-15 03:01:19,662 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-18866783:ctest-left_vn-07647523', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-18866783', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11006209927271892326', 'uuid-lslong': '10198041973028246728'}, 'enable': 'true', 'created': '2025-09-15T03:01:13', 'last-modified': '2025-09-15T03:01:14', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:05.619146'} 2025-09-15 03:01:19,669 - DEBUG - Route Targets: ['target:64512:8000005'] 2025-09-15 03:01:19,677 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-18866783:ctest-left_vn-07647523', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-18866783', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11006209927271892326', 'uuid-lslong': '10198041973028246728'}, 'enable': 'true', 'created': '2025-09-15T03:01:13', 'last-modified': '2025-09-15T03:01:14', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:05.634880'} 2025-09-15 03:01:19,687 - DEBUG - Route Targets: ['target:64512:8000005'] 2025-09-15 03:01:19,695 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-18866783:ctest-left_vn-07647523', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-18866783', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11006209927271892326', 'uuid-lslong': '10198041973028246728'}, 'enable': 'true', 'created': '2025-09-15T03:01:13', 'last-modified': '2025-09-15T03:01:14', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:05.645888'} 2025-09-15 03:01:19,705 - DEBUG - Route Targets: ['target:64512:8000005'] 2025-09-15 03:01:19,705 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-07647523 passed 2025-09-15 03:01:19,705 - DEBUG - ====Verifying policy data for ctest-left_vn-07647523 in API_Server ====== 2025-09-15 03:01:19,706 - DEBUG - Requesting: http://10.0.0.249:8082/domains 2025-09-15 03:01:19,715 - DEBUG - Requesting: http://10.0.0.249:8082/domain/fb35da95-2d14-4bd5-8610-16128fba9774 2025-09-15 03:01:19,731 - DEBUG - Requesting: http://10.0.0.249:8082/project/eb53b1a3-ea12-441c-8876-d6e981243169 2025-09-15 03:01:19,826 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/98bde99d-8e6b-4566-8d86-b92496df54c8 2025-09-15 03:01:19,843 - DEBUG - =>VN ctest-left_vn-07647523 has no policy to be verified 2025-09-15 03:01:19,843 - DEBUG - Verifying the vn in opserver 2025-09-15 03:01:19,843 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-18866783:ctest-left_vn-07647523 virtual network link through opserver 10.0.0.249 2025-09-15 03:01:19,844 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks 2025-09-15 03:01:19,930 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-18866783:ctest-left_vn-07647523', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-18866783:ctest-left_vn-07647523?flat'} 2025-09-15 03:01:19,930 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-18866783:ctest-left_vn-07647523 virtual network link through opserver 10.0.0.27 2025-09-15 03:01:19,930 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks 2025-09-15 03:01:19,991 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-18866783:ctest-left_vn-07647523', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-18866783:ctest-left_vn-07647523?flat'} 2025-09-15 03:01:19,991 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-18866783:ctest-left_vn-07647523 virtual network link through opserver 10.0.0.38 2025-09-15 03:01:19,991 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks 2025-09-15 03:01:20,067 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-18866783:ctest-left_vn-07647523', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-18866783:ctest-left_vn-07647523?flat'} 2025-09-15 03:01:20,067 - INFO - Validated that VN default-domain:ctest-TestSvcHC-18866783:ctest-left_vn-07647523 is found in opserver 2025-09-15 03:01:20,087 - DEBUG - Do not have enough data to verify VN in agent 2025-09-15 03:01:20,096 - DEBUG - VRF ids for VN ctest-left_vn-07647523: {} 2025-09-15 03:01:20,379 - DEBUG - Response for create_network : {'network': {'id': '6f5521cb-f98b-4fc2-b8a3-8bf1e1ac350c', 'name': 'ctest-right_vn-13302616', 'tenant_id': 'eb53b1a3ea12441c8876d6e981243169', 'project_id': 'eb53b1a3ea12441c8876d6e981243169', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-18866783', 'ctest-right_vn-13302616'], 'port_security_enabled': True, 'description': ''}} 2025-09-15 03:01:20,682 - DEBUG - Response for create_subnet : {'subnet': {'id': '09f4f0f9-d5e5-46bb-89cd-b810eff47f84', 'name': '', 'tenant_id': 'eb53b1a3ea12441c8876d6e981243169', 'network_id': '6f5521cb-f98b-4fc2-b8a3-8bf1e1ac350c', 'ip_version': 4, 'cidr': '55.36.151.0/26', 'allocation_pools': [{'start': '55.36.151.2', 'end': '55.36.151.62'}], 'gateway_ip': '55.36.151.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '55.36.151.2', 'tags': [], 'project_id': 'eb53b1a3ea12441c8876d6e981243169'}} 2025-09-15 03:01:20,702 - INFO - Created VN ctest-right_vn-13302616 2025-09-15 03:01:20,713 - DEBUG - VN ctest-right_vn-13302616 UUID is 6f5521cb-f98b-4fc2-b8a3-8bf1e1ac350c 2025-09-15 03:01:20,797 - DEBUG - Requesting: http://10.0.0.249:8082/domains 2025-09-15 03:01:20,805 - DEBUG - Requesting: http://10.0.0.249:8082/domain/fb35da95-2d14-4bd5-8610-16128fba9774 2025-09-15 03:01:20,819 - DEBUG - Requesting: http://10.0.0.249:8082/project/eb53b1a3-ea12-441c-8876-d6e981243169 2025-09-15 03:01:20,924 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/6f5521cb-f98b-4fc2-b8a3-8bf1e1ac350c 2025-09-15 03:01:20,938 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/6f5521cb-f98b-4fc2-b8a3-8bf1e1ac350c 2025-09-15 03:01:20,949 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/1b62dc21-3cae-462a-917d-ade8f2efafa5 2025-09-15 03:01:20,957 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/1b62dc21-3cae-462a-917d-ade8f2efafa5 2025-09-15 03:01:20,967 - DEBUG - Requesting: http://10.0.0.249:8082/route-target/ad3ea76f-9c90-45c1-8bc7-66bc484302a1 2025-09-15 03:01:20,975 - DEBUG - Route Targets: ['target:64512:8000006'] 2025-09-15 03:01:20,975 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/6f5521cb-f98b-4fc2-b8a3-8bf1e1ac350c 2025-09-15 03:01:20,984 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/1b62dc21-3cae-462a-917d-ade8f2efafa5 2025-09-15 03:01:21,000 - INFO - Verified VN network id 13 for VN 6f5521cb-f98b-4fc2-b8a3-8bf1e1ac350c 2025-09-15 03:01:21,000 - INFO - Verifications in API Server for VN ctest-right_vn-13302616 passed 2025-09-15 03:01:21,001 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/6f5521cb-f98b-4fc2-b8a3-8bf1e1ac350c 2025-09-15 03:01:21,012 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/1b62dc21-3cae-462a-917d-ade8f2efafa5 2025-09-15 03:01:21,021 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/1b62dc21-3cae-462a-917d-ade8f2efafa5 2025-09-15 03:01:21,030 - DEBUG - Requesting: http://10.0.0.249:8082/route-target/ad3ea76f-9c90-45c1-8bc7-66bc484302a1 2025-09-15 03:01:21,043 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-18866783:ctest-right_vn-13302616', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-18866783', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8022355471179141058', 'uuid-lslong': '13304631595172115724'}, 'enable': 'true', 'created': '2025-09-15T03:01:20', 'last-modified': '2025-09-15T03:01:20', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.446554'} 2025-09-15 03:01:21,049 - DEBUG - Route Targets: ['target:64512:8000006'] 2025-09-15 03:01:21,053 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-18866783:ctest-right_vn-13302616', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-18866783', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8022355471179141058', 'uuid-lslong': '13304631595172115724'}, 'enable': 'true', 'created': '2025-09-15T03:01:20', 'last-modified': '2025-09-15T03:01:20', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.459667'} 2025-09-15 03:01:21,058 - DEBUG - Route Targets: ['target:64512:8000006'] 2025-09-15 03:01:21,063 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-18866783:ctest-right_vn-13302616', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-18866783', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8022355471179141058', 'uuid-lslong': '13304631595172115724'}, 'enable': 'true', 'created': '2025-09-15T03:01:20', 'last-modified': '2025-09-15T03:01:20', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.470191'} 2025-09-15 03:01:21,069 - DEBUG - Route Targets: ['target:64512:8000006'] 2025-09-15 03:01:21,069 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-13302616 passed 2025-09-15 03:01:21,069 - DEBUG - ====Verifying policy data for ctest-right_vn-13302616 in API_Server ====== 2025-09-15 03:01:21,070 - DEBUG - Requesting: http://10.0.0.249:8082/domains 2025-09-15 03:01:21,076 - DEBUG - Requesting: http://10.0.0.249:8082/domain/fb35da95-2d14-4bd5-8610-16128fba9774 2025-09-15 03:01:21,089 - DEBUG - Requesting: http://10.0.0.249:8082/project/eb53b1a3-ea12-441c-8876-d6e981243169 2025-09-15 03:01:21,197 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/6f5521cb-f98b-4fc2-b8a3-8bf1e1ac350c 2025-09-15 03:01:21,211 - DEBUG - =>VN ctest-right_vn-13302616 has no policy to be verified 2025-09-15 03:01:21,211 - DEBUG - Verifying the vn in opserver 2025-09-15 03:01:21,211 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-18866783:ctest-right_vn-13302616 virtual network link through opserver 10.0.0.249 2025-09-15 03:01:21,211 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks 2025-09-15 03:01:21,269 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-18866783:ctest-right_vn-13302616', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-18866783:ctest-right_vn-13302616?flat'} 2025-09-15 03:01:21,269 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-18866783:ctest-right_vn-13302616 virtual network link through opserver 10.0.0.27 2025-09-15 03:01:21,269 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks 2025-09-15 03:01:21,284 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-18866783:ctest-right_vn-13302616', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-18866783:ctest-right_vn-13302616?flat'} 2025-09-15 03:01:21,284 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-18866783:ctest-right_vn-13302616 virtual network link through opserver 10.0.0.38 2025-09-15 03:01:21,284 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks 2025-09-15 03:01:21,297 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-18866783:ctest-right_vn-13302616', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-18866783:ctest-right_vn-13302616?flat'} 2025-09-15 03:01:21,297 - INFO - Validated that VN default-domain:ctest-TestSvcHC-18866783:ctest-right_vn-13302616 is found in opserver 2025-09-15 03:01:21,323 - DEBUG - Do not have enough data to verify VN in agent 2025-09-15 03:01:21,333 - DEBUG - VRF ids for VN ctest-right_vn-13302616: {} 2025-09-15 03:01:21,397 - DEBUG - Services list from nova: [, , , ] 2025-09-15 03:01:22,444 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4110-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4110-1) 2025-09-15 03:01:23,804 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4110-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4110-2) 2025-09-15 03:01:23,805 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-81509134'] 2025-09-15 03:01:24,117 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-81509134'] created succesfully 2025-09-15 03:01:24,517 - DEBUG - Image by name tiny_nat_fw not found 2025-09-15 03:01:24,517 - DEBUG - Installing image tiny_nat_fw 2025-09-15 03:01:24,517 - 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-09-15 03:01:24,517 - DEBUG - Image build path file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz 2025-09-15 03:01:24,518 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz 2025-09-15 03:01:24,518 - DEBUG - Unzip image 2025-09-15 03:01:24,518 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz 2025-09-15 03:01:24,545 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found 2025-09-15 03:01:24,546 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-81509134'] 2025-09-15 03:01:24,644 - INFO - Service template: ['default-domain', 'ctest-service_template_1-81509134'] deleted successfully. 2025-09-15 03:01:24,645 - INFO - Skip interface_detach for VM ctest-right_vm-79712160 in state BUILD 2025-09-15 03:01:24,645 - INFO - Deleting VM ctest-right_vm-79712160 2025-09-15 03:01:24,701 - ERROR - VM ctest-right_vm-79712160 has failed to come up 2025-09-15 03:01:24,701 - ERROR - Nova failed to get host of the VM 2025-09-15 03:01:24,701 - ERROR - VM ctest-right_vm-79712160 has failed to come up 2025-09-15 03:01:24,701 - ERROR - Nova failed to get host of the VM 2025-09-15 03:01:24,793 - INFO - Skip interface_detach for VM ctest-left_vm-07741272 in state BUILD 2025-09-15 03:01:24,794 - INFO - Deleting VM ctest-left_vm-07741272 2025-09-15 03:01:24,794 - ERROR - VM ctest-left_vm-07741272 has failed to come up 2025-09-15 03:01:24,794 - ERROR - Nova failed to get host of the VM 2025-09-15 03:01:24,794 - ERROR - VM ctest-left_vm-07741272 has failed to come up 2025-09-15 03:01:24,794 - ERROR - Nova failed to get host of the VM 2025-09-15 03:01:24,867 - INFO - Deleting VN ctest-right_vn-13302616 2025-09-15 03:01:24,912 - DEBUG - VN 6f5521cb-f98b-4fc2-b8a3-8bf1e1ac350c still in use: Unable to complete operation on network 6f5521cb-f98b-4fc2-b8a3-8bf1e1ac350c. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-a77235d4-121a-4570-ab2f-d77b7f2347fb'] 2025-09-15 03:01:24,912 - WARNING - Deleting VN ctest-right_vn-13302616 failed..Will retry 2025-09-15 03:01:27,057 - DEBUG - Response for deleting network () 2025-09-15 03:01:27,057 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/1b62dc21-3cae-462a-917d-ade8f2efafa5 2025-09-15 03:01:27,063 - DEBUG - Response Code: 404 2025-09-15 03:01:27,063 - DEBUG - Requesting: http://10.0.0.249:8082/domains 2025-09-15 03:01:27,070 - DEBUG - Requesting: http://10.0.0.249:8082/domain/fb35da95-2d14-4bd5-8610-16128fba9774 2025-09-15 03:01:27,096 - DEBUG - Requesting: http://10.0.0.249:8082/project/eb53b1a3-ea12-441c-8876-d6e981243169 2025-09-15 03:01:27,206 - INFO - Validated that VN ctest-right_vn-13302616 is not found in API Server 2025-09-15 03:01:27,219 - DEBUG - VN ctest-right_vn-13302616 is not present in Agent 10.0.0.19 2025-09-15 03:01:27,234 - DEBUG - VN ctest-right_vn-13302616 is not present in Agent 10.0.0.137 2025-09-15 03:01:27,234 - INFO - Validated that VN ctest-right_vn-13302616 is not in any agent 2025-09-15 03:01:27,269 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-13302616 info 2025-09-15 03:01:27,269 - INFO - Deleting VN ctest-left_vn-07647523 2025-09-15 03:01:27,418 - DEBUG - Response for deleting network () 2025-09-15 03:01:27,418 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/5690c94c-9d9f-4c26-89d3-5e9796ed534e 2025-09-15 03:01:27,425 - DEBUG - Response Code: 404 2025-09-15 03:01:27,425 - DEBUG - Requesting: http://10.0.0.249:8082/domains 2025-09-15 03:01:27,433 - DEBUG - Requesting: http://10.0.0.249:8082/domain/fb35da95-2d14-4bd5-8610-16128fba9774 2025-09-15 03:01:27,451 - DEBUG - Requesting: http://10.0.0.249:8082/project/eb53b1a3-ea12-441c-8876-d6e981243169 2025-09-15 03:01:27,539 - INFO - Validated that VN ctest-left_vn-07647523 is not found in API Server 2025-09-15 03:01:27,549 - DEBUG - VN ctest-left_vn-07647523 is not present in Agent 10.0.0.19 2025-09-15 03:01:27,559 - DEBUG - VN ctest-left_vn-07647523 is not present in Agent 10.0.0.137 2025-09-15 03:01:27,559 - INFO - Validated that VN ctest-left_vn-07647523 is not in any agent 2025-09-15 03:01:27,589 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-07647523 info 2025-09-15 03:01:27,589 - INFO - Deleting VN ctest-mgmt_vn-09477089 2025-09-15 03:01:27,718 - DEBUG - Response for deleting network () 2025-09-15 03:01:27,718 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/711d1c86-314e-4578-8d67-2fd4f23ec259 2025-09-15 03:01:27,725 - DEBUG - Response Code: 404 2025-09-15 03:01:27,726 - DEBUG - Requesting: http://10.0.0.249:8082/domains 2025-09-15 03:01:27,733 - DEBUG - Requesting: http://10.0.0.249:8082/domain/fb35da95-2d14-4bd5-8610-16128fba9774 2025-09-15 03:01:27,750 - DEBUG - Requesting: http://10.0.0.249:8082/project/eb53b1a3-ea12-441c-8876-d6e981243169 2025-09-15 03:01:27,848 - INFO - Validated that VN ctest-mgmt_vn-09477089 is not found in API Server 2025-09-15 03:01:27,858 - DEBUG - VN ctest-mgmt_vn-09477089 is not present in Agent 10.0.0.19 2025-09-15 03:01:27,871 - DEBUG - VN ctest-mgmt_vn-09477089 is not present in Agent 10.0.0.137 2025-09-15 03:01:27,871 - INFO - Validated that VN ctest-mgmt_vn-09477089 is not in any agent 2025-09-15 03:01:27,898 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-09477089 info 2025-09-15 03:01:29,163 - DEBUG - No XMPP flaps were noticed during the test 2025-09-15 03:01:29,163 - INFO -
2025-09-15 03:01:29,163 - INFO - END TEST : test_svc_hc_basic : SKIPPED[0:00:20]
2025-09-15 03:01:29,163 - INFO - -------------------------------------------------------------------------------- 2025-09-15 03:01:29,169 - INFO - ================================================================================ 2025-09-15 03:01:29,169 - INFO - STARTING TEST : test_svc_trans_segment_right_hc_fail_svm 2025-09-15 03:01:30,443 - DEBUG - Nothing to compare xmpp stats {'10.0.0.19': {'10.20.0.14': '0', '10.20.0.25': '0'}, '10.0.0.137': {'10.20.0.25': '0', '10.20.0.14': '0'}} with 2025-09-15 03:01:30,443 - INFO - Initial checks done. Running the testcase now 2025-09-15 03:01:30,443 - INFO - 2025-09-15 03:01:30,694 - DEBUG - Response for create_network : {'network': {'id': 'f6d0f3f2-8e5f-4e54-b05c-63b576fdc2de', 'name': 'ctest-mgmt_vn-60536442', 'tenant_id': 'eb53b1a3ea12441c8876d6e981243169', 'project_id': 'eb53b1a3ea12441c8876d6e981243169', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-18866783', 'ctest-mgmt_vn-60536442'], 'port_security_enabled': True, 'description': ''}} 2025-09-15 03:01:30,962 - DEBUG - Response for create_subnet : {'subnet': {'id': '0aa2f8e7-8a4f-4236-8816-2384ab6ac3b7', 'name': '', 'tenant_id': 'eb53b1a3ea12441c8876d6e981243169', 'network_id': 'f6d0f3f2-8e5f-4e54-b05c-63b576fdc2de', 'ip_version': 4, 'cidr': '79.234.123.64/26', 'allocation_pools': [{'start': '79.234.123.66', 'end': '79.234.123.126'}], 'gateway_ip': '79.234.123.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '79.234.123.66', 'tags': [], 'project_id': 'eb53b1a3ea12441c8876d6e981243169'}} 2025-09-15 03:01:30,981 - INFO - Created VN ctest-mgmt_vn-60536442 2025-09-15 03:01:30,991 - DEBUG - VN ctest-mgmt_vn-60536442 UUID is f6d0f3f2-8e5f-4e54-b05c-63b576fdc2de 2025-09-15 03:01:31,062 - DEBUG - Requesting: http://10.0.0.249:8082/domains 2025-09-15 03:01:31,068 - DEBUG - Requesting: http://10.0.0.249:8082/domain/fb35da95-2d14-4bd5-8610-16128fba9774 2025-09-15 03:01:31,079 - DEBUG - Requesting: http://10.0.0.249:8082/project/eb53b1a3-ea12-441c-8876-d6e981243169 2025-09-15 03:01:31,170 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/f6d0f3f2-8e5f-4e54-b05c-63b576fdc2de 2025-09-15 03:01:31,189 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/f6d0f3f2-8e5f-4e54-b05c-63b576fdc2de 2025-09-15 03:01:31,199 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/eefc0306-5be0-4bfe-ae69-753568fd22cd 2025-09-15 03:01:31,210 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/eefc0306-5be0-4bfe-ae69-753568fd22cd 2025-09-15 03:01:31,217 - DEBUG - Requesting: http://10.0.0.249:8082/route-target/6c1f2cc3-1df4-4e14-b7eb-bd0f046c184e 2025-09-15 03:01:31,224 - DEBUG - Route Targets: ['target:64512:8000004'] 2025-09-15 03:01:31,224 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/f6d0f3f2-8e5f-4e54-b05c-63b576fdc2de 2025-09-15 03:01:31,234 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/eefc0306-5be0-4bfe-ae69-753568fd22cd 2025-09-15 03:01:31,256 - INFO - Verified VN network id 11 for VN f6d0f3f2-8e5f-4e54-b05c-63b576fdc2de 2025-09-15 03:01:31,256 - INFO - Verifications in API Server for VN ctest-mgmt_vn-60536442 passed 2025-09-15 03:01:31,256 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/f6d0f3f2-8e5f-4e54-b05c-63b576fdc2de 2025-09-15 03:01:31,265 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/eefc0306-5be0-4bfe-ae69-753568fd22cd 2025-09-15 03:01:31,272 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/eefc0306-5be0-4bfe-ae69-753568fd22cd 2025-09-15 03:01:31,289 - DEBUG - Requesting: http://10.0.0.249:8082/route-target/6c1f2cc3-1df4-4e14-b7eb-bd0f046c184e 2025-09-15 03:01:31,301 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-18866783:ctest-mgmt_vn-60536442', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-18866783', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17784983151582334548', 'uuid-lslong': '12708141879569269470'}, 'enable': 'true', 'created': '2025-09-15T03:01:30', 'last-modified': '2025-09-15T03:01:30', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.395128'} 2025-09-15 03:01:31,306 - DEBUG - Route Targets: ['target:64512:8000004'] 2025-09-15 03:01:31,311 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-18866783:ctest-mgmt_vn-60536442', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-18866783', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17784983151582334548', 'uuid-lslong': '12708141879569269470'}, 'enable': 'true', 'created': '2025-09-15T03:01:30', 'last-modified': '2025-09-15T03:01:30', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.406012'} 2025-09-15 03:01:31,319 - DEBUG - Route Targets: ['target:64512:8000004'] 2025-09-15 03:01:31,325 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-18866783:ctest-mgmt_vn-60536442', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-18866783', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17784983151582334548', 'uuid-lslong': '12708141879569269470'}, 'enable': 'true', 'created': '2025-09-15T03:01:30', 'last-modified': '2025-09-15T03:01:30', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.405187'} 2025-09-15 03:01:31,332 - DEBUG - Route Targets: ['target:64512:8000004'] 2025-09-15 03:01:31,332 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-60536442 passed 2025-09-15 03:01:31,332 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-60536442 in API_Server ====== 2025-09-15 03:01:31,332 - DEBUG - Requesting: http://10.0.0.249:8082/domains 2025-09-15 03:01:31,339 - DEBUG - Requesting: http://10.0.0.249:8082/domain/fb35da95-2d14-4bd5-8610-16128fba9774 2025-09-15 03:01:31,349 - DEBUG - Requesting: http://10.0.0.249:8082/project/eb53b1a3-ea12-441c-8876-d6e981243169 2025-09-15 03:01:31,454 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/f6d0f3f2-8e5f-4e54-b05c-63b576fdc2de 2025-09-15 03:01:31,464 - DEBUG - =>VN ctest-mgmt_vn-60536442 has no policy to be verified 2025-09-15 03:01:31,464 - DEBUG - Verifying the vn in opserver 2025-09-15 03:01:31,464 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-18866783:ctest-mgmt_vn-60536442 virtual network link through opserver 10.0.0.249 2025-09-15 03:01:31,464 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks 2025-09-15 03:01:31,477 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-18866783:ctest-mgmt_vn-60536442', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-18866783:ctest-mgmt_vn-60536442?flat'} 2025-09-15 03:01:31,477 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-18866783:ctest-mgmt_vn-60536442 virtual network link through opserver 10.0.0.27 2025-09-15 03:01:31,477 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks 2025-09-15 03:01:31,539 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-18866783:ctest-mgmt_vn-60536442', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-18866783:ctest-mgmt_vn-60536442?flat'} 2025-09-15 03:01:31,539 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-18866783:ctest-mgmt_vn-60536442 virtual network link through opserver 10.0.0.38 2025-09-15 03:01:31,539 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks 2025-09-15 03:01:31,593 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-18866783:ctest-mgmt_vn-60536442', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-18866783:ctest-mgmt_vn-60536442?flat'} 2025-09-15 03:01:31,593 - INFO - Validated that VN default-domain:ctest-TestSvcHC-18866783:ctest-mgmt_vn-60536442 is found in opserver 2025-09-15 03:01:31,614 - DEBUG - Do not have enough data to verify VN in agent 2025-09-15 03:01:31,623 - DEBUG - VRF ids for VN ctest-mgmt_vn-60536442: {} 2025-09-15 03:01:31,939 - DEBUG - Response for create_network : {'network': {'id': '757f9a59-dc7f-4913-9eb9-52b7b8af2c67', 'name': 'ctest-left_vn-58982570', 'tenant_id': 'eb53b1a3ea12441c8876d6e981243169', 'project_id': 'eb53b1a3ea12441c8876d6e981243169', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-18866783', 'ctest-left_vn-58982570'], 'port_security_enabled': True, 'description': ''}} 2025-09-15 03:01:32,185 - DEBUG - Response for create_subnet : {'subnet': {'id': 'f24c81f6-5ce6-47b3-8c48-102daf708f5e', 'name': '', 'tenant_id': 'eb53b1a3ea12441c8876d6e981243169', 'network_id': '757f9a59-dc7f-4913-9eb9-52b7b8af2c67', 'ip_version': 4, 'cidr': '187.240.61.128/26', 'allocation_pools': [{'start': '187.240.61.130', 'end': '187.240.61.190'}], 'gateway_ip': '187.240.61.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '187.240.61.130', 'tags': [], 'project_id': 'eb53b1a3ea12441c8876d6e981243169'}} 2025-09-15 03:01:32,209 - INFO - Created VN ctest-left_vn-58982570 2025-09-15 03:01:32,222 - DEBUG - VN ctest-left_vn-58982570 UUID is 757f9a59-dc7f-4913-9eb9-52b7b8af2c67 2025-09-15 03:01:32,326 - DEBUG - Requesting: http://10.0.0.249:8082/domains 2025-09-15 03:01:32,333 - DEBUG - Requesting: http://10.0.0.249:8082/domain/fb35da95-2d14-4bd5-8610-16128fba9774 2025-09-15 03:01:32,344 - DEBUG - Requesting: http://10.0.0.249:8082/project/eb53b1a3-ea12-441c-8876-d6e981243169 2025-09-15 03:01:32,454 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/757f9a59-dc7f-4913-9eb9-52b7b8af2c67 2025-09-15 03:01:32,467 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/757f9a59-dc7f-4913-9eb9-52b7b8af2c67 2025-09-15 03:01:32,476 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/d7b69bee-a8e3-4dff-b9b0-c8b8decd245f 2025-09-15 03:01:32,485 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/d7b69bee-a8e3-4dff-b9b0-c8b8decd245f 2025-09-15 03:01:32,492 - DEBUG - Requesting: http://10.0.0.249:8082/route-target/d8854ce1-8789-4b8f-9d7d-859f76a93229 2025-09-15 03:01:32,501 - DEBUG - Route Targets: ['target:64512:8000005'] 2025-09-15 03:01:32,501 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/757f9a59-dc7f-4913-9eb9-52b7b8af2c67 2025-09-15 03:01:32,510 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/d7b69bee-a8e3-4dff-b9b0-c8b8decd245f 2025-09-15 03:01:32,524 - INFO - Verified VN network id 12 for VN 757f9a59-dc7f-4913-9eb9-52b7b8af2c67 2025-09-15 03:01:32,524 - INFO - Verifications in API Server for VN ctest-left_vn-58982570 passed 2025-09-15 03:01:32,524 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/757f9a59-dc7f-4913-9eb9-52b7b8af2c67 2025-09-15 03:01:32,536 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/d7b69bee-a8e3-4dff-b9b0-c8b8decd245f 2025-09-15 03:01:32,548 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/d7b69bee-a8e3-4dff-b9b0-c8b8decd245f 2025-09-15 03:01:32,556 - DEBUG - Requesting: http://10.0.0.249:8082/route-target/d8854ce1-8789-4b8f-9d7d-859f76a93229 2025-09-15 03:01:32,569 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-18866783:ctest-left_vn-58982570', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-18866783', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8466655535221917971', 'uuid-lslong': '11437263677715065959'}, 'enable': 'true', 'created': '2025-09-15T03:01:31', 'last-modified': '2025-09-15T03:01:32', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.465092'} 2025-09-15 03:01:32,576 - DEBUG - Route Targets: ['target:64512:8000005'] 2025-09-15 03:01:32,581 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-18866783:ctest-left_vn-58982570', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-18866783', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8466655535221917971', 'uuid-lslong': '11437263677715065959'}, 'enable': 'true', 'created': '2025-09-15T03:01:31', 'last-modified': '2025-09-15T03:01:32', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.481094'} 2025-09-15 03:01:32,586 - DEBUG - Route Targets: ['target:64512:8000005'] 2025-09-15 03:01:32,592 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-18866783:ctest-left_vn-58982570', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-18866783', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8466655535221917971', 'uuid-lslong': '11437263677715065959'}, 'enable': 'true', 'created': '2025-09-15T03:01:31', 'last-modified': '2025-09-15T03:01:32', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.492334'} 2025-09-15 03:01:32,599 - DEBUG - Route Targets: ['target:64512:8000005'] 2025-09-15 03:01:32,599 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-58982570 passed 2025-09-15 03:01:32,599 - DEBUG - ====Verifying policy data for ctest-left_vn-58982570 in API_Server ====== 2025-09-15 03:01:32,599 - DEBUG - Requesting: http://10.0.0.249:8082/domains 2025-09-15 03:01:32,609 - DEBUG - Requesting: http://10.0.0.249:8082/domain/fb35da95-2d14-4bd5-8610-16128fba9774 2025-09-15 03:01:32,620 - DEBUG - Requesting: http://10.0.0.249:8082/project/eb53b1a3-ea12-441c-8876-d6e981243169 2025-09-15 03:01:32,719 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/757f9a59-dc7f-4913-9eb9-52b7b8af2c67 2025-09-15 03:01:32,731 - DEBUG - =>VN ctest-left_vn-58982570 has no policy to be verified 2025-09-15 03:01:32,731 - DEBUG - Verifying the vn in opserver 2025-09-15 03:01:32,731 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-18866783:ctest-left_vn-58982570 virtual network link through opserver 10.0.0.249 2025-09-15 03:01:32,731 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks 2025-09-15 03:01:32,743 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-18866783:ctest-left_vn-58982570', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-18866783:ctest-left_vn-58982570?flat'} 2025-09-15 03:01:32,743 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-18866783:ctest-left_vn-58982570 virtual network link through opserver 10.0.0.27 2025-09-15 03:01:32,743 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks 2025-09-15 03:01:32,761 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-18866783:ctest-left_vn-58982570', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-18866783:ctest-left_vn-58982570?flat'} 2025-09-15 03:01:32,761 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-18866783:ctest-left_vn-58982570 virtual network link through opserver 10.0.0.38 2025-09-15 03:01:32,761 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks 2025-09-15 03:01:32,789 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-18866783:ctest-left_vn-58982570', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-18866783:ctest-left_vn-58982570?flat'} 2025-09-15 03:01:32,789 - INFO - Validated that VN default-domain:ctest-TestSvcHC-18866783:ctest-left_vn-58982570 is found in opserver 2025-09-15 03:01:32,808 - DEBUG - Do not have enough data to verify VN in agent 2025-09-15 03:01:32,818 - DEBUG - VRF ids for VN ctest-left_vn-58982570: {} 2025-09-15 03:01:33,120 - DEBUG - Response for create_network : {'network': {'id': '4f382e88-35c1-4adb-ad1d-3a94d7a0f646', 'name': 'ctest-right_vn-26242974', 'tenant_id': 'eb53b1a3ea12441c8876d6e981243169', 'project_id': 'eb53b1a3ea12441c8876d6e981243169', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-18866783', 'ctest-right_vn-26242974'], 'port_security_enabled': True, 'description': ''}} 2025-09-15 03:01:33,367 - DEBUG - Response for create_subnet : {'subnet': {'id': '3bcf6470-a7e5-4e6e-9f05-2171bd1841a3', 'name': '', 'tenant_id': 'eb53b1a3ea12441c8876d6e981243169', 'network_id': '4f382e88-35c1-4adb-ad1d-3a94d7a0f646', 'ip_version': 4, 'cidr': '192.208.237.64/26', 'allocation_pools': [{'start': '192.208.237.66', 'end': '192.208.237.126'}], 'gateway_ip': '192.208.237.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '192.208.237.66', 'tags': [], 'project_id': 'eb53b1a3ea12441c8876d6e981243169'}} 2025-09-15 03:01:33,403 - INFO - Created VN ctest-right_vn-26242974 2025-09-15 03:01:33,418 - DEBUG - VN ctest-right_vn-26242974 UUID is 4f382e88-35c1-4adb-ad1d-3a94d7a0f646 2025-09-15 03:01:33,493 - DEBUG - Requesting: http://10.0.0.249:8082/domains 2025-09-15 03:01:33,502 - DEBUG - Requesting: http://10.0.0.249:8082/domain/fb35da95-2d14-4bd5-8610-16128fba9774 2025-09-15 03:01:33,513 - DEBUG - Requesting: http://10.0.0.249:8082/project/eb53b1a3-ea12-441c-8876-d6e981243169 2025-09-15 03:01:33,598 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/4f382e88-35c1-4adb-ad1d-3a94d7a0f646 2025-09-15 03:01:33,615 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/4f382e88-35c1-4adb-ad1d-3a94d7a0f646 2025-09-15 03:01:33,629 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/b3bd1757-b17b-47fd-9b56-e173474012f1 2025-09-15 03:01:33,636 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/b3bd1757-b17b-47fd-9b56-e173474012f1 2025-09-15 03:01:33,647 - DEBUG - Requesting: http://10.0.0.249:8082/route-target/96e89ff9-6ca9-42db-bafb-8ff9ee7fdad3 2025-09-15 03:01:33,655 - DEBUG - Route Targets: ['target:64512:8000006'] 2025-09-15 03:01:33,655 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/4f382e88-35c1-4adb-ad1d-3a94d7a0f646 2025-09-15 03:01:33,664 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/b3bd1757-b17b-47fd-9b56-e173474012f1 2025-09-15 03:01:33,681 - INFO - Verified VN network id 13 for VN 4f382e88-35c1-4adb-ad1d-3a94d7a0f646 2025-09-15 03:01:33,682 - INFO - Verifications in API Server for VN ctest-right_vn-26242974 passed 2025-09-15 03:01:33,682 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/4f382e88-35c1-4adb-ad1d-3a94d7a0f646 2025-09-15 03:01:33,692 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/b3bd1757-b17b-47fd-9b56-e173474012f1 2025-09-15 03:01:33,700 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/b3bd1757-b17b-47fd-9b56-e173474012f1 2025-09-15 03:01:33,725 - DEBUG - Requesting: http://10.0.0.249:8082/route-target/96e89ff9-6ca9-42db-bafb-8ff9ee7fdad3 2025-09-15 03:01:33,748 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-18866783:ctest-right_vn-26242974', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-18866783', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5708363690244393691', 'uuid-lslong': '12474190953833363014'}, 'enable': 'true', 'created': '2025-09-15T03:01:33', 'last-modified': '2025-09-15T03:01:33', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.439823'} 2025-09-15 03:01:33,753 - DEBUG - Route Targets: ['target:64512:8000006'] 2025-09-15 03:01:33,760 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-18866783:ctest-right_vn-26242974', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-18866783', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5708363690244393691', 'uuid-lslong': '12474190953833363014'}, 'enable': 'true', 'created': '2025-09-15T03:01:33', 'last-modified': '2025-09-15T03:01:33', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.458441'} 2025-09-15 03:01:33,767 - DEBUG - Route Targets: ['target:64512:8000006'] 2025-09-15 03:01:33,773 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-18866783:ctest-right_vn-26242974', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-18866783', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5708363690244393691', 'uuid-lslong': '12474190953833363014'}, 'enable': 'true', 'created': '2025-09-15T03:01:33', 'last-modified': '2025-09-15T03:01:33', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.465267'} 2025-09-15 03:01:33,778 - DEBUG - Route Targets: ['target:64512:8000006'] 2025-09-15 03:01:33,778 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-26242974 passed 2025-09-15 03:01:33,779 - DEBUG - ====Verifying policy data for ctest-right_vn-26242974 in API_Server ====== 2025-09-15 03:01:33,779 - DEBUG - Requesting: http://10.0.0.249:8082/domains 2025-09-15 03:01:33,786 - DEBUG - Requesting: http://10.0.0.249:8082/domain/fb35da95-2d14-4bd5-8610-16128fba9774 2025-09-15 03:01:33,798 - DEBUG - Requesting: http://10.0.0.249:8082/project/eb53b1a3-ea12-441c-8876-d6e981243169 2025-09-15 03:01:33,920 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/4f382e88-35c1-4adb-ad1d-3a94d7a0f646 2025-09-15 03:01:33,939 - DEBUG - =>VN ctest-right_vn-26242974 has no policy to be verified 2025-09-15 03:01:33,939 - DEBUG - Verifying the vn in opserver 2025-09-15 03:01:33,939 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-18866783:ctest-right_vn-26242974 virtual network link through opserver 10.0.0.249 2025-09-15 03:01:33,939 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks 2025-09-15 03:01:33,954 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-18866783:ctest-right_vn-26242974', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-18866783:ctest-right_vn-26242974?flat'} 2025-09-15 03:01:33,954 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-18866783:ctest-right_vn-26242974 virtual network link through opserver 10.0.0.27 2025-09-15 03:01:33,954 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks 2025-09-15 03:01:33,966 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-18866783:ctest-right_vn-26242974', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-18866783:ctest-right_vn-26242974?flat'} 2025-09-15 03:01:33,966 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-18866783:ctest-right_vn-26242974 virtual network link through opserver 10.0.0.38 2025-09-15 03:01:33,966 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks 2025-09-15 03:01:33,979 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-18866783:ctest-right_vn-26242974', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-18866783:ctest-right_vn-26242974?flat'} 2025-09-15 03:01:33,979 - INFO - Validated that VN default-domain:ctest-TestSvcHC-18866783:ctest-right_vn-26242974 is found in opserver 2025-09-15 03:01:34,002 - DEBUG - Do not have enough data to verify VN in agent 2025-09-15 03:01:34,012 - DEBUG - VRF ids for VN ctest-right_vn-26242974: {} 2025-09-15 03:01:34,282 - DEBUG - Response for create_network : {'network': {'id': '33ed2a13-3b77-4cc1-ad58-beade72645d5', 'name': 'ctest-trans_left_vn-76281975', 'tenant_id': 'eb53b1a3ea12441c8876d6e981243169', 'project_id': 'eb53b1a3ea12441c8876d6e981243169', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-18866783', 'ctest-trans_left_vn-76281975'], 'port_security_enabled': True, 'description': ''}} 2025-09-15 03:01:34,567 - DEBUG - Response for create_subnet : {'subnet': {'id': '0bdedc13-bbb8-4c39-bae2-b1fc47660df7', 'name': '', 'tenant_id': 'eb53b1a3ea12441c8876d6e981243169', 'network_id': '33ed2a13-3b77-4cc1-ad58-beade72645d5', 'ip_version': 4, 'cidr': '157.23.233.128/26', 'allocation_pools': [{'start': '157.23.233.130', 'end': '157.23.233.190'}], 'gateway_ip': '157.23.233.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '157.23.233.130', 'tags': [], 'project_id': 'eb53b1a3ea12441c8876d6e981243169'}} 2025-09-15 03:01:34,590 - INFO - Created VN ctest-trans_left_vn-76281975 2025-09-15 03:01:34,601 - DEBUG - VN ctest-trans_left_vn-76281975 UUID is 33ed2a13-3b77-4cc1-ad58-beade72645d5 2025-09-15 03:01:34,676 - DEBUG - Requesting: http://10.0.0.249:8082/domains 2025-09-15 03:01:34,683 - DEBUG - Requesting: http://10.0.0.249:8082/domain/fb35da95-2d14-4bd5-8610-16128fba9774 2025-09-15 03:01:34,694 - DEBUG - Requesting: http://10.0.0.249:8082/project/eb53b1a3-ea12-441c-8876-d6e981243169 2025-09-15 03:01:34,794 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/33ed2a13-3b77-4cc1-ad58-beade72645d5 2025-09-15 03:01:34,810 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/33ed2a13-3b77-4cc1-ad58-beade72645d5 2025-09-15 03:01:34,820 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/a24ffd5b-27b7-469d-883f-1a93137443d8 2025-09-15 03:01:34,833 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/a24ffd5b-27b7-469d-883f-1a93137443d8 2025-09-15 03:01:34,840 - DEBUG - Requesting: http://10.0.0.249:8082/route-target/d07216bb-a887-4324-8509-cc8d354d387f 2025-09-15 03:01:34,848 - DEBUG - Route Targets: ['target:64512:8000007'] 2025-09-15 03:01:34,848 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/33ed2a13-3b77-4cc1-ad58-beade72645d5 2025-09-15 03:01:34,860 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/a24ffd5b-27b7-469d-883f-1a93137443d8 2025-09-15 03:01:34,877 - INFO - Verified VN network id 14 for VN 33ed2a13-3b77-4cc1-ad58-beade72645d5 2025-09-15 03:01:34,877 - INFO - Verifications in API Server for VN ctest-trans_left_vn-76281975 passed 2025-09-15 03:01:34,878 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/33ed2a13-3b77-4cc1-ad58-beade72645d5 2025-09-15 03:01:34,888 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/a24ffd5b-27b7-469d-883f-1a93137443d8 2025-09-15 03:01:34,896 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/a24ffd5b-27b7-469d-883f-1a93137443d8 2025-09-15 03:01:34,904 - DEBUG - Requesting: http://10.0.0.249:8082/route-target/d07216bb-a887-4324-8509-cc8d354d387f 2025-09-15 03:01:34,918 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-18866783:ctest-trans_left_vn-76281975', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-18866783', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3741693127505169601', 'uuid-lslong': '12490943220628735445'}, 'enable': 'true', 'created': '2025-09-15T03:01:34', 'last-modified': '2025-09-15T03:01:34', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.415943'} 2025-09-15 03:01:34,923 - DEBUG - Route Targets: ['target:64512:8000007'] 2025-09-15 03:01:34,928 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-18866783:ctest-trans_left_vn-76281975', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-18866783', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3741693127505169601', 'uuid-lslong': '12490943220628735445'}, 'enable': 'true', 'created': '2025-09-15T03:01:34', 'last-modified': '2025-09-15T03:01:34', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.421059'} 2025-09-15 03:01:34,932 - DEBUG - Route Targets: ['target:64512:8000007'] 2025-09-15 03:01:34,937 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-18866783:ctest-trans_left_vn-76281975', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-18866783', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3741693127505169601', 'uuid-lslong': '12490943220628735445'}, 'enable': 'true', 'created': '2025-09-15T03:01:34', 'last-modified': '2025-09-15T03:01:34', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.436964'} 2025-09-15 03:01:34,942 - DEBUG - Route Targets: ['target:64512:8000007'] 2025-09-15 03:01:34,942 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_left_vn-76281975 passed 2025-09-15 03:01:34,943 - DEBUG - ====Verifying policy data for ctest-trans_left_vn-76281975 in API_Server ====== 2025-09-15 03:01:34,943 - DEBUG - Requesting: http://10.0.0.249:8082/domains 2025-09-15 03:01:34,949 - DEBUG - Requesting: http://10.0.0.249:8082/domain/fb35da95-2d14-4bd5-8610-16128fba9774 2025-09-15 03:01:34,961 - DEBUG - Requesting: http://10.0.0.249:8082/project/eb53b1a3-ea12-441c-8876-d6e981243169 2025-09-15 03:01:35,071 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/33ed2a13-3b77-4cc1-ad58-beade72645d5 2025-09-15 03:01:35,080 - DEBUG - =>VN ctest-trans_left_vn-76281975 has no policy to be verified 2025-09-15 03:01:35,080 - DEBUG - Verifying the vn in opserver 2025-09-15 03:01:35,080 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-18866783:ctest-trans_left_vn-76281975 virtual network link through opserver 10.0.0.249 2025-09-15 03:01:35,080 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks 2025-09-15 03:01:35,093 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-18866783:ctest-trans_left_vn-76281975', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-18866783:ctest-trans_left_vn-76281975?flat'} 2025-09-15 03:01:35,093 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-18866783:ctest-trans_left_vn-76281975 virtual network link through opserver 10.0.0.27 2025-09-15 03:01:35,093 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks 2025-09-15 03:01:35,104 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-18866783:ctest-trans_left_vn-76281975', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-18866783:ctest-trans_left_vn-76281975?flat'} 2025-09-15 03:01:35,104 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-18866783:ctest-trans_left_vn-76281975 virtual network link through opserver 10.0.0.38 2025-09-15 03:01:35,104 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks 2025-09-15 03:01:35,116 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-18866783:ctest-trans_left_vn-76281975', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-18866783:ctest-trans_left_vn-76281975?flat'} 2025-09-15 03:01:35,116 - INFO - Validated that VN default-domain:ctest-TestSvcHC-18866783:ctest-trans_left_vn-76281975 is found in opserver 2025-09-15 03:01:35,137 - DEBUG - Do not have enough data to verify VN in agent 2025-09-15 03:01:35,147 - DEBUG - VRF ids for VN ctest-trans_left_vn-76281975: {} 2025-09-15 03:01:35,412 - DEBUG - Response for create_network : {'network': {'id': 'e9900ec6-4232-444b-9fba-d92691a30517', 'name': 'ctest-trans_right_vn-06778997', 'tenant_id': 'eb53b1a3ea12441c8876d6e981243169', 'project_id': 'eb53b1a3ea12441c8876d6e981243169', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-18866783', 'ctest-trans_right_vn-06778997'], 'port_security_enabled': True, 'description': ''}} 2025-09-15 03:01:35,615 - DEBUG - Response for create_subnet : {'subnet': {'id': 'f6e7c5bc-e2ad-47ec-97be-2a125d72ef7a', 'name': '', 'tenant_id': 'eb53b1a3ea12441c8876d6e981243169', 'network_id': 'e9900ec6-4232-444b-9fba-d92691a30517', 'ip_version': 4, 'cidr': '27.64.118.128/26', 'allocation_pools': [{'start': '27.64.118.130', 'end': '27.64.118.190'}], 'gateway_ip': '27.64.118.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '27.64.118.130', 'tags': [], 'project_id': 'eb53b1a3ea12441c8876d6e981243169'}} 2025-09-15 03:01:35,644 - INFO - Created VN ctest-trans_right_vn-06778997 2025-09-15 03:01:35,655 - DEBUG - VN ctest-trans_right_vn-06778997 UUID is e9900ec6-4232-444b-9fba-d92691a30517 2025-09-15 03:01:35,728 - DEBUG - Requesting: http://10.0.0.249:8082/domains 2025-09-15 03:01:35,748 - DEBUG - Requesting: http://10.0.0.249:8082/domain/fb35da95-2d14-4bd5-8610-16128fba9774 2025-09-15 03:01:35,761 - DEBUG - Requesting: http://10.0.0.249:8082/project/eb53b1a3-ea12-441c-8876-d6e981243169 2025-09-15 03:01:35,845 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/e9900ec6-4232-444b-9fba-d92691a30517 2025-09-15 03:01:35,862 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/e9900ec6-4232-444b-9fba-d92691a30517 2025-09-15 03:01:35,877 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/7418d191-ca34-46a6-8962-acd2baf86fba 2025-09-15 03:01:35,887 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/7418d191-ca34-46a6-8962-acd2baf86fba 2025-09-15 03:01:35,895 - DEBUG - Requesting: http://10.0.0.249:8082/route-target/824e98c8-dade-455c-a6c6-13e148ce9772 2025-09-15 03:01:35,903 - DEBUG - Route Targets: ['target:64512:8000008'] 2025-09-15 03:01:35,903 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/e9900ec6-4232-444b-9fba-d92691a30517 2025-09-15 03:01:35,912 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/7418d191-ca34-46a6-8962-acd2baf86fba 2025-09-15 03:01:35,930 - INFO - Verified VN network id 15 for VN e9900ec6-4232-444b-9fba-d92691a30517 2025-09-15 03:01:35,930 - INFO - Verifications in API Server for VN ctest-trans_right_vn-06778997 passed 2025-09-15 03:01:35,930 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/e9900ec6-4232-444b-9fba-d92691a30517 2025-09-15 03:01:35,942 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/7418d191-ca34-46a6-8962-acd2baf86fba 2025-09-15 03:01:35,951 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/7418d191-ca34-46a6-8962-acd2baf86fba 2025-09-15 03:01:35,959 - DEBUG - Requesting: http://10.0.0.249:8082/route-target/824e98c8-dade-455c-a6c6-13e148ce9772 2025-09-15 03:01:35,971 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-18866783:ctest-trans_right_vn-06778997', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-18866783', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16829968052160447563', 'uuid-lslong': '11509750557374088471'}, 'enable': 'true', 'created': '2025-09-15T03:01:35', 'last-modified': '2025-09-15T03:01:35', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.399945'} 2025-09-15 03:01:35,976 - DEBUG - Route Targets: ['target:64512:8000008'] 2025-09-15 03:01:35,982 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-18866783:ctest-trans_right_vn-06778997', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-18866783', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16829968052160447563', 'uuid-lslong': '11509750557374088471'}, 'enable': 'true', 'created': '2025-09-15T03:01:35', 'last-modified': '2025-09-15T03:01:35', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.413571'} 2025-09-15 03:01:35,987 - DEBUG - Route Targets: ['target:64512:8000008'] 2025-09-15 03:01:35,993 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-18866783:ctest-trans_right_vn-06778997', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-18866783', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16829968052160447563', 'uuid-lslong': '11509750557374088471'}, 'enable': 'true', 'created': '2025-09-15T03:01:35', 'last-modified': '2025-09-15T03:01:35', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.429301'} 2025-09-15 03:01:35,999 - DEBUG - Route Targets: ['target:64512:8000008'] 2025-09-15 03:01:35,999 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_right_vn-06778997 passed 2025-09-15 03:01:35,999 - DEBUG - ====Verifying policy data for ctest-trans_right_vn-06778997 in API_Server ====== 2025-09-15 03:01:35,999 - DEBUG - Requesting: http://10.0.0.249:8082/domains 2025-09-15 03:01:36,006 - DEBUG - Requesting: http://10.0.0.249:8082/domain/fb35da95-2d14-4bd5-8610-16128fba9774 2025-09-15 03:01:36,019 - DEBUG - Requesting: http://10.0.0.249:8082/project/eb53b1a3-ea12-441c-8876-d6e981243169 2025-09-15 03:01:36,120 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/e9900ec6-4232-444b-9fba-d92691a30517 2025-09-15 03:01:36,132 - DEBUG - =>VN ctest-trans_right_vn-06778997 has no policy to be verified 2025-09-15 03:01:36,132 - DEBUG - Verifying the vn in opserver 2025-09-15 03:01:36,132 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-18866783:ctest-trans_right_vn-06778997 virtual network link through opserver 10.0.0.249 2025-09-15 03:01:36,132 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks 2025-09-15 03:01:36,147 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-18866783:ctest-trans_right_vn-06778997', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-18866783:ctest-trans_right_vn-06778997?flat'} 2025-09-15 03:01:36,147 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-18866783:ctest-trans_right_vn-06778997 virtual network link through opserver 10.0.0.27 2025-09-15 03:01:36,147 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks 2025-09-15 03:01:36,161 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-18866783:ctest-trans_right_vn-06778997', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-18866783:ctest-trans_right_vn-06778997?flat'} 2025-09-15 03:01:36,161 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-18866783:ctest-trans_right_vn-06778997 virtual network link through opserver 10.0.0.38 2025-09-15 03:01:36,161 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks 2025-09-15 03:01:36,173 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-18866783:ctest-trans_right_vn-06778997', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-18866783:ctest-trans_right_vn-06778997?flat'} 2025-09-15 03:01:36,173 - INFO - Validated that VN default-domain:ctest-TestSvcHC-18866783:ctest-trans_right_vn-06778997 is found in opserver 2025-09-15 03:01:36,194 - DEBUG - Do not have enough data to verify VN in agent 2025-09-15 03:01:36,204 - DEBUG - VRF ids for VN ctest-trans_right_vn-06778997: {} 2025-09-15 03:01:37,215 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4110-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4110-2) 2025-09-15 03:01:38,446 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4110-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4110-1) 2025-09-15 03:01:38,446 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-35765735'] 2025-09-15 03:01:38,747 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-35765735'] created succesfully 2025-09-15 03:01:39,092 - DEBUG - Image by name tiny_trans_fw not found 2025-09-15 03:01:39,092 - DEBUG - Installing image tiny_trans_fw 2025-09-15 03:01:39,092 - 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-09-15 03:01:39,093 - DEBUG - Image build path file:///contrail-test/images/tinycore-net-transparent-fw.qcow2.gz 2025-09-15 03:01:39,093 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-net-transparent-fw.qcow2.gz 2025-09-15 03:01:39,093 - DEBUG - Unzip image 2025-09-15 03:01:39,093 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-net-transparent-fw.qcow2.gz 2025-09-15 03:01:39,113 - INFO - image /contrail-test/images/tinycore-net-transparent-fw.qcow2 is not found 2025-09-15 03:01:39,113 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-35765735'] 2025-09-15 03:01:39,218 - INFO - Service template: ['default-domain', 'ctest-service_template_1-35765735'] deleted successfully. 2025-09-15 03:01:39,218 - INFO - Skip interface_detach for VM ctest-right_vm-90224009 in state BUILD 2025-09-15 03:01:39,218 - INFO - Deleting VM ctest-right_vm-90224009 2025-09-15 03:01:39,218 - ERROR - VM ctest-right_vm-90224009 has failed to come up 2025-09-15 03:01:39,218 - ERROR - Nova failed to get host of the VM 2025-09-15 03:01:39,218 - ERROR - VM ctest-right_vm-90224009 has failed to come up 2025-09-15 03:01:39,219 - ERROR - Nova failed to get host of the VM 2025-09-15 03:01:39,357 - INFO - Skip interface_detach for VM ctest-left_vm-90507857 in state BUILD 2025-09-15 03:01:39,357 - INFO - Deleting VM ctest-left_vm-90507857 2025-09-15 03:01:39,357 - ERROR - VM ctest-left_vm-90507857 has failed to come up 2025-09-15 03:01:39,358 - ERROR - Nova failed to get host of the VM 2025-09-15 03:01:39,358 - ERROR - VM ctest-left_vm-90507857 has failed to come up 2025-09-15 03:01:39,358 - ERROR - Nova failed to get host of the VM 2025-09-15 03:01:39,449 - INFO - Deleting VN ctest-trans_right_vn-06778997 2025-09-15 03:01:39,598 - DEBUG - Response for deleting network () 2025-09-15 03:01:39,598 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/7418d191-ca34-46a6-8962-acd2baf86fba 2025-09-15 03:01:39,604 - DEBUG - Response Code: 404 2025-09-15 03:01:39,604 - DEBUG - Requesting: http://10.0.0.249:8082/domains 2025-09-15 03:01:39,614 - DEBUG - Requesting: http://10.0.0.249:8082/domain/fb35da95-2d14-4bd5-8610-16128fba9774 2025-09-15 03:01:39,633 - DEBUG - Requesting: http://10.0.0.249:8082/project/eb53b1a3-ea12-441c-8876-d6e981243169 2025-09-15 03:01:39,725 - INFO - Validated that VN ctest-trans_right_vn-06778997 is not found in API Server 2025-09-15 03:01:39,744 - DEBUG - VN ctest-trans_right_vn-06778997 is not present in Agent 10.0.0.19 2025-09-15 03:01:39,764 - DEBUG - VN ctest-trans_right_vn-06778997 is not present in Agent 10.0.0.137 2025-09-15 03:01:39,764 - INFO - Validated that VN ctest-trans_right_vn-06778997 is not in any agent 2025-09-15 03:01:39,824 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-trans_right_vn-06778997 info 2025-09-15 03:01:39,824 - INFO - Deleting VN ctest-trans_left_vn-76281975 2025-09-15 03:01:39,982 - DEBUG - Response for deleting network () 2025-09-15 03:01:39,982 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/a24ffd5b-27b7-469d-883f-1a93137443d8 2025-09-15 03:01:39,988 - DEBUG - Response Code: 404 2025-09-15 03:01:39,988 - DEBUG - Requesting: http://10.0.0.249:8082/domains 2025-09-15 03:01:40,010 - DEBUG - Requesting: http://10.0.0.249:8082/domain/fb35da95-2d14-4bd5-8610-16128fba9774 2025-09-15 03:01:40,035 - DEBUG - Requesting: http://10.0.0.249:8082/project/eb53b1a3-ea12-441c-8876-d6e981243169 2025-09-15 03:01:40,158 - INFO - Validated that VN ctest-trans_left_vn-76281975 is not found in API Server 2025-09-15 03:01:40,193 - DEBUG - VN ctest-trans_left_vn-76281975 is not present in Agent 10.0.0.19 2025-09-15 03:01:40,206 - DEBUG - VN ctest-trans_left_vn-76281975 is not present in Agent 10.0.0.137 2025-09-15 03:01:40,206 - INFO - Validated that VN ctest-trans_left_vn-76281975 is not in any agent 2025-09-15 03:01:40,242 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-trans_left_vn-76281975 info 2025-09-15 03:01:40,242 - INFO - Deleting VN ctest-right_vn-26242974 2025-09-15 03:01:40,299 - DEBUG - VN 4f382e88-35c1-4adb-ad1d-3a94d7a0f646 still in use: Unable to complete operation on network 4f382e88-35c1-4adb-ad1d-3a94d7a0f646. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-a4f38822-d088-411d-bb56-c835b7a8645b'] 2025-09-15 03:01:40,299 - WARNING - Deleting VN ctest-right_vn-26242974 failed..Will retry 2025-09-15 03:01:42,459 - DEBUG - Response for deleting network () 2025-09-15 03:01:42,459 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/b3bd1757-b17b-47fd-9b56-e173474012f1 2025-09-15 03:01:42,468 - DEBUG - Response Code: 404 2025-09-15 03:01:42,468 - DEBUG - Requesting: http://10.0.0.249:8082/domains 2025-09-15 03:01:42,483 - DEBUG - Requesting: http://10.0.0.249:8082/domain/fb35da95-2d14-4bd5-8610-16128fba9774 2025-09-15 03:01:42,509 - DEBUG - Requesting: http://10.0.0.249:8082/project/eb53b1a3-ea12-441c-8876-d6e981243169 2025-09-15 03:01:42,611 - INFO - Validated that VN ctest-right_vn-26242974 is not found in API Server 2025-09-15 03:01:42,624 - DEBUG - VN ctest-right_vn-26242974 is not present in Agent 10.0.0.19 2025-09-15 03:01:42,634 - DEBUG - VN ctest-right_vn-26242974 is not present in Agent 10.0.0.137 2025-09-15 03:01:42,634 - INFO - Validated that VN ctest-right_vn-26242974 is not in any agent 2025-09-15 03:01:42,670 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-26242974 info 2025-09-15 03:01:42,670 - INFO - Deleting VN ctest-left_vn-58982570 2025-09-15 03:01:42,823 - DEBUG - Response for deleting network () 2025-09-15 03:01:42,823 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/d7b69bee-a8e3-4dff-b9b0-c8b8decd245f 2025-09-15 03:01:42,829 - DEBUG - Response Code: 404 2025-09-15 03:01:42,829 - DEBUG - Requesting: http://10.0.0.249:8082/domains 2025-09-15 03:01:42,836 - DEBUG - Requesting: http://10.0.0.249:8082/domain/fb35da95-2d14-4bd5-8610-16128fba9774 2025-09-15 03:01:42,848 - DEBUG - Requesting: http://10.0.0.249:8082/project/eb53b1a3-ea12-441c-8876-d6e981243169 2025-09-15 03:01:42,939 - INFO - Validated that VN ctest-left_vn-58982570 is not found in API Server 2025-09-15 03:01:42,949 - DEBUG - VN ctest-left_vn-58982570 is not present in Agent 10.0.0.19 2025-09-15 03:01:42,960 - DEBUG - VN ctest-left_vn-58982570 is not present in Agent 10.0.0.137 2025-09-15 03:01:42,960 - INFO - Validated that VN ctest-left_vn-58982570 is not in any agent 2025-09-15 03:01:42,991 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-58982570 info 2025-09-15 03:01:42,991 - INFO - Deleting VN ctest-mgmt_vn-60536442 2025-09-15 03:01:43,156 - DEBUG - Response for deleting network () 2025-09-15 03:01:43,156 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/eefc0306-5be0-4bfe-ae69-753568fd22cd 2025-09-15 03:01:43,171 - DEBUG - Response Code: 404 2025-09-15 03:01:43,171 - DEBUG - Requesting: http://10.0.0.249:8082/domains 2025-09-15 03:01:43,181 - DEBUG - Requesting: http://10.0.0.249:8082/domain/fb35da95-2d14-4bd5-8610-16128fba9774 2025-09-15 03:01:43,237 - DEBUG - Requesting: http://10.0.0.249:8082/project/eb53b1a3-ea12-441c-8876-d6e981243169 2025-09-15 03:01:43,341 - INFO - Validated that VN ctest-mgmt_vn-60536442 is not found in API Server 2025-09-15 03:01:43,353 - DEBUG - VN ctest-mgmt_vn-60536442 is not present in Agent 10.0.0.19 2025-09-15 03:01:43,363 - DEBUG - VN ctest-mgmt_vn-60536442 is not present in Agent 10.0.0.137 2025-09-15 03:01:43,363 - INFO - Validated that VN ctest-mgmt_vn-60536442 is not in any agent 2025-09-15 03:01:43,394 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-60536442 info 2025-09-15 03:01:44,686 - DEBUG - No XMPP flaps were noticed during the test 2025-09-15 03:01:44,686 - INFO -
2025-09-15 03:01:44,686 - INFO - END TEST : test_svc_trans_segment_right_hc_fail_svm : SKIPPED[0:00:15]
2025-09-15 03:01:44,686 - INFO - -------------------------------------------------------------------------------- 2025-09-15 03:01:45,505 - INFO - Deleted project: ctest-TestSvcHC-18866783, ID : eb53b1a3-ea12-441c-8876-d6e981243169