2025-08-07 02:50:14,650 - INFO - Domain Default found not creating
2025-08-07 02:50:14,829 - INFO - Project ctest-TestPolicyAclIpv4v6-61472176 not found, creating it
2025-08-07 02:50:15,342 - INFO - Created Project:ctest-TestPolicyAclIpv4v6-61472176, ID : f38db1a7-18d4-40ec-9dd7-badb3e062bcd
2025-08-07 02:50:16,936 - INFO - ================================================================================
2025-08-07 02:50:16,936 - INFO - STARTING TEST : test_policy_cidr_src_vn_dst_cidr
2025-08-07 02:50:18,221 - DEBUG - Nothing to compare xmpp stats {'10.0.0.41': {'10.20.0.17': '0', '10.20.0.25': '0'}, '10.0.0.61': {'10.20.0.17': '0', '10.20.0.25': '0'}} with
2025-08-07 02:50:18,221 - INFO - Initial checks done. Running the testcase now
2025-08-07 02:50:18,221 - INFO -
2025-08-07 02:50:18,221 - INFO - ================================================================================
2025-08-07 02:50:18,221 - INFO - STARTING TEST : test_policy_cidr_src_vn_dst_cidr
2025-08-07 02:50:18,221 - INFO - TEST DESCRIPTION : Test cases to test policy CIDR
2025-08-07 02:50:19,517 - DEBUG - Nothing to compare xmpp stats {'10.0.0.41': {'10.20.0.17': '0', '10.20.0.25': '0'}, '10.0.0.61': {'10.20.0.17': '0', '10.20.0.25': '0'}} with
2025-08-07 02:50:19,518 - INFO - Initial checks done. Running the testcase now
2025-08-07 02:50:19,518 - INFO -
2025-08-07 02:50:20,882 - DEBUG - Requesting: http://10.0.0.56:8082/domains
2025-08-07 02:50:21,195 - DEBUG - Requesting: http://10.0.0.56:8082/domains
2025-08-07 02:50:21,230 - DEBUG - Requesting: http://10.0.0.56:8082/domain/fb2d80da-9971-40dc-80ca-c5bb54e98569
2025-08-07 02:50:21,250 - DEBUG - Requesting: http://10.0.0.56:8082/project/f38db1a7-18d4-40ec-9dd7-badb3e062bcd
2025-08-07 02:50:21,366 - DEBUG - Requesting: http://10.0.0.56:8082/network-ipam/0a9b397a-19b2-47ff-b0c0-06d0a6e4fd34
2025-08-07 02:50:21,374 - INFO - Verifications in API Server for IPAM: ipam1 passed
2025-08-07 02:50:21,382 - DEBUG - Control-node 10.0.0.56 : IPAM object is : {'node_name': 'network-ipam:default-domain:ctest-TestPolicyAclIpv4v6-61472176:ipam1', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestPolicyAclIpv4v6-61472176', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '764267758349338623', 'uuid-lslong': '12736187239426751796'}, 'enable': 'true', 'created': '2025-08-07T02:50:19', 'last-modified': '2025-08-07T02:50:20', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.214256'}
2025-08-07 02:50:21,390 - DEBUG - Control-node 10.0.0.130 : IPAM object is : {'node_name': 'network-ipam:default-domain:ctest-TestPolicyAclIpv4v6-61472176:ipam1', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestPolicyAclIpv4v6-61472176', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '764267758349338623', 'uuid-lslong': '12736187239426751796'}, 'enable': 'true', 'created': '2025-08-07T02:50:19', 'last-modified': '2025-08-07T02:50:20', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.222421'}
2025-08-07 02:50:21,399 - DEBUG - Control-node 10.0.0.249 : IPAM object is : {'node_name': 'network-ipam:default-domain:ctest-TestPolicyAclIpv4v6-61472176:ipam1', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestPolicyAclIpv4v6-61472176', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '764267758349338623', 'uuid-lslong': '12736187239426751796'}, 'enable': 'true', 'created': '2025-08-07T02:50:19', 'last-modified': '2025-08-07T02:50:20', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.229714'}
2025-08-07 02:50:21,399 - INFO - Verifications in Control node for IPAM: ipam1 passed
2025-08-07 02:50:21,399 - DEBUG - Requesting: http://10.0.0.56:8082/domains
2025-08-07 02:50:21,411 - DEBUG - Requesting: http://10.0.0.56:8082/domain/fb2d80da-9971-40dc-80ca-c5bb54e98569
2025-08-07 02:50:21,427 - DEBUG - Requesting: http://10.0.0.56:8082/project/f38db1a7-18d4-40ec-9dd7-badb3e062bcd
2025-08-07 02:50:21,560 - DEBUG - Requesting: http://10.0.0.56:8082/network-ipam/312d2767-6211-4773-b7ce-65d39e0380bc
2025-08-07 02:50:21,574 - INFO - Verifications in API Server for IPAM: ipam2 passed
2025-08-07 02:50:21,582 - DEBUG - Control-node 10.0.0.56 : IPAM object is : {'node_name': 'network-ipam:default-domain:ctest-TestPolicyAclIpv4v6-61472176:ipam2', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestPolicyAclIpv4v6-61472176', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3543531806790862707', 'uuid-lslong': '13244635513706741948'}, 'enable': 'true', 'created': '2025-08-07T02:50:20', 'last-modified': '2025-08-07T02:50:20', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.073596'}
2025-08-07 02:50:21,592 - DEBUG - Control-node 10.0.0.130 : IPAM object is : {'node_name': 'network-ipam:default-domain:ctest-TestPolicyAclIpv4v6-61472176:ipam2', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestPolicyAclIpv4v6-61472176', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3543531806790862707', 'uuid-lslong': '13244635513706741948'}, 'enable': 'true', 'created': '2025-08-07T02:50:20', 'last-modified': '2025-08-07T02:50:20', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.073129'}
2025-08-07 02:50:21,599 - DEBUG - Control-node 10.0.0.249 : IPAM object is : {'node_name': 'network-ipam:default-domain:ctest-TestPolicyAclIpv4v6-61472176:ipam2', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestPolicyAclIpv4v6-61472176', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3543531806790862707', 'uuid-lslong': '13244635513706741948'}, 'enable': 'true', 'created': '2025-08-07T02:50:20', 'last-modified': '2025-08-07T02:50:20', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.078946'}
2025-08-07 02:50:21,599 - INFO - Verifications in Control node for IPAM: ipam2 passed
2025-08-07 02:50:21,599 - DEBUG - Requesting: http://10.0.0.56:8082/domains
2025-08-07 02:50:21,608 - DEBUG - Requesting: http://10.0.0.56:8082/domain/fb2d80da-9971-40dc-80ca-c5bb54e98569
2025-08-07 02:50:21,624 - DEBUG - Requesting: http://10.0.0.56:8082/project/f38db1a7-18d4-40ec-9dd7-badb3e062bcd
2025-08-07 02:50:21,735 - DEBUG - Requesting: http://10.0.0.56:8082/network-ipam/5db52b93-e4a3-41dd-98c5-ef037571e3c1
2025-08-07 02:50:21,748 - INFO - Verifications in API Server for IPAM: ipam3 passed
2025-08-07 02:50:21,758 - DEBUG - Control-node 10.0.0.56 : IPAM object is : {'node_name': 'network-ipam:default-domain:ctest-TestPolicyAclIpv4v6-61472176:ipam3', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestPolicyAclIpv4v6-61472176', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6752351130508018141', 'uuid-lslong': '11008467662311384001'}, 'enable': 'true', 'created': '2025-08-07T02:50:20', 'last-modified': '2025-08-07T02:50:20', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.898566'}
2025-08-07 02:50:21,768 - DEBUG - Control-node 10.0.0.130 : IPAM object is : {'node_name': 'network-ipam:default-domain:ctest-TestPolicyAclIpv4v6-61472176:ipam3', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestPolicyAclIpv4v6-61472176', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6752351130508018141', 'uuid-lslong': '11008467662311384001'}, 'enable': 'true', 'created': '2025-08-07T02:50:20', 'last-modified': '2025-08-07T02:50:20', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.905936'}
2025-08-07 02:50:21,778 - DEBUG - Control-node 10.0.0.249 : IPAM object is : {'node_name': 'network-ipam:default-domain:ctest-TestPolicyAclIpv4v6-61472176:ipam3', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestPolicyAclIpv4v6-61472176', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6752351130508018141', 'uuid-lslong': '11008467662311384001'}, 'enable': 'true', 'created': '2025-08-07T02:50:20', 'last-modified': '2025-08-07T02:50:20', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.917135'}
2025-08-07 02:50:21,778 - INFO - Verifications in Control node for IPAM: ipam3 passed
2025-08-07 02:50:22,152 - DEBUG - Response for create_network : {'network': {'id': 'ded67615-8dee-4ed2-a5d6-dd8f4f9c546f', 'name': 'ctest-VN1-10139582', 'tenant_id': 'f38db1a718d440ec9dd7badb3e062bcd', 'project_id': 'f38db1a718d440ec9dd7badb3e062bcd', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestPolicyAclIpv4v6-61472176', 'ctest-VN1-10139582'], 'port_security_enabled': True, 'description': ''}}
2025-08-07 02:50:22,524 - DEBUG - Response for create_subnet : {'subnet': {'id': '61562893-c61a-4320-950c-41b8407941dc', 'name': '', 'tenant_id': 'f38db1a718d440ec9dd7badb3e062bcd', 'network_id': 'ded67615-8dee-4ed2-a5d6-dd8f4f9c546f', 'ip_version': 4, 'cidr': '17.109.38.64/26', 'allocation_pools': [{'start': '17.109.38.66', 'end': '17.109.38.126'}], 'gateway_ip': '17.109.38.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '17.109.38.66', 'tags': [], 'project_id': 'f38db1a718d440ec9dd7badb3e062bcd'}}
2025-08-07 02:50:22,814 - DEBUG - Response for create_subnet : {'subnet': {'id': '8bfffd69-0662-4cab-bb6e-92247d54922f', 'name': '', 'tenant_id': 'f38db1a718d440ec9dd7badb3e062bcd', 'network_id': 'ded67615-8dee-4ed2-a5d6-dd8f4f9c546f', 'ip_version': 6, 'cidr': '35cb:88b3:4858:61c5:735d:2091::/96', 'allocation_pools': [{'start': '35cb:88b3:4858:61c5:735d:2091:0:2', 'end': '35cb:88b3:4858:61c5:735d:2091:ffff:fffe'}], 'gateway_ip': '35cb:88b3:4858:61c5:735d:2091:0:1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '35cb:88b3:4858:61c5:735d:2091:0:2', 'tags': [], 'project_id': 'f38db1a718d440ec9dd7badb3e062bcd'}}
2025-08-07 02:50:22,851 - INFO - Created VN ctest-VN1-10139582
2025-08-07 02:50:22,868 - DEBUG - VN ctest-VN1-10139582 UUID is ded67615-8dee-4ed2-a5d6-dd8f4f9c546f
2025-08-07 02:50:23,086 - DEBUG - Fetched VN: default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN1-10139582(ded67615-8dee-4ed2-a5d6-dd8f4f9c546f) with subnets ['17.109.38.64/26', '35cb:88b3:4858:61c5:735d:2091::/96']
2025-08-07 02:50:23,611 - DEBUG - Response for create_network : {'network': {'id': '47ec5f77-95a8-4446-b0f1-83c6b6a4915d', 'name': 'ctest-VN2-78426741', 'tenant_id': 'f38db1a718d440ec9dd7badb3e062bcd', 'project_id': 'f38db1a718d440ec9dd7badb3e062bcd', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestPolicyAclIpv4v6-61472176', 'ctest-VN2-78426741'], 'port_security_enabled': True, 'description': ''}}
2025-08-07 02:50:23,926 - DEBUG - Response for create_subnet : {'subnet': {'id': '95672cda-8f24-4812-9e48-ba032f75f6a8', 'name': '', 'tenant_id': 'f38db1a718d440ec9dd7badb3e062bcd', 'network_id': '47ec5f77-95a8-4446-b0f1-83c6b6a4915d', 'ip_version': 4, 'cidr': '199.70.193.128/26', 'allocation_pools': [{'start': '199.70.193.130', 'end': '199.70.193.190'}], 'gateway_ip': '199.70.193.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '199.70.193.130', 'tags': [], 'project_id': 'f38db1a718d440ec9dd7badb3e062bcd'}}
2025-08-07 02:50:24,250 - DEBUG - Response for create_subnet : {'subnet': {'id': '20d27ccc-dda6-4893-acc9-f21bc78ea4ce', 'name': '', 'tenant_id': 'f38db1a718d440ec9dd7badb3e062bcd', 'network_id': '47ec5f77-95a8-4446-b0f1-83c6b6a4915d', 'ip_version': 6, 'cidr': '2648:2063:29a9:ef77:b20e:df36::/96', 'allocation_pools': [{'start': '2648:2063:29a9:ef77:b20e:df36:0:2', 'end': '2648:2063:29a9:ef77:b20e:df36:ffff:fffe'}], 'gateway_ip': '2648:2063:29a9:ef77:b20e:df36:0:1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '2648:2063:29a9:ef77:b20e:df36:0:2', 'tags': [], 'project_id': 'f38db1a718d440ec9dd7badb3e062bcd'}}
2025-08-07 02:50:24,279 - INFO - Created VN ctest-VN2-78426741
2025-08-07 02:50:24,297 - DEBUG - VN ctest-VN2-78426741 UUID is 47ec5f77-95a8-4446-b0f1-83c6b6a4915d
2025-08-07 02:50:24,929 - DEBUG - Response for create_network : {'network': {'id': '10bcb4e3-ac42-409e-9fe9-97e69bbab157', 'name': 'ctest-VN3-56781315', 'tenant_id': 'f38db1a718d440ec9dd7badb3e062bcd', 'project_id': 'f38db1a718d440ec9dd7badb3e062bcd', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestPolicyAclIpv4v6-61472176', 'ctest-VN3-56781315'], 'port_security_enabled': True, 'description': ''}}
2025-08-07 02:50:25,329 - DEBUG - Response for create_subnet : {'subnet': {'id': 'ae0c3e93-7de9-4b0f-8fa4-af2e2cdc45bb', 'name': '', 'tenant_id': 'f38db1a718d440ec9dd7badb3e062bcd', 'network_id': '10bcb4e3-ac42-409e-9fe9-97e69bbab157', 'ip_version': 4, 'cidr': '153.176.108.0/26', 'allocation_pools': [{'start': '153.176.108.2', 'end': '153.176.108.62'}], 'gateway_ip': '153.176.108.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '153.176.108.2', 'tags': [], 'project_id': 'f38db1a718d440ec9dd7badb3e062bcd'}}
2025-08-07 02:50:25,607 - DEBUG - Response for create_subnet : {'subnet': {'id': '19712c70-1d80-48f4-a9a3-358d6a706f35', 'name': '', 'tenant_id': 'f38db1a718d440ec9dd7badb3e062bcd', 'network_id': '10bcb4e3-ac42-409e-9fe9-97e69bbab157', 'ip_version': 6, 'cidr': '3afc:587a:21e9:bc25:c855:d925::/96', 'allocation_pools': [{'start': '3afc:587a:21e9:bc25:c855:d925:0:2', 'end': '3afc:587a:21e9:bc25:c855:d925:ffff:fffe'}], 'gateway_ip': '3afc:587a:21e9:bc25:c855:d925:0:1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '3afc:587a:21e9:bc25:c855:d925:0:2', 'tags': [], 'project_id': 'f38db1a718d440ec9dd7badb3e062bcd'}}
2025-08-07 02:50:25,659 - INFO - Created VN ctest-VN3-56781315
2025-08-07 02:50:25,676 - DEBUG - VN ctest-VN3-56781315 UUID is 10bcb4e3-ac42-409e-9fe9-97e69bbab157
2025-08-07 02:50:25,844 - DEBUG - Requesting: http://10.0.0.56:8082/domains
2025-08-07 02:50:25,852 - DEBUG - Requesting: http://10.0.0.56:8082/domain/fb2d80da-9971-40dc-80ca-c5bb54e98569
2025-08-07 02:50:25,867 - DEBUG - Requesting: http://10.0.0.56:8082/project/f38db1a7-18d4-40ec-9dd7-badb3e062bcd
2025-08-07 02:50:25,963 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-network/ded67615-8dee-4ed2-a5d6-dd8f4f9c546f
2025-08-07 02:50:25,980 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-network/ded67615-8dee-4ed2-a5d6-dd8f4f9c546f
2025-08-07 02:50:25,994 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/1857ebb3-bab8-4365-a7ed-632c57189ed1
2025-08-07 02:50:26,010 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/1857ebb3-bab8-4365-a7ed-632c57189ed1
2025-08-07 02:50:26,026 - DEBUG - Requesting: http://10.0.0.56:8082/route-target/15cdb4a5-3c04-4b0b-8f5e-d58135d552b3
2025-08-07 02:50:26,035 - DEBUG - Route Targets: ['target:64512:8000005']
2025-08-07 02:50:26,035 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-network/ded67615-8dee-4ed2-a5d6-dd8f4f9c546f
2025-08-07 02:50:26,048 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/1857ebb3-bab8-4365-a7ed-632c57189ed1
2025-08-07 02:50:26,067 - INFO - Verified VN network id 12 for VN ded67615-8dee-4ed2-a5d6-dd8f4f9c546f
2025-08-07 02:50:26,068 - INFO - Verifications in API Server for VN ctest-VN1-10139582 passed
2025-08-07 02:50:26,068 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-network/ded67615-8dee-4ed2-a5d6-dd8f4f9c546f
2025-08-07 02:50:26,081 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/1857ebb3-bab8-4365-a7ed-632c57189ed1
2025-08-07 02:50:26,096 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/1857ebb3-bab8-4365-a7ed-632c57189ed1
2025-08-07 02:50:26,108 - DEBUG - Requesting: http://10.0.0.56:8082/route-target/15cdb4a5-3c04-4b0b-8f5e-d58135d552b3
2025-08-07 02:50:26,126 - DEBUG - Control-node 10.0.0.56 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN1-10139582', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestPolicyAclIpv4v6-61472176', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16057151356383678162', 'uuid-lslong': '11949982268859896943'}, 'enable': 'true', 'created': '2025-08-07T02:50:22', 'last-modified': '2025-08-07T02:50:22', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:03.394360'}
2025-08-07 02:50:26,137 - DEBUG - Route Targets: ['target:64512:8000005']
2025-08-07 02:50:26,145 - DEBUG - Control-node 10.0.0.130 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN1-10139582', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestPolicyAclIpv4v6-61472176', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16057151356383678162', 'uuid-lslong': '11949982268859896943'}, 'enable': 'true', 'created': '2025-08-07T02:50:22', 'last-modified': '2025-08-07T02:50:22', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:03.424598'}
2025-08-07 02:50:26,153 - DEBUG - Route Targets: ['target:64512:8000005']
2025-08-07 02:50:26,161 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN1-10139582', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestPolicyAclIpv4v6-61472176', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16057151356383678162', 'uuid-lslong': '11949982268859896943'}, 'enable': 'true', 'created': '2025-08-07T02:50:22', 'last-modified': '2025-08-07T02:50:22', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:03.429827'}
2025-08-07 02:50:26,175 - DEBUG - Route Targets: ['target:64512:8000005']
2025-08-07 02:50:26,175 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-VN1-10139582 passed
2025-08-07 02:50:26,175 - DEBUG - ====Verifying policy data for ctest-VN1-10139582 in API_Server ======
2025-08-07 02:50:26,175 - DEBUG - Requesting: http://10.0.0.56:8082/domains
2025-08-07 02:50:26,184 - DEBUG - Requesting: http://10.0.0.56:8082/domain/fb2d80da-9971-40dc-80ca-c5bb54e98569
2025-08-07 02:50:26,200 - DEBUG - Requesting: http://10.0.0.56:8082/project/f38db1a7-18d4-40ec-9dd7-badb3e062bcd
2025-08-07 02:50:26,325 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-network/ded67615-8dee-4ed2-a5d6-dd8f4f9c546f
2025-08-07 02:50:26,340 - DEBUG - =>VN ctest-VN1-10139582 has no policy to be verified
2025-08-07 02:50:26,340 - DEBUG - Verifying the vn in opserver
2025-08-07 02:50:26,340 - DEBUG - Verifying the default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN1-10139582 virtual network link through opserver 10.0.0.56
2025-08-07 02:50:26,340 - DEBUG - Requesting: http://10.0.0.56:8081/analytics/uves/virtual-networks
2025-08-07 02:50:26,767 - DEBUG - Requesting: http://10.0.0.56:8081/analytics/uves/virtual-networks
2025-08-07 02:50:26,849 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN1-10139582', 'href': 'http://10.0.0.56:8081/analytics/uves/virtual-network/default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN1-10139582?flat'}
2025-08-07 02:50:26,849 - DEBUG - Verifying the default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN1-10139582 virtual network link through opserver 10.0.0.130
2025-08-07 02:50:26,849 - DEBUG - Requesting: http://10.0.0.130:8081/analytics/uves/virtual-networks
2025-08-07 02:50:27,168 - DEBUG - Requesting: http://10.0.0.130:8081/analytics/uves/virtual-networks
2025-08-07 02:50:27,236 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN1-10139582', 'href': 'http://10.0.0.130:8081/analytics/uves/virtual-network/default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN1-10139582?flat'}
2025-08-07 02:50:27,236 - DEBUG - Verifying the default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN1-10139582 virtual network link through opserver 10.0.0.249
2025-08-07 02:50:27,236 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2025-08-07 02:50:27,546 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2025-08-07 02:50:27,612 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN1-10139582', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN1-10139582?flat'}
2025-08-07 02:50:27,612 - INFO - Validated that VN default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN1-10139582 is found in opserver
2025-08-07 02:50:27,639 - DEBUG - Do not have enough data to verify VN in agent
2025-08-07 02:50:27,653 - DEBUG - VRF ids for VN ctest-VN1-10139582: {}
2025-08-07 02:50:27,653 - DEBUG - Requesting: http://10.0.0.56:8082/domains
2025-08-07 02:50:27,661 - DEBUG - Requesting: http://10.0.0.56:8082/domain/fb2d80da-9971-40dc-80ca-c5bb54e98569
2025-08-07 02:50:27,675 - DEBUG - Requesting: http://10.0.0.56:8082/project/f38db1a7-18d4-40ec-9dd7-badb3e062bcd
2025-08-07 02:50:27,788 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-network/47ec5f77-95a8-4446-b0f1-83c6b6a4915d
2025-08-07 02:50:27,807 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-network/47ec5f77-95a8-4446-b0f1-83c6b6a4915d
2025-08-07 02:50:27,821 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/8f112286-3cf4-4df9-9e2c-f43af5c9fc9f
2025-08-07 02:50:27,839 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/8f112286-3cf4-4df9-9e2c-f43af5c9fc9f
2025-08-07 02:50:27,849 - DEBUG - Requesting: http://10.0.0.56:8082/route-target/87055854-439f-4075-a2aa-4e6940179eab
2025-08-07 02:50:27,858 - DEBUG - Route Targets: ['target:64512:8000006']
2025-08-07 02:50:27,858 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-network/47ec5f77-95a8-4446-b0f1-83c6b6a4915d
2025-08-07 02:50:27,871 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/8f112286-3cf4-4df9-9e2c-f43af5c9fc9f
2025-08-07 02:50:27,896 - INFO - Verified VN network id 13 for VN 47ec5f77-95a8-4446-b0f1-83c6b6a4915d
2025-08-07 02:50:27,896 - INFO - Verifications in API Server for VN ctest-VN2-78426741 passed
2025-08-07 02:50:27,896 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-network/47ec5f77-95a8-4446-b0f1-83c6b6a4915d
2025-08-07 02:50:27,909 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/8f112286-3cf4-4df9-9e2c-f43af5c9fc9f
2025-08-07 02:50:27,918 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/8f112286-3cf4-4df9-9e2c-f43af5c9fc9f
2025-08-07 02:50:27,926 - DEBUG - Requesting: http://10.0.0.56:8082/route-target/87055854-439f-4075-a2aa-4e6940179eab
2025-08-07 02:50:27,945 - DEBUG - Control-node 10.0.0.56 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN2-78426741', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestPolicyAclIpv4v6-61472176', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5182622238413177926', 'uuid-lslong': '12750116909553586525'}, 'enable': 'true', 'created': '2025-08-07T02:50:23', 'last-modified': '2025-08-07T02:50:24', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:03.750214'}
2025-08-07 02:50:27,954 - DEBUG - Route Targets: ['target:64512:8000006']
2025-08-07 02:50:27,962 - DEBUG - Control-node 10.0.0.130 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN2-78426741', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestPolicyAclIpv4v6-61472176', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5182622238413177926', 'uuid-lslong': '12750116909553586525'}, 'enable': 'true', 'created': '2025-08-07T02:50:23', 'last-modified': '2025-08-07T02:50:24', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:03.790429'}
2025-08-07 02:50:27,976 - DEBUG - Route Targets: ['target:64512:8000006']
2025-08-07 02:50:27,984 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN2-78426741', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestPolicyAclIpv4v6-61472176', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5182622238413177926', 'uuid-lslong': '12750116909553586525'}, 'enable': 'true', 'created': '2025-08-07T02:50:23', 'last-modified': '2025-08-07T02:50:24', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:03.814449'}
2025-08-07 02:50:27,996 - DEBUG - Route Targets: ['target:64512:8000006']
2025-08-07 02:50:27,996 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-VN2-78426741 passed
2025-08-07 02:50:27,996 - DEBUG - ====Verifying policy data for ctest-VN2-78426741 in API_Server ======
2025-08-07 02:50:27,996 - DEBUG - Requesting: http://10.0.0.56:8082/domains
2025-08-07 02:50:28,004 - DEBUG - Requesting: http://10.0.0.56:8082/domain/fb2d80da-9971-40dc-80ca-c5bb54e98569
2025-08-07 02:50:28,018 - DEBUG - Requesting: http://10.0.0.56:8082/project/f38db1a7-18d4-40ec-9dd7-badb3e062bcd
2025-08-07 02:50:28,122 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-network/47ec5f77-95a8-4446-b0f1-83c6b6a4915d
2025-08-07 02:50:28,137 - DEBUG - =>VN ctest-VN2-78426741 has no policy to be verified
2025-08-07 02:50:28,138 - DEBUG - Verifying the vn in opserver
2025-08-07 02:50:28,138 - DEBUG - Verifying the default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN2-78426741 virtual network link through opserver 10.0.0.56
2025-08-07 02:50:28,138 - DEBUG - Requesting: http://10.0.0.56:8081/analytics/uves/virtual-networks
2025-08-07 02:50:28,226 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN2-78426741', 'href': 'http://10.0.0.56:8081/analytics/uves/virtual-network/default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN2-78426741?flat'}
2025-08-07 02:50:28,226 - DEBUG - Verifying the default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN2-78426741 virtual network link through opserver 10.0.0.130
2025-08-07 02:50:28,226 - DEBUG - Requesting: http://10.0.0.130:8081/analytics/uves/virtual-networks
2025-08-07 02:50:28,304 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN2-78426741', 'href': 'http://10.0.0.130:8081/analytics/uves/virtual-network/default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN2-78426741?flat'}
2025-08-07 02:50:28,304 - DEBUG - Verifying the default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN2-78426741 virtual network link through opserver 10.0.0.249
2025-08-07 02:50:28,304 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2025-08-07 02:50:28,375 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN2-78426741', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN2-78426741?flat'}
2025-08-07 02:50:28,375 - INFO - Validated that VN default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN2-78426741 is found in opserver
2025-08-07 02:50:28,407 - DEBUG - Do not have enough data to verify VN in agent
2025-08-07 02:50:28,426 - DEBUG - VRF ids for VN ctest-VN2-78426741: {}
2025-08-07 02:50:28,426 - DEBUG - Requesting: http://10.0.0.56:8082/domains
2025-08-07 02:50:28,433 - DEBUG - Requesting: http://10.0.0.56:8082/domain/fb2d80da-9971-40dc-80ca-c5bb54e98569
2025-08-07 02:50:28,448 - DEBUG - Requesting: http://10.0.0.56:8082/project/f38db1a7-18d4-40ec-9dd7-badb3e062bcd
2025-08-07 02:50:28,556 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-network/10bcb4e3-ac42-409e-9fe9-97e69bbab157
2025-08-07 02:50:28,581 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-network/10bcb4e3-ac42-409e-9fe9-97e69bbab157
2025-08-07 02:50:28,604 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/d20e9b38-aa75-46c1-a931-c644172dc0d5
2025-08-07 02:50:28,620 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/d20e9b38-aa75-46c1-a931-c644172dc0d5
2025-08-07 02:50:28,639 - DEBUG - Requesting: http://10.0.0.56:8082/route-target/e8c638a6-16d7-4714-ba7c-9724d04b2418
2025-08-07 02:50:28,653 - DEBUG - Route Targets: ['target:64512:8000007']
2025-08-07 02:50:28,653 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-network/10bcb4e3-ac42-409e-9fe9-97e69bbab157
2025-08-07 02:50:28,667 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/d20e9b38-aa75-46c1-a931-c644172dc0d5
2025-08-07 02:50:28,691 - INFO - Verified VN network id 14 for VN 10bcb4e3-ac42-409e-9fe9-97e69bbab157
2025-08-07 02:50:28,691 - INFO - Verifications in API Server for VN ctest-VN3-56781315 passed
2025-08-07 02:50:28,691 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-network/10bcb4e3-ac42-409e-9fe9-97e69bbab157
2025-08-07 02:50:28,709 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/d20e9b38-aa75-46c1-a931-c644172dc0d5
2025-08-07 02:50:28,718 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/d20e9b38-aa75-46c1-a931-c644172dc0d5
2025-08-07 02:50:28,730 - DEBUG - Requesting: http://10.0.0.56:8082/route-target/e8c638a6-16d7-4714-ba7c-9724d04b2418
2025-08-07 02:50:28,753 - DEBUG - Control-node 10.0.0.56 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN3-56781315', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestPolicyAclIpv4v6-61472176', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1206037690169049246', 'uuid-lslong': '11522908138315100503'}, 'enable': 'true', 'created': '2025-08-07T02:50:24', 'last-modified': '2025-08-07T02:50:25', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:03.233002'}
2025-08-07 02:50:28,763 - DEBUG - Route Targets: ['target:64512:8000007']
2025-08-07 02:50:28,773 - DEBUG - Control-node 10.0.0.130 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN3-56781315', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestPolicyAclIpv4v6-61472176', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1206037690169049246', 'uuid-lslong': '11522908138315100503'}, 'enable': 'true', 'created': '2025-08-07T02:50:24', 'last-modified': '2025-08-07T02:50:25', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:03.255067'}
2025-08-07 02:50:28,781 - DEBUG - Route Targets: ['target:64512:8000007']
2025-08-07 02:50:28,788 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN3-56781315', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestPolicyAclIpv4v6-61472176', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1206037690169049246', 'uuid-lslong': '11522908138315100503'}, 'enable': 'true', 'created': '2025-08-07T02:50:24', 'last-modified': '2025-08-07T02:50:25', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:03.275716'}
2025-08-07 02:50:28,800 - DEBUG - Route Targets: ['target:64512:8000007']
2025-08-07 02:50:28,800 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-VN3-56781315 passed
2025-08-07 02:50:28,800 - DEBUG - ====Verifying policy data for ctest-VN3-56781315 in API_Server ======
2025-08-07 02:50:28,800 - DEBUG - Requesting: http://10.0.0.56:8082/domains
2025-08-07 02:50:28,809 - DEBUG - Requesting: http://10.0.0.56:8082/domain/fb2d80da-9971-40dc-80ca-c5bb54e98569
2025-08-07 02:50:28,827 - DEBUG - Requesting: http://10.0.0.56:8082/project/f38db1a7-18d4-40ec-9dd7-badb3e062bcd
2025-08-07 02:50:28,938 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-network/10bcb4e3-ac42-409e-9fe9-97e69bbab157
2025-08-07 02:50:28,951 - DEBUG - =>VN ctest-VN3-56781315 has no policy to be verified
2025-08-07 02:50:28,951 - DEBUG - Verifying the vn in opserver
2025-08-07 02:50:28,951 - DEBUG - Verifying the default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN3-56781315 virtual network link through opserver 10.0.0.56
2025-08-07 02:50:28,951 - DEBUG - Requesting: http://10.0.0.56:8081/analytics/uves/virtual-networks
2025-08-07 02:50:29,020 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN3-56781315', 'href': 'http://10.0.0.56:8081/analytics/uves/virtual-network/default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN3-56781315?flat'}
2025-08-07 02:50:29,020 - DEBUG - Verifying the default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN3-56781315 virtual network link through opserver 10.0.0.130
2025-08-07 02:50:29,020 - DEBUG - Requesting: http://10.0.0.130:8081/analytics/uves/virtual-networks
2025-08-07 02:50:29,096 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN3-56781315', 'href': 'http://10.0.0.130:8081/analytics/uves/virtual-network/default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN3-56781315?flat'}
2025-08-07 02:50:29,096 - DEBUG - Verifying the default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN3-56781315 virtual network link through opserver 10.0.0.249
2025-08-07 02:50:29,096 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2025-08-07 02:50:29,162 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN3-56781315', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN3-56781315?flat'}
2025-08-07 02:50:29,162 - INFO - Validated that VN default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN3-56781315 is found in opserver
2025-08-07 02:50:29,192 - DEBUG - Do not have enough data to verify VN in agent
2025-08-07 02:50:29,206 - DEBUG - VRF ids for VN ctest-VN3-56781315: {}
2025-08-07 02:50:29,214 - DEBUG - No destination network defined
2025-08-07 02:50:29,214 - DEBUG - No destination network defined
2025-08-07 02:50:29,215 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = 58, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN1-10139582, security_group = None, network_policy = None, subnet_list = []], src_ports = [start_port = -1, end_port = -1], application = [], dst_addresses = [subnet = ip_prefix = 2648:2063:29a9:ef77:b20e:df36::, ip_prefix_len = 96, virtual_network = None, 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-TestPolicyAclIpv4v6-61472176:ctest-VN1-10139582, security_group = None, network_policy = None, subnet_list = []], src_ports = [start_port = -1, end_port = -1], application = [], dst_addresses = [subnet = ip_prefix = 199.70.193.128, ip_prefix_len = 26, virtual_network = None, 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-TestPolicyAclIpv4v6-61472176:ctest-VN1-10139582, 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-TestPolicyAclIpv4v6-61472176:ctest-VN2-78426741, 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-07 02:50:29,510 - DEBUG - No destination network defined
2025-08-07 02:50:29,510 - DEBUG - No destination network defined
2025-08-07 02:50:29,510 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = 58, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN2-78426741, security_group = None, network_policy = None, subnet_list = []], src_ports = [start_port = -1, end_port = -1], application = [], dst_addresses = [subnet = ip_prefix = 35cb:88b3:4858:61c5:735d:2091::, ip_prefix_len = 96, virtual_network = None, 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-TestPolicyAclIpv4v6-61472176:ctest-VN2-78426741, security_group = None, network_policy = None, subnet_list = []], src_ports = [start_port = -1, end_port = -1], application = [], dst_addresses = [subnet = ip_prefix = 17.109.38.64, ip_prefix_len = 26, virtual_network = None, 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-TestPolicyAclIpv4v6-61472176:ctest-VN2-78426741, 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-TestPolicyAclIpv4v6-61472176:ctest-VN1-10139582, 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-07 02:50:29,737 - DEBUG - Requesting: http://10.0.0.56:8082/domains
2025-08-07 02:50:29,744 - DEBUG - Requesting: http://10.0.0.56:8082/domain/fb2d80da-9971-40dc-80ca-c5bb54e98569
2025-08-07 02:50:29,759 - DEBUG - Requesting: http://10.0.0.56:8082/project/f38db1a7-18d4-40ec-9dd7-badb3e062bcd
2025-08-07 02:50:29,883 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-network/ded67615-8dee-4ed2-a5d6-dd8f4f9c546f
2025-08-07 02:50:29,896 - DEBUG - Setup step: Associating the policy to VN'
2025-08-07 02:50:30,048 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': 'ded67615-8dee-4ed2-a5d6-dd8f4f9c546f', 'name': 'ctest-VN1-10139582', 'tenant_id': 'f38db1a718d440ec9dd7badb3e062bcd', 'project_id': 'f38db1a718d440ec9dd7badb3e062bcd', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['61562893-c61a-4320-950c-41b8407941dc', '8bfffd69-0662-4cab-bb6e-92247d54922f'], 'fq_name': ['default-domain', 'ctest-TestPolicyAclIpv4v6-61472176', 'ctest-VN1-10139582'], 'policys': [['default-domain', 'ctest-TestPolicyAclIpv4v6-61472176', 'ctest-policy12-54508741']], 'subnet_ipam': [{'subnet_cidr': '17.109.38.64/26', 'ipam_fq_name': ['default-domain', 'ctest-TestPolicyAclIpv4v6-61472176', 'ipam1']}, {'subnet_cidr': '35cb:88b3:4858:61c5:735d:2091::/96', 'ipam_fq_name': ['default-domain', 'ctest-TestPolicyAclIpv4v6-61472176', 'ipam1']}], 'port_security_enabled': True, 'description': ''}}
2025-08-07 02:50:30,182 - DEBUG - Associated Policy:[['default-domain', 'ctest-TestPolicyAclIpv4v6-61472176', 'ctest-policy12-54508741']] to ctest-VN1-10139582
2025-08-07 02:50:30,183 - DEBUG - Requesting: http://10.0.0.56:8082/domains
2025-08-07 02:50:30,191 - DEBUG - Requesting: http://10.0.0.56:8082/domain/fb2d80da-9971-40dc-80ca-c5bb54e98569
2025-08-07 02:50:30,207 - DEBUG - Requesting: http://10.0.0.56:8082/project/f38db1a7-18d4-40ec-9dd7-badb3e062bcd
2025-08-07 02:50:30,325 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-network/47ec5f77-95a8-4446-b0f1-83c6b6a4915d
2025-08-07 02:50:30,341 - DEBUG - Setup step: Associating the policy to VN'
2025-08-07 02:50:30,522 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': '47ec5f77-95a8-4446-b0f1-83c6b6a4915d', 'name': 'ctest-VN2-78426741', 'tenant_id': 'f38db1a718d440ec9dd7badb3e062bcd', 'project_id': 'f38db1a718d440ec9dd7badb3e062bcd', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['95672cda-8f24-4812-9e48-ba032f75f6a8', '20d27ccc-dda6-4893-acc9-f21bc78ea4ce'], 'fq_name': ['default-domain', 'ctest-TestPolicyAclIpv4v6-61472176', 'ctest-VN2-78426741'], 'policys': [['default-domain', 'ctest-TestPolicyAclIpv4v6-61472176', 'ctest-policy21-14534381']], 'subnet_ipam': [{'subnet_cidr': '199.70.193.128/26', 'ipam_fq_name': ['default-domain', 'ctest-TestPolicyAclIpv4v6-61472176', 'ipam2']}, {'subnet_cidr': '2648:2063:29a9:ef77:b20e:df36::/96', 'ipam_fq_name': ['default-domain', 'ctest-TestPolicyAclIpv4v6-61472176', 'ipam2']}], 'port_security_enabled': True, 'description': ''}}
2025-08-07 02:50:30,663 - DEBUG - Associated Policy:[['default-domain', 'ctest-TestPolicyAclIpv4v6-61472176', 'ctest-policy21-14534381']] to ctest-VN2-78426741
2025-08-07 02:50:30,770 - DEBUG - Services list from nova: [, , , ]
2025-08-07 02:50:30,799 - DEBUG - Image by name ubuntu not found
2025-08-07 02:50:30,800 - DEBUG - Installing image ubuntu
2025-08-07 02:50:30,800 - DEBUG - Image info {'name': 'ubuntu.vmdk.gz', 'webserver': '', 'location': '/images/converts/', 'username': 'ubuntu', 'password': 'ubuntu', 'type': 'os', 'flavor': 'contrail_flavor_tiny', 'params': '--container-format bare --disk-format vmdk --property vmware_disktype="sparse" --property vmware_adaptertype="ide" --property hw_scsi_model=virtio-scsi --property hw_disk_bus_model=virtio-scsi --property hw_disk_bus=virtio', 'name_docker': 'phusion-baseimage-enablesshd'}
2025-08-07 02:50:30,800 - DEBUG - Image build path file:///contrail-test/images/ubuntu.vmdk.gz
2025-08-07 02:50:30,800 - DEBUG - Download image from local file file:///contrail-test/images/ubuntu.vmdk.gz
2025-08-07 02:50:30,800 - DEBUG - Unzip image
2025-08-07 02:50:30,800 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/ubuntu.vmdk.gz
2025-08-07 02:50:30,815 - INFO - image /contrail-test/images/ubuntu.vmdk is not found
2025-08-07 02:50:30,816 - DEBUG - Detaching the Policy for VN :ctest-VN2-78426741
2025-08-07 02:50:30,816 - DEBUG - Requesting: http://10.0.0.56:8082/domains
2025-08-07 02:50:30,825 - DEBUG - Requesting: http://10.0.0.56:8082/domain/fb2d80da-9971-40dc-80ca-c5bb54e98569
2025-08-07 02:50:30,842 - DEBUG - Requesting: http://10.0.0.56:8082/project/f38db1a7-18d4-40ec-9dd7-badb3e062bcd
2025-08-07 02:50:30,958 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-network/47ec5f77-95a8-4446-b0f1-83c6b6a4915d
2025-08-07 02:50:30,978 - DEBUG - Requesting: http://10.0.0.56:8082/network-policy/cf3f8ce0-57c8-475b-b01e-7d73920406cd
2025-08-07 02:50:31,208 - DEBUG - Detached Policy:[['default-domain', 'ctest-TestPolicyAclIpv4v6-61472176', 'ctest-policy21-14534381']] from ctest-VN2-78426741
2025-08-07 02:50:31,208 - DEBUG - Detaching the Policy for VN :ctest-VN1-10139582
2025-08-07 02:50:31,208 - DEBUG - Requesting: http://10.0.0.56:8082/domains
2025-08-07 02:50:31,218 - DEBUG - Requesting: http://10.0.0.56:8082/domain/fb2d80da-9971-40dc-80ca-c5bb54e98569
2025-08-07 02:50:31,246 - DEBUG - Requesting: http://10.0.0.56:8082/project/f38db1a7-18d4-40ec-9dd7-badb3e062bcd
2025-08-07 02:50:31,354 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-network/ded67615-8dee-4ed2-a5d6-dd8f4f9c546f
2025-08-07 02:50:31,372 - DEBUG - Requesting: http://10.0.0.56:8082/network-policy/8704671b-c131-49e6-a090-15f01125f88f
2025-08-07 02:50:31,626 - DEBUG - Detached Policy:[['default-domain', 'ctest-TestPolicyAclIpv4v6-61472176', 'ctest-policy12-54508741']] from ctest-VN1-10139582
2025-08-07 02:50:31,701 - INFO - Deleted policy ctest-policy21-14534381
2025-08-07 02:50:31,759 - INFO - Deleted policy ctest-policy12-54508741
2025-08-07 02:50:31,761 - INFO - Deleting VN ctest-VN3-56781315
2025-08-07 02:50:31,971 - DEBUG - Response for deleting network ()
2025-08-07 02:50:31,972 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/d20e9b38-aa75-46c1-a931-c644172dc0d5
2025-08-07 02:50:31,982 - DEBUG - Response Code: 404
2025-08-07 02:50:31,983 - DEBUG - Requesting: http://10.0.0.56:8082/domains
2025-08-07 02:50:31,991 - DEBUG - Requesting: http://10.0.0.56:8082/domain/fb2d80da-9971-40dc-80ca-c5bb54e98569
2025-08-07 02:50:32,048 - DEBUG - Requesting: http://10.0.0.56:8082/project/f38db1a7-18d4-40ec-9dd7-badb3e062bcd
2025-08-07 02:50:32,149 - INFO - Validated that VN ctest-VN3-56781315 is not found in API Server
2025-08-07 02:50:32,163 - DEBUG - VN ctest-VN3-56781315 is not present in Agent 10.0.0.41
2025-08-07 02:50:32,176 - DEBUG - VN ctest-VN3-56781315 is not present in Agent 10.0.0.61
2025-08-07 02:50:32,176 - INFO - Validated that VN ctest-VN3-56781315 is not in any agent
2025-08-07 02:50:32,217 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-VN3-56781315 info
2025-08-07 02:50:32,218 - INFO - Deleting VN ctest-VN2-78426741
2025-08-07 02:50:32,418 - DEBUG - Response for deleting network ()
2025-08-07 02:50:32,418 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/8f112286-3cf4-4df9-9e2c-f43af5c9fc9f
2025-08-07 02:50:32,426 - DEBUG - Response Code: 404
2025-08-07 02:50:32,426 - DEBUG - Requesting: http://10.0.0.56:8082/domains
2025-08-07 02:50:32,434 - DEBUG - Requesting: http://10.0.0.56:8082/domain/fb2d80da-9971-40dc-80ca-c5bb54e98569
2025-08-07 02:50:32,455 - DEBUG - Requesting: http://10.0.0.56:8082/project/f38db1a7-18d4-40ec-9dd7-badb3e062bcd
2025-08-07 02:50:32,562 - INFO - Validated that VN ctest-VN2-78426741 is not found in API Server
2025-08-07 02:50:32,576 - DEBUG - VN ctest-VN2-78426741 is not present in Agent 10.0.0.41
2025-08-07 02:50:32,591 - DEBUG - VN ctest-VN2-78426741 is not present in Agent 10.0.0.61
2025-08-07 02:50:32,591 - INFO - Validated that VN ctest-VN2-78426741 is not in any agent
2025-08-07 02:50:32,632 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-VN2-78426741 info
2025-08-07 02:50:32,633 - INFO - Deleting VN ctest-VN1-10139582
2025-08-07 02:50:32,853 - DEBUG - Response for deleting network ()
2025-08-07 02:50:32,853 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/1857ebb3-bab8-4365-a7ed-632c57189ed1
2025-08-07 02:50:32,865 - DEBUG - Response Code: 404
2025-08-07 02:50:32,865 - DEBUG - Requesting: http://10.0.0.56:8082/domains
2025-08-07 02:50:32,877 - DEBUG - Requesting: http://10.0.0.56:8082/domain/fb2d80da-9971-40dc-80ca-c5bb54e98569
2025-08-07 02:50:32,901 - DEBUG - Requesting: http://10.0.0.56:8082/project/f38db1a7-18d4-40ec-9dd7-badb3e062bcd
2025-08-07 02:50:33,022 - INFO - Validated that VN ctest-VN1-10139582 is not found in API Server
2025-08-07 02:50:33,038 - DEBUG - VN ctest-VN1-10139582 is not present in Agent 10.0.0.41
2025-08-07 02:50:33,051 - DEBUG - VN ctest-VN1-10139582 is not present in Agent 10.0.0.61
2025-08-07 02:50:33,051 - INFO - Validated that VN ctest-VN1-10139582 is not in any agent
2025-08-07 02:50:33,088 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-VN1-10139582 info
2025-08-07 02:50:33,186 - INFO - IPAM: ipam3 is not found in API Server
2025-08-07 02:50:33,213 - INFO - IPAM:ipam3 is not found in control node
2025-08-07 02:50:33,366 - INFO - IPAM: ipam2 is not found in API Server
2025-08-07 02:50:33,392 - INFO - IPAM:ipam2 is not found in control node
2025-08-07 02:50:33,534 - INFO - IPAM: ipam1 is not found in API Server
2025-08-07 02:50:33,565 - INFO - IPAM:ipam1 is not found in control node
2025-08-07 02:50:34,845 - DEBUG - No XMPP flaps were noticed during the test
2025-08-07 02:50:34,845 - INFO -
2025-08-07 02:50:34,845 - INFO - END TEST : test_policy_cidr_src_vn_dst_cidr : SKIPPED[0:00:16]
2025-08-07 02:50:34,845 - INFO - --------------------------------------------------------------------------------
2025-08-07 02:50:34,845 - INFO - image /contrail-test/images/ubuntu.vmdk is not found
2025-08-07 02:50:36,112 - DEBUG - No XMPP flaps were noticed during the test
2025-08-07 02:50:36,112 - INFO -
2025-08-07 02:50:36,113 - INFO - END TEST : test_policy_cidr_src_vn_dst_cidr : SKIPPED[0:00:20]
2025-08-07 02:50:36,113 - INFO - --------------------------------------------------------------------------------
2025-08-07 02:50:36,117 - INFO - ================================================================================
2025-08-07 02:50:36,117 - INFO - STARTING TEST : test_policy_inheritance_src_pol_dst_any
2025-08-07 02:50:37,403 - DEBUG - Nothing to compare xmpp stats {'10.0.0.41': {'10.20.0.17': '0', '10.20.0.25': '0'}, '10.0.0.61': {'10.20.0.17': '0', '10.20.0.25': '0'}} with
2025-08-07 02:50:37,403 - INFO - Initial checks done. Running the testcase now
2025-08-07 02:50:37,403 - INFO -
2025-08-07 02:50:37,403 - INFO - ================================================================================
2025-08-07 02:50:37,403 - INFO - STARTING TEST : test_policy_inheritance_src_pol_dst_any
2025-08-07 02:50:37,403 - INFO - TEST DESCRIPTION : Test cases to test policy inheritance
2025-08-07 02:50:38,684 - DEBUG - Nothing to compare xmpp stats {'10.0.0.41': {'10.20.0.17': '0', '10.20.0.25': '0'}, '10.0.0.61': {'10.20.0.17': '0', '10.20.0.25': '0'}} with
2025-08-07 02:50:38,684 - INFO - Initial checks done. Running the testcase now
2025-08-07 02:50:38,684 - INFO -
2025-08-07 02:50:39,722 - DEBUG - Requesting: http://10.0.0.56:8082/domains
2025-08-07 02:50:39,730 - DEBUG - Requesting: http://10.0.0.56:8082/domain/fb2d80da-9971-40dc-80ca-c5bb54e98569
2025-08-07 02:50:39,744 - DEBUG - Requesting: http://10.0.0.56:8082/project/f38db1a7-18d4-40ec-9dd7-badb3e062bcd
2025-08-07 02:50:39,853 - DEBUG - Requesting: http://10.0.0.56:8082/network-ipam/58e34640-a4d5-4f98-bb40-6677bae63927
2025-08-07 02:50:39,862 - INFO - Verifications in API Server for IPAM: ipam1 passed
2025-08-07 02:50:39,870 - DEBUG - Control-node 10.0.0.56 : IPAM object is : {'node_name': 'network-ipam:default-domain:ctest-TestPolicyAclIpv4v6-61472176:ipam1', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestPolicyAclIpv4v6-61472176', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6405040338508271512', 'uuid-lslong': '13492897148024797479'}, 'enable': 'true', 'created': '2025-08-07T02:50:38', 'last-modified': '2025-08-07T02:50:38', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.906636'}
2025-08-07 02:50:39,877 - DEBUG - Control-node 10.0.0.130 : IPAM object is : {'node_name': 'network-ipam:default-domain:ctest-TestPolicyAclIpv4v6-61472176:ipam1', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestPolicyAclIpv4v6-61472176', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6405040338508271512', 'uuid-lslong': '13492897148024797479'}, 'enable': 'true', 'created': '2025-08-07T02:50:38', 'last-modified': '2025-08-07T02:50:38', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.916650'}
2025-08-07 02:50:39,885 - DEBUG - Control-node 10.0.0.249 : IPAM object is : {'node_name': 'network-ipam:default-domain:ctest-TestPolicyAclIpv4v6-61472176:ipam1', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestPolicyAclIpv4v6-61472176', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6405040338508271512', 'uuid-lslong': '13492897148024797479'}, 'enable': 'true', 'created': '2025-08-07T02:50:38', 'last-modified': '2025-08-07T02:50:38', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.927133'}
2025-08-07 02:50:39,885 - INFO - Verifications in Control node for IPAM: ipam1 passed
2025-08-07 02:50:39,886 - DEBUG - Requesting: http://10.0.0.56:8082/domains
2025-08-07 02:50:39,893 - DEBUG - Requesting: http://10.0.0.56:8082/domain/fb2d80da-9971-40dc-80ca-c5bb54e98569
2025-08-07 02:50:39,911 - DEBUG - Requesting: http://10.0.0.56:8082/project/f38db1a7-18d4-40ec-9dd7-badb3e062bcd
2025-08-07 02:50:40,016 - DEBUG - Requesting: http://10.0.0.56:8082/network-ipam/e40130b2-cd88-4efe-af26-7c1225adb17a
2025-08-07 02:50:40,030 - INFO - Verifications in API Server for IPAM: ipam2 passed
2025-08-07 02:50:40,038 - DEBUG - Control-node 10.0.0.56 : IPAM object is : {'node_name': 'network-ipam:default-domain:ctest-TestPolicyAclIpv4v6-61472176:ipam2', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestPolicyAclIpv4v6-61472176', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16429466460134854398', 'uuid-lslong': '12620911423135789434'}, 'enable': 'true', 'created': '2025-08-07T02:50:39', 'last-modified': '2025-08-07T02:50:39', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.703115'}
2025-08-07 02:50:40,045 - DEBUG - Control-node 10.0.0.130 : IPAM object is : {'node_name': 'network-ipam:default-domain:ctest-TestPolicyAclIpv4v6-61472176:ipam2', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestPolicyAclIpv4v6-61472176', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16429466460134854398', 'uuid-lslong': '12620911423135789434'}, 'enable': 'true', 'created': '2025-08-07T02:50:39', 'last-modified': '2025-08-07T02:50:39', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.710943'}
2025-08-07 02:50:40,052 - DEBUG - Control-node 10.0.0.249 : IPAM object is : {'node_name': 'network-ipam:default-domain:ctest-TestPolicyAclIpv4v6-61472176:ipam2', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestPolicyAclIpv4v6-61472176', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16429466460134854398', 'uuid-lslong': '12620911423135789434'}, 'enable': 'true', 'created': '2025-08-07T02:50:39', 'last-modified': '2025-08-07T02:50:39', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.721456'}
2025-08-07 02:50:40,052 - INFO - Verifications in Control node for IPAM: ipam2 passed
2025-08-07 02:50:40,052 - DEBUG - Requesting: http://10.0.0.56:8082/domains
2025-08-07 02:50:40,059 - DEBUG - Requesting: http://10.0.0.56:8082/domain/fb2d80da-9971-40dc-80ca-c5bb54e98569
2025-08-07 02:50:40,077 - DEBUG - Requesting: http://10.0.0.56:8082/project/f38db1a7-18d4-40ec-9dd7-badb3e062bcd
2025-08-07 02:50:40,189 - DEBUG - Requesting: http://10.0.0.56:8082/network-ipam/36ba7c65-3a91-4264-b383-f34703a10470
2025-08-07 02:50:40,202 - INFO - Verifications in API Server for IPAM: ipam3 passed
2025-08-07 02:50:40,211 - DEBUG - Control-node 10.0.0.56 : IPAM object is : {'node_name': 'network-ipam:default-domain:ctest-TestPolicyAclIpv4v6-61472176:ipam3', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestPolicyAclIpv4v6-61472176', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3943601197932429924', 'uuid-lslong': '12935450041067308144'}, 'enable': 'true', 'created': '2025-08-07T02:50:39', 'last-modified': '2025-08-07T02:50:39', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.518631'}
2025-08-07 02:50:40,219 - DEBUG - Control-node 10.0.0.130 : IPAM object is : {'node_name': 'network-ipam:default-domain:ctest-TestPolicyAclIpv4v6-61472176:ipam3', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestPolicyAclIpv4v6-61472176', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3943601197932429924', 'uuid-lslong': '12935450041067308144'}, 'enable': 'true', 'created': '2025-08-07T02:50:39', 'last-modified': '2025-08-07T02:50:39', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.523167'}
2025-08-07 02:50:40,227 - DEBUG - Control-node 10.0.0.249 : IPAM object is : {'node_name': 'network-ipam:default-domain:ctest-TestPolicyAclIpv4v6-61472176:ipam3', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestPolicyAclIpv4v6-61472176', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3943601197932429924', 'uuid-lslong': '12935450041067308144'}, 'enable': 'true', 'created': '2025-08-07T02:50:39', 'last-modified': '2025-08-07T02:50:39', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.535138'}
2025-08-07 02:50:40,227 - INFO - Verifications in Control node for IPAM: ipam3 passed
2025-08-07 02:50:40,530 - DEBUG - Response for create_network : {'network': {'id': '1c684e70-334e-47f0-ab53-8f49c6cbbe91', 'name': 'ctest-VN1-88151024', 'tenant_id': 'f38db1a718d440ec9dd7badb3e062bcd', 'project_id': 'f38db1a718d440ec9dd7badb3e062bcd', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestPolicyAclIpv4v6-61472176', 'ctest-VN1-88151024'], 'port_security_enabled': True, 'description': ''}}
2025-08-07 02:50:40,856 - DEBUG - Response for create_subnet : {'subnet': {'id': '54a99d77-0286-490b-b210-55db2b33b069', 'name': '', 'tenant_id': 'f38db1a718d440ec9dd7badb3e062bcd', 'network_id': '1c684e70-334e-47f0-ab53-8f49c6cbbe91', 'ip_version': 4, 'cidr': '112.85.52.64/26', 'allocation_pools': [{'start': '112.85.52.66', 'end': '112.85.52.126'}], 'gateway_ip': '112.85.52.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '112.85.52.66', 'tags': [], 'project_id': 'f38db1a718d440ec9dd7badb3e062bcd'}}
2025-08-07 02:50:41,084 - DEBUG - Response for create_subnet : {'subnet': {'id': '262b5f52-27a4-4874-8f78-bf2b61d7df44', 'name': '', 'tenant_id': 'f38db1a718d440ec9dd7badb3e062bcd', 'network_id': '1c684e70-334e-47f0-ab53-8f49c6cbbe91', 'ip_version': 6, 'cidr': '2753:9136:d0ac:2abb:2500:b043::/96', 'allocation_pools': [{'start': '2753:9136:d0ac:2abb:2500:b043:0:2', 'end': '2753:9136:d0ac:2abb:2500:b043:ffff:fffe'}], 'gateway_ip': '2753:9136:d0ac:2abb:2500:b043:0:1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '2753:9136:d0ac:2abb:2500:b043:0:2', 'tags': [], 'project_id': 'f38db1a718d440ec9dd7badb3e062bcd'}}
2025-08-07 02:50:41,119 - INFO - Created VN ctest-VN1-88151024
2025-08-07 02:50:41,138 - DEBUG - VN ctest-VN1-88151024 UUID is 1c684e70-334e-47f0-ab53-8f49c6cbbe91
2025-08-07 02:50:41,366 - DEBUG - Fetched VN: default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN1-88151024(1c684e70-334e-47f0-ab53-8f49c6cbbe91) with subnets ['112.85.52.64/26', '2753:9136:d0ac:2abb:2500:b043::/96']
2025-08-07 02:50:41,736 - DEBUG - Response for create_network : {'network': {'id': 'a2944da6-34ba-449d-a874-9848df028ee9', 'name': 'ctest-VN2-59721803', 'tenant_id': 'f38db1a718d440ec9dd7badb3e062bcd', 'project_id': 'f38db1a718d440ec9dd7badb3e062bcd', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestPolicyAclIpv4v6-61472176', 'ctest-VN2-59721803'], 'port_security_enabled': True, 'description': ''}}
2025-08-07 02:50:42,000 - DEBUG - Response for create_subnet : {'subnet': {'id': '767912fa-e102-4705-8bac-6f43af922598', 'name': '', 'tenant_id': 'f38db1a718d440ec9dd7badb3e062bcd', 'network_id': 'a2944da6-34ba-449d-a874-9848df028ee9', 'ip_version': 4, 'cidr': '208.169.111.0/26', 'allocation_pools': [{'start': '208.169.111.2', 'end': '208.169.111.62'}], 'gateway_ip': '208.169.111.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '208.169.111.2', 'tags': [], 'project_id': 'f38db1a718d440ec9dd7badb3e062bcd'}}
2025-08-07 02:50:42,299 - DEBUG - Response for create_subnet : {'subnet': {'id': 'bf9ef398-b868-4d76-a7ad-07afbfc70b20', 'name': '', 'tenant_id': 'f38db1a718d440ec9dd7badb3e062bcd', 'network_id': 'a2944da6-34ba-449d-a874-9848df028ee9', 'ip_version': 6, 'cidr': '2b75:e8d8:9581:1f78:eca9:c8c1::/96', 'allocation_pools': [{'start': '2b75:e8d8:9581:1f78:eca9:c8c1:0:2', 'end': '2b75:e8d8:9581:1f78:eca9:c8c1:ffff:fffe'}], 'gateway_ip': '2b75:e8d8:9581:1f78:eca9:c8c1:0:1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '2b75:e8d8:9581:1f78:eca9:c8c1:0:2', 'tags': [], 'project_id': 'f38db1a718d440ec9dd7badb3e062bcd'}}
2025-08-07 02:50:42,339 - INFO - Created VN ctest-VN2-59721803
2025-08-07 02:50:42,360 - DEBUG - VN ctest-VN2-59721803 UUID is a2944da6-34ba-449d-a874-9848df028ee9
2025-08-07 02:50:42,834 - DEBUG - Response for create_network : {'network': {'id': 'dfa453fe-f508-4a67-a618-42f58fd6bef7', 'name': 'ctest-VN3-44948594', 'tenant_id': 'f38db1a718d440ec9dd7badb3e062bcd', 'project_id': 'f38db1a718d440ec9dd7badb3e062bcd', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestPolicyAclIpv4v6-61472176', 'ctest-VN3-44948594'], 'port_security_enabled': True, 'description': ''}}
2025-08-07 02:50:43,148 - DEBUG - Response for create_subnet : {'subnet': {'id': '80a8a465-40b4-4aff-896b-adac486d25a4', 'name': '', 'tenant_id': 'f38db1a718d440ec9dd7badb3e062bcd', 'network_id': 'dfa453fe-f508-4a67-a618-42f58fd6bef7', 'ip_version': 4, 'cidr': '111.218.193.64/26', 'allocation_pools': [{'start': '111.218.193.66', 'end': '111.218.193.126'}], 'gateway_ip': '111.218.193.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '111.218.193.66', 'tags': [], 'project_id': 'f38db1a718d440ec9dd7badb3e062bcd'}}
2025-08-07 02:50:43,403 - DEBUG - Response for create_subnet : {'subnet': {'id': 'c5b2e527-d877-40a9-a04b-531fd0450984', 'name': '', 'tenant_id': 'f38db1a718d440ec9dd7badb3e062bcd', 'network_id': 'dfa453fe-f508-4a67-a618-42f58fd6bef7', 'ip_version': 6, 'cidr': '3857:c502:1c9:674a:b38c:21ae::/96', 'allocation_pools': [{'start': '3857:c502:1c9:674a:b38c:21ae:0:2', 'end': '3857:c502:1c9:674a:b38c:21ae:ffff:fffe'}], 'gateway_ip': '3857:c502:1c9:674a:b38c:21ae:0:1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '3857:c502:1c9:674a:b38c:21ae:0:2', 'tags': [], 'project_id': 'f38db1a718d440ec9dd7badb3e062bcd'}}
2025-08-07 02:50:43,436 - INFO - Created VN ctest-VN3-44948594
2025-08-07 02:50:43,453 - DEBUG - VN ctest-VN3-44948594 UUID is dfa453fe-f508-4a67-a618-42f58fd6bef7
2025-08-07 02:50:43,575 - DEBUG - Requesting: http://10.0.0.56:8082/domains
2025-08-07 02:50:43,583 - DEBUG - Requesting: http://10.0.0.56:8082/domain/fb2d80da-9971-40dc-80ca-c5bb54e98569
2025-08-07 02:50:43,604 - DEBUG - Requesting: http://10.0.0.56:8082/project/f38db1a7-18d4-40ec-9dd7-badb3e062bcd
2025-08-07 02:50:43,698 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-network/1c684e70-334e-47f0-ab53-8f49c6cbbe91
2025-08-07 02:50:43,722 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-network/1c684e70-334e-47f0-ab53-8f49c6cbbe91
2025-08-07 02:50:43,737 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/f4d13a74-3a36-43ff-8c30-8da7c51b0541
2025-08-07 02:50:43,748 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/f4d13a74-3a36-43ff-8c30-8da7c51b0541
2025-08-07 02:50:43,757 - DEBUG - Requesting: http://10.0.0.56:8082/route-target/9c0258eb-a253-4c64-a06e-bb9f86f01eee
2025-08-07 02:50:43,767 - DEBUG - Route Targets: ['target:64512:8000005']
2025-08-07 02:50:43,767 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-network/1c684e70-334e-47f0-ab53-8f49c6cbbe91
2025-08-07 02:50:43,781 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/f4d13a74-3a36-43ff-8c30-8da7c51b0541
2025-08-07 02:50:43,800 - INFO - Verified VN network id 12 for VN 1c684e70-334e-47f0-ab53-8f49c6cbbe91
2025-08-07 02:50:43,801 - INFO - Verifications in API Server for VN ctest-VN1-88151024 passed
2025-08-07 02:50:43,801 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-network/1c684e70-334e-47f0-ab53-8f49c6cbbe91
2025-08-07 02:50:43,818 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/f4d13a74-3a36-43ff-8c30-8da7c51b0541
2025-08-07 02:50:43,827 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/f4d13a74-3a36-43ff-8c30-8da7c51b0541
2025-08-07 02:50:43,837 - DEBUG - Requesting: http://10.0.0.56:8082/route-target/9c0258eb-a253-4c64-a06e-bb9f86f01eee
2025-08-07 02:50:43,851 - DEBUG - Control-node 10.0.0.56 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN1-88151024', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestPolicyAclIpv4v6-61472176', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2046972274443962352', 'uuid-lslong': '12345368550583287441'}, 'enable': 'true', 'created': '2025-08-07T02:50:40', 'last-modified': '2025-08-07T02:50:40', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:02.835675'}
2025-08-07 02:50:43,859 - DEBUG - Route Targets: ['target:64512:8000005']
2025-08-07 02:50:43,872 - DEBUG - Control-node 10.0.0.130 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN1-88151024', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestPolicyAclIpv4v6-61472176', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2046972274443962352', 'uuid-lslong': '12345368550583287441'}, 'enable': 'true', 'created': '2025-08-07T02:50:40', 'last-modified': '2025-08-07T02:50:40', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:02.850961'}
2025-08-07 02:50:43,883 - DEBUG - Route Targets: ['target:64512:8000005']
2025-08-07 02:50:43,890 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN1-88151024', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestPolicyAclIpv4v6-61472176', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2046972274443962352', 'uuid-lslong': '12345368550583287441'}, 'enable': 'true', 'created': '2025-08-07T02:50:40', 'last-modified': '2025-08-07T02:50:40', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:02.885661'}
2025-08-07 02:50:43,898 - DEBUG - Route Targets: ['target:64512:8000005']
2025-08-07 02:50:43,898 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-VN1-88151024 passed
2025-08-07 02:50:43,898 - DEBUG - ====Verifying policy data for ctest-VN1-88151024 in API_Server ======
2025-08-07 02:50:43,898 - DEBUG - Requesting: http://10.0.0.56:8082/domains
2025-08-07 02:50:43,911 - DEBUG - Requesting: http://10.0.0.56:8082/domain/fb2d80da-9971-40dc-80ca-c5bb54e98569
2025-08-07 02:50:43,926 - DEBUG - Requesting: http://10.0.0.56:8082/project/f38db1a7-18d4-40ec-9dd7-badb3e062bcd
2025-08-07 02:50:44,047 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-network/1c684e70-334e-47f0-ab53-8f49c6cbbe91
2025-08-07 02:50:44,072 - DEBUG - =>VN ctest-VN1-88151024 has no policy to be verified
2025-08-07 02:50:44,072 - DEBUG - Verifying the vn in opserver
2025-08-07 02:50:44,073 - DEBUG - Verifying the default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN1-88151024 virtual network link through opserver 10.0.0.56
2025-08-07 02:50:44,073 - DEBUG - Requesting: http://10.0.0.56:8081/analytics/uves/virtual-networks
2025-08-07 02:50:44,091 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN1-88151024', 'href': 'http://10.0.0.56:8081/analytics/uves/virtual-network/default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN1-88151024?flat'}
2025-08-07 02:50:44,092 - DEBUG - Verifying the default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN1-88151024 virtual network link through opserver 10.0.0.130
2025-08-07 02:50:44,092 - DEBUG - Requesting: http://10.0.0.130:8081/analytics/uves/virtual-networks
2025-08-07 02:50:44,109 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN1-88151024', 'href': 'http://10.0.0.130:8081/analytics/uves/virtual-network/default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN1-88151024?flat'}
2025-08-07 02:50:44,110 - DEBUG - Verifying the default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN1-88151024 virtual network link through opserver 10.0.0.249
2025-08-07 02:50:44,110 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2025-08-07 02:50:44,128 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN1-88151024', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN1-88151024?flat'}
2025-08-07 02:50:44,128 - INFO - Validated that VN default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN1-88151024 is found in opserver
2025-08-07 02:50:44,155 - DEBUG - Do not have enough data to verify VN in agent
2025-08-07 02:50:44,168 - DEBUG - VRF ids for VN ctest-VN1-88151024: {}
2025-08-07 02:50:44,168 - DEBUG - Requesting: http://10.0.0.56:8082/domains
2025-08-07 02:50:44,177 - DEBUG - Requesting: http://10.0.0.56:8082/domain/fb2d80da-9971-40dc-80ca-c5bb54e98569
2025-08-07 02:50:44,195 - DEBUG - Requesting: http://10.0.0.56:8082/project/f38db1a7-18d4-40ec-9dd7-badb3e062bcd
2025-08-07 02:50:44,305 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-network/a2944da6-34ba-449d-a874-9848df028ee9
2025-08-07 02:50:44,320 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-network/a2944da6-34ba-449d-a874-9848df028ee9
2025-08-07 02:50:44,332 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/7e15b258-e077-4ea9-b012-082009bb8ef2
2025-08-07 02:50:44,341 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/7e15b258-e077-4ea9-b012-082009bb8ef2
2025-08-07 02:50:44,351 - DEBUG - Requesting: http://10.0.0.56:8082/route-target/0d42f52c-5406-485c-a201-53124c9e8c9f
2025-08-07 02:50:44,359 - DEBUG - Route Targets: ['target:64512:8000006']
2025-08-07 02:50:44,359 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-network/a2944da6-34ba-449d-a874-9848df028ee9
2025-08-07 02:50:44,370 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/7e15b258-e077-4ea9-b012-082009bb8ef2
2025-08-07 02:50:44,390 - INFO - Verified VN network id 13 for VN a2944da6-34ba-449d-a874-9848df028ee9
2025-08-07 02:50:44,390 - INFO - Verifications in API Server for VN ctest-VN2-59721803 passed
2025-08-07 02:50:44,390 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-network/a2944da6-34ba-449d-a874-9848df028ee9
2025-08-07 02:50:44,404 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/7e15b258-e077-4ea9-b012-082009bb8ef2
2025-08-07 02:50:44,412 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/7e15b258-e077-4ea9-b012-082009bb8ef2
2025-08-07 02:50:44,421 - DEBUG - Requesting: http://10.0.0.56:8082/route-target/0d42f52c-5406-485c-a201-53124c9e8c9f
2025-08-07 02:50:44,439 - DEBUG - Control-node 10.0.0.56 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN2-59721803', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestPolicyAclIpv4v6-61472176', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11715073906942035101', 'uuid-lslong': '12138494334416883433'}, 'enable': 'true', 'created': '2025-08-07T02:50:41', 'last-modified': '2025-08-07T02:50:42', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:02.220257'}
2025-08-07 02:50:44,451 - DEBUG - Route Targets: ['target:64512:8000006']
2025-08-07 02:50:44,459 - DEBUG - Control-node 10.0.0.130 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN2-59721803', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestPolicyAclIpv4v6-61472176', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11715073906942035101', 'uuid-lslong': '12138494334416883433'}, 'enable': 'true', 'created': '2025-08-07T02:50:41', 'last-modified': '2025-08-07T02:50:42', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:02.241294'}
2025-08-07 02:50:44,467 - DEBUG - Route Targets: ['target:64512:8000006']
2025-08-07 02:50:44,474 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN2-59721803', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestPolicyAclIpv4v6-61472176', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11715073906942035101', 'uuid-lslong': '12138494334416883433'}, 'enable': 'true', 'created': '2025-08-07T02:50:41', 'last-modified': '2025-08-07T02:50:42', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:02.235030'}
2025-08-07 02:50:44,482 - DEBUG - Route Targets: ['target:64512:8000006']
2025-08-07 02:50:44,483 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-VN2-59721803 passed
2025-08-07 02:50:44,483 - DEBUG - ====Verifying policy data for ctest-VN2-59721803 in API_Server ======
2025-08-07 02:50:44,483 - DEBUG - Requesting: http://10.0.0.56:8082/domains
2025-08-07 02:50:44,491 - DEBUG - Requesting: http://10.0.0.56:8082/domain/fb2d80da-9971-40dc-80ca-c5bb54e98569
2025-08-07 02:50:44,507 - DEBUG - Requesting: http://10.0.0.56:8082/project/f38db1a7-18d4-40ec-9dd7-badb3e062bcd
2025-08-07 02:50:44,613 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-network/a2944da6-34ba-449d-a874-9848df028ee9
2025-08-07 02:50:44,628 - DEBUG - =>VN ctest-VN2-59721803 has no policy to be verified
2025-08-07 02:50:44,628 - DEBUG - Verifying the vn in opserver
2025-08-07 02:50:44,628 - DEBUG - Verifying the default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN2-59721803 virtual network link through opserver 10.0.0.56
2025-08-07 02:50:44,628 - DEBUG - Requesting: http://10.0.0.56:8081/analytics/uves/virtual-networks
2025-08-07 02:50:44,642 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN2-59721803', 'href': 'http://10.0.0.56:8081/analytics/uves/virtual-network/default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN2-59721803?flat'}
2025-08-07 02:50:44,642 - DEBUG - Verifying the default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN2-59721803 virtual network link through opserver 10.0.0.130
2025-08-07 02:50:44,642 - DEBUG - Requesting: http://10.0.0.130:8081/analytics/uves/virtual-networks
2025-08-07 02:50:44,659 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN2-59721803', 'href': 'http://10.0.0.130:8081/analytics/uves/virtual-network/default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN2-59721803?flat'}
2025-08-07 02:50:44,659 - DEBUG - Verifying the default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN2-59721803 virtual network link through opserver 10.0.0.249
2025-08-07 02:50:44,659 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2025-08-07 02:50:44,675 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN2-59721803', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN2-59721803?flat'}
2025-08-07 02:50:44,675 - INFO - Validated that VN default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN2-59721803 is found in opserver
2025-08-07 02:50:44,706 - DEBUG - Do not have enough data to verify VN in agent
2025-08-07 02:50:44,720 - DEBUG - VRF ids for VN ctest-VN2-59721803: {}
2025-08-07 02:50:44,720 - DEBUG - Requesting: http://10.0.0.56:8082/domains
2025-08-07 02:50:44,730 - DEBUG - Requesting: http://10.0.0.56:8082/domain/fb2d80da-9971-40dc-80ca-c5bb54e98569
2025-08-07 02:50:44,746 - DEBUG - Requesting: http://10.0.0.56:8082/project/f38db1a7-18d4-40ec-9dd7-badb3e062bcd
2025-08-07 02:50:44,850 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-network/dfa453fe-f508-4a67-a618-42f58fd6bef7
2025-08-07 02:50:44,868 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-network/dfa453fe-f508-4a67-a618-42f58fd6bef7
2025-08-07 02:50:44,883 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/005040b0-f419-46a1-b7cc-64cf65abb913
2025-08-07 02:50:44,901 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/005040b0-f419-46a1-b7cc-64cf65abb913
2025-08-07 02:50:44,913 - DEBUG - Requesting: http://10.0.0.56:8082/route-target/51b695f7-cc4f-4df3-bb8d-e0ac9b260917
2025-08-07 02:50:44,925 - DEBUG - Route Targets: ['target:64512:8000007']
2025-08-07 02:50:44,925 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-network/dfa453fe-f508-4a67-a618-42f58fd6bef7
2025-08-07 02:50:44,938 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/005040b0-f419-46a1-b7cc-64cf65abb913
2025-08-07 02:50:44,961 - INFO - Verified VN network id 14 for VN dfa453fe-f508-4a67-a618-42f58fd6bef7
2025-08-07 02:50:44,961 - INFO - Verifications in API Server for VN ctest-VN3-44948594 passed
2025-08-07 02:50:44,961 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-network/dfa453fe-f508-4a67-a618-42f58fd6bef7
2025-08-07 02:50:44,979 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/005040b0-f419-46a1-b7cc-64cf65abb913
2025-08-07 02:50:44,988 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/005040b0-f419-46a1-b7cc-64cf65abb913
2025-08-07 02:50:44,998 - DEBUG - Requesting: http://10.0.0.56:8082/route-target/51b695f7-cc4f-4df3-bb8d-e0ac9b260917
2025-08-07 02:50:45,019 - DEBUG - Control-node 10.0.0.56 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN3-44948594', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestPolicyAclIpv4v6-61472176', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16115097721136237159', 'uuid-lslong': '11968389632184729335'}, 'enable': 'true', 'created': '2025-08-07T02:50:42', 'last-modified': '2025-08-07T02:50:43', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.686289'}
2025-08-07 02:50:45,028 - DEBUG - Route Targets: ['target:64512:8000007']
2025-08-07 02:50:45,035 - DEBUG - Control-node 10.0.0.130 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN3-44948594', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestPolicyAclIpv4v6-61472176', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16115097721136237159', 'uuid-lslong': '11968389632184729335'}, 'enable': 'true', 'created': '2025-08-07T02:50:42', 'last-modified': '2025-08-07T02:50:43', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.709175'}
2025-08-07 02:50:45,043 - DEBUG - Route Targets: ['target:64512:8000007']
2025-08-07 02:50:45,051 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN3-44948594', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestPolicyAclIpv4v6-61472176', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16115097721136237159', 'uuid-lslong': '11968389632184729335'}, 'enable': 'true', 'created': '2025-08-07T02:50:42', 'last-modified': '2025-08-07T02:50:43', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.721726'}
2025-08-07 02:50:45,058 - DEBUG - Route Targets: ['target:64512:8000007']
2025-08-07 02:50:45,058 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-VN3-44948594 passed
2025-08-07 02:50:45,058 - DEBUG - ====Verifying policy data for ctest-VN3-44948594 in API_Server ======
2025-08-07 02:50:45,059 - DEBUG - Requesting: http://10.0.0.56:8082/domains
2025-08-07 02:50:45,065 - DEBUG - Requesting: http://10.0.0.56:8082/domain/fb2d80da-9971-40dc-80ca-c5bb54e98569
2025-08-07 02:50:45,083 - DEBUG - Requesting: http://10.0.0.56:8082/project/f38db1a7-18d4-40ec-9dd7-badb3e062bcd
2025-08-07 02:50:45,186 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-network/dfa453fe-f508-4a67-a618-42f58fd6bef7
2025-08-07 02:50:45,200 - DEBUG - =>VN ctest-VN3-44948594 has no policy to be verified
2025-08-07 02:50:45,200 - DEBUG - Verifying the vn in opserver
2025-08-07 02:50:45,200 - DEBUG - Verifying the default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN3-44948594 virtual network link through opserver 10.0.0.56
2025-08-07 02:50:45,200 - DEBUG - Requesting: http://10.0.0.56:8081/analytics/uves/virtual-networks
2025-08-07 02:50:45,216 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN3-44948594', 'href': 'http://10.0.0.56:8081/analytics/uves/virtual-network/default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN3-44948594?flat'}
2025-08-07 02:50:45,216 - DEBUG - Verifying the default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN3-44948594 virtual network link through opserver 10.0.0.130
2025-08-07 02:50:45,216 - DEBUG - Requesting: http://10.0.0.130:8081/analytics/uves/virtual-networks
2025-08-07 02:50:45,232 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN3-44948594', 'href': 'http://10.0.0.130:8081/analytics/uves/virtual-network/default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN3-44948594?flat'}
2025-08-07 02:50:45,233 - DEBUG - Verifying the default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN3-44948594 virtual network link through opserver 10.0.0.249
2025-08-07 02:50:45,233 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2025-08-07 02:50:45,250 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN3-44948594', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN3-44948594?flat'}
2025-08-07 02:50:45,250 - INFO - Validated that VN default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN3-44948594 is found in opserver
2025-08-07 02:50:45,279 - DEBUG - Do not have enough data to verify VN in agent
2025-08-07 02:50:45,294 - DEBUG - VRF ids for VN ctest-VN3-44948594: {}
2025-08-07 02:50:45,302 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = any, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN1-88151024, 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-TestPolicyAclIpv4v6-61472176:ctest-VN3-44948594, 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-07 02:50:45,578 - DEBUG - No source network defined
2025-08-07 02:50:45,578 - DEBUG - No source network defined
2025-08-07 02:50:45,578 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = icmp, src_addresses = [subnet = None, virtual_network = None, security_group = None, network_policy = default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-policy13-25271894, subnet_list = []], src_ports = [start_port = -1, end_port = -1], application = [], dst_addresses = [subnet = None, virtual_network = any, 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 = None, security_group = None, network_policy = default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-policy13-25271894, subnet_list = []], src_ports = [start_port = -1, end_port = -1], application = [], dst_addresses = [subnet = None, virtual_network = any, 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-07 02:50:45,898 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = icmp, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestPolicyAclIpv4v6-61472176:ctest-VN2-59721803, 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-TestPolicyAclIpv4v6-61472176:ctest-VN1-88151024, 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-TestPolicyAclIpv4v6-61472176:ctest-VN2-59721803, 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-TestPolicyAclIpv4v6-61472176:ctest-VN1-88151024, 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-07 02:50:46,150 - DEBUG - Requesting: http://10.0.0.56:8082/domains
2025-08-07 02:50:46,158 - DEBUG - Requesting: http://10.0.0.56:8082/domain/fb2d80da-9971-40dc-80ca-c5bb54e98569
2025-08-07 02:50:46,172 - DEBUG - Requesting: http://10.0.0.56:8082/project/f38db1a7-18d4-40ec-9dd7-badb3e062bcd
2025-08-07 02:50:46,298 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-network/1c684e70-334e-47f0-ab53-8f49c6cbbe91
2025-08-07 02:50:46,311 - DEBUG - Setup step: Associating the policy to VN'
2025-08-07 02:50:46,450 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': '1c684e70-334e-47f0-ab53-8f49c6cbbe91', 'name': 'ctest-VN1-88151024', 'tenant_id': 'f38db1a718d440ec9dd7badb3e062bcd', 'project_id': 'f38db1a718d440ec9dd7badb3e062bcd', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['54a99d77-0286-490b-b210-55db2b33b069', '262b5f52-27a4-4874-8f78-bf2b61d7df44'], 'fq_name': ['default-domain', 'ctest-TestPolicyAclIpv4v6-61472176', 'ctest-VN1-88151024'], 'policys': [['default-domain', 'ctest-TestPolicyAclIpv4v6-61472176', 'ctest-policy12-75247377'], ['default-domain', 'ctest-TestPolicyAclIpv4v6-61472176', 'ctest-policy13-25271894']], 'subnet_ipam': [{'subnet_cidr': '112.85.52.64/26', 'ipam_fq_name': ['default-domain', 'ctest-TestPolicyAclIpv4v6-61472176', 'ipam1']}, {'subnet_cidr': '2753:9136:d0ac:2abb:2500:b043::/96', 'ipam_fq_name': ['default-domain', 'ctest-TestPolicyAclIpv4v6-61472176', 'ipam1']}], 'port_security_enabled': True, 'description': ''}}
2025-08-07 02:50:46,639 - DEBUG - Associated Policy:[['default-domain', 'ctest-TestPolicyAclIpv4v6-61472176', 'ctest-policy12-75247377'], ['default-domain', 'ctest-TestPolicyAclIpv4v6-61472176', 'ctest-policy13-25271894']] to ctest-VN1-88151024
2025-08-07 02:50:46,639 - DEBUG - Requesting: http://10.0.0.56:8082/domains
2025-08-07 02:50:46,647 - DEBUG - Requesting: http://10.0.0.56:8082/domain/fb2d80da-9971-40dc-80ca-c5bb54e98569
2025-08-07 02:50:46,660 - DEBUG - Requesting: http://10.0.0.56:8082/project/f38db1a7-18d4-40ec-9dd7-badb3e062bcd
2025-08-07 02:50:46,763 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-network/a2944da6-34ba-449d-a874-9848df028ee9
2025-08-07 02:50:46,775 - DEBUG - Setup step: Associating the policy to VN'
2025-08-07 02:50:46,920 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': 'a2944da6-34ba-449d-a874-9848df028ee9', 'name': 'ctest-VN2-59721803', 'tenant_id': 'f38db1a718d440ec9dd7badb3e062bcd', 'project_id': 'f38db1a718d440ec9dd7badb3e062bcd', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['767912fa-e102-4705-8bac-6f43af922598', 'bf9ef398-b868-4d76-a7ad-07afbfc70b20'], 'fq_name': ['default-domain', 'ctest-TestPolicyAclIpv4v6-61472176', 'ctest-VN2-59721803'], 'policys': [['default-domain', 'ctest-TestPolicyAclIpv4v6-61472176', 'ctest-policy21-81187064']], 'subnet_ipam': [{'subnet_cidr': '208.169.111.0/26', 'ipam_fq_name': ['default-domain', 'ctest-TestPolicyAclIpv4v6-61472176', 'ipam2']}, {'subnet_cidr': '2b75:e8d8:9581:1f78:eca9:c8c1::/96', 'ipam_fq_name': ['default-domain', 'ctest-TestPolicyAclIpv4v6-61472176', 'ipam2']}], 'port_security_enabled': True, 'description': ''}}
2025-08-07 02:50:47,035 - DEBUG - Associated Policy:[['default-domain', 'ctest-TestPolicyAclIpv4v6-61472176', 'ctest-policy21-81187064']] to ctest-VN2-59721803
2025-08-07 02:50:47,144 - DEBUG - Image by name ubuntu not found
2025-08-07 02:50:47,144 - DEBUG - Installing image ubuntu
2025-08-07 02:50:47,144 - DEBUG - Image info {'name': 'ubuntu.vmdk.gz', 'webserver': '', 'location': '/images/converts/', 'username': 'ubuntu', 'password': 'ubuntu', 'type': 'os', 'flavor': 'contrail_flavor_tiny', 'params': '--container-format bare --disk-format vmdk --property vmware_disktype="sparse" --property vmware_adaptertype="ide" --property hw_scsi_model=virtio-scsi --property hw_disk_bus_model=virtio-scsi --property hw_disk_bus=virtio', 'name_docker': 'phusion-baseimage-enablesshd'}
2025-08-07 02:50:47,145 - DEBUG - Image build path file:///contrail-test/images/ubuntu.vmdk.gz
2025-08-07 02:50:47,145 - DEBUG - Download image from local file file:///contrail-test/images/ubuntu.vmdk.gz
2025-08-07 02:50:47,145 - DEBUG - Unzip image
2025-08-07 02:50:47,145 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/ubuntu.vmdk.gz
2025-08-07 02:50:47,164 - INFO - image /contrail-test/images/ubuntu.vmdk is not found
2025-08-07 02:50:47,166 - DEBUG - Detaching the Policy for VN :ctest-VN2-59721803
2025-08-07 02:50:47,166 - DEBUG - Requesting: http://10.0.0.56:8082/domains
2025-08-07 02:50:47,175 - DEBUG - Requesting: http://10.0.0.56:8082/domain/fb2d80da-9971-40dc-80ca-c5bb54e98569
2025-08-07 02:50:47,192 - DEBUG - Requesting: http://10.0.0.56:8082/project/f38db1a7-18d4-40ec-9dd7-badb3e062bcd
2025-08-07 02:50:47,298 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-network/a2944da6-34ba-449d-a874-9848df028ee9
2025-08-07 02:50:47,331 - DEBUG - Requesting: http://10.0.0.56:8082/network-policy/f39d6acc-2619-4a54-ab4b-3add997c16ff
2025-08-07 02:50:47,631 - DEBUG - Detached Policy:[['default-domain', 'ctest-TestPolicyAclIpv4v6-61472176', 'ctest-policy21-81187064']] from ctest-VN2-59721803
2025-08-07 02:50:47,632 - DEBUG - Detaching the Policy for VN :ctest-VN1-88151024
2025-08-07 02:50:47,632 - DEBUG - Requesting: http://10.0.0.56:8082/domains
2025-08-07 02:50:47,648 - DEBUG - Requesting: http://10.0.0.56:8082/domain/fb2d80da-9971-40dc-80ca-c5bb54e98569
2025-08-07 02:50:47,672 - DEBUG - Requesting: http://10.0.0.56:8082/project/f38db1a7-18d4-40ec-9dd7-badb3e062bcd
2025-08-07 02:50:47,823 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-network/1c684e70-334e-47f0-ab53-8f49c6cbbe91
2025-08-07 02:50:47,849 - DEBUG - Requesting: http://10.0.0.56:8082/network-policy/24b23523-7beb-40f3-b0dc-324a47cf6e0c
2025-08-07 02:50:47,869 - DEBUG - Requesting: http://10.0.0.56:8082/network-policy/b87c5263-9d92-4988-92c0-137d3b749167
2025-08-07 02:50:48,102 - DEBUG - Detached Policy:[['default-domain', 'ctest-TestPolicyAclIpv4v6-61472176', 'ctest-policy12-75247377'], ['default-domain', 'ctest-TestPolicyAclIpv4v6-61472176', 'ctest-policy13-25271894']] from ctest-VN1-88151024
2025-08-07 02:50:48,169 - INFO - Deleted policy ctest-policy21-81187064
2025-08-07 02:50:48,250 - INFO - Deleted policy ctest-policy12-75247377
2025-08-07 02:50:48,300 - INFO - Deleted policy ctest-policy13-25271894
2025-08-07 02:50:48,301 - INFO - Deleting VN ctest-VN3-44948594
2025-08-07 02:50:48,547 - DEBUG - Response for deleting network ()
2025-08-07 02:50:48,547 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/005040b0-f419-46a1-b7cc-64cf65abb913
2025-08-07 02:50:48,554 - DEBUG - Response Code: 404
2025-08-07 02:50:48,554 - DEBUG - Requesting: http://10.0.0.56:8082/domains
2025-08-07 02:50:48,561 - DEBUG - Requesting: http://10.0.0.56:8082/domain/fb2d80da-9971-40dc-80ca-c5bb54e98569
2025-08-07 02:50:48,585 - DEBUG - Requesting: http://10.0.0.56:8082/project/f38db1a7-18d4-40ec-9dd7-badb3e062bcd
2025-08-07 02:50:48,685 - INFO - Validated that VN ctest-VN3-44948594 is not found in API Server
2025-08-07 02:50:48,702 - DEBUG - VN ctest-VN3-44948594 is not present in Agent 10.0.0.41
2025-08-07 02:50:48,714 - DEBUG - VN ctest-VN3-44948594 is not present in Agent 10.0.0.61
2025-08-07 02:50:48,714 - INFO - Validated that VN ctest-VN3-44948594 is not in any agent
2025-08-07 02:50:48,756 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-VN3-44948594 info
2025-08-07 02:50:48,756 - INFO - Deleting VN ctest-VN2-59721803
2025-08-07 02:50:48,979 - DEBUG - Response for deleting network ()
2025-08-07 02:50:48,979 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/7e15b258-e077-4ea9-b012-082009bb8ef2
2025-08-07 02:50:48,987 - DEBUG - Response Code: 404
2025-08-07 02:50:48,987 - DEBUG - Requesting: http://10.0.0.56:8082/domains
2025-08-07 02:50:48,996 - DEBUG - Requesting: http://10.0.0.56:8082/domain/fb2d80da-9971-40dc-80ca-c5bb54e98569
2025-08-07 02:50:49,053 - DEBUG - Requesting: http://10.0.0.56:8082/project/f38db1a7-18d4-40ec-9dd7-badb3e062bcd
2025-08-07 02:50:49,155 - INFO - Validated that VN ctest-VN2-59721803 is not found in API Server
2025-08-07 02:50:49,171 - DEBUG - VN ctest-VN2-59721803 is not present in Agent 10.0.0.41
2025-08-07 02:50:49,184 - DEBUG - VN ctest-VN2-59721803 is not present in Agent 10.0.0.61
2025-08-07 02:50:49,184 - INFO - Validated that VN ctest-VN2-59721803 is not in any agent
2025-08-07 02:50:49,226 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-VN2-59721803 info
2025-08-07 02:50:49,227 - INFO - Deleting VN ctest-VN1-88151024
2025-08-07 02:50:49,440 - DEBUG - Response for deleting network ()
2025-08-07 02:50:49,440 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/f4d13a74-3a36-43ff-8c30-8da7c51b0541
2025-08-07 02:50:49,455 - DEBUG - Response Code: 404
2025-08-07 02:50:49,455 - DEBUG - Requesting: http://10.0.0.56:8082/domains
2025-08-07 02:50:49,464 - DEBUG - Requesting: http://10.0.0.56:8082/domain/fb2d80da-9971-40dc-80ca-c5bb54e98569
2025-08-07 02:50:49,487 - DEBUG - Requesting: http://10.0.0.56:8082/project/f38db1a7-18d4-40ec-9dd7-badb3e062bcd
2025-08-07 02:50:49,599 - INFO - Validated that VN ctest-VN1-88151024 is not found in API Server
2025-08-07 02:50:49,615 - DEBUG - VN ctest-VN1-88151024 is not present in Agent 10.0.0.41
2025-08-07 02:50:49,631 - DEBUG - VN ctest-VN1-88151024 is not present in Agent 10.0.0.61
2025-08-07 02:50:49,631 - INFO - Validated that VN ctest-VN1-88151024 is not in any agent
2025-08-07 02:50:49,672 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-VN1-88151024 info
2025-08-07 02:50:49,786 - INFO - IPAM: ipam3 is not found in API Server
2025-08-07 02:50:49,818 - INFO - IPAM:ipam3 is not found in control node
2025-08-07 02:50:49,966 - INFO - IPAM: ipam2 is not found in API Server
2025-08-07 02:50:50,005 - INFO - IPAM:ipam2 is not found in control node
2025-08-07 02:50:50,114 - INFO - IPAM: ipam1 is not found in API Server
2025-08-07 02:50:50,148 - INFO - IPAM:ipam1 is not found in control node
2025-08-07 02:50:51,444 - DEBUG - No XMPP flaps were noticed during the test
2025-08-07 02:50:51,445 - INFO -
2025-08-07 02:50:51,445 - INFO - END TEST : test_policy_inheritance_src_pol_dst_any : SKIPPED[0:00:14]
2025-08-07 02:50:51,445 - INFO - --------------------------------------------------------------------------------
2025-08-07 02:50:51,445 - INFO - image /contrail-test/images/ubuntu.vmdk is not found
2025-08-07 02:50:52,736 - DEBUG - No XMPP flaps were noticed during the test
2025-08-07 02:50:52,736 - INFO -
2025-08-07 02:50:52,737 - INFO - END TEST : test_policy_inheritance_src_pol_dst_any : SKIPPED[0:00:16]
2025-08-07 02:50:52,737 - INFO - --------------------------------------------------------------------------------
2025-08-07 02:50:53,505 - INFO - Deleted project: ctest-TestPolicyAclIpv4v6-61472176, ID : f38db1a7-18d4-40ec-9dd7-badb3e062bcd