2026-06-18 01:45:30,667 - DEBUG - [10.0.0.22]: Running cmd : hostname 2026-06-18 01:45:30,919 - DEBUG - Output : cn-jenkins-deploy-platform-juju-k8s-2025-1 2026-06-18 01:45:30,920 - DEBUG - [10.0.0.22]: Running cmd : hostname -f 2026-06-18 01:45:30,955 - DEBUG - Output : cn-jenkins-deploy-platform-juju-k8s-2025-1 2026-06-18 01:45:30,955 - DEBUG - [10.0.0.22]: Running cmd : docker ps 2>/dev/null | grep -v "/pause\|/usr/bin/pod\|nova_api_\|contrail.*init\|init.*contrail\|provisioner\|placement" | awk '{print $NF}' 2026-06-18 01:45:31,068 - DEBUG - Output : NAMES contrail_test_6MqsE8fY9 contrail-kubernetes-master-kubemanager-1 analytics_snmp-snmp-collector-1 analytics_snmp-topology-1 analytics_snmp-nodemgr-1 analytics_alarm-nodemgr-1 analytics_alarm-kafka-1 analytics_alarm-alarm-gen-1 analytics-collector-1 analytics-api-1 analytics-nodemgr-1 analytics_database-query-engine-1 analytics_database-nodemgr-1 analytics_database-cassandra-1 redis-redis-1 webui-web-1 webui-job-1 control-named-1 control-nodemgr-1 control-control-1 control-dns-1 config_database-zookeeper-1 config_database-nodemgr-1 config_database-rabbitmq-1 config_database-cassandra-1 config_api-devicemgr-1 config_api-api-1 config_api-svcmonitor-1 config_api-schema-1 config_api-dnsmasq-1 config_api-nodemgr-1 2026-06-18 01:45:31,069 - DEBUG - [10.0.0.22]: Running cmd : ip -4 -o addr show | awk '{print $4}' 2026-06-18 01:45:31,102 - DEBUG - Output : 127.0.0.1/8 10.0.0.22/24 252.22.0.1/8 10.153.194.1/24 172.17.0.1/16 2026-06-18 01:45:31,103 - DEBUG - [10.0.0.22]: Running cmd : getent hosts 10.0.0.22 | head -n 1 | awk '{print $2}' 2026-06-18 01:45:31,136 - DEBUG - Output : cn-jenkins-deploy-platform-juju-k8s-2025-1 2026-06-18 01:45:31,231 - DEBUG - [10.0.0.242]: Running cmd : hostname 2026-06-18 01:45:31,484 - DEBUG - Output : an-jenkins-deploy-platform-juju-k8s-2025-1 2026-06-18 01:45:31,484 - DEBUG - [10.0.0.242]: Running cmd : hostname -f 2026-06-18 01:45:31,518 - DEBUG - Output : an-jenkins-deploy-platform-juju-k8s-2025-1 2026-06-18 01:45:31,518 - DEBUG - [10.0.0.242]: Running cmd : docker ps 2>/dev/null | grep -v "/pause\|/usr/bin/pod\|nova_api_\|contrail.*init\|init.*contrail\|provisioner\|placement" | awk '{print $NF}' 2026-06-18 01:45:31,563 - DEBUG - Output : NAMES vrouter-vrouter-agent-1 vrouter-nodemgr-1 2026-06-18 01:45:31,563 - DEBUG - [10.0.0.242]: Running cmd : ip -4 -o addr show dev vhost0 | awk '{print $4}' 2026-06-18 01:45:31,597 - DEBUG - Output : 10.0.0.242/24 2026-06-18 01:45:31,597 - DEBUG - [10.0.0.242]: Running cmd : getent hosts 10.0.0.242 | head -n 1 | awk '{print $2}' 2026-06-18 01:45:31,664 - DEBUG - Output : an-jenkins-deploy-platform-juju-k8s-2025-1 2026-06-18 01:45:31,739 - INFO - Using existing project ['default-domain', 'k8s-default'](7a4c14ab-6c01-4c59-981d-35d4170868d5) 2026-06-18 01:45:31,854 - INFO - Using existing project ['default-domain', 'k8s-default'](7a4c14ab-6c01-4c59-981d-35d4170868d5) 2026-06-18 01:45:31,968 - INFO - ================================================================================ 2026-06-18 01:45:31,968 - INFO - STARTING TEST : test_ingress_ip_assignment 2026-06-18 01:45:31,969 - 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 2026-06-18 01:45:32,233 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_AgentXmppConnectionStatusReq? 2026-06-18 01:45:32,243 - DEBUG - Nothing to compare xmpp stats {'10.0.0.242': {'10.0.0.22': '0'}} with 2026-06-18 01:45:32,243 - INFO - Initial checks done. Running the testcase now 2026-06-18 01:45:32,243 - INFO - 2026-06-18 01:45:32,247 - INFO - Namespace default already exists 2026-06-18 01:45:32,247 - DEBUG - [10.0.0.22]: Running cmd : docker exec --privileged -it contrail-kubernetes-master-kubemanager-1 /bin/bash -c 'grep "^[ ]*cluster_project" /etc/contrail/contrail-kubernetes.conf' 2026-06-18 01:45:32,385 - DEBUG - Output : cluster_project={} 2026-06-18 01:45:32,423 - INFO - Project default-domain:k8s-default for Namespace default is seen in contrail-api 2026-06-18 01:45:32,423 - DEBUG - Project uuid in Contrail is 7a4c14ab-6c01-4c59-981d-35d4170868d5 2026-06-18 01:45:32,423 - DEBUG - [10.0.0.22]: Running cmd : docker exec --privileged -it contrail-kubernetes-master-kubemanager-1 /bin/bash -c 'netstat -antp | grep :8108 | grep LISTEN' 2026-06-18 01:45:32,556 - DEBUG - Output : tcp 0 0 0.0.0.0:8108 0.0.0.0:* LISTEN 1/python3 2026-06-18 01:45:32,556 - DEBUG - Requesting: http://10.0.0.22:8108/Snh_NamespaceDatabaseList?namespace_uuid=9b68748e-b97a-4886-bdfd-33d80dbf9b9f 2026-06-18 01:45:32,559 - INFO - Namespace default with uuid 9b68748e-b97a-4886-bdfd-33d80dbf9b9f found in kube manager 2026-06-18 01:45:32,560 - INFO - Namespace default verification passed 2026-06-18 01:45:32,566 - DEBUG - Service ctest-nginx-svc-25194168 not present 2026-06-18 01:45:32,567 - INFO - Creating service ctest-nginx-svc-25194168 2026-06-18 01:45:32,590 - INFO - Created Service ctest-nginx-svc-25194168 2026-06-18 01:45:32,594 - DEBUG - Pod ctest-nginx-pod-63673523 not present 2026-06-18 01:45:32,595 - INFO - Creating Pod ctest-nginx-pod-63673523 2026-06-18 01:45:32,661 - DEBUG - Node for Pod ctest-nginx-pod-63673523 not yet populated 2026-06-18 01:45:35,668 - DEBUG - Pod : ctest-nginx-pod-63673523 UUID is 5d9fb591-50d6-4153-9a41-39b921c50f78 2026-06-18 01:45:35,670 - DEBUG - Pod ctest-nginx-pod-04559345 not present 2026-06-18 01:45:35,671 - INFO - Creating Pod ctest-nginx-pod-04559345 2026-06-18 01:45:35,698 - DEBUG - Pod : ctest-nginx-pod-04559345 UUID is 879e5ecc-4ebd-4be3-83d0-fd4b401534b0 2026-06-18 01:45:35,919 - INFO - Created VN __public__, UUID :efb11b63-c680-4d29-8e98-7a2002f8d642 2026-06-18 01:45:36,135 - DEBUG - Requesting: http://10.0.0.22:8082/domains 2026-06-18 01:45:36,139 - DEBUG - Requesting: http://10.0.0.22:8082/domain/1805582d-50c7-43c5-b69e-a7507255475c 2026-06-18 01:45:36,151 - DEBUG - Requesting: http://10.0.0.22:8082/project/7a4c14ab-6c01-4c59-981d-35d4170868d5 2026-06-18 01:45:36,192 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/efb11b63-c680-4d29-8e98-7a2002f8d642 2026-06-18 01:45:36,202 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/efb11b63-c680-4d29-8e98-7a2002f8d642 2026-06-18 01:45:36,214 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/03e4d89d-aeb5-492d-9128-9803bf2a4901 2026-06-18 01:45:36,227 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/03e4d89d-aeb5-492d-9128-9803bf2a4901 2026-06-18 01:45:36,238 - DEBUG - Requesting: http://10.0.0.22:8082/route-target/9280060d-f34f-4622-9bdf-aa84806a72fd 2026-06-18 01:45:36,243 - DEBUG - Route Targets: ['target:64512:8000006'] 2026-06-18 01:45:36,243 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/efb11b63-c680-4d29-8e98-7a2002f8d642 2026-06-18 01:45:36,267 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/03e4d89d-aeb5-492d-9128-9803bf2a4901 2026-06-18 01:45:36,283 - INFO - Verified VN network id 13 for VN efb11b63-c680-4d29-8e98-7a2002f8d642 2026-06-18 01:45:36,283 - INFO - Verifications in API Server for VN __public__ passed 2026-06-18 01:45:36,283 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/efb11b63-c680-4d29-8e98-7a2002f8d642 2026-06-18 01:45:36,291 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/03e4d89d-aeb5-492d-9128-9803bf2a4901 2026-06-18 01:45:36,296 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/03e4d89d-aeb5-492d-9128-9803bf2a4901 2026-06-18 01:45:36,301 - DEBUG - Requesting: http://10.0.0.22:8082/route-target/9280060d-f34f-4622-9bdf-aa84806a72fd 2026-06-18 01:45:36,306 - DEBUG - Requesting: http://10.0.0.22:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:k8s-default:__public__ 2026-06-18 01:45:36,312 - DEBUG - Control-node 10.0.0.22 : 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': '17271616161288572201', 'uuid-lslong': '10275096827753190978'}, 'enable': 'true', 'created': '2026-06-18T01:45:35', 'last-modified': '2026-06-18T01:45:36', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.236822'} 2026-06-18 01:45:36,313 - DEBUG - Requesting: http://10.0.0.22:8083/Snh_ShowRoutingInstanceReq?name=default-domain:k8s-default:__public__:__public__ 2026-06-18 01:45:36,325 - DEBUG - Route Targets: ['target:64512:8000006'] 2026-06-18 01:45:36,325 - INFO - On all control nodes, Config, RI and RT verification for VN __public__ passed 2026-06-18 01:45:36,326 - DEBUG - ====Verifying policy data for __public__ in API_Server ====== 2026-06-18 01:45:36,327 - DEBUG - Requesting: http://10.0.0.22:8082/domains 2026-06-18 01:45:36,332 - DEBUG - Requesting: http://10.0.0.22:8082/domain/1805582d-50c7-43c5-b69e-a7507255475c 2026-06-18 01:45:36,338 - DEBUG - Requesting: http://10.0.0.22:8082/project/7a4c14ab-6c01-4c59-981d-35d4170868d5 2026-06-18 01:45:36,385 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/efb11b63-c680-4d29-8e98-7a2002f8d642 2026-06-18 01:45:36,392 - DEBUG - =>VN __public__ has no policy to be verified 2026-06-18 01:45:36,392 - DEBUG - Verifying the vn in opserver 2026-06-18 01:45:36,392 - DEBUG - Verifying the default-domain:k8s-default:__public__ virtual network link through opserver 10.0.0.22 2026-06-18 01:45:36,392 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks 2026-06-18 01:45:36,396 - DEBUG - vn link and name as {'name': 'default-domain:k8s-default:__public__', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:k8s-default:__public__?flat'} 2026-06-18 01:45:36,396 - INFO - Validated that VN default-domain:k8s-default:__public__ is found in opserver 2026-06-18 01:45:36,396 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:k8s-default:__public__:__public__ 2026-06-18 01:45:36,402 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:k8s-default:__public__:__public__ 2026-06-18 01:45:36,407 - DEBUG - Do not have enough data to verify VN in agent 2026-06-18 01:45:36,407 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:k8s-default:__public__:__public__ 2026-06-18 01:45:36,412 - DEBUG - VRF ids for VN __public__: {} 2026-06-18 01:45:36,527 - INFO - Creating Floating IP pool __fip_pool_public__ in API Server 2026-06-18 01:45:36,669 - DEBUG - Requesting: http://10.0.0.22:8082/domains 2026-06-18 01:45:36,674 - DEBUG - Requesting: http://10.0.0.22:8082/domain/1805582d-50c7-43c5-b69e-a7507255475c 2026-06-18 01:45:36,680 - DEBUG - Requesting: http://10.0.0.22:8082/project/7a4c14ab-6c01-4c59-981d-35d4170868d5 2026-06-18 01:45:36,722 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/efb11b63-c680-4d29-8e98-7a2002f8d642 2026-06-18 01:45:36,731 - DEBUG - Requesting: http://10.0.0.22:8082/floating-ip-pool/d13ec324-9b53-4684-83cd-ad164bccc637 2026-06-18 01:45:36,736 - DEBUG - Requesting: http://10.0.0.22:8082/domains 2026-06-18 01:45:36,740 - DEBUG - Requesting: http://10.0.0.22:8082/domain/1805582d-50c7-43c5-b69e-a7507255475c 2026-06-18 01:45:36,746 - DEBUG - Requesting: http://10.0.0.22:8082/project/7a4c14ab-6c01-4c59-981d-35d4170868d5 2026-06-18 01:45:36,779 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/efb11b63-c680-4d29-8e98-7a2002f8d642 2026-06-18 01:45:36,786 - DEBUG - FIP Pool __fip_pool_public__ found in API Server 2026-06-18 01:45:36,786 - INFO - Verification for FIP pool __fip_pool_public__ in API Server passed 2026-06-18 01:45:36,797 - DEBUG - Requesting: http://10.0.0.22:8083/Snh_IFMapTableShowReq?table_name=floating-ip-pool&search_string=floating-ip-pool:default-domain:k8s-default:__public__:__fip_pool_public__ 2026-06-18 01:45:36,802 - DEBUG - Control-node Ifmap-view has FIP pool __fip_pool_public__ information 2026-06-18 01:45:36,802 - INFO - Verification for FIP pool __fip_pool_public__ in Control-node passed 2026-06-18 01:45:36,808 - DEBUG - Ingress ctest-nginx-ingress-50787070 not present 2026-06-18 01:45:36,809 - INFO - Creating Ingress ctest-nginx-ingress-50787070 2026-06-18 01:45:36,815 - INFO - Created Ingress ctest-nginx-ingress-50787070 2026-06-18 01:45:36,820 - DEBUG - Cluster IP not yet seen for Ingress ctest-nginx-ingress-50787070 2026-06-18 01:45:39,825 - DEBUG - For Ingress ctest-nginx-ingress-50787070, Cluster IP: 10.47.255.249, External IPs ['44.96.32.188'] 2026-06-18 01:45:39,825 - INFO - Verifications in k8s passed for Ingress ctest-nginx-ingress-50787070 2026-06-18 01:45:39,826 - DEBUG - Requesting: http://10.0.0.22:8108/Snh_LoadbalancerDatabaseList?x=0ab6a790-9cb3-46d1-b6dd-35ae569a153c 2026-06-18 01:45:39,830 - INFO - Ingress ctest-nginx-ingress-50787070 with uuid 0ab6a790-9cb3-46d1-b6dd-35ae569a153c found in kube manager 2026-06-18 01:45:39,830 - INFO - Ingress ctest-nginx-ingress-50787070 verification passed 2026-06-18 01:45:39,833 - DEBUG - Pod ctest-busybox-pod-13167701 not present 2026-06-18 01:45:39,833 - INFO - Creating Pod ctest-busybox-pod-13167701 2026-06-18 01:45:39,858 - DEBUG - Pod : ctest-busybox-pod-13167701 UUID is 12880d20-fbf9-4450-96d2-32468a940f15 2026-06-18 01:45:39,865 - DEBUG - Pod ctest-nginx-pod-63673523 not in running state.Currently in Pending 2026-06-18 01:45:44,872 - DEBUG - Pod ctest-nginx-pod-63673523 not in running state.Currently in Pending 2026-06-18 01:45:49,878 - INFO - Pod ctest-nginx-pod-63673523 is in running state.Got IP 10.47.255.251 2026-06-18 01:45:49,894 - DEBUG - Pod ctest-nginx-pod-63673523 has vmi 657b1c2a-6ab7-11f1-a83a-fa163ea2f05b 2026-06-18 01:45:49,894 - INFO - Verified pod ctest-nginx-pod-63673523 in contrail-api 2026-06-18 01:45:49,894 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2026-06-18 01:45:49,904 - DEBUG - VMI 657b1c2a-6ab7-11f1-a83a-fa163ea2f05b is active in agent 10.0.0.242 2026-06-18 01:45:49,904 - INFO - Verified Pod ctest-nginx-pod-63673523 in agent 10.0.0.242 2026-06-18 01:45:49,905 - DEBUG - Requesting: http://10.0.0.22:8108/Snh_VirtualMachineDatabaseList?x=5d9fb591-50d6-4153-9a41-39b921c50f78 2026-06-18 01:45:49,910 - INFO - Pod ctest-nginx-pod-63673523 with uuid 5d9fb591-50d6-4153-9a41-39b921c50f78 found in kube manager 2026-06-18 01:45:49,910 - INFO - Pod ctest-nginx-pod-63673523 verification passed 2026-06-18 01:45:49,976 - DEBUG - [Pod ctest-nginx-pod-63673523] Cmd: echo ctest-nginx-pod-63673523 > /usr/share/nginx/html/index.html, Output: 2026-06-18 01:45:49,983 - INFO - Pod ctest-nginx-pod-04559345 is in running state.Got IP 10.47.255.250 2026-06-18 01:45:49,994 - DEBUG - Pod ctest-nginx-pod-04559345 has vmi 66991bc0-6ab7-11f1-a83a-fa163ea2f05b 2026-06-18 01:45:49,994 - INFO - Verified pod ctest-nginx-pod-04559345 in contrail-api 2026-06-18 01:45:49,995 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2026-06-18 01:45:50,006 - DEBUG - VMI 66991bc0-6ab7-11f1-a83a-fa163ea2f05b is active in agent 10.0.0.242 2026-06-18 01:45:50,007 - INFO - Verified Pod ctest-nginx-pod-04559345 in agent 10.0.0.242 2026-06-18 01:45:50,007 - DEBUG - Requesting: http://10.0.0.22:8108/Snh_VirtualMachineDatabaseList?x=879e5ecc-4ebd-4be3-83d0-fd4b401534b0 2026-06-18 01:45:50,010 - INFO - Pod ctest-nginx-pod-04559345 with uuid 879e5ecc-4ebd-4be3-83d0-fd4b401534b0 found in kube manager 2026-06-18 01:45:50,011 - INFO - Pod ctest-nginx-pod-04559345 verification passed 2026-06-18 01:45:50,064 - DEBUG - [Pod ctest-nginx-pod-04559345] Cmd: echo ctest-nginx-pod-04559345 > /usr/share/nginx/html/index.html, Output: 2026-06-18 01:45:50,072 - DEBUG - Pod ctest-busybox-pod-13167701 not in running state.Currently in Pending 2026-06-18 01:45:55,080 - INFO - Pod ctest-busybox-pod-13167701 is in running state.Got IP 10.47.255.248 2026-06-18 01:45:55,091 - DEBUG - Pod ctest-busybox-pod-13167701 has vmi 6918236e-6ab7-11f1-a83a-fa163ea2f05b 2026-06-18 01:45:55,091 - INFO - Verified pod ctest-busybox-pod-13167701 in contrail-api 2026-06-18 01:45:55,091 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2026-06-18 01:45:55,101 - DEBUG - VMI 6918236e-6ab7-11f1-a83a-fa163ea2f05b is active in agent 10.0.0.242 2026-06-18 01:45:55,101 - INFO - Verified Pod ctest-busybox-pod-13167701 in agent 10.0.0.242 2026-06-18 01:45:55,101 - DEBUG - Requesting: http://10.0.0.22:8108/Snh_VirtualMachineDatabaseList?x=12880d20-fbf9-4450-96d2-32468a940f15 2026-06-18 01:45:55,105 - INFO - Pod ctest-busybox-pod-13167701 with uuid 12880d20-fbf9-4450-96d2-32468a940f15 found in kube manager 2026-06-18 01:45:55,105 - INFO - Pod ctest-busybox-pod-13167701 verification passed 2026-06-18 01:45:55,168 - DEBUG - [Pod ctest-busybox-pod-13167701] Cmd: wget http://10.47.255.249:80/ -O - -T 5 -t 1 , Output: ctest-nginx-pod-04559345 Connecting to 10.47.255.249:80 (10.47.255.249:80) writing to stdout - 100% |********************************| 25 0:00:00 ETA written to stdout 2026-06-18 01:45:55,168 - DEBUG - [Pod Pod ctest-busybox-pod-13167701] Cmd wget http://10.47.255.249:80/ -O - -T 5 -t 1 passed 2026-06-18 01:45:55,168 - DEBUG - [Pod Pod ctest-busybox-pod-13167701] Cmd output: ctest-nginx-pod-04559345 Connecting to 10.47.255.249:80 (10.47.255.249:80) writing to stdout - 100% |********************************| 25 0:00:00 ETA written to stdout 2026-06-18 01:45:55,213 - DEBUG - [Pod ctest-busybox-pod-13167701] Cmd: wget http://10.47.255.249:80/ -O - -T 5 -t 1 , Output: ctest-nginx-pod-63673523 Connecting to 10.47.255.249:80 (10.47.255.249:80) writing to stdout - 100% |********************************| 25 0:00:00 ETA written to stdout 2026-06-18 01:45:55,213 - DEBUG - [Pod Pod ctest-busybox-pod-13167701] Cmd wget http://10.47.255.249:80/ -O - -T 5 -t 1 passed 2026-06-18 01:45:55,213 - DEBUG - [Pod Pod ctest-busybox-pod-13167701] Cmd output: ctest-nginx-pod-63673523 Connecting to 10.47.255.249:80 (10.47.255.249:80) writing to stdout - 100% |********************************| 25 0:00:00 ETA written to stdout 2026-06-18 01:45:55,213 - INFO - Responses seen from all pods, lb seems fine.Hits : {'ctest-nginx-pod-63673523': 1, 'ctest-nginx-pod-04559345': 1} 2026-06-18 01:45:55,213 - WARNING - Nothing to delete parallely 2026-06-18 01:45:55,214 - INFO - Deleting pod default:ctest-busybox-pod-13167701 2026-06-18 01:45:55,234 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VmListReq?uuid=12880d20-fbf9-4450-96d2-32468a940f15 2026-06-18 01:45:55,241 - WARNING - Pod uuid 12880d20-fbf9-4450-96d2-32468a940f15 is still seen in agent 10.0.0.242 VM list 2026-06-18 01:46:00,241 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VmListReq?uuid=12880d20-fbf9-4450-96d2-32468a940f15 2026-06-18 01:46:00,248 - WARNING - Pod uuid 12880d20-fbf9-4450-96d2-32468a940f15 is still seen in agent 10.0.0.242 VM list 2026-06-18 01:46:05,249 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VmListReq?uuid=12880d20-fbf9-4450-96d2-32468a940f15 2026-06-18 01:46:05,255 - WARNING - Pod uuid 12880d20-fbf9-4450-96d2-32468a940f15 is still seen in agent 10.0.0.242 VM list 2026-06-18 01:46:10,256 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VmListReq?uuid=12880d20-fbf9-4450-96d2-32468a940f15 2026-06-18 01:46:10,263 - WARNING - Pod uuid 12880d20-fbf9-4450-96d2-32468a940f15 is still seen in agent 10.0.0.242 VM list 2026-06-18 01:46:15,264 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VmListReq?uuid=12880d20-fbf9-4450-96d2-32468a940f15 2026-06-18 01:46:15,274 - WARNING - Pod uuid 12880d20-fbf9-4450-96d2-32468a940f15 is still seen in agent 10.0.0.242 VM list 2026-06-18 01:46:20,275 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VmListReq?uuid=12880d20-fbf9-4450-96d2-32468a940f15 2026-06-18 01:46:20,284 - WARNING - Pod uuid 12880d20-fbf9-4450-96d2-32468a940f15 is still seen in agent 10.0.0.242 VM list 2026-06-18 01:46:25,285 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VmListReq?uuid=12880d20-fbf9-4450-96d2-32468a940f15 2026-06-18 01:46:25,296 - WARNING - Pod uuid 12880d20-fbf9-4450-96d2-32468a940f15 is still seen in agent 10.0.0.242 VM list 2026-06-18 01:46:30,297 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VmListReq?uuid=12880d20-fbf9-4450-96d2-32468a940f15 2026-06-18 01:46:30,303 - DEBUG - Pod 12880d20-fbf9-4450-96d2-32468a940f15 is not in agent 10.0.0.242 VM list 2026-06-18 01:46:30,303 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:6918236e-6ab7-11f1-a83a-fa163ea2f05b 2026-06-18 01:46:30,315 - DEBUG - VMI 6918236e-6ab7-11f1-a83a-fa163ea2f05b is removed from agent 10.0.0.242 2026-06-18 01:46:30,315 - INFO - Verified that pod ctest-busybox-pod-13167701 is removed in agent 2026-06-18 01:46:30,316 - INFO - Deleting Ingress : ctest-nginx-ingress-50787070 2026-06-18 01:46:30,331 - DEBUG - Requesting: http://10.0.0.22:8108/Snh_LoadbalancerDatabaseList?x=0ab6a790-9cb3-46d1-b6dd-35ae569a153c 2026-06-18 01:46:30,336 - ERROR - Ingress ctest-nginx-ingress-50787070 with uuid 0ab6a790-9cb3-46d1-b6dd-35ae569a153c still found in kube manager 2026-06-18 01:46:31,337 - DEBUG - Requesting: http://10.0.0.22:8108/Snh_LoadbalancerDatabaseList?x=0ab6a790-9cb3-46d1-b6dd-35ae569a153c 2026-06-18 01:46:31,342 - INFO - Ingress ctest-nginx-ingress-50787070 with uuid 0ab6a790-9cb3-46d1-b6dd-35ae569a153c deleted successfully from kube manager 2026-06-18 01:46:31,343 - INFO - Verifications on Ingress %s cleanup passed 2026-06-18 01:46:31,343 - INFO - Deleting the FIP pool __fip_pool_public__ 2026-06-18 01:46:31,507 - DEBUG - Requesting: http://10.0.0.22:8083/Snh_IFMapTableShowReq?table_name=floating-ip-pool&search_string=floating-ip-pool:default-domain:k8s-default:__public__:__fip_pool_public__ 2026-06-18 01:46:31,529 - DEBUG - Control-node Ifmap-view does not have FIP pool __fip_pool_public__ information 2026-06-18 01:46:31,529 - INFO - Deleting VN __public__ 2026-06-18 01:46:31,663 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/03e4d89d-aeb5-492d-9128-9803bf2a4901 2026-06-18 01:46:31,674 - DEBUG - Response Code: 404 2026-06-18 01:46:31,674 - DEBUG - Requesting: http://10.0.0.22:8082/domains 2026-06-18 01:46:31,678 - DEBUG - Requesting: http://10.0.0.22:8082/domain/1805582d-50c7-43c5-b69e-a7507255475c 2026-06-18 01:46:31,691 - DEBUG - Requesting: http://10.0.0.22:8082/project/7a4c14ab-6c01-4c59-981d-35d4170868d5 2026-06-18 01:46:31,751 - INFO - Validated that VN __public__ is not found in API Server 2026-06-18 01:46:31,751 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VnListReq?name=default-domain:k8s-default:__public__ 2026-06-18 01:46:31,767 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:k8s-default:__public__:__public__ 2026-06-18 01:46:31,782 - DEBUG - VN __public__ is not present in Agent 10.0.0.242 2026-06-18 01:46:31,782 - INFO - Validated that VN __public__ is not in any agent 2026-06-18 01:46:31,782 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:k8s-default:__public__:__public__ 2026-06-18 01:46:31,798 - DEBUG - Requesting: http://10.0.0.22:8083/Snh_ShowRoutingInstanceReq?name=default-domain:k8s-default:__public__:__public__ 2026-06-18 01:46:31,803 - DEBUG - Requesting: http://10.0.0.22:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:k8s-default:__public__ 2026-06-18 01:46:31,823 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN __public__ info 2026-06-18 01:46:31,824 - INFO - Deleting pod default:ctest-nginx-pod-04559345 2026-06-18 01:46:31,862 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VmListReq?uuid=879e5ecc-4ebd-4be3-83d0-fd4b401534b0 2026-06-18 01:46:31,903 - WARNING - Pod uuid 879e5ecc-4ebd-4be3-83d0-fd4b401534b0 is still seen in agent 10.0.0.242 VM list 2026-06-18 01:46:36,910 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VmListReq?uuid=879e5ecc-4ebd-4be3-83d0-fd4b401534b0 2026-06-18 01:46:36,916 - DEBUG - Pod 879e5ecc-4ebd-4be3-83d0-fd4b401534b0 is not in agent 10.0.0.242 VM list 2026-06-18 01:46:36,916 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:66991bc0-6ab7-11f1-a83a-fa163ea2f05b 2026-06-18 01:46:36,921 - DEBUG - VMI 66991bc0-6ab7-11f1-a83a-fa163ea2f05b is removed from agent 10.0.0.242 2026-06-18 01:46:36,921 - INFO - Verified that pod ctest-nginx-pod-04559345 is removed in agent 2026-06-18 01:46:36,922 - INFO - Deleting pod default:ctest-nginx-pod-63673523 2026-06-18 01:46:36,945 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VmListReq?uuid=5d9fb591-50d6-4153-9a41-39b921c50f78 2026-06-18 01:46:36,951 - WARNING - Pod uuid 5d9fb591-50d6-4153-9a41-39b921c50f78 is still seen in agent 10.0.0.242 VM list 2026-06-18 01:46:41,952 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VmListReq?uuid=5d9fb591-50d6-4153-9a41-39b921c50f78 2026-06-18 01:46:41,958 - DEBUG - Pod 5d9fb591-50d6-4153-9a41-39b921c50f78 is not in agent 10.0.0.242 VM list 2026-06-18 01:46:41,958 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:657b1c2a-6ab7-11f1-a83a-fa163ea2f05b 2026-06-18 01:46:41,963 - DEBUG - VMI 657b1c2a-6ab7-11f1-a83a-fa163ea2f05b is removed from agent 10.0.0.242 2026-06-18 01:46:41,963 - INFO - Verified that pod ctest-nginx-pod-63673523 is removed in agent 2026-06-18 01:46:41,964 - INFO - Deleting service : ctest-nginx-svc-25194168 2026-06-18 01:46:42,267 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_AgentXmppConnectionStatusReq? 2026-06-18 01:46:42,273 - DEBUG - No XMPP flaps were noticed during the test
2026-06-18 01:46:42,274 - INFO - END TEST : test_ingress_ip_assignment : PASSED[0:01:11]
2026-06-18 01:46:42,274 - INFO - -------------------------------------------------------------------------------- 2026-06-18 01:46:48,804 - DEBUG - [10.0.0.22]: Running cmd : docker exec --privileged -it contrail-kubernetes-master-kubemanager-1 /bin/bash -c 'grep "^[ ]*cluster_project" /etc/contrail/contrail-kubernetes.conf' 2026-06-18 01:46:48,938 - DEBUG - Output : cluster_project={} 2026-06-18 01:46:49,051 - DEBUG - [10.0.0.22]: Running cmd : docker exec --privileged -it contrail-kubernetes-master-kubemanager-1 /bin/bash -c 'netstat -antp | grep :8108 | grep LISTEN' 2026-06-18 01:46:49,189 - DEBUG - Output : tcp 0 0 0.0.0.0:8108 0.0.0.0:* LISTEN 1/python3 2026-06-18 01:46:49,194 - DEBUG - [10.0.0.22]: Running cmd : docker exec --privileged -it contrail-kubernetes-master-kubemanager-1 /bin/bash -c 'grep "^[ ]*cluster_project" /etc/contrail/contrail-kubernetes.conf' 2026-06-18 01:46:49,342 - DEBUG - Output : cluster_project={} 2026-06-18 01:46:59,494 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2026-06-18 01:46:59,529 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2026-06-18 01:46:59,559 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2026-06-18 01:47:04,638 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2026-06-18 01:47:09,682 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2026-06-18 01:47:09,762 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2026-06-18 01:47:09,793 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2026-06-18 01:47:09,868 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2026-06-18 01:47:10,114 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_AgentXmppConnectionStatusReq? 2026-06-18 01:47:12,706 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_ApplicationPolicySetReq? 2026-06-18 01:47:12,712 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_AclReq? 2026-06-18 01:47:12,740 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_AclReq? 2026-06-18 01:47:14,764 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_AclReq? 2026-06-18 01:50:23,291 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_AgentXmppConnectionStatusReq? 2026-06-18 01:50:23,362 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VmListReq?uuid=97da4e37-247d-41ce-93a0-a22ed06ba83d 2026-06-18 01:50:23,379 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VmListReq?uuid=76adcdf4-8e73-48ca-8b9c-bed92a05bf40 2026-06-18 01:50:23,411 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VmListReq?uuid=894dd7bb-97d7-4a26-b9a4-0a2ae7c67f4a 2026-06-18 01:50:23,425 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VmListReq?uuid=bcaaf1e6-11cc-4513-8993-6b701aab5f6c 2026-06-18 01:50:23,438 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VmListReq?uuid=10abbde8-d210-45c0-a16a-f99d0e538b6e 2026-06-18 01:50:23,449 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VmListReq?uuid=45bb7295-1dd6-4620-8035-f9d1e3cc7e57 2026-06-18 01:50:23,454 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VmListReq?uuid=57d1b009-c447-407e-932c-484e2d7bb84b 2026-06-18 01:50:23,459 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VmListReq?uuid=cbdaa98a-fedc-4ba9-b4f8-9ff7cb2f64ce 2026-06-18 01:50:28,465 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VmListReq?uuid=bcaaf1e6-11cc-4513-8993-6b701aab5f6c 2026-06-18 01:50:28,467 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VmListReq?uuid=894dd7bb-97d7-4a26-b9a4-0a2ae7c67f4a 2026-06-18 01:50:28,476 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:940c3812-6ab7-11f1-a83a-fa163ea2f05b 2026-06-18 01:50:28,492 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VmListReq?uuid=cbdaa98a-fedc-4ba9-b4f8-9ff7cb2f64ce 2026-06-18 01:50:28,493 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VmListReq?uuid=76adcdf4-8e73-48ca-8b9c-bed92a05bf40 2026-06-18 01:50:28,494 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VmListReq?uuid=10abbde8-d210-45c0-a16a-f99d0e538b6e 2026-06-18 01:50:28,494 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VmListReq?uuid=97da4e37-247d-41ce-93a0-a22ed06ba83d 2026-06-18 01:50:28,496 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VmListReq?uuid=57d1b009-c447-407e-932c-484e2d7bb84b 2026-06-18 01:50:28,497 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VmListReq?uuid=45bb7295-1dd6-4620-8035-f9d1e3cc7e57 2026-06-18 01:50:28,515 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:93775102-6ab7-11f1-a83a-fa163ea2f05b 2026-06-18 01:50:28,518 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:947fecb2-6ab7-11f1-a83a-fa163ea2f05b 2026-06-18 01:50:28,521 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:92f90ad6-6ab7-11f1-a83a-fa163ea2f05b 2026-06-18 01:50:33,476 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VmListReq?uuid=894dd7bb-97d7-4a26-b9a4-0a2ae7c67f4a 2026-06-18 01:50:33,517 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VmListReq?uuid=cbdaa98a-fedc-4ba9-b4f8-9ff7cb2f64ce 2026-06-18 01:50:33,520 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VmListReq?uuid=57d1b009-c447-407e-932c-484e2d7bb84b 2026-06-18 01:50:33,522 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VmListReq?uuid=76adcdf4-8e73-48ca-8b9c-bed92a05bf40 2026-06-18 01:50:38,484 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VmListReq?uuid=894dd7bb-97d7-4a26-b9a4-0a2ae7c67f4a 2026-06-18 01:50:38,526 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VmListReq?uuid=cbdaa98a-fedc-4ba9-b4f8-9ff7cb2f64ce 2026-06-18 01:50:38,538 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VmListReq?uuid=76adcdf4-8e73-48ca-8b9c-bed92a05bf40 2026-06-18 01:50:38,548 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VmListReq?uuid=57d1b009-c447-407e-932c-484e2d7bb84b 2026-06-18 01:50:43,492 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VmListReq?uuid=894dd7bb-97d7-4a26-b9a4-0a2ae7c67f4a 2026-06-18 01:50:43,533 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VmListReq?uuid=cbdaa98a-fedc-4ba9-b4f8-9ff7cb2f64ce 2026-06-18 01:50:43,544 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VmListReq?uuid=76adcdf4-8e73-48ca-8b9c-bed92a05bf40 2026-06-18 01:50:43,554 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VmListReq?uuid=57d1b009-c447-407e-932c-484e2d7bb84b 2026-06-18 01:50:48,501 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VmListReq?uuid=894dd7bb-97d7-4a26-b9a4-0a2ae7c67f4a 2026-06-18 01:50:48,541 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VmListReq?uuid=cbdaa98a-fedc-4ba9-b4f8-9ff7cb2f64ce 2026-06-18 01:50:48,551 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VmListReq?uuid=76adcdf4-8e73-48ca-8b9c-bed92a05bf40 2026-06-18 01:50:48,561 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VmListReq?uuid=57d1b009-c447-407e-932c-484e2d7bb84b 2026-06-18 01:50:53,508 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VmListReq?uuid=894dd7bb-97d7-4a26-b9a4-0a2ae7c67f4a 2026-06-18 01:50:53,549 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VmListReq?uuid=cbdaa98a-fedc-4ba9-b4f8-9ff7cb2f64ce 2026-06-18 01:50:53,556 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VmListReq?uuid=76adcdf4-8e73-48ca-8b9c-bed92a05bf40 2026-06-18 01:50:53,568 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VmListReq?uuid=57d1b009-c447-407e-932c-484e2d7bb84b 2026-06-18 01:50:58,529 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VmListReq?uuid=894dd7bb-97d7-4a26-b9a4-0a2ae7c67f4a 2026-06-18 01:50:58,535 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:9566248e-6ab7-11f1-a83a-fa163ea2f05b 2026-06-18 01:50:58,557 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VmListReq?uuid=cbdaa98a-fedc-4ba9-b4f8-9ff7cb2f64ce 2026-06-18 01:50:58,562 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VmListReq?uuid=76adcdf4-8e73-48ca-8b9c-bed92a05bf40 2026-06-18 01:50:58,564 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:96347b04-6ab7-11f1-a83a-fa163ea2f05b 2026-06-18 01:50:58,573 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:94f5aae2-6ab7-11f1-a83a-fa163ea2f05b 2026-06-18 01:50:58,583 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VmListReq?uuid=57d1b009-c447-407e-932c-484e2d7bb84b 2026-06-18 01:50:58,592 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:95ce1918-6ab7-11f1-a83a-fa163ea2f05b