(0.1ms)  DROP TABLE IF EXISTS "audits"
   (0.1ms)  SELECT sqlite_version(*)
   (133.0ms)  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)
   (36.3ms)  CREATE  INDEX "associated_index" ON "audits" ("associated_id", "associated_type")
   (24.8ms)  CREATE  INDEX "auditable_index" ON "audits" ("auditable_id", "auditable_type")
   (84.6ms)  CREATE  INDEX "index_audits_on_created_at" ON "audits" ("created_at")
   (80.4ms)  CREATE  INDEX "index_audits_on_request_uuid" ON "audits" ("request_uuid")
   (24.8ms)  CREATE  INDEX "user_index" ON "audits" ("user_id", "user_type")
   (0.1ms)  DROP TABLE IF EXISTS "products"
   (28.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)
   (0.1ms)  DROP TABLE IF EXISTS "users"
   (21.7ms)  CREATE TABLE "users" ("id" integer PRIMARY KEY AUTOINCREMENT NOT NULL, "name" varchar, "email" varchar, "created_at" datetime NOT NULL, "updated_at" datetime NOT NULL)
   (19.6ms)  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
   (12.4ms)  INSERT INTO "schema_migrations" (version) VALUES (20170507191539)
   (11.6ms)  INSERT INTO "schema_migrations" (version) VALUES
(20170507023018),
(20170507023113);


   (15.6ms)  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.0ms)  begin transaction
  ActiveRecord::InternalMetadata Create (0.2ms)  INSERT INTO "ar_internal_metadata" ("key", "value", "created_at", "updated_at") VALUES (?, ?, ?, ?)  [["key", "environment"], ["value", "test"], ["created_at", "2018-11-15 16:51:07.723358"], ["updated_at", "2018-11-15 16:51:07.723358"]]
   (11.8ms)  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.0ms)  begin transaction
   (0.0ms)  SAVEPOINT active_record_1
  User Create (0.2ms)  INSERT INTO "users" ("email", "created_at", "updated_at") VALUES (?, ?, ?)  [["email", "user@domain.com"], ["created_at", "2018-11-15 16:51:09.720596"], ["updated_at", "2018-11-15 16:51:09.720596"]]
   (0.1ms)  RELEASE SAVEPOINT active_record_1
   (0.1ms)  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-15 16:51:09.733874"], ["updated_at", "2018-11-15 16:51:09.733874"]]
   (0.2ms)  SELECT MAX("audits"."version") FROM "audits" WHERE "audits"."auditable_id" = ? AND "audits"."auditable_type" = ?  [["auditable_id", 1], ["auditable_type", "Product"]]
  Audited::Audit Create (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", "0c657f02-998f-4dc3-ae08-88083a1de25a"], ["created_at", "2018-11-15 16:51:09.758284"]]
   (0.1ms)  RELEASE SAVEPOINT active_record_1
Started GET "/products/1" for 127.0.0.1 at 2018-11-15 14:51:09 -0200
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 (50.7ms)
  Rendered products/show.html.erb within layouts/application (56.4ms)
Completed 200 OK in 186ms (Views: 183.0ms | ActiveRecord: 0.5ms)
   (0.1ms)  rollback transaction
   (0.0ms)  begin transaction
   (0.0ms)  SAVEPOINT active_record_1
  User Create (0.1ms)  INSERT INTO "users" ("email", "created_at", "updated_at") VALUES (?, ?, ?)  [["email", "user@domain.com"], ["created_at", "2018-11-15 16:51:09.963703"], ["updated_at", "2018-11-15 16:51:09.963703"]]
   (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-15 16:51:09.964744"], ["updated_at", "2018-11-15 16:51:09.964744"]]
   (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.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", "f294e080-c136-4d5e-b434-3d7027740958"], ["created_at", "2018-11-15 16:51:09.966485"]]
   (0.0ms)  RELEASE SAVEPOINT active_record_1
Started GET "/products/1" for 127.0.0.1 at 2018-11-15 14:51:09 -0200
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 (1.9ms)
  Rendered products/show.html.erb within layouts/application (2.3ms)
Completed 200 OK in 4ms (Views: 2.9ms | ActiveRecord: 0.3ms)
Started GET "/products/1?show_log=true" for 127.0.0.1 at 2018-11-15 14:51:09 -0200
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 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 /home/douglas/code/audited_views/app/views/application/_audit_record.html.erb (3.4ms)
  Rendered /home/douglas/code/audited_views/app/views/application/_audits.html.erb (5.2ms)
  Rendered /home/douglas/code/audited_views/app/views/application/_controls.html.erb (7.9ms)
  Rendered products/show.html.erb within layouts/application (8.3ms)
Completed 200 OK in 10ms (Views: 8.7ms | ActiveRecord: 0.5ms)
   (0.1ms)  rollback transaction