2025-10-31 22:14:44,836 - DEBUG - [10.0.0.50]: Running cmd : hostname
2025-10-31 22:14:45,041 - DEBUG - Output : cn-jenkins-deploy-platform-ansible-os-4582-1
2025-10-31 22:14:45,041 - DEBUG - [10.0.0.50]: Running cmd : hostname -f
2025-10-31 22:14:45,104 - DEBUG - Output : cn-jenkins-deploy-platform-ansible-os-4582-1.
2025-10-31 22:14:45,104 - DEBUG - [10.0.0.50]: 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 22:14:45,205 - DEBUG - Output : NAMES
contrail_test_6qexIiAOW
vrouter_vrouter-agent_1
vrouter_nodemgr_1
rsyslogd_rsyslogd_1
analytics_snmp_snmp-collector_1
analytics_snmp_nodemgr_1
analytics_snmp_topology_1
analytics_alarm_nodemgr_1
analytics_alarm_alarm-gen_1
analytics_alarm_kafka_1
analytics_api_1
analytics_nodemgr_1
analytics_collector_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_svcmonitor_1
config_dnsmasq_1
config_api_1
config_nodemgr_1
config_schema_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 22:14:45,205 - DEBUG - [10.0.0.50]: Running cmd : getent hosts 10.0.0.50 | head -n 1 | awk '{print $2}'
2025-10-31 22:14:45,268 - DEBUG - Output : cn-jenkins-deploy-platform-ansible-os-4582-1.
2025-10-31 22:14:45,268 - DEBUG - [10.0.0.50]: Running cmd : ip -4 -o addr show | awk '{print $4}'
2025-10-31 22:14:45,332 - DEBUG - Output : 127.0.0.1/8
10.0.0.50/24
172.17.0.1/16
10.20.0.254/24
2025-10-31 22:14:45,332 - DEBUG - [10.0.0.50]: Running cmd : ip -4 -o addr show dev vhost0 | awk '{print $4}'
2025-10-31 22:14:45,391 - DEBUG - Output : 10.20.0.254/24
2025-10-31 22:14:45,391 - DEBUG - [10.0.0.50]: Running cmd : getent hosts 10.20.0.254 | head -n 1 | awk '{print $2}'
2025-10-31 22:14:45,452 - DEBUG - Output : 
2025-10-31 22:14:47,103 - INFO - Using existing project ['default-domain', 'admin'](94ee3a64-a581-47a5-be15-658994f8fd1d)
2025-10-31 22:14:47,236 - INFO - ================================================================================
2025-10-31 22:14:47,236 - INFO - STARTING TEST    : test_contrail_status
2025-10-31 22:14:47,236 - INFO - TEST DESCRIPTION :  Test to verify that all services are running and active
        
2025-10-31 22:14:47,364 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 22:14:47,370 - DEBUG - Nothing to compare xmpp stats {'10.0.0.50': {'10.20.0.254': '0'}} with
2025-10-31 22:14:47,370 - INFO - Initial checks done. Running the testcase now
2025-10-31 22:14:47,370 - INFO - 
2025-10-31 22:14:47,370 - DEBUG - [10.0.0.50]: Running cmd : docker ps -f status=running --format {{.Names}} 2>/dev/null
2025-10-31 22:14:47,466 - DEBUG - Output : contrail_test_6qexIiAOW
vrouter_vrouter-agent_1
vrouter_provisioner_1
vrouter_nodemgr_1
rsyslogd_rsyslogd_1
analytics_snmp_snmp-collector_1
analytics_snmp_provisioner_1
analytics_snmp_nodemgr_1
analytics_snmp_topology_1
analytics_alarm_nodemgr_1
analytics_alarm_provisioner_1
analytics_alarm_alarm-gen_1
analytics_alarm_kafka_1
analytics_api_1
analytics_nodemgr_1
analytics_provisioner_1
analytics_collector_1
analytics_database_provisioner_1
analytics_database_nodemgr_1
analytics_database_query-engine_1
analytics_database_cassandra_1
control_named_1
control_dns_1
control_control_1
control_provisioner_1
control_nodemgr_1
webui_job_1
webui_web_1
config_devicemgr_1
config_svcmonitor_1
config_provisioner_1
config_dnsmasq_1
config_api_1
config_nodemgr_1
config_schema_1
config_database_rabbitmq_1
config_database_nodemgr_1
config_database_provisioner_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 22:14:47,466 - INFO - 10.0.0.50
2025-10-31 22:14:47,466 - INFO -   config
2025-10-31 22:14:47,472 - INFO -     config-nodemgr:active
2025-10-31 22:14:47,476 - INFO -     api-server:active
2025-10-31 22:14:47,479 - INFO -     schema:active
2025-10-31 22:14:47,482 - INFO -     svc-monitor:active
2025-10-31 22:14:47,486 - INFO -     device-manager:active
2025-10-31 22:14:47,486 - INFO -   config-database
2025-10-31 22:14:47,486 - INFO -     config-cassandra:active
2025-10-31 22:14:47,486 - INFO -     config-zookeeper:active
2025-10-31 22:14:47,486 - INFO -     config-rabbitmq:active
2025-10-31 22:14:47,486 - INFO -   vrouter
2025-10-31 22:14:47,490 - INFO -     vrouter-nodemgr:active
2025-10-31 22:14:47,494 - INFO -     agent:active
2025-10-31 22:14:47,494 - INFO -   control
2025-10-31 22:14:47,499 - INFO -     control-nodemgr:active
2025-10-31 22:14:47,503 - INFO -     control:active
2025-10-31 22:14:47,503 - INFO -     named:active
2025-10-31 22:14:47,507 - INFO -     dns:active
2025-10-31 22:14:47,507 - INFO -   analytics
2025-10-31 22:14:47,511 - INFO -     analytics-nodemgr:active
2025-10-31 22:14:47,515 - INFO -     analytics-api:active
2025-10-31 22:14:47,519 - INFO -     collector:active
2025-10-31 22:14:47,519 - INFO -   analytics-database
2025-10-31 22:14:47,519 - INFO -     analytics-cassandra:active
2025-10-31 22:14:47,524 - INFO -     analyticsdb-nodemgr:active
2025-10-31 22:14:47,528 - INFO -     query-engine:active
2025-10-31 22:14:47,528 - INFO -   webui
2025-10-31 22:14:47,529 - INFO -     webui:active
2025-10-31 22:14:47,529 - INFO -     webui-middleware:active
2025-10-31 22:14:47,529 - INFO -     redis:active
2025-10-31 22:14:47,529 - INFO -   analytics_snmp
2025-10-31 22:14:47,532 - INFO -     snmp-collector:active
2025-10-31 22:14:47,532 - INFO -     snmp-topology:active
2025-10-31 22:14:47,532 - INFO -   analytics_alarm
2025-10-31 22:14:47,532 - INFO -     alarmgen:active
2025-10-31 22:14:47,532 - INFO - All the contrail services are up on all nodes
2025-10-31 22:14:47,532 - INFO - contrail-status passed
2025-10-31 22:14:47,651 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 22:14:47,656 - DEBUG - No XMPP flaps were noticed during the test
2025-10-31 22:14:47,656 - INFO - END TEST : test_contrail_status : PASSED[0:00:00]
2025-10-31 22:14:47,656 - INFO - --------------------------------------------------------------------------------
2025-10-31 22:14:49,814 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 22:14:51,983 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-AnalyticsBasicTestSanity-38609930:ctest-vn22-18801325:ctest-vn22-18801325
2025-10-31 22:14:51,990 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-AnalyticsBasicTestSanity-38609930:ctest-vn22-18801325:ctest-vn22-18801325
2025-10-31 22:14:51,995 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-AnalyticsBasicTestSanity-38609930:ctest-vn22-18801325:ctest-vn22-18801325
2025-10-31 22:15:07,708 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VnListReq?name=default-domain:ctest-AnalyticsBasicTestSanity-38609930:ctest-vn22-18801325
2025-10-31 22:15:07,714 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-AnalyticsBasicTestSanity-38609930:ctest-vn22-18801325:ctest-vn22-18801325
2025-10-31 22:15:07,718 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-AnalyticsBasicTestSanity-38609930:ctest-vn22-18801325:ctest-vn22-18801325
2025-10-31 22:15:07,846 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 22:15:08,824 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 22:15:08,830 - DEBUG - [10.0.0.50]: Running cmd : docker exec  --privileged  -it config_api_1 /bin/bash -c  'db-manage check'
2025-10-31 22:15:11,957 - DEBUG - Output : 2025-10-31 22:15:11,176 INFO: (v1.41) Checker check_zk_mode_and_node_count: Success
2025-10-31 22:15:11,204 INFO: (v1.41) Checker check_cassandra_keyspace_replication: Success
2025-10-31 22:15:11,303 INFO: (v1.41) Checker check_obj_mandatory_fields: Success
2025-10-31 22:15:11,482 INFO: (v1.41) Checker check_orphan_resources: Success
2025-10-31 22:15:11,667 INFO: (v1.41) Checker check_fq_name_uuid_match: Success
2025-10-31 22:15:11,667 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 22:15:11,757 INFO: (v1.41) Checker check_duplicate_fq_name: Success
2025-10-31 22:15:11,767 INFO: (v1.41) Checker check_route_targets_routing_instance_backrefs: Success
2025-10-31 22:15:11,773 INFO: (v1.41) Checker check_subnet_uuid: Success
2025-10-31 22:15:11,783 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 22:15:11,807 INFO: (v1.41) Checker check_route_targets_id: Success
2025-10-31 22:15:11,829 INFO: (v1.41) Checker check_virtual_networks_id: Success
2025-10-31 22:15:11,841 INFO: (v1.41) Checker check_security_groups_id: Success
2025-10-31 22:15:11,844 INFO: (v1.41) Checker check_ipam_subnet_method: Success
2025-10-31 22:15:11,846 INFO: (v1.41) Checker check_aggregated_ethernet_id: Success
2025-10-31 22:15:12,110 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 22:15:12,298 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 22:15:12,458 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 22:15:12,622 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 22:15:12,781 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 22:15:15,290 - INFO - admin user already present
2025-10-31 22:15:16,053 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 22:15:18,015 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-FloatingipBasicTestSanity-88090328:ctest-fvn-84957432:ctest-fvn-84957432
2025-10-31 22:15:18,020 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-FloatingipBasicTestSanity-88090328:ctest-fvn-84957432:ctest-fvn-84957432
2025-10-31 22:15:18,024 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-FloatingipBasicTestSanity-88090328:ctest-fvn-84957432:ctest-fvn-84957432
2025-10-31 22:15:18,907 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-FloatingipBasicTestSanity-88090328:ctest-vn1-61150948:ctest-vn1-61150948
2025-10-31 22:15:18,911 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-FloatingipBasicTestSanity-88090328:ctest-vn1-61150948:ctest-vn1-61150948
2025-10-31 22:15:18,914 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-FloatingipBasicTestSanity-88090328:ctest-vn1-61150948:ctest-vn1-61150948
2025-10-31 22:15:27,260 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:13f0c8c2-40c8-41fa-ace3-684fb62ba05f
2025-10-31 22:15:27,269 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-FloatingipBasicTestSanity-88090328:ctest-vn1-61150948:ctest-vn1-61150948
2025-10-31 22:15:27,274 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:13f0c8c2-40c8-41fa-ace3-684fb62ba05f
2025-10-31 22:15:38,290 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:7f1165cc-4a50-4254-8489-23be64cdb52e
2025-10-31 22:15:38,295 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-FloatingipBasicTestSanity-88090328:ctest-fvn-84957432:ctest-fvn-84957432
2025-10-31 22:15:38,299 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:7f1165cc-4a50-4254-8489-23be64cdb52e
2025-10-31 22:15:39,831 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:13f0c8c2-40c8-41fa-ace3-684fb62ba05f
2025-10-31 22:15:39,837 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VnListReq?name=default-domain:ctest-FloatingipBasicTestSanity-88090328:ctest-fvn-84957432
2025-10-31 22:15:39,842 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-FloatingipBasicTestSanity-88090328:ctest-fvn-84957432:ctest-fvn-84957432
2025-10-31 22:15:39,847 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_Inet4UcRouteReq?x=3
2025-10-31 22:15:45,441 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VnListReq?name=default-domain:ctest-FloatingipBasicTestSanity-88090328:ctest-vn1-61150948
2025-10-31 22:15:45,446 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-FloatingipBasicTestSanity-88090328:ctest-vn1-61150948:ctest-vn1-61150948
2025-10-31 22:15:45,450 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-FloatingipBasicTestSanity-88090328:ctest-vn1-61150948:ctest-vn1-61150948
2025-10-31 22:15:45,690 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VnListReq?name=default-domain:ctest-FloatingipBasicTestSanity-88090328:ctest-fvn-84957432
2025-10-31 22:15:45,695 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-FloatingipBasicTestSanity-88090328:ctest-fvn-84957432:ctest-fvn-84957432
2025-10-31 22:15:45,700 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-FloatingipBasicTestSanity-88090328:ctest-fvn-84957432:ctest-fvn-84957432
2025-10-31 22:15:45,960 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 22:15:49,177 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 22:15:49,561 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 22:15:56,248 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 22:15:58,512 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 22:16:01,669 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 22:16:03,740 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 22:16:04,025 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 22:16:11,168 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:ff2c1040-87a4-4a41-80e4-adb430230a4d
2025-10-31 22:16:11,175 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestPorts-30681853:ctest-vn1-35784789:ctest-vn1-35784789
2025-10-31 22:16:11,180 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:ff2c1040-87a4-4a41-80e4-adb430230a4d
2025-10-31 22:16:17,074 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:52c23546-4749-427e-abc5-7fb9f2a0e1fb
2025-10-31 22:16:17,078 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestPorts-30681853:ctest-vn1-35784789:ctest-vn1-35784789
2025-10-31 22:16:17,082 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:52c23546-4749-427e-abc5-7fb9f2a0e1fb
2025-10-31 22:16:22,104 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 22:16:25,284 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 22:16:35,154 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:6f19dc1f-0367-44ca-a48f-233465e33924
2025-10-31 22:16:35,160 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestRouters-29047957:ctest-vn1-19865981:ctest-vn1-19865981
2025-10-31 22:16:35,165 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:6f19dc1f-0367-44ca-a48f-233465e33924
2025-10-31 22:16:41,032 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:cdd4ca8e-ef63-4d92-a1aa-dcc15de54b78
2025-10-31 22:16:41,037 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestRouters-29047957:ctest-vn2-75218288:ctest-vn2-75218288
2025-10-31 22:16:41,041 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:cdd4ca8e-ef63-4d92-a1aa-dcc15de54b78
2025-10-31 22:17:02,800 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 22:17:05,969 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 22:17:16,648 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:6f97fba9-9d69-40b3-a376-9b3cc181b502
2025-10-31 22:17:16,654 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestRoutersBasic-30319235:ctest-vn-04603859:ctest-vn-04603859
2025-10-31 22:17:16,659 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:6f97fba9-9d69-40b3-a376-9b3cc181b502
2025-10-31 22:17:22,555 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:cff6f9ae-00ee-4584-ad55-397717028e9e
2025-10-31 22:17:22,559 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestRoutersBasic-30319235:ctest-ext_vn-12783472:ctest-ext_vn-12783472
2025-10-31 22:17:22,563 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:cff6f9ae-00ee-4584-ad55-397717028e9e
2025-10-31 22:17:30,573 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 22:17:33,617 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 22:17:37,049 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-35008343:ctest-vn-99072432:ctest-vn-99072432
2025-10-31 22:17:37,054 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-35008343:ctest-vn-99072432:ctest-vn-99072432
2025-10-31 22:17:37,059 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-35008343:ctest-vn-99072432:ctest-vn-99072432
2025-10-31 22:17:37,334 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-35008343:ctest-vn-34629048:ctest-vn-34629048
2025-10-31 22:17:37,340 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-35008343:ctest-vn-34629048:ctest-vn-34629048
2025-10-31 22:17:37,347 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-35008343:ctest-vn-34629048:ctest-vn-34629048
2025-10-31 22:17:37,872 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VnListReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-35008343:ctest-vn-34629048
2025-10-31 22:17:37,877 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-35008343:ctest-vn-34629048:ctest-vn-34629048
2025-10-31 22:17:37,882 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-35008343:ctest-vn-34629048:ctest-vn-34629048
2025-10-31 22:17:38,126 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VnListReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-35008343:ctest-vn-99072432
2025-10-31 22:17:38,131 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-35008343:ctest-vn-99072432:ctest-vn-99072432
2025-10-31 22:17:38,136 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-35008343:ctest-vn-99072432:ctest-vn-99072432
2025-10-31 22:17:38,397 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 22:17:41,420 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 22:17:41,708 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 22:17:44,230 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyNegativeIpv4v6-19456468:ctest-vn4-68073371:ctest-vn4-68073371
2025-10-31 22:17:44,234 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyNegativeIpv4v6-19456468:ctest-vn4-68073371:ctest-vn4-68073371
2025-10-31 22:17:44,238 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyNegativeIpv4v6-19456468:ctest-vn4-68073371:ctest-vn4-68073371
2025-10-31 22:17:44,642 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VnListReq?name=default-domain:ctest-TestBasicPolicyNegativeIpv4v6-19456468:ctest-vn4-68073371
2025-10-31 22:17:44,646 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyNegativeIpv4v6-19456468:ctest-vn4-68073371:ctest-vn4-68073371
2025-10-31 22:17:44,651 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyNegativeIpv4v6-19456468:ctest-vn4-68073371:ctest-vn4-68073371
2025-10-31 22:17:45,097 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 22:17:45,388 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 22:17:48,380 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 22:17:51,431 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicy-33956641:ctest-vn-54897126:ctest-vn-54897126
2025-10-31 22:17:51,436 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicy-33956641:ctest-vn-54897126:ctest-vn-54897126
2025-10-31 22:17:51,441 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicy-33956641:ctest-vn-54897126:ctest-vn-54897126
2025-10-31 22:17:51,728 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicy-33956641:ctest-vn-05060548:ctest-vn-05060548
2025-10-31 22:17:51,734 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicy-33956641:ctest-vn-05060548:ctest-vn-05060548
2025-10-31 22:17:51,738 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicy-33956641:ctest-vn-05060548:ctest-vn-05060548
2025-10-31 22:17:59,260 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:0fca3aa1-f2d8-4476-aa18-7c0db7a3e281
2025-10-31 22:17:59,266 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicy-33956641:ctest-vn-54897126:ctest-vn-54897126
2025-10-31 22:17:59,270 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:0fca3aa1-f2d8-4476-aa18-7c0db7a3e281
2025-10-31 22:18:05,186 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:02504cd9-5463-4c39-a8c4-a486fcb760c2
2025-10-31 22:18:05,191 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicy-33956641:ctest-vn-05060548:ctest-vn-05060548
2025-10-31 22:18:05,195 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:02504cd9-5463-4c39-a8c4-a486fcb760c2
2025-10-31 22:18:16,806 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VnListReq?name=default-domain:ctest-TestBasicPolicy-33956641:ctest-vn-05060548
2025-10-31 22:18:16,811 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicy-33956641:ctest-vn-05060548:ctest-vn-05060548
2025-10-31 22:18:16,816 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicy-33956641:ctest-vn-05060548:ctest-vn-05060548
2025-10-31 22:18:17,060 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VnListReq?name=default-domain:ctest-TestBasicPolicy-33956641:ctest-vn-54897126
2025-10-31 22:18:17,065 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicy-33956641:ctest-vn-54897126:ctest-vn-54897126
2025-10-31 22:18:17,069 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicy-33956641:ctest-vn-54897126:ctest-vn-54897126
2025-10-31 22:18:17,329 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 22:18:20,428 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 22:18:30,085 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:cc7fd00b-a4d8-4a5f-8596-f71e91be537f
2025-10-31 22:18:30,089 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestRP-86609003:ctest-bgpaas_vn-44058972:ctest-bgpaas_vn-44058972
2025-10-31 22:18:30,094 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:cc7fd00b-a4d8-4a5f-8596-f71e91be537f
2025-10-31 22:18:35,965 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:557ed7c3-5202-423f-a249-ff81660d8168
2025-10-31 22:18:35,970 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestRP-86609003:ctest-bgpaas_vn-94560921:ctest-bgpaas_vn-94560921
2025-10-31 22:18:35,973 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:557ed7c3-5202-423f-a249-ff81660d8168
2025-10-31 22:18:37,629 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 22:18:44,028 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 22:18:47,115 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 22:18:48,984 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-10834864:ctest-mgmt_vn-70946099:ctest-mgmt_vn-70946099
2025-10-31 22:18:48,988 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-10834864:ctest-mgmt_vn-70946099:ctest-mgmt_vn-70946099
2025-10-31 22:18:48,992 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-10834864:ctest-mgmt_vn-70946099:ctest-mgmt_vn-70946099
2025-10-31 22:18:49,794 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-10834864:ctest-left_vn-76604066:ctest-left_vn-76604066
2025-10-31 22:18:49,799 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-10834864:ctest-left_vn-76604066:ctest-left_vn-76604066
2025-10-31 22:18:49,803 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-10834864:ctest-left_vn-76604066:ctest-left_vn-76604066
2025-10-31 22:18:50,583 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-10834864:ctest-right_vn-77869184:ctest-right_vn-77869184
2025-10-31 22:18:50,587 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-10834864:ctest-right_vn-77869184:ctest-right_vn-77869184
2025-10-31 22:18:50,591 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-10834864:ctest-right_vn-77869184:ctest-right_vn-77869184
2025-10-31 22:19:00,515 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:76462c0b-c2cd-42f5-90ae-81caade8e7e9
2025-10-31 22:19:00,521 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-10834864:ctest-mgmt_vn-70946099:ctest-mgmt_vn-70946099
2025-10-31 22:19:00,525 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:2cabee21-f308-4dfb-838c-5f332e67f2b4
2025-10-31 22:19:00,531 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-10834864:ctest-left_vn-76604066:ctest-left_vn-76604066
2025-10-31 22:19:00,536 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:68d1df6a-5255-4b1a-91fd-a8156dfdee83
2025-10-31 22:19:00,544 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-10834864:ctest-right_vn-77869184:ctest-right_vn-77869184
2025-10-31 22:19:00,557 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:2cabee21-f308-4dfb-838c-5f332e67f2b4
2025-10-31 22:19:00,562 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:68d1df6a-5255-4b1a-91fd-a8156dfdee83
2025-10-31 22:19:00,568 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:76462c0b-c2cd-42f5-90ae-81caade8e7e9
2025-10-31 22:19:36,738 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:27df38ad-0e8e-4ef4-b5fc-1af7693b332e
2025-10-31 22:19:36,742 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-10834864:ctest-left_vn-76604066:ctest-left_vn-76604066
2025-10-31 22:19:36,746 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:27df38ad-0e8e-4ef4-b5fc-1af7693b332e
2025-10-31 22:19:38,493 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:ae556268-62d9-4699-858f-82f5670cb96e
2025-10-31 22:19:38,498 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-10834864:ctest-right_vn-77869184:ctest-right_vn-77869184
2025-10-31 22:19:38,503 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:ae556268-62d9-4699-858f-82f5670cb96e
2025-10-31 22:19:43,012 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:2cabee21-f308-4dfb-838c-5f332e67f2b4
2025-10-31 22:19:43,019 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:68d1df6a-5255-4b1a-91fd-a8156dfdee83
2025-10-31 22:19:43,024 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:76462c0b-c2cd-42f5-90ae-81caade8e7e9
2025-10-31 22:19:44,255 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VnListReq?name=default-domain:ctest-TestSvcRegr-10834864:ctest-left_vn-76604066
2025-10-31 22:19:44,260 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:2cabee21-f308-4dfb-838c-5f332e67f2b4
2025-10-31 22:19:44,265 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,
2025-10-31 22:19:44,273 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-10834864:ctest-left_vn-76604066:ctest-left_vn-76604066
2025-10-31 22:19:44,425 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_Inet4UcRouteReq?x=2
2025-10-31 22:19:44,625 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_Layer2RouteReq?x=2
2025-10-31 22:19:44,635 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VnListReq?name=default-domain:ctest-TestSvcRegr-10834864:ctest-left_vn-76604066
2025-10-31 22:19:44,639 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-10834864:ctest-left_vn-76604066:ctest-left_vn-76604066
2025-10-31 22:19:44,849 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_Inet4UcRouteReq?x=2
2025-10-31 22:19:45,057 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_Layer2RouteReq?x=2
2025-10-31 22:19:45,067 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VnListReq?name=default-domain:ctest-TestSvcRegr-10834864:ctest-mgmt_vn-70946099
2025-10-31 22:19:45,072 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:76462c0b-c2cd-42f5-90ae-81caade8e7e9
2025-10-31 22:19:45,079 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,
2025-10-31 22:19:45,087 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-10834864:ctest-mgmt_vn-70946099:ctest-mgmt_vn-70946099
2025-10-31 22:19:45,289 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_Inet4UcRouteReq?x=4
2025-10-31 22:19:45,489 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_Layer2RouteReq?x=4
2025-10-31 22:19:45,498 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VnListReq?name=default-domain:ctest-TestSvcRegr-10834864:ctest-mgmt_vn-70946099
2025-10-31 22:19:45,502 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-10834864:ctest-mgmt_vn-70946099:ctest-mgmt_vn-70946099
2025-10-31 22:19:45,701 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_Inet4UcRouteReq?x=4
2025-10-31 22:19:45,905 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_Layer2RouteReq?x=4
2025-10-31 22:19:45,914 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VnListReq?name=default-domain:ctest-TestSvcRegr-10834864:ctest-right_vn-77869184
2025-10-31 22:19:45,918 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:68d1df6a-5255-4b1a-91fd-a8156dfdee83
2025-10-31 22:19:45,923 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,
2025-10-31 22:19:45,930 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-10834864:ctest-right_vn-77869184:ctest-right_vn-77869184
2025-10-31 22:19:46,125 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_Inet4UcRouteReq?x=3
2025-10-31 22:19:46,333 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_Layer2RouteReq?x=3
2025-10-31 22:19:46,343 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VnListReq?name=default-domain:ctest-TestSvcRegr-10834864:ctest-right_vn-77869184
2025-10-31 22:19:46,348 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-10834864:ctest-right_vn-77869184:ctest-right_vn-77869184
2025-10-31 22:19:46,541 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_Inet4UcRouteReq?x=3
2025-10-31 22:19:46,741 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_Layer2RouteReq?x=3
2025-10-31 22:19:47,245 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=
2025-10-31 22:19:47,250 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_Inet4UcRouteReq?x=5
2025-10-31 22:19:47,257 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:2cabee21-f308-4dfb-838c-5f332e67f2b4
2025-10-31 22:19:47,405 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=
2025-10-31 22:19:47,411 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_Inet4UcRouteReq?x=6
2025-10-31 22:19:47,417 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:68d1df6a-5255-4b1a-91fd-a8156dfdee83
2025-10-31 22:19:54,791 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VnListReq?name=default-domain:ctest-TestSvcRegr-10834864:ctest-right_vn-77869184
2025-10-31 22:19:54,796 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-10834864:ctest-right_vn-77869184:ctest-right_vn-77869184
2025-10-31 22:19:54,800 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-10834864:ctest-right_vn-77869184:ctest-right_vn-77869184
2025-10-31 22:19:55,035 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VnListReq?name=default-domain:ctest-TestSvcRegr-10834864:ctest-left_vn-76604066
2025-10-31 22:19:55,039 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-10834864:ctest-left_vn-76604066:ctest-left_vn-76604066
2025-10-31 22:19:55,043 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-10834864:ctest-left_vn-76604066:ctest-left_vn-76604066
2025-10-31 22:19:55,287 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VnListReq?name=default-domain:ctest-TestSvcRegr-10834864:ctest-mgmt_vn-70946099
2025-10-31 22:19:55,291 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-10834864:ctest-mgmt_vn-70946099:ctest-mgmt_vn-70946099
2025-10-31 22:19:55,295 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-10834864:ctest-mgmt_vn-70946099:ctest-mgmt_vn-70946099
2025-10-31 22:19:55,565 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 22:19:58,804 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 22:20:07,603 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:f64659de-4be9-4a44-91ad-99414ff70a49
2025-10-31 22:20:07,608 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestvDNSBasic0-60459408:ctest-vn1-vdns-62102847:ctest-vn1-vdns-62102847
2025-10-31 22:20:07,614 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:f64659de-4be9-4a44-91ad-99414ff70a49
2025-10-31 22:20:17,446 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_DnsInfo?
2025-10-31 22:20:23,893 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:e541d6ce-9ba6-4c29-9ab9-004c12524c16
2025-10-31 22:20:23,899 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestvDNSBasic0-60459408:ctest-vn1-vdns-62102847:ctest-vn1-vdns-62102847
2025-10-31 22:20:23,905 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:e541d6ce-9ba6-4c29-9ab9-004c12524c16
2025-10-31 22:20:33,704 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_DnsInfo?
2025-10-31 22:20:44,585 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 22:20:47,721 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 22:20:56,447 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:a5517a7b-b5bb-41e6-8536-b124216da500
2025-10-31 22:20:56,452 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicVMVNx-51239910:ctest-vn-24512513:ctest-vn-24512513
2025-10-31 22:20:56,456 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:a5517a7b-b5bb-41e6-8536-b124216da500
2025-10-31 22:21:02,347 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:f0a389a9-4d6f-4b45-8dc4-d05755082e82
2025-10-31 22:21:02,352 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicVMVNx-51239910:ctest-vn-24512513:ctest-vn-24512513
2025-10-31 22:21:02,357 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:f0a389a9-4d6f-4b45-8dc4-d05755082e82
2025-10-31 22:21:11,017 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 22:21:14,252 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 22:21:21,449 - DEBUG - [10.0.0.50]: Running cmd : docker exec  --privileged  -it vrouter_vrouter-agent_1 /bin/bash -c  'echo "10.20.0.254 cn-jenkins-deploy-platform-ansible-os-4582-1-test" >> /etc/hosts'
2025-10-31 22:21:21,557 - DEBUG - Output : 
2025-10-31 22:21:22,052 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:e8557616-fe23-41d7-a282-dd54c7ec7761
2025-10-31 22:21:22,057 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicVMVN-93885729:ctest-vn2_metadata-71923681:ctest-vn2_metadata-71923681
2025-10-31 22:21:22,061 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:e8557616-fe23-41d7-a282-dd54c7ec7761
2025-10-31 22:21:34,445 - DEBUG - [10.0.0.50]: Running cmd : docker exec  --privileged  -it vrouter_vrouter-agent_1 /bin/bash -c  'sed -i '$ d' /etc/hosts'
2025-10-31 22:21:34,589 - DEBUG - Output : sed: -e expression #1, char 1: missing command
2025-10-31 22:21:37,157 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 22:21:37,445 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 22:21:44,235 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:06ba886d-6c14-4493-96bc-6c15ba7d5f22
2025-10-31 22:21:44,241 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicVMVN-93885729:ctest-vn-02147453:ctest-vn-02147453
2025-10-31 22:21:44,245 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:06ba886d-6c14-4493-96bc-6c15ba7d5f22
2025-10-31 22:21:59,105 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 22:21:59,400 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 22:22:03,952 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicVMVN-93885729:ctest-vn-10212253:ctest-vn-10212253
2025-10-31 22:22:04,327 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:8a32836e-d214-4024-a6af-6eebf2ac28e2
2025-10-31 22:22:04,333 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicVMVN-93885729:ctest-vn-10212253:ctest-vn-10212253
2025-10-31 22:22:04,337 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:8a32836e-d214-4024-a6af-6eebf2ac28e2
2025-10-31 22:22:14,376 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:92e6ac49-30f3-44e7-a3fc-459840b8c99f
2025-10-31 22:22:14,381 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicVMVN-93885729:ctest-vn-10212253:ctest-vn-10212253
2025-10-31 22:22:14,385 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:92e6ac49-30f3-44e7-a3fc-459840b8c99f
2025-10-31 22:22:16,112 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:6b76d591-d7d8-416f-b78f-da51495ea23f
2025-10-31 22:22:16,117 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicVMVN-93885729:ctest-vn-10212253:ctest-vn-10212253
2025-10-31 22:22:16,121 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:6b76d591-d7d8-416f-b78f-da51495ea23f
2025-10-31 22:22:35,914 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VnListReq?name=default-domain:ctest-TestBasicVMVN-93885729:ctest-vn-10212253
2025-10-31 22:22:35,918 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicVMVN-93885729:ctest-vn-10212253:ctest-vn-10212253
2025-10-31 22:22:35,922 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_VrfListReq?name=
2025-10-31 22:22:35,926 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_KRouteReq?x=2
2025-10-31 22:22:35,932 - DEBUG - Unable to fetch route details in vrouter for  vrf index 2, Got :[]
2025-10-31 22:22:36,273 - DEBUG - Requesting: http://10.0.0.50:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-31 22:24:26,399 - INFO - Using existing project ['default-domain', 'admin'](94ee3a64-a581-47a5-be15-658994f8fd1d)
2025-10-31 22:24:26,406 - INFO - ================================================================================
2025-10-31 22:24:26,407 - INFO - STARTING TEST    : test_contrail_status
2025-10-31 22:24:26,407 - INFO - TEST DESCRIPTION :  Test to verify that all services are running and active
        
2025-10-31 22:24:26,540 - DEBUG - Skipping xmpp flap check
2025-10-31 22:24:26,541 - INFO - Initial checks done. Running the testcase now
2025-10-31 22:24:26,541 - INFO - 
2025-10-31 22:24:26,639 - INFO - 10.0.0.50
2025-10-31 22:24:26,639 - INFO -   config
2025-10-31 22:24:26,645 - INFO -     config-nodemgr:active
2025-10-31 22:24:26,649 - INFO -     api-server:active
2025-10-31 22:24:26,652 - INFO -     schema:active
2025-10-31 22:24:26,656 - INFO -     svc-monitor:active
2025-10-31 22:24:26,660 - INFO -     device-manager:active
2025-10-31 22:24:26,660 - INFO -   config-database
2025-10-31 22:24:26,660 - INFO -     config-cassandra:active
2025-10-31 22:24:26,660 - INFO -     config-zookeeper:active
2025-10-31 22:24:26,660 - INFO -     config-rabbitmq:active
2025-10-31 22:24:26,660 - INFO -   vrouter
2025-10-31 22:24:26,664 - INFO -     vrouter-nodemgr:active
2025-10-31 22:24:26,668 - INFO -     agent:active
2025-10-31 22:24:26,668 - INFO -   control
2025-10-31 22:24:26,672 - INFO -     control-nodemgr:active
2025-10-31 22:24:26,676 - INFO -     control:active
2025-10-31 22:24:26,676 - INFO -     named:active
2025-10-31 22:24:26,680 - INFO -     dns:active
2025-10-31 22:24:26,681 - INFO -   analytics
2025-10-31 22:24:26,684 - INFO -     analytics-nodemgr:active
2025-10-31 22:24:26,688 - INFO -     analytics-api:active
2025-10-31 22:24:26,692 - INFO -     collector:active
2025-10-31 22:24:26,692 - INFO -   analytics-database
2025-10-31 22:24:26,692 - INFO -     analytics-cassandra:active
2025-10-31 22:24:26,696 - INFO -     analyticsdb-nodemgr:active
2025-10-31 22:24:26,700 - INFO -     query-engine:active
2025-10-31 22:24:26,701 - INFO -   webui
2025-10-31 22:24:26,701 - INFO -     webui:active
2025-10-31 22:24:26,701 - INFO -     webui-middleware:active
2025-10-31 22:24:26,701 - INFO -     redis:active
2025-10-31 22:24:26,701 - INFO -   analytics_snmp
2025-10-31 22:24:26,705 - INFO -     snmp-collector:active
2025-10-31 22:24:26,705 - INFO -     snmp-topology:active
2025-10-31 22:24:26,705 - INFO -   analytics_alarm
2025-10-31 22:24:26,705 - INFO -     alarmgen:active
2025-10-31 22:24:26,706 - INFO - All the contrail services are up on all nodes
2025-10-31 22:24:26,706 - INFO - contrail-status passed
2025-10-31 22:24:26,826 - DEBUG - Skipping xmpp flap check
2025-10-31 22:24:26,826 - INFO - END TEST : test_contrail_status : PASSED[0:00:00]
2025-10-31 22:24:26,826 - INFO - --------------------------------------------------------------------------------