|
| 1 | +import functools |
1 | 2 | import time |
2 | 3 |
|
3 | 4 | from memos.log import get_logger |
|
6 | 7 | logger = get_logger(__name__) |
7 | 8 |
|
8 | 9 |
|
9 | | -def timed(func=None, *, log=True, log_prefix=""): |
10 | | - """Decorator to measure and optionally log time of retrieval steps. |
11 | | -
|
12 | | - Can be used as @timed or @timed(log=True) |
| 10 | +def timed(func=None, *, log=True, log_prefix="", log_args=None): |
| 11 | + """ |
| 12 | + Parameters: |
| 13 | + - log: enable timing logs (default True) |
| 14 | + - log_prefix: prefix; falls back to function name |
| 15 | + - log_args: names to include in logs (str or list/tuple of str). |
| 16 | + Value priority: kwargs → args[0].config.<name> (if available). |
| 17 | + Non-string items are ignored. |
| 18 | +
|
| 19 | + Examples: |
| 20 | + - @timed(log=True, log_prefix="OpenAI LLM", log_args=["model_name_or_path", "temperature"]) |
| 21 | + - @timed(log=True, log_prefix="OpenAI LLM", log_args=["temperature"]) |
| 22 | + - @timed() # defaults |
13 | 23 | """ |
14 | 24 |
|
15 | 25 | def decorator(fn): |
| 26 | + @functools.wraps(fn) |
16 | 27 | def wrapper(*args, **kwargs): |
17 | 28 | start = time.perf_counter() |
18 | 29 | result = fn(*args, **kwargs) |
19 | | - elapsed = time.perf_counter() - start |
20 | | - elapsed_ms = elapsed * 1000.0 |
21 | | - if log: |
22 | | - logger.info(f"[TIMER] {log_prefix or fn.__name__} took {elapsed_ms:.0f} ms") |
| 30 | + elapsed_ms = (time.perf_counter() - start) * 1000.0 |
| 31 | + ctx_str = "" |
| 32 | + |
| 33 | + if log is not True: |
| 34 | + return result |
| 35 | + |
| 36 | + if log_args: |
| 37 | + ctx_parts = [] |
| 38 | + for key in log_args: |
| 39 | + val = kwargs.get(key) |
| 40 | + ctx_parts.append(f"{key}={val}") |
| 41 | + ctx_str = f" [{', '.join(ctx_parts)}]" |
| 42 | + logger.info( |
| 43 | + f"[TIMER] {log_prefix or fn.__name__} took {elapsed_ms:.0f} ms, args: {ctx_str}" |
| 44 | + ) |
| 45 | + |
23 | 46 | return result |
24 | 47 |
|
25 | 48 | return wrapper |
|
0 commit comments