2025-10-27 19:55:39,527 - DEBUG - [10.0.0.19]: Running cmd : hostname 2025-10-27 19:55:39,821 - DEBUG - Output : cn-jenkins-deploy-platform-juju-k8s-1640-1 2025-10-27 19:55:39,821 - DEBUG - [10.0.0.19]: Running cmd : hostname -f 2025-10-27 19:55:39,854 - DEBUG - Output : cn-jenkins-deploy-platform-juju-k8s-1640-1 2025-10-27 19:55:39,854 - DEBUG - [10.0.0.19]: 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-10-27 19:55:39,929 - DEBUG - Output : NAMES contrail_test_KRQvttr1u contrail-kubernetes-master-kubemanager-1 webui-web-1 webui-job-1 analytics_database-query-engine-1 analytics_database-cassandra-1 analytics_database-nodemgr-1 analytics_snmp-snmp-collector-1 analytics_snmp-topology-1 analytics_snmp-nodemgr-1 analytics_alarm-kafka-1 analytics_alarm-nodemgr-1 analytics_alarm-alarm-gen-1 analytics-collector-1 analytics-nodemgr-1 analytics-api-1 redis-redis-1 control-named-1 control-nodemgr-1 control-control-1 control-dns-1 config_database-nodemgr-1 config_database-rabbitmq-1 config_database-cassandra-1 config_database-zookeeper-1 config_api-devicemgr-1 config_api-schema-1 config_api-nodemgr-1 config_api-dnsmasq-1 config_api-api-1 config_api-svcmonitor-1 2025-10-27 19:55:39,929 - DEBUG - [10.0.0.19]: Running cmd : ip -4 -o addr show | awk '{print $4}' 2025-10-27 19:55:39,977 - DEBUG - Output : 127.0.0.1/8 10.0.0.19/24 252.19.0.1/8 10.31.116.1/24 172.17.0.1/16 2025-10-27 19:55:39,977 - DEBUG - [10.0.0.19]: Running cmd : getent hosts 10.0.0.19 | head -n 1 | awk '{print $2}' 2025-10-27 19:55:40,070 - DEBUG - Output : cn-jenkins-deploy-platform-juju-k8s-1640-1 2025-10-27 19:55:40,132 - DEBUG - [10.0.0.27]: Running cmd : hostname 2025-10-27 19:55:40,401 - DEBUG - Output : an-jenkins-deploy-platform-juju-k8s-1640-1 2025-10-27 19:55:40,401 - DEBUG - [10.0.0.27]: Running cmd : hostname -f 2025-10-27 19:55:40,438 - DEBUG - Output : an-jenkins-deploy-platform-juju-k8s-1640-1 2025-10-27 19:55:40,439 - DEBUG - [10.0.0.27]: 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-10-27 19:55:40,516 - DEBUG - Output : NAMES vrouter-vrouter-agent-1 vrouter-nodemgr-1 2025-10-27 19:55:40,516 - DEBUG - [10.0.0.27]: Running cmd : ip -4 -o addr show dev vhost0 | awk '{print $4}' 2025-10-27 19:55:40,550 - DEBUG - Output : 10.0.0.27/24 2025-10-27 19:55:40,551 - DEBUG - [10.0.0.27]: Running cmd : getent hosts 10.0.0.27 | head -n 1 | awk '{print $2}' 2025-10-27 19:55:40,585 - DEBUG - Output : an-jenkins-deploy-platform-juju-k8s-1640-1 2025-10-27 19:55:40,652 - INFO - Using existing project ['default-domain', 'k8s-default'](36bdf51a-f0c5-45de-ac38-1f8691bba476) 2025-10-27 19:55:40,746 - INFO - Using existing project ['default-domain', 'k8s-default'](36bdf51a-f0c5-45de-ac38-1f8691bba476) 2025-10-27 19:55:40,851 - INFO - ================================================================================ 2025-10-27 19:55:40,851 - INFO - STARTING TEST : test_ingress_ip_assignment 2025-10-27 19:55:40,851 - 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-10-27 19:55:41,064 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_AgentXmppConnectionStatusReq? 2025-10-27 19:55:41,071 - DEBUG - Nothing to compare xmpp stats {'10.0.0.27': {'10.0.0.19': '0'}} with 2025-10-27 19:55:41,071 - INFO - Initial checks done. Running the testcase now 2025-10-27 19:55:41,071 - INFO - 2025-10-27 19:55:41,076 - INFO - Namespace default already exists 2025-10-27 19:55:41,076 - DEBUG - [10.0.0.19]: Running cmd : docker exec --privileged -it contrail-kubernetes-master-kubemanager-1 /bin/bash -c 'grep "^[ ]*cluster_project" /etc/contrail/contrail-kubernetes.conf' 2025-10-27 19:55:41,228 - DEBUG - Output : cluster_project={} 2025-10-27 19:55:41,279 - INFO - Project default-domain:k8s-default for Namespace default is seen in contrail-api 2025-10-27 19:55:41,280 - DEBUG - Project uuid in Contrail is 36bdf51a-f0c5-45de-ac38-1f8691bba476 2025-10-27 19:55:41,280 - DEBUG - [10.0.0.19]: Running cmd : docker exec --privileged -it contrail-kubernetes-master-kubemanager-1 /bin/bash -c 'netstat -antp | grep :8108 | grep LISTEN' 2025-10-27 19:55:41,434 - DEBUG - Output : tcp 0 0 0.0.0.0:8108 0.0.0.0:* LISTEN 1/python3 2025-10-27 19:55:41,434 - DEBUG - Requesting: http://10.0.0.19:8108/Snh_NamespaceDatabaseList?namespace_uuid=71a79e57-d2e5-4d72-a94f-7d72f55e4c26 2025-10-27 19:55:41,438 - INFO - Namespace default with uuid 71a79e57-d2e5-4d72-a94f-7d72f55e4c26 found in kube manager 2025-10-27 19:55:41,438 - INFO - Namespace default verification passed 2025-10-27 19:55:41,441 - DEBUG - Service ctest-nginx-svc-10318278 not present 2025-10-27 19:55:41,445 - INFO - Creating service ctest-nginx-svc-10318278 2025-10-27 19:55:41,478 - INFO - Created Service ctest-nginx-svc-10318278 2025-10-27 19:55:41,484 - DEBUG - Pod ctest-nginx-pod-24948669 not present 2025-10-27 19:55:41,485 - INFO - Creating Pod ctest-nginx-pod-24948669 2025-10-27 19:55:41,536 - DEBUG - Node for Pod ctest-nginx-pod-24948669 not yet populated 2025-10-27 19:55:44,546 - DEBUG - Pod : ctest-nginx-pod-24948669 UUID is 699575ca-47a5-4a9d-b8d8-e06b7c56d3fc 2025-10-27 19:55:44,549 - DEBUG - Pod ctest-nginx-pod-07484179 not present 2025-10-27 19:55:44,549 - INFO - Creating Pod ctest-nginx-pod-07484179 2025-10-27 19:55:44,575 - DEBUG - Pod : ctest-nginx-pod-07484179 UUID is 4a2face6-8875-478c-94ed-c0ca0d4b3716 2025-10-27 19:55:44,799 - INFO - Created VN __public__, UUID :5d8a22ed-42c2-4c48-b0d8-a2a60d405b2a 2025-10-27 19:55:45,048 - DEBUG - Requesting: http://10.0.0.19:8082/domains 2025-10-27 19:55:45,052 - DEBUG - Requesting: http://10.0.0.19:8082/domain/78836558-eb45-4857-b85b-0e64e6b31822 2025-10-27 19:55:45,063 - DEBUG - Requesting: http://10.0.0.19:8082/project/36bdf51a-f0c5-45de-ac38-1f8691bba476 2025-10-27 19:55:45,112 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/5d8a22ed-42c2-4c48-b0d8-a2a60d405b2a 2025-10-27 19:55:45,139 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/5d8a22ed-42c2-4c48-b0d8-a2a60d405b2a 2025-10-27 19:55:45,146 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/ae3660f5-5c01-4dbb-abe3-9d94f8c74236 2025-10-27 19:55:45,161 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/ae3660f5-5c01-4dbb-abe3-9d94f8c74236 2025-10-27 19:55:45,172 - DEBUG - Requesting: http://10.0.0.19:8082/route-target/d18c02c3-efb7-4dfb-8360-8f85e6739b21 2025-10-27 19:55:45,178 - DEBUG - Route Targets: ['target:64512:8000006'] 2025-10-27 19:55:45,179 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/5d8a22ed-42c2-4c48-b0d8-a2a60d405b2a 2025-10-27 19:55:45,188 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/ae3660f5-5c01-4dbb-abe3-9d94f8c74236 2025-10-27 19:55:45,201 - INFO - Verified VN network id 13 for VN 5d8a22ed-42c2-4c48-b0d8-a2a60d405b2a 2025-10-27 19:55:45,201 - INFO - Verifications in API Server for VN __public__ passed 2025-10-27 19:55:45,201 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/5d8a22ed-42c2-4c48-b0d8-a2a60d405b2a 2025-10-27 19:55:45,209 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/ae3660f5-5c01-4dbb-abe3-9d94f8c74236 2025-10-27 19:55:45,217 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/ae3660f5-5c01-4dbb-abe3-9d94f8c74236 2025-10-27 19:55:45,225 - DEBUG - Requesting: http://10.0.0.19:8082/route-target/d18c02c3-efb7-4dfb-8360-8f85e6739b21 2025-10-27 19:55:45,229 - DEBUG - Requesting: http://10.0.0.19:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:k8s-default:__public__ 2025-10-27 19:55:45,251 - DEBUG - Control-node 10.0.0.19 : 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': '6740238194735991880', 'uuid-lslong': '12743113979715410730'}, 'enable': 'true', 'created': '2025-10-27T19:55:44', 'last-modified': '2025-10-27T19:55:44', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.256888'} 2025-10-27 19:55:45,251 - DEBUG - Requesting: http://10.0.0.19:8083/Snh_ShowRoutingInstanceReq?name=default-domain:k8s-default:__public__:__public__ 2025-10-27 19:55:45,264 - DEBUG - Route Targets: ['target:64512:8000006'] 2025-10-27 19:55:45,265 - INFO - On all control nodes, Config, RI and RT verification for VN __public__ passed 2025-10-27 19:55:45,265 - DEBUG - ====Verifying policy data for __public__ in API_Server ====== 2025-10-27 19:55:45,265 - DEBUG - Requesting: http://10.0.0.19:8082/domains 2025-10-27 19:55:45,271 - DEBUG - Requesting: http://10.0.0.19:8082/domain/78836558-eb45-4857-b85b-0e64e6b31822 2025-10-27 19:55:45,277 - DEBUG - Requesting: http://10.0.0.19:8082/project/36bdf51a-f0c5-45de-ac38-1f8691bba476 2025-10-27 19:55:45,313 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/5d8a22ed-42c2-4c48-b0d8-a2a60d405b2a 2025-10-27 19:55:45,323 - DEBUG - =>VN __public__ has no policy to be verified 2025-10-27 19:55:45,323 - DEBUG - Verifying the vn in opserver 2025-10-27 19:55:45,323 - DEBUG - Verifying the default-domain:k8s-default:__public__ virtual network link through opserver 10.0.0.19 2025-10-27 19:55:45,323 - DEBUG - Requesting: http://10.0.0.19:8081/analytics/uves/virtual-networks 2025-10-27 19:55:45,327 - DEBUG - vn link and name as {'name': 'default-domain:k8s-default:__public__', 'href': 'http://10.0.0.19:8081/analytics/uves/virtual-network/default-domain:k8s-default:__public__?flat'} 2025-10-27 19:55:45,327 - INFO - Validated that VN default-domain:k8s-default:__public__ is found in opserver 2025-10-27 19:55:45,328 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_VrfListReq?name=default-domain:k8s-default:__public__:__public__ 2025-10-27 19:55:45,341 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_VrfListReq?name=default-domain:k8s-default:__public__:__public__ 2025-10-27 19:55:45,346 - DEBUG - Do not have enough data to verify VN in agent 2025-10-27 19:55:45,346 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_VrfListReq?name=default-domain:k8s-default:__public__:__public__ 2025-10-27 19:55:45,351 - DEBUG - VRF ids for VN __public__: {} 2025-10-27 19:55:45,440 - INFO - Creating Floating IP pool __fip_pool_public__ in API Server 2025-10-27 19:55:45,586 - DEBUG - Requesting: http://10.0.0.19:8082/domains 2025-10-27 19:55:45,591 - DEBUG - Requesting: http://10.0.0.19:8082/domain/78836558-eb45-4857-b85b-0e64e6b31822 2025-10-27 19:55:45,597 - DEBUG - Requesting: http://10.0.0.19:8082/project/36bdf51a-f0c5-45de-ac38-1f8691bba476 2025-10-27 19:55:45,646 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/5d8a22ed-42c2-4c48-b0d8-a2a60d405b2a 2025-10-27 19:55:45,655 - DEBUG - Requesting: http://10.0.0.19:8082/floating-ip-pool/1c570f62-a6c4-4915-901a-3114ce4ca61a 2025-10-27 19:55:45,660 - DEBUG - Requesting: http://10.0.0.19:8082/domains 2025-10-27 19:55:45,664 - DEBUG - Requesting: http://10.0.0.19:8082/domain/78836558-eb45-4857-b85b-0e64e6b31822 2025-10-27 19:55:45,670 - DEBUG - Requesting: http://10.0.0.19:8082/project/36bdf51a-f0c5-45de-ac38-1f8691bba476 2025-10-27 19:55:45,711 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/5d8a22ed-42c2-4c48-b0d8-a2a60d405b2a 2025-10-27 19:55:45,721 - DEBUG - FIP Pool __fip_pool_public__ found in API Server 2025-10-27 19:55:45,721 - INFO - Verification for FIP pool __fip_pool_public__ in API Server passed 2025-10-27 19:55:45,728 - DEBUG - Requesting: http://10.0.0.19:8083/Snh_IFMapTableShowReq?table_name=floating-ip-pool&search_string=floating-ip-pool:default-domain:k8s-default:__public__:__fip_pool_public__ 2025-10-27 19:55:45,733 - DEBUG - Control-node Ifmap-view has FIP pool __fip_pool_public__ information 2025-10-27 19:55:45,733 - INFO - Verification for FIP pool __fip_pool_public__ in Control-node passed 2025-10-27 19:55:45,736 - DEBUG - Ingress ctest-nginx-ingress-04042857 not present 2025-10-27 19:55:45,736 - INFO - Creating Ingress ctest-nginx-ingress-04042857 2025-10-27 19:55:45,745 - INFO - Created Ingress ctest-nginx-ingress-04042857 2025-10-27 19:55:45,750 - DEBUG - Cluster IP not yet seen for Ingress ctest-nginx-ingress-04042857 2025-10-27 19:55:48,755 - DEBUG - For Ingress ctest-nginx-ingress-04042857, Cluster IP: 10.47.255.249, External IPs ['39.9.4.188'] 2025-10-27 19:55:48,755 - INFO - Verifications in k8s passed for Ingress ctest-nginx-ingress-04042857 2025-10-27 19:55:48,755 - DEBUG - Requesting: http://10.0.0.19:8108/Snh_LoadbalancerDatabaseList?x=13da381d-41e4-4b54-a8e5-06213dd8901b 2025-10-27 19:55:48,761 - INFO - Ingress ctest-nginx-ingress-04042857 with uuid 13da381d-41e4-4b54-a8e5-06213dd8901b found in kube manager 2025-10-27 19:55:48,761 - INFO - Ingress ctest-nginx-ingress-04042857 verification passed 2025-10-27 19:55:48,766 - DEBUG - Pod ctest-busybox-pod-25663481 not present 2025-10-27 19:55:48,767 - INFO - Creating Pod ctest-busybox-pod-25663481 2025-10-27 19:55:48,809 - DEBUG - Pod : ctest-busybox-pod-25663481 UUID is 4ebb8000-36ad-4899-8ee4-c860cc01d3ef 2025-10-27 19:55:48,819 - DEBUG - Pod ctest-nginx-pod-24948669 not in running state.Currently in Pending 2025-10-27 19:55:53,826 - DEBUG - Pod ctest-nginx-pod-24948669 not in running state.Currently in Pending 2025-10-27 19:55:58,833 - INFO - Pod ctest-nginx-pod-24948669 is in running state.Got IP 10.47.255.251 2025-10-27 19:55:58,845 - DEBUG - Pod ctest-nginx-pod-24948669 has vmi eba84012-b36e-11f0-9728-fa163e5a2726 2025-10-27 19:55:58,845 - INFO - Verified pod ctest-nginx-pod-24948669 in contrail-api 2025-10-27 19:55:58,845 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2025-10-27 19:55:58,857 - DEBUG - VMI eba84012-b36e-11f0-9728-fa163e5a2726 is active in agent 10.0.0.27 2025-10-27 19:55:58,857 - INFO - Verified Pod ctest-nginx-pod-24948669 in agent 10.0.0.27 2025-10-27 19:55:58,857 - DEBUG - Requesting: http://10.0.0.19:8108/Snh_VirtualMachineDatabaseList?x=699575ca-47a5-4a9d-b8d8-e06b7c56d3fc 2025-10-27 19:55:58,860 - INFO - Pod ctest-nginx-pod-24948669 with uuid 699575ca-47a5-4a9d-b8d8-e06b7c56d3fc found in kube manager 2025-10-27 19:55:58,860 - INFO - Pod ctest-nginx-pod-24948669 verification passed 2025-10-27 19:55:58,928 - DEBUG - [Pod ctest-nginx-pod-24948669] Cmd: echo ctest-nginx-pod-24948669 > /usr/share/nginx/html/index.html, Output: 2025-10-27 19:55:58,938 - INFO - Pod ctest-nginx-pod-07484179 is in running state.Got IP 10.47.255.250 2025-10-27 19:55:58,960 - DEBUG - Pod ctest-nginx-pod-07484179 has vmi ecb64896-b36e-11f0-9728-fa163e5a2726 2025-10-27 19:55:58,960 - INFO - Verified pod ctest-nginx-pod-07484179 in contrail-api 2025-10-27 19:55:58,960 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2025-10-27 19:55:58,973 - DEBUG - VMI ecb64896-b36e-11f0-9728-fa163e5a2726 is active in agent 10.0.0.27 2025-10-27 19:55:58,973 - INFO - Verified Pod ctest-nginx-pod-07484179 in agent 10.0.0.27 2025-10-27 19:55:58,973 - DEBUG - Requesting: http://10.0.0.19:8108/Snh_VirtualMachineDatabaseList?x=4a2face6-8875-478c-94ed-c0ca0d4b3716 2025-10-27 19:55:58,976 - INFO - Pod ctest-nginx-pod-07484179 with uuid 4a2face6-8875-478c-94ed-c0ca0d4b3716 found in kube manager 2025-10-27 19:55:58,976 - INFO - Pod ctest-nginx-pod-07484179 verification passed 2025-10-27 19:55:59,037 - DEBUG - [Pod ctest-nginx-pod-07484179] Cmd: echo ctest-nginx-pod-07484179 > /usr/share/nginx/html/index.html, Output: 2025-10-27 19:55:59,043 - DEBUG - Pod ctest-busybox-pod-25663481 not in running state.Currently in Pending 2025-10-27 19:56:04,051 - INFO - Pod ctest-busybox-pod-25663481 is in running state.Got IP 10.47.255.248 2025-10-27 19:56:04,102 - DEBUG - Pod ctest-busybox-pod-25663481 has vmi ef3a4388-b36e-11f0-9728-fa163e5a2726 2025-10-27 19:56:04,102 - INFO - Verified pod ctest-busybox-pod-25663481 in contrail-api 2025-10-27 19:56:04,103 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2025-10-27 19:56:04,112 - DEBUG - VMI ef3a4388-b36e-11f0-9728-fa163e5a2726 is active in agent 10.0.0.27 2025-10-27 19:56:04,112 - INFO - Verified Pod ctest-busybox-pod-25663481 in agent 10.0.0.27 2025-10-27 19:56:04,112 - DEBUG - Requesting: http://10.0.0.19:8108/Snh_VirtualMachineDatabaseList?x=4ebb8000-36ad-4899-8ee4-c860cc01d3ef 2025-10-27 19:56:04,116 - INFO - Pod ctest-busybox-pod-25663481 with uuid 4ebb8000-36ad-4899-8ee4-c860cc01d3ef found in kube manager 2025-10-27 19:56:04,116 - INFO - Pod ctest-busybox-pod-25663481 verification passed 2025-10-27 19:56:04,178 - DEBUG - [Pod ctest-busybox-pod-25663481] Cmd: wget http://10.47.255.249:80/ -O - -T 5 -t 1 , Output: ctest-nginx-pod-07484179 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-10-27 19:56:04,178 - DEBUG - [Pod Pod ctest-busybox-pod-25663481] Cmd wget http://10.47.255.249:80/ -O - -T 5 -t 1 passed 2025-10-27 19:56:04,178 - DEBUG - [Pod Pod ctest-busybox-pod-25663481] Cmd output: ctest-nginx-pod-07484179 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-10-27 19:56:04,227 - DEBUG - [Pod ctest-busybox-pod-25663481] Cmd: wget http://10.47.255.249:80/ -O - -T 5 -t 1 , Output: Connecting to 10.47.255.249:80 (10.47.255.249:80) writing to stdout - 100% |********************************| 25 0:00:00 ETA written to stdout ctest-nginx-pod-24948669 2025-10-27 19:56:04,227 - DEBUG - [Pod Pod ctest-busybox-pod-25663481] Cmd wget http://10.47.255.249:80/ -O - -T 5 -t 1 passed 2025-10-27 19:56:04,227 - DEBUG - [Pod Pod ctest-busybox-pod-25663481] Cmd output: Connecting to 10.47.255.249:80 (10.47.255.249:80) writing to stdout - 100% |********************************| 25 0:00:00 ETA written to stdout ctest-nginx-pod-24948669 2025-10-27 19:56:04,227 - INFO - Responses seen from all pods, lb seems fine.Hits : {'ctest-nginx-pod-24948669': 1, 'ctest-nginx-pod-07484179': 1} 2025-10-27 19:56:04,227 - WARNING - Nothing to delete parallely 2025-10-27 19:56:04,228 - INFO - Deleting pod default:ctest-busybox-pod-25663481 2025-10-27 19:56:04,237 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_VmListReq?uuid=4ebb8000-36ad-4899-8ee4-c860cc01d3ef 2025-10-27 19:56:04,245 - WARNING - Pod uuid 4ebb8000-36ad-4899-8ee4-c860cc01d3ef is still seen in agent 10.0.0.27 VM list 2025-10-27 19:56:09,246 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_VmListReq?uuid=4ebb8000-36ad-4899-8ee4-c860cc01d3ef 2025-10-27 19:56:09,253 - WARNING - Pod uuid 4ebb8000-36ad-4899-8ee4-c860cc01d3ef is still seen in agent 10.0.0.27 VM list 2025-10-27 19:56:14,254 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_VmListReq?uuid=4ebb8000-36ad-4899-8ee4-c860cc01d3ef 2025-10-27 19:56:14,260 - WARNING - Pod uuid 4ebb8000-36ad-4899-8ee4-c860cc01d3ef is still seen in agent 10.0.0.27 VM list 2025-10-27 19:56:19,261 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_VmListReq?uuid=4ebb8000-36ad-4899-8ee4-c860cc01d3ef 2025-10-27 19:56:19,269 - WARNING - Pod uuid 4ebb8000-36ad-4899-8ee4-c860cc01d3ef is still seen in agent 10.0.0.27 VM list 2025-10-27 19:56:24,270 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_VmListReq?uuid=4ebb8000-36ad-4899-8ee4-c860cc01d3ef 2025-10-27 19:56:24,278 - WARNING - Pod uuid 4ebb8000-36ad-4899-8ee4-c860cc01d3ef is still seen in agent 10.0.0.27 VM list 2025-10-27 19:56:29,279 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_VmListReq?uuid=4ebb8000-36ad-4899-8ee4-c860cc01d3ef 2025-10-27 19:56:29,285 - WARNING - Pod uuid 4ebb8000-36ad-4899-8ee4-c860cc01d3ef is still seen in agent 10.0.0.27 VM list 2025-10-27 19:56:34,286 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_VmListReq?uuid=4ebb8000-36ad-4899-8ee4-c860cc01d3ef 2025-10-27 19:56:34,299 - WARNING - Pod uuid 4ebb8000-36ad-4899-8ee4-c860cc01d3ef is still seen in agent 10.0.0.27 VM list 2025-10-27 19:56:39,299 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_VmListReq?uuid=4ebb8000-36ad-4899-8ee4-c860cc01d3ef 2025-10-27 19:56:39,306 - DEBUG - Pod 4ebb8000-36ad-4899-8ee4-c860cc01d3ef is not in agent 10.0.0.27 VM list 2025-10-27 19:56:39,306 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:ef3a4388-b36e-11f0-9728-fa163e5a2726 2025-10-27 19:56:39,313 - DEBUG - VMI ef3a4388-b36e-11f0-9728-fa163e5a2726 is removed from agent 10.0.0.27 2025-10-27 19:56:39,313 - INFO - Verified that pod ctest-busybox-pod-25663481 is removed in agent 2025-10-27 19:56:39,313 - INFO - Deleting Ingress : ctest-nginx-ingress-04042857 2025-10-27 19:56:39,318 - DEBUG - Requesting: http://10.0.0.19:8108/Snh_LoadbalancerDatabaseList?x=13da381d-41e4-4b54-a8e5-06213dd8901b 2025-10-27 19:56:39,323 - ERROR - Ingress ctest-nginx-ingress-04042857 with uuid 13da381d-41e4-4b54-a8e5-06213dd8901b still found in kube manager 2025-10-27 19:56:40,324 - DEBUG - Requesting: http://10.0.0.19:8108/Snh_LoadbalancerDatabaseList?x=13da381d-41e4-4b54-a8e5-06213dd8901b 2025-10-27 19:56:40,330 - INFO - Ingress ctest-nginx-ingress-04042857 with uuid 13da381d-41e4-4b54-a8e5-06213dd8901b deleted successfully from kube manager 2025-10-27 19:56:40,333 - INFO - Verifications on Ingress %s cleanup passed 2025-10-27 19:56:40,334 - INFO - Deleting the FIP pool __fip_pool_public__ 2025-10-27 19:56:40,442 - DEBUG - Requesting: http://10.0.0.19:8083/Snh_IFMapTableShowReq?table_name=floating-ip-pool&search_string=floating-ip-pool:default-domain:k8s-default:__public__:__fip_pool_public__ 2025-10-27 19:56:40,447 - DEBUG - Control-node Ifmap-view does not have FIP pool __fip_pool_public__ information 2025-10-27 19:56:40,447 - INFO - Deleting VN __public__ 2025-10-27 19:56:40,611 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/ae3660f5-5c01-4dbb-abe3-9d94f8c74236 2025-10-27 19:56:40,617 - DEBUG - Response Code: 404 2025-10-27 19:56:40,617 - DEBUG - Requesting: http://10.0.0.19:8082/domains 2025-10-27 19:56:40,624 - DEBUG - Requesting: http://10.0.0.19:8082/domain/78836558-eb45-4857-b85b-0e64e6b31822 2025-10-27 19:56:40,634 - DEBUG - Requesting: http://10.0.0.19:8082/project/36bdf51a-f0c5-45de-ac38-1f8691bba476 2025-10-27 19:56:40,680 - INFO - Validated that VN __public__ is not found in API Server 2025-10-27 19:56:40,680 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_VnListReq?name=default-domain:k8s-default:__public__ 2025-10-27 19:56:40,707 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_VrfListReq?name=default-domain:k8s-default:__public__:__public__ 2025-10-27 19:56:40,721 - DEBUG - VN __public__ is not present in Agent 10.0.0.27 2025-10-27 19:56:40,721 - INFO - Validated that VN __public__ is not in any agent 2025-10-27 19:56:40,721 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_VrfListReq?name=default-domain:k8s-default:__public__:__public__ 2025-10-27 19:56:40,735 - DEBUG - Requesting: http://10.0.0.19:8083/Snh_ShowRoutingInstanceReq?name=default-domain:k8s-default:__public__:__public__ 2025-10-27 19:56:40,747 - DEBUG - Requesting: http://10.0.0.19:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:k8s-default:__public__ 2025-10-27 19:56:40,758 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN __public__ info 2025-10-27 19:56:40,758 - INFO - Deleting pod default:ctest-nginx-pod-07484179 2025-10-27 19:56:40,772 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_VmListReq?uuid=4a2face6-8875-478c-94ed-c0ca0d4b3716 2025-10-27 19:56:40,797 - WARNING - Pod uuid 4a2face6-8875-478c-94ed-c0ca0d4b3716 is still seen in agent 10.0.0.27 VM list 2025-10-27 19:56:45,797 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_VmListReq?uuid=4a2face6-8875-478c-94ed-c0ca0d4b3716 2025-10-27 19:56:45,805 - DEBUG - Pod 4a2face6-8875-478c-94ed-c0ca0d4b3716 is not in agent 10.0.0.27 VM list 2025-10-27 19:56:45,805 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:ecb64896-b36e-11f0-9728-fa163e5a2726 2025-10-27 19:56:45,811 - DEBUG - VMI ecb64896-b36e-11f0-9728-fa163e5a2726 is removed from agent 10.0.0.27 2025-10-27 19:56:45,811 - INFO - Verified that pod ctest-nginx-pod-07484179 is removed in agent 2025-10-27 19:56:45,811 - INFO - Deleting pod default:ctest-nginx-pod-24948669 2025-10-27 19:56:45,837 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_VmListReq?uuid=699575ca-47a5-4a9d-b8d8-e06b7c56d3fc 2025-10-27 19:56:45,854 - WARNING - Pod uuid 699575ca-47a5-4a9d-b8d8-e06b7c56d3fc is still seen in agent 10.0.0.27 VM list 2025-10-27 19:56:50,854 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_VmListReq?uuid=699575ca-47a5-4a9d-b8d8-e06b7c56d3fc 2025-10-27 19:56:50,862 - DEBUG - Pod 699575ca-47a5-4a9d-b8d8-e06b7c56d3fc is not in agent 10.0.0.27 VM list 2025-10-27 19:56:50,862 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:eba84012-b36e-11f0-9728-fa163e5a2726 2025-10-27 19:56:50,868 - DEBUG - VMI eba84012-b36e-11f0-9728-fa163e5a2726 is removed from agent 10.0.0.27 2025-10-27 19:56:50,869 - INFO - Verified that pod ctest-nginx-pod-24948669 is removed in agent 2025-10-27 19:56:50,869 - INFO - Deleting service : ctest-nginx-svc-10318278 2025-10-27 19:56:51,108 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_AgentXmppConnectionStatusReq? 2025-10-27 19:56:51,114 - DEBUG - No XMPP flaps were noticed during the test
2025-10-27 19:56:51,114 - INFO - END TEST : test_ingress_ip_assignment : PASSED[0:01:11]
2025-10-27 19:56:51,114 - INFO - -------------------------------------------------------------------------------- 2025-10-27 19:56:57,602 - DEBUG - [10.0.0.19]: Running cmd : docker exec --privileged -it contrail-kubernetes-master-kubemanager-1 /bin/bash -c 'grep "^[ ]*cluster_project" /etc/contrail/contrail-kubernetes.conf' 2025-10-27 19:56:57,769 - DEBUG - Output : cluster_project={} 2025-10-27 19:56:57,902 - DEBUG - [10.0.0.19]: Running cmd : docker exec --privileged -it contrail-kubernetes-master-kubemanager-1 /bin/bash -c 'netstat -antp | grep :8108 | grep LISTEN' 2025-10-27 19:56:58,082 - DEBUG - Output : tcp 0 0 0.0.0.0:8108 0.0.0.0:* LISTEN 1/python3 2025-10-27 19:56:58,087 - DEBUG - [10.0.0.19]: Running cmd : docker exec --privileged -it contrail-kubernetes-master-kubemanager-1 /bin/bash -c 'grep "^[ ]*cluster_project" /etc/contrail/contrail-kubernetes.conf' 2025-10-27 19:56:58,292 - DEBUG - Output : cluster_project={} 2025-10-27 19:57:13,503 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2025-10-27 19:57:13,542 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2025-10-27 19:57:13,618 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2025-10-27 19:57:13,668 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2025-10-27 19:57:13,751 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2025-10-27 19:57:13,843 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2025-10-27 19:57:18,888 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2025-10-27 19:57:18,967 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2025-10-27 19:57:19,266 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_AgentXmppConnectionStatusReq? 2025-10-27 19:57:22,966 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_ApplicationPolicySetReq? 2025-10-27 19:57:22,974 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_AclReq? 2025-10-27 19:57:23,000 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_AclReq? 2025-10-27 19:57:25,030 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_AclReq? 2025-10-27 20:00:25,341 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_AgentXmppConnectionStatusReq? 2025-10-27 20:00:25,399 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_VmListReq?uuid=d3ce854a-169b-4db4-96f0-3702706b5bef 2025-10-27 20:00:25,413 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_VmListReq?uuid=b8ced336-31a1-4f8a-9cf2-1edba0de79ef 2025-10-27 20:00:25,419 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_VmListReq?uuid=0bd07498-b2db-41a5-993a-d7901fd6ea57 2025-10-27 20:00:25,423 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_VmListReq?uuid=27298ee7-edc0-454f-a54b-5d6fb927e9c0 2025-10-27 20:00:25,429 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_VmListReq?uuid=6ddbe031-68fb-4300-ae57-4e51266a0474 2025-10-27 20:00:25,436 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_VmListReq?uuid=d4b4a4d6-0f2d-4d39-a724-01c48ca028e3 2025-10-27 20:00:25,440 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_VmListReq?uuid=65819771-9710-4e95-950f-4d2cb76b3854 2025-10-27 20:00:25,446 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_VmListReq?uuid=b12717df-96bf-4478-8716-618159a43c26 2025-10-27 20:00:30,476 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_VmListReq?uuid=6ddbe031-68fb-4300-ae57-4e51266a0474 2025-10-27 20:00:30,477 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_VmListReq?uuid=d3ce854a-169b-4db4-96f0-3702706b5bef 2025-10-27 20:00:30,480 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_VmListReq?uuid=65819771-9710-4e95-950f-4d2cb76b3854 2025-10-27 20:00:30,480 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_VmListReq?uuid=d4b4a4d6-0f2d-4d39-a724-01c48ca028e3 2025-10-27 20:00:30,481 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_VmListReq?uuid=b8ced336-31a1-4f8a-9cf2-1edba0de79ef 2025-10-27 20:00:30,482 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_VmListReq?uuid=0bd07498-b2db-41a5-993a-d7901fd6ea57 2025-10-27 20:00:30,485 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_VmListReq?uuid=27298ee7-edc0-454f-a54b-5d6fb927e9c0 2025-10-27 20:00:30,488 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:18efc0b8-b36f-11f0-9728-fa163e5a2726 2025-10-27 20:00:30,489 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_VmListReq?uuid=b12717df-96bf-4478-8716-618159a43c26 2025-10-27 20:00:30,505 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:1975adcc-b36f-11f0-9728-fa163e5a2726 2025-10-27 20:00:30,506 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:1a7941ca-b36f-11f0-9728-fa163e5a2726 2025-10-27 20:00:30,513 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:1a036252-b36f-11f0-9728-fa163e5a2726 2025-10-27 20:00:35,487 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_VmListReq?uuid=6ddbe031-68fb-4300-ae57-4e51266a0474 2025-10-27 20:00:35,512 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_VmListReq?uuid=0bd07498-b2db-41a5-993a-d7901fd6ea57 2025-10-27 20:00:35,515 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_VmListReq?uuid=b12717df-96bf-4478-8716-618159a43c26 2025-10-27 20:00:35,517 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_VmListReq?uuid=27298ee7-edc0-454f-a54b-5d6fb927e9c0 2025-10-27 20:00:40,494 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_VmListReq?uuid=6ddbe031-68fb-4300-ae57-4e51266a0474 2025-10-27 20:00:40,527 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_VmListReq?uuid=0bd07498-b2db-41a5-993a-d7901fd6ea57 2025-10-27 20:00:40,529 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_VmListReq?uuid=b12717df-96bf-4478-8716-618159a43c26 2025-10-27 20:00:40,530 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_VmListReq?uuid=27298ee7-edc0-454f-a54b-5d6fb927e9c0 2025-10-27 20:00:45,503 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_VmListReq?uuid=6ddbe031-68fb-4300-ae57-4e51266a0474 2025-10-27 20:00:45,541 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_VmListReq?uuid=b12717df-96bf-4478-8716-618159a43c26 2025-10-27 20:00:45,542 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_VmListReq?uuid=27298ee7-edc0-454f-a54b-5d6fb927e9c0 2025-10-27 20:00:45,543 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_VmListReq?uuid=0bd07498-b2db-41a5-993a-d7901fd6ea57 2025-10-27 20:00:50,513 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_VmListReq?uuid=6ddbe031-68fb-4300-ae57-4e51266a0474 2025-10-27 20:00:50,554 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_VmListReq?uuid=b12717df-96bf-4478-8716-618159a43c26 2025-10-27 20:00:50,555 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_VmListReq?uuid=27298ee7-edc0-454f-a54b-5d6fb927e9c0 2025-10-27 20:00:50,556 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_VmListReq?uuid=0bd07498-b2db-41a5-993a-d7901fd6ea57 2025-10-27 20:00:55,523 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_VmListReq?uuid=6ddbe031-68fb-4300-ae57-4e51266a0474 2025-10-27 20:00:55,566 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_VmListReq?uuid=b12717df-96bf-4478-8716-618159a43c26 2025-10-27 20:00:55,568 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_VmListReq?uuid=27298ee7-edc0-454f-a54b-5d6fb927e9c0 2025-10-27 20:00:55,569 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_VmListReq?uuid=0bd07498-b2db-41a5-993a-d7901fd6ea57 2025-10-27 20:01:00,532 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_VmListReq?uuid=6ddbe031-68fb-4300-ae57-4e51266a0474 2025-10-27 20:01:00,542 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:1c355918-b36f-11f0-9728-fa163e5a2726 2025-10-27 20:01:00,602 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_VmListReq?uuid=27298ee7-edc0-454f-a54b-5d6fb927e9c0 2025-10-27 20:01:00,603 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_VmListReq?uuid=0bd07498-b2db-41a5-993a-d7901fd6ea57 2025-10-27 20:01:00,604 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_VmListReq?uuid=b12717df-96bf-4478-8716-618159a43c26 2025-10-27 20:01:00,617 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:1b61e312-b36f-11f0-9728-fa163e5a2726 2025-10-27 20:01:00,619 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:1bcc43f6-b36f-11f0-9728-fa163e5a2726 2025-10-27 20:01:00,621 - DEBUG - Requesting: http://10.0.0.27:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:1ae80b5a-b36f-11f0-9728-fa163e5a2726