2025-07-21 13:43:19,599 - INFO - Domain Default found not creating
2025-07-21 13:43:20,037 - INFO - Project ctest-TestSVCV2Mirror-28126996 not found, creating it
2025-07-21 13:43:20,703 - INFO - Created Project:ctest-TestSVCV2Mirror-28126996, ID : 55614cc7-e660-48c7-a84e-d872cae34e05
2025-07-21 13:43:22,924 - INFO - ================================================================================
2025-07-21 13:43:22,925 - INFO - STARTING TEST : test_svc_v2_mirroring
2025-07-21 13:43:22,925 - INFO - TEST DESCRIPTION : Validate the service chain mirroring
2025-07-21 13:43:23,255 - DEBUG - Nothing to compare xmpp stats {'10.0.0.254': {'10.20.0.17': '0'}} with
2025-07-21 13:43:23,256 - INFO - Initial checks done. Running the testcase now
2025-07-21 13:43:23,256 - INFO -
2025-07-21 13:43:24,030 - DEBUG - Response for create_network : {'network': {'id': '5f646d0c-16d8-4901-933f-cd45cab2339a', 'name': 'ctest-left-81510986', 'tenant_id': '55614cc7e66048c7a84ed872cae34e05', 'project_id': '55614cc7e66048c7a84ed872cae34e05', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSVCV2Mirror-28126996', 'ctest-left-81510986'], 'port_security_enabled': True, 'description': ''}}
2025-07-21 13:43:24,228 - DEBUG - Response for create_subnet : {'subnet': {'id': '2b504111-2d5c-4580-9f86-a6cd71e9e6ab', 'name': '', 'tenant_id': '55614cc7e66048c7a84ed872cae34e05', 'network_id': '5f646d0c-16d8-4901-933f-cd45cab2339a', 'ip_version': 4, 'cidr': '5.5.10.128/26', 'allocation_pools': [{'start': '5.5.10.130', 'end': '5.5.10.190'}], 'gateway_ip': '5.5.10.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '5.5.10.130', 'tags': [], 'project_id': '55614cc7e66048c7a84ed872cae34e05'}}
2025-07-21 13:43:24,249 - INFO - Created VN ctest-left-81510986
2025-07-21 13:43:24,305 - DEBUG - VN ctest-left-81510986 UUID is 5f646d0c-16d8-4901-933f-cd45cab2339a
2025-07-21 13:43:24,494 - DEBUG - Requesting: http://10.0.0.254:8082/domains
2025-07-21 13:43:24,923 - DEBUG - Requesting: http://10.0.0.254:8082/domains
2025-07-21 13:43:24,974 - DEBUG - Requesting: http://10.0.0.254:8082/domain/6f2dbf83-3a1f-4a4f-8676-305ebe4efd33
2025-07-21 13:43:25,004 - DEBUG - Requesting: http://10.0.0.254:8082/project/55614cc7-e660-48c7-a84e-d872cae34e05
2025-07-21 13:43:25,100 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-network/5f646d0c-16d8-4901-933f-cd45cab2339a
2025-07-21 13:43:25,127 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-network/5f646d0c-16d8-4901-933f-cd45cab2339a
2025-07-21 13:43:25,159 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/b00de7d0-84f8-4f0b-a7a5-e081382a5a2a
2025-07-21 13:43:25,184 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/b00de7d0-84f8-4f0b-a7a5-e081382a5a2a
2025-07-21 13:43:25,206 - DEBUG - Requesting: http://10.0.0.254:8082/route-target/272394fa-eff5-4745-883a-7606884a761a
2025-07-21 13:43:25,228 - DEBUG - Route Targets: ['target:64512:8000011']
2025-07-21 13:43:25,228 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-network/5f646d0c-16d8-4901-933f-cd45cab2339a
2025-07-21 13:43:25,260 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/b00de7d0-84f8-4f0b-a7a5-e081382a5a2a
2025-07-21 13:43:25,308 - INFO - Verified VN network id 16 for VN 5f646d0c-16d8-4901-933f-cd45cab2339a
2025-07-21 13:43:25,308 - INFO - Verifications in API Server for VN ctest-left-81510986 passed
2025-07-21 13:43:25,309 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-network/5f646d0c-16d8-4901-933f-cd45cab2339a
2025-07-21 13:43:25,343 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/b00de7d0-84f8-4f0b-a7a5-e081382a5a2a
2025-07-21 13:43:25,366 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/b00de7d0-84f8-4f0b-a7a5-e081382a5a2a
2025-07-21 13:43:25,394 - DEBUG - Requesting: http://10.0.0.254:8082/route-target/272394fa-eff5-4745-883a-7606884a761a
2025-07-21 13:43:25,438 - DEBUG - Control-node 10.0.0.254 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSVCV2Mirror-28126996:ctest-left-81510986', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSVCV2Mirror-28126996', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6873738829964527873', 'uuid-lslong': '10610424946745291674'}, 'enable': 'true', 'created': '2025-07-21T13:43:23', 'last-modified': '2025-07-21T13:43:24', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.241522'}
2025-07-21 13:43:25,462 - DEBUG - Route Targets: ['target:64512:8000011']
2025-07-21 13:43:25,462 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left-81510986 passed
2025-07-21 13:43:25,462 - DEBUG - ====Verifying policy data for ctest-left-81510986 in API_Server ======
2025-07-21 13:43:25,463 - DEBUG - Requesting: http://10.0.0.254:8082/domains
2025-07-21 13:43:25,482 - DEBUG - Requesting: http://10.0.0.254:8082/domain/6f2dbf83-3a1f-4a4f-8676-305ebe4efd33
2025-07-21 13:43:25,523 - DEBUG - Requesting: http://10.0.0.254:8082/project/55614cc7-e660-48c7-a84e-d872cae34e05
2025-07-21 13:43:25,614 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-network/5f646d0c-16d8-4901-933f-cd45cab2339a
2025-07-21 13:43:25,639 - DEBUG - =>VN ctest-left-81510986 has no policy to be verified
2025-07-21 13:43:25,640 - DEBUG - Verifying the vn in opserver
2025-07-21 13:43:25,641 - DEBUG - Verifying the default-domain:ctest-TestSVCV2Mirror-28126996:ctest-left-81510986 virtual network link through opserver 10.0.0.254
2025-07-21 13:43:25,641 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-networks
2025-07-21 13:43:25,981 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-networks
2025-07-21 13:43:26,167 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSVCV2Mirror-28126996:ctest-left-81510986', 'href': 'http://10.0.0.254:8081/analytics/uves/virtual-network/default-domain:ctest-TestSVCV2Mirror-28126996:ctest-left-81510986?flat'}
2025-07-21 13:43:26,167 - INFO - Validated that VN default-domain:ctest-TestSVCV2Mirror-28126996:ctest-left-81510986 is found in opserver
2025-07-21 13:43:26,205 - DEBUG - Do not have enough data to verify VN in agent
2025-07-21 13:43:26,224 - DEBUG - VRF ids for VN ctest-left-81510986: {}
2025-07-21 13:43:26,549 - DEBUG - Response for create_network : {'network': {'id': 'bcd80a34-8a5f-4abf-8932-a9c822120273', 'name': 'ctest-right-13500432', 'tenant_id': '55614cc7e66048c7a84ed872cae34e05', 'project_id': '55614cc7e66048c7a84ed872cae34e05', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSVCV2Mirror-28126996', 'ctest-right-13500432'], 'port_security_enabled': True, 'description': ''}}
2025-07-21 13:43:26,783 - DEBUG - Response for create_subnet : {'subnet': {'id': 'ed015ff0-49d9-4ed8-8739-b0f9aed1cc22', 'name': '', 'tenant_id': '55614cc7e66048c7a84ed872cae34e05', 'network_id': 'bcd80a34-8a5f-4abf-8932-a9c822120273', 'ip_version': 4, 'cidr': '52.81.159.192/26', 'allocation_pools': [{'start': '52.81.159.194', 'end': '52.81.159.254'}], 'gateway_ip': '52.81.159.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '52.81.159.194', 'tags': [], 'project_id': '55614cc7e66048c7a84ed872cae34e05'}}
2025-07-21 13:43:26,808 - INFO - Created VN ctest-right-13500432
2025-07-21 13:43:26,869 - DEBUG - VN ctest-right-13500432 UUID is bcd80a34-8a5f-4abf-8932-a9c822120273
2025-07-21 13:43:27,054 - DEBUG - Requesting: http://10.0.0.254:8082/domains
2025-07-21 13:43:27,069 - DEBUG - Requesting: http://10.0.0.254:8082/domain/6f2dbf83-3a1f-4a4f-8676-305ebe4efd33
2025-07-21 13:43:27,094 - DEBUG - Requesting: http://10.0.0.254:8082/project/55614cc7-e660-48c7-a84e-d872cae34e05
2025-07-21 13:43:27,227 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-network/bcd80a34-8a5f-4abf-8932-a9c822120273
2025-07-21 13:43:27,262 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-network/bcd80a34-8a5f-4abf-8932-a9c822120273
2025-07-21 13:43:27,284 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/2854380f-25a6-4658-add2-3bbbeaac1b1c
2025-07-21 13:43:27,300 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/2854380f-25a6-4658-add2-3bbbeaac1b1c
2025-07-21 13:43:27,315 - DEBUG - Requesting: http://10.0.0.254:8082/route-target/ec3dca32-1f34-43ce-9d2b-e848258314f9
2025-07-21 13:43:27,330 - DEBUG - Route Targets: ['target:64512:8000012']
2025-07-21 13:43:27,331 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-network/bcd80a34-8a5f-4abf-8932-a9c822120273
2025-07-21 13:43:27,352 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/2854380f-25a6-4658-add2-3bbbeaac1b1c
2025-07-21 13:43:27,385 - INFO - Verified VN network id 17 for VN bcd80a34-8a5f-4abf-8932-a9c822120273
2025-07-21 13:43:27,385 - INFO - Verifications in API Server for VN ctest-right-13500432 passed
2025-07-21 13:43:27,385 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-network/bcd80a34-8a5f-4abf-8932-a9c822120273
2025-07-21 13:43:27,415 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/2854380f-25a6-4658-add2-3bbbeaac1b1c
2025-07-21 13:43:27,436 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/2854380f-25a6-4658-add2-3bbbeaac1b1c
2025-07-21 13:43:27,459 - DEBUG - Requesting: http://10.0.0.254:8082/route-target/ec3dca32-1f34-43ce-9d2b-e848258314f9
2025-07-21 13:43:27,503 - DEBUG - Control-node 10.0.0.254 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSVCV2Mirror-28126996:ctest-right-13500432', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSVCV2Mirror-28126996', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13607637494876031679', 'uuid-lslong': '9886150809061818995'}, 'enable': 'true', 'created': '2025-07-21T13:43:26', 'last-modified': '2025-07-21T13:43:26', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.756472'}
2025-07-21 13:43:27,526 - DEBUG - Route Targets: ['target:64512:8000012']
2025-07-21 13:43:27,527 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right-13500432 passed
2025-07-21 13:43:27,527 - DEBUG - ====Verifying policy data for ctest-right-13500432 in API_Server ======
2025-07-21 13:43:27,527 - DEBUG - Requesting: http://10.0.0.254:8082/domains
2025-07-21 13:43:27,542 - DEBUG - Requesting: http://10.0.0.254:8082/domain/6f2dbf83-3a1f-4a4f-8676-305ebe4efd33
2025-07-21 13:43:27,576 - DEBUG - Requesting: http://10.0.0.254:8082/project/55614cc7-e660-48c7-a84e-d872cae34e05
2025-07-21 13:43:27,707 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-network/bcd80a34-8a5f-4abf-8932-a9c822120273
2025-07-21 13:43:27,735 - DEBUG - =>VN ctest-right-13500432 has no policy to be verified
2025-07-21 13:43:27,735 - DEBUG - Verifying the vn in opserver
2025-07-21 13:43:27,735 - DEBUG - Verifying the default-domain:ctest-TestSVCV2Mirror-28126996:ctest-right-13500432 virtual network link through opserver 10.0.0.254
2025-07-21 13:43:27,736 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-networks
2025-07-21 13:43:27,778 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSVCV2Mirror-28126996:ctest-right-13500432', 'href': 'http://10.0.0.254:8081/analytics/uves/virtual-network/default-domain:ctest-TestSVCV2Mirror-28126996:ctest-right-13500432?flat'}
2025-07-21 13:43:27,779 - INFO - Validated that VN default-domain:ctest-TestSVCV2Mirror-28126996:ctest-right-13500432 is found in opserver
2025-07-21 13:43:27,818 - DEBUG - Do not have enough data to verify VN in agent
2025-07-21 13:43:27,840 - DEBUG - VRF ids for VN ctest-right-13500432: {}
2025-07-21 13:43:28,239 - DEBUG - Response for create_network : {'network': {'id': '7513f065-add1-4f14-a5a4-47e37879f013', 'name': 'ctest-mgmt_vn-07012480', 'tenant_id': '55614cc7e66048c7a84ed872cae34e05', 'project_id': '55614cc7e66048c7a84ed872cae34e05', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSVCV2Mirror-28126996', 'ctest-mgmt_vn-07012480'], 'port_security_enabled': True, 'description': ''}}
2025-07-21 13:43:28,542 - DEBUG - Response for create_subnet : {'subnet': {'id': 'ef0822d7-4cfc-43bf-b791-13fbeaa0f0f9', 'name': '', 'tenant_id': '55614cc7e66048c7a84ed872cae34e05', 'network_id': '7513f065-add1-4f14-a5a4-47e37879f013', 'ip_version': 4, 'cidr': '156.11.188.0/26', 'allocation_pools': [{'start': '156.11.188.2', 'end': '156.11.188.62'}], 'gateway_ip': '156.11.188.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '156.11.188.2', 'tags': [], 'project_id': '55614cc7e66048c7a84ed872cae34e05'}}
2025-07-21 13:43:28,588 - INFO - Created VN ctest-mgmt_vn-07012480
2025-07-21 13:43:28,659 - DEBUG - VN ctest-mgmt_vn-07012480 UUID is 7513f065-add1-4f14-a5a4-47e37879f013
2025-07-21 13:43:28,787 - DEBUG - Requesting: http://10.0.0.254:8082/domains
2025-07-21 13:43:28,796 - DEBUG - Requesting: http://10.0.0.254:8082/domain/6f2dbf83-3a1f-4a4f-8676-305ebe4efd33
2025-07-21 13:43:28,817 - DEBUG - Requesting: http://10.0.0.254:8082/project/55614cc7-e660-48c7-a84e-d872cae34e05
2025-07-21 13:43:28,910 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-network/7513f065-add1-4f14-a5a4-47e37879f013
2025-07-21 13:43:28,951 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-network/7513f065-add1-4f14-a5a4-47e37879f013
2025-07-21 13:43:28,981 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/3adc70fa-bd4f-4e08-8139-8375fb629373
2025-07-21 13:43:29,001 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/3adc70fa-bd4f-4e08-8139-8375fb629373
2025-07-21 13:43:29,018 - DEBUG - Requesting: http://10.0.0.254:8082/route-target/51fc8550-c109-487b-8d2a-dc264aba58e1
2025-07-21 13:43:29,035 - DEBUG - Route Targets: ['target:64512:8000013']
2025-07-21 13:43:29,035 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-network/7513f065-add1-4f14-a5a4-47e37879f013
2025-07-21 13:43:29,058 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/3adc70fa-bd4f-4e08-8139-8375fb629373
2025-07-21 13:43:29,100 - INFO - Verified VN network id 18 for VN 7513f065-add1-4f14-a5a4-47e37879f013
2025-07-21 13:43:29,100 - INFO - Verifications in API Server for VN ctest-mgmt_vn-07012480 passed
2025-07-21 13:43:29,100 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-network/7513f065-add1-4f14-a5a4-47e37879f013
2025-07-21 13:43:29,122 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/3adc70fa-bd4f-4e08-8139-8375fb629373
2025-07-21 13:43:29,137 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/3adc70fa-bd4f-4e08-8139-8375fb629373
2025-07-21 13:43:29,153 - DEBUG - Requesting: http://10.0.0.254:8082/route-target/51fc8550-c109-487b-8d2a-dc264aba58e1
2025-07-21 13:43:29,177 - DEBUG - Control-node 10.0.0.254 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSVCV2Mirror-28126996:ctest-mgmt_vn-07012480', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSVCV2Mirror-28126996', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8436350846493609748', 'uuid-lslong': '11935743954743062547'}, 'enable': 'true', 'created': '2025-07-21T13:43:28', 'last-modified': '2025-07-21T13:43:28', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.704917'}
2025-07-21 13:43:29,193 - DEBUG - Route Targets: ['target:64512:8000013']
2025-07-21 13:43:29,193 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-07012480 passed
2025-07-21 13:43:29,193 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-07012480 in API_Server ======
2025-07-21 13:43:29,193 - DEBUG - Requesting: http://10.0.0.254:8082/domains
2025-07-21 13:43:29,209 - DEBUG - Requesting: http://10.0.0.254:8082/domain/6f2dbf83-3a1f-4a4f-8676-305ebe4efd33
2025-07-21 13:43:29,234 - DEBUG - Requesting: http://10.0.0.254:8082/project/55614cc7-e660-48c7-a84e-d872cae34e05
2025-07-21 13:43:29,328 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-network/7513f065-add1-4f14-a5a4-47e37879f013
2025-07-21 13:43:29,349 - DEBUG - =>VN ctest-mgmt_vn-07012480 has no policy to be verified
2025-07-21 13:43:29,349 - DEBUG - Verifying the vn in opserver
2025-07-21 13:43:29,349 - DEBUG - Verifying the default-domain:ctest-TestSVCV2Mirror-28126996:ctest-mgmt_vn-07012480 virtual network link through opserver 10.0.0.254
2025-07-21 13:43:29,349 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-networks
2025-07-21 13:43:29,371 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSVCV2Mirror-28126996:ctest-mgmt_vn-07012480', 'href': 'http://10.0.0.254:8081/analytics/uves/virtual-network/default-domain:ctest-TestSVCV2Mirror-28126996:ctest-mgmt_vn-07012480?flat'}
2025-07-21 13:43:29,371 - INFO - Validated that VN default-domain:ctest-TestSVCV2Mirror-28126996:ctest-mgmt_vn-07012480 is found in opserver
2025-07-21 13:43:29,395 - DEBUG - Do not have enough data to verify VN in agent
2025-07-21 13:43:29,406 - DEBUG - VRF ids for VN ctest-mgmt_vn-07012480: {}
2025-07-21 13:43:29,674 - DEBUG - Response for create_network : {'network': {'id': 'c0f02ccd-ca3a-4635-afa4-db15d7f29d33', 'name': 'ctest-trans_left_vn-96647965', 'tenant_id': '55614cc7e66048c7a84ed872cae34e05', 'project_id': '55614cc7e66048c7a84ed872cae34e05', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSVCV2Mirror-28126996', 'ctest-trans_left_vn-96647965'], 'port_security_enabled': True, 'description': ''}}
2025-07-21 13:43:29,913 - DEBUG - Response for create_subnet : {'subnet': {'id': '73dc84a1-9410-4aac-bc2d-b75032e9bd9d', 'name': '', 'tenant_id': '55614cc7e66048c7a84ed872cae34e05', 'network_id': 'c0f02ccd-ca3a-4635-afa4-db15d7f29d33', 'ip_version': 4, 'cidr': '209.191.32.0/26', 'allocation_pools': [{'start': '209.191.32.2', 'end': '209.191.32.62'}], 'gateway_ip': '209.191.32.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '209.191.32.2', 'tags': [], 'project_id': '55614cc7e66048c7a84ed872cae34e05'}}
2025-07-21 13:43:29,942 - INFO - Created VN ctest-trans_left_vn-96647965
2025-07-21 13:43:30,009 - DEBUG - VN ctest-trans_left_vn-96647965 UUID is c0f02ccd-ca3a-4635-afa4-db15d7f29d33
2025-07-21 13:43:30,190 - DEBUG - Requesting: http://10.0.0.254:8082/domains
2025-07-21 13:43:30,201 - DEBUG - Requesting: http://10.0.0.254:8082/domain/6f2dbf83-3a1f-4a4f-8676-305ebe4efd33
2025-07-21 13:43:30,225 - DEBUG - Requesting: http://10.0.0.254:8082/project/55614cc7-e660-48c7-a84e-d872cae34e05
2025-07-21 13:43:30,314 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-network/c0f02ccd-ca3a-4635-afa4-db15d7f29d33
2025-07-21 13:43:30,329 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-network/c0f02ccd-ca3a-4635-afa4-db15d7f29d33
2025-07-21 13:43:30,339 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/547b5eda-405f-47ba-ae7b-b8432bea7efa
2025-07-21 13:43:30,349 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/547b5eda-405f-47ba-ae7b-b8432bea7efa
2025-07-21 13:43:30,358 - DEBUG - Requesting: http://10.0.0.254:8082/route-target/5500dfa1-2188-492f-b7e7-a42400e3cdd4
2025-07-21 13:43:30,368 - DEBUG - Route Targets: ['target:64512:8000014']
2025-07-21 13:43:30,369 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-network/c0f02ccd-ca3a-4635-afa4-db15d7f29d33
2025-07-21 13:43:30,382 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/547b5eda-405f-47ba-ae7b-b8432bea7efa
2025-07-21 13:43:30,403 - INFO - Verified VN network id 19 for VN c0f02ccd-ca3a-4635-afa4-db15d7f29d33
2025-07-21 13:43:30,403 - INFO - Verifications in API Server for VN ctest-trans_left_vn-96647965 passed
2025-07-21 13:43:30,403 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-network/c0f02ccd-ca3a-4635-afa4-db15d7f29d33
2025-07-21 13:43:30,418 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/547b5eda-405f-47ba-ae7b-b8432bea7efa
2025-07-21 13:43:30,428 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/547b5eda-405f-47ba-ae7b-b8432bea7efa
2025-07-21 13:43:30,437 - DEBUG - Requesting: http://10.0.0.254:8082/route-target/5500dfa1-2188-492f-b7e7-a42400e3cdd4
2025-07-21 13:43:30,457 - DEBUG - Control-node 10.0.0.254 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSVCV2Mirror-28126996:ctest-trans_left_vn-96647965', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSVCV2Mirror-28126996', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13902661312065455669', 'uuid-lslong': '12656481739681733939'}, 'enable': 'true', 'created': '2025-07-21T13:43:29', 'last-modified': '2025-07-21T13:43:29', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.599896'}
2025-07-21 13:43:30,466 - DEBUG - Route Targets: ['target:64512:8000014']
2025-07-21 13:43:30,466 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_left_vn-96647965 passed
2025-07-21 13:43:30,467 - DEBUG - ====Verifying policy data for ctest-trans_left_vn-96647965 in API_Server ======
2025-07-21 13:43:30,467 - DEBUG - Requesting: http://10.0.0.254:8082/domains
2025-07-21 13:43:30,477 - DEBUG - Requesting: http://10.0.0.254:8082/domain/6f2dbf83-3a1f-4a4f-8676-305ebe4efd33
2025-07-21 13:43:30,498 - DEBUG - Requesting: http://10.0.0.254:8082/project/55614cc7-e660-48c7-a84e-d872cae34e05
2025-07-21 13:43:30,612 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-network/c0f02ccd-ca3a-4635-afa4-db15d7f29d33
2025-07-21 13:43:30,630 - DEBUG - =>VN ctest-trans_left_vn-96647965 has no policy to be verified
2025-07-21 13:43:30,630 - DEBUG - Verifying the vn in opserver
2025-07-21 13:43:30,630 - DEBUG - Verifying the default-domain:ctest-TestSVCV2Mirror-28126996:ctest-trans_left_vn-96647965 virtual network link through opserver 10.0.0.254
2025-07-21 13:43:30,630 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-networks
2025-07-21 13:43:30,645 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSVCV2Mirror-28126996:ctest-trans_left_vn-96647965', 'href': 'http://10.0.0.254:8081/analytics/uves/virtual-network/default-domain:ctest-TestSVCV2Mirror-28126996:ctest-trans_left_vn-96647965?flat'}
2025-07-21 13:43:30,646 - INFO - Validated that VN default-domain:ctest-TestSVCV2Mirror-28126996:ctest-trans_left_vn-96647965 is found in opserver
2025-07-21 13:43:30,665 - DEBUG - Do not have enough data to verify VN in agent
2025-07-21 13:43:30,674 - DEBUG - VRF ids for VN ctest-trans_left_vn-96647965: {}
2025-07-21 13:43:30,963 - DEBUG - Response for create_network : {'network': {'id': '5138ad93-917a-4160-9c92-d74153da880c', 'name': 'ctest-trans_right_vn-96062265', 'tenant_id': '55614cc7e66048c7a84ed872cae34e05', 'project_id': '55614cc7e66048c7a84ed872cae34e05', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSVCV2Mirror-28126996', 'ctest-trans_right_vn-96062265'], 'port_security_enabled': True, 'description': ''}}
2025-07-21 13:43:31,213 - DEBUG - Response for create_subnet : {'subnet': {'id': '07c5126d-ca53-44fd-b0e7-ad3afd67cfc1', 'name': '', 'tenant_id': '55614cc7e66048c7a84ed872cae34e05', 'network_id': '5138ad93-917a-4160-9c92-d74153da880c', 'ip_version': 4, 'cidr': '34.184.111.0/26', 'allocation_pools': [{'start': '34.184.111.2', 'end': '34.184.111.62'}], 'gateway_ip': '34.184.111.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '34.184.111.2', 'tags': [], 'project_id': '55614cc7e66048c7a84ed872cae34e05'}}
2025-07-21 13:43:31,237 - INFO - Created VN ctest-trans_right_vn-96062265
2025-07-21 13:43:31,292 - DEBUG - VN ctest-trans_right_vn-96062265 UUID is 5138ad93-917a-4160-9c92-d74153da880c
2025-07-21 13:43:31,434 - DEBUG - Requesting: http://10.0.0.254:8082/domains
2025-07-21 13:43:31,442 - DEBUG - Requesting: http://10.0.0.254:8082/domain/6f2dbf83-3a1f-4a4f-8676-305ebe4efd33
2025-07-21 13:43:31,459 - DEBUG - Requesting: http://10.0.0.254:8082/project/55614cc7-e660-48c7-a84e-d872cae34e05
2025-07-21 13:43:31,547 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-network/5138ad93-917a-4160-9c92-d74153da880c
2025-07-21 13:43:31,561 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-network/5138ad93-917a-4160-9c92-d74153da880c
2025-07-21 13:43:31,574 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/2f5c0733-6384-4d38-b0bc-98d328ae311d
2025-07-21 13:43:31,583 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/2f5c0733-6384-4d38-b0bc-98d328ae311d
2025-07-21 13:43:31,594 - DEBUG - Requesting: http://10.0.0.254:8082/route-target/e3e2a046-fb37-4e78-8607-fa01a11c661a
2025-07-21 13:43:31,604 - DEBUG - Route Targets: ['target:64512:8000015']
2025-07-21 13:43:31,604 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-network/5138ad93-917a-4160-9c92-d74153da880c
2025-07-21 13:43:31,617 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/2f5c0733-6384-4d38-b0bc-98d328ae311d
2025-07-21 13:43:31,634 - INFO - Verified VN network id 20 for VN 5138ad93-917a-4160-9c92-d74153da880c
2025-07-21 13:43:31,634 - INFO - Verifications in API Server for VN ctest-trans_right_vn-96062265 passed
2025-07-21 13:43:31,635 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-network/5138ad93-917a-4160-9c92-d74153da880c
2025-07-21 13:43:31,649 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/2f5c0733-6384-4d38-b0bc-98d328ae311d
2025-07-21 13:43:31,659 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/2f5c0733-6384-4d38-b0bc-98d328ae311d
2025-07-21 13:43:31,674 - DEBUG - Requesting: http://10.0.0.254:8082/route-target/e3e2a046-fb37-4e78-8607-fa01a11c661a
2025-07-21 13:43:31,690 - DEBUG - Control-node 10.0.0.254 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSVCV2Mirror-28126996:ctest-trans_right_vn-96062265', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSVCV2Mirror-28126996', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5852618565080465760', 'uuid-lslong': '11282316692096190476'}, 'enable': 'true', 'created': '2025-07-21T13:43:30', 'last-modified': '2025-07-21T13:43:31', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.528339'}
2025-07-21 13:43:31,698 - DEBUG - Route Targets: ['target:64512:8000015']
2025-07-21 13:43:31,698 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_right_vn-96062265 passed
2025-07-21 13:43:31,698 - DEBUG - ====Verifying policy data for ctest-trans_right_vn-96062265 in API_Server ======
2025-07-21 13:43:31,698 - DEBUG - Requesting: http://10.0.0.254:8082/domains
2025-07-21 13:43:31,706 - DEBUG - Requesting: http://10.0.0.254:8082/domain/6f2dbf83-3a1f-4a4f-8676-305ebe4efd33
2025-07-21 13:43:31,719 - DEBUG - Requesting: http://10.0.0.254:8082/project/55614cc7-e660-48c7-a84e-d872cae34e05
2025-07-21 13:43:31,798 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-network/5138ad93-917a-4160-9c92-d74153da880c
2025-07-21 13:43:31,813 - DEBUG - =>VN ctest-trans_right_vn-96062265 has no policy to be verified
2025-07-21 13:43:31,813 - DEBUG - Verifying the vn in opserver
2025-07-21 13:43:31,813 - DEBUG - Verifying the default-domain:ctest-TestSVCV2Mirror-28126996:ctest-trans_right_vn-96062265 virtual network link through opserver 10.0.0.254
2025-07-21 13:43:31,813 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-networks
2025-07-21 13:43:31,827 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSVCV2Mirror-28126996:ctest-trans_right_vn-96062265', 'href': 'http://10.0.0.254:8081/analytics/uves/virtual-network/default-domain:ctest-TestSVCV2Mirror-28126996:ctest-trans_right_vn-96062265?flat'}
2025-07-21 13:43:31,827 - INFO - Validated that VN default-domain:ctest-TestSVCV2Mirror-28126996:ctest-trans_right_vn-96062265 is found in opserver
2025-07-21 13:43:31,846 - DEBUG - Do not have enough data to verify VN in agent
2025-07-21 13:43:31,853 - DEBUG - VRF ids for VN ctest-trans_right_vn-96062265: {}
2025-07-21 13:43:31,970 - DEBUG - Services list from nova: [Traceback (most recent call last):
File "/contrail-test/tcutils/wrappers.py", line 80, in wrapper
result = function(self, *args, **kwargs)
File "/contrail-test/scripts/svc_mirror/test_mirror.py", line 24, in test_svc_v2_mirroring
return self.verify_svc_mirroring()
File "/contrail-test/common/servicechain/mirror/verify.py", line 14, in verify_svc_mirroring
ret_dict = self.config_svc_mirroring(*args, **kwargs)
File "/contrail-test/common/servicechain/mirror/config.py", line 42, in config_svc_mirroring
create_svms=create_svms, **kwargs)
File "/contrail-test/common/servicechain/verify.py", line 320, in verify_svc_chain
ret_dict = svc_chain_info or self.config_svc_chain(*args, **kwargs)
File "/contrail-test/common/servicechain/config.py", line 533, in config_svc_chain
max_inst=max_inst)
File "/contrail-test/common/servicechain/config.py", line 335, in create_service_vms
zone=random.choice(valid_zones))
File "/contrail-test/common/servicechain/config.py", line 161, in config_vm_only
flavor=flavor, zone=zone, node_name=node_name,**kwargs)
File "/contrail-test/common/servicechain/config.py", line 203, in config_vm
flavor=flavor, vn_objs=vns, count=count, zone=zone,**kwargs))
File "/usr/local/lib/python3.6/site-packages/testtools/testcase.py", line 756, in useFixture
reraise(*exc_info)
File "/usr/local/lib/python3.6/site-packages/testtools/_compat3x.py", line 16, in reraise
raise exc_obj.with_traceback(exc_tb)
File "/usr/local/lib/python3.6/site-packages/testtools/testcase.py", line 731, in useFixture
fixture.setUp()
File "/contrail-test/fixtures/vm_test.py", line 188, in setUp
self.create()
File "/contrail-test/fixtures/vm_test.py", line 240, in create
fixed_ips=self.fixed_ips)
File "/contrail-test/fixtures/openstack.py", line 118, in create_vm
return self.nova_h.create_vm(vm_name=vm_name, image_name=image_name, vn_ids=vn_ids, **kwargs)
File "/contrail-test/fixtures/nova_test.py", line 577, in create_vm
image = self.get_image(image_name=image_name)
File "/contrail-test/fixtures/nova_test.py", line 198, in get_image
self._install_image(image_name=image_name)
File "/contrail-test/fixtures/nova_test.py", line 338, in _install_image
return self.copy_and_glance(build_path, image_name, params)
File "/contrail-test/fixtures/nova_test.py", line 407, in copy_and_glance
image_id = self.glance_h.create_image(generic_image_name, image_path_real, **params)
File "/contrail-test/fixtures/glance_test.py", line 50, in create_image
self.upload_image(obj['id'], filename)
File "/contrail-test/fixtures/glance_test.py", line 54, in upload_image
self.obj.images.upload(uuid, open(filename, 'rb'))
FileNotFoundError: [Errno 2] No such file or directory: '/contrail-test/images/ubuntu.vmdk'
2025-07-21 13:45:19,321 - DEBUG - No XMPP flaps were noticed during the test
2025-07-21 13:45:19,321 - INFO -