2025-10-29 12:35:08,269 - INFO - Domain Default found not creating 2025-10-29 12:35:08,450 - INFO - Project ctest-TestSvcHC-11898174 not found, creating it 2025-10-29 12:35:09,014 - INFO - Created Project:ctest-TestSvcHC-11898174, ID : c43dba4b-444a-459c-86da-1c6313585381 2025-10-29 12:35:10,684 - INFO - ================================================================================ 2025-10-29 12:35:10,684 - INFO - STARTING TEST : test_svc_hc_basic 2025-10-29 12:35:11,954 - DEBUG - Nothing to compare xmpp stats {'10.0.0.49': {'10.20.0.17': '0', '10.20.0.254': '0'}, '10.0.0.50': {'10.20.0.254': '0', '10.20.0.14': '0'}} with 2025-10-29 12:35:11,954 - INFO - Initial checks done. Running the testcase now 2025-10-29 12:35:11,954 - INFO - 2025-10-29 12:35:12,644 - DEBUG - Response for create_network : {'network': {'id': 'fbfd7c84-4205-4096-8246-c3ab110c00be', 'name': 'ctest-mgmt_vn-41987753', 'tenant_id': 'c43dba4b444a459c86da1c6313585381', 'project_id': 'c43dba4b444a459c86da1c6313585381', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-11898174', 'ctest-mgmt_vn-41987753'], 'port_security_enabled': True, 'description': ''}} 2025-10-29 12:35:12,956 - DEBUG - Response for create_subnet : {'subnet': {'id': '3f60d11a-0394-43a9-b2cc-6c562fa0e08f', 'name': '', 'tenant_id': 'c43dba4b444a459c86da1c6313585381', 'network_id': 'fbfd7c84-4205-4096-8246-c3ab110c00be', 'ip_version': 4, 'cidr': '129.18.47.64/26', 'allocation_pools': [{'start': '129.18.47.66', 'end': '129.18.47.126'}], 'gateway_ip': '129.18.47.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '129.18.47.66', 'tags': [], 'project_id': 'c43dba4b444a459c86da1c6313585381'}} 2025-10-29 12:35:12,982 - INFO - Created VN ctest-mgmt_vn-41987753 2025-10-29 12:35:12,999 - DEBUG - VN ctest-mgmt_vn-41987753 UUID is fbfd7c84-4205-4096-8246-c3ab110c00be 2025-10-29 12:35:13,078 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-10-29 12:35:13,409 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-10-29 12:35:13,446 - DEBUG - Requesting: http://10.0.0.38:8082/domain/fd9d3a52-0780-4060-8425-e3c883ec81fc 2025-10-29 12:35:13,466 - DEBUG - Requesting: http://10.0.0.38:8082/project/c43dba4b-444a-459c-86da-1c6313585381 2025-10-29 12:35:13,563 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/fbfd7c84-4205-4096-8246-c3ab110c00be 2025-10-29 12:35:13,578 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/fbfd7c84-4205-4096-8246-c3ab110c00be 2025-10-29 12:35:13,589 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/bbff9698-293c-4614-99f6-a64cd35d6b2a 2025-10-29 12:35:13,600 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/bbff9698-293c-4614-99f6-a64cd35d6b2a 2025-10-29 12:35:13,609 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/9d0566de-23e0-4ea4-9d19-178d92c69263 2025-10-29 12:35:13,616 - DEBUG - Route Targets: ['target:64512:8000004'] 2025-10-29 12:35:13,617 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/fbfd7c84-4205-4096-8246-c3ab110c00be 2025-10-29 12:35:13,629 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/bbff9698-293c-4614-99f6-a64cd35d6b2a 2025-10-29 12:35:13,647 - INFO - Verified VN network id 15 for VN fbfd7c84-4205-4096-8246-c3ab110c00be 2025-10-29 12:35:13,647 - INFO - Verifications in API Server for VN ctest-mgmt_vn-41987753 passed 2025-10-29 12:35:13,648 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/fbfd7c84-4205-4096-8246-c3ab110c00be 2025-10-29 12:35:13,660 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/bbff9698-293c-4614-99f6-a64cd35d6b2a 2025-10-29 12:35:13,669 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/bbff9698-293c-4614-99f6-a64cd35d6b2a 2025-10-29 12:35:13,677 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/9d0566de-23e0-4ea4-9d19-178d92c69263 2025-10-29 12:35:13,692 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-11898174:ctest-mgmt_vn-41987753', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-11898174', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '18157806180112875670', 'uuid-lslong': '9387405612793200830'}, 'enable': 'true', 'created': '2025-10-29T12:35:12', 'last-modified': '2025-10-29T12:35:12', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.786172'} 2025-10-29 12:35:13,699 - DEBUG - Route Targets: ['target:64512:8000004'] 2025-10-29 12:35:13,705 - DEBUG - Control-node 10.0.0.254 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-11898174:ctest-mgmt_vn-41987753', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-11898174', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '18157806180112875670', 'uuid-lslong': '9387405612793200830'}, 'enable': 'true', 'created': '2025-10-29T12:35:12', 'last-modified': '2025-10-29T12:35:12', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.801046'} 2025-10-29 12:35:13,711 - DEBUG - Route Targets: ['target:64512:8000004'] 2025-10-29 12:35:13,717 - DEBUG - Control-node 10.0.0.48 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-11898174:ctest-mgmt_vn-41987753', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-11898174', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '18157806180112875670', 'uuid-lslong': '9387405612793200830'}, 'enable': 'true', 'created': '2025-10-29T12:35:12', 'last-modified': '2025-10-29T12:35:12', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.814979'} 2025-10-29 12:35:13,724 - DEBUG - Route Targets: ['target:64512:8000004'] 2025-10-29 12:35:13,724 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-41987753 passed 2025-10-29 12:35:13,724 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-41987753 in API_Server ====== 2025-10-29 12:35:13,724 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-10-29 12:35:13,731 - DEBUG - Requesting: http://10.0.0.38:8082/domain/fd9d3a52-0780-4060-8425-e3c883ec81fc 2025-10-29 12:35:13,755 - DEBUG - Requesting: http://10.0.0.38:8082/project/c43dba4b-444a-459c-86da-1c6313585381 2025-10-29 12:35:13,852 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/fbfd7c84-4205-4096-8246-c3ab110c00be 2025-10-29 12:35:13,867 - DEBUG - =>VN ctest-mgmt_vn-41987753 has no policy to be verified 2025-10-29 12:35:13,867 - DEBUG - Verifying the vn in opserver 2025-10-29 12:35:13,867 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-11898174:ctest-mgmt_vn-41987753 virtual network link through opserver 10.0.0.38 2025-10-29 12:35:13,867 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks 2025-10-29 12:35:14,178 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks 2025-10-29 12:35:14,247 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-11898174:ctest-mgmt_vn-41987753', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-11898174:ctest-mgmt_vn-41987753?flat'} 2025-10-29 12:35:14,247 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-11898174:ctest-mgmt_vn-41987753 virtual network link through opserver 10.0.0.254 2025-10-29 12:35:14,247 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-networks 2025-10-29 12:35:14,564 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-networks 2025-10-29 12:35:14,634 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-11898174:ctest-mgmt_vn-41987753', 'href': 'http://10.0.0.254:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-11898174:ctest-mgmt_vn-41987753?flat'} 2025-10-29 12:35:14,634 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-11898174:ctest-mgmt_vn-41987753 virtual network link through opserver 10.0.0.48 2025-10-29 12:35:14,635 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/virtual-networks 2025-10-29 12:35:14,943 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/virtual-networks 2025-10-29 12:35:15,011 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-11898174:ctest-mgmt_vn-41987753', 'href': 'http://10.0.0.48:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-11898174:ctest-mgmt_vn-41987753?flat'} 2025-10-29 12:35:15,012 - INFO - Validated that VN default-domain:ctest-TestSvcHC-11898174:ctest-mgmt_vn-41987753 is found in opserver 2025-10-29 12:35:15,034 - DEBUG - Do not have enough data to verify VN in agent 2025-10-29 12:35:15,045 - DEBUG - VRF ids for VN ctest-mgmt_vn-41987753: {} 2025-10-29 12:35:15,336 - DEBUG - Response for create_network : {'network': {'id': '995583e7-4c71-4323-bf0b-27831924a238', 'name': 'ctest-left_vn-86489361', 'tenant_id': 'c43dba4b444a459c86da1c6313585381', 'project_id': 'c43dba4b444a459c86da1c6313585381', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-11898174', 'ctest-left_vn-86489361'], 'port_security_enabled': True, 'description': ''}} 2025-10-29 12:35:15,583 - DEBUG - Response for create_subnet : {'subnet': {'id': '8a55d24b-c837-4fc5-ac24-f7cb798b4073', 'name': '', 'tenant_id': 'c43dba4b444a459c86da1c6313585381', 'network_id': '995583e7-4c71-4323-bf0b-27831924a238', 'ip_version': 4, 'cidr': '173.180.194.64/26', 'allocation_pools': [{'start': '173.180.194.66', 'end': '173.180.194.126'}], 'gateway_ip': '173.180.194.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '173.180.194.66', 'tags': [], 'project_id': 'c43dba4b444a459c86da1c6313585381'}} 2025-10-29 12:35:15,605 - INFO - Created VN ctest-left_vn-86489361 2025-10-29 12:35:15,616 - DEBUG - VN ctest-left_vn-86489361 UUID is 995583e7-4c71-4323-bf0b-27831924a238 2025-10-29 12:35:15,690 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-10-29 12:35:15,696 - DEBUG - Requesting: http://10.0.0.38:8082/domain/fd9d3a52-0780-4060-8425-e3c883ec81fc 2025-10-29 12:35:15,708 - DEBUG - Requesting: http://10.0.0.38:8082/project/c43dba4b-444a-459c-86da-1c6313585381 2025-10-29 12:35:15,804 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/995583e7-4c71-4323-bf0b-27831924a238 2025-10-29 12:35:15,817 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/995583e7-4c71-4323-bf0b-27831924a238 2025-10-29 12:35:15,826 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/526ee6f1-0183-4d7a-b325-3f7679b64d96 2025-10-29 12:35:15,836 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/526ee6f1-0183-4d7a-b325-3f7679b64d96 2025-10-29 12:35:15,844 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/5f6a57b6-a2d8-44f9-9c73-1d03a30cbec8 2025-10-29 12:35:15,851 - DEBUG - Route Targets: ['target:64512:8000006'] 2025-10-29 12:35:15,851 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/995583e7-4c71-4323-bf0b-27831924a238 2025-10-29 12:35:15,859 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/526ee6f1-0183-4d7a-b325-3f7679b64d96 2025-10-29 12:35:15,876 - INFO - Verified VN network id 16 for VN 995583e7-4c71-4323-bf0b-27831924a238 2025-10-29 12:35:15,876 - INFO - Verifications in API Server for VN ctest-left_vn-86489361 passed 2025-10-29 12:35:15,876 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/995583e7-4c71-4323-bf0b-27831924a238 2025-10-29 12:35:15,887 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/526ee6f1-0183-4d7a-b325-3f7679b64d96 2025-10-29 12:35:15,897 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/526ee6f1-0183-4d7a-b325-3f7679b64d96 2025-10-29 12:35:15,906 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/5f6a57b6-a2d8-44f9-9c73-1d03a30cbec8 2025-10-29 12:35:15,920 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-11898174:ctest-left_vn-86489361', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-11898174', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11048882290266555171', 'uuid-lslong': '13766140130004083256'}, 'enable': 'true', 'created': '2025-10-29T12:35:15', 'last-modified': '2025-10-29T12:35:15', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.388061'} 2025-10-29 12:35:15,926 - DEBUG - Route Targets: ['target:64512:8000006'] 2025-10-29 12:35:15,933 - DEBUG - Control-node 10.0.0.254 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-11898174:ctest-left_vn-86489361', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-11898174', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11048882290266555171', 'uuid-lslong': '13766140130004083256'}, 'enable': 'true', 'created': '2025-10-29T12:35:15', 'last-modified': '2025-10-29T12:35:15', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.407090'} 2025-10-29 12:35:15,939 - DEBUG - Route Targets: ['target:64512:8000006'] 2025-10-29 12:35:15,945 - DEBUG - Control-node 10.0.0.48 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-11898174:ctest-left_vn-86489361', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-11898174', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11048882290266555171', 'uuid-lslong': '13766140130004083256'}, 'enable': 'true', 'created': '2025-10-29T12:35:15', 'last-modified': '2025-10-29T12:35:15', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.418157'} 2025-10-29 12:35:15,951 - DEBUG - Route Targets: ['target:64512:8000006'] 2025-10-29 12:35:15,952 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-86489361 passed 2025-10-29 12:35:15,952 - DEBUG - ====Verifying policy data for ctest-left_vn-86489361 in API_Server ====== 2025-10-29 12:35:15,952 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-10-29 12:35:15,959 - DEBUG - Requesting: http://10.0.0.38:8082/domain/fd9d3a52-0780-4060-8425-e3c883ec81fc 2025-10-29 12:35:15,975 - DEBUG - Requesting: http://10.0.0.38:8082/project/c43dba4b-444a-459c-86da-1c6313585381 2025-10-29 12:35:16,066 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/995583e7-4c71-4323-bf0b-27831924a238 2025-10-29 12:35:16,076 - DEBUG - =>VN ctest-left_vn-86489361 has no policy to be verified 2025-10-29 12:35:16,076 - DEBUG - Verifying the vn in opserver 2025-10-29 12:35:16,076 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-11898174:ctest-left_vn-86489361 virtual network link through opserver 10.0.0.38 2025-10-29 12:35:16,076 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks 2025-10-29 12:35:16,141 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-11898174:ctest-left_vn-86489361', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-11898174:ctest-left_vn-86489361?flat'} 2025-10-29 12:35:16,141 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-11898174:ctest-left_vn-86489361 virtual network link through opserver 10.0.0.254 2025-10-29 12:35:16,141 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-networks 2025-10-29 12:35:16,199 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-11898174:ctest-left_vn-86489361', 'href': 'http://10.0.0.254:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-11898174:ctest-left_vn-86489361?flat'} 2025-10-29 12:35:16,199 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-11898174:ctest-left_vn-86489361 virtual network link through opserver 10.0.0.48 2025-10-29 12:35:16,199 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/virtual-networks 2025-10-29 12:35:16,263 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-11898174:ctest-left_vn-86489361', 'href': 'http://10.0.0.48:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-11898174:ctest-left_vn-86489361?flat'} 2025-10-29 12:35:16,263 - INFO - Validated that VN default-domain:ctest-TestSvcHC-11898174:ctest-left_vn-86489361 is found in opserver 2025-10-29 12:35:16,286 - DEBUG - Do not have enough data to verify VN in agent 2025-10-29 12:35:16,297 - DEBUG - VRF ids for VN ctest-left_vn-86489361: {} 2025-10-29 12:35:16,592 - DEBUG - Response for create_network : {'network': {'id': '21451529-bcd3-4d44-bed8-dbcc9c18d05d', 'name': 'ctest-right_vn-11864219', 'tenant_id': 'c43dba4b444a459c86da1c6313585381', 'project_id': 'c43dba4b444a459c86da1c6313585381', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-11898174', 'ctest-right_vn-11864219'], 'port_security_enabled': True, 'description': ''}} 2025-10-29 12:35:16,962 - DEBUG - Response for create_subnet : {'subnet': {'id': 'c793bc66-bd2d-475b-b6e4-014fbe808e39', 'name': '', 'tenant_id': 'c43dba4b444a459c86da1c6313585381', 'network_id': '21451529-bcd3-4d44-bed8-dbcc9c18d05d', 'ip_version': 4, 'cidr': '204.30.75.0/26', 'allocation_pools': [{'start': '204.30.75.2', 'end': '204.30.75.62'}], 'gateway_ip': '204.30.75.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '204.30.75.2', 'tags': [], 'project_id': 'c43dba4b444a459c86da1c6313585381'}} 2025-10-29 12:35:16,985 - INFO - Created VN ctest-right_vn-11864219 2025-10-29 12:35:16,998 - DEBUG - VN ctest-right_vn-11864219 UUID is 21451529-bcd3-4d44-bed8-dbcc9c18d05d 2025-10-29 12:35:17,095 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-10-29 12:35:17,103 - DEBUG - Requesting: http://10.0.0.38:8082/domain/fd9d3a52-0780-4060-8425-e3c883ec81fc 2025-10-29 12:35:17,118 - DEBUG - Requesting: http://10.0.0.38:8082/project/c43dba4b-444a-459c-86da-1c6313585381 2025-10-29 12:35:17,227 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/21451529-bcd3-4d44-bed8-dbcc9c18d05d 2025-10-29 12:35:17,249 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/21451529-bcd3-4d44-bed8-dbcc9c18d05d 2025-10-29 12:35:17,260 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/ee49140e-c87f-4a4f-8e54-fc87c93e2153 2025-10-29 12:35:17,272 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/ee49140e-c87f-4a4f-8e54-fc87c93e2153 2025-10-29 12:35:17,297 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/2ccfbc8c-c9ce-484d-82c1-d62b6b881d57 2025-10-29 12:35:17,306 - DEBUG - Route Targets: ['target:64512:8000007'] 2025-10-29 12:35:17,306 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/21451529-bcd3-4d44-bed8-dbcc9c18d05d 2025-10-29 12:35:17,320 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/ee49140e-c87f-4a4f-8e54-fc87c93e2153 2025-10-29 12:35:17,348 - INFO - Verified VN network id 17 for VN 21451529-bcd3-4d44-bed8-dbcc9c18d05d 2025-10-29 12:35:17,348 - INFO - Verifications in API Server for VN ctest-right_vn-11864219 passed 2025-10-29 12:35:17,348 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/21451529-bcd3-4d44-bed8-dbcc9c18d05d 2025-10-29 12:35:17,359 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/ee49140e-c87f-4a4f-8e54-fc87c93e2153 2025-10-29 12:35:17,369 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/ee49140e-c87f-4a4f-8e54-fc87c93e2153 2025-10-29 12:35:17,378 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/2ccfbc8c-c9ce-484d-82c1-d62b6b881d57 2025-10-29 12:35:17,391 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-11898174:ctest-right_vn-11864219', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-11898174', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2397345645650464068', 'uuid-lslong': '13751983134014492765'}, 'enable': 'true', 'created': '2025-10-29T12:35:16', 'last-modified': '2025-10-29T12:35:16', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.518642'} 2025-10-29 12:35:17,396 - DEBUG - Route Targets: ['target:64512:8000007'] 2025-10-29 12:35:17,403 - DEBUG - Control-node 10.0.0.254 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-11898174:ctest-right_vn-11864219', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-11898174', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2397345645650464068', 'uuid-lslong': '13751983134014492765'}, 'enable': 'true', 'created': '2025-10-29T12:35:16', 'last-modified': '2025-10-29T12:35:16', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.531435'} 2025-10-29 12:35:17,409 - DEBUG - Route Targets: ['target:64512:8000007'] 2025-10-29 12:35:17,417 - DEBUG - Control-node 10.0.0.48 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-11898174:ctest-right_vn-11864219', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-11898174', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2397345645650464068', 'uuid-lslong': '13751983134014492765'}, 'enable': 'true', 'created': '2025-10-29T12:35:16', 'last-modified': '2025-10-29T12:35:16', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.544081'} 2025-10-29 12:35:17,425 - DEBUG - Route Targets: ['target:64512:8000007'] 2025-10-29 12:35:17,426 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-11864219 passed 2025-10-29 12:35:17,426 - DEBUG - ====Verifying policy data for ctest-right_vn-11864219 in API_Server ====== 2025-10-29 12:35:17,426 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-10-29 12:35:17,432 - DEBUG - Requesting: http://10.0.0.38:8082/domain/fd9d3a52-0780-4060-8425-e3c883ec81fc 2025-10-29 12:35:17,446 - DEBUG - Requesting: http://10.0.0.38:8082/project/c43dba4b-444a-459c-86da-1c6313585381 2025-10-29 12:35:17,553 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/21451529-bcd3-4d44-bed8-dbcc9c18d05d 2025-10-29 12:35:17,567 - DEBUG - =>VN ctest-right_vn-11864219 has no policy to be verified 2025-10-29 12:35:17,567 - DEBUG - Verifying the vn in opserver 2025-10-29 12:35:17,567 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-11898174:ctest-right_vn-11864219 virtual network link through opserver 10.0.0.38 2025-10-29 12:35:17,567 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks 2025-10-29 12:35:17,629 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-11898174:ctest-right_vn-11864219', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-11898174:ctest-right_vn-11864219?flat'} 2025-10-29 12:35:17,629 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-11898174:ctest-right_vn-11864219 virtual network link through opserver 10.0.0.254 2025-10-29 12:35:17,629 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-networks 2025-10-29 12:35:17,690 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-11898174:ctest-right_vn-11864219', 'href': 'http://10.0.0.254:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-11898174:ctest-right_vn-11864219?flat'} 2025-10-29 12:35:17,691 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-11898174:ctest-right_vn-11864219 virtual network link through opserver 10.0.0.48 2025-10-29 12:35:17,691 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/virtual-networks 2025-10-29 12:35:17,749 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-11898174:ctest-right_vn-11864219', 'href': 'http://10.0.0.48:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-11898174:ctest-right_vn-11864219?flat'} 2025-10-29 12:35:17,749 - INFO - Validated that VN default-domain:ctest-TestSvcHC-11898174:ctest-right_vn-11864219 is found in opserver 2025-10-29 12:35:17,771 - DEBUG - Do not have enough data to verify VN in agent 2025-10-29 12:35:17,781 - DEBUG - VRF ids for VN ctest-right_vn-11864219: {} 2025-10-29 12:35:17,853 - DEBUG - Services list from nova: [, , , ] 2025-10-29 12:35:18,937 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4521-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4521-2) 2025-10-29 12:35:20,678 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4521-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4521-1) 2025-10-29 12:35:20,678 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-51442225'] 2025-10-29 12:35:20,995 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-51442225'] created succesfully 2025-10-29 12:35:21,400 - DEBUG - Image by name tiny_nat_fw not found 2025-10-29 12:35:21,401 - DEBUG - Installing image tiny_nat_fw 2025-10-29 12:35:21,401 - 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-29 12:35:21,401 - DEBUG - Image build path file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz 2025-10-29 12:35:21,401 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz 2025-10-29 12:35:21,401 - DEBUG - Unzip image 2025-10-29 12:35:21,401 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz 2025-10-29 12:35:21,420 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found 2025-10-29 12:35:21,420 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-51442225'] 2025-10-29 12:35:21,527 - INFO - Service template: ['default-domain', 'ctest-service_template_1-51442225'] deleted successfully. 2025-10-29 12:35:21,528 - INFO - Skip interface_detach for VM ctest-right_vm-82911987 in state BUILD 2025-10-29 12:35:21,528 - INFO - Deleting VM ctest-right_vm-82911987 2025-10-29 12:35:21,612 - ERROR - VM ctest-right_vm-82911987 has failed to come up 2025-10-29 12:35:21,612 - ERROR - Nova failed to get host of the VM 2025-10-29 12:35:21,612 - ERROR - VM ctest-right_vm-82911987 has failed to come up 2025-10-29 12:35:21,613 - ERROR - Nova failed to get host of the VM 2025-10-29 12:35:21,707 - INFO - Skip interface_detach for VM ctest-left_vm-00393351 in state BUILD 2025-10-29 12:35:21,707 - INFO - Deleting VM ctest-left_vm-00393351 2025-10-29 12:35:21,707 - ERROR - VM ctest-left_vm-00393351 has failed to come up 2025-10-29 12:35:21,707 - ERROR - Nova failed to get host of the VM 2025-10-29 12:35:21,707 - ERROR - VM ctest-left_vm-00393351 has failed to come up 2025-10-29 12:35:21,707 - ERROR - Nova failed to get host of the VM 2025-10-29 12:35:21,783 - INFO - Deleting VN ctest-right_vn-11864219 2025-10-29 12:35:21,832 - DEBUG - VN 21451529-bcd3-4d44-bed8-dbcc9c18d05d still in use: Unable to complete operation on network 21451529-bcd3-4d44-bed8-dbcc9c18d05d. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-8d00e611-7257-4864-9b37-369b77b86397'] 2025-10-29 12:35:21,832 - WARNING - Deleting VN ctest-right_vn-11864219 failed..Will retry 2025-10-29 12:35:24,002 - DEBUG - Response for deleting network () 2025-10-29 12:35:24,002 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/ee49140e-c87f-4a4f-8e54-fc87c93e2153 2025-10-29 12:35:24,010 - DEBUG - Response Code: 404 2025-10-29 12:35:24,010 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-10-29 12:35:24,020 - DEBUG - Requesting: http://10.0.0.38:8082/domain/fd9d3a52-0780-4060-8425-e3c883ec81fc 2025-10-29 12:35:24,057 - DEBUG - Requesting: http://10.0.0.38:8082/project/c43dba4b-444a-459c-86da-1c6313585381 2025-10-29 12:35:24,156 - INFO - Validated that VN ctest-right_vn-11864219 is not found in API Server 2025-10-29 12:35:24,171 - DEBUG - VN ctest-right_vn-11864219 is not present in Agent 10.0.0.49 2025-10-29 12:35:24,181 - DEBUG - VN ctest-right_vn-11864219 is not present in Agent 10.0.0.50 2025-10-29 12:35:24,181 - INFO - Validated that VN ctest-right_vn-11864219 is not in any agent 2025-10-29 12:35:24,228 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-11864219 info 2025-10-29 12:35:24,229 - INFO - Deleting VN ctest-left_vn-86489361 2025-10-29 12:35:24,390 - DEBUG - Response for deleting network () 2025-10-29 12:35:24,390 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/526ee6f1-0183-4d7a-b325-3f7679b64d96 2025-10-29 12:35:24,404 - DEBUG - Response Code: 404 2025-10-29 12:35:24,405 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-10-29 12:35:24,419 - DEBUG - Requesting: http://10.0.0.38:8082/domain/fd9d3a52-0780-4060-8425-e3c883ec81fc 2025-10-29 12:35:24,439 - DEBUG - Requesting: http://10.0.0.38:8082/project/c43dba4b-444a-459c-86da-1c6313585381 2025-10-29 12:35:24,549 - INFO - Validated that VN ctest-left_vn-86489361 is not found in API Server 2025-10-29 12:35:24,561 - DEBUG - VN ctest-left_vn-86489361 is not present in Agent 10.0.0.49 2025-10-29 12:35:24,578 - DEBUG - VN ctest-left_vn-86489361 is not present in Agent 10.0.0.50 2025-10-29 12:35:24,578 - INFO - Validated that VN ctest-left_vn-86489361 is not in any agent 2025-10-29 12:35:24,619 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-86489361 info 2025-10-29 12:35:24,619 - INFO - Deleting VN ctest-mgmt_vn-41987753 2025-10-29 12:35:24,810 - DEBUG - Response for deleting network () 2025-10-29 12:35:24,810 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/bbff9698-293c-4614-99f6-a64cd35d6b2a 2025-10-29 12:35:24,824 - DEBUG - Response Code: 404 2025-10-29 12:35:24,824 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-10-29 12:35:24,835 - DEBUG - Requesting: http://10.0.0.38:8082/domain/fd9d3a52-0780-4060-8425-e3c883ec81fc 2025-10-29 12:35:24,850 - DEBUG - Requesting: http://10.0.0.38:8082/project/c43dba4b-444a-459c-86da-1c6313585381 2025-10-29 12:35:24,987 - INFO - Validated that VN ctest-mgmt_vn-41987753 is not found in API Server 2025-10-29 12:35:25,000 - DEBUG - VN ctest-mgmt_vn-41987753 is not present in Agent 10.0.0.49 2025-10-29 12:35:25,011 - DEBUG - VN ctest-mgmt_vn-41987753 is not present in Agent 10.0.0.50 2025-10-29 12:35:25,011 - INFO - Validated that VN ctest-mgmt_vn-41987753 is not in any agent 2025-10-29 12:35:25,056 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-41987753 info 2025-10-29 12:35:26,342 - DEBUG - No XMPP flaps were noticed during the test 2025-10-29 12:35:26,342 - INFO -
2025-10-29 12:35:26,342 - INFO - END TEST : test_svc_hc_basic : SKIPPED[0:00:16]
2025-10-29 12:35:26,342 - INFO - -------------------------------------------------------------------------------- 2025-10-29 12:35:26,348 - INFO - ================================================================================ 2025-10-29 12:35:26,348 - INFO - STARTING TEST : test_svc_trans_segment_right_hc_fail_svm 2025-10-29 12:35:27,635 - DEBUG - Nothing to compare xmpp stats {'10.0.0.49': {'10.20.0.17': '0', '10.20.0.254': '0'}, '10.0.0.50': {'10.20.0.254': '0', '10.20.0.14': '0'}} with 2025-10-29 12:35:27,635 - INFO - Initial checks done. Running the testcase now 2025-10-29 12:35:27,635 - INFO - 2025-10-29 12:35:27,945 - DEBUG - Response for create_network : {'network': {'id': '392980e4-9124-4a9f-86cb-0a9cabcf456d', 'name': 'ctest-mgmt_vn-96379915', 'tenant_id': 'c43dba4b444a459c86da1c6313585381', 'project_id': 'c43dba4b444a459c86da1c6313585381', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-11898174', 'ctest-mgmt_vn-96379915'], 'port_security_enabled': True, 'description': ''}} 2025-10-29 12:35:28,189 - DEBUG - Response for create_subnet : {'subnet': {'id': '882ca562-ef51-4a44-9a6e-096e48b40260', 'name': '', 'tenant_id': 'c43dba4b444a459c86da1c6313585381', 'network_id': '392980e4-9124-4a9f-86cb-0a9cabcf456d', 'ip_version': 4, 'cidr': '147.111.179.64/26', 'allocation_pools': [{'start': '147.111.179.66', 'end': '147.111.179.126'}], 'gateway_ip': '147.111.179.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '147.111.179.66', 'tags': [], 'project_id': 'c43dba4b444a459c86da1c6313585381'}} 2025-10-29 12:35:28,216 - INFO - Created VN ctest-mgmt_vn-96379915 2025-10-29 12:35:28,230 - DEBUG - VN ctest-mgmt_vn-96379915 UUID is 392980e4-9124-4a9f-86cb-0a9cabcf456d 2025-10-29 12:35:28,319 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-10-29 12:35:28,331 - DEBUG - Requesting: http://10.0.0.38:8082/domain/fd9d3a52-0780-4060-8425-e3c883ec81fc 2025-10-29 12:35:28,346 - DEBUG - Requesting: http://10.0.0.38:8082/project/c43dba4b-444a-459c-86da-1c6313585381 2025-10-29 12:35:28,444 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/392980e4-9124-4a9f-86cb-0a9cabcf456d 2025-10-29 12:35:28,457 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/392980e4-9124-4a9f-86cb-0a9cabcf456d 2025-10-29 12:35:28,472 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/f00e7147-e002-41cd-b050-d81f04e10b90 2025-10-29 12:35:28,497 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/f00e7147-e002-41cd-b050-d81f04e10b90 2025-10-29 12:35:28,507 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/db5ca3cf-ab29-4644-8488-f1c5d09c2e6f 2025-10-29 12:35:28,515 - DEBUG - Route Targets: ['target:64512:8000004'] 2025-10-29 12:35:28,515 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/392980e4-9124-4a9f-86cb-0a9cabcf456d 2025-10-29 12:35:28,528 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/f00e7147-e002-41cd-b050-d81f04e10b90 2025-10-29 12:35:28,548 - INFO - Verified VN network id 15 for VN 392980e4-9124-4a9f-86cb-0a9cabcf456d 2025-10-29 12:35:28,549 - INFO - Verifications in API Server for VN ctest-mgmt_vn-96379915 passed 2025-10-29 12:35:28,549 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/392980e4-9124-4a9f-86cb-0a9cabcf456d 2025-10-29 12:35:28,564 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/f00e7147-e002-41cd-b050-d81f04e10b90 2025-10-29 12:35:28,574 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/f00e7147-e002-41cd-b050-d81f04e10b90 2025-10-29 12:35:28,597 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/db5ca3cf-ab29-4644-8488-f1c5d09c2e6f 2025-10-29 12:35:28,615 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-11898174:ctest-mgmt_vn-96379915', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-11898174', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4118965053383002783', 'uuid-lslong': '9712868689368270189'}, 'enable': 'true', 'created': '2025-10-29T12:35:27', 'last-modified': '2025-10-29T12:35:28', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.486178'} 2025-10-29 12:35:28,628 - DEBUG - Route Targets: ['target:64512:8000004'] 2025-10-29 12:35:28,638 - DEBUG - Control-node 10.0.0.254 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-11898174:ctest-mgmt_vn-96379915', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-11898174', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4118965053383002783', 'uuid-lslong': '9712868689368270189'}, 'enable': 'true', 'created': '2025-10-29T12:35:27', 'last-modified': '2025-10-29T12:35:28', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.514962'} 2025-10-29 12:35:28,646 - DEBUG - Route Targets: ['target:64512:8000004'] 2025-10-29 12:35:28,655 - DEBUG - Control-node 10.0.0.48 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-11898174:ctest-mgmt_vn-96379915', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-11898174', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4118965053383002783', 'uuid-lslong': '9712868689368270189'}, 'enable': 'true', 'created': '2025-10-29T12:35:27', 'last-modified': '2025-10-29T12:35:28', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.528532'} 2025-10-29 12:35:28,666 - DEBUG - Route Targets: ['target:64512:8000004'] 2025-10-29 12:35:28,666 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-96379915 passed 2025-10-29 12:35:28,666 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-96379915 in API_Server ====== 2025-10-29 12:35:28,666 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-10-29 12:35:28,674 - DEBUG - Requesting: http://10.0.0.38:8082/domain/fd9d3a52-0780-4060-8425-e3c883ec81fc 2025-10-29 12:35:28,700 - DEBUG - Requesting: http://10.0.0.38:8082/project/c43dba4b-444a-459c-86da-1c6313585381 2025-10-29 12:35:28,791 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/392980e4-9124-4a9f-86cb-0a9cabcf456d 2025-10-29 12:35:28,803 - DEBUG - =>VN ctest-mgmt_vn-96379915 has no policy to be verified 2025-10-29 12:35:28,803 - DEBUG - Verifying the vn in opserver 2025-10-29 12:35:28,803 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-11898174:ctest-mgmt_vn-96379915 virtual network link through opserver 10.0.0.38 2025-10-29 12:35:28,803 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks 2025-10-29 12:35:28,820 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-11898174:ctest-mgmt_vn-96379915', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-11898174:ctest-mgmt_vn-96379915?flat'} 2025-10-29 12:35:28,820 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-11898174:ctest-mgmt_vn-96379915 virtual network link through opserver 10.0.0.254 2025-10-29 12:35:28,821 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-networks 2025-10-29 12:35:28,836 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-11898174:ctest-mgmt_vn-96379915', 'href': 'http://10.0.0.254:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-11898174:ctest-mgmt_vn-96379915?flat'} 2025-10-29 12:35:28,836 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-11898174:ctest-mgmt_vn-96379915 virtual network link through opserver 10.0.0.48 2025-10-29 12:35:28,836 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/virtual-networks 2025-10-29 12:35:28,850 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-11898174:ctest-mgmt_vn-96379915', 'href': 'http://10.0.0.48:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-11898174:ctest-mgmt_vn-96379915?flat'} 2025-10-29 12:35:28,850 - INFO - Validated that VN default-domain:ctest-TestSvcHC-11898174:ctest-mgmt_vn-96379915 is found in opserver 2025-10-29 12:35:28,871 - DEBUG - Do not have enough data to verify VN in agent 2025-10-29 12:35:28,883 - DEBUG - VRF ids for VN ctest-mgmt_vn-96379915: {} 2025-10-29 12:35:29,198 - DEBUG - Response for create_network : {'network': {'id': 'a20f6782-f2b8-4847-b3c9-47af7202b042', 'name': 'ctest-left_vn-53655756', 'tenant_id': 'c43dba4b444a459c86da1c6313585381', 'project_id': 'c43dba4b444a459c86da1c6313585381', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-11898174', 'ctest-left_vn-53655756'], 'port_security_enabled': True, 'description': ''}} 2025-10-29 12:35:29,402 - DEBUG - Response for create_subnet : {'subnet': {'id': '7e92350b-6832-4cf9-9932-e310eadf2548', 'name': '', 'tenant_id': 'c43dba4b444a459c86da1c6313585381', 'network_id': 'a20f6782-f2b8-4847-b3c9-47af7202b042', 'ip_version': 4, 'cidr': '69.238.182.0/26', 'allocation_pools': [{'start': '69.238.182.2', 'end': '69.238.182.62'}], 'gateway_ip': '69.238.182.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '69.238.182.2', 'tags': [], 'project_id': 'c43dba4b444a459c86da1c6313585381'}} 2025-10-29 12:35:29,433 - INFO - Created VN ctest-left_vn-53655756 2025-10-29 12:35:29,446 - DEBUG - VN ctest-left_vn-53655756 UUID is a20f6782-f2b8-4847-b3c9-47af7202b042 2025-10-29 12:35:29,539 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-10-29 12:35:29,548 - DEBUG - Requesting: http://10.0.0.38:8082/domain/fd9d3a52-0780-4060-8425-e3c883ec81fc 2025-10-29 12:35:29,561 - DEBUG - Requesting: http://10.0.0.38:8082/project/c43dba4b-444a-459c-86da-1c6313585381 2025-10-29 12:35:29,660 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/a20f6782-f2b8-4847-b3c9-47af7202b042 2025-10-29 12:35:29,675 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/a20f6782-f2b8-4847-b3c9-47af7202b042 2025-10-29 12:35:29,686 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/eb411839-0069-4b46-ae48-f46172dd9f6a 2025-10-29 12:35:29,699 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/eb411839-0069-4b46-ae48-f46172dd9f6a 2025-10-29 12:35:29,708 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/f5045403-19f4-49c0-afb5-2e5e1508ad06 2025-10-29 12:35:29,716 - DEBUG - Route Targets: ['target:64512:8000006'] 2025-10-29 12:35:29,716 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/a20f6782-f2b8-4847-b3c9-47af7202b042 2025-10-29 12:35:29,727 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/eb411839-0069-4b46-ae48-f46172dd9f6a 2025-10-29 12:35:29,744 - INFO - Verified VN network id 16 for VN a20f6782-f2b8-4847-b3c9-47af7202b042 2025-10-29 12:35:29,744 - INFO - Verifications in API Server for VN ctest-left_vn-53655756 passed 2025-10-29 12:35:29,744 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/a20f6782-f2b8-4847-b3c9-47af7202b042 2025-10-29 12:35:29,756 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/eb411839-0069-4b46-ae48-f46172dd9f6a 2025-10-29 12:35:29,764 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/eb411839-0069-4b46-ae48-f46172dd9f6a 2025-10-29 12:35:29,772 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/f5045403-19f4-49c0-afb5-2e5e1508ad06 2025-10-29 12:35:29,784 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-11898174:ctest-left_vn-53655756', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-11898174', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11677666170910558279', 'uuid-lslong': '12954964621965570114'}, 'enable': 'true', 'created': '2025-10-29T12:35:29', 'last-modified': '2025-10-29T12:35:29', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.439554'} 2025-10-29 12:35:29,792 - DEBUG - Route Targets: ['target:64512:8000006'] 2025-10-29 12:35:29,798 - DEBUG - Control-node 10.0.0.254 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-11898174:ctest-left_vn-53655756', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-11898174', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11677666170910558279', 'uuid-lslong': '12954964621965570114'}, 'enable': 'true', 'created': '2025-10-29T12:35:29', 'last-modified': '2025-10-29T12:35:29', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.454033'} 2025-10-29 12:35:29,804 - DEBUG - Route Targets: ['target:64512:8000006'] 2025-10-29 12:35:29,810 - DEBUG - Control-node 10.0.0.48 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-11898174:ctest-left_vn-53655756', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-11898174', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11677666170910558279', 'uuid-lslong': '12954964621965570114'}, 'enable': 'true', 'created': '2025-10-29T12:35:29', 'last-modified': '2025-10-29T12:35:29', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.466156'} 2025-10-29 12:35:29,816 - DEBUG - Route Targets: ['target:64512:8000006'] 2025-10-29 12:35:29,816 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-53655756 passed 2025-10-29 12:35:29,816 - DEBUG - ====Verifying policy data for ctest-left_vn-53655756 in API_Server ====== 2025-10-29 12:35:29,816 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-10-29 12:35:29,825 - DEBUG - Requesting: http://10.0.0.38:8082/domain/fd9d3a52-0780-4060-8425-e3c883ec81fc 2025-10-29 12:35:29,839 - DEBUG - Requesting: http://10.0.0.38:8082/project/c43dba4b-444a-459c-86da-1c6313585381 2025-10-29 12:35:29,943 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/a20f6782-f2b8-4847-b3c9-47af7202b042 2025-10-29 12:35:29,962 - DEBUG - =>VN ctest-left_vn-53655756 has no policy to be verified 2025-10-29 12:35:29,962 - DEBUG - Verifying the vn in opserver 2025-10-29 12:35:29,962 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-11898174:ctest-left_vn-53655756 virtual network link through opserver 10.0.0.38 2025-10-29 12:35:29,962 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks 2025-10-29 12:35:29,975 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-11898174:ctest-left_vn-53655756', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-11898174:ctest-left_vn-53655756?flat'} 2025-10-29 12:35:29,975 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-11898174:ctest-left_vn-53655756 virtual network link through opserver 10.0.0.254 2025-10-29 12:35:29,975 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-networks 2025-10-29 12:35:29,987 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-11898174:ctest-left_vn-53655756', 'href': 'http://10.0.0.254:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-11898174:ctest-left_vn-53655756?flat'} 2025-10-29 12:35:29,988 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-11898174:ctest-left_vn-53655756 virtual network link through opserver 10.0.0.48 2025-10-29 12:35:29,988 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/virtual-networks 2025-10-29 12:35:30,000 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-11898174:ctest-left_vn-53655756', 'href': 'http://10.0.0.48:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-11898174:ctest-left_vn-53655756?flat'} 2025-10-29 12:35:30,000 - INFO - Validated that VN default-domain:ctest-TestSvcHC-11898174:ctest-left_vn-53655756 is found in opserver 2025-10-29 12:35:30,028 - DEBUG - Do not have enough data to verify VN in agent 2025-10-29 12:35:30,039 - DEBUG - VRF ids for VN ctest-left_vn-53655756: {} 2025-10-29 12:35:30,325 - DEBUG - Response for create_network : {'network': {'id': 'e8a93f93-5f15-4cf9-8539-1963635436a2', 'name': 'ctest-right_vn-59660756', 'tenant_id': 'c43dba4b444a459c86da1c6313585381', 'project_id': 'c43dba4b444a459c86da1c6313585381', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-11898174', 'ctest-right_vn-59660756'], 'port_security_enabled': True, 'description': ''}} 2025-10-29 12:35:30,582 - DEBUG - Response for create_subnet : {'subnet': {'id': '23419b46-cecb-4981-844e-5a0a2bc86565', 'name': '', 'tenant_id': 'c43dba4b444a459c86da1c6313585381', 'network_id': 'e8a93f93-5f15-4cf9-8539-1963635436a2', 'ip_version': 4, 'cidr': '108.100.217.192/26', 'allocation_pools': [{'start': '108.100.217.194', 'end': '108.100.217.254'}], 'gateway_ip': '108.100.217.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '108.100.217.194', 'tags': [], 'project_id': 'c43dba4b444a459c86da1c6313585381'}} 2025-10-29 12:35:30,604 - INFO - Created VN ctest-right_vn-59660756 2025-10-29 12:35:30,616 - DEBUG - VN ctest-right_vn-59660756 UUID is e8a93f93-5f15-4cf9-8539-1963635436a2 2025-10-29 12:35:30,699 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-10-29 12:35:30,706 - DEBUG - Requesting: http://10.0.0.38:8082/domain/fd9d3a52-0780-4060-8425-e3c883ec81fc 2025-10-29 12:35:30,721 - DEBUG - Requesting: http://10.0.0.38:8082/project/c43dba4b-444a-459c-86da-1c6313585381 2025-10-29 12:35:30,828 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/e8a93f93-5f15-4cf9-8539-1963635436a2 2025-10-29 12:35:30,840 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/e8a93f93-5f15-4cf9-8539-1963635436a2 2025-10-29 12:35:30,856 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/ca31af1a-c33e-4623-abf8-571091b87c91 2025-10-29 12:35:30,865 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/ca31af1a-c33e-4623-abf8-571091b87c91 2025-10-29 12:35:30,872 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/55414be5-77b6-4921-ab10-d9b50534234f 2025-10-29 12:35:30,880 - DEBUG - Route Targets: ['target:64512:8000007'] 2025-10-29 12:35:30,881 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/e8a93f93-5f15-4cf9-8539-1963635436a2 2025-10-29 12:35:30,893 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/ca31af1a-c33e-4623-abf8-571091b87c91 2025-10-29 12:35:30,911 - INFO - Verified VN network id 17 for VN e8a93f93-5f15-4cf9-8539-1963635436a2 2025-10-29 12:35:30,911 - INFO - Verifications in API Server for VN ctest-right_vn-59660756 passed 2025-10-29 12:35:30,911 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/e8a93f93-5f15-4cf9-8539-1963635436a2 2025-10-29 12:35:30,924 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/ca31af1a-c33e-4623-abf8-571091b87c91 2025-10-29 12:35:30,935 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/ca31af1a-c33e-4623-abf8-571091b87c91 2025-10-29 12:35:30,946 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/55414be5-77b6-4921-ab10-d9b50534234f 2025-10-29 12:35:30,961 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-11898174:ctest-right_vn-59660756', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-11898174', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16765000990051355897', 'uuid-lslong': '9599731995375842978'}, 'enable': 'true', 'created': '2025-10-29T12:35:30', 'last-modified': '2025-10-29T12:35:30', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.451064'} 2025-10-29 12:35:30,967 - DEBUG - Route Targets: ['target:64512:8000007'] 2025-10-29 12:35:30,972 - DEBUG - Control-node 10.0.0.254 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-11898174:ctest-right_vn-59660756', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-11898174', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16765000990051355897', 'uuid-lslong': '9599731995375842978'}, 'enable': 'true', 'created': '2025-10-29T12:35:30', 'last-modified': '2025-10-29T12:35:30', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.463824'} 2025-10-29 12:35:30,977 - DEBUG - Route Targets: ['target:64512:8000007'] 2025-10-29 12:35:30,984 - DEBUG - Control-node 10.0.0.48 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-11898174:ctest-right_vn-59660756', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-11898174', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16765000990051355897', 'uuid-lslong': '9599731995375842978'}, 'enable': 'true', 'created': '2025-10-29T12:35:30', 'last-modified': '2025-10-29T12:35:30', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.473953'} 2025-10-29 12:35:30,990 - DEBUG - Route Targets: ['target:64512:8000007'] 2025-10-29 12:35:30,990 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-59660756 passed 2025-10-29 12:35:30,990 - DEBUG - ====Verifying policy data for ctest-right_vn-59660756 in API_Server ====== 2025-10-29 12:35:30,990 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-10-29 12:35:30,997 - DEBUG - Requesting: http://10.0.0.38:8082/domain/fd9d3a52-0780-4060-8425-e3c883ec81fc 2025-10-29 12:35:31,008 - DEBUG - Requesting: http://10.0.0.38:8082/project/c43dba4b-444a-459c-86da-1c6313585381 2025-10-29 12:35:31,107 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/e8a93f93-5f15-4cf9-8539-1963635436a2 2025-10-29 12:35:31,116 - DEBUG - =>VN ctest-right_vn-59660756 has no policy to be verified 2025-10-29 12:35:31,116 - DEBUG - Verifying the vn in opserver 2025-10-29 12:35:31,116 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-11898174:ctest-right_vn-59660756 virtual network link through opserver 10.0.0.38 2025-10-29 12:35:31,116 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks 2025-10-29 12:35:31,132 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-11898174:ctest-right_vn-59660756', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-11898174:ctest-right_vn-59660756?flat'} 2025-10-29 12:35:31,132 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-11898174:ctest-right_vn-59660756 virtual network link through opserver 10.0.0.254 2025-10-29 12:35:31,132 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-networks 2025-10-29 12:35:31,146 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-11898174:ctest-right_vn-59660756', 'href': 'http://10.0.0.254:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-11898174:ctest-right_vn-59660756?flat'} 2025-10-29 12:35:31,146 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-11898174:ctest-right_vn-59660756 virtual network link through opserver 10.0.0.48 2025-10-29 12:35:31,146 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/virtual-networks 2025-10-29 12:35:31,162 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-11898174:ctest-right_vn-59660756', 'href': 'http://10.0.0.48:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-11898174:ctest-right_vn-59660756?flat'} 2025-10-29 12:35:31,162 - INFO - Validated that VN default-domain:ctest-TestSvcHC-11898174:ctest-right_vn-59660756 is found in opserver 2025-10-29 12:35:31,190 - DEBUG - Do not have enough data to verify VN in agent 2025-10-29 12:35:31,203 - DEBUG - VRF ids for VN ctest-right_vn-59660756: {} 2025-10-29 12:35:31,478 - DEBUG - Response for create_network : {'network': {'id': '42f5a1ac-4dcd-47c8-82ea-1b5806d6096c', 'name': 'ctest-trans_left_vn-64710735', 'tenant_id': 'c43dba4b444a459c86da1c6313585381', 'project_id': 'c43dba4b444a459c86da1c6313585381', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-11898174', 'ctest-trans_left_vn-64710735'], 'port_security_enabled': True, 'description': ''}} 2025-10-29 12:35:31,688 - DEBUG - Response for create_subnet : {'subnet': {'id': '9a2e04cf-4046-4051-80ac-9a9db7bcf9a3', 'name': '', 'tenant_id': 'c43dba4b444a459c86da1c6313585381', 'network_id': '42f5a1ac-4dcd-47c8-82ea-1b5806d6096c', 'ip_version': 4, 'cidr': '181.4.232.128/26', 'allocation_pools': [{'start': '181.4.232.130', 'end': '181.4.232.190'}], 'gateway_ip': '181.4.232.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '181.4.232.130', 'tags': [], 'project_id': 'c43dba4b444a459c86da1c6313585381'}} 2025-10-29 12:35:31,714 - INFO - Created VN ctest-trans_left_vn-64710735 2025-10-29 12:35:31,729 - DEBUG - VN ctest-trans_left_vn-64710735 UUID is 42f5a1ac-4dcd-47c8-82ea-1b5806d6096c 2025-10-29 12:35:31,803 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-10-29 12:35:31,810 - DEBUG - Requesting: http://10.0.0.38:8082/domain/fd9d3a52-0780-4060-8425-e3c883ec81fc 2025-10-29 12:35:31,823 - DEBUG - Requesting: http://10.0.0.38:8082/project/c43dba4b-444a-459c-86da-1c6313585381 2025-10-29 12:35:31,928 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/42f5a1ac-4dcd-47c8-82ea-1b5806d6096c 2025-10-29 12:35:31,941 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/42f5a1ac-4dcd-47c8-82ea-1b5806d6096c 2025-10-29 12:35:31,953 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/afdb948f-2c88-4e87-ae10-dcfd72805c19 2025-10-29 12:35:31,966 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/afdb948f-2c88-4e87-ae10-dcfd72805c19 2025-10-29 12:35:31,974 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/1e131097-02fe-496d-b501-16e0648b5c88 2025-10-29 12:35:31,995 - DEBUG - Route Targets: ['target:64512:8000008'] 2025-10-29 12:35:31,995 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/42f5a1ac-4dcd-47c8-82ea-1b5806d6096c 2025-10-29 12:35:32,006 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/afdb948f-2c88-4e87-ae10-dcfd72805c19 2025-10-29 12:35:32,027 - INFO - Verified VN network id 18 for VN 42f5a1ac-4dcd-47c8-82ea-1b5806d6096c 2025-10-29 12:35:32,027 - INFO - Verifications in API Server for VN ctest-trans_left_vn-64710735 passed 2025-10-29 12:35:32,027 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/42f5a1ac-4dcd-47c8-82ea-1b5806d6096c 2025-10-29 12:35:32,038 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/afdb948f-2c88-4e87-ae10-dcfd72805c19 2025-10-29 12:35:32,046 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/afdb948f-2c88-4e87-ae10-dcfd72805c19 2025-10-29 12:35:32,054 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/1e131097-02fe-496d-b501-16e0648b5c88 2025-10-29 12:35:32,068 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-11898174:ctest-trans_left_vn-64710735', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-11898174', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4824940337209100232', 'uuid-lslong': '9433382434366687596'}, 'enable': 'true', 'created': '2025-10-29T12:35:31', 'last-modified': '2025-10-29T12:35:31', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.428765'} 2025-10-29 12:35:32,074 - DEBUG - Route Targets: ['target:64512:8000008'] 2025-10-29 12:35:32,080 - DEBUG - Control-node 10.0.0.254 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-11898174:ctest-trans_left_vn-64710735', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-11898174', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4824940337209100232', 'uuid-lslong': '9433382434366687596'}, 'enable': 'true', 'created': '2025-10-29T12:35:31', 'last-modified': '2025-10-29T12:35:31', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.442489'} 2025-10-29 12:35:32,086 - DEBUG - Route Targets: ['target:64512:8000008'] 2025-10-29 12:35:32,092 - DEBUG - Control-node 10.0.0.48 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-11898174:ctest-trans_left_vn-64710735', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-11898174', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4824940337209100232', 'uuid-lslong': '9433382434366687596'}, 'enable': 'true', 'created': '2025-10-29T12:35:31', 'last-modified': '2025-10-29T12:35:31', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.458830'} 2025-10-29 12:35:32,098 - DEBUG - Route Targets: ['target:64512:8000008'] 2025-10-29 12:35:32,098 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_left_vn-64710735 passed 2025-10-29 12:35:32,099 - DEBUG - ====Verifying policy data for ctest-trans_left_vn-64710735 in API_Server ====== 2025-10-29 12:35:32,099 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-10-29 12:35:32,106 - DEBUG - Requesting: http://10.0.0.38:8082/domain/fd9d3a52-0780-4060-8425-e3c883ec81fc 2025-10-29 12:35:32,121 - DEBUG - Requesting: http://10.0.0.38:8082/project/c43dba4b-444a-459c-86da-1c6313585381 2025-10-29 12:35:32,216 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/42f5a1ac-4dcd-47c8-82ea-1b5806d6096c 2025-10-29 12:35:32,228 - DEBUG - =>VN ctest-trans_left_vn-64710735 has no policy to be verified 2025-10-29 12:35:32,228 - DEBUG - Verifying the vn in opserver 2025-10-29 12:35:32,228 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-11898174:ctest-trans_left_vn-64710735 virtual network link through opserver 10.0.0.38 2025-10-29 12:35:32,228 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks 2025-10-29 12:35:32,242 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-11898174:ctest-trans_left_vn-64710735', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-11898174:ctest-trans_left_vn-64710735?flat'} 2025-10-29 12:35:32,242 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-11898174:ctest-trans_left_vn-64710735 virtual network link through opserver 10.0.0.254 2025-10-29 12:35:32,242 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-networks 2025-10-29 12:35:32,254 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-11898174:ctest-trans_left_vn-64710735', 'href': 'http://10.0.0.254:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-11898174:ctest-trans_left_vn-64710735?flat'} 2025-10-29 12:35:32,254 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-11898174:ctest-trans_left_vn-64710735 virtual network link through opserver 10.0.0.48 2025-10-29 12:35:32,254 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/virtual-networks 2025-10-29 12:35:32,268 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-11898174:ctest-trans_left_vn-64710735', 'href': 'http://10.0.0.48:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-11898174:ctest-trans_left_vn-64710735?flat'} 2025-10-29 12:35:32,268 - INFO - Validated that VN default-domain:ctest-TestSvcHC-11898174:ctest-trans_left_vn-64710735 is found in opserver 2025-10-29 12:35:32,293 - DEBUG - Do not have enough data to verify VN in agent 2025-10-29 12:35:32,305 - DEBUG - VRF ids for VN ctest-trans_left_vn-64710735: {} 2025-10-29 12:35:32,605 - DEBUG - Response for create_network : {'network': {'id': '09ad7c30-dbd0-44db-bf15-01240cf9810e', 'name': 'ctest-trans_right_vn-59314414', 'tenant_id': 'c43dba4b444a459c86da1c6313585381', 'project_id': 'c43dba4b444a459c86da1c6313585381', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-11898174', 'ctest-trans_right_vn-59314414'], 'port_security_enabled': True, 'description': ''}} 2025-10-29 12:35:32,829 - DEBUG - Response for create_subnet : {'subnet': {'id': '549013d1-a9fe-44be-bb11-16e5685cd8ea', 'name': '', 'tenant_id': 'c43dba4b444a459c86da1c6313585381', 'network_id': '09ad7c30-dbd0-44db-bf15-01240cf9810e', 'ip_version': 4, 'cidr': '69.173.25.0/26', 'allocation_pools': [{'start': '69.173.25.2', 'end': '69.173.25.62'}], 'gateway_ip': '69.173.25.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '69.173.25.2', 'tags': [], 'project_id': 'c43dba4b444a459c86da1c6313585381'}} 2025-10-29 12:35:32,852 - INFO - Created VN ctest-trans_right_vn-59314414 2025-10-29 12:35:32,863 - DEBUG - VN ctest-trans_right_vn-59314414 UUID is 09ad7c30-dbd0-44db-bf15-01240cf9810e 2025-10-29 12:35:32,962 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-10-29 12:35:32,970 - DEBUG - Requesting: http://10.0.0.38:8082/domain/fd9d3a52-0780-4060-8425-e3c883ec81fc 2025-10-29 12:35:32,984 - DEBUG - Requesting: http://10.0.0.38:8082/project/c43dba4b-444a-459c-86da-1c6313585381 2025-10-29 12:35:33,079 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/09ad7c30-dbd0-44db-bf15-01240cf9810e 2025-10-29 12:35:33,096 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/09ad7c30-dbd0-44db-bf15-01240cf9810e 2025-10-29 12:35:33,108 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/63728be9-3dd5-4973-8582-6b96a1d8f5d8 2025-10-29 12:35:33,119 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/63728be9-3dd5-4973-8582-6b96a1d8f5d8 2025-10-29 12:35:33,128 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/3f5808c8-2dc5-44ec-85dc-66902f0ce50e 2025-10-29 12:35:33,136 - DEBUG - Route Targets: ['target:64512:8000009'] 2025-10-29 12:35:33,136 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/09ad7c30-dbd0-44db-bf15-01240cf9810e 2025-10-29 12:35:33,147 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/63728be9-3dd5-4973-8582-6b96a1d8f5d8 2025-10-29 12:35:33,168 - INFO - Verified VN network id 19 for VN 09ad7c30-dbd0-44db-bf15-01240cf9810e 2025-10-29 12:35:33,168 - INFO - Verifications in API Server for VN ctest-trans_right_vn-59314414 passed 2025-10-29 12:35:33,168 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/09ad7c30-dbd0-44db-bf15-01240cf9810e 2025-10-29 12:35:33,178 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/63728be9-3dd5-4973-8582-6b96a1d8f5d8 2025-10-29 12:35:33,185 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/63728be9-3dd5-4973-8582-6b96a1d8f5d8 2025-10-29 12:35:33,193 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/3f5808c8-2dc5-44ec-85dc-66902f0ce50e 2025-10-29 12:35:33,207 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-11898174:ctest-trans_right_vn-59314414', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-11898174', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '697350066600428763', 'uuid-lslong': '13768912690103288078'}, 'enable': 'true', 'created': '2025-10-29T12:35:32', 'last-modified': '2025-10-29T12:35:32', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.423180'} 2025-10-29 12:35:33,214 - DEBUG - Route Targets: ['target:64512:8000009'] 2025-10-29 12:35:33,219 - DEBUG - Control-node 10.0.0.254 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-11898174:ctest-trans_right_vn-59314414', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-11898174', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '697350066600428763', 'uuid-lslong': '13768912690103288078'}, 'enable': 'true', 'created': '2025-10-29T12:35:32', 'last-modified': '2025-10-29T12:35:32', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.436523'} 2025-10-29 12:35:33,226 - DEBUG - Route Targets: ['target:64512:8000009'] 2025-10-29 12:35:33,232 - DEBUG - Control-node 10.0.0.48 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-11898174:ctest-trans_right_vn-59314414', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-11898174', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '697350066600428763', 'uuid-lslong': '13768912690103288078'}, 'enable': 'true', 'created': '2025-10-29T12:35:32', 'last-modified': '2025-10-29T12:35:32', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.450394'} 2025-10-29 12:35:33,239 - DEBUG - Route Targets: ['target:64512:8000009'] 2025-10-29 12:35:33,239 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_right_vn-59314414 passed 2025-10-29 12:35:33,240 - DEBUG - ====Verifying policy data for ctest-trans_right_vn-59314414 in API_Server ====== 2025-10-29 12:35:33,240 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-10-29 12:35:33,247 - DEBUG - Requesting: http://10.0.0.38:8082/domain/fd9d3a52-0780-4060-8425-e3c883ec81fc 2025-10-29 12:35:33,261 - DEBUG - Requesting: http://10.0.0.38:8082/project/c43dba4b-444a-459c-86da-1c6313585381 2025-10-29 12:35:33,364 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/09ad7c30-dbd0-44db-bf15-01240cf9810e 2025-10-29 12:35:33,378 - DEBUG - =>VN ctest-trans_right_vn-59314414 has no policy to be verified 2025-10-29 12:35:33,378 - DEBUG - Verifying the vn in opserver 2025-10-29 12:35:33,378 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-11898174:ctest-trans_right_vn-59314414 virtual network link through opserver 10.0.0.38 2025-10-29 12:35:33,378 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks 2025-10-29 12:35:33,391 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-11898174:ctest-trans_right_vn-59314414', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-11898174:ctest-trans_right_vn-59314414?flat'} 2025-10-29 12:35:33,391 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-11898174:ctest-trans_right_vn-59314414 virtual network link through opserver 10.0.0.254 2025-10-29 12:35:33,391 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-networks 2025-10-29 12:35:33,405 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-11898174:ctest-trans_right_vn-59314414', 'href': 'http://10.0.0.254:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-11898174:ctest-trans_right_vn-59314414?flat'} 2025-10-29 12:35:33,405 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-11898174:ctest-trans_right_vn-59314414 virtual network link through opserver 10.0.0.48 2025-10-29 12:35:33,405 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/virtual-networks 2025-10-29 12:35:33,419 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-11898174:ctest-trans_right_vn-59314414', 'href': 'http://10.0.0.48:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-11898174:ctest-trans_right_vn-59314414?flat'} 2025-10-29 12:35:33,419 - INFO - Validated that VN default-domain:ctest-TestSvcHC-11898174:ctest-trans_right_vn-59314414 is found in opserver 2025-10-29 12:35:33,443 - DEBUG - Do not have enough data to verify VN in agent 2025-10-29 12:35:33,456 - DEBUG - VRF ids for VN ctest-trans_right_vn-59314414: {} 2025-10-29 12:35:34,705 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4521-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4521-1) 2025-10-29 12:35:36,063 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4521-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4521-2) 2025-10-29 12:35:36,063 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-98746865'] 2025-10-29 12:35:36,367 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-98746865'] created succesfully 2025-10-29 12:35:36,787 - DEBUG - Image by name tiny_trans_fw not found 2025-10-29 12:35:36,787 - DEBUG - Installing image tiny_trans_fw 2025-10-29 12:35:36,787 - 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-29 12:35:36,788 - DEBUG - Image build path file:///contrail-test/images/tinycore-net-transparent-fw.qcow2.gz 2025-10-29 12:35:36,788 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-net-transparent-fw.qcow2.gz 2025-10-29 12:35:36,788 - DEBUG - Unzip image 2025-10-29 12:35:36,788 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-net-transparent-fw.qcow2.gz 2025-10-29 12:35:36,811 - INFO - image /contrail-test/images/tinycore-net-transparent-fw.qcow2 is not found 2025-10-29 12:35:36,811 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-98746865'] 2025-10-29 12:35:36,908 - INFO - Service template: ['default-domain', 'ctest-service_template_1-98746865'] deleted successfully. 2025-10-29 12:35:36,908 - INFO - Skip interface_detach for VM ctest-right_vm-81471544 in state BUILD 2025-10-29 12:35:36,908 - INFO - Deleting VM ctest-right_vm-81471544 2025-10-29 12:35:36,908 - ERROR - VM ctest-right_vm-81471544 has failed to come up 2025-10-29 12:35:36,908 - ERROR - Nova failed to get host of the VM 2025-10-29 12:35:36,908 - ERROR - VM ctest-right_vm-81471544 has failed to come up 2025-10-29 12:35:36,908 - ERROR - Nova failed to get host of the VM 2025-10-29 12:35:37,028 - INFO - Skip interface_detach for VM ctest-left_vm-62935526 in state BUILD 2025-10-29 12:35:37,028 - INFO - Deleting VM ctest-left_vm-62935526 2025-10-29 12:35:37,028 - ERROR - VM ctest-left_vm-62935526 has failed to come up 2025-10-29 12:35:37,028 - ERROR - Nova failed to get host of the VM 2025-10-29 12:35:37,028 - ERROR - VM ctest-left_vm-62935526 has failed to come up 2025-10-29 12:35:37,028 - ERROR - Nova failed to get host of the VM 2025-10-29 12:35:37,117 - INFO - Deleting VN ctest-trans_right_vn-59314414 2025-10-29 12:35:37,326 - DEBUG - Response for deleting network () 2025-10-29 12:35:37,326 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/63728be9-3dd5-4973-8582-6b96a1d8f5d8 2025-10-29 12:35:37,335 - DEBUG - Response Code: 404 2025-10-29 12:35:37,336 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-10-29 12:35:37,343 - DEBUG - Requesting: http://10.0.0.38:8082/domain/fd9d3a52-0780-4060-8425-e3c883ec81fc 2025-10-29 12:35:37,400 - DEBUG - Requesting: http://10.0.0.38:8082/project/c43dba4b-444a-459c-86da-1c6313585381 2025-10-29 12:35:37,510 - INFO - Validated that VN ctest-trans_right_vn-59314414 is not found in API Server 2025-10-29 12:35:37,532 - DEBUG - VN ctest-trans_right_vn-59314414 is not present in Agent 10.0.0.49 2025-10-29 12:35:37,565 - DEBUG - VN ctest-trans_right_vn-59314414 is not present in Agent 10.0.0.50 2025-10-29 12:35:37,565 - INFO - Validated that VN ctest-trans_right_vn-59314414 is not in any agent 2025-10-29 12:35:37,604 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-trans_right_vn-59314414 info 2025-10-29 12:35:37,605 - INFO - Deleting VN ctest-trans_left_vn-64710735 2025-10-29 12:35:37,770 - DEBUG - Response for deleting network () 2025-10-29 12:35:37,770 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/afdb948f-2c88-4e87-ae10-dcfd72805c19 2025-10-29 12:35:37,778 - DEBUG - Response Code: 404 2025-10-29 12:35:37,779 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-10-29 12:35:37,790 - DEBUG - Requesting: http://10.0.0.38:8082/domain/fd9d3a52-0780-4060-8425-e3c883ec81fc 2025-10-29 12:35:37,816 - DEBUG - Requesting: http://10.0.0.38:8082/project/c43dba4b-444a-459c-86da-1c6313585381 2025-10-29 12:35:37,925 - INFO - Validated that VN ctest-trans_left_vn-64710735 is not found in API Server 2025-10-29 12:35:37,938 - DEBUG - VN ctest-trans_left_vn-64710735 is not present in Agent 10.0.0.49 2025-10-29 12:35:37,951 - DEBUG - VN ctest-trans_left_vn-64710735 is not present in Agent 10.0.0.50 2025-10-29 12:35:37,951 - INFO - Validated that VN ctest-trans_left_vn-64710735 is not in any agent 2025-10-29 12:35:37,998 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-trans_left_vn-64710735 info 2025-10-29 12:35:37,998 - INFO - Deleting VN ctest-right_vn-59660756 2025-10-29 12:35:38,045 - DEBUG - VN e8a93f93-5f15-4cf9-8539-1963635436a2 still in use: Unable to complete operation on network e8a93f93-5f15-4cf9-8539-1963635436a2. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-1af824d9-5389-4a53-8a01-6dc2780ea4bf'] 2025-10-29 12:35:38,045 - WARNING - Deleting VN ctest-right_vn-59660756 failed..Will retry 2025-10-29 12:35:40,252 - DEBUG - Response for deleting network () 2025-10-29 12:35:40,252 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/ca31af1a-c33e-4623-abf8-571091b87c91 2025-10-29 12:35:40,260 - DEBUG - Response Code: 404 2025-10-29 12:35:40,260 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-10-29 12:35:40,280 - DEBUG - Requesting: http://10.0.0.38:8082/domain/fd9d3a52-0780-4060-8425-e3c883ec81fc 2025-10-29 12:35:40,302 - DEBUG - Requesting: http://10.0.0.38:8082/project/c43dba4b-444a-459c-86da-1c6313585381 2025-10-29 12:35:40,474 - INFO - Validated that VN ctest-right_vn-59660756 is not found in API Server 2025-10-29 12:35:40,490 - DEBUG - VN ctest-right_vn-59660756 is not present in Agent 10.0.0.49 2025-10-29 12:35:40,503 - DEBUG - VN ctest-right_vn-59660756 is not present in Agent 10.0.0.50 2025-10-29 12:35:40,503 - INFO - Validated that VN ctest-right_vn-59660756 is not in any agent 2025-10-29 12:35:40,555 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-59660756 info 2025-10-29 12:35:40,555 - INFO - Deleting VN ctest-left_vn-53655756 2025-10-29 12:35:40,911 - DEBUG - Response for deleting network () 2025-10-29 12:35:40,911 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/eb411839-0069-4b46-ae48-f46172dd9f6a 2025-10-29 12:35:40,925 - DEBUG - Response Code: 404 2025-10-29 12:35:40,925 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-10-29 12:35:40,933 - DEBUG - Requesting: http://10.0.0.38:8082/domain/fd9d3a52-0780-4060-8425-e3c883ec81fc 2025-10-29 12:35:40,969 - DEBUG - Requesting: http://10.0.0.38:8082/project/c43dba4b-444a-459c-86da-1c6313585381 2025-10-29 12:35:41,102 - INFO - Validated that VN ctest-left_vn-53655756 is not found in API Server 2025-10-29 12:35:41,117 - DEBUG - VN ctest-left_vn-53655756 is not present in Agent 10.0.0.49 2025-10-29 12:35:41,130 - DEBUG - VN ctest-left_vn-53655756 is not present in Agent 10.0.0.50 2025-10-29 12:35:41,130 - INFO - Validated that VN ctest-left_vn-53655756 is not in any agent 2025-10-29 12:35:41,166 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-53655756 info 2025-10-29 12:35:41,166 - INFO - Deleting VN ctest-mgmt_vn-96379915 2025-10-29 12:35:41,329 - DEBUG - Response for deleting network () 2025-10-29 12:35:41,330 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/f00e7147-e002-41cd-b050-d81f04e10b90 2025-10-29 12:35:41,337 - DEBUG - Response Code: 404 2025-10-29 12:35:41,337 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-10-29 12:35:41,356 - DEBUG - Requesting: http://10.0.0.38:8082/domain/fd9d3a52-0780-4060-8425-e3c883ec81fc 2025-10-29 12:35:41,372 - DEBUG - Requesting: http://10.0.0.38:8082/project/c43dba4b-444a-459c-86da-1c6313585381 2025-10-29 12:35:41,467 - INFO - Validated that VN ctest-mgmt_vn-96379915 is not found in API Server 2025-10-29 12:35:41,482 - DEBUG - VN ctest-mgmt_vn-96379915 is not present in Agent 10.0.0.49 2025-10-29 12:35:41,496 - DEBUG - VN ctest-mgmt_vn-96379915 is not present in Agent 10.0.0.50 2025-10-29 12:35:41,496 - INFO - Validated that VN ctest-mgmt_vn-96379915 is not in any agent 2025-10-29 12:35:41,533 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-96379915 info 2025-10-29 12:35:42,793 - DEBUG - No XMPP flaps were noticed during the test 2025-10-29 12:35:42,793 - INFO -
2025-10-29 12:35:42,793 - INFO - END TEST : test_svc_trans_segment_right_hc_fail_svm : SKIPPED[0:00:16]
2025-10-29 12:35:42,793 - INFO - -------------------------------------------------------------------------------- 2025-10-29 12:35:43,573 - INFO - Deleted project: ctest-TestSvcHC-11898174, ID : c43dba4b-444a-459c-86da-1c6313585381