2025-10-28 18:24:56,265 - DEBUG - [10.0.0.242]: Running cmd : hostname
2025-10-28 18:24:56,472 - DEBUG - Output : cn-jenkins-deploy-platform-ansible-os-4515-1
2025-10-28 18:24:56,473 - DEBUG - [10.0.0.242]: Running cmd : hostname -f
2025-10-28 18:24:56,532 - DEBUG - Output : cn-jenkins-deploy-platform-ansible-os-4515-1.
2025-10-28 18:24:56,532 - DEBUG - [10.0.0.242]: 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-28 18:24:56,648 - DEBUG - Output : NAMES
contrail_test_xuVnrB2j8
vrouter_vrouter-agent_1
vrouter_nodemgr_1
rsyslogd_rsyslogd_1
analytics_snmp_snmp-collector_1
analytics_snmp_topology_1
analytics_snmp_nodemgr_1
analytics_alarm_alarm-gen_1
analytics_alarm_nodemgr_1
analytics_alarm_kafka_1
analytics_api_1
analytics_collector_1
analytics_nodemgr_1
analytics_database_query-engine_1
analytics_database_nodemgr_1
analytics_database_cassandra_1
control_named_1
control_control_1
control_dns_1
control_nodemgr_1
webui_job_1
webui_web_1
config_devicemgr_1
config_svcmonitor_1
config_dnsmasq_1
config_nodemgr_1
config_api_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-28 18:24:56,648 - DEBUG - [10.0.0.242]: Running cmd : getent hosts 10.0.0.242 | head -n 1 | awk '{print $2}'
2025-10-28 18:24:56,705 - DEBUG - Output : cn-jenkins-deploy-platform-ansible-os-4515-1.
2025-10-28 18:24:56,705 - DEBUG - [10.0.0.242]: Running cmd : ip -4 -o addr show | awk '{print $4}'
2025-10-28 18:24:56,768 - DEBUG - Output : 127.0.0.1/8
10.0.0.242/24
172.17.0.1/16
10.20.0.254/24
2025-10-28 18:24:56,768 - DEBUG - [10.0.0.242]: Running cmd : ip -4 -o addr show dev vhost0 | awk '{print $4}'
2025-10-28 18:24:56,832 - DEBUG - Output : 10.20.0.254/24
2025-10-28 18:24:56,833 - DEBUG - [10.0.0.242]: Running cmd : getent hosts 10.20.0.254 | head -n 1 | awk '{print $2}'
2025-10-28 18:24:56,906 - DEBUG - Output :
2025-10-28 18:24:58,627 - INFO - Using existing project ['default-domain', 'admin'](7d12b033-4477-4e58-87e4-0f293264d8be)
2025-10-28 18:24:58,783 - INFO - ================================================================================
2025-10-28 18:24:58,783 - INFO - STARTING TEST : test_contrail_status
2025-10-28 18:24:58,784 - INFO - TEST DESCRIPTION : Test to verify that all services are running and active
2025-10-28 18:24:58,921 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-28 18:24:58,928 - DEBUG - Nothing to compare xmpp stats {'10.0.0.242': {'10.20.0.254': '0'}} with
2025-10-28 18:24:58,928 - INFO - Initial checks done. Running the testcase now
2025-10-28 18:24:58,928 - INFO -
2025-10-28 18:24:58,928 - DEBUG - [10.0.0.242]: Running cmd : docker ps -f status=running --format {{.Names}} 2>/dev/null
2025-10-28 18:24:59,035 - DEBUG - Output : contrail_test_xuVnrB2j8
vrouter_vrouter-agent_1
vrouter_provisioner_1
vrouter_nodemgr_1
rsyslogd_rsyslogd_1
analytics_snmp_snmp-collector_1
analytics_snmp_topology_1
analytics_snmp_nodemgr_1
analytics_snmp_provisioner_1
analytics_alarm_alarm-gen_1
analytics_alarm_nodemgr_1
analytics_alarm_provisioner_1
analytics_alarm_kafka_1
analytics_api_1
analytics_collector_1
analytics_provisioner_1
analytics_nodemgr_1
analytics_database_query-engine_1
analytics_database_nodemgr_1
analytics_database_provisioner_1
analytics_database_cassandra_1
control_named_1
control_control_1
control_provisioner_1
control_dns_1
control_nodemgr_1
webui_job_1
webui_web_1
config_devicemgr_1
config_provisioner_1
config_svcmonitor_1
config_dnsmasq_1
config_nodemgr_1
config_api_1
config_schema_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-28 18:24:59,036 - INFO - 10.0.0.242
2025-10-28 18:24:59,036 - INFO - config
2025-10-28 18:24:59,041 - INFO - config-nodemgr:active
2025-10-28 18:24:59,046 - INFO - api-server:active
2025-10-28 18:24:59,049 - INFO - schema:active
2025-10-28 18:24:59,053 - INFO - svc-monitor:active
2025-10-28 18:24:59,057 - INFO - device-manager:active
2025-10-28 18:24:59,057 - INFO - config-database
2025-10-28 18:24:59,057 - INFO - config-cassandra:active
2025-10-28 18:24:59,057 - INFO - config-zookeeper:active
2025-10-28 18:24:59,057 - INFO - config-rabbitmq:active
2025-10-28 18:24:59,057 - INFO - vrouter
2025-10-28 18:24:59,061 - INFO - vrouter-nodemgr:active
2025-10-28 18:24:59,065 - INFO - agent:active
2025-10-28 18:24:59,065 - INFO - control
2025-10-28 18:24:59,070 - INFO - control-nodemgr:active
2025-10-28 18:24:59,074 - INFO - control:active
2025-10-28 18:24:59,075 - INFO - named:active
2025-10-28 18:24:59,080 - INFO - dns:active
2025-10-28 18:24:59,080 - INFO - analytics
2025-10-28 18:24:59,085 - INFO - analytics-nodemgr:active
2025-10-28 18:24:59,088 - INFO - analytics-api:active
2025-10-28 18:24:59,093 - INFO - collector:active
2025-10-28 18:24:59,093 - INFO - analytics-database
2025-10-28 18:24:59,093 - INFO - analytics-cassandra:active
2025-10-28 18:24:59,098 - INFO - analyticsdb-nodemgr:active
2025-10-28 18:24:59,104 - INFO - query-engine:active
2025-10-28 18:24:59,104 - INFO - webui
2025-10-28 18:24:59,104 - INFO - webui:active
2025-10-28 18:24:59,104 - INFO - webui-middleware:active
2025-10-28 18:24:59,105 - INFO - redis:active
2025-10-28 18:24:59,105 - INFO - analytics_snmp
2025-10-28 18:24:59,108 - INFO - snmp-collector:active
2025-10-28 18:24:59,108 - INFO - snmp-topology:active
2025-10-28 18:24:59,109 - INFO - analytics_alarm
2025-10-28 18:24:59,109 - INFO - alarmgen:active
2025-10-28 18:24:59,109 - INFO - All the contrail services are up on all nodes
2025-10-28 18:24:59,109 - INFO - contrail-status passed
2025-10-28 18:24:59,230 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-28 18:24:59,235 - DEBUG - No XMPP flaps were noticed during the test
2025-10-28 18:24:59,235 - INFO - END TEST : test_contrail_status : PASSED[0:00:01]
2025-10-28 18:24:59,235 - INFO - --------------------------------------------------------------------------------
2025-10-28 18:25:01,602 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-28 18:25:03,952 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-AnalyticsBasicTestSanity-39828427:ctest-vn22-19411429:ctest-vn22-19411429
2025-10-28 18:25:03,959 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-AnalyticsBasicTestSanity-39828427:ctest-vn22-19411429:ctest-vn22-19411429
2025-10-28 18:25:03,964 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-AnalyticsBasicTestSanity-39828427:ctest-vn22-19411429:ctest-vn22-19411429
2025-10-28 18:25:25,124 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VnListReq?name=default-domain:ctest-AnalyticsBasicTestSanity-39828427:ctest-vn22-19411429
2025-10-28 18:25:25,130 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-AnalyticsBasicTestSanity-39828427:ctest-vn22-19411429:ctest-vn22-19411429
2025-10-28 18:25:25,135 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-AnalyticsBasicTestSanity-39828427:ctest-vn22-19411429:ctest-vn22-19411429
2025-10-28 18:25:25,293 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-28 18:25:26,405 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-28 18:25:26,411 - DEBUG - [10.0.0.242]: Running cmd : docker exec --privileged -it config_api_1 /bin/bash -c 'db-manage check'
2025-10-28 18:25:30,167 - DEBUG - Output : 2025-10-28 18:25:29,346 INFO: (v1.41) Checker check_zk_mode_and_node_count: Success
2025-10-28 18:25:29,378 INFO: (v1.41) Checker check_cassandra_keyspace_replication: Success
2025-10-28 18:25:29,475 INFO: (v1.41) Checker check_obj_mandatory_fields: Success
2025-10-28 18:25:29,662 INFO: (v1.41) Checker check_orphan_resources: Success
2025-10-28 18:25:29,856 INFO: (v1.41) Checker check_fq_name_uuid_match: Success
2025-10-28 18:25:29,856 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-28 18:25:29,958 INFO: (v1.41) Checker check_duplicate_fq_name: Success
2025-10-28 18:25:29,971 INFO: (v1.41) Checker check_route_targets_routing_instance_backrefs: Success
2025-10-28 18:25:29,977 INFO: (v1.41) Checker check_subnet_uuid: Success
2025-10-28 18:25:29,987 ERROR: (v1.41) Checker check_subnet_addr_alloc: Failed:
ZK subnet path '/api-server/subnets' does ends with a valid IP network
2025-10-28 18:25:30,027 INFO: (v1.41) Checker check_route_targets_id: Success
2025-10-28 18:25:30,037 INFO: (v1.41) Checker check_virtual_networks_id: Success
2025-10-28 18:25:30,044 INFO: (v1.41) Checker check_security_groups_id: Success
2025-10-28 18:25:30,047 INFO: (v1.41) Checker check_aggregated_ethernet_id: Success
2025-10-28 18:25:30,331 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-28 18:25:30,531 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-28 18:25:30,694 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-28 18:25:30,858 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-28 18:25:31,026 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-28 18:25:33,643 - INFO - admin user already present
2025-10-28 18:25:34,487 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-28 18:25:36,596 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-FloatingipBasicTestSanity-15656051:ctest-fvn-28352521:ctest-fvn-28352521
2025-10-28 18:25:36,604 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-FloatingipBasicTestSanity-15656051:ctest-fvn-28352521:ctest-fvn-28352521
2025-10-28 18:25:36,608 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-FloatingipBasicTestSanity-15656051:ctest-fvn-28352521:ctest-fvn-28352521
2025-10-28 18:25:37,584 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-FloatingipBasicTestSanity-15656051:ctest-vn1-51917691:ctest-vn1-51917691
2025-10-28 18:25:37,588 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-FloatingipBasicTestSanity-15656051:ctest-vn1-51917691:ctest-vn1-51917691
2025-10-28 18:25:37,594 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-FloatingipBasicTestSanity-15656051:ctest-vn1-51917691:ctest-vn1-51917691
2025-10-28 18:25:46,350 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:da32efcb-1794-4a38-bdc6-482862a7d0b8
2025-10-28 18:25:46,356 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-FloatingipBasicTestSanity-15656051:ctest-vn1-51917691:ctest-vn1-51917691
2025-10-28 18:25:46,361 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:da32efcb-1794-4a38-bdc6-482862a7d0b8
2025-10-28 18:25:52,250 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:8e5215d0-6d54-45c8-a5dd-945a204085b3
2025-10-28 18:25:52,255 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-FloatingipBasicTestSanity-15656051:ctest-fvn-28352521:ctest-fvn-28352521
2025-10-28 18:25:52,260 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:8e5215d0-6d54-45c8-a5dd-945a204085b3
2025-10-28 18:25:53,795 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:da32efcb-1794-4a38-bdc6-482862a7d0b8
2025-10-28 18:25:53,802 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VnListReq?name=default-domain:ctest-FloatingipBasicTestSanity-15656051:ctest-fvn-28352521
2025-10-28 18:25:53,809 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-FloatingipBasicTestSanity-15656051:ctest-fvn-28352521:ctest-fvn-28352521
2025-10-28 18:25:53,814 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_Inet4UcRouteReq?x=3
2025-10-28 18:25:59,533 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VnListReq?name=default-domain:ctest-FloatingipBasicTestSanity-15656051:ctest-vn1-51917691
2025-10-28 18:25:59,538 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-FloatingipBasicTestSanity-15656051:ctest-vn1-51917691:ctest-vn1-51917691
2025-10-28 18:25:59,543 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-FloatingipBasicTestSanity-15656051:ctest-vn1-51917691:ctest-vn1-51917691
2025-10-28 18:25:59,804 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VnListReq?name=default-domain:ctest-FloatingipBasicTestSanity-15656051:ctest-fvn-28352521
2025-10-28 18:25:59,809 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-FloatingipBasicTestSanity-15656051:ctest-fvn-28352521:ctest-fvn-28352521
2025-10-28 18:25:59,814 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-FloatingipBasicTestSanity-15656051:ctest-fvn-28352521:ctest-fvn-28352521
2025-10-28 18:26:00,076 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-28 18:26:03,622 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-28 18:26:04,027 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-28 18:26:10,937 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-28 18:26:13,438 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-28 18:26:16,817 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-28 18:26:19,021 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-28 18:26:19,327 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-28 18:26:26,591 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:ac85b2d5-3950-4c3b-8bd9-5e01930c1562
2025-10-28 18:26:26,597 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestPorts-93448591:ctest-vn1-40196071:ctest-vn1-40196071
2025-10-28 18:26:26,602 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:ac85b2d5-3950-4c3b-8bd9-5e01930c1562
2025-10-28 18:26:34,543 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:80d742ca-21c7-4662-a496-da801c6eca36
2025-10-28 18:26:34,548 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestPorts-93448591:ctest-vn1-40196071:ctest-vn1-40196071
2025-10-28 18:26:34,554 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:80d742ca-21c7-4662-a496-da801c6eca36
2025-10-28 18:26:40,810 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-28 18:26:44,753 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-28 18:26:54,805 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:943f404b-7c03-4827-b7ce-1914bbba9fdb
2025-10-28 18:26:54,812 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestRouters-59631707:ctest-vn1-57671620:ctest-vn1-57671620
2025-10-28 18:26:54,818 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:943f404b-7c03-4827-b7ce-1914bbba9fdb
2025-10-28 18:27:00,773 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:7c7ca408-dd87-4cb7-b8d6-59dd45413f13
2025-10-28 18:27:00,782 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestRouters-59631707:ctest-vn2-93674453:ctest-vn2-93674453
2025-10-28 18:27:00,790 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:7c7ca408-dd87-4cb7-b8d6-59dd45413f13
2025-10-28 18:27:22,932 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-28 18:27:26,265 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-28 18:27:37,074 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:ce191b62-8b1d-481c-a024-303cf011f937
2025-10-28 18:27:37,080 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestRoutersBasic-93553276:ctest-vn-05422396:ctest-vn-05422396
2025-10-28 18:27:37,086 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:ce191b62-8b1d-481c-a024-303cf011f937
2025-10-28 18:27:43,059 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:02d3f267-2323-4159-9074-033f8962fa25
2025-10-28 18:27:43,067 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestRoutersBasic-93553276:ctest-ext_vn-66366589:ctest-ext_vn-66366589
2025-10-28 18:27:43,072 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:02d3f267-2323-4159-9074-033f8962fa25
2025-10-28 18:27:51,227 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-28 18:27:54,425 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-28 18:27:57,971 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-89054190:ctest-vn-04642371:ctest-vn-04642371
2025-10-28 18:27:57,976 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-89054190:ctest-vn-04642371:ctest-vn-04642371
2025-10-28 18:27:57,980 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-89054190:ctest-vn-04642371:ctest-vn-04642371
2025-10-28 18:27:58,313 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-89054190:ctest-vn-15339099:ctest-vn-15339099
2025-10-28 18:27:58,319 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-89054190:ctest-vn-15339099:ctest-vn-15339099
2025-10-28 18:27:58,323 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-89054190:ctest-vn-15339099:ctest-vn-15339099
2025-10-28 18:27:58,864 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VnListReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-89054190:ctest-vn-15339099
2025-10-28 18:27:58,868 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-89054190:ctest-vn-15339099:ctest-vn-15339099
2025-10-28 18:27:58,872 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-89054190:ctest-vn-15339099:ctest-vn-15339099
2025-10-28 18:27:59,136 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VnListReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-89054190:ctest-vn-04642371
2025-10-28 18:27:59,140 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-89054190:ctest-vn-04642371:ctest-vn-04642371
2025-10-28 18:27:59,144 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-89054190:ctest-vn-04642371:ctest-vn-04642371
2025-10-28 18:27:59,409 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-28 18:28:02,772 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-28 18:28:03,079 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-28 18:28:05,797 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyNegativeIpv4v6-97839001:ctest-vn4-80646003:ctest-vn4-80646003
2025-10-28 18:28:05,803 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyNegativeIpv4v6-97839001:ctest-vn4-80646003:ctest-vn4-80646003
2025-10-28 18:28:05,807 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyNegativeIpv4v6-97839001:ctest-vn4-80646003:ctest-vn4-80646003
2025-10-28 18:28:06,191 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VnListReq?name=default-domain:ctest-TestBasicPolicyNegativeIpv4v6-97839001:ctest-vn4-80646003
2025-10-28 18:28:06,198 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyNegativeIpv4v6-97839001:ctest-vn4-80646003:ctest-vn4-80646003
2025-10-28 18:28:06,203 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyNegativeIpv4v6-97839001:ctest-vn4-80646003:ctest-vn4-80646003
2025-10-28 18:28:06,668 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-28 18:28:06,956 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-28 18:28:10,241 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-28 18:28:13,572 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicy-84170789:ctest-vn-16442067:ctest-vn-16442067
2025-10-28 18:28:13,577 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicy-84170789:ctest-vn-16442067:ctest-vn-16442067
2025-10-28 18:28:13,581 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicy-84170789:ctest-vn-16442067:ctest-vn-16442067
2025-10-28 18:28:13,883 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicy-84170789:ctest-vn-54955292:ctest-vn-54955292
2025-10-28 18:28:13,888 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicy-84170789:ctest-vn-54955292:ctest-vn-54955292
2025-10-28 18:28:13,893 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicy-84170789:ctest-vn-54955292:ctest-vn-54955292
2025-10-28 18:28:21,522 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:7a64a726-4c29-41ea-9ff6-3a6aa9c6c787
2025-10-28 18:28:21,528 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicy-84170789:ctest-vn-16442067:ctest-vn-16442067
2025-10-28 18:28:21,533 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:7a64a726-4c29-41ea-9ff6-3a6aa9c6c787
2025-10-28 18:28:27,522 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:a6e73403-94ae-4c47-b845-de7ae0b10119
2025-10-28 18:28:27,528 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicy-84170789:ctest-vn-54955292:ctest-vn-54955292
2025-10-28 18:28:27,534 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:a6e73403-94ae-4c47-b845-de7ae0b10119
2025-10-28 18:28:44,407 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VnListReq?name=default-domain:ctest-TestBasicPolicy-84170789:ctest-vn-54955292
2025-10-28 18:28:44,413 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicy-84170789:ctest-vn-54955292:ctest-vn-54955292
2025-10-28 18:28:44,419 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicy-84170789:ctest-vn-54955292:ctest-vn-54955292
2025-10-28 18:28:44,691 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VnListReq?name=default-domain:ctest-TestBasicPolicy-84170789:ctest-vn-16442067
2025-10-28 18:28:44,696 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicy-84170789:ctest-vn-16442067:ctest-vn-16442067
2025-10-28 18:28:44,701 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicy-84170789:ctest-vn-16442067:ctest-vn-16442067
2025-10-28 18:28:44,964 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-28 18:28:48,293 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-28 18:28:58,096 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:1c59fd78-e5b4-4685-9a7d-ff98a45f6592
2025-10-28 18:28:58,102 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestRP-40866520:ctest-bgpaas_vn-72801664:ctest-bgpaas_vn-72801664
2025-10-28 18:28:58,107 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:1c59fd78-e5b4-4685-9a7d-ff98a45f6592
2025-10-28 18:29:04,055 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:bd41cfaa-3be1-4ece-8ed3-ea3fef3d91e2
2025-10-28 18:29:04,061 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestRP-40866520:ctest-bgpaas_vn-14714361:ctest-bgpaas_vn-14714361
2025-10-28 18:29:04,066 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:bd41cfaa-3be1-4ece-8ed3-ea3fef3d91e2
2025-10-28 18:29:05,753 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-28 18:29:12,188 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-28 18:29:15,560 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-28 18:29:17,507 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-83725083:ctest-mgmt_vn-60310306:ctest-mgmt_vn-60310306
2025-10-28 18:29:17,513 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-83725083:ctest-mgmt_vn-60310306:ctest-mgmt_vn-60310306
2025-10-28 18:29:17,519 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-83725083:ctest-mgmt_vn-60310306:ctest-mgmt_vn-60310306
2025-10-28 18:29:18,419 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-83725083:ctest-left_vn-44940923:ctest-left_vn-44940923
2025-10-28 18:29:18,426 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-83725083:ctest-left_vn-44940923:ctest-left_vn-44940923
2025-10-28 18:29:18,431 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-83725083:ctest-left_vn-44940923:ctest-left_vn-44940923
2025-10-28 18:29:19,311 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-83725083:ctest-right_vn-89877194:ctest-right_vn-89877194
2025-10-28 18:29:19,316 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-83725083:ctest-right_vn-89877194:ctest-right_vn-89877194
2025-10-28 18:29:19,321 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-83725083:ctest-right_vn-89877194:ctest-right_vn-89877194
2025-10-28 18:29:29,780 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:18ba9ae9-d0f3-4da3-be69-ff130816dca9
2025-10-28 18:29:29,788 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-83725083:ctest-mgmt_vn-60310306:ctest-mgmt_vn-60310306
2025-10-28 18:29:29,796 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:4448df03-9b23-4204-ac61-387b2598cc11
2025-10-28 18:29:29,802 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-83725083:ctest-left_vn-44940923:ctest-left_vn-44940923
2025-10-28 18:29:29,808 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:3ab76f10-6ee0-4637-9f17-dd0db34a20f0
2025-10-28 18:29:29,816 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-83725083:ctest-right_vn-89877194:ctest-right_vn-89877194
2025-10-28 18:29:29,824 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:18ba9ae9-d0f3-4da3-be69-ff130816dca9
2025-10-28 18:29:29,834 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:3ab76f10-6ee0-4637-9f17-dd0db34a20f0
2025-10-28 18:29:29,839 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:4448df03-9b23-4204-ac61-387b2598cc11
2025-10-28 18:30:05,229 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:162390a2-047e-4b01-9171-a703e098dbc0
2025-10-28 18:30:05,234 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-83725083:ctest-left_vn-44940923:ctest-left_vn-44940923
2025-10-28 18:30:05,239 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:162390a2-047e-4b01-9171-a703e098dbc0
2025-10-28 18:30:07,053 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:9dae8b47-b37a-41dc-8cdb-f159dd80bbb8
2025-10-28 18:30:07,060 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-83725083:ctest-right_vn-89877194:ctest-right_vn-89877194
2025-10-28 18:30:07,065 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:9dae8b47-b37a-41dc-8cdb-f159dd80bbb8
2025-10-28 18:30:11,714 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:18ba9ae9-d0f3-4da3-be69-ff130816dca9
2025-10-28 18:30:11,720 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:3ab76f10-6ee0-4637-9f17-dd0db34a20f0
2025-10-28 18:30:11,725 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:4448df03-9b23-4204-ac61-387b2598cc11
2025-10-28 18:30:12,961 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VnListReq?name=default-domain:ctest-TestSvcRegr-83725083:ctest-left_vn-44940923
2025-10-28 18:30:12,967 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:4448df03-9b23-4204-ac61-387b2598cc11
2025-10-28 18:30:12,973 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,
2025-10-28 18:30:12,982 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-83725083:ctest-left_vn-44940923:ctest-left_vn-44940923
2025-10-28 18:30:13,137 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_Inet4UcRouteReq?x=2
2025-10-28 18:30:13,349 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_Layer2RouteReq?x=2
2025-10-28 18:30:13,360 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VnListReq?name=default-domain:ctest-TestSvcRegr-83725083:ctest-left_vn-44940923
2025-10-28 18:30:13,364 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-83725083:ctest-left_vn-44940923:ctest-left_vn-44940923
2025-10-28 18:30:13,569 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_Inet4UcRouteReq?x=2
2025-10-28 18:30:13,777 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_Layer2RouteReq?x=2
2025-10-28 18:30:13,788 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VnListReq?name=default-domain:ctest-TestSvcRegr-83725083:ctest-mgmt_vn-60310306
2025-10-28 18:30:13,793 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:18ba9ae9-d0f3-4da3-be69-ff130816dca9
2025-10-28 18:30:13,799 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,
2025-10-28 18:30:13,808 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-83725083:ctest-mgmt_vn-60310306:ctest-mgmt_vn-60310306
2025-10-28 18:30:14,005 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_Inet4UcRouteReq?x=4
2025-10-28 18:30:14,213 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_Layer2RouteReq?x=4
2025-10-28 18:30:14,224 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VnListReq?name=default-domain:ctest-TestSvcRegr-83725083:ctest-mgmt_vn-60310306
2025-10-28 18:30:14,229 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-83725083:ctest-mgmt_vn-60310306:ctest-mgmt_vn-60310306
2025-10-28 18:30:14,429 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_Inet4UcRouteReq?x=4
2025-10-28 18:30:14,641 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_Layer2RouteReq?x=4
2025-10-28 18:30:14,651 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VnListReq?name=default-domain:ctest-TestSvcRegr-83725083:ctest-right_vn-89877194
2025-10-28 18:30:14,657 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:3ab76f10-6ee0-4637-9f17-dd0db34a20f0
2025-10-28 18:30:14,665 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,
2025-10-28 18:30:14,674 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-83725083:ctest-right_vn-89877194:ctest-right_vn-89877194
2025-10-28 18:30:14,829 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_Inet4UcRouteReq?x=3
2025-10-28 18:30:15,033 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_Layer2RouteReq?x=3
2025-10-28 18:30:15,045 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VnListReq?name=default-domain:ctest-TestSvcRegr-83725083:ctest-right_vn-89877194
2025-10-28 18:30:15,051 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-83725083:ctest-right_vn-89877194:ctest-right_vn-89877194
2025-10-28 18:30:15,249 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_Inet4UcRouteReq?x=3
2025-10-28 18:30:15,453 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_Layer2RouteReq?x=3
2025-10-28 18:30:15,973 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=
2025-10-28 18:30:15,979 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_Inet4UcRouteReq?x=5
2025-10-28 18:30:15,987 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:4448df03-9b23-4204-ac61-387b2598cc11
2025-10-28 18:30:16,141 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=
2025-10-28 18:30:16,147 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_Inet4UcRouteReq?x=6
2025-10-28 18:30:16,155 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:3ab76f10-6ee0-4637-9f17-dd0db34a20f0
2025-10-28 18:30:23,571 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VnListReq?name=default-domain:ctest-TestSvcRegr-83725083:ctest-right_vn-89877194
2025-10-28 18:30:23,576 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-83725083:ctest-right_vn-89877194:ctest-right_vn-89877194
2025-10-28 18:30:23,581 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-83725083:ctest-right_vn-89877194:ctest-right_vn-89877194
2025-10-28 18:30:23,819 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VnListReq?name=default-domain:ctest-TestSvcRegr-83725083:ctest-left_vn-44940923
2025-10-28 18:30:23,823 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-83725083:ctest-left_vn-44940923:ctest-left_vn-44940923
2025-10-28 18:30:23,828 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-83725083:ctest-left_vn-44940923:ctest-left_vn-44940923
2025-10-28 18:30:24,098 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VnListReq?name=default-domain:ctest-TestSvcRegr-83725083:ctest-mgmt_vn-60310306
2025-10-28 18:30:24,102 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-83725083:ctest-mgmt_vn-60310306:ctest-mgmt_vn-60310306
2025-10-28 18:30:24,108 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-83725083:ctest-mgmt_vn-60310306:ctest-mgmt_vn-60310306
2025-10-28 18:30:24,377 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-28 18:30:27,765 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-28 18:30:36,576 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:a2e9e852-1ec8-406b-9381-e2d097d0b1d0
2025-10-28 18:30:36,583 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestvDNSBasic0-40808191:ctest-vn1-vdns-74883418:ctest-vn1-vdns-74883418
2025-10-28 18:30:36,587 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:a2e9e852-1ec8-406b-9381-e2d097d0b1d0
2025-10-28 18:30:48,533 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_DnsInfo?
2025-10-28 18:30:55,090 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:8b8e0c3c-9c66-494e-a65e-b51b6cba1523
2025-10-28 18:30:55,095 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestvDNSBasic0-40808191:ctest-vn1-vdns-74883418:ctest-vn1-vdns-74883418
2025-10-28 18:30:55,101 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:8b8e0c3c-9c66-494e-a65e-b51b6cba1523
2025-10-28 18:31:09,032 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_DnsInfo?
2025-10-28 18:31:20,161 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-28 18:31:23,485 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-28 18:31:32,424 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:6569e46e-f816-4405-9cbb-d3607f6de0c7
2025-10-28 18:31:32,430 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicVMVNx-89630940:ctest-vn-85309035:ctest-vn-85309035
2025-10-28 18:31:32,441 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:6569e46e-f816-4405-9cbb-d3607f6de0c7
2025-10-28 18:31:38,431 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:562ea7ac-4fd4-4f8f-8438-488192a32baa
2025-10-28 18:31:38,436 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicVMVNx-89630940:ctest-vn-85309035:ctest-vn-85309035
2025-10-28 18:31:38,441 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:562ea7ac-4fd4-4f8f-8438-488192a32baa
2025-10-28 18:31:47,252 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-28 18:31:50,588 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-28 18:31:57,918 - DEBUG - [10.0.0.242]: Running cmd : docker exec --privileged -it vrouter_vrouter-agent_1 /bin/bash -c 'echo "10.20.0.254 cn-jenkins-deploy-platform-ansible-os-4515-1-test" >> /etc/hosts'
2025-10-28 18:31:58,026 - DEBUG - Output :
2025-10-28 18:31:58,528 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:0a737979-faac-425a-abc8-4b930d602eb9
2025-10-28 18:31:58,534 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicVMVN-69563774:ctest-vn2_metadata-45932863:ctest-vn2_metadata-45932863
2025-10-28 18:31:58,539 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:0a737979-faac-425a-abc8-4b930d602eb9
2025-10-28 18:32:10,975 - DEBUG - [10.0.0.242]: Running cmd : docker exec --privileged -it vrouter_vrouter-agent_1 /bin/bash -c 'sed -i '$ d' /etc/hosts'
2025-10-28 18:32:11,117 - DEBUG - Output : sed: -e expression #1, char 1: missing command
2025-10-28 18:32:13,734 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-28 18:32:14,024 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-28 18:32:20,957 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:dc8e8daf-4d8a-4dde-8fac-69625e100205
2025-10-28 18:32:20,965 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicVMVN-69563774:ctest-vn-54141110:ctest-vn-54141110
2025-10-28 18:32:20,973 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:dc8e8daf-4d8a-4dde-8fac-69625e100205
2025-10-28 18:32:37,892 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-28 18:32:38,195 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-28 18:32:42,988 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicVMVN-69563774:ctest-vn-25773002:ctest-vn-25773002
2025-10-28 18:32:43,309 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:8c0cf588-f649-4f86-a952-48037a81d6eb
2025-10-28 18:32:43,317 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicVMVN-69563774:ctest-vn-25773002:ctest-vn-25773002
2025-10-28 18:32:43,323 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:8c0cf588-f649-4f86-a952-48037a81d6eb
2025-10-28 18:32:53,463 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:5064613f-dde5-4381-96c0-5adbb2dd65d5
2025-10-28 18:32:53,469 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicVMVN-69563774:ctest-vn-25773002:ctest-vn-25773002
2025-10-28 18:32:53,474 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:5064613f-dde5-4381-96c0-5adbb2dd65d5
2025-10-28 18:32:55,236 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:7089fecd-4c96-4e23-9084-f1315b17204a
2025-10-28 18:32:55,241 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicVMVN-69563774:ctest-vn-25773002:ctest-vn-25773002
2025-10-28 18:32:55,246 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:7089fecd-4c96-4e23-9084-f1315b17204a
2025-10-28 18:33:15,280 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VnListReq?name=default-domain:ctest-TestBasicVMVN-69563774:ctest-vn-25773002
2025-10-28 18:33:15,285 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicVMVN-69563774:ctest-vn-25773002:ctest-vn-25773002
2025-10-28 18:33:15,290 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_VrfListReq?name=
2025-10-28 18:33:15,296 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_KRouteReq?x=2
2025-10-28 18:33:15,302 - DEBUG - Unable to fetch route details in vrouter for vrf index 2, Got :[]
2025-10-28 18:33:15,657 - DEBUG - Requesting: http://10.0.0.242:8085/Snh_AgentXmppConnectionStatusReq?
2025-10-28 18:35:23,200 - INFO - Using existing project ['default-domain', 'admin'](7d12b033-4477-4e58-87e4-0f293264d8be)
2025-10-28 18:35:23,208 - INFO - ================================================================================
2025-10-28 18:35:23,209 - INFO - STARTING TEST : test_contrail_status
2025-10-28 18:35:23,209 - INFO - TEST DESCRIPTION : Test to verify that all services are running and active
2025-10-28 18:35:23,334 - DEBUG - Skipping xmpp flap check
2025-10-28 18:35:23,334 - INFO - Initial checks done. Running the testcase now
2025-10-28 18:35:23,334 - INFO -
2025-10-28 18:35:23,452 - INFO - 10.0.0.242
2025-10-28 18:35:23,452 - INFO - config
2025-10-28 18:35:23,458 - INFO - config-nodemgr:active
2025-10-28 18:35:23,463 - INFO - api-server:active
2025-10-28 18:35:23,466 - INFO - schema:active
2025-10-28 18:35:23,470 - INFO - svc-monitor:active
2025-10-28 18:35:23,473 - INFO - device-manager:active
2025-10-28 18:35:23,474 - INFO - config-database
2025-10-28 18:35:23,474 - INFO - config-cassandra:active
2025-10-28 18:35:23,474 - INFO - config-zookeeper:active
2025-10-28 18:35:23,474 - INFO - config-rabbitmq:active
2025-10-28 18:35:23,474 - INFO - vrouter
2025-10-28 18:35:23,478 - INFO - vrouter-nodemgr:active
2025-10-28 18:35:23,482 - INFO - agent:active
2025-10-28 18:35:23,482 - INFO - control
2025-10-28 18:35:23,486 - INFO - control-nodemgr:active
2025-10-28 18:35:23,490 - INFO - control:active
2025-10-28 18:35:23,490 - INFO - named:active
2025-10-28 18:35:23,494 - INFO - dns:active
2025-10-28 18:35:23,494 - INFO - analytics
2025-10-28 18:35:23,498 - INFO - analytics-nodemgr:active
2025-10-28 18:35:23,502 - INFO - analytics-api:active
2025-10-28 18:35:23,507 - INFO - collector:active
2025-10-28 18:35:23,507 - INFO - analytics-database
2025-10-28 18:35:23,507 - INFO - analytics-cassandra:active
2025-10-28 18:35:23,512 - INFO - analyticsdb-nodemgr:active
2025-10-28 18:35:23,517 - INFO - query-engine:active
2025-10-28 18:35:23,518 - INFO - webui
2025-10-28 18:35:23,518 - INFO - webui:active
2025-10-28 18:35:23,518 - INFO - webui-middleware:active
2025-10-28 18:35:23,518 - INFO - redis:active
2025-10-28 18:35:23,518 - INFO - analytics_snmp
2025-10-28 18:35:23,522 - INFO - snmp-collector:active
2025-10-28 18:35:23,522 - INFO - snmp-topology:active
2025-10-28 18:35:23,522 - INFO - analytics_alarm
2025-10-28 18:35:23,522 - INFO - alarmgen:active
2025-10-28 18:35:23,522 - INFO - All the contrail services are up on all nodes
2025-10-28 18:35:23,522 - INFO - contrail-status passed
2025-10-28 18:35:23,645 - DEBUG - Skipping xmpp flap check
2025-10-28 18:35:23,645 - INFO - END TEST : test_contrail_status : PASSED[0:00:00]
2025-10-28 18:35:23,646 - INFO - --------------------------------------------------------------------------------