~bzr-pqm/bzr/bzr.dev

« back to all changes in this revision

Viewing changes to bzrlib/progress.py

  • Committer: Martin Pool
  • Date: 2005-08-24 00:34:21 UTC
  • Revision ID: mbp@sourcefrog.net-20050824003421-33dd8e5c739cad2a
- send trace messages out through python logging module

Show diffs side-by-side

added added

removed removed

Lines of Context:
1
1
# Copyright (C) 2005 Aaron Bentley <aaron.bentley@utoronto.ca>
2
 
# Copyright (C) 2005, 2006 Canonical Ltd
3
 
#
4
 
# This program is free software; you can redistribute it and/or modify
5
 
# it under the terms of the GNU General Public License as published by
6
 
# the Free Software Foundation; either version 2 of the License, or
7
 
# (at your option) any later version.
8
 
#
9
 
# This program is distributed in the hope that it will be useful,
10
 
# but WITHOUT ANY WARRANTY; without even the implied warranty of
11
 
# MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE.  See the
12
 
# GNU General Public License for more details.
13
 
#
14
 
# You should have received a copy of the GNU General Public License
15
 
# along with this program; if not, write to the Free Software
16
 
# Foundation, Inc., 59 Temple Place, Suite 330, Boston, MA  02111-1307  USA
 
2
# Copyright (C) 2005 Canonical <canonical.com>
 
3
#
 
4
#    This program is free software; you can redistribute it and/or modify
 
5
#    it under the terms of the GNU General Public License as published by
 
6
#    the Free Software Foundation; either version 2 of the License, or
 
7
#    (at your option) any later version.
 
8
#
 
9
#    This program is distributed in the hope that it will be useful,
 
10
#    but WITHOUT ANY WARRANTY; without even the implied warranty of
 
11
#    MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE.  See the
 
12
#    GNU General Public License for more details.
 
13
#
 
14
#    You should have received a copy of the GNU General Public License
 
15
#    along with this program; if not, write to the Free Software
 
16
#    Foundation, Inc., 59 Temple Place, Suite 330, Boston, MA  02111-1307  USA
17
17
 
18
18
 
19
19
"""Simple text-mode progress indicator.
35
35
# TODO: Optionally show elapsed time instead/as well as ETA; nicer
36
36
# when the rate is unpredictable
37
37
 
 
38
 
38
39
import sys
39
40
import time
40
41
import os
41
42
 
42
 
from bzrlib.lazy_import import lazy_import
43
 
lazy_import(globals(), """
44
 
from bzrlib import (
45
 
    errors,
46
 
    )
47
 
""")
48
 
 
49
 
from bzrlib.trace import mutter
 
43
 
 
44
def _width():
 
45
    """Return estimated terminal width.
 
46
 
 
47
    TODO: Do something smart on Windows?
 
48
 
 
49
    TODO: Is there anything that gets a better update when the window
 
50
          is resized while the program is running?
 
51
    """
 
52
    try:
 
53
        return int(os.environ['COLUMNS'])
 
54
    except (IndexError, KeyError, ValueError):
 
55
        return 80
50
56
 
51
57
 
52
58
def _supports_progress(f):
53
 
    """Detect if we can use pretty progress bars on the output stream f.
54
 
 
55
 
    If this returns true we expect that a human may be looking at that 
56
 
    output, and that we can repaint a line to update it.
57
 
    """
58
 
    isatty = getattr(f, 'isatty', None)
59
 
    if isatty is None:
 
59
    if not hasattr(f, 'isatty'):
60
60
        return False
61
 
    if not isatty():
 
61
    if not f.isatty():
62
62
        return False
63
63
    if os.environ.get('TERM') == 'dumb':
64
64
        # e.g. emacs compile window
66
66
    return True
67
67
 
68
68
 
69
 
_progress_bar_types = {}
70
 
 
71
 
 
72
 
def ProgressBar(to_file=None, **kwargs):
 
69
 
 
70
def ProgressBar(to_file=sys.stderr, **kwargs):
73
71
    """Abstract factory"""
74
 
    if to_file is None:
75
 
        to_file = sys.stderr
76
 
    requested_bar_type = os.environ.get('BZR_PROGRESS_BAR')
77
 
    # An value of '' or not set reverts to standard processing
78
 
    if requested_bar_type in (None, ''):
79
 
        if _supports_progress(to_file):
80
 
            return TTYProgressBar(to_file=to_file, **kwargs)
81
 
        else:
82
 
            return DummyProgress(to_file=to_file, **kwargs)
 
72
    if _supports_progress(to_file):
 
73
        return TTYProgressBar(to_file=to_file, **kwargs)
83
74
    else:
84
 
        # Minor sanitation to prevent spurious errors
85
 
        requested_bar_type = requested_bar_type.lower().strip()
86
 
        # TODO: jam 20060710 Arguably we shouldn't raise an exception
87
 
        #       but should instead just disable progress bars if we
88
 
        #       don't recognize the type
89
 
        if requested_bar_type not in _progress_bar_types:
90
 
            raise errors.InvalidProgressBarType(requested_bar_type,
91
 
                                                _progress_bar_types.keys())
92
 
        return _progress_bar_types[requested_bar_type](to_file=to_file, **kwargs)
93
 
 
94
 
 
95
 
class ProgressBarStack(object):
96
 
    """A stack of progress bars."""
97
 
 
98
 
    def __init__(self,
99
 
                 to_file=None,
100
 
                 show_pct=False,
101
 
                 show_spinner=True,
102
 
                 show_eta=False,
103
 
                 show_bar=True,
104
 
                 show_count=True,
105
 
                 to_messages_file=None,
106
 
                 klass=None):
107
 
        """Setup the stack with the parameters the progress bars should have."""
108
 
        if to_file is None:
109
 
            to_file = sys.stderr
110
 
        if to_messages_file is None:
111
 
            to_messages_file = sys.stdout
112
 
        self._to_file = to_file
113
 
        self._show_pct = show_pct
114
 
        self._show_spinner = show_spinner
115
 
        self._show_eta = show_eta
116
 
        self._show_bar = show_bar
117
 
        self._show_count = show_count
118
 
        self._to_messages_file = to_messages_file
119
 
        self._stack = []
120
 
        self._klass = klass or ProgressBar
121
 
 
122
 
    def top(self):
123
 
        if len(self._stack) != 0:
124
 
            return self._stack[-1]
125
 
        else:
126
 
            return None
127
 
 
128
 
    def bottom(self):
129
 
        if len(self._stack) != 0:
130
 
            return self._stack[0]
131
 
        else:
132
 
            return None
133
 
 
134
 
    def get_nested(self):
135
 
        """Return a nested progress bar."""
136
 
        if len(self._stack) == 0:
137
 
            func = self._klass
138
 
        else:
139
 
            func = self.top().child_progress
140
 
        new_bar = func(to_file=self._to_file,
141
 
                       show_pct=self._show_pct,
142
 
                       show_spinner=self._show_spinner,
143
 
                       show_eta=self._show_eta,
144
 
                       show_bar=self._show_bar,
145
 
                       show_count=self._show_count,
146
 
                       to_messages_file=self._to_messages_file,
147
 
                       _stack=self)
148
 
        self._stack.append(new_bar)
149
 
        return new_bar
150
 
 
151
 
    def return_pb(self, bar):
152
 
        """Return bar after its been used."""
153
 
        if bar is not self._stack[-1]:
154
 
            raise errors.MissingProgressBarFinish()
155
 
        self._stack.pop()
156
 
 
157
 
 
 
75
        return DotsProgressBar(to_file=to_file, **kwargs)
 
76
    
 
77
    
158
78
class _BaseProgressBar(object):
159
 
 
160
79
    def __init__(self,
161
 
                 to_file=None,
 
80
                 to_file=sys.stderr,
162
81
                 show_pct=False,
163
82
                 show_spinner=False,
164
 
                 show_eta=False,
 
83
                 show_eta=True,
165
84
                 show_bar=True,
166
 
                 show_count=True,
167
 
                 to_messages_file=None,
168
 
                 _stack=None):
 
85
                 show_count=True):
169
86
        object.__init__(self)
170
 
        if to_file is None:
171
 
            to_file = sys.stderr
172
 
        if to_messages_file is None:
173
 
            to_messages_file = sys.stdout
174
87
        self.to_file = to_file
175
 
        self.to_messages_file = to_messages_file
 
88
 
176
89
        self.last_msg = None
177
90
        self.last_cnt = None
178
91
        self.last_total = None
181
94
        self.show_eta = show_eta
182
95
        self.show_bar = show_bar
183
96
        self.show_count = show_count
184
 
        self._stack = _stack
185
 
        # seed throttler
186
 
        self.MIN_PAUSE = 0.1 # seconds
187
 
        now = time.time()
188
 
        # starting now
189
 
        self.start_time = now
190
 
        # next update should not throttle
191
 
        self.last_update = now - self.MIN_PAUSE - 1
192
 
 
193
 
    def finished(self):
194
 
        """Return this bar to its progress stack."""
195
 
        self.clear()
196
 
        assert self._stack is not None
197
 
        self._stack.return_pb(self)
198
 
 
199
 
    def note(self, fmt_string, *args, **kwargs):
200
 
        """Record a note without disrupting the progress bar."""
201
 
        self.clear()
202
 
        self.to_messages_file.write(fmt_string % args)
203
 
        self.to_messages_file.write('\n')
204
 
 
205
 
    def child_progress(self, **kwargs):
206
 
        return ChildProgress(**kwargs)
207
 
 
208
 
 
209
 
class DummyProgress(_BaseProgressBar):
210
 
    """Progress-bar standin that does nothing.
211
 
 
212
 
    This can be used as the default argument for methods that
213
 
    take an optional progress indicator."""
214
 
    def tick(self):
215
 
        pass
216
 
 
217
 
    def update(self, msg=None, current=None, total=None):
218
 
        pass
219
 
 
220
 
    def child_update(self, message, current, total):
221
 
        pass
222
 
 
223
 
    def clear(self):
224
 
        pass
225
 
        
226
 
    def note(self, fmt_string, *args, **kwargs):
227
 
        """See _BaseProgressBar.note()."""
228
 
 
229
 
    def child_progress(self, **kwargs):
230
 
        return DummyProgress(**kwargs)
231
 
 
232
 
 
233
 
_progress_bar_types['dummy'] = DummyProgress
234
 
_progress_bar_types['none'] = DummyProgress
235
 
 
236
 
 
 
97
        
 
98
        
 
99
    
237
100
class DotsProgressBar(_BaseProgressBar):
238
 
 
239
101
    def __init__(self, **kwargs):
240
102
        _BaseProgressBar.__init__(self, **kwargs)
241
103
        self.last_msg = None
248
110
        if msg and msg != self.last_msg:
249
111
            if self.need_nl:
250
112
                self.to_file.write('\n')
 
113
            
251
114
            self.to_file.write(msg + ': ')
252
115
            self.last_msg = msg
253
116
        self.need_nl = True
256
119
    def clear(self):
257
120
        if self.need_nl:
258
121
            self.to_file.write('\n')
259
 
        self.need_nl = False
260
122
        
261
 
    def child_update(self, message, current, total):
262
 
        self.tick()
263
 
 
264
 
 
265
 
_progress_bar_types['dots'] = DotsProgressBar
266
 
 
267
123
    
268
124
class TTYProgressBar(_BaseProgressBar):
269
125
    """Progress bar display object.
286
142
    The output file should be in line-buffered or unbuffered mode.
287
143
    """
288
144
    SPIN_CHARS = r'/-\|'
 
145
    MIN_PAUSE = 0.1 # seconds
289
146
 
290
147
 
291
148
    def __init__(self, **kwargs):
292
 
        from bzrlib.osutils import terminal_width
293
149
        _BaseProgressBar.__init__(self, **kwargs)
294
150
        self.spin_pos = 0
295
 
        self.width = terminal_width()
296
 
        self.last_updates = []
297
 
        self._max_last_updates = 10
298
 
        self.child_fraction = 0
299
 
        self._have_output = False
 
151
        self.width = _width()
 
152
        self.start_time = None
 
153
        self.last_update = None
300
154
    
301
155
 
302
 
    def throttle(self, old_msg):
 
156
    def throttle(self):
303
157
        """Return True if the bar was updated too recently"""
304
 
        # time.time consistently takes 40/4000 ms = 0.01 ms.
305
 
        # time.clock() is faster, but gives us CPU time, not wall-clock time
306
158
        now = time.time()
307
 
        if self.start_time is not None and (now - self.start_time) < 1:
308
 
            return True
309
 
        if old_msg != self.last_msg:
 
159
        if self.start_time is None:
 
160
            self.start_time = self.last_update = now
310
161
            return False
311
 
        interval = now - self.last_update
312
 
        # if interval > 0
313
 
        if interval < self.MIN_PAUSE:
314
 
            return True
 
162
        else:
 
163
            interval = now - self.last_update
 
164
            if interval > 0 and interval < self.MIN_PAUSE:
 
165
                return True
315
166
 
316
 
        self.last_updates.append(now - self.last_update)
317
 
        # Don't let the queue grow without bound
318
 
        self.last_updates = self.last_updates[-self._max_last_updates:]
319
167
        self.last_update = now
320
168
        return False
321
169
        
 
170
 
322
171
    def tick(self):
323
 
        self.update(self.last_msg, self.last_cnt, self.last_total, 
324
 
                    self.child_fraction)
325
 
 
326
 
    def child_update(self, message, current, total):
327
 
        if current is not None and total != 0:
328
 
            child_fraction = float(current) / total
329
 
            if self.last_cnt is None:
330
 
                pass
331
 
            elif self.last_cnt + child_fraction <= self.last_total:
332
 
                self.child_fraction = child_fraction
333
 
            else:
334
 
                mutter('not updating child fraction')
335
 
        if self.last_msg is None:
336
 
            self.last_msg = ''
337
 
        self.tick()
338
 
 
339
 
    def update(self, msg, current_cnt=None, total_cnt=None, 
340
 
               child_fraction=0):
 
172
        self.update(self.last_msg, self.last_cnt, self.last_total)
 
173
                 
 
174
 
 
175
 
 
176
    def update(self, msg, current_cnt=None, total_cnt=None):
341
177
        """Update and redraw progress bar."""
342
 
        if msg is None:
343
 
            msg = self.last_msg
344
 
 
345
 
        if total_cnt is None:
346
 
            total_cnt = self.last_total
347
 
 
348
 
        if current_cnt < 0:
349
 
            current_cnt = 0
350
 
            
351
 
        if current_cnt > total_cnt:
352
 
            total_cnt = current_cnt
353
 
        
354
 
        ## # optional corner case optimisation 
355
 
        ## # currently does not seem to fire so costs more than saved.
356
 
        ## # trivial optimal case:
357
 
        ## # NB if callers are doing a clear and restore with
358
 
        ## # the saved values, this will prevent that:
359
 
        ## # in that case add a restore method that calls
360
 
        ## # _do_update or some such
361
 
        ## if (self.last_msg == msg and
362
 
        ##     self.last_cnt == current_cnt and
363
 
        ##     self.last_total == total_cnt and
364
 
        ##     self.child_fraction == child_fraction):
365
 
        ##     return
366
 
 
367
 
        old_msg = self.last_msg
 
178
 
368
179
        # save these for the tick() function
369
180
        self.last_msg = msg
370
181
        self.last_cnt = current_cnt
371
182
        self.last_total = total_cnt
372
 
        self.child_fraction = child_fraction
373
 
 
374
 
        # each function call takes 20ms/4000 = 0.005 ms, 
375
 
        # but multiple that by 4000 calls -> starts to cost.
376
 
        # so anything to make this function call faster
377
 
        # will improve base 'diff' time by up to 0.1 seconds.
378
 
        if self.throttle(old_msg):
379
 
            return
380
 
 
381
 
        if self.show_eta and self.start_time and self.last_total:
382
 
            eta = get_eta(self.start_time, self.last_cnt + self.child_fraction, 
383
 
                    self.last_total, last_updates = self.last_updates)
 
183
            
 
184
        if self.throttle():
 
185
            return 
 
186
        
 
187
        if total_cnt:
 
188
            assert current_cnt <= total_cnt
 
189
        if current_cnt:
 
190
            assert current_cnt >= 0
 
191
        
 
192
        if self.show_eta and self.start_time and total_cnt:
 
193
            eta = get_eta(self.start_time, current_cnt, total_cnt)
384
194
            eta_str = " " + str_tdelta(eta)
385
195
        else:
386
196
            eta_str = ""
393
203
        # always update this; it's also used for the bar
394
204
        self.spin_pos += 1
395
205
 
396
 
        if self.show_pct and self.last_total and self.last_cnt:
397
 
            pct = 100.0 * ((self.last_cnt + self.child_fraction) / self.last_total)
 
206
        if self.show_pct and total_cnt and current_cnt:
 
207
            pct = 100.0 * current_cnt / total_cnt
398
208
            pct_str = ' (%5.1f%%)' % pct
399
209
        else:
400
210
            pct_str = ''
401
211
 
402
212
        if not self.show_count:
403
213
            count_str = ''
404
 
        elif self.last_cnt is None:
 
214
        elif current_cnt is None:
405
215
            count_str = ''
406
 
        elif self.last_total is None:
407
 
            count_str = ' %i' % (self.last_cnt)
 
216
        elif total_cnt is None:
 
217
            count_str = ' %i' % (current_cnt)
408
218
        else:
409
219
            # make both fields the same size
410
 
            t = '%i' % (self.last_total)
411
 
            c = '%*i' % (len(t), self.last_cnt)
 
220
            t = '%i' % (total_cnt)
 
221
            c = '%*i' % (len(t), current_cnt)
412
222
            count_str = ' ' + c + '/' + t 
413
223
 
414
224
        if self.show_bar:
415
225
            # progress bar, if present, soaks up all remaining space
416
 
            cols = self.width - 1 - len(self.last_msg) - len(spin_str) - len(pct_str) \
 
226
            cols = self.width - 1 - len(msg) - len(spin_str) - len(pct_str) \
417
227
                   - len(eta_str) - len(count_str) - 3
418
228
 
419
 
            if self.last_total:
 
229
            if total_cnt:
420
230
                # number of markers highlighted in bar
421
 
                markers = int(round(float(cols) * 
422
 
                              (self.last_cnt + self.child_fraction) / self.last_total))
 
231
                markers = int(round(float(cols) * current_cnt / total_cnt))
423
232
                bar_str = '[' + ('=' * markers).ljust(cols) + '] '
424
233
            elif False:
425
234
                # don't know total, so can't show completion.
433
242
        else:
434
243
            bar_str = ''
435
244
 
436
 
        m = spin_str + bar_str + self.last_msg + count_str + pct_str + eta_str
437
 
        self.to_file.write('\r%-*.*s' % (self.width - 1, self.width - 1, m))
438
 
        self._have_output = True
 
245
        m = spin_str + bar_str + msg + count_str + pct_str + eta_str
 
246
 
 
247
        assert len(m) < self.width
 
248
        self.to_file.write('\r' + m.ljust(self.width - 1))
439
249
        #self.to_file.flush()
440
250
            
 
251
 
441
252
    def clear(self):        
442
 
        if self._have_output:
443
 
            self.to_file.write('\r%s\r' % (' ' * (self.width - 1)))
444
 
        self._have_output = False
 
253
        self.to_file.write('\r%s\r' % (' ' * (self.width - 1)))
445
254
        #self.to_file.flush()        
446
 
 
447
 
 
448
 
_progress_bar_types['tty'] = TTYProgressBar
449
 
 
450
 
 
451
 
class ChildProgress(_BaseProgressBar):
452
 
    """A progress indicator that pushes its data to the parent"""
453
 
 
454
 
    def __init__(self, _stack, **kwargs):
455
 
        _BaseProgressBar.__init__(self, _stack=_stack, **kwargs)
456
 
        self.parent = _stack.top()
457
 
        self.current = None
458
 
        self.total = None
459
 
        self.child_fraction = 0
460
 
        self.message = None
461
 
 
462
 
    def update(self, msg, current_cnt=None, total_cnt=None):
463
 
        self.current = current_cnt
464
 
        self.total = total_cnt
465
 
        self.message = msg
466
 
        self.child_fraction = 0
467
 
        self.tick()
468
 
 
469
 
    def child_update(self, message, current, total):
470
 
        if current is None or total == 0:
471
 
            self.child_fraction = 0
472
 
        else:
473
 
            self.child_fraction = float(current) / total
474
 
        self.tick()
475
 
 
476
 
    def tick(self):
477
 
        if self.current is None:
478
 
            count = None
479
 
        else:
480
 
            count = self.current+self.child_fraction
481
 
            if count > self.total:
482
 
                if __debug__:
483
 
                    mutter('clamping count of %d to %d' % (count, self.total))
484
 
                count = self.total
485
 
        self.parent.child_update(self.message, count, self.total)
486
 
 
487
 
    def clear(self):
488
 
        pass
489
 
 
490
 
    def note(self, *args, **kwargs):
491
 
        self.parent.note(*args, **kwargs)
492
 
 
493
 
 
 
255
    
 
256
 
 
257
        
494
258
def str_tdelta(delt):
495
259
    if delt is None:
496
260
        return "-:--:--"
500
264
                             delt % 60)
501
265
 
502
266
 
503
 
def get_eta(start_time, current, total, enough_samples=3, last_updates=None, n_recent=10):
 
267
def get_eta(start_time, current, total, enough_samples=3):
504
268
    if start_time is None:
505
269
        return None
506
270
 
522
286
 
523
287
    assert total_duration >= elapsed
524
288
 
525
 
    if last_updates and len(last_updates) >= n_recent:
526
 
        avg = sum(last_updates) / float(len(last_updates))
527
 
        time_left = avg * (total - current)
528
 
 
529
 
        old_time_left = total_duration - elapsed
530
 
 
531
 
        # We could return the average, or some other value here
532
 
        return (time_left + old_time_left) / 2
533
 
 
534
289
    return total_duration - elapsed
535
290
 
536
291
 
537
 
class ProgressPhase(object):
538
 
    """Update progress object with the current phase"""
539
 
    def __init__(self, message, total, pb):
540
 
        object.__init__(self)
541
 
        self.pb = pb
542
 
        self.message = message
543
 
        self.total = total
544
 
        self.cur_phase = None
545
 
 
546
 
    def next_phase(self):
547
 
        if self.cur_phase is None:
548
 
            self.cur_phase = 0
549
 
        else:
550
 
            self.cur_phase += 1
551
 
        assert self.cur_phase < self.total 
552
 
        self.pb.update(self.message, self.cur_phase, self.total)
553
 
 
554
 
 
555
292
def run_tests():
556
293
    import doctest
557
294
    result = doctest.testmod()