2025-10-16 01:45:12,828 - DEBUG - [10.0.0.49]: Running cmd : hostname 2025-10-16 01:45:13,107 - DEBUG - Output : cn-jenkins-deploy-platform-k8s-manifests-262-1 2025-10-16 01:45:13,107 - DEBUG - [10.0.0.49]: Running cmd : hostname -f 2025-10-16 01:45:13,214 - DEBUG - Output : cn-jenkins-deploy-platform-k8s-manifests-262-1.cluster.local 2025-10-16 01:45:13,214 - DEBUG - [10.0.0.49]: Running cmd : docker ps 2>/dev/null | grep -v "/pause\|/usr/bin/pod\|nova_api_\|contrail.*init\|init.*contrail\|provisioner\|placement" | awk '{print $NF}' 2025-10-16 01:45:13,379 - DEBUG - Output : NAMES contrail_test_2Kjdtx6LS k8s_autoscaler_dns-autoscaler-595558c478-svtl9_kube-system_012d354d-2b35-459c-85d0-7409aad0ca41_0 k8s_coredns_coredns-77f7cc69db-9q5c2_kube-system_4b5147c0-5279-4a25-8679-4e184918972e_0 k8s_opensdn-controller-config-nodemgr_opensdn-controller-config-4nxrr_kube-system_9ea21d44-5b24-42b0-9f27-ce8d0ec39c0d_0 k8s_opensdn-controller-config-svcmonitor_opensdn-controller-config-4nxrr_kube-system_9ea21d44-5b24-42b0-9f27-ce8d0ec39c0d_0 k8s_opensdn-controller-nodemgr_opensdn-controller-control-tqp86_kube-system_6d6917c0-3194-4f68-ac2b-bd8368de00df_0 k8s_opensdn-controller-control-named_opensdn-controller-control-tqp86_kube-system_6d6917c0-3194-4f68-ac2b-bd8368de00df_0 k8s_opensdn-controller-config-schema_opensdn-controller-config-4nxrr_kube-system_9ea21d44-5b24-42b0-9f27-ce8d0ec39c0d_0 k8s_opensdn-analytics-query-engine_opensdn-analyticsdb-kwzj8_kube-system_312556c1-8b01-43f7-91c7-89710cf017cd_0 k8s_opensdn-controller-control-dns_opensdn-controller-control-tqp86_kube-system_6d6917c0-3194-4f68-ac2b-bd8368de00df_0 k8s_opensdn-analytics-nodemgr_opensdn-analytics-pn5mw_kube-system_2ec7e92e-f970-46b5-a716-eb605fe045fb_0 k8s_opensdn-analytics-collector_opensdn-analytics-pn5mw_kube-system_2ec7e92e-f970-46b5-a716-eb605fe045fb_0 k8s_opensdn-analytics-alarm-nodemgr_opensdn-analytics-alarm-jrrcz_kube-system_17bfdf1e-0e15-44e7-94b0-120bc91839c5_0 k8s_opensdn-analytics-alarm-gen_opensdn-analytics-alarm-jrrcz_kube-system_17bfdf1e-0e15-44e7-94b0-120bc91839c5_0 k8s_opensdn-controller-config-devicemgr_opensdn-controller-config-4nxrr_kube-system_9ea21d44-5b24-42b0-9f27-ce8d0ec39c0d_0 k8s_opensdn-analytics-snmp-nodemgr_opensdn-analytics-snmp-tz5kl_kube-system_2d659c8b-e697-4b3a-b5d6-d62a45c087c2_0 k8s_opensdn-analytics-snmp-topology_opensdn-analytics-snmp-tz5kl_kube-system_2d659c8b-e697-4b3a-b5d6-d62a45c087c2_0 k8s_opensdn-controller-webui-web_opensdn-controller-webui-tkz55_kube-system_225a3aa4-397d-4d63-b924-727a8e8508c9_0 k8s_opensdn-analyticsdb_opensdn-analyticsdb-kwzj8_kube-system_312556c1-8b01-43f7-91c7-89710cf017cd_0 k8s_opensdn-controller-control_opensdn-controller-control-tqp86_kube-system_6d6917c0-3194-4f68-ac2b-bd8368de00df_0 k8s_opensdn-analytics-api_opensdn-analytics-pn5mw_kube-system_2ec7e92e-f970-46b5-a716-eb605fe045fb_0 k8s_kafka_opensdn-analytics-alarm-jrrcz_kube-system_17bfdf1e-0e15-44e7-94b0-120bc91839c5_0 k8s_opensdn-controller-config-api_opensdn-controller-config-4nxrr_kube-system_9ea21d44-5b24-42b0-9f27-ce8d0ec39c0d_0 k8s_opensdn-analytics-snmp-collector_opensdn-analytics-snmp-tz5kl_kube-system_2d659c8b-e697-4b3a-b5d6-d62a45c087c2_0 k8s_opensdn-controller-webui-job_opensdn-controller-webui-tkz55_kube-system_225a3aa4-397d-4d63-b924-727a8e8508c9_0 k8s_config-zookeeper_config-zookeeper-cjpdr_kube-system_5f044e49-5367-4ee3-af01-e6d1a30e0f66_0 k8s_opensdn-config-database-nodemgr_opensdn-configdb-z4n4c_kube-system_ce1738dd-bd83-4643-a46c-aa4bc93c760f_0 k8s_opensdn-configdb_opensdn-configdb-z4n4c_kube-system_ce1738dd-bd83-4643-a46c-aa4bc93c760f_0 k8s_rabbitmq_rabbitmq-ph6qg_kube-system_160819f4-688c-4488-918f-72be6fac1e4c_0 k8s_redis_redis-nwt7r_kube-system_005b248d-a8d2-4fb9-a3aa-fd4210338d49_0 k8s_opensdn-analyticsdb-nodemgr_opensdn-analyticsdb-kwzj8_kube-system_312556c1-8b01-43f7-91c7-89710cf017cd_0 k8s_opensdn-agent-nodemgr_opensdn-agent-s6crh_kube-system_a47bdbfc-c15c-4208-8fc1-e3df3bb38aea_0 k8s_opensdn-vrouter-agent_opensdn-agent-s6crh_kube-system_a47bdbfc-c15c-4208-8fc1-e3df3bb38aea_0 k8s_opensdn-kube-manager_opensdn-kube-manager-w7ws7_kube-system_a881c2fb-face-41a1-9d39-c35651c884ff_0 k8s_kube-proxy_kube-proxy-mr65k_kube-system_ede8c5d2-9b8a-4e97-a7f6-34665a5e3fa0_0 k8s_kube-controller-manager_kube-controller-manager-cn-jenkins-deploy-platform-k8s-manifests-262-1_kube-system_d7547d5be191daf44e22b948f4046f7e_1 k8s_kube-scheduler_kube-scheduler-cn-jenkins-deploy-platform-k8s-manifests-262-1_kube-system_db247af62bcc5fde122fb792ef461c63_1 k8s_kube-apiserver_kube-apiserver-cn-jenkins-deploy-platform-k8s-manifests-262-1_kube-system_34403a377eb0c32fcfd687322ea34d2a_0 2025-10-16 01:45:13,379 - DEBUG - [10.0.0.49]: Running cmd : ip -4 -o addr show | awk '{print $4}' 2025-10-16 01:45:13,497 - DEBUG - Output : 127.0.0.1/8 172.17.0.1/16 10.96.0.1/32 10.96.0.3/32 10.0.0.49/24 2025-10-16 01:45:13,497 - DEBUG - [10.0.0.49]: Running cmd : getent hosts 10.0.0.49 | head -n 1 | awk '{print $2}' 2025-10-16 01:45:13,630 - DEBUG - Output : cn-jenkins-deploy-platform-k8s-manifests-262-1.cluster.local 2025-10-16 01:45:13,630 - DEBUG - [10.0.0.49]: Running cmd : ip -4 -o addr show dev vhost0 | awk '{print $4}' 2025-10-16 01:45:13,749 - DEBUG - Output : 10.0.0.49/24 2025-10-16 01:45:14,106 - INFO - Using existing project ['default-domain', 'k8s-default'](eec715eb-ac09-48ed-8c3e-76878d386914) 2025-10-16 01:45:14,248 - INFO - Using existing project ['default-domain', 'k8s-default'](eec715eb-ac09-48ed-8c3e-76878d386914) 2025-10-16 01:45:14,368 - INFO - ================================================================================ 2025-10-16 01:45:14,369 - INFO - STARTING TEST : test_ingress_ip_assignment 2025-10-16 01:45:14,369 - 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-10-16 01:45:14,632 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_AgentXmppConnectionStatusReq? 2025-10-16 01:45:14,639 - DEBUG - Nothing to compare xmpp stats {'10.0.0.49': {'10.0.0.49': '2'}} with 2025-10-16 01:45:14,639 - INFO - Initial checks done. Running the testcase now 2025-10-16 01:45:14,639 - INFO - 2025-10-16 01:45:14,645 - INFO - Namespace default already exists 2025-10-16 01:45:14,646 - DEBUG - [10.0.0.49]: Running cmd : docker exec --privileged -it k8s_opensdn-kube-manager_opensdn-kube-manager-w7ws7_kube-system_a881c2fb-face-41a1-9d39-c35651c884ff_0 /bin/bash -c 'grep "^[ ]*cluster_project" /etc/contrail/contrail-kubernetes.conf' 2025-10-16 01:45:14,840 - DEBUG - Output : cluster_project={} 2025-10-16 01:45:14,907 - INFO - Project default-domain:k8s-default for Namespace default is seen in contrail-api 2025-10-16 01:45:14,907 - DEBUG - Project uuid in Contrail is eec715eb-ac09-48ed-8c3e-76878d386914 2025-10-16 01:45:14,907 - DEBUG - [10.0.0.49]: Running cmd : docker exec --privileged -it k8s_opensdn-kube-manager_opensdn-kube-manager-w7ws7_kube-system_a881c2fb-face-41a1-9d39-c35651c884ff_0 /bin/bash -c 'netstat -antp | grep :8108 | grep LISTEN' 2025-10-16 01:45:15,057 - DEBUG - Output : tcp 0 0 0.0.0.0:8108 0.0.0.0:* LISTEN 1/python3 2025-10-16 01:45:15,058 - DEBUG - Requesting: http://10.0.0.49:8108/Snh_NamespaceDatabaseList?namespace_uuid=7e5aa776-a736-44e5-a42d-fc65cb5f9fb5 2025-10-16 01:45:15,061 - INFO - Namespace default with uuid 7e5aa776-a736-44e5-a42d-fc65cb5f9fb5 found in kube manager 2025-10-16 01:45:15,062 - INFO - Namespace default verification passed 2025-10-16 01:45:15,065 - DEBUG - Service ctest-nginx-svc-88014147 not present 2025-10-16 01:45:15,065 - INFO - Creating service ctest-nginx-svc-88014147 2025-10-16 01:45:15,076 - INFO - Created Service ctest-nginx-svc-88014147 2025-10-16 01:45:15,079 - DEBUG - Pod ctest-nginx-pod-47086367 not present 2025-10-16 01:45:15,080 - INFO - Creating Pod ctest-nginx-pod-47086367 2025-10-16 01:45:15,107 - DEBUG - Pod : ctest-nginx-pod-47086367 UUID is 9cf36003-ab4d-41d6-91f2-d3e0fa950920 2025-10-16 01:45:15,114 - DEBUG - Pod ctest-nginx-pod-40982897 not present 2025-10-16 01:45:15,114 - INFO - Creating Pod ctest-nginx-pod-40982897 2025-10-16 01:45:15,136 - DEBUG - Pod : ctest-nginx-pod-40982897 UUID is 04edb11c-fa32-4633-9100-eb40dd0a7122 2025-10-16 01:45:15,390 - INFO - Created VN __public__, UUID :d330de5a-6437-425f-9d47-7f17a8936c2a 2025-10-16 01:45:15,624 - DEBUG - Requesting: http://10.0.0.49:8082/domains 2025-10-16 01:45:15,630 - DEBUG - Requesting: http://10.0.0.49:8082/domain/ad7256a5-37b5-4635-8f41-9f0ab26945fb 2025-10-16 01:45:15,642 - DEBUG - Requesting: http://10.0.0.49:8082/project/eec715eb-ac09-48ed-8c3e-76878d386914 2025-10-16 01:45:15,688 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-network/d330de5a-6437-425f-9d47-7f17a8936c2a 2025-10-16 01:45:15,698 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-network/d330de5a-6437-425f-9d47-7f17a8936c2a 2025-10-16 01:45:15,706 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/0df3fd05-2a52-4ddf-84bf-4339a2711d04 2025-10-16 01:45:15,713 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/0df3fd05-2a52-4ddf-84bf-4339a2711d04 2025-10-16 01:45:15,756 - DEBUG - Route Targets: [] 2025-10-16 01:45:15,756 - DEBUG - RT names not yet present for VN __public__ 2025-10-16 01:45:20,757 - DEBUG - Requesting: http://10.0.0.49:8082/domains 2025-10-16 01:45:20,764 - DEBUG - Requesting: http://10.0.0.49:8082/domain/ad7256a5-37b5-4635-8f41-9f0ab26945fb 2025-10-16 01:45:20,772 - DEBUG - Requesting: http://10.0.0.49:8082/project/eec715eb-ac09-48ed-8c3e-76878d386914 2025-10-16 01:45:20,800 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-network/d330de5a-6437-425f-9d47-7f17a8936c2a 2025-10-16 01:45:20,810 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-network/d330de5a-6437-425f-9d47-7f17a8936c2a 2025-10-16 01:45:20,817 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/0df3fd05-2a52-4ddf-84bf-4339a2711d04 2025-10-16 01:45:20,823 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/0df3fd05-2a52-4ddf-84bf-4339a2711d04 2025-10-16 01:45:20,828 - DEBUG - Requesting: http://10.0.0.49:8082/route-target/47c3a590-b86d-4280-ac6f-0dde865decba 2025-10-16 01:45:20,833 - DEBUG - Route Targets: ['target:64512:8000006'] 2025-10-16 01:45:20,833 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-network/d330de5a-6437-425f-9d47-7f17a8936c2a 2025-10-16 01:45:20,840 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/0df3fd05-2a52-4ddf-84bf-4339a2711d04 2025-10-16 01:45:20,849 - INFO - Verified VN network id 11 for VN d330de5a-6437-425f-9d47-7f17a8936c2a 2025-10-16 01:45:20,850 - INFO - Verifications in API Server for VN __public__ passed 2025-10-16 01:45:20,850 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-network/d330de5a-6437-425f-9d47-7f17a8936c2a 2025-10-16 01:45:20,857 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/0df3fd05-2a52-4ddf-84bf-4339a2711d04 2025-10-16 01:45:20,862 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/0df3fd05-2a52-4ddf-84bf-4339a2711d04 2025-10-16 01:45:20,866 - DEBUG - Requesting: http://10.0.0.49:8082/route-target/47c3a590-b86d-4280-ac6f-0dde865decba 2025-10-16 01:45:20,870 - DEBUG - Requesting: http://10.0.0.49:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:k8s-default:__public__ 2025-10-16 01:45:20,875 - DEBUG - Control-node 10.0.0.49 : 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': '15217907620694671967', 'uuid-lslong': '11333166726890351658'}, 'enable': 'true', 'created': '2025-10-16T01:45:15', 'last-modified': '2025-10-16T01:45:15', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:05.364385'} 2025-10-16 01:45:20,875 - DEBUG - Requesting: http://10.0.0.49:8083/Snh_ShowRoutingInstanceReq?name=default-domain:k8s-default:__public__:__public__ 2025-10-16 01:45:20,882 - DEBUG - Route Targets: ['target:64512:8000006'] 2025-10-16 01:45:20,882 - INFO - On all control nodes, Config, RI and RT verification for VN __public__ passed 2025-10-16 01:45:20,882 - DEBUG - ====Verifying policy data for __public__ in API_Server ====== 2025-10-16 01:45:20,882 - DEBUG - Requesting: http://10.0.0.49:8082/domains 2025-10-16 01:45:20,887 - DEBUG - Requesting: http://10.0.0.49:8082/domain/ad7256a5-37b5-4635-8f41-9f0ab26945fb 2025-10-16 01:45:20,892 - DEBUG - Requesting: http://10.0.0.49:8082/project/eec715eb-ac09-48ed-8c3e-76878d386914 2025-10-16 01:45:20,922 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-network/d330de5a-6437-425f-9d47-7f17a8936c2a 2025-10-16 01:45:20,935 - DEBUG - =>VN __public__ has no policy to be verified 2025-10-16 01:45:20,935 - DEBUG - Verifying the vn in opserver 2025-10-16 01:45:20,935 - DEBUG - Verifying the default-domain:k8s-default:__public__ virtual network link through opserver 10.0.0.49 2025-10-16 01:45:20,935 - DEBUG - Requesting: http://10.0.0.49:8081/analytics/uves/virtual-networks 2025-10-16 01:45:20,940 - DEBUG - vn link and name as {'name': 'default-domain:k8s-default:__public__', 'href': 'http://10.0.0.49:8081/analytics/uves/virtual-network/default-domain:k8s-default:__public__?flat'} 2025-10-16 01:45:20,941 - INFO - Validated that VN default-domain:k8s-default:__public__ is found in opserver 2025-10-16 01:45:20,941 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_VrfListReq?name=default-domain:k8s-default:__public__:__public__ 2025-10-16 01:45:20,946 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_VrfListReq?name=default-domain:k8s-default:__public__:__public__ 2025-10-16 01:45:20,950 - DEBUG - Do not have enough data to verify VN in agent 2025-10-16 01:45:20,950 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_VrfListReq?name=default-domain:k8s-default:__public__:__public__ 2025-10-16 01:45:20,957 - DEBUG - VRF ids for VN __public__: {} 2025-10-16 01:45:21,131 - INFO - Creating Floating IP pool __fip_pool_public__ in API Server 2025-10-16 01:45:21,355 - DEBUG - Requesting: http://10.0.0.49:8082/domains 2025-10-16 01:45:21,365 - DEBUG - Requesting: http://10.0.0.49:8082/domain/ad7256a5-37b5-4635-8f41-9f0ab26945fb 2025-10-16 01:45:21,372 - DEBUG - Requesting: http://10.0.0.49:8082/project/eec715eb-ac09-48ed-8c3e-76878d386914 2025-10-16 01:45:21,405 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-network/d330de5a-6437-425f-9d47-7f17a8936c2a 2025-10-16 01:45:21,416 - DEBUG - Requesting: http://10.0.0.49:8082/floating-ip-pool/815daf19-c8ea-4982-b28c-6641e6ccf25e 2025-10-16 01:45:21,424 - DEBUG - Requesting: http://10.0.0.49:8082/domains 2025-10-16 01:45:21,434 - DEBUG - Requesting: http://10.0.0.49:8082/domain/ad7256a5-37b5-4635-8f41-9f0ab26945fb 2025-10-16 01:45:21,441 - DEBUG - Requesting: http://10.0.0.49:8082/project/eec715eb-ac09-48ed-8c3e-76878d386914 2025-10-16 01:45:21,473 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-network/d330de5a-6437-425f-9d47-7f17a8936c2a 2025-10-16 01:45:21,480 - DEBUG - FIP Pool __fip_pool_public__ found in API Server 2025-10-16 01:45:21,480 - INFO - Verification for FIP pool __fip_pool_public__ in API Server passed 2025-10-16 01:45:21,486 - DEBUG - Requesting: http://10.0.0.49:8083/Snh_IFMapTableShowReq?table_name=floating-ip-pool&search_string=floating-ip-pool:default-domain:k8s-default:__public__:__fip_pool_public__ 2025-10-16 01:45:21,491 - DEBUG - Control-node Ifmap-view has FIP pool __fip_pool_public__ information 2025-10-16 01:45:21,491 - INFO - Verification for FIP pool __fip_pool_public__ in Control-node passed 2025-10-16 01:45:21,494 - DEBUG - Ingress ctest-nginx-ingress-58473541 not present 2025-10-16 01:45:21,494 - INFO - Creating Ingress ctest-nginx-ingress-58473541 2025-10-16 01:45:21,501 - INFO - Created Ingress ctest-nginx-ingress-58473541 2025-10-16 01:45:21,506 - DEBUG - Cluster IP not yet seen for Ingress ctest-nginx-ingress-58473541 2025-10-16 01:45:24,512 - DEBUG - For Ingress ctest-nginx-ingress-58473541, Cluster IP: 10.47.255.248, External IPs ['52.21.64.60'] 2025-10-16 01:45:24,512 - INFO - Verifications in k8s passed for Ingress ctest-nginx-ingress-58473541 2025-10-16 01:45:24,512 - DEBUG - Requesting: http://10.0.0.49:8108/Snh_LoadbalancerDatabaseList?x=18430aa1-29c4-468a-bfc1-2af3ac2afc14 2025-10-16 01:45:24,517 - INFO - Ingress ctest-nginx-ingress-58473541 with uuid 18430aa1-29c4-468a-bfc1-2af3ac2afc14 found in kube manager 2025-10-16 01:45:24,517 - INFO - Ingress ctest-nginx-ingress-58473541 verification passed 2025-10-16 01:45:24,521 - DEBUG - Pod ctest-busybox-pod-98162053 not present 2025-10-16 01:45:24,521 - INFO - Creating Pod ctest-busybox-pod-98162053 2025-10-16 01:45:24,555 - DEBUG - Node for Pod ctest-busybox-pod-98162053 not yet populated 2025-10-16 01:45:27,562 - DEBUG - Pod : ctest-busybox-pod-98162053 UUID is 3faedf6a-1dd3-4441-b5e9-159887c613e6 2025-10-16 01:45:27,573 - DEBUG - Pod ctest-nginx-pod-47086367 not in running state.Currently in Pending 2025-10-16 01:45:32,582 - INFO - Pod ctest-nginx-pod-47086367 is in running state.Got IP 10.47.255.250 2025-10-16 01:45:32,641 - DEBUG - Pod ctest-nginx-pod-47086367 has vmi c4a60a80-aa31-11f0-9472-0242551b6556 2025-10-16 01:45:32,641 - INFO - Verified pod ctest-nginx-pod-47086367 in contrail-api 2025-10-16 01:45:32,641 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2025-10-16 01:45:32,652 - DEBUG - VMI c4a60a80-aa31-11f0-9472-0242551b6556 is active in agent 10.0.0.49 2025-10-16 01:45:32,652 - INFO - Verified Pod ctest-nginx-pod-47086367 in agent 10.0.0.49 2025-10-16 01:45:32,652 - DEBUG - Requesting: http://10.0.0.49:8108/Snh_VirtualMachineDatabaseList?x=9cf36003-ab4d-41d6-91f2-d3e0fa950920 2025-10-16 01:45:32,658 - INFO - Pod ctest-nginx-pod-47086367 with uuid 9cf36003-ab4d-41d6-91f2-d3e0fa950920 found in kube manager 2025-10-16 01:45:32,658 - INFO - Pod ctest-nginx-pod-47086367 verification passed 2025-10-16 01:45:32,760 - DEBUG - [Pod ctest-nginx-pod-47086367] Cmd: echo ctest-nginx-pod-47086367 > /usr/share/nginx/html/index.html, Output: 2025-10-16 01:45:32,769 - INFO - Pod ctest-nginx-pod-40982897 is in running state.Got IP 10.47.255.249 2025-10-16 01:45:32,829 - DEBUG - Pod ctest-nginx-pod-40982897 has vmi c54d3bb6-aa31-11f0-9472-0242551b6556 2025-10-16 01:45:32,829 - INFO - Verified pod ctest-nginx-pod-40982897 in contrail-api 2025-10-16 01:45:32,829 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2025-10-16 01:45:32,839 - DEBUG - VMI c54d3bb6-aa31-11f0-9472-0242551b6556 is active in agent 10.0.0.49 2025-10-16 01:45:32,839 - INFO - Verified Pod ctest-nginx-pod-40982897 in agent 10.0.0.49 2025-10-16 01:45:32,839 - DEBUG - Requesting: http://10.0.0.49:8108/Snh_VirtualMachineDatabaseList?x=04edb11c-fa32-4633-9100-eb40dd0a7122 2025-10-16 01:45:32,843 - INFO - Pod ctest-nginx-pod-40982897 with uuid 04edb11c-fa32-4633-9100-eb40dd0a7122 found in kube manager 2025-10-16 01:45:32,843 - INFO - Pod ctest-nginx-pod-40982897 verification passed 2025-10-16 01:45:32,927 - DEBUG - [Pod ctest-nginx-pod-40982897] Cmd: echo ctest-nginx-pod-40982897 > /usr/share/nginx/html/index.html, Output: 2025-10-16 01:45:32,935 - DEBUG - Pod ctest-busybox-pod-98162053 not in running state.Currently in Pending 2025-10-16 01:45:37,943 - INFO - Pod ctest-busybox-pod-98162053 is in running state.Got IP 10.47.255.247 2025-10-16 01:45:37,994 - DEBUG - Pod ctest-busybox-pod-98162053 has vmi cb08ea1e-aa31-11f0-9472-0242551b6556 2025-10-16 01:45:37,994 - INFO - Verified pod ctest-busybox-pod-98162053 in contrail-api 2025-10-16 01:45:37,994 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2025-10-16 01:45:38,004 - DEBUG - VMI cb08ea1e-aa31-11f0-9472-0242551b6556 is active in agent 10.0.0.49 2025-10-16 01:45:38,004 - INFO - Verified Pod ctest-busybox-pod-98162053 in agent 10.0.0.49 2025-10-16 01:45:38,004 - DEBUG - Requesting: http://10.0.0.49:8108/Snh_VirtualMachineDatabaseList?x=3faedf6a-1dd3-4441-b5e9-159887c613e6 2025-10-16 01:45:38,008 - INFO - Pod ctest-busybox-pod-98162053 with uuid 3faedf6a-1dd3-4441-b5e9-159887c613e6 found in kube manager 2025-10-16 01:45:38,008 - INFO - Pod ctest-busybox-pod-98162053 verification passed 2025-10-16 01:45:38,081 - DEBUG - [Pod ctest-busybox-pod-98162053] Cmd: wget http://10.47.255.248:80/ -O - -T 5 -t 1 , Output: Connecting to 10.47.255.248:80 (10.47.255.248:80) ctest-nginx-pod-47086367 writing to stdout - 100% |********************************| 25 0:00:00 ETA written to stdout 2025-10-16 01:45:38,082 - DEBUG - [Pod Pod ctest-busybox-pod-98162053] Cmd wget http://10.47.255.248:80/ -O - -T 5 -t 1 passed 2025-10-16 01:45:38,082 - DEBUG - [Pod Pod ctest-busybox-pod-98162053] Cmd output: Connecting to 10.47.255.248:80 (10.47.255.248:80) ctest-nginx-pod-47086367 writing to stdout - 100% |********************************| 25 0:00:00 ETA written to stdout 2025-10-16 01:45:38,164 - DEBUG - [Pod ctest-busybox-pod-98162053] Cmd: wget http://10.47.255.248:80/ -O - -T 5 -t 1 , Output: Connecting to 10.47.255.248:80 (10.47.255.248:80) writing to stdout - 100% |********************************| 25 0:00:00 ETA written to stdout ctest-nginx-pod-47086367 2025-10-16 01:45:38,164 - DEBUG - [Pod Pod ctest-busybox-pod-98162053] Cmd wget http://10.47.255.248:80/ -O - -T 5 -t 1 passed 2025-10-16 01:45:38,164 - DEBUG - [Pod Pod ctest-busybox-pod-98162053] Cmd output: Connecting to 10.47.255.248:80 (10.47.255.248:80) writing to stdout - 100% |********************************| 25 0:00:00 ETA written to stdout ctest-nginx-pod-47086367 2025-10-16 01:45:38,240 - DEBUG - [Pod ctest-busybox-pod-98162053] Cmd: wget http://10.47.255.248:80/ -O - -T 5 -t 1 , Output: Connecting to 10.47.255.248:80 (10.47.255.248:80) ctest-nginx-pod-47086367 writing to stdout - 100% |********************************| 25 0:00:00 ETA written to stdout 2025-10-16 01:45:38,240 - DEBUG - [Pod Pod ctest-busybox-pod-98162053] Cmd wget http://10.47.255.248:80/ -O - -T 5 -t 1 passed 2025-10-16 01:45:38,240 - DEBUG - [Pod Pod ctest-busybox-pod-98162053] Cmd output: Connecting to 10.47.255.248:80 (10.47.255.248:80) ctest-nginx-pod-47086367 writing to stdout - 100% |********************************| 25 0:00:00 ETA written to stdout 2025-10-16 01:45:38,302 - DEBUG - [Pod ctest-busybox-pod-98162053] Cmd: wget http://10.47.255.248:80/ -O - -T 5 -t 1 , Output: Connecting to 10.47.255.248:80 (10.47.255.248:80) ctest-nginx-pod-47086367 writing to stdout - 100% |********************************| 25 0:00:00 ETA written to stdout 2025-10-16 01:45:38,302 - DEBUG - [Pod Pod ctest-busybox-pod-98162053] Cmd wget http://10.47.255.248:80/ -O - -T 5 -t 1 passed 2025-10-16 01:45:38,302 - DEBUG - [Pod Pod ctest-busybox-pod-98162053] Cmd output: Connecting to 10.47.255.248:80 (10.47.255.248:80) ctest-nginx-pod-47086367 writing to stdout - 100% |********************************| 25 0:00:00 ETA written to stdout 2025-10-16 01:45:38,378 - DEBUG - [Pod ctest-busybox-pod-98162053] Cmd: wget http://10.47.255.248:80/ -O - -T 5 -t 1 , Output: Connecting to 10.47.255.248:80 (10.47.255.248:80) writing to stdout - 100% |********************************| 25 0:00:00 ETA written to stdout ctest-nginx-pod-47086367 2025-10-16 01:45:38,378 - DEBUG - [Pod Pod ctest-busybox-pod-98162053] Cmd wget http://10.47.255.248:80/ -O - -T 5 -t 1 passed 2025-10-16 01:45:38,378 - DEBUG - [Pod Pod ctest-busybox-pod-98162053] Cmd output: Connecting to 10.47.255.248:80 (10.47.255.248:80) writing to stdout - 100% |********************************| 25 0:00:00 ETA written to stdout ctest-nginx-pod-47086367 2025-10-16 01:45:38,451 - DEBUG - [Pod ctest-busybox-pod-98162053] Cmd: wget http://10.47.255.248:80/ -O - -T 5 -t 1 , Output: Connecting to 10.47.255.248:80 (10.47.255.248:80) ctest-nginx-pod-47086367 writing to stdout - 100% |********************************| 25 0:00:00 ETA written to stdout 2025-10-16 01:45:38,451 - DEBUG - [Pod Pod ctest-busybox-pod-98162053] Cmd wget http://10.47.255.248:80/ -O - -T 5 -t 1 passed 2025-10-16 01:45:38,451 - DEBUG - [Pod Pod ctest-busybox-pod-98162053] Cmd output: Connecting to 10.47.255.248:80 (10.47.255.248:80) ctest-nginx-pod-47086367 writing to stdout - 100% |********************************| 25 0:00:00 ETA written to stdout 2025-10-16 01:45:38,513 - DEBUG - [Pod ctest-busybox-pod-98162053] Cmd: wget http://10.47.255.248:80/ -O - -T 5 -t 1 , Output: ctest-nginx-pod-40982897 Connecting to 10.47.255.248:80 (10.47.255.248:80) writing to stdout - 100% |********************************| 25 0:00:00 ETA written to stdout 2025-10-16 01:45:38,513 - DEBUG - [Pod Pod ctest-busybox-pod-98162053] Cmd wget http://10.47.255.248:80/ -O - -T 5 -t 1 passed 2025-10-16 01:45:38,513 - DEBUG - [Pod Pod ctest-busybox-pod-98162053] Cmd output: ctest-nginx-pod-40982897 Connecting to 10.47.255.248:80 (10.47.255.248:80) writing to stdout - 100% |********************************| 25 0:00:00 ETA written to stdout 2025-10-16 01:45:38,513 - INFO - Responses seen from all pods, lb seems fine.Hits : {'ctest-nginx-pod-47086367': 6, 'ctest-nginx-pod-40982897': 1} 2025-10-16 01:45:38,513 - WARNING - Nothing to delete parallely 2025-10-16 01:45:38,514 - INFO - Deleting pod default:ctest-busybox-pod-98162053 2025-10-16 01:45:38,528 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_VmListReq?uuid=3faedf6a-1dd3-4441-b5e9-159887c613e6 2025-10-16 01:45:38,533 - WARNING - Pod uuid 3faedf6a-1dd3-4441-b5e9-159887c613e6 is still seen in agent 10.0.0.49 VM list 2025-10-16 01:45:43,534 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_VmListReq?uuid=3faedf6a-1dd3-4441-b5e9-159887c613e6 2025-10-16 01:45:43,539 - WARNING - Pod uuid 3faedf6a-1dd3-4441-b5e9-159887c613e6 is still seen in agent 10.0.0.49 VM list 2025-10-16 01:45:48,540 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_VmListReq?uuid=3faedf6a-1dd3-4441-b5e9-159887c613e6 2025-10-16 01:45:48,547 - WARNING - Pod uuid 3faedf6a-1dd3-4441-b5e9-159887c613e6 is still seen in agent 10.0.0.49 VM list 2025-10-16 01:45:53,548 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_VmListReq?uuid=3faedf6a-1dd3-4441-b5e9-159887c613e6 2025-10-16 01:45:53,553 - WARNING - Pod uuid 3faedf6a-1dd3-4441-b5e9-159887c613e6 is still seen in agent 10.0.0.49 VM list 2025-10-16 01:45:58,554 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_VmListReq?uuid=3faedf6a-1dd3-4441-b5e9-159887c613e6 2025-10-16 01:45:58,560 - WARNING - Pod uuid 3faedf6a-1dd3-4441-b5e9-159887c613e6 is still seen in agent 10.0.0.49 VM list 2025-10-16 01:46:03,561 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_VmListReq?uuid=3faedf6a-1dd3-4441-b5e9-159887c613e6 2025-10-16 01:46:03,567 - WARNING - Pod uuid 3faedf6a-1dd3-4441-b5e9-159887c613e6 is still seen in agent 10.0.0.49 VM list 2025-10-16 01:46:08,568 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_VmListReq?uuid=3faedf6a-1dd3-4441-b5e9-159887c613e6 2025-10-16 01:46:08,573 - WARNING - Pod uuid 3faedf6a-1dd3-4441-b5e9-159887c613e6 is still seen in agent 10.0.0.49 VM list 2025-10-16 01:46:13,576 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_VmListReq?uuid=3faedf6a-1dd3-4441-b5e9-159887c613e6 2025-10-16 01:46:13,581 - DEBUG - Pod 3faedf6a-1dd3-4441-b5e9-159887c613e6 is not in agent 10.0.0.49 VM list 2025-10-16 01:46:13,581 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:cb08ea1e-aa31-11f0-9472-0242551b6556 2025-10-16 01:46:13,586 - DEBUG - VMI cb08ea1e-aa31-11f0-9472-0242551b6556 is removed from agent 10.0.0.49 2025-10-16 01:46:13,587 - INFO - Verified that pod ctest-busybox-pod-98162053 is removed in agent 2025-10-16 01:46:13,587 - INFO - Deleting Ingress : ctest-nginx-ingress-58473541 2025-10-16 01:46:13,597 - DEBUG - Requesting: http://10.0.0.49:8108/Snh_LoadbalancerDatabaseList?x=18430aa1-29c4-468a-bfc1-2af3ac2afc14 2025-10-16 01:46:13,602 - ERROR - Ingress ctest-nginx-ingress-58473541 with uuid 18430aa1-29c4-468a-bfc1-2af3ac2afc14 still found in kube manager 2025-10-16 01:46:14,603 - DEBUG - Requesting: http://10.0.0.49:8108/Snh_LoadbalancerDatabaseList?x=18430aa1-29c4-468a-bfc1-2af3ac2afc14 2025-10-16 01:46:14,613 - ERROR - Ingress ctest-nginx-ingress-58473541 with uuid 18430aa1-29c4-468a-bfc1-2af3ac2afc14 still found in kube manager 2025-10-16 01:46:15,614 - DEBUG - Requesting: http://10.0.0.49:8108/Snh_LoadbalancerDatabaseList?x=18430aa1-29c4-468a-bfc1-2af3ac2afc14 2025-10-16 01:46:15,617 - INFO - Ingress ctest-nginx-ingress-58473541 with uuid 18430aa1-29c4-468a-bfc1-2af3ac2afc14 deleted successfully from kube manager 2025-10-16 01:46:15,618 - INFO - Verifications on Ingress %s cleanup passed 2025-10-16 01:46:15,618 - INFO - Deleting the FIP pool __fip_pool_public__ 2025-10-16 01:46:15,699 - DEBUG - Requesting: http://10.0.0.49:8083/Snh_IFMapTableShowReq?table_name=floating-ip-pool&search_string=floating-ip-pool:default-domain:k8s-default:__public__:__fip_pool_public__ 2025-10-16 01:46:15,705 - DEBUG - Control-node Ifmap-view does not have FIP pool __fip_pool_public__ information 2025-10-16 01:46:15,705 - INFO - Deleting VN __public__ 2025-10-16 01:46:15,804 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/0df3fd05-2a52-4ddf-84bf-4339a2711d04 2025-10-16 01:46:15,809 - DEBUG - Response Code: 404 2025-10-16 01:46:15,810 - DEBUG - Requesting: http://10.0.0.49:8082/domains 2025-10-16 01:46:15,813 - DEBUG - Requesting: http://10.0.0.49:8082/domain/ad7256a5-37b5-4635-8f41-9f0ab26945fb 2025-10-16 01:46:15,819 - DEBUG - Requesting: http://10.0.0.49:8082/project/eec715eb-ac09-48ed-8c3e-76878d386914 2025-10-16 01:46:15,853 - INFO - Validated that VN __public__ is not found in API Server 2025-10-16 01:46:15,853 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_VnListReq?name=default-domain:k8s-default:__public__ 2025-10-16 01:46:15,859 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_VrfListReq?name=default-domain:k8s-default:__public__:__public__ 2025-10-16 01:46:15,863 - DEBUG - VN __public__ is not present in Agent 10.0.0.49 2025-10-16 01:46:15,863 - INFO - Validated that VN __public__ is not in any agent 2025-10-16 01:46:15,863 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_VrfListReq?name=default-domain:k8s-default:__public__:__public__ 2025-10-16 01:46:15,869 - DEBUG - Requesting: http://10.0.0.49:8083/Snh_ShowRoutingInstanceReq?name=default-domain:k8s-default:__public__:__public__ 2025-10-16 01:46:15,876 - DEBUG - Requesting: http://10.0.0.49:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:k8s-default:__public__ 2025-10-16 01:46:15,880 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN __public__ info 2025-10-16 01:46:15,881 - INFO - Deleting pod default:ctest-nginx-pod-40982897 2025-10-16 01:46:15,891 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_VmListReq?uuid=04edb11c-fa32-4633-9100-eb40dd0a7122 2025-10-16 01:46:15,897 - WARNING - Pod uuid 04edb11c-fa32-4633-9100-eb40dd0a7122 is still seen in agent 10.0.0.49 VM list 2025-10-16 01:46:20,898 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_VmListReq?uuid=04edb11c-fa32-4633-9100-eb40dd0a7122 2025-10-16 01:46:20,904 - DEBUG - Pod 04edb11c-fa32-4633-9100-eb40dd0a7122 is not in agent 10.0.0.49 VM list 2025-10-16 01:46:20,904 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:c54d3bb6-aa31-11f0-9472-0242551b6556 2025-10-16 01:46:20,910 - DEBUG - VMI c54d3bb6-aa31-11f0-9472-0242551b6556 is removed from agent 10.0.0.49 2025-10-16 01:46:20,910 - INFO - Verified that pod ctest-nginx-pod-40982897 is removed in agent 2025-10-16 01:46:20,911 - INFO - Deleting pod default:ctest-nginx-pod-47086367 2025-10-16 01:46:20,925 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_VmListReq?uuid=9cf36003-ab4d-41d6-91f2-d3e0fa950920 2025-10-16 01:46:20,935 - WARNING - Pod uuid 9cf36003-ab4d-41d6-91f2-d3e0fa950920 is still seen in agent 10.0.0.49 VM list 2025-10-16 01:46:25,936 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_VmListReq?uuid=9cf36003-ab4d-41d6-91f2-d3e0fa950920 2025-10-16 01:46:25,942 - DEBUG - Pod 9cf36003-ab4d-41d6-91f2-d3e0fa950920 is not in agent 10.0.0.49 VM list 2025-10-16 01:46:25,942 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:c4a60a80-aa31-11f0-9472-0242551b6556 2025-10-16 01:46:25,947 - DEBUG - VMI c4a60a80-aa31-11f0-9472-0242551b6556 is removed from agent 10.0.0.49 2025-10-16 01:46:25,947 - INFO - Verified that pod ctest-nginx-pod-47086367 is removed in agent 2025-10-16 01:46:25,948 - INFO - Deleting service : ctest-nginx-svc-88014147 2025-10-16 01:46:26,466 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_AgentXmppConnectionStatusReq? 2025-10-16 01:46:26,472 - DEBUG - No XMPP flaps were noticed during the test
2025-10-16 01:46:26,472 - INFO - END TEST : test_ingress_ip_assignment : PASSED[0:01:12]
2025-10-16 01:46:26,472 - INFO - -------------------------------------------------------------------------------- 2025-10-16 01:46:32,879 - DEBUG - [10.0.0.49]: Running cmd : docker exec --privileged -it k8s_opensdn-kube-manager_opensdn-kube-manager-w7ws7_kube-system_a881c2fb-face-41a1-9d39-c35651c884ff_0 /bin/bash -c 'grep "^[ ]*cluster_project" /etc/contrail/contrail-kubernetes.conf' 2025-10-16 01:46:33,130 - DEBUG - Output : cluster_project={} 2025-10-16 01:46:33,237 - DEBUG - [10.0.0.49]: Running cmd : docker exec --privileged -it k8s_opensdn-kube-manager_opensdn-kube-manager-w7ws7_kube-system_a881c2fb-face-41a1-9d39-c35651c884ff_0 /bin/bash -c 'netstat -antp | grep :8108 | grep LISTEN' 2025-10-16 01:46:33,467 - DEBUG - Output : tcp 0 0 0.0.0.0:8108 0.0.0.0:* LISTEN 1/python3 2025-10-16 01:46:33,471 - DEBUG - [10.0.0.49]: Running cmd : docker exec --privileged -it k8s_opensdn-kube-manager_opensdn-kube-manager-w7ws7_kube-system_a881c2fb-face-41a1-9d39-c35651c884ff_0 /bin/bash -c 'grep "^[ ]*cluster_project" /etc/contrail/contrail-kubernetes.conf' 2025-10-16 01:46:33,647 - DEBUG - Output : cluster_project={} 2025-10-16 01:46:48,882 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2025-10-16 01:46:48,998 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2025-10-16 01:46:49,109 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2025-10-16 01:46:54,193 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2025-10-16 01:46:54,303 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2025-10-16 01:46:54,413 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2025-10-16 01:46:54,526 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2025-10-16 01:46:59,607 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2025-10-16 01:46:59,894 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_AgentXmppConnectionStatusReq? 2025-10-16 01:47:02,734 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_ApplicationPolicySetReq? 2025-10-16 01:47:02,738 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_AclReq? 2025-10-16 01:47:02,758 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_AclReq? 2025-10-16 01:47:04,797 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_AclReq? 2025-10-16 01:47:06,829 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_AclReq? 2025-10-16 01:50:08,540 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_AgentXmppConnectionStatusReq? 2025-10-16 01:50:08,608 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_VmListReq?uuid=d84b288c-7d1b-4378-b774-e71ba33383ac 2025-10-16 01:50:08,616 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_VmListReq?uuid=dcb9ff70-cd8e-46e8-8b2b-4e2cab0e0525 2025-10-16 01:50:08,632 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_VmListReq?uuid=83c8d9d0-ec7f-4333-b33a-5034e5bc5cc6 2025-10-16 01:50:08,652 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_VmListReq?uuid=aa9b4e6f-46ac-4840-82b3-0ac69581cf19 2025-10-16 01:50:08,658 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_VmListReq?uuid=8913b85e-8571-4fad-a4a0-3b7b705af791 2025-10-16 01:50:08,662 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_VmListReq?uuid=0eb27ef4-4cdd-47e1-9b18-cd3afb8f20fe 2025-10-16 01:50:08,667 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_VmListReq?uuid=2218422d-f3f8-49cb-84d5-ef6be9ea0a50 2025-10-16 01:50:08,671 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_VmListReq?uuid=f4ca05f4-9253-43f4-b0d6-d68064758315 2025-10-16 01:50:13,677 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_VmListReq?uuid=83c8d9d0-ec7f-4333-b33a-5034e5bc5cc6 2025-10-16 01:50:13,678 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_VmListReq?uuid=dcb9ff70-cd8e-46e8-8b2b-4e2cab0e0525 2025-10-16 01:50:13,679 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_VmListReq?uuid=d84b288c-7d1b-4378-b774-e71ba33383ac 2025-10-16 01:50:13,690 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:f31a2a9a-aa31-11f0-9472-0242551b6556 2025-10-16 01:50:13,691 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:f4c0474e-aa31-11f0-9472-0242551b6556 2025-10-16 01:50:13,704 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_VmListReq?uuid=aa9b4e6f-46ac-4840-82b3-0ac69581cf19 2025-10-16 01:50:13,706 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_VmListReq?uuid=8913b85e-8571-4fad-a4a0-3b7b705af791 2025-10-16 01:50:13,706 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_VmListReq?uuid=f4ca05f4-9253-43f4-b0d6-d68064758315 2025-10-16 01:50:13,707 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_VmListReq?uuid=2218422d-f3f8-49cb-84d5-ef6be9ea0a50 2025-10-16 01:50:13,709 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_VmListReq?uuid=0eb27ef4-4cdd-47e1-9b18-cd3afb8f20fe 2025-10-16 01:50:13,720 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:f5709fc2-aa31-11f0-9472-0242551b6556 2025-10-16 01:50:13,728 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:f3c76606-aa31-11f0-9472-0242551b6556 2025-10-16 01:50:18,694 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_VmListReq?uuid=d84b288c-7d1b-4378-b774-e71ba33383ac 2025-10-16 01:50:18,721 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_VmListReq?uuid=8913b85e-8571-4fad-a4a0-3b7b705af791 2025-10-16 01:50:18,723 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_VmListReq?uuid=f4ca05f4-9253-43f4-b0d6-d68064758315 2025-10-16 01:50:18,731 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_VmListReq?uuid=0eb27ef4-4cdd-47e1-9b18-cd3afb8f20fe 2025-10-16 01:50:23,700 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_VmListReq?uuid=d84b288c-7d1b-4378-b774-e71ba33383ac 2025-10-16 01:50:23,727 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_VmListReq?uuid=8913b85e-8571-4fad-a4a0-3b7b705af791 2025-10-16 01:50:23,730 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_VmListReq?uuid=f4ca05f4-9253-43f4-b0d6-d68064758315 2025-10-16 01:50:23,737 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_VmListReq?uuid=0eb27ef4-4cdd-47e1-9b18-cd3afb8f20fe 2025-10-16 01:50:28,705 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_VmListReq?uuid=d84b288c-7d1b-4378-b774-e71ba33383ac 2025-10-16 01:50:28,733 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_VmListReq?uuid=8913b85e-8571-4fad-a4a0-3b7b705af791 2025-10-16 01:50:28,735 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_VmListReq?uuid=f4ca05f4-9253-43f4-b0d6-d68064758315 2025-10-16 01:50:28,742 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_VmListReq?uuid=0eb27ef4-4cdd-47e1-9b18-cd3afb8f20fe 2025-10-16 01:50:33,710 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_VmListReq?uuid=d84b288c-7d1b-4378-b774-e71ba33383ac 2025-10-16 01:50:33,744 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_VmListReq?uuid=f4ca05f4-9253-43f4-b0d6-d68064758315 2025-10-16 01:50:33,745 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_VmListReq?uuid=8913b85e-8571-4fad-a4a0-3b7b705af791 2025-10-16 01:50:33,748 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_VmListReq?uuid=0eb27ef4-4cdd-47e1-9b18-cd3afb8f20fe 2025-10-16 01:50:38,717 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_VmListReq?uuid=d84b288c-7d1b-4378-b774-e71ba33383ac 2025-10-16 01:50:38,755 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_VmListReq?uuid=f4ca05f4-9253-43f4-b0d6-d68064758315 2025-10-16 01:50:38,756 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_VmListReq?uuid=8913b85e-8571-4fad-a4a0-3b7b705af791 2025-10-16 01:50:38,757 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_VmListReq?uuid=0eb27ef4-4cdd-47e1-9b18-cd3afb8f20fe 2025-10-16 01:50:43,723 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_VmListReq?uuid=d84b288c-7d1b-4378-b774-e71ba33383ac 2025-10-16 01:50:43,729 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:f729134e-aa31-11f0-9472-0242551b6556 2025-10-16 01:50:43,766 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_VmListReq?uuid=f4ca05f4-9253-43f4-b0d6-d68064758315 2025-10-16 01:50:43,768 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_VmListReq?uuid=0eb27ef4-4cdd-47e1-9b18-cd3afb8f20fe 2025-10-16 01:50:43,769 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_VmListReq?uuid=8913b85e-8571-4fad-a4a0-3b7b705af791 2025-10-16 01:50:43,775 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:f644185c-aa31-11f0-9472-0242551b6556 2025-10-16 01:50:43,776 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:f8c37b68-aa31-11f0-9472-0242551b6556 2025-10-16 01:50:43,777 - DEBUG - Requesting: http://10.0.0.49:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:f7f146fc-aa31-11f0-9472-0242551b6556