2025-08-18 03:06:04,605 - INFO - Domain Default found not creating
2025-08-18 03:06:04,769 - INFO - Project ctest-TestSvcHC-37087753 not found, creating it
2025-08-18 03:06:05,274 - INFO - Created Project:ctest-TestSvcHC-37087753, ID : b35ac86e-18f0-4073-ae73-fb18757a2e35
2025-08-18 03:06:06,998 - INFO - ================================================================================
2025-08-18 03:06:06,998 - INFO - STARTING TEST : test_svc_hc_basic
2025-08-18 03:06:08,262 - DEBUG - Nothing to compare xmpp stats {'10.0.0.241': {'10.20.0.129': '0', '10.20.0.25': '0'}, '10.0.0.41': {'10.20.0.129': '0', '10.20.0.25': '0'}} with
2025-08-18 03:06:08,262 - INFO - Initial checks done. Running the testcase now
2025-08-18 03:06:08,262 - INFO -
2025-08-18 03:06:08,877 - DEBUG - Response for create_network : {'network': {'id': '1a01e239-e335-4631-8cb4-a4a85b1b45af', 'name': 'ctest-mgmt_vn-99902495', 'tenant_id': 'b35ac86e18f04073ae73fb18757a2e35', 'project_id': 'b35ac86e18f04073ae73fb18757a2e35', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-37087753', 'ctest-mgmt_vn-99902495'], 'port_security_enabled': True, 'description': ''}}
2025-08-18 03:06:09,151 - DEBUG - Response for create_subnet : {'subnet': {'id': '15b51e49-0b94-47e1-81a6-05a0eee6c2a8', 'name': '', 'tenant_id': 'b35ac86e18f04073ae73fb18757a2e35', 'network_id': '1a01e239-e335-4631-8cb4-a4a85b1b45af', 'ip_version': 4, 'cidr': '57.81.6.128/26', 'allocation_pools': [{'start': '57.81.6.130', 'end': '57.81.6.190'}], 'gateway_ip': '57.81.6.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '57.81.6.130', 'tags': [], 'project_id': 'b35ac86e18f04073ae73fb18757a2e35'}}
2025-08-18 03:06:09,177 - INFO - Created VN ctest-mgmt_vn-99902495
2025-08-18 03:06:09,188 - DEBUG - VN ctest-mgmt_vn-99902495 UUID is 1a01e239-e335-4631-8cb4-a4a85b1b45af
2025-08-18 03:06:09,268 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-08-18 03:06:09,563 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-08-18 03:06:09,589 - DEBUG - Requesting: http://10.0.0.27:8082/domain/edf943fc-0622-4564-8821-4de9bd04e8a3
2025-08-18 03:06:09,603 - DEBUG - Requesting: http://10.0.0.27:8082/project/b35ac86e-18f0-4073-ae73-fb18757a2e35
2025-08-18 03:06:09,697 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/1a01e239-e335-4631-8cb4-a4a85b1b45af
2025-08-18 03:06:09,714 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/1a01e239-e335-4631-8cb4-a4a85b1b45af
2025-08-18 03:06:09,724 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/1e926519-981f-4d1b-90ab-af09573ff670
2025-08-18 03:06:09,734 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/1e926519-981f-4d1b-90ab-af09573ff670
2025-08-18 03:06:09,740 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/4b49ed83-c2f8-4ad1-9acc-1bf6c61e2dd7
2025-08-18 03:06:09,747 - DEBUG - Route Targets: ['target:64512:8000005']
2025-08-18 03:06:09,747 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/1a01e239-e335-4631-8cb4-a4a85b1b45af
2025-08-18 03:06:09,756 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/1e926519-981f-4d1b-90ab-af09573ff670
2025-08-18 03:06:09,773 - INFO - Verified VN network id 13 for VN 1a01e239-e335-4631-8cb4-a4a85b1b45af
2025-08-18 03:06:09,773 - INFO - Verifications in API Server for VN ctest-mgmt_vn-99902495 passed
2025-08-18 03:06:09,773 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/1a01e239-e335-4631-8cb4-a4a85b1b45af
2025-08-18 03:06:09,783 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/1e926519-981f-4d1b-90ab-af09573ff670
2025-08-18 03:06:09,791 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/1e926519-981f-4d1b-90ab-af09573ff670
2025-08-18 03:06:09,802 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/4b49ed83-c2f8-4ad1-9acc-1bf6c61e2dd7
2025-08-18 03:06:09,814 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-37087753:ctest-mgmt_vn-99902495', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-37087753', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1874027658215769649', 'uuid-lslong': '10138909704107804079'}, 'enable': 'true', 'created': '2025-08-18T03:06:08', 'last-modified': '2025-08-18T03:06:09', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.702043'}
2025-08-18 03:06:09,820 - DEBUG - Route Targets: ['target:64512:8000005']
2025-08-18 03:06:09,826 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-37087753:ctest-mgmt_vn-99902495', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-37087753', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1874027658215769649', 'uuid-lslong': '10138909704107804079'}, 'enable': 'true', 'created': '2025-08-18T03:06:08', 'last-modified': '2025-08-18T03:06:09', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.715785'}
2025-08-18 03:06:09,835 - DEBUG - Route Targets: ['target:64512:8000005']
2025-08-18 03:06:09,842 - DEBUG - Control-node 10.0.0.19 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-37087753:ctest-mgmt_vn-99902495', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-37087753', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1874027658215769649', 'uuid-lslong': '10138909704107804079'}, 'enable': 'true', 'created': '2025-08-18T03:06:08', 'last-modified': '2025-08-18T03:06:09', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.732499'}
2025-08-18 03:06:09,850 - DEBUG - Route Targets: ['target:64512:8000005']
2025-08-18 03:06:09,850 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-99902495 passed
2025-08-18 03:06:09,850 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-99902495 in API_Server ======
2025-08-18 03:06:09,850 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-08-18 03:06:09,856 - DEBUG - Requesting: http://10.0.0.27:8082/domain/edf943fc-0622-4564-8821-4de9bd04e8a3
2025-08-18 03:06:09,869 - DEBUG - Requesting: http://10.0.0.27:8082/project/b35ac86e-18f0-4073-ae73-fb18757a2e35
2025-08-18 03:06:09,967 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/1a01e239-e335-4631-8cb4-a4a85b1b45af
2025-08-18 03:06:09,977 - DEBUG - =>VN ctest-mgmt_vn-99902495 has no policy to be verified
2025-08-18 03:06:09,977 - DEBUG - Verifying the vn in opserver
2025-08-18 03:06:09,977 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-37087753:ctest-mgmt_vn-99902495 virtual network link through opserver 10.0.0.27
2025-08-18 03:06:09,977 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2025-08-18 03:06:10,266 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2025-08-18 03:06:10,321 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-37087753:ctest-mgmt_vn-99902495', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-37087753:ctest-mgmt_vn-99902495?flat'}
2025-08-18 03:06:10,321 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-37087753:ctest-mgmt_vn-99902495 virtual network link through opserver 10.0.0.38
2025-08-18 03:06:10,321 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2025-08-18 03:06:10,612 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2025-08-18 03:06:10,662 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-37087753:ctest-mgmt_vn-99902495', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-37087753:ctest-mgmt_vn-99902495?flat'}
2025-08-18 03:06:10,662 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-37087753:ctest-mgmt_vn-99902495 virtual network link through opserver 10.0.0.19
2025-08-18 03:06:10,662 - DEBUG - Requesting: http://10.0.0.19:8081/analytics/uves/virtual-networks
2025-08-18 03:06:10,950 - DEBUG - Requesting: http://10.0.0.19:8081/analytics/uves/virtual-networks
2025-08-18 03:06:11,001 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-37087753:ctest-mgmt_vn-99902495', 'href': 'http://10.0.0.19:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-37087753:ctest-mgmt_vn-99902495?flat'}
2025-08-18 03:06:11,001 - INFO - Validated that VN default-domain:ctest-TestSvcHC-37087753:ctest-mgmt_vn-99902495 is found in opserver
2025-08-18 03:06:11,024 - DEBUG - Do not have enough data to verify VN in agent
2025-08-18 03:06:11,033 - DEBUG - VRF ids for VN ctest-mgmt_vn-99902495: {}
2025-08-18 03:06:11,278 - DEBUG - Response for create_network : {'network': {'id': 'b39b9ba6-52a3-4450-8486-8c90ad1ea6ed', 'name': 'ctest-left_vn-46118802', 'tenant_id': 'b35ac86e18f04073ae73fb18757a2e35', 'project_id': 'b35ac86e18f04073ae73fb18757a2e35', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-37087753', 'ctest-left_vn-46118802'], 'port_security_enabled': True, 'description': ''}}
2025-08-18 03:06:11,490 - DEBUG - Response for create_subnet : {'subnet': {'id': '560b4e75-5787-4540-a38d-b9037ec4aac6', 'name': '', 'tenant_id': 'b35ac86e18f04073ae73fb18757a2e35', 'network_id': 'b39b9ba6-52a3-4450-8486-8c90ad1ea6ed', 'ip_version': 4, 'cidr': '161.122.207.128/26', 'allocation_pools': [{'start': '161.122.207.130', 'end': '161.122.207.190'}], 'gateway_ip': '161.122.207.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '161.122.207.130', 'tags': [], 'project_id': 'b35ac86e18f04073ae73fb18757a2e35'}}
2025-08-18 03:06:11,509 - INFO - Created VN ctest-left_vn-46118802
2025-08-18 03:06:11,520 - DEBUG - VN ctest-left_vn-46118802 UUID is b39b9ba6-52a3-4450-8486-8c90ad1ea6ed
2025-08-18 03:06:11,583 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-08-18 03:06:11,589 - DEBUG - Requesting: http://10.0.0.27:8082/domain/edf943fc-0622-4564-8821-4de9bd04e8a3
2025-08-18 03:06:11,600 - DEBUG - Requesting: http://10.0.0.27:8082/project/b35ac86e-18f0-4073-ae73-fb18757a2e35
2025-08-18 03:06:11,690 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/b39b9ba6-52a3-4450-8486-8c90ad1ea6ed
2025-08-18 03:06:11,704 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/b39b9ba6-52a3-4450-8486-8c90ad1ea6ed
2025-08-18 03:06:11,714 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/5d343b98-224d-4714-90bd-ae961a2460ab
2025-08-18 03:06:11,722 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/5d343b98-224d-4714-90bd-ae961a2460ab
2025-08-18 03:06:11,728 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/d8fdb624-2f1c-4dd2-91bf-b0070a33ddab
2025-08-18 03:06:11,734 - DEBUG - Route Targets: ['target:64512:8000006']
2025-08-18 03:06:11,735 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/b39b9ba6-52a3-4450-8486-8c90ad1ea6ed
2025-08-18 03:06:11,743 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/5d343b98-224d-4714-90bd-ae961a2460ab
2025-08-18 03:06:11,758 - INFO - Verified VN network id 14 for VN b39b9ba6-52a3-4450-8486-8c90ad1ea6ed
2025-08-18 03:06:11,758 - INFO - Verifications in API Server for VN ctest-left_vn-46118802 passed
2025-08-18 03:06:11,758 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/b39b9ba6-52a3-4450-8486-8c90ad1ea6ed
2025-08-18 03:06:11,767 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/5d343b98-224d-4714-90bd-ae961a2460ab
2025-08-18 03:06:11,774 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/5d343b98-224d-4714-90bd-ae961a2460ab
2025-08-18 03:06:11,781 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/d8fdb624-2f1c-4dd2-91bf-b0070a33ddab
2025-08-18 03:06:11,794 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-37087753:ctest-left_vn-46118802', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-37087753', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12942109092832560208', 'uuid-lslong': '9549474612893361901'}, 'enable': 'true', 'created': '2025-08-18T03:06:11', 'last-modified': '2025-08-18T03:06:11', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.373744'}
2025-08-18 03:06:11,799 - DEBUG - Route Targets: ['target:64512:8000006']
2025-08-18 03:06:11,805 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-37087753:ctest-left_vn-46118802', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-37087753', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12942109092832560208', 'uuid-lslong': '9549474612893361901'}, 'enable': 'true', 'created': '2025-08-18T03:06:11', 'last-modified': '2025-08-18T03:06:11', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.380959'}
2025-08-18 03:06:11,811 - DEBUG - Route Targets: ['target:64512:8000006']
2025-08-18 03:06:11,817 - DEBUG - Control-node 10.0.0.19 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-37087753:ctest-left_vn-46118802', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-37087753', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12942109092832560208', 'uuid-lslong': '9549474612893361901'}, 'enable': 'true', 'created': '2025-08-18T03:06:11', 'last-modified': '2025-08-18T03:06:11', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.393859'}
2025-08-18 03:06:11,822 - DEBUG - Route Targets: ['target:64512:8000006']
2025-08-18 03:06:11,822 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-46118802 passed
2025-08-18 03:06:11,823 - DEBUG - ====Verifying policy data for ctest-left_vn-46118802 in API_Server ======
2025-08-18 03:06:11,823 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-08-18 03:06:11,828 - DEBUG - Requesting: http://10.0.0.27:8082/domain/edf943fc-0622-4564-8821-4de9bd04e8a3
2025-08-18 03:06:11,839 - DEBUG - Requesting: http://10.0.0.27:8082/project/b35ac86e-18f0-4073-ae73-fb18757a2e35
2025-08-18 03:06:11,930 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/b39b9ba6-52a3-4450-8486-8c90ad1ea6ed
2025-08-18 03:06:11,939 - DEBUG - =>VN ctest-left_vn-46118802 has no policy to be verified
2025-08-18 03:06:11,939 - DEBUG - Verifying the vn in opserver
2025-08-18 03:06:11,939 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-37087753:ctest-left_vn-46118802 virtual network link through opserver 10.0.0.27
2025-08-18 03:06:11,939 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2025-08-18 03:06:11,991 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-37087753:ctest-left_vn-46118802', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-37087753:ctest-left_vn-46118802?flat'}
2025-08-18 03:06:11,991 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-37087753:ctest-left_vn-46118802 virtual network link through opserver 10.0.0.38
2025-08-18 03:06:11,991 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2025-08-18 03:06:12,040 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-37087753:ctest-left_vn-46118802', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-37087753:ctest-left_vn-46118802?flat'}
2025-08-18 03:06:12,040 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-37087753:ctest-left_vn-46118802 virtual network link through opserver 10.0.0.19
2025-08-18 03:06:12,040 - DEBUG - Requesting: http://10.0.0.19:8081/analytics/uves/virtual-networks
2025-08-18 03:06:12,096 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-37087753:ctest-left_vn-46118802', 'href': 'http://10.0.0.19:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-37087753:ctest-left_vn-46118802?flat'}
2025-08-18 03:06:12,096 - INFO - Validated that VN default-domain:ctest-TestSvcHC-37087753:ctest-left_vn-46118802 is found in opserver
2025-08-18 03:06:12,119 - DEBUG - Do not have enough data to verify VN in agent
2025-08-18 03:06:12,131 - DEBUG - VRF ids for VN ctest-left_vn-46118802: {}
2025-08-18 03:06:12,371 - DEBUG - Response for create_network : {'network': {'id': '55a9e7ab-3965-4be9-9087-a63781911a12', 'name': 'ctest-right_vn-29014911', 'tenant_id': 'b35ac86e18f04073ae73fb18757a2e35', 'project_id': 'b35ac86e18f04073ae73fb18757a2e35', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-37087753', 'ctest-right_vn-29014911'], 'port_security_enabled': True, 'description': ''}}
2025-08-18 03:06:12,596 - DEBUG - Response for create_subnet : {'subnet': {'id': '483a9d0e-7d49-45e1-b4df-47c42d3029a8', 'name': '', 'tenant_id': 'b35ac86e18f04073ae73fb18757a2e35', 'network_id': '55a9e7ab-3965-4be9-9087-a63781911a12', 'ip_version': 4, 'cidr': '7.33.206.192/26', 'allocation_pools': [{'start': '7.33.206.194', 'end': '7.33.206.254'}], 'gateway_ip': '7.33.206.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '7.33.206.194', 'tags': [], 'project_id': 'b35ac86e18f04073ae73fb18757a2e35'}}
2025-08-18 03:06:12,616 - INFO - Created VN ctest-right_vn-29014911
2025-08-18 03:06:12,629 - DEBUG - VN ctest-right_vn-29014911 UUID is 55a9e7ab-3965-4be9-9087-a63781911a12
2025-08-18 03:06:12,693 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-08-18 03:06:12,700 - DEBUG - Requesting: http://10.0.0.27:8082/domain/edf943fc-0622-4564-8821-4de9bd04e8a3
2025-08-18 03:06:12,712 - DEBUG - Requesting: http://10.0.0.27:8082/project/b35ac86e-18f0-4073-ae73-fb18757a2e35
2025-08-18 03:06:12,795 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/55a9e7ab-3965-4be9-9087-a63781911a12
2025-08-18 03:06:12,809 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/55a9e7ab-3965-4be9-9087-a63781911a12
2025-08-18 03:06:12,818 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/84e8fc7a-7147-4caa-ac5a-a96b1aefac7b
2025-08-18 03:06:12,825 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/84e8fc7a-7147-4caa-ac5a-a96b1aefac7b
2025-08-18 03:06:12,831 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/ac8134de-d113-4631-b146-c73181b598e3
2025-08-18 03:06:12,838 - DEBUG - Route Targets: ['target:64512:8000007']
2025-08-18 03:06:12,838 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/55a9e7ab-3965-4be9-9087-a63781911a12
2025-08-18 03:06:12,847 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/84e8fc7a-7147-4caa-ac5a-a96b1aefac7b
2025-08-18 03:06:12,862 - INFO - Verified VN network id 15 for VN 55a9e7ab-3965-4be9-9087-a63781911a12
2025-08-18 03:06:12,862 - INFO - Verifications in API Server for VN ctest-right_vn-29014911 passed
2025-08-18 03:06:12,862 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/55a9e7ab-3965-4be9-9087-a63781911a12
2025-08-18 03:06:12,871 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/84e8fc7a-7147-4caa-ac5a-a96b1aefac7b
2025-08-18 03:06:12,878 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/84e8fc7a-7147-4caa-ac5a-a96b1aefac7b
2025-08-18 03:06:12,884 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/ac8134de-d113-4631-b146-c73181b598e3
2025-08-18 03:06:12,896 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-37087753:ctest-right_vn-29014911', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-37087753', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6172719486876339177', 'uuid-lslong': '10414475420644743698'}, 'enable': 'true', 'created': '2025-08-18T03:06:12', 'last-modified': '2025-08-18T03:06:12', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.364812'}
2025-08-18 03:06:12,903 - DEBUG - Route Targets: ['target:64512:8000007']
2025-08-18 03:06:12,908 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-37087753:ctest-right_vn-29014911', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-37087753', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6172719486876339177', 'uuid-lslong': '10414475420644743698'}, 'enable': 'true', 'created': '2025-08-18T03:06:12', 'last-modified': '2025-08-18T03:06:12', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.377606'}
2025-08-18 03:06:12,915 - DEBUG - Route Targets: ['target:64512:8000007']
2025-08-18 03:06:12,920 - DEBUG - Control-node 10.0.0.19 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-37087753:ctest-right_vn-29014911', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-37087753', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6172719486876339177', 'uuid-lslong': '10414475420644743698'}, 'enable': 'true', 'created': '2025-08-18T03:06:12', 'last-modified': '2025-08-18T03:06:12', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.394339'}
2025-08-18 03:06:12,926 - DEBUG - Route Targets: ['target:64512:8000007']
2025-08-18 03:06:12,926 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-29014911 passed
2025-08-18 03:06:12,926 - DEBUG - ====Verifying policy data for ctest-right_vn-29014911 in API_Server ======
2025-08-18 03:06:12,926 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-08-18 03:06:12,932 - DEBUG - Requesting: http://10.0.0.27:8082/domain/edf943fc-0622-4564-8821-4de9bd04e8a3
2025-08-18 03:06:12,943 - DEBUG - Requesting: http://10.0.0.27:8082/project/b35ac86e-18f0-4073-ae73-fb18757a2e35
2025-08-18 03:06:13,035 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/55a9e7ab-3965-4be9-9087-a63781911a12
2025-08-18 03:06:13,050 - DEBUG - =>VN ctest-right_vn-29014911 has no policy to be verified
2025-08-18 03:06:13,050 - DEBUG - Verifying the vn in opserver
2025-08-18 03:06:13,050 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-37087753:ctest-right_vn-29014911 virtual network link through opserver 10.0.0.27
2025-08-18 03:06:13,050 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2025-08-18 03:06:13,105 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-37087753:ctest-right_vn-29014911', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-37087753:ctest-right_vn-29014911?flat'}
2025-08-18 03:06:13,105 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-37087753:ctest-right_vn-29014911 virtual network link through opserver 10.0.0.38
2025-08-18 03:06:13,105 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2025-08-18 03:06:13,156 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-37087753:ctest-right_vn-29014911', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-37087753:ctest-right_vn-29014911?flat'}
2025-08-18 03:06:13,156 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-37087753:ctest-right_vn-29014911 virtual network link through opserver 10.0.0.19
2025-08-18 03:06:13,156 - DEBUG - Requesting: http://10.0.0.19:8081/analytics/uves/virtual-networks
2025-08-18 03:06:13,206 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-37087753:ctest-right_vn-29014911', 'href': 'http://10.0.0.19:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-37087753:ctest-right_vn-29014911?flat'}
2025-08-18 03:06:13,206 - INFO - Validated that VN default-domain:ctest-TestSvcHC-37087753:ctest-right_vn-29014911 is found in opserver
2025-08-18 03:06:13,229 - DEBUG - Do not have enough data to verify VN in agent
2025-08-18 03:06:13,239 - DEBUG - VRF ids for VN ctest-right_vn-29014911: {}
2025-08-18 03:06:13,289 - DEBUG - Services list from nova: [, , , ]
2025-08-18 03:06:14,456 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-3870-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-3870-1)
2025-08-18 03:06:15,768 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-3870-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-3870-2)
2025-08-18 03:06:15,769 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-34953797']
2025-08-18 03:06:16,064 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-34953797'] created succesfully
2025-08-18 03:06:16,491 - DEBUG - Image by name tiny_nat_fw not found
2025-08-18 03:06:16,491 - DEBUG - Installing image tiny_nat_fw
2025-08-18 03:06:16,491 - DEBUG - Image info {'name': 'tinycore-in-network-nat.qcow2.gz', 'webserver': '', 'location': '/images/tinycore/', 'username': 'tc', 'password': 'secret', 'type': 'os', 'flavor': 'contrail_flavor_tiny', 'params': '--container-format bare --disk-format vmdk --property vmware_disktype="sparse" --property vmware_adaptertype="ide" --property hypervisor_type=qemu', 'name_docker': 'phusion-baseimage-enablesshd', 'vmdk': 'service_chain_images/nat_service/tiny_nat_fw/tinycore-in-network-nat-flat.vmdk', 'shrinked_vmdk': "'no'"}
2025-08-18 03:06:16,491 - DEBUG - Image build path file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2025-08-18 03:06:16,492 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2025-08-18 03:06:16,492 - DEBUG - Unzip image
2025-08-18 03:06:16,492 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2025-08-18 03:06:16,508 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2025-08-18 03:06:16,508 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-34953797']
2025-08-18 03:06:16,642 - INFO - Service template: ['default-domain', 'ctest-service_template_1-34953797'] deleted successfully.
2025-08-18 03:06:16,642 - INFO - Skip interface_detach for VM ctest-right_vm-22840379 in state BUILD
2025-08-18 03:06:16,642 - INFO - Deleting VM ctest-right_vm-22840379
2025-08-18 03:06:16,665 - ERROR - VM ctest-right_vm-22840379 has failed to come up
2025-08-18 03:06:16,666 - ERROR - Nova failed to get host of the VM
2025-08-18 03:06:16,666 - ERROR - VM ctest-right_vm-22840379 has failed to come up
2025-08-18 03:06:16,666 - ERROR - Nova failed to get host of the VM
2025-08-18 03:06:16,725 - INFO - Skip interface_detach for VM ctest-left_vm-97542702 in state BUILD
2025-08-18 03:06:16,725 - INFO - Deleting VM ctest-left_vm-97542702
2025-08-18 03:06:16,725 - ERROR - VM ctest-left_vm-97542702 has failed to come up
2025-08-18 03:06:16,725 - ERROR - Nova failed to get host of the VM
2025-08-18 03:06:16,725 - ERROR - VM ctest-left_vm-97542702 has failed to come up
2025-08-18 03:06:16,725 - ERROR - Nova failed to get host of the VM
2025-08-18 03:06:16,784 - INFO - Deleting VN ctest-right_vn-29014911
2025-08-18 03:06:16,820 - DEBUG - VN 55a9e7ab-3965-4be9-9087-a63781911a12 still in use: Unable to complete operation on network 55a9e7ab-3965-4be9-9087-a63781911a12. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-8bdbb045-0afd-4cc7-8ea1-eaa3ac53635d']
2025-08-18 03:06:16,821 - WARNING - Deleting VN ctest-right_vn-29014911 failed..Will retry
2025-08-18 03:06:18,974 - DEBUG - Response for deleting network ()
2025-08-18 03:06:18,974 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/84e8fc7a-7147-4caa-ac5a-a96b1aefac7b
2025-08-18 03:06:18,980 - DEBUG - Response Code: 404
2025-08-18 03:06:18,980 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-08-18 03:06:18,986 - DEBUG - Requesting: http://10.0.0.27:8082/domain/edf943fc-0622-4564-8821-4de9bd04e8a3
2025-08-18 03:06:19,014 - DEBUG - Requesting: http://10.0.0.27:8082/project/b35ac86e-18f0-4073-ae73-fb18757a2e35
2025-08-18 03:06:19,113 - INFO - Validated that VN ctest-right_vn-29014911 is not found in API Server
2025-08-18 03:06:19,126 - DEBUG - VN ctest-right_vn-29014911 is not present in Agent 10.0.0.241
2025-08-18 03:06:19,138 - DEBUG - VN ctest-right_vn-29014911 is not present in Agent 10.0.0.41
2025-08-18 03:06:19,138 - INFO - Validated that VN ctest-right_vn-29014911 is not in any agent
2025-08-18 03:06:19,172 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-29014911 info
2025-08-18 03:06:19,172 - INFO - Deleting VN ctest-left_vn-46118802
2025-08-18 03:06:19,328 - DEBUG - Response for deleting network ()
2025-08-18 03:06:19,328 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/5d343b98-224d-4714-90bd-ae961a2460ab
2025-08-18 03:06:19,334 - DEBUG - Response Code: 404
2025-08-18 03:06:19,334 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-08-18 03:06:19,345 - DEBUG - Requesting: http://10.0.0.27:8082/domain/edf943fc-0622-4564-8821-4de9bd04e8a3
2025-08-18 03:06:19,359 - DEBUG - Requesting: http://10.0.0.27:8082/project/b35ac86e-18f0-4073-ae73-fb18757a2e35
2025-08-18 03:06:19,457 - INFO - Validated that VN ctest-left_vn-46118802 is not found in API Server
2025-08-18 03:06:19,470 - DEBUG - VN ctest-left_vn-46118802 is not present in Agent 10.0.0.241
2025-08-18 03:06:19,480 - DEBUG - VN ctest-left_vn-46118802 is not present in Agent 10.0.0.41
2025-08-18 03:06:19,480 - INFO - Validated that VN ctest-left_vn-46118802 is not in any agent
2025-08-18 03:06:19,513 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-46118802 info
2025-08-18 03:06:19,513 - INFO - Deleting VN ctest-mgmt_vn-99902495
2025-08-18 03:06:19,663 - DEBUG - Response for deleting network ()
2025-08-18 03:06:19,663 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/1e926519-981f-4d1b-90ab-af09573ff670
2025-08-18 03:06:19,668 - DEBUG - Response Code: 404
2025-08-18 03:06:19,668 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-08-18 03:06:19,675 - DEBUG - Requesting: http://10.0.0.27:8082/domain/edf943fc-0622-4564-8821-4de9bd04e8a3
2025-08-18 03:06:19,748 - DEBUG - Requesting: http://10.0.0.27:8082/project/b35ac86e-18f0-4073-ae73-fb18757a2e35
2025-08-18 03:06:19,831 - INFO - Validated that VN ctest-mgmt_vn-99902495 is not found in API Server
2025-08-18 03:06:19,844 - DEBUG - VN ctest-mgmt_vn-99902495 is not present in Agent 10.0.0.241
2025-08-18 03:06:19,855 - DEBUG - VN ctest-mgmt_vn-99902495 is not present in Agent 10.0.0.41
2025-08-18 03:06:19,855 - INFO - Validated that VN ctest-mgmt_vn-99902495 is not in any agent
2025-08-18 03:06:19,889 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-99902495 info
2025-08-18 03:06:21,159 - DEBUG - No XMPP flaps were noticed during the test
2025-08-18 03:06:21,159 - INFO -
2025-08-18 03:06:21,159 - INFO - END TEST : test_svc_hc_basic : SKIPPED[0:00:15]
2025-08-18 03:06:21,160 - INFO - --------------------------------------------------------------------------------
2025-08-18 03:06:21,167 - INFO - ================================================================================
2025-08-18 03:06:21,167 - INFO - STARTING TEST : test_svc_trans_segment_right_hc_fail_svm
2025-08-18 03:06:22,445 - DEBUG - Nothing to compare xmpp stats {'10.0.0.241': {'10.20.0.129': '0', '10.20.0.25': '0'}, '10.0.0.41': {'10.20.0.129': '0', '10.20.0.25': '0'}} with
2025-08-18 03:06:22,445 - INFO - Initial checks done. Running the testcase now
2025-08-18 03:06:22,445 - INFO -
2025-08-18 03:06:22,717 - DEBUG - Response for create_network : {'network': {'id': '9488997f-585e-47d0-be7c-1221795f856f', 'name': 'ctest-mgmt_vn-94500343', 'tenant_id': 'b35ac86e18f04073ae73fb18757a2e35', 'project_id': 'b35ac86e18f04073ae73fb18757a2e35', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-37087753', 'ctest-mgmt_vn-94500343'], 'port_security_enabled': True, 'description': ''}}
2025-08-18 03:06:22,951 - DEBUG - Response for create_subnet : {'subnet': {'id': '7141a3e8-e0ea-42a3-8647-459fa030aaf9', 'name': '', 'tenant_id': 'b35ac86e18f04073ae73fb18757a2e35', 'network_id': '9488997f-585e-47d0-be7c-1221795f856f', 'ip_version': 4, 'cidr': '179.108.196.64/26', 'allocation_pools': [{'start': '179.108.196.66', 'end': '179.108.196.126'}], 'gateway_ip': '179.108.196.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '179.108.196.66', 'tags': [], 'project_id': 'b35ac86e18f04073ae73fb18757a2e35'}}
2025-08-18 03:06:22,979 - INFO - Created VN ctest-mgmt_vn-94500343
2025-08-18 03:06:22,999 - DEBUG - VN ctest-mgmt_vn-94500343 UUID is 9488997f-585e-47d0-be7c-1221795f856f
2025-08-18 03:06:23,086 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-08-18 03:06:23,096 - DEBUG - Requesting: http://10.0.0.27:8082/domain/edf943fc-0622-4564-8821-4de9bd04e8a3
2025-08-18 03:06:23,111 - DEBUG - Requesting: http://10.0.0.27:8082/project/b35ac86e-18f0-4073-ae73-fb18757a2e35
2025-08-18 03:06:23,229 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/9488997f-585e-47d0-be7c-1221795f856f
2025-08-18 03:06:23,245 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/9488997f-585e-47d0-be7c-1221795f856f
2025-08-18 03:06:23,258 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/0c62d1bc-04af-4faf-a7a7-ba179e7f28f7
2025-08-18 03:06:23,269 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/0c62d1bc-04af-4faf-a7a7-ba179e7f28f7
2025-08-18 03:06:23,280 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/c3e48b36-79f8-46b6-8c03-f42c6225f72a
2025-08-18 03:06:23,291 - DEBUG - Route Targets: ['target:64512:8000005']
2025-08-18 03:06:23,291 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/9488997f-585e-47d0-be7c-1221795f856f
2025-08-18 03:06:23,305 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/0c62d1bc-04af-4faf-a7a7-ba179e7f28f7
2025-08-18 03:06:23,327 - INFO - Verified VN network id 13 for VN 9488997f-585e-47d0-be7c-1221795f856f
2025-08-18 03:06:23,327 - INFO - Verifications in API Server for VN ctest-mgmt_vn-94500343 passed
2025-08-18 03:06:23,327 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/9488997f-585e-47d0-be7c-1221795f856f
2025-08-18 03:06:23,340 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/0c62d1bc-04af-4faf-a7a7-ba179e7f28f7
2025-08-18 03:06:23,351 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/0c62d1bc-04af-4faf-a7a7-ba179e7f28f7
2025-08-18 03:06:23,361 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/c3e48b36-79f8-46b6-8c03-f42c6225f72a
2025-08-18 03:06:23,376 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-37087753:ctest-mgmt_vn-94500343', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-37087753', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10702973286668453840', 'uuid-lslong': '13725865699297953135'}, 'enable': 'true', 'created': '2025-08-18T03:06:22', 'last-modified': '2025-08-18T03:06:22', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.496919'}
2025-08-18 03:06:23,384 - DEBUG - Route Targets: ['target:64512:8000005']
2025-08-18 03:06:23,391 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-37087753:ctest-mgmt_vn-94500343', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-37087753', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10702973286668453840', 'uuid-lslong': '13725865699297953135'}, 'enable': 'true', 'created': '2025-08-18T03:06:22', 'last-modified': '2025-08-18T03:06:22', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.519776'}
2025-08-18 03:06:23,398 - DEBUG - Route Targets: ['target:64512:8000005']
2025-08-18 03:06:23,405 - DEBUG - Control-node 10.0.0.19 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-37087753:ctest-mgmt_vn-94500343', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-37087753', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10702973286668453840', 'uuid-lslong': '13725865699297953135'}, 'enable': 'true', 'created': '2025-08-18T03:06:22', 'last-modified': '2025-08-18T03:06:22', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.534210'}
2025-08-18 03:06:23,411 - DEBUG - Route Targets: ['target:64512:8000005']
2025-08-18 03:06:23,412 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-94500343 passed
2025-08-18 03:06:23,412 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-94500343 in API_Server ======
2025-08-18 03:06:23,412 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-08-18 03:06:23,420 - DEBUG - Requesting: http://10.0.0.27:8082/domain/edf943fc-0622-4564-8821-4de9bd04e8a3
2025-08-18 03:06:23,436 - DEBUG - Requesting: http://10.0.0.27:8082/project/b35ac86e-18f0-4073-ae73-fb18757a2e35
2025-08-18 03:06:23,530 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/9488997f-585e-47d0-be7c-1221795f856f
2025-08-18 03:06:23,544 - DEBUG - =>VN ctest-mgmt_vn-94500343 has no policy to be verified
2025-08-18 03:06:23,545 - DEBUG - Verifying the vn in opserver
2025-08-18 03:06:23,545 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-37087753:ctest-mgmt_vn-94500343 virtual network link through opserver 10.0.0.27
2025-08-18 03:06:23,545 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2025-08-18 03:06:23,561 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-37087753:ctest-mgmt_vn-94500343', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-37087753:ctest-mgmt_vn-94500343?flat'}
2025-08-18 03:06:23,561 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-37087753:ctest-mgmt_vn-94500343 virtual network link through opserver 10.0.0.38
2025-08-18 03:06:23,561 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2025-08-18 03:06:23,574 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-37087753:ctest-mgmt_vn-94500343', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-37087753:ctest-mgmt_vn-94500343?flat'}
2025-08-18 03:06:23,574 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-37087753:ctest-mgmt_vn-94500343 virtual network link through opserver 10.0.0.19
2025-08-18 03:06:23,574 - DEBUG - Requesting: http://10.0.0.19:8081/analytics/uves/virtual-networks
2025-08-18 03:06:23,587 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-37087753:ctest-mgmt_vn-94500343', 'href': 'http://10.0.0.19:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-37087753:ctest-mgmt_vn-94500343?flat'}
2025-08-18 03:06:23,587 - INFO - Validated that VN default-domain:ctest-TestSvcHC-37087753:ctest-mgmt_vn-94500343 is found in opserver
2025-08-18 03:06:23,613 - DEBUG - Do not have enough data to verify VN in agent
2025-08-18 03:06:23,625 - DEBUG - VRF ids for VN ctest-mgmt_vn-94500343: {}
2025-08-18 03:06:23,985 - DEBUG - Response for create_network : {'network': {'id': '9e0188a3-16c1-4ca8-8784-86f0420da7b4', 'name': 'ctest-left_vn-73135865', 'tenant_id': 'b35ac86e18f04073ae73fb18757a2e35', 'project_id': 'b35ac86e18f04073ae73fb18757a2e35', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-37087753', 'ctest-left_vn-73135865'], 'port_security_enabled': True, 'description': ''}}
2025-08-18 03:06:24,171 - DEBUG - Response for create_subnet : {'subnet': {'id': 'bbf38b58-6422-4ab6-b3f2-134c880a83eb', 'name': '', 'tenant_id': 'b35ac86e18f04073ae73fb18757a2e35', 'network_id': '9e0188a3-16c1-4ca8-8784-86f0420da7b4', 'ip_version': 4, 'cidr': '25.80.253.64/26', 'allocation_pools': [{'start': '25.80.253.66', 'end': '25.80.253.126'}], 'gateway_ip': '25.80.253.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '25.80.253.66', 'tags': [], 'project_id': 'b35ac86e18f04073ae73fb18757a2e35'}}
2025-08-18 03:06:24,206 - INFO - Created VN ctest-left_vn-73135865
2025-08-18 03:06:24,221 - DEBUG - VN ctest-left_vn-73135865 UUID is 9e0188a3-16c1-4ca8-8784-86f0420da7b4
2025-08-18 03:06:24,302 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-08-18 03:06:24,310 - DEBUG - Requesting: http://10.0.0.27:8082/domain/edf943fc-0622-4564-8821-4de9bd04e8a3
2025-08-18 03:06:24,325 - DEBUG - Requesting: http://10.0.0.27:8082/project/b35ac86e-18f0-4073-ae73-fb18757a2e35
2025-08-18 03:06:24,423 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/9e0188a3-16c1-4ca8-8784-86f0420da7b4
2025-08-18 03:06:24,448 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/9e0188a3-16c1-4ca8-8784-86f0420da7b4
2025-08-18 03:06:24,469 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/7be2409e-61af-4c79-84b4-957811782669
2025-08-18 03:06:24,482 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/7be2409e-61af-4c79-84b4-957811782669
2025-08-18 03:06:24,492 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/d4dce75c-4188-41df-b931-a8aca46e0378
2025-08-18 03:06:24,502 - DEBUG - Route Targets: ['target:64512:8000006']
2025-08-18 03:06:24,502 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/9e0188a3-16c1-4ca8-8784-86f0420da7b4
2025-08-18 03:06:24,514 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/7be2409e-61af-4c79-84b4-957811782669
2025-08-18 03:06:24,532 - INFO - Verified VN network id 14 for VN 9e0188a3-16c1-4ca8-8784-86f0420da7b4
2025-08-18 03:06:24,532 - INFO - Verifications in API Server for VN ctest-left_vn-73135865 passed
2025-08-18 03:06:24,533 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/9e0188a3-16c1-4ca8-8784-86f0420da7b4
2025-08-18 03:06:24,550 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/7be2409e-61af-4c79-84b4-957811782669
2025-08-18 03:06:24,558 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/7be2409e-61af-4c79-84b4-957811782669
2025-08-18 03:06:24,575 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/d4dce75c-4188-41df-b931-a8aca46e0378
2025-08-18 03:06:24,593 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-37087753:ctest-left_vn-73135865', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-37087753', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11385531567012138152', 'uuid-lslong': '9765078258504542132'}, 'enable': 'true', 'created': '2025-08-18T03:06:23', 'last-modified': '2025-08-18T03:06:24', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.468678'}
2025-08-18 03:06:24,600 - DEBUG - Route Targets: ['target:64512:8000006']
2025-08-18 03:06:24,606 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-37087753:ctest-left_vn-73135865', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-37087753', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11385531567012138152', 'uuid-lslong': '9765078258504542132'}, 'enable': 'true', 'created': '2025-08-18T03:06:23', 'last-modified': '2025-08-18T03:06:24', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.485530'}
2025-08-18 03:06:24,613 - DEBUG - Route Targets: ['target:64512:8000006']
2025-08-18 03:06:24,618 - DEBUG - Control-node 10.0.0.19 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-37087753:ctest-left_vn-73135865', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-37087753', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11385531567012138152', 'uuid-lslong': '9765078258504542132'}, 'enable': 'true', 'created': '2025-08-18T03:06:23', 'last-modified': '2025-08-18T03:06:24', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.496890'}
2025-08-18 03:06:24,625 - DEBUG - Route Targets: ['target:64512:8000006']
2025-08-18 03:06:24,625 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-73135865 passed
2025-08-18 03:06:24,625 - DEBUG - ====Verifying policy data for ctest-left_vn-73135865 in API_Server ======
2025-08-18 03:06:24,625 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-08-18 03:06:24,632 - DEBUG - Requesting: http://10.0.0.27:8082/domain/edf943fc-0622-4564-8821-4de9bd04e8a3
2025-08-18 03:06:24,648 - DEBUG - Requesting: http://10.0.0.27:8082/project/b35ac86e-18f0-4073-ae73-fb18757a2e35
2025-08-18 03:06:24,759 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/9e0188a3-16c1-4ca8-8784-86f0420da7b4
2025-08-18 03:06:24,773 - DEBUG - =>VN ctest-left_vn-73135865 has no policy to be verified
2025-08-18 03:06:24,773 - DEBUG - Verifying the vn in opserver
2025-08-18 03:06:24,774 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-37087753:ctest-left_vn-73135865 virtual network link through opserver 10.0.0.27
2025-08-18 03:06:24,774 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2025-08-18 03:06:24,786 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-37087753:ctest-left_vn-73135865', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-37087753:ctest-left_vn-73135865?flat'}
2025-08-18 03:06:24,786 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-37087753:ctest-left_vn-73135865 virtual network link through opserver 10.0.0.38
2025-08-18 03:06:24,786 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2025-08-18 03:06:24,806 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-37087753:ctest-left_vn-73135865', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-37087753:ctest-left_vn-73135865?flat'}
2025-08-18 03:06:24,806 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-37087753:ctest-left_vn-73135865 virtual network link through opserver 10.0.0.19
2025-08-18 03:06:24,806 - DEBUG - Requesting: http://10.0.0.19:8081/analytics/uves/virtual-networks
2025-08-18 03:06:24,819 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-37087753:ctest-left_vn-73135865', 'href': 'http://10.0.0.19:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-37087753:ctest-left_vn-73135865?flat'}
2025-08-18 03:06:24,819 - INFO - Validated that VN default-domain:ctest-TestSvcHC-37087753:ctest-left_vn-73135865 is found in opserver
2025-08-18 03:06:24,849 - DEBUG - Do not have enough data to verify VN in agent
2025-08-18 03:06:24,863 - DEBUG - VRF ids for VN ctest-left_vn-73135865: {}
2025-08-18 03:06:25,131 - DEBUG - Response for create_network : {'network': {'id': '61f86f78-dba1-4477-ae00-68164b50dc5f', 'name': 'ctest-right_vn-00762577', 'tenant_id': 'b35ac86e18f04073ae73fb18757a2e35', 'project_id': 'b35ac86e18f04073ae73fb18757a2e35', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-37087753', 'ctest-right_vn-00762577'], 'port_security_enabled': True, 'description': ''}}
2025-08-18 03:06:25,406 - DEBUG - Response for create_subnet : {'subnet': {'id': '8ac9fdf8-fb5c-4eb0-a598-8fb731c915c8', 'name': '', 'tenant_id': 'b35ac86e18f04073ae73fb18757a2e35', 'network_id': '61f86f78-dba1-4477-ae00-68164b50dc5f', 'ip_version': 4, 'cidr': '77.49.127.64/26', 'allocation_pools': [{'start': '77.49.127.66', 'end': '77.49.127.126'}], 'gateway_ip': '77.49.127.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '77.49.127.66', 'tags': [], 'project_id': 'b35ac86e18f04073ae73fb18757a2e35'}}
2025-08-18 03:06:25,436 - INFO - Created VN ctest-right_vn-00762577
2025-08-18 03:06:25,451 - DEBUG - VN ctest-right_vn-00762577 UUID is 61f86f78-dba1-4477-ae00-68164b50dc5f
2025-08-18 03:06:25,537 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-08-18 03:06:25,545 - DEBUG - Requesting: http://10.0.0.27:8082/domain/edf943fc-0622-4564-8821-4de9bd04e8a3
2025-08-18 03:06:25,561 - DEBUG - Requesting: http://10.0.0.27:8082/project/b35ac86e-18f0-4073-ae73-fb18757a2e35
2025-08-18 03:06:25,678 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/61f86f78-dba1-4477-ae00-68164b50dc5f
2025-08-18 03:06:25,693 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/61f86f78-dba1-4477-ae00-68164b50dc5f
2025-08-18 03:06:25,703 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/1910c9e2-eeab-4b0a-b958-328797dee253
2025-08-18 03:06:25,711 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/1910c9e2-eeab-4b0a-b958-328797dee253
2025-08-18 03:06:25,719 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/5ed7f15a-3071-48f2-a6dc-cc3df1fca735
2025-08-18 03:06:25,726 - DEBUG - Route Targets: ['target:64512:8000007']
2025-08-18 03:06:25,726 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/61f86f78-dba1-4477-ae00-68164b50dc5f
2025-08-18 03:06:25,735 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/1910c9e2-eeab-4b0a-b958-328797dee253
2025-08-18 03:06:25,751 - INFO - Verified VN network id 15 for VN 61f86f78-dba1-4477-ae00-68164b50dc5f
2025-08-18 03:06:25,751 - INFO - Verifications in API Server for VN ctest-right_vn-00762577 passed
2025-08-18 03:06:25,752 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/61f86f78-dba1-4477-ae00-68164b50dc5f
2025-08-18 03:06:25,763 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/1910c9e2-eeab-4b0a-b958-328797dee253
2025-08-18 03:06:25,771 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/1910c9e2-eeab-4b0a-b958-328797dee253
2025-08-18 03:06:25,778 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/5ed7f15a-3071-48f2-a6dc-cc3df1fca735
2025-08-18 03:06:25,790 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-37087753:ctest-right_vn-00762577', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-37087753', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7059514980774790263', 'uuid-lslong': '12538135807561620575'}, 'enable': 'true', 'created': '2025-08-18T03:06:25', 'last-modified': '2025-08-18T03:06:25', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.439930'}
2025-08-18 03:06:25,796 - DEBUG - Route Targets: ['target:64512:8000007']
2025-08-18 03:06:25,802 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-37087753:ctest-right_vn-00762577', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-37087753', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7059514980774790263', 'uuid-lslong': '12538135807561620575'}, 'enable': 'true', 'created': '2025-08-18T03:06:25', 'last-modified': '2025-08-18T03:06:25', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.456161'}
2025-08-18 03:06:25,808 - DEBUG - Route Targets: ['target:64512:8000007']
2025-08-18 03:06:25,814 - DEBUG - Control-node 10.0.0.19 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-37087753:ctest-right_vn-00762577', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-37087753', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7059514980774790263', 'uuid-lslong': '12538135807561620575'}, 'enable': 'true', 'created': '2025-08-18T03:06:25', 'last-modified': '2025-08-18T03:06:25', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.469486'}
2025-08-18 03:06:25,820 - DEBUG - Route Targets: ['target:64512:8000007']
2025-08-18 03:06:25,820 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-00762577 passed
2025-08-18 03:06:25,820 - DEBUG - ====Verifying policy data for ctest-right_vn-00762577 in API_Server ======
2025-08-18 03:06:25,820 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-08-18 03:06:25,827 - DEBUG - Requesting: http://10.0.0.27:8082/domain/edf943fc-0622-4564-8821-4de9bd04e8a3
2025-08-18 03:06:25,840 - DEBUG - Requesting: http://10.0.0.27:8082/project/b35ac86e-18f0-4073-ae73-fb18757a2e35
2025-08-18 03:06:25,935 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/61f86f78-dba1-4477-ae00-68164b50dc5f
2025-08-18 03:06:25,947 - DEBUG - =>VN ctest-right_vn-00762577 has no policy to be verified
2025-08-18 03:06:25,947 - DEBUG - Verifying the vn in opserver
2025-08-18 03:06:25,947 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-37087753:ctest-right_vn-00762577 virtual network link through opserver 10.0.0.27
2025-08-18 03:06:25,947 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2025-08-18 03:06:25,960 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-37087753:ctest-right_vn-00762577', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-37087753:ctest-right_vn-00762577?flat'}
2025-08-18 03:06:25,960 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-37087753:ctest-right_vn-00762577 virtual network link through opserver 10.0.0.38
2025-08-18 03:06:25,960 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2025-08-18 03:06:25,973 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-37087753:ctest-right_vn-00762577', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-37087753:ctest-right_vn-00762577?flat'}
2025-08-18 03:06:25,973 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-37087753:ctest-right_vn-00762577 virtual network link through opserver 10.0.0.19
2025-08-18 03:06:25,973 - DEBUG - Requesting: http://10.0.0.19:8081/analytics/uves/virtual-networks
2025-08-18 03:06:25,984 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-37087753:ctest-right_vn-00762577', 'href': 'http://10.0.0.19:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-37087753:ctest-right_vn-00762577?flat'}
2025-08-18 03:06:25,984 - INFO - Validated that VN default-domain:ctest-TestSvcHC-37087753:ctest-right_vn-00762577 is found in opserver
2025-08-18 03:06:26,008 - DEBUG - Do not have enough data to verify VN in agent
2025-08-18 03:06:26,020 - DEBUG - VRF ids for VN ctest-right_vn-00762577: {}
2025-08-18 03:06:26,244 - DEBUG - Response for create_network : {'network': {'id': '1bf4268a-9eab-47e3-a882-fb0e9c3a5fea', 'name': 'ctest-trans_left_vn-32610126', 'tenant_id': 'b35ac86e18f04073ae73fb18757a2e35', 'project_id': 'b35ac86e18f04073ae73fb18757a2e35', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-37087753', 'ctest-trans_left_vn-32610126'], 'port_security_enabled': True, 'description': ''}}
2025-08-18 03:06:26,471 - DEBUG - Response for create_subnet : {'subnet': {'id': '59c70683-bc23-45e2-a399-b73c65d4141f', 'name': '', 'tenant_id': 'b35ac86e18f04073ae73fb18757a2e35', 'network_id': '1bf4268a-9eab-47e3-a882-fb0e9c3a5fea', 'ip_version': 4, 'cidr': '150.180.139.0/26', 'allocation_pools': [{'start': '150.180.139.2', 'end': '150.180.139.62'}], 'gateway_ip': '150.180.139.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '150.180.139.2', 'tags': [], 'project_id': 'b35ac86e18f04073ae73fb18757a2e35'}}
2025-08-18 03:06:26,492 - INFO - Created VN ctest-trans_left_vn-32610126
2025-08-18 03:06:26,505 - DEBUG - VN ctest-trans_left_vn-32610126 UUID is 1bf4268a-9eab-47e3-a882-fb0e9c3a5fea
2025-08-18 03:06:26,565 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-08-18 03:06:26,574 - DEBUG - Requesting: http://10.0.0.27:8082/domain/edf943fc-0622-4564-8821-4de9bd04e8a3
2025-08-18 03:06:26,587 - DEBUG - Requesting: http://10.0.0.27:8082/project/b35ac86e-18f0-4073-ae73-fb18757a2e35
2025-08-18 03:06:26,680 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/1bf4268a-9eab-47e3-a882-fb0e9c3a5fea
2025-08-18 03:06:26,693 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/1bf4268a-9eab-47e3-a882-fb0e9c3a5fea
2025-08-18 03:06:26,703 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/d5cc375c-60e4-4150-83b7-6b7b4832e11b
2025-08-18 03:06:26,710 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/d5cc375c-60e4-4150-83b7-6b7b4832e11b
2025-08-18 03:06:26,718 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/ef59dcba-6d29-40e4-9e0d-3123a131bafe
2025-08-18 03:06:26,725 - DEBUG - Route Targets: ['target:64512:8000008']
2025-08-18 03:06:26,725 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/1bf4268a-9eab-47e3-a882-fb0e9c3a5fea
2025-08-18 03:06:26,734 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/d5cc375c-60e4-4150-83b7-6b7b4832e11b
2025-08-18 03:06:26,751 - INFO - Verified VN network id 16 for VN 1bf4268a-9eab-47e3-a882-fb0e9c3a5fea
2025-08-18 03:06:26,751 - INFO - Verifications in API Server for VN ctest-trans_left_vn-32610126 passed
2025-08-18 03:06:26,751 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/1bf4268a-9eab-47e3-a882-fb0e9c3a5fea
2025-08-18 03:06:26,763 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/d5cc375c-60e4-4150-83b7-6b7b4832e11b
2025-08-18 03:06:26,771 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/d5cc375c-60e4-4150-83b7-6b7b4832e11b
2025-08-18 03:06:26,779 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/ef59dcba-6d29-40e4-9e0d-3123a131bafe
2025-08-18 03:06:26,793 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-37087753:ctest-trans_left_vn-32610126', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-37087753', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2014277310150821859', 'uuid-lslong': '12142543585513463786'}, 'enable': 'true', 'created': '2025-08-18T03:06:26', 'last-modified': '2025-08-18T03:06:26', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.393927'}
2025-08-18 03:06:26,801 - DEBUG - Route Targets: ['target:64512:8000008']
2025-08-18 03:06:26,807 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-37087753:ctest-trans_left_vn-32610126', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-37087753', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2014277310150821859', 'uuid-lslong': '12142543585513463786'}, 'enable': 'true', 'created': '2025-08-18T03:06:26', 'last-modified': '2025-08-18T03:06:26', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.410103'}
2025-08-18 03:06:26,814 - DEBUG - Route Targets: ['target:64512:8000008']
2025-08-18 03:06:26,821 - DEBUG - Control-node 10.0.0.19 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-37087753:ctest-trans_left_vn-32610126', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-37087753', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2014277310150821859', 'uuid-lslong': '12142543585513463786'}, 'enable': 'true', 'created': '2025-08-18T03:06:26', 'last-modified': '2025-08-18T03:06:26', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.427339'}
2025-08-18 03:06:26,828 - DEBUG - Route Targets: ['target:64512:8000008']
2025-08-18 03:06:26,828 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_left_vn-32610126 passed
2025-08-18 03:06:26,829 - DEBUG - ====Verifying policy data for ctest-trans_left_vn-32610126 in API_Server ======
2025-08-18 03:06:26,829 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-08-18 03:06:26,835 - DEBUG - Requesting: http://10.0.0.27:8082/domain/edf943fc-0622-4564-8821-4de9bd04e8a3
2025-08-18 03:06:26,848 - DEBUG - Requesting: http://10.0.0.27:8082/project/b35ac86e-18f0-4073-ae73-fb18757a2e35
2025-08-18 03:06:26,944 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/1bf4268a-9eab-47e3-a882-fb0e9c3a5fea
2025-08-18 03:06:26,969 - DEBUG - =>VN ctest-trans_left_vn-32610126 has no policy to be verified
2025-08-18 03:06:26,969 - DEBUG - Verifying the vn in opserver
2025-08-18 03:06:26,969 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-37087753:ctest-trans_left_vn-32610126 virtual network link through opserver 10.0.0.27
2025-08-18 03:06:26,969 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2025-08-18 03:06:26,987 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-37087753:ctest-trans_left_vn-32610126', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-37087753:ctest-trans_left_vn-32610126?flat'}
2025-08-18 03:06:26,987 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-37087753:ctest-trans_left_vn-32610126 virtual network link through opserver 10.0.0.38
2025-08-18 03:06:26,987 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2025-08-18 03:06:27,000 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-37087753:ctest-trans_left_vn-32610126', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-37087753:ctest-trans_left_vn-32610126?flat'}
2025-08-18 03:06:27,000 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-37087753:ctest-trans_left_vn-32610126 virtual network link through opserver 10.0.0.19
2025-08-18 03:06:27,000 - DEBUG - Requesting: http://10.0.0.19:8081/analytics/uves/virtual-networks
2025-08-18 03:06:27,012 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-37087753:ctest-trans_left_vn-32610126', 'href': 'http://10.0.0.19:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-37087753:ctest-trans_left_vn-32610126?flat'}
2025-08-18 03:06:27,013 - INFO - Validated that VN default-domain:ctest-TestSvcHC-37087753:ctest-trans_left_vn-32610126 is found in opserver
2025-08-18 03:06:27,034 - DEBUG - Do not have enough data to verify VN in agent
2025-08-18 03:06:27,045 - DEBUG - VRF ids for VN ctest-trans_left_vn-32610126: {}
2025-08-18 03:06:27,290 - DEBUG - Response for create_network : {'network': {'id': 'c919741c-3550-46cf-bcf1-d48637f2cc39', 'name': 'ctest-trans_right_vn-48431288', 'tenant_id': 'b35ac86e18f04073ae73fb18757a2e35', 'project_id': 'b35ac86e18f04073ae73fb18757a2e35', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-37087753', 'ctest-trans_right_vn-48431288'], 'port_security_enabled': True, 'description': ''}}
2025-08-18 03:06:27,519 - DEBUG - Response for create_subnet : {'subnet': {'id': 'c8c5b0e1-28fd-496d-82b2-9873c89920e9', 'name': '', 'tenant_id': 'b35ac86e18f04073ae73fb18757a2e35', 'network_id': 'c919741c-3550-46cf-bcf1-d48637f2cc39', 'ip_version': 4, 'cidr': '140.56.228.192/26', 'allocation_pools': [{'start': '140.56.228.194', 'end': '140.56.228.254'}], 'gateway_ip': '140.56.228.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '140.56.228.194', 'tags': [], 'project_id': 'b35ac86e18f04073ae73fb18757a2e35'}}
2025-08-18 03:06:27,540 - INFO - Created VN ctest-trans_right_vn-48431288
2025-08-18 03:06:27,549 - DEBUG - VN ctest-trans_right_vn-48431288 UUID is c919741c-3550-46cf-bcf1-d48637f2cc39
2025-08-18 03:06:27,619 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-08-18 03:06:27,625 - DEBUG - Requesting: http://10.0.0.27:8082/domain/edf943fc-0622-4564-8821-4de9bd04e8a3
2025-08-18 03:06:27,643 - DEBUG - Requesting: http://10.0.0.27:8082/project/b35ac86e-18f0-4073-ae73-fb18757a2e35
2025-08-18 03:06:27,743 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/c919741c-3550-46cf-bcf1-d48637f2cc39
2025-08-18 03:06:27,755 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/c919741c-3550-46cf-bcf1-d48637f2cc39
2025-08-18 03:06:27,767 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/38f0850b-eb19-4a8c-9fa1-1ea15866d462
2025-08-18 03:06:27,780 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/38f0850b-eb19-4a8c-9fa1-1ea15866d462
2025-08-18 03:06:27,791 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/e63a961d-8fb2-47ea-845d-811c0ed6d990
2025-08-18 03:06:27,802 - DEBUG - Route Targets: ['target:64512:8000009']
2025-08-18 03:06:27,802 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/c919741c-3550-46cf-bcf1-d48637f2cc39
2025-08-18 03:06:27,815 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/38f0850b-eb19-4a8c-9fa1-1ea15866d462
2025-08-18 03:06:27,833 - INFO - Verified VN network id 17 for VN c919741c-3550-46cf-bcf1-d48637f2cc39
2025-08-18 03:06:27,833 - INFO - Verifications in API Server for VN ctest-trans_right_vn-48431288 passed
2025-08-18 03:06:27,833 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/c919741c-3550-46cf-bcf1-d48637f2cc39
2025-08-18 03:06:27,845 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/38f0850b-eb19-4a8c-9fa1-1ea15866d462
2025-08-18 03:06:27,853 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/38f0850b-eb19-4a8c-9fa1-1ea15866d462
2025-08-18 03:06:27,861 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/e63a961d-8fb2-47ea-845d-811c0ed6d990
2025-08-18 03:06:27,874 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-37087753:ctest-trans_right_vn-48431288', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-37087753', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '14490740940543641295', 'uuid-lslong': '13614896821447085113'}, 'enable': 'true', 'created': '2025-08-18T03:06:27', 'last-modified': '2025-08-18T03:06:27', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.410280'}
2025-08-18 03:06:27,881 - DEBUG - Route Targets: ['target:64512:8000009']
2025-08-18 03:06:27,887 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-37087753:ctest-trans_right_vn-48431288', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-37087753', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '14490740940543641295', 'uuid-lslong': '13614896821447085113'}, 'enable': 'true', 'created': '2025-08-18T03:06:27', 'last-modified': '2025-08-18T03:06:27', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.424727'}
2025-08-18 03:06:27,894 - DEBUG - Route Targets: ['target:64512:8000009']
2025-08-18 03:06:27,899 - DEBUG - Control-node 10.0.0.19 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-37087753:ctest-trans_right_vn-48431288', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-37087753', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '14490740940543641295', 'uuid-lslong': '13614896821447085113'}, 'enable': 'true', 'created': '2025-08-18T03:06:27', 'last-modified': '2025-08-18T03:06:27', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.435833'}
2025-08-18 03:06:27,905 - DEBUG - Route Targets: ['target:64512:8000009']
2025-08-18 03:06:27,905 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_right_vn-48431288 passed
2025-08-18 03:06:27,906 - DEBUG - ====Verifying policy data for ctest-trans_right_vn-48431288 in API_Server ======
2025-08-18 03:06:27,906 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-08-18 03:06:27,912 - DEBUG - Requesting: http://10.0.0.27:8082/domain/edf943fc-0622-4564-8821-4de9bd04e8a3
2025-08-18 03:06:27,928 - DEBUG - Requesting: http://10.0.0.27:8082/project/b35ac86e-18f0-4073-ae73-fb18757a2e35
2025-08-18 03:06:28,025 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/c919741c-3550-46cf-bcf1-d48637f2cc39
2025-08-18 03:06:28,040 - DEBUG - =>VN ctest-trans_right_vn-48431288 has no policy to be verified
2025-08-18 03:06:28,040 - DEBUG - Verifying the vn in opserver
2025-08-18 03:06:28,040 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-37087753:ctest-trans_right_vn-48431288 virtual network link through opserver 10.0.0.27
2025-08-18 03:06:28,040 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2025-08-18 03:06:28,061 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-37087753:ctest-trans_right_vn-48431288', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-37087753:ctest-trans_right_vn-48431288?flat'}
2025-08-18 03:06:28,061 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-37087753:ctest-trans_right_vn-48431288 virtual network link through opserver 10.0.0.38
2025-08-18 03:06:28,061 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2025-08-18 03:06:28,074 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-37087753:ctest-trans_right_vn-48431288', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-37087753:ctest-trans_right_vn-48431288?flat'}
2025-08-18 03:06:28,074 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-37087753:ctest-trans_right_vn-48431288 virtual network link through opserver 10.0.0.19
2025-08-18 03:06:28,074 - DEBUG - Requesting: http://10.0.0.19:8081/analytics/uves/virtual-networks
2025-08-18 03:06:28,088 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-37087753:ctest-trans_right_vn-48431288', 'href': 'http://10.0.0.19:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-37087753:ctest-trans_right_vn-48431288?flat'}
2025-08-18 03:06:28,088 - INFO - Validated that VN default-domain:ctest-TestSvcHC-37087753:ctest-trans_right_vn-48431288 is found in opserver
2025-08-18 03:06:28,115 - DEBUG - Do not have enough data to verify VN in agent
2025-08-18 03:06:28,128 - DEBUG - VRF ids for VN ctest-trans_right_vn-48431288: {}
2025-08-18 03:06:29,132 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-3870-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-3870-2)
2025-08-18 03:06:30,511 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-3870-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-3870-1)
2025-08-18 03:06:30,512 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-68347960']
2025-08-18 03:06:30,800 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-68347960'] created succesfully
2025-08-18 03:06:31,266 - DEBUG - Image by name tiny_trans_fw not found
2025-08-18 03:06:31,266 - DEBUG - Installing image tiny_trans_fw
2025-08-18 03:06:31,266 - DEBUG - Image info {'name': 'tinycore-net-transparent-fw.qcow2.gz', 'webserver': '', 'location': '/images/tinycore/', 'username': 'tc', 'password': 'secret', 'type': 'os', 'flavor': 'contrail_flavor_tiny', 'params': '--container-format bare --disk-format vmdk --property vmware_disktype="sparse" --property vmware_adaptertype="ide" --property hypervisor_type=qemu', 'name_docker': 'phusion-baseimage-enablesshd'}
2025-08-18 03:06:31,266 - DEBUG - Image build path file:///contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2025-08-18 03:06:31,267 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2025-08-18 03:06:31,267 - DEBUG - Unzip image
2025-08-18 03:06:31,267 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2025-08-18 03:06:31,305 - INFO - image /contrail-test/images/tinycore-net-transparent-fw.qcow2 is not found
2025-08-18 03:06:31,306 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-68347960']
2025-08-18 03:06:31,406 - INFO - Service template: ['default-domain', 'ctest-service_template_1-68347960'] deleted successfully.
2025-08-18 03:06:31,406 - INFO - Skip interface_detach for VM ctest-right_vm-25288751 in state BUILD
2025-08-18 03:06:31,406 - INFO - Deleting VM ctest-right_vm-25288751
2025-08-18 03:06:31,406 - ERROR - VM ctest-right_vm-25288751 has failed to come up
2025-08-18 03:06:31,406 - ERROR - Nova failed to get host of the VM
2025-08-18 03:06:31,407 - ERROR - VM ctest-right_vm-25288751 has failed to come up
2025-08-18 03:06:31,407 - ERROR - Nova failed to get host of the VM
2025-08-18 03:06:31,484 - INFO - Skip interface_detach for VM ctest-left_vm-37548559 in state BUILD
2025-08-18 03:06:31,484 - INFO - Deleting VM ctest-left_vm-37548559
2025-08-18 03:06:31,484 - ERROR - VM ctest-left_vm-37548559 has failed to come up
2025-08-18 03:06:31,484 - ERROR - Nova failed to get host of the VM
2025-08-18 03:06:31,484 - ERROR - VM ctest-left_vm-37548559 has failed to come up
2025-08-18 03:06:31,485 - ERROR - Nova failed to get host of the VM
2025-08-18 03:06:31,542 - INFO - Deleting VN ctest-trans_right_vn-48431288
2025-08-18 03:06:31,710 - DEBUG - Response for deleting network ()
2025-08-18 03:06:31,711 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/38f0850b-eb19-4a8c-9fa1-1ea15866d462
2025-08-18 03:06:31,718 - DEBUG - Response Code: 404
2025-08-18 03:06:31,718 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-08-18 03:06:31,729 - DEBUG - Requesting: http://10.0.0.27:8082/domain/edf943fc-0622-4564-8821-4de9bd04e8a3
2025-08-18 03:06:31,763 - DEBUG - Requesting: http://10.0.0.27:8082/project/b35ac86e-18f0-4073-ae73-fb18757a2e35
2025-08-18 03:06:31,862 - INFO - Validated that VN ctest-trans_right_vn-48431288 is not found in API Server
2025-08-18 03:06:31,882 - DEBUG - VN ctest-trans_right_vn-48431288 is not present in Agent 10.0.0.241
2025-08-18 03:06:31,894 - DEBUG - VN ctest-trans_right_vn-48431288 is not present in Agent 10.0.0.41
2025-08-18 03:06:31,894 - INFO - Validated that VN ctest-trans_right_vn-48431288 is not in any agent
2025-08-18 03:06:31,939 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-trans_right_vn-48431288 info
2025-08-18 03:06:31,940 - INFO - Deleting VN ctest-trans_left_vn-32610126
2025-08-18 03:06:32,084 - DEBUG - Response for deleting network ()
2025-08-18 03:06:32,084 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/d5cc375c-60e4-4150-83b7-6b7b4832e11b
2025-08-18 03:06:32,092 - DEBUG - Response Code: 404
2025-08-18 03:06:32,092 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-08-18 03:06:32,106 - DEBUG - Requesting: http://10.0.0.27:8082/domain/edf943fc-0622-4564-8821-4de9bd04e8a3
2025-08-18 03:06:32,136 - DEBUG - Requesting: http://10.0.0.27:8082/project/b35ac86e-18f0-4073-ae73-fb18757a2e35
2025-08-18 03:06:32,252 - INFO - Validated that VN ctest-trans_left_vn-32610126 is not found in API Server
2025-08-18 03:06:32,291 - DEBUG - VN ctest-trans_left_vn-32610126 is not present in Agent 10.0.0.241
2025-08-18 03:06:32,312 - DEBUG - VN ctest-trans_left_vn-32610126 is not present in Agent 10.0.0.41
2025-08-18 03:06:32,312 - INFO - Validated that VN ctest-trans_left_vn-32610126 is not in any agent
2025-08-18 03:06:32,371 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-trans_left_vn-32610126 info
2025-08-18 03:06:32,372 - INFO - Deleting VN ctest-right_vn-00762577
2025-08-18 03:06:32,422 - DEBUG - VN 61f86f78-dba1-4477-ae00-68164b50dc5f still in use: Unable to complete operation on network 61f86f78-dba1-4477-ae00-68164b50dc5f. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-1470fbd7-e37d-4f87-ac73-cbff51548874']
2025-08-18 03:06:32,422 - WARNING - Deleting VN ctest-right_vn-00762577 failed..Will retry
2025-08-18 03:06:34,562 - DEBUG - Response for deleting network ()
2025-08-18 03:06:34,562 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/1910c9e2-eeab-4b0a-b958-328797dee253
2025-08-18 03:06:34,575 - DEBUG - Response Code: 404
2025-08-18 03:06:34,577 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-08-18 03:06:34,588 - DEBUG - Requesting: http://10.0.0.27:8082/domain/edf943fc-0622-4564-8821-4de9bd04e8a3
2025-08-18 03:06:34,605 - DEBUG - Requesting: http://10.0.0.27:8082/project/b35ac86e-18f0-4073-ae73-fb18757a2e35
2025-08-18 03:06:34,697 - INFO - Validated that VN ctest-right_vn-00762577 is not found in API Server
2025-08-18 03:06:34,709 - DEBUG - VN ctest-right_vn-00762577 is not present in Agent 10.0.0.241
2025-08-18 03:06:34,721 - DEBUG - VN ctest-right_vn-00762577 is not present in Agent 10.0.0.41
2025-08-18 03:06:34,721 - INFO - Validated that VN ctest-right_vn-00762577 is not in any agent
2025-08-18 03:06:34,753 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-00762577 info
2025-08-18 03:06:34,753 - INFO - Deleting VN ctest-left_vn-73135865
2025-08-18 03:06:34,920 - DEBUG - Response for deleting network ()
2025-08-18 03:06:34,920 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/7be2409e-61af-4c79-84b4-957811782669
2025-08-18 03:06:34,937 - DEBUG - Response Code: 404
2025-08-18 03:06:34,937 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-08-18 03:06:34,947 - DEBUG - Requesting: http://10.0.0.27:8082/domain/edf943fc-0622-4564-8821-4de9bd04e8a3
2025-08-18 03:06:34,963 - DEBUG - Requesting: http://10.0.0.27:8082/project/b35ac86e-18f0-4073-ae73-fb18757a2e35
2025-08-18 03:06:35,051 - INFO - Validated that VN ctest-left_vn-73135865 is not found in API Server
2025-08-18 03:06:35,067 - DEBUG - VN ctest-left_vn-73135865 is not present in Agent 10.0.0.241
2025-08-18 03:06:35,084 - DEBUG - VN ctest-left_vn-73135865 is not present in Agent 10.0.0.41
2025-08-18 03:06:35,084 - INFO - Validated that VN ctest-left_vn-73135865 is not in any agent
2025-08-18 03:06:35,121 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-73135865 info
2025-08-18 03:06:35,121 - INFO - Deleting VN ctest-mgmt_vn-94500343
2025-08-18 03:06:35,260 - DEBUG - Response for deleting network ()
2025-08-18 03:06:35,260 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/0c62d1bc-04af-4faf-a7a7-ba179e7f28f7
2025-08-18 03:06:35,275 - DEBUG - Response Code: 404
2025-08-18 03:06:35,275 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-08-18 03:06:35,282 - DEBUG - Requesting: http://10.0.0.27:8082/domain/edf943fc-0622-4564-8821-4de9bd04e8a3
2025-08-18 03:06:35,303 - DEBUG - Requesting: http://10.0.0.27:8082/project/b35ac86e-18f0-4073-ae73-fb18757a2e35
2025-08-18 03:06:35,397 - INFO - Validated that VN ctest-mgmt_vn-94500343 is not found in API Server
2025-08-18 03:06:35,410 - DEBUG - VN ctest-mgmt_vn-94500343 is not present in Agent 10.0.0.241
2025-08-18 03:06:35,422 - DEBUG - VN ctest-mgmt_vn-94500343 is not present in Agent 10.0.0.41
2025-08-18 03:06:35,422 - INFO - Validated that VN ctest-mgmt_vn-94500343 is not in any agent
2025-08-18 03:06:35,454 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-94500343 info
2025-08-18 03:06:36,735 - DEBUG - No XMPP flaps were noticed during the test
2025-08-18 03:06:36,735 - INFO -
2025-08-18 03:06:36,735 - INFO - END TEST : test_svc_trans_segment_right_hc_fail_svm : SKIPPED[0:00:15]
2025-08-18 03:06:36,735 - INFO - --------------------------------------------------------------------------------
2025-08-18 03:06:37,448 - INFO - Deleted project: ctest-TestSvcHC-37087753, ID : b35ac86e-18f0-4073-ae73-fb18757a2e35