2026-05-27 16:51:30,015 - INFO - Domain Default found not creating 2026-05-27 16:51:30,202 - INFO - Project ctest-TestDetailedPolicy1Ipv4v6-87114749 not found, creating it 2026-05-27 16:51:30,826 - INFO - Created Project:ctest-TestDetailedPolicy1Ipv4v6-87114749, ID : 552f6fc8-eb73-4d0a-b47d-ad0f2b09e833 2026-05-27 16:51:32,399 - INFO - ================================================================================ 2026-05-27 16:51:32,399 - INFO - STARTING TEST : test_multi_vn_repeated_policy_update_with_ping 2026-05-27 16:51:32,399 - INFO - TEST DESCRIPTION : Call repeated_policy_update_test_with_ping with multi VN scenario. 2026-05-27 16:51:33,688 - DEBUG - Nothing to compare xmpp stats {'10.0.0.241': {'10.20.0.254': '0', '10.20.0.25': '0'}, '10.0.0.242': {'10.20.0.254': '0', '10.20.0.25': '0'}} with 2026-05-27 16:51:33,688 - INFO - Initial checks done. Running the testcase now 2026-05-27 16:51:33,688 - INFO - 2026-05-27 16:51:33,688 - INFO - Scenario for the test used is: 2026-05-27 16:51:33,688 - DEBUG - Starting setup 2026-05-27 16:51:34,507 - INFO - Using existing project ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-87114749'](552f6fc8-eb73-4d0a-b47d-ad0f2b09e833) 2026-05-27 16:51:34,507 - INFO - provision user admin with role as admin in tenant ctest-TestDetailedPolicy1Ipv4v6-87114749 2026-05-27 16:51:35,731 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-05-27 16:51:36,088 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-05-27 16:51:36,165 - DEBUG - Requesting: http://10.0.0.50:8082/domain/dd011215-fca5-4e74-b1da-d431e9fe9325 2026-05-27 16:51:36,187 - DEBUG - Requesting: http://10.0.0.50:8082/project/552f6fc8-eb73-4d0a-b47d-ad0f2b09e833 2026-05-27 16:51:36,305 - DEBUG - Requesting: http://10.0.0.22:8082/domains 2026-05-27 16:51:36,608 - DEBUG - Requesting: http://10.0.0.22:8082/domains 2026-05-27 16:51:36,650 - DEBUG - Requesting: http://10.0.0.22:8082/domain/dd011215-fca5-4e74-b1da-d431e9fe9325 2026-05-27 16:51:36,674 - DEBUG - Requesting: http://10.0.0.22:8082/project/552f6fc8-eb73-4d0a-b47d-ad0f2b09e833 2026-05-27 16:51:36,771 - DEBUG - Requesting: http://10.0.0.129:8082/domains 2026-05-27 16:51:37,084 - DEBUG - Requesting: http://10.0.0.129:8082/domains 2026-05-27 16:51:37,122 - DEBUG - Requesting: http://10.0.0.129:8082/domain/dd011215-fca5-4e74-b1da-d431e9fe9325 2026-05-27 16:51:37,141 - DEBUG - Requesting: http://10.0.0.129:8082/project/552f6fc8-eb73-4d0a-b47d-ad0f2b09e833 2026-05-27 16:51:37,252 - INFO - Verification of project ctest-TestDetailedPolicy1Ipv4v6-87114749 in API Server 10.0.0.129 passed 2026-05-27 16:51:37,566 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-05-27 16:51:37,575 - DEBUG - Requesting: http://10.0.0.50:8082/domain/dd011215-fca5-4e74-b1da-d431e9fe9325 2026-05-27 16:51:37,587 - DEBUG - Requesting: http://10.0.0.50:8082/project/552f6fc8-eb73-4d0a-b47d-ad0f2b09e833 2026-05-27 16:51:37,684 - DEBUG - Requesting: http://10.0.0.50:8082/network-ipam/607334a9-093e-4d23-8421-97b2ccb75f44 2026-05-27 16:51:37,693 - INFO - Verifications in API Server for IPAM: ctest-TestDetailedPolicy1Ipv4v6-87114749-default-ipam passed 2026-05-27 16:51:37,699 - DEBUG - Control-node 10.0.0.50 : IPAM object is : {'node_name': 'network-ipam:default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-TestDetailedPolicy1Ipv4v6-87114749-default-ipam', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestDetailedPolicy1Ipv4v6-87114749', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6949956550572002595', 'uuid-lslong': '9521057881432481604'}, 'enable': 'true', 'created': '2026-05-27T16:51:37', 'last-modified': '2026-05-27T16:51:37', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.162410'} 2026-05-27 16:51:37,705 - DEBUG - Control-node 10.0.0.22 : IPAM object is : {'node_name': 'network-ipam:default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-TestDetailedPolicy1Ipv4v6-87114749-default-ipam', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestDetailedPolicy1Ipv4v6-87114749', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6949956550572002595', 'uuid-lslong': '9521057881432481604'}, 'enable': 'true', 'created': '2026-05-27T16:51:37', 'last-modified': '2026-05-27T16:51:37', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.171143'} 2026-05-27 16:51:37,711 - DEBUG - Control-node 10.0.0.129 : IPAM object is : {'node_name': 'network-ipam:default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-TestDetailedPolicy1Ipv4v6-87114749-default-ipam', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestDetailedPolicy1Ipv4v6-87114749', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6949956550572002595', 'uuid-lslong': '9521057881432481604'}, 'enable': 'true', 'created': '2026-05-27T16:51:37', 'last-modified': '2026-05-27T16:51:37', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.171316'} 2026-05-27 16:51:37,711 - INFO - Verifications in Control node for IPAM: ctest-TestDetailedPolicy1Ipv4v6-87114749-default-ipam passed 2026-05-27 16:51:38,416 - DEBUG - Response for create_network : {'network': {'id': '0f03d5dd-12ad-4ed7-b0b5-2104d06c0b62', 'name': 'ctest-vnet0-16199476', 'tenant_id': '552f6fc8eb734d0ab47dad0f2b09e833', 'project_id': '552f6fc8eb734d0ab47dad0f2b09e833', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-87114749', 'ctest-vnet0-16199476'], 'port_security_enabled': True, 'description': ''}} 2026-05-27 16:51:38,754 - DEBUG - Response for create_subnet : {'subnet': {'id': '347c7373-9181-44c2-947d-d1170bc3ad17', 'name': '', 'tenant_id': '552f6fc8eb734d0ab47dad0f2b09e833', 'network_id': '0f03d5dd-12ad-4ed7-b0b5-2104d06c0b62', 'ip_version': 4, 'cidr': '10.1.1.0/24', 'allocation_pools': [{'start': '10.1.1.2', 'end': '10.1.1.254'}], 'gateway_ip': '10.1.1.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '10.1.1.2', 'tags': [], 'project_id': '552f6fc8eb734d0ab47dad0f2b09e833'}} 2026-05-27 16:51:38,986 - DEBUG - Response for create_subnet : {'subnet': {'id': '95e1b3f5-d8d5-423a-b523-4756dcb32e8f', 'name': '', 'tenant_id': '552f6fc8eb734d0ab47dad0f2b09e833', 'network_id': '0f03d5dd-12ad-4ed7-b0b5-2104d06c0b62', 'ip_version': 4, 'cidr': '11.1.1.0/24', 'allocation_pools': [{'start': '11.1.1.2', 'end': '11.1.1.254'}], 'gateway_ip': '11.1.1.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '11.1.1.2', 'tags': [], 'project_id': '552f6fc8eb734d0ab47dad0f2b09e833'}} 2026-05-27 16:51:39,197 - DEBUG - Response for create_subnet : {'subnet': {'id': '0ada5b4d-f2e4-4f64-9b29-f89fa292df4f', 'name': '', 'tenant_id': '552f6fc8eb734d0ab47dad0f2b09e833', 'network_id': '0f03d5dd-12ad-4ed7-b0b5-2104d06c0b62', 'ip_version': 6, 'cidr': '25d7:f14e:f367:707d:3ecb:212f::/96', 'allocation_pools': [{'start': '25d7:f14e:f367:707d:3ecb:212f:0:2', 'end': '25d7:f14e:f367:707d:3ecb:212f:ffff:fffe'}], 'gateway_ip': '25d7:f14e:f367:707d:3ecb:212f:0:1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '25d7:f14e:f367:707d:3ecb:212f:0:2', 'tags': [], 'project_id': '552f6fc8eb734d0ab47dad0f2b09e833'}} 2026-05-27 16:51:39,230 - INFO - Created VN ctest-vnet0-16199476 2026-05-27 16:51:39,243 - DEBUG - VN ctest-vnet0-16199476 UUID is 0f03d5dd-12ad-4ed7-b0b5-2104d06c0b62 2026-05-27 16:51:39,383 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-05-27 16:51:39,686 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-05-27 16:51:39,719 - DEBUG - Requesting: http://10.0.0.50:8082/domain/dd011215-fca5-4e74-b1da-d431e9fe9325 2026-05-27 16:51:39,730 - DEBUG - Requesting: http://10.0.0.50:8082/project/552f6fc8-eb73-4d0a-b47d-ad0f2b09e833 2026-05-27 16:51:39,822 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/0f03d5dd-12ad-4ed7-b0b5-2104d06c0b62 2026-05-27 16:51:39,841 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/0f03d5dd-12ad-4ed7-b0b5-2104d06c0b62 2026-05-27 16:51:39,861 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/a21ce863-aee0-465b-8d44-fac319a0dc77 2026-05-27 16:51:39,870 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/a21ce863-aee0-465b-8d44-fac319a0dc77 2026-05-27 16:51:39,879 - DEBUG - Requesting: http://10.0.0.50:8082/route-target/6a952660-27e0-4656-a48c-5732259c66f1 2026-05-27 16:51:39,887 - DEBUG - Route Targets: ['target:64512:8000004'] 2026-05-27 16:51:39,887 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/0f03d5dd-12ad-4ed7-b0b5-2104d06c0b62 2026-05-27 16:51:39,898 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/a21ce863-aee0-465b-8d44-fac319a0dc77 2026-05-27 16:51:39,916 - INFO - Verified VN network id 13 for VN 0f03d5dd-12ad-4ed7-b0b5-2104d06c0b62 2026-05-27 16:51:39,916 - INFO - Verifications in API Server for VN ctest-vnet0-16199476 passed 2026-05-27 16:51:39,916 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/0f03d5dd-12ad-4ed7-b0b5-2104d06c0b62 2026-05-27 16:51:39,927 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/a21ce863-aee0-465b-8d44-fac319a0dc77 2026-05-27 16:51:39,936 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/a21ce863-aee0-465b-8d44-fac319a0dc77 2026-05-27 16:51:39,943 - DEBUG - Requesting: http://10.0.0.50:8082/route-target/6a952660-27e0-4656-a48c-5732259c66f1 2026-05-27 16:51:39,956 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'admin', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1081943480976887511', 'uuid-lslong': '12733119826020272994'}, 'enable': 'true', 'created': '2026-05-27T16:51:38', 'last-modified': '2026-05-27T16:51:39', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.807576'} 2026-05-27 16:51:39,961 - DEBUG - Route Targets: ['target:64512:8000004'] 2026-05-27 16:51:39,968 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'admin', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1081943480976887511', 'uuid-lslong': '12733119826020272994'}, 'enable': 'true', 'created': '2026-05-27T16:51:38', 'last-modified': '2026-05-27T16:51:39', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.820482'} 2026-05-27 16:51:39,974 - DEBUG - Route Targets: ['target:64512:8000004'] 2026-05-27 16:51:39,982 - DEBUG - Control-node 10.0.0.129 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'admin', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1081943480976887511', 'uuid-lslong': '12733119826020272994'}, 'enable': 'true', 'created': '2026-05-27T16:51:38', 'last-modified': '2026-05-27T16:51:39', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.843087'} 2026-05-27 16:51:39,989 - DEBUG - Route Targets: ['target:64512:8000004'] 2026-05-27 16:51:39,989 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vnet0-16199476 passed 2026-05-27 16:51:39,989 - DEBUG - ====Verifying policy data for ctest-vnet0-16199476 in API_Server ====== 2026-05-27 16:51:39,989 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-05-27 16:51:39,996 - DEBUG - Requesting: http://10.0.0.50:8082/domain/dd011215-fca5-4e74-b1da-d431e9fe9325 2026-05-27 16:51:40,009 - DEBUG - Requesting: http://10.0.0.50:8082/project/552f6fc8-eb73-4d0a-b47d-ad0f2b09e833 2026-05-27 16:51:40,105 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/0f03d5dd-12ad-4ed7-b0b5-2104d06c0b62 2026-05-27 16:51:40,117 - DEBUG - =>VN ctest-vnet0-16199476 has no policy to be verified 2026-05-27 16:51:40,117 - DEBUG - Verifying the vn in opserver 2026-05-27 16:51:40,117 - DEBUG - Verifying the default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476 virtual network link through opserver 10.0.0.50 2026-05-27 16:51:40,117 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks 2026-05-27 16:51:40,423 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks 2026-05-27 16:51:40,501 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476?flat'} 2026-05-27 16:51:40,501 - DEBUG - Verifying the default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476 virtual network link through opserver 10.0.0.22 2026-05-27 16:51:40,501 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks 2026-05-27 16:51:40,798 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks 2026-05-27 16:51:40,894 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476?flat'} 2026-05-27 16:51:40,894 - DEBUG - Verifying the default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476 virtual network link through opserver 10.0.0.129 2026-05-27 16:51:40,894 - DEBUG - Requesting: http://10.0.0.129:8081/analytics/uves/virtual-networks 2026-05-27 16:51:41,385 - DEBUG - Requesting: http://10.0.0.129:8081/analytics/uves/virtual-networks 2026-05-27 16:51:41,455 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476', 'href': 'http://10.0.0.129:8081/analytics/uves/virtual-network/default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476?flat'} 2026-05-27 16:51:41,455 - INFO - Validated that VN default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476 is found in opserver 2026-05-27 16:51:41,478 - DEBUG - Do not have enough data to verify VN in agent 2026-05-27 16:51:41,489 - DEBUG - VRF ids for VN ctest-vnet0-16199476: {} 2026-05-27 16:51:41,810 - DEBUG - Response for create_network : {'network': {'id': 'd7afc87e-2a30-46ce-9470-50470b14a1b8', 'name': 'ctest-vnet1-50122070', 'tenant_id': '552f6fc8eb734d0ab47dad0f2b09e833', 'project_id': '552f6fc8eb734d0ab47dad0f2b09e833', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-87114749', 'ctest-vnet1-50122070'], 'port_security_enabled': True, 'description': ''}} 2026-05-27 16:51:42,065 - DEBUG - Response for create_subnet : {'subnet': {'id': 'fb1b198d-a40d-4c69-9222-6f38335da016', 'name': '', 'tenant_id': '552f6fc8eb734d0ab47dad0f2b09e833', 'network_id': 'd7afc87e-2a30-46ce-9470-50470b14a1b8', 'ip_version': 4, 'cidr': '12.1.1.0/24', 'allocation_pools': [{'start': '12.1.1.2', 'end': '12.1.1.254'}], 'gateway_ip': '12.1.1.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '12.1.1.2', 'tags': [], 'project_id': '552f6fc8eb734d0ab47dad0f2b09e833'}} 2026-05-27 16:51:42,302 - DEBUG - Response for create_subnet : {'subnet': {'id': '5663a508-e53e-414d-bb1f-c1f9eafd1b46', 'name': '', 'tenant_id': '552f6fc8eb734d0ab47dad0f2b09e833', 'network_id': 'd7afc87e-2a30-46ce-9470-50470b14a1b8', 'ip_version': 4, 'cidr': '13.1.1.0/24', 'allocation_pools': [{'start': '13.1.1.2', 'end': '13.1.1.254'}], 'gateway_ip': '13.1.1.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '13.1.1.2', 'tags': [], 'project_id': '552f6fc8eb734d0ab47dad0f2b09e833'}} 2026-05-27 16:51:42,600 - DEBUG - Response for create_subnet : {'subnet': {'id': '76af78c3-f5ff-43cc-80f3-964582f6c988', 'name': '', 'tenant_id': '552f6fc8eb734d0ab47dad0f2b09e833', 'network_id': 'd7afc87e-2a30-46ce-9470-50470b14a1b8', 'ip_version': 6, 'cidr': '3d60:606d:edf7:ed89:18f6:9e33::/96', 'allocation_pools': [{'start': '3d60:606d:edf7:ed89:18f6:9e33:0:2', 'end': '3d60:606d:edf7:ed89:18f6:9e33:ffff:fffe'}], 'gateway_ip': '3d60:606d:edf7:ed89:18f6:9e33:0:1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '3d60:606d:edf7:ed89:18f6:9e33:0:2', 'tags': [], 'project_id': '552f6fc8eb734d0ab47dad0f2b09e833'}} 2026-05-27 16:51:42,635 - INFO - Created VN ctest-vnet1-50122070 2026-05-27 16:51:42,648 - DEBUG - VN ctest-vnet1-50122070 UUID is d7afc87e-2a30-46ce-9470-50470b14a1b8 2026-05-27 16:51:42,808 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-05-27 16:51:42,815 - DEBUG - Requesting: http://10.0.0.50:8082/domain/dd011215-fca5-4e74-b1da-d431e9fe9325 2026-05-27 16:51:42,844 - DEBUG - Requesting: http://10.0.0.50:8082/project/552f6fc8-eb73-4d0a-b47d-ad0f2b09e833 2026-05-27 16:51:42,942 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/d7afc87e-2a30-46ce-9470-50470b14a1b8 2026-05-27 16:51:42,959 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/d7afc87e-2a30-46ce-9470-50470b14a1b8 2026-05-27 16:51:42,971 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/1687f46d-1468-4d1c-95d1-e1f408666e5b 2026-05-27 16:51:42,979 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/1687f46d-1468-4d1c-95d1-e1f408666e5b 2026-05-27 16:51:42,988 - DEBUG - Requesting: http://10.0.0.50:8082/route-target/955b8ff4-d794-4ce7-960e-700645f83abb 2026-05-27 16:51:42,996 - DEBUG - Route Targets: ['target:64512:8000006'] 2026-05-27 16:51:42,996 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/d7afc87e-2a30-46ce-9470-50470b14a1b8 2026-05-27 16:51:43,008 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/1687f46d-1468-4d1c-95d1-e1f408666e5b 2026-05-27 16:51:43,028 - INFO - Verified VN network id 14 for VN d7afc87e-2a30-46ce-9470-50470b14a1b8 2026-05-27 16:51:43,029 - INFO - Verifications in API Server for VN ctest-vnet1-50122070 passed 2026-05-27 16:51:43,029 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/d7afc87e-2a30-46ce-9470-50470b14a1b8 2026-05-27 16:51:43,040 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/1687f46d-1468-4d1c-95d1-e1f408666e5b 2026-05-27 16:51:43,048 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/1687f46d-1468-4d1c-95d1-e1f408666e5b 2026-05-27 16:51:43,056 - DEBUG - Requesting: http://10.0.0.50:8082/route-target/955b8ff4-d794-4ce7-960e-700645f83abb 2026-05-27 16:51:43,069 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet1-50122070', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'admin', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '15541861283278112462', 'uuid-lslong': '10696137381063729592'}, 'enable': 'true', 'created': '2026-05-27T16:51:41', 'last-modified': '2026-05-27T16:51:42', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.541205'} 2026-05-27 16:51:43,077 - DEBUG - Route Targets: ['target:64512:8000006'] 2026-05-27 16:51:43,086 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet1-50122070', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'admin', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '15541861283278112462', 'uuid-lslong': '10696137381063729592'}, 'enable': 'true', 'created': '2026-05-27T16:51:41', 'last-modified': '2026-05-27T16:51:42', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.555628'} 2026-05-27 16:51:43,099 - DEBUG - Route Targets: ['target:64512:8000006'] 2026-05-27 16:51:43,106 - DEBUG - Control-node 10.0.0.129 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet1-50122070', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'admin', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '15541861283278112462', 'uuid-lslong': '10696137381063729592'}, 'enable': 'true', 'created': '2026-05-27T16:51:41', 'last-modified': '2026-05-27T16:51:42', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.574320'} 2026-05-27 16:51:43,113 - DEBUG - Route Targets: ['target:64512:8000006'] 2026-05-27 16:51:43,113 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vnet1-50122070 passed 2026-05-27 16:51:43,113 - DEBUG - ====Verifying policy data for ctest-vnet1-50122070 in API_Server ====== 2026-05-27 16:51:43,113 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-05-27 16:51:43,119 - DEBUG - Requesting: http://10.0.0.50:8082/domain/dd011215-fca5-4e74-b1da-d431e9fe9325 2026-05-27 16:51:43,132 - DEBUG - Requesting: http://10.0.0.50:8082/project/552f6fc8-eb73-4d0a-b47d-ad0f2b09e833 2026-05-27 16:51:43,232 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/d7afc87e-2a30-46ce-9470-50470b14a1b8 2026-05-27 16:51:43,251 - DEBUG - =>VN ctest-vnet1-50122070 has no policy to be verified 2026-05-27 16:51:43,251 - DEBUG - Verifying the vn in opserver 2026-05-27 16:51:43,251 - DEBUG - Verifying the default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet1-50122070 virtual network link through opserver 10.0.0.50 2026-05-27 16:51:43,252 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks 2026-05-27 16:51:43,334 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet1-50122070', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet1-50122070?flat'} 2026-05-27 16:51:43,334 - DEBUG - Verifying the default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet1-50122070 virtual network link through opserver 10.0.0.22 2026-05-27 16:51:43,334 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks 2026-05-27 16:51:43,420 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet1-50122070', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet1-50122070?flat'} 2026-05-27 16:51:43,420 - DEBUG - Verifying the default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet1-50122070 virtual network link through opserver 10.0.0.129 2026-05-27 16:51:43,420 - DEBUG - Requesting: http://10.0.0.129:8081/analytics/uves/virtual-networks 2026-05-27 16:51:43,493 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet1-50122070', 'href': 'http://10.0.0.129:8081/analytics/uves/virtual-network/default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet1-50122070?flat'} 2026-05-27 16:51:43,493 - INFO - Validated that VN default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet1-50122070 is found in opserver 2026-05-27 16:51:43,519 - DEBUG - Do not have enough data to verify VN in agent 2026-05-27 16:51:43,531 - DEBUG - VRF ids for VN ctest-vnet1-50122070: {} 2026-05-27 16:51:43,539 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = tcp, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet1-50122070, 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-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476, security_group = None, network_policy = None, subnet_list = []], dst_ports = [start_port = -1, end_port = -1], action_list = simple_action = pass, gateway_name = None, apply_service = [], service_properties = None, mirror_to = None, assign_routing_instance = None, log = False, alert = False, qos_action = None, host_based_service = False, ethertype = None, created = None, last_modified = None, description = None, rule_sequence = None, rule_uuid = None, direction = <>, protocol = udp, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet1-50122070, 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-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476, 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 = icmp, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet1-50122070, 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-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476, security_group = None, network_policy = None, subnet_list = []], dst_ports = [start_port = -1, end_port = -1], action_list = simple_action = deny, gateway_name = None, apply_service = [], service_properties = None, mirror_to = None, assign_routing_instance = None, log = False, alert = False, qos_action = None, host_based_service = False, ethertype = None, created = None, last_modified = None, description = None, rule_sequence = None, rule_uuid = None, direction = <>, protocol = 58, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet1-50122070, 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-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476, security_group = None, network_policy = None, subnet_list = []], dst_ports = [start_port = -1, end_port = -1], action_list = simple_action = deny, gateway_name = None, apply_service = [], service_properties = None, mirror_to = None, assign_routing_instance = None, log = False, alert = False, qos_action = None, host_based_service = False, ethertype = None, created = None, last_modified = None, description = None] 2026-05-27 16:51:43,778 - DEBUG - ====Verifying data for policy0 in API_Server ====== 2026-05-27 16:51:43,778 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-05-27 16:51:43,784 - DEBUG - Requesting: http://10.0.0.50:8082/domain/dd011215-fca5-4e74-b1da-d431e9fe9325 2026-05-27 16:51:43,796 - DEBUG - Requesting: http://10.0.0.50:8082/project/552f6fc8-eb73-4d0a-b47d-ad0f2b09e833 2026-05-27 16:51:43,912 - DEBUG - Requesting: http://10.0.0.50:8082/network-policy/c74d1b01-e688-4f01-b76f-f10d06b9cacf 2026-05-27 16:51:43,925 - INFO - Verified policy policy0 in API Server, Result: True 2026-05-27 16:51:43,975 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = tcp, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet1-50122070, 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-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476, security_group = None, network_policy = None, subnet_list = []], dst_ports = [start_port = -1, end_port = -1], action_list = simple_action = pass, gateway_name = None, apply_service = [], service_properties = None, mirror_to = None, assign_routing_instance = None, log = False, alert = False, qos_action = None, host_based_service = False, ethertype = None, created = None, last_modified = None, description = None, rule_sequence = None, rule_uuid = None, direction = <>, protocol = udp, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet1-50122070, 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-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476, 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 = icmp, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet1-50122070, 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-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476, 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-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet1-50122070, 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-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476, security_group = None, network_policy = None, subnet_list = []], dst_ports = [start_port = -1, end_port = -1], action_list = simple_action = pass, gateway_name = None, apply_service = [], service_properties = None, mirror_to = None, assign_routing_instance = None, log = False, alert = False, qos_action = None, host_based_service = False, ethertype = None, created = None, last_modified = None, description = None] 2026-05-27 16:51:44,212 - DEBUG - ====Verifying data for policy1 in API_Server ====== 2026-05-27 16:51:44,213 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-05-27 16:51:44,220 - DEBUG - Requesting: http://10.0.0.50:8082/domain/dd011215-fca5-4e74-b1da-d431e9fe9325 2026-05-27 16:51:44,233 - DEBUG - Requesting: http://10.0.0.50:8082/project/552f6fc8-eb73-4d0a-b47d-ad0f2b09e833 2026-05-27 16:51:44,348 - DEBUG - Requesting: http://10.0.0.50:8082/network-policy/1cacd399-1199-4613-ad47-a39134639449 2026-05-27 16:51:44,363 - INFO - Verified policy policy1 in API Server, Result: True 2026-05-27 16:51:44,371 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = tcp, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet1-50122070, 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-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476, security_group = None, network_policy = None, subnet_list = []], dst_ports = [start_port = -1, end_port = -1], action_list = simple_action = pass, gateway_name = None, apply_service = [], service_properties = None, mirror_to = None, assign_routing_instance = None, log = False, alert = False, qos_action = None, host_based_service = False, ethertype = None, created = None, last_modified = None, description = None, rule_sequence = None, rule_uuid = None, direction = <>, protocol = udp, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet1-50122070, 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-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476, 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-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet1-50122070, 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-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476, security_group = None, network_policy = None, subnet_list = []], dst_ports = [start_port = -1, end_port = -1], action_list = simple_action = deny, gateway_name = None, apply_service = [], service_properties = None, mirror_to = None, assign_routing_instance = None, log = False, alert = False, qos_action = None, host_based_service = False, ethertype = None, created = None, last_modified = None, description = None, rule_sequence = None, rule_uuid = None, direction = <>, protocol = 58, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet1-50122070, 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-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476, security_group = None, network_policy = None, subnet_list = []], dst_ports = [start_port = -1, end_port = -1], action_list = simple_action = deny, gateway_name = None, apply_service = [], service_properties = None, mirror_to = None, assign_routing_instance = None, log = False, alert = False, qos_action = None, host_based_service = False, ethertype = None, created = None, last_modified = None, description = None] 2026-05-27 16:51:44,630 - DEBUG - ====Verifying data for policy2 in API_Server ====== 2026-05-27 16:51:44,630 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-05-27 16:51:44,639 - DEBUG - Requesting: http://10.0.0.50:8082/domain/dd011215-fca5-4e74-b1da-d431e9fe9325 2026-05-27 16:51:44,652 - DEBUG - Requesting: http://10.0.0.50:8082/project/552f6fc8-eb73-4d0a-b47d-ad0f2b09e833 2026-05-27 16:51:44,780 - DEBUG - Requesting: http://10.0.0.50:8082/network-policy/1ef941a3-67d5-4697-a99b-dba1444e1a70 2026-05-27 16:51:44,796 - INFO - Verified policy policy2 in API Server, Result: True 2026-05-27 16:51:44,807 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = tcp, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet1-50122070, 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-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476, security_group = None, network_policy = None, subnet_list = []], dst_ports = [start_port = -1, end_port = -1], action_list = simple_action = pass, gateway_name = None, apply_service = [], service_properties = None, mirror_to = None, assign_routing_instance = None, log = False, alert = False, qos_action = None, host_based_service = False, ethertype = None, created = None, last_modified = None, description = None, rule_sequence = None, rule_uuid = None, direction = <>, protocol = udp, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet1-50122070, 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-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476, 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-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet1-50122070, 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-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476, 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-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet1-50122070, 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-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476, security_group = None, network_policy = None, subnet_list = []], dst_ports = [start_port = -1, end_port = -1], action_list = simple_action = pass, gateway_name = None, apply_service = [], service_properties = None, mirror_to = None, assign_routing_instance = None, log = False, alert = False, qos_action = None, host_based_service = False, ethertype = None, created = None, last_modified = None, description = None] 2026-05-27 16:51:45,067 - DEBUG - ====Verifying data for policy3 in API_Server ====== 2026-05-27 16:51:45,067 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-05-27 16:51:45,073 - DEBUG - Requesting: http://10.0.0.50:8082/domain/dd011215-fca5-4e74-b1da-d431e9fe9325 2026-05-27 16:51:45,087 - DEBUG - Requesting: http://10.0.0.50:8082/project/552f6fc8-eb73-4d0a-b47d-ad0f2b09e833 2026-05-27 16:51:45,200 - DEBUG - Requesting: http://10.0.0.50:8082/network-policy/92a18386-2b75-447e-9c36-2b6f64ec5c48 2026-05-27 16:51:45,211 - INFO - Verified policy policy3 in API Server, Result: True 2026-05-27 16:51:45,219 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = any, src_addresses = [subnet = None, virtual_network = any, security_group = None, network_policy = None, 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] 2026-05-27 16:51:45,477 - DEBUG - ====Verifying data for policy100 in API_Server ====== 2026-05-27 16:51:45,477 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-05-27 16:51:45,484 - DEBUG - Requesting: http://10.0.0.50:8082/domain/dd011215-fca5-4e74-b1da-d431e9fe9325 2026-05-27 16:51:45,497 - DEBUG - Requesting: http://10.0.0.50:8082/project/552f6fc8-eb73-4d0a-b47d-ad0f2b09e833 2026-05-27 16:51:45,600 - DEBUG - Requesting: http://10.0.0.50:8082/network-policy/7a74ab9c-5dd0-4dcd-8d83-59c650a178c2 2026-05-27 16:51:45,612 - INFO - Verified policy policy100 in API Server, Result: True 2026-05-27 16:51:45,622 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = udp, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet1-50122070, 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-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476, security_group = None, network_policy = None, subnet_list = []], dst_ports = [start_port = -1, end_port = -1], action_list = simple_action = deny, gateway_name = None, apply_service = [], service_properties = None, mirror_to = None, assign_routing_instance = None, log = False, alert = False, qos_action = None, host_based_service = False, ethertype = None, created = None, last_modified = None, description = None, rule_sequence = None, rule_uuid = None, direction = <>, protocol = tcp, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet1-50122070, 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-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476, 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-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet1-50122070, 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-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476, security_group = None, network_policy = None, subnet_list = []], dst_ports = [start_port = -1, end_port = -1], action_list = simple_action = deny, gateway_name = None, apply_service = [], service_properties = None, mirror_to = None, assign_routing_instance = None, log = False, alert = False, qos_action = None, host_based_service = False, ethertype = None, created = None, last_modified = None, description = None, rule_sequence = None, rule_uuid = None, direction = <>, protocol = 58, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet1-50122070, 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-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476, security_group = None, network_policy = None, subnet_list = []], dst_ports = [start_port = -1, end_port = -1], action_list = simple_action = deny, gateway_name = None, apply_service = [], service_properties = None, mirror_to = None, assign_routing_instance = None, log = False, alert = False, qos_action = None, host_based_service = False, ethertype = None, created = None, last_modified = None, description = None] 2026-05-27 16:51:45,869 - DEBUG - ====Verifying data for policy10 in API_Server ====== 2026-05-27 16:51:45,869 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-05-27 16:51:45,877 - DEBUG - Requesting: http://10.0.0.50:8082/domain/dd011215-fca5-4e74-b1da-d431e9fe9325 2026-05-27 16:51:45,889 - DEBUG - Requesting: http://10.0.0.50:8082/project/552f6fc8-eb73-4d0a-b47d-ad0f2b09e833 2026-05-27 16:51:46,000 - DEBUG - Requesting: http://10.0.0.50:8082/network-policy/601ea74e-b572-44a1-94dc-cf96675e22cc 2026-05-27 16:51:46,012 - INFO - Verified policy policy10 in API Server, Result: True 2026-05-27 16:51:46,019 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = udp, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet1-50122070, 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-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476, security_group = None, network_policy = None, subnet_list = []], dst_ports = [start_port = -1, end_port = -1], action_list = simple_action = deny, gateway_name = None, apply_service = [], service_properties = None, mirror_to = None, assign_routing_instance = None, log = False, alert = False, qos_action = None, host_based_service = False, ethertype = None, created = None, last_modified = None, description = None, rule_sequence = None, rule_uuid = None, direction = <>, protocol = tcp, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet1-50122070, 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-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476, 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-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet1-50122070, 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-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476, 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-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet1-50122070, 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-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476, security_group = None, network_policy = None, subnet_list = []], dst_ports = [start_port = -1, end_port = -1], action_list = simple_action = pass, gateway_name = None, apply_service = [], service_properties = None, mirror_to = None, assign_routing_instance = None, log = False, alert = False, qos_action = None, host_based_service = False, ethertype = None, created = None, last_modified = None, description = None] 2026-05-27 16:51:46,250 - DEBUG - ====Verifying data for policy11 in API_Server ====== 2026-05-27 16:51:46,250 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-05-27 16:51:46,257 - DEBUG - Requesting: http://10.0.0.50:8082/domain/dd011215-fca5-4e74-b1da-d431e9fe9325 2026-05-27 16:51:46,271 - DEBUG - Requesting: http://10.0.0.50:8082/project/552f6fc8-eb73-4d0a-b47d-ad0f2b09e833 2026-05-27 16:51:46,380 - DEBUG - Requesting: http://10.0.0.50:8082/network-policy/80a536bf-f764-4b7c-acf0-79b0fcdead7b 2026-05-27 16:51:46,393 - INFO - Verified policy policy11 in API Server, Result: True 2026-05-27 16:51:46,400 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = tcp, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet1-50122070, 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-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476, security_group = None, network_policy = None, subnet_list = []], dst_ports = [start_port = -1, end_port = -1], action_list = simple_action = deny, gateway_name = None, apply_service = [], service_properties = None, mirror_to = None, assign_routing_instance = None, log = False, alert = False, qos_action = None, host_based_service = False, ethertype = None, created = None, last_modified = None, description = None, rule_sequence = None, rule_uuid = None, direction = <>, protocol = udp, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet1-50122070, 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-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476, 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 = icmp, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet1-50122070, 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-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476, security_group = None, network_policy = None, subnet_list = []], dst_ports = [start_port = -1, end_port = -1], action_list = simple_action = deny, gateway_name = None, apply_service = [], service_properties = None, mirror_to = None, assign_routing_instance = None, log = False, alert = False, qos_action = None, host_based_service = False, ethertype = None, created = None, last_modified = None, description = None, rule_sequence = None, rule_uuid = None, direction = <>, protocol = 58, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet1-50122070, 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-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476, security_group = None, network_policy = None, subnet_list = []], dst_ports = [start_port = -1, end_port = -1], action_list = simple_action = deny, gateway_name = None, apply_service = [], service_properties = None, mirror_to = None, assign_routing_instance = None, log = False, alert = False, qos_action = None, host_based_service = False, ethertype = None, created = None, last_modified = None, description = None] 2026-05-27 16:51:46,645 - DEBUG - ====Verifying data for policy12 in API_Server ====== 2026-05-27 16:51:46,645 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-05-27 16:51:46,652 - DEBUG - Requesting: http://10.0.0.50:8082/domain/dd011215-fca5-4e74-b1da-d431e9fe9325 2026-05-27 16:51:46,664 - DEBUG - Requesting: http://10.0.0.50:8082/project/552f6fc8-eb73-4d0a-b47d-ad0f2b09e833 2026-05-27 16:51:46,780 - DEBUG - Requesting: http://10.0.0.50:8082/network-policy/8d738800-dd61-41a1-9777-2d0310e9fc37 2026-05-27 16:51:46,794 - INFO - Verified policy policy12 in API Server, Result: True 2026-05-27 16:51:46,801 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = udp, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet1-50122070, 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-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476, 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 = icmp, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet1-50122070, 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-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476, 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 = tcp, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet1-50122070, 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-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476, security_group = None, network_policy = None, subnet_list = []], dst_ports = [start_port = -1, end_port = -1], action_list = simple_action = deny, gateway_name = None, apply_service = [], service_properties = None, mirror_to = None, assign_routing_instance = None, log = False, alert = False, qos_action = None, host_based_service = False, ethertype = None, created = None, last_modified = None, description = None, rule_sequence = None, rule_uuid = None, direction = <>, protocol = 58, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet1-50122070, 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-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476, security_group = None, network_policy = None, subnet_list = []], dst_ports = [start_port = -1, end_port = -1], action_list = simple_action = pass, gateway_name = None, apply_service = [], service_properties = None, mirror_to = None, assign_routing_instance = None, log = False, alert = False, qos_action = None, host_based_service = False, ethertype = None, created = None, last_modified = None, description = None] 2026-05-27 16:51:47,032 - DEBUG - ====Verifying data for policy13 in API_Server ====== 2026-05-27 16:51:47,032 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-05-27 16:51:47,039 - DEBUG - Requesting: http://10.0.0.50:8082/domain/dd011215-fca5-4e74-b1da-d431e9fe9325 2026-05-27 16:51:47,051 - DEBUG - Requesting: http://10.0.0.50:8082/project/552f6fc8-eb73-4d0a-b47d-ad0f2b09e833 2026-05-27 16:51:47,149 - DEBUG - Requesting: http://10.0.0.50:8082/network-policy/58326c7e-d80e-4c47-977f-47eff2485d80 2026-05-27 16:51:47,160 - INFO - Verified policy policy13 in API Server, Result: True 2026-05-27 16:51:47,166 - DEBUG - Policy np_rules : [] 2026-05-27 16:51:47,446 - DEBUG - ====Verifying data for policy1000 in API_Server ====== 2026-05-27 16:51:47,447 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-05-27 16:51:47,455 - DEBUG - Requesting: http://10.0.0.50:8082/domain/dd011215-fca5-4e74-b1da-d431e9fe9325 2026-05-27 16:51:47,467 - DEBUG - Requesting: http://10.0.0.50:8082/project/552f6fc8-eb73-4d0a-b47d-ad0f2b09e833 2026-05-27 16:51:47,564 - DEBUG - Requesting: http://10.0.0.50:8082/network-policy/06412302-2df2-4b74-ad2b-2f7426b0156f 2026-05-27 16:51:47,574 - INFO - Verified policy policy1000 in API Server, Result: True 2026-05-27 16:51:47,574 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-05-27 16:51:47,584 - DEBUG - Requesting: http://10.0.0.50:8082/domain/dd011215-fca5-4e74-b1da-d431e9fe9325 2026-05-27 16:51:47,597 - DEBUG - Requesting: http://10.0.0.50:8082/project/552f6fc8-eb73-4d0a-b47d-ad0f2b09e833 2026-05-27 16:51:47,698 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/0f03d5dd-12ad-4ed7-b0b5-2104d06c0b62 2026-05-27 16:51:47,709 - DEBUG - Setup step: Associating the policy to VN' 2026-05-27 16:51:47,858 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': '0f03d5dd-12ad-4ed7-b0b5-2104d06c0b62', 'name': 'ctest-vnet0-16199476', 'tenant_id': '552f6fc8eb734d0ab47dad0f2b09e833', 'project_id': '552f6fc8eb734d0ab47dad0f2b09e833', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['347c7373-9181-44c2-947d-d1170bc3ad17', '95e1b3f5-d8d5-423a-b523-4756dcb32e8f', '0ada5b4d-f2e4-4f64-9b29-f89fa292df4f'], 'fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-87114749', 'ctest-vnet0-16199476'], 'policys': [['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-87114749', 'policy0']], 'subnet_ipam': [{'subnet_cidr': '10.1.1.0/24', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-87114749', 'ctest-TestDetailedPolicy1Ipv4v6-87114749-default-ipam']}, {'subnet_cidr': '11.1.1.0/24', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-87114749', 'ctest-TestDetailedPolicy1Ipv4v6-87114749-default-ipam']}, {'subnet_cidr': '25d7:f14e:f367:707d:3ecb:212f::/96', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-87114749', 'ctest-TestDetailedPolicy1Ipv4v6-87114749-default-ipam']}], 'port_security_enabled': True, 'description': ''}} 2026-05-27 16:51:47,998 - DEBUG - Associated Policy:[['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-87114749', 'policy0']] to ctest-vnet0-16199476 2026-05-27 16:51:47,999 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-05-27 16:51:48,007 - DEBUG - Requesting: http://10.0.0.50:8082/domain/dd011215-fca5-4e74-b1da-d431e9fe9325 2026-05-27 16:51:48,019 - DEBUG - Requesting: http://10.0.0.50:8082/project/552f6fc8-eb73-4d0a-b47d-ad0f2b09e833 2026-05-27 16:51:48,117 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/d7afc87e-2a30-46ce-9470-50470b14a1b8 2026-05-27 16:51:48,135 - DEBUG - Setup step: Associating the policy to VN' 2026-05-27 16:51:48,276 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': 'd7afc87e-2a30-46ce-9470-50470b14a1b8', 'name': 'ctest-vnet1-50122070', 'tenant_id': '552f6fc8eb734d0ab47dad0f2b09e833', 'project_id': '552f6fc8eb734d0ab47dad0f2b09e833', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['fb1b198d-a40d-4c69-9222-6f38335da016', '5663a508-e53e-414d-bb1f-c1f9eafd1b46', '76af78c3-f5ff-43cc-80f3-964582f6c988'], 'fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-87114749', 'ctest-vnet1-50122070'], 'policys': [['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-87114749', 'policy100']], 'subnet_ipam': [{'subnet_cidr': '12.1.1.0/24', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-87114749', 'ctest-TestDetailedPolicy1Ipv4v6-87114749-default-ipam']}, {'subnet_cidr': '13.1.1.0/24', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-87114749', 'ctest-TestDetailedPolicy1Ipv4v6-87114749-default-ipam']}, {'subnet_cidr': '3d60:606d:edf7:ed89:18f6:9e33::/96', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-87114749', 'ctest-TestDetailedPolicy1Ipv4v6-87114749-default-ipam']}], 'port_security_enabled': True, 'description': ''}} 2026-05-27 16:51:48,409 - DEBUG - Associated Policy:[['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-87114749', 'policy100']] to ctest-vnet1-50122070 2026-05-27 16:51:48,436 - DEBUG - Services list from nova: [, , , ] 2026-05-27 16:51:48,437 - DEBUG - Hosts: {'nova': ['an-jenkins-deploy-platform-ansible-os-5832-2', 'an-jenkins-deploy-platform-ansible-os-5832-1']} 2026-05-27 16:51:48,540 - DEBUG - Services list from nova: [, , , ] 2026-05-27 16:51:49,738 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5832-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5832-2) 2026-05-27 16:51:51,257 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5832-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5832-1) 2026-05-27 16:51:51,258 - DEBUG - Setup step: Verify VM status and install Traffic package... 2026-05-27 16:51:51,258 - INFO - Waiting for VM ctest-vmc0-59605636 to be up.. 2026-05-27 16:51:51,396 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-05-27 16:51:56,496 - DEBUG - VM is in ACTIVE state now 2026-05-27 16:51:56,496 - INFO - VM name : ctest-vmc0-59605636 2026-05-27 16:51:56,602 - DEBUG - VM ctest-vmc0-59605636 ID is 57a5f1a1-e8df-4270-acc1-ad7d2c4c1149 2026-05-27 16:51:56,635 - DEBUG - VM ctest-vmc0-59605636 launched on Node an-jenkins-deploy-platform-ansible-os-5832-2 2026-05-27 16:51:56,739 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-machine/57a5f1a1-e8df-4270-acc1-ad7d2c4c1149 2026-05-27 16:51:57,035 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-machine/57a5f1a1-e8df-4270-acc1-ad7d2c4c1149 2026-05-27 16:51:57,080 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-machine-interface/90f1ee7b-f321-44cc-b23b-b0a387f24679 2026-05-27 16:52:00,254 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1002ms') 2026-05-27 16:52:00,254 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vmc0-59605636 failed! 2026-05-27 16:52:00,271 - DEBUG - Gateway for vn default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476 is 10.1.1.1 and allocation pool is NOT set 2026-05-27 16:52:00,271 - DEBUG - Gateway for vn default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476 is 11.1.1.1 and allocation pool is NOT set 2026-05-27 16:52:00,271 - DEBUG - Gateway for vn default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476 is 25d7:f14e:f367:707d:3ecb:212f:0:1 and allocation pool is NOT set 2026-05-27 16:52:04,345 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1008ms') 2026-05-27 16:52:04,345 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vmc0-59605636 failed! 2026-05-27 16:52:04,366 - DEBUG - Gateway for vn default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476 is 10.1.1.1 and allocation pool is NOT set 2026-05-27 16:52:04,366 - DEBUG - Gateway for vn default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476 is 11.1.1.1 and allocation pool is NOT set 2026-05-27 16:52:04,366 - DEBUG - Gateway for vn default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476 is 25d7:f14e:f367:707d:3ecb:212f:0:1 and allocation pool is NOT set 2026-05-27 16:52:08,439 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1014ms') 2026-05-27 16:52:08,439 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vmc0-59605636 failed! 2026-05-27 16:52:08,455 - DEBUG - Gateway for vn default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476 is 10.1.1.1 and allocation pool is NOT set 2026-05-27 16:52:08,455 - DEBUG - Gateway for vn default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476 is 11.1.1.1 and allocation pool is NOT set 2026-05-27 16:52:08,455 - DEBUG - Gateway for vn default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476 is 25d7:f14e:f367:707d:3ecb:212f:0:1 and allocation pool is NOT set 2026-05-27 16:52:12,544 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1021ms') 2026-05-27 16:52:12,544 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vmc0-59605636 failed! 2026-05-27 16:52:12,559 - DEBUG - Gateway for vn default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476 is 10.1.1.1 and allocation pool is NOT set 2026-05-27 16:52:12,559 - DEBUG - Gateway for vn default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476 is 11.1.1.1 and allocation pool is NOT set 2026-05-27 16:52:12,559 - DEBUG - Gateway for vn default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476 is 25d7:f14e:f367:707d:3ecb:212f:0:1 and allocation pool is NOT set 2026-05-27 16:52:16,634 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1013ms') 2026-05-27 16:52:16,634 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vmc0-59605636 failed! 2026-05-27 16:52:16,651 - DEBUG - Gateway for vn default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476 is 10.1.1.1 and allocation pool is NOT set 2026-05-27 16:52:16,651 - DEBUG - Gateway for vn default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476 is 11.1.1.1 and allocation pool is NOT set 2026-05-27 16:52:16,652 - DEBUG - Gateway for vn default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476 is 25d7:f14e:f367:707d:3ecb:212f:0:1 and allocation pool is NOT set 2026-05-27 16:52:20,732 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1015ms') 2026-05-27 16:52:20,732 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vmc0-59605636 failed! 2026-05-27 16:52:20,748 - DEBUG - Gateway for vn default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476 is 10.1.1.1 and allocation pool is NOT set 2026-05-27 16:52:20,748 - DEBUG - Gateway for vn default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476 is 11.1.1.1 and allocation pool is NOT set 2026-05-27 16:52:20,748 - DEBUG - Gateway for vn default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476 is 25d7:f14e:f367:707d:3ecb:212f:0:1 and allocation pool is NOT set 2026-05-27 16:52:24,833 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1014ms') 2026-05-27 16:52:24,833 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vmc0-59605636 failed! 2026-05-27 16:52:24,947 - DEBUG - Gateway for vn default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476 is 10.1.1.1 and allocation pool is NOT set 2026-05-27 16:52:24,947 - DEBUG - Gateway for vn default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476 is 11.1.1.1 and allocation pool is NOT set 2026-05-27 16:52:24,947 - DEBUG - Gateway for vn default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476 is 25d7:f14e:f367:707d:3ecb:212f:0:1 and allocation pool is NOT set 2026-05-27 16:52:29,015 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1010ms') 2026-05-27 16:52:29,015 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vmc0-59605636 failed! 2026-05-27 16:52:29,030 - DEBUG - Gateway for vn default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476 is 10.1.1.1 and allocation pool is NOT set 2026-05-27 16:52:29,030 - DEBUG - Gateway for vn default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476 is 11.1.1.1 and allocation pool is NOT set 2026-05-27 16:52:29,030 - DEBUG - Gateway for vn default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476 is 25d7:f14e:f367:707d:3ecb:212f:0:1 and allocation pool is NOT set 2026-05-27 16:52:31,101 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n64 bytes from 169.254.0.3: icmp_seq=1 ttl=63 time=8.96 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=5.49 ms\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1001ms\r\nrtt min/avg/max/mdev = 5.494/7.227/8.960/1.733 ms') 2026-05-27 16:52:31,101 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-vmc0-59605636 passed 2026-05-27 16:52:31,173 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-27 16:52:31,173 - DEBUG - Waiting to SSH to VM ctest-vmc0-59605636, IP 10.1.1.3, Port 22 2026-05-27 16:52:31,239 - DEBUG - Error on ssh to ubuntu@169.254.0.3:22, result: /bin/bash: connect: Connection refused /bin/bash: line 1: /dev/tcp/169.254.0.3/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.3/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.3/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''} 2026-05-27 16:52:31,336 - DEBUG - VM ctest-vmc0-59605636 is NOT ready for SSH connections, VM status: ACTIVE 2026-05-27 16:52:36,337 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-27 16:52:36,337 - DEBUG - Waiting to SSH to VM ctest-vmc0-59605636, IP 10.1.1.3, Port 22 2026-05-27 16:52:36,404 - DEBUG - Error on ssh to ubuntu@169.254.0.3:22, result: /bin/bash: connect: Connection refused /bin/bash: line 1: /dev/tcp/169.254.0.3/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.3/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.3/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''} 2026-05-27 16:52:36,495 - DEBUG - VM ctest-vmc0-59605636 is NOT ready for SSH connections, VM status: ACTIVE 2026-05-27 16:52:41,495 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-27 16:52:41,495 - DEBUG - Waiting to SSH to VM ctest-vmc0-59605636, IP 10.1.1.3, Port 22 2026-05-27 16:52:41,563 - DEBUG - Error on ssh to ubuntu@169.254.0.3:22, result: /bin/bash: connect: Connection refused /bin/bash: line 1: /dev/tcp/169.254.0.3/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.3/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.3/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''} 2026-05-27 16:52:41,652 - DEBUG - VM ctest-vmc0-59605636 is NOT ready for SSH connections, VM status: ACTIVE 2026-05-27 16:52:46,652 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-27 16:52:46,652 - DEBUG - Waiting to SSH to VM ctest-vmc0-59605636, IP 10.1.1.3, Port 22 2026-05-27 16:52:46,719 - DEBUG - Error on ssh to ubuntu@169.254.0.3:22, result: /bin/bash: connect: Connection refused /bin/bash: line 1: /dev/tcp/169.254.0.3/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.3/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.3/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''} 2026-05-27 16:52:46,828 - DEBUG - VM ctest-vmc0-59605636 is NOT ready for SSH connections, VM status: ACTIVE 2026-05-27 16:52:51,829 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-27 16:52:51,829 - DEBUG - Waiting to SSH to VM ctest-vmc0-59605636, IP 10.1.1.3, Port 22 2026-05-27 16:52:51,895 - DEBUG - Error on ssh to ubuntu@169.254.0.3:22, result: /bin/bash: connect: Connection refused /bin/bash: line 1: /dev/tcp/169.254.0.3/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.3/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.3/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''} 2026-05-27 16:52:51,989 - DEBUG - VM ctest-vmc0-59605636 is NOT ready for SSH connections, VM status: ACTIVE 2026-05-27 16:52:56,990 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-27 16:52:56,990 - DEBUG - Waiting to SSH to VM ctest-vmc0-59605636, IP 10.1.1.3, Port 22 2026-05-27 16:52:57,159 - DEBUG - VM ctest-vmc0-59605636 is ready for SSH connections 2026-05-27 16:52:57,159 - INFO - Waiting for VM ctest-vmc1-80121674 to be up.. 2026-05-27 16:52:57,268 - DEBUG - VM is in ACTIVE state now 2026-05-27 16:52:57,269 - INFO - VM name : ctest-vmc1-80121674 2026-05-27 16:52:57,375 - DEBUG - VM ctest-vmc1-80121674 ID is cd0d0faa-71f4-43b5-8fdb-2fb0c1eb07ec 2026-05-27 16:52:57,375 - DEBUG - VM ctest-vmc1-80121674 launched on Node an-jenkins-deploy-platform-ansible-os-5832-1 2026-05-27 16:52:57,474 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-machine/cd0d0faa-71f4-43b5-8fdb-2fb0c1eb07ec 2026-05-27 16:52:57,486 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-machine-interface/d35889ed-ee6d-476f-b209-76bb26e5c62f 2026-05-27 16:52:58,651 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n64 bytes from 169.254.0.3: icmp_seq=1 ttl=63 time=3.60 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.433 ms\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1002ms\r\nrtt min/avg/max/mdev = 0.433/2.016/3.600/1.583 ms') 2026-05-27 16:52:58,651 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-vmc1-80121674 passed 2026-05-27 16:52:58,724 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-27 16:52:58,724 - DEBUG - Waiting to SSH to VM ctest-vmc1-80121674, IP 12.1.1.3, Port 22 2026-05-27 16:52:58,890 - DEBUG - VM ctest-vmc1-80121674 is ready for SSH connections 2026-05-27 16:52:58,899 - DEBUG - Skipping the policy rule comparison since VM's are not exist for selected project:admin 2026-05-27 16:52:58,899 - DEBUG - Skipping the policy rule comparison since VM's are not exist for selected project:ctest-TestECMPIPv6Fragments-39605867 2026-05-27 16:52:59,131 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-05-27 16:52:59,138 - DEBUG - Requesting: http://10.0.0.50:8082/domain/dd011215-fca5-4e74-b1da-d431e9fe9325 2026-05-27 16:52:59,149 - DEBUG - Requesting: http://10.0.0.50:8082/project/552f6fc8-eb73-4d0a-b47d-ad0f2b09e833 2026-05-27 16:52:59,258 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/d7afc87e-2a30-46ce-9470-50470b14a1b8 2026-05-27 16:52:59,278 - DEBUG - Order of the policy's list:['policy100'] 2026-05-27 16:52:59,292 - DEBUG - , ['policy100'], ['admin', 'ctest-TestECMPIPv6Fragments-39605867', 'ctest-TestDetailedPolicy1Ipv4v6-87114749'], [, ], ['ctest-vnet1-50122070'] 2026-05-27 16:52:59,292 - DEBUG - Traslation of quantum rules to ACES format 2026-05-27 16:52:59,292 - DEBUG - vn is ctest-vnet1-50122070, vn_policy is policy100 2026-05-27 16:52:59,292 - DEBUG - VN: ctest-vnet1-50122070, expected ACE's is 2026-05-27 16:52:59,292 - DEBUG - {"ace_id": "1", "action_l": [{"alert": false, "apply_service": [], "assign_routing_instance": null, "gateway_name": null, "host_based_service": false, "log": false, "mirror_to": null, "qos_action": null, "service_properties": null, "simple_action": "pass"}], "dst": "any", "dst_port_l": {"max": "65535", "min": "0"}, "proto_l": {"max": "255", "min": "0"}, "rule_type": "Terminal", "src": "any", "src_port_l": {"max": "65535", "min": "0"}} 2026-05-27 16:52:59,293 - DEBUG - Verify rules expected in CN if VN-VM in CN 2026-05-27 16:52:59,293 - DEBUG - CN: 10.0.0.241, Check for expected data 2026-05-27 16:52:59,319 - DEBUG - ---------------------------------------- 2026-05-27 16:52:59,320 - DEBUG - CN: 10.0.0.241, VN: ctest-vnet1-50122070, result of expected rules check passed 2026-05-27 16:52:59,320 - INFO - Validated the rules for VM:ctest-vmc1-80121674 with attached policy:['policy100'] and vn:ctest-vnet1-50122070 2026-05-27 16:52:59,320 - DEBUG - Verify rules expected in CN if VN-VM in CN 2026-05-27 16:52:59,320 - DEBUG - CN: 10.0.0.242, Check for expected data 2026-05-27 16:52:59,328 - DEBUG - Verify policy rules for other vn if it is present 2026-05-27 16:52:59,431 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-05-27 16:52:59,439 - DEBUG - Requesting: http://10.0.0.50:8082/domain/dd011215-fca5-4e74-b1da-d431e9fe9325 2026-05-27 16:52:59,451 - DEBUG - Requesting: http://10.0.0.50:8082/project/552f6fc8-eb73-4d0a-b47d-ad0f2b09e833 2026-05-27 16:52:59,566 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/0f03d5dd-12ad-4ed7-b0b5-2104d06c0b62 2026-05-27 16:52:59,583 - DEBUG - Order of the policy's list:['policy0'] 2026-05-27 16:52:59,597 - DEBUG - , ['policy0'], ['admin', 'ctest-TestECMPIPv6Fragments-39605867', 'ctest-TestDetailedPolicy1Ipv4v6-87114749'], [, ], ['ctest-vnet0-16199476'] 2026-05-27 16:52:59,598 - DEBUG - Traslation of quantum rules to ACES format 2026-05-27 16:52:59,598 - DEBUG - vn is ctest-vnet0-16199476, vn_policy is policy0 2026-05-27 16:52:59,598 - DEBUG - VN: ctest-vnet0-16199476, expected ACE's is 2026-05-27 16:52:59,598 - DEBUG - {"ace_id": "1", "action_l": [{"alert": false, "apply_service": [], "assign_routing_instance": null, "gateway_name": null, "host_based_service": false, "log": false, "mirror_to": null, "qos_action": null, "service_properties": null, "simple_action": "pass"}], "dst": "default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476", "dst_port_l": {"max": "65535", "min": "0"}, "proto_l": {"max": "tcp", "min": "tcp"}, "rule_type": "Terminal", "src": "default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet1-50122070", "src_port_l": {"max": "65535", "min": "0"}} 2026-05-27 16:52:59,598 - DEBUG - {"ace_id": "2", "action_l": [{"alert": false, "apply_service": [], "assign_routing_instance": null, "gateway_name": null, "host_based_service": false, "log": false, "mirror_to": null, "qos_action": null, "service_properties": null, "simple_action": "pass"}], "dst": "default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet1-50122070", "dst_port_l": {"max": "65535", "min": "0"}, "proto_l": {"max": "tcp", "min": "tcp"}, "rule_type": "Terminal", "src": "default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476", "src_port_l": {"max": "65535", "min": "0"}} 2026-05-27 16:52:59,598 - DEBUG - {"ace_id": "3", "action_l": [{"alert": false, "apply_service": [], "assign_routing_instance": null, "gateway_name": null, "host_based_service": false, "log": false, "mirror_to": null, "qos_action": null, "service_properties": null, "simple_action": "pass"}], "dst": "default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476", "dst_port_l": {"max": "65535", "min": "0"}, "proto_l": {"max": "udp", "min": "udp"}, "rule_type": "Terminal", "src": "default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet1-50122070", "src_port_l": {"max": "65535", "min": "0"}} 2026-05-27 16:52:59,599 - DEBUG - {"ace_id": "4", "action_l": [{"alert": false, "apply_service": [], "assign_routing_instance": null, "gateway_name": null, "host_based_service": false, "log": false, "mirror_to": null, "qos_action": null, "service_properties": null, "simple_action": "pass"}], "dst": "default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet1-50122070", "dst_port_l": {"max": "65535", "min": "0"}, "proto_l": {"max": "udp", "min": "udp"}, "rule_type": "Terminal", "src": "default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476", "src_port_l": {"max": "65535", "min": "0"}} 2026-05-27 16:52:59,599 - DEBUG - {"ace_id": "5", "action_l": [{"alert": false, "apply_service": [], "assign_routing_instance": null, "gateway_name": null, "host_based_service": false, "log": false, "mirror_to": null, "qos_action": null, "service_properties": null, "simple_action": "deny"}], "dst": "default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476", "dst_port_l": {"max": "65535", "min": "0"}, "proto_l": {"max": "icmp", "min": "icmp"}, "rule_type": "Terminal", "src": "default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet1-50122070", "src_port_l": {"max": "65535", "min": "0"}} 2026-05-27 16:52:59,599 - DEBUG - {"ace_id": "6", "action_l": [{"alert": false, "apply_service": [], "assign_routing_instance": null, "gateway_name": null, "host_based_service": false, "log": false, "mirror_to": null, "qos_action": null, "service_properties": null, "simple_action": "deny"}], "dst": "default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet1-50122070", "dst_port_l": {"max": "65535", "min": "0"}, "proto_l": {"max": "icmp", "min": "icmp"}, "rule_type": "Terminal", "src": "default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476", "src_port_l": {"max": "65535", "min": "0"}} 2026-05-27 16:52:59,599 - DEBUG - {"ace_id": "7", "action_l": [{"alert": false, "apply_service": [], "assign_routing_instance": null, "gateway_name": null, "host_based_service": false, "log": false, "mirror_to": null, "qos_action": null, "service_properties": null, "simple_action": "deny"}], "dst": "default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476", "dst_port_l": {"max": "65535", "min": "0"}, "proto_l": {"max": "58", "min": "58"}, "rule_type": "Terminal", "src": "default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet1-50122070", "src_port_l": {"max": "65535", "min": "0"}} 2026-05-27 16:52:59,599 - DEBUG - {"ace_id": "8", "action_l": [{"alert": false, "apply_service": [], "assign_routing_instance": null, "gateway_name": null, "host_based_service": false, "log": false, "mirror_to": null, "qos_action": null, "service_properties": null, "simple_action": "deny"}], "dst": "default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet1-50122070", "dst_port_l": {"max": "65535", "min": "0"}, "proto_l": {"max": "58", "min": "58"}, "rule_type": "Terminal", "src": "default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476", "src_port_l": {"max": "65535", "min": "0"}} 2026-05-27 16:52:59,599 - DEBUG - {"ace_id": "9", "action_l": ["pass"], "dst": "default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476", "dst_port_l": {"max": "65535", "min": "0"}, "proto_l": {"max": "255", "min": "0"}, "rule_type": "Terminal", "src": "default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476", "src_port_l": {"max": "65535", "min": "0"}} 2026-05-27 16:52:59,599 - DEBUG - {"ace_id": "10", "action_l": ["deny"], "dst": "default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476", "dst_port_l": {"max": "65535", "min": "0"}, "proto_l": {"max": "255", "min": "0"}, "rule_type": "Terminal", "src": "default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet1-50122070", "src_port_l": {"max": "65535", "min": "0"}} 2026-05-27 16:52:59,599 - DEBUG - {"ace_id": "11", "action_l": ["deny"], "dst": "default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet1-50122070", "dst_port_l": {"max": "65535", "min": "0"}, "proto_l": {"max": "255", "min": "0"}, "rule_type": "Terminal", "src": "default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476", "src_port_l": {"max": "65535", "min": "0"}} 2026-05-27 16:52:59,599 - DEBUG - {"ace_id": "12", "action_l": ["pass"], "dst": "any", "dst_port_l": {"max": "65535", "min": "0"}, "proto_l": {"max": "255", "min": "0"}, "rule_type": "Terminal", "src": "any", "src_port_l": {"max": "65535", "min": "0"}} 2026-05-27 16:52:59,599 - DEBUG - Verify rules expected in CN if VN-VM in CN 2026-05-27 16:52:59,599 - DEBUG - CN: 10.0.0.241, Check for expected data 2026-05-27 16:52:59,607 - DEBUG - Verify rules expected in CN if VN-VM in CN 2026-05-27 16:52:59,607 - DEBUG - CN: 10.0.0.242, Check for expected data 2026-05-27 16:52:59,649 - DEBUG - ---------------------------------------- 2026-05-27 16:52:59,649 - DEBUG - CN: 10.0.0.242, VN: ctest-vnet0-16199476, result of expected rules check passed 2026-05-27 16:52:59,649 - INFO - Validated the rules for VM:ctest-vmc0-59605636 with attached policy:['policy0'] and vn:ctest-vnet0-16199476 2026-05-27 16:52:59,649 - DEBUG - Verify policy rules for other vn if it is present 2026-05-27 16:52:59,649 - INFO - Policy rules comparison with system for all Virtual networks are done 2026-05-27 16:52:59,649 - INFO - Setup completed with result True 2026-05-27 16:52:59,792 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': '0f03d5dd-12ad-4ed7-b0b5-2104d06c0b62', 'name': 'ctest-vnet0-16199476', 'tenant_id': '552f6fc8eb734d0ab47dad0f2b09e833', 'project_id': '552f6fc8eb734d0ab47dad0f2b09e833', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['347c7373-9181-44c2-947d-d1170bc3ad17', '95e1b3f5-d8d5-423a-b523-4756dcb32e8f', '0ada5b4d-f2e4-4f64-9b29-f89fa292df4f'], 'fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-87114749', 'ctest-vnet0-16199476'], 'policys': [['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-87114749', 'policy1']], 'subnet_ipam': [{'subnet_cidr': '10.1.1.0/24', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-87114749', 'ctest-TestDetailedPolicy1Ipv4v6-87114749-default-ipam']}, {'subnet_cidr': '11.1.1.0/24', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-87114749', 'ctest-TestDetailedPolicy1Ipv4v6-87114749-default-ipam']}, {'subnet_cidr': '25d7:f14e:f367:707d:3ecb:212f::/96', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-87114749', 'ctest-TestDetailedPolicy1Ipv4v6-87114749-default-ipam']}], 'port_security_enabled': True, 'description': ''}} 2026-05-27 16:53:04,908 - INFO - new policy list of vn ctest-vnet0-16199476 is policy1 2026-05-27 16:53:04,909 - INFO - Starting Verifications after policy for ctest-vnet0-16199476 updated to policy1 2026-05-27 16:53:04,909 - INFO - policy in effect is : [{'direction': '<>', 'protocol': 'tcp', 'dest_network': 'ctest-vnet0-16199476', 'source_network': 'ctest-vnet1-50122070', 'dst_ports': 'any', 'simple_action': 'pass', 'src_ports': 'any'}, {'direction': '<>', 'protocol': 'udp', 'dest_network': 'ctest-vnet0-16199476', 'source_network': 'ctest-vnet1-50122070', 'dst_ports': 'any', 'simple_action': 'pass', 'src_ports': 'any'}, {'direction': '<>', 'protocol': 'icmp', 'dest_network': 'ctest-vnet0-16199476', 'source_network': 'ctest-vnet1-50122070', 'dst_ports': 'any', 'simple_action': 'pass', 'src_ports': 'any'}, {'direction': '<>', 'protocol': '58', 'dest_network': 'ctest-vnet0-16199476', 'source_network': 'ctest-vnet1-50122070', 'dst_ports': 'any', 'simple_action': 'pass', 'src_ports': 'any'}] 2026-05-27 16:53:04,909 - INFO - matching_rule_action: {'tcp': 'pass', 'udp': 'pass', 'icmp': 'pass', '58': 'pass'} 2026-05-27 16:53:04,909 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-27 16:53:04,909 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 12.1.1.3, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.242, gateway password: c0ntrail123 2026-05-27 16:53:04,909 - DEBUG - ping -s 56 -c 3 -W 1 12.1.1.3 2026-05-27 16:53:20,442 - DEBUG - PING 12.1.1.3 (12.1.1.3) 56(84) bytes of data. 64 bytes from 12.1.1.3: icmp_req=1 ttl=63 time=10.7 ms 64 bytes from 12.1.1.3: icmp_req=2 ttl=63 time=1.78 ms 64 bytes from 12.1.1.3: icmp_req=3 ttl=63 time=1.29 ms --- 12.1.1.3 ping statistics --- 3 packets transmitted, 3 received, 0% packet loss, time 2004ms rtt min/avg/max/mdev = 1.299/4.600/10.712/4.326 ms 2026-05-27 16:53:20,443 - INFO - Ping to IP 12.1.1.3 from VM ctest-vmc0-59605636 passed 2026-05-27 16:53:20,443 - DEBUG - Running remote_cmd, Cmd : ping6 -s 56 -c 3 -W 1 3d60:606d:edf7:ed89:18f6:9e33:0:3, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.242, gateway password: c0ntrail123 2026-05-27 16:53:20,443 - DEBUG - ping6 -s 56 -c 3 -W 1 3d60:606d:edf7:ed89:18f6:9e33:0:3 2026-05-27 16:53:22,973 - DEBUG - PING 3d60:606d:edf7:ed89:18f6:9e33:0:3(3d60:606d:edf7:ed89:18f6:9e33:0:3) 56 data bytes 64 bytes from 3d60:606d:edf7:ed89:18f6:9e33:0:3: icmp_seq=1 ttl=64 time=7.18 ms 64 bytes from 3d60:606d:edf7:ed89:18f6:9e33:0:3: icmp_seq=2 ttl=64 time=1.95 ms 64 bytes from 3d60:606d:edf7:ed89:18f6:9e33:0:3: icmp_seq=3 ttl=64 time=1.41 ms --- 3d60:606d:edf7:ed89:18f6:9e33:0:3 ping statistics --- 3 packets transmitted, 3 received, 0% packet loss, time 2004ms rtt min/avg/max/mdev = 1.413/3.518/7.187/2.603 ms 2026-05-27 16:53:22,973 - INFO - Ping to IP 3d60:606d:edf7:ed89:18f6:9e33:0:3 from VM ctest-vmc0-59605636 passed 2026-05-27 16:53:22,973 - INFO - vm ping test result after policy for ctest-vnet0-16199476 updated to policy1 is: True 2026-05-27 16:53:23,150 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': '0f03d5dd-12ad-4ed7-b0b5-2104d06c0b62', 'name': 'ctest-vnet0-16199476', 'tenant_id': '552f6fc8eb734d0ab47dad0f2b09e833', 'project_id': '552f6fc8eb734d0ab47dad0f2b09e833', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['347c7373-9181-44c2-947d-d1170bc3ad17', '95e1b3f5-d8d5-423a-b523-4756dcb32e8f', '0ada5b4d-f2e4-4f64-9b29-f89fa292df4f'], 'fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-87114749', 'ctest-vnet0-16199476'], 'policys': [['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-87114749', 'policy1000']], 'subnet_ipam': [{'subnet_cidr': '10.1.1.0/24', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-87114749', 'ctest-TestDetailedPolicy1Ipv4v6-87114749-default-ipam']}, {'subnet_cidr': '11.1.1.0/24', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-87114749', 'ctest-TestDetailedPolicy1Ipv4v6-87114749-default-ipam']}, {'subnet_cidr': '25d7:f14e:f367:707d:3ecb:212f::/96', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-87114749', 'ctest-TestDetailedPolicy1Ipv4v6-87114749-default-ipam']}], 'port_security_enabled': True, 'description': ''}} 2026-05-27 16:53:28,315 - INFO - new policy list of vn ctest-vnet0-16199476 is policy1000 2026-05-27 16:53:28,316 - INFO - Starting Verifications after policy for ctest-vnet0-16199476 updated to policy1000 2026-05-27 16:53:28,316 - INFO - policy in effect is : [] 2026-05-27 16:53:28,316 - INFO - matching_rule_action: {'icmp': 'deny'} 2026-05-27 16:53:28,316 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-27 16:53:28,316 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 12.1.1.3, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.242, gateway password: c0ntrail123 2026-05-27 16:53:28,317 - DEBUG - ping -s 56 -c 3 -W 1 12.1.1.3 2026-05-27 16:53:32,346 - DEBUG - PING 12.1.1.3 (12.1.1.3) 56(84) bytes of data. --- 12.1.1.3 ping statistics --- 3 packets transmitted, 0 received, 100% packet loss, time 2017ms 2026-05-27 16:53:32,346 - WARNING - Ping to IP 12.1.1.3 from VM ctest-vmc0-59605636 failed 2026-05-27 16:53:32,346 - DEBUG - Running remote_cmd, Cmd : ping6 -s 56 -c 3 -W 1 3d60:606d:edf7:ed89:18f6:9e33:0:3, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.242, gateway password: c0ntrail123 2026-05-27 16:53:32,346 - DEBUG - ping6 -s 56 -c 3 -W 1 3d60:606d:edf7:ed89:18f6:9e33:0:3 2026-05-27 16:53:35,867 - DEBUG - PING 3d60:606d:edf7:ed89:18f6:9e33:0:3(3d60:606d:edf7:ed89:18f6:9e33:0:3) 56 data bytes --- 3d60:606d:edf7:ed89:18f6:9e33:0:3 ping statistics --- 3 packets transmitted, 0 received, 100% packet loss, time 2002ms 2026-05-27 16:53:35,867 - WARNING - Ping to IP 3d60:606d:edf7:ed89:18f6:9e33:0:3 from VM ctest-vmc0-59605636 failed 2026-05-27 16:53:35,867 - INFO - vm ping test result after policy for ctest-vnet0-16199476 updated to policy1000 is: True 2026-05-27 16:53:36,036 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': '0f03d5dd-12ad-4ed7-b0b5-2104d06c0b62', 'name': 'ctest-vnet0-16199476', 'tenant_id': '552f6fc8eb734d0ab47dad0f2b09e833', 'project_id': '552f6fc8eb734d0ab47dad0f2b09e833', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['347c7373-9181-44c2-947d-d1170bc3ad17', '95e1b3f5-d8d5-423a-b523-4756dcb32e8f', '0ada5b4d-f2e4-4f64-9b29-f89fa292df4f'], 'fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-87114749', 'ctest-vnet0-16199476'], 'policys': [['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-87114749', 'policy2']], 'subnet_ipam': [{'subnet_cidr': '10.1.1.0/24', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-87114749', 'ctest-TestDetailedPolicy1Ipv4v6-87114749-default-ipam']}, {'subnet_cidr': '11.1.1.0/24', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-87114749', 'ctest-TestDetailedPolicy1Ipv4v6-87114749-default-ipam']}, {'subnet_cidr': '25d7:f14e:f367:707d:3ecb:212f::/96', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-87114749', 'ctest-TestDetailedPolicy1Ipv4v6-87114749-default-ipam']}], 'port_security_enabled': True, 'description': ''}} 2026-05-27 16:53:41,164 - INFO - new policy list of vn ctest-vnet0-16199476 is policy2 2026-05-27 16:53:41,165 - INFO - Starting Verifications after policy for ctest-vnet0-16199476 updated to policy2 2026-05-27 16:53:41,165 - INFO - policy in effect is : [{'direction': '<>', 'protocol': 'tcp', 'dest_network': 'ctest-vnet0-16199476', 'source_network': 'ctest-vnet1-50122070', 'dst_ports': 'any', 'simple_action': 'pass', 'src_ports': 'any'}, {'direction': '<>', 'protocol': 'udp', 'dest_network': 'ctest-vnet0-16199476', 'source_network': 'ctest-vnet1-50122070', 'dst_ports': 'any', 'simple_action': 'deny', 'src_ports': 'any'}, {'direction': '<>', 'protocol': 'icmp', 'dest_network': 'ctest-vnet0-16199476', 'source_network': 'ctest-vnet1-50122070', 'dst_ports': 'any', 'simple_action': 'deny', 'src_ports': 'any'}, {'direction': '<>', 'protocol': '58', 'dest_network': 'ctest-vnet0-16199476', 'source_network': 'ctest-vnet1-50122070', 'dst_ports': 'any', 'simple_action': 'deny', 'src_ports': 'any'}] 2026-05-27 16:53:41,165 - INFO - matching_rule_action: {'tcp': 'pass', 'udp': 'deny', 'icmp': 'deny', '58': 'deny'} 2026-05-27 16:53:41,165 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-27 16:53:41,165 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 12.1.1.3, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.242, gateway password: c0ntrail123 2026-05-27 16:53:41,165 - DEBUG - ping -s 56 -c 3 -W 1 12.1.1.3 2026-05-27 16:53:44,732 - DEBUG - PING 12.1.1.3 (12.1.1.3) 56(84) bytes of data. --- 12.1.1.3 ping statistics --- 3 packets transmitted, 0 received, 100% packet loss, time 1999ms 2026-05-27 16:53:44,732 - WARNING - Ping to IP 12.1.1.3 from VM ctest-vmc0-59605636 failed 2026-05-27 16:53:44,732 - DEBUG - Running remote_cmd, Cmd : ping6 -s 56 -c 3 -W 1 3d60:606d:edf7:ed89:18f6:9e33:0:3, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.242, gateway password: c0ntrail123 2026-05-27 16:53:44,732 - DEBUG - ping6 -s 56 -c 3 -W 1 3d60:606d:edf7:ed89:18f6:9e33:0:3 2026-05-27 16:53:48,313 - DEBUG - PING 3d60:606d:edf7:ed89:18f6:9e33:0:3(3d60:606d:edf7:ed89:18f6:9e33:0:3) 56 data bytes --- 3d60:606d:edf7:ed89:18f6:9e33:0:3 ping statistics --- 3 packets transmitted, 0 received, 100% packet loss, time 2015ms 2026-05-27 16:53:48,313 - WARNING - Ping to IP 3d60:606d:edf7:ed89:18f6:9e33:0:3 from VM ctest-vmc0-59605636 failed 2026-05-27 16:53:48,313 - INFO - vm ping test result after policy for ctest-vnet0-16199476 updated to policy2 is: True 2026-05-27 16:53:48,463 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': '0f03d5dd-12ad-4ed7-b0b5-2104d06c0b62', 'name': 'ctest-vnet0-16199476', 'tenant_id': '552f6fc8eb734d0ab47dad0f2b09e833', 'project_id': '552f6fc8eb734d0ab47dad0f2b09e833', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['347c7373-9181-44c2-947d-d1170bc3ad17', '95e1b3f5-d8d5-423a-b523-4756dcb32e8f', '0ada5b4d-f2e4-4f64-9b29-f89fa292df4f'], 'fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-87114749', 'ctest-vnet0-16199476'], 'policys': [['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-87114749', 'policy3']], 'subnet_ipam': [{'subnet_cidr': '10.1.1.0/24', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-87114749', 'ctest-TestDetailedPolicy1Ipv4v6-87114749-default-ipam']}, {'subnet_cidr': '11.1.1.0/24', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-87114749', 'ctest-TestDetailedPolicy1Ipv4v6-87114749-default-ipam']}, {'subnet_cidr': '25d7:f14e:f367:707d:3ecb:212f::/96', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-87114749', 'ctest-TestDetailedPolicy1Ipv4v6-87114749-default-ipam']}], 'port_security_enabled': True, 'description': ''}} 2026-05-27 16:53:53,571 - INFO - new policy list of vn ctest-vnet0-16199476 is policy3 2026-05-27 16:53:53,572 - INFO - Starting Verifications after policy for ctest-vnet0-16199476 updated to policy3 2026-05-27 16:53:53,572 - INFO - policy in effect is : [{'direction': '<>', 'protocol': 'tcp', 'dest_network': 'ctest-vnet0-16199476', 'source_network': 'ctest-vnet1-50122070', 'dst_ports': 'any', 'simple_action': 'pass', 'src_ports': 'any'}, {'direction': '<>', 'protocol': 'udp', 'dest_network': 'ctest-vnet0-16199476', 'source_network': 'ctest-vnet1-50122070', 'dst_ports': 'any', 'simple_action': 'deny', 'src_ports': 'any'}, {'direction': '<>', 'protocol': 'icmp', 'dest_network': 'ctest-vnet0-16199476', 'source_network': 'ctest-vnet1-50122070', 'dst_ports': 'any', 'simple_action': 'pass', 'src_ports': 'any'}, {'direction': '<>', 'protocol': '58', 'dest_network': 'ctest-vnet0-16199476', 'source_network': 'ctest-vnet1-50122070', 'dst_ports': 'any', 'simple_action': 'pass', 'src_ports': 'any'}] 2026-05-27 16:53:53,572 - INFO - matching_rule_action: {'tcp': 'pass', 'udp': 'deny', 'icmp': 'pass', '58': 'pass'} 2026-05-27 16:53:53,572 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-27 16:53:53,572 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 12.1.1.3, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.242, gateway password: c0ntrail123 2026-05-27 16:53:53,572 - DEBUG - ping -s 56 -c 3 -W 1 12.1.1.3 2026-05-27 16:53:56,172 - DEBUG - PING 12.1.1.3 (12.1.1.3) 56(84) bytes of data. 64 bytes from 12.1.1.3: icmp_req=1 ttl=63 time=4.01 ms 64 bytes from 12.1.1.3: icmp_req=2 ttl=63 time=1.62 ms 64 bytes from 12.1.1.3: icmp_req=3 ttl=63 time=1.49 ms --- 12.1.1.3 ping statistics --- 3 packets transmitted, 3 received, 0% packet loss, time 2003ms rtt min/avg/max/mdev = 1.495/2.377/4.011/1.157 ms 2026-05-27 16:53:56,173 - INFO - Ping to IP 12.1.1.3 from VM ctest-vmc0-59605636 passed 2026-05-27 16:53:56,173 - DEBUG - Running remote_cmd, Cmd : ping6 -s 56 -c 3 -W 1 3d60:606d:edf7:ed89:18f6:9e33:0:3, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.242, gateway password: c0ntrail123 2026-05-27 16:53:56,173 - DEBUG - ping6 -s 56 -c 3 -W 1 3d60:606d:edf7:ed89:18f6:9e33:0:3 2026-05-27 16:53:58,722 - DEBUG - PING 3d60:606d:edf7:ed89:18f6:9e33:0:3(3d60:606d:edf7:ed89:18f6:9e33:0:3) 56 data bytes 64 bytes from 3d60:606d:edf7:ed89:18f6:9e33:0:3: icmp_seq=1 ttl=64 time=2.82 ms 64 bytes from 3d60:606d:edf7:ed89:18f6:9e33:0:3: icmp_seq=2 ttl=64 time=1.93 ms 64 bytes from 3d60:606d:edf7:ed89:18f6:9e33:0:3: icmp_seq=3 ttl=64 time=1.44 ms --- 3d60:606d:edf7:ed89:18f6:9e33:0:3 ping statistics --- 3 packets transmitted, 3 received, 0% packet loss, time 2003ms rtt min/avg/max/mdev = 1.446/2.068/2.822/0.569 ms 2026-05-27 16:53:58,722 - INFO - Ping to IP 3d60:606d:edf7:ed89:18f6:9e33:0:3 from VM ctest-vmc0-59605636 passed 2026-05-27 16:53:58,722 - INFO - vm ping test result after policy for ctest-vnet0-16199476 updated to policy3 is: True 2026-05-27 16:53:58,880 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': '0f03d5dd-12ad-4ed7-b0b5-2104d06c0b62', 'name': 'ctest-vnet0-16199476', 'tenant_id': '552f6fc8eb734d0ab47dad0f2b09e833', 'project_id': '552f6fc8eb734d0ab47dad0f2b09e833', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['347c7373-9181-44c2-947d-d1170bc3ad17', '95e1b3f5-d8d5-423a-b523-4756dcb32e8f', '0ada5b4d-f2e4-4f64-9b29-f89fa292df4f'], 'fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-87114749', 'ctest-vnet0-16199476'], 'policys': [['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-87114749', 'policy10']], 'subnet_ipam': [{'subnet_cidr': '10.1.1.0/24', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-87114749', 'ctest-TestDetailedPolicy1Ipv4v6-87114749-default-ipam']}, {'subnet_cidr': '11.1.1.0/24', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-87114749', 'ctest-TestDetailedPolicy1Ipv4v6-87114749-default-ipam']}, {'subnet_cidr': '25d7:f14e:f367:707d:3ecb:212f::/96', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-87114749', 'ctest-TestDetailedPolicy1Ipv4v6-87114749-default-ipam']}], 'port_security_enabled': True, 'description': ''}} 2026-05-27 16:54:04,032 - INFO - new policy list of vn ctest-vnet0-16199476 is policy10 2026-05-27 16:54:04,032 - INFO - Starting Verifications after policy for ctest-vnet0-16199476 updated to policy10 2026-05-27 16:54:04,033 - INFO - policy in effect is : [{'direction': '<>', 'protocol': 'udp', 'dest_network': 'ctest-vnet0-16199476', 'source_network': 'ctest-vnet1-50122070', 'dst_ports': 'any', 'simple_action': 'deny', 'src_ports': 'any'}, {'direction': '<>', 'protocol': 'tcp', 'dest_network': 'ctest-vnet0-16199476', 'source_network': 'ctest-vnet1-50122070', 'dst_ports': 'any', 'simple_action': 'deny', 'src_ports': 'any'}, {'direction': '<>', 'protocol': 'icmp', 'dest_network': 'ctest-vnet0-16199476', 'source_network': 'ctest-vnet1-50122070', 'dst_ports': 'any', 'simple_action': 'deny', 'src_ports': 'any'}, {'direction': '<>', 'protocol': '58', 'dest_network': 'ctest-vnet0-16199476', 'source_network': 'ctest-vnet1-50122070', 'dst_ports': 'any', 'simple_action': 'deny', 'src_ports': 'any'}] 2026-05-27 16:54:04,033 - INFO - matching_rule_action: {'udp': 'deny', 'tcp': 'deny', 'icmp': 'deny', '58': 'deny'} 2026-05-27 16:54:04,033 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-27 16:54:04,033 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 12.1.1.3, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.242, gateway password: c0ntrail123 2026-05-27 16:54:04,033 - DEBUG - ping -s 56 -c 3 -W 1 12.1.1.3 2026-05-27 16:54:07,530 - DEBUG - PING 12.1.1.3 (12.1.1.3) 56(84) bytes of data. --- 12.1.1.3 ping statistics --- 3 packets transmitted, 0 received, 100% packet loss, time 2000ms 2026-05-27 16:54:07,530 - WARNING - Ping to IP 12.1.1.3 from VM ctest-vmc0-59605636 failed 2026-05-27 16:54:07,531 - DEBUG - Running remote_cmd, Cmd : ping6 -s 56 -c 3 -W 1 3d60:606d:edf7:ed89:18f6:9e33:0:3, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.242, gateway password: c0ntrail123 2026-05-27 16:54:07,531 - DEBUG - ping6 -s 56 -c 3 -W 1 3d60:606d:edf7:ed89:18f6:9e33:0:3 2026-05-27 16:54:11,492 - DEBUG - PING 3d60:606d:edf7:ed89:18f6:9e33:0:3(3d60:606d:edf7:ed89:18f6:9e33:0:3) 56 data bytes --- 3d60:606d:edf7:ed89:18f6:9e33:0:3 ping statistics --- 3 packets transmitted, 0 received, 100% packet loss, time 2029ms 2026-05-27 16:54:11,492 - WARNING - Ping to IP 3d60:606d:edf7:ed89:18f6:9e33:0:3 from VM ctest-vmc0-59605636 failed 2026-05-27 16:54:11,493 - INFO - vm ping test result after policy for ctest-vnet0-16199476 updated to policy10 is: True 2026-05-27 16:54:11,652 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': '0f03d5dd-12ad-4ed7-b0b5-2104d06c0b62', 'name': 'ctest-vnet0-16199476', 'tenant_id': '552f6fc8eb734d0ab47dad0f2b09e833', 'project_id': '552f6fc8eb734d0ab47dad0f2b09e833', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['347c7373-9181-44c2-947d-d1170bc3ad17', '95e1b3f5-d8d5-423a-b523-4756dcb32e8f', '0ada5b4d-f2e4-4f64-9b29-f89fa292df4f'], 'fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-87114749', 'ctest-vnet0-16199476'], 'policys': [['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-87114749', 'policy11']], 'subnet_ipam': [{'subnet_cidr': '10.1.1.0/24', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-87114749', 'ctest-TestDetailedPolicy1Ipv4v6-87114749-default-ipam']}, {'subnet_cidr': '11.1.1.0/24', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-87114749', 'ctest-TestDetailedPolicy1Ipv4v6-87114749-default-ipam']}, {'subnet_cidr': '25d7:f14e:f367:707d:3ecb:212f::/96', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-87114749', 'ctest-TestDetailedPolicy1Ipv4v6-87114749-default-ipam']}], 'port_security_enabled': True, 'description': ''}} 2026-05-27 16:54:16,779 - INFO - new policy list of vn ctest-vnet0-16199476 is policy11 2026-05-27 16:54:16,780 - INFO - Starting Verifications after policy for ctest-vnet0-16199476 updated to policy11 2026-05-27 16:54:16,780 - INFO - policy in effect is : [{'direction': '<>', 'protocol': 'udp', 'dest_network': 'ctest-vnet0-16199476', 'source_network': 'ctest-vnet1-50122070', 'dst_ports': 'any', 'simple_action': 'deny', 'src_ports': 'any'}, {'direction': '<>', 'protocol': 'tcp', 'dest_network': 'ctest-vnet0-16199476', 'source_network': 'ctest-vnet1-50122070', 'dst_ports': 'any', 'simple_action': 'deny', 'src_ports': 'any'}, {'direction': '<>', 'protocol': 'icmp', 'dest_network': 'ctest-vnet0-16199476', 'source_network': 'ctest-vnet1-50122070', 'dst_ports': 'any', 'simple_action': 'pass', 'src_ports': 'any'}, {'direction': '<>', 'protocol': '58', 'dest_network': 'ctest-vnet0-16199476', 'source_network': 'ctest-vnet1-50122070', 'dst_ports': 'any', 'simple_action': 'pass', 'src_ports': 'any'}] 2026-05-27 16:54:16,780 - INFO - matching_rule_action: {'udp': 'deny', 'tcp': 'deny', 'icmp': 'pass', '58': 'pass'} 2026-05-27 16:54:16,780 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-27 16:54:16,780 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 12.1.1.3, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.242, gateway password: c0ntrail123 2026-05-27 16:54:16,780 - DEBUG - ping -s 56 -c 3 -W 1 12.1.1.3 2026-05-27 16:54:19,342 - DEBUG - PING 12.1.1.3 (12.1.1.3) 56(84) bytes of data. 64 bytes from 12.1.1.3: icmp_req=1 ttl=63 time=6.51 ms 64 bytes from 12.1.1.3: icmp_req=2 ttl=63 time=1.51 ms 64 bytes from 12.1.1.3: icmp_req=3 ttl=63 time=1.34 ms --- 12.1.1.3 ping statistics --- 3 packets transmitted, 3 received, 0% packet loss, time 2004ms rtt min/avg/max/mdev = 1.347/3.125/6.515/2.398 ms 2026-05-27 16:54:19,342 - INFO - Ping to IP 12.1.1.3 from VM ctest-vmc0-59605636 passed 2026-05-27 16:54:19,342 - DEBUG - Running remote_cmd, Cmd : ping6 -s 56 -c 3 -W 1 3d60:606d:edf7:ed89:18f6:9e33:0:3, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.242, gateway password: c0ntrail123 2026-05-27 16:54:19,342 - DEBUG - ping6 -s 56 -c 3 -W 1 3d60:606d:edf7:ed89:18f6:9e33:0:3 2026-05-27 16:54:21,929 - DEBUG - PING 3d60:606d:edf7:ed89:18f6:9e33:0:3(3d60:606d:edf7:ed89:18f6:9e33:0:3) 56 data bytes 64 bytes from 3d60:606d:edf7:ed89:18f6:9e33:0:3: icmp_seq=1 ttl=64 time=3.36 ms 64 bytes from 3d60:606d:edf7:ed89:18f6:9e33:0:3: icmp_seq=2 ttl=64 time=1.50 ms 64 bytes from 3d60:606d:edf7:ed89:18f6:9e33:0:3: icmp_seq=3 ttl=64 time=1.47 ms --- 3d60:606d:edf7:ed89:18f6:9e33:0:3 ping statistics --- 3 packets transmitted, 3 received, 0% packet loss, time 2004ms rtt min/avg/max/mdev = 1.479/2.115/3.360/0.880 ms 2026-05-27 16:54:21,929 - INFO - Ping to IP 3d60:606d:edf7:ed89:18f6:9e33:0:3 from VM ctest-vmc0-59605636 passed 2026-05-27 16:54:21,929 - INFO - vm ping test result after policy for ctest-vnet0-16199476 updated to policy11 is: True 2026-05-27 16:54:22,100 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': '0f03d5dd-12ad-4ed7-b0b5-2104d06c0b62', 'name': 'ctest-vnet0-16199476', 'tenant_id': '552f6fc8eb734d0ab47dad0f2b09e833', 'project_id': '552f6fc8eb734d0ab47dad0f2b09e833', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['347c7373-9181-44c2-947d-d1170bc3ad17', '95e1b3f5-d8d5-423a-b523-4756dcb32e8f', '0ada5b4d-f2e4-4f64-9b29-f89fa292df4f'], 'fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-87114749', 'ctest-vnet0-16199476'], 'policys': [['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-87114749', 'policy12']], 'subnet_ipam': [{'subnet_cidr': '10.1.1.0/24', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-87114749', 'ctest-TestDetailedPolicy1Ipv4v6-87114749-default-ipam']}, {'subnet_cidr': '11.1.1.0/24', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-87114749', 'ctest-TestDetailedPolicy1Ipv4v6-87114749-default-ipam']}, {'subnet_cidr': '25d7:f14e:f367:707d:3ecb:212f::/96', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-87114749', 'ctest-TestDetailedPolicy1Ipv4v6-87114749-default-ipam']}], 'port_security_enabled': True, 'description': ''}} 2026-05-27 16:54:27,212 - INFO - new policy list of vn ctest-vnet0-16199476 is policy12 2026-05-27 16:54:27,213 - INFO - Starting Verifications after policy for ctest-vnet0-16199476 updated to policy12 2026-05-27 16:54:27,213 - INFO - policy in effect is : [{'direction': '<>', 'protocol': 'tcp', 'dest_network': 'ctest-vnet0-16199476', 'source_network': 'ctest-vnet1-50122070', 'dst_ports': 'any', 'simple_action': 'deny', 'src_ports': 'any'}, {'direction': '<>', 'protocol': 'udp', 'dest_network': 'ctest-vnet0-16199476', 'source_network': 'ctest-vnet1-50122070', 'dst_ports': 'any', 'simple_action': 'pass', 'src_ports': 'any'}, {'direction': '<>', 'protocol': 'icmp', 'dest_network': 'ctest-vnet0-16199476', 'source_network': 'ctest-vnet1-50122070', 'dst_ports': 'any', 'simple_action': 'deny', 'src_ports': 'any'}, {'direction': '<>', 'protocol': '58', 'dest_network': 'ctest-vnet0-16199476', 'source_network': 'ctest-vnet1-50122070', 'dst_ports': 'any', 'simple_action': 'deny', 'src_ports': 'any'}] 2026-05-27 16:54:27,213 - INFO - matching_rule_action: {'tcp': 'deny', 'udp': 'pass', 'icmp': 'deny', '58': 'deny'} 2026-05-27 16:54:27,213 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-27 16:54:27,213 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 12.1.1.3, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.242, gateway password: c0ntrail123 2026-05-27 16:54:27,213 - DEBUG - ping -s 56 -c 3 -W 1 12.1.1.3 2026-05-27 16:54:30,703 - DEBUG - PING 12.1.1.3 (12.1.1.3) 56(84) bytes of data. --- 12.1.1.3 ping statistics --- 3 packets transmitted, 0 received, 100% packet loss, time 2015ms 2026-05-27 16:54:30,703 - WARNING - Ping to IP 12.1.1.3 from VM ctest-vmc0-59605636 failed 2026-05-27 16:54:30,703 - DEBUG - Running remote_cmd, Cmd : ping6 -s 56 -c 3 -W 1 3d60:606d:edf7:ed89:18f6:9e33:0:3, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.242, gateway password: c0ntrail123 2026-05-27 16:54:30,703 - DEBUG - ping6 -s 56 -c 3 -W 1 3d60:606d:edf7:ed89:18f6:9e33:0:3 2026-05-27 16:54:34,383 - DEBUG - PING 3d60:606d:edf7:ed89:18f6:9e33:0:3(3d60:606d:edf7:ed89:18f6:9e33:0:3) 56 data bytes --- 3d60:606d:edf7:ed89:18f6:9e33:0:3 ping statistics --- 3 packets transmitted, 0 received, 100% packet loss, time 2017ms 2026-05-27 16:54:34,383 - WARNING - Ping to IP 3d60:606d:edf7:ed89:18f6:9e33:0:3 from VM ctest-vmc0-59605636 failed 2026-05-27 16:54:34,383 - INFO - vm ping test result after policy for ctest-vnet0-16199476 updated to policy12 is: True 2026-05-27 16:54:34,553 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': '0f03d5dd-12ad-4ed7-b0b5-2104d06c0b62', 'name': 'ctest-vnet0-16199476', 'tenant_id': '552f6fc8eb734d0ab47dad0f2b09e833', 'project_id': '552f6fc8eb734d0ab47dad0f2b09e833', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['347c7373-9181-44c2-947d-d1170bc3ad17', '95e1b3f5-d8d5-423a-b523-4756dcb32e8f', '0ada5b4d-f2e4-4f64-9b29-f89fa292df4f'], 'fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-87114749', 'ctest-vnet0-16199476'], 'policys': [['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-87114749', 'policy13']], 'subnet_ipam': [{'subnet_cidr': '10.1.1.0/24', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-87114749', 'ctest-TestDetailedPolicy1Ipv4v6-87114749-default-ipam']}, {'subnet_cidr': '11.1.1.0/24', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-87114749', 'ctest-TestDetailedPolicy1Ipv4v6-87114749-default-ipam']}, {'subnet_cidr': '25d7:f14e:f367:707d:3ecb:212f::/96', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-87114749', 'ctest-TestDetailedPolicy1Ipv4v6-87114749-default-ipam']}], 'port_security_enabled': True, 'description': ''}} 2026-05-27 16:54:39,661 - INFO - new policy list of vn ctest-vnet0-16199476 is policy13 2026-05-27 16:54:39,662 - INFO - Starting Verifications after policy for ctest-vnet0-16199476 updated to policy13 2026-05-27 16:54:39,662 - INFO - policy in effect is : [{'direction': '<>', 'protocol': 'udp', 'dest_network': 'ctest-vnet0-16199476', 'source_network': 'ctest-vnet1-50122070', 'dst_ports': 'any', 'simple_action': 'pass', 'src_ports': 'any'}, {'direction': '<>', 'protocol': 'icmp', 'dest_network': 'ctest-vnet0-16199476', 'source_network': 'ctest-vnet1-50122070', 'dst_ports': 'any', 'simple_action': 'pass', 'src_ports': 'any'}, {'direction': '<>', 'protocol': 'tcp', 'dest_network': 'ctest-vnet0-16199476', 'source_network': 'ctest-vnet1-50122070', 'dst_ports': 'any', 'simple_action': 'deny', 'src_ports': 'any'}, {'direction': '<>', 'protocol': '58', 'dest_network': 'ctest-vnet0-16199476', 'source_network': 'ctest-vnet1-50122070', 'dst_ports': 'any', 'simple_action': 'pass', 'src_ports': 'any'}] 2026-05-27 16:54:39,662 - INFO - matching_rule_action: {'udp': 'pass', 'icmp': 'pass', 'tcp': 'deny', '58': 'pass'} 2026-05-27 16:54:39,662 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-27 16:54:39,662 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 12.1.1.3, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.242, gateway password: c0ntrail123 2026-05-27 16:54:39,662 - DEBUG - ping -s 56 -c 3 -W 1 12.1.1.3 2026-05-27 16:54:42,181 - DEBUG - PING 12.1.1.3 (12.1.1.3) 56(84) bytes of data. 64 bytes from 12.1.1.3: icmp_req=1 ttl=63 time=3.77 ms 64 bytes from 12.1.1.3: icmp_req=2 ttl=63 time=1.37 ms 64 bytes from 12.1.1.3: icmp_req=3 ttl=63 time=1.37 ms --- 12.1.1.3 ping statistics --- 3 packets transmitted, 3 received, 0% packet loss, time 2003ms rtt min/avg/max/mdev = 1.370/2.171/3.771/1.132 ms 2026-05-27 16:54:42,181 - INFO - Ping to IP 12.1.1.3 from VM ctest-vmc0-59605636 passed 2026-05-27 16:54:42,181 - DEBUG - Running remote_cmd, Cmd : ping6 -s 56 -c 3 -W 1 3d60:606d:edf7:ed89:18f6:9e33:0:3, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.242, gateway password: c0ntrail123 2026-05-27 16:54:42,181 - DEBUG - ping6 -s 56 -c 3 -W 1 3d60:606d:edf7:ed89:18f6:9e33:0:3 2026-05-27 16:54:44,716 - DEBUG - PING 3d60:606d:edf7:ed89:18f6:9e33:0:3(3d60:606d:edf7:ed89:18f6:9e33:0:3) 56 data bytes 64 bytes from 3d60:606d:edf7:ed89:18f6:9e33:0:3: icmp_seq=1 ttl=64 time=2.85 ms 64 bytes from 3d60:606d:edf7:ed89:18f6:9e33:0:3: icmp_seq=2 ttl=64 time=1.32 ms 64 bytes from 3d60:606d:edf7:ed89:18f6:9e33:0:3: icmp_seq=3 ttl=64 time=1.53 ms --- 3d60:606d:edf7:ed89:18f6:9e33:0:3 ping statistics --- 3 packets transmitted, 3 received, 0% packet loss, time 2003ms rtt min/avg/max/mdev = 1.327/1.905/2.856/0.679 ms 2026-05-27 16:54:44,716 - INFO - Ping to IP 3d60:606d:edf7:ed89:18f6:9e33:0:3 from VM ctest-vmc0-59605636 passed 2026-05-27 16:54:44,716 - INFO - vm ping test result after policy for ctest-vnet0-16199476 updated to policy13 is: True 2026-05-27 16:54:44,914 - INFO - Deleting VM ctest-vmc1-80121674 2026-05-27 16:54:45,037 - DEBUG - Verifying in api server 10.0.0.129 2026-05-27 16:54:45,037 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-machine/cd0d0faa-71f4-43b5-8fdb-2fb0c1eb07ec 2026-05-27 16:54:45,047 - DEBUG - VM ID cd0d0faa-71f4-43b5-8fdb-2fb0c1eb07ec of VM ctest-vmc1-80121674 is still found in API Server 2026-05-27 16:54:47,047 - DEBUG - Verifying in api server 10.0.0.129 2026-05-27 16:54:47,047 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-machine/cd0d0faa-71f4-43b5-8fdb-2fb0c1eb07ec 2026-05-27 16:54:47,055 - DEBUG - Response Code: 404 2026-05-27 16:54:47,055 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-machine/cd0d0faa-71f4-43b5-8fdb-2fb0c1eb07ec 2026-05-27 16:54:47,062 - DEBUG - Response Code: 404 2026-05-27 16:54:47,062 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-machine/cd0d0faa-71f4-43b5-8fdb-2fb0c1eb07ec 2026-05-27 16:54:47,069 - DEBUG - Response Code: 404 2026-05-27 16:54:47,069 - INFO - VM ctest-vmc1-80121674 is fully removed in API-Server 2026-05-27 16:54:47,222 - DEBUG - Skipping VM-deletion-check in nova db since mysql_token is not found 2026-05-27 16:54:47,269 - DEBUG - Validated that vrouter 10.0.0.241 does not have VMs route for VN default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet1-50122070 2026-05-27 16:54:47,282 - DEBUG - Validated that vrouter 10.0.0.242 does not have VMs route for VN default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet1-50122070 2026-05-27 16:54:47,282 - INFO - Validated that all vrouters do not have VMs route for VN default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet1-50122070 2026-05-27 16:54:47,282 - INFO - VM ctest-vmc1-80121674 is removed in Compute, and routes are removed in all compute nodes 2026-05-27 16:54:47,524 - INFO - Routes for VM ctest-vmc1-80121674 is removed in all control-nodes 2026-05-27 16:54:47,524 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5832-1:Compute:contrail-vrouter-agent:0?flat 2026-05-27 16:54:47,562 - DEBUG - Requesting: http://10.0.0.129:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5832-1?flat 2026-05-27 16:54:47,591 - DEBUG - VM cd0d0faa-71f4-43b5-8fdb-2fb0c1eb07ec is still present in vrouter an-jenkins-deploy-platform-ansible-os-5832-1 uve 2026-05-27 16:54:47,591 - DEBUG - Verifying if the vm interface deleted from vroter uve... 2026-05-27 16:54:47,592 - DEBUG - interface for vm cd0d0faa-71f4-43b5-8fdb-2fb0c1eb07ec deleted from vrouter uve ... 2026-05-27 16:54:47,592 - DEBUG - Deleted interface not in error interface list ... 2026-05-27 16:54:50,593 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5832-1:Compute:contrail-vrouter-agent:0?flat 2026-05-27 16:54:50,690 - DEBUG - Requesting: http://10.0.0.129:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5832-1?flat 2026-05-27 16:54:50,777 - DEBUG - VM cd0d0faa-71f4-43b5-8fdb-2fb0c1eb07ec is still present in vrouter an-jenkins-deploy-platform-ansible-os-5832-1 uve 2026-05-27 16:54:50,777 - DEBUG - Verifying if the vm interface deleted from vroter uve... 2026-05-27 16:54:50,777 - DEBUG - interface for vm cd0d0faa-71f4-43b5-8fdb-2fb0c1eb07ec deleted from vrouter uve ... 2026-05-27 16:54:50,777 - DEBUG - Deleted interface not in error interface list ... 2026-05-27 16:54:53,778 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5832-1:Compute:contrail-vrouter-agent:0?flat 2026-05-27 16:54:53,820 - DEBUG - Requesting: http://10.0.0.129:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5832-1?flat 2026-05-27 16:54:53,853 - DEBUG - VM cd0d0faa-71f4-43b5-8fdb-2fb0c1eb07ec is not present in vrouter an-jenkins-deploy-platform-ansible-os-5832-1 uve 2026-05-27 16:54:53,853 - DEBUG - Verifying if the vm interface deleted from vroter uve... 2026-05-27 16:54:53,853 - DEBUG - interface for vm cd0d0faa-71f4-43b5-8fdb-2fb0c1eb07ec deleted from vrouter uve ... 2026-05-27 16:54:53,854 - DEBUG - Deleted interface not in error interface list ... 2026-05-27 16:54:53,854 - DEBUG - Validated that VM cd0d0faa-71f4-43b5-8fdb-2fb0c1eb07ec is removed in Vrouter UVE 2026-05-27 16:54:53,854 - DEBUG - Verifying through opserver in 10.0.0.50 2026-05-27 16:54:53,854 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet1-50122070?flat 2026-05-27 16:54:53,877 - DEBUG - cd0d0faa-71f4-43b5-8fdb-2fb0c1eb07ec BM not in default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet1-50122070 uve 2026-05-27 16:54:53,877 - DEBUG - Validated that VM cd0d0faa-71f4-43b5-8fdb-2fb0c1eb07ec is not present in the VN UVE 2026-05-27 16:54:53,877 - DEBUG - Verifying the cd0d0faa-71f4-43b5-8fdb-2fb0c1eb07ec virtual network link through opserver 10.0.0.50 2026-05-27 16:54:53,877 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-machines 2026-05-27 16:54:53,890 - INFO - cd0d0faa-71f4-43b5-8fdb-2fb0c1eb07ec vm uve deleted from opserver 2026-05-27 16:54:53,890 - DEBUG - Verifying the cd0d0faa-71f4-43b5-8fdb-2fb0c1eb07ec virtual network link through opserver 10.0.0.22 2026-05-27 16:54:53,890 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-machines 2026-05-27 16:54:53,906 - INFO - cd0d0faa-71f4-43b5-8fdb-2fb0c1eb07ec vm uve deleted from opserver 2026-05-27 16:54:53,906 - DEBUG - Verifying the cd0d0faa-71f4-43b5-8fdb-2fb0c1eb07ec virtual network link through opserver 10.0.0.129 2026-05-27 16:54:53,906 - DEBUG - Requesting: http://10.0.0.129:8081/analytics/uves/virtual-machines 2026-05-27 16:54:53,923 - INFO - cd0d0faa-71f4-43b5-8fdb-2fb0c1eb07ec vm uve deleted from opserver 2026-05-27 16:54:53,923 - INFO - Validated that VM cd0d0faa-71f4-43b5-8fdb-2fb0c1eb07ec is removed from Opserver 2026-05-27 16:54:53,923 - INFO - Deleting VM ctest-vmc0-59605636 2026-05-27 16:54:53,999 - DEBUG - Verifying in api server 10.0.0.129 2026-05-27 16:54:53,999 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-machine/57a5f1a1-e8df-4270-acc1-ad7d2c4c1149 2026-05-27 16:54:54,011 - DEBUG - VM ID 57a5f1a1-e8df-4270-acc1-ad7d2c4c1149 of VM ctest-vmc0-59605636 is still found in API Server 2026-05-27 16:54:56,012 - DEBUG - Verifying in api server 10.0.0.129 2026-05-27 16:54:56,012 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-machine/57a5f1a1-e8df-4270-acc1-ad7d2c4c1149 2026-05-27 16:54:56,021 - DEBUG - Response Code: 404 2026-05-27 16:54:56,021 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-machine/57a5f1a1-e8df-4270-acc1-ad7d2c4c1149 2026-05-27 16:54:56,028 - DEBUG - Response Code: 404 2026-05-27 16:54:56,028 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-machine/57a5f1a1-e8df-4270-acc1-ad7d2c4c1149 2026-05-27 16:54:56,035 - DEBUG - Response Code: 404 2026-05-27 16:54:56,035 - INFO - VM ctest-vmc0-59605636 is fully removed in API-Server 2026-05-27 16:54:56,198 - DEBUG - Skipping VM-deletion-check in nova db since mysql_token is not found 2026-05-27 16:54:56,246 - DEBUG - Validated that vrouter 10.0.0.241 does not have VMs route for VN default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476 2026-05-27 16:54:56,257 - DEBUG - Validated that vrouter 10.0.0.242 does not have VMs route for VN default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476 2026-05-27 16:54:56,257 - INFO - Validated that all vrouters do not have VMs route for VN default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476 2026-05-27 16:54:56,258 - INFO - VM ctest-vmc0-59605636 is removed in Compute, and routes are removed in all compute nodes 2026-05-27 16:54:56,496 - INFO - Routes for VM ctest-vmc0-59605636 is removed in all control-nodes 2026-05-27 16:54:56,497 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5832-2:Compute:contrail-vrouter-agent:0?flat 2026-05-27 16:54:56,532 - DEBUG - Requesting: http://10.0.0.129:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5832-2?flat 2026-05-27 16:54:56,571 - DEBUG - VM 57a5f1a1-e8df-4270-acc1-ad7d2c4c1149 is still present in vrouter an-jenkins-deploy-platform-ansible-os-5832-2 uve 2026-05-27 16:54:56,571 - DEBUG - Verifying if the vm interface deleted from vroter uve... 2026-05-27 16:54:56,571 - DEBUG - interface for vm 57a5f1a1-e8df-4270-acc1-ad7d2c4c1149 deleted from vrouter uve ... 2026-05-27 16:54:56,571 - DEBUG - Deleted interface not in error interface list ... 2026-05-27 16:54:59,572 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5832-2:Compute:contrail-vrouter-agent:0?flat 2026-05-27 16:54:59,612 - DEBUG - Requesting: http://10.0.0.129:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5832-2?flat 2026-05-27 16:54:59,651 - DEBUG - VM 57a5f1a1-e8df-4270-acc1-ad7d2c4c1149 is still present in vrouter an-jenkins-deploy-platform-ansible-os-5832-2 uve 2026-05-27 16:54:59,651 - DEBUG - Verifying if the vm interface deleted from vroter uve... 2026-05-27 16:54:59,651 - DEBUG - interface for vm 57a5f1a1-e8df-4270-acc1-ad7d2c4c1149 deleted from vrouter uve ... 2026-05-27 16:54:59,651 - DEBUG - Deleted interface not in error interface list ... 2026-05-27 16:55:02,652 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5832-2:Compute:contrail-vrouter-agent:0?flat 2026-05-27 16:55:02,701 - DEBUG - Requesting: http://10.0.0.129:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5832-2?flat 2026-05-27 16:55:02,737 - DEBUG - VM 57a5f1a1-e8df-4270-acc1-ad7d2c4c1149 is still present in vrouter an-jenkins-deploy-platform-ansible-os-5832-2 uve 2026-05-27 16:55:02,737 - DEBUG - Verifying if the vm interface deleted from vroter uve... 2026-05-27 16:55:02,737 - DEBUG - interface for vm 57a5f1a1-e8df-4270-acc1-ad7d2c4c1149 deleted from vrouter uve ... 2026-05-27 16:55:02,737 - DEBUG - Deleted interface not in error interface list ... 2026-05-27 16:55:05,737 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5832-2:Compute:contrail-vrouter-agent:0?flat 2026-05-27 16:55:05,777 - DEBUG - Requesting: http://10.0.0.129:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5832-2?flat 2026-05-27 16:55:05,813 - DEBUG - VM 57a5f1a1-e8df-4270-acc1-ad7d2c4c1149 is still present in vrouter an-jenkins-deploy-platform-ansible-os-5832-2 uve 2026-05-27 16:55:05,813 - DEBUG - Verifying if the vm interface deleted from vroter uve... 2026-05-27 16:55:05,813 - DEBUG - interface for vm 57a5f1a1-e8df-4270-acc1-ad7d2c4c1149 deleted from vrouter uve ... 2026-05-27 16:55:05,813 - DEBUG - Deleted interface not in error interface list ... 2026-05-27 16:55:08,813 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5832-2:Compute:contrail-vrouter-agent:0?flat 2026-05-27 16:55:08,851 - DEBUG - Requesting: http://10.0.0.129:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5832-2?flat 2026-05-27 16:55:08,883 - DEBUG - VM 57a5f1a1-e8df-4270-acc1-ad7d2c4c1149 is still present in vrouter an-jenkins-deploy-platform-ansible-os-5832-2 uve 2026-05-27 16:55:08,883 - DEBUG - Verifying if the vm interface deleted from vroter uve... 2026-05-27 16:55:08,883 - DEBUG - interface for vm 57a5f1a1-e8df-4270-acc1-ad7d2c4c1149 deleted from vrouter uve ... 2026-05-27 16:55:08,883 - DEBUG - Deleted interface not in error interface list ... 2026-05-27 16:55:11,884 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5832-2:Compute:contrail-vrouter-agent:0?flat 2026-05-27 16:55:11,927 - DEBUG - Requesting: http://10.0.0.129:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5832-2?flat 2026-05-27 16:55:11,961 - DEBUG - VM 57a5f1a1-e8df-4270-acc1-ad7d2c4c1149 is still present in vrouter an-jenkins-deploy-platform-ansible-os-5832-2 uve 2026-05-27 16:55:11,962 - DEBUG - Verifying if the vm interface deleted from vroter uve... 2026-05-27 16:55:11,962 - DEBUG - interface for vm 57a5f1a1-e8df-4270-acc1-ad7d2c4c1149 deleted from vrouter uve ... 2026-05-27 16:55:11,962 - DEBUG - Deleted interface not in error interface list ... 2026-05-27 16:55:14,962 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5832-2:Compute:contrail-vrouter-agent:0?flat 2026-05-27 16:55:14,998 - DEBUG - Requesting: http://10.0.0.129:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5832-2?flat 2026-05-27 16:55:15,032 - DEBUG - VM 57a5f1a1-e8df-4270-acc1-ad7d2c4c1149 is still present in vrouter an-jenkins-deploy-platform-ansible-os-5832-2 uve 2026-05-27 16:55:15,032 - DEBUG - Verifying if the vm interface deleted from vroter uve... 2026-05-27 16:55:15,032 - DEBUG - interface for vm 57a5f1a1-e8df-4270-acc1-ad7d2c4c1149 deleted from vrouter uve ... 2026-05-27 16:55:15,032 - DEBUG - Deleted interface not in error interface list ... 2026-05-27 16:55:18,033 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5832-2:Compute:contrail-vrouter-agent:0?flat 2026-05-27 16:55:18,069 - DEBUG - Requesting: http://10.0.0.129:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5832-2?flat 2026-05-27 16:55:18,110 - DEBUG - VM 57a5f1a1-e8df-4270-acc1-ad7d2c4c1149 is still present in vrouter an-jenkins-deploy-platform-ansible-os-5832-2 uve 2026-05-27 16:55:18,110 - DEBUG - Verifying if the vm interface deleted from vroter uve... 2026-05-27 16:55:18,110 - DEBUG - interface for vm 57a5f1a1-e8df-4270-acc1-ad7d2c4c1149 deleted from vrouter uve ... 2026-05-27 16:55:18,110 - DEBUG - Deleted interface not in error interface list ... 2026-05-27 16:55:21,111 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5832-2:Compute:contrail-vrouter-agent:0?flat 2026-05-27 16:55:21,148 - DEBUG - Requesting: http://10.0.0.129:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5832-2?flat 2026-05-27 16:55:21,180 - DEBUG - VM 57a5f1a1-e8df-4270-acc1-ad7d2c4c1149 is not present in vrouter an-jenkins-deploy-platform-ansible-os-5832-2 uve 2026-05-27 16:55:21,180 - DEBUG - Verifying if the vm interface deleted from vroter uve... 2026-05-27 16:55:21,180 - DEBUG - interface for vm 57a5f1a1-e8df-4270-acc1-ad7d2c4c1149 deleted from vrouter uve ... 2026-05-27 16:55:21,180 - DEBUG - Deleted interface not in error interface list ... 2026-05-27 16:55:21,180 - DEBUG - Validated that VM 57a5f1a1-e8df-4270-acc1-ad7d2c4c1149 is removed in Vrouter UVE 2026-05-27 16:55:21,180 - DEBUG - Verifying through opserver in 10.0.0.50 2026-05-27 16:55:21,180 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476?flat 2026-05-27 16:55:21,199 - DEBUG - 57a5f1a1-e8df-4270-acc1-ad7d2c4c1149 BM not in default-domain:ctest-TestDetailedPolicy1Ipv4v6-87114749:ctest-vnet0-16199476 uve 2026-05-27 16:55:21,199 - DEBUG - Validated that VM 57a5f1a1-e8df-4270-acc1-ad7d2c4c1149 is not present in the VN UVE 2026-05-27 16:55:21,200 - DEBUG - Verifying the 57a5f1a1-e8df-4270-acc1-ad7d2c4c1149 virtual network link through opserver 10.0.0.50 2026-05-27 16:55:21,200 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-machines 2026-05-27 16:55:21,213 - DEBUG - No links retuned for 57a5f1a1-e8df-4270-acc1-ad7d2c4c1149 2026-05-27 16:55:21,213 - INFO - 57a5f1a1-e8df-4270-acc1-ad7d2c4c1149 vm uve deleted from opserver 2026-05-27 16:55:21,213 - DEBUG - Verifying the 57a5f1a1-e8df-4270-acc1-ad7d2c4c1149 virtual network link through opserver 10.0.0.22 2026-05-27 16:55:21,213 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-machines 2026-05-27 16:55:21,231 - DEBUG - No links retuned for 57a5f1a1-e8df-4270-acc1-ad7d2c4c1149 2026-05-27 16:55:21,231 - INFO - 57a5f1a1-e8df-4270-acc1-ad7d2c4c1149 vm uve deleted from opserver 2026-05-27 16:55:21,231 - DEBUG - Verifying the 57a5f1a1-e8df-4270-acc1-ad7d2c4c1149 virtual network link through opserver 10.0.0.129 2026-05-27 16:55:21,232 - DEBUG - Requesting: http://10.0.0.129:8081/analytics/uves/virtual-machines 2026-05-27 16:55:21,249 - DEBUG - No links retuned for 57a5f1a1-e8df-4270-acc1-ad7d2c4c1149 2026-05-27 16:55:21,249 - INFO - 57a5f1a1-e8df-4270-acc1-ad7d2c4c1149 vm uve deleted from opserver 2026-05-27 16:55:21,249 - INFO - Validated that VM 57a5f1a1-e8df-4270-acc1-ad7d2c4c1149 is removed from Opserver 2026-05-27 16:55:21,249 - DEBUG - Detaching the Policy for VN :ctest-vnet1-50122070 2026-05-27 16:55:21,249 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-05-27 16:55:21,257 - DEBUG - Requesting: http://10.0.0.50:8082/domain/dd011215-fca5-4e74-b1da-d431e9fe9325 2026-05-27 16:55:21,297 - DEBUG - Requesting: http://10.0.0.50:8082/project/552f6fc8-eb73-4d0a-b47d-ad0f2b09e833 2026-05-27 16:55:21,400 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/d7afc87e-2a30-46ce-9470-50470b14a1b8 2026-05-27 16:55:21,621 - DEBUG - Detached Policy:[['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-87114749', 'policy100']] from ctest-vnet1-50122070 2026-05-27 16:55:21,621 - DEBUG - Detaching the Policy for VN :ctest-vnet0-16199476 2026-05-27 16:55:21,621 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-05-27 16:55:21,628 - DEBUG - Requesting: http://10.0.0.50:8082/domain/dd011215-fca5-4e74-b1da-d431e9fe9325 2026-05-27 16:55:21,659 - DEBUG - Requesting: http://10.0.0.50:8082/project/552f6fc8-eb73-4d0a-b47d-ad0f2b09e833 2026-05-27 16:55:21,774 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/0f03d5dd-12ad-4ed7-b0b5-2104d06c0b62 2026-05-27 16:55:21,830 - INFO - Deleted policy policy1000 2026-05-27 16:55:21,992 - DEBUG - policy policy1000 is not found in API Server 2026-05-27 16:55:22,041 - INFO - Deleted policy policy13 2026-05-27 16:55:22,192 - DEBUG - policy policy13 is not found in API Server 2026-05-27 16:55:22,258 - INFO - Deleted policy policy12 2026-05-27 16:55:22,412 - DEBUG - policy policy12 is not found in API Server 2026-05-27 16:55:22,461 - INFO - Deleted policy policy11 2026-05-27 16:55:22,666 - DEBUG - policy policy11 is not found in API Server 2026-05-27 16:55:22,720 - INFO - Deleted policy policy10 2026-05-27 16:55:22,922 - DEBUG - policy policy10 is not found in API Server 2026-05-27 16:55:22,977 - INFO - Deleted policy policy100 2026-05-27 16:55:23,186 - DEBUG - policy policy100 is not found in API Server 2026-05-27 16:55:23,236 - INFO - Deleted policy policy3 2026-05-27 16:55:23,426 - DEBUG - policy policy3 is not found in API Server 2026-05-27 16:55:23,477 - INFO - Deleted policy policy2 2026-05-27 16:55:23,678 - DEBUG - policy policy2 is not found in API Server 2026-05-27 16:55:23,729 - INFO - Deleted policy policy1 2026-05-27 16:55:23,919 - DEBUG - policy policy1 is not found in API Server 2026-05-27 16:55:23,984 - INFO - Deleted policy policy0 2026-05-27 16:55:24,186 - DEBUG - policy policy0 is not found in API Server 2026-05-27 16:55:24,187 - INFO - Deleting VN ctest-vnet1-50122070 2026-05-27 16:55:24,433 - DEBUG - Response for deleting network () 2026-05-27 16:55:24,433 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/1687f46d-1468-4d1c-95d1-e1f408666e5b 2026-05-27 16:55:24,440 - DEBUG - Response Code: 404 2026-05-27 16:55:24,440 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-05-27 16:55:24,447 - DEBUG - Requesting: http://10.0.0.50:8082/domain/dd011215-fca5-4e74-b1da-d431e9fe9325 2026-05-27 16:55:24,461 - DEBUG - Requesting: http://10.0.0.50:8082/project/552f6fc8-eb73-4d0a-b47d-ad0f2b09e833 2026-05-27 16:55:24,562 - INFO - Validated that VN ctest-vnet1-50122070 is not found in API Server 2026-05-27 16:55:24,573 - DEBUG - VN ctest-vnet1-50122070 is not present in Agent 10.0.0.241 2026-05-27 16:55:24,587 - DEBUG - VN ctest-vnet1-50122070 is not present in Agent 10.0.0.242 2026-05-27 16:55:24,587 - INFO - Validated that VN ctest-vnet1-50122070 is not in any agent 2026-05-27 16:55:24,623 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vnet1-50122070 info 2026-05-27 16:55:24,623 - INFO - Deleting VN ctest-vnet0-16199476 2026-05-27 16:55:24,847 - DEBUG - Response for deleting network () 2026-05-27 16:55:24,848 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/a21ce863-aee0-465b-8d44-fac319a0dc77 2026-05-27 16:55:24,853 - DEBUG - Response Code: 404 2026-05-27 16:55:24,853 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-05-27 16:55:24,861 - DEBUG - Requesting: http://10.0.0.50:8082/domain/dd011215-fca5-4e74-b1da-d431e9fe9325 2026-05-27 16:55:24,877 - DEBUG - Requesting: http://10.0.0.50:8082/project/552f6fc8-eb73-4d0a-b47d-ad0f2b09e833 2026-05-27 16:55:24,993 - INFO - Validated that VN ctest-vnet0-16199476 is not found in API Server 2026-05-27 16:55:25,005 - DEBUG - VN ctest-vnet0-16199476 is not present in Agent 10.0.0.241 2026-05-27 16:55:25,019 - DEBUG - VN ctest-vnet0-16199476 is not present in Agent 10.0.0.242 2026-05-27 16:55:25,019 - INFO - Validated that VN ctest-vnet0-16199476 is not in any agent 2026-05-27 16:55:25,069 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vnet0-16199476 info 2026-05-27 16:55:25,218 - INFO - IPAM: ctest-TestDetailedPolicy1Ipv4v6-87114749-default-ipam is not found in API Server 2026-05-27 16:55:25,245 - INFO - IPAM:ctest-TestDetailedPolicy1Ipv4v6-87114749-default-ipam is not found in control node 2026-05-27 16:55:25,790 - DEBUG - Skipping the deletion of Project ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-87114749'] 2026-05-27 16:55:25,790 - DEBUG - Skipping the deletion of User admin 2026-05-27 16:55:27,091 - DEBUG - No XMPP flaps were noticed during the test
2026-05-27 16:55:27,091 - INFO - END TEST : test_multi_vn_repeated_policy_update_with_ping : PASSED[0:03:55]
2026-05-27 16:55:27,092 - INFO - -------------------------------------------------------------------------------- 2026-05-27 16:55:28,371 - INFO - Deleted project: ctest-TestDetailedPolicy1Ipv4v6-87114749, ID : 552f6fc8-eb73-4d0a-b47d-ad0f2b09e833