], ['ctest-vnet0-09242266']
2026-05-11 02:56:43,381 - DEBUG - Traslation of quantum rules to ACES format
2026-05-11 02:56:43,381 - DEBUG - vn is ctest-vnet0-09242266, vn_policy is policy0
2026-05-11 02:56:43,382 - DEBUG - VN: ctest-vnet0-09242266, expected ACE's is
2026-05-11 02:56:43,382 - 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-TestDetailedPolicy1-69989575:ctest-vnet0-09242266", "dst_port_l": {"max": "65535", "min": "0"}, "proto_l": {"max": "tcp", "min": "tcp"}, "rule_type": "Terminal", "src": "default-domain:ctest-TestDetailedPolicy1-69989575:ctest-vnet1-28251161", "src_port_l": {"max": "65535", "min": "0"}}
2026-05-11 02:56:43,382 - 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-TestDetailedPolicy1-69989575:ctest-vnet1-28251161", "dst_port_l": {"max": "65535", "min": "0"}, "proto_l": {"max": "tcp", "min": "tcp"}, "rule_type": "Terminal", "src": "default-domain:ctest-TestDetailedPolicy1-69989575:ctest-vnet0-09242266", "src_port_l": {"max": "65535", "min": "0"}}
2026-05-11 02:56:43,382 - 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-TestDetailedPolicy1-69989575:ctest-vnet0-09242266", "dst_port_l": {"max": "65535", "min": "0"}, "proto_l": {"max": "udp", "min": "udp"}, "rule_type": "Terminal", "src": "default-domain:ctest-TestDetailedPolicy1-69989575:ctest-vnet1-28251161", "src_port_l": {"max": "65535", "min": "0"}}
2026-05-11 02:56:43,382 - 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-TestDetailedPolicy1-69989575:ctest-vnet1-28251161", "dst_port_l": {"max": "65535", "min": "0"}, "proto_l": {"max": "udp", "min": "udp"}, "rule_type": "Terminal", "src": "default-domain:ctest-TestDetailedPolicy1-69989575:ctest-vnet0-09242266", "src_port_l": {"max": "65535", "min": "0"}}
2026-05-11 02:56:43,382 - 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-TestDetailedPolicy1-69989575:ctest-vnet0-09242266", "dst_port_l": {"max": "65535", "min": "0"}, "proto_l": {"max": "icmp", "min": "icmp"}, "rule_type": "Terminal", "src": "default-domain:ctest-TestDetailedPolicy1-69989575:ctest-vnet1-28251161", "src_port_l": {"max": "65535", "min": "0"}}
2026-05-11 02:56:43,382 - 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-TestDetailedPolicy1-69989575:ctest-vnet1-28251161", "dst_port_l": {"max": "65535", "min": "0"}, "proto_l": {"max": "icmp", "min": "icmp"}, "rule_type": "Terminal", "src": "default-domain:ctest-TestDetailedPolicy1-69989575:ctest-vnet0-09242266", "src_port_l": {"max": "65535", "min": "0"}}
2026-05-11 02:56:43,382 - DEBUG - {"ace_id": "7", "action_l": ["pass"], "dst": "default-domain:ctest-TestDetailedPolicy1-69989575:ctest-vnet0-09242266", "dst_port_l": {"max": "65535", "min": "0"}, "proto_l": {"max": "255", "min": "0"}, "rule_type": "Terminal", "src": "default-domain:ctest-TestDetailedPolicy1-69989575:ctest-vnet0-09242266", "src_port_l": {"max": "65535", "min": "0"}}
2026-05-11 02:56:43,382 - DEBUG - {"ace_id": "8", "action_l": ["deny"], "dst": "default-domain:ctest-TestDetailedPolicy1-69989575:ctest-vnet0-09242266", "dst_port_l": {"max": "65535", "min": "0"}, "proto_l": {"max": "255", "min": "0"}, "rule_type": "Terminal", "src": "default-domain:ctest-TestDetailedPolicy1-69989575:ctest-vnet1-28251161", "src_port_l": {"max": "65535", "min": "0"}}
2026-05-11 02:56:43,382 - DEBUG - {"ace_id": "9", "action_l": ["deny"], "dst": "default-domain:ctest-TestDetailedPolicy1-69989575:ctest-vnet1-28251161", "dst_port_l": {"max": "65535", "min": "0"}, "proto_l": {"max": "255", "min": "0"}, "rule_type": "Terminal", "src": "default-domain:ctest-TestDetailedPolicy1-69989575:ctest-vnet0-09242266", "src_port_l": {"max": "65535", "min": "0"}}
2026-05-11 02:56:43,382 - DEBUG - {"ace_id": "10", "action_l": ["pass"], "dst": "any", "dst_port_l": {"max": "65535", "min": "0"}, "proto_l": {"max": "255", "min": "0"}, "rule_type": "Terminal", "src": "any", "src_port_l": {"max": "65535", "min": "0"}}
2026-05-11 02:56:43,382 - DEBUG - Verify rules expected in CN if VN-VM in CN
2026-05-11 02:56:43,382 - DEBUG - CN: 10.0.0.23, Check for expected data
2026-05-11 02:56:43,392 - DEBUG - Verify rules expected in CN if VN-VM in CN
2026-05-11 02:56:43,392 - DEBUG - CN: 10.0.0.240, Check for expected data
2026-05-11 02:56:43,421 - DEBUG - ----------------------------------------
2026-05-11 02:56:43,421 - DEBUG - CN: 10.0.0.240, VN: ctest-vnet0-09242266, result of expected rules check passed
2026-05-11 02:56:43,421 - INFO - Validated the rules for VM:ctest-vmc0-69668299 with attached policy:['policy0'] and vn:ctest-vnet0-09242266
2026-05-11 02:56:43,421 - DEBUG - Verify policy rules for other vn if it is present
2026-05-11 02:56:43,422 - INFO - Policy rules comparison with system for all Virtual networks are done
2026-05-11 02:56:43,422 - INFO - Setup completed with result True
2026-05-11 02:56:43,570 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': 'ea04ac5e-5af7-434e-9d8f-9d34d013ac05', 'name': 'ctest-vnet0-09242266', 'tenant_id': '7a4b295f717d4991890a6d630c522ea0', 'project_id': '7a4b295f717d4991890a6d630c522ea0', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['c0f7ebaf-8ea0-4c42-bbb4-455110f51a0e', '8b4f1d5e-391c-4531-8f81-739bea8c7452'], 'fq_name': ['default-domain', 'ctest-TestDetailedPolicy1-69989575', 'ctest-vnet0-09242266'], 'policys': [['default-domain', 'ctest-TestDetailedPolicy1-69989575', 'policy1']], 'subnet_ipam': [{'subnet_cidr': '10.1.1.0/24', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1-69989575', 'ctest-TestDetailedPolicy1-69989575-default-ipam']}, {'subnet_cidr': '11.1.1.0/24', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1-69989575', 'ctest-TestDetailedPolicy1-69989575-default-ipam']}], 'port_security_enabled': True, 'description': ''}}
2026-05-11 02:56:48,663 - INFO - new policy list of vn ctest-vnet0-09242266 is policy1
2026-05-11 02:56:48,664 - INFO - Starting Verifications after policy for ctest-vnet0-09242266 updated to policy1
2026-05-11 02:56:48,664 - INFO - policy in effect is : [{'direction': '<>', 'protocol': 'tcp', 'dest_network': 'ctest-vnet0-09242266', 'source_network': 'ctest-vnet1-28251161', 'dst_ports': 'any', 'simple_action': 'pass', 'src_ports': 'any'}, {'direction': '<>', 'protocol': 'udp', 'dest_network': 'ctest-vnet0-09242266', 'source_network': 'ctest-vnet1-28251161', 'dst_ports': 'any', 'simple_action': 'pass', 'src_ports': 'any'}, {'direction': '<>', 'protocol': 'icmp', 'dest_network': 'ctest-vnet0-09242266', 'source_network': 'ctest-vnet1-28251161', 'dst_ports': 'any', 'simple_action': 'pass', 'src_ports': 'any'}]
2026-05-11 02:56:48,664 - INFO - matching_rule_action: {'tcp': 'pass', 'udp': 'pass', 'icmp': 'pass'}
2026-05-11 02:56:48,664 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-05-11 02:56:48,664 - 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.240, gateway password: c0ntrail123
2026-05-11 02:56:48,665 - DEBUG - ping -s 56 -c 3 -W 1 12.1.1.3
2026-05-11 02:57:44,338 - 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=12.3 ms
64 bytes from 12.1.1.3: icmp_req=2 ttl=63 time=2.23 ms
64 bytes from 12.1.1.3: icmp_req=3 ttl=63 time=1.68 ms
--- 12.1.1.3 ping statistics ---
3 packets transmitted, 3 received, 0% packet loss, time 2005ms
rtt min/avg/max/mdev = 1.681/5.432/12.376/4.915 ms
2026-05-11 02:57:44,338 - INFO - Ping to IP 12.1.1.3 from VM ctest-vmc0-69668299 passed
2026-05-11 02:57:44,338 - INFO - vm ping test result after policy for ctest-vnet0-09242266 updated to policy1 is: True
2026-05-11 02:57:44,475 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': 'ea04ac5e-5af7-434e-9d8f-9d34d013ac05', 'name': 'ctest-vnet0-09242266', 'tenant_id': '7a4b295f717d4991890a6d630c522ea0', 'project_id': '7a4b295f717d4991890a6d630c522ea0', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['c0f7ebaf-8ea0-4c42-bbb4-455110f51a0e', '8b4f1d5e-391c-4531-8f81-739bea8c7452'], 'fq_name': ['default-domain', 'ctest-TestDetailedPolicy1-69989575', 'ctest-vnet0-09242266'], 'policys': [['default-domain', 'ctest-TestDetailedPolicy1-69989575', 'policy1000']], 'subnet_ipam': [{'subnet_cidr': '10.1.1.0/24', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1-69989575', 'ctest-TestDetailedPolicy1-69989575-default-ipam']}, {'subnet_cidr': '11.1.1.0/24', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1-69989575', 'ctest-TestDetailedPolicy1-69989575-default-ipam']}], 'port_security_enabled': True, 'description': ''}}
2026-05-11 02:57:49,618 - INFO - new policy list of vn ctest-vnet0-09242266 is policy1000
2026-05-11 02:57:49,618 - INFO - Starting Verifications after policy for ctest-vnet0-09242266 updated to policy1000
2026-05-11 02:57:49,618 - INFO - policy in effect is : []
2026-05-11 02:57:49,618 - INFO - matching_rule_action: {'icmp': 'deny'}
2026-05-11 02:57:49,618 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-05-11 02:57:49,619 - 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.240, gateway password: c0ntrail123
2026-05-11 02:57:49,619 - DEBUG - ping -s 56 -c 3 -W 1 12.1.1.3
2026-05-11 02:57:53,109 - 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-05-11 02:57:53,109 - WARNING - Ping to IP 12.1.1.3 from VM ctest-vmc0-69668299 failed
2026-05-11 02:57:53,109 - INFO - vm ping test result after policy for ctest-vnet0-09242266 updated to policy1000 is: True
2026-05-11 02:57:53,244 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': 'ea04ac5e-5af7-434e-9d8f-9d34d013ac05', 'name': 'ctest-vnet0-09242266', 'tenant_id': '7a4b295f717d4991890a6d630c522ea0', 'project_id': '7a4b295f717d4991890a6d630c522ea0', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['c0f7ebaf-8ea0-4c42-bbb4-455110f51a0e', '8b4f1d5e-391c-4531-8f81-739bea8c7452'], 'fq_name': ['default-domain', 'ctest-TestDetailedPolicy1-69989575', 'ctest-vnet0-09242266'], 'policys': [['default-domain', 'ctest-TestDetailedPolicy1-69989575', 'policy2']], 'subnet_ipam': [{'subnet_cidr': '10.1.1.0/24', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1-69989575', 'ctest-TestDetailedPolicy1-69989575-default-ipam']}, {'subnet_cidr': '11.1.1.0/24', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1-69989575', 'ctest-TestDetailedPolicy1-69989575-default-ipam']}], 'port_security_enabled': True, 'description': ''}}
2026-05-11 02:57:58,402 - INFO - new policy list of vn ctest-vnet0-09242266 is policy2
2026-05-11 02:57:58,402 - INFO - Starting Verifications after policy for ctest-vnet0-09242266 updated to policy2
2026-05-11 02:57:58,403 - INFO - policy in effect is : [{'direction': '<>', 'protocol': 'tcp', 'dest_network': 'ctest-vnet0-09242266', 'source_network': 'ctest-vnet1-28251161', 'dst_ports': 'any', 'simple_action': 'pass', 'src_ports': 'any'}, {'direction': '<>', 'protocol': 'udp', 'dest_network': 'ctest-vnet0-09242266', 'source_network': 'ctest-vnet1-28251161', 'dst_ports': 'any', 'simple_action': 'deny', 'src_ports': 'any'}, {'direction': '<>', 'protocol': 'icmp', 'dest_network': 'ctest-vnet0-09242266', 'source_network': 'ctest-vnet1-28251161', 'dst_ports': 'any', 'simple_action': 'deny', 'src_ports': 'any'}]
2026-05-11 02:57:58,403 - INFO - matching_rule_action: {'tcp': 'pass', 'udp': 'deny', 'icmp': 'deny'}
2026-05-11 02:57:58,403 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-05-11 02:57:58,403 - 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.240, gateway password: c0ntrail123
2026-05-11 02:57:58,403 - DEBUG - ping -s 56 -c 3 -W 1 12.1.1.3
2026-05-11 02:58:01,915 - DEBUG - PING 12.1.1.3 (12.1.1.3) 56(84) bytes of data.
--- 12.1.1.3 ping statistics ---
3 packets transmitted, 0 received, 100% packet loss, time 2000ms
2026-05-11 02:58:01,915 - WARNING - Ping to IP 12.1.1.3 from VM ctest-vmc0-69668299 failed
2026-05-11 02:58:01,915 - INFO - vm ping test result after policy for ctest-vnet0-09242266 updated to policy2 is: True
2026-05-11 02:58:02,106 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': 'ea04ac5e-5af7-434e-9d8f-9d34d013ac05', 'name': 'ctest-vnet0-09242266', 'tenant_id': '7a4b295f717d4991890a6d630c522ea0', 'project_id': '7a4b295f717d4991890a6d630c522ea0', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['c0f7ebaf-8ea0-4c42-bbb4-455110f51a0e', '8b4f1d5e-391c-4531-8f81-739bea8c7452'], 'fq_name': ['default-domain', 'ctest-TestDetailedPolicy1-69989575', 'ctest-vnet0-09242266'], 'policys': [['default-domain', 'ctest-TestDetailedPolicy1-69989575', 'policy3']], 'subnet_ipam': [{'subnet_cidr': '10.1.1.0/24', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1-69989575', 'ctest-TestDetailedPolicy1-69989575-default-ipam']}, {'subnet_cidr': '11.1.1.0/24', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1-69989575', 'ctest-TestDetailedPolicy1-69989575-default-ipam']}], 'port_security_enabled': True, 'description': ''}}
2026-05-11 02:58:07,210 - INFO - new policy list of vn ctest-vnet0-09242266 is policy3
2026-05-11 02:58:07,210 - INFO - Starting Verifications after policy for ctest-vnet0-09242266 updated to policy3
2026-05-11 02:58:07,210 - INFO - policy in effect is : [{'direction': '<>', 'protocol': 'tcp', 'dest_network': 'ctest-vnet0-09242266', 'source_network': 'ctest-vnet1-28251161', 'dst_ports': 'any', 'simple_action': 'pass', 'src_ports': 'any'}, {'direction': '<>', 'protocol': 'udp', 'dest_network': 'ctest-vnet0-09242266', 'source_network': 'ctest-vnet1-28251161', 'dst_ports': 'any', 'simple_action': 'deny', 'src_ports': 'any'}, {'direction': '<>', 'protocol': 'icmp', 'dest_network': 'ctest-vnet0-09242266', 'source_network': 'ctest-vnet1-28251161', 'dst_ports': 'any', 'simple_action': 'pass', 'src_ports': 'any'}]
2026-05-11 02:58:07,211 - INFO - matching_rule_action: {'tcp': 'pass', 'udp': 'deny', 'icmp': 'pass'}
2026-05-11 02:58:07,211 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-05-11 02:58:07,211 - 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.240, gateway password: c0ntrail123
2026-05-11 02:58:07,211 - DEBUG - ping -s 56 -c 3 -W 1 12.1.1.3
2026-05-11 02:58:09,695 - 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=16.2 ms
64 bytes from 12.1.1.3: icmp_req=2 ttl=63 time=1.38 ms
64 bytes from 12.1.1.3: icmp_req=3 ttl=63 time=1.34 ms
--- 12.1.1.3 ping statistics ---
3 packets transmitted, 3 received, 0% packet loss, time 2004ms
rtt min/avg/max/mdev = 1.342/6.309/16.203/6.996 ms
2026-05-11 02:58:09,695 - INFO - Ping to IP 12.1.1.3 from VM ctest-vmc0-69668299 passed
2026-05-11 02:58:09,695 - INFO - vm ping test result after policy for ctest-vnet0-09242266 updated to policy3 is: True
2026-05-11 02:58:09,933 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': 'ea04ac5e-5af7-434e-9d8f-9d34d013ac05', 'name': 'ctest-vnet0-09242266', 'tenant_id': '7a4b295f717d4991890a6d630c522ea0', 'project_id': '7a4b295f717d4991890a6d630c522ea0', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['c0f7ebaf-8ea0-4c42-bbb4-455110f51a0e', '8b4f1d5e-391c-4531-8f81-739bea8c7452'], 'fq_name': ['default-domain', 'ctest-TestDetailedPolicy1-69989575', 'ctest-vnet0-09242266'], 'policys': [['default-domain', 'ctest-TestDetailedPolicy1-69989575', 'policy10']], 'subnet_ipam': [{'subnet_cidr': '10.1.1.0/24', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1-69989575', 'ctest-TestDetailedPolicy1-69989575-default-ipam']}, {'subnet_cidr': '11.1.1.0/24', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1-69989575', 'ctest-TestDetailedPolicy1-69989575-default-ipam']}], 'port_security_enabled': True, 'description': ''}}
2026-05-11 02:58:15,070 - INFO - new policy list of vn ctest-vnet0-09242266 is policy10
2026-05-11 02:58:15,070 - INFO - Starting Verifications after policy for ctest-vnet0-09242266 updated to policy10
2026-05-11 02:58:15,070 - INFO - policy in effect is : [{'direction': '<>', 'protocol': 'udp', 'dest_network': 'ctest-vnet0-09242266', 'source_network': 'ctest-vnet1-28251161', 'dst_ports': 'any', 'simple_action': 'deny', 'src_ports': 'any'}, {'direction': '<>', 'protocol': 'tcp', 'dest_network': 'ctest-vnet0-09242266', 'source_network': 'ctest-vnet1-28251161', 'dst_ports': 'any', 'simple_action': 'deny', 'src_ports': 'any'}, {'direction': '<>', 'protocol': 'icmp', 'dest_network': 'ctest-vnet0-09242266', 'source_network': 'ctest-vnet1-28251161', 'dst_ports': 'any', 'simple_action': 'deny', 'src_ports': 'any'}]
2026-05-11 02:58:15,071 - INFO - matching_rule_action: {'udp': 'deny', 'tcp': 'deny', 'icmp': 'deny'}
2026-05-11 02:58:15,071 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-05-11 02:58:15,071 - 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.240, gateway password: c0ntrail123
2026-05-11 02:58:15,071 - DEBUG - ping -s 56 -c 3 -W 1 12.1.1.3
2026-05-11 02:58:18,603 - DEBUG - PING 12.1.1.3 (12.1.1.3) 56(84) bytes of data.
--- 12.1.1.3 ping statistics ---
3 packets transmitted, 0 received, 100% packet loss, time 2000ms
2026-05-11 02:58:18,603 - WARNING - Ping to IP 12.1.1.3 from VM ctest-vmc0-69668299 failed
2026-05-11 02:58:18,603 - INFO - vm ping test result after policy for ctest-vnet0-09242266 updated to policy10 is: True
2026-05-11 02:58:18,751 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': 'ea04ac5e-5af7-434e-9d8f-9d34d013ac05', 'name': 'ctest-vnet0-09242266', 'tenant_id': '7a4b295f717d4991890a6d630c522ea0', 'project_id': '7a4b295f717d4991890a6d630c522ea0', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['c0f7ebaf-8ea0-4c42-bbb4-455110f51a0e', '8b4f1d5e-391c-4531-8f81-739bea8c7452'], 'fq_name': ['default-domain', 'ctest-TestDetailedPolicy1-69989575', 'ctest-vnet0-09242266'], 'policys': [['default-domain', 'ctest-TestDetailedPolicy1-69989575', 'policy11']], 'subnet_ipam': [{'subnet_cidr': '10.1.1.0/24', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1-69989575', 'ctest-TestDetailedPolicy1-69989575-default-ipam']}, {'subnet_cidr': '11.1.1.0/24', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1-69989575', 'ctest-TestDetailedPolicy1-69989575-default-ipam']}], 'port_security_enabled': True, 'description': ''}}
2026-05-11 02:58:23,876 - INFO - new policy list of vn ctest-vnet0-09242266 is policy11
2026-05-11 02:58:23,877 - INFO - Starting Verifications after policy for ctest-vnet0-09242266 updated to policy11
2026-05-11 02:58:23,877 - INFO - policy in effect is : [{'direction': '<>', 'protocol': 'udp', 'dest_network': 'ctest-vnet0-09242266', 'source_network': 'ctest-vnet1-28251161', 'dst_ports': 'any', 'simple_action': 'deny', 'src_ports': 'any'}, {'direction': '<>', 'protocol': 'tcp', 'dest_network': 'ctest-vnet0-09242266', 'source_network': 'ctest-vnet1-28251161', 'dst_ports': 'any', 'simple_action': 'deny', 'src_ports': 'any'}, {'direction': '<>', 'protocol': 'icmp', 'dest_network': 'ctest-vnet0-09242266', 'source_network': 'ctest-vnet1-28251161', 'dst_ports': 'any', 'simple_action': 'pass', 'src_ports': 'any'}]
2026-05-11 02:58:23,877 - INFO - matching_rule_action: {'udp': 'deny', 'tcp': 'deny', 'icmp': 'pass'}
2026-05-11 02:58:23,877 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-05-11 02:58:23,878 - 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.240, gateway password: c0ntrail123
2026-05-11 02:58:23,878 - DEBUG - ping -s 56 -c 3 -W 1 12.1.1.3
2026-05-11 02:58:26,733 - 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=5.61 ms
64 bytes from 12.1.1.3: icmp_req=2 ttl=63 time=4.73 ms
64 bytes from 12.1.1.3: icmp_req=3 ttl=63 time=1.60 ms
--- 12.1.1.3 ping statistics ---
3 packets transmitted, 3 received, 0% packet loss, time 2003ms
rtt min/avg/max/mdev = 1.604/3.986/5.618/1.724 ms
2026-05-11 02:58:26,733 - INFO - Ping to IP 12.1.1.3 from VM ctest-vmc0-69668299 passed
2026-05-11 02:58:26,733 - INFO - vm ping test result after policy for ctest-vnet0-09242266 updated to policy11 is: True
2026-05-11 02:58:26,866 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': 'ea04ac5e-5af7-434e-9d8f-9d34d013ac05', 'name': 'ctest-vnet0-09242266', 'tenant_id': '7a4b295f717d4991890a6d630c522ea0', 'project_id': '7a4b295f717d4991890a6d630c522ea0', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['c0f7ebaf-8ea0-4c42-bbb4-455110f51a0e', '8b4f1d5e-391c-4531-8f81-739bea8c7452'], 'fq_name': ['default-domain', 'ctest-TestDetailedPolicy1-69989575', 'ctest-vnet0-09242266'], 'policys': [['default-domain', 'ctest-TestDetailedPolicy1-69989575', 'policy12']], 'subnet_ipam': [{'subnet_cidr': '10.1.1.0/24', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1-69989575', 'ctest-TestDetailedPolicy1-69989575-default-ipam']}, {'subnet_cidr': '11.1.1.0/24', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1-69989575', 'ctest-TestDetailedPolicy1-69989575-default-ipam']}], 'port_security_enabled': True, 'description': ''}}
2026-05-11 02:58:31,982 - INFO - new policy list of vn ctest-vnet0-09242266 is policy12
2026-05-11 02:58:31,983 - INFO - Starting Verifications after policy for ctest-vnet0-09242266 updated to policy12
2026-05-11 02:58:31,983 - INFO - policy in effect is : [{'direction': '<>', 'protocol': 'tcp', 'dest_network': 'ctest-vnet0-09242266', 'source_network': 'ctest-vnet1-28251161', 'dst_ports': 'any', 'simple_action': 'deny', 'src_ports': 'any'}, {'direction': '<>', 'protocol': 'udp', 'dest_network': 'ctest-vnet0-09242266', 'source_network': 'ctest-vnet1-28251161', 'dst_ports': 'any', 'simple_action': 'pass', 'src_ports': 'any'}, {'direction': '<>', 'protocol': 'icmp', 'dest_network': 'ctest-vnet0-09242266', 'source_network': 'ctest-vnet1-28251161', 'dst_ports': 'any', 'simple_action': 'deny', 'src_ports': 'any'}]
2026-05-11 02:58:31,983 - INFO - matching_rule_action: {'tcp': 'deny', 'udp': 'pass', 'icmp': 'deny'}
2026-05-11 02:58:31,983 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-05-11 02:58:31,983 - 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.240, gateway password: c0ntrail123
2026-05-11 02:58:31,983 - DEBUG - ping -s 56 -c 3 -W 1 12.1.1.3
2026-05-11 02:58:35,816 - 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-05-11 02:58:35,816 - WARNING - Ping to IP 12.1.1.3 from VM ctest-vmc0-69668299 failed
2026-05-11 02:58:35,816 - INFO - vm ping test result after policy for ctest-vnet0-09242266 updated to policy12 is: True
2026-05-11 02:58:35,966 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': 'ea04ac5e-5af7-434e-9d8f-9d34d013ac05', 'name': 'ctest-vnet0-09242266', 'tenant_id': '7a4b295f717d4991890a6d630c522ea0', 'project_id': '7a4b295f717d4991890a6d630c522ea0', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['c0f7ebaf-8ea0-4c42-bbb4-455110f51a0e', '8b4f1d5e-391c-4531-8f81-739bea8c7452'], 'fq_name': ['default-domain', 'ctest-TestDetailedPolicy1-69989575', 'ctest-vnet0-09242266'], 'policys': [['default-domain', 'ctest-TestDetailedPolicy1-69989575', 'policy13']], 'subnet_ipam': [{'subnet_cidr': '10.1.1.0/24', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1-69989575', 'ctest-TestDetailedPolicy1-69989575-default-ipam']}, {'subnet_cidr': '11.1.1.0/24', 'ipam_fq_name': ['default-domain', 'ctest-TestDetailedPolicy1-69989575', 'ctest-TestDetailedPolicy1-69989575-default-ipam']}], 'port_security_enabled': True, 'description': ''}}
2026-05-11 02:58:41,075 - INFO - new policy list of vn ctest-vnet0-09242266 is policy13
2026-05-11 02:58:41,076 - INFO - Starting Verifications after policy for ctest-vnet0-09242266 updated to policy13
2026-05-11 02:58:41,076 - INFO - policy in effect is : [{'direction': '<>', 'protocol': 'udp', 'dest_network': 'ctest-vnet0-09242266', 'source_network': 'ctest-vnet1-28251161', 'dst_ports': 'any', 'simple_action': 'pass', 'src_ports': 'any'}, {'direction': '<>', 'protocol': 'icmp', 'dest_network': 'ctest-vnet0-09242266', 'source_network': 'ctest-vnet1-28251161', 'dst_ports': 'any', 'simple_action': 'pass', 'src_ports': 'any'}, {'direction': '<>', 'protocol': 'tcp', 'dest_network': 'ctest-vnet0-09242266', 'source_network': 'ctest-vnet1-28251161', 'dst_ports': 'any', 'simple_action': 'deny', 'src_ports': 'any'}]
2026-05-11 02:58:41,076 - INFO - matching_rule_action: {'udp': 'pass', 'icmp': 'pass', 'tcp': 'deny'}
2026-05-11 02:58:41,076 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-05-11 02:58:41,077 - 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.240, gateway password: c0ntrail123
2026-05-11 02:58:41,077 - DEBUG - ping -s 56 -c 3 -W 1 12.1.1.3
2026-05-11 02:58:43,600 - 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.53 ms
64 bytes from 12.1.1.3: icmp_req=2 ttl=63 time=2.41 ms
64 bytes from 12.1.1.3: icmp_req=3 ttl=63 time=1.30 ms
--- 12.1.1.3 ping statistics ---
3 packets transmitted, 3 received, 0% packet loss, time 2003ms
rtt min/avg/max/mdev = 1.304/2.750/4.535/1.340 ms
2026-05-11 02:58:43,600 - INFO - Ping to IP 12.1.1.3 from VM ctest-vmc0-69668299 passed
2026-05-11 02:58:43,600 - INFO - vm ping test result after policy for ctest-vnet0-09242266 updated to policy13 is: True
2026-05-11 02:58:43,792 - INFO - Deleting VM ctest-vmc1-15251833
2026-05-11 02:58:43,936 - DEBUG - Verifying in api server 10.0.0.27
2026-05-11 02:58:43,936 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-machine/264aa130-3e66-48e1-bdad-9a159dcbdf55
2026-05-11 02:58:43,944 - DEBUG - VM ID 264aa130-3e66-48e1-bdad-9a159dcbdf55 of VM ctest-vmc1-15251833 is still found in API Server
2026-05-11 02:58:45,944 - DEBUG - Verifying in api server 10.0.0.27
2026-05-11 02:58:45,944 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-machine/264aa130-3e66-48e1-bdad-9a159dcbdf55
2026-05-11 02:58:45,952 - DEBUG - Response Code: 404
2026-05-11 02:58:45,952 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-machine/264aa130-3e66-48e1-bdad-9a159dcbdf55
2026-05-11 02:58:45,958 - DEBUG - Response Code: 404
2026-05-11 02:58:45,959 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-machine/264aa130-3e66-48e1-bdad-9a159dcbdf55
2026-05-11 02:58:45,965 - DEBUG - Response Code: 404
2026-05-11 02:58:45,966 - INFO - VM ctest-vmc1-15251833 is fully removed in API-Server
2026-05-11 02:58:46,117 - DEBUG - Skipping VM-deletion-check in nova db since mysql_token is not found
2026-05-11 02:58:46,169 - DEBUG - Validated that vrouter 10.0.0.23 does not have VMs route for VN default-domain:ctest-TestDetailedPolicy1-69989575:ctest-vnet1-28251161
2026-05-11 02:58:46,181 - DEBUG - Validated that vrouter 10.0.0.240 does not have VMs route for VN default-domain:ctest-TestDetailedPolicy1-69989575:ctest-vnet1-28251161
2026-05-11 02:58:46,181 - INFO - Validated that all vrouters do not have VMs route for VN default-domain:ctest-TestDetailedPolicy1-69989575:ctest-vnet1-28251161
2026-05-11 02:58:46,181 - INFO - VM ctest-vmc1-15251833 is removed in Compute, and routes are removed in all compute nodes
2026-05-11 02:58:46,425 - INFO - Routes for VM ctest-vmc1-15251833 is removed in all control-nodes
2026-05-11 02:58:46,425 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5767-1:Compute:contrail-vrouter-agent:0?flat
2026-05-11 02:58:46,459 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5767-1?flat
2026-05-11 02:58:46,550 - DEBUG - VM 264aa130-3e66-48e1-bdad-9a159dcbdf55 is still present in vrouter an-jenkins-deploy-platform-ansible-os-5767-1 uve
2026-05-11 02:58:46,550 - DEBUG - Verifying if the vm interface deleted from vroter uve...
2026-05-11 02:58:46,551 - DEBUG - interface for vm 264aa130-3e66-48e1-bdad-9a159dcbdf55 deleted from vrouter uve ...
2026-05-11 02:58:46,551 - DEBUG - Deleted interface not in error interface list ...
2026-05-11 02:58:49,552 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5767-1:Compute:contrail-vrouter-agent:0?flat
2026-05-11 02:58:49,596 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5767-1?flat
2026-05-11 02:58:49,631 - DEBUG - VM 264aa130-3e66-48e1-bdad-9a159dcbdf55 is still present in vrouter an-jenkins-deploy-platform-ansible-os-5767-1 uve
2026-05-11 02:58:49,631 - DEBUG - Verifying if the vm interface deleted from vroter uve...
2026-05-11 02:58:49,631 - DEBUG - interface for vm 264aa130-3e66-48e1-bdad-9a159dcbdf55 deleted from vrouter uve ...
2026-05-11 02:58:49,631 - DEBUG - Deleted interface not in error interface list ...
2026-05-11 02:58:52,631 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5767-1:Compute:contrail-vrouter-agent:0?flat
2026-05-11 02:58:52,671 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5767-1?flat
2026-05-11 02:58:52,702 - DEBUG - VM 264aa130-3e66-48e1-bdad-9a159dcbdf55 is not present in vrouter an-jenkins-deploy-platform-ansible-os-5767-1 uve
2026-05-11 02:58:52,702 - DEBUG - Verifying if the vm interface deleted from vroter uve...
2026-05-11 02:58:52,702 - DEBUG - interface for vm 264aa130-3e66-48e1-bdad-9a159dcbdf55 deleted from vrouter uve ...
2026-05-11 02:58:52,702 - DEBUG - Deleted interface not in error interface list ...
2026-05-11 02:58:52,702 - DEBUG - Validated that VM 264aa130-3e66-48e1-bdad-9a159dcbdf55 is removed in Vrouter UVE
2026-05-11 02:58:52,702 - DEBUG - Verifying through opserver in 10.0.0.141
2026-05-11 02:58:52,702 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/virtual-network/default-domain:ctest-TestDetailedPolicy1-69989575:ctest-vnet1-28251161?flat
2026-05-11 02:58:52,719 - DEBUG - 264aa130-3e66-48e1-bdad-9a159dcbdf55 BM not in default-domain:ctest-TestDetailedPolicy1-69989575:ctest-vnet1-28251161 uve
2026-05-11 02:58:52,720 - DEBUG - Validated that VM 264aa130-3e66-48e1-bdad-9a159dcbdf55 is not present in the VN UVE
2026-05-11 02:58:52,720 - DEBUG - Verifying the 264aa130-3e66-48e1-bdad-9a159dcbdf55 virtual network link through opserver 10.0.0.141
2026-05-11 02:58:52,720 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/virtual-machines
2026-05-11 02:58:52,733 - INFO - 264aa130-3e66-48e1-bdad-9a159dcbdf55 vm uve deleted from opserver
2026-05-11 02:58:52,733 - DEBUG - Verifying the 264aa130-3e66-48e1-bdad-9a159dcbdf55 virtual network link through opserver 10.0.0.249
2026-05-11 02:58:52,733 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-machines
2026-05-11 02:58:52,747 - INFO - 264aa130-3e66-48e1-bdad-9a159dcbdf55 vm uve deleted from opserver
2026-05-11 02:58:52,747 - DEBUG - Verifying the 264aa130-3e66-48e1-bdad-9a159dcbdf55 virtual network link through opserver 10.0.0.27
2026-05-11 02:58:52,747 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-machines
2026-05-11 02:58:52,761 - INFO - 264aa130-3e66-48e1-bdad-9a159dcbdf55 vm uve deleted from opserver
2026-05-11 02:58:52,761 - INFO - Validated that VM 264aa130-3e66-48e1-bdad-9a159dcbdf55 is removed from Opserver
2026-05-11 02:58:52,761 - INFO - Deleting VM ctest-vmc0-69668299
2026-05-11 02:58:52,867 - DEBUG - Verifying in api server 10.0.0.27
2026-05-11 02:58:52,867 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-machine/40373c76-8c8a-49fe-a835-f4f548a6f396
2026-05-11 02:58:52,875 - DEBUG - VM ID 40373c76-8c8a-49fe-a835-f4f548a6f396 of VM ctest-vmc0-69668299 is still found in API Server
2026-05-11 02:58:54,876 - DEBUG - Verifying in api server 10.0.0.27
2026-05-11 02:58:54,876 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-machine/40373c76-8c8a-49fe-a835-f4f548a6f396
2026-05-11 02:58:54,883 - DEBUG - Response Code: 404
2026-05-11 02:58:54,883 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-machine/40373c76-8c8a-49fe-a835-f4f548a6f396
2026-05-11 02:58:54,889 - DEBUG - Response Code: 404
2026-05-11 02:58:54,889 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-machine/40373c76-8c8a-49fe-a835-f4f548a6f396
2026-05-11 02:58:54,895 - DEBUG - Response Code: 404
2026-05-11 02:58:54,895 - INFO - VM ctest-vmc0-69668299 is fully removed in API-Server
2026-05-11 02:58:55,049 - DEBUG - Skipping VM-deletion-check in nova db since mysql_token is not found
2026-05-11 02:58:55,095 - DEBUG - Validated that vrouter 10.0.0.23 does not have VMs route for VN default-domain:ctest-TestDetailedPolicy1-69989575:ctest-vnet0-09242266
2026-05-11 02:58:55,107 - DEBUG - Validated that vrouter 10.0.0.240 does not have VMs route for VN default-domain:ctest-TestDetailedPolicy1-69989575:ctest-vnet0-09242266
2026-05-11 02:58:55,107 - INFO - Validated that all vrouters do not have VMs route for VN default-domain:ctest-TestDetailedPolicy1-69989575:ctest-vnet0-09242266
2026-05-11 02:58:55,107 - INFO - VM ctest-vmc0-69668299 is removed in Compute, and routes are removed in all compute nodes
2026-05-11 02:58:55,345 - INFO - Routes for VM ctest-vmc0-69668299 is removed in all control-nodes
2026-05-11 02:58:55,346 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5767-2:Compute:contrail-vrouter-agent:0?flat
2026-05-11 02:58:55,385 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5767-2?flat
2026-05-11 02:58:55,416 - DEBUG - VM 40373c76-8c8a-49fe-a835-f4f548a6f396 is still present in vrouter an-jenkins-deploy-platform-ansible-os-5767-2 uve
2026-05-11 02:58:55,416 - DEBUG - Verifying if the vm interface deleted from vroter uve...
2026-05-11 02:58:55,416 - DEBUG - interface for vm 40373c76-8c8a-49fe-a835-f4f548a6f396 deleted from vrouter uve ...
2026-05-11 02:58:55,417 - DEBUG - Deleted interface not in error interface list ...
2026-05-11 02:58:58,417 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5767-2:Compute:contrail-vrouter-agent:0?flat
2026-05-11 02:58:58,460 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5767-2?flat
2026-05-11 02:58:58,499 - DEBUG - VM 40373c76-8c8a-49fe-a835-f4f548a6f396 is still present in vrouter an-jenkins-deploy-platform-ansible-os-5767-2 uve
2026-05-11 02:58:58,499 - DEBUG - Verifying if the vm interface deleted from vroter uve...
2026-05-11 02:58:58,499 - DEBUG - interface for vm 40373c76-8c8a-49fe-a835-f4f548a6f396 deleted from vrouter uve ...
2026-05-11 02:58:58,499 - DEBUG - Deleted interface not in error interface list ...
2026-05-11 02:59:01,499 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5767-2:Compute:contrail-vrouter-agent:0?flat
2026-05-11 02:59:01,542 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5767-2?flat
2026-05-11 02:59:01,580 - DEBUG - VM 40373c76-8c8a-49fe-a835-f4f548a6f396 is still present in vrouter an-jenkins-deploy-platform-ansible-os-5767-2 uve
2026-05-11 02:59:01,580 - DEBUG - Verifying if the vm interface deleted from vroter uve...
2026-05-11 02:59:01,580 - DEBUG - interface for vm 40373c76-8c8a-49fe-a835-f4f548a6f396 deleted from vrouter uve ...
2026-05-11 02:59:01,580 - DEBUG - Deleted interface not in error interface list ...
2026-05-11 02:59:04,581 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5767-2:Compute:contrail-vrouter-agent:0?flat
2026-05-11 02:59:04,622 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5767-2?flat
2026-05-11 02:59:04,659 - DEBUG - VM 40373c76-8c8a-49fe-a835-f4f548a6f396 is still present in vrouter an-jenkins-deploy-platform-ansible-os-5767-2 uve
2026-05-11 02:59:04,659 - DEBUG - Verifying if the vm interface deleted from vroter uve...
2026-05-11 02:59:04,659 - DEBUG - interface for vm 40373c76-8c8a-49fe-a835-f4f548a6f396 deleted from vrouter uve ...
2026-05-11 02:59:04,659 - DEBUG - Deleted interface not in error interface list ...
2026-05-11 02:59:07,660 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5767-2:Compute:contrail-vrouter-agent:0?flat
2026-05-11 02:59:07,700 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5767-2?flat
2026-05-11 02:59:07,730 - DEBUG - VM 40373c76-8c8a-49fe-a835-f4f548a6f396 is still present in vrouter an-jenkins-deploy-platform-ansible-os-5767-2 uve
2026-05-11 02:59:07,730 - DEBUG - Verifying if the vm interface deleted from vroter uve...
2026-05-11 02:59:07,730 - DEBUG - interface for vm 40373c76-8c8a-49fe-a835-f4f548a6f396 deleted from vrouter uve ...
2026-05-11 02:59:07,731 - DEBUG - Deleted interface not in error interface list ...
2026-05-11 02:59:10,731 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5767-2:Compute:contrail-vrouter-agent:0?flat
2026-05-11 02:59:10,766 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5767-2?flat
2026-05-11 02:59:10,796 - DEBUG - VM 40373c76-8c8a-49fe-a835-f4f548a6f396 is still present in vrouter an-jenkins-deploy-platform-ansible-os-5767-2 uve
2026-05-11 02:59:10,796 - DEBUG - Verifying if the vm interface deleted from vroter uve...
2026-05-11 02:59:10,796 - DEBUG - interface for vm 40373c76-8c8a-49fe-a835-f4f548a6f396 deleted from vrouter uve ...
2026-05-11 02:59:10,796 - DEBUG - Deleted interface not in error interface list ...
2026-05-11 02:59:13,797 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5767-2:Compute:contrail-vrouter-agent:0?flat
2026-05-11 02:59:13,834 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5767-2?flat
2026-05-11 02:59:13,864 - DEBUG - VM 40373c76-8c8a-49fe-a835-f4f548a6f396 is still present in vrouter an-jenkins-deploy-platform-ansible-os-5767-2 uve
2026-05-11 02:59:13,864 - DEBUG - Verifying if the vm interface deleted from vroter uve...
2026-05-11 02:59:13,864 - DEBUG - interface for vm 40373c76-8c8a-49fe-a835-f4f548a6f396 deleted from vrouter uve ...
2026-05-11 02:59:13,864 - DEBUG - Deleted interface not in error interface list ...
2026-05-11 02:59:16,865 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5767-2:Compute:contrail-vrouter-agent:0?flat
2026-05-11 02:59:16,902 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5767-2?flat
2026-05-11 02:59:16,934 - DEBUG - VM 40373c76-8c8a-49fe-a835-f4f548a6f396 is still present in vrouter an-jenkins-deploy-platform-ansible-os-5767-2 uve
2026-05-11 02:59:16,935 - DEBUG - Verifying if the vm interface deleted from vroter uve...
2026-05-11 02:59:16,935 - DEBUG - interface for vm 40373c76-8c8a-49fe-a835-f4f548a6f396 deleted from vrouter uve ...
2026-05-11 02:59:16,935 - DEBUG - Deleted interface not in error interface list ...
2026-05-11 02:59:19,935 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5767-2:Compute:contrail-vrouter-agent:0?flat
2026-05-11 02:59:19,971 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5767-2?flat
2026-05-11 02:59:20,002 - DEBUG - VM 40373c76-8c8a-49fe-a835-f4f548a6f396 is still present in vrouter an-jenkins-deploy-platform-ansible-os-5767-2 uve
2026-05-11 02:59:20,003 - DEBUG - Verifying if the vm interface deleted from vroter uve...
2026-05-11 02:59:20,003 - DEBUG - interface for vm 40373c76-8c8a-49fe-a835-f4f548a6f396 deleted from vrouter uve ...
2026-05-11 02:59:20,003 - DEBUG - Deleted interface not in error interface list ...
2026-05-11 02:59:23,003 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5767-2:Compute:contrail-vrouter-agent:0?flat
2026-05-11 02:59:23,044 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5767-2?flat
2026-05-11 02:59:23,076 - DEBUG - VM 40373c76-8c8a-49fe-a835-f4f548a6f396 is not present in vrouter an-jenkins-deploy-platform-ansible-os-5767-2 uve
2026-05-11 02:59:23,076 - DEBUG - Verifying if the vm interface deleted from vroter uve...
2026-05-11 02:59:23,076 - DEBUG - interface for vm 40373c76-8c8a-49fe-a835-f4f548a6f396 deleted from vrouter uve ...
2026-05-11 02:59:23,076 - DEBUG - Deleted interface not in error interface list ...
2026-05-11 02:59:23,076 - DEBUG - Validated that VM 40373c76-8c8a-49fe-a835-f4f548a6f396 is removed in Vrouter UVE
2026-05-11 02:59:23,076 - DEBUG - Verifying through opserver in 10.0.0.141
2026-05-11 02:59:23,076 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/virtual-network/default-domain:ctest-TestDetailedPolicy1-69989575:ctest-vnet0-09242266?flat
2026-05-11 02:59:23,095 - DEBUG - 40373c76-8c8a-49fe-a835-f4f548a6f396 BM not in default-domain:ctest-TestDetailedPolicy1-69989575:ctest-vnet0-09242266 uve
2026-05-11 02:59:23,095 - DEBUG - Validated that VM 40373c76-8c8a-49fe-a835-f4f548a6f396 is not present in the VN UVE
2026-05-11 02:59:23,095 - DEBUG - Verifying the 40373c76-8c8a-49fe-a835-f4f548a6f396 virtual network link through opserver 10.0.0.141
2026-05-11 02:59:23,095 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/virtual-machines
2026-05-11 02:59:23,107 - DEBUG - No links retuned for 40373c76-8c8a-49fe-a835-f4f548a6f396
2026-05-11 02:59:23,107 - INFO - 40373c76-8c8a-49fe-a835-f4f548a6f396 vm uve deleted from opserver
2026-05-11 02:59:23,107 - DEBUG - Verifying the 40373c76-8c8a-49fe-a835-f4f548a6f396 virtual network link through opserver 10.0.0.249
2026-05-11 02:59:23,107 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-machines
2026-05-11 02:59:23,125 - DEBUG - No links retuned for 40373c76-8c8a-49fe-a835-f4f548a6f396
2026-05-11 02:59:23,125 - INFO - 40373c76-8c8a-49fe-a835-f4f548a6f396 vm uve deleted from opserver
2026-05-11 02:59:23,125 - DEBUG - Verifying the 40373c76-8c8a-49fe-a835-f4f548a6f396 virtual network link through opserver 10.0.0.27
2026-05-11 02:59:23,125 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-machines
2026-05-11 02:59:23,140 - DEBUG - No links retuned for 40373c76-8c8a-49fe-a835-f4f548a6f396
2026-05-11 02:59:23,140 - INFO - 40373c76-8c8a-49fe-a835-f4f548a6f396 vm uve deleted from opserver
2026-05-11 02:59:23,140 - INFO - Validated that VM 40373c76-8c8a-49fe-a835-f4f548a6f396 is removed from Opserver
2026-05-11 02:59:23,140 - DEBUG - Detaching the Policy for VN :ctest-vnet1-28251161
2026-05-11 02:59:23,140 - DEBUG - Requesting: http://10.0.0.141:8082/domains
2026-05-11 02:59:23,148 - DEBUG - Requesting: http://10.0.0.141:8082/domain/a797b29a-b743-4bb0-b070-a90ae89983d0
2026-05-11 02:59:23,161 - DEBUG - Requesting: http://10.0.0.141:8082/project/7a4b295f-717d-4991-890a-6d630c522ea0
2026-05-11 02:59:23,260 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/52695fda-1449-44b1-bb70-f5d4761b6755
2026-05-11 02:59:23,445 - DEBUG - Detached Policy:[['default-domain', 'ctest-TestDetailedPolicy1-69989575', 'policy100']] from ctest-vnet1-28251161
2026-05-11 02:59:23,445 - DEBUG - Detaching the Policy for VN :ctest-vnet0-09242266
2026-05-11 02:59:23,445 - DEBUG - Requesting: http://10.0.0.141:8082/domains
2026-05-11 02:59:23,454 - DEBUG - Requesting: http://10.0.0.141:8082/domain/a797b29a-b743-4bb0-b070-a90ae89983d0
2026-05-11 02:59:23,477 - DEBUG - Requesting: http://10.0.0.141:8082/project/7a4b295f-717d-4991-890a-6d630c522ea0
2026-05-11 02:59:23,590 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/ea04ac5e-5af7-434e-9d8f-9d34d013ac05
2026-05-11 02:59:23,645 - INFO - Deleted policy policy1000
2026-05-11 02:59:23,826 - DEBUG - policy policy1000 is not found in API Server
2026-05-11 02:59:23,880 - INFO - Deleted policy policy13
2026-05-11 02:59:24,026 - DEBUG - policy policy13 is not found in API Server
2026-05-11 02:59:24,069 - INFO - Deleted policy policy12
2026-05-11 02:59:24,210 - DEBUG - policy policy12 is not found in API Server
2026-05-11 02:59:24,249 - INFO - Deleted policy policy11
2026-05-11 02:59:24,445 - DEBUG - policy policy11 is not found in API Server
2026-05-11 02:59:24,501 - INFO - Deleted policy policy10
2026-05-11 02:59:24,689 - DEBUG - policy policy10 is not found in API Server
2026-05-11 02:59:24,728 - INFO - Deleted policy policy100
2026-05-11 02:59:24,925 - DEBUG - policy policy100 is not found in API Server
2026-05-11 02:59:24,964 - INFO - Deleted policy policy3
2026-05-11 02:59:25,162 - DEBUG - policy policy3 is not found in API Server
2026-05-11 02:59:25,203 - INFO - Deleted policy policy2
2026-05-11 02:59:25,401 - DEBUG - policy policy2 is not found in API Server
2026-05-11 02:59:25,446 - INFO - Deleted policy policy1
2026-05-11 02:59:25,639 - DEBUG - policy policy1 is not found in API Server
2026-05-11 02:59:25,702 - INFO - Deleted policy policy0
2026-05-11 02:59:25,893 - DEBUG - policy policy0 is not found in API Server
2026-05-11 02:59:25,893 - INFO - Deleting VN ctest-vnet1-28251161
2026-05-11 02:59:26,062 - DEBUG - Response for deleting network ()
2026-05-11 02:59:26,062 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/3389e9f1-6fb0-4cda-b47e-35ea2b7175ba
2026-05-11 02:59:26,069 - DEBUG - Response Code: 404
2026-05-11 02:59:26,069 - DEBUG - Requesting: http://10.0.0.141:8082/domains
2026-05-11 02:59:26,079 - DEBUG - Requesting: http://10.0.0.141:8082/domain/a797b29a-b743-4bb0-b070-a90ae89983d0
2026-05-11 02:59:26,094 - DEBUG - Requesting: http://10.0.0.141:8082/project/7a4b295f-717d-4991-890a-6d630c522ea0
2026-05-11 02:59:26,188 - INFO - Validated that VN ctest-vnet1-28251161 is not found in API Server
2026-05-11 02:59:26,199 - DEBUG - VN ctest-vnet1-28251161 is not present in Agent 10.0.0.23
2026-05-11 02:59:26,209 - DEBUG - VN ctest-vnet1-28251161 is not present in Agent 10.0.0.240
2026-05-11 02:59:26,209 - INFO - Validated that VN ctest-vnet1-28251161 is not in any agent
2026-05-11 02:59:26,241 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vnet1-28251161 info
2026-05-11 02:59:26,241 - INFO - Deleting VN ctest-vnet0-09242266
2026-05-11 02:59:26,491 - DEBUG - Response for deleting network ()
2026-05-11 02:59:26,491 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/b81e6e39-5661-48ea-90ae-390afc438fe9
2026-05-11 02:59:26,497 - DEBUG - Response Code: 404
2026-05-11 02:59:26,497 - DEBUG - Requesting: http://10.0.0.141:8082/domains
2026-05-11 02:59:26,502 - DEBUG - Requesting: http://10.0.0.141:8082/domain/a797b29a-b743-4bb0-b070-a90ae89983d0
2026-05-11 02:59:26,512 - DEBUG - Requesting: http://10.0.0.141:8082/project/7a4b295f-717d-4991-890a-6d630c522ea0
2026-05-11 02:59:26,620 - INFO - Validated that VN ctest-vnet0-09242266 is not found in API Server
2026-05-11 02:59:26,631 - DEBUG - VN ctest-vnet0-09242266 is not present in Agent 10.0.0.23
2026-05-11 02:59:26,642 - DEBUG - VN ctest-vnet0-09242266 is not present in Agent 10.0.0.240
2026-05-11 02:59:26,642 - INFO - Validated that VN ctest-vnet0-09242266 is not in any agent
2026-05-11 02:59:26,677 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vnet0-09242266 info
2026-05-11 02:59:26,781 - INFO - IPAM: ctest-TestDetailedPolicy1-69989575-default-ipam is not found in API Server
2026-05-11 02:59:26,803 - INFO - IPAM:ctest-TestDetailedPolicy1-69989575-default-ipam is not found in control node
2026-05-11 02:59:27,361 - DEBUG - Skipping the deletion of Project ['default-domain', 'ctest-TestDetailedPolicy1-69989575']
2026-05-11 02:59:27,361 - DEBUG - Skipping the deletion of User admin
2026-05-11 02:59:28,644 - DEBUG - No XMPP flaps were noticed during the test
2026-05-11 02:59:28,644 - INFO - END TEST : test_multi_vn_repeated_policy_update_with_ping : PASSED[0:04:26]
2026-05-11 02:59:28,644 - INFO - --------------------------------------------------------------------------------
2026-05-11 02:59:29,843 - INFO - Deleted project: ctest-TestDetailedPolicy1-69989575, ID : 7a4b295f-717d-4991-890a-6d630c522ea0