2024-11-04 03:27:40,434 - DEBUG - [10.0.0.28]: Running cmd : hostname 2024-11-04 03:27:40,659 - DEBUG - Output : cn-jenkins-deploy-platform-juju-k8s-758-1 2024-11-04 03:27:40,660 - DEBUG - [10.0.0.28]: Running cmd : hostname -f 2024-11-04 03:27:40,694 - DEBUG - Output : cn-jenkins-deploy-platform-juju-k8s-758-1 2024-11-04 03:27:40,694 - DEBUG - [10.0.0.28]: 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}' 2024-11-04 03:27:40,789 - DEBUG - Output : NAMES contrail_test_trVi5wNLd contrail-kubernetes-master_kubemanager_1 webui_job_1 webui_web_1 analytics_snmp_snmp-collector_1 analytics_snmp_nodemgr_1 analytics_snmp_topology_1 analytics_alarm_alarm-gen_1 analytics_alarm_nodemgr_1 analytics_alarm_kafka_1 analytics_nodemgr_1 analytics_api_1 analytics_collector_1 analytics_database_cassandra_1 analytics_database_nodemgr_1 analytics_database_query-engine_1 redis_redis_1 control_named_1 control_control_1 control_dns_1 control_nodemgr_1 config_database_cassandra_1 config_database_zookeeper_1 config_database_rabbitmq_1 config_database_nodemgr_1 config_api_devicemgr_1 config_api_api_1 config_api_nodemgr_1 config_api_svcmonitor_1 config_api_dnsmasq_1 config_api_schema_1 2024-11-04 03:27:40,790 - DEBUG - [10.0.0.28]: Running cmd : ip addr show | grep 'inet .*/.* brd ' | awk '{print $2}' 2024-11-04 03:27:40,869 - DEBUG - Output : 10.0.0.28/24 172.17.0.1/16 2024-11-04 03:27:40,870 - DEBUG - [10.0.0.28]: Running cmd : getent hosts 10.0.0.28 | head -n 1 | awk '{print $2}' 2024-11-04 03:27:40,905 - DEBUG - Output : cn-jenkins-deploy-platform-juju-k8s-758-1 2024-11-04 03:27:41,007 - DEBUG - [10.0.0.31]: Running cmd : hostname 2024-11-04 03:27:41,247 - DEBUG - Output : an-jenkins-deploy-platform-juju-k8s-758-1 2024-11-04 03:27:41,248 - DEBUG - [10.0.0.31]: Running cmd : hostname -f 2024-11-04 03:27:41,282 - DEBUG - Output : an-jenkins-deploy-platform-juju-k8s-758-1 2024-11-04 03:27:41,283 - DEBUG - [10.0.0.31]: 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}' 2024-11-04 03:27:41,359 - DEBUG - Output : NAMES vrouter_nodemgr_1 vrouter_vrouter-agent_1 2024-11-04 03:27:41,359 - DEBUG - [10.0.0.31]: Running cmd : ip addr show dev vhost0 | grep 'inet .*/.* brd ' | awk '{print $2}' 2024-11-04 03:27:41,393 - DEBUG - Output : 10.0.0.31/24 2024-11-04 03:27:41,393 - DEBUG - [10.0.0.31]: Running cmd : getent hosts 10.0.0.31 | head -n 1 | awk '{print $2}' 2024-11-04 03:27:41,427 - DEBUG - Output : an-jenkins-deploy-platform-juju-k8s-758-1 2024-11-04 03:27:41,509 - INFO - Using existing project ['default-domain', 'k8s-default'](7a2e9f33-d28a-4806-bfcb-cc0cbfd970db) 2024-11-04 03:27:41,622 - INFO - Using existing project ['default-domain', 'k8s-default'](7a2e9f33-d28a-4806-bfcb-cc0cbfd970db) 2024-11-04 03:27:41,774 - INFO - ================================================================================ 2024-11-04 03:27:41,774 - INFO - STARTING TEST : test_ingress_ip_assignment 2024-11-04 03:27:41,775 - 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 2024-11-04 03:27:41,983 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_AgentXmppConnectionStatusReq? 2024-11-04 03:27:41,992 - DEBUG - Nothing to compare xmpp stats {'10.0.0.31': {'10.0.0.28': '0'}} with 2024-11-04 03:27:41,992 - INFO - Initial checks done. Running the testcase now 2024-11-04 03:27:41,992 - INFO - 2024-11-04 03:27:41,996 - INFO - Namespace default already exists 2024-11-04 03:27:41,997 - DEBUG - [10.0.0.28]: Running cmd : docker exec --privileged -it contrail-kubernetes-master_kubemanager_1 /bin/bash -c 'grep "^[ ]*cluster_project" /etc/contrail/contrail-kubernetes.conf' 2024-11-04 03:27:42,096 - DEBUG - Output : cluster_project={} 2024-11-04 03:27:42,147 - INFO - Project default-domain:k8s-default for Namespace default is seen in contrail-api 2024-11-04 03:27:42,147 - DEBUG - Project uuid in Contrail is 7a2e9f33-d28a-4806-bfcb-cc0cbfd970db 2024-11-04 03:27:42,148 - DEBUG - [10.0.0.28]: Running cmd : docker exec --privileged -it contrail-kubernetes-master_kubemanager_1 /bin/bash -c 'netstat -antp | grep :8108 | grep LISTEN' 2024-11-04 03:27:42,255 - DEBUG - Output : tcp 0 0 0.0.0.0:8108 0.0.0.0:* LISTEN 1/python3 2024-11-04 03:27:42,255 - DEBUG - Requesting: http://10.0.0.28:8108/Snh_NamespaceDatabaseList?namespace_uuid=f1b11b52-8373-4287-a5ac-08eb751ec29f 2024-11-04 03:27:42,260 - INFO - Namespace default with uuid f1b11b52-8373-4287-a5ac-08eb751ec29f found in kube manager 2024-11-04 03:27:42,260 - INFO - Namespace default verification passed 2024-11-04 03:27:42,263 - DEBUG - Service ctest-nginx-svc-21645842 not present 2024-11-04 03:27:42,263 - INFO - Creating service ctest-nginx-svc-21645842 2024-11-04 03:27:42,299 - INFO - Created Service ctest-nginx-svc-21645842 2024-11-04 03:27:42,306 - DEBUG - Pod ctest-nginx-pod-42295279 not present 2024-11-04 03:27:42,306 - INFO - Creating Pod ctest-nginx-pod-42295279 2024-11-04 03:27:42,372 - DEBUG - Pod : ctest-nginx-pod-42295279 UUID is 15d51a74-6b9f-4961-84f5-c8c813f4a973 2024-11-04 03:27:42,375 - DEBUG - Pod ctest-nginx-pod-53828641 not present 2024-11-04 03:27:42,376 - INFO - Creating Pod ctest-nginx-pod-53828641 2024-11-04 03:27:42,412 - DEBUG - Pod : ctest-nginx-pod-53828641 UUID is 2034add5-8283-4e28-af73-a31b16d0d998 2024-11-04 03:27:42,641 - INFO - Created VN __public__, UUID :9eeb0ec1-1e19-43e4-bc96-95d6691cc762 2024-11-04 03:27:42,887 - DEBUG - Requesting: http://10.0.0.28:8082/domains 2024-11-04 03:27:42,898 - DEBUG - Requesting: http://10.0.0.28:8082/domain/fdd0e898-9a24-4a4d-aee8-9991cbaeb8dc 2024-11-04 03:27:42,917 - DEBUG - Requesting: http://10.0.0.28:8082/project/7a2e9f33-d28a-4806-bfcb-cc0cbfd970db 2024-11-04 03:27:42,998 - DEBUG - Requesting: http://10.0.0.28:8082/virtual-network/9eeb0ec1-1e19-43e4-bc96-95d6691cc762 2024-11-04 03:27:43,015 - DEBUG - Requesting: http://10.0.0.28:8082/virtual-network/9eeb0ec1-1e19-43e4-bc96-95d6691cc762 2024-11-04 03:27:43,027 - DEBUG - Requesting: http://10.0.0.28:8082/routing-instance/f4ac535c-1740-4392-b003-ceac96281fc7 2024-11-04 03:27:43,037 - DEBUG - Requesting: http://10.0.0.28:8082/routing-instance/f4ac535c-1740-4392-b003-ceac96281fc7 2024-11-04 03:27:43,044 - DEBUG - Requesting: http://10.0.0.28:8082/route-target/358ab883-ec0c-4a39-bd9d-020fbdcc0c36 2024-11-04 03:27:43,052 - DEBUG - Route Targets: ['target:64512:8000007'] 2024-11-04 03:27:43,052 - DEBUG - Requesting: http://10.0.0.28:8082/virtual-network/9eeb0ec1-1e19-43e4-bc96-95d6691cc762 2024-11-04 03:27:43,065 - DEBUG - Requesting: http://10.0.0.28:8082/routing-instance/f4ac535c-1740-4392-b003-ceac96281fc7 2024-11-04 03:27:43,136 - INFO - Verified VN network id 13 for VN 9eeb0ec1-1e19-43e4-bc96-95d6691cc762 2024-11-04 03:27:43,136 - INFO - Verifications in API Server for VN __public__ passed 2024-11-04 03:27:43,136 - DEBUG - Requesting: http://10.0.0.28:8082/virtual-network/9eeb0ec1-1e19-43e4-bc96-95d6691cc762 2024-11-04 03:27:43,153 - DEBUG - Requesting: http://10.0.0.28:8082/routing-instance/f4ac535c-1740-4392-b003-ceac96281fc7 2024-11-04 03:27:43,191 - DEBUG - Requesting: http://10.0.0.28:8082/routing-instance/f4ac535c-1740-4392-b003-ceac96281fc7 2024-11-04 03:27:43,217 - DEBUG - Requesting: http://10.0.0.28:8082/route-target/358ab883-ec0c-4a39-bd9d-020fbdcc0c36 2024-11-04 03:27:43,225 - DEBUG - Requesting: http://10.0.0.28:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:k8s-default:__public__ 2024-11-04 03:27:43,234 - DEBUG - Control-node 10.0.0.28 : 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': '11451262700116067300', 'uuid-lslong': '13589213673756084066'}, 'enable': 'true', 'created': '2024-11-04T03:27:42', 'last-modified': '2024-11-04T03:27:42', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.406958'} 2024-11-04 03:27:43,234 - DEBUG - Requesting: http://10.0.0.28:8083/Snh_ShowRoutingInstanceReq?name=default-domain:k8s-default:__public__:__public__ 2024-11-04 03:27:43,244 - DEBUG - Route Targets: ['target:64512:8000007'] 2024-11-04 03:27:43,245 - INFO - On all control nodes, Config, RI and RT verification for VN __public__ passed 2024-11-04 03:27:43,246 - DEBUG - ====Verifying policy data for __public__ in API_Server ====== 2024-11-04 03:27:43,246 - DEBUG - Requesting: http://10.0.0.28:8082/domains 2024-11-04 03:27:43,256 - DEBUG - Requesting: http://10.0.0.28:8082/domain/fdd0e898-9a24-4a4d-aee8-9991cbaeb8dc 2024-11-04 03:27:43,288 - DEBUG - Requesting: http://10.0.0.28:8082/project/7a2e9f33-d28a-4806-bfcb-cc0cbfd970db 2024-11-04 03:27:43,367 - DEBUG - Requesting: http://10.0.0.28:8082/virtual-network/9eeb0ec1-1e19-43e4-bc96-95d6691cc762 2024-11-04 03:27:43,398 - DEBUG - =>VN __public__ has no policy to be verified 2024-11-04 03:27:43,398 - DEBUG - Verifying the vn in opserver 2024-11-04 03:27:43,398 - DEBUG - Verifying the default-domain:k8s-default:__public__ virtual network link through opserver 10.0.0.28 2024-11-04 03:27:43,398 - DEBUG - Requesting: http://10.0.0.28:8081/analytics/uves/virtual-networks 2024-11-04 03:27:43,403 - DEBUG - vn link and name as {'name': 'default-domain:k8s-default:__public__', 'href': 'http://10.0.0.28:8081/analytics/uves/virtual-network/default-domain:k8s-default:__public__?flat'} 2024-11-04 03:27:43,403 - INFO - Validated that VN default-domain:k8s-default:__public__ is found in opserver 2024-11-04 03:27:43,404 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_VrfListReq?name=default-domain:k8s-default:__public__:__public__ 2024-11-04 03:27:43,417 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_VrfListReq?name=default-domain:k8s-default:__public__:__public__ 2024-11-04 03:27:43,423 - DEBUG - Do not have enough data to verify VN in agent 2024-11-04 03:27:43,424 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_VrfListReq?name=default-domain:k8s-default:__public__:__public__ 2024-11-04 03:27:43,430 - DEBUG - VRF ids for VN __public__: {} 2024-11-04 03:27:43,562 - INFO - Creating Floating IP pool __fip_pool_public__ in API Server 2024-11-04 03:27:43,757 - DEBUG - Requesting: http://10.0.0.28:8082/domains 2024-11-04 03:27:43,783 - DEBUG - Requesting: http://10.0.0.28:8082/domain/fdd0e898-9a24-4a4d-aee8-9991cbaeb8dc 2024-11-04 03:27:43,793 - DEBUG - Requesting: http://10.0.0.28:8082/project/7a2e9f33-d28a-4806-bfcb-cc0cbfd970db 2024-11-04 03:27:43,880 - DEBUG - Requesting: http://10.0.0.28:8082/virtual-network/9eeb0ec1-1e19-43e4-bc96-95d6691cc762 2024-11-04 03:27:43,896 - DEBUG - Requesting: http://10.0.0.28:8082/floating-ip-pool/a1c56927-628e-4b93-813f-0d0f8abb1da3 2024-11-04 03:27:43,904 - DEBUG - Requesting: http://10.0.0.28:8082/domains 2024-11-04 03:27:43,909 - DEBUG - Requesting: http://10.0.0.28:8082/domain/fdd0e898-9a24-4a4d-aee8-9991cbaeb8dc 2024-11-04 03:27:43,918 - DEBUG - Requesting: http://10.0.0.28:8082/project/7a2e9f33-d28a-4806-bfcb-cc0cbfd970db 2024-11-04 03:27:44,007 - DEBUG - Requesting: http://10.0.0.28:8082/virtual-network/9eeb0ec1-1e19-43e4-bc96-95d6691cc762 2024-11-04 03:27:44,021 - DEBUG - FIP Pool __fip_pool_public__ found in API Server 2024-11-04 03:27:44,021 - INFO - Verification for FIP pool __fip_pool_public__ in API Server passed 2024-11-04 03:27:44,060 - DEBUG - Requesting: http://10.0.0.28:8083/Snh_IFMapTableShowReq?table_name=floating-ip-pool&search_string=floating-ip-pool:default-domain:k8s-default:__public__:__fip_pool_public__ 2024-11-04 03:27:44,066 - DEBUG - Control-node Ifmap-view has FIP pool __fip_pool_public__ information 2024-11-04 03:27:44,066 - INFO - Verification for FIP pool __fip_pool_public__ in Control-node passed 2024-11-04 03:27:44,081 - DEBUG - Ingress ctest-nginx-ingress-12498318 not present 2024-11-04 03:27:44,082 - INFO - Creating Ingress ctest-nginx-ingress-12498318 2024-11-04 03:27:44,089 - INFO - Created Ingress ctest-nginx-ingress-12498318 2024-11-04 03:27:44,092 - DEBUG - Cluster IP not yet seen for Ingress ctest-nginx-ingress-12498318 2024-11-04 03:27:47,097 - DEBUG - For Ingress ctest-nginx-ingress-12498318, Cluster IP: 10.47.255.249, External IPs ['221.85.205.124'] 2024-11-04 03:27:47,097 - INFO - Verifications in k8s passed for Ingress ctest-nginx-ingress-12498318 2024-11-04 03:27:47,097 - DEBUG - Requesting: http://10.0.0.28:8108/Snh_LoadbalancerDatabaseList?x=30f6101a-2482-4183-afb5-d6f26579b2ea 2024-11-04 03:27:47,102 - INFO - Ingress ctest-nginx-ingress-12498318 with uuid 30f6101a-2482-4183-afb5-d6f26579b2ea found in kube manager 2024-11-04 03:27:47,102 - INFO - Ingress ctest-nginx-ingress-12498318 verification passed 2024-11-04 03:27:47,105 - DEBUG - Pod ctest-busybox-pod-70571750 not present 2024-11-04 03:27:47,105 - INFO - Creating Pod ctest-busybox-pod-70571750 2024-11-04 03:27:47,141 - DEBUG - Pod : ctest-busybox-pod-70571750 UUID is 15d94e3d-718b-4ab0-913c-e2800b0d7764 2024-11-04 03:27:47,147 - DEBUG - Pod ctest-nginx-pod-42295279 not in running state.Currently in Pending 2024-11-04 03:27:52,154 - DEBUG - Pod ctest-nginx-pod-42295279 not in running state.Currently in Pending 2024-11-04 03:27:57,161 - DEBUG - Pod ctest-nginx-pod-42295279 not in running state.Currently in Pending 2024-11-04 03:28:02,184 - INFO - Pod ctest-nginx-pod-42295279 is in running state.Got IP 10.47.255.251 2024-11-04 03:28:02,203 - DEBUG - Pod ctest-nginx-pod-42295279 has vmi c14a03fe-9a5c-11ef-b331-fa163e954dcf 2024-11-04 03:28:02,203 - INFO - Verified pod ctest-nginx-pod-42295279 in contrail-api 2024-11-04 03:28:02,203 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2024-11-04 03:28:02,220 - DEBUG - VMI c14a03fe-9a5c-11ef-b331-fa163e954dcf is active in agent 10.0.0.31 2024-11-04 03:28:02,220 - INFO - Verified Pod ctest-nginx-pod-42295279 in agent 10.0.0.31 2024-11-04 03:28:02,220 - DEBUG - Requesting: http://10.0.0.28:8108/Snh_VirtualMachineDatabaseList?x=15d51a74-6b9f-4961-84f5-c8c813f4a973 2024-11-04 03:28:02,226 - INFO - Pod ctest-nginx-pod-42295279 with uuid 15d51a74-6b9f-4961-84f5-c8c813f4a973 found in kube manager 2024-11-04 03:28:02,226 - INFO - Pod ctest-nginx-pod-42295279 verification passed 2024-11-04 03:28:02,307 - DEBUG - [Pod ctest-nginx-pod-42295279] Cmd: echo ctest-nginx-pod-42295279 > /usr/share/nginx/html/index.html, Output: 2024-11-04 03:28:02,312 - INFO - Pod ctest-nginx-pod-53828641 is in running state.Got IP 10.47.255.250 2024-11-04 03:28:02,330 - DEBUG - Pod ctest-nginx-pod-53828641 has vmi c1c29c74-9a5c-11ef-b331-fa163e954dcf 2024-11-04 03:28:02,330 - INFO - Verified pod ctest-nginx-pod-53828641 in contrail-api 2024-11-04 03:28:02,330 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2024-11-04 03:28:02,345 - DEBUG - VMI c1c29c74-9a5c-11ef-b331-fa163e954dcf is active in agent 10.0.0.31 2024-11-04 03:28:02,345 - INFO - Verified Pod ctest-nginx-pod-53828641 in agent 10.0.0.31 2024-11-04 03:28:02,345 - DEBUG - Requesting: http://10.0.0.28:8108/Snh_VirtualMachineDatabaseList?x=2034add5-8283-4e28-af73-a31b16d0d998 2024-11-04 03:28:02,349 - INFO - Pod ctest-nginx-pod-53828641 with uuid 2034add5-8283-4e28-af73-a31b16d0d998 found in kube manager 2024-11-04 03:28:02,349 - INFO - Pod ctest-nginx-pod-53828641 verification passed 2024-11-04 03:28:02,413 - DEBUG - [Pod ctest-nginx-pod-53828641] Cmd: echo ctest-nginx-pod-53828641 > /usr/share/nginx/html/index.html, Output: 2024-11-04 03:28:02,418 - DEBUG - Pod ctest-busybox-pod-70571750 not in running state.Currently in Pending 2024-11-04 03:28:07,425 - INFO - Pod ctest-busybox-pod-70571750 is in running state.Got IP 10.47.255.248 2024-11-04 03:28:07,497 - DEBUG - Pod ctest-busybox-pod-70571750 has vmi c3f6f94a-9a5c-11ef-b331-fa163e954dcf 2024-11-04 03:28:07,498 - INFO - Verified pod ctest-busybox-pod-70571750 in contrail-api 2024-11-04 03:28:07,498 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2024-11-04 03:28:07,510 - DEBUG - VMI c3f6f94a-9a5c-11ef-b331-fa163e954dcf is active in agent 10.0.0.31 2024-11-04 03:28:07,510 - INFO - Verified Pod ctest-busybox-pod-70571750 in agent 10.0.0.31 2024-11-04 03:28:07,510 - DEBUG - Requesting: http://10.0.0.28:8108/Snh_VirtualMachineDatabaseList?x=15d94e3d-718b-4ab0-913c-e2800b0d7764 2024-11-04 03:28:07,515 - INFO - Pod ctest-busybox-pod-70571750 with uuid 15d94e3d-718b-4ab0-913c-e2800b0d7764 found in kube manager 2024-11-04 03:28:07,515 - INFO - Pod ctest-busybox-pod-70571750 verification passed 2024-11-04 03:28:07,584 - DEBUG - [Pod ctest-busybox-pod-70571750] Cmd: wget http://10.47.255.249:80/ -O - -T 5 -t 1 , Output: ctest-nginx-pod-53828641 Connecting to 10.47.255.249:80 (10.47.255.249:80) writing to stdout - 100% |********************************| 25 0:00:00 ETA written to stdout 2024-11-04 03:28:07,585 - DEBUG - [Pod Pod ctest-busybox-pod-70571750] Cmd wget http://10.47.255.249:80/ -O - -T 5 -t 1 passed 2024-11-04 03:28:07,585 - DEBUG - [Pod Pod ctest-busybox-pod-70571750] Cmd output: ctest-nginx-pod-53828641 Connecting to 10.47.255.249:80 (10.47.255.249:80) writing to stdout - 100% |********************************| 25 0:00:00 ETA written to stdout 2024-11-04 03:28:07,659 - DEBUG - [Pod ctest-busybox-pod-70571750] Cmd: wget http://10.47.255.249:80/ -O - -T 5 -t 1 , Output: Connecting to 10.47.255.249:80 (10.47.255.249:80) writing to stdout - 100% |********************************| 25 0:00:00 ETA written to stdout ctest-nginx-pod-42295279 2024-11-04 03:28:07,660 - DEBUG - [Pod Pod ctest-busybox-pod-70571750] Cmd wget http://10.47.255.249:80/ -O - -T 5 -t 1 passed 2024-11-04 03:28:07,660 - DEBUG - [Pod Pod ctest-busybox-pod-70571750] Cmd output: Connecting to 10.47.255.249:80 (10.47.255.249:80) writing to stdout - 100% |********************************| 25 0:00:00 ETA written to stdout ctest-nginx-pod-42295279 2024-11-04 03:28:07,660 - INFO - Responses seen from all pods, lb seems fine.Hits : {'ctest-nginx-pod-42295279': 1, 'ctest-nginx-pod-53828641': 1} 2024-11-04 03:28:07,660 - WARNING - Nothing to delete parallely 2024-11-04 03:28:07,660 - INFO - Deleting pod default:ctest-busybox-pod-70571750 2024-11-04 03:28:07,681 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_VmListReq?uuid=15d94e3d-718b-4ab0-913c-e2800b0d7764 2024-11-04 03:28:07,690 - WARNING - Pod uuid 15d94e3d-718b-4ab0-913c-e2800b0d7764 is still seen in agent 10.0.0.31 VM list 2024-11-04 03:28:12,691 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_VmListReq?uuid=15d94e3d-718b-4ab0-913c-e2800b0d7764 2024-11-04 03:28:12,698 - WARNING - Pod uuid 15d94e3d-718b-4ab0-913c-e2800b0d7764 is still seen in agent 10.0.0.31 VM list 2024-11-04 03:28:17,699 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_VmListReq?uuid=15d94e3d-718b-4ab0-913c-e2800b0d7764 2024-11-04 03:28:17,707 - WARNING - Pod uuid 15d94e3d-718b-4ab0-913c-e2800b0d7764 is still seen in agent 10.0.0.31 VM list 2024-11-04 03:28:22,707 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_VmListReq?uuid=15d94e3d-718b-4ab0-913c-e2800b0d7764 2024-11-04 03:28:22,715 - WARNING - Pod uuid 15d94e3d-718b-4ab0-913c-e2800b0d7764 is still seen in agent 10.0.0.31 VM list 2024-11-04 03:28:27,716 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_VmListReq?uuid=15d94e3d-718b-4ab0-913c-e2800b0d7764 2024-11-04 03:28:27,724 - WARNING - Pod uuid 15d94e3d-718b-4ab0-913c-e2800b0d7764 is still seen in agent 10.0.0.31 VM list 2024-11-04 03:28:32,724 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_VmListReq?uuid=15d94e3d-718b-4ab0-913c-e2800b0d7764 2024-11-04 03:28:32,732 - WARNING - Pod uuid 15d94e3d-718b-4ab0-913c-e2800b0d7764 is still seen in agent 10.0.0.31 VM list 2024-11-04 03:28:37,733 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_VmListReq?uuid=15d94e3d-718b-4ab0-913c-e2800b0d7764 2024-11-04 03:28:37,741 - WARNING - Pod uuid 15d94e3d-718b-4ab0-913c-e2800b0d7764 is still seen in agent 10.0.0.31 VM list 2024-11-04 03:28:42,742 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_VmListReq?uuid=15d94e3d-718b-4ab0-913c-e2800b0d7764 2024-11-04 03:28:42,749 - DEBUG - Pod 15d94e3d-718b-4ab0-913c-e2800b0d7764 is not in agent 10.0.0.31 VM list 2024-11-04 03:28:42,749 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:c3f6f94a-9a5c-11ef-b331-fa163e954dcf 2024-11-04 03:28:42,756 - DEBUG - VMI c3f6f94a-9a5c-11ef-b331-fa163e954dcf is removed from agent 10.0.0.31 2024-11-04 03:28:42,756 - INFO - Verified that pod ctest-busybox-pod-70571750 is removed in agent 2024-11-04 03:28:42,756 - INFO - Deleting Ingress : ctest-nginx-ingress-12498318 2024-11-04 03:28:42,763 - DEBUG - Requesting: http://10.0.0.28:8108/Snh_LoadbalancerDatabaseList?x=30f6101a-2482-4183-afb5-d6f26579b2ea 2024-11-04 03:28:42,771 - ERROR - Ingress ctest-nginx-ingress-12498318 with uuid 30f6101a-2482-4183-afb5-d6f26579b2ea still found in kube manager 2024-11-04 03:28:43,771 - DEBUG - Requesting: http://10.0.0.28:8108/Snh_LoadbalancerDatabaseList?x=30f6101a-2482-4183-afb5-d6f26579b2ea 2024-11-04 03:28:43,776 - INFO - Ingress ctest-nginx-ingress-12498318 with uuid 30f6101a-2482-4183-afb5-d6f26579b2ea deleted successfully from kube manager 2024-11-04 03:28:43,776 - INFO - Verifications on Ingress %s cleanup passed 2024-11-04 03:28:43,776 - INFO - Deleting the FIP pool __fip_pool_public__ 2024-11-04 03:28:43,886 - DEBUG - Requesting: http://10.0.0.28:8083/Snh_IFMapTableShowReq?table_name=floating-ip-pool&search_string=floating-ip-pool:default-domain:k8s-default:__public__:__fip_pool_public__ 2024-11-04 03:28:43,892 - DEBUG - Control-node Ifmap-view does not have FIP pool __fip_pool_public__ information 2024-11-04 03:28:43,892 - INFO - Deleting VN __public__ 2024-11-04 03:28:44,049 - DEBUG - Requesting: http://10.0.0.28:8082/routing-instance/f4ac535c-1740-4392-b003-ceac96281fc7 2024-11-04 03:28:44,065 - DEBUG - Response Code: 404 2024-11-04 03:28:44,065 - DEBUG - Requesting: http://10.0.0.28:8082/domains 2024-11-04 03:28:44,076 - DEBUG - Requesting: http://10.0.0.28:8082/domain/fdd0e898-9a24-4a4d-aee8-9991cbaeb8dc 2024-11-04 03:28:44,088 - DEBUG - Requesting: http://10.0.0.28:8082/project/7a2e9f33-d28a-4806-bfcb-cc0cbfd970db 2024-11-04 03:28:44,156 - INFO - Validated that VN __public__ is not found in API Server 2024-11-04 03:28:44,156 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_VnListReq?name=default-domain:k8s-default:__public__ 2024-11-04 03:28:44,167 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_VrfListReq?name=default-domain:k8s-default:__public__:__public__ 2024-11-04 03:28:44,179 - DEBUG - VN __public__ is not present in Agent 10.0.0.31 2024-11-04 03:28:44,180 - INFO - Validated that VN __public__ is not in any agent 2024-11-04 03:28:44,180 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_VrfListReq?name=default-domain:k8s-default:__public__:__public__ 2024-11-04 03:28:44,189 - DEBUG - Requesting: http://10.0.0.28:8083/Snh_ShowRoutingInstanceReq?name=default-domain:k8s-default:__public__:__public__ 2024-11-04 03:28:44,197 - DEBUG - Requesting: http://10.0.0.28:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:k8s-default:__public__ 2024-11-04 03:28:44,219 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN __public__ info 2024-11-04 03:28:44,219 - INFO - Deleting pod default:ctest-nginx-pod-53828641 2024-11-04 03:28:44,251 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_VmListReq?uuid=2034add5-8283-4e28-af73-a31b16d0d998 2024-11-04 03:28:44,258 - WARNING - Pod uuid 2034add5-8283-4e28-af73-a31b16d0d998 is still seen in agent 10.0.0.31 VM list 2024-11-04 03:28:49,259 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_VmListReq?uuid=2034add5-8283-4e28-af73-a31b16d0d998 2024-11-04 03:28:49,274 - DEBUG - Pod 2034add5-8283-4e28-af73-a31b16d0d998 is not in agent 10.0.0.31 VM list 2024-11-04 03:28:49,274 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:c1c29c74-9a5c-11ef-b331-fa163e954dcf 2024-11-04 03:28:49,281 - DEBUG - VMI c1c29c74-9a5c-11ef-b331-fa163e954dcf is removed from agent 10.0.0.31 2024-11-04 03:28:49,282 - INFO - Verified that pod ctest-nginx-pod-53828641 is removed in agent 2024-11-04 03:28:49,282 - INFO - Deleting pod default:ctest-nginx-pod-42295279 2024-11-04 03:28:49,292 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_VmListReq?uuid=15d51a74-6b9f-4961-84f5-c8c813f4a973 2024-11-04 03:28:49,302 - WARNING - Pod uuid 15d51a74-6b9f-4961-84f5-c8c813f4a973 is still seen in agent 10.0.0.31 VM list 2024-11-04 03:28:54,304 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_VmListReq?uuid=15d51a74-6b9f-4961-84f5-c8c813f4a973 2024-11-04 03:28:54,313 - DEBUG - Pod 15d51a74-6b9f-4961-84f5-c8c813f4a973 is not in agent 10.0.0.31 VM list 2024-11-04 03:28:54,313 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:c14a03fe-9a5c-11ef-b331-fa163e954dcf 2024-11-04 03:28:54,321 - DEBUG - VMI c14a03fe-9a5c-11ef-b331-fa163e954dcf is removed from agent 10.0.0.31 2024-11-04 03:28:54,322 - INFO - Verified that pod ctest-nginx-pod-42295279 is removed in agent 2024-11-04 03:28:54,322 - INFO - Deleting service : ctest-nginx-svc-21645842 2024-11-04 03:28:54,567 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_AgentXmppConnectionStatusReq? 2024-11-04 03:28:54,575 - DEBUG - No XMPP flaps were noticed during the test
2024-11-04 03:28:54,575 - INFO - END TEST : test_ingress_ip_assignment : PASSED[0:01:13]
2024-11-04 03:28:54,575 - INFO - -------------------------------------------------------------------------------- 2024-11-04 03:29:00,982 - DEBUG - [10.0.0.28]: Running cmd : docker exec --privileged -it contrail-kubernetes-master_kubemanager_1 /bin/bash -c 'grep "^[ ]*cluster_project" /etc/contrail/contrail-kubernetes.conf' 2024-11-04 03:29:01,119 - DEBUG - Output : cluster_project={} 2024-11-04 03:29:01,172 - DEBUG - [10.0.0.28]: Running cmd : docker exec --privileged -it contrail-kubernetes-master_kubemanager_1 /bin/bash -c 'netstat -antp | grep :8108 | grep LISTEN' 2024-11-04 03:29:01,363 - DEBUG - Output : tcp 0 0 0.0.0.0:8108 0.0.0.0:* LISTEN 1/python3 2024-11-04 03:29:01,368 - DEBUG - [10.0.0.28]: Running cmd : docker exec --privileged -it contrail-kubernetes-master_kubemanager_1 /bin/bash -c 'grep "^[ ]*cluster_project" /etc/contrail/contrail-kubernetes.conf' 2024-11-04 03:29:01,535 - DEBUG - Output : cluster_project={} 2024-11-04 03:29:16,685 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2024-11-04 03:29:16,790 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2024-11-04 03:29:16,850 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2024-11-04 03:29:16,933 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2024-11-04 03:29:21,991 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2024-11-04 03:29:22,086 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2024-11-04 03:29:22,178 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2024-11-04 03:29:22,243 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2024-11-04 03:29:22,513 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_AgentXmppConnectionStatusReq? 2024-11-04 03:29:25,235 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_ApplicationPolicySetReq? 2024-11-04 03:29:25,242 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_AclReq? 2024-11-04 03:29:25,290 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_AclReq? 2024-11-04 03:29:27,344 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_AclReq? 2024-11-04 03:29:29,392 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_AclReq? 2024-11-04 03:32:38,696 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_AgentXmppConnectionStatusReq? 2024-11-04 03:32:38,732 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_VmListReq?uuid=e0db9ae1-0a03-4cf8-8a6b-6e9c7168f428 2024-11-04 03:32:38,765 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_VmListReq?uuid=3f49c63c-832b-46c6-8054-779eaae7e5b4 2024-11-04 03:32:38,769 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_VmListReq?uuid=5a226b82-7523-4f5c-8194-2ee805791967 2024-11-04 03:32:38,774 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_VmListReq?uuid=d3f1c76c-b501-4ac8-b3f2-5ad75ac78d4c 2024-11-04 03:32:38,779 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_VmListReq?uuid=d5459880-3fdc-43f7-8519-a54d0e2f9e7f 2024-11-04 03:32:38,785 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_VmListReq?uuid=0c54170e-6329-4a50-8c46-2314943eacfa 2024-11-04 03:32:38,791 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_VmListReq?uuid=c2758868-14ee-4dfb-8802-fad17c225ee7 2024-11-04 03:32:38,796 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_VmListReq?uuid=90d6953b-8679-464c-835c-d8e68c232def 2024-11-04 03:32:43,750 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_VmListReq?uuid=e0db9ae1-0a03-4cf8-8a6b-6e9c7168f428 2024-11-04 03:32:43,758 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:f021ba46-9a5c-11ef-b331-fa163e954dcf 2024-11-04 03:32:43,858 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_VmListReq?uuid=3f49c63c-832b-46c6-8054-779eaae7e5b4 2024-11-04 03:32:43,861 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_VmListReq?uuid=0c54170e-6329-4a50-8c46-2314943eacfa 2024-11-04 03:32:43,862 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_VmListReq?uuid=c2758868-14ee-4dfb-8802-fad17c225ee7 2024-11-04 03:32:43,863 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_VmListReq?uuid=90d6953b-8679-464c-835c-d8e68c232def 2024-11-04 03:32:43,864 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_VmListReq?uuid=d5459880-3fdc-43f7-8519-a54d0e2f9e7f 2024-11-04 03:32:43,865 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_VmListReq?uuid=d3f1c76c-b501-4ac8-b3f2-5ad75ac78d4c 2024-11-04 03:32:43,867 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_VmListReq?uuid=5a226b82-7523-4f5c-8194-2ee805791967 2024-11-04 03:32:43,893 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:f165d856-9a5c-11ef-b331-fa163e954dcf 2024-11-04 03:32:43,895 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:f0ae4128-9a5c-11ef-b331-fa163e954dcf 2024-11-04 03:32:43,896 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:f1f5ed74-9a5c-11ef-b331-fa163e954dcf 2024-11-04 03:32:48,890 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_VmListReq?uuid=90d6953b-8679-464c-835c-d8e68c232def 2024-11-04 03:32:48,892 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_VmListReq?uuid=c2758868-14ee-4dfb-8802-fad17c225ee7 2024-11-04 03:32:48,894 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_VmListReq?uuid=d3f1c76c-b501-4ac8-b3f2-5ad75ac78d4c 2024-11-04 03:32:48,896 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_VmListReq?uuid=0c54170e-6329-4a50-8c46-2314943eacfa 2024-11-04 03:32:53,916 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_VmListReq?uuid=d3f1c76c-b501-4ac8-b3f2-5ad75ac78d4c 2024-11-04 03:32:53,918 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_VmListReq?uuid=c2758868-14ee-4dfb-8802-fad17c225ee7 2024-11-04 03:32:53,920 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_VmListReq?uuid=0c54170e-6329-4a50-8c46-2314943eacfa 2024-11-04 03:32:53,921 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_VmListReq?uuid=90d6953b-8679-464c-835c-d8e68c232def 2024-11-04 03:32:58,937 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_VmListReq?uuid=d3f1c76c-b501-4ac8-b3f2-5ad75ac78d4c 2024-11-04 03:32:58,939 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_VmListReq?uuid=c2758868-14ee-4dfb-8802-fad17c225ee7 2024-11-04 03:32:58,940 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_VmListReq?uuid=90d6953b-8679-464c-835c-d8e68c232def 2024-11-04 03:32:58,941 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_VmListReq?uuid=0c54170e-6329-4a50-8c46-2314943eacfa 2024-11-04 03:33:03,957 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_VmListReq?uuid=c2758868-14ee-4dfb-8802-fad17c225ee7 2024-11-04 03:33:03,959 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_VmListReq?uuid=d3f1c76c-b501-4ac8-b3f2-5ad75ac78d4c 2024-11-04 03:33:03,961 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_VmListReq?uuid=90d6953b-8679-464c-835c-d8e68c232def 2024-11-04 03:33:03,962 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_VmListReq?uuid=0c54170e-6329-4a50-8c46-2314943eacfa 2024-11-04 03:33:08,977 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_VmListReq?uuid=d3f1c76c-b501-4ac8-b3f2-5ad75ac78d4c 2024-11-04 03:33:08,979 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_VmListReq?uuid=90d6953b-8679-464c-835c-d8e68c232def 2024-11-04 03:33:08,981 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_VmListReq?uuid=0c54170e-6329-4a50-8c46-2314943eacfa 2024-11-04 03:33:08,982 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_VmListReq?uuid=c2758868-14ee-4dfb-8802-fad17c225ee7 2024-11-04 03:33:14,064 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_VmListReq?uuid=90d6953b-8679-464c-835c-d8e68c232def 2024-11-04 03:33:14,065 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_VmListReq?uuid=d3f1c76c-b501-4ac8-b3f2-5ad75ac78d4c 2024-11-04 03:33:14,074 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_VmListReq?uuid=0c54170e-6329-4a50-8c46-2314943eacfa 2024-11-04 03:33:14,076 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_VmListReq?uuid=c2758868-14ee-4dfb-8802-fad17c225ee7 2024-11-04 03:33:14,090 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:f309e5f8-9a5c-11ef-b331-fa163e954dcf 2024-11-04 03:33:14,094 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:f38cffb0-9a5c-11ef-b331-fa163e954dcf 2024-11-04 03:33:14,095 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:f406748a-9a5c-11ef-b331-fa163e954dcf 2024-11-04 03:33:14,098 - DEBUG - Requesting: http://10.0.0.31:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:f28c5ee4-9a5c-11ef-b331-fa163e954dcf