Forum: Ruby on Rails Reading log summary line from log file

Announcement (2017-05-07): www.ruby-forum.com is now read-only since I unfortunately do not have the time to support and maintain the forum any more. Please see rubyonrails.org/community and ruby-lang.org/en/community for other Rails- und Ruby-related community platforms.
6d465bb8df6bda89904c7aafea0dda6c?d=identicon&s=25 Don French (Guest)
on 2009-03-17 07:10
(Received via mailing list)
I am trying to understand the last line from an action log in
development mode. I have the following line and understand the view
and DB as the length of time it takes to process the view and the db
access. But what is the rest of the time?

Completed in 923ms (View: 220, DB: 45) | 200 OK [http://localhost:3000/
properties/2-hale-kamaole]

I get 265 ms but the total is 923ms. a long time.
872535e214a9e3a98889bd8d069f0294?d=identicon&s=25 "Wolas!" (Guest)
on 2009-03-17 10:05
(Received via mailing list)
Completed in 923ms (View: 220, DB: 45) | 200 OK

923 is total time it took since the request arrived untill it was
cmpletely served.

220 is how long it took to process the view
45 is the time the db took
200 is not a time is the HTTP header (200 means its all good to go,
404 means its not ... etc)
872535e214a9e3a98889bd8d069f0294?d=identicon&s=25 "Wolas!" (Guest)
on 2009-03-17 10:07
(Received via mailing list)
So sory! i didnt read that last line! Didnt mean to be so obvious.

there are more factors to completing a request than view and db (such
as watiting time). and if you do the same test on a heavily loaded
machine, it would take longer.
40db9e75b3f5899258e3bdc0c9210154?d=identicon&s=25 Conrad Taylor (conradwt)
on 2009-03-17 10:14
(Received via mailing list)
On Mon, Mar 16, 2009 at 11:09 PM, Don French <dhf0820@gmail.com> wrote:

>
>
You try running that request several times using 'ab' on your localhost
and
see how that number compares to the measurement above.

-Conrad
81b61875e41eaa58887543635d556fca?d=identicon&s=25 Frederick Cheung (Guest)
on 2009-03-17 10:24
(Received via mailing list)
On Mar 17, 6:09 am, Don French <dhf0...@gmail.com> wrote:
> I am trying to understand the last line from an action log in
> development mode. I have the following line and understand the view
> and DB as the length of time it takes to process the view and the db
> access. But what is the rest of the time?
>
> Completed in 923ms (View: 220, DB: 45) | 200 OK [http://localhost:3000/
> properties/2-hale-kamaole]
>
> I get 265 ms but the total is 923ms. a long time.

Controller code, model code that didn't hit the database etc... In
development there's also all the reloading of your source code.

Fred
6d465bb8df6bda89904c7aafea0dda6c?d=identicon&s=25 Don French (Guest)
on 2009-03-17 10:27
(Received via mailing list)
Waiting time? What waiting time?  I have run the test many times and
most are in this range. I am trying to figure out why it is taking so
long to complete.  The current time is unacceptable.

On Mar 16, 11:06 pm, "\"Wolas!\"" <jcpen...@gmail.com> wrote:
> So sory! i didnt read that last line! Didnt mean to be so obvious.
>
> there are more factors to completing a request than view and db (such
> as watiting time). and if you do the same test on a heavily loaded
> machine, it would take longer.
>
872535e214a9e3a98889bd8d069f0294?d=identicon&s=25 "Wolas!" (Guest)
on 2009-03-17 12:10
(Received via mailing list)
Without exact code posted it is hard to know why your setup is slow. I
do agree hoever tht your numbers seem higher than "usual".
This topic is locked and can not be replied to.