2025-07-21 01:56:05,091 - DEBUG - [10.0.0.249]: Running cmd : hostname 2025-07-21 01:56:05,387 - DEBUG - Output : cn-jenkins-deploy-platform-k8s-manifests-229-1 2025-07-21 01:56:05,387 - DEBUG - [10.0.0.249]: Running cmd : hostname -f 2025-07-21 01:56:05,492 - DEBUG - Output : cn-jenkins-deploy-platform-k8s-manifests-229-1.cluster.local 2025-07-21 01:56:05,493 - 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-07-21 01:56:05,660 - DEBUG - Output : NAMES contrail_test_C3c3WKmWT k8s_autoscaler_dns-autoscaler-595558c478-2k4lz_kube-system_8e09ddcc-b0e7-4be5-a435-31676ab1bc22_0 k8s_coredns_coredns-77f7cc69db-hq257_kube-system_36dd78e4-939e-45f0-9d17-c5b6450402e5_0 k8s_opensdn-controller-config-nodemgr_opensdn-controller-config-glrd7_kube-system_fb4d8918-a600-45d9-8a6b-dc9ae7dea429_0 k8s_opensdn-controller-config-svcmonitor_opensdn-controller-config-glrd7_kube-system_fb4d8918-a600-45d9-8a6b-dc9ae7dea429_0 k8s_opensdn-controller-config-schema_opensdn-controller-config-glrd7_kube-system_fb4d8918-a600-45d9-8a6b-dc9ae7dea429_0 k8s_opensdn-controller-nodemgr_opensdn-controller-control-c6h87_kube-system_bcb1bddf-3d76-4e5d-b099-f56f163e46f7_0 k8s_opensdn-controller-control-named_opensdn-controller-control-c6h87_kube-system_bcb1bddf-3d76-4e5d-b099-f56f163e46f7_0 k8s_opensdn-analytics-query-engine_opensdn-analyticsdb-ct92p_kube-system_d373d9c5-6569-460e-8931-252e95d6779b_0 k8s_opensdn-analytics-snmp-nodemgr_opensdn-analytics-snmp-v42n9_kube-system_3a21e8f0-d5d2-459c-9c84-ac9cb1605b72_0 k8s_opensdn-analytics-snmp-topology_opensdn-analytics-snmp-v42n9_kube-system_3a21e8f0-d5d2-459c-9c84-ac9cb1605b72_0 k8s_opensdn-controller-config-devicemgr_opensdn-controller-config-glrd7_kube-system_fb4d8918-a600-45d9-8a6b-dc9ae7dea429_0 k8s_opensdn-controller-control-dns_opensdn-controller-control-c6h87_kube-system_bcb1bddf-3d76-4e5d-b099-f56f163e46f7_0 k8s_opensdn-analytics-alarm-nodemgr_opensdn-analytics-alarm-gqc4r_kube-system_4379afda-abe6-4125-b4f9-353dcd2ae21b_0 k8s_opensdn-analytics-alarm-gen_opensdn-analytics-alarm-gqc4r_kube-system_4379afda-abe6-4125-b4f9-353dcd2ae21b_0 k8s_opensdn-analytics-nodemgr_opensdn-analytics-jgwfd_kube-system_7da251b5-7b2f-4375-80b8-b387bcbefa1e_0 k8s_opensdn-analytics-collector_opensdn-analytics-jgwfd_kube-system_7da251b5-7b2f-4375-80b8-b387bcbefa1e_0 k8s_opensdn-controller-webui-web_opensdn-controller-webui-6g9sq_kube-system_f71453b4-d90e-46e1-bdc8-713521ffe145_0 k8s_opensdn-analyticsdb_opensdn-analyticsdb-ct92p_kube-system_d373d9c5-6569-460e-8931-252e95d6779b_0 k8s_opensdn-analytics-snmp-collector_opensdn-analytics-snmp-v42n9_kube-system_3a21e8f0-d5d2-459c-9c84-ac9cb1605b72_0 k8s_opensdn-controller-config-api_opensdn-controller-config-glrd7_kube-system_fb4d8918-a600-45d9-8a6b-dc9ae7dea429_0 k8s_opensdn-controller-control_opensdn-controller-control-c6h87_kube-system_bcb1bddf-3d76-4e5d-b099-f56f163e46f7_0 k8s_kafka_opensdn-analytics-alarm-gqc4r_kube-system_4379afda-abe6-4125-b4f9-353dcd2ae21b_0 k8s_opensdn-analytics-api_opensdn-analytics-jgwfd_kube-system_7da251b5-7b2f-4375-80b8-b387bcbefa1e_0 k8s_opensdn-controller-webui-job_opensdn-controller-webui-6g9sq_kube-system_f71453b4-d90e-46e1-bdc8-713521ffe145_0 k8s_redis_redis-6lqkt_kube-system_9bf12a3b-48c3-43d6-b6d9-fe45fefc02a3_0 k8s_config-zookeeper_config-zookeeper-g5fht_kube-system_65773c6b-1c62-4e01-94d2-442763cf0556_0 k8s_rabbitmq_rabbitmq-f9bnv_kube-system_a217d2a2-1fdb-424a-ba89-c6d4b4d35a8a_0 k8s_opensdn-config-database-nodemgr_opensdn-configdb-t998x_kube-system_bc81dc48-3c5f-49ea-8b87-00d9a786f831_0 k8s_opensdn-configdb_opensdn-configdb-t998x_kube-system_bc81dc48-3c5f-49ea-8b87-00d9a786f831_0 k8s_opensdn-analyticsdb-nodemgr_opensdn-analyticsdb-ct92p_kube-system_d373d9c5-6569-460e-8931-252e95d6779b_0 k8s_opensdn-agent-nodemgr_opensdn-agent-5c7mh_kube-system_4a84e42e-b840-4056-9551-d30ed1e14bb9_0 k8s_opensdn-vrouter-agent_opensdn-agent-5c7mh_kube-system_4a84e42e-b840-4056-9551-d30ed1e14bb9_0 k8s_opensdn-kube-manager_opensdn-kube-manager-hxhfk_kube-system_0dce2a98-9d71-479c-9269-d4020b1e1b20_0 k8s_kube-proxy_kube-proxy-qsrmr_kube-system_7289532a-7a98-4003-98b8-1508e0d27105_0 k8s_kube-scheduler_kube-scheduler-cn-jenkins-deploy-platform-k8s-manifests-229-1_kube-system_f82c0ba9112412a550b0d562fa1e81af_1 k8s_kube-controller-manager_kube-controller-manager-cn-jenkins-deploy-platform-k8s-manifests-229-1_kube-system_0e85257b83735ac133ff3d6da79d4c52_1 k8s_kube-apiserver_kube-apiserver-cn-jenkins-deploy-platform-k8s-manifests-229-1_kube-system_fc718589d046567ed6fd860bc5bd9246_0 2025-07-21 01:56:05,660 - DEBUG - [10.0.0.249]: Running cmd : ip addr show | grep 'inet .*/.* brd ' | awk '{print $2}' 2025-07-21 01:56:05,783 - DEBUG - Output : 172.17.0.1/16 10.0.0.249/24 2025-07-21 01:56:05,784 - DEBUG - [10.0.0.249]: Running cmd : getent hosts 10.0.0.249 | head -n 1 | awk '{print $2}' 2025-07-21 01:56:05,913 - DEBUG - Output : cn-jenkins-deploy-platform-k8s-manifests-229-1.cluster.local 2025-07-21 01:56:05,913 - DEBUG - [10.0.0.249]: Running cmd : ip addr show dev vhost0 | grep 'inet .*/.* brd ' | awk '{print $2}' 2025-07-21 01:56:06,043 - DEBUG - Output : 10.0.0.249/24 2025-07-21 01:56:06,430 - INFO - Using existing project ['default-domain', 'k8s-default'](62d7fb53-ed32-4e11-985e-59035f66838a) 2025-07-21 01:56:06,564 - INFO - Using existing project ['default-domain', 'k8s-default'](62d7fb53-ed32-4e11-985e-59035f66838a) 2025-07-21 01:56:06,718 - INFO - ================================================================================ 2025-07-21 01:56:06,718 - INFO - STARTING TEST : test_ingress_ip_assignment 2025-07-21 01:56:06,719 - 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-07-21 01:56:07,015 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_AgentXmppConnectionStatusReq? 2025-07-21 01:56:07,024 - DEBUG - Nothing to compare xmpp stats {'10.0.0.249': {'10.0.0.249': '2'}} with 2025-07-21 01:56:07,025 - INFO - Initial checks done. Running the testcase now 2025-07-21 01:56:07,025 - INFO - 2025-07-21 01:56:07,030 - INFO - Namespace default already exists 2025-07-21 01:56:07,031 - DEBUG - [10.0.0.249]: Running cmd : docker exec --privileged -it k8s_opensdn-kube-manager_opensdn-kube-manager-hxhfk_kube-system_0dce2a98-9d71-479c-9269-d4020b1e1b20_0 /bin/bash -c 'grep "^[ ]*cluster_project" /etc/contrail/contrail-kubernetes.conf' 2025-07-21 01:56:07,201 - DEBUG - Output : cluster_project={} 2025-07-21 01:56:07,284 - INFO - Project default-domain:k8s-default for Namespace default is seen in contrail-api 2025-07-21 01:56:07,284 - DEBUG - Project uuid in Contrail is 62d7fb53-ed32-4e11-985e-59035f66838a 2025-07-21 01:56:07,285 - DEBUG - [10.0.0.249]: Running cmd : docker exec --privileged -it k8s_opensdn-kube-manager_opensdn-kube-manager-hxhfk_kube-system_0dce2a98-9d71-479c-9269-d4020b1e1b20_0 /bin/bash -c 'netstat -antp | grep :8108 | grep LISTEN' 2025-07-21 01:56:07,435 - DEBUG - Output : tcp 0 0 0.0.0.0:8108 0.0.0.0:* LISTEN 1/python3 2025-07-21 01:56:07,435 - DEBUG - Requesting: http://10.0.0.249:8108/Snh_NamespaceDatabaseList?namespace_uuid=2c389803-b1fb-4a08-ba0a-2d2011d3337a 2025-07-21 01:56:07,439 - INFO - Namespace default with uuid 2c389803-b1fb-4a08-ba0a-2d2011d3337a found in kube manager 2025-07-21 01:56:07,439 - INFO - Namespace default verification passed 2025-07-21 01:56:07,443 - DEBUG - Service ctest-nginx-svc-61550001 not present 2025-07-21 01:56:07,443 - INFO - Creating service ctest-nginx-svc-61550001 2025-07-21 01:56:07,456 - INFO - Created Service ctest-nginx-svc-61550001 2025-07-21 01:56:07,463 - DEBUG - Pod ctest-nginx-pod-15283292 not present 2025-07-21 01:56:07,463 - INFO - Creating Pod ctest-nginx-pod-15283292 2025-07-21 01:56:07,506 - DEBUG - Pod : ctest-nginx-pod-15283292 UUID is 4f4a01ee-d943-4ae0-9a5d-e0944fdc38e0 2025-07-21 01:56:07,510 - DEBUG - Pod ctest-nginx-pod-79508112 not present 2025-07-21 01:56:07,510 - INFO - Creating Pod ctest-nginx-pod-79508112 2025-07-21 01:56:07,525 - DEBUG - Pod : ctest-nginx-pod-79508112 UUID is f32c43c7-74dc-4ce0-b156-d697499a63d9 2025-07-21 01:56:07,833 - INFO - Created VN __public__, UUID :c12435da-5bff-4878-ae10-2718093ea0b2 2025-07-21 01:56:08,088 - DEBUG - Requesting: http://10.0.0.249:8082/domains 2025-07-21 01:56:08,094 - DEBUG - Requesting: http://10.0.0.249:8082/domain/240e9431-6035-4dd9-af6e-5880e8512984 2025-07-21 01:56:08,184 - DEBUG - Requesting: http://10.0.0.249:8082/project/62d7fb53-ed32-4e11-985e-59035f66838a 2025-07-21 01:56:08,357 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/c12435da-5bff-4878-ae10-2718093ea0b2 2025-07-21 01:56:08,370 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/c12435da-5bff-4878-ae10-2718093ea0b2 2025-07-21 01:56:08,381 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/0190270a-3a6d-41b8-a416-6d578171f30f 2025-07-21 01:56:08,389 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/0190270a-3a6d-41b8-a416-6d578171f30f 2025-07-21 01:56:08,396 - DEBUG - Requesting: http://10.0.0.249:8082/route-target/ef228292-f8d4-4a0c-8d30-c4bfba372dd5 2025-07-21 01:56:08,403 - DEBUG - Route Targets: ['target:64512:8000007'] 2025-07-21 01:56:08,403 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/c12435da-5bff-4878-ae10-2718093ea0b2 2025-07-21 01:56:08,413 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/0190270a-3a6d-41b8-a416-6d578171f30f 2025-07-21 01:56:08,436 - INFO - Verified VN network id 12 for VN c12435da-5bff-4878-ae10-2718093ea0b2 2025-07-21 01:56:08,436 - INFO - Verifications in API Server for VN __public__ passed 2025-07-21 01:56:08,436 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/c12435da-5bff-4878-ae10-2718093ea0b2 2025-07-21 01:56:08,451 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/0190270a-3a6d-41b8-a416-6d578171f30f 2025-07-21 01:56:08,463 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/0190270a-3a6d-41b8-a416-6d578171f30f 2025-07-21 01:56:08,473 - DEBUG - Requesting: http://10.0.0.249:8082/route-target/ef228292-f8d4-4a0c-8d30-c4bfba372dd5 2025-07-21 01:56:08,482 - DEBUG - Requesting: http://10.0.0.249:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:k8s-default:__public__ 2025-07-21 01:56:08,489 - 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': '13917307960444274808', 'uuid-lslong': '12542567946414629042'}, 'enable': 'true', 'created': '2025-07-21T01:56:07', 'last-modified': '2025-07-21T01:56:07', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.518357'} 2025-07-21 01:56:08,489 - DEBUG - Requesting: http://10.0.0.249:8083/Snh_ShowRoutingInstanceReq?name=default-domain:k8s-default:__public__:__public__ 2025-07-21 01:56:08,497 - DEBUG - Route Targets: ['target:64512:8000007'] 2025-07-21 01:56:08,497 - INFO - On all control nodes, Config, RI and RT verification for VN __public__ passed 2025-07-21 01:56:08,498 - DEBUG - ====Verifying policy data for __public__ in API_Server ====== 2025-07-21 01:56:08,498 - DEBUG - Requesting: http://10.0.0.249:8082/domains 2025-07-21 01:56:08,505 - DEBUG - Requesting: http://10.0.0.249:8082/domain/240e9431-6035-4dd9-af6e-5880e8512984 2025-07-21 01:56:08,514 - DEBUG - Requesting: http://10.0.0.249:8082/project/62d7fb53-ed32-4e11-985e-59035f66838a 2025-07-21 01:56:08,591 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/c12435da-5bff-4878-ae10-2718093ea0b2 2025-07-21 01:56:08,608 - DEBUG - =>VN __public__ has no policy to be verified 2025-07-21 01:56:08,608 - DEBUG - Verifying the vn in opserver 2025-07-21 01:56:08,608 - DEBUG - Verifying the default-domain:k8s-default:__public__ virtual network link through opserver 10.0.0.249 2025-07-21 01:56:08,608 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks 2025-07-21 01:56:08,615 - 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-07-21 01:56:08,615 - INFO - Validated that VN default-domain:k8s-default:__public__ is found in opserver 2025-07-21 01:56:08,615 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VrfListReq?name=default-domain:k8s-default:__public__:__public__ 2025-07-21 01:56:08,623 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VrfListReq?name=default-domain:k8s-default:__public__:__public__ 2025-07-21 01:56:08,629 - DEBUG - Do not have enough data to verify VN in agent 2025-07-21 01:56:08,629 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VrfListReq?name=default-domain:k8s-default:__public__:__public__ 2025-07-21 01:56:08,635 - DEBUG - VRF ids for VN __public__: {} 2025-07-21 01:56:08,824 - INFO - Creating Floating IP pool __fip_pool_public__ in API Server 2025-07-21 01:56:09,092 - DEBUG - Requesting: http://10.0.0.249:8082/domains 2025-07-21 01:56:09,111 - DEBUG - Requesting: http://10.0.0.249:8082/domain/240e9431-6035-4dd9-af6e-5880e8512984 2025-07-21 01:56:09,127 - DEBUG - Requesting: http://10.0.0.249:8082/project/62d7fb53-ed32-4e11-985e-59035f66838a 2025-07-21 01:56:09,173 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/c12435da-5bff-4878-ae10-2718093ea0b2 2025-07-21 01:56:09,188 - DEBUG - Requesting: http://10.0.0.249:8082/floating-ip-pool/e557d05c-3b1c-40c7-9c1c-d35694b31e29 2025-07-21 01:56:09,207 - DEBUG - Requesting: http://10.0.0.249:8082/domains 2025-07-21 01:56:09,217 - DEBUG - Requesting: http://10.0.0.249:8082/domain/240e9431-6035-4dd9-af6e-5880e8512984 2025-07-21 01:56:09,229 - DEBUG - Requesting: http://10.0.0.249:8082/project/62d7fb53-ed32-4e11-985e-59035f66838a 2025-07-21 01:56:09,265 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/c12435da-5bff-4878-ae10-2718093ea0b2 2025-07-21 01:56:09,275 - DEBUG - FIP Pool __fip_pool_public__ found in API Server 2025-07-21 01:56:09,275 - INFO - Verification for FIP pool __fip_pool_public__ in API Server passed 2025-07-21 01:56:09,282 - 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-07-21 01:56:09,288 - DEBUG - Control-node Ifmap-view has FIP pool __fip_pool_public__ information 2025-07-21 01:56:09,288 - INFO - Verification for FIP pool __fip_pool_public__ in Control-node passed 2025-07-21 01:56:09,292 - DEBUG - Ingress ctest-nginx-ingress-82397397 not present 2025-07-21 01:56:09,293 - INFO - Creating Ingress ctest-nginx-ingress-82397397 2025-07-21 01:56:09,300 - INFO - Created Ingress ctest-nginx-ingress-82397397 2025-07-21 01:56:09,303 - DEBUG - Cluster IP not yet seen for Ingress ctest-nginx-ingress-82397397 2025-07-21 01:56:12,308 - DEBUG - Cluster IP not yet seen for Ingress ctest-nginx-ingress-82397397 2025-07-21 01:56:15,315 - DEBUG - For Ingress ctest-nginx-ingress-82397397, Cluster IP: 10.47.255.248, External IPs ['28.38.119.124'] 2025-07-21 01:56:15,315 - INFO - Verifications in k8s passed for Ingress ctest-nginx-ingress-82397397 2025-07-21 01:56:15,315 - DEBUG - Requesting: http://10.0.0.249:8108/Snh_LoadbalancerDatabaseList?x=ce6b0040-a288-4cf4-a126-a756cf249fb9 2025-07-21 01:56:15,322 - INFO - Ingress ctest-nginx-ingress-82397397 with uuid ce6b0040-a288-4cf4-a126-a756cf249fb9 found in kube manager 2025-07-21 01:56:15,322 - INFO - Ingress ctest-nginx-ingress-82397397 verification passed 2025-07-21 01:56:15,325 - DEBUG - Pod ctest-busybox-pod-60298251 not present 2025-07-21 01:56:15,325 - INFO - Creating Pod ctest-busybox-pod-60298251 2025-07-21 01:56:15,350 - DEBUG - Pod : ctest-busybox-pod-60298251 UUID is 7dcdb738-a6d4-46fd-a3a8-6a44e0b61e6e 2025-07-21 01:56:15,359 - DEBUG - Pod ctest-nginx-pod-15283292 not in running state.Currently in Pending 2025-07-21 01:56:20,366 - DEBUG - Pod ctest-nginx-pod-15283292 not in running state.Currently in Pending 2025-07-21 01:56:25,376 - INFO - Pod ctest-nginx-pod-15283292 is in running state.Got IP 10.47.255.250 2025-07-21 01:56:25,448 - DEBUG - Pod ctest-nginx-pod-15283292 has vmi dfab084e-65d5-11f0-94bf-0242ad4e3b36 2025-07-21 01:56:25,448 - INFO - Verified pod ctest-nginx-pod-15283292 in contrail-api 2025-07-21 01:56:25,448 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2025-07-21 01:56:25,459 - DEBUG - VMI dfab084e-65d5-11f0-94bf-0242ad4e3b36 is active in agent 10.0.0.249 2025-07-21 01:56:25,459 - INFO - Verified Pod ctest-nginx-pod-15283292 in agent 10.0.0.249 2025-07-21 01:56:25,459 - DEBUG - Requesting: http://10.0.0.249:8108/Snh_VirtualMachineDatabaseList?x=4f4a01ee-d943-4ae0-9a5d-e0944fdc38e0 2025-07-21 01:56:25,463 - INFO - Pod ctest-nginx-pod-15283292 with uuid 4f4a01ee-d943-4ae0-9a5d-e0944fdc38e0 found in kube manager 2025-07-21 01:56:25,463 - INFO - Pod ctest-nginx-pod-15283292 verification passed 2025-07-21 01:56:25,541 - DEBUG - [Pod ctest-nginx-pod-15283292] Cmd: echo ctest-nginx-pod-15283292 > /usr/share/nginx/html/index.html, Output: 2025-07-21 01:56:25,547 - INFO - Pod ctest-nginx-pod-79508112 is in running state.Got IP 10.47.255.249 2025-07-21 01:56:25,601 - DEBUG - Pod ctest-nginx-pod-79508112 has vmi e0658aac-65d5-11f0-94bf-0242ad4e3b36 2025-07-21 01:56:25,601 - INFO - Verified pod ctest-nginx-pod-79508112 in contrail-api 2025-07-21 01:56:25,602 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2025-07-21 01:56:25,611 - DEBUG - VMI e0658aac-65d5-11f0-94bf-0242ad4e3b36 is active in agent 10.0.0.249 2025-07-21 01:56:25,611 - INFO - Verified Pod ctest-nginx-pod-79508112 in agent 10.0.0.249 2025-07-21 01:56:25,611 - DEBUG - Requesting: http://10.0.0.249:8108/Snh_VirtualMachineDatabaseList?x=f32c43c7-74dc-4ce0-b156-d697499a63d9 2025-07-21 01:56:25,615 - INFO - Pod ctest-nginx-pod-79508112 with uuid f32c43c7-74dc-4ce0-b156-d697499a63d9 found in kube manager 2025-07-21 01:56:25,615 - INFO - Pod ctest-nginx-pod-79508112 verification passed 2025-07-21 01:56:25,679 - DEBUG - [Pod ctest-nginx-pod-79508112] Cmd: echo ctest-nginx-pod-79508112 > /usr/share/nginx/html/index.html, Output: 2025-07-21 01:56:25,684 - DEBUG - Pod ctest-busybox-pod-60298251 not in running state.Currently in Pending 2025-07-21 01:56:30,694 - INFO - Pod ctest-busybox-pod-60298251 is in running state.Got IP 10.47.255.247 2025-07-21 01:56:30,748 - DEBUG - Pod ctest-busybox-pod-60298251 has vmi e3fe14e0-65d5-11f0-94bf-0242ad4e3b36 2025-07-21 01:56:30,748 - INFO - Verified pod ctest-busybox-pod-60298251 in contrail-api 2025-07-21 01:56:30,749 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2025-07-21 01:56:30,759 - DEBUG - VMI e3fe14e0-65d5-11f0-94bf-0242ad4e3b36 is active in agent 10.0.0.249 2025-07-21 01:56:30,759 - INFO - Verified Pod ctest-busybox-pod-60298251 in agent 10.0.0.249 2025-07-21 01:56:30,759 - DEBUG - Requesting: http://10.0.0.249:8108/Snh_VirtualMachineDatabaseList?x=7dcdb738-a6d4-46fd-a3a8-6a44e0b61e6e 2025-07-21 01:56:30,764 - INFO - Pod ctest-busybox-pod-60298251 with uuid 7dcdb738-a6d4-46fd-a3a8-6a44e0b61e6e found in kube manager 2025-07-21 01:56:30,764 - INFO - Pod ctest-busybox-pod-60298251 verification passed 2025-07-21 01:56:30,838 - DEBUG - [Pod ctest-busybox-pod-60298251] Cmd: wget http://10.47.255.248:80/ -O - -T 5 -t 1 , Output: Connecting to 10.47.255.248:80 (10.47.255.248:80) ctest-nginx-pod-15283292 writing to stdout - 100% |********************************| 25 0:00:00 ETA written to stdout 2025-07-21 01:56:30,838 - DEBUG - [Pod Pod ctest-busybox-pod-60298251] Cmd wget http://10.47.255.248:80/ -O - -T 5 -t 1 passed 2025-07-21 01:56:30,838 - DEBUG - [Pod Pod ctest-busybox-pod-60298251] Cmd output: Connecting to 10.47.255.248:80 (10.47.255.248:80) ctest-nginx-pod-15283292 writing to stdout - 100% |********************************| 25 0:00:00 ETA written to stdout 2025-07-21 01:56:30,931 - DEBUG - [Pod ctest-busybox-pod-60298251] Cmd: wget http://10.47.255.248:80/ -O - -T 5 -t 1 , Output: Connecting to 10.47.255.248:80 (10.47.255.248:80) ctest-nginx-pod-15283292 writing to stdout - 100% |********************************| 25 0:00:00 ETA written to stdout 2025-07-21 01:56:30,931 - DEBUG - [Pod Pod ctest-busybox-pod-60298251] Cmd wget http://10.47.255.248:80/ -O - -T 5 -t 1 passed 2025-07-21 01:56:30,931 - DEBUG - [Pod Pod ctest-busybox-pod-60298251] Cmd output: Connecting to 10.47.255.248:80 (10.47.255.248:80) ctest-nginx-pod-15283292 writing to stdout - 100% |********************************| 25 0:00:00 ETA written to stdout 2025-07-21 01:56:31,010 - DEBUG - [Pod ctest-busybox-pod-60298251] Cmd: wget http://10.47.255.248:80/ -O - -T 5 -t 1 , Output: Connecting to 10.47.255.248:80 (10.47.255.248:80) writing to stdout ctest-nginx-pod-15283292 - 100% |********************************| 25 0:00:00 ETA written to stdout 2025-07-21 01:56:31,010 - DEBUG - [Pod Pod ctest-busybox-pod-60298251] Cmd wget http://10.47.255.248:80/ -O - -T 5 -t 1 passed 2025-07-21 01:56:31,010 - DEBUG - [Pod Pod ctest-busybox-pod-60298251] Cmd output: Connecting to 10.47.255.248:80 (10.47.255.248:80) writing to stdout ctest-nginx-pod-15283292 - 100% |********************************| 25 0:00:00 ETA written to stdout 2025-07-21 01:56:31,105 - DEBUG - [Pod ctest-busybox-pod-60298251] Cmd: wget http://10.47.255.248:80/ -O - -T 5 -t 1 , Output: Connecting to 10.47.255.248:80 (10.47.255.248:80) ctest-nginx-pod-79508112 writing to stdout - 100% |********************************| 25 0:00:00 ETA written to stdout 2025-07-21 01:56:31,105 - DEBUG - [Pod Pod ctest-busybox-pod-60298251] Cmd wget http://10.47.255.248:80/ -O - -T 5 -t 1 passed 2025-07-21 01:56:31,105 - DEBUG - [Pod Pod ctest-busybox-pod-60298251] Cmd output: Connecting to 10.47.255.248:80 (10.47.255.248:80) ctest-nginx-pod-79508112 writing to stdout - 100% |********************************| 25 0:00:00 ETA written to stdout 2025-07-21 01:56:31,105 - INFO - Responses seen from all pods, lb seems fine.Hits : {'ctest-nginx-pod-15283292': 3, 'ctest-nginx-pod-79508112': 1} 2025-07-21 01:56:31,105 - WARNING - Nothing to delete parallely 2025-07-21 01:56:31,105 - INFO - Deleting pod default:ctest-busybox-pod-60298251 2025-07-21 01:56:31,123 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VmListReq?uuid=7dcdb738-a6d4-46fd-a3a8-6a44e0b61e6e 2025-07-21 01:56:31,139 - WARNING - Pod uuid 7dcdb738-a6d4-46fd-a3a8-6a44e0b61e6e is still seen in agent 10.0.0.249 VM list 2025-07-21 01:56:36,140 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VmListReq?uuid=7dcdb738-a6d4-46fd-a3a8-6a44e0b61e6e 2025-07-21 01:56:36,146 - WARNING - Pod uuid 7dcdb738-a6d4-46fd-a3a8-6a44e0b61e6e is still seen in agent 10.0.0.249 VM list 2025-07-21 01:56:41,147 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VmListReq?uuid=7dcdb738-a6d4-46fd-a3a8-6a44e0b61e6e 2025-07-21 01:56:41,154 - WARNING - Pod uuid 7dcdb738-a6d4-46fd-a3a8-6a44e0b61e6e is still seen in agent 10.0.0.249 VM list 2025-07-21 01:56:46,155 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VmListReq?uuid=7dcdb738-a6d4-46fd-a3a8-6a44e0b61e6e 2025-07-21 01:56:46,160 - WARNING - Pod uuid 7dcdb738-a6d4-46fd-a3a8-6a44e0b61e6e is still seen in agent 10.0.0.249 VM list 2025-07-21 01:56:51,161 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VmListReq?uuid=7dcdb738-a6d4-46fd-a3a8-6a44e0b61e6e 2025-07-21 01:56:51,167 - WARNING - Pod uuid 7dcdb738-a6d4-46fd-a3a8-6a44e0b61e6e is still seen in agent 10.0.0.249 VM list 2025-07-21 01:56:56,168 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VmListReq?uuid=7dcdb738-a6d4-46fd-a3a8-6a44e0b61e6e 2025-07-21 01:56:56,174 - WARNING - Pod uuid 7dcdb738-a6d4-46fd-a3a8-6a44e0b61e6e is still seen in agent 10.0.0.249 VM list 2025-07-21 01:57:01,174 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VmListReq?uuid=7dcdb738-a6d4-46fd-a3a8-6a44e0b61e6e 2025-07-21 01:57:01,183 - WARNING - Pod uuid 7dcdb738-a6d4-46fd-a3a8-6a44e0b61e6e is still seen in agent 10.0.0.249 VM list 2025-07-21 01:57:06,183 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VmListReq?uuid=7dcdb738-a6d4-46fd-a3a8-6a44e0b61e6e 2025-07-21 01:57:06,191 - DEBUG - Pod 7dcdb738-a6d4-46fd-a3a8-6a44e0b61e6e is not in agent 10.0.0.249 VM list 2025-07-21 01:57:06,191 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:e3fe14e0-65d5-11f0-94bf-0242ad4e3b36 2025-07-21 01:57:06,199 - DEBUG - VMI e3fe14e0-65d5-11f0-94bf-0242ad4e3b36 is removed from agent 10.0.0.249 2025-07-21 01:57:06,199 - INFO - Verified that pod ctest-busybox-pod-60298251 is removed in agent 2025-07-21 01:57:06,199 - INFO - Deleting Ingress : ctest-nginx-ingress-82397397 2025-07-21 01:57:06,205 - DEBUG - Requesting: http://10.0.0.249:8108/Snh_LoadbalancerDatabaseList?x=ce6b0040-a288-4cf4-a126-a756cf249fb9 2025-07-21 01:57:06,224 - ERROR - Ingress ctest-nginx-ingress-82397397 with uuid ce6b0040-a288-4cf4-a126-a756cf249fb9 still found in kube manager 2025-07-21 01:57:07,225 - DEBUG - Requesting: http://10.0.0.249:8108/Snh_LoadbalancerDatabaseList?x=ce6b0040-a288-4cf4-a126-a756cf249fb9 2025-07-21 01:57:07,230 - ERROR - Ingress ctest-nginx-ingress-82397397 with uuid ce6b0040-a288-4cf4-a126-a756cf249fb9 still found in kube manager 2025-07-21 01:57:08,233 - DEBUG - Requesting: http://10.0.0.249:8108/Snh_LoadbalancerDatabaseList?x=ce6b0040-a288-4cf4-a126-a756cf249fb9 2025-07-21 01:57:08,238 - INFO - Ingress ctest-nginx-ingress-82397397 with uuid ce6b0040-a288-4cf4-a126-a756cf249fb9 deleted successfully from kube manager 2025-07-21 01:57:08,238 - INFO - Verifications on Ingress %s cleanup passed 2025-07-21 01:57:08,238 - INFO - Deleting the FIP pool __fip_pool_public__ 2025-07-21 01:57:08,358 - 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-07-21 01:57:08,374 - DEBUG - Control-node Ifmap-view does not have FIP pool __fip_pool_public__ information 2025-07-21 01:57:08,374 - INFO - Deleting VN __public__ 2025-07-21 01:57:08,619 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/0190270a-3a6d-41b8-a416-6d578171f30f 2025-07-21 01:57:08,632 - DEBUG - Response Code: 404 2025-07-21 01:57:08,632 - DEBUG - Requesting: http://10.0.0.249:8082/domains 2025-07-21 01:57:08,641 - DEBUG - Requesting: http://10.0.0.249:8082/domain/240e9431-6035-4dd9-af6e-5880e8512984 2025-07-21 01:57:08,649 - DEBUG - Requesting: http://10.0.0.249:8082/project/62d7fb53-ed32-4e11-985e-59035f66838a 2025-07-21 01:57:08,757 - INFO - Validated that VN __public__ is not found in API Server 2025-07-21 01:57:08,757 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VnListReq?name=default-domain:k8s-default:__public__ 2025-07-21 01:57:08,764 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VrfListReq?name=default-domain:k8s-default:__public__:__public__ 2025-07-21 01:57:08,772 - DEBUG - VN __public__ is not present in Agent 10.0.0.249 2025-07-21 01:57:08,772 - INFO - Validated that VN __public__ is not in any agent 2025-07-21 01:57:08,772 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VrfListReq?name=default-domain:k8s-default:__public__:__public__ 2025-07-21 01:57:08,777 - DEBUG - Requesting: http://10.0.0.249:8083/Snh_ShowRoutingInstanceReq?name=default-domain:k8s-default:__public__:__public__ 2025-07-21 01:57:08,784 - DEBUG - Requesting: http://10.0.0.249:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:k8s-default:__public__ 2025-07-21 01:57:08,789 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN __public__ info 2025-07-21 01:57:08,789 - INFO - Deleting pod default:ctest-nginx-pod-79508112 2025-07-21 01:57:08,798 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VmListReq?uuid=f32c43c7-74dc-4ce0-b156-d697499a63d9 2025-07-21 01:57:08,808 - WARNING - Pod uuid f32c43c7-74dc-4ce0-b156-d697499a63d9 is still seen in agent 10.0.0.249 VM list 2025-07-21 01:57:13,809 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VmListReq?uuid=f32c43c7-74dc-4ce0-b156-d697499a63d9 2025-07-21 01:57:13,815 - DEBUG - Pod f32c43c7-74dc-4ce0-b156-d697499a63d9 is not in agent 10.0.0.249 VM list 2025-07-21 01:57:13,815 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:e0658aac-65d5-11f0-94bf-0242ad4e3b36 2025-07-21 01:57:13,820 - DEBUG - VMI e0658aac-65d5-11f0-94bf-0242ad4e3b36 is removed from agent 10.0.0.249 2025-07-21 01:57:13,820 - INFO - Verified that pod ctest-nginx-pod-79508112 is removed in agent 2025-07-21 01:57:13,821 - INFO - Deleting pod default:ctest-nginx-pod-15283292 2025-07-21 01:57:13,833 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VmListReq?uuid=4f4a01ee-d943-4ae0-9a5d-e0944fdc38e0 2025-07-21 01:57:13,839 - WARNING - Pod uuid 4f4a01ee-d943-4ae0-9a5d-e0944fdc38e0 is still seen in agent 10.0.0.249 VM list 2025-07-21 01:57:18,840 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_VmListReq?uuid=4f4a01ee-d943-4ae0-9a5d-e0944fdc38e0 2025-07-21 01:57:18,847 - DEBUG - Pod 4f4a01ee-d943-4ae0-9a5d-e0944fdc38e0 is not in agent 10.0.0.249 VM list 2025-07-21 01:57:18,847 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:dfab084e-65d5-11f0-94bf-0242ad4e3b36 2025-07-21 01:57:18,854 - DEBUG - VMI dfab084e-65d5-11f0-94bf-0242ad4e3b36 is removed from agent 10.0.0.249 2025-07-21 01:57:18,854 - INFO - Verified that pod ctest-nginx-pod-15283292 is removed in agent 2025-07-21 01:57:18,854 - INFO - Deleting service : ctest-nginx-svc-61550001 2025-07-21 01:57:19,344 - DEBUG - Requesting: http://10.0.0.249:8085/Snh_AgentXmppConnectionStatusReq? 2025-07-21 01:57:19,350 - DEBUG - No XMPP flaps were noticed during the test