spec/dummy/log/test.log in abstracted-0.3.4 vs spec/dummy/log/test.log in abstracted-0.4.1
- old
+ new
@@ -15026,5 +15026,885 @@
[1m[35mUser Load (0.0ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", 1]]
[1m[36mCACHE (0.0ms)[0m [1mSELECT "posts".* FROM "posts" WHERE "posts"."id" = ? LIMIT 1[0m [["id", "1"]]
Rendered text template (0.0ms)
Completed 200 OK in 2ms (Views: 0.3ms | ActiveRecord: 0.1ms)
[1m[35m (0.9ms)[0m rollback transaction
+ [1m[36mActiveRecord::SchemaMigration Load (0.4ms)[0m [1mSELECT "schema_migrations".* FROM "schema_migrations"[0m
+ [1m[35mActiveRecord::SchemaMigration Load (0.1ms)[0m SELECT "schema_migrations".* FROM "schema_migrations"
+ [1m[36m (1.4ms)[0m [1mDROP TABLE "users"[0m
+ [1m[35m (0.7ms)[0m CREATE TABLE "users" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "login" varchar)
+ [1m[36m (0.8ms)[0m [1mDROP TABLE "posts"[0m
+ [1m[35m (0.7ms)[0m CREATE TABLE "posts" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "title" varchar, "user_id" integer)
+ [1m[36m (0.1ms)[0m [1mSELECT version FROM "schema_migrations"[0m
+ [1m[35m (0.1ms)[0m begin transaction
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.4ms)[0m INSERT INTO "users" ("id", "login") VALUES (?, ?) [["id", 1], ["login", "test"]]
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (1.1ms)[0m [1mINSERT INTO "posts" ("id", "user_id", "title") VALUES (?, ?, ?)[0m [["id", 1], ["user_id", 1], ["title", "test"]]
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+Started GET "/users/1/posts/1" for 127.0.0.1 at 2016-03-14 16:51:27 +0100
+Processing by PostsController#show as HTML
+ Parameters: {"user_id"=>"1", "id"=>"1"}
+ [1m[36mPost Load (0.1ms)[0m [1mSELECT "posts".* FROM "posts" WHERE "posts"."id" = ? LIMIT 1[0m [["id", 1]]
+ [1m[35mUser Load (0.1ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", 1]]
+ [1m[36mCACHE (0.0ms)[0m [1mSELECT "posts".* FROM "posts" WHERE "posts"."id" = ? LIMIT 1[0m [["id", "1"]]
+ Rendered text template (0.0ms)
+Completed 200 OK in 20ms (Views: 9.8ms | ActiveRecord: 0.2ms)
+ [1m[35m (0.9ms)[0m rollback transaction
+ [1m[36m (0.0ms)[0m [1mbegin transaction[0m
+Started GET "/admin/users" for 127.0.0.1 at 2016-03-14 16:51:27 +0100
+Processing by UsersController#index as HTML
+ [1m[35mUser Load (0.1ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", nil]]
+ [1m[36mCACHE (0.0ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1[0m [["id", nil]]
+ Rendered text template (0.0ms)
+Completed 200 OK in 6ms (Views: 2.7ms | ActiveRecord: 0.1ms)
+ [1m[35m (0.1ms)[0m rollback transaction
+ [1m[36m (0.1ms)[0m [1mbegin transaction[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.3ms)[0m [1mINSERT INTO "users" ("id", "login") VALUES (?, ?)[0m [["id", 1], ["login", "test"]]
+ [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+Started GET "/admin/users/1?q=mx" for 127.0.0.1 at 2016-03-14 16:51:27 +0100
+Processing by UsersController#show as HTML
+ Parameters: {"q"=>"mx", "id"=>"1"}
+ [1m[36mUser Load (0.1ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1[0m [["id", 1]]
+ [1m[35mCACHE (0.0ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", "1"]]
+ Rendered text template (0.0ms)
+Completed 200 OK in 2ms (Views: 0.3ms | ActiveRecord: 0.1ms)
+ [1m[36m (0.5ms)[0m [1mrollback transaction[0m
+ [1m[35m (0.1ms)[0m begin transaction
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.3ms)[0m INSERT INTO "users" ("id", "login") VALUES (?, ?) [["id", 1], ["login", "test"]]
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Started GET "/users/1/posts" for 127.0.0.1 at 2016-03-14 16:51:27 +0100
+Processing by PostsController#index as HTML
+ Parameters: {"user_id"=>"1"}
+ [1m[35mPost Load (0.1ms)[0m SELECT "posts".* FROM "posts" WHERE "posts"."id" = ? LIMIT 1 [["id", nil]]
+ [1m[36mUser Load (0.0ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1[0m [["id", 1]]
+ Rendered text template (0.0ms)
+Completed 200 OK in 16ms (Views: 0.4ms | ActiveRecord: 0.1ms)
+ [1m[35m (0.5ms)[0m rollback transaction
+ [1m[36m (0.0ms)[0m [1mbegin transaction[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mINSERT INTO "users" ("id", "login") VALUES (?, ?)[0m [["id", 1], ["login", "test"]]
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+Started GET "/admin/users/1" for 127.0.0.1 at 2016-03-14 16:51:27 +0100
+Processing by UsersController#show as HTML
+ Parameters: {"id"=>"1"}
+ [1m[36mUser Load (0.0ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1[0m [["id", 1]]
+ [1m[35mCACHE (0.0ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", "1"]]
+ Rendered text template (0.0ms)
+Completed 200 OK in 2ms (Views: 0.3ms | ActiveRecord: 0.0ms)
+ [1m[36m (0.5ms)[0m [1mrollback transaction[0m
+ [1m[35m (0.0ms)[0m begin transaction
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.2ms)[0m INSERT INTO "users" ("id", "login") VALUES (?, ?) [["id", 1], ["login", "test"]]
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Started GET "/users/1" for 127.0.0.1 at 2016-03-14 16:51:27 +0100
+Processing by UsersController#show as HTML
+ Parameters: {"id"=>"1"}
+ [1m[35mUser Load (0.0ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", 1]]
+ [1m[36mCACHE (0.0ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1[0m [["id", "1"]]
+ Rendered text template (0.0ms)
+Completed 200 OK in 2ms (Views: 0.3ms | ActiveRecord: 0.1ms)
+ [1m[35m (1.0ms)[0m rollback transaction
+ [1m[36m (0.0ms)[0m [1mbegin transaction[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.3ms)[0m [1mINSERT INTO "users" ("id", "login") VALUES (?, ?)[0m [["id", 1], ["login", "test"]]
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+Started GET "/users/1/edit" for 127.0.0.1 at 2016-03-14 16:51:27 +0100
+Processing by UsersController#edit as HTML
+ Parameters: {"id"=>"1"}
+ [1m[36mUser Load (0.1ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1[0m [["id", 1]]
+ [1m[35mCACHE (0.0ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", "1"]]
+ Rendered text template (0.0ms)
+Completed 200 OK in 10ms (Views: 0.3ms | ActiveRecord: 0.1ms)
+ [1m[36m (6.8ms)[0m [1mrollback transaction[0m
+ [1m[35m (0.1ms)[0m begin transaction
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.3ms)[0m INSERT INTO "users" ("id", "login") VALUES (?, ?) [["id", 1], ["login", "test"]]
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Started GET "/admin/users/1/edit" for 127.0.0.1 at 2016-03-14 16:51:27 +0100
+Processing by UsersController#edit as HTML
+ Parameters: {"id"=>"1"}
+ [1m[35mUser Load (0.1ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", 1]]
+ [1m[36mCACHE (0.0ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1[0m [["id", "1"]]
+ Rendered text template (0.0ms)
+Completed 200 OK in 2ms (Views: 0.3ms | ActiveRecord: 0.1ms)
+ [1m[35m (0.4ms)[0m rollback transaction
+ [1m[36m (0.1ms)[0m [1mbegin transaction[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mINSERT INTO "users" ("id", "login") VALUES (?, ?)[0m [["id", 1], ["login", "test"]]
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+Started GET "/admin/users/1/edit?q=mx" for 127.0.0.1 at 2016-03-14 16:51:27 +0100
+Processing by UsersController#edit as HTML
+ Parameters: {"q"=>"mx", "id"=>"1"}
+ [1m[36mUser Load (0.1ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1[0m [["id", 1]]
+ [1m[35mCACHE (0.0ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", "1"]]
+ Rendered text template (0.1ms)
+Completed 200 OK in 2ms (Views: 0.3ms | ActiveRecord: 0.1ms)
+ [1m[36m (0.4ms)[0m [1mrollback transaction[0m
+ [1m[35m (0.1ms)[0m begin transaction
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.2ms)[0m INSERT INTO "users" ("id", "login") VALUES (?, ?) [["id", 1], ["login", "test"]]
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.3ms)[0m [1mINSERT INTO "posts" ("id", "user_id", "title") VALUES (?, ?, ?)[0m [["id", 1], ["user_id", 1], ["title", "test"]]
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+Started GET "/users/1/posts/1/edit" for 127.0.0.1 at 2016-03-14 16:51:27 +0100
+Processing by PostsController#edit as HTML
+ Parameters: {"user_id"=>"1", "id"=>"1"}
+ [1m[36mPost Load (0.1ms)[0m [1mSELECT "posts".* FROM "posts" WHERE "posts"."id" = ? LIMIT 1[0m [["id", 1]]
+ [1m[35mUser Load (0.0ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", 1]]
+ [1m[36mCACHE (0.0ms)[0m [1mSELECT "posts".* FROM "posts" WHERE "posts"."id" = ? LIMIT 1[0m [["id", "1"]]
+ Rendered text template (0.0ms)
+Completed 200 OK in 2ms (Views: 0.3ms | ActiveRecord: 0.1ms)
+ [1m[35m (0.5ms)[0m rollback transaction
+ [1m[36m (0.0ms)[0m [1mbegin transaction[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.3ms)[0m [1mINSERT INTO "users" ("id", "login") VALUES (?, ?)[0m [["id", 1], ["login", "test"]]
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+Started GET "/users/1" for 127.0.0.1 at 2016-03-14 16:51:27 +0100
+Processing by UsersController#show as HTML
+ Parameters: {"id"=>"1"}
+ [1m[36mUser Load (0.0ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1[0m [["id", 1]]
+ [1m[35mCACHE (0.0ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", "1"]]
+ Rendered text template (0.0ms)
+Completed 200 OK in 2ms (Views: 0.3ms | ActiveRecord: 0.1ms)
+ [1m[36m (0.4ms)[0m [1mrollback transaction[0m
+ [1m[35m (0.0ms)[0m begin transaction
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.3ms)[0m INSERT INTO "users" ("id", "login") VALUES (?, ?) [["id", 1], ["login", "test"]]
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Started GET "/admin/users/1" for 127.0.0.1 at 2016-03-14 16:51:27 +0100
+Processing by UsersController#show as HTML
+ Parameters: {"id"=>"1"}
+ [1m[35mUser Load (0.1ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", 1]]
+ [1m[36mCACHE (0.0ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1[0m [["id", "1"]]
+ Rendered text template (0.0ms)
+Completed 200 OK in 2ms (Views: 0.4ms | ActiveRecord: 0.1ms)
+ [1m[35m (0.4ms)[0m rollback transaction
+ [1m[36m (0.0ms)[0m [1mbegin transaction[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.3ms)[0m [1mINSERT INTO "users" ("id", "login") VALUES (?, ?)[0m [["id", 1], ["login", "test"]]
+ [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+Started GET "/admin/users/1?q=mx" for 127.0.0.1 at 2016-03-14 16:51:27 +0100
+Processing by UsersController#show as HTML
+ Parameters: {"q"=>"mx", "id"=>"1"}
+ [1m[36mUser Load (0.1ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1[0m [["id", 1]]
+ [1m[35mCACHE (0.0ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", "1"]]
+ Rendered text template (0.0ms)
+Completed 200 OK in 2ms (Views: 0.3ms | ActiveRecord: 0.1ms)
+ [1m[36m (0.4ms)[0m [1mrollback transaction[0m
+ [1m[35m (0.0ms)[0m begin transaction
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.3ms)[0m INSERT INTO "users" ("id", "login") VALUES (?, ?) [["id", 1], ["login", "test"]]
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mINSERT INTO "posts" ("id", "user_id", "title") VALUES (?, ?, ?)[0m [["id", 1], ["user_id", 1], ["title", "test"]]
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+Started GET "/users/1/posts/1" for 127.0.0.1 at 2016-03-14 16:51:27 +0100
+Processing by PostsController#show as HTML
+ Parameters: {"user_id"=>"1", "id"=>"1"}
+ [1m[36mPost Load (0.0ms)[0m [1mSELECT "posts".* FROM "posts" WHERE "posts"."id" = ? LIMIT 1[0m [["id", 1]]
+ [1m[35mUser Load (0.0ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", 1]]
+ [1m[36mCACHE (0.0ms)[0m [1mSELECT "posts".* FROM "posts" WHERE "posts"."id" = ? LIMIT 1[0m [["id", "1"]]
+ Rendered text template (0.0ms)
+Completed 200 OK in 2ms (Views: 0.4ms | ActiveRecord: 0.1ms)
+ [1m[35m (0.5ms)[0m rollback transaction
+ [1m[36m (0.0ms)[0m [1mbegin transaction[0m
+ [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mINSERT INTO "users" ("id", "login") VALUES (?, ?)[0m [["id", 1], ["login", "test"]]
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+Started GET "/users/1/edit" for 127.0.0.1 at 2016-03-14 16:51:27 +0100
+Processing by UsersController#edit as HTML
+ Parameters: {"id"=>"1"}
+ [1m[36mUser Load (0.0ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1[0m [["id", 1]]
+ [1m[35mCACHE (0.0ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", "1"]]
+ Rendered text template (0.0ms)
+Completed 200 OK in 2ms (Views: 0.3ms | ActiveRecord: 0.1ms)
+ [1m[36m (0.9ms)[0m [1mrollback transaction[0m
+ [1m[35m (0.0ms)[0m begin transaction
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.3ms)[0m INSERT INTO "users" ("id", "login") VALUES (?, ?) [["id", 1], ["login", "test"]]
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Started GET "/admin/users/1/edit" for 127.0.0.1 at 2016-03-14 16:51:27 +0100
+Processing by UsersController#edit as HTML
+ Parameters: {"id"=>"1"}
+ [1m[35mUser Load (0.0ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", 1]]
+ [1m[36mCACHE (0.0ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1[0m [["id", "1"]]
+ Rendered text template (0.0ms)
+Completed 200 OK in 2ms (Views: 0.3ms | ActiveRecord: 0.1ms)
+ [1m[35m (0.4ms)[0m rollback transaction
+ [1m[36m (0.0ms)[0m [1mbegin transaction[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mINSERT INTO "users" ("id", "login") VALUES (?, ?)[0m [["id", 1], ["login", "test"]]
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+Started GET "/admin/users/1/edit?q=mx" for 127.0.0.1 at 2016-03-14 16:51:27 +0100
+Processing by UsersController#edit as HTML
+ Parameters: {"q"=>"mx", "id"=>"1"}
+ [1m[36mUser Load (0.0ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1[0m [["id", 1]]
+ [1m[35mCACHE (0.0ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", "1"]]
+ Rendered text template (0.0ms)
+Completed 200 OK in 2ms (Views: 0.3ms | ActiveRecord: 0.1ms)
+ [1m[36m (0.4ms)[0m [1mrollback transaction[0m
+ [1m[35m (0.0ms)[0m begin transaction
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.2ms)[0m INSERT INTO "users" ("id", "login") VALUES (?, ?) [["id", 1], ["login", "test"]]
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.3ms)[0m [1mINSERT INTO "posts" ("id", "user_id", "title") VALUES (?, ?, ?)[0m [["id", 1], ["user_id", 1], ["title", "test"]]
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+Started GET "/users/1/posts/1/edit" for 127.0.0.1 at 2016-03-14 16:51:27 +0100
+Processing by PostsController#edit as HTML
+ Parameters: {"user_id"=>"1", "id"=>"1"}
+ [1m[36mPost Load (0.1ms)[0m [1mSELECT "posts".* FROM "posts" WHERE "posts"."id" = ? LIMIT 1[0m [["id", 1]]
+ [1m[35mUser Load (0.0ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", 1]]
+ [1m[36mCACHE (0.0ms)[0m [1mSELECT "posts".* FROM "posts" WHERE "posts"."id" = ? LIMIT 1[0m [["id", "1"]]
+ Rendered text template (0.0ms)
+Completed 200 OK in 2ms (Views: 0.3ms | ActiveRecord: 0.1ms)
+ [1m[35m (0.5ms)[0m rollback transaction
+ [1m[36m (0.0ms)[0m [1mbegin transaction[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mINSERT INTO "users" ("id", "login") VALUES (?, ?)[0m [["id", 1], ["login", "test"]]
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.3ms)[0m INSERT INTO "posts" ("id", "user_id", "title") VALUES (?, ?, ?) [["id", 1], ["user_id", 1], ["title", "test"]]
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Started GET "/admin/users/1/posts/1/print" for 127.0.0.1 at 2016-03-14 16:51:27 +0100
+Processing by PostsController#print as HTML
+ Parameters: {"user_id"=>"1", "id"=>"1"}
+ [1m[35mPost Load (0.1ms)[0m SELECT "posts".* FROM "posts" WHERE "posts"."id" = ? LIMIT 1 [["id", 1]]
+ [1m[36mUser Load (0.0ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1[0m [["id", 1]]
+ [1m[35mCACHE (0.0ms)[0m SELECT "posts".* FROM "posts" WHERE "posts"."id" = ? LIMIT 1 [["id", "1"]]
+ Rendered text template (0.0ms)
+Completed 200 OK in 2ms (Views: 0.3ms | ActiveRecord: 0.1ms)
+ [1m[36m (1.0ms)[0m [1mrollback transaction[0m
+ [1m[35m (0.0ms)[0m begin transaction
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.3ms)[0m INSERT INTO "users" ("id", "login") VALUES (?, ?) [["id", 1], ["login", "test"]]
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mINSERT INTO "posts" ("id", "user_id", "title") VALUES (?, ?, ?)[0m [["id", 1], ["user_id", 1], ["title", "test"]]
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+Started GET "/users/1/posts/1/print" for 127.0.0.1 at 2016-03-14 16:51:27 +0100
+Processing by PostsController#print as HTML
+ Parameters: {"user_id"=>"1", "id"=>"1"}
+ [1m[36mPost Load (0.1ms)[0m [1mSELECT "posts".* FROM "posts" WHERE "posts"."id" = ? LIMIT 1[0m [["id", 1]]
+ [1m[35mUser Load (0.0ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", 1]]
+ [1m[36mCACHE (0.0ms)[0m [1mSELECT "posts".* FROM "posts" WHERE "posts"."id" = ? LIMIT 1[0m [["id", "1"]]
+ Rendered text template (0.0ms)
+Completed 200 OK in 2ms (Views: 0.3ms | ActiveRecord: 0.1ms)
+ [1m[35m (5.6ms)[0m rollback transaction
+ [1m[36m (0.1ms)[0m [1mbegin transaction[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.3ms)[0m [1mINSERT INTO "users" ("id", "login") VALUES (?, ?)[0m [["id", 1], ["login", "test"]]
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+Started GET "/admin/users/1/edit" for 127.0.0.1 at 2016-03-14 16:51:27 +0100
+Processing by UsersController#edit as HTML
+ Parameters: {"id"=>"1"}
+ [1m[36mUser Load (0.1ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1[0m [["id", 1]]
+ [1m[35mCACHE (0.0ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", "1"]]
+ Rendered text template (0.0ms)
+Completed 200 OK in 2ms (Views: 0.3ms | ActiveRecord: 0.1ms)
+ [1m[36m (1.2ms)[0m [1mrollback transaction[0m
+ [1m[35m (0.1ms)[0m begin transaction
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.3ms)[0m INSERT INTO "users" ("id", "login") VALUES (?, ?) [["id", 1], ["login", "test"]]
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Started GET "/users/1/print" for 127.0.0.1 at 2016-03-14 16:51:27 +0100
+Processing by UsersController#print as HTML
+ Parameters: {"id"=>"1"}
+ [1m[35mUser Load (0.1ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", 1]]
+ [1m[36mCACHE (0.0ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1[0m [["id", "1"]]
+ Rendered text template (0.0ms)
+Completed 200 OK in 2ms (Views: 0.3ms | ActiveRecord: 0.1ms)
+ [1m[35m (0.4ms)[0m rollback transaction
+ [1m[36mActiveRecord::SchemaMigration Load (0.4ms)[0m [1mSELECT "schema_migrations".* FROM "schema_migrations"[0m
+ [1m[35mActiveRecord::SchemaMigration Load (0.1ms)[0m SELECT "schema_migrations".* FROM "schema_migrations"
+ [1m[36m (1.4ms)[0m [1mDROP TABLE "users"[0m
+ [1m[35m (0.7ms)[0m CREATE TABLE "users" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "login" varchar)
+ [1m[36m (0.9ms)[0m [1mDROP TABLE "posts"[0m
+ [1m[35m (0.6ms)[0m CREATE TABLE "posts" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "title" varchar, "user_id" integer)
+ [1m[36m (0.1ms)[0m [1mSELECT version FROM "schema_migrations"[0m
+ [1m[35m (0.1ms)[0m begin transaction
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.4ms)[0m INSERT INTO "users" ("id", "login") VALUES (?, ?) [["id", 1], ["login", "test"]]
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Started GET "/admin/users/1?q=mx" for 127.0.0.1 at 2016-03-14 17:03:21 +0100
+Processing by UsersController#show as HTML
+ Parameters: {"q"=>"mx", "id"=>"1"}
+ [1m[35mUser Load (0.1ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", 1]]
+ [1m[36mCACHE (0.0ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1[0m [["id", "1"]]
+ Rendered text template (0.0ms)
+Completed 200 OK in 19ms (Views: 9.4ms | ActiveRecord: 0.1ms)
+ [1m[35m (0.3ms)[0m rollback transaction
+ [1m[36m (0.0ms)[0m [1mbegin transaction[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mINSERT INTO "users" ("id", "login") VALUES (?, ?)[0m [["id", 1], ["login", "test"]]
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (1.0ms)[0m INSERT INTO "posts" ("id", "user_id", "title") VALUES (?, ?, ?) [["id", 1], ["user_id", 1], ["title", "test"]]
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Started GET "/users/1/posts/1" for 127.0.0.1 at 2016-03-14 17:03:21 +0100
+Processing by PostsController#show as HTML
+ Parameters: {"user_id"=>"1", "id"=>"1"}
+ [1m[35mPost Load (0.1ms)[0m SELECT "posts".* FROM "posts" WHERE "posts"."id" = ? LIMIT 1 [["id", 1]]
+ [1m[36mUser Load (0.0ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1[0m [["id", 1]]
+ [1m[35mCACHE (0.0ms)[0m SELECT "posts".* FROM "posts" WHERE "posts"."id" = ? LIMIT 1 [["id", "1"]]
+ Rendered text template (0.0ms)
+Completed 200 OK in 6ms (Views: 3.1ms | ActiveRecord: 0.2ms)
+ [1m[36m (0.5ms)[0m [1mrollback transaction[0m
+ [1m[35m (0.0ms)[0m begin transaction
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.3ms)[0m INSERT INTO "users" ("id", "login") VALUES (?, ?) [["id", 1], ["login", "test"]]
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Started GET "/admin/users/1" for 127.0.0.1 at 2016-03-14 17:03:21 +0100
+Processing by UsersController#show as HTML
+ Parameters: {"id"=>"1"}
+ [1m[35mUser Load (0.0ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", 1]]
+ [1m[36mCACHE (0.0ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1[0m [["id", "1"]]
+ Rendered text template (0.0ms)
+Completed 200 OK in 2ms (Views: 0.3ms | ActiveRecord: 0.1ms)
+ [1m[35m (0.4ms)[0m rollback transaction
+ [1m[36m (0.0ms)[0m [1mbegin transaction[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mINSERT INTO "users" ("id", "login") VALUES (?, ?)[0m [["id", 1], ["login", "test"]]
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+Started GET "/users/1" for 127.0.0.1 at 2016-03-14 17:03:21 +0100
+Processing by UsersController#show as HTML
+ Parameters: {"id"=>"1"}
+ [1m[36mUser Load (0.1ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1[0m [["id", 1]]
+ [1m[35mCACHE (0.0ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", "1"]]
+ Rendered text template (0.0ms)
+Completed 200 OK in 2ms (Views: 0.4ms | ActiveRecord: 0.1ms)
+ [1m[36m (0.4ms)[0m [1mrollback transaction[0m
+ [1m[35m (0.0ms)[0m begin transaction
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.2ms)[0m INSERT INTO "users" ("id", "login") VALUES (?, ?) [["id", 1], ["login", "test"]]
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Started GET "/users/1/posts" for 127.0.0.1 at 2016-03-14 17:03:21 +0100
+Processing by PostsController#index as HTML
+ Parameters: {"user_id"=>"1"}
+ [1m[35mPost Load (0.0ms)[0m SELECT "posts".* FROM "posts" WHERE "posts"."id" = ? LIMIT 1 [["id", nil]]
+ [1m[36mUser Load (0.0ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1[0m [["id", 1]]
+ Rendered text template (0.0ms)
+Completed 200 OK in 23ms (Views: 0.4ms | ActiveRecord: 0.1ms)
+ [1m[35m (0.6ms)[0m rollback transaction
+ [1m[36m (0.0ms)[0m [1mbegin transaction[0m
+Started GET "/admin/users" for 127.0.0.1 at 2016-03-14 17:03:21 +0100
+Processing by UsersController#index as HTML
+ [1m[35mUser Load (0.1ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", nil]]
+ [1m[36mCACHE (0.0ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1[0m [["id", nil]]
+ Rendered text template (0.0ms)
+Completed 200 OK in 3ms (Views: 0.3ms | ActiveRecord: 0.1ms)
+ [1m[35m (0.1ms)[0m rollback transaction
+ [1m[36m (0.0ms)[0m [1mbegin transaction[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mINSERT INTO "users" ("id", "login") VALUES (?, ?)[0m [["id", 1], ["login", "test"]]
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+Started GET "/admin/users/1/edit" for 127.0.0.1 at 2016-03-14 17:03:21 +0100
+Processing by UsersController#edit as HTML
+ Parameters: {"id"=>"1"}
+ [1m[36mUser Load (0.0ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1[0m [["id", 1]]
+ [1m[35mCACHE (0.0ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", "1"]]
+ Rendered text template (0.0ms)
+Completed 200 OK in 2ms (Views: 0.3ms | ActiveRecord: 0.1ms)
+ [1m[36m (0.6ms)[0m [1mrollback transaction[0m
+ [1m[35m (0.0ms)[0m begin transaction
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.3ms)[0m INSERT INTO "users" ("id", "login") VALUES (?, ?) [["id", 1], ["login", "test"]]
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.4ms)[0m [1mINSERT INTO "posts" ("id", "user_id", "title") VALUES (?, ?, ?)[0m [["id", 1], ["user_id", 1], ["title", "test"]]
+ [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+Started GET "/users/1/posts/1/edit" for 127.0.0.1 at 2016-03-14 17:03:21 +0100
+Processing by PostsController#edit as HTML
+ Parameters: {"user_id"=>"1", "id"=>"1"}
+ [1m[36mPost Load (0.1ms)[0m [1mSELECT "posts".* FROM "posts" WHERE "posts"."id" = ? LIMIT 1[0m [["id", 1]]
+ [1m[35mUser Load (0.1ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", 1]]
+ [1m[36mCACHE (0.0ms)[0m [1mSELECT "posts".* FROM "posts" WHERE "posts"."id" = ? LIMIT 1[0m [["id", "1"]]
+ Rendered text template (0.0ms)
+Completed 200 OK in 2ms (Views: 0.3ms | ActiveRecord: 0.1ms)
+ [1m[35m (0.8ms)[0m rollback transaction
+ [1m[36m (0.0ms)[0m [1mbegin transaction[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mINSERT INTO "users" ("id", "login") VALUES (?, ?)[0m [["id", 1], ["login", "test"]]
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+Started GET "/admin/users/1/edit?q=mx" for 127.0.0.1 at 2016-03-14 17:03:21 +0100
+Processing by UsersController#edit as HTML
+ Parameters: {"q"=>"mx", "id"=>"1"}
+ [1m[36mUser Load (0.0ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1[0m [["id", 1]]
+ [1m[35mCACHE (0.0ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", "1"]]
+ Rendered text template (0.0ms)
+Completed 200 OK in 2ms (Views: 0.3ms | ActiveRecord: 0.1ms)
+ [1m[36m (0.4ms)[0m [1mrollback transaction[0m
+ [1m[35m (0.0ms)[0m begin transaction
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.3ms)[0m INSERT INTO "users" ("id", "login") VALUES (?, ?) [["id", 1], ["login", "test"]]
+ [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Started GET "/users/1/edit" for 127.0.0.1 at 2016-03-14 17:03:21 +0100
+Processing by UsersController#edit as HTML
+ Parameters: {"id"=>"1"}
+ [1m[35mUser Load (0.0ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", 1]]
+ [1m[36mCACHE (0.0ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1[0m [["id", "1"]]
+ Rendered text template (0.0ms)
+Completed 200 OK in 2ms (Views: 0.3ms | ActiveRecord: 0.1ms)
+ [1m[35m (0.4ms)[0m rollback transaction
+ [1m[36m (0.0ms)[0m [1mbegin transaction[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.3ms)[0m [1mINSERT INTO "users" ("id", "login") VALUES (?, ?)[0m [["id", 1], ["login", "test"]]
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+Started GET "/admin/users/1/edit" for 127.0.0.1 at 2016-03-14 17:03:21 +0100
+Processing by UsersController#edit as HTML
+ Parameters: {"id"=>"1"}
+ [1m[36mUser Load (0.0ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1[0m [["id", 1]]
+ [1m[35mCACHE (0.0ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", "1"]]
+ Rendered text template (0.0ms)
+Completed 200 OK in 2ms (Views: 0.3ms | ActiveRecord: 0.1ms)
+ [1m[36m (0.4ms)[0m [1mrollback transaction[0m
+ [1m[35m (0.0ms)[0m begin transaction
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.3ms)[0m INSERT INTO "users" ("id", "login") VALUES (?, ?) [["id", 1], ["login", "test"]]
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.4ms)[0m [1mINSERT INTO "posts" ("id", "user_id", "title") VALUES (?, ?, ?)[0m [["id", 1], ["user_id", 1], ["title", "test"]]
+ [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+Started GET "/users/1/posts/1/edit" for 127.0.0.1 at 2016-03-14 17:03:21 +0100
+Processing by PostsController#edit as HTML
+ Parameters: {"user_id"=>"1", "id"=>"1"}
+ [1m[36mPost Load (0.1ms)[0m [1mSELECT "posts".* FROM "posts" WHERE "posts"."id" = ? LIMIT 1[0m [["id", 1]]
+ [1m[35mUser Load (0.0ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", 1]]
+ [1m[36mCACHE (0.0ms)[0m [1mSELECT "posts".* FROM "posts" WHERE "posts"."id" = ? LIMIT 1[0m [["id", "1"]]
+ Rendered text template (0.0ms)
+Completed 200 OK in 2ms (Views: 0.3ms | ActiveRecord: 0.1ms)
+ [1m[35m (0.5ms)[0m rollback transaction
+ [1m[36m (0.0ms)[0m [1mbegin transaction[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mINSERT INTO "users" ("id", "login") VALUES (?, ?)[0m [["id", 1], ["login", "test"]]
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+Started GET "/admin/users/1/edit?q=mx" for 127.0.0.1 at 2016-03-14 17:03:21 +0100
+Processing by UsersController#edit as HTML
+ Parameters: {"q"=>"mx", "id"=>"1"}
+ [1m[36mUser Load (0.1ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1[0m [["id", 1]]
+ [1m[35mCACHE (0.0ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", "1"]]
+ Rendered text template (0.0ms)
+Completed 200 OK in 2ms (Views: 0.3ms | ActiveRecord: 0.1ms)
+ [1m[36m (0.4ms)[0m [1mrollback transaction[0m
+ [1m[35m (0.0ms)[0m begin transaction
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.3ms)[0m INSERT INTO "users" ("id", "login") VALUES (?, ?) [["id", 1], ["login", "test"]]
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Started GET "/users/1/edit" for 127.0.0.1 at 2016-03-14 17:03:21 +0100
+Processing by UsersController#edit as HTML
+ Parameters: {"id"=>"1"}
+ [1m[35mUser Load (0.1ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", 1]]
+ [1m[36mCACHE (0.0ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1[0m [["id", "1"]]
+ Rendered text template (0.0ms)
+Completed 200 OK in 2ms (Views: 0.3ms | ActiveRecord: 0.1ms)
+ [1m[35m (0.4ms)[0m rollback transaction
+ [1m[36m (0.1ms)[0m [1mbegin transaction[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mINSERT INTO "users" ("id", "login") VALUES (?, ?)[0m [["id", 1], ["login", "test"]]
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.3ms)[0m INSERT INTO "posts" ("id", "user_id", "title") VALUES (?, ?, ?) [["id", 1], ["user_id", 1], ["title", "test"]]
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Started GET "/users/1/posts/1/print" for 127.0.0.1 at 2016-03-14 17:03:21 +0100
+Processing by PostsController#print as HTML
+ Parameters: {"user_id"=>"1", "id"=>"1"}
+ [1m[35mPost Load (0.1ms)[0m SELECT "posts".* FROM "posts" WHERE "posts"."id" = ? LIMIT 1 [["id", 1]]
+ [1m[36mUser Load (0.0ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1[0m [["id", 1]]
+ [1m[35mCACHE (0.0ms)[0m SELECT "posts".* FROM "posts" WHERE "posts"."id" = ? LIMIT 1 [["id", "1"]]
+ Rendered text template (0.0ms)
+Completed 200 OK in 2ms (Views: 0.3ms | ActiveRecord: 0.1ms)
+ [1m[36m (0.6ms)[0m [1mrollback transaction[0m
+ [1m[35m (0.1ms)[0m begin transaction
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.3ms)[0m INSERT INTO "users" ("id", "login") VALUES (?, ?) [["id", 1], ["login", "test"]]
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Started GET "/users/1/print" for 127.0.0.1 at 2016-03-14 17:03:21 +0100
+Processing by UsersController#print as HTML
+ Parameters: {"id"=>"1"}
+ [1m[35mUser Load (0.1ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", 1]]
+ [1m[36mCACHE (0.0ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1[0m [["id", "1"]]
+ Rendered text template (0.0ms)
+Completed 200 OK in 2ms (Views: 0.3ms | ActiveRecord: 0.1ms)
+ [1m[35m (0.4ms)[0m rollback transaction
+ [1m[36m (0.0ms)[0m [1mbegin transaction[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.3ms)[0m [1mINSERT INTO "users" ("id", "login") VALUES (?, ?)[0m [["id", 1], ["login", "test"]]
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+Started GET "/admin/users/1/edit" for 127.0.0.1 at 2016-03-14 17:03:21 +0100
+Processing by UsersController#edit as HTML
+ Parameters: {"id"=>"1"}
+ [1m[36mUser Load (0.1ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1[0m [["id", 1]]
+ [1m[35mCACHE (0.0ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", "1"]]
+ Rendered text template (0.0ms)
+Completed 200 OK in 2ms (Views: 0.3ms | ActiveRecord: 0.1ms)
+ [1m[36m (0.4ms)[0m [1mrollback transaction[0m
+ [1m[35m (0.1ms)[0m begin transaction
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.3ms)[0m INSERT INTO "users" ("id", "login") VALUES (?, ?) [["id", 1], ["login", "test"]]
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.4ms)[0m [1mINSERT INTO "posts" ("id", "user_id", "title") VALUES (?, ?, ?)[0m [["id", 1], ["user_id", 1], ["title", "test"]]
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+Started GET "/admin/users/1/posts/1/print" for 127.0.0.1 at 2016-03-14 17:03:21 +0100
+Processing by PostsController#print as HTML
+ Parameters: {"user_id"=>"1", "id"=>"1"}
+ [1m[36mPost Load (0.1ms)[0m [1mSELECT "posts".* FROM "posts" WHERE "posts"."id" = ? LIMIT 1[0m [["id", 1]]
+ [1m[35mUser Load (0.0ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", 1]]
+ [1m[36mCACHE (0.0ms)[0m [1mSELECT "posts".* FROM "posts" WHERE "posts"."id" = ? LIMIT 1[0m [["id", "1"]]
+ Rendered text template (0.0ms)
+Completed 200 OK in 2ms (Views: 0.3ms | ActiveRecord: 0.1ms)
+ [1m[35m (0.5ms)[0m rollback transaction
+ [1m[36m (0.0ms)[0m [1mbegin transaction[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mINSERT INTO "users" ("id", "login") VALUES (?, ?)[0m [["id", 1], ["login", "test"]]
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+Started GET "/admin/users/1" for 127.0.0.1 at 2016-03-14 17:03:21 +0100
+Processing by UsersController#show as HTML
+ Parameters: {"id"=>"1"}
+ [1m[36mUser Load (0.1ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1[0m [["id", 1]]
+ [1m[35mCACHE (0.0ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", "1"]]
+ Rendered text template (0.0ms)
+Completed 200 OK in 3ms (Views: 0.5ms | ActiveRecord: 0.1ms)
+ [1m[36m (0.4ms)[0m [1mrollback transaction[0m
+ [1m[35m (0.1ms)[0m begin transaction
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.3ms)[0m INSERT INTO "users" ("id", "login") VALUES (?, ?) [["id", 1], ["login", "test"]]
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.3ms)[0m [1mINSERT INTO "posts" ("id", "user_id", "title") VALUES (?, ?, ?)[0m [["id", 1], ["user_id", 1], ["title", "test"]]
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+Started GET "/users/1/posts/1" for 127.0.0.1 at 2016-03-14 17:03:21 +0100
+Processing by PostsController#show as HTML
+ Parameters: {"user_id"=>"1", "id"=>"1"}
+ [1m[36mPost Load (0.1ms)[0m [1mSELECT "posts".* FROM "posts" WHERE "posts"."id" = ? LIMIT 1[0m [["id", 1]]
+ [1m[35mUser Load (0.0ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", 1]]
+ [1m[36mCACHE (0.0ms)[0m [1mSELECT "posts".* FROM "posts" WHERE "posts"."id" = ? LIMIT 1[0m [["id", "1"]]
+ Rendered text template (0.0ms)
+Completed 200 OK in 2ms (Views: 0.3ms | ActiveRecord: 0.1ms)
+ [1m[35m (0.5ms)[0m rollback transaction
+ [1m[36m (0.0ms)[0m [1mbegin transaction[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mINSERT INTO "users" ("id", "login") VALUES (?, ?)[0m [["id", 1], ["login", "test"]]
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+Started GET "/admin/users/1?q=mx" for 127.0.0.1 at 2016-03-14 17:03:21 +0100
+Processing by UsersController#show as HTML
+ Parameters: {"q"=>"mx", "id"=>"1"}
+ [1m[36mUser Load (0.1ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1[0m [["id", 1]]
+ [1m[35mCACHE (0.0ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", "1"]]
+ Rendered text template (0.0ms)
+Completed 200 OK in 2ms (Views: 0.3ms | ActiveRecord: 0.1ms)
+ [1m[36m (0.6ms)[0m [1mrollback transaction[0m
+ [1m[35m (0.0ms)[0m begin transaction
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.3ms)[0m INSERT INTO "users" ("id", "login") VALUES (?, ?) [["id", 1], ["login", "test"]]
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Started GET "/users/1" for 127.0.0.1 at 2016-03-14 17:03:21 +0100
+Processing by UsersController#show as HTML
+ Parameters: {"id"=>"1"}
+ [1m[35mUser Load (0.0ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", 1]]
+ [1m[36mCACHE (0.0ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1[0m [["id", "1"]]
+ Rendered text template (0.0ms)
+Completed 200 OK in 2ms (Views: 0.3ms | ActiveRecord: 0.1ms)
+ [1m[35m (0.4ms)[0m rollback transaction
+ [1m[36mActiveRecord::SchemaMigration Load (1.0ms)[0m [1mSELECT "schema_migrations".* FROM "schema_migrations"[0m
+ [1m[35mActiveRecord::SchemaMigration Load (0.1ms)[0m SELECT "schema_migrations".* FROM "schema_migrations"
+ [1m[36m (1.3ms)[0m [1mDROP TABLE "users"[0m
+ [1m[35m (0.8ms)[0m CREATE TABLE "users" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "login" varchar)
+ [1m[36m (1.1ms)[0m [1mDROP TABLE "posts"[0m
+ [1m[35m (0.8ms)[0m CREATE TABLE "posts" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "title" varchar, "user_id" integer)
+ [1m[36m (0.1ms)[0m [1mSELECT version FROM "schema_migrations"[0m
+ [1m[35m (0.1ms)[0m begin transaction
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.4ms)[0m INSERT INTO "users" ("id", "login") VALUES (?, ?) [["id", 1], ["login", "test"]]
+ [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (2.9ms)[0m [1mINSERT INTO "posts" ("id", "user_id", "title") VALUES (?, ?, ?)[0m [["id", 1], ["user_id", 1], ["title", "test"]]
+ [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+Started GET "/users/1/posts/1" for 127.0.0.1 at 2016-03-14 17:05:55 +0100
+Processing by PostsController#show as HTML
+ Parameters: {"user_id"=>"1", "id"=>"1"}
+ [1m[36mPost Load (0.2ms)[0m [1mSELECT "posts".* FROM "posts" WHERE "posts"."id" = ? LIMIT 1[0m [["id", 1]]
+ [1m[35mUser Load (0.1ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", 1]]
+ [1m[36mCACHE (0.0ms)[0m [1mSELECT "posts".* FROM "posts" WHERE "posts"."id" = ? LIMIT 1[0m [["id", "1"]]
+ Rendered text template (0.1ms)
+Completed 200 OK in 41ms (Views: 18.6ms | ActiveRecord: 0.3ms)
+ [1m[35m (0.8ms)[0m rollback transaction
+ [1m[36m (0.1ms)[0m [1mbegin transaction[0m
+ [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.4ms)[0m [1mINSERT INTO "users" ("id", "login") VALUES (?, ?)[0m [["id", 1], ["login", "test"]]
+ [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+Started GET "/admin/users/1?q=mx" for 127.0.0.1 at 2016-03-14 17:05:55 +0100
+Processing by UsersController#show as HTML
+ Parameters: {"q"=>"mx", "id"=>"1"}
+ [1m[36mUser Load (0.1ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1[0m [["id", 1]]
+ [1m[35mCACHE (0.0ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", "1"]]
+ Rendered text template (0.0ms)
+Completed 200 OK in 7ms (Views: 4.1ms | ActiveRecord: 0.1ms)
+ [1m[36m (1.2ms)[0m [1mrollback transaction[0m
+ [1m[35m (0.1ms)[0m begin transaction
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.5ms)[0m INSERT INTO "users" ("id", "login") VALUES (?, ?) [["id", 1], ["login", "test"]]
+ [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Started GET "/users/1" for 127.0.0.1 at 2016-03-14 17:05:55 +0100
+Processing by UsersController#show as HTML
+ Parameters: {"id"=>"1"}
+ [1m[35mUser Load (0.1ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", 1]]
+ [1m[36mCACHE (0.0ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1[0m [["id", "1"]]
+ Rendered text template (0.0ms)
+Completed 200 OK in 3ms (Views: 0.5ms | ActiveRecord: 0.1ms)
+ [1m[35m (0.5ms)[0m rollback transaction
+ [1m[36m (0.1ms)[0m [1mbegin transaction[0m
+ [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.3ms)[0m [1mINSERT INTO "users" ("id", "login") VALUES (?, ?)[0m [["id", 1], ["login", "test"]]
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+Started GET "/admin/users/1" for 127.0.0.1 at 2016-03-14 17:05:55 +0100
+Processing by UsersController#show as HTML
+ Parameters: {"id"=>"1"}
+ [1m[36mUser Load (0.1ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1[0m [["id", 1]]
+ [1m[35mCACHE (0.0ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", "1"]]
+ Rendered text template (0.0ms)
+Completed 200 OK in 3ms (Views: 0.5ms | ActiveRecord: 0.1ms)
+ [1m[36m (1.7ms)[0m [1mrollback transaction[0m
+ [1m[35m (0.1ms)[0m begin transaction
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.3ms)[0m INSERT INTO "users" ("id", "login") VALUES (?, ?) [["id", 1], ["login", "test"]]
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Started GET "/users/1/print" for 127.0.0.1 at 2016-03-14 17:05:55 +0100
+Processing by UsersController#print as HTML
+ Parameters: {"id"=>"1"}
+ [1m[35mUser Load (0.1ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", 1]]
+ [1m[36mCACHE (0.0ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1[0m [["id", "1"]]
+ Rendered text template (0.0ms)
+Completed 200 OK in 2ms (Views: 0.3ms | ActiveRecord: 0.1ms)
+ [1m[35m (7.1ms)[0m rollback transaction
+ [1m[36m (0.1ms)[0m [1mbegin transaction[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.3ms)[0m [1mINSERT INTO "users" ("id", "login") VALUES (?, ?)[0m [["id", 1], ["login", "test"]]
+ [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+Started GET "/admin/users/1/edit" for 127.0.0.1 at 2016-03-14 17:05:55 +0100
+Processing by UsersController#edit as HTML
+ Parameters: {"id"=>"1"}
+ [1m[36mUser Load (0.1ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1[0m [["id", 1]]
+ [1m[35mCACHE (0.0ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", "1"]]
+ Rendered text template (0.0ms)
+Completed 200 OK in 2ms (Views: 0.3ms | ActiveRecord: 0.1ms)
+ [1m[36m (109.9ms)[0m [1mrollback transaction[0m
+ [1m[35m (0.1ms)[0m begin transaction
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.3ms)[0m INSERT INTO "users" ("id", "login") VALUES (?, ?) [["id", 1], ["login", "test"]]
+ [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.6ms)[0m [1mINSERT INTO "posts" ("id", "user_id", "title") VALUES (?, ?, ?)[0m [["id", 1], ["user_id", 1], ["title", "test"]]
+ [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+Started GET "/admin/users/1/posts/1/print" for 127.0.0.1 at 2016-03-14 17:05:55 +0100
+Processing by PostsController#print as HTML
+ Parameters: {"user_id"=>"1", "id"=>"1"}
+ [1m[36mPost Load (0.1ms)[0m [1mSELECT "posts".* FROM "posts" WHERE "posts"."id" = ? LIMIT 1[0m [["id", 1]]
+ [1m[35mUser Load (0.1ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", 1]]
+ [1m[36mCACHE (0.0ms)[0m [1mSELECT "posts".* FROM "posts" WHERE "posts"."id" = ? LIMIT 1[0m [["id", "1"]]
+ Rendered text template (0.0ms)
+Completed 200 OK in 5ms (Views: 0.7ms | ActiveRecord: 0.2ms)
+ [1m[35m (2.0ms)[0m rollback transaction
+ [1m[36m (0.1ms)[0m [1mbegin transaction[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.3ms)[0m [1mINSERT INTO "users" ("id", "login") VALUES (?, ?)[0m [["id", 1], ["login", "test"]]
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.3ms)[0m INSERT INTO "posts" ("id", "user_id", "title") VALUES (?, ?, ?) [["id", 1], ["user_id", 1], ["title", "test"]]
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Started GET "/users/1/posts/1/print" for 127.0.0.1 at 2016-03-14 17:05:55 +0100
+Processing by PostsController#print as HTML
+ Parameters: {"user_id"=>"1", "id"=>"1"}
+ [1m[35mPost Load (0.1ms)[0m SELECT "posts".* FROM "posts" WHERE "posts"."id" = ? LIMIT 1 [["id", 1]]
+ [1m[36mUser Load (0.0ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1[0m [["id", 1]]
+ [1m[35mCACHE (0.0ms)[0m SELECT "posts".* FROM "posts" WHERE "posts"."id" = ? LIMIT 1 [["id", "1"]]
+ Rendered text template (0.0ms)
+Completed 200 OK in 2ms (Views: 0.3ms | ActiveRecord: 0.1ms)
+ [1m[36m (0.9ms)[0m [1mrollback transaction[0m
+ [1m[35m (0.0ms)[0m begin transaction
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.3ms)[0m INSERT INTO "users" ("id", "login") VALUES (?, ?) [["id", 1], ["login", "test"]]
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mINSERT INTO "posts" ("id", "user_id", "title") VALUES (?, ?, ?)[0m [["id", 1], ["user_id", 1], ["title", "test"]]
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+Started GET "/users/1/posts/1/edit" for 127.0.0.1 at 2016-03-14 17:05:55 +0100
+Processing by PostsController#edit as HTML
+ Parameters: {"user_id"=>"1", "id"=>"1"}
+ [1m[36mPost Load (0.1ms)[0m [1mSELECT "posts".* FROM "posts" WHERE "posts"."id" = ? LIMIT 1[0m [["id", 1]]
+ [1m[35mUser Load (0.0ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", 1]]
+ [1m[36mCACHE (0.0ms)[0m [1mSELECT "posts".* FROM "posts" WHERE "posts"."id" = ? LIMIT 1[0m [["id", "1"]]
+ Rendered text template (0.0ms)
+Completed 200 OK in 2ms (Views: 0.3ms | ActiveRecord: 0.1ms)
+ [1m[35m (0.7ms)[0m rollback transaction
+ [1m[36m (0.0ms)[0m [1mbegin transaction[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mINSERT INTO "users" ("id", "login") VALUES (?, ?)[0m [["id", 1], ["login", "test"]]
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+Started GET "/admin/users/1/edit?q=mx" for 127.0.0.1 at 2016-03-14 17:05:55 +0100
+Processing by UsersController#edit as HTML
+ Parameters: {"q"=>"mx", "id"=>"1"}
+ [1m[36mUser Load (0.0ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1[0m [["id", 1]]
+ [1m[35mCACHE (0.0ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", "1"]]
+ Rendered text template (0.0ms)
+Completed 200 OK in 2ms (Views: 0.3ms | ActiveRecord: 0.1ms)
+ [1m[36m (0.4ms)[0m [1mrollback transaction[0m
+ [1m[35m (0.0ms)[0m begin transaction
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.2ms)[0m INSERT INTO "users" ("id", "login") VALUES (?, ?) [["id", 1], ["login", "test"]]
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Started GET "/users/1/edit" for 127.0.0.1 at 2016-03-14 17:05:55 +0100
+Processing by UsersController#edit as HTML
+ Parameters: {"id"=>"1"}
+ [1m[35mUser Load (0.0ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", 1]]
+ [1m[36mCACHE (0.0ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1[0m [["id", "1"]]
+ Rendered text template (0.0ms)
+Completed 200 OK in 2ms (Views: 0.3ms | ActiveRecord: 0.1ms)
+ [1m[35m (0.4ms)[0m rollback transaction
+ [1m[36m (0.0ms)[0m [1mbegin transaction[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mINSERT INTO "users" ("id", "login") VALUES (?, ?)[0m [["id", 1], ["login", "test"]]
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+Started GET "/admin/users/1/edit" for 127.0.0.1 at 2016-03-14 17:05:55 +0100
+Processing by UsersController#edit as HTML
+ Parameters: {"id"=>"1"}
+ [1m[36mUser Load (0.1ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1[0m [["id", 1]]
+ [1m[35mCACHE (0.0ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", "1"]]
+ Rendered text template (0.0ms)
+Completed 200 OK in 2ms (Views: 0.3ms | ActiveRecord: 0.1ms)
+ [1m[36m (0.4ms)[0m [1mrollback transaction[0m
+ [1m[35m (0.0ms)[0m begin transaction
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.2ms)[0m INSERT INTO "users" ("id", "login") VALUES (?, ?) [["id", 1], ["login", "test"]]
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.3ms)[0m [1mINSERT INTO "posts" ("id", "user_id", "title") VALUES (?, ?, ?)[0m [["id", 1], ["user_id", 1], ["title", "test"]]
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+Started GET "/users/1/posts/1/edit" for 127.0.0.1 at 2016-03-14 17:05:55 +0100
+Processing by PostsController#edit as HTML
+ Parameters: {"user_id"=>"1", "id"=>"1"}
+ [1m[36mPost Load (0.1ms)[0m [1mSELECT "posts".* FROM "posts" WHERE "posts"."id" = ? LIMIT 1[0m [["id", 1]]
+ [1m[35mUser Load (0.0ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", 1]]
+ [1m[36mCACHE (0.0ms)[0m [1mSELECT "posts".* FROM "posts" WHERE "posts"."id" = ? LIMIT 1[0m [["id", "1"]]
+ Rendered text template (0.0ms)
+Completed 200 OK in 2ms (Views: 0.3ms | ActiveRecord: 0.1ms)
+ [1m[35m (0.5ms)[0m rollback transaction
+ [1m[36m (0.0ms)[0m [1mbegin transaction[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mINSERT INTO "users" ("id", "login") VALUES (?, ?)[0m [["id", 1], ["login", "test"]]
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+Started GET "/admin/users/1/edit?q=mx" for 127.0.0.1 at 2016-03-14 17:05:55 +0100
+Processing by UsersController#edit as HTML
+ Parameters: {"q"=>"mx", "id"=>"1"}
+ [1m[36mUser Load (0.1ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1[0m [["id", 1]]
+ [1m[35mCACHE (0.0ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", "1"]]
+ Rendered text template (0.0ms)
+Completed 200 OK in 2ms (Views: 0.3ms | ActiveRecord: 0.1ms)
+ [1m[36m (0.4ms)[0m [1mrollback transaction[0m
+ [1m[35m (0.0ms)[0m begin transaction
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.2ms)[0m INSERT INTO "users" ("id", "login") VALUES (?, ?) [["id", 1], ["login", "test"]]
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Started GET "/users/1/edit" for 127.0.0.1 at 2016-03-14 17:05:55 +0100
+Processing by UsersController#edit as HTML
+ Parameters: {"id"=>"1"}
+ [1m[35mUser Load (0.1ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", 1]]
+ [1m[36mCACHE (0.0ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1[0m [["id", "1"]]
+ Rendered text template (0.0ms)
+Completed 200 OK in 2ms (Views: 0.3ms | ActiveRecord: 0.1ms)
+ [1m[35m (0.4ms)[0m rollback transaction
+ [1m[36m (0.0ms)[0m [1mbegin transaction[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mINSERT INTO "users" ("id", "login") VALUES (?, ?)[0m [["id", 1], ["login", "test"]]
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+Started GET "/admin/users/1/edit" for 127.0.0.1 at 2016-03-14 17:05:55 +0100
+Processing by UsersController#edit as HTML
+ Parameters: {"id"=>"1"}
+ [1m[36mUser Load (0.0ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1[0m [["id", 1]]
+ [1m[35mCACHE (0.0ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", "1"]]
+ Rendered text template (0.0ms)
+Completed 200 OK in 2ms (Views: 0.3ms | ActiveRecord: 0.1ms)
+ [1m[36m (0.6ms)[0m [1mrollback transaction[0m
+ [1m[35m (0.0ms)[0m begin transaction
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.3ms)[0m INSERT INTO "users" ("id", "login") VALUES (?, ?) [["id", 1], ["login", "test"]]
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Started GET "/users/1/posts" for 127.0.0.1 at 2016-03-14 17:05:55 +0100
+Processing by PostsController#index as HTML
+ Parameters: {"user_id"=>"1"}
+ [1m[35mPost Load (0.0ms)[0m SELECT "posts".* FROM "posts" WHERE "posts"."id" = ? LIMIT 1 [["id", nil]]
+ [1m[36mUser Load (0.0ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1[0m [["id", 1]]
+ Rendered text template (0.0ms)
+Completed 200 OK in 812785ms (Views: 0.6ms | ActiveRecord: 0.1ms)
+ [1m[35m (0.3ms)[0m rollback transaction
+ [1m[36m (0.0ms)[0m [1mbegin transaction[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.8ms)[0m [1mINSERT INTO "users" ("id", "login") VALUES (?, ?)[0m [["id", 1], ["login", "test"]]
+ [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+Started GET "/users/1" for 127.0.0.1 at 2016-03-14 17:19:28 +0100
+Processing by UsersController#show as HTML
+ Parameters: {"id"=>"1"}
+ [1m[36mUser Load (0.1ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1[0m [["id", 1]]
+ [1m[35mCACHE (0.0ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", "1"]]
+ Rendered text template (0.0ms)
+Completed 200 OK in 2ms (Views: 0.3ms | ActiveRecord: 0.1ms)
+ [1m[36m (1.8ms)[0m [1mrollback transaction[0m
+ [1m[35m (0.0ms)[0m begin transaction
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.2ms)[0m INSERT INTO "users" ("id", "login") VALUES (?, ?) [["id", 1], ["login", "test"]]
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Started GET "/admin/users/1" for 127.0.0.1 at 2016-03-14 17:19:28 +0100
+Processing by UsersController#show as HTML
+ Parameters: {"id"=>"1"}
+ [1m[35mUser Load (0.1ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", 1]]
+ [1m[36mCACHE (0.0ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1[0m [["id", "1"]]
+ Rendered text template (0.0ms)
+Completed 200 OK in 2ms (Views: 0.3ms | ActiveRecord: 0.1ms)
+ [1m[35m (0.4ms)[0m rollback transaction
+ [1m[36m (0.0ms)[0m [1mbegin transaction[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mINSERT INTO "users" ("id", "login") VALUES (?, ?)[0m [["id", 1], ["login", "test"]]
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.3ms)[0m INSERT INTO "posts" ("id", "user_id", "title") VALUES (?, ?, ?) [["id", 1], ["user_id", 1], ["title", "test"]]
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Started GET "/users/1/posts/1" for 127.0.0.1 at 2016-03-14 17:19:28 +0100
+Processing by PostsController#show as HTML
+ Parameters: {"user_id"=>"1", "id"=>"1"}
+ [1m[35mPost Load (0.1ms)[0m SELECT "posts".* FROM "posts" WHERE "posts"."id" = ? LIMIT 1 [["id", 1]]
+ [1m[36mUser Load (0.0ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1[0m [["id", 1]]
+ [1m[35mCACHE (0.0ms)[0m SELECT "posts".* FROM "posts" WHERE "posts"."id" = ? LIMIT 1 [["id", "1"]]
+ Rendered text template (0.0ms)
+Completed 200 OK in 2ms (Views: 0.3ms | ActiveRecord: 0.1ms)
+ [1m[36m (0.6ms)[0m [1mrollback transaction[0m
+ [1m[35m (0.0ms)[0m begin transaction
+Started GET "/admin/users" for 127.0.0.1 at 2016-03-14 17:19:28 +0100
+Processing by UsersController#index as HTML
+ [1m[36mUser Load (0.1ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1[0m [["id", nil]]
+ [1m[35mCACHE (0.0ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", nil]]
+ Rendered text template (0.0ms)
+Completed 200 OK in 1301ms (Views: 0.4ms | ActiveRecord: 0.1ms)
+ [1m[36m (0.1ms)[0m [1mrollback transaction[0m
+ [1m[35m (0.0ms)[0m begin transaction
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.3ms)[0m INSERT INTO "users" ("id", "login") VALUES (?, ?) [["id", 1], ["login", "test"]]
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Started GET "/admin/users/1?q=mx" for 127.0.0.1 at 2016-03-14 17:19:30 +0100
+Processing by UsersController#show as HTML
+ Parameters: {"q"=>"mx", "id"=>"1"}
+ [1m[35mUser Load (0.1ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", 1]]
+ [1m[36mCACHE (0.0ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1[0m [["id", "1"]]
+ Rendered text template (0.0ms)
+Completed 200 OK in 2ms (Views: 0.3ms | ActiveRecord: 0.1ms)
+ [1m[35m (1.7ms)[0m rollback transaction
+ [1m[36mActiveRecord::SchemaMigration Load (0.1ms)[0m [1mSELECT "schema_migrations".* FROM "schema_migrations"[0m
+ [1m[35mActiveRecord::SchemaMigration Load (0.2ms)[0m SELECT "schema_migrations".* FROM "schema_migrations"
+ [1m[36m (2.7ms)[0m [1mDROP TABLE "users"[0m
+ [1m[35m (0.8ms)[0m CREATE TABLE "users" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "login" varchar)
+ [1m[36m (0.7ms)[0m [1mDROP TABLE "posts"[0m
+ [1m[35m (0.9ms)[0m CREATE TABLE "posts" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "title" varchar, "user_id" integer)
+ [1m[36m (0.1ms)[0m [1mSELECT version FROM "schema_migrations"[0m