~bzr-pqm/bzr/bzr.dev

« back to all changes in this revision

Viewing changes to bzrlib/trace.py

  • Committer: Andrew Bennetts
  • Date: 2011-02-25 08:45:27 UTC
  • mto: This revision was merged to the branch mainline in revision 5695.
  • Revision ID: andrew.bennetts@canonical.com-20110225084527-0ucp7p00d00hoqon
Add another test.

Show diffs side-by-side

added added

removed removed

Lines of Context:
59
59
import os
60
60
import sys
61
61
import time
 
62
import tempfile
62
63
 
63
64
from bzrlib.lazy_import import lazy_import
64
65
lazy_import(globals(), """
111
112
 
112
113
 
113
114
def note(*args, **kwargs):
 
115
    """Output a note to the user.
 
116
 
 
117
    Takes the same parameters as logging.info.
 
118
 
 
119
    :return: None
 
120
    """
114
121
    # FIXME note always emits utf-8, regardless of the terminal encoding
115
122
    #
116
123
    # FIXME: clearing the ui and then going through the abstract logging
117
124
    # framework is whack; we should probably have a logging Handler that
118
125
    # deals with terminal output if needed.
119
 
    import bzrlib.ui
120
 
    bzrlib.ui.ui_factory.clear_term()
 
126
    ui.ui_factory.clear_term()
121
127
    _bzr_logger.info(*args, **kwargs)
122
128
 
123
129
 
124
130
def warning(*args, **kwargs):
125
 
    import bzrlib.ui
126
 
    bzrlib.ui.ui_factory.clear_term()
 
131
    ui.ui_factory.clear_term()
127
132
    _bzr_logger.warning(*args, **kwargs)
128
133
 
129
134
 
300
305
    logging.getLogger("bzr").
301
306
 
302
307
    Output can be redirected away by calling _push_log_file.
 
308
 
 
309
    :return: A memento from push_log_file for restoring the log state.
303
310
    """
304
 
    # Do this before we open the log file, so we prevent
305
 
    # get_terminal_encoding() from mutter()ing multiple times
306
 
    term_encoding = osutils.get_terminal_encoding()
307
311
    start_time = osutils.format_local_date(_bzr_log_start_time,
308
312
                                           timezone='local')
309
313
    # create encoded wrapper around stderr
310
314
    bzr_log_file = _open_bzr_log()
311
315
    if bzr_log_file is not None:
312
316
        bzr_log_file.write(start_time.encode('utf-8') + '\n')
313
 
    push_log_file(bzr_log_file,
 
317
    memento = push_log_file(bzr_log_file,
314
318
        r'[%(process)5d] %(asctime)s.%(msecs)03d %(levelname)s: %(message)s',
315
319
        r'%Y-%m-%d %H:%M:%S')
316
320
    # after hooking output into bzr_log, we also need to attach a stderr
317
321
    # handler, writing only at level info and with encoding
 
322
    term_encoding = osutils.get_terminal_encoding()
318
323
    writer_factory = codecs.getwriter(term_encoding)
319
324
    encoded_stderr = writer_factory(sys.stderr, errors='replace')
320
325
    stderr_handler = logging.StreamHandler(encoded_stderr)
321
326
    stderr_handler.setLevel(logging.INFO)
322
327
    logging.getLogger('bzr').addHandler(stderr_handler)
 
328
    return memento
323
329
 
324
330
 
325
331
def push_log_file(to_file, log_format=None, date_format=None):
361
367
def pop_log_file((magic, old_handlers, new_handler, old_trace_file, new_trace_file)):
362
368
    """Undo changes to logging/tracing done by _push_log_file.
363
369
 
364
 
    This flushes, but does not close the trace file.
 
370
    This flushes, but does not close the trace file (so that anything that was
 
371
    in it is output.
365
372
 
366
373
    Takes the memento returned from _push_log_file."""
367
374
    global _trace_file
368
375
    _trace_file = old_trace_file
369
376
    bzr_logger = logging.getLogger('bzr')
370
377
    bzr_logger.removeHandler(new_handler)
371
 
    # must be closed, otherwise logging will try to close it atexit, and the
 
378
    # must be closed, otherwise logging will try to close it at exit, and the
372
379
    # file will likely already be closed underneath.
373
380
    new_handler.close()
374
381
    bzr_logger.handlers = old_handlers
375
 
    new_trace_file.flush()
 
382
    if new_trace_file is not None:
 
383
        new_trace_file.flush()
376
384
 
377
385
 
378
386
def log_exception_quietly():
460
468
                    note(line)
461
469
                    break
462
470
 
 
471
def _dump_memory_usage(err_file):
 
472
    try:
 
473
        try:
 
474
            fd, name = tempfile.mkstemp(prefix="bzr_memdump", suffix=".json")
 
475
            dump_file = os.fdopen(fd, 'w')
 
476
            from meliae import scanner
 
477
            scanner.dump_gc_objects(dump_file)
 
478
            err_file.write("Memory dumped to %s\n" % name)
 
479
        except ImportError:
 
480
            err_file.write("Dumping memory requires meliae module.\n")
 
481
            log_exception_quietly()
 
482
        except:
 
483
            err_file.write("Exception while dumping memory.\n")
 
484
            log_exception_quietly()
 
485
    finally:
 
486
        if dump_file is not None:
 
487
            dump_file.close()
 
488
        elif fd is not None:
 
489
            os.close(fd)
463
490
 
464
491
def report_exception(exc_info, err_file):
465
492
    """Report an exception to err_file (typically stderr) and to .bzr.log.
483
510
        return errors.EXIT_ERROR
484
511
    elif isinstance(exc_object, MemoryError):
485
512
        err_file.write("bzr: out of memory\n")
 
513
        if 'mem_dump' in debug.debug_flags:
 
514
            _dump_memory_usage(err_file)
 
515
        else:
 
516
            err_file.write("Use -Dmem_dump to dump memory to a file.\n")
486
517
        return errors.EXIT_ERROR
487
518
    elif isinstance(exc_object, ImportError) \
488
519
        and str(exc_object).startswith("No module named "):
492
523
    elif not getattr(exc_object, 'internal_error', True):
493
524
        report_user_error(exc_info, err_file)
494
525
        return errors.EXIT_ERROR
495
 
    elif isinstance(exc_object, (OSError, IOError)):
 
526
    elif isinstance(exc_object, (OSError, IOError)) or (
 
527
        # GZ 2010-05-20: Like (exc_type is pywintypes.error) but avoid import
 
528
        exc_type.__name__ == "error" and exc_type.__module__ == "pywintypes"):
496
529
        # Might be nice to catch all of these and show them as something more
497
530
        # specific, but there are too many cases at the moment.
498
531
        report_user_error(exc_info, err_file)
532
565
 
533
566
 
534
567
def _flush_stdout_stderr():
535
 
    # installed into an atexit hook by bzrlib.initialize()
 
568
    # called from the bzrlib library finalizer returned by bzrlib.initialize()
536
569
    try:
537
570
        sys.stdout.flush()
538
571
        sys.stderr.flush()
545
578
 
546
579
 
547
580
def _flush_trace():
548
 
    # run from atexit hook
 
581
    # called from the bzrlib library finalizer returned by bzrlib.initialize()
549
582
    global _trace_file
550
583
    if _trace_file:
551
584
        _trace_file.flush()
 
585
 
 
586
 
 
587
class Config(object):
 
588
    """Configuration of message tracing in bzrlib.
 
589
 
 
590
    This implements the context manager protocol and should manage any global
 
591
    variables still used. The default config used is DefaultConfig, but
 
592
    embedded uses of bzrlib may wish to use a custom manager.
 
593
    """
 
594
 
 
595
    def __enter__(self):
 
596
        return self # This is bound to the 'as' clause in a with statement.
 
597
 
 
598
    def __exit__(self, exc_type, exc_val, exc_tb):
 
599
        return False # propogate exceptions.
 
600
 
 
601
 
 
602
class DefaultConfig(Config):
 
603
    """A default configuration for tracing of messages in bzrlib.
 
604
 
 
605
    This implements the context manager protocol.
 
606
    """
 
607
 
 
608
    def __enter__(self):
 
609
        self._original_filename = _bzr_log_filename
 
610
        self._original_state = enable_default_logging()
 
611
        return self # This is bound to the 'as' clause in a with statement.
 
612
 
 
613
    def __exit__(self, exc_type, exc_val, exc_tb):
 
614
        pop_log_file(self._original_state)
 
615
        global _bzr_log_filename
 
616
        _bzr_log_filename = self._original_filename
 
617
        return False # propogate exceptions.