2025-10-23 03:10:14,223 - INFO - Domain Default found not creating
2025-10-23 03:10:14,405 - INFO - Project ctest-TestSvcHC-62781284 not found, creating it
2025-10-23 03:10:14,942 - INFO - Created Project:ctest-TestSvcHC-62781284, ID : c00701fe-d665-4cba-8761-ee558f28c2b9
2025-10-23 03:10:16,779 - INFO - ================================================================================
2025-10-23 03:10:16,779 - INFO - STARTING TEST : test_svc_hc_basic
2025-10-23 03:10:18,093 - DEBUG - Nothing to compare xmpp stats {'10.0.0.48': {'10.20.0.14': '0', '10.20.0.129': '0'}, '10.0.0.49': {'10.20.0.14': '0', '10.20.0.129': '0'}} with
2025-10-23 03:10:18,093 - INFO - Initial checks done. Running the testcase now
2025-10-23 03:10:18,093 - INFO -
2025-10-23 03:10:18,838 - DEBUG - Response for create_network : {'network': {'id': 'efa4f5f9-ef06-4d33-80d4-b21a53b11bc9', 'name': 'ctest-mgmt_vn-75876103', 'tenant_id': 'c00701fed6654cba8761ee558f28c2b9', 'project_id': 'c00701fed6654cba8761ee558f28c2b9', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-62781284', 'ctest-mgmt_vn-75876103'], 'port_security_enabled': True, 'description': ''}}
2025-10-23 03:10:19,202 - DEBUG - Response for create_subnet : {'subnet': {'id': 'f982546a-e053-4579-a24d-cc64641dd9c9', 'name': '', 'tenant_id': 'c00701fed6654cba8761ee558f28c2b9', 'network_id': 'efa4f5f9-ef06-4d33-80d4-b21a53b11bc9', 'ip_version': 4, 'cidr': '26.57.238.64/26', 'allocation_pools': [{'start': '26.57.238.66', 'end': '26.57.238.126'}], 'gateway_ip': '26.57.238.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '26.57.238.66', 'tags': [], 'project_id': 'c00701fed6654cba8761ee558f28c2b9'}}
2025-10-23 03:10:19,228 - INFO - Created VN ctest-mgmt_vn-75876103
2025-10-23 03:10:19,243 - DEBUG - VN ctest-mgmt_vn-75876103 UUID is efa4f5f9-ef06-4d33-80d4-b21a53b11bc9
2025-10-23 03:10:19,322 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2025-10-23 03:10:19,705 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2025-10-23 03:10:19,744 - DEBUG - Requesting: http://10.0.0.41:8082/domain/4ac2eafd-52e8-4f65-a1ce-6478676e3af6
2025-10-23 03:10:19,764 - DEBUG - Requesting: http://10.0.0.41:8082/project/c00701fe-d665-4cba-8761-ee558f28c2b9
2025-10-23 03:10:19,859 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/efa4f5f9-ef06-4d33-80d4-b21a53b11bc9
2025-10-23 03:10:19,874 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/efa4f5f9-ef06-4d33-80d4-b21a53b11bc9
2025-10-23 03:10:19,894 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/f8aaa149-e64a-4b3a-8cee-c304d94266dd
2025-10-23 03:10:19,902 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/f8aaa149-e64a-4b3a-8cee-c304d94266dd
2025-10-23 03:10:19,915 - DEBUG - Requesting: http://10.0.0.41:8082/route-target/dc028727-d792-49d9-9ef0-9fbee570cc08
2025-10-23 03:10:19,926 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-23 03:10:19,926 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/efa4f5f9-ef06-4d33-80d4-b21a53b11bc9
2025-10-23 03:10:19,937 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/f8aaa149-e64a-4b3a-8cee-c304d94266dd
2025-10-23 03:10:19,956 - INFO - Verified VN network id 15 for VN efa4f5f9-ef06-4d33-80d4-b21a53b11bc9
2025-10-23 03:10:19,957 - INFO - Verifications in API Server for VN ctest-mgmt_vn-75876103 passed
2025-10-23 03:10:19,957 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/efa4f5f9-ef06-4d33-80d4-b21a53b11bc9
2025-10-23 03:10:19,978 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/f8aaa149-e64a-4b3a-8cee-c304d94266dd
2025-10-23 03:10:19,990 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/f8aaa149-e64a-4b3a-8cee-c304d94266dd
2025-10-23 03:10:20,000 - DEBUG - Requesting: http://10.0.0.41:8082/route-target/dc028727-d792-49d9-9ef0-9fbee570cc08
2025-10-23 03:10:20,023 - DEBUG - Control-node 10.0.0.41 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-62781284:ctest-mgmt_vn-75876103', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-62781284', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17268197325051153715', 'uuid-lslong': '9283240558060444617'}, 'enable': 'true', 'created': '2025-10-23T03:10:18', 'last-modified': '2025-10-23T03:10:19', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.883991'}
2025-10-23 03:10:20,033 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-23 03:10:20,042 - DEBUG - Control-node 10.0.0.73 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-62781284:ctest-mgmt_vn-75876103', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-62781284', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17268197325051153715', 'uuid-lslong': '9283240558060444617'}, 'enable': 'true', 'created': '2025-10-23T03:10:18', 'last-modified': '2025-10-23T03:10:19', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.911701'}
2025-10-23 03:10:20,050 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-23 03:10:20,058 - DEBUG - Control-node 10.0.0.133 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-62781284:ctest-mgmt_vn-75876103', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-62781284', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17268197325051153715', 'uuid-lslong': '9283240558060444617'}, 'enable': 'true', 'created': '2025-10-23T03:10:18', 'last-modified': '2025-10-23T03:10:19', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.927177'}
2025-10-23 03:10:20,067 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-23 03:10:20,067 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-75876103 passed
2025-10-23 03:10:20,068 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-75876103 in API_Server ======
2025-10-23 03:10:20,068 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2025-10-23 03:10:20,077 - DEBUG - Requesting: http://10.0.0.41:8082/domain/4ac2eafd-52e8-4f65-a1ce-6478676e3af6
2025-10-23 03:10:20,094 - DEBUG - Requesting: http://10.0.0.41:8082/project/c00701fe-d665-4cba-8761-ee558f28c2b9
2025-10-23 03:10:20,201 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/efa4f5f9-ef06-4d33-80d4-b21a53b11bc9
2025-10-23 03:10:20,214 - DEBUG - =>VN ctest-mgmt_vn-75876103 has no policy to be verified
2025-10-23 03:10:20,214 - DEBUG - Verifying the vn in opserver
2025-10-23 03:10:20,214 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-62781284:ctest-mgmt_vn-75876103 virtual network link through opserver 10.0.0.41
2025-10-23 03:10:20,215 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-networks
2025-10-23 03:10:20,573 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-networks
2025-10-23 03:10:20,650 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-62781284:ctest-mgmt_vn-75876103', 'href': 'http://10.0.0.41:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-62781284:ctest-mgmt_vn-75876103?flat'}
2025-10-23 03:10:20,650 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-62781284:ctest-mgmt_vn-75876103 virtual network link through opserver 10.0.0.73
2025-10-23 03:10:20,650 - DEBUG - Requesting: http://10.0.0.73:8081/analytics/uves/virtual-networks
2025-10-23 03:10:21,001 - DEBUG - Requesting: http://10.0.0.73:8081/analytics/uves/virtual-networks
2025-10-23 03:10:21,079 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-62781284:ctest-mgmt_vn-75876103', 'href': 'http://10.0.0.73:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-62781284:ctest-mgmt_vn-75876103?flat'}
2025-10-23 03:10:21,080 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-62781284:ctest-mgmt_vn-75876103 virtual network link through opserver 10.0.0.133
2025-10-23 03:10:21,080 - DEBUG - Requesting: http://10.0.0.133:8081/analytics/uves/virtual-networks
2025-10-23 03:10:21,447 - DEBUG - Requesting: http://10.0.0.133:8081/analytics/uves/virtual-networks
2025-10-23 03:10:21,513 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-62781284:ctest-mgmt_vn-75876103', 'href': 'http://10.0.0.133:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-62781284:ctest-mgmt_vn-75876103?flat'}
2025-10-23 03:10:21,513 - INFO - Validated that VN default-domain:ctest-TestSvcHC-62781284:ctest-mgmt_vn-75876103 is found in opserver
2025-10-23 03:10:21,539 - DEBUG - Do not have enough data to verify VN in agent
2025-10-23 03:10:21,553 - DEBUG - VRF ids for VN ctest-mgmt_vn-75876103: {}
2025-10-23 03:10:21,857 - DEBUG - Response for create_network : {'network': {'id': '972d14ec-14be-423a-a678-d00b9dc26a70', 'name': 'ctest-left_vn-58978887', 'tenant_id': 'c00701fed6654cba8761ee558f28c2b9', 'project_id': 'c00701fed6654cba8761ee558f28c2b9', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-62781284', 'ctest-left_vn-58978887'], 'port_security_enabled': True, 'description': ''}}
2025-10-23 03:10:22,124 - DEBUG - Response for create_subnet : {'subnet': {'id': '87bf2022-267d-4acf-8c28-60b3fe843554', 'name': '', 'tenant_id': 'c00701fed6654cba8761ee558f28c2b9', 'network_id': '972d14ec-14be-423a-a678-d00b9dc26a70', 'ip_version': 4, 'cidr': '205.88.160.0/26', 'allocation_pools': [{'start': '205.88.160.2', 'end': '205.88.160.62'}], 'gateway_ip': '205.88.160.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '205.88.160.2', 'tags': [], 'project_id': 'c00701fed6654cba8761ee558f28c2b9'}}
2025-10-23 03:10:22,149 - INFO - Created VN ctest-left_vn-58978887
2025-10-23 03:10:22,159 - DEBUG - VN ctest-left_vn-58978887 UUID is 972d14ec-14be-423a-a678-d00b9dc26a70
2025-10-23 03:10:22,264 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2025-10-23 03:10:22,270 - DEBUG - Requesting: http://10.0.0.41:8082/domain/4ac2eafd-52e8-4f65-a1ce-6478676e3af6
2025-10-23 03:10:22,282 - DEBUG - Requesting: http://10.0.0.41:8082/project/c00701fe-d665-4cba-8761-ee558f28c2b9
2025-10-23 03:10:22,407 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/972d14ec-14be-423a-a678-d00b9dc26a70
2025-10-23 03:10:22,431 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/972d14ec-14be-423a-a678-d00b9dc26a70
2025-10-23 03:10:22,443 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/87668ab5-554d-4910-b252-74423de28a72
2025-10-23 03:10:22,467 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/87668ab5-554d-4910-b252-74423de28a72
2025-10-23 03:10:22,477 - DEBUG - Requesting: http://10.0.0.41:8082/route-target/159d795c-4ecf-4623-b82b-115003144acd
2025-10-23 03:10:22,487 - DEBUG - Route Targets: ['target:64512:8000005']
2025-10-23 03:10:22,487 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/972d14ec-14be-423a-a678-d00b9dc26a70
2025-10-23 03:10:22,499 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/87668ab5-554d-4910-b252-74423de28a72
2025-10-23 03:10:22,518 - INFO - Verified VN network id 16 for VN 972d14ec-14be-423a-a678-d00b9dc26a70
2025-10-23 03:10:22,518 - INFO - Verifications in API Server for VN ctest-left_vn-58978887 passed
2025-10-23 03:10:22,518 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/972d14ec-14be-423a-a678-d00b9dc26a70
2025-10-23 03:10:22,529 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/87668ab5-554d-4910-b252-74423de28a72
2025-10-23 03:10:22,539 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/87668ab5-554d-4910-b252-74423de28a72
2025-10-23 03:10:22,548 - DEBUG - Requesting: http://10.0.0.41:8082/route-target/159d795c-4ecf-4623-b82b-115003144acd
2025-10-23 03:10:22,570 - DEBUG - Control-node 10.0.0.41 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-62781284:ctest-left_vn-58978887', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-62781284', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10893386077871948346', 'uuid-lslong': '11995566355811297904'}, 'enable': 'true', 'created': '2025-10-23T03:10:21', 'last-modified': '2025-10-23T03:10:22', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.504490'}
2025-10-23 03:10:22,581 - DEBUG - Route Targets: ['target:64512:8000005']
2025-10-23 03:10:22,588 - DEBUG - Control-node 10.0.0.73 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-62781284:ctest-left_vn-58978887', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-62781284', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10893386077871948346', 'uuid-lslong': '11995566355811297904'}, 'enable': 'true', 'created': '2025-10-23T03:10:21', 'last-modified': '2025-10-23T03:10:22', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.525079'}
2025-10-23 03:10:22,595 - DEBUG - Route Targets: ['target:64512:8000005']
2025-10-23 03:10:22,600 - DEBUG - Control-node 10.0.0.133 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-62781284:ctest-left_vn-58978887', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-62781284', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10893386077871948346', 'uuid-lslong': '11995566355811297904'}, 'enable': 'true', 'created': '2025-10-23T03:10:21', 'last-modified': '2025-10-23T03:10:22', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.541693'}
2025-10-23 03:10:22,606 - DEBUG - Route Targets: ['target:64512:8000005']
2025-10-23 03:10:22,606 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-58978887 passed
2025-10-23 03:10:22,606 - DEBUG - ====Verifying policy data for ctest-left_vn-58978887 in API_Server ======
2025-10-23 03:10:22,607 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2025-10-23 03:10:22,613 - DEBUG - Requesting: http://10.0.0.41:8082/domain/4ac2eafd-52e8-4f65-a1ce-6478676e3af6
2025-10-23 03:10:22,628 - DEBUG - Requesting: http://10.0.0.41:8082/project/c00701fe-d665-4cba-8761-ee558f28c2b9
2025-10-23 03:10:22,764 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/972d14ec-14be-423a-a678-d00b9dc26a70
2025-10-23 03:10:22,776 - DEBUG - =>VN ctest-left_vn-58978887 has no policy to be verified
2025-10-23 03:10:22,776 - DEBUG - Verifying the vn in opserver
2025-10-23 03:10:22,776 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-62781284:ctest-left_vn-58978887 virtual network link through opserver 10.0.0.41
2025-10-23 03:10:22,777 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-networks
2025-10-23 03:10:22,846 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-62781284:ctest-left_vn-58978887', 'href': 'http://10.0.0.41:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-62781284:ctest-left_vn-58978887?flat'}
2025-10-23 03:10:22,846 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-62781284:ctest-left_vn-58978887 virtual network link through opserver 10.0.0.73
2025-10-23 03:10:22,846 - DEBUG - Requesting: http://10.0.0.73:8081/analytics/uves/virtual-networks
2025-10-23 03:10:22,916 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-62781284:ctest-left_vn-58978887', 'href': 'http://10.0.0.73:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-62781284:ctest-left_vn-58978887?flat'}
2025-10-23 03:10:22,916 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-62781284:ctest-left_vn-58978887 virtual network link through opserver 10.0.0.133
2025-10-23 03:10:22,916 - DEBUG - Requesting: http://10.0.0.133:8081/analytics/uves/virtual-networks
2025-10-23 03:10:22,980 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-62781284:ctest-left_vn-58978887', 'href': 'http://10.0.0.133:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-62781284:ctest-left_vn-58978887?flat'}
2025-10-23 03:10:22,980 - INFO - Validated that VN default-domain:ctest-TestSvcHC-62781284:ctest-left_vn-58978887 is found in opserver
2025-10-23 03:10:23,006 - DEBUG - Do not have enough data to verify VN in agent
2025-10-23 03:10:23,024 - DEBUG - VRF ids for VN ctest-left_vn-58978887: {}
2025-10-23 03:10:23,321 - DEBUG - Response for create_network : {'network': {'id': '00b5d344-6f31-4d16-b1a6-48cf13ef4391', 'name': 'ctest-right_vn-29734836', 'tenant_id': 'c00701fed6654cba8761ee558f28c2b9', 'project_id': 'c00701fed6654cba8761ee558f28c2b9', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-62781284', 'ctest-right_vn-29734836'], 'port_security_enabled': True, 'description': ''}}
2025-10-23 03:10:23,598 - DEBUG - Response for create_subnet : {'subnet': {'id': 'f1de2ca5-463d-4afd-8eef-67e78e01ab06', 'name': '', 'tenant_id': 'c00701fed6654cba8761ee558f28c2b9', 'network_id': '00b5d344-6f31-4d16-b1a6-48cf13ef4391', 'ip_version': 4, 'cidr': '43.234.90.64/26', 'allocation_pools': [{'start': '43.234.90.66', 'end': '43.234.90.126'}], 'gateway_ip': '43.234.90.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '43.234.90.66', 'tags': [], 'project_id': 'c00701fed6654cba8761ee558f28c2b9'}}
2025-10-23 03:10:23,634 - INFO - Created VN ctest-right_vn-29734836
2025-10-23 03:10:23,646 - DEBUG - VN ctest-right_vn-29734836 UUID is 00b5d344-6f31-4d16-b1a6-48cf13ef4391
2025-10-23 03:10:23,731 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2025-10-23 03:10:23,739 - DEBUG - Requesting: http://10.0.0.41:8082/domain/4ac2eafd-52e8-4f65-a1ce-6478676e3af6
2025-10-23 03:10:23,754 - DEBUG - Requesting: http://10.0.0.41:8082/project/c00701fe-d665-4cba-8761-ee558f28c2b9
2025-10-23 03:10:23,864 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/00b5d344-6f31-4d16-b1a6-48cf13ef4391
2025-10-23 03:10:23,880 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/00b5d344-6f31-4d16-b1a6-48cf13ef4391
2025-10-23 03:10:23,891 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/06382302-297d-457f-80cd-90599a8551f9
2025-10-23 03:10:23,901 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/06382302-297d-457f-80cd-90599a8551f9
2025-10-23 03:10:23,909 - DEBUG - Requesting: http://10.0.0.41:8082/route-target/91ad7a9b-43cb-46ce-a699-453a8f00a4b3
2025-10-23 03:10:23,916 - DEBUG - Route Targets: ['target:64512:8000006']
2025-10-23 03:10:23,916 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/00b5d344-6f31-4d16-b1a6-48cf13ef4391
2025-10-23 03:10:23,926 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/06382302-297d-457f-80cd-90599a8551f9
2025-10-23 03:10:23,942 - INFO - Verified VN network id 17 for VN 00b5d344-6f31-4d16-b1a6-48cf13ef4391
2025-10-23 03:10:23,942 - INFO - Verifications in API Server for VN ctest-right_vn-29734836 passed
2025-10-23 03:10:23,942 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/00b5d344-6f31-4d16-b1a6-48cf13ef4391
2025-10-23 03:10:23,955 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/06382302-297d-457f-80cd-90599a8551f9
2025-10-23 03:10:23,965 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/06382302-297d-457f-80cd-90599a8551f9
2025-10-23 03:10:23,973 - DEBUG - Requesting: http://10.0.0.41:8082/route-target/91ad7a9b-43cb-46ce-a699-453a8f00a4b3
2025-10-23 03:10:23,986 - DEBUG - Control-node 10.0.0.41 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-62781284:ctest-right_vn-29734836', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-62781284', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '51179261661367574', 'uuid-lslong': '12800999045077091217'}, 'enable': 'true', 'created': '2025-10-23T03:10:23', 'last-modified': '2025-10-23T03:10:23', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.446228'}
2025-10-23 03:10:23,994 - DEBUG - Route Targets: ['target:64512:8000006']
2025-10-23 03:10:24,005 - DEBUG - Control-node 10.0.0.73 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-62781284:ctest-right_vn-29734836', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-62781284', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '51179261661367574', 'uuid-lslong': '12800999045077091217'}, 'enable': 'true', 'created': '2025-10-23T03:10:23', 'last-modified': '2025-10-23T03:10:23', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.467709'}
2025-10-23 03:10:24,012 - DEBUG - Route Targets: ['target:64512:8000006']
2025-10-23 03:10:24,018 - DEBUG - Control-node 10.0.0.133 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-62781284:ctest-right_vn-29734836', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-62781284', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '51179261661367574', 'uuid-lslong': '12800999045077091217'}, 'enable': 'true', 'created': '2025-10-23T03:10:23', 'last-modified': '2025-10-23T03:10:23', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.469960'}
2025-10-23 03:10:24,024 - DEBUG - Route Targets: ['target:64512:8000006']
2025-10-23 03:10:24,024 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-29734836 passed
2025-10-23 03:10:24,024 - DEBUG - ====Verifying policy data for ctest-right_vn-29734836 in API_Server ======
2025-10-23 03:10:24,024 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2025-10-23 03:10:24,032 - DEBUG - Requesting: http://10.0.0.41:8082/domain/4ac2eafd-52e8-4f65-a1ce-6478676e3af6
2025-10-23 03:10:24,045 - DEBUG - Requesting: http://10.0.0.41:8082/project/c00701fe-d665-4cba-8761-ee558f28c2b9
2025-10-23 03:10:24,150 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/00b5d344-6f31-4d16-b1a6-48cf13ef4391
2025-10-23 03:10:24,166 - DEBUG - =>VN ctest-right_vn-29734836 has no policy to be verified
2025-10-23 03:10:24,166 - DEBUG - Verifying the vn in opserver
2025-10-23 03:10:24,166 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-62781284:ctest-right_vn-29734836 virtual network link through opserver 10.0.0.41
2025-10-23 03:10:24,166 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-networks
2025-10-23 03:10:24,247 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-62781284:ctest-right_vn-29734836', 'href': 'http://10.0.0.41:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-62781284:ctest-right_vn-29734836?flat'}
2025-10-23 03:10:24,247 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-62781284:ctest-right_vn-29734836 virtual network link through opserver 10.0.0.73
2025-10-23 03:10:24,247 - DEBUG - Requesting: http://10.0.0.73:8081/analytics/uves/virtual-networks
2025-10-23 03:10:24,332 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-62781284:ctest-right_vn-29734836', 'href': 'http://10.0.0.73:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-62781284:ctest-right_vn-29734836?flat'}
2025-10-23 03:10:24,332 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-62781284:ctest-right_vn-29734836 virtual network link through opserver 10.0.0.133
2025-10-23 03:10:24,333 - DEBUG - Requesting: http://10.0.0.133:8081/analytics/uves/virtual-networks
2025-10-23 03:10:24,417 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-62781284:ctest-right_vn-29734836', 'href': 'http://10.0.0.133:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-62781284:ctest-right_vn-29734836?flat'}
2025-10-23 03:10:24,417 - INFO - Validated that VN default-domain:ctest-TestSvcHC-62781284:ctest-right_vn-29734836 is found in opserver
2025-10-23 03:10:24,457 - DEBUG - Do not have enough data to verify VN in agent
2025-10-23 03:10:24,476 - DEBUG - VRF ids for VN ctest-right_vn-29734836: {}
2025-10-23 03:10:24,579 - DEBUG - Services list from nova: [, , , ]
2025-10-23 03:10:25,820 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4448-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4448-2)
2025-10-23 03:10:27,331 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4448-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4448-1)
2025-10-23 03:10:27,331 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-50309953']
2025-10-23 03:10:27,623 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-50309953'] created succesfully
2025-10-23 03:10:28,072 - DEBUG - Image by name tiny_nat_fw not found
2025-10-23 03:10:28,072 - DEBUG - Installing image tiny_nat_fw
2025-10-23 03:10:28,072 - 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-23 03:10:28,073 - DEBUG - Image build path file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2025-10-23 03:10:28,073 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2025-10-23 03:10:28,073 - DEBUG - Unzip image
2025-10-23 03:10:28,073 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2025-10-23 03:10:28,106 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2025-10-23 03:10:28,107 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-50309953']
2025-10-23 03:10:28,202 - INFO - Service template: ['default-domain', 'ctest-service_template_1-50309953'] deleted successfully.
2025-10-23 03:10:28,202 - INFO - Skip interface_detach for VM ctest-right_vm-60351428 in state BUILD
2025-10-23 03:10:28,203 - INFO - Deleting VM ctest-right_vm-60351428
2025-10-23 03:10:28,293 - ERROR - VM ctest-right_vm-60351428 has failed to come up
2025-10-23 03:10:28,293 - ERROR - Nova failed to get host of the VM
2025-10-23 03:10:28,293 - ERROR - VM ctest-right_vm-60351428 has failed to come up
2025-10-23 03:10:28,293 - ERROR - Nova failed to get host of the VM
2025-10-23 03:10:28,399 - INFO - Skip interface_detach for VM ctest-left_vm-60845662 in state BUILD
2025-10-23 03:10:28,399 - INFO - Deleting VM ctest-left_vm-60845662
2025-10-23 03:10:28,399 - ERROR - VM ctest-left_vm-60845662 has failed to come up
2025-10-23 03:10:28,399 - ERROR - Nova failed to get host of the VM
2025-10-23 03:10:28,399 - ERROR - VM ctest-left_vm-60845662 has failed to come up
2025-10-23 03:10:28,399 - ERROR - Nova failed to get host of the VM
2025-10-23 03:10:28,505 - INFO - Deleting VN ctest-right_vn-29734836
2025-10-23 03:10:28,554 - DEBUG - VN 00b5d344-6f31-4d16-b1a6-48cf13ef4391 still in use: Unable to complete operation on network 00b5d344-6f31-4d16-b1a6-48cf13ef4391. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-725fccf4-458e-4e5d-a237-1e0c859d99db']
2025-10-23 03:10:28,554 - WARNING - Deleting VN ctest-right_vn-29734836 failed..Will retry
2025-10-23 03:10:30,727 - DEBUG - Response for deleting network ()
2025-10-23 03:10:30,727 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/06382302-297d-457f-80cd-90599a8551f9
2025-10-23 03:10:30,739 - DEBUG - Response Code: 404
2025-10-23 03:10:30,739 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2025-10-23 03:10:30,757 - DEBUG - Requesting: http://10.0.0.41:8082/domain/4ac2eafd-52e8-4f65-a1ce-6478676e3af6
2025-10-23 03:10:30,775 - DEBUG - Requesting: http://10.0.0.41:8082/project/c00701fe-d665-4cba-8761-ee558f28c2b9
2025-10-23 03:10:30,894 - INFO - Validated that VN ctest-right_vn-29734836 is not found in API Server
2025-10-23 03:10:30,907 - DEBUG - VN ctest-right_vn-29734836 is not present in Agent 10.0.0.48
2025-10-23 03:10:30,917 - DEBUG - VN ctest-right_vn-29734836 is not present in Agent 10.0.0.49
2025-10-23 03:10:30,917 - INFO - Validated that VN ctest-right_vn-29734836 is not in any agent
2025-10-23 03:10:30,951 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-29734836 info
2025-10-23 03:10:30,951 - INFO - Deleting VN ctest-left_vn-58978887
2025-10-23 03:10:31,168 - DEBUG - Response for deleting network ()
2025-10-23 03:10:31,168 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/87668ab5-554d-4910-b252-74423de28a72
2025-10-23 03:10:31,174 - DEBUG - Response Code: 404
2025-10-23 03:10:31,174 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2025-10-23 03:10:31,187 - DEBUG - Requesting: http://10.0.0.41:8082/domain/4ac2eafd-52e8-4f65-a1ce-6478676e3af6
2025-10-23 03:10:31,243 - DEBUG - Requesting: http://10.0.0.41:8082/project/c00701fe-d665-4cba-8761-ee558f28c2b9
2025-10-23 03:10:31,347 - INFO - Validated that VN ctest-left_vn-58978887 is not found in API Server
2025-10-23 03:10:31,359 - DEBUG - VN ctest-left_vn-58978887 is not present in Agent 10.0.0.48
2025-10-23 03:10:31,370 - DEBUG - VN ctest-left_vn-58978887 is not present in Agent 10.0.0.49
2025-10-23 03:10:31,370 - INFO - Validated that VN ctest-left_vn-58978887 is not in any agent
2025-10-23 03:10:31,403 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-58978887 info
2025-10-23 03:10:31,403 - INFO - Deleting VN ctest-mgmt_vn-75876103
2025-10-23 03:10:31,555 - DEBUG - Response for deleting network ()
2025-10-23 03:10:31,556 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/f8aaa149-e64a-4b3a-8cee-c304d94266dd
2025-10-23 03:10:31,561 - DEBUG - Response Code: 404
2025-10-23 03:10:31,562 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2025-10-23 03:10:31,568 - DEBUG - Requesting: http://10.0.0.41:8082/domain/4ac2eafd-52e8-4f65-a1ce-6478676e3af6
2025-10-23 03:10:31,591 - DEBUG - Requesting: http://10.0.0.41:8082/project/c00701fe-d665-4cba-8761-ee558f28c2b9
2025-10-23 03:10:31,686 - INFO - Validated that VN ctest-mgmt_vn-75876103 is not found in API Server
2025-10-23 03:10:31,699 - DEBUG - VN ctest-mgmt_vn-75876103 is not present in Agent 10.0.0.48
2025-10-23 03:10:31,713 - DEBUG - VN ctest-mgmt_vn-75876103 is not present in Agent 10.0.0.49
2025-10-23 03:10:31,713 - INFO - Validated that VN ctest-mgmt_vn-75876103 is not in any agent
2025-10-23 03:10:31,746 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-75876103 info
2025-10-23 03:10:33,028 - DEBUG - No XMPP flaps were noticed during the test
2025-10-23 03:10:33,029 - INFO -
2025-10-23 03:10:33,029 - INFO - END TEST : test_svc_hc_basic : SKIPPED[0:00:17]
2025-10-23 03:10:33,029 - INFO - --------------------------------------------------------------------------------
2025-10-23 03:10:33,032 - INFO - ================================================================================
2025-10-23 03:10:33,032 - INFO - STARTING TEST : test_svc_trans_segment_right_hc_fail_svm
2025-10-23 03:10:34,323 - DEBUG - Nothing to compare xmpp stats {'10.0.0.48': {'10.20.0.14': '0', '10.20.0.129': '0'}, '10.0.0.49': {'10.20.0.14': '0', '10.20.0.129': '0'}} with
2025-10-23 03:10:34,323 - INFO - Initial checks done. Running the testcase now
2025-10-23 03:10:34,323 - INFO -
2025-10-23 03:10:34,643 - DEBUG - Response for create_network : {'network': {'id': '108f557e-53ef-45b1-aca1-21ed3282db93', 'name': 'ctest-mgmt_vn-91470526', 'tenant_id': 'c00701fed6654cba8761ee558f28c2b9', 'project_id': 'c00701fed6654cba8761ee558f28c2b9', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-62781284', 'ctest-mgmt_vn-91470526'], 'port_security_enabled': True, 'description': ''}}
2025-10-23 03:10:34,929 - DEBUG - Response for create_subnet : {'subnet': {'id': '48e321cd-b5ca-47ad-ac93-e41fedccea10', 'name': '', 'tenant_id': 'c00701fed6654cba8761ee558f28c2b9', 'network_id': '108f557e-53ef-45b1-aca1-21ed3282db93', 'ip_version': 4, 'cidr': '82.33.134.192/26', 'allocation_pools': [{'start': '82.33.134.194', 'end': '82.33.134.254'}], 'gateway_ip': '82.33.134.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '82.33.134.194', 'tags': [], 'project_id': 'c00701fed6654cba8761ee558f28c2b9'}}
2025-10-23 03:10:34,964 - INFO - Created VN ctest-mgmt_vn-91470526
2025-10-23 03:10:34,976 - DEBUG - VN ctest-mgmt_vn-91470526 UUID is 108f557e-53ef-45b1-aca1-21ed3282db93
2025-10-23 03:10:35,057 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2025-10-23 03:10:35,063 - DEBUG - Requesting: http://10.0.0.41:8082/domain/4ac2eafd-52e8-4f65-a1ce-6478676e3af6
2025-10-23 03:10:35,076 - DEBUG - Requesting: http://10.0.0.41:8082/project/c00701fe-d665-4cba-8761-ee558f28c2b9
2025-10-23 03:10:35,176 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/108f557e-53ef-45b1-aca1-21ed3282db93
2025-10-23 03:10:35,190 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/108f557e-53ef-45b1-aca1-21ed3282db93
2025-10-23 03:10:35,201 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/68d8f17e-3fdf-42f4-a231-8f346cbca3be
2025-10-23 03:10:35,212 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/68d8f17e-3fdf-42f4-a231-8f346cbca3be
2025-10-23 03:10:35,223 - DEBUG - Requesting: http://10.0.0.41:8082/route-target/d3636db5-c7a4-41e9-a07e-868ee47558fe
2025-10-23 03:10:35,231 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-23 03:10:35,231 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/108f557e-53ef-45b1-aca1-21ed3282db93
2025-10-23 03:10:35,241 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/68d8f17e-3fdf-42f4-a231-8f346cbca3be
2025-10-23 03:10:35,258 - INFO - Verified VN network id 15 for VN 108f557e-53ef-45b1-aca1-21ed3282db93
2025-10-23 03:10:35,259 - INFO - Verifications in API Server for VN ctest-mgmt_vn-91470526 passed
2025-10-23 03:10:35,259 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/108f557e-53ef-45b1-aca1-21ed3282db93
2025-10-23 03:10:35,276 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/68d8f17e-3fdf-42f4-a231-8f346cbca3be
2025-10-23 03:10:35,288 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/68d8f17e-3fdf-42f4-a231-8f346cbca3be
2025-10-23 03:10:35,296 - DEBUG - Requesting: http://10.0.0.41:8082/route-target/d3636db5-c7a4-41e9-a07e-868ee47558fe
2025-10-23 03:10:35,312 - DEBUG - Control-node 10.0.0.41 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-62781284:ctest-mgmt_vn-91470526', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-62781284', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1193266427338900913', 'uuid-lslong': '12439260948412423059'}, 'enable': 'true', 'created': '2025-10-23T03:10:34', 'last-modified': '2025-10-23T03:10:34', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.434620'}
2025-10-23 03:10:35,320 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-23 03:10:35,325 - DEBUG - Control-node 10.0.0.73 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-62781284:ctest-mgmt_vn-91470526', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-62781284', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1193266427338900913', 'uuid-lslong': '12439260948412423059'}, 'enable': 'true', 'created': '2025-10-23T03:10:34', 'last-modified': '2025-10-23T03:10:34', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.448736'}
2025-10-23 03:10:35,331 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-23 03:10:35,337 - DEBUG - Control-node 10.0.0.133 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-62781284:ctest-mgmt_vn-91470526', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-62781284', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1193266427338900913', 'uuid-lslong': '12439260948412423059'}, 'enable': 'true', 'created': '2025-10-23T03:10:34', 'last-modified': '2025-10-23T03:10:34', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.476659'}
2025-10-23 03:10:35,343 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-23 03:10:35,344 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-91470526 passed
2025-10-23 03:10:35,344 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-91470526 in API_Server ======
2025-10-23 03:10:35,344 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2025-10-23 03:10:35,351 - DEBUG - Requesting: http://10.0.0.41:8082/domain/4ac2eafd-52e8-4f65-a1ce-6478676e3af6
2025-10-23 03:10:35,364 - DEBUG - Requesting: http://10.0.0.41:8082/project/c00701fe-d665-4cba-8761-ee558f28c2b9
2025-10-23 03:10:35,472 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/108f557e-53ef-45b1-aca1-21ed3282db93
2025-10-23 03:10:35,501 - DEBUG - =>VN ctest-mgmt_vn-91470526 has no policy to be verified
2025-10-23 03:10:35,501 - DEBUG - Verifying the vn in opserver
2025-10-23 03:10:35,501 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-62781284:ctest-mgmt_vn-91470526 virtual network link through opserver 10.0.0.41
2025-10-23 03:10:35,501 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-networks
2025-10-23 03:10:35,513 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-62781284:ctest-mgmt_vn-91470526', 'href': 'http://10.0.0.41:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-62781284:ctest-mgmt_vn-91470526?flat'}
2025-10-23 03:10:35,513 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-62781284:ctest-mgmt_vn-91470526 virtual network link through opserver 10.0.0.73
2025-10-23 03:10:35,513 - DEBUG - Requesting: http://10.0.0.73:8081/analytics/uves/virtual-networks
2025-10-23 03:10:35,527 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-62781284:ctest-mgmt_vn-91470526', 'href': 'http://10.0.0.73:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-62781284:ctest-mgmt_vn-91470526?flat'}
2025-10-23 03:10:35,527 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-62781284:ctest-mgmt_vn-91470526 virtual network link through opserver 10.0.0.133
2025-10-23 03:10:35,527 - DEBUG - Requesting: http://10.0.0.133:8081/analytics/uves/virtual-networks
2025-10-23 03:10:35,539 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-62781284:ctest-mgmt_vn-91470526', 'href': 'http://10.0.0.133:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-62781284:ctest-mgmt_vn-91470526?flat'}
2025-10-23 03:10:35,539 - INFO - Validated that VN default-domain:ctest-TestSvcHC-62781284:ctest-mgmt_vn-91470526 is found in opserver
2025-10-23 03:10:35,563 - DEBUG - Do not have enough data to verify VN in agent
2025-10-23 03:10:35,574 - DEBUG - VRF ids for VN ctest-mgmt_vn-91470526: {}
2025-10-23 03:10:35,845 - DEBUG - Response for create_network : {'network': {'id': '928754d2-c80f-4bc3-a887-678ced7b0cfd', 'name': 'ctest-left_vn-13400834', 'tenant_id': 'c00701fed6654cba8761ee558f28c2b9', 'project_id': 'c00701fed6654cba8761ee558f28c2b9', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-62781284', 'ctest-left_vn-13400834'], 'port_security_enabled': True, 'description': ''}}
2025-10-23 03:10:36,132 - DEBUG - Response for create_subnet : {'subnet': {'id': '04667aed-d884-4b53-b799-fcc466561a8d', 'name': '', 'tenant_id': 'c00701fed6654cba8761ee558f28c2b9', 'network_id': '928754d2-c80f-4bc3-a887-678ced7b0cfd', 'ip_version': 4, 'cidr': '121.73.93.0/26', 'allocation_pools': [{'start': '121.73.93.2', 'end': '121.73.93.62'}], 'gateway_ip': '121.73.93.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '121.73.93.2', 'tags': [], 'project_id': 'c00701fed6654cba8761ee558f28c2b9'}}
2025-10-23 03:10:36,154 - INFO - Created VN ctest-left_vn-13400834
2025-10-23 03:10:36,167 - DEBUG - VN ctest-left_vn-13400834 UUID is 928754d2-c80f-4bc3-a887-678ced7b0cfd
2025-10-23 03:10:36,242 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2025-10-23 03:10:36,249 - DEBUG - Requesting: http://10.0.0.41:8082/domain/4ac2eafd-52e8-4f65-a1ce-6478676e3af6
2025-10-23 03:10:36,261 - DEBUG - Requesting: http://10.0.0.41:8082/project/c00701fe-d665-4cba-8761-ee558f28c2b9
2025-10-23 03:10:36,376 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/928754d2-c80f-4bc3-a887-678ced7b0cfd
2025-10-23 03:10:36,389 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/928754d2-c80f-4bc3-a887-678ced7b0cfd
2025-10-23 03:10:36,405 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/d6c0d992-0371-4c7f-b1be-45967f203303
2025-10-23 03:10:36,417 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/d6c0d992-0371-4c7f-b1be-45967f203303
2025-10-23 03:10:36,428 - DEBUG - Requesting: http://10.0.0.41:8082/route-target/fdd7df56-6a36-45c4-a7b6-52574b937560
2025-10-23 03:10:36,438 - DEBUG - Route Targets: ['target:64512:8000005']
2025-10-23 03:10:36,438 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/928754d2-c80f-4bc3-a887-678ced7b0cfd
2025-10-23 03:10:36,451 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/d6c0d992-0371-4c7f-b1be-45967f203303
2025-10-23 03:10:36,470 - INFO - Verified VN network id 16 for VN 928754d2-c80f-4bc3-a887-678ced7b0cfd
2025-10-23 03:10:36,471 - INFO - Verifications in API Server for VN ctest-left_vn-13400834 passed
2025-10-23 03:10:36,471 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/928754d2-c80f-4bc3-a887-678ced7b0cfd
2025-10-23 03:10:36,491 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/d6c0d992-0371-4c7f-b1be-45967f203303
2025-10-23 03:10:36,501 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/d6c0d992-0371-4c7f-b1be-45967f203303
2025-10-23 03:10:36,509 - DEBUG - Requesting: http://10.0.0.41:8082/route-target/fdd7df56-6a36-45c4-a7b6-52574b937560
2025-10-23 03:10:36,524 - DEBUG - Control-node 10.0.0.41 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-62781284:ctest-left_vn-13400834', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-62781284', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10558501115669728195', 'uuid-lslong': '12143788775205178621'}, 'enable': 'true', 'created': '2025-10-23T03:10:35', 'last-modified': '2025-10-23T03:10:36', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.472028'}
2025-10-23 03:10:36,531 - DEBUG - Route Targets: ['target:64512:8000005']
2025-10-23 03:10:36,536 - DEBUG - Control-node 10.0.0.73 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-62781284:ctest-left_vn-13400834', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-62781284', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10558501115669728195', 'uuid-lslong': '12143788775205178621'}, 'enable': 'true', 'created': '2025-10-23T03:10:35', 'last-modified': '2025-10-23T03:10:36', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.489375'}
2025-10-23 03:10:36,542 - DEBUG - Route Targets: ['target:64512:8000005']
2025-10-23 03:10:36,547 - DEBUG - Control-node 10.0.0.133 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-62781284:ctest-left_vn-13400834', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-62781284', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10558501115669728195', 'uuid-lslong': '12143788775205178621'}, 'enable': 'true', 'created': '2025-10-23T03:10:35', 'last-modified': '2025-10-23T03:10:36', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.484807'}
2025-10-23 03:10:36,553 - DEBUG - Route Targets: ['target:64512:8000005']
2025-10-23 03:10:36,553 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-13400834 passed
2025-10-23 03:10:36,554 - DEBUG - ====Verifying policy data for ctest-left_vn-13400834 in API_Server ======
2025-10-23 03:10:36,554 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2025-10-23 03:10:36,560 - DEBUG - Requesting: http://10.0.0.41:8082/domain/4ac2eafd-52e8-4f65-a1ce-6478676e3af6
2025-10-23 03:10:36,574 - DEBUG - Requesting: http://10.0.0.41:8082/project/c00701fe-d665-4cba-8761-ee558f28c2b9
2025-10-23 03:10:36,692 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/928754d2-c80f-4bc3-a887-678ced7b0cfd
2025-10-23 03:10:36,709 - DEBUG - =>VN ctest-left_vn-13400834 has no policy to be verified
2025-10-23 03:10:36,709 - DEBUG - Verifying the vn in opserver
2025-10-23 03:10:36,709 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-62781284:ctest-left_vn-13400834 virtual network link through opserver 10.0.0.41
2025-10-23 03:10:36,709 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-networks
2025-10-23 03:10:36,731 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-62781284:ctest-left_vn-13400834', 'href': 'http://10.0.0.41:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-62781284:ctest-left_vn-13400834?flat'}
2025-10-23 03:10:36,731 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-62781284:ctest-left_vn-13400834 virtual network link through opserver 10.0.0.73
2025-10-23 03:10:36,731 - DEBUG - Requesting: http://10.0.0.73:8081/analytics/uves/virtual-networks
2025-10-23 03:10:36,746 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-62781284:ctest-left_vn-13400834', 'href': 'http://10.0.0.73:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-62781284:ctest-left_vn-13400834?flat'}
2025-10-23 03:10:36,746 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-62781284:ctest-left_vn-13400834 virtual network link through opserver 10.0.0.133
2025-10-23 03:10:36,746 - DEBUG - Requesting: http://10.0.0.133:8081/analytics/uves/virtual-networks
2025-10-23 03:10:36,761 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-62781284:ctest-left_vn-13400834', 'href': 'http://10.0.0.133:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-62781284:ctest-left_vn-13400834?flat'}
2025-10-23 03:10:36,761 - INFO - Validated that VN default-domain:ctest-TestSvcHC-62781284:ctest-left_vn-13400834 is found in opserver
2025-10-23 03:10:36,793 - DEBUG - Do not have enough data to verify VN in agent
2025-10-23 03:10:36,809 - DEBUG - VRF ids for VN ctest-left_vn-13400834: {}
2025-10-23 03:10:37,105 - DEBUG - Response for create_network : {'network': {'id': '3e42957e-28db-4e6f-8033-d52602d37751', 'name': 'ctest-right_vn-54699601', 'tenant_id': 'c00701fed6654cba8761ee558f28c2b9', 'project_id': 'c00701fed6654cba8761ee558f28c2b9', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-62781284', 'ctest-right_vn-54699601'], 'port_security_enabled': True, 'description': ''}}
2025-10-23 03:10:37,393 - DEBUG - Response for create_subnet : {'subnet': {'id': 'bcf49cf7-703a-4b40-8f24-049f77a6a6e7', 'name': '', 'tenant_id': 'c00701fed6654cba8761ee558f28c2b9', 'network_id': '3e42957e-28db-4e6f-8033-d52602d37751', 'ip_version': 4, 'cidr': '58.128.34.128/26', 'allocation_pools': [{'start': '58.128.34.130', 'end': '58.128.34.190'}], 'gateway_ip': '58.128.34.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '58.128.34.130', 'tags': [], 'project_id': 'c00701fed6654cba8761ee558f28c2b9'}}
2025-10-23 03:10:37,416 - INFO - Created VN ctest-right_vn-54699601
2025-10-23 03:10:37,428 - DEBUG - VN ctest-right_vn-54699601 UUID is 3e42957e-28db-4e6f-8033-d52602d37751
2025-10-23 03:10:37,507 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2025-10-23 03:10:37,514 - DEBUG - Requesting: http://10.0.0.41:8082/domain/4ac2eafd-52e8-4f65-a1ce-6478676e3af6
2025-10-23 03:10:37,526 - DEBUG - Requesting: http://10.0.0.41:8082/project/c00701fe-d665-4cba-8761-ee558f28c2b9
2025-10-23 03:10:37,621 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/3e42957e-28db-4e6f-8033-d52602d37751
2025-10-23 03:10:37,633 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/3e42957e-28db-4e6f-8033-d52602d37751
2025-10-23 03:10:37,644 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/a5661d55-ebe6-4e23-9535-c480f99b1f25
2025-10-23 03:10:37,653 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/a5661d55-ebe6-4e23-9535-c480f99b1f25
2025-10-23 03:10:37,661 - DEBUG - Requesting: http://10.0.0.41:8082/route-target/a6b64a8e-87e7-425c-b48c-2847bfbb71f8
2025-10-23 03:10:37,668 - DEBUG - Route Targets: ['target:64512:8000006']
2025-10-23 03:10:37,668 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/3e42957e-28db-4e6f-8033-d52602d37751
2025-10-23 03:10:37,678 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/a5661d55-ebe6-4e23-9535-c480f99b1f25
2025-10-23 03:10:37,696 - INFO - Verified VN network id 17 for VN 3e42957e-28db-4e6f-8033-d52602d37751
2025-10-23 03:10:37,696 - INFO - Verifications in API Server for VN ctest-right_vn-54699601 passed
2025-10-23 03:10:37,696 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/3e42957e-28db-4e6f-8033-d52602d37751
2025-10-23 03:10:37,706 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/a5661d55-ebe6-4e23-9535-c480f99b1f25
2025-10-23 03:10:37,714 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/a5661d55-ebe6-4e23-9535-c480f99b1f25
2025-10-23 03:10:37,722 - DEBUG - Requesting: http://10.0.0.41:8082/route-target/a6b64a8e-87e7-425c-b48c-2847bfbb71f8
2025-10-23 03:10:37,735 - DEBUG - Control-node 10.0.0.41 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-62781284:ctest-right_vn-54699601', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-62781284', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4486312547898314351', 'uuid-lslong': '9237961619899905873'}, 'enable': 'true', 'created': '2025-10-23T03:10:37', 'last-modified': '2025-10-23T03:10:37', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.422426'}
2025-10-23 03:10:37,741 - DEBUG - Route Targets: ['target:64512:8000006']
2025-10-23 03:10:37,746 - DEBUG - Control-node 10.0.0.73 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-62781284:ctest-right_vn-54699601', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-62781284', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4486312547898314351', 'uuid-lslong': '9237961619899905873'}, 'enable': 'true', 'created': '2025-10-23T03:10:37', 'last-modified': '2025-10-23T03:10:37', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.440513'}
2025-10-23 03:10:37,752 - DEBUG - Route Targets: ['target:64512:8000006']
2025-10-23 03:10:37,757 - DEBUG - Control-node 10.0.0.133 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-62781284:ctest-right_vn-54699601', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-62781284', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4486312547898314351', 'uuid-lslong': '9237961619899905873'}, 'enable': 'true', 'created': '2025-10-23T03:10:37', 'last-modified': '2025-10-23T03:10:37', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.450521'}
2025-10-23 03:10:37,764 - DEBUG - Route Targets: ['target:64512:8000006']
2025-10-23 03:10:37,764 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-54699601 passed
2025-10-23 03:10:37,764 - DEBUG - ====Verifying policy data for ctest-right_vn-54699601 in API_Server ======
2025-10-23 03:10:37,764 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2025-10-23 03:10:37,771 - DEBUG - Requesting: http://10.0.0.41:8082/domain/4ac2eafd-52e8-4f65-a1ce-6478676e3af6
2025-10-23 03:10:37,783 - DEBUG - Requesting: http://10.0.0.41:8082/project/c00701fe-d665-4cba-8761-ee558f28c2b9
2025-10-23 03:10:37,884 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/3e42957e-28db-4e6f-8033-d52602d37751
2025-10-23 03:10:37,896 - DEBUG - =>VN ctest-right_vn-54699601 has no policy to be verified
2025-10-23 03:10:37,896 - DEBUG - Verifying the vn in opserver
2025-10-23 03:10:37,896 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-62781284:ctest-right_vn-54699601 virtual network link through opserver 10.0.0.41
2025-10-23 03:10:37,896 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-networks
2025-10-23 03:10:37,910 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-62781284:ctest-right_vn-54699601', 'href': 'http://10.0.0.41:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-62781284:ctest-right_vn-54699601?flat'}
2025-10-23 03:10:37,910 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-62781284:ctest-right_vn-54699601 virtual network link through opserver 10.0.0.73
2025-10-23 03:10:37,910 - DEBUG - Requesting: http://10.0.0.73:8081/analytics/uves/virtual-networks
2025-10-23 03:10:37,923 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-62781284:ctest-right_vn-54699601', 'href': 'http://10.0.0.73:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-62781284:ctest-right_vn-54699601?flat'}
2025-10-23 03:10:37,923 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-62781284:ctest-right_vn-54699601 virtual network link through opserver 10.0.0.133
2025-10-23 03:10:37,923 - DEBUG - Requesting: http://10.0.0.133:8081/analytics/uves/virtual-networks
2025-10-23 03:10:37,937 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-62781284:ctest-right_vn-54699601', 'href': 'http://10.0.0.133:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-62781284:ctest-right_vn-54699601?flat'}
2025-10-23 03:10:37,937 - INFO - Validated that VN default-domain:ctest-TestSvcHC-62781284:ctest-right_vn-54699601 is found in opserver
2025-10-23 03:10:37,961 - DEBUG - Do not have enough data to verify VN in agent
2025-10-23 03:10:37,973 - DEBUG - VRF ids for VN ctest-right_vn-54699601: {}
2025-10-23 03:10:38,255 - DEBUG - Response for create_network : {'network': {'id': '6c1fe787-17c0-407f-a8c3-9236f7abedbf', 'name': 'ctest-trans_left_vn-27258479', 'tenant_id': 'c00701fed6654cba8761ee558f28c2b9', 'project_id': 'c00701fed6654cba8761ee558f28c2b9', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-62781284', 'ctest-trans_left_vn-27258479'], 'port_security_enabled': True, 'description': ''}}
2025-10-23 03:10:38,509 - DEBUG - Response for create_subnet : {'subnet': {'id': 'efdb12ce-25af-4288-be93-da19eee0fe05', 'name': '', 'tenant_id': 'c00701fed6654cba8761ee558f28c2b9', 'network_id': '6c1fe787-17c0-407f-a8c3-9236f7abedbf', 'ip_version': 4, 'cidr': '114.212.73.0/26', 'allocation_pools': [{'start': '114.212.73.2', 'end': '114.212.73.62'}], 'gateway_ip': '114.212.73.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '114.212.73.2', 'tags': [], 'project_id': 'c00701fed6654cba8761ee558f28c2b9'}}
2025-10-23 03:10:38,536 - INFO - Created VN ctest-trans_left_vn-27258479
2025-10-23 03:10:38,549 - DEBUG - VN ctest-trans_left_vn-27258479 UUID is 6c1fe787-17c0-407f-a8c3-9236f7abedbf
2025-10-23 03:10:38,627 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2025-10-23 03:10:38,634 - DEBUG - Requesting: http://10.0.0.41:8082/domain/4ac2eafd-52e8-4f65-a1ce-6478676e3af6
2025-10-23 03:10:38,648 - DEBUG - Requesting: http://10.0.0.41:8082/project/c00701fe-d665-4cba-8761-ee558f28c2b9
2025-10-23 03:10:38,757 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/6c1fe787-17c0-407f-a8c3-9236f7abedbf
2025-10-23 03:10:38,777 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/6c1fe787-17c0-407f-a8c3-9236f7abedbf
2025-10-23 03:10:38,790 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/df557574-3dd7-4cd1-a238-142d3e9c8f99
2025-10-23 03:10:38,800 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/df557574-3dd7-4cd1-a238-142d3e9c8f99
2025-10-23 03:10:38,808 - DEBUG - Requesting: http://10.0.0.41:8082/route-target/5b406039-d3fb-46dd-91ab-2d7d22c01299
2025-10-23 03:10:38,816 - DEBUG - Route Targets: ['target:64512:8000007']
2025-10-23 03:10:38,816 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/6c1fe787-17c0-407f-a8c3-9236f7abedbf
2025-10-23 03:10:38,826 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/df557574-3dd7-4cd1-a238-142d3e9c8f99
2025-10-23 03:10:38,843 - INFO - Verified VN network id 18 for VN 6c1fe787-17c0-407f-a8c3-9236f7abedbf
2025-10-23 03:10:38,843 - INFO - Verifications in API Server for VN ctest-trans_left_vn-27258479 passed
2025-10-23 03:10:38,843 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/6c1fe787-17c0-407f-a8c3-9236f7abedbf
2025-10-23 03:10:38,857 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/df557574-3dd7-4cd1-a238-142d3e9c8f99
2025-10-23 03:10:38,870 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/df557574-3dd7-4cd1-a238-142d3e9c8f99
2025-10-23 03:10:38,880 - DEBUG - Requesting: http://10.0.0.41:8082/route-target/5b406039-d3fb-46dd-91ab-2d7d22c01299
2025-10-23 03:10:38,895 - DEBUG - Control-node 10.0.0.41 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-62781284:ctest-trans_left_vn-27258479', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-62781284', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7791200447779324031', 'uuid-lslong': '12160724183611600319'}, 'enable': 'true', 'created': '2025-10-23T03:10:38', 'last-modified': '2025-10-23T03:10:38', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.441805'}
2025-10-23 03:10:38,903 - DEBUG - Route Targets: ['target:64512:8000007']
2025-10-23 03:10:38,908 - DEBUG - Control-node 10.0.0.73 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-62781284:ctest-trans_left_vn-27258479', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-62781284', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7791200447779324031', 'uuid-lslong': '12160724183611600319'}, 'enable': 'true', 'created': '2025-10-23T03:10:38', 'last-modified': '2025-10-23T03:10:38', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.449907'}
2025-10-23 03:10:38,915 - DEBUG - Route Targets: ['target:64512:8000007']
2025-10-23 03:10:38,922 - DEBUG - Control-node 10.0.0.133 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-62781284:ctest-trans_left_vn-27258479', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-62781284', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7791200447779324031', 'uuid-lslong': '12160724183611600319'}, 'enable': 'true', 'created': '2025-10-23T03:10:38', 'last-modified': '2025-10-23T03:10:38', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.469954'}
2025-10-23 03:10:38,929 - DEBUG - Route Targets: ['target:64512:8000007']
2025-10-23 03:10:38,929 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_left_vn-27258479 passed
2025-10-23 03:10:38,929 - DEBUG - ====Verifying policy data for ctest-trans_left_vn-27258479 in API_Server ======
2025-10-23 03:10:38,929 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2025-10-23 03:10:38,937 - DEBUG - Requesting: http://10.0.0.41:8082/domain/4ac2eafd-52e8-4f65-a1ce-6478676e3af6
2025-10-23 03:10:38,950 - DEBUG - Requesting: http://10.0.0.41:8082/project/c00701fe-d665-4cba-8761-ee558f28c2b9
2025-10-23 03:10:39,047 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/6c1fe787-17c0-407f-a8c3-9236f7abedbf
2025-10-23 03:10:39,058 - DEBUG - =>VN ctest-trans_left_vn-27258479 has no policy to be verified
2025-10-23 03:10:39,059 - DEBUG - Verifying the vn in opserver
2025-10-23 03:10:39,059 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-62781284:ctest-trans_left_vn-27258479 virtual network link through opserver 10.0.0.41
2025-10-23 03:10:39,059 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-networks
2025-10-23 03:10:39,072 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-62781284:ctest-trans_left_vn-27258479', 'href': 'http://10.0.0.41:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-62781284:ctest-trans_left_vn-27258479?flat'}
2025-10-23 03:10:39,072 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-62781284:ctest-trans_left_vn-27258479 virtual network link through opserver 10.0.0.73
2025-10-23 03:10:39,072 - DEBUG - Requesting: http://10.0.0.73:8081/analytics/uves/virtual-networks
2025-10-23 03:10:39,093 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-62781284:ctest-trans_left_vn-27258479', 'href': 'http://10.0.0.73:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-62781284:ctest-trans_left_vn-27258479?flat'}
2025-10-23 03:10:39,093 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-62781284:ctest-trans_left_vn-27258479 virtual network link through opserver 10.0.0.133
2025-10-23 03:10:39,093 - DEBUG - Requesting: http://10.0.0.133:8081/analytics/uves/virtual-networks
2025-10-23 03:10:39,107 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-62781284:ctest-trans_left_vn-27258479', 'href': 'http://10.0.0.133:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-62781284:ctest-trans_left_vn-27258479?flat'}
2025-10-23 03:10:39,107 - INFO - Validated that VN default-domain:ctest-TestSvcHC-62781284:ctest-trans_left_vn-27258479 is found in opserver
2025-10-23 03:10:39,132 - DEBUG - Do not have enough data to verify VN in agent
2025-10-23 03:10:39,143 - DEBUG - VRF ids for VN ctest-trans_left_vn-27258479: {}
2025-10-23 03:10:39,415 - DEBUG - Response for create_network : {'network': {'id': 'd8bbf4cd-4ba3-4381-8cfa-02edd411a138', 'name': 'ctest-trans_right_vn-29782373', 'tenant_id': 'c00701fed6654cba8761ee558f28c2b9', 'project_id': 'c00701fed6654cba8761ee558f28c2b9', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-62781284', 'ctest-trans_right_vn-29782373'], 'port_security_enabled': True, 'description': ''}}
2025-10-23 03:10:39,683 - DEBUG - Response for create_subnet : {'subnet': {'id': '0d785fd9-0114-4d2d-b913-efbb5b907f87', 'name': '', 'tenant_id': 'c00701fed6654cba8761ee558f28c2b9', 'network_id': 'd8bbf4cd-4ba3-4381-8cfa-02edd411a138', 'ip_version': 4, 'cidr': '207.134.82.192/26', 'allocation_pools': [{'start': '207.134.82.194', 'end': '207.134.82.254'}], 'gateway_ip': '207.134.82.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '207.134.82.194', 'tags': [], 'project_id': 'c00701fed6654cba8761ee558f28c2b9'}}
2025-10-23 03:10:39,717 - INFO - Created VN ctest-trans_right_vn-29782373
2025-10-23 03:10:39,734 - DEBUG - VN ctest-trans_right_vn-29782373 UUID is d8bbf4cd-4ba3-4381-8cfa-02edd411a138
2025-10-23 03:10:39,818 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2025-10-23 03:10:39,824 - DEBUG - Requesting: http://10.0.0.41:8082/domain/4ac2eafd-52e8-4f65-a1ce-6478676e3af6
2025-10-23 03:10:39,835 - DEBUG - Requesting: http://10.0.0.41:8082/project/c00701fe-d665-4cba-8761-ee558f28c2b9
2025-10-23 03:10:39,936 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/d8bbf4cd-4ba3-4381-8cfa-02edd411a138
2025-10-23 03:10:39,951 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/d8bbf4cd-4ba3-4381-8cfa-02edd411a138
2025-10-23 03:10:39,964 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/10292561-063b-4489-a3bf-acb19f89b1a1
2025-10-23 03:10:39,972 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/10292561-063b-4489-a3bf-acb19f89b1a1
2025-10-23 03:10:39,979 - DEBUG - Requesting: http://10.0.0.41:8082/route-target/8d432ab9-04f8-4242-9d4a-b7bfea0d9ed2
2025-10-23 03:10:39,987 - DEBUG - Route Targets: ['target:64512:8000008']
2025-10-23 03:10:39,987 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/d8bbf4cd-4ba3-4381-8cfa-02edd411a138
2025-10-23 03:10:39,999 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/10292561-063b-4489-a3bf-acb19f89b1a1
2025-10-23 03:10:40,016 - INFO - Verified VN network id 19 for VN d8bbf4cd-4ba3-4381-8cfa-02edd411a138
2025-10-23 03:10:40,016 - INFO - Verifications in API Server for VN ctest-trans_right_vn-29782373 passed
2025-10-23 03:10:40,016 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/d8bbf4cd-4ba3-4381-8cfa-02edd411a138
2025-10-23 03:10:40,029 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/10292561-063b-4489-a3bf-acb19f89b1a1
2025-10-23 03:10:40,037 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/10292561-063b-4489-a3bf-acb19f89b1a1
2025-10-23 03:10:40,045 - DEBUG - Requesting: http://10.0.0.41:8082/route-target/8d432ab9-04f8-4242-9d4a-b7bfea0d9ed2
2025-10-23 03:10:40,060 - DEBUG - Control-node 10.0.0.41 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-62781284:ctest-trans_right_vn-29782373', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-62781284', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '15617345295411790721', 'uuid-lslong': '10158435129976004920'}, 'enable': 'true', 'created': '2025-10-23T03:10:39', 'last-modified': '2025-10-23T03:10:39', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.442155'}
2025-10-23 03:10:40,066 - DEBUG - Route Targets: ['target:64512:8000008']
2025-10-23 03:10:40,071 - DEBUG - Control-node 10.0.0.73 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-62781284:ctest-trans_right_vn-29782373', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-62781284', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '15617345295411790721', 'uuid-lslong': '10158435129976004920'}, 'enable': 'true', 'created': '2025-10-23T03:10:39', 'last-modified': '2025-10-23T03:10:39', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.457020'}
2025-10-23 03:10:40,077 - DEBUG - Route Targets: ['target:64512:8000008']
2025-10-23 03:10:40,085 - DEBUG - Control-node 10.0.0.133 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-62781284:ctest-trans_right_vn-29782373', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-62781284', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '15617345295411790721', 'uuid-lslong': '10158435129976004920'}, 'enable': 'true', 'created': '2025-10-23T03:10:39', 'last-modified': '2025-10-23T03:10:39', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.467923'}
2025-10-23 03:10:40,090 - DEBUG - Route Targets: ['target:64512:8000008']
2025-10-23 03:10:40,090 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_right_vn-29782373 passed
2025-10-23 03:10:40,091 - DEBUG - ====Verifying policy data for ctest-trans_right_vn-29782373 in API_Server ======
2025-10-23 03:10:40,091 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2025-10-23 03:10:40,098 - DEBUG - Requesting: http://10.0.0.41:8082/domain/4ac2eafd-52e8-4f65-a1ce-6478676e3af6
2025-10-23 03:10:40,111 - DEBUG - Requesting: http://10.0.0.41:8082/project/c00701fe-d665-4cba-8761-ee558f28c2b9
2025-10-23 03:10:40,220 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/d8bbf4cd-4ba3-4381-8cfa-02edd411a138
2025-10-23 03:10:40,232 - DEBUG - =>VN ctest-trans_right_vn-29782373 has no policy to be verified
2025-10-23 03:10:40,232 - DEBUG - Verifying the vn in opserver
2025-10-23 03:10:40,232 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-62781284:ctest-trans_right_vn-29782373 virtual network link through opserver 10.0.0.41
2025-10-23 03:10:40,233 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-networks
2025-10-23 03:10:40,247 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-62781284:ctest-trans_right_vn-29782373', 'href': 'http://10.0.0.41:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-62781284:ctest-trans_right_vn-29782373?flat'}
2025-10-23 03:10:40,248 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-62781284:ctest-trans_right_vn-29782373 virtual network link through opserver 10.0.0.73
2025-10-23 03:10:40,248 - DEBUG - Requesting: http://10.0.0.73:8081/analytics/uves/virtual-networks
2025-10-23 03:10:40,261 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-62781284:ctest-trans_right_vn-29782373', 'href': 'http://10.0.0.73:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-62781284:ctest-trans_right_vn-29782373?flat'}
2025-10-23 03:10:40,261 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-62781284:ctest-trans_right_vn-29782373 virtual network link through opserver 10.0.0.133
2025-10-23 03:10:40,261 - DEBUG - Requesting: http://10.0.0.133:8081/analytics/uves/virtual-networks
2025-10-23 03:10:40,276 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-62781284:ctest-trans_right_vn-29782373', 'href': 'http://10.0.0.133:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-62781284:ctest-trans_right_vn-29782373?flat'}
2025-10-23 03:10:40,276 - INFO - Validated that VN default-domain:ctest-TestSvcHC-62781284:ctest-trans_right_vn-29782373 is found in opserver
2025-10-23 03:10:40,298 - DEBUG - Do not have enough data to verify VN in agent
2025-10-23 03:10:40,309 - DEBUG - VRF ids for VN ctest-trans_right_vn-29782373: {}
2025-10-23 03:10:41,560 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4448-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4448-1)
2025-10-23 03:10:43,078 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4448-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4448-2)
2025-10-23 03:10:43,079 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-73442700']
2025-10-23 03:10:43,366 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-73442700'] created succesfully
2025-10-23 03:10:43,783 - DEBUG - Image by name tiny_trans_fw not found
2025-10-23 03:10:43,783 - DEBUG - Installing image tiny_trans_fw
2025-10-23 03:10:43,783 - 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-23 03:10:43,783 - DEBUG - Image build path file:///contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2025-10-23 03:10:43,783 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2025-10-23 03:10:43,784 - DEBUG - Unzip image
2025-10-23 03:10:43,784 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2025-10-23 03:10:43,814 - INFO - image /contrail-test/images/tinycore-net-transparent-fw.qcow2 is not found
2025-10-23 03:10:43,817 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-73442700']
2025-10-23 03:10:43,908 - INFO - Service template: ['default-domain', 'ctest-service_template_1-73442700'] deleted successfully.
2025-10-23 03:10:43,908 - INFO - Skip interface_detach for VM ctest-right_vm-55860634 in state BUILD
2025-10-23 03:10:43,908 - INFO - Deleting VM ctest-right_vm-55860634
2025-10-23 03:10:43,908 - ERROR - VM ctest-right_vm-55860634 has failed to come up
2025-10-23 03:10:43,908 - ERROR - Nova failed to get host of the VM
2025-10-23 03:10:43,909 - ERROR - VM ctest-right_vm-55860634 has failed to come up
2025-10-23 03:10:43,909 - ERROR - Nova failed to get host of the VM
2025-10-23 03:10:44,044 - INFO - Skip interface_detach for VM ctest-left_vm-24379690 in state BUILD
2025-10-23 03:10:44,044 - INFO - Deleting VM ctest-left_vm-24379690
2025-10-23 03:10:44,044 - ERROR - VM ctest-left_vm-24379690 has failed to come up
2025-10-23 03:10:44,044 - ERROR - Nova failed to get host of the VM
2025-10-23 03:10:44,044 - ERROR - VM ctest-left_vm-24379690 has failed to come up
2025-10-23 03:10:44,044 - ERROR - Nova failed to get host of the VM
2025-10-23 03:10:44,142 - INFO - Deleting VN ctest-trans_right_vn-29782373
2025-10-23 03:10:44,302 - DEBUG - Response for deleting network ()
2025-10-23 03:10:44,302 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/10292561-063b-4489-a3bf-acb19f89b1a1
2025-10-23 03:10:44,310 - DEBUG - Response Code: 404
2025-10-23 03:10:44,310 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2025-10-23 03:10:44,319 - DEBUG - Requesting: http://10.0.0.41:8082/domain/4ac2eafd-52e8-4f65-a1ce-6478676e3af6
2025-10-23 03:10:44,335 - DEBUG - Requesting: http://10.0.0.41:8082/project/c00701fe-d665-4cba-8761-ee558f28c2b9
2025-10-23 03:10:44,435 - INFO - Validated that VN ctest-trans_right_vn-29782373 is not found in API Server
2025-10-23 03:10:44,448 - DEBUG - VN ctest-trans_right_vn-29782373 is not present in Agent 10.0.0.48
2025-10-23 03:10:44,512 - DEBUG - VN ctest-trans_right_vn-29782373 is not present in Agent 10.0.0.49
2025-10-23 03:10:44,513 - INFO - Validated that VN ctest-trans_right_vn-29782373 is not in any agent
2025-10-23 03:10:44,560 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-trans_right_vn-29782373 info
2025-10-23 03:10:44,560 - INFO - Deleting VN ctest-trans_left_vn-27258479
2025-10-23 03:10:44,716 - DEBUG - Response for deleting network ()
2025-10-23 03:10:44,716 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/df557574-3dd7-4cd1-a238-142d3e9c8f99
2025-10-23 03:10:44,732 - DEBUG - Response Code: 404
2025-10-23 03:10:44,732 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2025-10-23 03:10:44,740 - DEBUG - Requesting: http://10.0.0.41:8082/domain/4ac2eafd-52e8-4f65-a1ce-6478676e3af6
2025-10-23 03:10:44,756 - DEBUG - Requesting: http://10.0.0.41:8082/project/c00701fe-d665-4cba-8761-ee558f28c2b9
2025-10-23 03:10:44,851 - INFO - Validated that VN ctest-trans_left_vn-27258479 is not found in API Server
2025-10-23 03:10:44,870 - DEBUG - VN ctest-trans_left_vn-27258479 is not present in Agent 10.0.0.48
2025-10-23 03:10:44,890 - DEBUG - VN ctest-trans_left_vn-27258479 is not present in Agent 10.0.0.49
2025-10-23 03:10:44,890 - INFO - Validated that VN ctest-trans_left_vn-27258479 is not in any agent
2025-10-23 03:10:44,933 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-trans_left_vn-27258479 info
2025-10-23 03:10:44,933 - INFO - Deleting VN ctest-right_vn-54699601
2025-10-23 03:10:45,011 - DEBUG - VN 3e42957e-28db-4e6f-8033-d52602d37751 still in use: Unable to complete operation on network 3e42957e-28db-4e6f-8033-d52602d37751. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-6bca1473-6683-4b0a-ab93-76e3e22b412a']
2025-10-23 03:10:45,012 - WARNING - Deleting VN ctest-right_vn-54699601 failed..Will retry
2025-10-23 03:10:47,221 - DEBUG - Response for deleting network ()
2025-10-23 03:10:47,221 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/a5661d55-ebe6-4e23-9535-c480f99b1f25
2025-10-23 03:10:47,232 - DEBUG - Response Code: 404
2025-10-23 03:10:47,232 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2025-10-23 03:10:47,240 - DEBUG - Requesting: http://10.0.0.41:8082/domain/4ac2eafd-52e8-4f65-a1ce-6478676e3af6
2025-10-23 03:10:47,255 - DEBUG - Requesting: http://10.0.0.41:8082/project/c00701fe-d665-4cba-8761-ee558f28c2b9
2025-10-23 03:10:47,361 - INFO - Validated that VN ctest-right_vn-54699601 is not found in API Server
2025-10-23 03:10:47,374 - DEBUG - VN ctest-right_vn-54699601 is not present in Agent 10.0.0.48
2025-10-23 03:10:47,386 - DEBUG - VN ctest-right_vn-54699601 is not present in Agent 10.0.0.49
2025-10-23 03:10:47,386 - INFO - Validated that VN ctest-right_vn-54699601 is not in any agent
2025-10-23 03:10:47,421 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-54699601 info
2025-10-23 03:10:47,421 - INFO - Deleting VN ctest-left_vn-13400834
2025-10-23 03:10:47,561 - DEBUG - Response for deleting network ()
2025-10-23 03:10:47,561 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/d6c0d992-0371-4c7f-b1be-45967f203303
2025-10-23 03:10:47,567 - DEBUG - Response Code: 404
2025-10-23 03:10:47,567 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2025-10-23 03:10:47,573 - DEBUG - Requesting: http://10.0.0.41:8082/domain/4ac2eafd-52e8-4f65-a1ce-6478676e3af6
2025-10-23 03:10:47,606 - DEBUG - Requesting: http://10.0.0.41:8082/project/c00701fe-d665-4cba-8761-ee558f28c2b9
2025-10-23 03:10:47,714 - INFO - Validated that VN ctest-left_vn-13400834 is not found in API Server
2025-10-23 03:10:47,726 - DEBUG - VN ctest-left_vn-13400834 is not present in Agent 10.0.0.48
2025-10-23 03:10:47,738 - DEBUG - VN ctest-left_vn-13400834 is not present in Agent 10.0.0.49
2025-10-23 03:10:47,738 - INFO - Validated that VN ctest-left_vn-13400834 is not in any agent
2025-10-23 03:10:47,779 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-13400834 info
2025-10-23 03:10:47,779 - INFO - Deleting VN ctest-mgmt_vn-91470526
2025-10-23 03:10:47,938 - DEBUG - Response for deleting network ()
2025-10-23 03:10:47,938 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/68d8f17e-3fdf-42f4-a231-8f346cbca3be
2025-10-23 03:10:47,966 - DEBUG - Response Code: 404
2025-10-23 03:10:47,966 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2025-10-23 03:10:47,977 - DEBUG - Requesting: http://10.0.0.41:8082/domain/4ac2eafd-52e8-4f65-a1ce-6478676e3af6
2025-10-23 03:10:47,992 - DEBUG - Requesting: http://10.0.0.41:8082/project/c00701fe-d665-4cba-8761-ee558f28c2b9
2025-10-23 03:10:48,104 - INFO - Validated that VN ctest-mgmt_vn-91470526 is not found in API Server
2025-10-23 03:10:48,117 - DEBUG - VN ctest-mgmt_vn-91470526 is not present in Agent 10.0.0.48
2025-10-23 03:10:48,131 - DEBUG - VN ctest-mgmt_vn-91470526 is not present in Agent 10.0.0.49
2025-10-23 03:10:48,131 - INFO - Validated that VN ctest-mgmt_vn-91470526 is not in any agent
2025-10-23 03:10:48,178 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-91470526 info
2025-10-23 03:10:49,466 - DEBUG - No XMPP flaps were noticed during the test
2025-10-23 03:10:49,466 - INFO -
2025-10-23 03:10:49,467 - INFO - END TEST : test_svc_trans_segment_right_hc_fail_svm : SKIPPED[0:00:16]
2025-10-23 03:10:49,467 - INFO - --------------------------------------------------------------------------------
2025-10-23 03:10:50,320 - INFO - Deleted project: ctest-TestSvcHC-62781284, ID : c00701fe-d665-4cba-8761-ee558f28c2b9