]
2025-08-04 02:59:54,363 - DEBUG - Image by name ubuntu not found
2025-08-04 02:59:54,363 - DEBUG - Installing image ubuntu
2025-08-04 02:59:54,363 - 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'}
2025-08-04 02:59:54,363 - DEBUG - Image build path file:///contrail-test/images/ubuntu.vmdk.gz
2025-08-04 02:59:54,363 - DEBUG - Download image from local file file:///contrail-test/images/ubuntu.vmdk.gz
2025-08-04 02:59:54,363 - DEBUG - Unzip image
2025-08-04 02:59:54,364 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/ubuntu.vmdk.gz
2025-08-04 02:59:54,381 - INFO - image /contrail-test/images/ubuntu.vmdk is not found
2025-08-04 02:59:54,381 - DEBUG - Detaching the Policy for VN :ctest-VN2-74043077
2025-08-04 02:59:54,382 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-08-04 02:59:54,393 - DEBUG - Requesting: http://10.0.0.27:8082/domain/8d00e278-1e00-4abc-a644-cc23d080d5d1
2025-08-04 02:59:54,410 - DEBUG - Requesting: http://10.0.0.27:8082/project/1b963df1-2ef1-4846-a65f-9fb6ffb46eac
2025-08-04 02:59:54,519 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/3cef6a51-0c2a-4c97-9dba-645f93388ada
2025-08-04 02:59:54,541 - DEBUG - Requesting: http://10.0.0.27:8082/network-policy/2d89836e-844c-46e7-b9c9-2bd73ac5b3e8
2025-08-04 02:59:54,827 - DEBUG - Detached Policy:[['default-domain', 'ctest-TestPolicyAclIpv4v6-76147530', 'ctest-policy21-81646215']] from ctest-VN2-74043077
2025-08-04 02:59:54,828 - DEBUG - Detaching the Policy for VN :ctest-VN1-53615486
2025-08-04 02:59:54,828 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-08-04 02:59:54,840 - DEBUG - Requesting: http://10.0.0.27:8082/domain/8d00e278-1e00-4abc-a644-cc23d080d5d1
2025-08-04 02:59:54,861 - DEBUG - Requesting: http://10.0.0.27:8082/project/1b963df1-2ef1-4846-a65f-9fb6ffb46eac
2025-08-04 02:59:54,973 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/6e8ae393-d075-477b-92b1-da7577431217
2025-08-04 02:59:55,004 - DEBUG - Requesting: http://10.0.0.27:8082/network-policy/f20444d8-3bc9-4b55-9e2e-22804d1d4b5f
2025-08-04 02:59:55,279 - DEBUG - Detached Policy:[['default-domain', 'ctest-TestPolicyAclIpv4v6-76147530', 'ctest-policy12-96094390']] from ctest-VN1-53615486
2025-08-04 02:59:55,335 - INFO - Deleted policy ctest-policy21-81646215
2025-08-04 02:59:55,385 - INFO - Deleted policy ctest-policy12-96094390
2025-08-04 02:59:55,385 - INFO - Deleting VN ctest-VN3-54409418
2025-08-04 02:59:55,598 - DEBUG - Response for deleting network ()
2025-08-04 02:59:55,599 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/05db03bf-0fd7-461f-ad61-9d0830eb9cff
2025-08-04 02:59:55,611 - DEBUG - Response Code: 404
2025-08-04 02:59:55,612 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-08-04 02:59:55,622 - DEBUG - Requesting: http://10.0.0.27:8082/domain/8d00e278-1e00-4abc-a644-cc23d080d5d1
2025-08-04 02:59:55,678 - DEBUG - Requesting: http://10.0.0.27:8082/project/1b963df1-2ef1-4846-a65f-9fb6ffb46eac
2025-08-04 02:59:55,790 - INFO - Validated that VN ctest-VN3-54409418 is not found in API Server
2025-08-04 02:59:55,810 - DEBUG - VN ctest-VN3-54409418 is not present in Agent 10.0.0.41
2025-08-04 02:59:55,826 - DEBUG - VN ctest-VN3-54409418 is not present in Agent 10.0.0.57
2025-08-04 02:59:55,826 - INFO - Validated that VN ctest-VN3-54409418 is not in any agent
2025-08-04 02:59:55,882 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-VN3-54409418 info
2025-08-04 02:59:55,883 - INFO - Deleting VN ctest-VN2-74043077
2025-08-04 02:59:56,105 - DEBUG - Response for deleting network ()
2025-08-04 02:59:56,105 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/844c398b-72e6-403d-aa57-89ed948ef17c
2025-08-04 02:59:56,120 - DEBUG - Response Code: 404
2025-08-04 02:59:56,121 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-08-04 02:59:56,131 - DEBUG - Requesting: http://10.0.0.27:8082/domain/8d00e278-1e00-4abc-a644-cc23d080d5d1
2025-08-04 02:59:56,149 - DEBUG - Requesting: http://10.0.0.27:8082/project/1b963df1-2ef1-4846-a65f-9fb6ffb46eac
2025-08-04 02:59:56,262 - INFO - Validated that VN ctest-VN2-74043077 is not found in API Server
2025-08-04 02:59:56,279 - DEBUG - VN ctest-VN2-74043077 is not present in Agent 10.0.0.41
2025-08-04 02:59:56,293 - DEBUG - VN ctest-VN2-74043077 is not present in Agent 10.0.0.57
2025-08-04 02:59:56,293 - INFO - Validated that VN ctest-VN2-74043077 is not in any agent
2025-08-04 02:59:56,344 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-VN2-74043077 info
2025-08-04 02:59:56,344 - INFO - Deleting VN ctest-VN1-53615486
2025-08-04 02:59:56,570 - DEBUG - Response for deleting network ()
2025-08-04 02:59:56,571 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/98363176-24ca-401b-8fbc-52f788f4198a
2025-08-04 02:59:56,581 - DEBUG - Response Code: 404
2025-08-04 02:59:56,582 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-08-04 02:59:56,593 - DEBUG - Requesting: http://10.0.0.27:8082/domain/8d00e278-1e00-4abc-a644-cc23d080d5d1
2025-08-04 02:59:56,613 - DEBUG - Requesting: http://10.0.0.27:8082/project/1b963df1-2ef1-4846-a65f-9fb6ffb46eac
2025-08-04 02:59:56,717 - INFO - Validated that VN ctest-VN1-53615486 is not found in API Server
2025-08-04 02:59:56,732 - DEBUG - VN ctest-VN1-53615486 is not present in Agent 10.0.0.41
2025-08-04 02:59:56,750 - DEBUG - VN ctest-VN1-53615486 is not present in Agent 10.0.0.57
2025-08-04 02:59:56,750 - INFO - Validated that VN ctest-VN1-53615486 is not in any agent
2025-08-04 02:59:56,800 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-VN1-53615486 info
2025-08-04 02:59:56,916 - INFO - IPAM: ipam3 is not found in API Server
2025-08-04 02:59:56,948 - INFO - IPAM:ipam3 is not found in control node
2025-08-04 02:59:57,100 - INFO - IPAM: ipam2 is not found in API Server
2025-08-04 02:59:57,133 - INFO - IPAM:ipam2 is not found in control node
2025-08-04 02:59:57,287 - INFO - IPAM: ipam1 is not found in API Server
2025-08-04 02:59:57,313 - INFO - IPAM:ipam1 is not found in control node
2025-08-04 02:59:58,602 - DEBUG - No XMPP flaps were noticed during the test
2025-08-04 02:59:58,602 - INFO -
2025-08-04 02:59:58,602 - INFO - END TEST : test_policy_cidr_src_vn_dst_cidr : SKIPPED[0:00:16]
2025-08-04 02:59:58,602 - INFO - --------------------------------------------------------------------------------
2025-08-04 02:59:58,602 - INFO - image /contrail-test/images/ubuntu.vmdk is not found
2025-08-04 02:59:59,916 - DEBUG - No XMPP flaps were noticed during the test
2025-08-04 02:59:59,917 - INFO -
2025-08-04 02:59:59,917 - INFO - END TEST : test_policy_cidr_src_vn_dst_cidr : SKIPPED[0:00:18]
2025-08-04 02:59:59,917 - INFO - --------------------------------------------------------------------------------
2025-08-04 02:59:59,921 - INFO - ================================================================================
2025-08-04 02:59:59,921 - INFO - STARTING TEST : test_policy_inheritance_src_pol_dst_any
2025-08-04 03:00:01,200 - DEBUG - Nothing to compare xmpp stats {'10.0.0.41': {'10.20.0.18': '0', '10.20.0.129': '0'}, '10.0.0.57': {'10.20.0.193': '0', '10.20.0.18': '0'}} with
2025-08-04 03:00:01,200 - INFO - Initial checks done. Running the testcase now
2025-08-04 03:00:01,200 - INFO -
2025-08-04 03:00:01,200 - INFO - ================================================================================
2025-08-04 03:00:01,200 - INFO - STARTING TEST : test_policy_inheritance_src_pol_dst_any
2025-08-04 03:00:01,200 - INFO - TEST DESCRIPTION : Test cases to test policy inheritance
2025-08-04 03:00:02,486 - DEBUG - Nothing to compare xmpp stats {'10.0.0.41': {'10.20.0.18': '0', '10.20.0.129': '0'}, '10.0.0.57': {'10.20.0.193': '0', '10.20.0.18': '0'}} with
2025-08-04 03:00:02,486 - INFO - Initial checks done. Running the testcase now
2025-08-04 03:00:02,486 - INFO -
2025-08-04 03:00:03,500 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-08-04 03:00:03,510 - DEBUG - Requesting: http://10.0.0.27:8082/domain/8d00e278-1e00-4abc-a644-cc23d080d5d1
2025-08-04 03:00:03,533 - DEBUG - Requesting: http://10.0.0.27:8082/project/1b963df1-2ef1-4846-a65f-9fb6ffb46eac
2025-08-04 03:00:03,665 - DEBUG - Requesting: http://10.0.0.27:8082/network-ipam/1e2a8ca8-5939-4635-a480-793b81633c91
2025-08-04 03:00:03,677 - INFO - Verifications in API Server for IPAM: ipam1 passed
2025-08-04 03:00:03,686 - DEBUG - Control-node 10.0.0.27 : IPAM object is : {'node_name': 'network-ipam:default-domain:ctest-TestPolicyAclIpv4v6-76147530:ipam1', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestPolicyAclIpv4v6-76147530', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2173704424839005749', 'uuid-lslong': '11853607515719941265'}, 'enable': 'true', 'created': '2025-08-04T03:00:02', 'last-modified': '2025-08-04T03:00:02', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.923418'}
2025-08-04 03:00:03,695 - DEBUG - Control-node 10.0.0.38 : IPAM object is : {'node_name': 'network-ipam:default-domain:ctest-TestPolicyAclIpv4v6-76147530:ipam1', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestPolicyAclIpv4v6-76147530', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2173704424839005749', 'uuid-lslong': '11853607515719941265'}, 'enable': 'true', 'created': '2025-08-04T03:00:02', 'last-modified': '2025-08-04T03:00:02', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.926766'}
2025-08-04 03:00:03,704 - DEBUG - Control-node 10.0.0.61 : IPAM object is : {'node_name': 'network-ipam:default-domain:ctest-TestPolicyAclIpv4v6-76147530:ipam1', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestPolicyAclIpv4v6-76147530', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2173704424839005749', 'uuid-lslong': '11853607515719941265'}, 'enable': 'true', 'created': '2025-08-04T03:00:02', 'last-modified': '2025-08-04T03:00:02', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.929115'}
2025-08-04 03:00:03,704 - INFO - Verifications in Control node for IPAM: ipam1 passed
2025-08-04 03:00:03,704 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-08-04 03:00:03,715 - DEBUG - Requesting: http://10.0.0.27:8082/domain/8d00e278-1e00-4abc-a644-cc23d080d5d1
2025-08-04 03:00:03,734 - DEBUG - Requesting: http://10.0.0.27:8082/project/1b963df1-2ef1-4846-a65f-9fb6ffb46eac
2025-08-04 03:00:03,878 - DEBUG - Requesting: http://10.0.0.27:8082/network-ipam/e40ddbb4-82ac-4d49-ae79-0d2c98389f8d
2025-08-04 03:00:03,892 - INFO - Verifications in API Server for IPAM: ipam2 passed
2025-08-04 03:00:03,906 - DEBUG - Control-node 10.0.0.27 : IPAM object is : {'node_name': 'network-ipam:default-domain:ctest-TestPolicyAclIpv4v6-76147530:ipam2', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestPolicyAclIpv4v6-76147530', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16433032183677734217', 'uuid-lslong': '12572094319965020045'}, 'enable': 'true', 'created': '2025-08-04T03:00:02', 'last-modified': '2025-08-04T03:00:03', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.776477'}
2025-08-04 03:00:03,917 - DEBUG - Control-node 10.0.0.38 : IPAM object is : {'node_name': 'network-ipam:default-domain:ctest-TestPolicyAclIpv4v6-76147530:ipam2', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestPolicyAclIpv4v6-76147530', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16433032183677734217', 'uuid-lslong': '12572094319965020045'}, 'enable': 'true', 'created': '2025-08-04T03:00:02', 'last-modified': '2025-08-04T03:00:03', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.784294'}
2025-08-04 03:00:03,927 - DEBUG - Control-node 10.0.0.61 : IPAM object is : {'node_name': 'network-ipam:default-domain:ctest-TestPolicyAclIpv4v6-76147530:ipam2', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestPolicyAclIpv4v6-76147530', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16433032183677734217', 'uuid-lslong': '12572094319965020045'}, 'enable': 'true', 'created': '2025-08-04T03:00:02', 'last-modified': '2025-08-04T03:00:03', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.799061'}
2025-08-04 03:00:03,927 - INFO - Verifications in Control node for IPAM: ipam2 passed
2025-08-04 03:00:03,927 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-08-04 03:00:03,942 - DEBUG - Requesting: http://10.0.0.27:8082/domain/8d00e278-1e00-4abc-a644-cc23d080d5d1
2025-08-04 03:00:03,963 - DEBUG - Requesting: http://10.0.0.27:8082/project/1b963df1-2ef1-4846-a65f-9fb6ffb46eac
2025-08-04 03:00:04,067 - DEBUG - Requesting: http://10.0.0.27:8082/network-ipam/dc29964a-499d-436f-a2d3-edf044a640e0
2025-08-04 03:00:04,088 - INFO - Verifications in API Server for IPAM: ipam3 passed
2025-08-04 03:00:04,095 - DEBUG - Control-node 10.0.0.27 : IPAM object is : {'node_name': 'network-ipam:default-domain:ctest-TestPolicyAclIpv4v6-76147530:ipam3', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestPolicyAclIpv4v6-76147530', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '15864376408196072303', 'uuid-lslong': '11732983070429954272'}, 'enable': 'true', 'created': '2025-08-04T03:00:03', 'last-modified': '2025-08-04T03:00:03', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.626627'}
2025-08-04 03:00:04,102 - DEBUG - Control-node 10.0.0.38 : IPAM object is : {'node_name': 'network-ipam:default-domain:ctest-TestPolicyAclIpv4v6-76147530:ipam3', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestPolicyAclIpv4v6-76147530', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '15864376408196072303', 'uuid-lslong': '11732983070429954272'}, 'enable': 'true', 'created': '2025-08-04T03:00:03', 'last-modified': '2025-08-04T03:00:03', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.632155'}
2025-08-04 03:00:04,117 - DEBUG - Control-node 10.0.0.61 : IPAM object is : {'node_name': 'network-ipam:default-domain:ctest-TestPolicyAclIpv4v6-76147530:ipam3', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestPolicyAclIpv4v6-76147530', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '15864376408196072303', 'uuid-lslong': '11732983070429954272'}, 'enable': 'true', 'created': '2025-08-04T03:00:03', 'last-modified': '2025-08-04T03:00:03', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.642901'}
2025-08-04 03:00:04,117 - INFO - Verifications in Control node for IPAM: ipam3 passed
2025-08-04 03:00:04,436 - DEBUG - Response for create_network : {'network': {'id': '331be6e1-26d4-49f1-9714-294bbe99a364', 'name': 'ctest-VN1-20253302', 'tenant_id': '1b963df12ef14846a65f9fb6ffb46eac', 'project_id': '1b963df12ef14846a65f9fb6ffb46eac', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestPolicyAclIpv4v6-76147530', 'ctest-VN1-20253302'], 'port_security_enabled': True, 'description': ''}}
2025-08-04 03:00:04,722 - DEBUG - Response for create_subnet : {'subnet': {'id': '67f3847b-bfbb-4063-9b9f-9bef89185ac6', 'name': '', 'tenant_id': '1b963df12ef14846a65f9fb6ffb46eac', 'network_id': '331be6e1-26d4-49f1-9714-294bbe99a364', 'ip_version': 4, 'cidr': '149.91.26.64/26', 'allocation_pools': [{'start': '149.91.26.66', 'end': '149.91.26.126'}], 'gateway_ip': '149.91.26.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '149.91.26.66', 'tags': [], 'project_id': '1b963df12ef14846a65f9fb6ffb46eac'}}
2025-08-04 03:00:04,982 - DEBUG - Response for create_subnet : {'subnet': {'id': 'c94e5020-d02f-45d4-a24c-e35ad23a9e81', 'name': '', 'tenant_id': '1b963df12ef14846a65f9fb6ffb46eac', 'network_id': '331be6e1-26d4-49f1-9714-294bbe99a364', 'ip_version': 6, 'cidr': '386b:70f7:5a7b:16dd:5f9e:308c::/96', 'allocation_pools': [{'start': '386b:70f7:5a7b:16dd:5f9e:308c:0:2', 'end': '386b:70f7:5a7b:16dd:5f9e:308c:ffff:fffe'}], 'gateway_ip': '386b:70f7:5a7b:16dd:5f9e:308c:0:1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '386b:70f7:5a7b:16dd:5f9e:308c:0:2', 'tags': [], 'project_id': '1b963df12ef14846a65f9fb6ffb46eac'}}
2025-08-04 03:00:05,010 - INFO - Created VN ctest-VN1-20253302
2025-08-04 03:00:05,027 - DEBUG - VN ctest-VN1-20253302 UUID is 331be6e1-26d4-49f1-9714-294bbe99a364
2025-08-04 03:00:05,228 - DEBUG - Fetched VN: default-domain:ctest-TestPolicyAclIpv4v6-76147530:ctest-VN1-20253302(331be6e1-26d4-49f1-9714-294bbe99a364) with subnets ['149.91.26.64/26', '386b:70f7:5a7b:16dd:5f9e:308c::/96']
2025-08-04 03:00:05,618 - DEBUG - Response for create_network : {'network': {'id': 'faee589f-b93a-4530-a77e-0ff2486c43de', 'name': 'ctest-VN2-87496102', 'tenant_id': '1b963df12ef14846a65f9fb6ffb46eac', 'project_id': '1b963df12ef14846a65f9fb6ffb46eac', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestPolicyAclIpv4v6-76147530', 'ctest-VN2-87496102'], 'port_security_enabled': True, 'description': ''}}
2025-08-04 03:00:05,983 - DEBUG - Response for create_subnet : {'subnet': {'id': 'a40b2bc3-1b83-43a9-9dc3-6e378bce072a', 'name': '', 'tenant_id': '1b963df12ef14846a65f9fb6ffb46eac', 'network_id': 'faee589f-b93a-4530-a77e-0ff2486c43de', 'ip_version': 4, 'cidr': '114.199.147.0/26', 'allocation_pools': [{'start': '114.199.147.2', 'end': '114.199.147.62'}], 'gateway_ip': '114.199.147.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '114.199.147.2', 'tags': [], 'project_id': '1b963df12ef14846a65f9fb6ffb46eac'}}
2025-08-04 03:00:06,185 - DEBUG - Response for create_subnet : {'subnet': {'id': 'f0b82d18-3fb6-48e6-9834-76b965715bf3', 'name': '', 'tenant_id': '1b963df12ef14846a65f9fb6ffb46eac', 'network_id': 'faee589f-b93a-4530-a77e-0ff2486c43de', 'ip_version': 6, 'cidr': '32e7:5ae6:8225:ded7:b66c:1a6::/96', 'allocation_pools': [{'start': '32e7:5ae6:8225:ded7:b66c:1a6:0:2', 'end': '32e7:5ae6:8225:ded7:b66c:1a6:ffff:fffe'}], 'gateway_ip': '32e7:5ae6:8225:ded7:b66c:1a6:0:1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '32e7:5ae6:8225:ded7:b66c:1a6:0:2', 'tags': [], 'project_id': '1b963df12ef14846a65f9fb6ffb46eac'}}
2025-08-04 03:00:06,217 - INFO - Created VN ctest-VN2-87496102
2025-08-04 03:00:06,229 - DEBUG - VN ctest-VN2-87496102 UUID is faee589f-b93a-4530-a77e-0ff2486c43de
2025-08-04 03:00:06,690 - DEBUG - Response for create_network : {'network': {'id': '016b9c0b-7954-4fe1-8404-a9ca34305036', 'name': 'ctest-VN3-22987411', 'tenant_id': '1b963df12ef14846a65f9fb6ffb46eac', 'project_id': '1b963df12ef14846a65f9fb6ffb46eac', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestPolicyAclIpv4v6-76147530', 'ctest-VN3-22987411'], 'port_security_enabled': True, 'description': ''}}
2025-08-04 03:00:06,975 - DEBUG - Response for create_subnet : {'subnet': {'id': '83f9e693-3345-45d6-ac19-b63095f7da86', 'name': '', 'tenant_id': '1b963df12ef14846a65f9fb6ffb46eac', 'network_id': '016b9c0b-7954-4fe1-8404-a9ca34305036', 'ip_version': 4, 'cidr': '23.205.35.64/26', 'allocation_pools': [{'start': '23.205.35.66', 'end': '23.205.35.126'}], 'gateway_ip': '23.205.35.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '23.205.35.66', 'tags': [], 'project_id': '1b963df12ef14846a65f9fb6ffb46eac'}}
2025-08-04 03:00:07,187 - DEBUG - Response for create_subnet : {'subnet': {'id': '96c6be27-9cc1-44dd-a38a-fa6f8223659e', 'name': '', 'tenant_id': '1b963df12ef14846a65f9fb6ffb46eac', 'network_id': '016b9c0b-7954-4fe1-8404-a9ca34305036', 'ip_version': 6, 'cidr': '29d6:76f8:5a2a:1672:1537:e18e::/96', 'allocation_pools': [{'start': '29d6:76f8:5a2a:1672:1537:e18e:0:2', 'end': '29d6:76f8:5a2a:1672:1537:e18e:ffff:fffe'}], 'gateway_ip': '29d6:76f8:5a2a:1672:1537:e18e:0:1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '29d6:76f8:5a2a:1672:1537:e18e:0:2', 'tags': [], 'project_id': '1b963df12ef14846a65f9fb6ffb46eac'}}
2025-08-04 03:00:07,216 - INFO - Created VN ctest-VN3-22987411
2025-08-04 03:00:07,232 - DEBUG - VN ctest-VN3-22987411 UUID is 016b9c0b-7954-4fe1-8404-a9ca34305036
2025-08-04 03:00:07,381 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-08-04 03:00:07,395 - DEBUG - Requesting: http://10.0.0.27:8082/domain/8d00e278-1e00-4abc-a644-cc23d080d5d1
2025-08-04 03:00:07,413 - DEBUG - Requesting: http://10.0.0.27:8082/project/1b963df1-2ef1-4846-a65f-9fb6ffb46eac
2025-08-04 03:00:07,525 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/331be6e1-26d4-49f1-9714-294bbe99a364
2025-08-04 03:00:07,543 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/331be6e1-26d4-49f1-9714-294bbe99a364
2025-08-04 03:00:07,556 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/64a6af96-998f-4506-99d7-4e39b9c2d0e5
2025-08-04 03:00:07,567 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/64a6af96-998f-4506-99d7-4e39b9c2d0e5
2025-08-04 03:00:07,578 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/3db26531-8ad7-4469-b4a3-94194e6a65d1
2025-08-04 03:00:07,587 - DEBUG - Route Targets: ['target:64512:8000005']
2025-08-04 03:00:07,587 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/331be6e1-26d4-49f1-9714-294bbe99a364
2025-08-04 03:00:07,598 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/64a6af96-998f-4506-99d7-4e39b9c2d0e5
2025-08-04 03:00:07,617 - INFO - Verified VN network id 13 for VN 331be6e1-26d4-49f1-9714-294bbe99a364
2025-08-04 03:00:07,617 - INFO - Verifications in API Server for VN ctest-VN1-20253302 passed
2025-08-04 03:00:07,617 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/331be6e1-26d4-49f1-9714-294bbe99a364
2025-08-04 03:00:07,631 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/64a6af96-998f-4506-99d7-4e39b9c2d0e5
2025-08-04 03:00:07,640 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/64a6af96-998f-4506-99d7-4e39b9c2d0e5
2025-08-04 03:00:07,651 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/3db26531-8ad7-4469-b4a3-94194e6a65d1
2025-08-04 03:00:07,670 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestPolicyAclIpv4v6-76147530:ctest-VN1-20253302', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestPolicyAclIpv4v6-76147530', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3682790974998989297', 'uuid-lslong': '10886371604558357348'}, 'enable': 'true', 'created': '2025-08-04T03:00:04', 'last-modified': '2025-08-04T03:00:04', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:02.758527'}
2025-08-04 03:00:07,680 - DEBUG - Route Targets: ['target:64512:8000005']
2025-08-04 03:00:07,689 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestPolicyAclIpv4v6-76147530:ctest-VN1-20253302', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestPolicyAclIpv4v6-76147530', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3682790974998989297', 'uuid-lslong': '10886371604558357348'}, 'enable': 'true', 'created': '2025-08-04T03:00:04', 'last-modified': '2025-08-04T03:00:04', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:02.790013'}
2025-08-04 03:00:07,699 - DEBUG - Route Targets: ['target:64512:8000005']
2025-08-04 03:00:07,707 - DEBUG - Control-node 10.0.0.61 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestPolicyAclIpv4v6-76147530:ctest-VN1-20253302', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestPolicyAclIpv4v6-76147530', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3682790974998989297', 'uuid-lslong': '10886371604558357348'}, 'enable': 'true', 'created': '2025-08-04T03:00:04', 'last-modified': '2025-08-04T03:00:04', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:02.813183'}
2025-08-04 03:00:07,715 - DEBUG - Route Targets: ['target:64512:8000005']
2025-08-04 03:00:07,715 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-VN1-20253302 passed
2025-08-04 03:00:07,715 - DEBUG - ====Verifying policy data for ctest-VN1-20253302 in API_Server ======
2025-08-04 03:00:07,715 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-08-04 03:00:07,724 - DEBUG - Requesting: http://10.0.0.27:8082/domain/8d00e278-1e00-4abc-a644-cc23d080d5d1
2025-08-04 03:00:07,739 - DEBUG - Requesting: http://10.0.0.27:8082/project/1b963df1-2ef1-4846-a65f-9fb6ffb46eac
2025-08-04 03:00:07,842 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/331be6e1-26d4-49f1-9714-294bbe99a364
2025-08-04 03:00:07,854 - DEBUG - =>VN ctest-VN1-20253302 has no policy to be verified
2025-08-04 03:00:07,854 - DEBUG - Verifying the vn in opserver
2025-08-04 03:00:07,854 - DEBUG - Verifying the default-domain:ctest-TestPolicyAclIpv4v6-76147530:ctest-VN1-20253302 virtual network link through opserver 10.0.0.27
2025-08-04 03:00:07,854 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2025-08-04 03:00:07,870 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestPolicyAclIpv4v6-76147530:ctest-VN1-20253302', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestPolicyAclIpv4v6-76147530:ctest-VN1-20253302?flat'}
2025-08-04 03:00:07,870 - DEBUG - Verifying the default-domain:ctest-TestPolicyAclIpv4v6-76147530:ctest-VN1-20253302 virtual network link through opserver 10.0.0.38
2025-08-04 03:00:07,870 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2025-08-04 03:00:07,883 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestPolicyAclIpv4v6-76147530:ctest-VN1-20253302', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestPolicyAclIpv4v6-76147530:ctest-VN1-20253302?flat'}
2025-08-04 03:00:07,883 - DEBUG - Verifying the default-domain:ctest-TestPolicyAclIpv4v6-76147530:ctest-VN1-20253302 virtual network link through opserver 10.0.0.61
2025-08-04 03:00:07,883 - DEBUG - Requesting: http://10.0.0.61:8081/analytics/uves/virtual-networks
2025-08-04 03:00:07,904 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestPolicyAclIpv4v6-76147530:ctest-VN1-20253302', 'href': 'http://10.0.0.61:8081/analytics/uves/virtual-network/default-domain:ctest-TestPolicyAclIpv4v6-76147530:ctest-VN1-20253302?flat'}
2025-08-04 03:00:07,904 - INFO - Validated that VN default-domain:ctest-TestPolicyAclIpv4v6-76147530:ctest-VN1-20253302 is found in opserver
2025-08-04 03:00:07,936 - DEBUG - Do not have enough data to verify VN in agent
2025-08-04 03:00:07,950 - DEBUG - VRF ids for VN ctest-VN1-20253302: {}
2025-08-04 03:00:07,950 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-08-04 03:00:07,958 - DEBUG - Requesting: http://10.0.0.27:8082/domain/8d00e278-1e00-4abc-a644-cc23d080d5d1
2025-08-04 03:00:07,973 - DEBUG - Requesting: http://10.0.0.27:8082/project/1b963df1-2ef1-4846-a65f-9fb6ffb46eac
2025-08-04 03:00:08,072 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/faee589f-b93a-4530-a77e-0ff2486c43de
2025-08-04 03:00:08,090 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/faee589f-b93a-4530-a77e-0ff2486c43de
2025-08-04 03:00:08,106 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/208355c4-33e6-451c-8edc-53a1fdde80b9
2025-08-04 03:00:08,119 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/208355c4-33e6-451c-8edc-53a1fdde80b9
2025-08-04 03:00:08,129 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/6353d3af-286e-4ccf-b863-47eccafc8c09
2025-08-04 03:00:08,139 - DEBUG - Route Targets: ['target:64512:8000006']
2025-08-04 03:00:08,139 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/faee589f-b93a-4530-a77e-0ff2486c43de
2025-08-04 03:00:08,152 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/208355c4-33e6-451c-8edc-53a1fdde80b9
2025-08-04 03:00:08,178 - INFO - Verified VN network id 14 for VN faee589f-b93a-4530-a77e-0ff2486c43de
2025-08-04 03:00:08,178 - INFO - Verifications in API Server for VN ctest-VN2-87496102 passed
2025-08-04 03:00:08,179 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/faee589f-b93a-4530-a77e-0ff2486c43de
2025-08-04 03:00:08,195 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/208355c4-33e6-451c-8edc-53a1fdde80b9
2025-08-04 03:00:08,207 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/208355c4-33e6-451c-8edc-53a1fdde80b9
2025-08-04 03:00:08,219 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/6353d3af-286e-4ccf-b863-47eccafc8c09
2025-08-04 03:00:08,239 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestPolicyAclIpv4v6-76147530:ctest-VN2-87496102', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestPolicyAclIpv4v6-76147530', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '18081486996969768240', 'uuid-lslong': '12069101584671065054'}, 'enable': 'true', 'created': '2025-08-04T03:00:05', 'last-modified': '2025-08-04T03:00:06', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:02.116483'}
2025-08-04 03:00:08,248 - DEBUG - Route Targets: ['target:64512:8000006']
2025-08-04 03:00:08,256 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestPolicyAclIpv4v6-76147530:ctest-VN2-87496102', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestPolicyAclIpv4v6-76147530', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '18081486996969768240', 'uuid-lslong': '12069101584671065054'}, 'enable': 'true', 'created': '2025-08-04T03:00:05', 'last-modified': '2025-08-04T03:00:06', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:02.134678'}
2025-08-04 03:00:08,263 - DEBUG - Route Targets: ['target:64512:8000006']
2025-08-04 03:00:08,272 - DEBUG - Control-node 10.0.0.61 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestPolicyAclIpv4v6-76147530:ctest-VN2-87496102', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestPolicyAclIpv4v6-76147530', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '18081486996969768240', 'uuid-lslong': '12069101584671065054'}, 'enable': 'true', 'created': '2025-08-04T03:00:05', 'last-modified': '2025-08-04T03:00:06', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:02.147418'}
2025-08-04 03:00:08,281 - DEBUG - Route Targets: ['target:64512:8000006']
2025-08-04 03:00:08,281 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-VN2-87496102 passed
2025-08-04 03:00:08,282 - DEBUG - ====Verifying policy data for ctest-VN2-87496102 in API_Server ======
2025-08-04 03:00:08,282 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-08-04 03:00:08,289 - DEBUG - Requesting: http://10.0.0.27:8082/domain/8d00e278-1e00-4abc-a644-cc23d080d5d1
2025-08-04 03:00:08,303 - DEBUG - Requesting: http://10.0.0.27:8082/project/1b963df1-2ef1-4846-a65f-9fb6ffb46eac
2025-08-04 03:00:08,408 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/faee589f-b93a-4530-a77e-0ff2486c43de
2025-08-04 03:00:08,424 - DEBUG - =>VN ctest-VN2-87496102 has no policy to be verified
2025-08-04 03:00:08,424 - DEBUG - Verifying the vn in opserver
2025-08-04 03:00:08,424 - DEBUG - Verifying the default-domain:ctest-TestPolicyAclIpv4v6-76147530:ctest-VN2-87496102 virtual network link through opserver 10.0.0.27
2025-08-04 03:00:08,424 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2025-08-04 03:00:08,441 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestPolicyAclIpv4v6-76147530:ctest-VN2-87496102', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestPolicyAclIpv4v6-76147530:ctest-VN2-87496102?flat'}
2025-08-04 03:00:08,442 - DEBUG - Verifying the default-domain:ctest-TestPolicyAclIpv4v6-76147530:ctest-VN2-87496102 virtual network link through opserver 10.0.0.38
2025-08-04 03:00:08,442 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2025-08-04 03:00:08,457 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestPolicyAclIpv4v6-76147530:ctest-VN2-87496102', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestPolicyAclIpv4v6-76147530:ctest-VN2-87496102?flat'}
2025-08-04 03:00:08,457 - DEBUG - Verifying the default-domain:ctest-TestPolicyAclIpv4v6-76147530:ctest-VN2-87496102 virtual network link through opserver 10.0.0.61
2025-08-04 03:00:08,457 - DEBUG - Requesting: http://10.0.0.61:8081/analytics/uves/virtual-networks
2025-08-04 03:00:08,477 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestPolicyAclIpv4v6-76147530:ctest-VN2-87496102', 'href': 'http://10.0.0.61:8081/analytics/uves/virtual-network/default-domain:ctest-TestPolicyAclIpv4v6-76147530:ctest-VN2-87496102?flat'}
2025-08-04 03:00:08,477 - INFO - Validated that VN default-domain:ctest-TestPolicyAclIpv4v6-76147530:ctest-VN2-87496102 is found in opserver
2025-08-04 03:00:08,509 - DEBUG - Do not have enough data to verify VN in agent
2025-08-04 03:00:08,527 - DEBUG - VRF ids for VN ctest-VN2-87496102: {}
2025-08-04 03:00:08,527 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-08-04 03:00:08,539 - DEBUG - Requesting: http://10.0.0.27:8082/domain/8d00e278-1e00-4abc-a644-cc23d080d5d1
2025-08-04 03:00:08,561 - DEBUG - Requesting: http://10.0.0.27:8082/project/1b963df1-2ef1-4846-a65f-9fb6ffb46eac
2025-08-04 03:00:08,681 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/016b9c0b-7954-4fe1-8404-a9ca34305036
2025-08-04 03:00:08,697 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/016b9c0b-7954-4fe1-8404-a9ca34305036
2025-08-04 03:00:08,710 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/23927e59-30d8-4781-868c-58c6f05b787b
2025-08-04 03:00:08,720 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/23927e59-30d8-4781-868c-58c6f05b787b
2025-08-04 03:00:08,729 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/04d93be4-a47b-4f7c-8331-0d906f3df4e7
2025-08-04 03:00:08,738 - DEBUG - Route Targets: ['target:64512:8000007']
2025-08-04 03:00:08,738 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/016b9c0b-7954-4fe1-8404-a9ca34305036
2025-08-04 03:00:08,753 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/23927e59-30d8-4781-868c-58c6f05b787b
2025-08-04 03:00:08,775 - INFO - Verified VN network id 15 for VN 016b9c0b-7954-4fe1-8404-a9ca34305036
2025-08-04 03:00:08,775 - INFO - Verifications in API Server for VN ctest-VN3-22987411 passed
2025-08-04 03:00:08,775 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/016b9c0b-7954-4fe1-8404-a9ca34305036
2025-08-04 03:00:08,790 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/23927e59-30d8-4781-868c-58c6f05b787b
2025-08-04 03:00:08,802 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/23927e59-30d8-4781-868c-58c6f05b787b
2025-08-04 03:00:08,813 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/04d93be4-a47b-4f7c-8331-0d906f3df4e7
2025-08-04 03:00:08,835 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestPolicyAclIpv4v6-76147530:ctest-VN3-22987411', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestPolicyAclIpv4v6-76147530', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '102346989640110049', 'uuid-lslong': '9512914998837399606'}, 'enable': 'true', 'created': '2025-08-04T03:00:06', 'last-modified': '2025-08-04T03:00:07', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.706665'}
2025-08-04 03:00:08,845 - DEBUG - Route Targets: ['target:64512:8000007']
2025-08-04 03:00:08,853 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestPolicyAclIpv4v6-76147530:ctest-VN3-22987411', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestPolicyAclIpv4v6-76147530', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '102346989640110049', 'uuid-lslong': '9512914998837399606'}, 'enable': 'true', 'created': '2025-08-04T03:00:06', 'last-modified': '2025-08-04T03:00:07', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.713588'}
2025-08-04 03:00:08,862 - DEBUG - Route Targets: ['target:64512:8000007']
2025-08-04 03:00:08,871 - DEBUG - Control-node 10.0.0.61 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestPolicyAclIpv4v6-76147530:ctest-VN3-22987411', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestPolicyAclIpv4v6-76147530', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '102346989640110049', 'uuid-lslong': '9512914998837399606'}, 'enable': 'true', 'created': '2025-08-04T03:00:06', 'last-modified': '2025-08-04T03:00:07', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.746188'}
2025-08-04 03:00:08,882 - DEBUG - Route Targets: ['target:64512:8000007']
2025-08-04 03:00:08,882 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-VN3-22987411 passed
2025-08-04 03:00:08,882 - DEBUG - ====Verifying policy data for ctest-VN3-22987411 in API_Server ======
2025-08-04 03:00:08,882 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-08-04 03:00:08,892 - DEBUG - Requesting: http://10.0.0.27:8082/domain/8d00e278-1e00-4abc-a644-cc23d080d5d1
2025-08-04 03:00:08,912 - DEBUG - Requesting: http://10.0.0.27:8082/project/1b963df1-2ef1-4846-a65f-9fb6ffb46eac
2025-08-04 03:00:09,027 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/016b9c0b-7954-4fe1-8404-a9ca34305036
2025-08-04 03:00:09,039 - DEBUG - =>VN ctest-VN3-22987411 has no policy to be verified
2025-08-04 03:00:09,039 - DEBUG - Verifying the vn in opserver
2025-08-04 03:00:09,039 - DEBUG - Verifying the default-domain:ctest-TestPolicyAclIpv4v6-76147530:ctest-VN3-22987411 virtual network link through opserver 10.0.0.27
2025-08-04 03:00:09,039 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2025-08-04 03:00:09,064 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestPolicyAclIpv4v6-76147530:ctest-VN3-22987411', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestPolicyAclIpv4v6-76147530:ctest-VN3-22987411?flat'}
2025-08-04 03:00:09,064 - DEBUG - Verifying the default-domain:ctest-TestPolicyAclIpv4v6-76147530:ctest-VN3-22987411 virtual network link through opserver 10.0.0.38
2025-08-04 03:00:09,064 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2025-08-04 03:00:09,084 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestPolicyAclIpv4v6-76147530:ctest-VN3-22987411', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestPolicyAclIpv4v6-76147530:ctest-VN3-22987411?flat'}
2025-08-04 03:00:09,084 - DEBUG - Verifying the default-domain:ctest-TestPolicyAclIpv4v6-76147530:ctest-VN3-22987411 virtual network link through opserver 10.0.0.61
2025-08-04 03:00:09,085 - DEBUG - Requesting: http://10.0.0.61:8081/analytics/uves/virtual-networks
2025-08-04 03:00:09,101 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestPolicyAclIpv4v6-76147530:ctest-VN3-22987411', 'href': 'http://10.0.0.61:8081/analytics/uves/virtual-network/default-domain:ctest-TestPolicyAclIpv4v6-76147530:ctest-VN3-22987411?flat'}
2025-08-04 03:00:09,101 - INFO - Validated that VN default-domain:ctest-TestPolicyAclIpv4v6-76147530:ctest-VN3-22987411 is found in opserver
2025-08-04 03:00:09,132 - DEBUG - Do not have enough data to verify VN in agent
2025-08-04 03:00:09,146 - DEBUG - VRF ids for VN ctest-VN3-22987411: {}
2025-08-04 03:00:09,155 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = any, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestPolicyAclIpv4v6-76147530:ctest-VN1-20253302, security_group = None, network_policy = None, subnet_list = []], src_ports = [start_port = -1, end_port = -1], application = [], dst_addresses = [subnet = None, virtual_network = default-domain:ctest-TestPolicyAclIpv4v6-76147530:ctest-VN3-22987411, security_group = None, network_policy = None, subnet_list = []], dst_ports = [start_port = -1, end_port = -1], action_list = simple_action = deny, 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-08-04 03:00:09,444 - DEBUG - No source network defined
2025-08-04 03:00:09,444 - DEBUG - No source network defined
2025-08-04 03:00:09,444 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = icmp, src_addresses = [subnet = None, virtual_network = None, security_group = None, network_policy = default-domain:ctest-TestPolicyAclIpv4v6-76147530:ctest-policy13-13878098, subnet_list = []], src_ports = [start_port = -1, end_port = -1], application = [], dst_addresses = [subnet = None, virtual_network = any, security_group = None, network_policy = None, subnet_list = []], dst_ports = [start_port = -1, end_port = -1], 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 = 58, src_addresses = [subnet = None, virtual_network = None, security_group = None, network_policy = default-domain:ctest-TestPolicyAclIpv4v6-76147530:ctest-policy13-13878098, subnet_list = []], src_ports = [start_port = -1, end_port = -1], application = [], dst_addresses = [subnet = None, virtual_network = any, security_group = None, network_policy = None, subnet_list = []], dst_ports = [start_port = -1, end_port = -1], 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-08-04 03:00:09,744 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = icmp, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestPolicyAclIpv4v6-76147530:ctest-VN2-87496102, security_group = None, network_policy = None, subnet_list = []], src_ports = [start_port = -1, end_port = -1], application = [], dst_addresses = [subnet = None, virtual_network = default-domain:ctest-TestPolicyAclIpv4v6-76147530:ctest-VN1-20253302, security_group = None, network_policy = None, subnet_list = []], dst_ports = [start_port = -1, end_port = -1], 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 = 58, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestPolicyAclIpv4v6-76147530:ctest-VN2-87496102, security_group = None, network_policy = None, subnet_list = []], src_ports = [start_port = -1, end_port = -1], application = [], dst_addresses = [subnet = None, virtual_network = default-domain:ctest-TestPolicyAclIpv4v6-76147530:ctest-VN1-20253302, security_group = None, network_policy = None, subnet_list = []], dst_ports = [start_port = -1, end_port = -1], 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-08-04 03:00:09,982 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-08-04 03:00:09,991 - DEBUG - Requesting: http://10.0.0.27:8082/domain/8d00e278-1e00-4abc-a644-cc23d080d5d1
2025-08-04 03:00:10,009 - DEBUG - Requesting: http://10.0.0.27:8082/project/1b963df1-2ef1-4846-a65f-9fb6ffb46eac
2025-08-04 03:00:10,128 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/331be6e1-26d4-49f1-9714-294bbe99a364
2025-08-04 03:00:10,145 - DEBUG - Setup step: Associating the policy to VN'
2025-08-04 03:00:10,326 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': '331be6e1-26d4-49f1-9714-294bbe99a364', 'name': 'ctest-VN1-20253302', 'tenant_id': '1b963df12ef14846a65f9fb6ffb46eac', 'project_id': '1b963df12ef14846a65f9fb6ffb46eac', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['67f3847b-bfbb-4063-9b9f-9bef89185ac6', 'c94e5020-d02f-45d4-a24c-e35ad23a9e81'], 'fq_name': ['default-domain', 'ctest-TestPolicyAclIpv4v6-76147530', 'ctest-VN1-20253302'], 'policys': [['default-domain', 'ctest-TestPolicyAclIpv4v6-76147530', 'ctest-policy12-11486470'], ['default-domain', 'ctest-TestPolicyAclIpv4v6-76147530', 'ctest-policy13-13878098']], 'subnet_ipam': [{'subnet_cidr': '149.91.26.64/26', 'ipam_fq_name': ['default-domain', 'ctest-TestPolicyAclIpv4v6-76147530', 'ipam1']}, {'subnet_cidr': '386b:70f7:5a7b:16dd:5f9e:308c::/96', 'ipam_fq_name': ['default-domain', 'ctest-TestPolicyAclIpv4v6-76147530', 'ipam1']}], 'port_security_enabled': True, 'description': ''}}
2025-08-04 03:00:10,484 - DEBUG - Associated Policy:[['default-domain', 'ctest-TestPolicyAclIpv4v6-76147530', 'ctest-policy12-11486470'], ['default-domain', 'ctest-TestPolicyAclIpv4v6-76147530', 'ctest-policy13-13878098']] to ctest-VN1-20253302
2025-08-04 03:00:10,485 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-08-04 03:00:10,492 - DEBUG - Requesting: http://10.0.0.27:8082/domain/8d00e278-1e00-4abc-a644-cc23d080d5d1
2025-08-04 03:00:10,511 - DEBUG - Requesting: http://10.0.0.27:8082/project/1b963df1-2ef1-4846-a65f-9fb6ffb46eac
2025-08-04 03:00:10,600 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/faee589f-b93a-4530-a77e-0ff2486c43de
2025-08-04 03:00:10,618 - DEBUG - Setup step: Associating the policy to VN'
2025-08-04 03:00:10,766 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': 'faee589f-b93a-4530-a77e-0ff2486c43de', 'name': 'ctest-VN2-87496102', 'tenant_id': '1b963df12ef14846a65f9fb6ffb46eac', 'project_id': '1b963df12ef14846a65f9fb6ffb46eac', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['a40b2bc3-1b83-43a9-9dc3-6e378bce072a', 'f0b82d18-3fb6-48e6-9834-76b965715bf3'], 'fq_name': ['default-domain', 'ctest-TestPolicyAclIpv4v6-76147530', 'ctest-VN2-87496102'], 'policys': [['default-domain', 'ctest-TestPolicyAclIpv4v6-76147530', 'ctest-policy21-09022947']], 'subnet_ipam': [{'subnet_cidr': '114.199.147.0/26', 'ipam_fq_name': ['default-domain', 'ctest-TestPolicyAclIpv4v6-76147530', 'ipam2']}, {'subnet_cidr': '32e7:5ae6:8225:ded7:b66c:1a6::/96', 'ipam_fq_name': ['default-domain', 'ctest-TestPolicyAclIpv4v6-76147530', 'ipam2']}], 'port_security_enabled': True, 'description': ''}}
2025-08-04 03:00:10,898 - DEBUG - Associated Policy:[['default-domain', 'ctest-TestPolicyAclIpv4v6-76147530', 'ctest-policy21-09022947']] to ctest-VN2-87496102
2025-08-04 03:00:11,011 - DEBUG - Image by name ubuntu not found
2025-08-04 03:00:11,011 - DEBUG - Installing image ubuntu
2025-08-04 03:00:11,011 - 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'}
2025-08-04 03:00:11,012 - DEBUG - Image build path file:///contrail-test/images/ubuntu.vmdk.gz
2025-08-04 03:00:11,012 - DEBUG - Download image from local file file:///contrail-test/images/ubuntu.vmdk.gz
2025-08-04 03:00:11,012 - DEBUG - Unzip image
2025-08-04 03:00:11,012 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/ubuntu.vmdk.gz
2025-08-04 03:00:11,041 - INFO - image /contrail-test/images/ubuntu.vmdk is not found
2025-08-04 03:00:11,042 - DEBUG - Detaching the Policy for VN :ctest-VN2-87496102
2025-08-04 03:00:11,042 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-08-04 03:00:11,058 - DEBUG - Requesting: http://10.0.0.27:8082/domain/8d00e278-1e00-4abc-a644-cc23d080d5d1
2025-08-04 03:00:11,079 - DEBUG - Requesting: http://10.0.0.27:8082/project/1b963df1-2ef1-4846-a65f-9fb6ffb46eac
2025-08-04 03:00:11,182 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/faee589f-b93a-4530-a77e-0ff2486c43de
2025-08-04 03:00:11,217 - DEBUG - Requesting: http://10.0.0.27:8082/network-policy/6bbcc61c-aa22-4f4c-ac48-dd8aa5149d83
2025-08-04 03:00:11,457 - DEBUG - Detached Policy:[['default-domain', 'ctest-TestPolicyAclIpv4v6-76147530', 'ctest-policy21-09022947']] from ctest-VN2-87496102
2025-08-04 03:00:11,457 - DEBUG - Detaching the Policy for VN :ctest-VN1-20253302
2025-08-04 03:00:11,457 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-08-04 03:00:11,473 - DEBUG - Requesting: http://10.0.0.27:8082/domain/8d00e278-1e00-4abc-a644-cc23d080d5d1
2025-08-04 03:00:11,496 - DEBUG - Requesting: http://10.0.0.27:8082/project/1b963df1-2ef1-4846-a65f-9fb6ffb46eac
2025-08-04 03:00:11,621 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/331be6e1-26d4-49f1-9714-294bbe99a364
2025-08-04 03:00:11,643 - DEBUG - Requesting: http://10.0.0.27:8082/network-policy/b8543414-08bd-4bc5-b9c0-7dab1f42afc9
2025-08-04 03:00:11,655 - DEBUG - Requesting: http://10.0.0.27:8082/network-policy/3822f24a-a91c-4643-be4a-e5d2aaa78201
2025-08-04 03:00:11,881 - DEBUG - Detached Policy:[['default-domain', 'ctest-TestPolicyAclIpv4v6-76147530', 'ctest-policy12-11486470'], ['default-domain', 'ctest-TestPolicyAclIpv4v6-76147530', 'ctest-policy13-13878098']] from ctest-VN1-20253302
2025-08-04 03:00:11,949 - INFO - Deleted policy ctest-policy21-09022947
2025-08-04 03:00:12,040 - INFO - Deleted policy ctest-policy12-11486470
2025-08-04 03:00:12,105 - INFO - Deleted policy ctest-policy13-13878098
2025-08-04 03:00:12,106 - INFO - Deleting VN ctest-VN3-22987411
2025-08-04 03:00:12,299 - DEBUG - Response for deleting network ()
2025-08-04 03:00:12,299 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/23927e59-30d8-4781-868c-58c6f05b787b
2025-08-04 03:00:12,310 - DEBUG - Response Code: 404
2025-08-04 03:00:12,311 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-08-04 03:00:12,323 - DEBUG - Requesting: http://10.0.0.27:8082/domain/8d00e278-1e00-4abc-a644-cc23d080d5d1
2025-08-04 03:00:12,338 - DEBUG - Requesting: http://10.0.0.27:8082/project/1b963df1-2ef1-4846-a65f-9fb6ffb46eac
2025-08-04 03:00:12,461 - INFO - Validated that VN ctest-VN3-22987411 is not found in API Server
2025-08-04 03:00:12,475 - DEBUG - VN ctest-VN3-22987411 is not present in Agent 10.0.0.41
2025-08-04 03:00:12,488 - DEBUG - VN ctest-VN3-22987411 is not present in Agent 10.0.0.57
2025-08-04 03:00:12,488 - INFO - Validated that VN ctest-VN3-22987411 is not in any agent
2025-08-04 03:00:12,525 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-VN3-22987411 info
2025-08-04 03:00:12,526 - INFO - Deleting VN ctest-VN2-87496102
2025-08-04 03:00:12,697 - DEBUG - Response for deleting network ()
2025-08-04 03:00:12,697 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/208355c4-33e6-451c-8edc-53a1fdde80b9
2025-08-04 03:00:12,708 - DEBUG - Response Code: 404
2025-08-04 03:00:12,708 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-08-04 03:00:12,720 - DEBUG - Requesting: http://10.0.0.27:8082/domain/8d00e278-1e00-4abc-a644-cc23d080d5d1
2025-08-04 03:00:12,735 - DEBUG - Requesting: http://10.0.0.27:8082/project/1b963df1-2ef1-4846-a65f-9fb6ffb46eac
2025-08-04 03:00:12,849 - INFO - Validated that VN ctest-VN2-87496102 is not found in API Server
2025-08-04 03:00:12,865 - DEBUG - VN ctest-VN2-87496102 is not present in Agent 10.0.0.41
2025-08-04 03:00:12,879 - DEBUG - VN ctest-VN2-87496102 is not present in Agent 10.0.0.57
2025-08-04 03:00:12,879 - INFO - Validated that VN ctest-VN2-87496102 is not in any agent
2025-08-04 03:00:12,930 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-VN2-87496102 info
2025-08-04 03:00:12,930 - INFO - Deleting VN ctest-VN1-20253302
2025-08-04 03:00:13,140 - DEBUG - Response for deleting network ()
2025-08-04 03:00:13,140 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/64a6af96-998f-4506-99d7-4e39b9c2d0e5
2025-08-04 03:00:13,155 - DEBUG - Response Code: 404
2025-08-04 03:00:13,155 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-08-04 03:00:13,163 - DEBUG - Requesting: http://10.0.0.27:8082/domain/8d00e278-1e00-4abc-a644-cc23d080d5d1
2025-08-04 03:00:13,177 - DEBUG - Requesting: http://10.0.0.27:8082/project/1b963df1-2ef1-4846-a65f-9fb6ffb46eac
2025-08-04 03:00:13,283 - INFO - Validated that VN ctest-VN1-20253302 is not found in API Server
2025-08-04 03:00:13,301 - DEBUG - VN ctest-VN1-20253302 is not present in Agent 10.0.0.41
2025-08-04 03:00:13,315 - DEBUG - VN ctest-VN1-20253302 is not present in Agent 10.0.0.57
2025-08-04 03:00:13,315 - INFO - Validated that VN ctest-VN1-20253302 is not in any agent
2025-08-04 03:00:13,367 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-VN1-20253302 info
2025-08-04 03:00:13,484 - INFO - IPAM: ipam3 is not found in API Server
2025-08-04 03:00:13,517 - INFO - IPAM:ipam3 is not found in control node
2025-08-04 03:00:13,672 - INFO - IPAM: ipam2 is not found in API Server
2025-08-04 03:00:13,700 - INFO - IPAM:ipam2 is not found in control node
2025-08-04 03:00:13,848 - INFO - IPAM: ipam1 is not found in API Server
2025-08-04 03:00:13,876 - INFO - IPAM:ipam1 is not found in control node
2025-08-04 03:00:15,170 - DEBUG - No XMPP flaps were noticed during the test
2025-08-04 03:00:15,170 - INFO -
2025-08-04 03:00:15,170 - INFO - END TEST : test_policy_inheritance_src_pol_dst_any : SKIPPED[0:00:14]
2025-08-04 03:00:15,170 - INFO - --------------------------------------------------------------------------------
2025-08-04 03:00:15,170 - INFO - image /contrail-test/images/ubuntu.vmdk is not found
2025-08-04 03:00:16,503 - DEBUG - No XMPP flaps were noticed during the test
2025-08-04 03:00:16,503 - INFO -
2025-08-04 03:00:16,503 - INFO - END TEST : test_policy_inheritance_src_pol_dst_any : SKIPPED[0:00:17]
2025-08-04 03:00:16,503 - INFO - --------------------------------------------------------------------------------
2025-08-04 03:00:17,346 - INFO - Deleted project: ctest-TestPolicyAclIpv4v6-76147530, ID : 1b963df1-2ef1-4846-a65f-9fb6ffb46eac