2026-05-14 03:38:21,018 - INFO - Domain Default found not creating
2026-05-14 03:38:21,268 - INFO - Project ctest-TestSvcHC-36638429 not found, creating it
2026-05-14 03:38:21,912 - INFO - Created Project:ctest-TestSvcHC-36638429, ID : 848007dc-4dc2-429c-b4a9-9b36ec0651bd
2026-05-14 03:38:23,769 - INFO - ================================================================================
2026-05-14 03:38:23,769 - INFO - STARTING TEST : test_svc_hc_basic
2026-05-14 03:38:25,064 - DEBUG - Nothing to compare xmpp stats {'10.0.0.240': {'10.20.0.18': '0', '10.20.0.129': '0'}, '10.0.0.65': {'10.20.0.18': '0', '10.20.0.129': '0'}} with
2026-05-14 03:38:25,064 - INFO - Initial checks done. Running the testcase now
2026-05-14 03:38:25,064 - INFO -
2026-05-14 03:38:25,848 - DEBUG - Response for create_network : {'network': {'id': '5fd7d736-2a52-4478-b131-575809c83150', 'name': 'ctest-mgmt_vn-79504920', 'tenant_id': '848007dc4dc2429cb4a99b36ec0651bd', 'project_id': '848007dc4dc2429cb4a99b36ec0651bd', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-36638429', 'ctest-mgmt_vn-79504920'], 'port_security_enabled': True, 'description': ''}}
2026-05-14 03:38:26,198 - DEBUG - Response for create_subnet : {'subnet': {'id': '203f22b3-5226-458b-b2b2-6f54b4189667', 'name': '', 'tenant_id': '848007dc4dc2429cb4a99b36ec0651bd', 'network_id': '5fd7d736-2a52-4478-b131-575809c83150', 'ip_version': 4, 'cidr': '102.101.79.64/26', 'allocation_pools': [{'start': '102.101.79.66', 'end': '102.101.79.126'}], 'gateway_ip': '102.101.79.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '102.101.79.66', 'tags': [], 'project_id': '848007dc4dc2429cb4a99b36ec0651bd'}}
2026-05-14 03:38:26,227 - INFO - Created VN ctest-mgmt_vn-79504920
2026-05-14 03:38:26,241 - DEBUG - VN ctest-mgmt_vn-79504920 UUID is 5fd7d736-2a52-4478-b131-575809c83150
2026-05-14 03:38:26,330 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-05-14 03:38:26,666 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-05-14 03:38:26,704 - DEBUG - Requesting: http://10.0.0.27:8082/domain/50f581a9-730f-4c54-9cc2-74fc8369ab40
2026-05-14 03:38:26,721 - DEBUG - Requesting: http://10.0.0.27:8082/project/848007dc-4dc2-429c-b4a9-9b36ec0651bd
2026-05-14 03:38:26,821 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/5fd7d736-2a52-4478-b131-575809c83150
2026-05-14 03:38:26,834 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/5fd7d736-2a52-4478-b131-575809c83150
2026-05-14 03:38:26,845 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/bd925300-3842-4ca0-96bc-131621907536
2026-05-14 03:38:26,854 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/bd925300-3842-4ca0-96bc-131621907536
2026-05-14 03:38:26,864 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/169ba3df-df15-42aa-b9cf-7126993b0159
2026-05-14 03:38:26,872 - DEBUG - Route Targets: ['target:64512:8000007']
2026-05-14 03:38:26,872 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/5fd7d736-2a52-4478-b131-575809c83150
2026-05-14 03:38:26,884 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/bd925300-3842-4ca0-96bc-131621907536
2026-05-14 03:38:26,904 - INFO - Verified VN network id 18 for VN 5fd7d736-2a52-4478-b131-575809c83150
2026-05-14 03:38:26,904 - INFO - Verifications in API Server for VN ctest-mgmt_vn-79504920 passed
2026-05-14 03:38:26,904 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/5fd7d736-2a52-4478-b131-575809c83150
2026-05-14 03:38:26,915 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/bd925300-3842-4ca0-96bc-131621907536
2026-05-14 03:38:26,924 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/bd925300-3842-4ca0-96bc-131621907536
2026-05-14 03:38:26,933 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/169ba3df-df15-42aa-b9cf-7126993b0159
2026-05-14 03:38:26,949 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-36638429:ctest-mgmt_vn-79504920', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-36638429', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6906225181234185336', 'uuid-lslong': '12768082454204920144'}, 'enable': 'true', 'created': '2026-05-14T03:38:25', 'last-modified': '2026-05-14T03:38:26', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.811374'}
2026-05-14 03:38:26,957 - DEBUG - Route Targets: ['target:64512:8000007']
2026-05-14 03:38:26,964 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-36638429:ctest-mgmt_vn-79504920', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-36638429', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6906225181234185336', 'uuid-lslong': '12768082454204920144'}, 'enable': 'true', 'created': '2026-05-14T03:38:25', 'last-modified': '2026-05-14T03:38:26', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.828017'}
2026-05-14 03:38:26,971 - DEBUG - Route Targets: ['target:64512:8000007']
2026-05-14 03:38:26,978 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-36638429:ctest-mgmt_vn-79504920', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-36638429', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6906225181234185336', 'uuid-lslong': '12768082454204920144'}, 'enable': 'true', 'created': '2026-05-14T03:38:25', 'last-modified': '2026-05-14T03:38:26', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.841730'}
2026-05-14 03:38:26,985 - DEBUG - Route Targets: ['target:64512:8000007']
2026-05-14 03:38:26,986 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-79504920 passed
2026-05-14 03:38:26,986 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-79504920 in API_Server ======
2026-05-14 03:38:26,986 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-05-14 03:38:26,997 - DEBUG - Requesting: http://10.0.0.27:8082/domain/50f581a9-730f-4c54-9cc2-74fc8369ab40
2026-05-14 03:38:27,017 - DEBUG - Requesting: http://10.0.0.27:8082/project/848007dc-4dc2-429c-b4a9-9b36ec0651bd
2026-05-14 03:38:27,114 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/5fd7d736-2a52-4478-b131-575809c83150
2026-05-14 03:38:27,126 - DEBUG - =>VN ctest-mgmt_vn-79504920 has no policy to be verified
2026-05-14 03:38:27,126 - DEBUG - Verifying the vn in opserver
2026-05-14 03:38:27,127 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-36638429:ctest-mgmt_vn-79504920 virtual network link through opserver 10.0.0.27
2026-05-14 03:38:27,127 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-05-14 03:38:27,467 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-05-14 03:38:27,545 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-36638429:ctest-mgmt_vn-79504920', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-36638429:ctest-mgmt_vn-79504920?flat'}
2026-05-14 03:38:27,545 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-36638429:ctest-mgmt_vn-79504920 virtual network link through opserver 10.0.0.22
2026-05-14 03:38:27,545 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-05-14 03:38:27,885 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-05-14 03:38:27,960 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-36638429:ctest-mgmt_vn-79504920', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-36638429:ctest-mgmt_vn-79504920?flat'}
2026-05-14 03:38:27,960 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-36638429:ctest-mgmt_vn-79504920 virtual network link through opserver 10.0.0.23
2026-05-14 03:38:27,960 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-05-14 03:38:28,304 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-05-14 03:38:28,375 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-36638429:ctest-mgmt_vn-79504920', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-36638429:ctest-mgmt_vn-79504920?flat'}
2026-05-14 03:38:28,375 - INFO - Validated that VN default-domain:ctest-TestSvcHC-36638429:ctest-mgmt_vn-79504920 is found in opserver
2026-05-14 03:38:28,404 - DEBUG - Do not have enough data to verify VN in agent
2026-05-14 03:38:28,417 - DEBUG - VRF ids for VN ctest-mgmt_vn-79504920: {}
2026-05-14 03:38:28,767 - DEBUG - Response for create_network : {'network': {'id': '3745fae3-4bda-4d96-a3f1-086f33e3ae7f', 'name': 'ctest-left_vn-04698970', 'tenant_id': '848007dc4dc2429cb4a99b36ec0651bd', 'project_id': '848007dc4dc2429cb4a99b36ec0651bd', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-36638429', 'ctest-left_vn-04698970'], 'port_security_enabled': True, 'description': ''}}
2026-05-14 03:38:29,047 - DEBUG - Response for create_subnet : {'subnet': {'id': '403ccab7-c9e2-482c-869f-abb923bfed9c', 'name': '', 'tenant_id': '848007dc4dc2429cb4a99b36ec0651bd', 'network_id': '3745fae3-4bda-4d96-a3f1-086f33e3ae7f', 'ip_version': 4, 'cidr': '67.35.234.128/26', 'allocation_pools': [{'start': '67.35.234.130', 'end': '67.35.234.190'}], 'gateway_ip': '67.35.234.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '67.35.234.130', 'tags': [], 'project_id': '848007dc4dc2429cb4a99b36ec0651bd'}}
2026-05-14 03:38:29,073 - INFO - Created VN ctest-left_vn-04698970
2026-05-14 03:38:29,090 - DEBUG - VN ctest-left_vn-04698970 UUID is 3745fae3-4bda-4d96-a3f1-086f33e3ae7f
2026-05-14 03:38:29,186 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-05-14 03:38:29,195 - DEBUG - Requesting: http://10.0.0.27:8082/domain/50f581a9-730f-4c54-9cc2-74fc8369ab40
2026-05-14 03:38:29,218 - DEBUG - Requesting: http://10.0.0.27:8082/project/848007dc-4dc2-429c-b4a9-9b36ec0651bd
2026-05-14 03:38:29,345 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/3745fae3-4bda-4d96-a3f1-086f33e3ae7f
2026-05-14 03:38:29,362 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/3745fae3-4bda-4d96-a3f1-086f33e3ae7f
2026-05-14 03:38:29,393 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/78c365da-3645-407b-b82e-b80a817dd7f8
2026-05-14 03:38:29,406 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/78c365da-3645-407b-b82e-b80a817dd7f8
2026-05-14 03:38:29,416 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/87b67d49-5b29-406f-8d0f-2e406414d837
2026-05-14 03:38:29,425 - DEBUG - Route Targets: ['target:64512:8000008']
2026-05-14 03:38:29,425 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/3745fae3-4bda-4d96-a3f1-086f33e3ae7f
2026-05-14 03:38:29,438 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/78c365da-3645-407b-b82e-b80a817dd7f8
2026-05-14 03:38:29,459 - INFO - Verified VN network id 19 for VN 3745fae3-4bda-4d96-a3f1-086f33e3ae7f
2026-05-14 03:38:29,459 - INFO - Verifications in API Server for VN ctest-left_vn-04698970 passed
2026-05-14 03:38:29,460 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/3745fae3-4bda-4d96-a3f1-086f33e3ae7f
2026-05-14 03:38:29,472 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/78c365da-3645-407b-b82e-b80a817dd7f8
2026-05-14 03:38:29,482 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/78c365da-3645-407b-b82e-b80a817dd7f8
2026-05-14 03:38:29,491 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/87b67d49-5b29-406f-8d0f-2e406414d837
2026-05-14 03:38:29,508 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-36638429:ctest-left_vn-04698970', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-36638429', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3982865299616189846', 'uuid-lslong': '11813232571274473087'}, 'enable': 'true', 'created': '2026-05-14T03:38:28', 'last-modified': '2026-05-14T03:38:28', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.542343'}
2026-05-14 03:38:29,520 - DEBUG - Route Targets: ['target:64512:8000008']
2026-05-14 03:38:29,528 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-36638429:ctest-left_vn-04698970', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-36638429', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3982865299616189846', 'uuid-lslong': '11813232571274473087'}, 'enable': 'true', 'created': '2026-05-14T03:38:28', 'last-modified': '2026-05-14T03:38:28', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.564465'}
2026-05-14 03:38:29,536 - DEBUG - Route Targets: ['target:64512:8000008']
2026-05-14 03:38:29,543 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-36638429:ctest-left_vn-04698970', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-36638429', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3982865299616189846', 'uuid-lslong': '11813232571274473087'}, 'enable': 'true', 'created': '2026-05-14T03:38:28', 'last-modified': '2026-05-14T03:38:28', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.589949'}
2026-05-14 03:38:29,551 - DEBUG - Route Targets: ['target:64512:8000008']
2026-05-14 03:38:29,551 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-04698970 passed
2026-05-14 03:38:29,551 - DEBUG - ====Verifying policy data for ctest-left_vn-04698970 in API_Server ======
2026-05-14 03:38:29,551 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-05-14 03:38:29,558 - DEBUG - Requesting: http://10.0.0.27:8082/domain/50f581a9-730f-4c54-9cc2-74fc8369ab40
2026-05-14 03:38:29,571 - DEBUG - Requesting: http://10.0.0.27:8082/project/848007dc-4dc2-429c-b4a9-9b36ec0651bd
2026-05-14 03:38:29,680 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/3745fae3-4bda-4d96-a3f1-086f33e3ae7f
2026-05-14 03:38:29,691 - DEBUG - =>VN ctest-left_vn-04698970 has no policy to be verified
2026-05-14 03:38:29,691 - DEBUG - Verifying the vn in opserver
2026-05-14 03:38:29,691 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-36638429:ctest-left_vn-04698970 virtual network link through opserver 10.0.0.27
2026-05-14 03:38:29,691 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-05-14 03:38:29,933 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-36638429:ctest-left_vn-04698970', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-36638429:ctest-left_vn-04698970?flat'}
2026-05-14 03:38:29,933 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-36638429:ctest-left_vn-04698970 virtual network link through opserver 10.0.0.22
2026-05-14 03:38:29,933 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-05-14 03:38:30,021 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-36638429:ctest-left_vn-04698970', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-36638429:ctest-left_vn-04698970?flat'}
2026-05-14 03:38:30,021 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-36638429:ctest-left_vn-04698970 virtual network link through opserver 10.0.0.23
2026-05-14 03:38:30,021 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-05-14 03:38:30,095 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-36638429:ctest-left_vn-04698970', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-36638429:ctest-left_vn-04698970?flat'}
2026-05-14 03:38:30,095 - INFO - Validated that VN default-domain:ctest-TestSvcHC-36638429:ctest-left_vn-04698970 is found in opserver
2026-05-14 03:38:30,122 - DEBUG - Do not have enough data to verify VN in agent
2026-05-14 03:38:30,141 - DEBUG - VRF ids for VN ctest-left_vn-04698970: {}
2026-05-14 03:38:30,476 - DEBUG - Response for create_network : {'network': {'id': '94b82318-1c76-4951-8f97-c2bd261de568', 'name': 'ctest-right_vn-69293974', 'tenant_id': '848007dc4dc2429cb4a99b36ec0651bd', 'project_id': '848007dc4dc2429cb4a99b36ec0651bd', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-36638429', 'ctest-right_vn-69293974'], 'port_security_enabled': True, 'description': ''}}
2026-05-14 03:38:30,761 - DEBUG - Response for create_subnet : {'subnet': {'id': '1e44bc57-de2a-4fb6-a6c9-020fec6d5d8f', 'name': '', 'tenant_id': '848007dc4dc2429cb4a99b36ec0651bd', 'network_id': '94b82318-1c76-4951-8f97-c2bd261de568', 'ip_version': 4, 'cidr': '80.30.5.0/26', 'allocation_pools': [{'start': '80.30.5.2', 'end': '80.30.5.62'}], 'gateway_ip': '80.30.5.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '80.30.5.2', 'tags': [], 'project_id': '848007dc4dc2429cb4a99b36ec0651bd'}}
2026-05-14 03:38:30,791 - INFO - Created VN ctest-right_vn-69293974
2026-05-14 03:38:30,806 - DEBUG - VN ctest-right_vn-69293974 UUID is 94b82318-1c76-4951-8f97-c2bd261de568
2026-05-14 03:38:30,901 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-05-14 03:38:30,915 - DEBUG - Requesting: http://10.0.0.27:8082/domain/50f581a9-730f-4c54-9cc2-74fc8369ab40
2026-05-14 03:38:30,946 - DEBUG - Requesting: http://10.0.0.27:8082/project/848007dc-4dc2-429c-b4a9-9b36ec0651bd
2026-05-14 03:38:31,040 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/94b82318-1c76-4951-8f97-c2bd261de568
2026-05-14 03:38:31,054 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/94b82318-1c76-4951-8f97-c2bd261de568
2026-05-14 03:38:31,072 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/a8af61ec-2fc5-4c6a-bad9-4b9f46ac9b8c
2026-05-14 03:38:31,084 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/a8af61ec-2fc5-4c6a-bad9-4b9f46ac9b8c
2026-05-14 03:38:31,093 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/02774ade-3391-44ff-b6b6-7a0199146278
2026-05-14 03:38:31,126 - DEBUG - Route Targets: ['target:64512:8000009']
2026-05-14 03:38:31,127 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/94b82318-1c76-4951-8f97-c2bd261de568
2026-05-14 03:38:31,145 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/a8af61ec-2fc5-4c6a-bad9-4b9f46ac9b8c
2026-05-14 03:38:31,179 - INFO - Verified VN network id 20 for VN 94b82318-1c76-4951-8f97-c2bd261de568
2026-05-14 03:38:31,179 - INFO - Verifications in API Server for VN ctest-right_vn-69293974 passed
2026-05-14 03:38:31,179 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/94b82318-1c76-4951-8f97-c2bd261de568
2026-05-14 03:38:31,206 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/a8af61ec-2fc5-4c6a-bad9-4b9f46ac9b8c
2026-05-14 03:38:31,224 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/a8af61ec-2fc5-4c6a-bad9-4b9f46ac9b8c
2026-05-14 03:38:31,247 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/02774ade-3391-44ff-b6b6-7a0199146278
2026-05-14 03:38:31,267 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-36638429:ctest-right_vn-69293974', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-36638429', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10716353899791796561', 'uuid-lslong': '10346952786551104872'}, 'enable': 'true', 'created': '2026-05-14T03:38:30', 'last-modified': '2026-05-14T03:38:30', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.566773'}
2026-05-14 03:38:31,276 - DEBUG - Route Targets: ['target:64512:8000009']
2026-05-14 03:38:31,286 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-36638429:ctest-right_vn-69293974', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-36638429', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10716353899791796561', 'uuid-lslong': '10346952786551104872'}, 'enable': 'true', 'created': '2026-05-14T03:38:30', 'last-modified': '2026-05-14T03:38:30', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.583933'}
2026-05-14 03:38:31,303 - DEBUG - Route Targets: ['target:64512:8000009']
2026-05-14 03:38:31,317 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-36638429:ctest-right_vn-69293974', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-36638429', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10716353899791796561', 'uuid-lslong': '10346952786551104872'}, 'enable': 'true', 'created': '2026-05-14T03:38:30', 'last-modified': '2026-05-14T03:38:30', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.611869'}
2026-05-14 03:38:31,331 - DEBUG - Route Targets: ['target:64512:8000009']
2026-05-14 03:38:31,332 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-69293974 passed
2026-05-14 03:38:31,332 - DEBUG - ====Verifying policy data for ctest-right_vn-69293974 in API_Server ======
2026-05-14 03:38:31,332 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-05-14 03:38:31,368 - DEBUG - Requesting: http://10.0.0.27:8082/domain/50f581a9-730f-4c54-9cc2-74fc8369ab40
2026-05-14 03:38:31,408 - DEBUG - Requesting: http://10.0.0.27:8082/project/848007dc-4dc2-429c-b4a9-9b36ec0651bd
2026-05-14 03:38:31,479 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/94b82318-1c76-4951-8f97-c2bd261de568
2026-05-14 03:38:31,494 - DEBUG - =>VN ctest-right_vn-69293974 has no policy to be verified
2026-05-14 03:38:31,495 - DEBUG - Verifying the vn in opserver
2026-05-14 03:38:31,495 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-36638429:ctest-right_vn-69293974 virtual network link through opserver 10.0.0.27
2026-05-14 03:38:31,495 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-05-14 03:38:31,508 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-36638429:ctest-right_vn-69293974', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-36638429:ctest-right_vn-69293974?flat'}
2026-05-14 03:38:31,508 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-36638429:ctest-right_vn-69293974 virtual network link through opserver 10.0.0.22
2026-05-14 03:38:31,508 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-05-14 03:38:31,591 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-36638429:ctest-right_vn-69293974', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-36638429:ctest-right_vn-69293974?flat'}
2026-05-14 03:38:31,591 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-36638429:ctest-right_vn-69293974 virtual network link through opserver 10.0.0.23
2026-05-14 03:38:31,591 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-05-14 03:38:31,606 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-36638429:ctest-right_vn-69293974', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-36638429:ctest-right_vn-69293974?flat'}
2026-05-14 03:38:31,606 - INFO - Validated that VN default-domain:ctest-TestSvcHC-36638429:ctest-right_vn-69293974 is found in opserver
2026-05-14 03:38:31,630 - DEBUG - Do not have enough data to verify VN in agent
2026-05-14 03:38:31,642 - DEBUG - VRF ids for VN ctest-right_vn-69293974: {}
2026-05-14 03:38:31,792 - DEBUG - Services list from nova: [, , , ]
2026-05-14 03:38:33,069 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5780-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5780-1)
2026-05-14 03:38:34,764 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5780-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5780-2)
2026-05-14 03:38:34,764 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-54107423']
2026-05-14 03:38:35,082 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-54107423'] created succesfully
2026-05-14 03:38:35,688 - DEBUG - Image by name tiny_nat_fw not found
2026-05-14 03:38:35,689 - DEBUG - Installing image tiny_nat_fw
2026-05-14 03:38:35,689 - 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'"}
2026-05-14 03:38:35,689 - DEBUG - Image build path file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-05-14 03:38:35,689 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-05-14 03:38:35,689 - DEBUG - Unzip image
2026-05-14 03:38:35,689 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-05-14 03:38:35,714 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2026-05-14 03:38:35,714 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-54107423']
2026-05-14 03:38:35,819 - INFO - Service template: ['default-domain', 'ctest-service_template_1-54107423'] deleted successfully.
2026-05-14 03:38:35,819 - INFO - Skip interface_detach for VM ctest-right_vm-09919708 in state BUILD
2026-05-14 03:38:35,819 - INFO - Deleting VM ctest-right_vm-09919708
2026-05-14 03:38:35,853 - ERROR - VM ctest-right_vm-09919708 has failed to come up
2026-05-14 03:38:35,853 - ERROR - Nova failed to get host of the VM
2026-05-14 03:38:35,853 - ERROR - VM ctest-right_vm-09919708 has failed to come up
2026-05-14 03:38:35,853 - ERROR - Nova failed to get host of the VM
2026-05-14 03:38:35,954 - INFO - Skip interface_detach for VM ctest-left_vm-60518696 in state BUILD
2026-05-14 03:38:35,954 - INFO - Deleting VM ctest-left_vm-60518696
2026-05-14 03:38:35,954 - ERROR - VM ctest-left_vm-60518696 has failed to come up
2026-05-14 03:38:35,954 - ERROR - Nova failed to get host of the VM
2026-05-14 03:38:35,954 - ERROR - VM ctest-left_vm-60518696 has failed to come up
2026-05-14 03:38:35,954 - ERROR - Nova failed to get host of the VM
2026-05-14 03:38:36,042 - INFO - Deleting VN ctest-right_vn-69293974
2026-05-14 03:38:36,092 - DEBUG - VN 94b82318-1c76-4951-8f97-c2bd261de568 still in use: Unable to complete operation on network 94b82318-1c76-4951-8f97-c2bd261de568. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-ee41f427-cd88-4f29-a7dc-a1ced27578c3']
2026-05-14 03:38:36,092 - WARNING - Deleting VN ctest-right_vn-69293974 failed..Will retry
2026-05-14 03:38:38,321 - DEBUG - Response for deleting network ()
2026-05-14 03:38:38,321 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/a8af61ec-2fc5-4c6a-bad9-4b9f46ac9b8c
2026-05-14 03:38:38,331 - DEBUG - Response Code: 404
2026-05-14 03:38:38,331 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-05-14 03:38:38,340 - DEBUG - Requesting: http://10.0.0.27:8082/domain/50f581a9-730f-4c54-9cc2-74fc8369ab40
2026-05-14 03:38:38,411 - DEBUG - Requesting: http://10.0.0.27:8082/project/848007dc-4dc2-429c-b4a9-9b36ec0651bd
2026-05-14 03:38:38,521 - INFO - Validated that VN ctest-right_vn-69293974 is not found in API Server
2026-05-14 03:38:38,535 - DEBUG - VN ctest-right_vn-69293974 is not present in Agent 10.0.0.240
2026-05-14 03:38:38,552 - DEBUG - VN ctest-right_vn-69293974 is not present in Agent 10.0.0.65
2026-05-14 03:38:38,552 - INFO - Validated that VN ctest-right_vn-69293974 is not in any agent
2026-05-14 03:38:38,593 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-69293974 info
2026-05-14 03:38:38,593 - INFO - Deleting VN ctest-left_vn-04698970
2026-05-14 03:38:38,777 - DEBUG - Response for deleting network ()
2026-05-14 03:38:38,777 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/78c365da-3645-407b-b82e-b80a817dd7f8
2026-05-14 03:38:38,799 - DEBUG - Response Code: 404
2026-05-14 03:38:38,799 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-05-14 03:38:38,809 - DEBUG - Requesting: http://10.0.0.27:8082/domain/50f581a9-730f-4c54-9cc2-74fc8369ab40
2026-05-14 03:38:38,828 - DEBUG - Requesting: http://10.0.0.27:8082/project/848007dc-4dc2-429c-b4a9-9b36ec0651bd
2026-05-14 03:38:38,958 - INFO - Validated that VN ctest-left_vn-04698970 is not found in API Server
2026-05-14 03:38:38,974 - DEBUG - VN ctest-left_vn-04698970 is not present in Agent 10.0.0.240
2026-05-14 03:38:38,994 - DEBUG - VN ctest-left_vn-04698970 is not present in Agent 10.0.0.65
2026-05-14 03:38:38,994 - INFO - Validated that VN ctest-left_vn-04698970 is not in any agent
2026-05-14 03:38:39,039 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-04698970 info
2026-05-14 03:38:39,039 - INFO - Deleting VN ctest-mgmt_vn-79504920
2026-05-14 03:38:39,222 - DEBUG - Response for deleting network ()
2026-05-14 03:38:39,222 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/bd925300-3842-4ca0-96bc-131621907536
2026-05-14 03:38:39,230 - DEBUG - Response Code: 404
2026-05-14 03:38:39,231 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-05-14 03:38:39,244 - DEBUG - Requesting: http://10.0.0.27:8082/domain/50f581a9-730f-4c54-9cc2-74fc8369ab40
2026-05-14 03:38:39,267 - DEBUG - Requesting: http://10.0.0.27:8082/project/848007dc-4dc2-429c-b4a9-9b36ec0651bd
2026-05-14 03:38:39,361 - INFO - Validated that VN ctest-mgmt_vn-79504920 is not found in API Server
2026-05-14 03:38:39,374 - DEBUG - VN ctest-mgmt_vn-79504920 is not present in Agent 10.0.0.240
2026-05-14 03:38:39,396 - DEBUG - VN ctest-mgmt_vn-79504920 is not present in Agent 10.0.0.65
2026-05-14 03:38:39,396 - INFO - Validated that VN ctest-mgmt_vn-79504920 is not in any agent
2026-05-14 03:38:39,436 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-79504920 info
2026-05-14 03:38:40,764 - DEBUG - No XMPP flaps were noticed during the test
2026-05-14 03:38:40,764 - INFO -
2026-05-14 03:38:40,764 - INFO - END TEST : test_svc_hc_basic : SKIPPED[0:00:17]
2026-05-14 03:38:40,764 - INFO - --------------------------------------------------------------------------------
2026-05-14 03:38:40,768 - INFO - ================================================================================
2026-05-14 03:38:40,768 - INFO - STARTING TEST : test_svc_trans_segment_right_hc_fail_svm
2026-05-14 03:38:42,056 - DEBUG - Nothing to compare xmpp stats {'10.0.0.240': {'10.20.0.18': '0', '10.20.0.129': '0'}, '10.0.0.65': {'10.20.0.18': '0', '10.20.0.129': '0'}} with
2026-05-14 03:38:42,056 - INFO - Initial checks done. Running the testcase now
2026-05-14 03:38:42,056 - INFO -
2026-05-14 03:38:42,403 - DEBUG - Response for create_network : {'network': {'id': '9b289948-bb2b-4501-b07e-f9fe567bb5c1', 'name': 'ctest-mgmt_vn-22621661', 'tenant_id': '848007dc4dc2429cb4a99b36ec0651bd', 'project_id': '848007dc4dc2429cb4a99b36ec0651bd', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-36638429', 'ctest-mgmt_vn-22621661'], 'port_security_enabled': True, 'description': ''}}
2026-05-14 03:38:42,729 - DEBUG - Response for create_subnet : {'subnet': {'id': 'cf83dba5-7074-40ec-90de-5e794cd39833', 'name': '', 'tenant_id': '848007dc4dc2429cb4a99b36ec0651bd', 'network_id': '9b289948-bb2b-4501-b07e-f9fe567bb5c1', 'ip_version': 4, 'cidr': '155.116.237.64/26', 'allocation_pools': [{'start': '155.116.237.66', 'end': '155.116.237.126'}], 'gateway_ip': '155.116.237.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '155.116.237.66', 'tags': [], 'project_id': '848007dc4dc2429cb4a99b36ec0651bd'}}
2026-05-14 03:38:42,757 - INFO - Created VN ctest-mgmt_vn-22621661
2026-05-14 03:38:42,779 - DEBUG - VN ctest-mgmt_vn-22621661 UUID is 9b289948-bb2b-4501-b07e-f9fe567bb5c1
2026-05-14 03:38:42,880 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-05-14 03:38:42,888 - DEBUG - Requesting: http://10.0.0.27:8082/domain/50f581a9-730f-4c54-9cc2-74fc8369ab40
2026-05-14 03:38:42,902 - DEBUG - Requesting: http://10.0.0.27:8082/project/848007dc-4dc2-429c-b4a9-9b36ec0651bd
2026-05-14 03:38:43,010 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/9b289948-bb2b-4501-b07e-f9fe567bb5c1
2026-05-14 03:38:43,037 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/9b289948-bb2b-4501-b07e-f9fe567bb5c1
2026-05-14 03:38:43,051 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/526b7ab0-181c-4d35-a1e6-11028a26b7b0
2026-05-14 03:38:43,063 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/526b7ab0-181c-4d35-a1e6-11028a26b7b0
2026-05-14 03:38:43,076 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/42a9643e-c827-4aca-a67e-0441591308d3
2026-05-14 03:38:43,087 - DEBUG - Route Targets: ['target:64512:8000007']
2026-05-14 03:38:43,087 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/9b289948-bb2b-4501-b07e-f9fe567bb5c1
2026-05-14 03:38:43,107 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/526b7ab0-181c-4d35-a1e6-11028a26b7b0
2026-05-14 03:38:43,132 - INFO - Verified VN network id 18 for VN 9b289948-bb2b-4501-b07e-f9fe567bb5c1
2026-05-14 03:38:43,132 - INFO - Verifications in API Server for VN ctest-mgmt_vn-22621661 passed
2026-05-14 03:38:43,132 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/9b289948-bb2b-4501-b07e-f9fe567bb5c1
2026-05-14 03:38:43,147 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/526b7ab0-181c-4d35-a1e6-11028a26b7b0
2026-05-14 03:38:43,160 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/526b7ab0-181c-4d35-a1e6-11028a26b7b0
2026-05-14 03:38:43,175 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/42a9643e-c827-4aca-a67e-0441591308d3
2026-05-14 03:38:43,201 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-36638429:ctest-mgmt_vn-22621661', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-36638429', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11180354612604126465', 'uuid-lslong': '12717877268508816833'}, 'enable': 'true', 'created': '2026-05-14T03:38:42', 'last-modified': '2026-05-14T03:38:42', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.557123'}
2026-05-14 03:38:43,212 - DEBUG - Route Targets: ['target:64512:8000007']
2026-05-14 03:38:43,221 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-36638429:ctest-mgmt_vn-22621661', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-36638429', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11180354612604126465', 'uuid-lslong': '12717877268508816833'}, 'enable': 'true', 'created': '2026-05-14T03:38:42', 'last-modified': '2026-05-14T03:38:42', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.579901'}
2026-05-14 03:38:43,228 - DEBUG - Route Targets: ['target:64512:8000007']
2026-05-14 03:38:43,235 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-36638429:ctest-mgmt_vn-22621661', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-36638429', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11180354612604126465', 'uuid-lslong': '12717877268508816833'}, 'enable': 'true', 'created': '2026-05-14T03:38:42', 'last-modified': '2026-05-14T03:38:42', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.595892'}
2026-05-14 03:38:43,244 - DEBUG - Route Targets: ['target:64512:8000007']
2026-05-14 03:38:43,244 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-22621661 passed
2026-05-14 03:38:43,244 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-22621661 in API_Server ======
2026-05-14 03:38:43,244 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-05-14 03:38:43,253 - DEBUG - Requesting: http://10.0.0.27:8082/domain/50f581a9-730f-4c54-9cc2-74fc8369ab40
2026-05-14 03:38:43,267 - DEBUG - Requesting: http://10.0.0.27:8082/project/848007dc-4dc2-429c-b4a9-9b36ec0651bd
2026-05-14 03:38:43,385 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/9b289948-bb2b-4501-b07e-f9fe567bb5c1
2026-05-14 03:38:43,398 - DEBUG - =>VN ctest-mgmt_vn-22621661 has no policy to be verified
2026-05-14 03:38:43,398 - DEBUG - Verifying the vn in opserver
2026-05-14 03:38:43,398 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-36638429:ctest-mgmt_vn-22621661 virtual network link through opserver 10.0.0.27
2026-05-14 03:38:43,398 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-05-14 03:38:43,420 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-36638429:ctest-mgmt_vn-22621661', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-36638429:ctest-mgmt_vn-22621661?flat'}
2026-05-14 03:38:43,420 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-36638429:ctest-mgmt_vn-22621661 virtual network link through opserver 10.0.0.22
2026-05-14 03:38:43,420 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-05-14 03:38:43,435 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-36638429:ctest-mgmt_vn-22621661', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-36638429:ctest-mgmt_vn-22621661?flat'}
2026-05-14 03:38:43,435 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-36638429:ctest-mgmt_vn-22621661 virtual network link through opserver 10.0.0.23
2026-05-14 03:38:43,435 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-05-14 03:38:43,522 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-36638429:ctest-mgmt_vn-22621661', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-36638429:ctest-mgmt_vn-22621661?flat'}
2026-05-14 03:38:43,522 - INFO - Validated that VN default-domain:ctest-TestSvcHC-36638429:ctest-mgmt_vn-22621661 is found in opserver
2026-05-14 03:38:43,545 - DEBUG - Do not have enough data to verify VN in agent
2026-05-14 03:38:43,557 - DEBUG - VRF ids for VN ctest-mgmt_vn-22621661: {}
2026-05-14 03:38:43,902 - DEBUG - Response for create_network : {'network': {'id': '64a5144d-e1c9-4cc6-b504-cc598d2a4218', 'name': 'ctest-left_vn-14995913', 'tenant_id': '848007dc4dc2429cb4a99b36ec0651bd', 'project_id': '848007dc4dc2429cb4a99b36ec0651bd', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-36638429', 'ctest-left_vn-14995913'], 'port_security_enabled': True, 'description': ''}}
2026-05-14 03:38:44,225 - DEBUG - Response for create_subnet : {'subnet': {'id': 'ac2976e1-8f44-4658-b4bc-47aa5e4a37a7', 'name': '', 'tenant_id': '848007dc4dc2429cb4a99b36ec0651bd', 'network_id': '64a5144d-e1c9-4cc6-b504-cc598d2a4218', 'ip_version': 4, 'cidr': '14.56.1.0/26', 'allocation_pools': [{'start': '14.56.1.2', 'end': '14.56.1.62'}], 'gateway_ip': '14.56.1.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '14.56.1.2', 'tags': [], 'project_id': '848007dc4dc2429cb4a99b36ec0651bd'}}
2026-05-14 03:38:44,284 - INFO - Created VN ctest-left_vn-14995913
2026-05-14 03:38:44,301 - DEBUG - VN ctest-left_vn-14995913 UUID is 64a5144d-e1c9-4cc6-b504-cc598d2a4218
2026-05-14 03:38:44,402 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-05-14 03:38:44,411 - DEBUG - Requesting: http://10.0.0.27:8082/domain/50f581a9-730f-4c54-9cc2-74fc8369ab40
2026-05-14 03:38:44,425 - DEBUG - Requesting: http://10.0.0.27:8082/project/848007dc-4dc2-429c-b4a9-9b36ec0651bd
2026-05-14 03:38:44,542 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/64a5144d-e1c9-4cc6-b504-cc598d2a4218
2026-05-14 03:38:44,569 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/64a5144d-e1c9-4cc6-b504-cc598d2a4218
2026-05-14 03:38:44,583 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/87309ec1-4e0d-44ce-bf13-ed42d461cafc
2026-05-14 03:38:44,598 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/87309ec1-4e0d-44ce-bf13-ed42d461cafc
2026-05-14 03:38:44,609 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/df4f5408-4fb5-4aa7-8b8c-419386b1f0d0
2026-05-14 03:38:44,620 - DEBUG - Route Targets: ['target:64512:8000008']
2026-05-14 03:38:44,620 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/64a5144d-e1c9-4cc6-b504-cc598d2a4218
2026-05-14 03:38:44,632 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/87309ec1-4e0d-44ce-bf13-ed42d461cafc
2026-05-14 03:38:44,651 - INFO - Verified VN network id 19 for VN 64a5144d-e1c9-4cc6-b504-cc598d2a4218
2026-05-14 03:38:44,651 - INFO - Verifications in API Server for VN ctest-left_vn-14995913 passed
2026-05-14 03:38:44,651 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/64a5144d-e1c9-4cc6-b504-cc598d2a4218
2026-05-14 03:38:44,662 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/87309ec1-4e0d-44ce-bf13-ed42d461cafc
2026-05-14 03:38:44,671 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/87309ec1-4e0d-44ce-bf13-ed42d461cafc
2026-05-14 03:38:44,680 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/df4f5408-4fb5-4aa7-8b8c-419386b1f0d0
2026-05-14 03:38:44,696 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-36638429:ctest-left_vn-14995913', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-36638429', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7252225099683155142', 'uuid-lslong': '13043775105764311576'}, 'enable': 'true', 'created': '2026-05-14T03:38:43', 'last-modified': '2026-05-14T03:38:44', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.527168'}
2026-05-14 03:38:44,708 - DEBUG - Route Targets: ['target:64512:8000008']
2026-05-14 03:38:44,715 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-36638429:ctest-left_vn-14995913', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-36638429', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7252225099683155142', 'uuid-lslong': '13043775105764311576'}, 'enable': 'true', 'created': '2026-05-14T03:38:43', 'last-modified': '2026-05-14T03:38:44', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.547132'}
2026-05-14 03:38:44,724 - DEBUG - Route Targets: ['target:64512:8000008']
2026-05-14 03:38:44,732 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-36638429:ctest-left_vn-14995913', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-36638429', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7252225099683155142', 'uuid-lslong': '13043775105764311576'}, 'enable': 'true', 'created': '2026-05-14T03:38:43', 'last-modified': '2026-05-14T03:38:44', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.557341'}
2026-05-14 03:38:44,740 - DEBUG - Route Targets: ['target:64512:8000008']
2026-05-14 03:38:44,740 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-14995913 passed
2026-05-14 03:38:44,740 - DEBUG - ====Verifying policy data for ctest-left_vn-14995913 in API_Server ======
2026-05-14 03:38:44,740 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-05-14 03:38:44,747 - DEBUG - Requesting: http://10.0.0.27:8082/domain/50f581a9-730f-4c54-9cc2-74fc8369ab40
2026-05-14 03:38:44,764 - DEBUG - Requesting: http://10.0.0.27:8082/project/848007dc-4dc2-429c-b4a9-9b36ec0651bd
2026-05-14 03:38:44,880 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/64a5144d-e1c9-4cc6-b504-cc598d2a4218
2026-05-14 03:38:44,890 - DEBUG - =>VN ctest-left_vn-14995913 has no policy to be verified
2026-05-14 03:38:44,891 - DEBUG - Verifying the vn in opserver
2026-05-14 03:38:44,891 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-36638429:ctest-left_vn-14995913 virtual network link through opserver 10.0.0.27
2026-05-14 03:38:44,891 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-05-14 03:38:44,977 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-36638429:ctest-left_vn-14995913', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-36638429:ctest-left_vn-14995913?flat'}
2026-05-14 03:38:44,977 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-36638429:ctest-left_vn-14995913 virtual network link through opserver 10.0.0.22
2026-05-14 03:38:44,977 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-05-14 03:38:44,994 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-36638429:ctest-left_vn-14995913', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-36638429:ctest-left_vn-14995913?flat'}
2026-05-14 03:38:44,994 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-36638429:ctest-left_vn-14995913 virtual network link through opserver 10.0.0.23
2026-05-14 03:38:44,994 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-05-14 03:38:45,011 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-36638429:ctest-left_vn-14995913', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-36638429:ctest-left_vn-14995913?flat'}
2026-05-14 03:38:45,011 - INFO - Validated that VN default-domain:ctest-TestSvcHC-36638429:ctest-left_vn-14995913 is found in opserver
2026-05-14 03:38:45,047 - DEBUG - Do not have enough data to verify VN in agent
2026-05-14 03:38:45,060 - DEBUG - VRF ids for VN ctest-left_vn-14995913: {}
2026-05-14 03:38:45,476 - DEBUG - Response for create_network : {'network': {'id': '2aca30da-f57c-402d-86f0-27da2170c43c', 'name': 'ctest-right_vn-46342578', 'tenant_id': '848007dc4dc2429cb4a99b36ec0651bd', 'project_id': '848007dc4dc2429cb4a99b36ec0651bd', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-36638429', 'ctest-right_vn-46342578'], 'port_security_enabled': True, 'description': ''}}
2026-05-14 03:38:45,860 - DEBUG - Response for create_subnet : {'subnet': {'id': '5f9b61a9-9578-4a49-b871-004f28cc34ca', 'name': '', 'tenant_id': '848007dc4dc2429cb4a99b36ec0651bd', 'network_id': '2aca30da-f57c-402d-86f0-27da2170c43c', 'ip_version': 4, 'cidr': '137.128.69.192/26', 'allocation_pools': [{'start': '137.128.69.194', 'end': '137.128.69.254'}], 'gateway_ip': '137.128.69.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '137.128.69.194', 'tags': [], 'project_id': '848007dc4dc2429cb4a99b36ec0651bd'}}
2026-05-14 03:38:45,922 - INFO - Created VN ctest-right_vn-46342578
2026-05-14 03:38:45,940 - DEBUG - VN ctest-right_vn-46342578 UUID is 2aca30da-f57c-402d-86f0-27da2170c43c
2026-05-14 03:38:46,056 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-05-14 03:38:46,064 - DEBUG - Requesting: http://10.0.0.27:8082/domain/50f581a9-730f-4c54-9cc2-74fc8369ab40
2026-05-14 03:38:46,082 - DEBUG - Requesting: http://10.0.0.27:8082/project/848007dc-4dc2-429c-b4a9-9b36ec0651bd
2026-05-14 03:38:46,210 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/2aca30da-f57c-402d-86f0-27da2170c43c
2026-05-14 03:38:46,234 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/2aca30da-f57c-402d-86f0-27da2170c43c
2026-05-14 03:38:46,250 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/81af02d1-2e37-43e4-8764-a8329b958d0f
2026-05-14 03:38:46,268 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/81af02d1-2e37-43e4-8764-a8329b958d0f
2026-05-14 03:38:46,283 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/81073cb1-191c-4c73-b7d7-d80abbeee5c6
2026-05-14 03:38:46,301 - DEBUG - Route Targets: ['target:64512:8000009']
2026-05-14 03:38:46,301 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/2aca30da-f57c-402d-86f0-27da2170c43c
2026-05-14 03:38:46,322 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/81af02d1-2e37-43e4-8764-a8329b958d0f
2026-05-14 03:38:46,349 - INFO - Verified VN network id 20 for VN 2aca30da-f57c-402d-86f0-27da2170c43c
2026-05-14 03:38:46,349 - INFO - Verifications in API Server for VN ctest-right_vn-46342578 passed
2026-05-14 03:38:46,349 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/2aca30da-f57c-402d-86f0-27da2170c43c
2026-05-14 03:38:46,371 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/81af02d1-2e37-43e4-8764-a8329b958d0f
2026-05-14 03:38:46,388 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/81af02d1-2e37-43e4-8764-a8329b958d0f
2026-05-14 03:38:46,407 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/81073cb1-191c-4c73-b7d7-d80abbeee5c6
2026-05-14 03:38:46,426 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-36638429:ctest-right_vn-46342578', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-36638429', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3083330611868090413', 'uuid-lslong': '9723315413310293052'}, 'enable': 'true', 'created': '2026-05-14T03:38:45', 'last-modified': '2026-05-14T03:38:45', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.662375'}
2026-05-14 03:38:46,437 - DEBUG - Route Targets: ['target:64512:8000009']
2026-05-14 03:38:46,448 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-36638429:ctest-right_vn-46342578', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-36638429', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3083330611868090413', 'uuid-lslong': '9723315413310293052'}, 'enable': 'true', 'created': '2026-05-14T03:38:45', 'last-modified': '2026-05-14T03:38:45', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.674230'}
2026-05-14 03:38:46,463 - DEBUG - Route Targets: ['target:64512:8000009']
2026-05-14 03:38:46,471 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-36638429:ctest-right_vn-46342578', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-36638429', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3083330611868090413', 'uuid-lslong': '9723315413310293052'}, 'enable': 'true', 'created': '2026-05-14T03:38:45', 'last-modified': '2026-05-14T03:38:45', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.697368'}
2026-05-14 03:38:46,485 - DEBUG - Route Targets: ['target:64512:8000009']
2026-05-14 03:38:46,485 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-46342578 passed
2026-05-14 03:38:46,486 - DEBUG - ====Verifying policy data for ctest-right_vn-46342578 in API_Server ======
2026-05-14 03:38:46,486 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-05-14 03:38:46,495 - DEBUG - Requesting: http://10.0.0.27:8082/domain/50f581a9-730f-4c54-9cc2-74fc8369ab40
2026-05-14 03:38:46,511 - DEBUG - Requesting: http://10.0.0.27:8082/project/848007dc-4dc2-429c-b4a9-9b36ec0651bd
2026-05-14 03:38:46,631 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/2aca30da-f57c-402d-86f0-27da2170c43c
2026-05-14 03:38:46,645 - DEBUG - =>VN ctest-right_vn-46342578 has no policy to be verified
2026-05-14 03:38:46,645 - DEBUG - Verifying the vn in opserver
2026-05-14 03:38:46,645 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-36638429:ctest-right_vn-46342578 virtual network link through opserver 10.0.0.27
2026-05-14 03:38:46,645 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-05-14 03:38:46,664 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-36638429:ctest-right_vn-46342578', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-36638429:ctest-right_vn-46342578?flat'}
2026-05-14 03:38:46,664 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-36638429:ctest-right_vn-46342578 virtual network link through opserver 10.0.0.22
2026-05-14 03:38:46,664 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-05-14 03:38:46,684 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-36638429:ctest-right_vn-46342578', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-36638429:ctest-right_vn-46342578?flat'}
2026-05-14 03:38:46,684 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-36638429:ctest-right_vn-46342578 virtual network link through opserver 10.0.0.23
2026-05-14 03:38:46,684 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-05-14 03:38:46,704 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-36638429:ctest-right_vn-46342578', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-36638429:ctest-right_vn-46342578?flat'}
2026-05-14 03:38:46,704 - INFO - Validated that VN default-domain:ctest-TestSvcHC-36638429:ctest-right_vn-46342578 is found in opserver
2026-05-14 03:38:46,732 - DEBUG - Do not have enough data to verify VN in agent
2026-05-14 03:38:46,750 - DEBUG - VRF ids for VN ctest-right_vn-46342578: {}
2026-05-14 03:38:47,084 - DEBUG - Response for create_network : {'network': {'id': 'fd083bb7-0d7d-4b0c-906b-f1b8d8283b96', 'name': 'ctest-trans_left_vn-79045584', 'tenant_id': '848007dc4dc2429cb4a99b36ec0651bd', 'project_id': '848007dc4dc2429cb4a99b36ec0651bd', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-36638429', 'ctest-trans_left_vn-79045584'], 'port_security_enabled': True, 'description': ''}}
2026-05-14 03:38:47,327 - DEBUG - Response for create_subnet : {'subnet': {'id': '248a8a00-8314-48c6-82eb-08e932a1ce26', 'name': '', 'tenant_id': '848007dc4dc2429cb4a99b36ec0651bd', 'network_id': 'fd083bb7-0d7d-4b0c-906b-f1b8d8283b96', 'ip_version': 4, 'cidr': '178.34.2.128/26', 'allocation_pools': [{'start': '178.34.2.130', 'end': '178.34.2.190'}], 'gateway_ip': '178.34.2.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '178.34.2.130', 'tags': [], 'project_id': '848007dc4dc2429cb4a99b36ec0651bd'}}
2026-05-14 03:38:47,361 - INFO - Created VN ctest-trans_left_vn-79045584
2026-05-14 03:38:47,376 - DEBUG - VN ctest-trans_left_vn-79045584 UUID is fd083bb7-0d7d-4b0c-906b-f1b8d8283b96
2026-05-14 03:38:47,476 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-05-14 03:38:47,487 - DEBUG - Requesting: http://10.0.0.27:8082/domain/50f581a9-730f-4c54-9cc2-74fc8369ab40
2026-05-14 03:38:47,506 - DEBUG - Requesting: http://10.0.0.27:8082/project/848007dc-4dc2-429c-b4a9-9b36ec0651bd
2026-05-14 03:38:47,617 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/fd083bb7-0d7d-4b0c-906b-f1b8d8283b96
2026-05-14 03:38:47,632 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/fd083bb7-0d7d-4b0c-906b-f1b8d8283b96
2026-05-14 03:38:47,644 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/affa5123-d7da-46b0-9b64-53bddf9dd62e
2026-05-14 03:38:47,657 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/affa5123-d7da-46b0-9b64-53bddf9dd62e
2026-05-14 03:38:47,669 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/a9ecf35e-fbdd-4ac7-b51c-0252e32c3e2d
2026-05-14 03:38:47,679 - DEBUG - Route Targets: ['target:64512:8000010']
2026-05-14 03:38:47,679 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/fd083bb7-0d7d-4b0c-906b-f1b8d8283b96
2026-05-14 03:38:47,693 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/affa5123-d7da-46b0-9b64-53bddf9dd62e
2026-05-14 03:38:47,718 - INFO - Verified VN network id 21 for VN fd083bb7-0d7d-4b0c-906b-f1b8d8283b96
2026-05-14 03:38:47,718 - INFO - Verifications in API Server for VN ctest-trans_left_vn-79045584 passed
2026-05-14 03:38:47,718 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/fd083bb7-0d7d-4b0c-906b-f1b8d8283b96
2026-05-14 03:38:47,730 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/affa5123-d7da-46b0-9b64-53bddf9dd62e
2026-05-14 03:38:47,741 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/affa5123-d7da-46b0-9b64-53bddf9dd62e
2026-05-14 03:38:47,753 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/a9ecf35e-fbdd-4ac7-b51c-0252e32c3e2d
2026-05-14 03:38:47,770 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-36638429:ctest-trans_left_vn-79045584', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-36638429', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '18232888748800822028', 'uuid-lslong': '10406677140172454806'}, 'enable': 'true', 'created': '2026-05-14T03:38:47', 'last-modified': '2026-05-14T03:38:47', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.489857'}
2026-05-14 03:38:47,783 - DEBUG - Route Targets: ['target:64512:8000010']
2026-05-14 03:38:47,791 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-36638429:ctest-trans_left_vn-79045584', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-36638429', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '18232888748800822028', 'uuid-lslong': '10406677140172454806'}, 'enable': 'true', 'created': '2026-05-14T03:38:47', 'last-modified': '2026-05-14T03:38:47', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.513587'}
2026-05-14 03:38:47,800 - DEBUG - Route Targets: ['target:64512:8000010']
2026-05-14 03:38:47,808 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-36638429:ctest-trans_left_vn-79045584', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-36638429', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '18232888748800822028', 'uuid-lslong': '10406677140172454806'}, 'enable': 'true', 'created': '2026-05-14T03:38:47', 'last-modified': '2026-05-14T03:38:47', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.528175'}
2026-05-14 03:38:47,818 - DEBUG - Route Targets: ['target:64512:8000010']
2026-05-14 03:38:47,819 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_left_vn-79045584 passed
2026-05-14 03:38:47,819 - DEBUG - ====Verifying policy data for ctest-trans_left_vn-79045584 in API_Server ======
2026-05-14 03:38:47,819 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-05-14 03:38:47,829 - DEBUG - Requesting: http://10.0.0.27:8082/domain/50f581a9-730f-4c54-9cc2-74fc8369ab40
2026-05-14 03:38:47,848 - DEBUG - Requesting: http://10.0.0.27:8082/project/848007dc-4dc2-429c-b4a9-9b36ec0651bd
2026-05-14 03:38:47,958 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/fd083bb7-0d7d-4b0c-906b-f1b8d8283b96
2026-05-14 03:38:47,979 - DEBUG - =>VN ctest-trans_left_vn-79045584 has no policy to be verified
2026-05-14 03:38:47,979 - DEBUG - Verifying the vn in opserver
2026-05-14 03:38:47,979 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-36638429:ctest-trans_left_vn-79045584 virtual network link through opserver 10.0.0.27
2026-05-14 03:38:47,980 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-05-14 03:38:47,995 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-36638429:ctest-trans_left_vn-79045584', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-36638429:ctest-trans_left_vn-79045584?flat'}
2026-05-14 03:38:47,995 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-36638429:ctest-trans_left_vn-79045584 virtual network link through opserver 10.0.0.22
2026-05-14 03:38:47,995 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-05-14 03:38:48,013 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-36638429:ctest-trans_left_vn-79045584', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-36638429:ctest-trans_left_vn-79045584?flat'}
2026-05-14 03:38:48,013 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-36638429:ctest-trans_left_vn-79045584 virtual network link through opserver 10.0.0.23
2026-05-14 03:38:48,013 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-05-14 03:38:48,032 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-36638429:ctest-trans_left_vn-79045584', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-36638429:ctest-trans_left_vn-79045584?flat'}
2026-05-14 03:38:48,032 - INFO - Validated that VN default-domain:ctest-TestSvcHC-36638429:ctest-trans_left_vn-79045584 is found in opserver
2026-05-14 03:38:48,067 - DEBUG - Do not have enough data to verify VN in agent
2026-05-14 03:38:48,080 - DEBUG - VRF ids for VN ctest-trans_left_vn-79045584: {}
2026-05-14 03:38:48,411 - DEBUG - Response for create_network : {'network': {'id': 'c609cb90-4ab6-4656-aab3-241eb3ebfa79', 'name': 'ctest-trans_right_vn-26573538', 'tenant_id': '848007dc4dc2429cb4a99b36ec0651bd', 'project_id': '848007dc4dc2429cb4a99b36ec0651bd', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-36638429', 'ctest-trans_right_vn-26573538'], 'port_security_enabled': True, 'description': ''}}
2026-05-14 03:38:48,703 - DEBUG - Response for create_subnet : {'subnet': {'id': '8c509f4e-db5b-4c43-a984-b0d65f16cbab', 'name': '', 'tenant_id': '848007dc4dc2429cb4a99b36ec0651bd', 'network_id': 'c609cb90-4ab6-4656-aab3-241eb3ebfa79', 'ip_version': 4, 'cidr': '177.148.1.192/26', 'allocation_pools': [{'start': '177.148.1.194', 'end': '177.148.1.254'}], 'gateway_ip': '177.148.1.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '177.148.1.194', 'tags': [], 'project_id': '848007dc4dc2429cb4a99b36ec0651bd'}}
2026-05-14 03:38:48,743 - INFO - Created VN ctest-trans_right_vn-26573538
2026-05-14 03:38:48,763 - DEBUG - VN ctest-trans_right_vn-26573538 UUID is c609cb90-4ab6-4656-aab3-241eb3ebfa79
2026-05-14 03:38:48,857 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-05-14 03:38:48,864 - DEBUG - Requesting: http://10.0.0.27:8082/domain/50f581a9-730f-4c54-9cc2-74fc8369ab40
2026-05-14 03:38:48,879 - DEBUG - Requesting: http://10.0.0.27:8082/project/848007dc-4dc2-429c-b4a9-9b36ec0651bd
2026-05-14 03:38:48,977 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/c609cb90-4ab6-4656-aab3-241eb3ebfa79
2026-05-14 03:38:48,991 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/c609cb90-4ab6-4656-aab3-241eb3ebfa79
2026-05-14 03:38:49,002 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/7d6bc32e-1e4d-468d-8ca5-c75c4661f9b2
2026-05-14 03:38:49,012 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/7d6bc32e-1e4d-468d-8ca5-c75c4661f9b2
2026-05-14 03:38:49,021 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/c5160ddb-f96c-4465-94c3-1c723c3ed394
2026-05-14 03:38:49,029 - DEBUG - Route Targets: ['target:64512:8000011']
2026-05-14 03:38:49,030 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/c609cb90-4ab6-4656-aab3-241eb3ebfa79
2026-05-14 03:38:49,040 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/7d6bc32e-1e4d-468d-8ca5-c75c4661f9b2
2026-05-14 03:38:49,059 - INFO - Verified VN network id 22 for VN c609cb90-4ab6-4656-aab3-241eb3ebfa79
2026-05-14 03:38:49,059 - INFO - Verifications in API Server for VN ctest-trans_right_vn-26573538 passed
2026-05-14 03:38:49,059 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/c609cb90-4ab6-4656-aab3-241eb3ebfa79
2026-05-14 03:38:49,072 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/7d6bc32e-1e4d-468d-8ca5-c75c4661f9b2
2026-05-14 03:38:49,082 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/7d6bc32e-1e4d-468d-8ca5-c75c4661f9b2
2026-05-14 03:38:49,091 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/c5160ddb-f96c-4465-94c3-1c723c3ed394
2026-05-14 03:38:49,105 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-36638429:ctest-trans_right_vn-26573538', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-36638429', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '14270160714889315926', 'uuid-lslong': '12300214721565162105'}, 'enable': 'true', 'created': '2026-05-14T03:38:48', 'last-modified': '2026-05-14T03:38:48', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.494578'}
2026-05-14 03:38:49,111 - DEBUG - Route Targets: ['target:64512:8000011']
2026-05-14 03:38:49,118 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-36638429:ctest-trans_right_vn-26573538', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-36638429', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '14270160714889315926', 'uuid-lslong': '12300214721565162105'}, 'enable': 'true', 'created': '2026-05-14T03:38:48', 'last-modified': '2026-05-14T03:38:48', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.500670'}
2026-05-14 03:38:49,125 - DEBUG - Route Targets: ['target:64512:8000011']
2026-05-14 03:38:49,132 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-36638429:ctest-trans_right_vn-26573538', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-36638429', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '14270160714889315926', 'uuid-lslong': '12300214721565162105'}, 'enable': 'true', 'created': '2026-05-14T03:38:48', 'last-modified': '2026-05-14T03:38:48', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.521023'}
2026-05-14 03:38:49,139 - DEBUG - Route Targets: ['target:64512:8000011']
2026-05-14 03:38:49,139 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_right_vn-26573538 passed
2026-05-14 03:38:49,139 - DEBUG - ====Verifying policy data for ctest-trans_right_vn-26573538 in API_Server ======
2026-05-14 03:38:49,139 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-05-14 03:38:49,149 - DEBUG - Requesting: http://10.0.0.27:8082/domain/50f581a9-730f-4c54-9cc2-74fc8369ab40
2026-05-14 03:38:49,162 - DEBUG - Requesting: http://10.0.0.27:8082/project/848007dc-4dc2-429c-b4a9-9b36ec0651bd
2026-05-14 03:38:49,268 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/c609cb90-4ab6-4656-aab3-241eb3ebfa79
2026-05-14 03:38:49,288 - DEBUG - =>VN ctest-trans_right_vn-26573538 has no policy to be verified
2026-05-14 03:38:49,288 - DEBUG - Verifying the vn in opserver
2026-05-14 03:38:49,288 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-36638429:ctest-trans_right_vn-26573538 virtual network link through opserver 10.0.0.27
2026-05-14 03:38:49,288 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-05-14 03:38:49,305 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-36638429:ctest-trans_right_vn-26573538', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-36638429:ctest-trans_right_vn-26573538?flat'}
2026-05-14 03:38:49,305 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-36638429:ctest-trans_right_vn-26573538 virtual network link through opserver 10.0.0.22
2026-05-14 03:38:49,305 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-05-14 03:38:49,324 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-36638429:ctest-trans_right_vn-26573538', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-36638429:ctest-trans_right_vn-26573538?flat'}
2026-05-14 03:38:49,324 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-36638429:ctest-trans_right_vn-26573538 virtual network link through opserver 10.0.0.23
2026-05-14 03:38:49,325 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-05-14 03:38:49,344 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-36638429:ctest-trans_right_vn-26573538', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-36638429:ctest-trans_right_vn-26573538?flat'}
2026-05-14 03:38:49,344 - INFO - Validated that VN default-domain:ctest-TestSvcHC-36638429:ctest-trans_right_vn-26573538 is found in opserver
2026-05-14 03:38:49,374 - DEBUG - Do not have enough data to verify VN in agent
2026-05-14 03:38:49,387 - DEBUG - VRF ids for VN ctest-trans_right_vn-26573538: {}
2026-05-14 03:38:50,821 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5780-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5780-2)
2026-05-14 03:38:52,603 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5780-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5780-1)
2026-05-14 03:38:52,603 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-44653275']
2026-05-14 03:38:52,939 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-44653275'] created succesfully
2026-05-14 03:38:53,462 - DEBUG - Image by name tiny_trans_fw not found
2026-05-14 03:38:53,462 - DEBUG - Installing image tiny_trans_fw
2026-05-14 03:38:53,462 - 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'}
2026-05-14 03:38:53,462 - DEBUG - Image build path file:///contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2026-05-14 03:38:53,462 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2026-05-14 03:38:53,462 - DEBUG - Unzip image
2026-05-14 03:38:53,463 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2026-05-14 03:38:53,483 - INFO - image /contrail-test/images/tinycore-net-transparent-fw.qcow2 is not found
2026-05-14 03:38:53,483 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-44653275']
2026-05-14 03:38:53,611 - INFO - Service template: ['default-domain', 'ctest-service_template_1-44653275'] deleted successfully.
2026-05-14 03:38:53,611 - INFO - Skip interface_detach for VM ctest-right_vm-21896918 in state BUILD
2026-05-14 03:38:53,611 - INFO - Deleting VM ctest-right_vm-21896918
2026-05-14 03:38:53,611 - ERROR - VM ctest-right_vm-21896918 has failed to come up
2026-05-14 03:38:53,611 - ERROR - Nova failed to get host of the VM
2026-05-14 03:38:53,611 - ERROR - VM ctest-right_vm-21896918 has failed to come up
2026-05-14 03:38:53,611 - ERROR - Nova failed to get host of the VM
2026-05-14 03:38:53,724 - INFO - Skip interface_detach for VM ctest-left_vm-08989180 in state BUILD
2026-05-14 03:38:53,724 - INFO - Deleting VM ctest-left_vm-08989180
2026-05-14 03:38:53,724 - ERROR - VM ctest-left_vm-08989180 has failed to come up
2026-05-14 03:38:53,724 - ERROR - Nova failed to get host of the VM
2026-05-14 03:38:53,724 - ERROR - VM ctest-left_vm-08989180 has failed to come up
2026-05-14 03:38:53,724 - ERROR - Nova failed to get host of the VM
2026-05-14 03:38:53,814 - INFO - Deleting VN ctest-trans_right_vn-26573538
2026-05-14 03:38:54,007 - DEBUG - Response for deleting network ()
2026-05-14 03:38:54,007 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/7d6bc32e-1e4d-468d-8ca5-c75c4661f9b2
2026-05-14 03:38:54,015 - DEBUG - Response Code: 404
2026-05-14 03:38:54,015 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-05-14 03:38:54,023 - DEBUG - Requesting: http://10.0.0.27:8082/domain/50f581a9-730f-4c54-9cc2-74fc8369ab40
2026-05-14 03:38:54,051 - DEBUG - Requesting: http://10.0.0.27:8082/project/848007dc-4dc2-429c-b4a9-9b36ec0651bd
2026-05-14 03:38:54,155 - INFO - Validated that VN ctest-trans_right_vn-26573538 is not found in API Server
2026-05-14 03:38:54,172 - DEBUG - VN ctest-trans_right_vn-26573538 is not present in Agent 10.0.0.240
2026-05-14 03:38:54,183 - DEBUG - VN ctest-trans_right_vn-26573538 is not present in Agent 10.0.0.65
2026-05-14 03:38:54,183 - INFO - Validated that VN ctest-trans_right_vn-26573538 is not in any agent
2026-05-14 03:38:54,229 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-trans_right_vn-26573538 info
2026-05-14 03:38:54,229 - INFO - Deleting VN ctest-trans_left_vn-79045584
2026-05-14 03:38:54,432 - DEBUG - Response for deleting network ()
2026-05-14 03:38:54,432 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/affa5123-d7da-46b0-9b64-53bddf9dd62e
2026-05-14 03:38:54,443 - DEBUG - Response Code: 404
2026-05-14 03:38:54,443 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-05-14 03:38:54,460 - DEBUG - Requesting: http://10.0.0.27:8082/domain/50f581a9-730f-4c54-9cc2-74fc8369ab40
2026-05-14 03:38:54,484 - DEBUG - Requesting: http://10.0.0.27:8082/project/848007dc-4dc2-429c-b4a9-9b36ec0651bd
2026-05-14 03:38:54,616 - INFO - Validated that VN ctest-trans_left_vn-79045584 is not found in API Server
2026-05-14 03:38:54,643 - DEBUG - VN ctest-trans_left_vn-79045584 is not present in Agent 10.0.0.240
2026-05-14 03:38:54,664 - DEBUG - VN ctest-trans_left_vn-79045584 is not present in Agent 10.0.0.65
2026-05-14 03:38:54,664 - INFO - Validated that VN ctest-trans_left_vn-79045584 is not in any agent
2026-05-14 03:38:54,740 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-trans_left_vn-79045584 info
2026-05-14 03:38:54,740 - INFO - Deleting VN ctest-right_vn-46342578
2026-05-14 03:38:54,825 - DEBUG - VN 2aca30da-f57c-402d-86f0-27da2170c43c still in use: Unable to complete operation on network 2aca30da-f57c-402d-86f0-27da2170c43c. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-fcabd6f6-a8f1-4638-9a2a-c0be5a2e1109']
2026-05-14 03:38:54,826 - WARNING - Deleting VN ctest-right_vn-46342578 failed..Will retry
2026-05-14 03:38:57,060 - DEBUG - Response for deleting network ()
2026-05-14 03:38:57,061 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/81af02d1-2e37-43e4-8764-a8329b958d0f
2026-05-14 03:38:57,073 - DEBUG - Response Code: 404
2026-05-14 03:38:57,073 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-05-14 03:38:57,082 - DEBUG - Requesting: http://10.0.0.27:8082/domain/50f581a9-730f-4c54-9cc2-74fc8369ab40
2026-05-14 03:38:57,098 - DEBUG - Requesting: http://10.0.0.27:8082/project/848007dc-4dc2-429c-b4a9-9b36ec0651bd
2026-05-14 03:38:57,251 - INFO - Validated that VN ctest-right_vn-46342578 is not found in API Server
2026-05-14 03:38:57,264 - DEBUG - VN ctest-right_vn-46342578 is not present in Agent 10.0.0.240
2026-05-14 03:38:57,281 - DEBUG - VN ctest-right_vn-46342578 is not present in Agent 10.0.0.65
2026-05-14 03:38:57,281 - INFO - Validated that VN ctest-right_vn-46342578 is not in any agent
2026-05-14 03:38:57,333 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-46342578 info
2026-05-14 03:38:57,334 - INFO - Deleting VN ctest-left_vn-14995913
2026-05-14 03:38:57,538 - DEBUG - Response for deleting network ()
2026-05-14 03:38:57,538 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/87309ec1-4e0d-44ce-bf13-ed42d461cafc
2026-05-14 03:38:57,548 - DEBUG - Response Code: 404
2026-05-14 03:38:57,548 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-05-14 03:38:57,569 - DEBUG - Requesting: http://10.0.0.27:8082/domain/50f581a9-730f-4c54-9cc2-74fc8369ab40
2026-05-14 03:38:57,586 - DEBUG - Requesting: http://10.0.0.27:8082/project/848007dc-4dc2-429c-b4a9-9b36ec0651bd
2026-05-14 03:38:57,717 - INFO - Validated that VN ctest-left_vn-14995913 is not found in API Server
2026-05-14 03:38:57,731 - DEBUG - VN ctest-left_vn-14995913 is not present in Agent 10.0.0.240
2026-05-14 03:38:57,744 - DEBUG - VN ctest-left_vn-14995913 is not present in Agent 10.0.0.65
2026-05-14 03:38:57,744 - INFO - Validated that VN ctest-left_vn-14995913 is not in any agent
2026-05-14 03:38:57,789 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-14995913 info
2026-05-14 03:38:57,789 - INFO - Deleting VN ctest-mgmt_vn-22621661
2026-05-14 03:38:57,970 - DEBUG - Response for deleting network ()
2026-05-14 03:38:57,971 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/526b7ab0-181c-4d35-a1e6-11028a26b7b0
2026-05-14 03:38:57,980 - DEBUG - Response Code: 404
2026-05-14 03:38:57,980 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-05-14 03:38:57,990 - DEBUG - Requesting: http://10.0.0.27:8082/domain/50f581a9-730f-4c54-9cc2-74fc8369ab40
2026-05-14 03:38:58,028 - DEBUG - Requesting: http://10.0.0.27:8082/project/848007dc-4dc2-429c-b4a9-9b36ec0651bd
2026-05-14 03:38:58,168 - INFO - Validated that VN ctest-mgmt_vn-22621661 is not found in API Server
2026-05-14 03:38:58,181 - DEBUG - VN ctest-mgmt_vn-22621661 is not present in Agent 10.0.0.240
2026-05-14 03:38:58,196 - DEBUG - VN ctest-mgmt_vn-22621661 is not present in Agent 10.0.0.65
2026-05-14 03:38:58,196 - INFO - Validated that VN ctest-mgmt_vn-22621661 is not in any agent
2026-05-14 03:38:58,250 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-22621661 info
2026-05-14 03:38:59,560 - DEBUG - No XMPP flaps were noticed during the test
2026-05-14 03:38:59,560 - INFO -
2026-05-14 03:38:59,560 - INFO - END TEST : test_svc_trans_segment_right_hc_fail_svm : SKIPPED[0:00:19]
2026-05-14 03:38:59,560 - INFO - --------------------------------------------------------------------------------
2026-05-14 03:39:00,518 - INFO - Deleted project: ctest-TestSvcHC-36638429, ID : 848007dc-4dc2-429c-b4a9-9b36ec0651bd