2025-12-22 03:11:36,825 - INFO - Domain Default found not creating
2025-12-22 03:11:36,980 - INFO - Project ctest-TestSvcHC-80710792 not found, creating it
2025-12-22 03:11:37,511 - INFO - Created Project:ctest-TestSvcHC-80710792, ID : 0c56ebf2-8393-4d53-81c8-e788efc49815
2025-12-22 03:11:38,945 - INFO - ================================================================================
2025-12-22 03:11:38,945 - INFO - STARTING TEST : test_svc_hc_basic
2025-12-22 03:11:40,267 - DEBUG - Nothing to compare xmpp stats {'10.0.0.130': {'10.20.0.14': '0', '10.20.0.192': '0'}, '10.0.0.19': {'10.20.0.129': '0', '10.20.0.192': '0'}} with
2025-12-22 03:11:40,267 - INFO - Initial checks done. Running the testcase now
2025-12-22 03:11:40,267 - INFO -
2025-12-22 03:11:40,927 - DEBUG - Response for create_network : {'network': {'id': '64fd1377-1e14-483c-9fb4-f433d5e5b366', 'name': 'ctest-mgmt_vn-60609853', 'tenant_id': '0c56ebf283934d5381c8e788efc49815', 'project_id': '0c56ebf283934d5381c8e788efc49815', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-80710792', 'ctest-mgmt_vn-60609853'], 'port_security_enabled': True, 'description': ''}}
2025-12-22 03:11:41,190 - DEBUG - Response for create_subnet : {'subnet': {'id': '5f2ca858-54c1-425c-97dc-9df361077618', 'name': '', 'tenant_id': '0c56ebf283934d5381c8e788efc49815', 'network_id': '64fd1377-1e14-483c-9fb4-f433d5e5b366', 'ip_version': 4, 'cidr': '105.104.74.64/26', 'allocation_pools': [{'start': '105.104.74.66', 'end': '105.104.74.126'}], 'gateway_ip': '105.104.74.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '105.104.74.66', 'tags': [], 'project_id': '0c56ebf283934d5381c8e788efc49815'}}
2025-12-22 03:11:41,215 - INFO - Created VN ctest-mgmt_vn-60609853
2025-12-22 03:11:41,229 - DEBUG - VN ctest-mgmt_vn-60609853 UUID is 64fd1377-1e14-483c-9fb4-f433d5e5b366
2025-12-22 03:11:41,303 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-22 03:11:41,595 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-22 03:11:41,627 - DEBUG - Requesting: http://10.0.0.23:8082/domain/cc89f09a-44c2-47d5-97ff-1101c2b1f822
2025-12-22 03:11:41,641 - DEBUG - Requesting: http://10.0.0.23:8082/project/0c56ebf2-8393-4d53-81c8-e788efc49815
2025-12-22 03:11:41,741 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/64fd1377-1e14-483c-9fb4-f433d5e5b366
2025-12-22 03:11:41,755 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/64fd1377-1e14-483c-9fb4-f433d5e5b366
2025-12-22 03:11:41,764 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/7148d134-10c4-4342-a994-57dda18671e4
2025-12-22 03:11:41,774 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/7148d134-10c4-4342-a994-57dda18671e4
2025-12-22 03:11:41,780 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/3ed45c75-84eb-4bf9-8d2b-7b2b1cfa9d32
2025-12-22 03:11:41,787 - DEBUG - Route Targets: ['target:64512:8000004']
2025-12-22 03:11:41,788 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/64fd1377-1e14-483c-9fb4-f433d5e5b366
2025-12-22 03:11:41,796 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/7148d134-10c4-4342-a994-57dda18671e4
2025-12-22 03:11:41,814 - INFO - Verified VN network id 10 for VN 64fd1377-1e14-483c-9fb4-f433d5e5b366
2025-12-22 03:11:41,814 - INFO - Verifications in API Server for VN ctest-mgmt_vn-60609853 passed
2025-12-22 03:11:41,814 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/64fd1377-1e14-483c-9fb4-f433d5e5b366
2025-12-22 03:11:41,824 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/7148d134-10c4-4342-a994-57dda18671e4
2025-12-22 03:11:41,834 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/7148d134-10c4-4342-a994-57dda18671e4
2025-12-22 03:11:41,841 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/3ed45c75-84eb-4bf9-8d2b-7b2b1cfa9d32
2025-12-22 03:11:41,854 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-80710792:ctest-mgmt_vn-60609853', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-80710792', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7276993975227271228', 'uuid-lslong': '11508091451307570022'}, 'enable': 'true', 'created': '2025-12-22T03:11:40', 'last-modified': '2025-12-22T03:11:41', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.717836'}
2025-12-22 03:11:41,860 - DEBUG - Route Targets: ['target:64512:8000004']
2025-12-22 03:11:41,865 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-80710792:ctest-mgmt_vn-60609853', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-80710792', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7276993975227271228', 'uuid-lslong': '11508091451307570022'}, 'enable': 'true', 'created': '2025-12-22T03:11:40', 'last-modified': '2025-12-22T03:11:41', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.726261'}
2025-12-22 03:11:41,870 - DEBUG - Route Targets: ['target:64512:8000004']
2025-12-22 03:11:41,877 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-80710792:ctest-mgmt_vn-60609853', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-80710792', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7276993975227271228', 'uuid-lslong': '11508091451307570022'}, 'enable': 'true', 'created': '2025-12-22T03:11:40', 'last-modified': '2025-12-22T03:11:41', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.744175'}
2025-12-22 03:11:41,884 - DEBUG - Route Targets: ['target:64512:8000004']
2025-12-22 03:11:41,884 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-60609853 passed
2025-12-22 03:11:41,884 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-60609853 in API_Server ======
2025-12-22 03:11:41,884 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-22 03:11:41,889 - DEBUG - Requesting: http://10.0.0.23:8082/domain/cc89f09a-44c2-47d5-97ff-1101c2b1f822
2025-12-22 03:11:41,900 - DEBUG - Requesting: http://10.0.0.23:8082/project/0c56ebf2-8393-4d53-81c8-e788efc49815
2025-12-22 03:11:41,989 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/64fd1377-1e14-483c-9fb4-f433d5e5b366
2025-12-22 03:11:41,998 - DEBUG - =>VN ctest-mgmt_vn-60609853 has no policy to be verified
2025-12-22 03:11:41,998 - DEBUG - Verifying the vn in opserver
2025-12-22 03:11:41,998 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-80710792:ctest-mgmt_vn-60609853 virtual network link through opserver 10.0.0.23
2025-12-22 03:11:41,998 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-12-22 03:11:42,294 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-12-22 03:11:42,366 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-80710792:ctest-mgmt_vn-60609853', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-80710792:ctest-mgmt_vn-60609853?flat'}
2025-12-22 03:11:42,366 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-80710792:ctest-mgmt_vn-60609853 virtual network link through opserver 10.0.0.22
2025-12-22 03:11:42,367 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2025-12-22 03:11:42,658 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2025-12-22 03:11:42,715 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-80710792:ctest-mgmt_vn-60609853', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-80710792:ctest-mgmt_vn-60609853?flat'}
2025-12-22 03:11:42,715 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-80710792:ctest-mgmt_vn-60609853 virtual network link through opserver 10.0.0.65
2025-12-22 03:11:42,716 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2025-12-22 03:11:43,008 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2025-12-22 03:11:43,065 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-80710792:ctest-mgmt_vn-60609853', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-80710792:ctest-mgmt_vn-60609853?flat'}
2025-12-22 03:11:43,065 - INFO - Validated that VN default-domain:ctest-TestSvcHC-80710792:ctest-mgmt_vn-60609853 is found in opserver
2025-12-22 03:11:43,090 - DEBUG - Do not have enough data to verify VN in agent
2025-12-22 03:11:43,100 - DEBUG - VRF ids for VN ctest-mgmt_vn-60609853: {}
2025-12-22 03:11:43,393 - DEBUG - Response for create_network : {'network': {'id': '917736d6-501a-41e5-bedc-fa64851a23a6', 'name': 'ctest-left_vn-13135216', 'tenant_id': '0c56ebf283934d5381c8e788efc49815', 'project_id': '0c56ebf283934d5381c8e788efc49815', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-80710792', 'ctest-left_vn-13135216'], 'port_security_enabled': True, 'description': ''}}
2025-12-22 03:11:43,692 - DEBUG - Response for create_subnet : {'subnet': {'id': 'ad18f0f7-865b-4eec-9f55-5b62d3b94bd0', 'name': '', 'tenant_id': '0c56ebf283934d5381c8e788efc49815', 'network_id': '917736d6-501a-41e5-bedc-fa64851a23a6', 'ip_version': 4, 'cidr': '36.192.103.128/26', 'allocation_pools': [{'start': '36.192.103.130', 'end': '36.192.103.190'}], 'gateway_ip': '36.192.103.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '36.192.103.130', 'tags': [], 'project_id': '0c56ebf283934d5381c8e788efc49815'}}
2025-12-22 03:11:43,718 - INFO - Created VN ctest-left_vn-13135216
2025-12-22 03:11:43,731 - DEBUG - VN ctest-left_vn-13135216 UUID is 917736d6-501a-41e5-bedc-fa64851a23a6
2025-12-22 03:11:43,805 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-22 03:11:43,810 - DEBUG - Requesting: http://10.0.0.23:8082/domain/cc89f09a-44c2-47d5-97ff-1101c2b1f822
2025-12-22 03:11:43,824 - DEBUG - Requesting: http://10.0.0.23:8082/project/0c56ebf2-8393-4d53-81c8-e788efc49815
2025-12-22 03:11:43,912 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/917736d6-501a-41e5-bedc-fa64851a23a6
2025-12-22 03:11:43,946 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/917736d6-501a-41e5-bedc-fa64851a23a6
2025-12-22 03:11:43,954 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/9e323a6c-3d9e-4746-ad9f-190d6e58de22
2025-12-22 03:11:43,972 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/9e323a6c-3d9e-4746-ad9f-190d6e58de22
2025-12-22 03:11:43,983 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/dca16e3c-ad93-4379-8dbd-9634da51fa64
2025-12-22 03:11:43,994 - DEBUG - Route Targets: ['target:64512:8000005']
2025-12-22 03:11:43,994 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/917736d6-501a-41e5-bedc-fa64851a23a6
2025-12-22 03:11:44,003 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/9e323a6c-3d9e-4746-ad9f-190d6e58de22
2025-12-22 03:11:44,019 - INFO - Verified VN network id 11 for VN 917736d6-501a-41e5-bedc-fa64851a23a6
2025-12-22 03:11:44,020 - INFO - Verifications in API Server for VN ctest-left_vn-13135216 passed
2025-12-22 03:11:44,020 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/917736d6-501a-41e5-bedc-fa64851a23a6
2025-12-22 03:11:44,029 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/9e323a6c-3d9e-4746-ad9f-190d6e58de22
2025-12-22 03:11:44,036 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/9e323a6c-3d9e-4746-ad9f-190d6e58de22
2025-12-22 03:11:44,042 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/dca16e3c-ad93-4379-8dbd-9634da51fa64
2025-12-22 03:11:44,052 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-80710792:ctest-left_vn-13135216', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-80710792', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10481906951822918117', 'uuid-lslong': '13753142671719408550'}, 'enable': 'true', 'created': '2025-12-22T03:11:43', 'last-modified': '2025-12-22T03:11:43', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.436847'}
2025-12-22 03:11:44,057 - DEBUG - Route Targets: ['target:64512:8000005']
2025-12-22 03:11:44,062 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-80710792:ctest-left_vn-13135216', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-80710792', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10481906951822918117', 'uuid-lslong': '13753142671719408550'}, 'enable': 'true', 'created': '2025-12-22T03:11:43', 'last-modified': '2025-12-22T03:11:43', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.447133'}
2025-12-22 03:11:44,067 - DEBUG - Route Targets: ['target:64512:8000005']
2025-12-22 03:11:44,075 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-80710792:ctest-left_vn-13135216', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-80710792', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10481906951822918117', 'uuid-lslong': '13753142671719408550'}, 'enable': 'true', 'created': '2025-12-22T03:11:43', 'last-modified': '2025-12-22T03:11:43', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.454521'}
2025-12-22 03:11:44,082 - DEBUG - Route Targets: ['target:64512:8000005']
2025-12-22 03:11:44,082 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-13135216 passed
2025-12-22 03:11:44,083 - DEBUG - ====Verifying policy data for ctest-left_vn-13135216 in API_Server ======
2025-12-22 03:11:44,083 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-22 03:11:44,090 - DEBUG - Requesting: http://10.0.0.23:8082/domain/cc89f09a-44c2-47d5-97ff-1101c2b1f822
2025-12-22 03:11:44,104 - DEBUG - Requesting: http://10.0.0.23:8082/project/0c56ebf2-8393-4d53-81c8-e788efc49815
2025-12-22 03:11:44,202 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/917736d6-501a-41e5-bedc-fa64851a23a6
2025-12-22 03:11:44,210 - DEBUG - =>VN ctest-left_vn-13135216 has no policy to be verified
2025-12-22 03:11:44,210 - DEBUG - Verifying the vn in opserver
2025-12-22 03:11:44,210 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-80710792:ctest-left_vn-13135216 virtual network link through opserver 10.0.0.23
2025-12-22 03:11:44,210 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-12-22 03:11:44,275 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-80710792:ctest-left_vn-13135216', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-80710792:ctest-left_vn-13135216?flat'}
2025-12-22 03:11:44,275 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-80710792:ctest-left_vn-13135216 virtual network link through opserver 10.0.0.22
2025-12-22 03:11:44,275 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2025-12-22 03:11:44,333 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-80710792:ctest-left_vn-13135216', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-80710792:ctest-left_vn-13135216?flat'}
2025-12-22 03:11:44,333 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-80710792:ctest-left_vn-13135216 virtual network link through opserver 10.0.0.65
2025-12-22 03:11:44,333 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2025-12-22 03:11:44,394 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-80710792:ctest-left_vn-13135216', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-80710792:ctest-left_vn-13135216?flat'}
2025-12-22 03:11:44,394 - INFO - Validated that VN default-domain:ctest-TestSvcHC-80710792:ctest-left_vn-13135216 is found in opserver
2025-12-22 03:11:44,418 - DEBUG - Do not have enough data to verify VN in agent
2025-12-22 03:11:44,428 - DEBUG - VRF ids for VN ctest-left_vn-13135216: {}
2025-12-22 03:11:44,791 - DEBUG - Response for create_network : {'network': {'id': '91a4d3ee-6b8d-4a7d-a741-b9a31fdcdb79', 'name': 'ctest-right_vn-73661754', 'tenant_id': '0c56ebf283934d5381c8e788efc49815', 'project_id': '0c56ebf283934d5381c8e788efc49815', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-80710792', 'ctest-right_vn-73661754'], 'port_security_enabled': True, 'description': ''}}
2025-12-22 03:11:45,056 - DEBUG - Response for create_subnet : {'subnet': {'id': '3ad0795c-50d0-48ed-84f9-1ee3b01151e8', 'name': '', 'tenant_id': '0c56ebf283934d5381c8e788efc49815', 'network_id': '91a4d3ee-6b8d-4a7d-a741-b9a31fdcdb79', 'ip_version': 4, 'cidr': '51.59.0.128/26', 'allocation_pools': [{'start': '51.59.0.130', 'end': '51.59.0.190'}], 'gateway_ip': '51.59.0.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '51.59.0.130', 'tags': [], 'project_id': '0c56ebf283934d5381c8e788efc49815'}}
2025-12-22 03:11:45,079 - INFO - Created VN ctest-right_vn-73661754
2025-12-22 03:11:45,094 - DEBUG - VN ctest-right_vn-73661754 UUID is 91a4d3ee-6b8d-4a7d-a741-b9a31fdcdb79
2025-12-22 03:11:45,165 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-22 03:11:45,171 - DEBUG - Requesting: http://10.0.0.23:8082/domain/cc89f09a-44c2-47d5-97ff-1101c2b1f822
2025-12-22 03:11:45,182 - DEBUG - Requesting: http://10.0.0.23:8082/project/0c56ebf2-8393-4d53-81c8-e788efc49815
2025-12-22 03:11:45,287 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/91a4d3ee-6b8d-4a7d-a741-b9a31fdcdb79
2025-12-22 03:11:45,298 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/91a4d3ee-6b8d-4a7d-a741-b9a31fdcdb79
2025-12-22 03:11:45,307 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/ad99d970-8dc2-441a-a1b0-b43864ddc901
2025-12-22 03:11:45,314 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/ad99d970-8dc2-441a-a1b0-b43864ddc901
2025-12-22 03:11:45,320 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/ac8c2d8f-e7bd-4fce-b615-4452642b2218
2025-12-22 03:11:45,327 - DEBUG - Route Targets: ['target:64512:8000006']
2025-12-22 03:11:45,327 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/91a4d3ee-6b8d-4a7d-a741-b9a31fdcdb79
2025-12-22 03:11:45,339 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/ad99d970-8dc2-441a-a1b0-b43864ddc901
2025-12-22 03:11:45,358 - INFO - Verified VN network id 12 for VN 91a4d3ee-6b8d-4a7d-a741-b9a31fdcdb79
2025-12-22 03:11:45,358 - INFO - Verifications in API Server for VN ctest-right_vn-73661754 passed
2025-12-22 03:11:45,358 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/91a4d3ee-6b8d-4a7d-a741-b9a31fdcdb79
2025-12-22 03:11:45,375 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/ad99d970-8dc2-441a-a1b0-b43864ddc901
2025-12-22 03:11:45,386 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/ad99d970-8dc2-441a-a1b0-b43864ddc901
2025-12-22 03:11:45,396 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/ac8c2d8f-e7bd-4fce-b615-4452642b2218
2025-12-22 03:11:45,410 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-80710792:ctest-right_vn-73661754', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-80710792', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10494746052640197245', 'uuid-lslong': '12052118188085533561'}, 'enable': 'true', 'created': '2025-12-22T03:11:44', 'last-modified': '2025-12-22T03:11:44', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.419567'}
2025-12-22 03:11:45,416 - DEBUG - Route Targets: ['target:64512:8000006']
2025-12-22 03:11:45,421 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-80710792:ctest-right_vn-73661754', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-80710792', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10494746052640197245', 'uuid-lslong': '12052118188085533561'}, 'enable': 'true', 'created': '2025-12-22T03:11:44', 'last-modified': '2025-12-22T03:11:44', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.430306'}
2025-12-22 03:11:45,428 - DEBUG - Route Targets: ['target:64512:8000006']
2025-12-22 03:11:45,445 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-80710792:ctest-right_vn-73661754', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-80710792', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10494746052640197245', 'uuid-lslong': '12052118188085533561'}, 'enable': 'true', 'created': '2025-12-22T03:11:44', 'last-modified': '2025-12-22T03:11:44', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.444638'}
2025-12-22 03:11:45,452 - DEBUG - Route Targets: ['target:64512:8000006']
2025-12-22 03:11:45,453 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-73661754 passed
2025-12-22 03:11:45,453 - DEBUG - ====Verifying policy data for ctest-right_vn-73661754 in API_Server ======
2025-12-22 03:11:45,453 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-22 03:11:45,465 - DEBUG - Requesting: http://10.0.0.23:8082/domain/cc89f09a-44c2-47d5-97ff-1101c2b1f822
2025-12-22 03:11:45,478 - DEBUG - Requesting: http://10.0.0.23:8082/project/0c56ebf2-8393-4d53-81c8-e788efc49815
2025-12-22 03:11:45,582 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/91a4d3ee-6b8d-4a7d-a741-b9a31fdcdb79
2025-12-22 03:11:45,607 - DEBUG - =>VN ctest-right_vn-73661754 has no policy to be verified
2025-12-22 03:11:45,607 - DEBUG - Verifying the vn in opserver
2025-12-22 03:11:45,607 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-80710792:ctest-right_vn-73661754 virtual network link through opserver 10.0.0.23
2025-12-22 03:11:45,607 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-12-22 03:11:45,669 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-80710792:ctest-right_vn-73661754', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-80710792:ctest-right_vn-73661754?flat'}
2025-12-22 03:11:45,669 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-80710792:ctest-right_vn-73661754 virtual network link through opserver 10.0.0.22
2025-12-22 03:11:45,669 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2025-12-22 03:11:45,741 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-80710792:ctest-right_vn-73661754', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-80710792:ctest-right_vn-73661754?flat'}
2025-12-22 03:11:45,741 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-80710792:ctest-right_vn-73661754 virtual network link through opserver 10.0.0.65
2025-12-22 03:11:45,741 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2025-12-22 03:11:45,815 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-80710792:ctest-right_vn-73661754', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-80710792:ctest-right_vn-73661754?flat'}
2025-12-22 03:11:45,815 - INFO - Validated that VN default-domain:ctest-TestSvcHC-80710792:ctest-right_vn-73661754 is found in opserver
2025-12-22 03:11:45,839 - DEBUG - Do not have enough data to verify VN in agent
2025-12-22 03:11:45,850 - DEBUG - VRF ids for VN ctest-right_vn-73661754: {}
2025-12-22 03:11:45,914 - DEBUG - Services list from nova: [, , , ]
2025-12-22 03:11:47,000 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4918-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4918-1)
2025-12-22 03:11:48,386 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4918-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4918-2)
2025-12-22 03:11:48,386 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-74333534']
2025-12-22 03:11:48,694 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-74333534'] created succesfully
2025-12-22 03:11:49,073 - DEBUG - Image by name tiny_nat_fw not found
2025-12-22 03:11:49,073 - DEBUG - Installing image tiny_nat_fw
2025-12-22 03:11:49,073 - 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-22 03:11:49,073 - DEBUG - Image build path file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2025-12-22 03:11:49,073 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2025-12-22 03:11:49,073 - DEBUG - Unzip image
2025-12-22 03:11:49,073 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2025-12-22 03:11:49,091 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2025-12-22 03:11:49,091 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-74333534']
2025-12-22 03:11:49,206 - INFO - Service template: ['default-domain', 'ctest-service_template_1-74333534'] deleted successfully.
2025-12-22 03:11:49,206 - INFO - Skip interface_detach for VM ctest-right_vm-47120554 in state BUILD
2025-12-22 03:11:49,206 - INFO - Deleting VM ctest-right_vm-47120554
2025-12-22 03:11:49,279 - ERROR - VM ctest-right_vm-47120554 has failed to come up
2025-12-22 03:11:49,279 - ERROR - Nova failed to get host of the VM
2025-12-22 03:11:49,279 - ERROR - VM ctest-right_vm-47120554 has failed to come up
2025-12-22 03:11:49,279 - ERROR - Nova failed to get host of the VM
2025-12-22 03:11:49,357 - INFO - Skip interface_detach for VM ctest-left_vm-62574811 in state BUILD
2025-12-22 03:11:49,357 - INFO - Deleting VM ctest-left_vm-62574811
2025-12-22 03:11:49,357 - ERROR - VM ctest-left_vm-62574811 has failed to come up
2025-12-22 03:11:49,358 - ERROR - Nova failed to get host of the VM
2025-12-22 03:11:49,358 - ERROR - VM ctest-left_vm-62574811 has failed to come up
2025-12-22 03:11:49,358 - ERROR - Nova failed to get host of the VM
2025-12-22 03:11:49,428 - INFO - Deleting VN ctest-right_vn-73661754
2025-12-22 03:11:49,470 - DEBUG - VN 91a4d3ee-6b8d-4a7d-a741-b9a31fdcdb79 still in use: Unable to complete operation on network 91a4d3ee-6b8d-4a7d-a741-b9a31fdcdb79. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-cbe137fc-f3e8-4b40-872b-e96af70845e7']
2025-12-22 03:11:49,470 - WARNING - Deleting VN ctest-right_vn-73661754 failed..Will retry
2025-12-22 03:11:51,650 - DEBUG - Response for deleting network ()
2025-12-22 03:11:51,650 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/ad99d970-8dc2-441a-a1b0-b43864ddc901
2025-12-22 03:11:51,656 - DEBUG - Response Code: 404
2025-12-22 03:11:51,656 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-22 03:11:51,667 - DEBUG - Requesting: http://10.0.0.23:8082/domain/cc89f09a-44c2-47d5-97ff-1101c2b1f822
2025-12-22 03:11:51,703 - DEBUG - Requesting: http://10.0.0.23:8082/project/0c56ebf2-8393-4d53-81c8-e788efc49815
2025-12-22 03:11:51,793 - INFO - Validated that VN ctest-right_vn-73661754 is not found in API Server
2025-12-22 03:11:51,804 - DEBUG - VN ctest-right_vn-73661754 is not present in Agent 10.0.0.130
2025-12-22 03:11:51,815 - DEBUG - VN ctest-right_vn-73661754 is not present in Agent 10.0.0.19
2025-12-22 03:11:51,815 - INFO - Validated that VN ctest-right_vn-73661754 is not in any agent
2025-12-22 03:11:51,853 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-73661754 info
2025-12-22 03:11:51,853 - INFO - Deleting VN ctest-left_vn-13135216
2025-12-22 03:11:52,042 - DEBUG - Response for deleting network ()
2025-12-22 03:11:52,042 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/9e323a6c-3d9e-4746-ad9f-190d6e58de22
2025-12-22 03:11:52,049 - DEBUG - Response Code: 404
2025-12-22 03:11:52,049 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-22 03:11:52,063 - DEBUG - Requesting: http://10.0.0.23:8082/domain/cc89f09a-44c2-47d5-97ff-1101c2b1f822
2025-12-22 03:11:52,089 - DEBUG - Requesting: http://10.0.0.23:8082/project/0c56ebf2-8393-4d53-81c8-e788efc49815
2025-12-22 03:11:52,188 - INFO - Validated that VN ctest-left_vn-13135216 is not found in API Server
2025-12-22 03:11:52,199 - DEBUG - VN ctest-left_vn-13135216 is not present in Agent 10.0.0.130
2025-12-22 03:11:52,209 - DEBUG - VN ctest-left_vn-13135216 is not present in Agent 10.0.0.19
2025-12-22 03:11:52,209 - INFO - Validated that VN ctest-left_vn-13135216 is not in any agent
2025-12-22 03:11:52,237 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-13135216 info
2025-12-22 03:11:52,238 - INFO - Deleting VN ctest-mgmt_vn-60609853
2025-12-22 03:11:52,393 - DEBUG - Response for deleting network ()
2025-12-22 03:11:52,393 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/7148d134-10c4-4342-a994-57dda18671e4
2025-12-22 03:11:52,399 - DEBUG - Response Code: 404
2025-12-22 03:11:52,399 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-22 03:11:52,406 - DEBUG - Requesting: http://10.0.0.23:8082/domain/cc89f09a-44c2-47d5-97ff-1101c2b1f822
2025-12-22 03:11:52,417 - DEBUG - Requesting: http://10.0.0.23:8082/project/0c56ebf2-8393-4d53-81c8-e788efc49815
2025-12-22 03:11:52,523 - INFO - Validated that VN ctest-mgmt_vn-60609853 is not found in API Server
2025-12-22 03:11:52,535 - DEBUG - VN ctest-mgmt_vn-60609853 is not present in Agent 10.0.0.130
2025-12-22 03:11:52,547 - DEBUG - VN ctest-mgmt_vn-60609853 is not present in Agent 10.0.0.19
2025-12-22 03:11:52,547 - INFO - Validated that VN ctest-mgmt_vn-60609853 is not in any agent
2025-12-22 03:11:52,578 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-60609853 info
2025-12-22 03:11:53,872 - DEBUG - No XMPP flaps were noticed during the test
2025-12-22 03:11:53,872 - INFO -
2025-12-22 03:11:53,873 - INFO - END TEST : test_svc_hc_basic : SKIPPED[0:00:15]
2025-12-22 03:11:53,873 - INFO - --------------------------------------------------------------------------------
2025-12-22 03:11:53,878 - INFO - ================================================================================
2025-12-22 03:11:53,878 - INFO - STARTING TEST : test_svc_trans_segment_right_hc_fail_svm
2025-12-22 03:11:55,179 - DEBUG - Nothing to compare xmpp stats {'10.0.0.130': {'10.20.0.14': '0', '10.20.0.192': '0'}, '10.0.0.19': {'10.20.0.129': '0', '10.20.0.192': '0'}} with
2025-12-22 03:11:55,179 - INFO - Initial checks done. Running the testcase now
2025-12-22 03:11:55,179 - INFO -
2025-12-22 03:11:55,434 - DEBUG - Response for create_network : {'network': {'id': 'e9f5da7c-630a-4d45-a91e-d7264d791a47', 'name': 'ctest-mgmt_vn-73812737', 'tenant_id': '0c56ebf283934d5381c8e788efc49815', 'project_id': '0c56ebf283934d5381c8e788efc49815', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-80710792', 'ctest-mgmt_vn-73812737'], 'port_security_enabled': True, 'description': ''}}
2025-12-22 03:11:55,646 - DEBUG - Response for create_subnet : {'subnet': {'id': '8892a357-6c42-4222-b451-a7efbf774819', 'name': '', 'tenant_id': '0c56ebf283934d5381c8e788efc49815', 'network_id': 'e9f5da7c-630a-4d45-a91e-d7264d791a47', 'ip_version': 4, 'cidr': '169.154.192.0/26', 'allocation_pools': [{'start': '169.154.192.2', 'end': '169.154.192.62'}], 'gateway_ip': '169.154.192.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '169.154.192.2', 'tags': [], 'project_id': '0c56ebf283934d5381c8e788efc49815'}}
2025-12-22 03:11:55,670 - INFO - Created VN ctest-mgmt_vn-73812737
2025-12-22 03:11:55,684 - DEBUG - VN ctest-mgmt_vn-73812737 UUID is e9f5da7c-630a-4d45-a91e-d7264d791a47
2025-12-22 03:11:55,751 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-22 03:11:55,756 - DEBUG - Requesting: http://10.0.0.23:8082/domain/cc89f09a-44c2-47d5-97ff-1101c2b1f822
2025-12-22 03:11:55,767 - DEBUG - Requesting: http://10.0.0.23:8082/project/0c56ebf2-8393-4d53-81c8-e788efc49815
2025-12-22 03:11:55,856 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/e9f5da7c-630a-4d45-a91e-d7264d791a47
2025-12-22 03:11:55,867 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/e9f5da7c-630a-4d45-a91e-d7264d791a47
2025-12-22 03:11:55,876 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/19e673a3-9f4a-4110-8465-ecca608a17e9
2025-12-22 03:11:55,883 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/19e673a3-9f4a-4110-8465-ecca608a17e9
2025-12-22 03:11:55,890 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/fe5faec1-0f35-4fa0-98e6-f6a19e634a82
2025-12-22 03:11:55,898 - DEBUG - Route Targets: ['target:64512:8000004']
2025-12-22 03:11:55,898 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/e9f5da7c-630a-4d45-a91e-d7264d791a47
2025-12-22 03:11:55,906 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/19e673a3-9f4a-4110-8465-ecca608a17e9
2025-12-22 03:11:55,922 - INFO - Verified VN network id 10 for VN e9f5da7c-630a-4d45-a91e-d7264d791a47
2025-12-22 03:11:55,922 - INFO - Verifications in API Server for VN ctest-mgmt_vn-73812737 passed
2025-12-22 03:11:55,922 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/e9f5da7c-630a-4d45-a91e-d7264d791a47
2025-12-22 03:11:55,930 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/19e673a3-9f4a-4110-8465-ecca608a17e9
2025-12-22 03:11:55,936 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/19e673a3-9f4a-4110-8465-ecca608a17e9
2025-12-22 03:11:55,942 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/fe5faec1-0f35-4fa0-98e6-f6a19e634a82
2025-12-22 03:11:55,953 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-80710792:ctest-mgmt_vn-73812737', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-80710792', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16858621007903739205', 'uuid-lslong': '12186414201219652167'}, 'enable': 'true', 'created': '2025-12-22T03:11:55', 'last-modified': '2025-12-22T03:11:55', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.345091'}
2025-12-22 03:11:55,959 - DEBUG - Route Targets: ['target:64512:8000004']
2025-12-22 03:11:55,963 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-80710792:ctest-mgmt_vn-73812737', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-80710792', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16858621007903739205', 'uuid-lslong': '12186414201219652167'}, 'enable': 'true', 'created': '2025-12-22T03:11:55', 'last-modified': '2025-12-22T03:11:55', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.366627'}
2025-12-22 03:11:55,969 - DEBUG - Route Targets: ['target:64512:8000004']
2025-12-22 03:11:55,975 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-80710792:ctest-mgmt_vn-73812737', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-80710792', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16858621007903739205', 'uuid-lslong': '12186414201219652167'}, 'enable': 'true', 'created': '2025-12-22T03:11:55', 'last-modified': '2025-12-22T03:11:55', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.377500'}
2025-12-22 03:11:55,982 - DEBUG - Route Targets: ['target:64512:8000004']
2025-12-22 03:11:55,982 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-73812737 passed
2025-12-22 03:11:55,982 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-73812737 in API_Server ======
2025-12-22 03:11:55,982 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-22 03:11:55,989 - DEBUG - Requesting: http://10.0.0.23:8082/domain/cc89f09a-44c2-47d5-97ff-1101c2b1f822
2025-12-22 03:11:55,999 - DEBUG - Requesting: http://10.0.0.23:8082/project/0c56ebf2-8393-4d53-81c8-e788efc49815
2025-12-22 03:11:56,091 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/e9f5da7c-630a-4d45-a91e-d7264d791a47
2025-12-22 03:11:56,101 - DEBUG - =>VN ctest-mgmt_vn-73812737 has no policy to be verified
2025-12-22 03:11:56,101 - DEBUG - Verifying the vn in opserver
2025-12-22 03:11:56,101 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-80710792:ctest-mgmt_vn-73812737 virtual network link through opserver 10.0.0.23
2025-12-22 03:11:56,102 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-12-22 03:11:56,114 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-80710792:ctest-mgmt_vn-73812737', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-80710792:ctest-mgmt_vn-73812737?flat'}
2025-12-22 03:11:56,114 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-80710792:ctest-mgmt_vn-73812737 virtual network link through opserver 10.0.0.22
2025-12-22 03:11:56,114 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2025-12-22 03:11:56,126 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-80710792:ctest-mgmt_vn-73812737', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-80710792:ctest-mgmt_vn-73812737?flat'}
2025-12-22 03:11:56,126 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-80710792:ctest-mgmt_vn-73812737 virtual network link through opserver 10.0.0.65
2025-12-22 03:11:56,126 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2025-12-22 03:11:56,140 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-80710792:ctest-mgmt_vn-73812737', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-80710792:ctest-mgmt_vn-73812737?flat'}
2025-12-22 03:11:56,140 - INFO - Validated that VN default-domain:ctest-TestSvcHC-80710792:ctest-mgmt_vn-73812737 is found in opserver
2025-12-22 03:11:56,161 - DEBUG - Do not have enough data to verify VN in agent
2025-12-22 03:11:56,171 - DEBUG - VRF ids for VN ctest-mgmt_vn-73812737: {}
2025-12-22 03:11:56,458 - DEBUG - Response for create_network : {'network': {'id': 'bdfda055-61c5-4f2c-87bd-4a2fd22f9377', 'name': 'ctest-left_vn-27457002', 'tenant_id': '0c56ebf283934d5381c8e788efc49815', 'project_id': '0c56ebf283934d5381c8e788efc49815', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-80710792', 'ctest-left_vn-27457002'], 'port_security_enabled': True, 'description': ''}}
2025-12-22 03:11:56,697 - DEBUG - Response for create_subnet : {'subnet': {'id': 'b977c698-b23a-489c-b877-9b0eec636bb0', 'name': '', 'tenant_id': '0c56ebf283934d5381c8e788efc49815', 'network_id': 'bdfda055-61c5-4f2c-87bd-4a2fd22f9377', 'ip_version': 4, 'cidr': '65.239.148.192/26', 'allocation_pools': [{'start': '65.239.148.194', 'end': '65.239.148.254'}], 'gateway_ip': '65.239.148.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '65.239.148.194', 'tags': [], 'project_id': '0c56ebf283934d5381c8e788efc49815'}}
2025-12-22 03:11:56,720 - INFO - Created VN ctest-left_vn-27457002
2025-12-22 03:11:56,732 - DEBUG - VN ctest-left_vn-27457002 UUID is bdfda055-61c5-4f2c-87bd-4a2fd22f9377
2025-12-22 03:11:56,813 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-22 03:11:56,820 - DEBUG - Requesting: http://10.0.0.23:8082/domain/cc89f09a-44c2-47d5-97ff-1101c2b1f822
2025-12-22 03:11:56,832 - DEBUG - Requesting: http://10.0.0.23:8082/project/0c56ebf2-8393-4d53-81c8-e788efc49815
2025-12-22 03:11:56,926 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/bdfda055-61c5-4f2c-87bd-4a2fd22f9377
2025-12-22 03:11:56,940 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/bdfda055-61c5-4f2c-87bd-4a2fd22f9377
2025-12-22 03:11:56,950 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/9c15b287-9433-4d66-b1ed-14204edef55a
2025-12-22 03:11:56,958 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/9c15b287-9433-4d66-b1ed-14204edef55a
2025-12-22 03:11:56,966 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/1df29687-48e2-433e-9c58-2593fcc7fd5b
2025-12-22 03:11:56,973 - DEBUG - Route Targets: ['target:64512:8000005']
2025-12-22 03:11:56,973 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/bdfda055-61c5-4f2c-87bd-4a2fd22f9377
2025-12-22 03:11:56,983 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/9c15b287-9433-4d66-b1ed-14204edef55a
2025-12-22 03:11:57,001 - INFO - Verified VN network id 11 for VN bdfda055-61c5-4f2c-87bd-4a2fd22f9377
2025-12-22 03:11:57,001 - INFO - Verifications in API Server for VN ctest-left_vn-27457002 passed
2025-12-22 03:11:57,001 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/bdfda055-61c5-4f2c-87bd-4a2fd22f9377
2025-12-22 03:11:57,014 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/9c15b287-9433-4d66-b1ed-14204edef55a
2025-12-22 03:11:57,023 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/9c15b287-9433-4d66-b1ed-14204edef55a
2025-12-22 03:11:57,031 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/1df29687-48e2-433e-9c58-2593fcc7fd5b
2025-12-22 03:11:57,048 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-80710792:ctest-left_vn-27457002', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-80710792', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13690274730849161004', 'uuid-lslong': '9781055534968836983'}, 'enable': 'true', 'created': '2025-12-22T03:11:56', 'last-modified': '2025-12-22T03:11:56', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.417957'}
2025-12-22 03:11:57,056 - DEBUG - Route Targets: ['target:64512:8000005']
2025-12-22 03:11:57,062 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-80710792:ctest-left_vn-27457002', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-80710792', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13690274730849161004', 'uuid-lslong': '9781055534968836983'}, 'enable': 'true', 'created': '2025-12-22T03:11:56', 'last-modified': '2025-12-22T03:11:56', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.430509'}
2025-12-22 03:11:57,068 - DEBUG - Route Targets: ['target:64512:8000005']
2025-12-22 03:11:57,073 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-80710792:ctest-left_vn-27457002', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-80710792', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13690274730849161004', 'uuid-lslong': '9781055534968836983'}, 'enable': 'true', 'created': '2025-12-22T03:11:56', 'last-modified': '2025-12-22T03:11:56', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.442517'}
2025-12-22 03:11:57,079 - DEBUG - Route Targets: ['target:64512:8000005']
2025-12-22 03:11:57,079 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-27457002 passed
2025-12-22 03:11:57,079 - DEBUG - ====Verifying policy data for ctest-left_vn-27457002 in API_Server ======
2025-12-22 03:11:57,080 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-22 03:11:57,087 - DEBUG - Requesting: http://10.0.0.23:8082/domain/cc89f09a-44c2-47d5-97ff-1101c2b1f822
2025-12-22 03:11:57,106 - DEBUG - Requesting: http://10.0.0.23:8082/project/0c56ebf2-8393-4d53-81c8-e788efc49815
2025-12-22 03:11:57,212 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/bdfda055-61c5-4f2c-87bd-4a2fd22f9377
2025-12-22 03:11:57,225 - DEBUG - =>VN ctest-left_vn-27457002 has no policy to be verified
2025-12-22 03:11:57,225 - DEBUG - Verifying the vn in opserver
2025-12-22 03:11:57,225 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-80710792:ctest-left_vn-27457002 virtual network link through opserver 10.0.0.23
2025-12-22 03:11:57,225 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-12-22 03:11:57,238 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-80710792:ctest-left_vn-27457002', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-80710792:ctest-left_vn-27457002?flat'}
2025-12-22 03:11:57,238 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-80710792:ctest-left_vn-27457002 virtual network link through opserver 10.0.0.22
2025-12-22 03:11:57,238 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2025-12-22 03:11:57,251 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-80710792:ctest-left_vn-27457002', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-80710792:ctest-left_vn-27457002?flat'}
2025-12-22 03:11:57,251 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-80710792:ctest-left_vn-27457002 virtual network link through opserver 10.0.0.65
2025-12-22 03:11:57,251 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2025-12-22 03:11:57,269 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-80710792:ctest-left_vn-27457002', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-80710792:ctest-left_vn-27457002?flat'}
2025-12-22 03:11:57,269 - INFO - Validated that VN default-domain:ctest-TestSvcHC-80710792:ctest-left_vn-27457002 is found in opserver
2025-12-22 03:11:57,293 - DEBUG - Do not have enough data to verify VN in agent
2025-12-22 03:11:57,304 - DEBUG - VRF ids for VN ctest-left_vn-27457002: {}
2025-12-22 03:11:57,614 - DEBUG - Response for create_network : {'network': {'id': '295cdf84-ab5e-4f8b-8fa5-84e78ad85837', 'name': 'ctest-right_vn-80760319', 'tenant_id': '0c56ebf283934d5381c8e788efc49815', 'project_id': '0c56ebf283934d5381c8e788efc49815', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-80710792', 'ctest-right_vn-80760319'], 'port_security_enabled': True, 'description': ''}}
2025-12-22 03:11:57,840 - DEBUG - Response for create_subnet : {'subnet': {'id': '5bba7f8f-9147-4aeb-ae35-2e479426354e', 'name': '', 'tenant_id': '0c56ebf283934d5381c8e788efc49815', 'network_id': '295cdf84-ab5e-4f8b-8fa5-84e78ad85837', 'ip_version': 4, 'cidr': '188.37.155.192/26', 'allocation_pools': [{'start': '188.37.155.194', 'end': '188.37.155.254'}], 'gateway_ip': '188.37.155.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '188.37.155.194', 'tags': [], 'project_id': '0c56ebf283934d5381c8e788efc49815'}}
2025-12-22 03:11:57,863 - INFO - Created VN ctest-right_vn-80760319
2025-12-22 03:11:57,878 - DEBUG - VN ctest-right_vn-80760319 UUID is 295cdf84-ab5e-4f8b-8fa5-84e78ad85837
2025-12-22 03:11:57,952 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-22 03:11:57,959 - DEBUG - Requesting: http://10.0.0.23:8082/domain/cc89f09a-44c2-47d5-97ff-1101c2b1f822
2025-12-22 03:11:57,970 - DEBUG - Requesting: http://10.0.0.23:8082/project/0c56ebf2-8393-4d53-81c8-e788efc49815
2025-12-22 03:11:58,070 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/295cdf84-ab5e-4f8b-8fa5-84e78ad85837
2025-12-22 03:11:58,084 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/295cdf84-ab5e-4f8b-8fa5-84e78ad85837
2025-12-22 03:11:58,092 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/ddb73e53-bacd-4d2a-9738-76bfc932d8c5
2025-12-22 03:11:58,098 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/ddb73e53-bacd-4d2a-9738-76bfc932d8c5
2025-12-22 03:11:58,107 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/da131352-b04c-4775-acd9-1b7aabe6d354
2025-12-22 03:11:58,113 - DEBUG - Route Targets: ['target:64512:8000006']
2025-12-22 03:11:58,113 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/295cdf84-ab5e-4f8b-8fa5-84e78ad85837
2025-12-22 03:11:58,122 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/ddb73e53-bacd-4d2a-9738-76bfc932d8c5
2025-12-22 03:11:58,137 - INFO - Verified VN network id 12 for VN 295cdf84-ab5e-4f8b-8fa5-84e78ad85837
2025-12-22 03:11:58,137 - INFO - Verifications in API Server for VN ctest-right_vn-80760319 passed
2025-12-22 03:11:58,137 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/295cdf84-ab5e-4f8b-8fa5-84e78ad85837
2025-12-22 03:11:58,147 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/ddb73e53-bacd-4d2a-9738-76bfc932d8c5
2025-12-22 03:11:58,156 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/ddb73e53-bacd-4d2a-9738-76bfc932d8c5
2025-12-22 03:11:58,165 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/da131352-b04c-4775-acd9-1b7aabe6d354
2025-12-22 03:11:58,177 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-80710792:ctest-right_vn-80760319', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-80710792', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2980502814316187531', 'uuid-lslong': '10350825448582699063'}, 'enable': 'true', 'created': '2025-12-22T03:11:57', 'last-modified': '2025-12-22T03:11:57', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.394735'}
2025-12-22 03:11:58,182 - DEBUG - Route Targets: ['target:64512:8000006']
2025-12-22 03:11:58,187 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-80710792:ctest-right_vn-80760319', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-80710792', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2980502814316187531', 'uuid-lslong': '10350825448582699063'}, 'enable': 'true', 'created': '2025-12-22T03:11:57', 'last-modified': '2025-12-22T03:11:57', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.407947'}
2025-12-22 03:11:58,193 - DEBUG - Route Targets: ['target:64512:8000006']
2025-12-22 03:11:58,199 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-80710792:ctest-right_vn-80760319', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-80710792', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2980502814316187531', 'uuid-lslong': '10350825448582699063'}, 'enable': 'true', 'created': '2025-12-22T03:11:57', 'last-modified': '2025-12-22T03:11:57', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.419123'}
2025-12-22 03:11:58,204 - DEBUG - Route Targets: ['target:64512:8000006']
2025-12-22 03:11:58,204 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-80760319 passed
2025-12-22 03:11:58,205 - DEBUG - ====Verifying policy data for ctest-right_vn-80760319 in API_Server ======
2025-12-22 03:11:58,205 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-22 03:11:58,212 - DEBUG - Requesting: http://10.0.0.23:8082/domain/cc89f09a-44c2-47d5-97ff-1101c2b1f822
2025-12-22 03:11:58,222 - DEBUG - Requesting: http://10.0.0.23:8082/project/0c56ebf2-8393-4d53-81c8-e788efc49815
2025-12-22 03:11:58,315 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/295cdf84-ab5e-4f8b-8fa5-84e78ad85837
2025-12-22 03:11:58,327 - DEBUG - =>VN ctest-right_vn-80760319 has no policy to be verified
2025-12-22 03:11:58,327 - DEBUG - Verifying the vn in opserver
2025-12-22 03:11:58,328 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-80710792:ctest-right_vn-80760319 virtual network link through opserver 10.0.0.23
2025-12-22 03:11:58,328 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-12-22 03:11:58,340 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-80710792:ctest-right_vn-80760319', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-80710792:ctest-right_vn-80760319?flat'}
2025-12-22 03:11:58,340 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-80710792:ctest-right_vn-80760319 virtual network link through opserver 10.0.0.22
2025-12-22 03:11:58,340 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2025-12-22 03:11:58,355 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-80710792:ctest-right_vn-80760319', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-80710792:ctest-right_vn-80760319?flat'}
2025-12-22 03:11:58,355 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-80710792:ctest-right_vn-80760319 virtual network link through opserver 10.0.0.65
2025-12-22 03:11:58,355 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2025-12-22 03:11:58,373 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-80710792:ctest-right_vn-80760319', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-80710792:ctest-right_vn-80760319?flat'}
2025-12-22 03:11:58,373 - INFO - Validated that VN default-domain:ctest-TestSvcHC-80710792:ctest-right_vn-80760319 is found in opserver
2025-12-22 03:11:58,396 - DEBUG - Do not have enough data to verify VN in agent
2025-12-22 03:11:58,407 - DEBUG - VRF ids for VN ctest-right_vn-80760319: {}
2025-12-22 03:11:58,674 - DEBUG - Response for create_network : {'network': {'id': '0749260c-4473-44c5-84d4-2528f3a2ab52', 'name': 'ctest-trans_left_vn-75539957', 'tenant_id': '0c56ebf283934d5381c8e788efc49815', 'project_id': '0c56ebf283934d5381c8e788efc49815', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-80710792', 'ctest-trans_left_vn-75539957'], 'port_security_enabled': True, 'description': ''}}
2025-12-22 03:11:58,905 - DEBUG - Response for create_subnet : {'subnet': {'id': 'ba448e1b-bb03-457a-816b-f9d1f6acf007', 'name': '', 'tenant_id': '0c56ebf283934d5381c8e788efc49815', 'network_id': '0749260c-4473-44c5-84d4-2528f3a2ab52', 'ip_version': 4, 'cidr': '63.51.163.64/26', 'allocation_pools': [{'start': '63.51.163.66', 'end': '63.51.163.126'}], 'gateway_ip': '63.51.163.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '63.51.163.66', 'tags': [], 'project_id': '0c56ebf283934d5381c8e788efc49815'}}
2025-12-22 03:11:58,932 - INFO - Created VN ctest-trans_left_vn-75539957
2025-12-22 03:11:58,943 - DEBUG - VN ctest-trans_left_vn-75539957 UUID is 0749260c-4473-44c5-84d4-2528f3a2ab52
2025-12-22 03:11:59,026 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-22 03:11:59,033 - DEBUG - Requesting: http://10.0.0.23:8082/domain/cc89f09a-44c2-47d5-97ff-1101c2b1f822
2025-12-22 03:11:59,044 - DEBUG - Requesting: http://10.0.0.23:8082/project/0c56ebf2-8393-4d53-81c8-e788efc49815
2025-12-22 03:11:59,141 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/0749260c-4473-44c5-84d4-2528f3a2ab52
2025-12-22 03:11:59,152 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/0749260c-4473-44c5-84d4-2528f3a2ab52
2025-12-22 03:11:59,160 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/712b82da-4c9c-4076-982a-20cff823b416
2025-12-22 03:11:59,168 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/712b82da-4c9c-4076-982a-20cff823b416
2025-12-22 03:11:59,174 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/6874aa61-e579-4279-8bc0-66ca806a83d8
2025-12-22 03:11:59,180 - DEBUG - Route Targets: ['target:64512:8000007']
2025-12-22 03:11:59,180 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/0749260c-4473-44c5-84d4-2528f3a2ab52
2025-12-22 03:11:59,188 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/712b82da-4c9c-4076-982a-20cff823b416
2025-12-22 03:11:59,203 - INFO - Verified VN network id 13 for VN 0749260c-4473-44c5-84d4-2528f3a2ab52
2025-12-22 03:11:59,204 - INFO - Verifications in API Server for VN ctest-trans_left_vn-75539957 passed
2025-12-22 03:11:59,204 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/0749260c-4473-44c5-84d4-2528f3a2ab52
2025-12-22 03:11:59,213 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/712b82da-4c9c-4076-982a-20cff823b416
2025-12-22 03:11:59,219 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/712b82da-4c9c-4076-982a-20cff823b416
2025-12-22 03:11:59,225 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/6874aa61-e579-4279-8bc0-66ca806a83d8
2025-12-22 03:11:59,236 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-80710792:ctest-trans_left_vn-75539957', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-80710792', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '524992665695241413', 'uuid-lslong': '9571315965885590354'}, 'enable': 'true', 'created': '2025-12-22T03:11:58', 'last-modified': '2025-12-22T03:11:58', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.380232'}
2025-12-22 03:11:59,241 - DEBUG - Route Targets: ['target:64512:8000007']
2025-12-22 03:11:59,247 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-80710792:ctest-trans_left_vn-75539957', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-80710792', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '524992665695241413', 'uuid-lslong': '9571315965885590354'}, 'enable': 'true', 'created': '2025-12-22T03:11:58', 'last-modified': '2025-12-22T03:11:58', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.393117'}
2025-12-22 03:11:59,253 - DEBUG - Route Targets: ['target:64512:8000007']
2025-12-22 03:11:59,259 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-80710792:ctest-trans_left_vn-75539957', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-80710792', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '524992665695241413', 'uuid-lslong': '9571315965885590354'}, 'enable': 'true', 'created': '2025-12-22T03:11:58', 'last-modified': '2025-12-22T03:11:58', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.401657'}
2025-12-22 03:11:59,266 - DEBUG - Route Targets: ['target:64512:8000007']
2025-12-22 03:11:59,266 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_left_vn-75539957 passed
2025-12-22 03:11:59,267 - DEBUG - ====Verifying policy data for ctest-trans_left_vn-75539957 in API_Server ======
2025-12-22 03:11:59,267 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-22 03:11:59,272 - DEBUG - Requesting: http://10.0.0.23:8082/domain/cc89f09a-44c2-47d5-97ff-1101c2b1f822
2025-12-22 03:11:59,281 - DEBUG - Requesting: http://10.0.0.23:8082/project/0c56ebf2-8393-4d53-81c8-e788efc49815
2025-12-22 03:11:59,376 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/0749260c-4473-44c5-84d4-2528f3a2ab52
2025-12-22 03:11:59,386 - DEBUG - =>VN ctest-trans_left_vn-75539957 has no policy to be verified
2025-12-22 03:11:59,386 - DEBUG - Verifying the vn in opserver
2025-12-22 03:11:59,386 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-80710792:ctest-trans_left_vn-75539957 virtual network link through opserver 10.0.0.23
2025-12-22 03:11:59,386 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-12-22 03:11:59,399 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-80710792:ctest-trans_left_vn-75539957', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-80710792:ctest-trans_left_vn-75539957?flat'}
2025-12-22 03:11:59,399 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-80710792:ctest-trans_left_vn-75539957 virtual network link through opserver 10.0.0.22
2025-12-22 03:11:59,399 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2025-12-22 03:11:59,412 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-80710792:ctest-trans_left_vn-75539957', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-80710792:ctest-trans_left_vn-75539957?flat'}
2025-12-22 03:11:59,412 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-80710792:ctest-trans_left_vn-75539957 virtual network link through opserver 10.0.0.65
2025-12-22 03:11:59,412 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2025-12-22 03:11:59,426 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-80710792:ctest-trans_left_vn-75539957', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-80710792:ctest-trans_left_vn-75539957?flat'}
2025-12-22 03:11:59,426 - INFO - Validated that VN default-domain:ctest-TestSvcHC-80710792:ctest-trans_left_vn-75539957 is found in opserver
2025-12-22 03:11:59,446 - DEBUG - Do not have enough data to verify VN in agent
2025-12-22 03:11:59,456 - DEBUG - VRF ids for VN ctest-trans_left_vn-75539957: {}
2025-12-22 03:11:59,753 - DEBUG - Response for create_network : {'network': {'id': '0f3d6957-4c87-4c79-b2ac-0a9ff3b85efb', 'name': 'ctest-trans_right_vn-27720007', 'tenant_id': '0c56ebf283934d5381c8e788efc49815', 'project_id': '0c56ebf283934d5381c8e788efc49815', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-80710792', 'ctest-trans_right_vn-27720007'], 'port_security_enabled': True, 'description': ''}}
2025-12-22 03:11:59,996 - DEBUG - Response for create_subnet : {'subnet': {'id': '05297060-ff1f-402b-85aa-f7a569e62abd', 'name': '', 'tenant_id': '0c56ebf283934d5381c8e788efc49815', 'network_id': '0f3d6957-4c87-4c79-b2ac-0a9ff3b85efb', 'ip_version': 4, 'cidr': '158.170.38.64/26', 'allocation_pools': [{'start': '158.170.38.66', 'end': '158.170.38.126'}], 'gateway_ip': '158.170.38.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '158.170.38.66', 'tags': [], 'project_id': '0c56ebf283934d5381c8e788efc49815'}}
2025-12-22 03:12:00,021 - INFO - Created VN ctest-trans_right_vn-27720007
2025-12-22 03:12:00,038 - DEBUG - VN ctest-trans_right_vn-27720007 UUID is 0f3d6957-4c87-4c79-b2ac-0a9ff3b85efb
2025-12-22 03:12:00,116 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-22 03:12:00,123 - DEBUG - Requesting: http://10.0.0.23:8082/domain/cc89f09a-44c2-47d5-97ff-1101c2b1f822
2025-12-22 03:12:00,133 - DEBUG - Requesting: http://10.0.0.23:8082/project/0c56ebf2-8393-4d53-81c8-e788efc49815
2025-12-22 03:12:00,226 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/0f3d6957-4c87-4c79-b2ac-0a9ff3b85efb
2025-12-22 03:12:00,241 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/0f3d6957-4c87-4c79-b2ac-0a9ff3b85efb
2025-12-22 03:12:00,250 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/977915d7-c933-4718-9986-6ce8f5fd6203
2025-12-22 03:12:00,261 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/977915d7-c933-4718-9986-6ce8f5fd6203
2025-12-22 03:12:00,268 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/4a2422dc-d63a-4739-aee3-eff4d94b489b
2025-12-22 03:12:00,275 - DEBUG - Route Targets: ['target:64512:8000008']
2025-12-22 03:12:00,275 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/0f3d6957-4c87-4c79-b2ac-0a9ff3b85efb
2025-12-22 03:12:00,284 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/977915d7-c933-4718-9986-6ce8f5fd6203
2025-12-22 03:12:00,300 - INFO - Verified VN network id 14 for VN 0f3d6957-4c87-4c79-b2ac-0a9ff3b85efb
2025-12-22 03:12:00,301 - INFO - Verifications in API Server for VN ctest-trans_right_vn-27720007 passed
2025-12-22 03:12:00,301 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/0f3d6957-4c87-4c79-b2ac-0a9ff3b85efb
2025-12-22 03:12:00,312 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/977915d7-c933-4718-9986-6ce8f5fd6203
2025-12-22 03:12:00,321 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/977915d7-c933-4718-9986-6ce8f5fd6203
2025-12-22 03:12:00,328 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/4a2422dc-d63a-4739-aee3-eff4d94b489b
2025-12-22 03:12:00,340 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-80710792:ctest-trans_right_vn-27720007', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-80710792', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1098149707815275641', 'uuid-lslong': '12874677116850429691'}, 'enable': 'true', 'created': '2025-12-22T03:11:59', 'last-modified': '2025-12-22T03:11:59', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.414448'}
2025-12-22 03:12:00,345 - DEBUG - Route Targets: ['target:64512:8000008']
2025-12-22 03:12:00,351 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-80710792:ctest-trans_right_vn-27720007', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-80710792', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1098149707815275641', 'uuid-lslong': '12874677116850429691'}, 'enable': 'true', 'created': '2025-12-22T03:11:59', 'last-modified': '2025-12-22T03:11:59', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.425559'}
2025-12-22 03:12:00,356 - DEBUG - Route Targets: ['target:64512:8000008']
2025-12-22 03:12:00,363 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-80710792:ctest-trans_right_vn-27720007', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-80710792', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1098149707815275641', 'uuid-lslong': '12874677116850429691'}, 'enable': 'true', 'created': '2025-12-22T03:11:59', 'last-modified': '2025-12-22T03:11:59', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.437625'}
2025-12-22 03:12:00,370 - DEBUG - Route Targets: ['target:64512:8000008']
2025-12-22 03:12:00,371 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_right_vn-27720007 passed
2025-12-22 03:12:00,371 - DEBUG - ====Verifying policy data for ctest-trans_right_vn-27720007 in API_Server ======
2025-12-22 03:12:00,371 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-22 03:12:00,377 - DEBUG - Requesting: http://10.0.0.23:8082/domain/cc89f09a-44c2-47d5-97ff-1101c2b1f822
2025-12-22 03:12:00,389 - DEBUG - Requesting: http://10.0.0.23:8082/project/0c56ebf2-8393-4d53-81c8-e788efc49815
2025-12-22 03:12:00,487 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/0f3d6957-4c87-4c79-b2ac-0a9ff3b85efb
2025-12-22 03:12:00,496 - DEBUG - =>VN ctest-trans_right_vn-27720007 has no policy to be verified
2025-12-22 03:12:00,496 - DEBUG - Verifying the vn in opserver
2025-12-22 03:12:00,496 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-80710792:ctest-trans_right_vn-27720007 virtual network link through opserver 10.0.0.23
2025-12-22 03:12:00,496 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-12-22 03:12:00,507 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-80710792:ctest-trans_right_vn-27720007', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-80710792:ctest-trans_right_vn-27720007?flat'}
2025-12-22 03:12:00,507 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-80710792:ctest-trans_right_vn-27720007 virtual network link through opserver 10.0.0.22
2025-12-22 03:12:00,507 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2025-12-22 03:12:00,521 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-80710792:ctest-trans_right_vn-27720007', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-80710792:ctest-trans_right_vn-27720007?flat'}
2025-12-22 03:12:00,521 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-80710792:ctest-trans_right_vn-27720007 virtual network link through opserver 10.0.0.65
2025-12-22 03:12:00,521 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2025-12-22 03:12:00,536 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-80710792:ctest-trans_right_vn-27720007', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-80710792:ctest-trans_right_vn-27720007?flat'}
2025-12-22 03:12:00,536 - INFO - Validated that VN default-domain:ctest-TestSvcHC-80710792:ctest-trans_right_vn-27720007 is found in opserver
2025-12-22 03:12:00,559 - DEBUG - Do not have enough data to verify VN in agent
2025-12-22 03:12:00,571 - DEBUG - VRF ids for VN ctest-trans_right_vn-27720007: {}
2025-12-22 03:12:01,614 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4918-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4918-2)
2025-12-22 03:12:02,889 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4918-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4918-1)
2025-12-22 03:12:02,889 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-97113084']
2025-12-22 03:12:03,203 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-97113084'] created succesfully
2025-12-22 03:12:03,534 - DEBUG - Image by name tiny_trans_fw not found
2025-12-22 03:12:03,534 - DEBUG - Installing image tiny_trans_fw
2025-12-22 03:12:03,534 - 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-22 03:12:03,535 - DEBUG - Image build path file:///contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2025-12-22 03:12:03,535 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2025-12-22 03:12:03,535 - DEBUG - Unzip image
2025-12-22 03:12:03,535 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2025-12-22 03:12:03,551 - INFO - image /contrail-test/images/tinycore-net-transparent-fw.qcow2 is not found
2025-12-22 03:12:03,552 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-97113084']
2025-12-22 03:12:03,674 - INFO - Service template: ['default-domain', 'ctest-service_template_1-97113084'] deleted successfully.
2025-12-22 03:12:03,674 - INFO - Skip interface_detach for VM ctest-right_vm-58282501 in state BUILD
2025-12-22 03:12:03,674 - INFO - Deleting VM ctest-right_vm-58282501
2025-12-22 03:12:03,674 - ERROR - VM ctest-right_vm-58282501 has failed to come up
2025-12-22 03:12:03,674 - ERROR - Nova failed to get host of the VM
2025-12-22 03:12:03,674 - ERROR - VM ctest-right_vm-58282501 has failed to come up
2025-12-22 03:12:03,674 - ERROR - Nova failed to get host of the VM
2025-12-22 03:12:03,777 - INFO - Skip interface_detach for VM ctest-left_vm-91082737 in state BUILD
2025-12-22 03:12:03,777 - INFO - Deleting VM ctest-left_vm-91082737
2025-12-22 03:12:03,779 - ERROR - VM ctest-left_vm-91082737 has failed to come up
2025-12-22 03:12:03,779 - ERROR - Nova failed to get host of the VM
2025-12-22 03:12:03,779 - ERROR - VM ctest-left_vm-91082737 has failed to come up
2025-12-22 03:12:03,779 - ERROR - Nova failed to get host of the VM
2025-12-22 03:12:03,844 - INFO - Deleting VN ctest-trans_right_vn-27720007
2025-12-22 03:12:03,995 - DEBUG - Response for deleting network ()
2025-12-22 03:12:03,996 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/977915d7-c933-4718-9986-6ce8f5fd6203
2025-12-22 03:12:04,005 - DEBUG - Response Code: 404
2025-12-22 03:12:04,005 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-22 03:12:04,014 - DEBUG - Requesting: http://10.0.0.23:8082/domain/cc89f09a-44c2-47d5-97ff-1101c2b1f822
2025-12-22 03:12:04,037 - DEBUG - Requesting: http://10.0.0.23:8082/project/0c56ebf2-8393-4d53-81c8-e788efc49815
2025-12-22 03:12:04,120 - INFO - Validated that VN ctest-trans_right_vn-27720007 is not found in API Server
2025-12-22 03:12:04,133 - DEBUG - VN ctest-trans_right_vn-27720007 is not present in Agent 10.0.0.130
2025-12-22 03:12:04,172 - DEBUG - VN ctest-trans_right_vn-27720007 is not present in Agent 10.0.0.19
2025-12-22 03:12:04,173 - INFO - Validated that VN ctest-trans_right_vn-27720007 is not in any agent
2025-12-22 03:12:04,206 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-trans_right_vn-27720007 info
2025-12-22 03:12:04,206 - INFO - Deleting VN ctest-trans_left_vn-75539957
2025-12-22 03:12:04,370 - DEBUG - Response for deleting network ()
2025-12-22 03:12:04,370 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/712b82da-4c9c-4076-982a-20cff823b416
2025-12-22 03:12:04,374 - DEBUG - Response Code: 404
2025-12-22 03:12:04,375 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-22 03:12:04,383 - DEBUG - Requesting: http://10.0.0.23:8082/domain/cc89f09a-44c2-47d5-97ff-1101c2b1f822
2025-12-22 03:12:04,442 - DEBUG - Requesting: http://10.0.0.23:8082/project/0c56ebf2-8393-4d53-81c8-e788efc49815
2025-12-22 03:12:04,537 - INFO - Validated that VN ctest-trans_left_vn-75539957 is not found in API Server
2025-12-22 03:12:04,558 - DEBUG - VN ctest-trans_left_vn-75539957 is not present in Agent 10.0.0.130
2025-12-22 03:12:04,568 - DEBUG - VN ctest-trans_left_vn-75539957 is not present in Agent 10.0.0.19
2025-12-22 03:12:04,568 - INFO - Validated that VN ctest-trans_left_vn-75539957 is not in any agent
2025-12-22 03:12:04,627 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-trans_left_vn-75539957 info
2025-12-22 03:12:04,627 - INFO - Deleting VN ctest-right_vn-80760319
2025-12-22 03:12:04,681 - DEBUG - VN 295cdf84-ab5e-4f8b-8fa5-84e78ad85837 still in use: Unable to complete operation on network 295cdf84-ab5e-4f8b-8fa5-84e78ad85837. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-d0f94306-95ed-4c97-8f9a-b10cf1736fbb']
2025-12-22 03:12:04,681 - WARNING - Deleting VN ctest-right_vn-80760319 failed..Will retry
2025-12-22 03:12:06,900 - DEBUG - Response for deleting network ()
2025-12-22 03:12:06,900 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/ddb73e53-bacd-4d2a-9738-76bfc932d8c5
2025-12-22 03:12:06,909 - DEBUG - Response Code: 404
2025-12-22 03:12:06,909 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-22 03:12:06,916 - DEBUG - Requesting: http://10.0.0.23:8082/domain/cc89f09a-44c2-47d5-97ff-1101c2b1f822
2025-12-22 03:12:06,930 - DEBUG - Requesting: http://10.0.0.23:8082/project/0c56ebf2-8393-4d53-81c8-e788efc49815
2025-12-22 03:12:07,023 - INFO - Validated that VN ctest-right_vn-80760319 is not found in API Server
2025-12-22 03:12:07,035 - DEBUG - VN ctest-right_vn-80760319 is not present in Agent 10.0.0.130
2025-12-22 03:12:07,045 - DEBUG - VN ctest-right_vn-80760319 is not present in Agent 10.0.0.19
2025-12-22 03:12:07,045 - INFO - Validated that VN ctest-right_vn-80760319 is not in any agent
2025-12-22 03:12:07,075 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-80760319 info
2025-12-22 03:12:07,075 - INFO - Deleting VN ctest-left_vn-27457002
2025-12-22 03:12:07,249 - DEBUG - Response for deleting network ()
2025-12-22 03:12:07,249 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/9c15b287-9433-4d66-b1ed-14204edef55a
2025-12-22 03:12:07,253 - DEBUG - Response Code: 404
2025-12-22 03:12:07,254 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-22 03:12:07,266 - DEBUG - Requesting: http://10.0.0.23:8082/domain/cc89f09a-44c2-47d5-97ff-1101c2b1f822
2025-12-22 03:12:07,282 - DEBUG - Requesting: http://10.0.0.23:8082/project/0c56ebf2-8393-4d53-81c8-e788efc49815
2025-12-22 03:12:07,378 - INFO - Validated that VN ctest-left_vn-27457002 is not found in API Server
2025-12-22 03:12:07,388 - DEBUG - VN ctest-left_vn-27457002 is not present in Agent 10.0.0.130
2025-12-22 03:12:07,399 - DEBUG - VN ctest-left_vn-27457002 is not present in Agent 10.0.0.19
2025-12-22 03:12:07,399 - INFO - Validated that VN ctest-left_vn-27457002 is not in any agent
2025-12-22 03:12:07,432 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-27457002 info
2025-12-22 03:12:07,433 - INFO - Deleting VN ctest-mgmt_vn-73812737
2025-12-22 03:12:07,571 - DEBUG - Response for deleting network ()
2025-12-22 03:12:07,571 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/19e673a3-9f4a-4110-8465-ecca608a17e9
2025-12-22 03:12:07,578 - DEBUG - Response Code: 404
2025-12-22 03:12:07,579 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-22 03:12:07,588 - DEBUG - Requesting: http://10.0.0.23:8082/domain/cc89f09a-44c2-47d5-97ff-1101c2b1f822
2025-12-22 03:12:07,598 - DEBUG - Requesting: http://10.0.0.23:8082/project/0c56ebf2-8393-4d53-81c8-e788efc49815
2025-12-22 03:12:07,690 - INFO - Validated that VN ctest-mgmt_vn-73812737 is not found in API Server
2025-12-22 03:12:07,700 - DEBUG - VN ctest-mgmt_vn-73812737 is not present in Agent 10.0.0.130
2025-12-22 03:12:07,713 - DEBUG - VN ctest-mgmt_vn-73812737 is not present in Agent 10.0.0.19
2025-12-22 03:12:07,713 - INFO - Validated that VN ctest-mgmt_vn-73812737 is not in any agent
2025-12-22 03:12:07,742 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-73812737 info
2025-12-22 03:12:09,028 - DEBUG - No XMPP flaps were noticed during the test
2025-12-22 03:12:09,028 - INFO -
2025-12-22 03:12:09,028 - INFO - END TEST : test_svc_trans_segment_right_hc_fail_svm : SKIPPED[0:00:16]
2025-12-22 03:12:09,028 - INFO - --------------------------------------------------------------------------------
2025-12-22 03:12:09,817 - INFO - Deleted project: ctest-TestSvcHC-80710792, ID : 0c56ebf2-8393-4d53-81c8-e788efc49815