2025-11-01 07:39:00,814 - DEBUG - [10.0.0.38]: Running cmd : hostname
2025-11-01 07:39:01,104 - DEBUG - Output : cn-jenkins-deploy-platform-ansible-os-4586-1
2025-11-01 07:39:01,104 - DEBUG - [10.0.0.38]: Running cmd : hostname -f
2025-11-01 07:39:01,188 - DEBUG - Output : cn-jenkins-deploy-platform-ansible-os-4586-1.
2025-11-01 07:39:01,188 - DEBUG - [10.0.0.38]: 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-11-01 07:39:01,303 - DEBUG - Output : NAMES
contrail_test_PDJg0KB5q
vrouter_vrouter-agent_1
vrouter_nodemgr_1
rsyslogd_rsyslogd_1
analytics_snmp_nodemgr_1
analytics_snmp_snmp-collector_1
analytics_snmp_topology_1
analytics_alarm_nodemgr_1
analytics_alarm_alarm-gen_1
analytics_alarm_kafka_1
analytics_nodemgr_1
analytics_collector_1
analytics_api_1
analytics_database_nodemgr_1
analytics_database_query-engine_1
analytics_database_cassandra_1
control_named_1
control_dns_1
control_control_1
control_nodemgr_1
webui_job_1
webui_web_1
config_devicemgr_1
config_api_1
config_nodemgr_1
config_schema_1
config_dnsmasq_1
config_svcmonitor_1
config_database_nodemgr_1
config_database_rabbitmq_1
config_database_cassandra_1
config_database_zookeeper_1
redis_redis_1
barbican_worker
barbican_keystone_listener
barbican_api
horizon
heat_engine
heat_api_cfn
heat_api
neutron_server
nova_compute
nova_libvirt
nova_ssh
nova_novncproxy
nova_conductor
nova_api
nova_scheduler
glance_api
keystone
keystone_fernet
keystone_ssh
rabbitmq
memcached
mariadb
cron
kolla_toolbox
fluentd
2025-11-01 07:39:01,303 - DEBUG - [10.0.0.38]: Running cmd : getent hosts 10.0.0.38 | head -n 1 | awk '{print $2}'
2025-11-01 07:39:01,376 - DEBUG - Output : cn-jenkins-deploy-platform-ansible-os-4586-1.
2025-11-01 07:39:01,376 - DEBUG - [10.0.0.38]: Running cmd : ip -4 -o addr show | awk '{print $4}'
2025-11-01 07:39:01,446 - DEBUG - Output : 127.0.0.1/8
10.0.0.38/24
172.17.0.1/16
10.20.0.17/24
2025-11-01 07:39:01,446 - DEBUG - [10.0.0.38]: Running cmd : ip -4 -o addr show dev vhost0 | awk '{print $4}'
2025-11-01 07:39:01,514 - DEBUG - Output : 10.20.0.17/24
2025-11-01 07:39:01,515 - DEBUG - [10.0.0.38]: Running cmd : getent hosts 10.20.0.17 | head -n 1 | awk '{print $2}'
2025-11-01 07:39:01,591 - DEBUG - Output : 
2025-11-01 07:39:03,644 - INFO - Using existing project ['default-domain', 'admin'](78b6db8c-ca7b-4564-8d17-8895330cb422)
2025-11-01 07:39:03,819 - INFO - ================================================================================
2025-11-01 07:39:03,819 - INFO - STARTING TEST    : test_contrail_status
2025-11-01 07:39:03,819 - INFO - TEST DESCRIPTION :  Test to verify that all services are running and active
        
2025-11-01 07:39:03,955 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_AgentXmppConnectionStatusReq?
2025-11-01 07:39:03,962 - DEBUG - Nothing to compare xmpp stats {'10.0.0.38': {'10.20.0.17': '0'}} with
2025-11-01 07:39:03,962 - INFO - Initial checks done. Running the testcase now
2025-11-01 07:39:03,962 - INFO - 
2025-11-01 07:39:03,963 - DEBUG - [10.0.0.38]: Running cmd : docker ps -f status=running --format {{.Names}} 2>/dev/null
2025-11-01 07:39:04,099 - DEBUG - Output : contrail_test_PDJg0KB5q
vrouter_vrouter-agent_1
vrouter_nodemgr_1
vrouter_provisioner_1
rsyslogd_rsyslogd_1
analytics_snmp_nodemgr_1
analytics_snmp_snmp-collector_1
analytics_snmp_topology_1
analytics_snmp_provisioner_1
analytics_alarm_nodemgr_1
analytics_alarm_provisioner_1
analytics_alarm_alarm-gen_1
analytics_alarm_kafka_1
analytics_nodemgr_1
analytics_provisioner_1
analytics_collector_1
analytics_api_1
analytics_database_nodemgr_1
analytics_database_provisioner_1
analytics_database_query-engine_1
analytics_database_cassandra_1
control_named_1
control_dns_1
control_provisioner_1
control_control_1
control_nodemgr_1
webui_job_1
webui_web_1
config_devicemgr_1
config_api_1
config_provisioner_1
config_nodemgr_1
config_schema_1
config_dnsmasq_1
config_svcmonitor_1
config_database_nodemgr_1
config_database_provisioner_1
config_database_rabbitmq_1
config_database_cassandra_1
config_database_zookeeper_1
redis_redis_1
barbican_worker
barbican_keystone_listener
barbican_api
horizon
heat_engine
heat_api_cfn
heat_api
neutron_server
nova_compute
nova_libvirt
nova_ssh
nova_novncproxy
nova_conductor
nova_api
nova_scheduler
placement_api
glance_api
keystone
keystone_fernet
keystone_ssh
rabbitmq
memcached
mariadb
cron
kolla_toolbox
fluentd
2025-11-01 07:39:04,099 - INFO - 10.0.0.38
2025-11-01 07:39:04,099 - INFO -   config
2025-11-01 07:39:04,108 - INFO -     config-nodemgr:active
2025-11-01 07:39:04,114 - INFO -     api-server:active
2025-11-01 07:39:04,121 - INFO -     schema:active
2025-11-01 07:39:04,128 - INFO -     svc-monitor:active
2025-11-01 07:39:04,133 - INFO -     device-manager:active
2025-11-01 07:39:04,133 - INFO -   config-database
2025-11-01 07:39:04,133 - INFO -     config-cassandra:active
2025-11-01 07:39:04,133 - INFO -     config-zookeeper:active
2025-11-01 07:39:04,134 - INFO -     config-rabbitmq:active
2025-11-01 07:39:04,134 - INFO -   vrouter
2025-11-01 07:39:04,141 - INFO -     vrouter-nodemgr:active
2025-11-01 07:39:04,151 - INFO -     agent:active
2025-11-01 07:39:04,151 - INFO -   control
2025-11-01 07:39:04,159 - INFO -     control-nodemgr:active
2025-11-01 07:39:04,167 - INFO -     control:active
2025-11-01 07:39:04,167 - INFO -     named:active
2025-11-01 07:39:04,175 - INFO -     dns:active
2025-11-01 07:39:04,176 - INFO -   analytics
2025-11-01 07:39:04,188 - INFO -     analytics-nodemgr:active
2025-11-01 07:39:04,197 - INFO -     analytics-api:active
2025-11-01 07:39:04,208 - INFO -     collector:active
2025-11-01 07:39:04,209 - INFO -   analytics-database
2025-11-01 07:39:04,209 - INFO -     analytics-cassandra:active
2025-11-01 07:39:04,220 - INFO -     analyticsdb-nodemgr:active
2025-11-01 07:39:04,232 - INFO -     query-engine:active
2025-11-01 07:39:04,232 - INFO -   webui
2025-11-01 07:39:04,232 - INFO -     webui:active
2025-11-01 07:39:04,232 - INFO -     webui-middleware:active
2025-11-01 07:39:04,233 - INFO -     redis:active
2025-11-01 07:39:04,233 - INFO -   analytics_snmp
2025-11-01 07:39:04,240 - INFO -     snmp-collector:active
2025-11-01 07:39:04,241 - INFO -     snmp-topology:active
2025-11-01 07:39:04,241 - INFO -   analytics_alarm
2025-11-01 07:39:04,241 - INFO -     alarmgen:active
2025-11-01 07:39:04,241 - INFO - All the contrail services are up on all nodes
2025-11-01 07:39:04,241 - INFO - contrail-status passed
2025-11-01 07:39:04,392 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_AgentXmppConnectionStatusReq?
2025-11-01 07:39:04,401 - DEBUG - No XMPP flaps were noticed during the test
2025-11-01 07:39:04,401 - INFO - END TEST : test_contrail_status : PASSED[0:00:01]
2025-11-01 07:39:04,402 - INFO - --------------------------------------------------------------------------------
2025-11-01 07:39:07,172 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_AgentXmppConnectionStatusReq?
2025-11-01 07:39:09,992 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-AnalyticsBasicTestSanity-04152120:ctest-vn22-91681741:ctest-vn22-91681741
2025-11-01 07:39:10,006 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-AnalyticsBasicTestSanity-04152120:ctest-vn22-91681741:ctest-vn22-91681741
2025-11-01 07:39:10,014 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-AnalyticsBasicTestSanity-04152120:ctest-vn22-91681741:ctest-vn22-91681741
2025-11-01 07:39:32,260 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VnListReq?name=default-domain:ctest-AnalyticsBasicTestSanity-04152120:ctest-vn22-91681741
2025-11-01 07:39:32,269 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-AnalyticsBasicTestSanity-04152120:ctest-vn22-91681741:ctest-vn22-91681741
2025-11-01 07:39:32,274 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-AnalyticsBasicTestSanity-04152120:ctest-vn22-91681741:ctest-vn22-91681741
2025-11-01 07:39:32,464 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_AgentXmppConnectionStatusReq?
2025-11-01 07:39:33,744 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_AgentXmppConnectionStatusReq?
2025-11-01 07:39:33,756 - DEBUG - [10.0.0.38]: Running cmd : docker exec  --privileged  -it config_api_1 /bin/bash -c  'db-manage check'
2025-11-01 07:39:37,509 - DEBUG - Output : 2025-11-01 07:39:36,517 INFO: (v1.41) Checker check_zk_mode_and_node_count: Success
2025-11-01 07:39:36,551 INFO: (v1.41) Checker check_cassandra_keyspace_replication: Success
2025-11-01 07:39:36,655 INFO: (v1.41) Checker check_obj_mandatory_fields: Success
2025-11-01 07:39:36,922 INFO: (v1.41) Checker check_orphan_resources: Success
2025-11-01 07:39:37,143 INFO: (v1.41) Checker check_fq_name_uuid_match: Success
2025-11-01 07:39:37,143 WARNING: Be careful, that check can return false positive errors if stale FQ names and stale resources were not cleaned before. Run at least commands 'clean_obj_missing_mandatory_fields', 'clean_orphan_resources' and 'clean_stale_fq_names' before.
2025-11-01 07:39:37,262 INFO: (v1.41) Checker check_duplicate_fq_name: Success
2025-11-01 07:39:37,276 INFO: (v1.41) Checker check_route_targets_routing_instance_backrefs: Success
2025-11-01 07:39:37,286 INFO: (v1.41) Checker check_subnet_uuid: Success
2025-11-01 07:39:37,299 ERROR: (v1.41) Checker check_subnet_addr_alloc: Failed:
ZK subnet path '/api-server/subnets' does ends with a valid IP network
2025-11-01 07:39:37,332 INFO: (v1.41) Checker check_route_targets_id: Success
2025-11-01 07:39:37,343 INFO: (v1.41) Checker check_virtual_networks_id: Success
2025-11-01 07:39:37,351 INFO: (v1.41) Checker check_security_groups_id: Success
2025-11-01 07:39:37,355 INFO: (v1.41) Checker check_ipam_subnet_method: Success
2025-11-01 07:39:37,357 INFO: (v1.41) Checker check_aggregated_ethernet_id: Success
2025-11-01 07:39:37,701 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_AgentXmppConnectionStatusReq?
2025-11-01 07:39:37,950 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_AgentXmppConnectionStatusReq?
2025-11-01 07:39:38,154 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_AgentXmppConnectionStatusReq?
2025-11-01 07:39:38,352 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_AgentXmppConnectionStatusReq?
2025-11-01 07:39:38,545 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_AgentXmppConnectionStatusReq?
2025-11-01 07:39:42,011 - INFO - admin user already present
2025-11-01 07:39:43,065 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_AgentXmppConnectionStatusReq?
2025-11-01 07:39:45,603 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-FloatingipBasicTestSanity-76978270:ctest-fvn-28540425:ctest-fvn-28540425
2025-11-01 07:39:45,608 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-FloatingipBasicTestSanity-76978270:ctest-fvn-28540425:ctest-fvn-28540425
2025-11-01 07:39:45,614 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-FloatingipBasicTestSanity-76978270:ctest-fvn-28540425:ctest-fvn-28540425
2025-11-01 07:39:46,664 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-FloatingipBasicTestSanity-76978270:ctest-vn1-84468143:ctest-vn1-84468143
2025-11-01 07:39:46,671 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-FloatingipBasicTestSanity-76978270:ctest-vn1-84468143:ctest-vn1-84468143
2025-11-01 07:39:46,678 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-FloatingipBasicTestSanity-76978270:ctest-vn1-84468143:ctest-vn1-84468143
2025-11-01 07:39:55,705 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:21bd6998-183d-4fdc-8b82-e072945cd4e0
2025-11-01 07:39:55,716 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-FloatingipBasicTestSanity-76978270:ctest-vn1-84468143:ctest-vn1-84468143
2025-11-01 07:39:55,722 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:21bd6998-183d-4fdc-8b82-e072945cd4e0
2025-11-01 07:40:06,947 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:c3c7b388-4eca-4953-8aa9-c61feeaee643
2025-11-01 07:40:06,954 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-FloatingipBasicTestSanity-76978270:ctest-fvn-28540425:ctest-fvn-28540425
2025-11-01 07:40:06,960 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:c3c7b388-4eca-4953-8aa9-c61feeaee643
2025-11-01 07:40:08,572 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:21bd6998-183d-4fdc-8b82-e072945cd4e0
2025-11-01 07:40:08,580 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VnListReq?name=default-domain:ctest-FloatingipBasicTestSanity-76978270:ctest-fvn-28540425
2025-11-01 07:40:08,589 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-FloatingipBasicTestSanity-76978270:ctest-fvn-28540425:ctest-fvn-28540425
2025-11-01 07:40:08,599 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_Inet4UcRouteReq?x=3
2025-11-01 07:40:14,850 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VnListReq?name=default-domain:ctest-FloatingipBasicTestSanity-76978270:ctest-vn1-84468143
2025-11-01 07:40:14,855 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-FloatingipBasicTestSanity-76978270:ctest-vn1-84468143:ctest-vn1-84468143
2025-11-01 07:40:14,861 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-FloatingipBasicTestSanity-76978270:ctest-vn1-84468143:ctest-vn1-84468143
2025-11-01 07:40:15,146 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VnListReq?name=default-domain:ctest-FloatingipBasicTestSanity-76978270:ctest-fvn-28540425
2025-11-01 07:40:15,154 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-FloatingipBasicTestSanity-76978270:ctest-fvn-28540425:ctest-fvn-28540425
2025-11-01 07:40:15,161 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-FloatingipBasicTestSanity-76978270:ctest-fvn-28540425:ctest-fvn-28540425
2025-11-01 07:40:15,474 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_AgentXmppConnectionStatusReq?
2025-11-01 07:40:19,946 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_AgentXmppConnectionStatusReq?
2025-11-01 07:40:20,475 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_AgentXmppConnectionStatusReq?
2025-11-01 07:40:28,846 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_AgentXmppConnectionStatusReq?
2025-11-01 07:40:31,841 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_AgentXmppConnectionStatusReq?
2025-11-01 07:40:36,184 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_AgentXmppConnectionStatusReq?
2025-11-01 07:40:38,780 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_AgentXmppConnectionStatusReq?
2025-11-01 07:40:39,144 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_AgentXmppConnectionStatusReq?
2025-11-01 07:40:46,839 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:1f76729d-c365-44e4-8648-d4a533714c88
2025-11-01 07:40:46,844 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestPorts-19234859:ctest-vn1-59973944:ctest-vn1-59973944
2025-11-01 07:40:46,849 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:1f76729d-c365-44e4-8648-d4a533714c88
2025-11-01 07:41:02,372 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:ac39cd57-7f79-4de6-a1f8-e7c9ae697914
2025-11-01 07:41:02,382 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestPorts-19234859:ctest-vn1-59973944:ctest-vn1-59973944
2025-11-01 07:41:02,391 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:ac39cd57-7f79-4de6-a1f8-e7c9ae697914
2025-11-01 07:41:08,026 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_AgentXmppConnectionStatusReq?
2025-11-01 07:41:12,157 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_AgentXmppConnectionStatusReq?
2025-11-01 07:41:23,137 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:d77f5e6b-d788-4e08-bd37-fa2ecb69e5c3
2025-11-01 07:41:23,146 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestRouters-97329014:ctest-vn1-30268747:ctest-vn1-30268747
2025-11-01 07:41:23,154 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:d77f5e6b-d788-4e08-bd37-fa2ecb69e5c3
2025-11-01 07:41:34,441 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:1854890d-d3fa-4c47-a669-2873b071ded5
2025-11-01 07:41:34,449 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestRouters-97329014:ctest-vn2-50109390:ctest-vn2-50109390
2025-11-01 07:41:34,456 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:1854890d-d3fa-4c47-a669-2873b071ded5
2025-11-01 07:41:53,138 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_AgentXmppConnectionStatusReq?
2025-11-01 07:41:57,880 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_AgentXmppConnectionStatusReq?
2025-11-01 07:42:10,109 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:399b5426-0a9d-4e9f-8be4-3393ac37ff67
2025-11-01 07:42:10,124 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestRoutersBasic-89936222:ctest-vn-33597185:ctest-vn-33597185
2025-11-01 07:42:10,132 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:399b5426-0a9d-4e9f-8be4-3393ac37ff67
2025-11-01 07:42:16,277 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:a59c36b7-49f0-4741-b5b0-08f0711244f7
2025-11-01 07:42:16,284 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestRoutersBasic-89936222:ctest-ext_vn-97716474:ctest-ext_vn-97716474
2025-11-01 07:42:16,291 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:a59c36b7-49f0-4741-b5b0-08f0711244f7
2025-11-01 07:42:25,138 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_AgentXmppConnectionStatusReq?
2025-11-01 07:42:28,991 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_AgentXmppConnectionStatusReq?
2025-11-01 07:42:33,266 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-17980041:ctest-vn-35681442:ctest-vn-35681442
2025-11-01 07:42:33,274 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-17980041:ctest-vn-35681442:ctest-vn-35681442
2025-11-01 07:42:33,281 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-17980041:ctest-vn-35681442:ctest-vn-35681442
2025-11-01 07:42:33,687 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-17980041:ctest-vn-64485066:ctest-vn-64485066
2025-11-01 07:42:33,695 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-17980041:ctest-vn-64485066:ctest-vn-64485066
2025-11-01 07:42:33,703 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-17980041:ctest-vn-64485066:ctest-vn-64485066
2025-11-01 07:42:34,311 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VnListReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-17980041:ctest-vn-64485066
2025-11-01 07:42:34,319 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-17980041:ctest-vn-64485066:ctest-vn-64485066
2025-11-01 07:42:34,324 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-17980041:ctest-vn-64485066:ctest-vn-64485066
2025-11-01 07:42:34,686 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VnListReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-17980041:ctest-vn-35681442
2025-11-01 07:42:34,696 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-17980041:ctest-vn-35681442:ctest-vn-35681442
2025-11-01 07:42:34,702 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-17980041:ctest-vn-35681442:ctest-vn-35681442
2025-11-01 07:42:34,995 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_AgentXmppConnectionStatusReq?
2025-11-01 07:42:39,182 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_AgentXmppConnectionStatusReq?
2025-11-01 07:42:39,502 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_AgentXmppConnectionStatusReq?
2025-11-01 07:42:42,646 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyNegativeIpv4v6-07860357:ctest-vn4-34213987:ctest-vn4-34213987
2025-11-01 07:42:42,653 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyNegativeIpv4v6-07860357:ctest-vn4-34213987:ctest-vn4-34213987
2025-11-01 07:42:42,660 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyNegativeIpv4v6-07860357:ctest-vn4-34213987:ctest-vn4-34213987
2025-11-01 07:42:43,120 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VnListReq?name=default-domain:ctest-TestBasicPolicyNegativeIpv4v6-07860357:ctest-vn4-34213987
2025-11-01 07:42:43,128 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyNegativeIpv4v6-07860357:ctest-vn4-34213987:ctest-vn4-34213987
2025-11-01 07:42:43,135 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyNegativeIpv4v6-07860357:ctest-vn4-34213987:ctest-vn4-34213987
2025-11-01 07:42:43,643 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_AgentXmppConnectionStatusReq?
2025-11-01 07:42:43,954 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_AgentXmppConnectionStatusReq?
2025-11-01 07:42:47,838 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_AgentXmppConnectionStatusReq?
2025-11-01 07:42:51,870 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicy-69653770:ctest-vn-29357249:ctest-vn-29357249
2025-11-01 07:42:51,886 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicy-69653770:ctest-vn-29357249:ctest-vn-29357249
2025-11-01 07:42:51,899 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicy-69653770:ctest-vn-29357249:ctest-vn-29357249
2025-11-01 07:42:52,337 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicy-69653770:ctest-vn-55483853:ctest-vn-55483853
2025-11-01 07:42:52,346 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicy-69653770:ctest-vn-55483853:ctest-vn-55483853
2025-11-01 07:42:52,352 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicy-69653770:ctest-vn-55483853:ctest-vn-55483853
2025-11-01 07:43:00,584 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:77ecab53-97be-4f3f-bf9a-d3884e0093e3
2025-11-01 07:43:00,592 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicy-69653770:ctest-vn-29357249:ctest-vn-29357249
2025-11-01 07:43:00,599 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:77ecab53-97be-4f3f-bf9a-d3884e0093e3
2025-11-01 07:43:06,663 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:5a1fbcf5-111c-4376-8966-e931a623c251
2025-11-01 07:43:06,671 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicy-69653770:ctest-vn-55483853:ctest-vn-55483853
2025-11-01 07:43:06,678 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:5a1fbcf5-111c-4376-8966-e931a623c251
2025-11-01 07:43:24,361 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VnListReq?name=default-domain:ctest-TestBasicPolicy-69653770:ctest-vn-55483853
2025-11-01 07:43:24,369 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicy-69653770:ctest-vn-55483853:ctest-vn-55483853
2025-11-01 07:43:24,378 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicy-69653770:ctest-vn-55483853:ctest-vn-55483853
2025-11-01 07:43:24,762 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VnListReq?name=default-domain:ctest-TestBasicPolicy-69653770:ctest-vn-29357249
2025-11-01 07:43:24,768 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicy-69653770:ctest-vn-29357249:ctest-vn-29357249
2025-11-01 07:43:24,774 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicy-69653770:ctest-vn-29357249:ctest-vn-29357249
2025-11-01 07:43:25,058 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_AgentXmppConnectionStatusReq?
2025-11-01 07:43:29,207 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_AgentXmppConnectionStatusReq?
2025-11-01 07:43:39,888 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:7d54a5bd-62d4-494e-92f7-287e43534f4f
2025-11-01 07:43:39,895 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestRP-52064065:ctest-bgpaas_vn-58529891:ctest-bgpaas_vn-58529891
2025-11-01 07:43:39,901 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:7d54a5bd-62d4-494e-92f7-287e43534f4f
2025-11-01 07:43:51,209 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:08f4ff6e-16ad-464a-8436-a64449318a9d
2025-11-01 07:43:51,219 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestRP-52064065:ctest-bgpaas_vn-85871942:ctest-bgpaas_vn-85871942
2025-11-01 07:43:51,226 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:08f4ff6e-16ad-464a-8436-a64449318a9d
2025-11-01 07:43:53,007 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_AgentXmppConnectionStatusReq?
2025-11-01 07:43:59,929 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_AgentXmppConnectionStatusReq?
2025-11-01 07:44:03,882 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_AgentXmppConnectionStatusReq?
2025-11-01 07:44:06,267 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-81950760:ctest-mgmt_vn-06074740:ctest-mgmt_vn-06074740
2025-11-01 07:44:06,277 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-81950760:ctest-mgmt_vn-06074740:ctest-mgmt_vn-06074740
2025-11-01 07:44:06,285 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-81950760:ctest-mgmt_vn-06074740:ctest-mgmt_vn-06074740
2025-11-01 07:44:07,318 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-81950760:ctest-left_vn-51033290:ctest-left_vn-51033290
2025-11-01 07:44:07,326 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-81950760:ctest-left_vn-51033290:ctest-left_vn-51033290
2025-11-01 07:44:07,333 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-81950760:ctest-left_vn-51033290:ctest-left_vn-51033290
2025-11-01 07:44:08,321 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-81950760:ctest-right_vn-08649744:ctest-right_vn-08649744
2025-11-01 07:44:08,330 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-81950760:ctest-right_vn-08649744:ctest-right_vn-08649744
2025-11-01 07:44:08,336 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-81950760:ctest-right_vn-08649744:ctest-right_vn-08649744
2025-11-01 07:44:19,376 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:102ce969-bf9f-4712-b511-d74f4d9b4f16
2025-11-01 07:44:19,385 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-81950760:ctest-mgmt_vn-06074740:ctest-mgmt_vn-06074740
2025-11-01 07:44:19,393 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:1191ce0c-6a54-43d7-ab98-7acc5d441e3e
2025-11-01 07:44:19,400 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-81950760:ctest-left_vn-51033290:ctest-left_vn-51033290
2025-11-01 07:44:19,413 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:1052bf51-fb72-4143-b437-11a667af92af
2025-11-01 07:44:19,421 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-81950760:ctest-right_vn-08649744:ctest-right_vn-08649744
2025-11-01 07:44:19,428 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:102ce969-bf9f-4712-b511-d74f4d9b4f16
2025-11-01 07:44:19,434 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:1052bf51-fb72-4143-b437-11a667af92af
2025-11-01 07:44:19,440 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:1191ce0c-6a54-43d7-ab98-7acc5d441e3e
2025-11-01 07:45:10,832 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:cd3e11fb-cd4c-4876-97a7-984d837635b2
2025-11-01 07:45:10,837 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-81950760:ctest-left_vn-51033290:ctest-left_vn-51033290
2025-11-01 07:45:10,842 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:cd3e11fb-cd4c-4876-97a7-984d837635b2
2025-11-01 07:45:12,724 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:74976592-c962-4150-a531-47a571093944
2025-11-01 07:45:12,730 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-81950760:ctest-right_vn-08649744:ctest-right_vn-08649744
2025-11-01 07:45:12,736 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:74976592-c962-4150-a531-47a571093944
2025-11-01 07:45:17,753 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:102ce969-bf9f-4712-b511-d74f4d9b4f16
2025-11-01 07:45:17,760 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:1052bf51-fb72-4143-b437-11a667af92af
2025-11-01 07:45:17,766 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:1191ce0c-6a54-43d7-ab98-7acc5d441e3e
2025-11-01 07:45:19,046 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VnListReq?name=default-domain:ctest-TestSvcRegr-81950760:ctest-left_vn-51033290
2025-11-01 07:45:19,057 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:1191ce0c-6a54-43d7-ab98-7acc5d441e3e
2025-11-01 07:45:19,070 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,
2025-11-01 07:45:19,091 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-81950760:ctest-left_vn-51033290:ctest-left_vn-51033290
2025-11-01 07:45:19,264 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_Inet4UcRouteReq?x=2
2025-11-01 07:45:19,499 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_Layer2RouteReq?x=2
2025-11-01 07:45:19,516 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VnListReq?name=default-domain:ctest-TestSvcRegr-81950760:ctest-left_vn-51033290
2025-11-01 07:45:19,527 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-81950760:ctest-left_vn-51033290:ctest-left_vn-51033290
2025-11-01 07:45:19,747 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_Inet4UcRouteReq?x=2
2025-11-01 07:45:19,979 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_Layer2RouteReq?x=2
2025-11-01 07:45:20,003 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VnListReq?name=default-domain:ctest-TestSvcRegr-81950760:ctest-mgmt_vn-06074740
2025-11-01 07:45:20,011 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:102ce969-bf9f-4712-b511-d74f4d9b4f16
2025-11-01 07:45:20,018 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,
2025-11-01 07:45:20,032 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-81950760:ctest-mgmt_vn-06074740:ctest-mgmt_vn-06074740
2025-11-01 07:45:20,195 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_Inet4UcRouteReq?x=4
2025-11-01 07:45:20,411 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_Layer2RouteReq?x=4
2025-11-01 07:45:20,433 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VnListReq?name=default-domain:ctest-TestSvcRegr-81950760:ctest-mgmt_vn-06074740
2025-11-01 07:45:20,443 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-81950760:ctest-mgmt_vn-06074740:ctest-mgmt_vn-06074740
2025-11-01 07:45:20,611 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_Inet4UcRouteReq?x=4
2025-11-01 07:45:20,827 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_Layer2RouteReq?x=4
2025-11-01 07:45:20,840 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VnListReq?name=default-domain:ctest-TestSvcRegr-81950760:ctest-right_vn-08649744
2025-11-01 07:45:20,847 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:1052bf51-fb72-4143-b437-11a667af92af
2025-11-01 07:45:20,854 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,
2025-11-01 07:45:20,865 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-81950760:ctest-right_vn-08649744:ctest-right_vn-08649744
2025-11-01 07:45:21,031 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_Inet4UcRouteReq?x=3
2025-11-01 07:45:21,268 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_Layer2RouteReq?x=3
2025-11-01 07:45:21,290 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VnListReq?name=default-domain:ctest-TestSvcRegr-81950760:ctest-right_vn-08649744
2025-11-01 07:45:21,301 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-81950760:ctest-right_vn-08649744:ctest-right_vn-08649744
2025-11-01 07:45:21,480 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_Inet4UcRouteReq?x=3
2025-11-01 07:45:21,724 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_Layer2RouteReq?x=3
2025-11-01 07:45:22,375 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=
2025-11-01 07:45:22,386 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_Inet4UcRouteReq?x=5
2025-11-01 07:45:22,400 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:1191ce0c-6a54-43d7-ab98-7acc5d441e3e
2025-11-01 07:45:22,572 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=
2025-11-01 07:45:22,583 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_Inet4UcRouteReq?x=6
2025-11-01 07:45:22,598 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:1052bf51-fb72-4143-b437-11a667af92af
2025-11-01 07:45:30,492 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VnListReq?name=default-domain:ctest-TestSvcRegr-81950760:ctest-right_vn-08649744
2025-11-01 07:45:30,500 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-81950760:ctest-right_vn-08649744:ctest-right_vn-08649744
2025-11-01 07:45:30,509 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-81950760:ctest-right_vn-08649744:ctest-right_vn-08649744
2025-11-01 07:45:30,836 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VnListReq?name=default-domain:ctest-TestSvcRegr-81950760:ctest-left_vn-51033290
2025-11-01 07:45:30,843 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-81950760:ctest-left_vn-51033290:ctest-left_vn-51033290
2025-11-01 07:45:30,850 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-81950760:ctest-left_vn-51033290:ctest-left_vn-51033290
2025-11-01 07:45:31,159 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VnListReq?name=default-domain:ctest-TestSvcRegr-81950760:ctest-mgmt_vn-06074740
2025-11-01 07:45:31,165 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-81950760:ctest-mgmt_vn-06074740:ctest-mgmt_vn-06074740
2025-11-01 07:45:31,172 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-81950760:ctest-mgmt_vn-06074740:ctest-mgmt_vn-06074740
2025-11-01 07:45:31,467 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_AgentXmppConnectionStatusReq?
2025-11-01 07:45:35,706 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_AgentXmppConnectionStatusReq?
2025-11-01 07:45:45,183 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:ec3c02ad-edf1-4c31-94c7-e70d61c3b3bb
2025-11-01 07:45:45,200 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestvDNSBasic0-67461594:ctest-vn1-vdns-56068657:ctest-vn1-vdns-56068657
2025-11-01 07:45:45,211 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:ec3c02ad-edf1-4c31-94c7-e70d61c3b3bb
2025-11-01 07:46:02,626 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_DnsInfo?
2025-11-01 07:46:09,506 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:a447f4c6-8807-44ec-bbe8-5b09561bf882
2025-11-01 07:46:09,518 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestvDNSBasic0-67461594:ctest-vn1-vdns-56068657:ctest-vn1-vdns-56068657
2025-11-01 07:46:09,528 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:a447f4c6-8807-44ec-bbe8-5b09561bf882
2025-11-01 07:46:21,728 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_DnsInfo?
2025-11-01 07:46:33,402 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_AgentXmppConnectionStatusReq?
2025-11-01 07:46:37,447 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_AgentXmppConnectionStatusReq?
2025-11-01 07:46:46,972 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:0d0f7e67-d7f6-44f6-9526-ab014a888bfa
2025-11-01 07:46:46,979 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicVMVNx-46753425:ctest-vn-00244862:ctest-vn-00244862
2025-11-01 07:46:46,984 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:0d0f7e67-d7f6-44f6-9526-ab014a888bfa
2025-11-01 07:46:58,222 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:381086eb-0003-4e66-8ecd-f986552b9f8d
2025-11-01 07:46:58,230 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicVMVNx-46753425:ctest-vn-00244862:ctest-vn-00244862
2025-11-01 07:46:58,237 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:381086eb-0003-4e66-8ecd-f986552b9f8d
2025-11-01 07:47:07,543 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_AgentXmppConnectionStatusReq?
2025-11-01 07:47:11,670 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_AgentXmppConnectionStatusReq?
2025-11-01 07:47:19,516 - DEBUG - [10.0.0.38]: Running cmd : docker exec  --privileged  -it vrouter_vrouter-agent_1 /bin/bash -c  'echo "10.20.0.17 cn-jenkins-deploy-platform-ansible-os-4586-1-test" >> /etc/hosts'
2025-11-01 07:47:19,653 - DEBUG - Output : 
2025-11-01 07:47:20,277 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:37e8fe91-122a-4049-9637-6d58d154331c
2025-11-01 07:47:20,288 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicVMVN-17886024:ctest-vn2_metadata-45137187:ctest-vn2_metadata-45137187
2025-11-01 07:47:20,300 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:37e8fe91-122a-4049-9637-6d58d154331c
2025-11-01 07:47:30,051 - DEBUG - [10.0.0.38]: Running cmd : docker exec  --privileged  -it vrouter_vrouter-agent_1 /bin/bash -c  'sed -i '$ d' /etc/hosts'
2025-11-01 07:47:30,277 - DEBUG - Output : sed: -e expression #1, char 1: missing command
2025-11-01 07:47:33,006 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_AgentXmppConnectionStatusReq?
2025-11-01 07:47:33,326 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_AgentXmppConnectionStatusReq?
2025-11-01 07:47:40,556 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:f9f2eb02-36cb-4794-9b22-f234f4451775
2025-11-01 07:47:40,564 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicVMVN-17886024:ctest-vn-77228066:ctest-vn-77228066
2025-11-01 07:47:40,571 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:f9f2eb02-36cb-4794-9b22-f234f4451775
2025-11-01 07:47:54,947 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_AgentXmppConnectionStatusReq?
2025-11-01 07:47:55,270 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_AgentXmppConnectionStatusReq?
2025-11-01 07:48:01,003 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicVMVN-17886024:ctest-vn-47567871:ctest-vn-47567871
2025-11-01 07:48:01,391 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:511c16fe-120e-4d4a-bb3e-ebf466f70687
2025-11-01 07:48:01,397 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicVMVN-17886024:ctest-vn-47567871:ctest-vn-47567871
2025-11-01 07:48:01,403 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:511c16fe-120e-4d4a-bb3e-ebf466f70687
2025-11-01 07:48:16,816 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:ae7aa38d-e89a-45ef-bc2a-7133ad7382c8
2025-11-01 07:48:16,831 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicVMVN-17886024:ctest-vn-47567871:ctest-vn-47567871
2025-11-01 07:48:16,848 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:ae7aa38d-e89a-45ef-bc2a-7133ad7382c8
2025-11-01 07:48:18,860 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:ed9b5fe3-fa79-488f-9537-81847278cb31
2025-11-01 07:48:18,871 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicVMVN-17886024:ctest-vn-47567871:ctest-vn-47567871
2025-11-01 07:48:18,879 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:ed9b5fe3-fa79-488f-9537-81847278cb31
2025-11-01 07:48:38,350 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VnListReq?name=default-domain:ctest-TestBasicVMVN-17886024:ctest-vn-47567871
2025-11-01 07:48:38,358 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicVMVN-17886024:ctest-vn-47567871:ctest-vn-47567871
2025-11-01 07:48:38,366 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_VrfListReq?name=
2025-11-01 07:48:38,372 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_KRouteReq?x=2
2025-11-01 07:48:38,379 - DEBUG - Unable to fetch route details in vrouter for  vrf index 2, Got :[]
2025-11-01 07:48:38,762 - DEBUG - Requesting: http://10.0.0.38:8085/Snh_AgentXmppConnectionStatusReq?
2025-11-01 07:50:59,717 - INFO - Using existing project ['default-domain', 'admin'](78b6db8c-ca7b-4564-8d17-8895330cb422)
2025-11-01 07:50:59,729 - INFO - ================================================================================
2025-11-01 07:50:59,729 - INFO - STARTING TEST    : test_contrail_status
2025-11-01 07:50:59,729 - INFO - TEST DESCRIPTION :  Test to verify that all services are running and active
        
2025-11-01 07:50:59,875 - DEBUG - Skipping xmpp flap check
2025-11-01 07:50:59,875 - INFO - Initial checks done. Running the testcase now
2025-11-01 07:50:59,876 - INFO - 
2025-11-01 07:50:59,976 - INFO - 10.0.0.38
2025-11-01 07:50:59,976 - INFO -   config
2025-11-01 07:50:59,985 - INFO -     config-nodemgr:active
2025-11-01 07:50:59,991 - INFO -     api-server:active
2025-11-01 07:50:59,996 - INFO -     schema:active
2025-11-01 07:51:00,002 - INFO -     svc-monitor:active
2025-11-01 07:51:00,007 - INFO -     device-manager:active
2025-11-01 07:51:00,007 - INFO -   config-database
2025-11-01 07:51:00,007 - INFO -     config-cassandra:active
2025-11-01 07:51:00,007 - INFO -     config-zookeeper:active
2025-11-01 07:51:00,007 - INFO -     config-rabbitmq:active
2025-11-01 07:51:00,007 - INFO -   vrouter
2025-11-01 07:51:00,013 - INFO -     vrouter-nodemgr:active
2025-11-01 07:51:00,019 - INFO -     agent:active
2025-11-01 07:51:00,019 - INFO -   control
2025-11-01 07:51:00,025 - INFO -     control-nodemgr:active
2025-11-01 07:51:00,032 - INFO -     control:active
2025-11-01 07:51:00,032 - INFO -     named:active
2025-11-01 07:51:00,038 - INFO -     dns:active
2025-11-01 07:51:00,039 - INFO -   analytics
2025-11-01 07:51:00,044 - INFO -     analytics-nodemgr:active
2025-11-01 07:51:00,048 - INFO -     analytics-api:active
2025-11-01 07:51:00,055 - INFO -     collector:active
2025-11-01 07:51:00,055 - INFO -   analytics-database
2025-11-01 07:51:00,055 - INFO -     analytics-cassandra:active
2025-11-01 07:51:00,061 - INFO -     analyticsdb-nodemgr:active
2025-11-01 07:51:00,067 - INFO -     query-engine:active
2025-11-01 07:51:00,067 - INFO -   webui
2025-11-01 07:51:00,067 - INFO -     webui:active
2025-11-01 07:51:00,067 - INFO -     webui-middleware:active
2025-11-01 07:51:00,067 - INFO -     redis:active
2025-11-01 07:51:00,067 - INFO -   analytics_snmp
2025-11-01 07:51:00,072 - INFO -     snmp-collector:active
2025-11-01 07:51:00,072 - INFO -     snmp-topology:active
2025-11-01 07:51:00,072 - INFO -   analytics_alarm
2025-11-01 07:51:00,072 - INFO -     alarmgen:active
2025-11-01 07:51:00,072 - INFO - All the contrail services are up on all nodes
2025-11-01 07:51:00,072 - INFO - contrail-status passed
2025-11-01 07:51:00,207 - DEBUG - Skipping xmpp flap check
2025-11-01 07:51:00,208 - INFO - END TEST : test_contrail_status : PASSED[0:00:01]
2025-11-01 07:51:00,208 - INFO - --------------------------------------------------------------------------------