2025-08-18 15:35:08,473 - DEBUG - [10.0.0.254]: Running cmd : hostname 2025-08-18 15:35:09,017 - DEBUG - Output : cn-jenkins-deploy-platform-ansible-os-3878-1 2025-08-18 15:35:09,017 - DEBUG - [10.0.0.254]: Running cmd : hostname -f 2025-08-18 15:35:09,076 - DEBUG - Output : cn-jenkins-deploy-platform-ansible-os-3878-1. 2025-08-18 15:35:09,076 - DEBUG - [10.0.0.254]: Running cmd : docker ps 2>/dev/null | grep -v "/pause\|/usr/bin/pod\|nova_api_\|contrail.*init\|init.*contrail\|provisioner\|placement" | awk '{print $NF}' 2025-08-18 15:35:09,177 - DEBUG - Output : NAMES contrail_test_SQ8nqTqeS 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_nodemgr_1 analytics_alarm_alarm-gen_1 analytics_alarm_kafka_1 analytics_nodemgr_1 analytics_collector_1 analytics_api_1 analytics_database_nodemgr_1 analytics_database_query-engine_1 analytics_database_cassandra_1 control_named_1 control_nodemgr_1 control_dns_1 control_control_1 webui_job_1 webui_web_1 config_devicemgr_1 config_schema_1 config_nodemgr_1 config_api_1 config_svcmonitor_1 config_dnsmasq_1 config_database_nodemgr_1 config_database_rabbitmq_1 config_database_zookeeper_1 config_database_cassandra_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-08-18 15:35:09,177 - DEBUG - [10.0.0.254]: Running cmd : getent hosts 10.0.0.254 | head -n 1 | awk '{print $2}' 2025-08-18 15:35:09,236 - DEBUG - Output : cn-jenkins-deploy-platform-ansible-os-3878-1. 2025-08-18 15:35:09,236 - DEBUG - [10.0.0.254]: Running cmd : ip -4 -o addr show | awk '{print $4}' 2025-08-18 15:35:09,300 - DEBUG - Output : 127.0.0.1/8 172.17.0.1/16 10.0.0.254/24 2025-08-18 15:35:09,300 - DEBUG - [10.0.0.254]: Running cmd : ip -4 -o addr show dev vhost0 | awk '{print $4}' 2025-08-18 15:35:09,364 - DEBUG - Output : 10.0.0.254/24 2025-08-18 15:35:11,201 - INFO - Using existing project ['default-domain', 'admin'](424872b8-35a4-403e-b480-f7f7a3ba4af3) 2025-08-18 15:35:11,356 - INFO - ================================================================================ 2025-08-18 15:35:11,356 - INFO - STARTING TEST : test_contrail_status 2025-08-18 15:35:11,356 - INFO - TEST DESCRIPTION : Test to verify that all services are running and active 2025-08-18 15:35:11,484 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq? 2025-08-18 15:35:11,491 - DEBUG - Nothing to compare xmpp stats {'10.0.0.254': {'10.0.0.254': '0'}} with 2025-08-18 15:35:11,491 - INFO - Initial checks done. Running the testcase now 2025-08-18 15:35:11,491 - INFO - 2025-08-18 15:35:11,491 - DEBUG - [10.0.0.254]: Running cmd : docker ps -f status=running --format {{.Names}} 2>/dev/null 2025-08-18 15:35:11,576 - DEBUG - Output : contrail_test_SQ8nqTqeS vrouter_vrouter-agent_1 vrouter_provisioner_1 vrouter_nodemgr_1 rsyslogd_rsyslogd_1 analytics_snmp_snmp-collector_1 analytics_snmp_provisioner_1 analytics_snmp_topology_1 analytics_snmp_nodemgr_1 analytics_alarm_provisioner_1 analytics_alarm_nodemgr_1 analytics_alarm_alarm-gen_1 analytics_alarm_kafka_1 analytics_nodemgr_1 analytics_collector_1 analytics_provisioner_1 analytics_api_1 analytics_database_nodemgr_1 analytics_database_query-engine_1 analytics_database_provisioner_1 analytics_database_cassandra_1 control_named_1 control_nodemgr_1 control_dns_1 control_control_1 control_provisioner_1 webui_job_1 webui_web_1 config_devicemgr_1 config_provisioner_1 config_schema_1 config_nodemgr_1 config_api_1 config_svcmonitor_1 config_dnsmasq_1 config_database_nodemgr_1 config_database_provisioner_1 config_database_rabbitmq_1 config_database_zookeeper_1 config_database_cassandra_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-08-18 15:35:11,576 - INFO - 10.0.0.254 2025-08-18 15:35:11,576 - INFO - config 2025-08-18 15:35:11,581 - INFO - config-nodemgr:active 2025-08-18 15:35:11,584 - INFO - api-server:active 2025-08-18 15:35:11,588 - INFO - schema:active 2025-08-18 15:35:11,591 - INFO - svc-monitor:active 2025-08-18 15:35:11,595 - INFO - device-manager:active 2025-08-18 15:35:11,595 - INFO - config-database 2025-08-18 15:35:11,595 - INFO - config-cassandra:active 2025-08-18 15:35:11,595 - INFO - config-zookeeper:active 2025-08-18 15:35:11,595 - INFO - config-rabbitmq:active 2025-08-18 15:35:11,595 - INFO - vrouter 2025-08-18 15:35:11,599 - INFO - vrouter-nodemgr:active 2025-08-18 15:35:11,603 - INFO - agent:active 2025-08-18 15:35:11,603 - INFO - control 2025-08-18 15:35:11,607 - INFO - control-nodemgr:active 2025-08-18 15:35:11,611 - INFO - control:active 2025-08-18 15:35:11,611 - INFO - named:active 2025-08-18 15:35:11,615 - INFO - dns:active 2025-08-18 15:35:11,615 - INFO - analytics 2025-08-18 15:35:11,619 - INFO - analytics-nodemgr:active 2025-08-18 15:35:11,623 - INFO - analytics-api:active 2025-08-18 15:35:11,627 - INFO - collector:active 2025-08-18 15:35:11,627 - INFO - analytics-database 2025-08-18 15:35:11,627 - INFO - analytics-cassandra:active 2025-08-18 15:35:11,631 - INFO - analyticsdb-nodemgr:active 2025-08-18 15:35:11,635 - INFO - query-engine:active 2025-08-18 15:35:11,635 - INFO - webui 2025-08-18 15:35:11,636 - INFO - webui:active 2025-08-18 15:35:11,636 - INFO - webui-middleware:active 2025-08-18 15:35:11,636 - INFO - redis:active 2025-08-18 15:35:11,636 - INFO - analytics_snmp 2025-08-18 15:35:11,639 - INFO - snmp-collector:active 2025-08-18 15:35:11,639 - INFO - snmp-topology:active 2025-08-18 15:35:11,639 - INFO - analytics_alarm 2025-08-18 15:35:11,639 - INFO - alarmgen:active 2025-08-18 15:35:11,639 - INFO - All the contrail services are up on all nodes 2025-08-18 15:35:11,639 - INFO - contrail-status passed 2025-08-18 15:35:11,758 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq? 2025-08-18 15:35:11,763 - DEBUG - No XMPP flaps were noticed during the test
2025-08-18 15:35:11,763 - INFO - END TEST : test_contrail_status : PASSED[0:00:00]
2025-08-18 15:35:11,763 - INFO - -------------------------------------------------------------------------------- 2025-08-18 15:35:14,738 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq? 2025-08-18 15:35:16,979 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-AnalyticsBasicTestSanity-43337926:ctest-vn22-02719787:ctest-vn22-02719787 2025-08-18 15:35:16,985 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-AnalyticsBasicTestSanity-43337926:ctest-vn22-02719787:ctest-vn22-02719787 2025-08-18 15:35:16,989 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-AnalyticsBasicTestSanity-43337926:ctest-vn22-02719787:ctest-vn22-02719787 2025-08-18 15:35:38,197 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VnListReq?name=default-domain:ctest-AnalyticsBasicTestSanity-43337926:ctest-vn22-02719787 2025-08-18 15:35:38,204 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-AnalyticsBasicTestSanity-43337926:ctest-vn22-02719787:ctest-vn22-02719787 2025-08-18 15:35:38,211 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-AnalyticsBasicTestSanity-43337926:ctest-vn22-02719787:ctest-vn22-02719787 2025-08-18 15:35:38,352 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq? 2025-08-18 15:35:39,419 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq? 2025-08-18 15:35:39,425 - DEBUG - [10.0.0.254]: Running cmd : docker exec --privileged -it config_api_1 /bin/bash -c 'db-manage check' 2025-08-18 15:35:43,981 - DEBUG - Output : 2025-08-18 15:35:41,972 INFO: (v1.41) Checker check_zk_mode_and_node_count: Success 2025-08-18 15:35:41,990 INFO: (v1.41) Checker check_cassandra_keyspace_replication: Success 2025-08-18 15:35:42,358 INFO: (v1.41) Checker check_obj_mandatory_fields: Success 2025-08-18 15:35:42,874 INFO: (v1.41) Checker check_orphan_resources: Success 2025-08-18 15:35:43,373 INFO: (v1.41) Checker check_fq_name_uuid_match: Success 2025-08-18 15:35:43,373 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-08-18 15:35:43,608 INFO: (v1.41) Checker check_duplicate_fq_name: Success 2025-08-18 15:35:43,621 INFO: (v1.41) Checker check_route_targets_routing_instance_backrefs: Success 2025-08-18 15:35:43,633 INFO: (v1.41) Checker check_subnet_uuid: Success 2025-08-18 15:35:43,673 ERROR: (v1.41) Checker check_subnet_addr_alloc: Exception, NameError Python 3.9.21: /usr/bin/python3 Mon Aug 18 15:35:43 2025 A problem occurred in a Python script. Here is the sequence of function calls leading up to the error, in the order they occurred. /usr/local/lib/python3.9/site-packages/vnc_cfg_api_server/db_manage.py in wrapper(*args=(,), **kwargs={}) 1547 self = args[0] 1548 try: 1549 errors = func(*args, **kwargs) 1550 if not errors: 1551 self._logger.info('(v%s) Checker %s: Success', __version__, errors undefined func = args = (,) kwargs = {} /usr/local/lib/python3.9/site-packages/vnc_cfg_api_server/db_manage.py in check_subnet_addr_alloc(self=) 1861 # whether ip allocated in subnet in zk match iip+fip in cassandra 1862 (zk_all_vns, cassandra_all_vns, duplicate_ips, 1863 ret_errors, stale_zk_path) = self.audit_subnet_addr_alloc() 1864 1865 # check stale ZK subnet path ret_errors undefined stale_zk_path undefined self = self.audit_subnet_addr_alloc = > /usr/local/lib/python3.9/site-packages/vnc_cfg_api_server/db_manage.py in audit_subnet_addr_alloc(self=) 1179 self.base_subnet_zk_path) 1180 num_addrs = 0 1181 for subnet_path in self._subnet_path_discovery( 1182 ret_errors, stale_zk_path): 1183 if subnet_path.startswith("%s/" % self.base_subnet_zk_path): subnet_path undefined self = self._subnet_path_discovery = > ret_errors = [] stale_zk_path = [] /usr/local/lib/python3.9/site-packages/vnc_cfg_api_server/db_manage.py in _subnet_path_discovery(self=, ret_errors=[], stale_zk_path=[]) 1167 subnet_paths.add(path) 1168 1169 deep_path_discovery(self.base_subnet_zk_path) 1170 return subnet_paths 1171 deep_path_discovery = .deep_path_discovery> self = self.base_subnet_zk_path = '/api-server/subnets' /usr/local/lib/python3.9/site-packages/vnc_cfg_api_server/db_manage.py in deep_path_discovery(path='/api-server/subnets') 1154 except AddrFormatError: 1155 try: 1156 suffixes = zk_children_with_retry(path) 1157 except kazoo.exceptions.NoNodeError: 1158 self._logger.debug("ZK subnet path '%s' does not exits" % suffixes undefined zk_children_with_retry = .zk_children_with_retry> path = '/api-server/subnets' /usr/local/lib/python3.9/site-packages/vnc_cfg_api_server/db_manage.py in zk_children_with_retry(path='/api-server/subnets', retries=5, delay=0.2) 1147 if kids or attempt == retries - 1: 1148 return kids 1149 time.sleep(delay) 1150 1151 def deep_path_discovery(path): time undefined delay = 0.2 NameError: name 'time' is not defined __cause__ = None __class__ = __context__ = AddrFormatError('invalid IPNetwork /api-server/subnets') __delattr__ = __dict__ = {} __dir__ = __doc__ = 'Name not found globally.' __eq__ = __format__ = __ge__ = __getattribute__ = __gt__ = __hash__ = __init__ = __init_subclass__ = __le__ = __lt__ = __ne__ = __new__ = __reduce__ = __reduce_ex__ = __repr__ = __setattr__ = __setstate__ = __sizeof__ = __str__ = __subclasshook__ = __suppress_context__ = False __traceback__ = args = ("name 'time' is not defined",) with_traceback = The above is a description of an error in a Python program. Here is the original traceback: Traceback (most recent call last): File "/usr/local/lib/python3.9/site-packages/netaddr/strategy/ipv4.py", line 129, in str_to_int return _struct.unpack('>I', _inet_pton(AF_INET, addr))[0] OSError: illegal IP address string passed to inet_pton During handling of the above exception, another exception occurred: Traceback (most recent call last): File "/usr/local/lib/python3.9/site-packages/netaddr/ip/__init__.py", line 380, in __init__ self._value = self._module.str_to_int(addr, flags) File "/usr/local/lib/python3.9/site-packages/netaddr/strategy/ipv4.py", line 133, in str_to_int raise AddrFormatError('%r is not a valid IPv4 address string!' % (addr,)) netaddr.core.AddrFormatError: '' is not a valid IPv4 address string! During handling of the above exception, another exception occurred: Traceback (most recent call last): File "/usr/local/lib/python3.9/site-packages/netaddr/ip/__init__.py", line 962, in parse_ip_network ip = IPAddress(val1, module.version, flags=INET_PTON) File "/usr/local/lib/python3.9/site-packages/netaddr/ip/__init__.py", line 382, in __init__ raise AddrFormatError('base address %r is not IPv%d' netaddr.core.AddrFormatError: base address '' is not IPv4 During handling of the above exception, another exception occurred: Traceback (most recent call last): File "/usr/local/lib/python3.9/site-packages/netaddr/strategy/ipv4.py", line 269, in expand_partial_address tokens = ['%d' % int(addr)] ValueError: invalid literal for int() with base 10: '' During handling of the above exception, another exception occurred: Traceback (most recent call last): File "/usr/local/lib/python3.9/site-packages/netaddr/ip/__init__.py", line 1116, in __init__ value, prefixlen = parse_ip_network(module, addr, File "/usr/local/lib/python3.9/site-packages/netaddr/ip/__init__.py", line 966, in parse_ip_network expanded_addr = _ipv4.expand_partial_address(val1) File "/usr/local/lib/python3.9/site-packages/netaddr/strategy/ipv4.py", line 271, in expand_partial_address raise error netaddr.core.AddrFormatError: invalid partial IPv4 address: ''! During handling of the above exception, another exception occurred: Traceback (most recent call last): File "/usr/local/lib/python3.9/site-packages/vnc_cfg_api_server/db_manage.py", line 1153, in deep_path_discovery IPNetwork(path.split(':', 3)[-1]) File "/usr/local/lib/python3.9/site-packages/netaddr/ip/__init__.py", line 1127, in __init__ raise AddrFormatError('invalid IPNetwork %s' % (addr,)) netaddr.core.AddrFormatError: invalid IPNetwork /api-server/subnets During handling of the above exception, another exception occurred: Traceback (most recent call last): File "/usr/local/lib/python3.9/site-packages/vnc_cfg_api_server/db_manage.py", line 1549, in wrapper errors = func(*args, **kwargs) File "/usr/local/lib/python3.9/site-packages/vnc_cfg_api_server/db_manage.py", line 1863, in check_subnet_addr_alloc ret_errors, stale_zk_path) = self.audit_subnet_addr_alloc() File "/usr/local/lib/python3.9/site-packages/vnc_cfg_api_server/db_manage.py", line 1181, in audit_subnet_addr_alloc for subnet_path in self._subnet_path_discovery( File "/usr/local/lib/python3.9/site-packages/vnc_cfg_api_server/db_manage.py", line 1169, in _subnet_path_discovery deep_path_discovery(self.base_subnet_zk_path) File "/usr/local/lib/python3.9/site-packages/vnc_cfg_api_server/db_manage.py", line 1156, in deep_path_discovery suffixes = zk_children_with_retry(path) File "/usr/local/lib/python3.9/site-packages/vnc_cfg_api_server/db_manage.py", line 1149, in zk_children_with_retry time.sleep(delay) NameError: name 'time' is not defined Traceback (most recent call last): File "/usr/local/lib/python3.9/site-packages/netaddr/strategy/ipv4.py", line 129, in str_to_int return _struct.unpack('>I', _inet_pton(AF_INET, addr))[0] OSError: illegal IP address string passed to inet_pton During handling of the above exception, another exception occurred: Traceback (most recent call last): File "/usr/local/lib/python3.9/site-packages/netaddr/ip/__init__.py", line 380, in __init__ self._value = self._module.str_to_int(addr, flags) File "/usr/local/lib/python3.9/site-packages/netaddr/strategy/ipv4.py", line 133, in str_to_int raise AddrFormatError('%r is not a valid IPv4 address string!' % (addr,)) netaddr.core.AddrFormatError: '' is not a valid IPv4 address string! During handling of the above exception, another exception occurred: Traceback (most recent call last): File "/usr/local/lib/python3.9/site-packages/netaddr/ip/__init__.py", line 962, in parse_ip_network ip = IPAddress(val1, module.version, flags=INET_PTON) File "/usr/local/lib/python3.9/site-packages/netaddr/ip/__init__.py", line 382, in __init__ raise AddrFormatError('base address %r is not IPv%d' netaddr.core.AddrFormatError: base address '' is not IPv4 During handling of the above exception, another exception occurred: Traceback (most recent call last): File "/usr/local/lib/python3.9/site-packages/netaddr/strategy/ipv4.py", line 269, in expand_partial_address tokens = ['%d' % int(addr)] ValueError: invalid literal for int() with base 10: '' During handling of the above exception, another exception occurred: Traceback (most recent call last): File "/usr/local/lib/python3.9/site-packages/netaddr/ip/__init__.py", line 1116, in __init__ value, prefixlen = parse_ip_network(module, addr, File "/usr/local/lib/python3.9/site-packages/netaddr/ip/__init__.py", line 966, in parse_ip_network expanded_addr = _ipv4.expand_partial_address(val1) File "/usr/local/lib/python3.9/site-packages/netaddr/strategy/ipv4.py", line 271, in expand_partial_address raise error netaddr.core.AddrFormatError: invalid partial IPv4 address: ''! During handling of the above exception, another exception occurred: Traceback (most recent call last): File "/usr/local/lib/python3.9/site-packages/vnc_cfg_api_server/db_manage.py", line 1153, in deep_path_discovery IPNetwork(path.split(':', 3)[-1]) File "/usr/local/lib/python3.9/site-packages/netaddr/ip/__init__.py", line 1127, in __init__ raise AddrFormatError('invalid IPNetwork %s' % (addr,)) netaddr.core.AddrFormatError: invalid IPNetwork /api-server/subnets During handling of the above exception, another exception occurred: Traceback (most recent call last): File "/usr/local/lib/python3.9/site-packages/vnc_cfg_api_server/db_manage.py", line 1549, in wrapper errors = func(*args, **kwargs) File "/usr/local/lib/python3.9/site-packages/vnc_cfg_api_server/db_manage.py", line 1863, in check_subnet_addr_alloc ret_errors, stale_zk_path) = self.audit_subnet_addr_alloc() File "/usr/local/lib/python3.9/site-packages/vnc_cfg_api_server/db_manage.py", line 1181, in audit_subnet_addr_alloc for subnet_path in self._subnet_path_discovery( File "/usr/local/lib/python3.9/site-packages/vnc_cfg_api_server/db_manage.py", line 1169, in _subnet_path_discovery deep_path_discovery(self.base_subnet_zk_path) File "/usr/local/lib/python3.9/site-packages/vnc_cfg_api_server/db_manage.py", line 1156, in deep_path_discovery suffixes = zk_children_with_retry(path) File "/usr/local/lib/python3.9/site-packages/vnc_cfg_api_server/db_manage.py", line 1149, in zk_children_with_retry time.sleep(delay) NameError: name 'time' is not defined NameError Python 3.9.21: /usr/bin/python3 Mon Aug 18 15:35:43 2025 A problem occurred in a Python script. Here is the sequence of function calls leading up to the error, in the order they occurred. /usr/local/bin/db-manage in 3 from vnc_cfg_api_server.db_manage import main 4 if __name__ == '__main__': 5 if sys.argv[0].endswith('.exe'): 6 sys.argv[0] = sys.argv[0][:-4] 7 sys.exit(main()) sys = sys.exit = main = /usr/local/lib/python3.9/site-packages/vnc_cfg_api_server/db_manage.py in main() 3452 verb = args.operation 3453 if 'db_%s' % (verb) in globals(): 3454 return globals()['db_%s' % (verb)](args, api_args) 3455 3456 if getattr(DatabaseChecker, verb, None): builtinglobals = verb = 'check' args = Namespace(operation='check', api_conf='/etc/cont...1024, log_file='/var/log/contrail/db_manage.log') api_args = Namespace(conf_file=['/etc/contrail/contrail-api...esh_base.SandeshConfig object at 0x7fc1ab3861f0>) /usr/local/lib/python3.9/site-packages/vnc_cfg_api_server/db_manage.py in db_check(args=Namespace(operation='check', api_conf='/etc/cont...1024, log_file='/var/log/contrail/db_manage.log'), api_args=Namespace(conf_file=['/etc/contrail/contrail-api...esh_base.SandeshConfig object at 0x7fc1ab3861f0>)) 3369 # ID allocation inconsistencies 3370 db_checker.check_subnet_uuid() 3371 db_checker.check_subnet_addr_alloc() 3372 db_checker.check_route_targets_id() 3373 db_checker.check_virtual_networks_id() db_checker = db_checker.check_subnet_addr_alloc = > /usr/local/lib/python3.9/site-packages/vnc_cfg_api_server/db_manage.py in wrapper(*args=(,), **kwargs={}) 1547 self = args[0] 1548 try: 1549 errors = func(*args, **kwargs) 1550 if not errors: 1551 self._logger.info('(v%s) Checker %s: Success', __version__, errors undefined func = args = (,) kwargs = {} /usr/local/lib/python3.9/site-packages/vnc_cfg_api_server/db_manage.py in check_subnet_addr_alloc(self=) 1861 # whether ip allocated in subnet in zk match iip+fip in cassandra 1862 (zk_all_vns, cassandra_all_vns, duplicate_ips, 1863 ret_errors, stale_zk_path) = self.audit_subnet_addr_alloc() 1864 1865 # check stale ZK subnet path ret_errors undefined stale_zk_path undefined self = self.audit_subnet_addr_alloc = > /usr/local/lib/python3.9/site-packages/vnc_cfg_api_server/db_manage.py in audit_subnet_addr_alloc(self=) 1179 self.base_subnet_zk_path) 1180 num_addrs = 0 1181 for subnet_path in self._subnet_path_discovery( 1182 ret_errors, stale_zk_path): 1183 if subnet_path.startswith("%s/" % self.base_subnet_zk_path): subnet_path undefined self = self._subnet_path_discovery = > ret_errors = [] stale_zk_path = [] /usr/local/lib/python3.9/site-packages/vnc_cfg_api_server/db_manage.py in _subnet_path_discovery(self=, ret_errors=[], stale_zk_path=[]) 1167 subnet_paths.add(path) 1168 1169 deep_path_discovery(self.base_subnet_zk_path) 1170 return subnet_paths 1171 deep_path_discovery = .deep_path_discovery> self = self.base_subnet_zk_path = '/api-server/subnets' /usr/local/lib/python3.9/site-packages/vnc_cfg_api_server/db_manage.py in deep_path_discovery(path='/api-server/subnets') 1154 except AddrFormatError: 1155 try: 1156 suffixes = zk_children_with_retry(path) 1157 except kazoo.exceptions.NoNodeError: 1158 self._logger.debug("ZK subnet path '%s' does not exits" % suffixes undefined zk_children_with_retry = .zk_children_with_retry> path = '/api-server/subnets' /usr/local/lib/python3.9/site-packages/vnc_cfg_api_server/db_manage.py in zk_children_with_retry(path='/api-server/subnets', retries=5, delay=0.2) 1147 if kids or attempt == retries - 1: 1148 return kids 1149 time.sleep(delay) 1150 1151 def deep_path_discovery(path): time undefined delay = 0.2 NameError: name 'time' is not defined __cause__ = None __class__ = __context__ = AddrFormatError('invalid IPNetwork /api-server/subnets') __delattr__ = __dict__ = {} __dir__ = __doc__ = 'Name not found globally.' __eq__ = __format__ = __ge__ = __getattribute__ = __gt__ = __hash__ = __init__ = __init_subclass__ = __le__ = __lt__ = __ne__ = __new__ = __reduce__ = __reduce_ex__ = __repr__ = __setattr__ = __setstate__ = __sizeof__ = __str__ = __subclasshook__ = __suppress_context__ = False __traceback__ = args = ("name 'time' is not defined",) with_traceback = The above is a description of an error in a Python program. Here is the original traceback: Traceback (most recent call last): File "/usr/local/lib/python3.9/site-packages/netaddr/strategy/ipv4.py", line 129, in str_to_int return _struct.unpack('>I', _inet_pton(AF_INET, addr))[0] OSError: illegal IP address string passed to inet_pton During handling of the above exception, another exception occurred: Traceback (most recent call last): File "/usr/local/lib/python3.9/site-packages/netaddr/ip/__init__.py", line 380, in __init__ self._value = self._module.str_to_int(addr, flags) File "/usr/local/lib/python3.9/site-packages/netaddr/strategy/ipv4.py", line 133, in str_to_int raise AddrFormatError('%r is not a valid IPv4 address string!' % (addr,)) netaddr.core.AddrFormatError: '' is not a valid IPv4 address string! During handling of the above exception, another exception occurred: Traceback (most recent call last): File "/usr/local/lib/python3.9/site-packages/netaddr/ip/__init__.py", line 962, in parse_ip_network ip = IPAddress(val1, module.version, flags=INET_PTON) File "/usr/local/lib/python3.9/site-packages/netaddr/ip/__init__.py", line 382, in __init__ raise AddrFormatError('base address %r is not IPv%d' netaddr.core.AddrFormatError: base address '' is not IPv4 During handling of the above exception, another exception occurred: Traceback (most recent call last): File "/usr/local/lib/python3.9/site-packages/netaddr/strategy/ipv4.py", line 269, in expand_partial_address tokens = ['%d' % int(addr)] ValueError: invalid literal for int() with base 10: '' During handling of the above exception, another exception occurred: Traceback (most recent call last): File "/usr/local/lib/python3.9/site-packages/netaddr/ip/__init__.py", line 1116, in __init__ value, prefixlen = parse_ip_network(module, addr, File "/usr/local/lib/python3.9/site-packages/netaddr/ip/__init__.py", line 966, in parse_ip_network expanded_addr = _ipv4.expand_partial_address(val1) File "/usr/local/lib/python3.9/site-packages/netaddr/strategy/ipv4.py", line 271, in expand_partial_address raise error netaddr.core.AddrFormatError: invalid partial IPv4 address: ''! During handling of the above exception, another exception occurred: Traceback (most recent call last): File "/usr/local/lib/python3.9/site-packages/vnc_cfg_api_server/db_manage.py", line 1153, in deep_path_discovery IPNetwork(path.split(':', 3)[-1]) File "/usr/local/lib/python3.9/site-packages/netaddr/ip/__init__.py", line 1127, in __init__ raise AddrFormatError('invalid IPNetwork %s' % (addr,)) netaddr.core.AddrFormatError: invalid IPNetwork /api-server/subnets During handling of the above exception, another exception occurred: Traceback (most recent call last): File "/usr/local/bin/db-manage", line 7, in sys.exit(main()) File "/usr/local/lib/python3.9/site-packages/vnc_cfg_api_server/db_manage.py", line 3454, in main return globals()['db_%s' % (verb)](args, api_args) File "/usr/local/lib/python3.9/site-packages/vnc_cfg_api_server/db_manage.py", line 3371, in db_check db_checker.check_subnet_addr_alloc() File "/usr/local/lib/python3.9/site-packages/vnc_cfg_api_server/db_manage.py", line 1549, in wrapper errors = func(*args, **kwargs) File "/usr/local/lib/python3.9/site-packages/vnc_cfg_api_server/db_manage.py", line 1863, in check_subnet_addr_alloc ret_errors, stale_zk_path) = self.audit_subnet_addr_alloc() File "/usr/local/lib/python3.9/site-packages/vnc_cfg_api_server/db_manage.py", line 1181, in audit_subnet_addr_alloc for subnet_path in self._subnet_path_discovery( File "/usr/local/lib/python3.9/site-packages/vnc_cfg_api_server/db_manage.py", line 1169, in _subnet_path_discovery deep_path_discovery(self.base_subnet_zk_path) File "/usr/local/lib/python3.9/site-packages/vnc_cfg_api_server/db_manage.py", line 1156, in deep_path_discovery suffixes = zk_children_with_retry(path) File "/usr/local/lib/python3.9/site-packages/vnc_cfg_api_server/db_manage.py", line 1149, in zk_children_with_retry time.sleep(delay) NameError: name 'time' is not defined 2025-08-18 15:35:44,098 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq? 2025-08-18 15:35:46,775 - INFO - admin user already present 2025-08-18 15:35:47,518 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq? 2025-08-18 15:35:49,531 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-FloatingipBasicTestSanity-86716918:ctest-fvn-70796118:ctest-fvn-70796118 2025-08-18 15:35:49,536 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-FloatingipBasicTestSanity-86716918:ctest-fvn-70796118:ctest-fvn-70796118 2025-08-18 15:35:49,543 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-FloatingipBasicTestSanity-86716918:ctest-fvn-70796118:ctest-fvn-70796118 2025-08-18 15:35:50,437 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-FloatingipBasicTestSanity-86716918:ctest-vn1-11425632:ctest-vn1-11425632 2025-08-18 15:35:50,442 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-FloatingipBasicTestSanity-86716918:ctest-vn1-11425632:ctest-vn1-11425632 2025-08-18 15:35:50,446 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-FloatingipBasicTestSanity-86716918:ctest-vn1-11425632:ctest-vn1-11425632 2025-08-18 15:35:53,963 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:0933f5b1-5717-4d7c-8fec-48b50b692f1a 2025-08-18 15:35:53,969 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-FloatingipBasicTestSanity-86716918:ctest-vn1-11425632:ctest-vn1-11425632 2025-08-18 15:35:53,975 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:0933f5b1-5717-4d7c-8fec-48b50b692f1a 2025-08-18 15:36:09,095 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:a3554cf6-fb9a-4426-a99b-4137393f600b 2025-08-18 15:36:09,100 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-FloatingipBasicTestSanity-86716918:ctest-fvn-70796118:ctest-fvn-70796118 2025-08-18 15:36:09,105 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:a3554cf6-fb9a-4426-a99b-4137393f600b 2025-08-18 15:36:10,643 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:0933f5b1-5717-4d7c-8fec-48b50b692f1a 2025-08-18 15:36:10,650 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VnListReq?name=default-domain:ctest-FloatingipBasicTestSanity-86716918:ctest-fvn-70796118 2025-08-18 15:36:10,655 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-FloatingipBasicTestSanity-86716918:ctest-fvn-70796118:ctest-fvn-70796118 2025-08-18 15:36:10,659 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_Inet4UcRouteReq?x=3 2025-08-18 15:36:16,361 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VnListReq?name=default-domain:ctest-FloatingipBasicTestSanity-86716918:ctest-vn1-11425632 2025-08-18 15:36:16,369 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-FloatingipBasicTestSanity-86716918:ctest-vn1-11425632:ctest-vn1-11425632 2025-08-18 15:36:16,373 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-FloatingipBasicTestSanity-86716918:ctest-vn1-11425632:ctest-vn1-11425632 2025-08-18 15:36:16,672 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VnListReq?name=default-domain:ctest-FloatingipBasicTestSanity-86716918:ctest-fvn-70796118 2025-08-18 15:36:16,678 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-FloatingipBasicTestSanity-86716918:ctest-fvn-70796118:ctest-fvn-70796118 2025-08-18 15:36:16,682 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-FloatingipBasicTestSanity-86716918:ctest-fvn-70796118:ctest-fvn-70796118 2025-08-18 15:36:16,954 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq? 2025-08-18 15:36:20,477 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq? 2025-08-18 15:36:20,873 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq? 2025-08-18 15:36:27,674 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq? 2025-08-18 15:36:30,017 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq? 2025-08-18 15:36:33,281 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq? 2025-08-18 15:36:35,437 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq? 2025-08-18 15:36:35,725 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq? 2025-08-18 15:36:42,968 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:d3b8ef38-693f-4da9-af19-9f55958425f9 2025-08-18 15:36:42,973 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestPorts-38012616:ctest-vn1-64923410:ctest-vn1-64923410 2025-08-18 15:36:42,978 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:d3b8ef38-693f-4da9-af19-9f55958425f9 2025-08-18 15:36:56,033 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:e8e0035c-7550-4f67-a226-cc237c14ade3 2025-08-18 15:36:56,038 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestPorts-38012616:ctest-vn1-64923410:ctest-vn1-64923410 2025-08-18 15:36:56,043 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:e8e0035c-7550-4f67-a226-cc237c14ade3 2025-08-18 15:37:01,197 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq? 2025-08-18 15:37:04,693 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq? 2025-08-18 15:37:14,981 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:819f4868-7da5-49e4-80a0-93619d3e10c8 2025-08-18 15:37:14,988 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestRouters-08337268:ctest-vn1-50834540:ctest-vn1-50834540 2025-08-18 15:37:14,995 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:819f4868-7da5-49e4-80a0-93619d3e10c8 2025-08-18 15:37:20,955 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:09a2ccaa-611a-4823-84a8-143aff501af6 2025-08-18 15:37:20,961 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestRouters-08337268:ctest-vn2-23599963:ctest-vn2-23599963 2025-08-18 15:37:20,966 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:09a2ccaa-611a-4823-84a8-143aff501af6 2025-08-18 15:37:42,693 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq? 2025-08-18 15:37:45,926 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq? 2025-08-18 15:37:57,026 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:627704cc-1161-4730-b03e-91d719ad0c62 2025-08-18 15:37:57,034 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestRoutersBasic-49324927:ctest-vn-52626317:ctest-vn-52626317 2025-08-18 15:37:57,038 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:627704cc-1161-4730-b03e-91d719ad0c62 2025-08-18 15:38:02,982 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:a4a9bdb3-b5fc-42ad-9f91-53b8795fe343 2025-08-18 15:38:02,988 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestRoutersBasic-49324927:ctest-ext_vn-60169338:ctest-ext_vn-60169338 2025-08-18 15:38:02,994 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:a4a9bdb3-b5fc-42ad-9f91-53b8795fe343 2025-08-18 15:38:11,489 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq? 2025-08-18 15:38:14,705 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq? 2025-08-18 15:38:18,622 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-52335811:ctest-vn-81374405:ctest-vn-81374405 2025-08-18 15:38:18,627 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-52335811:ctest-vn-81374405:ctest-vn-81374405 2025-08-18 15:38:18,631 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-52335811:ctest-vn-81374405:ctest-vn-81374405 2025-08-18 15:38:18,925 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-52335811:ctest-vn-02080855:ctest-vn-02080855 2025-08-18 15:38:18,930 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-52335811:ctest-vn-02080855:ctest-vn-02080855 2025-08-18 15:38:18,934 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-52335811:ctest-vn-02080855:ctest-vn-02080855 2025-08-18 15:38:19,539 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VnListReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-52335811:ctest-vn-02080855 2025-08-18 15:38:19,544 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-52335811:ctest-vn-02080855:ctest-vn-02080855 2025-08-18 15:38:19,548 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-52335811:ctest-vn-02080855:ctest-vn-02080855 2025-08-18 15:38:19,798 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VnListReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-52335811:ctest-vn-81374405 2025-08-18 15:38:19,802 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-52335811:ctest-vn-81374405:ctest-vn-81374405 2025-08-18 15:38:19,807 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-52335811:ctest-vn-81374405:ctest-vn-81374405 2025-08-18 15:38:20,069 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq? 2025-08-18 15:38:23,349 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq? 2025-08-18 15:38:23,641 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq? 2025-08-18 15:38:26,450 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyNegativeIpv4v6-36066365:ctest-vn4-07584322:ctest-vn4-07584322 2025-08-18 15:38:26,455 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyNegativeIpv4v6-36066365:ctest-vn4-07584322:ctest-vn4-07584322 2025-08-18 15:38:26,459 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyNegativeIpv4v6-36066365:ctest-vn4-07584322:ctest-vn4-07584322 2025-08-18 15:38:26,870 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VnListReq?name=default-domain:ctest-TestBasicPolicyNegativeIpv4v6-36066365:ctest-vn4-07584322 2025-08-18 15:38:26,876 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyNegativeIpv4v6-36066365:ctest-vn4-07584322:ctest-vn4-07584322 2025-08-18 15:38:26,880 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicyNegativeIpv4v6-36066365:ctest-vn4-07584322:ctest-vn4-07584322 2025-08-18 15:38:27,333 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq? 2025-08-18 15:38:27,622 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq? 2025-08-18 15:38:30,849 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq? 2025-08-18 15:38:34,128 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicy-66821602:ctest-vn-04928045:ctest-vn-04928045 2025-08-18 15:38:34,132 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicy-66821602:ctest-vn-04928045:ctest-vn-04928045 2025-08-18 15:38:34,137 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicy-66821602:ctest-vn-04928045:ctest-vn-04928045 2025-08-18 15:38:34,445 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicy-66821602:ctest-vn-07258853:ctest-vn-07258853 2025-08-18 15:38:34,450 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicy-66821602:ctest-vn-07258853:ctest-vn-07258853 2025-08-18 15:38:34,454 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicy-66821602:ctest-vn-07258853:ctest-vn-07258853 2025-08-18 15:38:42,161 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:b89d22ab-de0b-4bbc-8763-a856e32e5085 2025-08-18 15:38:42,167 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicy-66821602:ctest-vn-04928045:ctest-vn-04928045 2025-08-18 15:38:42,173 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:b89d22ab-de0b-4bbc-8763-a856e32e5085 2025-08-18 15:38:48,071 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:5035f5b3-95a4-43da-a4ea-d4ec1bcbd325 2025-08-18 15:38:48,076 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicy-66821602:ctest-vn-07258853:ctest-vn-07258853 2025-08-18 15:38:48,080 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:5035f5b3-95a4-43da-a4ea-d4ec1bcbd325 2025-08-18 15:38:59,512 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VnListReq?name=default-domain:ctest-TestBasicPolicy-66821602:ctest-vn-07258853 2025-08-18 15:38:59,517 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicy-66821602:ctest-vn-07258853:ctest-vn-07258853 2025-08-18 15:38:59,522 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicy-66821602:ctest-vn-07258853:ctest-vn-07258853 2025-08-18 15:38:59,763 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VnListReq?name=default-domain:ctest-TestBasicPolicy-66821602:ctest-vn-04928045 2025-08-18 15:38:59,768 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicy-66821602:ctest-vn-04928045:ctest-vn-04928045 2025-08-18 15:38:59,772 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicPolicy-66821602:ctest-vn-04928045:ctest-vn-04928045 2025-08-18 15:39:00,045 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq? 2025-08-18 15:39:03,297 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq? 2025-08-18 15:39:13,492 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:77eef1c3-636d-4840-bcff-95f80b324668 2025-08-18 15:39:13,499 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestRP-34668217:ctest-bgpaas_vn-81757413:ctest-bgpaas_vn-81757413 2025-08-18 15:39:13,504 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:77eef1c3-636d-4840-bcff-95f80b324668 2025-08-18 15:39:19,424 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:ee64b637-9d5b-490f-a51b-df45c52cbb8c 2025-08-18 15:39:19,430 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestRP-34668217:ctest-bgpaas_vn-60246482:ctest-bgpaas_vn-60246482 2025-08-18 15:39:19,434 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:ee64b637-9d5b-490f-a51b-df45c52cbb8c 2025-08-18 15:39:21,134 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq? 2025-08-18 15:39:27,903 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq? 2025-08-18 15:39:31,240 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq? 2025-08-18 15:39:33,238 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-01556108:ctest-mgmt_vn-65029616:ctest-mgmt_vn-65029616 2025-08-18 15:39:33,243 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-01556108:ctest-mgmt_vn-65029616:ctest-mgmt_vn-65029616 2025-08-18 15:39:33,248 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-01556108:ctest-mgmt_vn-65029616:ctest-mgmt_vn-65029616 2025-08-18 15:39:34,100 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-01556108:ctest-left_vn-88058862:ctest-left_vn-88058862 2025-08-18 15:39:34,105 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-01556108:ctest-left_vn-88058862:ctest-left_vn-88058862 2025-08-18 15:39:34,110 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-01556108:ctest-left_vn-88058862:ctest-left_vn-88058862 2025-08-18 15:39:34,924 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-01556108:ctest-right_vn-52003332:ctest-right_vn-52003332 2025-08-18 15:39:34,929 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-01556108:ctest-right_vn-52003332:ctest-right_vn-52003332 2025-08-18 15:39:34,933 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-01556108:ctest-right_vn-52003332:ctest-right_vn-52003332 2025-08-18 15:39:45,475 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:56a079cb-cdd8-4379-9066-9f14dcd4eaab 2025-08-18 15:39:45,482 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-01556108:ctest-mgmt_vn-65029616:ctest-mgmt_vn-65029616 2025-08-18 15:39:45,488 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:33806ec1-3454-4370-b297-00a986a3e7e4 2025-08-18 15:39:45,493 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-01556108:ctest-left_vn-88058862:ctest-left_vn-88058862 2025-08-18 15:39:45,498 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:51434f45-6ca3-4c94-9efa-238abc0a0f7a 2025-08-18 15:39:45,502 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-01556108:ctest-right_vn-52003332:ctest-right_vn-52003332 2025-08-18 15:39:45,507 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:33806ec1-3454-4370-b297-00a986a3e7e4 2025-08-18 15:39:45,513 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:51434f45-6ca3-4c94-9efa-238abc0a0f7a 2025-08-18 15:39:45,518 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:56a079cb-cdd8-4379-9066-9f14dcd4eaab 2025-08-18 15:40:25,998 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:bbb6786b-cfaa-4773-ae22-67fe6796be9f 2025-08-18 15:40:26,003 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-01556108:ctest-left_vn-88058862:ctest-left_vn-88058862 2025-08-18 15:40:26,008 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:bbb6786b-cfaa-4773-ae22-67fe6796be9f 2025-08-18 15:40:27,759 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:86439555-e817-4f7c-9cfa-06a8885ab3dd 2025-08-18 15:40:27,764 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-01556108:ctest-right_vn-52003332:ctest-right_vn-52003332 2025-08-18 15:40:27,768 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:86439555-e817-4f7c-9cfa-06a8885ab3dd 2025-08-18 15:40:32,358 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:33806ec1-3454-4370-b297-00a986a3e7e4 2025-08-18 15:40:32,363 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:51434f45-6ca3-4c94-9efa-238abc0a0f7a 2025-08-18 15:40:32,368 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:56a079cb-cdd8-4379-9066-9f14dcd4eaab 2025-08-18 15:40:33,599 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VnListReq?name=default-domain:ctest-TestSvcRegr-01556108:ctest-left_vn-88058862 2025-08-18 15:40:33,604 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:33806ec1-3454-4370-b297-00a986a3e7e4 2025-08-18 15:40:33,609 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2025-08-18 15:40:33,617 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-01556108:ctest-left_vn-88058862:ctest-left_vn-88058862 2025-08-18 15:40:33,778 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_Inet4UcRouteReq?x=2 2025-08-18 15:40:33,978 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_Layer2RouteReq?x=2 2025-08-18 15:40:33,989 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VnListReq?name=default-domain:ctest-TestSvcRegr-01556108:ctest-left_vn-88058862 2025-08-18 15:40:33,993 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-01556108:ctest-left_vn-88058862:ctest-left_vn-88058862 2025-08-18 15:40:34,194 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_Inet4UcRouteReq?x=2 2025-08-18 15:40:34,406 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_Layer2RouteReq?x=2 2025-08-18 15:40:34,416 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VnListReq?name=default-domain:ctest-TestSvcRegr-01556108:ctest-mgmt_vn-65029616 2025-08-18 15:40:34,420 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:56a079cb-cdd8-4379-9066-9f14dcd4eaab 2025-08-18 15:40:34,426 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2025-08-18 15:40:34,432 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-01556108:ctest-mgmt_vn-65029616:ctest-mgmt_vn-65029616 2025-08-18 15:40:34,630 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_Inet4UcRouteReq?x=4 2025-08-18 15:40:34,838 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_Layer2RouteReq?x=4 2025-08-18 15:40:34,847 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VnListReq?name=default-domain:ctest-TestSvcRegr-01556108:ctest-mgmt_vn-65029616 2025-08-18 15:40:34,852 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-01556108:ctest-mgmt_vn-65029616:ctest-mgmt_vn-65029616 2025-08-18 15:40:35,046 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_Inet4UcRouteReq?x=4 2025-08-18 15:40:35,254 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_Layer2RouteReq?x=4 2025-08-18 15:40:35,264 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VnListReq?name=default-domain:ctest-TestSvcRegr-01556108:ctest-right_vn-52003332 2025-08-18 15:40:35,268 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:51434f45-6ca3-4c94-9efa-238abc0a0f7a 2025-08-18 15:40:35,274 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0, 2025-08-18 15:40:35,281 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-01556108:ctest-right_vn-52003332:ctest-right_vn-52003332 2025-08-18 15:40:35,482 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_Inet4UcRouteReq?x=3 2025-08-18 15:40:35,686 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_Layer2RouteReq?x=3 2025-08-18 15:40:35,697 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VnListReq?name=default-domain:ctest-TestSvcRegr-01556108:ctest-right_vn-52003332 2025-08-18 15:40:35,704 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-01556108:ctest-right_vn-52003332:ctest-right_vn-52003332 2025-08-18 15:40:35,902 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_Inet4UcRouteReq?x=3 2025-08-18 15:40:36,110 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_Layer2RouteReq?x=3 2025-08-18 15:40:36,662 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name= 2025-08-18 15:40:36,669 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_Inet4UcRouteReq?x=5 2025-08-18 15:40:36,677 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:33806ec1-3454-4370-b297-00a986a3e7e4 2025-08-18 15:40:36,834 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name= 2025-08-18 15:40:36,841 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_Inet4UcRouteReq?x=6 2025-08-18 15:40:36,848 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:51434f45-6ca3-4c94-9efa-238abc0a0f7a 2025-08-18 15:40:44,005 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VnListReq?name=default-domain:ctest-TestSvcRegr-01556108:ctest-right_vn-52003332 2025-08-18 15:40:44,010 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-01556108:ctest-right_vn-52003332:ctest-right_vn-52003332 2025-08-18 15:40:44,014 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-01556108:ctest-right_vn-52003332:ctest-right_vn-52003332 2025-08-18 15:40:44,258 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VnListReq?name=default-domain:ctest-TestSvcRegr-01556108:ctest-left_vn-88058862 2025-08-18 15:40:44,263 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-01556108:ctest-left_vn-88058862:ctest-left_vn-88058862 2025-08-18 15:40:44,268 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-01556108:ctest-left_vn-88058862:ctest-left_vn-88058862 2025-08-18 15:40:44,533 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VnListReq?name=default-domain:ctest-TestSvcRegr-01556108:ctest-mgmt_vn-65029616 2025-08-18 15:40:44,538 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-01556108:ctest-mgmt_vn-65029616:ctest-mgmt_vn-65029616 2025-08-18 15:40:44,543 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestSvcRegr-01556108:ctest-mgmt_vn-65029616:ctest-mgmt_vn-65029616 2025-08-18 15:40:44,806 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq? 2025-08-18 15:40:48,117 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq? 2025-08-18 15:40:57,006 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:96d44d8a-00d2-48e6-9253-014c80f98b27 2025-08-18 15:40:57,013 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestvDNSBasic0-04620346:ctest-vn1-vdns-28052861:ctest-vn1-vdns-28052861 2025-08-18 15:40:57,018 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:96d44d8a-00d2-48e6-9253-014c80f98b27 2025-08-18 15:41:12,051 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_DnsInfo? 2025-08-18 15:41:18,648 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:bc6dcb02-a878-4488-adac-d6e5e3aff17b 2025-08-18 15:41:18,656 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestvDNSBasic0-04620346:ctest-vn1-vdns-28052861:ctest-vn1-vdns-28052861 2025-08-18 15:41:18,662 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:bc6dcb02-a878-4488-adac-d6e5e3aff17b 2025-08-18 15:41:33,988 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_DnsInfo? 2025-08-18 15:41:44,994 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq? 2025-08-18 15:41:48,165 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq? 2025-08-18 15:41:57,383 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:0ba34317-02da-4574-abdc-0c844d7a2a04 2025-08-18 15:41:57,389 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicVMVNx-82324323:ctest-vn-41714978:ctest-vn-41714978 2025-08-18 15:41:57,395 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:0ba34317-02da-4574-abdc-0c844d7a2a04 2025-08-18 15:42:03,311 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:6ff6f1a5-af2c-4043-92c3-67c84c287978 2025-08-18 15:42:03,317 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicVMVNx-82324323:ctest-vn-41714978:ctest-vn-41714978 2025-08-18 15:42:03,322 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:6ff6f1a5-af2c-4043-92c3-67c84c287978 2025-08-18 15:42:11,653 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq? 2025-08-18 15:42:15,141 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq? 2025-08-18 15:42:22,499 - DEBUG - [10.0.0.254]: Running cmd : docker exec --privileged -it vrouter_vrouter-agent_1 /bin/bash -c 'echo "10.0.0.254 cn-jenkins-deploy-platform-ansible-os-3878-1.-test" >> /etc/hosts' 2025-08-18 15:42:22,604 - DEBUG - Output : 2025-08-18 15:42:23,118 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:e10aaf40-61ca-4956-8b2c-41000941452a 2025-08-18 15:42:23,124 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicVMVN-17421903:ctest-vn2_metadata-69550235:ctest-vn2_metadata-69550235 2025-08-18 15:42:23,130 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:e10aaf40-61ca-4956-8b2c-41000941452a 2025-08-18 15:42:35,900 - DEBUG - [10.0.0.254]: Running cmd : docker exec --privileged -it vrouter_vrouter-agent_1 /bin/bash -c 'sed -i '$ d' /etc/hosts' 2025-08-18 15:42:36,048 - DEBUG - Output : sed: -e expression #1, char 1: missing command 2025-08-18 15:42:38,626 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq? 2025-08-18 15:42:38,917 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq? 2025-08-18 15:42:45,812 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:55c77609-e6cc-4d30-8ef8-61b65a967509 2025-08-18 15:42:45,818 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicVMVN-17421903:ctest-vn-99891184:ctest-vn-99891184 2025-08-18 15:42:45,823 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:55c77609-e6cc-4d30-8ef8-61b65a967509 2025-08-18 15:42:55,605 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq? 2025-08-18 15:42:55,901 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq? 2025-08-18 15:43:00,787 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicVMVN-17421903:ctest-vn-11997961:ctest-vn-11997961 2025-08-18 15:43:01,104 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:d61ce58b-1ae7-4d38-bcbf-02d8670f5636 2025-08-18 15:43:01,116 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicVMVN-17421903:ctest-vn-11997961:ctest-vn-11997961 2025-08-18 15:43:01,123 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:d61ce58b-1ae7-4d38-bcbf-02d8670f5636 2025-08-18 15:43:16,329 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:c0f09d89-a63a-44d0-bc31-904b41d3eeca 2025-08-18 15:43:16,334 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicVMVN-17421903:ctest-vn-11997961:ctest-vn-11997961 2025-08-18 15:43:16,338 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:c0f09d89-a63a-44d0-bc31-904b41d3eeca 2025-08-18 15:43:18,110 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:eb7efc7b-4031-4ae1-a2c8-83a8520e5bf9 2025-08-18 15:43:18,115 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicVMVN-17421903:ctest-vn-11997961:ctest-vn-11997961 2025-08-18 15:43:18,119 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_PageReq?x=begin:-1,end:-1,table:db.interface.0,uuid:eb7efc7b-4031-4ae1-a2c8-83a8520e5bf9 2025-08-18 15:43:37,787 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VnListReq?name=default-domain:ctest-TestBasicVMVN-17421903:ctest-vn-11997961 2025-08-18 15:43:37,792 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name=default-domain:ctest-TestBasicVMVN-17421903:ctest-vn-11997961:ctest-vn-11997961 2025-08-18 15:43:37,797 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_VrfListReq?name= 2025-08-18 15:43:37,802 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_KRouteReq?x=2 2025-08-18 15:43:37,808 - DEBUG - Unable to fetch route details in vrouter for vrf index 2, Got :[] 2025-08-18 15:43:38,153 - DEBUG - Requesting: http://10.0.0.254:8085/Snh_AgentXmppConnectionStatusReq? 2025-08-18 15:45:04,888 - INFO - Using existing project ['default-domain', 'admin'](424872b8-35a4-403e-b480-f7f7a3ba4af3) 2025-08-18 15:45:04,902 - INFO - ================================================================================ 2025-08-18 15:45:04,903 - INFO - STARTING TEST : test_contrail_status 2025-08-18 15:45:04,903 - INFO - TEST DESCRIPTION : Test to verify that all services are running and active 2025-08-18 15:45:05,031 - DEBUG - Skipping xmpp flap check 2025-08-18 15:45:05,031 - INFO - Initial checks done. Running the testcase now 2025-08-18 15:45:05,031 - INFO - 2025-08-18 15:45:05,128 - INFO - 10.0.0.254 2025-08-18 15:45:05,128 - INFO - config 2025-08-18 15:45:05,134 - INFO - config-nodemgr:active 2025-08-18 15:45:05,138 - INFO - api-server:active 2025-08-18 15:45:05,141 - INFO - schema:active 2025-08-18 15:45:05,145 - INFO - svc-monitor:active 2025-08-18 15:45:05,148 - INFO - device-manager:active 2025-08-18 15:45:05,148 - INFO - config-database 2025-08-18 15:45:05,149 - INFO - config-cassandra:active 2025-08-18 15:45:05,149 - INFO - config-zookeeper:active 2025-08-18 15:45:05,149 - INFO - config-rabbitmq:active 2025-08-18 15:45:05,149 - INFO - vrouter 2025-08-18 15:45:05,153 - INFO - vrouter-nodemgr:active 2025-08-18 15:45:05,157 - INFO - agent:active 2025-08-18 15:45:05,157 - INFO - control 2025-08-18 15:45:05,162 - INFO - control-nodemgr:active 2025-08-18 15:45:05,166 - INFO - control:active 2025-08-18 15:45:05,166 - INFO - named:active 2025-08-18 15:45:05,171 - INFO - dns:active 2025-08-18 15:45:05,171 - INFO - analytics 2025-08-18 15:45:05,175 - INFO - analytics-nodemgr:active 2025-08-18 15:45:05,178 - INFO - analytics-api:active 2025-08-18 15:45:05,184 - INFO - collector:active 2025-08-18 15:45:05,184 - INFO - analytics-database 2025-08-18 15:45:05,184 - INFO - analytics-cassandra:active 2025-08-18 15:45:05,188 - INFO - analyticsdb-nodemgr:active 2025-08-18 15:45:05,192 - INFO - query-engine:active 2025-08-18 15:45:05,192 - INFO - webui 2025-08-18 15:45:05,193 - INFO - webui:active 2025-08-18 15:45:05,193 - INFO - webui-middleware:active 2025-08-18 15:45:05,193 - INFO - redis:active 2025-08-18 15:45:05,193 - INFO - analytics_snmp 2025-08-18 15:45:05,196 - INFO - snmp-collector:active 2025-08-18 15:45:05,197 - INFO - snmp-topology:active 2025-08-18 15:45:05,197 - INFO - analytics_alarm 2025-08-18 15:45:05,197 - INFO - alarmgen:active 2025-08-18 15:45:05,197 - INFO - All the contrail services are up on all nodes 2025-08-18 15:45:05,197 - INFO - contrail-status passed 2025-08-18 15:45:05,319 - DEBUG - Skipping xmpp flap check
2025-08-18 15:45:05,319 - INFO - END TEST : test_contrail_status : PASSED[0:00:01]
2025-08-18 15:45:05,319 - INFO - --------------------------------------------------------------------------------