2025-10-13 04:01:03,212 - INFO - Domain Default found not creating
2025-10-13 04:01:03,390 - INFO - Project ctest-TestRbac-92605139 not found, creating it
2025-10-13 04:01:03,924 - INFO - Created Project:ctest-TestRbac-92605139, ID : d8c2d770-cbc2-423d-ab76-0fb583ebdf0a
2025-10-13 04:01:07,470 - INFO - ================================================================================
2025-10-13 04:01:07,471 - INFO - STARTING TEST : test_perms2_global_share
2025-10-13 04:01:07,471 - 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-10-13 04:01:08,749 - DEBUG - Skipping xmpp flap check
2025-10-13 04:01:09,068 - INFO - Initial checks done. Running the testcase now
2025-10-13 04:01:09,068 - INFO -
2025-10-13 04:01:09,413 - INFO - Project ctest-TestRbac-40770353 not found, creating it
2025-10-13 04:01:09,875 - INFO - Created Project:ctest-TestRbac-40770353, ID : 4fefebbe-abbd-486e-a771-967bdde83643
2025-10-13 04:01:10,223 - INFO - Project ctest-TestRbac-53855334 not found, creating it
2025-10-13 04:01:10,723 - INFO - Created Project:ctest-TestRbac-53855334, ID : 3334f988-9e72-46cd-a381-9caff84014df
2025-10-13 04:01:12,540 - DEBUG - Requesting: http://10.0.0.22:8082/api-access-list/288051fd-0f56-4549-b9c5-715eda987f4f
2025-10-13 04:01:12,865 - DEBUG - Requesting: http://10.0.0.22:8082/api-access-list/288051fd-0f56-4549-b9c5-715eda987f4f
2025-10-13 04:01:12,931 - DEBUG - API access-list (288051fd-0f56-4549-b9c5-715eda987f4f) found in api server
2025-10-13 04:01:12,931 - INFO - API access-list 288051fd-0f56-4549-b9c5-715eda987f4f verify on api server passed
2025-10-13 04:01:13,632 - INFO - Created VN ctest-TestRbac-40770353-53869182, UUID :25e33d09-f3cd-4929-9316-68add1e0685e
2025-10-13 04:01:14,320 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/25e33d09-f3cd-4929-9316-68add1e0685e
2025-10-13 04:01:14,630 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/25e33d09-f3cd-4929-9316-68add1e0685e
2025-10-13 04:01:14,711 - INFO - API Server: Read VN 25e33d09-f3cd-4929-9316-68add1e0685e
2025-10-13 04:01:14,712 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/25e33d09-f3cd-4929-9316-68add1e0685e
2025-10-13 04:01:15,195 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/25e33d09-f3cd-4929-9316-68add1e0685e
2025-10-13 04:01:15,275 - INFO - API Server: Read VN 25e33d09-f3cd-4929-9316-68add1e0685e
2025-10-13 04:01:16,055 - WARNING - Unable to get the list of compute nodes
2025-10-13 04:01:17,234 - INFO - VM ([]) created on node: (None), Zone: (None)
2025-10-13 04:01:17,304 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2025-10-13 04:01:22,391 - DEBUG - VM is in ACTIVE state now
2025-10-13 04:01:22,391 - INFO - VM name : ctest-TestRbac-53855334-42020193
2025-10-13 04:01:22,470 - DEBUG - VM ctest-TestRbac-53855334-42020193 ID is bb57b645-05c2-4220-a23a-8c4c4f20c001
2025-10-13 04:01:22,552 - DEBUG - VM is in ACTIVE state now
2025-10-13 04:01:22,583 - DEBUG - VM ctest-TestRbac-53855334-42020193 launched on Node an-jenkins-deploy-platform-ansible-os-4296-2
2025-10-13 04:01:22,661 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-machine/bb57b645-05c2-4220-a23a-8c4c4f20c001
2025-10-13 04:01:22,972 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-machine/bb57b645-05c2-4220-a23a-8c4c4f20c001
2025-10-13 04:01:23,021 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-machine/bb57b645-05c2-4220-a23a-8c4c4f20c001
2025-10-13 04:01:23,044 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-machine-interface/e5bc8433-9ee1-4d28-9986-5ce635504145
2025-10-13 04:01:23,076 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-machine/bb57b645-05c2-4220-a23a-8c4c4f20c001
2025-10-13 04:01:23,096 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-machine-interface/e5bc8433-9ee1-4d28-9986-5ce635504145
2025-10-13 04:01:23,124 - DEBUG - Requesting: http://10.0.0.41:8082/instance-ip/3cdcccfe-34b9-486c-8324-d288ab59c190
2025-10-13 04:01:23,146 - DEBUG - Verifying in api server 10.0.0.41
2025-10-13 04:01:23,146 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-machine/bb57b645-05c2-4220-a23a-8c4c4f20c001
2025-10-13 04:01:23,169 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-machine-interface/e5bc8433-9ee1-4d28-9986-5ce635504145
2025-10-13 04:01:23,197 - DEBUG - Requesting: http://10.0.0.41:8082/instance-ip/3cdcccfe-34b9-486c-8324-d288ab59c190
2025-10-13 04:01:23,217 - INFO - VM ctest-TestRbac-53855334-42020193 verfication in all API Servers passed
2025-10-13 04:01:23,236 - DEBUG - VM ctest-TestRbac-53855334-42020193 Tap interface: {'index': '3', 'name': 'tape5bc8433-9e', 'uuid': 'e5bc8433-9ee1-4d28-9986-5ce635504145', 'vrf_name': 'default-domain:ctest-TestRbac-40770353:ctest-TestRbac-40770353-53869182:ctest-TestRbac-40770353-53869182', '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': '24', 'l2_label': '29', 'vxlan_id': '13', 'vn_name': 'default-domain:ctest-TestRbac-40770353:ctest-TestRbac-40770353-53869182', 'vm_uuid': 'bb57b645-05c2-4220-a23a-8c4c4f20c001', 'vm_name': 'ctest-TestRbac-53855334-42020193', 'ip_addr': '5.143.20.188', 'mac_addr': '02:e5:bc:84:33:9e', '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-53855334:e5bc8433-9ee1-4d28-9986-5ce635504145', 'sg_uuid_list': ['8b642068-5476-4ab3-820e-85cb76b21528'], 'static_route_list': None, 'vm_project_uuid': '3334f988-9e72-46cd-a381-9caff84014df', 'admin_state': 'Enabled', 'flow_key_idx': '25', '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-10-13 04:01:23,236 - DEBUG - Agent 10.0.0.27 vrf name: default-domain:ctest-TestRbac-40770353:ctest-TestRbac-40770353-53869182:ctest-TestRbac-40770353-53869182
2025-10-13 04:01:23,241 - DEBUG - Agent VRF Object : {'vrf_list': [{'name': 'default-domain:ctest-TestRbac-40770353:ctest-TestRbac-40770353-53869182:ctest-TestRbac-40770353-53869182', 'ucindex': '2', 'mcindex': '2', 'l2index': '2', 'source': 'Config; ', 'uc6index': '2', 'vn': 'default-domain:ctest-TestRbac-40770353:ctest-TestRbac-40770353-53869182', 'table_label': '-1', 'vxlan_id': '13', 'evpnindex': '2', 'brindex': '2', 'mplsindex': '0', 'RD': '10.20.0.201:2', 'mac_aging_time': '0', 'layer2_control_word': 'false', 'forwarding_vrf': None, 'hbf_rintf': '-1', 'hbf_lintf': '-1'}]}
2025-10-13 04:01:23,925 - DEBUG - VM ctest-TestRbac-53855334-42020193 : Tap interface tape5bc8433-9e is set to Active
2025-10-13 04:01:23,925 - DEBUG - Tap interface tape5bc8433-9e detail : {'index': '3', 'name': 'tape5bc8433-9e', 'uuid': 'e5bc8433-9ee1-4d28-9986-5ce635504145', 'vrf_name': 'default-domain:ctest-TestRbac-40770353:ctest-TestRbac-40770353-53869182:ctest-TestRbac-40770353-53869182', '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': '24', 'l2_label': '29', 'vxlan_id': '13', 'vn_name': 'default-domain:ctest-TestRbac-40770353:ctest-TestRbac-40770353-53869182', 'vm_uuid': 'bb57b645-05c2-4220-a23a-8c4c4f20c001', 'vm_name': 'ctest-TestRbac-53855334-42020193', 'ip_addr': '5.143.20.188', 'mac_addr': '02:e5:bc:84:33:9e', '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-53855334:e5bc8433-9ee1-4d28-9986-5ce635504145', 'sg_uuid_list': ['8b642068-5476-4ab3-820e-85cb76b21528'], 'static_route_list': None, 'vm_project_uuid': '3334f988-9e72-46cd-a381-9caff84014df', 'admin_state': 'Enabled', 'flow_key_idx': '25', '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-10-13 04:01:24,056 - DEBUG - Starting Layer 2 verification in Agent
2025-10-13 04:01:24,071 - DEBUG - Layer 2 path is seen for VM MAC 02:e5:bc:84:33:9e in agent 10.0.0.27
2025-10-13 04:01:24,071 - DEBUG - Active layer 2 route in agent is present for VMI tape5bc8433-9e
2025-10-13 04:01:24,071 - DEBUG - L2 label(29) matches bw route table and interface table
2025-10-13 04:01:24,084 - DEBUG - VN default-domain:ctest-TestRbac-40770353:ctest-TestRbac-40770353-53869182 is found in Agent of node 10.0.0.27
2025-10-13 04:01:24,207 - DEBUG - VRF IDs of VN default-domain:ctest-TestRbac-40770353:ctest-TestRbac-40770353-53869182 is consistent in agent 10.0.0.27
2025-10-13 04:01:24,208 - DEBUG - Route for VM IP ['5.143.20.188'] is consistent in agent 10.0.0.27
2025-10-13 04:01:24,208 - DEBUG - VN default-domain:ctest-TestRbac-40770353:ctest-TestRbac-40770353-53869182 verification for VM ctest-TestRbac-53855334-42020193 in Agent 10.0.0.27 passed
2025-10-13 04:01:24,344 - DEBUG - Starting all layer 2 verification in agent 10.0.0.27
2025-10-13 04:01:24,356 - DEBUG - Route for VM MAC 02:e5:bc:84:33:9e is consistent in agent 10.0.0.27
2025-10-13 04:01:27,566 - 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 1022ms')
2025-10-13 04:01:27,566 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-TestRbac-53855334-42020193 failed!
2025-10-13 04:01:27,612 - DEBUG - Gateway for vn default-domain:ctest-TestRbac-40770353:ctest-TestRbac-40770353-53869182 is 5.143.20.190 and allocation pool is NOT set
2025-10-13 04:01:29,676 - 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=4.25 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.489 ms\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1001ms\r\nrtt min/avg/max/mdev = 0.489/2.368/4.247/1.879 ms')
2025-10-13 04:01:29,676 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-TestRbac-53855334-42020193 passed
2025-10-13 04:01:29,676 - INFO - VM ctest-TestRbac-53855334-42020193 verifications in Compute nodes passed
2025-10-13 04:01:29,877 - DEBUG - Validated VM route 5.143.20.188 in vrouter of 10.0.0.27
2025-10-13 04:01:29,881 - DEBUG - Remote Nh validation passed. Expected Tunnel, label: None, 0; Got None,0
2025-10-13 04:01:29,881 - INFO - Validated routes of VM ctest-TestRbac-53855334-42020193 in all vrouters
2025-10-13 04:01:30,504 - DEBUG - Starting all layer2 verification in 10.0.0.41 Control Node
2025-10-13 04:01:30,610 - DEBUG - Layer2 route found for VM MAC 02:e5:bc:84:33:9e in Control-node 10.0.0.41
2025-10-13 04:01:30,610 - DEBUG - L2 Label for VM ctest-TestRbac-53855334-42020193 same between Control-node 10.0.0.41 and Agent, Expected: 29, Seen: 29
2025-10-13 04:01:30,610 - DEBUG - Starting all layer2 verification in 10.0.0.22 Control Node
2025-10-13 04:01:30,760 - DEBUG - Layer2 route found for VM MAC 02:e5:bc:84:33:9e in Control-node 10.0.0.22
2025-10-13 04:01:30,761 - DEBUG - L2 Label for VM ctest-TestRbac-53855334-42020193 same between Control-node 10.0.0.22 and Agent, Expected: 29, Seen: 29
2025-10-13 04:01:30,761 - INFO - Verification in Control-nodes for VM ctest-TestRbac-53855334-42020193 passed
2025-10-13 04:01:30,761 - DEBUG - Verifying the vm in opserver
2025-10-13 04:01:30,761 - DEBUG - Verifying in collector 10.0.0.41 ...
2025-10-13 04:01:30,761 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-machine/bb57b645-05c2-4220-a23a-8c4c4f20c001?flat
2025-10-13 04:01:31,052 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-machine/bb57b645-05c2-4220-a23a-8c4c4f20c001?flat
2025-10-13 04:01:31,166 - DEBUG - Failed to get VM ctest-TestRbac-53855334-42020193, ID bb57b645-05c2-4220-a23a-8c4c4f20c001 info from Opserver
2025-10-13 04:01:33,167 - DEBUG - Verifying the vm in opserver
2025-10-13 04:01:33,167 - DEBUG - Verifying in collector 10.0.0.41 ...
2025-10-13 04:01:33,168 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-machine/bb57b645-05c2-4220-a23a-8c4c4f20c001?flat
2025-10-13 04:01:33,258 - DEBUG - Failed to get VM ctest-TestRbac-53855334-42020193, ID bb57b645-05c2-4220-a23a-8c4c4f20c001 info from Opserver
2025-10-13 04:01:35,258 - DEBUG - Verifying the vm in opserver
2025-10-13 04:01:35,258 - DEBUG - Verifying in collector 10.0.0.41 ...
2025-10-13 04:01:35,258 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-machine/bb57b645-05c2-4220-a23a-8c4c4f20c001?flat
2025-10-13 04:01:35,324 - DEBUG - Failed to get VM ctest-TestRbac-53855334-42020193, ID bb57b645-05c2-4220-a23a-8c4c4f20c001 info from Opserver
2025-10-13 04:01:37,325 - DEBUG - Verifying the vm in opserver
2025-10-13 04:01:37,325 - DEBUG - Verifying in collector 10.0.0.41 ...
2025-10-13 04:01:37,325 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-machine/bb57b645-05c2-4220-a23a-8c4c4f20c001?flat
2025-10-13 04:01:37,378 - DEBUG - Failed to get VM ctest-TestRbac-53855334-42020193, ID bb57b645-05c2-4220-a23a-8c4c4f20c001 info from Opserver
2025-10-13 04:01:39,379 - DEBUG - Verifying the vm in opserver
2025-10-13 04:01:39,379 - DEBUG - Verifying in collector 10.0.0.41 ...
2025-10-13 04:01:39,379 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-machine/bb57b645-05c2-4220-a23a-8c4c4f20c001?flat
2025-10-13 04:01:39,433 - DEBUG - Failed to get VM ctest-TestRbac-53855334-42020193, ID bb57b645-05c2-4220-a23a-8c4c4f20c001 info from Opserver
2025-10-13 04:01:41,434 - DEBUG - Verifying the vm in opserver
2025-10-13 04:01:41,434 - DEBUG - Verifying in collector 10.0.0.41 ...
2025-10-13 04:01:41,434 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-machine/bb57b645-05c2-4220-a23a-8c4c4f20c001?flat
2025-10-13 04:01:41,482 - DEBUG - Failed to get VM ctest-TestRbac-53855334-42020193, ID bb57b645-05c2-4220-a23a-8c4c4f20c001 info from Opserver
2025-10-13 04:01:43,483 - DEBUG - Verifying the vm in opserver
2025-10-13 04:01:43,483 - DEBUG - Verifying in collector 10.0.0.41 ...
2025-10-13 04:01:43,483 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-machine/bb57b645-05c2-4220-a23a-8c4c4f20c001?flat
2025-10-13 04:01:43,529 - DEBUG - Failed to get VM ctest-TestRbac-53855334-42020193, ID bb57b645-05c2-4220-a23a-8c4c4f20c001 info from Opserver
2025-10-13 04:01:45,530 - DEBUG - Verifying the vm in opserver
2025-10-13 04:01:45,531 - DEBUG - Verifying in collector 10.0.0.41 ...
2025-10-13 04:01:45,531 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-machine/bb57b645-05c2-4220-a23a-8c4c4f20c001?flat
2025-10-13 04:01:45,581 - DEBUG - Failed to get VM ctest-TestRbac-53855334-42020193, ID bb57b645-05c2-4220-a23a-8c4c4f20c001 info from Opserver
2025-10-13 04:01:47,581 - DEBUG - Verifying the vm in opserver
2025-10-13 04:01:47,581 - DEBUG - Verifying in collector 10.0.0.41 ...
2025-10-13 04:01:47,581 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-machine/bb57b645-05c2-4220-a23a-8c4c4f20c001?flat
2025-10-13 04:01:47,623 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-machine-interface/default-domain:ctest-TestRbac-53855334:e5bc8433-9ee1-4d28-9986-5ce635504145?flat
2025-10-13 04:01:47,922 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-machine-interface/default-domain:ctest-TestRbac-53855334:e5bc8433-9ee1-4d28-9986-5ce635504145?flat
2025-10-13 04:01:48,346 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-machine-interface/default-domain:ctest-TestRbac-53855334:e5bc8433-9ee1-4d28-9986-5ce635504145?flat
2025-10-13 04:01:48,452 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-machine/bb57b645-05c2-4220-a23a-8c4c4f20c001?flat
2025-10-13 04:01:48,496 - DEBUG - Verifying vm in vn uve
2025-10-13 04:01:48,496 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-machine-interface/default-domain:ctest-TestRbac-53855334:e5bc8433-9ee1-4d28-9986-5ce635504145?flat
2025-10-13 04:01:48,550 - DEBUG - VM uve shows interface as {'admin_state': True, 'active': True, 'label': 24, 'ip4_active': True, 'uuid': 'e5bc8433-9ee1-4d28-9986-5ce635504145', 'fixed_ip4_list': ['5.143.20.188'], 'gateway': '5.143.20.190', 'vhostuser_mode': 0, 'tx_vlan': 65535, 'mac_address': '02:e5:bc:84:33:9e', 'port_mirror_enabled': False, 'vn_uuid': '25e33d09-f3cd-4929-9316-68add1e0685e', 'vm_uuid': 'bb57b645-05c2-4220-a23a-8c4c4f20c001', 'is_health_check_active': True, 'vm_name': 'ctest-TestRbac-53855334-42020193', 'ip6_active': False, 'virtual_network': 'default-domain:ctest-TestRbac-40770353:ctest-TestRbac-40770353-53869182', 'rx_vlan': 65535, 'ip6_address': '::', '__T': 1760328105850469, 'ip_address': '5.143.20.188', 'l2_active': True}
2025-10-13 04:01:48,550 - DEBUG - VM uve shows ip address as ['5.143.20.188', '::']
2025-10-13 04:01:48,550 - DEBUG - VM uve shows virtual network as default-domain:ctest-TestRbac-40770353:ctest-TestRbac-40770353-53869182
2025-10-13 04:01:48,550 - INFO - Verifying through opserver in 10.0.0.22
2025-10-13 04:01:48,550 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestRbac-40770353:ctest-TestRbac-40770353-53869182?flat
2025-10-13 04:01:48,609 - DEBUG - expected vm list bb57b645-05c2-4220-a23a-8c4c4f20c001
2025-10-13 04:01:48,609 - DEBUG - Extracted vm list ['bb57b645-05c2-4220-a23a-8c4c4f20c001']
2025-10-13 04:01:48,609 - INFO - VM bb57b645-05c2-4220-a23a-8c4c4f20c001 is present in default-domain:ctest-TestRbac-40770353:ctest-TestRbac-40770353-53869182
2025-10-13 04:01:48,609 - DEBUG - Verifying vm in vrouter uve
2025-10-13 04:01:48,609 - DEBUG - Getting info from collector 10.0.0.41..
2025-10-13 04:01:48,609 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-machine/bb57b645-05c2-4220-a23a-8c4c4f20c001?flat
2025-10-13 04:01:48,653 - DEBUG - VM uve shows vrouter as ['an-jenkins-deploy-platform-ansible-os-4296-2']
2025-10-13 04:01:48,653 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-4296-2:Compute:contrail-vrouter-agent:0?flat
2025-10-13 04:01:49,030 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-4296-2:Compute:contrail-vrouter-agent:0?flat
2025-10-13 04:01:49,161 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-4296-2:Compute:contrail-vrouter-agent:0?flat
2025-10-13 04:01:49,456 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-4296-2:Compute:contrail-vrouter-agent:0?flat
2025-10-13 04:01:49,528 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-4296-2?flat
2025-10-13 04:01:49,826 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-4296-2?flat
2025-10-13 04:01:49,890 - DEBUG - VM bb57b645-05c2-4220-a23a-8c4c4f20c001 is present in vrouter an-jenkins-deploy-platform-ansible-os-4296-2 uve
2025-10-13 04:01:49,891 - DEBUG - Validated that VM ctest-TestRbac-53855334-42020193 is in Vrouter an-jenkins-deploy-platform-ansible-os-4296-2 UVE
2025-10-13 04:01:49,891 - DEBUG - Verifying vm tap interface/vn in vrouter uve
2025-10-13 04:01:49,901 - DEBUG - Expected tap interface of VM uuid bb57b645-05c2-4220-a23a-8c4c4f20c001 is default-domain:ctest-TestRbac-53855334:e5bc8433-9ee1-4d28-9986-5ce635504145
2025-10-13 04:01:49,902 - DEBUG - Expected VN of VM uuid bb57b645-05c2-4220-a23a-8c4c4f20c001 is default-domain:ctest-TestRbac-40770353:ctest-TestRbac-40770353-53869182
2025-10-13 04:01:49,902 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-4296-2:Compute:contrail-vrouter-agent:0?flat
2025-10-13 04:01:50,325 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-4296-2:Compute:contrail-vrouter-agent:0?flat
2025-10-13 04:01:50,455 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-4296-2:Compute:contrail-vrouter-agent:0?flat
2025-10-13 04:01:50,529 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-4296-2?flat
2025-10-13 04:01:50,597 - DEBUG - VM bb57b645-05c2-4220-a23a-8c4c4f20c001 is present in vrouter an-jenkins-deploy-platform-ansible-os-4296-2 uve
2025-10-13 04:01:50,597 - INFO - tap interface default-domain:ctest-TestRbac-53855334:e5bc8433-9ee1-4d28-9986-5ce635504145 of vm bb57b645-05c2-4220-a23a-8c4c4f20c001 is present in vrouter an-jenkins-deploy-platform-ansible-os-4296-2 uve
2025-10-13 04:01:50,597 - DEBUG - Connected network default-domain:ctest-TestRbac-40770353:ctest-TestRbac-40770353-53869182 of vm bb57b645-05c2-4220-a23a-8c4c4f20c001 is present in vrouter an-jenkins-deploy-platform-ansible-os-4296-2 uve
2025-10-13 04:01:50,597 - DEBUG - Verifying the bb57b645-05c2-4220-a23a-8c4c4f20c001 virtual network link through opserver 10.0.0.22
2025-10-13 04:01:50,598 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-machines
2025-10-13 04:01:50,645 - DEBUG - VM link and name as {'name': 'bb57b645-05c2-4220-a23a-8c4c4f20c001', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-machine/bb57b645-05c2-4220-a23a-8c4c4f20c001?flat'}
2025-10-13 04:01:50,645 - DEBUG - Verifying the bb57b645-05c2-4220-a23a-8c4c4f20c001 virtual network link through opserver 10.0.0.19
2025-10-13 04:01:50,645 - DEBUG - Requesting: http://10.0.0.19:8081/analytics/uves/virtual-machines
2025-10-13 04:01:50,936 - DEBUG - Requesting: http://10.0.0.19:8081/analytics/uves/virtual-machines
2025-10-13 04:01:51,039 - DEBUG - VM link and name as {'name': 'bb57b645-05c2-4220-a23a-8c4c4f20c001', 'href': 'http://10.0.0.19:8081/analytics/uves/virtual-machine/bb57b645-05c2-4220-a23a-8c4c4f20c001?flat'}
2025-10-13 04:01:51,039 - DEBUG - Verifying the bb57b645-05c2-4220-a23a-8c4c4f20c001 virtual network link through opserver 10.0.0.41
2025-10-13 04:01:51,039 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-machines
2025-10-13 04:01:51,093 - DEBUG - VM link and name as {'name': 'bb57b645-05c2-4220-a23a-8c4c4f20c001', 'href': 'http://10.0.0.41:8081/analytics/uves/virtual-machine/bb57b645-05c2-4220-a23a-8c4c4f20c001?flat'}
2025-10-13 04:01:51,093 - INFO - VM ctest-TestRbac-53855334-42020193 validations in Opserver passed
2025-10-13 04:01:51,093 - INFO - Deleting VM ctest-TestRbac-53855334-42020193
2025-10-13 04:01:51,184 - DEBUG - Verifying in api server 10.0.0.41
2025-10-13 04:01:51,184 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-machine/bb57b645-05c2-4220-a23a-8c4c4f20c001
2025-10-13 04:01:51,205 - DEBUG - VM ID bb57b645-05c2-4220-a23a-8c4c4f20c001 of VM ctest-TestRbac-53855334-42020193 is still found in API Server
2025-10-13 04:01:53,206 - DEBUG - Verifying in api server 10.0.0.41
2025-10-13 04:01:53,206 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-machine/bb57b645-05c2-4220-a23a-8c4c4f20c001
2025-10-13 04:01:53,226 - DEBUG - Response Code: 404
2025-10-13 04:01:53,227 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-machine/bb57b645-05c2-4220-a23a-8c4c4f20c001
2025-10-13 04:01:53,242 - DEBUG - Response Code: 404
2025-10-13 04:01:53,242 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-machine/bb57b645-05c2-4220-a23a-8c4c4f20c001
2025-10-13 04:01:53,259 - DEBUG - Response Code: 404
2025-10-13 04:01:53,259 - INFO - VM ctest-TestRbac-53855334-42020193 is fully removed in API-Server
2025-10-13 04:01:53,417 - DEBUG - Skipping VM-deletion-check in nova db since mysql_token is not found
2025-10-13 04:01:53,453 - DEBUG - Validated that vrouter 10.0.0.249 does not have VMs route for VN default-domain:ctest-TestRbac-40770353:ctest-TestRbac-40770353-53869182
2025-10-13 04:01:53,463 - DEBUG - Validated that vrouter 10.0.0.27 does not have VMs route for VN default-domain:ctest-TestRbac-40770353:ctest-TestRbac-40770353-53869182
2025-10-13 04:01:53,463 - INFO - Validated that all vrouters do not have VMs route for VN default-domain:ctest-TestRbac-40770353:ctest-TestRbac-40770353-53869182
2025-10-13 04:01:53,463 - INFO - VM ctest-TestRbac-53855334-42020193 is removed in Compute, and routes are removed in all compute nodes
2025-10-13 04:01:53,761 - INFO - Routes for VM ctest-TestRbac-53855334-42020193 is removed in all control-nodes
2025-10-13 04:01:53,761 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-4296-2:Compute:contrail-vrouter-agent:0?flat
2025-10-13 04:01:54,162 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-4296-2:Compute:contrail-vrouter-agent:0?flat
2025-10-13 04:01:54,284 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-4296-2:Compute:contrail-vrouter-agent:0?flat
2025-10-13 04:01:54,314 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-4296-2?flat
2025-10-13 04:01:54,341 - DEBUG - VM bb57b645-05c2-4220-a23a-8c4c4f20c001 is still present in vrouter an-jenkins-deploy-platform-ansible-os-4296-2 uve
2025-10-13 04:01:54,341 - DEBUG - Verifying if the vm interface deleted from vroter uve...
2025-10-13 04:01:54,341 - DEBUG - interface for vm bb57b645-05c2-4220-a23a-8c4c4f20c001 deleted from vrouter uve ...
2025-10-13 04:01:54,341 - DEBUG - Deleted interface not in error interface list ...
2025-10-13 04:01:57,342 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-4296-2:Compute:contrail-vrouter-agent:0?flat
2025-10-13 04:01:57,411 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-4296-2?flat
2025-10-13 04:01:57,478 - DEBUG - VM bb57b645-05c2-4220-a23a-8c4c4f20c001 is still present in vrouter an-jenkins-deploy-platform-ansible-os-4296-2 uve
2025-10-13 04:01:57,478 - DEBUG - Verifying if the vm interface deleted from vroter uve...
2025-10-13 04:01:57,478 - DEBUG - interface for vm bb57b645-05c2-4220-a23a-8c4c4f20c001 deleted from vrouter uve ...
2025-10-13 04:01:57,478 - DEBUG - Deleted interface not in error interface list ...
2025-10-13 04:02:00,479 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-4296-2:Compute:contrail-vrouter-agent:0?flat
2025-10-13 04:02:00,522 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-4296-2?flat
2025-10-13 04:02:00,551 - DEBUG - VM bb57b645-05c2-4220-a23a-8c4c4f20c001 is still present in vrouter an-jenkins-deploy-platform-ansible-os-4296-2 uve
2025-10-13 04:02:00,551 - DEBUG - Verifying if the vm interface deleted from vroter uve...
2025-10-13 04:02:00,551 - DEBUG - interface for vm bb57b645-05c2-4220-a23a-8c4c4f20c001 deleted from vrouter uve ...
2025-10-13 04:02:00,551 - DEBUG - Deleted interface not in error interface list ...
2025-10-13 04:02:03,552 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-4296-2:Compute:contrail-vrouter-agent:0?flat
2025-10-13 04:02:03,585 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-4296-2?flat
2025-10-13 04:02:03,618 - DEBUG - VM bb57b645-05c2-4220-a23a-8c4c4f20c001 is still present in vrouter an-jenkins-deploy-platform-ansible-os-4296-2 uve
2025-10-13 04:02:03,618 - DEBUG - Verifying if the vm interface deleted from vroter uve...
2025-10-13 04:02:03,618 - DEBUG - interface for vm bb57b645-05c2-4220-a23a-8c4c4f20c001 deleted from vrouter uve ...
2025-10-13 04:02:03,618 - DEBUG - Deleted interface not in error interface list ...
2025-10-13 04:02:06,619 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-4296-2:Compute:contrail-vrouter-agent:0?flat
2025-10-13 04:02:06,653 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-4296-2?flat
2025-10-13 04:02:06,683 - DEBUG - VM bb57b645-05c2-4220-a23a-8c4c4f20c001 is still present in vrouter an-jenkins-deploy-platform-ansible-os-4296-2 uve
2025-10-13 04:02:06,683 - DEBUG - Verifying if the vm interface deleted from vroter uve...
2025-10-13 04:02:06,683 - DEBUG - interface for vm bb57b645-05c2-4220-a23a-8c4c4f20c001 deleted from vrouter uve ...
2025-10-13 04:02:06,683 - DEBUG - Deleted interface not in error interface list ...
2025-10-13 04:02:09,683 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-4296-2:Compute:contrail-vrouter-agent:0?flat
2025-10-13 04:02:09,715 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-4296-2?flat
2025-10-13 04:02:09,742 - DEBUG - VM bb57b645-05c2-4220-a23a-8c4c4f20c001 is still present in vrouter an-jenkins-deploy-platform-ansible-os-4296-2 uve
2025-10-13 04:02:09,742 - DEBUG - Verifying if the vm interface deleted from vroter uve...
2025-10-13 04:02:09,742 - DEBUG - interface for vm bb57b645-05c2-4220-a23a-8c4c4f20c001 deleted from vrouter uve ...
2025-10-13 04:02:09,742 - DEBUG - Deleted interface not in error interface list ...
2025-10-13 04:02:12,743 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-4296-2:Compute:contrail-vrouter-agent:0?flat
2025-10-13 04:02:12,773 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-4296-2?flat
2025-10-13 04:02:12,802 - DEBUG - VM bb57b645-05c2-4220-a23a-8c4c4f20c001 is still present in vrouter an-jenkins-deploy-platform-ansible-os-4296-2 uve
2025-10-13 04:02:12,802 - DEBUG - Verifying if the vm interface deleted from vroter uve...
2025-10-13 04:02:12,802 - DEBUG - interface for vm bb57b645-05c2-4220-a23a-8c4c4f20c001 deleted from vrouter uve ...
2025-10-13 04:02:12,802 - DEBUG - Deleted interface not in error interface list ...
2025-10-13 04:02:15,802 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-4296-2:Compute:contrail-vrouter-agent:0?flat
2025-10-13 04:02:15,841 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-4296-2?flat
2025-10-13 04:02:15,873 - DEBUG - VM bb57b645-05c2-4220-a23a-8c4c4f20c001 is not present in vrouter an-jenkins-deploy-platform-ansible-os-4296-2 uve
2025-10-13 04:02:15,873 - DEBUG - Verifying if the vm interface deleted from vroter uve...
2025-10-13 04:02:15,873 - DEBUG - interface for vm bb57b645-05c2-4220-a23a-8c4c4f20c001 deleted from vrouter uve ...
2025-10-13 04:02:15,873 - DEBUG - Deleted interface not in error interface list ...
2025-10-13 04:02:15,873 - DEBUG - Validated that VM bb57b645-05c2-4220-a23a-8c4c4f20c001 is removed in Vrouter UVE
2025-10-13 04:02:15,873 - DEBUG - Verifying through opserver in 10.0.0.22
2025-10-13 04:02:15,873 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestRbac-40770353:ctest-TestRbac-40770353-53869182?flat
2025-10-13 04:02:15,890 - DEBUG - bb57b645-05c2-4220-a23a-8c4c4f20c001 BM not in default-domain:ctest-TestRbac-40770353:ctest-TestRbac-40770353-53869182 uve
2025-10-13 04:02:15,890 - DEBUG - Validated that VM bb57b645-05c2-4220-a23a-8c4c4f20c001 is not present in the VN UVE
2025-10-13 04:02:15,890 - DEBUG - Verifying the bb57b645-05c2-4220-a23a-8c4c4f20c001 virtual network link through opserver 10.0.0.22
2025-10-13 04:02:15,890 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-machines
2025-10-13 04:02:15,903 - INFO - bb57b645-05c2-4220-a23a-8c4c4f20c001 vm uve deleted from opserver
2025-10-13 04:02:15,903 - DEBUG - Verifying the bb57b645-05c2-4220-a23a-8c4c4f20c001 virtual network link through opserver 10.0.0.19
2025-10-13 04:02:15,903 - DEBUG - Requesting: http://10.0.0.19:8081/analytics/uves/virtual-machines
2025-10-13 04:02:16,203 - DEBUG - Requesting: http://10.0.0.19:8081/analytics/uves/virtual-machines
2025-10-13 04:02:16,266 - INFO - bb57b645-05c2-4220-a23a-8c4c4f20c001 vm uve deleted from opserver
2025-10-13 04:02:16,267 - DEBUG - Verifying the bb57b645-05c2-4220-a23a-8c4c4f20c001 virtual network link through opserver 10.0.0.41
2025-10-13 04:02:16,267 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-machines
2025-10-13 04:02:16,280 - INFO - bb57b645-05c2-4220-a23a-8c4c4f20c001 vm uve deleted from opserver
2025-10-13 04:02:16,280 - INFO - Validated that VM bb57b645-05c2-4220-a23a-8c4c4f20c001 is removed from Opserver
2025-10-13 04:02:16,281 - INFO - Deleting VN ctest-TestRbac-40770353-53869182
2025-10-13 04:02:16,486 - DEBUG - Requesting: http://10.0.0.22:8082/api-access-list/288051fd-0f56-4549-b9c5-715eda987f4f
2025-10-13 04:02:16,494 - DEBUG - Response Code: 404
2025-10-13 04:02:16,494 - INFO - API access-list (288051fd-0f56-4549-b9c5-715eda987f4f) got deleted in api server
2025-10-13 04:02:17,463 - INFO - Deleted project: ctest-TestRbac-53855334, ID : 3334f988-9e72-46cd-a381-9caff84014df
2025-10-13 04:02:18,173 - INFO - Deleted project: ctest-TestRbac-40770353, ID : 4fefebbe-abbd-486e-a771-967bdde83643
2025-10-13 04:02:19,441 - DEBUG - Skipping xmpp flap check
2025-10-13 04:02:19,441 - INFO - END TEST : test_perms2_global_share : PASSED[0:01:12]
2025-10-13 04:02:19,441 - INFO - --------------------------------------------------------------------------------
2025-10-13 04:02:21,504 - INFO - Deleted project: ctest-TestRbac-92605139, ID : d8c2d770-cbc2-423d-ab76-0fb583ebdf0a