def test_timestatskeeper_measure_avg_min_max():
"""Test measuring avg min max values."""
keeper = TimeStatsKeeper()
keeper.enable()
# TimeStatsKeeper on Windows has only a precision of 1/60 sec
durations = (0.6, 1.2, 1.5)
delta = 0.08
count = len(durations)
stats = keeper.get_stats('foo')
m_durations = []
for duration in durations:
m_durations.append(measure(stats, duration))
min_dur = min(m_durations)
max_dur = max(m_durations)
avg_dur = sum(m_durations) / float(count)
stats_dict = keeper.snapshot()
for op_name in stats_dict:
stats = stats_dict[op_name]
assert stats.count == 3
assert time_abs_delta(stats.avg_time, avg_dur) < delta, \
"avg time: actual: %f, expected: %f, delta: %f" % \
(stats.avg_time, avg_dur, delta)
assert time_abs_delta(stats.min_time, min_dur) < delta, \
"min time: actual: %f, expected: %f, delta: %f" % \
(stats.min_time, min_dur, delta)
assert time_abs_delta(stats.max_time, max_dur) < delta, \
"max time: actual: %f, expected: %f, delta: %f" % \
(stats.max_time, max_dur, delta)
def test_timestatskeeper_str_empty():
"""Test TimestatsKeeper.__str__() for an empty enabled keeper."""
keeper = TimeStatsKeeper()
keeper.enable()
s = str(keeper)
assert s == PRINT_HEADER
def test_timestatskeeper_snapshot():
"""Test that snapshot() takes a stable snapshot."""
keeper = TimeStatsKeeper()
keeper.enable()
duration = 0.2
stats = keeper.get_stats('foo')
# produce a first data item
stats.begin()
time.sleep(duration)
stats.end()
# take the snapshot
snap_stats_dict = keeper.snapshot()
# produce a second data item
stats.begin()
time.sleep(duration)
stats.end()
# verify that only the first data item is in the snapshot
for op_name in snap_stats_dict:
snap_stats = snap_stats_dict[op_name]
assert snap_stats.count == 1
# verify that both data items are in the original stats object
assert stats.count == 2
def test_timestatskeeper_measure_enabled():
"""Test measuring time with enabled keeper."""
keeper = TimeStatsKeeper()
keeper.enable()
# TimeStatsKeeper on Windows has only a precision of 1/60 sec
duration = 1.6
delta = duration / 10.0
stats = keeper.get_stats('foo')
dur = measure(stats, duration)
stats_dict = keeper.snapshot()
for op_name in stats_dict:
stats = stats_dict[op_name]
assert stats.count == 1
assert time_abs_delta(stats.avg_time, dur) < delta, \
"avg time: actual: %f, expected: %f, delta: %f" % \
(stats.avg_time, dur, delta)
assert time_abs_delta(stats.min_time, dur) < delta, \
"min time: actual: %f, expected: %f, delta: %f" % \
(stats.min_time, dur, delta)
assert time_abs_delta(stats.max_time, dur) < delta, \
"max time: actual: %f, expected: %f, delta: %f" % \
(stats.max_time, dur, delta)
stats.reset()
assert stats.count == 0
assert stats.avg_time == 0
assert stats.min_time == float('inf')
assert stats.max_time == 0
def test_timestatskeeper_only_end():
"""Test that invoking end() before begin() has ever been called raises
a RuntimeError exception."""
keeper = TimeStatsKeeper()
keeper.enable()
stats = keeper.get_stats('foo')
with pytest.raises(RuntimeError):
stats.end()
def test_timestats_str():
"""Test Timestats.__str__()."""
keeper = TimeStatsKeeper()
timestats = TimeStats(keeper, "foo")
s = str(timestats)
assert s.startswith("TimeStats:"), \
"Unexpected str(timestats): %r" % s
num_lines = len(s.split('\n'))
assert num_lines == 1, \
"Unexpected str(timestats): %r" % s
def test_timestatskeeper_end_after_end():
"""Test that invoking end() after a begin/end sequence raises
a RuntimeError exception."""
keeper = TimeStatsKeeper()
keeper.enable()
stats = keeper.get_stats('foo')
stats.begin()
time.sleep(0.01)
stats.end()
with pytest.raises(RuntimeError):
stats.end()
def test_timestatskeeper_get():
"""Test getting time statistics."""
keeper = TimeStatsKeeper()
snapshot_length = len(keeper.snapshot())
assert snapshot_length == 0, \
"Verify that initial state has no time statistics. " \
"Actual number = %d" % snapshot_length
stats = keeper.get_stats('foo')
snapshot_length = len(keeper.snapshot())
assert snapshot_length == 0, \
"Verify that getting a new stats with a disabled keeper results " \
"in no time statistics. Actual number = %d" % snapshot_length
assert stats.keeper == keeper
assert stats.name == "disabled" # stats for disabled keeper
assert stats.count == 0
assert stats.avg_time == 0
assert stats.min_time == float('inf')
assert stats.max_time == 0
keeper.enable()
stats = keeper.get_stats('foo')
snapshot_length = len(keeper.snapshot())
assert snapshot_length == 1, \
"Verify that getting a new stats with an enabled keeper results " \
"in one time statistics. Actual number = %d" % snapshot_length
assert stats.keeper == keeper
assert stats.name == 'foo'
assert stats.count == 0
assert stats.avg_time == 0
assert stats.min_time == float('inf')
assert stats.max_time == 0
keeper.get_stats('foo')
snapshot_length = len(keeper.snapshot())
assert snapshot_length == 1, \
"Verify that getting an existing stats with an enabled keeper " \
"results in the same number of time statistics. " \
"Actual number = %d" % snapshot_length
def test_timestatskeeper_measure_disabled():
"""Test measuring time with disabled keeper."""
keeper = TimeStatsKeeper()
duration = 0.2
stats = keeper.get_stats('foo')
assert stats.name == 'disabled'
stats.begin()
time.sleep(duration)
stats.end()
stats_dict = keeper.snapshot()
for op_name in stats_dict:
stats = stats_dict[op_name]
assert stats.count == 0
assert stats.avg_time == 0
assert stats.min_time == float('inf')
assert stats.max_time == 0
def test_timestatskeeper_str_one():
"""Test TimestatsKeeper.__str__() for an enabled keeper with one data
item."""
keeper = TimeStatsKeeper()
keeper.enable()
duration = 0.1
stats = keeper.get_stats('foo')
# produce a data item
stats.begin()
time.sleep(duration)
stats.end()
s = str(keeper)
assert s.startswith(PRINT_HEADER), \
"Unexpected str(keeper): %r" % s
num_lines = len(s.split('\n'))
assert num_lines == 3, \
"Unexpected str(keeper): %r" % s
def test_timestatskeeper_enabling():
"""Test enabling and disabling."""
keeper = TimeStatsKeeper()
assert not keeper.enabled, \
"Verify that initial state is disabled"
keeper.disable()
assert not keeper.enabled, \
"Verify that disabling a disabled keeper works"
keeper.enable()
assert keeper.enabled, \
"Verify that enabling a disabled keeper works"
keeper.enable()
assert keeper.enabled, \
"Verify that enabling an enabled keeper works"
keeper.disable()
assert not keeper.enabled, \
"Verify that disabling an enabled keeper works"
def test_timestatskeeper_str_disabled():
"""Test TimestatsKeeper.__str__() for a disabled keeper."""
keeper = TimeStatsKeeper()
s = str(keeper)
assert s == PRINT_HEADER_DISABLED