2024-10-25 16:56:54,283 - DEBUG - [10.0.0.22]: Running cmd : hostname
2024-10-25 16:56:54,536 - DEBUG - Output : cn-jenkins-deploy-platform-juju-k8s-739-1
2024-10-25 16:56:54,537 - DEBUG - [10.0.0.22]: Running cmd : hostname -f
2024-10-25 16:56:54,571 - DEBUG - Output : cn-jenkins-deploy-platform-juju-k8s-739-1
2024-10-25 16:56:54,571 - DEBUG - [10.0.0.22]: 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-10-25 16:56:54,657 - DEBUG - Output : NAMES
contrail_test_kHMTOVoCg
contrail-kubernetes-master_kubemanager_1
webui_web_1
webui_job_1
analytics_database_query-engine_1
analytics_database_cassandra_1
analytics_database_nodemgr_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_nodemgr_1
analytics_api_1
analytics_collector_1
redis_redis_1
control_named_1
control_control_1
control_dns_1
control_nodemgr_1
config_database_zookeeper_1
config_database_nodemgr_1
config_database_cassandra_1
config_database_rabbitmq_1
config_api_devicemgr_1
config_api_api_1
config_api_svcmonitor_1
config_api_dnsmasq_1
config_api_schema_1
config_api_nodemgr_1
2024-10-25 16:56:54,658 - DEBUG - [10.0.0.22]: Running cmd : ip addr show | grep 'inet .*/.* brd ' | awk '{print $2}'
2024-10-25 16:56:54,727 - DEBUG - Output : 10.0.0.22/24
172.17.0.1/16
2024-10-25 16:56:54,728 - DEBUG - [10.0.0.22]: Running cmd : getent hosts 10.0.0.22 | head -n 1 | awk '{print $2}'
2024-10-25 16:56:54,771 - DEBUG - Output : cn-jenkins-deploy-platform-juju-k8s-739-1
2024-10-25 16:56:54,874 - DEBUG - [10.0.0.42]: Running cmd : hostname
2024-10-25 16:56:55,100 - DEBUG - Output : an-jenkins-deploy-platform-juju-k8s-739-1
2024-10-25 16:56:55,101 - DEBUG - [10.0.0.42]: Running cmd : hostname -f
2024-10-25 16:56:55,127 - DEBUG - Output : an-jenkins-deploy-platform-juju-k8s-739-1
2024-10-25 16:56:55,128 - DEBUG - [10.0.0.42]: 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-10-25 16:56:55,216 - DEBUG - Output : NAMES
vrouter_nodemgr_1
vrouter_vrouter-agent_1
2024-10-25 16:56:55,216 - DEBUG - [10.0.0.42]: Running cmd : ip addr show dev vhost0 | grep 'inet .*/.* brd ' | awk '{print $2}'
2024-10-25 16:56:55,251 - DEBUG - Output : 10.0.0.42/24
2024-10-25 16:56:55,251 - DEBUG - [10.0.0.42]: Running cmd : getent hosts 10.0.0.42 | head -n 1 | awk '{print $2}'
2024-10-25 16:56:55,287 - DEBUG - Output : an-jenkins-deploy-platform-juju-k8s-739-1
2024-10-25 16:56:55,494 - INFO - Using existing project ['default-domain', 'k8s-default'](f4cc8171-aaab-4c57-ad89-b5047c1bb448)
2024-10-25 16:56:55,693 - INFO - Using existing project ['default-domain', 'k8s-default'](f4cc8171-aaab-4c57-ad89-b5047c1bb448)
2024-10-25 16:56:55,897 - INFO - ================================================================================
2024-10-25 16:56:55,911 - INFO - STARTING TEST : test_ingress_ip_assignment
2024-10-25 16:56:55,912 - 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-10-25 16:56:56,190 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_AgentXmppConnectionStatusReq?
2024-10-25 16:56:56,198 - DEBUG - Nothing to compare xmpp stats {'10.0.0.42': {'10.0.0.22': '0'}} with
2024-10-25 16:56:56,198 - INFO - Initial checks done. Running the testcase now
2024-10-25 16:56:56,198 - INFO -
2024-10-25 16:56:56,203 - INFO - Namespace default already exists
2024-10-25 16:56:56,204 - DEBUG - [10.0.0.22]: Running cmd : docker exec --privileged -it contrail-kubernetes-master_kubemanager_1 /bin/bash -c 'grep "^[ ]*cluster_project" /etc/contrail/contrail-kubernetes.conf'
2024-10-25 16:56:56,321 - DEBUG - Output : cluster_project={}
2024-10-25 16:56:56,387 - INFO - Project default-domain:k8s-default for Namespace default is seen in contrail-api
2024-10-25 16:56:56,388 - DEBUG - Project uuid in Contrail is f4cc8171-aaab-4c57-ad89-b5047c1bb448
2024-10-25 16:56:56,388 - DEBUG - [10.0.0.22]: Running cmd : docker exec --privileged -it contrail-kubernetes-master_kubemanager_1 /bin/bash -c 'netstat -antp | grep :8108 | grep LISTEN'
2024-10-25 16:56:56,516 - DEBUG - Output : tcp 0 0 0.0.0.0:8108 0.0.0.0:* LISTEN 1/python3
2024-10-25 16:56:56,517 - DEBUG - Requesting: http://10.0.0.22:8108/Snh_NamespaceDatabaseList?namespace_uuid=0d8a3a91-c4d9-4713-82eb-c9c88b60a155
2024-10-25 16:56:56,522 - INFO - Namespace default with uuid 0d8a3a91-c4d9-4713-82eb-c9c88b60a155 found in kube manager
2024-10-25 16:56:56,522 - INFO - Namespace default verification passed
2024-10-25 16:56:56,526 - DEBUG - Service ctest-nginx-svc-17142755 not present
2024-10-25 16:56:56,526 - INFO - Creating service ctest-nginx-svc-17142755
2024-10-25 16:56:56,547 - INFO - Created Service ctest-nginx-svc-17142755
2024-10-25 16:56:56,557 - DEBUG - Pod ctest-nginx-pod-73443455 not present
2024-10-25 16:56:56,558 - INFO - Creating Pod ctest-nginx-pod-73443455
2024-10-25 16:56:56,602 - DEBUG - Node for Pod ctest-nginx-pod-73443455 not yet populated
2024-10-25 16:56:59,614 - DEBUG - Pod : ctest-nginx-pod-73443455 UUID is 89dfdd87-bb8b-4139-ae0d-582f378a1fa5
2024-10-25 16:56:59,617 - DEBUG - Pod ctest-nginx-pod-08917864 not present
2024-10-25 16:56:59,617 - INFO - Creating Pod ctest-nginx-pod-08917864
2024-10-25 16:56:59,638 - DEBUG - Pod : ctest-nginx-pod-08917864 UUID is 11ee0ebd-306d-43ac-b14e-f8c7a67f5ec1
2024-10-25 16:56:59,926 - INFO - Created VN __public__, UUID :ca610237-a972-4a67-b829-eb85571b289f
2024-10-25 16:57:00,281 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2024-10-25 16:57:00,292 - DEBUG - Requesting: http://10.0.0.22:8082/domain/a8080c69-97bb-4888-b478-91142083aeda
2024-10-25 16:57:00,320 - DEBUG - Requesting: http://10.0.0.22:8082/project/f4cc8171-aaab-4c57-ad89-b5047c1bb448
2024-10-25 16:57:00,393 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/ca610237-a972-4a67-b829-eb85571b289f
2024-10-25 16:57:00,411 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/ca610237-a972-4a67-b829-eb85571b289f
2024-10-25 16:57:00,428 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/c161c785-f2f4-4a3c-b2b6-1ece613d4bdb
2024-10-25 16:57:00,438 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/c161c785-f2f4-4a3c-b2b6-1ece613d4bdb
2024-10-25 16:57:00,448 - DEBUG - Requesting: http://10.0.0.22:8082/route-target/41a4e44c-76fe-4717-9681-ce6879c14997
2024-10-25 16:57:00,486 - DEBUG - Route Targets: ['target:64512:8000007']
2024-10-25 16:57:00,486 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/ca610237-a972-4a67-b829-eb85571b289f
2024-10-25 16:57:00,503 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/c161c785-f2f4-4a3c-b2b6-1ece613d4bdb
2024-10-25 16:57:00,529 - INFO - Verified VN network id 13 for VN ca610237-a972-4a67-b829-eb85571b289f
2024-10-25 16:57:00,529 - INFO - Verifications in API Server for VN __public__ passed
2024-10-25 16:57:00,529 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/ca610237-a972-4a67-b829-eb85571b289f
2024-10-25 16:57:00,546 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/c161c785-f2f4-4a3c-b2b6-1ece613d4bdb
2024-10-25 16:57:00,563 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/c161c785-f2f4-4a3c-b2b6-1ece613d4bdb
2024-10-25 16:57:00,580 - DEBUG - Requesting: http://10.0.0.22:8082/route-target/41a4e44c-76fe-4717-9681-ce6879c14997
2024-10-25 16:57:00,590 - DEBUG - Requesting: http://10.0.0.22:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:k8s-default:__public__
2024-10-25 16:57:00,597 - DEBUG - Control-node 10.0.0.22 : 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': '14582939506491673191', 'uuid-lslong': '13270396734948452511'}, 'enable': 'true', 'created': '2024-10-25T16:56:59', 'last-modified': '2024-10-25T16:57:00', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.469602'}
2024-10-25 16:57:00,597 - DEBUG - Requesting: http://10.0.0.22:8083/Snh_ShowRoutingInstanceReq?name=default-domain:k8s-default:__public__:__public__
2024-10-25 16:57:00,605 - DEBUG - Route Targets: ['target:64512:8000007']
2024-10-25 16:57:00,605 - INFO - On all control nodes, Config, RI and RT verification for VN __public__ passed
2024-10-25 16:57:00,606 - DEBUG - ====Verifying policy data for __public__ in API_Server ======
2024-10-25 16:57:00,606 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2024-10-25 16:57:00,612 - DEBUG - Requesting: http://10.0.0.22:8082/domain/a8080c69-97bb-4888-b478-91142083aeda
2024-10-25 16:57:00,625 - DEBUG - Requesting: http://10.0.0.22:8082/project/f4cc8171-aaab-4c57-ad89-b5047c1bb448
2024-10-25 16:57:00,731 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/ca610237-a972-4a67-b829-eb85571b289f
2024-10-25 16:57:00,750 - DEBUG - =>VN __public__ has no policy to be verified
2024-10-25 16:57:00,750 - DEBUG - Verifying the vn in opserver
2024-10-25 16:57:00,750 - DEBUG - Verifying the default-domain:k8s-default:__public__ virtual network link through opserver 10.0.0.22
2024-10-25 16:57:00,750 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2024-10-25 16:57:00,756 - DEBUG - vn link and name as {'name': 'default-domain:k8s-default:__public__', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:k8s-default:__public__?flat'}
2024-10-25 16:57:00,756 - INFO - Validated that VN default-domain:k8s-default:__public__ is found in opserver
2024-10-25 16:57:00,756 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_VrfListReq?name=default-domain:k8s-default:__public__:__public__
2024-10-25 16:57:00,764 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_VrfListReq?name=default-domain:k8s-default:__public__:__public__
2024-10-25 16:57:00,771 - DEBUG - Do not have enough data to verify VN in agent
2024-10-25 16:57:00,771 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_VrfListReq?name=default-domain:k8s-default:__public__:__public__
2024-10-25 16:57:00,779 - DEBUG - VRF ids for VN __public__: {}
2024-10-25 16:57:00,865 - INFO - Creating Floating IP pool __fip_pool_public__ in API Server
2024-10-25 16:57:01,003 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2024-10-25 16:57:01,013 - DEBUG - Requesting: http://10.0.0.22:8082/domain/a8080c69-97bb-4888-b478-91142083aeda
2024-10-25 16:57:01,024 - DEBUG - Requesting: http://10.0.0.22:8082/project/f4cc8171-aaab-4c57-ad89-b5047c1bb448
2024-10-25 16:57:01,084 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/ca610237-a972-4a67-b829-eb85571b289f
2024-10-25 16:57:01,101 - DEBUG - Requesting: http://10.0.0.22:8082/floating-ip-pool/35746105-82c1-4209-95fd-c7f3b5d19ae5
2024-10-25 16:57:01,111 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2024-10-25 16:57:01,120 - DEBUG - Requesting: http://10.0.0.22:8082/domain/a8080c69-97bb-4888-b478-91142083aeda
2024-10-25 16:57:01,132 - DEBUG - Requesting: http://10.0.0.22:8082/project/f4cc8171-aaab-4c57-ad89-b5047c1bb448
2024-10-25 16:57:01,189 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/ca610237-a972-4a67-b829-eb85571b289f
2024-10-25 16:57:01,207 - DEBUG - FIP Pool __fip_pool_public__ found in API Server
2024-10-25 16:57:01,207 - INFO - Verification for FIP pool __fip_pool_public__ in API Server passed
2024-10-25 16:57:01,221 - DEBUG - Requesting: http://10.0.0.22:8083/Snh_IFMapTableShowReq?table_name=floating-ip-pool&search_string=floating-ip-pool:default-domain:k8s-default:__public__:__fip_pool_public__
2024-10-25 16:57:01,228 - DEBUG - Control-node Ifmap-view has FIP pool __fip_pool_public__ information
2024-10-25 16:57:01,228 - INFO - Verification for FIP pool __fip_pool_public__ in Control-node passed
2024-10-25 16:57:01,231 - DEBUG - Ingress ctest-nginx-ingress-16824860 not present
2024-10-25 16:57:01,232 - INFO - Creating Ingress ctest-nginx-ingress-16824860
2024-10-25 16:57:01,239 - INFO - Created Ingress ctest-nginx-ingress-16824860
2024-10-25 16:57:01,243 - DEBUG - Cluster IP not yet seen for Ingress ctest-nginx-ingress-16824860
2024-10-25 16:57:04,248 - DEBUG - For Ingress ctest-nginx-ingress-16824860, Cluster IP: 10.47.255.249, External IPs ['195.197.223.60']
2024-10-25 16:57:04,248 - INFO - Verifications in k8s passed for Ingress ctest-nginx-ingress-16824860
2024-10-25 16:57:04,248 - DEBUG - Requesting: http://10.0.0.22:8108/Snh_LoadbalancerDatabaseList?x=a8e44084-f345-4bbb-975a-b6a8849bbc41
2024-10-25 16:57:04,254 - INFO - Ingress ctest-nginx-ingress-16824860 with uuid a8e44084-f345-4bbb-975a-b6a8849bbc41 found in kube manager
2024-10-25 16:57:04,254 - INFO - Ingress ctest-nginx-ingress-16824860 verification passed
2024-10-25 16:57:04,258 - DEBUG - Pod ctest-busybox-pod-81480256 not present
2024-10-25 16:57:04,259 - INFO - Creating Pod ctest-busybox-pod-81480256
2024-10-25 16:57:04,312 - DEBUG - Pod : ctest-busybox-pod-81480256 UUID is 50d44808-9ed7-46d9-891d-18bc1602c4ec
2024-10-25 16:57:04,323 - DEBUG - Pod ctest-nginx-pod-73443455 not in running state.Currently in Pending
2024-10-25 16:57:09,330 - DEBUG - Pod ctest-nginx-pod-73443455 not in running state.Currently in Pending
2024-10-25 16:57:14,340 - INFO - Pod ctest-nginx-pod-73443455 is in running state.Got IP 10.47.255.251
2024-10-25 16:57:14,409 - DEBUG - Pod ctest-nginx-pod-73443455 has vmi 25b8b8de-92f2-11ef-83e4-fa163eb33011
2024-10-25 16:57:14,410 - INFO - Verified pod ctest-nginx-pod-73443455 in contrail-api
2024-10-25 16:57:14,410 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,
2024-10-25 16:57:14,425 - DEBUG - VMI 25b8b8de-92f2-11ef-83e4-fa163eb33011 is active in agent 10.0.0.42
2024-10-25 16:57:14,425 - INFO - Verified Pod ctest-nginx-pod-73443455 in agent 10.0.0.42
2024-10-25 16:57:14,425 - DEBUG - Requesting: http://10.0.0.22:8108/Snh_VirtualMachineDatabaseList?x=89dfdd87-bb8b-4139-ae0d-582f378a1fa5
2024-10-25 16:57:14,431 - INFO - Pod ctest-nginx-pod-73443455 with uuid 89dfdd87-bb8b-4139-ae0d-582f378a1fa5 found in kube manager
2024-10-25 16:57:14,431 - INFO - Pod ctest-nginx-pod-73443455 verification passed
2024-10-25 16:57:14,505 - DEBUG - [Pod ctest-nginx-pod-73443455] Cmd: echo ctest-nginx-pod-73443455 > /usr/share/nginx/html/index.html, Output:
2024-10-25 16:57:14,513 - DEBUG - Pod ctest-nginx-pod-08917864 not in running state.Currently in Pending
2024-10-25 16:57:19,520 - INFO - Pod ctest-nginx-pod-08917864 is in running state.Got IP 10.47.255.250
2024-10-25 16:57:19,547 - DEBUG - Pod ctest-nginx-pod-08917864 has vmi 26959c86-92f2-11ef-83e4-fa163eb33011
2024-10-25 16:57:19,548 - INFO - Verified pod ctest-nginx-pod-08917864 in contrail-api
2024-10-25 16:57:19,548 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,
2024-10-25 16:57:19,559 - DEBUG - VMI 26959c86-92f2-11ef-83e4-fa163eb33011 is active in agent 10.0.0.42
2024-10-25 16:57:19,559 - INFO - Verified Pod ctest-nginx-pod-08917864 in agent 10.0.0.42
2024-10-25 16:57:19,560 - DEBUG - Requesting: http://10.0.0.22:8108/Snh_VirtualMachineDatabaseList?x=11ee0ebd-306d-43ac-b14e-f8c7a67f5ec1
2024-10-25 16:57:19,565 - INFO - Pod ctest-nginx-pod-08917864 with uuid 11ee0ebd-306d-43ac-b14e-f8c7a67f5ec1 found in kube manager
2024-10-25 16:57:19,565 - INFO - Pod ctest-nginx-pod-08917864 verification passed
2024-10-25 16:57:19,624 - DEBUG - [Pod ctest-nginx-pod-08917864] Cmd: echo ctest-nginx-pod-08917864 > /usr/share/nginx/html/index.html, Output:
2024-10-25 16:57:19,631 - INFO - Pod ctest-busybox-pod-81480256 is in running state.Got IP 10.47.255.248
2024-10-25 16:57:19,657 - DEBUG - Pod ctest-busybox-pod-81480256 has vmi 29a041e2-92f2-11ef-83e4-fa163eb33011
2024-10-25 16:57:19,657 - INFO - Verified pod ctest-busybox-pod-81480256 in contrail-api
2024-10-25 16:57:19,657 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,
2024-10-25 16:57:19,669 - DEBUG - VMI 29a041e2-92f2-11ef-83e4-fa163eb33011 is active in agent 10.0.0.42
2024-10-25 16:57:19,669 - INFO - Verified Pod ctest-busybox-pod-81480256 in agent 10.0.0.42
2024-10-25 16:57:19,669 - DEBUG - Requesting: http://10.0.0.22:8108/Snh_VirtualMachineDatabaseList?x=50d44808-9ed7-46d9-891d-18bc1602c4ec
2024-10-25 16:57:19,675 - INFO - Pod ctest-busybox-pod-81480256 with uuid 50d44808-9ed7-46d9-891d-18bc1602c4ec found in kube manager
2024-10-25 16:57:19,675 - INFO - Pod ctest-busybox-pod-81480256 verification passed
2024-10-25 16:57:19,739 - DEBUG - [Pod ctest-busybox-pod-81480256] Cmd: wget http://10.47.255.249:80/ -O - -T 5 -t 1 , Output: ctest-nginx-pod-08917864
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-10-25 16:57:19,739 - DEBUG - [Pod Pod ctest-busybox-pod-81480256] Cmd wget http://10.47.255.249:80/ -O - -T 5 -t 1 passed
2024-10-25 16:57:19,739 - DEBUG - [Pod Pod ctest-busybox-pod-81480256] Cmd output: ctest-nginx-pod-08917864
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-10-25 16:57:19,800 - DEBUG - [Pod ctest-busybox-pod-81480256] 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-73443455
2024-10-25 16:57:19,800 - DEBUG - [Pod Pod ctest-busybox-pod-81480256] Cmd wget http://10.47.255.249:80/ -O - -T 5 -t 1 passed
2024-10-25 16:57:19,800 - DEBUG - [Pod Pod ctest-busybox-pod-81480256] 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-73443455
2024-10-25 16:57:19,800 - INFO - Responses seen from all pods, lb seems fine.Hits : {'ctest-nginx-pod-73443455': 1, 'ctest-nginx-pod-08917864': 1}
2024-10-25 16:57:19,801 - WARNING - Nothing to delete parallely
2024-10-25 16:57:19,801 - INFO - Deleting pod default:ctest-busybox-pod-81480256
2024-10-25 16:57:19,822 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_VmListReq?uuid=50d44808-9ed7-46d9-891d-18bc1602c4ec
2024-10-25 16:57:19,830 - WARNING - Pod uuid 50d44808-9ed7-46d9-891d-18bc1602c4ec is still seen in agent 10.0.0.42 VM list
2024-10-25 16:57:24,831 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_VmListReq?uuid=50d44808-9ed7-46d9-891d-18bc1602c4ec
2024-10-25 16:57:24,839 - WARNING - Pod uuid 50d44808-9ed7-46d9-891d-18bc1602c4ec is still seen in agent 10.0.0.42 VM list
2024-10-25 16:57:29,841 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_VmListReq?uuid=50d44808-9ed7-46d9-891d-18bc1602c4ec
2024-10-25 16:57:29,848 - WARNING - Pod uuid 50d44808-9ed7-46d9-891d-18bc1602c4ec is still seen in agent 10.0.0.42 VM list
2024-10-25 16:57:34,849 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_VmListReq?uuid=50d44808-9ed7-46d9-891d-18bc1602c4ec
2024-10-25 16:57:34,856 - WARNING - Pod uuid 50d44808-9ed7-46d9-891d-18bc1602c4ec is still seen in agent 10.0.0.42 VM list
2024-10-25 16:57:39,857 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_VmListReq?uuid=50d44808-9ed7-46d9-891d-18bc1602c4ec
2024-10-25 16:57:39,865 - WARNING - Pod uuid 50d44808-9ed7-46d9-891d-18bc1602c4ec is still seen in agent 10.0.0.42 VM list
2024-10-25 16:57:44,866 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_VmListReq?uuid=50d44808-9ed7-46d9-891d-18bc1602c4ec
2024-10-25 16:57:44,873 - WARNING - Pod uuid 50d44808-9ed7-46d9-891d-18bc1602c4ec is still seen in agent 10.0.0.42 VM list
2024-10-25 16:57:49,877 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_VmListReq?uuid=50d44808-9ed7-46d9-891d-18bc1602c4ec
2024-10-25 16:57:49,885 - WARNING - Pod uuid 50d44808-9ed7-46d9-891d-18bc1602c4ec is still seen in agent 10.0.0.42 VM list
2024-10-25 16:57:54,886 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_VmListReq?uuid=50d44808-9ed7-46d9-891d-18bc1602c4ec
2024-10-25 16:57:54,894 - DEBUG - Pod 50d44808-9ed7-46d9-891d-18bc1602c4ec is not in agent 10.0.0.42 VM list
2024-10-25 16:57:54,894 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:29a041e2-92f2-11ef-83e4-fa163eb33011
2024-10-25 16:57:54,901 - DEBUG - VMI 29a041e2-92f2-11ef-83e4-fa163eb33011 is removed from agent 10.0.0.42
2024-10-25 16:57:54,901 - INFO - Verified that pod ctest-busybox-pod-81480256 is removed in agent
2024-10-25 16:57:54,901 - INFO - Deleting Ingress : ctest-nginx-ingress-16824860
2024-10-25 16:57:54,910 - DEBUG - Requesting: http://10.0.0.22:8108/Snh_LoadbalancerDatabaseList?x=a8e44084-f345-4bbb-975a-b6a8849bbc41
2024-10-25 16:57:54,916 - ERROR - Ingress ctest-nginx-ingress-16824860 with uuid a8e44084-f345-4bbb-975a-b6a8849bbc41 still found in kube manager
2024-10-25 16:57:55,917 - DEBUG - Requesting: http://10.0.0.22:8108/Snh_LoadbalancerDatabaseList?x=a8e44084-f345-4bbb-975a-b6a8849bbc41
2024-10-25 16:57:55,937 - ERROR - Ingress ctest-nginx-ingress-16824860 with uuid a8e44084-f345-4bbb-975a-b6a8849bbc41 still found in kube manager
2024-10-25 16:57:56,937 - DEBUG - Requesting: http://10.0.0.22:8108/Snh_LoadbalancerDatabaseList?x=a8e44084-f345-4bbb-975a-b6a8849bbc41
2024-10-25 16:57:56,943 - INFO - Ingress ctest-nginx-ingress-16824860 with uuid a8e44084-f345-4bbb-975a-b6a8849bbc41 deleted successfully from kube manager
2024-10-25 16:57:56,943 - INFO - Verifications on Ingress %s cleanup passed
2024-10-25 16:57:56,943 - INFO - Deleting the FIP pool __fip_pool_public__
2024-10-25 16:57:57,110 - DEBUG - Requesting: http://10.0.0.22:8083/Snh_IFMapTableShowReq?table_name=floating-ip-pool&search_string=floating-ip-pool:default-domain:k8s-default:__public__:__fip_pool_public__
2024-10-25 16:57:57,118 - DEBUG - Control-node Ifmap-view does not have FIP pool __fip_pool_public__ information
2024-10-25 16:57:57,118 - INFO - Deleting VN __public__
2024-10-25 16:57:57,277 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/c161c785-f2f4-4a3c-b2b6-1ece613d4bdb
2024-10-25 16:57:57,283 - DEBUG - Response Code: 404
2024-10-25 16:57:57,283 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2024-10-25 16:57:57,292 - DEBUG - Requesting: http://10.0.0.22:8082/domain/a8080c69-97bb-4888-b478-91142083aeda
2024-10-25 16:57:57,330 - DEBUG - Requesting: http://10.0.0.22:8082/project/f4cc8171-aaab-4c57-ad89-b5047c1bb448
2024-10-25 16:57:57,448 - INFO - Validated that VN __public__ is not found in API Server
2024-10-25 16:57:57,456 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_VnListReq?name=default-domain:k8s-default:__public__
2024-10-25 16:57:57,480 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_VrfListReq?name=default-domain:k8s-default:__public__:__public__
2024-10-25 16:57:57,492 - DEBUG - VN __public__ is not present in Agent 10.0.0.42
2024-10-25 16:57:57,492 - INFO - Validated that VN __public__ is not in any agent
2024-10-25 16:57:57,492 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_VrfListReq?name=default-domain:k8s-default:__public__:__public__
2024-10-25 16:57:57,506 - DEBUG - Requesting: http://10.0.0.22:8083/Snh_ShowRoutingInstanceReq?name=default-domain:k8s-default:__public__:__public__
2024-10-25 16:57:57,513 - DEBUG - Requesting: http://10.0.0.22:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:k8s-default:__public__
2024-10-25 16:57:57,521 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN __public__ info
2024-10-25 16:57:57,522 - INFO - Deleting pod default:ctest-nginx-pod-08917864
2024-10-25 16:57:57,534 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_VmListReq?uuid=11ee0ebd-306d-43ac-b14e-f8c7a67f5ec1
2024-10-25 16:57:57,561 - WARNING - Pod uuid 11ee0ebd-306d-43ac-b14e-f8c7a67f5ec1 is still seen in agent 10.0.0.42 VM list
2024-10-25 16:58:02,565 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_VmListReq?uuid=11ee0ebd-306d-43ac-b14e-f8c7a67f5ec1
2024-10-25 16:58:02,572 - DEBUG - Pod 11ee0ebd-306d-43ac-b14e-f8c7a67f5ec1 is not in agent 10.0.0.42 VM list
2024-10-25 16:58:02,573 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:26959c86-92f2-11ef-83e4-fa163eb33011
2024-10-25 16:58:02,580 - DEBUG - VMI 26959c86-92f2-11ef-83e4-fa163eb33011 is removed from agent 10.0.0.42
2024-10-25 16:58:02,580 - INFO - Verified that pod ctest-nginx-pod-08917864 is removed in agent
2024-10-25 16:58:02,580 - INFO - Deleting pod default:ctest-nginx-pod-73443455
2024-10-25 16:58:02,597 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_VmListReq?uuid=89dfdd87-bb8b-4139-ae0d-582f378a1fa5
2024-10-25 16:58:02,609 - WARNING - Pod uuid 89dfdd87-bb8b-4139-ae0d-582f378a1fa5 is still seen in agent 10.0.0.42 VM list
2024-10-25 16:58:07,611 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_VmListReq?uuid=89dfdd87-bb8b-4139-ae0d-582f378a1fa5
2024-10-25 16:58:07,618 - DEBUG - Pod 89dfdd87-bb8b-4139-ae0d-582f378a1fa5 is not in agent 10.0.0.42 VM list
2024-10-25 16:58:07,619 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:25b8b8de-92f2-11ef-83e4-fa163eb33011
2024-10-25 16:58:07,626 - DEBUG - VMI 25b8b8de-92f2-11ef-83e4-fa163eb33011 is removed from agent 10.0.0.42
2024-10-25 16:58:07,626 - INFO - Verified that pod ctest-nginx-pod-73443455 is removed in agent
2024-10-25 16:58:07,626 - INFO - Deleting service : ctest-nginx-svc-17142755
2024-10-25 16:58:07,874 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_AgentXmppConnectionStatusReq?
2024-10-25 16:58:07,882 - DEBUG - No XMPP flaps were noticed during the test
2024-10-25 16:58:07,882 - INFO - END TEST : test_ingress_ip_assignment : PASSED[0:01:12]
2024-10-25 16:58:07,882 - INFO - --------------------------------------------------------------------------------
2024-10-25 16:58:14,387 - DEBUG - [10.0.0.22]: Running cmd : docker exec --privileged -it contrail-kubernetes-master_kubemanager_1 /bin/bash -c 'grep "^[ ]*cluster_project" /etc/contrail/contrail-kubernetes.conf'
2024-10-25 16:58:14,542 - DEBUG - Output : cluster_project={}
2024-10-25 16:58:14,597 - DEBUG - [10.0.0.22]: Running cmd : docker exec --privileged -it contrail-kubernetes-master_kubemanager_1 /bin/bash -c 'netstat -antp | grep :8108 | grep LISTEN'
2024-10-25 16:58:14,792 - DEBUG - Output : tcp 0 0 0.0.0.0:8108 0.0.0.0:* LISTEN 1/python3
2024-10-25 16:58:14,798 - DEBUG - [10.0.0.22]: Running cmd : docker exec --privileged -it contrail-kubernetes-master_kubemanager_1 /bin/bash -c 'grep "^[ ]*cluster_project" /etc/contrail/contrail-kubernetes.conf'
2024-10-25 16:58:14,907 - DEBUG - Output : cluster_project={}
2024-10-25 16:58:25,090 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,
2024-10-25 16:58:30,176 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,
2024-10-25 16:58:30,273 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,
2024-10-25 16:58:30,326 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,
2024-10-25 16:58:30,414 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,
2024-10-25 16:58:30,506 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,
2024-10-25 16:58:30,555 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,
2024-10-25 16:58:35,657 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,
2024-10-25 16:58:35,928 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_AgentXmppConnectionStatusReq?
2024-10-25 16:58:38,598 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_ApplicationPolicySetReq?
2024-10-25 16:58:38,606 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_AclReq?
2024-10-25 16:58:38,640 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_AclReq?
2024-10-25 16:58:40,677 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_AclReq?
2024-10-25 17:01:48,438 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_AgentXmppConnectionStatusReq?
2024-10-25 17:01:48,489 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_VmListReq?uuid=270fcd4e-4c62-4d65-89b9-3ee0a67fca8a
2024-10-25 17:01:48,514 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_VmListReq?uuid=ee2ece6a-b4bc-4d4d-a9d5-d0d1719e2eb8
2024-10-25 17:01:48,526 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_VmListReq?uuid=54a33163-c5fc-4d24-90be-eeace64f6208
2024-10-25 17:01:48,538 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_VmListReq?uuid=85a8281c-9462-4888-8189-31a8b4416023
2024-10-25 17:01:48,551 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_VmListReq?uuid=972eee5d-c456-4625-b795-f1221513b948
2024-10-25 17:01:48,555 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_VmListReq?uuid=34da2e5c-9bae-4ee6-b8c7-3fe7278d4519
2024-10-25 17:01:48,560 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_VmListReq?uuid=7df05a5c-733b-4283-b174-1aea71a9782e
2024-10-25 17:01:48,564 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_VmListReq?uuid=95d1f00f-6ad8-410e-b67d-df466603f63e
2024-10-25 17:01:53,606 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_VmListReq?uuid=95d1f00f-6ad8-410e-b67d-df466603f63e
2024-10-25 17:01:53,608 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_VmListReq?uuid=7df05a5c-733b-4283-b174-1aea71a9782e
2024-10-25 17:01:53,610 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_VmListReq?uuid=972eee5d-c456-4625-b795-f1221513b948
2024-10-25 17:01:53,611 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_VmListReq?uuid=270fcd4e-4c62-4d65-89b9-3ee0a67fca8a
2024-10-25 17:01:53,613 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_VmListReq?uuid=34da2e5c-9bae-4ee6-b8c7-3fe7278d4519
2024-10-25 17:01:53,615 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_VmListReq?uuid=ee2ece6a-b4bc-4d4d-a9d5-d0d1719e2eb8
2024-10-25 17:01:53,616 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_VmListReq?uuid=85a8281c-9462-4888-8189-31a8b4416023
2024-10-25 17:01:53,617 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_VmListReq?uuid=54a33163-c5fc-4d24-90be-eeace64f6208
2024-10-25 17:01:53,638 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:55887b12-92f2-11ef-83e4-fa163eb33011
2024-10-25 17:01:53,639 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:54bdbfda-92f2-11ef-83e4-fa163eb33011
2024-10-25 17:01:53,641 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:56280fb0-92f2-11ef-83e4-fa163eb33011
2024-10-25 17:01:53,642 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:54255e52-92f2-11ef-83e4-fa163eb33011
2024-10-25 17:01:58,641 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_VmListReq?uuid=972eee5d-c456-4625-b795-f1221513b948
2024-10-25 17:01:58,647 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_VmListReq?uuid=85a8281c-9462-4888-8189-31a8b4416023
2024-10-25 17:01:58,651 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_VmListReq?uuid=ee2ece6a-b4bc-4d4d-a9d5-d0d1719e2eb8
2024-10-25 17:01:58,652 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_VmListReq?uuid=7df05a5c-733b-4283-b174-1aea71a9782e
2024-10-25 17:02:03,651 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_VmListReq?uuid=972eee5d-c456-4625-b795-f1221513b948
2024-10-25 17:02:03,666 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_VmListReq?uuid=85a8281c-9462-4888-8189-31a8b4416023
2024-10-25 17:02:03,668 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_VmListReq?uuid=7df05a5c-733b-4283-b174-1aea71a9782e
2024-10-25 17:02:03,669 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_VmListReq?uuid=ee2ece6a-b4bc-4d4d-a9d5-d0d1719e2eb8
2024-10-25 17:02:08,661 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_VmListReq?uuid=972eee5d-c456-4625-b795-f1221513b948
2024-10-25 17:02:08,681 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_VmListReq?uuid=7df05a5c-733b-4283-b174-1aea71a9782e
2024-10-25 17:02:08,684 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_VmListReq?uuid=85a8281c-9462-4888-8189-31a8b4416023
2024-10-25 17:02:08,686 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_VmListReq?uuid=ee2ece6a-b4bc-4d4d-a9d5-d0d1719e2eb8
2024-10-25 17:02:13,670 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_VmListReq?uuid=972eee5d-c456-4625-b795-f1221513b948
2024-10-25 17:02:13,704 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_VmListReq?uuid=7df05a5c-733b-4283-b174-1aea71a9782e
2024-10-25 17:02:13,707 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_VmListReq?uuid=85a8281c-9462-4888-8189-31a8b4416023
2024-10-25 17:02:13,708 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_VmListReq?uuid=ee2ece6a-b4bc-4d4d-a9d5-d0d1719e2eb8
2024-10-25 17:02:18,679 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_VmListReq?uuid=972eee5d-c456-4625-b795-f1221513b948
2024-10-25 17:02:18,721 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_VmListReq?uuid=85a8281c-9462-4888-8189-31a8b4416023
2024-10-25 17:02:18,724 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_VmListReq?uuid=ee2ece6a-b4bc-4d4d-a9d5-d0d1719e2eb8
2024-10-25 17:02:18,725 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_VmListReq?uuid=7df05a5c-733b-4283-b174-1aea71a9782e
2024-10-25 17:02:23,691 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_VmListReq?uuid=972eee5d-c456-4625-b795-f1221513b948
2024-10-25 17:02:23,701 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:5756fac2-92f2-11ef-83e4-fa163eb33011
2024-10-25 17:02:23,804 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_VmListReq?uuid=85a8281c-9462-4888-8189-31a8b4416023
2024-10-25 17:02:23,806 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_VmListReq?uuid=7df05a5c-733b-4283-b174-1aea71a9782e
2024-10-25 17:02:23,807 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_VmListReq?uuid=ee2ece6a-b4bc-4d4d-a9d5-d0d1719e2eb8
2024-10-25 17:02:23,820 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:588d585a-92f2-11ef-83e4-fa163eb33011
2024-10-25 17:02:23,823 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:56c8ee30-92f2-11ef-83e4-fa163eb33011
2024-10-25 17:02:23,827 - DEBUG - Requesting: http://10.0.0.42:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:57ed77e0-92f2-11ef-83e4-fa163eb33011