Processing ArticlesController#index (for 127.0.0.1 at 2006-07-07 23:57:18) [GET] Parameters: {"action"=>"index", "controller"=>"articles"} Blog Load (0.016137) SELECT * FROM blogs ORDER BY id LIMIT 1 Trigger Load (0.005647) SELECT * FROM triggers WHERE (due_at <= '2006-07-07 23:57:18')  SQL (0.015496)  SELECT a.attname, format_type(a.atttypid, a.atttypmod), d.adsrc, a.attnotnull FROM pg_attribute a LEFT JOIN pg_attrdef d ON a.attrelid = d.adrelid AND a.attnum = d.adnum WHERE a.attrelid = 'users'::regclass AND a.attnum > 0 AND NOT a.attisdropped ORDER BY a.attnum  SQL (0.003890) SELECT count(*) AS count_all FROM users  SQL (0.003992)  SELECT a.attname, format_type(a.atttypid, a.atttypmod), d.adsrc, a.attnotnull FROM pg_attribute a LEFT JOIN pg_attrdef d ON a.attrelid = d.adrelid AND a.attnum = d.adnum WHERE a.attrelid = 'blogs'::regclass AND a.attnum > 0 AND NOT a.attisdropped ORDER BY a.attnum  SQL (0.004945)  SELECT a.attname, format_type(a.atttypid, a.atttypmod), d.adsrc, a.attnotnull FROM pg_attribute a LEFT JOIN pg_attrdef d ON a.attrelid = d.adrelid AND a.attnum = d.adnum WHERE a.attrelid = 'contents'::regclass AND a.attnum > 0 AND NOT a.attisdropped ORDER BY a.attnum  Article Count (4.513755) SELECT COUNT(DISTINCT contents.id) FROM contents LEFT OUTER JOIN articles_categories ON articles_categories.article_id = contents.id LEFT OUTER JOIN categories ON categories.id = articles_categories.category_id LEFT OUTER JOIN articles_tags ON articles_tags.article_id = contents.id LEFT OUTER JOIN tags ON tags.id = articles_tags.tag_id WHERE (published = 't' AND contents.created_at < '2006-07-07 23:57:18' AND blog_id = 1) AND ( (contents."type" = 'Article' ) )  SQL (0.004335)  SELECT a.attname, format_type(a.atttypid, a.atttypmod), d.adsrc, a.attnotnull FROM pg_attribute a LEFT JOIN pg_attrdef d ON a.attrelid = d.adrelid AND a.attnum = d.adnum WHERE a.attrelid = 'categories'::regclass AND a.attnum > 0 AND NOT a.attisdropped ORDER BY a.attnum  SQL (0.013500)  SELECT a.attname, format_type(a.atttypid, a.atttypmod), d.adsrc, a.attnotnull FROM pg_attribute a LEFT JOIN pg_attrdef d ON a.attrelid = d.adrelid AND a.attnum = d.adnum WHERE a.attrelid = 'tags'::regclass AND a.attnum > 0 AND NOT a.attisdropped ORDER BY a.attnum  Article Load IDs For Limited Eager Loading (0.020334) SELECT id FROM contents WHERE (published = 't' AND contents.created_at < '2006-07-07 23:57:18' AND blog_id = 1) AND ( (contents."type" = 'Article' ) ) ORDER BY contents.published_at DESC LIMIT 15 OFFSET 0 Article Load Including Associations (0.386613) SELECT contents."id" AS t0_r0, contents."title" AS t0_r1, contents."author" AS t0_r2, contents."body" AS t0_r3, contents."body_html" AS t0_r4, contents."extended" AS t0_r5, contents."excerpt" AS t0_r6, contents."keywords" AS t0_r7, contents."created_at" AS t0_r8, contents."updated_at" AS t0_r9, contents."extended_html" AS t0_r10, contents."user_id" AS t0_r11, contents."permalink" AS t0_r12, contents."guid" AS t0_r13, contents."text_filter_id" AS t0_r14, contents."whiteboard" AS t0_r15, contents."comments_count" AS t0_r16, contents."trackbacks_count" AS t0_r17, contents."type" AS t0_r18, contents."article_id" AS t0_r19, contents."email" AS t0_r20, contents."url" AS t0_r21, contents."ip" AS t0_r22, contents."blog_name" AS t0_r23, contents."name" AS t0_r24, contents."published" AS t0_r25, contents."allow_pings" AS t0_r26, contents."allow_comments" AS t0_r27, contents."blog_id" AS t0_r28, contents."published_at" AS t0_r29, categories."id" AS t1_r0, categories."name" AS t1_r1, categories."position" AS t1_r2, categories."is_primary" AS t1_r3, categories."permalink" AS t1_r4, tags."id" AS t2_r0, tags."name" AS t2_r1, tags."created_at" AS t2_r2, tags."updated_at" AS t2_r3, tags."display_name" AS t2_r4 FROM contents LEFT OUTER JOIN articles_categories ON articles_categories.article_id = contents.id LEFT OUTER JOIN categories ON categories.id = articles_categories.category_id LEFT OUTER JOIN articles_tags ON articles_tags.article_id = contents.id LEFT OUTER JOIN tags ON tags.id = articles_tags.tag_id WHERE (published = 't' AND contents.created_at < '2006-07-07 23:57:18' AND blog_id = 1) AND ( (contents."type" = 'Article' ) ) AND contents.id IN ('1640', '562', '561', '560', '559', '558', '557', '556', '555', '554', '553', '552', '551', '550', '549') ORDER BY contents.published_at DESC  Rendering within ../../themes/scribbish/layouts/default Rendering articles/index Blog Load (0.002023) SELECT * FROM blogs WHERE (blogs.id = 1) LIMIT 1 User Load (0.002719) SELECT * FROM users WHERE (users.id = 1) LIMIT 1 Blog Load (0.001383) SELECT * FROM blogs ORDER BY id LIMIT 1 Rendered articles/_article (0.05445) Blog Load (0.002212) SELECT * FROM blogs WHERE (blogs.id = 1) LIMIT 1 User Load (0.001886) SELECT * FROM users WHERE (users.id = 1) LIMIT 1 Rendered articles/_article (0.01711) Blog Load (0.001771) SELECT * FROM blogs WHERE (blogs.id = 1) LIMIT 1 User Load (0.002901) SELECT * FROM users WHERE (users.id = 1) LIMIT 1 Rendered articles/_article (0.01773) Blog Load (0.001740) SELECT * FROM blogs WHERE (blogs.id = 1) LIMIT 1 User Load (0.001870) SELECT * FROM users WHERE (users.id = 1) LIMIT 1 Rendered articles/_article (0.02209) Blog Load (0.001782) SELECT * FROM blogs WHERE (blogs.id = 1) LIMIT 1 User Load (0.002901) SELECT * FROM users WHERE (users.id = 1) LIMIT 1 Rendered articles/_article (0.15349) Blog Load (0.001817) SELECT * FROM blogs WHERE (blogs.id = 1) LIMIT 1 User Load (0.001941) SELECT * FROM users WHERE (users.id = 1) LIMIT 1 Rendered articles/_article (0.02095) Blog Load (0.001861) SELECT * FROM blogs WHERE (blogs.id = 1) LIMIT 1 User Load (0.002133) SELECT * FROM users WHERE (users.id = 1) LIMIT 1 Rendered articles/_article (0.01751) Blog Load (0.001752) SELECT * FROM blogs WHERE (blogs.id = 1) LIMIT 1 User Load (0.001913) SELECT * FROM users WHERE (users.id = 1) LIMIT 1 Rendered articles/_article (0.02205) Blog Load (0.001730) SELECT * FROM blogs WHERE (blogs.id = 1) LIMIT 1 User Load (0.001901) SELECT * FROM users WHERE (users.id = 1) LIMIT 1 Rendered articles/_article (0.01732) Blog Load (0.001755) SELECT * FROM blogs WHERE (blogs.id = 1) LIMIT 1 User Load (0.002170) SELECT * FROM users WHERE (users.id = 1) LIMIT 1 Rendered articles/_article (0.01707) Blog Load (0.003053) SELECT * FROM blogs WHERE (blogs.id = 1) LIMIT 1 User Load (0.009510) SELECT * FROM users WHERE (users.id = 1) LIMIT 1 Rendered articles/_article (0.03132) Blog Load (0.001715) SELECT * FROM blogs WHERE (blogs.id = 1) LIMIT 1 User Load (0.002746) SELECT * FROM users WHERE (users.id = 1) LIMIT 1 Rendered articles/_article (0.01928) Blog Load (0.001758) SELECT * FROM blogs WHERE (blogs.id = 1) LIMIT 1 User Load (0.002025) SELECT * FROM users WHERE (users.id = 1) LIMIT 1 Rendered articles/_article (0.15543) Blog Load (0.013129) SELECT * FROM blogs WHERE (blogs.id = 1) LIMIT 1 User Load (0.002782) SELECT * FROM users WHERE (users.id = 1) LIMIT 1 Rendered articles/_article (0.04339) Blog Load (0.002026) SELECT * FROM blogs WHERE (blogs.id = 1) LIMIT 1 User Load (0.001945) SELECT * FROM users WHERE (users.id = 1) LIMIT 1 Rendered articles/_article (0.02155) Rendered articles/_search (0.02073) Start rendering component ({:controller=>SidebarController, :action=>"display_plugins"}): Processing SidebarController#display_plugins (for 127.0.0.1 at 2006-07-07 23:57:25) Blog Load (0.001413) SELECT * FROM blogs ORDER BY id LIMIT 1 Trigger Load (0.001452) SELECT * FROM triggers WHERE (due_at <= '2006-07-07 23:57:25')  Sidebar Load (0.011881) SELECT * FROM sidebars WHERE (active_position is not null) ORDER BY active_position  SQL (0.004057)  SELECT a.attname, format_type(a.atttypid, a.atttypmod), d.adsrc, a.attnotnull FROM pg_attribute a LEFT JOIN pg_attrdef d ON a.attrelid = d.adrelid AND a.attnum = d.adnum WHERE a.attrelid = 'sidebars'::regclass AND a.attnum > 0 AND NOT a.attisdropped ORDER BY a.attnum  Rendering sidebar/display_plugins Start rendering component ({:controller=>Plugins::Sidebars::TagController, :action=>"index", :layout=>false}): Processing TagController#index (for 127.0.0.1 at 2006-07-07 23:57:25) Blog Load (0.001426) SELECT * FROM blogs ORDER BY id LIMIT 1 Trigger Load (0.001745) SELECT * FROM triggers WHERE (due_at <= '2006-07-07 23:57:25')  Tag Load (0.054555)  SELECT tags.id, tags.name, tags.display_name, COUNT(articles_tags.article_id) AS article_counter FROM tags tags LEFT OUTER JOIN articles_tags articles_tags ON articles_tags.tag_id = tags.id LEFT OUTER JOIN contents articles ON articles_tags.article_id = articles.id WHERE articles.published = 't' GROUP BY tags.id, tags.name, tags.display_name ORDER BY article_counter DESC LIMIT 20  Rendering plugins/sidebars/tag/content Completed in 0.22549 (4 reqs/sec) | Rendering: 0.01884 (8%) | DB: 0.05773 (25%) | 200 OK [http://localhost/] End of component rendering BENCHMARK: display_plugins: tag (0.23098) Rendered sidebar/_sidebar (0.23655) Start rendering component ({:controller=>Plugins::Sidebars::ArchivesController, :action=>"index", :layout=>false}): Processing ArchivesController#index (for 127.0.0.1 at 2006-07-07 23:57:25) Blog Load (0.001529) SELECT * FROM blogs ORDER BY id LIMIT 1 Trigger Load (0.001818) SELECT * FROM triggers WHERE (due_at <= '2006-07-07 23:57:25')  Content Load (0.045127) select count(*) as count, extract(year from published_at)||' '||extract(month from published_at) as date from contents where published = 't' and published_at < '2006-07-07 23:57:25' group by date SQL (0.004646)  SELECT a.attname, format_type(a.atttypid, a.atttypmod), d.adsrc, a.attnotnull FROM pg_attribute a LEFT JOIN pg_attrdef d ON a.attrelid = d.adrelid AND a.attnum = d.adnum WHERE a.attrelid = 'contents'::regclass AND a.attnum > 0 AND NOT a.attisdropped ORDER BY a.attnum  Rendering plugins/sidebars/archives/content Completed in 0.24106 (4 reqs/sec) | Rendering: 0.16822 (69%) | DB: 0.05312 (22%) | 200 OK [http://localhost/] End of component rendering BENCHMARK: display_plugins: archives (0.24435) Rendered sidebar/_sidebar (0.24557) Start rendering component ({:controller=>Plugins::Sidebars::StaticController, :action=>"index", :layout=>false}): Processing StaticController#index (for 127.0.0.1 at 2006-07-07 23:57:25) Blog Load (0.001436) SELECT * FROM blogs ORDER BY id LIMIT 1 Trigger Load (0.002549) SELECT * FROM triggers WHERE (due_at <= '2006-07-07 23:57:25')  Rendering plugins/sidebars/static/content Completed in 0.01794 (55 reqs/sec) | Rendering: 0.00785 (43%) | DB: 0.00399 (22%) | 200 OK [http://localhost/] End of component rendering BENCHMARK: display_plugins: static (0.02245) Rendered sidebar/_sidebar (0.02336) BENCHMARK: display_plugins (0.50874) Completed in 0.55068 (1 reqs/sec) | Rendering: 0.51641 (93%) | DB: 0.10165 (18%) | 200 OK [http://localhost/] End of component rendering Article Load (0.010661) SELECT * FROM contents WHERE (published = 't' AND created_at > '2006-07-07 23:57:18') AND ( (contents."type" = 'Article' ) ) ORDER BY created_at ASC LIMIT 1 Completed in 6.95595 (0 reqs/sec) | Rendering: 1.56626 (22%) | DB: 4.99931 (71%) | 200 OK [http://localhost/] Processing XmlController#feed (for 127.0.0.1 at 2006-07-07 23:57:27) [GET] Parameters: {"format"=>"atom", "type"=>"feed", "action"=>"feed", "controller"=>"xml"} Blog Load (0.001394) SELECT * FROM blogs ORDER BY id LIMIT 1 Trigger Load (0.001630) SELECT * FROM triggers WHERE (due_at <= '2006-07-07 23:57:27')  SQL (0.003843)  SELECT a.attname, format_type(a.atttypid, a.atttypmod), d.adsrc, a.attnotnull FROM pg_attribute a LEFT JOIN pg_attrdef d ON a.attrelid = d.adrelid AND a.attnum = d.adnum WHERE a.attrelid = 'blogs'::regclass AND a.attnum > 0 AND NOT a.attisdropped ORDER BY a.attnum  ActiveRecord::ConfigurationError (Association named 'blogs' was not found; perhaps you misspelled it?): /opt/local/lib/ruby/gems/1.8/gems/activerecord-1.14.3/lib/active_record/associations.rb:1294:in `build' /opt/local/lib/ruby/gems/1.8/gems/activerecord-1.14.3/lib/active_record/associations.rb:1299:in `build' /opt/local/lib/ruby/gems/1.8/gems/activerecord-1.14.3/lib/active_record/associations.rb:1298:in `build' /opt/local/lib/ruby/gems/1.8/gems/activerecord-1.14.3/lib/active_record/associations.rb:1262:in `initialize' /opt/local/lib/ruby/gems/1.8/gems/activerecord-1.14.3/lib/active_record/associations.rb:974:in `find_with_associations' /opt/local/lib/ruby/gems/1.8/gems/activerecord-1.14.3/lib/active_record/associations.rb:973:in `find_with_associations' /opt/local/lib/ruby/gems/1.8/gems/activerecord-1.14.3/lib/active_record/base.rb:923:in `find_every' /opt/local/lib/ruby/gems/1.8/gems/activerecord-1.14.3/lib/active_record/base.rb:381:in `find' /app/models/content.rb:82:in `find_published' /app/models/content.rb:97:in `find_already_published' /opt/local/lib/ruby/gems/1.8/gems/activerecord-1.14.3/lib/active_record/base.rb:873:in `with_scope' /app/models/content.rb:96:in `find_already_published' /opt/local/lib/ruby/gems/1.8/gems/activerecord-1.14.3/lib/active_record/associations/has_many_association.rb:102:in `method_missing' /opt/local/lib/ruby/gems/1.8/gems/activerecord-1.14.3/lib/active_record/base.rb:873:in `with_scope' /opt/local/lib/ruby/gems/1.8/gems/activerecord-1.14.3/lib/active_record/associations/has_many_association.rb:92:in `method_missing' /app/controllers/xml_controller.rb:71:in `fetch_items' /app/controllers/xml_controller.rb:75:in `prep_feed' /app/controllers/xml_controller.rb:34:in `feed' /opt/local/lib/ruby/gems/1.8/gems/actionpack-1.12.3/lib/action_controller/base.rb:910:in `perform_action_without_filters' /opt/local/lib/ruby/gems/1.8/gems/actionpack-1.12.3/lib/action_controller/filters.rb:368:in `perform_action_without_benchmark' /opt/local/lib/ruby/gems/1.8/gems/actionpack-1.12.3/lib/action_controller/benchmarking.rb:69:in `perform_action_without_rescue' /opt/local/lib/ruby/1.8/benchmark.rb:293:in `measure' /opt/local/lib/ruby/gems/1.8/gems/actionpack-1.12.3/lib/action_controller/benchmarking.rb:69:in `perform_action_without_rescue' /opt/local/lib/ruby/gems/1.8/gems/actionpack-1.12.3/lib/action_controller/rescue.rb:82:in `perform_action' /opt/local/lib/ruby/gems/1.8/gems/actionpack-1.12.3/lib/action_controller/base.rb:381:in `process_without_filters' /opt/local/lib/ruby/gems/1.8/gems/actionpack-1.12.3/lib/action_controller/filters.rb:377:in `process_without_session_management_support' /opt/local/lib/ruby/gems/1.8/gems/actionpack-1.12.3/lib/action_controller/session_management.rb:117:in `process' /opt/local/lib/ruby/gems/1.8/gems/rails-1.1.4/lib/dispatcher.rb:38:in `dispatch' /opt/local/lib/ruby/gems/1.8/gems/rails-1.1.4/lib/webrick_server.rb:115:in `handle_dispatch' /opt/local/lib/ruby/gems/1.8/gems/rails-1.1.4/lib/webrick_server.rb:81:in `service' /opt/local/lib/ruby/1.8/webrick/httpserver.rb:104:in `service' /opt/local/lib/ruby/1.8/webrick/httpserver.rb:65:in `run' /opt/local/lib/ruby/1.8/webrick/server.rb:173:in `start_thread' /opt/local/lib/ruby/1.8/webrick/server.rb:162:in `start_thread' /opt/local/lib/ruby/1.8/webrick/server.rb:95:in `start' /opt/local/lib/ruby/1.8/webrick/server.rb:92:in `start' /opt/local/lib/ruby/1.8/webrick/server.rb:23:in `start' /opt/local/lib/ruby/1.8/webrick/server.rb:82:in `start' /opt/local/lib/ruby/gems/1.8/gems/rails-1.1.4/lib/webrick_server.rb:67:in `dispatch' /opt/local/lib/ruby/gems/1.8/gems/rails-1.1.4/lib/commands/servers/webrick.rb:59 /opt/local/lib/ruby/site_ruby/1.8/rubygems/custom_require.rb:21:in `require' /opt/local/lib/ruby/gems/1.8/gems/activesupport-1.3.1/lib/active_support/dependencies.rb:147:in `require' /opt/local/lib/ruby/gems/1.8/gems/rails-1.1.4/lib/commands/server.rb:30 /opt/local/lib/ruby/site_ruby/1.8/rubygems/custom_require.rb:21:in `require' /opt/local/lib/ruby/gems/1.8/gems/activesupport-1.3.1/lib/active_support/dependencies.rb:147:in `require' ./script/server:3 Rendering /opt/local/lib/ruby/gems/1.8/gems/actionpack-1.12.3/lib/action_controller/templates/rescues/layout.rhtml (500 Internal Error) Processing XmlController#feed (for 127.0.0.1 at 2006-07-07 23:57:28) [GET] Parameters: {"format"=>"rss20", "type"=>"feed", "action"=>"feed", "controller"=>"xml"} Blog Load (0.001594) SELECT * FROM blogs ORDER BY id LIMIT 1 Trigger Load (0.001654) SELECT * FROM triggers WHERE (due_at <= '2006-07-07 23:57:28')  SQL (0.014642)  SELECT a.attname, format_type(a.atttypid, a.atttypmod), d.adsrc, a.attnotnull FROM pg_attribute a LEFT JOIN pg_attrdef d ON a.attrelid = d.adrelid AND a.attnum = d.adnum WHERE a.attrelid = 'blogs'::regclass AND a.attnum > 0 AND NOT a.attisdropped ORDER BY a.attnum  ActiveRecord::ConfigurationError (Association named 'blogs' was not found; perhaps you misspelled it?): /opt/local/lib/ruby/gems/1.8/gems/activerecord-1.14.3/lib/active_record/associations.rb:1294:in `build' /opt/local/lib/ruby/gems/1.8/gems/activerecord-1.14.3/lib/active_record/associations.rb:1299:in `build' /opt/local/lib/ruby/gems/1.8/gems/activerecord-1.14.3/lib/active_record/associations.rb:1298:in `build' /opt/local/lib/ruby/gems/1.8/gems/activerecord-1.14.3/lib/active_record/associations.rb:1262:in `initialize' /opt/local/lib/ruby/gems/1.8/gems/activerecord-1.14.3/lib/active_record/associations.rb:974:in `find_with_associations' /opt/local/lib/ruby/gems/1.8/gems/activerecord-1.14.3/lib/active_record/associations.rb:973:in `find_with_associations' /opt/local/lib/ruby/gems/1.8/gems/activerecord-1.14.3/lib/active_record/base.rb:923:in `find_every' /opt/local/lib/ruby/gems/1.8/gems/activerecord-1.14.3/lib/active_record/base.rb:381:in `find' /app/models/content.rb:82:in `find_published' /app/models/content.rb:97:in `find_already_published' /opt/local/lib/ruby/gems/1.8/gems/activerecord-1.14.3/lib/active_record/base.rb:873:in `with_scope' /app/models/content.rb:96:in `find_already_published' /opt/local/lib/ruby/gems/1.8/gems/activerecord-1.14.3/lib/active_record/associations/has_many_association.rb:102:in `method_missing' /opt/local/lib/ruby/gems/1.8/gems/activerecord-1.14.3/lib/active_record/base.rb:873:in `with_scope' /opt/local/lib/ruby/gems/1.8/gems/activerecord-1.14.3/lib/active_record/associations/has_many_association.rb:92:in `method_missing' /app/controllers/xml_controller.rb:71:in `fetch_items' /app/controllers/xml_controller.rb:75:in `prep_feed' /app/controllers/xml_controller.rb:34:in `feed' /opt/local/lib/ruby/gems/1.8/gems/actionpack-1.12.3/lib/action_controller/base.rb:910:in `perform_action_without_filters' /opt/local/lib/ruby/gems/1.8/gems/actionpack-1.12.3/lib/action_controller/filters.rb:368:in `perform_action_without_benchmark' /opt/local/lib/ruby/gems/1.8/gems/actionpack-1.12.3/lib/action_controller/benchmarking.rb:69:in `perform_action_without_rescue' /opt/local/lib/ruby/1.8/benchmark.rb:293:in `measure' /opt/local/lib/ruby/gems/1.8/gems/actionpack-1.12.3/lib/action_controller/benchmarking.rb:69:in `perform_action_without_rescue' /opt/local/lib/ruby/gems/1.8/gems/actionpack-1.12.3/lib/action_controller/rescue.rb:82:in `perform_action' /opt/local/lib/ruby/gems/1.8/gems/actionpack-1.12.3/lib/action_controller/base.rb:381:in `process_without_filters' /opt/local/lib/ruby/gems/1.8/gems/actionpack-1.12.3/lib/action_controller/filters.rb:377:in `process_without_session_management_support' /opt/local/lib/ruby/gems/1.8/gems/actionpack-1.12.3/lib/action_controller/session_management.rb:117:in `process' /opt/local/lib/ruby/gems/1.8/gems/rails-1.1.4/lib/dispatcher.rb:38:in `dispatch' /opt/local/lib/ruby/gems/1.8/gems/rails-1.1.4/lib/webrick_server.rb:115:in `handle_dispatch' /opt/local/lib/ruby/gems/1.8/gems/rails-1.1.4/lib/webrick_server.rb:81:in `service' /opt/local/lib/ruby/1.8/webrick/httpserver.rb:104:in `service' /opt/local/lib/ruby/1.8/webrick/httpserver.rb:65:in `run' /opt/local/lib/ruby/1.8/webrick/server.rb:173:in `start_thread' /opt/local/lib/ruby/1.8/webrick/server.rb:162:in `start_thread' /opt/local/lib/ruby/1.8/webrick/server.rb:95:in `start' /opt/local/lib/ruby/1.8/webrick/server.rb:92:in `start' /opt/local/lib/ruby/1.8/webrick/server.rb:23:in `start' /opt/local/lib/ruby/1.8/webrick/server.rb:82:in `start' /opt/local/lib/ruby/gems/1.8/gems/rails-1.1.4/lib/webrick_server.rb:67:in `dispatch' /opt/local/lib/ruby/gems/1.8/gems/rails-1.1.4/lib/commands/servers/webrick.rb:59 /opt/local/lib/ruby/site_ruby/1.8/rubygems/custom_require.rb:21:in `require' /opt/local/lib/ruby/gems/1.8/gems/activesupport-1.3.1/lib/active_support/dependencies.rb:147:in `require' /opt/local/lib/ruby/gems/1.8/gems/rails-1.1.4/lib/commands/server.rb:30 /opt/local/lib/ruby/site_ruby/1.8/rubygems/custom_require.rb:21:in `require' /opt/local/lib/ruby/gems/1.8/gems/activesupport-1.3.1/lib/active_support/dependencies.rb:147:in `require' ./script/server:3 Rendering /opt/local/lib/ruby/gems/1.8/gems/actionpack-1.12.3/lib/action_controller/templates/rescues/layout.rhtml (500 Internal Error) Processing ThemeController#stylesheets (for 127.0.0.1 at 2006-07-07 23:57:30) [GET] Parameters: {"action"=>"stylesheets", "controller"=>"theme", "filename"=>"application.css"} Blog Load (0.001407) SELECT * FROM blogs ORDER BY id LIMIT 1 Trigger Load (0.001592) SELECT * FROM triggers WHERE (due_at <= '2006-07-07 23:57:30')  SQL (0.004152)  SELECT a.attname, format_type(a.atttypid, a.atttypmod), d.adsrc, a.attnotnull FROM pg_attribute a LEFT JOIN pg_attrdef d ON a.attrelid = d.adrelid AND a.attnum = d.adnum WHERE a.attrelid = 'blogs'::regclass AND a.attnum > 0 AND NOT a.attisdropped ORDER BY a.attnum  Sending file script/../config/../themes/scribbish/stylesheets/application.css Completed in 0.01916 (52 reqs/sec) | Rendering: 0.00015 (0%) | DB: 0.03191 (166%) | 200 OK [http://localhost/stylesheets/theme/application.css?] Processing ThemeController#stylesheets (for 127.0.0.1 at 2006-07-07 23:57:31) [GET] Parameters: {"action"=>"stylesheets", "controller"=>"theme", "filename"=>"layout.css"} Blog Load (0.001499) SELECT * FROM blogs ORDER BY id LIMIT 1 Trigger Load (0.001597) SELECT * FROM triggers WHERE (due_at <= '2006-07-07 23:57:31')  SQL (0.007464)  SELECT a.attname, format_type(a.atttypid, a.atttypmod), d.adsrc, a.attnotnull FROM pg_attribute a LEFT JOIN pg_attrdef d ON a.attrelid = d.adrelid AND a.attnum = d.adnum WHERE a.attrelid = 'blogs'::regclass AND a.attnum > 0 AND NOT a.attisdropped ORDER BY a.attnum  Sending file script/../config/../themes/scribbish/stylesheets/layout.css Completed in 0.02883 (34 reqs/sec) | Rendering: 0.00015 (0%) | DB: 0.01056 (36%) | 200 OK [http://localhost/stylesheets/theme/layout.css] Processing ThemeController#stylesheets (for 127.0.0.1 at 2006-07-07 23:57:33) [GET] Parameters: {"action"=>"stylesheets", "controller"=>"theme", "filename"=>"content.css"} Blog Load (0.001384) SELECT * FROM blogs ORDER BY id LIMIT 1 Trigger Load (0.001564) SELECT * FROM triggers WHERE (due_at <= '2006-07-07 23:57:33')  SQL (0.003930)  SELECT a.attname, format_type(a.atttypid, a.atttypmod), d.adsrc, a.attnotnull FROM pg_attribute a LEFT JOIN pg_attrdef d ON a.attrelid = d.adrelid AND a.attnum = d.adnum WHERE a.attrelid = 'blogs'::regclass AND a.attnum > 0 AND NOT a.attisdropped ORDER BY a.attnum  Sending file script/../config/../themes/scribbish/stylesheets/content.css Completed in 0.02013 (49 reqs/sec) | Rendering: 0.00015 (0%) | DB: 0.00688 (34%) | 200 OK [http://localhost/stylesheets/theme/content.css] Processing ThemeController#javascript (for 127.0.0.1 at 2006-07-07 23:57:34) [GET] Parameters: {"action"=>"javascript", "controller"=>"theme", "filename"=>"application.js"} Blog Load (0.001414) SELECT * FROM blogs ORDER BY id LIMIT 1 Trigger Load (0.004993) SELECT * FROM triggers WHERE (due_at <= '2006-07-07 23:57:34')  SQL (0.008219)  SELECT a.attname, format_type(a.atttypid, a.atttypmod), d.adsrc, a.attnotnull FROM pg_attribute a LEFT JOIN pg_attrdef d ON a.attrelid = d.adrelid AND a.attnum = d.adnum WHERE a.attrelid = 'blogs'::regclass AND a.attnum > 0 AND NOT a.attisdropped ORDER BY a.attnum  ActionController::MissingFile (Cannot read file script/../config/../themes/scribbish/javascript/application.js): /opt/local/lib/ruby/gems/1.8/gems/actionpack-1.12.3/lib/action_controller/streaming.rb:55:in `send_file' /app/controllers/theme_controller.rb:28:in `render_theme_item' /app/controllers/theme_controller.rb:10:in `javascript' /opt/local/lib/ruby/gems/1.8/gems/actionpack-1.12.3/lib/action_controller/base.rb:910:in `perform_action_without_filters' /opt/local/lib/ruby/gems/1.8/gems/actionpack-1.12.3/lib/action_controller/filters.rb:368:in `perform_action_without_benchmark' /opt/local/lib/ruby/gems/1.8/gems/actionpack-1.12.3/lib/action_controller/benchmarking.rb:69:in `perform_action_without_rescue' /opt/local/lib/ruby/1.8/benchmark.rb:293:in `measure' /opt/local/lib/ruby/gems/1.8/gems/actionpack-1.12.3/lib/action_controller/benchmarking.rb:69:in `perform_action_without_rescue' /opt/local/lib/ruby/gems/1.8/gems/actionpack-1.12.3/lib/action_controller/rescue.rb:82:in `perform_action' /opt/local/lib/ruby/gems/1.8/gems/actionpack-1.12.3/lib/action_controller/base.rb:381:in `process_without_filters' /opt/local/lib/ruby/gems/1.8/gems/actionpack-1.12.3/lib/action_controller/filters.rb:377:in `process_without_session_management_support' /opt/local/lib/ruby/gems/1.8/gems/actionpack-1.12.3/lib/action_controller/session_management.rb:117:in `process' /opt/local/lib/ruby/gems/1.8/gems/rails-1.1.4/lib/dispatcher.rb:38:in `dispatch' /opt/local/lib/ruby/gems/1.8/gems/rails-1.1.4/lib/webrick_server.rb:115:in `handle_dispatch' /opt/local/lib/ruby/gems/1.8/gems/rails-1.1.4/lib/webrick_server.rb:81:in `service' /opt/local/lib/ruby/1.8/webrick/httpserver.rb:104:in `service' /opt/local/lib/ruby/1.8/webrick/httpserver.rb:65:in `run' /opt/local/lib/ruby/1.8/webrick/server.rb:173:in `start_thread' /opt/local/lib/ruby/1.8/webrick/server.rb:162:in `start_thread' /opt/local/lib/ruby/1.8/webrick/server.rb:95:in `start' /opt/local/lib/ruby/1.8/webrick/server.rb:92:in `start' /opt/local/lib/ruby/1.8/webrick/server.rb:23:in `start' /opt/local/lib/ruby/1.8/webrick/server.rb:82:in `start' /opt/local/lib/ruby/gems/1.8/gems/rails-1.1.4/lib/webrick_server.rb:67:in `dispatch' /opt/local/lib/ruby/gems/1.8/gems/rails-1.1.4/lib/commands/servers/webrick.rb:59 /opt/local/lib/ruby/site_ruby/1.8/rubygems/custom_require.rb:21:in `require' /opt/local/lib/ruby/gems/1.8/gems/activesupport-1.3.1/lib/active_support/dependencies.rb:147:in `require' /opt/local/lib/ruby/gems/1.8/gems/rails-1.1.4/lib/commands/server.rb:30 /opt/local/lib/ruby/site_ruby/1.8/rubygems/custom_require.rb:21:in `require' /opt/local/lib/ruby/gems/1.8/gems/activesupport-1.3.1/lib/active_support/dependencies.rb:147:in `require' ./script/server:3 Rendering /opt/local/lib/ruby/gems/1.8/gems/actionpack-1.12.3/lib/action_controller/templates/rescues/layout.rhtml (500 Internal Error) Processing ThemeController#images (for 127.0.0.1 at 2006-07-07 23:57:36) [GET] Parameters: {"action"=>"images", "controller"=>"theme", "filename"=>"background.gif"} Blog Load (0.001460) SELECT * FROM blogs ORDER BY id LIMIT 1 Trigger Load (0.001595) SELECT * FROM triggers WHERE (due_at <= '2006-07-07 23:57:36')  SQL (0.004071)  SELECT a.attname, format_type(a.atttypid, a.atttypmod), d.adsrc, a.attnotnull FROM pg_attribute a LEFT JOIN pg_attrdef d ON a.attrelid = d.adrelid AND a.attnum = d.adnum WHERE a.attrelid = 'blogs'::regclass AND a.attnum > 0 AND NOT a.attisdropped ORDER BY a.attnum  Sending file script/../config/../themes/scribbish/images/background.gif Completed in 0.02155 (46 reqs/sec) | Rendering: 0.00016 (0%) | DB: 0.02175 (100%) | 200 OK [http://localhost/images/theme/background.gif] Processing ThemeController#images (for 127.0.0.1 at 2006-07-07 23:57:37) [GET] Parameters: {"action"=>"images", "controller"=>"theme", "filename"=>"header_shadow.gif"} Blog Load (0.001589) SELECT * FROM blogs ORDER BY id LIMIT 1 Trigger Load (0.001693) SELECT * FROM triggers WHERE (due_at <= '2006-07-07 23:57:37')  SQL (0.003891)  SELECT a.attname, format_type(a.atttypid, a.atttypmod), d.adsrc, a.attnotnull FROM pg_attribute a LEFT JOIN pg_attrdef d ON a.attrelid = d.adrelid AND a.attnum = d.adnum WHERE a.attrelid = 'blogs'::regclass AND a.attnum > 0 AND NOT a.attisdropped ORDER BY a.attnum  Sending file script/../config/../themes/scribbish/images/header_shadow.gif Completed in 0.02114 (47 reqs/sec) | Rendering: 0.00015 (0%) | DB: 0.00717 (33%) | 200 OK [http://localhost/images/theme/header_shadow.gif]