2025-09-11 16:47:04,334 - DEBUG - [10.0.0.33]: Running cmd : hostname
2025-09-11 16:47:04,595 - DEBUG - Output : cn-jenkins-deploy-platform-juju-k8s-1474-1
2025-09-11 16:47:04,595 - DEBUG - [10.0.0.33]: Running cmd : hostname -f
2025-09-11 16:47:04,629 - DEBUG - Output : cn-jenkins-deploy-platform-juju-k8s-1474-1
2025-09-11 16:47:04,629 - 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-11 16:47:04,683 - DEBUG - Output : NAMES
contrail_test_ppPLuO6Vm
contrail-kubernetes-master-kubemanager-1
analytics_snmp-nodemgr-1
analytics_snmp-snmp-collector-1
analytics_snmp-topology-1
analytics_alarm-nodemgr-1
analytics_alarm-alarm-gen-1
analytics_alarm-kafka-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-dns-1
control-control-1
control-nodemgr-1
config_database-zookeeper-1
config_database-rabbitmq-1
config_database-cassandra-1
config_database-nodemgr-1
config_api-devicemgr-1
config_api-dnsmasq-1
config_api-schema-1
config_api-nodemgr-1
config_api-svcmonitor-1
config_api-api-1
2025-09-11 16:47:04,684 - DEBUG - [10.0.0.33]: Running cmd : ip -4 -o addr show | awk '{print $4}'
2025-09-11 16:47:04,727 - DEBUG - Output : 127.0.0.1/8
10.0.0.33/24
252.33.0.1/8
10.214.236.1/24
172.17.0.1/16
2025-09-11 16:47:04,730 - DEBUG - [10.0.0.33]: Running cmd : getent hosts 10.0.0.33 | head -n 1 | awk '{print $2}'
2025-09-11 16:47:04,773 - DEBUG - Output : cn-jenkins-deploy-platform-juju-k8s-1474-1
2025-09-11 16:47:04,872 - DEBUG - [10.0.0.249]: Running cmd : hostname
2025-09-11 16:47:05,084 - DEBUG - Output : an-jenkins-deploy-platform-juju-k8s-1474-1
2025-09-11 16:47:05,084 - DEBUG - [10.0.0.249]: Running cmd : hostname -f
2025-09-11 16:47:05,161 - DEBUG - Output : an-jenkins-deploy-platform-juju-k8s-1474-1
2025-09-11 16:47:05,161 - DEBUG - [10.0.0.249]: 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-11 16:47:05,216 - DEBUG - Output : NAMES
vrouter-vrouter-agent-1
vrouter-nodemgr-1
2025-09-11 16:47:05,217 - DEBUG - [10.0.0.249]: Running cmd : ip -4 -o addr show dev vhost0 | awk '{print $4}'
2025-09-11 16:47:05,284 - DEBUG - Output : 10.0.0.249/24
2025-09-11 16:47:05,284 - DEBUG - [10.0.0.249]: Running cmd : getent hosts 10.0.0.249 | head -n 1 | awk '{print $2}'
2025-09-11 16:47:05,319 - DEBUG - Output : an-jenkins-deploy-platform-juju-k8s-1474-1
2025-09-11 16:47:05,391 - INFO - Using existing project ['default-domain', 'k8s-default'](1d44ef42-4b5b-4002-84f9-068f9085e2b7)
2025-09-11 16:47:05,442 - INFO - Using existing project ['default-domain', 'k8s-default'](1d44ef42-4b5b-4002-84f9-068f9085e2b7)
2025-09-11 16:47:05,548 - INFO - ================================================================================
2025-09-11 16:47:05,548 - INFO - STARTING TEST : test_ingress_ip_assignment
2025-09-11 16:47:05,548 - 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-11 16:47:05,781 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_AgentXmppConnectionStatusReq?
2025-09-11 16:47:05,788 - DEBUG - Nothing to compare xmpp stats {'10.0.0.249': {'10.0.0.33': '0'}} with
2025-09-11 16:47:05,788 - INFO - Initial checks done. Running the testcase now
2025-09-11 16:47:05,788 - INFO -
2025-09-11 16:47:05,791 - INFO - Namespace default already exists
2025-09-11 16:47:05,791 - DEBUG - [10.0.0.33]: Running cmd : docker exec --privileged -it contrail-kubernetes-master-kubemanager-1 /bin/bash -c 'grep "^[ ]*cluster_project" /etc/contrail/contrail-kubernetes.conf'
2025-09-11 16:47:05,916 - DEBUG - Output : cluster_project={}
2025-09-11 16:47:05,955 - INFO - Project default-domain:k8s-default for Namespace default is seen in contrail-api
2025-09-11 16:47:05,955 - DEBUG - Project uuid in Contrail is 1d44ef42-4b5b-4002-84f9-068f9085e2b7
2025-09-11 16:47:05,955 - DEBUG - [10.0.0.33]: Running cmd : docker exec --privileged -it contrail-kubernetes-master-kubemanager-1 /bin/bash -c 'netstat -antp | grep :8108 | grep LISTEN'
2025-09-11 16:47:06,070 - DEBUG - Output : tcp 0 0 0.0.0.0:8108 0.0.0.0:* LISTEN 1/python3
2025-09-11 16:47:06,071 - DEBUG - Requesting: http://10.0.0.33:8108/Snh_NamespaceDatabaseList?namespace_uuid=6ddc1f25-0232-4de2-a01c-73492c0f159a
2025-09-11 16:47:06,075 - INFO - Namespace default with uuid 6ddc1f25-0232-4de2-a01c-73492c0f159a found in kube manager
2025-09-11 16:47:06,075 - INFO - Namespace default verification passed
2025-09-11 16:47:06,078 - DEBUG - Service ctest-nginx-svc-40970150 not present
2025-09-11 16:47:06,078 - INFO - Creating service ctest-nginx-svc-40970150
2025-09-11 16:47:06,093 - INFO - Created Service ctest-nginx-svc-40970150
2025-09-11 16:47:06,100 - DEBUG - Pod ctest-nginx-pod-79787389 not present
2025-09-11 16:47:06,101 - INFO - Creating Pod ctest-nginx-pod-79787389
2025-09-11 16:47:06,151 - DEBUG - Node for Pod ctest-nginx-pod-79787389 not yet populated
2025-09-11 16:47:09,159 - DEBUG - Pod : ctest-nginx-pod-79787389 UUID is b4acac58-4c71-4bf4-b483-213aa3994420
2025-09-11 16:47:09,161 - DEBUG - Pod ctest-nginx-pod-88631941 not present
2025-09-11 16:47:09,161 - INFO - Creating Pod ctest-nginx-pod-88631941
2025-09-11 16:47:09,195 - DEBUG - Pod : ctest-nginx-pod-88631941 UUID is c915a954-40c8-44d4-a459-00d2ab77e617
2025-09-11 16:47:09,414 - INFO - Created VN __public__, UUID :05c054c5-b03a-42bf-b399-8c31e3e277cd
2025-09-11 16:47:09,725 - DEBUG - Requesting: http://10.0.0.33:8082/domains
2025-09-11 16:47:09,730 - DEBUG - Requesting: http://10.0.0.33:8082/domain/71eec0fd-a95b-49d1-88ba-aaea85aa6e6a
2025-09-11 16:47:09,746 - DEBUG - Requesting: http://10.0.0.33:8082/project/1d44ef42-4b5b-4002-84f9-068f9085e2b7
2025-09-11 16:47:09,791 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/05c054c5-b03a-42bf-b399-8c31e3e277cd
2025-09-11 16:47:09,838 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/05c054c5-b03a-42bf-b399-8c31e3e277cd
2025-09-11 16:47:09,847 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/c95808a5-372d-47c7-b168-19541b331e32
2025-09-11 16:47:09,854 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/c95808a5-372d-47c7-b168-19541b331e32
2025-09-11 16:47:09,859 - DEBUG - Requesting: http://10.0.0.33:8082/route-target/f4d57d51-d72e-4823-aea2-f1694042fc2d
2025-09-11 16:47:09,864 - DEBUG - Route Targets: ['target:64512:8000006']
2025-09-11 16:47:09,864 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/05c054c5-b03a-42bf-b399-8c31e3e277cd
2025-09-11 16:47:09,871 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/c95808a5-372d-47c7-b168-19541b331e32
2025-09-11 16:47:09,893 - INFO - Verified VN network id 13 for VN 05c054c5-b03a-42bf-b399-8c31e3e277cd
2025-09-11 16:47:09,893 - INFO - Verifications in API Server for VN __public__ passed
2025-09-11 16:47:09,893 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/05c054c5-b03a-42bf-b399-8c31e3e277cd
2025-09-11 16:47:09,902 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/c95808a5-372d-47c7-b168-19541b331e32
2025-09-11 16:47:09,910 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/c95808a5-372d-47c7-b168-19541b331e32
2025-09-11 16:47:09,917 - DEBUG - Requesting: http://10.0.0.33:8082/route-target/f4d57d51-d72e-4823-aea2-f1694042fc2d
2025-09-11 16:47:09,924 - DEBUG - Requesting: http://10.0.0.33:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:k8s-default:__public__
2025-09-11 16:47:09,929 - DEBUG - Control-node 10.0.0.33 : 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': '414424373759984319', 'uuid-lslong': '12941529150130386893'}, 'enable': 'true', 'created': '2025-09-11T16:47:09', 'last-modified': '2025-09-11T16:47:09', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.294149'}
2025-09-11 16:47:09,929 - DEBUG - Requesting: http://10.0.0.33:8083/Snh_ShowRoutingInstanceReq?name=default-domain:k8s-default:__public__:__public__
2025-09-11 16:47:09,940 - DEBUG - Route Targets: ['target:64512:8000006']
2025-09-11 16:47:09,940 - INFO - On all control nodes, Config, RI and RT verification for VN __public__ passed
2025-09-11 16:47:09,941 - DEBUG - ====Verifying policy data for __public__ in API_Server ======
2025-09-11 16:47:09,941 - DEBUG - Requesting: http://10.0.0.33:8082/domains
2025-09-11 16:47:09,946 - DEBUG - Requesting: http://10.0.0.33:8082/domain/71eec0fd-a95b-49d1-88ba-aaea85aa6e6a
2025-09-11 16:47:09,952 - DEBUG - Requesting: http://10.0.0.33:8082/project/1d44ef42-4b5b-4002-84f9-068f9085e2b7
2025-09-11 16:47:10,012 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/05c054c5-b03a-42bf-b399-8c31e3e277cd
2025-09-11 16:47:10,025 - DEBUG - =>VN __public__ has no policy to be verified
2025-09-11 16:47:10,025 - DEBUG - Verifying the vn in opserver
2025-09-11 16:47:10,025 - DEBUG - Verifying the default-domain:k8s-default:__public__ virtual network link through opserver 10.0.0.33
2025-09-11 16:47:10,025 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2025-09-11 16:47:10,029 - DEBUG - vn link and name as {'name': 'default-domain:k8s-default:__public__', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:k8s-default:__public__?flat'}
2025-09-11 16:47:10,029 - INFO - Validated that VN default-domain:k8s-default:__public__ is found in opserver
2025-09-11 16:47:10,029 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VrfListReq?name=default-domain:k8s-default:__public__:__public__
2025-09-11 16:47:10,037 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VrfListReq?name=default-domain:k8s-default:__public__:__public__
2025-09-11 16:47:10,043 - DEBUG - Do not have enough data to verify VN in agent
2025-09-11 16:47:10,043 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VrfListReq?name=default-domain:k8s-default:__public__:__public__
2025-09-11 16:47:10,049 - DEBUG - VRF ids for VN __public__: {}
2025-09-11 16:47:10,140 - INFO - Creating Floating IP pool __fip_pool_public__ in API Server
2025-09-11 16:47:10,243 - DEBUG - Requesting: http://10.0.0.33:8082/domains
2025-09-11 16:47:10,247 - DEBUG - Requesting: http://10.0.0.33:8082/domain/71eec0fd-a95b-49d1-88ba-aaea85aa6e6a
2025-09-11 16:47:10,253 - DEBUG - Requesting: http://10.0.0.33:8082/project/1d44ef42-4b5b-4002-84f9-068f9085e2b7
2025-09-11 16:47:10,286 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/05c054c5-b03a-42bf-b399-8c31e3e277cd
2025-09-11 16:47:10,295 - DEBUG - Requesting: http://10.0.0.33:8082/floating-ip-pool/7b1b90e9-bc3b-4a67-9b69-5cc0221ede96
2025-09-11 16:47:10,303 - DEBUG - Requesting: http://10.0.0.33:8082/domains
2025-09-11 16:47:10,308 - DEBUG - Requesting: http://10.0.0.33:8082/domain/71eec0fd-a95b-49d1-88ba-aaea85aa6e6a
2025-09-11 16:47:10,322 - DEBUG - Requesting: http://10.0.0.33:8082/project/1d44ef42-4b5b-4002-84f9-068f9085e2b7
2025-09-11 16:47:10,370 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/05c054c5-b03a-42bf-b399-8c31e3e277cd
2025-09-11 16:47:10,378 - DEBUG - FIP Pool __fip_pool_public__ found in API Server
2025-09-11 16:47:10,378 - INFO - Verification for FIP pool __fip_pool_public__ in API Server passed
2025-09-11 16:47:10,385 - DEBUG - Requesting: http://10.0.0.33:8083/Snh_IFMapTableShowReq?table_name=floating-ip-pool&search_string=floating-ip-pool:default-domain:k8s-default:__public__:__fip_pool_public__
2025-09-11 16:47:10,391 - DEBUG - Control-node Ifmap-view has FIP pool __fip_pool_public__ information
2025-09-11 16:47:10,391 - INFO - Verification for FIP pool __fip_pool_public__ in Control-node passed
2025-09-11 16:47:10,393 - DEBUG - Ingress ctest-nginx-ingress-08647764 not present
2025-09-11 16:47:10,394 - INFO - Creating Ingress ctest-nginx-ingress-08647764
2025-09-11 16:47:10,401 - INFO - Created Ingress ctest-nginx-ingress-08647764
2025-09-11 16:47:10,405 - DEBUG - Cluster IP not yet seen for Ingress ctest-nginx-ingress-08647764
2025-09-11 16:47:13,409 - DEBUG - For Ingress ctest-nginx-ingress-08647764, Cluster IP: 10.47.255.249, External IPs ['138.198.156.188']
2025-09-11 16:47:13,410 - INFO - Verifications in k8s passed for Ingress ctest-nginx-ingress-08647764
2025-09-11 16:47:13,410 - DEBUG - Requesting: http://10.0.0.33:8108/Snh_LoadbalancerDatabaseList?x=998497a6-652f-4f1d-8fa3-86f751c3b692
2025-09-11 16:47:13,413 - INFO - Ingress ctest-nginx-ingress-08647764 with uuid 998497a6-652f-4f1d-8fa3-86f751c3b692 found in kube manager
2025-09-11 16:47:13,413 - INFO - Ingress ctest-nginx-ingress-08647764 verification passed
2025-09-11 16:47:13,416 - DEBUG - Pod ctest-busybox-pod-61875475 not present
2025-09-11 16:47:13,417 - INFO - Creating Pod ctest-busybox-pod-61875475
2025-09-11 16:47:13,458 - DEBUG - Pod : ctest-busybox-pod-61875475 UUID is dfb0aa70-fab6-43dc-b445-57a2db05c9ca
2025-09-11 16:47:13,463 - DEBUG - Pod ctest-nginx-pod-79787389 not in running state.Currently in Pending
2025-09-11 16:47:18,470 - DEBUG - Pod ctest-nginx-pod-79787389 not in running state.Currently in Pending
2025-09-11 16:47:23,478 - INFO - Pod ctest-nginx-pod-79787389 is in running state.Got IP 10.47.255.251
2025-09-11 16:47:23,494 - DEBUG - Pod ctest-nginx-pod-79787389 has vmi f42040aa-8f2e-11f0-86bc-fa163ea1df27
2025-09-11 16:47:23,494 - INFO - Verified pod ctest-nginx-pod-79787389 in contrail-api
2025-09-11 16:47:23,494 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,
2025-09-11 16:47:23,505 - DEBUG - VMI f42040aa-8f2e-11f0-86bc-fa163ea1df27 is active in agent 10.0.0.249
2025-09-11 16:47:23,506 - INFO - Verified Pod ctest-nginx-pod-79787389 in agent 10.0.0.249
2025-09-11 16:47:23,506 - DEBUG - Requesting: http://10.0.0.33:8108/Snh_VirtualMachineDatabaseList?x=b4acac58-4c71-4bf4-b483-213aa3994420
2025-09-11 16:47:23,510 - INFO - Pod ctest-nginx-pod-79787389 with uuid b4acac58-4c71-4bf4-b483-213aa3994420 found in kube manager
2025-09-11 16:47:23,510 - INFO - Pod ctest-nginx-pod-79787389 verification passed
2025-09-11 16:47:23,578 - DEBUG - [Pod ctest-nginx-pod-79787389] Cmd: echo ctest-nginx-pod-79787389 > /usr/share/nginx/html/index.html, Output:
2025-09-11 16:47:23,584 - INFO - Pod ctest-nginx-pod-88631941 is in running state.Got IP 10.47.255.250
2025-09-11 16:47:23,651 - DEBUG - Pod ctest-nginx-pod-88631941 has vmi f531a3c6-8f2e-11f0-86bc-fa163ea1df27
2025-09-11 16:47:23,651 - INFO - Verified pod ctest-nginx-pod-88631941 in contrail-api
2025-09-11 16:47:23,651 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,
2025-09-11 16:47:23,661 - DEBUG - VMI f531a3c6-8f2e-11f0-86bc-fa163ea1df27 is active in agent 10.0.0.249
2025-09-11 16:47:23,661 - INFO - Verified Pod ctest-nginx-pod-88631941 in agent 10.0.0.249
2025-09-11 16:47:23,662 - DEBUG - Requesting: http://10.0.0.33:8108/Snh_VirtualMachineDatabaseList?x=c915a954-40c8-44d4-a459-00d2ab77e617
2025-09-11 16:47:23,665 - INFO - Pod ctest-nginx-pod-88631941 with uuid c915a954-40c8-44d4-a459-00d2ab77e617 found in kube manager
2025-09-11 16:47:23,666 - INFO - Pod ctest-nginx-pod-88631941 verification passed
2025-09-11 16:47:23,725 - DEBUG - [Pod ctest-nginx-pod-88631941] Cmd: echo ctest-nginx-pod-88631941 > /usr/share/nginx/html/index.html, Output:
2025-09-11 16:47:23,733 - INFO - Pod ctest-busybox-pod-61875475 is in running state.Got IP 10.47.255.248
2025-09-11 16:47:23,746 - DEBUG - Pod ctest-busybox-pod-61875475 has vmi f7bf8a68-8f2e-11f0-86bc-fa163ea1df27
2025-09-11 16:47:23,746 - INFO - Verified pod ctest-busybox-pod-61875475 in contrail-api
2025-09-11 16:47:23,746 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,
2025-09-11 16:47:23,756 - DEBUG - VMI f7bf8a68-8f2e-11f0-86bc-fa163ea1df27 is active in agent 10.0.0.249
2025-09-11 16:47:23,756 - INFO - Verified Pod ctest-busybox-pod-61875475 in agent 10.0.0.249
2025-09-11 16:47:23,756 - DEBUG - Requesting: http://10.0.0.33:8108/Snh_VirtualMachineDatabaseList?x=dfb0aa70-fab6-43dc-b445-57a2db05c9ca
2025-09-11 16:47:23,759 - INFO - Pod ctest-busybox-pod-61875475 with uuid dfb0aa70-fab6-43dc-b445-57a2db05c9ca found in kube manager
2025-09-11 16:47:23,759 - INFO - Pod ctest-busybox-pod-61875475 verification passed
2025-09-11 16:47:23,818 - DEBUG - [Pod ctest-busybox-pod-61875475] 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-88631941
2025-09-11 16:47:23,818 - DEBUG - [Pod Pod ctest-busybox-pod-61875475] Cmd wget http://10.47.255.249:80/ -O - -T 5 -t 1 passed
2025-09-11 16:47:23,818 - DEBUG - [Pod Pod ctest-busybox-pod-61875475] 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-88631941
2025-09-11 16:47:23,873 - DEBUG - [Pod ctest-busybox-pod-61875475] Cmd: wget http://10.47.255.249:80/ -O - -T 5 -t 1 , Output: ctest-nginx-pod-79787389
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-11 16:47:23,874 - DEBUG - [Pod Pod ctest-busybox-pod-61875475] Cmd wget http://10.47.255.249:80/ -O - -T 5 -t 1 passed
2025-09-11 16:47:23,874 - DEBUG - [Pod Pod ctest-busybox-pod-61875475] Cmd output: ctest-nginx-pod-79787389
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-11 16:47:23,874 - INFO - Responses seen from all pods, lb seems fine.Hits : {'ctest-nginx-pod-79787389': 1, 'ctest-nginx-pod-88631941': 1}
2025-09-11 16:47:23,874 - WARNING - Nothing to delete parallely
2025-09-11 16:47:23,875 - INFO - Deleting pod default:ctest-busybox-pod-61875475
2025-09-11 16:47:23,888 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VmListReq?uuid=dfb0aa70-fab6-43dc-b445-57a2db05c9ca
2025-09-11 16:47:23,894 - WARNING - Pod uuid dfb0aa70-fab6-43dc-b445-57a2db05c9ca is still seen in agent 10.0.0.249 VM list
2025-09-11 16:47:28,896 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VmListReq?uuid=dfb0aa70-fab6-43dc-b445-57a2db05c9ca
2025-09-11 16:47:28,903 - WARNING - Pod uuid dfb0aa70-fab6-43dc-b445-57a2db05c9ca is still seen in agent 10.0.0.249 VM list
2025-09-11 16:47:33,904 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VmListReq?uuid=dfb0aa70-fab6-43dc-b445-57a2db05c9ca
2025-09-11 16:47:33,912 - WARNING - Pod uuid dfb0aa70-fab6-43dc-b445-57a2db05c9ca is still seen in agent 10.0.0.249 VM list
2025-09-11 16:47:38,913 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VmListReq?uuid=dfb0aa70-fab6-43dc-b445-57a2db05c9ca
2025-09-11 16:47:38,920 - WARNING - Pod uuid dfb0aa70-fab6-43dc-b445-57a2db05c9ca is still seen in agent 10.0.0.249 VM list
2025-09-11 16:47:43,921 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VmListReq?uuid=dfb0aa70-fab6-43dc-b445-57a2db05c9ca
2025-09-11 16:47:43,927 - WARNING - Pod uuid dfb0aa70-fab6-43dc-b445-57a2db05c9ca is still seen in agent 10.0.0.249 VM list
2025-09-11 16:47:48,927 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VmListReq?uuid=dfb0aa70-fab6-43dc-b445-57a2db05c9ca
2025-09-11 16:47:48,939 - WARNING - Pod uuid dfb0aa70-fab6-43dc-b445-57a2db05c9ca is still seen in agent 10.0.0.249 VM list
2025-09-11 16:47:53,939 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VmListReq?uuid=dfb0aa70-fab6-43dc-b445-57a2db05c9ca
2025-09-11 16:47:53,946 - WARNING - Pod uuid dfb0aa70-fab6-43dc-b445-57a2db05c9ca is still seen in agent 10.0.0.249 VM list
2025-09-11 16:47:58,946 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VmListReq?uuid=dfb0aa70-fab6-43dc-b445-57a2db05c9ca
2025-09-11 16:47:58,952 - DEBUG - Pod dfb0aa70-fab6-43dc-b445-57a2db05c9ca is not in agent 10.0.0.249 VM list
2025-09-11 16:47:58,952 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:f7bf8a68-8f2e-11f0-86bc-fa163ea1df27
2025-09-11 16:47:58,960 - DEBUG - VMI f7bf8a68-8f2e-11f0-86bc-fa163ea1df27 is removed from agent 10.0.0.249
2025-09-11 16:47:58,960 - INFO - Verified that pod ctest-busybox-pod-61875475 is removed in agent
2025-09-11 16:47:58,960 - INFO - Deleting Ingress : ctest-nginx-ingress-08647764
2025-09-11 16:47:58,969 - DEBUG - Requesting: http://10.0.0.33:8108/Snh_LoadbalancerDatabaseList?x=998497a6-652f-4f1d-8fa3-86f751c3b692
2025-09-11 16:47:58,974 - ERROR - Ingress ctest-nginx-ingress-08647764 with uuid 998497a6-652f-4f1d-8fa3-86f751c3b692 still found in kube manager
2025-09-11 16:47:59,975 - DEBUG - Requesting: http://10.0.0.33:8108/Snh_LoadbalancerDatabaseList?x=998497a6-652f-4f1d-8fa3-86f751c3b692
2025-09-11 16:47:59,983 - ERROR - Ingress ctest-nginx-ingress-08647764 with uuid 998497a6-652f-4f1d-8fa3-86f751c3b692 still found in kube manager
2025-09-11 16:48:00,984 - DEBUG - Requesting: http://10.0.0.33:8108/Snh_LoadbalancerDatabaseList?x=998497a6-652f-4f1d-8fa3-86f751c3b692
2025-09-11 16:48:00,989 - INFO - Ingress ctest-nginx-ingress-08647764 with uuid 998497a6-652f-4f1d-8fa3-86f751c3b692 deleted successfully from kube manager
2025-09-11 16:48:00,990 - INFO - Verifications on Ingress %s cleanup passed
2025-09-11 16:48:00,990 - INFO - Deleting the FIP pool __fip_pool_public__
2025-09-11 16:48:01,047 - DEBUG - Requesting: http://10.0.0.33:8083/Snh_IFMapTableShowReq?table_name=floating-ip-pool&search_string=floating-ip-pool:default-domain:k8s-default:__public__:__fip_pool_public__
2025-09-11 16:48:01,053 - DEBUG - Control-node Ifmap-view does not have FIP pool __fip_pool_public__ information
2025-09-11 16:48:01,053 - INFO - Deleting VN __public__
2025-09-11 16:48:01,141 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/c95808a5-372d-47c7-b168-19541b331e32
2025-09-11 16:48:01,147 - DEBUG - Response Code: 404
2025-09-11 16:48:01,147 - DEBUG - Requesting: http://10.0.0.33:8082/domains
2025-09-11 16:48:01,153 - DEBUG - Requesting: http://10.0.0.33:8082/domain/71eec0fd-a95b-49d1-88ba-aaea85aa6e6a
2025-09-11 16:48:01,168 - DEBUG - Requesting: http://10.0.0.33:8082/project/1d44ef42-4b5b-4002-84f9-068f9085e2b7
2025-09-11 16:48:01,207 - INFO - Validated that VN __public__ is not found in API Server
2025-09-11 16:48:01,207 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VnListReq?name=default-domain:k8s-default:__public__
2025-09-11 16:48:01,215 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VrfListReq?name=default-domain:k8s-default:__public__:__public__
2025-09-11 16:48:01,224 - DEBUG - VN __public__ is not present in Agent 10.0.0.249
2025-09-11 16:48:01,224 - INFO - Validated that VN __public__ is not in any agent
2025-09-11 16:48:01,224 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VrfListReq?name=default-domain:k8s-default:__public__:__public__
2025-09-11 16:48:01,233 - DEBUG - Requesting: http://10.0.0.33:8083/Snh_ShowRoutingInstanceReq?name=default-domain:k8s-default:__public__:__public__
2025-09-11 16:48:01,238 - DEBUG - Requesting: http://10.0.0.33:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:k8s-default:__public__
2025-09-11 16:48:01,242 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN __public__ info
2025-09-11 16:48:01,242 - INFO - Deleting pod default:ctest-nginx-pod-88631941
2025-09-11 16:48:01,267 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VmListReq?uuid=c915a954-40c8-44d4-a459-00d2ab77e617
2025-09-11 16:48:01,281 - WARNING - Pod uuid c915a954-40c8-44d4-a459-00d2ab77e617 is still seen in agent 10.0.0.249 VM list
2025-09-11 16:48:06,281 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VmListReq?uuid=c915a954-40c8-44d4-a459-00d2ab77e617
2025-09-11 16:48:06,287 - DEBUG - Pod c915a954-40c8-44d4-a459-00d2ab77e617 is not in agent 10.0.0.249 VM list
2025-09-11 16:48:06,287 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:f531a3c6-8f2e-11f0-86bc-fa163ea1df27
2025-09-11 16:48:06,292 - DEBUG - VMI f531a3c6-8f2e-11f0-86bc-fa163ea1df27 is removed from agent 10.0.0.249
2025-09-11 16:48:06,292 - INFO - Verified that pod ctest-nginx-pod-88631941 is removed in agent
2025-09-11 16:48:06,292 - INFO - Deleting pod default:ctest-nginx-pod-79787389
2025-09-11 16:48:06,316 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VmListReq?uuid=b4acac58-4c71-4bf4-b483-213aa3994420
2025-09-11 16:48:06,321 - WARNING - Pod uuid b4acac58-4c71-4bf4-b483-213aa3994420 is still seen in agent 10.0.0.249 VM list
2025-09-11 16:48:11,322 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VmListReq?uuid=b4acac58-4c71-4bf4-b483-213aa3994420
2025-09-11 16:48:11,329 - DEBUG - Pod b4acac58-4c71-4bf4-b483-213aa3994420 is not in agent 10.0.0.249 VM list
2025-09-11 16:48:11,329 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:f42040aa-8f2e-11f0-86bc-fa163ea1df27
2025-09-11 16:48:11,334 - DEBUG - VMI f42040aa-8f2e-11f0-86bc-fa163ea1df27 is removed from agent 10.0.0.249
2025-09-11 16:48:11,334 - INFO - Verified that pod ctest-nginx-pod-79787389 is removed in agent
2025-09-11 16:48:11,334 - INFO - Deleting service : ctest-nginx-svc-40970150
2025-09-11 16:48:11,569 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_AgentXmppConnectionStatusReq?
2025-09-11 16:48:11,574 - DEBUG - No XMPP flaps were noticed during the test
2025-09-11 16:48:11,574 - INFO - END TEST : test_ingress_ip_assignment : PASSED[0:01:06]
2025-09-11 16:48:11,574 - INFO - --------------------------------------------------------------------------------
2025-09-11 16:48:18,004 - DEBUG - [10.0.0.33]: Running cmd : docker exec --privileged -it contrail-kubernetes-master-kubemanager-1 /bin/bash -c 'grep "^[ ]*cluster_project" /etc/contrail/contrail-kubernetes.conf'
2025-09-11 16:48:18,133 - DEBUG - Output : cluster_project={}
2025-09-11 16:48:18,220 - DEBUG - [10.0.0.33]: Running cmd : docker exec --privileged -it contrail-kubernetes-master-kubemanager-1 /bin/bash -c 'netstat -antp | grep :8108 | grep LISTEN'
2025-09-11 16:48:18,361 - DEBUG - Output : tcp 0 0 0.0.0.0:8108 0.0.0.0:* LISTEN 1/python3
2025-09-11 16:48:18,366 - DEBUG - [10.0.0.33]: Running cmd : docker exec --privileged -it contrail-kubernetes-master-kubemanager-1 /bin/bash -c 'grep "^[ ]*cluster_project" /etc/contrail/contrail-kubernetes.conf'
2025-09-11 16:48:18,480 - DEBUG - Output : cluster_project={}
2025-09-11 16:48:28,623 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,
2025-09-11 16:48:33,664 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,
2025-09-11 16:48:33,739 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,
2025-09-11 16:48:33,813 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,
2025-09-11 16:48:33,850 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,
2025-09-11 16:48:38,937 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,
2025-09-11 16:48:38,971 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,
2025-09-11 16:48:39,045 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,
2025-09-11 16:48:39,260 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_AgentXmppConnectionStatusReq?
2025-09-11 16:48:41,165 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_ApplicationPolicySetReq?
2025-09-11 16:48:41,173 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_AclReq?
2025-09-11 16:48:41,196 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_AclReq?
2025-09-11 16:48:43,219 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_AclReq?
2025-09-11 16:51:49,003 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_AgentXmppConnectionStatusReq?
2025-09-11 16:51:49,055 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VmListReq?uuid=a4a0685b-d0b0-41f0-9e14-5e6abcb12e49
2025-09-11 16:51:49,069 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VmListReq?uuid=8fcec07b-a7d6-48f1-9253-067fe59f5c3c
2025-09-11 16:51:49,075 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VmListReq?uuid=bfd81542-9db8-465d-ad48-98146e90ffa1
2025-09-11 16:51:49,080 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VmListReq?uuid=384e8be9-cec0-4d62-87ef-58fb4642bed6
2025-09-11 16:51:49,084 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VmListReq?uuid=bbc5e0d5-07a3-4a54-a5cc-610f93c3fa42
2025-09-11 16:51:49,091 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VmListReq?uuid=4b96be32-61de-4234-ac0b-41942e153c85
2025-09-11 16:51:49,100 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VmListReq?uuid=3995d076-ec95-4af8-b081-292d7a40e119
2025-09-11 16:51:49,104 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VmListReq?uuid=104584bd-b86d-46f2-a394-0a390f2662f4
2025-09-11 16:51:54,110 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VmListReq?uuid=a4a0685b-d0b0-41f0-9e14-5e6abcb12e49
2025-09-11 16:51:54,118 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:1ee39198-8f2f-11f0-86bc-fa163ea1df27
2025-09-11 16:51:54,123 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VmListReq?uuid=8fcec07b-a7d6-48f1-9253-067fe59f5c3c
2025-09-11 16:51:54,126 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VmListReq?uuid=104584bd-b86d-46f2-a394-0a390f2662f4
2025-09-11 16:51:54,128 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VmListReq?uuid=3995d076-ec95-4af8-b081-292d7a40e119
2025-09-11 16:51:54,129 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VmListReq?uuid=bbc5e0d5-07a3-4a54-a5cc-610f93c3fa42
2025-09-11 16:51:54,130 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VmListReq?uuid=384e8be9-cec0-4d62-87ef-58fb4642bed6
2025-09-11 16:51:54,131 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VmListReq?uuid=bfd81542-9db8-465d-ad48-98146e90ffa1
2025-09-11 16:51:54,134 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VmListReq?uuid=4b96be32-61de-4234-ac0b-41942e153c85
2025-09-11 16:51:54,136 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:1f56cc9e-8f2f-11f0-86bc-fa163ea1df27
2025-09-11 16:51:54,149 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:206d5dd2-8f2f-11f0-86bc-fa163ea1df27
2025-09-11 16:51:54,154 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:1fde3bfc-8f2f-11f0-86bc-fa163ea1df27
2025-09-11 16:51:59,154 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VmListReq?uuid=4b96be32-61de-4234-ac0b-41942e153c85
2025-09-11 16:51:59,156 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VmListReq?uuid=384e8be9-cec0-4d62-87ef-58fb4642bed6
2025-09-11 16:51:59,156 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VmListReq?uuid=3995d076-ec95-4af8-b081-292d7a40e119
2025-09-11 16:51:59,157 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VmListReq?uuid=104584bd-b86d-46f2-a394-0a390f2662f4
2025-09-11 16:52:04,169 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VmListReq?uuid=104584bd-b86d-46f2-a394-0a390f2662f4
2025-09-11 16:52:04,171 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VmListReq?uuid=4b96be32-61de-4234-ac0b-41942e153c85
2025-09-11 16:52:04,174 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VmListReq?uuid=3995d076-ec95-4af8-b081-292d7a40e119
2025-09-11 16:52:04,174 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VmListReq?uuid=384e8be9-cec0-4d62-87ef-58fb4642bed6
2025-09-11 16:52:09,186 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VmListReq?uuid=384e8be9-cec0-4d62-87ef-58fb4642bed6
2025-09-11 16:52:09,187 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VmListReq?uuid=104584bd-b86d-46f2-a394-0a390f2662f4
2025-09-11 16:52:09,189 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VmListReq?uuid=4b96be32-61de-4234-ac0b-41942e153c85
2025-09-11 16:52:09,190 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VmListReq?uuid=3995d076-ec95-4af8-b081-292d7a40e119
2025-09-11 16:52:14,201 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VmListReq?uuid=104584bd-b86d-46f2-a394-0a390f2662f4
2025-09-11 16:52:14,202 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VmListReq?uuid=4b96be32-61de-4234-ac0b-41942e153c85
2025-09-11 16:52:14,203 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VmListReq?uuid=3995d076-ec95-4af8-b081-292d7a40e119
2025-09-11 16:52:14,204 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VmListReq?uuid=384e8be9-cec0-4d62-87ef-58fb4642bed6
2025-09-11 16:52:19,216 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VmListReq?uuid=104584bd-b86d-46f2-a394-0a390f2662f4
2025-09-11 16:52:19,218 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VmListReq?uuid=3995d076-ec95-4af8-b081-292d7a40e119
2025-09-11 16:52:19,218 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VmListReq?uuid=4b96be32-61de-4234-ac0b-41942e153c85
2025-09-11 16:52:19,220 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VmListReq?uuid=384e8be9-cec0-4d62-87ef-58fb4642bed6
2025-09-11 16:52:24,254 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VmListReq?uuid=104584bd-b86d-46f2-a394-0a390f2662f4
2025-09-11 16:52:24,256 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VmListReq?uuid=4b96be32-61de-4234-ac0b-41942e153c85
2025-09-11 16:52:24,257 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VmListReq?uuid=384e8be9-cec0-4d62-87ef-58fb4642bed6
2025-09-11 16:52:24,258 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VmListReq?uuid=3995d076-ec95-4af8-b081-292d7a40e119
2025-09-11 16:52:24,269 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:21d1c618-8f2f-11f0-86bc-fa163ea1df27
2025-09-11 16:52:24,270 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:223ad7de-8f2f-11f0-86bc-fa163ea1df27
2025-09-11 16:52:24,272 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:2159f926-8f2f-11f0-86bc-fa163ea1df27
2025-09-11 16:52:24,273 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:20e89452-8f2f-11f0-86bc-fa163ea1df27