2026-05-20 15:48:31,978 - INFO - Domain Default found not creating
2026-05-20 15:48:32,280 - INFO - Project ctest-TestSvcHC-01457283 not found, creating it
2026-05-20 15:48:32,989 - INFO - Created Project:ctest-TestSvcHC-01457283, ID : 00822bf8-9298-441b-90cd-e724d140d8d1
2026-05-20 15:48:35,098 - INFO - ================================================================================
2026-05-20 15:48:35,098 - INFO - STARTING TEST : test_svc_hc_basic
2026-05-20 15:48:36,447 - DEBUG - Nothing to compare xmpp stats {'10.0.0.242': {'10.20.0.25': '0', '10.20.0.193': '0'}, '10.0.0.249': {'10.20.0.25': '0', '10.20.0.14': '0'}} with
2026-05-20 15:48:36,447 - INFO - Initial checks done. Running the testcase now
2026-05-20 15:48:36,448 - INFO -
2026-05-20 15:48:37,321 - DEBUG - Response for create_network : {'network': {'id': '0178f659-7d16-4232-889a-5089223f2656', 'name': 'ctest-mgmt_vn-74338798', 'tenant_id': '00822bf89298441b90cde724d140d8d1', 'project_id': '00822bf89298441b90cde724d140d8d1', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-01457283', 'ctest-mgmt_vn-74338798'], 'port_security_enabled': True, 'description': ''}}
2026-05-20 15:48:37,764 - DEBUG - Response for create_subnet : {'subnet': {'id': '5e467679-c109-4801-a7ad-87c39dea9b8c', 'name': '', 'tenant_id': '00822bf89298441b90cde724d140d8d1', 'network_id': '0178f659-7d16-4232-889a-5089223f2656', 'ip_version': 4, 'cidr': '145.192.102.0/26', 'allocation_pools': [{'start': '145.192.102.2', 'end': '145.192.102.62'}], 'gateway_ip': '145.192.102.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '145.192.102.2', 'tags': [], 'project_id': '00822bf89298441b90cde724d140d8d1'}}
2026-05-20 15:48:37,794 - INFO - Created VN ctest-mgmt_vn-74338798
2026-05-20 15:48:37,811 - DEBUG - VN ctest-mgmt_vn-74338798 UUID is 0178f659-7d16-4232-889a-5089223f2656
2026-05-20 15:48:37,913 - DEBUG - Requesting: http://10.0.0.57:8082/domains
2026-05-20 15:48:38,290 - DEBUG - Requesting: http://10.0.0.57:8082/domains
2026-05-20 15:48:38,330 - DEBUG - Requesting: http://10.0.0.57:8082/domain/ffb590f3-7b6e-40e6-89b8-bd634f94ea0b
2026-05-20 15:48:38,353 - DEBUG - Requesting: http://10.0.0.57:8082/project/00822bf8-9298-441b-90cd-e724d140d8d1
2026-05-20 15:48:38,500 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/0178f659-7d16-4232-889a-5089223f2656
2026-05-20 15:48:38,515 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/0178f659-7d16-4232-889a-5089223f2656
2026-05-20 15:48:38,529 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/2a3ee0ac-5f10-4435-aba5-cfff66cc9231
2026-05-20 15:48:38,548 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/2a3ee0ac-5f10-4435-aba5-cfff66cc9231
2026-05-20 15:48:38,577 - DEBUG - Requesting: http://10.0.0.57:8082/route-target/ea86f0b0-6dd9-4f6c-a174-58161e8956d5
2026-05-20 15:48:38,587 - DEBUG - Route Targets: ['target:64512:8000007']
2026-05-20 15:48:38,587 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/0178f659-7d16-4232-889a-5089223f2656
2026-05-20 15:48:38,601 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/2a3ee0ac-5f10-4435-aba5-cfff66cc9231
2026-05-20 15:48:38,625 - INFO - Verified VN network id 14 for VN 0178f659-7d16-4232-889a-5089223f2656
2026-05-20 15:48:38,625 - INFO - Verifications in API Server for VN ctest-mgmt_vn-74338798 passed
2026-05-20 15:48:38,626 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/0178f659-7d16-4232-889a-5089223f2656
2026-05-20 15:48:38,644 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/2a3ee0ac-5f10-4435-aba5-cfff66cc9231
2026-05-20 15:48:38,658 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/2a3ee0ac-5f10-4435-aba5-cfff66cc9231
2026-05-20 15:48:38,670 - DEBUG - Requesting: http://10.0.0.57:8082/route-target/ea86f0b0-6dd9-4f6c-a174-58161e8956d5
2026-05-20 15:48:38,695 - DEBUG - Control-node 10.0.0.57 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-01457283:ctest-mgmt_vn-74338798', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-01457283', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '106105455454339634', 'uuid-lslong': '9843268485486945878'}, 'enable': 'true', 'created': '2026-05-20T15:48:37', 'last-modified': '2026-05-20T15:48:37', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.005779'}
2026-05-20 15:48:38,709 - DEBUG - Route Targets: ['target:64512:8000007']
2026-05-20 15:48:38,718 - DEBUG - Control-node 10.0.0.141 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-01457283:ctest-mgmt_vn-74338798', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-01457283', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '106105455454339634', 'uuid-lslong': '9843268485486945878'}, 'enable': 'true', 'created': '2026-05-20T15:48:37', 'last-modified': '2026-05-20T15:48:37', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.037630'}
2026-05-20 15:48:38,726 - DEBUG - Route Targets: ['target:64512:8000007']
2026-05-20 15:48:38,734 - DEBUG - Control-node 10.0.0.56 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-01457283:ctest-mgmt_vn-74338798', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-01457283', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '106105455454339634', 'uuid-lslong': '9843268485486945878'}, 'enable': 'true', 'created': '2026-05-20T15:48:37', 'last-modified': '2026-05-20T15:48:37', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.048599'}
2026-05-20 15:48:38,742 - DEBUG - Route Targets: ['target:64512:8000007']
2026-05-20 15:48:38,742 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-74338798 passed
2026-05-20 15:48:38,742 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-74338798 in API_Server ======
2026-05-20 15:48:38,743 - DEBUG - Requesting: http://10.0.0.57:8082/domains
2026-05-20 15:48:38,751 - DEBUG - Requesting: http://10.0.0.57:8082/domain/ffb590f3-7b6e-40e6-89b8-bd634f94ea0b
2026-05-20 15:48:38,768 - DEBUG - Requesting: http://10.0.0.57:8082/project/00822bf8-9298-441b-90cd-e724d140d8d1
2026-05-20 15:48:38,881 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/0178f659-7d16-4232-889a-5089223f2656
2026-05-20 15:48:38,896 - DEBUG - =>VN ctest-mgmt_vn-74338798 has no policy to be verified
2026-05-20 15:48:38,896 - DEBUG - Verifying the vn in opserver
2026-05-20 15:48:38,896 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-01457283:ctest-mgmt_vn-74338798 virtual network link through opserver 10.0.0.57
2026-05-20 15:48:38,896 - DEBUG - Requesting: http://10.0.0.57:8081/analytics/uves/virtual-networks
2026-05-20 15:48:39,279 - DEBUG - Requesting: http://10.0.0.57:8081/analytics/uves/virtual-networks
2026-05-20 15:48:39,372 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-01457283:ctest-mgmt_vn-74338798', 'href': 'http://10.0.0.57:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-01457283:ctest-mgmt_vn-74338798?flat'}
2026-05-20 15:48:39,372 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-01457283:ctest-mgmt_vn-74338798 virtual network link through opserver 10.0.0.141
2026-05-20 15:48:39,372 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/virtual-networks
2026-05-20 15:48:39,754 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/virtual-networks
2026-05-20 15:48:39,840 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-01457283:ctest-mgmt_vn-74338798', 'href': 'http://10.0.0.141:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-01457283:ctest-mgmt_vn-74338798?flat'}
2026-05-20 15:48:39,840 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-01457283:ctest-mgmt_vn-74338798 virtual network link through opserver 10.0.0.56
2026-05-20 15:48:39,841 - DEBUG - Requesting: http://10.0.0.56:8081/analytics/uves/virtual-networks
2026-05-20 15:48:40,223 - DEBUG - Requesting: http://10.0.0.56:8081/analytics/uves/virtual-networks
2026-05-20 15:48:40,307 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-01457283:ctest-mgmt_vn-74338798', 'href': 'http://10.0.0.56:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-01457283:ctest-mgmt_vn-74338798?flat'}
2026-05-20 15:48:40,307 - INFO - Validated that VN default-domain:ctest-TestSvcHC-01457283:ctest-mgmt_vn-74338798 is found in opserver
2026-05-20 15:48:40,336 - DEBUG - Do not have enough data to verify VN in agent
2026-05-20 15:48:40,347 - DEBUG - VRF ids for VN ctest-mgmt_vn-74338798: {}
2026-05-20 15:48:40,666 - DEBUG - Response for create_network : {'network': {'id': '5f4c6f00-0fc2-47b9-940a-8a4f85d418b0', 'name': 'ctest-left_vn-51480980', 'tenant_id': '00822bf89298441b90cde724d140d8d1', 'project_id': '00822bf89298441b90cde724d140d8d1', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-01457283', 'ctest-left_vn-51480980'], 'port_security_enabled': True, 'description': ''}}
2026-05-20 15:48:40,950 - DEBUG - Response for create_subnet : {'subnet': {'id': '06d49f7f-2d48-4915-b695-301ffd0369d9', 'name': '', 'tenant_id': '00822bf89298441b90cde724d140d8d1', 'network_id': '5f4c6f00-0fc2-47b9-940a-8a4f85d418b0', 'ip_version': 4, 'cidr': '34.224.102.64/26', 'allocation_pools': [{'start': '34.224.102.66', 'end': '34.224.102.126'}], 'gateway_ip': '34.224.102.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '34.224.102.66', 'tags': [], 'project_id': '00822bf89298441b90cde724d140d8d1'}}
2026-05-20 15:48:40,980 - INFO - Created VN ctest-left_vn-51480980
2026-05-20 15:48:40,996 - DEBUG - VN ctest-left_vn-51480980 UUID is 5f4c6f00-0fc2-47b9-940a-8a4f85d418b0
2026-05-20 15:48:41,110 - DEBUG - Requesting: http://10.0.0.57:8082/domains
2026-05-20 15:48:41,119 - DEBUG - Requesting: http://10.0.0.57:8082/domain/ffb590f3-7b6e-40e6-89b8-bd634f94ea0b
2026-05-20 15:48:41,136 - DEBUG - Requesting: http://10.0.0.57:8082/project/00822bf8-9298-441b-90cd-e724d140d8d1
2026-05-20 15:48:41,251 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/5f4c6f00-0fc2-47b9-940a-8a4f85d418b0
2026-05-20 15:48:41,271 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/5f4c6f00-0fc2-47b9-940a-8a4f85d418b0
2026-05-20 15:48:41,286 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/fec7e9f0-0220-41d4-bc2f-9b030969919d
2026-05-20 15:48:41,298 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/fec7e9f0-0220-41d4-bc2f-9b030969919d
2026-05-20 15:48:41,309 - DEBUG - Requesting: http://10.0.0.57:8082/route-target/9e008e95-0476-46a8-8518-7896608fcffe
2026-05-20 15:48:41,318 - DEBUG - Route Targets: ['target:64512:8000008']
2026-05-20 15:48:41,318 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/5f4c6f00-0fc2-47b9-940a-8a4f85d418b0
2026-05-20 15:48:41,330 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/fec7e9f0-0220-41d4-bc2f-9b030969919d
2026-05-20 15:48:41,354 - INFO - Verified VN network id 15 for VN 5f4c6f00-0fc2-47b9-940a-8a4f85d418b0
2026-05-20 15:48:41,354 - INFO - Verifications in API Server for VN ctest-left_vn-51480980 passed
2026-05-20 15:48:41,354 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/5f4c6f00-0fc2-47b9-940a-8a4f85d418b0
2026-05-20 15:48:41,367 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/fec7e9f0-0220-41d4-bc2f-9b030969919d
2026-05-20 15:48:41,377 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/fec7e9f0-0220-41d4-bc2f-9b030969919d
2026-05-20 15:48:41,389 - DEBUG - Requesting: http://10.0.0.57:8082/route-target/9e008e95-0476-46a8-8518-7896608fcffe
2026-05-20 15:48:41,407 - DEBUG - Control-node 10.0.0.57 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-01457283:ctest-left_vn-51480980', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-01457283', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6866985577888237497', 'uuid-lslong': '10667490741532760240'}, 'enable': 'true', 'created': '2026-05-20T15:48:40', 'last-modified': '2026-05-20T15:48:40', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.524856'}
2026-05-20 15:48:41,417 - DEBUG - Route Targets: ['target:64512:8000008']
2026-05-20 15:48:41,424 - DEBUG - Control-node 10.0.0.141 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-01457283:ctest-left_vn-51480980', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-01457283', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6866985577888237497', 'uuid-lslong': '10667490741532760240'}, 'enable': 'true', 'created': '2026-05-20T15:48:40', 'last-modified': '2026-05-20T15:48:40', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.545066'}
2026-05-20 15:48:41,431 - DEBUG - Route Targets: ['target:64512:8000008']
2026-05-20 15:48:41,438 - DEBUG - Control-node 10.0.0.56 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-01457283:ctest-left_vn-51480980', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-01457283', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6866985577888237497', 'uuid-lslong': '10667490741532760240'}, 'enable': 'true', 'created': '2026-05-20T15:48:40', 'last-modified': '2026-05-20T15:48:40', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.550699'}
2026-05-20 15:48:41,447 - DEBUG - Route Targets: ['target:64512:8000008']
2026-05-20 15:48:41,447 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-51480980 passed
2026-05-20 15:48:41,447 - DEBUG - ====Verifying policy data for ctest-left_vn-51480980 in API_Server ======
2026-05-20 15:48:41,447 - DEBUG - Requesting: http://10.0.0.57:8082/domains
2026-05-20 15:48:41,457 - DEBUG - Requesting: http://10.0.0.57:8082/domain/ffb590f3-7b6e-40e6-89b8-bd634f94ea0b
2026-05-20 15:48:41,472 - DEBUG - Requesting: http://10.0.0.57:8082/project/00822bf8-9298-441b-90cd-e724d140d8d1
2026-05-20 15:48:41,595 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/5f4c6f00-0fc2-47b9-940a-8a4f85d418b0
2026-05-20 15:48:41,608 - DEBUG - =>VN ctest-left_vn-51480980 has no policy to be verified
2026-05-20 15:48:41,608 - DEBUG - Verifying the vn in opserver
2026-05-20 15:48:41,608 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-01457283:ctest-left_vn-51480980 virtual network link through opserver 10.0.0.57
2026-05-20 15:48:41,608 - DEBUG - Requesting: http://10.0.0.57:8081/analytics/uves/virtual-networks
2026-05-20 15:48:41,692 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-01457283:ctest-left_vn-51480980', 'href': 'http://10.0.0.57:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-01457283:ctest-left_vn-51480980?flat'}
2026-05-20 15:48:41,692 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-01457283:ctest-left_vn-51480980 virtual network link through opserver 10.0.0.141
2026-05-20 15:48:41,692 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/virtual-networks
2026-05-20 15:48:41,797 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-01457283:ctest-left_vn-51480980', 'href': 'http://10.0.0.141:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-01457283:ctest-left_vn-51480980?flat'}
2026-05-20 15:48:41,797 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-01457283:ctest-left_vn-51480980 virtual network link through opserver 10.0.0.56
2026-05-20 15:48:41,798 - DEBUG - Requesting: http://10.0.0.56:8081/analytics/uves/virtual-networks
2026-05-20 15:48:41,888 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-01457283:ctest-left_vn-51480980', 'href': 'http://10.0.0.56:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-01457283:ctest-left_vn-51480980?flat'}
2026-05-20 15:48:41,888 - INFO - Validated that VN default-domain:ctest-TestSvcHC-01457283:ctest-left_vn-51480980 is found in opserver
2026-05-20 15:48:41,935 - DEBUG - Do not have enough data to verify VN in agent
2026-05-20 15:48:41,949 - DEBUG - VRF ids for VN ctest-left_vn-51480980: {}
2026-05-20 15:48:42,301 - DEBUG - Response for create_network : {'network': {'id': '761c503b-a9c3-4a42-9124-689c88f7bf69', 'name': 'ctest-right_vn-87654510', 'tenant_id': '00822bf89298441b90cde724d140d8d1', 'project_id': '00822bf89298441b90cde724d140d8d1', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-01457283', 'ctest-right_vn-87654510'], 'port_security_enabled': True, 'description': ''}}
2026-05-20 15:48:42,576 - DEBUG - Response for create_subnet : {'subnet': {'id': 'a6f2aba5-da1a-4516-b8cb-5a2367c048f7', 'name': '', 'tenant_id': '00822bf89298441b90cde724d140d8d1', 'network_id': '761c503b-a9c3-4a42-9124-689c88f7bf69', 'ip_version': 4, 'cidr': '5.196.87.192/26', 'allocation_pools': [{'start': '5.196.87.194', 'end': '5.196.87.254'}], 'gateway_ip': '5.196.87.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '5.196.87.194', 'tags': [], 'project_id': '00822bf89298441b90cde724d140d8d1'}}
2026-05-20 15:48:42,608 - INFO - Created VN ctest-right_vn-87654510
2026-05-20 15:48:42,625 - DEBUG - VN ctest-right_vn-87654510 UUID is 761c503b-a9c3-4a42-9124-689c88f7bf69
2026-05-20 15:48:42,718 - DEBUG - Requesting: http://10.0.0.57:8082/domains
2026-05-20 15:48:42,726 - DEBUG - Requesting: http://10.0.0.57:8082/domain/ffb590f3-7b6e-40e6-89b8-bd634f94ea0b
2026-05-20 15:48:42,741 - DEBUG - Requesting: http://10.0.0.57:8082/project/00822bf8-9298-441b-90cd-e724d140d8d1
2026-05-20 15:48:42,848 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/761c503b-a9c3-4a42-9124-689c88f7bf69
2026-05-20 15:48:42,867 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/761c503b-a9c3-4a42-9124-689c88f7bf69
2026-05-20 15:48:42,881 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/2aafe1ec-1466-4383-bda3-20a91f94b201
2026-05-20 15:48:42,891 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/2aafe1ec-1466-4383-bda3-20a91f94b201
2026-05-20 15:48:42,902 - DEBUG - Requesting: http://10.0.0.57:8082/route-target/c34fad50-91cd-4f0c-a271-6238805907e5
2026-05-20 15:48:42,913 - DEBUG - Route Targets: ['target:64512:8000009']
2026-05-20 15:48:42,913 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/761c503b-a9c3-4a42-9124-689c88f7bf69
2026-05-20 15:48:42,925 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/2aafe1ec-1466-4383-bda3-20a91f94b201
2026-05-20 15:48:42,948 - INFO - Verified VN network id 16 for VN 761c503b-a9c3-4a42-9124-689c88f7bf69
2026-05-20 15:48:42,948 - INFO - Verifications in API Server for VN ctest-right_vn-87654510 passed
2026-05-20 15:48:42,949 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/761c503b-a9c3-4a42-9124-689c88f7bf69
2026-05-20 15:48:42,962 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/2aafe1ec-1466-4383-bda3-20a91f94b201
2026-05-20 15:48:42,975 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/2aafe1ec-1466-4383-bda3-20a91f94b201
2026-05-20 15:48:42,987 - DEBUG - Requesting: http://10.0.0.57:8082/route-target/c34fad50-91cd-4f0c-a271-6238805907e5
2026-05-20 15:48:43,010 - DEBUG - Control-node 10.0.0.57 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-01457283:ctest-right_vn-87654510', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-01457283', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8510765613004835394', 'uuid-lslong': '10458599256183258985'}, 'enable': 'true', 'created': '2026-05-20T15:48:42', 'last-modified': '2026-05-20T15:48:42', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.510539'}
2026-05-20 15:48:43,019 - DEBUG - Route Targets: ['target:64512:8000009']
2026-05-20 15:48:43,027 - DEBUG - Control-node 10.0.0.141 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-01457283:ctest-right_vn-87654510', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-01457283', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8510765613004835394', 'uuid-lslong': '10458599256183258985'}, 'enable': 'true', 'created': '2026-05-20T15:48:42', 'last-modified': '2026-05-20T15:48:42', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.520576'}
2026-05-20 15:48:43,038 - DEBUG - Route Targets: ['target:64512:8000009']
2026-05-20 15:48:43,045 - DEBUG - Control-node 10.0.0.56 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-01457283:ctest-right_vn-87654510', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-01457283', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8510765613004835394', 'uuid-lslong': '10458599256183258985'}, 'enable': 'true', 'created': '2026-05-20T15:48:42', 'last-modified': '2026-05-20T15:48:42', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.550968'}
2026-05-20 15:48:43,056 - DEBUG - Route Targets: ['target:64512:8000009']
2026-05-20 15:48:43,056 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-87654510 passed
2026-05-20 15:48:43,056 - DEBUG - ====Verifying policy data for ctest-right_vn-87654510 in API_Server ======
2026-05-20 15:48:43,056 - DEBUG - Requesting: http://10.0.0.57:8082/domains
2026-05-20 15:48:43,065 - DEBUG - Requesting: http://10.0.0.57:8082/domain/ffb590f3-7b6e-40e6-89b8-bd634f94ea0b
2026-05-20 15:48:43,081 - DEBUG - Requesting: http://10.0.0.57:8082/project/00822bf8-9298-441b-90cd-e724d140d8d1
2026-05-20 15:48:43,203 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/761c503b-a9c3-4a42-9124-689c88f7bf69
2026-05-20 15:48:43,221 - DEBUG - =>VN ctest-right_vn-87654510 has no policy to be verified
2026-05-20 15:48:43,221 - DEBUG - Verifying the vn in opserver
2026-05-20 15:48:43,221 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-01457283:ctest-right_vn-87654510 virtual network link through opserver 10.0.0.57
2026-05-20 15:48:43,221 - DEBUG - Requesting: http://10.0.0.57:8081/analytics/uves/virtual-networks
2026-05-20 15:48:43,311 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-01457283:ctest-right_vn-87654510', 'href': 'http://10.0.0.57:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-01457283:ctest-right_vn-87654510?flat'}
2026-05-20 15:48:43,311 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-01457283:ctest-right_vn-87654510 virtual network link through opserver 10.0.0.141
2026-05-20 15:48:43,311 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/virtual-networks
2026-05-20 15:48:43,405 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-01457283:ctest-right_vn-87654510', 'href': 'http://10.0.0.141:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-01457283:ctest-right_vn-87654510?flat'}
2026-05-20 15:48:43,405 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-01457283:ctest-right_vn-87654510 virtual network link through opserver 10.0.0.56
2026-05-20 15:48:43,405 - DEBUG - Requesting: http://10.0.0.56:8081/analytics/uves/virtual-networks
2026-05-20 15:48:43,487 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-01457283:ctest-right_vn-87654510', 'href': 'http://10.0.0.56:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-01457283:ctest-right_vn-87654510?flat'}
2026-05-20 15:48:43,487 - INFO - Validated that VN default-domain:ctest-TestSvcHC-01457283:ctest-right_vn-87654510 is found in opserver
2026-05-20 15:48:43,522 - DEBUG - Do not have enough data to verify VN in agent
2026-05-20 15:48:43,538 - DEBUG - VRF ids for VN ctest-right_vn-87654510: {}
2026-05-20 15:48:43,724 - DEBUG - Services list from nova: [, , , ]
2026-05-20 15:48:45,214 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5803-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5803-2)
2026-05-20 15:48:47,078 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5803-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5803-1)
2026-05-20 15:48:47,078 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-14789592']
2026-05-20 15:48:47,407 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-14789592'] created succesfully
2026-05-20 15:48:48,005 - DEBUG - Image by name tiny_nat_fw not found
2026-05-20 15:48:48,006 - DEBUG - Installing image tiny_nat_fw
2026-05-20 15:48:48,006 - 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'"}
2026-05-20 15:48:48,006 - DEBUG - Image build path file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-05-20 15:48:48,007 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-05-20 15:48:48,007 - DEBUG - Unzip image
2026-05-20 15:48:48,007 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-05-20 15:48:48,032 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2026-05-20 15:48:48,032 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-14789592']
2026-05-20 15:48:48,135 - INFO - Service template: ['default-domain', 'ctest-service_template_1-14789592'] deleted successfully.
2026-05-20 15:48:48,136 - INFO - Skip interface_detach for VM ctest-right_vm-38065662 in state BUILD
2026-05-20 15:48:48,136 - INFO - Deleting VM ctest-right_vm-38065662
2026-05-20 15:48:48,191 - ERROR - VM ctest-right_vm-38065662 has failed to come up
2026-05-20 15:48:48,191 - ERROR - Nova failed to get host of the VM
2026-05-20 15:48:48,191 - ERROR - VM ctest-right_vm-38065662 has failed to come up
2026-05-20 15:48:48,192 - ERROR - Nova failed to get host of the VM
2026-05-20 15:48:48,289 - INFO - Skip interface_detach for VM ctest-left_vm-58180229 in state BUILD
2026-05-20 15:48:48,289 - INFO - Deleting VM ctest-left_vm-58180229
2026-05-20 15:48:48,289 - ERROR - VM ctest-left_vm-58180229 has failed to come up
2026-05-20 15:48:48,289 - ERROR - Nova failed to get host of the VM
2026-05-20 15:48:48,289 - ERROR - VM ctest-left_vm-58180229 has failed to come up
2026-05-20 15:48:48,289 - ERROR - Nova failed to get host of the VM
2026-05-20 15:48:48,397 - INFO - Deleting VN ctest-right_vn-87654510
2026-05-20 15:48:48,467 - DEBUG - VN 761c503b-a9c3-4a42-9124-689c88f7bf69 still in use: Unable to complete operation on network 761c503b-a9c3-4a42-9124-689c88f7bf69. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-67d96529-04d6-4bd9-8a00-3760f8503645']
2026-05-20 15:48:48,468 - WARNING - Deleting VN ctest-right_vn-87654510 failed..Will retry
2026-05-20 15:48:50,536 - DEBUG - VN 761c503b-a9c3-4a42-9124-689c88f7bf69 still in use: Unable to complete operation on network 761c503b-a9c3-4a42-9124-689c88f7bf69. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-ca835995-ea76-4603-8e8a-c91fee087a32']
2026-05-20 15:48:50,536 - WARNING - Deleting VN ctest-right_vn-87654510 failed..Will retry
2026-05-20 15:48:52,766 - DEBUG - Response for deleting network ()
2026-05-20 15:48:52,766 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/2aafe1ec-1466-4383-bda3-20a91f94b201
2026-05-20 15:48:52,787 - DEBUG - Response Code: 404
2026-05-20 15:48:52,787 - DEBUG - Requesting: http://10.0.0.57:8082/domains
2026-05-20 15:48:52,797 - DEBUG - Requesting: http://10.0.0.57:8082/domain/ffb590f3-7b6e-40e6-89b8-bd634f94ea0b
2026-05-20 15:48:52,821 - DEBUG - Requesting: http://10.0.0.57:8082/project/00822bf8-9298-441b-90cd-e724d140d8d1
2026-05-20 15:48:52,928 - INFO - Validated that VN ctest-right_vn-87654510 is not found in API Server
2026-05-20 15:48:52,941 - DEBUG - VN ctest-right_vn-87654510 is not present in Agent 10.0.0.242
2026-05-20 15:48:52,955 - DEBUG - VN ctest-right_vn-87654510 is not present in Agent 10.0.0.249
2026-05-20 15:48:52,955 - INFO - Validated that VN ctest-right_vn-87654510 is not in any agent
2026-05-20 15:48:52,994 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-87654510 info
2026-05-20 15:48:52,994 - INFO - Deleting VN ctest-left_vn-51480980
2026-05-20 15:48:53,203 - DEBUG - Response for deleting network ()
2026-05-20 15:48:53,204 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/fec7e9f0-0220-41d4-bc2f-9b030969919d
2026-05-20 15:48:53,215 - DEBUG - Response Code: 404
2026-05-20 15:48:53,215 - DEBUG - Requesting: http://10.0.0.57:8082/domains
2026-05-20 15:48:53,223 - DEBUG - Requesting: http://10.0.0.57:8082/domain/ffb590f3-7b6e-40e6-89b8-bd634f94ea0b
2026-05-20 15:48:53,241 - DEBUG - Requesting: http://10.0.0.57:8082/project/00822bf8-9298-441b-90cd-e724d140d8d1
2026-05-20 15:48:53,343 - INFO - Validated that VN ctest-left_vn-51480980 is not found in API Server
2026-05-20 15:48:53,361 - DEBUG - VN ctest-left_vn-51480980 is not present in Agent 10.0.0.242
2026-05-20 15:48:53,374 - DEBUG - VN ctest-left_vn-51480980 is not present in Agent 10.0.0.249
2026-05-20 15:48:53,374 - INFO - Validated that VN ctest-left_vn-51480980 is not in any agent
2026-05-20 15:48:53,418 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-51480980 info
2026-05-20 15:48:53,418 - INFO - Deleting VN ctest-mgmt_vn-74338798
2026-05-20 15:48:53,633 - DEBUG - Response for deleting network ()
2026-05-20 15:48:53,633 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/2a3ee0ac-5f10-4435-aba5-cfff66cc9231
2026-05-20 15:48:53,655 - DEBUG - Response Code: 404
2026-05-20 15:48:53,655 - DEBUG - Requesting: http://10.0.0.57:8082/domains
2026-05-20 15:48:53,668 - DEBUG - Requesting: http://10.0.0.57:8082/domain/ffb590f3-7b6e-40e6-89b8-bd634f94ea0b
2026-05-20 15:48:53,693 - DEBUG - Requesting: http://10.0.0.57:8082/project/00822bf8-9298-441b-90cd-e724d140d8d1
2026-05-20 15:48:53,813 - INFO - Validated that VN ctest-mgmt_vn-74338798 is not found in API Server
2026-05-20 15:48:53,833 - DEBUG - VN ctest-mgmt_vn-74338798 is not present in Agent 10.0.0.242
2026-05-20 15:48:53,847 - DEBUG - VN ctest-mgmt_vn-74338798 is not present in Agent 10.0.0.249
2026-05-20 15:48:53,847 - INFO - Validated that VN ctest-mgmt_vn-74338798 is not in any agent
2026-05-20 15:48:53,886 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-74338798 info
2026-05-20 15:48:55,210 - DEBUG - No XMPP flaps were noticed during the test
2026-05-20 15:48:55,210 - INFO -
2026-05-20 15:48:55,214 - INFO - END TEST : test_svc_hc_basic : SKIPPED[0:00:20]
2026-05-20 15:48:55,215 - INFO - --------------------------------------------------------------------------------
2026-05-20 15:48:55,221 - INFO - ================================================================================
2026-05-20 15:48:55,221 - INFO - STARTING TEST : test_svc_trans_segment_right_hc_fail_svm
2026-05-20 15:48:56,565 - DEBUG - Nothing to compare xmpp stats {'10.0.0.242': {'10.20.0.25': '0', '10.20.0.193': '0'}, '10.0.0.249': {'10.20.0.25': '0', '10.20.0.14': '0'}} with
2026-05-20 15:48:56,565 - INFO - Initial checks done. Running the testcase now
2026-05-20 15:48:56,565 - INFO -
2026-05-20 15:48:56,917 - DEBUG - Response for create_network : {'network': {'id': '1eec2ff3-ba7c-4362-a40c-7a498efdafe2', 'name': 'ctest-mgmt_vn-62329986', 'tenant_id': '00822bf89298441b90cde724d140d8d1', 'project_id': '00822bf89298441b90cde724d140d8d1', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-01457283', 'ctest-mgmt_vn-62329986'], 'port_security_enabled': True, 'description': ''}}
2026-05-20 15:48:57,218 - DEBUG - Response for create_subnet : {'subnet': {'id': 'f617cd05-f8ab-4fed-9de7-ad7b88698e69', 'name': '', 'tenant_id': '00822bf89298441b90cde724d140d8d1', 'network_id': '1eec2ff3-ba7c-4362-a40c-7a498efdafe2', 'ip_version': 4, 'cidr': '177.243.114.192/26', 'allocation_pools': [{'start': '177.243.114.194', 'end': '177.243.114.254'}], 'gateway_ip': '177.243.114.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '177.243.114.194', 'tags': [], 'project_id': '00822bf89298441b90cde724d140d8d1'}}
2026-05-20 15:48:57,246 - INFO - Created VN ctest-mgmt_vn-62329986
2026-05-20 15:48:57,263 - DEBUG - VN ctest-mgmt_vn-62329986 UUID is 1eec2ff3-ba7c-4362-a40c-7a498efdafe2
2026-05-20 15:48:57,356 - DEBUG - Requesting: http://10.0.0.57:8082/domains
2026-05-20 15:48:57,372 - DEBUG - Requesting: http://10.0.0.57:8082/domain/ffb590f3-7b6e-40e6-89b8-bd634f94ea0b
2026-05-20 15:48:57,392 - DEBUG - Requesting: http://10.0.0.57:8082/project/00822bf8-9298-441b-90cd-e724d140d8d1
2026-05-20 15:48:57,518 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/1eec2ff3-ba7c-4362-a40c-7a498efdafe2
2026-05-20 15:48:57,541 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/1eec2ff3-ba7c-4362-a40c-7a498efdafe2
2026-05-20 15:48:57,558 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/faa98226-4b1d-4bd4-b85f-a27b166b71ee
2026-05-20 15:48:57,569 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/faa98226-4b1d-4bd4-b85f-a27b166b71ee
2026-05-20 15:48:57,582 - DEBUG - Requesting: http://10.0.0.57:8082/route-target/5e0859b4-2578-4cb1-ab50-c5e0c9e42162
2026-05-20 15:48:57,597 - DEBUG - Route Targets: ['target:64512:8000007']
2026-05-20 15:48:57,597 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/1eec2ff3-ba7c-4362-a40c-7a498efdafe2
2026-05-20 15:48:57,610 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/faa98226-4b1d-4bd4-b85f-a27b166b71ee
2026-05-20 15:48:57,632 - INFO - Verified VN network id 14 for VN 1eec2ff3-ba7c-4362-a40c-7a498efdafe2
2026-05-20 15:48:57,632 - INFO - Verifications in API Server for VN ctest-mgmt_vn-62329986 passed
2026-05-20 15:48:57,632 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/1eec2ff3-ba7c-4362-a40c-7a498efdafe2
2026-05-20 15:48:57,650 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/faa98226-4b1d-4bd4-b85f-a27b166b71ee
2026-05-20 15:48:57,662 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/faa98226-4b1d-4bd4-b85f-a27b166b71ee
2026-05-20 15:48:57,674 - DEBUG - Requesting: http://10.0.0.57:8082/route-target/5e0859b4-2578-4cb1-ab50-c5e0c9e42162
2026-05-20 15:48:57,694 - DEBUG - Control-node 10.0.0.57 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-01457283:ctest-mgmt_vn-62329986', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-01457283', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2228208639493817186', 'uuid-lslong': '11820957578290900962'}, 'enable': 'true', 'created': '2026-05-20T15:48:56', 'last-modified': '2026-05-20T15:48:57', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.551435'}
2026-05-20 15:48:57,702 - DEBUG - Route Targets: ['target:64512:8000007']
2026-05-20 15:48:57,708 - DEBUG - Control-node 10.0.0.141 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-01457283:ctest-mgmt_vn-62329986', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-01457283', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2228208639493817186', 'uuid-lslong': '11820957578290900962'}, 'enable': 'true', 'created': '2026-05-20T15:48:56', 'last-modified': '2026-05-20T15:48:57', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.569397'}
2026-05-20 15:48:57,716 - DEBUG - Route Targets: ['target:64512:8000007']
2026-05-20 15:48:57,723 - DEBUG - Control-node 10.0.0.56 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-01457283:ctest-mgmt_vn-62329986', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-01457283', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2228208639493817186', 'uuid-lslong': '11820957578290900962'}, 'enable': 'true', 'created': '2026-05-20T15:48:56', 'last-modified': '2026-05-20T15:48:57', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.585272'}
2026-05-20 15:48:57,732 - DEBUG - Route Targets: ['target:64512:8000007']
2026-05-20 15:48:57,732 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-62329986 passed
2026-05-20 15:48:57,732 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-62329986 in API_Server ======
2026-05-20 15:48:57,732 - DEBUG - Requesting: http://10.0.0.57:8082/domains
2026-05-20 15:48:57,742 - DEBUG - Requesting: http://10.0.0.57:8082/domain/ffb590f3-7b6e-40e6-89b8-bd634f94ea0b
2026-05-20 15:48:57,761 - DEBUG - Requesting: http://10.0.0.57:8082/project/00822bf8-9298-441b-90cd-e724d140d8d1
2026-05-20 15:48:57,881 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/1eec2ff3-ba7c-4362-a40c-7a498efdafe2
2026-05-20 15:48:57,897 - DEBUG - =>VN ctest-mgmt_vn-62329986 has no policy to be verified
2026-05-20 15:48:57,897 - DEBUG - Verifying the vn in opserver
2026-05-20 15:48:57,897 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-01457283:ctest-mgmt_vn-62329986 virtual network link through opserver 10.0.0.57
2026-05-20 15:48:57,897 - DEBUG - Requesting: http://10.0.0.57:8081/analytics/uves/virtual-networks
2026-05-20 15:48:57,913 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-01457283:ctest-mgmt_vn-62329986', 'href': 'http://10.0.0.57:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-01457283:ctest-mgmt_vn-62329986?flat'}
2026-05-20 15:48:57,913 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-01457283:ctest-mgmt_vn-62329986 virtual network link through opserver 10.0.0.141
2026-05-20 15:48:57,913 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/virtual-networks
2026-05-20 15:48:57,929 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-01457283:ctest-mgmt_vn-62329986', 'href': 'http://10.0.0.141:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-01457283:ctest-mgmt_vn-62329986?flat'}
2026-05-20 15:48:57,929 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-01457283:ctest-mgmt_vn-62329986 virtual network link through opserver 10.0.0.56
2026-05-20 15:48:57,929 - DEBUG - Requesting: http://10.0.0.56:8081/analytics/uves/virtual-networks
2026-05-20 15:48:57,945 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-01457283:ctest-mgmt_vn-62329986', 'href': 'http://10.0.0.56:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-01457283:ctest-mgmt_vn-62329986?flat'}
2026-05-20 15:48:57,945 - INFO - Validated that VN default-domain:ctest-TestSvcHC-01457283:ctest-mgmt_vn-62329986 is found in opserver
2026-05-20 15:48:57,973 - DEBUG - Do not have enough data to verify VN in agent
2026-05-20 15:48:57,987 - DEBUG - VRF ids for VN ctest-mgmt_vn-62329986: {}
2026-05-20 15:48:58,337 - DEBUG - Response for create_network : {'network': {'id': '28c40d4f-686e-43d5-bb86-eefc2bf9fa32', 'name': 'ctest-left_vn-53296067', 'tenant_id': '00822bf89298441b90cde724d140d8d1', 'project_id': '00822bf89298441b90cde724d140d8d1', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-01457283', 'ctest-left_vn-53296067'], 'port_security_enabled': True, 'description': ''}}
2026-05-20 15:48:58,608 - DEBUG - Response for create_subnet : {'subnet': {'id': '85f13503-d295-49d6-8cdb-4736d45c8b8e', 'name': '', 'tenant_id': '00822bf89298441b90cde724d140d8d1', 'network_id': '28c40d4f-686e-43d5-bb86-eefc2bf9fa32', 'ip_version': 4, 'cidr': '25.121.167.0/26', 'allocation_pools': [{'start': '25.121.167.2', 'end': '25.121.167.62'}], 'gateway_ip': '25.121.167.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '25.121.167.2', 'tags': [], 'project_id': '00822bf89298441b90cde724d140d8d1'}}
2026-05-20 15:48:58,636 - INFO - Created VN ctest-left_vn-53296067
2026-05-20 15:48:58,649 - DEBUG - VN ctest-left_vn-53296067 UUID is 28c40d4f-686e-43d5-bb86-eefc2bf9fa32
2026-05-20 15:48:58,753 - DEBUG - Requesting: http://10.0.0.57:8082/domains
2026-05-20 15:48:58,764 - DEBUG - Requesting: http://10.0.0.57:8082/domain/ffb590f3-7b6e-40e6-89b8-bd634f94ea0b
2026-05-20 15:48:58,781 - DEBUG - Requesting: http://10.0.0.57:8082/project/00822bf8-9298-441b-90cd-e724d140d8d1
2026-05-20 15:48:58,885 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/28c40d4f-686e-43d5-bb86-eefc2bf9fa32
2026-05-20 15:48:58,901 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/28c40d4f-686e-43d5-bb86-eefc2bf9fa32
2026-05-20 15:48:58,913 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/01ea8ca5-b0f1-42bf-9d38-87b366d419d1
2026-05-20 15:48:58,923 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/01ea8ca5-b0f1-42bf-9d38-87b366d419d1
2026-05-20 15:48:58,934 - DEBUG - Requesting: http://10.0.0.57:8082/route-target/d55b375b-1e99-4ac6-b2b0-9e341c91706a
2026-05-20 15:48:58,946 - DEBUG - Route Targets: ['target:64512:8000008']
2026-05-20 15:48:58,947 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/28c40d4f-686e-43d5-bb86-eefc2bf9fa32
2026-05-20 15:48:58,959 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/01ea8ca5-b0f1-42bf-9d38-87b366d419d1
2026-05-20 15:48:58,979 - INFO - Verified VN network id 15 for VN 28c40d4f-686e-43d5-bb86-eefc2bf9fa32
2026-05-20 15:48:58,980 - INFO - Verifications in API Server for VN ctest-left_vn-53296067 passed
2026-05-20 15:48:58,980 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/28c40d4f-686e-43d5-bb86-eefc2bf9fa32
2026-05-20 15:48:58,992 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/01ea8ca5-b0f1-42bf-9d38-87b366d419d1
2026-05-20 15:48:59,003 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/01ea8ca5-b0f1-42bf-9d38-87b366d419d1
2026-05-20 15:48:59,023 - DEBUG - Requesting: http://10.0.0.57:8082/route-target/d55b375b-1e99-4ac6-b2b0-9e341c91706a
2026-05-20 15:48:59,047 - DEBUG - Control-node 10.0.0.57 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-01457283:ctest-left_vn-53296067', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-01457283', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2937487491658040277', 'uuid-lslong': '13512750498808724018'}, 'enable': 'true', 'created': '2026-05-20T15:48:58', 'last-modified': '2026-05-20T15:48:58', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.497027'}
2026-05-20 15:48:59,060 - DEBUG - Route Targets: ['target:64512:8000008']
2026-05-20 15:48:59,070 - DEBUG - Control-node 10.0.0.141 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-01457283:ctest-left_vn-53296067', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-01457283', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2937487491658040277', 'uuid-lslong': '13512750498808724018'}, 'enable': 'true', 'created': '2026-05-20T15:48:58', 'last-modified': '2026-05-20T15:48:58', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.535537'}
2026-05-20 15:48:59,080 - DEBUG - Route Targets: ['target:64512:8000008']
2026-05-20 15:48:59,088 - DEBUG - Control-node 10.0.0.56 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-01457283:ctest-left_vn-53296067', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-01457283', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2937487491658040277', 'uuid-lslong': '13512750498808724018'}, 'enable': 'true', 'created': '2026-05-20T15:48:58', 'last-modified': '2026-05-20T15:48:58', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.555519'}
2026-05-20 15:48:59,097 - DEBUG - Route Targets: ['target:64512:8000008']
2026-05-20 15:48:59,097 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-53296067 passed
2026-05-20 15:48:59,097 - DEBUG - ====Verifying policy data for ctest-left_vn-53296067 in API_Server ======
2026-05-20 15:48:59,098 - DEBUG - Requesting: http://10.0.0.57:8082/domains
2026-05-20 15:48:59,110 - DEBUG - Requesting: http://10.0.0.57:8082/domain/ffb590f3-7b6e-40e6-89b8-bd634f94ea0b
2026-05-20 15:48:59,128 - DEBUG - Requesting: http://10.0.0.57:8082/project/00822bf8-9298-441b-90cd-e724d140d8d1
2026-05-20 15:48:59,256 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/28c40d4f-686e-43d5-bb86-eefc2bf9fa32
2026-05-20 15:48:59,270 - DEBUG - =>VN ctest-left_vn-53296067 has no policy to be verified
2026-05-20 15:48:59,270 - DEBUG - Verifying the vn in opserver
2026-05-20 15:48:59,270 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-01457283:ctest-left_vn-53296067 virtual network link through opserver 10.0.0.57
2026-05-20 15:48:59,270 - DEBUG - Requesting: http://10.0.0.57:8081/analytics/uves/virtual-networks
2026-05-20 15:48:59,287 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-01457283:ctest-left_vn-53296067', 'href': 'http://10.0.0.57:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-01457283:ctest-left_vn-53296067?flat'}
2026-05-20 15:48:59,287 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-01457283:ctest-left_vn-53296067 virtual network link through opserver 10.0.0.141
2026-05-20 15:48:59,287 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/virtual-networks
2026-05-20 15:48:59,305 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-01457283:ctest-left_vn-53296067', 'href': 'http://10.0.0.141:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-01457283:ctest-left_vn-53296067?flat'}
2026-05-20 15:48:59,305 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-01457283:ctest-left_vn-53296067 virtual network link through opserver 10.0.0.56
2026-05-20 15:48:59,305 - DEBUG - Requesting: http://10.0.0.56:8081/analytics/uves/virtual-networks
2026-05-20 15:48:59,322 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-01457283:ctest-left_vn-53296067', 'href': 'http://10.0.0.56:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-01457283:ctest-left_vn-53296067?flat'}
2026-05-20 15:48:59,322 - INFO - Validated that VN default-domain:ctest-TestSvcHC-01457283:ctest-left_vn-53296067 is found in opserver
2026-05-20 15:48:59,349 - DEBUG - Do not have enough data to verify VN in agent
2026-05-20 15:48:59,363 - DEBUG - VRF ids for VN ctest-left_vn-53296067: {}
2026-05-20 15:48:59,724 - DEBUG - Response for create_network : {'network': {'id': 'c11284c4-ea8b-4030-9947-845edb5193d9', 'name': 'ctest-right_vn-11858533', 'tenant_id': '00822bf89298441b90cde724d140d8d1', 'project_id': '00822bf89298441b90cde724d140d8d1', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-01457283', 'ctest-right_vn-11858533'], 'port_security_enabled': True, 'description': ''}}
2026-05-20 15:48:59,946 - DEBUG - Response for create_subnet : {'subnet': {'id': '0305685d-e534-4749-a6dc-20a62888893f', 'name': '', 'tenant_id': '00822bf89298441b90cde724d140d8d1', 'network_id': 'c11284c4-ea8b-4030-9947-845edb5193d9', 'ip_version': 4, 'cidr': '26.217.181.64/26', 'allocation_pools': [{'start': '26.217.181.66', 'end': '26.217.181.126'}], 'gateway_ip': '26.217.181.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '26.217.181.66', 'tags': [], 'project_id': '00822bf89298441b90cde724d140d8d1'}}
2026-05-20 15:48:59,980 - INFO - Created VN ctest-right_vn-11858533
2026-05-20 15:49:00,000 - DEBUG - VN ctest-right_vn-11858533 UUID is c11284c4-ea8b-4030-9947-845edb5193d9
2026-05-20 15:49:00,130 - DEBUG - Requesting: http://10.0.0.57:8082/domains
2026-05-20 15:49:00,140 - DEBUG - Requesting: http://10.0.0.57:8082/domain/ffb590f3-7b6e-40e6-89b8-bd634f94ea0b
2026-05-20 15:49:00,155 - DEBUG - Requesting: http://10.0.0.57:8082/project/00822bf8-9298-441b-90cd-e724d140d8d1
2026-05-20 15:49:00,292 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/c11284c4-ea8b-4030-9947-845edb5193d9
2026-05-20 15:49:00,311 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/c11284c4-ea8b-4030-9947-845edb5193d9
2026-05-20 15:49:00,327 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/b30d6658-e36d-4825-b78e-614e413b8d32
2026-05-20 15:49:00,345 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/b30d6658-e36d-4825-b78e-614e413b8d32
2026-05-20 15:49:00,356 - DEBUG - Requesting: http://10.0.0.57:8082/route-target/2d510988-a9c3-4ad4-9374-93fe922a9b0e
2026-05-20 15:49:00,369 - DEBUG - Route Targets: ['target:64512:8000009']
2026-05-20 15:49:00,369 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/c11284c4-ea8b-4030-9947-845edb5193d9
2026-05-20 15:49:00,384 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/b30d6658-e36d-4825-b78e-614e413b8d32
2026-05-20 15:49:00,417 - INFO - Verified VN network id 16 for VN c11284c4-ea8b-4030-9947-845edb5193d9
2026-05-20 15:49:00,417 - INFO - Verifications in API Server for VN ctest-right_vn-11858533 passed
2026-05-20 15:49:00,417 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/c11284c4-ea8b-4030-9947-845edb5193d9
2026-05-20 15:49:00,433 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/b30d6658-e36d-4825-b78e-614e413b8d32
2026-05-20 15:49:00,443 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/b30d6658-e36d-4825-b78e-614e413b8d32
2026-05-20 15:49:00,455 - DEBUG - Requesting: http://10.0.0.57:8082/route-target/2d510988-a9c3-4ad4-9374-93fe922a9b0e
2026-05-20 15:49:00,472 - DEBUG - Control-node 10.0.0.57 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-01457283:ctest-right_vn-11858533', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-01457283', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13912328180184334384', 'uuid-lslong': '11044942154090779609'}, 'enable': 'true', 'created': '2026-05-20T15:48:59', 'last-modified': '2026-05-20T15:48:59', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.583174'}
2026-05-20 15:49:00,479 - DEBUG - Route Targets: ['target:64512:8000009']
2026-05-20 15:49:00,486 - DEBUG - Control-node 10.0.0.141 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-01457283:ctest-right_vn-11858533', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-01457283', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13912328180184334384', 'uuid-lslong': '11044942154090779609'}, 'enable': 'true', 'created': '2026-05-20T15:48:59', 'last-modified': '2026-05-20T15:48:59', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.594518'}
2026-05-20 15:49:00,494 - DEBUG - Route Targets: ['target:64512:8000009']
2026-05-20 15:49:00,502 - DEBUG - Control-node 10.0.0.56 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-01457283:ctest-right_vn-11858533', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-01457283', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13912328180184334384', 'uuid-lslong': '11044942154090779609'}, 'enable': 'true', 'created': '2026-05-20T15:48:59', 'last-modified': '2026-05-20T15:48:59', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.612590'}
2026-05-20 15:49:00,511 - DEBUG - Route Targets: ['target:64512:8000009']
2026-05-20 15:49:00,511 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-11858533 passed
2026-05-20 15:49:00,511 - DEBUG - ====Verifying policy data for ctest-right_vn-11858533 in API_Server ======
2026-05-20 15:49:00,511 - DEBUG - Requesting: http://10.0.0.57:8082/domains
2026-05-20 15:49:00,519 - DEBUG - Requesting: http://10.0.0.57:8082/domain/ffb590f3-7b6e-40e6-89b8-bd634f94ea0b
2026-05-20 15:49:00,534 - DEBUG - Requesting: http://10.0.0.57:8082/project/00822bf8-9298-441b-90cd-e724d140d8d1
2026-05-20 15:49:00,650 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/c11284c4-ea8b-4030-9947-845edb5193d9
2026-05-20 15:49:00,662 - DEBUG - =>VN ctest-right_vn-11858533 has no policy to be verified
2026-05-20 15:49:00,662 - DEBUG - Verifying the vn in opserver
2026-05-20 15:49:00,662 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-01457283:ctest-right_vn-11858533 virtual network link through opserver 10.0.0.57
2026-05-20 15:49:00,662 - DEBUG - Requesting: http://10.0.0.57:8081/analytics/uves/virtual-networks
2026-05-20 15:49:00,678 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-01457283:ctest-right_vn-11858533', 'href': 'http://10.0.0.57:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-01457283:ctest-right_vn-11858533?flat'}
2026-05-20 15:49:00,678 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-01457283:ctest-right_vn-11858533 virtual network link through opserver 10.0.0.141
2026-05-20 15:49:00,678 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/virtual-networks
2026-05-20 15:49:00,693 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-01457283:ctest-right_vn-11858533', 'href': 'http://10.0.0.141:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-01457283:ctest-right_vn-11858533?flat'}
2026-05-20 15:49:00,693 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-01457283:ctest-right_vn-11858533 virtual network link through opserver 10.0.0.56
2026-05-20 15:49:00,693 - DEBUG - Requesting: http://10.0.0.56:8081/analytics/uves/virtual-networks
2026-05-20 15:49:00,710 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-01457283:ctest-right_vn-11858533', 'href': 'http://10.0.0.56:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-01457283:ctest-right_vn-11858533?flat'}
2026-05-20 15:49:00,710 - INFO - Validated that VN default-domain:ctest-TestSvcHC-01457283:ctest-right_vn-11858533 is found in opserver
2026-05-20 15:49:00,740 - DEBUG - Do not have enough data to verify VN in agent
2026-05-20 15:49:00,754 - DEBUG - VRF ids for VN ctest-right_vn-11858533: {}
2026-05-20 15:49:01,123 - DEBUG - Response for create_network : {'network': {'id': '94365cb2-7fcd-4147-81bd-a0caf2be0286', 'name': 'ctest-trans_left_vn-35282682', 'tenant_id': '00822bf89298441b90cde724d140d8d1', 'project_id': '00822bf89298441b90cde724d140d8d1', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-01457283', 'ctest-trans_left_vn-35282682'], 'port_security_enabled': True, 'description': ''}}
2026-05-20 15:49:01,426 - DEBUG - Response for create_subnet : {'subnet': {'id': 'f5a9979c-da49-4d2b-b7b3-8fe383b71c63', 'name': '', 'tenant_id': '00822bf89298441b90cde724d140d8d1', 'network_id': '94365cb2-7fcd-4147-81bd-a0caf2be0286', 'ip_version': 4, 'cidr': '20.211.104.192/26', 'allocation_pools': [{'start': '20.211.104.194', 'end': '20.211.104.254'}], 'gateway_ip': '20.211.104.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '20.211.104.194', 'tags': [], 'project_id': '00822bf89298441b90cde724d140d8d1'}}
2026-05-20 15:49:01,455 - INFO - Created VN ctest-trans_left_vn-35282682
2026-05-20 15:49:01,472 - DEBUG - VN ctest-trans_left_vn-35282682 UUID is 94365cb2-7fcd-4147-81bd-a0caf2be0286
2026-05-20 15:49:01,563 - DEBUG - Requesting: http://10.0.0.57:8082/domains
2026-05-20 15:49:01,571 - DEBUG - Requesting: http://10.0.0.57:8082/domain/ffb590f3-7b6e-40e6-89b8-bd634f94ea0b
2026-05-20 15:49:01,585 - DEBUG - Requesting: http://10.0.0.57:8082/project/00822bf8-9298-441b-90cd-e724d140d8d1
2026-05-20 15:49:01,698 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/94365cb2-7fcd-4147-81bd-a0caf2be0286
2026-05-20 15:49:01,714 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/94365cb2-7fcd-4147-81bd-a0caf2be0286
2026-05-20 15:49:01,729 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/28e6013b-caaf-49d9-b9be-ae66a63f1bcd
2026-05-20 15:49:01,742 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/28e6013b-caaf-49d9-b9be-ae66a63f1bcd
2026-05-20 15:49:01,753 - DEBUG - Requesting: http://10.0.0.57:8082/route-target/4b1e4b01-9143-45b5-9664-ad815f8007a9
2026-05-20 15:49:01,762 - DEBUG - Route Targets: ['target:64512:8000010']
2026-05-20 15:49:01,762 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/94365cb2-7fcd-4147-81bd-a0caf2be0286
2026-05-20 15:49:01,775 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/28e6013b-caaf-49d9-b9be-ae66a63f1bcd
2026-05-20 15:49:01,802 - INFO - Verified VN network id 17 for VN 94365cb2-7fcd-4147-81bd-a0caf2be0286
2026-05-20 15:49:01,802 - INFO - Verifications in API Server for VN ctest-trans_left_vn-35282682 passed
2026-05-20 15:49:01,803 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/94365cb2-7fcd-4147-81bd-a0caf2be0286
2026-05-20 15:49:01,814 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/28e6013b-caaf-49d9-b9be-ae66a63f1bcd
2026-05-20 15:49:01,823 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/28e6013b-caaf-49d9-b9be-ae66a63f1bcd
2026-05-20 15:49:01,839 - DEBUG - Requesting: http://10.0.0.57:8082/route-target/4b1e4b01-9143-45b5-9664-ad815f8007a9
2026-05-20 15:49:01,858 - DEBUG - Control-node 10.0.0.57 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-01457283:ctest-trans_left_vn-35282682', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-01457283', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10679825488073802055', 'uuid-lslong': '9348805195007394438'}, 'enable': 'true', 'created': '2026-05-20T15:49:01', 'last-modified': '2026-05-20T15:49:01', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.509821'}
2026-05-20 15:49:01,866 - DEBUG - Route Targets: ['target:64512:8000010']
2026-05-20 15:49:01,874 - DEBUG - Control-node 10.0.0.141 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-01457283:ctest-trans_left_vn-35282682', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-01457283', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10679825488073802055', 'uuid-lslong': '9348805195007394438'}, 'enable': 'true', 'created': '2026-05-20T15:49:01', 'last-modified': '2026-05-20T15:49:01', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.521109'}
2026-05-20 15:49:01,890 - DEBUG - Route Targets: ['target:64512:8000010']
2026-05-20 15:49:01,898 - DEBUG - Control-node 10.0.0.56 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-01457283:ctest-trans_left_vn-35282682', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-01457283', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10679825488073802055', 'uuid-lslong': '9348805195007394438'}, 'enable': 'true', 'created': '2026-05-20T15:49:01', 'last-modified': '2026-05-20T15:49:01', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.553565'}
2026-05-20 15:49:01,910 - DEBUG - Route Targets: ['target:64512:8000010']
2026-05-20 15:49:01,911 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_left_vn-35282682 passed
2026-05-20 15:49:01,911 - DEBUG - ====Verifying policy data for ctest-trans_left_vn-35282682 in API_Server ======
2026-05-20 15:49:01,911 - DEBUG - Requesting: http://10.0.0.57:8082/domains
2026-05-20 15:49:01,921 - DEBUG - Requesting: http://10.0.0.57:8082/domain/ffb590f3-7b6e-40e6-89b8-bd634f94ea0b
2026-05-20 15:49:01,937 - DEBUG - Requesting: http://10.0.0.57:8082/project/00822bf8-9298-441b-90cd-e724d140d8d1
2026-05-20 15:49:02,043 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/94365cb2-7fcd-4147-81bd-a0caf2be0286
2026-05-20 15:49:02,060 - DEBUG - =>VN ctest-trans_left_vn-35282682 has no policy to be verified
2026-05-20 15:49:02,060 - DEBUG - Verifying the vn in opserver
2026-05-20 15:49:02,060 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-01457283:ctest-trans_left_vn-35282682 virtual network link through opserver 10.0.0.57
2026-05-20 15:49:02,060 - DEBUG - Requesting: http://10.0.0.57:8081/analytics/uves/virtual-networks
2026-05-20 15:49:02,076 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-01457283:ctest-trans_left_vn-35282682', 'href': 'http://10.0.0.57:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-01457283:ctest-trans_left_vn-35282682?flat'}
2026-05-20 15:49:02,076 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-01457283:ctest-trans_left_vn-35282682 virtual network link through opserver 10.0.0.141
2026-05-20 15:49:02,076 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/virtual-networks
2026-05-20 15:49:02,096 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-01457283:ctest-trans_left_vn-35282682', 'href': 'http://10.0.0.141:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-01457283:ctest-trans_left_vn-35282682?flat'}
2026-05-20 15:49:02,096 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-01457283:ctest-trans_left_vn-35282682 virtual network link through opserver 10.0.0.56
2026-05-20 15:49:02,096 - DEBUG - Requesting: http://10.0.0.56:8081/analytics/uves/virtual-networks
2026-05-20 15:49:02,114 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-01457283:ctest-trans_left_vn-35282682', 'href': 'http://10.0.0.56:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-01457283:ctest-trans_left_vn-35282682?flat'}
2026-05-20 15:49:02,114 - INFO - Validated that VN default-domain:ctest-TestSvcHC-01457283:ctest-trans_left_vn-35282682 is found in opserver
2026-05-20 15:49:02,141 - DEBUG - Do not have enough data to verify VN in agent
2026-05-20 15:49:02,155 - DEBUG - VRF ids for VN ctest-trans_left_vn-35282682: {}
2026-05-20 15:49:02,562 - DEBUG - Response for create_network : {'network': {'id': '1d784085-fa44-4cd1-952a-7e706dee42c5', 'name': 'ctest-trans_right_vn-52933585', 'tenant_id': '00822bf89298441b90cde724d140d8d1', 'project_id': '00822bf89298441b90cde724d140d8d1', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-01457283', 'ctest-trans_right_vn-52933585'], 'port_security_enabled': True, 'description': ''}}
2026-05-20 15:49:02,894 - DEBUG - Response for create_subnet : {'subnet': {'id': 'ea903fb1-ca1c-4b07-bc88-080d5772bbfd', 'name': '', 'tenant_id': '00822bf89298441b90cde724d140d8d1', 'network_id': '1d784085-fa44-4cd1-952a-7e706dee42c5', 'ip_version': 4, 'cidr': '125.210.229.0/26', 'allocation_pools': [{'start': '125.210.229.2', 'end': '125.210.229.62'}], 'gateway_ip': '125.210.229.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '125.210.229.2', 'tags': [], 'project_id': '00822bf89298441b90cde724d140d8d1'}}
2026-05-20 15:49:02,927 - INFO - Created VN ctest-trans_right_vn-52933585
2026-05-20 15:49:02,943 - DEBUG - VN ctest-trans_right_vn-52933585 UUID is 1d784085-fa44-4cd1-952a-7e706dee42c5
2026-05-20 15:49:03,056 - DEBUG - Requesting: http://10.0.0.57:8082/domains
2026-05-20 15:49:03,065 - DEBUG - Requesting: http://10.0.0.57:8082/domain/ffb590f3-7b6e-40e6-89b8-bd634f94ea0b
2026-05-20 15:49:03,079 - DEBUG - Requesting: http://10.0.0.57:8082/project/00822bf8-9298-441b-90cd-e724d140d8d1
2026-05-20 15:49:03,190 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/1d784085-fa44-4cd1-952a-7e706dee42c5
2026-05-20 15:49:03,213 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/1d784085-fa44-4cd1-952a-7e706dee42c5
2026-05-20 15:49:03,229 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/688c6877-688d-4812-bc1b-666479d978e5
2026-05-20 15:49:03,241 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/688c6877-688d-4812-bc1b-666479d978e5
2026-05-20 15:49:03,253 - DEBUG - Requesting: http://10.0.0.57:8082/route-target/718cdef8-46ba-4326-9318-b6ffc0b4110c
2026-05-20 15:49:03,264 - DEBUG - Route Targets: ['target:64512:8000011']
2026-05-20 15:49:03,264 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/1d784085-fa44-4cd1-952a-7e706dee42c5
2026-05-20 15:49:03,278 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/688c6877-688d-4812-bc1b-666479d978e5
2026-05-20 15:49:03,302 - INFO - Verified VN network id 18 for VN 1d784085-fa44-4cd1-952a-7e706dee42c5
2026-05-20 15:49:03,302 - INFO - Verifications in API Server for VN ctest-trans_right_vn-52933585 passed
2026-05-20 15:49:03,302 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/1d784085-fa44-4cd1-952a-7e706dee42c5
2026-05-20 15:49:03,314 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/688c6877-688d-4812-bc1b-666479d978e5
2026-05-20 15:49:03,324 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/688c6877-688d-4812-bc1b-666479d978e5
2026-05-20 15:49:03,340 - DEBUG - Requesting: http://10.0.0.57:8082/route-target/718cdef8-46ba-4326-9318-b6ffc0b4110c
2026-05-20 15:49:03,365 - DEBUG - Control-node 10.0.0.57 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-01457283:ctest-trans_right_vn-52933585', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-01457283', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2123518168478797009', 'uuid-lslong': '10748542482018878149'}, 'enable': 'true', 'created': '2026-05-20T15:49:02', 'last-modified': '2026-05-20T15:49:02', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.550650'}
2026-05-20 15:49:03,375 - DEBUG - Route Targets: ['target:64512:8000011']
2026-05-20 15:49:03,383 - DEBUG - Control-node 10.0.0.141 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-01457283:ctest-trans_right_vn-52933585', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-01457283', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2123518168478797009', 'uuid-lslong': '10748542482018878149'}, 'enable': 'true', 'created': '2026-05-20T15:49:02', 'last-modified': '2026-05-20T15:49:02', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.584481'}
2026-05-20 15:49:03,393 - DEBUG - Route Targets: ['target:64512:8000011']
2026-05-20 15:49:03,403 - DEBUG - Control-node 10.0.0.56 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-01457283:ctest-trans_right_vn-52933585', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-01457283', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2123518168478797009', 'uuid-lslong': '10748542482018878149'}, 'enable': 'true', 'created': '2026-05-20T15:49:02', 'last-modified': '2026-05-20T15:49:02', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.588038'}
2026-05-20 15:49:03,414 - DEBUG - Route Targets: ['target:64512:8000011']
2026-05-20 15:49:03,414 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_right_vn-52933585 passed
2026-05-20 15:49:03,415 - DEBUG - ====Verifying policy data for ctest-trans_right_vn-52933585 in API_Server ======
2026-05-20 15:49:03,415 - DEBUG - Requesting: http://10.0.0.57:8082/domains
2026-05-20 15:49:03,423 - DEBUG - Requesting: http://10.0.0.57:8082/domain/ffb590f3-7b6e-40e6-89b8-bd634f94ea0b
2026-05-20 15:49:03,440 - DEBUG - Requesting: http://10.0.0.57:8082/project/00822bf8-9298-441b-90cd-e724d140d8d1
2026-05-20 15:49:03,558 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/1d784085-fa44-4cd1-952a-7e706dee42c5
2026-05-20 15:49:03,573 - DEBUG - =>VN ctest-trans_right_vn-52933585 has no policy to be verified
2026-05-20 15:49:03,573 - DEBUG - Verifying the vn in opserver
2026-05-20 15:49:03,573 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-01457283:ctest-trans_right_vn-52933585 virtual network link through opserver 10.0.0.57
2026-05-20 15:49:03,573 - DEBUG - Requesting: http://10.0.0.57:8081/analytics/uves/virtual-networks
2026-05-20 15:49:03,591 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-01457283:ctest-trans_right_vn-52933585', 'href': 'http://10.0.0.57:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-01457283:ctest-trans_right_vn-52933585?flat'}
2026-05-20 15:49:03,591 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-01457283:ctest-trans_right_vn-52933585 virtual network link through opserver 10.0.0.141
2026-05-20 15:49:03,591 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/virtual-networks
2026-05-20 15:49:03,612 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-01457283:ctest-trans_right_vn-52933585', 'href': 'http://10.0.0.141:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-01457283:ctest-trans_right_vn-52933585?flat'}
2026-05-20 15:49:03,612 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-01457283:ctest-trans_right_vn-52933585 virtual network link through opserver 10.0.0.56
2026-05-20 15:49:03,612 - DEBUG - Requesting: http://10.0.0.56:8081/analytics/uves/virtual-networks
2026-05-20 15:49:03,630 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-01457283:ctest-trans_right_vn-52933585', 'href': 'http://10.0.0.56:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-01457283:ctest-trans_right_vn-52933585?flat'}
2026-05-20 15:49:03,630 - INFO - Validated that VN default-domain:ctest-TestSvcHC-01457283:ctest-trans_right_vn-52933585 is found in opserver
2026-05-20 15:49:03,663 - DEBUG - Do not have enough data to verify VN in agent
2026-05-20 15:49:03,680 - DEBUG - VRF ids for VN ctest-trans_right_vn-52933585: {}
2026-05-20 15:49:05,380 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5803-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5803-1)
2026-05-20 15:49:07,455 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5803-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5803-2)
2026-05-20 15:49:07,455 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-49530416']
2026-05-20 15:49:07,804 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-49530416'] created succesfully
2026-05-20 15:49:08,416 - DEBUG - Image by name tiny_trans_fw not found
2026-05-20 15:49:08,416 - DEBUG - Installing image tiny_trans_fw
2026-05-20 15:49:08,416 - 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'}
2026-05-20 15:49:08,416 - DEBUG - Image build path file:///contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2026-05-20 15:49:08,417 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2026-05-20 15:49:08,417 - DEBUG - Unzip image
2026-05-20 15:49:08,417 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2026-05-20 15:49:08,445 - INFO - image /contrail-test/images/tinycore-net-transparent-fw.qcow2 is not found
2026-05-20 15:49:08,445 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-49530416']
2026-05-20 15:49:08,606 - INFO - Service template: ['default-domain', 'ctest-service_template_1-49530416'] deleted successfully.
2026-05-20 15:49:08,606 - INFO - Skip interface_detach for VM ctest-right_vm-51595212 in state BUILD
2026-05-20 15:49:08,606 - INFO - Deleting VM ctest-right_vm-51595212
2026-05-20 15:49:08,607 - ERROR - VM ctest-right_vm-51595212 has failed to come up
2026-05-20 15:49:08,607 - ERROR - Nova failed to get host of the VM
2026-05-20 15:49:08,607 - ERROR - VM ctest-right_vm-51595212 has failed to come up
2026-05-20 15:49:08,607 - ERROR - Nova failed to get host of the VM
2026-05-20 15:49:08,765 - INFO - Skip interface_detach for VM ctest-left_vm-83720193 in state BUILD
2026-05-20 15:49:08,765 - INFO - Deleting VM ctest-left_vm-83720193
2026-05-20 15:49:08,765 - ERROR - VM ctest-left_vm-83720193 has failed to come up
2026-05-20 15:49:08,765 - ERROR - Nova failed to get host of the VM
2026-05-20 15:49:08,765 - ERROR - VM ctest-left_vm-83720193 has failed to come up
2026-05-20 15:49:08,766 - ERROR - Nova failed to get host of the VM
2026-05-20 15:49:08,888 - INFO - Deleting VN ctest-trans_right_vn-52933585
2026-05-20 15:49:09,125 - DEBUG - Response for deleting network ()
2026-05-20 15:49:09,125 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/688c6877-688d-4812-bc1b-666479d978e5
2026-05-20 15:49:09,133 - DEBUG - Response Code: 404
2026-05-20 15:49:09,133 - DEBUG - Requesting: http://10.0.0.57:8082/domains
2026-05-20 15:49:09,158 - DEBUG - Requesting: http://10.0.0.57:8082/domain/ffb590f3-7b6e-40e6-89b8-bd634f94ea0b
2026-05-20 15:49:09,180 - DEBUG - Requesting: http://10.0.0.57:8082/project/00822bf8-9298-441b-90cd-e724d140d8d1
2026-05-20 15:49:09,295 - INFO - Validated that VN ctest-trans_right_vn-52933585 is not found in API Server
2026-05-20 15:49:09,312 - DEBUG - VN ctest-trans_right_vn-52933585 is not present in Agent 10.0.0.242
2026-05-20 15:49:09,346 - DEBUG - VN ctest-trans_right_vn-52933585 is not present in Agent 10.0.0.249
2026-05-20 15:49:09,346 - INFO - Validated that VN ctest-trans_right_vn-52933585 is not in any agent
2026-05-20 15:49:09,414 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-trans_right_vn-52933585 info
2026-05-20 15:49:09,415 - INFO - Deleting VN ctest-trans_left_vn-35282682
2026-05-20 15:49:09,724 - DEBUG - Response for deleting network ()
2026-05-20 15:49:09,724 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/28e6013b-caaf-49d9-b9be-ae66a63f1bcd
2026-05-20 15:49:09,736 - DEBUG - Response Code: 404
2026-05-20 15:49:09,737 - DEBUG - Requesting: http://10.0.0.57:8082/domains
2026-05-20 15:49:09,749 - DEBUG - Requesting: http://10.0.0.57:8082/domain/ffb590f3-7b6e-40e6-89b8-bd634f94ea0b
2026-05-20 15:49:09,781 - DEBUG - Requesting: http://10.0.0.57:8082/project/00822bf8-9298-441b-90cd-e724d140d8d1
2026-05-20 15:49:09,945 - INFO - Validated that VN ctest-trans_left_vn-35282682 is not found in API Server
2026-05-20 15:49:09,960 - DEBUG - VN ctest-trans_left_vn-35282682 is not present in Agent 10.0.0.242
2026-05-20 15:49:09,978 - DEBUG - VN ctest-trans_left_vn-35282682 is not present in Agent 10.0.0.249
2026-05-20 15:49:09,978 - INFO - Validated that VN ctest-trans_left_vn-35282682 is not in any agent
2026-05-20 15:49:10,046 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-trans_left_vn-35282682 info
2026-05-20 15:49:10,047 - INFO - Deleting VN ctest-right_vn-11858533
2026-05-20 15:49:10,134 - DEBUG - VN c11284c4-ea8b-4030-9947-845edb5193d9 still in use: Unable to complete operation on network c11284c4-ea8b-4030-9947-845edb5193d9. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-e7cbebea-806f-4aa3-a34e-6d4bc7496fa3']
2026-05-20 15:49:10,134 - WARNING - Deleting VN ctest-right_vn-11858533 failed..Will retry
2026-05-20 15:49:12,371 - DEBUG - Response for deleting network ()
2026-05-20 15:49:12,371 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/b30d6658-e36d-4825-b78e-614e413b8d32
2026-05-20 15:49:12,380 - DEBUG - Response Code: 404
2026-05-20 15:49:12,380 - DEBUG - Requesting: http://10.0.0.57:8082/domains
2026-05-20 15:49:12,388 - DEBUG - Requesting: http://10.0.0.57:8082/domain/ffb590f3-7b6e-40e6-89b8-bd634f94ea0b
2026-05-20 15:49:12,405 - DEBUG - Requesting: http://10.0.0.57:8082/project/00822bf8-9298-441b-90cd-e724d140d8d1
2026-05-20 15:49:12,533 - INFO - Validated that VN ctest-right_vn-11858533 is not found in API Server
2026-05-20 15:49:12,552 - DEBUG - VN ctest-right_vn-11858533 is not present in Agent 10.0.0.242
2026-05-20 15:49:12,570 - DEBUG - VN ctest-right_vn-11858533 is not present in Agent 10.0.0.249
2026-05-20 15:49:12,570 - INFO - Validated that VN ctest-right_vn-11858533 is not in any agent
2026-05-20 15:49:12,628 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-11858533 info
2026-05-20 15:49:12,629 - INFO - Deleting VN ctest-left_vn-53296067
2026-05-20 15:49:12,859 - DEBUG - Response for deleting network ()
2026-05-20 15:49:12,859 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/01ea8ca5-b0f1-42bf-9d38-87b366d419d1
2026-05-20 15:49:12,866 - DEBUG - Response Code: 404
2026-05-20 15:49:12,866 - DEBUG - Requesting: http://10.0.0.57:8082/domains
2026-05-20 15:49:12,880 - DEBUG - Requesting: http://10.0.0.57:8082/domain/ffb590f3-7b6e-40e6-89b8-bd634f94ea0b
2026-05-20 15:49:12,904 - DEBUG - Requesting: http://10.0.0.57:8082/project/00822bf8-9298-441b-90cd-e724d140d8d1
2026-05-20 15:49:13,009 - INFO - Validated that VN ctest-left_vn-53296067 is not found in API Server
2026-05-20 15:49:13,022 - DEBUG - VN ctest-left_vn-53296067 is not present in Agent 10.0.0.242
2026-05-20 15:49:13,035 - DEBUG - VN ctest-left_vn-53296067 is not present in Agent 10.0.0.249
2026-05-20 15:49:13,035 - INFO - Validated that VN ctest-left_vn-53296067 is not in any agent
2026-05-20 15:49:13,076 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-53296067 info
2026-05-20 15:49:13,076 - INFO - Deleting VN ctest-mgmt_vn-62329986
2026-05-20 15:49:13,340 - DEBUG - Response for deleting network ()
2026-05-20 15:49:13,340 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/faa98226-4b1d-4bd4-b85f-a27b166b71ee
2026-05-20 15:49:13,348 - DEBUG - Response Code: 404
2026-05-20 15:49:13,348 - DEBUG - Requesting: http://10.0.0.57:8082/domains
2026-05-20 15:49:13,358 - DEBUG - Requesting: http://10.0.0.57:8082/domain/ffb590f3-7b6e-40e6-89b8-bd634f94ea0b
2026-05-20 15:49:13,418 - DEBUG - Requesting: http://10.0.0.57:8082/project/00822bf8-9298-441b-90cd-e724d140d8d1
2026-05-20 15:49:13,542 - INFO - Validated that VN ctest-mgmt_vn-62329986 is not found in API Server
2026-05-20 15:49:13,555 - DEBUG - VN ctest-mgmt_vn-62329986 is not present in Agent 10.0.0.242
2026-05-20 15:49:13,569 - DEBUG - VN ctest-mgmt_vn-62329986 is not present in Agent 10.0.0.249
2026-05-20 15:49:13,570 - INFO - Validated that VN ctest-mgmt_vn-62329986 is not in any agent
2026-05-20 15:49:13,621 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-62329986 info
2026-05-20 15:49:14,935 - DEBUG - No XMPP flaps were noticed during the test
2026-05-20 15:49:14,935 - INFO -
2026-05-20 15:49:14,936 - INFO - END TEST : test_svc_trans_segment_right_hc_fail_svm : SKIPPED[0:00:19]
2026-05-20 15:49:14,936 - INFO - --------------------------------------------------------------------------------
2026-05-20 15:49:15,871 - INFO - Deleted project: ctest-TestSvcHC-01457283, ID : 00822bf8-9298-441b-90cd-e724d140d8d1