2025-12-18 03:24:33,335 - INFO - Domain Default found not creating
2025-12-18 03:24:33,532 - INFO - Project ctest-TestSvcHC-81168376 not found, creating it
2025-12-18 03:24:34,146 - INFO - Created Project:ctest-TestSvcHC-81168376, ID : 04e44351-bf07-45ef-92ab-9e5848135657
2025-12-18 03:24:35,694 - INFO - ================================================================================
2025-12-18 03:24:35,694 - INFO - STARTING TEST : test_svc_hc_basic
2025-12-18 03:24:36,987 - DEBUG - Nothing to compare xmpp stats {'10.0.0.249': {'10.20.0.129': '0', '10.20.0.252': '0'}, '10.0.0.129': {'10.20.0.129': '0', '10.20.0.252': '0'}} with
2025-12-18 03:24:36,987 - INFO - Initial checks done. Running the testcase now
2025-12-18 03:24:36,987 - INFO -
2025-12-18 03:24:37,682 - DEBUG - Response for create_network : {'network': {'id': 'f467e735-07be-44bb-8381-da99621bdaa8', 'name': 'ctest-mgmt_vn-38898065', 'tenant_id': '04e44351bf0745ef92ab9e5848135657', 'project_id': '04e44351bf0745ef92ab9e5848135657', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-81168376', 'ctest-mgmt_vn-38898065'], 'port_security_enabled': True, 'description': ''}}
2025-12-18 03:24:37,971 - DEBUG - Response for create_subnet : {'subnet': {'id': '7b6b6271-8fd9-45f4-a1f7-889f08406122', 'name': '', 'tenant_id': '04e44351bf0745ef92ab9e5848135657', 'network_id': 'f467e735-07be-44bb-8381-da99621bdaa8', 'ip_version': 4, 'cidr': '118.82.121.128/26', 'allocation_pools': [{'start': '118.82.121.130', 'end': '118.82.121.190'}], 'gateway_ip': '118.82.121.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '118.82.121.130', 'tags': [], 'project_id': '04e44351bf0745ef92ab9e5848135657'}}
2025-12-18 03:24:37,996 - INFO - Created VN ctest-mgmt_vn-38898065
2025-12-18 03:24:38,011 - DEBUG - VN ctest-mgmt_vn-38898065 UUID is f467e735-07be-44bb-8381-da99621bdaa8
2025-12-18 03:24:38,090 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-18 03:24:38,398 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-18 03:24:38,431 - DEBUG - Requesting: http://10.0.0.23:8082/domain/48c3cb03-f70f-4f5d-8ebd-0d23e5db0707
2025-12-18 03:24:38,449 - DEBUG - Requesting: http://10.0.0.23:8082/project/04e44351-bf07-45ef-92ab-9e5848135657
2025-12-18 03:24:38,553 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/f467e735-07be-44bb-8381-da99621bdaa8
2025-12-18 03:24:38,564 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/f467e735-07be-44bb-8381-da99621bdaa8
2025-12-18 03:24:38,576 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/39d0d5eb-622b-4b29-938d-3dd8da473725
2025-12-18 03:24:38,584 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/39d0d5eb-622b-4b29-938d-3dd8da473725
2025-12-18 03:24:38,591 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/36cf88d5-986c-40f0-b97d-04bff84371e2
2025-12-18 03:24:38,597 - DEBUG - Route Targets: ['target:64512:8000004']
2025-12-18 03:24:38,597 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/f467e735-07be-44bb-8381-da99621bdaa8
2025-12-18 03:24:38,606 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/39d0d5eb-622b-4b29-938d-3dd8da473725
2025-12-18 03:24:38,623 - INFO - Verified VN network id 14 for VN f467e735-07be-44bb-8381-da99621bdaa8
2025-12-18 03:24:38,623 - INFO - Verifications in API Server for VN ctest-mgmt_vn-38898065 passed
2025-12-18 03:24:38,624 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/f467e735-07be-44bb-8381-da99621bdaa8
2025-12-18 03:24:38,633 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/39d0d5eb-622b-4b29-938d-3dd8da473725
2025-12-18 03:24:38,642 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/39d0d5eb-622b-4b29-938d-3dd8da473725
2025-12-18 03:24:38,651 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/36cf88d5-986c-40f0-b97d-04bff84371e2
2025-12-18 03:24:38,665 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-81168376:ctest-mgmt_vn-38898065', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-81168376', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17611299082804806843', 'uuid-lslong': '9476095443275078312'}, 'enable': 'true', 'created': '2025-12-18T03:24:37', 'last-modified': '2025-12-18T03:24:37', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.757381'}
2025-12-18 03:24:38,672 - DEBUG - Route Targets: ['target:64512:8000004']
2025-12-18 03:24:38,678 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-81168376:ctest-mgmt_vn-38898065', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-81168376', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17611299082804806843', 'uuid-lslong': '9476095443275078312'}, 'enable': 'true', 'created': '2025-12-18T03:24:37', 'last-modified': '2025-12-18T03:24:37', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.771445'}
2025-12-18 03:24:38,684 - DEBUG - Route Targets: ['target:64512:8000004']
2025-12-18 03:24:38,689 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-81168376:ctest-mgmt_vn-38898065', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-81168376', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17611299082804806843', 'uuid-lslong': '9476095443275078312'}, 'enable': 'true', 'created': '2025-12-18T03:24:37', 'last-modified': '2025-12-18T03:24:37', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.778728'}
2025-12-18 03:24:38,696 - DEBUG - Route Targets: ['target:64512:8000004']
2025-12-18 03:24:38,696 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-38898065 passed
2025-12-18 03:24:38,697 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-38898065 in API_Server ======
2025-12-18 03:24:38,697 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-18 03:24:38,703 - DEBUG - Requesting: http://10.0.0.23:8082/domain/48c3cb03-f70f-4f5d-8ebd-0d23e5db0707
2025-12-18 03:24:38,718 - DEBUG - Requesting: http://10.0.0.23:8082/project/04e44351-bf07-45ef-92ab-9e5848135657
2025-12-18 03:24:38,824 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/f467e735-07be-44bb-8381-da99621bdaa8
2025-12-18 03:24:38,836 - DEBUG - =>VN ctest-mgmt_vn-38898065 has no policy to be verified
2025-12-18 03:24:38,836 - DEBUG - Verifying the vn in opserver
2025-12-18 03:24:38,836 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-81168376:ctest-mgmt_vn-38898065 virtual network link through opserver 10.0.0.23
2025-12-18 03:24:38,836 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-12-18 03:24:39,164 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-12-18 03:24:39,243 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-81168376:ctest-mgmt_vn-38898065', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-81168376:ctest-mgmt_vn-38898065?flat'}
2025-12-18 03:24:39,244 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-81168376:ctest-mgmt_vn-38898065 virtual network link through opserver 10.0.0.50
2025-12-18 03:24:39,244 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2025-12-18 03:24:39,559 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2025-12-18 03:24:39,628 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-81168376:ctest-mgmt_vn-38898065', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-81168376:ctest-mgmt_vn-38898065?flat'}
2025-12-18 03:24:39,628 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-81168376:ctest-mgmt_vn-38898065 virtual network link through opserver 10.0.0.65
2025-12-18 03:24:39,628 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2025-12-18 03:24:39,944 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2025-12-18 03:24:40,015 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-81168376:ctest-mgmt_vn-38898065', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-81168376:ctest-mgmt_vn-38898065?flat'}
2025-12-18 03:24:40,015 - INFO - Validated that VN default-domain:ctest-TestSvcHC-81168376:ctest-mgmt_vn-38898065 is found in opserver
2025-12-18 03:24:40,038 - DEBUG - Do not have enough data to verify VN in agent
2025-12-18 03:24:40,048 - DEBUG - VRF ids for VN ctest-mgmt_vn-38898065: {}
2025-12-18 03:24:40,322 - DEBUG - Response for create_network : {'network': {'id': '00a0cc82-9f10-48c7-85cf-14b1fd669181', 'name': 'ctest-left_vn-79454787', 'tenant_id': '04e44351bf0745ef92ab9e5848135657', 'project_id': '04e44351bf0745ef92ab9e5848135657', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-81168376', 'ctest-left_vn-79454787'], 'port_security_enabled': True, 'description': ''}}
2025-12-18 03:24:40,589 - DEBUG - Response for create_subnet : {'subnet': {'id': 'f5e83cfa-89e0-4ee8-a9a1-5361d28445b4', 'name': '', 'tenant_id': '04e44351bf0745ef92ab9e5848135657', 'network_id': '00a0cc82-9f10-48c7-85cf-14b1fd669181', 'ip_version': 4, 'cidr': '112.108.115.128/26', 'allocation_pools': [{'start': '112.108.115.130', 'end': '112.108.115.190'}], 'gateway_ip': '112.108.115.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '112.108.115.130', 'tags': [], 'project_id': '04e44351bf0745ef92ab9e5848135657'}}
2025-12-18 03:24:40,617 - INFO - Created VN ctest-left_vn-79454787
2025-12-18 03:24:40,632 - DEBUG - VN ctest-left_vn-79454787 UUID is 00a0cc82-9f10-48c7-85cf-14b1fd669181
2025-12-18 03:24:40,707 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-18 03:24:40,714 - DEBUG - Requesting: http://10.0.0.23:8082/domain/48c3cb03-f70f-4f5d-8ebd-0d23e5db0707
2025-12-18 03:24:40,727 - DEBUG - Requesting: http://10.0.0.23:8082/project/04e44351-bf07-45ef-92ab-9e5848135657
2025-12-18 03:24:40,826 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/00a0cc82-9f10-48c7-85cf-14b1fd669181
2025-12-18 03:24:40,839 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/00a0cc82-9f10-48c7-85cf-14b1fd669181
2025-12-18 03:24:40,849 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/356e9f9f-bdd3-4e73-9e4d-a48d6b40c5e6
2025-12-18 03:24:40,857 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/356e9f9f-bdd3-4e73-9e4d-a48d6b40c5e6
2025-12-18 03:24:40,866 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/eefa6895-3c4c-438c-9107-c9bf67a77f1c
2025-12-18 03:24:40,881 - DEBUG - Route Targets: ['target:64512:8000006']
2025-12-18 03:24:40,881 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/00a0cc82-9f10-48c7-85cf-14b1fd669181
2025-12-18 03:24:40,893 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/356e9f9f-bdd3-4e73-9e4d-a48d6b40c5e6
2025-12-18 03:24:40,908 - INFO - Verified VN network id 15 for VN 00a0cc82-9f10-48c7-85cf-14b1fd669181
2025-12-18 03:24:40,908 - INFO - Verifications in API Server for VN ctest-left_vn-79454787 passed
2025-12-18 03:24:40,908 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/00a0cc82-9f10-48c7-85cf-14b1fd669181
2025-12-18 03:24:40,918 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/356e9f9f-bdd3-4e73-9e4d-a48d6b40c5e6
2025-12-18 03:24:40,926 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/356e9f9f-bdd3-4e73-9e4d-a48d6b40c5e6
2025-12-18 03:24:40,934 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/eefa6895-3c4c-438c-9107-c9bf67a77f1c
2025-12-18 03:24:40,948 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-81168376:ctest-left_vn-79454787', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-81168376', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '45260857660164295', 'uuid-lslong': '9641948081916645761'}, 'enable': 'true', 'created': '2025-12-18T03:24:40', 'last-modified': '2025-12-18T03:24:40', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.413881'}
2025-12-18 03:24:40,955 - DEBUG - Route Targets: ['target:64512:8000006']
2025-12-18 03:24:40,964 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-81168376:ctest-left_vn-79454787', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-81168376', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '45260857660164295', 'uuid-lslong': '9641948081916645761'}, 'enable': 'true', 'created': '2025-12-18T03:24:40', 'last-modified': '2025-12-18T03:24:40', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.429520'}
2025-12-18 03:24:40,972 - DEBUG - Route Targets: ['target:64512:8000006']
2025-12-18 03:24:40,986 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-81168376:ctest-left_vn-79454787', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-81168376', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '45260857660164295', 'uuid-lslong': '9641948081916645761'}, 'enable': 'true', 'created': '2025-12-18T03:24:40', 'last-modified': '2025-12-18T03:24:40', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.454229'}
2025-12-18 03:24:40,995 - DEBUG - Route Targets: ['target:64512:8000006']
2025-12-18 03:24:40,995 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-79454787 passed
2025-12-18 03:24:40,995 - DEBUG - ====Verifying policy data for ctest-left_vn-79454787 in API_Server ======
2025-12-18 03:24:40,995 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-18 03:24:41,004 - DEBUG - Requesting: http://10.0.0.23:8082/domain/48c3cb03-f70f-4f5d-8ebd-0d23e5db0707
2025-12-18 03:24:41,018 - DEBUG - Requesting: http://10.0.0.23:8082/project/04e44351-bf07-45ef-92ab-9e5848135657
2025-12-18 03:24:41,121 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/00a0cc82-9f10-48c7-85cf-14b1fd669181
2025-12-18 03:24:41,147 - DEBUG - =>VN ctest-left_vn-79454787 has no policy to be verified
2025-12-18 03:24:41,147 - DEBUG - Verifying the vn in opserver
2025-12-18 03:24:41,147 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-81168376:ctest-left_vn-79454787 virtual network link through opserver 10.0.0.23
2025-12-18 03:24:41,147 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-12-18 03:24:41,271 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-81168376:ctest-left_vn-79454787', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-81168376:ctest-left_vn-79454787?flat'}
2025-12-18 03:24:41,271 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-81168376:ctest-left_vn-79454787 virtual network link through opserver 10.0.0.50
2025-12-18 03:24:41,271 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2025-12-18 03:24:41,353 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-81168376:ctest-left_vn-79454787', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-81168376:ctest-left_vn-79454787?flat'}
2025-12-18 03:24:41,353 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-81168376:ctest-left_vn-79454787 virtual network link through opserver 10.0.0.65
2025-12-18 03:24:41,353 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2025-12-18 03:24:41,419 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-81168376:ctest-left_vn-79454787', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-81168376:ctest-left_vn-79454787?flat'}
2025-12-18 03:24:41,419 - INFO - Validated that VN default-domain:ctest-TestSvcHC-81168376:ctest-left_vn-79454787 is found in opserver
2025-12-18 03:24:41,444 - DEBUG - Do not have enough data to verify VN in agent
2025-12-18 03:24:41,455 - DEBUG - VRF ids for VN ctest-left_vn-79454787: {}
2025-12-18 03:24:41,768 - DEBUG - Response for create_network : {'network': {'id': '906976ae-ca06-45bd-9f11-2f2b4a862da3', 'name': 'ctest-right_vn-02117469', 'tenant_id': '04e44351bf0745ef92ab9e5848135657', 'project_id': '04e44351bf0745ef92ab9e5848135657', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-81168376', 'ctest-right_vn-02117469'], 'port_security_enabled': True, 'description': ''}}
2025-12-18 03:24:42,080 - DEBUG - Response for create_subnet : {'subnet': {'id': '60b8db95-de01-4147-89db-58bf77156fe8', 'name': '', 'tenant_id': '04e44351bf0745ef92ab9e5848135657', 'network_id': '906976ae-ca06-45bd-9f11-2f2b4a862da3', 'ip_version': 4, 'cidr': '3.63.167.0/26', 'allocation_pools': [{'start': '3.63.167.2', 'end': '3.63.167.62'}], 'gateway_ip': '3.63.167.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '3.63.167.2', 'tags': [], 'project_id': '04e44351bf0745ef92ab9e5848135657'}}
2025-12-18 03:24:42,103 - INFO - Created VN ctest-right_vn-02117469
2025-12-18 03:24:42,114 - DEBUG - VN ctest-right_vn-02117469 UUID is 906976ae-ca06-45bd-9f11-2f2b4a862da3
2025-12-18 03:24:42,196 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-18 03:24:42,226 - DEBUG - Requesting: http://10.0.0.23:8082/domain/48c3cb03-f70f-4f5d-8ebd-0d23e5db0707
2025-12-18 03:24:42,239 - DEBUG - Requesting: http://10.0.0.23:8082/project/04e44351-bf07-45ef-92ab-9e5848135657
2025-12-18 03:24:42,340 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/906976ae-ca06-45bd-9f11-2f2b4a862da3
2025-12-18 03:24:42,354 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/906976ae-ca06-45bd-9f11-2f2b4a862da3
2025-12-18 03:24:42,367 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/5c387854-f83e-4583-a0ae-8322037a0caf
2025-12-18 03:24:42,376 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/5c387854-f83e-4583-a0ae-8322037a0caf
2025-12-18 03:24:42,385 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/af2a06b6-b294-4dde-b5a2-508be205053a
2025-12-18 03:24:42,400 - DEBUG - Route Targets: ['target:64512:8000007']
2025-12-18 03:24:42,400 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/906976ae-ca06-45bd-9f11-2f2b4a862da3
2025-12-18 03:24:42,414 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/5c387854-f83e-4583-a0ae-8322037a0caf
2025-12-18 03:24:42,432 - INFO - Verified VN network id 16 for VN 906976ae-ca06-45bd-9f11-2f2b4a862da3
2025-12-18 03:24:42,432 - INFO - Verifications in API Server for VN ctest-right_vn-02117469 passed
2025-12-18 03:24:42,432 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/906976ae-ca06-45bd-9f11-2f2b4a862da3
2025-12-18 03:24:42,442 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/5c387854-f83e-4583-a0ae-8322037a0caf
2025-12-18 03:24:42,449 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/5c387854-f83e-4583-a0ae-8322037a0caf
2025-12-18 03:24:42,455 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/af2a06b6-b294-4dde-b5a2-508be205053a
2025-12-18 03:24:42,468 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-81168376:ctest-right_vn-02117469', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-81168376', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10405978907102037437', 'uuid-lslong': '11461994389615029667'}, 'enable': 'true', 'created': '2025-12-18T03:24:41', 'last-modified': '2025-12-18T03:24:41', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.472283'}
2025-12-18 03:24:42,476 - DEBUG - Route Targets: ['target:64512:8000007']
2025-12-18 03:24:42,483 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-81168376:ctest-right_vn-02117469', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-81168376', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10405978907102037437', 'uuid-lslong': '11461994389615029667'}, 'enable': 'true', 'created': '2025-12-18T03:24:41', 'last-modified': '2025-12-18T03:24:41', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.485202'}
2025-12-18 03:24:42,489 - DEBUG - Route Targets: ['target:64512:8000007']
2025-12-18 03:24:42,494 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-81168376:ctest-right_vn-02117469', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-81168376', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10405978907102037437', 'uuid-lslong': '11461994389615029667'}, 'enable': 'true', 'created': '2025-12-18T03:24:41', 'last-modified': '2025-12-18T03:24:41', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.495057'}
2025-12-18 03:24:42,502 - DEBUG - Route Targets: ['target:64512:8000007']
2025-12-18 03:24:42,502 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-02117469 passed
2025-12-18 03:24:42,503 - DEBUG - ====Verifying policy data for ctest-right_vn-02117469 in API_Server ======
2025-12-18 03:24:42,503 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-18 03:24:42,511 - DEBUG - Requesting: http://10.0.0.23:8082/domain/48c3cb03-f70f-4f5d-8ebd-0d23e5db0707
2025-12-18 03:24:42,523 - DEBUG - Requesting: http://10.0.0.23:8082/project/04e44351-bf07-45ef-92ab-9e5848135657
2025-12-18 03:24:42,614 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/906976ae-ca06-45bd-9f11-2f2b4a862da3
2025-12-18 03:24:42,624 - DEBUG - =>VN ctest-right_vn-02117469 has no policy to be verified
2025-12-18 03:24:42,624 - DEBUG - Verifying the vn in opserver
2025-12-18 03:24:42,624 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-81168376:ctest-right_vn-02117469 virtual network link through opserver 10.0.0.23
2025-12-18 03:24:42,624 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-12-18 03:24:42,703 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-81168376:ctest-right_vn-02117469', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-81168376:ctest-right_vn-02117469?flat'}
2025-12-18 03:24:42,703 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-81168376:ctest-right_vn-02117469 virtual network link through opserver 10.0.0.50
2025-12-18 03:24:42,703 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2025-12-18 03:24:42,778 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-81168376:ctest-right_vn-02117469', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-81168376:ctest-right_vn-02117469?flat'}
2025-12-18 03:24:42,779 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-81168376:ctest-right_vn-02117469 virtual network link through opserver 10.0.0.65
2025-12-18 03:24:42,779 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2025-12-18 03:24:42,847 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-81168376:ctest-right_vn-02117469', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-81168376:ctest-right_vn-02117469?flat'}
2025-12-18 03:24:42,847 - INFO - Validated that VN default-domain:ctest-TestSvcHC-81168376:ctest-right_vn-02117469 is found in opserver
2025-12-18 03:24:42,875 - DEBUG - Do not have enough data to verify VN in agent
2025-12-18 03:24:42,889 - DEBUG - VRF ids for VN ctest-right_vn-02117469: {}
2025-12-18 03:24:42,955 - DEBUG - Services list from nova: [, , , ]
2025-12-18 03:24:44,078 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4903-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4903-1)
2025-12-18 03:24:45,756 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4903-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4903-2)
2025-12-18 03:24:45,757 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-87968265']
2025-12-18 03:24:46,073 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-87968265'] created succesfully
2025-12-18 03:24:46,445 - DEBUG - Image by name tiny_nat_fw not found
2025-12-18 03:24:46,445 - DEBUG - Installing image tiny_nat_fw
2025-12-18 03:24:46,445 - 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-18 03:24:46,446 - DEBUG - Image build path file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2025-12-18 03:24:46,446 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2025-12-18 03:24:46,446 - DEBUG - Unzip image
2025-12-18 03:24:46,446 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2025-12-18 03:24:46,466 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2025-12-18 03:24:46,467 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-87968265']
2025-12-18 03:24:46,569 - INFO - Service template: ['default-domain', 'ctest-service_template_1-87968265'] deleted successfully.
2025-12-18 03:24:46,569 - INFO - Skip interface_detach for VM ctest-right_vm-25573176 in state BUILD
2025-12-18 03:24:46,569 - INFO - Deleting VM ctest-right_vm-25573176
2025-12-18 03:24:46,619 - ERROR - VM ctest-right_vm-25573176 has failed to come up
2025-12-18 03:24:46,620 - ERROR - Nova failed to get host of the VM
2025-12-18 03:24:46,621 - ERROR - VM ctest-right_vm-25573176 has failed to come up
2025-12-18 03:24:46,622 - ERROR - Nova failed to get host of the VM
2025-12-18 03:24:46,698 - INFO - Skip interface_detach for VM ctest-left_vm-78385073 in state BUILD
2025-12-18 03:24:46,698 - INFO - Deleting VM ctest-left_vm-78385073
2025-12-18 03:24:46,698 - ERROR - VM ctest-left_vm-78385073 has failed to come up
2025-12-18 03:24:46,698 - ERROR - Nova failed to get host of the VM
2025-12-18 03:24:46,698 - ERROR - VM ctest-left_vm-78385073 has failed to come up
2025-12-18 03:24:46,698 - ERROR - Nova failed to get host of the VM
2025-12-18 03:24:46,776 - INFO - Deleting VN ctest-right_vn-02117469
2025-12-18 03:24:46,822 - DEBUG - VN 906976ae-ca06-45bd-9f11-2f2b4a862da3 still in use: Unable to complete operation on network 906976ae-ca06-45bd-9f11-2f2b4a862da3. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-504b4ae0-222a-46b1-bcf1-9a0d98bc072b']
2025-12-18 03:24:46,822 - WARNING - Deleting VN ctest-right_vn-02117469 failed..Will retry
2025-12-18 03:24:48,982 - DEBUG - Response for deleting network ()
2025-12-18 03:24:48,982 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/5c387854-f83e-4583-a0ae-8322037a0caf
2025-12-18 03:24:48,988 - DEBUG - Response Code: 404
2025-12-18 03:24:48,988 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-18 03:24:48,994 - DEBUG - Requesting: http://10.0.0.23:8082/domain/48c3cb03-f70f-4f5d-8ebd-0d23e5db0707
2025-12-18 03:24:49,027 - DEBUG - Requesting: http://10.0.0.23:8082/project/04e44351-bf07-45ef-92ab-9e5848135657
2025-12-18 03:24:49,144 - INFO - Validated that VN ctest-right_vn-02117469 is not found in API Server
2025-12-18 03:24:49,156 - DEBUG - VN ctest-right_vn-02117469 is not present in Agent 10.0.0.249
2025-12-18 03:24:49,168 - DEBUG - VN ctest-right_vn-02117469 is not present in Agent 10.0.0.129
2025-12-18 03:24:49,168 - INFO - Validated that VN ctest-right_vn-02117469 is not in any agent
2025-12-18 03:24:49,204 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-02117469 info
2025-12-18 03:24:49,204 - INFO - Deleting VN ctest-left_vn-79454787
2025-12-18 03:24:49,369 - DEBUG - Response for deleting network ()
2025-12-18 03:24:49,369 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/356e9f9f-bdd3-4e73-9e4d-a48d6b40c5e6
2025-12-18 03:24:49,380 - DEBUG - Response Code: 404
2025-12-18 03:24:49,380 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-18 03:24:49,387 - DEBUG - Requesting: http://10.0.0.23:8082/domain/48c3cb03-f70f-4f5d-8ebd-0d23e5db0707
2025-12-18 03:24:49,406 - DEBUG - Requesting: http://10.0.0.23:8082/project/04e44351-bf07-45ef-92ab-9e5848135657
2025-12-18 03:24:49,535 - INFO - Validated that VN ctest-left_vn-79454787 is not found in API Server
2025-12-18 03:24:49,546 - DEBUG - VN ctest-left_vn-79454787 is not present in Agent 10.0.0.249
2025-12-18 03:24:49,556 - DEBUG - VN ctest-left_vn-79454787 is not present in Agent 10.0.0.129
2025-12-18 03:24:49,556 - INFO - Validated that VN ctest-left_vn-79454787 is not in any agent
2025-12-18 03:24:49,589 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-79454787 info
2025-12-18 03:24:49,589 - INFO - Deleting VN ctest-mgmt_vn-38898065
2025-12-18 03:24:49,752 - DEBUG - Response for deleting network ()
2025-12-18 03:24:49,752 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/39d0d5eb-622b-4b29-938d-3dd8da473725
2025-12-18 03:24:49,757 - DEBUG - Response Code: 404
2025-12-18 03:24:49,757 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-18 03:24:49,773 - DEBUG - Requesting: http://10.0.0.23:8082/domain/48c3cb03-f70f-4f5d-8ebd-0d23e5db0707
2025-12-18 03:24:49,790 - DEBUG - Requesting: http://10.0.0.23:8082/project/04e44351-bf07-45ef-92ab-9e5848135657
2025-12-18 03:24:49,891 - INFO - Validated that VN ctest-mgmt_vn-38898065 is not found in API Server
2025-12-18 03:24:49,913 - DEBUG - VN ctest-mgmt_vn-38898065 is not present in Agent 10.0.0.249
2025-12-18 03:24:49,924 - DEBUG - VN ctest-mgmt_vn-38898065 is not present in Agent 10.0.0.129
2025-12-18 03:24:49,924 - INFO - Validated that VN ctest-mgmt_vn-38898065 is not in any agent
2025-12-18 03:24:49,957 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-38898065 info
2025-12-18 03:24:51,271 - DEBUG - No XMPP flaps were noticed during the test
2025-12-18 03:24:51,272 - INFO -
2025-12-18 03:24:51,272 - INFO - END TEST : test_svc_hc_basic : SKIPPED[0:00:16]
2025-12-18 03:24:51,272 - INFO - --------------------------------------------------------------------------------
2025-12-18 03:24:51,278 - INFO - ================================================================================
2025-12-18 03:24:51,278 - INFO - STARTING TEST : test_svc_trans_segment_right_hc_fail_svm
2025-12-18 03:24:52,585 - DEBUG - Nothing to compare xmpp stats {'10.0.0.249': {'10.20.0.129': '0', '10.20.0.252': '0'}, '10.0.0.129': {'10.20.0.129': '0', '10.20.0.252': '0'}} with
2025-12-18 03:24:52,585 - INFO - Initial checks done. Running the testcase now
2025-12-18 03:24:52,586 - INFO -
2025-12-18 03:24:52,871 - DEBUG - Response for create_network : {'network': {'id': '1737ed32-eccc-4826-ad9a-0dae59c5b207', 'name': 'ctest-mgmt_vn-65975991', 'tenant_id': '04e44351bf0745ef92ab9e5848135657', 'project_id': '04e44351bf0745ef92ab9e5848135657', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-81168376', 'ctest-mgmt_vn-65975991'], 'port_security_enabled': True, 'description': ''}}
2025-12-18 03:24:53,115 - DEBUG - Response for create_subnet : {'subnet': {'id': 'b668b53b-ce42-47a0-9343-bb0f39544429', 'name': '', 'tenant_id': '04e44351bf0745ef92ab9e5848135657', 'network_id': '1737ed32-eccc-4826-ad9a-0dae59c5b207', 'ip_version': 4, 'cidr': '31.207.61.192/26', 'allocation_pools': [{'start': '31.207.61.194', 'end': '31.207.61.254'}], 'gateway_ip': '31.207.61.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '31.207.61.194', 'tags': [], 'project_id': '04e44351bf0745ef92ab9e5848135657'}}
2025-12-18 03:24:53,140 - INFO - Created VN ctest-mgmt_vn-65975991
2025-12-18 03:24:53,151 - DEBUG - VN ctest-mgmt_vn-65975991 UUID is 1737ed32-eccc-4826-ad9a-0dae59c5b207
2025-12-18 03:24:53,229 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-18 03:24:53,237 - DEBUG - Requesting: http://10.0.0.23:8082/domain/48c3cb03-f70f-4f5d-8ebd-0d23e5db0707
2025-12-18 03:24:53,251 - DEBUG - Requesting: http://10.0.0.23:8082/project/04e44351-bf07-45ef-92ab-9e5848135657
2025-12-18 03:24:53,343 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/1737ed32-eccc-4826-ad9a-0dae59c5b207
2025-12-18 03:24:53,367 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/1737ed32-eccc-4826-ad9a-0dae59c5b207
2025-12-18 03:24:53,379 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/a401fe70-d4be-4e28-938b-819923c6b863
2025-12-18 03:24:53,388 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/a401fe70-d4be-4e28-938b-819923c6b863
2025-12-18 03:24:53,396 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/f4a9b847-9ce9-4803-b049-e8323b6cbad2
2025-12-18 03:24:53,403 - DEBUG - Route Targets: ['target:64512:8000004']
2025-12-18 03:24:53,403 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/1737ed32-eccc-4826-ad9a-0dae59c5b207
2025-12-18 03:24:53,413 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/a401fe70-d4be-4e28-938b-819923c6b863
2025-12-18 03:24:53,430 - INFO - Verified VN network id 14 for VN 1737ed32-eccc-4826-ad9a-0dae59c5b207
2025-12-18 03:24:53,430 - INFO - Verifications in API Server for VN ctest-mgmt_vn-65975991 passed
2025-12-18 03:24:53,430 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/1737ed32-eccc-4826-ad9a-0dae59c5b207
2025-12-18 03:24:53,440 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/a401fe70-d4be-4e28-938b-819923c6b863
2025-12-18 03:24:53,448 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/a401fe70-d4be-4e28-938b-819923c6b863
2025-12-18 03:24:53,455 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/f4a9b847-9ce9-4803-b049-e8323b6cbad2
2025-12-18 03:24:53,469 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-81168376:ctest-mgmt_vn-65975991', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-81168376', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1673066589568387110', 'uuid-lslong': '12509325957456572935'}, 'enable': 'true', 'created': '2025-12-18T03:24:52', 'last-modified': '2025-12-18T03:24:53', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.404155'}
2025-12-18 03:24:53,478 - DEBUG - Route Targets: ['target:64512:8000004']
2025-12-18 03:24:53,484 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-81168376:ctest-mgmt_vn-65975991', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-81168376', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1673066589568387110', 'uuid-lslong': '12509325957456572935'}, 'enable': 'true', 'created': '2025-12-18T03:24:52', 'last-modified': '2025-12-18T03:24:53', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.422980'}
2025-12-18 03:24:53,491 - DEBUG - Route Targets: ['target:64512:8000004']
2025-12-18 03:24:53,497 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-81168376:ctest-mgmt_vn-65975991', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-81168376', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1673066589568387110', 'uuid-lslong': '12509325957456572935'}, 'enable': 'true', 'created': '2025-12-18T03:24:52', 'last-modified': '2025-12-18T03:24:53', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.436100'}
2025-12-18 03:24:53,504 - DEBUG - Route Targets: ['target:64512:8000004']
2025-12-18 03:24:53,504 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-65975991 passed
2025-12-18 03:24:53,504 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-65975991 in API_Server ======
2025-12-18 03:24:53,504 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-18 03:24:53,511 - DEBUG - Requesting: http://10.0.0.23:8082/domain/48c3cb03-f70f-4f5d-8ebd-0d23e5db0707
2025-12-18 03:24:53,523 - DEBUG - Requesting: http://10.0.0.23:8082/project/04e44351-bf07-45ef-92ab-9e5848135657
2025-12-18 03:24:53,623 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/1737ed32-eccc-4826-ad9a-0dae59c5b207
2025-12-18 03:24:53,639 - DEBUG - =>VN ctest-mgmt_vn-65975991 has no policy to be verified
2025-12-18 03:24:53,639 - DEBUG - Verifying the vn in opserver
2025-12-18 03:24:53,640 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-81168376:ctest-mgmt_vn-65975991 virtual network link through opserver 10.0.0.23
2025-12-18 03:24:53,640 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-12-18 03:24:53,651 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-81168376:ctest-mgmt_vn-65975991', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-81168376:ctest-mgmt_vn-65975991?flat'}
2025-12-18 03:24:53,651 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-81168376:ctest-mgmt_vn-65975991 virtual network link through opserver 10.0.0.50
2025-12-18 03:24:53,652 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2025-12-18 03:24:53,666 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-81168376:ctest-mgmt_vn-65975991', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-81168376:ctest-mgmt_vn-65975991?flat'}
2025-12-18 03:24:53,666 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-81168376:ctest-mgmt_vn-65975991 virtual network link through opserver 10.0.0.65
2025-12-18 03:24:53,666 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2025-12-18 03:24:53,679 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-81168376:ctest-mgmt_vn-65975991', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-81168376:ctest-mgmt_vn-65975991?flat'}
2025-12-18 03:24:53,679 - INFO - Validated that VN default-domain:ctest-TestSvcHC-81168376:ctest-mgmt_vn-65975991 is found in opserver
2025-12-18 03:24:53,703 - DEBUG - Do not have enough data to verify VN in agent
2025-12-18 03:24:53,718 - DEBUG - VRF ids for VN ctest-mgmt_vn-65975991: {}
2025-12-18 03:24:54,021 - DEBUG - Response for create_network : {'network': {'id': 'de557a8a-d389-4446-ad21-9ba521afa3cd', 'name': 'ctest-left_vn-65007048', 'tenant_id': '04e44351bf0745ef92ab9e5848135657', 'project_id': '04e44351bf0745ef92ab9e5848135657', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-81168376', 'ctest-left_vn-65007048'], 'port_security_enabled': True, 'description': ''}}
2025-12-18 03:24:54,232 - DEBUG - Response for create_subnet : {'subnet': {'id': '02369dec-e87d-4ab0-a773-9b272ea6a6d4', 'name': '', 'tenant_id': '04e44351bf0745ef92ab9e5848135657', 'network_id': 'de557a8a-d389-4446-ad21-9ba521afa3cd', 'ip_version': 4, 'cidr': '65.176.197.64/26', 'allocation_pools': [{'start': '65.176.197.66', 'end': '65.176.197.126'}], 'gateway_ip': '65.176.197.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '65.176.197.66', 'tags': [], 'project_id': '04e44351bf0745ef92ab9e5848135657'}}
2025-12-18 03:24:54,253 - INFO - Created VN ctest-left_vn-65007048
2025-12-18 03:24:54,267 - DEBUG - VN ctest-left_vn-65007048 UUID is de557a8a-d389-4446-ad21-9ba521afa3cd
2025-12-18 03:24:54,342 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-18 03:24:54,349 - DEBUG - Requesting: http://10.0.0.23:8082/domain/48c3cb03-f70f-4f5d-8ebd-0d23e5db0707
2025-12-18 03:24:54,363 - DEBUG - Requesting: http://10.0.0.23:8082/project/04e44351-bf07-45ef-92ab-9e5848135657
2025-12-18 03:24:54,470 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/de557a8a-d389-4446-ad21-9ba521afa3cd
2025-12-18 03:24:54,488 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/de557a8a-d389-4446-ad21-9ba521afa3cd
2025-12-18 03:24:54,498 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/f80d97df-a30e-43fe-9bc6-16ee7f245874
2025-12-18 03:24:54,508 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/f80d97df-a30e-43fe-9bc6-16ee7f245874
2025-12-18 03:24:54,515 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/d2e45bbc-151a-4f8a-a03d-29a56c568391
2025-12-18 03:24:54,522 - DEBUG - Route Targets: ['target:64512:8000006']
2025-12-18 03:24:54,522 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/de557a8a-d389-4446-ad21-9ba521afa3cd
2025-12-18 03:24:54,534 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/f80d97df-a30e-43fe-9bc6-16ee7f245874
2025-12-18 03:24:54,549 - INFO - Verified VN network id 15 for VN de557a8a-d389-4446-ad21-9ba521afa3cd
2025-12-18 03:24:54,550 - INFO - Verifications in API Server for VN ctest-left_vn-65007048 passed
2025-12-18 03:24:54,550 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/de557a8a-d389-4446-ad21-9ba521afa3cd
2025-12-18 03:24:54,561 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/f80d97df-a30e-43fe-9bc6-16ee7f245874
2025-12-18 03:24:54,568 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/f80d97df-a30e-43fe-9bc6-16ee7f245874
2025-12-18 03:24:54,576 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/d2e45bbc-151a-4f8a-a03d-29a56c568391
2025-12-18 03:24:54,588 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-81168376:ctest-left_vn-65007048', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-81168376', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16020845986113471558', 'uuid-lslong': '12475423576330052557'}, 'enable': 'true', 'created': '2025-12-18T03:24:53', 'last-modified': '2025-12-18T03:24:54', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.413577'}
2025-12-18 03:24:54,596 - DEBUG - Route Targets: ['target:64512:8000006']
2025-12-18 03:24:54,601 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-81168376:ctest-left_vn-65007048', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-81168376', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16020845986113471558', 'uuid-lslong': '12475423576330052557'}, 'enable': 'true', 'created': '2025-12-18T03:24:53', 'last-modified': '2025-12-18T03:24:54', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.428150'}
2025-12-18 03:24:54,607 - DEBUG - Route Targets: ['target:64512:8000006']
2025-12-18 03:24:54,613 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-81168376:ctest-left_vn-65007048', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-81168376', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16020845986113471558', 'uuid-lslong': '12475423576330052557'}, 'enable': 'true', 'created': '2025-12-18T03:24:53', 'last-modified': '2025-12-18T03:24:54', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.438102'}
2025-12-18 03:24:54,619 - DEBUG - Route Targets: ['target:64512:8000006']
2025-12-18 03:24:54,619 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-65007048 passed
2025-12-18 03:24:54,619 - DEBUG - ====Verifying policy data for ctest-left_vn-65007048 in API_Server ======
2025-12-18 03:24:54,620 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-18 03:24:54,626 - DEBUG - Requesting: http://10.0.0.23:8082/domain/48c3cb03-f70f-4f5d-8ebd-0d23e5db0707
2025-12-18 03:24:54,639 - DEBUG - Requesting: http://10.0.0.23:8082/project/04e44351-bf07-45ef-92ab-9e5848135657
2025-12-18 03:24:54,734 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/de557a8a-d389-4446-ad21-9ba521afa3cd
2025-12-18 03:24:54,748 - DEBUG - =>VN ctest-left_vn-65007048 has no policy to be verified
2025-12-18 03:24:54,748 - DEBUG - Verifying the vn in opserver
2025-12-18 03:24:54,749 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-81168376:ctest-left_vn-65007048 virtual network link through opserver 10.0.0.23
2025-12-18 03:24:54,749 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-12-18 03:24:54,767 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-81168376:ctest-left_vn-65007048', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-81168376:ctest-left_vn-65007048?flat'}
2025-12-18 03:24:54,767 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-81168376:ctest-left_vn-65007048 virtual network link through opserver 10.0.0.50
2025-12-18 03:24:54,767 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2025-12-18 03:24:54,785 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-81168376:ctest-left_vn-65007048', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-81168376:ctest-left_vn-65007048?flat'}
2025-12-18 03:24:54,785 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-81168376:ctest-left_vn-65007048 virtual network link through opserver 10.0.0.65
2025-12-18 03:24:54,785 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2025-12-18 03:24:54,800 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-81168376:ctest-left_vn-65007048', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-81168376:ctest-left_vn-65007048?flat'}
2025-12-18 03:24:54,800 - INFO - Validated that VN default-domain:ctest-TestSvcHC-81168376:ctest-left_vn-65007048 is found in opserver
2025-12-18 03:24:54,826 - DEBUG - Do not have enough data to verify VN in agent
2025-12-18 03:24:54,839 - DEBUG - VRF ids for VN ctest-left_vn-65007048: {}
2025-12-18 03:24:55,121 - DEBUG - Response for create_network : {'network': {'id': '3db78c0f-181b-43f0-8bff-298b80aeab69', 'name': 'ctest-right_vn-66076516', 'tenant_id': '04e44351bf0745ef92ab9e5848135657', 'project_id': '04e44351bf0745ef92ab9e5848135657', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-81168376', 'ctest-right_vn-66076516'], 'port_security_enabled': True, 'description': ''}}
2025-12-18 03:24:55,360 - DEBUG - Response for create_subnet : {'subnet': {'id': '999e41bc-a1e4-4708-9402-d71ec60baa05', 'name': '', 'tenant_id': '04e44351bf0745ef92ab9e5848135657', 'network_id': '3db78c0f-181b-43f0-8bff-298b80aeab69', 'ip_version': 4, 'cidr': '84.180.57.0/26', 'allocation_pools': [{'start': '84.180.57.2', 'end': '84.180.57.62'}], 'gateway_ip': '84.180.57.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '84.180.57.2', 'tags': [], 'project_id': '04e44351bf0745ef92ab9e5848135657'}}
2025-12-18 03:24:55,394 - INFO - Created VN ctest-right_vn-66076516
2025-12-18 03:24:55,408 - DEBUG - VN ctest-right_vn-66076516 UUID is 3db78c0f-181b-43f0-8bff-298b80aeab69
2025-12-18 03:24:55,484 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-18 03:24:55,490 - DEBUG - Requesting: http://10.0.0.23:8082/domain/48c3cb03-f70f-4f5d-8ebd-0d23e5db0707
2025-12-18 03:24:55,502 - DEBUG - Requesting: http://10.0.0.23:8082/project/04e44351-bf07-45ef-92ab-9e5848135657
2025-12-18 03:24:55,594 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/3db78c0f-181b-43f0-8bff-298b80aeab69
2025-12-18 03:24:55,610 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/3db78c0f-181b-43f0-8bff-298b80aeab69
2025-12-18 03:24:55,619 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/6b46aa8a-7db6-4ea9-9689-2dabcfbc4f59
2025-12-18 03:24:55,627 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/6b46aa8a-7db6-4ea9-9689-2dabcfbc4f59
2025-12-18 03:24:55,634 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/f382a2a7-b5e1-464e-8810-db62081611a6
2025-12-18 03:24:55,640 - DEBUG - Route Targets: ['target:64512:8000007']
2025-12-18 03:24:55,640 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/3db78c0f-181b-43f0-8bff-298b80aeab69
2025-12-18 03:24:55,650 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/6b46aa8a-7db6-4ea9-9689-2dabcfbc4f59
2025-12-18 03:24:55,665 - INFO - Verified VN network id 16 for VN 3db78c0f-181b-43f0-8bff-298b80aeab69
2025-12-18 03:24:55,665 - INFO - Verifications in API Server for VN ctest-right_vn-66076516 passed
2025-12-18 03:24:55,666 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/3db78c0f-181b-43f0-8bff-298b80aeab69
2025-12-18 03:24:55,675 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/6b46aa8a-7db6-4ea9-9689-2dabcfbc4f59
2025-12-18 03:24:55,682 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/6b46aa8a-7db6-4ea9-9689-2dabcfbc4f59
2025-12-18 03:24:55,689 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/f382a2a7-b5e1-464e-8810-db62081611a6
2025-12-18 03:24:55,701 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-81168376:ctest-right_vn-66076516', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-81168376', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4447177153508492272', 'uuid-lslong': '10087827369469324137'}, 'enable': 'true', 'created': '2025-12-18T03:24:55', 'last-modified': '2025-12-18T03:24:55', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.399822'}
2025-12-18 03:24:55,707 - DEBUG - Route Targets: ['target:64512:8000007']
2025-12-18 03:24:55,715 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-81168376:ctest-right_vn-66076516', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-81168376', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4447177153508492272', 'uuid-lslong': '10087827369469324137'}, 'enable': 'true', 'created': '2025-12-18T03:24:55', 'last-modified': '2025-12-18T03:24:55', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.411742'}
2025-12-18 03:24:55,723 - DEBUG - Route Targets: ['target:64512:8000007']
2025-12-18 03:24:55,731 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-81168376:ctest-right_vn-66076516', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-81168376', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4447177153508492272', 'uuid-lslong': '10087827369469324137'}, 'enable': 'true', 'created': '2025-12-18T03:24:55', 'last-modified': '2025-12-18T03:24:55', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.432545'}
2025-12-18 03:24:55,736 - DEBUG - Route Targets: ['target:64512:8000007']
2025-12-18 03:24:55,737 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-66076516 passed
2025-12-18 03:24:55,737 - DEBUG - ====Verifying policy data for ctest-right_vn-66076516 in API_Server ======
2025-12-18 03:24:55,737 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-18 03:24:55,744 - DEBUG - Requesting: http://10.0.0.23:8082/domain/48c3cb03-f70f-4f5d-8ebd-0d23e5db0707
2025-12-18 03:24:55,755 - DEBUG - Requesting: http://10.0.0.23:8082/project/04e44351-bf07-45ef-92ab-9e5848135657
2025-12-18 03:24:55,850 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/3db78c0f-181b-43f0-8bff-298b80aeab69
2025-12-18 03:24:55,860 - DEBUG - =>VN ctest-right_vn-66076516 has no policy to be verified
2025-12-18 03:24:55,860 - DEBUG - Verifying the vn in opserver
2025-12-18 03:24:55,860 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-81168376:ctest-right_vn-66076516 virtual network link through opserver 10.0.0.23
2025-12-18 03:24:55,860 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-12-18 03:24:55,873 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-81168376:ctest-right_vn-66076516', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-81168376:ctest-right_vn-66076516?flat'}
2025-12-18 03:24:55,873 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-81168376:ctest-right_vn-66076516 virtual network link through opserver 10.0.0.50
2025-12-18 03:24:55,873 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2025-12-18 03:24:55,888 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-81168376:ctest-right_vn-66076516', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-81168376:ctest-right_vn-66076516?flat'}
2025-12-18 03:24:55,888 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-81168376:ctest-right_vn-66076516 virtual network link through opserver 10.0.0.65
2025-12-18 03:24:55,888 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2025-12-18 03:24:55,901 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-81168376:ctest-right_vn-66076516', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-81168376:ctest-right_vn-66076516?flat'}
2025-12-18 03:24:55,901 - INFO - Validated that VN default-domain:ctest-TestSvcHC-81168376:ctest-right_vn-66076516 is found in opserver
2025-12-18 03:24:55,925 - DEBUG - Do not have enough data to verify VN in agent
2025-12-18 03:24:55,940 - DEBUG - VRF ids for VN ctest-right_vn-66076516: {}
2025-12-18 03:24:56,214 - DEBUG - Response for create_network : {'network': {'id': '5145b877-f725-4801-b6c2-0c5c48164c6a', 'name': 'ctest-trans_left_vn-29166133', 'tenant_id': '04e44351bf0745ef92ab9e5848135657', 'project_id': '04e44351bf0745ef92ab9e5848135657', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-81168376', 'ctest-trans_left_vn-29166133'], 'port_security_enabled': True, 'description': ''}}
2025-12-18 03:24:56,494 - DEBUG - Response for create_subnet : {'subnet': {'id': '34041c06-89a0-40bb-b6d6-d1eb72b0bfc8', 'name': '', 'tenant_id': '04e44351bf0745ef92ab9e5848135657', 'network_id': '5145b877-f725-4801-b6c2-0c5c48164c6a', 'ip_version': 4, 'cidr': '85.97.214.0/26', 'allocation_pools': [{'start': '85.97.214.2', 'end': '85.97.214.62'}], 'gateway_ip': '85.97.214.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '85.97.214.2', 'tags': [], 'project_id': '04e44351bf0745ef92ab9e5848135657'}}
2025-12-18 03:24:56,536 - INFO - Created VN ctest-trans_left_vn-29166133
2025-12-18 03:24:56,551 - DEBUG - VN ctest-trans_left_vn-29166133 UUID is 5145b877-f725-4801-b6c2-0c5c48164c6a
2025-12-18 03:24:56,635 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-18 03:24:56,640 - DEBUG - Requesting: http://10.0.0.23:8082/domain/48c3cb03-f70f-4f5d-8ebd-0d23e5db0707
2025-12-18 03:24:56,652 - DEBUG - Requesting: http://10.0.0.23:8082/project/04e44351-bf07-45ef-92ab-9e5848135657
2025-12-18 03:24:56,760 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/5145b877-f725-4801-b6c2-0c5c48164c6a
2025-12-18 03:24:56,773 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/5145b877-f725-4801-b6c2-0c5c48164c6a
2025-12-18 03:24:56,784 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/aa9edd90-bf0b-4be5-b504-744b4608c160
2025-12-18 03:24:56,791 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/aa9edd90-bf0b-4be5-b504-744b4608c160
2025-12-18 03:24:56,798 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/95f64af6-44f7-41b9-8723-fc1e6dac80ec
2025-12-18 03:24:56,804 - DEBUG - Route Targets: ['target:64512:8000008']
2025-12-18 03:24:56,805 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/5145b877-f725-4801-b6c2-0c5c48164c6a
2025-12-18 03:24:56,813 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/aa9edd90-bf0b-4be5-b504-744b4608c160
2025-12-18 03:24:56,829 - INFO - Verified VN network id 17 for VN 5145b877-f725-4801-b6c2-0c5c48164c6a
2025-12-18 03:24:56,829 - INFO - Verifications in API Server for VN ctest-trans_left_vn-29166133 passed
2025-12-18 03:24:56,829 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/5145b877-f725-4801-b6c2-0c5c48164c6a
2025-12-18 03:24:56,838 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/aa9edd90-bf0b-4be5-b504-744b4608c160
2025-12-18 03:24:56,847 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/aa9edd90-bf0b-4be5-b504-744b4608c160
2025-12-18 03:24:56,855 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/95f64af6-44f7-41b9-8723-fc1e6dac80ec
2025-12-18 03:24:56,867 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-81168376:ctest-trans_left_vn-29166133', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-81168376', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5856289715852232705', 'uuid-lslong': '13169101850870697066'}, 'enable': 'true', 'created': '2025-12-18T03:24:56', 'last-modified': '2025-12-18T03:24:56', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.432321'}
2025-12-18 03:24:56,873 - DEBUG - Route Targets: ['target:64512:8000008']
2025-12-18 03:24:56,880 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-81168376:ctest-trans_left_vn-29166133', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-81168376', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5856289715852232705', 'uuid-lslong': '13169101850870697066'}, 'enable': 'true', 'created': '2025-12-18T03:24:56', 'last-modified': '2025-12-18T03:24:56', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.437333'}
2025-12-18 03:24:56,885 - DEBUG - Route Targets: ['target:64512:8000008']
2025-12-18 03:24:56,891 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-81168376:ctest-trans_left_vn-29166133', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-81168376', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5856289715852232705', 'uuid-lslong': '13169101850870697066'}, 'enable': 'true', 'created': '2025-12-18T03:24:56', 'last-modified': '2025-12-18T03:24:56', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.448318'}
2025-12-18 03:24:56,898 - DEBUG - Route Targets: ['target:64512:8000008']
2025-12-18 03:24:56,898 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_left_vn-29166133 passed
2025-12-18 03:24:56,898 - DEBUG - ====Verifying policy data for ctest-trans_left_vn-29166133 in API_Server ======
2025-12-18 03:24:56,898 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-18 03:24:56,904 - DEBUG - Requesting: http://10.0.0.23:8082/domain/48c3cb03-f70f-4f5d-8ebd-0d23e5db0707
2025-12-18 03:24:56,919 - DEBUG - Requesting: http://10.0.0.23:8082/project/04e44351-bf07-45ef-92ab-9e5848135657
2025-12-18 03:24:57,021 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/5145b877-f725-4801-b6c2-0c5c48164c6a
2025-12-18 03:24:57,034 - DEBUG - =>VN ctest-trans_left_vn-29166133 has no policy to be verified
2025-12-18 03:24:57,034 - DEBUG - Verifying the vn in opserver
2025-12-18 03:24:57,034 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-81168376:ctest-trans_left_vn-29166133 virtual network link through opserver 10.0.0.23
2025-12-18 03:24:57,035 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-12-18 03:24:57,050 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-81168376:ctest-trans_left_vn-29166133', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-81168376:ctest-trans_left_vn-29166133?flat'}
2025-12-18 03:24:57,050 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-81168376:ctest-trans_left_vn-29166133 virtual network link through opserver 10.0.0.50
2025-12-18 03:24:57,050 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2025-12-18 03:24:57,064 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-81168376:ctest-trans_left_vn-29166133', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-81168376:ctest-trans_left_vn-29166133?flat'}
2025-12-18 03:24:57,064 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-81168376:ctest-trans_left_vn-29166133 virtual network link through opserver 10.0.0.65
2025-12-18 03:24:57,064 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2025-12-18 03:24:57,077 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-81168376:ctest-trans_left_vn-29166133', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-81168376:ctest-trans_left_vn-29166133?flat'}
2025-12-18 03:24:57,077 - INFO - Validated that VN default-domain:ctest-TestSvcHC-81168376:ctest-trans_left_vn-29166133 is found in opserver
2025-12-18 03:24:57,102 - DEBUG - Do not have enough data to verify VN in agent
2025-12-18 03:24:57,115 - DEBUG - VRF ids for VN ctest-trans_left_vn-29166133: {}
2025-12-18 03:24:57,386 - DEBUG - Response for create_network : {'network': {'id': '35fd9dba-01f1-4848-96ea-6b789b2bee71', 'name': 'ctest-trans_right_vn-20050421', 'tenant_id': '04e44351bf0745ef92ab9e5848135657', 'project_id': '04e44351bf0745ef92ab9e5848135657', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-81168376', 'ctest-trans_right_vn-20050421'], 'port_security_enabled': True, 'description': ''}}
2025-12-18 03:24:57,625 - DEBUG - Response for create_subnet : {'subnet': {'id': 'c2d6be44-36d4-4f90-b4f7-624c5dc38287', 'name': '', 'tenant_id': '04e44351bf0745ef92ab9e5848135657', 'network_id': '35fd9dba-01f1-4848-96ea-6b789b2bee71', 'ip_version': 4, 'cidr': '94.90.113.128/26', 'allocation_pools': [{'start': '94.90.113.130', 'end': '94.90.113.190'}], 'gateway_ip': '94.90.113.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '94.90.113.130', 'tags': [], 'project_id': '04e44351bf0745ef92ab9e5848135657'}}
2025-12-18 03:24:57,648 - INFO - Created VN ctest-trans_right_vn-20050421
2025-12-18 03:24:57,666 - DEBUG - VN ctest-trans_right_vn-20050421 UUID is 35fd9dba-01f1-4848-96ea-6b789b2bee71
2025-12-18 03:24:57,748 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-18 03:24:57,755 - DEBUG - Requesting: http://10.0.0.23:8082/domain/48c3cb03-f70f-4f5d-8ebd-0d23e5db0707
2025-12-18 03:24:57,767 - DEBUG - Requesting: http://10.0.0.23:8082/project/04e44351-bf07-45ef-92ab-9e5848135657
2025-12-18 03:24:57,855 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/35fd9dba-01f1-4848-96ea-6b789b2bee71
2025-12-18 03:24:57,872 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/35fd9dba-01f1-4848-96ea-6b789b2bee71
2025-12-18 03:24:57,882 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/802e63e3-305e-4112-a411-d177ae4023d6
2025-12-18 03:24:57,892 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/802e63e3-305e-4112-a411-d177ae4023d6
2025-12-18 03:24:57,899 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/fd399c89-49c9-4aa3-9c2a-4e93815d8b0f
2025-12-18 03:24:57,906 - DEBUG - Route Targets: ['target:64512:8000009']
2025-12-18 03:24:57,906 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/35fd9dba-01f1-4848-96ea-6b789b2bee71
2025-12-18 03:24:57,919 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/802e63e3-305e-4112-a411-d177ae4023d6
2025-12-18 03:24:57,934 - INFO - Verified VN network id 18 for VN 35fd9dba-01f1-4848-96ea-6b789b2bee71
2025-12-18 03:24:57,934 - INFO - Verifications in API Server for VN ctest-trans_right_vn-20050421 passed
2025-12-18 03:24:57,934 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/35fd9dba-01f1-4848-96ea-6b789b2bee71
2025-12-18 03:24:57,944 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/802e63e3-305e-4112-a411-d177ae4023d6
2025-12-18 03:24:57,950 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/802e63e3-305e-4112-a411-d177ae4023d6
2025-12-18 03:24:57,957 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/fd399c89-49c9-4aa3-9c2a-4e93815d8b0f
2025-12-18 03:24:57,971 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-81168376:ctest-trans_right_vn-20050421', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-81168376', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3890439075340044360', 'uuid-lslong': '10874622415983079025'}, 'enable': 'true', 'created': '2025-12-18T03:24:57', 'last-modified': '2025-12-18T03:24:57', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.395484'}
2025-12-18 03:24:57,980 - DEBUG - Route Targets: ['target:64512:8000009']
2025-12-18 03:24:57,988 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-81168376:ctest-trans_right_vn-20050421', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-81168376', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3890439075340044360', 'uuid-lslong': '10874622415983079025'}, 'enable': 'true', 'created': '2025-12-18T03:24:57', 'last-modified': '2025-12-18T03:24:57', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.411761'}
2025-12-18 03:24:57,995 - DEBUG - Route Targets: ['target:64512:8000009']
2025-12-18 03:24:58,002 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-81168376:ctest-trans_right_vn-20050421', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-81168376', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3890439075340044360', 'uuid-lslong': '10874622415983079025'}, 'enable': 'true', 'created': '2025-12-18T03:24:57', 'last-modified': '2025-12-18T03:24:57', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.425646'}
2025-12-18 03:24:58,008 - DEBUG - Route Targets: ['target:64512:8000009']
2025-12-18 03:24:58,008 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_right_vn-20050421 passed
2025-12-18 03:24:58,008 - DEBUG - ====Verifying policy data for ctest-trans_right_vn-20050421 in API_Server ======
2025-12-18 03:24:58,008 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-18 03:24:58,014 - DEBUG - Requesting: http://10.0.0.23:8082/domain/48c3cb03-f70f-4f5d-8ebd-0d23e5db0707
2025-12-18 03:24:58,027 - DEBUG - Requesting: http://10.0.0.23:8082/project/04e44351-bf07-45ef-92ab-9e5848135657
2025-12-18 03:24:58,122 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/35fd9dba-01f1-4848-96ea-6b789b2bee71
2025-12-18 03:24:58,132 - DEBUG - =>VN ctest-trans_right_vn-20050421 has no policy to be verified
2025-12-18 03:24:58,132 - DEBUG - Verifying the vn in opserver
2025-12-18 03:24:58,133 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-81168376:ctest-trans_right_vn-20050421 virtual network link through opserver 10.0.0.23
2025-12-18 03:24:58,133 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-12-18 03:24:58,146 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-81168376:ctest-trans_right_vn-20050421', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-81168376:ctest-trans_right_vn-20050421?flat'}
2025-12-18 03:24:58,146 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-81168376:ctest-trans_right_vn-20050421 virtual network link through opserver 10.0.0.50
2025-12-18 03:24:58,146 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2025-12-18 03:24:58,160 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-81168376:ctest-trans_right_vn-20050421', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-81168376:ctest-trans_right_vn-20050421?flat'}
2025-12-18 03:24:58,160 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-81168376:ctest-trans_right_vn-20050421 virtual network link through opserver 10.0.0.65
2025-12-18 03:24:58,160 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2025-12-18 03:24:58,172 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-81168376:ctest-trans_right_vn-20050421', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-81168376:ctest-trans_right_vn-20050421?flat'}
2025-12-18 03:24:58,172 - INFO - Validated that VN default-domain:ctest-TestSvcHC-81168376:ctest-trans_right_vn-20050421 is found in opserver
2025-12-18 03:24:58,196 - DEBUG - Do not have enough data to verify VN in agent
2025-12-18 03:24:58,209 - DEBUG - VRF ids for VN ctest-trans_right_vn-20050421: {}
2025-12-18 03:24:59,267 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4903-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4903-2)
2025-12-18 03:25:00,657 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4903-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4903-1)
2025-12-18 03:25:00,657 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-07078651']
2025-12-18 03:25:00,970 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-07078651'] created succesfully
2025-12-18 03:25:01,359 - DEBUG - Image by name tiny_trans_fw not found
2025-12-18 03:25:01,359 - DEBUG - Installing image tiny_trans_fw
2025-12-18 03:25:01,359 - 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-18 03:25:01,359 - DEBUG - Image build path file:///contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2025-12-18 03:25:01,359 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2025-12-18 03:25:01,359 - DEBUG - Unzip image
2025-12-18 03:25:01,359 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2025-12-18 03:25:01,379 - INFO - image /contrail-test/images/tinycore-net-transparent-fw.qcow2 is not found
2025-12-18 03:25:01,379 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-07078651']
2025-12-18 03:25:01,489 - INFO - Service template: ['default-domain', 'ctest-service_template_1-07078651'] deleted successfully.
2025-12-18 03:25:01,489 - INFO - Skip interface_detach for VM ctest-right_vm-62437953 in state BUILD
2025-12-18 03:25:01,490 - INFO - Deleting VM ctest-right_vm-62437953
2025-12-18 03:25:01,490 - ERROR - VM ctest-right_vm-62437953 has failed to come up
2025-12-18 03:25:01,490 - ERROR - Nova failed to get host of the VM
2025-12-18 03:25:01,490 - ERROR - VM ctest-right_vm-62437953 has failed to come up
2025-12-18 03:25:01,490 - ERROR - Nova failed to get host of the VM
2025-12-18 03:25:01,676 - INFO - Skip interface_detach for VM ctest-left_vm-51659138 in state BUILD
2025-12-18 03:25:01,677 - INFO - Deleting VM ctest-left_vm-51659138
2025-12-18 03:25:01,677 - ERROR - VM ctest-left_vm-51659138 has failed to come up
2025-12-18 03:25:01,677 - ERROR - Nova failed to get host of the VM
2025-12-18 03:25:01,677 - ERROR - VM ctest-left_vm-51659138 has failed to come up
2025-12-18 03:25:01,677 - ERROR - Nova failed to get host of the VM
2025-12-18 03:25:01,873 - INFO - Deleting VN ctest-trans_right_vn-20050421
2025-12-18 03:25:02,128 - DEBUG - Response for deleting network ()
2025-12-18 03:25:02,129 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/802e63e3-305e-4112-a411-d177ae4023d6
2025-12-18 03:25:02,138 - DEBUG - Response Code: 404
2025-12-18 03:25:02,139 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-18 03:25:02,146 - DEBUG - Requesting: http://10.0.0.23:8082/domain/48c3cb03-f70f-4f5d-8ebd-0d23e5db0707
2025-12-18 03:25:02,187 - DEBUG - Requesting: http://10.0.0.23:8082/project/04e44351-bf07-45ef-92ab-9e5848135657
2025-12-18 03:25:02,298 - INFO - Validated that VN ctest-trans_right_vn-20050421 is not found in API Server
2025-12-18 03:25:02,311 - DEBUG - VN ctest-trans_right_vn-20050421 is not present in Agent 10.0.0.249
2025-12-18 03:25:02,335 - DEBUG - VN ctest-trans_right_vn-20050421 is not present in Agent 10.0.0.129
2025-12-18 03:25:02,335 - INFO - Validated that VN ctest-trans_right_vn-20050421 is not in any agent
2025-12-18 03:25:02,377 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-trans_right_vn-20050421 info
2025-12-18 03:25:02,378 - INFO - Deleting VN ctest-trans_left_vn-29166133
2025-12-18 03:25:02,582 - DEBUG - Response for deleting network ()
2025-12-18 03:25:02,582 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/aa9edd90-bf0b-4be5-b504-744b4608c160
2025-12-18 03:25:02,597 - DEBUG - Response Code: 404
2025-12-18 03:25:02,597 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-18 03:25:02,614 - DEBUG - Requesting: http://10.0.0.23:8082/domain/48c3cb03-f70f-4f5d-8ebd-0d23e5db0707
2025-12-18 03:25:02,643 - DEBUG - Requesting: http://10.0.0.23:8082/project/04e44351-bf07-45ef-92ab-9e5848135657
2025-12-18 03:25:02,850 - INFO - Validated that VN ctest-trans_left_vn-29166133 is not found in API Server
2025-12-18 03:25:02,884 - DEBUG - VN ctest-trans_left_vn-29166133 is not present in Agent 10.0.0.249
2025-12-18 03:25:02,895 - DEBUG - VN ctest-trans_left_vn-29166133 is not present in Agent 10.0.0.129
2025-12-18 03:25:02,895 - INFO - Validated that VN ctest-trans_left_vn-29166133 is not in any agent
2025-12-18 03:25:02,949 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-trans_left_vn-29166133 info
2025-12-18 03:25:02,949 - INFO - Deleting VN ctest-right_vn-66076516
2025-12-18 03:25:03,007 - DEBUG - VN 3db78c0f-181b-43f0-8bff-298b80aeab69 still in use: Unable to complete operation on network 3db78c0f-181b-43f0-8bff-298b80aeab69. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-28b5bdb7-5c95-431c-9c66-b8570f3a5b2e']
2025-12-18 03:25:03,007 - WARNING - Deleting VN ctest-right_vn-66076516 failed..Will retry
2025-12-18 03:25:05,193 - DEBUG - Response for deleting network ()
2025-12-18 03:25:05,193 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/6b46aa8a-7db6-4ea9-9689-2dabcfbc4f59
2025-12-18 03:25:05,200 - DEBUG - Response Code: 404
2025-12-18 03:25:05,200 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-18 03:25:05,211 - DEBUG - Requesting: http://10.0.0.23:8082/domain/48c3cb03-f70f-4f5d-8ebd-0d23e5db0707
2025-12-18 03:25:05,235 - DEBUG - Requesting: http://10.0.0.23:8082/project/04e44351-bf07-45ef-92ab-9e5848135657
2025-12-18 03:25:05,355 - INFO - Validated that VN ctest-right_vn-66076516 is not found in API Server
2025-12-18 03:25:05,366 - DEBUG - VN ctest-right_vn-66076516 is not present in Agent 10.0.0.249
2025-12-18 03:25:05,379 - DEBUG - VN ctest-right_vn-66076516 is not present in Agent 10.0.0.129
2025-12-18 03:25:05,379 - INFO - Validated that VN ctest-right_vn-66076516 is not in any agent
2025-12-18 03:25:05,417 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-66076516 info
2025-12-18 03:25:05,417 - INFO - Deleting VN ctest-left_vn-65007048
2025-12-18 03:25:05,697 - DEBUG - Response for deleting network ()
2025-12-18 03:25:05,697 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/f80d97df-a30e-43fe-9bc6-16ee7f245874
2025-12-18 03:25:05,703 - DEBUG - Response Code: 404
2025-12-18 03:25:05,703 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-18 03:25:05,711 - DEBUG - Requesting: http://10.0.0.23:8082/domain/48c3cb03-f70f-4f5d-8ebd-0d23e5db0707
2025-12-18 03:25:05,730 - DEBUG - Requesting: http://10.0.0.23:8082/project/04e44351-bf07-45ef-92ab-9e5848135657
2025-12-18 03:25:05,827 - INFO - Validated that VN ctest-left_vn-65007048 is not found in API Server
2025-12-18 03:25:05,838 - DEBUG - VN ctest-left_vn-65007048 is not present in Agent 10.0.0.249
2025-12-18 03:25:05,851 - DEBUG - VN ctest-left_vn-65007048 is not present in Agent 10.0.0.129
2025-12-18 03:25:05,851 - INFO - Validated that VN ctest-left_vn-65007048 is not in any agent
2025-12-18 03:25:05,890 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-65007048 info
2025-12-18 03:25:05,891 - INFO - Deleting VN ctest-mgmt_vn-65975991
2025-12-18 03:25:06,050 - DEBUG - Response for deleting network ()
2025-12-18 03:25:06,050 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/a401fe70-d4be-4e28-938b-819923c6b863
2025-12-18 03:25:06,065 - DEBUG - Response Code: 404
2025-12-18 03:25:06,066 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-18 03:25:06,072 - DEBUG - Requesting: http://10.0.0.23:8082/domain/48c3cb03-f70f-4f5d-8ebd-0d23e5db0707
2025-12-18 03:25:06,127 - DEBUG - Requesting: http://10.0.0.23:8082/project/04e44351-bf07-45ef-92ab-9e5848135657
2025-12-18 03:25:06,220 - INFO - Validated that VN ctest-mgmt_vn-65975991 is not found in API Server
2025-12-18 03:25:06,232 - DEBUG - VN ctest-mgmt_vn-65975991 is not present in Agent 10.0.0.249
2025-12-18 03:25:06,245 - DEBUG - VN ctest-mgmt_vn-65975991 is not present in Agent 10.0.0.129
2025-12-18 03:25:06,245 - INFO - Validated that VN ctest-mgmt_vn-65975991 is not in any agent
2025-12-18 03:25:06,278 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-65975991 info
2025-12-18 03:25:07,606 - DEBUG - No XMPP flaps were noticed during the test
2025-12-18 03:25:07,606 - INFO -
2025-12-18 03:25:07,606 - INFO - END TEST : test_svc_trans_segment_right_hc_fail_svm : SKIPPED[0:00:16]
2025-12-18 03:25:07,606 - INFO - --------------------------------------------------------------------------------
2025-12-18 03:25:08,361 - INFO - Deleted project: ctest-TestSvcHC-81168376, ID : 04e44351-bf07-45ef-92ab-9e5848135657