2025-07-31 03:12:30,193 - INFO - Domain Default found not creating
2025-07-31 03:12:30,450 - INFO - Project ctest-TestIntfMirror6-61712589 not found, creating it
2025-07-31 03:12:31,214 - INFO - Created Project:ctest-TestIntfMirror6-61712589, ID : 9a9059a2-99b5-46c6-9dd0-be285702c1ef
2025-07-31 03:12:32,773 - INFO - ================================================================================
2025-07-31 03:12:32,773 - INFO - STARTING TEST : test_intf_mirror6_src_cn1vn1_dst_cn2vn2_analyzer_cn3vn3
2025-07-31 03:12:32,773 - INFO - TEST DESCRIPTION : Validate the interface mirroring IPv6
src vm, dst vm and analyzer vm on different CNs, all in different VNs
Maintainer : ankitja@juniper.net
2025-07-31 03:12:34,184 - DEBUG - Nothing to compare xmpp stats {'10.0.0.27': {'10.20.0.193': '0', '10.20.0.18': '0'}, '10.0.0.57': {'10.20.0.18': '0', '10.20.0.193': '0'}} with
2025-07-31 03:12:34,184 - INFO - Initial checks done. Running the testcase now
2025-07-31 03:12:34,185 - INFO -
2025-07-31 03:12:34,186 - INFO - src compute an-jenkins-deploy-platform-ansible-os-3732-1 -> dst compute an-jenkins-deploy-platform-ansible-os-3732-2 => analyzer compute an-jenkins-deploy-platform-ansible-os-3732-2
2025-07-31 03:12:35,055 - DEBUG - Response for create_network : {'network': {'id': '68070e9d-c52b-4584-b600-cfac2bab9620', 'name': 'ctest-vn1-27687642', 'tenant_id': '9a9059a299b546c69dd0be285702c1ef', 'project_id': '9a9059a299b546c69dd0be285702c1ef', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestIntfMirror6-61712589', 'ctest-vn1-27687642'], 'port_security_enabled': True, 'description': ''}}
2025-07-31 03:12:35,405 - DEBUG - Response for create_subnet : {'subnet': {'id': '8664fcfa-fc46-4aa6-9f02-a93b1630cb6f', 'name': '', 'tenant_id': '9a9059a299b546c69dd0be285702c1ef', 'network_id': '68070e9d-c52b-4584-b600-cfac2bab9620', 'ip_version': 6, 'cidr': '322e:5645:4e5a:80e4:873c:b026::/96', 'allocation_pools': [{'start': '322e:5645:4e5a:80e4:873c:b026:0:2', 'end': '322e:5645:4e5a:80e4:873c:b026:ffff:fffe'}], 'gateway_ip': '322e:5645:4e5a:80e4:873c:b026:0:1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '322e:5645:4e5a:80e4:873c:b026:0:2', 'tags': [], 'project_id': '9a9059a299b546c69dd0be285702c1ef'}}
2025-07-31 03:12:35,680 - DEBUG - Response for create_subnet : {'subnet': {'id': 'c4d853f7-fdca-4eea-bfe1-46b9bc866c26', 'name': '', 'tenant_id': '9a9059a299b546c69dd0be285702c1ef', 'network_id': '68070e9d-c52b-4584-b600-cfac2bab9620', 'ip_version': 4, 'cidr': '155.244.13.0/26', 'allocation_pools': [{'start': '155.244.13.2', 'end': '155.244.13.62'}], 'gateway_ip': '155.244.13.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '155.244.13.2', 'tags': [], 'project_id': '9a9059a299b546c69dd0be285702c1ef'}}
2025-07-31 03:12:35,711 - INFO - Created VN ctest-vn1-27687642
2025-07-31 03:12:35,727 - DEBUG - VN ctest-vn1-27687642 UUID is 68070e9d-c52b-4584-b600-cfac2bab9620
2025-07-31 03:12:35,857 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2025-07-31 03:12:36,155 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2025-07-31 03:12:36,207 - DEBUG - Requesting: http://10.0.0.41:8082/domain/34dad5b7-e30d-42c7-8ff4-7b0d7fa576d7
2025-07-31 03:12:36,236 - DEBUG - Requesting: http://10.0.0.41:8082/project/9a9059a2-99b5-46c6-9dd0-be285702c1ef
2025-07-31 03:12:36,374 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/68070e9d-c52b-4584-b600-cfac2bab9620
2025-07-31 03:12:36,388 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/68070e9d-c52b-4584-b600-cfac2bab9620
2025-07-31 03:12:36,405 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/5601e9a7-5824-463a-8848-6e1a05be0aa0
2025-07-31 03:12:36,418 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/5601e9a7-5824-463a-8848-6e1a05be0aa0
2025-07-31 03:12:36,429 - DEBUG - Requesting: http://10.0.0.41:8082/route-target/bb737a41-9961-4fe8-8acd-9d1495b63a11
2025-07-31 03:12:36,439 - DEBUG - Route Targets: ['target:64512:8000005']
2025-07-31 03:12:36,439 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/68070e9d-c52b-4584-b600-cfac2bab9620
2025-07-31 03:12:36,452 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/5601e9a7-5824-463a-8848-6e1a05be0aa0
2025-07-31 03:12:36,472 - INFO - Verified VN network id 11 for VN 68070e9d-c52b-4584-b600-cfac2bab9620
2025-07-31 03:12:36,472 - INFO - Verifications in API Server for VN ctest-vn1-27687642 passed
2025-07-31 03:12:36,472 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/68070e9d-c52b-4584-b600-cfac2bab9620
2025-07-31 03:12:36,490 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/5601e9a7-5824-463a-8848-6e1a05be0aa0
2025-07-31 03:12:36,503 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/5601e9a7-5824-463a-8848-6e1a05be0aa0
2025-07-31 03:12:36,517 - DEBUG - Requesting: http://10.0.0.41:8082/route-target/bb737a41-9961-4fe8-8acd-9d1495b63a11
2025-07-31 03:12:36,549 - DEBUG - Control-node 10.0.0.41 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestIntfMirror6-61712589:ctest-vn1-27687642', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestIntfMirror6-61712589', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7495976175562081668', 'uuid-lslong': '13114710453276874272'}, 'enable': 'true', 'created': '2025-07-31T03:12:34', 'last-modified': '2025-07-31T03:12:35', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.957054'}
2025-07-31 03:12:36,570 - DEBUG - Route Targets: ['target:64512:8000005']
2025-07-31 03:12:36,583 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestIntfMirror6-61712589:ctest-vn1-27687642', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestIntfMirror6-61712589', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7495976175562081668', 'uuid-lslong': '13114710453276874272'}, 'enable': 'true', 'created': '2025-07-31T03:12:34', 'last-modified': '2025-07-31T03:12:35', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.996138'}
2025-07-31 03:12:36,596 - DEBUG - Route Targets: ['target:64512:8000005']
2025-07-31 03:12:36,610 - DEBUG - Control-node 10.0.0.61 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestIntfMirror6-61712589:ctest-vn1-27687642', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestIntfMirror6-61712589', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7495976175562081668', 'uuid-lslong': '13114710453276874272'}, 'enable': 'true', 'created': '2025-07-31T03:12:34', 'last-modified': '2025-07-31T03:12:35', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.022888'}
2025-07-31 03:12:36,627 - DEBUG - Route Targets: ['target:64512:8000005']
2025-07-31 03:12:36,628 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn1-27687642 passed
2025-07-31 03:12:36,628 - DEBUG - ====Verifying policy data for ctest-vn1-27687642 in API_Server ======
2025-07-31 03:12:36,629 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2025-07-31 03:12:36,649 - DEBUG - Requesting: http://10.0.0.41:8082/domain/34dad5b7-e30d-42c7-8ff4-7b0d7fa576d7
2025-07-31 03:12:36,695 - DEBUG - Requesting: http://10.0.0.41:8082/project/9a9059a2-99b5-46c6-9dd0-be285702c1ef
2025-07-31 03:12:36,845 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/68070e9d-c52b-4584-b600-cfac2bab9620
2025-07-31 03:12:36,859 - DEBUG - =>VN ctest-vn1-27687642 has no policy to be verified
2025-07-31 03:12:36,859 - DEBUG - Verifying the vn in opserver
2025-07-31 03:12:36,859 - DEBUG - Verifying the default-domain:ctest-TestIntfMirror6-61712589:ctest-vn1-27687642 virtual network link through opserver 10.0.0.41
2025-07-31 03:12:36,859 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-networks
2025-07-31 03:12:37,168 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-networks
2025-07-31 03:12:37,241 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestIntfMirror6-61712589:ctest-vn1-27687642', 'href': 'http://10.0.0.41:8081/analytics/uves/virtual-network/default-domain:ctest-TestIntfMirror6-61712589:ctest-vn1-27687642?flat'}
2025-07-31 03:12:37,241 - DEBUG - Verifying the default-domain:ctest-TestIntfMirror6-61712589:ctest-vn1-27687642 virtual network link through opserver 10.0.0.38
2025-07-31 03:12:37,241 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2025-07-31 03:12:37,645 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2025-07-31 03:12:37,734 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestIntfMirror6-61712589:ctest-vn1-27687642', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestIntfMirror6-61712589:ctest-vn1-27687642?flat'}
2025-07-31 03:12:37,734 - DEBUG - Verifying the default-domain:ctest-TestIntfMirror6-61712589:ctest-vn1-27687642 virtual network link through opserver 10.0.0.61
2025-07-31 03:12:37,735 - DEBUG - Requesting: http://10.0.0.61:8081/analytics/uves/virtual-networks
2025-07-31 03:12:38,047 - DEBUG - Requesting: http://10.0.0.61:8081/analytics/uves/virtual-networks
2025-07-31 03:12:38,159 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestIntfMirror6-61712589:ctest-vn1-27687642', 'href': 'http://10.0.0.61:8081/analytics/uves/virtual-network/default-domain:ctest-TestIntfMirror6-61712589:ctest-vn1-27687642?flat'}
2025-07-31 03:12:38,159 - INFO - Validated that VN default-domain:ctest-TestIntfMirror6-61712589:ctest-vn1-27687642 is found in opserver
2025-07-31 03:12:38,210 - DEBUG - Do not have enough data to verify VN in agent
2025-07-31 03:12:38,235 - DEBUG - VRF ids for VN ctest-vn1-27687642: {}
2025-07-31 03:12:38,572 - DEBUG - Response for create_network : {'network': {'id': 'd97a5bdc-652e-45d5-a6c5-7d6724763f63', 'name': 'ctest-vn2-10192094', 'tenant_id': '9a9059a299b546c69dd0be285702c1ef', 'project_id': '9a9059a299b546c69dd0be285702c1ef', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestIntfMirror6-61712589', 'ctest-vn2-10192094'], 'port_security_enabled': True, 'description': ''}}
2025-07-31 03:12:38,821 - DEBUG - Response for create_subnet : {'subnet': {'id': 'd66431ad-1b4c-404a-bd80-78c811e751fd', 'name': '', 'tenant_id': '9a9059a299b546c69dd0be285702c1ef', 'network_id': 'd97a5bdc-652e-45d5-a6c5-7d6724763f63', 'ip_version': 6, 'cidr': '27c9:9920:22e4:1d22:f1b3:f308::/96', 'allocation_pools': [{'start': '27c9:9920:22e4:1d22:f1b3:f308:0:2', 'end': '27c9:9920:22e4:1d22:f1b3:f308:ffff:fffe'}], 'gateway_ip': '27c9:9920:22e4:1d22:f1b3:f308:0:1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '27c9:9920:22e4:1d22:f1b3:f308:0:2', 'tags': [], 'project_id': '9a9059a299b546c69dd0be285702c1ef'}}
2025-07-31 03:12:39,056 - DEBUG - Response for create_subnet : {'subnet': {'id': 'd7e90611-c0a9-4f4e-98e5-88f5ad4ab293', 'name': '', 'tenant_id': '9a9059a299b546c69dd0be285702c1ef', 'network_id': 'd97a5bdc-652e-45d5-a6c5-7d6724763f63', 'ip_version': 4, 'cidr': '156.113.216.128/26', 'allocation_pools': [{'start': '156.113.216.130', 'end': '156.113.216.190'}], 'gateway_ip': '156.113.216.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '156.113.216.130', 'tags': [], 'project_id': '9a9059a299b546c69dd0be285702c1ef'}}
2025-07-31 03:12:39,084 - INFO - Created VN ctest-vn2-10192094
2025-07-31 03:12:39,103 - DEBUG - VN ctest-vn2-10192094 UUID is d97a5bdc-652e-45d5-a6c5-7d6724763f63
2025-07-31 03:12:39,243 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2025-07-31 03:12:39,251 - DEBUG - Requesting: http://10.0.0.41:8082/domain/34dad5b7-e30d-42c7-8ff4-7b0d7fa576d7
2025-07-31 03:12:39,269 - DEBUG - Requesting: http://10.0.0.41:8082/project/9a9059a2-99b5-46c6-9dd0-be285702c1ef
2025-07-31 03:12:39,396 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/d97a5bdc-652e-45d5-a6c5-7d6724763f63
2025-07-31 03:12:39,419 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/d97a5bdc-652e-45d5-a6c5-7d6724763f63
2025-07-31 03:12:39,439 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/3451e105-9b1e-4a85-b141-45f4885fbd39
2025-07-31 03:12:39,453 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/3451e105-9b1e-4a85-b141-45f4885fbd39
2025-07-31 03:12:39,464 - DEBUG - Requesting: http://10.0.0.41:8082/route-target/3e5c3333-a02d-439d-8be3-d94281e75e7a
2025-07-31 03:12:39,480 - DEBUG - Route Targets: ['target:64512:8000006']
2025-07-31 03:12:39,480 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/d97a5bdc-652e-45d5-a6c5-7d6724763f63
2025-07-31 03:12:39,495 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/3451e105-9b1e-4a85-b141-45f4885fbd39
2025-07-31 03:12:39,525 - INFO - Verified VN network id 12 for VN d97a5bdc-652e-45d5-a6c5-7d6724763f63
2025-07-31 03:12:39,526 - INFO - Verifications in API Server for VN ctest-vn2-10192094 passed
2025-07-31 03:12:39,526 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/d97a5bdc-652e-45d5-a6c5-7d6724763f63
2025-07-31 03:12:39,548 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/3451e105-9b1e-4a85-b141-45f4885fbd39
2025-07-31 03:12:39,559 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/3451e105-9b1e-4a85-b141-45f4885fbd39
2025-07-31 03:12:39,571 - DEBUG - Requesting: http://10.0.0.41:8082/route-target/3e5c3333-a02d-439d-8be3-d94281e75e7a
2025-07-31 03:12:39,590 - DEBUG - Control-node 10.0.0.41 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestIntfMirror6-61712589:ctest-vn2-10192094', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestIntfMirror6-61712589', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '15670938855537526229', 'uuid-lslong': '12017149062654869347'}, 'enable': 'true', 'created': '2025-07-31T03:12:38', 'last-modified': '2025-07-31T03:12:38', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.592489'}
2025-07-31 03:12:39,601 - DEBUG - Route Targets: ['target:64512:8000006']
2025-07-31 03:12:39,609 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestIntfMirror6-61712589:ctest-vn2-10192094', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestIntfMirror6-61712589', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '15670938855537526229', 'uuid-lslong': '12017149062654869347'}, 'enable': 'true', 'created': '2025-07-31T03:12:38', 'last-modified': '2025-07-31T03:12:38', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.612177'}
2025-07-31 03:12:39,618 - DEBUG - Route Targets: ['target:64512:8000006']
2025-07-31 03:12:39,626 - DEBUG - Control-node 10.0.0.61 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestIntfMirror6-61712589:ctest-vn2-10192094', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestIntfMirror6-61712589', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '15670938855537526229', 'uuid-lslong': '12017149062654869347'}, 'enable': 'true', 'created': '2025-07-31T03:12:38', 'last-modified': '2025-07-31T03:12:38', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.642354'}
2025-07-31 03:12:39,635 - DEBUG - Route Targets: ['target:64512:8000006']
2025-07-31 03:12:39,635 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn2-10192094 passed
2025-07-31 03:12:39,636 - DEBUG - ====Verifying policy data for ctest-vn2-10192094 in API_Server ======
2025-07-31 03:12:39,636 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2025-07-31 03:12:39,645 - DEBUG - Requesting: http://10.0.0.41:8082/domain/34dad5b7-e30d-42c7-8ff4-7b0d7fa576d7
2025-07-31 03:12:39,669 - DEBUG - Requesting: http://10.0.0.41:8082/project/9a9059a2-99b5-46c6-9dd0-be285702c1ef
2025-07-31 03:12:39,816 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/d97a5bdc-652e-45d5-a6c5-7d6724763f63
2025-07-31 03:12:39,835 - DEBUG - =>VN ctest-vn2-10192094 has no policy to be verified
2025-07-31 03:12:39,835 - DEBUG - Verifying the vn in opserver
2025-07-31 03:12:39,835 - DEBUG - Verifying the default-domain:ctest-TestIntfMirror6-61712589:ctest-vn2-10192094 virtual network link through opserver 10.0.0.41
2025-07-31 03:12:39,835 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-networks
2025-07-31 03:12:39,941 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestIntfMirror6-61712589:ctest-vn2-10192094', 'href': 'http://10.0.0.41:8081/analytics/uves/virtual-network/default-domain:ctest-TestIntfMirror6-61712589:ctest-vn2-10192094?flat'}
2025-07-31 03:12:39,941 - DEBUG - Verifying the default-domain:ctest-TestIntfMirror6-61712589:ctest-vn2-10192094 virtual network link through opserver 10.0.0.38
2025-07-31 03:12:39,941 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2025-07-31 03:12:40,077 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestIntfMirror6-61712589:ctest-vn2-10192094', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestIntfMirror6-61712589:ctest-vn2-10192094?flat'}
2025-07-31 03:12:40,078 - DEBUG - Verifying the default-domain:ctest-TestIntfMirror6-61712589:ctest-vn2-10192094 virtual network link through opserver 10.0.0.61
2025-07-31 03:12:40,078 - DEBUG - Requesting: http://10.0.0.61:8081/analytics/uves/virtual-networks
2025-07-31 03:12:40,182 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestIntfMirror6-61712589:ctest-vn2-10192094', 'href': 'http://10.0.0.61:8081/analytics/uves/virtual-network/default-domain:ctest-TestIntfMirror6-61712589:ctest-vn2-10192094?flat'}
2025-07-31 03:12:40,182 - INFO - Validated that VN default-domain:ctest-TestIntfMirror6-61712589:ctest-vn2-10192094 is found in opserver
2025-07-31 03:12:40,237 - DEBUG - Do not have enough data to verify VN in agent
2025-07-31 03:12:40,255 - DEBUG - VRF ids for VN ctest-vn2-10192094: {}
2025-07-31 03:12:40,620 - DEBUG - Response for create_network : {'network': {'id': 'f814111c-9659-41d0-ad11-f09a452a60b1', 'name': 'ctest-vn3-59008052', 'tenant_id': '9a9059a299b546c69dd0be285702c1ef', 'project_id': '9a9059a299b546c69dd0be285702c1ef', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestIntfMirror6-61712589', 'ctest-vn3-59008052'], 'port_security_enabled': True, 'description': ''}}
2025-07-31 03:12:40,888 - DEBUG - Response for create_subnet : {'subnet': {'id': '19b0c632-82c4-4cd5-8734-ffa18c95e4de', 'name': '', 'tenant_id': '9a9059a299b546c69dd0be285702c1ef', 'network_id': 'f814111c-9659-41d0-ad11-f09a452a60b1', 'ip_version': 6, 'cidr': '24f2:28eb:e531:13c2:d6c2:57e0::/96', 'allocation_pools': [{'start': '24f2:28eb:e531:13c2:d6c2:57e0:0:2', 'end': '24f2:28eb:e531:13c2:d6c2:57e0:ffff:fffe'}], 'gateway_ip': '24f2:28eb:e531:13c2:d6c2:57e0:0:1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '24f2:28eb:e531:13c2:d6c2:57e0:0:2', 'tags': [], 'project_id': '9a9059a299b546c69dd0be285702c1ef'}}
2025-07-31 03:12:41,163 - DEBUG - Response for create_subnet : {'subnet': {'id': '73bc7b92-30be-4bf3-acc1-3d73c37d3e46', 'name': '', 'tenant_id': '9a9059a299b546c69dd0be285702c1ef', 'network_id': 'f814111c-9659-41d0-ad11-f09a452a60b1', 'ip_version': 4, 'cidr': '188.167.28.0/26', 'allocation_pools': [{'start': '188.167.28.2', 'end': '188.167.28.62'}], 'gateway_ip': '188.167.28.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '188.167.28.2', 'tags': [], 'project_id': '9a9059a299b546c69dd0be285702c1ef'}}
2025-07-31 03:12:41,189 - INFO - Created VN ctest-vn3-59008052
2025-07-31 03:12:41,203 - DEBUG - VN ctest-vn3-59008052 UUID is f814111c-9659-41d0-ad11-f09a452a60b1
2025-07-31 03:12:41,304 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2025-07-31 03:12:41,314 - DEBUG - Requesting: http://10.0.0.41:8082/domain/34dad5b7-e30d-42c7-8ff4-7b0d7fa576d7
2025-07-31 03:12:41,330 - DEBUG - Requesting: http://10.0.0.41:8082/project/9a9059a2-99b5-46c6-9dd0-be285702c1ef
2025-07-31 03:12:41,458 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/f814111c-9659-41d0-ad11-f09a452a60b1
2025-07-31 03:12:41,481 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/f814111c-9659-41d0-ad11-f09a452a60b1
2025-07-31 03:12:41,508 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/967474c7-9416-47e9-8f1a-552632994bf9
2025-07-31 03:12:41,526 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/967474c7-9416-47e9-8f1a-552632994bf9
2025-07-31 03:12:41,549 - DEBUG - Requesting: http://10.0.0.41:8082/route-target/786c88cd-37f1-49a7-b919-40a817cf0753
2025-07-31 03:12:41,567 - DEBUG - Route Targets: ['target:64512:8000007']
2025-07-31 03:12:41,568 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/f814111c-9659-41d0-ad11-f09a452a60b1
2025-07-31 03:12:41,594 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/967474c7-9416-47e9-8f1a-552632994bf9
2025-07-31 03:12:41,625 - INFO - Verified VN network id 13 for VN f814111c-9659-41d0-ad11-f09a452a60b1
2025-07-31 03:12:41,625 - INFO - Verifications in API Server for VN ctest-vn3-59008052 passed
2025-07-31 03:12:41,626 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/f814111c-9659-41d0-ad11-f09a452a60b1
2025-07-31 03:12:41,663 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/967474c7-9416-47e9-8f1a-552632994bf9
2025-07-31 03:12:41,686 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/967474c7-9416-47e9-8f1a-552632994bf9
2025-07-31 03:12:41,709 - DEBUG - Requesting: http://10.0.0.41:8082/route-target/786c88cd-37f1-49a7-b919-40a817cf0753
2025-07-31 03:12:41,757 - DEBUG - Control-node 10.0.0.41 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestIntfMirror6-61712589:ctest-vn3-59008052', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestIntfMirror6-61712589', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17875931635419529680', 'uuid-lslong': '12471013388541649073'}, 'enable': 'true', 'created': '2025-07-31T03:12:40', 'last-modified': '2025-07-31T03:12:41', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.665317'}
2025-07-31 03:12:41,783 - DEBUG - Route Targets: ['target:64512:8000007']
2025-07-31 03:12:41,797 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestIntfMirror6-61712589:ctest-vn3-59008052', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestIntfMirror6-61712589', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17875931635419529680', 'uuid-lslong': '12471013388541649073'}, 'enable': 'true', 'created': '2025-07-31T03:12:40', 'last-modified': '2025-07-31T03:12:41', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.707425'}
2025-07-31 03:12:41,812 - DEBUG - Route Targets: ['target:64512:8000007']
2025-07-31 03:12:41,823 - DEBUG - Control-node 10.0.0.61 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestIntfMirror6-61712589:ctest-vn3-59008052', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestIntfMirror6-61712589', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17875931635419529680', 'uuid-lslong': '12471013388541649073'}, 'enable': 'true', 'created': '2025-07-31T03:12:40', 'last-modified': '2025-07-31T03:12:41', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.747896'}
2025-07-31 03:12:41,834 - DEBUG - Route Targets: ['target:64512:8000007']
2025-07-31 03:12:41,834 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn3-59008052 passed
2025-07-31 03:12:41,835 - DEBUG - ====Verifying policy data for ctest-vn3-59008052 in API_Server ======
2025-07-31 03:12:41,835 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2025-07-31 03:12:41,848 - DEBUG - Requesting: http://10.0.0.41:8082/domain/34dad5b7-e30d-42c7-8ff4-7b0d7fa576d7
2025-07-31 03:12:41,868 - DEBUG - Requesting: http://10.0.0.41:8082/project/9a9059a2-99b5-46c6-9dd0-be285702c1ef
2025-07-31 03:12:41,990 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/f814111c-9659-41d0-ad11-f09a452a60b1
2025-07-31 03:12:42,003 - DEBUG - =>VN ctest-vn3-59008052 has no policy to be verified
2025-07-31 03:12:42,003 - DEBUG - Verifying the vn in opserver
2025-07-31 03:12:42,003 - DEBUG - Verifying the default-domain:ctest-TestIntfMirror6-61712589:ctest-vn3-59008052 virtual network link through opserver 10.0.0.41
2025-07-31 03:12:42,003 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-networks
2025-07-31 03:12:42,073 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestIntfMirror6-61712589:ctest-vn3-59008052', 'href': 'http://10.0.0.41:8081/analytics/uves/virtual-network/default-domain:ctest-TestIntfMirror6-61712589:ctest-vn3-59008052?flat'}
2025-07-31 03:12:42,073 - DEBUG - Verifying the default-domain:ctest-TestIntfMirror6-61712589:ctest-vn3-59008052 virtual network link through opserver 10.0.0.38
2025-07-31 03:12:42,073 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2025-07-31 03:12:42,210 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestIntfMirror6-61712589:ctest-vn3-59008052', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestIntfMirror6-61712589:ctest-vn3-59008052?flat'}
2025-07-31 03:12:42,210 - DEBUG - Verifying the default-domain:ctest-TestIntfMirror6-61712589:ctest-vn3-59008052 virtual network link through opserver 10.0.0.61
2025-07-31 03:12:42,210 - DEBUG - Requesting: http://10.0.0.61:8081/analytics/uves/virtual-networks
2025-07-31 03:12:42,318 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestIntfMirror6-61712589:ctest-vn3-59008052', 'href': 'http://10.0.0.61:8081/analytics/uves/virtual-network/default-domain:ctest-TestIntfMirror6-61712589:ctest-vn3-59008052?flat'}
2025-07-31 03:12:42,318 - INFO - Validated that VN default-domain:ctest-TestIntfMirror6-61712589:ctest-vn3-59008052 is found in opserver
2025-07-31 03:12:42,371 - DEBUG - Do not have enough data to verify VN in agent
2025-07-31 03:12:42,397 - DEBUG - VRF ids for VN ctest-vn3-59008052: {}
2025-07-31 03:12:42,410 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = 58, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestIntfMirror6-61712589:ctest-vn1-27687642, security_group = None, network_policy = None, subnet_list = []], src_ports = [start_port = 0, end_port = 65535], application = [], dst_addresses = [subnet = None, virtual_network = default-domain:ctest-TestIntfMirror6-61712589:ctest-vn2-10192094, security_group = None, network_policy = None, subnet_list = []], dst_ports = [start_port = 0, end_port = 65535], action_list = simple_action = pass, gateway_name = None, apply_service = [], service_properties = None, mirror_to = None, assign_routing_instance = None, log = False, alert = False, qos_action = None, host_based_service = False, ethertype = None, created = None, last_modified = None, description = None, rule_sequence = None, rule_uuid = None, direction = <>, protocol = icmp6, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestIntfMirror6-61712589:ctest-vn1-27687642, security_group = None, network_policy = None, subnet_list = []], src_ports = [start_port = 0, end_port = 65535], application = [], dst_addresses = [subnet = None, virtual_network = default-domain:ctest-TestIntfMirror6-61712589:ctest-vn2-10192094, security_group = None, network_policy = None, subnet_list = []], dst_ports = [start_port = 0, end_port = 65535], action_list = simple_action = pass, gateway_name = None, apply_service = [], service_properties = None, mirror_to = None, assign_routing_instance = None, log = False, alert = False, qos_action = None, host_based_service = False, ethertype = None, created = None, last_modified = None, description = None, rule_sequence = None, rule_uuid = None, direction = <>, protocol = udp, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestIntfMirror6-61712589:ctest-vn1-27687642, security_group = None, network_policy = None, subnet_list = []], src_ports = [start_port = 0, end_port = 65535], application = [], dst_addresses = [subnet = None, virtual_network = default-domain:ctest-TestIntfMirror6-61712589:ctest-vn2-10192094, security_group = None, network_policy = None, subnet_list = []], dst_ports = [start_port = 0, end_port = 65535], action_list = simple_action = pass, gateway_name = None, apply_service = [], service_properties = None, mirror_to = None, assign_routing_instance = None, log = False, alert = False, qos_action = None, host_based_service = False, ethertype = None, created = None, last_modified = None, description = None]
2025-07-31 03:12:42,717 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = 58, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestIntfMirror6-61712589:ctest-vn1-27687642, security_group = None, network_policy = None, subnet_list = []], src_ports = [start_port = 0, end_port = 65535], application = [], dst_addresses = [subnet = None, virtual_network = default-domain:ctest-TestIntfMirror6-61712589:ctest-vn3-59008052, security_group = None, network_policy = None, subnet_list = []], dst_ports = [start_port = 0, end_port = 65535], action_list = simple_action = pass, gateway_name = None, apply_service = [], service_properties = None, mirror_to = None, assign_routing_instance = None, log = False, alert = False, qos_action = None, host_based_service = False, ethertype = None, created = None, last_modified = None, description = None, rule_sequence = None, rule_uuid = None, direction = <>, protocol = icmp6, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestIntfMirror6-61712589:ctest-vn1-27687642, security_group = None, network_policy = None, subnet_list = []], src_ports = [start_port = 0, end_port = 65535], application = [], dst_addresses = [subnet = None, virtual_network = default-domain:ctest-TestIntfMirror6-61712589:ctest-vn3-59008052, security_group = None, network_policy = None, subnet_list = []], dst_ports = [start_port = 0, end_port = 65535], action_list = simple_action = pass, gateway_name = None, apply_service = [], service_properties = None, mirror_to = None, assign_routing_instance = None, log = False, alert = False, qos_action = None, host_based_service = False, ethertype = None, created = None, last_modified = None, description = None, rule_sequence = None, rule_uuid = None, direction = <>, protocol = udp, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestIntfMirror6-61712589:ctest-vn1-27687642, security_group = None, network_policy = None, subnet_list = []], src_ports = [start_port = 0, end_port = 65535], application = [], dst_addresses = [subnet = None, virtual_network = default-domain:ctest-TestIntfMirror6-61712589:ctest-vn3-59008052, security_group = None, network_policy = None, subnet_list = []], dst_ports = [start_port = 0, end_port = 65535], action_list = simple_action = pass, gateway_name = None, apply_service = [], service_properties = None, mirror_to = None, assign_routing_instance = None, log = False, alert = False, qos_action = None, host_based_service = False, ethertype = None, created = None, last_modified = None, description = None]
2025-07-31 03:12:43,049 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = 58, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestIntfMirror6-61712589:ctest-vn2-10192094, security_group = None, network_policy = None, subnet_list = []], src_ports = [start_port = 0, end_port = 65535], application = [], dst_addresses = [subnet = None, virtual_network = default-domain:ctest-TestIntfMirror6-61712589:ctest-vn3-59008052, security_group = None, network_policy = None, subnet_list = []], dst_ports = [start_port = 0, end_port = 65535], action_list = simple_action = pass, gateway_name = None, apply_service = [], service_properties = None, mirror_to = None, assign_routing_instance = None, log = False, alert = False, qos_action = None, host_based_service = False, ethertype = None, created = None, last_modified = None, description = None, rule_sequence = None, rule_uuid = None, direction = <>, protocol = icmp6, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestIntfMirror6-61712589:ctest-vn2-10192094, security_group = None, network_policy = None, subnet_list = []], src_ports = [start_port = 0, end_port = 65535], application = [], dst_addresses = [subnet = None, virtual_network = default-domain:ctest-TestIntfMirror6-61712589:ctest-vn3-59008052, security_group = None, network_policy = None, subnet_list = []], dst_ports = [start_port = 0, end_port = 65535], action_list = simple_action = pass, gateway_name = None, apply_service = [], service_properties = None, mirror_to = None, assign_routing_instance = None, log = False, alert = False, qos_action = None, host_based_service = False, ethertype = None, created = None, last_modified = None, description = None, rule_sequence = None, rule_uuid = None, direction = <>, protocol = udp, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestIntfMirror6-61712589:ctest-vn2-10192094, security_group = None, network_policy = None, subnet_list = []], src_ports = [start_port = 0, end_port = 65535], application = [], dst_addresses = [subnet = None, virtual_network = default-domain:ctest-TestIntfMirror6-61712589:ctest-vn3-59008052, security_group = None, network_policy = None, subnet_list = []], dst_ports = [start_port = 0, end_port = 65535], action_list = simple_action = pass, gateway_name = None, apply_service = [], service_properties = None, mirror_to = None, assign_routing_instance = None, log = False, alert = False, qos_action = None, host_based_service = False, ethertype = None, created = None, last_modified = None, description = None]
2025-07-31 03:12:43,485 - INFO - Attaching policy ctest-vn1_vn2_pass-38030875 to vn ctest-vn1-27687642
2025-07-31 03:12:43,903 - INFO - Attaching policy ctest-vn1_vn2_pass-38030875 to vn ctest-vn2-10192094
2025-07-31 03:12:44,335 - INFO - Attaching policy ctest-vn1_vn3_pass-01445533 to vn ctest-vn1-27687642
2025-07-31 03:12:44,803 - INFO - Attaching policy ctest-vn1_vn3_pass-01445533 to vn ctest-vn3-59008052
2025-07-31 03:12:45,227 - INFO - Attaching policy ctest-vn2_vn3_pass-41499211 to vn ctest-vn2-10192094
2025-07-31 03:12:45,737 - INFO - Attaching policy ctest-vn2_vn3_pass-41499211 to vn ctest-vn3-59008052
2025-07-31 03:12:46,203 - DEBUG - Services list from nova: [, , , ]
2025-07-31 03:14:26,887 - DEBUG - Installing image ubuntu
2025-07-31 03:14:26,887 - DEBUG - Image info {'name': 'ubuntu.vmdk.gz', 'webserver': '', 'location': '/images/converts/', 'username': 'ubuntu', 'password': 'ubuntu', 'type': 'os', 'flavor': 'contrail_flavor_tiny', 'params': '--container-format bare --disk-format vmdk --property vmware_disktype="sparse" --property vmware_adaptertype="ide" --property hw_scsi_model=virtio-scsi --property hw_disk_bus_model=virtio-scsi --property hw_disk_bus=virtio', 'name_docker': 'phusion-baseimage-enablesshd', 'vctmpl': 'ubuntu.vmtx', 'vcname': 'ubuntu-disk1.vmdk'}
2025-07-31 03:14:26,888 - DEBUG - Image build path file:///contrail-test/images/ubuntu.vmdk.gz
2025-07-31 03:14:26,888 - DEBUG - Download image from local file file:///contrail-test/images/ubuntu.vmdk.gz
2025-07-31 03:14:26,888 - DEBUG - Unzip image
2025-07-31 03:14:26,888 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/ubuntu.vmdk.gz
2025-07-31 03:14:26,900 - DEBUG - Try to create image in user context
2025-07-31 03:14:26,975 - INFO - Dettaching policy ctest-vn2_vn3_pass-41499211 from vn ctest-vn3-59008052
2025-07-31 03:14:27,227 - INFO - Dettaching policy ctest-vn2_vn3_pass-41499211 from vn ctest-vn2-10192094
2025-07-31 03:14:27,489 - INFO - Dettaching policy ctest-vn1_vn3_pass-01445533 from vn ctest-vn3-59008052
2025-07-31 03:14:27,795 - INFO - Dettaching policy ctest-vn1_vn3_pass-01445533 from vn ctest-vn1-27687642
2025-07-31 03:14:28,109 - INFO - Dettaching policy ctest-vn1_vn2_pass-38030875 from vn ctest-vn2-10192094
2025-07-31 03:14:28,334 - INFO - Dettaching policy ctest-vn1_vn2_pass-38030875 from vn ctest-vn1-27687642
2025-07-31 03:14:28,643 - INFO - Deleted policy ctest-vn2_vn3_pass-41499211
2025-07-31 03:14:28,699 - INFO - Deleted policy ctest-vn1_vn3_pass-01445533
2025-07-31 03:14:28,759 - INFO - Deleted policy ctest-vn1_vn2_pass-38030875
2025-07-31 03:14:28,759 - INFO - Deleting VN ctest-vn3-59008052
2025-07-31 03:14:28,930 - DEBUG - Response for deleting network ()
2025-07-31 03:14:28,931 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/967474c7-9416-47e9-8f1a-552632994bf9
2025-07-31 03:14:28,942 - DEBUG - Response Code: 404
2025-07-31 03:14:28,943 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2025-07-31 03:14:28,955 - DEBUG - Requesting: http://10.0.0.41:8082/domain/34dad5b7-e30d-42c7-8ff4-7b0d7fa576d7
2025-07-31 03:14:28,969 - DEBUG - Requesting: http://10.0.0.41:8082/project/9a9059a2-99b5-46c6-9dd0-be285702c1ef
2025-07-31 03:14:29,067 - INFO - Validated that VN ctest-vn3-59008052 is not found in API Server
2025-07-31 03:14:29,081 - DEBUG - VN ctest-vn3-59008052 is not present in Agent 10.0.0.27
2025-07-31 03:14:29,094 - DEBUG - VN ctest-vn3-59008052 is not present in Agent 10.0.0.57
2025-07-31 03:14:29,094 - INFO - Validated that VN ctest-vn3-59008052 is not in any agent
2025-07-31 03:14:29,130 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn3-59008052 info
2025-07-31 03:14:29,130 - INFO - Deleting VN ctest-vn2-10192094
2025-07-31 03:14:29,325 - DEBUG - Response for deleting network ()
2025-07-31 03:14:29,325 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/3451e105-9b1e-4a85-b141-45f4885fbd39
2025-07-31 03:14:29,335 - DEBUG - Response Code: 404
2025-07-31 03:14:29,335 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2025-07-31 03:14:29,341 - DEBUG - Requesting: http://10.0.0.41:8082/domain/34dad5b7-e30d-42c7-8ff4-7b0d7fa576d7
2025-07-31 03:14:29,396 - DEBUG - Requesting: http://10.0.0.41:8082/project/9a9059a2-99b5-46c6-9dd0-be285702c1ef
2025-07-31 03:14:29,519 - INFO - Validated that VN ctest-vn2-10192094 is not found in API Server
2025-07-31 03:14:29,533 - DEBUG - VN ctest-vn2-10192094 is not present in Agent 10.0.0.27
2025-07-31 03:14:29,546 - DEBUG - VN ctest-vn2-10192094 is not present in Agent 10.0.0.57
2025-07-31 03:14:29,546 - INFO - Validated that VN ctest-vn2-10192094 is not in any agent
2025-07-31 03:14:29,609 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn2-10192094 info
2025-07-31 03:14:29,609 - INFO - Deleting VN ctest-vn1-27687642
2025-07-31 03:14:29,820 - DEBUG - Response for deleting network ()
2025-07-31 03:14:29,820 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/5601e9a7-5824-463a-8848-6e1a05be0aa0
2025-07-31 03:14:29,835 - DEBUG - Response Code: 404
2025-07-31 03:14:29,835 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2025-07-31 03:14:29,844 - DEBUG - Requesting: http://10.0.0.41:8082/domain/34dad5b7-e30d-42c7-8ff4-7b0d7fa576d7
2025-07-31 03:14:29,858 - DEBUG - Requesting: http://10.0.0.41:8082/project/9a9059a2-99b5-46c6-9dd0-be285702c1ef
2025-07-31 03:14:29,974 - INFO - Validated that VN ctest-vn1-27687642 is not found in API Server
2025-07-31 03:14:29,988 - DEBUG - VN ctest-vn1-27687642 is not present in Agent 10.0.0.27
2025-07-31 03:14:30,007 - DEBUG - VN ctest-vn1-27687642 is not present in Agent 10.0.0.57
2025-07-31 03:14:30,008 - INFO - Validated that VN ctest-vn1-27687642 is not in any agent
2025-07-31 03:14:30,078 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn1-27687642 info
2025-07-31 03:14:31,371 - ERROR - Traceback (most recent call last):
File "/contrail-test/tcutils/wrappers.py", line 80, in wrapper
result = function(self, *args, **kwargs)
File "/contrail-test/scripts/intf_mirror/test_intf_mirror6.py", line 94, in test_intf_mirror6_src_cn1vn1_dst_cn2vn2_analyzer_cn3vn3
return self.verify_intf_mirroring_src_on_cn1_vn1_dst_on_cn2_vn2_analyzer_on_cn3_vn3(ipv6=True)
File "/contrail-test/common/intf_mirroring/verify.py", line 85, in verify_intf_mirroring_src_on_cn1_vn1_dst_on_cn2_vn2_analyzer_on_cn3_vn3
return self.verify_intf_mirroring(compute_nodes, [0, 1, 2], sub_intf, parent_intf, nic_mirror, ipv6=ipv6)
File "/contrail-test/common/intf_mirroring/verify.py", line 549, in verify_intf_mirroring
image_name=image_name, node_name=src_compute, port_ids=src_port_ids)
File "/contrail-test/common/base.py", line 281, in create_vm
**kwargs)
File "/contrail-test/common/base.py", line 254, in create_only_vm
vm_obj.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-31 03:14:31,392 - DEBUG - No XMPP flaps were noticed during the test
2025-07-31 03:14:31,392 - INFO -
2025-07-31 03:14:31,392 - INFO - END TEST : test_intf_mirror6_src_cn1vn1_dst_cn2vn2_analyzer_cn3vn3 : FAILED[0:01:59]
2025-07-31 03:14:31,392 - INFO - --------------------------------------------------------------------------------
2025-07-31 03:14:31,395 - INFO - ================================================================================
2025-07-31 03:14:31,395 - INFO - STARTING TEST : test_juniper_header6_without_header_ingress
2025-07-31 03:14:31,395 - INFO - TEST DESCRIPTION : Validate the presence of no juniper header IPv6 cases
1) Check pkts get mirrored from both sub intf and parent intf when enabled on both
2) Verify if the juniper header is absent
3) Verify if the inner header is correct
Maintainer : ankitja@juniper.net
2025-07-31 03:14:32,730 - DEBUG - Nothing to compare xmpp stats {'10.0.0.27': {'10.20.0.193': '0', '10.20.0.18': '0'}, '10.0.0.57': {'10.20.0.18': '0', '10.20.0.193': '0'}} with
2025-07-31 03:14:32,730 - INFO - Initial checks done. Running the testcase now
2025-07-31 03:14:32,730 - INFO -
2025-07-31 03:14:32,730 - INFO - src compute an-jenkins-deploy-platform-ansible-os-3732-1 -> dst compute an-jenkins-deploy-platform-ansible-os-3732-2 => analyzer compute an-jenkins-deploy-platform-ansible-os-3732-2
2025-07-31 03:14:32,974 - DEBUG - Response for create_network : {'network': {'id': 'efe1f6c8-ddb7-4e3b-b26e-ec786f9f6dd4', 'name': 'ctest-vn1-13085731', 'tenant_id': '9a9059a299b546c69dd0be285702c1ef', 'project_id': '9a9059a299b546c69dd0be285702c1ef', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestIntfMirror6-61712589', 'ctest-vn1-13085731'], 'port_security_enabled': True, 'description': ''}}
2025-07-31 03:14:33,188 - DEBUG - Response for create_subnet : {'subnet': {'id': 'a1cfff5f-f50a-4f25-a7f0-d0a315e40e88', 'name': '', 'tenant_id': '9a9059a299b546c69dd0be285702c1ef', 'network_id': 'efe1f6c8-ddb7-4e3b-b26e-ec786f9f6dd4', 'ip_version': 6, 'cidr': '29b5:18d1:beb3:1dbe:4cae:c6c7::/96', 'allocation_pools': [{'start': '29b5:18d1:beb3:1dbe:4cae:c6c7:0:2', 'end': '29b5:18d1:beb3:1dbe:4cae:c6c7:ffff:fffe'}], 'gateway_ip': '29b5:18d1:beb3:1dbe:4cae:c6c7:0:1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '29b5:18d1:beb3:1dbe:4cae:c6c7:0:2', 'tags': [], 'project_id': '9a9059a299b546c69dd0be285702c1ef'}}
2025-07-31 03:14:33,387 - DEBUG - Response for create_subnet : {'subnet': {'id': 'fc931ef0-c4af-476a-8a75-d1af3697b232', 'name': '', 'tenant_id': '9a9059a299b546c69dd0be285702c1ef', 'network_id': 'efe1f6c8-ddb7-4e3b-b26e-ec786f9f6dd4', 'ip_version': 4, 'cidr': '200.159.14.64/26', 'allocation_pools': [{'start': '200.159.14.66', 'end': '200.159.14.126'}], 'gateway_ip': '200.159.14.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '200.159.14.66', 'tags': [], 'project_id': '9a9059a299b546c69dd0be285702c1ef'}}
2025-07-31 03:14:33,413 - INFO - Created VN ctest-vn1-13085731
2025-07-31 03:14:33,427 - DEBUG - VN ctest-vn1-13085731 UUID is efe1f6c8-ddb7-4e3b-b26e-ec786f9f6dd4
2025-07-31 03:14:33,524 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2025-07-31 03:14:33,530 - DEBUG - Requesting: http://10.0.0.41:8082/domain/34dad5b7-e30d-42c7-8ff4-7b0d7fa576d7
2025-07-31 03:14:33,542 - DEBUG - Requesting: http://10.0.0.41:8082/project/9a9059a2-99b5-46c6-9dd0-be285702c1ef
2025-07-31 03:14:33,665 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/efe1f6c8-ddb7-4e3b-b26e-ec786f9f6dd4
2025-07-31 03:14:33,680 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/efe1f6c8-ddb7-4e3b-b26e-ec786f9f6dd4
2025-07-31 03:14:33,699 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/1a6221d7-8c30-49d2-a2dc-ae7f5700dbd6
2025-07-31 03:14:33,712 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/1a6221d7-8c30-49d2-a2dc-ae7f5700dbd6
2025-07-31 03:14:33,723 - DEBUG - Requesting: http://10.0.0.41:8082/route-target/a82941b4-fdc6-47e5-8f8b-d570fed25113
2025-07-31 03:14:33,733 - DEBUG - Route Targets: ['target:64512:8000005']
2025-07-31 03:14:33,733 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/efe1f6c8-ddb7-4e3b-b26e-ec786f9f6dd4
2025-07-31 03:14:33,748 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/1a6221d7-8c30-49d2-a2dc-ae7f5700dbd6
2025-07-31 03:14:33,768 - INFO - Verified VN network id 11 for VN efe1f6c8-ddb7-4e3b-b26e-ec786f9f6dd4
2025-07-31 03:14:33,768 - INFO - Verifications in API Server for VN ctest-vn1-13085731 passed
2025-07-31 03:14:33,768 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/efe1f6c8-ddb7-4e3b-b26e-ec786f9f6dd4
2025-07-31 03:14:33,793 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/1a6221d7-8c30-49d2-a2dc-ae7f5700dbd6
2025-07-31 03:14:33,806 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/1a6221d7-8c30-49d2-a2dc-ae7f5700dbd6
2025-07-31 03:14:33,818 - DEBUG - Requesting: http://10.0.0.41:8082/route-target/a82941b4-fdc6-47e5-8f8b-d570fed25113
2025-07-31 03:14:33,841 - DEBUG - Control-node 10.0.0.41 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestIntfMirror6-61712589:ctest-vn1-13085731', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestIntfMirror6-61712589', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17285368187398344251', 'uuid-lslong': '12857473988202294740'}, 'enable': 'true', 'created': '2025-07-31T03:14:32', 'last-modified': '2025-07-31T03:14:33', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.528168'}
2025-07-31 03:14:33,850 - DEBUG - Route Targets: ['target:64512:8000005']
2025-07-31 03:14:33,857 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestIntfMirror6-61712589:ctest-vn1-13085731', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestIntfMirror6-61712589', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17285368187398344251', 'uuid-lslong': '12857473988202294740'}, 'enable': 'true', 'created': '2025-07-31T03:14:32', 'last-modified': '2025-07-31T03:14:33', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.543742'}
2025-07-31 03:14:33,863 - DEBUG - Route Targets: ['target:64512:8000005']
2025-07-31 03:14:33,870 - DEBUG - Control-node 10.0.0.61 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestIntfMirror6-61712589:ctest-vn1-13085731', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestIntfMirror6-61712589', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17285368187398344251', 'uuid-lslong': '12857473988202294740'}, 'enable': 'true', 'created': '2025-07-31T03:14:32', 'last-modified': '2025-07-31T03:14:33', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.549519'}
2025-07-31 03:14:33,876 - DEBUG - Route Targets: ['target:64512:8000005']
2025-07-31 03:14:33,876 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn1-13085731 passed
2025-07-31 03:14:33,877 - DEBUG - ====Verifying policy data for ctest-vn1-13085731 in API_Server ======
2025-07-31 03:14:33,877 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2025-07-31 03:14:33,891 - DEBUG - Requesting: http://10.0.0.41:8082/domain/34dad5b7-e30d-42c7-8ff4-7b0d7fa576d7
2025-07-31 03:14:33,903 - DEBUG - Requesting: http://10.0.0.41:8082/project/9a9059a2-99b5-46c6-9dd0-be285702c1ef
2025-07-31 03:14:33,995 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/efe1f6c8-ddb7-4e3b-b26e-ec786f9f6dd4
2025-07-31 03:14:34,012 - DEBUG - =>VN ctest-vn1-13085731 has no policy to be verified
2025-07-31 03:14:34,013 - DEBUG - Verifying the vn in opserver
2025-07-31 03:14:34,013 - DEBUG - Verifying the default-domain:ctest-TestIntfMirror6-61712589:ctest-vn1-13085731 virtual network link through opserver 10.0.0.41
2025-07-31 03:14:34,013 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-networks
2025-07-31 03:14:34,032 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestIntfMirror6-61712589:ctest-vn1-13085731', 'href': 'http://10.0.0.41:8081/analytics/uves/virtual-network/default-domain:ctest-TestIntfMirror6-61712589:ctest-vn1-13085731?flat'}
2025-07-31 03:14:34,032 - DEBUG - Verifying the default-domain:ctest-TestIntfMirror6-61712589:ctest-vn1-13085731 virtual network link through opserver 10.0.0.38
2025-07-31 03:14:34,032 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2025-07-31 03:14:34,046 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestIntfMirror6-61712589:ctest-vn1-13085731', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestIntfMirror6-61712589:ctest-vn1-13085731?flat'}
2025-07-31 03:14:34,046 - DEBUG - Verifying the default-domain:ctest-TestIntfMirror6-61712589:ctest-vn1-13085731 virtual network link through opserver 10.0.0.61
2025-07-31 03:14:34,047 - DEBUG - Requesting: http://10.0.0.61:8081/analytics/uves/virtual-networks
2025-07-31 03:14:34,060 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestIntfMirror6-61712589:ctest-vn1-13085731', 'href': 'http://10.0.0.61:8081/analytics/uves/virtual-network/default-domain:ctest-TestIntfMirror6-61712589:ctest-vn1-13085731?flat'}
2025-07-31 03:14:34,060 - INFO - Validated that VN default-domain:ctest-TestIntfMirror6-61712589:ctest-vn1-13085731 is found in opserver
2025-07-31 03:14:34,093 - DEBUG - Do not have enough data to verify VN in agent
2025-07-31 03:14:34,110 - DEBUG - VRF ids for VN ctest-vn1-13085731: {}
2025-07-31 03:14:34,376 - DEBUG - Response for create_network : {'network': {'id': '11417f88-fcfa-4d93-bb31-04f4a6a63e67', 'name': 'ctest-vn2-94776077', 'tenant_id': '9a9059a299b546c69dd0be285702c1ef', 'project_id': '9a9059a299b546c69dd0be285702c1ef', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestIntfMirror6-61712589', 'ctest-vn2-94776077'], 'port_security_enabled': True, 'description': ''}}
2025-07-31 03:14:34,592 - DEBUG - Response for create_subnet : {'subnet': {'id': '9ef09def-a85d-4bfa-b41a-8663e99542e4', 'name': '', 'tenant_id': '9a9059a299b546c69dd0be285702c1ef', 'network_id': '11417f88-fcfa-4d93-bb31-04f4a6a63e67', 'ip_version': 6, 'cidr': '3d9c:ca50:67af:d7e6:1ba2:6db3::/96', 'allocation_pools': [{'start': '3d9c:ca50:67af:d7e6:1ba2:6db3:0:2', 'end': '3d9c:ca50:67af:d7e6:1ba2:6db3:ffff:fffe'}], 'gateway_ip': '3d9c:ca50:67af:d7e6:1ba2:6db3:0:1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '3d9c:ca50:67af:d7e6:1ba2:6db3:0:2', 'tags': [], 'project_id': '9a9059a299b546c69dd0be285702c1ef'}}
2025-07-31 03:14:34,859 - DEBUG - Response for create_subnet : {'subnet': {'id': '19a2ef56-4f56-4217-9127-62655624aed2', 'name': '', 'tenant_id': '9a9059a299b546c69dd0be285702c1ef', 'network_id': '11417f88-fcfa-4d93-bb31-04f4a6a63e67', 'ip_version': 4, 'cidr': '4.70.249.192/26', 'allocation_pools': [{'start': '4.70.249.194', 'end': '4.70.249.254'}], 'gateway_ip': '4.70.249.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '4.70.249.194', 'tags': [], 'project_id': '9a9059a299b546c69dd0be285702c1ef'}}
2025-07-31 03:14:34,886 - INFO - Created VN ctest-vn2-94776077
2025-07-31 03:14:34,904 - DEBUG - VN ctest-vn2-94776077 UUID is 11417f88-fcfa-4d93-bb31-04f4a6a63e67
2025-07-31 03:14:35,016 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2025-07-31 03:14:35,029 - DEBUG - Requesting: http://10.0.0.41:8082/domain/34dad5b7-e30d-42c7-8ff4-7b0d7fa576d7
2025-07-31 03:14:35,041 - DEBUG - Requesting: http://10.0.0.41:8082/project/9a9059a2-99b5-46c6-9dd0-be285702c1ef
2025-07-31 03:14:35,131 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/11417f88-fcfa-4d93-bb31-04f4a6a63e67
2025-07-31 03:14:35,150 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/11417f88-fcfa-4d93-bb31-04f4a6a63e67
2025-07-31 03:14:35,163 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/dc74862a-96ff-448c-a09a-55cf500c39a3
2025-07-31 03:14:35,171 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/dc74862a-96ff-448c-a09a-55cf500c39a3
2025-07-31 03:14:35,178 - DEBUG - Requesting: http://10.0.0.41:8082/route-target/fa6eafe0-801f-40e8-bd52-b56d1e49b944
2025-07-31 03:14:35,187 - DEBUG - Route Targets: ['target:64512:8000006']
2025-07-31 03:14:35,187 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/11417f88-fcfa-4d93-bb31-04f4a6a63e67
2025-07-31 03:14:35,199 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/dc74862a-96ff-448c-a09a-55cf500c39a3
2025-07-31 03:14:35,214 - INFO - Verified VN network id 12 for VN 11417f88-fcfa-4d93-bb31-04f4a6a63e67
2025-07-31 03:14:35,214 - INFO - Verifications in API Server for VN ctest-vn2-94776077 passed
2025-07-31 03:14:35,214 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/11417f88-fcfa-4d93-bb31-04f4a6a63e67
2025-07-31 03:14:35,227 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/dc74862a-96ff-448c-a09a-55cf500c39a3
2025-07-31 03:14:35,235 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/dc74862a-96ff-448c-a09a-55cf500c39a3
2025-07-31 03:14:35,243 - DEBUG - Requesting: http://10.0.0.41:8082/route-target/fa6eafe0-801f-40e8-bd52-b56d1e49b944
2025-07-31 03:14:35,257 - DEBUG - Control-node 10.0.0.41 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestIntfMirror6-61712589:ctest-vn2-94776077', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestIntfMirror6-61712589', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1243415198467509651', 'uuid-lslong': '13488567807765790311'}, 'enable': 'true', 'created': '2025-07-31T03:14:34', 'last-modified': '2025-07-31T03:14:34', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.491696'}
2025-07-31 03:14:35,264 - DEBUG - Route Targets: ['target:64512:8000006']
2025-07-31 03:14:35,273 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestIntfMirror6-61712589:ctest-vn2-94776077', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestIntfMirror6-61712589', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1243415198467509651', 'uuid-lslong': '13488567807765790311'}, 'enable': 'true', 'created': '2025-07-31T03:14:34', 'last-modified': '2025-07-31T03:14:34', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.502499'}
2025-07-31 03:14:35,283 - DEBUG - Route Targets: ['target:64512:8000006']
2025-07-31 03:14:35,291 - DEBUG - Control-node 10.0.0.61 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestIntfMirror6-61712589:ctest-vn2-94776077', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestIntfMirror6-61712589', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1243415198467509651', 'uuid-lslong': '13488567807765790311'}, 'enable': 'true', 'created': '2025-07-31T03:14:34', 'last-modified': '2025-07-31T03:14:34', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.502335'}
2025-07-31 03:14:35,301 - DEBUG - Route Targets: ['target:64512:8000006']
2025-07-31 03:14:35,301 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn2-94776077 passed
2025-07-31 03:14:35,301 - DEBUG - ====Verifying policy data for ctest-vn2-94776077 in API_Server ======
2025-07-31 03:14:35,301 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2025-07-31 03:14:35,311 - DEBUG - Requesting: http://10.0.0.41:8082/domain/34dad5b7-e30d-42c7-8ff4-7b0d7fa576d7
2025-07-31 03:14:35,334 - DEBUG - Requesting: http://10.0.0.41:8082/project/9a9059a2-99b5-46c6-9dd0-be285702c1ef
2025-07-31 03:14:35,484 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/11417f88-fcfa-4d93-bb31-04f4a6a63e67
2025-07-31 03:14:35,504 - DEBUG - =>VN ctest-vn2-94776077 has no policy to be verified
2025-07-31 03:14:35,504 - DEBUG - Verifying the vn in opserver
2025-07-31 03:14:35,504 - DEBUG - Verifying the default-domain:ctest-TestIntfMirror6-61712589:ctest-vn2-94776077 virtual network link through opserver 10.0.0.41
2025-07-31 03:14:35,504 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-networks
2025-07-31 03:14:35,519 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestIntfMirror6-61712589:ctest-vn2-94776077', 'href': 'http://10.0.0.41:8081/analytics/uves/virtual-network/default-domain:ctest-TestIntfMirror6-61712589:ctest-vn2-94776077?flat'}
2025-07-31 03:14:35,519 - DEBUG - Verifying the default-domain:ctest-TestIntfMirror6-61712589:ctest-vn2-94776077 virtual network link through opserver 10.0.0.38
2025-07-31 03:14:35,519 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2025-07-31 03:14:35,540 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestIntfMirror6-61712589:ctest-vn2-94776077', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestIntfMirror6-61712589:ctest-vn2-94776077?flat'}
2025-07-31 03:14:35,540 - DEBUG - Verifying the default-domain:ctest-TestIntfMirror6-61712589:ctest-vn2-94776077 virtual network link through opserver 10.0.0.61
2025-07-31 03:14:35,540 - DEBUG - Requesting: http://10.0.0.61:8081/analytics/uves/virtual-networks
2025-07-31 03:14:35,562 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestIntfMirror6-61712589:ctest-vn2-94776077', 'href': 'http://10.0.0.61:8081/analytics/uves/virtual-network/default-domain:ctest-TestIntfMirror6-61712589:ctest-vn2-94776077?flat'}
2025-07-31 03:14:35,562 - INFO - Validated that VN default-domain:ctest-TestIntfMirror6-61712589:ctest-vn2-94776077 is found in opserver
2025-07-31 03:14:35,598 - DEBUG - Do not have enough data to verify VN in agent
2025-07-31 03:14:35,612 - DEBUG - VRF ids for VN ctest-vn2-94776077: {}
2025-07-31 03:14:35,954 - DEBUG - Response for create_network : {'network': {'id': 'cb048b3e-03c6-42d8-9cc8-1c869b1615d2', 'name': 'ctest-vn3-13259881', 'tenant_id': '9a9059a299b546c69dd0be285702c1ef', 'project_id': '9a9059a299b546c69dd0be285702c1ef', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestIntfMirror6-61712589', 'ctest-vn3-13259881'], 'port_security_enabled': True, 'description': ''}}
2025-07-31 03:14:36,213 - DEBUG - Response for create_subnet : {'subnet': {'id': '4f6fa888-3f11-462b-bb04-33f6d5648a56', 'name': '', 'tenant_id': '9a9059a299b546c69dd0be285702c1ef', 'network_id': 'cb048b3e-03c6-42d8-9cc8-1c869b1615d2', 'ip_version': 6, 'cidr': '3bad:b4a8:39e2:5010:afa8:1db3::/96', 'allocation_pools': [{'start': '3bad:b4a8:39e2:5010:afa8:1db3:0:2', 'end': '3bad:b4a8:39e2:5010:afa8:1db3:ffff:fffe'}], 'gateway_ip': '3bad:b4a8:39e2:5010:afa8:1db3:0:1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '3bad:b4a8:39e2:5010:afa8:1db3:0:2', 'tags': [], 'project_id': '9a9059a299b546c69dd0be285702c1ef'}}
2025-07-31 03:14:36,528 - DEBUG - Response for create_subnet : {'subnet': {'id': '3756da0e-26bb-4f56-8f0d-d495de83321c', 'name': '', 'tenant_id': '9a9059a299b546c69dd0be285702c1ef', 'network_id': 'cb048b3e-03c6-42d8-9cc8-1c869b1615d2', 'ip_version': 4, 'cidr': '15.65.38.0/26', 'allocation_pools': [{'start': '15.65.38.2', 'end': '15.65.38.62'}], 'gateway_ip': '15.65.38.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '15.65.38.2', 'tags': [], 'project_id': '9a9059a299b546c69dd0be285702c1ef'}}
2025-07-31 03:14:36,554 - INFO - Created VN ctest-vn3-13259881
2025-07-31 03:14:36,568 - DEBUG - VN ctest-vn3-13259881 UUID is cb048b3e-03c6-42d8-9cc8-1c869b1615d2
2025-07-31 03:14:36,691 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2025-07-31 03:14:36,702 - DEBUG - Requesting: http://10.0.0.41:8082/domain/34dad5b7-e30d-42c7-8ff4-7b0d7fa576d7
2025-07-31 03:14:36,721 - DEBUG - Requesting: http://10.0.0.41:8082/project/9a9059a2-99b5-46c6-9dd0-be285702c1ef
2025-07-31 03:14:36,836 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/cb048b3e-03c6-42d8-9cc8-1c869b1615d2
2025-07-31 03:14:36,866 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/cb048b3e-03c6-42d8-9cc8-1c869b1615d2
2025-07-31 03:14:36,883 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/f3fda0ed-930a-405d-9a53-9d21cc6ea3da
2025-07-31 03:14:36,896 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/f3fda0ed-930a-405d-9a53-9d21cc6ea3da
2025-07-31 03:14:36,907 - DEBUG - Requesting: http://10.0.0.41:8082/route-target/e3040bf4-2ebf-44f9-927e-3fda27a4e9e0
2025-07-31 03:14:36,917 - DEBUG - Route Targets: ['target:64512:8000007']
2025-07-31 03:14:36,917 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/cb048b3e-03c6-42d8-9cc8-1c869b1615d2
2025-07-31 03:14:36,931 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/f3fda0ed-930a-405d-9a53-9d21cc6ea3da
2025-07-31 03:14:36,951 - INFO - Verified VN network id 13 for VN cb048b3e-03c6-42d8-9cc8-1c869b1615d2
2025-07-31 03:14:36,951 - INFO - Verifications in API Server for VN ctest-vn3-13259881 passed
2025-07-31 03:14:36,951 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/cb048b3e-03c6-42d8-9cc8-1c869b1615d2
2025-07-31 03:14:36,966 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/f3fda0ed-930a-405d-9a53-9d21cc6ea3da
2025-07-31 03:14:36,981 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/f3fda0ed-930a-405d-9a53-9d21cc6ea3da
2025-07-31 03:14:36,993 - DEBUG - Requesting: http://10.0.0.41:8082/route-target/e3040bf4-2ebf-44f9-927e-3fda27a4e9e0
2025-07-31 03:14:37,012 - DEBUG - Control-node 10.0.0.41 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestIntfMirror6-61712589:ctest-vn3-13259881', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestIntfMirror6-61712589', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '14628970588073771736', 'uuid-lslong': '11297311029712000466'}, 'enable': 'true', 'created': '2025-07-31T03:14:35', 'last-modified': '2025-07-31T03:14:36', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.571490'}
2025-07-31 03:14:37,027 - DEBUG - Route Targets: ['target:64512:8000007']
2025-07-31 03:14:37,035 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestIntfMirror6-61712589:ctest-vn3-13259881', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestIntfMirror6-61712589', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '14628970588073771736', 'uuid-lslong': '11297311029712000466'}, 'enable': 'true', 'created': '2025-07-31T03:14:35', 'last-modified': '2025-07-31T03:14:36', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.595161'}
2025-07-31 03:14:37,044 - DEBUG - Route Targets: ['target:64512:8000007']
2025-07-31 03:14:37,051 - DEBUG - Control-node 10.0.0.61 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestIntfMirror6-61712589:ctest-vn3-13259881', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestIntfMirror6-61712589', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '14628970588073771736', 'uuid-lslong': '11297311029712000466'}, 'enable': 'true', 'created': '2025-07-31T03:14:35', 'last-modified': '2025-07-31T03:14:36', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.611279'}
2025-07-31 03:14:37,060 - DEBUG - Route Targets: ['target:64512:8000007']
2025-07-31 03:14:37,060 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn3-13259881 passed
2025-07-31 03:14:37,060 - DEBUG - ====Verifying policy data for ctest-vn3-13259881 in API_Server ======
2025-07-31 03:14:37,060 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2025-07-31 03:14:37,085 - DEBUG - Requesting: http://10.0.0.41:8082/domain/34dad5b7-e30d-42c7-8ff4-7b0d7fa576d7
2025-07-31 03:14:37,145 - DEBUG - Requesting: http://10.0.0.41:8082/project/9a9059a2-99b5-46c6-9dd0-be285702c1ef
2025-07-31 03:14:37,301 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/cb048b3e-03c6-42d8-9cc8-1c869b1615d2
2025-07-31 03:14:37,323 - DEBUG - =>VN ctest-vn3-13259881 has no policy to be verified
2025-07-31 03:14:37,323 - DEBUG - Verifying the vn in opserver
2025-07-31 03:14:37,324 - DEBUG - Verifying the default-domain:ctest-TestIntfMirror6-61712589:ctest-vn3-13259881 virtual network link through opserver 10.0.0.41
2025-07-31 03:14:37,324 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-networks
2025-07-31 03:14:37,344 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestIntfMirror6-61712589:ctest-vn3-13259881', 'href': 'http://10.0.0.41:8081/analytics/uves/virtual-network/default-domain:ctest-TestIntfMirror6-61712589:ctest-vn3-13259881?flat'}
2025-07-31 03:14:37,344 - DEBUG - Verifying the default-domain:ctest-TestIntfMirror6-61712589:ctest-vn3-13259881 virtual network link through opserver 10.0.0.38
2025-07-31 03:14:37,344 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2025-07-31 03:14:37,365 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestIntfMirror6-61712589:ctest-vn3-13259881', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestIntfMirror6-61712589:ctest-vn3-13259881?flat'}
2025-07-31 03:14:37,365 - DEBUG - Verifying the default-domain:ctest-TestIntfMirror6-61712589:ctest-vn3-13259881 virtual network link through opserver 10.0.0.61
2025-07-31 03:14:37,366 - DEBUG - Requesting: http://10.0.0.61:8081/analytics/uves/virtual-networks
2025-07-31 03:14:37,384 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestIntfMirror6-61712589:ctest-vn3-13259881', 'href': 'http://10.0.0.61:8081/analytics/uves/virtual-network/default-domain:ctest-TestIntfMirror6-61712589:ctest-vn3-13259881?flat'}
2025-07-31 03:14:37,384 - INFO - Validated that VN default-domain:ctest-TestIntfMirror6-61712589:ctest-vn3-13259881 is found in opserver
2025-07-31 03:14:37,417 - DEBUG - Do not have enough data to verify VN in agent
2025-07-31 03:14:37,437 - DEBUG - VRF ids for VN ctest-vn3-13259881: {}
2025-07-31 03:14:37,446 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = 58, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestIntfMirror6-61712589:ctest-vn1-13085731, security_group = None, network_policy = None, subnet_list = []], src_ports = [start_port = 0, end_port = 65535], application = [], dst_addresses = [subnet = None, virtual_network = default-domain:ctest-TestIntfMirror6-61712589:ctest-vn2-94776077, security_group = None, network_policy = None, subnet_list = []], dst_ports = [start_port = 0, end_port = 65535], action_list = simple_action = pass, gateway_name = None, apply_service = [], service_properties = None, mirror_to = None, assign_routing_instance = None, log = False, alert = False, qos_action = None, host_based_service = False, ethertype = None, created = None, last_modified = None, description = None, rule_sequence = None, rule_uuid = None, direction = <>, protocol = icmp6, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestIntfMirror6-61712589:ctest-vn1-13085731, security_group = None, network_policy = None, subnet_list = []], src_ports = [start_port = 0, end_port = 65535], application = [], dst_addresses = [subnet = None, virtual_network = default-domain:ctest-TestIntfMirror6-61712589:ctest-vn2-94776077, security_group = None, network_policy = None, subnet_list = []], dst_ports = [start_port = 0, end_port = 65535], action_list = simple_action = pass, gateway_name = None, apply_service = [], service_properties = None, mirror_to = None, assign_routing_instance = None, log = False, alert = False, qos_action = None, host_based_service = False, ethertype = None, created = None, last_modified = None, description = None, rule_sequence = None, rule_uuid = None, direction = <>, protocol = udp, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestIntfMirror6-61712589:ctest-vn1-13085731, security_group = None, network_policy = None, subnet_list = []], src_ports = [start_port = 0, end_port = 65535], application = [], dst_addresses = [subnet = None, virtual_network = default-domain:ctest-TestIntfMirror6-61712589:ctest-vn2-94776077, security_group = None, network_policy = None, subnet_list = []], dst_ports = [start_port = 0, end_port = 65535], action_list = simple_action = pass, gateway_name = None, apply_service = [], service_properties = None, mirror_to = None, assign_routing_instance = None, log = False, alert = False, qos_action = None, host_based_service = False, ethertype = None, created = None, last_modified = None, description = None]
2025-07-31 03:14:37,753 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = 58, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestIntfMirror6-61712589:ctest-vn1-13085731, security_group = None, network_policy = None, subnet_list = []], src_ports = [start_port = 0, end_port = 65535], application = [], dst_addresses = [subnet = None, virtual_network = default-domain:ctest-TestIntfMirror6-61712589:ctest-vn3-13259881, security_group = None, network_policy = None, subnet_list = []], dst_ports = [start_port = 0, end_port = 65535], action_list = simple_action = pass, gateway_name = None, apply_service = [], service_properties = None, mirror_to = None, assign_routing_instance = None, log = False, alert = False, qos_action = None, host_based_service = False, ethertype = None, created = None, last_modified = None, description = None, rule_sequence = None, rule_uuid = None, direction = <>, protocol = icmp6, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestIntfMirror6-61712589:ctest-vn1-13085731, security_group = None, network_policy = None, subnet_list = []], src_ports = [start_port = 0, end_port = 65535], application = [], dst_addresses = [subnet = None, virtual_network = default-domain:ctest-TestIntfMirror6-61712589:ctest-vn3-13259881, security_group = None, network_policy = None, subnet_list = []], dst_ports = [start_port = 0, end_port = 65535], action_list = simple_action = pass, gateway_name = None, apply_service = [], service_properties = None, mirror_to = None, assign_routing_instance = None, log = False, alert = False, qos_action = None, host_based_service = False, ethertype = None, created = None, last_modified = None, description = None, rule_sequence = None, rule_uuid = None, direction = <>, protocol = udp, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestIntfMirror6-61712589:ctest-vn1-13085731, security_group = None, network_policy = None, subnet_list = []], src_ports = [start_port = 0, end_port = 65535], application = [], dst_addresses = [subnet = None, virtual_network = default-domain:ctest-TestIntfMirror6-61712589:ctest-vn3-13259881, security_group = None, network_policy = None, subnet_list = []], dst_ports = [start_port = 0, end_port = 65535], action_list = simple_action = pass, gateway_name = None, apply_service = [], service_properties = None, mirror_to = None, assign_routing_instance = None, log = False, alert = False, qos_action = None, host_based_service = False, ethertype = None, created = None, last_modified = None, description = None]
2025-07-31 03:14:38,089 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = 58, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestIntfMirror6-61712589:ctest-vn2-94776077, security_group = None, network_policy = None, subnet_list = []], src_ports = [start_port = 0, end_port = 65535], application = [], dst_addresses = [subnet = None, virtual_network = default-domain:ctest-TestIntfMirror6-61712589:ctest-vn3-13259881, security_group = None, network_policy = None, subnet_list = []], dst_ports = [start_port = 0, end_port = 65535], action_list = simple_action = pass, gateway_name = None, apply_service = [], service_properties = None, mirror_to = None, assign_routing_instance = None, log = False, alert = False, qos_action = None, host_based_service = False, ethertype = None, created = None, last_modified = None, description = None, rule_sequence = None, rule_uuid = None, direction = <>, protocol = icmp6, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestIntfMirror6-61712589:ctest-vn2-94776077, security_group = None, network_policy = None, subnet_list = []], src_ports = [start_port = 0, end_port = 65535], application = [], dst_addresses = [subnet = None, virtual_network = default-domain:ctest-TestIntfMirror6-61712589:ctest-vn3-13259881, security_group = None, network_policy = None, subnet_list = []], dst_ports = [start_port = 0, end_port = 65535], action_list = simple_action = pass, gateway_name = None, apply_service = [], service_properties = None, mirror_to = None, assign_routing_instance = None, log = False, alert = False, qos_action = None, host_based_service = False, ethertype = None, created = None, last_modified = None, description = None, rule_sequence = None, rule_uuid = None, direction = <>, protocol = udp, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestIntfMirror6-61712589:ctest-vn2-94776077, security_group = None, network_policy = None, subnet_list = []], src_ports = [start_port = 0, end_port = 65535], application = [], dst_addresses = [subnet = None, virtual_network = default-domain:ctest-TestIntfMirror6-61712589:ctest-vn3-13259881, security_group = None, network_policy = None, subnet_list = []], dst_ports = [start_port = 0, end_port = 65535], action_list = simple_action = pass, gateway_name = None, apply_service = [], service_properties = None, mirror_to = None, assign_routing_instance = None, log = False, alert = False, qos_action = None, host_based_service = False, ethertype = None, created = None, last_modified = None, description = None]
2025-07-31 03:14:38,502 - INFO - Attaching policy ctest-vn1_vn2_pass-32358775 to vn ctest-vn1-13085731
2025-07-31 03:14:38,930 - INFO - Attaching policy ctest-vn1_vn2_pass-32358775 to vn ctest-vn2-94776077
2025-07-31 03:14:39,386 - INFO - Attaching policy ctest-vn1_vn3_pass-26563440 to vn ctest-vn1-13085731
2025-07-31 03:14:39,830 - INFO - Attaching policy ctest-vn1_vn3_pass-26563440 to vn ctest-vn3-13259881
2025-07-31 03:14:40,253 - INFO - Attaching policy ctest-vn2_vn3_pass-68915600 to vn ctest-vn2-94776077
2025-07-31 03:14:40,758 - INFO - Attaching policy ctest-vn2_vn3_pass-68915600 to vn ctest-vn3-13259881
2025-07-31 03:16:22,013 - DEBUG - Installing image ubuntu
2025-07-31 03:16:22,013 - DEBUG - Image info {'name': 'ubuntu.vmdk.gz', 'webserver': '', 'location': '/images/converts/', 'username': 'ubuntu', 'password': 'ubuntu', 'type': 'os', 'flavor': 'contrail_flavor_tiny', 'params': '--container-format bare --disk-format vmdk --property vmware_disktype="sparse" --property vmware_adaptertype="ide" --property hw_scsi_model=virtio-scsi --property hw_disk_bus_model=virtio-scsi --property hw_disk_bus=virtio', 'name_docker': 'phusion-baseimage-enablesshd', 'vctmpl': 'ubuntu.vmtx', 'vcname': 'ubuntu-disk1.vmdk'}
2025-07-31 03:16:22,014 - DEBUG - Image build path file:///contrail-test/images/ubuntu.vmdk.gz
2025-07-31 03:16:22,014 - DEBUG - Download image from local file file:///contrail-test/images/ubuntu.vmdk.gz
2025-07-31 03:16:22,014 - DEBUG - Unzip image
2025-07-31 03:16:22,014 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/ubuntu.vmdk.gz
2025-07-31 03:16:22,045 - DEBUG - Try to create image in user context
2025-07-31 03:16:22,188 - INFO - Dettaching policy ctest-vn2_vn3_pass-68915600 from vn ctest-vn3-13259881
2025-07-31 03:16:22,454 - INFO - Dettaching policy ctest-vn2_vn3_pass-68915600 from vn ctest-vn2-94776077
2025-07-31 03:16:22,769 - INFO - Dettaching policy ctest-vn1_vn3_pass-26563440 from vn ctest-vn3-13259881
2025-07-31 03:16:23,029 - INFO - Dettaching policy ctest-vn1_vn3_pass-26563440 from vn ctest-vn1-13085731
2025-07-31 03:16:23,318 - INFO - Dettaching policy ctest-vn1_vn2_pass-32358775 from vn ctest-vn2-94776077
2025-07-31 03:16:23,595 - INFO - Dettaching policy ctest-vn1_vn2_pass-32358775 from vn ctest-vn1-13085731
2025-07-31 03:16:23,878 - INFO - Deleted policy ctest-vn2_vn3_pass-68915600
2025-07-31 03:16:23,907 - INFO - Deleted policy ctest-vn1_vn3_pass-26563440
2025-07-31 03:16:23,976 - INFO - Deleted policy ctest-vn1_vn2_pass-32358775
2025-07-31 03:16:23,976 - INFO - Deleting VN ctest-vn3-13259881
2025-07-31 03:16:24,177 - DEBUG - Response for deleting network ()
2025-07-31 03:16:24,177 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/f3fda0ed-930a-405d-9a53-9d21cc6ea3da
2025-07-31 03:16:24,183 - DEBUG - Response Code: 404
2025-07-31 03:16:24,184 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2025-07-31 03:16:24,190 - DEBUG - Requesting: http://10.0.0.41:8082/domain/34dad5b7-e30d-42c7-8ff4-7b0d7fa576d7
2025-07-31 03:16:24,207 - DEBUG - Requesting: http://10.0.0.41:8082/project/9a9059a2-99b5-46c6-9dd0-be285702c1ef
2025-07-31 03:16:24,313 - INFO - Validated that VN ctest-vn3-13259881 is not found in API Server
2025-07-31 03:16:24,328 - DEBUG - VN ctest-vn3-13259881 is not present in Agent 10.0.0.27
2025-07-31 03:16:24,342 - DEBUG - VN ctest-vn3-13259881 is not present in Agent 10.0.0.57
2025-07-31 03:16:24,342 - INFO - Validated that VN ctest-vn3-13259881 is not in any agent
2025-07-31 03:16:24,384 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn3-13259881 info
2025-07-31 03:16:24,384 - INFO - Deleting VN ctest-vn2-94776077
2025-07-31 03:16:24,591 - DEBUG - Response for deleting network ()
2025-07-31 03:16:24,591 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/dc74862a-96ff-448c-a09a-55cf500c39a3
2025-07-31 03:16:24,610 - DEBUG - Response Code: 404
2025-07-31 03:16:24,610 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2025-07-31 03:16:24,619 - DEBUG - Requesting: http://10.0.0.41:8082/domain/34dad5b7-e30d-42c7-8ff4-7b0d7fa576d7
2025-07-31 03:16:24,637 - DEBUG - Requesting: http://10.0.0.41:8082/project/9a9059a2-99b5-46c6-9dd0-be285702c1ef
2025-07-31 03:16:24,755 - INFO - Validated that VN ctest-vn2-94776077 is not found in API Server
2025-07-31 03:16:24,769 - DEBUG - VN ctest-vn2-94776077 is not present in Agent 10.0.0.27
2025-07-31 03:16:24,782 - DEBUG - VN ctest-vn2-94776077 is not present in Agent 10.0.0.57
2025-07-31 03:16:24,782 - INFO - Validated that VN ctest-vn2-94776077 is not in any agent
2025-07-31 03:16:24,829 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn2-94776077 info
2025-07-31 03:16:24,829 - INFO - Deleting VN ctest-vn1-13085731
2025-07-31 03:16:25,040 - DEBUG - Response for deleting network ()
2025-07-31 03:16:25,041 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/1a6221d7-8c30-49d2-a2dc-ae7f5700dbd6
2025-07-31 03:16:25,052 - DEBUG - Response Code: 404
2025-07-31 03:16:25,052 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2025-07-31 03:16:25,073 - DEBUG - Requesting: http://10.0.0.41:8082/domain/34dad5b7-e30d-42c7-8ff4-7b0d7fa576d7
2025-07-31 03:16:25,092 - DEBUG - Requesting: http://10.0.0.41:8082/project/9a9059a2-99b5-46c6-9dd0-be285702c1ef
2025-07-31 03:16:25,204 - INFO - Validated that VN ctest-vn1-13085731 is not found in API Server
2025-07-31 03:16:25,221 - DEBUG - VN ctest-vn1-13085731 is not present in Agent 10.0.0.27
2025-07-31 03:16:25,237 - DEBUG - VN ctest-vn1-13085731 is not present in Agent 10.0.0.57
2025-07-31 03:16:25,237 - INFO - Validated that VN ctest-vn1-13085731 is not in any agent
2025-07-31 03:16:25,292 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn1-13085731 info
2025-07-31 03:16:26,630 - ERROR - Traceback (most recent call last):
File "/contrail-test/tcutils/wrappers.py", line 80, in wrapper
result = function(self, *args, **kwargs)
File "/contrail-test/scripts/intf_mirror/test_intf_mirror6.py", line 76, in test_juniper_header6_without_header_ingress
return self.verify_juniper_header_testcase(header=3, direction='ingress', ipv6=True)
File "/contrail-test/common/intf_mirroring/verify.py", line 77, in verify_juniper_header_testcase
return self.verify_intf_mirroring(compute_nodes, [0, 1, 2], sub_intf, parent_intf, nic_mirror, header = header, nh_mode=nh_mode, direction = direction, ipv6=ipv6)
File "/contrail-test/common/intf_mirroring/verify.py", line 549, in verify_intf_mirroring
image_name=image_name, node_name=src_compute, port_ids=src_port_ids)
File "/contrail-test/common/base.py", line 281, in create_vm
**kwargs)
File "/contrail-test/common/base.py", line 254, in create_only_vm
vm_obj.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-31 03:16:26,652 - DEBUG - No XMPP flaps were noticed during the test
2025-07-31 03:16:26,652 - INFO -
2025-07-31 03:16:26,652 - INFO - --------------------------------------------------------------------------------
2025-07-31 03:16:27,504 - INFO - Deleted project: ctest-TestIntfMirror6-61712589, ID : 9a9059a2-99b5-46c6-9dd0-be285702c1ef