test/dummy/log/test.log in cachers-4.1.0.1 vs test/dummy/log/test.log in cachers-4.1.0.2

- old
+ new

@@ -1732,5 +1732,276 @@  (0.1ms) RELEASE SAVEPOINT active_record_1  (0.1ms) SAVEPOINT active_record_1 SQL (0.2ms) DELETE FROM "users" WHERE "users"."id" = $1 [["id", 3]]  (0.1ms) RELEASE SAVEPOINT active_record_1  (0.1ms) ROLLBACK + ActiveRecord::SchemaMigration Load (0.4ms) SELECT "schema_migrations".* FROM "schema_migrations" +  (0.3ms) BEGIN +------------------ +TaskTest: test_all +------------------ +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.4ms) INSERT INTO "users" ("name", "created_at", "updated_at") VALUES ($1, $2, $3) RETURNING "id" [["name", "mike"], ["created_at", "2016-12-14 06:04:36.181765"], ["updated_at", "2016-12-14 06:04:36.181765"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.2ms) INSERT INTO "users" ("name", "created_at", "updated_at") VALUES ($1, $2, $3) RETURNING "id" [["name", "john"], ["created_at", "2016-12-14 06:04:36.185642"], ["updated_at", "2016-12-14 06:04:36.185642"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 + User Load (0.4ms) SELECT "users".* FROM "users" ORDER BY "users"."id" ASC LIMIT 1000 + User Load (0.3ms) SELECT "users".* FROM "users" ORDER BY "users"."id" ASC LIMIT 1000 + User Load (0.2ms) SELECT "users".* FROM "users" ORDER BY "users"."id" ASC LIMIT 1000 +  (0.2ms) ROLLBACK +  (0.1ms) BEGIN +--------------------------- +GeneratorsTest: test_cacher +--------------------------- +  (0.2ms) ROLLBACK +  (0.1ms) BEGIN +---------------------------- +GeneratorsTest: test_install +---------------------------- +  (0.1ms) ROLLBACK +  (0.1ms) BEGIN +-------------------------- +RecordTest: test_callbacks +-------------------------- +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.2ms) INSERT INTO "users" ("name", "created_at", "updated_at") VALUES ($1, $2, $3) RETURNING "id" [["name", "mike"], ["created_at", "2016-12-14 06:04:36.230893"], ["updated_at", "2016-12-14 06:04:36.230893"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) ROLLBACK + ActiveRecord::SchemaMigration Load (0.4ms) SELECT "schema_migrations".* FROM "schema_migrations" +  (0.2ms) BEGIN +---------------------------- +GeneratorsTest: test_install +---------------------------- +  (0.2ms) ROLLBACK +  (0.1ms) BEGIN +--------------------------- +GeneratorsTest: test_cacher +--------------------------- +  (0.3ms) ROLLBACK +  (0.1ms) BEGIN +------------------ +TaskTest: test_all +------------------ +  (0.2ms) SAVEPOINT active_record_1 + SQL (0.3ms) INSERT INTO "users" ("name", "created_at", "updated_at") VALUES ($1, $2, $3) RETURNING "id" [["name", "mike"], ["created_at", "2016-12-14 06:05:35.450623"], ["updated_at", "2016-12-14 06:05:35.450623"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.2ms) INSERT INTO "users" ("name", "created_at", "updated_at") VALUES ($1, $2, $3) RETURNING "id" [["name", "john"], ["created_at", "2016-12-14 06:05:35.453859"], ["updated_at", "2016-12-14 06:05:35.453859"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 + User Load (0.4ms) SELECT "users".* FROM "users" ORDER BY "users"."id" ASC LIMIT 1000 + User Load (0.5ms) SELECT "users".* FROM "users" ORDER BY "users"."id" ASC LIMIT 1000 + User Load (0.3ms) SELECT "users".* FROM "users" ORDER BY "users"."id" ASC LIMIT 1000 +  (0.2ms) ROLLBACK +  (0.1ms) BEGIN +-------------------------- +RecordTest: test_callbacks +-------------------------- +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.1ms) INSERT INTO "users" ("name", "created_at", "updated_at") VALUES ($1, $2, $3) RETURNING "id" [["name", "mike"], ["created_at", "2016-12-14 06:05:35.476332"], ["updated_at", "2016-12-14 06:05:35.476332"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 + ActiveRecord::SchemaMigration Load (0.3ms) SELECT "schema_migrations".* FROM "schema_migrations" +  (0.2ms) BEGIN +---------------------------- +GeneratorsTest: test_install +---------------------------- +  (0.2ms) ROLLBACK +  (0.2ms) BEGIN +--------------------------- +GeneratorsTest: test_cacher +--------------------------- +  (0.2ms) ROLLBACK +  (0.2ms) BEGIN +-------------------------- +RecordTest: test_callbacks +-------------------------- +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.3ms) INSERT INTO "users" ("name", "created_at", "updated_at") VALUES ($1, $2, $3) RETURNING "id" [["name", "mike"], ["created_at", "2016-12-14 06:06:18.039597"], ["updated_at", "2016-12-14 06:06:18.039597"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 + ActiveRecord::SchemaMigration Load (0.3ms) SELECT "schema_migrations".* FROM "schema_migrations" +  (0.2ms) BEGIN +---------------------------- +GeneratorsTest: test_install +---------------------------- +  (0.2ms) ROLLBACK +  (0.1ms) BEGIN +--------------------------- +GeneratorsTest: test_cacher +--------------------------- +  (0.1ms) ROLLBACK +  (0.1ms) BEGIN +-------------------------- +RecordTest: test_callbacks +-------------------------- +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.3ms) INSERT INTO "users" ("name", "created_at", "updated_at") VALUES ($1, $2, $3) RETURNING "id" [["name", "mike"], ["created_at", "2016-12-14 06:08:01.122344"], ["updated_at", "2016-12-14 06:08:01.122344"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.3ms) ROLLBACK +  (0.2ms) BEGIN +------------------ +TaskTest: test_all +------------------ +  (0.2ms) SAVEPOINT active_record_1 + SQL (0.6ms) INSERT INTO "users" ("name", "created_at", "updated_at") VALUES ($1, $2, $3) RETURNING "id" [["name", "mike"], ["created_at", "2016-12-14 06:08:13.007968"], ["updated_at", "2016-12-14 06:08:13.007968"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.2ms) INSERT INTO "users" ("name", "created_at", "updated_at") VALUES ($1, $2, $3) RETURNING "id" [["name", "john"], ["created_at", "2016-12-14 06:08:13.010593"], ["updated_at", "2016-12-14 06:08:13.010593"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 + User Load (0.4ms) SELECT "users".* FROM "users" ORDER BY "users"."id" ASC LIMIT 1000 + User Load (0.3ms) SELECT "users".* FROM "users" ORDER BY "users"."id" ASC LIMIT 1000 + User Load (0.2ms) SELECT "users".* FROM "users" ORDER BY "users"."id" ASC LIMIT 1000 +  (0.1ms) ROLLBACK + ActiveRecord::SchemaMigration Load (0.3ms) SELECT "schema_migrations".* FROM "schema_migrations" +  (0.2ms) BEGIN +---------------------------- +GeneratorsTest: test_install +---------------------------- +  (0.2ms) ROLLBACK +  (0.1ms) BEGIN +--------------------------- +GeneratorsTest: test_cacher +--------------------------- +  (0.2ms) ROLLBACK +  (0.1ms) BEGIN +------------------ +TaskTest: test_all +------------------ +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.4ms) INSERT INTO "users" ("name", "created_at", "updated_at") VALUES ($1, $2, $3) RETURNING "id" [["name", "mike"], ["created_at", "2016-12-14 06:12:37.797251"], ["updated_at", "2016-12-14 06:12:37.797251"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.2ms) INSERT INTO "users" ("name", "created_at", "updated_at") VALUES ($1, $2, $3) RETURNING "id" [["name", "john"], ["created_at", "2016-12-14 06:12:37.800457"], ["updated_at", "2016-12-14 06:12:37.800457"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 + User Load (0.4ms) SELECT "users".* FROM "users" ORDER BY "users"."id" ASC LIMIT 1000 + User Load (0.3ms) SELECT "users".* FROM "users" ORDER BY "users"."id" ASC LIMIT 1000 + User Load (0.3ms) SELECT "users".* FROM "users" ORDER BY "users"."id" ASC LIMIT 1000 +  (0.1ms) ROLLBACK +  (1.5ms) BEGIN +-------------------------- +RecordTest: test_callbacks +-------------------------- +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.2ms) INSERT INTO "users" ("name", "created_at", "updated_at") VALUES ($1, $2, $3) RETURNING "id" [["name", "mike"], ["created_at", "2016-12-14 06:12:37.824277"], ["updated_at", "2016-12-14 06:12:37.824277"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.3ms) UPDATE "users" SET "name" = $1, "updated_at" = $2 WHERE "users"."id" = $3 [["name", "john"], ["updated_at", "2016-12-14 06:12:37.826113"], ["id", 16]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.2ms) DELETE FROM "users" WHERE "users"."id" = $1 [["id", 16]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) ROLLBACK + ActiveRecord::SchemaMigration Load (0.3ms) SELECT "schema_migrations".* FROM "schema_migrations" +  (0.2ms) BEGIN +--------------------------- +GeneratorsTest: test_cacher +--------------------------- +  (0.1ms) ROLLBACK +  (0.1ms) BEGIN +---------------------------- +GeneratorsTest: test_install +---------------------------- +  (0.1ms) ROLLBACK +  (0.2ms) BEGIN +------------------------- +ModelTest: test_singleton +------------------------- +  (0.2ms) ROLLBACK +  (0.1ms) BEGIN +------------------------- +ModelTest: test_callbacks +------------------------- +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.3ms) INSERT INTO "users" ("name", "created_at", "updated_at") VALUES ($1, $2, $3) RETURNING "id" [["name", "mike"], ["created_at", "2016-12-14 06:14:13.670994"], ["updated_at", "2016-12-14 06:14:13.670994"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.4ms) UPDATE "users" SET "name" = $1, "updated_at" = $2 WHERE "users"."id" = $3 [["name", "john"], ["updated_at", "2016-12-14 06:14:13.674523"], ["id", 17]] +  (0.3ms) RELEASE SAVEPOINT active_record_1 +  (0.2ms) SAVEPOINT active_record_1 + SQL (0.3ms) DELETE FROM "users" WHERE "users"."id" = $1 [["id", 17]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.2ms) ROLLBACK +  (0.1ms) BEGIN +-------------------------- +RecordTest: test_callbacks +-------------------------- +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.2ms) INSERT INTO "users" ("name", "created_at", "updated_at") VALUES ($1, $2, $3) RETURNING "id" [["name", "mike"], ["created_at", "2016-12-14 06:14:13.683359"], ["updated_at", "2016-12-14 06:14:13.683359"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.2ms) UPDATE "users" SET "name" = $1, "updated_at" = $2 WHERE "users"."id" = $3 [["name", "john"], ["updated_at", "2016-12-14 06:14:13.684804"], ["id", 18]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.1ms) DELETE FROM "users" WHERE "users"."id" = $1 [["id", 18]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) ROLLBACK +  (0.1ms) BEGIN +------------------ +TaskTest: test_all +------------------ +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.2ms) INSERT INTO "users" ("name", "created_at", "updated_at") VALUES ($1, $2, $3) RETURNING "id" [["name", "mike"], ["created_at", "2016-12-14 06:14:13.688848"], ["updated_at", "2016-12-14 06:14:13.688848"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.3ms) INSERT INTO "users" ("name", "created_at", "updated_at") VALUES ($1, $2, $3) RETURNING "id" [["name", "john"], ["created_at", "2016-12-14 06:14:13.691504"], ["updated_at", "2016-12-14 06:14:13.691504"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 + User Load (0.3ms) SELECT "users".* FROM "users" ORDER BY "users"."id" ASC LIMIT 1000 + User Load (0.3ms) SELECT "users".* FROM "users" ORDER BY "users"."id" ASC LIMIT 1000 + User Load (0.2ms) SELECT "users".* FROM "users" ORDER BY "users"."id" ASC LIMIT 1000 +  (0.1ms) ROLLBACK + ActiveRecord::SchemaMigration Load (0.4ms) SELECT "schema_migrations".* FROM "schema_migrations" +  (0.2ms) BEGIN +--------------------------- +GeneratorsTest: test_cacher +--------------------------- +  (0.2ms) ROLLBACK +  (0.1ms) BEGIN +---------------------------- +GeneratorsTest: test_install +---------------------------- +  (0.1ms) ROLLBACK +  (0.1ms) BEGIN +------------------------- +ModelTest: test_callbacks +------------------------- +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.4ms) INSERT INTO "users" ("name", "created_at", "updated_at") VALUES ($1, $2, $3) RETURNING "id" [["name", "mike"], ["created_at", "2016-12-14 06:17:47.559730"], ["updated_at", "2016-12-14 06:17:47.559730"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.3ms) UPDATE "users" SET "name" = $1, "updated_at" = $2 WHERE "users"."id" = $3 [["name", "john"], ["updated_at", "2016-12-14 06:17:47.585446"], ["id", 21]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.2ms) SAVEPOINT active_record_1 + SQL (0.2ms) DELETE FROM "users" WHERE "users"."id" = $1 [["id", 21]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) ROLLBACK +  (0.1ms) BEGIN +------------------------- +ModelTest: test_singleton +------------------------- +  (0.1ms) ROLLBACK +  (0.1ms) BEGIN +-------------------------- +RecordTest: test_callbacks +-------------------------- +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.2ms) INSERT INTO "users" ("name", "created_at", "updated_at") VALUES ($1, $2, $3) RETURNING "id" [["name", "mike"], ["created_at", "2016-12-14 06:17:47.596104"], ["updated_at", "2016-12-14 06:17:47.596104"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.2ms) UPDATE "users" SET "name" = $1, "updated_at" = $2 WHERE "users"."id" = $3 [["name", "john"], ["updated_at", "2016-12-14 06:17:47.597480"], ["id", 22]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.1ms) DELETE FROM "users" WHERE "users"."id" = $1 [["id", 22]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) ROLLBACK +  (0.1ms) BEGIN +------------------ +TaskTest: test_all +------------------ +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.1ms) INSERT INTO "users" ("name", "created_at", "updated_at") VALUES ($1, $2, $3) RETURNING "id" [["name", "mike"], ["created_at", "2016-12-14 06:17:47.601508"], ["updated_at", "2016-12-14 06:17:47.601508"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.1ms) INSERT INTO "users" ("name", "created_at", "updated_at") VALUES ($1, $2, $3) RETURNING "id" [["name", "john"], ["created_at", "2016-12-14 06:17:47.602587"], ["updated_at", "2016-12-14 06:17:47.602587"]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 + User Load (0.3ms) SELECT "users".* FROM "users" ORDER BY "users"."id" ASC LIMIT 1000 + User Load (0.3ms) SELECT "users".* FROM "users" ORDER BY "users"."id" ASC LIMIT 1000 + User Load (0.2ms) SELECT "users".* FROM "users" ORDER BY "users"."id" ASC LIMIT 1000 +  (0.1ms) ROLLBACK