2025-12-01 03:12:01,523 - INFO - Domain Default found not creating
2025-12-01 03:12:01,724 - INFO - Project ctest-TestSvcHC-95796989 not found, creating it
2025-12-01 03:12:02,940 - INFO - Created Project:ctest-TestSvcHC-95796989, ID : 137b1f61-d728-4a4e-8f3d-7f3152dced90
2025-12-01 03:12:04,931 - INFO - ================================================================================
2025-12-01 03:12:04,932 - INFO - STARTING TEST : test_svc_hc_basic
2025-12-01 03:12:06,211 - DEBUG - Nothing to compare xmpp stats {'10.0.0.22': {'10.20.0.209': '0', '10.20.0.192': '0'}, '10.0.0.241': {'10.20.0.209': '0', '10.20.0.192': '0'}} with
2025-12-01 03:12:06,211 - INFO - Initial checks done. Running the testcase now
2025-12-01 03:12:06,211 - INFO -
2025-12-01 03:12:07,051 - DEBUG - Response for create_network : {'network': {'id': '70d7f13a-01c4-494b-95ba-a9b9c4222c94', 'name': 'ctest-mgmt_vn-98808540', 'tenant_id': '137b1f61d7284a4e8f3d7f3152dced90', 'project_id': '137b1f61d7284a4e8f3d7f3152dced90', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-95796989', 'ctest-mgmt_vn-98808540'], 'port_security_enabled': True, 'description': ''}}
2025-12-01 03:12:07,397 - DEBUG - Response for create_subnet : {'subnet': {'id': '5aeae978-8223-47a3-b822-6c8db72885a0', 'name': '', 'tenant_id': '137b1f61d7284a4e8f3d7f3152dced90', 'network_id': '70d7f13a-01c4-494b-95ba-a9b9c4222c94', 'ip_version': 4, 'cidr': '187.30.198.0/26', 'allocation_pools': [{'start': '187.30.198.2', 'end': '187.30.198.62'}], 'gateway_ip': '187.30.198.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '187.30.198.2', 'tags': [], 'project_id': '137b1f61d7284a4e8f3d7f3152dced90'}}
2025-12-01 03:12:07,424 - INFO - Created VN ctest-mgmt_vn-98808540
2025-12-01 03:12:07,439 - DEBUG - VN ctest-mgmt_vn-98808540 UUID is 70d7f13a-01c4-494b-95ba-a9b9c4222c94
2025-12-01 03:12:07,523 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-01 03:12:07,878 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-01 03:12:07,918 - DEBUG - Requesting: http://10.0.0.27:8082/domain/a276f104-9d2c-4383-87cf-b8e3164113c5
2025-12-01 03:12:07,934 - DEBUG - Requesting: http://10.0.0.27:8082/project/137b1f61-d728-4a4e-8f3d-7f3152dced90
2025-12-01 03:12:08,053 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/70d7f13a-01c4-494b-95ba-a9b9c4222c94
2025-12-01 03:12:08,065 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/70d7f13a-01c4-494b-95ba-a9b9c4222c94
2025-12-01 03:12:08,075 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/3bad6874-8383-492a-804e-5a164e683ba8
2025-12-01 03:12:08,087 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/3bad6874-8383-492a-804e-5a164e683ba8
2025-12-01 03:12:08,095 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/dbc00afa-d253-4bf6-8623-dad5056a197c
2025-12-01 03:12:08,102 - DEBUG - Route Targets: ['target:64512:8000004']
2025-12-01 03:12:08,102 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/70d7f13a-01c4-494b-95ba-a9b9c4222c94
2025-12-01 03:12:08,112 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/3bad6874-8383-492a-804e-5a164e683ba8
2025-12-01 03:12:08,133 - INFO - Verified VN network id 13 for VN 70d7f13a-01c4-494b-95ba-a9b9c4222c94
2025-12-01 03:12:08,133 - INFO - Verifications in API Server for VN ctest-mgmt_vn-98808540 passed
2025-12-01 03:12:08,133 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/70d7f13a-01c4-494b-95ba-a9b9c4222c94
2025-12-01 03:12:08,149 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/3bad6874-8383-492a-804e-5a164e683ba8
2025-12-01 03:12:08,158 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/3bad6874-8383-492a-804e-5a164e683ba8
2025-12-01 03:12:08,167 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/dbc00afa-d253-4bf6-8623-dad5056a197c
2025-12-01 03:12:08,182 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-95796989:ctest-mgmt_vn-98808540', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-95796989', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8131232883680758091', 'uuid-lslong': '10789122472644062356'}, 'enable': 'true', 'created': '2025-12-01T03:12:06', 'last-modified': '2025-12-01T03:12:07', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.878855'}
2025-12-01 03:12:08,189 - DEBUG - Route Targets: ['target:64512:8000004']
2025-12-01 03:12:08,196 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-95796989:ctest-mgmt_vn-98808540', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-95796989', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8131232883680758091', 'uuid-lslong': '10789122472644062356'}, 'enable': 'true', 'created': '2025-12-01T03:12:06', 'last-modified': '2025-12-01T03:12:07', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.888638'}
2025-12-01 03:12:08,202 - DEBUG - Route Targets: ['target:64512:8000004']
2025-12-01 03:12:08,210 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-95796989:ctest-mgmt_vn-98808540', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-95796989', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8131232883680758091', 'uuid-lslong': '10789122472644062356'}, 'enable': 'true', 'created': '2025-12-01T03:12:06', 'last-modified': '2025-12-01T03:12:07', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.906591'}
2025-12-01 03:12:08,217 - DEBUG - Route Targets: ['target:64512:8000004']
2025-12-01 03:12:08,218 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-98808540 passed
2025-12-01 03:12:08,218 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-98808540 in API_Server ======
2025-12-01 03:12:08,218 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-01 03:12:08,226 - DEBUG - Requesting: http://10.0.0.27:8082/domain/a276f104-9d2c-4383-87cf-b8e3164113c5
2025-12-01 03:12:08,241 - DEBUG - Requesting: http://10.0.0.27:8082/project/137b1f61-d728-4a4e-8f3d-7f3152dced90
2025-12-01 03:12:08,346 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/70d7f13a-01c4-494b-95ba-a9b9c4222c94
2025-12-01 03:12:08,357 - DEBUG - =>VN ctest-mgmt_vn-98808540 has no policy to be verified
2025-12-01 03:12:08,357 - DEBUG - Verifying the vn in opserver
2025-12-01 03:12:08,357 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-95796989:ctest-mgmt_vn-98808540 virtual network link through opserver 10.0.0.27
2025-12-01 03:12:08,357 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2025-12-01 03:12:08,703 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2025-12-01 03:12:08,791 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-95796989:ctest-mgmt_vn-98808540', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-95796989:ctest-mgmt_vn-98808540?flat'}
2025-12-01 03:12:08,791 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-95796989:ctest-mgmt_vn-98808540 virtual network link through opserver 10.0.0.33
2025-12-01 03:12:08,791 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2025-12-01 03:12:09,142 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2025-12-01 03:12:09,229 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-95796989:ctest-mgmt_vn-98808540', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-95796989:ctest-mgmt_vn-98808540?flat'}
2025-12-01 03:12:09,229 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-95796989:ctest-mgmt_vn-98808540 virtual network link through opserver 10.0.0.23
2025-12-01 03:12:09,229 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-12-01 03:12:09,572 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-12-01 03:12:09,646 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-95796989:ctest-mgmt_vn-98808540', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-95796989:ctest-mgmt_vn-98808540?flat'}
2025-12-01 03:12:09,646 - INFO - Validated that VN default-domain:ctest-TestSvcHC-95796989:ctest-mgmt_vn-98808540 is found in opserver
2025-12-01 03:12:09,674 - DEBUG - Do not have enough data to verify VN in agent
2025-12-01 03:12:09,686 - DEBUG - VRF ids for VN ctest-mgmt_vn-98808540: {}
2025-12-01 03:12:10,034 - DEBUG - Response for create_network : {'network': {'id': 'f0748a38-cde6-46d4-b67e-645077320bac', 'name': 'ctest-left_vn-31211858', 'tenant_id': '137b1f61d7284a4e8f3d7f3152dced90', 'project_id': '137b1f61d7284a4e8f3d7f3152dced90', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-95796989', 'ctest-left_vn-31211858'], 'port_security_enabled': True, 'description': ''}}
2025-12-01 03:12:10,344 - DEBUG - Response for create_subnet : {'subnet': {'id': 'ca2c1ac8-1e08-4970-8907-7fcae1500682', 'name': '', 'tenant_id': '137b1f61d7284a4e8f3d7f3152dced90', 'network_id': 'f0748a38-cde6-46d4-b67e-645077320bac', 'ip_version': 4, 'cidr': '20.1.121.64/26', 'allocation_pools': [{'start': '20.1.121.66', 'end': '20.1.121.126'}], 'gateway_ip': '20.1.121.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '20.1.121.66', 'tags': [], 'project_id': '137b1f61d7284a4e8f3d7f3152dced90'}}
2025-12-01 03:12:10,371 - INFO - Created VN ctest-left_vn-31211858
2025-12-01 03:12:10,385 - DEBUG - VN ctest-left_vn-31211858 UUID is f0748a38-cde6-46d4-b67e-645077320bac
2025-12-01 03:12:10,469 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-01 03:12:10,477 - DEBUG - Requesting: http://10.0.0.27:8082/domain/a276f104-9d2c-4383-87cf-b8e3164113c5
2025-12-01 03:12:10,491 - DEBUG - Requesting: http://10.0.0.27:8082/project/137b1f61-d728-4a4e-8f3d-7f3152dced90
2025-12-01 03:12:10,590 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/f0748a38-cde6-46d4-b67e-645077320bac
2025-12-01 03:12:10,603 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/f0748a38-cde6-46d4-b67e-645077320bac
2025-12-01 03:12:10,614 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/3c085cdf-b3fd-4df1-973d-99bee7c8b4ca
2025-12-01 03:12:10,623 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/3c085cdf-b3fd-4df1-973d-99bee7c8b4ca
2025-12-01 03:12:10,631 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/70c358a2-feaf-4dab-8734-de8f428992e9
2025-12-01 03:12:10,639 - DEBUG - Route Targets: ['target:64512:8000006']
2025-12-01 03:12:10,639 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/f0748a38-cde6-46d4-b67e-645077320bac
2025-12-01 03:12:10,649 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/3c085cdf-b3fd-4df1-973d-99bee7c8b4ca
2025-12-01 03:12:10,670 - INFO - Verified VN network id 14 for VN f0748a38-cde6-46d4-b67e-645077320bac
2025-12-01 03:12:10,670 - INFO - Verifications in API Server for VN ctest-left_vn-31211858 passed
2025-12-01 03:12:10,670 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/f0748a38-cde6-46d4-b67e-645077320bac
2025-12-01 03:12:10,683 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/3c085cdf-b3fd-4df1-973d-99bee7c8b4ca
2025-12-01 03:12:10,692 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/3c085cdf-b3fd-4df1-973d-99bee7c8b4ca
2025-12-01 03:12:10,702 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/70c358a2-feaf-4dab-8734-de8f428992e9
2025-12-01 03:12:10,715 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-95796989:ctest-left_vn-31211858', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-95796989', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17326625642978363092', 'uuid-lslong': '13150058258728356780'}, 'enable': 'true', 'created': '2025-12-01T03:12:09', 'last-modified': '2025-12-01T03:12:10', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.447213'}
2025-12-01 03:12:10,720 - DEBUG - Route Targets: ['target:64512:8000006']
2025-12-01 03:12:10,726 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-95796989:ctest-left_vn-31211858', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-95796989', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17326625642978363092', 'uuid-lslong': '13150058258728356780'}, 'enable': 'true', 'created': '2025-12-01T03:12:09', 'last-modified': '2025-12-01T03:12:10', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.455248'}
2025-12-01 03:12:10,732 - DEBUG - Route Targets: ['target:64512:8000006']
2025-12-01 03:12:10,738 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-95796989:ctest-left_vn-31211858', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-95796989', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17326625642978363092', 'uuid-lslong': '13150058258728356780'}, 'enable': 'true', 'created': '2025-12-01T03:12:09', 'last-modified': '2025-12-01T03:12:10', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.465409'}
2025-12-01 03:12:10,745 - DEBUG - Route Targets: ['target:64512:8000006']
2025-12-01 03:12:10,745 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-31211858 passed
2025-12-01 03:12:10,745 - DEBUG - ====Verifying policy data for ctest-left_vn-31211858 in API_Server ======
2025-12-01 03:12:10,745 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-01 03:12:10,752 - DEBUG - Requesting: http://10.0.0.27:8082/domain/a276f104-9d2c-4383-87cf-b8e3164113c5
2025-12-01 03:12:10,765 - DEBUG - Requesting: http://10.0.0.27:8082/project/137b1f61-d728-4a4e-8f3d-7f3152dced90
2025-12-01 03:12:10,863 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/f0748a38-cde6-46d4-b67e-645077320bac
2025-12-01 03:12:10,874 - DEBUG - =>VN ctest-left_vn-31211858 has no policy to be verified
2025-12-01 03:12:10,874 - DEBUG - Verifying the vn in opserver
2025-12-01 03:12:10,874 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-95796989:ctest-left_vn-31211858 virtual network link through opserver 10.0.0.27
2025-12-01 03:12:10,874 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2025-12-01 03:12:10,937 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-95796989:ctest-left_vn-31211858', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-95796989:ctest-left_vn-31211858?flat'}
2025-12-01 03:12:10,938 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-95796989:ctest-left_vn-31211858 virtual network link through opserver 10.0.0.33
2025-12-01 03:12:10,938 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2025-12-01 03:12:11,015 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-95796989:ctest-left_vn-31211858', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-95796989:ctest-left_vn-31211858?flat'}
2025-12-01 03:12:11,015 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-95796989:ctest-left_vn-31211858 virtual network link through opserver 10.0.0.23
2025-12-01 03:12:11,015 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-12-01 03:12:11,087 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-95796989:ctest-left_vn-31211858', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-95796989:ctest-left_vn-31211858?flat'}
2025-12-01 03:12:11,087 - INFO - Validated that VN default-domain:ctest-TestSvcHC-95796989:ctest-left_vn-31211858 is found in opserver
2025-12-01 03:12:11,110 - DEBUG - Do not have enough data to verify VN in agent
2025-12-01 03:12:11,121 - DEBUG - VRF ids for VN ctest-left_vn-31211858: {}
2025-12-01 03:12:11,430 - DEBUG - Response for create_network : {'network': {'id': 'b33c346a-28df-4323-a6fb-6895a3570e0c', 'name': 'ctest-right_vn-57114968', 'tenant_id': '137b1f61d7284a4e8f3d7f3152dced90', 'project_id': '137b1f61d7284a4e8f3d7f3152dced90', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-95796989', 'ctest-right_vn-57114968'], 'port_security_enabled': True, 'description': ''}}
2025-12-01 03:12:11,714 - DEBUG - Response for create_subnet : {'subnet': {'id': '599f17cc-ca2b-477e-b877-c84d053b936b', 'name': '', 'tenant_id': '137b1f61d7284a4e8f3d7f3152dced90', 'network_id': 'b33c346a-28df-4323-a6fb-6895a3570e0c', 'ip_version': 4, 'cidr': '165.137.115.0/26', 'allocation_pools': [{'start': '165.137.115.2', 'end': '165.137.115.62'}], 'gateway_ip': '165.137.115.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '165.137.115.2', 'tags': [], 'project_id': '137b1f61d7284a4e8f3d7f3152dced90'}}
2025-12-01 03:12:11,741 - INFO - Created VN ctest-right_vn-57114968
2025-12-01 03:12:11,757 - DEBUG - VN ctest-right_vn-57114968 UUID is b33c346a-28df-4323-a6fb-6895a3570e0c
2025-12-01 03:12:11,922 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-01 03:12:11,929 - DEBUG - Requesting: http://10.0.0.27:8082/domain/a276f104-9d2c-4383-87cf-b8e3164113c5
2025-12-01 03:12:11,944 - DEBUG - Requesting: http://10.0.0.27:8082/project/137b1f61-d728-4a4e-8f3d-7f3152dced90
2025-12-01 03:12:12,049 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/b33c346a-28df-4323-a6fb-6895a3570e0c
2025-12-01 03:12:12,084 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/b33c346a-28df-4323-a6fb-6895a3570e0c
2025-12-01 03:12:12,096 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/434a44cb-2d7e-45f9-bb40-7e0829b5386d
2025-12-01 03:12:12,106 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/434a44cb-2d7e-45f9-bb40-7e0829b5386d
2025-12-01 03:12:12,119 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/d8a548ff-4e4b-4095-83fc-9952369a4a69
2025-12-01 03:12:12,131 - DEBUG - Route Targets: ['target:64512:8000007']
2025-12-01 03:12:12,131 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/b33c346a-28df-4323-a6fb-6895a3570e0c
2025-12-01 03:12:12,142 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/434a44cb-2d7e-45f9-bb40-7e0829b5386d
2025-12-01 03:12:12,159 - INFO - Verified VN network id 15 for VN b33c346a-28df-4323-a6fb-6895a3570e0c
2025-12-01 03:12:12,160 - INFO - Verifications in API Server for VN ctest-right_vn-57114968 passed
2025-12-01 03:12:12,160 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/b33c346a-28df-4323-a6fb-6895a3570e0c
2025-12-01 03:12:12,172 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/434a44cb-2d7e-45f9-bb40-7e0829b5386d
2025-12-01 03:12:12,180 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/434a44cb-2d7e-45f9-bb40-7e0829b5386d
2025-12-01 03:12:12,188 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/d8a548ff-4e4b-4095-83fc-9952369a4a69
2025-12-01 03:12:12,205 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-95796989:ctest-right_vn-57114968', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-95796989', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12915255461948637987', 'uuid-lslong': '12032325821350219276'}, 'enable': 'true', 'created': '2025-12-01T03:12:11', 'last-modified': '2025-12-01T03:12:11', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.570499'}
2025-12-01 03:12:12,212 - DEBUG - Route Targets: ['target:64512:8000007']
2025-12-01 03:12:12,217 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-95796989:ctest-right_vn-57114968', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-95796989', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12915255461948637987', 'uuid-lslong': '12032325821350219276'}, 'enable': 'true', 'created': '2025-12-01T03:12:11', 'last-modified': '2025-12-01T03:12:11', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.593848'}
2025-12-01 03:12:12,223 - DEBUG - Route Targets: ['target:64512:8000007']
2025-12-01 03:12:12,230 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-95796989:ctest-right_vn-57114968', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-95796989', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12915255461948637987', 'uuid-lslong': '12032325821350219276'}, 'enable': 'true', 'created': '2025-12-01T03:12:11', 'last-modified': '2025-12-01T03:12:11', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.589614'}
2025-12-01 03:12:12,239 - DEBUG - Route Targets: ['target:64512:8000007']
2025-12-01 03:12:12,239 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-57114968 passed
2025-12-01 03:12:12,239 - DEBUG - ====Verifying policy data for ctest-right_vn-57114968 in API_Server ======
2025-12-01 03:12:12,239 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-01 03:12:12,246 - DEBUG - Requesting: http://10.0.0.27:8082/domain/a276f104-9d2c-4383-87cf-b8e3164113c5
2025-12-01 03:12:12,260 - DEBUG - Requesting: http://10.0.0.27:8082/project/137b1f61-d728-4a4e-8f3d-7f3152dced90
2025-12-01 03:12:12,360 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/b33c346a-28df-4323-a6fb-6895a3570e0c
2025-12-01 03:12:12,371 - DEBUG - =>VN ctest-right_vn-57114968 has no policy to be verified
2025-12-01 03:12:12,371 - DEBUG - Verifying the vn in opserver
2025-12-01 03:12:12,371 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-95796989:ctest-right_vn-57114968 virtual network link through opserver 10.0.0.27
2025-12-01 03:12:12,371 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2025-12-01 03:12:12,434 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-95796989:ctest-right_vn-57114968', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-95796989:ctest-right_vn-57114968?flat'}
2025-12-01 03:12:12,434 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-95796989:ctest-right_vn-57114968 virtual network link through opserver 10.0.0.33
2025-12-01 03:12:12,434 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2025-12-01 03:12:12,503 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-95796989:ctest-right_vn-57114968', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-95796989:ctest-right_vn-57114968?flat'}
2025-12-01 03:12:12,503 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-95796989:ctest-right_vn-57114968 virtual network link through opserver 10.0.0.23
2025-12-01 03:12:12,503 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-12-01 03:12:12,568 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-95796989:ctest-right_vn-57114968', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-95796989:ctest-right_vn-57114968?flat'}
2025-12-01 03:12:12,568 - INFO - Validated that VN default-domain:ctest-TestSvcHC-95796989:ctest-right_vn-57114968 is found in opserver
2025-12-01 03:12:12,590 - DEBUG - Do not have enough data to verify VN in agent
2025-12-01 03:12:12,600 - DEBUG - VRF ids for VN ctest-right_vn-57114968: {}
2025-12-01 03:12:12,673 - DEBUG - Services list from nova: [, , , ]
2025-12-01 03:12:14,018 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4827-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4827-1)
2025-12-01 03:12:15,506 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4827-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4827-2)
2025-12-01 03:12:15,506 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-46699646']
2025-12-01 03:12:15,814 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-46699646'] created succesfully
2025-12-01 03:12:16,191 - DEBUG - Image by name tiny_nat_fw not found
2025-12-01 03:12:16,191 - DEBUG - Installing image tiny_nat_fw
2025-12-01 03:12:16,191 - 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-12-01 03:12:16,191 - DEBUG - Image build path file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2025-12-01 03:12:16,191 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2025-12-01 03:12:16,191 - DEBUG - Unzip image
2025-12-01 03:12:16,192 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2025-12-01 03:12:16,215 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2025-12-01 03:12:16,215 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-46699646']
2025-12-01 03:12:16,325 - INFO - Service template: ['default-domain', 'ctest-service_template_1-46699646'] deleted successfully.
2025-12-01 03:12:16,326 - INFO - Skip interface_detach for VM ctest-right_vm-92678147 in state BUILD
2025-12-01 03:12:16,326 - INFO - Deleting VM ctest-right_vm-92678147
2025-12-01 03:12:16,364 - ERROR - VM ctest-right_vm-92678147 has failed to come up
2025-12-01 03:12:16,364 - ERROR - Nova failed to get host of the VM
2025-12-01 03:12:16,364 - ERROR - VM ctest-right_vm-92678147 has failed to come up
2025-12-01 03:12:16,364 - ERROR - Nova failed to get host of the VM
2025-12-01 03:12:16,493 - INFO - Skip interface_detach for VM ctest-left_vm-57380065 in state BUILD
2025-12-01 03:12:16,493 - INFO - Deleting VM ctest-left_vm-57380065
2025-12-01 03:12:16,493 - ERROR - VM ctest-left_vm-57380065 has failed to come up
2025-12-01 03:12:16,494 - ERROR - Nova failed to get host of the VM
2025-12-01 03:12:16,494 - ERROR - VM ctest-left_vm-57380065 has failed to come up
2025-12-01 03:12:16,494 - ERROR - Nova failed to get host of the VM
2025-12-01 03:12:16,574 - INFO - Deleting VN ctest-right_vn-57114968
2025-12-01 03:12:16,632 - DEBUG - VN b33c346a-28df-4323-a6fb-6895a3570e0c still in use: Unable to complete operation on network b33c346a-28df-4323-a6fb-6895a3570e0c. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-8aacec64-bed3-4f61-ba73-0e62126b89e6']
2025-12-01 03:12:16,632 - WARNING - Deleting VN ctest-right_vn-57114968 failed..Will retry
2025-12-01 03:12:18,803 - DEBUG - Response for deleting network ()
2025-12-01 03:12:18,803 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/434a44cb-2d7e-45f9-bb40-7e0829b5386d
2025-12-01 03:12:18,810 - DEBUG - Response Code: 404
2025-12-01 03:12:18,810 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-01 03:12:18,824 - DEBUG - Requesting: http://10.0.0.27:8082/domain/a276f104-9d2c-4383-87cf-b8e3164113c5
2025-12-01 03:12:18,849 - DEBUG - Requesting: http://10.0.0.27:8082/project/137b1f61-d728-4a4e-8f3d-7f3152dced90
2025-12-01 03:12:18,988 - INFO - Validated that VN ctest-right_vn-57114968 is not found in API Server
2025-12-01 03:12:18,999 - DEBUG - VN ctest-right_vn-57114968 is not present in Agent 10.0.0.22
2025-12-01 03:12:19,011 - DEBUG - VN ctest-right_vn-57114968 is not present in Agent 10.0.0.241
2025-12-01 03:12:19,011 - INFO - Validated that VN ctest-right_vn-57114968 is not in any agent
2025-12-01 03:12:19,046 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-57114968 info
2025-12-01 03:12:19,046 - INFO - Deleting VN ctest-left_vn-31211858
2025-12-01 03:12:19,231 - DEBUG - Response for deleting network ()
2025-12-01 03:12:19,232 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/3c085cdf-b3fd-4df1-973d-99bee7c8b4ca
2025-12-01 03:12:19,238 - DEBUG - Response Code: 404
2025-12-01 03:12:19,239 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-01 03:12:19,246 - DEBUG - Requesting: http://10.0.0.27:8082/domain/a276f104-9d2c-4383-87cf-b8e3164113c5
2025-12-01 03:12:19,275 - DEBUG - Requesting: http://10.0.0.27:8082/project/137b1f61-d728-4a4e-8f3d-7f3152dced90
2025-12-01 03:12:19,366 - INFO - Validated that VN ctest-left_vn-31211858 is not found in API Server
2025-12-01 03:12:19,384 - DEBUG - VN ctest-left_vn-31211858 is not present in Agent 10.0.0.22
2025-12-01 03:12:19,398 - DEBUG - VN ctest-left_vn-31211858 is not present in Agent 10.0.0.241
2025-12-01 03:12:19,398 - INFO - Validated that VN ctest-left_vn-31211858 is not in any agent
2025-12-01 03:12:19,438 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-31211858 info
2025-12-01 03:12:19,438 - INFO - Deleting VN ctest-mgmt_vn-98808540
2025-12-01 03:12:19,662 - DEBUG - Response for deleting network ()
2025-12-01 03:12:19,662 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/3bad6874-8383-492a-804e-5a164e683ba8
2025-12-01 03:12:19,669 - DEBUG - Response Code: 404
2025-12-01 03:12:19,669 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-01 03:12:19,676 - DEBUG - Requesting: http://10.0.0.27:8082/domain/a276f104-9d2c-4383-87cf-b8e3164113c5
2025-12-01 03:12:19,736 - DEBUG - Requesting: http://10.0.0.27:8082/project/137b1f61-d728-4a4e-8f3d-7f3152dced90
2025-12-01 03:12:19,836 - INFO - Validated that VN ctest-mgmt_vn-98808540 is not found in API Server
2025-12-01 03:12:19,848 - DEBUG - VN ctest-mgmt_vn-98808540 is not present in Agent 10.0.0.22
2025-12-01 03:12:19,864 - DEBUG - VN ctest-mgmt_vn-98808540 is not present in Agent 10.0.0.241
2025-12-01 03:12:19,864 - INFO - Validated that VN ctest-mgmt_vn-98808540 is not in any agent
2025-12-01 03:12:19,900 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-98808540 info
2025-12-01 03:12:21,197 - DEBUG - No XMPP flaps were noticed during the test
2025-12-01 03:12:21,197 - INFO -
2025-12-01 03:12:21,197 - INFO - END TEST : test_svc_hc_basic : SKIPPED[0:00:17]
2025-12-01 03:12:21,197 - INFO - --------------------------------------------------------------------------------
2025-12-01 03:12:21,203 - INFO - ================================================================================
2025-12-01 03:12:21,203 - INFO - STARTING TEST : test_svc_trans_segment_right_hc_fail_svm
2025-12-01 03:12:22,495 - DEBUG - Nothing to compare xmpp stats {'10.0.0.22': {'10.20.0.209': '0', '10.20.0.192': '0'}, '10.0.0.241': {'10.20.0.209': '0', '10.20.0.192': '0'}} with
2025-12-01 03:12:22,495 - INFO - Initial checks done. Running the testcase now
2025-12-01 03:12:22,495 - INFO -
2025-12-01 03:12:22,788 - DEBUG - Response for create_network : {'network': {'id': '5586564b-a1ee-4303-b9d6-283ada45852e', 'name': 'ctest-mgmt_vn-68367196', 'tenant_id': '137b1f61d7284a4e8f3d7f3152dced90', 'project_id': '137b1f61d7284a4e8f3d7f3152dced90', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-95796989', 'ctest-mgmt_vn-68367196'], 'port_security_enabled': True, 'description': ''}}
2025-12-01 03:12:23,042 - DEBUG - Response for create_subnet : {'subnet': {'id': '53b39134-3521-46df-ab3c-c3a3c4d278ba', 'name': '', 'tenant_id': '137b1f61d7284a4e8f3d7f3152dced90', 'network_id': '5586564b-a1ee-4303-b9d6-283ada45852e', 'ip_version': 4, 'cidr': '130.106.239.0/26', 'allocation_pools': [{'start': '130.106.239.2', 'end': '130.106.239.62'}], 'gateway_ip': '130.106.239.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '130.106.239.2', 'tags': [], 'project_id': '137b1f61d7284a4e8f3d7f3152dced90'}}
2025-12-01 03:12:23,069 - INFO - Created VN ctest-mgmt_vn-68367196
2025-12-01 03:12:23,085 - DEBUG - VN ctest-mgmt_vn-68367196 UUID is 5586564b-a1ee-4303-b9d6-283ada45852e
2025-12-01 03:12:23,168 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-01 03:12:23,175 - DEBUG - Requesting: http://10.0.0.27:8082/domain/a276f104-9d2c-4383-87cf-b8e3164113c5
2025-12-01 03:12:23,193 - DEBUG - Requesting: http://10.0.0.27:8082/project/137b1f61-d728-4a4e-8f3d-7f3152dced90
2025-12-01 03:12:23,295 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/5586564b-a1ee-4303-b9d6-283ada45852e
2025-12-01 03:12:23,310 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/5586564b-a1ee-4303-b9d6-283ada45852e
2025-12-01 03:12:23,324 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/28027f12-c246-4158-b25d-4b2dfb78d251
2025-12-01 03:12:23,335 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/28027f12-c246-4158-b25d-4b2dfb78d251
2025-12-01 03:12:23,344 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/9ac3c27e-a7b4-4ac3-a59b-b35b67546392
2025-12-01 03:12:23,353 - DEBUG - Route Targets: ['target:64512:8000004']
2025-12-01 03:12:23,353 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/5586564b-a1ee-4303-b9d6-283ada45852e
2025-12-01 03:12:23,364 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/28027f12-c246-4158-b25d-4b2dfb78d251
2025-12-01 03:12:23,382 - INFO - Verified VN network id 13 for VN 5586564b-a1ee-4303-b9d6-283ada45852e
2025-12-01 03:12:23,382 - INFO - Verifications in API Server for VN ctest-mgmt_vn-68367196 passed
2025-12-01 03:12:23,382 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/5586564b-a1ee-4303-b9d6-283ada45852e
2025-12-01 03:12:23,393 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/28027f12-c246-4158-b25d-4b2dfb78d251
2025-12-01 03:12:23,403 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/28027f12-c246-4158-b25d-4b2dfb78d251
2025-12-01 03:12:23,411 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/9ac3c27e-a7b4-4ac3-a59b-b35b67546392
2025-12-01 03:12:23,425 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-95796989:ctest-mgmt_vn-68367196', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-95796989', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6162708022942384899', 'uuid-lslong': '13390934775267951918'}, 'enable': 'true', 'created': '2025-12-01T03:12:22', 'last-modified': '2025-12-01T03:12:22', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.458151'}
2025-12-01 03:12:23,432 - DEBUG - Route Targets: ['target:64512:8000004']
2025-12-01 03:12:23,438 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-95796989:ctest-mgmt_vn-68367196', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-95796989', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6162708022942384899', 'uuid-lslong': '13390934775267951918'}, 'enable': 'true', 'created': '2025-12-01T03:12:22', 'last-modified': '2025-12-01T03:12:22', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.470705'}
2025-12-01 03:12:23,444 - DEBUG - Route Targets: ['target:64512:8000004']
2025-12-01 03:12:23,450 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-95796989:ctest-mgmt_vn-68367196', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-95796989', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6162708022942384899', 'uuid-lslong': '13390934775267951918'}, 'enable': 'true', 'created': '2025-12-01T03:12:22', 'last-modified': '2025-12-01T03:12:22', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.476189'}
2025-12-01 03:12:23,457 - DEBUG - Route Targets: ['target:64512:8000004']
2025-12-01 03:12:23,457 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-68367196 passed
2025-12-01 03:12:23,457 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-68367196 in API_Server ======
2025-12-01 03:12:23,458 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-01 03:12:23,465 - DEBUG - Requesting: http://10.0.0.27:8082/domain/a276f104-9d2c-4383-87cf-b8e3164113c5
2025-12-01 03:12:23,478 - DEBUG - Requesting: http://10.0.0.27:8082/project/137b1f61-d728-4a4e-8f3d-7f3152dced90
2025-12-01 03:12:23,590 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/5586564b-a1ee-4303-b9d6-283ada45852e
2025-12-01 03:12:23,605 - DEBUG - =>VN ctest-mgmt_vn-68367196 has no policy to be verified
2025-12-01 03:12:23,605 - DEBUG - Verifying the vn in opserver
2025-12-01 03:12:23,605 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-95796989:ctest-mgmt_vn-68367196 virtual network link through opserver 10.0.0.27
2025-12-01 03:12:23,605 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2025-12-01 03:12:23,619 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-95796989:ctest-mgmt_vn-68367196', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-95796989:ctest-mgmt_vn-68367196?flat'}
2025-12-01 03:12:23,619 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-95796989:ctest-mgmt_vn-68367196 virtual network link through opserver 10.0.0.33
2025-12-01 03:12:23,619 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2025-12-01 03:12:23,634 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-95796989:ctest-mgmt_vn-68367196', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-95796989:ctest-mgmt_vn-68367196?flat'}
2025-12-01 03:12:23,634 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-95796989:ctest-mgmt_vn-68367196 virtual network link through opserver 10.0.0.23
2025-12-01 03:12:23,634 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-12-01 03:12:23,648 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-95796989:ctest-mgmt_vn-68367196', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-95796989:ctest-mgmt_vn-68367196?flat'}
2025-12-01 03:12:23,648 - INFO - Validated that VN default-domain:ctest-TestSvcHC-95796989:ctest-mgmt_vn-68367196 is found in opserver
2025-12-01 03:12:23,680 - DEBUG - Do not have enough data to verify VN in agent
2025-12-01 03:12:23,692 - DEBUG - VRF ids for VN ctest-mgmt_vn-68367196: {}
2025-12-01 03:12:24,005 - DEBUG - Response for create_network : {'network': {'id': 'faf9fe4a-e42f-4a5c-b349-76043d456d2e', 'name': 'ctest-left_vn-12691929', 'tenant_id': '137b1f61d7284a4e8f3d7f3152dced90', 'project_id': '137b1f61d7284a4e8f3d7f3152dced90', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-95796989', 'ctest-left_vn-12691929'], 'port_security_enabled': True, 'description': ''}}
2025-12-01 03:12:24,259 - DEBUG - Response for create_subnet : {'subnet': {'id': '370e21b8-77b9-4e95-98ee-856fcfb867f1', 'name': '', 'tenant_id': '137b1f61d7284a4e8f3d7f3152dced90', 'network_id': 'faf9fe4a-e42f-4a5c-b349-76043d456d2e', 'ip_version': 4, 'cidr': '41.169.168.64/26', 'allocation_pools': [{'start': '41.169.168.66', 'end': '41.169.168.126'}], 'gateway_ip': '41.169.168.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '41.169.168.66', 'tags': [], 'project_id': '137b1f61d7284a4e8f3d7f3152dced90'}}
2025-12-01 03:12:24,288 - INFO - Created VN ctest-left_vn-12691929
2025-12-01 03:12:24,300 - DEBUG - VN ctest-left_vn-12691929 UUID is faf9fe4a-e42f-4a5c-b349-76043d456d2e
2025-12-01 03:12:24,395 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-01 03:12:24,404 - DEBUG - Requesting: http://10.0.0.27:8082/domain/a276f104-9d2c-4383-87cf-b8e3164113c5
2025-12-01 03:12:24,417 - DEBUG - Requesting: http://10.0.0.27:8082/project/137b1f61-d728-4a4e-8f3d-7f3152dced90
2025-12-01 03:12:24,528 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/faf9fe4a-e42f-4a5c-b349-76043d456d2e
2025-12-01 03:12:24,540 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/faf9fe4a-e42f-4a5c-b349-76043d456d2e
2025-12-01 03:12:24,550 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/2b7fb4d7-2147-4a23-9022-49bac25537d4
2025-12-01 03:12:24,560 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/2b7fb4d7-2147-4a23-9022-49bac25537d4
2025-12-01 03:12:24,568 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/604eaaf3-cff6-42e2-9b73-44f2a0a41fd4
2025-12-01 03:12:24,576 - DEBUG - Route Targets: ['target:64512:8000006']
2025-12-01 03:12:24,576 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/faf9fe4a-e42f-4a5c-b349-76043d456d2e
2025-12-01 03:12:24,586 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/2b7fb4d7-2147-4a23-9022-49bac25537d4
2025-12-01 03:12:24,602 - INFO - Verified VN network id 14 for VN faf9fe4a-e42f-4a5c-b349-76043d456d2e
2025-12-01 03:12:24,602 - INFO - Verifications in API Server for VN ctest-left_vn-12691929 passed
2025-12-01 03:12:24,603 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/faf9fe4a-e42f-4a5c-b349-76043d456d2e
2025-12-01 03:12:24,613 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/2b7fb4d7-2147-4a23-9022-49bac25537d4
2025-12-01 03:12:24,621 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/2b7fb4d7-2147-4a23-9022-49bac25537d4
2025-12-01 03:12:24,628 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/604eaaf3-cff6-42e2-9b73-44f2a0a41fd4
2025-12-01 03:12:24,641 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-95796989:ctest-left_vn-12691929', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-95796989', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '18084765376292276828', 'uuid-lslong': '12918986766668885294'}, 'enable': 'true', 'created': '2025-12-01T03:12:23', 'last-modified': '2025-12-01T03:12:24', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.442309'}
2025-12-01 03:12:24,649 - DEBUG - Route Targets: ['target:64512:8000006']
2025-12-01 03:12:24,654 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-95796989:ctest-left_vn-12691929', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-95796989', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '18084765376292276828', 'uuid-lslong': '12918986766668885294'}, 'enable': 'true', 'created': '2025-12-01T03:12:23', 'last-modified': '2025-12-01T03:12:24', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.455009'}
2025-12-01 03:12:24,660 - DEBUG - Route Targets: ['target:64512:8000006']
2025-12-01 03:12:24,666 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-95796989:ctest-left_vn-12691929', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-95796989', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '18084765376292276828', 'uuid-lslong': '12918986766668885294'}, 'enable': 'true', 'created': '2025-12-01T03:12:23', 'last-modified': '2025-12-01T03:12:24', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.457231'}
2025-12-01 03:12:24,673 - DEBUG - Route Targets: ['target:64512:8000006']
2025-12-01 03:12:24,673 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-12691929 passed
2025-12-01 03:12:24,673 - DEBUG - ====Verifying policy data for ctest-left_vn-12691929 in API_Server ======
2025-12-01 03:12:24,673 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-01 03:12:24,681 - DEBUG - Requesting: http://10.0.0.27:8082/domain/a276f104-9d2c-4383-87cf-b8e3164113c5
2025-12-01 03:12:24,693 - DEBUG - Requesting: http://10.0.0.27:8082/project/137b1f61-d728-4a4e-8f3d-7f3152dced90
2025-12-01 03:12:24,793 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/faf9fe4a-e42f-4a5c-b349-76043d456d2e
2025-12-01 03:12:24,806 - DEBUG - =>VN ctest-left_vn-12691929 has no policy to be verified
2025-12-01 03:12:24,806 - DEBUG - Verifying the vn in opserver
2025-12-01 03:12:24,806 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-95796989:ctest-left_vn-12691929 virtual network link through opserver 10.0.0.27
2025-12-01 03:12:24,806 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2025-12-01 03:12:24,820 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-95796989:ctest-left_vn-12691929', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-95796989:ctest-left_vn-12691929?flat'}
2025-12-01 03:12:24,820 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-95796989:ctest-left_vn-12691929 virtual network link through opserver 10.0.0.33
2025-12-01 03:12:24,820 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2025-12-01 03:12:24,833 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-95796989:ctest-left_vn-12691929', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-95796989:ctest-left_vn-12691929?flat'}
2025-12-01 03:12:24,833 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-95796989:ctest-left_vn-12691929 virtual network link through opserver 10.0.0.23
2025-12-01 03:12:24,833 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-12-01 03:12:24,849 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-95796989:ctest-left_vn-12691929', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-95796989:ctest-left_vn-12691929?flat'}
2025-12-01 03:12:24,849 - INFO - Validated that VN default-domain:ctest-TestSvcHC-95796989:ctest-left_vn-12691929 is found in opserver
2025-12-01 03:12:24,871 - DEBUG - Do not have enough data to verify VN in agent
2025-12-01 03:12:24,884 - DEBUG - VRF ids for VN ctest-left_vn-12691929: {}
2025-12-01 03:12:25,172 - DEBUG - Response for create_network : {'network': {'id': 'b03fb013-1bba-47d7-aeb6-ea7c976e5993', 'name': 'ctest-right_vn-46675944', 'tenant_id': '137b1f61d7284a4e8f3d7f3152dced90', 'project_id': '137b1f61d7284a4e8f3d7f3152dced90', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-95796989', 'ctest-right_vn-46675944'], 'port_security_enabled': True, 'description': ''}}
2025-12-01 03:12:25,467 - DEBUG - Response for create_subnet : {'subnet': {'id': '22428280-ff2f-4a0d-8cd6-2a095fdfef34', 'name': '', 'tenant_id': '137b1f61d7284a4e8f3d7f3152dced90', 'network_id': 'b03fb013-1bba-47d7-aeb6-ea7c976e5993', 'ip_version': 4, 'cidr': '46.77.210.64/26', 'allocation_pools': [{'start': '46.77.210.66', 'end': '46.77.210.126'}], 'gateway_ip': '46.77.210.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '46.77.210.66', 'tags': [], 'project_id': '137b1f61d7284a4e8f3d7f3152dced90'}}
2025-12-01 03:12:25,494 - INFO - Created VN ctest-right_vn-46675944
2025-12-01 03:12:25,510 - DEBUG - VN ctest-right_vn-46675944 UUID is b03fb013-1bba-47d7-aeb6-ea7c976e5993
2025-12-01 03:12:25,590 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-01 03:12:25,598 - DEBUG - Requesting: http://10.0.0.27:8082/domain/a276f104-9d2c-4383-87cf-b8e3164113c5
2025-12-01 03:12:25,614 - DEBUG - Requesting: http://10.0.0.27:8082/project/137b1f61-d728-4a4e-8f3d-7f3152dced90
2025-12-01 03:12:25,706 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/b03fb013-1bba-47d7-aeb6-ea7c976e5993
2025-12-01 03:12:25,730 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/b03fb013-1bba-47d7-aeb6-ea7c976e5993
2025-12-01 03:12:25,742 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/ac489da9-4291-4270-a9d6-9f3ed0e1e9e5
2025-12-01 03:12:25,750 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/ac489da9-4291-4270-a9d6-9f3ed0e1e9e5
2025-12-01 03:12:25,759 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/a8fd6919-975c-413a-8212-ad2fc4408b42
2025-12-01 03:12:25,767 - DEBUG - Route Targets: ['target:64512:8000007']
2025-12-01 03:12:25,767 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/b03fb013-1bba-47d7-aeb6-ea7c976e5993
2025-12-01 03:12:25,777 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/ac489da9-4291-4270-a9d6-9f3ed0e1e9e5
2025-12-01 03:12:25,793 - INFO - Verified VN network id 15 for VN b03fb013-1bba-47d7-aeb6-ea7c976e5993
2025-12-01 03:12:25,793 - INFO - Verifications in API Server for VN ctest-right_vn-46675944 passed
2025-12-01 03:12:25,793 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/b03fb013-1bba-47d7-aeb6-ea7c976e5993
2025-12-01 03:12:25,805 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/ac489da9-4291-4270-a9d6-9f3ed0e1e9e5
2025-12-01 03:12:25,820 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/ac489da9-4291-4270-a9d6-9f3ed0e1e9e5
2025-12-01 03:12:25,831 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/a8fd6919-975c-413a-8212-ad2fc4408b42
2025-12-01 03:12:25,846 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-95796989:ctest-right_vn-46675944', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-95796989', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12700063070324148183', 'uuid-lslong': '12589507629198236051'}, 'enable': 'true', 'created': '2025-12-01T03:12:25', 'last-modified': '2025-12-01T03:12:25', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.438380'}
2025-12-01 03:12:25,854 - DEBUG - Route Targets: ['target:64512:8000007']
2025-12-01 03:12:25,861 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-95796989:ctest-right_vn-46675944', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-95796989', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12700063070324148183', 'uuid-lslong': '12589507629198236051'}, 'enable': 'true', 'created': '2025-12-01T03:12:25', 'last-modified': '2025-12-01T03:12:25', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.455175'}
2025-12-01 03:12:25,867 - DEBUG - Route Targets: ['target:64512:8000007']
2025-12-01 03:12:25,873 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-95796989:ctest-right_vn-46675944', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-95796989', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12700063070324148183', 'uuid-lslong': '12589507629198236051'}, 'enable': 'true', 'created': '2025-12-01T03:12:25', 'last-modified': '2025-12-01T03:12:25', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.467824'}
2025-12-01 03:12:25,879 - DEBUG - Route Targets: ['target:64512:8000007']
2025-12-01 03:12:25,879 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-46675944 passed
2025-12-01 03:12:25,880 - DEBUG - ====Verifying policy data for ctest-right_vn-46675944 in API_Server ======
2025-12-01 03:12:25,880 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-01 03:12:25,888 - DEBUG - Requesting: http://10.0.0.27:8082/domain/a276f104-9d2c-4383-87cf-b8e3164113c5
2025-12-01 03:12:25,904 - DEBUG - Requesting: http://10.0.0.27:8082/project/137b1f61-d728-4a4e-8f3d-7f3152dced90
2025-12-01 03:12:26,012 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/b03fb013-1bba-47d7-aeb6-ea7c976e5993
2025-12-01 03:12:26,027 - DEBUG - =>VN ctest-right_vn-46675944 has no policy to be verified
2025-12-01 03:12:26,027 - DEBUG - Verifying the vn in opserver
2025-12-01 03:12:26,027 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-95796989:ctest-right_vn-46675944 virtual network link through opserver 10.0.0.27
2025-12-01 03:12:26,027 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2025-12-01 03:12:26,041 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-95796989:ctest-right_vn-46675944', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-95796989:ctest-right_vn-46675944?flat'}
2025-12-01 03:12:26,041 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-95796989:ctest-right_vn-46675944 virtual network link through opserver 10.0.0.33
2025-12-01 03:12:26,041 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2025-12-01 03:12:26,055 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-95796989:ctest-right_vn-46675944', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-95796989:ctest-right_vn-46675944?flat'}
2025-12-01 03:12:26,055 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-95796989:ctest-right_vn-46675944 virtual network link through opserver 10.0.0.23
2025-12-01 03:12:26,055 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-12-01 03:12:26,070 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-95796989:ctest-right_vn-46675944', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-95796989:ctest-right_vn-46675944?flat'}
2025-12-01 03:12:26,070 - INFO - Validated that VN default-domain:ctest-TestSvcHC-95796989:ctest-right_vn-46675944 is found in opserver
2025-12-01 03:12:26,096 - DEBUG - Do not have enough data to verify VN in agent
2025-12-01 03:12:26,107 - DEBUG - VRF ids for VN ctest-right_vn-46675944: {}
2025-12-01 03:12:26,399 - DEBUG - Response for create_network : {'network': {'id': '5059886f-558c-4e64-9410-db5bbad09fce', 'name': 'ctest-trans_left_vn-95184732', 'tenant_id': '137b1f61d7284a4e8f3d7f3152dced90', 'project_id': '137b1f61d7284a4e8f3d7f3152dced90', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-95796989', 'ctest-trans_left_vn-95184732'], 'port_security_enabled': True, 'description': ''}}
2025-12-01 03:12:26,675 - DEBUG - Response for create_subnet : {'subnet': {'id': '6c2daa4c-5b56-4a6f-95db-b8989a081793', 'name': '', 'tenant_id': '137b1f61d7284a4e8f3d7f3152dced90', 'network_id': '5059886f-558c-4e64-9410-db5bbad09fce', 'ip_version': 4, 'cidr': '166.87.210.128/26', 'allocation_pools': [{'start': '166.87.210.130', 'end': '166.87.210.190'}], 'gateway_ip': '166.87.210.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '166.87.210.130', 'tags': [], 'project_id': '137b1f61d7284a4e8f3d7f3152dced90'}}
2025-12-01 03:12:26,711 - INFO - Created VN ctest-trans_left_vn-95184732
2025-12-01 03:12:26,733 - DEBUG - VN ctest-trans_left_vn-95184732 UUID is 5059886f-558c-4e64-9410-db5bbad09fce
2025-12-01 03:12:26,810 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-01 03:12:26,817 - DEBUG - Requesting: http://10.0.0.27:8082/domain/a276f104-9d2c-4383-87cf-b8e3164113c5
2025-12-01 03:12:26,829 - DEBUG - Requesting: http://10.0.0.27:8082/project/137b1f61-d728-4a4e-8f3d-7f3152dced90
2025-12-01 03:12:26,940 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/5059886f-558c-4e64-9410-db5bbad09fce
2025-12-01 03:12:26,958 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/5059886f-558c-4e64-9410-db5bbad09fce
2025-12-01 03:12:26,969 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/ae3144cd-22f6-4587-8aa9-9dcbc845b21b
2025-12-01 03:12:26,978 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/ae3144cd-22f6-4587-8aa9-9dcbc845b21b
2025-12-01 03:12:26,986 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/9374f996-dcec-4dc1-b11c-5f2f3f151397
2025-12-01 03:12:26,993 - DEBUG - Route Targets: ['target:64512:8000008']
2025-12-01 03:12:26,993 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/5059886f-558c-4e64-9410-db5bbad09fce
2025-12-01 03:12:27,003 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/ae3144cd-22f6-4587-8aa9-9dcbc845b21b
2025-12-01 03:12:27,020 - INFO - Verified VN network id 16 for VN 5059886f-558c-4e64-9410-db5bbad09fce
2025-12-01 03:12:27,021 - INFO - Verifications in API Server for VN ctest-trans_left_vn-95184732 passed
2025-12-01 03:12:27,021 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/5059886f-558c-4e64-9410-db5bbad09fce
2025-12-01 03:12:27,032 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/ae3144cd-22f6-4587-8aa9-9dcbc845b21b
2025-12-01 03:12:27,040 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/ae3144cd-22f6-4587-8aa9-9dcbc845b21b
2025-12-01 03:12:27,047 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/9374f996-dcec-4dc1-b11c-5f2f3f151397
2025-12-01 03:12:27,064 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-95796989:ctest-trans_left_vn-95184732', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-95796989', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5789808807719489124', 'uuid-lslong': '10669268704263446478'}, 'enable': 'true', 'created': '2025-12-01T03:12:26', 'last-modified': '2025-12-01T03:12:26', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.463061'}
2025-12-01 03:12:27,071 - DEBUG - Route Targets: ['target:64512:8000008']
2025-12-01 03:12:27,077 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-95796989:ctest-trans_left_vn-95184732', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-95796989', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5789808807719489124', 'uuid-lslong': '10669268704263446478'}, 'enable': 'true', 'created': '2025-12-01T03:12:26', 'last-modified': '2025-12-01T03:12:26', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.476945'}
2025-12-01 03:12:27,083 - DEBUG - Route Targets: ['target:64512:8000008']
2025-12-01 03:12:27,089 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-95796989:ctest-trans_left_vn-95184732', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-95796989', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5789808807719489124', 'uuid-lslong': '10669268704263446478'}, 'enable': 'true', 'created': '2025-12-01T03:12:26', 'last-modified': '2025-12-01T03:12:26', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.489825'}
2025-12-01 03:12:27,096 - DEBUG - Route Targets: ['target:64512:8000008']
2025-12-01 03:12:27,096 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_left_vn-95184732 passed
2025-12-01 03:12:27,096 - DEBUG - ====Verifying policy data for ctest-trans_left_vn-95184732 in API_Server ======
2025-12-01 03:12:27,096 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-01 03:12:27,103 - DEBUG - Requesting: http://10.0.0.27:8082/domain/a276f104-9d2c-4383-87cf-b8e3164113c5
2025-12-01 03:12:27,118 - DEBUG - Requesting: http://10.0.0.27:8082/project/137b1f61-d728-4a4e-8f3d-7f3152dced90
2025-12-01 03:12:27,222 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/5059886f-558c-4e64-9410-db5bbad09fce
2025-12-01 03:12:27,237 - DEBUG - =>VN ctest-trans_left_vn-95184732 has no policy to be verified
2025-12-01 03:12:27,237 - DEBUG - Verifying the vn in opserver
2025-12-01 03:12:27,237 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-95796989:ctest-trans_left_vn-95184732 virtual network link through opserver 10.0.0.27
2025-12-01 03:12:27,237 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2025-12-01 03:12:27,251 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-95796989:ctest-trans_left_vn-95184732', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-95796989:ctest-trans_left_vn-95184732?flat'}
2025-12-01 03:12:27,251 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-95796989:ctest-trans_left_vn-95184732 virtual network link through opserver 10.0.0.33
2025-12-01 03:12:27,251 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2025-12-01 03:12:27,267 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-95796989:ctest-trans_left_vn-95184732', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-95796989:ctest-trans_left_vn-95184732?flat'}
2025-12-01 03:12:27,267 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-95796989:ctest-trans_left_vn-95184732 virtual network link through opserver 10.0.0.23
2025-12-01 03:12:27,267 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-12-01 03:12:27,286 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-95796989:ctest-trans_left_vn-95184732', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-95796989:ctest-trans_left_vn-95184732?flat'}
2025-12-01 03:12:27,286 - INFO - Validated that VN default-domain:ctest-TestSvcHC-95796989:ctest-trans_left_vn-95184732 is found in opserver
2025-12-01 03:12:27,310 - DEBUG - Do not have enough data to verify VN in agent
2025-12-01 03:12:27,321 - DEBUG - VRF ids for VN ctest-trans_left_vn-95184732: {}
2025-12-01 03:12:27,635 - DEBUG - Response for create_network : {'network': {'id': '04867f8e-2f5b-4503-9995-8bf6ef366c00', 'name': 'ctest-trans_right_vn-82727794', 'tenant_id': '137b1f61d7284a4e8f3d7f3152dced90', 'project_id': '137b1f61d7284a4e8f3d7f3152dced90', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-95796989', 'ctest-trans_right_vn-82727794'], 'port_security_enabled': True, 'description': ''}}
2025-12-01 03:12:27,909 - DEBUG - Response for create_subnet : {'subnet': {'id': 'ad46e0e1-027c-4ae0-bd7b-39ed2ff8c8cb', 'name': '', 'tenant_id': '137b1f61d7284a4e8f3d7f3152dced90', 'network_id': '04867f8e-2f5b-4503-9995-8bf6ef366c00', 'ip_version': 4, 'cidr': '45.59.82.128/26', 'allocation_pools': [{'start': '45.59.82.130', 'end': '45.59.82.190'}], 'gateway_ip': '45.59.82.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '45.59.82.130', 'tags': [], 'project_id': '137b1f61d7284a4e8f3d7f3152dced90'}}
2025-12-01 03:12:27,943 - INFO - Created VN ctest-trans_right_vn-82727794
2025-12-01 03:12:27,957 - DEBUG - VN ctest-trans_right_vn-82727794 UUID is 04867f8e-2f5b-4503-9995-8bf6ef366c00
2025-12-01 03:12:28,043 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-01 03:12:28,049 - DEBUG - Requesting: http://10.0.0.27:8082/domain/a276f104-9d2c-4383-87cf-b8e3164113c5
2025-12-01 03:12:28,060 - DEBUG - Requesting: http://10.0.0.27:8082/project/137b1f61-d728-4a4e-8f3d-7f3152dced90
2025-12-01 03:12:28,158 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/04867f8e-2f5b-4503-9995-8bf6ef366c00
2025-12-01 03:12:28,170 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/04867f8e-2f5b-4503-9995-8bf6ef366c00
2025-12-01 03:12:28,180 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/fe9e61a8-e789-4dcf-b95e-275772f8156a
2025-12-01 03:12:28,191 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/fe9e61a8-e789-4dcf-b95e-275772f8156a
2025-12-01 03:12:28,201 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/bed7a8af-2bfb-4ca9-a59e-5230834b04d6
2025-12-01 03:12:28,210 - DEBUG - Route Targets: ['target:64512:8000009']
2025-12-01 03:12:28,210 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/04867f8e-2f5b-4503-9995-8bf6ef366c00
2025-12-01 03:12:28,222 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/fe9e61a8-e789-4dcf-b95e-275772f8156a
2025-12-01 03:12:28,242 - INFO - Verified VN network id 17 for VN 04867f8e-2f5b-4503-9995-8bf6ef366c00
2025-12-01 03:12:28,242 - INFO - Verifications in API Server for VN ctest-trans_right_vn-82727794 passed
2025-12-01 03:12:28,242 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/04867f8e-2f5b-4503-9995-8bf6ef366c00
2025-12-01 03:12:28,254 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/fe9e61a8-e789-4dcf-b95e-275772f8156a
2025-12-01 03:12:28,262 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/fe9e61a8-e789-4dcf-b95e-275772f8156a
2025-12-01 03:12:28,272 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/bed7a8af-2bfb-4ca9-a59e-5230834b04d6
2025-12-01 03:12:28,285 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-95796989:ctest-trans_right_vn-82727794', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-95796989', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '326088271687533827', 'uuid-lslong': '11066905552024398848'}, 'enable': 'true', 'created': '2025-12-01T03:12:27', 'last-modified': '2025-12-01T03:12:27', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.430023'}
2025-12-01 03:12:28,292 - DEBUG - Route Targets: ['target:64512:8000009']
2025-12-01 03:12:28,298 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-95796989:ctest-trans_right_vn-82727794', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-95796989', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '326088271687533827', 'uuid-lslong': '11066905552024398848'}, 'enable': 'true', 'created': '2025-12-01T03:12:27', 'last-modified': '2025-12-01T03:12:27', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.443129'}
2025-12-01 03:12:28,308 - DEBUG - Route Targets: ['target:64512:8000009']
2025-12-01 03:12:28,315 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-95796989:ctest-trans_right_vn-82727794', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-95796989', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '326088271687533827', 'uuid-lslong': '11066905552024398848'}, 'enable': 'true', 'created': '2025-12-01T03:12:27', 'last-modified': '2025-12-01T03:12:27', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.465736'}
2025-12-01 03:12:28,321 - DEBUG - Route Targets: ['target:64512:8000009']
2025-12-01 03:12:28,321 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_right_vn-82727794 passed
2025-12-01 03:12:28,321 - DEBUG - ====Verifying policy data for ctest-trans_right_vn-82727794 in API_Server ======
2025-12-01 03:12:28,321 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-01 03:12:28,329 - DEBUG - Requesting: http://10.0.0.27:8082/domain/a276f104-9d2c-4383-87cf-b8e3164113c5
2025-12-01 03:12:28,342 - DEBUG - Requesting: http://10.0.0.27:8082/project/137b1f61-d728-4a4e-8f3d-7f3152dced90
2025-12-01 03:12:28,437 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/04867f8e-2f5b-4503-9995-8bf6ef366c00
2025-12-01 03:12:28,452 - DEBUG - =>VN ctest-trans_right_vn-82727794 has no policy to be verified
2025-12-01 03:12:28,452 - DEBUG - Verifying the vn in opserver
2025-12-01 03:12:28,452 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-95796989:ctest-trans_right_vn-82727794 virtual network link through opserver 10.0.0.27
2025-12-01 03:12:28,452 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2025-12-01 03:12:28,466 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-95796989:ctest-trans_right_vn-82727794', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-95796989:ctest-trans_right_vn-82727794?flat'}
2025-12-01 03:12:28,466 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-95796989:ctest-trans_right_vn-82727794 virtual network link through opserver 10.0.0.33
2025-12-01 03:12:28,466 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2025-12-01 03:12:28,480 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-95796989:ctest-trans_right_vn-82727794', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-95796989:ctest-trans_right_vn-82727794?flat'}
2025-12-01 03:12:28,480 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-95796989:ctest-trans_right_vn-82727794 virtual network link through opserver 10.0.0.23
2025-12-01 03:12:28,481 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-12-01 03:12:28,499 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-95796989:ctest-trans_right_vn-82727794', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-95796989:ctest-trans_right_vn-82727794?flat'}
2025-12-01 03:12:28,499 - INFO - Validated that VN default-domain:ctest-TestSvcHC-95796989:ctest-trans_right_vn-82727794 is found in opserver
2025-12-01 03:12:28,524 - DEBUG - Do not have enough data to verify VN in agent
2025-12-01 03:12:28,534 - DEBUG - VRF ids for VN ctest-trans_right_vn-82727794: {}
2025-12-01 03:12:29,756 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4827-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4827-2)
2025-12-01 03:12:31,358 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4827-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4827-1)
2025-12-01 03:12:31,358 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-86290243']
2025-12-01 03:12:31,670 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-86290243'] created succesfully
2025-12-01 03:12:32,106 - DEBUG - Image by name tiny_trans_fw not found
2025-12-01 03:12:32,106 - DEBUG - Installing image tiny_trans_fw
2025-12-01 03:12:32,106 - 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-12-01 03:12:32,106 - DEBUG - Image build path file:///contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2025-12-01 03:12:32,106 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2025-12-01 03:12:32,106 - DEBUG - Unzip image
2025-12-01 03:12:32,107 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2025-12-01 03:12:32,130 - INFO - image /contrail-test/images/tinycore-net-transparent-fw.qcow2 is not found
2025-12-01 03:12:32,130 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-86290243']
2025-12-01 03:12:32,273 - INFO - Service template: ['default-domain', 'ctest-service_template_1-86290243'] deleted successfully.
2025-12-01 03:12:32,274 - INFO - Skip interface_detach for VM ctest-right_vm-97516132 in state BUILD
2025-12-01 03:12:32,274 - INFO - Deleting VM ctest-right_vm-97516132
2025-12-01 03:12:32,274 - ERROR - VM ctest-right_vm-97516132 has failed to come up
2025-12-01 03:12:32,274 - ERROR - Nova failed to get host of the VM
2025-12-01 03:12:32,274 - ERROR - VM ctest-right_vm-97516132 has failed to come up
2025-12-01 03:12:32,274 - ERROR - Nova failed to get host of the VM
2025-12-01 03:12:32,430 - INFO - Skip interface_detach for VM ctest-left_vm-80866635 in state BUILD
2025-12-01 03:12:32,430 - INFO - Deleting VM ctest-left_vm-80866635
2025-12-01 03:12:32,430 - ERROR - VM ctest-left_vm-80866635 has failed to come up
2025-12-01 03:12:32,430 - ERROR - Nova failed to get host of the VM
2025-12-01 03:12:32,430 - ERROR - VM ctest-left_vm-80866635 has failed to come up
2025-12-01 03:12:32,430 - ERROR - Nova failed to get host of the VM
2025-12-01 03:12:32,560 - INFO - Deleting VN ctest-trans_right_vn-82727794
2025-12-01 03:12:32,754 - DEBUG - Response for deleting network ()
2025-12-01 03:12:32,754 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/fe9e61a8-e789-4dcf-b95e-275772f8156a
2025-12-01 03:12:32,762 - DEBUG - Response Code: 404
2025-12-01 03:12:32,762 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-01 03:12:32,768 - DEBUG - Requesting: http://10.0.0.27:8082/domain/a276f104-9d2c-4383-87cf-b8e3164113c5
2025-12-01 03:12:32,798 - DEBUG - Requesting: http://10.0.0.27:8082/project/137b1f61-d728-4a4e-8f3d-7f3152dced90
2025-12-01 03:12:32,908 - INFO - Validated that VN ctest-trans_right_vn-82727794 is not found in API Server
2025-12-01 03:12:32,948 - DEBUG - VN ctest-trans_right_vn-82727794 is not present in Agent 10.0.0.22
2025-12-01 03:12:32,962 - DEBUG - VN ctest-trans_right_vn-82727794 is not present in Agent 10.0.0.241
2025-12-01 03:12:32,962 - INFO - Validated that VN ctest-trans_right_vn-82727794 is not in any agent
2025-12-01 03:12:33,017 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-trans_right_vn-82727794 info
2025-12-01 03:12:33,017 - INFO - Deleting VN ctest-trans_left_vn-95184732
2025-12-01 03:12:33,208 - DEBUG - Response for deleting network ()
2025-12-01 03:12:33,208 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/ae3144cd-22f6-4587-8aa9-9dcbc845b21b
2025-12-01 03:12:33,214 - DEBUG - Response Code: 404
2025-12-01 03:12:33,214 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-01 03:12:33,222 - DEBUG - Requesting: http://10.0.0.27:8082/domain/a276f104-9d2c-4383-87cf-b8e3164113c5
2025-12-01 03:12:33,247 - DEBUG - Requesting: http://10.0.0.27:8082/project/137b1f61-d728-4a4e-8f3d-7f3152dced90
2025-12-01 03:12:33,368 - INFO - Validated that VN ctest-trans_left_vn-95184732 is not found in API Server
2025-12-01 03:12:33,379 - DEBUG - VN ctest-trans_left_vn-95184732 is not present in Agent 10.0.0.22
2025-12-01 03:12:33,396 - DEBUG - VN ctest-trans_left_vn-95184732 is not present in Agent 10.0.0.241
2025-12-01 03:12:33,397 - INFO - Validated that VN ctest-trans_left_vn-95184732 is not in any agent
2025-12-01 03:12:33,471 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-trans_left_vn-95184732 info
2025-12-01 03:12:33,471 - INFO - Deleting VN ctest-right_vn-46675944
2025-12-01 03:12:33,548 - DEBUG - VN b03fb013-1bba-47d7-aeb6-ea7c976e5993 still in use: Unable to complete operation on network b03fb013-1bba-47d7-aeb6-ea7c976e5993. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-ee6ff67f-72af-486f-9440-751255ebc0e7']
2025-12-01 03:12:33,548 - WARNING - Deleting VN ctest-right_vn-46675944 failed..Will retry
2025-12-01 03:12:35,713 - DEBUG - Response for deleting network ()
2025-12-01 03:12:35,713 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/ac489da9-4291-4270-a9d6-9f3ed0e1e9e5
2025-12-01 03:12:35,720 - DEBUG - Response Code: 404
2025-12-01 03:12:35,720 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-01 03:12:35,735 - DEBUG - Requesting: http://10.0.0.27:8082/domain/a276f104-9d2c-4383-87cf-b8e3164113c5
2025-12-01 03:12:35,753 - DEBUG - Requesting: http://10.0.0.27:8082/project/137b1f61-d728-4a4e-8f3d-7f3152dced90
2025-12-01 03:12:35,852 - INFO - Validated that VN ctest-right_vn-46675944 is not found in API Server
2025-12-01 03:12:35,866 - DEBUG - VN ctest-right_vn-46675944 is not present in Agent 10.0.0.22
2025-12-01 03:12:35,879 - DEBUG - VN ctest-right_vn-46675944 is not present in Agent 10.0.0.241
2025-12-01 03:12:35,879 - INFO - Validated that VN ctest-right_vn-46675944 is not in any agent
2025-12-01 03:12:35,931 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-46675944 info
2025-12-01 03:12:35,931 - INFO - Deleting VN ctest-left_vn-12691929
2025-12-01 03:12:36,122 - DEBUG - Response for deleting network ()
2025-12-01 03:12:36,122 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/2b7fb4d7-2147-4a23-9022-49bac25537d4
2025-12-01 03:12:36,133 - DEBUG - Response Code: 404
2025-12-01 03:12:36,133 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-01 03:12:36,154 - DEBUG - Requesting: http://10.0.0.27:8082/domain/a276f104-9d2c-4383-87cf-b8e3164113c5
2025-12-01 03:12:36,174 - DEBUG - Requesting: http://10.0.0.27:8082/project/137b1f61-d728-4a4e-8f3d-7f3152dced90
2025-12-01 03:12:36,281 - INFO - Validated that VN ctest-left_vn-12691929 is not found in API Server
2025-12-01 03:12:36,293 - DEBUG - VN ctest-left_vn-12691929 is not present in Agent 10.0.0.22
2025-12-01 03:12:36,306 - DEBUG - VN ctest-left_vn-12691929 is not present in Agent 10.0.0.241
2025-12-01 03:12:36,307 - INFO - Validated that VN ctest-left_vn-12691929 is not in any agent
2025-12-01 03:12:36,357 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-12691929 info
2025-12-01 03:12:36,357 - INFO - Deleting VN ctest-mgmt_vn-68367196
2025-12-01 03:12:36,512 - DEBUG - Response for deleting network ()
2025-12-01 03:12:36,512 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/28027f12-c246-4158-b25d-4b2dfb78d251
2025-12-01 03:12:36,528 - DEBUG - Response Code: 404
2025-12-01 03:12:36,528 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-01 03:12:36,537 - DEBUG - Requesting: http://10.0.0.27:8082/domain/a276f104-9d2c-4383-87cf-b8e3164113c5
2025-12-01 03:12:36,553 - DEBUG - Requesting: http://10.0.0.27:8082/project/137b1f61-d728-4a4e-8f3d-7f3152dced90
2025-12-01 03:12:36,650 - INFO - Validated that VN ctest-mgmt_vn-68367196 is not found in API Server
2025-12-01 03:12:36,662 - DEBUG - VN ctest-mgmt_vn-68367196 is not present in Agent 10.0.0.22
2025-12-01 03:12:36,674 - DEBUG - VN ctest-mgmt_vn-68367196 is not present in Agent 10.0.0.241
2025-12-01 03:12:36,674 - INFO - Validated that VN ctest-mgmt_vn-68367196 is not in any agent
2025-12-01 03:12:36,714 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-68367196 info
2025-12-01 03:12:38,029 - DEBUG - No XMPP flaps were noticed during the test
2025-12-01 03:12:38,029 - INFO -
2025-12-01 03:12:38,029 - INFO - END TEST : test_svc_trans_segment_right_hc_fail_svm : SKIPPED[0:00:17]
2025-12-01 03:12:38,030 - INFO - --------------------------------------------------------------------------------
2025-12-01 03:12:38,962 - INFO - Deleted project: ctest-TestSvcHC-95796989, ID : 137b1f61-d728-4a4e-8f3d-7f3152dced90