Connecting to database specified by database.yml  (0.1ms) select sqlite_version(*)  (161.4ms) CREATE TABLE "schema_migrations" ("version" varchar(255) NOT NULL)  (145.2ms) CREATE UNIQUE INDEX "unique_schema_migrations" ON "schema_migrations" ("version")  (1.1ms) SELECT "schema_migrations"."version" FROM "schema_migrations" Migrating to CreateKblogArticles (20130303192309)  (0.0ms) begin transaction  (0.6ms) CREATE TABLE "kblog_articles" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "title" varchar(255), "content" text, "created_at" datetime NOT NULL, "updated_at" datetime NOT NULL)  (0.3ms) INSERT INTO "schema_migrations" ("version") VALUES ('20130303192309')  (139.9ms) commit transaction  (0.1ms) SELECT "schema_migrations"."version" FROM "schema_migrations"  Connecting to database specified by database.yml Started GET "/" for 127.0.0.1 at 2013-03-03 20:27:32 +0100 ActionController::RoutingError (No route matches [GET] "/"): actionpack (3.2.13.rc1) lib/action_dispatch/middleware/debug_exceptions.rb:21:in `call' actionpack (3.2.13.rc1) lib/action_dispatch/middleware/show_exceptions.rb:56:in `call' railties (3.2.13.rc1) lib/rails/rack/logger.rb:32:in `call_app' railties (3.2.13.rc1) lib/rails/rack/logger.rb:16:in `block in call' activesupport (3.2.13.rc1) lib/active_support/tagged_logging.rb:22:in `tagged' railties (3.2.13.rc1) lib/rails/rack/logger.rb:16:in `call' actionpack (3.2.13.rc1) lib/action_dispatch/middleware/request_id.rb:22:in `call' rack (1.4.5) lib/rack/methodoverride.rb:21:in `call' rack (1.4.5) lib/rack/runtime.rb:17:in `call' activesupport (3.2.13.rc1) lib/active_support/cache/strategy/local_cache.rb:72:in `call' rack (1.4.5) lib/rack/lock.rb:15:in `call' actionpack (3.2.13.rc1) lib/action_dispatch/middleware/static.rb:63:in `call' railties (3.2.13.rc1) lib/rails/engine.rb:479:in `call' railties (3.2.13.rc1) lib/rails/application.rb:223:in `call' rack (1.4.5) lib/rack/content_length.rb:14:in `call' railties (3.2.13.rc1) lib/rails/rack/log_tailer.rb:17:in `call' rack (1.4.5) lib/rack/handler/webrick.rb:59:in `service' /usr/local/lib/ruby/1.9.1/webrick/httpserver.rb:138:in `service' /usr/local/lib/ruby/1.9.1/webrick/httpserver.rb:94:in `run' /usr/local/lib/ruby/1.9.1/webrick/server.rb:191:in `block in start_thread' Rendered /usr/local/lib/ruby/gems/1.9.1/gems/actionpack-3.2.13.rc1/lib/action_dispatch/middleware/templates/rescues/routing_error.erb within rescues/layout (2.8ms) Started GET "/kblog/" for 127.0.0.1 at 2013-03-03 20:27:37 +0100 ActionController::RoutingError (No route matches [GET] "/kblog"): actionpack (3.2.13.rc1) lib/action_dispatch/middleware/debug_exceptions.rb:21:in `call' actionpack (3.2.13.rc1) lib/action_dispatch/middleware/show_exceptions.rb:56:in `call' railties (3.2.13.rc1) lib/rails/rack/logger.rb:32:in `call_app' railties (3.2.13.rc1) lib/rails/rack/logger.rb:16:in `block in call' activesupport (3.2.13.rc1) lib/active_support/tagged_logging.rb:22:in `tagged' railties (3.2.13.rc1) lib/rails/rack/logger.rb:16:in `call' actionpack (3.2.13.rc1) lib/action_dispatch/middleware/request_id.rb:22:in `call' rack (1.4.5) lib/rack/methodoverride.rb:21:in `call' rack (1.4.5) lib/rack/runtime.rb:17:in `call' activesupport (3.2.13.rc1) lib/active_support/cache/strategy/local_cache.rb:72:in `call' rack (1.4.5) lib/rack/lock.rb:15:in `call' actionpack (3.2.13.rc1) lib/action_dispatch/middleware/static.rb:63:in `call' railties (3.2.13.rc1) lib/rails/engine.rb:479:in `call' railties (3.2.13.rc1) lib/rails/application.rb:223:in `call' rack (1.4.5) lib/rack/content_length.rb:14:in `call' railties (3.2.13.rc1) lib/rails/rack/log_tailer.rb:17:in `call' rack (1.4.5) lib/rack/handler/webrick.rb:59:in `service' /usr/local/lib/ruby/1.9.1/webrick/httpserver.rb:138:in `service' /usr/local/lib/ruby/1.9.1/webrick/httpserver.rb:94:in `run' /usr/local/lib/ruby/1.9.1/webrick/server.rb:191:in `block in start_thread' Rendered /usr/local/lib/ruby/gems/1.9.1/gems/actionpack-3.2.13.rc1/lib/action_dispatch/middleware/templates/rescues/routing_error.erb within rescues/layout (0.7ms) Connecting to database specified by database.yml Started GET "/kblog/new" for 127.0.0.1 at 2013-03-03 20:29:05 +0100 ActionController::RoutingError (No route matches [GET] "/kblog/new"): actionpack (3.2.13.rc1) lib/action_dispatch/middleware/debug_exceptions.rb:21:in `call' actionpack (3.2.13.rc1) lib/action_dispatch/middleware/show_exceptions.rb:56:in `call' railties (3.2.13.rc1) lib/rails/rack/logger.rb:32:in `call_app' railties (3.2.13.rc1) lib/rails/rack/logger.rb:16:in `block in call' activesupport (3.2.13.rc1) lib/active_support/tagged_logging.rb:22:in `tagged' railties (3.2.13.rc1) lib/rails/rack/logger.rb:16:in `call' actionpack (3.2.13.rc1) lib/action_dispatch/middleware/request_id.rb:22:in `call' rack (1.4.5) lib/rack/methodoverride.rb:21:in `call' rack (1.4.5) lib/rack/runtime.rb:17:in `call' activesupport (3.2.13.rc1) lib/active_support/cache/strategy/local_cache.rb:72:in `call' rack (1.4.5) lib/rack/lock.rb:15:in `call' actionpack (3.2.13.rc1) lib/action_dispatch/middleware/static.rb:63:in `call' railties (3.2.13.rc1) lib/rails/engine.rb:479:in `call' railties (3.2.13.rc1) lib/rails/application.rb:223:in `call' rack (1.4.5) lib/rack/content_length.rb:14:in `call' railties (3.2.13.rc1) lib/rails/rack/log_tailer.rb:17:in `call' rack (1.4.5) lib/rack/handler/webrick.rb:59:in `service' /usr/local/lib/ruby/1.9.1/webrick/httpserver.rb:138:in `service' /usr/local/lib/ruby/1.9.1/webrick/httpserver.rb:94:in `run' /usr/local/lib/ruby/1.9.1/webrick/server.rb:191:in `block in start_thread' Rendered /usr/local/lib/ruby/gems/1.9.1/gems/actionpack-3.2.13.rc1/lib/action_dispatch/middleware/templates/rescues/routing_error.erb within rescues/layout (2.2ms) Connecting to database specified by database.yml  (1.0ms) SELECT "schema_migrations"."version" FROM "schema_migrations"  Migrating to CreateKblogArticles (20130303192309)  (0.1ms) select sqlite_version(*)  (0.1ms) SELECT "schema_migrations"."version" FROM "schema_migrations"  Started GET "/kblog" for 127.0.0.1 at 2013-03-03 20:30:39 +0100 Processing by Kblog::ArticlesController#index as HTML Kblog::Article Load (0.1ms) SELECT "kblog_articles".* FROM "kblog_articles"  Rendered /home/erpe/devel/kblog/app/views/kblog/articles/index.html.erb within layouts/kblog/application (1.0ms) Compiled kblog/articles.css (28ms) (pid 4815) Compiled kblog/application.css (35ms) (pid 4815) Compiled jquery.js (2ms) (pid 4815) Compiled jquery_ujs.js (0ms) (pid 4815) Compiled kblog/articles.js (0ms) (pid 4815) Compiled kblog/application.js (88ms) (pid 4815) Completed 200 OK in 262ms (Views: 206.3ms | ActiveRecord: 1.8ms) Started GET "/assets/kblog/application.css?body=1" for 127.0.0.1 at 2013-03-03 20:30:40 +0100 Served asset /kblog/application.css - 304 Not Modified (4ms) Started GET "/assets/kblog/articles.css?body=1" for 127.0.0.1 at 2013-03-03 20:30:40 +0100 Served asset /kblog/articles.css - 304 Not Modified (3ms) Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2013-03-03 20:30:40 +0100 Served asset /jquery.js - 304 Not Modified (4ms) Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2013-03-03 20:30:40 +0100 Served asset /jquery_ujs.js - 304 Not Modified (1ms) Started GET "/assets/kblog/articles.js?body=1" for 127.0.0.1 at 2013-03-03 20:30:40 +0100 Served asset /kblog/articles.js - 304 Not Modified (1ms) Started GET "/assets/kblog/application.js?body=1" for 127.0.0.1 at 2013-03-03 20:30:40 +0100 Served asset /kblog/application.js - 304 Not Modified (5ms) Started GET "/kblog/articles/new" for 127.0.0.1 at 2013-03-03 20:30:42 +0100 Processing by Kblog::ArticlesController#new as HTML Rendered /home/erpe/devel/kblog/app/views/kblog/articles/_form.html.erb (33.2ms) Rendered /home/erpe/devel/kblog/app/views/kblog/articles/new.html.erb within layouts/kblog/application (60.2ms) Completed 200 OK in 74ms (Views: 68.5ms | ActiveRecord: 0.0ms) Started GET "/assets/kblog/application.css?body=1" for 127.0.0.1 at 2013-03-03 20:30:42 +0100 Served asset /kblog/application.css - 304 Not Modified (3ms) Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2013-03-03 20:30:42 +0100 Served asset /jquery.js - 304 Not Modified (1ms) Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2013-03-03 20:30:42 +0100 Served asset /jquery_ujs.js - 304 Not Modified (0ms) Started GET "/assets/kblog/articles.css?body=1" for 127.0.0.1 at 2013-03-03 20:30:42 +0100 Served asset /kblog/articles.css - 304 Not Modified (0ms) Started GET "/assets/kblog/articles.js?body=1" for 127.0.0.1 at 2013-03-03 20:30:42 +0100 Served asset /kblog/articles.js - 304 Not Modified (0ms) Started GET "/assets/kblog/application.js?body=1" for 127.0.0.1 at 2013-03-03 20:30:42 +0100 Served asset /kblog/application.js - 304 Not Modified (7ms) Started GET "/kblog" for 127.0.0.1 at 2013-03-03 20:31:24 +0100 Processing by Kblog::ArticlesController#index as HTML Kblog::Article Load (0.2ms) SELECT "kblog_articles".* FROM "kblog_articles" Rendered /home/erpe/devel/kblog/app/views/kblog/articles/index.html.erb within layouts/kblog/application (0.4ms) Completed 200 OK in 11ms (Views: 10.3ms | ActiveRecord: 0.2ms) Started GET "/assets/kblog/application.css?body=1" for 127.0.0.1 at 2013-03-03 20:31:24 +0100 Served asset /kblog/application.css - 304 Not Modified (0ms) Started GET "/assets/kblog/articles.css?body=1" for 127.0.0.1 at 2013-03-03 20:31:24 +0100 Served asset /kblog/articles.css - 304 Not Modified (3ms) Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2013-03-03 20:31:24 +0100 Served asset /jquery.js - 304 Not Modified (0ms) Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2013-03-03 20:31:24 +0100 Served asset /jquery_ujs.js - 304 Not Modified (0ms) Started GET "/assets/kblog/articles.js?body=1" for 127.0.0.1 at 2013-03-03 20:31:24 +0100 Served asset /kblog/articles.js - 304 Not Modified (0ms) Started GET "/assets/kblog/application.js?body=1" for 127.0.0.1 at 2013-03-03 20:31:24 +0100 Served asset /kblog/application.js - 304 Not Modified (1ms) Started GET "/kblog" for 127.0.0.1 at 2013-03-03 20:31:28 +0100 Processing by Kblog::ArticlesController#index as HTML Kblog::Article Load (0.4ms) SELECT "kblog_articles".* FROM "kblog_articles"  Rendered /home/erpe/devel/kblog/app/views/kblog/articles/index.html.erb within layouts/kblog/application (0.3ms) Completed 200 OK in 14ms (Views: 11.6ms | ActiveRecord: 0.4ms) Started GET "/assets/kblog/application.css?body=1" for 127.0.0.1 at 2013-03-03 20:31:28 +0100 Served asset /kblog/application.css - 304 Not Modified (0ms) Started GET "/assets/kblog/application.js?body=1" for 127.0.0.1 at 2013-03-03 20:31:28 +0100 Served asset /kblog/application.js - 304 Not Modified (7ms) Started GET "/assets/kblog/articles.js?body=1" for 127.0.0.1 at 2013-03-03 20:31:28 +0100 Served asset /kblog/articles.js - 304 Not Modified (0ms) Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2013-03-03 20:31:28 +0100 Served asset /jquery_ujs.js - 304 Not Modified (0ms) Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2013-03-03 20:31:28 +0100 Served asset /jquery.js - 304 Not Modified (1ms) Started GET "/assets/kblog/articles.css?body=1" for 127.0.0.1 at 2013-03-03 20:31:28 +0100 Served asset /kblog/articles.css - 304 Not Modified (0ms) Started GET "/kblog/articles/new" for 127.0.0.1 at 2013-03-03 20:31:31 +0100 Processing by Kblog::ArticlesController#new as HTML Rendered /home/erpe/devel/kblog/app/views/kblog/articles/_form.html.erb (1.9ms) Rendered /home/erpe/devel/kblog/app/views/kblog/articles/new.html.erb within layouts/kblog/application (2.9ms) Completed 200 OK in 44ms (Views: 43.7ms | ActiveRecord: 0.0ms) Started GET "/assets/kblog/application.css?body=1" for 127.0.0.1 at 2013-03-03 20:31:31 +0100 Served asset /kblog/application.css - 304 Not Modified (1ms) Started GET "/assets/kblog/articles.css?body=1" for 127.0.0.1 at 2013-03-03 20:31:31 +0100 Served asset /kblog/articles.css - 304 Not Modified (0ms) Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2013-03-03 20:31:31 +0100 Served asset /jquery_ujs.js - 304 Not Modified (0ms) Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2013-03-03 20:31:31 +0100 Served asset /jquery.js - 304 Not Modified (1ms) Started GET "/assets/kblog/articles.js?body=1" for 127.0.0.1 at 2013-03-03 20:31:31 +0100 Served asset /kblog/articles.js - 304 Not Modified (0ms) Started GET "/assets/kblog/application.js?body=1" for 127.0.0.1 at 2013-03-03 20:31:31 +0100 Served asset /kblog/application.js - 304 Not Modified (1ms) Started GET "/kblog/articles/new" for 127.0.0.1 at 2013-03-03 20:31:34 +0100 Processing by Kblog::ArticlesController#new as HTML Rendered /home/erpe/devel/kblog/app/views/kblog/articles/_form.html.erb (2.2ms) Rendered /home/erpe/devel/kblog/app/views/kblog/articles/new.html.erb within layouts/kblog/application (3.2ms) Completed 200 OK in 12ms (Views: 12.1ms | ActiveRecord: 0.0ms) Started GET "/assets/kblog/application.css?body=1" for 127.0.0.1 at 2013-03-03 20:31:34 +0100 Served asset /kblog/application.css - 304 Not Modified (0ms) Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2013-03-03 20:31:34 +0100 Served asset /jquery.js - 304 Not Modified (2ms) Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2013-03-03 20:31:34 +0100 Served asset /jquery_ujs.js - 304 Not Modified (0ms) Started GET "/assets/kblog/articles.css?body=1" for 127.0.0.1 at 2013-03-03 20:31:34 +0100 Served asset /kblog/articles.css - 304 Not Modified (0ms) Started GET "/assets/kblog/application.js?body=1" for 127.0.0.1 at 2013-03-03 20:31:34 +0100 Served asset /kblog/application.js - 304 Not Modified (1ms) Started GET "/assets/kblog/articles.js?body=1" for 127.0.0.1 at 2013-03-03 20:31:34 +0100 Served asset /kblog/articles.js - 304 Not Modified (0ms) Connecting to database specified by database.yml Started GET "/kblog/articles/new" for 127.0.0.1 at 2013-03-03 20:32:05 +0100 Processing by Kblog::ArticlesController#new as HTML Rendered /home/erpe/devel/kblog/app/views/kblog/articles/_form.html.erb (6.6ms) Rendered /home/erpe/devel/kblog/app/views/kblog/articles/new.html.erb within layouts/kblog/application (11.8ms) Completed 200 OK in 147ms (Views: 96.8ms | ActiveRecord: 1.6ms) Started GET "/assets/kblog/application.css?body=1" for 127.0.0.1 at 2013-03-03 20:32:05 +0100 Served asset /kblog/application.css - 304 Not Modified (8ms) Started GET "/assets/kblog/articles.js?body=1" for 127.0.0.1 at 2013-03-03 20:32:05 +0100 Served asset /kblog/articles.js - 304 Not Modified (1ms) Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2013-03-03 20:32:05 +0100 Served asset /jquery_ujs.js - 304 Not Modified (1ms) Started GET "/assets/kblog/application.js?body=1" for 127.0.0.1 at 2013-03-03 20:32:05 +0100 Served asset /kblog/application.js - 304 Not Modified (35ms) Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2013-03-03 20:32:05 +0100 Served asset /jquery.js - 304 Not Modified (3ms) Started GET "/assets/kblog/articles.css?body=1" for 127.0.0.1 at 2013-03-03 20:32:05 +0100 Served asset /kblog/articles.css - 304 Not Modified (2ms) Started GET "/kblog/articles" for 127.0.0.1 at 2013-03-03 20:32:07 +0100 Processing by Kblog::ArticlesController#index as HTML Kblog::Article Load (0.2ms) SELECT "kblog_articles".* FROM "kblog_articles"  Rendered /home/erpe/devel/kblog/app/views/kblog/articles/_article.html.erb (0.0ms) Rendered /home/erpe/devel/kblog/app/views/kblog/articles/index.html.erb within layouts/kblog/application (31.0ms) Completed 500 Internal Server Error in 34ms ActionView::Template::Error (undefined method `will_paginate' for #<#:0x00000001730e28>): 2:

KBlog

3: <%= render(:partial => 'article', :collection => @articles) %> 4: 7: