2026-10-26 02:59:45,065 - INFO - Domain Default found not creating
2026-10-26 02:59:45,246 - INFO - Project ctest-TestBasicPolicyNegativeIpv4v6-76072601 not found, creating it
2026-10-26 02:59:45,760 - INFO - Created Project:ctest-TestBasicPolicyNegativeIpv4v6-76072601, ID : aef077ee-c573-482d-ae2a-ad238a33ea06
2026-10-26 02:59:47,609 - INFO - ================================================================================
2026-10-26 02:59:47,609 - INFO - STARTING TEST : test_remove_policy_with_ref
2026-10-26 02:59:48,910 - DEBUG - Nothing to compare xmpp stats {'10.0.0.50': {'10.20.0.30': '0', '10.20.0.254': '0'}, '10.0.0.38': {'10.20.0.254': '0', '10.20.0.30': '0'}} with
2026-10-26 02:59:48,910 - INFO - Initial checks done. Running the testcase now
2026-10-26 02:59:48,910 - INFO -
2026-10-26 02:59:48,910 - INFO - ================================================================================
2026-10-26 02:59:48,910 - INFO - STARTING TEST : test_remove_policy_with_ref
2026-10-26 02:59:48,910 - 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.
2026-10-26 02:59:50,225 - DEBUG - Nothing to compare xmpp stats {'10.0.0.50': {'10.20.0.30': '0', '10.20.0.254': '0'}, '10.0.0.38': {'10.20.0.254': '0', '10.20.0.30': '0'}} with
2026-10-26 02:59:50,225 - INFO - Initial checks done. Running the testcase now
2026-10-26 02:59:50,225 - INFO -
2026-10-26 02:59:50,699 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = icmp, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestBasicPolicyNegativeIpv4v6-76072601:ctest-vn4-53041430, 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-76072601:ctest-vn4-53041430, 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-76072601:ctest-vn4-53041430, 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-76072601:ctest-vn4-53041430, 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]
2026-10-26 02:59:51,351 - DEBUG - Response for create_network : {'network': {'id': 'f70dcbf8-d63c-469b-9d4a-b4568413daa8', 'name': 'ctest-vn4-53041430', 'tenant_id': 'aef077eec573482dae2aad238a33ea06', 'project_id': 'aef077eec573482dae2aad238a33ea06', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'tags': [], 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestBasicPolicyNegativeIpv4v6-76072601', 'ctest-vn4-53041430'], 'port_security_enabled': True, 'description': ''}}
2026-10-26 02:59:51,718 - DEBUG - Response for create_subnet : {'subnet': {'id': '112d05ae-56db-4597-ac55-989401e19287', 'name': '', 'tenant_id': 'aef077eec573482dae2aad238a33ea06', 'network_id': 'f70dcbf8-d63c-469b-9d4a-b4568413daa8', 'ip_version': 4, 'cidr': '84.233.194.64/26', 'allocation_pools': [{'start': '84.233.194.66', 'end': '84.233.194.126'}], 'gateway_ip': '84.233.194.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '84.233.194.66', 'tags': [], 'project_id': 'aef077eec573482dae2aad238a33ea06'}}
2026-10-26 02:59:51,992 - DEBUG - Response for create_subnet : {'subnet': {'id': '28140706-a321-4a5e-883d-a2d1a7705b85', 'name': '', 'tenant_id': 'aef077eec573482dae2aad238a33ea06', 'network_id': 'f70dcbf8-d63c-469b-9d4a-b4568413daa8', 'ip_version': 6, 'cidr': '383f:cefe:51ba:a76d:d777:1a9f::/96', 'allocation_pools': [{'start': '383f:cefe:51ba:a76d:d777:1a9f:0:2', 'end': '383f:cefe:51ba:a76d:d777:1a9f:ffff:fffe'}], 'gateway_ip': '383f:cefe:51ba:a76d:d777:1a9f:0:1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '383f:cefe:51ba:a76d:d777:1a9f:0:2', 'tags': [], 'project_id': 'aef077eec573482dae2aad238a33ea06'}}
2026-10-26 02:59:52,019 - INFO - Created VN ctest-vn4-53041430
2026-10-26 02:59:52,033 - DEBUG - VN ctest-vn4-53041430 UUID is f70dcbf8-d63c-469b-9d4a-b4568413daa8
2026-10-26 02:59:52,233 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': 'f70dcbf8-d63c-469b-9d4a-b4568413daa8', 'name': 'ctest-vn4-53041430', 'tenant_id': 'aef077eec573482dae2aad238a33ea06', 'project_id': 'aef077eec573482dae2aad238a33ea06', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'tags': [], 'subnets': ['112d05ae-56db-4597-ac55-989401e19287', '28140706-a321-4a5e-883d-a2d1a7705b85'], 'fq_name': ['default-domain', 'ctest-TestBasicPolicyNegativeIpv4v6-76072601', 'ctest-vn4-53041430'], 'policys': [['default-domain', 'ctest-TestBasicPolicyNegativeIpv4v6-76072601', 'ctest-policy1-72171224']], 'subnet_ipam': [{'subnet_cidr': '84.233.194.64/26', 'ipam_fq_name': ['default-domain', 'default-project', 'default-network-ipam']}, {'subnet_cidr': '383f:cefe:51ba:a76d:d777:1a9f::/96', 'ipam_fq_name': ['default-domain', 'default-project', 'default-network-ipam']}], 'port_security_enabled': True, 'description': ''}}
2026-10-26 02:59:52,317 - DEBUG - Requesting: http://10.0.0.251:8082/domains
2026-10-26 02:59:52,684 - DEBUG - Requesting: http://10.0.0.251:8082/domains
2026-10-26 02:59:52,716 - DEBUG - Requesting: http://10.0.0.251:8082/domain/88a347a6-c9cd-49cd-b26a-2cbc745dd4cb
2026-10-26 02:59:52,733 - DEBUG - Requesting: http://10.0.0.251:8082/project/aef077ee-c573-482d-ae2a-ad238a33ea06
2026-10-26 02:59:52,831 - DEBUG - Requesting: http://10.0.0.251:8082/virtual-network/f70dcbf8-d63c-469b-9d4a-b4568413daa8
2026-10-26 02:59:52,849 - DEBUG - Requesting: http://10.0.0.251:8082/virtual-network/f70dcbf8-d63c-469b-9d4a-b4568413daa8
2026-10-26 02:59:52,863 - DEBUG - Requesting: http://10.0.0.251:8082/routing-instance/8b8f2a3e-0cdf-44ec-bdd2-6c17d5ae9610
2026-10-26 02:59:52,871 - DEBUG - Requesting: http://10.0.0.251:8082/routing-instance/8b8f2a3e-0cdf-44ec-bdd2-6c17d5ae9610
2026-10-26 02:59:52,879 - DEBUG - Requesting: http://10.0.0.251:8082/route-target/5177bd31-453c-4c74-9cc3-5bb8f3e12a45
2026-10-26 02:59:52,887 - DEBUG - Route Targets: ['target:64512:8000005']
2026-10-26 02:59:52,888 - DEBUG - Requesting: http://10.0.0.251:8082/virtual-network/f70dcbf8-d63c-469b-9d4a-b4568413daa8
2026-10-26 02:59:52,899 - DEBUG - Requesting: http://10.0.0.251:8082/routing-instance/8b8f2a3e-0cdf-44ec-bdd2-6c17d5ae9610
2026-10-26 02:59:52,924 - INFO - Verified VN network id 15 for VN f70dcbf8-d63c-469b-9d4a-b4568413daa8
2026-10-26 02:59:52,925 - INFO - Verifications in API Server for VN ctest-vn4-53041430 passed
2026-10-26 02:59:52,925 - DEBUG - Requesting: http://10.0.0.251:8082/virtual-network/f70dcbf8-d63c-469b-9d4a-b4568413daa8
2026-10-26 02:59:52,940 - DEBUG - Requesting: http://10.0.0.251:8082/routing-instance/8b8f2a3e-0cdf-44ec-bdd2-6c17d5ae9610
2026-10-26 02:59:52,950 - DEBUG - Requesting: http://10.0.0.251:8082/routing-instance/8b8f2a3e-0cdf-44ec-bdd2-6c17d5ae9610
2026-10-26 02:59:52,959 - DEBUG - Requesting: http://10.0.0.251:8082/route-target/5177bd31-453c-4c74-9cc3-5bb8f3e12a45
2026-10-26 02:59:52,978 - DEBUG - Control-node 10.0.0.251 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestBasicPolicyNegativeIpv4v6-76072601:ctest-vn4-53041430', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestBasicPolicyNegativeIpv4v6-76072601', 'owner-access': '7', 'group': 'manager', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17802109171672041115', 'uuid-lslong': '11334069695907355304'}, 'enable': 'true', 'created': '2026-10-26T02:59:51', 'last-modified': '2026-10-26T02:59:52', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.789250'}
2026-10-26 02:59:52,986 - DEBUG - Route Targets: ['target:64512:8000005']
2026-10-26 02:59:52,993 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestBasicPolicyNegativeIpv4v6-76072601:ctest-vn4-53041430', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestBasicPolicyNegativeIpv4v6-76072601', 'owner-access': '7', 'group': 'manager', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17802109171672041115', 'uuid-lslong': '11334069695907355304'}, 'enable': 'true', 'created': '2026-10-26T02:59:51', 'last-modified': '2026-10-26T02:59:52', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.804607'}
2026-10-26 02:59:53,002 - DEBUG - Route Targets: ['target:64512:8000005']
2026-10-26 02:59:53,008 - DEBUG - Control-node 10.0.0.248 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestBasicPolicyNegativeIpv4v6-76072601:ctest-vn4-53041430', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestBasicPolicyNegativeIpv4v6-76072601', 'owner-access': '7', 'group': 'manager', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17802109171672041115', 'uuid-lslong': '11334069695907355304'}, 'enable': 'true', 'created': '2026-10-26T02:59:51', 'last-modified': '2026-10-26T02:59:52', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.818506'}
2026-10-26 02:59:53,014 - DEBUG - Route Targets: ['target:64512:8000005']
2026-10-26 02:59:53,015 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn4-53041430 passed
2026-10-26 02:59:53,015 - DEBUG - ====Verifying policy data for ctest-vn4-53041430 in API_Server ======
2026-10-26 02:59:53,015 - DEBUG - Requesting: http://10.0.0.251:8082/domains
2026-10-26 02:59:53,022 - DEBUG - Requesting: http://10.0.0.251:8082/domain/88a347a6-c9cd-49cd-b26a-2cbc745dd4cb
2026-10-26 02:59:53,035 - DEBUG - Requesting: http://10.0.0.251:8082/project/aef077ee-c573-482d-ae2a-ad238a33ea06
2026-10-26 02:59:53,128 - DEBUG - Requesting: http://10.0.0.251:8082/virtual-network/f70dcbf8-d63c-469b-9d4a-b4568413daa8
2026-10-26 02:59:53,141 - DEBUG - ==>Verifying data for policy with id: 1cf39c45-5c4c-4e45-97b8-9fe139fd2857, fqn: ['default-domain', 'ctest-TestBasicPolicyNegativeIpv4v6-76072601', 'ctest-policy1-72171224']
2026-10-26 02:59:53,141 - INFO - VN ctest-vn4-53041430 Policy verification: verify_vn_policy_in_api_server, status: True
2026-10-26 02:59:53,141 - DEBUG - Verifying the vn in opserver
2026-10-26 02:59:53,141 - DEBUG - Verifying the default-domain:ctest-TestBasicPolicyNegativeIpv4v6-76072601:ctest-vn4-53041430 virtual network link through opserver 10.0.0.251
2026-10-26 02:59:53,141 - DEBUG - Requesting: http://10.0.0.251:8081/analytics/uves/virtual-networks
2026-10-26 02:59:53,522 - DEBUG - Requesting: http://10.0.0.251:8081/analytics/uves/virtual-networks
2026-10-26 02:59:53,579 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestBasicPolicyNegativeIpv4v6-76072601:ctest-vn4-53041430', 'href': 'http://10.0.0.251:8081/analytics/uves/virtual-network/default-domain:ctest-TestBasicPolicyNegativeIpv4v6-76072601:ctest-vn4-53041430?flat'}
2026-10-26 02:59:53,579 - DEBUG - Verifying the default-domain:ctest-TestBasicPolicyNegativeIpv4v6-76072601:ctest-vn4-53041430 virtual network link through opserver 10.0.0.33
2026-10-26 02:59:53,580 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2026-10-26 02:59:53,955 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2026-10-26 02:59:54,021 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestBasicPolicyNegativeIpv4v6-76072601:ctest-vn4-53041430', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-TestBasicPolicyNegativeIpv4v6-76072601:ctest-vn4-53041430?flat'}
2026-10-26 02:59:54,021 - DEBUG - Verifying the default-domain:ctest-TestBasicPolicyNegativeIpv4v6-76072601:ctest-vn4-53041430 virtual network link through opserver 10.0.0.248
2026-10-26 02:59:54,021 - DEBUG - Requesting: http://10.0.0.248:8081/analytics/uves/virtual-networks
2026-10-26 02:59:54,398 - DEBUG - Requesting: http://10.0.0.248:8081/analytics/uves/virtual-networks
2026-10-26 02:59:54,449 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestBasicPolicyNegativeIpv4v6-76072601:ctest-vn4-53041430', 'href': 'http://10.0.0.248:8081/analytics/uves/virtual-network/default-domain:ctest-TestBasicPolicyNegativeIpv4v6-76072601:ctest-vn4-53041430?flat'}
2026-10-26 02:59:54,450 - INFO - Validated that VN default-domain:ctest-TestBasicPolicyNegativeIpv4v6-76072601:ctest-vn4-53041430 is found in opserver
2026-10-26 02:59:54,475 - DEBUG - Do not have enough data to verify VN in agent
2026-10-26 02:59:54,489 - DEBUG - VRF ids for VN ctest-vn4-53041430: {}
2026-10-26 02:59:54,489 - DEBUG - ====Verifying data for ctest-policy1-72171224 in API_Server ======
2026-10-26 02:59:54,489 - DEBUG - Requesting: http://10.0.0.251:8082/domains
2026-10-26 02:59:54,496 - DEBUG - Requesting: http://10.0.0.251:8082/domain/88a347a6-c9cd-49cd-b26a-2cbc745dd4cb
2026-10-26 02:59:54,510 - DEBUG - Requesting: http://10.0.0.251:8082/project/aef077ee-c573-482d-ae2a-ad238a33ea06
2026-10-26 02:59:54,627 - DEBUG - Requesting: http://10.0.0.251:8082/network-policy/1cf39c45-5c4c-4e45-97b8-9fe139fd2857
2026-10-26 02:59:54,638 - INFO - Verified policy ctest-policy1-72171224 in API Server, Result: True
2026-10-26 02:59:54,638 - INFO - Done with setup and verification, moving onto test ..
2026-10-26 02:59:54,650 - INFO - Deleting VN ctest-vn4-53041430
2026-10-26 02:59:54,832 - DEBUG - Response for deleting network ()
2026-10-26 02:59:54,833 - DEBUG - Requesting: http://10.0.0.251:8082/routing-instance/8b8f2a3e-0cdf-44ec-bdd2-6c17d5ae9610
2026-10-26 02:59:54,843 - DEBUG - Response Code: 404
2026-10-26 02:59:54,843 - DEBUG - Requesting: http://10.0.0.251:8082/domains
2026-10-26 02:59:54,849 - DEBUG - Requesting: http://10.0.0.251:8082/domain/88a347a6-c9cd-49cd-b26a-2cbc745dd4cb
2026-10-26 02:59:54,860 - DEBUG - Requesting: http://10.0.0.251:8082/project/aef077ee-c573-482d-ae2a-ad238a33ea06
2026-10-26 02:59:54,953 - INFO - Validated that VN ctest-vn4-53041430 is not found in API Server
2026-10-26 02:59:54,967 - DEBUG - VN ctest-vn4-53041430 is not present in Agent 10.0.0.50
2026-10-26 02:59:54,979 - DEBUG - VN ctest-vn4-53041430 is not present in Agent 10.0.0.38
2026-10-26 02:59:54,979 - INFO - Validated that VN ctest-vn4-53041430 is not in any agent
2026-10-26 02:59:55,016 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn4-53041430 info
2026-10-26 02:59:55,051 - INFO - Deleted policy ctest-policy1-72171224
2026-10-26 02:59:55,241 - DEBUG - policy ctest-policy1-72171224 is not found in API Server
2026-10-26 02:59:56,531 - DEBUG - No XMPP flaps were noticed during the test
2026-10-26 02:59:56,531 - INFO - END TEST : test_remove_policy_with_ref : PASSED[0:00:08]
2026-10-26 02:59:56,531 - INFO - --------------------------------------------------------------------------------
2026-10-26 02:59:57,832 - DEBUG - No XMPP flaps were noticed during the test
2026-10-26 02:59:57,832 - INFO - END TEST : test_remove_policy_with_ref : PASSED[0:00:10]
2026-10-26 02:59:57,833 - INFO - --------------------------------------------------------------------------------
2026-10-26 02:59:58,649 - INFO - Deleted project: ctest-TestBasicPolicyNegativeIpv4v6-76072601, ID : aef077ee-c573-482d-ae2a-ad238a33ea06