15c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)# Copyright (C) 2010, 2012 Google Inc. All rights reserved.
25c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)#
35c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)# Redistribution and use in source and binary forms, with or without
45c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)# modification, are permitted provided that the following conditions are
55c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)# met:
65c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)#
75c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)#     * Redistributions of source code must retain the above copyright
85c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)# notice, this list of conditions and the following disclaimer.
95c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)#     * Redistributions in binary form must reproduce the above
105c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)# copyright notice, this list of conditions and the following disclaimer
115c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)# in the documentation and/or other materials provided with the
125c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)# distribution.
135c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)#     * Neither the name of Google Inc. nor the names of its
145c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)# contributors may be used to endorse or promote products derived from
155c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)# this software without specific prior written permission.
165c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)#
175c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)# THIS SOFTWARE IS PROVIDED BY THE COPYRIGHT HOLDERS AND CONTRIBUTORS
185c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)# "AS IS" AND ANY EXPRESS OR IMPLIED WARRANTIES, INCLUDING, BUT NOT
195c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)# LIMITED TO, THE IMPLIED WARRANTIES OF MERCHANTABILITY AND FITNESS FOR
205c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)# A PARTICULAR PURPOSE ARE DISCLAIMED. IN NO EVENT SHALL THE COPYRIGHT
215c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)# OWNER OR CONTRIBUTORS BE LIABLE FOR ANY DIRECT, INDIRECT, INCIDENTAL,
225c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)# SPECIAL, EXEMPLARY, OR CONSEQUENTIAL DAMAGES (INCLUDING, BUT NOT
235c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)# LIMITED TO, PROCUREMENT OF SUBSTITUTE GOODS OR SERVICES; LOSS OF USE,
245c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)# DATA, OR PROFITS; OR BUSINESS INTERRUPTION) HOWEVER CAUSED AND ON ANY
255c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)# THEORY OF LIABILITY, WHETHER IN CONTRACT, STRICT LIABILITY, OR TORT
265c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)# (INCLUDING NEGLIGENCE OR OTHERWISE) ARISING IN ANY WAY OUT OF THE USE
275c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)# OF THIS SOFTWARE, EVEN IF ADVISED OF THE POSSIBILITY OF SUCH DAMAGE.
285c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)
29e38fbeeb576b5094e34e038ab88d9d6a5c5c2214Torne (Richard Coles)import StringIO
305c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)import logging
315c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)import re
32e38fbeeb576b5094e34e038ab88d9d6a5c5c2214Torne (Richard Coles)import unittest
335c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)
345c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)from webkitpy.layout_tests.views.metered_stream import MeteredStream
355c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)
365c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)
375c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)class RegularTest(unittest.TestCase):
385c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)    verbose = False
395c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)    isatty = False
405c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)
415c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)    def setUp(self):
425c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)        self.stream = StringIO.StringIO()
435c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)        self.buflist = self.stream.buflist
445c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)        self.stream.isatty = lambda: self.isatty
455c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)
465c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)        # configure a logger to test that log calls do normally get included.
475c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)        self.logger = logging.getLogger(__name__)
485c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)        self.logger.setLevel(logging.DEBUG)
495c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)        self.logger.propagate = False
505c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)
515c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)        # add a dummy time counter for a default behavior.
525c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)        self.times = range(10)
535c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)
545c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)        self.meter = MeteredStream(self.stream, self.verbose, self.logger, self.time_fn, 8675)
555c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)
565c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)    def tearDown(self):
575c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)        if self.meter:
585c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)            self.meter.cleanup()
595c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)            self.meter = None
605c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)
615c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)    def time_fn(self):
625c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)        return self.times.pop(0)
635c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)
645c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)    def test_logging_not_included(self):
655c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)        # This tests that if we don't hand a logger to the MeteredStream,
665c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)        # nothing is logged.
675c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)        logging_stream = StringIO.StringIO()
685c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)        handler = logging.StreamHandler(logging_stream)
695c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)        root_logger = logging.getLogger()
705c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)        orig_level = root_logger.level
715c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)        root_logger.addHandler(handler)
725c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)        root_logger.setLevel(logging.DEBUG)
735c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)        try:
745c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)            self.meter = MeteredStream(self.stream, self.verbose, None, self.time_fn, 8675)
755c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)            self.meter.write_throttled_update('foo')
765c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)            self.meter.write_update('bar')
775c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)            self.meter.write('baz')
78926b001d589ce2f10facb93dd4b87578ea35a855Torne (Richard Coles)            self.assertEqual(logging_stream.buflist, [])
795c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)        finally:
805c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)            root_logger.removeHandler(handler)
815c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)            root_logger.setLevel(orig_level)
825c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)
835c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)    def _basic(self, times):
845c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)        self.times = times
855c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)        self.meter.write_update('foo')
865c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)        self.meter.write_update('bar')
875c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)        self.meter.write_throttled_update('baz')
885c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)        self.meter.write_throttled_update('baz 2')
895c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)        self.meter.writeln('done')
90926b001d589ce2f10facb93dd4b87578ea35a855Torne (Richard Coles)        self.assertEqual(self.times, [])
915c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)        return self.buflist
925c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)
935c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)    def test_basic(self):
945c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)        buflist = self._basic([0, 1, 2, 13, 14])
95926b001d589ce2f10facb93dd4b87578ea35a855Torne (Richard Coles)        self.assertEqual(buflist, ['foo\n', 'bar\n', 'baz 2\n', 'done\n'])
965c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)
975c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)    def _log_after_update(self):
985c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)        self.meter.write_update('foo')
995c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)        self.logger.info('bar')
1005c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)        return self.buflist
1015c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)
1025c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)    def test_log_after_update(self):
1035c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)        buflist = self._log_after_update()
104926b001d589ce2f10facb93dd4b87578ea35a855Torne (Richard Coles)        self.assertEqual(buflist, ['foo\n', 'bar\n'])
1055c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)
1065c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)    def test_log_args(self):
1075c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)        self.logger.info('foo %s %d', 'bar', 2)
108926b001d589ce2f10facb93dd4b87578ea35a855Torne (Richard Coles)        self.assertEqual(self.buflist, ['foo bar 2\n'])
1095c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)
1105c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)class TtyTest(RegularTest):
1115c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)    verbose = False
1125c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)    isatty = True
1135c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)
1145c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)    def test_basic(self):
1155c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)        buflist = self._basic([0, 1, 1.05, 1.1, 2])
116926b001d589ce2f10facb93dd4b87578ea35a855Torne (Richard Coles)        self.assertEqual(buflist, ['foo',
1175c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)                                     MeteredStream._erasure('foo'), 'bar',
1185c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)                                     MeteredStream._erasure('bar'), 'baz 2',
1195c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)                                     MeteredStream._erasure('baz 2'), 'done\n'])
1205c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)
1215c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)    def test_log_after_update(self):
1225c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)        buflist = self._log_after_update()
123926b001d589ce2f10facb93dd4b87578ea35a855Torne (Richard Coles)        self.assertEqual(buflist, ['foo',
1245c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)                                     MeteredStream._erasure('foo'), 'bar\n'])
1255c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)
1265c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)
1275c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)class VerboseTest(RegularTest):
1285c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)    isatty = False
1295c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)    verbose = True
1305c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)
1315c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)    def test_basic(self):
1325c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)        buflist = self._basic([0, 1, 2.1, 13, 14.1234])
1335c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)        # We don't bother to match the hours and minutes of the timestamp since
1345c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)        # the local timezone can vary and we can't set that portably and easily.
1355c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)        self.assertTrue(re.match('\d\d:\d\d:00.000 8675 foo\n', buflist[0]))
1365c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)        self.assertTrue(re.match('\d\d:\d\d:01.000 8675 bar\n', buflist[1]))
1375c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)        self.assertTrue(re.match('\d\d:\d\d:13.000 8675 baz 2\n', buflist[2]))
1385c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)        self.assertTrue(re.match('\d\d:\d\d:14.123 8675 done\n', buflist[3]))
139926b001d589ce2f10facb93dd4b87578ea35a855Torne (Richard Coles)        self.assertEqual(len(buflist), 4)
1405c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)
1415c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)    def test_log_after_update(self):
1425c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)        buflist = self._log_after_update()
1435c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)        self.assertTrue(re.match('\d\d:\d\d:00.000 8675 foo\n', buflist[0]))
1445c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)
1455c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)        # The second argument should have a real timestamp and pid, so we just check the format.
1465c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)        self.assertTrue(re.match('\d\d:\d\d:\d\d.\d\d\d \d+ bar\n', buflist[1]))
1475c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)
148926b001d589ce2f10facb93dd4b87578ea35a855Torne (Richard Coles)        self.assertEqual(len(buflist), 2)
1495c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)
1505c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)    def test_log_args(self):
1515c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)        self.logger.info('foo %s %d', 'bar', 2)
152926b001d589ce2f10facb93dd4b87578ea35a855Torne (Richard Coles)        self.assertEqual(len(self.buflist), 1)
1535c87bf8b86a7c82ef50fb7a89697d8e02e2553beTorne (Richard Coles)        self.assertTrue(self.buflist[0].endswith('foo bar 2\n'))
154