logging.py 9.29 KB
Newer Older
Lysandre Debut's avatar
Lysandre Debut committed
1
2
3
4
5
6
7
8
9
10
11
12
13
14
# coding=utf-8
# Copyright 2020 Optuna, Hugging Face
#
# 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.
Sylvain Gugger's avatar
Sylvain Gugger committed
15
""" Logging utilities."""
Lysandre Debut's avatar
Lysandre Debut committed
16
17

import logging
18
import os
Stas Bekman's avatar
Stas Bekman committed
19
import sys
Lysandre Debut's avatar
Lysandre Debut committed
20
21
22
23
24
25
26
27
28
29
30
import threading
from logging import CRITICAL  # NOQA
from logging import DEBUG  # NOQA
from logging import ERROR  # NOQA
from logging import FATAL  # NOQA
from logging import INFO  # NOQA
from logging import NOTSET  # NOQA
from logging import WARN  # NOQA
from logging import WARNING  # NOQA
from typing import Optional

Jake Tae's avatar
Jake Tae committed
31
32
from tqdm import auto as tqdm_lib

Lysandre Debut's avatar
Lysandre Debut committed
33
34
35
36

_lock = threading.Lock()
_default_handler: Optional[logging.Handler] = None

37
38
39
40
41
42
43
44
45
46
log_levels = {
    "debug": logging.DEBUG,
    "info": logging.INFO,
    "warning": logging.WARNING,
    "error": logging.ERROR,
    "critical": logging.CRITICAL,
}

_default_log_level = logging.WARNING

Jake Tae's avatar
Jake Tae committed
47
48
_tqdm_active = True

49
50
51

def _get_default_logging_level():
    """
Sylvain Gugger's avatar
Sylvain Gugger committed
52
    If TRANSFORMERS_VERBOSITY env var is set to one of the valid choices return that as the new default level. If it is
53
    not - fall back to `_default_log_level`
54
55
56
57
58
59
60
61
62
63
64
65
    """
    env_level_str = os.getenv("TRANSFORMERS_VERBOSITY", None)
    if env_level_str:
        if env_level_str in log_levels:
            return log_levels[env_level_str]
        else:
            logging.getLogger().warning(
                f"Unknown option TRANSFORMERS_VERBOSITY={env_level_str}, "
                f"has to be one of: { ', '.join(log_levels.keys()) }"
            )
    return _default_log_level

Lysandre Debut's avatar
Lysandre Debut committed
66
67
68
69
70
71
72
73
74
75
76
77
78
79
80
81
82
83
84
85

def _get_library_name() -> str:

    return __name__.split(".")[0]


def _get_library_root_logger() -> logging.Logger:

    return logging.getLogger(_get_library_name())


def _configure_library_root_logger() -> None:

    global _default_handler

    with _lock:
        if _default_handler:
            # This library has already configured the library root logger.
            return
        _default_handler = logging.StreamHandler()  # Set sys.stderr as stream.
Stas Bekman's avatar
Stas Bekman committed
86
        _default_handler.flush = sys.stderr.flush
Lysandre Debut's avatar
Lysandre Debut committed
87
88
89
90

        # Apply our default configuration to the library root logger.
        library_root_logger = _get_library_root_logger()
        library_root_logger.addHandler(_default_handler)
91
        library_root_logger.setLevel(_get_default_logging_level())
Lysandre Debut's avatar
Lysandre Debut committed
92
        library_root_logger.propagate = False
Lysandre Debut's avatar
Lysandre Debut committed
93
94
95
96
97
98
99
100
101
102
103
104
105
106
107
108


def _reset_library_root_logger() -> None:

    global _default_handler

    with _lock:
        if not _default_handler:
            return

        library_root_logger = _get_library_root_logger()
        library_root_logger.removeHandler(_default_handler)
        library_root_logger.setLevel(logging.NOTSET)
        _default_handler = None


109
110
111
112
def get_log_levels_dict():
    return log_levels


Lysandre Debut's avatar
Lysandre Debut committed
113
def get_logger(name: Optional[str] = None) -> logging.Logger:
Sylvain Gugger's avatar
Sylvain Gugger committed
114
115
116
117
    """
    Return a logger with the specified name.

    This function is not supposed to be directly accessed unless you are writing a custom transformers module.
Lysandre Debut's avatar
Lysandre Debut committed
118
119
120
121
122
123
124
125
126
127
    """

    if name is None:
        name = _get_library_name()

    _configure_library_root_logger()
    return logging.getLogger(name)


def get_verbosity() -> int:
Sylvain Gugger's avatar
Sylvain Gugger committed
128
129
130
    """
    Return the current level for the 馃 Transformers's root logger as an int.

Lysandre Debut's avatar
Lysandre Debut committed
131
    Returns:
132
        `int`: The logging level.
Sylvain Gugger's avatar
Sylvain Gugger committed
133

134
    <Tip>
Sylvain Gugger's avatar
Sylvain Gugger committed
135

136
    馃 Transformers has following logging levels:
Sylvain Gugger's avatar
Sylvain Gugger committed
137

138
139
140
141
142
143
144
    - 50: `transformers.logging.CRITICAL` or `transformers.logging.FATAL`
    - 40: `transformers.logging.ERROR`
    - 30: `transformers.logging.WARNING` or `transformers.logging.WARN`
    - 20: `transformers.logging.INFO`
    - 10: `transformers.logging.DEBUG`

    </Tip>"""
Lysandre Debut's avatar
Lysandre Debut committed
145
146
147
148
149
150

    _configure_library_root_logger()
    return _get_library_root_logger().getEffectiveLevel()


def set_verbosity(verbosity: int) -> None:
Sylvain Gugger's avatar
Sylvain Gugger committed
151
    """
152
    Set the verbosity level for the 馃 Transformers's root logger.
Sylvain Gugger's avatar
Sylvain Gugger committed
153

Lysandre Debut's avatar
Lysandre Debut committed
154
    Args:
155
        verbosity (`int`):
Sylvain Gugger's avatar
Sylvain Gugger committed
156
157
            Logging level, e.g., one of:

158
159
160
161
162
            - `transformers.logging.CRITICAL` or `transformers.logging.FATAL`
            - `transformers.logging.ERROR`
            - `transformers.logging.WARNING` or `transformers.logging.WARN`
            - `transformers.logging.INFO`
            - `transformers.logging.DEBUG`
Lysandre Debut's avatar
Lysandre Debut committed
163
164
165
166
167
168
169
    """

    _configure_library_root_logger()
    _get_library_root_logger().setLevel(verbosity)


def set_verbosity_info():
170
    """Set the verbosity to the `INFO` level."""
Lysandre Debut's avatar
Lysandre Debut committed
171
172
173
174
    return set_verbosity(INFO)


def set_verbosity_warning():
175
    """Set the verbosity to the `WARNING` level."""
Lysandre Debut's avatar
Lysandre Debut committed
176
177
178
179
    return set_verbosity(WARNING)


def set_verbosity_debug():
180
    """Set the verbosity to the `DEBUG` level."""
Lysandre Debut's avatar
Lysandre Debut committed
181
182
183
184
    return set_verbosity(DEBUG)


def set_verbosity_error():
185
    """Set the verbosity to the `ERROR` level."""
Lysandre Debut's avatar
Lysandre Debut committed
186
187
188
189
190
191
192
193
194
195
196
197
198
199
200
201
202
203
204
205
206
    return set_verbosity(ERROR)


def disable_default_handler() -> None:
    """Disable the default handler of the HuggingFace Transformers's root logger."""

    _configure_library_root_logger()

    assert _default_handler is not None
    _get_library_root_logger().removeHandler(_default_handler)


def enable_default_handler() -> None:
    """Enable the default handler of the HuggingFace Transformers's root logger."""

    _configure_library_root_logger()

    assert _default_handler is not None
    _get_library_root_logger().addHandler(_default_handler)


207
208
209
210
211
212
213
214
215
216
217
218
219
220
221
222
223
224
def add_handler(handler: logging.Handler) -> None:
    """adds a handler to the HuggingFace Transformers's root logger."""

    _configure_library_root_logger()

    assert handler is not None
    _get_library_root_logger().addHandler(handler)


def remove_handler(handler: logging.Handler) -> None:
    """removes given handler from the HuggingFace Transformers's root logger."""

    _configure_library_root_logger()

    assert handler is not None and handler not in _get_library_root_logger().handlers
    _get_library_root_logger().removeHandler(handler)


Lysandre Debut's avatar
Lysandre Debut committed
225
def disable_propagation() -> None:
Sylvain Gugger's avatar
Sylvain Gugger committed
226
227
    """
    Disable propagation of the library log outputs. Note that log propagation is disabled by default.
Lysandre Debut's avatar
Lysandre Debut committed
228
229
230
231
232
233
234
    """

    _configure_library_root_logger()
    _get_library_root_logger().propagate = False


def enable_propagation() -> None:
Sylvain Gugger's avatar
Sylvain Gugger committed
235
236
237
    """
    Enable propagation of the library log outputs. Please disable the HuggingFace Transformers's default handler to
    prevent double logging if the root logger has been configured.
Lysandre Debut's avatar
Lysandre Debut committed
238
239
240
241
    """

    _configure_library_root_logger()
    _get_library_root_logger().propagate = True
Lysandre Debut's avatar
Lysandre Debut committed
242
243
244
245
246


def enable_explicit_format() -> None:
    """
    Enable explicit formatting for every HuggingFace Transformers's logger. The explicit formatter is as follows:
Stas Bekman's avatar
Stas Bekman committed
247
    ```
Lysandre Debut's avatar
Lysandre Debut committed
248
        [LEVELNAME|FILENAME|LINE NUMBER] TIME >> MESSAGE
Stas Bekman's avatar
Stas Bekman committed
249
    ```
Lysandre Debut's avatar
Lysandre Debut committed
250
251
252
253
254
255
256
257
258
259
260
261
262
263
264
265
266
267
268
    All handlers currently bound to the root logger are affected by this method.
    """
    handlers = _get_library_root_logger().handlers

    for handler in handlers:
        formatter = logging.Formatter("[%(levelname)s|%(filename)s:%(lineno)s] %(asctime)s >> %(message)s")
        handler.setFormatter(formatter)


def reset_format() -> None:
    """
    Resets the formatting for HuggingFace Transformers's loggers.

    All handlers currently bound to the root logger are affected by this method.
    """
    handlers = _get_library_root_logger().handlers

    for handler in handlers:
        handler.setFormatter(None)
269
270
271
272
273
274
275
276
277
278
279
280
281
282


def warning_advice(self, *args, **kwargs):
    """
    This method is identical to `logger.warning()`, but if env var TRANSFORMERS_NO_ADVISORY_WARNINGS=1 is set, this
    warning will not be printed
    """
    no_advisory_warnings = os.getenv("TRANSFORMERS_NO_ADVISORY_WARNINGS", False)
    if no_advisory_warnings:
        return
    self.warning(*args, **kwargs)


logging.Logger.warning_advice = warning_advice
Jake Tae's avatar
Jake Tae committed
283
284
285
286
287
288
289
290
291
292
293
294
295
296
297
298
299
300
301
302
303
304
305
306
307
308
309
310
311
312
313
314
315
316
317
318
319
320
321
322
323
324
325
326
327
328
329
330
331
332
333
334
335
336
337
338
339
340
341


class EmptyTqdm:
    """Dummy tqdm which doesn't do anything."""

    def __init__(self, *args, **kwargs):  # pylint: disable=unused-argument
        self._iterator = args[0] if args else None

    def __iter__(self):
        return iter(self._iterator)

    def __getattr__(self, _):
        """Return empty function."""

        def empty_fn(*args, **kwargs):  # pylint: disable=unused-argument
            return

        return empty_fn

    def __enter__(self):
        return self

    def __exit__(self, type_, value, traceback):
        return


class _tqdm_cls:
    def __call__(self, *args, **kwargs):
        if _tqdm_active:
            return tqdm_lib.tqdm(*args, **kwargs)
        else:
            return EmptyTqdm(*args, **kwargs)

    def set_lock(self, *args, **kwargs):
        self._lock = None
        if _tqdm_active:
            return tqdm_lib.tqdm.set_lock(*args, **kwargs)

    def get_lock(self):
        if _tqdm_active:
            return tqdm_lib.tqdm.get_lock()


tqdm = _tqdm_cls()


def is_progress_bar_enabled() -> bool:
    """Return a boolean indicating whether tqdm progress bars are enabled."""
    global _tqdm_active
    return bool(_tqdm_active)


def enable_progress_bar():
    """Enable tqdm progress bar."""
    global _tqdm_active
    _tqdm_active = True


def disable_progress_bar():
342
    """Disable tqdm progress bar."""
Jake Tae's avatar
Jake Tae committed
343
344
    global _tqdm_active
    _tqdm_active = False