2026-03-23 02:34:36,672 - INFO - Domain Default found not creating 2026-03-23 02:34:36,851 - INFO - Project ctest-TestBasicPolicyModifyIpv4v6-40124791 not found, creating it 2026-03-23 02:34:37,355 - INFO - Created Project:ctest-TestBasicPolicyModifyIpv4v6-40124791, ID : bb0c6e9a-cafc-4049-8601-7d2208a46e07 2026-03-23 02:34:39,181 - INFO - ================================================================================ 2026-03-23 02:34:39,181 - INFO - STARTING TEST : test_policy_modify_vn_policy 2026-03-23 02:34:40,502 - DEBUG - Nothing to compare xmpp stats {'10.0.0.249': {'10.20.0.18': '0', '10.20.0.14': '0'}, '10.0.0.65': {'10.20.0.18': '0', '10.20.0.14': '0'}} with 2026-03-23 02:34:40,502 - INFO - Initial checks done. Running the testcase now 2026-03-23 02:34:40,502 - INFO - 2026-03-23 02:34:40,502 - INFO - ================================================================================ 2026-03-23 02:34:40,502 - INFO - STARTING TEST : test_policy_modify_vn_policy 2026-03-23 02:34:40,502 - INFO - TEST DESCRIPTION : Configure policies based on topology; 2026-03-23 02:34:41,824 - DEBUG - Nothing to compare xmpp stats {'10.0.0.249': {'10.20.0.18': '0', '10.20.0.14': '0'}, '10.0.0.65': {'10.20.0.18': '0', '10.20.0.14': '0'}} with 2026-03-23 02:34:41,824 - INFO - Initial checks done. Running the testcase now 2026-03-23 02:34:41,824 - INFO - 2026-03-23 02:34:41,824 - INFO - Scenario for the test used is: 2026-03-23 02:34:41,825 - DEBUG - Starting setup 2026-03-23 02:34:42,652 - INFO - Using existing project ['default-domain', 'ctest-TestBasicPolicyModifyIpv4v6-40124791'](bb0c6e9a-cafc-4049-8601-7d2208a46e07) 2026-03-23 02:34:42,652 - INFO - provision user admin with role as admin in tenant ctest-TestBasicPolicyModifyIpv4v6-40124791 2026-03-23 02:34:43,899 - DEBUG - Requesting: http://10.0.0.27:8082/domains 2026-03-23 02:34:44,266 - DEBUG - Requesting: http://10.0.0.27:8082/domains 2026-03-23 02:34:44,339 - DEBUG - Requesting: http://10.0.0.27:8082/domain/54adab80-1c58-45eb-8fc6-565ee3803789 2026-03-23 02:34:44,361 - DEBUG - Requesting: http://10.0.0.27:8082/project/bb0c6e9a-cafc-4049-8601-7d2208a46e07 2026-03-23 02:34:44,466 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-03-23 02:34:44,800 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-03-23 02:34:44,839 - DEBUG - Requesting: http://10.0.0.50:8082/domain/54adab80-1c58-45eb-8fc6-565ee3803789 2026-03-23 02:34:44,856 - DEBUG - Requesting: http://10.0.0.50:8082/project/bb0c6e9a-cafc-4049-8601-7d2208a46e07 2026-03-23 02:34:44,944 - DEBUG - Requesting: http://10.0.0.23:8082/domains 2026-03-23 02:34:45,322 - DEBUG - Requesting: http://10.0.0.23:8082/domains 2026-03-23 02:34:45,362 - DEBUG - Requesting: http://10.0.0.23:8082/domain/54adab80-1c58-45eb-8fc6-565ee3803789 2026-03-23 02:34:45,375 - DEBUG - Requesting: http://10.0.0.23:8082/project/bb0c6e9a-cafc-4049-8601-7d2208a46e07 2026-03-23 02:34:45,467 - INFO - Verification of project ctest-TestBasicPolicyModifyIpv4v6-40124791 in API Server 10.0.0.23 passed 2026-03-23 02:34:45,767 - DEBUG - Requesting: http://10.0.0.27:8082/domains 2026-03-23 02:34:45,773 - DEBUG - Requesting: http://10.0.0.27:8082/domain/54adab80-1c58-45eb-8fc6-565ee3803789 2026-03-23 02:34:45,788 - DEBUG - Requesting: http://10.0.0.27:8082/project/bb0c6e9a-cafc-4049-8601-7d2208a46e07 2026-03-23 02:34:45,894 - DEBUG - Requesting: http://10.0.0.27:8082/network-ipam/ec5daec3-6b8d-4820-8300-0980411fc4f2 2026-03-23 02:34:45,907 - INFO - Verifications in API Server for IPAM: ctest-TestBasicPolicyModifyIpv4v6-40124791-default-ipam passed 2026-03-23 02:34:45,913 - DEBUG - Control-node 10.0.0.27 : IPAM object is : {'node_name': 'network-ipam:default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-TestBasicPolicyModifyIpv4v6-40124791-default-ipam', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestBasicPolicyModifyIpv4v6-40124791', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17031961520131360800', 'uuid-lslong': '9439555265421624562'}, 'enable': 'true', 'created': '2026-03-23T02:34:45', 'last-modified': '2026-03-23T02:34:45', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.175970'} 2026-03-23 02:34:45,919 - DEBUG - Control-node 10.0.0.50 : IPAM object is : {'node_name': 'network-ipam:default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-TestBasicPolicyModifyIpv4v6-40124791-default-ipam', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestBasicPolicyModifyIpv4v6-40124791', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17031961520131360800', 'uuid-lslong': '9439555265421624562'}, 'enable': 'true', 'created': '2026-03-23T02:34:45', 'last-modified': '2026-03-23T02:34:45', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.178439'} 2026-03-23 02:34:45,925 - DEBUG - Control-node 10.0.0.23 : IPAM object is : {'node_name': 'network-ipam:default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-TestBasicPolicyModifyIpv4v6-40124791-default-ipam', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestBasicPolicyModifyIpv4v6-40124791', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17031961520131360800', 'uuid-lslong': '9439555265421624562'}, 'enable': 'true', 'created': '2026-03-23T02:34:45', 'last-modified': '2026-03-23T02:34:45', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.185675'} 2026-03-23 02:34:45,925 - INFO - Verifications in Control node for IPAM: ctest-TestBasicPolicyModifyIpv4v6-40124791-default-ipam passed 2026-03-23 02:34:46,609 - DEBUG - Response for create_network : {'network': {'id': 'fd03ad8c-4f56-4d5f-871e-13bd0f86bb12', 'name': 'ctest-vnet0-85453305', 'tenant_id': 'bb0c6e9acafc404986017d2208a46e07', 'project_id': 'bb0c6e9acafc404986017d2208a46e07', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestBasicPolicyModifyIpv4v6-40124791', 'ctest-vnet0-85453305'], 'port_security_enabled': True, 'description': ''}} 2026-03-23 02:34:46,947 - DEBUG - Response for create_subnet : {'subnet': {'id': 'a9921f4e-3c71-465e-b47a-83d76ed6bac2', 'name': '', 'tenant_id': 'bb0c6e9acafc404986017d2208a46e07', 'network_id': 'fd03ad8c-4f56-4d5f-871e-13bd0f86bb12', 'ip_version': 4, 'cidr': '126.222.217.0/26', 'allocation_pools': [{'start': '126.222.217.2', 'end': '126.222.217.62'}], 'gateway_ip': '126.222.217.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '126.222.217.2', 'tags': [], 'project_id': 'bb0c6e9acafc404986017d2208a46e07'}} 2026-03-23 02:34:47,192 - DEBUG - Response for create_subnet : {'subnet': {'id': 'a7d20a6a-56d8-4f94-badd-26c4029aa73a', 'name': '', 'tenant_id': 'bb0c6e9acafc404986017d2208a46e07', 'network_id': 'fd03ad8c-4f56-4d5f-871e-13bd0f86bb12', 'ip_version': 6, 'cidr': '37ea:d6cb:7e0b:736f:ef08:abaf::/96', 'allocation_pools': [{'start': '37ea:d6cb:7e0b:736f:ef08:abaf:0:2', 'end': '37ea:d6cb:7e0b:736f:ef08:abaf:ffff:fffe'}], 'gateway_ip': '37ea:d6cb:7e0b:736f:ef08:abaf:0:1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '37ea:d6cb:7e0b:736f:ef08:abaf:0:2', 'tags': [], 'project_id': 'bb0c6e9acafc404986017d2208a46e07'}} 2026-03-23 02:34:47,223 - INFO - Created VN ctest-vnet0-85453305 2026-03-23 02:34:47,235 - DEBUG - VN ctest-vnet0-85453305 UUID is fd03ad8c-4f56-4d5f-871e-13bd0f86bb12 2026-03-23 02:34:47,364 - DEBUG - Requesting: http://10.0.0.27:8082/domains 2026-03-23 02:34:47,684 - DEBUG - Requesting: http://10.0.0.27:8082/domains 2026-03-23 02:34:47,721 - DEBUG - Requesting: http://10.0.0.27:8082/domain/54adab80-1c58-45eb-8fc6-565ee3803789 2026-03-23 02:34:47,734 - DEBUG - Requesting: http://10.0.0.27:8082/project/bb0c6e9a-cafc-4049-8601-7d2208a46e07 2026-03-23 02:34:47,839 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/fd03ad8c-4f56-4d5f-871e-13bd0f86bb12 2026-03-23 02:34:47,852 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/fd03ad8c-4f56-4d5f-871e-13bd0f86bb12 2026-03-23 02:34:47,862 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/7e0cea07-dfcf-4bd2-92b0-a2d71d7f35b2 2026-03-23 02:34:47,872 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/7e0cea07-dfcf-4bd2-92b0-a2d71d7f35b2 2026-03-23 02:34:47,880 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/a3e3cf6b-e343-43dd-a7ef-f57d75a47338 2026-03-23 02:34:47,890 - DEBUG - Route Targets: ['target:64512:8000004'] 2026-03-23 02:34:47,890 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/fd03ad8c-4f56-4d5f-871e-13bd0f86bb12 2026-03-23 02:34:47,902 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/7e0cea07-dfcf-4bd2-92b0-a2d71d7f35b2 2026-03-23 02:34:47,925 - INFO - Verified VN network id 15 for VN fd03ad8c-4f56-4d5f-871e-13bd0f86bb12 2026-03-23 02:34:47,925 - INFO - Verifications in API Server for VN ctest-vnet0-85453305 passed 2026-03-23 02:34:47,925 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/fd03ad8c-4f56-4d5f-871e-13bd0f86bb12 2026-03-23 02:34:47,939 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/7e0cea07-dfcf-4bd2-92b0-a2d71d7f35b2 2026-03-23 02:34:47,950 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/7e0cea07-dfcf-4bd2-92b0-a2d71d7f35b2 2026-03-23 02:34:47,961 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/a3e3cf6b-e343-43dd-a7ef-f57d75a47338 2026-03-23 02:34:47,977 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'admin', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '18231606534663982431', 'uuid-lslong': '9736241147151825682'}, 'enable': 'true', 'created': '2026-03-23T02:34:46', 'last-modified': '2026-03-23T02:34:47', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.833949'} 2026-03-23 02:34:47,988 - DEBUG - Route Targets: ['target:64512:8000004'] 2026-03-23 02:34:47,996 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'admin', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '18231606534663982431', 'uuid-lslong': '9736241147151825682'}, 'enable': 'true', 'created': '2026-03-23T02:34:46', 'last-modified': '2026-03-23T02:34:47', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.856115'} 2026-03-23 02:34:48,004 - DEBUG - Route Targets: ['target:64512:8000004'] 2026-03-23 02:34:48,010 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'admin', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '18231606534663982431', 'uuid-lslong': '9736241147151825682'}, 'enable': 'true', 'created': '2026-03-23T02:34:46', 'last-modified': '2026-03-23T02:34:47', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.868711'} 2026-03-23 02:34:48,017 - DEBUG - Route Targets: ['target:64512:8000004'] 2026-03-23 02:34:48,017 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vnet0-85453305 passed 2026-03-23 02:34:48,017 - DEBUG - ====Verifying policy data for ctest-vnet0-85453305 in API_Server ====== 2026-03-23 02:34:48,017 - DEBUG - Requesting: http://10.0.0.27:8082/domains 2026-03-23 02:34:48,025 - DEBUG - Requesting: http://10.0.0.27:8082/domain/54adab80-1c58-45eb-8fc6-565ee3803789 2026-03-23 02:34:48,040 - DEBUG - Requesting: http://10.0.0.27:8082/project/bb0c6e9a-cafc-4049-8601-7d2208a46e07 2026-03-23 02:34:48,159 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/fd03ad8c-4f56-4d5f-871e-13bd0f86bb12 2026-03-23 02:34:48,173 - DEBUG - =>VN ctest-vnet0-85453305 has no policy to be verified 2026-03-23 02:34:48,173 - DEBUG - Verifying the vn in opserver 2026-03-23 02:34:48,173 - DEBUG - Verifying the default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305 virtual network link through opserver 10.0.0.27 2026-03-23 02:34:48,174 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks 2026-03-23 02:34:48,498 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks 2026-03-23 02:34:48,576 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305?flat'} 2026-03-23 02:34:48,576 - DEBUG - Verifying the default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305 virtual network link through opserver 10.0.0.50 2026-03-23 02:34:48,576 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks 2026-03-23 02:34:48,891 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks 2026-03-23 02:34:48,959 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305?flat'} 2026-03-23 02:34:48,959 - DEBUG - Verifying the default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305 virtual network link through opserver 10.0.0.23 2026-03-23 02:34:48,959 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks 2026-03-23 02:34:49,284 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks 2026-03-23 02:34:49,374 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305?flat'} 2026-03-23 02:34:49,374 - INFO - Validated that VN default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305 is found in opserver 2026-03-23 02:34:49,398 - DEBUG - Do not have enough data to verify VN in agent 2026-03-23 02:34:49,410 - DEBUG - VRF ids for VN ctest-vnet0-85453305: {} 2026-03-23 02:34:49,416 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = >, protocol = tcp, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305, security_group = None, network_policy = None, subnet_list = []], src_ports = [start_port = 0, end_port = 0], application = [], dst_addresses = [subnet = None, virtual_network = default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305, security_group = None, network_policy = None, subnet_list = []], dst_ports = [start_port = -1, end_port = -1], action_list = simple_action = deny, 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 = tcp, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305, 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-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305, security_group = None, network_policy = None, subnet_list = []], dst_ports = [start_port = -1, end_port = -1], action_list = simple_action = deny, 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 = tcp, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305, security_group = None, network_policy = None, subnet_list = []], src_ports = [start_port = 2, end_port = 2], application = [], dst_addresses = [subnet = None, virtual_network = default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305, security_group = None, network_policy = None, subnet_list = []], dst_ports = [start_port = -1, end_port = -1], action_list = simple_action = deny, 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-03-23 02:34:49,689 - DEBUG - ====Verifying data for ctest-policy0-05695839 in API_Server ====== 2026-03-23 02:34:49,690 - DEBUG - Requesting: http://10.0.0.27:8082/domains 2026-03-23 02:34:49,703 - DEBUG - Requesting: http://10.0.0.27:8082/domain/54adab80-1c58-45eb-8fc6-565ee3803789 2026-03-23 02:34:49,716 - DEBUG - Requesting: http://10.0.0.27:8082/project/bb0c6e9a-cafc-4049-8601-7d2208a46e07 2026-03-23 02:34:49,832 - DEBUG - Requesting: http://10.0.0.27:8082/network-policy/d1dd2d1f-892e-457b-a4fa-74f596ceaed4 2026-03-23 02:34:49,843 - INFO - Verified policy ctest-policy0-05695839 in API Server, Result: True 2026-03-23 02:34:49,849 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = >, protocol = icmp, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305, 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-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305, security_group = None, network_policy = None, subnet_list = []], dst_ports = [start_port = -1, end_port = -1], action_list = simple_action = deny, 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-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305, 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-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305, security_group = None, network_policy = None, subnet_list = []], dst_ports = [start_port = -1, end_port = -1], action_list = simple_action = deny, 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-03-23 02:34:50,120 - DEBUG - ====Verifying data for ctest-policy1-79926995 in API_Server ====== 2026-03-23 02:34:50,120 - DEBUG - Requesting: http://10.0.0.27:8082/domains 2026-03-23 02:34:50,126 - DEBUG - Requesting: http://10.0.0.27:8082/domain/54adab80-1c58-45eb-8fc6-565ee3803789 2026-03-23 02:34:50,138 - DEBUG - Requesting: http://10.0.0.27:8082/project/bb0c6e9a-cafc-4049-8601-7d2208a46e07 2026-03-23 02:34:50,244 - DEBUG - Requesting: http://10.0.0.27:8082/network-policy/e1c1fe20-02a7-43ce-bb2e-14eb3b7241a5 2026-03-23 02:34:50,256 - INFO - Verified policy ctest-policy1-79926995 in API Server, Result: True 2026-03-23 02:34:50,303 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = >, protocol = udp, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305, security_group = None, network_policy = None, subnet_list = []], src_ports = [start_port = 10, end_port = 10], application = [], dst_addresses = [subnet = None, virtual_network = default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305, security_group = None, network_policy = None, subnet_list = []], dst_ports = [start_port = -1, end_port = -1], action_list = simple_action = deny, 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-03-23 02:34:50,533 - DEBUG - ====Verifying data for ctest-policy2-01864600 in API_Server ====== 2026-03-23 02:34:50,534 - DEBUG - Requesting: http://10.0.0.27:8082/domains 2026-03-23 02:34:50,541 - DEBUG - Requesting: http://10.0.0.27:8082/domain/54adab80-1c58-45eb-8fc6-565ee3803789 2026-03-23 02:34:50,555 - DEBUG - Requesting: http://10.0.0.27:8082/project/bb0c6e9a-cafc-4049-8601-7d2208a46e07 2026-03-23 02:34:50,664 - DEBUG - Requesting: http://10.0.0.27:8082/network-policy/999b3f1b-8812-48ec-bcd1-1edddeb06ff0 2026-03-23 02:34:50,689 - INFO - Verified policy ctest-policy2-01864600 in API Server, Result: True 2026-03-23 02:34:50,689 - DEBUG - Requesting: http://10.0.0.27:8082/domains 2026-03-23 02:34:50,697 - DEBUG - Requesting: http://10.0.0.27:8082/domain/54adab80-1c58-45eb-8fc6-565ee3803789 2026-03-23 02:34:50,709 - DEBUG - Requesting: http://10.0.0.27:8082/project/bb0c6e9a-cafc-4049-8601-7d2208a46e07 2026-03-23 02:34:50,805 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/fd03ad8c-4f56-4d5f-871e-13bd0f86bb12 2026-03-23 02:34:50,822 - DEBUG - Setup step: Associating the policy to VN' 2026-03-23 02:34:51,024 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': 'fd03ad8c-4f56-4d5f-871e-13bd0f86bb12', 'name': 'ctest-vnet0-85453305', 'tenant_id': 'bb0c6e9acafc404986017d2208a46e07', 'project_id': 'bb0c6e9acafc404986017d2208a46e07', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['a9921f4e-3c71-465e-b47a-83d76ed6bac2', 'a7d20a6a-56d8-4f94-badd-26c4029aa73a'], 'fq_name': ['default-domain', 'ctest-TestBasicPolicyModifyIpv4v6-40124791', 'ctest-vnet0-85453305'], 'policys': [['default-domain', 'ctest-TestBasicPolicyModifyIpv4v6-40124791', 'ctest-policy0-05695839'], ['default-domain', 'ctest-TestBasicPolicyModifyIpv4v6-40124791', 'ctest-policy1-79926995']], 'subnet_ipam': [{'subnet_cidr': '126.222.217.0/26', 'ipam_fq_name': ['default-domain', 'ctest-TestBasicPolicyModifyIpv4v6-40124791', 'ctest-TestBasicPolicyModifyIpv4v6-40124791-default-ipam']}, {'subnet_cidr': '37ea:d6cb:7e0b:736f:ef08:abaf::/96', 'ipam_fq_name': ['default-domain', 'ctest-TestBasicPolicyModifyIpv4v6-40124791', 'ctest-TestBasicPolicyModifyIpv4v6-40124791-default-ipam']}], 'port_security_enabled': True, 'description': ''}} 2026-03-23 02:34:51,208 - DEBUG - Associated Policy:[['default-domain', 'ctest-TestBasicPolicyModifyIpv4v6-40124791', 'ctest-policy0-05695839'], ['default-domain', 'ctest-TestBasicPolicyModifyIpv4v6-40124791', 'ctest-policy1-79926995']] to ctest-vnet0-85453305 2026-03-23 02:34:51,239 - DEBUG - Services list from nova: [, , , ] 2026-03-23 02:34:51,239 - DEBUG - Hosts: {'nova': ['an-jenkins-deploy-platform-ansible-os-5514-2', 'an-jenkins-deploy-platform-ansible-os-5514-1']} 2026-03-23 02:34:51,361 - DEBUG - Services list from nova: [, , , ] 2026-03-23 02:34:52,592 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5514-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5514-2) 2026-03-23 02:34:52,592 - DEBUG - Setup step: Verify VM status and install Traffic package... 2026-03-23 02:34:52,592 - INFO - Waiting for VM ctest-vmc0-86263273 to be up.. 2026-03-23 02:34:52,643 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-03-23 02:34:57,748 - DEBUG - VM is in ACTIVE state now 2026-03-23 02:34:57,748 - INFO - VM name : ctest-vmc0-86263273 2026-03-23 02:34:57,839 - DEBUG - VM ctest-vmc0-86263273 ID is d41a23a0-90ed-47a4-92f2-ad81060cd653 2026-03-23 02:34:57,871 - DEBUG - VM ctest-vmc0-86263273 launched on Node an-jenkins-deploy-platform-ansible-os-5514-2 2026-03-23 02:34:57,963 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/d41a23a0-90ed-47a4-92f2-ad81060cd653 2026-03-23 02:34:58,271 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/d41a23a0-90ed-47a4-92f2-ad81060cd653 2026-03-23 02:34:58,313 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/5b4e94ee-e143-432f-a94e-d7aed1ef6ced 2026-03-23 02:35:01,512 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1023ms') 2026-03-23 02:35:01,512 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vmc0-86263273 failed! 2026-03-23 02:35:01,528 - DEBUG - Gateway for vn default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305 is 126.222.217.1 and allocation pool is NOT set 2026-03-23 02:35:01,528 - DEBUG - Gateway for vn default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305 is 37ea:d6cb:7e0b:736f:ef08:abaf:0:1 and allocation pool is NOT set 2026-03-23 02:35:05,604 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1013ms') 2026-03-23 02:35:05,604 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vmc0-86263273 failed! 2026-03-23 02:35:05,620 - DEBUG - Gateway for vn default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305 is 126.222.217.1 and allocation pool is NOT set 2026-03-23 02:35:05,620 - DEBUG - Gateway for vn default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305 is 37ea:d6cb:7e0b:736f:ef08:abaf:0:1 and allocation pool is NOT set 2026-03-23 02:35:09,706 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1022ms') 2026-03-23 02:35:09,706 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vmc0-86263273 failed! 2026-03-23 02:35:09,720 - DEBUG - Gateway for vn default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305 is 126.222.217.1 and allocation pool is NOT set 2026-03-23 02:35:09,720 - DEBUG - Gateway for vn default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305 is 37ea:d6cb:7e0b:736f:ef08:abaf:0:1 and allocation pool is NOT set 2026-03-23 02:35:13,800 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1017ms') 2026-03-23 02:35:13,800 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vmc0-86263273 failed! 2026-03-23 02:35:13,815 - DEBUG - Gateway for vn default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305 is 126.222.217.1 and allocation pool is NOT set 2026-03-23 02:35:13,815 - DEBUG - Gateway for vn default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305 is 37ea:d6cb:7e0b:736f:ef08:abaf:0:1 and allocation pool is NOT set 2026-03-23 02:35:17,896 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1017ms') 2026-03-23 02:35:17,897 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vmc0-86263273 failed! 2026-03-23 02:35:17,911 - DEBUG - Gateway for vn default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305 is 126.222.217.1 and allocation pool is NOT set 2026-03-23 02:35:17,911 - DEBUG - Gateway for vn default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305 is 37ea:d6cb:7e0b:736f:ef08:abaf:0:1 and allocation pool is NOT set 2026-03-23 02:35:21,995 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1018ms') 2026-03-23 02:35:21,996 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vmc0-86263273 failed! 2026-03-23 02:35:22,055 - DEBUG - Gateway for vn default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305 is 126.222.217.1 and allocation pool is NOT set 2026-03-23 02:35:22,055 - DEBUG - Gateway for vn default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305 is 37ea:d6cb:7e0b:736f:ef08:abaf:0:1 and allocation pool is NOT set 2026-03-23 02:35:26,153 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1034ms') 2026-03-23 02:35:26,153 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vmc0-86263273 failed! 2026-03-23 02:35:26,166 - DEBUG - Gateway for vn default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305 is 126.222.217.1 and allocation pool is NOT set 2026-03-23 02:35:26,166 - DEBUG - Gateway for vn default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305 is 37ea:d6cb:7e0b:736f:ef08:abaf:0:1 and allocation pool is NOT set 2026-03-23 02:35:30,244 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1016ms') 2026-03-23 02:35:30,245 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vmc0-86263273 failed! 2026-03-23 02:35:30,259 - DEBUG - Gateway for vn default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305 is 126.222.217.1 and allocation pool is NOT set 2026-03-23 02:35:30,259 - DEBUG - Gateway for vn default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305 is 37ea:d6cb:7e0b:736f:ef08:abaf:0:1 and allocation pool is NOT set 2026-03-23 02:35:34,342 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1020ms') 2026-03-23 02:35:34,342 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vmc0-86263273 failed! 2026-03-23 02:35:34,357 - DEBUG - Gateway for vn default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305 is 126.222.217.1 and allocation pool is NOT set 2026-03-23 02:35:34,357 - DEBUG - Gateway for vn default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305 is 37ea:d6cb:7e0b:736f:ef08:abaf:0:1 and allocation pool is NOT set 2026-03-23 02:35:36,429 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n64 bytes from 169.254.0.3: icmp_seq=1 ttl=63 time=8.21 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.668 ms\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1001ms\r\nrtt min/avg/max/mdev = 0.668/4.436/8.205/3.768 ms') 2026-03-23 02:35:36,429 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-vmc0-86263273 passed 2026-03-23 02:35:36,501 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-03-23 02:35:36,501 - DEBUG - Waiting to SSH to VM ctest-vmc0-86263273, IP 126.222.217.3, Port 22 2026-03-23 02:35:36,572 - DEBUG - Error on ssh to ubuntu@169.254.0.3:22, result: /bin/bash: connect: Connection refused /bin/bash: line 1: /dev/tcp/169.254.0.3/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.3/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.3/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''} 2026-03-23 02:35:36,670 - DEBUG - VM ctest-vmc0-86263273 is NOT ready for SSH connections, VM status: ACTIVE 2026-03-23 02:35:41,671 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-03-23 02:35:41,671 - DEBUG - Waiting to SSH to VM ctest-vmc0-86263273, IP 126.222.217.3, Port 22 2026-03-23 02:35:41,743 - DEBUG - Error on ssh to ubuntu@169.254.0.3:22, result: /bin/bash: connect: Connection refused /bin/bash: line 1: /dev/tcp/169.254.0.3/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.3/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.3/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''} 2026-03-23 02:35:41,839 - DEBUG - VM ctest-vmc0-86263273 is NOT ready for SSH connections, VM status: ACTIVE 2026-03-23 02:35:46,840 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-03-23 02:35:46,840 - DEBUG - Waiting to SSH to VM ctest-vmc0-86263273, IP 126.222.217.3, Port 22 2026-03-23 02:35:46,909 - DEBUG - Error on ssh to ubuntu@169.254.0.3:22, result: /bin/bash: connect: Connection refused /bin/bash: line 1: /dev/tcp/169.254.0.3/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.3/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.3/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''} 2026-03-23 02:35:46,994 - DEBUG - VM ctest-vmc0-86263273 is NOT ready for SSH connections, VM status: ACTIVE 2026-03-23 02:35:51,995 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-03-23 02:35:51,996 - DEBUG - Waiting to SSH to VM ctest-vmc0-86263273, IP 126.222.217.3, Port 22 2026-03-23 02:35:52,065 - DEBUG - Error on ssh to ubuntu@169.254.0.3:22, result: /bin/bash: connect: Connection refused /bin/bash: line 1: /dev/tcp/169.254.0.3/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.3/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.3/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''} 2026-03-23 02:35:52,161 - DEBUG - VM ctest-vmc0-86263273 is NOT ready for SSH connections, VM status: ACTIVE 2026-03-23 02:35:57,162 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-03-23 02:35:57,162 - DEBUG - Waiting to SSH to VM ctest-vmc0-86263273, IP 126.222.217.3, Port 22 2026-03-23 02:35:57,228 - DEBUG - Error on ssh to ubuntu@169.254.0.3:22, result: /bin/bash: connect: Connection refused /bin/bash: line 1: /dev/tcp/169.254.0.3/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.3/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.3/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''} 2026-03-23 02:35:57,327 - DEBUG - VM ctest-vmc0-86263273 is NOT ready for SSH connections, VM status: ACTIVE 2026-03-23 02:36:02,327 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-03-23 02:36:02,328 - DEBUG - Waiting to SSH to VM ctest-vmc0-86263273, IP 126.222.217.3, Port 22 2026-03-23 02:36:02,500 - DEBUG - VM ctest-vmc0-86263273 is ready for SSH connections 2026-03-23 02:36:02,508 - DEBUG - Skipping the policy rule comparison since VM's are not exist for selected project:admin 2026-03-23 02:36:02,508 - DEBUG - Skipping the policy rule comparison since VM's are not exist for selected project:ctest-TestECMPIPv6Fragments-99033287 2026-03-23 02:36:02,508 - DEBUG - Skipping the policy rule comparison since VM's are not exist for selected project:ctest-TestBasicPolicyIpv4v6-52947145 2026-03-23 02:36:02,739 - DEBUG - Requesting: http://10.0.0.27:8082/domains 2026-03-23 02:36:02,746 - DEBUG - Requesting: http://10.0.0.27:8082/domain/54adab80-1c58-45eb-8fc6-565ee3803789 2026-03-23 02:36:02,760 - DEBUG - Requesting: http://10.0.0.27:8082/project/bb0c6e9a-cafc-4049-8601-7d2208a46e07 2026-03-23 02:36:02,853 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/fd03ad8c-4f56-4d5f-871e-13bd0f86bb12 2026-03-23 02:36:02,871 - DEBUG - Order of the policy's list:['ctest-policy0-05695839', 'ctest-policy1-79926995'] 2026-03-23 02:36:02,883 - DEBUG - , ['ctest-policy0-05695839', 'ctest-policy1-79926995'], ['admin', 'ctest-TestECMPIPv6Fragments-99033287', 'ctest-TestBasicPolicyIpv4v6-52947145', 'ctest-TestBasicPolicyModifyIpv4v6-40124791'], [], ['ctest-vnet0-85453305'] 2026-03-23 02:36:02,883 - DEBUG - Traslation of quantum rules to ACES format 2026-03-23 02:36:02,883 - DEBUG - vn is ctest-vnet0-85453305, vn_policy is ctest-policy0-05695839 2026-03-23 02:36:02,941 - DEBUG - , ['ctest-policy0-05695839', 'ctest-policy1-79926995'], ['admin', 'ctest-TestECMPIPv6Fragments-99033287', 'ctest-TestBasicPolicyIpv4v6-52947145', 'ctest-TestBasicPolicyModifyIpv4v6-40124791'], [], ['ctest-vnet0-85453305'] 2026-03-23 02:36:02,942 - DEBUG - Traslation of quantum rules to ACES format 2026-03-23 02:36:02,942 - DEBUG - vn is ctest-vnet0-85453305, vn_policy is ctest-policy1-79926995 2026-03-23 02:36:02,942 - DEBUG - VN: ctest-vnet0-85453305, expected ACE's is 2026-03-23 02:36:02,942 - DEBUG - {"ace_id": "1", "action_l": [{"alert": false, "apply_service": [], "assign_routing_instance": null, "gateway_name": null, "host_based_service": false, "log": false, "mirror_to": null, "qos_action": null, "service_properties": null, "simple_action": "deny"}], "dst": "default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305", "dst_port_l": {"max": "65535", "min": "0"}, "proto_l": {"max": "tcp", "min": "tcp"}, "rule_type": "Terminal", "src": "default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305", "src_port_l": {"max": "0", "min": "0"}} 2026-03-23 02:36:02,942 - DEBUG - {"ace_id": "2", "action_l": [{"alert": false, "apply_service": [], "assign_routing_instance": null, "gateway_name": null, "host_based_service": false, "log": false, "mirror_to": null, "qos_action": null, "service_properties": null, "simple_action": "deny"}], "dst": "default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305", "dst_port_l": {"max": "65535", "min": "0"}, "proto_l": {"max": "tcp", "min": "tcp"}, "rule_type": "Terminal", "src": "default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305", "src_port_l": {"max": "1", "min": "1"}} 2026-03-23 02:36:02,942 - DEBUG - {"ace_id": "3", "action_l": [{"alert": false, "apply_service": [], "assign_routing_instance": null, "gateway_name": null, "host_based_service": false, "log": false, "mirror_to": null, "qos_action": null, "service_properties": null, "simple_action": "deny"}], "dst": "default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305", "dst_port_l": {"max": "65535", "min": "0"}, "proto_l": {"max": "tcp", "min": "tcp"}, "rule_type": "Terminal", "src": "default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305", "src_port_l": {"max": "2", "min": "2"}} 2026-03-23 02:36:02,942 - DEBUG - {"ace_id": "4", "action_l": [{"alert": false, "apply_service": [], "assign_routing_instance": null, "gateway_name": null, "host_based_service": false, "log": false, "mirror_to": null, "qos_action": null, "service_properties": null, "simple_action": "deny"}], "dst": "default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305", "dst_port_l": {"max": "65535", "min": "0"}, "proto_l": {"max": "icmp", "min": "icmp"}, "rule_type": "Terminal", "src": "default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305", "src_port_l": {"max": "65535", "min": "0"}} 2026-03-23 02:36:02,942 - DEBUG - {"ace_id": "5", "action_l": [{"alert": false, "apply_service": [], "assign_routing_instance": null, "gateway_name": null, "host_based_service": false, "log": false, "mirror_to": null, "qos_action": null, "service_properties": null, "simple_action": "deny"}], "dst": "default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305", "dst_port_l": {"max": "65535", "min": "0"}, "proto_l": {"max": "58", "min": "58"}, "rule_type": "Terminal", "src": "default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305", "src_port_l": {"max": "65535", "min": "0"}} 2026-03-23 02:36:02,942 - DEBUG - {"ace_id": "6", "action_l": ["pass"], "dst": "default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305", "dst_port_l": {"max": "65535", "min": "0"}, "proto_l": {"max": "255", "min": "0"}, "rule_type": "Terminal", "src": "default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305", "src_port_l": {"max": "65535", "min": "0"}} 2026-03-23 02:36:02,942 - DEBUG - {"ace_id": "7", "action_l": ["pass"], "dst": "any", "dst_port_l": {"max": "65535", "min": "0"}, "proto_l": {"max": "255", "min": "0"}, "rule_type": "Terminal", "src": "any", "src_port_l": {"max": "65535", "min": "0"}} 2026-03-23 02:36:02,942 - DEBUG - Verify rules expected in CN if VN-VM in CN 2026-03-23 02:36:02,942 - DEBUG - CN: 10.0.0.249, Check for expected data 2026-03-23 02:36:02,950 - DEBUG - Verify rules expected in CN if VN-VM in CN 2026-03-23 02:36:02,950 - DEBUG - CN: 10.0.0.65, Check for expected data 2026-03-23 02:36:02,983 - DEBUG - ---------------------------------------- 2026-03-23 02:36:02,983 - DEBUG - CN: 10.0.0.65, VN: ctest-vnet0-85453305, result of expected rules check passed 2026-03-23 02:36:02,983 - INFO - Validated the rules for VM:ctest-vmc0-86263273 with attached policy:['ctest-policy0-05695839', 'ctest-policy1-79926995'] and vn:ctest-vnet0-85453305 2026-03-23 02:36:02,983 - DEBUG - Verify policy rules for other vn if it is present 2026-03-23 02:36:02,983 - INFO - Policy rules comparison with system for all Virtual networks are done 2026-03-23 02:36:02,984 - DEBUG - Starting Verifications after setup 2026-03-23 02:36:02,984 - DEBUG - Starting verify_policy_in_vna 2026-03-23 02:36:02,984 - DEBUG - vn is ctest-vnet0-85453305, scn.vn_policy is ['ctest-policy0-05695839', 'ctest-policy1-79926995'] 2026-03-23 02:36:02,984 - DEBUG - [{"action_l": ["deny"], "direction": ">", "dst": "ctest-vnet0-85453305", "dst_port_l": {"max": "65535", "min": "0"}, "proto_l": {"max": "255", "min": "0"}, "simple_action": "deny", "src": "ctest-vnet0-85453305", "src_port_l": {"max": "65535", "min": "0"}}, {"action_l": ["deny"], "direction": ">", "dst": "ctest-vnet0-85453305", "dst_port_l": {"max": "65535", "min": "0"}, "proto_l": {"max": "255", "min": "0"}, "simple_action": "deny", "src": "ctest-vnet0-85453305", "src_port_l": {"max": "65535", "min": "0"}}, {"action_l": ["deny"], "direction": ">", "dst": "ctest-vnet0-85453305", "dst_port_l": {"max": "65535", "min": "0"}, "proto_l": {"max": "255", "min": "0"}, "simple_action": "deny", "src": "ctest-vnet0-85453305", "src_port_l": {"max": "65535", "min": "0"}}, {"action_l": ["deny"], "direction": ">", "dst": "ctest-vnet0-85453305", "dst_port_l": {"max": "65535", "min": "0"}, "proto_l": {"max": "255", "min": "0"}, "simple_action": "deny", "src": "ctest-vnet0-85453305", "src_port_l": {"max": "65535", "min": "0"}}, {"action_l": ["deny"], "direction": ">", "dst": "ctest-vnet0-85453305", "dst_port_l": {"max": "65535", "min": "0"}, "proto_l": {"max": "255", "min": "0"}, "simple_action": "deny", "src": "ctest-vnet0-85453305", "src_port_l": {"max": "65535", "min": "0"}}] 2026-03-23 02:36:02,985 - DEBUG - VN: ctest-vnet0-85453305, expected ACE's is 2026-03-23 02:36:02,985 - DEBUG - {"ace_id": "1", "action_l": ["deny"], "dst": "default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305", "dst_port_l": {"max": "65535", "min": "0"}, "proto_l": {"max": "tcp", "min": "tcp"}, "rule_type": "Terminal", "src": "default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305", "src_port_l": {"max": "0", "min": "0"}} 2026-03-23 02:36:02,985 - DEBUG - {"ace_id": "2", "action_l": ["deny"], "dst": "default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305", "dst_port_l": {"max": "65535", "min": "0"}, "proto_l": {"max": "tcp", "min": "tcp"}, "rule_type": "Terminal", "src": "default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305", "src_port_l": {"max": "1", "min": "1"}} 2026-03-23 02:36:02,985 - DEBUG - {"ace_id": "3", "action_l": ["deny"], "dst": "default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305", "dst_port_l": {"max": "65535", "min": "0"}, "proto_l": {"max": "tcp", "min": "tcp"}, "rule_type": "Terminal", "src": "default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305", "src_port_l": {"max": "2", "min": "2"}} 2026-03-23 02:36:02,985 - DEBUG - {"ace_id": "4", "action_l": ["deny"], "dst": "default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305", "dst_port_l": {"max": "65535", "min": "0"}, "proto_l": {"max": "icmp", "min": "icmp"}, "rule_type": "Terminal", "src": "default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305", "src_port_l": {"max": "65535", "min": "0"}} 2026-03-23 02:36:02,985 - DEBUG - {"ace_id": "5", "action_l": ["deny"], "dst": "default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305", "dst_port_l": {"max": "65535", "min": "0"}, "proto_l": {"max": "58", "min": "58"}, "rule_type": "Terminal", "src": "default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305", "src_port_l": {"max": "65535", "min": "0"}} 2026-03-23 02:36:02,985 - DEBUG - {"ace_id": "6", "action_l": ["pass"], "dst": "default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305", "dst_port_l": {"max": "65535", "min": "0"}, "proto_l": {"max": "255", "min": "0"}, "rule_type": "Terminal", "src": "default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305", "src_port_l": {"max": "65535", "min": "0"}} 2026-03-23 02:36:02,985 - DEBUG - {"ace_id": "7", "action_l": ["pass"], "dst": "any", "dst_port_l": {"max": "65535", "min": "0"}, "proto_l": {"max": "255", "min": "0"}, "rule_type": "Terminal", "src": "any", "src_port_l": {"max": "65535", "min": "0"}} 2026-03-23 02:36:02,985 - DEBUG - Compute node: 10.0.0.249, Check for expected data 2026-03-23 02:36:02,985 - DEBUG - Compute node: 10.0.0.249, Check for unexpected data 2026-03-23 02:36:02,991 - INFO - Compute node: 10.0.0.249, VN: ctest-vnet0-85453305, validated that no extra rules are present 2026-03-23 02:36:02,991 - DEBUG - Compute node: 10.0.0.65, Check for expected data 2026-03-23 02:36:02,991 - DEBUG - Checking for VN ctest-vnet0-85453305 in Compute 10.0.0.65 2026-03-23 02:36:03,016 - DEBUG - ---------------------------------------- 2026-03-23 02:36:03,016 - INFO - Compute node: 10.0.0.65, VN: ctest-vnet0-85453305, result of expected rules check passed 2026-03-23 02:36:03,016 - DEBUG - Compute node: 10.0.0.65, Check for unexpected data 2026-03-23 02:36:03,070 - DEBUG - Policy ctest-policy2-01864600 already present, not creating any policy 2026-03-23 02:36:03,070 - INFO - adding policy ctest-policy2-01864600 to vn ctest-vnet0-85453305 2026-03-23 02:36:03,211 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': 'fd03ad8c-4f56-4d5f-871e-13bd0f86bb12', 'name': 'ctest-vnet0-85453305', 'tenant_id': 'bb0c6e9acafc404986017d2208a46e07', 'project_id': 'bb0c6e9acafc404986017d2208a46e07', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['a9921f4e-3c71-465e-b47a-83d76ed6bac2', 'a7d20a6a-56d8-4f94-badd-26c4029aa73a'], 'fq_name': ['default-domain', 'ctest-TestBasicPolicyModifyIpv4v6-40124791', 'ctest-vnet0-85453305'], 'policys': [['default-domain', 'ctest-TestBasicPolicyModifyIpv4v6-40124791', 'ctest-policy0-05695839'], ['default-domain', 'ctest-TestBasicPolicyModifyIpv4v6-40124791', 'ctest-policy1-79926995'], ['default-domain', 'ctest-TestBasicPolicyModifyIpv4v6-40124791', 'ctest-policy2-01864600']], 'subnet_ipam': [{'subnet_cidr': '126.222.217.0/26', 'ipam_fq_name': ['default-domain', 'ctest-TestBasicPolicyModifyIpv4v6-40124791', 'ctest-TestBasicPolicyModifyIpv4v6-40124791-default-ipam']}, {'subnet_cidr': '37ea:d6cb:7e0b:736f:ef08:abaf::/96', 'ipam_fq_name': ['default-domain', 'ctest-TestBasicPolicyModifyIpv4v6-40124791', 'ctest-TestBasicPolicyModifyIpv4v6-40124791-default-ipam']}], 'port_security_enabled': True, 'description': ''}} 2026-03-23 02:36:08,498 - INFO - New policy list of VN ctest-vnet0-85453305 is ['ctest-policy0-05695839', 'ctest-policy1-79926995', 'ctest-policy2-01864600'] 2026-03-23 02:36:08,498 - DEBUG - Starting Verifications after add policy: 2026-03-23 02:36:08,499 - DEBUG - Starting verify_policy_in_vna 2026-03-23 02:36:08,499 - DEBUG - vn is ctest-vnet0-85453305, scn.vn_policy is ['ctest-policy0-05695839', 'ctest-policy1-79926995', 'ctest-policy2-01864600'] 2026-03-23 02:36:08,499 - DEBUG - [{"action_l": ["deny"], "direction": ">", "dst": "ctest-vnet0-85453305", "dst_port_l": {"max": "65535", "min": "0"}, "proto_l": {"max": "255", "min": "0"}, "simple_action": "deny", "src": "ctest-vnet0-85453305", "src_port_l": {"max": "65535", "min": "0"}}, {"action_l": ["deny"], "direction": ">", "dst": "ctest-vnet0-85453305", "dst_port_l": {"max": "65535", "min": "0"}, "proto_l": {"max": "255", "min": "0"}, "simple_action": "deny", "src": "ctest-vnet0-85453305", "src_port_l": {"max": "65535", "min": "0"}}, {"action_l": ["deny"], "direction": ">", "dst": "ctest-vnet0-85453305", "dst_port_l": {"max": "65535", "min": "0"}, "proto_l": {"max": "255", "min": "0"}, "simple_action": "deny", "src": "ctest-vnet0-85453305", "src_port_l": {"max": "65535", "min": "0"}}, {"action_l": ["deny"], "direction": ">", "dst": "ctest-vnet0-85453305", "dst_port_l": {"max": "65535", "min": "0"}, "proto_l": {"max": "255", "min": "0"}, "simple_action": "deny", "src": "ctest-vnet0-85453305", "src_port_l": {"max": "65535", "min": "0"}}, {"action_l": ["deny"], "direction": ">", "dst": "ctest-vnet0-85453305", "dst_port_l": {"max": "65535", "min": "0"}, "proto_l": {"max": "255", "min": "0"}, "simple_action": "deny", "src": "ctest-vnet0-85453305", "src_port_l": {"max": "65535", "min": "0"}}, {"action_l": ["deny"], "direction": ">", "dst": "ctest-vnet0-85453305", "dst_port_l": {"max": "65535", "min": "0"}, "proto_l": {"max": "255", "min": "0"}, "simple_action": "deny", "src": "ctest-vnet0-85453305", "src_port_l": {"max": "65535", "min": "0"}}] 2026-03-23 02:36:08,499 - DEBUG - VN: ctest-vnet0-85453305, expected ACE's is 2026-03-23 02:36:08,499 - DEBUG - {"ace_id": "1", "action_l": ["deny"], "dst": "default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305", "dst_port_l": {"max": "65535", "min": "0"}, "proto_l": {"max": "tcp", "min": "tcp"}, "rule_type": "Terminal", "src": "default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305", "src_port_l": {"max": "0", "min": "0"}} 2026-03-23 02:36:08,499 - DEBUG - {"ace_id": "2", "action_l": ["deny"], "dst": "default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305", "dst_port_l": {"max": "65535", "min": "0"}, "proto_l": {"max": "tcp", "min": "tcp"}, "rule_type": "Terminal", "src": "default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305", "src_port_l": {"max": "1", "min": "1"}} 2026-03-23 02:36:08,499 - DEBUG - {"ace_id": "3", "action_l": ["deny"], "dst": "default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305", "dst_port_l": {"max": "65535", "min": "0"}, "proto_l": {"max": "tcp", "min": "tcp"}, "rule_type": "Terminal", "src": "default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305", "src_port_l": {"max": "2", "min": "2"}} 2026-03-23 02:36:08,499 - DEBUG - {"ace_id": "4", "action_l": ["deny"], "dst": "default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305", "dst_port_l": {"max": "65535", "min": "0"}, "proto_l": {"max": "icmp", "min": "icmp"}, "rule_type": "Terminal", "src": "default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305", "src_port_l": {"max": "65535", "min": "0"}} 2026-03-23 02:36:08,499 - DEBUG - {"ace_id": "5", "action_l": ["deny"], "dst": "default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305", "dst_port_l": {"max": "65535", "min": "0"}, "proto_l": {"max": "58", "min": "58"}, "rule_type": "Terminal", "src": "default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305", "src_port_l": {"max": "65535", "min": "0"}} 2026-03-23 02:36:08,499 - DEBUG - {"ace_id": "6", "action_l": ["deny"], "dst": "default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305", "dst_port_l": {"max": "65535", "min": "0"}, "proto_l": {"max": "udp", "min": "udp"}, "rule_type": "Terminal", "src": "default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305", "src_port_l": {"max": "10", "min": "10"}} 2026-03-23 02:36:08,499 - DEBUG - {"ace_id": "7", "action_l": ["pass"], "dst": "default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305", "dst_port_l": {"max": "65535", "min": "0"}, "proto_l": {"max": "255", "min": "0"}, "rule_type": "Terminal", "src": "default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305", "src_port_l": {"max": "65535", "min": "0"}} 2026-03-23 02:36:08,499 - DEBUG - {"ace_id": "8", "action_l": ["pass"], "dst": "any", "dst_port_l": {"max": "65535", "min": "0"}, "proto_l": {"max": "255", "min": "0"}, "rule_type": "Terminal", "src": "any", "src_port_l": {"max": "65535", "min": "0"}} 2026-03-23 02:36:08,499 - DEBUG - Compute node: 10.0.0.249, Check for expected data 2026-03-23 02:36:08,499 - DEBUG - Compute node: 10.0.0.249, Check for unexpected data 2026-03-23 02:36:08,506 - INFO - Compute node: 10.0.0.249, VN: ctest-vnet0-85453305, validated that no extra rules are present 2026-03-23 02:36:08,506 - DEBUG - Compute node: 10.0.0.65, Check for expected data 2026-03-23 02:36:08,506 - DEBUG - Checking for VN ctest-vnet0-85453305 in Compute 10.0.0.65 2026-03-23 02:36:08,527 - DEBUG - ---------------------------------------- 2026-03-23 02:36:08,528 - INFO - Compute node: 10.0.0.65, VN: ctest-vnet0-85453305, result of expected rules check passed 2026-03-23 02:36:08,528 - DEBUG - Compute node: 10.0.0.65, Check for unexpected data 2026-03-23 02:36:13,731 - INFO - New policy list of VN ctest-vnet0-85453305 is [] 2026-03-23 02:36:13,731 - DEBUG - Starting Verifications after unbinding all policies 2026-03-23 02:36:13,732 - DEBUG - Starting verify_policy_in_vna 2026-03-23 02:36:13,732 - DEBUG - vn is ctest-vnet0-85453305, scn.vn_policy is [] 2026-03-23 02:36:13,732 - DEBUG - VN: ctest-vnet0-85453305, expected ACE's is 2026-03-23 02:36:13,732 - DEBUG - Compute node: 10.0.0.249, Check for expected data 2026-03-23 02:36:13,732 - DEBUG - Compute node: 10.0.0.249, Check for unexpected data 2026-03-23 02:36:13,738 - INFO - Compute node: 10.0.0.249, VN: ctest-vnet0-85453305, validated that no extra rules are present 2026-03-23 02:36:13,738 - DEBUG - Compute node: 10.0.0.65, Check for expected data 2026-03-23 02:36:13,738 - DEBUG - Checking for VN ctest-vnet0-85453305 in Compute 10.0.0.65 2026-03-23 02:36:13,751 - DEBUG - ---------------------------------------- 2026-03-23 02:36:13,752 - INFO - Compute node: 10.0.0.65, VN: ctest-vnet0-85453305, result of expected rules check passed 2026-03-23 02:36:13,752 - DEBUG - Compute node: 10.0.0.65, Check for unexpected data 2026-03-23 02:36:13,752 - INFO - Skipping deletion of policy ctest-policy2-01864600 2026-03-23 02:36:13,752 - INFO - Deleting VM ctest-vmc0-86263273 2026-03-23 02:36:13,833 - DEBUG - Verifying in api server 10.0.0.23 2026-03-23 02:36:13,833 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/d41a23a0-90ed-47a4-92f2-ad81060cd653 2026-03-23 02:36:13,842 - DEBUG - VM ID d41a23a0-90ed-47a4-92f2-ad81060cd653 of VM ctest-vmc0-86263273 is still found in API Server 2026-03-23 02:36:15,843 - DEBUG - Verifying in api server 10.0.0.23 2026-03-23 02:36:15,843 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/d41a23a0-90ed-47a4-92f2-ad81060cd653 2026-03-23 02:36:15,850 - DEBUG - Response Code: 404 2026-03-23 02:36:15,850 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/d41a23a0-90ed-47a4-92f2-ad81060cd653 2026-03-23 02:36:15,857 - DEBUG - Response Code: 404 2026-03-23 02:36:15,857 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/d41a23a0-90ed-47a4-92f2-ad81060cd653 2026-03-23 02:36:15,865 - DEBUG - Response Code: 404 2026-03-23 02:36:15,866 - INFO - VM ctest-vmc0-86263273 is fully removed in API-Server 2026-03-23 02:36:16,027 - DEBUG - Skipping VM-deletion-check in nova db since mysql_token is not found 2026-03-23 02:36:16,073 - DEBUG - Validated that vrouter 10.0.0.249 does not have VMs route for VN default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305 2026-03-23 02:36:16,083 - DEBUG - Validated that vrouter 10.0.0.65 does not have VMs route for VN default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305 2026-03-23 02:36:16,083 - INFO - Validated that all vrouters do not have VMs route for VN default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305 2026-03-23 02:36:16,083 - INFO - VM ctest-vmc0-86263273 is removed in Compute, and routes are removed in all compute nodes 2026-03-23 02:36:16,311 - INFO - Routes for VM ctest-vmc0-86263273 is removed in all control-nodes 2026-03-23 02:36:16,311 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5514-2:Compute:contrail-vrouter-agent:0?flat 2026-03-23 02:36:16,432 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5514-2?flat 2026-03-23 02:36:16,484 - DEBUG - VM d41a23a0-90ed-47a4-92f2-ad81060cd653 is still present in vrouter an-jenkins-deploy-platform-ansible-os-5514-2 uve 2026-03-23 02:36:16,484 - DEBUG - Verifying if the vm interface deleted from vroter uve... 2026-03-23 02:36:16,485 - DEBUG - interface for vm d41a23a0-90ed-47a4-92f2-ad81060cd653 deleted from vrouter uve ... 2026-03-23 02:36:16,485 - DEBUG - Deleted interface not in error interface list ... 2026-03-23 02:36:19,485 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5514-2:Compute:contrail-vrouter-agent:0?flat 2026-03-23 02:36:19,572 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5514-2?flat 2026-03-23 02:36:19,605 - DEBUG - VM d41a23a0-90ed-47a4-92f2-ad81060cd653 is still present in vrouter an-jenkins-deploy-platform-ansible-os-5514-2 uve 2026-03-23 02:36:19,605 - DEBUG - Verifying if the vm interface deleted from vroter uve... 2026-03-23 02:36:19,605 - DEBUG - interface for vm d41a23a0-90ed-47a4-92f2-ad81060cd653 deleted from vrouter uve ... 2026-03-23 02:36:19,605 - DEBUG - Deleted interface not in error interface list ... 2026-03-23 02:36:22,606 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5514-2:Compute:contrail-vrouter-agent:0?flat 2026-03-23 02:36:22,644 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5514-2?flat 2026-03-23 02:36:22,684 - DEBUG - VM d41a23a0-90ed-47a4-92f2-ad81060cd653 is still present in vrouter an-jenkins-deploy-platform-ansible-os-5514-2 uve 2026-03-23 02:36:22,684 - DEBUG - Verifying if the vm interface deleted from vroter uve... 2026-03-23 02:36:22,684 - DEBUG - interface for vm d41a23a0-90ed-47a4-92f2-ad81060cd653 deleted from vrouter uve ... 2026-03-23 02:36:22,684 - DEBUG - Deleted interface not in error interface list ... 2026-03-23 02:36:25,684 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5514-2:Compute:contrail-vrouter-agent:0?flat 2026-03-23 02:36:25,725 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5514-2?flat 2026-03-23 02:36:25,758 - DEBUG - VM d41a23a0-90ed-47a4-92f2-ad81060cd653 is still present in vrouter an-jenkins-deploy-platform-ansible-os-5514-2 uve 2026-03-23 02:36:25,758 - DEBUG - Verifying if the vm interface deleted from vroter uve... 2026-03-23 02:36:25,758 - DEBUG - interface for vm d41a23a0-90ed-47a4-92f2-ad81060cd653 deleted from vrouter uve ... 2026-03-23 02:36:25,758 - DEBUG - Deleted interface not in error interface list ... 2026-03-23 02:36:28,759 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5514-2:Compute:contrail-vrouter-agent:0?flat 2026-03-23 02:36:28,803 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5514-2?flat 2026-03-23 02:36:28,842 - DEBUG - VM d41a23a0-90ed-47a4-92f2-ad81060cd653 is still present in vrouter an-jenkins-deploy-platform-ansible-os-5514-2 uve 2026-03-23 02:36:28,842 - DEBUG - Verifying if the vm interface deleted from vroter uve... 2026-03-23 02:36:28,842 - DEBUG - interface for vm d41a23a0-90ed-47a4-92f2-ad81060cd653 deleted from vrouter uve ... 2026-03-23 02:36:28,842 - DEBUG - Deleted interface not in error interface list ... 2026-03-23 02:36:31,843 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5514-2:Compute:contrail-vrouter-agent:0?flat 2026-03-23 02:36:31,882 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5514-2?flat 2026-03-23 02:36:31,916 - DEBUG - VM d41a23a0-90ed-47a4-92f2-ad81060cd653 is still present in vrouter an-jenkins-deploy-platform-ansible-os-5514-2 uve 2026-03-23 02:36:31,917 - DEBUG - Verifying if the vm interface deleted from vroter uve... 2026-03-23 02:36:31,917 - DEBUG - interface for vm d41a23a0-90ed-47a4-92f2-ad81060cd653 deleted from vrouter uve ... 2026-03-23 02:36:31,917 - DEBUG - Deleted interface not in error interface list ... 2026-03-23 02:36:34,917 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5514-2:Compute:contrail-vrouter-agent:0?flat 2026-03-23 02:36:34,960 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5514-2?flat 2026-03-23 02:36:34,995 - DEBUG - VM d41a23a0-90ed-47a4-92f2-ad81060cd653 is still present in vrouter an-jenkins-deploy-platform-ansible-os-5514-2 uve 2026-03-23 02:36:34,995 - DEBUG - Verifying if the vm interface deleted from vroter uve... 2026-03-23 02:36:34,995 - DEBUG - interface for vm d41a23a0-90ed-47a4-92f2-ad81060cd653 deleted from vrouter uve ... 2026-03-23 02:36:34,996 - DEBUG - Deleted interface not in error interface list ... 2026-03-23 02:36:37,996 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5514-2:Compute:contrail-vrouter-agent:0?flat 2026-03-23 02:36:38,035 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5514-2?flat 2026-03-23 02:36:38,068 - DEBUG - VM d41a23a0-90ed-47a4-92f2-ad81060cd653 is still present in vrouter an-jenkins-deploy-platform-ansible-os-5514-2 uve 2026-03-23 02:36:38,068 - DEBUG - Verifying if the vm interface deleted from vroter uve... 2026-03-23 02:36:38,068 - DEBUG - interface for vm d41a23a0-90ed-47a4-92f2-ad81060cd653 deleted from vrouter uve ... 2026-03-23 02:36:38,068 - DEBUG - Deleted interface not in error interface list ... 2026-03-23 02:36:41,069 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5514-2:Compute:contrail-vrouter-agent:0?flat 2026-03-23 02:36:41,108 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5514-2?flat 2026-03-23 02:36:41,144 - DEBUG - VM d41a23a0-90ed-47a4-92f2-ad81060cd653 is not present in vrouter an-jenkins-deploy-platform-ansible-os-5514-2 uve 2026-03-23 02:36:41,144 - DEBUG - Verifying if the vm interface deleted from vroter uve... 2026-03-23 02:36:41,144 - DEBUG - interface for vm d41a23a0-90ed-47a4-92f2-ad81060cd653 deleted from vrouter uve ... 2026-03-23 02:36:41,144 - DEBUG - Deleted interface not in error interface list ... 2026-03-23 02:36:41,144 - DEBUG - Validated that VM d41a23a0-90ed-47a4-92f2-ad81060cd653 is removed in Vrouter UVE 2026-03-23 02:36:41,144 - DEBUG - Verifying through opserver in 10.0.0.27 2026-03-23 02:36:41,144 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305?flat 2026-03-23 02:36:41,166 - DEBUG - d41a23a0-90ed-47a4-92f2-ad81060cd653 BM not in default-domain:ctest-TestBasicPolicyModifyIpv4v6-40124791:ctest-vnet0-85453305 uve 2026-03-23 02:36:41,166 - DEBUG - Validated that VM d41a23a0-90ed-47a4-92f2-ad81060cd653 is not present in the VN UVE 2026-03-23 02:36:41,166 - DEBUG - Verifying the d41a23a0-90ed-47a4-92f2-ad81060cd653 virtual network link through opserver 10.0.0.27 2026-03-23 02:36:41,166 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-machines 2026-03-23 02:36:41,178 - DEBUG - No links retuned for d41a23a0-90ed-47a4-92f2-ad81060cd653 2026-03-23 02:36:41,179 - INFO - d41a23a0-90ed-47a4-92f2-ad81060cd653 vm uve deleted from opserver 2026-03-23 02:36:41,179 - DEBUG - Verifying the d41a23a0-90ed-47a4-92f2-ad81060cd653 virtual network link through opserver 10.0.0.50 2026-03-23 02:36:41,179 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-machines 2026-03-23 02:36:41,249 - DEBUG - No links retuned for d41a23a0-90ed-47a4-92f2-ad81060cd653 2026-03-23 02:36:41,249 - INFO - d41a23a0-90ed-47a4-92f2-ad81060cd653 vm uve deleted from opserver 2026-03-23 02:36:41,249 - DEBUG - Verifying the d41a23a0-90ed-47a4-92f2-ad81060cd653 virtual network link through opserver 10.0.0.23 2026-03-23 02:36:41,249 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-machines 2026-03-23 02:36:41,315 - DEBUG - No links retuned for d41a23a0-90ed-47a4-92f2-ad81060cd653 2026-03-23 02:36:41,315 - INFO - d41a23a0-90ed-47a4-92f2-ad81060cd653 vm uve deleted from opserver 2026-03-23 02:36:41,316 - INFO - Validated that VM d41a23a0-90ed-47a4-92f2-ad81060cd653 is removed from Opserver 2026-03-23 02:36:41,316 - DEBUG - Detaching the Policy for VN :ctest-vnet0-85453305 2026-03-23 02:36:41,316 - DEBUG - Requesting: http://10.0.0.27:8082/domains 2026-03-23 02:36:41,324 - DEBUG - Requesting: http://10.0.0.27:8082/domain/54adab80-1c58-45eb-8fc6-565ee3803789 2026-03-23 02:36:41,366 - DEBUG - Requesting: http://10.0.0.27:8082/project/bb0c6e9a-cafc-4049-8601-7d2208a46e07 2026-03-23 02:36:41,473 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/fd03ad8c-4f56-4d5f-871e-13bd0f86bb12 2026-03-23 02:36:41,529 - INFO - Deleted policy ctest-policy2-01864600 2026-03-23 02:36:41,715 - DEBUG - policy ctest-policy2-01864600 is not found in API Server 2026-03-23 02:36:41,759 - INFO - Deleted policy ctest-policy1-79926995 2026-03-23 02:36:41,951 - DEBUG - policy ctest-policy1-79926995 is not found in API Server 2026-03-23 02:36:41,992 - INFO - Deleted policy ctest-policy0-05695839 2026-03-23 02:36:42,171 - DEBUG - policy ctest-policy0-05695839 is not found in API Server 2026-03-23 02:36:42,171 - INFO - Deleting VN ctest-vnet0-85453305 2026-03-23 02:36:42,433 - DEBUG - Response for deleting network () 2026-03-23 02:36:42,433 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/7e0cea07-dfcf-4bd2-92b0-a2d71d7f35b2 2026-03-23 02:36:42,444 - DEBUG - Response Code: 404 2026-03-23 02:36:42,445 - DEBUG - Requesting: http://10.0.0.27:8082/domains 2026-03-23 02:36:42,451 - DEBUG - Requesting: http://10.0.0.27:8082/domain/54adab80-1c58-45eb-8fc6-565ee3803789 2026-03-23 02:36:42,467 - DEBUG - Requesting: http://10.0.0.27:8082/project/bb0c6e9a-cafc-4049-8601-7d2208a46e07 2026-03-23 02:36:42,575 - INFO - Validated that VN ctest-vnet0-85453305 is not found in API Server 2026-03-23 02:36:42,586 - DEBUG - VN ctest-vnet0-85453305 is not present in Agent 10.0.0.249 2026-03-23 02:36:42,597 - DEBUG - VN ctest-vnet0-85453305 is not present in Agent 10.0.0.65 2026-03-23 02:36:42,597 - INFO - Validated that VN ctest-vnet0-85453305 is not in any agent 2026-03-23 02:36:42,634 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vnet0-85453305 info 2026-03-23 02:36:42,724 - INFO - IPAM: ctest-TestBasicPolicyModifyIpv4v6-40124791-default-ipam is not found in API Server 2026-03-23 02:36:42,754 - INFO - IPAM:ctest-TestBasicPolicyModifyIpv4v6-40124791-default-ipam is not found in control node 2026-03-23 02:36:43,227 - DEBUG - Skipping the deletion of Project ['default-domain', 'ctest-TestBasicPolicyModifyIpv4v6-40124791'] 2026-03-23 02:36:43,227 - DEBUG - Skipping the deletion of User admin 2026-03-23 02:36:44,527 - DEBUG - No XMPP flaps were noticed during the test
2026-03-23 02:36:44,527 - INFO - END TEST : test_policy_modify_vn_policy : PASSED[0:02:04]
2026-03-23 02:36:44,527 - INFO - -------------------------------------------------------------------------------- 2026-03-23 02:36:45,840 - DEBUG - No XMPP flaps were noticed during the test
2026-03-23 02:36:45,840 - INFO - END TEST : test_policy_modify_vn_policy : PASSED[0:02:06]
2026-03-23 02:36:45,840 - INFO - -------------------------------------------------------------------------------- 2026-03-23 02:36:47,305 - INFO - Deleted project: ctest-TestBasicPolicyModifyIpv4v6-40124791, ID : bb0c6e9a-cafc-4049-8601-7d2208a46e07