2026-06-01 16:41:41,799 - INFO - Domain Default found not creating
2026-06-01 16:41:42,050 - INFO - Project ctest-TestSvcHC-08051395 not found, creating it
2026-06-01 16:41:42,575 - INFO - Created Project:ctest-TestSvcHC-08051395, ID : 45ef1a62-5dad-445c-924b-7ae6933cce02
2026-06-01 16:41:44,368 - INFO - ================================================================================
2026-06-01 16:41:44,368 - INFO - STARTING TEST : test_svc_hc_basic
2026-06-01 16:41:45,681 - DEBUG - Nothing to compare xmpp stats {'10.0.0.141': {'10.20.0.17': '3', '10.20.0.254': '3'}, '10.0.0.27': {'10.20.0.14': '2', '10.20.0.254': '3'}} with
2026-06-01 16:41:45,682 - INFO - Initial checks done. Running the testcase now
2026-06-01 16:41:45,682 - INFO -
2026-06-01 16:41:46,401 - DEBUG - Response for create_network : {'network': {'id': 'b116aa46-3bd3-4d0a-98f3-7e6900dc7180', 'name': 'ctest-mgmt_vn-78612988', 'tenant_id': '45ef1a625dad445c924b7ae6933cce02', 'project_id': '45ef1a625dad445c924b7ae6933cce02', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-08051395', 'ctest-mgmt_vn-78612988'], 'port_security_enabled': True, 'description': ''}}
2026-06-01 16:41:46,758 - DEBUG - Response for create_subnet : {'subnet': {'id': 'e48345bf-872e-47b4-b147-c0d9d03e15b8', 'name': '', 'tenant_id': '45ef1a625dad445c924b7ae6933cce02', 'network_id': 'b116aa46-3bd3-4d0a-98f3-7e6900dc7180', 'ip_version': 4, 'cidr': '89.81.221.192/26', 'allocation_pools': [{'start': '89.81.221.194', 'end': '89.81.221.254'}], 'gateway_ip': '89.81.221.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '89.81.221.194', 'tags': [], 'project_id': '45ef1a625dad445c924b7ae6933cce02'}}
2026-06-01 16:41:46,783 - INFO - Created VN ctest-mgmt_vn-78612988
2026-06-01 16:41:46,798 - DEBUG - VN ctest-mgmt_vn-78612988 UUID is b116aa46-3bd3-4d0a-98f3-7e6900dc7180
2026-06-01 16:41:46,897 - DEBUG - Requesting: http://10.0.0.241:8082/domains
2026-06-01 16:41:47,199 - DEBUG - Requesting: http://10.0.0.241:8082/domains
2026-06-01 16:41:47,234 - DEBUG - Requesting: http://10.0.0.241:8082/domain/4934cdf0-e2c0-49f7-8ec1-47ce02d5e849
2026-06-01 16:41:47,250 - DEBUG - Requesting: http://10.0.0.241:8082/project/45ef1a62-5dad-445c-924b-7ae6933cce02
2026-06-01 16:41:47,375 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-network/b116aa46-3bd3-4d0a-98f3-7e6900dc7180
2026-06-01 16:41:47,401 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-network/b116aa46-3bd3-4d0a-98f3-7e6900dc7180
2026-06-01 16:41:47,419 - DEBUG - Requesting: http://10.0.0.241:8082/routing-instance/e11cd62a-fe47-42b0-8cbf-ebebfa53f3a7
2026-06-01 16:41:47,429 - DEBUG - Requesting: http://10.0.0.241:8082/routing-instance/e11cd62a-fe47-42b0-8cbf-ebebfa53f3a7
2026-06-01 16:41:47,438 - DEBUG - Requesting: http://10.0.0.241:8082/route-target/d8b68286-0b5c-4d97-8dab-a6904bb8edc9
2026-06-01 16:41:47,451 - DEBUG - Route Targets: ['target:64512:8000008']
2026-06-01 16:41:47,451 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-network/b116aa46-3bd3-4d0a-98f3-7e6900dc7180
2026-06-01 16:41:47,463 - DEBUG - Requesting: http://10.0.0.241:8082/routing-instance/e11cd62a-fe47-42b0-8cbf-ebebfa53f3a7
2026-06-01 16:41:47,482 - INFO - Verified VN network id 18 for VN b116aa46-3bd3-4d0a-98f3-7e6900dc7180
2026-06-01 16:41:47,482 - INFO - Verifications in API Server for VN ctest-mgmt_vn-78612988 passed
2026-06-01 16:41:47,482 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-network/b116aa46-3bd3-4d0a-98f3-7e6900dc7180
2026-06-01 16:41:47,496 - DEBUG - Requesting: http://10.0.0.241:8082/routing-instance/e11cd62a-fe47-42b0-8cbf-ebebfa53f3a7
2026-06-01 16:41:47,507 - DEBUG - Requesting: http://10.0.0.241:8082/routing-instance/e11cd62a-fe47-42b0-8cbf-ebebfa53f3a7
2026-06-01 16:41:47,522 - DEBUG - Requesting: http://10.0.0.241:8082/route-target/d8b68286-0b5c-4d97-8dab-a6904bb8edc9
2026-06-01 16:41:47,537 - DEBUG - Control-node 10.0.0.241 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-08051395:ctest-mgmt_vn-78612988', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-08051395', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12760573812829015306', 'uuid-lslong': '11021291702556848512'}, 'enable': 'true', 'created': '2026-06-01T16:41:46', 'last-modified': '2026-06-01T16:41:46', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.861853'}
2026-06-01 16:41:47,547 - DEBUG - Route Targets: ['target:64512:8000008']
2026-06-01 16:41:47,556 - DEBUG - Control-node 10.0.0.242 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-08051395:ctest-mgmt_vn-78612988', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-08051395', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12760573812829015306', 'uuid-lslong': '11021291702556848512'}, 'enable': 'true', 'created': '2026-06-01T16:41:46', 'last-modified': '2026-06-01T16:41:46', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.880290'}
2026-06-01 16:41:47,567 - DEBUG - Route Targets: ['target:64512:8000008']
2026-06-01 16:41:47,573 - DEBUG - Control-node 10.0.0.19 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-08051395:ctest-mgmt_vn-78612988', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-08051395', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12760573812829015306', 'uuid-lslong': '11021291702556848512'}, 'enable': 'true', 'created': '2026-06-01T16:41:46', 'last-modified': '2026-06-01T16:41:46', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.900527'}
2026-06-01 16:41:47,580 - DEBUG - Route Targets: ['target:64512:8000008']
2026-06-01 16:41:47,580 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-78612988 passed
2026-06-01 16:41:47,580 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-78612988 in API_Server ======
2026-06-01 16:41:47,580 - DEBUG - Requesting: http://10.0.0.241:8082/domains
2026-06-01 16:41:47,588 - DEBUG - Requesting: http://10.0.0.241:8082/domain/4934cdf0-e2c0-49f7-8ec1-47ce02d5e849
2026-06-01 16:41:47,602 - DEBUG - Requesting: http://10.0.0.241:8082/project/45ef1a62-5dad-445c-924b-7ae6933cce02
2026-06-01 16:41:47,725 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-network/b116aa46-3bd3-4d0a-98f3-7e6900dc7180
2026-06-01 16:41:47,741 - DEBUG - =>VN ctest-mgmt_vn-78612988 has no policy to be verified
2026-06-01 16:41:47,741 - DEBUG - Verifying the vn in opserver
2026-06-01 16:41:47,741 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-08051395:ctest-mgmt_vn-78612988 virtual network link through opserver 10.0.0.241
2026-06-01 16:41:47,742 - DEBUG - Requesting: http://10.0.0.241:8081/analytics/uves/virtual-networks
2026-06-01 16:41:48,058 - DEBUG - Requesting: http://10.0.0.241:8081/analytics/uves/virtual-networks
2026-06-01 16:41:48,159 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-08051395:ctest-mgmt_vn-78612988', 'href': 'http://10.0.0.241:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-08051395:ctest-mgmt_vn-78612988?flat'}
2026-06-01 16:41:48,159 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-08051395:ctest-mgmt_vn-78612988 virtual network link through opserver 10.0.0.242
2026-06-01 16:41:48,159 - DEBUG - Requesting: http://10.0.0.242:8081/analytics/uves/virtual-networks
2026-06-01 16:41:48,479 - DEBUG - Requesting: http://10.0.0.242:8081/analytics/uves/virtual-networks
2026-06-01 16:41:48,551 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-08051395:ctest-mgmt_vn-78612988', 'href': 'http://10.0.0.242:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-08051395:ctest-mgmt_vn-78612988?flat'}
2026-06-01 16:41:48,551 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-08051395:ctest-mgmt_vn-78612988 virtual network link through opserver 10.0.0.19
2026-06-01 16:41:48,551 - DEBUG - Requesting: http://10.0.0.19:8081/analytics/uves/virtual-networks
2026-06-01 16:41:48,861 - DEBUG - Requesting: http://10.0.0.19:8081/analytics/uves/virtual-networks
2026-06-01 16:41:48,931 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-08051395:ctest-mgmt_vn-78612988', 'href': 'http://10.0.0.19:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-08051395:ctest-mgmt_vn-78612988?flat'}
2026-06-01 16:41:48,931 - INFO - Validated that VN default-domain:ctest-TestSvcHC-08051395:ctest-mgmt_vn-78612988 is found in opserver
2026-06-01 16:41:48,955 - DEBUG - Do not have enough data to verify VN in agent
2026-06-01 16:41:48,968 - DEBUG - VRF ids for VN ctest-mgmt_vn-78612988: {}
2026-06-01 16:41:49,291 - DEBUG - Response for create_network : {'network': {'id': '622f61de-2b33-4301-b1bc-0262d762a836', 'name': 'ctest-left_vn-51787431', 'tenant_id': '45ef1a625dad445c924b7ae6933cce02', 'project_id': '45ef1a625dad445c924b7ae6933cce02', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-08051395', 'ctest-left_vn-51787431'], 'port_security_enabled': True, 'description': ''}}
2026-06-01 16:41:49,548 - DEBUG - Response for create_subnet : {'subnet': {'id': '1dcda611-7540-42dc-9876-5c470b3f7799', 'name': '', 'tenant_id': '45ef1a625dad445c924b7ae6933cce02', 'network_id': '622f61de-2b33-4301-b1bc-0262d762a836', 'ip_version': 4, 'cidr': '32.140.188.128/26', 'allocation_pools': [{'start': '32.140.188.130', 'end': '32.140.188.190'}], 'gateway_ip': '32.140.188.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '32.140.188.130', 'tags': [], 'project_id': '45ef1a625dad445c924b7ae6933cce02'}}
2026-06-01 16:41:49,575 - INFO - Created VN ctest-left_vn-51787431
2026-06-01 16:41:49,588 - DEBUG - VN ctest-left_vn-51787431 UUID is 622f61de-2b33-4301-b1bc-0262d762a836
2026-06-01 16:41:49,705 - DEBUG - Requesting: http://10.0.0.241:8082/domains
2026-06-01 16:41:49,717 - DEBUG - Requesting: http://10.0.0.241:8082/domain/4934cdf0-e2c0-49f7-8ec1-47ce02d5e849
2026-06-01 16:41:49,733 - DEBUG - Requesting: http://10.0.0.241:8082/project/45ef1a62-5dad-445c-924b-7ae6933cce02
2026-06-01 16:41:49,848 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-network/622f61de-2b33-4301-b1bc-0262d762a836
2026-06-01 16:41:49,867 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-network/622f61de-2b33-4301-b1bc-0262d762a836
2026-06-01 16:41:49,889 - DEBUG - Requesting: http://10.0.0.241:8082/routing-instance/a29f3376-b970-4936-b8e5-b11248f76b10
2026-06-01 16:41:49,908 - DEBUG - Requesting: http://10.0.0.241:8082/routing-instance/a29f3376-b970-4936-b8e5-b11248f76b10
2026-06-01 16:41:49,923 - DEBUG - Requesting: http://10.0.0.241:8082/route-target/acf18eca-0b43-404c-925b-c5eaa2bb4771
2026-06-01 16:41:49,937 - DEBUG - Route Targets: ['target:64512:8000009']
2026-06-01 16:41:49,937 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-network/622f61de-2b33-4301-b1bc-0262d762a836
2026-06-01 16:41:49,962 - DEBUG - Requesting: http://10.0.0.241:8082/routing-instance/a29f3376-b970-4936-b8e5-b11248f76b10
2026-06-01 16:41:49,984 - INFO - Verified VN network id 19 for VN 622f61de-2b33-4301-b1bc-0262d762a836
2026-06-01 16:41:49,985 - INFO - Verifications in API Server for VN ctest-left_vn-51787431 passed
2026-06-01 16:41:49,985 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-network/622f61de-2b33-4301-b1bc-0262d762a836
2026-06-01 16:41:50,002 - DEBUG - Requesting: http://10.0.0.241:8082/routing-instance/a29f3376-b970-4936-b8e5-b11248f76b10
2026-06-01 16:41:50,013 - DEBUG - Requesting: http://10.0.0.241:8082/routing-instance/a29f3376-b970-4936-b8e5-b11248f76b10
2026-06-01 16:41:50,025 - DEBUG - Requesting: http://10.0.0.241:8082/route-target/acf18eca-0b43-404c-925b-c5eaa2bb4771
2026-06-01 16:41:50,050 - DEBUG - Control-node 10.0.0.241 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-08051395:ctest-left_vn-51787431', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-08051395', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7074981146457752321', 'uuid-lslong': '12807114063878465590'}, 'enable': 'true', 'created': '2026-06-01T16:41:49', 'last-modified': '2026-06-01T16:41:49', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.550107'}
2026-06-01 16:41:50,058 - DEBUG - Route Targets: ['target:64512:8000009']
2026-06-01 16:41:50,069 - DEBUG - Control-node 10.0.0.242 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-08051395:ctest-left_vn-51787431', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-08051395', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7074981146457752321', 'uuid-lslong': '12807114063878465590'}, 'enable': 'true', 'created': '2026-06-01T16:41:49', 'last-modified': '2026-06-01T16:41:49', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.570906'}
2026-06-01 16:41:50,080 - DEBUG - Route Targets: ['target:64512:8000009']
2026-06-01 16:41:50,088 - DEBUG - Control-node 10.0.0.19 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-08051395:ctest-left_vn-51787431', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-08051395', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7074981146457752321', 'uuid-lslong': '12807114063878465590'}, 'enable': 'true', 'created': '2026-06-01T16:41:49', 'last-modified': '2026-06-01T16:41:49', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.600501'}
2026-06-01 16:41:50,097 - DEBUG - Route Targets: ['target:64512:8000009']
2026-06-01 16:41:50,097 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-51787431 passed
2026-06-01 16:41:50,097 - DEBUG - ====Verifying policy data for ctest-left_vn-51787431 in API_Server ======
2026-06-01 16:41:50,097 - DEBUG - Requesting: http://10.0.0.241:8082/domains
2026-06-01 16:41:50,108 - DEBUG - Requesting: http://10.0.0.241:8082/domain/4934cdf0-e2c0-49f7-8ec1-47ce02d5e849
2026-06-01 16:41:50,126 - DEBUG - Requesting: http://10.0.0.241:8082/project/45ef1a62-5dad-445c-924b-7ae6933cce02
2026-06-01 16:41:50,238 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-network/622f61de-2b33-4301-b1bc-0262d762a836
2026-06-01 16:41:50,252 - DEBUG - =>VN ctest-left_vn-51787431 has no policy to be verified
2026-06-01 16:41:50,252 - DEBUG - Verifying the vn in opserver
2026-06-01 16:41:50,252 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-08051395:ctest-left_vn-51787431 virtual network link through opserver 10.0.0.241
2026-06-01 16:41:50,252 - DEBUG - Requesting: http://10.0.0.241:8081/analytics/uves/virtual-networks
2026-06-01 16:41:50,345 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-08051395:ctest-left_vn-51787431', 'href': 'http://10.0.0.241:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-08051395:ctest-left_vn-51787431?flat'}
2026-06-01 16:41:50,345 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-08051395:ctest-left_vn-51787431 virtual network link through opserver 10.0.0.242
2026-06-01 16:41:50,345 - DEBUG - Requesting: http://10.0.0.242:8081/analytics/uves/virtual-networks
2026-06-01 16:41:50,412 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-08051395:ctest-left_vn-51787431', 'href': 'http://10.0.0.242:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-08051395:ctest-left_vn-51787431?flat'}
2026-06-01 16:41:50,412 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-08051395:ctest-left_vn-51787431 virtual network link through opserver 10.0.0.19
2026-06-01 16:41:50,412 - DEBUG - Requesting: http://10.0.0.19:8081/analytics/uves/virtual-networks
2026-06-01 16:41:50,505 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-08051395:ctest-left_vn-51787431', 'href': 'http://10.0.0.19:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-08051395:ctest-left_vn-51787431?flat'}
2026-06-01 16:41:50,505 - INFO - Validated that VN default-domain:ctest-TestSvcHC-08051395:ctest-left_vn-51787431 is found in opserver
2026-06-01 16:41:50,533 - DEBUG - Do not have enough data to verify VN in agent
2026-06-01 16:41:50,548 - DEBUG - VRF ids for VN ctest-left_vn-51787431: {}
2026-06-01 16:41:50,851 - DEBUG - Response for create_network : {'network': {'id': 'f8656cea-976a-4e2a-ab52-56502ef5bc0f', 'name': 'ctest-right_vn-72409723', 'tenant_id': '45ef1a625dad445c924b7ae6933cce02', 'project_id': '45ef1a625dad445c924b7ae6933cce02', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-08051395', 'ctest-right_vn-72409723'], 'port_security_enabled': True, 'description': ''}}
2026-06-01 16:41:51,139 - DEBUG - Response for create_subnet : {'subnet': {'id': 'e93f24ab-e456-44bc-ac95-4b5ee861ae59', 'name': '', 'tenant_id': '45ef1a625dad445c924b7ae6933cce02', 'network_id': 'f8656cea-976a-4e2a-ab52-56502ef5bc0f', 'ip_version': 4, 'cidr': '90.173.145.64/26', 'allocation_pools': [{'start': '90.173.145.66', 'end': '90.173.145.126'}], 'gateway_ip': '90.173.145.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '90.173.145.66', 'tags': [], 'project_id': '45ef1a625dad445c924b7ae6933cce02'}}
2026-06-01 16:41:51,169 - INFO - Created VN ctest-right_vn-72409723
2026-06-01 16:41:51,187 - DEBUG - VN ctest-right_vn-72409723 UUID is f8656cea-976a-4e2a-ab52-56502ef5bc0f
2026-06-01 16:41:51,280 - DEBUG - Requesting: http://10.0.0.241:8082/domains
2026-06-01 16:41:51,295 - DEBUG - Requesting: http://10.0.0.241:8082/domain/4934cdf0-e2c0-49f7-8ec1-47ce02d5e849
2026-06-01 16:41:51,324 - DEBUG - Requesting: http://10.0.0.241:8082/project/45ef1a62-5dad-445c-924b-7ae6933cce02
2026-06-01 16:41:51,445 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-network/f8656cea-976a-4e2a-ab52-56502ef5bc0f
2026-06-01 16:41:51,459 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-network/f8656cea-976a-4e2a-ab52-56502ef5bc0f
2026-06-01 16:41:51,474 - DEBUG - Requesting: http://10.0.0.241:8082/routing-instance/e8aa8871-8664-469f-bcfc-656e22cb93b2
2026-06-01 16:41:51,484 - DEBUG - Requesting: http://10.0.0.241:8082/routing-instance/e8aa8871-8664-469f-bcfc-656e22cb93b2
2026-06-01 16:41:51,493 - DEBUG - Requesting: http://10.0.0.241:8082/route-target/fc461363-a017-4841-8df0-8f006bf7b128
2026-06-01 16:41:51,501 - DEBUG - Route Targets: ['target:64512:8000010']
2026-06-01 16:41:51,501 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-network/f8656cea-976a-4e2a-ab52-56502ef5bc0f
2026-06-01 16:41:51,515 - DEBUG - Requesting: http://10.0.0.241:8082/routing-instance/e8aa8871-8664-469f-bcfc-656e22cb93b2
2026-06-01 16:41:51,543 - INFO - Verified VN network id 20 for VN f8656cea-976a-4e2a-ab52-56502ef5bc0f
2026-06-01 16:41:51,544 - INFO - Verifications in API Server for VN ctest-right_vn-72409723 passed
2026-06-01 16:41:51,544 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-network/f8656cea-976a-4e2a-ab52-56502ef5bc0f
2026-06-01 16:41:51,655 - DEBUG - Requesting: http://10.0.0.241:8082/routing-instance/e8aa8871-8664-469f-bcfc-656e22cb93b2
2026-06-01 16:41:51,664 - DEBUG - Requesting: http://10.0.0.241:8082/routing-instance/e8aa8871-8664-469f-bcfc-656e22cb93b2
2026-06-01 16:41:51,673 - DEBUG - Requesting: http://10.0.0.241:8082/route-target/fc461363-a017-4841-8df0-8f006bf7b128
2026-06-01 16:41:51,687 - DEBUG - Control-node 10.0.0.241 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-08051395:ctest-right_vn-72409723', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-08051395', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17898832048872377898', 'uuid-lslong': '12345024430961179663'}, 'enable': 'true', 'created': '2026-06-01T16:41:50', 'last-modified': '2026-06-01T16:41:51', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.615857'}
2026-06-01 16:41:51,696 - DEBUG - Route Targets: ['target:64512:8000010']
2026-06-01 16:41:51,702 - DEBUG - Control-node 10.0.0.242 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-08051395:ctest-right_vn-72409723', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-08051395', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17898832048872377898', 'uuid-lslong': '12345024430961179663'}, 'enable': 'true', 'created': '2026-06-01T16:41:50', 'last-modified': '2026-06-01T16:41:51', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.631472'}
2026-06-01 16:41:51,711 - DEBUG - Route Targets: ['target:64512:8000010']
2026-06-01 16:41:51,718 - DEBUG - Control-node 10.0.0.19 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-08051395:ctest-right_vn-72409723', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-08051395', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17898832048872377898', 'uuid-lslong': '12345024430961179663'}, 'enable': 'true', 'created': '2026-06-01T16:41:50', 'last-modified': '2026-06-01T16:41:51', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.648288'}
2026-06-01 16:41:51,726 - DEBUG - Route Targets: ['target:64512:8000010']
2026-06-01 16:41:51,727 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-72409723 passed
2026-06-01 16:41:51,727 - DEBUG - ====Verifying policy data for ctest-right_vn-72409723 in API_Server ======
2026-06-01 16:41:51,727 - DEBUG - Requesting: http://10.0.0.241:8082/domains
2026-06-01 16:41:51,735 - DEBUG - Requesting: http://10.0.0.241:8082/domain/4934cdf0-e2c0-49f7-8ec1-47ce02d5e849
2026-06-01 16:41:51,750 - DEBUG - Requesting: http://10.0.0.241:8082/project/45ef1a62-5dad-445c-924b-7ae6933cce02
2026-06-01 16:41:51,860 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-network/f8656cea-976a-4e2a-ab52-56502ef5bc0f
2026-06-01 16:41:51,871 - DEBUG - =>VN ctest-right_vn-72409723 has no policy to be verified
2026-06-01 16:41:51,871 - DEBUG - Verifying the vn in opserver
2026-06-01 16:41:51,871 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-08051395:ctest-right_vn-72409723 virtual network link through opserver 10.0.0.241
2026-06-01 16:41:51,872 - DEBUG - Requesting: http://10.0.0.241:8081/analytics/uves/virtual-networks
2026-06-01 16:41:51,960 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-08051395:ctest-right_vn-72409723', 'href': 'http://10.0.0.241:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-08051395:ctest-right_vn-72409723?flat'}
2026-06-01 16:41:51,960 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-08051395:ctest-right_vn-72409723 virtual network link through opserver 10.0.0.242
2026-06-01 16:41:51,960 - DEBUG - Requesting: http://10.0.0.242:8081/analytics/uves/virtual-networks
2026-06-01 16:41:52,065 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-08051395:ctest-right_vn-72409723', 'href': 'http://10.0.0.242:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-08051395:ctest-right_vn-72409723?flat'}
2026-06-01 16:41:52,066 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-08051395:ctest-right_vn-72409723 virtual network link through opserver 10.0.0.19
2026-06-01 16:41:52,066 - DEBUG - Requesting: http://10.0.0.19:8081/analytics/uves/virtual-networks
2026-06-01 16:41:52,166 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-08051395:ctest-right_vn-72409723', 'href': 'http://10.0.0.19:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-08051395:ctest-right_vn-72409723?flat'}
2026-06-01 16:41:52,166 - INFO - Validated that VN default-domain:ctest-TestSvcHC-08051395:ctest-right_vn-72409723 is found in opserver
2026-06-01 16:41:52,201 - DEBUG - Do not have enough data to verify VN in agent
2026-06-01 16:41:52,215 - DEBUG - VRF ids for VN ctest-right_vn-72409723: {}
2026-06-01 16:41:52,436 - DEBUG - Services list from nova: [, , , ]
2026-06-01 16:41:53,902 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5870-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5870-1)
2026-06-01 16:41:55,969 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5870-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5870-2)
2026-06-01 16:41:55,969 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-15462250']
2026-06-01 16:41:56,290 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-15462250'] created succesfully
2026-06-01 16:41:56,895 - DEBUG - Image by name tiny_nat_fw not found
2026-06-01 16:41:56,895 - DEBUG - Installing image tiny_nat_fw
2026-06-01 16:41:56,895 - 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-06-01 16:41:56,895 - DEBUG - Image build path file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-06-01 16:41:56,896 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-06-01 16:41:56,896 - DEBUG - Unzip image
2026-06-01 16:41:56,896 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-06-01 16:41:56,922 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2026-06-01 16:41:56,923 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-15462250']
2026-06-01 16:41:57,037 - INFO - Service template: ['default-domain', 'ctest-service_template_1-15462250'] deleted successfully.
2026-06-01 16:41:57,037 - INFO - Skip interface_detach for VM ctest-right_vm-51757490 in state BUILD
2026-06-01 16:41:57,037 - INFO - Deleting VM ctest-right_vm-51757490
2026-06-01 16:41:57,090 - ERROR - VM ctest-right_vm-51757490 has failed to come up
2026-06-01 16:41:57,090 - ERROR - Nova failed to get host of the VM
2026-06-01 16:41:57,091 - ERROR - VM ctest-right_vm-51757490 has failed to come up
2026-06-01 16:41:57,092 - ERROR - Nova failed to get host of the VM
2026-06-01 16:41:57,173 - INFO - Skip interface_detach for VM ctest-left_vm-97102479 in state BUILD
2026-06-01 16:41:57,173 - INFO - Deleting VM ctest-left_vm-97102479
2026-06-01 16:41:57,173 - ERROR - VM ctest-left_vm-97102479 has failed to come up
2026-06-01 16:41:57,173 - ERROR - Nova failed to get host of the VM
2026-06-01 16:41:57,173 - ERROR - VM ctest-left_vm-97102479 has failed to come up
2026-06-01 16:41:57,173 - ERROR - Nova failed to get host of the VM
2026-06-01 16:41:57,268 - INFO - Deleting VN ctest-right_vn-72409723
2026-06-01 16:41:57,334 - DEBUG - VN f8656cea-976a-4e2a-ab52-56502ef5bc0f still in use: Unable to complete operation on network f8656cea-976a-4e2a-ab52-56502ef5bc0f. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-eb85612e-4bad-40c3-94fd-0393a8234a75']
2026-06-01 16:41:57,335 - WARNING - Deleting VN ctest-right_vn-72409723 failed..Will retry
2026-06-01 16:41:59,542 - DEBUG - Response for deleting network ()
2026-06-01 16:41:59,542 - DEBUG - Requesting: http://10.0.0.241:8082/routing-instance/e8aa8871-8664-469f-bcfc-656e22cb93b2
2026-06-01 16:41:59,555 - DEBUG - Response Code: 404
2026-06-01 16:41:59,555 - DEBUG - Requesting: http://10.0.0.241:8082/domains
2026-06-01 16:41:59,575 - DEBUG - Requesting: http://10.0.0.241:8082/domain/4934cdf0-e2c0-49f7-8ec1-47ce02d5e849
2026-06-01 16:41:59,624 - DEBUG - Requesting: http://10.0.0.241:8082/project/45ef1a62-5dad-445c-924b-7ae6933cce02
2026-06-01 16:41:59,761 - INFO - Validated that VN ctest-right_vn-72409723 is not found in API Server
2026-06-01 16:41:59,784 - DEBUG - VN ctest-right_vn-72409723 is not present in Agent 10.0.0.141
2026-06-01 16:41:59,803 - DEBUG - VN ctest-right_vn-72409723 is not present in Agent 10.0.0.27
2026-06-01 16:41:59,803 - INFO - Validated that VN ctest-right_vn-72409723 is not in any agent
2026-06-01 16:41:59,853 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-72409723 info
2026-06-01 16:41:59,854 - INFO - Deleting VN ctest-left_vn-51787431
2026-06-01 16:42:00,067 - DEBUG - Response for deleting network ()
2026-06-01 16:42:00,067 - DEBUG - Requesting: http://10.0.0.241:8082/routing-instance/a29f3376-b970-4936-b8e5-b11248f76b10
2026-06-01 16:42:00,076 - DEBUG - Response Code: 404
2026-06-01 16:42:00,076 - DEBUG - Requesting: http://10.0.0.241:8082/domains
2026-06-01 16:42:00,092 - DEBUG - Requesting: http://10.0.0.241:8082/domain/4934cdf0-e2c0-49f7-8ec1-47ce02d5e849
2026-06-01 16:42:00,119 - DEBUG - Requesting: http://10.0.0.241:8082/project/45ef1a62-5dad-445c-924b-7ae6933cce02
2026-06-01 16:42:00,243 - INFO - Validated that VN ctest-left_vn-51787431 is not found in API Server
2026-06-01 16:42:00,266 - DEBUG - VN ctest-left_vn-51787431 is not present in Agent 10.0.0.141
2026-06-01 16:42:00,279 - DEBUG - VN ctest-left_vn-51787431 is not present in Agent 10.0.0.27
2026-06-01 16:42:00,279 - INFO - Validated that VN ctest-left_vn-51787431 is not in any agent
2026-06-01 16:42:00,354 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-51787431 info
2026-06-01 16:42:00,354 - INFO - Deleting VN ctest-mgmt_vn-78612988
2026-06-01 16:42:00,550 - DEBUG - Response for deleting network ()
2026-06-01 16:42:00,551 - DEBUG - Requesting: http://10.0.0.241:8082/routing-instance/e11cd62a-fe47-42b0-8cbf-ebebfa53f3a7
2026-06-01 16:42:00,557 - DEBUG - Response Code: 404
2026-06-01 16:42:00,558 - DEBUG - Requesting: http://10.0.0.241:8082/domains
2026-06-01 16:42:00,571 - DEBUG - Requesting: http://10.0.0.241:8082/domain/4934cdf0-e2c0-49f7-8ec1-47ce02d5e849
2026-06-01 16:42:00,587 - DEBUG - Requesting: http://10.0.0.241:8082/project/45ef1a62-5dad-445c-924b-7ae6933cce02
2026-06-01 16:42:00,695 - INFO - Validated that VN ctest-mgmt_vn-78612988 is not found in API Server
2026-06-01 16:42:00,714 - DEBUG - VN ctest-mgmt_vn-78612988 is not present in Agent 10.0.0.141
2026-06-01 16:42:00,728 - DEBUG - VN ctest-mgmt_vn-78612988 is not present in Agent 10.0.0.27
2026-06-01 16:42:00,728 - INFO - Validated that VN ctest-mgmt_vn-78612988 is not in any agent
2026-06-01 16:42:00,776 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-78612988 info
2026-06-01 16:42:02,130 - DEBUG - No XMPP flaps were noticed during the test
2026-06-01 16:42:02,130 - INFO -
2026-06-01 16:42:02,130 - INFO - END TEST : test_svc_hc_basic : SKIPPED[0:00:18]
2026-06-01 16:42:02,130 - INFO - --------------------------------------------------------------------------------
2026-06-01 16:42:02,134 - INFO - ================================================================================
2026-06-01 16:42:02,135 - INFO - STARTING TEST : test_svc_trans_segment_right_hc_fail_svm
2026-06-01 16:42:03,520 - DEBUG - Nothing to compare xmpp stats {'10.0.0.141': {'10.20.0.17': '3', '10.20.0.254': '3'}, '10.0.0.27': {'10.20.0.14': '2', '10.20.0.254': '3'}} with
2026-06-01 16:42:03,520 - INFO - Initial checks done. Running the testcase now
2026-06-01 16:42:03,520 - INFO -
2026-06-01 16:42:03,880 - DEBUG - Response for create_network : {'network': {'id': '90a38e04-80a4-4cfd-affb-386db0e73b20', 'name': 'ctest-mgmt_vn-83981971', 'tenant_id': '45ef1a625dad445c924b7ae6933cce02', 'project_id': '45ef1a625dad445c924b7ae6933cce02', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-08051395', 'ctest-mgmt_vn-83981971'], 'port_security_enabled': True, 'description': ''}}
2026-06-01 16:42:04,137 - DEBUG - Response for create_subnet : {'subnet': {'id': '3574358b-9879-48ee-97b4-cd942e491976', 'name': '', 'tenant_id': '45ef1a625dad445c924b7ae6933cce02', 'network_id': '90a38e04-80a4-4cfd-affb-386db0e73b20', 'ip_version': 4, 'cidr': '72.28.53.128/26', 'allocation_pools': [{'start': '72.28.53.130', 'end': '72.28.53.190'}], 'gateway_ip': '72.28.53.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '72.28.53.130', 'tags': [], 'project_id': '45ef1a625dad445c924b7ae6933cce02'}}
2026-06-01 16:42:04,162 - INFO - Created VN ctest-mgmt_vn-83981971
2026-06-01 16:42:04,176 - DEBUG - VN ctest-mgmt_vn-83981971 UUID is 90a38e04-80a4-4cfd-affb-386db0e73b20
2026-06-01 16:42:04,270 - DEBUG - Requesting: http://10.0.0.241:8082/domains
2026-06-01 16:42:04,277 - DEBUG - Requesting: http://10.0.0.241:8082/domain/4934cdf0-e2c0-49f7-8ec1-47ce02d5e849
2026-06-01 16:42:04,294 - DEBUG - Requesting: http://10.0.0.241:8082/project/45ef1a62-5dad-445c-924b-7ae6933cce02
2026-06-01 16:42:04,401 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-network/90a38e04-80a4-4cfd-affb-386db0e73b20
2026-06-01 16:42:04,414 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-network/90a38e04-80a4-4cfd-affb-386db0e73b20
2026-06-01 16:42:04,425 - DEBUG - Requesting: http://10.0.0.241:8082/routing-instance/2833fd46-9896-42bf-a6c9-cdf4731923ad
2026-06-01 16:42:04,434 - DEBUG - Requesting: http://10.0.0.241:8082/routing-instance/2833fd46-9896-42bf-a6c9-cdf4731923ad
2026-06-01 16:42:04,442 - DEBUG - Requesting: http://10.0.0.241:8082/route-target/da61f856-2e2b-4901-be36-4b82c45bc3e6
2026-06-01 16:42:04,451 - DEBUG - Route Targets: ['target:64512:8000008']
2026-06-01 16:42:04,451 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-network/90a38e04-80a4-4cfd-affb-386db0e73b20
2026-06-01 16:42:04,463 - DEBUG - Requesting: http://10.0.0.241:8082/routing-instance/2833fd46-9896-42bf-a6c9-cdf4731923ad
2026-06-01 16:42:04,481 - INFO - Verified VN network id 18 for VN 90a38e04-80a4-4cfd-affb-386db0e73b20
2026-06-01 16:42:04,481 - INFO - Verifications in API Server for VN ctest-mgmt_vn-83981971 passed
2026-06-01 16:42:04,482 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-network/90a38e04-80a4-4cfd-affb-386db0e73b20
2026-06-01 16:42:04,495 - DEBUG - Requesting: http://10.0.0.241:8082/routing-instance/2833fd46-9896-42bf-a6c9-cdf4731923ad
2026-06-01 16:42:04,504 - DEBUG - Requesting: http://10.0.0.241:8082/routing-instance/2833fd46-9896-42bf-a6c9-cdf4731923ad
2026-06-01 16:42:04,513 - DEBUG - Requesting: http://10.0.0.241:8082/route-target/da61f856-2e2b-4901-be36-4b82c45bc3e6
2026-06-01 16:42:04,527 - DEBUG - Control-node 10.0.0.241 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-08051395:ctest-mgmt_vn-83981971', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-08051395', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10422330112654724349', 'uuid-lslong': '12680791219562298144'}, 'enable': 'true', 'created': '2026-06-01T16:42:03', 'last-modified': '2026-06-01T16:42:04', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.456864'}
2026-06-01 16:42:04,534 - DEBUG - Route Targets: ['target:64512:8000008']
2026-06-01 16:42:04,540 - DEBUG - Control-node 10.0.0.242 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-08051395:ctest-mgmt_vn-83981971', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-08051395', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10422330112654724349', 'uuid-lslong': '12680791219562298144'}, 'enable': 'true', 'created': '2026-06-01T16:42:03', 'last-modified': '2026-06-01T16:42:04', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.463376'}
2026-06-01 16:42:04,549 - DEBUG - Route Targets: ['target:64512:8000008']
2026-06-01 16:42:04,555 - DEBUG - Control-node 10.0.0.19 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-08051395:ctest-mgmt_vn-83981971', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-08051395', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10422330112654724349', 'uuid-lslong': '12680791219562298144'}, 'enable': 'true', 'created': '2026-06-01T16:42:03', 'last-modified': '2026-06-01T16:42:04', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.485239'}
2026-06-01 16:42:04,560 - DEBUG - Route Targets: ['target:64512:8000008']
2026-06-01 16:42:04,561 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-83981971 passed
2026-06-01 16:42:04,561 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-83981971 in API_Server ======
2026-06-01 16:42:04,561 - DEBUG - Requesting: http://10.0.0.241:8082/domains
2026-06-01 16:42:04,568 - DEBUG - Requesting: http://10.0.0.241:8082/domain/4934cdf0-e2c0-49f7-8ec1-47ce02d5e849
2026-06-01 16:42:04,581 - DEBUG - Requesting: http://10.0.0.241:8082/project/45ef1a62-5dad-445c-924b-7ae6933cce02
2026-06-01 16:42:04,701 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-network/90a38e04-80a4-4cfd-affb-386db0e73b20
2026-06-01 16:42:04,722 - DEBUG - =>VN ctest-mgmt_vn-83981971 has no policy to be verified
2026-06-01 16:42:04,722 - DEBUG - Verifying the vn in opserver
2026-06-01 16:42:04,722 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-08051395:ctest-mgmt_vn-83981971 virtual network link through opserver 10.0.0.241
2026-06-01 16:42:04,722 - DEBUG - Requesting: http://10.0.0.241:8081/analytics/uves/virtual-networks
2026-06-01 16:42:04,741 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-08051395:ctest-mgmt_vn-83981971', 'href': 'http://10.0.0.241:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-08051395:ctest-mgmt_vn-83981971?flat'}
2026-06-01 16:42:04,741 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-08051395:ctest-mgmt_vn-83981971 virtual network link through opserver 10.0.0.242
2026-06-01 16:42:04,741 - DEBUG - Requesting: http://10.0.0.242:8081/analytics/uves/virtual-networks
2026-06-01 16:42:04,757 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-08051395:ctest-mgmt_vn-83981971', 'href': 'http://10.0.0.242:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-08051395:ctest-mgmt_vn-83981971?flat'}
2026-06-01 16:42:04,757 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-08051395:ctest-mgmt_vn-83981971 virtual network link through opserver 10.0.0.19
2026-06-01 16:42:04,757 - DEBUG - Requesting: http://10.0.0.19:8081/analytics/uves/virtual-networks
2026-06-01 16:42:04,773 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-08051395:ctest-mgmt_vn-83981971', 'href': 'http://10.0.0.19:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-08051395:ctest-mgmt_vn-83981971?flat'}
2026-06-01 16:42:04,774 - INFO - Validated that VN default-domain:ctest-TestSvcHC-08051395:ctest-mgmt_vn-83981971 is found in opserver
2026-06-01 16:42:04,798 - DEBUG - Do not have enough data to verify VN in agent
2026-06-01 16:42:04,833 - DEBUG - VRF ids for VN ctest-mgmt_vn-83981971: {}
2026-06-01 16:42:05,131 - DEBUG - Response for create_network : {'network': {'id': '71406f33-5e55-430a-9625-c5024855ffac', 'name': 'ctest-left_vn-42394725', 'tenant_id': '45ef1a625dad445c924b7ae6933cce02', 'project_id': '45ef1a625dad445c924b7ae6933cce02', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-08051395', 'ctest-left_vn-42394725'], 'port_security_enabled': True, 'description': ''}}
2026-06-01 16:42:05,411 - DEBUG - Response for create_subnet : {'subnet': {'id': '042281d7-18cb-445f-a909-7d7d4ad70ded', 'name': '', 'tenant_id': '45ef1a625dad445c924b7ae6933cce02', 'network_id': '71406f33-5e55-430a-9625-c5024855ffac', 'ip_version': 4, 'cidr': '138.123.183.192/26', 'allocation_pools': [{'start': '138.123.183.194', 'end': '138.123.183.254'}], 'gateway_ip': '138.123.183.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '138.123.183.194', 'tags': [], 'project_id': '45ef1a625dad445c924b7ae6933cce02'}}
2026-06-01 16:42:05,436 - INFO - Created VN ctest-left_vn-42394725
2026-06-01 16:42:05,448 - DEBUG - VN ctest-left_vn-42394725 UUID is 71406f33-5e55-430a-9625-c5024855ffac
2026-06-01 16:42:05,543 - DEBUG - Requesting: http://10.0.0.241:8082/domains
2026-06-01 16:42:05,553 - DEBUG - Requesting: http://10.0.0.241:8082/domain/4934cdf0-e2c0-49f7-8ec1-47ce02d5e849
2026-06-01 16:42:05,576 - DEBUG - Requesting: http://10.0.0.241:8082/project/45ef1a62-5dad-445c-924b-7ae6933cce02
2026-06-01 16:42:05,692 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-network/71406f33-5e55-430a-9625-c5024855ffac
2026-06-01 16:42:05,712 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-network/71406f33-5e55-430a-9625-c5024855ffac
2026-06-01 16:42:05,727 - DEBUG - Requesting: http://10.0.0.241:8082/routing-instance/5ba74996-a7bd-46dd-be82-ab1148dbbee5
2026-06-01 16:42:05,745 - DEBUG - Requesting: http://10.0.0.241:8082/routing-instance/5ba74996-a7bd-46dd-be82-ab1148dbbee5
2026-06-01 16:42:05,758 - DEBUG - Requesting: http://10.0.0.241:8082/route-target/1b734e32-81e0-4d20-9ed7-31adac12e085
2026-06-01 16:42:05,770 - DEBUG - Route Targets: ['target:64512:8000009']
2026-06-01 16:42:05,770 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-network/71406f33-5e55-430a-9625-c5024855ffac
2026-06-01 16:42:05,785 - DEBUG - Requesting: http://10.0.0.241:8082/routing-instance/5ba74996-a7bd-46dd-be82-ab1148dbbee5
2026-06-01 16:42:05,814 - INFO - Verified VN network id 19 for VN 71406f33-5e55-430a-9625-c5024855ffac
2026-06-01 16:42:05,814 - INFO - Verifications in API Server for VN ctest-left_vn-42394725 passed
2026-06-01 16:42:05,815 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-network/71406f33-5e55-430a-9625-c5024855ffac
2026-06-01 16:42:05,835 - DEBUG - Requesting: http://10.0.0.241:8082/routing-instance/5ba74996-a7bd-46dd-be82-ab1148dbbee5
2026-06-01 16:42:05,847 - DEBUG - Requesting: http://10.0.0.241:8082/routing-instance/5ba74996-a7bd-46dd-be82-ab1148dbbee5
2026-06-01 16:42:05,864 - DEBUG - Requesting: http://10.0.0.241:8082/route-target/1b734e32-81e0-4d20-9ed7-31adac12e085
2026-06-01 16:42:05,885 - DEBUG - Control-node 10.0.0.241 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-08051395:ctest-left_vn-42394725', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-08051395', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8160644791212000010', 'uuid-lslong': '10819270293421686700'}, 'enable': 'true', 'created': '2026-06-01T16:42:05', 'last-modified': '2026-06-01T16:42:05', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.536366'}
2026-06-01 16:42:05,898 - DEBUG - Route Targets: ['target:64512:8000009']
2026-06-01 16:42:05,909 - DEBUG - Control-node 10.0.0.242 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-08051395:ctest-left_vn-42394725', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-08051395', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8160644791212000010', 'uuid-lslong': '10819270293421686700'}, 'enable': 'true', 'created': '2026-06-01T16:42:05', 'last-modified': '2026-06-01T16:42:05', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.551611'}
2026-06-01 16:42:05,918 - DEBUG - Route Targets: ['target:64512:8000009']
2026-06-01 16:42:05,925 - DEBUG - Control-node 10.0.0.19 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-08051395:ctest-left_vn-42394725', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-08051395', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8160644791212000010', 'uuid-lslong': '10819270293421686700'}, 'enable': 'true', 'created': '2026-06-01T16:42:05', 'last-modified': '2026-06-01T16:42:05', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.569861'}
2026-06-01 16:42:05,932 - DEBUG - Route Targets: ['target:64512:8000009']
2026-06-01 16:42:05,932 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-42394725 passed
2026-06-01 16:42:05,932 - DEBUG - ====Verifying policy data for ctest-left_vn-42394725 in API_Server ======
2026-06-01 16:42:05,932 - DEBUG - Requesting: http://10.0.0.241:8082/domains
2026-06-01 16:42:05,942 - DEBUG - Requesting: http://10.0.0.241:8082/domain/4934cdf0-e2c0-49f7-8ec1-47ce02d5e849
2026-06-01 16:42:05,963 - DEBUG - Requesting: http://10.0.0.241:8082/project/45ef1a62-5dad-445c-924b-7ae6933cce02
2026-06-01 16:42:06,093 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-network/71406f33-5e55-430a-9625-c5024855ffac
2026-06-01 16:42:06,110 - DEBUG - =>VN ctest-left_vn-42394725 has no policy to be verified
2026-06-01 16:42:06,110 - DEBUG - Verifying the vn in opserver
2026-06-01 16:42:06,110 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-08051395:ctest-left_vn-42394725 virtual network link through opserver 10.0.0.241
2026-06-01 16:42:06,110 - DEBUG - Requesting: http://10.0.0.241:8081/analytics/uves/virtual-networks
2026-06-01 16:42:06,128 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-08051395:ctest-left_vn-42394725', 'href': 'http://10.0.0.241:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-08051395:ctest-left_vn-42394725?flat'}
2026-06-01 16:42:06,128 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-08051395:ctest-left_vn-42394725 virtual network link through opserver 10.0.0.242
2026-06-01 16:42:06,128 - DEBUG - Requesting: http://10.0.0.242:8081/analytics/uves/virtual-networks
2026-06-01 16:42:06,148 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-08051395:ctest-left_vn-42394725', 'href': 'http://10.0.0.242:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-08051395:ctest-left_vn-42394725?flat'}
2026-06-01 16:42:06,148 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-08051395:ctest-left_vn-42394725 virtual network link through opserver 10.0.0.19
2026-06-01 16:42:06,148 - DEBUG - Requesting: http://10.0.0.19:8081/analytics/uves/virtual-networks
2026-06-01 16:42:06,164 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-08051395:ctest-left_vn-42394725', 'href': 'http://10.0.0.19:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-08051395:ctest-left_vn-42394725?flat'}
2026-06-01 16:42:06,164 - INFO - Validated that VN default-domain:ctest-TestSvcHC-08051395:ctest-left_vn-42394725 is found in opserver
2026-06-01 16:42:06,196 - DEBUG - Do not have enough data to verify VN in agent
2026-06-01 16:42:06,214 - DEBUG - VRF ids for VN ctest-left_vn-42394725: {}
2026-06-01 16:42:06,565 - DEBUG - Response for create_network : {'network': {'id': '6a80bf47-f2c0-49d2-bb1c-3361bfe22b76', 'name': 'ctest-right_vn-08220523', 'tenant_id': '45ef1a625dad445c924b7ae6933cce02', 'project_id': '45ef1a625dad445c924b7ae6933cce02', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-08051395', 'ctest-right_vn-08220523'], 'port_security_enabled': True, 'description': ''}}
2026-06-01 16:42:06,965 - DEBUG - Response for create_subnet : {'subnet': {'id': '18255dc9-f591-4d0e-91e3-ffce3b54b4d2', 'name': '', 'tenant_id': '45ef1a625dad445c924b7ae6933cce02', 'network_id': '6a80bf47-f2c0-49d2-bb1c-3361bfe22b76', 'ip_version': 4, 'cidr': '207.219.157.192/26', 'allocation_pools': [{'start': '207.219.157.194', 'end': '207.219.157.254'}], 'gateway_ip': '207.219.157.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '207.219.157.194', 'tags': [], 'project_id': '45ef1a625dad445c924b7ae6933cce02'}}
2026-06-01 16:42:06,997 - INFO - Created VN ctest-right_vn-08220523
2026-06-01 16:42:07,015 - DEBUG - VN ctest-right_vn-08220523 UUID is 6a80bf47-f2c0-49d2-bb1c-3361bfe22b76
2026-06-01 16:42:07,127 - DEBUG - Requesting: http://10.0.0.241:8082/domains
2026-06-01 16:42:07,135 - DEBUG - Requesting: http://10.0.0.241:8082/domain/4934cdf0-e2c0-49f7-8ec1-47ce02d5e849
2026-06-01 16:42:07,150 - DEBUG - Requesting: http://10.0.0.241:8082/project/45ef1a62-5dad-445c-924b-7ae6933cce02
2026-06-01 16:42:07,275 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-network/6a80bf47-f2c0-49d2-bb1c-3361bfe22b76
2026-06-01 16:42:07,294 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-network/6a80bf47-f2c0-49d2-bb1c-3361bfe22b76
2026-06-01 16:42:07,306 - DEBUG - Requesting: http://10.0.0.241:8082/routing-instance/519761be-26cb-43d6-87e8-d39a82876730
2026-06-01 16:42:07,317 - DEBUG - Requesting: http://10.0.0.241:8082/routing-instance/519761be-26cb-43d6-87e8-d39a82876730
2026-06-01 16:42:07,328 - DEBUG - Requesting: http://10.0.0.241:8082/route-target/792e16a4-f7b1-450e-af8e-2bff52edbd44
2026-06-01 16:42:07,338 - DEBUG - Route Targets: ['target:64512:8000010']
2026-06-01 16:42:07,338 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-network/6a80bf47-f2c0-49d2-bb1c-3361bfe22b76
2026-06-01 16:42:07,350 - DEBUG - Requesting: http://10.0.0.241:8082/routing-instance/519761be-26cb-43d6-87e8-d39a82876730
2026-06-01 16:42:07,368 - INFO - Verified VN network id 20 for VN 6a80bf47-f2c0-49d2-bb1c-3361bfe22b76
2026-06-01 16:42:07,368 - INFO - Verifications in API Server for VN ctest-right_vn-08220523 passed
2026-06-01 16:42:07,368 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-network/6a80bf47-f2c0-49d2-bb1c-3361bfe22b76
2026-06-01 16:42:07,379 - DEBUG - Requesting: http://10.0.0.241:8082/routing-instance/519761be-26cb-43d6-87e8-d39a82876730
2026-06-01 16:42:07,388 - DEBUG - Requesting: http://10.0.0.241:8082/routing-instance/519761be-26cb-43d6-87e8-d39a82876730
2026-06-01 16:42:07,397 - DEBUG - Requesting: http://10.0.0.241:8082/route-target/792e16a4-f7b1-450e-af8e-2bff52edbd44
2026-06-01 16:42:07,413 - DEBUG - Control-node 10.0.0.241 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-08051395:ctest-right_vn-08220523', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-08051395', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7674344080775596498', 'uuid-lslong': '13482707879364537206'}, 'enable': 'true', 'created': '2026-06-01T16:42:06', 'last-modified': '2026-06-01T16:42:06', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.534194'}
2026-06-01 16:42:07,420 - DEBUG - Route Targets: ['target:64512:8000010']
2026-06-01 16:42:07,427 - DEBUG - Control-node 10.0.0.242 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-08051395:ctest-right_vn-08220523', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-08051395', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7674344080775596498', 'uuid-lslong': '13482707879364537206'}, 'enable': 'true', 'created': '2026-06-01T16:42:06', 'last-modified': '2026-06-01T16:42:06', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.549543'}
2026-06-01 16:42:07,434 - DEBUG - Route Targets: ['target:64512:8000010']
2026-06-01 16:42:07,441 - DEBUG - Control-node 10.0.0.19 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-08051395:ctest-right_vn-08220523', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-08051395', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7674344080775596498', 'uuid-lslong': '13482707879364537206'}, 'enable': 'true', 'created': '2026-06-01T16:42:06', 'last-modified': '2026-06-01T16:42:06', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.561266'}
2026-06-01 16:42:07,448 - DEBUG - Route Targets: ['target:64512:8000010']
2026-06-01 16:42:07,449 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-08220523 passed
2026-06-01 16:42:07,449 - DEBUG - ====Verifying policy data for ctest-right_vn-08220523 in API_Server ======
2026-06-01 16:42:07,449 - DEBUG - Requesting: http://10.0.0.241:8082/domains
2026-06-01 16:42:07,457 - DEBUG - Requesting: http://10.0.0.241:8082/domain/4934cdf0-e2c0-49f7-8ec1-47ce02d5e849
2026-06-01 16:42:07,471 - DEBUG - Requesting: http://10.0.0.241:8082/project/45ef1a62-5dad-445c-924b-7ae6933cce02
2026-06-01 16:42:07,572 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-network/6a80bf47-f2c0-49d2-bb1c-3361bfe22b76
2026-06-01 16:42:07,583 - DEBUG - =>VN ctest-right_vn-08220523 has no policy to be verified
2026-06-01 16:42:07,583 - DEBUG - Verifying the vn in opserver
2026-06-01 16:42:07,583 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-08051395:ctest-right_vn-08220523 virtual network link through opserver 10.0.0.241
2026-06-01 16:42:07,583 - DEBUG - Requesting: http://10.0.0.241:8081/analytics/uves/virtual-networks
2026-06-01 16:42:07,598 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-08051395:ctest-right_vn-08220523', 'href': 'http://10.0.0.241:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-08051395:ctest-right_vn-08220523?flat'}
2026-06-01 16:42:07,598 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-08051395:ctest-right_vn-08220523 virtual network link through opserver 10.0.0.242
2026-06-01 16:42:07,598 - DEBUG - Requesting: http://10.0.0.242:8081/analytics/uves/virtual-networks
2026-06-01 16:42:07,614 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-08051395:ctest-right_vn-08220523', 'href': 'http://10.0.0.242:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-08051395:ctest-right_vn-08220523?flat'}
2026-06-01 16:42:07,614 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-08051395:ctest-right_vn-08220523 virtual network link through opserver 10.0.0.19
2026-06-01 16:42:07,614 - DEBUG - Requesting: http://10.0.0.19:8081/analytics/uves/virtual-networks
2026-06-01 16:42:07,632 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-08051395:ctest-right_vn-08220523', 'href': 'http://10.0.0.19:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-08051395:ctest-right_vn-08220523?flat'}
2026-06-01 16:42:07,632 - INFO - Validated that VN default-domain:ctest-TestSvcHC-08051395:ctest-right_vn-08220523 is found in opserver
2026-06-01 16:42:07,657 - DEBUG - Do not have enough data to verify VN in agent
2026-06-01 16:42:07,672 - DEBUG - VRF ids for VN ctest-right_vn-08220523: {}
2026-06-01 16:42:08,024 - DEBUG - Response for create_network : {'network': {'id': 'b4233d5f-b6dd-43b0-892a-00314b26cf40', 'name': 'ctest-trans_left_vn-91522909', 'tenant_id': '45ef1a625dad445c924b7ae6933cce02', 'project_id': '45ef1a625dad445c924b7ae6933cce02', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-08051395', 'ctest-trans_left_vn-91522909'], 'port_security_enabled': True, 'description': ''}}
2026-06-01 16:42:08,269 - DEBUG - Response for create_subnet : {'subnet': {'id': '502e36e0-3135-450b-89d3-d046100b80fd', 'name': '', 'tenant_id': '45ef1a625dad445c924b7ae6933cce02', 'network_id': 'b4233d5f-b6dd-43b0-892a-00314b26cf40', 'ip_version': 4, 'cidr': '37.186.134.192/26', 'allocation_pools': [{'start': '37.186.134.194', 'end': '37.186.134.254'}], 'gateway_ip': '37.186.134.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '37.186.134.194', 'tags': [], 'project_id': '45ef1a625dad445c924b7ae6933cce02'}}
2026-06-01 16:42:08,294 - INFO - Created VN ctest-trans_left_vn-91522909
2026-06-01 16:42:08,306 - DEBUG - VN ctest-trans_left_vn-91522909 UUID is b4233d5f-b6dd-43b0-892a-00314b26cf40
2026-06-01 16:42:08,399 - DEBUG - Requesting: http://10.0.0.241:8082/domains
2026-06-01 16:42:08,407 - DEBUG - Requesting: http://10.0.0.241:8082/domain/4934cdf0-e2c0-49f7-8ec1-47ce02d5e849
2026-06-01 16:42:08,421 - DEBUG - Requesting: http://10.0.0.241:8082/project/45ef1a62-5dad-445c-924b-7ae6933cce02
2026-06-01 16:42:08,539 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-network/b4233d5f-b6dd-43b0-892a-00314b26cf40
2026-06-01 16:42:08,557 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-network/b4233d5f-b6dd-43b0-892a-00314b26cf40
2026-06-01 16:42:08,570 - DEBUG - Requesting: http://10.0.0.241:8082/routing-instance/6478432d-eec0-4ae0-bf0d-e14f23213ba8
2026-06-01 16:42:08,581 - DEBUG - Requesting: http://10.0.0.241:8082/routing-instance/6478432d-eec0-4ae0-bf0d-e14f23213ba8
2026-06-01 16:42:08,592 - DEBUG - Requesting: http://10.0.0.241:8082/route-target/01d01cdb-3e56-4167-9e28-0427deac84b0
2026-06-01 16:42:08,601 - DEBUG - Route Targets: ['target:64512:8000011']
2026-06-01 16:42:08,601 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-network/b4233d5f-b6dd-43b0-892a-00314b26cf40
2026-06-01 16:42:08,615 - DEBUG - Requesting: http://10.0.0.241:8082/routing-instance/6478432d-eec0-4ae0-bf0d-e14f23213ba8
2026-06-01 16:42:08,638 - INFO - Verified VN network id 21 for VN b4233d5f-b6dd-43b0-892a-00314b26cf40
2026-06-01 16:42:08,639 - INFO - Verifications in API Server for VN ctest-trans_left_vn-91522909 passed
2026-06-01 16:42:08,639 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-network/b4233d5f-b6dd-43b0-892a-00314b26cf40
2026-06-01 16:42:08,651 - DEBUG - Requesting: http://10.0.0.241:8082/routing-instance/6478432d-eec0-4ae0-bf0d-e14f23213ba8
2026-06-01 16:42:08,660 - DEBUG - Requesting: http://10.0.0.241:8082/routing-instance/6478432d-eec0-4ae0-bf0d-e14f23213ba8
2026-06-01 16:42:08,670 - DEBUG - Requesting: http://10.0.0.241:8082/route-target/01d01cdb-3e56-4167-9e28-0427deac84b0
2026-06-01 16:42:08,684 - DEBUG - Control-node 10.0.0.241 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-08051395:ctest-trans_left_vn-91522909', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-08051395', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12980286032311042992', 'uuid-lslong': '9883712543932206912'}, 'enable': 'true', 'created': '2026-06-01T16:42:07', 'last-modified': '2026-06-01T16:42:08', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.476046'}
2026-06-01 16:42:08,691 - DEBUG - Route Targets: ['target:64512:8000011']
2026-06-01 16:42:08,701 - DEBUG - Control-node 10.0.0.242 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-08051395:ctest-trans_left_vn-91522909', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-08051395', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12980286032311042992', 'uuid-lslong': '9883712543932206912'}, 'enable': 'true', 'created': '2026-06-01T16:42:07', 'last-modified': '2026-06-01T16:42:08', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.493666'}
2026-06-01 16:42:08,714 - DEBUG - Route Targets: ['target:64512:8000011']
2026-06-01 16:42:08,722 - DEBUG - Control-node 10.0.0.19 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-08051395:ctest-trans_left_vn-91522909', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-08051395', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12980286032311042992', 'uuid-lslong': '9883712543932206912'}, 'enable': 'true', 'created': '2026-06-01T16:42:07', 'last-modified': '2026-06-01T16:42:08', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.515898'}
2026-06-01 16:42:08,729 - DEBUG - Route Targets: ['target:64512:8000011']
2026-06-01 16:42:08,729 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_left_vn-91522909 passed
2026-06-01 16:42:08,729 - DEBUG - ====Verifying policy data for ctest-trans_left_vn-91522909 in API_Server ======
2026-06-01 16:42:08,729 - DEBUG - Requesting: http://10.0.0.241:8082/domains
2026-06-01 16:42:08,737 - DEBUG - Requesting: http://10.0.0.241:8082/domain/4934cdf0-e2c0-49f7-8ec1-47ce02d5e849
2026-06-01 16:42:08,751 - DEBUG - Requesting: http://10.0.0.241:8082/project/45ef1a62-5dad-445c-924b-7ae6933cce02
2026-06-01 16:42:08,856 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-network/b4233d5f-b6dd-43b0-892a-00314b26cf40
2026-06-01 16:42:08,868 - DEBUG - =>VN ctest-trans_left_vn-91522909 has no policy to be verified
2026-06-01 16:42:08,868 - DEBUG - Verifying the vn in opserver
2026-06-01 16:42:08,869 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-08051395:ctest-trans_left_vn-91522909 virtual network link through opserver 10.0.0.241
2026-06-01 16:42:08,869 - DEBUG - Requesting: http://10.0.0.241:8081/analytics/uves/virtual-networks
2026-06-01 16:42:08,885 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-08051395:ctest-trans_left_vn-91522909', 'href': 'http://10.0.0.241:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-08051395:ctest-trans_left_vn-91522909?flat'}
2026-06-01 16:42:08,885 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-08051395:ctest-trans_left_vn-91522909 virtual network link through opserver 10.0.0.242
2026-06-01 16:42:08,885 - DEBUG - Requesting: http://10.0.0.242:8081/analytics/uves/virtual-networks
2026-06-01 16:42:08,902 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-08051395:ctest-trans_left_vn-91522909', 'href': 'http://10.0.0.242:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-08051395:ctest-trans_left_vn-91522909?flat'}
2026-06-01 16:42:08,902 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-08051395:ctest-trans_left_vn-91522909 virtual network link through opserver 10.0.0.19
2026-06-01 16:42:08,902 - DEBUG - Requesting: http://10.0.0.19:8081/analytics/uves/virtual-networks
2026-06-01 16:42:08,920 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-08051395:ctest-trans_left_vn-91522909', 'href': 'http://10.0.0.19:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-08051395:ctest-trans_left_vn-91522909?flat'}
2026-06-01 16:42:08,920 - INFO - Validated that VN default-domain:ctest-TestSvcHC-08051395:ctest-trans_left_vn-91522909 is found in opserver
2026-06-01 16:42:08,946 - DEBUG - Do not have enough data to verify VN in agent
2026-06-01 16:42:08,958 - DEBUG - VRF ids for VN ctest-trans_left_vn-91522909: {}
2026-06-01 16:42:09,299 - DEBUG - Response for create_network : {'network': {'id': '9aa048bd-99d9-4287-a3f7-e54ef8b4bbbb', 'name': 'ctest-trans_right_vn-54298248', 'tenant_id': '45ef1a625dad445c924b7ae6933cce02', 'project_id': '45ef1a625dad445c924b7ae6933cce02', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-08051395', 'ctest-trans_right_vn-54298248'], 'port_security_enabled': True, 'description': ''}}
2026-06-01 16:42:09,546 - DEBUG - Response for create_subnet : {'subnet': {'id': '81c29a39-8c36-4f3f-9566-fc600ee52c74', 'name': '', 'tenant_id': '45ef1a625dad445c924b7ae6933cce02', 'network_id': '9aa048bd-99d9-4287-a3f7-e54ef8b4bbbb', 'ip_version': 4, 'cidr': '102.139.255.192/26', 'allocation_pools': [{'start': '102.139.255.194', 'end': '102.139.255.254'}], 'gateway_ip': '102.139.255.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '102.139.255.194', 'tags': [], 'project_id': '45ef1a625dad445c924b7ae6933cce02'}}
2026-06-01 16:42:09,574 - INFO - Created VN ctest-trans_right_vn-54298248
2026-06-01 16:42:09,589 - DEBUG - VN ctest-trans_right_vn-54298248 UUID is 9aa048bd-99d9-4287-a3f7-e54ef8b4bbbb
2026-06-01 16:42:09,689 - DEBUG - Requesting: http://10.0.0.241:8082/domains
2026-06-01 16:42:09,697 - DEBUG - Requesting: http://10.0.0.241:8082/domain/4934cdf0-e2c0-49f7-8ec1-47ce02d5e849
2026-06-01 16:42:09,709 - DEBUG - Requesting: http://10.0.0.241:8082/project/45ef1a62-5dad-445c-924b-7ae6933cce02
2026-06-01 16:42:09,808 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-network/9aa048bd-99d9-4287-a3f7-e54ef8b4bbbb
2026-06-01 16:42:09,823 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-network/9aa048bd-99d9-4287-a3f7-e54ef8b4bbbb
2026-06-01 16:42:09,839 - DEBUG - Requesting: http://10.0.0.241:8082/routing-instance/faceb501-ae0d-40f5-a427-6c4938f15885
2026-06-01 16:42:09,854 - DEBUG - Requesting: http://10.0.0.241:8082/routing-instance/faceb501-ae0d-40f5-a427-6c4938f15885
2026-06-01 16:42:09,866 - DEBUG - Requesting: http://10.0.0.241:8082/route-target/35934f62-6f03-4b72-a591-396067cd05bf
2026-06-01 16:42:09,874 - DEBUG - Route Targets: ['target:64512:8000012']
2026-06-01 16:42:09,875 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-network/9aa048bd-99d9-4287-a3f7-e54ef8b4bbbb
2026-06-01 16:42:09,887 - DEBUG - Requesting: http://10.0.0.241:8082/routing-instance/faceb501-ae0d-40f5-a427-6c4938f15885
2026-06-01 16:42:09,909 - INFO - Verified VN network id 22 for VN 9aa048bd-99d9-4287-a3f7-e54ef8b4bbbb
2026-06-01 16:42:09,909 - INFO - Verifications in API Server for VN ctest-trans_right_vn-54298248 passed
2026-06-01 16:42:09,909 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-network/9aa048bd-99d9-4287-a3f7-e54ef8b4bbbb
2026-06-01 16:42:09,923 - DEBUG - Requesting: http://10.0.0.241:8082/routing-instance/faceb501-ae0d-40f5-a427-6c4938f15885
2026-06-01 16:42:09,934 - DEBUG - Requesting: http://10.0.0.241:8082/routing-instance/faceb501-ae0d-40f5-a427-6c4938f15885
2026-06-01 16:42:09,944 - DEBUG - Requesting: http://10.0.0.241:8082/route-target/35934f62-6f03-4b72-a591-396067cd05bf
2026-06-01 16:42:09,963 - DEBUG - Control-node 10.0.0.241 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-08051395:ctest-trans_right_vn-54298248', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-08051395', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11141985457281778311', 'uuid-lslong': '11815164274772589499'}, 'enable': 'true', 'created': '2026-06-01T16:42:09', 'last-modified': '2026-06-01T16:42:09', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.470969'}
2026-06-01 16:42:09,971 - DEBUG - Route Targets: ['target:64512:8000012']
2026-06-01 16:42:09,980 - DEBUG - Control-node 10.0.0.242 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-08051395:ctest-trans_right_vn-54298248', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-08051395', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11141985457281778311', 'uuid-lslong': '11815164274772589499'}, 'enable': 'true', 'created': '2026-06-01T16:42:09', 'last-modified': '2026-06-01T16:42:09', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.486259'}
2026-06-01 16:42:09,990 - DEBUG - Route Targets: ['target:64512:8000012']
2026-06-01 16:42:09,996 - DEBUG - Control-node 10.0.0.19 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-08051395:ctest-trans_right_vn-54298248', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-08051395', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11141985457281778311', 'uuid-lslong': '11815164274772589499'}, 'enable': 'true', 'created': '2026-06-01T16:42:09', 'last-modified': '2026-06-01T16:42:09', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.504519'}
2026-06-01 16:42:10,003 - DEBUG - Route Targets: ['target:64512:8000012']
2026-06-01 16:42:10,003 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_right_vn-54298248 passed
2026-06-01 16:42:10,004 - DEBUG - ====Verifying policy data for ctest-trans_right_vn-54298248 in API_Server ======
2026-06-01 16:42:10,004 - DEBUG - Requesting: http://10.0.0.241:8082/domains
2026-06-01 16:42:10,011 - DEBUG - Requesting: http://10.0.0.241:8082/domain/4934cdf0-e2c0-49f7-8ec1-47ce02d5e849
2026-06-01 16:42:10,027 - DEBUG - Requesting: http://10.0.0.241:8082/project/45ef1a62-5dad-445c-924b-7ae6933cce02
2026-06-01 16:42:10,146 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-network/9aa048bd-99d9-4287-a3f7-e54ef8b4bbbb
2026-06-01 16:42:10,162 - DEBUG - =>VN ctest-trans_right_vn-54298248 has no policy to be verified
2026-06-01 16:42:10,162 - DEBUG - Verifying the vn in opserver
2026-06-01 16:42:10,162 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-08051395:ctest-trans_right_vn-54298248 virtual network link through opserver 10.0.0.241
2026-06-01 16:42:10,162 - DEBUG - Requesting: http://10.0.0.241:8081/analytics/uves/virtual-networks
2026-06-01 16:42:10,181 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-08051395:ctest-trans_right_vn-54298248', 'href': 'http://10.0.0.241:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-08051395:ctest-trans_right_vn-54298248?flat'}
2026-06-01 16:42:10,181 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-08051395:ctest-trans_right_vn-54298248 virtual network link through opserver 10.0.0.242
2026-06-01 16:42:10,181 - DEBUG - Requesting: http://10.0.0.242:8081/analytics/uves/virtual-networks
2026-06-01 16:42:10,200 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-08051395:ctest-trans_right_vn-54298248', 'href': 'http://10.0.0.242:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-08051395:ctest-trans_right_vn-54298248?flat'}
2026-06-01 16:42:10,200 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-08051395:ctest-trans_right_vn-54298248 virtual network link through opserver 10.0.0.19
2026-06-01 16:42:10,200 - DEBUG - Requesting: http://10.0.0.19:8081/analytics/uves/virtual-networks
2026-06-01 16:42:10,219 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-08051395:ctest-trans_right_vn-54298248', 'href': 'http://10.0.0.19:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-08051395:ctest-trans_right_vn-54298248?flat'}
2026-06-01 16:42:10,219 - INFO - Validated that VN default-domain:ctest-TestSvcHC-08051395:ctest-trans_right_vn-54298248 is found in opserver
2026-06-01 16:42:10,246 - DEBUG - Do not have enough data to verify VN in agent
2026-06-01 16:42:10,260 - DEBUG - VRF ids for VN ctest-trans_right_vn-54298248: {}
2026-06-01 16:42:11,695 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5870-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5870-2)
2026-06-01 16:42:13,536 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5870-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5870-1)
2026-06-01 16:42:13,536 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-28702175']
2026-06-01 16:42:13,835 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-28702175'] created succesfully
2026-06-01 16:42:14,398 - DEBUG - Image by name tiny_trans_fw not found
2026-06-01 16:42:14,398 - DEBUG - Installing image tiny_trans_fw
2026-06-01 16:42:14,399 - 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-06-01 16:42:14,399 - DEBUG - Image build path file:///contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2026-06-01 16:42:14,399 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2026-06-01 16:42:14,399 - DEBUG - Unzip image
2026-06-01 16:42:14,399 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2026-06-01 16:42:14,431 - INFO - image /contrail-test/images/tinycore-net-transparent-fw.qcow2 is not found
2026-06-01 16:42:14,432 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-28702175']
2026-06-01 16:42:14,549 - INFO - Service template: ['default-domain', 'ctest-service_template_1-28702175'] deleted successfully.
2026-06-01 16:42:14,549 - INFO - Skip interface_detach for VM ctest-right_vm-45656132 in state BUILD
2026-06-01 16:42:14,549 - INFO - Deleting VM ctest-right_vm-45656132
2026-06-01 16:42:14,549 - ERROR - VM ctest-right_vm-45656132 has failed to come up
2026-06-01 16:42:14,549 - ERROR - Nova failed to get host of the VM
2026-06-01 16:42:14,549 - ERROR - VM ctest-right_vm-45656132 has failed to come up
2026-06-01 16:42:14,549 - ERROR - Nova failed to get host of the VM
2026-06-01 16:42:14,684 - INFO - Skip interface_detach for VM ctest-left_vm-16168551 in state BUILD
2026-06-01 16:42:14,684 - INFO - Deleting VM ctest-left_vm-16168551
2026-06-01 16:42:14,684 - ERROR - VM ctest-left_vm-16168551 has failed to come up
2026-06-01 16:42:14,684 - ERROR - Nova failed to get host of the VM
2026-06-01 16:42:14,684 - ERROR - VM ctest-left_vm-16168551 has failed to come up
2026-06-01 16:42:14,684 - ERROR - Nova failed to get host of the VM
2026-06-01 16:42:14,772 - INFO - Deleting VN ctest-trans_right_vn-54298248
2026-06-01 16:42:14,931 - DEBUG - Response for deleting network ()
2026-06-01 16:42:14,932 - DEBUG - Requesting: http://10.0.0.241:8082/routing-instance/faceb501-ae0d-40f5-a427-6c4938f15885
2026-06-01 16:42:14,941 - DEBUG - Response Code: 404
2026-06-01 16:42:14,941 - DEBUG - Requesting: http://10.0.0.241:8082/domains
2026-06-01 16:42:14,948 - DEBUG - Requesting: http://10.0.0.241:8082/domain/4934cdf0-e2c0-49f7-8ec1-47ce02d5e849
2026-06-01 16:42:14,962 - DEBUG - Requesting: http://10.0.0.241:8082/project/45ef1a62-5dad-445c-924b-7ae6933cce02
2026-06-01 16:42:15,066 - INFO - Validated that VN ctest-trans_right_vn-54298248 is not found in API Server
2026-06-01 16:42:15,154 - DEBUG - VN ctest-trans_right_vn-54298248 is not present in Agent 10.0.0.141
2026-06-01 16:42:15,169 - DEBUG - VN ctest-trans_right_vn-54298248 is not present in Agent 10.0.0.27
2026-06-01 16:42:15,170 - INFO - Validated that VN ctest-trans_right_vn-54298248 is not in any agent
2026-06-01 16:42:15,226 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-trans_right_vn-54298248 info
2026-06-01 16:42:15,226 - INFO - Deleting VN ctest-trans_left_vn-91522909
2026-06-01 16:42:15,397 - DEBUG - Response for deleting network ()
2026-06-01 16:42:15,397 - DEBUG - Requesting: http://10.0.0.241:8082/routing-instance/6478432d-eec0-4ae0-bf0d-e14f23213ba8
2026-06-01 16:42:15,411 - DEBUG - Response Code: 404
2026-06-01 16:42:15,412 - DEBUG - Requesting: http://10.0.0.241:8082/domains
2026-06-01 16:42:15,442 - DEBUG - Requesting: http://10.0.0.241:8082/domain/4934cdf0-e2c0-49f7-8ec1-47ce02d5e849
2026-06-01 16:42:15,492 - DEBUG - Requesting: http://10.0.0.241:8082/project/45ef1a62-5dad-445c-924b-7ae6933cce02
2026-06-01 16:42:15,602 - INFO - Validated that VN ctest-trans_left_vn-91522909 is not found in API Server
2026-06-01 16:42:15,630 - DEBUG - VN ctest-trans_left_vn-91522909 is not present in Agent 10.0.0.141
2026-06-01 16:42:15,642 - DEBUG - VN ctest-trans_left_vn-91522909 is not present in Agent 10.0.0.27
2026-06-01 16:42:15,642 - INFO - Validated that VN ctest-trans_left_vn-91522909 is not in any agent
2026-06-01 16:42:15,696 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-trans_left_vn-91522909 info
2026-06-01 16:42:15,699 - INFO - Deleting VN ctest-right_vn-08220523
2026-06-01 16:42:15,815 - DEBUG - VN 6a80bf47-f2c0-49d2-bb1c-3361bfe22b76 still in use: Unable to complete operation on network 6a80bf47-f2c0-49d2-bb1c-3361bfe22b76. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-5c4020e7-879c-410d-b2e0-658f8f71a34c']
2026-06-01 16:42:15,815 - WARNING - Deleting VN ctest-right_vn-08220523 failed..Will retry
2026-06-01 16:42:18,033 - DEBUG - Response for deleting network ()
2026-06-01 16:42:18,033 - DEBUG - Requesting: http://10.0.0.241:8082/routing-instance/519761be-26cb-43d6-87e8-d39a82876730
2026-06-01 16:42:18,040 - DEBUG - Response Code: 404
2026-06-01 16:42:18,041 - DEBUG - Requesting: http://10.0.0.241:8082/domains
2026-06-01 16:42:18,055 - DEBUG - Requesting: http://10.0.0.241:8082/domain/4934cdf0-e2c0-49f7-8ec1-47ce02d5e849
2026-06-01 16:42:18,111 - DEBUG - Requesting: http://10.0.0.241:8082/project/45ef1a62-5dad-445c-924b-7ae6933cce02
2026-06-01 16:42:18,216 - INFO - Validated that VN ctest-right_vn-08220523 is not found in API Server
2026-06-01 16:42:18,232 - DEBUG - VN ctest-right_vn-08220523 is not present in Agent 10.0.0.141
2026-06-01 16:42:18,243 - DEBUG - VN ctest-right_vn-08220523 is not present in Agent 10.0.0.27
2026-06-01 16:42:18,243 - INFO - Validated that VN ctest-right_vn-08220523 is not in any agent
2026-06-01 16:42:18,297 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-08220523 info
2026-06-01 16:42:18,298 - INFO - Deleting VN ctest-left_vn-42394725
2026-06-01 16:42:18,493 - DEBUG - Response for deleting network ()
2026-06-01 16:42:18,493 - DEBUG - Requesting: http://10.0.0.241:8082/routing-instance/5ba74996-a7bd-46dd-be82-ab1148dbbee5
2026-06-01 16:42:18,501 - DEBUG - Response Code: 404
2026-06-01 16:42:18,501 - DEBUG - Requesting: http://10.0.0.241:8082/domains
2026-06-01 16:42:18,508 - DEBUG - Requesting: http://10.0.0.241:8082/domain/4934cdf0-e2c0-49f7-8ec1-47ce02d5e849
2026-06-01 16:42:18,521 - DEBUG - Requesting: http://10.0.0.241:8082/project/45ef1a62-5dad-445c-924b-7ae6933cce02
2026-06-01 16:42:18,635 - INFO - Validated that VN ctest-left_vn-42394725 is not found in API Server
2026-06-01 16:42:18,648 - DEBUG - VN ctest-left_vn-42394725 is not present in Agent 10.0.0.141
2026-06-01 16:42:18,663 - DEBUG - VN ctest-left_vn-42394725 is not present in Agent 10.0.0.27
2026-06-01 16:42:18,663 - INFO - Validated that VN ctest-left_vn-42394725 is not in any agent
2026-06-01 16:42:18,704 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-42394725 info
2026-06-01 16:42:18,705 - INFO - Deleting VN ctest-mgmt_vn-83981971
2026-06-01 16:42:18,872 - DEBUG - Response for deleting network ()
2026-06-01 16:42:18,872 - DEBUG - Requesting: http://10.0.0.241:8082/routing-instance/2833fd46-9896-42bf-a6c9-cdf4731923ad
2026-06-01 16:42:18,878 - DEBUG - Response Code: 404
2026-06-01 16:42:18,879 - DEBUG - Requesting: http://10.0.0.241:8082/domains
2026-06-01 16:42:18,886 - DEBUG - Requesting: http://10.0.0.241:8082/domain/4934cdf0-e2c0-49f7-8ec1-47ce02d5e849
2026-06-01 16:42:18,910 - DEBUG - Requesting: http://10.0.0.241:8082/project/45ef1a62-5dad-445c-924b-7ae6933cce02
2026-06-01 16:42:19,021 - INFO - Validated that VN ctest-mgmt_vn-83981971 is not found in API Server
2026-06-01 16:42:19,037 - DEBUG - VN ctest-mgmt_vn-83981971 is not present in Agent 10.0.0.141
2026-06-01 16:42:19,052 - DEBUG - VN ctest-mgmt_vn-83981971 is not present in Agent 10.0.0.27
2026-06-01 16:42:19,052 - INFO - Validated that VN ctest-mgmt_vn-83981971 is not in any agent
2026-06-01 16:42:19,094 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-83981971 info
2026-06-01 16:42:20,434 - DEBUG - No XMPP flaps were noticed during the test
2026-06-01 16:42:20,434 - INFO -
2026-06-01 16:42:20,434 - INFO - END TEST : test_svc_trans_segment_right_hc_fail_svm : SKIPPED[0:00:18]
2026-06-01 16:42:20,434 - INFO - --------------------------------------------------------------------------------
2026-06-01 16:42:21,318 - INFO - Deleted project: ctest-TestSvcHC-08051395, ID : 45ef1a62-5dad-445c-924b-7ae6933cce02