2025-10-31 08:58:16,603 - DEBUG - [10.0.0.254]: Running cmd : hostname
2025-10-31 08:58:16,839 - DEBUG - Output : cn-jenkins-deploy-platform-ansible-os-4573-1
2025-10-31 08:58:16,840 - DEBUG - [10.0.0.254]: Running cmd : hostname -f
2025-10-31 08:58:16,911 - DEBUG - Output : cn-jenkins-deploy-platform-ansible-os-4573-1.
2025-10-31 08:58:16,911 - DEBUG - [10.0.0.254]: 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-31 08:58:17,013 - DEBUG - Output : NAMES
contrail_test_FU3D8aJ8G
vrouter_vrouter-agent_1
vrouter_nodemgr_1
rsyslogd_rsyslogd_1
analytics_snmp_topology_1
analytics_snmp_nodemgr_1
analytics_snmp_snmp-collector_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_nodemgr_1
control_dns_1
control_control_1
webui_job_1
webui_web_1
config_devicemgr_1
config_nodemgr_1
config_dnsmasq_1
config_svcmonitor_1
config_schema_1
config_api_1
config_database_rabbitmq_1
config_database_nodemgr_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-10-31 08:58:17,014 - DEBUG - [10.0.0.254]: Running cmd : getent hosts 10.0.0.254 | head -n 1 | awk '{print $2}'
2025-10-31 08:58:17,091 - DEBUG - Output : cn-jenkins-deploy-platform-ansible-os-4573-1.
2025-10-31 08:58:17,091 - DEBUG - [10.0.0.254]: Running cmd : ip -4 -o addr show | awk '{print $4}'
2025-10-31 08:58:17,147 - DEBUG - Output : 127.0.0.1/8
10.0.0.254/24
172.17.0.1/16
10.20.0.14/24
2025-10-31 08:58:17,148 - DEBUG - [10.0.0.254]: Running cmd : ip -4 -o addr show dev vhost0 | awk '{print $4}'
2025-10-31 08:58:17,217 - DEBUG - Output : 10.20.0.14/24
2025-10-31 08:58:17,217 - DEBUG - [10.0.0.254]: Running cmd : getent hosts 10.20.0.14 | head -n 1 | awk '{print $2}'
2025-10-31 08:58:17,290 - DEBUG - Output :
2025-10-31 08:58:19,112 - INFO - Using existing project ['default-domain', 'admin'](e1bdc373-0bc5-406c-822c-7dea05b38f42)
2025-10-31 08:58:19,277 - INFO - ================================================================================
2025-10-31 08:58:19,277 - INFO - STARTING TEST : test_contrail_status
2025-10-31 08:58:19,278 - INFO - TEST DESCRIPTION : Test to verify that all services are running and active
2025-10-31 08:58:19,416 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 08:58:19,423 - DEBUG - Nothing to compare xmpp stats {'10.0.0.254': {'10.20.0.14': '0'}} with
2025-10-31 08:58:19,423 - INFO - Initial checks done. Running the testcase now
2025-10-31 08:58:19,423 - INFO -
2025-10-31 08:58:19,424 - DEBUG - [10.0.0.254]: Running cmd : docker ps -f status=running --format {{.Names}} 2>/dev/null
2025-10-31 08:58:19,514 - DEBUG - Output : contrail_test_FU3D8aJ8G
vrouter_vrouter-agent_1
vrouter_provisioner_1
vrouter_nodemgr_1
rsyslogd_rsyslogd_1
analytics_snmp_topology_1
analytics_snmp_nodemgr_1
analytics_snmp_snmp-collector_1
analytics_snmp_provisioner_1
analytics_alarm_nodemgr_1
analytics_alarm_alarm-gen_1
analytics_alarm_provisioner_1
analytics_alarm_kafka_1
analytics_provisioner_1
analytics_nodemgr_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_provisioner_1
control_nodemgr_1
control_dns_1
control_control_1
webui_job_1
webui_web_1
config_devicemgr_1
config_nodemgr_1
config_provisioner_1
config_dnsmasq_1
config_svcmonitor_1
config_schema_1
config_api_1
config_database_provisioner_1
config_database_rabbitmq_1
config_database_nodemgr_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-10-31 08:58:19,514 - INFO - 10.0.0.254
2025-10-31 08:58:19,514 - INFO - config
2025-10-31 08:58:19,521 - INFO - config-nodemgr:active
2025-10-31 08:58:19,526 - INFO - api-server:active
2025-10-31 08:58:19,531 - INFO - schema:active
2025-10-31 08:58:19,535 - INFO - svc-monitor:active
2025-10-31 08:58:19,539 - INFO - device-manager:active
2025-10-31 08:58:19,540 - INFO - config-database
2025-10-31 08:58:19,540 - INFO - config-cassandra:active
2025-10-31 08:58:19,540 - INFO - config-zookeeper:active
2025-10-31 08:58:19,540 - INFO - config-rabbitmq:active
2025-10-31 08:58:19,540 - INFO - vrouter
2025-10-31 08:58:19,545 - INFO - vrouter-nodemgr:active
2025-10-31 08:58:19,550 - INFO - agent:active
2025-10-31 08:58:19,550 - INFO - control
2025-10-31 08:58:19,554 - INFO - control-nodemgr:active
2025-10-31 08:58:19,563 - INFO - control:active
2025-10-31 08:58:19,563 - INFO - named:active
2025-10-31 08:58:19,569 - INFO - dns:active
2025-10-31 08:58:19,570 - INFO - analytics
2025-10-31 08:58:19,576 - INFO - analytics-nodemgr:active
2025-10-31 08:58:19,581 - INFO - analytics-api:active
2025-10-31 08:58:19,586 - INFO - collector:active
2025-10-31 08:58:19,586 - INFO - analytics-database
2025-10-31 08:58:19,586 - INFO - analytics-cassandra:active
2025-10-31 08:58:19,592 - INFO - analyticsdb-nodemgr:active
2025-10-31 08:58:19,598 - INFO - query-engine:active
2025-10-31 08:58:19,598 - INFO - webui
2025-10-31 08:58:19,598 - INFO - webui:active
2025-10-31 08:58:19,598 - INFO - webui-middleware:active
2025-10-31 08:58:19,598 - INFO - redis:active
2025-10-31 08:58:19,598 - INFO - analytics_snmp
2025-10-31 08:58:19,602 - INFO - snmp-collector:active
2025-10-31 08:58:19,602 - INFO - snmp-topology:active
2025-10-31 08:58:19,602 - INFO - analytics_alarm
2025-10-31 08:58:19,602 - INFO - alarmgen:active
2025-10-31 08:58:19,602 - INFO - All the contrail services are up on all nodes
2025-10-31 08:58:19,603 - INFO - contrail-status passed
2025-10-31 08:58:19,736 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 08:58:19,741 - DEBUG - No XMPP flaps were noticed during the test
2025-10-31 08:58:19,741 - INFO - END TEST : test_contrail_status : PASSED[0:00:00]
2025-10-31 08:58:19,742 - INFO - --------------------------------------------------------------------------------
2025-10-31 08:58:22,333 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 08:58:24,774 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-AnalyticsBasicTestSanity-06314619:ctest-vn22-24311076:ctest-vn22-24311076
2025-10-31 08:58:24,782 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-AnalyticsBasicTestSanity-06314619:ctest-vn22-24311076:ctest-vn22-24311076
2025-10-31 08:58:24,789 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-AnalyticsBasicTestSanity-06314619:ctest-vn22-24311076:ctest-vn22-24311076
2025-10-31 08:58:46,682 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VnListReq?name=default-domain:ctest-AnalyticsBasicTestSanity-06314619:ctest-vn22-24311076
2025-10-31 08:58:46,691 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-AnalyticsBasicTestSanity-06314619:ctest-vn22-24311076:ctest-vn22-24311076
2025-10-31 08:58:46,696 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-AnalyticsBasicTestSanity-06314619:ctest-vn22-24311076:ctest-vn22-24311076
2025-10-31 08:58:46,848 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 08:58:47,971 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 08:58:47,978 - DEBUG - [10.0.0.254]: Running cmd : docker exec --privileged -it config_api_1 /bin/bash -c 'db-manage check'
2025-10-31 08:58:51,962 - DEBUG - Output : 2025-10-31 08:58:50,952 INFO: (v1.41) Checker check_zk_mode_and_node_count: Success
2025-10-31 08:58:50,998 INFO: (v1.41) Checker check_cassandra_keyspace_replication: Success
2025-10-31 08:58:51,101 INFO: (v1.41) Checker check_obj_mandatory_fields: Success
2025-10-31 08:58:51,305 INFO: (v1.41) Checker check_orphan_resources: Success
2025-10-31 08:58:51,537 INFO: (v1.41) Checker check_fq_name_uuid_match: Success
2025-10-31 08:58:51,538 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-10-31 08:58:51,721 INFO: (v1.41) Checker check_duplicate_fq_name: Success
2025-10-31 08:58:51,733 INFO: (v1.41) Checker check_route_targets_routing_instance_backrefs: Success
2025-10-31 08:58:51,739 INFO: (v1.41) Checker check_subnet_uuid: Success
2025-10-31 08:58:51,749 ERROR: (v1.41) Checker check_subnet_addr_alloc: Failed:
ZK subnet path '/api-server/subnets' does ends with a valid IP network
2025-10-31 08:58:51,790 INFO: (v1.41) Checker check_route_targets_id: Success
2025-10-31 08:58:51,813 INFO: (v1.41) Checker check_virtual_networks_id: Success
2025-10-31 08:58:51,823 INFO: (v1.41) Checker check_security_groups_id: Success
2025-10-31 08:58:51,827 INFO: (v1.41) Checker check_ipam_subnet_method: Success
2025-10-31 08:58:51,830 INFO: (v1.41) Checker check_aggregated_ethernet_id: Success
2025-10-31 08:58:52,148 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 08:58:52,361 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 08:58:52,522 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 08:58:52,708 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 08:58:52,862 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 08:58:55,719 - INFO - admin user already present
2025-10-31 08:58:56,617 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 08:58:58,735 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-FloatingipBasicTestSanity-13495592:ctest-fvn-74822639:ctest-fvn-74822639
2025-10-31 08:58:58,740 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-FloatingipBasicTestSanity-13495592:ctest-fvn-74822639:ctest-fvn-74822639
2025-10-31 08:58:58,746 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-FloatingipBasicTestSanity-13495592:ctest-fvn-74822639:ctest-fvn-74822639
2025-10-31 08:58:59,744 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-FloatingipBasicTestSanity-13495592:ctest-vn1-40034805:ctest-vn1-40034805
2025-10-31 08:58:59,749 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-FloatingipBasicTestSanity-13495592:ctest-vn1-40034805:ctest-vn1-40034805
2025-10-31 08:58:59,755 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-FloatingipBasicTestSanity-13495592:ctest-vn1-40034805:ctest-vn1-40034805
2025-10-31 08:59:08,858 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:a81d4f1d-c518-4a6c-80eb-4ce1855f2fdc
2025-10-31 08:59:08,864 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-FloatingipBasicTestSanity-13495592:ctest-vn1-40034805:ctest-vn1-40034805
2025-10-31 08:59:08,871 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:a81d4f1d-c518-4a6c-80eb-4ce1855f2fdc
2025-10-31 08:59:14,842 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:ad9f6d06-03a0-44af-ad07-93cc76db9d76
2025-10-31 08:59:14,847 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-FloatingipBasicTestSanity-13495592:ctest-fvn-74822639:ctest-fvn-74822639
2025-10-31 08:59:14,852 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:ad9f6d06-03a0-44af-ad07-93cc76db9d76
2025-10-31 08:59:16,395 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:a81d4f1d-c518-4a6c-80eb-4ce1855f2fdc
2025-10-31 08:59:16,400 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VnListReq?name=default-domain:ctest-FloatingipBasicTestSanity-13495592:ctest-fvn-74822639
2025-10-31 08:59:16,406 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-FloatingipBasicTestSanity-13495592:ctest-fvn-74822639:ctest-fvn-74822639
2025-10-31 08:59:16,411 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_Inet4UcRouteReq?x=3
2025-10-31 08:59:22,230 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VnListReq?name=default-domain:ctest-FloatingipBasicTestSanity-13495592:ctest-vn1-40034805
2025-10-31 08:59:22,235 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-FloatingipBasicTestSanity-13495592:ctest-vn1-40034805:ctest-vn1-40034805
2025-10-31 08:59:22,241 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-FloatingipBasicTestSanity-13495592:ctest-vn1-40034805:ctest-vn1-40034805
2025-10-31 08:59:22,532 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VnListReq?name=default-domain:ctest-FloatingipBasicTestSanity-13495592:ctest-fvn-74822639
2025-10-31 08:59:22,537 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-FloatingipBasicTestSanity-13495592:ctest-fvn-74822639:ctest-fvn-74822639
2025-10-31 08:59:22,542 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-FloatingipBasicTestSanity-13495592:ctest-fvn-74822639:ctest-fvn-74822639
2025-10-31 08:59:22,812 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 08:59:26,378 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 08:59:26,810 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 08:59:33,912 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 08:59:36,468 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 08:59:39,851 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 08:59:42,003 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 08:59:42,288 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 08:59:49,709 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:bf9d0247-20eb-4900-af18-12a4c39fc6bd
2025-10-31 08:59:49,717 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestPorts-57035401:ctest-vn1-12178917:ctest-vn1-12178917
2025-10-31 08:59:49,726 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:bf9d0247-20eb-4900-af18-12a4c39fc6bd
2025-10-31 08:59:57,717 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:fc1bfe8d-f0b4-4486-ba3a-563fbe1d2e1b
2025-10-31 08:59:57,724 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestPorts-57035401:ctest-vn1-12178917:ctest-vn1-12178917
2025-10-31 08:59:57,729 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:fc1bfe8d-f0b4-4486-ba3a-563fbe1d2e1b
2025-10-31 09:00:03,096 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 09:00:06,721 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 09:00:17,225 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:4ee08027-ccab-4c9c-bc79-d3d85c429359
2025-10-31 09:00:17,233 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestRouters-97803413:ctest-vn1-62963184:ctest-vn1-62963184
2025-10-31 09:00:17,239 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:4ee08027-ccab-4c9c-bc79-d3d85c429359
2025-10-31 09:00:23,271 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:f1da7a1e-f8f4-4c58-af95-e4f8663f5f9f
2025-10-31 09:00:23,281 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestRouters-97803413:ctest-vn2-74823579:ctest-vn2-74823579
2025-10-31 09:00:23,289 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:f1da7a1e-f8f4-4c58-af95-e4f8663f5f9f
2025-10-31 09:00:50,863 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 09:00:54,297 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 09:01:05,535 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:1fc681d6-0811-4156-b2c1-68c3a8a6c6e9
2025-10-31 09:01:05,541 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestRoutersBasic-97430203:ctest-vn-86586040:ctest-vn-86586040
2025-10-31 09:01:05,547 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:1fc681d6-0811-4156-b2c1-68c3a8a6c6e9
2025-10-31 09:01:11,479 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:cb9bbcc0-4848-4e21-8ffa-11cb8108496f
2025-10-31 09:01:11,486 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestRoutersBasic-97430203:ctest-ext_vn-67950419:ctest-ext_vn-67950419
2025-10-31 09:01:11,493 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:cb9bbcc0-4848-4e21-8ffa-11cb8108496f
2025-10-31 09:01:19,707 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 09:01:23,211 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 09:01:27,221 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-12805350:ctest-vn-53826189:ctest-vn-53826189
2025-10-31 09:01:27,228 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-12805350:ctest-vn-53826189:ctest-vn-53826189
2025-10-31 09:01:27,233 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-12805350:ctest-vn-53826189:ctest-vn-53826189
2025-10-31 09:01:27,596 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-12805350:ctest-vn-83461369:ctest-vn-83461369
2025-10-31 09:01:27,602 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-12805350:ctest-vn-83461369:ctest-vn-83461369
2025-10-31 09:01:27,609 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-12805350:ctest-vn-83461369:ctest-vn-83461369
2025-10-31 09:01:28,220 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VnListReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-12805350:ctest-vn-83461369
2025-10-31 09:01:28,227 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-12805350:ctest-vn-83461369:ctest-vn-83461369
2025-10-31 09:01:28,233 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-12805350:ctest-vn-83461369:ctest-vn-83461369
2025-10-31 09:01:28,516 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VnListReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-12805350:ctest-vn-53826189
2025-10-31 09:01:28,521 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-12805350:ctest-vn-53826189:ctest-vn-53826189
2025-10-31 09:01:28,526 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-12805350:ctest-vn-53826189:ctest-vn-53826189
2025-10-31 09:01:28,799 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 09:01:32,268 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 09:01:32,559 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 09:01:35,458 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyNegativeIpv4v6-87879139:ctest-vn4-57217328:ctest-vn4-57217328
2025-10-31 09:01:35,464 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyNegativeIpv4v6-87879139:ctest-vn4-57217328:ctest-vn4-57217328
2025-10-31 09:01:35,469 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyNegativeIpv4v6-87879139:ctest-vn4-57217328:ctest-vn4-57217328
2025-10-31 09:01:35,896 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VnListReq?name=default-domain:ctest-TestBasicPolicyNegativeIpv4v6-87879139:ctest-vn4-57217328
2025-10-31 09:01:35,901 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyNegativeIpv4v6-87879139:ctest-vn4-57217328:ctest-vn4-57217328
2025-10-31 09:01:35,906 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyNegativeIpv4v6-87879139:ctest-vn4-57217328:ctest-vn4-57217328
2025-10-31 09:01:36,382 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 09:01:36,691 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 09:01:40,221 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 09:01:43,567 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicy-50973276:ctest-vn-37539573:ctest-vn-37539573
2025-10-31 09:01:43,572 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicy-50973276:ctest-vn-37539573:ctest-vn-37539573
2025-10-31 09:01:43,577 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicy-50973276:ctest-vn-37539573:ctest-vn-37539573
2025-10-31 09:01:43,915 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicy-50973276:ctest-vn-76523744:ctest-vn-76523744
2025-10-31 09:01:43,921 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicy-50973276:ctest-vn-76523744:ctest-vn-76523744
2025-10-31 09:01:43,926 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicy-50973276:ctest-vn-76523744:ctest-vn-76523744
2025-10-31 09:01:51,728 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:035c25bf-64a0-4a94-b880-3ce106c1b69f
2025-10-31 09:01:51,737 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicy-50973276:ctest-vn-37539573:ctest-vn-37539573
2025-10-31 09:01:51,748 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:035c25bf-64a0-4a94-b880-3ce106c1b69f
2025-10-31 09:01:57,733 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:89a4ed34-2f17-477e-9d34-7b5d86e939ce
2025-10-31 09:01:57,744 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicy-50973276:ctest-vn-76523744:ctest-vn-76523744
2025-10-31 09:01:57,751 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:89a4ed34-2f17-477e-9d34-7b5d86e939ce
2025-10-31 09:02:14,781 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VnListReq?name=default-domain:ctest-TestBasicPolicy-50973276:ctest-vn-76523744
2025-10-31 09:02:14,787 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicy-50973276:ctest-vn-76523744:ctest-vn-76523744
2025-10-31 09:02:14,792 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicy-50973276:ctest-vn-76523744:ctest-vn-76523744
2025-10-31 09:02:15,072 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VnListReq?name=default-domain:ctest-TestBasicPolicy-50973276:ctest-vn-37539573
2025-10-31 09:02:15,077 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicy-50973276:ctest-vn-37539573:ctest-vn-37539573
2025-10-31 09:02:15,083 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicy-50973276:ctest-vn-37539573:ctest-vn-37539573
2025-10-31 09:02:15,356 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 09:02:18,972 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 09:02:29,176 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:7c3835a0-664b-4296-b01c-fcebe83c6ed9
2025-10-31 09:02:29,182 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestRP-52849787:ctest-bgpaas_vn-56187804:ctest-bgpaas_vn-56187804
2025-10-31 09:02:29,188 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:7c3835a0-664b-4296-b01c-fcebe83c6ed9
2025-10-31 09:02:35,291 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:e6e8b19f-6ad5-4f1e-8a81-afbe041c4d29
2025-10-31 09:02:35,297 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestRP-52849787:ctest-bgpaas_vn-80329226:ctest-bgpaas_vn-80329226
2025-10-31 09:02:35,302 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:e6e8b19f-6ad5-4f1e-8a81-afbe041c4d29
2025-10-31 09:02:37,000 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 09:02:43,508 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 09:02:46,925 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 09:02:48,939 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-85414588:ctest-mgmt_vn-41089201:ctest-mgmt_vn-41089201
2025-10-31 09:02:48,944 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-85414588:ctest-mgmt_vn-41089201:ctest-mgmt_vn-41089201
2025-10-31 09:02:48,949 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-85414588:ctest-mgmt_vn-41089201:ctest-mgmt_vn-41089201
2025-10-31 09:02:49,838 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-85414588:ctest-left_vn-56136102:ctest-left_vn-56136102
2025-10-31 09:02:49,843 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-85414588:ctest-left_vn-56136102:ctest-left_vn-56136102
2025-10-31 09:02:49,848 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-85414588:ctest-left_vn-56136102:ctest-left_vn-56136102
2025-10-31 09:02:50,794 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-85414588:ctest-right_vn-03997901:ctest-right_vn-03997901
2025-10-31 09:02:50,800 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-85414588:ctest-right_vn-03997901:ctest-right_vn-03997901
2025-10-31 09:02:50,804 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-85414588:ctest-right_vn-03997901:ctest-right_vn-03997901
2025-10-31 09:03:01,411 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:868bc126-ce96-4c14-afce-deb9995e6072
2025-10-31 09:03:01,419 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-85414588:ctest-mgmt_vn-41089201:ctest-mgmt_vn-41089201
2025-10-31 09:03:01,426 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:b37eea91-3c7a-44cb-af81-f6b3a0c0268a
2025-10-31 09:03:01,434 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-85414588:ctest-left_vn-56136102:ctest-left_vn-56136102
2025-10-31 09:03:01,440 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:512aac4c-49b5-4b10-b8c9-110bc05f33e0
2025-10-31 09:03:01,448 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-85414588:ctest-right_vn-03997901:ctest-right_vn-03997901
2025-10-31 09:03:01,455 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:512aac4c-49b5-4b10-b8c9-110bc05f33e0
2025-10-31 09:03:01,462 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:868bc126-ce96-4c14-afce-deb9995e6072
2025-10-31 09:03:01,468 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:b37eea91-3c7a-44cb-af81-f6b3a0c0268a
2025-10-31 09:03:44,187 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:00f794c4-4b8d-454a-b7aa-efe086e408e8
2025-10-31 09:03:44,193 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-85414588:ctest-left_vn-56136102:ctest-left_vn-56136102
2025-10-31 09:03:44,199 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:00f794c4-4b8d-454a-b7aa-efe086e408e8
2025-10-31 09:03:46,022 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:95efed2d-5eb3-45d0-8e08-0475d9415ec0
2025-10-31 09:03:46,028 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-85414588:ctest-right_vn-03997901:ctest-right_vn-03997901
2025-10-31 09:03:46,035 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:95efed2d-5eb3-45d0-8e08-0475d9415ec0
2025-10-31 09:03:50,921 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:512aac4c-49b5-4b10-b8c9-110bc05f33e0
2025-10-31 09:03:50,929 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:868bc126-ce96-4c14-afce-deb9995e6072
2025-10-31 09:03:50,939 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:b37eea91-3c7a-44cb-af81-f6b3a0c0268a
2025-10-31 09:03:52,181 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VnListReq?name=default-domain:ctest-TestSvcRegr-85414588:ctest-left_vn-56136102
2025-10-31 09:03:52,187 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:b37eea91-3c7a-44cb-af81-f6b3a0c0268a
2025-10-31 09:03:52,194 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,
2025-10-31 09:03:52,205 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-85414588:ctest-left_vn-56136102:ctest-left_vn-56136102
2025-10-31 09:03:52,364 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_Inet4UcRouteReq?x=2
2025-10-31 09:03:52,569 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_Layer2RouteReq?x=2
2025-10-31 09:03:52,581 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VnListReq?name=default-domain:ctest-TestSvcRegr-85414588:ctest-left_vn-56136102
2025-10-31 09:03:52,587 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-85414588:ctest-left_vn-56136102:ctest-left_vn-56136102
2025-10-31 09:03:52,788 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_Inet4UcRouteReq?x=2
2025-10-31 09:03:52,997 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_Layer2RouteReq?x=2
2025-10-31 09:03:53,014 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VnListReq?name=default-domain:ctest-TestSvcRegr-85414588:ctest-mgmt_vn-41089201
2025-10-31 09:03:53,022 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:868bc126-ce96-4c14-afce-deb9995e6072
2025-10-31 09:03:53,028 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,
2025-10-31 09:03:53,040 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-85414588:ctest-mgmt_vn-41089201:ctest-mgmt_vn-41089201
2025-10-31 09:03:53,204 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_Inet4UcRouteReq?x=4
2025-10-31 09:03:53,413 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_Layer2RouteReq?x=4
2025-10-31 09:03:53,425 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VnListReq?name=default-domain:ctest-TestSvcRegr-85414588:ctest-mgmt_vn-41089201
2025-10-31 09:03:53,431 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-85414588:ctest-mgmt_vn-41089201:ctest-mgmt_vn-41089201
2025-10-31 09:03:53,640 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_Inet4UcRouteReq?x=4
2025-10-31 09:03:53,845 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_Layer2RouteReq?x=4
2025-10-31 09:03:53,855 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VnListReq?name=default-domain:ctest-TestSvcRegr-85414588:ctest-right_vn-03997901
2025-10-31 09:03:53,862 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:512aac4c-49b5-4b10-b8c9-110bc05f33e0
2025-10-31 09:03:53,869 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,
2025-10-31 09:03:53,878 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-85414588:ctest-right_vn-03997901:ctest-right_vn-03997901
2025-10-31 09:03:54,045 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_Inet4UcRouteReq?x=3
2025-10-31 09:03:54,253 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_Layer2RouteReq?x=3
2025-10-31 09:03:54,264 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VnListReq?name=default-domain:ctest-TestSvcRegr-85414588:ctest-right_vn-03997901
2025-10-31 09:03:54,271 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-85414588:ctest-right_vn-03997901:ctest-right_vn-03997901
2025-10-31 09:03:54,485 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_Inet4UcRouteReq?x=3
2025-10-31 09:03:54,697 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_Layer2RouteReq?x=3
2025-10-31 09:03:55,236 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=
2025-10-31 09:03:55,244 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_Inet4UcRouteReq?x=5
2025-10-31 09:03:55,252 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:b37eea91-3c7a-44cb-af81-f6b3a0c0268a
2025-10-31 09:03:55,413 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=
2025-10-31 09:03:55,418 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_Inet4UcRouteReq?x=6
2025-10-31 09:03:55,427 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:512aac4c-49b5-4b10-b8c9-110bc05f33e0
2025-10-31 09:04:03,144 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VnListReq?name=default-domain:ctest-TestSvcRegr-85414588:ctest-right_vn-03997901
2025-10-31 09:04:03,151 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-85414588:ctest-right_vn-03997901:ctest-right_vn-03997901
2025-10-31 09:04:03,155 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-85414588:ctest-right_vn-03997901:ctest-right_vn-03997901
2025-10-31 09:04:03,466 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VnListReq?name=default-domain:ctest-TestSvcRegr-85414588:ctest-left_vn-56136102
2025-10-31 09:04:03,471 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-85414588:ctest-left_vn-56136102:ctest-left_vn-56136102
2025-10-31 09:04:03,476 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-85414588:ctest-left_vn-56136102:ctest-left_vn-56136102
2025-10-31 09:04:03,772 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VnListReq?name=default-domain:ctest-TestSvcRegr-85414588:ctest-mgmt_vn-41089201
2025-10-31 09:04:03,778 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-85414588:ctest-mgmt_vn-41089201:ctest-mgmt_vn-41089201
2025-10-31 09:04:03,783 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-85414588:ctest-mgmt_vn-41089201:ctest-mgmt_vn-41089201
2025-10-31 09:04:04,063 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 09:04:07,796 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 09:04:16,924 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:95ec4105-1bcf-4b04-831a-968cd300f453
2025-10-31 09:04:16,931 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestvDNSBasic0-38323086:ctest-vn1-vdns-53282549:ctest-vn1-vdns-53282549
2025-10-31 09:04:16,936 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:95ec4105-1bcf-4b04-831a-968cd300f453
2025-10-31 09:04:28,949 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_DnsInfo?
2025-10-31 09:04:35,576 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:f68e61c0-0b2d-4468-b30d-fcf8544c5c73
2025-10-31 09:04:35,584 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestvDNSBasic0-38323086:ctest-vn1-vdns-53282549:ctest-vn1-vdns-53282549
2025-10-31 09:04:35,590 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:f68e61c0-0b2d-4468-b30d-fcf8544c5c73
2025-10-31 09:04:47,459 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_DnsInfo?
2025-10-31 09:04:58,825 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 09:05:02,397 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 09:05:11,816 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:c9770790-ed85-4e1f-a183-bed04cfb32be
2025-10-31 09:05:11,822 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicVMVNx-52886343:ctest-vn-39680314:ctest-vn-39680314
2025-10-31 09:05:11,830 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:c9770790-ed85-4e1f-a183-bed04cfb32be
2025-10-31 09:05:17,803 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:25dd2374-7012-4433-b497-4e4c04713db1
2025-10-31 09:05:17,809 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicVMVNx-52886343:ctest-vn-39680314:ctest-vn-39680314
2025-10-31 09:05:17,814 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:25dd2374-7012-4433-b497-4e4c04713db1
2025-10-31 09:05:26,938 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 09:05:30,461 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 09:05:37,939 - DEBUG - [10.0.0.254]: Running cmd : docker exec --privileged -it vrouter_vrouter-agent_1 /bin/bash -c 'echo "10.20.0.14 cn-jenkins-deploy-platform-ansible-os-4573-1-test" >> /etc/hosts'
2025-10-31 09:05:38,059 - DEBUG - Output :
2025-10-31 09:05:38,585 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:81b22950-75fc-4d1b-8361-81d1676eba9f
2025-10-31 09:05:38,591 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicVMVN-04104852:ctest-vn2_metadata-48173221:ctest-vn2_metadata-48173221
2025-10-31 09:05:38,597 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:81b22950-75fc-4d1b-8361-81d1676eba9f
2025-10-31 09:05:45,994 - DEBUG - [10.0.0.254]: Running cmd : docker exec --privileged -it vrouter_vrouter-agent_1 /bin/bash -c 'sed -i '$ d' /etc/hosts'
2025-10-31 09:05:46,152 - DEBUG - Output : sed: -e expression #1, char 1: missing command
2025-10-31 09:05:48,753 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 09:05:49,051 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 09:05:56,053 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:d4083192-e91d-4e0a-ab52-d98ac044f4b8
2025-10-31 09:05:56,060 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicVMVN-04104852:ctest-vn-97145582:ctest-vn-97145582
2025-10-31 09:05:56,066 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:d4083192-e91d-4e0a-ab52-d98ac044f4b8
2025-10-31 09:06:07,943 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 09:06:08,235 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 09:06:13,140 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicVMVN-04104852:ctest-vn-87394366:ctest-vn-87394366
2025-10-31 09:06:13,469 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:d35f033b-e662-465b-a261-c4f58f204a1b
2025-10-31 09:06:13,476 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicVMVN-04104852:ctest-vn-87394366:ctest-vn-87394366
2025-10-31 09:06:13,481 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:d35f033b-e662-465b-a261-c4f58f204a1b
2025-10-31 09:06:23,577 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:9d6b1fd5-0dc3-4bc3-aec4-5ee01b0278d7
2025-10-31 09:06:23,583 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicVMVN-04104852:ctest-vn-87394366:ctest-vn-87394366
2025-10-31 09:06:23,588 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:9d6b1fd5-0dc3-4bc3-aec4-5ee01b0278d7
2025-10-31 09:06:25,421 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:bab0d6af-702c-426d-b2ff-9bd810aa155d
2025-10-31 09:06:25,428 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicVMVN-04104852:ctest-vn-87394366:ctest-vn-87394366
2025-10-31 09:06:25,434 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:bab0d6af-702c-426d-b2ff-9bd810aa155d
2025-10-31 09:06:45,941 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VnListReq?name=default-domain:ctest-TestBasicVMVN-04104852:ctest-vn-87394366
2025-10-31 09:06:45,946 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicVMVN-04104852:ctest-vn-87394366:ctest-vn-87394366
2025-10-31 09:06:45,953 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=
2025-10-31 09:06:45,959 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_KRouteReq?x=2
2025-10-31 09:06:45,966 - DEBUG - Unable to fetch route details in vrouter for vrf index 2, Got :[]
2025-10-31 09:06:46,332 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 09:08:51,007 - INFO - Using existing project ['default-domain', 'admin'](e1bdc373-0bc5-406c-822c-7dea05b38f42)
2025-10-31 09:08:51,019 - INFO - ================================================================================
2025-10-31 09:08:51,019 - INFO - STARTING TEST : test_contrail_status
2025-10-31 09:08:51,019 - INFO - TEST DESCRIPTION : Test to verify that all services are running and active
2025-10-31 09:08:51,145 - DEBUG - Skipping xmpp flap check
2025-10-31 09:08:51,145 - INFO - Initial checks done. Running the testcase now
2025-10-31 09:08:51,145 - INFO -
2025-10-31 09:08:51,266 - INFO - 10.0.0.254
2025-10-31 09:08:51,266 - INFO - config
2025-10-31 09:08:51,273 - INFO - config-nodemgr:active
2025-10-31 09:08:51,278 - INFO - api-server:active
2025-10-31 09:08:51,283 - INFO - schema:active
2025-10-31 09:08:51,288 - INFO - svc-monitor:active
2025-10-31 09:08:51,292 - INFO - device-manager:active
2025-10-31 09:08:51,292 - INFO - config-database
2025-10-31 09:08:51,292 - INFO - config-cassandra:active
2025-10-31 09:08:51,292 - INFO - config-zookeeper:active
2025-10-31 09:08:51,292 - INFO - config-rabbitmq:active
2025-10-31 09:08:51,292 - INFO - vrouter
2025-10-31 09:08:51,297 - INFO - vrouter-nodemgr:active
2025-10-31 09:08:51,301 - INFO - agent:active
2025-10-31 09:08:51,301 - INFO - control
2025-10-31 09:08:51,306 - INFO - control-nodemgr:active
2025-10-31 09:08:51,311 - INFO - control:active
2025-10-31 09:08:51,311 - INFO - named:active
2025-10-31 09:08:51,315 - INFO - dns:active
2025-10-31 09:08:51,315 - INFO - analytics
2025-10-31 09:08:51,321 - INFO - analytics-nodemgr:active
2025-10-31 09:08:51,325 - INFO - analytics-api:active
2025-10-31 09:08:51,331 - INFO - collector:active
2025-10-31 09:08:51,331 - INFO - analytics-database
2025-10-31 09:08:51,331 - INFO - analytics-cassandra:active
2025-10-31 09:08:51,336 - INFO - analyticsdb-nodemgr:active
2025-10-31 09:08:51,340 - INFO - query-engine:active
2025-10-31 09:08:51,341 - INFO - webui
2025-10-31 09:08:51,341 - INFO - webui:active
2025-10-31 09:08:51,341 - INFO - webui-middleware:active
2025-10-31 09:08:51,341 - INFO - redis:active
2025-10-31 09:08:51,341 - INFO - analytics_snmp
2025-10-31 09:08:51,345 - INFO - snmp-collector:active
2025-10-31 09:08:51,345 - INFO - snmp-topology:active
2025-10-31 09:08:51,345 - INFO - analytics_alarm
2025-10-31 09:08:51,345 - INFO - alarmgen:active
2025-10-31 09:08:51,345 - INFO - All the contrail services are up on all nodes
2025-10-31 09:08:51,345 - INFO - contrail-status passed
2025-10-31 09:08:51,481 - DEBUG - Skipping xmpp flap check
2025-10-31 09:08:51,481 - INFO - END TEST : test_contrail_status : PASSED[0:00:00]
2025-10-31 09:08:51,481 - INFO - --------------------------------------------------------------------------------