(0.1ms) DROP TABLE IF EXISTS "audits"  (0.2ms) SELECT sqlite_version(*)  (1.8ms) 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)  (1.4ms) CREATE INDEX "associated_index" ON "audits" ("associated_id", "associated_type")  (1.5ms) CREATE INDEX "auditable_index" ON "audits" ("auditable_id", "auditable_type")  (1.1ms) CREATE INDEX "index_audits_on_created_at" ON "audits" ("created_at")  (1.1ms) CREATE INDEX "index_audits_on_request_uuid" ON "audits" ("request_uuid")  (1.3ms) CREATE INDEX "user_index" ON "audits" ("user_id", "user_type")  (0.2ms) DROP TABLE IF EXISTS "products"  (1.2ms) 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)  (0.2ms) DROP TABLE IF EXISTS "users"  (1.2ms) CREATE TABLE "users" ("id" integer PRIMARY KEY AUTOINCREMENT NOT NULL, "name" varchar, "email" varchar, "created_at" datetime NOT NULL, "updated_at" datetime NOT NULL)  (1.2ms) CREATE TABLE "schema_migrations" ("version" varchar NOT NULL PRIMARY KEY)  (0.1ms) SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC  (1.0ms) INSERT INTO "schema_migrations" (version) VALUES (20170507191539)  (0.9ms) INSERT INTO "schema_migrations" (version) VALUES (20170507023018), (20170507023113);   (1.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.3ms) begin transaction ActiveRecord::InternalMetadata Create (1.2ms) INSERT INTO "ar_internal_metadata" ("key", "value", "created_at", "updated_at") VALUES (?, ?, ?, ?) [["key", "environment"], ["value", "test"], ["created_at", "2018-11-02 02:33:21.760012"], ["updated_at", "2018-11-02 02:33:21.760012"]]  (1.4ms) commit transaction ActiveRecord::InternalMetadata Load (0.2ms) 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.1ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 User Create (0.6ms) INSERT INTO "users" ("email", "created_at", "updated_at") VALUES (?, ?, ?) [["email", "user@domain.com"], ["created_at", "2018-11-02 02:33:25.004094"], ["updated_at", "2018-11-02 02:33:25.004094"]]  (0.1ms) RELEASE SAVEPOINT active_record_1  (0.1ms) SAVEPOINT active_record_1 Product Create (0.3ms) INSERT INTO "products" ("sku", "title", "price", "active", "description", "created_at", "updated_at") VALUES (?, ?, ?, ?, ?, ?, ?) [["sku", "001"], ["title", "Smartphone"], ["price", 450.0], ["active", "t"], ["description", "Smartphone ABC"], ["created_at", "2018-11-02 02:33:25.030110"], ["updated_at", "2018-11-02 02:33:25.030110"]]  (0.3ms) SELECT MAX("audits"."version") FROM "audits" WHERE "audits"."auditable_id" = ? AND "audits"."auditable_type" = ? [["auditable_id", 1], ["auditable_type", "Product"]] Audited::Audit Create (0.6ms) 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", "1d43f5f3-6e68-42d8-b1fb-da4e4b58e02d"], ["created_at", "2018-11-02 02:33:25.072335"]]  (0.2ms) RELEASE SAVEPOINT active_record_1 Started GET "/products/1" for 127.0.0.1 at 2018-11-01 23:33:25 -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 /Users/douglas.lise/code/douglas/audited_views/app/views/application/_controls.html.erb (10.9ms) Rendered products/show.html.erb within layouts/application (21.8ms) Completed 200 OK in 243ms (Views: 238.3ms | ActiveRecord: 0.6ms) Started GET "/products/1?show_log=true" for 127.0.0.1 at 2018-11-01 23:33:25 -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 User Load (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 /Users/douglas.lise/code/douglas/audited_views/app/views/application/_audit_record.html.erb (5.6ms) Rendered /Users/douglas.lise/code/douglas/audited_views/app/views/application/_audits.html.erb (13.2ms) Rendered /Users/douglas.lise/code/douglas/audited_views/app/views/application/_controls.html.erb (21.5ms) Rendered products/show.html.erb within layouts/application (22.0ms) Completed 200 OK in 24ms (Views: 22.4ms | ActiveRecord: 0.7ms)  (0.5ms) rollback transaction  (0.1ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 User Create (0.3ms) INSERT INTO "users" ("email", "created_at", "updated_at") VALUES (?, ?, ?) [["email", "user@domain.com"], ["created_at", "2018-11-02 02:33:25.370446"], ["updated_at", "2018-11-02 02:33:25.370446"]]  (0.0ms) RELEASE SAVEPOINT active_record_1  (0.0ms) SAVEPOINT active_record_1 Product Create (0.1ms) INSERT INTO "products" ("sku", "title", "price", "active", "description", "created_at", "updated_at") VALUES (?, ?, ?, ?, ?, ?, ?) [["sku", "001"], ["title", "Smartphone"], ["price", 450.0], ["active", "t"], ["description", "Smartphone ABC"], ["created_at", "2018-11-02 02:33:25.371857"], ["updated_at", "2018-11-02 02:33:25.371857"]]  (0.1ms) SELECT MAX("audits"."version") FROM "audits" WHERE "audits"."auditable_id" = ? AND "audits"."auditable_type" = ? [["auditable_id", 1], ["auditable_type", "Product"]] Audited::Audit Create (0.6ms) 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", "8a79d021-e6f8-4801-81ff-eae8b8b20fa4"], ["created_at", "2018-11-02 02:33:25.374072"]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Started GET "/products/1" for 127.0.0.1 at 2018-11-01 23:33:25 -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.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT ? [["id", 1], ["LIMIT", 1]] Rendered /Users/douglas.lise/code/douglas/audited_views/app/views/application/_controls.html.erb (2.2ms) Rendered products/show.html.erb within layouts/application (2.6ms) Completed 200 OK in 4ms (Views: 3.4ms | ActiveRecord: 0.4ms)  (0.6ms) rollback transaction