(114.7ms) CREATE TABLE "schema_migrations" ("version" varchar NOT NULL PRIMARY KEY)  (102.2ms) CREATE TABLE "ar_internal_metadata" ("key" varchar NOT NULL PRIMARY KEY, "value" varchar, "created_at" datetime NOT NULL, "updated_at" datetime NOT NULL) ActiveRecord::SchemaMigration Load (0.1ms) SELECT "schema_migrations".* FROM "schema_migrations" Migrating to CreatePosts (20161212004726)  (0.1ms) begin transaction  (0.3ms) CREATE TABLE "posts" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "title" varchar, "body" text, "created_at" datetime NOT NULL, "updated_at" datetime NOT NULL) SQL (0.1ms) INSERT INTO "schema_migrations" ("version") VALUES (?) [["version", "20161212004726"]]  (102.0ms) commit transaction ActiveRecord::InternalMetadata Load (0.3ms) SELECT "ar_internal_metadata".* FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = ? LIMIT ? [["key", :environment], ["LIMIT", 1]]  (0.3ms) begin transaction SQL (0.4ms) INSERT INTO "ar_internal_metadata" ("key", "value", "created_at", "updated_at") VALUES (?, ?, ?, ?) [["key", "environment"], ["value", "development"], ["created_at", 2016-12-12 14:58:52 UTC], ["updated_at", 2016-12-12 14:58:52 UTC]]  (81.5ms) commit transaction ActiveRecord::SchemaMigration Load (0.2ms) SELECT "schema_migrations".* FROM "schema_migrations" Started GET "/" for ::1 at 2016-12-12 23:58:55 +0900 ActiveRecord::SchemaMigration Load (0.1ms) SELECT "schema_migrations".* FROM "schema_migrations" Processing by Rails::WelcomeController#index as HTML Parameters: {"internal"=>true} Rendering /var/lib/gems/2.3.0/gems/railties-5.0.0.1/lib/rails/templates/rails/welcome/index.html.erb Rendered /var/lib/gems/2.3.0/gems/railties-5.0.0.1/lib/rails/templates/rails/welcome/index.html.erb (2.7ms) Completed 200 OK in 12ms (Views: 5.7ms | ActiveRecord: 0.0ms) Started GET "/posts" for ::1 at 2016-12-12 23:58:59 +0900 Processing by PostsController#index as HTML Completed 500 Internal Server Error in 5ms (ActiveRecord: 0.0ms) NoMethodError (undefined method `search' for PostsSearcher:Class): app/controllers/posts_controller.rb:7:in `index' Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/diagnostics.html.erb within rescues/layout Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_source.html.erb Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_source.html.erb (2.2ms) Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (1.0ms) Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (0.5ms) Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/diagnostics.html.erb within rescues/layout (17.5ms) Started GET "/posts" for ::1 at 2016-12-12 23:59:16 +0900 Processing by PostsController#index as HTML Completed 500 Internal Server Error in 5ms (ActiveRecord: 0.0ms) NoMethodError (private method `select' called for PostsSearcher:Class): app/controllers/posts_controller.rb:7:in `index' Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/diagnostics.html.erb within rescues/layout Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_source.html.erb Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_source.html.erb (5.7ms) Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (0.9ms) Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (0.4ms) Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/diagnostics.html.erb within rescues/layout (15.6ms) Started GET "/posts" for ::1 at 2016-12-13 00:01:34 +0900 Processing by PostsController#index as HTML Completed 500 Internal Server Error in 89ms (ActiveRecord: 0.0ms) Groonga::Client::Protocol::WrappedError (Failed to open TCP connection to 127.0.0.1:10041 (Connection refused - connect(2) for "127.0.0.1" port 10041)): app/controllers/posts_controller.rb:17:in `index' Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/diagnostics.html.erb within rescues/layout Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_source.html.erb Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_source.html.erb (4.5ms) Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (1.8ms) Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (0.5ms) Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/diagnostics.html.erb within rescues/layout (15.9ms) Started GET "/posts" for ::1 at 2016-12-13 00:01:44 +0900 Processing by PostsController#index as HTML Completed 500 Internal Server Error in 3ms (ActiveRecord: 0.0ms) Groonga::Client::Request::ErrorResponse (failed to execute: select: -22: <[select][table] invalid name: >): app/controllers/posts_controller.rb:17:in `index' Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/diagnostics.html.erb within rescues/layout Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_source.html.erb Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_source.html.erb (2.1ms) Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (1.2ms) Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (0.5ms) Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/diagnostics.html.erb within rescues/layout (12.5ms) Started GET "/posts" for ::1 at 2016-12-13 00:01:45 +0900 Processing by PostsController#index as HTML Completed 500 Internal Server Error in 6ms (ActiveRecord: 0.0ms) Groonga::Client::Request::ErrorResponse (failed to execute: select: -22: <[select][table] invalid name: >): app/controllers/posts_controller.rb:17:in `index' Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/diagnostics.html.erb within rescues/layout Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_source.html.erb Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_source.html.erb (2.0ms) Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (1.5ms) Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (0.5ms) Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/diagnostics.html.erb within rescues/layout (13.1ms) Post Load (0.1ms) SELECT "posts".* FROM "posts" ORDER BY "posts"."id" ASC LIMIT ? [["LIMIT", 1000]] Post Load (0.3ms) SELECT "posts".* FROM "posts" ORDER BY "posts"."id" ASC LIMIT ? [["LIMIT", 1000]] Started GET "/posts" for ::1 at 2016-12-13 00:02:06 +0900 ActiveRecord::SchemaMigration Load (0.1ms) SELECT "schema_migrations".* FROM "schema_migrations" Processing by PostsController#index as HTML Rendering posts/index.html.erb within layouts/application Rendered posts/index.html.erb within layouts/application (4.3ms) Completed 500 Internal Server Error in 17ms (ActiveRecord: 0.0ms) ActionView::Template::Error (undefined method `each' for #): 12: 13: 14: 15: <% @result_set.each do |record| %> 16: <% post = record.souce %> 17: 18: <%= post.title %> app/views/posts/index.html.erb:15:in `_app_views_posts_index_html_erb___67860871454373141_47176851818460' Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/template_error.html.erb within rescues/layout Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_source.html.erb Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_source.html.erb (2.6ms) Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (1.2ms) Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (0.4ms) Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/template_error.html.erb within rescues/layout (15.4ms) Started GET "/posts" for ::1 at 2016-12-13 00:02:09 +0900 Processing by PostsController#index as HTML Rendering posts/index.html.erb within layouts/application Rendered posts/index.html.erb within layouts/application (2.0ms) Completed 500 Internal Server Error in 7ms (ActiveRecord: 0.0ms) ActionView::Template::Error (undefined method `each' for #): 12: 13: 14: 15: <% @result_set.each do |record| %> 16: <% post = record.souce %> 17: 18: <%= post.title %> app/views/posts/index.html.erb:15:in `_app_views_posts_index_html_erb___67860871454373141_47176868584280' Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/template_error.html.erb within rescues/layout Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_source.html.erb Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_source.html.erb (2.5ms) Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (1.0ms) Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (0.5ms) Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/template_error.html.erb within rescues/layout (12.8ms) Started GET "/posts" for ::1 at 2016-12-13 00:02:47 +0900 Processing by PostsController#index as HTML Rendering posts/index.html.erb within layouts/application Rendered posts/index.html.erb within layouts/application (0.7ms) Completed 200 OK in 705ms (Views: 702.3ms | ActiveRecord: 0.0ms) Started GET "/posts/new" for ::1 at 2016-12-13 00:02:53 +0900 Processing by PostsController#new as HTML Rendering posts/new.html.erb within layouts/application Rendered posts/_form.html.erb (84.5ms) Rendered posts/new.html.erb within layouts/application (85.8ms) Completed 200 OK in 120ms (Views: 113.4ms | ActiveRecord: 0.5ms) Started POST "/posts" for ::1 at 2016-12-13 00:03:03 +0900 Processing by PostsController#create as HTML Parameters: {"utf8"=>"✓", "authenticity_token"=>"BgzdF9cB4nTMHci4myra91sTYnAYGB0Sf29OWTwQl78koVVQdceO60H8BhGR72e+RufhaBA/Ebgf46scIfJ5pA==", "post"=>{"title"=>"こんにちは!", "body"=>"私の名前は中野です。"}, "commit"=>"Create Post"}  (0.6ms) begin transaction SQL (2.2ms) INSERT INTO "posts" ("title", "body", "created_at", "updated_at") VALUES (?, ?, ?, ?) [["title", "こんにちは!"], ["body", "私の名前は中野です。"], ["created_at", 2016-12-12 15:03:03 UTC], ["updated_at", 2016-12-12 15:03:03 UTC]]  (117.3ms) commit transaction Redirected to http://localhost:3000/posts/1 Completed 302 Found in 137ms (ActiveRecord: 120.1ms) Started GET "/posts/1" for ::1 at 2016-12-13 00:03:03 +0900 Processing by PostsController#show as HTML Parameters: {"id"=>"1"} Post Load (0.2ms) SELECT "posts".* FROM "posts" WHERE "posts"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendering posts/show.html.erb within layouts/application Rendered posts/show.html.erb within layouts/application (0.7ms) Completed 200 OK in 26ms (Views: 14.0ms | ActiveRecord: 0.2ms) Started GET "/posts" for ::1 at 2016-12-13 00:03:10 +0900 Processing by PostsController#index as HTML Rendering posts/index.html.erb within layouts/application Rendered posts/index.html.erb within layouts/application (3.5ms) Completed 500 Internal Server Error in 9ms (ActiveRecord: 0.0ms) ActionView::Template::Error (undefined method `souce' for #): 13: 14: 15: <% @result_set.records.each do |record| %> 16: <% post = record.souce %> 17: 18: <%= post.title %> 19: <%= post.body %> app/views/posts/index.html.erb:16:in `block in _app_views_posts_index_html_erb___67860871454373141_70304086711920' app/views/posts/index.html.erb:15:in `each' app/views/posts/index.html.erb:15:in `_app_views_posts_index_html_erb___67860871454373141_70304086711920' Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/template_error.html.erb within rescues/layout Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_source.html.erb Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_source.html.erb (2.8ms) Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (1.3ms) Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (0.5ms) Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/template_error.html.erb within rescues/layout (13.2ms) Started GET "/posts" for ::1 at 2016-12-13 00:03:16 +0900 Processing by PostsController#index as HTML Rendering posts/index.html.erb within layouts/application Rendered posts/index.html.erb within layouts/application (3.6ms) Completed 500 Internal Server Error in 8ms (ActiveRecord: 0.0ms) ActionView::Template::Error (undefined method `source' for # Did you mean? store): 13: 14: 15: <% @result_set.records.each do |record| %> 16: <% post = record.source %> 17: 18: <%= post.title %> 19: <%= post.body %> app/views/posts/index.html.erb:16:in `block in _app_views_posts_index_html_erb___67860871454373141_47176863087720' app/views/posts/index.html.erb:15:in `each' app/views/posts/index.html.erb:15:in `_app_views_posts_index_html_erb___67860871454373141_47176863087720' Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/template_error.html.erb within rescues/layout Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_source.html.erb Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_source.html.erb (2.8ms) Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (1.1ms) Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (0.4ms) Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/template_error.html.erb within rescues/layout (13.6ms) Started GET "/posts" for ::1 at 2016-12-13 00:04:22 +0900 Processing by PostsController#index as HTML Rendering posts/index.html.erb within layouts/application Rendered posts/index.html.erb within layouts/application (1.8ms) Completed 500 Internal Server Error in 12ms (ActiveRecord: 0.0ms) SyntaxError (/home/kou/work/ruby/groonga-client-rails/test/apps/rails5-activerecord/app/views/posts/index.html.erb:16: syntax error, unexpected '.'): app/views/posts/index.html.erb:16: syntax error, unexpected '.' Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/diagnostics.html.erb within rescues/layout Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_source.html.erb Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_source.html.erb (2.9ms) Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (1.2ms) Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (0.4ms) Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/diagnostics.html.erb within rescues/layout (13.4ms) Started GET "/posts" for ::1 at 2016-12-13 00:04:27 +0900 Processing by PostsController#index as HTML Rendering posts/index.html.erb within layouts/application Rendered posts/index.html.erb within layouts/application (4.3ms) Completed 500 Internal Server Error in 8ms (ActiveRecord: 0.0ms) ActionView::Template::Error (undefined method `source' for # Did you mean? store): 14: 15: <% @result_set.records.each do |record| %> 16: <% p record %> 17: <% post = record.source %> 18: 19: <%= post.title %> 20: <%= post.body %> app/views/posts/index.html.erb:17:in `block in _app_views_posts_index_html_erb___67860871454373141_47176868444140' app/views/posts/index.html.erb:15:in `each' app/views/posts/index.html.erb:15:in `_app_views_posts_index_html_erb___67860871454373141_47176868444140' Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/template_error.html.erb within rescues/layout Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_source.html.erb Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_source.html.erb (3.2ms) Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (1.2ms) Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (0.4ms) Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/template_error.html.erb within rescues/layout (13.7ms) Started GET "/posts" for ::1 at 2016-12-13 00:05:03 +0900 Processing by PostsController#index as HTML Rendering posts/index.html.erb within layouts/application Post Load (0.2ms) SELECT "posts".* FROM "posts" WHERE "posts"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendered posts/index.html.erb within layouts/application (3.0ms) Completed 200 OK in 20ms (Views: 16.5ms | ActiveRecord: 0.2ms) Started GET "/posts" for ::1 at 2016-12-13 00:06:01 +0900 Processing by PostsController#index as HTML Rendering posts/index.html.erb within layouts/application Rendered posts/index.html.erb within layouts/application (9.1ms) Completed 500 Internal Server Error in 20ms (ActiveRecord: 0.0ms) ActionView::Template::Error (undefined method `source' for # Did you mean? store): 13: 14: 15: <% @result_set.records.each do |record| %> 16: <% post = record.source %> 17: 18: <%= post.title %> 19: <%= post.body %> app/views/posts/index.html.erb:16:in `block in _app_views_posts_index_html_erb___67860871454373141_47176870733640' app/views/posts/index.html.erb:15:in `each' app/views/posts/index.html.erb:15:in `_app_views_posts_index_html_erb___67860871454373141_47176870733640' Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/template_error.html.erb within rescues/layout Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_source.html.erb Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_source.html.erb (2.5ms) Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (1.1ms) Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (0.4ms) Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/template_error.html.erb within rescues/layout (12.9ms) Started GET "/posts" for ::1 at 2016-12-13 00:06:09 +0900 ActiveRecord::SchemaMigration Load (0.1ms) SELECT "schema_migrations".* FROM "schema_migrations" Processing by PostsController#index as HTML Post Load (0.1ms) SELECT "posts".* FROM "posts" WHERE "posts"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendering posts/index.html.erb within layouts/application Rendered posts/index.html.erb within layouts/application (4.9ms) Completed 200 OK in 164ms (Views: 145.6ms | ActiveRecord: 0.6ms) Started GET "/posts" for ::1 at 2016-12-13 00:07:04 +0900 Processing by PostsController#index as HTML Post Load (0.3ms) SELECT "posts".* FROM "posts" WHERE "posts"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendering posts/index.html.erb within layouts/application Rendered posts/index.html.erb within layouts/application (0.7ms) Completed 200 OK in 13ms (Views: 10.4ms | ActiveRecord: 0.3ms) Started GET "/posts" for ::1 at 2016-12-13 00:16:17 +0900 ActiveRecord::SchemaMigration Load (0.1ms) SELECT "schema_migrations".* FROM "schema_migrations" Processing by PostsController#index as HTML Post Load (0.1ms) SELECT "posts".* FROM "posts" WHERE "posts"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendering posts/index.html.erb within layouts/application Rendered posts/index.html.erb within layouts/application (5.5ms) Completed 200 OK in 162ms (Views: 143.7ms | ActiveRecord: 0.4ms) Started GET "/posts?query=%E4%B8%AD%E9%87%8E" for ::1 at 2016-12-13 00:16:22 +0900 Processing by PostsController#index as HTML Parameters: {"query"=>"中野"} Post Load (0.3ms) SELECT "posts".* FROM "posts" WHERE "posts"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendering posts/index.html.erb within layouts/application Rendered posts/index.html.erb within layouts/application (0.7ms) Completed 200 OK in 42ms (Views: 10.2ms | ActiveRecord: 0.3ms) Started GET "/posts?query=%E4%B8%AD%E9%87%8E" for ::1 at 2016-12-13 00:16:36 +0900 Processing by PostsController#index as HTML Parameters: {"query"=>"中野"} Post Load (0.2ms) SELECT "posts".* FROM "posts" WHERE "posts"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendering posts/index.html.erb within layouts/application Rendered posts/index.html.erb within layouts/application (1.3ms) Completed 200 OK in 32ms (Views: 18.1ms | ActiveRecord: 1.3ms) Started GET "/posts?query=%E4%B8%AD%E9%87%8E" for ::1 at 2016-12-13 00:16:46 +0900 Processing by PostsController#index as HTML Parameters: {"query"=>"中野"} Post Load (0.1ms) SELECT "posts".* FROM "posts" WHERE "posts"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendering posts/index.html.erb within layouts/application Rendered posts/index.html.erb within layouts/application (1.1ms) Completed 200 OK in 25ms (Views: 13.3ms | ActiveRecord: 0.9ms) Started GET "/.mypage" for ::1 at 2016-12-21 17:14:53 +0900 ActiveRecord::SchemaMigration Load (0.1ms) SELECT "schema_migrations".* FROM "schema_migrations" ActionController::RoutingError (No route matches [GET] "/.mypage"): actionpack (5.0.0.1) lib/action_dispatch/middleware/debug_exceptions.rb:53:in `call' web-console (3.4.0) lib/web_console/middleware.rb:135:in `call_app' web-console (3.4.0) lib/web_console/middleware.rb:28:in `block in call' web-console (3.4.0) lib/web_console/middleware.rb:18:in `catch' web-console (3.4.0) lib/web_console/middleware.rb:18:in `call' actionpack (5.0.0.1) lib/action_dispatch/middleware/show_exceptions.rb:31:in `call' railties (5.0.0.1) lib/rails/rack/logger.rb:36:in `call_app' railties (5.0.0.1) lib/rails/rack/logger.rb:24:in `block in call' activesupport (5.0.0.1) lib/active_support/tagged_logging.rb:70:in `block in tagged' activesupport (5.0.0.1) lib/active_support/tagged_logging.rb:26:in `tagged' activesupport (5.0.0.1) lib/active_support/tagged_logging.rb:70:in `tagged' railties (5.0.0.1) lib/rails/rack/logger.rb:24:in `call' sprockets-rails (3.2.0) lib/sprockets/rails/quiet_assets.rb:13:in `call' actionpack (5.0.0.1) lib/action_dispatch/middleware/request_id.rb:24:in `call' rack (2.0.1) lib/rack/method_override.rb:22:in `call' rack (2.0.1) lib/rack/runtime.rb:22:in `call' activesupport (5.0.0.1) lib/active_support/cache/strategy/local_cache_middleware.rb:28:in `call' actionpack (5.0.0.1) lib/action_dispatch/middleware/executor.rb:12:in `call' actionpack (5.0.0.1) lib/action_dispatch/middleware/static.rb:136:in `call' rack (2.0.1) lib/rack/sendfile.rb:111:in `call' railties (5.0.0.1) lib/rails/engine.rb:522:in `call' puma (3.6.2) lib/puma/configuration.rb:225:in `call' puma (3.6.2) lib/puma/server.rb:578:in `handle_request' puma (3.6.2) lib/puma/server.rb:415:in `process_client' puma (3.6.2) lib/puma/server.rb:275:in `block in run' puma (3.6.2) lib/puma/thread_pool.rb:116:in `block in spawn_thread' Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/routing_error.html.erb within rescues/layout Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (3.9ms) Rendered collection of /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/routes/_route.html.erb [8 times] (5.5ms) Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/routes/_table.html.erb (18.6ms) Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (9.1ms) Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/routing_error.html.erb within rescues/layout (84.0ms) Started GET "/" for ::1 at 2016-12-21 17:28:57 +0900 Processing by Rails::WelcomeController#index as HTML Parameters: {"internal"=>true} Rendering /var/lib/gems/2.3.0/gems/railties-5.0.0.1/lib/rails/templates/rails/welcome/index.html.erb Rendered /var/lib/gems/2.3.0/gems/railties-5.0.0.1/lib/rails/templates/rails/welcome/index.html.erb (5.4ms) Completed 200 OK in 20ms (Views: 7.2ms | ActiveRecord: 0.0ms) Started GET "/posts" for ::1 at 2016-12-21 17:29:03 +0900 Processing by PostsController#index as HTML Completed 500 Internal Server Error in 5ms (ActiveRecord: 0.0ms) Groonga::Client::Request::ErrorResponse (failed to execute: select: -22: <[select][table] invalid name: >): app/controllers/posts_controller.rb:24:in `index' Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/diagnostics.html.erb within rescues/layout Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_source.html.erb Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_source.html.erb (2.2ms) Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (1.0ms) Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (0.4ms) Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/diagnostics.html.erb within rescues/layout (12.9ms) Post Load (0.1ms) SELECT "posts".* FROM "posts" ORDER BY "posts"."id" ASC LIMIT ? [["LIMIT", 1000]] Started GET "/posts" for ::1 at 2016-12-21 17:29:21 +0900 Processing by PostsController#index as HTML Post Load (0.2ms) SELECT "posts".* FROM "posts" WHERE "posts"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendering posts/index.html.erb within layouts/application Rendered posts/index.html.erb within layouts/application (1.4ms) Completed 200 OK in 261ms (Views: 232.8ms | ActiveRecord: 1.5ms) Started GET "/posts?query=%E4%B8%AD%E9%87%8E" for ::1 at 2016-12-21 17:29:27 +0900 Processing by PostsController#index as HTML Parameters: {"query"=>"中野"} Post Load (0.3ms) SELECT "posts".* FROM "posts" WHERE "posts"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendering posts/index.html.erb within layouts/application Rendered posts/index.html.erb within layouts/application (3.3ms) Completed 200 OK in 28ms (Views: 24.4ms | ActiveRecord: 0.3ms) Started GET "/posts?query=%E3%81%93%E3%82%93" for ::1 at 2016-12-21 17:29:34 +0900 Processing by PostsController#index as HTML Parameters: {"query"=>"こん"} Post Load (0.1ms) SELECT "posts".* FROM "posts" WHERE "posts"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendering posts/index.html.erb within layouts/application Rendered posts/index.html.erb within layouts/application (1.7ms) Completed 200 OK in 43ms (Views: 38.4ms | ActiveRecord: 0.1ms) Started GET "/posts?query=%E3%81%93%E3%82%93" for ::1 at 2016-12-21 17:30:31 +0900 Processing by PostsController#index as HTML Parameters: {"query"=>"こん"} Post Load (0.7ms) SELECT "posts".* FROM "posts" WHERE "posts"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendering posts/index.html.erb within layouts/application Rendered posts/index.html.erb within layouts/application (2.7ms) Completed 200 OK in 72ms (Views: 63.0ms | ActiveRecord: 0.7ms) Started GET "/posts?query=%E3%81%93%E3%82%93" for ::1 at 2016-12-21 17:30:32 +0900 Processing by PostsController#index as HTML Parameters: {"query"=>"こん"} Post Load (0.1ms) SELECT "posts".* FROM "posts" WHERE "posts"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendering posts/index.html.erb within layouts/application Rendered posts/index.html.erb within layouts/application (0.7ms) Completed 200 OK in 14ms (Views: 9.9ms | ActiveRecord: 0.1ms) Started GET "/posts?query=%E3%81%93%E3%82%93" for ::1 at 2016-12-21 17:31:01 +0900 Processing by PostsController#index as HTML Parameters: {"query"=>"こん"} Post Load (0.1ms) SELECT "posts".* FROM "posts" WHERE "posts"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendering posts/index.html.erb within layouts/application Rendered posts/index.html.erb within layouts/application (1.0ms) Completed 200 OK in 22ms (Views: 12.6ms | ActiveRecord: 0.9ms) Started GET "/posts?query=%E3%81%93%E3%82%93" for ::1 at 2016-12-21 17:31:21 +0900 Processing by PostsController#index as HTML Parameters: {"query"=>"こん"} Post Load (0.6ms) SELECT "posts".* FROM "posts" WHERE "posts"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendering posts/index.html.erb within layouts/application Rendered posts/index.html.erb within layouts/application (2.3ms) Completed 200 OK in 32ms (Views: 23.9ms | ActiveRecord: 0.6ms) Started GET "/posts?query=%E3%81%93%E3%82%93" for ::1 at 2016-12-21 17:31:26 +0900 Processing by PostsController#index as HTML Parameters: {"query"=>"こん"} Post Load (0.1ms) SELECT "posts".* FROM "posts" WHERE "posts"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendering posts/index.html.erb within layouts/application Rendered posts/index.html.erb within layouts/application (1.0ms) Completed 200 OK in 17ms (Views: 13.8ms | ActiveRecord: 0.1ms) Started GET "/posts?query=%E3%81%93%E3%82%93" for ::1 at 2016-12-21 17:32:17 +0900 Processing by PostsController#index as HTML Parameters: {"query"=>"こん"} Post Load (0.4ms) SELECT "posts".* FROM "posts" WHERE "posts"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendering posts/index.html.erb within layouts/application Rendered posts/index.html.erb within layouts/application (2.8ms) Completed 200 OK in 42ms (Views: 31.7ms | ActiveRecord: 0.4ms) Started GET "/posts?query=%E4%B8%AD%E9%87%8E" for ::1 at 2016-12-21 17:32:22 +0900 Processing by PostsController#index as HTML Parameters: {"query"=>"中野"} Post Load (0.4ms) SELECT "posts".* FROM "posts" WHERE "posts"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendering posts/index.html.erb within layouts/application Rendered posts/index.html.erb within layouts/application (1.1ms) Completed 200 OK in 23ms (Views: 17.5ms | ActiveRecord: 0.4ms) Started GET "/posts?query=%E4%B8%AD%E9%87%8E" for ::1 at 2016-12-21 17:32:38 +0900 Processing by PostsController#index as HTML Parameters: {"query"=>"中野"} Post Load (0.2ms) SELECT "posts".* FROM "posts" WHERE "posts"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendering posts/index.html.erb within layouts/application Rendered posts/index.html.erb within layouts/application (107.8ms) Completed 500 Internal Server Error in 113ms (ActiveRecord: 0.2ms) ActionView::Template::Error (undefined local variable or method `documents_path' for #<#:0x007f6115d16d70>): 4: 5:

<%= @result_set.n_hits %> records

6: 7: <%= form_tag(documents_path, method: "get") do %> 8: <%= search_field_tag "query", params["query"] %> 9: <%= submit_tag "Search" %> 10: <% end %> app/views/posts/index.html.erb:7:in `_app_views_posts_index_html_erb___1020311010432945652_70027477302640' Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/template_error.html.erb within rescues/layout Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_source.html.erb Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_source.html.erb (2.8ms) Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (1.3ms) Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (0.6ms) Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/template_error.html.erb within rescues/layout (14.3ms) Started GET "/posts?query=%E4%B8%AD%E9%87%8E" for ::1 at 2016-12-21 17:32:44 +0900 Processing by PostsController#index as HTML Parameters: {"query"=>"中野"} Post Load (0.6ms) SELECT "posts".* FROM "posts" WHERE "posts"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendering posts/index.html.erb within layouts/application Rendered posts/index.html.erb within layouts/application (4.0ms) Completed 200 OK in 28ms (Views: 22.5ms | ActiveRecord: 0.6ms) Started GET "/posts?utf8=%E2%9C%93&query=%E3%81%93%E3%82%93%E3%81%AB%E3%81%A1%E3%81%AF&commit=Search" for ::1 at 2016-12-21 17:32:52 +0900 Processing by PostsController#index as HTML Parameters: {"utf8"=>"✓", "query"=>"こんにちは", "commit"=>"Search"} Post Load (0.4ms) SELECT "posts".* FROM "posts" WHERE "posts"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendering posts/index.html.erb within layouts/application Rendered posts/index.html.erb within layouts/application (3.1ms) Completed 200 OK in 24ms (Views: 19.5ms | ActiveRecord: 0.4ms) Started GET "/posts?utf8=%E2%9C%93&query=%E3%81%93%E3%82%93%E3%81%AB%E3%81%A1%E3%81%AF&commit=Search" for ::1 at 2016-12-21 17:35:46 +0900 ActiveRecord::SchemaMigration Load (0.1ms) SELECT "schema_migrations".* FROM "schema_migrations" Processing by PostsController#index as HTML Parameters: {"utf8"=>"✓", "query"=>"こんにちは", "commit"=>"Search"} Post Load (0.1ms) SELECT "posts".* FROM "posts" WHERE "posts"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendering posts/index.html.erb within layouts/application Rendered posts/index.html.erb within layouts/application (28.1ms) Completed 200 OK in 193ms (Views: 173.2ms | ActiveRecord: 0.4ms) Started GET "/posts/new" for ::1 at 2016-12-21 17:36:04 +0900 Processing by PostsController#new as HTML Rendering posts/new.html.erb within layouts/application Rendered posts/_form.html.erb (13.6ms) Rendered posts/new.html.erb within layouts/application (14.8ms) Completed 200 OK in 30ms (Views: 28.9ms | ActiveRecord: 0.0ms) Started POST "/posts" for ::1 at 2016-12-21 17:36:12 +0900 Processing by PostsController#create as HTML Parameters: {"utf8"=>"✓", "authenticity_token"=>"sgEaqDJlGxYQtWogks7t+zsRTU9rccgEgTavdP7I0iDeyzXrpdWqw+XRI9uLupMy2amGftPLS4G9tukzkHz98g==", "post"=>{"title"=>"ふふふ", "body"=>"どうでしょう!"}, "commit"=>"Create Post"}  (0.3ms) begin transaction SQL (0.2ms) INSERT INTO "posts" ("title", "body", "created_at", "updated_at") VALUES (?, ?, ?, ?) [["title", "ふふふ"], ["body", "どうでしょう!"], ["created_at", 2016-12-21 08:36:12 UTC], ["updated_at", 2016-12-21 08:36:12 UTC]]  (164.6ms) commit transaction Redirected to http://localhost:3000/posts/2 Completed 302 Found in 171ms (ActiveRecord: 165.1ms) Started GET "/posts/2" for ::1 at 2016-12-21 17:36:12 +0900 Processing by PostsController#show as HTML Parameters: {"id"=>"2"} Post Load (0.2ms) SELECT "posts".* FROM "posts" WHERE "posts"."id" = ? LIMIT ? [["id", 2], ["LIMIT", 1]] Rendering posts/show.html.erb within layouts/application Rendered posts/show.html.erb within layouts/application (0.6ms) Completed 200 OK in 14ms (Views: 10.9ms | ActiveRecord: 0.2ms) Started GET "/posts/2/edit" for ::1 at 2016-12-21 17:36:14 +0900 Processing by PostsController#edit as HTML Parameters: {"id"=>"2"} Post Load (0.1ms) SELECT "posts".* FROM "posts" WHERE "posts"."id" = ? LIMIT ? [["id", 2], ["LIMIT", 1]] Rendering posts/edit.html.erb within layouts/application Rendered posts/_form.html.erb (1.8ms) Rendered posts/edit.html.erb within layouts/application (3.0ms) Completed 200 OK in 18ms (Views: 16.3ms | ActiveRecord: 0.1ms) Started GET "/posts" for ::1 at 2016-12-21 17:36:15 +0900 Processing by PostsController#index as HTML Post Load (0.4ms) SELECT "posts".* FROM "posts" WHERE "posts"."id" IN (2, 1) Rendering posts/index.html.erb within layouts/application Rendered posts/index.html.erb within layouts/application (3.2ms) Completed 200 OK in 20ms (Views: 14.7ms | ActiveRecord: 0.4ms) Started GET "/posts" for ::1 at 2016-12-21 17:36:25 +0900 Processing by PostsController#index as HTML Completed 500 Internal Server Error in 2ms (ActiveRecord: 0.0ms) ArgumentError (wrong number of arguments (given 2, expected 1)): app/controllers/posts_controller.rb:24:in `index' Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/diagnostics.html.erb within rescues/layout Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_source.html.erb Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_source.html.erb (2.2ms) Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (1.2ms) Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (0.5ms) Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/diagnostics.html.erb within rescues/layout (13.8ms) Started GET "/posts" for ::1 at 2016-12-21 17:36:29 +0900 Processing by PostsController#index as HTML Completed 500 Internal Server Error in 5ms (ActiveRecord: 0.0ms) ArgumentError (unknown keyword: limit): app/controllers/posts_controller.rb:24:in `index' Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/diagnostics.html.erb within rescues/layout Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_source.html.erb Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_source.html.erb (3.7ms) Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (1.7ms) Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (0.8ms) Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/diagnostics.html.erb within rescues/layout (17.2ms) Started GET "/posts" for ::1 at 2016-12-21 17:36:33 +0900 Processing by PostsController#index as HTML Post Load (0.1ms) SELECT "posts".* FROM "posts" WHERE "posts"."id" = ? LIMIT ? [["id", 2], ["LIMIT", 1]] Rendering posts/index.html.erb within layouts/application Rendered posts/index.html.erb within layouts/application (19.1ms) Completed 200 OK in 47ms (Views: 33.7ms | ActiveRecord: 1.1ms) Started GET "/posts?page=2" for ::1 at 2016-12-21 17:36:38 +0900 Processing by PostsController#index as HTML Parameters: {"page"=>"2"} Post Load (0.2ms) SELECT "posts".* FROM "posts" WHERE "posts"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendering posts/index.html.erb within layouts/application Rendered posts/index.html.erb within layouts/application (40.6ms) Completed 200 OK in 63ms (Views: 59.3ms | ActiveRecord: 0.2ms) Started GET "/posts" for ::1 at 2016-12-21 17:36:40 +0900 Processing by PostsController#index as HTML Post Load (0.4ms) SELECT "posts".* FROM "posts" WHERE "posts"."id" = ? LIMIT ? [["id", 2], ["LIMIT", 1]] Rendering posts/index.html.erb within layouts/application Rendered posts/index.html.erb within layouts/application (7.4ms) Completed 200 OK in 24ms (Views: 20.7ms | ActiveRecord: 0.4ms) Started GET "/posts" for ::1 at 2016-12-21 17:37:03 +0900 Processing by PostsController#index as HTML Post Load (0.2ms) SELECT "posts".* FROM "posts" WHERE "posts"."id" IN (2, 1) Rendering posts/index.html.erb within layouts/application Rendered posts/index.html.erb within layouts/application (60.4ms) Completed 500 Internal Server Error in 73ms (ActiveRecord: 1.0ms) ActionView::Template::Error (undefined method `page_info' for #<#:0x007fca6cca9ae8>): 3:

Posts

4: 5:

<%= @result_set.n_hits %> records

6: <%= page_info(@result_set) %> 7: 8: <%= form_tag(posts_path, method: "get") do %> 9: <%= search_field_tag "query", params["query"] %> app/views/posts/index.html.erb:6:in `_app_views_posts_index_html_erb___345720712053629378_70253692700580' Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/template_error.html.erb within rescues/layout Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_source.html.erb Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_source.html.erb (2.5ms) Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (1.2ms) Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (0.4ms) Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/template_error.html.erb within rescues/layout (12.9ms) Started GET "/posts" for ::1 at 2016-12-21 17:37:49 +0900 Processing by PostsController#index as HTML Post Load (0.3ms) SELECT "posts".* FROM "posts" WHERE "posts"."id" IN (2, 1) Rendering posts/index.html.erb within layouts/application Rendered posts/index.html.erb within layouts/application (5.7ms) Completed 500 Internal Server Error in 13ms (ActiveRecord: 0.3ms) ActionView::Template::Error (undefined method `entry_name' for # Did you mean? entries): 3:

Posts

4: 5:

<%= @result_set.n_hits %> records

6: <%= page_entries_info(@result_set) %> 7: 8: <%= form_tag(posts_path, method: "get") do %> 9: <%= search_field_tag "query", params["query"] %> app/views/posts/index.html.erb:6:in `_app_views_posts_index_html_erb___345720712053629378_70253702938020' Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/template_error.html.erb within rescues/layout Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_source.html.erb Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_source.html.erb (9.1ms) Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (1.4ms) Rendering /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (0.4ms) Rendered /var/lib/gems/2.3.0/gems/actionpack-5.0.0.1/lib/action_dispatch/middleware/templates/rescues/template_error.html.erb within rescues/layout (20.4ms) Started GET "/posts" for ::1 at 2016-12-21 17:38:04 +0900 Processing by PostsController#index as HTML Post Load (0.3ms) SELECT "posts".* FROM "posts" WHERE "posts"."id" IN (2, 1) Rendering posts/index.html.erb within layouts/application Rendered posts/index.html.erb within layouts/application (3.3ms) Completed 200 OK in 17ms (Views: 13.9ms | ActiveRecord: 0.3ms) Started GET "/posts" for ::1 at 2016-12-21 17:38:13 +0900 Processing by PostsController#index as HTML Post Load (0.4ms) SELECT "posts".* FROM "posts" WHERE "posts"."id" IN (2, 1) Rendering posts/index.html.erb within layouts/application Rendered posts/index.html.erb within layouts/application (5.9ms) Completed 200 OK in 31ms (Views: 23.6ms | ActiveRecord: 0.4ms) Started GET "/posts" for ::1 at 2016-12-21 17:38:19 +0900 Processing by PostsController#index as HTML Post Load (0.9ms) SELECT "posts".* FROM "posts" WHERE "posts"."id" IN (2, 1) Rendering posts/index.html.erb within layouts/application Rendered posts/index.html.erb within layouts/application (6.2ms) Completed 200 OK in 37ms (Views: 28.1ms | ActiveRecord: 0.9ms) Started GET "/posts" for ::1 at 2016-12-21 17:38:53 +0900 Processing by PostsController#index as HTML Post Load (0.1ms) SELECT "posts".* FROM "posts" WHERE "posts"."id" IN (2, 1) Rendering posts/index.html.erb within layouts/application Rendered posts/index.html.erb within layouts/application (3.8ms) Completed 200 OK in 29ms (Views: 17.2ms | ActiveRecord: 0.6ms) Started GET "/posts" for ::1 at 2016-12-21 17:39:00 +0900 Processing by PostsController#index as HTML Post Load (0.2ms) SELECT "posts".* FROM "posts" WHERE "posts"."id" IN (2, 1) Rendering posts/index.html.erb within layouts/application Rendered posts/index.html.erb within layouts/application (3.7ms) Completed 200 OK in 30ms (Views: 18.4ms | ActiveRecord: 0.9ms) Started GET "/posts" for ::1 at 2016-12-21 17:39:06 +0900 Processing by PostsController#index as HTML Post Load (0.1ms) SELECT "posts".* FROM "posts" WHERE "posts"."id" = ? LIMIT ? [["id", 2], ["LIMIT", 1]] Rendering posts/index.html.erb within layouts/application Rendered posts/index.html.erb within layouts/application (7.6ms) Completed 200 OK in 33ms (Views: 22.0ms | ActiveRecord: 0.7ms)