2025-06-10 15:44:00,857 - DEBUG - [10.0.0.241]: Running cmd : hostname
2025-06-10 15:44:01,128 - DEBUG - Output : cn-jenkins-deploy-platform-ansible-k8s-384-1.novalocal
2025-06-10 15:44:01,128 - DEBUG - [10.0.0.241]: Running cmd : hostname -f
2025-06-10 15:44:01,238 - DEBUG - Output : cn-jenkins-deploy-platform-ansible-k8s-384-1.novalocal
2025-06-10 15:44:01,238 - 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-06-10 15:44:01,416 - DEBUG - Output : NAMES
contrail_test_WnmvWLVY9
vrouter_vrouter-agent_1
vrouter_nodemgr_1
rsyslogd_rsyslogd_1
kubemanager_k8s_kubemanager_1
analytics_snmp_snmp-collector_1
analytics_snmp_nodemgr_1
analytics_snmp_topology_1
analytics_alarm_nodemgr_1
analytics_alarm_alarm-gen_1
analytics_alarm_kafka_1
analytics_api_1
analytics_nodemgr_1
analytics_collector_1
analytics_database_nodemgr_1
analytics_database_query-engine_1
analytics_database_cassandra_1
control_named_1
control_control_1
control_dns_1
control_nodemgr_1
webui_job_1
webui_web_1
config_devicemgr_1
config_nodemgr_1
config_schema_1
config_dnsmasq_1
config_svcmonitor_1
config_api_1
config_database_nodemgr_1
config_database_rabbitmq_1
config_database_zookeeper_1
config_database_cassandra_1
redis_redis_1
2025-06-10 15:44:01,417 - DEBUG - [10.0.0.241]: Running cmd : ip addr show | grep 'inet .*/.* brd ' | awk '{print $2}'
2025-06-10 15:44:01,543 - DEBUG - Output : 10.0.0.241/24
10.20.0.254/24
172.17.0.1/16
10.20.0.254/24
2025-06-10 15:44:01,543 - DEBUG - [10.0.0.241]: Running cmd : getent hosts 10.0.0.241 | head -n 1 | awk '{print $2}'
2025-06-10 15:44:01,680 - DEBUG - Output : cn-jenkins-deploy-platform-ansible-k8s-384-1.novalocal
2025-06-10 15:44:01,681 - DEBUG - [10.0.0.241]: Running cmd : ip addr show dev vhost0 | grep 'inet .*/.* brd ' | awk '{print $2}'
2025-06-10 15:44:01,804 - DEBUG - Output : 10.20.0.254/24
2025-06-10 15:44:01,804 - DEBUG - [10.0.0.241]: Running cmd : getent hosts 10.20.0.254 | head -n 1 | awk '{print $2}'
2025-06-10 15:44:01,938 - DEBUG - Output : cn-jenkins-deploy-platform-ansible-k8s-384-1.novalocal
2025-06-10 15:44:02,297 - INFO - Using existing project ['default-domain', 'k8s-default'](356bacc4-8774-40c0-a03e-a2f11aefe36a)
2025-06-10 15:44:02,398 - INFO - Using existing project ['default-domain', 'k8s-default'](356bacc4-8774-40c0-a03e-a2f11aefe36a)
2025-06-10 15:44:02,565 - INFO - ================================================================================
2025-06-10 15:44:02,565 - INFO - STARTING TEST : test_ingress_ip_assignment
2025-06-10 15:44:02,566 - 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-06-10 15:44:02,868 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_AgentXmppConnectionStatusReq?
2025-06-10 15:44:02,875 - DEBUG - Nothing to compare xmpp stats {'10.0.0.241': {'10.20.0.254': '0'}} with
2025-06-10 15:44:02,875 - INFO - Initial checks done. Running the testcase now
2025-06-10 15:44:02,875 - INFO -
2025-06-10 15:44:02,880 - INFO - Namespace default already exists
2025-06-10 15:44:02,880 - DEBUG - [10.0.0.241]: Running cmd : docker exec --privileged -it kubemanager_k8s_kubemanager_1 /bin/bash -c 'grep "^[ ]*cluster_project" /etc/contrail/contrail-kubernetes.conf'
2025-06-10 15:44:03,051 - DEBUG - Output : cluster_project={}
2025-06-10 15:44:03,105 - INFO - Project default-domain:k8s-default for Namespace default is seen in contrail-api
2025-06-10 15:44:03,106 - DEBUG - Project uuid in Contrail is 356bacc4-8774-40c0-a03e-a2f11aefe36a
2025-06-10 15:44:03,106 - DEBUG - [10.0.0.241]: Running cmd : docker exec --privileged -it kubemanager_k8s_kubemanager_1 /bin/bash -c 'netstat -antp | grep :8108 | grep LISTEN'
2025-06-10 15:44:03,287 - DEBUG - Output : tcp 0 0 0.0.0.0:8108 0.0.0.0:* LISTEN 1/python3
2025-06-10 15:44:03,287 - DEBUG - Requesting: http://10.0.0.241:8108/Snh_NamespaceDatabaseList?namespace_uuid=e1e73496-515a-4e50-ade1-5cac6c63b3d5
2025-06-10 15:44:03,293 - INFO - Namespace default with uuid e1e73496-515a-4e50-ade1-5cac6c63b3d5 found in kube manager
2025-06-10 15:44:03,293 - INFO - Namespace default verification passed
2025-06-10 15:44:03,297 - DEBUG - Service ctest-nginx-svc-02724977 not present
2025-06-10 15:44:03,297 - INFO - Creating service ctest-nginx-svc-02724977
2025-06-10 15:44:03,333 - INFO - Created Service ctest-nginx-svc-02724977
2025-06-10 15:44:03,337 - DEBUG - Pod ctest-nginx-pod-38575566 not present
2025-06-10 15:44:03,338 - INFO - Creating Pod ctest-nginx-pod-38575566
2025-06-10 15:44:03,405 - DEBUG - Pod : ctest-nginx-pod-38575566 UUID is f9c58ca5-9095-460e-9139-007518248962
2025-06-10 15:44:03,408 - DEBUG - Pod ctest-nginx-pod-06020815 not present
2025-06-10 15:44:03,408 - INFO - Creating Pod ctest-nginx-pod-06020815
2025-06-10 15:44:03,447 - DEBUG - Pod : ctest-nginx-pod-06020815 UUID is e56761e4-29ed-4eb0-aedb-abd91f5c0537
2025-06-10 15:44:03,681 - INFO - Created VN __public__, UUID :1832cfdb-49ff-42a9-b539-0c4e1b349bfc
2025-06-10 15:44:03,953 - DEBUG - Requesting: http://10.0.0.241:8082/domains
2025-06-10 15:44:03,964 - DEBUG - Requesting: http://10.0.0.241:8082/domain/070f76a3-8e04-4031-8374-478488ba1b8b
2025-06-10 15:44:03,975 - DEBUG - Requesting: http://10.0.0.241:8082/project/356bacc4-8774-40c0-a03e-a2f11aefe36a
2025-06-10 15:44:04,055 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-network/1832cfdb-49ff-42a9-b539-0c4e1b349bfc
2025-06-10 15:44:04,064 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-network/1832cfdb-49ff-42a9-b539-0c4e1b349bfc
2025-06-10 15:44:04,073 - DEBUG - Requesting: http://10.0.0.241:8082/routing-instance/355938b6-5c4f-4ac2-b2bd-9d7df15a1c75
2025-06-10 15:44:04,088 - DEBUG - Requesting: http://10.0.0.241:8082/routing-instance/355938b6-5c4f-4ac2-b2bd-9d7df15a1c75
2025-06-10 15:44:04,096 - DEBUG - Requesting: http://10.0.0.241:8082/route-target/f5a8c5f1-c0c6-40da-941d-9cad30b40c9e
2025-06-10 15:44:04,102 - DEBUG - Route Targets: ['target:64512:8000007']
2025-06-10 15:44:04,102 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-network/1832cfdb-49ff-42a9-b539-0c4e1b349bfc
2025-06-10 15:44:04,110 - DEBUG - Requesting: http://10.0.0.241:8082/routing-instance/355938b6-5c4f-4ac2-b2bd-9d7df15a1c75
2025-06-10 15:44:04,122 - INFO - Verified VN network id 15 for VN 1832cfdb-49ff-42a9-b539-0c4e1b349bfc
2025-06-10 15:44:04,122 - INFO - Verifications in API Server for VN __public__ passed
2025-06-10 15:44:04,122 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-network/1832cfdb-49ff-42a9-b539-0c4e1b349bfc
2025-06-10 15:44:04,132 - DEBUG - Requesting: http://10.0.0.241:8082/routing-instance/355938b6-5c4f-4ac2-b2bd-9d7df15a1c75
2025-06-10 15:44:04,138 - DEBUG - Requesting: http://10.0.0.241:8082/routing-instance/355938b6-5c4f-4ac2-b2bd-9d7df15a1c75
2025-06-10 15:44:04,144 - DEBUG - Requesting: http://10.0.0.241:8082/route-target/f5a8c5f1-c0c6-40da-941d-9cad30b40c9e
2025-06-10 15:44:04,150 - DEBUG - Requesting: http://10.0.0.241:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:k8s-default:__public__
2025-06-10 15:44:04,157 - DEBUG - Control-node 10.0.0.241 : 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': '1743684546492056233', 'uuid-lslong': '13058482124140878844'}, 'enable': 'true', 'created': '2025-06-10T15:44:03', 'last-modified': '2025-06-10T15:44:03', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.270163'}
2025-06-10 15:44:04,157 - DEBUG - Requesting: http://10.0.0.241:8083/Snh_ShowRoutingInstanceReq?name=default-domain:k8s-default:__public__:__public__
2025-06-10 15:44:04,167 - DEBUG - Route Targets: ['target:64512:8000007']
2025-06-10 15:44:04,167 - INFO - On all control nodes, Config, RI and RT verification for VN __public__ passed
2025-06-10 15:44:04,168 - DEBUG - ====Verifying policy data for __public__ in API_Server ======
2025-06-10 15:44:04,168 - DEBUG - Requesting: http://10.0.0.241:8082/domains
2025-06-10 15:44:04,173 - DEBUG - Requesting: http://10.0.0.241:8082/domain/070f76a3-8e04-4031-8374-478488ba1b8b
2025-06-10 15:44:04,181 - DEBUG - Requesting: http://10.0.0.241:8082/project/356bacc4-8774-40c0-a03e-a2f11aefe36a
2025-06-10 15:44:04,222 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-network/1832cfdb-49ff-42a9-b539-0c4e1b349bfc
2025-06-10 15:44:04,233 - DEBUG - =>VN __public__ has no policy to be verified
2025-06-10 15:44:04,233 - DEBUG - Verifying the vn in opserver
2025-06-10 15:44:04,233 - DEBUG - Verifying the default-domain:k8s-default:__public__ virtual network link through opserver 10.0.0.241
2025-06-10 15:44:04,233 - DEBUG - Requesting: http://10.0.0.241:8081/analytics/uves/virtual-networks
2025-06-10 15:44:04,239 - DEBUG - vn link and name as {'name': 'default-domain:k8s-default:__public__', 'href': 'http://10.0.0.241:8081/analytics/uves/virtual-network/default-domain:k8s-default:__public__?flat'}
2025-06-10 15:44:04,239 - INFO - Validated that VN default-domain:k8s-default:__public__ is found in opserver
2025-06-10 15:44:04,239 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VrfListReq?name=default-domain:k8s-default:__public__:__public__
2025-06-10 15:44:04,250 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VrfListReq?name=default-domain:k8s-default:__public__:__public__
2025-06-10 15:44:04,258 - DEBUG - Do not have enough data to verify VN in agent
2025-06-10 15:44:04,258 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VrfListReq?name=default-domain:k8s-default:__public__:__public__
2025-06-10 15:44:04,266 - DEBUG - VRF ids for VN __public__: {}
2025-06-10 15:44:04,359 - INFO - Creating Floating IP pool __fip_pool_public__ in API Server
2025-06-10 15:44:04,469 - DEBUG - Requesting: http://10.0.0.241:8082/domains
2025-06-10 15:44:04,480 - DEBUG - Requesting: http://10.0.0.241:8082/domain/070f76a3-8e04-4031-8374-478488ba1b8b
2025-06-10 15:44:04,490 - DEBUG - Requesting: http://10.0.0.241:8082/project/356bacc4-8774-40c0-a03e-a2f11aefe36a
2025-06-10 15:44:04,607 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-network/1832cfdb-49ff-42a9-b539-0c4e1b349bfc
2025-06-10 15:44:04,625 - DEBUG - Requesting: http://10.0.0.241:8082/floating-ip-pool/c5d7e8e5-81a0-43b4-8216-972384643fd2
2025-06-10 15:44:04,631 - DEBUG - Requesting: http://10.0.0.241:8082/domains
2025-06-10 15:44:04,639 - DEBUG - Requesting: http://10.0.0.241:8082/domain/070f76a3-8e04-4031-8374-478488ba1b8b
2025-06-10 15:44:04,659 - DEBUG - Requesting: http://10.0.0.241:8082/project/356bacc4-8774-40c0-a03e-a2f11aefe36a
2025-06-10 15:44:04,794 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-network/1832cfdb-49ff-42a9-b539-0c4e1b349bfc
2025-06-10 15:44:04,805 - DEBUG - FIP Pool __fip_pool_public__ found in API Server
2025-06-10 15:44:04,805 - INFO - Verification for FIP pool __fip_pool_public__ in API Server passed
2025-06-10 15:44:04,814 - DEBUG - Requesting: http://10.0.0.241:8083/Snh_IFMapTableShowReq?table_name=floating-ip-pool&search_string=floating-ip-pool:default-domain:k8s-default:__public__:__fip_pool_public__
2025-06-10 15:44:04,824 - DEBUG - Control-node Ifmap-view has FIP pool __fip_pool_public__ information
2025-06-10 15:44:04,824 - INFO - Verification for FIP pool __fip_pool_public__ in Control-node passed
2025-06-10 15:44:04,827 - DEBUG - Ingress ctest-nginx-ingress-52992670 not present
2025-06-10 15:44:04,827 - INFO - Creating Ingress ctest-nginx-ingress-52992670
2025-06-10 15:44:04,835 - INFO - Created Ingress ctest-nginx-ingress-52992670
2025-06-10 15:44:04,841 - DEBUG - Cluster IP not yet seen for Ingress ctest-nginx-ingress-52992670
2025-06-10 15:44:07,846 - DEBUG - Cluster IP not yet seen for Ingress ctest-nginx-ingress-52992670
2025-06-10 15:44:10,851 - DEBUG - Cluster IP not yet seen for Ingress ctest-nginx-ingress-52992670
2025-06-10 15:44:13,857 - DEBUG - Cluster IP not yet seen for Ingress ctest-nginx-ingress-52992670
2025-06-10 15:44:16,862 - DEBUG - Cluster IP not yet seen for Ingress ctest-nginx-ingress-52992670
2025-06-10 15:44:19,869 - DEBUG - Cluster IP not yet seen for Ingress ctest-nginx-ingress-52992670
2025-06-10 15:44:22,876 - DEBUG - Cluster IP not yet seen for Ingress ctest-nginx-ingress-52992670
2025-06-10 15:44:25,882 - DEBUG - Cluster IP not yet seen for Ingress ctest-nginx-ingress-52992670
2025-06-10 15:44:28,887 - DEBUG - Cluster IP not yet seen for Ingress ctest-nginx-ingress-52992670
2025-06-10 15:44:31,892 - DEBUG - Cluster IP not yet seen for Ingress ctest-nginx-ingress-52992670
2025-06-10 15:44:34,898 - DEBUG - For Ingress ctest-nginx-ingress-52992670, Cluster IP: 10.47.255.246, External IPs ['59.25.66.188']
2025-06-10 15:44:34,898 - INFO - Verifications in k8s passed for Ingress ctest-nginx-ingress-52992670
2025-06-10 15:44:34,899 - DEBUG - Requesting: http://10.0.0.241:8108/Snh_LoadbalancerDatabaseList?x=37dec8c4-4742-4ecb-943f-be9bb28ea2dc
2025-06-10 15:44:34,905 - INFO - Ingress ctest-nginx-ingress-52992670 with uuid 37dec8c4-4742-4ecb-943f-be9bb28ea2dc found in kube manager
2025-06-10 15:44:34,906 - INFO - Ingress ctest-nginx-ingress-52992670 verification passed
2025-06-10 15:44:34,912 - DEBUG - Pod ctest-busybox-pod-57768660 not present
2025-06-10 15:44:34,913 - INFO - Creating Pod ctest-busybox-pod-57768660
2025-06-10 15:44:34,984 - DEBUG - Pod : ctest-busybox-pod-57768660 UUID is 0e3c8f42-e994-4ea1-980d-97a118f74c3b
2025-06-10 15:44:35,000 - INFO - Pod ctest-nginx-pod-38575566 is in running state.Got IP 10.47.255.248
2025-06-10 15:44:35,052 - DEBUG - Pod ctest-nginx-pod-38575566 has vmi c0a2c2c2-4611-11f0-a555-fa163e356de7
2025-06-10 15:44:35,052 - INFO - Verified pod ctest-nginx-pod-38575566 in contrail-api
2025-06-10 15:44:35,052 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,
2025-06-10 15:44:35,088 - DEBUG - VMI c0a2c2c2-4611-11f0-a555-fa163e356de7 is active in agent 10.0.0.241
2025-06-10 15:44:35,089 - INFO - Verified Pod ctest-nginx-pod-38575566 in agent 10.0.0.241
2025-06-10 15:44:35,089 - DEBUG - Requesting: http://10.0.0.241:8108/Snh_VirtualMachineDatabaseList?x=f9c58ca5-9095-460e-9139-007518248962
2025-06-10 15:44:35,101 - INFO - Pod ctest-nginx-pod-38575566 with uuid f9c58ca5-9095-460e-9139-007518248962 found in kube manager
2025-06-10 15:44:35,101 - INFO - Pod ctest-nginx-pod-38575566 verification passed
2025-06-10 15:44:35,207 - DEBUG - [Pod ctest-nginx-pod-38575566] Cmd: echo ctest-nginx-pod-38575566 > /usr/share/nginx/html/index.html, Output:
2025-06-10 15:44:35,214 - INFO - Pod ctest-nginx-pod-06020815 is in running state.Got IP 10.47.255.247
2025-06-10 15:44:35,278 - DEBUG - Pod ctest-nginx-pod-06020815 has vmi c49f23b6-4611-11f0-a555-fa163e356de7
2025-06-10 15:44:35,278 - INFO - Verified pod ctest-nginx-pod-06020815 in contrail-api
2025-06-10 15:44:35,279 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,
2025-06-10 15:44:35,296 - DEBUG - VMI c49f23b6-4611-11f0-a555-fa163e356de7 is active in agent 10.0.0.241
2025-06-10 15:44:35,297 - INFO - Verified Pod ctest-nginx-pod-06020815 in agent 10.0.0.241
2025-06-10 15:44:35,297 - DEBUG - Requesting: http://10.0.0.241:8108/Snh_VirtualMachineDatabaseList?x=e56761e4-29ed-4eb0-aedb-abd91f5c0537
2025-06-10 15:44:35,302 - INFO - Pod ctest-nginx-pod-06020815 with uuid e56761e4-29ed-4eb0-aedb-abd91f5c0537 found in kube manager
2025-06-10 15:44:35,302 - INFO - Pod ctest-nginx-pod-06020815 verification passed
2025-06-10 15:44:35,426 - DEBUG - [Pod ctest-nginx-pod-06020815] Cmd: echo ctest-nginx-pod-06020815 > /usr/share/nginx/html/index.html, Output:
2025-06-10 15:44:35,432 - DEBUG - Pod ctest-busybox-pod-57768660 not in running state.Currently in Pending
2025-06-10 15:44:40,439 - DEBUG - Pod ctest-busybox-pod-57768660 not in running state.Currently in Pending
2025-06-10 15:44:45,450 - DEBUG - Pod ctest-busybox-pod-57768660 not in running state.Currently in Pending
2025-06-10 15:44:50,457 - DEBUG - Pod ctest-busybox-pod-57768660 not in running state.Currently in Pending
2025-06-10 15:44:55,465 - DEBUG - Pod ctest-busybox-pod-57768660 not in running state.Currently in Pending
2025-06-10 15:45:00,479 - DEBUG - Pod ctest-busybox-pod-57768660 not in running state.Currently in Pending
2025-06-10 15:45:05,492 - INFO - Pod ctest-busybox-pod-57768660 is in running state.Got IP 10.47.255.245
2025-06-10 15:45:05,515 - DEBUG - Pod ctest-busybox-pod-57768660 has vmi d6e176b4-4611-11f0-a555-fa163e356de7
2025-06-10 15:45:05,516 - INFO - Verified pod ctest-busybox-pod-57768660 in contrail-api
2025-06-10 15:45:05,516 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,
2025-06-10 15:45:05,530 - DEBUG - VMI d6e176b4-4611-11f0-a555-fa163e356de7 is active in agent 10.0.0.241
2025-06-10 15:45:05,531 - INFO - Verified Pod ctest-busybox-pod-57768660 in agent 10.0.0.241
2025-06-10 15:45:05,531 - DEBUG - Requesting: http://10.0.0.241:8108/Snh_VirtualMachineDatabaseList?x=0e3c8f42-e994-4ea1-980d-97a118f74c3b
2025-06-10 15:45:05,537 - INFO - Pod ctest-busybox-pod-57768660 with uuid 0e3c8f42-e994-4ea1-980d-97a118f74c3b found in kube manager
2025-06-10 15:45:05,537 - INFO - Pod ctest-busybox-pod-57768660 verification passed
2025-06-10 15:45:05,588 - DEBUG - [Pod ctest-busybox-pod-57768660] Cmd: wget http://10.47.255.246:80/ -O - -T 5 -t 1 , Output: Connecting to 10.47.255.246:80 (10.47.255.246:80)
writing to stdout
- 100% |********************************| 25 0:00:00 ETA
written to stdout
ctest-nginx-pod-38575566
2025-06-10 15:45:05,588 - DEBUG - [Pod Pod ctest-busybox-pod-57768660] Cmd wget http://10.47.255.246:80/ -O - -T 5 -t 1 passed
2025-06-10 15:45:05,588 - DEBUG - [Pod Pod ctest-busybox-pod-57768660] Cmd output: Connecting to 10.47.255.246:80 (10.47.255.246:80)
writing to stdout
- 100% |********************************| 25 0:00:00 ETA
written to stdout
ctest-nginx-pod-38575566
2025-06-10 15:45:05,650 - DEBUG - [Pod ctest-busybox-pod-57768660] Cmd: wget http://10.47.255.246:80/ -O - -T 5 -t 1 , Output: Connecting to 10.47.255.246:80 (10.47.255.246:80)
ctest-nginx-pod-38575566
writing to stdout
- 100% |********************************| 25 0:00:00 ETA
written to stdout
2025-06-10 15:45:05,650 - DEBUG - [Pod Pod ctest-busybox-pod-57768660] Cmd wget http://10.47.255.246:80/ -O - -T 5 -t 1 passed
2025-06-10 15:45:05,650 - DEBUG - [Pod Pod ctest-busybox-pod-57768660] Cmd output: Connecting to 10.47.255.246:80 (10.47.255.246:80)
ctest-nginx-pod-38575566
writing to stdout
- 100% |********************************| 25 0:00:00 ETA
written to stdout
2025-06-10 15:45:05,702 - DEBUG - [Pod ctest-busybox-pod-57768660] Cmd: wget http://10.47.255.246:80/ -O - -T 5 -t 1 , Output: ctest-nginx-pod-38575566
Connecting to 10.47.255.246:80 (10.47.255.246:80)
writing to stdout
- 100% |********************************| 25 0:00:00 ETA
written to stdout
2025-06-10 15:45:05,702 - DEBUG - [Pod Pod ctest-busybox-pod-57768660] Cmd wget http://10.47.255.246:80/ -O - -T 5 -t 1 passed
2025-06-10 15:45:05,702 - DEBUG - [Pod Pod ctest-busybox-pod-57768660] Cmd output: ctest-nginx-pod-38575566
Connecting to 10.47.255.246:80 (10.47.255.246:80)
writing to stdout
- 100% |********************************| 25 0:00:00 ETA
written to stdout
2025-06-10 15:45:05,752 - DEBUG - [Pod ctest-busybox-pod-57768660] Cmd: wget http://10.47.255.246:80/ -O - -T 5 -t 1 , Output: Connecting to 10.47.255.246:80 (10.47.255.246:80)
writing to stdout
- 100% |********************************| 25 0:00:00 ETA
written to stdout
ctest-nginx-pod-38575566
2025-06-10 15:45:05,752 - DEBUG - [Pod Pod ctest-busybox-pod-57768660] Cmd wget http://10.47.255.246:80/ -O - -T 5 -t 1 passed
2025-06-10 15:45:05,752 - DEBUG - [Pod Pod ctest-busybox-pod-57768660] Cmd output: Connecting to 10.47.255.246:80 (10.47.255.246:80)
writing to stdout
- 100% |********************************| 25 0:00:00 ETA
written to stdout
ctest-nginx-pod-38575566
2025-06-10 15:45:05,805 - DEBUG - [Pod ctest-busybox-pod-57768660] Cmd: wget http://10.47.255.246:80/ -O - -T 5 -t 1 , Output: Connecting to 10.47.255.246:80 (10.47.255.246:80)
writing to stdout
- 100% |********************************| 25 0:00:00 ETA
written to stdout
ctest-nginx-pod-38575566
2025-06-10 15:45:05,805 - DEBUG - [Pod Pod ctest-busybox-pod-57768660] Cmd wget http://10.47.255.246:80/ -O - -T 5 -t 1 passed
2025-06-10 15:45:05,805 - DEBUG - [Pod Pod ctest-busybox-pod-57768660] Cmd output: Connecting to 10.47.255.246:80 (10.47.255.246:80)
writing to stdout
- 100% |********************************| 25 0:00:00 ETA
written to stdout
ctest-nginx-pod-38575566
2025-06-10 15:45:05,873 - DEBUG - [Pod ctest-busybox-pod-57768660] Cmd: wget http://10.47.255.246:80/ -O - -T 5 -t 1 , Output: Connecting to 10.47.255.246:80 (10.47.255.246:80)
writing to stdout
- 100% |********************************| 25 0:00:00 ETA
written to stdout
ctest-nginx-pod-38575566
2025-06-10 15:45:05,873 - DEBUG - [Pod Pod ctest-busybox-pod-57768660] Cmd wget http://10.47.255.246:80/ -O - -T 5 -t 1 passed
2025-06-10 15:45:05,873 - DEBUG - [Pod Pod ctest-busybox-pod-57768660] Cmd output: Connecting to 10.47.255.246:80 (10.47.255.246:80)
writing to stdout
- 100% |********************************| 25 0:00:00 ETA
written to stdout
ctest-nginx-pod-38575566
2025-06-10 15:45:05,925 - DEBUG - [Pod ctest-busybox-pod-57768660] Cmd: wget http://10.47.255.246:80/ -O - -T 5 -t 1 , Output: Connecting to 10.47.255.246:80 (10.47.255.246:80)
writing to stdout
- 100% |********************************| 25 0:00:00 ETA
written to stdout
ctest-nginx-pod-06020815
2025-06-10 15:45:05,925 - DEBUG - [Pod Pod ctest-busybox-pod-57768660] Cmd wget http://10.47.255.246:80/ -O - -T 5 -t 1 passed
2025-06-10 15:45:05,925 - DEBUG - [Pod Pod ctest-busybox-pod-57768660] Cmd output: Connecting to 10.47.255.246:80 (10.47.255.246:80)
writing to stdout
- 100% |********************************| 25 0:00:00 ETA
written to stdout
ctest-nginx-pod-06020815
2025-06-10 15:45:05,925 - INFO - Responses seen from all pods, lb seems fine.Hits : {'ctest-nginx-pod-38575566': 6, 'ctest-nginx-pod-06020815': 1}
2025-06-10 15:45:05,925 - WARNING - Nothing to delete parallely
2025-06-10 15:45:05,926 - INFO - Deleting pod default:ctest-busybox-pod-57768660
2025-06-10 15:45:05,943 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=0e3c8f42-e994-4ea1-980d-97a118f74c3b
2025-06-10 15:45:05,952 - WARNING - Pod uuid 0e3c8f42-e994-4ea1-980d-97a118f74c3b is still seen in agent 10.0.0.241 VM list
2025-06-10 15:45:10,955 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=0e3c8f42-e994-4ea1-980d-97a118f74c3b
2025-06-10 15:45:10,963 - WARNING - Pod uuid 0e3c8f42-e994-4ea1-980d-97a118f74c3b is still seen in agent 10.0.0.241 VM list
2025-06-10 15:45:15,964 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=0e3c8f42-e994-4ea1-980d-97a118f74c3b
2025-06-10 15:45:15,972 - WARNING - Pod uuid 0e3c8f42-e994-4ea1-980d-97a118f74c3b is still seen in agent 10.0.0.241 VM list
2025-06-10 15:45:20,973 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=0e3c8f42-e994-4ea1-980d-97a118f74c3b
2025-06-10 15:45:20,979 - WARNING - Pod uuid 0e3c8f42-e994-4ea1-980d-97a118f74c3b is still seen in agent 10.0.0.241 VM list
2025-06-10 15:45:25,980 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=0e3c8f42-e994-4ea1-980d-97a118f74c3b
2025-06-10 15:45:25,998 - WARNING - Pod uuid 0e3c8f42-e994-4ea1-980d-97a118f74c3b is still seen in agent 10.0.0.241 VM list
2025-06-10 15:45:30,999 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=0e3c8f42-e994-4ea1-980d-97a118f74c3b
2025-06-10 15:45:31,008 - WARNING - Pod uuid 0e3c8f42-e994-4ea1-980d-97a118f74c3b is still seen in agent 10.0.0.241 VM list
2025-06-10 15:45:36,010 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=0e3c8f42-e994-4ea1-980d-97a118f74c3b
2025-06-10 15:45:36,016 - WARNING - Pod uuid 0e3c8f42-e994-4ea1-980d-97a118f74c3b is still seen in agent 10.0.0.241 VM list
2025-06-10 15:45:41,017 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=0e3c8f42-e994-4ea1-980d-97a118f74c3b
2025-06-10 15:45:41,025 - DEBUG - Pod 0e3c8f42-e994-4ea1-980d-97a118f74c3b is not in agent 10.0.0.241 VM list
2025-06-10 15:45:41,025 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:d6e176b4-4611-11f0-a555-fa163e356de7
2025-06-10 15:45:41,032 - DEBUG - VMI d6e176b4-4611-11f0-a555-fa163e356de7 is removed from agent 10.0.0.241
2025-06-10 15:45:41,032 - INFO - Verified that pod ctest-busybox-pod-57768660 is removed in agent
2025-06-10 15:45:41,032 - INFO - Deleting Ingress : ctest-nginx-ingress-52992670
2025-06-10 15:45:41,041 - DEBUG - Requesting: http://10.0.0.241:8108/Snh_LoadbalancerDatabaseList?x=37dec8c4-4742-4ecb-943f-be9bb28ea2dc
2025-06-10 15:45:41,053 - ERROR - Ingress ctest-nginx-ingress-52992670 with uuid 37dec8c4-4742-4ecb-943f-be9bb28ea2dc still found in kube manager
2025-06-10 15:45:42,054 - DEBUG - Requesting: http://10.0.0.241:8108/Snh_LoadbalancerDatabaseList?x=37dec8c4-4742-4ecb-943f-be9bb28ea2dc
2025-06-10 15:45:42,059 - ERROR - Ingress ctest-nginx-ingress-52992670 with uuid 37dec8c4-4742-4ecb-943f-be9bb28ea2dc still found in kube manager
2025-06-10 15:45:43,060 - DEBUG - Requesting: http://10.0.0.241:8108/Snh_LoadbalancerDatabaseList?x=37dec8c4-4742-4ecb-943f-be9bb28ea2dc
2025-06-10 15:45:43,065 - ERROR - Ingress ctest-nginx-ingress-52992670 with uuid 37dec8c4-4742-4ecb-943f-be9bb28ea2dc still found in kube manager
2025-06-10 15:45:44,065 - DEBUG - Requesting: http://10.0.0.241:8108/Snh_LoadbalancerDatabaseList?x=37dec8c4-4742-4ecb-943f-be9bb28ea2dc
2025-06-10 15:45:44,070 - ERROR - Ingress ctest-nginx-ingress-52992670 with uuid 37dec8c4-4742-4ecb-943f-be9bb28ea2dc still found in kube manager
2025-06-10 15:45:45,072 - DEBUG - Requesting: http://10.0.0.241:8108/Snh_LoadbalancerDatabaseList?x=37dec8c4-4742-4ecb-943f-be9bb28ea2dc
2025-06-10 15:45:45,082 - ERROR - Ingress ctest-nginx-ingress-52992670 with uuid 37dec8c4-4742-4ecb-943f-be9bb28ea2dc still found in kube manager
2025-06-10 15:45:46,083 - DEBUG - Requesting: http://10.0.0.241:8108/Snh_LoadbalancerDatabaseList?x=37dec8c4-4742-4ecb-943f-be9bb28ea2dc
2025-06-10 15:45:46,088 - ERROR - Ingress ctest-nginx-ingress-52992670 with uuid 37dec8c4-4742-4ecb-943f-be9bb28ea2dc still found in kube manager
2025-06-10 15:45:47,089 - DEBUG - Requesting: http://10.0.0.241:8108/Snh_LoadbalancerDatabaseList?x=37dec8c4-4742-4ecb-943f-be9bb28ea2dc
2025-06-10 15:45:47,095 - ERROR - Ingress ctest-nginx-ingress-52992670 with uuid 37dec8c4-4742-4ecb-943f-be9bb28ea2dc still found in kube manager
2025-06-10 15:45:48,097 - DEBUG - Requesting: http://10.0.0.241:8108/Snh_LoadbalancerDatabaseList?x=37dec8c4-4742-4ecb-943f-be9bb28ea2dc
2025-06-10 15:45:48,105 - ERROR - Ingress ctest-nginx-ingress-52992670 with uuid 37dec8c4-4742-4ecb-943f-be9bb28ea2dc still found in kube manager
2025-06-10 15:45:49,106 - DEBUG - Requesting: http://10.0.0.241:8108/Snh_LoadbalancerDatabaseList?x=37dec8c4-4742-4ecb-943f-be9bb28ea2dc
2025-06-10 15:45:49,112 - ERROR - Ingress ctest-nginx-ingress-52992670 with uuid 37dec8c4-4742-4ecb-943f-be9bb28ea2dc still found in kube manager
2025-06-10 15:45:50,113 - DEBUG - Requesting: http://10.0.0.241:8108/Snh_LoadbalancerDatabaseList?x=37dec8c4-4742-4ecb-943f-be9bb28ea2dc
2025-06-10 15:45:50,118 - ERROR - Ingress ctest-nginx-ingress-52992670 with uuid 37dec8c4-4742-4ecb-943f-be9bb28ea2dc still found in kube manager
2025-06-10 15:45:51,122 - DEBUG - Requesting: http://10.0.0.241:8108/Snh_LoadbalancerDatabaseList?x=37dec8c4-4742-4ecb-943f-be9bb28ea2dc
2025-06-10 15:45:51,128 - ERROR - Ingress ctest-nginx-ingress-52992670 with uuid 37dec8c4-4742-4ecb-943f-be9bb28ea2dc still found in kube manager
2025-06-10 15:45:51,129 - INFO - Deleting the FIP pool __fip_pool_public__
2025-06-10 15:45:51,233 - INFO - Deleting VN __public__
2025-06-10 15:45:51,272 - DEBUG - RefsExistError Delete when children still present: ['http://10.0.0.241:8082/floating-ip-pool/c5d7e8e5-81a0-43b4-8216-972384643fd2'] while deleting VN __public__..Will retry
2025-06-10 15:45:53,289 - DEBUG - RefsExistError Delete when children still present: ['http://10.0.0.241:8082/floating-ip-pool/c5d7e8e5-81a0-43b4-8216-972384643fd2'] while deleting VN __public__..Will retry
2025-06-10 15:45:55,308 - DEBUG - RefsExistError Delete when children still present: ['http://10.0.0.241:8082/floating-ip-pool/c5d7e8e5-81a0-43b4-8216-972384643fd2'] while deleting VN __public__..Will retry
2025-06-10 15:45:57,320 - DEBUG - RefsExistError Delete when children still present: ['http://10.0.0.241:8082/floating-ip-pool/c5d7e8e5-81a0-43b4-8216-972384643fd2'] while deleting VN __public__..Will retry
2025-06-10 15:45:59,327 - DEBUG - RefsExistError Delete when children still present: ['http://10.0.0.241:8082/floating-ip-pool/c5d7e8e5-81a0-43b4-8216-972384643fd2'] while deleting VN __public__..Will retry
2025-06-10 15:46:01,335 - DEBUG - RefsExistError Delete when children still present: ['http://10.0.0.241:8082/floating-ip-pool/c5d7e8e5-81a0-43b4-8216-972384643fd2'] while deleting VN __public__..Will retry
2025-06-10 15:46:03,350 - DEBUG - RefsExistError Delete when children still present: ['http://10.0.0.241:8082/floating-ip-pool/c5d7e8e5-81a0-43b4-8216-972384643fd2'] while deleting VN __public__..Will retry
2025-06-10 15:46:05,358 - DEBUG - RefsExistError Delete when children still present: ['http://10.0.0.241:8082/floating-ip-pool/c5d7e8e5-81a0-43b4-8216-972384643fd2'] while deleting VN __public__..Will retry
2025-06-10 15:46:07,372 - DEBUG - RefsExistError Delete when children still present: ['http://10.0.0.241:8082/floating-ip-pool/c5d7e8e5-81a0-43b4-8216-972384643fd2'] while deleting VN __public__..Will retry
2025-06-10 15:46:09,384 - DEBUG - RefsExistError Delete when children still present: ['http://10.0.0.241:8082/floating-ip-pool/c5d7e8e5-81a0-43b4-8216-972384643fd2'] while deleting VN __public__..Will retry
2025-06-10 15:46:11,399 - DEBUG - RefsExistError Delete when children still present: ['http://10.0.0.241:8082/floating-ip-pool/c5d7e8e5-81a0-43b4-8216-972384643fd2'] while deleting VN __public__..Will retry
2025-06-10 15:46:13,412 - DEBUG - RefsExistError Delete when children still present: ['http://10.0.0.241:8082/floating-ip-pool/c5d7e8e5-81a0-43b4-8216-972384643fd2'] while deleting VN __public__..Will retry
2025-06-10 15:46:15,421 - DEBUG - RefsExistError Delete when children still present: ['http://10.0.0.241:8082/floating-ip-pool/c5d7e8e5-81a0-43b4-8216-972384643fd2'] while deleting VN __public__..Will retry
2025-06-10 15:46:17,438 - DEBUG - RefsExistError Delete when children still present: ['http://10.0.0.241:8082/floating-ip-pool/c5d7e8e5-81a0-43b4-8216-972384643fd2'] while deleting VN __public__..Will retry
2025-06-10 15:46:19,456 - DEBUG - RefsExistError Delete when children still present: ['http://10.0.0.241:8082/floating-ip-pool/c5d7e8e5-81a0-43b4-8216-972384643fd2'] while deleting VN __public__..Will retry
2025-06-10 15:46:21,467 - DEBUG - RefsExistError Delete when children still present: ['http://10.0.0.241:8082/floating-ip-pool/c5d7e8e5-81a0-43b4-8216-972384643fd2'] while deleting VN __public__..Will retry
2025-06-10 15:46:23,477 - DEBUG - RefsExistError Delete when children still present: ['http://10.0.0.241:8082/floating-ip-pool/c5d7e8e5-81a0-43b4-8216-972384643fd2'] while deleting VN __public__..Will retry
2025-06-10 15:46:25,511 - DEBUG - RefsExistError Delete when children still present: ['http://10.0.0.241:8082/floating-ip-pool/c5d7e8e5-81a0-43b4-8216-972384643fd2'] while deleting VN __public__..Will retry
2025-06-10 15:46:27,528 - DEBUG - RefsExistError Delete when children still present: ['http://10.0.0.241:8082/floating-ip-pool/c5d7e8e5-81a0-43b4-8216-972384643fd2'] while deleting VN __public__..Will retry
2025-06-10 15:46:29,543 - DEBUG - RefsExistError Delete when children still present: ['http://10.0.0.241:8082/floating-ip-pool/c5d7e8e5-81a0-43b4-8216-972384643fd2'] while deleting VN __public__..Will retry
2025-06-10 15:46:31,556 - DEBUG - RefsExistError Delete when children still present: ['http://10.0.0.241:8082/floating-ip-pool/c5d7e8e5-81a0-43b4-8216-972384643fd2'] while deleting VN __public__..Will retry
2025-06-10 15:46:33,565 - DEBUG - RefsExistError Delete when children still present: ['http://10.0.0.241:8082/floating-ip-pool/c5d7e8e5-81a0-43b4-8216-972384643fd2'] while deleting VN __public__..Will retry
2025-06-10 15:46:35,584 - DEBUG - RefsExistError Delete when children still present: ['http://10.0.0.241:8082/floating-ip-pool/c5d7e8e5-81a0-43b4-8216-972384643fd2'] while deleting VN __public__..Will retry
2025-06-10 15:46:37,595 - DEBUG - RefsExistError Delete when children still present: ['http://10.0.0.241:8082/floating-ip-pool/c5d7e8e5-81a0-43b4-8216-972384643fd2'] while deleting VN __public__..Will retry
2025-06-10 15:46:39,603 - DEBUG - RefsExistError Delete when children still present: ['http://10.0.0.241:8082/floating-ip-pool/c5d7e8e5-81a0-43b4-8216-972384643fd2'] while deleting VN __public__..Will retry
2025-06-10 15:46:41,614 - DEBUG - RefsExistError Delete when children still present: ['http://10.0.0.241:8082/floating-ip-pool/c5d7e8e5-81a0-43b4-8216-972384643fd2'] while deleting VN __public__..Will retry
2025-06-10 15:46:41,614 - DEBUG - Requesting: http://10.0.0.241:8082/routing-instance/355938b6-5c4f-4ac2-b2bd-9d7df15a1c75
2025-06-10 15:46:41,626 - WARNING - RI __public__ is still found in API-Server
2025-06-10 15:46:46,627 - DEBUG - Requesting: http://10.0.0.241:8082/routing-instance/355938b6-5c4f-4ac2-b2bd-9d7df15a1c75
2025-06-10 15:46:46,636 - WARNING - RI __public__ is still found in API-Server
2025-06-10 15:46:51,637 - DEBUG - Requesting: http://10.0.0.241:8082/routing-instance/355938b6-5c4f-4ac2-b2bd-9d7df15a1c75
2025-06-10 15:46:51,646 - WARNING - RI __public__ is still found in API-Server
2025-06-10 15:46:56,647 - DEBUG - Requesting: http://10.0.0.241:8082/routing-instance/355938b6-5c4f-4ac2-b2bd-9d7df15a1c75
2025-06-10 15:46:56,658 - WARNING - RI __public__ is still found in API-Server
2025-06-10 15:47:01,660 - DEBUG - Requesting: http://10.0.0.241:8082/routing-instance/355938b6-5c4f-4ac2-b2bd-9d7df15a1c75
2025-06-10 15:47:01,669 - WARNING - RI __public__ is still found in API-Server
2025-06-10 15:47:06,671 - DEBUG - Requesting: http://10.0.0.241:8082/routing-instance/355938b6-5c4f-4ac2-b2bd-9d7df15a1c75
2025-06-10 15:47:06,682 - WARNING - RI __public__ is still found in API-Server
2025-06-10 15:47:11,683 - DEBUG - Requesting: http://10.0.0.241:8082/routing-instance/355938b6-5c4f-4ac2-b2bd-9d7df15a1c75
2025-06-10 15:47:11,691 - WARNING - RI __public__ is still found in API-Server
2025-06-10 15:47:16,692 - DEBUG - Requesting: http://10.0.0.241:8082/routing-instance/355938b6-5c4f-4ac2-b2bd-9d7df15a1c75
2025-06-10 15:47:16,700 - WARNING - RI __public__ is still found in API-Server
2025-06-10 15:47:21,701 - DEBUG - Requesting: http://10.0.0.241:8082/routing-instance/355938b6-5c4f-4ac2-b2bd-9d7df15a1c75
2025-06-10 15:47:21,710 - WARNING - RI __public__ is still found in API-Server
2025-06-10 15:47:26,711 - DEBUG - Requesting: http://10.0.0.241:8082/routing-instance/355938b6-5c4f-4ac2-b2bd-9d7df15a1c75
2025-06-10 15:47:26,720 - WARNING - RI __public__ is still found in API-Server
2025-06-10 15:47:31,721 - DEBUG - Requesting: http://10.0.0.241:8082/routing-instance/355938b6-5c4f-4ac2-b2bd-9d7df15a1c75
2025-06-10 15:47:31,729 - WARNING - RI __public__ is still found in API-Server
2025-06-10 15:47:31,729 - INFO - Deleting pod default:ctest-nginx-pod-06020815
2025-06-10 15:47:31,759 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=e56761e4-29ed-4eb0-aedb-abd91f5c0537
2025-06-10 15:47:31,767 - WARNING - Pod uuid e56761e4-29ed-4eb0-aedb-abd91f5c0537 is still seen in agent 10.0.0.241 VM list
2025-06-10 15:47:36,768 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=e56761e4-29ed-4eb0-aedb-abd91f5c0537
2025-06-10 15:47:36,775 - DEBUG - Pod e56761e4-29ed-4eb0-aedb-abd91f5c0537 is not in agent 10.0.0.241 VM list
2025-06-10 15:47:36,775 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:c49f23b6-4611-11f0-a555-fa163e356de7
2025-06-10 15:47:36,781 - DEBUG - VMI c49f23b6-4611-11f0-a555-fa163e356de7 is removed from agent 10.0.0.241
2025-06-10 15:47:36,781 - INFO - Verified that pod ctest-nginx-pod-06020815 is removed in agent
2025-06-10 15:47:36,781 - INFO - Deleting pod default:ctest-nginx-pod-38575566
2025-06-10 15:47:36,802 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=f9c58ca5-9095-460e-9139-007518248962
2025-06-10 15:47:36,819 - WARNING - Pod uuid f9c58ca5-9095-460e-9139-007518248962 is still seen in agent 10.0.0.241 VM list
2025-06-10 15:47:41,820 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=f9c58ca5-9095-460e-9139-007518248962
2025-06-10 15:47:41,828 - DEBUG - Pod f9c58ca5-9095-460e-9139-007518248962 is not in agent 10.0.0.241 VM list
2025-06-10 15:47:41,828 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:c0a2c2c2-4611-11f0-a555-fa163e356de7
2025-06-10 15:47:41,835 - DEBUG - VMI c0a2c2c2-4611-11f0-a555-fa163e356de7 is removed from agent 10.0.0.241
2025-06-10 15:47:41,835 - INFO - Verified that pod ctest-nginx-pod-38575566 is removed in agent
2025-06-10 15:47:41,835 - INFO - Deleting service : ctest-nginx-svc-02724977
2025-06-10 15:47:42,372 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_AgentXmppConnectionStatusReq?
2025-06-10 15:47:42,380 - DEBUG - No XMPP flaps were noticed during the test
2025-06-10 15:47:42,380 - INFO - END TEST : test_ingress_ip_assignment : PASSED[0:03:40]
2025-06-10 15:47:42,380 - INFO - --------------------------------------------------------------------------------
2025-06-10 15:47:48,798 - DEBUG - [10.0.0.241]: Running cmd : docker exec --privileged -it kubemanager_k8s_kubemanager_1 /bin/bash -c 'grep "^[ ]*cluster_project" /etc/contrail/contrail-kubernetes.conf'
2025-06-10 15:47:48,967 - DEBUG - Output : cluster_project={}
2025-06-10 15:47:49,033 - DEBUG - [10.0.0.241]: Running cmd : docker exec --privileged -it kubemanager_k8s_kubemanager_1 /bin/bash -c 'netstat -antp | grep :8108 | grep LISTEN'
2025-06-10 15:47:49,228 - DEBUG - Output : tcp 0 0 0.0.0.0:8108 0.0.0.0:* LISTEN 1/python3
2025-06-10 15:47:49,236 - DEBUG - [10.0.0.241]: Running cmd : docker exec --privileged -it kubemanager_k8s_kubemanager_1 /bin/bash -c 'grep "^[ ]*cluster_project" /etc/contrail/contrail-kubernetes.conf'
2025-06-10 15:47:49,550 - DEBUG - Output : cluster_project={}
2025-06-10 15:48:19,735 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,
2025-06-10 15:48:24,805 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,
2025-06-10 15:48:24,858 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,
2025-06-10 15:48:34,916 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,
2025-06-10 15:48:49,990 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,
2025-06-10 15:48:50,039 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,
2025-06-10 15:48:50,095 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,
2025-06-10 15:48:50,138 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,
2025-06-10 15:48:50,737 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_AgentXmppConnectionStatusReq?
2025-06-10 15:48:57,874 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_ApplicationPolicySetReq?
2025-06-10 15:48:57,881 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_AclReq?
2025-06-10 15:48:57,911 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_AclReq?
2025-06-10 15:48:59,949 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_AclReq?
2025-06-10 15:49:01,987 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_AclReq?
2025-06-10 15:49:04,026 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_AclReq?
2025-06-10 15:52:04,350 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_AgentXmppConnectionStatusReq?
2025-06-10 15:52:04,441 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=7a15d2d1-afc9-45af-8e06-c93859660dde
2025-06-10 15:52:04,455 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=9d99c1bb-848d-4d1a-bea9-3535a02ef25e
2025-06-10 15:52:04,484 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=919aeeab-3791-41ec-8a65-046936b8a469
2025-06-10 15:52:04,492 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=30ef1880-5fd1-495c-b940-bc55eefa2373
2025-06-10 15:52:04,499 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=0ce769e7-17c8-4336-8805-7456d4937085
2025-06-10 15:52:04,503 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=d8227010-df76-443d-9609-ed670ceb2209
2025-06-10 15:52:04,510 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=caea14c1-da15-44c2-9b11-f9abccb4597d
2025-06-10 15:52:04,520 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=a6d39d40-4461-42cf-88ba-232080881c08
2025-06-10 15:52:09,581 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=caea14c1-da15-44c2-9b11-f9abccb4597d
2025-06-10 15:52:09,584 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=9d99c1bb-848d-4d1a-bea9-3535a02ef25e
2025-06-10 15:52:09,586 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=7a15d2d1-afc9-45af-8e06-c93859660dde
2025-06-10 15:52:09,587 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=919aeeab-3791-41ec-8a65-046936b8a469
2025-06-10 15:52:09,589 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=d8227010-df76-443d-9609-ed670ceb2209
2025-06-10 15:52:09,591 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=30ef1880-5fd1-495c-b940-bc55eefa2373
2025-06-10 15:52:09,594 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=0ce769e7-17c8-4336-8805-7456d4937085
2025-06-10 15:52:09,599 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=a6d39d40-4461-42cf-88ba-232080881c08
2025-06-10 15:52:09,632 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:539e9a6a-4612-11f0-a555-fa163e356de7
2025-06-10 15:52:14,629 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=0ce769e7-17c8-4336-8805-7456d4937085
2025-06-10 15:52:14,630 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=7a15d2d1-afc9-45af-8e06-c93859660dde
2025-06-10 15:52:14,633 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=9d99c1bb-848d-4d1a-bea9-3535a02ef25e
2025-06-10 15:52:14,634 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=a6d39d40-4461-42cf-88ba-232080881c08
2025-06-10 15:52:14,636 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=30ef1880-5fd1-495c-b940-bc55eefa2373
2025-06-10 15:52:14,637 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=caea14c1-da15-44c2-9b11-f9abccb4597d
2025-06-10 15:52:14,639 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=919aeeab-3791-41ec-8a65-046936b8a469
2025-06-10 15:52:14,678 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:4df3e818-4612-11f0-a555-fa163e356de7
2025-06-10 15:52:14,680 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:516cb614-4612-11f0-a555-fa163e356de7
2025-06-10 15:52:19,675 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=30ef1880-5fd1-495c-b940-bc55eefa2373
2025-06-10 15:52:19,677 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=a6d39d40-4461-42cf-88ba-232080881c08
2025-06-10 15:52:19,679 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=9d99c1bb-848d-4d1a-bea9-3535a02ef25e
2025-06-10 15:52:19,680 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=7a15d2d1-afc9-45af-8e06-c93859660dde
2025-06-10 15:52:19,681 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=919aeeab-3791-41ec-8a65-046936b8a469
2025-06-10 15:52:19,705 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:4b2bb9a8-4612-11f0-a555-fa163e356de7
2025-06-10 15:52:24,703 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=9d99c1bb-848d-4d1a-bea9-3535a02ef25e
2025-06-10 15:52:24,705 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=30ef1880-5fd1-495c-b940-bc55eefa2373
2025-06-10 15:52:24,707 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=a6d39d40-4461-42cf-88ba-232080881c08
2025-06-10 15:52:24,709 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=919aeeab-3791-41ec-8a65-046936b8a469
2025-06-10 15:52:29,727 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=9d99c1bb-848d-4d1a-bea9-3535a02ef25e
2025-06-10 15:52:29,729 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=30ef1880-5fd1-495c-b940-bc55eefa2373
2025-06-10 15:52:29,730 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=a6d39d40-4461-42cf-88ba-232080881c08
2025-06-10 15:52:29,731 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=919aeeab-3791-41ec-8a65-046936b8a469
2025-06-10 15:52:34,747 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=a6d39d40-4461-42cf-88ba-232080881c08
2025-06-10 15:52:34,751 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=30ef1880-5fd1-495c-b940-bc55eefa2373
2025-06-10 15:52:34,754 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=919aeeab-3791-41ec-8a65-046936b8a469
2025-06-10 15:52:34,755 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=9d99c1bb-848d-4d1a-bea9-3535a02ef25e
2025-06-10 15:52:39,815 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=30ef1880-5fd1-495c-b940-bc55eefa2373
2025-06-10 15:52:39,818 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=919aeeab-3791-41ec-8a65-046936b8a469
2025-06-10 15:52:39,819 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=a6d39d40-4461-42cf-88ba-232080881c08
2025-06-10 15:52:39,822 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=9d99c1bb-848d-4d1a-bea9-3535a02ef25e
2025-06-10 15:52:39,836 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:584ed00c-4612-11f0-a555-fa163e356de7
2025-06-10 15:52:39,837 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:5baed56c-4612-11f0-a555-fa163e356de7
2025-06-10 15:52:44,834 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=a6d39d40-4461-42cf-88ba-232080881c08
2025-06-10 15:52:44,840 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_VmListReq?uuid=919aeeab-3791-41ec-8a65-046936b8a469
2025-06-10 15:52:44,857 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:5e34ca30-4612-11f0-a555-fa163e356de7
2025-06-10 15:52:44,859 - DEBUG - Requesting: http://10.0.0.241:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:5ca81c80-4612-11f0-a555-fa163e356de7