Rails, Passenger, FreeBSD, Production weird goings on

Hi,

Our production site is going very slow and i was just wondering if
anyone has ever seen stuff like this before in the logs

One request returning four, notice the db times.

Processing ArticlesController#show (for 193.172.238.146 at 2010-11-18
16:26:03) [GET]
  Session ID: d3ab8cc7b8bfc3154e1f3cdd11a79ec0
  Parameters: {"action"=>"show", "id"=>"12",
"controller"=>"education/articles"}
Completed in 201.30773 (0 reqs/sec) | Rendering: 0.84850 (0%) | DB:
200.23051 (99%) | 200 OK
[http://xx.xxx-xxxxxxxxxxx.com/education/articles/15]
Completed in 201.30773 (0 reqs/sec) | Rendering: 0.67231 (0%) | DB:
200.58331 (99%) | 200 OK
[http://xx.xxx-xxxxxxxxxxx.com/education/articles/64]
Completed in 198.24940 (0 reqs/sec) | Rendering: 0.76880 (0%) | DB:
197.43730 (99%) | 200 OK
[http://xx.xxx-xxxxxxxxxxx.com/education/articles/35]
Completed in 199.86349 (0 reqs/sec) | Rendering: 0.66750 (0%) | DB:
199.01294 (99%) | 200 OK
[http://xx.xxx-xxxxxxxxxxx.com/education/articles/54]

This looks unusual to me too, rendering the same views multiples of
times.

Processing ArticlesController#show (for 200.35.190.97 at 2010-11-18
16:25:14) [GET]
  Session ID: ffcb436fd7bc07baf925eb87ed069aa0
  Parameters: {"action"=>"show", "id"=>"101",
"controller"=>"education/articles"}
Rendering within layouts/application
Rendering education/articles/show
Rendering within layouts/business/application
Rendering within layouts/application
Rendering education/articles/show
Rendering within layouts/application
Rendering education/articles/show
Rendering within layouts/application
Rendering education/articles/show
Rendering within layouts/application
Rendering education/articles/show
Rendering within layouts/application
Rendering within layouts/application
Rendering education/articles/show
Rendering education/articles/show
Rendering business/articles/show
Completed in 151.21412 (0 reqs/sec) | Rendering: 0.53775 (0%) | DB:
149.92393 (99%) | 200 OK
[http://xx.xxx-xxxxxxxxxxx.com/business/articles/116]
Completed in 200.98208 (0 reqs/sec) | Rendering: 0.25980 (0%) | DB:
200.69937 (99%) | 200 OK
[http://xx.xxx-xxxxxxxxxxxx.com/education/articles/299]

The production site runs:

rails 2.1.0
postgres
freebsd
passenger

One thing i noticed is Passenger is referencing Ruby Enterprise but the
app reports that it's runnign under FreeBSD's Ruby

This is a system we inherited, not our design or what we are used to.

Anyone shed any light?

JB

Hi,

Our production site is going very slow and i was just wondering if
anyone has ever seen stuff like this before in the logs

Is that just multiple simultaneous requests writing to the log file at
the same time, so all the results get interleaved?

If you suspect a database problem then turn on the slow query log (or
even just sitting at the database console and asking it what it's
doing (show processlist for mysql)) to see what queries are slow

Fred