test/dummy/log/test.log in pagers-4.0.0.0 vs test/dummy/log/test.log in pagers-4.0.0.1

- old
+ new

@@ -22125,5 +22125,313 @@  (0.2ms) SELECT COUNT(count_column) FROM (SELECT 1 AS count_column FROM "products" LIMIT 15 OFFSET 19) subquery_for_count  (0.1ms) SELECT COUNT(*) FROM "products"  (0.2ms) SELECT COUNT(count_column) FROM (SELECT 1 AS count_column FROM "products" LIMIT 15 OFFSET 34) subquery_for_count  (0.1ms) SELECT COUNT(*) FROM "products"  (0.1ms) ROLLBACK +  (175.8ms) DROP DATABASE IF EXISTS "pagers_test" +  (295.9ms) CREATE DATABASE "pagers_test" ENCODING = 'utf8' + SQL (0.3ms) CREATE EXTENSION IF NOT EXISTS "plpgsql" +  (3.0ms) CREATE TABLE "products" ("id" serial primary key, "created_at" timestamp NOT NULL, "updated_at" timestamp NOT NULL) +  (1.4ms) CREATE TABLE "schema_migrations" ("version" character varying NOT NULL)  +  (0.9ms) CREATE UNIQUE INDEX "unique_schema_migrations" ON "schema_migrations" ("version") +  (0.2ms) SELECT version FROM "schema_migrations" +  (0.4ms) INSERT INTO "schema_migrations" (version) VALUES ('20130820024335') + ActiveRecord::SchemaMigration Load (0.3ms) SELECT "schema_migrations".* FROM "schema_migrations" +  (0.2ms) BEGIN +------------------- +ViewTest: test_html +------------------- +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.5ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:06.920554"], ["updated_at", "2016-12-13 20:19:06.920554"]] +  (0.2ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.2ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:06.924689"], ["updated_at", "2016-12-13 20:19:06.924689"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.2ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:06.925779"], ["updated_at", "2016-12-13 20:19:06.925779"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.2ms) SAVEPOINT active_record_1 + SQL (0.2ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:06.926814"], ["updated_at", "2016-12-13 20:19:06.926814"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.2ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:06.927732"], ["updated_at", "2016-12-13 20:19:06.927732"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.1ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:06.928681"], ["updated_at", "2016-12-13 20:19:06.928681"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.1ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:06.929596"], ["updated_at", "2016-12-13 20:19:06.929596"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.1ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:06.930553"], ["updated_at", "2016-12-13 20:19:06.930553"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.1ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:06.931458"], ["updated_at", "2016-12-13 20:19:06.931458"]] +  (0.2ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.1ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:06.932434"], ["updated_at", "2016-12-13 20:19:06.932434"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +Started GET "/" for 127.0.0.1 at 2016-12-13 17:19:06 -0300 +Processing by ProductsController#index as HTML +  (0.3ms) SELECT COUNT(*) FROM "products" + Rendered /Users/Matt/Documents/Github/pagers/app/views/pagers/_main.html.erb (7.4ms) + Rendered products/index.html.erb within layouts/application (13.5ms) +Completed 200 OK in 187ms (Views: 185.9ms | ActiveRecord: 0.3ms) +Started GET "/?page=5" for 127.0.0.1 at 2016-12-13 17:19:07 -0300 +Processing by ProductsController#index as HTML + Parameters: {"page"=>"5"} +  (0.3ms) SELECT COUNT(*) FROM "products" + Rendered /Users/Matt/Documents/Github/pagers/app/views/pagers/_main.html.erb (1.1ms) + Rendered products/index.html.erb within layouts/application (2.0ms) +Completed 200 OK in 3ms (Views: 2.4ms | ActiveRecord: 0.3ms) +Started GET "/?page=10" for 127.0.0.1 at 2016-12-13 17:19:07 -0300 +Processing by ProductsController#index as HTML + Parameters: {"page"=>"10"} +  (0.3ms) SELECT COUNT(*) FROM "products" + Rendered /Users/Matt/Documents/Github/pagers/app/views/pagers/_main.html.erb (0.8ms) + Rendered products/index.html.erb within layouts/application (1.6ms) +Completed 200 OK in 3ms (Views: 2.1ms | ActiveRecord: 0.3ms) +  (0.2ms) ROLLBACK +  (0.1ms) BEGIN +---------------------------- +GeneratorsTest: test_install +---------------------------- +  (0.2ms) ROLLBACK +  (0.2ms) BEGIN +------------------------- +RelationTest: test_middle +------------------------- +  (0.2ms) SAVEPOINT active_record_1 + SQL (0.2ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:07.195562"], ["updated_at", "2016-12-13 20:19:07.195562"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.2ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:07.196952"], ["updated_at", "2016-12-13 20:19:07.196952"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.2ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:07.198154"], ["updated_at", "2016-12-13 20:19:07.198154"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.2ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:07.199309"], ["updated_at", "2016-12-13 20:19:07.199309"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.2ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:07.200437"], ["updated_at", "2016-12-13 20:19:07.200437"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.2ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:07.201435"], ["updated_at", "2016-12-13 20:19:07.201435"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.2ms) SAVEPOINT active_record_1 + SQL (0.2ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:07.202729"], ["updated_at", "2016-12-13 20:19:07.202729"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.2ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:07.203900"], ["updated_at", "2016-12-13 20:19:07.203900"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.1ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:07.204958"], ["updated_at", "2016-12-13 20:19:07.204958"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.2ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:07.205938"], ["updated_at", "2016-12-13 20:19:07.205938"]] +  (0.2ms) RELEASE SAVEPOINT active_record_1 +  (0.2ms) SELECT COUNT(*) FROM "products" +  (0.1ms) ROLLBACK +  (0.1ms) BEGIN +-------------------------- +RelationTest: test_padding +-------------------------- +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.2ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:07.208647"], ["updated_at", "2016-12-13 20:19:07.208647"]] +  (0.2ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.1ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:07.210032"], ["updated_at", "2016-12-13 20:19:07.210032"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.3ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:07.211039"], ["updated_at", "2016-12-13 20:19:07.211039"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.2ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:07.212262"], ["updated_at", "2016-12-13 20:19:07.212262"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.1ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:07.213342"], ["updated_at", "2016-12-13 20:19:07.213342"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.1ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:07.214269"], ["updated_at", "2016-12-13 20:19:07.214269"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.2ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:07.215182"], ["updated_at", "2016-12-13 20:19:07.215182"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.1ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:07.216168"], ["updated_at", "2016-12-13 20:19:07.216168"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.1ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:07.217012"], ["updated_at", "2016-12-13 20:19:07.217012"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.1ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:07.217861"], ["updated_at", "2016-12-13 20:19:07.217861"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.1ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:07.218758"], ["updated_at", "2016-12-13 20:19:07.218758"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.2ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:07.219627"], ["updated_at", "2016-12-13 20:19:07.219627"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.2ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:07.220706"], ["updated_at", "2016-12-13 20:19:07.220706"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.1ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:07.221846"], ["updated_at", "2016-12-13 20:19:07.221846"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.1ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:07.222710"], ["updated_at", "2016-12-13 20:19:07.222710"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.1ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:07.223472"], ["updated_at", "2016-12-13 20:19:07.223472"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.1ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:07.224284"], ["updated_at", "2016-12-13 20:19:07.224284"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.2ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:07.225123"], ["updated_at", "2016-12-13 20:19:07.225123"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.2ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:07.226180"], ["updated_at", "2016-12-13 20:19:07.226180"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.4ms) SELECT COUNT(count_column) FROM (SELECT 1 AS count_column FROM "products" LIMIT 15 OFFSET 4) subquery_for_count +  (0.2ms) SELECT COUNT(*) FROM "products" +  (0.2ms) SELECT COUNT(count_column) FROM (SELECT 1 AS count_column FROM "products" LIMIT 15 OFFSET 19) subquery_for_count +  (0.1ms) SELECT COUNT(*) FROM "products" +  (0.2ms) SELECT COUNT(count_column) FROM (SELECT 1 AS count_column FROM "products" LIMIT 15 OFFSET 34) subquery_for_count +  (0.2ms) SELECT COUNT(*) FROM "products" +  (0.1ms) ROLLBACK +  (0.1ms) BEGIN +----------------------- +RelationTest: test_last +----------------------- +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.2ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:07.233462"], ["updated_at", "2016-12-13 20:19:07.233462"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.1ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:07.234531"], ["updated_at", "2016-12-13 20:19:07.234531"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.1ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:07.235307"], ["updated_at", "2016-12-13 20:19:07.235307"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.1ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:07.236143"], ["updated_at", "2016-12-13 20:19:07.236143"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.1ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:07.237029"], ["updated_at", "2016-12-13 20:19:07.237029"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.1ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:07.237955"], ["updated_at", "2016-12-13 20:19:07.237955"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.1ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:07.238845"], ["updated_at", "2016-12-13 20:19:07.238845"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.1ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:07.239661"], ["updated_at", "2016-12-13 20:19:07.239661"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.1ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:07.240389"], ["updated_at", "2016-12-13 20:19:07.240389"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.1ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:07.241133"], ["updated_at", "2016-12-13 20:19:07.241133"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.2ms) SELECT COUNT(*) FROM "products" +  (0.1ms) ROLLBACK +  (0.1ms) BEGIN +------------------------ +RelationTest: test_empty +------------------------ +  (0.1ms) SELECT COUNT(*) FROM "products" +  (0.1ms) ROLLBACK +  (0.1ms) BEGIN +------------------------ +RelationTest: test_first +------------------------ +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.1ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:07.244040"], ["updated_at", "2016-12-13 20:19:07.244040"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.1ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:07.244908"], ["updated_at", "2016-12-13 20:19:07.244908"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.1ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:07.245762"], ["updated_at", "2016-12-13 20:19:07.245762"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.1ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:07.246547"], ["updated_at", "2016-12-13 20:19:07.246547"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.1ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:07.247391"], ["updated_at", "2016-12-13 20:19:07.247391"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.1ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:07.248207"], ["updated_at", "2016-12-13 20:19:07.248207"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.1ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:07.249104"], ["updated_at", "2016-12-13 20:19:07.249104"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.1ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:07.250039"], ["updated_at", "2016-12-13 20:19:07.250039"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.1ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:07.250910"], ["updated_at", "2016-12-13 20:19:07.250910"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.1ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:07.251761"], ["updated_at", "2016-12-13 20:19:07.251761"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.2ms) SELECT COUNT(*) FROM "products" +  (0.1ms) ROLLBACK +  (0.1ms) BEGIN +---------------------- +RelationTest: test_out +---------------------- +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.1ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:07.253619"], ["updated_at", "2016-12-13 20:19:07.253619"]] +  (0.2ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.1ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:07.254560"], ["updated_at", "2016-12-13 20:19:07.254560"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.2ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:07.255333"], ["updated_at", "2016-12-13 20:19:07.255333"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.1ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:07.256258"], ["updated_at", "2016-12-13 20:19:07.256258"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.1ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:07.257090"], ["updated_at", "2016-12-13 20:19:07.257090"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.1ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:07.257834"], ["updated_at", "2016-12-13 20:19:07.257834"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.1ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:07.258540"], ["updated_at", "2016-12-13 20:19:07.258540"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.1ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:07.259308"], ["updated_at", "2016-12-13 20:19:07.259308"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.1ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:07.260078"], ["updated_at", "2016-12-13 20:19:07.260078"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.0ms) SAVEPOINT active_record_1 + SQL (0.1ms) INSERT INTO "products" ("created_at", "updated_at") VALUES ($1, $2) RETURNING "id" [["created_at", "2016-12-13 20:19:07.260750"], ["updated_at", "2016-12-13 20:19:07.260750"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SELECT COUNT(*) FROM "products" +  (0.1ms) ROLLBACK +  (2.6ms) CREATE TABLE "schema_migrations" ("version" character varying NOT NULL)  +  (0.9ms) CREATE UNIQUE INDEX "unique_schema_migrations" ON "schema_migrations" ("version") + ActiveRecord::SchemaMigration Load (0.3ms) SELECT "schema_migrations".* FROM "schema_migrations" +Migrating to CreateProducts (20130820024335) +  (0.1ms) BEGIN +  (7.7ms) CREATE TABLE "products" ("id" serial primary key, "created_at" timestamp NOT NULL, "updated_at" timestamp NOT NULL)  + SQL (0.3ms) INSERT INTO "schema_migrations" ("version") VALUES ($1) [["version", "20130820024335"]] +  (11.6ms) COMMIT + ActiveRecord::SchemaMigration Load (0.4ms) SELECT "schema_migrations".* FROM "schema_migrations" +  (1.8ms) SELECT t2.oid::regclass::text AS to_table, a1.attname AS column, a2.attname AS primary_key, c.conname AS name, c.confupdtype AS on_update, c.confdeltype AS on_delete +FROM pg_constraint c +JOIN pg_class t1 ON c.conrelid = t1.oid +JOIN pg_class t2 ON c.confrelid = t2.oid +JOIN pg_attribute a1 ON a1.attnum = c.conkey[1] AND a1.attrelid = t1.oid +JOIN pg_attribute a2 ON a2.attnum = c.confkey[1] AND a2.attrelid = t2.oid +JOIN pg_namespace t3 ON c.connamespace = t3.oid +WHERE c.contype = 'f' + AND t1.relname = 'products' + AND t3.nspname = ANY (current_schemas(false)) +ORDER BY c.conname +