Line Profiler¶
The line_profiler module for doing line-by-line profiling of functions
Github |
|
Pypi |
|
ReadTheDocs |
Installation¶
Releases of line_profiler and kernprof can be installed
using pip
pip install line_profiler
The package also provides extras for optional dependencies, which can be installed via:
pip install line_profiler[all]
Line Profiler Basic Usage¶
To demonstrate line profiling, we first need to generate a Python script to
profile. Write the following code to a file called demo_primes.py:
from line_profiler import profile
@profile
def is_prime(n):
'''
Check if the number "n" is prime, with n > 1.
Returns a boolean, True if n is prime.
'''
max_val = n ** 0.5
stop = int(max_val + 1)
for i in range(2, stop):
if n % i == 0:
return False
return True
@profile
def find_primes(size):
primes = []
for n in range(size):
flag = is_prime(n)
if flag:
primes.append(n)
return primes
@profile
def main():
print('start calculating')
primes = find_primes(100000)
print(f'done calculating. Found {len(primes)} primes.')
if __name__ == '__main__':
main()
In this script we explicitly import the
@profile function
from line_profiler, and then we decorate function of interest with
@profile.
By default nothing is profiled when running the script.
python demo_primes.py
The output will be
start calculating
done calculating. Found 9594 primes.
The quickest way to enable profiling is to set the environment variable
LINE_PROFILE=1 and running your script as normal.
LINE_PROFILE=1 python demo_primes.py
This will output 3 files: profile_output.txt,
profile_output_<timestamp>.txt, and profile_output.lprof; and
stdout will look something like:
start calculating
done calculating. Found 9594 primes.
Timer unit: 1e-09 s
0.65 seconds - demo_primes.py:4 - is_prime
1.47 seconds - demo_primes.py:19 - find_primes
1.51 seconds - demo_primes.py:29 - main
Wrote profile results to profile_output.txt
Wrote profile results to profile_output_2023-08-12T193302.txt
Wrote profile results to profile_output.lprof
To view details run:
python -m line_profiler -rtmz profile_output.lprof
The details contained in the output txt files or by running the script provided in the output will show detailed line-by-line timing information for each decorated function.
Timer unit: 1e-06 s
Total time: 0.731624 s
File: ./demo_primes.py
Function: is_prime at line 4
Line # Hits Time Per Hit % Time Line Contents
==============================================================
4 @profile
5 def is_prime(n):
6 '''
7 Check if the number "n" is prime, with n > 1.
8
9 Returns a boolean, True if n is prime.
10 '''
11 100000 14178.0 0.1 1.9 max_val = n ** 0.5
12 100000 22830.7 0.2 3.1 stop = int(max_val + 1)
13 2755287 313514.1 0.1 42.9 for i in range(2, stop):
14 2745693 368716.6 0.1 50.4 if n % i == 0:
15 90406 11462.9 0.1 1.6 return False
16 9594 922.0 0.1 0.1 return True
Total time: 1.56771 s
File: ./demo_primes.py
Function: find_primes at line 19
Line # Hits Time Per Hit % Time Line Contents
==============================================================
19 @profile
20 def find_primes(size):
21 1 0.2 0.2 0.0 primes = []
22 100001 10280.4 0.1 0.7 for n in range(size):
23 100000 1544196.6 15.4 98.5 flag = is_prime(n)
24 100000 11375.4 0.1 0.7 if flag:
25 9594 1853.2 0.2 0.1 primes.append(n)
26 1 0.1 0.1 0.0 return primes
Total time: 1.60483 s
File: ./demo_primes.py
Function: main at line 29
Line # Hits Time Per Hit % Time Line Contents
==============================================================
29 @profile
30 def main():
31 1 14.0 14.0 0.0 print('start calculating')
32 1 1604795.1 2e+06 100.0 primes = find_primes(100000)
33 1 20.6 20.6 0.0 print(f'done calculating. Found {len(primes)} primes.')
See also
autoprofiling usage in:
line_profiler.autoprofile
Limitations¶
Line profiling does have limitations, and it is important to be aware of them. Profiling multi-threaded, multi-processing, and asynchronous code may produce unexpected or no results. All profiling also adds some amount of overhead to the runtime, which may influence which parts of the code become bottlenecks.
Line profiler only measures the time between the start and end of a Python call, so for benchmarking GPU code (e.g. with torch), which have asynchronous or delayed behavior, it will only show the time to sync blocking calls in the main thread.
Other profilers have different limitations and different trade-offs. It’s good to be aware of the right tool for the job. Here is a short list of other profiling tools:
Scalene: A CPU+GPU+memory sampling based profiler.
PyInstrument: A call stack profiler.
Yappi: A tracing profiler that is multithreading, asyncio and gevent aware.
profile / cProfile: The builtin profile module.
timeit: The builtin timeit module for profiling single statements.
timerit: A multi-statements alternative to the builtin
timeitmodule.torch.profiler tools for profiling torch code.
Package Layout
- line_profiler package
- Subpackages
- line_profiler.autoprofile package
- Submodules
- line_profiler.autoprofile.ast_profle_transformer module
- line_profiler.autoprofile.ast_tree_profiler module
- line_profiler.autoprofile.autoprofile module
- line_profiler.autoprofile.eager_preimports module
- line_profiler.autoprofile.line_profiler_utils module
- line_profiler.autoprofile.profmod_extractor module
- line_profiler.autoprofile.run_module module
- line_profiler.autoprofile.util_static module
- Module contents
- Submodules
- line_profiler.autoprofile package
- Submodules
- line_profiler.__main__ module
- line_profiler._line_profiler module
LineProfilerLineProfiler.add_function()LineProfiler.c_code_mapLineProfiler.c_last_timeLineProfiler.code_hash_mapLineProfiler.code_mapLineProfiler.disable()LineProfiler.disable_by_count()LineProfiler.dupes_mapLineProfiler.enable()LineProfiler.enable_by_count()LineProfiler.enable_countLineProfiler.functionsLineProfiler.get_stats()LineProfiler.last_timeLineProfiler.set_frame_local_traceLineProfiler.threaddataLineProfiler.timer_unitLineProfiler.tool_idLineProfiler.wrap_trace
LineStats_LineProfilerManager_LineProfilerManager.__call__()_LineProfilerManager.active_instances_LineProfilerManager.handle_line_event()_LineProfilerManager.handle_raise_event()_LineProfilerManager.handle_reraise_event()_LineProfilerManager.handle_return_event()_LineProfilerManager.handle_yield_event()_LineProfilerManager.set_frame_local_trace_LineProfilerManager.wrap_local_f_trace()_LineProfilerManager.wrap_trace
disable_line_events()find_cython_source_file()label()
- line_profiler.cli_utils module
- line_profiler.explicit_profiler module
- line_profiler.ipython_extension module
- line_profiler.line_profiler module
- line_profiler.profiler_mixin module
is_c_level_callable()is_cython_callable()is_classmethod()is_staticmethod()is_boundmethod()is_partialmethod()is_partial()is_property()is_cached_property()ByCountProfilerMixinByCountProfilerMixin.enable_by_count()ByCountProfilerMixin.disable_by_count()ByCountProfilerMixin.wrap_callable()ByCountProfilerMixin.get_underlying_functions()ByCountProfilerMixin.wrap_classmethod()ByCountProfilerMixin.wrap_staticmethod()ByCountProfilerMixin.wrap_boundmethod()ByCountProfilerMixin.wrap_partial()ByCountProfilerMixin.wrap_partialmethod()ByCountProfilerMixin.wrap_property()ByCountProfilerMixin.wrap_cached_property()ByCountProfilerMixin.wrap_async_generator()ByCountProfilerMixin.wrap_coroutine()ByCountProfilerMixin.wrap_generator()ByCountProfilerMixin.wrap_function()ByCountProfilerMixin.wrap_class()ByCountProfilerMixin.run()ByCountProfilerMixin.runctx()ByCountProfilerMixin.runcall()
- line_profiler.scoping_policy module
- line_profiler.toml_config module
- Module contents
- Subpackages
- line_profiler.autoprofile package
- Submodules
- line_profiler.autoprofile.ast_profle_transformer module
- line_profiler.autoprofile.ast_tree_profiler module
- line_profiler.autoprofile.autoprofile module
- line_profiler.autoprofile.eager_preimports module
- line_profiler.autoprofile.line_profiler_utils module
- line_profiler.autoprofile.profmod_extractor module
- line_profiler.autoprofile.run_module module
- line_profiler.autoprofile.util_static module
- Module contents
- Submodules
- line_profiler.explicit_profiler module
- kernprof module
- Examples