error.py 16.0 KB
Newer Older
1 2 3 4 5 6 7 8 9 10 11 12 13 14
# Copyright (c) 2020 PaddlePaddle Authors. 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
16
import six
17 18
import sys
import traceback
19
import linecache
20
import re
21
import numpy as np
22 23

from paddle.fluid.dygraph.dygraph_to_static.origin_info import Location, OriginInfo, global_origin_info_map
24
from paddle.fluid.dygraph.dygraph_to_static.utils import _is_api_in_module_helper, RE_PYMODULE
25 26 27

ERROR_DATA = "Error data about original source code information and traceback."

28 29 30 31 32 33 34 35
# A flag to set whether to open the dygraph2static error reporting module
SIMPLIFY_ERROR_ENV_NAME = "TRANSLATOR_SIMPLIFY_NEW_ERROR"
DEFAULT_SIMPLIFY_NEW_ERROR = 1

# A flag to set whether to display the simplified error stack
DISABLE_ERROR_ENV_NAME = "TRANSLATOR_DISABLE_NEW_ERROR"
DEFAULT_DISABLE_NEW_ERROR = 0

36 37 38
SOURCE_CODE_RANGE = 5
BLANK_COUNT_BEFORE_FILE_STR = 4

39

40
def attach_error_data(error, in_runtime=False):
41 42 43 44 45
    """
    Attachs error data about original source code information and traceback to an error.

    Args:
        error(Exception): An native error.
46
        in_runtime(bool): `error` is raised in runtime if in_runtime is True, otherwise in compile time
47 48 49
    Returns:
        An error attached data about original source code information and traceback.
    """
50

51 52 53 54
    e_type, e_value, e_traceback = sys.exc_info()
    tb = traceback.extract_tb(e_traceback)[1:]

    error_data = ErrorData(e_type, e_value, tb, global_origin_info_map)
55 56
    error_data.in_runtime = in_runtime

57 58 59 60 61 62 63 64 65 66 67 68 69 70
    setattr(error, ERROR_DATA, error_data)

    return error


class TraceBackFrame(OriginInfo):
    """
    Traceback frame information.
    """

    def __init__(self, location, function_name, source_code):
        self.location = location
        self.function_name = function_name
        self.source_code = source_code
71
        self.error_line = ''
72

73
    def formated_message(self):
74 75
        # self.source_code may be empty in some functions.
        # For example, decorator generated function
76
        return ' ' * BLANK_COUNT_BEFORE_FILE_STR + 'File "{}", line {}, in {}\n\t{}'.format(
77
            self.location.filepath, self.location.lineno, self.function_name,
78 79
            self.source_code.lstrip()
            if isinstance(self.source_code, str) else self.source_code)
80

81

82 83 84 85 86 87 88 89 90
class TraceBackFrameRange(OriginInfo):
    """
    Traceback frame information.
    """

    def __init__(self, location, function_name):
        self.location = location
        self.function_name = function_name
        self.source_code = []
91
        self.error_line = ''
92 93 94 95
        blank_count = []
        begin_lineno = max(1, self.location.lineno - int(SOURCE_CODE_RANGE / 2))

        for i in range(begin_lineno, begin_lineno + SOURCE_CODE_RANGE):
96 97
            line = linecache.getline(self.location.filepath, i).rstrip('\n')
            line_lstrip = line.lstrip()
98
            self.source_code.append(line_lstrip)
99 100 101 102
            if not line_lstrip:  # empty line from source code
                blank_count.append(-1)
            else:
                blank_count.append(len(line) - len(line_lstrip))
103 104

            if i == self.location.lineno:
105
                self.error_line = self.source_code[-1]
106 107 108 109
                hint_msg = '~' * len(self.source_code[-1]) + ' <--- HERE'
                self.source_code.append(hint_msg)
                blank_count.append(blank_count[-1])
        linecache.clearcache()
110 111 112 113 114 115 116 117 118
        # remove top and bottom empty line in source code
        while len(self.source_code) > 0 and not self.source_code[0]:
            self.source_code.pop(0)
            blank_count.pop(0)
        while len(self.source_code) > 0 and not self.source_code[-1]:
            self.source_code.pop(-1)
            blank_count.pop(-1)

        min_black_count = min([i for i in blank_count if i >= 0])
119
        for i in range(len(self.source_code)):
120 121
            # if source_code[i] is empty line between two code line, dont add blank
            if self.source_code[i]:
122 123 124
                self.source_code[i] = ' ' * (
                    blank_count[i] - min_black_count +
                    BLANK_COUNT_BEFORE_FILE_STR * 2) + self.source_code[i]
125 126 127 128 129

    def formated_message(self):
        msg = ' ' * BLANK_COUNT_BEFORE_FILE_STR + 'File "{}", line {}, in {}\n'.format(
            self.location.filepath, self.location.lineno, self.function_name)
        # add empty line after range code
130
        return msg + '\n'.join(self.source_code)
131 132


133
class SuggestionDict(object):
134

135 136 137 138 139 140 141 142 143 144 145 146 147 148 149 150
    def __init__(self):
        # {(keywords): (suggestions)}
        self.suggestion_dict = {
            ('is not initialized.', 'Hint:', 'IsInitialized'):
            ("Please ensure all your sublayers are inheritted from nn.Layer.",
             "Please ensure there is no tensor created explicitly depended on external data, we suggest to register it as buffer tensor. See https://www.paddlepaddle.org.cn/documentation/docs/zh/guides/04_dygraph_to_static/export_model/principle_cn.html#parameters-buffers for details"
             )
        }

    def keys(self):
        return self.suggestion_dict.keys()

    def __getitem__(self, key):
        return self.suggestion_dict[key]


151 152 153 154
class Dy2StKeyError(Exception):
    pass


155 156 157 158 159 160 161 162 163 164 165
class ErrorData(object):
    """
    Error data attached to an exception which is raised in un-transformed code.
    """

    def __init__(self, error_type, error_value, origin_traceback,
                 origin_info_map):
        self.error_type = error_type
        self.error_value = error_value
        self.origin_traceback = origin_traceback
        self.origin_info_map = origin_info_map
166
        self.in_runtime = False
167
        self.suggestion_dict = SuggestionDict()
168 169 170

    def create_exception(self):
        message = self.create_message()
171 172 173 174
        if self.error_type is KeyError:
            new_exception = Dy2StKeyError(message)
        else:
            new_exception = self.error_type(message)
175 176 177
        setattr(new_exception, ERROR_DATA, self)
        return new_exception

178 179 180 181 182 183 184 185 186 187 188 189 190 191 192 193 194 195 196 197 198 199 200 201 202 203 204 205 206 207
    def numpy_api_check(self, format_exception, error_line):
        if self.error_type is not TypeError:
            return format_exception

        tb = self.origin_traceback
        func_str = None
        for frame in tb:
            searched_name = re.search(
                r'({module})*{name}'.format(module=RE_PYMODULE,
                                            name=frame.name), error_line)
            if searched_name:
                func_str = searched_name.group(0)
                break
        try:
            module_result = eval("_is_api_in_module_helper({}, '{}')".format(
                func_str, "numpy"))
            is_numpy_api_err = module_result or (func_str.startswith("numpy.")
                                                 or func_str.startswith("np."))
        except Exception:
            is_numpy_api_err = False

        if is_numpy_api_err and func_str:
            return [
                "TypeError: Code '{}' called numpy API {}, please use Paddle API to replace it."
                .format(error_line, func_str),
                "           values will be changed to variables by dy2static, numpy api can not handle variables"
            ]
        else:
            return format_exception

208 209 210 211 212 213 214
    def create_message(self):
        """
        Creates a custom error message which includes trace stack with source code information of dygraph from user.
        """
        message_lines = []

        # Step1: Adds header message to prompt users that the following is the original information.
215
        header_message = "In transformed code:"
216 217
        message_lines.append(header_message)
        message_lines.append("")
218
        error_line = None
219

220 221
        # Simplify error value to improve readability if error is raised in runtime
        if self.in_runtime:
222 223 224 225
            if int(
                    os.getenv(SIMPLIFY_ERROR_ENV_NAME,
                              DEFAULT_SIMPLIFY_NEW_ERROR)):
                self._simplify_error_value()
226 227 228
            message_lines.append(str(self.error_value))
            return '\n'.join(message_lines)

229
        # Step2: Optimizes stack information with source code information of dygraph from user.
230 231 232 233
        user_code_traceback_index = []
        for i, (filepath, lineno, funcname,
                code) in enumerate(self.origin_traceback):
            dygraph_func_info = self.origin_info_map.get((filepath, lineno),
234 235
                                                         None)
            if dygraph_func_info:
236 237 238 239 240 241 242 243 244 245 246 247 248 249 250 251
                user_code_traceback_index.append(i)

        # Add user code traceback
        for i in user_code_traceback_index:
            filepath, lineno, funcname, code = self.origin_traceback[i]
            dygraph_func_info = self.origin_info_map.get((filepath, lineno),
                                                         None)
            if i == user_code_traceback_index[-1]:
                traceback_frame = TraceBackFrameRange(
                    dygraph_func_info.location, dygraph_func_info.function_name)
            else:
                traceback_frame = TraceBackFrame(
                    dygraph_func_info.location, dygraph_func_info.function_name,
                    dygraph_func_info.source_code)

            message_lines.append(traceback_frame.formated_message())
252
            error_line = traceback_frame.error_line
253 254 255
        message_lines.append("")

        # Add paddle traceback after user code traceback
256
        paddle_traceback_start_index = user_code_traceback_index[
257 258
            -1] + 1 if user_code_traceback_index else 0
        for filepath, lineno, funcname, code in self.origin_traceback[
259
                paddle_traceback_start_index:]:
260 261
            traceback_frame = TraceBackFrame(Location(filepath, lineno),
                                             funcname, code)
262 263
            message_lines.append(traceback_frame.formated_message())
        message_lines.append("")
264 265

        # Step3: Adds error message like "TypeError: dtype must be int32, but received float32".
266 267
        # NOTE: `format_exception` is a list, its length is 1 in most cases, but sometimes its length
        # is gather than 1, for example, the error_type is IndentationError.
268 269
        format_exception = traceback.format_exception_only(
            self.error_type, self.error_value)
270 271 272 273
        if error_line is not None:
            format_exception = self.numpy_api_check(format_exception,
                                                    error_line)

274 275 276 277
        error_message = [
            " " * BLANK_COUNT_BEFORE_FILE_STR + line
            for line in format_exception
        ]
278
        message_lines.extend(error_message)
279 280

        return '\n'.join(message_lines)
281

282 283 284 285 286 287 288 289 290 291 292 293 294 295 296 297
    def _create_revise_suggestion(self, bottom_error_message):
        revise_suggestions = [
            '', ' ' * BLANK_COUNT_BEFORE_FILE_STR + 'Revise suggestion: '
        ]
        for keywords in self.suggestion_dict.keys():
            contain_keywords = [
                True for i in keywords if i in ''.join(bottom_error_message)
            ]
            if len(contain_keywords) == len(
                    keywords):  # all keywords should be in bottom_error_message
                for suggestion in self.suggestion_dict[keywords]:
                    suggestion_msg = ' ' * BLANK_COUNT_BEFORE_FILE_STR * 2 + '{}. {}'.format(
                        str(len(revise_suggestions) - 1), suggestion)
                    revise_suggestions.append(suggestion_msg)
        return revise_suggestions if len(revise_suggestions) > 2 else []

298 299 300 301 302 303 304 305 306 307
    def _simplify_error_value(self):
        """
        Simplifies error value to improve readability if error is raised in runtime.

        NOTE(liym27): The op callstack information about transformed static code has been replaced with original dygraph code.

        TODO(liym27):
            1. Need a more robust way because the code of start_trace may change.
            2. Set the switch to determine whether to simplify error_value
        """
308

309 310 311 312 313 314 315
        assert self.in_runtime is True

        error_value_lines = str(self.error_value).split("\n")
        error_value_lines_strip = [mes.lstrip(" ") for mes in error_value_lines]

        start_trace = "outputs = static_func(*inputs)"
        start_idx = error_value_lines_strip.index(start_trace)
316

317
        error_value_lines = error_value_lines[start_idx + 1:]
318 319 320 321 322
        error_value_lines_strip = error_value_lines_strip[start_idx + 1:]

        # use empty line to locate the bottom_error_message
        empty_line_idx = error_value_lines_strip.index('')
        bottom_error_message = error_value_lines[empty_line_idx + 1:]
323
        revise_suggestion = self._create_revise_suggestion(bottom_error_message)
324

325 326
        error_traceback = []
        user_code_traceback_index = []
327
        pattern = 'File "(?P<filepath>.+)", line (?P<lineno>.+), in (?P<function_name>.+)'
328 329 330 331 332 333 334 335

        # Distinguish user code and framework code using static_info_map
        static_info_map = {}
        for k, v in self.origin_info_map.items():
            origin_filepath = v.location.filepath
            origin_lineno = v.location.lineno
            static_info_map[(origin_filepath, origin_lineno)] = k

336 337 338 339
        for i in range(0, len(error_value_lines_strip), 2):
            if error_value_lines_strip[i].startswith("File "):
                re_result = re.search(pattern, error_value_lines_strip[i])
                tmp_filepath, lineno_str, function_name = re_result.groups()
340 341
                code = error_value_lines_strip[
                    i + 1] if i + 1 < len(error_value_lines_strip) else ''
342 343

                if static_info_map.get((tmp_filepath, int(lineno_str))):
344 345 346 347
                    user_code_traceback_index.append(len(error_traceback))

                error_traceback.append(
                    (tmp_filepath, int(lineno_str), function_name, code))
348 349

        error_frame = []
350 351 352 353 354 355
        # Add user code traceback
        for i in user_code_traceback_index:
            filepath, lineno, funcname, code = error_traceback[i]
            if i == user_code_traceback_index[-1]:
                traceback_frame = TraceBackFrameRange(
                    Location(filepath, lineno), funcname)
356
            else:
357 358
                traceback_frame = TraceBackFrame(Location(filepath, lineno),
                                                 funcname, code)
359 360 361 362
            error_frame.append(traceback_frame.formated_message())
        error_frame.append("")

        # Add paddle traceback after user code traceback
363
        paddle_traceback_start_index = user_code_traceback_index[
364 365
            -1] + 1 if user_code_traceback_index else 0
        for filepath, lineno, funcname, code in error_traceback[
366
                paddle_traceback_start_index:]:
367 368
            traceback_frame = TraceBackFrame(Location(filepath, lineno),
                                             funcname, code)
369 370
            error_frame.append(traceback_frame.formated_message())
        error_frame.append("")
371

372
        error_frame.extend(bottom_error_message)
373
        error_frame.extend(revise_suggestion)
374
        error_value_str = '\n'.join(error_frame)
375
        self.error_value = self.error_type(error_value_str)
376 377 378 379 380 381 382 383 384 385 386 387 388 389 390 391 392 393

    def raise_new_exception(self):
        # Raises the origin error if disable dygraph2static error module,
        if int(os.getenv(DISABLE_ERROR_ENV_NAME, DEFAULT_DISABLE_NEW_ERROR)):
            raise

        new_exception = self.create_exception()
        if six.PY3:
            # NOTE(liym27):
            # 1. Why `raise new_exception from None`?
            #   In Python 3, by default, an new exception is raised with trace information of the caught exception.
            #   This only raises new_exception and hides unwanted implementation details from tracebacks of the
            #   caught exception.
            # 2. Use exec to bypass syntax error checking in Python 2.

            six.exec_("raise new_exception from None")
        else:
            raise new_exception