test_logging.py 5.28 KB
Newer Older
Sylvain Gugger's avatar
Sylvain Gugger committed
1
2
3
4
5
6
7
8
9
10
11
12
13
14
# Copyright 2020 The HuggingFace Team. All rights reserved.
#
# Licensed under the Apache License, Version 2.0 (the "License");
# you may not use this file except in compliance with the License.
# You may obtain a copy of the License at
#
#     http://www.apache.org/licenses/LICENSE-2.0
#
# Unless required by applicable law or agreed to in writing, software
# distributed under the License is distributed on an "AS IS" BASIS,
# WITHOUT WARRANTIES OR CONDITIONS OF ANY KIND, either express or implied.
# See the License for the specific language governing permissions and
# limitations under the License.

15
import os
Lysandre Debut's avatar
Lysandre Debut committed
16
import unittest
Jake Tae's avatar
Jake Tae committed
17
from unittest.mock import patch
Lysandre Debut's avatar
Lysandre Debut committed
18

Sylvain Gugger's avatar
Sylvain Gugger committed
19
import transformers.models.bart.tokenization_bart
Jake Tae's avatar
Jake Tae committed
20
from transformers import AutoConfig, logging
21
from transformers.testing_utils import CaptureLogger, mockenv, mockenv_context
Jake Tae's avatar
Jake Tae committed
22
from transformers.utils.logging import disable_progress_bar, enable_progress_bar
Lysandre Debut's avatar
Lysandre Debut committed
23
24
25
26
27
28


class HfArgumentParserTest(unittest.TestCase):
    def test_set_level(self):
        logger = logging.get_logger()

29
30
31
        # the current default level is logging.WARNING
        level_origin = logging.get_verbosity()

Lysandre Debut's avatar
Lysandre Debut committed
32
33
34
35
36
37
38
39
40
41
42
        logging.set_verbosity_error()
        self.assertEqual(logger.getEffectiveLevel(), logging.get_verbosity())

        logging.set_verbosity_warning()
        self.assertEqual(logger.getEffectiveLevel(), logging.get_verbosity())

        logging.set_verbosity_info()
        self.assertEqual(logger.getEffectiveLevel(), logging.get_verbosity())

        logging.set_verbosity_debug()
        self.assertEqual(logger.getEffectiveLevel(), logging.get_verbosity())
43
44
45
46
47
48
49

        # restore to the original level
        logging.set_verbosity(level_origin)

    def test_integration(self):
        level_origin = logging.get_verbosity()

Sylvain Gugger's avatar
Sylvain Gugger committed
50
        logger = logging.get_logger("transformers.models.bart.tokenization_bart")
51
52
        msg = "Testing 1, 2, 3"

53
        # should be able to log warnings (if default settings weren't overridden by `pytest --log-level-all`)
54
55
        if level_origin <= logging.WARNING:
            with CaptureLogger(logger) as cl:
56
                logger.warning(msg)
57
58
59
60
61
62
63
            self.assertEqual(cl.out, msg + "\n")

        # this is setting the level for all of `transformers.*` loggers
        logging.set_verbosity_error()

        # should not be able to log warnings
        with CaptureLogger(logger) as cl:
64
            logger.warning(msg)
65
66
67
68
69
70
71
72
73
74
75
76
77
78
79
80
        self.assertEqual(cl.out, "")

        # should be able to log warnings again
        logging.set_verbosity_warning()
        with CaptureLogger(logger) as cl:
            logger.warning(msg)
        self.assertEqual(cl.out, msg + "\n")

        # restore to the original level
        logging.set_verbosity(level_origin)

    @mockenv(TRANSFORMERS_VERBOSITY="error")
    def test_env_override(self):
        # reset for the env var to take effect, next time some logger call is made
        transformers.utils.logging._reset_library_root_logger()
        # this action activates the env var
Sylvain Gugger's avatar
Sylvain Gugger committed
81
        _ = logging.get_logger("transformers.models.bart.tokenization_bart")
82
83
84
85
86
87
88
89
90
91
92
93
94
95
96
97
98
99
100
101
102
103

        env_level_str = os.getenv("TRANSFORMERS_VERBOSITY", None)
        env_level = logging.log_levels[env_level_str]

        current_level = logging.get_verbosity()
        self.assertEqual(
            env_level,
            current_level,
            f"TRANSFORMERS_VERBOSITY={env_level_str}/{env_level}, but internal verbosity is {current_level}",
        )

        # restore to the original level
        os.environ["TRANSFORMERS_VERBOSITY"] = ""
        transformers.utils.logging._reset_library_root_logger()

    @mockenv(TRANSFORMERS_VERBOSITY="super-error")
    def test_env_invalid_override(self):
        # reset for the env var to take effect, next time some logger call is made
        transformers.utils.logging._reset_library_root_logger()
        logger = logging.logging.getLogger()
        with CaptureLogger(logger) as cl:
            # this action activates the env var
Sylvain Gugger's avatar
Sylvain Gugger committed
104
            logging.get_logger("transformers.models.bart.tokenization_bart")
105
106
107
        self.assertIn("Unknown option TRANSFORMERS_VERBOSITY=super-error", cl.out)

        # no need to restore as nothing was changed
108
109
110
111
112
113
114
115
116
117
118
119
120
121
122
123
124
125

    def test_advisory_warnings(self):
        # testing `logger.warning_advice()`

        logger = logging.get_logger("transformers.models.bart.tokenization_bart")
        msg = "Testing 1, 2, 3"

        with mockenv_context(TRANSFORMERS_NO_ADVISORY_WARNINGS="1"):
            # nothing should be logged as env var disables this method
            with CaptureLogger(logger) as cl:
                logger.warning_advice(msg)
            self.assertEqual(cl.out, "")

        with mockenv_context(TRANSFORMERS_NO_ADVISORY_WARNINGS=""):
            # should log normally as TRANSFORMERS_NO_ADVISORY_WARNINGS is unset
            with CaptureLogger(logger) as cl:
                logger.warning_advice(msg)
            self.assertEqual(cl.out, msg + "\n")
Jake Tae's avatar
Jake Tae committed
126
127
128
129
130
131
132
133
134
135
136
137
138
139


def test_set_progress_bar_enabled():
    TINY_MODEL = "hf-internal-testing/tiny-random-distilbert"
    with patch("tqdm.auto.tqdm") as mock_tqdm:
        disable_progress_bar()
        _ = AutoConfig.from_pretrained(TINY_MODEL, force_download=True)
        mock_tqdm.assert_not_called()

        mock_tqdm.reset_mock()

        enable_progress_bar()
        _ = AutoConfig.from_pretrained(TINY_MODEL, force_download=True)
        mock_tqdm.assert_called()