2025-08-02 23:32:04,363 - INFO - Domain Default found not creating 2025-08-02 23:32:04,597 - INFO - Project ctest-TestBasicPolicyIpv4v6-06509302 not found, creating it 2025-08-02 23:32:05,323 - INFO - Created Project:ctest-TestBasicPolicyIpv4v6-06509302, ID : 34d59a3a-8d04-421e-b65f-82e204288393 2025-08-02 23:32:06,791 - INFO - ================================================================================ 2025-08-02 23:32:06,792 - INFO - STARTING TEST : test_basic_policy_allow_deny 2025-08-02 23:32:06,792 - INFO - TEST DESCRIPTION : Create 2 Vns and allow icmp traffic between them and validate with pings Update the policy to deny the same traffic Check that pings fail 2025-08-02 23:32:08,145 - DEBUG - Nothing to compare xmpp stats {'10.0.0.48': {'10.20.0.17': '0', '10.20.0.14': '0'}, '10.0.0.49': {'10.20.0.17': '0', '10.20.0.14': '0'}} with 2025-08-02 23:32:08,145 - INFO - Initial checks done. Running the testcase now 2025-08-02 23:32:08,145 - INFO - 2025-08-02 23:32:09,031 - DEBUG - Response for create_network : {'network': {'id': 'ec972476-9a6b-46b5-956a-d9bcf522639b', 'name': 'ctest-vn-82883188', 'tenant_id': '34d59a3a8d04421eb65f82e204288393', 'project_id': '34d59a3a8d04421eb65f82e204288393', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestBasicPolicyIpv4v6-06509302', 'ctest-vn-82883188'], 'port_security_enabled': True, 'description': ''}} 2025-08-02 23:32:09,334 - DEBUG - Response for create_subnet : {'subnet': {'id': '90b5809d-cacb-4f88-8d59-209623305630', 'name': '', 'tenant_id': '34d59a3a8d04421eb65f82e204288393', 'network_id': 'ec972476-9a6b-46b5-956a-d9bcf522639b', 'ip_version': 4, 'cidr': '218.161.219.192/26', 'allocation_pools': [{'start': '218.161.219.194', 'end': '218.161.219.254'}], 'gateway_ip': '218.161.219.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '218.161.219.194', 'tags': [], 'project_id': '34d59a3a8d04421eb65f82e204288393'}} 2025-08-02 23:32:09,671 - DEBUG - Response for create_subnet : {'subnet': {'id': '09b9f605-d766-4917-83a6-62c421c291e0', 'name': '', 'tenant_id': '34d59a3a8d04421eb65f82e204288393', 'network_id': 'ec972476-9a6b-46b5-956a-d9bcf522639b', 'ip_version': 6, 'cidr': '268a:94f9:369a:6de6:d1f:2054::/96', 'allocation_pools': [{'start': '268a:94f9:369a:6de6:d1f:2054:0:2', 'end': '268a:94f9:369a:6de6:d1f:2054:ffff:fffe'}], 'gateway_ip': '268a:94f9:369a:6de6:d1f:2054:0:1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '268a:94f9:369a:6de6:d1f:2054:0:2', 'tags': [], 'project_id': '34d59a3a8d04421eb65f82e204288393'}} 2025-08-02 23:32:09,713 - INFO - Created VN ctest-vn-82883188 2025-08-02 23:32:09,750 - DEBUG - VN ctest-vn-82883188 UUID is ec972476-9a6b-46b5-956a-d9bcf522639b 2025-08-02 23:32:10,290 - DEBUG - Response for create_network : {'network': {'id': '612a5296-6f44-4914-88e3-c33940b89f78', 'name': 'ctest-vn-07494235', 'tenant_id': '34d59a3a8d04421eb65f82e204288393', 'project_id': '34d59a3a8d04421eb65f82e204288393', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestBasicPolicyIpv4v6-06509302', 'ctest-vn-07494235'], 'port_security_enabled': True, 'description': ''}} 2025-08-02 23:32:10,554 - DEBUG - Response for create_subnet : {'subnet': {'id': '49c34096-d828-4bd9-8870-c1d0c5d4065a', 'name': '', 'tenant_id': '34d59a3a8d04421eb65f82e204288393', 'network_id': '612a5296-6f44-4914-88e3-c33940b89f78', 'ip_version': 4, 'cidr': '146.217.44.128/26', 'allocation_pools': [{'start': '146.217.44.130', 'end': '146.217.44.190'}], 'gateway_ip': '146.217.44.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '146.217.44.130', 'tags': [], 'project_id': '34d59a3a8d04421eb65f82e204288393'}} 2025-08-02 23:32:10,860 - DEBUG - Response for create_subnet : {'subnet': {'id': '03a1a2f8-7aa1-444c-8fd5-94fd124a5012', 'name': '', 'tenant_id': '34d59a3a8d04421eb65f82e204288393', 'network_id': '612a5296-6f44-4914-88e3-c33940b89f78', 'ip_version': 6, 'cidr': '2cf6:7e97:d964:edbd:e488:5c80::/96', 'allocation_pools': [{'start': '2cf6:7e97:d964:edbd:e488:5c80:0:2', 'end': '2cf6:7e97:d964:edbd:e488:5c80:ffff:fffe'}], 'gateway_ip': '2cf6:7e97:d964:edbd:e488:5c80:0:1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '2cf6:7e97:d964:edbd:e488:5c80:0:2', 'tags': [], 'project_id': '34d59a3a8d04421eb65f82e204288393'}} 2025-08-02 23:32:10,894 - INFO - Created VN ctest-vn-07494235 2025-08-02 23:32:10,913 - DEBUG - VN ctest-vn-07494235 UUID is 612a5296-6f44-4914-88e3-c33940b89f78 2025-08-02 23:32:11,085 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = icmp, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn-82883188, 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-TestBasicPolicyIpv4v6-06509302:ctest-vn-07494235, 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-TestBasicPolicyIpv4v6-06509302:ctest-vn-82883188, 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-TestBasicPolicyIpv4v6-06509302:ctest-vn-07494235, 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-08-02 23:32:11,604 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': 'ec972476-9a6b-46b5-956a-d9bcf522639b', 'name': 'ctest-vn-82883188', 'tenant_id': '34d59a3a8d04421eb65f82e204288393', 'project_id': '34d59a3a8d04421eb65f82e204288393', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['90b5809d-cacb-4f88-8d59-209623305630', '09b9f605-d766-4917-83a6-62c421c291e0'], 'fq_name': ['default-domain', 'ctest-TestBasicPolicyIpv4v6-06509302', 'ctest-vn-82883188'], 'policys': [['default-domain', 'ctest-TestBasicPolicyIpv4v6-06509302', 'ctest-policy-allow-all-68266097']], 'subnet_ipam': [{'subnet_cidr': '218.161.219.192/26', 'ipam_fq_name': ['default-domain', 'default-project', 'default-network-ipam']}, {'subnet_cidr': '268a:94f9:369a:6de6:d1f:2054::/96', 'ipam_fq_name': ['default-domain', 'default-project', 'default-network-ipam']}], 'port_security_enabled': True, 'description': ''}} 2025-08-02 23:32:11,913 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': '612a5296-6f44-4914-88e3-c33940b89f78', 'name': 'ctest-vn-07494235', 'tenant_id': '34d59a3a8d04421eb65f82e204288393', 'project_id': '34d59a3a8d04421eb65f82e204288393', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['49c34096-d828-4bd9-8870-c1d0c5d4065a', '03a1a2f8-7aa1-444c-8fd5-94fd124a5012'], 'fq_name': ['default-domain', 'ctest-TestBasicPolicyIpv4v6-06509302', 'ctest-vn-07494235'], 'policys': [['default-domain', 'ctest-TestBasicPolicyIpv4v6-06509302', 'ctest-policy-allow-all-68266097']], 'subnet_ipam': [{'subnet_cidr': '146.217.44.128/26', 'ipam_fq_name': ['default-domain', 'default-project', 'default-network-ipam']}, {'subnet_cidr': '2cf6:7e97:d964:edbd:e488:5c80::/96', 'ipam_fq_name': ['default-domain', 'default-project', 'default-network-ipam']}], 'port_security_enabled': True, 'description': ''}} 2025-08-02 23:32:12,017 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-08-02 23:32:12,318 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-08-02 23:32:12,350 - DEBUG - Requesting: http://10.0.0.38:8082/domain/e48a4202-dd3d-4b87-9406-48f7b2154028 2025-08-02 23:32:12,376 - DEBUG - Requesting: http://10.0.0.38:8082/project/34d59a3a-8d04-421e-b65f-82e204288393 2025-08-02 23:32:12,542 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/ec972476-9a6b-46b5-956a-d9bcf522639b 2025-08-02 23:32:12,562 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/ec972476-9a6b-46b5-956a-d9bcf522639b 2025-08-02 23:32:12,590 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/1baa65d1-f1c6-4add-9ea5-16276790600d 2025-08-02 23:32:12,624 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/1baa65d1-f1c6-4add-9ea5-16276790600d 2025-08-02 23:32:12,643 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/e7976ddf-5ee4-4fba-a9cb-0463ca108966 2025-08-02 23:32:12,659 - DEBUG - Route Targets: ['target:64512:8000005'] 2025-08-02 23:32:12,660 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/ec972476-9a6b-46b5-956a-d9bcf522639b 2025-08-02 23:32:12,687 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/1baa65d1-f1c6-4add-9ea5-16276790600d 2025-08-02 23:32:12,721 - INFO - Verified VN network id 12 for VN ec972476-9a6b-46b5-956a-d9bcf522639b 2025-08-02 23:32:12,721 - INFO - Verifications in API Server for VN ctest-vn-82883188 passed 2025-08-02 23:32:12,722 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/ec972476-9a6b-46b5-956a-d9bcf522639b 2025-08-02 23:32:12,740 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/1baa65d1-f1c6-4add-9ea5-16276790600d 2025-08-02 23:32:12,751 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/1baa65d1-f1c6-4add-9ea5-16276790600d 2025-08-02 23:32:12,762 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/e7976ddf-5ee4-4fba-a9cb-0463ca108966 2025-08-02 23:32:12,779 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn-82883188', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestBasicPolicyIpv4v6-06509302', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17048135006249764533', 'uuid-lslong': '10766657264772342683'}, 'enable': 'true', 'created': '2025-08-02T23:32:08', 'last-modified': '2025-08-02T23:32:11', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.224635'} 2025-08-02 23:32:12,787 - DEBUG - Route Targets: ['target:64512:8000005'] 2025-08-02 23:32:12,794 - DEBUG - Control-node 10.0.0.254 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn-82883188', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestBasicPolicyIpv4v6-06509302', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17048135006249764533', 'uuid-lslong': '10766657264772342683'}, 'enable': 'true', 'created': '2025-08-02T23:32:08', 'last-modified': '2025-08-02T23:32:11', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.249842'} 2025-08-02 23:32:12,801 - DEBUG - Route Targets: ['target:64512:8000005'] 2025-08-02 23:32:12,815 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn-82883188', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestBasicPolicyIpv4v6-06509302', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17048135006249764533', 'uuid-lslong': '10766657264772342683'}, 'enable': 'true', 'created': '2025-08-02T23:32:08', 'last-modified': '2025-08-02T23:32:11', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.261230'} 2025-08-02 23:32:12,829 - DEBUG - Route Targets: ['target:64512:8000005'] 2025-08-02 23:32:12,829 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn-82883188 passed 2025-08-02 23:32:12,829 - DEBUG - ====Verifying policy data for ctest-vn-82883188 in API_Server ====== 2025-08-02 23:32:12,829 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-08-02 23:32:12,837 - DEBUG - Requesting: http://10.0.0.38:8082/domain/e48a4202-dd3d-4b87-9406-48f7b2154028 2025-08-02 23:32:12,850 - DEBUG - Requesting: http://10.0.0.38:8082/project/34d59a3a-8d04-421e-b65f-82e204288393 2025-08-02 23:32:12,968 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/ec972476-9a6b-46b5-956a-d9bcf522639b 2025-08-02 23:32:12,981 - DEBUG - ==>Verifying data for policy with id: f127b67c-8f04-4ac6-b6a4-d36c52fc69b4, fqn: ['default-domain', 'ctest-TestBasicPolicyIpv4v6-06509302', 'ctest-policy-allow-all-68266097'] 2025-08-02 23:32:12,981 - INFO - VN ctest-vn-82883188 Policy verification: verify_vn_policy_in_api_server, status: True 2025-08-02 23:32:12,981 - DEBUG - Verifying the vn in opserver 2025-08-02 23:32:12,981 - DEBUG - Verifying the default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn-82883188 virtual network link through opserver 10.0.0.38 2025-08-02 23:32:12,981 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks 2025-08-02 23:32:13,274 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks 2025-08-02 23:32:13,363 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn-82883188', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn-82883188?flat'} 2025-08-02 23:32:13,363 - DEBUG - Verifying the default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn-82883188 virtual network link through opserver 10.0.0.254 2025-08-02 23:32:13,363 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-networks 2025-08-02 23:32:13,663 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-networks 2025-08-02 23:32:13,743 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn-82883188', 'href': 'http://10.0.0.254:8081/analytics/uves/virtual-network/default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn-82883188?flat'} 2025-08-02 23:32:13,743 - DEBUG - Verifying the default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn-82883188 virtual network link through opserver 10.0.0.50 2025-08-02 23:32:13,744 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks 2025-08-02 23:32:14,048 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks 2025-08-02 23:32:14,118 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn-82883188', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn-82883188?flat'} 2025-08-02 23:32:14,118 - INFO - Validated that VN default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn-82883188 is found in opserver 2025-08-02 23:32:14,144 - DEBUG - Do not have enough data to verify VN in agent 2025-08-02 23:32:14,157 - DEBUG - VRF ids for VN ctest-vn-82883188: {} 2025-08-02 23:32:14,157 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-08-02 23:32:14,166 - DEBUG - Requesting: http://10.0.0.38:8082/domain/e48a4202-dd3d-4b87-9406-48f7b2154028 2025-08-02 23:32:14,184 - DEBUG - Requesting: http://10.0.0.38:8082/project/34d59a3a-8d04-421e-b65f-82e204288393 2025-08-02 23:32:14,296 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/612a5296-6f44-4914-88e3-c33940b89f78 2025-08-02 23:32:14,315 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/612a5296-6f44-4914-88e3-c33940b89f78 2025-08-02 23:32:14,327 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/b8f0172b-6e74-4e34-a5a4-21098eeef000 2025-08-02 23:32:14,338 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/b8f0172b-6e74-4e34-a5a4-21098eeef000 2025-08-02 23:32:14,351 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/4c16ecb1-b9c1-4527-a23c-ed1614bc6d20 2025-08-02 23:32:14,360 - DEBUG - Route Targets: ['target:64512:8000006'] 2025-08-02 23:32:14,360 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/612a5296-6f44-4914-88e3-c33940b89f78 2025-08-02 23:32:14,378 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/b8f0172b-6e74-4e34-a5a4-21098eeef000 2025-08-02 23:32:14,400 - INFO - Verified VN network id 13 for VN 612a5296-6f44-4914-88e3-c33940b89f78 2025-08-02 23:32:14,400 - INFO - Verifications in API Server for VN ctest-vn-07494235 passed 2025-08-02 23:32:14,400 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/612a5296-6f44-4914-88e3-c33940b89f78 2025-08-02 23:32:14,413 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/b8f0172b-6e74-4e34-a5a4-21098eeef000 2025-08-02 23:32:14,422 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/b8f0172b-6e74-4e34-a5a4-21098eeef000 2025-08-02 23:32:14,431 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/4c16ecb1-b9c1-4527-a23c-ed1614bc6d20 2025-08-02 23:32:14,445 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn-07494235', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestBasicPolicyIpv4v6-06509302', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7001499376766175508', 'uuid-lslong': '9863942259537911672'}, 'enable': 'true', 'created': '2025-08-02T23:32:10', 'last-modified': '2025-08-02T23:32:11', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:02.617610'} 2025-08-02 23:32:14,451 - DEBUG - Route Targets: ['target:64512:8000006'] 2025-08-02 23:32:14,464 - DEBUG - Control-node 10.0.0.254 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn-07494235', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestBasicPolicyIpv4v6-06509302', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7001499376766175508', 'uuid-lslong': '9863942259537911672'}, 'enable': 'true', 'created': '2025-08-02T23:32:10', 'last-modified': '2025-08-02T23:32:11', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:02.609373'} 2025-08-02 23:32:14,478 - DEBUG - Route Targets: ['target:64512:8000006'] 2025-08-02 23:32:14,487 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn-07494235', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestBasicPolicyIpv4v6-06509302', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7001499376766175508', 'uuid-lslong': '9863942259537911672'}, 'enable': 'true', 'created': '2025-08-02T23:32:10', 'last-modified': '2025-08-02T23:32:11', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:02.650799'} 2025-08-02 23:32:14,498 - DEBUG - Route Targets: ['target:64512:8000006'] 2025-08-02 23:32:14,498 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn-07494235 passed 2025-08-02 23:32:14,499 - DEBUG - ====Verifying policy data for ctest-vn-07494235 in API_Server ====== 2025-08-02 23:32:14,499 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-08-02 23:32:14,507 - DEBUG - Requesting: http://10.0.0.38:8082/domain/e48a4202-dd3d-4b87-9406-48f7b2154028 2025-08-02 23:32:14,524 - DEBUG - Requesting: http://10.0.0.38:8082/project/34d59a3a-8d04-421e-b65f-82e204288393 2025-08-02 23:32:14,630 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/612a5296-6f44-4914-88e3-c33940b89f78 2025-08-02 23:32:14,651 - DEBUG - ==>Verifying data for policy with id: f127b67c-8f04-4ac6-b6a4-d36c52fc69b4, fqn: ['default-domain', 'ctest-TestBasicPolicyIpv4v6-06509302', 'ctest-policy-allow-all-68266097'] 2025-08-02 23:32:14,651 - INFO - VN ctest-vn-07494235 Policy verification: verify_vn_policy_in_api_server, status: True 2025-08-02 23:32:14,651 - DEBUG - Verifying the vn in opserver 2025-08-02 23:32:14,651 - DEBUG - Verifying the default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn-07494235 virtual network link through opserver 10.0.0.38 2025-08-02 23:32:14,651 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks 2025-08-02 23:32:14,721 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn-07494235', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn-07494235?flat'} 2025-08-02 23:32:14,721 - DEBUG - Verifying the default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn-07494235 virtual network link through opserver 10.0.0.254 2025-08-02 23:32:14,721 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-networks 2025-08-02 23:32:14,814 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn-07494235', 'href': 'http://10.0.0.254:8081/analytics/uves/virtual-network/default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn-07494235?flat'} 2025-08-02 23:32:14,814 - DEBUG - Verifying the default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn-07494235 virtual network link through opserver 10.0.0.50 2025-08-02 23:32:14,814 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks 2025-08-02 23:32:14,903 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn-07494235', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn-07494235?flat'} 2025-08-02 23:32:14,903 - INFO - Validated that VN default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn-07494235 is found in opserver 2025-08-02 23:32:14,931 - DEBUG - Do not have enough data to verify VN in agent 2025-08-02 23:32:14,946 - DEBUG - VRF ids for VN ctest-vn-07494235: {} 2025-08-02 23:32:15,011 - DEBUG - Services list from nova: [, , , ] 2025-08-02 23:32:16,165 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-3743-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-3743-2) 2025-08-02 23:32:17,689 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-3743-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-3743-1) 2025-08-02 23:32:17,690 - INFO - Waiting for VM ctest-TestBasicPolicyIpv4v6-06509302-27457638 to be up.. 2025-08-02 23:32:17,822 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2025-08-02 23:32:22,943 - DEBUG - VM is in ACTIVE state now 2025-08-02 23:32:22,943 - INFO - VM name : ctest-TestBasicPolicyIpv4v6-06509302-27457638 2025-08-02 23:32:23,077 - DEBUG - VM ctest-TestBasicPolicyIpv4v6-06509302-27457638 ID is cd8f8a57-2ee4-4712-92fa-31d4e75234ea 2025-08-02 23:32:23,102 - DEBUG - VM ctest-TestBasicPolicyIpv4v6-06509302-27457638 launched on Node an-jenkins-deploy-platform-ansible-os-3743-2 2025-08-02 23:32:23,220 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-machine/cd8f8a57-2ee4-4712-92fa-31d4e75234ea 2025-08-02 23:32:23,517 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-machine/cd8f8a57-2ee4-4712-92fa-31d4e75234ea 2025-08-02 23:32:23,568 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-machine-interface/8770b4f6-cba6-4667-ba5f-fbc0f868fd65 2025-08-02 23:32:26,826 - 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') 2025-08-02 23:32:26,826 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicPolicyIpv4v6-06509302-27457638 failed! 2025-08-02 23:32:26,857 - DEBUG - Gateway for vn default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn-82883188 is 218.161.219.193 and allocation pool is NOT set 2025-08-02 23:32:26,857 - DEBUG - Gateway for vn default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn-82883188 is 268a:94f9:369a:6de6:d1f:2054:0:1 and allocation pool is NOT set 2025-08-02 23:32:30,954 - 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 1033ms') 2025-08-02 23:32:30,955 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicPolicyIpv4v6-06509302-27457638 failed! 2025-08-02 23:32:30,991 - DEBUG - Gateway for vn default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn-82883188 is 218.161.219.193 and allocation pool is NOT set 2025-08-02 23:32:30,991 - DEBUG - Gateway for vn default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn-82883188 is 268a:94f9:369a:6de6:d1f:2054:0:1 and allocation pool is NOT set 2025-08-02 23:32:35,080 - 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 1025ms') 2025-08-02 23:32:35,080 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicPolicyIpv4v6-06509302-27457638 failed! 2025-08-02 23:32:35,117 - DEBUG - Gateway for vn default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn-82883188 is 218.161.219.193 and allocation pool is NOT set 2025-08-02 23:32:35,117 - DEBUG - Gateway for vn default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn-82883188 is 268a:94f9:369a:6de6:d1f:2054:0:1 and allocation pool is NOT set 2025-08-02 23:32:39,206 - 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 1031ms') 2025-08-02 23:32:39,206 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicPolicyIpv4v6-06509302-27457638 failed! 2025-08-02 23:32:39,238 - DEBUG - Gateway for vn default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn-82883188 is 218.161.219.193 and allocation pool is NOT set 2025-08-02 23:32:39,239 - DEBUG - Gateway for vn default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn-82883188 is 268a:94f9:369a:6de6:d1f:2054:0:1 and allocation pool is NOT set 2025-08-02 23:32:43,306 - 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 1003ms') 2025-08-02 23:32:43,306 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicPolicyIpv4v6-06509302-27457638 failed! 2025-08-02 23:32:43,341 - DEBUG - Gateway for vn default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn-82883188 is 218.161.219.193 and allocation pool is NOT set 2025-08-02 23:32:43,341 - DEBUG - Gateway for vn default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn-82883188 is 268a:94f9:369a:6de6:d1f:2054:0:1 and allocation pool is NOT set 2025-08-02 23:32:47,429 - 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 1031ms') 2025-08-02 23:32:47,429 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicPolicyIpv4v6-06509302-27457638 failed! 2025-08-02 23:32:47,458 - DEBUG - Gateway for vn default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn-82883188 is 218.161.219.193 and allocation pool is NOT set 2025-08-02 23:32:47,458 - DEBUG - Gateway for vn default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn-82883188 is 268a:94f9:369a:6de6:d1f:2054:0:1 and allocation pool is NOT set 2025-08-02 23:32:51,532 - 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 1006ms') 2025-08-02 23:32:51,533 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicPolicyIpv4v6-06509302-27457638 failed! 2025-08-02 23:32:51,574 - DEBUG - Gateway for vn default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn-82883188 is 218.161.219.193 and allocation pool is NOT set 2025-08-02 23:32:51,574 - DEBUG - Gateway for vn default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn-82883188 is 268a:94f9:369a:6de6:d1f:2054:0:1 and allocation pool is NOT set 2025-08-02 23:32:55,655 - 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') 2025-08-02 23:32:55,656 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicPolicyIpv4v6-06509302-27457638 failed! 2025-08-02 23:32:55,693 - DEBUG - Gateway for vn default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn-82883188 is 218.161.219.193 and allocation pool is NOT set 2025-08-02 23:32:55,693 - DEBUG - Gateway for vn default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn-82883188 is 268a:94f9:369a:6de6:d1f:2054:0:1 and allocation pool is NOT set 2025-08-02 23:32:57,761 - 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=9.71 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=3.39 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 = 3.387/6.549/9.711/3.162 ms') 2025-08-02 23:32:57,761 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicPolicyIpv4v6-06509302-27457638 passed 2025-08-02 23:32:57,911 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-08-02 23:32:57,911 - DEBUG - Waiting to SSH to VM ctest-TestBasicPolicyIpv4v6-06509302-27457638, IP 218.161.219.195, Port 22 2025-08-02 23:32:57,980 - 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': ''} 2025-08-02 23:32:58,094 - DEBUG - VM ctest-TestBasicPolicyIpv4v6-06509302-27457638 is NOT ready for SSH connections, VM status: ACTIVE 2025-08-02 23:33:03,095 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-08-02 23:33:03,095 - DEBUG - Waiting to SSH to VM ctest-TestBasicPolicyIpv4v6-06509302-27457638, IP 218.161.219.195, Port 22 2025-08-02 23:33:03,164 - 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': ''} 2025-08-02 23:33:03,309 - DEBUG - VM ctest-TestBasicPolicyIpv4v6-06509302-27457638 is NOT ready for SSH connections, VM status: ACTIVE 2025-08-02 23:33:08,310 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-08-02 23:33:08,311 - DEBUG - Waiting to SSH to VM ctest-TestBasicPolicyIpv4v6-06509302-27457638, IP 218.161.219.195, Port 22 2025-08-02 23:33:08,380 - 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': ''} 2025-08-02 23:33:08,491 - DEBUG - VM ctest-TestBasicPolicyIpv4v6-06509302-27457638 is NOT ready for SSH connections, VM status: ACTIVE 2025-08-02 23:33:13,491 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-08-02 23:33:13,492 - DEBUG - Waiting to SSH to VM ctest-TestBasicPolicyIpv4v6-06509302-27457638, IP 218.161.219.195, Port 22 2025-08-02 23:33:13,560 - 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': ''} 2025-08-02 23:33:13,688 - DEBUG - VM ctest-TestBasicPolicyIpv4v6-06509302-27457638 is NOT ready for SSH connections, VM status: ACTIVE 2025-08-02 23:33:18,689 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-08-02 23:33:18,689 - DEBUG - Waiting to SSH to VM ctest-TestBasicPolicyIpv4v6-06509302-27457638, IP 218.161.219.195, Port 22 2025-08-02 23:33:18,845 - DEBUG - VM ctest-TestBasicPolicyIpv4v6-06509302-27457638 is ready for SSH connections 2025-08-02 23:33:18,846 - INFO - Waiting for VM ctest-TestBasicPolicyIpv4v6-06509302-96305650 to be up.. 2025-08-02 23:33:18,942 - DEBUG - VM is in ACTIVE state now 2025-08-02 23:33:18,942 - INFO - VM name : ctest-TestBasicPolicyIpv4v6-06509302-96305650 2025-08-02 23:33:19,064 - DEBUG - VM ctest-TestBasicPolicyIpv4v6-06509302-96305650 ID is 4356e3f4-e18e-4895-89ea-31168b8f5251 2025-08-02 23:33:19,065 - DEBUG - VM ctest-TestBasicPolicyIpv4v6-06509302-96305650 launched on Node an-jenkins-deploy-platform-ansible-os-3743-1 2025-08-02 23:33:19,197 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-machine/4356e3f4-e18e-4895-89ea-31168b8f5251 2025-08-02 23:33:19,218 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-machine-interface/aa11c186-2452-4de2-85ee-315728ca2ad4 2025-08-02 23:33:20,468 - 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=2.02 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=2.27 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 = 2.021/2.144/2.268/0.123 ms') 2025-08-02 23:33:20,468 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicPolicyIpv4v6-06509302-96305650 passed 2025-08-02 23:33:20,618 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-08-02 23:33:20,618 - DEBUG - Waiting to SSH to VM ctest-TestBasicPolicyIpv4v6-06509302-96305650, IP 146.217.44.131, Port 22 2025-08-02 23:33:20,786 - DEBUG - VM ctest-TestBasicPolicyIpv4v6-06509302-96305650 is ready for SSH connections 2025-08-02 23:33:20,786 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-08-02 23:33:20,786 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 146.217.44.131, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.49, gateway password: c0ntrail123 2025-08-02 23:33:20,786 - DEBUG - ping -s 56 -c 3 -W 1 146.217.44.131 2025-08-02 23:33:44,356 - DEBUG - PING 146.217.44.131 (146.217.44.131) 56(84) bytes of data. 64 bytes from 146.217.44.131: icmp_req=1 ttl=63 time=10.0 ms 64 bytes from 146.217.44.131: icmp_req=2 ttl=63 time=1.57 ms 64 bytes from 146.217.44.131: icmp_req=3 ttl=63 time=1.12 ms --- 146.217.44.131 ping statistics --- 3 packets transmitted, 3 received, 0% packet loss, time 2004ms rtt min/avg/max/mdev = 1.129/4.257/10.067/4.112 ms 2025-08-02 23:33:44,356 - INFO - Ping to IP 146.217.44.131 from VM ctest-TestBasicPolicyIpv4v6-06509302-27457638 passed 2025-08-02 23:33:44,657 - DEBUG - Policy Update Response {"network-policy": {"uuid": "f127b67c-8f04-4ac6-b6a4-d36c52fc69b4", "href": "http://10.0.0.50:8082/network-policy/f127b67c-8f04-4ac6-b6a4-d36c52fc69b4"}} 2025-08-02 23:33:44,657 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-08-02 23:33:44,657 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 146.217.44.131, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.49, gateway password: c0ntrail123 2025-08-02 23:33:44,657 - DEBUG - ping -s 56 -c 3 -W 1 146.217.44.131 2025-08-02 23:33:48,151 - DEBUG - PING 146.217.44.131 (146.217.44.131) 56(84) bytes of data. 64 bytes from 146.217.44.131: icmp_req=1 ttl=63 time=4.98 ms --- 146.217.44.131 ping statistics --- 3 packets transmitted, 1 received, 66% packet loss, time 2002ms rtt min/avg/max/mdev = 4.989/4.989/4.989/0.000 ms 2025-08-02 23:33:48,151 - WARNING - Ping to IP 146.217.44.131 from VM ctest-TestBasicPolicyIpv4v6-06509302-27457638 failed 2025-08-02 23:33:48,151 - INFO - Deleting VM ctest-TestBasicPolicyIpv4v6-06509302-96305650 2025-08-02 23:33:48,239 - INFO - Deleting VM ctest-TestBasicPolicyIpv4v6-06509302-27457638 2025-08-02 23:33:48,890 - INFO - Deleted policy ctest-policy-allow-all-68266097 2025-08-02 23:33:48,891 - INFO - Deleting VN ctest-vn-07494235 2025-08-02 23:33:48,963 - DEBUG - VN 612a5296-6f44-4914-88e3-c33940b89f78 still in use: Unable to complete operation on network 612a5296-6f44-4914-88e3-c33940b89f78. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-b3e98922-8372-44bc-b15b-c42e022da889'] 2025-08-02 23:33:48,963 - WARNING - Deleting VN ctest-vn-07494235 failed..Will retry 2025-08-02 23:33:51,229 - DEBUG - Response for deleting network () 2025-08-02 23:33:51,230 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/b8f0172b-6e74-4e34-a5a4-21098eeef000 2025-08-02 23:33:51,242 - DEBUG - Response Code: 404 2025-08-02 23:33:51,242 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-08-02 23:33:51,253 - DEBUG - Requesting: http://10.0.0.38:8082/domain/e48a4202-dd3d-4b87-9406-48f7b2154028 2025-08-02 23:33:51,275 - DEBUG - Requesting: http://10.0.0.38:8082/project/34d59a3a-8d04-421e-b65f-82e204288393 2025-08-02 23:33:51,387 - INFO - Validated that VN ctest-vn-07494235 is not found in API Server 2025-08-02 23:33:51,408 - DEBUG - VN ctest-vn-07494235 is not present in Agent 10.0.0.48 2025-08-02 23:33:51,420 - DEBUG - VN ctest-vn-07494235 is not present in Agent 10.0.0.49 2025-08-02 23:33:51,421 - INFO - Validated that VN ctest-vn-07494235 is not in any agent 2025-08-02 23:33:51,470 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn-07494235 info 2025-08-02 23:33:51,471 - INFO - Deleting VN ctest-vn-82883188 2025-08-02 23:33:51,771 - DEBUG - Response for deleting network () 2025-08-02 23:33:51,771 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/1baa65d1-f1c6-4add-9ea5-16276790600d 2025-08-02 23:33:51,784 - DEBUG - Response Code: 404 2025-08-02 23:33:51,784 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-08-02 23:33:51,793 - DEBUG - Requesting: http://10.0.0.38:8082/domain/e48a4202-dd3d-4b87-9406-48f7b2154028 2025-08-02 23:33:51,819 - DEBUG - Requesting: http://10.0.0.38:8082/project/34d59a3a-8d04-421e-b65f-82e204288393 2025-08-02 23:33:51,925 - INFO - Validated that VN ctest-vn-82883188 is not found in API Server 2025-08-02 23:33:51,939 - DEBUG - VN ctest-vn-82883188 is not present in Agent 10.0.0.48 2025-08-02 23:33:51,952 - DEBUG - VN ctest-vn-82883188 is not present in Agent 10.0.0.49 2025-08-02 23:33:51,952 - INFO - Validated that VN ctest-vn-82883188 is not in any agent 2025-08-02 23:33:51,998 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn-82883188 info 2025-08-02 23:33:53,369 - DEBUG - No XMPP flaps were noticed during the test

2025-08-02 23:33:53,369 - INFO - END TEST : test_basic_policy_allow_deny : PASSED[0:01:47]

2025-08-02 23:33:53,369 - INFO - -------------------------------------------------------------------------------- 2025-08-02 23:33:53,372 - INFO - ================================================================================ 2025-08-02 23:33:53,372 - INFO - STARTING TEST : test_policy 2025-08-02 23:33:54,722 - DEBUG - Nothing to compare xmpp stats {'10.0.0.48': {'10.20.0.17': '0', '10.20.0.14': '0'}, '10.0.0.49': {'10.20.0.17': '0', '10.20.0.14': '0'}} with 2025-08-02 23:33:54,722 - INFO - Initial checks done. Running the testcase now 2025-08-02 23:33:54,722 - INFO - 2025-08-02 23:33:54,722 - INFO - ================================================================================ 2025-08-02 23:33:54,723 - INFO - STARTING TEST : test_policy 2025-08-02 23:33:54,723 - INFO - TEST DESCRIPTION : Configure policies based on topology and run policy related verifications. 2025-08-02 23:33:56,147 - DEBUG - Nothing to compare xmpp stats {'10.0.0.48': {'10.20.0.17': '0', '10.20.0.14': '0'}, '10.0.0.49': {'10.20.0.17': '0', '10.20.0.14': '0'}} with 2025-08-02 23:33:56,148 - INFO - Initial checks done. Running the testcase now 2025-08-02 23:33:56,148 - INFO - 2025-08-02 23:33:56,148 - INFO - Scenario for the test used is: 2025-08-02 23:33:56,149 - DEBUG - Starting setup 2025-08-02 23:33:56,640 - INFO - Using existing project ['default-domain', 'ctest-TestBasicPolicyIpv4v6-06509302'](34d59a3a-8d04-421e-b65f-82e204288393) 2025-08-02 23:33:56,640 - INFO - provision user ctest-TestBasicPolicyIpv4v6-06509302 with role as admin in tenant ctest-TestBasicPolicyIpv4v6-06509302 2025-08-02 23:33:57,042 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-08-02 23:33:57,053 - DEBUG - Requesting: http://10.0.0.38:8082/domain/e48a4202-dd3d-4b87-9406-48f7b2154028 2025-08-02 23:33:57,069 - DEBUG - Requesting: http://10.0.0.38:8082/project/34d59a3a-8d04-421e-b65f-82e204288393 2025-08-02 23:33:57,206 - DEBUG - Requesting: http://10.0.0.254:8082/domains 2025-08-02 23:33:57,534 - DEBUG - Requesting: http://10.0.0.254:8082/domains 2025-08-02 23:33:57,615 - DEBUG - Requesting: http://10.0.0.254:8082/domain/e48a4202-dd3d-4b87-9406-48f7b2154028 2025-08-02 23:33:57,647 - DEBUG - Requesting: http://10.0.0.254:8082/project/34d59a3a-8d04-421e-b65f-82e204288393 2025-08-02 23:33:57,780 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2025-08-02 23:33:57,797 - DEBUG - Requesting: http://10.0.0.50:8082/domain/e48a4202-dd3d-4b87-9406-48f7b2154028 2025-08-02 23:33:57,829 - DEBUG - Requesting: http://10.0.0.50:8082/project/34d59a3a-8d04-421e-b65f-82e204288393 2025-08-02 23:33:57,985 - INFO - Verification of project ctest-TestBasicPolicyIpv4v6-06509302 in API Server 10.0.0.50 passed 2025-08-02 23:33:58,337 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-08-02 23:33:58,346 - DEBUG - Requesting: http://10.0.0.38:8082/domain/e48a4202-dd3d-4b87-9406-48f7b2154028 2025-08-02 23:33:58,370 - DEBUG - Requesting: http://10.0.0.38:8082/project/34d59a3a-8d04-421e-b65f-82e204288393 2025-08-02 23:33:58,499 - DEBUG - Requesting: http://10.0.0.38:8082/network-ipam/b9ded2ca-7cc2-49b2-b05e-a441751485e7 2025-08-02 23:33:58,510 - INFO - Verifications in API Server for IPAM: ctest-TestBasicPolicyIpv4v6-06509302-default-ipam passed 2025-08-02 23:33:58,519 - DEBUG - Control-node 10.0.0.38 : IPAM object is : {'node_name': 'network-ipam:default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-TestBasicPolicyIpv4v6-06509302-default-ipam', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestBasicPolicyIpv4v6-06509302', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13393374108964768178', 'uuid-lslong': '12708775799530227175'}, 'enable': 'true', 'created': '2025-08-02T23:33:58', 'last-modified': '2025-08-02T23:33:58', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.194486'} 2025-08-02 23:33:58,533 - DEBUG - Control-node 10.0.0.254 : IPAM object is : {'node_name': 'network-ipam:default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-TestBasicPolicyIpv4v6-06509302-default-ipam', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestBasicPolicyIpv4v6-06509302', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13393374108964768178', 'uuid-lslong': '12708775799530227175'}, 'enable': 'true', 'created': '2025-08-02T23:33:58', 'last-modified': '2025-08-02T23:33:58', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.201464'} 2025-08-02 23:33:58,546 - DEBUG - Control-node 10.0.0.50 : IPAM object is : {'node_name': 'network-ipam:default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-TestBasicPolicyIpv4v6-06509302-default-ipam', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestBasicPolicyIpv4v6-06509302', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13393374108964768178', 'uuid-lslong': '12708775799530227175'}, 'enable': 'true', 'created': '2025-08-02T23:33:58', 'last-modified': '2025-08-02T23:33:58', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.221452'} 2025-08-02 23:33:58,547 - INFO - Verifications in Control node for IPAM: ctest-TestBasicPolicyIpv4v6-06509302-default-ipam passed 2025-08-02 23:33:58,980 - DEBUG - Response for create_network : {'network': {'id': '32649cb6-be55-4283-aa28-9848ff9bbc1a', 'name': 'ctest-vnet0-44636210', 'tenant_id': '34d59a3a8d04421eb65f82e204288393', 'project_id': '34d59a3a8d04421eb65f82e204288393', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestBasicPolicyIpv4v6-06509302', 'ctest-vnet0-44636210'], 'port_security_enabled': True, 'description': ''}} 2025-08-02 23:33:59,288 - DEBUG - Response for create_subnet : {'subnet': {'id': 'b66ca3ca-2429-481c-9b85-63318742ae4d', 'name': '', 'tenant_id': '34d59a3a8d04421eb65f82e204288393', 'network_id': '32649cb6-be55-4283-aa28-9848ff9bbc1a', 'ip_version': 4, 'cidr': '10.1.1.0/24', 'allocation_pools': [{'start': '10.1.1.2', 'end': '10.1.1.254'}], 'gateway_ip': '10.1.1.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '10.1.1.2', 'tags': [], 'project_id': '34d59a3a8d04421eb65f82e204288393'}} 2025-08-02 23:33:59,586 - DEBUG - Response for create_subnet : {'subnet': {'id': '6d218ac4-b8bd-497c-908a-a58ccf9717cb', 'name': '', 'tenant_id': '34d59a3a8d04421eb65f82e204288393', 'network_id': '32649cb6-be55-4283-aa28-9848ff9bbc1a', 'ip_version': 4, 'cidr': '11.1.1.0/24', 'allocation_pools': [{'start': '11.1.1.2', 'end': '11.1.1.254'}], 'gateway_ip': '11.1.1.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '11.1.1.2', 'tags': [], 'project_id': '34d59a3a8d04421eb65f82e204288393'}} 2025-08-02 23:33:59,961 - DEBUG - Response for create_subnet : {'subnet': {'id': 'c45077c6-3656-4671-86fa-2ee00d376051', 'name': '', 'tenant_id': '34d59a3a8d04421eb65f82e204288393', 'network_id': '32649cb6-be55-4283-aa28-9848ff9bbc1a', 'ip_version': 6, 'cidr': '2c87:ae4b:a4a8:499c:620e:87fa::/96', 'allocation_pools': [{'start': '2c87:ae4b:a4a8:499c:620e:87fa:0:2', 'end': '2c87:ae4b:a4a8:499c:620e:87fa:ffff:fffe'}], 'gateway_ip': '2c87:ae4b:a4a8:499c:620e:87fa:0:1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '2c87:ae4b:a4a8:499c:620e:87fa:0:2', 'tags': [], 'project_id': '34d59a3a8d04421eb65f82e204288393'}} 2025-08-02 23:34:00,007 - INFO - Created VN ctest-vnet0-44636210 2025-08-02 23:34:00,035 - DEBUG - VN ctest-vnet0-44636210 UUID is 32649cb6-be55-4283-aa28-9848ff9bbc1a 2025-08-02 23:34:00,252 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-08-02 23:34:00,260 - DEBUG - Requesting: http://10.0.0.38:8082/domain/e48a4202-dd3d-4b87-9406-48f7b2154028 2025-08-02 23:34:00,277 - DEBUG - Requesting: http://10.0.0.38:8082/project/34d59a3a-8d04-421e-b65f-82e204288393 2025-08-02 23:34:00,395 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/32649cb6-be55-4283-aa28-9848ff9bbc1a 2025-08-02 23:34:00,416 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/32649cb6-be55-4283-aa28-9848ff9bbc1a 2025-08-02 23:34:00,430 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/6e30b63c-f517-4f1e-92c3-f10208272b83 2025-08-02 23:34:00,443 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/6e30b63c-f517-4f1e-92c3-f10208272b83 2025-08-02 23:34:00,456 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/f691d7c6-0433-408c-839a-421f552f7c1e 2025-08-02 23:34:00,468 - DEBUG - Route Targets: ['target:64512:8000005'] 2025-08-02 23:34:00,468 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/32649cb6-be55-4283-aa28-9848ff9bbc1a 2025-08-02 23:34:00,485 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/6e30b63c-f517-4f1e-92c3-f10208272b83 2025-08-02 23:34:00,510 - INFO - Verified VN network id 12 for VN 32649cb6-be55-4283-aa28-9848ff9bbc1a 2025-08-02 23:34:00,511 - INFO - Verifications in API Server for VN ctest-vnet0-44636210 passed 2025-08-02 23:34:00,511 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/32649cb6-be55-4283-aa28-9848ff9bbc1a 2025-08-02 23:34:00,526 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/6e30b63c-f517-4f1e-92c3-f10208272b83 2025-08-02 23:34:00,538 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/6e30b63c-f517-4f1e-92c3-f10208272b83 2025-08-02 23:34:00,549 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/f691d7c6-0433-408c-839a-421f552f7c1e 2025-08-02 23:34:00,570 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet0-44636210', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestBasicPolicyIpv4v6-06509302', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3631199508258701955', 'uuid-lslong': '12261217424809638938'}, 'enable': 'true', 'created': '2025-08-02T23:33:58', 'last-modified': '2025-08-02T23:33:59', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.692402'} 2025-08-02 23:34:00,580 - DEBUG - Route Targets: ['target:64512:8000005'] 2025-08-02 23:34:00,597 - DEBUG - Control-node 10.0.0.254 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet0-44636210', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestBasicPolicyIpv4v6-06509302', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3631199508258701955', 'uuid-lslong': '12261217424809638938'}, 'enable': 'true', 'created': '2025-08-02T23:33:58', 'last-modified': '2025-08-02T23:33:59', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.726068'} 2025-08-02 23:34:00,616 - DEBUG - Route Targets: ['target:64512:8000005'] 2025-08-02 23:34:00,632 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet0-44636210', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestBasicPolicyIpv4v6-06509302', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3631199508258701955', 'uuid-lslong': '12261217424809638938'}, 'enable': 'true', 'created': '2025-08-02T23:33:58', 'last-modified': '2025-08-02T23:33:59', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.756639'} 2025-08-02 23:34:00,649 - DEBUG - Route Targets: ['target:64512:8000005'] 2025-08-02 23:34:00,649 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vnet0-44636210 passed 2025-08-02 23:34:00,649 - DEBUG - ====Verifying policy data for ctest-vnet0-44636210 in API_Server ====== 2025-08-02 23:34:00,650 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-08-02 23:34:00,658 - DEBUG - Requesting: http://10.0.0.38:8082/domain/e48a4202-dd3d-4b87-9406-48f7b2154028 2025-08-02 23:34:00,676 - DEBUG - Requesting: http://10.0.0.38:8082/project/34d59a3a-8d04-421e-b65f-82e204288393 2025-08-02 23:34:00,805 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/32649cb6-be55-4283-aa28-9848ff9bbc1a 2025-08-02 23:34:00,822 - DEBUG - =>VN ctest-vnet0-44636210 has no policy to be verified 2025-08-02 23:34:00,822 - DEBUG - Verifying the vn in opserver 2025-08-02 23:34:00,822 - DEBUG - Verifying the default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet0-44636210 virtual network link through opserver 10.0.0.38 2025-08-02 23:34:00,822 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks 2025-08-02 23:34:00,838 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet0-44636210', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet0-44636210?flat'} 2025-08-02 23:34:00,838 - DEBUG - Verifying the default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet0-44636210 virtual network link through opserver 10.0.0.254 2025-08-02 23:34:00,838 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-networks 2025-08-02 23:34:00,863 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet0-44636210', 'href': 'http://10.0.0.254:8081/analytics/uves/virtual-network/default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet0-44636210?flat'} 2025-08-02 23:34:00,863 - DEBUG - Verifying the default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet0-44636210 virtual network link through opserver 10.0.0.50 2025-08-02 23:34:00,863 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks 2025-08-02 23:34:00,886 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet0-44636210', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet0-44636210?flat'} 2025-08-02 23:34:00,886 - INFO - Validated that VN default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet0-44636210 is found in opserver 2025-08-02 23:34:00,918 - DEBUG - Do not have enough data to verify VN in agent 2025-08-02 23:34:00,932 - DEBUG - VRF ids for VN ctest-vnet0-44636210: {} 2025-08-02 23:34:01,340 - DEBUG - Response for create_network : {'network': {'id': '16d102c9-51ea-4c1f-afec-c6af4bbbcdf9', 'name': 'ctest-vnet1-78450148', 'tenant_id': '34d59a3a8d04421eb65f82e204288393', 'project_id': '34d59a3a8d04421eb65f82e204288393', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestBasicPolicyIpv4v6-06509302', 'ctest-vnet1-78450148'], 'port_security_enabled': True, 'description': ''}} 2025-08-02 23:34:01,684 - DEBUG - Response for create_subnet : {'subnet': {'id': '51a2e75c-c1d4-4a37-8330-ecd4b4a77a45', 'name': '', 'tenant_id': '34d59a3a8d04421eb65f82e204288393', 'network_id': '16d102c9-51ea-4c1f-afec-c6af4bbbcdf9', 'ip_version': 4, 'cidr': '12.1.1.0/24', 'allocation_pools': [{'start': '12.1.1.2', 'end': '12.1.1.254'}], 'gateway_ip': '12.1.1.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '12.1.1.2', 'tags': [], 'project_id': '34d59a3a8d04421eb65f82e204288393'}} 2025-08-02 23:34:01,939 - DEBUG - Response for create_subnet : {'subnet': {'id': '069c5fff-c592-4025-a05f-881ad6e69bd0', 'name': '', 'tenant_id': '34d59a3a8d04421eb65f82e204288393', 'network_id': '16d102c9-51ea-4c1f-afec-c6af4bbbcdf9', 'ip_version': 4, 'cidr': '13.1.1.0/24', 'allocation_pools': [{'start': '13.1.1.2', 'end': '13.1.1.254'}], 'gateway_ip': '13.1.1.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '13.1.1.2', 'tags': [], 'project_id': '34d59a3a8d04421eb65f82e204288393'}} 2025-08-02 23:34:02,182 - DEBUG - Response for create_subnet : {'subnet': {'id': '523a2513-a25d-4b88-a196-25871847138c', 'name': '', 'tenant_id': '34d59a3a8d04421eb65f82e204288393', 'network_id': '16d102c9-51ea-4c1f-afec-c6af4bbbcdf9', 'ip_version': 6, 'cidr': '3ff4:adc:c8d7:a906:3cf1:9177::/96', 'allocation_pools': [{'start': '3ff4:adc:c8d7:a906:3cf1:9177:0:2', 'end': '3ff4:adc:c8d7:a906:3cf1:9177:ffff:fffe'}], 'gateway_ip': '3ff4:adc:c8d7:a906:3cf1:9177:0:1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '3ff4:adc:c8d7:a906:3cf1:9177:0:2', 'tags': [], 'project_id': '34d59a3a8d04421eb65f82e204288393'}} 2025-08-02 23:34:02,215 - INFO - Created VN ctest-vnet1-78450148 2025-08-02 23:34:02,232 - DEBUG - VN ctest-vnet1-78450148 UUID is 16d102c9-51ea-4c1f-afec-c6af4bbbcdf9 2025-08-02 23:34:02,420 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-08-02 23:34:02,430 - DEBUG - Requesting: http://10.0.0.38:8082/domain/e48a4202-dd3d-4b87-9406-48f7b2154028 2025-08-02 23:34:02,443 - DEBUG - Requesting: http://10.0.0.38:8082/project/34d59a3a-8d04-421e-b65f-82e204288393 2025-08-02 23:34:02,574 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/16d102c9-51ea-4c1f-afec-c6af4bbbcdf9 2025-08-02 23:34:02,590 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/16d102c9-51ea-4c1f-afec-c6af4bbbcdf9 2025-08-02 23:34:02,603 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/119bd77b-8873-4262-95da-08fbe0775123 2025-08-02 23:34:02,615 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/119bd77b-8873-4262-95da-08fbe0775123 2025-08-02 23:34:02,626 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/26f5e293-e3d2-4884-9462-aa8a8e87a4ae 2025-08-02 23:34:02,635 - DEBUG - Route Targets: ['target:64512:8000006'] 2025-08-02 23:34:02,635 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/16d102c9-51ea-4c1f-afec-c6af4bbbcdf9 2025-08-02 23:34:02,647 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/119bd77b-8873-4262-95da-08fbe0775123 2025-08-02 23:34:02,671 - INFO - Verified VN network id 13 for VN 16d102c9-51ea-4c1f-afec-c6af4bbbcdf9 2025-08-02 23:34:02,671 - INFO - Verifications in API Server for VN ctest-vnet1-78450148 passed 2025-08-02 23:34:02,671 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/16d102c9-51ea-4c1f-afec-c6af4bbbcdf9 2025-08-02 23:34:02,686 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/119bd77b-8873-4262-95da-08fbe0775123 2025-08-02 23:34:02,697 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/119bd77b-8873-4262-95da-08fbe0775123 2025-08-02 23:34:02,707 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/26f5e293-e3d2-4884-9462-aa8a8e87a4ae 2025-08-02 23:34:02,723 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet1-78450148', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestBasicPolicyIpv4v6-06509302', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1644098402652933151', 'uuid-lslong': '12676725507333279225'}, 'enable': 'true', 'created': '2025-08-02T23:34:01', 'last-modified': '2025-08-02T23:34:02', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.604002'} 2025-08-02 23:34:02,730 - DEBUG - Route Targets: ['target:64512:8000006'] 2025-08-02 23:34:02,742 - DEBUG - Control-node 10.0.0.254 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet1-78450148', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestBasicPolicyIpv4v6-06509302', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1644098402652933151', 'uuid-lslong': '12676725507333279225'}, 'enable': 'true', 'created': '2025-08-02T23:34:01', 'last-modified': '2025-08-02T23:34:02', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.623712'} 2025-08-02 23:34:02,756 - DEBUG - Route Targets: ['target:64512:8000006'] 2025-08-02 23:34:02,765 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet1-78450148', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestBasicPolicyIpv4v6-06509302', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1644098402652933151', 'uuid-lslong': '12676725507333279225'}, 'enable': 'true', 'created': '2025-08-02T23:34:01', 'last-modified': '2025-08-02T23:34:02', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.644718'} 2025-08-02 23:34:02,776 - DEBUG - Route Targets: ['target:64512:8000006'] 2025-08-02 23:34:02,777 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vnet1-78450148 passed 2025-08-02 23:34:02,777 - DEBUG - ====Verifying policy data for ctest-vnet1-78450148 in API_Server ====== 2025-08-02 23:34:02,777 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-08-02 23:34:02,785 - DEBUG - Requesting: http://10.0.0.38:8082/domain/e48a4202-dd3d-4b87-9406-48f7b2154028 2025-08-02 23:34:02,800 - DEBUG - Requesting: http://10.0.0.38:8082/project/34d59a3a-8d04-421e-b65f-82e204288393 2025-08-02 23:34:02,908 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/16d102c9-51ea-4c1f-afec-c6af4bbbcdf9 2025-08-02 23:34:02,924 - DEBUG - =>VN ctest-vnet1-78450148 has no policy to be verified 2025-08-02 23:34:02,924 - DEBUG - Verifying the vn in opserver 2025-08-02 23:34:02,924 - DEBUG - Verifying the default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet1-78450148 virtual network link through opserver 10.0.0.38 2025-08-02 23:34:02,924 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks 2025-08-02 23:34:02,941 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet1-78450148', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet1-78450148?flat'} 2025-08-02 23:34:02,941 - DEBUG - Verifying the default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet1-78450148 virtual network link through opserver 10.0.0.254 2025-08-02 23:34:02,941 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-networks 2025-08-02 23:34:03,014 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet1-78450148', 'href': 'http://10.0.0.254:8081/analytics/uves/virtual-network/default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet1-78450148?flat'} 2025-08-02 23:34:03,014 - DEBUG - Verifying the default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet1-78450148 virtual network link through opserver 10.0.0.50 2025-08-02 23:34:03,014 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks 2025-08-02 23:34:03,037 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet1-78450148', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet1-78450148?flat'} 2025-08-02 23:34:03,037 - INFO - Validated that VN default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet1-78450148 is found in opserver 2025-08-02 23:34:03,064 - DEBUG - Do not have enough data to verify VN in agent 2025-08-02 23:34:03,078 - DEBUG - VRF ids for VN ctest-vnet1-78450148: {} 2025-08-02 23:34:03,501 - DEBUG - Response for create_network : {'network': {'id': 'f0d279d7-fbc3-4c5a-a552-b07b63cc8e90', 'name': 'ctest-vnet2-05275703', 'tenant_id': '34d59a3a8d04421eb65f82e204288393', 'project_id': '34d59a3a8d04421eb65f82e204288393', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestBasicPolicyIpv4v6-06509302', 'ctest-vnet2-05275703'], 'port_security_enabled': True, 'description': ''}} 2025-08-02 23:34:03,818 - DEBUG - Response for create_subnet : {'subnet': {'id': 'db87633f-f540-4c04-8c13-254d12c6e51f', 'name': '', 'tenant_id': '34d59a3a8d04421eb65f82e204288393', 'network_id': 'f0d279d7-fbc3-4c5a-a552-b07b63cc8e90', 'ip_version': 4, 'cidr': '14.1.1.0/24', 'allocation_pools': [{'start': '14.1.1.2', 'end': '14.1.1.254'}], 'gateway_ip': '14.1.1.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '14.1.1.2', 'tags': [], 'project_id': '34d59a3a8d04421eb65f82e204288393'}} 2025-08-02 23:34:04,120 - DEBUG - Response for create_subnet : {'subnet': {'id': '6d3d06ed-22dc-4988-acc3-b59306a58391', 'name': '', 'tenant_id': '34d59a3a8d04421eb65f82e204288393', 'network_id': 'f0d279d7-fbc3-4c5a-a552-b07b63cc8e90', 'ip_version': 4, 'cidr': '15.1.1.0/24', 'allocation_pools': [{'start': '15.1.1.2', 'end': '15.1.1.254'}], 'gateway_ip': '15.1.1.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '15.1.1.2', 'tags': [], 'project_id': '34d59a3a8d04421eb65f82e204288393'}} 2025-08-02 23:34:04,389 - DEBUG - Response for create_subnet : {'subnet': {'id': '906dcbc8-7f41-4c25-b52d-0b50d4179152', 'name': '', 'tenant_id': '34d59a3a8d04421eb65f82e204288393', 'network_id': 'f0d279d7-fbc3-4c5a-a552-b07b63cc8e90', 'ip_version': 6, 'cidr': '3e31:b3fb:f72e:677a:a747:168f::/96', 'allocation_pools': [{'start': '3e31:b3fb:f72e:677a:a747:168f:0:2', 'end': '3e31:b3fb:f72e:677a:a747:168f:ffff:fffe'}], 'gateway_ip': '3e31:b3fb:f72e:677a:a747:168f:0:1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '3e31:b3fb:f72e:677a:a747:168f:0:2', 'tags': [], 'project_id': '34d59a3a8d04421eb65f82e204288393'}} 2025-08-02 23:34:04,418 - INFO - Created VN ctest-vnet2-05275703 2025-08-02 23:34:04,433 - DEBUG - VN ctest-vnet2-05275703 UUID is f0d279d7-fbc3-4c5a-a552-b07b63cc8e90 2025-08-02 23:34:04,601 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-08-02 23:34:04,611 - DEBUG - Requesting: http://10.0.0.38:8082/domain/e48a4202-dd3d-4b87-9406-48f7b2154028 2025-08-02 23:34:04,626 - DEBUG - Requesting: http://10.0.0.38:8082/project/34d59a3a-8d04-421e-b65f-82e204288393 2025-08-02 23:34:04,750 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/f0d279d7-fbc3-4c5a-a552-b07b63cc8e90 2025-08-02 23:34:04,771 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/f0d279d7-fbc3-4c5a-a552-b07b63cc8e90 2025-08-02 23:34:04,789 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/da11b25c-16ee-4f55-82c9-1b158bd5a340 2025-08-02 23:34:04,800 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/da11b25c-16ee-4f55-82c9-1b158bd5a340 2025-08-02 23:34:04,815 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/9fb891c9-233c-4d5a-b094-e34f6a25a0f9 2025-08-02 23:34:04,824 - DEBUG - Route Targets: ['target:64512:8000007'] 2025-08-02 23:34:04,825 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/f0d279d7-fbc3-4c5a-a552-b07b63cc8e90 2025-08-02 23:34:04,837 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/da11b25c-16ee-4f55-82c9-1b158bd5a340 2025-08-02 23:34:04,859 - INFO - Verified VN network id 14 for VN f0d279d7-fbc3-4c5a-a552-b07b63cc8e90 2025-08-02 23:34:04,859 - INFO - Verifications in API Server for VN ctest-vnet2-05275703 passed 2025-08-02 23:34:04,859 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/f0d279d7-fbc3-4c5a-a552-b07b63cc8e90 2025-08-02 23:34:04,873 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/da11b25c-16ee-4f55-82c9-1b158bd5a340 2025-08-02 23:34:04,883 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/da11b25c-16ee-4f55-82c9-1b158bd5a340 2025-08-02 23:34:04,893 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/9fb891c9-233c-4d5a-b094-e34f6a25a0f9 2025-08-02 23:34:04,908 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet2-05275703', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestBasicPolicyIpv4v6-06509302', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17353066282760752218', 'uuid-lslong': '11912778008350199440'}, 'enable': 'true', 'created': '2025-08-02T23:34:03', 'last-modified': '2025-08-02T23:34:04', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.583702'} 2025-08-02 23:34:04,915 - DEBUG - Route Targets: ['target:64512:8000007'] 2025-08-02 23:34:04,924 - DEBUG - Control-node 10.0.0.254 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet2-05275703', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestBasicPolicyIpv4v6-06509302', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17353066282760752218', 'uuid-lslong': '11912778008350199440'}, 'enable': 'true', 'created': '2025-08-02T23:34:03', 'last-modified': '2025-08-02T23:34:04', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.607295'} 2025-08-02 23:34:04,933 - DEBUG - Route Targets: ['target:64512:8000007'] 2025-08-02 23:34:04,947 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet2-05275703', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestBasicPolicyIpv4v6-06509302', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17353066282760752218', 'uuid-lslong': '11912778008350199440'}, 'enable': 'true', 'created': '2025-08-02T23:34:03', 'last-modified': '2025-08-02T23:34:04', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.628400'} 2025-08-02 23:34:04,965 - DEBUG - Route Targets: ['target:64512:8000007'] 2025-08-02 23:34:04,965 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vnet2-05275703 passed 2025-08-02 23:34:04,966 - DEBUG - ====Verifying policy data for ctest-vnet2-05275703 in API_Server ====== 2025-08-02 23:34:04,966 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-08-02 23:34:04,976 - DEBUG - Requesting: http://10.0.0.38:8082/domain/e48a4202-dd3d-4b87-9406-48f7b2154028 2025-08-02 23:34:04,993 - DEBUG - Requesting: http://10.0.0.38:8082/project/34d59a3a-8d04-421e-b65f-82e204288393 2025-08-02 23:34:05,108 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/f0d279d7-fbc3-4c5a-a552-b07b63cc8e90 2025-08-02 23:34:05,130 - DEBUG - =>VN ctest-vnet2-05275703 has no policy to be verified 2025-08-02 23:34:05,130 - DEBUG - Verifying the vn in opserver 2025-08-02 23:34:05,130 - DEBUG - Verifying the default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet2-05275703 virtual network link through opserver 10.0.0.38 2025-08-02 23:34:05,130 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks 2025-08-02 23:34:05,195 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet2-05275703', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet2-05275703?flat'} 2025-08-02 23:34:05,195 - DEBUG - Verifying the default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet2-05275703 virtual network link through opserver 10.0.0.254 2025-08-02 23:34:05,195 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-networks 2025-08-02 23:34:05,221 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet2-05275703', 'href': 'http://10.0.0.254:8081/analytics/uves/virtual-network/default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet2-05275703?flat'} 2025-08-02 23:34:05,222 - DEBUG - Verifying the default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet2-05275703 virtual network link through opserver 10.0.0.50 2025-08-02 23:34:05,222 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks 2025-08-02 23:34:05,302 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet2-05275703', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet2-05275703?flat'} 2025-08-02 23:34:05,303 - INFO - Validated that VN default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet2-05275703 is found in opserver 2025-08-02 23:34:05,335 - DEBUG - Do not have enough data to verify VN in agent 2025-08-02 23:34:05,348 - DEBUG - VRF ids for VN ctest-vnet2-05275703: {} 2025-08-02 23:34:05,802 - DEBUG - Response for create_network : {'network': {'id': '0265521e-513e-4b57-a847-2fcf27176bae', 'name': 'ctest-vnet3-74042446', 'tenant_id': '34d59a3a8d04421eb65f82e204288393', 'project_id': '34d59a3a8d04421eb65f82e204288393', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestBasicPolicyIpv4v6-06509302', 'ctest-vnet3-74042446'], 'port_security_enabled': True, 'description': ''}} 2025-08-02 23:34:06,138 - DEBUG - Response for create_subnet : {'subnet': {'id': '2c5a2b7b-ecff-49ba-a071-4537ae737e13', 'name': '', 'tenant_id': '34d59a3a8d04421eb65f82e204288393', 'network_id': '0265521e-513e-4b57-a847-2fcf27176bae', 'ip_version': 4, 'cidr': '16.1.1.0/24', 'allocation_pools': [{'start': '16.1.1.2', 'end': '16.1.1.254'}], 'gateway_ip': '16.1.1.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '16.1.1.2', 'tags': [], 'project_id': '34d59a3a8d04421eb65f82e204288393'}} 2025-08-02 23:34:06,342 - DEBUG - Response for create_subnet : {'subnet': {'id': '67b858cb-d9a9-430b-a7b1-550fce8e3398', 'name': '', 'tenant_id': '34d59a3a8d04421eb65f82e204288393', 'network_id': '0265521e-513e-4b57-a847-2fcf27176bae', 'ip_version': 4, 'cidr': '17.1.1.0/24', 'allocation_pools': [{'start': '17.1.1.2', 'end': '17.1.1.254'}], 'gateway_ip': '17.1.1.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '17.1.1.2', 'tags': [], 'project_id': '34d59a3a8d04421eb65f82e204288393'}} 2025-08-02 23:34:06,613 - DEBUG - Response for create_subnet : {'subnet': {'id': '71df46f7-8de7-4be1-a520-39184a5d36a1', 'name': '', 'tenant_id': '34d59a3a8d04421eb65f82e204288393', 'network_id': '0265521e-513e-4b57-a847-2fcf27176bae', 'ip_version': 6, 'cidr': '3e68:20cd:a299:e16d:ad3c:b651::/96', 'allocation_pools': [{'start': '3e68:20cd:a299:e16d:ad3c:b651:0:2', 'end': '3e68:20cd:a299:e16d:ad3c:b651:ffff:fffe'}], 'gateway_ip': '3e68:20cd:a299:e16d:ad3c:b651:0:1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '3e68:20cd:a299:e16d:ad3c:b651:0:2', 'tags': [], 'project_id': '34d59a3a8d04421eb65f82e204288393'}} 2025-08-02 23:34:06,651 - INFO - Created VN ctest-vnet3-74042446 2025-08-02 23:34:06,671 - DEBUG - VN ctest-vnet3-74042446 UUID is 0265521e-513e-4b57-a847-2fcf27176bae 2025-08-02 23:34:06,845 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-08-02 23:34:06,855 - DEBUG - Requesting: http://10.0.0.38:8082/domain/e48a4202-dd3d-4b87-9406-48f7b2154028 2025-08-02 23:34:06,870 - DEBUG - Requesting: http://10.0.0.38:8082/project/34d59a3a-8d04-421e-b65f-82e204288393 2025-08-02 23:34:06,988 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/0265521e-513e-4b57-a847-2fcf27176bae 2025-08-02 23:34:07,010 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/0265521e-513e-4b57-a847-2fcf27176bae 2025-08-02 23:34:07,023 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/e69514ce-6178-45ca-a3e6-6ff5c39dacf2 2025-08-02 23:34:07,034 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/e69514ce-6178-45ca-a3e6-6ff5c39dacf2 2025-08-02 23:34:07,046 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/269376a3-e404-40c5-b32a-a1cbee0c1f41 2025-08-02 23:34:07,060 - DEBUG - Route Targets: ['target:64512:8000008'] 2025-08-02 23:34:07,060 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/0265521e-513e-4b57-a847-2fcf27176bae 2025-08-02 23:34:07,074 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/e69514ce-6178-45ca-a3e6-6ff5c39dacf2 2025-08-02 23:34:07,096 - INFO - Verified VN network id 15 for VN 0265521e-513e-4b57-a847-2fcf27176bae 2025-08-02 23:34:07,096 - INFO - Verifications in API Server for VN ctest-vnet3-74042446 passed 2025-08-02 23:34:07,096 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/0265521e-513e-4b57-a847-2fcf27176bae 2025-08-02 23:34:07,112 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/e69514ce-6178-45ca-a3e6-6ff5c39dacf2 2025-08-02 23:34:07,122 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/e69514ce-6178-45ca-a3e6-6ff5c39dacf2 2025-08-02 23:34:07,132 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/269376a3-e404-40c5-b32a-a1cbee0c1f41 2025-08-02 23:34:07,151 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet3-74042446', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestBasicPolicyIpv4v6-06509302', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '172634450889165655', 'uuid-lslong': '12125713088478931886'}, 'enable': 'true', 'created': '2025-08-02T23:34:05', 'last-modified': '2025-08-02T23:34:06', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.617728'} 2025-08-02 23:34:07,159 - DEBUG - Route Targets: ['target:64512:8000008'] 2025-08-02 23:34:07,170 - DEBUG - Control-node 10.0.0.254 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet3-74042446', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestBasicPolicyIpv4v6-06509302', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '172634450889165655', 'uuid-lslong': '12125713088478931886'}, 'enable': 'true', 'created': '2025-08-02T23:34:05', 'last-modified': '2025-08-02T23:34:06', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.630389'} 2025-08-02 23:34:07,184 - DEBUG - Route Targets: ['target:64512:8000008'] 2025-08-02 23:34:07,196 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet3-74042446', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestBasicPolicyIpv4v6-06509302', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '172634450889165655', 'uuid-lslong': '12125713088478931886'}, 'enable': 'true', 'created': '2025-08-02T23:34:05', 'last-modified': '2025-08-02T23:34:06', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.660343'} 2025-08-02 23:34:07,212 - DEBUG - Route Targets: ['target:64512:8000008'] 2025-08-02 23:34:07,212 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vnet3-74042446 passed 2025-08-02 23:34:07,212 - DEBUG - ====Verifying policy data for ctest-vnet3-74042446 in API_Server ====== 2025-08-02 23:34:07,212 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-08-02 23:34:07,224 - DEBUG - Requesting: http://10.0.0.38:8082/domain/e48a4202-dd3d-4b87-9406-48f7b2154028 2025-08-02 23:34:07,246 - DEBUG - Requesting: http://10.0.0.38:8082/project/34d59a3a-8d04-421e-b65f-82e204288393 2025-08-02 23:34:07,385 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/0265521e-513e-4b57-a847-2fcf27176bae 2025-08-02 23:34:07,404 - DEBUG - =>VN ctest-vnet3-74042446 has no policy to be verified 2025-08-02 23:34:07,404 - DEBUG - Verifying the vn in opserver 2025-08-02 23:34:07,404 - DEBUG - Verifying the default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet3-74042446 virtual network link through opserver 10.0.0.38 2025-08-02 23:34:07,404 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks 2025-08-02 23:34:07,427 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet3-74042446', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet3-74042446?flat'} 2025-08-02 23:34:07,427 - DEBUG - Verifying the default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet3-74042446 virtual network link through opserver 10.0.0.254 2025-08-02 23:34:07,427 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-networks 2025-08-02 23:34:07,449 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet3-74042446', 'href': 'http://10.0.0.254:8081/analytics/uves/virtual-network/default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet3-74042446?flat'} 2025-08-02 23:34:07,449 - DEBUG - Verifying the default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet3-74042446 virtual network link through opserver 10.0.0.50 2025-08-02 23:34:07,449 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks 2025-08-02 23:34:07,478 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet3-74042446', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet3-74042446?flat'} 2025-08-02 23:34:07,479 - INFO - Validated that VN default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet3-74042446 is found in opserver 2025-08-02 23:34:07,508 - DEBUG - Do not have enough data to verify VN in agent 2025-08-02 23:34:07,522 - DEBUG - VRF ids for VN ctest-vnet3-74042446: {} 2025-08-02 23:34:07,534 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = icmp, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet0-44636210, 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-TestBasicPolicyIpv4v6-06509302:ctest-vnet1-78450148, 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 = any, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet0-44636210, 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-TestBasicPolicyIpv4v6-06509302:ctest-vnet0-44636210, 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 = any, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet0-44636210, 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-TestBasicPolicyIpv4v6-06509302:ctest-vnet0-44636210, 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 = any, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet0-44636210, 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-TestBasicPolicyIpv4v6-06509302:ctest-vnet0-44636210, 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 = any, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet0-44636210, security_group = None, network_policy = None, subnet_list = []], src_ports = [start_port = 3, end_port = 3], application = [], dst_addresses = [subnet = None, virtual_network = default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet0-44636210, 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-TestBasicPolicyIpv4v6-06509302:ctest-vnet0-44636210, 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-TestBasicPolicyIpv4v6-06509302:ctest-vnet1-78450148, 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-08-02 23:34:07,858 - DEBUG - ====Verifying data for ctest-policy0-94101144 in API_Server ====== 2025-08-02 23:34:07,858 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-08-02 23:34:07,874 - DEBUG - Requesting: http://10.0.0.38:8082/domain/e48a4202-dd3d-4b87-9406-48f7b2154028 2025-08-02 23:34:07,899 - DEBUG - Requesting: http://10.0.0.38:8082/project/34d59a3a-8d04-421e-b65f-82e204288393 2025-08-02 23:34:08,028 - DEBUG - Requesting: http://10.0.0.38:8082/network-policy/22fcceee-305a-45f2-8c68-f717f8762039 2025-08-02 23:34:08,053 - INFO - Verified policy ctest-policy0-94101144 in API Server, Result: True 2025-08-02 23:34:08,063 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = >, protocol = any, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet0-44636210, 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-TestBasicPolicyIpv4v6-06509302:ctest-vnet0-44636210, 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 = any, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet0-44636210, 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-TestBasicPolicyIpv4v6-06509302:ctest-vnet0-44636210, 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 = any, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet0-44636210, 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-TestBasicPolicyIpv4v6-06509302:ctest-vnet0-44636210, 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 = any, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet0-44636210, security_group = None, network_policy = None, subnet_list = []], src_ports = [start_port = 3, end_port = 3], application = [], dst_addresses = [subnet = None, virtual_network = default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet0-44636210, 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] 2025-08-02 23:34:08,353 - DEBUG - ====Verifying data for ctest-policy1-57279714 in API_Server ====== 2025-08-02 23:34:08,354 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-08-02 23:34:08,367 - DEBUG - Requesting: http://10.0.0.38:8082/domain/e48a4202-dd3d-4b87-9406-48f7b2154028 2025-08-02 23:34:08,386 - DEBUG - Requesting: http://10.0.0.38:8082/project/34d59a3a-8d04-421e-b65f-82e204288393 2025-08-02 23:34:08,502 - DEBUG - Requesting: http://10.0.0.38:8082/network-policy/7314a799-a761-4299-9db5-b6eaa6e008aa 2025-08-02 23:34:08,519 - INFO - Verified policy ctest-policy1-57279714 in API Server, Result: True 2025-08-02 23:34:08,574 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = icmp, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet1-78450148, 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-TestBasicPolicyIpv4v6-06509302:ctest-vnet0-44636210, 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 = udp, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet1-78450148, 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-TestBasicPolicyIpv4v6-06509302:ctest-vnet1-78450148, 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 = udp, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet1-78450148, 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-TestBasicPolicyIpv4v6-06509302:ctest-vnet1-78450148, 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 = udp, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet1-78450148, 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-TestBasicPolicyIpv4v6-06509302:ctest-vnet1-78450148, 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 = udp, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet1-78450148, security_group = None, network_policy = None, subnet_list = []], src_ports = [start_port = 3, end_port = 3], application = [], dst_addresses = [subnet = None, virtual_network = default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet1-78450148, 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-TestBasicPolicyIpv4v6-06509302:ctest-vnet1-78450148, 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-TestBasicPolicyIpv4v6-06509302:ctest-vnet0-44636210, 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-08-02 23:34:08,896 - DEBUG - ====Verifying data for ctest-policy2-54629202 in API_Server ====== 2025-08-02 23:34:08,896 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-08-02 23:34:08,904 - DEBUG - Requesting: http://10.0.0.38:8082/domain/e48a4202-dd3d-4b87-9406-48f7b2154028 2025-08-02 23:34:08,921 - DEBUG - Requesting: http://10.0.0.38:8082/project/34d59a3a-8d04-421e-b65f-82e204288393 2025-08-02 23:34:09,042 - DEBUG - Requesting: http://10.0.0.38:8082/network-policy/bd6a0274-8a3c-4fab-be7b-0f03f8ecc2ce 2025-08-02 23:34:09,059 - INFO - Verified policy ctest-policy2-54629202 in API Server, Result: True 2025-08-02 23:34:09,067 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = >, protocol = icmp, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet1-78450148, 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-TestBasicPolicyIpv4v6-06509302:ctest-vnet1-78450148, 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 = icmp, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet1-78450148, 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-TestBasicPolicyIpv4v6-06509302:ctest-vnet1-78450148, 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 = icmp, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet1-78450148, 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-TestBasicPolicyIpv4v6-06509302:ctest-vnet1-78450148, 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 = icmp, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet1-78450148, security_group = None, network_policy = None, subnet_list = []], src_ports = [start_port = 3, end_port = 3], application = [], dst_addresses = [subnet = None, virtual_network = default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet1-78450148, 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-TestBasicPolicyIpv4v6-06509302:ctest-vnet1-78450148, 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-TestBasicPolicyIpv4v6-06509302:ctest-vnet1-78450148, 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-TestBasicPolicyIpv4v6-06509302:ctest-vnet1-78450148, 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-TestBasicPolicyIpv4v6-06509302:ctest-vnet1-78450148, 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-TestBasicPolicyIpv4v6-06509302:ctest-vnet1-78450148, 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-TestBasicPolicyIpv4v6-06509302:ctest-vnet1-78450148, 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-TestBasicPolicyIpv4v6-06509302:ctest-vnet1-78450148, security_group = None, network_policy = None, subnet_list = []], src_ports = [start_port = 3, end_port = 3], application = [], dst_addresses = [subnet = None, virtual_network = default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet1-78450148, 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] 2025-08-02 23:34:09,402 - DEBUG - ====Verifying data for ctest-policy3-30142472 in API_Server ====== 2025-08-02 23:34:09,402 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-08-02 23:34:09,415 - DEBUG - Requesting: http://10.0.0.38:8082/domain/e48a4202-dd3d-4b87-9406-48f7b2154028 2025-08-02 23:34:09,435 - DEBUG - Requesting: http://10.0.0.38:8082/project/34d59a3a-8d04-421e-b65f-82e204288393 2025-08-02 23:34:09,562 - DEBUG - Requesting: http://10.0.0.38:8082/network-policy/052f0d3f-b8d5-42bb-985e-4da7501f649a 2025-08-02 23:34:09,593 - INFO - Verified policy ctest-policy3-30142472 in API Server, Result: True 2025-08-02 23:34:09,603 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = >, protocol = udp, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet2-05275703, 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-TestBasicPolicyIpv4v6-06509302:ctest-vnet2-05275703, 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 = udp, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet2-05275703, 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-TestBasicPolicyIpv4v6-06509302:ctest-vnet2-05275703, 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 = udp, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet2-05275703, 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-TestBasicPolicyIpv4v6-06509302:ctest-vnet2-05275703, 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 = udp, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet2-05275703, security_group = None, network_policy = None, subnet_list = []], src_ports = [start_port = 3, end_port = 3], application = [], dst_addresses = [subnet = None, virtual_network = default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet2-05275703, 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] 2025-08-02 23:34:09,921 - DEBUG - ====Verifying data for ctest-policy4-56260264 in API_Server ====== 2025-08-02 23:34:09,921 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-08-02 23:34:09,928 - DEBUG - Requesting: http://10.0.0.38:8082/domain/e48a4202-dd3d-4b87-9406-48f7b2154028 2025-08-02 23:34:09,942 - DEBUG - Requesting: http://10.0.0.38:8082/project/34d59a3a-8d04-421e-b65f-82e204288393 2025-08-02 23:34:10,065 - DEBUG - Requesting: http://10.0.0.38:8082/network-policy/59443f57-ba14-485c-8352-a8604cf2daa3 2025-08-02 23:34:10,079 - INFO - Verified policy ctest-policy4-56260264 in API Server, Result: True 2025-08-02 23:34:10,088 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = >, protocol = tcp, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet2-05275703, 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-TestBasicPolicyIpv4v6-06509302:ctest-vnet2-05275703, 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-TestBasicPolicyIpv4v6-06509302:ctest-vnet2-05275703, 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-TestBasicPolicyIpv4v6-06509302:ctest-vnet2-05275703, 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-TestBasicPolicyIpv4v6-06509302:ctest-vnet2-05275703, 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-TestBasicPolicyIpv4v6-06509302:ctest-vnet2-05275703, 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-TestBasicPolicyIpv4v6-06509302:ctest-vnet2-05275703, security_group = None, network_policy = None, subnet_list = []], src_ports = [start_port = 3, end_port = 3], application = [], dst_addresses = [subnet = None, virtual_network = default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet2-05275703, 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] 2025-08-02 23:34:10,358 - DEBUG - ====Verifying data for ctest-policy5-09464733 in API_Server ====== 2025-08-02 23:34:10,358 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-08-02 23:34:10,372 - DEBUG - Requesting: http://10.0.0.38:8082/domain/e48a4202-dd3d-4b87-9406-48f7b2154028 2025-08-02 23:34:10,387 - DEBUG - Requesting: http://10.0.0.38:8082/project/34d59a3a-8d04-421e-b65f-82e204288393 2025-08-02 23:34:10,499 - DEBUG - Requesting: http://10.0.0.38:8082/network-policy/4f0aa6cd-05c3-43d9-81b7-efd7c5d758d6 2025-08-02 23:34:10,513 - INFO - Verified policy ctest-policy5-09464733 in API Server, Result: True 2025-08-02 23:34:10,521 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = >, protocol = icmp, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet3-74042446, 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-TestBasicPolicyIpv4v6-06509302:ctest-vnet3-74042446, 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 = icmp, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet3-74042446, 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-TestBasicPolicyIpv4v6-06509302:ctest-vnet3-74042446, 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 = icmp, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet3-74042446, 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-TestBasicPolicyIpv4v6-06509302:ctest-vnet3-74042446, 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 = icmp, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet3-74042446, security_group = None, network_policy = None, subnet_list = []], src_ports = [start_port = 3, end_port = 3], application = [], dst_addresses = [subnet = None, virtual_network = default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet3-74042446, 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-TestBasicPolicyIpv4v6-06509302:ctest-vnet3-74042446, 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-TestBasicPolicyIpv4v6-06509302:ctest-vnet3-74042446, 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-TestBasicPolicyIpv4v6-06509302:ctest-vnet3-74042446, 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-TestBasicPolicyIpv4v6-06509302:ctest-vnet3-74042446, 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-TestBasicPolicyIpv4v6-06509302:ctest-vnet3-74042446, 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-TestBasicPolicyIpv4v6-06509302:ctest-vnet3-74042446, 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-TestBasicPolicyIpv4v6-06509302:ctest-vnet3-74042446, security_group = None, network_policy = None, subnet_list = []], src_ports = [start_port = 3, end_port = 3], application = [], dst_addresses = [subnet = None, virtual_network = default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet3-74042446, 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] 2025-08-02 23:34:10,842 - DEBUG - ====Verifying data for ctest-policy6-13176554 in API_Server ====== 2025-08-02 23:34:10,842 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-08-02 23:34:10,851 - DEBUG - Requesting: http://10.0.0.38:8082/domain/e48a4202-dd3d-4b87-9406-48f7b2154028 2025-08-02 23:34:10,866 - DEBUG - Requesting: http://10.0.0.38:8082/project/34d59a3a-8d04-421e-b65f-82e204288393 2025-08-02 23:34:10,972 - DEBUG - Requesting: http://10.0.0.38:8082/network-policy/bf91396b-7045-4bc7-9957-0d8a5d0f9680 2025-08-02 23:34:10,991 - INFO - Verified policy ctest-policy6-13176554 in API Server, Result: True 2025-08-02 23:34:11,046 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = >, protocol = any, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet3-74042446, 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-TestBasicPolicyIpv4v6-06509302:ctest-vnet3-74042446, 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 = any, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet3-74042446, 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-TestBasicPolicyIpv4v6-06509302:ctest-vnet3-74042446, 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 = any, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet3-74042446, 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-TestBasicPolicyIpv4v6-06509302:ctest-vnet3-74042446, 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 = any, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet3-74042446, security_group = None, network_policy = None, subnet_list = []], src_ports = [start_port = 3, end_port = 3], application = [], dst_addresses = [subnet = None, virtual_network = default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vnet3-74042446, 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] 2025-08-02 23:34:11,353 - DEBUG - ====Verifying data for ctest-policy7-84293853 in API_Server ====== 2025-08-02 23:34:11,353 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-08-02 23:34:11,361 - DEBUG - Requesting: http://10.0.0.38:8082/domain/e48a4202-dd3d-4b87-9406-48f7b2154028 2025-08-02 23:34:11,377 - DEBUG - Requesting: http://10.0.0.38:8082/project/34d59a3a-8d04-421e-b65f-82e204288393 2025-08-02 23:34:11,500 - DEBUG - Requesting: http://10.0.0.38:8082/network-policy/41bd0bf5-3df1-40c7-8b77-178f788c6415 2025-08-02 23:34:11,515 - INFO - Verified policy ctest-policy7-84293853 in API Server, Result: True 2025-08-02 23:34:11,516 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-08-02 23:34:11,525 - DEBUG - Requesting: http://10.0.0.38:8082/domain/e48a4202-dd3d-4b87-9406-48f7b2154028 2025-08-02 23:34:11,541 - DEBUG - Requesting: http://10.0.0.38:8082/project/34d59a3a-8d04-421e-b65f-82e204288393 2025-08-02 23:34:11,675 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/32649cb6-be55-4283-aa28-9848ff9bbc1a 2025-08-02 23:34:11,690 - DEBUG - Setup step: Associating the policy to VN' 2025-08-02 23:34:11,856 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': '32649cb6-be55-4283-aa28-9848ff9bbc1a', 'name': 'ctest-vnet0-44636210', 'tenant_id': '34d59a3a8d04421eb65f82e204288393', 'project_id': '34d59a3a8d04421eb65f82e204288393', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['b66ca3ca-2429-481c-9b85-63318742ae4d', '6d218ac4-b8bd-497c-908a-a58ccf9717cb', 'c45077c6-3656-4671-86fa-2ee00d376051'], 'fq_name': ['default-domain', 'ctest-TestBasicPolicyIpv4v6-06509302', 'ctest-vnet0-44636210'], 'policys': [['default-domain', 'ctest-TestBasicPolicyIpv4v6-06509302', 'ctest-policy0-94101144'], ['default-domain', 'ctest-TestBasicPolicyIpv4v6-06509302', 'ctest-policy1-57279714']], 'subnet_ipam': [{'subnet_cidr': '10.1.1.0/24', 'ipam_fq_name': ['default-domain', 'ctest-TestBasicPolicyIpv4v6-06509302', 'ctest-TestBasicPolicyIpv4v6-06509302-default-ipam']}, {'subnet_cidr': '11.1.1.0/24', 'ipam_fq_name': ['default-domain', 'ctest-TestBasicPolicyIpv4v6-06509302', 'ctest-TestBasicPolicyIpv4v6-06509302-default-ipam']}, {'subnet_cidr': '2c87:ae4b:a4a8:499c:620e:87fa::/96', 'ipam_fq_name': ['default-domain', 'ctest-TestBasicPolicyIpv4v6-06509302', 'ctest-TestBasicPolicyIpv4v6-06509302-default-ipam']}], 'port_security_enabled': True, 'description': ''}} 2025-08-02 23:34:12,038 - DEBUG - Associated Policy:[['default-domain', 'ctest-TestBasicPolicyIpv4v6-06509302', 'ctest-policy0-94101144'], ['default-domain', 'ctest-TestBasicPolicyIpv4v6-06509302', 'ctest-policy1-57279714']] to ctest-vnet0-44636210 2025-08-02 23:34:12,039 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-08-02 23:34:12,047 - DEBUG - Requesting: http://10.0.0.38:8082/domain/e48a4202-dd3d-4b87-9406-48f7b2154028 2025-08-02 23:34:12,063 - DEBUG - Requesting: http://10.0.0.38:8082/project/34d59a3a-8d04-421e-b65f-82e204288393 2025-08-02 23:34:12,171 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/16d102c9-51ea-4c1f-afec-c6af4bbbcdf9 2025-08-02 23:34:12,184 - DEBUG - Setup step: Associating the policy to VN' 2025-08-02 23:34:12,336 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': '16d102c9-51ea-4c1f-afec-c6af4bbbcdf9', 'name': 'ctest-vnet1-78450148', 'tenant_id': '34d59a3a8d04421eb65f82e204288393', 'project_id': '34d59a3a8d04421eb65f82e204288393', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['51a2e75c-c1d4-4a37-8330-ecd4b4a77a45', '069c5fff-c592-4025-a05f-881ad6e69bd0', '523a2513-a25d-4b88-a196-25871847138c'], 'fq_name': ['default-domain', 'ctest-TestBasicPolicyIpv4v6-06509302', 'ctest-vnet1-78450148'], 'policys': [['default-domain', 'ctest-TestBasicPolicyIpv4v6-06509302', 'ctest-policy2-54629202'], ['default-domain', 'ctest-TestBasicPolicyIpv4v6-06509302', 'ctest-policy3-30142472']], 'subnet_ipam': [{'subnet_cidr': '12.1.1.0/24', 'ipam_fq_name': ['default-domain', 'ctest-TestBasicPolicyIpv4v6-06509302', 'ctest-TestBasicPolicyIpv4v6-06509302-default-ipam']}, {'subnet_cidr': '13.1.1.0/24', 'ipam_fq_name': ['default-domain', 'ctest-TestBasicPolicyIpv4v6-06509302', 'ctest-TestBasicPolicyIpv4v6-06509302-default-ipam']}, {'subnet_cidr': '3ff4:adc:c8d7:a906:3cf1:9177::/96', 'ipam_fq_name': ['default-domain', 'ctest-TestBasicPolicyIpv4v6-06509302', 'ctest-TestBasicPolicyIpv4v6-06509302-default-ipam']}], 'port_security_enabled': True, 'description': ''}} 2025-08-02 23:34:12,523 - DEBUG - Associated Policy:[['default-domain', 'ctest-TestBasicPolicyIpv4v6-06509302', 'ctest-policy2-54629202'], ['default-domain', 'ctest-TestBasicPolicyIpv4v6-06509302', 'ctest-policy3-30142472']] to ctest-vnet1-78450148 2025-08-02 23:34:12,523 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-08-02 23:34:12,531 - DEBUG - Requesting: http://10.0.0.38:8082/domain/e48a4202-dd3d-4b87-9406-48f7b2154028 2025-08-02 23:34:12,545 - DEBUG - Requesting: http://10.0.0.38:8082/project/34d59a3a-8d04-421e-b65f-82e204288393 2025-08-02 23:34:12,658 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/f0d279d7-fbc3-4c5a-a552-b07b63cc8e90 2025-08-02 23:34:12,672 - DEBUG - Setup step: Associating the policy to VN' 2025-08-02 23:34:12,825 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': 'f0d279d7-fbc3-4c5a-a552-b07b63cc8e90', 'name': 'ctest-vnet2-05275703', 'tenant_id': '34d59a3a8d04421eb65f82e204288393', 'project_id': '34d59a3a8d04421eb65f82e204288393', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['db87633f-f540-4c04-8c13-254d12c6e51f', '6d3d06ed-22dc-4988-acc3-b59306a58391', '906dcbc8-7f41-4c25-b52d-0b50d4179152'], 'fq_name': ['default-domain', 'ctest-TestBasicPolicyIpv4v6-06509302', 'ctest-vnet2-05275703'], 'policys': [['default-domain', 'ctest-TestBasicPolicyIpv4v6-06509302', 'ctest-policy4-56260264'], ['default-domain', 'ctest-TestBasicPolicyIpv4v6-06509302', 'ctest-policy5-09464733']], 'subnet_ipam': [{'subnet_cidr': '14.1.1.0/24', 'ipam_fq_name': ['default-domain', 'ctest-TestBasicPolicyIpv4v6-06509302', 'ctest-TestBasicPolicyIpv4v6-06509302-default-ipam']}, {'subnet_cidr': '15.1.1.0/24', 'ipam_fq_name': ['default-domain', 'ctest-TestBasicPolicyIpv4v6-06509302', 'ctest-TestBasicPolicyIpv4v6-06509302-default-ipam']}, {'subnet_cidr': '3e31:b3fb:f72e:677a:a747:168f::/96', 'ipam_fq_name': ['default-domain', 'ctest-TestBasicPolicyIpv4v6-06509302', 'ctest-TestBasicPolicyIpv4v6-06509302-default-ipam']}], 'port_security_enabled': True, 'description': ''}} 2025-08-02 23:34:13,001 - DEBUG - Associated Policy:[['default-domain', 'ctest-TestBasicPolicyIpv4v6-06509302', 'ctest-policy4-56260264'], ['default-domain', 'ctest-TestBasicPolicyIpv4v6-06509302', 'ctest-policy5-09464733']] to ctest-vnet2-05275703 2025-08-02 23:34:13,001 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-08-02 23:34:13,010 - DEBUG - Requesting: http://10.0.0.38:8082/domain/e48a4202-dd3d-4b87-9406-48f7b2154028 2025-08-02 23:34:13,033 - DEBUG - Requesting: http://10.0.0.38:8082/project/34d59a3a-8d04-421e-b65f-82e204288393 2025-08-02 23:34:13,166 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/0265521e-513e-4b57-a847-2fcf27176bae 2025-08-02 23:34:13,181 - DEBUG - Setup step: Associating the policy to VN' 2025-08-02 23:34:13,366 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': '0265521e-513e-4b57-a847-2fcf27176bae', 'name': 'ctest-vnet3-74042446', 'tenant_id': '34d59a3a8d04421eb65f82e204288393', 'project_id': '34d59a3a8d04421eb65f82e204288393', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['2c5a2b7b-ecff-49ba-a071-4537ae737e13', '67b858cb-d9a9-430b-a7b1-550fce8e3398', '71df46f7-8de7-4be1-a520-39184a5d36a1'], 'fq_name': ['default-domain', 'ctest-TestBasicPolicyIpv4v6-06509302', 'ctest-vnet3-74042446'], 'policys': [['default-domain', 'ctest-TestBasicPolicyIpv4v6-06509302', 'ctest-policy6-13176554'], ['default-domain', 'ctest-TestBasicPolicyIpv4v6-06509302', 'ctest-policy7-84293853']], 'subnet_ipam': [{'subnet_cidr': '16.1.1.0/24', 'ipam_fq_name': ['default-domain', 'ctest-TestBasicPolicyIpv4v6-06509302', 'ctest-TestBasicPolicyIpv4v6-06509302-default-ipam']}, {'subnet_cidr': '17.1.1.0/24', 'ipam_fq_name': ['default-domain', 'ctest-TestBasicPolicyIpv4v6-06509302', 'ctest-TestBasicPolicyIpv4v6-06509302-default-ipam']}, {'subnet_cidr': '3e68:20cd:a299:e16d:ad3c:b651::/96', 'ipam_fq_name': ['default-domain', 'ctest-TestBasicPolicyIpv4v6-06509302', 'ctest-TestBasicPolicyIpv4v6-06509302-default-ipam']}], 'port_security_enabled': True, 'description': ''}} 2025-08-02 23:34:13,585 - DEBUG - Associated Policy:[['default-domain', 'ctest-TestBasicPolicyIpv4v6-06509302', 'ctest-policy6-13176554'], ['default-domain', 'ctest-TestBasicPolicyIpv4v6-06509302', 'ctest-policy7-84293853']] to ctest-vnet3-74042446 2025-08-02 23:34:13,585 - DEBUG - Hosts: {'nova': ['an-jenkins-deploy-platform-ansible-os-3743-2', 'an-jenkins-deploy-platform-ansible-os-3743-1']} 2025-08-02 23:34:13,697 - DEBUG - Services list from nova: [, , , ] 2025-08-02 23:34:13,727 - DEBUG - Image by name ubuntu-traffic-py3 not found 2025-08-02 23:34:13,727 - DEBUG - Installing image ubuntu-traffic-py3 2025-08-02 23:34:13,727 - DEBUG - Image info {'name': 'ubuntu-traffic-py3.qcow2.gz', 'webserver': '', 'location': '/images/converts/', 'username': 'ubuntu', 'password': 'ubuntu', 'type': 'os', 'flavor': 'contrail_flavor_small', 'params': '--container-format ovf --disk-format qcow2 --property hypervisor_type=qemu', 'name_docker': 'phusion-baseimage-enablesshd'} 2025-08-02 23:34:13,727 - DEBUG - Image build path http://nexus.opensdn.io/repository///images/converts//ubuntu-traffic-py3.qcow2.gz 2025-08-02 23:34:13,727 - DEBUG - Download image from web http://nexus.opensdn.io/repository///images/converts//ubuntu-traffic-py3.qcow2.gz 2025-08-02 23:34:13,745 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: wget -nv http://nexus.opensdn.io/repository///images/converts//ubuntu-traffic-py3.qcow2.gz -O /contrail-test/images/ubuntu-traffic-py3.qcow2.gz 2025-08-02 23:34:13,791 - DEBUG - Image has been downloaded to /contrail-test/images/ubuntu-traffic-py3.qcow2.gz 2025-08-02 23:34:13,792 - DEBUG - Unzip image 2025-08-02 23:34:13,792 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/ubuntu-traffic-py3.qcow2.gz 2025-08-02 23:34:13,813 - INFO - image /contrail-test/images/ubuntu-traffic-py3.qcow2 is not found 2025-08-02 23:34:13,813 - DEBUG - Detaching the Policy for VN :ctest-vnet3-74042446 2025-08-02 23:34:13,813 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-08-02 23:34:13,825 - DEBUG - Requesting: http://10.0.0.38:8082/domain/e48a4202-dd3d-4b87-9406-48f7b2154028 2025-08-02 23:34:13,841 - DEBUG - Requesting: http://10.0.0.38:8082/project/34d59a3a-8d04-421e-b65f-82e204288393 2025-08-02 23:34:13,967 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/0265521e-513e-4b57-a847-2fcf27176bae 2025-08-02 23:34:14,286 - DEBUG - Detached Policy:[['default-domain', 'ctest-TestBasicPolicyIpv4v6-06509302', 'ctest-policy6-13176554'], ['default-domain', 'ctest-TestBasicPolicyIpv4v6-06509302', 'ctest-policy7-84293853']] from ctest-vnet3-74042446 2025-08-02 23:34:14,286 - DEBUG - Detaching the Policy for VN :ctest-vnet2-05275703 2025-08-02 23:34:14,286 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-08-02 23:34:14,296 - DEBUG - Requesting: http://10.0.0.38:8082/domain/e48a4202-dd3d-4b87-9406-48f7b2154028 2025-08-02 23:34:14,311 - DEBUG - Requesting: http://10.0.0.38:8082/project/34d59a3a-8d04-421e-b65f-82e204288393 2025-08-02 23:34:14,455 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/f0d279d7-fbc3-4c5a-a552-b07b63cc8e90 2025-08-02 23:34:14,732 - DEBUG - Detached Policy:[['default-domain', 'ctest-TestBasicPolicyIpv4v6-06509302', 'ctest-policy4-56260264'], ['default-domain', 'ctest-TestBasicPolicyIpv4v6-06509302', 'ctest-policy5-09464733']] from ctest-vnet2-05275703 2025-08-02 23:34:14,732 - DEBUG - Detaching the Policy for VN :ctest-vnet1-78450148 2025-08-02 23:34:14,732 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-08-02 23:34:14,740 - DEBUG - Requesting: http://10.0.0.38:8082/domain/e48a4202-dd3d-4b87-9406-48f7b2154028 2025-08-02 23:34:14,755 - DEBUG - Requesting: http://10.0.0.38:8082/project/34d59a3a-8d04-421e-b65f-82e204288393 2025-08-02 23:34:14,893 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/16d102c9-51ea-4c1f-afec-c6af4bbbcdf9 2025-08-02 23:34:15,168 - DEBUG - Detached Policy:[['default-domain', 'ctest-TestBasicPolicyIpv4v6-06509302', 'ctest-policy2-54629202'], ['default-domain', 'ctest-TestBasicPolicyIpv4v6-06509302', 'ctest-policy3-30142472']] from ctest-vnet1-78450148 2025-08-02 23:34:15,168 - DEBUG - Detaching the Policy for VN :ctest-vnet0-44636210 2025-08-02 23:34:15,168 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-08-02 23:34:15,184 - DEBUG - Requesting: http://10.0.0.38:8082/domain/e48a4202-dd3d-4b87-9406-48f7b2154028 2025-08-02 23:34:15,206 - DEBUG - Requesting: http://10.0.0.38:8082/project/34d59a3a-8d04-421e-b65f-82e204288393 2025-08-02 23:34:15,327 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/32649cb6-be55-4283-aa28-9848ff9bbc1a 2025-08-02 23:34:15,734 - DEBUG - Detached Policy:[['default-domain', 'ctest-TestBasicPolicyIpv4v6-06509302', 'ctest-policy0-94101144'], ['default-domain', 'ctest-TestBasicPolicyIpv4v6-06509302', 'ctest-policy1-57279714']] from ctest-vnet0-44636210 2025-08-02 23:34:15,791 - INFO - Deleted policy ctest-policy7-84293853 2025-08-02 23:34:15,947 - DEBUG - policy ctest-policy7-84293853 is not found in API Server 2025-08-02 23:34:16,015 - INFO - Deleted policy ctest-policy6-13176554 2025-08-02 23:34:16,241 - DEBUG - policy ctest-policy6-13176554 is not found in API Server 2025-08-02 23:34:16,305 - INFO - Deleted policy ctest-policy5-09464733 2025-08-02 23:34:16,557 - DEBUG - policy ctest-policy5-09464733 is not found in API Server 2025-08-02 23:34:16,638 - INFO - Deleted policy ctest-policy4-56260264 2025-08-02 23:34:16,890 - DEBUG - policy ctest-policy4-56260264 is not found in API Server 2025-08-02 23:34:16,987 - INFO - Deleted policy ctest-policy3-30142472 2025-08-02 23:34:17,213 - DEBUG - policy ctest-policy3-30142472 is not found in API Server 2025-08-02 23:34:17,312 - INFO - Deleted policy ctest-policy2-54629202 2025-08-02 23:34:17,577 - DEBUG - policy ctest-policy2-54629202 is not found in API Server 2025-08-02 23:34:17,668 - INFO - Deleted policy ctest-policy1-57279714 2025-08-02 23:34:17,897 - DEBUG - policy ctest-policy1-57279714 is not found in API Server 2025-08-02 23:34:18,001 - INFO - Deleted policy ctest-policy0-94101144 2025-08-02 23:34:18,277 - DEBUG - policy ctest-policy0-94101144 is not found in API Server 2025-08-02 23:34:18,278 - INFO - Deleting VN ctest-vnet3-74042446 2025-08-02 23:34:18,571 - DEBUG - Response for deleting network () 2025-08-02 23:34:18,571 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/e69514ce-6178-45ca-a3e6-6ff5c39dacf2 2025-08-02 23:34:18,579 - DEBUG - Response Code: 404 2025-08-02 23:34:18,579 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-08-02 23:34:18,588 - DEBUG - Requesting: http://10.0.0.38:8082/domain/e48a4202-dd3d-4b87-9406-48f7b2154028 2025-08-02 23:34:18,645 - DEBUG - Requesting: http://10.0.0.38:8082/project/34d59a3a-8d04-421e-b65f-82e204288393 2025-08-02 23:34:18,769 - INFO - Validated that VN ctest-vnet3-74042446 is not found in API Server 2025-08-02 23:34:18,786 - DEBUG - VN ctest-vnet3-74042446 is not present in Agent 10.0.0.48 2025-08-02 23:34:18,800 - DEBUG - VN ctest-vnet3-74042446 is not present in Agent 10.0.0.49 2025-08-02 23:34:18,800 - INFO - Validated that VN ctest-vnet3-74042446 is not in any agent 2025-08-02 23:34:18,856 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vnet3-74042446 info 2025-08-02 23:34:18,856 - INFO - Deleting VN ctest-vnet2-05275703 2025-08-02 23:34:19,171 - DEBUG - Response for deleting network () 2025-08-02 23:34:19,171 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/da11b25c-16ee-4f55-82c9-1b158bd5a340 2025-08-02 23:34:19,179 - DEBUG - Response Code: 404 2025-08-02 23:34:19,179 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-08-02 23:34:19,188 - DEBUG - Requesting: http://10.0.0.38:8082/domain/e48a4202-dd3d-4b87-9406-48f7b2154028 2025-08-02 23:34:19,205 - DEBUG - Requesting: http://10.0.0.38:8082/project/34d59a3a-8d04-421e-b65f-82e204288393 2025-08-02 23:34:19,322 - INFO - Validated that VN ctest-vnet2-05275703 is not found in API Server 2025-08-02 23:34:19,340 - DEBUG - VN ctest-vnet2-05275703 is not present in Agent 10.0.0.48 2025-08-02 23:34:19,354 - DEBUG - VN ctest-vnet2-05275703 is not present in Agent 10.0.0.49 2025-08-02 23:34:19,355 - INFO - Validated that VN ctest-vnet2-05275703 is not in any agent 2025-08-02 23:34:19,423 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vnet2-05275703 info 2025-08-02 23:34:19,423 - INFO - Deleting VN ctest-vnet1-78450148 2025-08-02 23:34:19,726 - DEBUG - Response for deleting network () 2025-08-02 23:34:19,726 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/119bd77b-8873-4262-95da-08fbe0775123 2025-08-02 23:34:19,735 - DEBUG - Response Code: 404 2025-08-02 23:34:19,735 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-08-02 23:34:19,747 - DEBUG - Requesting: http://10.0.0.38:8082/domain/e48a4202-dd3d-4b87-9406-48f7b2154028 2025-08-02 23:34:19,764 - DEBUG - Requesting: http://10.0.0.38:8082/project/34d59a3a-8d04-421e-b65f-82e204288393 2025-08-02 23:34:19,878 - INFO - Validated that VN ctest-vnet1-78450148 is not found in API Server 2025-08-02 23:34:19,893 - DEBUG - VN ctest-vnet1-78450148 is not present in Agent 10.0.0.48 2025-08-02 23:34:19,906 - DEBUG - VN ctest-vnet1-78450148 is not present in Agent 10.0.0.49 2025-08-02 23:34:19,906 - INFO - Validated that VN ctest-vnet1-78450148 is not in any agent 2025-08-02 23:34:19,958 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vnet1-78450148 info 2025-08-02 23:34:19,958 - INFO - Deleting VN ctest-vnet0-44636210 2025-08-02 23:34:20,212 - DEBUG - Response for deleting network () 2025-08-02 23:34:20,213 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/6e30b63c-f517-4f1e-92c3-f10208272b83 2025-08-02 23:34:20,220 - DEBUG - Response Code: 404 2025-08-02 23:34:20,220 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-08-02 23:34:20,229 - DEBUG - Requesting: http://10.0.0.38:8082/domain/e48a4202-dd3d-4b87-9406-48f7b2154028 2025-08-02 23:34:20,286 - DEBUG - Requesting: http://10.0.0.38:8082/project/34d59a3a-8d04-421e-b65f-82e204288393 2025-08-02 23:34:20,422 - INFO - Validated that VN ctest-vnet0-44636210 is not found in API Server 2025-08-02 23:34:20,436 - DEBUG - VN ctest-vnet0-44636210 is not present in Agent 10.0.0.48 2025-08-02 23:34:20,450 - DEBUG - VN ctest-vnet0-44636210 is not present in Agent 10.0.0.49 2025-08-02 23:34:20,450 - INFO - Validated that VN ctest-vnet0-44636210 is not in any agent 2025-08-02 23:34:20,504 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vnet0-44636210 info 2025-08-02 23:34:20,657 - INFO - IPAM: ctest-TestBasicPolicyIpv4v6-06509302-default-ipam is not found in API Server 2025-08-02 23:34:20,691 - INFO - IPAM:ctest-TestBasicPolicyIpv4v6-06509302-default-ipam is not found in control node 2025-08-02 23:34:21,397 - DEBUG - Skipping the deletion of Project ['default-domain', 'ctest-TestBasicPolicyIpv4v6-06509302'] 2025-08-02 23:34:21,398 - DEBUG - Skipping the deletion of User ctest-TestBasicPolicyIpv4v6-06509302 2025-08-02 23:34:22,764 - DEBUG - No XMPP flaps were noticed during the test 2025-08-02 23:34:22,764 - INFO -

2025-08-02 23:34:22,764 - INFO - END TEST : test_policy : SKIPPED[0:00:28]

2025-08-02 23:34:22,764 - INFO - -------------------------------------------------------------------------------- 2025-08-02 23:34:22,765 - INFO - image /contrail-test/images/ubuntu-traffic-py3.qcow2 is not found 2025-08-02 23:34:24,162 - DEBUG - No XMPP flaps were noticed during the test 2025-08-02 23:34:24,162 - INFO -

2025-08-02 23:34:24,162 - INFO - END TEST : test_policy : SKIPPED[0:00:31]

2025-08-02 23:34:24,162 - INFO - -------------------------------------------------------------------------------- 2025-08-02 23:34:24,166 - INFO - ================================================================================ 2025-08-02 23:34:24,166 - INFO - STARTING TEST : test_policy_to_deny 2025-08-02 23:34:25,536 - DEBUG - Nothing to compare xmpp stats {'10.0.0.48': {'10.20.0.17': '0', '10.20.0.14': '0'}, '10.0.0.49': {'10.20.0.17': '0', '10.20.0.14': '0'}} with 2025-08-02 23:34:25,536 - INFO - Initial checks done. Running the testcase now 2025-08-02 23:34:25,537 - INFO - 2025-08-02 23:34:25,537 - INFO - ================================================================================ 2025-08-02 23:34:25,537 - INFO - STARTING TEST : test_policy_to_deny 2025-08-02 23:34:25,537 - INFO - TEST DESCRIPTION : Test to validate that with policy having rule to disable icmp within the VN, ping between VMs should fail 1. Pick 2 VN from resource pool which have one VM in each 2. Create policy with icmp deny rule 3. Associate policy to both VN 4. Ping from one VM to another. Ping should fail Pass criteria: Step 2,3 and 4 should pass 2025-08-02 23:34:26,867 - DEBUG - Nothing to compare xmpp stats {'10.0.0.48': {'10.20.0.17': '0', '10.20.0.14': '0'}, '10.0.0.49': {'10.20.0.17': '0', '10.20.0.14': '0'}} with 2025-08-02 23:34:26,867 - INFO - Initial checks done. Running the testcase now 2025-08-02 23:34:26,868 - INFO - 2025-08-02 23:34:26,881 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = icmp, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn1-62198248, 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-TestBasicPolicyIpv4v6-06509302:ctest-vn1-62198248, 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-TestBasicPolicyIpv4v6-06509302:ctest-vn1-62198248, 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-TestBasicPolicyIpv4v6-06509302:ctest-vn1-62198248, 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] 2025-08-02 23:34:28,001 - DEBUG - Response for create_network : {'network': {'id': '6e2cc96f-c4d9-496d-a63e-2a122b4fc7b0', 'name': 'ctest-vn1-62198248', 'tenant_id': '34d59a3a8d04421eb65f82e204288393', 'project_id': '34d59a3a8d04421eb65f82e204288393', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestBasicPolicyIpv4v6-06509302', 'ctest-vn1-62198248'], 'port_security_enabled': True, 'description': ''}} 2025-08-02 23:34:28,237 - DEBUG - Response for create_subnet : {'subnet': {'id': '1150ee6e-0af7-4752-b527-ff51d504f4e3', 'name': '', 'tenant_id': '34d59a3a8d04421eb65f82e204288393', 'network_id': '6e2cc96f-c4d9-496d-a63e-2a122b4fc7b0', 'ip_version': 4, 'cidr': '192.168.10.0/24', 'allocation_pools': [{'start': '192.168.10.2', 'end': '192.168.10.254'}], 'gateway_ip': '192.168.10.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '192.168.10.2', 'tags': [], 'project_id': '34d59a3a8d04421eb65f82e204288393'}} 2025-08-02 23:34:28,552 - DEBUG - Response for create_subnet : {'subnet': {'id': 'f9742043-7fd5-41c5-bc41-fcc8a6b336bb', 'name': '', 'tenant_id': '34d59a3a8d04421eb65f82e204288393', 'network_id': '6e2cc96f-c4d9-496d-a63e-2a122b4fc7b0', 'ip_version': 6, 'cidr': '3b3b:11ea:9da6:b563:8bc1:66eb::/96', 'allocation_pools': [{'start': '3b3b:11ea:9da6:b563:8bc1:66eb:0:2', 'end': '3b3b:11ea:9da6:b563:8bc1:66eb:ffff:fffe'}], 'gateway_ip': '3b3b:11ea:9da6:b563:8bc1:66eb:0:1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '3b3b:11ea:9da6:b563:8bc1:66eb:0:2', 'tags': [], 'project_id': '34d59a3a8d04421eb65f82e204288393'}} 2025-08-02 23:34:28,589 - INFO - Created VN ctest-vn1-62198248 2025-08-02 23:34:28,616 - DEBUG - VN ctest-vn1-62198248 UUID is 6e2cc96f-c4d9-496d-a63e-2a122b4fc7b0 2025-08-02 23:34:28,983 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': '6e2cc96f-c4d9-496d-a63e-2a122b4fc7b0', 'name': 'ctest-vn1-62198248', 'tenant_id': '34d59a3a8d04421eb65f82e204288393', 'project_id': '34d59a3a8d04421eb65f82e204288393', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['1150ee6e-0af7-4752-b527-ff51d504f4e3', 'f9742043-7fd5-41c5-bc41-fcc8a6b336bb'], 'fq_name': ['default-domain', 'ctest-TestBasicPolicyIpv4v6-06509302', 'ctest-vn1-62198248'], 'policys': [['default-domain', 'ctest-TestBasicPolicyIpv4v6-06509302', 'ctest-policy1-41624907']], 'subnet_ipam': [{'subnet_cidr': '192.168.10.0/24', 'ipam_fq_name': ['default-domain', 'default-project', 'default-network-ipam']}, {'subnet_cidr': '3b3b:11ea:9da6:b563:8bc1:66eb::/96', 'ipam_fq_name': ['default-domain', 'default-project', 'default-network-ipam']}], 'port_security_enabled': True, 'description': ''}} 2025-08-02 23:34:29,091 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-08-02 23:34:29,100 - DEBUG - Requesting: http://10.0.0.38:8082/domain/e48a4202-dd3d-4b87-9406-48f7b2154028 2025-08-02 23:34:29,118 - DEBUG - Requesting: http://10.0.0.38:8082/project/34d59a3a-8d04-421e-b65f-82e204288393 2025-08-02 23:34:29,241 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/6e2cc96f-c4d9-496d-a63e-2a122b4fc7b0 2025-08-02 23:34:29,261 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/6e2cc96f-c4d9-496d-a63e-2a122b4fc7b0 2025-08-02 23:34:29,282 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/1390dbc5-f9eb-4369-833e-58d507cd81cb 2025-08-02 23:34:29,296 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/1390dbc5-f9eb-4369-833e-58d507cd81cb 2025-08-02 23:34:29,311 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/b2e5b2aa-a25c-418f-a70c-57bdfc4fc036 2025-08-02 23:34:29,322 - DEBUG - Route Targets: ['target:64512:8000005'] 2025-08-02 23:34:29,322 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/6e2cc96f-c4d9-496d-a63e-2a122b4fc7b0 2025-08-02 23:34:29,337 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/1390dbc5-f9eb-4369-833e-58d507cd81cb 2025-08-02 23:34:29,369 - INFO - Verified VN network id 12 for VN 6e2cc96f-c4d9-496d-a63e-2a122b4fc7b0 2025-08-02 23:34:29,369 - INFO - Verifications in API Server for VN ctest-vn1-62198248 passed 2025-08-02 23:34:29,369 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/6e2cc96f-c4d9-496d-a63e-2a122b4fc7b0 2025-08-02 23:34:29,385 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/1390dbc5-f9eb-4369-833e-58d507cd81cb 2025-08-02 23:34:29,399 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/1390dbc5-f9eb-4369-833e-58d507cd81cb 2025-08-02 23:34:29,412 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/b2e5b2aa-a25c-418f-a70c-57bdfc4fc036 2025-08-02 23:34:29,434 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn1-62198248', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestBasicPolicyIpv4v6-06509302', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7938941725028469101', 'uuid-lslong': '11979058316376524720'}, 'enable': 'true', 'created': '2025-08-02T23:34:27', 'last-modified': '2025-08-02T23:34:28', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.516694'} 2025-08-02 23:34:29,443 - DEBUG - Route Targets: ['target:64512:8000005'] 2025-08-02 23:34:29,458 - DEBUG - Control-node 10.0.0.254 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn1-62198248', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestBasicPolicyIpv4v6-06509302', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7938941725028469101', 'uuid-lslong': '11979058316376524720'}, 'enable': 'true', 'created': '2025-08-02T23:34:27', 'last-modified': '2025-08-02T23:34:28', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.535377'} 2025-08-02 23:34:29,474 - DEBUG - Route Targets: ['target:64512:8000005'] 2025-08-02 23:34:29,489 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn1-62198248', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestBasicPolicyIpv4v6-06509302', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7938941725028469101', 'uuid-lslong': '11979058316376524720'}, 'enable': 'true', 'created': '2025-08-02T23:34:27', 'last-modified': '2025-08-02T23:34:28', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.578999'} 2025-08-02 23:34:29,503 - DEBUG - Route Targets: ['target:64512:8000005'] 2025-08-02 23:34:29,503 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn1-62198248 passed 2025-08-02 23:34:29,503 - DEBUG - ====Verifying policy data for ctest-vn1-62198248 in API_Server ====== 2025-08-02 23:34:29,503 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-08-02 23:34:29,516 - DEBUG - Requesting: http://10.0.0.38:8082/domain/e48a4202-dd3d-4b87-9406-48f7b2154028 2025-08-02 23:34:29,544 - DEBUG - Requesting: http://10.0.0.38:8082/project/34d59a3a-8d04-421e-b65f-82e204288393 2025-08-02 23:34:29,678 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/6e2cc96f-c4d9-496d-a63e-2a122b4fc7b0 2025-08-02 23:34:29,696 - DEBUG - ==>Verifying data for policy with id: bc3217fa-4c7d-4392-99c1-0c55b45a97f5, fqn: ['default-domain', 'ctest-TestBasicPolicyIpv4v6-06509302', 'ctest-policy1-41624907'] 2025-08-02 23:34:29,696 - INFO - VN ctest-vn1-62198248 Policy verification: verify_vn_policy_in_api_server, status: True 2025-08-02 23:34:29,696 - DEBUG - Verifying the vn in opserver 2025-08-02 23:34:29,696 - DEBUG - Verifying the default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn1-62198248 virtual network link through opserver 10.0.0.38 2025-08-02 23:34:29,696 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks 2025-08-02 23:34:29,713 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn1-62198248', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn1-62198248?flat'} 2025-08-02 23:34:29,713 - DEBUG - Verifying the default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn1-62198248 virtual network link through opserver 10.0.0.254 2025-08-02 23:34:29,713 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-networks 2025-08-02 23:34:29,742 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn1-62198248', 'href': 'http://10.0.0.254:8081/analytics/uves/virtual-network/default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn1-62198248?flat'} 2025-08-02 23:34:29,742 - DEBUG - Verifying the default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn1-62198248 virtual network link through opserver 10.0.0.50 2025-08-02 23:34:29,742 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks 2025-08-02 23:34:29,768 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn1-62198248', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn1-62198248?flat'} 2025-08-02 23:34:29,768 - INFO - Validated that VN default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn1-62198248 is found in opserver 2025-08-02 23:34:29,797 - DEBUG - Do not have enough data to verify VN in agent 2025-08-02 23:34:29,813 - DEBUG - VRF ids for VN ctest-vn1-62198248: {} 2025-08-02 23:34:31,104 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-3743-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-3743-2) 2025-08-02 23:34:32,562 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-3743-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-3743-1) 2025-08-02 23:34:32,562 - INFO - Waiting for VM ctest-vn1_vm1-59350198 to be up.. 2025-08-02 23:34:32,685 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2025-08-02 23:34:37,823 - DEBUG - VM is in ACTIVE state now 2025-08-02 23:34:37,823 - INFO - VM name : ctest-vn1_vm1-59350198 2025-08-02 23:34:37,927 - DEBUG - VM ctest-vn1_vm1-59350198 ID is 92ec5083-528d-4381-a248-c6e85d0cc647 2025-08-02 23:34:37,928 - DEBUG - VM ctest-vn1_vm1-59350198 launched on Node an-jenkins-deploy-platform-ansible-os-3743-2 2025-08-02 23:34:38,040 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-machine/92ec5083-528d-4381-a248-c6e85d0cc647 2025-08-02 23:34:38,062 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-machine-interface/ba403980-584b-4dc8-a285-b3a9b16cca80 2025-08-02 23:34:41,323 - 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 1007ms') 2025-08-02 23:34:41,324 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1_vm1-59350198 failed! 2025-08-02 23:34:41,355 - DEBUG - Gateway for vn default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn1-62198248 is 192.168.10.1 and allocation pool is NOT set 2025-08-02 23:34:41,355 - DEBUG - Gateway for vn default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn1-62198248 is 3b3b:11ea:9da6:b563:8bc1:66eb:0:1 and allocation pool is NOT set 2025-08-02 23:34:45,458 - 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 1027ms') 2025-08-02 23:34:45,458 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1_vm1-59350198 failed! 2025-08-02 23:34:45,480 - DEBUG - Gateway for vn default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn1-62198248 is 192.168.10.1 and allocation pool is NOT set 2025-08-02 23:34:45,480 - DEBUG - Gateway for vn default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn1-62198248 is 3b3b:11ea:9da6:b563:8bc1:66eb:0:1 and allocation pool is NOT set 2025-08-02 23:34:49,546 - 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 1003ms') 2025-08-02 23:34:49,546 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1_vm1-59350198 failed! 2025-08-02 23:34:49,564 - DEBUG - Gateway for vn default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn1-62198248 is 192.168.10.1 and allocation pool is NOT set 2025-08-02 23:34:49,564 - DEBUG - Gateway for vn default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn1-62198248 is 3b3b:11ea:9da6:b563:8bc1:66eb:0:1 and allocation pool is NOT set 2025-08-02 23:34:53,643 - 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 1011ms') 2025-08-02 23:34:53,643 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1_vm1-59350198 failed! 2025-08-02 23:34:53,683 - DEBUG - Gateway for vn default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn1-62198248 is 192.168.10.1 and allocation pool is NOT set 2025-08-02 23:34:53,683 - DEBUG - Gateway for vn default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn1-62198248 is 3b3b:11ea:9da6:b563:8bc1:66eb:0:1 and allocation pool is NOT set 2025-08-02 23:34:57,770 - 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 1021ms') 2025-08-02 23:34:57,770 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1_vm1-59350198 failed! 2025-08-02 23:34:57,806 - DEBUG - Gateway for vn default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn1-62198248 is 192.168.10.1 and allocation pool is NOT set 2025-08-02 23:34:57,807 - DEBUG - Gateway for vn default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn1-62198248 is 3b3b:11ea:9da6:b563:8bc1:66eb:0:1 and allocation pool is NOT set 2025-08-02 23:35:01,891 - 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 1027ms') 2025-08-02 23:35:01,891 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1_vm1-59350198 failed! 2025-08-02 23:35:01,927 - DEBUG - Gateway for vn default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn1-62198248 is 192.168.10.1 and allocation pool is NOT set 2025-08-02 23:35:01,927 - DEBUG - Gateway for vn default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn1-62198248 is 3b3b:11ea:9da6:b563:8bc1:66eb:0:1 and allocation pool is NOT set 2025-08-02 23:35:06,028 - 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 1029ms') 2025-08-02 23:35:06,028 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1_vm1-59350198 failed! 2025-08-02 23:35:06,063 - DEBUG - Gateway for vn default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn1-62198248 is 192.168.10.1 and allocation pool is NOT set 2025-08-02 23:35:06,063 - DEBUG - Gateway for vn default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn1-62198248 is 3b3b:11ea:9da6:b563:8bc1:66eb:0:1 and allocation pool is NOT set 2025-08-02 23:35:10,151 - 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 1027ms') 2025-08-02 23:35:10,151 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1_vm1-59350198 failed! 2025-08-02 23:35:10,174 - DEBUG - Gateway for vn default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn1-62198248 is 192.168.10.1 and allocation pool is NOT set 2025-08-02 23:35:10,174 - DEBUG - Gateway for vn default-domain:ctest-TestBasicPolicyIpv4v6-06509302:ctest-vn1-62198248 is 3b3b:11ea:9da6:b563:8bc1:66eb:0:1 and allocation pool is NOT set 2025-08-02 23:35:12,243 - 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=4.97 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=2.40 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 = 2.398/3.685/4.973/1.287 ms') 2025-08-02 23:35:12,243 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1_vm1-59350198 passed 2025-08-02 23:35:12,399 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-08-02 23:35:12,399 - DEBUG - Waiting to SSH to VM ctest-vn1_vm1-59350198, IP 192.168.10.3, Port 22 2025-08-02 23:35:12,469 - 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': ''} 2025-08-02 23:35:12,577 - DEBUG - VM ctest-vn1_vm1-59350198 is NOT ready for SSH connections, VM status: ACTIVE 2025-08-02 23:35:17,578 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-08-02 23:35:17,579 - DEBUG - Waiting to SSH to VM ctest-vn1_vm1-59350198, IP 192.168.10.3, Port 22 2025-08-02 23:35:17,638 - 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': ''} 2025-08-02 23:35:17,745 - DEBUG - VM ctest-vn1_vm1-59350198 is NOT ready for SSH connections, VM status: ACTIVE 2025-08-02 23:35:22,747 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-08-02 23:35:22,747 - DEBUG - Waiting to SSH to VM ctest-vn1_vm1-59350198, IP 192.168.10.3, Port 22 2025-08-02 23:35:22,826 - 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': ''} 2025-08-02 23:35:22,978 - DEBUG - VM ctest-vn1_vm1-59350198 is NOT ready for SSH connections, VM status: ACTIVE 2025-08-02 23:35:27,979 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-08-02 23:35:27,979 - DEBUG - Waiting to SSH to VM ctest-vn1_vm1-59350198, IP 192.168.10.3, Port 22 2025-08-02 23:35:28,037 - 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': ''} 2025-08-02 23:35:28,152 - DEBUG - VM ctest-vn1_vm1-59350198 is NOT ready for SSH connections, VM status: ACTIVE 2025-08-02 23:35:33,153 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-08-02 23:35:33,153 - DEBUG - Waiting to SSH to VM ctest-vn1_vm1-59350198, IP 192.168.10.3, Port 22 2025-08-02 23:35:33,338 - DEBUG - VM ctest-vn1_vm1-59350198 is ready for SSH connections 2025-08-02 23:35:33,338 - INFO - Waiting for VM ctest-vn1_vm2-94087060 to be up.. 2025-08-02 23:35:33,469 - DEBUG - VM is in ACTIVE state now 2025-08-02 23:35:33,469 - INFO - VM name : ctest-vn1_vm2-94087060 2025-08-02 23:35:33,572 - DEBUG - VM ctest-vn1_vm2-94087060 ID is d4027a6c-4a60-44d5-a0ba-311194da6fad 2025-08-02 23:35:33,572 - DEBUG - VM ctest-vn1_vm2-94087060 launched on Node an-jenkins-deploy-platform-ansible-os-3743-1 2025-08-02 23:35:33,682 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-machine/d4027a6c-4a60-44d5-a0ba-311194da6fad 2025-08-02 23:35:33,702 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-machine-interface/04db5050-adf2-430b-9c06-f774ec24a296 2025-08-02 23:35:34,956 - 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=6.32 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=2.40 ms\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1002ms\r\nrtt min/avg/max/mdev = 2.401/4.362/6.324/1.961 ms') 2025-08-02 23:35:34,956 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1_vm2-94087060 passed 2025-08-02 23:35:35,112 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-08-02 23:35:35,112 - DEBUG - Waiting to SSH to VM ctest-vn1_vm2-94087060, IP 192.168.10.4, Port 22 2025-08-02 23:35:35,283 - DEBUG - VM ctest-vn1_vm2-94087060 is ready for SSH connections 2025-08-02 23:35:35,283 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 192.168.10.4, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.49, gateway password: c0ntrail123 2025-08-02 23:35:35,283 - DEBUG - ping -s 56 -c 3 -W 1 192.168.10.4 2025-08-02 23:35:59,466 - DEBUG - PING 192.168.10.4 (192.168.10.4) 56(84) bytes of data. --- 192.168.10.4 ping statistics --- 3 packets transmitted, 0 received, 100% packet loss, time 2003ms 2025-08-02 23:35:59,466 - WARNING - Ping to IP 192.168.10.4 from VM ctest-vn1_vm1-59350198 failed 2025-08-02 23:35:59,466 - DEBUG - Running remote_cmd, Cmd : ping6 -s 56 -c 3 -W 1 3b3b:11ea:9da6:b563:8bc1:66eb:0:4, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.49, gateway password: c0ntrail123 2025-08-02 23:35:59,466 - DEBUG - ping6 -s 56 -c 3 -W 1 3b3b:11ea:9da6:b563:8bc1:66eb:0:4 2025-08-02 23:36:03,078 - DEBUG - PING 3b3b:11ea:9da6:b563:8bc1:66eb:0:4(3b3b:11ea:9da6:b563:8bc1:66eb:0:4) 56 data bytes --- 3b3b:11ea:9da6:b563:8bc1:66eb:0:4 ping statistics --- 3 packets transmitted, 0 received, 100% packet loss, time 2004ms 2025-08-02 23:36:03,079 - WARNING - Ping to IP 3b3b:11ea:9da6:b563:8bc1:66eb:0:4 from VM ctest-vn1_vm1-59350198 failed 2025-08-02 23:36:03,079 - INFO - Deleting VM ctest-vn1_vm2-94087060 2025-08-02 23:36:03,145 - INFO - Deleting VM ctest-vn1_vm1-59350198 2025-08-02 23:36:03,439 - INFO - Deleting VN ctest-vn1-62198248 2025-08-02 23:36:03,514 - DEBUG - VN 6e2cc96f-c4d9-496d-a63e-2a122b4fc7b0 still in use: Unable to complete operation on network 6e2cc96f-c4d9-496d-a63e-2a122b4fc7b0. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-9fcaa33f-5e09-498b-a712-a8a481632d76'] 2025-08-02 23:36:03,514 - WARNING - Deleting VN ctest-vn1-62198248 failed..Will retry 2025-08-02 23:36:05,874 - DEBUG - Response for deleting network () 2025-08-02 23:36:05,874 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/1390dbc5-f9eb-4369-833e-58d507cd81cb 2025-08-02 23:36:05,882 - DEBUG - Response Code: 404 2025-08-02 23:36:05,882 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-08-02 23:36:05,889 - DEBUG - Requesting: http://10.0.0.38:8082/domain/e48a4202-dd3d-4b87-9406-48f7b2154028 2025-08-02 23:36:05,950 - DEBUG - Requesting: http://10.0.0.38:8082/project/34d59a3a-8d04-421e-b65f-82e204288393 2025-08-02 23:36:06,068 - INFO - Validated that VN ctest-vn1-62198248 is not found in API Server 2025-08-02 23:36:06,080 - DEBUG - VN ctest-vn1-62198248 is not present in Agent 10.0.0.48 2025-08-02 23:36:06,094 - DEBUG - VN ctest-vn1-62198248 is not present in Agent 10.0.0.49 2025-08-02 23:36:06,094 - INFO - Validated that VN ctest-vn1-62198248 is not in any agent 2025-08-02 23:36:06,151 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn1-62198248 info 2025-08-02 23:36:06,243 - INFO - Deleted policy ctest-policy1-41624907 2025-08-02 23:36:07,635 - DEBUG - No XMPP flaps were noticed during the test

2025-08-02 23:36:07,636 - INFO - END TEST : test_policy_to_deny : PASSED[0:01:42]

2025-08-02 23:36:07,636 - INFO - -------------------------------------------------------------------------------- 2025-08-02 23:36:09,051 - DEBUG - No XMPP flaps were noticed during the test

2025-08-02 23:36:09,051 - INFO - END TEST : test_policy_to_deny : PASSED[0:01:45]

2025-08-02 23:36:09,051 - INFO - -------------------------------------------------------------------------------- 2025-08-02 23:36:10,099 - INFO - Deleted project: ctest-TestBasicPolicyIpv4v6-06509302, ID : 34d59a3a-8d04-421e-b65f-82e204288393