Started GET "/" for 127.0.0.1 at 2018-07-03 14:12:21 +0300
Processing by Rails::WelcomeController#index as HTML
  Rendering /home/alex/.rvm/gems/ruby-2.5.0/gems/railties-5.2.0/lib/rails/templates/rails/welcome/index.html.erb
  Rendered /home/alex/.rvm/gems/ruby-2.5.0/gems/railties-5.2.0/lib/rails/templates/rails/welcome/index.html.erb (1.5ms)
Completed 200 OK in 4ms (Views: 3.4ms | ActiveRecord: 0.0ms)


Started GET "/" for 127.0.0.1 at 2018-07-03 17:28:55 +0300
Processing by Rails::WelcomeController#index as HTML
  Rendering /home/alex/.rvm/gems/ruby-2.5.0/gems/railties-5.2.0/lib/rails/templates/rails/welcome/index.html.erb
  Rendered /home/alex/.rvm/gems/ruby-2.5.0/gems/railties-5.2.0/lib/rails/templates/rails/welcome/index.html.erb (1.7ms)
Completed 200 OK in 7ms (Views: 6.1ms | ActiveRecord: 0.0ms)


Started GET "/api/v1/users/me/subscriptions/recent" for 127.0.0.1 at 2018-07-03 17:29:00 +0300
  
ActionController::RoutingError (No route matches [GET] "/api/v1/users/me/subscriptions/recent"):
  
actionpack (5.2.0) lib/action_dispatch/middleware/debug_exceptions.rb:65:in `call'
actionpack (5.2.0) lib/action_dispatch/middleware/show_exceptions.rb:33:in `call'
railties (5.2.0) lib/rails/rack/logger.rb:38:in `call_app'
railties (5.2.0) lib/rails/rack/logger.rb:26:in `block in call'
activesupport (5.2.0) lib/active_support/tagged_logging.rb:71:in `block in tagged'
activesupport (5.2.0) lib/active_support/tagged_logging.rb:28:in `tagged'
activesupport (5.2.0) lib/active_support/tagged_logging.rb:71:in `tagged'
railties (5.2.0) lib/rails/rack/logger.rb:26:in `call'
sprockets-rails (3.2.1) lib/sprockets/rails/quiet_assets.rb:13:in `call'
actionpack (5.2.0) lib/action_dispatch/middleware/remote_ip.rb:81:in `call'
actionpack (5.2.0) lib/action_dispatch/middleware/request_id.rb:27:in `call'
rack (2.0.5) lib/rack/method_override.rb:22:in `call'
rack (2.0.5) lib/rack/runtime.rb:22:in `call'
activesupport (5.2.0) lib/active_support/cache/strategy/local_cache_middleware.rb:29:in `call'
actionpack (5.2.0) lib/action_dispatch/middleware/executor.rb:14:in `call'
actionpack (5.2.0) lib/action_dispatch/middleware/static.rb:127:in `call'
rack (2.0.5) lib/rack/sendfile.rb:111:in `call'
railties (5.2.0) lib/rails/engine.rb:524:in `call'
rack (2.0.5) lib/rack/handler/webrick.rb:86:in `service'
/usr/share/rvm/rubies/ruby-2.5.0/lib/ruby/2.5.0/webrick/httpserver.rb:140:in `service'
/usr/share/rvm/rubies/ruby-2.5.0/lib/ruby/2.5.0/webrick/httpserver.rb:96:in `run'
/usr/share/rvm/rubies/ruby-2.5.0/lib/ruby/2.5.0/webrick/server.rb:307:in `block in start_thread'
   (0.1ms)  SELECT sqlite_version(*)
  ↳ bin/rails:4
   (105.3ms)  CREATE TABLE "schema_migrations" ("version" varchar NOT NULL PRIMARY KEY)
  ↳ bin/rails:4
   (64.9ms)  CREATE TABLE "ar_internal_metadata" ("key" varchar NOT NULL PRIMARY KEY, "value" varchar, "created_at" datetime NOT NULL, "updated_at" datetime NOT NULL)
  ↳ bin/rails:4
  ActiveRecord::InternalMetadata Load (0.5ms)  SELECT  "ar_internal_metadata".* FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = ? LIMIT ?  [["key", "environment"], ["LIMIT", 1]]
  ↳ bin/rails:4
   (0.1ms)  begin transaction
  ↳ bin/rails:4
  ActiveRecord::InternalMetadata Create (0.5ms)  INSERT INTO "ar_internal_metadata" ("key", "value", "created_at", "updated_at") VALUES (?, ?, ?, ?)  [["key", "environment"], ["value", "development"], ["created_at", "2018-07-03 14:49:47.881238"], ["updated_at", "2018-07-03 14:49:47.881238"]]
  ↳ bin/rails:4
   (49.6ms)  commit transaction
  ↳ bin/rails:4
   (0.3ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:4
   (0.1ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
Migrating to CreateApiUserAuthAuthUsers (20180703111608)
   (0.0ms)  begin transaction
  ↳ bin/rails:25
   (0.1ms)  SELECT sqlite_version(*)
  ↳ /home/alex/bit_forge/api_user_auth/db/migrate/20180703111608_create_api_user_auth_auth_users.rb:3
   (0.2ms)  CREATE TABLE "api_user_auth_auth_users" ("id" integer PRIMARY KEY AUTOINCREMENT NOT NULL, "created_at" datetime NOT NULL, "updated_at" datetime NOT NULL)
  ↳ /home/alex/bit_forge/api_user_auth/db/migrate/20180703111608_create_api_user_auth_auth_users.rb:3
  ActiveRecord::SchemaMigration Create (0.1ms)  INSERT INTO "schema_migrations" ("version") VALUES (?)  [["version", "20180703111608"]]
  ↳ bin/rails:25
   (45.5ms)  commit transaction
  ↳ bin/rails:25
  ActiveRecord::InternalMetadata Load (0.1ms)  SELECT  "ar_internal_metadata".* FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = ? LIMIT ?  [["key", "environment"], ["LIMIT", 1]]
  ↳ bin/rails:25
   (0.1ms)  begin transaction
  ↳ bin/rails:25
   (0.1ms)  commit transaction
  ↳ bin/rails:25
   (0.1ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
   (0.1ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ /home/alex/.rvm/gems/ruby-2.5.0/bin/rake:23
  ActiveRecord::InternalMetadata Load (0.1ms)  SELECT  "ar_internal_metadata".* FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = ? LIMIT ?  [["key", "environment"], ["LIMIT", 1]]
  ↳ /home/alex/.rvm/gems/ruby-2.5.0/bin/rake:23
   (0.0ms)  begin transaction
  ↳ /home/alex/.rvm/gems/ruby-2.5.0/bin/rake:23
   (0.0ms)  commit transaction
  ↳ /home/alex/.rvm/gems/ruby-2.5.0/bin/rake:23
   (0.0ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ /home/alex/.rvm/gems/ruby-2.5.0/bin/rake:23
   (0.1ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ /home/alex/.rvm/gems/ruby-2.5.0/bin/rake:23
   (0.1ms)  SELECT "ar_internal_metadata"."value" FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = ?  [["key", "environment"]]
  ↳ /home/alex/.rvm/gems/ruby-2.5.0/bin/rake:23
   (0.0ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ /home/alex/.rvm/gems/ruby-2.5.0/bin/rake:23
   (0.0ms)  SELECT "ar_internal_metadata"."value" FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = ?  [["key", "environment"]]
  ↳ /home/alex/.rvm/gems/ruby-2.5.0/bin/rake:23
   (0.0ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ /home/alex/.rvm/gems/ruby-2.5.0/bin/rake:23
   (0.0ms)  SELECT "ar_internal_metadata"."value" FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = ?  [["key", "environment"]]
  ↳ /home/alex/.rvm/gems/ruby-2.5.0/bin/rake:23
   (0.1ms)  DROP TABLE IF EXISTS "api_user_auth_auth_users"
  ↳ db/schema.rb:15
   (0.0ms)  SELECT sqlite_version(*)
  ↳ db/schema.rb:15
   (76.2ms)  CREATE TABLE "api_user_auth_auth_users" ("id" integer PRIMARY KEY AUTOINCREMENT NOT NULL, "created_at" datetime NOT NULL, "updated_at" datetime NOT NULL)
  ↳ db/schema.rb:15
   (35.5ms)  CREATE TABLE "schema_migrations" ("version" varchar NOT NULL PRIMARY KEY)
  ↳ db/schema.rb:13
   (0.3ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ db/schema.rb:13
   (25.5ms)  INSERT INTO "schema_migrations" (version) VALUES (20180703111608)
  ↳ db/schema.rb:13
   (41.9ms)  CREATE TABLE "ar_internal_metadata" ("key" varchar NOT NULL PRIMARY KEY, "value" varchar, "created_at" datetime NOT NULL, "updated_at" datetime NOT NULL)
  ↳ db/schema.rb:13
  ActiveRecord::InternalMetadata Load (0.4ms)  SELECT  "ar_internal_metadata".* FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = ? LIMIT ?  [["key", "environment"], ["LIMIT", 1]]
  ↳ db/schema.rb:13
   (0.0ms)  begin transaction
  ↳ db/schema.rb:13
  ActiveRecord::InternalMetadata Create (0.1ms)  INSERT INTO "ar_internal_metadata" ("key", "value", "created_at", "updated_at") VALUES (?, ?, ?, ?)  [["key", "environment"], ["value", "development"], ["created_at", "2018-07-03 15:35:06.840797"], ["updated_at", "2018-07-03 15:35:06.840797"]]
  ↳ db/schema.rb:13
   (102.2ms)  commit transaction
  ↳ db/schema.rb:13
  ActiveRecord::InternalMetadata Load (0.2ms)  SELECT  "ar_internal_metadata".* FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = ? LIMIT ?  [["key", "environment"], ["LIMIT", 1]]
  ↳ /home/alex/.rvm/gems/ruby-2.5.0/bin/rake:23
   (0.1ms)  begin transaction
  ↳ /home/alex/.rvm/gems/ruby-2.5.0/bin/rake:23
  ActiveRecord::InternalMetadata Update (0.5ms)  UPDATE "ar_internal_metadata" SET "value" = ?, "updated_at" = ? WHERE "ar_internal_metadata"."key" = ?  [["value", "test"], ["updated_at", "2018-07-03 15:35:06.949127"], ["key", "environment"]]
  ↳ /home/alex/.rvm/gems/ruby-2.5.0/bin/rake:23
   (47.6ms)  commit transaction
  ↳ /home/alex/.rvm/gems/ruby-2.5.0/bin/rake:23
   (0.1ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
   (0.1ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
   (0.0ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
   (0.0ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
Migrating to CreateApiUserAuthAuthUsers (20180703111608)
   (0.1ms)  begin transaction
  ↳ bin/rails:25
   (0.3ms)  DROP TABLE "api_user_auth_auth_users"
  ↳ bin/rails:25
  ActiveRecord::SchemaMigration Destroy (0.3ms)  DELETE FROM "schema_migrations" WHERE "schema_migrations"."version" = ?  [["version", "20180703111608"]]
  ↳ bin/rails:25
   (41.5ms)  commit transaction
  ↳ bin/rails:25
   (0.3ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
   (0.1ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
Migrating to CreateApiUserAuthAuthUsers (20180703111608)
   (0.0ms)  begin transaction
  ↳ bin/rails:25
   (0.0ms)  rollback transaction
  ↳ bin/rails:25
   (1058.4ms)  CREATE DATABASE "dummy_dev" ENCODING = 'utf8'
  ↳ bin/rails:25
   (600.1ms)  CREATE DATABASE "dummy_test" ENCODING = 'utf8'
  ↳ bin/rails:25
   (69.9ms)  CREATE TABLE "schema_migrations" ("version" character varying NOT NULL PRIMARY KEY)
  ↳ bin/rails:25
   (67.7ms)  CREATE TABLE "ar_internal_metadata" ("key" character varying NOT NULL PRIMARY KEY, "value" character varying, "created_at" timestamp NOT NULL, "updated_at" timestamp NOT NULL)
  ↳ bin/rails:25
   (0.3ms)  SELECT pg_try_advisory_lock(7325747718710370390)
  ↳ bin/rails:25
   (0.3ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
Migrating to CreateApiUserAuthAuthUsers (20180703111608)
   (0.1ms)  BEGIN
  ↳ bin/rails:25
  SQL (0.2ms)  CREATE EXTENSION IF NOT EXISTS "pgcrypto"
  ↳ /home/alex/bit_forge/api_user_auth/db/migrate/20180703111608_create_api_user_auth_auth_users.rb:3
   (60.8ms)  CREATE TABLE "api_user_auth_auth_users" ("id" bigserial primary key, "email" character varying NOT NULL, "encrypted_password" character varying NOT NULL, "auth_tokens" uuid[] DEFAULT '{}', "created_at" timestamp NOT NULL, "updated_at" timestamp NOT NULL)
  ↳ /home/alex/bit_forge/api_user_auth/db/migrate/20180703111608_create_api_user_auth_auth_users.rb:5
   (52.5ms)  CREATE UNIQUE INDEX  "index_api_user_auth_auth_users_on_email" ON "api_user_auth_auth_users"  ("email")
  ↳ /home/alex/bit_forge/api_user_auth/db/migrate/20180703111608_create_api_user_auth_auth_users.rb:5
  ActiveRecord::SchemaMigration Create (0.9ms)  INSERT INTO "schema_migrations" ("version") VALUES ($1) RETURNING "version"  [["version", "20180703111608"]]
  ↳ bin/rails:25
   (37.1ms)  COMMIT
  ↳ bin/rails:25
  ActiveRecord::InternalMetadata Load (0.9ms)  SELECT  "ar_internal_metadata".* FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = $1 LIMIT $2  [["key", "environment"], ["LIMIT", 1]]
  ↳ bin/rails:25
   (0.2ms)  BEGIN
  ↳ bin/rails:25
  ActiveRecord::InternalMetadata Create (0.4ms)  INSERT INTO "ar_internal_metadata" ("key", "value", "created_at", "updated_at") VALUES ($1, $2, $3, $4) RETURNING "key"  [["key", "environment"], ["value", "development"], ["created_at", "2018-07-05 09:51:43.608383"], ["updated_at", "2018-07-05 09:51:43.608383"]]
  ↳ bin/rails:25
   (49.2ms)  COMMIT
  ↳ bin/rails:25
   (0.5ms)  SELECT pg_advisory_unlock(7325747718710370390)
  ↳ bin/rails:25
   (0.5ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
   (43.9ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
   (7.6ms)  SELECT "ar_internal_metadata"."value" FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = $1  [["key", "environment"]]
  ↳ bin/rails:25
   (0.6ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
   (0.5ms)  SELECT "ar_internal_metadata"."value" FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = $1  [["key", "environment"]]
  ↳ bin/rails:25
   (0.6ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
   (0.5ms)  SELECT "ar_internal_metadata"."value" FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = $1  [["key", "environment"]]
  ↳ bin/rails:25
   (317.8ms)  DROP DATABASE IF EXISTS "dummy_dev"
  ↳ bin/rails:25
   (277.4ms)  DROP DATABASE IF EXISTS "dummy_test"
  ↳ bin/rails:25
   (1146.4ms)  CREATE DATABASE "dummy_dev" ENCODING = 'utf8'
  ↳ bin/rails:25
   (560.1ms)  CREATE DATABASE "dummy_test" ENCODING = 'utf8'
  ↳ bin/rails:25
   (98.1ms)  CREATE TABLE "schema_migrations" ("version" character varying NOT NULL PRIMARY KEY)
  ↳ bin/rails:25
   (165.7ms)  CREATE TABLE "ar_internal_metadata" ("key" character varying NOT NULL PRIMARY KEY, "value" character varying, "created_at" timestamp NOT NULL, "updated_at" timestamp NOT NULL)
  ↳ bin/rails:25
   (0.5ms)  SELECT pg_try_advisory_lock(7325747718710370390)
  ↳ bin/rails:25
   (1.1ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
Migrating to CreateApiUserAuthAuthUsers (20180703111608)
   (0.4ms)  BEGIN
  ↳ bin/rails:25
  SQL (0.6ms)  CREATE EXTENSION IF NOT EXISTS "pgcrypto"
  ↳ /home/alex/bit_forge/api_user_auth/db/migrate/20180703111608_create_api_user_auth_auth_users.rb:3
   (46.3ms)  CREATE TABLE "api_user_auth_auth_users" ("id" bigserial primary key, "email" character varying NOT NULL, "encrypted_password" character varying NOT NULL, "code" character varying DEFAULT '', "auth_tokens" uuid[] DEFAULT '{}', "created_at" timestamp NOT NULL, "updated_at" timestamp NOT NULL)
  ↳ /home/alex/bit_forge/api_user_auth/db/migrate/20180703111608_create_api_user_auth_auth_users.rb:5
   (10.8ms)  CREATE UNIQUE INDEX  "index_api_user_auth_auth_users_on_email" ON "api_user_auth_auth_users"  ("email")
  ↳ /home/alex/bit_forge/api_user_auth/db/migrate/20180703111608_create_api_user_auth_auth_users.rb:5
  ActiveRecord::SchemaMigration Create (0.3ms)  INSERT INTO "schema_migrations" ("version") VALUES ($1) RETURNING "version"  [["version", "20180703111608"]]
  ↳ bin/rails:25
   (5.5ms)  COMMIT
  ↳ bin/rails:25
  ActiveRecord::InternalMetadata Load (0.4ms)  SELECT  "ar_internal_metadata".* FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = $1 LIMIT $2  [["key", "environment"], ["LIMIT", 1]]
  ↳ bin/rails:25
   (0.2ms)  BEGIN
  ↳ bin/rails:25
  ActiveRecord::InternalMetadata Create (0.4ms)  INSERT INTO "ar_internal_metadata" ("key", "value", "created_at", "updated_at") VALUES ($1, $2, $3, $4) RETURNING "key"  [["key", "environment"], ["value", "development"], ["created_at", "2018-07-09 07:14:46.792463"], ["updated_at", "2018-07-09 07:14:46.792463"]]
  ↳ bin/rails:25
   (36.4ms)  COMMIT
  ↳ bin/rails:25
   (0.6ms)  SELECT pg_advisory_unlock(7325747718710370390)
  ↳ bin/rails:25
   (0.6ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
Started PATCH "/api-user-auth/password" for 127.0.0.1 at 2018-07-09 14:30:31 +0300
  
ActionController::RoutingError (No route matches [PATCH] "/api-user-auth/password"):
  
actionpack (5.2.0) lib/action_dispatch/middleware/debug_exceptions.rb:65:in `call'
actionpack (5.2.0) lib/action_dispatch/middleware/show_exceptions.rb:33:in `call'
railties (5.2.0) lib/rails/rack/logger.rb:38:in `call_app'
railties (5.2.0) lib/rails/rack/logger.rb:26:in `block in call'
activesupport (5.2.0) lib/active_support/tagged_logging.rb:71:in `block in tagged'
activesupport (5.2.0) lib/active_support/tagged_logging.rb:28:in `tagged'
activesupport (5.2.0) lib/active_support/tagged_logging.rb:71:in `tagged'
railties (5.2.0) lib/rails/rack/logger.rb:26:in `call'
sprockets-rails (3.2.1) lib/sprockets/rails/quiet_assets.rb:13:in `call'
actionpack (5.2.0) lib/action_dispatch/middleware/remote_ip.rb:81:in `call'
actionpack (5.2.0) lib/action_dispatch/middleware/request_id.rb:27:in `call'
rack (2.0.5) lib/rack/method_override.rb:22:in `call'
rack (2.0.5) lib/rack/runtime.rb:22:in `call'
activesupport (5.2.0) lib/active_support/cache/strategy/local_cache_middleware.rb:29:in `call'
actionpack (5.2.0) lib/action_dispatch/middleware/executor.rb:14:in `call'
actionpack (5.2.0) lib/action_dispatch/middleware/static.rb:127:in `call'
rack (2.0.5) lib/rack/sendfile.rb:111:in `call'
railties (5.2.0) lib/rails/engine.rb:524:in `call'
rack (2.0.5) lib/rack/handler/webrick.rb:86:in `service'
/usr/share/rvm/rubies/ruby-2.5.0/lib/ruby/2.5.0/webrick/httpserver.rb:140:in `service'
/usr/share/rvm/rubies/ruby-2.5.0/lib/ruby/2.5.0/webrick/httpserver.rb:96:in `run'
/usr/share/rvm/rubies/ruby-2.5.0/lib/ruby/2.5.0/webrick/server.rb:307:in `block in start_thread'
Started PATCH "/auth/password" for 127.0.0.1 at 2018-07-09 14:31:05 +0300
  
ActionController::RoutingError (No route matches [PATCH] "/auth/password"):
  
actionpack (5.2.0) lib/action_dispatch/middleware/debug_exceptions.rb:65:in `call'
actionpack (5.2.0) lib/action_dispatch/middleware/show_exceptions.rb:33:in `call'
railties (5.2.0) lib/rails/rack/logger.rb:38:in `call_app'
railties (5.2.0) lib/rails/rack/logger.rb:26:in `block in call'
activesupport (5.2.0) lib/active_support/tagged_logging.rb:71:in `block in tagged'
activesupport (5.2.0) lib/active_support/tagged_logging.rb:28:in `tagged'
activesupport (5.2.0) lib/active_support/tagged_logging.rb:71:in `tagged'
railties (5.2.0) lib/rails/rack/logger.rb:26:in `call'
sprockets-rails (3.2.1) lib/sprockets/rails/quiet_assets.rb:13:in `call'
actionpack (5.2.0) lib/action_dispatch/middleware/remote_ip.rb:81:in `call'
actionpack (5.2.0) lib/action_dispatch/middleware/request_id.rb:27:in `call'
rack (2.0.5) lib/rack/method_override.rb:22:in `call'
rack (2.0.5) lib/rack/runtime.rb:22:in `call'
activesupport (5.2.0) lib/active_support/cache/strategy/local_cache_middleware.rb:29:in `call'
actionpack (5.2.0) lib/action_dispatch/middleware/executor.rb:14:in `call'
actionpack (5.2.0) lib/action_dispatch/middleware/static.rb:127:in `call'
rack (2.0.5) lib/rack/sendfile.rb:111:in `call'
railties (5.2.0) lib/rails/engine.rb:524:in `call'
rack (2.0.5) lib/rack/handler/webrick.rb:86:in `service'
/usr/share/rvm/rubies/ruby-2.5.0/lib/ruby/2.5.0/webrick/httpserver.rb:140:in `service'
/usr/share/rvm/rubies/ruby-2.5.0/lib/ruby/2.5.0/webrick/httpserver.rb:96:in `run'
/usr/share/rvm/rubies/ruby-2.5.0/lib/ruby/2.5.0/webrick/server.rb:307:in `block in start_thread'
Started PATCH "/auth/password" for 127.0.0.1 at 2018-07-09 14:31:25 +0300
  
ActionController::RoutingError (No route matches [PATCH] "/auth/password"):
  
actionpack (5.2.0) lib/action_dispatch/middleware/debug_exceptions.rb:65:in `call'
actionpack (5.2.0) lib/action_dispatch/middleware/show_exceptions.rb:33:in `call'
railties (5.2.0) lib/rails/rack/logger.rb:38:in `call_app'
railties (5.2.0) lib/rails/rack/logger.rb:26:in `block in call'
activesupport (5.2.0) lib/active_support/tagged_logging.rb:71:in `block in tagged'
activesupport (5.2.0) lib/active_support/tagged_logging.rb:28:in `tagged'
activesupport (5.2.0) lib/active_support/tagged_logging.rb:71:in `tagged'
railties (5.2.0) lib/rails/rack/logger.rb:26:in `call'
sprockets-rails (3.2.1) lib/sprockets/rails/quiet_assets.rb:13:in `call'
actionpack (5.2.0) lib/action_dispatch/middleware/remote_ip.rb:81:in `call'
actionpack (5.2.0) lib/action_dispatch/middleware/request_id.rb:27:in `call'
rack (2.0.5) lib/rack/method_override.rb:22:in `call'
rack (2.0.5) lib/rack/runtime.rb:22:in `call'
activesupport (5.2.0) lib/active_support/cache/strategy/local_cache_middleware.rb:29:in `call'
actionpack (5.2.0) lib/action_dispatch/middleware/executor.rb:14:in `call'
actionpack (5.2.0) lib/action_dispatch/middleware/static.rb:127:in `call'
rack (2.0.5) lib/rack/sendfile.rb:111:in `call'
railties (5.2.0) lib/rails/engine.rb:524:in `call'
rack (2.0.5) lib/rack/handler/webrick.rb:86:in `service'
/usr/share/rvm/rubies/ruby-2.5.0/lib/ruby/2.5.0/webrick/httpserver.rb:140:in `service'
/usr/share/rvm/rubies/ruby-2.5.0/lib/ruby/2.5.0/webrick/httpserver.rb:96:in `run'
/usr/share/rvm/rubies/ruby-2.5.0/lib/ruby/2.5.0/webrick/server.rb:307:in `block in start_thread'
Started PATCH "/auth/password" for 127.0.0.1 at 2018-07-09 14:31:50 +0300
  
ActionController::RoutingError (No route matches [PATCH] "/auth/password"):
  
actionpack (5.2.0) lib/action_dispatch/middleware/debug_exceptions.rb:65:in `call'
actionpack (5.2.0) lib/action_dispatch/middleware/show_exceptions.rb:33:in `call'
railties (5.2.0) lib/rails/rack/logger.rb:38:in `call_app'
railties (5.2.0) lib/rails/rack/logger.rb:26:in `block in call'
activesupport (5.2.0) lib/active_support/tagged_logging.rb:71:in `block in tagged'
activesupport (5.2.0) lib/active_support/tagged_logging.rb:28:in `tagged'
activesupport (5.2.0) lib/active_support/tagged_logging.rb:71:in `tagged'
railties (5.2.0) lib/rails/rack/logger.rb:26:in `call'
sprockets-rails (3.2.1) lib/sprockets/rails/quiet_assets.rb:13:in `call'
actionpack (5.2.0) lib/action_dispatch/middleware/remote_ip.rb:81:in `call'
actionpack (5.2.0) lib/action_dispatch/middleware/request_id.rb:27:in `call'
rack (2.0.5) lib/rack/method_override.rb:22:in `call'
rack (2.0.5) lib/rack/runtime.rb:22:in `call'
activesupport (5.2.0) lib/active_support/cache/strategy/local_cache_middleware.rb:29:in `call'
actionpack (5.2.0) lib/action_dispatch/middleware/executor.rb:14:in `call'
actionpack (5.2.0) lib/action_dispatch/middleware/static.rb:127:in `call'
rack (2.0.5) lib/rack/sendfile.rb:111:in `call'
railties (5.2.0) lib/rails/engine.rb:524:in `call'
rack (2.0.5) lib/rack/handler/webrick.rb:86:in `service'
/usr/share/rvm/rubies/ruby-2.5.0/lib/ruby/2.5.0/webrick/httpserver.rb:140:in `service'
/usr/share/rvm/rubies/ruby-2.5.0/lib/ruby/2.5.0/webrick/httpserver.rb:96:in `run'
/usr/share/rvm/rubies/ruby-2.5.0/lib/ruby/2.5.0/webrick/server.rb:307:in `block in start_thread'
Started PATCH "/auth/password" for 127.0.0.1 at 2018-07-09 14:32:36 +0300
  
ActionController::RoutingError (No route matches [PATCH] "/auth/password"):
  
actionpack (5.2.0) lib/action_dispatch/middleware/debug_exceptions.rb:65:in `call'
actionpack (5.2.0) lib/action_dispatch/middleware/show_exceptions.rb:33:in `call'
railties (5.2.0) lib/rails/rack/logger.rb:38:in `call_app'
railties (5.2.0) lib/rails/rack/logger.rb:26:in `block in call'
activesupport (5.2.0) lib/active_support/tagged_logging.rb:71:in `block in tagged'
activesupport (5.2.0) lib/active_support/tagged_logging.rb:28:in `tagged'
activesupport (5.2.0) lib/active_support/tagged_logging.rb:71:in `tagged'
railties (5.2.0) lib/rails/rack/logger.rb:26:in `call'
sprockets-rails (3.2.1) lib/sprockets/rails/quiet_assets.rb:13:in `call'
actionpack (5.2.0) lib/action_dispatch/middleware/remote_ip.rb:81:in `call'
actionpack (5.2.0) lib/action_dispatch/middleware/request_id.rb:27:in `call'
rack (2.0.5) lib/rack/method_override.rb:22:in `call'
rack (2.0.5) lib/rack/runtime.rb:22:in `call'
activesupport (5.2.0) lib/active_support/cache/strategy/local_cache_middleware.rb:29:in `call'
actionpack (5.2.0) lib/action_dispatch/middleware/executor.rb:14:in `call'
actionpack (5.2.0) lib/action_dispatch/middleware/static.rb:127:in `call'
rack (2.0.5) lib/rack/sendfile.rb:111:in `call'
railties (5.2.0) lib/rails/engine.rb:524:in `call'
rack (2.0.5) lib/rack/handler/webrick.rb:86:in `service'
/usr/share/rvm/rubies/ruby-2.5.0/lib/ruby/2.5.0/webrick/httpserver.rb:140:in `service'
/usr/share/rvm/rubies/ruby-2.5.0/lib/ruby/2.5.0/webrick/httpserver.rb:96:in `run'
/usr/share/rvm/rubies/ruby-2.5.0/lib/ruby/2.5.0/webrick/server.rb:307:in `block in start_thread'
Started PATCH "/api_user_auth/auth/password" for 127.0.0.1 at 2018-07-09 14:33:26 +0300
Processing by ApiUserAuth::AuthController#password as */*
  Parameters: {"email"=>"user@mail.com"}
Completed 422 Unprocessable Entity in 18ms (Views: 0.1ms | ActiveRecord: 0.0ms)


   (0.9ms)  CREATE DATABASE "dummy_dev" ENCODING = 'utf8'
  ↳ bin/rails:25
   (0.2ms)  CREATE DATABASE "dummy_test" ENCODING = 'utf8'
  ↳ bin/rails:25
   (52.3ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
   (14.3ms)  SELECT "ar_internal_metadata"."value" FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = $1  [["key", "environment"]]
  ↳ bin/rails:25
   (0.6ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
   (0.5ms)  SELECT "ar_internal_metadata"."value" FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = $1  [["key", "environment"]]
  ↳ bin/rails:25
   (0.6ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
   (0.5ms)  SELECT "ar_internal_metadata"."value" FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = $1  [["key", "environment"]]
  ↳ bin/rails:25
   (371.1ms)  DROP DATABASE IF EXISTS "dummy_dev"
  ↳ bin/rails:25
   (303.7ms)  DROP DATABASE IF EXISTS "dummy_test"
  ↳ bin/rails:25
   (1111.9ms)  CREATE DATABASE "dummy_dev" ENCODING = 'utf8'
  ↳ bin/rails:25
   (576.9ms)  CREATE DATABASE "dummy_test" ENCODING = 'utf8'
  ↳ bin/rails:25
   (855.4ms)  DROP DATABASE IF EXISTS "dummy_dev"
  ↳ bin/rails:25
   (155.5ms)  DROP DATABASE IF EXISTS "dummy_test"
  ↳ bin/rails:25
   (579.9ms)  CREATE DATABASE "dummy_dev" ENCODING = 'utf8'
  ↳ bin/rails:25
   (812.0ms)  CREATE DATABASE "dummy_test" ENCODING = 'utf8'
  ↳ bin/rails:25
   (42.6ms)  CREATE TABLE "schema_migrations" ("version" character varying NOT NULL PRIMARY KEY)
  ↳ bin/rails:25
   (78.3ms)  CREATE TABLE "ar_internal_metadata" ("key" character varying NOT NULL PRIMARY KEY, "value" character varying, "created_at" timestamp NOT NULL, "updated_at" timestamp NOT NULL)
  ↳ bin/rails:25
   (0.5ms)  SELECT pg_try_advisory_lock(7325747718710370390)
  ↳ bin/rails:25
   (0.3ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
Migrating to CreateApiUserAuthAuthUsers (20180703111608)
   (0.3ms)  BEGIN
  ↳ bin/rails:25
  SQL (0.4ms)  CREATE EXTENSION IF NOT EXISTS "pgcrypto"
  ↳ /home/alex/bit_forge/api_user_auth/db/migrate/20180703111608_create_api_user_auth_auth_users.rb:3
   (39.8ms)  CREATE TABLE "api_user_auth_auth_users" ("id" bigserial primary key, "email" character varying NOT NULL, "encrypted_password" character varying NOT NULL, "code" character varying DEFAULT '', "auth_tokens" uuid[] DEFAULT '{}', "user_provider_data" jsonb DEFAULT '{}', "created_at" timestamp NOT NULL, "updated_at" timestamp NOT NULL)
  ↳ /home/alex/bit_forge/api_user_auth/db/migrate/20180703111608_create_api_user_auth_auth_users.rb:5
   (30.2ms)  CREATE UNIQUE INDEX  "index_api_user_auth_auth_users_on_email" ON "api_user_auth_auth_users"  ("email")
  ↳ /home/alex/bit_forge/api_user_auth/db/migrate/20180703111608_create_api_user_auth_auth_users.rb:5
  ActiveRecord::SchemaMigration Create (0.8ms)  INSERT INTO "schema_migrations" ("version") VALUES ($1) RETURNING "version"  [["version", "20180703111608"]]
  ↳ bin/rails:25
   (29.3ms)  COMMIT
  ↳ bin/rails:25
  ActiveRecord::InternalMetadata Load (0.8ms)  SELECT  "ar_internal_metadata".* FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = $1 LIMIT $2  [["key", "environment"], ["LIMIT", 1]]
  ↳ bin/rails:25
   (0.3ms)  BEGIN
  ↳ bin/rails:25
  ActiveRecord::InternalMetadata Create (0.8ms)  INSERT INTO "ar_internal_metadata" ("key", "value", "created_at", "updated_at") VALUES ($1, $2, $3, $4) RETURNING "key"  [["key", "environment"], ["value", "development"], ["created_at", "2018-07-19 15:28:11.790946"], ["updated_at", "2018-07-19 15:28:11.790946"]]
  ↳ bin/rails:25
   (56.0ms)  COMMIT
  ↳ bin/rails:25
   (0.7ms)  SELECT pg_advisory_unlock(7325747718710370390)
  ↳ bin/rails:25
   (0.6ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
   (28.6ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
   (1.4ms)  SELECT "ar_internal_metadata"."value" FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = $1  [["key", "environment"]]
  ↳ bin/rails:25
   (0.6ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
   (0.5ms)  SELECT "ar_internal_metadata"."value" FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = $1  [["key", "environment"]]
  ↳ bin/rails:25
   (0.6ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
   (0.5ms)  SELECT "ar_internal_metadata"."value" FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = $1  [["key", "environment"]]
  ↳ bin/rails:25
   (244.8ms)  DROP DATABASE IF EXISTS "dummy_dev"
  ↳ bin/rails:25
   (262.1ms)  DROP DATABASE IF EXISTS "dummy_test"
  ↳ bin/rails:25
   (625.1ms)  CREATE DATABASE "dummy_dev" ENCODING = 'utf8'
  ↳ bin/rails:25
   (873.6ms)  CREATE DATABASE "dummy_test" ENCODING = 'utf8'
  ↳ bin/rails:25
   (852.8ms)  DROP DATABASE IF EXISTS "dummy_dev"
  ↳ bin/rails:25
   (131.8ms)  DROP DATABASE IF EXISTS "dummy_test"
  ↳ bin/rails:25
   (551.2ms)  CREATE DATABASE "dummy_dev" ENCODING = 'utf8'
  ↳ bin/rails:25
   (593.7ms)  CREATE DATABASE "dummy_test" ENCODING = 'utf8'
  ↳ bin/rails:25
   (123.9ms)  CREATE TABLE "schema_migrations" ("version" character varying NOT NULL PRIMARY KEY)
  ↳ bin/rails:25
   (45.2ms)  CREATE TABLE "ar_internal_metadata" ("key" character varying NOT NULL PRIMARY KEY, "value" character varying, "created_at" timestamp NOT NULL, "updated_at" timestamp NOT NULL)
  ↳ bin/rails:25
   (0.5ms)  SELECT pg_try_advisory_lock(7325747718710370390)
  ↳ bin/rails:25
   (1.1ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
Migrating to CreateApiUserAuthAuthUsers (20180703111608)
   (0.4ms)  BEGIN
  ↳ bin/rails:25
  SQL (0.6ms)  CREATE EXTENSION IF NOT EXISTS "pgcrypto"
  ↳ /home/alex/bit_forge/api_user_auth/db/migrate/20180703111608_create_api_user_auth_auth_users.rb:3
   (67.4ms)  CREATE TABLE "api_user_auth_auth_users" ("id" bigserial primary key, "email" character varying NOT NULL, "encrypted_password" character varying NOT NULL, "code" character varying DEFAULT '', "auth_tokens" uuid[] DEFAULT '{}', "user_provider_data" jsonb DEFAULT '{}', "provider" character varying DEFAULT 'email', "created_at" timestamp NOT NULL, "updated_at" timestamp NOT NULL)
  ↳ /home/alex/bit_forge/api_user_auth/db/migrate/20180703111608_create_api_user_auth_auth_users.rb:5
   (21.5ms)  CREATE UNIQUE INDEX  "index_api_user_auth_auth_users_on_email" ON "api_user_auth_auth_users"  ("email")
  ↳ /home/alex/bit_forge/api_user_auth/db/migrate/20180703111608_create_api_user_auth_auth_users.rb:5
  ActiveRecord::SchemaMigration Create (0.8ms)  INSERT INTO "schema_migrations" ("version") VALUES ($1) RETURNING "version"  [["version", "20180703111608"]]
  ↳ bin/rails:25
   (30.2ms)  COMMIT
  ↳ bin/rails:25
  ActiveRecord::InternalMetadata Load (0.8ms)  SELECT  "ar_internal_metadata".* FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = $1 LIMIT $2  [["key", "environment"], ["LIMIT", 1]]
  ↳ bin/rails:25
   (0.3ms)  BEGIN
  ↳ bin/rails:25
  ActiveRecord::InternalMetadata Create (0.8ms)  INSERT INTO "ar_internal_metadata" ("key", "value", "created_at", "updated_at") VALUES ($1, $2, $3, $4) RETURNING "key"  [["key", "environment"], ["value", "development"], ["created_at", "2018-07-20 12:47:13.995013"], ["updated_at", "2018-07-20 12:47:13.995013"]]
  ↳ bin/rails:25
   (56.1ms)  COMMIT
  ↳ bin/rails:25
   (0.6ms)  SELECT pg_advisory_unlock(7325747718710370390)
  ↳ bin/rails:25
   (0.6ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
   (23.4ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
   (1.4ms)  SELECT "ar_internal_metadata"."value" FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = $1  [["key", "environment"]]
  ↳ bin/rails:25
   (0.6ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
   (0.5ms)  SELECT "ar_internal_metadata"."value" FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = $1  [["key", "environment"]]
  ↳ bin/rails:25
   (0.6ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
   (0.5ms)  SELECT "ar_internal_metadata"."value" FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = $1  [["key", "environment"]]
  ↳ bin/rails:25
   (244.4ms)  DROP DATABASE IF EXISTS "dummy_test"
  ↳ bin/rails:25
   (589.9ms)  CREATE DATABASE "dummy_test" ENCODING = 'utf8'
  ↳ bin/rails:25
  SQL (0.7ms)  CREATE EXTENSION IF NOT EXISTS "pgcrypto"
  ↳ db/schema.rb:16
  SQL (0.5ms)  CREATE EXTENSION IF NOT EXISTS "plpgsql"
  ↳ db/schema.rb:17
   (0.5ms)  DROP TABLE IF EXISTS "api_user_auth_auth_users" CASCADE
  ↳ db/schema.rb:19
   (70.0ms)  CREATE TABLE "api_user_auth_auth_users" ("id" bigserial primary key, "email" character varying NOT NULL, "encrypted_password" character varying NOT NULL, "code" character varying DEFAULT '', "auth_tokens" uuid[] DEFAULT '{}', "user_provider_data" jsonb DEFAULT '{}', "provider" character varying DEFAULT 'email', "created_at" timestamp NOT NULL, "updated_at" timestamp NOT NULL)
  ↳ db/schema.rb:19
   (41.0ms)  CREATE UNIQUE INDEX  "index_api_user_auth_auth_users_on_email" ON "api_user_auth_auth_users"  ("email")
  ↳ db/schema.rb:19
   (74.0ms)  CREATE TABLE "schema_migrations" ("version" character varying NOT NULL PRIMARY KEY)
  ↳ db/schema.rb:13
   (1.2ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ db/schema.rb:13
   (9.1ms)  INSERT INTO "schema_migrations" (version) VALUES (20180703111608)
  ↳ db/schema.rb:13
   (395.1ms)  CREATE TABLE "ar_internal_metadata" ("key" character varying NOT NULL PRIMARY KEY, "value" character varying, "created_at" timestamp NOT NULL, "updated_at" timestamp NOT NULL)
  ↳ db/schema.rb:13
  ActiveRecord::InternalMetadata Load (0.8ms)  SELECT  "ar_internal_metadata".* FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = $1 LIMIT $2  [["key", "environment"], ["LIMIT", 1]]
  ↳ db/schema.rb:13
   (0.4ms)  BEGIN
  ↳ db/schema.rb:13
  ActiveRecord::InternalMetadata Create (0.9ms)  INSERT INTO "ar_internal_metadata" ("key", "value", "created_at", "updated_at") VALUES ($1, $2, $3, $4) RETURNING "key"  [["key", "environment"], ["value", "development"], ["created_at", "2018-07-26 14:16:48.679513"], ["updated_at", "2018-07-26 14:16:48.679513"]]
  ↳ db/schema.rb:13
   (212.9ms)  COMMIT
  ↳ db/schema.rb:13
  ActiveRecord::InternalMetadata Load (0.6ms)  SELECT  "ar_internal_metadata".* FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = $1 LIMIT $2  [["key", "environment"], ["LIMIT", 1]]
  ↳ bin/rails:25
   (0.3ms)  BEGIN
  ↳ bin/rails:25
  ActiveRecord::InternalMetadata Update (0.7ms)  UPDATE "ar_internal_metadata" SET "value" = $1, "updated_at" = $2 WHERE "ar_internal_metadata"."key" = $3  [["value", "test"], ["updated_at", "2018-07-26 14:16:48.902983"], ["key", "environment"]]
  ↳ bin/rails:25
   (7.9ms)  COMMIT
  ↳ bin/rails:25
   (0.4ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
   (0.3ms)  SELECT "ar_internal_metadata"."value" FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = $1  [["key", "environment"]]
  ↳ bin/rails:25
   (0.2ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
   (0.2ms)  SELECT "ar_internal_metadata"."value" FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = $1  [["key", "environment"]]
  ↳ bin/rails:25
   (0.2ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
   (0.2ms)  SELECT "ar_internal_metadata"."value" FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = $1  [["key", "environment"]]
  ↳ bin/rails:25
   (882.4ms)  DROP DATABASE IF EXISTS "dummy_dev"
  ↳ bin/rails:25
   (144.4ms)  DROP DATABASE IF EXISTS "dummy_test"
  ↳ bin/rails:25
   (871.9ms)  CREATE DATABASE "dummy_dev" ENCODING = 'utf8'
  ↳ bin/rails:25
   (513.4ms)  CREATE DATABASE "dummy_test" ENCODING = 'utf8'
  ↳ bin/rails:25
   (80.7ms)  CREATE TABLE "schema_migrations" ("version" character varying NOT NULL PRIMARY KEY)
  ↳ bin/rails:25
   (66.3ms)  CREATE TABLE "ar_internal_metadata" ("key" character varying NOT NULL PRIMARY KEY, "value" character varying, "created_at" timestamp NOT NULL, "updated_at" timestamp NOT NULL)
  ↳ bin/rails:25
   (0.5ms)  SELECT pg_try_advisory_lock(7325747718710370390)
  ↳ bin/rails:25
   (1.1ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
Migrating to CreateApiUserAuthAuthUsers (20180703111608)
   (0.4ms)  BEGIN
  ↳ bin/rails:25
  SQL (0.6ms)  CREATE EXTENSION IF NOT EXISTS "pgcrypto"
  ↳ /home/alex/bit_forge/api_user_auth/db/migrate/20180703111608_create_api_user_auth_auth_users.rb:3
   (51.2ms)  CREATE TABLE "api_user_auth_auth_users" ("id" bigserial primary key, "email" character varying NOT NULL, "encrypted_password" character varying NOT NULL, "code" character varying DEFAULT '', "auth_tokens" uuid[] DEFAULT '{}', "user_provider_data" jsonb DEFAULT '{}', "provider" character varying DEFAULT 'email', "created_at" timestamp NOT NULL, "updated_at" timestamp NOT NULL)
  ↳ /home/alex/bit_forge/api_user_auth/db/migrate/20180703111608_create_api_user_auth_auth_users.rb:5
   (34.0ms)  CREATE UNIQUE INDEX  "index_api_user_auth_auth_users_on_email" ON "api_user_auth_auth_users"  ("email")
  ↳ /home/alex/bit_forge/api_user_auth/db/migrate/20180703111608_create_api_user_auth_auth_users.rb:5
  ActiveRecord::SchemaMigration Create (0.9ms)  INSERT INTO "schema_migrations" ("version") VALUES ($1) RETURNING "version"  [["version", "20180703111608"]]
  ↳ bin/rails:25
   (47.1ms)  COMMIT
  ↳ bin/rails:25
Migrating to CreateApiUserAuthProviderTokens (20180726140712)
   (0.4ms)  BEGIN
  ↳ bin/rails:25
   (26.2ms)  CREATE TABLE "api_user_auth_provider_tokens" ("id" bigserial primary key, "api_user_auth_auth_user_id" bigint, "provider_id" integer DEFAULT 0, "user_id" character varying NOT NULL, "user_data" jsonb DEFAULT '{}', "created_at" timestamp NOT NULL, "updated_at" timestamp NOT NULL)
  ↳ /home/alex/bit_forge/api_user_auth/db/migrate/20180726140712_create_api_user_auth_provider_tokens.rb:3
   (1.3ms)  ROLLBACK
  ↳ bin/rails:25
   (0.6ms)  SELECT pg_advisory_unlock(7325747718710370390)
  ↳ bin/rails:25
   (0.2ms)  SELECT pg_try_advisory_lock(7325747718710370390)
  ↳ bin/rails:25
   (0.4ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
Migrating to CreateApiUserAuthProviderTokens (20180726140712)
   (0.1ms)  BEGIN
  ↳ bin/rails:25
   (30.7ms)  CREATE TABLE "api_user_auth_provider_tokens" ("id" bigserial primary key, "api_user_auth_auth_user_id" bigint, "provider_id" integer DEFAULT 0, "user_id" character varying NOT NULL, "user_data" jsonb DEFAULT '{}', "created_at" timestamp NOT NULL, "updated_at" timestamp NOT NULL)
  ↳ /home/alex/bit_forge/api_user_auth/db/migrate/20180726140712_create_api_user_auth_provider_tokens.rb:3
   (1.1ms)  ROLLBACK
  ↳ bin/rails:25
   (0.4ms)  SELECT pg_advisory_unlock(7325747718710370390)
  ↳ bin/rails:25
   (0.2ms)  SELECT pg_try_advisory_lock(7325747718710370390)
  ↳ bin/rails:25
   (0.4ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
Migrating to CreateApiUserAuthProviderTokens (20180726140712)
   (0.1ms)  BEGIN
  ↳ bin/rails:25
   (60.0ms)  CREATE TABLE "api_user_auth_provider_tokens" ("id" bigserial primary key, "api_user_auth_auth_user_id" bigint, "provider_id" integer DEFAULT 0, "user_id" character varying NOT NULL, "user_data" jsonb DEFAULT '{}', "created_at" timestamp NOT NULL, "updated_at" timestamp NOT NULL)
  ↳ /home/alex/bit_forge/api_user_auth/db/migrate/20180726140712_create_api_user_auth_provider_tokens.rb:3
   (50.0ms)  CREATE  INDEX  "my_supplier_index" ON "api_user_auth_provider_tokens"  ("api_user_auth_auth_user_id")
  ↳ /home/alex/bit_forge/api_user_auth/db/migrate/20180726140712_create_api_user_auth_provider_tokens.rb:3
  ActiveRecord::SchemaMigration Create (0.7ms)  INSERT INTO "schema_migrations" ("version") VALUES ($1) RETURNING "version"  [["version", "20180726140712"]]
  ↳ bin/rails:25
   (50.0ms)  COMMIT
  ↳ bin/rails:25
  ActiveRecord::InternalMetadata Load (0.8ms)  SELECT  "ar_internal_metadata".* FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = $1 LIMIT $2  [["key", "environment"], ["LIMIT", 1]]
  ↳ bin/rails:25
   (0.4ms)  BEGIN
  ↳ bin/rails:25
  ActiveRecord::InternalMetadata Create (0.9ms)  INSERT INTO "ar_internal_metadata" ("key", "value", "created_at", "updated_at") VALUES ($1, $2, $3, $4) RETURNING "key"  [["key", "environment"], ["value", "development"], ["created_at", "2018-07-26 14:22:39.524329"], ["updated_at", "2018-07-26 14:22:39.524329"]]
  ↳ bin/rails:25
   (34.7ms)  COMMIT
  ↳ bin/rails:25
   (0.6ms)  SELECT pg_advisory_unlock(7325747718710370390)
  ↳ bin/rails:25
   (0.6ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
   (0.2ms)  SELECT pg_try_advisory_lock(7325747718710370390)
  ↳ bin/rails:25
   (0.4ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
  ActiveRecord::InternalMetadata Load (0.3ms)  SELECT  "ar_internal_metadata".* FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = $1 LIMIT $2  [["key", "environment"], ["LIMIT", 1]]
  ↳ bin/rails:25
   (0.1ms)  BEGIN
  ↳ bin/rails:25
   (0.1ms)  COMMIT
  ↳ bin/rails:25
   (0.2ms)  SELECT pg_advisory_unlock(7325747718710370390)
  ↳ bin/rails:25
   (0.2ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
   (0.4ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
   (0.2ms)  SELECT "ar_internal_metadata"."value" FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = $1  [["key", "environment"]]
  ↳ bin/rails:25
   (0.2ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
   (0.2ms)  SELECT "ar_internal_metadata"."value" FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = $1  [["key", "environment"]]
  ↳ bin/rails:25
   (0.2ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
   (0.1ms)  SELECT "ar_internal_metadata"."value" FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = $1  [["key", "environment"]]
  ↳ bin/rails:25
   (254.1ms)  DROP DATABASE IF EXISTS "dummy_dev"
  ↳ bin/rails:25
   (135.1ms)  DROP DATABASE IF EXISTS "dummy_test"
  ↳ bin/rails:25
   (629.9ms)  CREATE DATABASE "dummy_dev" ENCODING = 'utf8'
  ↳ bin/rails:25
   (670.8ms)  CREATE DATABASE "dummy_test" ENCODING = 'utf8'
  ↳ bin/rails:25
   (72.2ms)  CREATE TABLE "schema_migrations" ("version" character varying NOT NULL PRIMARY KEY)
  ↳ bin/rails:25
   (69.1ms)  CREATE TABLE "ar_internal_metadata" ("key" character varying NOT NULL PRIMARY KEY, "value" character varying, "created_at" timestamp NOT NULL, "updated_at" timestamp NOT NULL)
  ↳ bin/rails:25
   (0.6ms)  SELECT pg_try_advisory_lock(7325747718710370390)
  ↳ bin/rails:25
   (1.1ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
Migrating to CreateApiUserAuthAuthUsers (20180703111608)
   (0.3ms)  BEGIN
  ↳ bin/rails:25
  SQL (0.6ms)  CREATE EXTENSION IF NOT EXISTS "pgcrypto"
  ↳ /home/alex/bit_forge/api_user_auth/db/migrate/20180703111608_create_api_user_auth_auth_users.rb:3
   (95.4ms)  CREATE TABLE "api_user_auth_auth_users" ("id" bigserial primary key, "email" character varying NOT NULL, "encrypted_password" character varying NOT NULL, "code" character varying DEFAULT '', "auth_tokens" uuid[] DEFAULT '{}', "user_provider_data" jsonb DEFAULT '{}', "provider" character varying DEFAULT 'email', "created_at" timestamp NOT NULL, "updated_at" timestamp NOT NULL)
  ↳ /home/alex/bit_forge/api_user_auth/db/migrate/20180703111608_create_api_user_auth_auth_users.rb:5
   (52.3ms)  CREATE UNIQUE INDEX  "index_api_user_auth_auth_users_on_email" ON "api_user_auth_auth_users"  ("email")
  ↳ /home/alex/bit_forge/api_user_auth/db/migrate/20180703111608_create_api_user_auth_auth_users.rb:5
  ActiveRecord::SchemaMigration Create (0.8ms)  INSERT INTO "schema_migrations" ("version") VALUES ($1) RETURNING "version"  [["version", "20180703111608"]]
  ↳ bin/rails:25
   (48.5ms)  COMMIT
  ↳ bin/rails:25
Migrating to CreateApiUserAuthProviderTokens (20180726140712)
   (0.4ms)  BEGIN
  ↳ bin/rails:25
   (62.0ms)  CREATE TABLE "api_user_auth_provider_tokens" ("id" bigserial primary key, "api_user_auth_auth_user_id" bigint, "provider_id" integer DEFAULT 0, "user_id" character varying NOT NULL, "user_data" jsonb DEFAULT '{}', "created_at" timestamp NOT NULL, "updated_at" timestamp NOT NULL)
  ↳ /home/alex/bit_forge/api_user_auth/db/migrate/20180726140712_create_api_user_auth_provider_tokens.rb:3
   (30.7ms)  CREATE  INDEX  "provider_auth_user_id" ON "api_user_auth_provider_tokens"  ("api_user_auth_auth_user_id")
  ↳ /home/alex/bit_forge/api_user_auth/db/migrate/20180726140712_create_api_user_auth_provider_tokens.rb:3
  ActiveRecord::SchemaMigration Create (0.6ms)  INSERT INTO "schema_migrations" ("version") VALUES ($1) RETURNING "version"  [["version", "20180726140712"]]
  ↳ bin/rails:25
   (16.3ms)  COMMIT
  ↳ bin/rails:25
  ActiveRecord::InternalMetadata Load (0.8ms)  SELECT  "ar_internal_metadata".* FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = $1 LIMIT $2  [["key", "environment"], ["LIMIT", 1]]
  ↳ bin/rails:25
   (0.4ms)  BEGIN
  ↳ bin/rails:25
  ActiveRecord::InternalMetadata Create (0.9ms)  INSERT INTO "ar_internal_metadata" ("key", "value", "created_at", "updated_at") VALUES ($1, $2, $3, $4) RETURNING "key"  [["key", "environment"], ["value", "development"], ["created_at", "2018-07-26 14:23:23.319242"], ["updated_at", "2018-07-26 14:23:23.319242"]]
  ↳ bin/rails:25
   (52.0ms)  COMMIT
  ↳ bin/rails:25
   (0.7ms)  SELECT pg_advisory_unlock(7325747718710370390)
  ↳ bin/rails:25
   (0.6ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
   (0.4ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
   (0.2ms)  SELECT "ar_internal_metadata"."value" FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = $1  [["key", "environment"]]
  ↳ bin/rails:25
   (0.2ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
   (0.2ms)  SELECT "ar_internal_metadata"."value" FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = $1  [["key", "environment"]]
  ↳ bin/rails:25
   (0.2ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
   (0.2ms)  SELECT "ar_internal_metadata"."value" FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = $1  [["key", "environment"]]
  ↳ bin/rails:25
   (234.2ms)  DROP DATABASE IF EXISTS "dummy_test"
  ↳ bin/rails:25
   (615.9ms)  CREATE DATABASE "dummy_test" ENCODING = 'utf8'
  ↳ bin/rails:25
  SQL (0.2ms)  CREATE EXTENSION IF NOT EXISTS "pgcrypto"
  ↳ db/schema.rb:16
  SQL (0.2ms)  CREATE EXTENSION IF NOT EXISTS "plpgsql"
  ↳ db/schema.rb:17
   (0.2ms)  DROP TABLE IF EXISTS "api_user_auth_auth_users" CASCADE
  ↳ db/schema.rb:19
   (33.8ms)  CREATE TABLE "api_user_auth_auth_users" ("id" bigserial primary key, "email" character varying NOT NULL, "encrypted_password" character varying NOT NULL, "code" character varying DEFAULT '', "auth_tokens" uuid[] DEFAULT '{}', "user_provider_data" jsonb DEFAULT '{}', "provider" character varying DEFAULT 'email', "created_at" timestamp NOT NULL, "updated_at" timestamp NOT NULL)
  ↳ db/schema.rb:19
   (29.2ms)  CREATE UNIQUE INDEX  "index_api_user_auth_auth_users_on_email" ON "api_user_auth_auth_users"  ("email")
  ↳ db/schema.rb:19
   (0.5ms)  DROP TABLE IF EXISTS "api_user_auth_provider_tokens" CASCADE
  ↳ db/schema.rb:31
   (77.9ms)  CREATE TABLE "api_user_auth_provider_tokens" ("id" bigserial primary key, "api_user_auth_auth_user_id" bigint, "provider_id" integer DEFAULT 0, "user_id" character varying NOT NULL, "user_data" jsonb DEFAULT '{}', "created_at" timestamp NOT NULL, "updated_at" timestamp NOT NULL)
  ↳ db/schema.rb:31
   (44.8ms)  CREATE  INDEX  "provider_auth_user_id" ON "api_user_auth_provider_tokens"  ("api_user_auth_auth_user_id")
  ↳ db/schema.rb:31
   (78.0ms)  CREATE TABLE "schema_migrations" ("version" character varying NOT NULL PRIMARY KEY)
  ↳ db/schema.rb:13
   (1.3ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ db/schema.rb:13
   (32.6ms)  INSERT INTO "schema_migrations" (version) VALUES (20180726140712)
  ↳ db/schema.rb:13
   (9.0ms)  INSERT INTO "schema_migrations" (version) VALUES
(20180703111608);


  ↳ db/schema.rb:13
   (73.0ms)  CREATE TABLE "ar_internal_metadata" ("key" character varying NOT NULL PRIMARY KEY, "value" character varying, "created_at" timestamp NOT NULL, "updated_at" timestamp NOT NULL)
  ↳ db/schema.rb:13
  ActiveRecord::InternalMetadata Load (0.8ms)  SELECT  "ar_internal_metadata".* FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = $1 LIMIT $2  [["key", "environment"], ["LIMIT", 1]]
  ↳ db/schema.rb:13
   (0.1ms)  BEGIN
  ↳ db/schema.rb:13
  ActiveRecord::InternalMetadata Create (0.3ms)  INSERT INTO "ar_internal_metadata" ("key", "value", "created_at", "updated_at") VALUES ($1, $2, $3, $4) RETURNING "key"  [["key", "environment"], ["value", "development"], ["created_at", "2018-07-26 14:24:15.060827"], ["updated_at", "2018-07-26 14:24:15.060827"]]
  ↳ db/schema.rb:13
   (32.3ms)  COMMIT
  ↳ db/schema.rb:13
  ActiveRecord::InternalMetadata Load (0.3ms)  SELECT  "ar_internal_metadata".* FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = $1 LIMIT $2  [["key", "environment"], ["LIMIT", 1]]
  ↳ bin/rails:25
   (0.2ms)  BEGIN
  ↳ bin/rails:25
  ActiveRecord::InternalMetadata Update (0.4ms)  UPDATE "ar_internal_metadata" SET "value" = $1, "updated_at" = $2 WHERE "ar_internal_metadata"."key" = $3  [["value", "test"], ["updated_at", "2018-07-26 14:24:15.097524"], ["key", "environment"]]
  ↳ bin/rails:25
   (31.4ms)  COMMIT
  ↳ bin/rails:25
   (0.4ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
   (0.2ms)  SELECT "ar_internal_metadata"."value" FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = $1  [["key", "environment"]]
  ↳ bin/rails:25
   (0.2ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
   (0.2ms)  SELECT "ar_internal_metadata"."value" FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = $1  [["key", "environment"]]
  ↳ bin/rails:25
   (0.2ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
   (0.2ms)  SELECT "ar_internal_metadata"."value" FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = $1  [["key", "environment"]]
  ↳ bin/rails:25
   (147.1ms)  DROP DATABASE IF EXISTS "dummy_dev"
  ↳ bin/rails:25
   (262.1ms)  DROP DATABASE IF EXISTS "dummy_test"
  ↳ bin/rails:25
   (629.1ms)  CREATE DATABASE "dummy_dev" ENCODING = 'utf8'
  ↳ bin/rails:25
   (599.1ms)  CREATE DATABASE "dummy_test" ENCODING = 'utf8'
  ↳ bin/rails:25
   (39.6ms)  CREATE TABLE "schema_migrations" ("version" character varying NOT NULL PRIMARY KEY)
  ↳ bin/rails:25
   (86.3ms)  CREATE TABLE "ar_internal_metadata" ("key" character varying NOT NULL PRIMARY KEY, "value" character varying, "created_at" timestamp NOT NULL, "updated_at" timestamp NOT NULL)
  ↳ bin/rails:25
   (0.2ms)  SELECT pg_try_advisory_lock(7325747718710370390)
  ↳ bin/rails:25
   (0.3ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
Migrating to CreateApiUserAuthAuthUsers (20180703111608)
   (0.1ms)  BEGIN
  ↳ bin/rails:25
  SQL (0.2ms)  CREATE EXTENSION IF NOT EXISTS "pgcrypto"
  ↳ /home/alex/bit_forge/api_user_auth/db/migrate/20180703111608_create_api_user_auth_auth_users.rb:3
   (49.5ms)  CREATE TABLE "api_user_auth_auth_users" ("id" bigserial primary key, "email" character varying NOT NULL, "encrypted_password" character varying NOT NULL, "code" character varying DEFAULT '', "auth_tokens" uuid[] DEFAULT '{}', "user_provider_data" jsonb DEFAULT '{}', "provider" character varying DEFAULT 'email', "created_at" timestamp NOT NULL, "updated_at" timestamp NOT NULL)
  ↳ /home/alex/bit_forge/api_user_auth/db/migrate/20180703111608_create_api_user_auth_auth_users.rb:5
   (41.0ms)  CREATE UNIQUE INDEX  "index_api_user_auth_auth_users_on_email" ON "api_user_auth_auth_users"  ("email")
  ↳ /home/alex/bit_forge/api_user_auth/db/migrate/20180703111608_create_api_user_auth_auth_users.rb:5
  ActiveRecord::SchemaMigration Create (0.8ms)  INSERT INTO "schema_migrations" ("version") VALUES ($1) RETURNING "version"  [["version", "20180703111608"]]
  ↳ bin/rails:25
   (57.4ms)  COMMIT
  ↳ bin/rails:25
Migrating to CreateApiUserAuthProviderTokens (20180726140712)
   (0.4ms)  BEGIN
  ↳ bin/rails:25
   (88.3ms)  CREATE TABLE "api_user_auth_provider_tokens" ("id" bigserial primary key, "api_user_auth_auth_user_id" bigint, "provider" integer DEFAULT 0, "user_id" character varying NOT NULL, "user_data" jsonb DEFAULT '{}', "created_at" timestamp NOT NULL, "updated_at" timestamp NOT NULL)
  ↳ /home/alex/bit_forge/api_user_auth/db/migrate/20180726140712_create_api_user_auth_provider_tokens.rb:3
   (38.8ms)  CREATE  INDEX  "provider_auth_user_id" ON "api_user_auth_provider_tokens"  ("api_user_auth_auth_user_id")
  ↳ /home/alex/bit_forge/api_user_auth/db/migrate/20180726140712_create_api_user_auth_provider_tokens.rb:3
  ActiveRecord::SchemaMigration Create (0.7ms)  INSERT INTO "schema_migrations" ("version") VALUES ($1) RETURNING "version"  [["version", "20180726140712"]]
  ↳ bin/rails:25
   (18.8ms)  COMMIT
  ↳ bin/rails:25
  ActiveRecord::InternalMetadata Load (1.4ms)  SELECT  "ar_internal_metadata".* FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = $1 LIMIT $2  [["key", "environment"], ["LIMIT", 1]]
  ↳ bin/rails:25
   (0.3ms)  BEGIN
  ↳ bin/rails:25
  ActiveRecord::InternalMetadata Create (0.8ms)  INSERT INTO "ar_internal_metadata" ("key", "value", "created_at", "updated_at") VALUES ($1, $2, $3, $4) RETURNING "key"  [["key", "environment"], ["value", "development"], ["created_at", "2018-07-26 14:50:12.496796"], ["updated_at", "2018-07-26 14:50:12.496796"]]
  ↳ bin/rails:25
   (40.8ms)  COMMIT
  ↳ bin/rails:25
   (0.6ms)  SELECT pg_advisory_unlock(7325747718710370390)
  ↳ bin/rails:25
   (0.6ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
   (0.4ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
   (0.2ms)  SELECT "ar_internal_metadata"."value" FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = $1  [["key", "environment"]]
  ↳ bin/rails:25
   (0.2ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
   (0.2ms)  SELECT "ar_internal_metadata"."value" FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = $1  [["key", "environment"]]
  ↳ bin/rails:25
   (0.2ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
   (0.2ms)  SELECT "ar_internal_metadata"."value" FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = $1  [["key", "environment"]]
  ↳ bin/rails:25
   (918.1ms)  DROP DATABASE IF EXISTS "dummy_test"
  ↳ bin/rails:25
   (500.0ms)  CREATE DATABASE "dummy_test" ENCODING = 'utf8'
  ↳ bin/rails:25
  SQL (0.2ms)  CREATE EXTENSION IF NOT EXISTS "pgcrypto"
  ↳ db/schema.rb:16
  SQL (0.2ms)  CREATE EXTENSION IF NOT EXISTS "plpgsql"
  ↳ db/schema.rb:17
   (0.2ms)  DROP TABLE IF EXISTS "api_user_auth_auth_users" CASCADE
  ↳ db/schema.rb:19
   (74.3ms)  CREATE TABLE "api_user_auth_auth_users" ("id" bigserial primary key, "email" character varying NOT NULL, "encrypted_password" character varying NOT NULL, "code" character varying DEFAULT '', "auth_tokens" uuid[] DEFAULT '{}', "user_provider_data" jsonb DEFAULT '{}', "provider" character varying DEFAULT 'email', "created_at" timestamp NOT NULL, "updated_at" timestamp NOT NULL)
  ↳ db/schema.rb:19
   (27.6ms)  CREATE UNIQUE INDEX  "index_api_user_auth_auth_users_on_email" ON "api_user_auth_auth_users"  ("email")
  ↳ db/schema.rb:19
   (0.5ms)  DROP TABLE IF EXISTS "api_user_auth_provider_tokens" CASCADE
  ↳ db/schema.rb:31
   (67.2ms)  CREATE TABLE "api_user_auth_provider_tokens" ("id" bigserial primary key, "api_user_auth_auth_user_id" bigint, "provider" integer DEFAULT 0, "user_id" character varying NOT NULL, "user_data" jsonb DEFAULT '{}', "created_at" timestamp NOT NULL, "updated_at" timestamp NOT NULL)
  ↳ db/schema.rb:31
   (35.8ms)  CREATE  INDEX  "provider_auth_user_id" ON "api_user_auth_provider_tokens"  ("api_user_auth_auth_user_id")
  ↳ db/schema.rb:31
   (70.2ms)  CREATE TABLE "schema_migrations" ("version" character varying NOT NULL PRIMARY KEY)
  ↳ db/schema.rb:13
   (1.2ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ db/schema.rb:13
   (8.8ms)  INSERT INTO "schema_migrations" (version) VALUES (20180726140712)
  ↳ db/schema.rb:13
   (9.5ms)  INSERT INTO "schema_migrations" (version) VALUES
(20180703111608);


  ↳ db/schema.rb:13
   (87.5ms)  CREATE TABLE "ar_internal_metadata" ("key" character varying NOT NULL PRIMARY KEY, "value" character varying, "created_at" timestamp NOT NULL, "updated_at" timestamp NOT NULL)
  ↳ db/schema.rb:13
  ActiveRecord::InternalMetadata Load (0.8ms)  SELECT  "ar_internal_metadata".* FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = $1 LIMIT $2  [["key", "environment"], ["LIMIT", 1]]
  ↳ db/schema.rb:13
   (0.1ms)  BEGIN
  ↳ db/schema.rb:13
  ActiveRecord::InternalMetadata Create (0.3ms)  INSERT INTO "ar_internal_metadata" ("key", "value", "created_at", "updated_at") VALUES ($1, $2, $3, $4) RETURNING "key"  [["key", "environment"], ["value", "development"], ["created_at", "2018-07-26 14:50:23.804958"], ["updated_at", "2018-07-26 14:50:23.804958"]]
  ↳ db/schema.rb:13
   (34.1ms)  COMMIT
  ↳ db/schema.rb:13
  ActiveRecord::InternalMetadata Load (0.5ms)  SELECT  "ar_internal_metadata".* FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = $1 LIMIT $2  [["key", "environment"], ["LIMIT", 1]]
  ↳ bin/rails:25
   (0.3ms)  BEGIN
  ↳ bin/rails:25
  ActiveRecord::InternalMetadata Update (0.7ms)  UPDATE "ar_internal_metadata" SET "value" = $1, "updated_at" = $2 WHERE "ar_internal_metadata"."key" = $3  [["value", "test"], ["updated_at", "2018-07-26 14:50:23.845530"], ["key", "environment"]]
  ↳ bin/rails:25
   (33.1ms)  COMMIT
  ↳ bin/rails:25
   (0.4ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
   (0.2ms)  SELECT "ar_internal_metadata"."value" FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = $1  [["key", "environment"]]
  ↳ bin/rails:25
   (0.2ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
   (0.2ms)  SELECT "ar_internal_metadata"."value" FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = $1  [["key", "environment"]]
  ↳ bin/rails:25
   (0.2ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
   (0.2ms)  SELECT "ar_internal_metadata"."value" FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = $1  [["key", "environment"]]
  ↳ bin/rails:25
   (248.9ms)  DROP DATABASE IF EXISTS "dummy_dev"
  ↳ bin/rails:25
   (148.5ms)  DROP DATABASE IF EXISTS "dummy_test"
  ↳ bin/rails:25
   (0.2ms)  DROP DATABASE IF EXISTS "dummy_test"
  ↳ bin/rails:25
   (628.5ms)  CREATE DATABASE "dummy_test" ENCODING = 'utf8'
  ↳ bin/rails:25
  SQL (0.2ms)  CREATE EXTENSION IF NOT EXISTS "pgcrypto"
  ↳ db/schema.rb:16
  SQL (0.2ms)  CREATE EXTENSION IF NOT EXISTS "plpgsql"
  ↳ db/schema.rb:17
   (0.2ms)  DROP TABLE IF EXISTS "api_user_auth_auth_users" CASCADE
  ↳ db/schema.rb:19
   (37.4ms)  CREATE TABLE "api_user_auth_auth_users" ("id" bigserial primary key, "email" character varying NOT NULL, "encrypted_password" character varying NOT NULL, "code" character varying DEFAULT '', "auth_tokens" uuid[] DEFAULT '{}', "user_provider_data" jsonb DEFAULT '{}', "provider" character varying DEFAULT 'email', "created_at" timestamp NOT NULL, "updated_at" timestamp NOT NULL)
  ↳ db/schema.rb:19
   (66.2ms)  CREATE UNIQUE INDEX  "index_api_user_auth_auth_users_on_email" ON "api_user_auth_auth_users"  ("email")
  ↳ db/schema.rb:19
   (0.2ms)  DROP TABLE IF EXISTS "api_user_auth_provider_tokens" CASCADE
  ↳ db/schema.rb:31
   (55.5ms)  CREATE TABLE "api_user_auth_provider_tokens" ("id" bigserial primary key, "api_user_auth_auth_user_id" bigint, "provider" integer DEFAULT 0, "user_id" character varying NOT NULL, "user_data" jsonb DEFAULT '{}', "created_at" timestamp NOT NULL, "updated_at" timestamp NOT NULL)
  ↳ db/schema.rb:31
   (209.4ms)  CREATE  INDEX  "provider_auth_user_id" ON "api_user_auth_provider_tokens"  ("api_user_auth_auth_user_id")
  ↳ db/schema.rb:31
   (45.8ms)  CREATE TABLE "schema_migrations" ("version" character varying NOT NULL PRIMARY KEY)
  ↳ db/schema.rb:13
   (0.4ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ db/schema.rb:13
   (41.5ms)  INSERT INTO "schema_migrations" (version) VALUES (20180726140712)
  ↳ db/schema.rb:13
   (3.7ms)  INSERT INTO "schema_migrations" (version) VALUES
(20180703111608);


  ↳ db/schema.rb:13
   (57.3ms)  CREATE TABLE "ar_internal_metadata" ("key" character varying NOT NULL PRIMARY KEY, "value" character varying, "created_at" timestamp NOT NULL, "updated_at" timestamp NOT NULL)
  ↳ db/schema.rb:13
  ActiveRecord::InternalMetadata Load (0.3ms)  SELECT  "ar_internal_metadata".* FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = $1 LIMIT $2  [["key", "environment"], ["LIMIT", 1]]
  ↳ db/schema.rb:13
   (0.2ms)  BEGIN
  ↳ db/schema.rb:13
  ActiveRecord::InternalMetadata Create (0.3ms)  INSERT INTO "ar_internal_metadata" ("key", "value", "created_at", "updated_at") VALUES ($1, $2, $3, $4) RETURNING "key"  [["key", "environment"], ["value", "development"], ["created_at", "2018-07-26 15:19:02.423981"], ["updated_at", "2018-07-26 15:19:02.423981"]]
  ↳ db/schema.rb:13
   (42.0ms)  COMMIT
  ↳ db/schema.rb:13
  ActiveRecord::InternalMetadata Load (0.2ms)  SELECT  "ar_internal_metadata".* FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = $1 LIMIT $2  [["key", "environment"], ["LIMIT", 1]]
  ↳ bin/rails:25
   (0.1ms)  BEGIN
  ↳ bin/rails:25
  ActiveRecord::InternalMetadata Update (0.2ms)  UPDATE "ar_internal_metadata" SET "value" = $1, "updated_at" = $2 WHERE "ar_internal_metadata"."key" = $3  [["value", "test"], ["updated_at", "2018-07-26 15:19:02.469306"], ["key", "environment"]]
  ↳ bin/rails:25
   (5.2ms)  COMMIT
  ↳ bin/rails:25
   (0.1ms)  DROP DATABASE IF EXISTS "dummy_dev"
  ↳ bin/rails:25
   (252.6ms)  DROP DATABASE IF EXISTS "dummy_test"
  ↳ bin/rails:25
   (657.3ms)  CREATE DATABASE "dummy_dev" ENCODING = 'utf8'
  ↳ bin/rails:25
   (589.4ms)  CREATE DATABASE "dummy_test" ENCODING = 'utf8'
  ↳ bin/rails:25
   (244.6ms)  DROP DATABASE IF EXISTS "dummy_test"
  ↳ bin/rails:25
   (561.0ms)  CREATE DATABASE "dummy_test" ENCODING = 'utf8'
  ↳ bin/rails:25
  SQL (0.2ms)  CREATE EXTENSION IF NOT EXISTS "pgcrypto"
  ↳ db/schema.rb:16
  SQL (0.2ms)  CREATE EXTENSION IF NOT EXISTS "plpgsql"
  ↳ db/schema.rb:17
   (0.2ms)  DROP TABLE IF EXISTS "api_user_auth_auth_users" CASCADE
  ↳ db/schema.rb:19
   (54.3ms)  CREATE TABLE "api_user_auth_auth_users" ("id" bigserial primary key, "email" character varying NOT NULL, "encrypted_password" character varying NOT NULL, "code" character varying DEFAULT '', "auth_tokens" uuid[] DEFAULT '{}', "user_provider_data" jsonb DEFAULT '{}', "provider" character varying DEFAULT 'email', "created_at" timestamp NOT NULL, "updated_at" timestamp NOT NULL)
  ↳ db/schema.rb:19
   (30.5ms)  CREATE UNIQUE INDEX  "index_api_user_auth_auth_users_on_email" ON "api_user_auth_auth_users"  ("email")
  ↳ db/schema.rb:19
   (0.5ms)  DROP TABLE IF EXISTS "api_user_auth_provider_tokens" CASCADE
  ↳ db/schema.rb:31
   (88.7ms)  CREATE TABLE "api_user_auth_provider_tokens" ("id" bigserial primary key, "api_user_auth_auth_user_id" bigint, "provider" integer DEFAULT 0, "user_id" character varying NOT NULL, "user_data" jsonb DEFAULT '{}', "created_at" timestamp NOT NULL, "updated_at" timestamp NOT NULL)
  ↳ db/schema.rb:31
   (61.5ms)  CREATE  INDEX  "provider_auth_user_id" ON "api_user_auth_provider_tokens"  ("api_user_auth_auth_user_id")
  ↳ db/schema.rb:31
   (72.6ms)  CREATE TABLE "schema_migrations" ("version" character varying NOT NULL PRIMARY KEY)
  ↳ db/schema.rb:13
   (1.1ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ db/schema.rb:13
   (41.6ms)  INSERT INTO "schema_migrations" (version) VALUES (20180726140712)
  ↳ db/schema.rb:13
   (33.8ms)  INSERT INTO "schema_migrations" (version) VALUES
(20180703111608);


  ↳ db/schema.rb:13
   (37.1ms)  CREATE TABLE "ar_internal_metadata" ("key" character varying NOT NULL PRIMARY KEY, "value" character varying, "created_at" timestamp NOT NULL, "updated_at" timestamp NOT NULL)
  ↳ db/schema.rb:13
  ActiveRecord::InternalMetadata Load (0.8ms)  SELECT  "ar_internal_metadata".* FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = $1 LIMIT $2  [["key", "environment"], ["LIMIT", 1]]
  ↳ db/schema.rb:13
   (0.4ms)  BEGIN
  ↳ db/schema.rb:13
  ActiveRecord::InternalMetadata Create (0.9ms)  INSERT INTO "ar_internal_metadata" ("key", "value", "created_at", "updated_at") VALUES ($1, $2, $3, $4) RETURNING "key"  [["key", "environment"], ["value", "development"], ["created_at", "2018-07-26 15:21:49.315746"], ["updated_at", "2018-07-26 15:21:49.315746"]]
  ↳ db/schema.rb:13
   (53.8ms)  COMMIT
  ↳ db/schema.rb:13
  ActiveRecord::InternalMetadata Load (0.5ms)  SELECT  "ar_internal_metadata".* FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = $1 LIMIT $2  [["key", "environment"], ["LIMIT", 1]]
  ↳ bin/rails:25
   (0.3ms)  BEGIN
  ↳ bin/rails:25
  ActiveRecord::InternalMetadata Update (0.7ms)  UPDATE "ar_internal_metadata" SET "value" = $1, "updated_at" = $2 WHERE "ar_internal_metadata"."key" = $3  [["value", "test"], ["updated_at", "2018-07-26 15:21:49.380182"], ["key", "environment"]]
  ↳ bin/rails:25
   (14.2ms)  COMMIT
  ↳ bin/rails:25
   (433.8ms)  DROP DATABASE IF EXISTS "dummy_test"
  ↳ bin/rails:25
   (622.8ms)  CREATE DATABASE "dummy_test" ENCODING = 'utf8'
  ↳ bin/rails:25
  SQL (0.2ms)  CREATE EXTENSION IF NOT EXISTS "pgcrypto"
  ↳ db/schema.rb:16
  SQL (0.2ms)  CREATE EXTENSION IF NOT EXISTS "plpgsql"
  ↳ db/schema.rb:17
   (0.2ms)  DROP TABLE IF EXISTS "api_user_auth_auth_users" CASCADE
  ↳ db/schema.rb:19
   (67.5ms)  CREATE TABLE "api_user_auth_auth_users" ("id" bigserial primary key, "email" character varying NOT NULL, "encrypted_password" character varying NOT NULL, "code" character varying DEFAULT '', "auth_tokens" uuid[] DEFAULT '{}', "user_provider_data" jsonb DEFAULT '{}', "provider" character varying DEFAULT 'email', "created_at" timestamp NOT NULL, "updated_at" timestamp NOT NULL)
  ↳ db/schema.rb:19
   (38.9ms)  CREATE UNIQUE INDEX  "index_api_user_auth_auth_users_on_email" ON "api_user_auth_auth_users"  ("email")
  ↳ db/schema.rb:19
   (0.5ms)  DROP TABLE IF EXISTS "api_user_auth_provider_tokens" CASCADE
  ↳ db/schema.rb:31
   (64.3ms)  CREATE TABLE "api_user_auth_provider_tokens" ("id" bigserial primary key, "api_user_auth_auth_user_id" bigint, "provider" integer DEFAULT 0, "user_id" character varying NOT NULL, "user_data" jsonb DEFAULT '{}', "created_at" timestamp NOT NULL, "updated_at" timestamp NOT NULL)
  ↳ db/schema.rb:31
   (61.0ms)  CREATE  INDEX  "provider_auth_user_id" ON "api_user_auth_provider_tokens"  ("api_user_auth_auth_user_id")
  ↳ db/schema.rb:31
   (97.7ms)  CREATE TABLE "schema_migrations" ("version" character varying NOT NULL PRIMARY KEY)
  ↳ db/schema.rb:13
   (1.1ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ db/schema.rb:13
   (42.8ms)  INSERT INTO "schema_migrations" (version) VALUES (20180726140712)
  ↳ db/schema.rb:13
   (9.0ms)  INSERT INTO "schema_migrations" (version) VALUES
(20180703111608);


  ↳ db/schema.rb:13
   (73.5ms)  CREATE TABLE "ar_internal_metadata" ("key" character varying NOT NULL PRIMARY KEY, "value" character varying, "created_at" timestamp NOT NULL, "updated_at" timestamp NOT NULL)
  ↳ db/schema.rb:13
  ActiveRecord::InternalMetadata Load (0.8ms)  SELECT  "ar_internal_metadata".* FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = $1 LIMIT $2  [["key", "environment"], ["LIMIT", 1]]
  ↳ db/schema.rb:13
   (0.3ms)  BEGIN
  ↳ db/schema.rb:13
  ActiveRecord::InternalMetadata Create (0.9ms)  INSERT INTO "ar_internal_metadata" ("key", "value", "created_at", "updated_at") VALUES ($1, $2, $3, $4) RETURNING "key"  [["key", "environment"], ["value", "development"], ["created_at", "2018-07-26 15:23:45.255648"], ["updated_at", "2018-07-26 15:23:45.255648"]]
  ↳ db/schema.rb:13
   (57.7ms)  COMMIT
  ↳ db/schema.rb:13
  ActiveRecord::InternalMetadata Load (0.6ms)  SELECT  "ar_internal_metadata".* FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = $1 LIMIT $2  [["key", "environment"], ["LIMIT", 1]]
  ↳ bin/rails:25
   (0.3ms)  BEGIN
  ↳ bin/rails:25
  ActiveRecord::InternalMetadata Update (0.7ms)  UPDATE "ar_internal_metadata" SET "value" = $1, "updated_at" = $2 WHERE "ar_internal_metadata"."key" = $3  [["value", "test"], ["updated_at", "2018-07-26 15:23:45.323600"], ["key", "environment"]]
  ↳ bin/rails:25
   (13.8ms)  COMMIT
  ↳ bin/rails:25
   (923.0ms)  DROP DATABASE IF EXISTS "dummy_dev"
  ↳ bin/rails:25
   (245.5ms)  DROP DATABASE IF EXISTS "dummy_test"
  ↳ bin/rails:25
   (531.9ms)  CREATE DATABASE "dummy_dev" ENCODING = 'utf8'
  ↳ bin/rails:25
   (600.4ms)  CREATE DATABASE "dummy_test" ENCODING = 'utf8'
  ↳ bin/rails:25
   (111.5ms)  CREATE TABLE "schema_migrations" ("version" character varying NOT NULL PRIMARY KEY)
  ↳ bin/rails:25
   (92.6ms)  CREATE TABLE "ar_internal_metadata" ("key" character varying NOT NULL PRIMARY KEY, "value" character varying, "created_at" timestamp NOT NULL, "updated_at" timestamp NOT NULL)
  ↳ bin/rails:25
   (0.5ms)  SELECT pg_try_advisory_lock(7325747718710370390)
  ↳ bin/rails:25
   (1.2ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
Migrating to CreateApiUserAuthAuthUsers (20180703111608)
   (0.3ms)  BEGIN
  ↳ bin/rails:25
  SQL (0.6ms)  CREATE EXTENSION IF NOT EXISTS "pgcrypto"
  ↳ /home/alex/bit_forge/api_user_auth/db/migrate/20180703111608_create_api_user_auth_auth_users.rb:3
   (66.2ms)  CREATE TABLE "api_user_auth_auth_users" ("id" bigserial primary key, "email" character varying NOT NULL, "encrypted_password" character varying NOT NULL, "code" character varying DEFAULT '', "auth_tokens" uuid[] DEFAULT '{}', "user_provider_data" jsonb DEFAULT '{}', "provider" character varying DEFAULT 'email', "created_at" timestamp NOT NULL, "updated_at" timestamp NOT NULL)
  ↳ /home/alex/bit_forge/api_user_auth/db/migrate/20180703111608_create_api_user_auth_auth_users.rb:5
   (42.2ms)  CREATE UNIQUE INDEX  "index_api_user_auth_auth_users_on_email" ON "api_user_auth_auth_users"  ("email")
  ↳ /home/alex/bit_forge/api_user_auth/db/migrate/20180703111608_create_api_user_auth_auth_users.rb:5
  ActiveRecord::SchemaMigration Create (1.1ms)  INSERT INTO "schema_migrations" ("version") VALUES ($1) RETURNING "version"  [["version", "20180703111608"]]
  ↳ bin/rails:25
   (42.6ms)  COMMIT
  ↳ bin/rails:25
Migrating to CreateApiUserAuthProviderTokens (20180726140712)
   (0.4ms)  BEGIN
  ↳ bin/rails:25
   (60.4ms)  CREATE TABLE "api_user_auth_provider_tokens" ("id" bigserial primary key, "auth_user_id" bigint, "provider" integer DEFAULT 0, "user_id" character varying NOT NULL, "user_data" jsonb DEFAULT '{}', "created_at" timestamp NOT NULL, "updated_at" timestamp NOT NULL)
  ↳ /home/alex/bit_forge/api_user_auth/db/migrate/20180726140712_create_api_user_auth_provider_tokens.rb:3
   (54.3ms)  CREATE  INDEX  "index_api_user_auth_provider_tokens_on_auth_user_id" ON "api_user_auth_provider_tokens"  ("auth_user_id")
  ↳ /home/alex/bit_forge/api_user_auth/db/migrate/20180726140712_create_api_user_auth_provider_tokens.rb:3
  ActiveRecord::SchemaMigration Create (0.6ms)  INSERT INTO "schema_migrations" ("version") VALUES ($1) RETURNING "version"  [["version", "20180726140712"]]
  ↳ bin/rails:25
   (14.7ms)  COMMIT
  ↳ bin/rails:25
  ActiveRecord::InternalMetadata Load (0.7ms)  SELECT  "ar_internal_metadata".* FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = $1 LIMIT $2  [["key", "environment"], ["LIMIT", 1]]
  ↳ bin/rails:25
   (0.4ms)  BEGIN
  ↳ bin/rails:25
  ActiveRecord::InternalMetadata Create (0.9ms)  INSERT INTO "ar_internal_metadata" ("key", "value", "created_at", "updated_at") VALUES ($1, $2, $3, $4) RETURNING "key"  [["key", "environment"], ["value", "development"], ["created_at", "2018-07-26 15:24:00.631422"], ["updated_at", "2018-07-26 15:24:00.631422"]]
  ↳ bin/rails:25
   (50.8ms)  COMMIT
  ↳ bin/rails:25
   (0.6ms)  SELECT pg_advisory_unlock(7325747718710370390)
  ↳ bin/rails:25
   (0.6ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
   (0.4ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
   (0.2ms)  SELECT "ar_internal_metadata"."value" FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = $1  [["key", "environment"]]
  ↳ bin/rails:25
   (0.2ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
   (0.2ms)  SELECT "ar_internal_metadata"."value" FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = $1  [["key", "environment"]]
  ↳ bin/rails:25
   (0.2ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
   (0.1ms)  SELECT "ar_internal_metadata"."value" FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = $1  [["key", "environment"]]
  ↳ bin/rails:25
   (1031.7ms)  DROP DATABASE IF EXISTS "dummy_test"
  ↳ bin/rails:25
   (631.1ms)  CREATE DATABASE "dummy_test" ENCODING = 'utf8'
  ↳ bin/rails:25
  SQL (0.7ms)  CREATE EXTENSION IF NOT EXISTS "pgcrypto"
  ↳ db/schema.rb:16
  SQL (0.5ms)  CREATE EXTENSION IF NOT EXISTS "plpgsql"
  ↳ db/schema.rb:17
   (0.5ms)  DROP TABLE IF EXISTS "api_user_auth_auth_users" CASCADE
  ↳ db/schema.rb:19
   (62.6ms)  CREATE TABLE "api_user_auth_auth_users" ("id" bigserial primary key, "email" character varying NOT NULL, "encrypted_password" character varying NOT NULL, "code" character varying DEFAULT '', "auth_tokens" uuid[] DEFAULT '{}', "user_provider_data" jsonb DEFAULT '{}', "provider" character varying DEFAULT 'email', "created_at" timestamp NOT NULL, "updated_at" timestamp NOT NULL)
  ↳ db/schema.rb:19
   (30.3ms)  CREATE UNIQUE INDEX  "index_api_user_auth_auth_users_on_email" ON "api_user_auth_auth_users"  ("email")
  ↳ db/schema.rb:19
   (0.5ms)  DROP TABLE IF EXISTS "api_user_auth_provider_tokens" CASCADE
  ↳ db/schema.rb:31
   (100.1ms)  CREATE TABLE "api_user_auth_provider_tokens" ("id" bigserial primary key, "auth_user_id" bigint, "provider" integer DEFAULT 0, "user_id" character varying NOT NULL, "user_data" jsonb DEFAULT '{}', "created_at" timestamp NOT NULL, "updated_at" timestamp NOT NULL)
  ↳ db/schema.rb:31
   (55.6ms)  CREATE  INDEX  "index_api_user_auth_provider_tokens_on_auth_user_id" ON "api_user_auth_provider_tokens"  ("auth_user_id")
  ↳ db/schema.rb:31
   (90.7ms)  CREATE TABLE "schema_migrations" ("version" character varying NOT NULL PRIMARY KEY)
  ↳ db/schema.rb:13
   (1.3ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ db/schema.rb:13
   (43.8ms)  INSERT INTO "schema_migrations" (version) VALUES (20180726140712)
  ↳ db/schema.rb:13
   (4.8ms)  INSERT INTO "schema_migrations" (version) VALUES
(20180703111608);


  ↳ db/schema.rb:13
   (103.3ms)  CREATE TABLE "ar_internal_metadata" ("key" character varying NOT NULL PRIMARY KEY, "value" character varying, "created_at" timestamp NOT NULL, "updated_at" timestamp NOT NULL)
  ↳ db/schema.rb:13
  ActiveRecord::InternalMetadata Load (0.3ms)  SELECT  "ar_internal_metadata".* FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = $1 LIMIT $2  [["key", "environment"], ["LIMIT", 1]]
  ↳ db/schema.rb:13
   (0.1ms)  BEGIN
  ↳ db/schema.rb:13
  ActiveRecord::InternalMetadata Create (0.3ms)  INSERT INTO "ar_internal_metadata" ("key", "value", "created_at", "updated_at") VALUES ($1, $2, $3, $4) RETURNING "key"  [["key", "environment"], ["value", "development"], ["created_at", "2018-07-26 15:24:07.537012"], ["updated_at", "2018-07-26 15:24:07.537012"]]
  ↳ db/schema.rb:13
   (27.5ms)  COMMIT
  ↳ db/schema.rb:13
  ActiveRecord::InternalMetadata Load (0.6ms)  SELECT  "ar_internal_metadata".* FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = $1 LIMIT $2  [["key", "environment"], ["LIMIT", 1]]
  ↳ bin/rails:25
   (0.3ms)  BEGIN
  ↳ bin/rails:25
  ActiveRecord::InternalMetadata Update (0.7ms)  UPDATE "ar_internal_metadata" SET "value" = $1, "updated_at" = $2 WHERE "ar_internal_metadata"."key" = $3  [["value", "test"], ["updated_at", "2018-07-26 15:24:07.572738"], ["key", "environment"]]
  ↳ bin/rails:25
   (67.7ms)  COMMIT
  ↳ bin/rails:25
   (0.3ms)  CREATE DATABASE "dummy_dev" ENCODING = 'utf8'
  ↳ bin/rails:25
   (0.2ms)  CREATE DATABASE "dummy_test" ENCODING = 'utf8'
  ↳ bin/rails:25
   (0.4ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
   (0.3ms)  SELECT "ar_internal_metadata"."value" FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = $1  [["key", "environment"]]
  ↳ bin/rails:25
   (0.2ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
   (0.2ms)  SELECT "ar_internal_metadata"."value" FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = $1  [["key", "environment"]]
  ↳ bin/rails:25
   (0.2ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
   (0.2ms)  SELECT "ar_internal_metadata"."value" FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = $1  [["key", "environment"]]
  ↳ bin/rails:25
   (844.8ms)  DROP DATABASE IF EXISTS "dummy_dev"
  ↳ bin/rails:25
   (149.2ms)  DROP DATABASE IF EXISTS "dummy_test"
  ↳ bin/rails:25
   (642.6ms)  CREATE DATABASE "dummy_dev" ENCODING = 'utf8'
  ↳ bin/rails:25
   (590.5ms)  CREATE DATABASE "dummy_test" ENCODING = 'utf8'
  ↳ bin/rails:25
   (65.2ms)  CREATE TABLE "schema_migrations" ("version" character varying NOT NULL PRIMARY KEY)
  ↳ bin/rails:25
   (62.2ms)  CREATE TABLE "ar_internal_metadata" ("key" character varying NOT NULL PRIMARY KEY, "value" character varying, "created_at" timestamp NOT NULL, "updated_at" timestamp NOT NULL)
  ↳ bin/rails:25
   (0.5ms)  SELECT pg_try_advisory_lock(7325747718710370390)
  ↳ bin/rails:25
   (1.1ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
Migrating to CreateApiUserAuthAuthUsers (20180703111608)
   (0.1ms)  BEGIN
  ↳ bin/rails:25
  SQL (0.2ms)  CREATE EXTENSION IF NOT EXISTS "pgcrypto"
  ↳ /home/alex/bit_forge/api_user_auth/db/migrate/20180703111608_create_api_user_auth_auth_users.rb:3
   (72.0ms)  CREATE TABLE "api_user_auth_auth_users" ("id" bigserial primary key, "email" character varying NOT NULL, "encrypted_password" character varying NOT NULL, "code" character varying DEFAULT '', "auth_tokens" uuid[] DEFAULT '{}', "user_provider_data" jsonb DEFAULT '{}', "provider" character varying DEFAULT 'email', "created_at" timestamp NOT NULL, "updated_at" timestamp NOT NULL)
  ↳ /home/alex/bit_forge/api_user_auth/db/migrate/20180703111608_create_api_user_auth_auth_users.rb:5
   (34.1ms)  CREATE UNIQUE INDEX  "index_api_user_auth_auth_users_on_email" ON "api_user_auth_auth_users"  ("email")
  ↳ /home/alex/bit_forge/api_user_auth/db/migrate/20180703111608_create_api_user_auth_auth_users.rb:5
  ActiveRecord::SchemaMigration Create (0.9ms)  INSERT INTO "schema_migrations" ("version") VALUES ($1) RETURNING "version"  [["version", "20180703111608"]]
  ↳ bin/rails:25
   (54.4ms)  COMMIT
  ↳ bin/rails:25
Migrating to CreateApiUserAuthProviderTokens (20180726140712)
   (0.4ms)  BEGIN
  ↳ bin/rails:25
   (54.3ms)  CREATE TABLE "api_user_auth_provider_tokens" ("id" bigserial primary key, "auth_user_id" bigint, "provider" integer, "user_id" character varying NOT NULL, "user_data" jsonb DEFAULT '{}', "created_at" timestamp NOT NULL, "updated_at" timestamp NOT NULL)
  ↳ /home/alex/bit_forge/api_user_auth/db/migrate/20180726140712_create_api_user_auth_provider_tokens.rb:3
   (36.0ms)  CREATE  INDEX  "index_api_user_auth_provider_tokens_on_auth_user_id" ON "api_user_auth_provider_tokens"  ("auth_user_id")
  ↳ /home/alex/bit_forge/api_user_auth/db/migrate/20180726140712_create_api_user_auth_provider_tokens.rb:3
  ActiveRecord::SchemaMigration Create (0.7ms)  INSERT INTO "schema_migrations" ("version") VALUES ($1) RETURNING "version"  [["version", "20180726140712"]]
  ↳ bin/rails:25
   (6.4ms)  COMMIT
  ↳ bin/rails:25
  ActiveRecord::InternalMetadata Load (0.8ms)  SELECT  "ar_internal_metadata".* FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = $1 LIMIT $2  [["key", "environment"], ["LIMIT", 1]]
  ↳ bin/rails:25
   (0.9ms)  BEGIN
  ↳ bin/rails:25
  ActiveRecord::InternalMetadata Create (0.9ms)  INSERT INTO "ar_internal_metadata" ("key", "value", "created_at", "updated_at") VALUES ($1, $2, $3, $4) RETURNING "key"  [["key", "environment"], ["value", "development"], ["created_at", "2018-07-26 15:25:21.454345"], ["updated_at", "2018-07-26 15:25:21.454345"]]
  ↳ bin/rails:25
   (39.4ms)  COMMIT
  ↳ bin/rails:25
   (0.6ms)  SELECT pg_advisory_unlock(7325747718710370390)
  ↳ bin/rails:25
   (0.6ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
   (0.4ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
   (0.3ms)  SELECT "ar_internal_metadata"."value" FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = $1  [["key", "environment"]]
  ↳ bin/rails:25
   (0.2ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
   (0.2ms)  SELECT "ar_internal_metadata"."value" FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = $1  [["key", "environment"]]
  ↳ bin/rails:25
   (0.2ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ bin/rails:25
   (0.2ms)  SELECT "ar_internal_metadata"."value" FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = $1  [["key", "environment"]]
  ↳ bin/rails:25
   (821.5ms)  DROP DATABASE IF EXISTS "dummy_test"
  ↳ bin/rails:25
   (743.2ms)  CREATE DATABASE "dummy_test" ENCODING = 'utf8'
  ↳ bin/rails:25
  SQL (0.7ms)  CREATE EXTENSION IF NOT EXISTS "pgcrypto"
  ↳ db/schema.rb:16
  SQL (0.5ms)  CREATE EXTENSION IF NOT EXISTS "plpgsql"
  ↳ db/schema.rb:17
   (0.5ms)  DROP TABLE IF EXISTS "api_user_auth_auth_users" CASCADE
  ↳ db/schema.rb:19
   (89.0ms)  CREATE TABLE "api_user_auth_auth_users" ("id" bigserial primary key, "email" character varying NOT NULL, "encrypted_password" character varying NOT NULL, "code" character varying DEFAULT '', "auth_tokens" uuid[] DEFAULT '{}', "user_provider_data" jsonb DEFAULT '{}', "provider" character varying DEFAULT 'email', "created_at" timestamp NOT NULL, "updated_at" timestamp NOT NULL)
  ↳ db/schema.rb:19
   (39.9ms)  CREATE UNIQUE INDEX  "index_api_user_auth_auth_users_on_email" ON "api_user_auth_auth_users"  ("email")
  ↳ db/schema.rb:19
   (0.5ms)  DROP TABLE IF EXISTS "api_user_auth_provider_tokens" CASCADE
  ↳ db/schema.rb:31
   (90.9ms)  CREATE TABLE "api_user_auth_provider_tokens" ("id" bigserial primary key, "auth_user_id" bigint, "provider" integer, "user_id" character varying NOT NULL, "user_data" jsonb DEFAULT '{}', "created_at" timestamp NOT NULL, "updated_at" timestamp NOT NULL)
  ↳ db/schema.rb:31
   (57.0ms)  CREATE  INDEX  "index_api_user_auth_provider_tokens_on_auth_user_id" ON "api_user_auth_provider_tokens"  ("auth_user_id")
  ↳ db/schema.rb:31
   (76.6ms)  CREATE TABLE "schema_migrations" ("version" character varying NOT NULL PRIMARY KEY)
  ↳ db/schema.rb:13
   (1.3ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ↳ db/schema.rb:13
   (9.0ms)  INSERT INTO "schema_migrations" (version) VALUES (20180726140712)
  ↳ db/schema.rb:13
   (8.9ms)  INSERT INTO "schema_migrations" (version) VALUES
(20180703111608);


  ↳ db/schema.rb:13
   (75.5ms)  CREATE TABLE "ar_internal_metadata" ("key" character varying NOT NULL PRIMARY KEY, "value" character varying, "created_at" timestamp NOT NULL, "updated_at" timestamp NOT NULL)
  ↳ db/schema.rb:13
  ActiveRecord::InternalMetadata Load (0.3ms)  SELECT  "ar_internal_metadata".* FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = $1 LIMIT $2  [["key", "environment"], ["LIMIT", 1]]
  ↳ db/schema.rb:13
   (0.1ms)  BEGIN
  ↳ db/schema.rb:13
  ActiveRecord::InternalMetadata Create (0.3ms)  INSERT INTO "ar_internal_metadata" ("key", "value", "created_at", "updated_at") VALUES ($1, $2, $3, $4) RETURNING "key"  [["key", "environment"], ["value", "development"], ["created_at", "2018-07-26 15:25:28.731259"], ["updated_at", "2018-07-26 15:25:28.731259"]]
  ↳ db/schema.rb:13
   (31.9ms)  COMMIT
  ↳ db/schema.rb:13
  ActiveRecord::InternalMetadata Load (0.6ms)  SELECT  "ar_internal_metadata".* FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = $1 LIMIT $2  [["key", "environment"], ["LIMIT", 1]]
  ↳ bin/rails:25
   (0.3ms)  BEGIN
  ↳ bin/rails:25
  ActiveRecord::InternalMetadata Update (0.7ms)  UPDATE "ar_internal_metadata" SET "value" = $1, "updated_at" = $2 WHERE "ar_internal_metadata"."key" = $3  [["value", "test"], ["updated_at", "2018-07-26 15:25:28.771255"], ["key", "environment"]]
  ↳ bin/rails:25
   (62.3ms)  COMMIT
  ↳ bin/rails:25