(0.2ms) begin transaction  (0.1ms) rollback transaction  (0.0ms) begin transaction  (0.0ms) rollback transaction  (23.1ms) CREATE TABLE "audits" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "auditable_id" integer, "auditable_type" varchar, "associated_id" integer, "associated_type" varchar, "user_id" integer, "user_type" varchar, "username" varchar, "action" varchar, "audited_changes" text, "version" integer DEFAULT 0, "comment" varchar, "remote_address" varchar, "request_uuid" varchar, "created_at" datetime)  (0.1ms) select sqlite_version(*)  (8.1ms) CREATE INDEX "associated_index" ON "audits" ("associated_id", "associated_type")  (0.1ms)  SELECT sql FROM sqlite_master WHERE name='associated_index' AND type='index' UNION ALL SELECT sql FROM sqlite_temp_master WHERE name='associated_index' AND type='index'   (10.6ms) CREATE INDEX "auditable_index" ON "audits" ("auditable_id", "auditable_type")  (0.1ms)  SELECT sql FROM sqlite_master WHERE name='auditable_index' AND type='index' UNION ALL SELECT sql FROM sqlite_temp_master WHERE name='auditable_index' AND type='index'   (0.1ms)  SELECT sql FROM sqlite_master WHERE name='associated_index' AND type='index' UNION ALL SELECT sql FROM sqlite_temp_master WHERE name='associated_index' AND type='index'   (10.7ms) CREATE INDEX "index_audits_on_created_at" ON "audits" ("created_at")  (0.1ms)  SELECT sql FROM sqlite_master WHERE name='index_audits_on_created_at' AND type='index' UNION ALL SELECT sql FROM sqlite_temp_master WHERE name='index_audits_on_created_at' AND type='index'   (0.1ms)  SELECT sql FROM sqlite_master WHERE name='auditable_index' AND type='index' UNION ALL SELECT sql FROM sqlite_temp_master WHERE name='auditable_index' AND type='index'   (0.1ms)  SELECT sql FROM sqlite_master WHERE name='associated_index' AND type='index' UNION ALL SELECT sql FROM sqlite_temp_master WHERE name='associated_index' AND type='index'   (10.3ms) CREATE INDEX "index_audits_on_request_uuid" ON "audits" ("request_uuid")  (0.1ms)  SELECT sql FROM sqlite_master WHERE name='index_audits_on_request_uuid' AND type='index' UNION ALL SELECT sql FROM sqlite_temp_master WHERE name='index_audits_on_request_uuid' AND type='index'   (0.1ms)  SELECT sql FROM sqlite_master WHERE name='index_audits_on_created_at' AND type='index' UNION ALL SELECT sql FROM sqlite_temp_master WHERE name='index_audits_on_created_at' AND type='index'   (0.1ms)  SELECT sql FROM sqlite_master WHERE name='auditable_index' AND type='index' UNION ALL SELECT sql FROM sqlite_temp_master WHERE name='auditable_index' AND type='index'   (0.1ms)  SELECT sql FROM sqlite_master WHERE name='associated_index' AND type='index' UNION ALL SELECT sql FROM sqlite_temp_master WHERE name='associated_index' AND type='index'   (11.7ms) CREATE INDEX "user_index" ON "audits" ("user_id", "user_type")  (12.3ms) CREATE TABLE "products" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "sku" varchar, "title" varchar, "price" decimal, "active" boolean, "description" text, "created_at" datetime NOT NULL, "updated_at" datetime NOT NULL)  (12.0ms) CREATE TABLE "users" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "name" varchar, "email" varchar, "created_at" datetime NOT NULL, "updated_at" datetime NOT NULL)  (10.5ms) CREATE TABLE "schema_migrations" ("version" varchar NOT NULL PRIMARY KEY)  (0.1ms) SELECT version FROM "schema_migrations"  (10.3ms) INSERT INTO "schema_migrations" (version) VALUES (20170507191539)  (10.2ms) INSERT INTO "schema_migrations" (version) VALUES (20170507023018), (20170507023113);   (12.5ms) CREATE TABLE "ar_internal_metadata" ("key" varchar NOT NULL PRIMARY KEY, "value" varchar, "created_at" datetime NOT NULL, "updated_at" datetime NOT NULL) ActiveRecord::InternalMetadata Load (0.2ms) SELECT "ar_internal_metadata".* FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = ? LIMIT ? [["key", :environment], ["LIMIT", 1]]  (0.1ms) begin transaction SQL (0.2ms) INSERT INTO "ar_internal_metadata" ("key", "value", "created_at", "updated_at") VALUES (?, ?, ?, ?) [["key", "environment"], ["value", "test"], ["created_at", 2017-05-08 12:35:48 UTC], ["updated_at", 2017-05-08 12:35:48 UTC]]  (11.2ms) commit transaction ActiveRecord::InternalMetadata Load (0.1ms) SELECT "ar_internal_metadata".* FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = ? LIMIT ? [["key", :environment], ["LIMIT", 1]]  (0.1ms) begin transaction  (0.0ms) commit transaction  (0.4ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (0.2ms) INSERT INTO "users" ("email", "created_at", "updated_at") VALUES (?, ?, ?) [["email", "user@domain.com"], ["created_at", 2017-05-08 12:35:50 UTC], ["updated_at", 2017-05-08 12:35:50 UTC]]  (0.0ms) RELEASE SAVEPOINT active_record_1  (0.1ms) SAVEPOINT active_record_1 SQL (0.6ms) INSERT INTO "products" ("sku", "title", "price", "active", "description", "created_at", "updated_at") VALUES (?, ?, ?, ?, ?, ?, ?) [["sku", "001"], ["title", "Smartphone"], ["price", #], ["active", true], ["description", "Smartphone ABC"], ["created_at", 2017-05-08 12:35:50 UTC], ["updated_at", 2017-05-08 12:35:50 UTC]] Audited::Audit Load (0.2ms) SELECT "audits".* FROM "audits" WHERE "audits"."auditable_id" = ? AND "audits"."auditable_type" = ? ORDER BY "audits"."version" DESC LIMIT ? [["auditable_id", 1], ["auditable_type", "Product"], ["LIMIT", 1]] SQL (0.2ms) INSERT INTO "audits" ("auditable_id", "auditable_type", "user_id", "user_type", "action", "audited_changes", "version", "request_uuid", "created_at") VALUES (?, ?, ?, ?, ?, ?, ?, ?, ?) [["auditable_id", 1], ["auditable_type", "Product"], ["user_id", 1], ["user_type", "User"], ["action", "create"], ["audited_changes", "---\nsku: '001'\ntitle: Smartphone\nprice: !ruby/object:BigDecimal 18:0.45E3\nactive: true\ndescription: Smartphone ABC\n"], ["version", 1], ["request_uuid", "d9a6a17e-5235-46e2-a037-474ddd818b86"], ["created_at", 2017-05-08 12:35:50 UTC]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Started GET "/products/1" for 127.0.0.1 at 2017-05-08 09:35:50 -0300 Processing by ProductsController#show as HTML Parameters: {"id"=>"1"} Product Load (0.1ms) SELECT "products".* FROM "products" WHERE "products"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendering products/show.html.erb within layouts/application Audited::Audit Load (0.2ms) SELECT "audits".* FROM "audits" WHERE "audits"."auditable_id" = ? AND "audits"."auditable_type" = ? AND "audits"."action" = ? ORDER BY "audits"."version" ASC LIMIT ? [["auditable_id", 1], ["auditable_type", "Product"], ["action", "create"], ["LIMIT", 1]] User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendered /home/douglas/code/audited_views/app/views/application/_controls.html.erb (21.6ms) Rendered products/show.html.erb within layouts/application (47.4ms) Completed 200 OK in 233ms (Views: 214.4ms | ActiveRecord: 0.5ms)  (0.2ms) rollback transaction  (0.1ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (0.2ms) INSERT INTO "users" ("email", "created_at", "updated_at") VALUES (?, ?, ?) [["email", "user@domain.com"], ["created_at", 2017-05-08 12:35:50 UTC], ["updated_at", 2017-05-08 12:35:50 UTC]]  (0.0ms) RELEASE SAVEPOINT active_record_1  (0.1ms) SAVEPOINT active_record_1 SQL (0.2ms) INSERT INTO "products" ("sku", "title", "price", "active", "description", "created_at", "updated_at") VALUES (?, ?, ?, ?, ?, ?, ?) [["sku", "001"], ["title", "Smartphone"], ["price", #], ["active", true], ["description", "Smartphone ABC"], ["created_at", 2017-05-08 12:35:50 UTC], ["updated_at", 2017-05-08 12:35:50 UTC]] Audited::Audit Load (0.1ms) SELECT "audits".* FROM "audits" WHERE "audits"."auditable_id" = ? AND "audits"."auditable_type" = ? ORDER BY "audits"."version" DESC LIMIT ? [["auditable_id", 1], ["auditable_type", "Product"], ["LIMIT", 1]] SQL (0.2ms) INSERT INTO "audits" ("auditable_id", "auditable_type", "user_id", "user_type", "action", "audited_changes", "version", "request_uuid", "created_at") VALUES (?, ?, ?, ?, ?, ?, ?, ?, ?) [["auditable_id", 1], ["auditable_type", "Product"], ["user_id", 1], ["user_type", "User"], ["action", "create"], ["audited_changes", "---\nsku: '001'\ntitle: Smartphone\nprice: !ruby/object:BigDecimal 18:0.45E3\nactive: true\ndescription: Smartphone ABC\n"], ["version", 1], ["request_uuid", "b4626db5-205e-411d-b256-ff38c2608cec"], ["created_at", 2017-05-08 12:35:50 UTC]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Started GET "/products/1" for 127.0.0.1 at 2017-05-08 09:35:50 -0300 Processing by ProductsController#show as HTML Parameters: {"id"=>"1"} Product Load (0.1ms) SELECT "products".* FROM "products" WHERE "products"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendering products/show.html.erb within layouts/application Audited::Audit Load (0.3ms) SELECT "audits".* FROM "audits" WHERE "audits"."auditable_id" = ? AND "audits"."auditable_type" = ? AND "audits"."action" = ? ORDER BY "audits"."version" ASC LIMIT ? [["auditable_id", 1], ["auditable_type", "Product"], ["action", "create"], ["LIMIT", 1]] User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendered /home/douglas/code/audited_views/app/views/application/_controls.html.erb (5.1ms) Rendered products/show.html.erb within layouts/application (7.4ms) Completed 200 OK in 11ms (Views: 9.5ms | ActiveRecord: 0.4ms) Started GET "/products/1?show_log=true" for 127.0.0.1 at 2017-05-08 09:35:50 -0300 Processing by ProductsController#show as HTML Parameters: {"show_log"=>"true", "id"=>"1"} Product Load (0.1ms) SELECT "products".* FROM "products" WHERE "products"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendering products/show.html.erb within layouts/application Audited::Audit Load (0.2ms) SELECT "audits".* FROM "audits" WHERE "audits"."auditable_id" = ? AND "audits"."auditable_type" = ? AND "audits"."action" = ? ORDER BY "audits"."version" ASC LIMIT ? [["auditable_id", 1], ["auditable_type", "Product"], ["action", "create"], ["LIMIT", 1]] User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Audited::Audit Load (0.2ms) SELECT "audits".* FROM "audits" WHERE "audits"."auditable_id" = ? AND "audits"."auditable_type" = ? ORDER BY "audits"."version" ASC [["auditable_id", 1], ["auditable_type", "Product"]] CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Product Load (0.1ms) SELECT "products".* FROM "products" WHERE "products"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendered /home/douglas/code/audited_views/app/views/application/_audit_record.html.erb (10.0ms) Rendered /home/douglas/code/audited_views/app/views/application/_audits.html.erb (13.0ms) Rendered /home/douglas/code/audited_views/app/views/application/_controls.html.erb (20.0ms) Rendered products/show.html.erb within layouts/application (22.6ms) Completed 200 OK in 27ms (Views: 24.5ms | ActiveRecord: 0.7ms)  (0.2ms) rollback transaction ActiveRecord::SchemaMigration Load (0.1ms) SELECT "schema_migrations".* FROM "schema_migrations"  (0.2ms) SELECT "ar_internal_metadata"."value" FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = ? [["key", :environment]] ActiveRecord::SchemaMigration Load (0.0ms) SELECT "schema_migrations".* FROM "schema_migrations"  (0.1ms) SELECT "ar_internal_metadata"."value" FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = ? [["key", :environment]] ActiveRecord::SchemaMigration Load (0.1ms) SELECT "schema_migrations".* FROM "schema_migrations"  (0.1ms) SELECT "ar_internal_metadata"."value" FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = ? [["key", :environment]]  (14.5ms) CREATE TABLE "audits" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "auditable_id" integer, "auditable_type" varchar, "associated_id" integer, "associated_type" varchar, "user_id" integer, "user_type" varchar, "username" varchar, "action" varchar, "audited_changes" text, "version" integer DEFAULT 0, "comment" varchar, "remote_address" varchar, "request_uuid" varchar, "created_at" datetime)  (0.1ms) select sqlite_version(*)  (9.6ms) CREATE INDEX "associated_index" ON "audits" ("associated_id", "associated_type")  (0.1ms)  SELECT sql FROM sqlite_master WHERE name='associated_index' AND type='index' UNION ALL SELECT sql FROM sqlite_temp_master WHERE name='associated_index' AND type='index'   (11.6ms) CREATE INDEX "auditable_index" ON "audits" ("auditable_id", "auditable_type")  (0.1ms)  SELECT sql FROM sqlite_master WHERE name='auditable_index' AND type='index' UNION ALL SELECT sql FROM sqlite_temp_master WHERE name='auditable_index' AND type='index'   (0.1ms)  SELECT sql FROM sqlite_master WHERE name='associated_index' AND type='index' UNION ALL SELECT sql FROM sqlite_temp_master WHERE name='associated_index' AND type='index'   (10.4ms) CREATE INDEX "index_audits_on_created_at" ON "audits" ("created_at")  (0.1ms)  SELECT sql FROM sqlite_master WHERE name='index_audits_on_created_at' AND type='index' UNION ALL SELECT sql FROM sqlite_temp_master WHERE name='index_audits_on_created_at' AND type='index'   (0.1ms)  SELECT sql FROM sqlite_master WHERE name='auditable_index' AND type='index' UNION ALL SELECT sql FROM sqlite_temp_master WHERE name='auditable_index' AND type='index'   (0.1ms)  SELECT sql FROM sqlite_master WHERE name='associated_index' AND type='index' UNION ALL SELECT sql FROM sqlite_temp_master WHERE name='associated_index' AND type='index'   (10.3ms) CREATE INDEX "index_audits_on_request_uuid" ON "audits" ("request_uuid")  (0.1ms)  SELECT sql FROM sqlite_master WHERE name='index_audits_on_request_uuid' AND type='index' UNION ALL SELECT sql FROM sqlite_temp_master WHERE name='index_audits_on_request_uuid' AND type='index'   (0.1ms)  SELECT sql FROM sqlite_master WHERE name='index_audits_on_created_at' AND type='index' UNION ALL SELECT sql FROM sqlite_temp_master WHERE name='index_audits_on_created_at' AND type='index'   (0.2ms)  SELECT sql FROM sqlite_master WHERE name='auditable_index' AND type='index' UNION ALL SELECT sql FROM sqlite_temp_master WHERE name='auditable_index' AND type='index'   (0.4ms)  SELECT sql FROM sqlite_master WHERE name='associated_index' AND type='index' UNION ALL SELECT sql FROM sqlite_temp_master WHERE name='associated_index' AND type='index'   (9.6ms) CREATE INDEX "user_index" ON "audits" ("user_id", "user_type")  (10.5ms) CREATE TABLE "products" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "sku" varchar, "title" varchar, "price" decimal, "active" boolean, "description" text, "created_at" datetime NOT NULL, "updated_at" datetime NOT NULL)  (10.5ms) CREATE TABLE "users" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "name" varchar, "email" varchar, "created_at" datetime NOT NULL, "updated_at" datetime NOT NULL)  (11.8ms) CREATE TABLE "schema_migrations" ("version" varchar NOT NULL PRIMARY KEY)  (0.1ms) SELECT version FROM "schema_migrations"  (10.4ms) INSERT INTO "schema_migrations" (version) VALUES (20170507191539)  (8.8ms) INSERT INTO "schema_migrations" (version) VALUES (20170507023018), (20170507023113);   (12.2ms) CREATE TABLE "ar_internal_metadata" ("key" varchar NOT NULL PRIMARY KEY, "value" varchar, "created_at" datetime NOT NULL, "updated_at" datetime NOT NULL) ActiveRecord::InternalMetadata Load (0.2ms) SELECT "ar_internal_metadata".* FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = ? LIMIT ? [["key", :environment], ["LIMIT", 1]]  (0.1ms) begin transaction SQL (0.2ms) INSERT INTO "ar_internal_metadata" ("key", "value", "created_at", "updated_at") VALUES (?, ?, ?, ?) [["key", "environment"], ["value", "test"], ["created_at", 2017-05-08 12:35:56 UTC], ["updated_at", 2017-05-08 12:35:56 UTC]]  (9.1ms) commit transaction ActiveRecord::InternalMetadata Load (0.1ms) SELECT "ar_internal_metadata".* FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = ? LIMIT ? [["key", :environment], ["LIMIT", 1]]  (0.1ms) begin transaction  (0.0ms) commit transaction  (0.5ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (0.5ms) INSERT INTO "users" ("email", "created_at", "updated_at") VALUES (?, ?, ?) [["email", "user@domain.com"], ["created_at", 2017-05-08 12:35:57 UTC], ["updated_at", 2017-05-08 12:35:57 UTC]]  (0.1ms) RELEASE SAVEPOINT active_record_1  (0.1ms) SAVEPOINT active_record_1 SQL (0.2ms) INSERT INTO "products" ("sku", "title", "price", "active", "description", "created_at", "updated_at") VALUES (?, ?, ?, ?, ?, ?, ?) [["sku", "001"], ["title", "Smartphone"], ["price", #], ["active", true], ["description", "Smartphone ABC"], ["created_at", 2017-05-08 12:35:57 UTC], ["updated_at", 2017-05-08 12:35:57 UTC]] Audited::Audit Load (0.3ms) SELECT "audits".* FROM "audits" WHERE "audits"."auditable_id" = ? AND "audits"."auditable_type" = ? ORDER BY "audits"."version" DESC LIMIT ? [["auditable_id", 1], ["auditable_type", "Product"], ["LIMIT", 1]] SQL (0.3ms) INSERT INTO "audits" ("auditable_id", "auditable_type", "user_id", "user_type", "action", "audited_changes", "version", "request_uuid", "created_at") VALUES (?, ?, ?, ?, ?, ?, ?, ?, ?) [["auditable_id", 1], ["auditable_type", "Product"], ["user_id", 1], ["user_type", "User"], ["action", "create"], ["audited_changes", "---\nsku: '001'\ntitle: Smartphone\nprice: !ruby/object:BigDecimal 18:0.45E3\nactive: true\ndescription: Smartphone ABC\n"], ["version", 1], ["request_uuid", "41835f55-1b36-43a4-ad3e-575de5255d6f"], ["created_at", 2017-05-08 12:35:57 UTC]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Started GET "/products/1" for 127.0.0.1 at 2017-05-08 09:35:57 -0300 Processing by ProductsController#show as HTML Parameters: {"id"=>"1"} Product Load (0.2ms) SELECT "products".* FROM "products" WHERE "products"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendering products/show.html.erb within layouts/application Audited::Audit Load (0.2ms) SELECT "audits".* FROM "audits" WHERE "audits"."auditable_id" = ? AND "audits"."auditable_type" = ? AND "audits"."action" = ? ORDER BY "audits"."version" ASC LIMIT ? [["auditable_id", 1], ["auditable_type", "Product"], ["action", "create"], ["LIMIT", 1]] User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendered /home/douglas/code/audited_views/app/views/application/_controls.html.erb (18.4ms) Rendered products/show.html.erb within layouts/application (36.1ms) Completed 200 OK in 197ms (Views: 190.6ms | ActiveRecord: 0.6ms) Started GET "/products/1?show_log=true" for 127.0.0.1 at 2017-05-08 09:35:58 -0300 Processing by ProductsController#show as HTML Parameters: {"show_log"=>"true", "id"=>"1"} Product Load (0.1ms) SELECT "products".* FROM "products" WHERE "products"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendering products/show.html.erb within layouts/application Audited::Audit Load (0.2ms) SELECT "audits".* FROM "audits" WHERE "audits"."auditable_id" = ? AND "audits"."auditable_type" = ? AND "audits"."action" = ? ORDER BY "audits"."version" ASC LIMIT ? [["auditable_id", 1], ["auditable_type", "Product"], ["action", "create"], ["LIMIT", 1]] User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Audited::Audit Load (0.2ms) SELECT "audits".* FROM "audits" WHERE "audits"."auditable_id" = ? AND "audits"."auditable_type" = ? ORDER BY "audits"."version" ASC [["auditable_id", 1], ["auditable_type", "Product"]] CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Product Load (0.1ms) SELECT "products".* FROM "products" WHERE "products"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendered /home/douglas/code/audited_views/app/views/application/_audit_record.html.erb (6.3ms) Rendered /home/douglas/code/audited_views/app/views/application/_audits.html.erb (8.7ms) Rendered /home/douglas/code/audited_views/app/views/application/_controls.html.erb (13.8ms) Rendered products/show.html.erb within layouts/application (15.5ms) Completed 200 OK in 19ms (Views: 17.2ms | ActiveRecord: 0.6ms)  (0.2ms) rollback transaction  (0.1ms) begin transaction  (0.0ms) SAVEPOINT active_record_1 SQL (0.2ms) INSERT INTO "users" ("email", "created_at", "updated_at") VALUES (?, ?, ?) [["email", "user@domain.com"], ["created_at", 2017-05-08 12:35:58 UTC], ["updated_at", 2017-05-08 12:35:58 UTC]]  (0.0ms) RELEASE SAVEPOINT active_record_1  (0.1ms) SAVEPOINT active_record_1 SQL (0.2ms) INSERT INTO "products" ("sku", "title", "price", "active", "description", "created_at", "updated_at") VALUES (?, ?, ?, ?, ?, ?, ?) [["sku", "001"], ["title", "Smartphone"], ["price", #], ["active", true], ["description", "Smartphone ABC"], ["created_at", 2017-05-08 12:35:58 UTC], ["updated_at", 2017-05-08 12:35:58 UTC]] Audited::Audit Load (0.1ms) SELECT "audits".* FROM "audits" WHERE "audits"."auditable_id" = ? AND "audits"."auditable_type" = ? ORDER BY "audits"."version" DESC LIMIT ? [["auditable_id", 1], ["auditable_type", "Product"], ["LIMIT", 1]] SQL (0.2ms) INSERT INTO "audits" ("auditable_id", "auditable_type", "user_id", "user_type", "action", "audited_changes", "version", "request_uuid", "created_at") VALUES (?, ?, ?, ?, ?, ?, ?, ?, ?) [["auditable_id", 1], ["auditable_type", "Product"], ["user_id", 1], ["user_type", "User"], ["action", "create"], ["audited_changes", "---\nsku: '001'\ntitle: Smartphone\nprice: !ruby/object:BigDecimal 18:0.45E3\nactive: true\ndescription: Smartphone ABC\n"], ["version", 1], ["request_uuid", "73f94d51-41f9-43c8-a48c-1f9fdf8a7bb5"], ["created_at", 2017-05-08 12:35:58 UTC]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Started GET "/products/1" for 127.0.0.1 at 2017-05-08 09:35:58 -0300 Processing by ProductsController#show as HTML Parameters: {"id"=>"1"} Product Load (0.1ms) SELECT "products".* FROM "products" WHERE "products"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendering products/show.html.erb within layouts/application Audited::Audit Load (0.3ms) SELECT "audits".* FROM "audits" WHERE "audits"."auditable_id" = ? AND "audits"."auditable_type" = ? AND "audits"."action" = ? ORDER BY "audits"."version" ASC LIMIT ? [["auditable_id", 1], ["auditable_type", "Product"], ["action", "create"], ["LIMIT", 1]] User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendered /home/douglas/code/audited_views/app/views/application/_controls.html.erb (4.9ms) Rendered products/show.html.erb within layouts/application (7.2ms) Completed 200 OK in 11ms (Views: 9.4ms | ActiveRecord: 0.4ms)  (0.3ms) rollback transaction  (0.4ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "users" ("email", "created_at", "updated_at") VALUES (?, ?, ?) [["email", "user@domain.com"], ["created_at", 2017-05-08 12:36:01 UTC], ["updated_at", 2017-05-08 12:36:01 UTC]]  (0.1ms) RELEASE SAVEPOINT active_record_1  (0.1ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "products" ("sku", "title", "price", "active", "description", "created_at", "updated_at") VALUES (?, ?, ?, ?, ?, ?, ?) [["sku", "001"], ["title", "Smartphone"], ["price", #], ["active", true], ["description", "Smartphone ABC"], ["created_at", 2017-05-08 12:36:01 UTC], ["updated_at", 2017-05-08 12:36:01 UTC]] Audited::Audit Load (0.3ms) SELECT "audits".* FROM "audits" WHERE "audits"."auditable_id" = ? AND "audits"."auditable_type" = ? ORDER BY "audits"."version" DESC LIMIT ? [["auditable_id", 1], ["auditable_type", "Product"], ["LIMIT", 1]] SQL (0.3ms) INSERT INTO "audits" ("auditable_id", "auditable_type", "user_id", "user_type", "action", "audited_changes", "version", "request_uuid", "created_at") VALUES (?, ?, ?, ?, ?, ?, ?, ?, ?) [["auditable_id", 1], ["auditable_type", "Product"], ["user_id", 1], ["user_type", "User"], ["action", "create"], ["audited_changes", "---\nsku: '001'\ntitle: Smartphone\nprice: !ruby/object:BigDecimal 18:0.45E3\nactive: true\ndescription: Smartphone ABC\n"], ["version", 1], ["request_uuid", "eee48361-37f1-4160-b26e-1f375731ed9d"], ["created_at", 2017-05-08 12:36:01 UTC]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Started GET "/products/1" for 127.0.0.1 at 2017-05-08 09:36:01 -0300 Processing by ProductsController#show as HTML Parameters: {"id"=>"1"} Product Load (0.2ms) SELECT "products".* FROM "products" WHERE "products"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendering products/show.html.erb within layouts/application Audited::Audit Load (0.2ms) SELECT "audits".* FROM "audits" WHERE "audits"."auditable_id" = ? AND "audits"."auditable_type" = ? AND "audits"."action" = ? ORDER BY "audits"."version" ASC LIMIT ? [["auditable_id", 1], ["auditable_type", "Product"], ["action", "create"], ["LIMIT", 1]] User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendered /home/douglas/code/audited_views/app/views/application/_controls.html.erb (11.6ms) Rendered products/show.html.erb within layouts/application (26.6ms) Completed 200 OK in 211ms (Views: 203.8ms | ActiveRecord: 0.5ms)  (0.2ms) rollback transaction  (0.1ms) begin transaction  (0.0ms) SAVEPOINT active_record_1 SQL (0.2ms) INSERT INTO "users" ("email", "created_at", "updated_at") VALUES (?, ?, ?) [["email", "user@domain.com"], ["created_at", 2017-05-08 12:36:01 UTC], ["updated_at", 2017-05-08 12:36:01 UTC]]  (0.0ms) RELEASE SAVEPOINT active_record_1  (0.0ms) SAVEPOINT active_record_1 SQL (0.2ms) INSERT INTO "products" ("sku", "title", "price", "active", "description", "created_at", "updated_at") VALUES (?, ?, ?, ?, ?, ?, ?) [["sku", "001"], ["title", "Smartphone"], ["price", #], ["active", true], ["description", "Smartphone ABC"], ["created_at", 2017-05-08 12:36:01 UTC], ["updated_at", 2017-05-08 12:36:01 UTC]] Audited::Audit Load (0.1ms) SELECT "audits".* FROM "audits" WHERE "audits"."auditable_id" = ? AND "audits"."auditable_type" = ? ORDER BY "audits"."version" DESC LIMIT ? [["auditable_id", 1], ["auditable_type", "Product"], ["LIMIT", 1]] SQL (0.2ms) INSERT INTO "audits" ("auditable_id", "auditable_type", "user_id", "user_type", "action", "audited_changes", "version", "request_uuid", "created_at") VALUES (?, ?, ?, ?, ?, ?, ?, ?, ?) [["auditable_id", 1], ["auditable_type", "Product"], ["user_id", 1], ["user_type", "User"], ["action", "create"], ["audited_changes", "---\nsku: '001'\ntitle: Smartphone\nprice: !ruby/object:BigDecimal 18:0.45E3\nactive: true\ndescription: Smartphone ABC\n"], ["version", 1], ["request_uuid", "f6da4da1-a6c6-46e8-a08b-c45a3f626f6f"], ["created_at", 2017-05-08 12:36:01 UTC]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Started GET "/products/1" for 127.0.0.1 at 2017-05-08 09:36:01 -0300 Processing by ProductsController#show as HTML Parameters: {"id"=>"1"} Product Load (0.1ms) SELECT "products".* FROM "products" WHERE "products"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendering products/show.html.erb within layouts/application Audited::Audit Load (0.2ms) SELECT "audits".* FROM "audits" WHERE "audits"."auditable_id" = ? AND "audits"."auditable_type" = ? AND "audits"."action" = ? ORDER BY "audits"."version" ASC LIMIT ? [["auditable_id", 1], ["auditable_type", "Product"], ["action", "create"], ["LIMIT", 1]] User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendered /home/douglas/code/audited_views/app/views/application/_controls.html.erb (4.4ms) Rendered products/show.html.erb within layouts/application (6.6ms) Completed 200 OK in 10ms (Views: 8.7ms | ActiveRecord: 0.3ms) Started GET "/products/1?show_log=true" for 127.0.0.1 at 2017-05-08 09:36:01 -0300 Processing by ProductsController#show as HTML Parameters: {"show_log"=>"true", "id"=>"1"} Product Load (0.1ms) SELECT "products".* FROM "products" WHERE "products"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendering products/show.html.erb within layouts/application Audited::Audit Load (0.4ms) SELECT "audits".* FROM "audits" WHERE "audits"."auditable_id" = ? AND "audits"."auditable_type" = ? AND "audits"."action" = ? ORDER BY "audits"."version" ASC LIMIT ? [["auditable_id", 1], ["auditable_type", "Product"], ["action", "create"], ["LIMIT", 1]] User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Audited::Audit Load (0.2ms) SELECT "audits".* FROM "audits" WHERE "audits"."auditable_id" = ? AND "audits"."auditable_type" = ? ORDER BY "audits"."version" ASC [["auditable_id", 1], ["auditable_type", "Product"]] CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Product Load (0.1ms) SELECT "products".* FROM "products" WHERE "products"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendered /home/douglas/code/audited_views/app/views/application/_audit_record.html.erb (6.7ms) Rendered /home/douglas/code/audited_views/app/views/application/_audits.html.erb (9.5ms) Rendered /home/douglas/code/audited_views/app/views/application/_controls.html.erb (15.7ms) Rendered products/show.html.erb within layouts/application (17.2ms) Completed 200 OK in 20ms (Views: 18.5ms | ActiveRecord: 0.8ms)  (0.2ms) rollback transaction  (0.3ms) begin transaction  (0.0ms) SAVEPOINT active_record_1 SQL (0.2ms) INSERT INTO "users" ("email", "created_at", "updated_at") VALUES (?, ?, ?) [["email", "user@domain.com"], ["created_at", 2017-05-24 20:02:21 UTC], ["updated_at", 2017-05-24 20:02:21 UTC]]  (0.0ms) RELEASE SAVEPOINT active_record_1  (0.1ms) SAVEPOINT active_record_1 SQL (2.6ms) INSERT INTO "products" ("sku", "title", "price", "active", "description", "created_at", "updated_at") VALUES (?, ?, ?, ?, ?, ?, ?) [["sku", "001"], ["title", "Smartphone"], ["price", 0.45e3], ["active", true], ["description", "Smartphone ABC"], ["created_at", 2017-05-24 20:02:21 UTC], ["updated_at", 2017-05-24 20:02:21 UTC]] Audited::Audit Load (0.2ms) SELECT "audits".* FROM "audits" WHERE "audits"."auditable_id" = ? AND "audits"."auditable_type" = ? ORDER BY "audits"."version" DESC LIMIT ? [["auditable_id", 1], ["auditable_type", "Product"], ["LIMIT", 1]] SQL (0.2ms) INSERT INTO "audits" ("auditable_id", "auditable_type", "user_id", "user_type", "action", "audited_changes", "version", "request_uuid", "created_at") VALUES (?, ?, ?, ?, ?, ?, ?, ?, ?) [["auditable_id", 1], ["auditable_type", "Product"], ["user_id", 1], ["user_type", "User"], ["action", "create"], ["audited_changes", "---\nsku: '001'\ntitle: Smartphone\nprice: !ruby/object:BigDecimal 18:0.45e3\nactive: true\ndescription: Smartphone ABC\n"], ["version", 1], ["request_uuid", "62f49913-0e08-4a70-adab-946829009a1a"], ["created_at", 2017-05-24 20:02:21 UTC]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Started GET "/products/1" for 127.0.0.1 at 2017-05-24 17:02:21 -0300 Processing by ProductsController#show as HTML Parameters: {"id"=>"1"} Product Load (0.1ms) SELECT "products".* FROM "products" WHERE "products"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendering products/show.html.erb within layouts/application Audited::Audit Load (0.2ms) SELECT "audits".* FROM "audits" WHERE "audits"."auditable_id" = ? AND "audits"."auditable_type" = ? AND "audits"."action" = ? ORDER BY "audits"."version" ASC LIMIT ? [["auditable_id", 1], ["auditable_type", "Product"], ["action", "create"], ["LIMIT", 1]] User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendered /home/douglas/code/audited_views/app/views/application/_controls.html.erb (13.5ms) Rendered products/show.html.erb within layouts/application (31.0ms) Completed 200 OK in 216ms (Views: 210.9ms | ActiveRecord: 0.5ms) Started GET "/products/1?show_log=true" for 127.0.0.1 at 2017-05-24 17:02:22 -0300 Processing by ProductsController#show as HTML Parameters: {"show_log"=>"true", "id"=>"1"} Product Load (0.1ms) SELECT "products".* FROM "products" WHERE "products"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendering products/show.html.erb within layouts/application Audited::Audit Load (0.2ms) SELECT "audits".* FROM "audits" WHERE "audits"."auditable_id" = ? AND "audits"."auditable_type" = ? AND "audits"."action" = ? ORDER BY "audits"."version" ASC LIMIT ? [["auditable_id", 1], ["auditable_type", "Product"], ["action", "create"], ["LIMIT", 1]] User Load (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Audited::Audit Load (0.1ms) SELECT "audits".* FROM "audits" WHERE "audits"."auditable_id" = ? AND "audits"."auditable_type" = ? ORDER BY "audits"."version" ASC [["auditable_id", 1], ["auditable_type", "Product"]] CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Product Load (0.1ms) SELECT "products".* FROM "products" WHERE "products"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendered /home/douglas/code/audited_views/app/views/application/_audit_record.html.erb (4.7ms) Rendered /home/douglas/code/audited_views/app/views/application/_audits.html.erb (6.7ms) Rendered /home/douglas/code/audited_views/app/views/application/_controls.html.erb (10.5ms) Rendered products/show.html.erb within layouts/application (12.0ms) Completed 200 OK in 15ms (Views: 13.4ms | ActiveRecord: 0.5ms)  (0.2ms) rollback transaction  (0.1ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (0.2ms) INSERT INTO "users" ("email", "created_at", "updated_at") VALUES (?, ?, ?) [["email", "user@domain.com"], ["created_at", 2017-05-24 20:02:22 UTC], ["updated_at", 2017-05-24 20:02:22 UTC]]  (0.0ms) RELEASE SAVEPOINT active_record_1  (0.0ms) SAVEPOINT active_record_1 SQL (0.1ms) INSERT INTO "products" ("sku", "title", "price", "active", "description", "created_at", "updated_at") VALUES (?, ?, ?, ?, ?, ?, ?) [["sku", "001"], ["title", "Smartphone"], ["price", 0.45e3], ["active", true], ["description", "Smartphone ABC"], ["created_at", 2017-05-24 20:02:22 UTC], ["updated_at", 2017-05-24 20:02:22 UTC]] Audited::Audit Load (0.1ms) SELECT "audits".* FROM "audits" WHERE "audits"."auditable_id" = ? AND "audits"."auditable_type" = ? ORDER BY "audits"."version" DESC LIMIT ? [["auditable_id", 1], ["auditable_type", "Product"], ["LIMIT", 1]] SQL (0.2ms) INSERT INTO "audits" ("auditable_id", "auditable_type", "user_id", "user_type", "action", "audited_changes", "version", "request_uuid", "created_at") VALUES (?, ?, ?, ?, ?, ?, ?, ?, ?) [["auditable_id", 1], ["auditable_type", "Product"], ["user_id", 1], ["user_type", "User"], ["action", "create"], ["audited_changes", "---\nsku: '001'\ntitle: Smartphone\nprice: !ruby/object:BigDecimal 18:0.45e3\nactive: true\ndescription: Smartphone ABC\n"], ["version", 1], ["request_uuid", "44ab377d-ec1e-416e-baeb-99c985e8f659"], ["created_at", 2017-05-24 20:02:22 UTC]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Started GET "/products/1" for 127.0.0.1 at 2017-05-24 17:02:22 -0300 Processing by ProductsController#show as HTML Parameters: {"id"=>"1"} Product Load (0.0ms) SELECT "products".* FROM "products" WHERE "products"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendering products/show.html.erb within layouts/application Audited::Audit Load (0.2ms) SELECT "audits".* FROM "audits" WHERE "audits"."auditable_id" = ? AND "audits"."auditable_type" = ? AND "audits"."action" = ? ORDER BY "audits"."version" ASC LIMIT ? [["auditable_id", 1], ["auditable_type", "Product"], ["action", "create"], ["LIMIT", 1]] User Load (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendered /home/douglas/code/audited_views/app/views/application/_controls.html.erb (3.4ms) Rendered products/show.html.erb within layouts/application (4.9ms) Completed 200 OK in 8ms (Views: 6.4ms | ActiveRecord: 0.3ms)  (0.1ms) rollback transaction  (0.2ms) begin transaction  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "users" ("email", "created_at", "updated_at") VALUES (?, ?, ?) [["email", "user@domain.com"], ["created_at", 2017-05-24 20:03:11 UTC], ["updated_at", 2017-05-24 20:03:11 UTC]]  (0.0ms) RELEASE SAVEPOINT active_record_1  (0.1ms) SAVEPOINT active_record_1 SQL (0.2ms) INSERT INTO "products" ("sku", "title", "price", "active", "description", "created_at", "updated_at") VALUES (?, ?, ?, ?, ?, ?, ?) [["sku", "001"], ["title", "Smartphone"], ["price", 0.45e3], ["active", true], ["description", "Smartphone ABC"], ["created_at", 2017-05-24 20:03:11 UTC], ["updated_at", 2017-05-24 20:03:11 UTC]] Audited::Audit Load (0.2ms) SELECT "audits".* FROM "audits" WHERE "audits"."auditable_id" = ? AND "audits"."auditable_type" = ? ORDER BY "audits"."version" DESC LIMIT ? [["auditable_id", 1], ["auditable_type", "Product"], ["LIMIT", 1]] SQL (0.2ms) INSERT INTO "audits" ("auditable_id", "auditable_type", "user_id", "user_type", "action", "audited_changes", "version", "request_uuid", "created_at") VALUES (?, ?, ?, ?, ?, ?, ?, ?, ?) [["auditable_id", 1], ["auditable_type", "Product"], ["user_id", 1], ["user_type", "User"], ["action", "create"], ["audited_changes", "---\nsku: '001'\ntitle: Smartphone\nprice: !ruby/object:BigDecimal 18:0.45e3\nactive: true\ndescription: Smartphone ABC\n"], ["version", 1], ["request_uuid", "9247a947-9280-4ca2-973a-690eec9734f8"], ["created_at", 2017-05-24 20:03:11 UTC]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Started GET "/products/1" for 127.0.0.1 at 2017-05-24 17:03:11 -0300 Processing by ProductsController#show as HTML Parameters: {"id"=>"1"} Product Load (0.1ms) SELECT "products".* FROM "products" WHERE "products"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendering products/show.html.erb within layouts/application Audited::Audit Load (0.2ms) SELECT "audits".* FROM "audits" WHERE "audits"."auditable_id" = ? AND "audits"."auditable_type" = ? AND "audits"."action" = ? ORDER BY "audits"."version" ASC LIMIT ? [["auditable_id", 1], ["auditable_type", "Product"], ["action", "create"], ["LIMIT", 1]] User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendered /home/douglas/code/audited_views/app/views/application/_controls.html.erb (6.7ms) Rendered products/show.html.erb within layouts/application (16.8ms) Completed 200 OK in 113ms (Views: 109.7ms | ActiveRecord: 0.4ms)  (0.2ms) rollback transaction  (0.0ms) begin transaction  (0.0ms) SAVEPOINT active_record_1 SQL (0.2ms) INSERT INTO "users" ("email", "created_at", "updated_at") VALUES (?, ?, ?) [["email", "user@domain.com"], ["created_at", 2017-05-24 20:03:11 UTC], ["updated_at", 2017-05-24 20:03:11 UTC]]  (0.0ms) RELEASE SAVEPOINT active_record_1  (0.0ms) SAVEPOINT active_record_1 SQL (0.1ms) INSERT INTO "products" ("sku", "title", "price", "active", "description", "created_at", "updated_at") VALUES (?, ?, ?, ?, ?, ?, ?) [["sku", "001"], ["title", "Smartphone"], ["price", 0.45e3], ["active", true], ["description", "Smartphone ABC"], ["created_at", 2017-05-24 20:03:11 UTC], ["updated_at", 2017-05-24 20:03:11 UTC]] Audited::Audit Load (0.1ms) SELECT "audits".* FROM "audits" WHERE "audits"."auditable_id" = ? AND "audits"."auditable_type" = ? ORDER BY "audits"."version" DESC LIMIT ? [["auditable_id", 1], ["auditable_type", "Product"], ["LIMIT", 1]] SQL (0.2ms) INSERT INTO "audits" ("auditable_id", "auditable_type", "user_id", "user_type", "action", "audited_changes", "version", "request_uuid", "created_at") VALUES (?, ?, ?, ?, ?, ?, ?, ?, ?) [["auditable_id", 1], ["auditable_type", "Product"], ["user_id", 1], ["user_type", "User"], ["action", "create"], ["audited_changes", "---\nsku: '001'\ntitle: Smartphone\nprice: !ruby/object:BigDecimal 18:0.45e3\nactive: true\ndescription: Smartphone ABC\n"], ["version", 1], ["request_uuid", "59c3fdc3-921d-438e-bd47-c7aa91f9e7ce"], ["created_at", 2017-05-24 20:03:11 UTC]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Started GET "/products/1" for 127.0.0.1 at 2017-05-24 17:03:11 -0300 Processing by ProductsController#show as HTML Parameters: {"id"=>"1"} Product Load (0.1ms) SELECT "products".* FROM "products" WHERE "products"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendering products/show.html.erb within layouts/application Audited::Audit Load (0.3ms) SELECT "audits".* FROM "audits" WHERE "audits"."auditable_id" = ? AND "audits"."auditable_type" = ? AND "audits"."action" = ? ORDER BY "audits"."version" ASC LIMIT ? [["auditable_id", 1], ["auditable_type", "Product"], ["action", "create"], ["LIMIT", 1]] User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendered /home/douglas/code/audited_views/app/views/application/_controls.html.erb (5.8ms) Rendered products/show.html.erb within layouts/application (7.9ms) Completed 200 OK in 11ms (Views: 9.5ms | ActiveRecord: 0.5ms) Started GET "/products/1?show_log=true" for 127.0.0.1 at 2017-05-24 17:03:11 -0300 Processing by ProductsController#show as HTML Parameters: {"show_log"=>"true", "id"=>"1"} Product Load (0.1ms) SELECT "products".* FROM "products" WHERE "products"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendering products/show.html.erb within layouts/application Audited::Audit Load (0.2ms) SELECT "audits".* FROM "audits" WHERE "audits"."auditable_id" = ? AND "audits"."auditable_type" = ? AND "audits"."action" = ? ORDER BY "audits"."version" ASC LIMIT ? [["auditable_id", 1], ["auditable_type", "Product"], ["action", "create"], ["LIMIT", 1]] User Load (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Audited::Audit Load (0.2ms) SELECT "audits".* FROM "audits" WHERE "audits"."auditable_id" = ? AND "audits"."auditable_type" = ? ORDER BY "audits"."version" ASC [["auditable_id", 1], ["auditable_type", "Product"]] CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Product Load (0.1ms) SELECT "products".* FROM "products" WHERE "products"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendered /home/douglas/code/audited_views/app/views/application/_audit_record.html.erb (6.2ms) Rendered /home/douglas/code/audited_views/app/views/application/_audits.html.erb (8.4ms) Rendered /home/douglas/code/audited_views/app/views/application/_controls.html.erb (12.6ms) Rendered products/show.html.erb within layouts/application (14.0ms) Completed 200 OK in 17ms (Views: 15.1ms | ActiveRecord: 0.7ms)  (0.1ms) rollback transaction  (0.3ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "users" ("email", "created_at", "updated_at") VALUES (?, ?, ?) [["email", "user@domain.com"], ["created_at", 2017-05-24 20:03:17 UTC], ["updated_at", 2017-05-24 20:03:17 UTC]]  (0.1ms) RELEASE SAVEPOINT active_record_1  (0.1ms) SAVEPOINT active_record_1 SQL (0.2ms) INSERT INTO "products" ("sku", "title", "price", "active", "description", "created_at", "updated_at") VALUES (?, ?, ?, ?, ?, ?, ?) [["sku", "001"], ["title", "Smartphone"], ["price", 0.45e3], ["active", true], ["description", "Smartphone ABC"], ["created_at", 2017-05-24 20:03:17 UTC], ["updated_at", 2017-05-24 20:03:17 UTC]] Audited::Audit Load (0.2ms) SELECT "audits".* FROM "audits" WHERE "audits"."auditable_id" = ? AND "audits"."auditable_type" = ? ORDER BY "audits"."version" DESC LIMIT ? [["auditable_id", 1], ["auditable_type", "Product"], ["LIMIT", 1]] SQL (0.2ms) INSERT INTO "audits" ("auditable_id", "auditable_type", "user_id", "user_type", "action", "audited_changes", "version", "request_uuid", "created_at") VALUES (?, ?, ?, ?, ?, ?, ?, ?, ?) [["auditable_id", 1], ["auditable_type", "Product"], ["user_id", 1], ["user_type", "User"], ["action", "create"], ["audited_changes", "---\nsku: '001'\ntitle: Smartphone\nprice: !ruby/object:BigDecimal 18:0.45e3\nactive: true\ndescription: Smartphone ABC\n"], ["version", 1], ["request_uuid", "247692e4-5d18-4063-a40c-73e1f7a38910"], ["created_at", 2017-05-24 20:03:17 UTC]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Started GET "/products/1" for 127.0.0.1 at 2017-05-24 17:03:17 -0300 Processing by ProductsController#show as HTML Parameters: {"id"=>"1"} Product Load (0.1ms) SELECT "products".* FROM "products" WHERE "products"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendering products/show.html.erb within layouts/application Audited::Audit Load (0.2ms) SELECT "audits".* FROM "audits" WHERE "audits"."auditable_id" = ? AND "audits"."auditable_type" = ? AND "audits"."action" = ? ORDER BY "audits"."version" ASC LIMIT ? [["auditable_id", 1], ["auditable_type", "Product"], ["action", "create"], ["LIMIT", 1]] User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendered /home/douglas/code/audited_views/app/views/application/_controls.html.erb (7.0ms) Rendered products/show.html.erb within layouts/application (16.7ms) Completed 200 OK in 112ms (Views: 109.2ms | ActiveRecord: 0.4ms)  (0.2ms) rollback transaction  (0.0ms) begin transaction  (0.0ms) SAVEPOINT active_record_1 SQL (0.1ms) INSERT INTO "users" ("email", "created_at", "updated_at") VALUES (?, ?, ?) [["email", "user@domain.com"], ["created_at", 2017-05-24 20:03:18 UTC], ["updated_at", 2017-05-24 20:03:18 UTC]]  (0.0ms) RELEASE SAVEPOINT active_record_1  (0.0ms) SAVEPOINT active_record_1 SQL (0.1ms) INSERT INTO "products" ("sku", "title", "price", "active", "description", "created_at", "updated_at") VALUES (?, ?, ?, ?, ?, ?, ?) [["sku", "001"], ["title", "Smartphone"], ["price", 0.45e3], ["active", true], ["description", "Smartphone ABC"], ["created_at", 2017-05-24 20:03:18 UTC], ["updated_at", 2017-05-24 20:03:18 UTC]] Audited::Audit Load (0.1ms) SELECT "audits".* FROM "audits" WHERE "audits"."auditable_id" = ? AND "audits"."auditable_type" = ? ORDER BY "audits"."version" DESC LIMIT ? [["auditable_id", 1], ["auditable_type", "Product"], ["LIMIT", 1]] SQL (0.2ms) INSERT INTO "audits" ("auditable_id", "auditable_type", "user_id", "user_type", "action", "audited_changes", "version", "request_uuid", "created_at") VALUES (?, ?, ?, ?, ?, ?, ?, ?, ?) [["auditable_id", 1], ["auditable_type", "Product"], ["user_id", 1], ["user_type", "User"], ["action", "create"], ["audited_changes", "---\nsku: '001'\ntitle: Smartphone\nprice: !ruby/object:BigDecimal 18:0.45e3\nactive: true\ndescription: Smartphone ABC\n"], ["version", 1], ["request_uuid", "5d0bbe25-b8b8-44bf-9236-518c3cc5994f"], ["created_at", 2017-05-24 20:03:18 UTC]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Started GET "/products/1" for 127.0.0.1 at 2017-05-24 17:03:18 -0300 Processing by ProductsController#show as HTML Parameters: {"id"=>"1"} Product Load (0.0ms) SELECT "products".* FROM "products" WHERE "products"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendering products/show.html.erb within layouts/application Audited::Audit Load (0.2ms) SELECT "audits".* FROM "audits" WHERE "audits"."auditable_id" = ? AND "audits"."auditable_type" = ? AND "audits"."action" = ? ORDER BY "audits"."version" ASC LIMIT ? [["auditable_id", 1], ["auditable_type", "Product"], ["action", "create"], ["LIMIT", 1]] User Load (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendered /home/douglas/code/audited_views/app/views/application/_controls.html.erb (4.1ms) Rendered products/show.html.erb within layouts/application (5.8ms) Completed 200 OK in 9ms (Views: 7.5ms | ActiveRecord: 0.3ms) Started GET "/products/1?show_log=true" for 127.0.0.1 at 2017-05-24 17:03:18 -0300 Processing by ProductsController#show as HTML Parameters: {"show_log"=>"true", "id"=>"1"} Product Load (0.1ms) SELECT "products".* FROM "products" WHERE "products"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendering products/show.html.erb within layouts/application Audited::Audit Load (0.2ms) SELECT "audits".* FROM "audits" WHERE "audits"."auditable_id" = ? AND "audits"."auditable_type" = ? AND "audits"."action" = ? ORDER BY "audits"."version" ASC LIMIT ? [["auditable_id", 1], ["auditable_type", "Product"], ["action", "create"], ["LIMIT", 1]] User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Audited::Audit Load (0.2ms) SELECT "audits".* FROM "audits" WHERE "audits"."auditable_id" = ? AND "audits"."auditable_type" = ? ORDER BY "audits"."version" ASC [["auditable_id", 1], ["auditable_type", "Product"]] CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Product Load (0.1ms) SELECT "products".* FROM "products" WHERE "products"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendered /home/douglas/code/audited_views/app/views/application/_audit_record.html.erb (4.9ms) Rendered /home/douglas/code/audited_views/app/views/application/_audits.html.erb (7.5ms) Rendered /home/douglas/code/audited_views/app/views/application/_controls.html.erb (12.3ms) Rendered products/show.html.erb within layouts/application (14.4ms) Completed 200 OK in 18ms (Views: 16.2ms | ActiveRecord: 0.6ms)  (0.1ms) rollback transaction  (0.3ms) begin transaction  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "users" ("email", "created_at", "updated_at") VALUES (?, ?, ?) [["email", "user@domain.com"], ["created_at", 2017-05-24 20:03:22 UTC], ["updated_at", 2017-05-24 20:03:22 UTC]]  (0.0ms) RELEASE SAVEPOINT active_record_1  (0.0ms) SAVEPOINT active_record_1 SQL (0.2ms) INSERT INTO "products" ("sku", "title", "price", "active", "description", "created_at", "updated_at") VALUES (?, ?, ?, ?, ?, ?, ?) [["sku", "001"], ["title", "Smartphone"], ["price", 0.45e3], ["active", true], ["description", "Smartphone ABC"], ["created_at", 2017-05-24 20:03:22 UTC], ["updated_at", 2017-05-24 20:03:22 UTC]] Audited::Audit Load (0.2ms) SELECT "audits".* FROM "audits" WHERE "audits"."auditable_id" = ? AND "audits"."auditable_type" = ? ORDER BY "audits"."version" DESC LIMIT ? [["auditable_id", 1], ["auditable_type", "Product"], ["LIMIT", 1]] SQL (0.2ms) INSERT INTO "audits" ("auditable_id", "auditable_type", "user_id", "user_type", "action", "audited_changes", "version", "request_uuid", "created_at") VALUES (?, ?, ?, ?, ?, ?, ?, ?, ?) [["auditable_id", 1], ["auditable_type", "Product"], ["user_id", 1], ["user_type", "User"], ["action", "create"], ["audited_changes", "---\nsku: '001'\ntitle: Smartphone\nprice: !ruby/object:BigDecimal 18:0.45e3\nactive: true\ndescription: Smartphone ABC\n"], ["version", 1], ["request_uuid", "7aae40ec-d30a-4ad4-b151-a84c48b30350"], ["created_at", 2017-05-24 20:03:22 UTC]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Started GET "/products/1" for 127.0.0.1 at 2017-05-24 17:03:22 -0300 Processing by ProductsController#show as HTML Parameters: {"id"=>"1"} Product Load (0.1ms) SELECT "products".* FROM "products" WHERE "products"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendering products/show.html.erb within layouts/application Audited::Audit Load (0.2ms) SELECT "audits".* FROM "audits" WHERE "audits"."auditable_id" = ? AND "audits"."auditable_type" = ? AND "audits"."action" = ? ORDER BY "audits"."version" ASC LIMIT ? [["auditable_id", 1], ["auditable_type", "Product"], ["action", "create"], ["LIMIT", 1]] User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendered /home/douglas/code/audited_views/app/views/application/_controls.html.erb (6.9ms) Rendered products/show.html.erb within layouts/application (16.6ms) Completed 200 OK in 166ms (Views: 162.9ms | ActiveRecord: 0.4ms) Started GET "/products/1?show_log=true" for 127.0.0.1 at 2017-05-24 17:03:22 -0300 Processing by ProductsController#show as HTML Parameters: {"show_log"=>"true", "id"=>"1"} Product Load (0.1ms) SELECT "products".* FROM "products" WHERE "products"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendering products/show.html.erb within layouts/application Audited::Audit Load (0.2ms) SELECT "audits".* FROM "audits" WHERE "audits"."auditable_id" = ? AND "audits"."auditable_type" = ? AND "audits"."action" = ? ORDER BY "audits"."version" ASC LIMIT ? [["auditable_id", 1], ["auditable_type", "Product"], ["action", "create"], ["LIMIT", 1]] User Load (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Audited::Audit Load (0.1ms) SELECT "audits".* FROM "audits" WHERE "audits"."auditable_id" = ? AND "audits"."auditable_type" = ? ORDER BY "audits"."version" ASC [["auditable_id", 1], ["auditable_type", "Product"]] CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Product Load (0.0ms) SELECT "products".* FROM "products" WHERE "products"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendered /home/douglas/code/audited_views/app/views/application/_audit_record.html.erb (4.0ms) Rendered /home/douglas/code/audited_views/app/views/application/_audits.html.erb (5.9ms) Rendered /home/douglas/code/audited_views/app/views/application/_controls.html.erb (9.6ms) Rendered products/show.html.erb within layouts/application (11.0ms) Completed 200 OK in 14ms (Views: 12.4ms | ActiveRecord: 0.5ms)  (0.1ms) rollback transaction  (0.0ms) begin transaction  (0.0ms) SAVEPOINT active_record_1 SQL (0.2ms) INSERT INTO "users" ("email", "created_at", "updated_at") VALUES (?, ?, ?) [["email", "user@domain.com"], ["created_at", 2017-05-24 20:03:22 UTC], ["updated_at", 2017-05-24 20:03:22 UTC]]  (0.0ms) RELEASE SAVEPOINT active_record_1  (0.0ms) SAVEPOINT active_record_1 SQL (0.2ms) INSERT INTO "products" ("sku", "title", "price", "active", "description", "created_at", "updated_at") VALUES (?, ?, ?, ?, ?, ?, ?) [["sku", "001"], ["title", "Smartphone"], ["price", 0.45e3], ["active", true], ["description", "Smartphone ABC"], ["created_at", 2017-05-24 20:03:22 UTC], ["updated_at", 2017-05-24 20:03:22 UTC]] Audited::Audit Load (0.1ms) SELECT "audits".* FROM "audits" WHERE "audits"."auditable_id" = ? AND "audits"."auditable_type" = ? ORDER BY "audits"."version" DESC LIMIT ? [["auditable_id", 1], ["auditable_type", "Product"], ["LIMIT", 1]] SQL (0.2ms) INSERT INTO "audits" ("auditable_id", "auditable_type", "user_id", "user_type", "action", "audited_changes", "version", "request_uuid", "created_at") VALUES (?, ?, ?, ?, ?, ?, ?, ?, ?) [["auditable_id", 1], ["auditable_type", "Product"], ["user_id", 1], ["user_type", "User"], ["action", "create"], ["audited_changes", "---\nsku: '001'\ntitle: Smartphone\nprice: !ruby/object:BigDecimal 18:0.45e3\nactive: true\ndescription: Smartphone ABC\n"], ["version", 1], ["request_uuid", "c95ed066-e4d5-41b7-8071-35a6f7fe68e7"], ["created_at", 2017-05-24 20:03:22 UTC]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Started GET "/products/1" for 127.0.0.1 at 2017-05-24 17:03:22 -0300 Processing by ProductsController#show as HTML Parameters: {"id"=>"1"} Product Load (0.0ms) SELECT "products".* FROM "products" WHERE "products"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendering products/show.html.erb within layouts/application Audited::Audit Load (0.2ms) SELECT "audits".* FROM "audits" WHERE "audits"."auditable_id" = ? AND "audits"."auditable_type" = ? AND "audits"."action" = ? ORDER BY "audits"."version" ASC LIMIT ? [["auditable_id", 1], ["auditable_type", "Product"], ["action", "create"], ["LIMIT", 1]] User Load (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendered /home/douglas/code/audited_views/app/views/application/_controls.html.erb (3.3ms) Rendered products/show.html.erb within layouts/application (4.9ms) Completed 200 OK in 8ms (Views: 6.4ms | ActiveRecord: 0.3ms)  (0.1ms) rollback transaction ActiveRecord::SchemaMigration Load (0.1ms) SELECT "schema_migrations".* FROM "schema_migrations"  (0.1ms) SELECT "ar_internal_metadata"."value" FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = ? [["key", :environment]] ActiveRecord::SchemaMigration Load (0.0ms) SELECT "schema_migrations".* FROM "schema_migrations"  (0.0ms) SELECT "ar_internal_metadata"."value" FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = ? [["key", :environment]] ActiveRecord::SchemaMigration Load (0.0ms) SELECT "schema_migrations".* FROM "schema_migrations"  (0.1ms) SELECT "ar_internal_metadata"."value" FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = ? [["key", :environment]]  (30.7ms) CREATE TABLE "audits" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "auditable_id" integer, "auditable_type" varchar, "associated_id" integer, "associated_type" varchar, "user_id" integer, "user_type" varchar, "username" varchar, "action" varchar, "audited_changes" text, "version" integer DEFAULT 0, "comment" varchar, "remote_address" varchar, "request_uuid" varchar, "created_at" datetime)  (0.1ms) select sqlite_version(*)  (12.3ms) CREATE INDEX "associated_index" ON "audits" ("associated_id", "associated_type")  (0.1ms)  SELECT sql FROM sqlite_master WHERE name='associated_index' AND type='index' UNION ALL SELECT sql FROM sqlite_temp_master WHERE name='associated_index' AND type='index'   (12.9ms) CREATE INDEX "auditable_index" ON "audits" ("auditable_id", "auditable_type")  (0.1ms)  SELECT sql FROM sqlite_master WHERE name='auditable_index' AND type='index' UNION ALL SELECT sql FROM sqlite_temp_master WHERE name='auditable_index' AND type='index'   (0.1ms)  SELECT sql FROM sqlite_master WHERE name='associated_index' AND type='index' UNION ALL SELECT sql FROM sqlite_temp_master WHERE name='associated_index' AND type='index'   (12.7ms) CREATE INDEX "index_audits_on_created_at" ON "audits" ("created_at")  (0.1ms)  SELECT sql FROM sqlite_master WHERE name='index_audits_on_created_at' AND type='index' UNION ALL SELECT sql FROM sqlite_temp_master WHERE name='index_audits_on_created_at' AND type='index'   (0.1ms)  SELECT sql FROM sqlite_master WHERE name='auditable_index' AND type='index' UNION ALL SELECT sql FROM sqlite_temp_master WHERE name='auditable_index' AND type='index'   (0.1ms)  SELECT sql FROM sqlite_master WHERE name='associated_index' AND type='index' UNION ALL SELECT sql FROM sqlite_temp_master WHERE name='associated_index' AND type='index'   (15.7ms) CREATE INDEX "index_audits_on_request_uuid" ON "audits" ("request_uuid")  (0.1ms)  SELECT sql FROM sqlite_master WHERE name='index_audits_on_request_uuid' AND type='index' UNION ALL SELECT sql FROM sqlite_temp_master WHERE name='index_audits_on_request_uuid' AND type='index'   (0.1ms)  SELECT sql FROM sqlite_master WHERE name='index_audits_on_created_at' AND type='index' UNION ALL SELECT sql FROM sqlite_temp_master WHERE name='index_audits_on_created_at' AND type='index'   (0.1ms)  SELECT sql FROM sqlite_master WHERE name='auditable_index' AND type='index' UNION ALL SELECT sql FROM sqlite_temp_master WHERE name='auditable_index' AND type='index'   (0.1ms)  SELECT sql FROM sqlite_master WHERE name='associated_index' AND type='index' UNION ALL SELECT sql FROM sqlite_temp_master WHERE name='associated_index' AND type='index'   (13.6ms) CREATE INDEX "user_index" ON "audits" ("user_id", "user_type")  (12.8ms) CREATE TABLE "products" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "sku" varchar, "title" varchar, "price" decimal, "active" boolean, "description" text, "created_at" datetime NOT NULL, "updated_at" datetime NOT NULL)  (12.9ms) CREATE TABLE "users" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "name" varchar, "email" varchar, "created_at" datetime NOT NULL, "updated_at" datetime NOT NULL)  (14.6ms) CREATE TABLE "schema_migrations" ("version" varchar NOT NULL PRIMARY KEY)  (0.1ms) SELECT version FROM "schema_migrations"  (14.2ms) INSERT INTO "schema_migrations" (version) VALUES (20170507191539)  (12.9ms) INSERT INTO "schema_migrations" (version) VALUES (20170507023018), (20170507023113);   (19.3ms) CREATE TABLE "ar_internal_metadata" ("key" varchar NOT NULL PRIMARY KEY, "value" varchar, "created_at" datetime NOT NULL, "updated_at" datetime NOT NULL) ActiveRecord::InternalMetadata Load (0.1ms) SELECT "ar_internal_metadata".* FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = ? LIMIT ? [["key", :environment], ["LIMIT", 1]]  (0.1ms) begin transaction SQL (0.2ms) INSERT INTO "ar_internal_metadata" ("key", "value", "created_at", "updated_at") VALUES (?, ?, ?, ?) [["key", "environment"], ["value", "test"], ["created_at", 2017-05-24 20:04:17 UTC], ["updated_at", 2017-05-24 20:04:17 UTC]]  (12.7ms) commit transaction ActiveRecord::InternalMetadata Load (0.0ms) SELECT "ar_internal_metadata".* FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = ? LIMIT ? [["key", :environment], ["LIMIT", 1]]  (0.0ms) begin transaction  (0.0ms) commit transaction  (0.2ms) begin transaction  (0.0ms) SAVEPOINT active_record_1 SQL (0.2ms) INSERT INTO "users" ("email", "created_at", "updated_at") VALUES (?, ?, ?) [["email", "user@domain.com"], ["created_at", 2017-05-24 20:04:19 UTC], ["updated_at", 2017-05-24 20:04:19 UTC]]  (0.0ms) RELEASE SAVEPOINT active_record_1  (0.1ms) SAVEPOINT active_record_1 SQL (0.2ms) INSERT INTO "products" ("sku", "title", "price", "active", "description", "created_at", "updated_at") VALUES (?, ?, ?, ?, ?, ?, ?) [["sku", "001"], ["title", "Smartphone"], ["price", 0.45e3], ["active", true], ["description", "Smartphone ABC"], ["created_at", 2017-05-24 20:04:19 UTC], ["updated_at", 2017-05-24 20:04:19 UTC]] Audited::Audit Load (0.2ms) SELECT "audits".* FROM "audits" WHERE "audits"."auditable_id" = ? AND "audits"."auditable_type" = ? ORDER BY "audits"."version" DESC LIMIT ? [["auditable_id", 1], ["auditable_type", "Product"], ["LIMIT", 1]] SQL (0.2ms) INSERT INTO "audits" ("auditable_id", "auditable_type", "user_id", "user_type", "action", "audited_changes", "version", "request_uuid", "created_at") VALUES (?, ?, ?, ?, ?, ?, ?, ?, ?) [["auditable_id", 1], ["auditable_type", "Product"], ["user_id", 1], ["user_type", "User"], ["action", "create"], ["audited_changes", "---\nsku: '001'\ntitle: Smartphone\nprice: !ruby/object:BigDecimal 18:0.45e3\nactive: true\ndescription: Smartphone ABC\n"], ["version", 1], ["request_uuid", "5716d7cd-b3ca-4550-9a8b-60a52e558034"], ["created_at", 2017-05-24 20:04:19 UTC]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Started GET "/products/1" for 127.0.0.1 at 2017-05-24 17:04:19 -0300 Processing by ProductsController#show as HTML Parameters: {"id"=>"1"} Product Load (0.1ms) SELECT "products".* FROM "products" WHERE "products"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendering products/show.html.erb within layouts/application Audited::Audit Load (0.2ms) SELECT "audits".* FROM "audits" WHERE "audits"."auditable_id" = ? AND "audits"."auditable_type" = ? AND "audits"."action" = ? ORDER BY "audits"."version" ASC LIMIT ? [["auditable_id", 1], ["auditable_type", "Product"], ["action", "create"], ["LIMIT", 1]] User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendered /home/douglas/code/audited_views/app/views/application/_controls.html.erb (6.8ms) Rendered products/show.html.erb within layouts/application (16.9ms) Completed 200 OK in 152ms (Views: 149.6ms | ActiveRecord: 0.4ms) Started GET "/products/1?show_log=true" for 127.0.0.1 at 2017-05-24 17:04:19 -0300 Processing by ProductsController#show as HTML Parameters: {"show_log"=>"true", "id"=>"1"} Product Load (0.1ms) SELECT "products".* FROM "products" WHERE "products"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendering products/show.html.erb within layouts/application Audited::Audit Load (0.2ms) SELECT "audits".* FROM "audits" WHERE "audits"."auditable_id" = ? AND "audits"."auditable_type" = ? AND "audits"."action" = ? ORDER BY "audits"."version" ASC LIMIT ? [["auditable_id", 1], ["auditable_type", "Product"], ["action", "create"], ["LIMIT", 1]] User Load (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Audited::Audit Load (0.1ms) SELECT "audits".* FROM "audits" WHERE "audits"."auditable_id" = ? AND "audits"."auditable_type" = ? ORDER BY "audits"."version" ASC [["auditable_id", 1], ["auditable_type", "Product"]] CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Product Load (0.0ms) SELECT "products".* FROM "products" WHERE "products"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendered /home/douglas/code/audited_views/app/views/application/_audit_record.html.erb (4.0ms) Rendered /home/douglas/code/audited_views/app/views/application/_audits.html.erb (5.9ms) Rendered /home/douglas/code/audited_views/app/views/application/_controls.html.erb (9.9ms) Rendered products/show.html.erb within layouts/application (11.5ms) Completed 200 OK in 14ms (Views: 12.8ms | ActiveRecord: 0.5ms)  (0.1ms) rollback transaction  (0.0ms) begin transaction  (0.0ms) SAVEPOINT active_record_1 SQL (0.2ms) INSERT INTO "users" ("email", "created_at", "updated_at") VALUES (?, ?, ?) [["email", "user@domain.com"], ["created_at", 2017-05-24 20:04:19 UTC], ["updated_at", 2017-05-24 20:04:19 UTC]]  (0.0ms) RELEASE SAVEPOINT active_record_1  (0.1ms) SAVEPOINT active_record_1 SQL (0.2ms) INSERT INTO "products" ("sku", "title", "price", "active", "description", "created_at", "updated_at") VALUES (?, ?, ?, ?, ?, ?, ?) [["sku", "001"], ["title", "Smartphone"], ["price", 0.45e3], ["active", true], ["description", "Smartphone ABC"], ["created_at", 2017-05-24 20:04:19 UTC], ["updated_at", 2017-05-24 20:04:19 UTC]] Audited::Audit Load (0.1ms) SELECT "audits".* FROM "audits" WHERE "audits"."auditable_id" = ? AND "audits"."auditable_type" = ? ORDER BY "audits"."version" DESC LIMIT ? [["auditable_id", 1], ["auditable_type", "Product"], ["LIMIT", 1]] SQL (0.2ms) INSERT INTO "audits" ("auditable_id", "auditable_type", "user_id", "user_type", "action", "audited_changes", "version", "request_uuid", "created_at") VALUES (?, ?, ?, ?, ?, ?, ?, ?, ?) [["auditable_id", 1], ["auditable_type", "Product"], ["user_id", 1], ["user_type", "User"], ["action", "create"], ["audited_changes", "---\nsku: '001'\ntitle: Smartphone\nprice: !ruby/object:BigDecimal 18:0.45e3\nactive: true\ndescription: Smartphone ABC\n"], ["version", 1], ["request_uuid", "d479c820-e51e-42a6-ad03-93634030a648"], ["created_at", 2017-05-24 20:04:19 UTC]]  (0.2ms) RELEASE SAVEPOINT active_record_1 Started GET "/products/1" for 127.0.0.1 at 2017-05-24 17:04:19 -0300 Processing by ProductsController#show as HTML Parameters: {"id"=>"1"} Product Load (0.1ms) SELECT "products".* FROM "products" WHERE "products"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendering products/show.html.erb within layouts/application Audited::Audit Load (0.2ms) SELECT "audits".* FROM "audits" WHERE "audits"."auditable_id" = ? AND "audits"."auditable_type" = ? AND "audits"."action" = ? ORDER BY "audits"."version" ASC LIMIT ? [["auditable_id", 1], ["auditable_type", "Product"], ["action", "create"], ["LIMIT", 1]] User Load (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendered /home/douglas/code/audited_views/app/views/application/_controls.html.erb (3.4ms) Rendered products/show.html.erb within layouts/application (4.9ms) Completed 200 OK in 8ms (Views: 6.5ms | ActiveRecord: 0.3ms)  (0.1ms) rollback transaction