Connecting to database specified by database.yml  (0.1ms) select sqlite_version(*)  (3.6ms) CREATE TABLE "schema_migrations" ("version" varchar(255) NOT NULL)  (0.0ms) PRAGMA index_list("schema_migrations")  (4.3ms) CREATE UNIQUE INDEX "unique_schema_migrations" ON "schema_migrations" ("version") Connecting to database specified by database.yml  (0.1ms) SELECT "schema_migrations"."version" FROM "schema_migrations"  Migrating to CreateUsers (20110814091304)  (0.0ms) select sqlite_version(*)  (0.0ms) begin transaction  (0.4ms) CREATE TABLE "users" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "username" varchar(255), "password" varchar(255), "created_at" datetime NOT NULL, "updated_at" datetime NOT NULL)  (0.1ms) INSERT INTO "schema_migrations" ("version") VALUES ('20110814091304')  (51.1ms) commit transaction Migrating to CreatePeople (20110819103335)  (0.1ms) begin transaction  (0.4ms) CREATE TABLE "people" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "name" varchar(255), "created_at" datetime NOT NULL, "updated_at" datetime NOT NULL)  (0.1ms) INSERT INTO "schema_migrations" ("version") VALUES ('20110819103335')  (4.2ms) commit transaction Migrating to CreateBlogPosts (20111118222920)  (0.0ms) begin transaction  (0.4ms) CREATE TABLE "blog_posts" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "title" varchar(255) NOT NULL, "body" text NOT NULL, "blogger_id" integer, "blogger_type" varchar(255), "comments_count" integer DEFAULT 0 NOT NULL, "created_at" datetime NOT NULL, "updated_at" datetime NOT NULL)  (0.0ms) PRAGMA index_list("blog_posts")  (0.1ms) CREATE INDEX "index_blog_posts_on_blogger_type_and_blogger_id" ON "blog_posts" ("blogger_type", "blogger_id")  (0.1ms) INSERT INTO "schema_migrations" ("version") VALUES ('20111118222920')  (5.7ms) commit transaction Migrating to CreateBlogComments (20111118222921)  (0.0ms) begin transaction  (0.3ms) CREATE TABLE "blog_comments" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "name" varchar(255) NOT NULL, "email" varchar(255) NOT NULL, "website" varchar(255), "body" text NOT NULL, "post_id" integer NOT NULL, "state" varchar(255), "created_at" datetime NOT NULL, "updated_at" datetime NOT NULL)  (0.0ms) PRAGMA index_list("blog_comments")  (0.1ms) CREATE INDEX "index_blog_comments_on_post_id" ON "blog_comments" ("post_id")  (0.1ms) INSERT INTO "schema_migrations" ("version") VALUES ('20111118222921')  (4.1ms) commit transaction Migrating to ActsAsTaggableOnMigration (20111118222922)  (0.1ms) begin transaction  (0.3ms) CREATE TABLE "tags" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "name" varchar(255))  (0.1ms) CREATE TABLE "taggings" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "tag_id" integer, "taggable_id" integer, "taggable_type" varchar(255), "tagger_id" integer, "tagger_type" varchar(255), "context" varchar(255), "created_at" datetime)   (0.0ms) PRAGMA index_list("taggings")  (0.1ms) CREATE INDEX "index_taggings_on_tag_id" ON "taggings" ("tag_id")  (0.0ms) PRAGMA index_list("taggings")  (0.0ms) PRAGMA index_info('index_taggings_on_tag_id')  (0.1ms) CREATE INDEX "index_taggings_on_taggable_id_and_taggable_type_and_context" ON "taggings" ("taggable_id", "taggable_type", "context")  (0.1ms) INSERT INTO "schema_migrations" ("version") VALUES ('20111118222922')  (4.7ms) commit transaction  (0.3ms) select sqlite_version(*)  (0.1ms) SELECT "schema_migrations"."version" FROM "schema_migrations"  (0.0ms) PRAGMA index_list("blog_comments")  (0.0ms) PRAGMA index_info('index_blog_comments_on_post_id')  (0.0ms) PRAGMA index_list("blog_posts")  (0.0ms) PRAGMA index_info('index_blog_posts_on_blogger_type_and_blogger_id')  (0.0ms) PRAGMA index_list("people")  (0.0ms) PRAGMA index_list("taggings")  (0.0ms) PRAGMA index_info('index_taggings_on_taggable_id_and_taggable_type_and_context')  (0.0ms) PRAGMA index_info('index_taggings_on_tag_id')  (0.0ms) PRAGMA index_list("tags")  (0.0ms) PRAGMA index_list("users") Connecting to database specified by database.yml Connecting to database specified by database.yml  (0.1ms) SELECT "schema_migrations"."version" FROM "schema_migrations"  Migrating to CreateUsers (20110814091304) Migrating to CreateBlogPosts (20110814091434)  (0.0ms) select sqlite_version(*)  (0.0ms) begin transaction  (0.3ms) CREATE TABLE "blog_posts" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "title" varchar(255) NOT NULL, "body" text NOT NULL, "blogger_id" integer, "blogger_type" varchar(255), "comments_count" integer DEFAULT 0 NOT NULL, "created_at" datetime NOT NULL, "updated_at" datetime NOT NULL) SQLite3::SQLException: table "blog_posts" already exists: CREATE TABLE "blog_posts" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "title" varchar(255) NOT NULL, "body" text NOT NULL, "blogger_id" integer, "blogger_type" varchar(255), "comments_count" integer DEFAULT 0 NOT NULL, "created_at" datetime NOT NULL, "updated_at" datetime NOT NULL)  (0.1ms) rollback transaction Connecting to database specified by database.yml  (0.1ms) select sqlite_version(*)  (53.4ms) CREATE TABLE "schema_migrations" ("version" varchar(255) NOT NULL)  (0.0ms) PRAGMA index_list("schema_migrations")  (3.5ms) CREATE UNIQUE INDEX "unique_schema_migrations" ON "schema_migrations" ("version")  (0.1ms) SELECT "schema_migrations"."version" FROM "schema_migrations"  Migrating to CreateUsers (20110814091304)  (0.0ms) begin transaction  (0.3ms) CREATE TABLE "users" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "username" varchar(255), "password" varchar(255), "created_at" datetime NOT NULL, "updated_at" datetime NOT NULL)   (0.1ms) INSERT INTO "schema_migrations" ("version") VALUES ('20110814091304')  (4.6ms) commit transaction Migrating to CreateBlogPosts (20110814091434)  (0.0ms) begin transaction  (0.3ms) CREATE TABLE "blog_posts" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "title" varchar(255) NOT NULL, "body" text NOT NULL, "blogger_id" integer, "blogger_type" varchar(255), "comments_count" integer DEFAULT 0 NOT NULL, "created_at" datetime NOT NULL, "updated_at" datetime NOT NULL)   (0.0ms) PRAGMA index_list("blog_posts")  (0.1ms) CREATE INDEX "index_blog_posts_on_blogger_type_and_blogger_id" ON "blog_posts" ("blogger_type", "blogger_id")  (0.1ms) INSERT INTO "schema_migrations" ("version") VALUES ('20110814091434')  (5.5ms) commit transaction Migrating to CreateBlogComments (20110814093229)  (0.0ms) begin transaction  (0.3ms) CREATE TABLE "blog_comments" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "name" varchar(255) NOT NULL, "email" varchar(255) NOT NULL, "website" varchar(255), "body" text NOT NULL, "post_id" integer NOT NULL, "state" varchar(255), "created_at" datetime NOT NULL, "updated_at" datetime NOT NULL)   (0.0ms) PRAGMA index_list("blog_comments")  (0.1ms) CREATE INDEX "index_blog_comments_on_post_id" ON "blog_comments" ("post_id")  (0.1ms) INSERT INTO "schema_migrations" ("version") VALUES ('20110814093229')  (4.5ms) commit transaction Migrating to ActsAsTaggableOnMigration (20110814103306)  (0.0ms) begin transaction  (0.3ms) CREATE TABLE "tags" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "name" varchar(255))   (0.1ms) CREATE TABLE "taggings" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "tag_id" integer, "taggable_id" integer, "taggable_type" varchar(255), "tagger_id" integer, "tagger_type" varchar(255), "context" varchar(255), "created_at" datetime)  (0.0ms) PRAGMA index_list("taggings")  (0.1ms) CREATE INDEX "index_taggings_on_tag_id" ON "taggings" ("tag_id")  (0.0ms) PRAGMA index_list("taggings")  (0.0ms) PRAGMA index_info('index_taggings_on_tag_id')  (0.1ms) CREATE INDEX "index_taggings_on_taggable_id_and_taggable_type_and_context" ON "taggings" ("taggable_id", "taggable_type", "context")  (0.1ms) INSERT INTO "schema_migrations" ("version") VALUES ('20110814103306')  (4.0ms) commit transaction Migrating to CreatePeople (20110819103335)  (0.0ms) begin transaction  (0.4ms) CREATE TABLE "people" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "name" varchar(255), "created_at" datetime NOT NULL, "updated_at" datetime NOT NULL)   (0.1ms) INSERT INTO "schema_migrations" ("version") VALUES ('20110819103335')  (4.3ms) commit transaction  (0.3ms) select sqlite_version(*)  (0.1ms) SELECT "schema_migrations"."version" FROM "schema_migrations"   (0.0ms) PRAGMA index_list("blog_comments")  (0.0ms) PRAGMA index_info('index_blog_comments_on_post_id')  (0.0ms) PRAGMA index_list("blog_posts")  (0.0ms) PRAGMA index_info('index_blog_posts_on_blogger_type_and_blogger_id')  (0.0ms) PRAGMA index_list("people")  (0.0ms) PRAGMA index_list("taggings")  (0.0ms) PRAGMA index_info('index_taggings_on_taggable_id_and_taggable_type_and_context')  (0.0ms) PRAGMA index_info('index_taggings_on_tag_id')  (0.0ms) PRAGMA index_list("tags")  (0.0ms) PRAGMA index_list("users") Connecting to database specified by database.yml  (0.1ms) SELECT "schema_migrations"."version" FROM "schema_migrations"  Migrating to CreateUsers (20110814091304) Migrating to CreatePeople (20110819103335)  (0.2ms) select sqlite_version(*)  (0.1ms) SELECT "schema_migrations"."version" FROM "schema_migrations"   (0.0ms) PRAGMA index_list("blog_comments")  (0.1ms) PRAGMA index_info('index_blog_comments_on_post_id')  (0.0ms) PRAGMA index_list("blog_posts")  (0.0ms) PRAGMA index_info('index_blog_posts_on_blogger_type_and_blogger_id')  (0.0ms) PRAGMA index_list("people")  (0.0ms) PRAGMA index_list("taggings")  (0.0ms) PRAGMA index_info('index_taggings_on_taggable_id_and_taggable_type_and_context')  (0.0ms) PRAGMA index_info('index_taggings_on_tag_id')  (0.0ms) PRAGMA index_list("tags")  (0.0ms) PRAGMA index_list("users") Connecting to database specified by database.yml  (0.1ms) SELECT "schema_migrations"."version" FROM "schema_migrations"  Migrating to CreateUsers (20110814091304) Migrating to CreateBlogPosts (20110814091434) Migrating to CreateBlogComments (20110814093229) Migrating to ActsAsTaggableOnMigration (20110814103306) Migrating to CreatePeople (20110819103335)  (0.3ms) select sqlite_version(*)  (0.1ms) SELECT "schema_migrations"."version" FROM "schema_migrations"   (0.0ms) PRAGMA index_list("blog_comments")  (0.1ms) PRAGMA index_info('index_blog_comments_on_post_id')  (0.0ms) PRAGMA index_list("blog_posts")  (0.1ms) PRAGMA index_info('index_blog_posts_on_blogger_type_and_blogger_id')  (0.0ms) PRAGMA index_list("people")  (0.0ms) PRAGMA index_list("taggings")  (0.0ms) PRAGMA index_info('index_taggings_on_taggable_id_and_taggable_type_and_context')  (0.0ms) PRAGMA index_info('index_taggings_on_tag_id')  (0.0ms) PRAGMA index_list("tags")  (0.0ms) PRAGMA index_list("users") Connecting to database specified by database.yml Connecting to database specified by database.yml Connecting to database specified by database.yml Connecting to database specified by database.yml  (0.2ms) select sqlite_version(*)  (3.6ms) CREATE TABLE "schema_migrations" ("version" varchar(255) NOT NULL)  (0.0ms) PRAGMA index_list("schema_migrations")  (3.9ms) CREATE UNIQUE INDEX "unique_schema_migrations" ON "schema_migrations" ("version") Connecting to database specified by database.yml  (0.1ms) SELECT "schema_migrations"."version" FROM "schema_migrations"  Migrating to CreateUsers (20110814091304)  (0.0ms) select sqlite_version(*)  (0.0ms) begin transaction  (0.5ms) CREATE TABLE "users" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "username" varchar(255), "password" varchar(255), "created_at" datetime NOT NULL, "updated_at" datetime NOT NULL)  (0.1ms) INSERT INTO "schema_migrations" ("version") VALUES ('20110814091304')  (54.1ms) commit transaction Migrating to CreateBlogPosts (20110814091434)  (0.1ms) begin transaction  (0.5ms) CREATE TABLE "blog_posts" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "title" varchar(255) NOT NULL, "body" text NOT NULL, "blogger_id" integer, "blogger_type" varchar(255), "comments_count" integer DEFAULT 0 NOT NULL, "created_at" datetime NOT NULL, "updated_at" datetime NOT NULL)  (0.1ms) PRAGMA index_list("blog_posts")  (0.1ms) CREATE INDEX "index_blog_posts_on_blogger_type_and_blogger_id" ON "blog_posts" ("blogger_type", "blogger_id")  (0.1ms) INSERT INTO "schema_migrations" ("version") VALUES ('20110814091434')  (4.6ms) commit transaction Migrating to CreateBlogComments (20110814093229)  (0.1ms) begin transaction  (0.4ms) CREATE TABLE "blog_comments" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "name" varchar(255) NOT NULL, "email" varchar(255) NOT NULL, "website" varchar(255), "body" text NOT NULL, "post_id" integer NOT NULL, "state" varchar(255), "created_at" datetime NOT NULL, "updated_at" datetime NOT NULL)  (0.0ms) PRAGMA index_list("blog_comments")  (0.1ms) CREATE INDEX "index_blog_comments_on_post_id" ON "blog_comments" ("post_id")  (0.1ms) INSERT INTO "schema_migrations" ("version") VALUES ('20110814093229')  (4.8ms) commit transaction Migrating to ActsAsTaggableOnMigration (20110814103306)  (0.0ms) begin transaction  (0.3ms) CREATE TABLE "tags" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "name" varchar(255))  (0.1ms) CREATE TABLE "taggings" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "tag_id" integer, "taggable_id" integer, "taggable_type" varchar(255), "tagger_id" integer, "tagger_type" varchar(255), "context" varchar(255), "created_at" datetime)   (0.0ms) PRAGMA index_list("taggings")  (0.1ms) CREATE INDEX "index_taggings_on_tag_id" ON "taggings" ("tag_id")  (0.0ms) PRAGMA index_list("taggings")  (0.0ms) PRAGMA index_info('index_taggings_on_tag_id')  (0.1ms) CREATE INDEX "index_taggings_on_taggable_id_and_taggable_type_and_context" ON "taggings" ("taggable_id", "taggable_type", "context")  (0.1ms) INSERT INTO "schema_migrations" ("version") VALUES ('20110814103306')  (4.5ms) commit transaction Migrating to CreatePeople (20110819103335)  (0.0ms) begin transaction  (0.4ms) CREATE TABLE "people" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "name" varchar(255), "created_at" datetime NOT NULL, "updated_at" datetime NOT NULL)  (0.1ms) INSERT INTO "schema_migrations" ("version") VALUES ('20110819103335')  (4.2ms) commit transaction  (0.5ms) select sqlite_version(*)  (0.2ms) SELECT "schema_migrations"."version" FROM "schema_migrations"  (0.0ms) PRAGMA index_list("blog_comments")  (0.0ms) PRAGMA index_info('index_blog_comments_on_post_id')  (0.1ms) PRAGMA index_list("blog_posts")  (0.1ms) PRAGMA index_info('index_blog_posts_on_blogger_type_and_blogger_id')  (0.0ms) PRAGMA index_list("people")  (0.0ms) PRAGMA index_list("taggings")  (0.0ms) PRAGMA index_info('index_taggings_on_taggable_id_and_taggable_type_and_context')  (0.1ms) PRAGMA index_info('index_taggings_on_tag_id')  (0.0ms) PRAGMA index_list("tags")  (0.0ms) PRAGMA index_list("users") Connecting to database specified by database.yml Connecting to database specified by database.yml Started GET "/" for 127.0.0.1 at 2013-02-27 15:01:54 +0000 Processing by Blogit::PostsController#index as HTML User Load (0.2ms) SELECT "users".* FROM "users" WHERE "users"."id" IS NULL LIMIT 1  (0.3ms) SELECT COUNT(count_column) FROM (SELECT 1 AS count_column FROM "blog_posts" LIMIT 5 OFFSET 0) subquery_for_count Blogit::Post Load (0.2ms) SELECT "blog_posts".* FROM "blog_posts" ORDER BY created_at DESC LIMIT 5 OFFSET 0 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_head.html.erb (101.3ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_body.html.erb (0.8ms) CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" IS NULL LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_links.html.erb (1.7ms) User Load (0.2ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_blogger_information.html.erb (24.5ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post.html.erb (170.0ms)  (0.2ms) SELECT COUNT(*) FROM "blog_posts" Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_pagination.html.erb (17.1ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/index.html.erb within layouts/application (255.7ms) Compiled blogit/index.css (0ms) (pid 9812) Compiled application.css (0ms) (pid 9812) CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" IS NULL LIMIT 1 Blogit::Post Load (0.2ms) SELECT "blog_posts".* FROM "blog_posts" ORDER BY created_at DESC Compiled jquery.js (4ms) (pid 9812) Compiled jquery_ujs.js (0ms) (pid 9812) Compiled application.js (90ms) (pid 9812) Compiled blogit/archive.js (0ms) (pid 9812) Compiled blogit/index.js (29ms) (pid 9812) Completed 200 OK in 567ms (Views: 564.2ms | ActiveRecord: 1.7ms) Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2013-02-27 15:01:55 +0000 Served asset /jquery_ujs.js - 200 OK (7ms) Started GET "/assets/blogit/index.css?body=1" for 127.0.0.1 at 2013-02-27 15:01:55 +0000 Served asset /blogit/index.css - 200 OK (9ms) Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2013-02-27 15:01:55 +0000 Served asset /application.js - 200 OK (10ms) Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2013-02-27 15:01:55 +0000 Served asset /jquery.js - 200 OK (5ms) Started GET "/assets/blogit/archive.js?body=1" for 127.0.0.1 at 2013-02-27 15:01:55 +0000 Served asset /blogit/archive.js - 200 OK (3ms) Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2013-02-27 15:01:55 +0000 Served asset /application.css - 200 OK (2ms) Started GET "/assets/blogit/index.js?body=1" for 127.0.0.1 at 2013-02-27 15:01:55 +0000 Served asset /blogit/index.js - 200 OK (5ms) Started GET "/blog/posts/1-test-postasdfa-sdf-afas-d" for 127.0.0.1 at 2013-02-27 15:01:57 +0000 Processing by Blogit::PostsController#show as HTML Parameters: {"id"=>"1-test-postasdfa-sdf-afas-d"} Blogit::Post Load (0.3ms) SELECT "blog_posts".* FROM "blog_posts" WHERE "blog_posts"."id" = ? LIMIT 1 [["id", "1-test-postasdfa-sdf-afas-d"]] Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_head.html.erb (1.0ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_body.html.erb (0.4ms) User Load (0.2ms) SELECT "users".* FROM "users" WHERE "users"."id" IS NULL LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_links.html.erb (1.1ms) User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_blogger_information.html.erb (1.6ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post.html.erb (9.0ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_share_bar.html.erb (0.8ms) ActsAsTaggableOn::Tag Load (0.1ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 1 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) CACHE (0.0ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 1 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) Blogit::Post Load (0.2ms) SELECT blog_posts.*, COUNT(tags.id) AS count FROM blog_posts, tags, taggings WHERE (blog_posts.id != 1 AND blog_posts.id = taggings.taggable_id AND taggings.taggable_type = 'Blogit::Post' AND taggings.tag_id = tags.id AND tags.name IN (NULL)) GROUP BY blog_posts.id ORDER BY count DESC Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_related.html.erb (64.4ms) Rendered blogit/posts/_post_footer.html.erb (79.7ms) Blogit::Comment Load (0.3ms) SELECT "blog_comments".* FROM "blog_comments" WHERE "blog_comments"."post_id" = 1 Rendered collection (0.0ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/comments/_form.html.erb (6.1ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_active_record_comments.html.erb (16.3ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/show.html.erb within layouts/application (201.5ms) CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" IS NULL LIMIT 1 Blogit::Post Load (0.2ms) SELECT "blog_posts".* FROM "blog_posts" ORDER BY created_at DESC Completed 200 OK in 212ms (Views: 208.4ms | ActiveRecord: 2.0ms) Started GET "/session/new" for 127.0.0.1 at 2013-02-27 15:01:59 +0000 Processing by SessionsController#new as HTML Rendered sessions/new.html.erb within layouts/application (1.8ms) User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" IS NULL LIMIT 1 Blogit::Post Load (0.1ms) SELECT "blog_posts".* FROM "blog_posts" ORDER BY created_at DESC Completed 200 OK in 25ms (Views: 24.7ms | ActiveRecord: 0.2ms) Started POST "/session" for 127.0.0.1 at 2013-02-27 15:02:06 +0000 Processing by SessionsController#create as HTML Parameters: {"utf8"=>"✓", "authenticity_token"=>"jxRC1MwFpiGworG7h3LQF5j+fflZUMuhosbM/XymGoI=", "session"=>{"username"=>"bodacious", "password"=>"[FILTERED]"}, "commit"=>"Log in"} User Load (0.2ms) SELECT "users".* FROM "users" WHERE "users"."username" = 'bodacious' AND "users"."password" = 'password' LIMIT 1 Rendered sessions/new.html.erb within layouts/application (1.6ms) User Load (0.2ms) SELECT "users".* FROM "users" WHERE "users"."id" IS NULL LIMIT 1 Blogit::Post Load (0.2ms) SELECT "blog_posts".* FROM "blog_posts" ORDER BY created_at DESC Completed 200 OK in 31ms (Views: 28.9ms | ActiveRecord: 0.5ms) Connecting to database specified by database.yml Started POST "/session" for 127.0.0.1 at 2013-02-27 15:02:39 +0000 Processing by SessionsController#create as HTML Parameters: {"utf8"=>"✓", "authenticity_token"=>"jxRC1MwFpiGworG7h3LQF5j+fflZUMuhosbM/XymGoI=", "session"=>{"username"=>"gavin", "password"=>"[FILTERED]"}, "commit"=>"Log in"} User Load (0.2ms) SELECT "users".* FROM "users" WHERE "users"."username" = 'gavin' AND "users"."password" = '' LIMIT 1 Rendered sessions/new.html.erb within layouts/application (13.3ms) User Load (0.2ms) SELECT "users".* FROM "users" WHERE "users"."id" IS NULL LIMIT 1 Blogit::Post Load (0.2ms) SELECT "blog_posts".* FROM "blog_posts" ORDER BY created_at DESC Completed 200 OK in 33ms (Views: 31.1ms | ActiveRecord: 0.6ms) Started POST "/session" for 127.0.0.1 at 2013-02-27 15:03:09 +0000 Processing by SessionsController#create as HTML Parameters: {"utf8"=>"✓", "authenticity_token"=>"jxRC1MwFpiGworG7h3LQF5j+fflZUMuhosbM/XymGoI=", "session"=>{"username"=>"Gavin", "password"=>"[FILTERED]"}, "commit"=>"Log in"} User Load (0.2ms) SELECT "users".* FROM "users" WHERE "users"."username" = 'Gavin' AND "users"."password" = 'password' LIMIT 1 Redirected to http://localhost:3000/ Completed 302 Found in 2ms (ActiveRecord: 0.2ms) Started GET "/" for 127.0.0.1 at 2013-02-27 15:03:09 +0000 Processing by Blogit::PostsController#index as HTML User Load (0.2ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1  (0.1ms) SELECT COUNT(count_column) FROM (SELECT 1 AS count_column FROM "blog_posts" LIMIT 5 OFFSET 0) subquery_for_count Blogit::Post Load (0.1ms) SELECT "blog_posts".* FROM "blog_posts" ORDER BY created_at DESC LIMIT 5 OFFSET 0 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_head.html.erb (0.8ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_body.html.erb (0.4ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_links.html.erb (1.3ms) CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_blogger_information.html.erb (1.2ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post.html.erb (8.0ms)  (0.1ms) SELECT COUNT(*) FROM "blog_posts"  Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_pagination.html.erb (2.3ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/index.html.erb within layouts/application (14.5ms) Blogit::Post Load (0.2ms) SELECT "blog_posts".* FROM "blog_posts" ORDER BY created_at DESC Completed 200 OK in 24ms (Views: 22.5ms | ActiveRecord: 0.8ms) Started GET "/blog/posts/new" for 127.0.0.1 at 2013-02-27 15:03:12 +0000 Processing by Blogit::PostsController#new as HTML User Load (0.2ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 ActsAsTaggableOn::Tag Load (0.2ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" IS NULL AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_form.html.erb (7.9ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/new.html.erb within layouts/application (85.7ms) Blogit::Post Load (0.1ms) SELECT "blog_posts".* FROM "blog_posts" ORDER BY created_at DESC Completed 200 OK in 96ms (Views: 92.8ms | ActiveRecord: 0.5ms) Started POST "/blog/posts" for 127.0.0.1 at 2013-02-27 15:03:26 +0000 Processing by Blogit::PostsController#create as HTML Parameters: {"utf8"=>"✓", "authenticity_token"=>"jxRC1MwFpiGworG7h3LQF5j+fflZUMuhosbM/XymGoI=", "post"=>{"title"=>"This is a new blog post", "body"=>"Thiso jfaosfja sodfj aosifj aoisdfj osaidjf aosidjfasoidj faosij", "tag_list"=>"one, two, three"}, "commit"=>"Create Post"} User Load (0.2ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 ActsAsTaggableOn::Tag Load (0.2ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" IS NULL AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL)  (0.1ms) begin transaction SQL (0.8ms) INSERT INTO "blog_posts" ("blogger_id", "blogger_type", "body", "comments_count", "created_at", "title", "updated_at") VALUES (?, ?, ?, ?, ?, ?, ?) [["blogger_id", 1], ["blogger_type", "User"], ["body", "Thiso jfaosfja sodfj aosifj aoisdfj osaidjf aosidjfasoidj faosij"], ["comments_count", 0], ["created_at", Wed, 27 Feb 2013 15:03:26 UTC +00:00], ["title", "This is a new blog post"], ["updated_at", Wed, 27 Feb 2013 15:03:26 UTC +00:00]] ActsAsTaggableOn::Tag Load (0.1ms) SELECT "tags".* FROM "tags" WHERE (lower(name) = 'one' OR lower(name) = 'two' OR lower(name) = 'three') ActsAsTaggableOn::Tag Exists (0.1ms) SELECT 1 AS one FROM "tags" WHERE "tags"."name" = 'one' LIMIT 1 SQL (0.2ms) INSERT INTO "tags" ("name") VALUES (?) [["name", "one"]] ActsAsTaggableOn::Tag Exists (0.1ms) SELECT 1 AS one FROM "tags" WHERE "tags"."name" = 'two' LIMIT 1 SQL (0.1ms) INSERT INTO "tags" ("name") VALUES (?) [["name", "two"]] ActsAsTaggableOn::Tag Exists (0.1ms) SELECT 1 AS one FROM "tags" WHERE "tags"."name" = 'three' LIMIT 1 SQL (0.0ms) INSERT INTO "tags" ("name") VALUES (?) [["name", "three"]] ActsAsTaggableOn::Tag Load (0.1ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) ActsAsTaggableOn::Tagging Exists (0.1ms) SELECT 1 AS one FROM "taggings" WHERE ("taggings"."tag_id" = 1 AND "taggings"."taggable_type" = 'Blogit::Post' AND "taggings"."taggable_id" = 2 AND "taggings"."context" = 'tags' AND "taggings"."tagger_id" IS NULL AND "taggings"."tagger_type" IS NULL) LIMIT 1 SQL (0.4ms) INSERT INTO "taggings" ("context", "created_at", "tag_id", "taggable_id", "taggable_type", "tagger_id", "tagger_type") VALUES (?, ?, ?, ?, ?, ?, ?) [["context", "tags"], ["created_at", Wed, 27 Feb 2013 15:03:26 UTC +00:00], ["tag_id", 1], ["taggable_id", 2], ["taggable_type", "Blogit::Post"], ["tagger_id", nil], ["tagger_type", nil]] ActsAsTaggableOn::Tagging Exists (0.1ms) SELECT 1 AS one FROM "taggings" WHERE ("taggings"."tag_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND "taggings"."taggable_id" = 2 AND "taggings"."context" = 'tags' AND "taggings"."tagger_id" IS NULL AND "taggings"."tagger_type" IS NULL) LIMIT 1 SQL (0.1ms) INSERT INTO "taggings" ("context", "created_at", "tag_id", "taggable_id", "taggable_type", "tagger_id", "tagger_type") VALUES (?, ?, ?, ?, ?, ?, ?) [["context", "tags"], ["created_at", Wed, 27 Feb 2013 15:03:26 UTC +00:00], ["tag_id", 2], ["taggable_id", 2], ["taggable_type", "Blogit::Post"], ["tagger_id", nil], ["tagger_type", nil]] ActsAsTaggableOn::Tagging Exists (0.1ms) SELECT 1 AS one FROM "taggings" WHERE ("taggings"."tag_id" = 3 AND "taggings"."taggable_type" = 'Blogit::Post' AND "taggings"."taggable_id" = 2 AND "taggings"."context" = 'tags' AND "taggings"."tagger_id" IS NULL AND "taggings"."tagger_type" IS NULL) LIMIT 1 SQL (0.1ms) INSERT INTO "taggings" ("context", "created_at", "tag_id", "taggable_id", "taggable_type", "tagger_id", "tagger_type") VALUES (?, ?, ?, ?, ?, ?, ?) [["context", "tags"], ["created_at", Wed, 27 Feb 2013 15:03:26 UTC +00:00], ["tag_id", 3], ["taggable_id", 2], ["taggable_type", "Blogit::Post"], ["tagger_id", nil], ["tagger_type", nil]] Blogit::Post Load (0.1ms) SELECT "blog_posts".* FROM "blog_posts"  (56.6ms) commit transaction Redirected to http://localhost:3000/blog/posts/2-this-is-a-new-blog-post Completed 302 Found in 126ms (ActiveRecord: 59.8ms) Started GET "/blog/posts/2-this-is-a-new-blog-post" for 127.0.0.1 at 2013-02-27 15:03:26 +0000 Processing by Blogit::PostsController#show as HTML Parameters: {"id"=>"2-this-is-a-new-blog-post"} Blogit::Post Load (0.1ms) SELECT "blog_posts".* FROM "blog_posts" WHERE "blog_posts"."id" = ? LIMIT 1 [["id", "2-this-is-a-new-blog-post"]] Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_head.html.erb (0.6ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_body.html.erb (0.3ms) User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_links.html.erb (1.8ms) CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_blogger_information.html.erb (1.3ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post.html.erb (7.7ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_share_bar.html.erb (0.1ms) ActsAsTaggableOn::Tag Load (0.2ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) CACHE (0.0ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) Blogit::Post Load (0.2ms) SELECT blog_posts.*, COUNT(tags.id) AS count FROM blog_posts, tags, taggings WHERE (blog_posts.id != 2 AND blog_posts.id = taggings.taggable_id AND taggings.taggable_type = 'Blogit::Post' AND taggings.tag_id = tags.id AND tags.name IN ('one','two','three')) GROUP BY blog_posts.id ORDER BY count DESC Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_related.html.erb (6.2ms) Rendered blogit/posts/_post_footer.html.erb (6.9ms) Blogit::Comment Load (0.1ms) SELECT "blog_comments".* FROM "blog_comments" WHERE "blog_comments"."post_id" = 2 Rendered collection (0.0ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/comments/_form.html.erb (2.9ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_active_record_comments.html.erb (4.6ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/show.html.erb within layouts/application (22.9ms) Blogit::Post Load (0.2ms) SELECT "blog_posts".* FROM "blog_posts" ORDER BY created_at DESC Completed 200 OK in 33ms (Views: 31.6ms | ActiveRecord: 1.0ms) Connecting to database specified by database.yml Connecting to database specified by database.yml Started GET "/blog/posts/2-this-is-a-new-blog-post" for 127.0.0.1 at 2013-02-27 15:05:46 +0000 Processing by Blogit::PostsController#show as HTML Parameters: {"id"=>"2-this-is-a-new-blog-post"} Blogit::Post Load (0.2ms) SELECT "blog_posts".* FROM "blog_posts" WHERE "blog_posts"."id" = ? LIMIT 1 [["id", "2-this-is-a-new-blog-post"]] Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_head.html.erb (75.2ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_body.html.erb (0.7ms) User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_links.html.erb (19.1ms) CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_blogger_information.html.erb (15.5ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post.html.erb (114.8ms) ActsAsTaggableOn::Tag Load (0.1ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) CACHE (0.0ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) Blogit::Post Load (0.2ms) SELECT blog_posts.*, COUNT(tags.id) AS count FROM blog_posts, tags, taggings WHERE (blog_posts.id != 2 AND blog_posts.id = taggings.taggable_id AND taggings.taggable_type = 'Blogit::Post' AND taggings.tag_id = tags.id AND tags.name IN ('one','two','three')) GROUP BY blog_posts.id ORDER BY count DESC Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_related.html.erb (26.8ms) Rendered blogit/posts/_post_footer.html.erb (27.7ms) Blogit::Comment Load (0.2ms) SELECT "blog_comments".* FROM "blog_comments" WHERE "blog_comments"."post_id" = 2 Rendered collection (0.0ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/comments/_form.html.erb (6.8ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_active_record_comments.html.erb (10.4ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/show.html.erb within layouts/application (192.0ms) Completed 500 Internal Server Error in 310ms ActionView::Template::Error (undefined local variable or method `root_path' for #<#:0x007ff1346c6290>): 15: <%= link_to("log in", main_app.new_session_path) %> 16: <% end %> 17: 18:

<%= link_to("My Awesome Blog", root_path) %>

19: 20: <%= yield %> 21: app/views/layouts/application.html.erb:18:in `_app_views_layouts_application_html_erb___3211448699255320262_70336983835780' Rendered /Users/Gavin/.rvm/gems/ruby-1.9.3-p194@blogit/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/_trace.erb (1.6ms) Rendered /Users/Gavin/.rvm/gems/ruby-1.9.3-p194@blogit/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (0.9ms) Rendered /Users/Gavin/.rvm/gems/ruby-1.9.3-p194@blogit/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/template_error.erb within rescues/layout (15.5ms) Started GET "/blog/posts/2-this-is-a-new-blog-post" for 127.0.0.1 at 2013-02-27 15:06:10 +0000 Processing by Blogit::PostsController#show as HTML Parameters: {"id"=>"2-this-is-a-new-blog-post"} Blogit::Post Load (0.2ms) SELECT "blog_posts".* FROM "blog_posts" WHERE "blog_posts"."id" = ? LIMIT 1 [["id", "2-this-is-a-new-blog-post"]] Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_head.html.erb (1.0ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_body.html.erb (0.4ms) User Load (0.2ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_links.html.erb (2.3ms) CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_blogger_information.html.erb (1.6ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post.html.erb (9.4ms) ActsAsTaggableOn::Tag Load (0.2ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) CACHE (0.0ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) Blogit::Post Load (0.2ms) SELECT blog_posts.*, COUNT(tags.id) AS count FROM blog_posts, tags, taggings WHERE (blog_posts.id != 2 AND blog_posts.id = taggings.taggable_id AND taggings.taggable_type = 'Blogit::Post' AND taggings.tag_id = tags.id AND tags.name IN ('one','two','three')) GROUP BY blog_posts.id ORDER BY count DESC Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_related.html.erb (5.8ms) Rendered blogit/posts/_post_footer.html.erb (6.8ms) Blogit::Comment Load (0.1ms) SELECT "blog_comments".* FROM "blog_comments" WHERE "blog_comments"."post_id" = 2 Rendered collection (0.0ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/comments/_form.html.erb (3.4ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_active_record_comments.html.erb (5.5ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/show.html.erb within layouts/application (24.8ms) Completed 500 Internal Server Error in 44ms ActionView::Template::Error (undefined local variable or method `blogit_root_path' for #<#:0x007ff136c94670>): 15: <%= link_to("log in", main_app.new_session_path) %> 16: <% end %> 17: 18:

<%= link_to("My Awesome Blog", blogit_root_path) %>

19: 20: <%= yield %> 21: app/views/layouts/application.html.erb:18:in `_app_views_layouts_application_html_erb___3211448699255320262_70336991484120' Rendered /Users/Gavin/.rvm/gems/ruby-1.9.3-p194@blogit/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/_trace.erb (1.1ms) Rendered /Users/Gavin/.rvm/gems/ruby-1.9.3-p194@blogit/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (0.8ms) Rendered /Users/Gavin/.rvm/gems/ruby-1.9.3-p194@blogit/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/template_error.erb within rescues/layout (6.3ms) Started GET "/blog/posts/2-this-is-a-new-blog-post" for 127.0.0.1 at 2013-02-27 15:06:16 +0000 Processing by Blogit::PostsController#show as HTML Parameters: {"id"=>"2-this-is-a-new-blog-post"} Blogit::Post Load (0.2ms) SELECT "blog_posts".* FROM "blog_posts" WHERE "blog_posts"."id" = ? LIMIT 1 [["id", "2-this-is-a-new-blog-post"]] Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_head.html.erb (0.7ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_body.html.erb (0.2ms) User Load (0.2ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_links.html.erb (1.6ms) CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_blogger_information.html.erb (1.1ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post.html.erb (6.6ms) ActsAsTaggableOn::Tag Load (0.2ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) CACHE (0.0ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) Blogit::Post Load (0.2ms) SELECT blog_posts.*, COUNT(tags.id) AS count FROM blog_posts, tags, taggings WHERE (blog_posts.id != 2 AND blog_posts.id = taggings.taggable_id AND taggings.taggable_type = 'Blogit::Post' AND taggings.tag_id = tags.id AND tags.name IN ('one','two','three')) GROUP BY blog_posts.id ORDER BY count DESC Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_related.html.erb (5.5ms) Rendered blogit/posts/_post_footer.html.erb (6.4ms) Blogit::Comment Load (0.1ms) SELECT "blog_comments".* FROM "blog_comments" WHERE "blog_comments"."post_id" = 2 Rendered collection (0.0ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/comments/_form.html.erb (2.7ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_active_record_comments.html.erb (4.6ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/show.html.erb within layouts/application (20.4ms) Blogit::Post Load (0.2ms) SELECT "blog_posts".* FROM "blog_posts" ORDER BY created_at DESC Completed 200 OK in 45ms (Views: 42.2ms | ActiveRecord: 1.2ms) Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2013-02-27 15:06:16 +0000 Served asset /application.css - 304 Not Modified (3ms) Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2013-02-27 15:06:16 +0000 Served asset /jquery_ujs.js - 304 Not Modified (6ms) Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2013-02-27 15:06:16 +0000 Served asset /jquery.js - 304 Not Modified (14ms) Started GET "/assets/blogit/archive.js?body=1" for 127.0.0.1 at 2013-02-27 15:06:16 +0000 Served asset /blogit/archive.js - 304 Not Modified (2ms) Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2013-02-27 15:06:16 +0000 Served asset /application.js - 304 Not Modified (6ms) Started GET "/assets/blogit/index.js?body=1" for 127.0.0.1 at 2013-02-27 15:06:16 +0000 Served asset /blogit/index.js - 304 Not Modified (24ms) Started GET "/assets/blogit/index.css?body=1" for 127.0.0.1 at 2013-02-27 15:06:16 +0000 Served asset /blogit/index.css - 304 Not Modified (2ms) Started GET "/blog/posts/2-this-is-a-new-blog-post/edit" for 127.0.0.1 at 2013-02-27 15:06:21 +0000 Processing by Blogit::PostsController#edit as HTML Parameters: {"id"=>"2-this-is-a-new-blog-post"} User Load (0.2ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Blogit::Post Load (0.2ms) SELECT "blog_posts".* FROM "blog_posts" WHERE "blog_posts"."blogger_id" = 1 AND "blog_posts"."blogger_type" = 'User' AND "blog_posts"."id" = ? LIMIT 1 [["id", "2-this-is-a-new-blog-post"]] ActsAsTaggableOn::Tag Load (0.2ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_form.html.erb (7.3ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/edit.html.erb within layouts/application (9.0ms) Blogit::Post Load (0.2ms) SELECT "blog_posts".* FROM "blog_posts" ORDER BY created_at DESC Completed 200 OK in 21ms (Views: 17.0ms | ActiveRecord: 0.8ms) Started GET "/assets/blogit/index.css?body=1" for 127.0.0.1 at 2013-02-27 15:06:21 +0000 Served asset /blogit/index.css - 304 Not Modified (0ms) Started GET "/assets/blogit/archive.js?body=1" for 127.0.0.1 at 2013-02-27 15:06:21 +0000 Served asset /blogit/archive.js - 304 Not Modified (0ms) Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2013-02-27 15:06:21 +0000 Served asset /jquery_ujs.js - 304 Not Modified (0ms) Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2013-02-27 15:06:21 +0000 Served asset /application.js - 304 Not Modified (0ms) Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2013-02-27 15:06:21 +0000 Served asset /application.css - 304 Not Modified (0ms) Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2013-02-27 15:06:21 +0000 Served asset /jquery.js - 304 Not Modified (0ms) Started GET "/assets/blogit/index.js?body=1" for 127.0.0.1 at 2013-02-27 15:06:21 +0000 Served asset /blogit/index.js - 304 Not Modified (0ms) Started PUT "/blog/posts/2-this-is-a-new-blog-post" for 127.0.0.1 at 2013-02-27 15:06:27 +0000 Processing by Blogit::PostsController#update as HTML Parameters: {"utf8"=>"✓", "authenticity_token"=>"jxRC1MwFpiGworG7h3LQF5j+fflZUMuhosbM/XymGoI=", "post"=>{"title"=>"This is a new blog post", "body"=>"Thiso jfaosfja sodfj aosifj aoisdfj osaidjf aosidjfasoidj faosij", "tag_list"=>"one, two, three"}, "commit"=>"Update Post", "id"=>"2-this-is-a-new-blog-post"} User Load (0.2ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Blogit::Post Load (0.1ms) SELECT "blog_posts".* FROM "blog_posts" WHERE "blog_posts"."blogger_id" = 1 AND "blog_posts"."blogger_type" = 'User' AND "blog_posts"."id" = ? LIMIT 1 [["id", "2-this-is-a-new-blog-post"]]  (0.1ms) begin transaction ActsAsTaggableOn::Tag Load (0.2ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) ActsAsTaggableOn::Tag Load (0.1ms) SELECT "tags".* FROM "tags" WHERE (lower(name) = 'one' OR lower(name) = 'two' OR lower(name) = 'three') CACHE (0.0ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL)  (0.1ms) commit transaction Redirected to http://localhost:3000/blog/posts/2-this-is-a-new-blog-post Completed 302 Found in 18ms (ActiveRecord: 0.7ms) Started GET "/blog/posts/2-this-is-a-new-blog-post" for 127.0.0.1 at 2013-02-27 15:06:27 +0000 Processing by Blogit::PostsController#show as HTML Parameters: {"id"=>"2-this-is-a-new-blog-post"} Blogit::Post Load (0.1ms) SELECT "blog_posts".* FROM "blog_posts" WHERE "blog_posts"."id" = ? LIMIT 1 [["id", "2-this-is-a-new-blog-post"]] Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_head.html.erb (0.7ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_body.html.erb (0.3ms) User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_links.html.erb (1.6ms) CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_blogger_information.html.erb (1.1ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post.html.erb (6.8ms) ActsAsTaggableOn::Tag Load (0.1ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) CACHE (0.0ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) Blogit::Post Load (0.3ms) SELECT blog_posts.*, COUNT(tags.id) AS count FROM blog_posts, tags, taggings WHERE (blog_posts.id != 2 AND blog_posts.id = taggings.taggable_id AND taggings.taggable_type = 'Blogit::Post' AND taggings.tag_id = tags.id AND tags.name IN ('one','two','three')) GROUP BY blog_posts.id ORDER BY count DESC Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_related.html.erb (4.6ms) Rendered blogit/posts/_post_footer.html.erb (5.2ms) Blogit::Comment Load (0.1ms) SELECT "blog_comments".* FROM "blog_comments" WHERE "blog_comments"."post_id" = 2 Rendered collection (0.0ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/comments/_form.html.erb (2.9ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_active_record_comments.html.erb (4.8ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/show.html.erb within layouts/application (19.9ms) Blogit::Post Load (0.1ms) SELECT "blog_posts".* FROM "blog_posts" ORDER BY created_at DESC Completed 200 OK in 28ms (Views: 26.0ms | ActiveRecord: 0.9ms) Started GET "/assets/blogit/index.css?body=1" for 127.0.0.1 at 2013-02-27 15:06:27 +0000 Served asset /blogit/index.css - 304 Not Modified (0ms) Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2013-02-27 15:06:27 +0000 Served asset /jquery.js - 304 Not Modified (0ms) Started GET "/assets/blogit/archive.js?body=1" for 127.0.0.1 at 2013-02-27 15:06:27 +0000 Served asset /blogit/archive.js - 304 Not Modified (0ms) Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2013-02-27 15:06:27 +0000 Served asset /jquery_ujs.js - 304 Not Modified (0ms) Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2013-02-27 15:06:27 +0000 Served asset /application.css - 304 Not Modified (0ms) Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2013-02-27 15:06:27 +0000 Served asset /application.js - 304 Not Modified (0ms) Started GET "/assets/blogit/index.js?body=1" for 127.0.0.1 at 2013-02-27 15:06:27 +0000 Served asset /blogit/index.js - 304 Not Modified (0ms) Started GET "/blog/posts/2-this-is-a-new-blog-post/edit" for 127.0.0.1 at 2013-02-27 15:07:04 +0000 Processing by Blogit::PostsController#edit as HTML Parameters: {"id"=>"2-this-is-a-new-blog-post"} User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Blogit::Post Load (0.1ms) SELECT "blog_posts".* FROM "blog_posts" WHERE "blog_posts"."blogger_id" = 1 AND "blog_posts"."blogger_type" = 'User' AND "blog_posts"."id" = ? LIMIT 1 [["id", "2-this-is-a-new-blog-post"]] ActsAsTaggableOn::Tag Load (0.2ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_form.html.erb (13.3ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/edit.html.erb within layouts/application (14.4ms) Blogit::Post Load (0.2ms) SELECT "blog_posts".* FROM "blog_posts" ORDER BY created_at DESC Completed 200 OK in 46ms (Views: 22.5ms | ActiveRecord: 1.4ms) Started GET "/assets/blogit/index.css?body=1" for 127.0.0.1 at 2013-02-27 15:07:05 +0000 Served asset /blogit/index.css - 304 Not Modified (0ms) Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2013-02-27 15:07:05 +0000 Served asset /jquery.js - 304 Not Modified (0ms) Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2013-02-27 15:07:05 +0000 Served asset /application.js - 304 Not Modified (0ms) Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2013-02-27 15:07:05 +0000 Served asset /jquery_ujs.js - 304 Not Modified (0ms) Started GET "/assets/blogit/archive.js?body=1" for 127.0.0.1 at 2013-02-27 15:07:05 +0000 Served asset /blogit/archive.js - 304 Not Modified (0ms) Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2013-02-27 15:07:05 +0000 Served asset /application.css - 304 Not Modified (0ms) Started GET "/assets/blogit/index.js?body=1" for 127.0.0.1 at 2013-02-27 15:07:05 +0000 Served asset /blogit/index.js - 304 Not Modified (0ms) Started PUT "/blog/posts/2-this-is-a-new-blog-post" for 127.0.0.1 at 2013-02-27 15:07:06 +0000 Processing by Blogit::PostsController#update as HTML Parameters: {"utf8"=>"✓", "authenticity_token"=>"jxRC1MwFpiGworG7h3LQF5j+fflZUMuhosbM/XymGoI=", "post"=>{"title"=>"This is a new blog post", "body"=>"Thiso jfaosfja sodfj aosifj aoisdfj osaidjf aosidjfasoidj faosij", "tag_list"=>"one, two, three"}, "commit"=>"Update Post", "id"=>"2-this-is-a-new-blog-post"} User Load (0.3ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Blogit::Post Load (0.1ms) SELECT "blog_posts".* FROM "blog_posts" WHERE "blog_posts"."blogger_id" = 1 AND "blog_posts"."blogger_type" = 'User' AND "blog_posts"."id" = ? LIMIT 1 [["id", "2-this-is-a-new-blog-post"]]  (0.1ms) begin transaction ActsAsTaggableOn::Tag Load (0.2ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) ActsAsTaggableOn::Tag Load (0.3ms) SELECT "tags".* FROM "tags" WHERE (lower(name) = 'one' OR lower(name) = 'two' OR lower(name) = 'three') CACHE (0.0ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL)  (0.1ms) commit transaction Redirected to http://localhost:3000/blog/posts/2-this-is-a-new-blog-post Completed 302 Found in 13ms (ActiveRecord: 1.1ms) Started GET "/blog/posts/2-this-is-a-new-blog-post" for 127.0.0.1 at 2013-02-27 15:07:06 +0000 Processing by Blogit::PostsController#show as HTML Parameters: {"id"=>"2-this-is-a-new-blog-post"} Blogit::Post Load (0.2ms) SELECT "blog_posts".* FROM "blog_posts" WHERE "blog_posts"."id" = ? LIMIT 1 [["id", "2-this-is-a-new-blog-post"]] Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_head.html.erb (0.8ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_body.html.erb (0.2ms) User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_links.html.erb (1.7ms) CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_blogger_information.html.erb (1.4ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post.html.erb (7.8ms) ActsAsTaggableOn::Tag Load (0.2ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) CACHE (0.0ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) Blogit::Post Load (0.3ms) SELECT blog_posts.*, COUNT(tags.id) AS count FROM blog_posts, tags, taggings WHERE (blog_posts.id != 2 AND blog_posts.id = taggings.taggable_id AND taggings.taggable_type = 'Blogit::Post' AND taggings.tag_id = tags.id AND tags.name IN ('one','two','three')) GROUP BY blog_posts.id ORDER BY count DESC Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_related.html.erb (4.8ms) Rendered blogit/posts/_post_footer.html.erb (5.5ms) Blogit::Comment Load (0.2ms) SELECT "blog_comments".* FROM "blog_comments" WHERE "blog_comments"."post_id" = 2 Rendered collection (0.0ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/comments/_form.html.erb (3.4ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_active_record_comments.html.erb (7.7ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/show.html.erb within layouts/application (60.9ms) Blogit::Post Load (0.1ms) SELECT "blog_posts".* FROM "blog_posts" ORDER BY created_at DESC Completed 200 OK in 70ms (Views: 67.1ms | ActiveRecord: 1.3ms) Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2013-02-27 15:07:07 +0000 Served asset /jquery_ujs.js - 304 Not Modified (0ms) Started GET "/assets/blogit/archive.js?body=1" for 127.0.0.1 at 2013-02-27 15:07:07 +0000 Served asset /blogit/archive.js - 304 Not Modified (0ms) Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2013-02-27 15:07:07 +0000 Served asset /application.js - 304 Not Modified (0ms) Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2013-02-27 15:07:07 +0000 Served asset /application.css - 304 Not Modified (0ms) Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2013-02-27 15:07:07 +0000 Served asset /jquery.js - 304 Not Modified (0ms) Started GET "/assets/blogit/index.js?body=1" for 127.0.0.1 at 2013-02-27 15:07:07 +0000 Served asset /blogit/index.js - 304 Not Modified (0ms) Started GET "/assets/blogit/index.css?body=1" for 127.0.0.1 at 2013-02-27 15:07:07 +0000 Served asset /blogit/index.css - 304 Not Modified (0ms) Connecting to database specified by database.yml Started GET "/blog/posts/2-this-is-a-new-blog-post/edit" for 127.0.0.1 at 2013-02-27 15:07:56 +0000 Processing by Blogit::PostsController#edit as HTML Parameters: {"id"=>"2-this-is-a-new-blog-post"} User Load (0.2ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Blogit::Post Load (0.2ms) SELECT "blog_posts".* FROM "blog_posts" WHERE "blog_posts"."blogger_id" = 1 AND "blog_posts"."blogger_type" = 'User' AND "blog_posts"."id" = ? LIMIT 1 [["id", "2-this-is-a-new-blog-post"]] ActsAsTaggableOn::Tag Load (0.1ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_form.html.erb (95.1ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/edit.html.erb within layouts/application (108.4ms) Blogit::Post Load (0.2ms) SELECT "blog_posts".* FROM "blog_posts" ORDER BY created_at DESC Completed 200 OK in 198ms (Views: 145.8ms | ActiveRecord: 1.6ms) Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2013-02-27 15:07:56 +0000 Served asset /application.css - 304 Not Modified (2ms) Started GET "/assets/blogit/index.css?body=1" for 127.0.0.1 at 2013-02-27 15:07:56 +0000 Served asset /blogit/index.css - 304 Not Modified (2ms) Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2013-02-27 15:07:56 +0000 Served asset /jquery.js - 304 Not Modified (4ms) Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2013-02-27 15:07:56 +0000 Served asset /application.js - 304 Not Modified (4ms) Started GET "/assets/blogit/archive.js?body=1" for 127.0.0.1 at 2013-02-27 15:07:56 +0000 Served asset /blogit/archive.js - 304 Not Modified (2ms) Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2013-02-27 15:07:57 +0000 Served asset /jquery_ujs.js - 304 Not Modified (2ms) Started GET "/assets/blogit/index.js?body=1" for 127.0.0.1 at 2013-02-27 15:07:57 +0000 Served asset /blogit/index.js - 304 Not Modified (2ms) Started PUT "/blog/posts/2-this-is-a-new-blog-post" for 127.0.0.1 at 2013-02-27 15:07:58 +0000 Processing by Blogit::PostsController#update as HTML Parameters: {"utf8"=>"✓", "authenticity_token"=>"jxRC1MwFpiGworG7h3LQF5j+fflZUMuhosbM/XymGoI=", "post"=>{"title"=>"This is a new blog post", "body"=>"Thiso jfaosfja sodfj aosifj aoisdfj osaidjf aosidjfasoidj faosij", "tag_list"=>"one, two, three"}, "commit"=>"Update Post", "id"=>"2-this-is-a-new-blog-post"} User Load (0.2ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Blogit::Post Load (0.1ms) SELECT "blog_posts".* FROM "blog_posts" WHERE "blog_posts"."blogger_id" = 1 AND "blog_posts"."blogger_type" = 'User' AND "blog_posts"."id" = ? LIMIT 1 [["id", "2-this-is-a-new-blog-post"]]  (0.1ms) begin transaction ActsAsTaggableOn::Tag Load (0.2ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) ActsAsTaggableOn::Tag Load (0.1ms) SELECT "tags".* FROM "tags" WHERE (lower(name) = 'one' OR lower(name) = 'two' OR lower(name) = 'three') CACHE (0.0ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL)  (0.1ms) commit transaction Redirected to http://localhost:3000/blog/posts/2-this-is-a-new-blog-post Completed 302 Found in 16ms (ActiveRecord: 0.8ms) Started GET "/blog/posts/2-this-is-a-new-blog-post" for 127.0.0.1 at 2013-02-27 15:07:58 +0000 Processing by Blogit::PostsController#show as HTML Parameters: {"id"=>"2-this-is-a-new-blog-post"} Blogit::Post Load (0.2ms) SELECT "blog_posts".* FROM "blog_posts" WHERE "blog_posts"."id" = ? LIMIT 1 [["id", "2-this-is-a-new-blog-post"]] Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_head.html.erb (1.1ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_body.html.erb (0.7ms) User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_links.html.erb (2.3ms) CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_blogger_information.html.erb (5.6ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post.html.erb (14.0ms) ActsAsTaggableOn::Tag Load (0.2ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) CACHE (0.0ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) Blogit::Post Load (0.2ms) SELECT blog_posts.*, COUNT(tags.id) AS count FROM blog_posts, tags, taggings WHERE (blog_posts.id != 2 AND blog_posts.id = taggings.taggable_id AND taggings.taggable_type = 'Blogit::Post' AND taggings.tag_id = tags.id AND tags.name IN ('one','two','three')) GROUP BY blog_posts.id ORDER BY count DESC Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_related.html.erb (5.1ms) Rendered blogit/posts/_post_footer.html.erb (6.6ms) Blogit::Comment Load (0.2ms) SELECT "blog_comments".* FROM "blog_comments" WHERE "blog_comments"."post_id" = 2 Rendered collection (0.0ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/comments/_form.html.erb (4.3ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_active_record_comments.html.erb (7.6ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/show.html.erb within layouts/application (47.6ms) Blogit::Post Load (0.2ms) SELECT "blog_posts".* FROM "blog_posts" ORDER BY created_at DESC Completed 200 OK in 56ms (Views: 53.3ms | ActiveRecord: 1.3ms) Started GET "/assets/blogit/index.css?body=1" for 127.0.0.1 at 2013-02-27 15:07:58 +0000 Served asset /blogit/index.css - 304 Not Modified (0ms) Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2013-02-27 15:07:58 +0000 Served asset /application.css - 304 Not Modified (0ms) Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2013-02-27 15:07:58 +0000 Served asset /jquery_ujs.js - 304 Not Modified (0ms) Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2013-02-27 15:07:58 +0000 Served asset /application.js - 304 Not Modified (0ms) Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2013-02-27 15:07:58 +0000 Served asset /jquery.js - 304 Not Modified (0ms) Started GET "/assets/blogit/archive.js?body=1" for 127.0.0.1 at 2013-02-27 15:07:58 +0000 Served asset /blogit/archive.js - 304 Not Modified (0ms) Started GET "/assets/blogit/index.js?body=1" for 127.0.0.1 at 2013-02-27 15:07:58 +0000 Served asset /blogit/index.js - 304 Not Modified (0ms) Connecting to database specified by database.yml Started GET "/blog/posts/2-this-is-a-new-blog-post" for 127.0.0.1 at 2013-02-27 15:09:06 +0000 Processing by Blogit::PostsController#show as HTML Parameters: {"id"=>"2-this-is-a-new-blog-post"} Blogit::Post Load (0.2ms) SELECT "blog_posts".* FROM "blog_posts" WHERE "blog_posts"."id" = ? LIMIT 1 [["id", "2-this-is-a-new-blog-post"]] Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_head.html.erb (83.6ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_body.html.erb (0.7ms) User Load (0.2ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_links.html.erb (20.8ms) CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_blogger_information.html.erb (17.0ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post.html.erb (126.9ms) ActsAsTaggableOn::Tag Load (0.1ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) CACHE (0.0ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) Blogit::Post Load (0.2ms) SELECT blog_posts.*, COUNT(tags.id) AS count FROM blog_posts, tags, taggings WHERE (blog_posts.id != 2 AND blog_posts.id = taggings.taggable_id AND taggings.taggable_type = 'Blogit::Post' AND taggings.tag_id = tags.id AND tags.name IN ('one','two','three')) GROUP BY blog_posts.id ORDER BY count DESC Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_related.html.erb (33.6ms) Rendered blogit/posts/_post_footer.html.erb (34.5ms) Blogit::Comment Load (0.2ms) SELECT "blog_comments".* FROM "blog_comments" WHERE "blog_comments"."post_id" = 2 Rendered collection (0.0ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/comments/_form.html.erb (7.7ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_active_record_comments.html.erb (11.1ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/show.html.erb within layouts/application (194.1ms) Blogit::Post Load (0.2ms) SELECT "blog_posts".* FROM "blog_posts" ORDER BY created_at DESC Completed 200 OK in 258ms (Views: 245.9ms | ActiveRecord: 2.3ms) Started GET "/assets/blogit/index.css?body=1" for 127.0.0.1 at 2013-02-27 15:09:06 +0000 Served asset /blogit/index.css - 304 Not Modified (3ms) Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2013-02-27 15:09:06 +0000 Served asset /application.js - 304 Not Modified (12ms) Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2013-02-27 15:09:06 +0000 Served asset /jquery_ujs.js - 304 Not Modified (1ms) Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2013-02-27 15:09:06 +0000 Served asset /jquery.js - 304 Not Modified (2ms) Started GET "/assets/blogit/archive.js?body=1" for 127.0.0.1 at 2013-02-27 15:09:06 +0000 Served asset /blogit/archive.js - 304 Not Modified (1ms) Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2013-02-27 15:09:06 +0000 Served asset /application.css - 304 Not Modified (1ms) Started GET "/assets/blogit/index.js?body=1" for 127.0.0.1 at 2013-02-27 15:09:06 +0000 Served asset /blogit/index.js - 304 Not Modified (4ms) Started GET "/blog/posts/2-this-is-a-new-blog-post/edit" for 127.0.0.1 at 2013-02-27 15:09:07 +0000 Processing by Blogit::PostsController#edit as HTML Parameters: {"id"=>"2-this-is-a-new-blog-post"} User Load (0.2ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Blogit::Post Load (0.2ms) SELECT "blog_posts".* FROM "blog_posts" WHERE "blog_posts"."blogger_id" = 1 AND "blog_posts"."blogger_type" = 'User' AND "blog_posts"."id" = ? LIMIT 1 [["id", "2-this-is-a-new-blog-post"]] ActsAsTaggableOn::Tag Load (0.2ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_form.html.erb (6.7ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/edit.html.erb within layouts/application (8.6ms) Blogit::Post Load (0.2ms) SELECT "blog_posts".* FROM "blog_posts" ORDER BY created_at DESC Completed 200 OK in 20ms (Views: 16.1ms | ActiveRecord: 0.8ms) Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2013-02-27 15:09:07 +0000 Served asset /application.css - 304 Not Modified (0ms) Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2013-02-27 15:09:07 +0000 Served asset /jquery.js - 304 Not Modified (0ms) Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2013-02-27 15:09:07 +0000 Served asset /application.js - 304 Not Modified (0ms) Started GET "/assets/blogit/archive.js?body=1" for 127.0.0.1 at 2013-02-27 15:09:07 +0000 Served asset /blogit/archive.js - 304 Not Modified (0ms) Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2013-02-27 15:09:07 +0000 Served asset /jquery_ujs.js - 304 Not Modified (0ms) Started GET "/assets/blogit/index.css?body=1" for 127.0.0.1 at 2013-02-27 15:09:07 +0000 Served asset /blogit/index.css - 304 Not Modified (0ms) Started GET "/assets/blogit/index.js?body=1" for 127.0.0.1 at 2013-02-27 15:09:07 +0000 Served asset /blogit/index.js - 304 Not Modified (0ms) Started PUT "/blog/posts/2-this-is-a-new-blog-post" for 127.0.0.1 at 2013-02-27 15:09:09 +0000 Processing by Blogit::PostsController#update as HTML Parameters: {"utf8"=>"✓", "authenticity_token"=>"jxRC1MwFpiGworG7h3LQF5j+fflZUMuhosbM/XymGoI=", "post"=>{"title"=>"This is a new blog post", "body"=>"Thiso jfaosfja sodfj aosifj aoisdfj osaidjf aosidjfasoidj faosij", "tag_list"=>"one, two, three"}, "commit"=>"Update Post", "id"=>"2-this-is-a-new-blog-post"} User Load (0.9ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Blogit::Post Load (0.2ms) SELECT "blog_posts".* FROM "blog_posts" WHERE "blog_posts"."blogger_id" = 1 AND "blog_posts"."blogger_type" = 'User' AND "blog_posts"."id" = ? LIMIT 1 [["id", "2-this-is-a-new-blog-post"]]  (0.1ms) begin transaction ActsAsTaggableOn::Tag Load (0.4ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) ActsAsTaggableOn::Tag Load (0.2ms) SELECT "tags".* FROM "tags" WHERE (lower(name) = 'one' OR lower(name) = 'two' OR lower(name) = 'three') CACHE (0.0ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL)  (0.1ms) commit transaction Redirected to http://localhost:3000/blog/posts/2-this-is-a-new-blog-post Completed 302 Found in 37ms (ActiveRecord: 1.8ms) Started GET "/blog/posts/2-this-is-a-new-blog-post" for 127.0.0.1 at 2013-02-27 15:09:09 +0000 Processing by Blogit::PostsController#show as HTML Parameters: {"id"=>"2-this-is-a-new-blog-post"} Blogit::Post Load (0.1ms) SELECT "blog_posts".* FROM "blog_posts" WHERE "blog_posts"."id" = ? LIMIT 1 [["id", "2-this-is-a-new-blog-post"]] Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_head.html.erb (0.7ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_body.html.erb (0.2ms) User Load (0.2ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_links.html.erb (2.9ms) CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_blogger_information.html.erb (1.3ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post.html.erb (8.5ms) ActsAsTaggableOn::Tag Load (0.2ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) CACHE (0.0ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) Blogit::Post Load (0.2ms) SELECT blog_posts.*, COUNT(tags.id) AS count FROM blog_posts, tags, taggings WHERE (blog_posts.id != 2 AND blog_posts.id = taggings.taggable_id AND taggings.taggable_type = 'Blogit::Post' AND taggings.tag_id = tags.id AND tags.name IN ('one','two','three')) GROUP BY blog_posts.id ORDER BY count DESC Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_related.html.erb (3.7ms) Rendered blogit/posts/_post_footer.html.erb (4.4ms) Blogit::Comment Load (0.1ms) SELECT "blog_comments".* FROM "blog_comments" WHERE "blog_comments"."post_id" = 2 Rendered collection (0.0ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/comments/_form.html.erb (4.2ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_active_record_comments.html.erb (5.6ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/show.html.erb within layouts/application (21.0ms) Blogit::Post Load (0.2ms) SELECT "blog_posts".* FROM "blog_posts" ORDER BY created_at DESC Completed 200 OK in 30ms (Views: 28.4ms | ActiveRecord: 0.9ms) Started GET "/assets/blogit/index.css?body=1" for 127.0.0.1 at 2013-02-27 15:09:09 +0000 Served asset /blogit/index.css - 304 Not Modified (0ms) Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2013-02-27 15:09:09 +0000 Served asset /application.css - 304 Not Modified (0ms) Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2013-02-27 15:09:09 +0000 Served asset /jquery.js - 304 Not Modified (0ms) Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2013-02-27 15:09:09 +0000 Served asset /application.js - 304 Not Modified (0ms) Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2013-02-27 15:09:09 +0000 Served asset /jquery_ujs.js - 304 Not Modified (0ms) Started GET "/assets/blogit/archive.js?body=1" for 127.0.0.1 at 2013-02-27 15:09:09 +0000 Served asset /blogit/archive.js - 304 Not Modified (0ms) Started GET "/assets/blogit/index.js?body=1" for 127.0.0.1 at 2013-02-27 15:09:09 +0000 Served asset /blogit/index.js - 304 Not Modified (0ms) Connecting to database specified by database.yml Started GET "/blog/posts/2-this-is-a-new-blog-post" for 127.0.0.1 at 2013-02-27 15:09:42 +0000 Processing by Blogit::PostsController#show as HTML Parameters: {"id"=>"2-this-is-a-new-blog-post"} Blogit::Post Load (0.2ms) SELECT "blog_posts".* FROM "blog_posts" WHERE "blog_posts"."id" = ? LIMIT 1 [["id", "2-this-is-a-new-blog-post"]] Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_head.html.erb (90.9ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_body.html.erb (0.7ms) User Load (0.2ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_links.html.erb (25.4ms) CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_blogger_information.html.erb (18.0ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post.html.erb (139.7ms) ActsAsTaggableOn::Tag Load (0.2ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) CACHE (0.0ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) Blogit::Post Load (0.2ms) SELECT blog_posts.*, COUNT(tags.id) AS count FROM blog_posts, tags, taggings WHERE (blog_posts.id != 2 AND blog_posts.id = taggings.taggable_id AND taggings.taggable_type = 'Blogit::Post' AND taggings.tag_id = tags.id AND tags.name IN ('one','two','three')) GROUP BY blog_posts.id ORDER BY count DESC Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_related.html.erb (34.2ms) Rendered blogit/posts/_post_footer.html.erb (35.5ms) Blogit::Comment Load (0.2ms) SELECT "blog_comments".* FROM "blog_comments" WHERE "blog_comments"."post_id" = 2 Rendered collection (0.0ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/comments/_form.html.erb (8.1ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_active_record_comments.html.erb (12.0ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/show.html.erb within layouts/application (212.8ms) Blogit::Post Load (0.2ms) SELECT "blog_posts".* FROM "blog_posts" ORDER BY created_at DESC Completed 200 OK in 286ms (Views: 272.0ms | ActiveRecord: 2.4ms) Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2013-02-27 15:09:42 +0000 Served asset /application.css - 304 Not Modified (2ms) Started GET "/assets/blogit/index.css?body=1" for 127.0.0.1 at 2013-02-27 15:09:42 +0000 Served asset /blogit/index.css - 304 Not Modified (2ms) Started GET "/assets/blogit/archive.js?body=1" for 127.0.0.1 at 2013-02-27 15:09:42 +0000 Served asset /blogit/archive.js - 304 Not Modified (2ms) Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2013-02-27 15:09:42 +0000 Served asset /jquery_ujs.js - 304 Not Modified (2ms) Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2013-02-27 15:09:42 +0000 Served asset /application.js - 304 Not Modified (6ms) Started GET "/assets/blogit/index.js?body=1" for 127.0.0.1 at 2013-02-27 15:09:42 +0000 Served asset /blogit/index.js - 304 Not Modified (3ms) Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2013-02-27 15:09:42 +0000 Served asset /jquery.js - 304 Not Modified (3ms) Started GET "/blog/posts/2-this-is-a-new-blog-post/edit" for 127.0.0.1 at 2013-02-27 15:09:43 +0000 Processing by Blogit::PostsController#edit as HTML Parameters: {"id"=>"2-this-is-a-new-blog-post"} User Load (0.3ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Blogit::Post Load (0.3ms) SELECT "blog_posts".* FROM "blog_posts" WHERE "blog_posts"."blogger_id" = 1 AND "blog_posts"."blogger_type" = 'User' AND "blog_posts"."id" = ? LIMIT 1 [["id", "2-this-is-a-new-blog-post"]] ActsAsTaggableOn::Tag Load (0.2ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_form.html.erb (7.7ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/edit.html.erb within layouts/application (9.5ms) Blogit::Post Load (0.2ms) SELECT "blog_posts".* FROM "blog_posts" ORDER BY created_at DESC Completed 200 OK in 23ms (Views: 18.2ms | ActiveRecord: 1.0ms) Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2013-02-27 15:09:43 +0000 Served asset /application.css - 304 Not Modified (0ms) Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2013-02-27 15:09:43 +0000 Served asset /jquery.js - 304 Not Modified (0ms) Started GET "/assets/blogit/archive.js?body=1" for 127.0.0.1 at 2013-02-27 15:09:43 +0000 Served asset /blogit/archive.js - 304 Not Modified (0ms) Started GET "/assets/blogit/index.css?body=1" for 127.0.0.1 at 2013-02-27 15:09:43 +0000 Served asset /blogit/index.css - 304 Not Modified (0ms) Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2013-02-27 15:09:43 +0000 Served asset /jquery_ujs.js - 304 Not Modified (0ms) Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2013-02-27 15:09:43 +0000 Served asset /application.js - 304 Not Modified (0ms) Started GET "/assets/blogit/index.js?body=1" for 127.0.0.1 at 2013-02-27 15:09:43 +0000 Served asset /blogit/index.js - 304 Not Modified (0ms) Started PUT "/blog/posts/2-this-is-a-new-blog-post" for 127.0.0.1 at 2013-02-27 15:09:45 +0000 Processing by Blogit::PostsController#update as HTML Parameters: {"utf8"=>"✓", "authenticity_token"=>"jxRC1MwFpiGworG7h3LQF5j+fflZUMuhosbM/XymGoI=", "post"=>{"title"=>"This is a new blog post", "body"=>"Thiso jfaosfja sodfj aosifj aoisdfj osaidjf aosidjfasoidj faosij", "tag_list"=>"one, two, three"}, "commit"=>"Update Post", "id"=>"2-this-is-a-new-blog-post"} User Load (0.2ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Blogit::Post Load (0.1ms) SELECT "blog_posts".* FROM "blog_posts" WHERE "blog_posts"."blogger_id" = 1 AND "blog_posts"."blogger_type" = 'User' AND "blog_posts"."id" = ? LIMIT 1 [["id", "2-this-is-a-new-blog-post"]]  (0.0ms) begin transaction ActsAsTaggableOn::Tag Load (0.2ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) ActsAsTaggableOn::Tag Load (0.1ms) SELECT "tags".* FROM "tags" WHERE (lower(name) = 'one' OR lower(name) = 'two' OR lower(name) = 'three') CACHE (0.0ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL)  (0.0ms) commit transaction Redirected to http://localhost:3000/blog/posts/2-this-is-a-new-blog-post Completed 302 Found in 16ms (ActiveRecord: 0.8ms) Started GET "/blog/posts/2-this-is-a-new-blog-post" for 127.0.0.1 at 2013-02-27 15:09:45 +0000 Processing by Blogit::PostsController#show as HTML Parameters: {"id"=>"2-this-is-a-new-blog-post"} Blogit::Post Load (0.1ms) SELECT "blog_posts".* FROM "blog_posts" WHERE "blog_posts"."id" = ? LIMIT 1 [["id", "2-this-is-a-new-blog-post"]] Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_head.html.erb (0.7ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_body.html.erb (0.2ms) User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_links.html.erb (1.6ms) CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_blogger_information.html.erb (1.0ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post.html.erb (6.6ms) ActsAsTaggableOn::Tag Load (0.1ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) CACHE (0.0ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) Blogit::Post Load (0.1ms) SELECT blog_posts.*, COUNT(tags.id) AS count FROM blog_posts, tags, taggings WHERE (blog_posts.id != 2 AND blog_posts.id = taggings.taggable_id AND taggings.taggable_type = 'Blogit::Post' AND taggings.tag_id = tags.id AND tags.name IN ('one','two','three')) GROUP BY blog_posts.id ORDER BY count DESC Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_related.html.erb (3.6ms) Rendered blogit/posts/_post_footer.html.erb (4.2ms) Blogit::Comment Load (0.1ms) SELECT "blog_comments".* FROM "blog_comments" WHERE "blog_comments"."post_id" = 2 Rendered collection (0.0ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/comments/_form.html.erb (3.7ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_active_record_comments.html.erb (5.6ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/show.html.erb within layouts/application (19.1ms) Blogit::Post Load (0.1ms) SELECT "blog_posts".* FROM "blog_posts" ORDER BY created_at DESC Completed 200 OK in 28ms (Views: 26.1ms | ActiveRecord: 0.8ms) Started GET "/assets/blogit/index.css?body=1" for 127.0.0.1 at 2013-02-27 15:09:45 +0000 Served asset /blogit/index.css - 304 Not Modified (0ms) Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2013-02-27 15:09:45 +0000 Served asset /application.css - 304 Not Modified (0ms) Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2013-02-27 15:09:45 +0000 Served asset /application.js - 304 Not Modified (0ms) Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2013-02-27 15:09:45 +0000 Served asset /jquery_ujs.js - 304 Not Modified (0ms) Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2013-02-27 15:09:45 +0000 Served asset /jquery.js - 304 Not Modified (0ms) Started GET "/assets/blogit/archive.js?body=1" for 127.0.0.1 at 2013-02-27 15:09:45 +0000 Served asset /blogit/archive.js - 304 Not Modified (0ms) Started GET "/assets/blogit/index.js?body=1" for 127.0.0.1 at 2013-02-27 15:09:45 +0000 Served asset /blogit/index.js - 304 Not Modified (0ms) Connecting to database specified by database.yml Started GET "/blog/posts/2-this-is-a-new-blog-post" for 127.0.0.1 at 2013-02-27 15:13:26 +0000 Processing by Blogit::PostsController#show as HTML Parameters: {"id"=>"2-this-is-a-new-blog-post"} Blogit::Post Load (0.3ms) SELECT "blog_posts".* FROM "blog_posts" WHERE "blog_posts"."id" = ? LIMIT 1 [["id", "2-this-is-a-new-blog-post"]] Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_head.html.erb (89.9ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_body.html.erb (0.9ms) User Load (0.2ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_links.html.erb (22.2ms) CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_blogger_information.html.erb (18.5ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post.html.erb (136.6ms) ActsAsTaggableOn::Tag Load (0.1ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) CACHE (0.0ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) Blogit::Post Load (0.2ms) SELECT blog_posts.*, COUNT(tags.id) AS count FROM blog_posts, tags, taggings WHERE (blog_posts.id != 2 AND blog_posts.id = taggings.taggable_id AND taggings.taggable_type = 'Blogit::Post' AND taggings.tag_id = tags.id AND tags.name IN ('one','two','three')) GROUP BY blog_posts.id ORDER BY count DESC Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_related.html.erb (32.1ms) Rendered blogit/posts/_post_footer.html.erb (33.1ms) Blogit::Comment Load (0.2ms) SELECT "blog_comments".* FROM "blog_comments" WHERE "blog_comments"."post_id" = 2 Rendered collection (0.0ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/comments/_form.html.erb (7.6ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_active_record_comments.html.erb (12.4ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/show.html.erb within layouts/application (208.7ms) Blogit::Post Load (0.2ms) SELECT "blog_posts".* FROM "blog_posts" ORDER BY created_at DESC Completed 200 OK in 271ms (Views: 254.5ms | ActiveRecord: 2.4ms) Started GET "/assets/blogit/index.css?body=1" for 127.0.0.1 at 2013-02-27 15:13:27 +0000 Served asset /blogit/index.css - 304 Not Modified (3ms) Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2013-02-27 15:13:27 +0000 Served asset /jquery_ujs.js - 304 Not Modified (6ms) Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2013-02-27 15:13:27 +0000 Served asset /application.css - 304 Not Modified (1ms) Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2013-02-27 15:13:27 +0000 Served asset /jquery.js - 304 Not Modified (2ms) Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2013-02-27 15:13:27 +0000 Served asset /application.js - 304 Not Modified (5ms) Started GET "/assets/blogit/archive.js?body=1" for 127.0.0.1 at 2013-02-27 15:13:27 +0000 Served asset /blogit/archive.js - 304 Not Modified (2ms) Started GET "/assets/blogit/index.js?body=1" for 127.0.0.1 at 2013-02-27 15:13:27 +0000 Served asset /blogit/index.js - 304 Not Modified (4ms) Started GET "/blog/posts/2-this-is-a-new-blog-post/edit" for 127.0.0.1 at 2013-02-27 15:13:29 +0000 Processing by Blogit::PostsController#edit as HTML Parameters: {"id"=>"2-this-is-a-new-blog-post"} User Load (0.2ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Blogit::Post Load (0.2ms) SELECT "blog_posts".* FROM "blog_posts" WHERE "blog_posts"."blogger_id" = 1 AND "blog_posts"."blogger_type" = 'User' AND "blog_posts"."id" = ? LIMIT 1 [["id", "2-this-is-a-new-blog-post"]] ActsAsTaggableOn::Tag Load (0.2ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_form.html.erb (6.9ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/edit.html.erb within layouts/application (8.5ms) Blogit::Post Load (0.1ms) SELECT "blog_posts".* FROM "blog_posts" ORDER BY created_at DESC Completed 200 OK in 19ms (Views: 15.0ms | ActiveRecord: 0.7ms) Started GET "/assets/blogit/index.css?body=1" for 127.0.0.1 at 2013-02-27 15:13:29 +0000 Served asset /blogit/index.css - 304 Not Modified (0ms) Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2013-02-27 15:13:29 +0000 Served asset /application.css - 304 Not Modified (0ms) Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2013-02-27 15:13:29 +0000 Served asset /jquery.js - 304 Not Modified (0ms) Started GET "/assets/blogit/archive.js?body=1" for 127.0.0.1 at 2013-02-27 15:13:29 +0000 Served asset /blogit/archive.js - 304 Not Modified (0ms) Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2013-02-27 15:13:29 +0000 Served asset /jquery_ujs.js - 304 Not Modified (0ms) Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2013-02-27 15:13:29 +0000 Served asset /application.js - 304 Not Modified (0ms) Started GET "/assets/blogit/index.js?body=1" for 127.0.0.1 at 2013-02-27 15:13:29 +0000 Served asset /blogit/index.js - 304 Not Modified (0ms) Started PUT "/blog/posts/2-this-is-a-new-blog-post" for 127.0.0.1 at 2013-02-27 15:13:30 +0000 Processing by Blogit::PostsController#update as HTML Parameters: {"utf8"=>"✓", "authenticity_token"=>"jxRC1MwFpiGworG7h3LQF5j+fflZUMuhosbM/XymGoI=", "post"=>{"title"=>"This is a new blog post", "body"=>"Thiso jfaosfja sodfj aosifj aoisdfj osaidjf aosidjfasoidj faosij", "tag_list"=>"one, two, three"}, "commit"=>"Update Post", "id"=>"2-this-is-a-new-blog-post"} This is called!! User Load (0.3ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Blogit::Post Load (0.1ms) SELECT "blog_posts".* FROM "blog_posts" WHERE "blog_posts"."blogger_id" = 1 AND "blog_posts"."blogger_type" = 'User' AND "blog_posts"."id" = ? LIMIT 1 [["id", "2-this-is-a-new-blog-post"]]  (0.1ms) begin transaction ActsAsTaggableOn::Tag Load (0.2ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) ActsAsTaggableOn::Tag Load (0.2ms) SELECT "tags".* FROM "tags" WHERE (lower(name) = 'one' OR lower(name) = 'two' OR lower(name) = 'three') CACHE (0.0ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL)  (0.1ms) commit transaction Redirected to http://localhost:3000/blog/posts/2-this-is-a-new-blog-post Completed 302 Found in 22ms (ActiveRecord: 1.0ms) Started GET "/blog/posts/2-this-is-a-new-blog-post" for 127.0.0.1 at 2013-02-27 15:13:30 +0000 Processing by Blogit::PostsController#show as HTML Parameters: {"id"=>"2-this-is-a-new-blog-post"} Blogit::Post Load (0.1ms) SELECT "blog_posts".* FROM "blog_posts" WHERE "blog_posts"."id" = ? LIMIT 1 [["id", "2-this-is-a-new-blog-post"]] Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_head.html.erb (0.7ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_body.html.erb (0.2ms) User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_links.html.erb (1.7ms) CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_blogger_information.html.erb (1.4ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post.html.erb (7.4ms) ActsAsTaggableOn::Tag Load (0.2ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) CACHE (0.0ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) Blogit::Post Load (0.2ms) SELECT blog_posts.*, COUNT(tags.id) AS count FROM blog_posts, tags, taggings WHERE (blog_posts.id != 2 AND blog_posts.id = taggings.taggable_id AND taggings.taggable_type = 'Blogit::Post' AND taggings.tag_id = tags.id AND tags.name IN ('one','two','three')) GROUP BY blog_posts.id ORDER BY count DESC Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_related.html.erb (4.4ms) Rendered blogit/posts/_post_footer.html.erb (5.2ms) Blogit::Comment Load (0.1ms) SELECT "blog_comments".* FROM "blog_comments" WHERE "blog_comments"."post_id" = 2 Rendered collection (0.0ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/comments/_form.html.erb (2.6ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_active_record_comments.html.erb (4.1ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/show.html.erb within layouts/application (19.2ms) Blogit::Post Load (0.2ms) SELECT "blog_posts".* FROM "blog_posts" ORDER BY created_at DESC Completed 200 OK in 27ms (Views: 25.4ms | ActiveRecord: 0.8ms) Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2013-02-27 15:13:31 +0000 Served asset /application.css - 304 Not Modified (0ms) Started GET "/assets/blogit/index.css?body=1" for 127.0.0.1 at 2013-02-27 15:13:31 +0000 Served asset /blogit/index.css - 304 Not Modified (0ms) Started GET "/assets/blogit/archive.js?body=1" for 127.0.0.1 at 2013-02-27 15:13:31 +0000 Served asset /blogit/archive.js - 304 Not Modified (0ms) Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2013-02-27 15:13:31 +0000 Served asset /jquery.js - 304 Not Modified (0ms) Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2013-02-27 15:13:31 +0000 Served asset /jquery_ujs.js - 304 Not Modified (0ms) Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2013-02-27 15:13:31 +0000 Served asset /application.js - 304 Not Modified (0ms) Started GET "/assets/blogit/index.js?body=1" for 127.0.0.1 at 2013-02-27 15:13:31 +0000 Served asset /blogit/index.js - 304 Not Modified (0ms) Connecting to database specified by database.yml Connecting to database specified by database.yml Connecting to database specified by database.yml Connecting to database specified by database.yml Started GET "/" for 127.0.0.1 at 2013-04-14 16:47:21 +0100 Processing by Blogit::PostsController#index as HTML User Load (0.9ms) SELECT "users".* FROM "users" WHERE "users"."id" IS NULL LIMIT 1  (0.8ms) SELECT COUNT(count_column) FROM (SELECT 1 AS count_column FROM "blog_posts" LIMIT 5 OFFSET 0) subquery_for_count Blogit::Post Load (0.2ms) SELECT "blog_posts".* FROM "blog_posts" ORDER BY created_at DESC LIMIT 5 OFFSET 0 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_head.html.erb (69.4ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_body.html.erb (0.7ms) CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" IS NULL LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_links.html.erb (1.3ms) User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_blogger_information.html.erb (19.2ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_head.html.erb (0.7ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_body.html.erb (0.2ms) CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" IS NULL LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_links.html.erb (0.6ms) CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_blogger_information.html.erb (0.9ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post.html.erb (101.2ms)  (1.1ms) SELECT COUNT(*) FROM "blog_posts" Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_pagination.html.erb (19.0ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/index.html.erb within layouts/application (150.0ms) CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" IS NULL LIMIT 1 Blogit::Post Load (0.3ms) SELECT "blog_posts".* FROM "blog_posts" ORDER BY created_at DESC Compiled jquery.js (2ms) (pid 1628) Compiled jquery_ujs.js (0ms) (pid 1628) Compiled application.js (73ms) (pid 1628) Completed 200 OK in 547ms (Views: 541.6ms | ActiveRecord: 3.9ms) Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2013-04-14 16:47:22 +0100 Served asset /application.css - 200 OK (2ms) Started GET "/assets/blogit/index.css?body=1" for 127.0.0.1 at 2013-04-14 16:47:22 +0100 Served asset /blogit/index.css - 200 OK (5ms) Started GET "/assets/blogit/archive.js?body=1" for 127.0.0.1 at 2013-04-14 16:47:22 +0100 Served asset /blogit/archive.js - 200 OK (2ms) Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2013-04-14 16:47:22 +0100 Served asset /jquery.js - 200 OK (2ms) Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2013-04-14 16:47:22 +0100 Served asset /application.js - 200 OK (5ms) Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2013-04-14 16:47:22 +0100 Served asset /jquery_ujs.js - 200 OK (2ms) Started GET "/assets/blogit/index.js?body=1" for 127.0.0.1 at 2013-04-14 16:47:22 +0100 Served asset /blogit/index.js - 200 OK (2ms) Started GET "/blog/posts/1-test-postasdfa-sdf-afas-d" for 127.0.0.1 at 2013-04-14 16:47:28 +0100 Processing by Blogit::PostsController#show as HTML Parameters: {"id"=>"1-test-postasdfa-sdf-afas-d"} Blogit::Post Load (0.3ms) SELECT "blog_posts".* FROM "blog_posts" WHERE "blog_posts"."id" = ? LIMIT 1 [["id", "1-test-postasdfa-sdf-afas-d"]] Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_head.html.erb (0.8ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_body.html.erb (0.3ms) User Load (0.2ms) SELECT "users".* FROM "users" WHERE "users"."id" IS NULL LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_links.html.erb (0.9ms) User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_blogger_information.html.erb (1.4ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post.html.erb (7.5ms) ActsAsTaggableOn::Tag Load (18.1ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 1 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) CACHE (0.0ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 1 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) Blogit::Post Load (2.4ms) SELECT blog_posts.*, COUNT(tags.id) AS count FROM blog_posts, tags, taggings WHERE (blog_posts.id != 1 AND blog_posts.id = taggings.taggable_id AND taggings.taggable_type = 'Blogit::Post' AND taggings.tag_id = tags.id AND tags.name IN (NULL)) GROUP BY blog_posts.id ORDER BY count DESC Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_related.html.erb (145.2ms) Rendered blogit/posts/_post_footer.html.erb (146.3ms) Blogit::Comment Load (0.8ms) SELECT "blog_comments".* FROM "blog_comments" WHERE "blog_comments"."post_id" = 1 Rendered collection (0.0ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/comments/_form.html.erb (4.1ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_active_record_comments.html.erb (8.1ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/show.html.erb within layouts/application (179.1ms) CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" IS NULL LIMIT 1 Blogit::Post Load (0.2ms) SELECT "blog_posts".* FROM "blog_posts" ORDER BY created_at DESC Completed 200 OK in 189ms (Views: 164.7ms | ActiveRecord: 22.6ms) Started GET "/blog/posts/1-test-postasdfa-sdf-afas-d" for 127.0.0.1 at 2013-04-14 16:47:39 +0100 Processing by Blogit::PostsController#show as HTML Parameters: {"id"=>"1-test-postasdfa-sdf-afas-d"} Blogit::Post Load (0.2ms) SELECT "blog_posts".* FROM "blog_posts" WHERE "blog_posts"."id" = ? LIMIT 1 [["id", "1-test-postasdfa-sdf-afas-d"]] Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_head.html.erb (0.7ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_body.html.erb (0.4ms) User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" IS NULL LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_links.html.erb (0.7ms) User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_blogger_information.html.erb (2.1ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post.html.erb (8.7ms) ActsAsTaggableOn::Tag Load (0.1ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 1 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) CACHE (0.0ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 1 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) Blogit::Post Load (0.2ms) SELECT blog_posts.*, COUNT(tags.id) AS count FROM blog_posts, tags, taggings WHERE (blog_posts.id != 1 AND blog_posts.id = taggings.taggable_id AND taggings.taggable_type = 'Blogit::Post' AND taggings.tag_id = tags.id AND tags.name IN (NULL)) GROUP BY blog_posts.id ORDER BY count DESC Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_related.html.erb (3.1ms) Rendered blogit/posts/_post_footer.html.erb (3.8ms) Blogit::Comment Load (0.1ms) SELECT "blog_comments".* FROM "blog_comments" WHERE "blog_comments"."post_id" = 1 Rendered collection (0.0ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/comments/_form.html.erb (2.8ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_active_record_comments.html.erb (4.3ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/show.html.erb within layouts/application (19.4ms) CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" IS NULL LIMIT 1 Blogit::Post Load (0.1ms) SELECT "blog_posts".* FROM "blog_posts" ORDER BY created_at DESC Completed 200 OK in 29ms (Views: 26.8ms | ActiveRecord: 1.1ms) Started GET "/assets/blogit/index.css?body=1" for 127.0.0.1 at 2013-04-14 16:47:39 +0100 Served asset /blogit/index.css - 304 Not Modified (0ms) Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2013-04-14 16:47:39 +0100 Served asset /application.js - 304 Not Modified (0ms) Started GET "/assets/blogit/archive.js?body=1" for 127.0.0.1 at 2013-04-14 16:47:39 +0100 Served asset /blogit/archive.js - 304 Not Modified (0ms) Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2013-04-14 16:47:39 +0100 Served asset /jquery.js - 304 Not Modified (0ms) Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2013-04-14 16:47:39 +0100 Served asset /jquery_ujs.js - 304 Not Modified (0ms) Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2013-04-14 16:47:39 +0100 Served asset /application.css - 304 Not Modified (0ms) Started GET "/assets/blogit/index.js?body=1" for 127.0.0.1 at 2013-04-14 16:47:39 +0100 Served asset /blogit/index.js - 304 Not Modified (0ms) Started GET "/blog/posts/1-test-postasdfa-sdf-afas-d" for 127.0.0.1 at 2013-04-14 16:49:14 +0100 Processing by Blogit::PostsController#show as HTML Parameters: {"id"=>"1-test-postasdfa-sdf-afas-d"} Blogit::Post Load (0.1ms) SELECT "blog_posts".* FROM "blog_posts" WHERE "blog_posts"."id" = ? LIMIT 1 [["id", "1-test-postasdfa-sdf-afas-d"]] Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_head.html.erb (0.9ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_body.html.erb (0.4ms) User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" IS NULL LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_links.html.erb (0.9ms) User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_blogger_information.html.erb (2.5ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post.html.erb (8.6ms) ActsAsTaggableOn::Tag Load (0.2ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 1 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) CACHE (0.0ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 1 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) Blogit::Post Load (0.2ms) SELECT blog_posts.*, COUNT(tags.id) AS count FROM blog_posts, tags, taggings WHERE (blog_posts.id != 1 AND blog_posts.id = taggings.taggable_id AND taggings.taggable_type = 'Blogit::Post' AND taggings.tag_id = tags.id AND tags.name IN (NULL)) GROUP BY blog_posts.id ORDER BY count DESC Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_related.html.erb (3.6ms) Rendered blogit/posts/_post_footer.html.erb (4.5ms) Blogit::Comment Load (0.2ms) SELECT "blog_comments".* FROM "blog_comments" WHERE "blog_comments"."post_id" = 1 Rendered collection (0.0ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/comments/_form.html.erb (2.8ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_active_record_comments.html.erb (5.0ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/show.html.erb within layouts/application (21.0ms) CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" IS NULL LIMIT 1 Blogit::Post Load (0.2ms) SELECT "blog_posts".* FROM "blog_posts" ORDER BY created_at DESC Completed 200 OK in 29ms (Views: 27.2ms | ActiveRecord: 1.1ms) Started GET "/assets/blogit/index.css?body=1" for 127.0.0.1 at 2013-04-14 16:49:15 +0100 Served asset /blogit/index.css - 304 Not Modified (0ms) Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2013-04-14 16:49:15 +0100 Served asset /jquery.js - 304 Not Modified (0ms) Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2013-04-14 16:49:15 +0100 Served asset /application.css - 304 Not Modified (0ms) Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2013-04-14 16:49:15 +0100 Served asset /application.js - 304 Not Modified (0ms) Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2013-04-14 16:49:15 +0100 Served asset /jquery_ujs.js - 304 Not Modified (0ms) Started GET "/assets/blogit/archive.js?body=1" for 127.0.0.1 at 2013-04-14 16:49:15 +0100 Served asset /blogit/archive.js - 304 Not Modified (0ms) Started GET "/assets/blogit/index.js?body=1" for 127.0.0.1 at 2013-04-14 16:49:15 +0100 Served asset /blogit/index.js - 304 Not Modified (0ms) Started GET "/blog/posts/1-test-postasdfa-sdf-afas-d" for 127.0.0.1 at 2013-04-14 16:50:22 +0100 Processing by Blogit::PostsController#show as HTML Parameters: {"id"=>"1-test-postasdfa-sdf-afas-d"} Blogit::Post Load (0.2ms) SELECT "blog_posts".* FROM "blog_posts" WHERE "blog_posts"."id" = ? LIMIT 1 [["id", "1-test-postasdfa-sdf-afas-d"]] Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_head.html.erb (0.8ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_body.html.erb (0.3ms) User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" IS NULL LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_links.html.erb (0.7ms) User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_blogger_information.html.erb (1.5ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post.html.erb (7.1ms) ActsAsTaggableOn::Tag Load (0.2ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 1 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) CACHE (0.0ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 1 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) Blogit::Post Load (0.3ms) SELECT blog_posts.*, COUNT(tags.id) AS count FROM blog_posts, tags, taggings WHERE (blog_posts.id != 1 AND blog_posts.id = taggings.taggable_id AND taggings.taggable_type = 'Blogit::Post' AND taggings.tag_id = tags.id AND tags.name IN (NULL)) GROUP BY blog_posts.id ORDER BY count DESC Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_related.html.erb (4.2ms) Rendered blogit/posts/_post_footer.html.erb (4.9ms) Blogit::Comment Load (0.1ms) SELECT "blog_comments".* FROM "blog_comments" WHERE "blog_comments"."post_id" = 1 Rendered collection (0.0ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/comments/_form.html.erb (21.0ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_active_record_comments.html.erb (23.0ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/show.html.erb within layouts/application (38.0ms) CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" IS NULL LIMIT 1 Blogit::Post Load (0.1ms) SELECT "blog_posts".* FROM "blog_posts" ORDER BY created_at DESC Completed 200 OK in 46ms (Views: 43.8ms | ActiveRecord: 1.2ms) Started GET "/assets/blogit/index.css?body=1" for 127.0.0.1 at 2013-04-14 16:50:22 +0100 Served asset /blogit/index.css - 304 Not Modified (0ms) Started GET "/assets/blogit/archive.js?body=1" for 127.0.0.1 at 2013-04-14 16:50:22 +0100 Served asset /blogit/archive.js - 304 Not Modified (0ms) Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2013-04-14 16:50:22 +0100 Served asset /application.css - 304 Not Modified (0ms) Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2013-04-14 16:50:22 +0100 Served asset /jquery.js - 304 Not Modified (0ms) Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2013-04-14 16:50:22 +0100 Served asset /jquery_ujs.js - 304 Not Modified (0ms) Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2013-04-14 16:50:22 +0100 Served asset /application.js - 304 Not Modified (0ms) Started GET "/assets/blogit/index.js?body=1" for 127.0.0.1 at 2013-04-14 16:50:23 +0100 Served asset /blogit/index.js - 304 Not Modified (0ms) Started POST "/blog/posts/1-test-postasdfa-sdf-afas-d/comments" for 127.0.0.1 at 2013-04-14 16:50:38 +0100 Processing by Blogit::CommentsController#create as JS Parameters: {"utf8"=>"✓", "authenticity_token"=>"jN8I9fQRhk9tLtrnPuj62NZ/PU+sJEjqCAA+7JvVdD0=", "comment"=>{"nickname"=>"", "name"=>"Gavin", "email"=>"gavin@gavinmorrice.com", "website"=>"www.gavinmorrice.com", "body"=>"This is a test comment"}, "commit"=>"Add Comment", "post_id"=>"1-test-postasdfa-sdf-afas-d"} Blogit::Post Load (0.1ms) SELECT "blog_posts".* FROM "blog_posts" WHERE "blog_posts"."id" = ? LIMIT 1 [["id", "1-test-postasdfa-sdf-afas-d"]]  (0.0ms) begin transaction SQL (12.6ms) INSERT INTO "blog_comments" ("body", "created_at", "email", "name", "post_id", "state", "updated_at", "website") VALUES (?, ?, ?, ?, ?, ?, ?, ?) [["body", "This is a test comment"], ["created_at", Sun, 14 Apr 2013 15:50:38 UTC +00:00], ["email", "gavin@gavinmorrice.com"], ["name", "Gavin"], ["post_id", 1], ["state", nil], ["updated_at", Sun, 14 Apr 2013 15:50:38 UTC +00:00], ["website", "http://www.gavinmorrice.com"]] Blogit::Post Load (0.1ms) SELECT "blog_posts".* FROM "blog_posts" WHERE "blog_posts"."id" = 1 LIMIT 1 SQL (0.2ms) UPDATE "blog_posts" SET "comments_count" = COALESCE("comments_count", 0) + 1 WHERE "blog_posts"."id" = 1 SQL (0.3ms) UPDATE "blog_posts" SET "updated_at" = '2013-04-14 15:50:38.843193' WHERE "blog_posts"."id" = 1  (24.5ms) commit transaction  (0.1ms) begin transaction SQL (0.3ms) UPDATE "blog_posts" SET "updated_at" = '2013-04-14 15:50:38.875781' WHERE "blog_posts"."id" = 1  (3.9ms) commit transaction User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" IS NULL LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/comments/_admin_links.html.erb (1.1ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/comments/_comment.html.erb (3.7ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/comments/create.js.erb (11.9ms) Completed 200 OK in 65ms (Views: 12.0ms | ActiveRecord: 42.3ms) Started GET "/blog/posts/1-test-postasdfa-sdf-afas-d" for 127.0.0.1 at 2013-04-14 16:51:20 +0100 Processing by Blogit::PostsController#show as HTML Parameters: {"id"=>"1-test-postasdfa-sdf-afas-d"} Blogit::Post Load (0.1ms) SELECT "blog_posts".* FROM "blog_posts" WHERE "blog_posts"."id" = ? LIMIT 1 [["id", "1-test-postasdfa-sdf-afas-d"]] Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_head.html.erb (0.7ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_body.html.erb (0.2ms) User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" IS NULL LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_links.html.erb (0.6ms) User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_blogger_information.html.erb (1.3ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post.html.erb (5.7ms) ActsAsTaggableOn::Tag Load (0.2ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 1 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) CACHE (0.0ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 1 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) Blogit::Post Load (0.2ms) SELECT blog_posts.*, COUNT(tags.id) AS count FROM blog_posts, tags, taggings WHERE (blog_posts.id != 1 AND blog_posts.id = taggings.taggable_id AND taggings.taggable_type = 'Blogit::Post' AND taggings.tag_id = tags.id AND tags.name IN (NULL)) GROUP BY blog_posts.id ORDER BY count DESC Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_related.html.erb (3.0ms) Rendered blogit/posts/_post_footer.html.erb (3.9ms) Blogit::Comment Load (0.1ms) SELECT "blog_comments".* FROM "blog_comments" WHERE "blog_comments"."post_id" = 1 CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" IS NULL LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/comments/_admin_links.html.erb (1.0ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/comments/_comment.html.erb (3.4ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/comments/_form.html.erb (2.5ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_active_record_comments.html.erb (9.2ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/show.html.erb within layouts/application (21.4ms) CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" IS NULL LIMIT 1 Blogit::Post Load (0.2ms) SELECT "blog_posts".* FROM "blog_posts" ORDER BY created_at DESC Completed 200 OK in 29ms (Views: 27.1ms | ActiveRecord: 1.0ms) Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2013-04-14 16:51:20 +0100 Served asset /jquery_ujs.js - 304 Not Modified (0ms) Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2013-04-14 16:51:20 +0100 Served asset /application.css - 304 Not Modified (0ms) Started GET "/assets/blogit/index.css?body=1" for 127.0.0.1 at 2013-04-14 16:51:20 +0100 Served asset /blogit/index.css - 304 Not Modified (0ms) Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2013-04-14 16:51:20 +0100 Served asset /application.js - 304 Not Modified (0ms) Started GET "/assets/blogit/archive.js?body=1" for 127.0.0.1 at 2013-04-14 16:51:20 +0100 Served asset /blogit/archive.js - 304 Not Modified (0ms) Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2013-04-14 16:51:20 +0100 Served asset /jquery.js - 304 Not Modified (0ms) Started GET "/assets/blogit/index.js?body=1" for 127.0.0.1 at 2013-04-14 16:51:20 +0100 Served asset /blogit/index.js - 304 Not Modified (0ms) Started GET "/blog/posts/1-test-postasdfa-sdf-afas-d" for 127.0.0.1 at 2013-04-14 16:51:48 +0100 Processing by Blogit::PostsController#show as HTML Parameters: {"id"=>"1-test-postasdfa-sdf-afas-d"} Blogit::Post Load (0.1ms) SELECT "blog_posts".* FROM "blog_posts" WHERE "blog_posts"."id" = ? LIMIT 1 [["id", "1-test-postasdfa-sdf-afas-d"]] Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_head.html.erb (0.9ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_body.html.erb (0.3ms) User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" IS NULL LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_links.html.erb (0.8ms) User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_blogger_information.html.erb (1.7ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post.html.erb (7.5ms) ActsAsTaggableOn::Tag Load (0.2ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 1 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) CACHE (0.0ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 1 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) Blogit::Post Load (0.3ms) SELECT blog_posts.*, COUNT(tags.id) AS count FROM blog_posts, tags, taggings WHERE (blog_posts.id != 1 AND blog_posts.id = taggings.taggable_id AND taggings.taggable_type = 'Blogit::Post' AND taggings.tag_id = tags.id AND tags.name IN (NULL)) GROUP BY blog_posts.id ORDER BY count DESC Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_related.html.erb (3.4ms) Rendered blogit/posts/_post_footer.html.erb (4.2ms) Blogit::Comment Load (0.2ms) SELECT "blog_comments".* FROM "blog_comments" WHERE "blog_comments"."post_id" = 1 CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" IS NULL LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/comments/_admin_links.html.erb (0.6ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/comments/_comment.html.erb (3.1ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/comments/_form.html.erb (3.0ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_active_record_comments.html.erb (9.6ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/show.html.erb within layouts/application (24.2ms) CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" IS NULL LIMIT 1 Blogit::Post Load (0.2ms) SELECT "blog_posts".* FROM "blog_posts" ORDER BY created_at DESC Completed 200 OK in 34ms (Views: 31.6ms | ActiveRecord: 1.2ms) Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2013-04-14 16:51:48 +0100 Served asset /application.css - 304 Not Modified (0ms) Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2013-04-14 16:51:48 +0100 Served asset /jquery.js - 304 Not Modified (0ms) Started GET "/assets/blogit/index.css?body=1" for 127.0.0.1 at 2013-04-14 16:51:48 +0100 Served asset /blogit/index.css - 304 Not Modified (0ms) Started GET "/assets/blogit/archive.js?body=1" for 127.0.0.1 at 2013-04-14 16:51:48 +0100 Served asset /blogit/archive.js - 304 Not Modified (0ms) Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2013-04-14 16:51:48 +0100 Served asset /jquery_ujs.js - 304 Not Modified (0ms) Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2013-04-14 16:51:48 +0100 Served asset /application.js - 304 Not Modified (0ms) Started GET "/assets/blogit/index.js?body=1" for 127.0.0.1 at 2013-04-14 16:51:48 +0100 Served asset /blogit/index.js - 304 Not Modified (0ms) Started GET "/blog/posts/1-test-postasdfa-sdf-afas-d" for 127.0.0.1 at 2013-04-14 16:58:48 +0100 Processing by Blogit::PostsController#show as HTML Parameters: {"id"=>"1-test-postasdfa-sdf-afas-d"} Blogit::Post Load (0.2ms) SELECT "blog_posts".* FROM "blog_posts" WHERE "blog_posts"."id" = ? LIMIT 1 [["id", "1-test-postasdfa-sdf-afas-d"]] Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_head.html.erb (0.9ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_body.html.erb (0.3ms) User Load (0.2ms) SELECT "users".* FROM "users" WHERE "users"."id" IS NULL LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_links.html.erb (0.9ms) User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_blogger_information.html.erb (1.5ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post.html.erb (7.4ms) ActsAsTaggableOn::Tag Load (0.1ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 1 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) CACHE (0.0ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 1 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) Blogit::Post Load (0.2ms) SELECT blog_posts.*, COUNT(tags.id) AS count FROM blog_posts, tags, taggings WHERE (blog_posts.id != 1 AND blog_posts.id = taggings.taggable_id AND taggings.taggable_type = 'Blogit::Post' AND taggings.tag_id = tags.id AND tags.name IN (NULL)) GROUP BY blog_posts.id ORDER BY count DESC Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_related.html.erb (2.8ms) Rendered blogit/posts/_post_footer.html.erb (3.4ms) Blogit::Comment Load (0.2ms) SELECT "blog_comments".* FROM "blog_comments" WHERE "blog_comments"."post_id" = 1 CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" IS NULL LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/comments/_admin_links.html.erb (0.6ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/comments/_comment.html.erb (3.3ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/comments/_form.html.erb (2.4ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_active_record_comments.html.erb (8.5ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/show.html.erb within layouts/application (21.9ms) CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" IS NULL LIMIT 1 Blogit::Post Load (0.2ms) SELECT "blog_posts".* FROM "blog_posts" ORDER BY created_at DESC Completed 200 OK in 31ms (Views: 28.8ms | ActiveRecord: 1.1ms) Started GET "/assets/blogit/index.css?body=1" for 127.0.0.1 at 2013-04-14 16:58:48 +0100 Served asset /blogit/index.css - 304 Not Modified (0ms) Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2013-04-14 16:58:48 +0100 Served asset /application.css - 304 Not Modified (0ms) Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2013-04-14 16:58:48 +0100 Served asset /jquery.js - 304 Not Modified (0ms) Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2013-04-14 16:58:48 +0100 Served asset /application.js - 304 Not Modified (0ms) Started GET "/assets/blogit/archive.js?body=1" for 127.0.0.1 at 2013-04-14 16:58:48 +0100 Served asset /blogit/archive.js - 304 Not Modified (0ms) Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2013-04-14 16:58:48 +0100 Served asset /jquery_ujs.js - 304 Not Modified (0ms) Started GET "/assets/blogit/index.js?body=1" for 127.0.0.1 at 2013-04-14 16:58:48 +0100 Served asset /blogit/index.js - 304 Not Modified (0ms) Started GET "/blog/posts/1-test-postasdfa-sdf-afas-d" for 127.0.0.1 at 2013-04-14 17:04:36 +0100 Processing by Blogit::PostsController#show as HTML Parameters: {"id"=>"1-test-postasdfa-sdf-afas-d"} Blogit::Post Load (0.1ms) SELECT "blog_posts".* FROM "blog_posts" WHERE "blog_posts"."id" = ? LIMIT 1 [["id", "1-test-postasdfa-sdf-afas-d"]] Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_head.html.erb (1.9ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_body.html.erb (0.3ms) User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" IS NULL LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_links.html.erb (6.0ms) User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_blogger_information.html.erb (5.4ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post.html.erb (17.1ms) ActsAsTaggableOn::Tag Load (0.1ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 1 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) CACHE (0.0ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 1 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) Blogit::Post Load (0.2ms) SELECT blog_posts.*, COUNT(tags.id) AS count FROM blog_posts, tags, taggings WHERE (blog_posts.id != 1 AND blog_posts.id = taggings.taggable_id AND taggings.taggable_type = 'Blogit::Post' AND taggings.tag_id = tags.id AND tags.name IN (NULL)) GROUP BY blog_posts.id ORDER BY count DESC Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_related.html.erb (6.6ms) Rendered blogit/posts/_post_footer.html.erb (7.3ms) Blogit::Comment Load (0.2ms) SELECT "blog_comments".* FROM "blog_comments" WHERE "blog_comments"."post_id" = 1 CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" IS NULL LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/comments/_admin_links.html.erb (0.5ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/comments/_comment.html.erb (2.9ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/comments/_form.html.erb (3.0ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_active_record_comments.html.erb (10.7ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/show.html.erb within layouts/application (51.5ms) CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" IS NULL LIMIT 1 Blogit::Post Load (0.2ms) SELECT "blog_posts".* FROM "blog_posts" ORDER BY created_at DESC Completed 200 OK in 84ms (Views: 57.2ms | ActiveRecord: 2.0ms) Started GET "/assets/blogit/index.css?body=1" for 127.0.0.1 at 2013-04-14 17:04:36 +0100 Served asset /blogit/index.css - 304 Not Modified (0ms) Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2013-04-14 17:04:36 +0100 Served asset /application.js - 304 Not Modified (0ms) Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2013-04-14 17:04:36 +0100 Served asset /application.css - 304 Not Modified (0ms) Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2013-04-14 17:04:36 +0100 Served asset /jquery.js - 304 Not Modified (0ms) Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2013-04-14 17:04:36 +0100 Served asset /jquery_ujs.js - 304 Not Modified (0ms) Started GET "/assets/blogit/archive.js?body=1" for 127.0.0.1 at 2013-04-14 17:04:36 +0100 Served asset /blogit/archive.js - 304 Not Modified (0ms) Started GET "/assets/blogit/index.js?body=1" for 127.0.0.1 at 2013-04-14 17:04:36 +0100 Served asset /blogit/index.js - 304 Not Modified (0ms) Started GET "/blog/posts/1-test-postasdfa-sdf-afas-d" for 127.0.0.1 at 2013-04-14 17:05:30 +0100 Processing by Blogit::PostsController#show as HTML Parameters: {"id"=>"1-test-postasdfa-sdf-afas-d"} Blogit::Post Load (0.1ms) SELECT "blog_posts".* FROM "blog_posts" WHERE "blog_posts"."id" = ? LIMIT 1 [["id", "1-test-postasdfa-sdf-afas-d"]] Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_head.html.erb (1.2ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_body.html.erb (0.2ms) User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" IS NULL LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_links.html.erb (6.1ms) User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_blogger_information.html.erb (13.6ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post.html.erb (24.2ms) ActsAsTaggableOn::Tag Load (0.1ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 1 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) CACHE (0.0ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 1 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) Blogit::Post Load (0.2ms) SELECT blog_posts.*, COUNT(tags.id) AS count FROM blog_posts, tags, taggings WHERE (blog_posts.id != 1 AND blog_posts.id = taggings.taggable_id AND taggings.taggable_type = 'Blogit::Post' AND taggings.tag_id = tags.id AND tags.name IN (NULL)) GROUP BY blog_posts.id ORDER BY count DESC Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_related.html.erb (7.2ms) Rendered blogit/posts/_post_footer.html.erb (7.9ms) Blogit::Comment Load (0.2ms) SELECT "blog_comments".* FROM "blog_comments" WHERE "blog_comments"."post_id" = 1 CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" IS NULL LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/comments/_admin_links.html.erb (0.5ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/comments/_comment.html.erb (2.1ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/comments/_form.html.erb (3.2ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_active_record_comments.html.erb (9.2ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/show.html.erb within layouts/application (58.6ms) CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" IS NULL LIMIT 1 Blogit::Post Load (0.2ms) SELECT "blog_posts".* FROM "blog_posts" ORDER BY created_at DESC Completed 200 OK in 72ms (Views: 63.5ms | ActiveRecord: 1.9ms) Started GET "/assets/blogit/index.css?body=1" for 127.0.0.1 at 2013-04-14 17:05:30 +0100 Served asset /blogit/index.css - 304 Not Modified (0ms) Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2013-04-14 17:05:30 +0100 Served asset /jquery_ujs.js - 304 Not Modified (0ms) Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2013-04-14 17:05:30 +0100 Served asset /application.css - 304 Not Modified (0ms) Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2013-04-14 17:05:30 +0100 Served asset /application.js - 304 Not Modified (0ms) Started GET "/assets/blogit/archive.js?body=1" for 127.0.0.1 at 2013-04-14 17:05:30 +0100 Served asset /blogit/archive.js - 304 Not Modified (0ms) Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2013-04-14 17:05:30 +0100 Served asset /jquery.js - 304 Not Modified (0ms) Started GET "/assets/blogit/index.js?body=1" for 127.0.0.1 at 2013-04-14 17:05:30 +0100 Served asset /blogit/index.js - 304 Not Modified (0ms) Started POST "/blog/posts/1-test-postasdfa-sdf-afas-d/comments" for 127.0.0.1 at 2013-04-14 17:07:49 +0100 Processing by Blogit::CommentsController#create as JS Parameters: {"utf8"=>"✓", "authenticity_token"=>"jN8I9fQRhk9tLtrnPuj62NZ/PU+sJEjqCAA+7JvVdD0=", "comment"=>{"nickname"=>"", "name"=>"Cornelius", "email"=>"gavin@gavinmorrice.com", "website"=>"", "body"=>"THis is a comment"}, "commit"=>"Add Comment", "post_id"=>"1-test-postasdfa-sdf-afas-d"} Blogit::Post Load (0.1ms) SELECT "blog_posts".* FROM "blog_posts" WHERE "blog_posts"."id" = ? LIMIT 1 [["id", "1-test-postasdfa-sdf-afas-d"]]  (0.1ms) begin transaction SQL (0.5ms) INSERT INTO "blog_comments" ("body", "created_at", "email", "name", "post_id", "state", "updated_at", "website") VALUES (?, ?, ?, ?, ?, ?, ?, ?) [["body", "THis is a comment"], ["created_at", Sun, 14 Apr 2013 16:07:49 UTC +00:00], ["email", "gavin@gavinmorrice.com"], ["name", "Cornelius"], ["post_id", 1], ["state", nil], ["updated_at", Sun, 14 Apr 2013 16:07:49 UTC +00:00], ["website", ""]] Blogit::Post Load (0.1ms) SELECT "blog_posts".* FROM "blog_posts" WHERE "blog_posts"."id" = 1 LIMIT 1 SQL (0.1ms) UPDATE "blog_posts" SET "comments_count" = COALESCE("comments_count", 0) + 1 WHERE "blog_posts"."id" = 1 SQL (0.2ms) UPDATE "blog_posts" SET "updated_at" = '2013-04-14 16:07:49.717094' WHERE "blog_posts"."id" = 1  (54.4ms) commit transaction  (0.1ms) begin transaction SQL (0.3ms) UPDATE "blog_posts" SET "updated_at" = '2013-04-14 16:07:49.778509' WHERE "blog_posts"."id" = 1  (3.9ms) commit transaction User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" IS NULL LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/comments/_admin_links.html.erb (0.8ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/comments/_comment.html.erb (3.4ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/comments/create.js.erb (10.8ms) Completed 200 OK in 94ms (Views: 11.0ms | ActiveRecord: 59.9ms) Connecting to database specified by database.yml Connecting to database specified by database.yml Started GET "/blog/posts/1-test-postasdfa-sdf-afas-d" for 127.0.0.1 at 2013-04-14 17:26:25 +0100 Processing by Blogit::PostsController#show as HTML Parameters: {"id"=>"1-test-postasdfa-sdf-afas-d"} Blogit::Post Load (0.3ms) SELECT "blog_posts".* FROM "blog_posts" WHERE "blog_posts"."id" = ? LIMIT 1 [["id", "1-test-postasdfa-sdf-afas-d"]] Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_head.html.erb (73.6ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_body.html.erb (0.7ms) User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" IS NULL LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_links.html.erb (15.3ms) User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_blogger_information.html.erb (20.9ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post.html.erb (115.4ms) ActsAsTaggableOn::Tag Load (0.1ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 1 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) CACHE (0.0ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 1 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) Blogit::Post Load (0.3ms) SELECT blog_posts.*, COUNT(tags.id) AS count FROM blog_posts, tags, taggings WHERE (blog_posts.id != 1 AND blog_posts.id = taggings.taggable_id AND taggings.taggable_type = 'Blogit::Post' AND taggings.tag_id = tags.id AND tags.name IN (NULL)) GROUP BY blog_posts.id ORDER BY count DESC Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_related.html.erb (43.5ms) Rendered blogit/posts/_post_footer.html.erb (44.6ms) Blogit::Comment Load (0.2ms) SELECT "blog_comments".* FROM "blog_comments" WHERE "blog_comments"."post_id" = 1 CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" IS NULL LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/comments/_admin_links.html.erb (1.1ms) CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" IS NULL LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/comments/_admin_links.html.erb (0.3ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/comments/_comment.html.erb (6.2ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/comments/_form.html.erb (7.4ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_active_record_comments.html.erb (18.3ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/show.html.erb within layouts/application (202.8ms) CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" IS NULL LIMIT 1 Blogit::Post Load (0.2ms) SELECT "blog_posts".* FROM "blog_posts" ORDER BY created_at DESC Completed 200 OK in 244ms (Views: 231.8ms | ActiveRecord: 2.6ms) Started GET "/assets/blogit/index.css?body=1" for 127.0.0.1 at 2013-04-14 17:26:26 +0100 Served asset /blogit/index.css - 304 Not Modified (3ms) Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2013-04-14 17:26:26 +0100 Served asset /application.css - 304 Not Modified (3ms) Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2013-04-14 17:26:26 +0100 Served asset /jquery.js - 304 Not Modified (4ms) Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2013-04-14 17:26:26 +0100 Served asset /application.js - 304 Not Modified (4ms) Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2013-04-14 17:26:26 +0100 Served asset /jquery_ujs.js - 304 Not Modified (1ms) Started GET "/assets/blogit/archive.js?body=1" for 127.0.0.1 at 2013-04-14 17:26:26 +0100 Served asset /blogit/archive.js - 304 Not Modified (1ms) Started GET "/assets/blogit/index.js?body=1" for 127.0.0.1 at 2013-04-14 17:26:26 +0100 Served asset /blogit/index.js - 304 Not Modified (3ms) Started GET "/blog/posts/1-test-postasdfa-sdf-afas-d" for 127.0.0.1 at 2013-04-14 17:26:29 +0100 Processing by Blogit::PostsController#show as HTML Parameters: {"id"=>"1-test-postasdfa-sdf-afas-d"} Blogit::Post Load (0.1ms) SELECT "blog_posts".* FROM "blog_posts" WHERE "blog_posts"."id" = ? LIMIT 1 [["id", "1-test-postasdfa-sdf-afas-d"]] Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_head.html.erb (0.9ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_body.html.erb (0.3ms) User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" IS NULL LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_links.html.erb (0.8ms) User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_blogger_information.html.erb (1.6ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post.html.erb (7.4ms) ActsAsTaggableOn::Tag Load (0.2ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 1 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) CACHE (0.0ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 1 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) Blogit::Post Load (0.3ms) SELECT blog_posts.*, COUNT(tags.id) AS count FROM blog_posts, tags, taggings WHERE (blog_posts.id != 1 AND blog_posts.id = taggings.taggable_id AND taggings.taggable_type = 'Blogit::Post' AND taggings.tag_id = tags.id AND tags.name IN (NULL)) GROUP BY blog_posts.id ORDER BY count DESC Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_related.html.erb (2.8ms) Rendered blogit/posts/_post_footer.html.erb (3.6ms) Blogit::Comment Load (0.2ms) SELECT "blog_comments".* FROM "blog_comments" WHERE "blog_comments"."post_id" = 1 CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" IS NULL LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/comments/_admin_links.html.erb (0.5ms) CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" IS NULL LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/comments/_admin_links.html.erb (0.3ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/comments/_comment.html.erb (4.6ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/comments/_form.html.erb (3.0ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_active_record_comments.html.erb (9.7ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/show.html.erb within layouts/application (23.3ms) CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" IS NULL LIMIT 1 Blogit::Post Load (0.2ms) SELECT "blog_posts".* FROM "blog_posts" ORDER BY created_at DESC Completed 200 OK in 32ms (Views: 30.2ms | ActiveRecord: 1.2ms) Started GET "/assets/blogit/index.css?body=1" for 127.0.0.1 at 2013-04-14 17:26:29 +0100 Served asset /blogit/index.css - 304 Not Modified (0ms) Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2013-04-14 17:26:29 +0100 Served asset /jquery.js - 304 Not Modified (0ms) Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2013-04-14 17:26:29 +0100 Served asset /jquery_ujs.js - 304 Not Modified (0ms) Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2013-04-14 17:26:29 +0100 Served asset /application.js - 304 Not Modified (0ms) Started GET "/assets/blogit/archive.js?body=1" for 127.0.0.1 at 2013-04-14 17:26:29 +0100 Served asset /blogit/archive.js - 304 Not Modified (0ms) Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2013-04-14 17:26:29 +0100 Served asset /application.css - 304 Not Modified (0ms) Started GET "/assets/blogit/index.js?body=1" for 127.0.0.1 at 2013-04-14 17:26:29 +0100 Served asset /blogit/index.js - 304 Not Modified (0ms) Started GET "/blog/" for 127.0.0.1 at 2013-04-14 17:26:32 +0100 Processing by Blogit::PostsController#index as HTML User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" IS NULL LIMIT 1  (0.2ms) SELECT COUNT(count_column) FROM (SELECT 1 AS count_column FROM "blog_posts" LIMIT 5 OFFSET 0) subquery_for_count Blogit::Post Load (0.1ms) SELECT "blog_posts".* FROM "blog_posts" ORDER BY created_at DESC LIMIT 5 OFFSET 0 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_head.html.erb (0.7ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_body.html.erb (0.4ms) CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" IS NULL LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_links.html.erb (0.9ms) User Load (0.2ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_blogger_information.html.erb (1.8ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_head.html.erb (0.7ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_body.html.erb (0.3ms) CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" IS NULL LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_links.html.erb (0.4ms) CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_blogger_information.html.erb (1.3ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post.html.erb (15.2ms)  (0.1ms) SELECT COUNT(*) FROM "blog_posts" Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_pagination.html.erb (3.0ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/index.html.erb within layouts/application (23.3ms) CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" IS NULL LIMIT 1 Blogit::Post Load (0.1ms) SELECT "blog_posts".* FROM "blog_posts" ORDER BY created_at DESC Completed 200 OK in 32ms (Views: 29.9ms | ActiveRecord: 0.8ms) Started GET "/assets/blogit/index.css?body=1" for 127.0.0.1 at 2013-04-14 17:26:32 +0100 Served asset /blogit/index.css - 304 Not Modified (0ms) Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2013-04-14 17:26:32 +0100 Served asset /jquery.js - 304 Not Modified (0ms) Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2013-04-14 17:26:32 +0100 Served asset /jquery_ujs.js - 304 Not Modified (0ms) Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2013-04-14 17:26:32 +0100 Served asset /application.css - 304 Not Modified (0ms) Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2013-04-14 17:26:32 +0100 Served asset /application.js - 304 Not Modified (0ms) Started GET "/assets/blogit/archive.js?body=1" for 127.0.0.1 at 2013-04-14 17:26:32 +0100 Served asset /blogit/archive.js - 304 Not Modified (0ms) Started GET "/assets/blogit/index.js?body=1" for 127.0.0.1 at 2013-04-14 17:26:32 +0100 Served asset /blogit/index.js - 304 Not Modified (0ms) Started GET "/session/new" for 127.0.0.1 at 2013-04-14 17:26:44 +0100 Processing by SessionsController#new as HTML Rendered sessions/new.html.erb within layouts/application (1.4ms) User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" IS NULL LIMIT 1 Completed 500 Internal Server Error in 85ms ActionView::Template::Error (undefined local variable or method `blog_root_path' for #<#:0x007fc0d598f7b8>): 15: <%= link_to("log in", main_app.new_session_path) %> 16: <% end %> 17: 18:

<%= link_to("My Awesome Blog", blog_root_path) %>

19: 20: <%= yield %> 21: app/views/layouts/application.html.erb:18:in `_app_views_layouts_application_html_erb__1118358286315869622_70233099350520' Rendered /Users/Gavin/.rvm/gems/ruby-1.9.3-p194@blogit/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/_trace.erb (1.2ms) Rendered /Users/Gavin/.rvm/gems/ruby-1.9.3-p194@blogit/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (1.0ms) Rendered /Users/Gavin/.rvm/gems/ruby-1.9.3-p194@blogit/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/template_error.erb within rescues/layout (10.7ms) Started GET "/session/new" for 127.0.0.1 at 2013-04-14 17:27:04 +0100 Processing by SessionsController#new as HTML Rendered sessions/new.html.erb within layouts/application (1.0ms) User Load (0.2ms) SELECT "users".* FROM "users" WHERE "users"."id" IS NULL LIMIT 1 Completed 500 Internal Server Error in 26ms ActionView::Template::Error (undefined method `root_path' for #): 15: <%= link_to("log in", main_app.new_session_path) %> 16: <% end %> 17: 18:

<%= link_to("My Awesome Blog", blogit.root_path) %>

19: 20: <%= yield %> 21: app/views/layouts/application.html.erb:18:in `_app_views_layouts_application_html_erb__1118358286315869622_70233090563540' Rendered /Users/Gavin/.rvm/gems/ruby-1.9.3-p194@blogit/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/_trace.erb (1.0ms) Rendered /Users/Gavin/.rvm/gems/ruby-1.9.3-p194@blogit/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (1.9ms) Rendered /Users/Gavin/.rvm/gems/ruby-1.9.3-p194@blogit/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/template_error.erb within rescues/layout (7.0ms) Started GET "/session/new" for 127.0.0.1 at 2013-04-14 17:27:10 +0100 Processing by SessionsController#new as HTML Rendered sessions/new.html.erb within layouts/application (1.1ms) User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" IS NULL LIMIT 1 Completed 500 Internal Server Error in 14ms ActionView::Template::Error (undefined method `blogit_root_path' for #): 15: <%= link_to("log in", main_app.new_session_path) %> 16: <% end %> 17: 18:

<%= link_to("My Awesome Blog", blogit.blogit_root_path) %>

19: 20: <%= yield %> 21: app/views/layouts/application.html.erb:18:in `_app_views_layouts_application_html_erb__1118358286315869622_70233103211440' Rendered /Users/Gavin/.rvm/gems/ruby-1.9.3-p194@blogit/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/_trace.erb (1.0ms) Rendered /Users/Gavin/.rvm/gems/ruby-1.9.3-p194@blogit/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (0.7ms) Rendered /Users/Gavin/.rvm/gems/ruby-1.9.3-p194@blogit/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/template_error.erb within rescues/layout (6.0ms) Started GET "/session/new" for 127.0.0.1 at 2013-04-14 17:27:21 +0100 Processing by SessionsController#new as HTML Rendered sessions/new.html.erb within layouts/application (1.5ms) User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" IS NULL LIMIT 1 Blogit::Post Load (0.2ms) SELECT "blog_posts".* FROM "blog_posts" ORDER BY created_at DESC Completed 200 OK in 11ms (Views: 10.7ms | ActiveRecord: 0.3ms) Started GET "/assets/blogit/index.css?body=1" for 127.0.0.1 at 2013-04-14 17:27:21 +0100 Served asset /blogit/index.css - 304 Not Modified (0ms) Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2013-04-14 17:27:21 +0100 Served asset /jquery.js - 304 Not Modified (0ms) Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2013-04-14 17:27:21 +0100 Served asset /jquery_ujs.js - 304 Not Modified (0ms) Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2013-04-14 17:27:21 +0100 Served asset /application.css - 304 Not Modified (0ms) Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2013-04-14 17:27:21 +0100 Served asset /application.js - 304 Not Modified (0ms) Started GET "/assets/blogit/archive.js?body=1" for 127.0.0.1 at 2013-04-14 17:27:21 +0100 Served asset /blogit/archive.js - 304 Not Modified (0ms) Started GET "/assets/blogit/index.js?body=1" for 127.0.0.1 at 2013-04-14 17:27:21 +0100 Served asset /blogit/index.js - 304 Not Modified (0ms) Started POST "/session" for 127.0.0.1 at 2013-04-14 17:28:06 +0100 Processing by SessionsController#create as HTML Parameters: {"utf8"=>"✓", "authenticity_token"=>"jN8I9fQRhk9tLtrnPuj62NZ/PU+sJEjqCAA+7JvVdD0=", "session"=>{"username"=>"bodacious", "password"=>"[FILTERED]"}, "commit"=>"Log in"} User Load (0.2ms) SELECT "users".* FROM "users" WHERE "users"."username" = 'bodacious' AND "users"."password" = 'password' LIMIT 1 Rendered sessions/new.html.erb within layouts/application (1.7ms) User Load (0.2ms) SELECT "users".* FROM "users" WHERE "users"."id" IS NULL LIMIT 1 Blogit::Post Load (0.2ms) SELECT "blog_posts".* FROM "blog_posts" ORDER BY created_at DESC Completed 200 OK in 16ms (Views: 14.2ms | ActiveRecord: 0.6ms) Started GET "/assets/blogit/index.css?body=1" for 127.0.0.1 at 2013-04-14 17:28:06 +0100 Served asset /blogit/index.css - 304 Not Modified (0ms) Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2013-04-14 17:28:06 +0100 Served asset /application.css - 304 Not Modified (0ms) Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2013-04-14 17:28:06 +0100 Served asset /application.js - 304 Not Modified (0ms) Started GET "/assets/blogit/archive.js?body=1" for 127.0.0.1 at 2013-04-14 17:28:06 +0100 Served asset /blogit/archive.js - 304 Not Modified (0ms) Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2013-04-14 17:28:06 +0100 Served asset /jquery.js - 304 Not Modified (0ms) Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2013-04-14 17:28:06 +0100 Served asset /jquery_ujs.js - 304 Not Modified (0ms) Started GET "/assets/blogit/index.js?body=1" for 127.0.0.1 at 2013-04-14 17:28:06 +0100 Served asset /blogit/index.js - 304 Not Modified (0ms) Started POST "/session" for 127.0.0.1 at 2013-04-14 17:28:11 +0100 Processing by SessionsController#create as HTML Parameters: {"utf8"=>"✓", "authenticity_token"=>"jN8I9fQRhk9tLtrnPuj62NZ/PU+sJEjqCAA+7JvVdD0=", "session"=>{"username"=>"gavin", "password"=>"[FILTERED]"}, "commit"=>"Log in"} User Load (0.2ms) SELECT "users".* FROM "users" WHERE "users"."username" = 'gavin' AND "users"."password" = 'password' LIMIT 1 Rendered sessions/new.html.erb within layouts/application (1.0ms) User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" IS NULL LIMIT 1 Blogit::Post Load (0.1ms) SELECT "blog_posts".* FROM "blog_posts" ORDER BY created_at DESC Completed 200 OK in 9ms (Views: 7.2ms | ActiveRecord: 0.4ms) Started GET "/assets/blogit/index.css?body=1" for 127.0.0.1 at 2013-04-14 17:28:11 +0100 Served asset /blogit/index.css - 304 Not Modified (0ms) Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2013-04-14 17:28:11 +0100 Served asset /jquery.js - 304 Not Modified (0ms) Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2013-04-14 17:28:11 +0100 Served asset /jquery_ujs.js - 304 Not Modified (0ms) Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2013-04-14 17:28:11 +0100 Served asset /application.js - 304 Not Modified (0ms) Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2013-04-14 17:28:11 +0100 Served asset /application.css - 304 Not Modified (0ms) Started GET "/assets/blogit/archive.js?body=1" for 127.0.0.1 at 2013-04-14 17:28:11 +0100 Served asset /blogit/archive.js - 304 Not Modified (0ms) Started GET "/assets/blogit/index.js?body=1" for 127.0.0.1 at 2013-04-14 17:28:11 +0100 Served asset /blogit/index.js - 304 Not Modified (0ms) Started POST "/session" for 127.0.0.1 at 2013-04-14 17:28:15 +0100 Processing by SessionsController#create as HTML Parameters: {"utf8"=>"✓", "authenticity_token"=>"jN8I9fQRhk9tLtrnPuj62NZ/PU+sJEjqCAA+7JvVdD0=", "session"=>{"username"=>"gavinmorrice", "password"=>"[FILTERED]"}, "commit"=>"Log in"} User Load (0.2ms) SELECT "users".* FROM "users" WHERE "users"."username" = 'gavinmorrice' AND "users"."password" = 'password' LIMIT 1 Rendered sessions/new.html.erb within layouts/application (1.1ms) User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" IS NULL LIMIT 1 Blogit::Post Load (0.1ms) SELECT "blog_posts".* FROM "blog_posts" ORDER BY created_at DESC Completed 200 OK in 9ms (Views: 7.9ms | ActiveRecord: 0.4ms) Started GET "/assets/blogit/index.css?body=1" for 127.0.0.1 at 2013-04-14 17:28:15 +0100 Served asset /blogit/index.css - 304 Not Modified (0ms) Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2013-04-14 17:28:15 +0100 Served asset /application.js - 304 Not Modified (0ms) Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2013-04-14 17:28:15 +0100 Served asset /application.css - 304 Not Modified (0ms) Started GET "/assets/blogit/archive.js?body=1" for 127.0.0.1 at 2013-04-14 17:28:15 +0100 Served asset /blogit/archive.js - 304 Not Modified (0ms) Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2013-04-14 17:28:15 +0100 Served asset /jquery.js - 304 Not Modified (0ms) Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2013-04-14 17:28:15 +0100 Served asset /jquery_ujs.js - 304 Not Modified (0ms) Started GET "/assets/blogit/index.js?body=1" for 127.0.0.1 at 2013-04-14 17:28:15 +0100 Served asset /blogit/index.js - 304 Not Modified (0ms) Connecting to database specified by database.yml Started POST "/session" for 127.0.0.1 at 2013-04-14 17:28:37 +0100 Processing by SessionsController#create as HTML Parameters: {"utf8"=>"✓", "authenticity_token"=>"jN8I9fQRhk9tLtrnPuj62NZ/PU+sJEjqCAA+7JvVdD0=", "session"=>{"username"=>"Gavin", "password"=>"[FILTERED]"}, "commit"=>"Log in"} User Load (0.2ms) SELECT "users".* FROM "users" WHERE "users"."username" = 'Gavin' AND "users"."password" = 'password' LIMIT 1 Redirected to http://localhost:3000/ Completed 302 Found in 2ms (ActiveRecord: 0.2ms) Started GET "/" for 127.0.0.1 at 2013-04-14 17:28:37 +0100 Processing by Blogit::PostsController#index as HTML User Load (0.2ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1  (0.3ms) SELECT COUNT(count_column) FROM (SELECT 1 AS count_column FROM "blog_posts" LIMIT 5 OFFSET 0) subquery_for_count  Blogit::Post Load (0.3ms) SELECT "blog_posts".* FROM "blog_posts" ORDER BY created_at DESC LIMIT 5 OFFSET 0 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_head.html.erb (0.9ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_body.html.erb (0.4ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_links.html.erb (1.6ms) CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_blogger_information.html.erb (1.6ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_head.html.erb (0.8ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_body.html.erb (0.2ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_links.html.erb (1.0ms) CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_blogger_information.html.erb (2.0ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post.html.erb (17.2ms)  (0.1ms) SELECT COUNT(*) FROM "blog_posts"  Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_pagination.html.erb (2.1ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/index.html.erb within layouts/application (25.8ms) Blogit::Post Load (0.1ms) SELECT "blog_posts".* FROM "blog_posts" ORDER BY created_at DESC Completed 200 OK in 33ms (Views: 31.3ms | ActiveRecord: 1.0ms) Started GET "/assets/blogit/index.css?body=1" for 127.0.0.1 at 2013-04-14 17:28:37 +0100 Served asset /blogit/index.css - 304 Not Modified (0ms) Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2013-04-14 17:28:37 +0100 Served asset /jquery_ujs.js - 304 Not Modified (0ms) Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2013-04-14 17:28:37 +0100 Served asset /jquery.js - 304 Not Modified (0ms) Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2013-04-14 17:28:37 +0100 Served asset /application.js - 304 Not Modified (0ms) Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2013-04-14 17:28:37 +0100 Served asset /application.css - 304 Not Modified (0ms) Started GET "/assets/blogit/archive.js?body=1" for 127.0.0.1 at 2013-04-14 17:28:37 +0100 Served asset /blogit/archive.js - 304 Not Modified (0ms) Started GET "/assets/blogit/index.js?body=1" for 127.0.0.1 at 2013-04-14 17:28:37 +0100 Served asset /blogit/index.js - 304 Not Modified (0ms) Started GET "/blog/posts/2-this-is-a-new-blog-post/edit" for 127.0.0.1 at 2013-04-14 17:28:45 +0100 Processing by Blogit::PostsController#edit as HTML Parameters: {"id"=>"2-this-is-a-new-blog-post"} User Load (0.2ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Blogit::Post Load (0.1ms) SELECT "blog_posts".* FROM "blog_posts" WHERE "blog_posts"."blogger_id" = 1 AND "blog_posts"."blogger_type" = 'User' AND "blog_posts"."id" = ? LIMIT 1 [["id", "2-this-is-a-new-blog-post"]] ActsAsTaggableOn::Tag Load (0.2ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_form.html.erb (7.6ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/edit.html.erb within layouts/application (9.3ms) Blogit::Post Load (0.1ms) SELECT "blog_posts".* FROM "blog_posts" ORDER BY created_at DESC Completed 200 OK in 21ms (Views: 18.0ms | ActiveRecord: 0.7ms) Started GET "/assets/blogit/index.css?body=1" for 127.0.0.1 at 2013-04-14 17:28:45 +0100 Served asset /blogit/index.css - 304 Not Modified (0ms) Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2013-04-14 17:28:45 +0100 Served asset /application.css - 304 Not Modified (0ms) Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2013-04-14 17:28:45 +0100 Served asset /jquery_ujs.js - 304 Not Modified (0ms) Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2013-04-14 17:28:45 +0100 Served asset /jquery.js - 304 Not Modified (0ms) Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2013-04-14 17:28:45 +0100 Served asset /application.js - 304 Not Modified (0ms) Started GET "/assets/blogit/archive.js?body=1" for 127.0.0.1 at 2013-04-14 17:28:45 +0100 Served asset /blogit/archive.js - 304 Not Modified (0ms) Started GET "/assets/blogit/index.js?body=1" for 127.0.0.1 at 2013-04-14 17:28:45 +0100 Served asset /blogit/index.js - 304 Not Modified (0ms) Started PUT "/blog/posts/2-this-is-a-new-blog-post" for 127.0.0.1 at 2013-04-14 17:29:11 +0100 Processing by Blogit::PostsController#update as HTML Parameters: {"utf8"=>"✓", "authenticity_token"=>"jN8I9fQRhk9tLtrnPuj62NZ/PU+sJEjqCAA+7JvVdD0=", "post"=>{"title"=>"This is a new blog post", "body"=>"Thiso jfaosfja sodfj aosifj aoisdfj osaidjf aosidjfasoidj faosij\r\n\r\n```ruby\r\n\r\nclass Code\r\n\r\n def to_s\r\n \"hello\"\r\n end\r\n\r\nend\r\n```", "tag_list"=>"one, two, three"}, "commit"=>"Update Post", "id"=>"2-this-is-a-new-blog-post"} User Load (0.2ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Blogit::Post Load (0.1ms) SELECT "blog_posts".* FROM "blog_posts" WHERE "blog_posts"."blogger_id" = 1 AND "blog_posts"."blogger_type" = 'User' AND "blog_posts"."id" = ? LIMIT 1 [["id", "2-this-is-a-new-blog-post"]]  (0.0ms) begin transaction ActsAsTaggableOn::Tag Load (0.2ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL)  (0.3ms) UPDATE "blog_posts" SET "body" = 'Thiso jfaosfja sodfj aosifj aoisdfj osaidjf aosidjfasoidj faosij ```ruby class Code def to_s "hello" end end ```', "updated_at" = '2013-04-14 16:29:11.679593' WHERE "blog_posts"."id" = 2 ActsAsTaggableOn::Tag Load (0.2ms) SELECT "tags".* FROM "tags" WHERE (lower(name) = 'one' OR lower(name) = 'two' OR lower(name) = 'three') ActsAsTaggableOn::Tag Load (0.1ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL)  (56.4ms) commit transaction Redirected to http://localhost:3000/blog/posts/2-this-is-a-new-blog-post Completed 302 Found in 69ms (ActiveRecord: 57.4ms) Started GET "/blog/posts/2-this-is-a-new-blog-post" for 127.0.0.1 at 2013-04-14 17:29:11 +0100 Processing by Blogit::PostsController#show as HTML Parameters: {"id"=>"2-this-is-a-new-blog-post"} Blogit::Post Load (0.1ms) SELECT "blog_posts".* FROM "blog_posts" WHERE "blog_posts"."id" = ? LIMIT 1 [["id", "2-this-is-a-new-blog-post"]] Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_head.html.erb (0.6ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_body.html.erb (169.4ms) User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_links.html.erb (2.0ms) CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_blogger_information.html.erb (1.2ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post.html.erb (176.6ms) ActsAsTaggableOn::Tag Load (0.2ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) CACHE (0.0ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) Blogit::Post Load (0.1ms) SELECT blog_posts.*, COUNT(tags.id) AS count FROM blog_posts, tags, taggings WHERE (blog_posts.id != 2 AND blog_posts.id = taggings.taggable_id AND taggings.taggable_type = 'Blogit::Post' AND taggings.tag_id = tags.id AND tags.name IN ('one','two','three')) GROUP BY blog_posts.id ORDER BY count DESC Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_related.html.erb (3.3ms) Rendered blogit/posts/_post_footer.html.erb (4.0ms) Blogit::Comment Load (0.1ms) SELECT "blog_comments".* FROM "blog_comments" WHERE "blog_comments"."post_id" = 2 Rendered collection (0.0ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/comments/_form.html.erb (2.9ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_active_record_comments.html.erb (4.7ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/show.html.erb within layouts/application (187.7ms) Blogit::Post Load (0.2ms) SELECT "blog_posts".* FROM "blog_posts" ORDER BY created_at DESC Completed 200 OK in 196ms (Views: 194.8ms | ActiveRecord: 0.8ms) Started GET "/assets/blogit/index.css?body=1" for 127.0.0.1 at 2013-04-14 17:29:11 +0100 Served asset /blogit/index.css - 304 Not Modified (0ms) Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2013-04-14 17:29:11 +0100 Served asset /application.js - 304 Not Modified (0ms) Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2013-04-14 17:29:11 +0100 Served asset /jquery.js - 304 Not Modified (0ms) Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2013-04-14 17:29:11 +0100 Served asset /jquery_ujs.js - 304 Not Modified (0ms) Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2013-04-14 17:29:12 +0100 Served asset /application.css - 304 Not Modified (0ms) Started GET "/assets/blogit/archive.js?body=1" for 127.0.0.1 at 2013-04-14 17:29:12 +0100 Served asset /blogit/archive.js - 304 Not Modified (0ms) Started GET "/assets/blogit/index.js?body=1" for 127.0.0.1 at 2013-04-14 17:29:12 +0100 Served asset /blogit/index.js - 304 Not Modified (0ms) Started GET "/blog/posts/2-this-is-a-new-blog-post" for 127.0.0.1 at 2013-04-14 17:29:23 +0100 Processing by Blogit::PostsController#show as HTML Parameters: {"id"=>"2-this-is-a-new-blog-post"} Blogit::Post Load (0.2ms) SELECT "blog_posts".* FROM "blog_posts" WHERE "blog_posts"."id" = ? LIMIT 1 [["id", "2-this-is-a-new-blog-post"]] Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_head.html.erb (0.6ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_body.html.erb (172.5ms) User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_links.html.erb (1.6ms) CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_blogger_information.html.erb (0.9ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post.html.erb (178.9ms) ActsAsTaggableOn::Tag Load (0.2ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) CACHE (0.0ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) Blogit::Post Load (0.1ms) SELECT blog_posts.*, COUNT(tags.id) AS count FROM blog_posts, tags, taggings WHERE (blog_posts.id != 2 AND blog_posts.id = taggings.taggable_id AND taggings.taggable_type = 'Blogit::Post' AND taggings.tag_id = tags.id AND tags.name IN ('one','two','three')) GROUP BY blog_posts.id ORDER BY count DESC Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_related.html.erb (3.3ms) Rendered blogit/posts/_post_footer.html.erb (3.9ms) Blogit::Comment Load (0.1ms) SELECT "blog_comments".* FROM "blog_comments" WHERE "blog_comments"."post_id" = 2 Rendered collection (0.0ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/comments/_form.html.erb (2.5ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_active_record_comments.html.erb (4.0ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/show.html.erb within layouts/application (189.1ms) Blogit::Post Load (0.2ms) SELECT "blog_posts".* FROM "blog_posts" ORDER BY created_at DESC Completed 200 OK in 197ms (Views: 195.3ms | ActiveRecord: 0.8ms) Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2013-04-14 17:29:23 +0100 Served asset /application.css - 304 Not Modified (0ms) Started GET "/assets/blogit/index.css?body=1" for 127.0.0.1 at 2013-04-14 17:29:24 +0100 Served asset /blogit/index.css - 304 Not Modified (0ms) Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2013-04-14 17:29:24 +0100 Served asset /jquery_ujs.js - 304 Not Modified (0ms) Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2013-04-14 17:29:24 +0100 Served asset /jquery.js - 304 Not Modified (0ms) Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2013-04-14 17:29:24 +0100 Served asset /application.js - 304 Not Modified (0ms) Started GET "/assets/blogit/archive.js?body=1" for 127.0.0.1 at 2013-04-14 17:29:24 +0100 Served asset /blogit/archive.js - 304 Not Modified (0ms) Started GET "/assets/blogit/index.js?body=1" for 127.0.0.1 at 2013-04-14 17:29:24 +0100 Served asset /blogit/index.js - 304 Not Modified (0ms) Connecting to database specified by database.yml Started GET "/blog/posts/2-this-is-a-new-blog-post" for 127.0.0.1 at 2013-04-14 17:33:49 +0100 Processing by Blogit::PostsController#show as HTML Parameters: {"id"=>"2-this-is-a-new-blog-post"} Blogit::Post Load (0.3ms) SELECT "blog_posts".* FROM "blog_posts" WHERE "blog_posts"."id" = ? LIMIT 1 [["id", "2-this-is-a-new-blog-post"]] Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_head.html.erb (90.9ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_body.html.erb (171.6ms) User Load (0.2ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_links.html.erb (20.2ms) CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_blogger_information.html.erb (16.0ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post.html.erb (303.5ms) ActsAsTaggableOn::Tag Load (0.1ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) CACHE (0.0ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) Blogit::Post Load (0.2ms) SELECT blog_posts.*, COUNT(tags.id) AS count FROM blog_posts, tags, taggings WHERE (blog_posts.id != 2 AND blog_posts.id = taggings.taggable_id AND taggings.taggable_type = 'Blogit::Post' AND taggings.tag_id = tags.id AND tags.name IN ('one','two','three')) GROUP BY blog_posts.id ORDER BY count DESC Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_related.html.erb (45.2ms) Rendered blogit/posts/_post_footer.html.erb (46.2ms) Blogit::Comment Load (0.2ms) SELECT "blog_comments".* FROM "blog_comments" WHERE "blog_comments"."post_id" = 2 Rendered collection (0.0ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/comments/_form.html.erb (7.4ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_active_record_comments.html.erb (10.9ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/show.html.erb within layouts/application (384.1ms) Blogit::Post Load (0.2ms) SELECT "blog_posts".* FROM "blog_posts" ORDER BY created_at DESC Completed 200 OK in 428ms (Views: 415.7ms | ActiveRecord: 2.4ms) Started GET "/assets/blogit/index.css?body=1" for 127.0.0.1 at 2013-04-14 17:33:50 +0100 Served asset /blogit/index.css - 304 Not Modified (2ms) Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2013-04-14 17:33:50 +0100 Served asset /application.css - 304 Not Modified (2ms) Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2013-04-14 17:33:50 +0100 Served asset /jquery_ujs.js - 304 Not Modified (9ms) Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2013-04-14 17:33:50 +0100 Served asset /application.js - 304 Not Modified (5ms) Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2013-04-14 17:33:50 +0100 Served asset /jquery.js - 304 Not Modified (2ms) Started GET "/assets/blogit/archive.js?body=1" for 127.0.0.1 at 2013-04-14 17:33:50 +0100 Served asset /blogit/archive.js - 304 Not Modified (2ms) Started GET "/assets/blogit/index.js?body=1" for 127.0.0.1 at 2013-04-14 17:33:50 +0100 Served asset /blogit/index.js - 304 Not Modified (2ms) Connecting to database specified by database.yml Started GET "/blog/posts/2-this-is-a-new-blog-post" for 127.0.0.1 at 2013-04-14 17:34:32 +0100 Processing by Blogit::PostsController#show as HTML Parameters: {"id"=>"2-this-is-a-new-blog-post"} Blogit::Post Load (0.2ms) SELECT "blog_posts".* FROM "blog_posts" WHERE "blog_posts"."id" = ? LIMIT 1 [["id", "2-this-is-a-new-blog-post"]] Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_head.html.erb (70.9ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_body.html.erb (172.8ms) User Load (0.2ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_links.html.erb (19.9ms) CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_blogger_information.html.erb (15.2ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post.html.erb (284.1ms) ActsAsTaggableOn::Tag Load (0.1ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) CACHE (0.0ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) Blogit::Post Load (0.2ms) SELECT blog_posts.*, COUNT(tags.id) AS count FROM blog_posts, tags, taggings WHERE (blog_posts.id != 2 AND blog_posts.id = taggings.taggable_id AND taggings.taggable_type = 'Blogit::Post' AND taggings.tag_id = tags.id AND tags.name IN ('one','two','three')) GROUP BY blog_posts.id ORDER BY count DESC Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_related.html.erb (44.8ms) Rendered blogit/posts/_post_footer.html.erb (46.0ms) Blogit::Comment Load (0.2ms) SELECT "blog_comments".* FROM "blog_comments" WHERE "blog_comments"."post_id" = 2 Rendered collection (0.0ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/comments/_form.html.erb (7.0ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_active_record_comments.html.erb (10.6ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/show.html.erb within layouts/application (364.3ms) Blogit::Post Load (0.2ms) SELECT "blog_posts".* FROM "blog_posts" ORDER BY created_at DESC Completed 200 OK in 406ms (Views: 395.7ms | ActiveRecord: 2.4ms) Started GET "/assets/blogit/index.css?body=1" for 127.0.0.1 at 2013-04-14 17:34:33 +0100 Served asset /blogit/index.css - 304 Not Modified (2ms) Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2013-04-14 17:34:33 +0100 Served asset /application.css - 304 Not Modified (2ms) Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2013-04-14 17:34:33 +0100 Served asset /jquery.js - 304 Not Modified (2ms) Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2013-04-14 17:34:33 +0100 Served asset /jquery_ujs.js - 304 Not Modified (1ms) Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2013-04-14 17:34:33 +0100 Served asset /application.js - 304 Not Modified (4ms) Started GET "/assets/blogit/archive.js?body=1" for 127.0.0.1 at 2013-04-14 17:34:33 +0100 Served asset /blogit/archive.js - 304 Not Modified (2ms) Started GET "/assets/blogit/index.js?body=1" for 127.0.0.1 at 2013-04-14 17:34:33 +0100 Served asset /blogit/index.js - 304 Not Modified (3ms) Started GET "/blog/posts/2-this-is-a-new-blog-post" for 127.0.0.1 at 2013-04-14 17:34:41 +0100 Processing by Blogit::PostsController#show as HTML Parameters: {"id"=>"2-this-is-a-new-blog-post"} Blogit::Post Load (0.1ms) SELECT "blog_posts".* FROM "blog_posts" WHERE "blog_posts"."id" = ? LIMIT 1 [["id", "2-this-is-a-new-blog-post"]] Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_head.html.erb (0.7ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_body.html.erb (182.9ms) User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_links.html.erb (1.8ms) CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_blogger_information.html.erb (1.4ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post.html.erb (190.0ms) ActsAsTaggableOn::Tag Load (0.2ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) CACHE (0.0ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) Blogit::Post Load (0.1ms) SELECT blog_posts.*, COUNT(tags.id) AS count FROM blog_posts, tags, taggings WHERE (blog_posts.id != 2 AND blog_posts.id = taggings.taggable_id AND taggings.taggable_type = 'Blogit::Post' AND taggings.tag_id = tags.id AND tags.name IN ('one','two','three')) GROUP BY blog_posts.id ORDER BY count DESC Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_related.html.erb (3.4ms) Rendered blogit/posts/_post_footer.html.erb (4.1ms) Blogit::Comment Load (0.1ms) SELECT "blog_comments".* FROM "blog_comments" WHERE "blog_comments"."post_id" = 2 Rendered collection (0.0ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/comments/_form.html.erb (2.3ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_active_record_comments.html.erb (3.6ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/show.html.erb within layouts/application (199.9ms) Blogit::Post Load (0.1ms) SELECT "blog_posts".* FROM "blog_posts" ORDER BY created_at DESC Completed 200 OK in 207ms (Views: 205.2ms | ActiveRecord: 0.8ms) Started GET "/assets/blogit/index.css?body=1" for 127.0.0.1 at 2013-04-14 17:34:41 +0100 Served asset /blogit/index.css - 304 Not Modified (0ms) Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2013-04-14 17:34:41 +0100 Served asset /application.css - 304 Not Modified (0ms) Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2013-04-14 17:34:41 +0100 Served asset /jquery_ujs.js - 304 Not Modified (0ms) Started GET "/assets/blogit/archive.js?body=1" for 127.0.0.1 at 2013-04-14 17:34:41 +0100 Served asset /blogit/archive.js - 304 Not Modified (0ms) Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2013-04-14 17:34:41 +0100 Served asset /jquery.js - 304 Not Modified (0ms) Started GET "/assets/blogit/index.js?body=1" for 127.0.0.1 at 2013-04-14 17:34:41 +0100 Served asset /blogit/index.js - 304 Not Modified (0ms) Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2013-04-14 17:34:41 +0100 Served asset /application.js - 304 Not Modified (0ms) Connecting to database specified by database.yml Connecting to database specified by database.yml Started GET "/blog/posts/2-this-is-a-new-blog-post" for 127.0.0.1 at 2013-04-14 18:00:39 +0100 Processing by Blogit::PostsController#show as HTML Parameters: {"id"=>"2-this-is-a-new-blog-post"} Blogit::Post Load (0.2ms) SELECT "blog_posts".* FROM "blog_posts" WHERE "blog_posts"."id" = ? LIMIT 1 [["id", "2-this-is-a-new-blog-post"]] Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_head.html.erb (71.9ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_body.html.erb (4.9ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post.html.erb (79.3ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/show.html.erb within layouts/application (84.6ms) Completed 500 Internal Server Error in 105ms ActionView::Template::Error ([blogit] The pygmentize command could not be found in your load path! Please either do one of the following: $ sudo easy_install Pygments) # to install it or set config.highlight_code_syntax to false in your blogit.rb config file. ): 1: <%= format_content(post.body) %> /Users/Gavin/Gems/blogit/lib/blogit/parsers/markdown_parser.rb:48:in `ensure_pygments_is_installed' /Users/Gavin/Gems/blogit/lib/blogit/parsers/markdown_parser.rb:12:in `parsed' /Users/Gavin/Gems/blogit/app/helpers/blogit/application_helper.rb:28:in `format_content' /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_body.html.erb:1:in `___sers__avin__ems_blogit_app_views_blogit_posts__post_body_html_erb___565794632098263310_70296976529080' actionpack (3.2.8) lib/action_view/template.rb:145:in `block in render' activesupport (3.2.8) lib/active_support/notifications.rb:125:in `instrument' actionpack (3.2.8) lib/action_view/template.rb:143:in `render' actionpack (3.2.8) lib/action_view/renderer/partial_renderer.rb:265:in `render_partial' actionpack (3.2.8) lib/action_view/renderer/partial_renderer.rb:238:in `block in render' actionpack (3.2.8) lib/action_view/renderer/abstract_renderer.rb:38:in `block in instrument' activesupport (3.2.8) lib/active_support/notifications.rb:123:in `block in instrument' activesupport (3.2.8) lib/active_support/notifications/instrumenter.rb:20:in `instrument' activesupport (3.2.8) lib/active_support/notifications.rb:123:in `instrument' actionpack (3.2.8) lib/action_view/renderer/abstract_renderer.rb:38:in `instrument' actionpack (3.2.8) lib/action_view/renderer/partial_renderer.rb:237:in `render' actionpack (3.2.8) lib/action_view/renderer/renderer.rb:41:in `render_partial' actionpack (3.2.8) lib/action_view/helpers/rendering_helper.rb:27:in `render' /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post.html.erb:7:in `block in ___sers__avin__ems_blogit_app_views_blogit_posts__post_html_erb__580331434581751533_70296978766740' actionpack (3.2.8) lib/action_view/helpers/capture_helper.rb:40:in `block in capture' actionpack (3.2.8) lib/action_view/helpers/capture_helper.rb:187:in `with_output_buffer' actionpack (3.2.8) lib/action_view/helpers/capture_helper.rb:40:in `capture' actionpack (3.2.8) lib/action_view/helpers/tag_helper.rb:95:in `content_tag' /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post.html.erb:1:in `___sers__avin__ems_blogit_app_views_blogit_posts__post_html_erb__580331434581751533_70296978766740' actionpack (3.2.8) lib/action_view/template.rb:145:in `block in render' activesupport (3.2.8) lib/active_support/notifications.rb:125:in `instrument' actionpack (3.2.8) lib/action_view/template.rb:143:in `render' actionpack (3.2.8) lib/action_view/renderer/partial_renderer.rb:265:in `render_partial' actionpack (3.2.8) lib/action_view/renderer/partial_renderer.rb:238:in `block in render' actionpack (3.2.8) lib/action_view/renderer/abstract_renderer.rb:38:in `block in instrument' activesupport (3.2.8) lib/active_support/notifications.rb:123:in `block in instrument' activesupport (3.2.8) lib/active_support/notifications/instrumenter.rb:20:in `instrument' activesupport (3.2.8) lib/active_support/notifications.rb:123:in `instrument' actionpack (3.2.8) lib/action_view/renderer/abstract_renderer.rb:38:in `instrument' actionpack (3.2.8) lib/action_view/renderer/partial_renderer.rb:237:in `render' actionpack (3.2.8) lib/action_view/renderer/renderer.rb:41:in `render_partial' actionpack (3.2.8) lib/action_view/helpers/rendering_helper.rb:27:in `render' /Users/Gavin/Gems/blogit/app/views/blogit/posts/show.html.erb:1:in `___sers__avin__ems_blogit_app_views_blogit_posts_show_html_erb__818609365965346330_70296978878800' actionpack (3.2.8) lib/action_view/template.rb:145:in `block in render' activesupport (3.2.8) lib/active_support/notifications.rb:125:in `instrument' actionpack (3.2.8) lib/action_view/template.rb:143:in `render' actionpack (3.2.8) lib/action_view/renderer/template_renderer.rb:47:in `block (2 levels) in render_template' actionpack (3.2.8) lib/action_view/renderer/abstract_renderer.rb:38:in `block in instrument' activesupport (3.2.8) lib/active_support/notifications.rb:123:in `block in instrument' activesupport (3.2.8) lib/active_support/notifications/instrumenter.rb:20:in `instrument' activesupport (3.2.8) lib/active_support/notifications.rb:123:in `instrument' actionpack (3.2.8) lib/action_view/renderer/abstract_renderer.rb:38:in `instrument' actionpack (3.2.8) lib/action_view/renderer/template_renderer.rb:46:in `block in render_template' actionpack (3.2.8) lib/action_view/renderer/template_renderer.rb:54:in `render_with_layout' actionpack (3.2.8) lib/action_view/renderer/template_renderer.rb:45:in `render_template' actionpack (3.2.8) lib/action_view/renderer/template_renderer.rb:18:in `render' actionpack (3.2.8) lib/action_view/renderer/renderer.rb:36:in `render_template' actionpack (3.2.8) lib/action_view/renderer/renderer.rb:17:in `render' actionpack (3.2.8) lib/abstract_controller/rendering.rb:110:in `_render_template' actionpack (3.2.8) lib/action_controller/metal/streaming.rb:225:in `_render_template' actionpack (3.2.8) lib/abstract_controller/rendering.rb:103:in `render_to_body' actionpack (3.2.8) lib/action_controller/metal/renderers.rb:28:in `render_to_body' actionpack (3.2.8) lib/action_controller/metal/compatibility.rb:50:in `render_to_body' actionpack (3.2.8) lib/abstract_controller/rendering.rb:88:in `render' actionpack (3.2.8) lib/action_controller/metal/rendering.rb:16:in `render' actionpack (3.2.8) lib/action_controller/metal/instrumentation.rb:40:in `block (2 levels) in render' activesupport (3.2.8) lib/active_support/core_ext/benchmark.rb:5:in `block in ms' /Users/Gavin/.rvm/rubies/ruby-1.9.3-p194/lib/ruby/1.9.1/benchmark.rb:295:in `realtime' activesupport (3.2.8) lib/active_support/core_ext/benchmark.rb:5:in `ms' actionpack (3.2.8) lib/action_controller/metal/instrumentation.rb:40:in `block in render' actionpack (3.2.8) lib/action_controller/metal/instrumentation.rb:83:in `cleanup_view_runtime' activerecord (3.2.8) lib/active_record/railties/controller_runtime.rb:24:in `cleanup_view_runtime' actionpack (3.2.8) lib/action_controller/metal/instrumentation.rb:39:in `render' actionpack (3.2.8) lib/action_controller/metal/implicit_render.rb:10:in `default_render' actionpack (3.2.8) lib/action_controller/metal/implicit_render.rb:5:in `send_action' actionpack (3.2.8) lib/abstract_controller/base.rb:167:in `process_action' actionpack (3.2.8) lib/action_controller/metal/rendering.rb:10:in `process_action' actionpack (3.2.8) lib/abstract_controller/callbacks.rb:18:in `block in process_action' activesupport (3.2.8) lib/active_support/callbacks.rb:414:in `_run__452247299678931154__process_action__2310806406290898008__callbacks' activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `__run_callback' activesupport (3.2.8) lib/active_support/callbacks.rb:385:in `_run_process_action_callbacks' activesupport (3.2.8) lib/active_support/callbacks.rb:81:in `run_callbacks' actionpack (3.2.8) lib/abstract_controller/callbacks.rb:17:in `process_action' actionpack (3.2.8) lib/action_controller/metal/rescue.rb:29:in `process_action' actionpack (3.2.8) lib/action_controller/metal/instrumentation.rb:30:in `block in process_action' activesupport (3.2.8) lib/active_support/notifications.rb:123:in `block in instrument' activesupport (3.2.8) lib/active_support/notifications/instrumenter.rb:20:in `instrument' activesupport (3.2.8) lib/active_support/notifications.rb:123:in `instrument' actionpack (3.2.8) lib/action_controller/metal/instrumentation.rb:29:in `process_action' actionpack (3.2.8) lib/action_controller/metal/params_wrapper.rb:207:in `process_action' activerecord (3.2.8) lib/active_record/railties/controller_runtime.rb:18:in `process_action' actionpack (3.2.8) lib/abstract_controller/base.rb:121:in `process' actionpack (3.2.8) lib/abstract_controller/rendering.rb:45:in `process' actionpack (3.2.8) lib/action_controller/metal.rb:203:in `dispatch' actionpack (3.2.8) lib/action_controller/metal/rack_delegation.rb:14:in `dispatch' actionpack (3.2.8) lib/action_controller/metal.rb:246:in `block in action' actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:73:in `call' actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:73:in `dispatch' actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:36:in `call' journey (1.0.4) lib/journey/router.rb:68:in `block in call' journey (1.0.4) lib/journey/router.rb:56:in `each' journey (1.0.4) lib/journey/router.rb:56:in `call' actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:600:in `call' railties (3.2.8) lib/rails/engine.rb:479:in `call' railties (3.2.8) lib/rails/railtie/configurable.rb:30:in `method_missing' journey (1.0.4) lib/journey/router.rb:68:in `block in call' journey (1.0.4) lib/journey/router.rb:56:in `each' journey (1.0.4) lib/journey/router.rb:56:in `call' actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:600:in `call' actionpack (3.2.8) lib/action_dispatch/middleware/best_standards_support.rb:17:in `call' rack (1.4.1) lib/rack/etag.rb:23:in `call' rack (1.4.1) lib/rack/conditionalget.rb:25:in `call' actionpack (3.2.8) lib/action_dispatch/middleware/head.rb:14:in `call' actionpack (3.2.8) lib/action_dispatch/middleware/params_parser.rb:21:in `call' actionpack (3.2.8) lib/action_dispatch/middleware/flash.rb:242:in `call' rack (1.4.1) lib/rack/session/abstract/id.rb:205:in `context' rack (1.4.1) lib/rack/session/abstract/id.rb:200:in `call' actionpack (3.2.8) lib/action_dispatch/middleware/cookies.rb:339:in `call' activerecord (3.2.8) lib/active_record/query_cache.rb:64:in `call' activerecord (3.2.8) lib/active_record/connection_adapters/abstract/connection_pool.rb:473:in `call' actionpack (3.2.8) lib/action_dispatch/middleware/callbacks.rb:28:in `block in call' activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `_run__3288660937958956851__call__3149872817018234628__callbacks' activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `__run_callback' activesupport (3.2.8) lib/active_support/callbacks.rb:385:in `_run_call_callbacks' activesupport (3.2.8) lib/active_support/callbacks.rb:81:in `run_callbacks' actionpack (3.2.8) lib/action_dispatch/middleware/callbacks.rb:27:in `call' actionpack (3.2.8) lib/action_dispatch/middleware/reloader.rb:65:in `call' actionpack (3.2.8) lib/action_dispatch/middleware/remote_ip.rb:31:in `call' actionpack (3.2.8) lib/action_dispatch/middleware/debug_exceptions.rb:16:in `call' actionpack (3.2.8) lib/action_dispatch/middleware/show_exceptions.rb:56:in `call' railties (3.2.8) lib/rails/rack/logger.rb:26:in `call_app' railties (3.2.8) lib/rails/rack/logger.rb:16:in `call' actionpack (3.2.8) lib/action_dispatch/middleware/request_id.rb:22:in `call' rack (1.4.1) lib/rack/methodoverride.rb:21:in `call' rack (1.4.1) lib/rack/runtime.rb:17:in `call' activesupport (3.2.8) lib/active_support/cache/strategy/local_cache.rb:72:in `call' rack (1.4.1) lib/rack/lock.rb:15:in `call' actionpack (3.2.8) lib/action_dispatch/middleware/static.rb:62:in `call' railties (3.2.8) lib/rails/engine.rb:479:in `call' railties (3.2.8) lib/rails/application.rb:223:in `call' rack (1.4.1) lib/rack/content_length.rb:14:in `call' railties (3.2.8) lib/rails/rack/log_tailer.rb:17:in `call' rack (1.4.1) lib/rack/handler/webrick.rb:59:in `service' /Users/Gavin/.rvm/rubies/ruby-1.9.3-p194/lib/ruby/1.9.1/webrick/httpserver.rb:138:in `service' /Users/Gavin/.rvm/rubies/ruby-1.9.3-p194/lib/ruby/1.9.1/webrick/httpserver.rb:94:in `run' /Users/Gavin/.rvm/rubies/ruby-1.9.3-p194/lib/ruby/1.9.1/webrick/server.rb:191:in `block in start_thread' Rendered /Users/Gavin/.rvm/gems/ruby-1.9.3-p194@blogit/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/_trace.erb (1.1ms) Rendered /Users/Gavin/.rvm/gems/ruby-1.9.3-p194@blogit/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (0.8ms) Rendered /Users/Gavin/.rvm/gems/ruby-1.9.3-p194@blogit/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/template_error.erb within rescues/layout (5.9ms) Connecting to database specified by database.yml Started GET "/blog/posts/2-this-is-a-new-blog-post" for 127.0.0.1 at 2013-04-14 18:02:20 +0100 Processing by Blogit::PostsController#show as HTML Parameters: {"id"=>"2-this-is-a-new-blog-post"} Blogit::Post Load (0.2ms) SELECT "blog_posts".* FROM "blog_posts" WHERE "blog_posts"."id" = ? LIMIT 1 [["id", "2-this-is-a-new-blog-post"]] Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_head.html.erb (74.3ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_body.html.erb (172.5ms) User Load (0.2ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_links.html.erb (20.3ms) CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_blogger_information.html.erb (18.7ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post.html.erb (290.8ms) ActsAsTaggableOn::Tag Load (0.1ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) CACHE (0.0ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) Blogit::Post Load (0.2ms) SELECT blog_posts.*, COUNT(tags.id) AS count FROM blog_posts, tags, taggings WHERE (blog_posts.id != 2 AND blog_posts.id = taggings.taggable_id AND taggings.taggable_type = 'Blogit::Post' AND taggings.tag_id = tags.id AND tags.name IN ('one','two','three')) GROUP BY blog_posts.id ORDER BY count DESC Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_related.html.erb (42.2ms) Rendered blogit/posts/_post_footer.html.erb (43.3ms) Blogit::Comment Load (0.1ms) SELECT "blog_comments".* FROM "blog_comments" WHERE "blog_comments"."post_id" = 2 Rendered collection (0.0ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/comments/_form.html.erb (7.3ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_active_record_comments.html.erb (10.8ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/show.html.erb within layouts/application (367.4ms) Blogit::Post Load (0.2ms) SELECT "blog_posts".* FROM "blog_posts" ORDER BY created_at DESC Completed 200 OK in 407ms (Views: 396.4ms | ActiveRecord: 2.2ms) Started GET "/assets/blogit/index.css?body=1" for 127.0.0.1 at 2013-04-14 18:02:21 +0100 Served asset /blogit/index.css - 304 Not Modified (3ms) Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2013-04-14 18:02:21 +0100 Served asset /application.js - 304 Not Modified (12ms) Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2013-04-14 18:02:21 +0100 Served asset /jquery_ujs.js - 304 Not Modified (1ms) Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2013-04-14 18:02:21 +0100 Served asset /jquery.js - 304 Not Modified (2ms) Started GET "/assets/blogit/archive.js?body=1" for 127.0.0.1 at 2013-04-14 18:02:21 +0100 Served asset /blogit/archive.js - 304 Not Modified (2ms) Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2013-04-14 18:02:21 +0100 Served asset /application.css - 304 Not Modified (3ms) Started GET "/assets/blogit/index.js?body=1" for 127.0.0.1 at 2013-04-14 18:02:21 +0100 Served asset /blogit/index.js - 304 Not Modified (4ms) Connecting to database specified by database.yml Started GET "/blog/posts/2-this-is-a-new-blog-post" for 127.0.0.1 at 2013-04-14 18:21:11 +0100 Processing by Blogit::PostsController#show as HTML Parameters: {"id"=>"2-this-is-a-new-blog-post"} Blogit::Post Load (0.1ms) SELECT "blog_posts".* FROM "blog_posts" WHERE "blog_posts"."id" = ? LIMIT 1 [["id", "2-this-is-a-new-blog-post"]] Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_head.html.erb (1.1ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_body.html.erb (209.0ms) User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_links.html.erb (1.8ms) CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_blogger_information.html.erb (1.2ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post.html.erb (217.4ms) ActsAsTaggableOn::Tag Load (0.2ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) CACHE (0.0ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) Blogit::Post Load (0.2ms) SELECT blog_posts.*, COUNT(tags.id) AS count FROM blog_posts, tags, taggings WHERE (blog_posts.id != 2 AND blog_posts.id = taggings.taggable_id AND taggings.taggable_type = 'Blogit::Post' AND taggings.tag_id = tags.id AND tags.name IN ('one','two','three')) GROUP BY blog_posts.id ORDER BY count DESC Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_related.html.erb (4.0ms) Rendered blogit/posts/_post_footer.html.erb (4.7ms) Blogit::Comment Load (0.1ms) SELECT "blog_comments".* FROM "blog_comments" WHERE "blog_comments"."post_id" = 2 Rendered collection (0.0ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/comments/_form.html.erb (2.9ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_active_record_comments.html.erb (4.6ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/show.html.erb within layouts/application (229.6ms) Blogit::Post Load (0.2ms) SELECT "blog_posts".* FROM "blog_posts" ORDER BY created_at DESC Completed 200 OK in 240ms (Views: 238.4ms | ActiveRecord: 0.9ms) Started GET "/assets/blogit/index.css?body=1" for 127.0.0.1 at 2013-04-14 18:21:12 +0100 Served asset /blogit/index.css - 304 Not Modified (0ms) Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2013-04-14 18:21:12 +0100 Served asset /jquery.js - 304 Not Modified (0ms) Started GET "/assets/blogit/archive.js?body=1" for 127.0.0.1 at 2013-04-14 18:21:12 +0100 Served asset /blogit/archive.js - 304 Not Modified (0ms) Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2013-04-14 18:21:12 +0100 Served asset /application.css - 304 Not Modified (0ms) Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2013-04-14 18:21:12 +0100 Served asset /jquery_ujs.js - 304 Not Modified (0ms) Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2013-04-14 18:21:12 +0100 Served asset /application.js - 304 Not Modified (0ms) Started GET "/assets/blogit/index.js?body=1" for 127.0.0.1 at 2013-04-14 18:21:12 +0100 Served asset /blogit/index.js - 304 Not Modified (0ms) Started GET "/blog/posts/2-this-is-a-new-blog-post" for 127.0.0.1 at 2013-04-14 18:21:55 +0100 Processing by Blogit::PostsController#show as HTML Parameters: {"id"=>"2-this-is-a-new-blog-post"} Blogit::Post Load (0.1ms) SELECT "blog_posts".* FROM "blog_posts" WHERE "blog_posts"."id" = ? LIMIT 1 [["id", "2-this-is-a-new-blog-post"]] Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_head.html.erb (0.6ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_body.html.erb (172.1ms) User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_links.html.erb (1.8ms) CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_blogger_information.html.erb (1.4ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post.html.erb (179.5ms) ActsAsTaggableOn::Tag Load (0.2ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) CACHE (0.0ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) Blogit::Post Load (0.2ms) SELECT blog_posts.*, COUNT(tags.id) AS count FROM blog_posts, tags, taggings WHERE (blog_posts.id != 2 AND blog_posts.id = taggings.taggable_id AND taggings.taggable_type = 'Blogit::Post' AND taggings.tag_id = tags.id AND tags.name IN ('one','two','three')) GROUP BY blog_posts.id ORDER BY count DESC Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_related.html.erb (3.6ms) Rendered blogit/posts/_post_footer.html.erb (4.3ms) Blogit::Comment Load (0.1ms) SELECT "blog_comments".* FROM "blog_comments" WHERE "blog_comments"."post_id" = 2 Rendered collection (0.0ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/comments/_form.html.erb (2.6ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_active_record_comments.html.erb (4.1ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/show.html.erb within layouts/application (190.6ms) Completed 500 Internal Server Error in 207ms ActionView::Template::Error (couldn't find file 'blogit/pygments' (in /Users/Gavin/Gems/blogit/spec/dummy/app/assets/stylesheets/application.css:7)): 2: 3: 4: Dummy 5: <%= stylesheet_link_tag "blogit", "application" %> 6: <%= csrf_meta_tags %> 7: 8: app/views/layouts/application.html.erb:5:in `_app_views_layouts_application_html_erb__245696387247541801_70120291360540' Rendered /Users/Gavin/.rvm/gems/ruby-1.9.3-p194@blogit/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/_trace.erb (1.2ms) Rendered /Users/Gavin/.rvm/gems/ruby-1.9.3-p194@blogit/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (0.7ms) Rendered /Users/Gavin/.rvm/gems/ruby-1.9.3-p194@blogit/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/template_error.erb within rescues/layout (6.4ms) Started GET "/blog/posts/2-this-is-a-new-blog-post" for 127.0.0.1 at 2013-04-14 18:22:24 +0100 Processing by Blogit::PostsController#show as HTML Parameters: {"id"=>"2-this-is-a-new-blog-post"} Blogit::Post Load (0.1ms) SELECT "blog_posts".* FROM "blog_posts" WHERE "blog_posts"."id" = ? LIMIT 1 [["id", "2-this-is-a-new-blog-post"]] Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_head.html.erb (0.7ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_body.html.erb (174.8ms) User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_links.html.erb (1.7ms) CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_blogger_information.html.erb (1.0ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post.html.erb (181.3ms) ActsAsTaggableOn::Tag Load (0.1ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) CACHE (0.0ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) Blogit::Post Load (0.2ms) SELECT blog_posts.*, COUNT(tags.id) AS count FROM blog_posts, tags, taggings WHERE (blog_posts.id != 2 AND blog_posts.id = taggings.taggable_id AND taggings.taggable_type = 'Blogit::Post' AND taggings.tag_id = tags.id AND tags.name IN ('one','two','three')) GROUP BY blog_posts.id ORDER BY count DESC Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_related.html.erb (4.6ms) Rendered blogit/posts/_post_footer.html.erb (5.4ms) Blogit::Comment Load (0.1ms) SELECT "blog_comments".* FROM "blog_comments" WHERE "blog_comments"."post_id" = 2 Rendered collection (0.0ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/comments/_form.html.erb (2.9ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_active_record_comments.html.erb (4.4ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/show.html.erb within layouts/application (193.4ms) Completed 500 Internal Server Error in 205ms ActionView::Template::Error (cannot load such file -- sass (in /Users/Gavin/Gems/blogit/app/assets/stylesheets/blogit/pygments.css.scss)): 2: 3: 4: Dummy 5: <%= stylesheet_link_tag "blogit", "application" %> 6: <%= csrf_meta_tags %> 7: 8: app/views/layouts/application.html.erb:5:in `_app_views_layouts_application_html_erb__245696387247541801_70120291360540' Rendered /Users/Gavin/.rvm/gems/ruby-1.9.3-p194@blogit/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/_trace.erb (1.2ms) Rendered /Users/Gavin/.rvm/gems/ruby-1.9.3-p194@blogit/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (2.0ms) Rendered /Users/Gavin/.rvm/gems/ruby-1.9.3-p194@blogit/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/template_error.erb within rescues/layout (7.5ms) Started GET "/blog/posts/2-this-is-a-new-blog-post" for 127.0.0.1 at 2013-04-14 18:24:32 +0100 Processing by Blogit::PostsController#show as HTML Parameters: {"id"=>"2-this-is-a-new-blog-post"} Blogit::Post Load (0.1ms) SELECT "blog_posts".* FROM "blog_posts" WHERE "blog_posts"."id" = ? LIMIT 1 [["id", "2-this-is-a-new-blog-post"]] Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_head.html.erb (0.7ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_body.html.erb (171.4ms) User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_links.html.erb (1.9ms) CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_blogger_information.html.erb (1.1ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post.html.erb (178.6ms) ActsAsTaggableOn::Tag Load (0.2ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) CACHE (0.0ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) Blogit::Post Load (0.2ms) SELECT blog_posts.*, COUNT(tags.id) AS count FROM blog_posts, tags, taggings WHERE (blog_posts.id != 2 AND blog_posts.id = taggings.taggable_id AND taggings.taggable_type = 'Blogit::Post' AND taggings.tag_id = tags.id AND tags.name IN ('one','two','three')) GROUP BY blog_posts.id ORDER BY count DESC Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_related.html.erb (3.7ms) Rendered blogit/posts/_post_footer.html.erb (4.4ms) Blogit::Comment Load (0.1ms) SELECT "blog_comments".* FROM "blog_comments" WHERE "blog_comments"."post_id" = 2 Rendered collection (0.0ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/comments/_form.html.erb (2.5ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_active_record_comments.html.erb (4.0ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/show.html.erb within layouts/application (189.6ms) Compiled blogit/pygments.css (0ms) (pid 2799) Compiled application.css (61ms) (pid 2799) Blogit::Post Load (0.2ms) SELECT "blog_posts".* FROM "blog_posts" ORDER BY created_at DESC Completed 200 OK in 279ms (Views: 277.7ms | ActiveRecord: 0.8ms) Started GET "/assets/blogit/index.css?body=1" for 127.0.0.1 at 2013-04-14 18:24:32 +0100 Served asset /blogit/index.css - 304 Not Modified (0ms) Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2013-04-14 18:24:32 +0100 Served asset /application.css - 200 OK (14ms) Started GET "/assets/blogit/pygments.css?body=1" for 127.0.0.1 at 2013-04-14 18:24:32 +0100 Served asset /blogit/pygments.css - 200 OK (4ms) Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2013-04-14 18:24:32 +0100 Served asset /jquery_ujs.js - 304 Not Modified (0ms) Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2013-04-14 18:24:32 +0100 Served asset /application.js - 304 Not Modified (0ms) Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2013-04-14 18:24:33 +0100 Served asset /jquery.js - 304 Not Modified (0ms) Started GET "/assets/blogit/archive.js?body=1" for 127.0.0.1 at 2013-04-14 18:24:33 +0100 Served asset /blogit/archive.js - 304 Not Modified (0ms) Started GET "/assets/blogit/index.js?body=1" for 127.0.0.1 at 2013-04-14 18:24:33 +0100 Served asset /blogit/index.js - 304 Not Modified (0ms) Started GET "/blog/posts/2-this-is-a-new-blog-post" for 127.0.0.1 at 2013-04-14 18:25:47 +0100 Processing by Blogit::PostsController#show as HTML Parameters: {"id"=>"2-this-is-a-new-blog-post"} Blogit::Post Load (0.1ms) SELECT "blog_posts".* FROM "blog_posts" WHERE "blog_posts"."id" = ? LIMIT 1 [["id", "2-this-is-a-new-blog-post"]] Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_head.html.erb (0.9ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_body.html.erb (171.6ms) User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_links.html.erb (1.6ms) CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_blogger_information.html.erb (1.0ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post.html.erb (178.8ms) ActsAsTaggableOn::Tag Load (0.2ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) CACHE (0.0ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) Blogit::Post Load (0.2ms) SELECT blog_posts.*, COUNT(tags.id) AS count FROM blog_posts, tags, taggings WHERE (blog_posts.id != 2 AND blog_posts.id = taggings.taggable_id AND taggings.taggable_type = 'Blogit::Post' AND taggings.tag_id = tags.id AND tags.name IN ('one','two','three')) GROUP BY blog_posts.id ORDER BY count DESC Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_related.html.erb (3.8ms) Rendered blogit/posts/_post_footer.html.erb (4.6ms) Blogit::Comment Load (0.1ms) SELECT "blog_comments".* FROM "blog_comments" WHERE "blog_comments"."post_id" = 2 Rendered collection (0.0ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/comments/_form.html.erb (2.7ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_active_record_comments.html.erb (4.3ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/show.html.erb within layouts/application (190.4ms) Blogit::Post Load (0.2ms) SELECT "blog_posts".* FROM "blog_posts" ORDER BY created_at DESC Completed 200 OK in 198ms (Views: 196.9ms | ActiveRecord: 0.8ms) Started GET "/assets/blogit/index.css?body=1" for 127.0.0.1 at 2013-04-14 18:25:48 +0100 Served asset /blogit/index.css - 304 Not Modified (0ms) Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2013-04-14 18:25:48 +0100 Served asset /jquery.js - 304 Not Modified (0ms) Started GET "/assets/blogit/pygments.css?body=1" for 127.0.0.1 at 2013-04-14 18:25:48 +0100 Served asset /blogit/pygments.css - 304 Not Modified (0ms) Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2013-04-14 18:25:48 +0100 Served asset /application.js - 304 Not Modified (0ms) Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2013-04-14 18:25:48 +0100 Served asset /application.css - 304 Not Modified (0ms) Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2013-04-14 18:25:48 +0100 Served asset /jquery_ujs.js - 304 Not Modified (0ms) Started GET "/assets/blogit/archive.js?body=1" for 127.0.0.1 at 2013-04-14 18:25:48 +0100 Served asset /blogit/archive.js - 304 Not Modified (0ms) Started GET "/assets/blogit/index.js?body=1" for 127.0.0.1 at 2013-04-14 18:25:48 +0100 Served asset /blogit/index.js - 304 Not Modified (0ms) Started GET "/blog/posts/2-this-is-a-new-blog-post" for 127.0.0.1 at 2013-04-14 18:26:04 +0100 Processing by Blogit::PostsController#show as HTML Parameters: {"id"=>"2-this-is-a-new-blog-post"} Blogit::Post Load (0.1ms) SELECT "blog_posts".* FROM "blog_posts" WHERE "blog_posts"."id" = ? LIMIT 1 [["id", "2-this-is-a-new-blog-post"]] Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_head.html.erb (1.0ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_body.html.erb (190.6ms) User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_links.html.erb (1.6ms) CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_blogger_information.html.erb (1.1ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post.html.erb (197.9ms) ActsAsTaggableOn::Tag Load (0.1ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) CACHE (0.0ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = 2 AND "taggings"."taggable_type" = 'Blogit::Post' AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) Blogit::Post Load (0.1ms) SELECT blog_posts.*, COUNT(tags.id) AS count FROM blog_posts, tags, taggings WHERE (blog_posts.id != 2 AND blog_posts.id = taggings.taggable_id AND taggings.taggable_type = 'Blogit::Post' AND taggings.tag_id = tags.id AND tags.name IN ('one','two','three')) GROUP BY blog_posts.id ORDER BY count DESC Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_related.html.erb (3.3ms) Rendered blogit/posts/_post_footer.html.erb (4.0ms) Blogit::Comment Load (0.1ms) SELECT "blog_comments".* FROM "blog_comments" WHERE "blog_comments"."post_id" = 2 Rendered collection (0.0ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/comments/_form.html.erb (2.4ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_active_record_comments.html.erb (4.2ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/show.html.erb within layouts/application (208.6ms) Compiled application.css (0ms) (pid 2799) Blogit::Post Load (0.2ms) SELECT "blog_posts".* FROM "blog_posts" ORDER BY created_at DESC Completed 200 OK in 232ms (Views: 229.8ms | ActiveRecord: 0.8ms) Started GET "/assets/blogit/index.css?body=1" for 127.0.0.1 at 2013-04-14 18:26:04 +0100 Served asset /blogit/index.css - 304 Not Modified (0ms) Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2013-04-14 18:26:04 +0100 Served asset /jquery.js - 304 Not Modified (0ms) Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2013-04-14 18:26:04 +0100 Served asset /application.js - 304 Not Modified (0ms) Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2013-04-14 18:26:04 +0100 Served asset /jquery_ujs.js - 304 Not Modified (0ms) Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2013-04-14 18:26:04 +0100 Served asset /application.css - 200 OK (3ms) Started GET "/assets/blogit/archive.js?body=1" for 127.0.0.1 at 2013-04-14 18:26:04 +0100 Served asset /blogit/archive.js - 304 Not Modified (0ms) Started GET "/assets/blogit/index.js?body=1" for 127.0.0.1 at 2013-04-14 18:26:04 +0100 Served asset /blogit/index.js - 304 Not Modified (0ms) Connecting to database specified by database.yml Connecting to database specified by database.yml Connecting to database specified by database.yml Connecting to database specified by database.yml Connecting to database specified by database.yml Connecting to database specified by database.yml Connecting to database specified by database.yml Connecting to database specified by database.yml Connecting to database specified by database.yml Connecting to database specified by database.yml Connecting to database specified by database.yml Connecting to database specified by database.yml Connecting to database specified by database.yml Connecting to database specified by database.yml Started GET "/blog/posts/2-this-is-a-new-blog-post" for 127.0.0.1 at 2013-04-14 19:02:06 +0100 Processing by Blogit::PostsController#show as HTML Parameters: {"id"=>"2-this-is-a-new-blog-post"} Blogit::Post Load (0.1ms) SELECT "blog_posts".* FROM "blog_posts" WHERE "blog_posts"."id" = ? LIMIT 1 [["id", "2-this-is-a-new-blog-post"]] Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_head.html.erb (0.9ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_body.html.erb (180.2ms) User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_links.html.erb (1.7ms) CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_blogger_information.html.erb (1.2ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post.html.erb (188.0ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_post_footer.html.erb (0.3ms) Blogit::Comment Load (0.1ms) SELECT "blog_comments".* FROM "blog_comments" WHERE "blog_comments"."post_id" = 2 Rendered collection (0.0ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/comments/_form.html.erb (2.7ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/_active_record_comments.html.erb (4.7ms) Rendered /Users/Gavin/Gems/blogit/app/views/blogit/posts/show.html.erb within layouts/application (196.0ms) Blogit::Post Load (0.2ms) SELECT "blog_posts".* FROM "blog_posts" ORDER BY created_at DESC Completed 200 OK in 205ms (Views: 203.4ms | ActiveRecord: 0.6ms) Started GET "/assets/blogit/index.css?body=1" for 127.0.0.1 at 2013-04-14 19:02:07 +0100 Served asset /blogit/index.css - 304 Not Modified (0ms) Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2013-04-14 19:02:07 +0100 Served asset /application.css - 304 Not Modified (9ms) Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2013-04-14 19:02:07 +0100 Served asset /jquery.js - 304 Not Modified (0ms) Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2013-04-14 19:02:07 +0100 Served asset /jquery_ujs.js - 304 Not Modified (0ms) Started GET "/assets/blogit/archive.js?body=1" for 127.0.0.1 at 2013-04-14 19:02:07 +0100 Served asset /blogit/archive.js - 304 Not Modified (0ms) Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2013-04-14 19:02:07 +0100 Served asset /application.js - 304 Not Modified (0ms) Started GET "/assets/blogit/index.js?body=1" for 127.0.0.1 at 2013-04-14 19:02:07 +0100 Served asset /blogit/index.js - 304 Not Modified (0ms)