2025-12-18 04:29:13,532 - INFO - Domain Default found not creating
2025-12-18 04:29:13,755 - INFO - Project ctest-TestRbac-76346359 not found, creating it
2025-12-18 04:29:14,307 - INFO - Created Project:ctest-TestRbac-76346359, ID : 6829ad44-d811-4474-93b3-a695f0a5c74f
2025-12-18 04:29:18,663 - INFO - ================================================================================
2025-12-18 04:29:18,663 - INFO - STARTING TEST : test_perms2_global_share
2025-12-18 04:29:18,663 - INFO - TEST DESCRIPTION :
Test perms2 global shared property of an object
steps:
1. Add user1 as role1 in project1 and project2
2. Add *.* role1:CRUD to domain acl
3. Create a Shared virtual-network in project1
4. Verify global shared flag is set on VN's perms2
4. Using shared VN try to launch a VM in project2
2025-12-18 04:29:19,954 - DEBUG - Skipping xmpp flap check
2025-12-18 04:29:20,317 - INFO - Initial checks done. Running the testcase now
2025-12-18 04:29:20,317 - INFO -
2025-12-18 04:29:20,729 - INFO - Project ctest-TestRbac-65563266 not found, creating it
2025-12-18 04:29:21,311 - INFO - Created Project:ctest-TestRbac-65563266, ID : 123ecd14-4302-4b2b-9261-1e22a30cfde5
2025-12-18 04:29:21,692 - INFO - Project ctest-TestRbac-20942021 not found, creating it
2025-12-18 04:29:22,260 - INFO - Created Project:ctest-TestRbac-20942021, ID : f07e242c-cfb7-4522-a888-6caaf996ed6e
2025-12-18 04:29:24,310 - DEBUG - Requesting: http://10.0.0.23:8082/api-access-list/d4afe345-4d8e-4473-942b-b8e13d9b485b
2025-12-18 04:29:24,649 - DEBUG - Requesting: http://10.0.0.23:8082/api-access-list/d4afe345-4d8e-4473-942b-b8e13d9b485b
2025-12-18 04:29:24,728 - DEBUG - API access-list (d4afe345-4d8e-4473-942b-b8e13d9b485b) found in api server
2025-12-18 04:29:24,729 - INFO - API access-list d4afe345-4d8e-4473-942b-b8e13d9b485b verify on api server passed
2025-12-18 04:29:25,501 - INFO - Created VN ctest-TestRbac-65563266-73308169, UUID :d479333d-0585-4041-83e0-d01b8866be6e
2025-12-18 04:29:26,231 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/d479333d-0585-4041-83e0-d01b8866be6e
2025-12-18 04:29:26,534 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/d479333d-0585-4041-83e0-d01b8866be6e
2025-12-18 04:29:26,596 - INFO - API Server: Read VN d479333d-0585-4041-83e0-d01b8866be6e
2025-12-18 04:29:26,596 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/d479333d-0585-4041-83e0-d01b8866be6e
2025-12-18 04:29:26,930 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/d479333d-0585-4041-83e0-d01b8866be6e
2025-12-18 04:29:26,992 - INFO - API Server: Read VN d479333d-0585-4041-83e0-d01b8866be6e
2025-12-18 04:29:26,992 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestRbac-65563266:ctest-TestRbac-65563266-73308169?flat
2025-12-18 04:29:27,293 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestRbac-65563266:ctest-TestRbac-65563266-73308169?flat
2025-12-18 04:29:27,748 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-12-18 04:29:27,924 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestRbac-65563266:ctest-TestRbac-65563266-73308169?flat
2025-12-18 04:29:28,249 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestRbac-65563266:ctest-TestRbac-65563266-73308169?flat
2025-12-18 04:29:28,468 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-12-18 04:29:29,387 - WARNING - Unable to get the list of compute nodes
2025-12-18 04:29:30,716 - INFO - VM ([]) created on node: (None), Zone: (None)
2025-12-18 04:29:30,802 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2025-12-18 04:29:35,898 - DEBUG - VM is in ACTIVE state now
2025-12-18 04:29:35,898 - INFO - VM name : ctest-TestRbac-20942021-78016795
2025-12-18 04:29:35,993 - DEBUG - VM ctest-TestRbac-20942021-78016795 ID is ffaffec0-9d93-4812-9fed-06bd1b2e86ab
2025-12-18 04:29:36,102 - DEBUG - VM is in ACTIVE state now
2025-12-18 04:29:36,141 - DEBUG - VM ctest-TestRbac-20942021-78016795 launched on Node an-jenkins-deploy-platform-ansible-os-4903-2
2025-12-18 04:29:36,231 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-machine/ffaffec0-9d93-4812-9fed-06bd1b2e86ab
2025-12-18 04:29:36,552 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-machine/ffaffec0-9d93-4812-9fed-06bd1b2e86ab
2025-12-18 04:29:36,605 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-machine/ffaffec0-9d93-4812-9fed-06bd1b2e86ab
2025-12-18 04:29:36,629 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-machine-interface/697633d4-814f-408f-af0f-1007a657e115
2025-12-18 04:29:36,657 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-machine/ffaffec0-9d93-4812-9fed-06bd1b2e86ab
2025-12-18 04:29:36,683 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-machine-interface/697633d4-814f-408f-af0f-1007a657e115
2025-12-18 04:29:36,718 - DEBUG - Requesting: http://10.0.0.65:8082/instance-ip/4e9ad5c2-2352-4ea9-96d1-0dc9aaa6751d
2025-12-18 04:29:36,749 - DEBUG - Verifying in api server 10.0.0.65
2025-12-18 04:29:36,749 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-machine/ffaffec0-9d93-4812-9fed-06bd1b2e86ab
2025-12-18 04:29:36,777 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-machine-interface/697633d4-814f-408f-af0f-1007a657e115
2025-12-18 04:29:36,810 - DEBUG - Requesting: http://10.0.0.65:8082/instance-ip/4e9ad5c2-2352-4ea9-96d1-0dc9aaa6751d
2025-12-18 04:29:36,836 - INFO - VM ctest-TestRbac-20942021-78016795 verfication in all API Servers passed
2025-12-18 04:29:36,862 - DEBUG - VM ctest-TestRbac-20942021-78016795 Tap interface: {'index': '3', 'name': 'tap697633d4-81', 'uuid': '697633d4-814f-408f-af0f-1007a657e115', 'vrf_name': 'default-domain:ctest-TestRbac-65563266:ctest-TestRbac-65563266-73308169:ctest-TestRbac-65563266-73308169', 'active': 'Active', 'ipv4_active': 'Active', 'l2_active': 'L2 Active', 'ip6_active': 'Ipv6 Inactive < no-ipv6-addr >', 'health_check_active': 'Active', 'dhcp_service': 'Enable', 'dhcp_service_v6': 'Disable', 'dns_service': 'Enable', 'type': 'vport', 'label': '25', 'l2_label': '29', 'vxlan_id': '14', 'vn_name': 'default-domain:ctest-TestRbac-65563266:ctest-TestRbac-65563266-73308169', 'vm_uuid': 'ffaffec0-9d93-4812-9fed-06bd1b2e86ab', 'vm_name': 'ctest-TestRbac-20942021-78016795', 'ip_addr': '157.105.147.188', 'mac_addr': '02:69:76:33:d4:81', 'policy': 'Enable', 'fip_list': [], 'mdata_ip_addr': '169.254.0.3', 'service_vlan_list': None, 'os_ifindex': '125', 'fabric_port': 'NotFabricPort', 'alloc_linklocal_ip': 'LL-Enable', 'analyzer_name': None, 'config_name': 'default-domain:ctest-TestRbac-20942021:697633d4-814f-408f-af0f-1007a657e115', 'sg_uuid_list': ['d76930ed-12e7-4af5-943f-563c923180b9'], 'static_route_list': None, 'vm_project_uuid': 'f07e242c-cfb7-4522-a888-6caaf996ed6e', 'admin_state': 'Enabled', 'flow_key_idx': '31', 'allowed_address_pair_list': None, 'ip6_addr': '::', 'local_preference': '0', 'tx_vlan_id': '-1', 'rx_vlan_id': '-1', 'parent_interface': None, 'subnet': '--NA--', 'sub_type': 'Tap', 'vrf_assign_acl_uuid': '--NA--', 'vmi_type': 'Virtual Machine', 'transport': 'Ethernet', 'logical_interface_uuid': '00000000-0000-0000-0000-000000000000', 'flood_unknown_unicast': 'false', 'physical_device': None, 'physical_interface': None, 'fixed_ip4_list': None, 'fixed_ip6_list': None, 'fat_flow_list': None, 'metadata_ip_active': 'Active', 'service_health_check_ip': '0.0.0.0', 'alias_ip_list': None, 'drop_new_flows': 'false', 'bridge_domain_list': [], 'vmi_tag_list': None, 'policy_set_acl_list': None, 'slo_list': None, 'vhostuser_mode': '0', 'si_other_end_vmi': '00000000-0000-0000-0000-000000000000', 'cfg_igmp_enable': 'false', 'igmp_enabled': 'false', 'max_flows': '0', 'policy_set_fwaas_list': None, 'bond_interface_list': None, 'mac_ip_learning_enable': 'false', 'mac_ip_list': []}
2025-12-18 04:29:36,862 - DEBUG - Agent 10.0.0.129 vrf name: default-domain:ctest-TestRbac-65563266:ctest-TestRbac-65563266-73308169:ctest-TestRbac-65563266-73308169
2025-12-18 04:29:36,870 - DEBUG - Agent VRF Object : {'vrf_list': [{'name': 'default-domain:ctest-TestRbac-65563266:ctest-TestRbac-65563266-73308169:ctest-TestRbac-65563266-73308169', 'ucindex': '2', 'mcindex': '2', 'l2index': '2', 'source': 'Config; ', 'uc6index': '2', 'vn': 'default-domain:ctest-TestRbac-65563266:ctest-TestRbac-65563266-73308169', 'table_label': '-1', 'vxlan_id': '14', 'evpnindex': '2', 'brindex': '2', 'mplsindex': '0', 'RD': '10.20.0.240:2', 'mac_aging_time': '0', 'layer2_control_word': 'false', 'forwarding_vrf': None, 'hbf_rintf': '-1', 'hbf_lintf': '-1'}]}
2025-12-18 04:29:37,650 - DEBUG - VM ctest-TestRbac-20942021-78016795 : Tap interface tap697633d4-81 is set to Active
2025-12-18 04:29:37,650 - DEBUG - Tap interface tap697633d4-81 detail : {'index': '3', 'name': 'tap697633d4-81', 'uuid': '697633d4-814f-408f-af0f-1007a657e115', 'vrf_name': 'default-domain:ctest-TestRbac-65563266:ctest-TestRbac-65563266-73308169:ctest-TestRbac-65563266-73308169', 'active': 'Active', 'ipv4_active': 'Active', 'l2_active': 'L2 Active', 'ip6_active': 'Ipv6 Inactive < no-ipv6-addr >', 'health_check_active': 'Active', 'dhcp_service': 'Enable', 'dhcp_service_v6': 'Disable', 'dns_service': 'Enable', 'type': 'vport', 'label': '25', 'l2_label': '29', 'vxlan_id': '14', 'vn_name': 'default-domain:ctest-TestRbac-65563266:ctest-TestRbac-65563266-73308169', 'vm_uuid': 'ffaffec0-9d93-4812-9fed-06bd1b2e86ab', 'vm_name': 'ctest-TestRbac-20942021-78016795', 'ip_addr': '157.105.147.188', 'mac_addr': '02:69:76:33:d4:81', 'policy': 'Enable', 'fip_list': [], 'mdata_ip_addr': '169.254.0.3', 'service_vlan_list': None, 'os_ifindex': '125', 'fabric_port': 'NotFabricPort', 'alloc_linklocal_ip': 'LL-Enable', 'analyzer_name': None, 'config_name': 'default-domain:ctest-TestRbac-20942021:697633d4-814f-408f-af0f-1007a657e115', 'sg_uuid_list': ['d76930ed-12e7-4af5-943f-563c923180b9'], 'static_route_list': None, 'vm_project_uuid': 'f07e242c-cfb7-4522-a888-6caaf996ed6e', 'admin_state': 'Enabled', 'flow_key_idx': '31', 'allowed_address_pair_list': None, 'ip6_addr': '::', 'local_preference': '0', 'tx_vlan_id': '-1', 'rx_vlan_id': '-1', 'parent_interface': None, 'subnet': '--NA--', 'sub_type': 'Tap', 'vrf_assign_acl_uuid': '--NA--', 'vmi_type': 'Virtual Machine', 'transport': 'Ethernet', 'logical_interface_uuid': '00000000-0000-0000-0000-000000000000', 'flood_unknown_unicast': 'false', 'physical_device': None, 'physical_interface': None, 'fixed_ip4_list': None, 'fixed_ip6_list': None, 'fat_flow_list': None, 'metadata_ip_active': 'Active', 'service_health_check_ip': '0.0.0.0', 'alias_ip_list': None, 'drop_new_flows': 'false', 'bridge_domain_list': [], 'vmi_tag_list': None, 'policy_set_acl_list': None, 'slo_list': None, 'vhostuser_mode': '0', 'si_other_end_vmi': '00000000-0000-0000-0000-000000000000', 'cfg_igmp_enable': 'false', 'igmp_enabled': 'false', 'max_flows': '0', 'policy_set_fwaas_list': None, 'bond_interface_list': None, 'mac_ip_learning_enable': 'false', 'mac_ip_list': []}
2025-12-18 04:29:37,797 - DEBUG - Starting Layer 2 verification in Agent
2025-12-18 04:29:37,815 - DEBUG - Layer 2 path is seen for VM MAC 02:69:76:33:d4:81 in agent 10.0.0.129
2025-12-18 04:29:37,816 - DEBUG - Active layer 2 route in agent is present for VMI tap697633d4-81
2025-12-18 04:29:37,816 - DEBUG - L2 label(29) matches bw route table and interface table
2025-12-18 04:29:37,834 - DEBUG - VN default-domain:ctest-TestRbac-65563266:ctest-TestRbac-65563266-73308169 is found in Agent of node 10.0.0.129
2025-12-18 04:29:37,973 - DEBUG - VRF IDs of VN default-domain:ctest-TestRbac-65563266:ctest-TestRbac-65563266-73308169 is consistent in agent 10.0.0.129
2025-12-18 04:29:37,973 - DEBUG - Route for VM IP ['157.105.147.188'] is consistent in agent 10.0.0.129
2025-12-18 04:29:37,974 - DEBUG - VN default-domain:ctest-TestRbac-65563266:ctest-TestRbac-65563266-73308169 verification for VM ctest-TestRbac-20942021-78016795 in Agent 10.0.0.129 passed
2025-12-18 04:29:38,113 - DEBUG - Starting all layer 2 verification in agent 10.0.0.129
2025-12-18 04:29:38,128 - DEBUG - Route for VM MAC 02:69:76:33:d4:81 is consistent in agent 10.0.0.129
2025-12-18 04:29:41,357 - 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')
2025-12-18 04:29:41,357 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-TestRbac-20942021-78016795 failed!
2025-12-18 04:29:41,401 - DEBUG - Gateway for vn default-domain:ctest-TestRbac-65563266:ctest-TestRbac-65563266-73308169 is 157.105.147.190 and allocation pool is NOT set
2025-12-18 04:29:45,490 - 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=9.20 ms\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 1 received, 50% packet loss, time 1008ms\r\nrtt min/avg/max/mdev = 9.197/9.197/9.197/0.000 ms')
2025-12-18 04:29:45,490 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-TestRbac-20942021-78016795 passed
2025-12-18 04:29:45,490 - INFO - VM ctest-TestRbac-20942021-78016795 verifications in Compute nodes passed
2025-12-18 04:29:45,750 - DEBUG - Validated VM route 157.105.147.188 in vrouter of 10.0.0.129
2025-12-18 04:29:45,755 - DEBUG - Remote Nh validation passed. Expected Tunnel, label: None, 0; Got None,0
2025-12-18 04:29:45,755 - INFO - Validated routes of VM ctest-TestRbac-20942021-78016795 in all vrouters
2025-12-18 04:29:46,387 - DEBUG - Starting all layer2 verification in 10.0.0.23 Control Node
2025-12-18 04:29:46,491 - DEBUG - Layer2 route found for VM MAC 02:69:76:33:d4:81 in Control-node 10.0.0.23
2025-12-18 04:29:46,492 - DEBUG - L2 Label for VM ctest-TestRbac-20942021-78016795 same between Control-node 10.0.0.23 and Agent, Expected: 29, Seen: 29
2025-12-18 04:29:46,492 - DEBUG - Starting all layer2 verification in 10.0.0.65 Control Node
2025-12-18 04:29:46,645 - DEBUG - Layer2 route found for VM MAC 02:69:76:33:d4:81 in Control-node 10.0.0.65
2025-12-18 04:29:46,645 - DEBUG - L2 Label for VM ctest-TestRbac-20942021-78016795 same between Control-node 10.0.0.65 and Agent, Expected: 29, Seen: 29
2025-12-18 04:29:46,645 - INFO - Verification in Control-nodes for VM ctest-TestRbac-20942021-78016795 passed
2025-12-18 04:29:46,645 - DEBUG - Verifying the vm in opserver
2025-12-18 04:29:46,646 - DEBUG - Verifying in collector 10.0.0.65 ...
2025-12-18 04:29:46,646 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-machine/ffaffec0-9d93-4812-9fed-06bd1b2e86ab?flat
2025-12-18 04:29:46,964 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-machine/ffaffec0-9d93-4812-9fed-06bd1b2e86ab?flat
2025-12-18 04:29:47,107 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-machine-interface/default-domain:ctest-TestRbac-20942021:697633d4-814f-408f-af0f-1007a657e115?flat
2025-12-18 04:29:47,175 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-machine-interface/default-domain:ctest-TestRbac-20942021:697633d4-814f-408f-af0f-1007a657e115?flat
2025-12-18 04:29:47,241 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-machine/ffaffec0-9d93-4812-9fed-06bd1b2e86ab?flat
2025-12-18 04:29:47,350 - DEBUG - Verifying vm in vn uve
2025-12-18 04:29:47,350 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-machine-interface/default-domain:ctest-TestRbac-20942021:697633d4-814f-408f-af0f-1007a657e115?flat
2025-12-18 04:29:47,420 - DEBUG - VM uve shows interface as {'tx_vlan': 65535, 'vm_uuid': 'ffaffec0-9d93-4812-9fed-06bd1b2e86ab', '__T': 1766032183459898, 'vn_uuid': 'd479333d-0585-4041-83e0-d01b8866be6e', 'active': True, 'ip6_active': False, 'vm_name': 'ctest-TestRbac-20942021-78016795', 'uuid': '697633d4-814f-408f-af0f-1007a657e115', 'ip_address': '157.105.147.188', 'virtual_network': 'default-domain:ctest-TestRbac-65563266:ctest-TestRbac-65563266-73308169', 'fixed_ip4_list': ['157.105.147.188'], 'ip4_active': True, 'mac_address': '02:69:76:33:d4:81', 'port_mirror_enabled': False, 'l2_active': True, 'label': 25, 'vhostuser_mode': 0, 'ip6_address': '::', 'is_health_check_active': True, 'admin_state': True, 'rx_vlan': 65535, 'gateway': '157.105.147.190'}
2025-12-18 04:29:47,420 - DEBUG - VM uve shows ip address as ['157.105.147.188', '::']
2025-12-18 04:29:47,420 - DEBUG - VM uve shows virtual network as default-domain:ctest-TestRbac-65563266:ctest-TestRbac-65563266-73308169
2025-12-18 04:29:47,420 - INFO - Verifying through opserver in 10.0.0.23
2025-12-18 04:29:47,421 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestRbac-65563266:ctest-TestRbac-65563266-73308169?flat
2025-12-18 04:29:47,485 - DEBUG - expected vm list ffaffec0-9d93-4812-9fed-06bd1b2e86ab
2025-12-18 04:29:47,485 - DEBUG - Extracted vm list ['ffaffec0-9d93-4812-9fed-06bd1b2e86ab']
2025-12-18 04:29:47,485 - INFO - VM ffaffec0-9d93-4812-9fed-06bd1b2e86ab is present in default-domain:ctest-TestRbac-65563266:ctest-TestRbac-65563266-73308169
2025-12-18 04:29:47,485 - DEBUG - Verifying vm in vrouter uve
2025-12-18 04:29:47,485 - DEBUG - Getting info from collector 10.0.0.65..
2025-12-18 04:29:47,485 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-machine/ffaffec0-9d93-4812-9fed-06bd1b2e86ab?flat
2025-12-18 04:29:47,564 - DEBUG - VM uve shows vrouter as ['an-jenkins-deploy-platform-ansible-os-4903-2']
2025-12-18 04:29:47,564 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-4903-2:Compute:contrail-vrouter-agent:0?flat
2025-12-18 04:29:47,942 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-4903-2:Compute:contrail-vrouter-agent:0?flat
2025-12-18 04:29:48,123 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-4903-2:Compute:contrail-vrouter-agent:0?flat
2025-12-18 04:29:48,485 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-4903-2:Compute:contrail-vrouter-agent:0?flat
2025-12-18 04:29:48,586 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-4903-2?flat
2025-12-18 04:29:48,916 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-4903-2?flat
2025-12-18 04:29:48,998 - DEBUG - VM ffaffec0-9d93-4812-9fed-06bd1b2e86ab is present in vrouter an-jenkins-deploy-platform-ansible-os-4903-2 uve
2025-12-18 04:29:48,998 - DEBUG - Validated that VM ctest-TestRbac-20942021-78016795 is in Vrouter an-jenkins-deploy-platform-ansible-os-4903-2 UVE
2025-12-18 04:29:48,998 - DEBUG - Verifying vm tap interface/vn in vrouter uve
2025-12-18 04:29:49,009 - DEBUG - Expected tap interface of VM uuid ffaffec0-9d93-4812-9fed-06bd1b2e86ab is default-domain:ctest-TestRbac-20942021:697633d4-814f-408f-af0f-1007a657e115
2025-12-18 04:29:49,009 - DEBUG - Expected VN of VM uuid ffaffec0-9d93-4812-9fed-06bd1b2e86ab is default-domain:ctest-TestRbac-65563266:ctest-TestRbac-65563266-73308169
2025-12-18 04:29:49,010 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-4903-2:Compute:contrail-vrouter-agent:0?flat
2025-12-18 04:29:49,357 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-4903-2:Compute:contrail-vrouter-agent:0?flat
2025-12-18 04:29:49,522 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-4903-2:Compute:contrail-vrouter-agent:0?flat
2025-12-18 04:29:49,611 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-4903-2?flat
2025-12-18 04:29:49,697 - DEBUG - VM ffaffec0-9d93-4812-9fed-06bd1b2e86ab is present in vrouter an-jenkins-deploy-platform-ansible-os-4903-2 uve
2025-12-18 04:29:49,697 - INFO - tap interface default-domain:ctest-TestRbac-20942021:697633d4-814f-408f-af0f-1007a657e115 of vm ffaffec0-9d93-4812-9fed-06bd1b2e86ab is present in vrouter an-jenkins-deploy-platform-ansible-os-4903-2 uve
2025-12-18 04:29:49,698 - DEBUG - Connected network default-domain:ctest-TestRbac-65563266:ctest-TestRbac-65563266-73308169 of vm ffaffec0-9d93-4812-9fed-06bd1b2e86ab is present in vrouter an-jenkins-deploy-platform-ansible-os-4903-2 uve
2025-12-18 04:29:49,698 - DEBUG - Verifying the ffaffec0-9d93-4812-9fed-06bd1b2e86ab virtual network link through opserver 10.0.0.23
2025-12-18 04:29:49,698 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-machines
2025-12-18 04:29:49,755 - DEBUG - VM link and name as {'name': 'ffaffec0-9d93-4812-9fed-06bd1b2e86ab', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-machine/ffaffec0-9d93-4812-9fed-06bd1b2e86ab?flat'}
2025-12-18 04:29:49,755 - DEBUG - Verifying the ffaffec0-9d93-4812-9fed-06bd1b2e86ab virtual network link through opserver 10.0.0.50
2025-12-18 04:29:49,755 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-machines
2025-12-18 04:29:50,063 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-machines
2025-12-18 04:29:50,226 - DEBUG - VM link and name as {'name': 'ffaffec0-9d93-4812-9fed-06bd1b2e86ab', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-machine/ffaffec0-9d93-4812-9fed-06bd1b2e86ab?flat'}
2025-12-18 04:29:50,226 - DEBUG - Verifying the ffaffec0-9d93-4812-9fed-06bd1b2e86ab virtual network link through opserver 10.0.0.65
2025-12-18 04:29:50,226 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-machines
2025-12-18 04:29:50,272 - DEBUG - VM link and name as {'name': 'ffaffec0-9d93-4812-9fed-06bd1b2e86ab', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-machine/ffaffec0-9d93-4812-9fed-06bd1b2e86ab?flat'}
2025-12-18 04:29:50,272 - INFO - VM ctest-TestRbac-20942021-78016795 validations in Opserver passed
2025-12-18 04:29:50,273 - INFO - Deleting VM ctest-TestRbac-20942021-78016795
2025-12-18 04:29:50,348 - DEBUG - Verifying in api server 10.0.0.65
2025-12-18 04:29:50,348 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-machine/ffaffec0-9d93-4812-9fed-06bd1b2e86ab
2025-12-18 04:29:50,372 - DEBUG - VM ID ffaffec0-9d93-4812-9fed-06bd1b2e86ab of VM ctest-TestRbac-20942021-78016795 is still found in API Server
2025-12-18 04:29:52,372 - DEBUG - Verifying in api server 10.0.0.65
2025-12-18 04:29:52,373 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-machine/ffaffec0-9d93-4812-9fed-06bd1b2e86ab
2025-12-18 04:29:52,397 - DEBUG - Response Code: 404
2025-12-18 04:29:52,397 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-machine/ffaffec0-9d93-4812-9fed-06bd1b2e86ab
2025-12-18 04:29:52,417 - DEBUG - Response Code: 404
2025-12-18 04:29:52,417 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-machine/ffaffec0-9d93-4812-9fed-06bd1b2e86ab
2025-12-18 04:29:52,435 - DEBUG - Response Code: 404
2025-12-18 04:29:52,436 - INFO - VM ctest-TestRbac-20942021-78016795 is fully removed in API-Server
2025-12-18 04:29:52,589 - DEBUG - Skipping VM-deletion-check in nova db since mysql_token is not found
2025-12-18 04:29:52,636 - DEBUG - Validated that vrouter 10.0.0.249 does not have VMs route for VN default-domain:ctest-TestRbac-65563266:ctest-TestRbac-65563266-73308169
2025-12-18 04:29:52,648 - DEBUG - Validated that vrouter 10.0.0.129 does not have VMs route for VN default-domain:ctest-TestRbac-65563266:ctest-TestRbac-65563266-73308169
2025-12-18 04:29:52,648 - INFO - Validated that all vrouters do not have VMs route for VN default-domain:ctest-TestRbac-65563266:ctest-TestRbac-65563266-73308169
2025-12-18 04:29:52,648 - INFO - VM ctest-TestRbac-20942021-78016795 is removed in Compute, and routes are removed in all compute nodes
2025-12-18 04:29:52,970 - INFO - Routes for VM ctest-TestRbac-20942021-78016795 is removed in all control-nodes
2025-12-18 04:29:52,970 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-4903-2:Compute:contrail-vrouter-agent:0?flat
2025-12-18 04:29:53,400 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-4903-2:Compute:contrail-vrouter-agent:0?flat
2025-12-18 04:29:53,573 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-4903-2:Compute:contrail-vrouter-agent:0?flat
2025-12-18 04:29:53,606 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-4903-2?flat
2025-12-18 04:29:53,636 - DEBUG - VM ffaffec0-9d93-4812-9fed-06bd1b2e86ab is still present in vrouter an-jenkins-deploy-platform-ansible-os-4903-2 uve
2025-12-18 04:29:53,636 - DEBUG - Verifying if the vm interface deleted from vroter uve...
2025-12-18 04:29:53,637 - DEBUG - interface for vm ffaffec0-9d93-4812-9fed-06bd1b2e86ab deleted from vrouter uve ...
2025-12-18 04:29:53,637 - DEBUG - Deleted interface not in error interface list ...
2025-12-18 04:29:56,637 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-4903-2:Compute:contrail-vrouter-agent:0?flat
2025-12-18 04:29:56,733 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-4903-2?flat
2025-12-18 04:29:56,820 - DEBUG - VM ffaffec0-9d93-4812-9fed-06bd1b2e86ab is still present in vrouter an-jenkins-deploy-platform-ansible-os-4903-2 uve
2025-12-18 04:29:56,820 - DEBUG - Verifying if the vm interface deleted from vroter uve...
2025-12-18 04:29:56,820 - DEBUG - interface for vm ffaffec0-9d93-4812-9fed-06bd1b2e86ab deleted from vrouter uve ...
2025-12-18 04:29:56,820 - DEBUG - Deleted interface not in error interface list ...
2025-12-18 04:29:59,820 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-4903-2:Compute:contrail-vrouter-agent:0?flat
2025-12-18 04:29:59,863 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-4903-2?flat
2025-12-18 04:29:59,897 - DEBUG - VM ffaffec0-9d93-4812-9fed-06bd1b2e86ab is still present in vrouter an-jenkins-deploy-platform-ansible-os-4903-2 uve
2025-12-18 04:29:59,897 - DEBUG - Verifying if the vm interface deleted from vroter uve...
2025-12-18 04:29:59,897 - DEBUG - interface for vm ffaffec0-9d93-4812-9fed-06bd1b2e86ab deleted from vrouter uve ...
2025-12-18 04:29:59,897 - DEBUG - Deleted interface not in error interface list ...
2025-12-18 04:30:02,899 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-4903-2:Compute:contrail-vrouter-agent:0?flat
2025-12-18 04:30:02,947 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-4903-2?flat
2025-12-18 04:30:02,984 - DEBUG - VM ffaffec0-9d93-4812-9fed-06bd1b2e86ab is still present in vrouter an-jenkins-deploy-platform-ansible-os-4903-2 uve
2025-12-18 04:30:02,984 - DEBUG - Verifying if the vm interface deleted from vroter uve...
2025-12-18 04:30:02,984 - DEBUG - interface for vm ffaffec0-9d93-4812-9fed-06bd1b2e86ab deleted from vrouter uve ...
2025-12-18 04:30:02,984 - DEBUG - Deleted interface not in error interface list ...
2025-12-18 04:30:05,985 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-4903-2:Compute:contrail-vrouter-agent:0?flat
2025-12-18 04:30:06,019 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-4903-2?flat
2025-12-18 04:30:06,053 - DEBUG - VM ffaffec0-9d93-4812-9fed-06bd1b2e86ab is still present in vrouter an-jenkins-deploy-platform-ansible-os-4903-2 uve
2025-12-18 04:30:06,053 - DEBUG - Verifying if the vm interface deleted from vroter uve...
2025-12-18 04:30:06,053 - DEBUG - interface for vm ffaffec0-9d93-4812-9fed-06bd1b2e86ab deleted from vrouter uve ...
2025-12-18 04:30:06,053 - DEBUG - Deleted interface not in error interface list ...
2025-12-18 04:30:09,053 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-4903-2:Compute:contrail-vrouter-agent:0?flat
2025-12-18 04:30:09,093 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-4903-2?flat
2025-12-18 04:30:09,125 - DEBUG - VM ffaffec0-9d93-4812-9fed-06bd1b2e86ab is still present in vrouter an-jenkins-deploy-platform-ansible-os-4903-2 uve
2025-12-18 04:30:09,125 - DEBUG - Verifying if the vm interface deleted from vroter uve...
2025-12-18 04:30:09,125 - DEBUG - interface for vm ffaffec0-9d93-4812-9fed-06bd1b2e86ab deleted from vrouter uve ...
2025-12-18 04:30:09,125 - DEBUG - Deleted interface not in error interface list ...
2025-12-18 04:30:12,126 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-4903-2:Compute:contrail-vrouter-agent:0?flat
2025-12-18 04:30:12,170 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-4903-2?flat
2025-12-18 04:30:12,205 - DEBUG - VM ffaffec0-9d93-4812-9fed-06bd1b2e86ab is still present in vrouter an-jenkins-deploy-platform-ansible-os-4903-2 uve
2025-12-18 04:30:12,205 - DEBUG - Verifying if the vm interface deleted from vroter uve...
2025-12-18 04:30:12,205 - DEBUG - interface for vm ffaffec0-9d93-4812-9fed-06bd1b2e86ab deleted from vrouter uve ...
2025-12-18 04:30:12,205 - DEBUG - Deleted interface not in error interface list ...
2025-12-18 04:30:15,207 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-4903-2:Compute:contrail-vrouter-agent:0?flat
2025-12-18 04:30:15,245 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-4903-2?flat
2025-12-18 04:30:15,277 - DEBUG - VM ffaffec0-9d93-4812-9fed-06bd1b2e86ab is not present in vrouter an-jenkins-deploy-platform-ansible-os-4903-2 uve
2025-12-18 04:30:15,277 - DEBUG - Verifying if the vm interface deleted from vroter uve...
2025-12-18 04:30:15,277 - DEBUG - interface for vm ffaffec0-9d93-4812-9fed-06bd1b2e86ab deleted from vrouter uve ...
2025-12-18 04:30:15,277 - DEBUG - Deleted interface not in error interface list ...
2025-12-18 04:30:15,277 - DEBUG - Validated that VM ffaffec0-9d93-4812-9fed-06bd1b2e86ab is removed in Vrouter UVE
2025-12-18 04:30:15,277 - DEBUG - Verifying through opserver in 10.0.0.23
2025-12-18 04:30:15,277 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestRbac-65563266:ctest-TestRbac-65563266-73308169?flat
2025-12-18 04:30:15,298 - DEBUG - ffaffec0-9d93-4812-9fed-06bd1b2e86ab BM not in default-domain:ctest-TestRbac-65563266:ctest-TestRbac-65563266-73308169 uve
2025-12-18 04:30:15,298 - DEBUG - Validated that VM ffaffec0-9d93-4812-9fed-06bd1b2e86ab is not present in the VN UVE
2025-12-18 04:30:15,298 - DEBUG - Verifying the ffaffec0-9d93-4812-9fed-06bd1b2e86ab virtual network link through opserver 10.0.0.23
2025-12-18 04:30:15,298 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-machines
2025-12-18 04:30:15,311 - INFO - ffaffec0-9d93-4812-9fed-06bd1b2e86ab vm uve deleted from opserver
2025-12-18 04:30:15,311 - DEBUG - Verifying the ffaffec0-9d93-4812-9fed-06bd1b2e86ab virtual network link through opserver 10.0.0.50
2025-12-18 04:30:15,312 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-machines
2025-12-18 04:30:15,637 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-machines
2025-12-18 04:30:15,705 - INFO - ffaffec0-9d93-4812-9fed-06bd1b2e86ab vm uve deleted from opserver
2025-12-18 04:30:15,705 - DEBUG - Verifying the ffaffec0-9d93-4812-9fed-06bd1b2e86ab virtual network link through opserver 10.0.0.65
2025-12-18 04:30:15,705 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-machines
2025-12-18 04:30:15,720 - INFO - ffaffec0-9d93-4812-9fed-06bd1b2e86ab vm uve deleted from opserver
2025-12-18 04:30:15,720 - INFO - Validated that VM ffaffec0-9d93-4812-9fed-06bd1b2e86ab is removed from Opserver
2025-12-18 04:30:15,720 - INFO - Deleting VN ctest-TestRbac-65563266-73308169
2025-12-18 04:30:15,933 - DEBUG - Requesting: http://10.0.0.23:8082/api-access-list/d4afe345-4d8e-4473-942b-b8e13d9b485b
2025-12-18 04:30:15,944 - DEBUG - Response Code: 404
2025-12-18 04:30:15,944 - INFO - API access-list (d4afe345-4d8e-4473-942b-b8e13d9b485b) got deleted in api server
2025-12-18 04:30:17,025 - INFO - Deleted project: ctest-TestRbac-20942021, ID : f07e242c-cfb7-4522-a888-6caaf996ed6e
2025-12-18 04:30:17,858 - INFO - Deleted project: ctest-TestRbac-65563266, ID : 123ecd14-4302-4b2b-9261-1e22a30cfde5
2025-12-18 04:30:19,147 - DEBUG - Skipping xmpp flap check
2025-12-18 04:30:19,147 - INFO - END TEST : test_perms2_global_share : PASSED[0:01:01]
2025-12-18 04:30:19,147 - INFO - --------------------------------------------------------------------------------
2025-12-18 04:30:20,947 - INFO - Deleted project: ctest-TestRbac-76346359, ID : 6829ad44-d811-4474-93b3-a695f0a5c74f