2025-10-08 16:52:33,525 - INFO - Domain Default found not creating
2025-10-08 16:52:33,659 - INFO - Project ctest-TestBasicPolicyNegativeIpv4v6-83883544 not found, creating it
2025-10-08 16:52:34,225 - INFO - Created Project:ctest-TestBasicPolicyNegativeIpv4v6-83883544, ID : 73ca3fa3-80bc-4769-b92a-4ef2b82f81b6
2025-10-08 16:52:35,837 - INFO - ================================================================================
2025-10-08 16:52:35,837 - INFO - STARTING TEST : test_remove_policy_with_ref
2025-10-08 16:52:37,127 - DEBUG - Nothing to compare xmpp stats {'10.0.0.33': {'10.20.0.192': '0', '10.20.0.19': '0'}, '10.0.0.19': {'10.20.0.192': '0', '10.20.0.19': '0'}} with
2025-10-08 16:52:37,127 - INFO - Initial checks done. Running the testcase now
2025-10-08 16:52:37,128 - INFO -
2025-10-08 16:52:37,128 - INFO - ================================================================================
2025-10-08 16:52:37,128 - INFO - STARTING TEST : test_remove_policy_with_ref
2025-10-08 16:52:37,128 - INFO - TEST DESCRIPTION : This tests the following scenarios.
1. Test to validate that policy removal will fail when it referenced with VN.
2. validate vn_policy data in api-s against quantum-vn data, when created and unbind policy from VN thru quantum APIs.
3. validate policy data in api-s against quantum-policy data, when created and deleted thru quantum APIs.
2025-10-08 16:52:38,422 - DEBUG - Nothing to compare xmpp stats {'10.0.0.33': {'10.20.0.192': '0', '10.20.0.19': '0'}, '10.0.0.19': {'10.20.0.192': '0', '10.20.0.19': '0'}} with
2025-10-08 16:52:38,422 - INFO - Initial checks done. Running the testcase now
2025-10-08 16:52:38,423 - INFO -
2025-10-08 16:52:38,775 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = icmp, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestBasicPolicyNegativeIpv4v6-83883544:ctest-vn4-77092161, security_group = None, network_policy = None, subnet_list = []], src_ports = [start_port = -1, end_port = -1], application = [], dst_addresses = [subnet = None, virtual_network = default-domain:ctest-TestBasicPolicyNegativeIpv4v6-83883544:ctest-vn4-77092161, security_group = None, network_policy = None, subnet_list = []], dst_ports = [start_port = -1, end_port = -1], action_list = simple_action = pass, gateway_name = None, apply_service = [], service_properties = None, mirror_to = None, assign_routing_instance = None, log = False, alert = False, qos_action = None, host_based_service = False, ethertype = None, created = None, last_modified = None, description = None, rule_sequence = None, rule_uuid = None, direction = <>, protocol = 58, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestBasicPolicyNegativeIpv4v6-83883544:ctest-vn4-77092161, security_group = None, network_policy = None, subnet_list = []], src_ports = [start_port = -1, end_port = -1], application = [], dst_addresses = [subnet = None, virtual_network = default-domain:ctest-TestBasicPolicyNegativeIpv4v6-83883544:ctest-vn4-77092161, security_group = None, network_policy = None, subnet_list = []], dst_ports = [start_port = -1, end_port = -1], action_list = simple_action = pass, gateway_name = None, apply_service = [], service_properties = None, mirror_to = None, assign_routing_instance = None, log = False, alert = False, qos_action = None, host_based_service = False, ethertype = None, created = None, last_modified = None, description = None]
2025-10-08 16:52:39,425 - DEBUG - Response for create_network : {'network': {'id': '2c85bd17-09f0-4770-835b-ed4ea402095d', 'name': 'ctest-vn4-77092161', 'tenant_id': '73ca3fa380bc4769b92a4ef2b82f81b6', 'project_id': '73ca3fa380bc4769b92a4ef2b82f81b6', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestBasicPolicyNegativeIpv4v6-83883544', 'ctest-vn4-77092161'], 'port_security_enabled': True, 'description': ''}}
2025-10-08 16:52:39,679 - DEBUG - Response for create_subnet : {'subnet': {'id': '05711dd8-e119-4b64-9536-0aae08a6a4dc', 'name': '', 'tenant_id': '73ca3fa380bc4769b92a4ef2b82f81b6', 'network_id': '2c85bd17-09f0-4770-835b-ed4ea402095d', 'ip_version': 4, 'cidr': '155.65.198.0/26', 'allocation_pools': [{'start': '155.65.198.2', 'end': '155.65.198.62'}], 'gateway_ip': '155.65.198.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '155.65.198.2', 'tags': [], 'project_id': '73ca3fa380bc4769b92a4ef2b82f81b6'}}
2025-10-08 16:52:39,893 - DEBUG - Response for create_subnet : {'subnet': {'id': '0e5683b3-13c3-4401-a315-77a8280207df', 'name': '', 'tenant_id': '73ca3fa380bc4769b92a4ef2b82f81b6', 'network_id': '2c85bd17-09f0-4770-835b-ed4ea402095d', 'ip_version': 6, 'cidr': '3a4e:113a:e18f:38c3:1653:1c2f::/96', 'allocation_pools': [{'start': '3a4e:113a:e18f:38c3:1653:1c2f:0:2', 'end': '3a4e:113a:e18f:38c3:1653:1c2f:ffff:fffe'}], 'gateway_ip': '3a4e:113a:e18f:38c3:1653:1c2f:0:1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '3a4e:113a:e18f:38c3:1653:1c2f:0:2', 'tags': [], 'project_id': '73ca3fa380bc4769b92a4ef2b82f81b6'}}
2025-10-08 16:52:39,916 - INFO - Created VN ctest-vn4-77092161
2025-10-08 16:52:39,930 - DEBUG - VN ctest-vn4-77092161 UUID is 2c85bd17-09f0-4770-835b-ed4ea402095d
2025-10-08 16:52:40,138 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': '2c85bd17-09f0-4770-835b-ed4ea402095d', 'name': 'ctest-vn4-77092161', 'tenant_id': '73ca3fa380bc4769b92a4ef2b82f81b6', 'project_id': '73ca3fa380bc4769b92a4ef2b82f81b6', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['05711dd8-e119-4b64-9536-0aae08a6a4dc', '0e5683b3-13c3-4401-a315-77a8280207df'], 'fq_name': ['default-domain', 'ctest-TestBasicPolicyNegativeIpv4v6-83883544', 'ctest-vn4-77092161'], 'policys': [['default-domain', 'ctest-TestBasicPolicyNegativeIpv4v6-83883544', 'ctest-policy1-09372798']], 'subnet_ipam': [{'subnet_cidr': '155.65.198.0/26', 'ipam_fq_name': ['default-domain', 'default-project', 'default-network-ipam']}, {'subnet_cidr': '3a4e:113a:e18f:38c3:1653:1c2f::/96', 'ipam_fq_name': ['default-domain', 'default-project', 'default-network-ipam']}], 'port_security_enabled': True, 'description': ''}}
2025-10-08 16:52:40,236 - DEBUG - Requesting: http://10.0.0.56:8082/domains
2025-10-08 16:52:40,538 - DEBUG - Requesting: http://10.0.0.56:8082/domains
2025-10-08 16:52:40,562 - DEBUG - Requesting: http://10.0.0.56:8082/domain/1d11f468-2e8f-4a79-a987-f452a249cd6b
2025-10-08 16:52:40,574 - DEBUG - Requesting: http://10.0.0.56:8082/project/73ca3fa3-80bc-4769-b92a-4ef2b82f81b6
2025-10-08 16:52:40,674 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-network/2c85bd17-09f0-4770-835b-ed4ea402095d
2025-10-08 16:52:40,687 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-network/2c85bd17-09f0-4770-835b-ed4ea402095d
2025-10-08 16:52:40,696 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/53100f8d-b730-4a2d-82c9-f59d2b65bf65
2025-10-08 16:52:40,703 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/53100f8d-b730-4a2d-82c9-f59d2b65bf65
2025-10-08 16:52:40,710 - DEBUG - Requesting: http://10.0.0.56:8082/route-target/81c6bada-918e-4a58-931f-033780ed8edb
2025-10-08 16:52:40,717 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-08 16:52:40,717 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-network/2c85bd17-09f0-4770-835b-ed4ea402095d
2025-10-08 16:52:40,729 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/53100f8d-b730-4a2d-82c9-f59d2b65bf65
2025-10-08 16:52:40,745 - INFO - Verified VN network id 13 for VN 2c85bd17-09f0-4770-835b-ed4ea402095d
2025-10-08 16:52:40,746 - INFO - Verifications in API Server for VN ctest-vn4-77092161 passed
2025-10-08 16:52:40,746 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-network/2c85bd17-09f0-4770-835b-ed4ea402095d
2025-10-08 16:52:40,755 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/53100f8d-b730-4a2d-82c9-f59d2b65bf65
2025-10-08 16:52:40,762 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/53100f8d-b730-4a2d-82c9-f59d2b65bf65
2025-10-08 16:52:40,768 - DEBUG - Requesting: http://10.0.0.56:8082/route-target/81c6bada-918e-4a58-931f-033780ed8edb
2025-10-08 16:52:40,788 - DEBUG - Control-node 10.0.0.56 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestBasicPolicyNegativeIpv4v6-83883544:ctest-vn4-77092161', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestBasicPolicyNegativeIpv4v6-83883544', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3208178216219985776', 'uuid-lslong': '9465419963864058205'}, 'enable': 'true', 'created': '2025-10-08T16:52:39', 'last-modified': '2025-10-08T16:52:40', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.690941'}
2025-10-08 16:52:40,798 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-08 16:52:40,804 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestBasicPolicyNegativeIpv4v6-83883544:ctest-vn4-77092161', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestBasicPolicyNegativeIpv4v6-83883544', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3208178216219985776', 'uuid-lslong': '9465419963864058205'}, 'enable': 'true', 'created': '2025-10-08T16:52:39', 'last-modified': '2025-10-08T16:52:40', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.708534'}
2025-10-08 16:52:40,810 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-08 16:52:40,820 - DEBUG - Control-node 10.0.0.41 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestBasicPolicyNegativeIpv4v6-83883544:ctest-vn4-77092161', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestBasicPolicyNegativeIpv4v6-83883544', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3208178216219985776', 'uuid-lslong': '9465419963864058205'}, 'enable': 'true', 'created': '2025-10-08T16:52:39', 'last-modified': '2025-10-08T16:52:40', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.720338'}
2025-10-08 16:52:40,826 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-08 16:52:40,826 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn4-77092161 passed
2025-10-08 16:52:40,826 - DEBUG - ====Verifying policy data for ctest-vn4-77092161 in API_Server ======
2025-10-08 16:52:40,826 - DEBUG - Requesting: http://10.0.0.56:8082/domains
2025-10-08 16:52:40,833 - DEBUG - Requesting: http://10.0.0.56:8082/domain/1d11f468-2e8f-4a79-a987-f452a249cd6b
2025-10-08 16:52:40,843 - DEBUG - Requesting: http://10.0.0.56:8082/project/73ca3fa3-80bc-4769-b92a-4ef2b82f81b6
2025-10-08 16:52:40,932 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-network/2c85bd17-09f0-4770-835b-ed4ea402095d
2025-10-08 16:52:40,943 - DEBUG - ==>Verifying data for policy with id: 7cffc81b-4415-4457-9503-ad5c90e55395, fqn: ['default-domain', 'ctest-TestBasicPolicyNegativeIpv4v6-83883544', 'ctest-policy1-09372798']
2025-10-08 16:52:40,943 - INFO - VN ctest-vn4-77092161 Policy verification: verify_vn_policy_in_api_server, status: True
2025-10-08 16:52:40,943 - DEBUG - Verifying the vn in opserver
2025-10-08 16:52:40,943 - DEBUG - Verifying the default-domain:ctest-TestBasicPolicyNegativeIpv4v6-83883544:ctest-vn4-77092161 virtual network link through opserver 10.0.0.56
2025-10-08 16:52:40,943 - DEBUG - Requesting: http://10.0.0.56:8081/analytics/uves/virtual-networks
2025-10-08 16:52:41,232 - DEBUG - Requesting: http://10.0.0.56:8081/analytics/uves/virtual-networks
2025-10-08 16:52:41,283 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestBasicPolicyNegativeIpv4v6-83883544:ctest-vn4-77092161', 'href': 'http://10.0.0.56:8081/analytics/uves/virtual-network/default-domain:ctest-TestBasicPolicyNegativeIpv4v6-83883544:ctest-vn4-77092161?flat'}
2025-10-08 16:52:41,283 - DEBUG - Verifying the default-domain:ctest-TestBasicPolicyNegativeIpv4v6-83883544:ctest-vn4-77092161 virtual network link through opserver 10.0.0.249
2025-10-08 16:52:41,283 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2025-10-08 16:52:41,578 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2025-10-08 16:52:41,639 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestBasicPolicyNegativeIpv4v6-83883544:ctest-vn4-77092161', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-TestBasicPolicyNegativeIpv4v6-83883544:ctest-vn4-77092161?flat'}
2025-10-08 16:52:41,639 - DEBUG - Verifying the default-domain:ctest-TestBasicPolicyNegativeIpv4v6-83883544:ctest-vn4-77092161 virtual network link through opserver 10.0.0.41
2025-10-08 16:52:41,639 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-networks
2025-10-08 16:52:41,932 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-networks
2025-10-08 16:52:42,001 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestBasicPolicyNegativeIpv4v6-83883544:ctest-vn4-77092161', 'href': 'http://10.0.0.41:8081/analytics/uves/virtual-network/default-domain:ctest-TestBasicPolicyNegativeIpv4v6-83883544:ctest-vn4-77092161?flat'}
2025-10-08 16:52:42,001 - INFO - Validated that VN default-domain:ctest-TestBasicPolicyNegativeIpv4v6-83883544:ctest-vn4-77092161 is found in opserver
2025-10-08 16:52:42,024 - DEBUG - Do not have enough data to verify VN in agent
2025-10-08 16:52:42,033 - DEBUG - VRF ids for VN ctest-vn4-77092161: {}
2025-10-08 16:52:42,034 - DEBUG - ====Verifying data for ctest-policy1-09372798 in API_Server ======
2025-10-08 16:52:42,034 - DEBUG - Requesting: http://10.0.0.56:8082/domains
2025-10-08 16:52:42,040 - DEBUG - Requesting: http://10.0.0.56:8082/domain/1d11f468-2e8f-4a79-a987-f452a249cd6b
2025-10-08 16:52:42,050 - DEBUG - Requesting: http://10.0.0.56:8082/project/73ca3fa3-80bc-4769-b92a-4ef2b82f81b6
2025-10-08 16:52:42,137 - DEBUG - Requesting: http://10.0.0.56:8082/network-policy/7cffc81b-4415-4457-9503-ad5c90e55395
2025-10-08 16:52:42,148 - INFO - Verified policy ctest-policy1-09372798 in API Server, Result: True
2025-10-08 16:52:42,148 - INFO - Done with setup and verification, moving onto test ..
2025-10-08 16:52:42,159 - INFO - Deleting VN ctest-vn4-77092161
2025-10-08 16:52:42,427 - DEBUG - Response for deleting network ()
2025-10-08 16:52:42,428 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/53100f8d-b730-4a2d-82c9-f59d2b65bf65
2025-10-08 16:52:42,435 - DEBUG - Response Code: 404
2025-10-08 16:52:42,435 - DEBUG - Requesting: http://10.0.0.56:8082/domains
2025-10-08 16:52:42,441 - DEBUG - Requesting: http://10.0.0.56:8082/domain/1d11f468-2e8f-4a79-a987-f452a249cd6b
2025-10-08 16:52:42,452 - DEBUG - Requesting: http://10.0.0.56:8082/project/73ca3fa3-80bc-4769-b92a-4ef2b82f81b6
2025-10-08 16:52:42,575 - INFO - Validated that VN ctest-vn4-77092161 is not found in API Server
2025-10-08 16:52:42,587 - DEBUG - VN ctest-vn4-77092161 is not present in Agent 10.0.0.33
2025-10-08 16:52:42,601 - DEBUG - VN ctest-vn4-77092161 is not present in Agent 10.0.0.19
2025-10-08 16:52:42,601 - INFO - Validated that VN ctest-vn4-77092161 is not in any agent
2025-10-08 16:52:42,630 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn4-77092161 info
2025-10-08 16:52:42,683 - INFO - Deleted policy ctest-policy1-09372798
2025-10-08 16:52:42,897 - DEBUG - policy ctest-policy1-09372798 is not found in API Server
2025-10-08 16:52:44,175 - DEBUG - No XMPP flaps were noticed during the test
2025-10-08 16:52:44,175 - INFO - END TEST : test_remove_policy_with_ref : PASSED[0:00:07]
2025-10-08 16:52:44,175 - INFO - --------------------------------------------------------------------------------
2025-10-08 16:52:45,450 - DEBUG - No XMPP flaps were noticed during the test
2025-10-08 16:52:45,450 - INFO - END TEST : test_remove_policy_with_ref : PASSED[0:00:10]
2025-10-08 16:52:45,450 - INFO - --------------------------------------------------------------------------------
2025-10-08 16:52:46,205 - INFO - Deleted project: ctest-TestBasicPolicyNegativeIpv4v6-83883544, ID : 73ca3fa3-80bc-4769-b92a-4ef2b82f81b6