2026-01-19 02:46:07,945 - INFO - Domain Default found not creating 2026-01-19 02:46:08,113 - INFO - Project ctest-TestDetailedPolicy1Ipv4v6-14690172 not found, creating it 2026-01-19 02:46:08,623 - INFO - Created Project:ctest-TestDetailedPolicy1Ipv4v6-14690172, ID : cc751c61-127b-4002-a4fc-c2b2a652cb26 2026-01-19 02:46:10,119 - INFO - ================================================================================ 2026-01-19 02:46:10,119 - INFO - STARTING TEST : test_multi_vn_repeated_policy_update_with_ping 2026-01-19 02:46:10,119 - INFO - TEST DESCRIPTION : Call repeated_policy_update_test_with_ping with multi VN scenario. 2026-01-19 02:46:11,395 - DEBUG - Nothing to compare xmpp stats {'10.0.0.249': {'10.20.0.25': '0', '10.20.0.193': '0'}, '10.0.0.65': {'10.20.0.17': '0', '10.20.0.25': '0'}} with 2026-01-19 02:46:11,395 - INFO - Initial checks done. Running the testcase now 2026-01-19 02:46:11,396 - INFO - 2026-01-19 02:46:11,396 - INFO - Scenario for the test used is: 2026-01-19 02:46:11,396 - DEBUG - Starting setup 2026-01-19 02:46:12,139 - INFO - Using existing project ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-14690172'](cc751c61-127b-4002-a4fc-c2b2a652cb26) 2026-01-19 02:46:12,139 - INFO - provision user admin with role as admin in tenant ctest-TestDetailedPolicy1Ipv4v6-14690172 2026-01-19 02:46:13,159 - DEBUG - Requesting: http://10.0.0.27:8082/domains 2026-01-19 02:46:13,478 - DEBUG - Requesting: http://10.0.0.27:8082/domains 2026-01-19 02:46:13,538 - DEBUG - Requesting: http://10.0.0.27:8082/domain/bc123c74-c45e-4d7a-a955-76f59d7a4cc7 2026-01-19 02:46:13,554 - DEBUG - Requesting: http://10.0.0.27:8082/project/cc751c61-127b-4002-a4fc-c2b2a652cb26 2026-01-19 02:46:13,644 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-01-19 02:46:13,946 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-01-19 02:46:13,978 - DEBUG - Requesting: http://10.0.0.50:8082/domain/bc123c74-c45e-4d7a-a955-76f59d7a4cc7 2026-01-19 02:46:14,017 - DEBUG - Requesting: http://10.0.0.50:8082/project/cc751c61-127b-4002-a4fc-c2b2a652cb26 2026-01-19 02:46:14,109 - DEBUG - Requesting: http://10.0.0.23:8082/domains 2026-01-19 02:46:14,410 - DEBUG - Requesting: http://10.0.0.23:8082/domains 2026-01-19 02:46:14,442 - DEBUG - Requesting: http://10.0.0.23:8082/domain/bc123c74-c45e-4d7a-a955-76f59d7a4cc7 2026-01-19 02:46:14,459 - DEBUG - Requesting: http://10.0.0.23:8082/project/cc751c61-127b-4002-a4fc-c2b2a652cb26 2026-01-19 02:46:14,557 - INFO - Verification of project ctest-TestDetailedPolicy1Ipv4v6-14690172 in API Server 10.0.0.23 passed 2026-01-19 02:46:14,847 - DEBUG - Requesting: http://10.0.0.27:8082/domains 2026-01-19 02:46:14,857 - DEBUG - Requesting: http://10.0.0.27:8082/domain/bc123c74-c45e-4d7a-a955-76f59d7a4cc7 2026-01-19 02:46:14,867 - DEBUG - Requesting: http://10.0.0.27:8082/project/cc751c61-127b-4002-a4fc-c2b2a652cb26 2026-01-19 02:46:14,960 - DEBUG - Requesting: http://10.0.0.27:8082/network-ipam/2a545285-ee55-4dc3-b273-0e0b1ef1cadc 2026-01-19 02:46:14,967 - INFO - Verifications in API Server for IPAM: ctest-TestDetailedPolicy1Ipv4v6-14690172-default-ipam passed 2026-01-19 02:46:14,972 - DEBUG - Control-node 10.0.0.27 : IPAM object is : {'node_name': 'network-ipam:default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-TestDetailedPolicy1Ipv4v6-14690172-default-ipam', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestDetailedPolicy1Ipv4v6-14690172', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3050153582819364291', 'uuid-lslong': '12858636801999489756'}, 'enable': 'true', 'created': '2026-01-19T02:46:14', 'last-modified': '2026-01-19T02:46:14', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.159873'} 2026-01-19 02:46:14,977 - DEBUG - Control-node 10.0.0.50 : IPAM object is : {'node_name': 'network-ipam:default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-TestDetailedPolicy1Ipv4v6-14690172-default-ipam', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestDetailedPolicy1Ipv4v6-14690172', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3050153582819364291', 'uuid-lslong': '12858636801999489756'}, 'enable': 'true', 'created': '2026-01-19T02:46:14', 'last-modified': '2026-01-19T02:46:14', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.163050'} 2026-01-19 02:46:14,982 - DEBUG - Control-node 10.0.0.23 : IPAM object is : {'node_name': 'network-ipam:default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-TestDetailedPolicy1Ipv4v6-14690172-default-ipam', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestDetailedPolicy1Ipv4v6-14690172', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3050153582819364291', 'uuid-lslong': '12858636801999489756'}, 'enable': 'true', 'created': '2026-01-19T02:46:14', 'last-modified': '2026-01-19T02:46:14', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.167134'} 2026-01-19 02:46:14,982 - INFO - Verifications in Control node for IPAM: ctest-TestDetailedPolicy1Ipv4v6-14690172-default-ipam passed 2026-01-19 02:46:15,615 - DEBUG - Response for create_network : {'network': {'id': '6d9e4248-f02e-4eb9-8318-39780205931e', 'name': 'ctest-vnet0-99217706', 'tenant_id': 'cc751c61127b4002a4fcc2b2a652cb26', 'project_id': 'cc751c61127b4002a4fcc2b2a652cb26', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-14690172', 'ctest-vnet0-99217706'], 'port_security_enabled': True, 'description': ''}} 2026-01-19 02:46:15,907 - DEBUG - Response for create_subnet : {'subnet': {'id': 'bbeeae9e-c8d1-4f70-a6c2-6e3b322b8e47', 'name': '', 'tenant_id': 'cc751c61127b4002a4fcc2b2a652cb26', 'network_id': '6d9e4248-f02e-4eb9-8318-39780205931e', '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': 'cc751c61127b4002a4fcc2b2a652cb26'}} 2026-01-19 02:46:16,132 - DEBUG - Response for create_subnet : {'subnet': {'id': '58413eaa-42e9-4095-9b62-b583707e36b1', 'name': '', 'tenant_id': 'cc751c61127b4002a4fcc2b2a652cb26', 'network_id': '6d9e4248-f02e-4eb9-8318-39780205931e', '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': 'cc751c61127b4002a4fcc2b2a652cb26'}} 2026-01-19 02:46:16,335 - DEBUG - Response for create_subnet : {'subnet': {'id': '39c23520-56d6-41ea-9100-baa4264b9c9c', 'name': '', 'tenant_id': 'cc751c61127b4002a4fcc2b2a652cb26', 'network_id': '6d9e4248-f02e-4eb9-8318-39780205931e', 'ip_version': 6, 'cidr': '2b72:8ff6:69b1:2e35:8646:d794::/96', 'allocation_pools': [{'start': '2b72:8ff6:69b1:2e35:8646:d794:0:2', 'end': '2b72:8ff6:69b1:2e35:8646:d794:ffff:fffe'}], 'gateway_ip': '2b72:8ff6:69b1:2e35:8646:d794:0:1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '2b72:8ff6:69b1:2e35:8646:d794:0:2', 'tags': [], 'project_id': 'cc751c61127b4002a4fcc2b2a652cb26'}} 2026-01-19 02:46:16,362 - INFO - Created VN ctest-vnet0-99217706 2026-01-19 02:46:16,373 - DEBUG - VN ctest-vnet0-99217706 UUID is 6d9e4248-f02e-4eb9-8318-39780205931e 2026-01-19 02:46:16,495 - DEBUG - Requesting: http://10.0.0.27:8082/domains 2026-01-19 02:46:16,794 - DEBUG - Requesting: http://10.0.0.27:8082/domains 2026-01-19 02:46:16,827 - DEBUG - Requesting: http://10.0.0.27:8082/domain/bc123c74-c45e-4d7a-a955-76f59d7a4cc7 2026-01-19 02:46:16,838 - DEBUG - Requesting: http://10.0.0.27:8082/project/cc751c61-127b-4002-a4fc-c2b2a652cb26 2026-01-19 02:46:16,930 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/6d9e4248-f02e-4eb9-8318-39780205931e 2026-01-19 02:46:16,944 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/6d9e4248-f02e-4eb9-8318-39780205931e 2026-01-19 02:46:16,954 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/a058c742-745b-47e1-89ee-eb8277d282bd 2026-01-19 02:46:16,967 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/a058c742-745b-47e1-89ee-eb8277d282bd 2026-01-19 02:46:16,977 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/4377df1d-b546-40cb-bb53-a93b9670e715 2026-01-19 02:46:16,985 - DEBUG - Route Targets: ['target:64512:8000004'] 2026-01-19 02:46:16,985 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/6d9e4248-f02e-4eb9-8318-39780205931e 2026-01-19 02:46:16,997 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/a058c742-745b-47e1-89ee-eb8277d282bd 2026-01-19 02:46:17,013 - INFO - Verified VN network id 16 for VN 6d9e4248-f02e-4eb9-8318-39780205931e 2026-01-19 02:46:17,013 - INFO - Verifications in API Server for VN ctest-vnet0-99217706 passed 2026-01-19 02:46:17,013 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/6d9e4248-f02e-4eb9-8318-39780205931e 2026-01-19 02:46:17,025 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/a058c742-745b-47e1-89ee-eb8277d282bd 2026-01-19 02:46:17,032 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/a058c742-745b-47e1-89ee-eb8277d282bd 2026-01-19 02:46:17,038 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/4377df1d-b546-40cb-bb53-a93b9670e715 2026-01-19 02:46:17,049 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet0-99217706', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'admin', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7898823677489073849', 'uuid-lslong': '9446363406002393886'}, 'enable': 'true', 'created': '2026-01-19T02:46:15', 'last-modified': '2026-01-19T02:46:16', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.762296'} 2026-01-19 02:46:17,054 - DEBUG - Route Targets: ['target:64512:8000004'] 2026-01-19 02:46:17,058 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet0-99217706', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'admin', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7898823677489073849', 'uuid-lslong': '9446363406002393886'}, 'enable': 'true', 'created': '2026-01-19T02:46:15', 'last-modified': '2026-01-19T02:46:16', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.766952'} 2026-01-19 02:46:17,063 - DEBUG - Route Targets: ['target:64512:8000004'] 2026-01-19 02:46:17,069 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet0-99217706', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'admin', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7898823677489073849', 'uuid-lslong': '9446363406002393886'}, 'enable': 'true', 'created': '2026-01-19T02:46:15', 'last-modified': '2026-01-19T02:46:16', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.781772'} 2026-01-19 02:46:17,074 - DEBUG - Route Targets: ['target:64512:8000004'] 2026-01-19 02:46:17,074 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vnet0-99217706 passed 2026-01-19 02:46:17,074 - DEBUG - ====Verifying policy data for ctest-vnet0-99217706 in API_Server ====== 2026-01-19 02:46:17,074 - DEBUG - Requesting: http://10.0.0.27:8082/domains 2026-01-19 02:46:17,080 - DEBUG - Requesting: http://10.0.0.27:8082/domain/bc123c74-c45e-4d7a-a955-76f59d7a4cc7 2026-01-19 02:46:17,090 - DEBUG - Requesting: http://10.0.0.27:8082/project/cc751c61-127b-4002-a4fc-c2b2a652cb26 2026-01-19 02:46:17,181 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/6d9e4248-f02e-4eb9-8318-39780205931e 2026-01-19 02:46:17,190 - DEBUG - =>VN ctest-vnet0-99217706 has no policy to be verified 2026-01-19 02:46:17,191 - DEBUG - Verifying the vn in opserver 2026-01-19 02:46:17,191 - DEBUG - Verifying the default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet0-99217706 virtual network link through opserver 10.0.0.27 2026-01-19 02:46:17,191 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks 2026-01-19 02:46:17,488 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks 2026-01-19 02:46:17,546 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet0-99217706', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet0-99217706?flat'} 2026-01-19 02:46:17,546 - DEBUG - Verifying the default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet0-99217706 virtual network link through opserver 10.0.0.50 2026-01-19 02:46:17,546 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks 2026-01-19 02:46:17,842 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks 2026-01-19 02:46:17,915 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet0-99217706', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet0-99217706?flat'} 2026-01-19 02:46:17,915 - DEBUG - Verifying the default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet0-99217706 virtual network link through opserver 10.0.0.23 2026-01-19 02:46:17,915 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks 2026-01-19 02:46:18,208 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks 2026-01-19 02:46:18,271 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet0-99217706', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet0-99217706?flat'} 2026-01-19 02:46:18,271 - INFO - Validated that VN default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet0-99217706 is found in opserver 2026-01-19 02:46:18,293 - DEBUG - Do not have enough data to verify VN in agent 2026-01-19 02:46:18,302 - DEBUG - VRF ids for VN ctest-vnet0-99217706: {} 2026-01-19 02:46:18,627 - DEBUG - Response for create_network : {'network': {'id': '7bb0dc5f-08da-4272-afb4-47e10df56c8e', 'name': 'ctest-vnet1-43842364', 'tenant_id': 'cc751c61127b4002a4fcc2b2a652cb26', 'project_id': 'cc751c61127b4002a4fcc2b2a652cb26', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-14690172', 'ctest-vnet1-43842364'], 'port_security_enabled': True, 'description': ''}} 2026-01-19 02:46:18,832 - DEBUG - Response for create_subnet : {'subnet': {'id': '0f928f0a-f73e-41ee-a29b-3cea45000c23', 'name': '', 'tenant_id': 'cc751c61127b4002a4fcc2b2a652cb26', 'network_id': '7bb0dc5f-08da-4272-afb4-47e10df56c8e', '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': 'cc751c61127b4002a4fcc2b2a652cb26'}} 2026-01-19 02:46:19,052 - DEBUG - Response for create_subnet : {'subnet': {'id': 'f5f81189-6e03-4408-b9a3-7545dcf1de26', 'name': '', 'tenant_id': 'cc751c61127b4002a4fcc2b2a652cb26', 'network_id': '7bb0dc5f-08da-4272-afb4-47e10df56c8e', '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': 'cc751c61127b4002a4fcc2b2a652cb26'}} 2026-01-19 02:46:19,281 - DEBUG - Response for create_subnet : {'subnet': {'id': '4c8c7b16-e69b-4e1d-b552-9693b20dda46', 'name': '', 'tenant_id': 'cc751c61127b4002a4fcc2b2a652cb26', 'network_id': '7bb0dc5f-08da-4272-afb4-47e10df56c8e', 'ip_version': 6, 'cidr': '2361:8b15:ffd7:263f:72fb:105c::/96', 'allocation_pools': [{'start': '2361:8b15:ffd7:263f:72fb:105c:0:2', 'end': '2361:8b15:ffd7:263f:72fb:105c:ffff:fffe'}], 'gateway_ip': '2361:8b15:ffd7:263f:72fb:105c:0:1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '2361:8b15:ffd7:263f:72fb:105c:0:2', 'tags': [], 'project_id': 'cc751c61127b4002a4fcc2b2a652cb26'}} 2026-01-19 02:46:19,307 - INFO - Created VN ctest-vnet1-43842364 2026-01-19 02:46:19,322 - DEBUG - VN ctest-vnet1-43842364 UUID is 7bb0dc5f-08da-4272-afb4-47e10df56c8e 2026-01-19 02:46:19,444 - DEBUG - Requesting: http://10.0.0.27:8082/domains 2026-01-19 02:46:19,450 - DEBUG - Requesting: http://10.0.0.27:8082/domain/bc123c74-c45e-4d7a-a955-76f59d7a4cc7 2026-01-19 02:46:19,460 - DEBUG - Requesting: http://10.0.0.27:8082/project/cc751c61-127b-4002-a4fc-c2b2a652cb26 2026-01-19 02:46:19,546 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/7bb0dc5f-08da-4272-afb4-47e10df56c8e 2026-01-19 02:46:19,559 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/7bb0dc5f-08da-4272-afb4-47e10df56c8e 2026-01-19 02:46:19,569 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/cd9ffd33-dc38-4633-9255-70378dc9784d 2026-01-19 02:46:19,575 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/cd9ffd33-dc38-4633-9255-70378dc9784d 2026-01-19 02:46:19,583 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/655b0c69-31af-488f-bb28-17583dce117a 2026-01-19 02:46:19,589 - DEBUG - Route Targets: ['target:64512:8000006'] 2026-01-19 02:46:19,589 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/7bb0dc5f-08da-4272-afb4-47e10df56c8e 2026-01-19 02:46:19,598 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/cd9ffd33-dc38-4633-9255-70378dc9784d 2026-01-19 02:46:19,612 - INFO - Verified VN network id 17 for VN 7bb0dc5f-08da-4272-afb4-47e10df56c8e 2026-01-19 02:46:19,612 - INFO - Verifications in API Server for VN ctest-vnet1-43842364 passed 2026-01-19 02:46:19,612 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/7bb0dc5f-08da-4272-afb4-47e10df56c8e 2026-01-19 02:46:19,622 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/cd9ffd33-dc38-4633-9255-70378dc9784d 2026-01-19 02:46:19,628 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/cd9ffd33-dc38-4633-9255-70378dc9784d 2026-01-19 02:46:19,634 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/655b0c69-31af-488f-bb28-17583dce117a 2026-01-19 02:46:19,644 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet1-43842364', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'admin', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8912865963294737010', 'uuid-lslong': '12660823484372708494'}, 'enable': 'true', 'created': '2026-01-19T02:46:18', 'last-modified': '2026-01-19T02:46:19', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.414336'} 2026-01-19 02:46:19,651 - DEBUG - Route Targets: ['target:64512:8000006'] 2026-01-19 02:46:19,656 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet1-43842364', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'admin', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8912865963294737010', 'uuid-lslong': '12660823484372708494'}, 'enable': 'true', 'created': '2026-01-19T02:46:18', 'last-modified': '2026-01-19T02:46:19', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.422591'} 2026-01-19 02:46:19,661 - DEBUG - Route Targets: ['target:64512:8000006'] 2026-01-19 02:46:19,668 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet1-43842364', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'admin', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8912865963294737010', 'uuid-lslong': '12660823484372708494'}, 'enable': 'true', 'created': '2026-01-19T02:46:18', 'last-modified': '2026-01-19T02:46:19', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.433772'} 2026-01-19 02:46:19,675 - DEBUG - Route Targets: ['target:64512:8000006'] 2026-01-19 02:46:19,675 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vnet1-43842364 passed 2026-01-19 02:46:19,675 - DEBUG - ====Verifying policy data for ctest-vnet1-43842364 in API_Server ====== 2026-01-19 02:46:19,675 - DEBUG - Requesting: http://10.0.0.27:8082/domains 2026-01-19 02:46:19,682 - DEBUG - Requesting: http://10.0.0.27:8082/domain/bc123c74-c45e-4d7a-a955-76f59d7a4cc7 2026-01-19 02:46:19,692 - DEBUG - Requesting: http://10.0.0.27:8082/project/cc751c61-127b-4002-a4fc-c2b2a652cb26 2026-01-19 02:46:19,779 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/7bb0dc5f-08da-4272-afb4-47e10df56c8e 2026-01-19 02:46:19,791 - DEBUG - =>VN ctest-vnet1-43842364 has no policy to be verified 2026-01-19 02:46:19,791 - DEBUG - Verifying the vn in opserver 2026-01-19 02:46:19,791 - DEBUG - Verifying the default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet1-43842364 virtual network link through opserver 10.0.0.27 2026-01-19 02:46:19,792 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks 2026-01-19 02:46:19,861 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet1-43842364', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet1-43842364?flat'} 2026-01-19 02:46:19,861 - DEBUG - Verifying the default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet1-43842364 virtual network link through opserver 10.0.0.50 2026-01-19 02:46:19,861 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks 2026-01-19 02:46:19,940 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet1-43842364', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet1-43842364?flat'} 2026-01-19 02:46:19,940 - DEBUG - Verifying the default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet1-43842364 virtual network link through opserver 10.0.0.23 2026-01-19 02:46:19,940 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks 2026-01-19 02:46:20,023 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet1-43842364', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet1-43842364?flat'} 2026-01-19 02:46:20,023 - INFO - Validated that VN default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet1-43842364 is found in opserver 2026-01-19 02:46:20,048 - DEBUG - Do not have enough data to verify VN in agent 2026-01-19 02:46:20,061 - DEBUG - VRF ids for VN ctest-vnet1-43842364: {} 2026-01-19 02:46:20,069 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = tcp, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet1-43842364, 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-14690172:ctest-vnet0-99217706, 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-14690172:ctest-vnet1-43842364, 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-14690172:ctest-vnet0-99217706, 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-14690172:ctest-vnet1-43842364, 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-14690172:ctest-vnet0-99217706, 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-14690172:ctest-vnet1-43842364, 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-14690172:ctest-vnet0-99217706, 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-01-19 02:46:20,335 - DEBUG - ====Verifying data for policy0 in API_Server ====== 2026-01-19 02:46:20,335 - DEBUG - Requesting: http://10.0.0.27:8082/domains 2026-01-19 02:46:20,340 - DEBUG - Requesting: http://10.0.0.27:8082/domain/bc123c74-c45e-4d7a-a955-76f59d7a4cc7 2026-01-19 02:46:20,352 - DEBUG - Requesting: http://10.0.0.27:8082/project/cc751c61-127b-4002-a4fc-c2b2a652cb26 2026-01-19 02:46:20,451 - DEBUG - Requesting: http://10.0.0.27:8082/network-policy/f7236c59-1ae0-4aae-bd7b-d2d1a2082e70 2026-01-19 02:46:20,466 - INFO - Verified policy policy0 in API Server, Result: True 2026-01-19 02:46:20,476 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = tcp, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet1-43842364, 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-14690172:ctest-vnet0-99217706, 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-14690172:ctest-vnet1-43842364, 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-14690172:ctest-vnet0-99217706, 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-14690172:ctest-vnet1-43842364, 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-14690172:ctest-vnet0-99217706, 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-14690172:ctest-vnet1-43842364, 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-14690172:ctest-vnet0-99217706, 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-01-19 02:46:20,759 - DEBUG - ====Verifying data for policy1 in API_Server ====== 2026-01-19 02:46:20,759 - DEBUG - Requesting: http://10.0.0.27:8082/domains 2026-01-19 02:46:20,770 - DEBUG - Requesting: http://10.0.0.27:8082/domain/bc123c74-c45e-4d7a-a955-76f59d7a4cc7 2026-01-19 02:46:20,785 - DEBUG - Requesting: http://10.0.0.27:8082/project/cc751c61-127b-4002-a4fc-c2b2a652cb26 2026-01-19 02:46:20,885 - DEBUG - Requesting: http://10.0.0.27:8082/network-policy/542c7b4d-b869-46bd-8fe8-d95c84397eea 2026-01-19 02:46:20,899 - INFO - Verified policy policy1 in API Server, Result: True 2026-01-19 02:46:20,951 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = tcp, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet1-43842364, 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-14690172:ctest-vnet0-99217706, 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-14690172:ctest-vnet1-43842364, 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-14690172:ctest-vnet0-99217706, 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-14690172:ctest-vnet1-43842364, 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-14690172:ctest-vnet0-99217706, 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-14690172:ctest-vnet1-43842364, 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-14690172:ctest-vnet0-99217706, 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-01-19 02:46:21,223 - DEBUG - ====Verifying data for policy2 in API_Server ====== 2026-01-19 02:46:21,223 - DEBUG - Requesting: http://10.0.0.27:8082/domains 2026-01-19 02:46:21,229 - DEBUG - Requesting: http://10.0.0.27:8082/domain/bc123c74-c45e-4d7a-a955-76f59d7a4cc7 2026-01-19 02:46:21,242 - DEBUG - Requesting: http://10.0.0.27:8082/project/cc751c61-127b-4002-a4fc-c2b2a652cb26 2026-01-19 02:46:21,330 - DEBUG - Requesting: http://10.0.0.27:8082/network-policy/8358a917-4820-4088-afa6-7ea6b354fbe8 2026-01-19 02:46:21,341 - INFO - Verified policy policy2 in API Server, Result: True 2026-01-19 02:46:21,387 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = tcp, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet1-43842364, 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-14690172:ctest-vnet0-99217706, 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-14690172:ctest-vnet1-43842364, 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-14690172:ctest-vnet0-99217706, 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-14690172:ctest-vnet1-43842364, 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-14690172:ctest-vnet0-99217706, 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-14690172:ctest-vnet1-43842364, 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-14690172:ctest-vnet0-99217706, 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-01-19 02:46:21,644 - DEBUG - ====Verifying data for policy3 in API_Server ====== 2026-01-19 02:46:21,644 - DEBUG - Requesting: http://10.0.0.27:8082/domains 2026-01-19 02:46:21,650 - DEBUG - Requesting: http://10.0.0.27:8082/domain/bc123c74-c45e-4d7a-a955-76f59d7a4cc7 2026-01-19 02:46:21,660 - DEBUG - Requesting: http://10.0.0.27:8082/project/cc751c61-127b-4002-a4fc-c2b2a652cb26 2026-01-19 02:46:21,748 - DEBUG - Requesting: http://10.0.0.27:8082/network-policy/e7283628-77c1-4f3b-8a3e-fa4c9c1f9c82 2026-01-19 02:46:21,759 - INFO - Verified policy policy3 in API Server, Result: True 2026-01-19 02:46:21,807 - 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-01-19 02:46:22,032 - DEBUG - ====Verifying data for policy100 in API_Server ====== 2026-01-19 02:46:22,032 - DEBUG - Requesting: http://10.0.0.27:8082/domains 2026-01-19 02:46:22,037 - DEBUG - Requesting: http://10.0.0.27:8082/domain/bc123c74-c45e-4d7a-a955-76f59d7a4cc7 2026-01-19 02:46:22,047 - DEBUG - Requesting: http://10.0.0.27:8082/project/cc751c61-127b-4002-a4fc-c2b2a652cb26 2026-01-19 02:46:22,149 - DEBUG - Requesting: http://10.0.0.27:8082/network-policy/e4a1b889-cdc5-416b-ad1d-baf4a9919674 2026-01-19 02:46:22,156 - INFO - Verified policy policy100 in API Server, Result: True 2026-01-19 02:46:22,163 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = udp, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet1-43842364, 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-14690172:ctest-vnet0-99217706, 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-14690172:ctest-vnet1-43842364, 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-14690172:ctest-vnet0-99217706, 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-14690172:ctest-vnet1-43842364, 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-14690172:ctest-vnet0-99217706, 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-14690172:ctest-vnet1-43842364, 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-14690172:ctest-vnet0-99217706, 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-01-19 02:46:22,454 - DEBUG - ====Verifying data for policy10 in API_Server ====== 2026-01-19 02:46:22,454 - DEBUG - Requesting: http://10.0.0.27:8082/domains 2026-01-19 02:46:22,462 - DEBUG - Requesting: http://10.0.0.27:8082/domain/bc123c74-c45e-4d7a-a955-76f59d7a4cc7 2026-01-19 02:46:22,474 - DEBUG - Requesting: http://10.0.0.27:8082/project/cc751c61-127b-4002-a4fc-c2b2a652cb26 2026-01-19 02:46:22,579 - DEBUG - Requesting: http://10.0.0.27:8082/network-policy/cdfcedef-338e-4439-a0b9-acd7d5aaf68c 2026-01-19 02:46:22,591 - INFO - Verified policy policy10 in API Server, Result: True 2026-01-19 02:46:22,639 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = udp, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet1-43842364, 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-14690172:ctest-vnet0-99217706, 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-14690172:ctest-vnet1-43842364, 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-14690172:ctest-vnet0-99217706, 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-14690172:ctest-vnet1-43842364, 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-14690172:ctest-vnet0-99217706, 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-14690172:ctest-vnet1-43842364, 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-14690172:ctest-vnet0-99217706, 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-01-19 02:46:22,917 - DEBUG - ====Verifying data for policy11 in API_Server ====== 2026-01-19 02:46:22,917 - DEBUG - Requesting: http://10.0.0.27:8082/domains 2026-01-19 02:46:22,923 - DEBUG - Requesting: http://10.0.0.27:8082/domain/bc123c74-c45e-4d7a-a955-76f59d7a4cc7 2026-01-19 02:46:22,933 - DEBUG - Requesting: http://10.0.0.27:8082/project/cc751c61-127b-4002-a4fc-c2b2a652cb26 2026-01-19 02:46:23,017 - DEBUG - Requesting: http://10.0.0.27:8082/network-policy/8bfa1a79-03ee-45ec-8a2a-d89ca411af30 2026-01-19 02:46:23,034 - INFO - Verified policy policy11 in API Server, Result: True 2026-01-19 02:46:23,041 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = tcp, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet1-43842364, 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-14690172:ctest-vnet0-99217706, 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-14690172:ctest-vnet1-43842364, 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-14690172:ctest-vnet0-99217706, 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-14690172:ctest-vnet1-43842364, 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-14690172:ctest-vnet0-99217706, 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-14690172:ctest-vnet1-43842364, 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-14690172:ctest-vnet0-99217706, 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-01-19 02:46:23,331 - DEBUG - ====Verifying data for policy12 in API_Server ====== 2026-01-19 02:46:23,331 - DEBUG - Requesting: http://10.0.0.27:8082/domains 2026-01-19 02:46:23,338 - DEBUG - Requesting: http://10.0.0.27:8082/domain/bc123c74-c45e-4d7a-a955-76f59d7a4cc7 2026-01-19 02:46:23,347 - DEBUG - Requesting: http://10.0.0.27:8082/project/cc751c61-127b-4002-a4fc-c2b2a652cb26 2026-01-19 02:46:23,454 - DEBUG - Requesting: http://10.0.0.27:8082/network-policy/7f01b7e8-a763-4e29-97df-78c35ed05a35 2026-01-19 02:46:23,466 - INFO - Verified policy policy12 in API Server, Result: True 2026-01-19 02:46:23,515 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = udp, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet1-43842364, 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-14690172:ctest-vnet0-99217706, 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-14690172:ctest-vnet1-43842364, 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-14690172:ctest-vnet0-99217706, 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-14690172:ctest-vnet1-43842364, 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-14690172:ctest-vnet0-99217706, 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-14690172:ctest-vnet1-43842364, 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-14690172:ctest-vnet0-99217706, 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-01-19 02:46:23,832 - DEBUG - ====Verifying data for policy13 in API_Server ====== 2026-01-19 02:46:23,833 - DEBUG - Requesting: http://10.0.0.27:8082/domains 2026-01-19 02:46:23,838 - DEBUG - Requesting: http://10.0.0.27:8082/domain/bc123c74-c45e-4d7a-a955-76f59d7a4cc7 2026-01-19 02:46:23,849 - DEBUG - Requesting: http://10.0.0.27:8082/project/cc751c61-127b-4002-a4fc-c2b2a652cb26 2026-01-19 02:46:23,947 - DEBUG - Requesting: http://10.0.0.27:8082/network-policy/7bb3eb89-4e34-455b-9487-390a0ce93629 2026-01-19 02:46:23,958 - INFO - Verified policy policy13 in API Server, Result: True 2026-01-19 02:46:24,007 - DEBUG - Policy np_rules : [] 2026-01-19 02:46:24,283 - DEBUG - ====Verifying data for policy1000 in API_Server ====== 2026-01-19 02:46:24,283 - DEBUG - Requesting: http://10.0.0.27:8082/domains 2026-01-19 02:46:24,289 - DEBUG - Requesting: http://10.0.0.27:8082/domain/bc123c74-c45e-4d7a-a955-76f59d7a4cc7 2026-01-19 02:46:24,303 - DEBUG - Requesting: http://10.0.0.27:8082/project/cc751c61-127b-4002-a4fc-c2b2a652cb26 2026-01-19 02:46:24,390 - DEBUG - Requesting: http://10.0.0.27:8082/network-policy/99923549-8bfb-4105-b12c-6762961e9cb1 2026-01-19 02:46:24,397 - INFO - Verified policy policy1000 in API Server, Result: True 2026-01-19 02:46:24,397 - DEBUG - Requesting: http://10.0.0.27:8082/domains 2026-01-19 02:46:24,402 - DEBUG - Requesting: http://10.0.0.27:8082/domain/bc123c74-c45e-4d7a-a955-76f59d7a4cc7 2026-01-19 02:46:24,414 - DEBUG - Requesting: http://10.0.0.27:8082/project/cc751c61-127b-4002-a4fc-c2b2a652cb26 2026-01-19 02:46:24,501 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/6d9e4248-f02e-4eb9-8318-39780205931e 2026-01-19 02:46:24,518 - DEBUG - Setup step: Associating the policy to VN' 2026-01-19 02:46:24,649 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': '6d9e4248-f02e-4eb9-8318-39780205931e', 'name': 'ctest-vnet0-99217706', 'tenant_id': 'cc751c61127b4002a4fcc2b2a652cb26', 'project_id': 'cc751c61127b4002a4fcc2b2a652cb26', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['bbeeae9e-c8d1-4f70-a6c2-6e3b322b8e47', '58413eaa-42e9-4095-9b62-b583707e36b1', '39c23520-56d6-41ea-9100-baa4264b9c9c'], 'fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-14690172', 'ctest-vnet0-99217706'], 'policys': [['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-14690172', 'policy0']], 'subnet_ipam': [{'subnet_cidr': '10.1.1.0/24', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-14690172', 'ctest-TestDetailedPolicy1Ipv4v6-14690172-default-ipam']}, {'subnet_cidr': '11.1.1.0/24', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-14690172', 'ctest-TestDetailedPolicy1Ipv4v6-14690172-default-ipam']}, {'subnet_cidr': '2b72:8ff6:69b1:2e35:8646:d794::/96', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-14690172', 'ctest-TestDetailedPolicy1Ipv4v6-14690172-default-ipam']}], 'port_security_enabled': True, 'description': ''}} 2026-01-19 02:46:24,758 - DEBUG - Associated Policy:[['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-14690172', 'policy0']] to ctest-vnet0-99217706 2026-01-19 02:46:24,758 - DEBUG - Requesting: http://10.0.0.27:8082/domains 2026-01-19 02:46:24,764 - DEBUG - Requesting: http://10.0.0.27:8082/domain/bc123c74-c45e-4d7a-a955-76f59d7a4cc7 2026-01-19 02:46:24,774 - DEBUG - Requesting: http://10.0.0.27:8082/project/cc751c61-127b-4002-a4fc-c2b2a652cb26 2026-01-19 02:46:24,860 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/7bb0dc5f-08da-4272-afb4-47e10df56c8e 2026-01-19 02:46:24,872 - DEBUG - Setup step: Associating the policy to VN' 2026-01-19 02:46:24,990 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': '7bb0dc5f-08da-4272-afb4-47e10df56c8e', 'name': 'ctest-vnet1-43842364', 'tenant_id': 'cc751c61127b4002a4fcc2b2a652cb26', 'project_id': 'cc751c61127b4002a4fcc2b2a652cb26', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['0f928f0a-f73e-41ee-a29b-3cea45000c23', 'f5f81189-6e03-4408-b9a3-7545dcf1de26', '4c8c7b16-e69b-4e1d-b552-9693b20dda46'], 'fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-14690172', 'ctest-vnet1-43842364'], 'policys': [['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-14690172', 'policy100']], 'subnet_ipam': [{'subnet_cidr': '12.1.1.0/24', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-14690172', 'ctest-TestDetailedPolicy1Ipv4v6-14690172-default-ipam']}, {'subnet_cidr': '13.1.1.0/24', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-14690172', 'ctest-TestDetailedPolicy1Ipv4v6-14690172-default-ipam']}, {'subnet_cidr': '2361:8b15:ffd7:263f:72fb:105c::/96', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-14690172', 'ctest-TestDetailedPolicy1Ipv4v6-14690172-default-ipam']}], 'port_security_enabled': True, 'description': ''}} 2026-01-19 02:46:25,101 - DEBUG - Associated Policy:[['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-14690172', 'policy100']] to ctest-vnet1-43842364 2026-01-19 02:46:25,124 - DEBUG - Services list from nova: [, , , ] 2026-01-19 02:46:25,124 - DEBUG - Hosts: {'nova': ['an-jenkins-deploy-platform-ansible-os-5040-1', 'an-jenkins-deploy-platform-ansible-os-5040-2']} 2026-01-19 02:46:25,218 - DEBUG - Services list from nova: [, , , ] 2026-01-19 02:46:26,363 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5040-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5040-1) 2026-01-19 02:46:27,640 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5040-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5040-2) 2026-01-19 02:46:27,640 - DEBUG - Setup step: Verify VM status and install Traffic package... 2026-01-19 02:46:27,640 - INFO - Waiting for VM ctest-vmc0-96991212 to be up.. 2026-01-19 02:46:27,740 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-01-19 02:46:32,815 - DEBUG - VM is in ACTIVE state now 2026-01-19 02:46:32,816 - INFO - VM name : ctest-vmc0-96991212 2026-01-19 02:46:32,897 - DEBUG - VM ctest-vmc0-96991212 ID is a16afaf0-3b36-427a-a531-1522bc26a23b 2026-01-19 02:46:32,924 - DEBUG - VM ctest-vmc0-96991212 launched on Node an-jenkins-deploy-platform-ansible-os-5040-1 2026-01-19 02:46:33,000 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/a16afaf0-3b36-427a-a531-1522bc26a23b 2026-01-19 02:46:33,298 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/a16afaf0-3b36-427a-a531-1522bc26a23b 2026-01-19 02:46:33,336 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/2bc1e7f4-23c5-42c2-84e8-e8f58238c339 2026-01-19 02:46:36,516 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1023ms') 2026-01-19 02:46:36,516 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vmc0-96991212 failed! 2026-01-19 02:46:36,531 - DEBUG - Gateway for vn default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet0-99217706 is 10.1.1.1 and allocation pool is NOT set 2026-01-19 02:46:36,531 - DEBUG - Gateway for vn default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet0-99217706 is 11.1.1.1 and allocation pool is NOT set 2026-01-19 02:46:36,531 - DEBUG - Gateway for vn default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet0-99217706 is 2b72:8ff6:69b1:2e35:8646:d794:0:1 and allocation pool is NOT set 2026-01-19 02:46:40,616 - 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 1019ms') 2026-01-19 02:46:40,616 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vmc0-96991212 failed! 2026-01-19 02:46:40,633 - DEBUG - Gateway for vn default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet0-99217706 is 10.1.1.1 and allocation pool is NOT set 2026-01-19 02:46:40,634 - DEBUG - Gateway for vn default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet0-99217706 is 11.1.1.1 and allocation pool is NOT set 2026-01-19 02:46:40,634 - DEBUG - Gateway for vn default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet0-99217706 is 2b72:8ff6:69b1:2e35:8646:d794:0:1 and allocation pool is NOT set 2026-01-19 02:46:44,716 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1018ms') 2026-01-19 02:46:44,716 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vmc0-96991212 failed! 2026-01-19 02:46:44,776 - DEBUG - Gateway for vn default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet0-99217706 is 10.1.1.1 and allocation pool is NOT set 2026-01-19 02:46:44,776 - DEBUG - Gateway for vn default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet0-99217706 is 11.1.1.1 and allocation pool is NOT set 2026-01-19 02:46:44,776 - DEBUG - Gateway for vn default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet0-99217706 is 2b72:8ff6:69b1:2e35:8646:d794:0:1 and allocation pool is NOT set 2026-01-19 02:46:48,873 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1031ms') 2026-01-19 02:46:48,873 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vmc0-96991212 failed! 2026-01-19 02:46:48,887 - DEBUG - Gateway for vn default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet0-99217706 is 10.1.1.1 and allocation pool is NOT set 2026-01-19 02:46:48,887 - DEBUG - Gateway for vn default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet0-99217706 is 11.1.1.1 and allocation pool is NOT set 2026-01-19 02:46:48,887 - DEBUG - Gateway for vn default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet0-99217706 is 2b72:8ff6:69b1:2e35:8646:d794:0:1 and allocation pool is NOT set 2026-01-19 02:46:52,966 - 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 1019ms') 2026-01-19 02:46:52,966 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vmc0-96991212 failed! 2026-01-19 02:46:52,983 - DEBUG - Gateway for vn default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet0-99217706 is 10.1.1.1 and allocation pool is NOT set 2026-01-19 02:46:52,983 - DEBUG - Gateway for vn default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet0-99217706 is 11.1.1.1 and allocation pool is NOT set 2026-01-19 02:46:52,983 - DEBUG - Gateway for vn default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet0-99217706 is 2b72:8ff6:69b1:2e35:8646:d794:0:1 and allocation pool is NOT set 2026-01-19 02:46:57,065 - 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-01-19 02:46:57,065 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vmc0-96991212 failed! 2026-01-19 02:46:57,082 - DEBUG - Gateway for vn default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet0-99217706 is 10.1.1.1 and allocation pool is NOT set 2026-01-19 02:46:57,082 - DEBUG - Gateway for vn default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet0-99217706 is 11.1.1.1 and allocation pool is NOT set 2026-01-19 02:46:57,082 - DEBUG - Gateway for vn default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet0-99217706 is 2b72:8ff6:69b1:2e35:8646:d794:0:1 and allocation pool is NOT set 2026-01-19 02:47:01,155 - 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-01-19 02:47:01,155 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vmc0-96991212 failed! 2026-01-19 02:47:01,175 - DEBUG - Gateway for vn default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet0-99217706 is 10.1.1.1 and allocation pool is NOT set 2026-01-19 02:47:01,176 - DEBUG - Gateway for vn default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet0-99217706 is 11.1.1.1 and allocation pool is NOT set 2026-01-19 02:47:01,176 - DEBUG - Gateway for vn default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet0-99217706 is 2b72:8ff6:69b1:2e35:8646:d794:0:1 and allocation pool is NOT set 2026-01-19 02:47:05,248 - 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-01-19 02:47:05,248 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vmc0-96991212 failed! 2026-01-19 02:47:05,264 - DEBUG - Gateway for vn default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet0-99217706 is 10.1.1.1 and allocation pool is NOT set 2026-01-19 02:47:05,264 - DEBUG - Gateway for vn default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet0-99217706 is 11.1.1.1 and allocation pool is NOT set 2026-01-19 02:47:05,264 - DEBUG - Gateway for vn default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet0-99217706 is 2b72:8ff6:69b1:2e35:8646:d794:0:1 and allocation pool is NOT set 2026-01-19 02:47:09,348 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1027ms') 2026-01-19 02:47:09,348 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vmc0-96991212 failed! 2026-01-19 02:47:09,363 - DEBUG - Gateway for vn default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet0-99217706 is 10.1.1.1 and allocation pool is NOT set 2026-01-19 02:47:09,364 - DEBUG - Gateway for vn default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet0-99217706 is 11.1.1.1 and allocation pool is NOT set 2026-01-19 02:47:09,364 - DEBUG - Gateway for vn default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet0-99217706 is 2b72:8ff6:69b1:2e35:8646:d794:0:1 and allocation pool is NOT set 2026-01-19 02:47:13,448 - 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 1019ms') 2026-01-19 02:47:13,448 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vmc0-96991212 failed! 2026-01-19 02:47:13,462 - DEBUG - Gateway for vn default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet0-99217706 is 10.1.1.1 and allocation pool is NOT set 2026-01-19 02:47:13,462 - DEBUG - Gateway for vn default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet0-99217706 is 11.1.1.1 and allocation pool is NOT set 2026-01-19 02:47:13,462 - DEBUG - Gateway for vn default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet0-99217706 is 2b72:8ff6:69b1:2e35:8646:d794:0:1 and allocation pool is NOT set 2026-01-19 02:47:17,550 - 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=2 ttl=63 time=7.94 ms\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 1 received, 50% packet loss, time 1023ms\r\nrtt min/avg/max/mdev = 7.941/7.941/7.941/0.000 ms') 2026-01-19 02:47:17,550 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-vmc0-96991212 passed 2026-01-19 02:47:17,623 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-01-19 02:47:17,623 - DEBUG - Waiting to SSH to VM ctest-vmc0-96991212, IP 10.1.1.3, Port 22 2026-01-19 02:47:17,679 - 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-01-19 02:47:17,766 - DEBUG - VM ctest-vmc0-96991212 is NOT ready for SSH connections, VM status: ACTIVE 2026-01-19 02:47:22,767 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-01-19 02:47:22,767 - DEBUG - Waiting to SSH to VM ctest-vmc0-96991212, IP 10.1.1.3, Port 22 2026-01-19 02:47:22,835 - 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-01-19 02:47:22,960 - DEBUG - VM ctest-vmc0-96991212 is NOT ready for SSH connections, VM status: ACTIVE 2026-01-19 02:47:27,960 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-01-19 02:47:27,961 - DEBUG - Waiting to SSH to VM ctest-vmc0-96991212, IP 10.1.1.3, Port 22 2026-01-19 02:47:28,029 - 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-01-19 02:47:28,122 - DEBUG - VM ctest-vmc0-96991212 is NOT ready for SSH connections, VM status: ACTIVE 2026-01-19 02:47:33,123 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-01-19 02:47:33,124 - DEBUG - Waiting to SSH to VM ctest-vmc0-96991212, IP 10.1.1.3, Port 22 2026-01-19 02:47:33,179 - 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-01-19 02:47:33,256 - DEBUG - VM ctest-vmc0-96991212 is NOT ready for SSH connections, VM status: ACTIVE 2026-01-19 02:47:38,257 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-01-19 02:47:38,257 - DEBUG - Waiting to SSH to VM ctest-vmc0-96991212, IP 10.1.1.3, Port 22 2026-01-19 02:47:38,325 - 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-01-19 02:47:38,404 - DEBUG - VM ctest-vmc0-96991212 is NOT ready for SSH connections, VM status: ACTIVE 2026-01-19 02:47:43,404 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-01-19 02:47:43,404 - DEBUG - Waiting to SSH to VM ctest-vmc0-96991212, IP 10.1.1.3, Port 22 2026-01-19 02:47:43,572 - DEBUG - VM ctest-vmc0-96991212 is ready for SSH connections 2026-01-19 02:47:43,572 - INFO - Waiting for VM ctest-vmc1-09943559 to be up.. 2026-01-19 02:47:43,648 - DEBUG - VM is in ACTIVE state now 2026-01-19 02:47:43,648 - INFO - VM name : ctest-vmc1-09943559 2026-01-19 02:47:43,727 - DEBUG - VM ctest-vmc1-09943559 ID is 6526dd0e-1196-4117-8bb5-a74471a8b0ef 2026-01-19 02:47:43,727 - DEBUG - VM ctest-vmc1-09943559 launched on Node an-jenkins-deploy-platform-ansible-os-5040-2 2026-01-19 02:47:43,817 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/6526dd0e-1196-4117-8bb5-a74471a8b0ef 2026-01-19 02:47:43,828 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/2ad9287e-df3b-4b8d-abdf-ac4c51dbe61d 2026-01-19 02:47:44,988 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n64 bytes from 169.254.0.3: icmp_seq=1 ttl=63 time=2.68 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.570 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.570/1.625/2.680/1.055 ms') 2026-01-19 02:47:44,989 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-vmc1-09943559 passed 2026-01-19 02:47:45,056 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-01-19 02:47:45,056 - DEBUG - Waiting to SSH to VM ctest-vmc1-09943559, IP 12.1.1.3, Port 22 2026-01-19 02:47:45,223 - DEBUG - VM ctest-vmc1-09943559 is ready for SSH connections 2026-01-19 02:47:45,228 - DEBUG - Skipping the policy rule comparison since VM's are not exist for selected project:admin 2026-01-19 02:47:45,228 - DEBUG - Skipping the policy rule comparison since VM's are not exist for selected project:ctest-TestECMPIPv6Fragments-18501284 2026-01-19 02:47:45,432 - DEBUG - Requesting: http://10.0.0.27:8082/domains 2026-01-19 02:47:45,437 - DEBUG - Requesting: http://10.0.0.27:8082/domain/bc123c74-c45e-4d7a-a955-76f59d7a4cc7 2026-01-19 02:47:45,447 - DEBUG - Requesting: http://10.0.0.27:8082/project/cc751c61-127b-4002-a4fc-c2b2a652cb26 2026-01-19 02:47:45,538 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/7bb0dc5f-08da-4272-afb4-47e10df56c8e 2026-01-19 02:47:45,551 - DEBUG - Order of the policy's list:['policy100'] 2026-01-19 02:47:45,562 - DEBUG - , ['policy100'], ['admin', 'ctest-TestECMPIPv6Fragments-18501284', 'ctest-TestDetailedPolicy1Ipv4v6-14690172'], [, ], ['ctest-vnet1-43842364'] 2026-01-19 02:47:45,562 - DEBUG - Traslation of quantum rules to ACES format 2026-01-19 02:47:45,562 - DEBUG - vn is ctest-vnet1-43842364, vn_policy is policy100 2026-01-19 02:47:45,562 - DEBUG - VN: ctest-vnet1-43842364, expected ACE's is 2026-01-19 02:47:45,562 - 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-01-19 02:47:45,562 - DEBUG - Verify rules expected in CN if VN-VM in CN 2026-01-19 02:47:45,562 - DEBUG - CN: 10.0.0.249, Check for expected data 2026-01-19 02:47:45,571 - DEBUG - Verify rules expected in CN if VN-VM in CN 2026-01-19 02:47:45,571 - DEBUG - CN: 10.0.0.65, Check for expected data 2026-01-19 02:47:45,592 - DEBUG - ---------------------------------------- 2026-01-19 02:47:45,592 - DEBUG - CN: 10.0.0.65, VN: ctest-vnet1-43842364, result of expected rules check passed 2026-01-19 02:47:45,592 - INFO - Validated the rules for VM:ctest-vmc1-09943559 with attached policy:['policy100'] and vn:ctest-vnet1-43842364 2026-01-19 02:47:45,592 - DEBUG - Verify policy rules for other vn if it is present 2026-01-19 02:47:45,666 - DEBUG - Requesting: http://10.0.0.27:8082/domains 2026-01-19 02:47:45,672 - DEBUG - Requesting: http://10.0.0.27:8082/domain/bc123c74-c45e-4d7a-a955-76f59d7a4cc7 2026-01-19 02:47:45,683 - DEBUG - Requesting: http://10.0.0.27:8082/project/cc751c61-127b-4002-a4fc-c2b2a652cb26 2026-01-19 02:47:45,771 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/6d9e4248-f02e-4eb9-8318-39780205931e 2026-01-19 02:47:45,785 - DEBUG - Order of the policy's list:['policy0'] 2026-01-19 02:47:45,796 - DEBUG - , ['policy0'], ['admin', 'ctest-TestECMPIPv6Fragments-18501284', 'ctest-TestDetailedPolicy1Ipv4v6-14690172'], [, ], ['ctest-vnet0-99217706'] 2026-01-19 02:47:45,796 - DEBUG - Traslation of quantum rules to ACES format 2026-01-19 02:47:45,797 - DEBUG - vn is ctest-vnet0-99217706, vn_policy is policy0 2026-01-19 02:47:45,797 - DEBUG - VN: ctest-vnet0-99217706, expected ACE's is 2026-01-19 02:47:45,797 - 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-14690172:ctest-vnet0-99217706", "dst_port_l": {"max": "65535", "min": "0"}, "proto_l": {"max": "tcp", "min": "tcp"}, "rule_type": "Terminal", "src": "default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet1-43842364", "src_port_l": {"max": "65535", "min": "0"}} 2026-01-19 02:47:45,797 - 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-14690172:ctest-vnet1-43842364", "dst_port_l": {"max": "65535", "min": "0"}, "proto_l": {"max": "tcp", "min": "tcp"}, "rule_type": "Terminal", "src": "default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet0-99217706", "src_port_l": {"max": "65535", "min": "0"}} 2026-01-19 02:47:45,797 - 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-14690172:ctest-vnet0-99217706", "dst_port_l": {"max": "65535", "min": "0"}, "proto_l": {"max": "udp", "min": "udp"}, "rule_type": "Terminal", "src": "default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet1-43842364", "src_port_l": {"max": "65535", "min": "0"}} 2026-01-19 02:47:45,797 - 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-14690172:ctest-vnet1-43842364", "dst_port_l": {"max": "65535", "min": "0"}, "proto_l": {"max": "udp", "min": "udp"}, "rule_type": "Terminal", "src": "default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet0-99217706", "src_port_l": {"max": "65535", "min": "0"}} 2026-01-19 02:47:45,797 - 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-14690172:ctest-vnet0-99217706", "dst_port_l": {"max": "65535", "min": "0"}, "proto_l": {"max": "icmp", "min": "icmp"}, "rule_type": "Terminal", "src": "default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet1-43842364", "src_port_l": {"max": "65535", "min": "0"}} 2026-01-19 02:47:45,797 - 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-14690172:ctest-vnet1-43842364", "dst_port_l": {"max": "65535", "min": "0"}, "proto_l": {"max": "icmp", "min": "icmp"}, "rule_type": "Terminal", "src": "default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet0-99217706", "src_port_l": {"max": "65535", "min": "0"}} 2026-01-19 02:47:45,797 - 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-14690172:ctest-vnet0-99217706", "dst_port_l": {"max": "65535", "min": "0"}, "proto_l": {"max": "58", "min": "58"}, "rule_type": "Terminal", "src": "default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet1-43842364", "src_port_l": {"max": "65535", "min": "0"}} 2026-01-19 02:47:45,797 - 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-14690172:ctest-vnet1-43842364", "dst_port_l": {"max": "65535", "min": "0"}, "proto_l": {"max": "58", "min": "58"}, "rule_type": "Terminal", "src": "default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet0-99217706", "src_port_l": {"max": "65535", "min": "0"}} 2026-01-19 02:47:45,797 - DEBUG - {"ace_id": "9", "action_l": ["pass"], "dst": "default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet0-99217706", "dst_port_l": {"max": "65535", "min": "0"}, "proto_l": {"max": "255", "min": "0"}, "rule_type": "Terminal", "src": "default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet0-99217706", "src_port_l": {"max": "65535", "min": "0"}} 2026-01-19 02:47:45,797 - DEBUG - {"ace_id": "10", "action_l": ["deny"], "dst": "default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet0-99217706", "dst_port_l": {"max": "65535", "min": "0"}, "proto_l": {"max": "255", "min": "0"}, "rule_type": "Terminal", "src": "default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet1-43842364", "src_port_l": {"max": "65535", "min": "0"}} 2026-01-19 02:47:45,797 - DEBUG - {"ace_id": "11", "action_l": ["deny"], "dst": "default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet1-43842364", "dst_port_l": {"max": "65535", "min": "0"}, "proto_l": {"max": "255", "min": "0"}, "rule_type": "Terminal", "src": "default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet0-99217706", "src_port_l": {"max": "65535", "min": "0"}} 2026-01-19 02:47:45,798 - 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-01-19 02:47:45,798 - DEBUG - Verify rules expected in CN if VN-VM in CN 2026-01-19 02:47:45,798 - DEBUG - CN: 10.0.0.249, Check for expected data 2026-01-19 02:47:45,828 - DEBUG - ---------------------------------------- 2026-01-19 02:47:45,828 - DEBUG - CN: 10.0.0.249, VN: ctest-vnet0-99217706, result of expected rules check passed 2026-01-19 02:47:45,828 - INFO - Validated the rules for VM:ctest-vmc0-96991212 with attached policy:['policy0'] and vn:ctest-vnet0-99217706 2026-01-19 02:47:45,828 - DEBUG - Verify rules expected in CN if VN-VM in CN 2026-01-19 02:47:45,828 - DEBUG - CN: 10.0.0.65, Check for expected data 2026-01-19 02:47:45,834 - DEBUG - Verify policy rules for other vn if it is present 2026-01-19 02:47:45,834 - INFO - Policy rules comparison with system for all Virtual networks are done 2026-01-19 02:47:45,835 - INFO - Setup completed with result True 2026-01-19 02:47:46,001 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': '6d9e4248-f02e-4eb9-8318-39780205931e', 'name': 'ctest-vnet0-99217706', 'tenant_id': 'cc751c61127b4002a4fcc2b2a652cb26', 'project_id': 'cc751c61127b4002a4fcc2b2a652cb26', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['bbeeae9e-c8d1-4f70-a6c2-6e3b322b8e47', '58413eaa-42e9-4095-9b62-b583707e36b1', '39c23520-56d6-41ea-9100-baa4264b9c9c'], 'fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-14690172', 'ctest-vnet0-99217706'], 'policys': [['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-14690172', 'policy1']], 'subnet_ipam': [{'subnet_cidr': '10.1.1.0/24', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-14690172', 'ctest-TestDetailedPolicy1Ipv4v6-14690172-default-ipam']}, {'subnet_cidr': '11.1.1.0/24', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-14690172', 'ctest-TestDetailedPolicy1Ipv4v6-14690172-default-ipam']}, {'subnet_cidr': '2b72:8ff6:69b1:2e35:8646:d794::/96', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-14690172', 'ctest-TestDetailedPolicy1Ipv4v6-14690172-default-ipam']}], 'port_security_enabled': True, 'description': ''}} 2026-01-19 02:47:51,104 - INFO - new policy list of vn ctest-vnet0-99217706 is policy1 2026-01-19 02:47:51,104 - INFO - Starting Verifications after policy for ctest-vnet0-99217706 updated to policy1 2026-01-19 02:47:51,104 - INFO - policy in effect is : [{'direction': '<>', 'protocol': 'tcp', 'dest_network': 'ctest-vnet0-99217706', 'source_network': 'ctest-vnet1-43842364', 'dst_ports': 'any', 'simple_action': 'pass', 'src_ports': 'any'}, {'direction': '<>', 'protocol': 'udp', 'dest_network': 'ctest-vnet0-99217706', 'source_network': 'ctest-vnet1-43842364', 'dst_ports': 'any', 'simple_action': 'pass', 'src_ports': 'any'}, {'direction': '<>', 'protocol': 'icmp', 'dest_network': 'ctest-vnet0-99217706', 'source_network': 'ctest-vnet1-43842364', 'dst_ports': 'any', 'simple_action': 'pass', 'src_ports': 'any'}, {'direction': '<>', 'protocol': '58', 'dest_network': 'ctest-vnet0-99217706', 'source_network': 'ctest-vnet1-43842364', 'dst_ports': 'any', 'simple_action': 'pass', 'src_ports': 'any'}] 2026-01-19 02:47:51,105 - INFO - matching_rule_action: {'tcp': 'pass', 'udp': 'pass', 'icmp': 'pass', '58': 'pass'} 2026-01-19 02:47:51,105 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-01-19 02:47:51,105 - 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.249, gateway password: c0ntrail123 2026-01-19 02:47:51,105 - DEBUG - ping -s 56 -c 3 -W 1 12.1.1.3 2026-01-19 02:48:06,800 - 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.32 ms 64 bytes from 12.1.1.3: icmp_req=2 ttl=63 time=1.47 ms 64 bytes from 12.1.1.3: icmp_req=3 ttl=63 time=1.16 ms --- 12.1.1.3 ping statistics --- 3 packets transmitted, 3 received, 0% packet loss, time 2004ms rtt min/avg/max/mdev = 1.163/2.989/6.327/2.364 ms 2026-01-19 02:48:06,800 - INFO - Ping to IP 12.1.1.3 from VM ctest-vmc0-96991212 passed 2026-01-19 02:48:06,801 - DEBUG - Running remote_cmd, Cmd : ping6 -s 56 -c 3 -W 1 2361:8b15:ffd7:263f:72fb:105c:0:3, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.249, gateway password: c0ntrail123 2026-01-19 02:48:06,801 - DEBUG - ping6 -s 56 -c 3 -W 1 2361:8b15:ffd7:263f:72fb:105c:0:3 2026-01-19 02:48:09,327 - DEBUG - PING 2361:8b15:ffd7:263f:72fb:105c:0:3(2361:8b15:ffd7:263f:72fb:105c:0:3) 56 data bytes 64 bytes from 2361:8b15:ffd7:263f:72fb:105c:0:3: icmp_seq=1 ttl=64 time=7.59 ms 64 bytes from 2361:8b15:ffd7:263f:72fb:105c:0:3: icmp_seq=2 ttl=64 time=1.47 ms 64 bytes from 2361:8b15:ffd7:263f:72fb:105c:0:3: icmp_seq=3 ttl=64 time=1.37 ms --- 2361:8b15:ffd7:263f:72fb:105c:0:3 ping statistics --- 3 packets transmitted, 3 received, 0% packet loss, time 2004ms rtt min/avg/max/mdev = 1.370/3.479/7.591/2.908 ms 2026-01-19 02:48:09,328 - INFO - Ping to IP 2361:8b15:ffd7:263f:72fb:105c:0:3 from VM ctest-vmc0-96991212 passed 2026-01-19 02:48:09,328 - INFO - vm ping test result after policy for ctest-vnet0-99217706 updated to policy1 is: True 2026-01-19 02:48:09,475 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': '6d9e4248-f02e-4eb9-8318-39780205931e', 'name': 'ctest-vnet0-99217706', 'tenant_id': 'cc751c61127b4002a4fcc2b2a652cb26', 'project_id': 'cc751c61127b4002a4fcc2b2a652cb26', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['bbeeae9e-c8d1-4f70-a6c2-6e3b322b8e47', '58413eaa-42e9-4095-9b62-b583707e36b1', '39c23520-56d6-41ea-9100-baa4264b9c9c'], 'fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-14690172', 'ctest-vnet0-99217706'], 'policys': [['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-14690172', 'policy1000']], 'subnet_ipam': [{'subnet_cidr': '10.1.1.0/24', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-14690172', 'ctest-TestDetailedPolicy1Ipv4v6-14690172-default-ipam']}, {'subnet_cidr': '11.1.1.0/24', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-14690172', 'ctest-TestDetailedPolicy1Ipv4v6-14690172-default-ipam']}, {'subnet_cidr': '2b72:8ff6:69b1:2e35:8646:d794::/96', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-14690172', 'ctest-TestDetailedPolicy1Ipv4v6-14690172-default-ipam']}], 'port_security_enabled': True, 'description': ''}} 2026-01-19 02:48:14,639 - INFO - new policy list of vn ctest-vnet0-99217706 is policy1000 2026-01-19 02:48:14,640 - INFO - Starting Verifications after policy for ctest-vnet0-99217706 updated to policy1000 2026-01-19 02:48:14,640 - INFO - policy in effect is : [] 2026-01-19 02:48:14,640 - INFO - matching_rule_action: {'icmp': 'deny'} 2026-01-19 02:48:14,640 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-01-19 02:48:14,640 - 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.249, gateway password: c0ntrail123 2026-01-19 02:48:14,640 - DEBUG - ping -s 56 -c 3 -W 1 12.1.1.3 2026-01-19 02:48:18,554 - 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-01-19 02:48:18,554 - WARNING - Ping to IP 12.1.1.3 from VM ctest-vmc0-96991212 failed 2026-01-19 02:48:18,555 - DEBUG - Running remote_cmd, Cmd : ping6 -s 56 -c 3 -W 1 2361:8b15:ffd7:263f:72fb:105c:0:3, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.249, gateway password: c0ntrail123 2026-01-19 02:48:18,555 - DEBUG - ping6 -s 56 -c 3 -W 1 2361:8b15:ffd7:263f:72fb:105c:0:3 2026-01-19 02:48:22,054 - DEBUG - PING 2361:8b15:ffd7:263f:72fb:105c:0:3(2361:8b15:ffd7:263f:72fb:105c:0:3) 56 data bytes --- 2361:8b15:ffd7:263f:72fb:105c:0:3 ping statistics --- 3 packets transmitted, 0 received, 100% packet loss, time 2016ms 2026-01-19 02:48:22,054 - WARNING - Ping to IP 2361:8b15:ffd7:263f:72fb:105c:0:3 from VM ctest-vmc0-96991212 failed 2026-01-19 02:48:22,054 - INFO - vm ping test result after policy for ctest-vnet0-99217706 updated to policy1000 is: True 2026-01-19 02:48:22,170 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': '6d9e4248-f02e-4eb9-8318-39780205931e', 'name': 'ctest-vnet0-99217706', 'tenant_id': 'cc751c61127b4002a4fcc2b2a652cb26', 'project_id': 'cc751c61127b4002a4fcc2b2a652cb26', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['bbeeae9e-c8d1-4f70-a6c2-6e3b322b8e47', '58413eaa-42e9-4095-9b62-b583707e36b1', '39c23520-56d6-41ea-9100-baa4264b9c9c'], 'fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-14690172', 'ctest-vnet0-99217706'], 'policys': [['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-14690172', 'policy2']], 'subnet_ipam': [{'subnet_cidr': '10.1.1.0/24', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-14690172', 'ctest-TestDetailedPolicy1Ipv4v6-14690172-default-ipam']}, {'subnet_cidr': '11.1.1.0/24', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-14690172', 'ctest-TestDetailedPolicy1Ipv4v6-14690172-default-ipam']}, {'subnet_cidr': '2b72:8ff6:69b1:2e35:8646:d794::/96', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-14690172', 'ctest-TestDetailedPolicy1Ipv4v6-14690172-default-ipam']}], 'port_security_enabled': True, 'description': ''}} 2026-01-19 02:48:27,272 - INFO - new policy list of vn ctest-vnet0-99217706 is policy2 2026-01-19 02:48:27,273 - INFO - Starting Verifications after policy for ctest-vnet0-99217706 updated to policy2 2026-01-19 02:48:27,273 - INFO - policy in effect is : [{'direction': '<>', 'protocol': 'tcp', 'dest_network': 'ctest-vnet0-99217706', 'source_network': 'ctest-vnet1-43842364', 'dst_ports': 'any', 'simple_action': 'pass', 'src_ports': 'any'}, {'direction': '<>', 'protocol': 'udp', 'dest_network': 'ctest-vnet0-99217706', 'source_network': 'ctest-vnet1-43842364', 'dst_ports': 'any', 'simple_action': 'deny', 'src_ports': 'any'}, {'direction': '<>', 'protocol': 'icmp', 'dest_network': 'ctest-vnet0-99217706', 'source_network': 'ctest-vnet1-43842364', 'dst_ports': 'any', 'simple_action': 'deny', 'src_ports': 'any'}, {'direction': '<>', 'protocol': '58', 'dest_network': 'ctest-vnet0-99217706', 'source_network': 'ctest-vnet1-43842364', 'dst_ports': 'any', 'simple_action': 'deny', 'src_ports': 'any'}] 2026-01-19 02:48:27,273 - INFO - matching_rule_action: {'tcp': 'pass', 'udp': 'deny', 'icmp': 'deny', '58': 'deny'} 2026-01-19 02:48:27,273 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-01-19 02:48:27,273 - 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.249, gateway password: c0ntrail123 2026-01-19 02:48:27,273 - DEBUG - ping -s 56 -c 3 -W 1 12.1.1.3 2026-01-19 02:48:30,733 - 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 2001ms 2026-01-19 02:48:30,733 - WARNING - Ping to IP 12.1.1.3 from VM ctest-vmc0-96991212 failed 2026-01-19 02:48:30,733 - DEBUG - Running remote_cmd, Cmd : ping6 -s 56 -c 3 -W 1 2361:8b15:ffd7:263f:72fb:105c:0:3, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.249, gateway password: c0ntrail123 2026-01-19 02:48:30,734 - DEBUG - ping6 -s 56 -c 3 -W 1 2361:8b15:ffd7:263f:72fb:105c:0:3 2026-01-19 02:48:34,286 - DEBUG - PING 2361:8b15:ffd7:263f:72fb:105c:0:3(2361:8b15:ffd7:263f:72fb:105c:0:3) 56 data bytes --- 2361:8b15:ffd7:263f:72fb:105c:0:3 ping statistics --- 3 packets transmitted, 0 received, 100% packet loss, time 2017ms 2026-01-19 02:48:34,287 - WARNING - Ping to IP 2361:8b15:ffd7:263f:72fb:105c:0:3 from VM ctest-vmc0-96991212 failed 2026-01-19 02:48:34,287 - INFO - vm ping test result after policy for ctest-vnet0-99217706 updated to policy2 is: True 2026-01-19 02:48:34,413 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': '6d9e4248-f02e-4eb9-8318-39780205931e', 'name': 'ctest-vnet0-99217706', 'tenant_id': 'cc751c61127b4002a4fcc2b2a652cb26', 'project_id': 'cc751c61127b4002a4fcc2b2a652cb26', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['bbeeae9e-c8d1-4f70-a6c2-6e3b322b8e47', '58413eaa-42e9-4095-9b62-b583707e36b1', '39c23520-56d6-41ea-9100-baa4264b9c9c'], 'fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-14690172', 'ctest-vnet0-99217706'], 'policys': [['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-14690172', 'policy3']], 'subnet_ipam': [{'subnet_cidr': '10.1.1.0/24', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-14690172', 'ctest-TestDetailedPolicy1Ipv4v6-14690172-default-ipam']}, {'subnet_cidr': '11.1.1.0/24', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-14690172', 'ctest-TestDetailedPolicy1Ipv4v6-14690172-default-ipam']}, {'subnet_cidr': '2b72:8ff6:69b1:2e35:8646:d794::/96', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-14690172', 'ctest-TestDetailedPolicy1Ipv4v6-14690172-default-ipam']}], 'port_security_enabled': True, 'description': ''}} 2026-01-19 02:48:39,518 - INFO - new policy list of vn ctest-vnet0-99217706 is policy3 2026-01-19 02:48:39,519 - INFO - Starting Verifications after policy for ctest-vnet0-99217706 updated to policy3 2026-01-19 02:48:39,519 - INFO - policy in effect is : [{'direction': '<>', 'protocol': 'tcp', 'dest_network': 'ctest-vnet0-99217706', 'source_network': 'ctest-vnet1-43842364', 'dst_ports': 'any', 'simple_action': 'pass', 'src_ports': 'any'}, {'direction': '<>', 'protocol': 'udp', 'dest_network': 'ctest-vnet0-99217706', 'source_network': 'ctest-vnet1-43842364', 'dst_ports': 'any', 'simple_action': 'deny', 'src_ports': 'any'}, {'direction': '<>', 'protocol': 'icmp', 'dest_network': 'ctest-vnet0-99217706', 'source_network': 'ctest-vnet1-43842364', 'dst_ports': 'any', 'simple_action': 'pass', 'src_ports': 'any'}, {'direction': '<>', 'protocol': '58', 'dest_network': 'ctest-vnet0-99217706', 'source_network': 'ctest-vnet1-43842364', 'dst_ports': 'any', 'simple_action': 'pass', 'src_ports': 'any'}] 2026-01-19 02:48:39,520 - INFO - matching_rule_action: {'tcp': 'pass', 'udp': 'deny', 'icmp': 'pass', '58': 'pass'} 2026-01-19 02:48:39,520 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-01-19 02:48:39,520 - 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.249, gateway password: c0ntrail123 2026-01-19 02:48:39,520 - DEBUG - ping -s 56 -c 3 -W 1 12.1.1.3 2026-01-19 02:48:41,995 - 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.40 ms 64 bytes from 12.1.1.3: icmp_req=2 ttl=63 time=1.10 ms 64 bytes from 12.1.1.3: icmp_req=3 ttl=63 time=1.36 ms --- 12.1.1.3 ping statistics --- 3 packets transmitted, 3 received, 0% packet loss, time 2004ms rtt min/avg/max/mdev = 1.106/2.290/4.406/1.500 ms 2026-01-19 02:48:41,996 - INFO - Ping to IP 12.1.1.3 from VM ctest-vmc0-96991212 passed 2026-01-19 02:48:41,996 - DEBUG - Running remote_cmd, Cmd : ping6 -s 56 -c 3 -W 1 2361:8b15:ffd7:263f:72fb:105c:0:3, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.249, gateway password: c0ntrail123 2026-01-19 02:48:41,996 - DEBUG - ping6 -s 56 -c 3 -W 1 2361:8b15:ffd7:263f:72fb:105c:0:3 2026-01-19 02:48:44,491 - DEBUG - PING 2361:8b15:ffd7:263f:72fb:105c:0:3(2361:8b15:ffd7:263f:72fb:105c:0:3) 56 data bytes 64 bytes from 2361:8b15:ffd7:263f:72fb:105c:0:3: icmp_seq=1 ttl=64 time=2.79 ms 64 bytes from 2361:8b15:ffd7:263f:72fb:105c:0:3: icmp_seq=2 ttl=64 time=1.33 ms 64 bytes from 2361:8b15:ffd7:263f:72fb:105c:0:3: icmp_seq=3 ttl=64 time=1.76 ms --- 2361:8b15:ffd7:263f:72fb:105c:0:3 ping statistics --- 3 packets transmitted, 3 received, 0% packet loss, time 2003ms rtt min/avg/max/mdev = 1.335/1.966/2.798/0.614 ms 2026-01-19 02:48:44,491 - INFO - Ping to IP 2361:8b15:ffd7:263f:72fb:105c:0:3 from VM ctest-vmc0-96991212 passed 2026-01-19 02:48:44,491 - INFO - vm ping test result after policy for ctest-vnet0-99217706 updated to policy3 is: True 2026-01-19 02:48:44,650 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': '6d9e4248-f02e-4eb9-8318-39780205931e', 'name': 'ctest-vnet0-99217706', 'tenant_id': 'cc751c61127b4002a4fcc2b2a652cb26', 'project_id': 'cc751c61127b4002a4fcc2b2a652cb26', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['bbeeae9e-c8d1-4f70-a6c2-6e3b322b8e47', '58413eaa-42e9-4095-9b62-b583707e36b1', '39c23520-56d6-41ea-9100-baa4264b9c9c'], 'fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-14690172', 'ctest-vnet0-99217706'], 'policys': [['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-14690172', 'policy10']], 'subnet_ipam': [{'subnet_cidr': '10.1.1.0/24', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-14690172', 'ctest-TestDetailedPolicy1Ipv4v6-14690172-default-ipam']}, {'subnet_cidr': '11.1.1.0/24', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-14690172', 'ctest-TestDetailedPolicy1Ipv4v6-14690172-default-ipam']}, {'subnet_cidr': '2b72:8ff6:69b1:2e35:8646:d794::/96', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-14690172', 'ctest-TestDetailedPolicy1Ipv4v6-14690172-default-ipam']}], 'port_security_enabled': True, 'description': ''}} 2026-01-19 02:48:49,774 - INFO - new policy list of vn ctest-vnet0-99217706 is policy10 2026-01-19 02:48:49,775 - INFO - Starting Verifications after policy for ctest-vnet0-99217706 updated to policy10 2026-01-19 02:48:49,775 - INFO - policy in effect is : [{'direction': '<>', 'protocol': 'udp', 'dest_network': 'ctest-vnet0-99217706', 'source_network': 'ctest-vnet1-43842364', 'dst_ports': 'any', 'simple_action': 'deny', 'src_ports': 'any'}, {'direction': '<>', 'protocol': 'tcp', 'dest_network': 'ctest-vnet0-99217706', 'source_network': 'ctest-vnet1-43842364', 'dst_ports': 'any', 'simple_action': 'deny', 'src_ports': 'any'}, {'direction': '<>', 'protocol': 'icmp', 'dest_network': 'ctest-vnet0-99217706', 'source_network': 'ctest-vnet1-43842364', 'dst_ports': 'any', 'simple_action': 'deny', 'src_ports': 'any'}, {'direction': '<>', 'protocol': '58', 'dest_network': 'ctest-vnet0-99217706', 'source_network': 'ctest-vnet1-43842364', 'dst_ports': 'any', 'simple_action': 'deny', 'src_ports': 'any'}] 2026-01-19 02:48:49,775 - INFO - matching_rule_action: {'udp': 'deny', 'tcp': 'deny', 'icmp': 'deny', '58': 'deny'} 2026-01-19 02:48:49,775 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-01-19 02:48:49,775 - 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.249, gateway password: c0ntrail123 2026-01-19 02:48:49,776 - DEBUG - ping -s 56 -c 3 -W 1 12.1.1.3 2026-01-19 02:48:53,266 - 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 2016ms 2026-01-19 02:48:53,266 - WARNING - Ping to IP 12.1.1.3 from VM ctest-vmc0-96991212 failed 2026-01-19 02:48:53,267 - DEBUG - Running remote_cmd, Cmd : ping6 -s 56 -c 3 -W 1 2361:8b15:ffd7:263f:72fb:105c:0:3, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.249, gateway password: c0ntrail123 2026-01-19 02:48:53,267 - DEBUG - ping6 -s 56 -c 3 -W 1 2361:8b15:ffd7:263f:72fb:105c:0:3 2026-01-19 02:48:57,235 - DEBUG - PING 2361:8b15:ffd7:263f:72fb:105c:0:3(2361:8b15:ffd7:263f:72fb:105c:0:3) 56 data bytes --- 2361:8b15:ffd7:263f:72fb:105c:0:3 ping statistics --- 3 packets transmitted, 0 received, 100% packet loss, time 2033ms 2026-01-19 02:48:57,235 - WARNING - Ping to IP 2361:8b15:ffd7:263f:72fb:105c:0:3 from VM ctest-vmc0-96991212 failed 2026-01-19 02:48:57,235 - INFO - vm ping test result after policy for ctest-vnet0-99217706 updated to policy10 is: True 2026-01-19 02:48:57,353 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': '6d9e4248-f02e-4eb9-8318-39780205931e', 'name': 'ctest-vnet0-99217706', 'tenant_id': 'cc751c61127b4002a4fcc2b2a652cb26', 'project_id': 'cc751c61127b4002a4fcc2b2a652cb26', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['bbeeae9e-c8d1-4f70-a6c2-6e3b322b8e47', '58413eaa-42e9-4095-9b62-b583707e36b1', '39c23520-56d6-41ea-9100-baa4264b9c9c'], 'fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-14690172', 'ctest-vnet0-99217706'], 'policys': [['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-14690172', 'policy11']], 'subnet_ipam': [{'subnet_cidr': '10.1.1.0/24', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-14690172', 'ctest-TestDetailedPolicy1Ipv4v6-14690172-default-ipam']}, {'subnet_cidr': '11.1.1.0/24', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-14690172', 'ctest-TestDetailedPolicy1Ipv4v6-14690172-default-ipam']}, {'subnet_cidr': '2b72:8ff6:69b1:2e35:8646:d794::/96', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-14690172', 'ctest-TestDetailedPolicy1Ipv4v6-14690172-default-ipam']}], 'port_security_enabled': True, 'description': ''}} 2026-01-19 02:49:02,458 - INFO - new policy list of vn ctest-vnet0-99217706 is policy11 2026-01-19 02:49:02,459 - INFO - Starting Verifications after policy for ctest-vnet0-99217706 updated to policy11 2026-01-19 02:49:02,459 - INFO - policy in effect is : [{'direction': '<>', 'protocol': 'udp', 'dest_network': 'ctest-vnet0-99217706', 'source_network': 'ctest-vnet1-43842364', 'dst_ports': 'any', 'simple_action': 'deny', 'src_ports': 'any'}, {'direction': '<>', 'protocol': 'tcp', 'dest_network': 'ctest-vnet0-99217706', 'source_network': 'ctest-vnet1-43842364', 'dst_ports': 'any', 'simple_action': 'deny', 'src_ports': 'any'}, {'direction': '<>', 'protocol': 'icmp', 'dest_network': 'ctest-vnet0-99217706', 'source_network': 'ctest-vnet1-43842364', 'dst_ports': 'any', 'simple_action': 'pass', 'src_ports': 'any'}, {'direction': '<>', 'protocol': '58', 'dest_network': 'ctest-vnet0-99217706', 'source_network': 'ctest-vnet1-43842364', 'dst_ports': 'any', 'simple_action': 'pass', 'src_ports': 'any'}] 2026-01-19 02:49:02,459 - INFO - matching_rule_action: {'udp': 'deny', 'tcp': 'deny', 'icmp': 'pass', '58': 'pass'} 2026-01-19 02:49:02,460 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-01-19 02:49:02,460 - 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.249, gateway password: c0ntrail123 2026-01-19 02:49:02,460 - DEBUG - ping -s 56 -c 3 -W 1 12.1.1.3 2026-01-19 02:49:04,983 - 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.72 ms 64 bytes from 12.1.1.3: icmp_req=2 ttl=63 time=1.39 ms 64 bytes from 12.1.1.3: icmp_req=3 ttl=63 time=1.69 ms --- 12.1.1.3 ping statistics --- 3 packets transmitted, 3 received, 0% packet loss, time 2006ms rtt min/avg/max/mdev = 1.394/3.271/6.729/2.448 ms 2026-01-19 02:49:04,984 - INFO - Ping to IP 12.1.1.3 from VM ctest-vmc0-96991212 passed 2026-01-19 02:49:04,984 - DEBUG - Running remote_cmd, Cmd : ping6 -s 56 -c 3 -W 1 2361:8b15:ffd7:263f:72fb:105c:0:3, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.249, gateway password: c0ntrail123 2026-01-19 02:49:04,984 - DEBUG - ping6 -s 56 -c 3 -W 1 2361:8b15:ffd7:263f:72fb:105c:0:3 2026-01-19 02:49:07,480 - DEBUG - PING 2361:8b15:ffd7:263f:72fb:105c:0:3(2361:8b15:ffd7:263f:72fb:105c:0:3) 56 data bytes 64 bytes from 2361:8b15:ffd7:263f:72fb:105c:0:3: icmp_seq=1 ttl=64 time=2.96 ms 64 bytes from 2361:8b15:ffd7:263f:72fb:105c:0:3: icmp_seq=2 ttl=64 time=1.32 ms 64 bytes from 2361:8b15:ffd7:263f:72fb:105c:0:3: icmp_seq=3 ttl=64 time=1.35 ms --- 2361:8b15:ffd7:263f:72fb:105c:0:3 ping statistics --- 3 packets transmitted, 3 received, 0% packet loss, time 2004ms rtt min/avg/max/mdev = 1.321/1.880/2.962/0.766 ms 2026-01-19 02:49:07,481 - INFO - Ping to IP 2361:8b15:ffd7:263f:72fb:105c:0:3 from VM ctest-vmc0-96991212 passed 2026-01-19 02:49:07,481 - INFO - vm ping test result after policy for ctest-vnet0-99217706 updated to policy11 is: True 2026-01-19 02:49:07,639 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': '6d9e4248-f02e-4eb9-8318-39780205931e', 'name': 'ctest-vnet0-99217706', 'tenant_id': 'cc751c61127b4002a4fcc2b2a652cb26', 'project_id': 'cc751c61127b4002a4fcc2b2a652cb26', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['bbeeae9e-c8d1-4f70-a6c2-6e3b322b8e47', '58413eaa-42e9-4095-9b62-b583707e36b1', '39c23520-56d6-41ea-9100-baa4264b9c9c'], 'fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-14690172', 'ctest-vnet0-99217706'], 'policys': [['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-14690172', 'policy12']], 'subnet_ipam': [{'subnet_cidr': '10.1.1.0/24', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-14690172', 'ctest-TestDetailedPolicy1Ipv4v6-14690172-default-ipam']}, {'subnet_cidr': '11.1.1.0/24', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-14690172', 'ctest-TestDetailedPolicy1Ipv4v6-14690172-default-ipam']}, {'subnet_cidr': '2b72:8ff6:69b1:2e35:8646:d794::/96', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-14690172', 'ctest-TestDetailedPolicy1Ipv4v6-14690172-default-ipam']}], 'port_security_enabled': True, 'description': ''}} 2026-01-19 02:49:12,755 - INFO - new policy list of vn ctest-vnet0-99217706 is policy12 2026-01-19 02:49:12,756 - INFO - Starting Verifications after policy for ctest-vnet0-99217706 updated to policy12 2026-01-19 02:49:12,756 - INFO - policy in effect is : [{'direction': '<>', 'protocol': 'tcp', 'dest_network': 'ctest-vnet0-99217706', 'source_network': 'ctest-vnet1-43842364', 'dst_ports': 'any', 'simple_action': 'deny', 'src_ports': 'any'}, {'direction': '<>', 'protocol': 'udp', 'dest_network': 'ctest-vnet0-99217706', 'source_network': 'ctest-vnet1-43842364', 'dst_ports': 'any', 'simple_action': 'pass', 'src_ports': 'any'}, {'direction': '<>', 'protocol': 'icmp', 'dest_network': 'ctest-vnet0-99217706', 'source_network': 'ctest-vnet1-43842364', 'dst_ports': 'any', 'simple_action': 'deny', 'src_ports': 'any'}, {'direction': '<>', 'protocol': '58', 'dest_network': 'ctest-vnet0-99217706', 'source_network': 'ctest-vnet1-43842364', 'dst_ports': 'any', 'simple_action': 'deny', 'src_ports': 'any'}] 2026-01-19 02:49:12,756 - INFO - matching_rule_action: {'tcp': 'deny', 'udp': 'pass', 'icmp': 'deny', '58': 'deny'} 2026-01-19 02:49:12,756 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-01-19 02:49:12,756 - 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.249, gateway password: c0ntrail123 2026-01-19 02:49:12,756 - DEBUG - ping -s 56 -c 3 -W 1 12.1.1.3 2026-01-19 02:49:16,210 - 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-01-19 02:49:16,211 - WARNING - Ping to IP 12.1.1.3 from VM ctest-vmc0-96991212 failed 2026-01-19 02:49:16,211 - DEBUG - Running remote_cmd, Cmd : ping6 -s 56 -c 3 -W 1 2361:8b15:ffd7:263f:72fb:105c:0:3, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.249, gateway password: c0ntrail123 2026-01-19 02:49:16,211 - DEBUG - ping6 -s 56 -c 3 -W 1 2361:8b15:ffd7:263f:72fb:105c:0:3 2026-01-19 02:49:19,718 - DEBUG - PING 2361:8b15:ffd7:263f:72fb:105c:0:3(2361:8b15:ffd7:263f:72fb:105c:0:3) 56 data bytes --- 2361:8b15:ffd7:263f:72fb:105c:0:3 ping statistics --- 3 packets transmitted, 0 received, 100% packet loss, time 2016ms 2026-01-19 02:49:19,719 - WARNING - Ping to IP 2361:8b15:ffd7:263f:72fb:105c:0:3 from VM ctest-vmc0-96991212 failed 2026-01-19 02:49:19,719 - INFO - vm ping test result after policy for ctest-vnet0-99217706 updated to policy12 is: True 2026-01-19 02:49:19,836 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': '6d9e4248-f02e-4eb9-8318-39780205931e', 'name': 'ctest-vnet0-99217706', 'tenant_id': 'cc751c61127b4002a4fcc2b2a652cb26', 'project_id': 'cc751c61127b4002a4fcc2b2a652cb26', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['bbeeae9e-c8d1-4f70-a6c2-6e3b322b8e47', '58413eaa-42e9-4095-9b62-b583707e36b1', '39c23520-56d6-41ea-9100-baa4264b9c9c'], 'fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-14690172', 'ctest-vnet0-99217706'], 'policys': [['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-14690172', 'policy13']], 'subnet_ipam': [{'subnet_cidr': '10.1.1.0/24', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-14690172', 'ctest-TestDetailedPolicy1Ipv4v6-14690172-default-ipam']}, {'subnet_cidr': '11.1.1.0/24', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-14690172', 'ctest-TestDetailedPolicy1Ipv4v6-14690172-default-ipam']}, {'subnet_cidr': '2b72:8ff6:69b1:2e35:8646:d794::/96', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-14690172', 'ctest-TestDetailedPolicy1Ipv4v6-14690172-default-ipam']}], 'port_security_enabled': True, 'description': ''}} 2026-01-19 02:49:24,941 - INFO - new policy list of vn ctest-vnet0-99217706 is policy13 2026-01-19 02:49:24,942 - INFO - Starting Verifications after policy for ctest-vnet0-99217706 updated to policy13 2026-01-19 02:49:24,942 - INFO - policy in effect is : [{'direction': '<>', 'protocol': 'udp', 'dest_network': 'ctest-vnet0-99217706', 'source_network': 'ctest-vnet1-43842364', 'dst_ports': 'any', 'simple_action': 'pass', 'src_ports': 'any'}, {'direction': '<>', 'protocol': 'icmp', 'dest_network': 'ctest-vnet0-99217706', 'source_network': 'ctest-vnet1-43842364', 'dst_ports': 'any', 'simple_action': 'pass', 'src_ports': 'any'}, {'direction': '<>', 'protocol': 'tcp', 'dest_network': 'ctest-vnet0-99217706', 'source_network': 'ctest-vnet1-43842364', 'dst_ports': 'any', 'simple_action': 'deny', 'src_ports': 'any'}, {'direction': '<>', 'protocol': '58', 'dest_network': 'ctest-vnet0-99217706', 'source_network': 'ctest-vnet1-43842364', 'dst_ports': 'any', 'simple_action': 'pass', 'src_ports': 'any'}] 2026-01-19 02:49:24,942 - INFO - matching_rule_action: {'udp': 'pass', 'icmp': 'pass', 'tcp': 'deny', '58': 'pass'} 2026-01-19 02:49:24,942 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-01-19 02:49:24,942 - 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.249, gateway password: c0ntrail123 2026-01-19 02:49:24,943 - DEBUG - ping -s 56 -c 3 -W 1 12.1.1.3 2026-01-19 02:49:27,439 - 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.67 ms 64 bytes from 12.1.1.3: icmp_req=2 ttl=63 time=1.07 ms 64 bytes from 12.1.1.3: icmp_req=3 ttl=63 time=1.27 ms --- 12.1.1.3 ping statistics --- 3 packets transmitted, 3 received, 0% packet loss, time 2003ms rtt min/avg/max/mdev = 1.077/2.008/3.675/1.182 ms 2026-01-19 02:49:27,439 - INFO - Ping to IP 12.1.1.3 from VM ctest-vmc0-96991212 passed 2026-01-19 02:49:27,439 - DEBUG - Running remote_cmd, Cmd : ping6 -s 56 -c 3 -W 1 2361:8b15:ffd7:263f:72fb:105c:0:3, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.249, gateway password: c0ntrail123 2026-01-19 02:49:27,440 - DEBUG - ping6 -s 56 -c 3 -W 1 2361:8b15:ffd7:263f:72fb:105c:0:3 2026-01-19 02:49:29,924 - DEBUG - PING 2361:8b15:ffd7:263f:72fb:105c:0:3(2361:8b15:ffd7:263f:72fb:105c:0:3) 56 data bytes 64 bytes from 2361:8b15:ffd7:263f:72fb:105c:0:3: icmp_seq=1 ttl=64 time=4.73 ms 64 bytes from 2361:8b15:ffd7:263f:72fb:105c:0:3: icmp_seq=2 ttl=64 time=1.80 ms 64 bytes from 2361:8b15:ffd7:263f:72fb:105c:0:3: icmp_seq=3 ttl=64 time=1.19 ms --- 2361:8b15:ffd7:263f:72fb:105c:0:3 ping statistics --- 3 packets transmitted, 3 received, 0% packet loss, time 2005ms rtt min/avg/max/mdev = 1.193/2.575/4.733/1.546 ms 2026-01-19 02:49:29,924 - INFO - Ping to IP 2361:8b15:ffd7:263f:72fb:105c:0:3 from VM ctest-vmc0-96991212 passed 2026-01-19 02:49:29,924 - INFO - vm ping test result after policy for ctest-vnet0-99217706 updated to policy13 is: True 2026-01-19 02:49:30,124 - INFO - Deleting VM ctest-vmc1-09943559 2026-01-19 02:49:30,207 - DEBUG - Verifying in api server 10.0.0.23 2026-01-19 02:49:30,207 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/6526dd0e-1196-4117-8bb5-a74471a8b0ef 2026-01-19 02:49:30,220 - DEBUG - VM ID 6526dd0e-1196-4117-8bb5-a74471a8b0ef of VM ctest-vmc1-09943559 is still found in API Server 2026-01-19 02:49:32,221 - DEBUG - Verifying in api server 10.0.0.23 2026-01-19 02:49:32,221 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/6526dd0e-1196-4117-8bb5-a74471a8b0ef 2026-01-19 02:49:32,227 - DEBUG - Response Code: 404 2026-01-19 02:49:32,227 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/6526dd0e-1196-4117-8bb5-a74471a8b0ef 2026-01-19 02:49:32,233 - DEBUG - Response Code: 404 2026-01-19 02:49:32,233 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/6526dd0e-1196-4117-8bb5-a74471a8b0ef 2026-01-19 02:49:32,239 - DEBUG - Response Code: 404 2026-01-19 02:49:32,239 - INFO - VM ctest-vmc1-09943559 is fully removed in API-Server 2026-01-19 02:49:32,390 - DEBUG - Skipping VM-deletion-check in nova db since mysql_token is not found 2026-01-19 02:49:32,436 - DEBUG - Validated that vrouter 10.0.0.249 does not have VMs route for VN default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet1-43842364 2026-01-19 02:49:32,445 - DEBUG - Validated that vrouter 10.0.0.65 does not have VMs route for VN default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet1-43842364 2026-01-19 02:49:32,445 - INFO - Validated that all vrouters do not have VMs route for VN default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet1-43842364 2026-01-19 02:49:32,445 - INFO - VM ctest-vmc1-09943559 is removed in Compute, and routes are removed in all compute nodes 2026-01-19 02:49:32,681 - INFO - Routes for VM ctest-vmc1-09943559 is removed in all control-nodes 2026-01-19 02:49:32,681 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5040-2:Compute:contrail-vrouter-agent:0?flat 2026-01-19 02:49:32,715 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5040-2?flat 2026-01-19 02:49:32,745 - DEBUG - VM 6526dd0e-1196-4117-8bb5-a74471a8b0ef is still present in vrouter an-jenkins-deploy-platform-ansible-os-5040-2 uve 2026-01-19 02:49:32,745 - DEBUG - Verifying if the vm interface deleted from vroter uve... 2026-01-19 02:49:32,746 - DEBUG - interface for vm 6526dd0e-1196-4117-8bb5-a74471a8b0ef deleted from vrouter uve ... 2026-01-19 02:49:32,746 - DEBUG - Deleted interface not in error interface list ... 2026-01-19 02:49:35,746 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5040-2:Compute:contrail-vrouter-agent:0?flat 2026-01-19 02:49:35,848 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5040-2?flat 2026-01-19 02:49:35,931 - DEBUG - VM 6526dd0e-1196-4117-8bb5-a74471a8b0ef is still present in vrouter an-jenkins-deploy-platform-ansible-os-5040-2 uve 2026-01-19 02:49:35,931 - DEBUG - Verifying if the vm interface deleted from vroter uve... 2026-01-19 02:49:35,931 - DEBUG - interface for vm 6526dd0e-1196-4117-8bb5-a74471a8b0ef deleted from vrouter uve ... 2026-01-19 02:49:35,931 - DEBUG - Deleted interface not in error interface list ... 2026-01-19 02:49:38,931 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5040-2:Compute:contrail-vrouter-agent:0?flat 2026-01-19 02:49:38,965 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5040-2?flat 2026-01-19 02:49:38,992 - DEBUG - VM 6526dd0e-1196-4117-8bb5-a74471a8b0ef is still present in vrouter an-jenkins-deploy-platform-ansible-os-5040-2 uve 2026-01-19 02:49:38,993 - DEBUG - Verifying if the vm interface deleted from vroter uve... 2026-01-19 02:49:38,993 - DEBUG - interface for vm 6526dd0e-1196-4117-8bb5-a74471a8b0ef deleted from vrouter uve ... 2026-01-19 02:49:38,993 - DEBUG - Deleted interface not in error interface list ... 2026-01-19 02:49:41,994 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5040-2:Compute:contrail-vrouter-agent:0?flat 2026-01-19 02:49:42,025 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5040-2?flat 2026-01-19 02:49:42,054 - DEBUG - VM 6526dd0e-1196-4117-8bb5-a74471a8b0ef is still present in vrouter an-jenkins-deploy-platform-ansible-os-5040-2 uve 2026-01-19 02:49:42,054 - DEBUG - Verifying if the vm interface deleted from vroter uve... 2026-01-19 02:49:42,054 - DEBUG - interface for vm 6526dd0e-1196-4117-8bb5-a74471a8b0ef deleted from vrouter uve ... 2026-01-19 02:49:42,054 - DEBUG - Deleted interface not in error interface list ... 2026-01-19 02:49:45,055 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5040-2:Compute:contrail-vrouter-agent:0?flat 2026-01-19 02:49:45,087 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5040-2?flat 2026-01-19 02:49:45,115 - DEBUG - VM 6526dd0e-1196-4117-8bb5-a74471a8b0ef is still present in vrouter an-jenkins-deploy-platform-ansible-os-5040-2 uve 2026-01-19 02:49:45,115 - DEBUG - Verifying if the vm interface deleted from vroter uve... 2026-01-19 02:49:45,116 - DEBUG - interface for vm 6526dd0e-1196-4117-8bb5-a74471a8b0ef deleted from vrouter uve ... 2026-01-19 02:49:45,116 - DEBUG - Deleted interface not in error interface list ... 2026-01-19 02:49:48,117 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5040-2:Compute:contrail-vrouter-agent:0?flat 2026-01-19 02:49:48,148 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5040-2?flat 2026-01-19 02:49:48,176 - DEBUG - VM 6526dd0e-1196-4117-8bb5-a74471a8b0ef is still present in vrouter an-jenkins-deploy-platform-ansible-os-5040-2 uve 2026-01-19 02:49:48,176 - DEBUG - Verifying if the vm interface deleted from vroter uve... 2026-01-19 02:49:48,176 - DEBUG - interface for vm 6526dd0e-1196-4117-8bb5-a74471a8b0ef deleted from vrouter uve ... 2026-01-19 02:49:48,176 - DEBUG - Deleted interface not in error interface list ... 2026-01-19 02:49:51,177 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5040-2:Compute:contrail-vrouter-agent:0?flat 2026-01-19 02:49:51,207 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5040-2?flat 2026-01-19 02:49:51,234 - DEBUG - VM 6526dd0e-1196-4117-8bb5-a74471a8b0ef is still present in vrouter an-jenkins-deploy-platform-ansible-os-5040-2 uve 2026-01-19 02:49:51,234 - DEBUG - Verifying if the vm interface deleted from vroter uve... 2026-01-19 02:49:51,234 - DEBUG - interface for vm 6526dd0e-1196-4117-8bb5-a74471a8b0ef deleted from vrouter uve ... 2026-01-19 02:49:51,234 - DEBUG - Deleted interface not in error interface list ... 2026-01-19 02:49:54,235 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5040-2:Compute:contrail-vrouter-agent:0?flat 2026-01-19 02:49:54,268 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5040-2?flat 2026-01-19 02:49:54,296 - DEBUG - VM 6526dd0e-1196-4117-8bb5-a74471a8b0ef is still present in vrouter an-jenkins-deploy-platform-ansible-os-5040-2 uve 2026-01-19 02:49:54,296 - DEBUG - Verifying if the vm interface deleted from vroter uve... 2026-01-19 02:49:54,296 - DEBUG - interface for vm 6526dd0e-1196-4117-8bb5-a74471a8b0ef deleted from vrouter uve ... 2026-01-19 02:49:54,296 - DEBUG - Deleted interface not in error interface list ... 2026-01-19 02:49:57,297 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5040-2:Compute:contrail-vrouter-agent:0?flat 2026-01-19 02:49:57,328 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5040-2?flat 2026-01-19 02:49:57,378 - DEBUG - VM 6526dd0e-1196-4117-8bb5-a74471a8b0ef is still present in vrouter an-jenkins-deploy-platform-ansible-os-5040-2 uve 2026-01-19 02:49:57,378 - DEBUG - Verifying if the vm interface deleted from vroter uve... 2026-01-19 02:49:57,378 - DEBUG - interface for vm 6526dd0e-1196-4117-8bb5-a74471a8b0ef deleted from vrouter uve ... 2026-01-19 02:49:57,378 - DEBUG - Deleted interface not in error interface list ... 2026-01-19 02:50:00,379 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5040-2:Compute:contrail-vrouter-agent:0?flat 2026-01-19 02:50:00,432 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5040-2?flat 2026-01-19 02:50:00,468 - DEBUG - VM 6526dd0e-1196-4117-8bb5-a74471a8b0ef is not present in vrouter an-jenkins-deploy-platform-ansible-os-5040-2 uve 2026-01-19 02:50:00,468 - DEBUG - Verifying if the vm interface deleted from vroter uve... 2026-01-19 02:50:00,468 - DEBUG - interface for vm 6526dd0e-1196-4117-8bb5-a74471a8b0ef deleted from vrouter uve ... 2026-01-19 02:50:00,468 - DEBUG - Deleted interface not in error interface list ... 2026-01-19 02:50:00,468 - DEBUG - Validated that VM 6526dd0e-1196-4117-8bb5-a74471a8b0ef is removed in Vrouter UVE 2026-01-19 02:50:00,468 - DEBUG - Verifying through opserver in 10.0.0.27 2026-01-19 02:50:00,469 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet1-43842364?flat 2026-01-19 02:50:00,486 - DEBUG - 6526dd0e-1196-4117-8bb5-a74471a8b0ef BM not in default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet1-43842364 uve 2026-01-19 02:50:00,486 - DEBUG - Validated that VM 6526dd0e-1196-4117-8bb5-a74471a8b0ef is not present in the VN UVE 2026-01-19 02:50:00,486 - DEBUG - Verifying the 6526dd0e-1196-4117-8bb5-a74471a8b0ef virtual network link through opserver 10.0.0.27 2026-01-19 02:50:00,486 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-machines 2026-01-19 02:50:00,500 - INFO - 6526dd0e-1196-4117-8bb5-a74471a8b0ef vm uve deleted from opserver 2026-01-19 02:50:00,500 - DEBUG - Verifying the 6526dd0e-1196-4117-8bb5-a74471a8b0ef virtual network link through opserver 10.0.0.50 2026-01-19 02:50:00,500 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-machines 2026-01-19 02:50:00,522 - INFO - 6526dd0e-1196-4117-8bb5-a74471a8b0ef vm uve deleted from opserver 2026-01-19 02:50:00,522 - DEBUG - Verifying the 6526dd0e-1196-4117-8bb5-a74471a8b0ef virtual network link through opserver 10.0.0.23 2026-01-19 02:50:00,522 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-machines 2026-01-19 02:50:00,591 - INFO - 6526dd0e-1196-4117-8bb5-a74471a8b0ef vm uve deleted from opserver 2026-01-19 02:50:00,591 - INFO - Validated that VM 6526dd0e-1196-4117-8bb5-a74471a8b0ef is removed from Opserver 2026-01-19 02:50:00,592 - INFO - Deleting VM ctest-vmc0-96991212 2026-01-19 02:50:00,660 - DEBUG - Verifying in api server 10.0.0.23 2026-01-19 02:50:00,660 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/a16afaf0-3b36-427a-a531-1522bc26a23b 2026-01-19 02:50:00,670 - DEBUG - VM ID a16afaf0-3b36-427a-a531-1522bc26a23b of VM ctest-vmc0-96991212 is still found in API Server 2026-01-19 02:50:02,671 - DEBUG - Verifying in api server 10.0.0.23 2026-01-19 02:50:02,671 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/a16afaf0-3b36-427a-a531-1522bc26a23b 2026-01-19 02:50:02,677 - DEBUG - Response Code: 404 2026-01-19 02:50:02,677 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/a16afaf0-3b36-427a-a531-1522bc26a23b 2026-01-19 02:50:02,683 - DEBUG - Response Code: 404 2026-01-19 02:50:02,683 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/a16afaf0-3b36-427a-a531-1522bc26a23b 2026-01-19 02:50:02,689 - DEBUG - Response Code: 404 2026-01-19 02:50:02,689 - INFO - VM ctest-vmc0-96991212 is fully removed in API-Server 2026-01-19 02:50:02,846 - DEBUG - Skipping VM-deletion-check in nova db since mysql_token is not found 2026-01-19 02:50:02,889 - DEBUG - Validated that vrouter 10.0.0.249 does not have VMs route for VN default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet0-99217706 2026-01-19 02:50:02,899 - DEBUG - Validated that vrouter 10.0.0.65 does not have VMs route for VN default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet0-99217706 2026-01-19 02:50:02,899 - INFO - Validated that all vrouters do not have VMs route for VN default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet0-99217706 2026-01-19 02:50:02,899 - INFO - VM ctest-vmc0-96991212 is removed in Compute, and routes are removed in all compute nodes 2026-01-19 02:50:03,128 - INFO - Routes for VM ctest-vmc0-96991212 is removed in all control-nodes 2026-01-19 02:50:03,129 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5040-1:Compute:contrail-vrouter-agent:0?flat 2026-01-19 02:50:03,161 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5040-1?flat 2026-01-19 02:50:03,190 - DEBUG - VM a16afaf0-3b36-427a-a531-1522bc26a23b is still present in vrouter an-jenkins-deploy-platform-ansible-os-5040-1 uve 2026-01-19 02:50:03,191 - DEBUG - Verifying if the vm interface deleted from vroter uve... 2026-01-19 02:50:03,191 - DEBUG - interface for vm a16afaf0-3b36-427a-a531-1522bc26a23b deleted from vrouter uve ... 2026-01-19 02:50:03,191 - DEBUG - Deleted interface not in error interface list ... 2026-01-19 02:50:06,192 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5040-1:Compute:contrail-vrouter-agent:0?flat 2026-01-19 02:50:06,226 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5040-1?flat 2026-01-19 02:50:06,253 - DEBUG - VM a16afaf0-3b36-427a-a531-1522bc26a23b is still present in vrouter an-jenkins-deploy-platform-ansible-os-5040-1 uve 2026-01-19 02:50:06,254 - DEBUG - Verifying if the vm interface deleted from vroter uve... 2026-01-19 02:50:06,254 - DEBUG - interface for vm a16afaf0-3b36-427a-a531-1522bc26a23b deleted from vrouter uve ... 2026-01-19 02:50:06,254 - DEBUG - Deleted interface not in error interface list ... 2026-01-19 02:50:09,255 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5040-1:Compute:contrail-vrouter-agent:0?flat 2026-01-19 02:50:09,289 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5040-1?flat 2026-01-19 02:50:09,319 - DEBUG - VM a16afaf0-3b36-427a-a531-1522bc26a23b is still present in vrouter an-jenkins-deploy-platform-ansible-os-5040-1 uve 2026-01-19 02:50:09,319 - DEBUG - Verifying if the vm interface deleted from vroter uve... 2026-01-19 02:50:09,319 - DEBUG - interface for vm a16afaf0-3b36-427a-a531-1522bc26a23b deleted from vrouter uve ... 2026-01-19 02:50:09,319 - DEBUG - Deleted interface not in error interface list ... 2026-01-19 02:50:12,319 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5040-1:Compute:contrail-vrouter-agent:0?flat 2026-01-19 02:50:12,350 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5040-1?flat 2026-01-19 02:50:12,377 - DEBUG - VM a16afaf0-3b36-427a-a531-1522bc26a23b is still present in vrouter an-jenkins-deploy-platform-ansible-os-5040-1 uve 2026-01-19 02:50:12,378 - DEBUG - Verifying if the vm interface deleted from vroter uve... 2026-01-19 02:50:12,378 - DEBUG - interface for vm a16afaf0-3b36-427a-a531-1522bc26a23b deleted from vrouter uve ... 2026-01-19 02:50:12,378 - DEBUG - Deleted interface not in error interface list ... 2026-01-19 02:50:15,378 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5040-1:Compute:contrail-vrouter-agent:0?flat 2026-01-19 02:50:15,411 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5040-1?flat 2026-01-19 02:50:15,439 - DEBUG - VM a16afaf0-3b36-427a-a531-1522bc26a23b is still present in vrouter an-jenkins-deploy-platform-ansible-os-5040-1 uve 2026-01-19 02:50:15,439 - DEBUG - Verifying if the vm interface deleted from vroter uve... 2026-01-19 02:50:15,439 - DEBUG - interface for vm a16afaf0-3b36-427a-a531-1522bc26a23b deleted from vrouter uve ... 2026-01-19 02:50:15,439 - DEBUG - Deleted interface not in error interface list ... 2026-01-19 02:50:18,439 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5040-1:Compute:contrail-vrouter-agent:0?flat 2026-01-19 02:50:18,473 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5040-1?flat 2026-01-19 02:50:18,503 - DEBUG - VM a16afaf0-3b36-427a-a531-1522bc26a23b is still present in vrouter an-jenkins-deploy-platform-ansible-os-5040-1 uve 2026-01-19 02:50:18,504 - DEBUG - Verifying if the vm interface deleted from vroter uve... 2026-01-19 02:50:18,504 - DEBUG - interface for vm a16afaf0-3b36-427a-a531-1522bc26a23b deleted from vrouter uve ... 2026-01-19 02:50:18,504 - DEBUG - Deleted interface not in error interface list ... 2026-01-19 02:50:21,504 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5040-1:Compute:contrail-vrouter-agent:0?flat 2026-01-19 02:50:21,538 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5040-1?flat 2026-01-19 02:50:21,569 - DEBUG - VM a16afaf0-3b36-427a-a531-1522bc26a23b is still present in vrouter an-jenkins-deploy-platform-ansible-os-5040-1 uve 2026-01-19 02:50:21,569 - DEBUG - Verifying if the vm interface deleted from vroter uve... 2026-01-19 02:50:21,569 - DEBUG - interface for vm a16afaf0-3b36-427a-a531-1522bc26a23b deleted from vrouter uve ... 2026-01-19 02:50:21,569 - DEBUG - Deleted interface not in error interface list ... 2026-01-19 02:50:24,570 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5040-1:Compute:contrail-vrouter-agent:0?flat 2026-01-19 02:50:24,605 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5040-1?flat 2026-01-19 02:50:24,640 - DEBUG - VM a16afaf0-3b36-427a-a531-1522bc26a23b is still present in vrouter an-jenkins-deploy-platform-ansible-os-5040-1 uve 2026-01-19 02:50:24,640 - DEBUG - Verifying if the vm interface deleted from vroter uve... 2026-01-19 02:50:24,640 - DEBUG - interface for vm a16afaf0-3b36-427a-a531-1522bc26a23b deleted from vrouter uve ... 2026-01-19 02:50:24,640 - DEBUG - Deleted interface not in error interface list ... 2026-01-19 02:50:27,641 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5040-1:Compute:contrail-vrouter-agent:0?flat 2026-01-19 02:50:27,675 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5040-1?flat 2026-01-19 02:50:27,702 - DEBUG - VM a16afaf0-3b36-427a-a531-1522bc26a23b is still present in vrouter an-jenkins-deploy-platform-ansible-os-5040-1 uve 2026-01-19 02:50:27,702 - DEBUG - Verifying if the vm interface deleted from vroter uve... 2026-01-19 02:50:27,702 - DEBUG - interface for vm a16afaf0-3b36-427a-a531-1522bc26a23b deleted from vrouter uve ... 2026-01-19 02:50:27,702 - DEBUG - Deleted interface not in error interface list ... 2026-01-19 02:50:30,703 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5040-1:Compute:contrail-vrouter-agent:0?flat 2026-01-19 02:50:30,737 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5040-1?flat 2026-01-19 02:50:30,769 - DEBUG - VM a16afaf0-3b36-427a-a531-1522bc26a23b is not present in vrouter an-jenkins-deploy-platform-ansible-os-5040-1 uve 2026-01-19 02:50:30,769 - DEBUG - Verifying if the vm interface deleted from vroter uve... 2026-01-19 02:50:30,769 - DEBUG - interface for vm a16afaf0-3b36-427a-a531-1522bc26a23b deleted from vrouter uve ... 2026-01-19 02:50:30,770 - DEBUG - Deleted interface not in error interface list ... 2026-01-19 02:50:30,770 - DEBUG - Validated that VM a16afaf0-3b36-427a-a531-1522bc26a23b is removed in Vrouter UVE 2026-01-19 02:50:30,770 - DEBUG - Verifying through opserver in 10.0.0.27 2026-01-19 02:50:30,770 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet0-99217706?flat 2026-01-19 02:50:30,791 - DEBUG - a16afaf0-3b36-427a-a531-1522bc26a23b BM not in default-domain:ctest-TestDetailedPolicy1Ipv4v6-14690172:ctest-vnet0-99217706 uve 2026-01-19 02:50:30,791 - DEBUG - Validated that VM a16afaf0-3b36-427a-a531-1522bc26a23b is not present in the VN UVE 2026-01-19 02:50:30,791 - DEBUG - Verifying the a16afaf0-3b36-427a-a531-1522bc26a23b virtual network link through opserver 10.0.0.27 2026-01-19 02:50:30,791 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-machines 2026-01-19 02:50:30,803 - DEBUG - No links retuned for a16afaf0-3b36-427a-a531-1522bc26a23b 2026-01-19 02:50:30,803 - INFO - a16afaf0-3b36-427a-a531-1522bc26a23b vm uve deleted from opserver 2026-01-19 02:50:30,805 - DEBUG - Verifying the a16afaf0-3b36-427a-a531-1522bc26a23b virtual network link through opserver 10.0.0.50 2026-01-19 02:50:30,806 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-machines 2026-01-19 02:50:30,818 - DEBUG - No links retuned for a16afaf0-3b36-427a-a531-1522bc26a23b 2026-01-19 02:50:30,818 - INFO - a16afaf0-3b36-427a-a531-1522bc26a23b vm uve deleted from opserver 2026-01-19 02:50:30,818 - DEBUG - Verifying the a16afaf0-3b36-427a-a531-1522bc26a23b virtual network link through opserver 10.0.0.23 2026-01-19 02:50:30,818 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-machines 2026-01-19 02:50:30,831 - DEBUG - No links retuned for a16afaf0-3b36-427a-a531-1522bc26a23b 2026-01-19 02:50:30,831 - INFO - a16afaf0-3b36-427a-a531-1522bc26a23b vm uve deleted from opserver 2026-01-19 02:50:30,831 - INFO - Validated that VM a16afaf0-3b36-427a-a531-1522bc26a23b is removed from Opserver 2026-01-19 02:50:30,831 - DEBUG - Detaching the Policy for VN :ctest-vnet1-43842364 2026-01-19 02:50:30,831 - DEBUG - Requesting: http://10.0.0.27:8082/domains 2026-01-19 02:50:30,837 - DEBUG - Requesting: http://10.0.0.27:8082/domain/bc123c74-c45e-4d7a-a955-76f59d7a4cc7 2026-01-19 02:50:30,875 - DEBUG - Requesting: http://10.0.0.27:8082/project/cc751c61-127b-4002-a4fc-c2b2a652cb26 2026-01-19 02:50:30,968 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/7bb0dc5f-08da-4272-afb4-47e10df56c8e 2026-01-19 02:50:31,124 - DEBUG - Detached Policy:[['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-14690172', 'policy100']] from ctest-vnet1-43842364 2026-01-19 02:50:31,124 - DEBUG - Detaching the Policy for VN :ctest-vnet0-99217706 2026-01-19 02:50:31,124 - DEBUG - Requesting: http://10.0.0.27:8082/domains 2026-01-19 02:50:31,132 - DEBUG - Requesting: http://10.0.0.27:8082/domain/bc123c74-c45e-4d7a-a955-76f59d7a4cc7 2026-01-19 02:50:31,149 - DEBUG - Requesting: http://10.0.0.27:8082/project/cc751c61-127b-4002-a4fc-c2b2a652cb26 2026-01-19 02:50:31,233 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/6d9e4248-f02e-4eb9-8318-39780205931e 2026-01-19 02:50:31,293 - INFO - Deleted policy policy1000 2026-01-19 02:50:31,463 - DEBUG - policy policy1000 is not found in API Server 2026-01-19 02:50:31,516 - INFO - Deleted policy policy13 2026-01-19 02:50:31,667 - DEBUG - policy policy13 is not found in API Server 2026-01-19 02:50:31,714 - INFO - Deleted policy policy12 2026-01-19 02:50:31,858 - DEBUG - policy policy12 is not found in API Server 2026-01-19 02:50:31,889 - INFO - Deleted policy policy11 2026-01-19 02:50:32,087 - DEBUG - policy policy11 is not found in API Server 2026-01-19 02:50:32,130 - INFO - Deleted policy policy10 2026-01-19 02:50:32,327 - DEBUG - policy policy10 is not found in API Server 2026-01-19 02:50:32,371 - INFO - Deleted policy policy100 2026-01-19 02:50:32,563 - DEBUG - policy policy100 is not found in API Server 2026-01-19 02:50:32,606 - INFO - Deleted policy policy3 2026-01-19 02:50:32,795 - DEBUG - policy policy3 is not found in API Server 2026-01-19 02:50:32,835 - INFO - Deleted policy policy2 2026-01-19 02:50:33,027 - DEBUG - policy policy2 is not found in API Server 2026-01-19 02:50:33,068 - INFO - Deleted policy policy1 2026-01-19 02:50:33,255 - DEBUG - policy policy1 is not found in API Server 2026-01-19 02:50:33,289 - INFO - Deleted policy policy0 2026-01-19 02:50:33,487 - DEBUG - policy policy0 is not found in API Server 2026-01-19 02:50:33,488 - INFO - Deleting VN ctest-vnet1-43842364 2026-01-19 02:50:33,721 - DEBUG - Response for deleting network () 2026-01-19 02:50:33,721 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/cd9ffd33-dc38-4633-9255-70378dc9784d 2026-01-19 02:50:33,726 - DEBUG - Response Code: 404 2026-01-19 02:50:33,726 - DEBUG - Requesting: http://10.0.0.27:8082/domains 2026-01-19 02:50:33,742 - DEBUG - Requesting: http://10.0.0.27:8082/domain/bc123c74-c45e-4d7a-a955-76f59d7a4cc7 2026-01-19 02:50:33,752 - DEBUG - Requesting: http://10.0.0.27:8082/project/cc751c61-127b-4002-a4fc-c2b2a652cb26 2026-01-19 02:50:33,836 - INFO - Validated that VN ctest-vnet1-43842364 is not found in API Server 2026-01-19 02:50:33,847 - DEBUG - VN ctest-vnet1-43842364 is not present in Agent 10.0.0.249 2026-01-19 02:50:33,857 - DEBUG - VN ctest-vnet1-43842364 is not present in Agent 10.0.0.65 2026-01-19 02:50:33,857 - INFO - Validated that VN ctest-vnet1-43842364 is not in any agent 2026-01-19 02:50:33,889 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vnet1-43842364 info 2026-01-19 02:50:33,889 - INFO - Deleting VN ctest-vnet0-99217706 2026-01-19 02:50:34,095 - DEBUG - Response for deleting network () 2026-01-19 02:50:34,095 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/a058c742-745b-47e1-89ee-eb8277d282bd 2026-01-19 02:50:34,102 - DEBUG - Response Code: 404 2026-01-19 02:50:34,102 - DEBUG - Requesting: http://10.0.0.27:8082/domains 2026-01-19 02:50:34,107 - DEBUG - Requesting: http://10.0.0.27:8082/domain/bc123c74-c45e-4d7a-a955-76f59d7a4cc7 2026-01-19 02:50:34,161 - DEBUG - Requesting: http://10.0.0.27:8082/project/cc751c61-127b-4002-a4fc-c2b2a652cb26 2026-01-19 02:50:34,254 - INFO - Validated that VN ctest-vnet0-99217706 is not found in API Server 2026-01-19 02:50:34,264 - DEBUG - VN ctest-vnet0-99217706 is not present in Agent 10.0.0.249 2026-01-19 02:50:34,273 - DEBUG - VN ctest-vnet0-99217706 is not present in Agent 10.0.0.65 2026-01-19 02:50:34,273 - INFO - Validated that VN ctest-vnet0-99217706 is not in any agent 2026-01-19 02:50:34,304 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vnet0-99217706 info 2026-01-19 02:50:34,399 - INFO - IPAM: ctest-TestDetailedPolicy1Ipv4v6-14690172-default-ipam is not found in API Server 2026-01-19 02:50:34,421 - INFO - IPAM:ctest-TestDetailedPolicy1Ipv4v6-14690172-default-ipam is not found in control node 2026-01-19 02:50:34,987 - DEBUG - Skipping the deletion of Project ['default-domain', 'ctest-TestDetailedPolicy1Ipv4v6-14690172'] 2026-01-19 02:50:34,987 - DEBUG - Skipping the deletion of User admin 2026-01-19 02:50:36,265 - DEBUG - No XMPP flaps were noticed during the test

2026-01-19 02:50:36,265 - INFO - END TEST : test_multi_vn_repeated_policy_update_with_ping : PASSED[0:04:26]

2026-01-19 02:50:36,266 - INFO - -------------------------------------------------------------------------------- 2026-01-19 02:50:37,570 - INFO - Deleted project: ctest-TestDetailedPolicy1Ipv4v6-14690172, ID : cc751c61-127b-4002-a4fc-c2b2a652cb26