2025-09-18 01:32:16,071 - DEBUG - [10.0.0.38]: Running cmd : hostname 2025-09-18 01:32:16,333 - DEBUG - Output : cn-jenkins-deploy-platform-juju-k8s-1485-1 2025-09-18 01:32:16,333 - DEBUG - [10.0.0.38]: Running cmd : hostname -f 2025-09-18 01:32:16,367 - DEBUG - Output : cn-jenkins-deploy-platform-juju-k8s-1485-1 2025-09-18 01:32:16,367 - DEBUG - [10.0.0.38]: Running cmd : docker ps 2>/dev/null | grep -v "/pause\|/usr/bin/pod\|nova_api_\|contrail.*init\|init.*contrail\|provisioner\|placement" | awk '{print $NF}' 2025-09-18 01:32:16,457 - DEBUG - Output : NAMES contrail_test_9UchbyJgW contrail-kubernetes-master-kubemanager-1 analytics_snmp-topology-1 analytics_snmp-nodemgr-1 analytics_snmp-snmp-collector-1 analytics_alarm-kafka-1 analytics_alarm-nodemgr-1 analytics_alarm-alarm-gen-1 analytics-collector-1 analytics-api-1 analytics-nodemgr-1 analytics_database-cassandra-1 analytics_database-nodemgr-1 analytics_database-query-engine-1 redis-redis-1 webui-web-1 webui-job-1 control-named-1 control-nodemgr-1 control-control-1 control-dns-1 config_database-cassandra-1 config_database-zookeeper-1 config_database-nodemgr-1 config_database-rabbitmq-1 config_api-devicemgr-1 config_api-dnsmasq-1 config_api-svcmonitor-1 config_api-schema-1 config_api-api-1 config_api-nodemgr-1 2025-09-18 01:32:16,457 - DEBUG - [10.0.0.38]: Running cmd : ip -4 -o addr show | awk '{print $4}' 2025-09-18 01:32:16,490 - DEBUG - Output : 127.0.0.1/8 10.0.0.38/24 252.38.0.1/8 10.153.95.1/24 172.17.0.1/16 2025-09-18 01:32:16,491 - DEBUG - [10.0.0.38]: Running cmd : getent hosts 10.0.0.38 | head -n 1 | awk '{print $2}' 2025-09-18 01:32:16,563 - DEBUG - Output : cn-jenkins-deploy-platform-juju-k8s-1485-1 2025-09-18 01:32:16,609 - DEBUG - [10.0.0.33]: Running cmd : hostname 2025-09-18 01:32:16,853 - DEBUG - Output : an-jenkins-deploy-platform-juju-k8s-1485-1 2025-09-18 01:32:16,853 - DEBUG - [10.0.0.33]: Running cmd : hostname -f 2025-09-18 01:32:16,887 - DEBUG - Output : an-jenkins-deploy-platform-juju-k8s-1485-1 2025-09-18 01:32:16,887 - DEBUG - [10.0.0.33]: Running cmd : docker ps 2>/dev/null | grep -v "/pause\|/usr/bin/pod\|nova_api_\|contrail.*init\|init.*contrail\|provisioner\|placement" | awk '{print $NF}' 2025-09-18 01:32:16,978 - DEBUG - Output : NAMES vrouter-vrouter-agent-1 vrouter-nodemgr-1 2025-09-18 01:32:16,979 - DEBUG - [10.0.0.33]: Running cmd : ip -4 -o addr show dev vhost0 | awk '{print $4}' 2025-09-18 01:32:17,012 - DEBUG - Output : 10.0.0.33/24 2025-09-18 01:32:17,012 - DEBUG - [10.0.0.33]: Running cmd : getent hosts 10.0.0.33 | head -n 1 | awk '{print $2}' 2025-09-18 01:32:17,046 - DEBUG - Output : an-jenkins-deploy-platform-juju-k8s-1485-1 2025-09-18 01:32:17,133 - INFO - Using existing project ['default-domain', 'k8s-default'](b1077729-53d8-4175-8260-1cee95e834e8) 2025-09-18 01:32:17,215 - INFO - Using existing project ['default-domain', 'k8s-default'](b1077729-53d8-4175-8260-1cee95e834e8) 2025-09-18 01:32:17,331 - INFO - ================================================================================ 2025-09-18 01:32:17,331 - INFO - STARTING TEST : test_ingress_ip_assignment 2025-09-18 01:32:17,332 - INFO - TEST DESCRIPTION : Verify that Ingress gets a CLuster IP which is reachable to Pods in same namespace. Also verify that a Floating IP is assigned to the Ingress from the Public FIP poo. Steps: 1. Create a service with 2 pods running nginx 2. Create an ingress out of this service 3. From another Pod do a wget on the ingress Cluster ip Validate that Ingress get a IP from Public FIP pool which might/might not be accessible. Validate that service and its loadbalancing work 2025-09-18 01:32:17,532 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_AgentXmppConnectionStatusReq? 2025-09-18 01:32:17,538 - DEBUG - Nothing to compare xmpp stats {'10.0.0.33': {'10.0.0.38': '0'}} with 2025-09-18 01:32:17,538 - INFO - Initial checks done. Running the testcase now 2025-09-18 01:32:17,538 - INFO - 2025-09-18 01:32:17,542 - INFO - Namespace default already exists 2025-09-18 01:32:17,542 - DEBUG - [10.0.0.38]: Running cmd : docker exec --privileged -it contrail-kubernetes-master-kubemanager-1 /bin/bash -c 'grep "^[ ]*cluster_project" /etc/contrail/contrail-kubernetes.conf' 2025-09-18 01:32:17,649 - DEBUG - Output : cluster_project={} 2025-09-18 01:32:17,696 - INFO - Project default-domain:k8s-default for Namespace default is seen in contrail-api 2025-09-18 01:32:17,697 - DEBUG - Project uuid in Contrail is b1077729-53d8-4175-8260-1cee95e834e8 2025-09-18 01:32:17,697 - DEBUG - [10.0.0.38]: Running cmd : docker exec --privileged -it contrail-kubernetes-master-kubemanager-1 /bin/bash -c 'netstat -antp | grep :8108 | grep LISTEN' 2025-09-18 01:32:17,823 - DEBUG - Output : tcp 0 0 0.0.0.0:8108 0.0.0.0:* LISTEN 1/python3 2025-09-18 01:32:17,823 - DEBUG - Requesting: http://10.0.0.38:8108/Snh_NamespaceDatabaseList?namespace_uuid=f5580c1e-7732-4238-a18a-d9e3248347ef 2025-09-18 01:32:17,827 - INFO - Namespace default with uuid f5580c1e-7732-4238-a18a-d9e3248347ef found in kube manager 2025-09-18 01:32:17,827 - INFO - Namespace default verification passed 2025-09-18 01:32:17,830 - DEBUG - Service ctest-nginx-svc-04669308 not present 2025-09-18 01:32:17,831 - INFO - Creating service ctest-nginx-svc-04669308 2025-09-18 01:32:17,849 - INFO - Created Service ctest-nginx-svc-04669308 2025-09-18 01:32:17,853 - DEBUG - Pod ctest-nginx-pod-86775489 not present 2025-09-18 01:32:17,853 - INFO - Creating Pod ctest-nginx-pod-86775489 2025-09-18 01:32:17,929 - DEBUG - Pod : ctest-nginx-pod-86775489 UUID is 1aeef7e4-3402-4284-8116-a73bcdc448b2 2025-09-18 01:32:17,932 - DEBUG - Pod ctest-nginx-pod-10572874 not present 2025-09-18 01:32:17,932 - INFO - Creating Pod ctest-nginx-pod-10572874 2025-09-18 01:32:17,968 - DEBUG - Pod : ctest-nginx-pod-10572874 UUID is 783cab7e-435f-4edd-89af-dc7a8f839220 2025-09-18 01:32:18,164 - INFO - Created VN __public__, UUID :cb63db06-0404-468c-9f69-b2c9435af494 2025-09-18 01:32:18,405 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-09-18 01:32:18,410 - DEBUG - Requesting: http://10.0.0.38:8082/domain/431c9d82-6960-4020-a4d2-40941124ad48 2025-09-18 01:32:18,429 - DEBUG - Requesting: http://10.0.0.38:8082/project/b1077729-53d8-4175-8260-1cee95e834e8 2025-09-18 01:32:18,494 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/cb63db06-0404-468c-9f69-b2c9435af494 2025-09-18 01:32:18,511 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/cb63db06-0404-468c-9f69-b2c9435af494 2025-09-18 01:32:18,560 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/41091a42-2ae4-44cb-8d1f-235ed1174717 2025-09-18 01:32:18,577 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/41091a42-2ae4-44cb-8d1f-235ed1174717 2025-09-18 01:32:18,584 - DEBUG - Route Targets: [] 2025-09-18 01:32:18,584 - DEBUG - RT names not yet present for VN __public__ 2025-09-18 01:32:23,585 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-09-18 01:32:23,590 - DEBUG - Requesting: http://10.0.0.38:8082/domain/431c9d82-6960-4020-a4d2-40941124ad48 2025-09-18 01:32:23,597 - DEBUG - Requesting: http://10.0.0.38:8082/project/b1077729-53d8-4175-8260-1cee95e834e8 2025-09-18 01:32:23,644 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/cb63db06-0404-468c-9f69-b2c9435af494 2025-09-18 01:32:23,653 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/cb63db06-0404-468c-9f69-b2c9435af494 2025-09-18 01:32:23,661 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/41091a42-2ae4-44cb-8d1f-235ed1174717 2025-09-18 01:32:23,669 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/41091a42-2ae4-44cb-8d1f-235ed1174717 2025-09-18 01:32:23,674 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/4e4b467d-df6f-4d4a-a6dd-b942351cf72b 2025-09-18 01:32:23,679 - DEBUG - Route Targets: ['target:64512:8000006'] 2025-09-18 01:32:23,679 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/cb63db06-0404-468c-9f69-b2c9435af494 2025-09-18 01:32:23,687 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/41091a42-2ae4-44cb-8d1f-235ed1174717 2025-09-18 01:32:23,698 - INFO - Verified VN network id 13 for VN cb63db06-0404-468c-9f69-b2c9435af494 2025-09-18 01:32:23,698 - INFO - Verifications in API Server for VN __public__ passed 2025-09-18 01:32:23,698 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/cb63db06-0404-468c-9f69-b2c9435af494 2025-09-18 01:32:23,706 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/41091a42-2ae4-44cb-8d1f-235ed1174717 2025-09-18 01:32:23,714 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/41091a42-2ae4-44cb-8d1f-235ed1174717 2025-09-18 01:32:23,725 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/4e4b467d-df6f-4d4a-a6dd-b942351cf72b 2025-09-18 01:32:23,732 - DEBUG - Requesting: http://10.0.0.38:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:k8s-default:__public__ 2025-09-18 01:32:23,739 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:k8s-default:__public__', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'cloud-admin', 'owner-access': '7', 'group': 'cloud-admin-group', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '14655798431277401740', 'uuid-lslong': '11486908902073365652'}, 'enable': 'true', 'created': '2025-09-18T01:32:18', 'last-modified': '2025-09-18T01:32:18', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:05.390715'} 2025-09-18 01:32:23,739 - DEBUG - Requesting: http://10.0.0.38:8083/Snh_ShowRoutingInstanceReq?name=default-domain:k8s-default:__public__:__public__ 2025-09-18 01:32:23,746 - DEBUG - Route Targets: ['target:64512:8000006'] 2025-09-18 01:32:23,746 - INFO - On all control nodes, Config, RI and RT verification for VN __public__ passed 2025-09-18 01:32:23,747 - DEBUG - ====Verifying policy data for __public__ in API_Server ====== 2025-09-18 01:32:23,747 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-09-18 01:32:23,751 - DEBUG - Requesting: http://10.0.0.38:8082/domain/431c9d82-6960-4020-a4d2-40941124ad48 2025-09-18 01:32:23,757 - DEBUG - Requesting: http://10.0.0.38:8082/project/b1077729-53d8-4175-8260-1cee95e834e8 2025-09-18 01:32:23,794 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/cb63db06-0404-468c-9f69-b2c9435af494 2025-09-18 01:32:23,802 - DEBUG - =>VN __public__ has no policy to be verified 2025-09-18 01:32:23,802 - DEBUG - Verifying the vn in opserver 2025-09-18 01:32:23,802 - DEBUG - Verifying the default-domain:k8s-default:__public__ virtual network link through opserver 10.0.0.38 2025-09-18 01:32:23,802 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks 2025-09-18 01:32:23,807 - DEBUG - vn link and name as {'name': 'default-domain:k8s-default:__public__', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:k8s-default:__public__?flat'} 2025-09-18 01:32:23,807 - INFO - Validated that VN default-domain:k8s-default:__public__ is found in opserver 2025-09-18 01:32:23,807 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_VrfListReq?name=default-domain:k8s-default:__public__:__public__ 2025-09-18 01:32:23,814 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_VrfListReq?name=default-domain:k8s-default:__public__:__public__ 2025-09-18 01:32:23,819 - DEBUG - Do not have enough data to verify VN in agent 2025-09-18 01:32:23,819 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_VrfListReq?name=default-domain:k8s-default:__public__:__public__ 2025-09-18 01:32:23,823 - DEBUG - VRF ids for VN __public__: {} 2025-09-18 01:32:23,922 - INFO - Creating Floating IP pool __fip_pool_public__ in API Server 2025-09-18 01:32:24,021 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-09-18 01:32:24,026 - DEBUG - Requesting: http://10.0.0.38:8082/domain/431c9d82-6960-4020-a4d2-40941124ad48 2025-09-18 01:32:24,032 - DEBUG - Requesting: http://10.0.0.38:8082/project/b1077729-53d8-4175-8260-1cee95e834e8 2025-09-18 01:32:24,067 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/cb63db06-0404-468c-9f69-b2c9435af494 2025-09-18 01:32:24,076 - DEBUG - Requesting: http://10.0.0.38:8082/floating-ip-pool/08f49f44-3968-499d-b018-a225e1e757e9 2025-09-18 01:32:24,081 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-09-18 01:32:24,085 - DEBUG - Requesting: http://10.0.0.38:8082/domain/431c9d82-6960-4020-a4d2-40941124ad48 2025-09-18 01:32:24,092 - DEBUG - Requesting: http://10.0.0.38:8082/project/b1077729-53d8-4175-8260-1cee95e834e8 2025-09-18 01:32:24,131 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/cb63db06-0404-468c-9f69-b2c9435af494 2025-09-18 01:32:24,140 - DEBUG - FIP Pool __fip_pool_public__ found in API Server 2025-09-18 01:32:24,140 - INFO - Verification for FIP pool __fip_pool_public__ in API Server passed 2025-09-18 01:32:24,147 - DEBUG - Requesting: http://10.0.0.38:8083/Snh_IFMapTableShowReq?table_name=floating-ip-pool&search_string=floating-ip-pool:default-domain:k8s-default:__public__:__fip_pool_public__ 2025-09-18 01:32:24,152 - DEBUG - Control-node Ifmap-view has FIP pool __fip_pool_public__ information 2025-09-18 01:32:24,152 - INFO - Verification for FIP pool __fip_pool_public__ in Control-node passed 2025-09-18 01:32:24,155 - DEBUG - Ingress ctest-nginx-ingress-43092959 not present 2025-09-18 01:32:24,156 - INFO - Creating Ingress ctest-nginx-ingress-43092959 2025-09-18 01:32:24,173 - INFO - Created Ingress ctest-nginx-ingress-43092959 2025-09-18 01:32:24,176 - DEBUG - Cluster IP not yet seen for Ingress ctest-nginx-ingress-43092959 2025-09-18 01:32:27,181 - DEBUG - For Ingress ctest-nginx-ingress-43092959, Cluster IP: 10.47.255.249, External IPs ['135.50.165.60'] 2025-09-18 01:32:27,181 - INFO - Verifications in k8s passed for Ingress ctest-nginx-ingress-43092959 2025-09-18 01:32:27,181 - DEBUG - Requesting: http://10.0.0.38:8108/Snh_LoadbalancerDatabaseList?x=9d79d53f-6fd3-4d05-8dc4-f22a0d6c0ae5 2025-09-18 01:32:27,185 - INFO - Ingress ctest-nginx-ingress-43092959 with uuid 9d79d53f-6fd3-4d05-8dc4-f22a0d6c0ae5 found in kube manager 2025-09-18 01:32:27,185 - INFO - Ingress ctest-nginx-ingress-43092959 verification passed 2025-09-18 01:32:27,187 - DEBUG - Pod ctest-busybox-pod-69280126 not present 2025-09-18 01:32:27,188 - INFO - Creating Pod ctest-busybox-pod-69280126 2025-09-18 01:32:27,219 - DEBUG - Pod : ctest-busybox-pod-69280126 UUID is 948de2af-6633-439c-8f36-53a19f44a83f 2025-09-18 01:32:27,227 - DEBUG - Pod ctest-nginx-pod-86775489 not in running state.Currently in Pending 2025-09-18 01:32:32,243 - DEBUG - Pod ctest-nginx-pod-86775489 not in running state.Currently in Pending 2025-09-18 01:32:37,250 - INFO - Pod ctest-nginx-pod-86775489 is in running state.Got IP 10.47.255.251 2025-09-18 01:32:37,302 - DEBUG - Pod ctest-nginx-pod-86775489 has vmi 5133df36-942f-11f0-b2ed-fa163ecc747d 2025-09-18 01:32:37,303 - INFO - Verified pod ctest-nginx-pod-86775489 in contrail-api 2025-09-18 01:32:37,303 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2025-09-18 01:32:37,315 - DEBUG - VMI 5133df36-942f-11f0-b2ed-fa163ecc747d is active in agent 10.0.0.33 2025-09-18 01:32:37,315 - INFO - Verified Pod ctest-nginx-pod-86775489 in agent 10.0.0.33 2025-09-18 01:32:37,315 - DEBUG - Requesting: http://10.0.0.38:8108/Snh_VirtualMachineDatabaseList?x=1aeef7e4-3402-4284-8116-a73bcdc448b2 2025-09-18 01:32:37,319 - INFO - Pod ctest-nginx-pod-86775489 with uuid 1aeef7e4-3402-4284-8116-a73bcdc448b2 found in kube manager 2025-09-18 01:32:37,319 - INFO - Pod ctest-nginx-pod-86775489 verification passed 2025-09-18 01:32:37,379 - DEBUG - [Pod ctest-nginx-pod-86775489] Cmd: echo ctest-nginx-pod-86775489 > /usr/share/nginx/html/index.html, Output: 2025-09-18 01:32:37,386 - INFO - Pod ctest-nginx-pod-10572874 is in running state.Got IP 10.47.255.250 2025-09-18 01:32:37,398 - DEBUG - Pod ctest-nginx-pod-10572874 has vmi 51ac5a10-942f-11f0-b2ed-fa163ecc747d 2025-09-18 01:32:37,398 - INFO - Verified pod ctest-nginx-pod-10572874 in contrail-api 2025-09-18 01:32:37,398 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2025-09-18 01:32:37,408 - DEBUG - VMI 51ac5a10-942f-11f0-b2ed-fa163ecc747d is active in agent 10.0.0.33 2025-09-18 01:32:37,408 - INFO - Verified Pod ctest-nginx-pod-10572874 in agent 10.0.0.33 2025-09-18 01:32:37,408 - DEBUG - Requesting: http://10.0.0.38:8108/Snh_VirtualMachineDatabaseList?x=783cab7e-435f-4edd-89af-dc7a8f839220 2025-09-18 01:32:37,411 - INFO - Pod ctest-nginx-pod-10572874 with uuid 783cab7e-435f-4edd-89af-dc7a8f839220 found in kube manager 2025-09-18 01:32:37,411 - INFO - Pod ctest-nginx-pod-10572874 verification passed 2025-09-18 01:32:37,469 - DEBUG - [Pod ctest-nginx-pod-10572874] Cmd: echo ctest-nginx-pod-10572874 > /usr/share/nginx/html/index.html, Output: 2025-09-18 01:32:37,477 - DEBUG - Pod ctest-busybox-pod-69280126 not in running state.Currently in Pending 2025-09-18 01:32:42,484 - INFO - Pod ctest-busybox-pod-69280126 is in running state.Got IP 10.47.255.248 2025-09-18 01:32:42,496 - DEBUG - Pod ctest-busybox-pod-69280126 has vmi 560d5f00-942f-11f0-b2ed-fa163ecc747d 2025-09-18 01:32:42,496 - INFO - Verified pod ctest-busybox-pod-69280126 in contrail-api 2025-09-18 01:32:42,496 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2025-09-18 01:32:42,506 - DEBUG - VMI 560d5f00-942f-11f0-b2ed-fa163ecc747d is active in agent 10.0.0.33 2025-09-18 01:32:42,506 - INFO - Verified Pod ctest-busybox-pod-69280126 in agent 10.0.0.33 2025-09-18 01:32:42,506 - DEBUG - Requesting: http://10.0.0.38:8108/Snh_VirtualMachineDatabaseList?x=948de2af-6633-439c-8f36-53a19f44a83f 2025-09-18 01:32:42,510 - INFO - Pod ctest-busybox-pod-69280126 with uuid 948de2af-6633-439c-8f36-53a19f44a83f found in kube manager 2025-09-18 01:32:42,510 - INFO - Pod ctest-busybox-pod-69280126 verification passed 2025-09-18 01:32:42,572 - DEBUG - [Pod ctest-busybox-pod-69280126] Cmd: wget http://10.47.255.249:80/ -O - -T 5 -t 1 , Output: ctest-nginx-pod-86775489 Connecting to 10.47.255.249:80 (10.47.255.249:80) writing to stdout - 100% |********************************| 25 0:00:00 ETA written to stdout 2025-09-18 01:32:42,572 - DEBUG - [Pod Pod ctest-busybox-pod-69280126] Cmd wget http://10.47.255.249:80/ -O - -T 5 -t 1 passed 2025-09-18 01:32:42,572 - DEBUG - [Pod Pod ctest-busybox-pod-69280126] Cmd output: ctest-nginx-pod-86775489 Connecting to 10.47.255.249:80 (10.47.255.249:80) writing to stdout - 100% |********************************| 25 0:00:00 ETA written to stdout 2025-09-18 01:32:42,627 - DEBUG - [Pod ctest-busybox-pod-69280126] Cmd: wget http://10.47.255.249:80/ -O - -T 5 -t 1 , Output: ctest-nginx-pod-10572874 Connecting to 10.47.255.249:80 (10.47.255.249:80) writing to stdout - 100% |********************************| 25 0:00:00 ETA written to stdout 2025-09-18 01:32:42,627 - DEBUG - [Pod Pod ctest-busybox-pod-69280126] Cmd wget http://10.47.255.249:80/ -O - -T 5 -t 1 passed 2025-09-18 01:32:42,627 - DEBUG - [Pod Pod ctest-busybox-pod-69280126] Cmd output: ctest-nginx-pod-10572874 Connecting to 10.47.255.249:80 (10.47.255.249:80) writing to stdout - 100% |********************************| 25 0:00:00 ETA written to stdout 2025-09-18 01:32:42,627 - INFO - Responses seen from all pods, lb seems fine.Hits : {'ctest-nginx-pod-86775489': 1, 'ctest-nginx-pod-10572874': 1} 2025-09-18 01:32:42,628 - WARNING - Nothing to delete parallely 2025-09-18 01:32:42,628 - INFO - Deleting pod default:ctest-busybox-pod-69280126 2025-09-18 01:32:42,637 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_VmListReq?uuid=948de2af-6633-439c-8f36-53a19f44a83f 2025-09-18 01:32:42,644 - WARNING - Pod uuid 948de2af-6633-439c-8f36-53a19f44a83f is still seen in agent 10.0.0.33 VM list 2025-09-18 01:32:47,644 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_VmListReq?uuid=948de2af-6633-439c-8f36-53a19f44a83f 2025-09-18 01:32:47,652 - WARNING - Pod uuid 948de2af-6633-439c-8f36-53a19f44a83f is still seen in agent 10.0.0.33 VM list 2025-09-18 01:32:52,653 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_VmListReq?uuid=948de2af-6633-439c-8f36-53a19f44a83f 2025-09-18 01:32:52,659 - WARNING - Pod uuid 948de2af-6633-439c-8f36-53a19f44a83f is still seen in agent 10.0.0.33 VM list 2025-09-18 01:32:57,660 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_VmListReq?uuid=948de2af-6633-439c-8f36-53a19f44a83f 2025-09-18 01:32:57,665 - WARNING - Pod uuid 948de2af-6633-439c-8f36-53a19f44a83f is still seen in agent 10.0.0.33 VM list 2025-09-18 01:33:02,666 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_VmListReq?uuid=948de2af-6633-439c-8f36-53a19f44a83f 2025-09-18 01:33:02,673 - WARNING - Pod uuid 948de2af-6633-439c-8f36-53a19f44a83f is still seen in agent 10.0.0.33 VM list 2025-09-18 01:33:07,673 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_VmListReq?uuid=948de2af-6633-439c-8f36-53a19f44a83f 2025-09-18 01:33:07,681 - WARNING - Pod uuid 948de2af-6633-439c-8f36-53a19f44a83f is still seen in agent 10.0.0.33 VM list 2025-09-18 01:33:12,681 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_VmListReq?uuid=948de2af-6633-439c-8f36-53a19f44a83f 2025-09-18 01:33:12,689 - WARNING - Pod uuid 948de2af-6633-439c-8f36-53a19f44a83f is still seen in agent 10.0.0.33 VM list 2025-09-18 01:33:17,689 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_VmListReq?uuid=948de2af-6633-439c-8f36-53a19f44a83f 2025-09-18 01:33:17,696 - DEBUG - Pod 948de2af-6633-439c-8f36-53a19f44a83f is not in agent 10.0.0.33 VM list 2025-09-18 01:33:17,696 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:560d5f00-942f-11f0-b2ed-fa163ecc747d 2025-09-18 01:33:17,702 - DEBUG - VMI 560d5f00-942f-11f0-b2ed-fa163ecc747d is removed from agent 10.0.0.33 2025-09-18 01:33:17,702 - INFO - Verified that pod ctest-busybox-pod-69280126 is removed in agent 2025-09-18 01:33:17,702 - INFO - Deleting Ingress : ctest-nginx-ingress-43092959 2025-09-18 01:33:17,717 - DEBUG - Requesting: http://10.0.0.38:8108/Snh_LoadbalancerDatabaseList?x=9d79d53f-6fd3-4d05-8dc4-f22a0d6c0ae5 2025-09-18 01:33:17,722 - ERROR - Ingress ctest-nginx-ingress-43092959 with uuid 9d79d53f-6fd3-4d05-8dc4-f22a0d6c0ae5 still found in kube manager 2025-09-18 01:33:18,723 - DEBUG - Requesting: http://10.0.0.38:8108/Snh_LoadbalancerDatabaseList?x=9d79d53f-6fd3-4d05-8dc4-f22a0d6c0ae5 2025-09-18 01:33:18,727 - INFO - Ingress ctest-nginx-ingress-43092959 with uuid 9d79d53f-6fd3-4d05-8dc4-f22a0d6c0ae5 deleted successfully from kube manager 2025-09-18 01:33:18,727 - INFO - Verifications on Ingress %s cleanup passed 2025-09-18 01:33:18,727 - INFO - Deleting the FIP pool __fip_pool_public__ 2025-09-18 01:33:18,853 - DEBUG - Requesting: http://10.0.0.38:8083/Snh_IFMapTableShowReq?table_name=floating-ip-pool&search_string=floating-ip-pool:default-domain:k8s-default:__public__:__fip_pool_public__ 2025-09-18 01:33:18,858 - DEBUG - Control-node Ifmap-view does not have FIP pool __fip_pool_public__ information 2025-09-18 01:33:18,859 - INFO - Deleting VN __public__ 2025-09-18 01:33:18,999 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/41091a42-2ae4-44cb-8d1f-235ed1174717 2025-09-18 01:33:19,012 - DEBUG - Response Code: 404 2025-09-18 01:33:19,012 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-09-18 01:33:19,016 - DEBUG - Requesting: http://10.0.0.38:8082/domain/431c9d82-6960-4020-a4d2-40941124ad48 2025-09-18 01:33:19,023 - DEBUG - Requesting: http://10.0.0.38:8082/project/b1077729-53d8-4175-8260-1cee95e834e8 2025-09-18 01:33:19,064 - INFO - Validated that VN __public__ is not found in API Server 2025-09-18 01:33:19,065 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_VnListReq?name=default-domain:k8s-default:__public__ 2025-09-18 01:33:19,071 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_VrfListReq?name=default-domain:k8s-default:__public__:__public__ 2025-09-18 01:33:19,079 - DEBUG - VN __public__ is not present in Agent 10.0.0.33 2025-09-18 01:33:19,079 - INFO - Validated that VN __public__ is not in any agent 2025-09-18 01:33:19,080 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_VrfListReq?name=default-domain:k8s-default:__public__:__public__ 2025-09-18 01:33:19,093 - DEBUG - Requesting: http://10.0.0.38:8083/Snh_ShowRoutingInstanceReq?name=default-domain:k8s-default:__public__:__public__ 2025-09-18 01:33:19,099 - DEBUG - Requesting: http://10.0.0.38:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:k8s-default:__public__ 2025-09-18 01:33:19,103 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN __public__ info 2025-09-18 01:33:19,104 - INFO - Deleting pod default:ctest-nginx-pod-10572874 2025-09-18 01:33:19,132 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_VmListReq?uuid=783cab7e-435f-4edd-89af-dc7a8f839220 2025-09-18 01:33:19,155 - WARNING - Pod uuid 783cab7e-435f-4edd-89af-dc7a8f839220 is still seen in agent 10.0.0.33 VM list 2025-09-18 01:33:24,156 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_VmListReq?uuid=783cab7e-435f-4edd-89af-dc7a8f839220 2025-09-18 01:33:24,163 - DEBUG - Pod 783cab7e-435f-4edd-89af-dc7a8f839220 is not in agent 10.0.0.33 VM list 2025-09-18 01:33:24,163 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:51ac5a10-942f-11f0-b2ed-fa163ecc747d 2025-09-18 01:33:24,169 - DEBUG - VMI 51ac5a10-942f-11f0-b2ed-fa163ecc747d is removed from agent 10.0.0.33 2025-09-18 01:33:24,169 - INFO - Verified that pod ctest-nginx-pod-10572874 is removed in agent 2025-09-18 01:33:24,169 - INFO - Deleting pod default:ctest-nginx-pod-86775489 2025-09-18 01:33:24,184 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_VmListReq?uuid=1aeef7e4-3402-4284-8116-a73bcdc448b2 2025-09-18 01:33:24,205 - WARNING - Pod uuid 1aeef7e4-3402-4284-8116-a73bcdc448b2 is still seen in agent 10.0.0.33 VM list 2025-09-18 01:33:29,206 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_VmListReq?uuid=1aeef7e4-3402-4284-8116-a73bcdc448b2 2025-09-18 01:33:29,212 - DEBUG - Pod 1aeef7e4-3402-4284-8116-a73bcdc448b2 is not in agent 10.0.0.33 VM list 2025-09-18 01:33:29,212 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:5133df36-942f-11f0-b2ed-fa163ecc747d 2025-09-18 01:33:29,217 - DEBUG - VMI 5133df36-942f-11f0-b2ed-fa163ecc747d is removed from agent 10.0.0.33 2025-09-18 01:33:29,217 - INFO - Verified that pod ctest-nginx-pod-86775489 is removed in agent 2025-09-18 01:33:29,217 - INFO - Deleting service : ctest-nginx-svc-04669308 2025-09-18 01:33:29,435 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_AgentXmppConnectionStatusReq? 2025-09-18 01:33:29,440 - DEBUG - No XMPP flaps were noticed during the test
2025-09-18 01:33:29,441 - INFO - END TEST : test_ingress_ip_assignment : PASSED[0:01:12]
2025-09-18 01:33:29,441 - INFO - -------------------------------------------------------------------------------- 2025-09-18 01:33:35,859 - DEBUG - [10.0.0.38]: Running cmd : docker exec --privileged -it contrail-kubernetes-master-kubemanager-1 /bin/bash -c 'grep "^[ ]*cluster_project" /etc/contrail/contrail-kubernetes.conf' 2025-09-18 01:33:35,967 - DEBUG - Output : cluster_project={} 2025-09-18 01:33:36,055 - DEBUG - [10.0.0.38]: Running cmd : docker exec --privileged -it contrail-kubernetes-master-kubemanager-1 /bin/bash -c 'netstat -antp | grep :8108 | grep LISTEN' 2025-09-18 01:33:36,219 - DEBUG - Output : tcp 0 0 0.0.0.0:8108 0.0.0.0:* LISTEN 1/python3 2025-09-18 01:33:36,235 - DEBUG - [10.0.0.38]: Running cmd : docker exec --privileged -it contrail-kubernetes-master-kubemanager-1 /bin/bash -c 'grep "^[ ]*cluster_project" /etc/contrail/contrail-kubernetes.conf' 2025-09-18 01:33:36,359 - DEBUG - Output : cluster_project={} 2025-09-18 01:33:46,503 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2025-09-18 01:33:51,542 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2025-09-18 01:33:51,615 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2025-09-18 01:33:51,655 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2025-09-18 01:33:51,729 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2025-09-18 01:33:51,765 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2025-09-18 01:33:51,845 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2025-09-18 01:33:51,923 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2025-09-18 01:33:52,180 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_AgentXmppConnectionStatusReq? 2025-09-18 01:48:10,304 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_AgentXmppConnectionStatusReq? 2025-09-18 01:48:10,348 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_VmListReq?uuid=126afc7e-d732-4ac3-85d2-517b33243782 2025-09-18 01:48:10,364 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_VmListReq?uuid=41172ff3-5e56-4b4a-ba38-514c0bd7f7b8 2025-09-18 01:48:10,372 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_VmListReq?uuid=0ab00726-b1ca-4095-9999-47ee67d03ac5 2025-09-18 01:48:10,379 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_VmListReq?uuid=51531f42-101b-40a1-8a04-bc985b38e71e 2025-09-18 01:48:10,387 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_VmListReq?uuid=180d3220-b2ec-493b-ad02-03ff6cbfe902 2025-09-18 01:48:10,391 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_VmListReq?uuid=28841eb0-aa8d-45dc-9128-4472964ecee2 2025-09-18 01:48:10,398 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_VmListReq?uuid=9cfe40a4-12dc-4980-88f8-cac123326739 2025-09-18 01:48:10,403 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_VmListReq?uuid=2efab2ad-83d4-4574-b822-4955a8f70093 2025-09-18 01:48:15,451 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_VmListReq?uuid=126afc7e-d732-4ac3-85d2-517b33243782 2025-09-18 01:48:15,452 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_VmListReq?uuid=0ab00726-b1ca-4095-9999-47ee67d03ac5 2025-09-18 01:48:15,453 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_VmListReq?uuid=9cfe40a4-12dc-4980-88f8-cac123326739 2025-09-18 01:48:15,454 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_VmListReq?uuid=2efab2ad-83d4-4574-b822-4955a8f70093 2025-09-18 01:48:15,456 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_VmListReq?uuid=51531f42-101b-40a1-8a04-bc985b38e71e 2025-09-18 01:48:15,457 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_VmListReq?uuid=41172ff3-5e56-4b4a-ba38-514c0bd7f7b8 2025-09-18 01:48:15,457 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_VmListReq?uuid=28841eb0-aa8d-45dc-9128-4472964ecee2 2025-09-18 01:48:15,458 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_VmListReq?uuid=180d3220-b2ec-493b-ad02-03ff6cbfe902 2025-09-18 01:48:15,476 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:80efb8c6-942f-11f0-b2ed-fa163ecc747d 2025-09-18 01:48:15,479 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:7fffde82-942f-11f0-b2ed-fa163ecc747d 2025-09-18 01:48:15,480 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:7f846234-942f-11f0-b2ed-fa163ecc747d 2025-09-18 01:48:15,481 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:808727de-942f-11f0-b2ed-fa163ecc747d 2025-09-18 01:48:20,479 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_VmListReq?uuid=180d3220-b2ec-493b-ad02-03ff6cbfe902 2025-09-18 01:48:20,481 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_VmListReq?uuid=0ab00726-b1ca-4095-9999-47ee67d03ac5 2025-09-18 01:48:20,482 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_VmListReq?uuid=51531f42-101b-40a1-8a04-bc985b38e71e 2025-09-18 01:48:20,483 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_VmListReq?uuid=28841eb0-aa8d-45dc-9128-4472964ecee2 2025-09-18 01:48:25,494 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_VmListReq?uuid=0ab00726-b1ca-4095-9999-47ee67d03ac5 2025-09-18 01:48:25,495 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_VmListReq?uuid=180d3220-b2ec-493b-ad02-03ff6cbfe902 2025-09-18 01:48:25,496 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_VmListReq?uuid=51531f42-101b-40a1-8a04-bc985b38e71e 2025-09-18 01:48:25,497 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_VmListReq?uuid=28841eb0-aa8d-45dc-9128-4472964ecee2 2025-09-18 01:48:30,515 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_VmListReq?uuid=51531f42-101b-40a1-8a04-bc985b38e71e 2025-09-18 01:48:30,516 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_VmListReq?uuid=180d3220-b2ec-493b-ad02-03ff6cbfe902 2025-09-18 01:48:30,518 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_VmListReq?uuid=0ab00726-b1ca-4095-9999-47ee67d03ac5 2025-09-18 01:48:30,519 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_VmListReq?uuid=28841eb0-aa8d-45dc-9128-4472964ecee2 2025-09-18 01:48:35,532 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_VmListReq?uuid=51531f42-101b-40a1-8a04-bc985b38e71e 2025-09-18 01:48:35,534 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_VmListReq?uuid=28841eb0-aa8d-45dc-9128-4472964ecee2 2025-09-18 01:48:35,535 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_VmListReq?uuid=0ab00726-b1ca-4095-9999-47ee67d03ac5 2025-09-18 01:48:35,537 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_VmListReq?uuid=180d3220-b2ec-493b-ad02-03ff6cbfe902 2025-09-18 01:48:40,551 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_VmListReq?uuid=51531f42-101b-40a1-8a04-bc985b38e71e 2025-09-18 01:48:40,552 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_VmListReq?uuid=180d3220-b2ec-493b-ad02-03ff6cbfe902 2025-09-18 01:48:40,553 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_VmListReq?uuid=28841eb0-aa8d-45dc-9128-4472964ecee2 2025-09-18 01:48:40,555 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_VmListReq?uuid=0ab00726-b1ca-4095-9999-47ee67d03ac5 2025-09-18 01:48:45,637 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_VmListReq?uuid=180d3220-b2ec-493b-ad02-03ff6cbfe902 2025-09-18 01:48:45,639 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_VmListReq?uuid=28841eb0-aa8d-45dc-9128-4472964ecee2 2025-09-18 01:48:45,640 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_VmListReq?uuid=0ab00726-b1ca-4095-9999-47ee67d03ac5 2025-09-18 01:48:45,641 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_VmListReq?uuid=51531f42-101b-40a1-8a04-bc985b38e71e 2025-09-18 01:48:45,652 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:82ac566a-942f-11f0-b2ed-fa163ecc747d 2025-09-18 01:48:45,655 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:81d8e0aa-942f-11f0-b2ed-fa163ecc747d 2025-09-18 01:48:45,656 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:81700134-942f-11f0-b2ed-fa163ecc747d 2025-09-18 01:48:45,657 - DEBUG - Requesting: http://10.0.0.33:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:823ba0b4-942f-11f0-b2ed-fa163ecc747d