2025-01-08 11:59:11,294 - DEBUG - [10.0.0.24]: Running cmd : hostname
2025-01-08 11:59:11,574 - DEBUG - Output : cn-jenkins-deploy-platform-juju-k8s-906-1
2025-01-08 11:59:11,575 - DEBUG - [10.0.0.24]: Running cmd : hostname -f
2025-01-08 11:59:11,609 - DEBUG - Output : cn-jenkins-deploy-platform-juju-k8s-906-1
2025-01-08 11:59:11,609 - DEBUG - [10.0.0.24]: Running cmd : docker ps -a 2>/dev/null | grep -v "/pause\|/usr/bin/pod\|nova_api_\|contrail.*init\|init.*contrail\|provisioner\|placement" | awk '{print $NF}'
2025-01-08 11:59:11,695 - DEBUG - Output : NAMES
contrail_test_OlrW2Rj76
contrail-kubernetes-master_kubemanager_1
analytics_snmp_topology_1
analytics_snmp_nodemgr_1
analytics_snmp_snmp-collector_1
analytics_alarm_kafka_1
analytics_alarm_alarm-gen_1
analytics_alarm_nodemgr_1
analytics_api_1
analytics_collector_1
analytics_nodemgr_1
analytics_database_nodemgr_1
analytics_database_cassandra_1
analytics_database_query-engine_1
redis_redis_1
webui_job_1
webui_web_1
control_named_1
control_control_1
control_dns_1
control_nodemgr_1
config_database_rabbitmq_1
config_database_nodemgr_1
config_database_zookeeper_1
config_database_cassandra_1
config_api_devicemgr_1
config_api_nodemgr_1
config_api_api_1
config_api_dnsmasq_1
config_api_schema_1
config_api_svcmonitor_1
2025-01-08 11:59:11,695 - DEBUG - [10.0.0.24]: Running cmd : ip addr show | grep 'inet .*/.* brd ' | awk '{print $2}'
2025-01-08 11:59:11,779 - DEBUG - Output : 10.0.0.24/24
172.17.0.1/16
2025-01-08 11:59:11,779 - DEBUG - [10.0.0.24]: Running cmd : getent hosts 10.0.0.24 | head -n 1 | awk '{print $2}'
2025-01-08 11:59:11,824 - DEBUG - Output : cn-jenkins-deploy-platform-juju-k8s-906-1
2025-01-08 11:59:11,936 - DEBUG - [10.0.0.34]: Running cmd : hostname
2025-01-08 11:59:12,188 - DEBUG - Output : an-jenkins-deploy-platform-juju-k8s-906-1
2025-01-08 11:59:12,188 - DEBUG - [10.0.0.34]: Running cmd : hostname -f
2025-01-08 11:59:12,254 - DEBUG - Output : an-jenkins-deploy-platform-juju-k8s-906-1
2025-01-08 11:59:12,254 - DEBUG - [10.0.0.34]: Running cmd : docker ps -a 2>/dev/null | grep -v "/pause\|/usr/bin/pod\|nova_api_\|contrail.*init\|init.*contrail\|provisioner\|placement" | awk '{print $NF}'
2025-01-08 11:59:12,299 - DEBUG - Output : NAMES
vrouter_nodemgr_1
vrouter_vrouter-agent_1
2025-01-08 11:59:12,300 - DEBUG - [10.0.0.34]: Running cmd : ip addr show dev vhost0 | grep 'inet .*/.* brd ' | awk '{print $2}'
2025-01-08 11:59:12,335 - DEBUG - Output : 10.0.0.34/24
2025-01-08 11:59:12,335 - DEBUG - [10.0.0.34]: Running cmd : getent hosts 10.0.0.34 | head -n 1 | awk '{print $2}'
2025-01-08 11:59:12,401 - DEBUG - Output : an-jenkins-deploy-platform-juju-k8s-906-1
2025-01-08 11:59:12,482 - INFO - Using existing project ['default-domain', 'k8s-default'](cf72eb8b-8868-4c1c-b964-7e5eb7f8ebad)
2025-01-08 11:59:12,575 - INFO - Using existing project ['default-domain', 'k8s-default'](cf72eb8b-8868-4c1c-b964-7e5eb7f8ebad)
2025-01-08 11:59:12,750 - INFO - ================================================================================
2025-01-08 11:59:12,750 - INFO - STARTING TEST : test_ingress_ip_assignment
2025-01-08 11:59:12,751 - 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-01-08 11:59:13,005 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_AgentXmppConnectionStatusReq?
2025-01-08 11:59:13,013 - DEBUG - Nothing to compare xmpp stats {'10.0.0.34': {'10.0.0.24': '0'}} with
2025-01-08 11:59:13,013 - INFO - Initial checks done. Running the testcase now
2025-01-08 11:59:13,013 - INFO -
2025-01-08 11:59:13,017 - INFO - Namespace default already exists
2025-01-08 11:59:13,017 - DEBUG - [10.0.0.24]: Running cmd : docker exec --privileged -it contrail-kubernetes-master_kubemanager_1 /bin/bash -c 'grep "^[ ]*cluster_project" /etc/contrail/contrail-kubernetes.conf'
2025-01-08 11:59:13,136 - DEBUG - Output : cluster_project={}
2025-01-08 11:59:13,222 - INFO - Project default-domain:k8s-default for Namespace default is seen in contrail-api
2025-01-08 11:59:13,222 - DEBUG - Project uuid in Contrail is cf72eb8b-8868-4c1c-b964-7e5eb7f8ebad
2025-01-08 11:59:13,222 - DEBUG - [10.0.0.24]: Running cmd : docker exec --privileged -it contrail-kubernetes-master_kubemanager_1 /bin/bash -c 'netstat -antp | grep :8108 | grep LISTEN'
2025-01-08 11:59:13,352 - DEBUG - Output : tcp 0 0 0.0.0.0:8108 0.0.0.0:* LISTEN 1/python3
2025-01-08 11:59:13,352 - DEBUG - Requesting: http://10.0.0.24:8108/Snh_NamespaceDatabaseList?namespace_uuid=7b2dff3a-52f9-4f6c-b831-3c7b0ba596d2
2025-01-08 11:59:13,358 - INFO - Namespace default with uuid 7b2dff3a-52f9-4f6c-b831-3c7b0ba596d2 found in kube manager
2025-01-08 11:59:13,358 - INFO - Namespace default verification passed
2025-01-08 11:59:13,362 - DEBUG - Service ctest-nginx-svc-52289205 not present
2025-01-08 11:59:13,362 - INFO - Creating service ctest-nginx-svc-52289205
2025-01-08 11:59:13,385 - INFO - Created Service ctest-nginx-svc-52289205
2025-01-08 11:59:13,395 - DEBUG - Pod ctest-nginx-pod-21584640 not present
2025-01-08 11:59:13,396 - INFO - Creating Pod ctest-nginx-pod-21584640
2025-01-08 11:59:13,456 - DEBUG - Pod : ctest-nginx-pod-21584640 UUID is c519a8c9-f888-4014-956e-573d6a7be385
2025-01-08 11:59:13,461 - DEBUG - Pod ctest-nginx-pod-36023020 not present
2025-01-08 11:59:13,462 - INFO - Creating Pod ctest-nginx-pod-36023020
2025-01-08 11:59:13,490 - DEBUG - Pod : ctest-nginx-pod-36023020 UUID is f02d7c47-ebba-45dc-a914-c4e89787a384
2025-01-08 11:59:13,686 - INFO - Created VN __public__, UUID :8483637b-a6e1-4de3-97d0-dc057b452393
2025-01-08 11:59:14,031 - DEBUG - Requesting: http://10.0.0.24:8082/domains
2025-01-08 11:59:14,042 - DEBUG - Requesting: http://10.0.0.24:8082/domain/91d095a1-961c-413e-a0b8-ef8584696977
2025-01-08 11:59:14,115 - DEBUG - Requesting: http://10.0.0.24:8082/project/cf72eb8b-8868-4c1c-b964-7e5eb7f8ebad
2025-01-08 11:59:14,310 - DEBUG - Requesting: http://10.0.0.24:8082/virtual-network/8483637b-a6e1-4de3-97d0-dc057b452393
2025-01-08 11:59:14,350 - DEBUG - Requesting: http://10.0.0.24:8082/virtual-network/8483637b-a6e1-4de3-97d0-dc057b452393
2025-01-08 11:59:14,379 - DEBUG - Requesting: http://10.0.0.24:8082/routing-instance/b86bbe00-df4c-4314-a6e1-36f6ae806e46
2025-01-08 11:59:14,390 - DEBUG - Requesting: http://10.0.0.24:8082/routing-instance/b86bbe00-df4c-4314-a6e1-36f6ae806e46
2025-01-08 11:59:14,415 - DEBUG - Requesting: http://10.0.0.24:8082/route-target/3f2820ea-72e8-4084-8f0a-e353a940bc0e
2025-01-08 11:59:14,450 - DEBUG - Route Targets: ['target:64512:8000006']
2025-01-08 11:59:14,450 - DEBUG - Requesting: http://10.0.0.24:8082/virtual-network/8483637b-a6e1-4de3-97d0-dc057b452393
2025-01-08 11:59:14,477 - DEBUG - Requesting: http://10.0.0.24:8082/routing-instance/b86bbe00-df4c-4314-a6e1-36f6ae806e46
2025-01-08 11:59:14,537 - INFO - Verified VN network id 13 for VN 8483637b-a6e1-4de3-97d0-dc057b452393
2025-01-08 11:59:14,537 - INFO - Verifications in API Server for VN __public__ passed
2025-01-08 11:59:14,537 - DEBUG - Requesting: http://10.0.0.24:8082/virtual-network/8483637b-a6e1-4de3-97d0-dc057b452393
2025-01-08 11:59:14,561 - DEBUG - Requesting: http://10.0.0.24:8082/routing-instance/b86bbe00-df4c-4314-a6e1-36f6ae806e46
2025-01-08 11:59:14,598 - DEBUG - Requesting: http://10.0.0.24:8082/routing-instance/b86bbe00-df4c-4314-a6e1-36f6ae806e46
2025-01-08 11:59:14,611 - DEBUG - Requesting: http://10.0.0.24:8082/route-target/3f2820ea-72e8-4084-8f0a-e353a940bc0e
2025-01-08 11:59:14,623 - DEBUG - Requesting: http://10.0.0.24:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:k8s-default:__public__
2025-01-08 11:59:14,640 - DEBUG - Control-node 10.0.0.24 : 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': '9548585017687494115', 'uuid-lslong': '10939485410984010643'}, 'enable': 'true', 'created': '2025-01-08T11:59:13', 'last-modified': '2025-01-08T11:59:13', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.750642'}
2025-01-08 11:59:14,640 - DEBUG - Requesting: http://10.0.0.24:8083/Snh_ShowRoutingInstanceReq?name=default-domain:k8s-default:__public__:__public__
2025-01-08 11:59:14,655 - DEBUG - Route Targets: ['target:64512:8000006']
2025-01-08 11:59:14,655 - INFO - On all control nodes, Config, RI and RT verification for VN __public__ passed
2025-01-08 11:59:14,656 - DEBUG - ====Verifying policy data for __public__ in API_Server ======
2025-01-08 11:59:14,656 - DEBUG - Requesting: http://10.0.0.24:8082/domains
2025-01-08 11:59:14,664 - DEBUG - Requesting: http://10.0.0.24:8082/domain/91d095a1-961c-413e-a0b8-ef8584696977
2025-01-08 11:59:14,682 - DEBUG - Requesting: http://10.0.0.24:8082/project/cf72eb8b-8868-4c1c-b964-7e5eb7f8ebad
2025-01-08 11:59:14,772 - DEBUG - Requesting: http://10.0.0.24:8082/virtual-network/8483637b-a6e1-4de3-97d0-dc057b452393
2025-01-08 11:59:14,792 - DEBUG - =>VN __public__ has no policy to be verified
2025-01-08 11:59:14,792 - DEBUG - Verifying the vn in opserver
2025-01-08 11:59:14,792 - DEBUG - Verifying the default-domain:k8s-default:__public__ virtual network link through opserver 10.0.0.24
2025-01-08 11:59:14,792 - DEBUG - Requesting: http://10.0.0.24:8081/analytics/uves/virtual-networks
2025-01-08 11:59:14,797 - DEBUG - vn link and name as {'name': 'default-domain:k8s-default:__public__', 'href': 'http://10.0.0.24:8081/analytics/uves/virtual-network/default-domain:k8s-default:__public__?flat'}
2025-01-08 11:59:14,797 - INFO - Validated that VN default-domain:k8s-default:__public__ is found in opserver
2025-01-08 11:59:14,797 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_VrfListReq?name=default-domain:k8s-default:__public__:__public__
2025-01-08 11:59:14,806 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_VrfListReq?name=default-domain:k8s-default:__public__:__public__
2025-01-08 11:59:14,813 - DEBUG - Do not have enough data to verify VN in agent
2025-01-08 11:59:14,813 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_VrfListReq?name=default-domain:k8s-default:__public__:__public__
2025-01-08 11:59:14,820 - DEBUG - VRF ids for VN __public__: {}
2025-01-08 11:59:14,971 - INFO - Creating Floating IP pool __fip_pool_public__ in API Server
2025-01-08 11:59:15,121 - DEBUG - Requesting: http://10.0.0.24:8082/domains
2025-01-08 11:59:15,127 - DEBUG - Requesting: http://10.0.0.24:8082/domain/91d095a1-961c-413e-a0b8-ef8584696977
2025-01-08 11:59:15,136 - DEBUG - Requesting: http://10.0.0.24:8082/project/cf72eb8b-8868-4c1c-b964-7e5eb7f8ebad
2025-01-08 11:59:15,210 - DEBUG - Requesting: http://10.0.0.24:8082/virtual-network/8483637b-a6e1-4de3-97d0-dc057b452393
2025-01-08 11:59:15,222 - DEBUG - Requesting: http://10.0.0.24:8082/floating-ip-pool/69e08a32-4319-40e9-a3a2-746caf76810b
2025-01-08 11:59:15,230 - DEBUG - Requesting: http://10.0.0.24:8082/domains
2025-01-08 11:59:15,237 - DEBUG - Requesting: http://10.0.0.24:8082/domain/91d095a1-961c-413e-a0b8-ef8584696977
2025-01-08 11:59:15,247 - DEBUG - Requesting: http://10.0.0.24:8082/project/cf72eb8b-8868-4c1c-b964-7e5eb7f8ebad
2025-01-08 11:59:15,304 - DEBUG - Requesting: http://10.0.0.24:8082/virtual-network/8483637b-a6e1-4de3-97d0-dc057b452393
2025-01-08 11:59:15,315 - DEBUG - FIP Pool __fip_pool_public__ found in API Server
2025-01-08 11:59:15,315 - INFO - Verification for FIP pool __fip_pool_public__ in API Server passed
2025-01-08 11:59:15,326 - DEBUG - Requesting: http://10.0.0.24:8083/Snh_IFMapTableShowReq?table_name=floating-ip-pool&search_string=floating-ip-pool:default-domain:k8s-default:__public__:__fip_pool_public__
2025-01-08 11:59:15,345 - DEBUG - Control-node Ifmap-view has FIP pool __fip_pool_public__ information
2025-01-08 11:59:15,345 - INFO - Verification for FIP pool __fip_pool_public__ in Control-node passed
2025-01-08 11:59:15,349 - DEBUG - Ingress ctest-nginx-ingress-18735301 not present
2025-01-08 11:59:15,349 - INFO - Creating Ingress ctest-nginx-ingress-18735301
2025-01-08 11:59:15,363 - INFO - Created Ingress ctest-nginx-ingress-18735301
2025-01-08 11:59:15,369 - DEBUG - Cluster IP not yet seen for Ingress ctest-nginx-ingress-18735301
2025-01-08 11:59:18,374 - DEBUG - Cluster IP not yet seen for Ingress ctest-nginx-ingress-18735301
2025-01-08 11:59:21,380 - DEBUG - For Ingress ctest-nginx-ingress-18735301, Cluster IP: 10.47.255.249, External IPs ['163.180.158.60']
2025-01-08 11:59:21,380 - INFO - Verifications in k8s passed for Ingress ctest-nginx-ingress-18735301
2025-01-08 11:59:21,380 - DEBUG - Requesting: http://10.0.0.24:8108/Snh_LoadbalancerDatabaseList?x=4f8358ab-229f-4fb8-8078-e6e78262de62
2025-01-08 11:59:21,388 - INFO - Ingress ctest-nginx-ingress-18735301 with uuid 4f8358ab-229f-4fb8-8078-e6e78262de62 found in kube manager
2025-01-08 11:59:21,388 - INFO - Ingress ctest-nginx-ingress-18735301 verification passed
2025-01-08 11:59:21,395 - DEBUG - Pod ctest-busybox-pod-67509326 not present
2025-01-08 11:59:21,396 - INFO - Creating Pod ctest-busybox-pod-67509326
2025-01-08 11:59:21,433 - DEBUG - Pod : ctest-busybox-pod-67509326 UUID is 20a45cff-c2ae-47f7-b571-1bee4cc0bd17
2025-01-08 11:59:21,439 - DEBUG - Pod ctest-nginx-pod-21584640 not in running state.Currently in Pending
2025-01-08 11:59:26,447 - DEBUG - Pod ctest-nginx-pod-21584640 not in running state.Currently in Pending
2025-01-08 11:59:31,456 - INFO - Pod ctest-nginx-pod-21584640 is in running state.Got IP 10.47.255.251
2025-01-08 11:59:31,482 - DEBUG - Pod ctest-nginx-pod-21584640 has vmi fb8117fe-cdb7-11ef-882f-fa163eb2dec0
2025-01-08 11:59:31,482 - INFO - Verified pod ctest-nginx-pod-21584640 in contrail-api
2025-01-08 11:59:31,483 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,
2025-01-08 11:59:31,498 - DEBUG - VMI fb8117fe-cdb7-11ef-882f-fa163eb2dec0 is active in agent 10.0.0.34
2025-01-08 11:59:31,498 - INFO - Verified Pod ctest-nginx-pod-21584640 in agent 10.0.0.34
2025-01-08 11:59:31,498 - DEBUG - Requesting: http://10.0.0.24:8108/Snh_VirtualMachineDatabaseList?x=c519a8c9-f888-4014-956e-573d6a7be385
2025-01-08 11:59:31,505 - INFO - Pod ctest-nginx-pod-21584640 with uuid c519a8c9-f888-4014-956e-573d6a7be385 found in kube manager
2025-01-08 11:59:31,505 - INFO - Pod ctest-nginx-pod-21584640 verification passed
2025-01-08 11:59:31,592 - DEBUG - [Pod ctest-nginx-pod-21584640] Cmd: echo ctest-nginx-pod-21584640 > /usr/share/nginx/html/index.html, Output:
2025-01-08 11:59:31,597 - DEBUG - Pod ctest-nginx-pod-36023020 not in running state.Currently in Pending
2025-01-08 11:59:36,604 - INFO - Pod ctest-nginx-pod-36023020 is in running state.Got IP 10.47.255.250
2025-01-08 11:59:36,663 - DEBUG - Pod ctest-nginx-pod-36023020 has vmi fc0d3356-cdb7-11ef-882f-fa163eb2dec0
2025-01-08 11:59:36,663 - INFO - Verified pod ctest-nginx-pod-36023020 in contrail-api
2025-01-08 11:59:36,664 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,
2025-01-08 11:59:36,684 - DEBUG - VMI fc0d3356-cdb7-11ef-882f-fa163eb2dec0 is active in agent 10.0.0.34
2025-01-08 11:59:36,684 - INFO - Verified Pod ctest-nginx-pod-36023020 in agent 10.0.0.34
2025-01-08 11:59:36,685 - DEBUG - Requesting: http://10.0.0.24:8108/Snh_VirtualMachineDatabaseList?x=f02d7c47-ebba-45dc-a914-c4e89787a384
2025-01-08 11:59:36,691 - INFO - Pod ctest-nginx-pod-36023020 with uuid f02d7c47-ebba-45dc-a914-c4e89787a384 found in kube manager
2025-01-08 11:59:36,691 - INFO - Pod ctest-nginx-pod-36023020 verification passed
2025-01-08 11:59:36,746 - DEBUG - [Pod ctest-nginx-pod-36023020] Cmd: echo ctest-nginx-pod-36023020 > /usr/share/nginx/html/index.html, Output:
2025-01-08 11:59:36,752 - INFO - Pod ctest-busybox-pod-67509326 is in running state.Got IP 10.47.255.248
2025-01-08 11:59:36,769 - DEBUG - Pod ctest-busybox-pod-67509326 has vmi ff3e08ca-cdb7-11ef-882f-fa163eb2dec0
2025-01-08 11:59:36,769 - INFO - Verified pod ctest-busybox-pod-67509326 in contrail-api
2025-01-08 11:59:36,770 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,
2025-01-08 11:59:36,784 - DEBUG - VMI ff3e08ca-cdb7-11ef-882f-fa163eb2dec0 is active in agent 10.0.0.34
2025-01-08 11:59:36,785 - INFO - Verified Pod ctest-busybox-pod-67509326 in agent 10.0.0.34
2025-01-08 11:59:36,785 - DEBUG - Requesting: http://10.0.0.24:8108/Snh_VirtualMachineDatabaseList?x=20a45cff-c2ae-47f7-b571-1bee4cc0bd17
2025-01-08 11:59:36,790 - INFO - Pod ctest-busybox-pod-67509326 with uuid 20a45cff-c2ae-47f7-b571-1bee4cc0bd17 found in kube manager
2025-01-08 11:59:36,790 - INFO - Pod ctest-busybox-pod-67509326 verification passed
2025-01-08 11:59:36,853 - DEBUG - [Pod ctest-busybox-pod-67509326] Cmd: wget http://10.47.255.249:80/ -O - -T 5 -t 1 , Output: ctest-nginx-pod-21584640
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-01-08 11:59:36,853 - DEBUG - [Pod Pod ctest-busybox-pod-67509326] Cmd wget http://10.47.255.249:80/ -O - -T 5 -t 1 passed
2025-01-08 11:59:36,853 - DEBUG - [Pod Pod ctest-busybox-pod-67509326] Cmd output: ctest-nginx-pod-21584640
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-01-08 11:59:36,909 - DEBUG - [Pod ctest-busybox-pod-67509326] Cmd: wget http://10.47.255.249:80/ -O - -T 5 -t 1 , Output: ctest-nginx-pod-36023020
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-01-08 11:59:36,909 - DEBUG - [Pod Pod ctest-busybox-pod-67509326] Cmd wget http://10.47.255.249:80/ -O - -T 5 -t 1 passed
2025-01-08 11:59:36,909 - DEBUG - [Pod Pod ctest-busybox-pod-67509326] Cmd output: ctest-nginx-pod-36023020
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-01-08 11:59:36,909 - INFO - Responses seen from all pods, lb seems fine.Hits : {'ctest-nginx-pod-21584640': 1, 'ctest-nginx-pod-36023020': 1}
2025-01-08 11:59:36,910 - WARNING - Nothing to delete parallely
2025-01-08 11:59:36,910 - INFO - Deleting pod default:ctest-busybox-pod-67509326
2025-01-08 11:59:36,930 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_VmListReq?uuid=20a45cff-c2ae-47f7-b571-1bee4cc0bd17
2025-01-08 11:59:36,937 - WARNING - Pod uuid 20a45cff-c2ae-47f7-b571-1bee4cc0bd17 is still seen in agent 10.0.0.34 VM list
2025-01-08 11:59:41,938 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_VmListReq?uuid=20a45cff-c2ae-47f7-b571-1bee4cc0bd17
2025-01-08 11:59:41,945 - WARNING - Pod uuid 20a45cff-c2ae-47f7-b571-1bee4cc0bd17 is still seen in agent 10.0.0.34 VM list
2025-01-08 11:59:46,946 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_VmListReq?uuid=20a45cff-c2ae-47f7-b571-1bee4cc0bd17
2025-01-08 11:59:46,954 - WARNING - Pod uuid 20a45cff-c2ae-47f7-b571-1bee4cc0bd17 is still seen in agent 10.0.0.34 VM list
2025-01-08 11:59:51,954 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_VmListReq?uuid=20a45cff-c2ae-47f7-b571-1bee4cc0bd17
2025-01-08 11:59:51,964 - WARNING - Pod uuid 20a45cff-c2ae-47f7-b571-1bee4cc0bd17 is still seen in agent 10.0.0.34 VM list
2025-01-08 11:59:56,965 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_VmListReq?uuid=20a45cff-c2ae-47f7-b571-1bee4cc0bd17
2025-01-08 11:59:56,975 - WARNING - Pod uuid 20a45cff-c2ae-47f7-b571-1bee4cc0bd17 is still seen in agent 10.0.0.34 VM list
2025-01-08 12:00:01,982 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_VmListReq?uuid=20a45cff-c2ae-47f7-b571-1bee4cc0bd17
2025-01-08 12:00:01,992 - WARNING - Pod uuid 20a45cff-c2ae-47f7-b571-1bee4cc0bd17 is still seen in agent 10.0.0.34 VM list
2025-01-08 12:00:06,993 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_VmListReq?uuid=20a45cff-c2ae-47f7-b571-1bee4cc0bd17
2025-01-08 12:00:07,005 - WARNING - Pod uuid 20a45cff-c2ae-47f7-b571-1bee4cc0bd17 is still seen in agent 10.0.0.34 VM list
2025-01-08 12:00:12,006 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_VmListReq?uuid=20a45cff-c2ae-47f7-b571-1bee4cc0bd17
2025-01-08 12:00:12,016 - DEBUG - Pod 20a45cff-c2ae-47f7-b571-1bee4cc0bd17 is not in agent 10.0.0.34 VM list
2025-01-08 12:00:12,016 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:ff3e08ca-cdb7-11ef-882f-fa163eb2dec0
2025-01-08 12:00:12,023 - DEBUG - VMI ff3e08ca-cdb7-11ef-882f-fa163eb2dec0 is removed from agent 10.0.0.34
2025-01-08 12:00:12,023 - INFO - Verified that pod ctest-busybox-pod-67509326 is removed in agent
2025-01-08 12:00:12,023 - INFO - Deleting Ingress : ctest-nginx-ingress-18735301
2025-01-08 12:00:12,032 - DEBUG - Requesting: http://10.0.0.24:8108/Snh_LoadbalancerDatabaseList?x=4f8358ab-229f-4fb8-8078-e6e78262de62
2025-01-08 12:00:12,039 - ERROR - Ingress ctest-nginx-ingress-18735301 with uuid 4f8358ab-229f-4fb8-8078-e6e78262de62 still found in kube manager
2025-01-08 12:00:13,040 - DEBUG - Requesting: http://10.0.0.24:8108/Snh_LoadbalancerDatabaseList?x=4f8358ab-229f-4fb8-8078-e6e78262de62
2025-01-08 12:00:13,045 - ERROR - Ingress ctest-nginx-ingress-18735301 with uuid 4f8358ab-229f-4fb8-8078-e6e78262de62 still found in kube manager
2025-01-08 12:00:14,045 - DEBUG - Requesting: http://10.0.0.24:8108/Snh_LoadbalancerDatabaseList?x=4f8358ab-229f-4fb8-8078-e6e78262de62
2025-01-08 12:00:14,052 - INFO - Ingress ctest-nginx-ingress-18735301 with uuid 4f8358ab-229f-4fb8-8078-e6e78262de62 deleted successfully from kube manager
2025-01-08 12:00:14,052 - INFO - Verifications on Ingress %s cleanup passed
2025-01-08 12:00:14,053 - INFO - Deleting the FIP pool __fip_pool_public__
2025-01-08 12:00:14,209 - DEBUG - Requesting: http://10.0.0.24:8083/Snh_IFMapTableShowReq?table_name=floating-ip-pool&search_string=floating-ip-pool:default-domain:k8s-default:__public__:__fip_pool_public__
2025-01-08 12:00:14,220 - DEBUG - Control-node Ifmap-view does not have FIP pool __fip_pool_public__ information
2025-01-08 12:00:14,220 - INFO - Deleting VN __public__
2025-01-08 12:00:14,504 - DEBUG - Requesting: http://10.0.0.24:8082/routing-instance/b86bbe00-df4c-4314-a6e1-36f6ae806e46
2025-01-08 12:00:14,512 - DEBUG - Response Code: 404
2025-01-08 12:00:14,513 - DEBUG - Requesting: http://10.0.0.24:8082/domains
2025-01-08 12:00:14,521 - DEBUG - Requesting: http://10.0.0.24:8082/domain/91d095a1-961c-413e-a0b8-ef8584696977
2025-01-08 12:00:14,537 - DEBUG - Requesting: http://10.0.0.24:8082/project/cf72eb8b-8868-4c1c-b964-7e5eb7f8ebad
2025-01-08 12:00:14,592 - INFO - Validated that VN __public__ is not found in API Server
2025-01-08 12:00:14,592 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_VnListReq?name=default-domain:k8s-default:__public__
2025-01-08 12:00:14,602 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_VrfListReq?name=default-domain:k8s-default:__public__:__public__
2025-01-08 12:00:14,608 - DEBUG - VN __public__ is not present in Agent 10.0.0.34
2025-01-08 12:00:14,608 - INFO - Validated that VN __public__ is not in any agent
2025-01-08 12:00:14,609 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_VrfListReq?name=default-domain:k8s-default:__public__:__public__
2025-01-08 12:00:14,615 - DEBUG - Requesting: http://10.0.0.24:8083/Snh_ShowRoutingInstanceReq?name=default-domain:k8s-default:__public__:__public__
2025-01-08 12:00:14,622 - DEBUG - Requesting: http://10.0.0.24:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:k8s-default:__public__
2025-01-08 12:00:14,630 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN __public__ info
2025-01-08 12:00:14,631 - INFO - Deleting pod default:ctest-nginx-pod-36023020
2025-01-08 12:00:14,668 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_VmListReq?uuid=f02d7c47-ebba-45dc-a914-c4e89787a384
2025-01-08 12:00:14,688 - WARNING - Pod uuid f02d7c47-ebba-45dc-a914-c4e89787a384 is still seen in agent 10.0.0.34 VM list
2025-01-08 12:00:19,689 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_VmListReq?uuid=f02d7c47-ebba-45dc-a914-c4e89787a384
2025-01-08 12:00:19,696 - DEBUG - Pod f02d7c47-ebba-45dc-a914-c4e89787a384 is not in agent 10.0.0.34 VM list
2025-01-08 12:00:19,697 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:fc0d3356-cdb7-11ef-882f-fa163eb2dec0
2025-01-08 12:00:19,705 - DEBUG - VMI fc0d3356-cdb7-11ef-882f-fa163eb2dec0 is removed from agent 10.0.0.34
2025-01-08 12:00:19,705 - INFO - Verified that pod ctest-nginx-pod-36023020 is removed in agent
2025-01-08 12:00:19,705 - INFO - Deleting pod default:ctest-nginx-pod-21584640
2025-01-08 12:00:19,722 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_VmListReq?uuid=c519a8c9-f888-4014-956e-573d6a7be385
2025-01-08 12:00:19,731 - WARNING - Pod uuid c519a8c9-f888-4014-956e-573d6a7be385 is still seen in agent 10.0.0.34 VM list
2025-01-08 12:00:24,732 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_VmListReq?uuid=c519a8c9-f888-4014-956e-573d6a7be385
2025-01-08 12:00:24,740 - DEBUG - Pod c519a8c9-f888-4014-956e-573d6a7be385 is not in agent 10.0.0.34 VM list
2025-01-08 12:00:24,741 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:fb8117fe-cdb7-11ef-882f-fa163eb2dec0
2025-01-08 12:00:24,748 - DEBUG - VMI fb8117fe-cdb7-11ef-882f-fa163eb2dec0 is removed from agent 10.0.0.34
2025-01-08 12:00:24,748 - INFO - Verified that pod ctest-nginx-pod-21584640 is removed in agent
2025-01-08 12:00:24,749 - INFO - Deleting service : ctest-nginx-svc-52289205
2025-01-08 12:00:24,959 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_AgentXmppConnectionStatusReq?
2025-01-08 12:00:24,970 - DEBUG - No XMPP flaps were noticed during the test
2025-01-08 12:00:24,971 - INFO - END TEST : test_ingress_ip_assignment : PASSED[0:01:12]
2025-01-08 12:00:24,971 - INFO - --------------------------------------------------------------------------------
2025-01-08 12:00:31,521 - DEBUG - [10.0.0.24]: Running cmd : docker exec --privileged -it contrail-kubernetes-master_kubemanager_1 /bin/bash -c 'grep "^[ ]*cluster_project" /etc/contrail/contrail-kubernetes.conf'
2025-01-08 12:00:31,666 - DEBUG - Output : cluster_project={}
2025-01-08 12:00:31,723 - DEBUG - [10.0.0.24]: Running cmd : docker exec --privileged -it contrail-kubernetes-master_kubemanager_1 /bin/bash -c 'netstat -antp | grep :8108 | grep LISTEN'
2025-01-08 12:00:31,943 - DEBUG - Output : tcp 0 0 0.0.0.0:8108 0.0.0.0:* LISTEN 1/python3
2025-01-08 12:00:31,959 - DEBUG - [10.0.0.24]: Running cmd : docker exec --privileged -it contrail-kubernetes-master_kubemanager_1 /bin/bash -c 'grep "^[ ]*cluster_project" /etc/contrail/contrail-kubernetes.conf'
2025-01-08 12:00:32,140 - DEBUG - Output : cluster_project={}
2025-01-08 12:00:47,308 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,
2025-01-08 12:00:47,375 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,
2025-01-08 12:00:47,465 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,
2025-01-08 12:00:52,530 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,
2025-01-08 12:00:52,661 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,
2025-01-08 12:00:52,759 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,
2025-01-08 12:00:52,829 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,
2025-01-08 12:00:52,936 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,
2025-01-08 12:00:53,219 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_AgentXmppConnectionStatusReq?
2025-01-08 12:00:56,102 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_ApplicationPolicySetReq?
2025-01-08 12:00:56,125 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_AclReq?
2025-01-08 12:00:56,163 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_AclReq?
2025-01-08 12:00:58,199 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_AclReq?
2025-01-08 12:04:07,192 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_AgentXmppConnectionStatusReq?
2025-01-08 12:04:07,263 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_VmListReq?uuid=95458b20-533f-415f-99ce-628cf405a4e9
2025-01-08 12:04:07,269 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_VmListReq?uuid=40f2dd29-6ab1-4664-a507-e161e98fd23a
2025-01-08 12:04:07,308 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_VmListReq?uuid=098d23af-964e-4e7b-b8a5-229157d4cfae
2025-01-08 12:04:07,333 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_VmListReq?uuid=ccc00349-e00c-45c1-b3ed-cc9f3506c9c9
2025-01-08 12:04:07,337 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_VmListReq?uuid=fecc91be-43b8-482c-b6b0-b278a5276a0e
2025-01-08 12:04:07,350 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_VmListReq?uuid=e29aee4a-8fd2-45b4-bebc-783feedc7586
2025-01-08 12:04:07,360 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_VmListReq?uuid=6d9a0481-34c2-48a1-a457-a9dd1f09c203
2025-01-08 12:04:07,365 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_VmListReq?uuid=58153549-6911-4ee8-a0c7-48f0f96743ec
2025-01-08 12:04:12,317 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_VmListReq?uuid=95458b20-533f-415f-99ce-628cf405a4e9
2025-01-08 12:04:12,325 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:2a0acfe8-cdb8-11ef-882f-fa163eb2dec0
2025-01-08 12:04:12,328 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_VmListReq?uuid=40f2dd29-6ab1-4664-a507-e161e98fd23a
2025-01-08 12:04:12,377 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_VmListReq?uuid=ccc00349-e00c-45c1-b3ed-cc9f3506c9c9
2025-01-08 12:04:12,380 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_VmListReq?uuid=098d23af-964e-4e7b-b8a5-229157d4cfae
2025-01-08 12:04:12,381 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_VmListReq?uuid=fecc91be-43b8-482c-b6b0-b278a5276a0e
2025-01-08 12:04:12,392 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:2ba5ccae-cdb8-11ef-882f-fa163eb2dec0
2025-01-08 12:04:12,397 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:2c424958-cdb8-11ef-882f-fa163eb2dec0
2025-01-08 12:04:12,404 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_VmListReq?uuid=e29aee4a-8fd2-45b4-bebc-783feedc7586
2025-01-08 12:04:12,406 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_VmListReq?uuid=58153549-6911-4ee8-a0c7-48f0f96743ec
2025-01-08 12:04:12,407 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_VmListReq?uuid=6d9a0481-34c2-48a1-a457-a9dd1f09c203
2025-01-08 12:04:12,423 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:2ae2c682-cdb8-11ef-882f-fa163eb2dec0
2025-01-08 12:04:17,339 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_VmListReq?uuid=40f2dd29-6ab1-4664-a507-e161e98fd23a
2025-01-08 12:04:17,397 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_VmListReq?uuid=098d23af-964e-4e7b-b8a5-229157d4cfae
2025-01-08 12:04:17,422 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_VmListReq?uuid=e29aee4a-8fd2-45b4-bebc-783feedc7586
2025-01-08 12:04:17,424 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_VmListReq?uuid=6d9a0481-34c2-48a1-a457-a9dd1f09c203
2025-01-08 12:04:22,348 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_VmListReq?uuid=40f2dd29-6ab1-4664-a507-e161e98fd23a
2025-01-08 12:04:22,414 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_VmListReq?uuid=098d23af-964e-4e7b-b8a5-229157d4cfae
2025-01-08 12:04:22,430 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_VmListReq?uuid=e29aee4a-8fd2-45b4-bebc-783feedc7586
2025-01-08 12:04:22,434 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_VmListReq?uuid=6d9a0481-34c2-48a1-a457-a9dd1f09c203
2025-01-08 12:04:27,358 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_VmListReq?uuid=40f2dd29-6ab1-4664-a507-e161e98fd23a
2025-01-08 12:04:27,424 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_VmListReq?uuid=098d23af-964e-4e7b-b8a5-229157d4cfae
2025-01-08 12:04:27,439 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_VmListReq?uuid=e29aee4a-8fd2-45b4-bebc-783feedc7586
2025-01-08 12:04:27,449 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_VmListReq?uuid=6d9a0481-34c2-48a1-a457-a9dd1f09c203
2025-01-08 12:04:32,369 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_VmListReq?uuid=40f2dd29-6ab1-4664-a507-e161e98fd23a
2025-01-08 12:04:32,433 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_VmListReq?uuid=098d23af-964e-4e7b-b8a5-229157d4cfae
2025-01-08 12:04:32,447 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_VmListReq?uuid=e29aee4a-8fd2-45b4-bebc-783feedc7586
2025-01-08 12:04:32,458 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_VmListReq?uuid=6d9a0481-34c2-48a1-a457-a9dd1f09c203
2025-01-08 12:04:37,377 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_VmListReq?uuid=40f2dd29-6ab1-4664-a507-e161e98fd23a
2025-01-08 12:04:37,444 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_VmListReq?uuid=098d23af-964e-4e7b-b8a5-229157d4cfae
2025-01-08 12:04:37,456 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_VmListReq?uuid=e29aee4a-8fd2-45b4-bebc-783feedc7586
2025-01-08 12:04:37,466 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_VmListReq?uuid=6d9a0481-34c2-48a1-a457-a9dd1f09c203
2025-01-08 12:04:42,386 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_VmListReq?uuid=40f2dd29-6ab1-4664-a507-e161e98fd23a
2025-01-08 12:04:42,394 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:2d8fcc04-cdb8-11ef-882f-fa163eb2dec0
2025-01-08 12:04:42,454 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_VmListReq?uuid=098d23af-964e-4e7b-b8a5-229157d4cfae
2025-01-08 12:04:42,462 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:2d038578-cdb8-11ef-882f-fa163eb2dec0
2025-01-08 12:04:42,465 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_VmListReq?uuid=e29aee4a-8fd2-45b4-bebc-783feedc7586
2025-01-08 12:04:42,474 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:2ebc6394-cdb8-11ef-882f-fa163eb2dec0
2025-01-08 12:04:42,485 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_VmListReq?uuid=6d9a0481-34c2-48a1-a457-a9dd1f09c203
2025-01-08 12:04:42,497 - DEBUG - Requesting: http://10.0.0.34:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:2e2ce444-cdb8-11ef-882f-fa163eb2dec0