2025-11-03 17:42:00,392 - DEBUG - [10.0.0.249]: Running cmd : hostname 2025-11-03 17:42:00,635 - DEBUG - Output : cn-jenkins-deploy-platform-juju-k8s-1676-1 2025-11-03 17:42:00,636 - DEBUG - [10.0.0.249]: Running cmd : hostname -f 2025-11-03 17:42:00,670 - DEBUG - Output : cn-jenkins-deploy-platform-juju-k8s-1676-1 2025-11-03 17:42:00,670 - 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-11-03 17:42:00,737 - DEBUG - Output : NAMES contrail_test_NSHLcrXva contrail-kubernetes-master-kubemanager-1 webui-job-1 webui-web-1 control-named-1 control-nodemgr-1 control-dns-1 control-control-1 config_database-nodemgr-1 config_database-rabbitmq-1 config_database-cassandra-1 config_database-zookeeper-1 config_api-devicemgr-1 config_api-nodemgr-1 config_api-dnsmasq-1 config_api-api-1 config_api-svcmonitor-1 config_api-schema-1 analytics_database-cassandra-1 analytics_database-query-engine-1 analytics_database-nodemgr-1 redis-redis-1 analytics_snmp-nodemgr-1 analytics_snmp-topology-1 analytics_snmp-snmp-collector-1 analytics_alarm-kafka-1 analytics_alarm-alarm-gen-1 analytics_alarm-nodemgr-1 analytics-nodemgr-1 analytics-api-1 analytics-collector-1 2025-11-03 17:42:00,738 - DEBUG - [10.0.0.249]: Running cmd : ip -4 -o addr show | awk '{print $4}' 2025-11-03 17:42:00,772 - DEBUG - Output : 127.0.0.1/8 10.0.0.249/24 252.249.0.1/8 10.231.252.1/24 172.17.0.1/16 2025-11-03 17:42:00,772 - DEBUG - [10.0.0.249]: Running cmd : getent hosts 10.0.0.249 | head -n 1 | awk '{print $2}' 2025-11-03 17:42:00,847 - DEBUG - Output : cn-jenkins-deploy-platform-juju-k8s-1676-1 2025-11-03 17:42:00,904 - DEBUG - [10.0.0.241]: Running cmd : hostname 2025-11-03 17:42:01,156 - DEBUG - Output : an-jenkins-deploy-platform-juju-k8s-1676-1 2025-11-03 17:42:01,157 - DEBUG - [10.0.0.241]: Running cmd : hostname -f 2025-11-03 17:42:01,231 - DEBUG - Output : an-jenkins-deploy-platform-juju-k8s-1676-1 2025-11-03 17:42:01,231 - DEBUG - [10.0.0.241]: 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-11-03 17:42:01,277 - DEBUG - Output : NAMES vrouter-vrouter-agent-1 vrouter-nodemgr-1 2025-11-03 17:42:01,277 - DEBUG - [10.0.0.241]: Running cmd : ip -4 -o addr show dev vhost0 | awk '{print $4}' 2025-11-03 17:42:01,355 - DEBUG - Output : 10.0.0.241/24 2025-11-03 17:42:01,355 - DEBUG - [10.0.0.241]: Running cmd : getent hosts 10.0.0.241 | head -n 1 | awk '{print $2}' 2025-11-03 17:42:01,389 - DEBUG - Output : an-jenkins-deploy-platform-juju-k8s-1676-1 2025-11-03 17:42:01,526 - INFO - Using existing project ['default-domain', 'k8s-default'](962435ac-89ab-45f8-bec8-f56e7cdd7e3b) 2025-11-03 17:42:01,632 - INFO - Using existing project ['default-domain', 'k8s-default'](962435ac-89ab-45f8-bec8-f56e7cdd7e3b) 2025-11-03 17:42:01,753 - INFO - ================================================================================ 2025-11-03 17:42:01,753 - INFO - STARTING TEST : test_ingress_ip_assignment 2025-11-03 17:42:01,753 - 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-11-03 17:42:01,917 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_AgentXmppConnectionStatusReq? 2025-11-03 17:42:01,926 - DEBUG - Nothing to compare xmpp stats {'10.0.0.241': {'10.0.0.249': '0'}} with 2025-11-03 17:42:01,926 - INFO - Initial checks done. Running the testcase now 2025-11-03 17:42:01,926 - INFO - 2025-11-03 17:42:01,931 - INFO - Namespace default already exists 2025-11-03 17:42:01,931 - DEBUG - [10.0.0.249]: Running cmd : docker exec --privileged -it contrail-kubernetes-master-kubemanager-1 /bin/bash -c 'grep "^[ ]*cluster_project" /etc/contrail/contrail-kubernetes.conf' 2025-11-03 17:42:02,048 - DEBUG - Output : cluster_project={} 2025-11-03 17:42:02,094 - INFO - Project default-domain:k8s-default for Namespace default is seen in contrail-api 2025-11-03 17:42:02,094 - DEBUG - Project uuid in Contrail is 962435ac-89ab-45f8-bec8-f56e7cdd7e3b 2025-11-03 17:42:02,094 - DEBUG - [10.0.0.249]: Running cmd : docker exec --privileged -it contrail-kubernetes-master-kubemanager-1 /bin/bash -c 'netstat -antp | grep :8108 | grep LISTEN' 2025-11-03 17:42:02,242 - DEBUG - Output : tcp 0 0 0.0.0.0:8108 0.0.0.0:* LISTEN 1/python3 2025-11-03 17:42:02,242 - DEBUG - Requesting: http://10.0.0.249:8108/Snh_NamespaceDatabaseList?namespace_uuid=f66307a3-da59-49bb-b671-268e307def08 2025-11-03 17:42:02,247 - INFO - Namespace default with uuid f66307a3-da59-49bb-b671-268e307def08 found in kube manager 2025-11-03 17:42:02,247 - INFO - Namespace default verification passed 2025-11-03 17:42:02,250 - DEBUG - Service ctest-nginx-svc-94690533 not present 2025-11-03 17:42:02,251 - INFO - Creating service ctest-nginx-svc-94690533 2025-11-03 17:42:02,277 - INFO - Created Service ctest-nginx-svc-94690533 2025-11-03 17:42:02,295 - DEBUG - Pod ctest-nginx-pod-36651979 not present 2025-11-03 17:42:02,299 - INFO - Creating Pod ctest-nginx-pod-36651979 2025-11-03 17:42:02,366 - DEBUG - Node for Pod ctest-nginx-pod-36651979 not yet populated 2025-11-03 17:42:05,375 - DEBUG - Pod : ctest-nginx-pod-36651979 UUID is 9731bee9-6469-4640-96e4-2f015977499d 2025-11-03 17:42:05,377 - DEBUG - Pod ctest-nginx-pod-47309980 not present 2025-11-03 17:42:05,378 - INFO - Creating Pod ctest-nginx-pod-47309980 2025-11-03 17:42:05,426 - DEBUG - Pod : ctest-nginx-pod-47309980 UUID is c8ffcaad-b843-4360-9893-5a607c5b570d 2025-11-03 17:42:05,641 - INFO - Created VN __public__, UUID :d4534234-b8ed-4897-a96a-c9fb53284cad 2025-11-03 17:42:05,876 - DEBUG - Requesting: http://10.0.0.249:8082/domains 2025-11-03 17:42:05,881 - DEBUG - Requesting: http://10.0.0.249:8082/domain/3b3f591f-2792-4f25-95d2-3956e1543974 2025-11-03 17:42:05,894 - DEBUG - Requesting: http://10.0.0.249:8082/project/962435ac-89ab-45f8-bec8-f56e7cdd7e3b 2025-11-03 17:42:05,947 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/d4534234-b8ed-4897-a96a-c9fb53284cad 2025-11-03 17:42:05,961 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/d4534234-b8ed-4897-a96a-c9fb53284cad 2025-11-03 17:42:05,979 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/3a0d4196-917b-4a7a-8eac-e62cce940837 2025-11-03 17:42:05,992 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/3a0d4196-917b-4a7a-8eac-e62cce940837 2025-11-03 17:42:06,010 - DEBUG - Requesting: http://10.0.0.249:8082/route-target/add2059e-ba7e-43bd-85ad-f8ae95a166eb 2025-11-03 17:42:06,023 - DEBUG - Route Targets: ['target:64512:8000006'] 2025-11-03 17:42:06,023 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/d4534234-b8ed-4897-a96a-c9fb53284cad 2025-11-03 17:42:06,032 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/3a0d4196-917b-4a7a-8eac-e62cce940837 2025-11-03 17:42:06,044 - INFO - Verified VN network id 13 for VN d4534234-b8ed-4897-a96a-c9fb53284cad 2025-11-03 17:42:06,044 - INFO - Verifications in API Server for VN __public__ passed 2025-11-03 17:42:06,044 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/d4534234-b8ed-4897-a96a-c9fb53284cad 2025-11-03 17:42:06,052 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/3a0d4196-917b-4a7a-8eac-e62cce940837 2025-11-03 17:42:06,058 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/3a0d4196-917b-4a7a-8eac-e62cce940837 2025-11-03 17:42:06,064 - DEBUG - Requesting: http://10.0.0.249:8082/route-target/add2059e-ba7e-43bd-85ad-f8ae95a166eb 2025-11-03 17:42:06,069 - DEBUG - Requesting: http://10.0.0.249:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:k8s-default:__public__ 2025-11-03 17:42:06,075 - DEBUG - Control-node 10.0.0.249 : 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': '15299645153315997847', 'uuid-lslong': '12207791821210274989'}, 'enable': 'true', 'created': '2025-11-03T17:42:05', 'last-modified': '2025-11-03T17:42:05', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.263596'} 2025-11-03 17:42:06,075 - DEBUG - Requesting: http://10.0.0.249:8083/Snh_ShowRoutingInstanceReq?name=default-domain:k8s-default:__public__:__public__ 2025-11-03 17:42:06,086 - DEBUG - Route Targets: ['target:64512:8000006'] 2025-11-03 17:42:06,086 - INFO - On all control nodes, Config, RI and RT verification for VN __public__ passed 2025-11-03 17:42:06,087 - DEBUG - ====Verifying policy data for __public__ in API_Server ====== 2025-11-03 17:42:06,087 - DEBUG - Requesting: http://10.0.0.249:8082/domains 2025-11-03 17:42:06,092 - DEBUG - Requesting: http://10.0.0.249:8082/domain/3b3f591f-2792-4f25-95d2-3956e1543974 2025-11-03 17:42:06,099 - DEBUG - Requesting: http://10.0.0.249:8082/project/962435ac-89ab-45f8-bec8-f56e7cdd7e3b 2025-11-03 17:42:06,154 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/d4534234-b8ed-4897-a96a-c9fb53284cad 2025-11-03 17:42:06,163 - DEBUG - =>VN __public__ has no policy to be verified 2025-11-03 17:42:06,163 - DEBUG - Verifying the vn in opserver 2025-11-03 17:42:06,163 - DEBUG - Verifying the default-domain:k8s-default:__public__ virtual network link through opserver 10.0.0.249 2025-11-03 17:42:06,164 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks 2025-11-03 17:42:06,168 - DEBUG - vn link and name as {'name': 'default-domain:k8s-default:__public__', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:k8s-default:__public__?flat'} 2025-11-03 17:42:06,168 - INFO - Validated that VN default-domain:k8s-default:__public__ is found in opserver 2025-11-03 17:42:06,168 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VrfListReq?name=default-domain:k8s-default:__public__:__public__ 2025-11-03 17:42:06,176 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VrfListReq?name=default-domain:k8s-default:__public__:__public__ 2025-11-03 17:42:06,182 - DEBUG - Do not have enough data to verify VN in agent 2025-11-03 17:42:06,182 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VrfListReq?name=default-domain:k8s-default:__public__:__public__ 2025-11-03 17:42:06,187 - DEBUG - VRF ids for VN __public__: {} 2025-11-03 17:42:06,309 - INFO - Creating Floating IP pool __fip_pool_public__ in API Server 2025-11-03 17:42:06,503 - DEBUG - Requesting: http://10.0.0.249:8082/domains 2025-11-03 17:42:06,514 - DEBUG - Requesting: http://10.0.0.249:8082/domain/3b3f591f-2792-4f25-95d2-3956e1543974 2025-11-03 17:42:06,525 - DEBUG - Requesting: http://10.0.0.249:8082/project/962435ac-89ab-45f8-bec8-f56e7cdd7e3b 2025-11-03 17:42:06,593 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/d4534234-b8ed-4897-a96a-c9fb53284cad 2025-11-03 17:42:06,605 - DEBUG - Requesting: http://10.0.0.249:8082/floating-ip-pool/683d02be-f26f-46d3-ba88-efcf34c46688 2025-11-03 17:42:06,619 - DEBUG - Requesting: http://10.0.0.249:8082/domains 2025-11-03 17:42:06,630 - DEBUG - Requesting: http://10.0.0.249:8082/domain/3b3f591f-2792-4f25-95d2-3956e1543974 2025-11-03 17:42:06,638 - DEBUG - Requesting: http://10.0.0.249:8082/project/962435ac-89ab-45f8-bec8-f56e7cdd7e3b 2025-11-03 17:42:06,730 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/d4534234-b8ed-4897-a96a-c9fb53284cad 2025-11-03 17:42:06,752 - DEBUG - FIP Pool __fip_pool_public__ found in API Server 2025-11-03 17:42:06,752 - INFO - Verification for FIP pool __fip_pool_public__ in API Server passed 2025-11-03 17:42:06,766 - DEBUG - Requesting: http://10.0.0.249:8083/Snh_IFMapTableShowReq?table_name=floating-ip-pool&search_string=floating-ip-pool:default-domain:k8s-default:__public__:__fip_pool_public__ 2025-11-03 17:42:06,776 - DEBUG - Control-node Ifmap-view has FIP pool __fip_pool_public__ information 2025-11-03 17:42:06,776 - INFO - Verification for FIP pool __fip_pool_public__ in Control-node passed 2025-11-03 17:42:06,787 - DEBUG - Ingress ctest-nginx-ingress-43422495 not present 2025-11-03 17:42:06,788 - INFO - Creating Ingress ctest-nginx-ingress-43422495 2025-11-03 17:42:06,802 - INFO - Created Ingress ctest-nginx-ingress-43422495 2025-11-03 17:42:06,814 - DEBUG - Cluster IP not yet seen for Ingress ctest-nginx-ingress-43422495 2025-11-03 17:42:09,824 - DEBUG - For Ingress ctest-nginx-ingress-43422495, Cluster IP: 10.47.255.249, External IPs ['88.187.80.188'] 2025-11-03 17:42:09,824 - INFO - Verifications in k8s passed for Ingress ctest-nginx-ingress-43422495 2025-11-03 17:42:09,824 - DEBUG - Requesting: http://10.0.0.249:8108/Snh_LoadbalancerDatabaseList?x=952bfaa0-9d73-4a4d-b6a1-71c510f8bdd1 2025-11-03 17:42:09,829 - INFO - Ingress ctest-nginx-ingress-43422495 with uuid 952bfaa0-9d73-4a4d-b6a1-71c510f8bdd1 found in kube manager 2025-11-03 17:42:09,829 - INFO - Ingress ctest-nginx-ingress-43422495 verification passed 2025-11-03 17:42:09,832 - DEBUG - Pod ctest-busybox-pod-16015083 not present 2025-11-03 17:42:09,833 - INFO - Creating Pod ctest-busybox-pod-16015083 2025-11-03 17:42:09,858 - DEBUG - Pod : ctest-busybox-pod-16015083 UUID is d9a10a75-a81d-4fd4-8e41-6bd207292d25 2025-11-03 17:42:09,864 - DEBUG - Pod ctest-nginx-pod-36651979 not in running state.Currently in Pending 2025-11-03 17:42:14,880 - DEBUG - Pod ctest-nginx-pod-36651979 not in running state.Currently in Pending 2025-11-03 17:42:19,889 - INFO - Pod ctest-nginx-pod-36651979 is in running state.Got IP 10.47.255.251 2025-11-03 17:42:19,904 - DEBUG - Pod ctest-nginx-pod-36651979 has vmi 692877ec-b8dc-11f0-881a-fa163e4639b8 2025-11-03 17:42:19,904 - INFO - Verified pod ctest-nginx-pod-36651979 in contrail-api 2025-11-03 17:42:19,904 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2025-11-03 17:42:19,915 - DEBUG - VMI 692877ec-b8dc-11f0-881a-fa163e4639b8 is active in agent 10.0.0.241 2025-11-03 17:42:19,915 - INFO - Verified Pod ctest-nginx-pod-36651979 in agent 10.0.0.241 2025-11-03 17:42:19,915 - DEBUG - Requesting: http://10.0.0.249:8108/Snh_VirtualMachineDatabaseList?x=9731bee9-6469-4640-96e4-2f015977499d 2025-11-03 17:42:19,922 - INFO - Pod ctest-nginx-pod-36651979 with uuid 9731bee9-6469-4640-96e4-2f015977499d found in kube manager 2025-11-03 17:42:19,923 - INFO - Pod ctest-nginx-pod-36651979 verification passed 2025-11-03 17:42:20,005 - DEBUG - [Pod ctest-nginx-pod-36651979] Cmd: echo ctest-nginx-pod-36651979 > /usr/share/nginx/html/index.html, Output: 2025-11-03 17:42:20,013 - INFO - Pod ctest-nginx-pod-47309980 is in running state.Got IP 10.47.255.250 2025-11-03 17:42:20,032 - DEBUG - Pod ctest-nginx-pod-47309980 has vmi 69cc6c6c-b8dc-11f0-881a-fa163e4639b8 2025-11-03 17:42:20,032 - INFO - Verified pod ctest-nginx-pod-47309980 in contrail-api 2025-11-03 17:42:20,032 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2025-11-03 17:42:20,043 - DEBUG - VMI 69cc6c6c-b8dc-11f0-881a-fa163e4639b8 is active in agent 10.0.0.241 2025-11-03 17:42:20,043 - INFO - Verified Pod ctest-nginx-pod-47309980 in agent 10.0.0.241 2025-11-03 17:42:20,044 - DEBUG - Requesting: http://10.0.0.249:8108/Snh_VirtualMachineDatabaseList?x=c8ffcaad-b843-4360-9893-5a607c5b570d 2025-11-03 17:42:20,048 - INFO - Pod ctest-nginx-pod-47309980 with uuid c8ffcaad-b843-4360-9893-5a607c5b570d found in kube manager 2025-11-03 17:42:20,048 - INFO - Pod ctest-nginx-pod-47309980 verification passed 2025-11-03 17:42:20,104 - DEBUG - [Pod ctest-nginx-pod-47309980] Cmd: echo ctest-nginx-pod-47309980 > /usr/share/nginx/html/index.html, Output: 2025-11-03 17:42:20,111 - DEBUG - Pod ctest-busybox-pod-16015083 not in running state.Currently in Pending 2025-11-03 17:42:25,118 - INFO - Pod ctest-busybox-pod-16015083 is in running state.Got IP 10.47.255.248 2025-11-03 17:42:25,171 - DEBUG - Pod ctest-busybox-pod-16015083 has vmi 6c79282e-b8dc-11f0-881a-fa163e4639b8 2025-11-03 17:42:25,171 - INFO - Verified pod ctest-busybox-pod-16015083 in contrail-api 2025-11-03 17:42:25,171 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2025-11-03 17:42:25,182 - DEBUG - VMI 6c79282e-b8dc-11f0-881a-fa163e4639b8 is active in agent 10.0.0.241 2025-11-03 17:42:25,182 - INFO - Verified Pod ctest-busybox-pod-16015083 in agent 10.0.0.241 2025-11-03 17:42:25,182 - DEBUG - Requesting: http://10.0.0.249:8108/Snh_VirtualMachineDatabaseList?x=d9a10a75-a81d-4fd4-8e41-6bd207292d25 2025-11-03 17:42:25,186 - INFO - Pod ctest-busybox-pod-16015083 with uuid d9a10a75-a81d-4fd4-8e41-6bd207292d25 found in kube manager 2025-11-03 17:42:25,186 - INFO - Pod ctest-busybox-pod-16015083 verification passed 2025-11-03 17:42:25,235 - DEBUG - [Pod ctest-busybox-pod-16015083] Cmd: wget http://10.47.255.249:80/ -O - -T 5 -t 1 , Output: ctest-nginx-pod-47309980 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-11-03 17:42:25,236 - DEBUG - [Pod Pod ctest-busybox-pod-16015083] Cmd wget http://10.47.255.249:80/ -O - -T 5 -t 1 passed 2025-11-03 17:42:25,236 - DEBUG - [Pod Pod ctest-busybox-pod-16015083] Cmd output: ctest-nginx-pod-47309980 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-11-03 17:42:25,292 - DEBUG - [Pod ctest-busybox-pod-16015083] 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-36651979 2025-11-03 17:42:25,292 - DEBUG - [Pod Pod ctest-busybox-pod-16015083] Cmd wget http://10.47.255.249:80/ -O - -T 5 -t 1 passed 2025-11-03 17:42:25,292 - DEBUG - [Pod Pod ctest-busybox-pod-16015083] 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-36651979 2025-11-03 17:42:25,292 - INFO - Responses seen from all pods, lb seems fine.Hits : {'ctest-nginx-pod-36651979': 1, 'ctest-nginx-pod-47309980': 1} 2025-11-03 17:42:25,292 - WARNING - Nothing to delete parallely 2025-11-03 17:42:25,293 - INFO - Deleting pod default:ctest-busybox-pod-16015083 2025-11-03 17:42:25,303 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=d9a10a75-a81d-4fd4-8e41-6bd207292d25 2025-11-03 17:42:25,309 - WARNING - Pod uuid d9a10a75-a81d-4fd4-8e41-6bd207292d25 is still seen in agent 10.0.0.241 VM list 2025-11-03 17:42:30,309 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=d9a10a75-a81d-4fd4-8e41-6bd207292d25 2025-11-03 17:42:30,317 - WARNING - Pod uuid d9a10a75-a81d-4fd4-8e41-6bd207292d25 is still seen in agent 10.0.0.241 VM list 2025-11-03 17:42:35,318 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=d9a10a75-a81d-4fd4-8e41-6bd207292d25 2025-11-03 17:42:35,327 - WARNING - Pod uuid d9a10a75-a81d-4fd4-8e41-6bd207292d25 is still seen in agent 10.0.0.241 VM list 2025-11-03 17:42:40,328 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=d9a10a75-a81d-4fd4-8e41-6bd207292d25 2025-11-03 17:42:40,337 - WARNING - Pod uuid d9a10a75-a81d-4fd4-8e41-6bd207292d25 is still seen in agent 10.0.0.241 VM list 2025-11-03 17:42:45,338 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=d9a10a75-a81d-4fd4-8e41-6bd207292d25 2025-11-03 17:42:45,347 - WARNING - Pod uuid d9a10a75-a81d-4fd4-8e41-6bd207292d25 is still seen in agent 10.0.0.241 VM list 2025-11-03 17:42:50,349 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=d9a10a75-a81d-4fd4-8e41-6bd207292d25 2025-11-03 17:42:50,361 - WARNING - Pod uuid d9a10a75-a81d-4fd4-8e41-6bd207292d25 is still seen in agent 10.0.0.241 VM list 2025-11-03 17:42:55,362 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=d9a10a75-a81d-4fd4-8e41-6bd207292d25 2025-11-03 17:42:55,369 - WARNING - Pod uuid d9a10a75-a81d-4fd4-8e41-6bd207292d25 is still seen in agent 10.0.0.241 VM list 2025-11-03 17:43:00,371 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=d9a10a75-a81d-4fd4-8e41-6bd207292d25 2025-11-03 17:43:00,377 - DEBUG - Pod d9a10a75-a81d-4fd4-8e41-6bd207292d25 is not in agent 10.0.0.241 VM list 2025-11-03 17:43:00,377 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:6c79282e-b8dc-11f0-881a-fa163e4639b8 2025-11-03 17:43:00,383 - DEBUG - VMI 6c79282e-b8dc-11f0-881a-fa163e4639b8 is removed from agent 10.0.0.241 2025-11-03 17:43:00,383 - INFO - Verified that pod ctest-busybox-pod-16015083 is removed in agent 2025-11-03 17:43:00,383 - INFO - Deleting Ingress : ctest-nginx-ingress-43422495 2025-11-03 17:43:00,391 - DEBUG - Requesting: http://10.0.0.249:8108/Snh_LoadbalancerDatabaseList?x=952bfaa0-9d73-4a4d-b6a1-71c510f8bdd1 2025-11-03 17:43:00,401 - ERROR - Ingress ctest-nginx-ingress-43422495 with uuid 952bfaa0-9d73-4a4d-b6a1-71c510f8bdd1 still found in kube manager 2025-11-03 17:43:01,402 - DEBUG - Requesting: http://10.0.0.249:8108/Snh_LoadbalancerDatabaseList?x=952bfaa0-9d73-4a4d-b6a1-71c510f8bdd1 2025-11-03 17:43:01,406 - INFO - Ingress ctest-nginx-ingress-43422495 with uuid 952bfaa0-9d73-4a4d-b6a1-71c510f8bdd1 deleted successfully from kube manager 2025-11-03 17:43:01,406 - INFO - Verifications on Ingress %s cleanup passed 2025-11-03 17:43:01,406 - INFO - Deleting the FIP pool __fip_pool_public__ 2025-11-03 17:43:01,543 - DEBUG - Requesting: http://10.0.0.249:8083/Snh_IFMapTableShowReq?table_name=floating-ip-pool&search_string=floating-ip-pool:default-domain:k8s-default:__public__:__fip_pool_public__ 2025-11-03 17:43:01,549 - DEBUG - Control-node Ifmap-view does not have FIP pool __fip_pool_public__ information 2025-11-03 17:43:01,549 - INFO - Deleting VN __public__ 2025-11-03 17:43:01,640 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/3a0d4196-917b-4a7a-8eac-e62cce940837 2025-11-03 17:43:01,661 - DEBUG - Response Code: 404 2025-11-03 17:43:01,661 - DEBUG - Requesting: http://10.0.0.249:8082/domains 2025-11-03 17:43:01,668 - DEBUG - Requesting: http://10.0.0.249:8082/domain/3b3f591f-2792-4f25-95d2-3956e1543974 2025-11-03 17:43:01,675 - DEBUG - Requesting: http://10.0.0.249:8082/project/962435ac-89ab-45f8-bec8-f56e7cdd7e3b 2025-11-03 17:43:01,727 - INFO - Validated that VN __public__ is not found in API Server 2025-11-03 17:43:01,727 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VnListReq?name=default-domain:k8s-default:__public__ 2025-11-03 17:43:01,734 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VrfListReq?name=default-domain:k8s-default:__public__:__public__ 2025-11-03 17:43:01,744 - DEBUG - VN __public__ is not present in Agent 10.0.0.241 2025-11-03 17:43:01,744 - INFO - Validated that VN __public__ is not in any agent 2025-11-03 17:43:01,744 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VrfListReq?name=default-domain:k8s-default:__public__:__public__ 2025-11-03 17:43:01,752 - DEBUG - Requesting: http://10.0.0.249:8083/Snh_ShowRoutingInstanceReq?name=default-domain:k8s-default:__public__:__public__ 2025-11-03 17:43:01,756 - DEBUG - Requesting: http://10.0.0.249:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:k8s-default:__public__ 2025-11-03 17:43:01,761 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN __public__ info 2025-11-03 17:43:01,762 - INFO - Deleting pod default:ctest-nginx-pod-47309980 2025-11-03 17:43:01,775 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=c8ffcaad-b843-4360-9893-5a607c5b570d 2025-11-03 17:43:01,793 - WARNING - Pod uuid c8ffcaad-b843-4360-9893-5a607c5b570d is still seen in agent 10.0.0.241 VM list 2025-11-03 17:43:06,794 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=c8ffcaad-b843-4360-9893-5a607c5b570d 2025-11-03 17:43:06,801 - DEBUG - Pod c8ffcaad-b843-4360-9893-5a607c5b570d is not in agent 10.0.0.241 VM list 2025-11-03 17:43:06,801 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:69cc6c6c-b8dc-11f0-881a-fa163e4639b8 2025-11-03 17:43:06,808 - DEBUG - VMI 69cc6c6c-b8dc-11f0-881a-fa163e4639b8 is removed from agent 10.0.0.241 2025-11-03 17:43:06,808 - INFO - Verified that pod ctest-nginx-pod-47309980 is removed in agent 2025-11-03 17:43:06,808 - INFO - Deleting pod default:ctest-nginx-pod-36651979 2025-11-03 17:43:06,836 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=9731bee9-6469-4640-96e4-2f015977499d 2025-11-03 17:43:06,842 - WARNING - Pod uuid 9731bee9-6469-4640-96e4-2f015977499d is still seen in agent 10.0.0.241 VM list 2025-11-03 17:43:11,843 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=9731bee9-6469-4640-96e4-2f015977499d 2025-11-03 17:43:11,850 - DEBUG - Pod 9731bee9-6469-4640-96e4-2f015977499d is not in agent 10.0.0.241 VM list 2025-11-03 17:43:11,850 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:692877ec-b8dc-11f0-881a-fa163e4639b8 2025-11-03 17:43:11,856 - DEBUG - VMI 692877ec-b8dc-11f0-881a-fa163e4639b8 is removed from agent 10.0.0.241 2025-11-03 17:43:11,856 - INFO - Verified that pod ctest-nginx-pod-36651979 is removed in agent 2025-11-03 17:43:11,856 - INFO - Deleting service : ctest-nginx-svc-94690533 2025-11-03 17:43:12,064 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_AgentXmppConnectionStatusReq? 2025-11-03 17:43:12,071 - DEBUG - No XMPP flaps were noticed during the test
2025-11-03 17:43:12,071 - INFO - END TEST : test_ingress_ip_assignment : PASSED[0:01:11]
2025-11-03 17:43:12,071 - INFO - -------------------------------------------------------------------------------- 2025-11-03 17:43:18,577 - DEBUG - [10.0.0.249]: Running cmd : docker exec --privileged -it contrail-kubernetes-master-kubemanager-1 /bin/bash -c 'grep "^[ ]*cluster_project" /etc/contrail/contrail-kubernetes.conf' 2025-11-03 17:43:18,749 - DEBUG - Output : cluster_project={} 2025-11-03 17:43:18,811 - DEBUG - [10.0.0.249]: Running cmd : docker exec --privileged -it contrail-kubernetes-master-kubemanager-1 /bin/bash -c 'netstat -antp | grep :8108 | grep LISTEN' 2025-11-03 17:43:18,973 - DEBUG - Output : tcp 0 0 0.0.0.0:8108 0.0.0.0:* LISTEN 1/python3 2025-11-03 17:43:18,978 - DEBUG - [10.0.0.249]: Running cmd : docker exec --privileged -it contrail-kubernetes-master-kubemanager-1 /bin/bash -c 'grep "^[ ]*cluster_project" /etc/contrail/contrail-kubernetes.conf' 2025-11-03 17:43:19,218 - DEBUG - Output : cluster_project={} 2025-11-03 17:43:34,424 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2025-11-03 17:43:34,496 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2025-11-03 17:43:34,547 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2025-11-03 17:43:34,638 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2025-11-03 17:43:34,692 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2025-11-03 17:43:34,777 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2025-11-03 17:43:39,840 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2025-11-03 17:43:39,926 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2025-11-03 17:43:40,145 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_AgentXmppConnectionStatusReq? 2025-11-03 17:43:42,019 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_ApplicationPolicySetReq? 2025-11-03 17:43:42,026 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_AclReq? 2025-11-03 17:43:42,057 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_AclReq? 2025-11-03 17:43:44,081 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_AclReq? 2025-11-03 17:46:44,105 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_AgentXmppConnectionStatusReq? 2025-11-03 17:46:44,146 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=d3725449-b842-4cb8-916e-cc84f89a2137 2025-11-03 17:46:44,161 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=e1642d9b-b309-4baa-87a0-b8e900d7b143 2025-11-03 17:46:44,172 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=0793b858-a341-4de0-9838-fcefb1bc94e3 2025-11-03 17:46:44,183 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=555f08fc-d2ae-4b66-b6ad-446f34d7b0df 2025-11-03 17:46:44,194 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=2e7d8b81-17f8-4057-bbe2-f647545b13e4 2025-11-03 17:46:44,212 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=6f09dd4b-b137-4392-bb1d-ebf46e0f41a7 2025-11-03 17:46:44,219 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=54ab42fe-3857-4a5c-a392-d6ceebb91f6d 2025-11-03 17:46:44,223 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=dd3b53a5-190f-4e95-9eae-2fe7127fc572 2025-11-03 17:46:49,229 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=d3725449-b842-4cb8-916e-cc84f89a2137 2025-11-03 17:46:49,236 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:964e6920-b8dc-11f0-881a-fa163e4639b8 2025-11-03 17:46:49,270 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=0793b858-a341-4de0-9838-fcefb1bc94e3 2025-11-03 17:46:49,272 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=555f08fc-d2ae-4b66-b6ad-446f34d7b0df 2025-11-03 17:46:49,274 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=2e7d8b81-17f8-4057-bbe2-f647545b13e4 2025-11-03 17:46:49,276 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=6f09dd4b-b137-4392-bb1d-ebf46e0f41a7 2025-11-03 17:46:49,276 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=54ab42fe-3857-4a5c-a392-d6ceebb91f6d 2025-11-03 17:46:49,277 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=e1642d9b-b309-4baa-87a0-b8e900d7b143 2025-11-03 17:46:49,278 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=dd3b53a5-190f-4e95-9eae-2fe7127fc572 2025-11-03 17:46:49,311 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:97debc36-b8dc-11f0-881a-fa163e4639b8 2025-11-03 17:46:49,313 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:96c64a80-b8dc-11f0-881a-fa163e4639b8 2025-11-03 17:46:49,314 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:97630cf8-b8dc-11f0-881a-fa163e4639b8 2025-11-03 17:46:54,309 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=6f09dd4b-b137-4392-bb1d-ebf46e0f41a7 2025-11-03 17:46:54,344 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=54ab42fe-3857-4a5c-a392-d6ceebb91f6d 2025-11-03 17:46:54,346 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=2e7d8b81-17f8-4057-bbe2-f647545b13e4 2025-11-03 17:46:54,347 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=e1642d9b-b309-4baa-87a0-b8e900d7b143 2025-11-03 17:46:59,365 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=2e7d8b81-17f8-4057-bbe2-f647545b13e4 2025-11-03 17:46:59,366 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=6f09dd4b-b137-4392-bb1d-ebf46e0f41a7 2025-11-03 17:46:59,367 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=54ab42fe-3857-4a5c-a392-d6ceebb91f6d 2025-11-03 17:46:59,369 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=e1642d9b-b309-4baa-87a0-b8e900d7b143 2025-11-03 17:47:04,381 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=54ab42fe-3857-4a5c-a392-d6ceebb91f6d 2025-11-03 17:47:04,382 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=2e7d8b81-17f8-4057-bbe2-f647545b13e4 2025-11-03 17:47:04,385 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=e1642d9b-b309-4baa-87a0-b8e900d7b143 2025-11-03 17:47:04,386 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=6f09dd4b-b137-4392-bb1d-ebf46e0f41a7 2025-11-03 17:47:09,400 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=2e7d8b81-17f8-4057-bbe2-f647545b13e4 2025-11-03 17:47:09,402 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=54ab42fe-3857-4a5c-a392-d6ceebb91f6d 2025-11-03 17:47:09,403 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=e1642d9b-b309-4baa-87a0-b8e900d7b143 2025-11-03 17:47:09,404 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=6f09dd4b-b137-4392-bb1d-ebf46e0f41a7 2025-11-03 17:47:14,419 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=54ab42fe-3857-4a5c-a392-d6ceebb91f6d 2025-11-03 17:47:14,421 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=6f09dd4b-b137-4392-bb1d-ebf46e0f41a7 2025-11-03 17:47:14,422 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=e1642d9b-b309-4baa-87a0-b8e900d7b143 2025-11-03 17:47:14,423 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=2e7d8b81-17f8-4057-bbe2-f647545b13e4 2025-11-03 17:47:19,454 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=e1642d9b-b309-4baa-87a0-b8e900d7b143 2025-11-03 17:47:19,455 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=2e7d8b81-17f8-4057-bbe2-f647545b13e4 2025-11-03 17:47:19,456 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=6f09dd4b-b137-4392-bb1d-ebf46e0f41a7 2025-11-03 17:47:19,457 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=54ab42fe-3857-4a5c-a392-d6ceebb91f6d 2025-11-03 17:47:19,469 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:99aae2a6-b8dc-11f0-881a-fa163e4639b8 2025-11-03 17:47:19,472 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:98d6243a-b8dc-11f0-881a-fa163e4639b8 2025-11-03 17:47:19,474 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:99406926-b8dc-11f0-881a-fa163e4639b8 2025-11-03 17:47:19,475 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:986b1316-b8dc-11f0-881a-fa163e4639b8