is there a emacs lisp timing command?

is there a emacs lisp timing command?

[Xah Lee]

is there a elisp command like timing, that returns the time a function
took?

while testing some performance issues, i tried to write one.

(defun xx-timing ()
  "returns the timing."
  (interactive)
  (let (starttime endtime)
    (setq starttime (current-time))

    ;; some function here
    (sleep-for 0 5)

    (setq endtime (current-time))
    (message "%f" (+ (* (- (elt endtime 0)
                           (elt starttime 0)) 65536)
                     (- (elt endtime 1)
                        (elt starttime 1))
                     (* (- (elt endtime 2)
                           (elt starttime 2)) 0.001)))
    ))

but after about 20 minutes on this, i gave up. It seems to me, when
microseconds is involved (returned by current-time), the result is
weired. I don't see any logical problem in my code, but the above code
is obvious wrong, often returning results some 70 seconds extra
whenever microseconds is involved.

anyone has written a timing command somewhere?

This is on:
GNU Emacs 22.2.1 (powerpc-apple-darwin8.11.0, Carbon Version 1.6.0) of
2008-04-05 on g5.tokyo.stp.isas.jaxa.jp

PowerPC G5, osx 10.4.11.

  Xah
∑ http://xahlee.org/

☄

Re: is there a emacs lisp timing command?

[thierry.volpiatto]

Hi, 
have a look at traverselisp.el,
the function `traverse-deep-rfind' have a timer.
http://www.emacswiki.org/cgi-bin/emacs/traverselisp.el

Xah Lee <xahlee@gmail.com> writes:

> is there a elisp command like timing, that returns the time a function
> took?
>
> while testing some performance issues, i tried to write one.
>
> (defun xx-timing ()
>   "returns the timing."
>   (interactive)
>   (let (starttime endtime)
>     (setq starttime (current-time))
>
>     ;; some function here
>     (sleep-for 0 5)
>
>     (setq endtime (current-time))
>     (message "%f" (+ (* (- (elt endtime 0)
>                            (elt starttime 0)) 65536)
>                      (- (elt endtime 1)
>                         (elt starttime 1))
>                      (* (- (elt endtime 2)
>                            (elt starttime 2)) 0.001)))
>     ))
>
> but after about 20 minutes on this, i gave up. It seems to me, when
> microseconds is involved (returned by current-time), the result is
> weired. I don't see any logical problem in my code, but the above code
> is obvious wrong, often returning results some 70 seconds extra
> whenever microseconds is involved.
>
> anyone has written a timing command somewhere?
>
> This is on:
> GNU Emacs 22.2.1 (powerpc-apple-darwin8.11.0, Carbon Version 1.6.0) of
> 2008-04-05 on g5.tokyo.stp.isas.jaxa.jp
>
> PowerPC G5, osx 10.4.11.
>
>   Xah
> ∑ http://xahlee.org/
>
> ☄
>
>

-- 
A + Thierry Volpiatto
Location: Saint-Cyr-Sur-Mer - France

Re: is there a emacs lisp timing command?

[thierry.volpiatto]

And this can help also:(adapt for your case with traverselisp code).


(defun current-human-time ()
  (let* ((cur-time (decode-time (current-time)))
         (h (int-to-string (nth 2 cur-time)))
         (m (int-to-string (nth 1 cur-time)))
         (s (int-to-string (nth 0 cur-time))))
    (message "%s" (concat h ":" m ":" s))))

(defvar my-time nil)
(defun start-watch ()
  (setq my-time (run-with-timer 1 1 'current-human-time)))

(defun stop-watch ()
  (cancel-timer my-time)
  (setq my-time nil))

thierry.volpiatto@gmail.com writes:

> Hi, 
> have a look at traverselisp.el,
> the function `traverse-deep-rfind' have a timer.
> http://www.emacswiki.org/cgi-bin/emacs/traverselisp.el
>
> Xah Lee <xahlee@gmail.com> writes:
>
>> is there a elisp command like timing, that returns the time a function
>> took?
>>
>> while testing some performance issues, i tried to write one.
>>
>> (defun xx-timing ()
>>   "returns the timing."
>>   (interactive)
>>   (let (starttime endtime)
>>     (setq starttime (current-time))
>>
>>     ;; some function here
>>     (sleep-for 0 5)
>>
>>     (setq endtime (current-time))
>>     (message "%f" (+ (* (- (elt endtime 0)
>>                            (elt starttime 0)) 65536)
>>                      (- (elt endtime 1)
>>                         (elt starttime 1))
>>                      (* (- (elt endtime 2)
>>                            (elt starttime 2)) 0.001)))
>>     ))
>>
>> but after about 20 minutes on this, i gave up. It seems to me, when
>> microseconds is involved (returned by current-time), the result is
>> weired. I don't see any logical problem in my code, but the above code
>> is obvious wrong, often returning results some 70 seconds extra
>> whenever microseconds is involved.
>>
>> anyone has written a timing command somewhere?
>>
>> This is on:
>> GNU Emacs 22.2.1 (powerpc-apple-darwin8.11.0, Carbon Version 1.6.0) of
>> 2008-04-05 on g5.tokyo.stp.isas.jaxa.jp
>>
>> PowerPC G5, osx 10.4.11.
>>
>>   Xah
>> ∑ http://xahlee.org/
>>
>> ☄
>>
>>

-- 
A + Thierry Volpiatto
Location: Saint-Cyr-Sur-Mer - France

Re: is there a emacs lisp timing command?

[thierry.volpiatto]

hoops! i didn't remember i had this one also:

(defmacro chrono-func (output fn &rest args)
  `(let ((init-time (cadr (current-time)))
         (final-time)
         (final-result))
     (setq final-result (funcall ,fn ,@args))
     (setq final-time (- (cadr (current-time)) init-time))
     (message "Time:%2s s" final-time)
     (when ,output
       final-result)))

May be it's exactly what you want.

thierry.volpiatto@gmail.com writes:

> And this can help also:(adapt for your case with traverselisp code).
>
>
> (defun current-human-time ()
>   (let* ((cur-time (decode-time (current-time)))
>          (h (int-to-string (nth 2 cur-time)))
>          (m (int-to-string (nth 1 cur-time)))
>          (s (int-to-string (nth 0 cur-time))))
>     (message "%s" (concat h ":" m ":" s))))
>
> (defvar my-time nil)
> (defun start-watch ()
>   (setq my-time (run-with-timer 1 1 'current-human-time)))
>
> (defun stop-watch ()
>   (cancel-timer my-time)
>   (setq my-time nil))
>
> thierry.volpiatto@gmail.com writes:
>
>> Hi, 
>> have a look at traverselisp.el,
>> the function `traverse-deep-rfind' have a timer.
>> http://www.emacswiki.org/cgi-bin/emacs/traverselisp.el
>>
>> Xah Lee <xahlee@gmail.com> writes:
>>
>>> is there a elisp command like timing, that returns the time a function
>>> took?
>>>
>>> while testing some performance issues, i tried to write one.
>>>
>>> (defun xx-timing ()
>>>   "returns the timing."
>>>   (interactive)
>>>   (let (starttime endtime)
>>>     (setq starttime (current-time))
>>>
>>>     ;; some function here
>>>     (sleep-for 0 5)
>>>
>>>     (setq endtime (current-time))
>>>     (message "%f" (+ (* (- (elt endtime 0)
>>>                            (elt starttime 0)) 65536)
>>>                      (- (elt endtime 1)
>>>                         (elt starttime 1))
>>>                      (* (- (elt endtime 2)
>>>                            (elt starttime 2)) 0.001)))
>>>     ))
>>>
>>> but after about 20 minutes on this, i gave up. It seems to me, when
>>> microseconds is involved (returned by current-time), the result is
>>> weired. I don't see any logical problem in my code, but the above code
>>> is obvious wrong, often returning results some 70 seconds extra
>>> whenever microseconds is involved.
>>>
>>> anyone has written a timing command somewhere?
>>>
>>> This is on:
>>> GNU Emacs 22.2.1 (powerpc-apple-darwin8.11.0, Carbon Version 1.6.0) of
>>> 2008-04-05 on g5.tokyo.stp.isas.jaxa.jp
>>>
>>> PowerPC G5, osx 10.4.11.
>>>
>>>   Xah
>>> ∑ http://xahlee.org/
>>>
>>> ☄
>>>
>>>

-- 
A + Thierry Volpiatto
Location: Saint-Cyr-Sur-Mer - France

Re: is there a emacs lisp timing command?

[Helmut Eller]

* Xah Lee [2009-03-24 02:57+0100] writes:

> anyone has written a timing command somewhere?

I've use this for ages:

;;;; CL-like time macro
(defmacro time (form)
  (autoload 'elp-elapsed-time "elp")
  (let ((start (make-symbol "#:start")))
    `(let ((,start (current-time)))
       (prog1 ,form
	 (princ (format "Elapsed time: %.2f sec  \n"
			(elp-elapsed-time ,start (current-time))))))))


Helmut.

Re: is there a emacs lisp timing command?

[thierry.volpiatto]

Have a look also at all the elp-instrument-* functions

Helmut Eller <eller.helmut@gmail.com> writes:

> * Xah Lee [2009-03-24 02:57+0100] writes:
>
>> anyone has written a timing command somewhere?
>
> I've use this for ages:
>
> ;;;; CL-like time macro
> (defmacro time (form)
>   (autoload 'elp-elapsed-time "elp")
>   (let ((start (make-symbol "#:start")))
>     `(let ((,start (current-time)))
>        (prog1 ,form
> 	 (princ (format "Elapsed time: %.2f sec  \n"
> 			(elp-elapsed-time ,start (current-time))))))))
>
>
> Helmut.
>

-- 
A + Thierry Volpiatto
Location: Saint-Cyr-Sur-Mer - France

Re: is there a emacs lisp timing command?

[David Kastrup]

Xah Lee <xahlee@gmail.com> writes:

> is there a elisp command like timing, that returns the time a function
> took?
>
> while testing some performance issues, i tried to write one.
>
> (defun xx-timing ()
>   "returns the timing."
>   (interactive)
>   (let (starttime endtime)
>     (setq starttime (current-time))
>
>     ;; some function here
>     (sleep-for 0 5)
>
>     (setq endtime (current-time))
>     (message "%f" (+ (* (- (elt endtime 0)
>                            (elt starttime 0)) 65536)
>                      (- (elt endtime 1)
>                         (elt starttime 1))
>                      (* (- (elt endtime 2)
>                            (elt starttime 2)) 0.001)))
>     ))
>
> but after about 20 minutes on this, i gave up. It seems to me, when
> microseconds is involved (returned by current-time), the result is
> weired. I don't see any logical problem in my code, but the above code
> is obvious wrong, often returning results some 70 seconds extra
> whenever microseconds is involved.

65536000000 is not a number representable in Elisp integers.

Why don't you use the time-subtract command and/or the float-time
command?

Note: the float-time command DOC string talks about a time form
(HIGH LOW . IGNORED).  Quite counterintuively, IGNORED is not ignored
but rather gives microseconds.  So you can use this function just fine.
I have made a bug report.

-- 
David Kastrup

Re: is there a emacs lisp timing command?

[Nikolaj Schumacher]

Xah Lee <xahlee@gmail.com> wrote:

> is there a elisp command like timing, that returns the time a function
> took?

Seems like everybody here has written their own, but Emacs does come with:
benchmark-run and benchmark-run-compiled.

It takes garbage collection into account, which can explain fluctuating
results.

regards,
Nikolaj Schumacher

Re: is there a emacs lisp timing command?

[Xah Lee]

On Mar 24, 1:25 pm, Nikolaj Schumacher <m...@nschum.de> wrote:
> Xah Lee <xah...@gmail.com> wrote:
> > is there a elisp command like timing, that returns the time a function
> > took?
>
> Seems like everybody here has written their own, but Emacs does come with:
> benchmark-run and benchmark-run-compiled.
>
> It takes garbage collection into account, which can explain fluctuating
> results.

Thank you all for the help.

After reading the replies, it turns out my error was that i mistook
microsecond to be 10^-3 but it should be 10^-6.

Thanks Nik for the benchmark-run. That'll be helpful too, and the elp
profiler down the road.

  Xah
∑ http://xahlee.org/

☄