2025-10-30 03:15:33,295 - INFO - Domain Default found not creating 2025-10-30 03:15:33,455 - INFO - Project ctest-TestSvcHC-20871179 not found, creating it 2025-10-30 03:15:34,047 - INFO - Created Project:ctest-TestSvcHC-20871179, ID : 2ee20ab4-67d9-42ce-9bba-66f37d99df39 2025-10-30 03:15:35,517 - INFO - ================================================================================ 2025-10-30 03:15:35,517 - INFO - STARTING TEST : test_svc_hc_basic 2025-10-30 03:15:36,781 - DEBUG - Nothing to compare xmpp stats {'10.0.0.129': {'10.20.0.131': '0', '10.20.0.254': '0'}, '10.0.0.65': {'10.20.0.254': '0', '10.20.0.131': '0'}} with 2025-10-30 03:15:36,781 - INFO - Initial checks done. Running the testcase now 2025-10-30 03:15:36,781 - INFO - 2025-10-30 03:15:37,533 - DEBUG - Response for create_network : {'network': {'id': '77207014-6e60-4fab-a8f1-149495fa975b', 'name': 'ctest-mgmt_vn-58756841', 'tenant_id': '2ee20ab467d942ce9bba66f37d99df39', 'project_id': '2ee20ab467d942ce9bba66f37d99df39', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-20871179', 'ctest-mgmt_vn-58756841'], 'port_security_enabled': True, 'description': ''}} 2025-10-30 03:15:37,797 - DEBUG - Response for create_subnet : {'subnet': {'id': 'de8355ba-a634-44b5-b11c-51b401192bb5', 'name': '', 'tenant_id': '2ee20ab467d942ce9bba66f37d99df39', 'network_id': '77207014-6e60-4fab-a8f1-149495fa975b', 'ip_version': 4, 'cidr': '2.65.213.64/26', 'allocation_pools': [{'start': '2.65.213.66', 'end': '2.65.213.126'}], 'gateway_ip': '2.65.213.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '2.65.213.66', 'tags': [], 'project_id': '2ee20ab467d942ce9bba66f37d99df39'}} 2025-10-30 03:15:37,822 - INFO - Created VN ctest-mgmt_vn-58756841 2025-10-30 03:15:37,836 - DEBUG - VN ctest-mgmt_vn-58756841 UUID is 77207014-6e60-4fab-a8f1-149495fa975b 2025-10-30 03:15:37,928 - DEBUG - Requesting: http://10.0.0.242:8082/domains 2025-10-30 03:15:38,308 - DEBUG - Requesting: http://10.0.0.242:8082/domains 2025-10-30 03:15:38,343 - DEBUG - Requesting: http://10.0.0.242:8082/domain/2be6ea5e-665d-4a78-a8ec-f940f567f06f 2025-10-30 03:15:38,356 - DEBUG - Requesting: http://10.0.0.242:8082/project/2ee20ab4-67d9-42ce-9bba-66f37d99df39 2025-10-30 03:15:38,460 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/77207014-6e60-4fab-a8f1-149495fa975b 2025-10-30 03:15:38,474 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/77207014-6e60-4fab-a8f1-149495fa975b 2025-10-30 03:15:38,487 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/cb332105-c1f8-4734-803b-8c8933737e55 2025-10-30 03:15:38,502 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/cb332105-c1f8-4734-803b-8c8933737e55 2025-10-30 03:15:38,511 - DEBUG - Requesting: http://10.0.0.242:8082/route-target/66a55708-7540-4945-8f16-e40fd6fa036b 2025-10-30 03:15:38,519 - DEBUG - Route Targets: ['target:64512:8000004'] 2025-10-30 03:15:38,519 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/77207014-6e60-4fab-a8f1-149495fa975b 2025-10-30 03:15:38,528 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/cb332105-c1f8-4734-803b-8c8933737e55 2025-10-30 03:15:38,546 - INFO - Verified VN network id 13 for VN 77207014-6e60-4fab-a8f1-149495fa975b 2025-10-30 03:15:38,546 - INFO - Verifications in API Server for VN ctest-mgmt_vn-58756841 passed 2025-10-30 03:15:38,546 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/77207014-6e60-4fab-a8f1-149495fa975b 2025-10-30 03:15:38,556 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/cb332105-c1f8-4734-803b-8c8933737e55 2025-10-30 03:15:38,563 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/cb332105-c1f8-4734-803b-8c8933737e55 2025-10-30 03:15:38,570 - DEBUG - Requesting: http://10.0.0.242:8082/route-target/66a55708-7540-4945-8f16-e40fd6fa036b 2025-10-30 03:15:38,584 - DEBUG - Control-node 10.0.0.242 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-20871179:ctest-mgmt_vn-58756841', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-20871179', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8583984122821627819', 'uuid-lslong': '12173533896163104603'}, 'enable': 'true', 'created': '2025-10-30T03:15:37', 'last-modified': '2025-10-30T03:15:37', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.833644'} 2025-10-30 03:15:38,596 - DEBUG - Route Targets: ['target:64512:8000004'] 2025-10-30 03:15:38,601 - DEBUG - Control-node 10.0.0.254 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-20871179:ctest-mgmt_vn-58756841', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-20871179', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8583984122821627819', 'uuid-lslong': '12173533896163104603'}, 'enable': 'true', 'created': '2025-10-30T03:15:37', 'last-modified': '2025-10-30T03:15:37', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.859867'} 2025-10-30 03:15:38,606 - DEBUG - Route Targets: ['target:64512:8000004'] 2025-10-30 03:15:38,613 - DEBUG - Control-node 10.0.0.240 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-20871179:ctest-mgmt_vn-58756841', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-20871179', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8583984122821627819', 'uuid-lslong': '12173533896163104603'}, 'enable': 'true', 'created': '2025-10-30T03:15:37', 'last-modified': '2025-10-30T03:15:37', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.869818'} 2025-10-30 03:15:38,619 - DEBUG - Route Targets: ['target:64512:8000004'] 2025-10-30 03:15:38,619 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-58756841 passed 2025-10-30 03:15:38,619 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-58756841 in API_Server ====== 2025-10-30 03:15:38,619 - DEBUG - Requesting: http://10.0.0.242:8082/domains 2025-10-30 03:15:38,628 - DEBUG - Requesting: http://10.0.0.242:8082/domain/2be6ea5e-665d-4a78-a8ec-f940f567f06f 2025-10-30 03:15:38,638 - DEBUG - Requesting: http://10.0.0.242:8082/project/2ee20ab4-67d9-42ce-9bba-66f37d99df39 2025-10-30 03:15:38,726 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/77207014-6e60-4fab-a8f1-149495fa975b 2025-10-30 03:15:38,735 - DEBUG - =>VN ctest-mgmt_vn-58756841 has no policy to be verified 2025-10-30 03:15:38,735 - DEBUG - Verifying the vn in opserver 2025-10-30 03:15:38,735 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-20871179:ctest-mgmt_vn-58756841 virtual network link through opserver 10.0.0.242 2025-10-30 03:15:38,736 - DEBUG - Requesting: http://10.0.0.242:8081/analytics/uves/virtual-networks 2025-10-30 03:15:39,038 - DEBUG - Requesting: http://10.0.0.242:8081/analytics/uves/virtual-networks 2025-10-30 03:15:39,105 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-20871179:ctest-mgmt_vn-58756841', 'href': 'http://10.0.0.242:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-20871179:ctest-mgmt_vn-58756841?flat'} 2025-10-30 03:15:39,105 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-20871179:ctest-mgmt_vn-58756841 virtual network link through opserver 10.0.0.254 2025-10-30 03:15:39,105 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-networks 2025-10-30 03:15:39,400 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-networks 2025-10-30 03:15:39,456 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-20871179:ctest-mgmt_vn-58756841', 'href': 'http://10.0.0.254:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-20871179:ctest-mgmt_vn-58756841?flat'} 2025-10-30 03:15:39,456 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-20871179:ctest-mgmt_vn-58756841 virtual network link through opserver 10.0.0.240 2025-10-30 03:15:39,456 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/virtual-networks 2025-10-30 03:15:39,752 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/virtual-networks 2025-10-30 03:15:39,810 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-20871179:ctest-mgmt_vn-58756841', 'href': 'http://10.0.0.240:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-20871179:ctest-mgmt_vn-58756841?flat'} 2025-10-30 03:15:39,811 - INFO - Validated that VN default-domain:ctest-TestSvcHC-20871179:ctest-mgmt_vn-58756841 is found in opserver 2025-10-30 03:15:39,832 - DEBUG - Do not have enough data to verify VN in agent 2025-10-30 03:15:39,841 - DEBUG - VRF ids for VN ctest-mgmt_vn-58756841: {} 2025-10-30 03:15:40,134 - DEBUG - Response for create_network : {'network': {'id': 'c8fa7008-69e9-474c-98a4-dea335bf4aa5', 'name': 'ctest-left_vn-94574668', 'tenant_id': '2ee20ab467d942ce9bba66f37d99df39', 'project_id': '2ee20ab467d942ce9bba66f37d99df39', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-20871179', 'ctest-left_vn-94574668'], 'port_security_enabled': True, 'description': ''}} 2025-10-30 03:15:40,359 - DEBUG - Response for create_subnet : {'subnet': {'id': '08230165-6115-4e52-91cd-1a2c02ffc556', 'name': '', 'tenant_id': '2ee20ab467d942ce9bba66f37d99df39', 'network_id': 'c8fa7008-69e9-474c-98a4-dea335bf4aa5', 'ip_version': 4, 'cidr': '11.15.158.128/26', 'allocation_pools': [{'start': '11.15.158.130', 'end': '11.15.158.190'}], 'gateway_ip': '11.15.158.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '11.15.158.130', 'tags': [], 'project_id': '2ee20ab467d942ce9bba66f37d99df39'}} 2025-10-30 03:15:40,384 - INFO - Created VN ctest-left_vn-94574668 2025-10-30 03:15:40,396 - DEBUG - VN ctest-left_vn-94574668 UUID is c8fa7008-69e9-474c-98a4-dea335bf4aa5 2025-10-30 03:15:40,484 - DEBUG - Requesting: http://10.0.0.242:8082/domains 2025-10-30 03:15:40,492 - DEBUG - Requesting: http://10.0.0.242:8082/domain/2be6ea5e-665d-4a78-a8ec-f940f567f06f 2025-10-30 03:15:40,507 - DEBUG - Requesting: http://10.0.0.242:8082/project/2ee20ab4-67d9-42ce-9bba-66f37d99df39 2025-10-30 03:15:40,622 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/c8fa7008-69e9-474c-98a4-dea335bf4aa5 2025-10-30 03:15:40,638 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/c8fa7008-69e9-474c-98a4-dea335bf4aa5 2025-10-30 03:15:40,649 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/f39a737c-5e0e-4a12-8fae-3546af0a979e 2025-10-30 03:15:40,657 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/f39a737c-5e0e-4a12-8fae-3546af0a979e 2025-10-30 03:15:40,663 - DEBUG - Requesting: http://10.0.0.242:8082/route-target/13308d70-96d2-4574-8487-820d4c39fcb0 2025-10-30 03:15:40,671 - DEBUG - Route Targets: ['target:64512:8000005'] 2025-10-30 03:15:40,671 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/c8fa7008-69e9-474c-98a4-dea335bf4aa5 2025-10-30 03:15:40,680 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/f39a737c-5e0e-4a12-8fae-3546af0a979e 2025-10-30 03:15:40,696 - INFO - Verified VN network id 14 for VN c8fa7008-69e9-474c-98a4-dea335bf4aa5 2025-10-30 03:15:40,696 - INFO - Verifications in API Server for VN ctest-left_vn-94574668 passed 2025-10-30 03:15:40,696 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/c8fa7008-69e9-474c-98a4-dea335bf4aa5 2025-10-30 03:15:40,706 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/f39a737c-5e0e-4a12-8fae-3546af0a979e 2025-10-30 03:15:40,714 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/f39a737c-5e0e-4a12-8fae-3546af0a979e 2025-10-30 03:15:40,721 - DEBUG - Requesting: http://10.0.0.242:8082/route-target/13308d70-96d2-4574-8487-820d4c39fcb0 2025-10-30 03:15:40,733 - DEBUG - Control-node 10.0.0.242 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-20871179:ctest-left_vn-94574668', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-20871179', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '14482010733202196300', 'uuid-lslong': '10999160982508358309'}, 'enable': 'true', 'created': '2025-10-30T03:15:40', 'last-modified': '2025-10-30T03:15:40', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.425902'} 2025-10-30 03:15:40,739 - DEBUG - Route Targets: ['target:64512:8000005'] 2025-10-30 03:15:40,744 - DEBUG - Control-node 10.0.0.254 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-20871179:ctest-left_vn-94574668', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-20871179', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '14482010733202196300', 'uuid-lslong': '10999160982508358309'}, 'enable': 'true', 'created': '2025-10-30T03:15:40', 'last-modified': '2025-10-30T03:15:40', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.447433'} 2025-10-30 03:15:40,749 - DEBUG - Route Targets: ['target:64512:8000005'] 2025-10-30 03:15:40,754 - DEBUG - Control-node 10.0.0.240 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-20871179:ctest-left_vn-94574668', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-20871179', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '14482010733202196300', 'uuid-lslong': '10999160982508358309'}, 'enable': 'true', 'created': '2025-10-30T03:15:40', 'last-modified': '2025-10-30T03:15:40', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.448629'} 2025-10-30 03:15:40,760 - DEBUG - Route Targets: ['target:64512:8000005'] 2025-10-30 03:15:40,760 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-94574668 passed 2025-10-30 03:15:40,760 - DEBUG - ====Verifying policy data for ctest-left_vn-94574668 in API_Server ====== 2025-10-30 03:15:40,760 - DEBUG - Requesting: http://10.0.0.242:8082/domains 2025-10-30 03:15:40,768 - DEBUG - Requesting: http://10.0.0.242:8082/domain/2be6ea5e-665d-4a78-a8ec-f940f567f06f 2025-10-30 03:15:40,779 - DEBUG - Requesting: http://10.0.0.242:8082/project/2ee20ab4-67d9-42ce-9bba-66f37d99df39 2025-10-30 03:15:40,869 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/c8fa7008-69e9-474c-98a4-dea335bf4aa5 2025-10-30 03:15:40,877 - DEBUG - =>VN ctest-left_vn-94574668 has no policy to be verified 2025-10-30 03:15:40,878 - DEBUG - Verifying the vn in opserver 2025-10-30 03:15:40,878 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-20871179:ctest-left_vn-94574668 virtual network link through opserver 10.0.0.242 2025-10-30 03:15:40,878 - DEBUG - Requesting: http://10.0.0.242:8081/analytics/uves/virtual-networks 2025-10-30 03:15:40,935 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-20871179:ctest-left_vn-94574668', 'href': 'http://10.0.0.242:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-20871179:ctest-left_vn-94574668?flat'} 2025-10-30 03:15:40,935 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-20871179:ctest-left_vn-94574668 virtual network link through opserver 10.0.0.254 2025-10-30 03:15:40,935 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-networks 2025-10-30 03:15:40,991 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-20871179:ctest-left_vn-94574668', 'href': 'http://10.0.0.254:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-20871179:ctest-left_vn-94574668?flat'} 2025-10-30 03:15:40,991 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-20871179:ctest-left_vn-94574668 virtual network link through opserver 10.0.0.240 2025-10-30 03:15:40,991 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/virtual-networks 2025-10-30 03:15:41,048 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-20871179:ctest-left_vn-94574668', 'href': 'http://10.0.0.240:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-20871179:ctest-left_vn-94574668?flat'} 2025-10-30 03:15:41,048 - INFO - Validated that VN default-domain:ctest-TestSvcHC-20871179:ctest-left_vn-94574668 is found in opserver 2025-10-30 03:15:41,071 - DEBUG - Do not have enough data to verify VN in agent 2025-10-30 03:15:41,081 - DEBUG - VRF ids for VN ctest-left_vn-94574668: {} 2025-10-30 03:15:41,387 - DEBUG - Response for create_network : {'network': {'id': 'b2e8f0e7-6cb0-4dfb-8b89-c4562151ee21', 'name': 'ctest-right_vn-37925614', 'tenant_id': '2ee20ab467d942ce9bba66f37d99df39', 'project_id': '2ee20ab467d942ce9bba66f37d99df39', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-20871179', 'ctest-right_vn-37925614'], 'port_security_enabled': True, 'description': ''}} 2025-10-30 03:15:41,648 - DEBUG - Response for create_subnet : {'subnet': {'id': 'c4153424-c27d-479e-97da-8f6013997026', 'name': '', 'tenant_id': '2ee20ab467d942ce9bba66f37d99df39', 'network_id': 'b2e8f0e7-6cb0-4dfb-8b89-c4562151ee21', 'ip_version': 4, 'cidr': '200.172.66.64/26', 'allocation_pools': [{'start': '200.172.66.66', 'end': '200.172.66.126'}], 'gateway_ip': '200.172.66.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '200.172.66.66', 'tags': [], 'project_id': '2ee20ab467d942ce9bba66f37d99df39'}} 2025-10-30 03:15:41,674 - INFO - Created VN ctest-right_vn-37925614 2025-10-30 03:15:41,703 - DEBUG - VN ctest-right_vn-37925614 UUID is b2e8f0e7-6cb0-4dfb-8b89-c4562151ee21 2025-10-30 03:15:41,787 - DEBUG - Requesting: http://10.0.0.242:8082/domains 2025-10-30 03:15:41,796 - DEBUG - Requesting: http://10.0.0.242:8082/domain/2be6ea5e-665d-4a78-a8ec-f940f567f06f 2025-10-30 03:15:41,807 - DEBUG - Requesting: http://10.0.0.242:8082/project/2ee20ab4-67d9-42ce-9bba-66f37d99df39 2025-10-30 03:15:41,919 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/b2e8f0e7-6cb0-4dfb-8b89-c4562151ee21 2025-10-30 03:15:41,932 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/b2e8f0e7-6cb0-4dfb-8b89-c4562151ee21 2025-10-30 03:15:41,950 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/374d5c8b-918b-497b-b6ec-14217dd4cb09 2025-10-30 03:15:41,960 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/374d5c8b-918b-497b-b6ec-14217dd4cb09 2025-10-30 03:15:41,967 - DEBUG - Requesting: http://10.0.0.242:8082/route-target/abd59cf6-ed33-4fce-a544-80cf6d06bc60 2025-10-30 03:15:41,976 - DEBUG - Route Targets: ['target:64512:8000006'] 2025-10-30 03:15:41,976 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/b2e8f0e7-6cb0-4dfb-8b89-c4562151ee21 2025-10-30 03:15:41,988 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/374d5c8b-918b-497b-b6ec-14217dd4cb09 2025-10-30 03:15:42,014 - INFO - Verified VN network id 15 for VN b2e8f0e7-6cb0-4dfb-8b89-c4562151ee21 2025-10-30 03:15:42,014 - INFO - Verifications in API Server for VN ctest-right_vn-37925614 passed 2025-10-30 03:15:42,014 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/b2e8f0e7-6cb0-4dfb-8b89-c4562151ee21 2025-10-30 03:15:42,031 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/374d5c8b-918b-497b-b6ec-14217dd4cb09 2025-10-30 03:15:42,044 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/374d5c8b-918b-497b-b6ec-14217dd4cb09 2025-10-30 03:15:42,056 - DEBUG - Requesting: http://10.0.0.242:8082/route-target/abd59cf6-ed33-4fce-a544-80cf6d06bc60 2025-10-30 03:15:42,075 - DEBUG - Control-node 10.0.0.242 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-20871179:ctest-right_vn-37925614', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-20871179', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12891818810099650043', 'uuid-lslong': '10054783517286592033'}, 'enable': 'true', 'created': '2025-10-30T03:15:41', 'last-modified': '2025-10-30T03:15:41', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.512532'} 2025-10-30 03:15:42,087 - DEBUG - Route Targets: ['target:64512:8000006'] 2025-10-30 03:15:42,094 - DEBUG - Control-node 10.0.0.254 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-20871179:ctest-right_vn-37925614', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-20871179', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12891818810099650043', 'uuid-lslong': '10054783517286592033'}, 'enable': 'true', 'created': '2025-10-30T03:15:41', 'last-modified': '2025-10-30T03:15:41', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.525456'} 2025-10-30 03:15:42,101 - DEBUG - Route Targets: ['target:64512:8000006'] 2025-10-30 03:15:42,106 - DEBUG - Control-node 10.0.0.240 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-20871179:ctest-right_vn-37925614', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-20871179', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12891818810099650043', 'uuid-lslong': '10054783517286592033'}, 'enable': 'true', 'created': '2025-10-30T03:15:41', 'last-modified': '2025-10-30T03:15:41', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.542671'} 2025-10-30 03:15:42,113 - DEBUG - Route Targets: ['target:64512:8000006'] 2025-10-30 03:15:42,113 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-37925614 passed 2025-10-30 03:15:42,113 - DEBUG - ====Verifying policy data for ctest-right_vn-37925614 in API_Server ====== 2025-10-30 03:15:42,113 - DEBUG - Requesting: http://10.0.0.242:8082/domains 2025-10-30 03:15:42,120 - DEBUG - Requesting: http://10.0.0.242:8082/domain/2be6ea5e-665d-4a78-a8ec-f940f567f06f 2025-10-30 03:15:42,133 - DEBUG - Requesting: http://10.0.0.242:8082/project/2ee20ab4-67d9-42ce-9bba-66f37d99df39 2025-10-30 03:15:42,225 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/b2e8f0e7-6cb0-4dfb-8b89-c4562151ee21 2025-10-30 03:15:42,236 - DEBUG - =>VN ctest-right_vn-37925614 has no policy to be verified 2025-10-30 03:15:42,236 - DEBUG - Verifying the vn in opserver 2025-10-30 03:15:42,236 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-20871179:ctest-right_vn-37925614 virtual network link through opserver 10.0.0.242 2025-10-30 03:15:42,236 - DEBUG - Requesting: http://10.0.0.242:8081/analytics/uves/virtual-networks 2025-10-30 03:15:42,292 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-20871179:ctest-right_vn-37925614', 'href': 'http://10.0.0.242:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-20871179:ctest-right_vn-37925614?flat'} 2025-10-30 03:15:42,292 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-20871179:ctest-right_vn-37925614 virtual network link through opserver 10.0.0.254 2025-10-30 03:15:42,292 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-networks 2025-10-30 03:15:42,362 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-20871179:ctest-right_vn-37925614', 'href': 'http://10.0.0.254:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-20871179:ctest-right_vn-37925614?flat'} 2025-10-30 03:15:42,362 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-20871179:ctest-right_vn-37925614 virtual network link through opserver 10.0.0.240 2025-10-30 03:15:42,362 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/virtual-networks 2025-10-30 03:15:42,433 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-20871179:ctest-right_vn-37925614', 'href': 'http://10.0.0.240:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-20871179:ctest-right_vn-37925614?flat'} 2025-10-30 03:15:42,433 - INFO - Validated that VN default-domain:ctest-TestSvcHC-20871179:ctest-right_vn-37925614 is found in opserver 2025-10-30 03:15:42,456 - DEBUG - Do not have enough data to verify VN in agent 2025-10-30 03:15:42,467 - DEBUG - VRF ids for VN ctest-right_vn-37925614: {} 2025-10-30 03:15:42,531 - DEBUG - Services list from nova: [, , , ] 2025-10-30 03:15:43,667 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4535-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4535-2) 2025-10-30 03:15:45,148 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4535-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4535-1) 2025-10-30 03:15:45,148 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-17904148'] 2025-10-30 03:15:45,464 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-17904148'] created succesfully 2025-10-30 03:15:45,880 - DEBUG - Image by name tiny_nat_fw not found 2025-10-30 03:15:45,880 - DEBUG - Installing image tiny_nat_fw 2025-10-30 03:15:45,880 - DEBUG - Image info {'name': 'tinycore-in-network-nat.qcow2.gz', 'webserver': '', 'location': '/images/tinycore/', 'username': 'tc', 'password': 'secret', 'type': 'os', 'flavor': 'contrail_flavor_tiny', 'params': '--container-format bare --disk-format vmdk --property vmware_disktype="sparse" --property vmware_adaptertype="ide" --property hypervisor_type=qemu', 'name_docker': 'phusion-baseimage-enablesshd', 'vmdk': 'service_chain_images/nat_service/tiny_nat_fw/tinycore-in-network-nat-flat.vmdk', 'shrinked_vmdk': "'no'"} 2025-10-30 03:15:45,880 - DEBUG - Image build path file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz 2025-10-30 03:15:45,881 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz 2025-10-30 03:15:45,881 - DEBUG - Unzip image 2025-10-30 03:15:45,881 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz 2025-10-30 03:15:45,909 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found 2025-10-30 03:15:45,910 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-17904148'] 2025-10-30 03:15:46,020 - INFO - Service template: ['default-domain', 'ctest-service_template_1-17904148'] deleted successfully. 2025-10-30 03:15:46,021 - INFO - Skip interface_detach for VM ctest-right_vm-73953925 in state BUILD 2025-10-30 03:15:46,021 - INFO - Deleting VM ctest-right_vm-73953925 2025-10-30 03:15:46,053 - ERROR - VM ctest-right_vm-73953925 has failed to come up 2025-10-30 03:15:46,053 - ERROR - Nova failed to get host of the VM 2025-10-30 03:15:46,053 - ERROR - VM ctest-right_vm-73953925 has failed to come up 2025-10-30 03:15:46,053 - ERROR - Nova failed to get host of the VM 2025-10-30 03:15:46,166 - INFO - Skip interface_detach for VM ctest-left_vm-08258362 in state BUILD 2025-10-30 03:15:46,166 - INFO - Deleting VM ctest-left_vm-08258362 2025-10-30 03:15:46,166 - ERROR - VM ctest-left_vm-08258362 has failed to come up 2025-10-30 03:15:46,166 - ERROR - Nova failed to get host of the VM 2025-10-30 03:15:46,166 - ERROR - VM ctest-left_vm-08258362 has failed to come up 2025-10-30 03:15:46,166 - ERROR - Nova failed to get host of the VM 2025-10-30 03:15:46,244 - INFO - Deleting VN ctest-right_vn-37925614 2025-10-30 03:15:46,313 - DEBUG - VN b2e8f0e7-6cb0-4dfb-8b89-c4562151ee21 still in use: Unable to complete operation on network b2e8f0e7-6cb0-4dfb-8b89-c4562151ee21. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-6028da80-71f6-4898-8077-a1ad7f29dba2'] 2025-10-30 03:15:46,313 - WARNING - Deleting VN ctest-right_vn-37925614 failed..Will retry 2025-10-30 03:15:48,478 - DEBUG - Response for deleting network () 2025-10-30 03:15:48,478 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/374d5c8b-918b-497b-b6ec-14217dd4cb09 2025-10-30 03:15:48,485 - DEBUG - Response Code: 404 2025-10-30 03:15:48,485 - DEBUG - Requesting: http://10.0.0.242:8082/domains 2025-10-30 03:15:48,494 - DEBUG - Requesting: http://10.0.0.242:8082/domain/2be6ea5e-665d-4a78-a8ec-f940f567f06f 2025-10-30 03:15:48,517 - DEBUG - Requesting: http://10.0.0.242:8082/project/2ee20ab4-67d9-42ce-9bba-66f37d99df39 2025-10-30 03:15:48,616 - INFO - Validated that VN ctest-right_vn-37925614 is not found in API Server 2025-10-30 03:15:48,628 - DEBUG - VN ctest-right_vn-37925614 is not present in Agent 10.0.0.129 2025-10-30 03:15:48,640 - DEBUG - VN ctest-right_vn-37925614 is not present in Agent 10.0.0.65 2025-10-30 03:15:48,640 - INFO - Validated that VN ctest-right_vn-37925614 is not in any agent 2025-10-30 03:15:48,673 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-37925614 info 2025-10-30 03:15:48,673 - INFO - Deleting VN ctest-left_vn-94574668 2025-10-30 03:15:48,848 - DEBUG - Response for deleting network () 2025-10-30 03:15:48,848 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/f39a737c-5e0e-4a12-8fae-3546af0a979e 2025-10-30 03:15:48,854 - DEBUG - Response Code: 404 2025-10-30 03:15:48,854 - DEBUG - Requesting: http://10.0.0.242:8082/domains 2025-10-30 03:15:48,863 - DEBUG - Requesting: http://10.0.0.242:8082/domain/2be6ea5e-665d-4a78-a8ec-f940f567f06f 2025-10-30 03:15:48,877 - DEBUG - Requesting: http://10.0.0.242:8082/project/2ee20ab4-67d9-42ce-9bba-66f37d99df39 2025-10-30 03:15:48,972 - INFO - Validated that VN ctest-left_vn-94574668 is not found in API Server 2025-10-30 03:15:48,983 - DEBUG - VN ctest-left_vn-94574668 is not present in Agent 10.0.0.129 2025-10-30 03:15:48,994 - DEBUG - VN ctest-left_vn-94574668 is not present in Agent 10.0.0.65 2025-10-30 03:15:48,994 - INFO - Validated that VN ctest-left_vn-94574668 is not in any agent 2025-10-30 03:15:49,032 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-94574668 info 2025-10-30 03:15:49,032 - INFO - Deleting VN ctest-mgmt_vn-58756841 2025-10-30 03:15:49,171 - DEBUG - Response for deleting network () 2025-10-30 03:15:49,171 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/cb332105-c1f8-4734-803b-8c8933737e55 2025-10-30 03:15:49,176 - DEBUG - Response Code: 404 2025-10-30 03:15:49,177 - DEBUG - Requesting: http://10.0.0.242:8082/domains 2025-10-30 03:15:49,182 - DEBUG - Requesting: http://10.0.0.242:8082/domain/2be6ea5e-665d-4a78-a8ec-f940f567f06f 2025-10-30 03:15:49,239 - DEBUG - Requesting: http://10.0.0.242:8082/project/2ee20ab4-67d9-42ce-9bba-66f37d99df39 2025-10-30 03:15:49,342 - INFO - Validated that VN ctest-mgmt_vn-58756841 is not found in API Server 2025-10-30 03:15:49,353 - DEBUG - VN ctest-mgmt_vn-58756841 is not present in Agent 10.0.0.129 2025-10-30 03:15:49,362 - DEBUG - VN ctest-mgmt_vn-58756841 is not present in Agent 10.0.0.65 2025-10-30 03:15:49,362 - INFO - Validated that VN ctest-mgmt_vn-58756841 is not in any agent 2025-10-30 03:15:49,397 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-58756841 info 2025-10-30 03:15:50,679 - DEBUG - No XMPP flaps were noticed during the test 2025-10-30 03:15:50,679 - INFO -

2025-10-30 03:15:50,679 - INFO - END TEST : test_svc_hc_basic : SKIPPED[0:00:15]

2025-10-30 03:15:50,679 - INFO - -------------------------------------------------------------------------------- 2025-10-30 03:15:50,682 - INFO - ================================================================================ 2025-10-30 03:15:50,682 - INFO - STARTING TEST : test_svc_trans_segment_right_hc_fail_svm 2025-10-30 03:15:51,945 - DEBUG - Nothing to compare xmpp stats {'10.0.0.129': {'10.20.0.131': '0', '10.20.0.254': '0'}, '10.0.0.65': {'10.20.0.254': '0', '10.20.0.131': '0'}} with 2025-10-30 03:15:51,945 - INFO - Initial checks done. Running the testcase now 2025-10-30 03:15:51,945 - INFO - 2025-10-30 03:15:52,246 - DEBUG - Response for create_network : {'network': {'id': '4d00fc75-31b6-417c-bf42-0c64221b1149', 'name': 'ctest-mgmt_vn-18492125', 'tenant_id': '2ee20ab467d942ce9bba66f37d99df39', 'project_id': '2ee20ab467d942ce9bba66f37d99df39', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-20871179', 'ctest-mgmt_vn-18492125'], 'port_security_enabled': True, 'description': ''}} 2025-10-30 03:15:52,519 - DEBUG - Response for create_subnet : {'subnet': {'id': '50d0ffd2-fc4c-4d7a-bf9b-58a651f7a0b5', 'name': '', 'tenant_id': '2ee20ab467d942ce9bba66f37d99df39', 'network_id': '4d00fc75-31b6-417c-bf42-0c64221b1149', 'ip_version': 4, 'cidr': '87.138.115.0/26', 'allocation_pools': [{'start': '87.138.115.2', 'end': '87.138.115.62'}], 'gateway_ip': '87.138.115.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '87.138.115.2', 'tags': [], 'project_id': '2ee20ab467d942ce9bba66f37d99df39'}} 2025-10-30 03:15:52,542 - INFO - Created VN ctest-mgmt_vn-18492125 2025-10-30 03:15:52,559 - DEBUG - VN ctest-mgmt_vn-18492125 UUID is 4d00fc75-31b6-417c-bf42-0c64221b1149 2025-10-30 03:15:52,632 - DEBUG - Requesting: http://10.0.0.242:8082/domains 2025-10-30 03:15:52,638 - DEBUG - Requesting: http://10.0.0.242:8082/domain/2be6ea5e-665d-4a78-a8ec-f940f567f06f 2025-10-30 03:15:52,648 - DEBUG - Requesting: http://10.0.0.242:8082/project/2ee20ab4-67d9-42ce-9bba-66f37d99df39 2025-10-30 03:15:52,741 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/4d00fc75-31b6-417c-bf42-0c64221b1149 2025-10-30 03:15:52,751 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/4d00fc75-31b6-417c-bf42-0c64221b1149 2025-10-30 03:15:52,766 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/2a633113-4ffe-4fc8-a3e5-2420afdc5301 2025-10-30 03:15:52,773 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/2a633113-4ffe-4fc8-a3e5-2420afdc5301 2025-10-30 03:15:52,779 - DEBUG - Requesting: http://10.0.0.242:8082/route-target/e62a6ded-00d4-490a-9024-c15e5c9e6bc0 2025-10-30 03:15:52,786 - DEBUG - Route Targets: ['target:64512:8000004'] 2025-10-30 03:15:52,786 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/4d00fc75-31b6-417c-bf42-0c64221b1149 2025-10-30 03:15:52,796 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/2a633113-4ffe-4fc8-a3e5-2420afdc5301 2025-10-30 03:15:52,813 - INFO - Verified VN network id 13 for VN 4d00fc75-31b6-417c-bf42-0c64221b1149 2025-10-30 03:15:52,813 - INFO - Verifications in API Server for VN ctest-mgmt_vn-18492125 passed 2025-10-30 03:15:52,813 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/4d00fc75-31b6-417c-bf42-0c64221b1149 2025-10-30 03:15:52,824 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/2a633113-4ffe-4fc8-a3e5-2420afdc5301 2025-10-30 03:15:52,832 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/2a633113-4ffe-4fc8-a3e5-2420afdc5301 2025-10-30 03:15:52,840 - DEBUG - Requesting: http://10.0.0.242:8082/route-target/e62a6ded-00d4-490a-9024-c15e5c9e6bc0 2025-10-30 03:15:52,853 - DEBUG - Control-node 10.0.0.242 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-20871179:ctest-mgmt_vn-18492125', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-20871179', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5548712321195852156', 'uuid-lslong': '13781591433915601225'}, 'enable': 'true', 'created': '2025-10-30T03:15:52', 'last-modified': '2025-10-30T03:15:52', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.386357'} 2025-10-30 03:15:52,858 - DEBUG - Route Targets: ['target:64512:8000004'] 2025-10-30 03:15:52,863 - DEBUG - Control-node 10.0.0.254 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-20871179:ctest-mgmt_vn-18492125', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-20871179', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5548712321195852156', 'uuid-lslong': '13781591433915601225'}, 'enable': 'true', 'created': '2025-10-30T03:15:52', 'last-modified': '2025-10-30T03:15:52', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.396824'} 2025-10-30 03:15:52,871 - DEBUG - Route Targets: ['target:64512:8000004'] 2025-10-30 03:15:52,877 - DEBUG - Control-node 10.0.0.240 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-20871179:ctest-mgmt_vn-18492125', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-20871179', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5548712321195852156', 'uuid-lslong': '13781591433915601225'}, 'enable': 'true', 'created': '2025-10-30T03:15:52', 'last-modified': '2025-10-30T03:15:52', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.410800'} 2025-10-30 03:15:52,883 - DEBUG - Route Targets: ['target:64512:8000004'] 2025-10-30 03:15:52,883 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-18492125 passed 2025-10-30 03:15:52,883 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-18492125 in API_Server ====== 2025-10-30 03:15:52,883 - DEBUG - Requesting: http://10.0.0.242:8082/domains 2025-10-30 03:15:52,890 - DEBUG - Requesting: http://10.0.0.242:8082/domain/2be6ea5e-665d-4a78-a8ec-f940f567f06f 2025-10-30 03:15:52,900 - DEBUG - Requesting: http://10.0.0.242:8082/project/2ee20ab4-67d9-42ce-9bba-66f37d99df39 2025-10-30 03:15:52,992 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/4d00fc75-31b6-417c-bf42-0c64221b1149 2025-10-30 03:15:53,005 - DEBUG - =>VN ctest-mgmt_vn-18492125 has no policy to be verified 2025-10-30 03:15:53,005 - DEBUG - Verifying the vn in opserver 2025-10-30 03:15:53,005 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-20871179:ctest-mgmt_vn-18492125 virtual network link through opserver 10.0.0.242 2025-10-30 03:15:53,005 - DEBUG - Requesting: http://10.0.0.242:8081/analytics/uves/virtual-networks 2025-10-30 03:15:53,020 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-20871179:ctest-mgmt_vn-18492125', 'href': 'http://10.0.0.242:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-20871179:ctest-mgmt_vn-18492125?flat'} 2025-10-30 03:15:53,020 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-20871179:ctest-mgmt_vn-18492125 virtual network link through opserver 10.0.0.254 2025-10-30 03:15:53,020 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-networks 2025-10-30 03:15:53,032 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-20871179:ctest-mgmt_vn-18492125', 'href': 'http://10.0.0.254:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-20871179:ctest-mgmt_vn-18492125?flat'} 2025-10-30 03:15:53,032 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-20871179:ctest-mgmt_vn-18492125 virtual network link through opserver 10.0.0.240 2025-10-30 03:15:53,033 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/virtual-networks 2025-10-30 03:15:53,048 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-20871179:ctest-mgmt_vn-18492125', 'href': 'http://10.0.0.240:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-20871179:ctest-mgmt_vn-18492125?flat'} 2025-10-30 03:15:53,048 - INFO - Validated that VN default-domain:ctest-TestSvcHC-20871179:ctest-mgmt_vn-18492125 is found in opserver 2025-10-30 03:15:53,073 - DEBUG - Do not have enough data to verify VN in agent 2025-10-30 03:15:53,085 - DEBUG - VRF ids for VN ctest-mgmt_vn-18492125: {} 2025-10-30 03:15:53,363 - DEBUG - Response for create_network : {'network': {'id': '3da76bdc-1d7b-4635-8ed1-81ae7a141360', 'name': 'ctest-left_vn-60664428', 'tenant_id': '2ee20ab467d942ce9bba66f37d99df39', 'project_id': '2ee20ab467d942ce9bba66f37d99df39', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-20871179', 'ctest-left_vn-60664428'], 'port_security_enabled': True, 'description': ''}} 2025-10-30 03:15:53,627 - DEBUG - Response for create_subnet : {'subnet': {'id': '7cfb7c37-7ce3-42c9-a766-a1b77cf5490b', 'name': '', 'tenant_id': '2ee20ab467d942ce9bba66f37d99df39', 'network_id': '3da76bdc-1d7b-4635-8ed1-81ae7a141360', 'ip_version': 4, 'cidr': '14.61.253.128/26', 'allocation_pools': [{'start': '14.61.253.130', 'end': '14.61.253.190'}], 'gateway_ip': '14.61.253.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '14.61.253.130', 'tags': [], 'project_id': '2ee20ab467d942ce9bba66f37d99df39'}} 2025-10-30 03:15:53,651 - INFO - Created VN ctest-left_vn-60664428 2025-10-30 03:15:53,664 - DEBUG - VN ctest-left_vn-60664428 UUID is 3da76bdc-1d7b-4635-8ed1-81ae7a141360 2025-10-30 03:15:53,736 - DEBUG - Requesting: http://10.0.0.242:8082/domains 2025-10-30 03:15:53,744 - DEBUG - Requesting: http://10.0.0.242:8082/domain/2be6ea5e-665d-4a78-a8ec-f940f567f06f 2025-10-30 03:15:53,755 - DEBUG - Requesting: http://10.0.0.242:8082/project/2ee20ab4-67d9-42ce-9bba-66f37d99df39 2025-10-30 03:15:53,845 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/3da76bdc-1d7b-4635-8ed1-81ae7a141360 2025-10-30 03:15:53,858 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/3da76bdc-1d7b-4635-8ed1-81ae7a141360 2025-10-30 03:15:53,872 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/0ab0adbf-06ee-4a0e-b9de-93caa2ccc6ab 2025-10-30 03:15:53,880 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/0ab0adbf-06ee-4a0e-b9de-93caa2ccc6ab 2025-10-30 03:15:53,888 - DEBUG - Requesting: http://10.0.0.242:8082/route-target/bc9853df-c2d8-440c-ae90-a7ef01642e61 2025-10-30 03:15:53,896 - DEBUG - Route Targets: ['target:64512:8000005'] 2025-10-30 03:15:53,896 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/3da76bdc-1d7b-4635-8ed1-81ae7a141360 2025-10-30 03:15:53,906 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/0ab0adbf-06ee-4a0e-b9de-93caa2ccc6ab 2025-10-30 03:15:53,924 - INFO - Verified VN network id 14 for VN 3da76bdc-1d7b-4635-8ed1-81ae7a141360 2025-10-30 03:15:53,925 - INFO - Verifications in API Server for VN ctest-left_vn-60664428 passed 2025-10-30 03:15:53,925 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/3da76bdc-1d7b-4635-8ed1-81ae7a141360 2025-10-30 03:15:53,936 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/0ab0adbf-06ee-4a0e-b9de-93caa2ccc6ab 2025-10-30 03:15:53,945 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/0ab0adbf-06ee-4a0e-b9de-93caa2ccc6ab 2025-10-30 03:15:53,954 - DEBUG - Requesting: http://10.0.0.242:8082/route-target/bc9853df-c2d8-440c-ae90-a7ef01642e61 2025-10-30 03:15:53,966 - DEBUG - Control-node 10.0.0.242 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-20871179:ctest-left_vn-60664428', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-20871179', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4442638150555878965', 'uuid-lslong': '10291149209890722656'}, 'enable': 'true', 'created': '2025-10-30T03:15:53', 'last-modified': '2025-10-30T03:15:53', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.411350'} 2025-10-30 03:15:53,972 - DEBUG - Route Targets: ['target:64512:8000005'] 2025-10-30 03:15:53,978 - DEBUG - Control-node 10.0.0.254 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-20871179:ctest-left_vn-60664428', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-20871179', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4442638150555878965', 'uuid-lslong': '10291149209890722656'}, 'enable': 'true', 'created': '2025-10-30T03:15:53', 'last-modified': '2025-10-30T03:15:53', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.423788'} 2025-10-30 03:15:53,985 - DEBUG - Route Targets: ['target:64512:8000005'] 2025-10-30 03:15:53,991 - DEBUG - Control-node 10.0.0.240 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-20871179:ctest-left_vn-60664428', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-20871179', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4442638150555878965', 'uuid-lslong': '10291149209890722656'}, 'enable': 'true', 'created': '2025-10-30T03:15:53', 'last-modified': '2025-10-30T03:15:53', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.431251'} 2025-10-30 03:15:53,997 - DEBUG - Route Targets: ['target:64512:8000005'] 2025-10-30 03:15:53,997 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-60664428 passed 2025-10-30 03:15:53,997 - DEBUG - ====Verifying policy data for ctest-left_vn-60664428 in API_Server ====== 2025-10-30 03:15:53,997 - DEBUG - Requesting: http://10.0.0.242:8082/domains 2025-10-30 03:15:54,004 - DEBUG - Requesting: http://10.0.0.242:8082/domain/2be6ea5e-665d-4a78-a8ec-f940f567f06f 2025-10-30 03:15:54,015 - DEBUG - Requesting: http://10.0.0.242:8082/project/2ee20ab4-67d9-42ce-9bba-66f37d99df39 2025-10-30 03:15:54,108 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/3da76bdc-1d7b-4635-8ed1-81ae7a141360 2025-10-30 03:15:54,118 - DEBUG - =>VN ctest-left_vn-60664428 has no policy to be verified 2025-10-30 03:15:54,118 - DEBUG - Verifying the vn in opserver 2025-10-30 03:15:54,118 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-20871179:ctest-left_vn-60664428 virtual network link through opserver 10.0.0.242 2025-10-30 03:15:54,118 - DEBUG - Requesting: http://10.0.0.242:8081/analytics/uves/virtual-networks 2025-10-30 03:15:54,131 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-20871179:ctest-left_vn-60664428', 'href': 'http://10.0.0.242:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-20871179:ctest-left_vn-60664428?flat'} 2025-10-30 03:15:54,131 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-20871179:ctest-left_vn-60664428 virtual network link through opserver 10.0.0.254 2025-10-30 03:15:54,131 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-networks 2025-10-30 03:15:54,145 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-20871179:ctest-left_vn-60664428', 'href': 'http://10.0.0.254:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-20871179:ctest-left_vn-60664428?flat'} 2025-10-30 03:15:54,145 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-20871179:ctest-left_vn-60664428 virtual network link through opserver 10.0.0.240 2025-10-30 03:15:54,145 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/virtual-networks 2025-10-30 03:15:54,157 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-20871179:ctest-left_vn-60664428', 'href': 'http://10.0.0.240:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-20871179:ctest-left_vn-60664428?flat'} 2025-10-30 03:15:54,157 - INFO - Validated that VN default-domain:ctest-TestSvcHC-20871179:ctest-left_vn-60664428 is found in opserver 2025-10-30 03:15:54,179 - DEBUG - Do not have enough data to verify VN in agent 2025-10-30 03:15:54,189 - DEBUG - VRF ids for VN ctest-left_vn-60664428: {} 2025-10-30 03:15:54,435 - DEBUG - Response for create_network : {'network': {'id': 'c4432a47-0363-47b7-9722-1ae72161f2d0', 'name': 'ctest-right_vn-07557643', 'tenant_id': '2ee20ab467d942ce9bba66f37d99df39', 'project_id': '2ee20ab467d942ce9bba66f37d99df39', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-20871179', 'ctest-right_vn-07557643'], 'port_security_enabled': True, 'description': ''}} 2025-10-30 03:15:54,652 - DEBUG - Response for create_subnet : {'subnet': {'id': '4fcdf4fa-9963-4dc2-a94e-6d89b2f509fa', 'name': '', 'tenant_id': '2ee20ab467d942ce9bba66f37d99df39', 'network_id': 'c4432a47-0363-47b7-9722-1ae72161f2d0', 'ip_version': 4, 'cidr': '104.169.241.128/26', 'allocation_pools': [{'start': '104.169.241.130', 'end': '104.169.241.190'}], 'gateway_ip': '104.169.241.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '104.169.241.130', 'tags': [], 'project_id': '2ee20ab467d942ce9bba66f37d99df39'}} 2025-10-30 03:15:54,673 - INFO - Created VN ctest-right_vn-07557643 2025-10-30 03:15:54,687 - DEBUG - VN ctest-right_vn-07557643 UUID is c4432a47-0363-47b7-9722-1ae72161f2d0 2025-10-30 03:15:54,763 - DEBUG - Requesting: http://10.0.0.242:8082/domains 2025-10-30 03:15:54,770 - DEBUG - Requesting: http://10.0.0.242:8082/domain/2be6ea5e-665d-4a78-a8ec-f940f567f06f 2025-10-30 03:15:54,781 - DEBUG - Requesting: http://10.0.0.242:8082/project/2ee20ab4-67d9-42ce-9bba-66f37d99df39 2025-10-30 03:15:54,870 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/c4432a47-0363-47b7-9722-1ae72161f2d0 2025-10-30 03:15:54,884 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/c4432a47-0363-47b7-9722-1ae72161f2d0 2025-10-30 03:15:54,895 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/7a5cb7c4-0a7e-4185-a617-1089907148f3 2025-10-30 03:15:54,908 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/7a5cb7c4-0a7e-4185-a617-1089907148f3 2025-10-30 03:15:54,919 - DEBUG - Requesting: http://10.0.0.242:8082/route-target/79c90af6-fc84-4d7e-a772-09571eb41b34 2025-10-30 03:15:54,928 - DEBUG - Route Targets: ['target:64512:8000006'] 2025-10-30 03:15:54,928 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/c4432a47-0363-47b7-9722-1ae72161f2d0 2025-10-30 03:15:54,943 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/7a5cb7c4-0a7e-4185-a617-1089907148f3 2025-10-30 03:15:54,961 - INFO - Verified VN network id 15 for VN c4432a47-0363-47b7-9722-1ae72161f2d0 2025-10-30 03:15:54,961 - INFO - Verifications in API Server for VN ctest-right_vn-07557643 passed 2025-10-30 03:15:54,961 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/c4432a47-0363-47b7-9722-1ae72161f2d0 2025-10-30 03:15:54,975 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/7a5cb7c4-0a7e-4185-a617-1089907148f3 2025-10-30 03:15:54,984 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/7a5cb7c4-0a7e-4185-a617-1089907148f3 2025-10-30 03:15:54,991 - DEBUG - Requesting: http://10.0.0.242:8082/route-target/79c90af6-fc84-4d7e-a772-09571eb41b34 2025-10-30 03:15:55,002 - DEBUG - Control-node 10.0.0.242 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-20871179:ctest-right_vn-07557643', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-20871179', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '14142193739361372087', 'uuid-lslong': '10890296428935115472'}, 'enable': 'true', 'created': '2025-10-30T03:15:54', 'last-modified': '2025-10-30T03:15:54', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.399142'} 2025-10-30 03:15:55,010 - DEBUG - Route Targets: ['target:64512:8000006'] 2025-10-30 03:15:55,016 - DEBUG - Control-node 10.0.0.254 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-20871179:ctest-right_vn-07557643', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-20871179', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '14142193739361372087', 'uuid-lslong': '10890296428935115472'}, 'enable': 'true', 'created': '2025-10-30T03:15:54', 'last-modified': '2025-10-30T03:15:54', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.417511'} 2025-10-30 03:15:55,021 - DEBUG - Route Targets: ['target:64512:8000006'] 2025-10-30 03:15:55,028 - DEBUG - Control-node 10.0.0.240 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-20871179:ctest-right_vn-07557643', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-20871179', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '14142193739361372087', 'uuid-lslong': '10890296428935115472'}, 'enable': 'true', 'created': '2025-10-30T03:15:54', 'last-modified': '2025-10-30T03:15:54', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.430018'} 2025-10-30 03:15:55,035 - DEBUG - Route Targets: ['target:64512:8000006'] 2025-10-30 03:15:55,035 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-07557643 passed 2025-10-30 03:15:55,036 - DEBUG - ====Verifying policy data for ctest-right_vn-07557643 in API_Server ====== 2025-10-30 03:15:55,036 - DEBUG - Requesting: http://10.0.0.242:8082/domains 2025-10-30 03:15:55,042 - DEBUG - Requesting: http://10.0.0.242:8082/domain/2be6ea5e-665d-4a78-a8ec-f940f567f06f 2025-10-30 03:15:55,054 - DEBUG - Requesting: http://10.0.0.242:8082/project/2ee20ab4-67d9-42ce-9bba-66f37d99df39 2025-10-30 03:15:55,146 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/c4432a47-0363-47b7-9722-1ae72161f2d0 2025-10-30 03:15:55,160 - DEBUG - =>VN ctest-right_vn-07557643 has no policy to be verified 2025-10-30 03:15:55,160 - DEBUG - Verifying the vn in opserver 2025-10-30 03:15:55,160 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-20871179:ctest-right_vn-07557643 virtual network link through opserver 10.0.0.242 2025-10-30 03:15:55,160 - DEBUG - Requesting: http://10.0.0.242:8081/analytics/uves/virtual-networks 2025-10-30 03:15:55,173 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-20871179:ctest-right_vn-07557643', 'href': 'http://10.0.0.242:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-20871179:ctest-right_vn-07557643?flat'} 2025-10-30 03:15:55,173 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-20871179:ctest-right_vn-07557643 virtual network link through opserver 10.0.0.254 2025-10-30 03:15:55,173 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-networks 2025-10-30 03:15:55,187 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-20871179:ctest-right_vn-07557643', 'href': 'http://10.0.0.254:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-20871179:ctest-right_vn-07557643?flat'} 2025-10-30 03:15:55,187 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-20871179:ctest-right_vn-07557643 virtual network link through opserver 10.0.0.240 2025-10-30 03:15:55,187 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/virtual-networks 2025-10-30 03:15:55,200 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-20871179:ctest-right_vn-07557643', 'href': 'http://10.0.0.240:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-20871179:ctest-right_vn-07557643?flat'} 2025-10-30 03:15:55,200 - INFO - Validated that VN default-domain:ctest-TestSvcHC-20871179:ctest-right_vn-07557643 is found in opserver 2025-10-30 03:15:55,221 - DEBUG - Do not have enough data to verify VN in agent 2025-10-30 03:15:55,230 - DEBUG - VRF ids for VN ctest-right_vn-07557643: {} 2025-10-30 03:15:55,538 - DEBUG - Response for create_network : {'network': {'id': '770459e3-871b-4ff3-ac91-4f62cae677d8', 'name': 'ctest-trans_left_vn-73457458', 'tenant_id': '2ee20ab467d942ce9bba66f37d99df39', 'project_id': '2ee20ab467d942ce9bba66f37d99df39', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-20871179', 'ctest-trans_left_vn-73457458'], 'port_security_enabled': True, 'description': ''}} 2025-10-30 03:15:55,767 - DEBUG - Response for create_subnet : {'subnet': {'id': 'e9b5c49c-3710-474a-9209-f7e91da537f4', 'name': '', 'tenant_id': '2ee20ab467d942ce9bba66f37d99df39', 'network_id': '770459e3-871b-4ff3-ac91-4f62cae677d8', 'ip_version': 4, 'cidr': '7.128.100.0/26', 'allocation_pools': [{'start': '7.128.100.2', 'end': '7.128.100.62'}], 'gateway_ip': '7.128.100.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '7.128.100.2', 'tags': [], 'project_id': '2ee20ab467d942ce9bba66f37d99df39'}} 2025-10-30 03:15:55,792 - INFO - Created VN ctest-trans_left_vn-73457458 2025-10-30 03:15:55,809 - DEBUG - VN ctest-trans_left_vn-73457458 UUID is 770459e3-871b-4ff3-ac91-4f62cae677d8 2025-10-30 03:15:55,890 - DEBUG - Requesting: http://10.0.0.242:8082/domains 2025-10-30 03:15:55,897 - DEBUG - Requesting: http://10.0.0.242:8082/domain/2be6ea5e-665d-4a78-a8ec-f940f567f06f 2025-10-30 03:15:55,910 - DEBUG - Requesting: http://10.0.0.242:8082/project/2ee20ab4-67d9-42ce-9bba-66f37d99df39 2025-10-30 03:15:56,001 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/770459e3-871b-4ff3-ac91-4f62cae677d8 2025-10-30 03:15:56,020 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/770459e3-871b-4ff3-ac91-4f62cae677d8 2025-10-30 03:15:56,030 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/105b3fc5-3c55-476a-b493-3d34d2410c4e 2025-10-30 03:15:56,038 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/105b3fc5-3c55-476a-b493-3d34d2410c4e 2025-10-30 03:15:56,046 - DEBUG - Requesting: http://10.0.0.242:8082/route-target/1ef8924d-d6b9-4e12-a19e-2b44205f5a8e 2025-10-30 03:15:56,053 - DEBUG - Route Targets: ['target:64512:8000007'] 2025-10-30 03:15:56,053 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/770459e3-871b-4ff3-ac91-4f62cae677d8 2025-10-30 03:15:56,063 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/105b3fc5-3c55-476a-b493-3d34d2410c4e 2025-10-30 03:15:56,081 - INFO - Verified VN network id 16 for VN 770459e3-871b-4ff3-ac91-4f62cae677d8 2025-10-30 03:15:56,081 - INFO - Verifications in API Server for VN ctest-trans_left_vn-73457458 passed 2025-10-30 03:15:56,081 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/770459e3-871b-4ff3-ac91-4f62cae677d8 2025-10-30 03:15:56,093 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/105b3fc5-3c55-476a-b493-3d34d2410c4e 2025-10-30 03:15:56,103 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/105b3fc5-3c55-476a-b493-3d34d2410c4e 2025-10-30 03:15:56,111 - DEBUG - Requesting: http://10.0.0.242:8082/route-target/1ef8924d-d6b9-4e12-a19e-2b44205f5a8e 2025-10-30 03:15:56,124 - DEBUG - Control-node 10.0.0.242 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-20871179:ctest-trans_left_vn-73457458', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-20871179', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8576078424179429363', 'uuid-lslong': '12434807331876141016'}, 'enable': 'true', 'created': '2025-10-30T03:15:55', 'last-modified': '2025-10-30T03:15:55', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.408369'} 2025-10-30 03:15:56,130 - DEBUG - Route Targets: ['target:64512:8000007'] 2025-10-30 03:15:56,136 - DEBUG - Control-node 10.0.0.254 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-20871179:ctest-trans_left_vn-73457458', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-20871179', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8576078424179429363', 'uuid-lslong': '12434807331876141016'}, 'enable': 'true', 'created': '2025-10-30T03:15:55', 'last-modified': '2025-10-30T03:15:55', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.444554'} 2025-10-30 03:15:56,142 - DEBUG - Route Targets: ['target:64512:8000007'] 2025-10-30 03:15:56,147 - DEBUG - Control-node 10.0.0.240 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-20871179:ctest-trans_left_vn-73457458', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-20871179', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8576078424179429363', 'uuid-lslong': '12434807331876141016'}, 'enable': 'true', 'created': '2025-10-30T03:15:55', 'last-modified': '2025-10-30T03:15:55', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.458311'} 2025-10-30 03:15:56,154 - DEBUG - Route Targets: ['target:64512:8000007'] 2025-10-30 03:15:56,154 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_left_vn-73457458 passed 2025-10-30 03:15:56,155 - DEBUG - ====Verifying policy data for ctest-trans_left_vn-73457458 in API_Server ====== 2025-10-30 03:15:56,155 - DEBUG - Requesting: http://10.0.0.242:8082/domains 2025-10-30 03:15:56,161 - DEBUG - Requesting: http://10.0.0.242:8082/domain/2be6ea5e-665d-4a78-a8ec-f940f567f06f 2025-10-30 03:15:56,172 - DEBUG - Requesting: http://10.0.0.242:8082/project/2ee20ab4-67d9-42ce-9bba-66f37d99df39 2025-10-30 03:15:56,262 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/770459e3-871b-4ff3-ac91-4f62cae677d8 2025-10-30 03:15:56,273 - DEBUG - =>VN ctest-trans_left_vn-73457458 has no policy to be verified 2025-10-30 03:15:56,273 - DEBUG - Verifying the vn in opserver 2025-10-30 03:15:56,273 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-20871179:ctest-trans_left_vn-73457458 virtual network link through opserver 10.0.0.242 2025-10-30 03:15:56,274 - DEBUG - Requesting: http://10.0.0.242:8081/analytics/uves/virtual-networks 2025-10-30 03:15:56,286 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-20871179:ctest-trans_left_vn-73457458', 'href': 'http://10.0.0.242:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-20871179:ctest-trans_left_vn-73457458?flat'} 2025-10-30 03:15:56,286 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-20871179:ctest-trans_left_vn-73457458 virtual network link through opserver 10.0.0.254 2025-10-30 03:15:56,286 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-networks 2025-10-30 03:15:56,299 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-20871179:ctest-trans_left_vn-73457458', 'href': 'http://10.0.0.254:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-20871179:ctest-trans_left_vn-73457458?flat'} 2025-10-30 03:15:56,299 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-20871179:ctest-trans_left_vn-73457458 virtual network link through opserver 10.0.0.240 2025-10-30 03:15:56,300 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/virtual-networks 2025-10-30 03:15:56,314 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-20871179:ctest-trans_left_vn-73457458', 'href': 'http://10.0.0.240:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-20871179:ctest-trans_left_vn-73457458?flat'} 2025-10-30 03:15:56,314 - INFO - Validated that VN default-domain:ctest-TestSvcHC-20871179:ctest-trans_left_vn-73457458 is found in opserver 2025-10-30 03:15:56,336 - DEBUG - Do not have enough data to verify VN in agent 2025-10-30 03:15:56,345 - DEBUG - VRF ids for VN ctest-trans_left_vn-73457458: {} 2025-10-30 03:15:56,658 - DEBUG - Response for create_network : {'network': {'id': 'e1d1ae3e-2382-43a7-8197-6d9999392201', 'name': 'ctest-trans_right_vn-48330847', 'tenant_id': '2ee20ab467d942ce9bba66f37d99df39', 'project_id': '2ee20ab467d942ce9bba66f37d99df39', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-20871179', 'ctest-trans_right_vn-48330847'], 'port_security_enabled': True, 'description': ''}} 2025-10-30 03:15:56,899 - DEBUG - Response for create_subnet : {'subnet': {'id': 'add0baba-7867-41bc-9c07-2a26495cdc41', 'name': '', 'tenant_id': '2ee20ab467d942ce9bba66f37d99df39', 'network_id': 'e1d1ae3e-2382-43a7-8197-6d9999392201', 'ip_version': 4, 'cidr': '83.211.126.192/26', 'allocation_pools': [{'start': '83.211.126.194', 'end': '83.211.126.254'}], 'gateway_ip': '83.211.126.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '83.211.126.194', 'tags': [], 'project_id': '2ee20ab467d942ce9bba66f37d99df39'}} 2025-10-30 03:15:56,925 - INFO - Created VN ctest-trans_right_vn-48330847 2025-10-30 03:15:56,940 - DEBUG - VN ctest-trans_right_vn-48330847 UUID is e1d1ae3e-2382-43a7-8197-6d9999392201 2025-10-30 03:15:57,024 - DEBUG - Requesting: http://10.0.0.242:8082/domains 2025-10-30 03:15:57,031 - DEBUG - Requesting: http://10.0.0.242:8082/domain/2be6ea5e-665d-4a78-a8ec-f940f567f06f 2025-10-30 03:15:57,042 - DEBUG - Requesting: http://10.0.0.242:8082/project/2ee20ab4-67d9-42ce-9bba-66f37d99df39 2025-10-30 03:15:57,151 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/e1d1ae3e-2382-43a7-8197-6d9999392201 2025-10-30 03:15:57,185 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/e1d1ae3e-2382-43a7-8197-6d9999392201 2025-10-30 03:15:57,200 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/7eee9faa-80a6-49fd-9ae4-6a898cecb4e3 2025-10-30 03:15:57,211 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/7eee9faa-80a6-49fd-9ae4-6a898cecb4e3 2025-10-30 03:15:57,223 - DEBUG - Requesting: http://10.0.0.242:8082/route-target/da328ea0-95a9-4354-a072-960f517839d3 2025-10-30 03:15:57,234 - DEBUG - Route Targets: ['target:64512:8000008'] 2025-10-30 03:15:57,234 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/e1d1ae3e-2382-43a7-8197-6d9999392201 2025-10-30 03:15:57,253 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/7eee9faa-80a6-49fd-9ae4-6a898cecb4e3 2025-10-30 03:15:57,280 - INFO - Verified VN network id 17 for VN e1d1ae3e-2382-43a7-8197-6d9999392201 2025-10-30 03:15:57,280 - INFO - Verifications in API Server for VN ctest-trans_right_vn-48330847 passed 2025-10-30 03:15:57,280 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/e1d1ae3e-2382-43a7-8197-6d9999392201 2025-10-30 03:15:57,297 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/7eee9faa-80a6-49fd-9ae4-6a898cecb4e3 2025-10-30 03:15:57,306 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/7eee9faa-80a6-49fd-9ae4-6a898cecb4e3 2025-10-30 03:15:57,318 - DEBUG - Requesting: http://10.0.0.242:8082/route-target/da328ea0-95a9-4354-a072-960f517839d3 2025-10-30 03:15:57,332 - DEBUG - Control-node 10.0.0.242 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-20871179:ctest-trans_right_vn-48330847', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-20871179', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16271978510573257639', 'uuid-lslong': '9338052858844094977'}, 'enable': 'true', 'created': '2025-10-30T03:15:56', 'last-modified': '2025-10-30T03:15:56', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.500956'} 2025-10-30 03:15:57,341 - DEBUG - Route Targets: ['target:64512:8000008'] 2025-10-30 03:15:57,347 - DEBUG - Control-node 10.0.0.254 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-20871179:ctest-trans_right_vn-48330847', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-20871179', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16271978510573257639', 'uuid-lslong': '9338052858844094977'}, 'enable': 'true', 'created': '2025-10-30T03:15:56', 'last-modified': '2025-10-30T03:15:56', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.516073'} 2025-10-30 03:15:57,352 - DEBUG - Route Targets: ['target:64512:8000008'] 2025-10-30 03:15:57,357 - DEBUG - Control-node 10.0.0.240 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-20871179:ctest-trans_right_vn-48330847', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-20871179', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16271978510573257639', 'uuid-lslong': '9338052858844094977'}, 'enable': 'true', 'created': '2025-10-30T03:15:56', 'last-modified': '2025-10-30T03:15:56', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.527803'} 2025-10-30 03:15:57,364 - DEBUG - Route Targets: ['target:64512:8000008'] 2025-10-30 03:15:57,364 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_right_vn-48330847 passed 2025-10-30 03:15:57,364 - DEBUG - ====Verifying policy data for ctest-trans_right_vn-48330847 in API_Server ====== 2025-10-30 03:15:57,364 - DEBUG - Requesting: http://10.0.0.242:8082/domains 2025-10-30 03:15:57,371 - DEBUG - Requesting: http://10.0.0.242:8082/domain/2be6ea5e-665d-4a78-a8ec-f940f567f06f 2025-10-30 03:15:57,383 - DEBUG - Requesting: http://10.0.0.242:8082/project/2ee20ab4-67d9-42ce-9bba-66f37d99df39 2025-10-30 03:15:57,478 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/e1d1ae3e-2382-43a7-8197-6d9999392201 2025-10-30 03:15:57,491 - DEBUG - =>VN ctest-trans_right_vn-48330847 has no policy to be verified 2025-10-30 03:15:57,491 - DEBUG - Verifying the vn in opserver 2025-10-30 03:15:57,491 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-20871179:ctest-trans_right_vn-48330847 virtual network link through opserver 10.0.0.242 2025-10-30 03:15:57,491 - DEBUG - Requesting: http://10.0.0.242:8081/analytics/uves/virtual-networks 2025-10-30 03:15:57,502 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-20871179:ctest-trans_right_vn-48330847', 'href': 'http://10.0.0.242:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-20871179:ctest-trans_right_vn-48330847?flat'} 2025-10-30 03:15:57,502 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-20871179:ctest-trans_right_vn-48330847 virtual network link through opserver 10.0.0.254 2025-10-30 03:15:57,502 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-networks 2025-10-30 03:15:57,516 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-20871179:ctest-trans_right_vn-48330847', 'href': 'http://10.0.0.254:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-20871179:ctest-trans_right_vn-48330847?flat'} 2025-10-30 03:15:57,516 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-20871179:ctest-trans_right_vn-48330847 virtual network link through opserver 10.0.0.240 2025-10-30 03:15:57,516 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/virtual-networks 2025-10-30 03:15:57,535 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-20871179:ctest-trans_right_vn-48330847', 'href': 'http://10.0.0.240:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-20871179:ctest-trans_right_vn-48330847?flat'} 2025-10-30 03:15:57,535 - INFO - Validated that VN default-domain:ctest-TestSvcHC-20871179:ctest-trans_right_vn-48330847 is found in opserver 2025-10-30 03:15:57,558 - DEBUG - Do not have enough data to verify VN in agent 2025-10-30 03:15:57,569 - DEBUG - VRF ids for VN ctest-trans_right_vn-48330847: {} 2025-10-30 03:15:58,694 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4535-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4535-1) 2025-10-30 03:16:00,032 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4535-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4535-2) 2025-10-30 03:16:00,032 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-60350006'] 2025-10-30 03:16:00,366 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-60350006'] created succesfully 2025-10-30 03:16:00,768 - DEBUG - Image by name tiny_trans_fw not found 2025-10-30 03:16:00,769 - DEBUG - Installing image tiny_trans_fw 2025-10-30 03:16:00,769 - DEBUG - Image info {'name': 'tinycore-net-transparent-fw.qcow2.gz', 'webserver': '', 'location': '/images/tinycore/', 'username': 'tc', 'password': 'secret', 'type': 'os', 'flavor': 'contrail_flavor_tiny', 'params': '--container-format bare --disk-format vmdk --property vmware_disktype="sparse" --property vmware_adaptertype="ide" --property hypervisor_type=qemu', 'name_docker': 'phusion-baseimage-enablesshd'} 2025-10-30 03:16:00,769 - DEBUG - Image build path file:///contrail-test/images/tinycore-net-transparent-fw.qcow2.gz 2025-10-30 03:16:00,769 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-net-transparent-fw.qcow2.gz 2025-10-30 03:16:00,769 - DEBUG - Unzip image 2025-10-30 03:16:00,769 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-net-transparent-fw.qcow2.gz 2025-10-30 03:16:00,793 - INFO - image /contrail-test/images/tinycore-net-transparent-fw.qcow2 is not found 2025-10-30 03:16:00,794 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-60350006'] 2025-10-30 03:16:00,900 - INFO - Service template: ['default-domain', 'ctest-service_template_1-60350006'] deleted successfully. 2025-10-30 03:16:00,901 - INFO - Skip interface_detach for VM ctest-right_vm-23409622 in state BUILD 2025-10-30 03:16:00,901 - INFO - Deleting VM ctest-right_vm-23409622 2025-10-30 03:16:00,901 - ERROR - VM ctest-right_vm-23409622 has failed to come up 2025-10-30 03:16:00,901 - ERROR - Nova failed to get host of the VM 2025-10-30 03:16:00,901 - ERROR - VM ctest-right_vm-23409622 has failed to come up 2025-10-30 03:16:00,902 - ERROR - Nova failed to get host of the VM 2025-10-30 03:16:01,017 - INFO - Skip interface_detach for VM ctest-left_vm-93746262 in state BUILD 2025-10-30 03:16:01,017 - INFO - Deleting VM ctest-left_vm-93746262 2025-10-30 03:16:01,017 - ERROR - VM ctest-left_vm-93746262 has failed to come up 2025-10-30 03:16:01,017 - ERROR - Nova failed to get host of the VM 2025-10-30 03:16:01,018 - ERROR - VM ctest-left_vm-93746262 has failed to come up 2025-10-30 03:16:01,018 - ERROR - Nova failed to get host of the VM 2025-10-30 03:16:01,101 - INFO - Deleting VN ctest-trans_right_vn-48330847 2025-10-30 03:16:01,276 - DEBUG - Response for deleting network () 2025-10-30 03:16:01,276 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/7eee9faa-80a6-49fd-9ae4-6a898cecb4e3 2025-10-30 03:16:01,283 - DEBUG - Response Code: 404 2025-10-30 03:16:01,283 - DEBUG - Requesting: http://10.0.0.242:8082/domains 2025-10-30 03:16:01,289 - DEBUG - Requesting: http://10.0.0.242:8082/domain/2be6ea5e-665d-4a78-a8ec-f940f567f06f 2025-10-30 03:16:01,355 - DEBUG - Requesting: http://10.0.0.242:8082/project/2ee20ab4-67d9-42ce-9bba-66f37d99df39 2025-10-30 03:16:01,465 - INFO - Validated that VN ctest-trans_right_vn-48330847 is not found in API Server 2025-10-30 03:16:01,477 - DEBUG - VN ctest-trans_right_vn-48330847 is not present in Agent 10.0.0.129 2025-10-30 03:16:01,502 - DEBUG - VN ctest-trans_right_vn-48330847 is not present in Agent 10.0.0.65 2025-10-30 03:16:01,502 - INFO - Validated that VN ctest-trans_right_vn-48330847 is not in any agent 2025-10-30 03:16:01,558 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-trans_right_vn-48330847 info 2025-10-30 03:16:01,558 - INFO - Deleting VN ctest-trans_left_vn-73457458 2025-10-30 03:16:01,740 - DEBUG - Response for deleting network () 2025-10-30 03:16:01,740 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/105b3fc5-3c55-476a-b493-3d34d2410c4e 2025-10-30 03:16:01,746 - DEBUG - Response Code: 404 2025-10-30 03:16:01,746 - DEBUG - Requesting: http://10.0.0.242:8082/domains 2025-10-30 03:16:01,766 - DEBUG - Requesting: http://10.0.0.242:8082/domain/2be6ea5e-665d-4a78-a8ec-f940f567f06f 2025-10-30 03:16:01,803 - DEBUG - Requesting: http://10.0.0.242:8082/project/2ee20ab4-67d9-42ce-9bba-66f37d99df39 2025-10-30 03:16:01,915 - INFO - Validated that VN ctest-trans_left_vn-73457458 is not found in API Server 2025-10-30 03:16:01,928 - DEBUG - VN ctest-trans_left_vn-73457458 is not present in Agent 10.0.0.129 2025-10-30 03:16:01,941 - DEBUG - VN ctest-trans_left_vn-73457458 is not present in Agent 10.0.0.65 2025-10-30 03:16:01,942 - INFO - Validated that VN ctest-trans_left_vn-73457458 is not in any agent 2025-10-30 03:16:01,984 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-trans_left_vn-73457458 info 2025-10-30 03:16:01,984 - INFO - Deleting VN ctest-right_vn-07557643 2025-10-30 03:16:02,030 - DEBUG - VN c4432a47-0363-47b7-9722-1ae72161f2d0 still in use: Unable to complete operation on network c4432a47-0363-47b7-9722-1ae72161f2d0. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-bb43c136-d01d-41de-96bb-527ed7c3039b'] 2025-10-30 03:16:02,030 - WARNING - Deleting VN ctest-right_vn-07557643 failed..Will retry 2025-10-30 03:16:04,194 - DEBUG - Response for deleting network () 2025-10-30 03:16:04,195 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/7a5cb7c4-0a7e-4185-a617-1089907148f3 2025-10-30 03:16:04,207 - DEBUG - Response Code: 404 2025-10-30 03:16:04,207 - DEBUG - Requesting: http://10.0.0.242:8082/domains 2025-10-30 03:16:04,214 - DEBUG - Requesting: http://10.0.0.242:8082/domain/2be6ea5e-665d-4a78-a8ec-f940f567f06f 2025-10-30 03:16:04,226 - DEBUG - Requesting: http://10.0.0.242:8082/project/2ee20ab4-67d9-42ce-9bba-66f37d99df39 2025-10-30 03:16:04,323 - INFO - Validated that VN ctest-right_vn-07557643 is not found in API Server 2025-10-30 03:16:04,333 - DEBUG - VN ctest-right_vn-07557643 is not present in Agent 10.0.0.129 2025-10-30 03:16:04,342 - DEBUG - VN ctest-right_vn-07557643 is not present in Agent 10.0.0.65 2025-10-30 03:16:04,342 - INFO - Validated that VN ctest-right_vn-07557643 is not in any agent 2025-10-30 03:16:04,372 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-07557643 info 2025-10-30 03:16:04,372 - INFO - Deleting VN ctest-left_vn-60664428 2025-10-30 03:16:04,548 - DEBUG - Response for deleting network () 2025-10-30 03:16:04,548 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/0ab0adbf-06ee-4a0e-b9de-93caa2ccc6ab 2025-10-30 03:16:04,554 - DEBUG - Response Code: 404 2025-10-30 03:16:04,554 - DEBUG - Requesting: http://10.0.0.242:8082/domains 2025-10-30 03:16:04,562 - DEBUG - Requesting: http://10.0.0.242:8082/domain/2be6ea5e-665d-4a78-a8ec-f940f567f06f 2025-10-30 03:16:04,618 - DEBUG - Requesting: http://10.0.0.242:8082/project/2ee20ab4-67d9-42ce-9bba-66f37d99df39 2025-10-30 03:16:04,717 - INFO - Validated that VN ctest-left_vn-60664428 is not found in API Server 2025-10-30 03:16:04,735 - DEBUG - VN ctest-left_vn-60664428 is not present in Agent 10.0.0.129 2025-10-30 03:16:04,748 - DEBUG - VN ctest-left_vn-60664428 is not present in Agent 10.0.0.65 2025-10-30 03:16:04,748 - INFO - Validated that VN ctest-left_vn-60664428 is not in any agent 2025-10-30 03:16:04,788 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-60664428 info 2025-10-30 03:16:04,788 - INFO - Deleting VN ctest-mgmt_vn-18492125 2025-10-30 03:16:04,943 - DEBUG - Response for deleting network () 2025-10-30 03:16:04,943 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/2a633113-4ffe-4fc8-a3e5-2420afdc5301 2025-10-30 03:16:04,952 - DEBUG - Response Code: 404 2025-10-30 03:16:04,952 - DEBUG - Requesting: http://10.0.0.242:8082/domains 2025-10-30 03:16:04,961 - DEBUG - Requesting: http://10.0.0.242:8082/domain/2be6ea5e-665d-4a78-a8ec-f940f567f06f 2025-10-30 03:16:04,974 - DEBUG - Requesting: http://10.0.0.242:8082/project/2ee20ab4-67d9-42ce-9bba-66f37d99df39 2025-10-30 03:16:05,061 - INFO - Validated that VN ctest-mgmt_vn-18492125 is not found in API Server 2025-10-30 03:16:05,075 - DEBUG - VN ctest-mgmt_vn-18492125 is not present in Agent 10.0.0.129 2025-10-30 03:16:05,088 - DEBUG - VN ctest-mgmt_vn-18492125 is not present in Agent 10.0.0.65 2025-10-30 03:16:05,088 - INFO - Validated that VN ctest-mgmt_vn-18492125 is not in any agent 2025-10-30 03:16:05,123 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-18492125 info 2025-10-30 03:16:06,407 - DEBUG - No XMPP flaps were noticed during the test 2025-10-30 03:16:06,407 - INFO -

2025-10-30 03:16:06,408 - INFO - END TEST : test_svc_trans_segment_right_hc_fail_svm : SKIPPED[0:00:16]

2025-10-30 03:16:06,408 - INFO - -------------------------------------------------------------------------------- 2025-10-30 03:16:07,230 - INFO - Deleted project: ctest-TestSvcHC-20871179, ID : 2ee20ab4-67d9-42ce-9bba-66f37d99df39