mirror of
https://github.com/fish-shell/fish-shell.git
synced 2024-12-11 15:53:37 +08:00
82 lines
3.6 KiB
ReStructuredText
82 lines
3.6 KiB
ReStructuredText
.. _cmd-time:
|
|
|
|
time - measure how long a command or block takes
|
|
================================================
|
|
|
|
Synopsis
|
|
--------
|
|
|
|
.. synopsis::
|
|
|
|
time COMMAND
|
|
|
|
Description
|
|
-----------
|
|
|
|
.. only:: builder_man
|
|
|
|
NOTE: This page documents the fish keyword ``time``.
|
|
To see the documentation on the ``time`` command you might have,
|
|
use ``command man time``.
|
|
|
|
``time`` causes fish to measure how long a command takes and print the results afterwards. The command can be a simple fish command or a block. The results can not currently be redirected.
|
|
|
|
For checking timing after a command has completed, check :ref:`$CMD_DURATION <variables-special>`.
|
|
|
|
Your system most likely also has a ``time`` command. To use that use something like ``command time``, as in ``command time sleep 10``. Because it's not inside fish, it won't have access to fish functions and won't be able to time blocks and such.
|
|
|
|
How to interpret the output
|
|
---------------------------
|
|
|
|
Time outputs a few different values. Let's look at an example::
|
|
|
|
> time string repeat -n 10000000 y\n | command grep y >/dev/null
|
|
________________________________________________________
|
|
Executed in 805.98 millis fish external
|
|
usr time 798.88 millis 763.88 millis 34.99 millis
|
|
sys time 141.22 millis 40.20 millis 101.02 millis
|
|
|
|
The time after "Executed in" is what is known as the "wall-clock time". It is simply a measure of how long it took from the start of the command until it finished. Typically it is reasonably close to :envvar:`CMD_DURATION`, except for a slight skew because the two are taken at slightly different times.
|
|
|
|
The other times are all measures of CPU time. That means they measure how long the CPU was used in this part, and they count multiple cores separately. So a program with four threads using all CPU for a second will have a time of 4 seconds.
|
|
|
|
The "usr" time is how much CPU time was spent inside the program itself, the "sys" time is how long was spent in the kernel on behalf of that program.
|
|
|
|
The "fish" time is how much CPU was spent in fish, the "external" time how much was spent in external commands.
|
|
|
|
So in this example, since ``string`` is a builtin, everything that ``string repeat`` did is accounted to fish. Any time it spends doing syscalls like ``write()`` is accounted for in the fish/sys time.
|
|
|
|
And ``grep`` here is explicitly invoked as an external command, so its times will be counted in the "external" column.
|
|
|
|
Note that, as in this example, the CPU times can add up to more than the execution time. This is because things can be done in parallel - ``grep`` can match while ``string repeat`` writes.
|
|
|
|
Example
|
|
-------
|
|
|
|
(for obvious reasons exact results will vary on your system)
|
|
|
|
::
|
|
|
|
>_ time sleep 1s
|
|
|
|
________________________________________________________
|
|
Executed in 1,01 secs fish external
|
|
usr time 2,32 millis 0,00 micros 2,32 millis
|
|
sys time 0,88 millis 877,00 micros 0,00 millis
|
|
|
|
>_ time for i in 1 2 3; sleep 1s; end
|
|
|
|
________________________________________________________
|
|
Executed in 3,01 secs fish external
|
|
usr time 9,16 millis 2,94 millis 6,23 millis
|
|
sys time 0,23 millis 0,00 millis 0,23 millis
|
|
|
|
Inline variable assignments need to follow the ``time`` keyword::
|
|
|
|
>_ time a_moment=1.5m sleep $a_moment
|
|
|
|
________________________________________________________
|
|
Executed in 90.00 secs fish external
|
|
usr time 4.62 millis 4.62 millis 0.00 millis
|
|
sys time 2.35 millis 0.41 millis 1.95 millis
|