def test_log_setlevel():
_rm_env_config()
os.environ['GLOG_v'] = '0'
from mindspore import log as logger
#logger_instance = logger._get_logger()
#del logger_instance
loglevel = logger.get_level()
log_str = 'print debug informations'
logger.debug("5 test log message debug:%s", log_str)
assert loglevel == '0'
# Clean up _global_logger to avoid affecting for next usecase
logger._global_logger = None
def test_log_perf():
"""
Performance test with python logging
"""
_rm_env_config()
os.environ['GLOG_v'] = '3'
from mindspore import log as logger
loglevel = logging.ERROR
logging.basicConfig()
py_logging = logging.getLogger()
py_logging.setLevel(loglevel)
log_count = 100000
print("logger level:", logger.get_level())
print("py_logging level:", py_logging.getEffectiveLevel())
# Calculate PY logging execution time
start_time_py_logging = int(round(time.time() * 1000))
for i in range(0, log_count, 1):
py_logging.info("test log message info :%r", i)
end_time_py_logging = int(round(time.time() * 1000))
time_diff_py_logging = end_time_py_logging - start_time_py_logging
# Calculate MS logger execution time
start_time_logger = int(round(time.time() * 1000))
for i in range(0, log_count, 1):
logger.info("test log message info :%r", i)
end_time_logger = int(round(time.time() * 1000))
time_diff_logger = end_time_logger - start_time_logger
# Calculate time difference
time_diff = time_diff_logger - time_diff_py_logging
strprint = f'time difference between MS logger ' \
f'and Python logging: {time_diff} ms'
print(strprint)
std_time = 2000
assert time_diff < std_time
# Clean up _global_logger to avoid affecting for next usecase
logger._global_logger = None