(7.0ms) CREATE TABLE "accounts" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "provider" varchar(255), "uid" integer, "name" varchar(255), "oauth_access_token" varchar(255), "oauth_refresh_token" varchar(255), "oauth_expires_at" varchar(255))   (1.1ms) CREATE INDEX "index_accounts_on_uid" ON "accounts" ("uid")  (1.3ms) CREATE TABLE "schema_migrations" ("version" varchar(255) NOT NULL)   (1.2ms) CREATE UNIQUE INDEX "unique_schema_migrations" ON "schema_migrations" ("version")  (0.2ms) SELECT version FROM "schema_migrations"  (0.9ms) INSERT INTO "schema_migrations" (version) VALUES ('20140312093436')  (1.8ms) CREATE TABLE "accounts" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "provider" varchar(255), "uid" integer, "name" varchar(255), "oauth_access_token" varchar(255), "oauth_refresh_token" varchar(255), "oauth_expires_at" varchar(255))   (1.0ms) CREATE INDEX "index_accounts_on_uid" ON "accounts" ("uid")  (1.1ms) CREATE TABLE "schema_migrations" ("version" varchar(255) NOT NULL)   (1.1ms) CREATE UNIQUE INDEX "unique_schema_migrations" ON "schema_migrations" ("version")  (0.2ms) SELECT version FROM "schema_migrations"  (2.2ms) INSERT INTO "schema_migrations" (version) VALUES ('20140312093436')  (1.2ms) CREATE TABLE "accounts" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "provider" varchar(255), "uid" integer, "name" varchar(255), "oauth_access_token" varchar(255), "oauth_refresh_token" varchar(255), "oauth_expires_at" varchar(255))   (1.1ms) CREATE INDEX "index_accounts_on_uid" ON "accounts" ("uid")  (1.6ms) CREATE TABLE "schema_migrations" ("version" varchar(255) NOT NULL)   (0.9ms) CREATE UNIQUE INDEX "unique_schema_migrations" ON "schema_migrations" ("version")  (0.1ms) SELECT version FROM "schema_migrations"  (0.8ms) INSERT INTO "schema_migrations" (version) VALUES ('20140312093436')  (1.4ms) CREATE TABLE "accounts" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "provider" varchar(255), "uid" integer, "name" varchar(255), "oauth_access_token" varchar(255), "oauth_refresh_token" varchar(255), "oauth_expires_at" varchar(255))   (1.1ms) CREATE INDEX "index_accounts_on_uid" ON "accounts" ("uid")  (1.0ms) CREATE TABLE "schema_migrations" ("version" varchar(255) NOT NULL)   (0.9ms) CREATE UNIQUE INDEX "unique_schema_migrations" ON "schema_migrations" ("version")  (0.3ms) SELECT version FROM "schema_migrations"  (2.1ms) INSERT INTO "schema_migrations" (version) VALUES ('20140312093436')  (1.3ms) CREATE TABLE "accounts" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "provider" varchar(255), "uid" integer, "name" varchar(255), "oauth_access_token" varchar(255), "oauth_refresh_token" varchar(255), "oauth_expires_at" varchar(255))   (0.9ms) CREATE INDEX "index_accounts_on_uid" ON "accounts" ("uid")  (0.8ms) CREATE TABLE "schema_migrations" ("version" varchar(255) NOT NULL)   (0.7ms) CREATE UNIQUE INDEX "unique_schema_migrations" ON "schema_migrations" ("version")  (0.1ms) SELECT version FROM "schema_migrations"  (0.7ms) INSERT INTO "schema_migrations" (version) VALUES ('20140312093436')  (1.3ms) CREATE TABLE "accounts" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "provider" varchar(255), "uid" integer, "name" varchar(255), "oauth_access_token" varchar(255), "oauth_refresh_token" varchar(255), "oauth_expires_at" varchar(255))   (0.9ms) CREATE INDEX "index_accounts_on_uid" ON "accounts" ("uid")  (0.9ms) CREATE TABLE "schema_migrations" ("version" varchar(255) NOT NULL)   (0.7ms) CREATE UNIQUE INDEX "unique_schema_migrations" ON "schema_migrations" ("version")  (0.1ms) SELECT version FROM "schema_migrations"  (0.6ms) INSERT INTO "schema_migrations" (version) VALUES ('20140312093436')  (2.7ms) CREATE TABLE "accounts" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "provider" varchar(255), "uid" integer, "name" varchar(255), "oauth_access_token" varchar(255), "oauth_refresh_token" varchar(255), "oauth_expires_at" varchar(255))   (1.0ms) CREATE INDEX "index_accounts_on_uid" ON "accounts" ("uid")  (1.0ms) CREATE TABLE "schema_migrations" ("version" varchar(255) NOT NULL)   (0.9ms) CREATE UNIQUE INDEX "unique_schema_migrations" ON "schema_migrations" ("version")  (0.1ms) SELECT version FROM "schema_migrations"  (1.6ms) INSERT INTO "schema_migrations" (version) VALUES ('20140312093436')  (1.1ms) CREATE TABLE "accounts" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "provider" varchar(255), "uid" integer, "name" varchar(255), "oauth_access_token" varchar(255), "oauth_refresh_token" varchar(255), "oauth_expires_at" varchar(255))   (0.9ms) CREATE INDEX "index_accounts_on_uid" ON "accounts" ("uid")  (0.9ms) CREATE TABLE "schema_migrations" ("version" varchar(255) NOT NULL)   (0.7ms) CREATE UNIQUE INDEX "unique_schema_migrations" ON "schema_migrations" ("version")  (0.1ms) SELECT version FROM "schema_migrations"  (0.6ms) INSERT INTO "schema_migrations" (version) VALUES ('20140312093436')  (4.3ms) CREATE TABLE "accounts" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "provider" varchar(255), "uid" integer, "name" varchar(255), "oauth_access_token" varchar(255), "oauth_refresh_token" varchar(255), "oauth_expires_at" varchar(255))   (1.0ms) CREATE INDEX "index_accounts_on_uid" ON "accounts" ("uid")  (1.2ms) CREATE TABLE "schema_migrations" ("version" varchar(255) NOT NULL)   (2.9ms) CREATE UNIQUE INDEX "unique_schema_migrations" ON "schema_migrations" ("version")  (0.4ms) SELECT version FROM "schema_migrations"  (1.1ms) INSERT INTO "schema_migrations" (version) VALUES ('20140312093436')  (2.5ms) CREATE TABLE "accounts" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "provider" varchar(255), "uid" integer, "name" varchar(255), "oauth_access_token" varchar(255), "oauth_refresh_token" varchar(255), "oauth_expires_at" varchar(255))   (0.8ms) CREATE INDEX "index_accounts_on_uid" ON "accounts" ("uid")  (0.9ms) CREATE TABLE "schema_migrations" ("version" varchar(255) NOT NULL)   (0.8ms) CREATE UNIQUE INDEX "unique_schema_migrations" ON "schema_migrations" ("version")  (0.1ms) SELECT version FROM "schema_migrations"  (0.7ms) INSERT INTO "schema_migrations" (version) VALUES ('20140312093436')  (0.3ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (2.8ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1  (0.7ms) rollback transaction  (1.1ms) CREATE TABLE "accounts" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "provider" varchar(255), "uid" integer, "name" varchar(255), "oauth_access_token" varchar(255), "oauth_refresh_token" varchar(255), "oauth_expires_at" varchar(255))   (0.9ms) CREATE INDEX "index_accounts_on_uid" ON "accounts" ("uid")  (1.0ms) CREATE TABLE "schema_migrations" ("version" varchar(255) NOT NULL)   (1.0ms) CREATE UNIQUE INDEX "unique_schema_migrations" ON "schema_migrations" ("version")  (0.2ms) SELECT version FROM "schema_migrations"  (0.8ms) INSERT INTO "schema_migrations" (version) VALUES ('20140312093436')  (0.6ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (2.4ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (1.1ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh_token"], ["oauth_expires_at", "expires_at"]]  (0.1ms) RELEASE SAVEPOINT active_record_1  (0.5ms) rollback transaction  (0.4ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (2.8ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (1.0ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh_token"], ["oauth_expires_at", "expires_at"]]  (0.1ms) RELEASE SAVEPOINT active_record_1  (0.5ms) rollback transaction  (0.3ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (2.0ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (1.3ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh_token"], ["oauth_expires_at", "expires_at"]]  (0.1ms) RELEASE SAVEPOINT active_record_1  (2.4ms) rollback transaction  (0.3ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (2.6ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (1.1ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh_token"], ["oauth_expires_at", "expires_at"]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (2.2ms) rollback transaction  (0.1ms) begin transaction  (0.2ms) SAVEPOINT active_record_1 SQL (0.4ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (0.3ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh_token"], ["oauth_expires_at", "expires_at"]]  (0.0ms) RELEASE SAVEPOINT active_record_1  (0.5ms) rollback transaction  (0.3ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (2.3ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (1.1ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh_token"], ["oauth_expires_at", "expires_at"]]  (0.1ms) RELEASE SAVEPOINT active_record_1  (0.5ms) rollback transaction  (0.1ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (0.6ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh_token"], ["oauth_expires_at", "expires_at"]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.5ms) rollback transaction  (0.3ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (2.1ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (1.0ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh_token"], ["oauth_expires_at", "expires_at"]]  (0.1ms) RELEASE SAVEPOINT active_record_1  (2.1ms) rollback transaction  (0.2ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (0.6ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh_token"], ["oauth_expires_at", "expires_at"]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.5ms) rollback transaction  (0.1ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (0.6ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.4ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh_token"], ["oauth_expires_at", "expires_at"]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.5ms) rollback transaction  (0.3ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (2.0ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (0.9ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh_token"], ["oauth_expires_at", "expires_at"]]  (0.1ms) RELEASE SAVEPOINT active_record_1  (2.6ms) rollback transaction  (0.1ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (0.5ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (0.4ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh_token"], ["oauth_expires_at", "expires_at"]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.5ms) rollback transaction  (0.1ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (0.4ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (0.3ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh_token"], ["oauth_expires_at", "expires_at"]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Account Load (0.0ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.5ms) rollback transaction  (0.1ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (0.6ms) INSERT INTO "accounts" ("oauth_access_token", "oauth_expires_at", "oauth_refresh_token") VALUES (?, ?, ?) [["oauth_access_token", "token"], ["oauth_expires_at", "expires"], ["oauth_refresh_token", "refresh"]]  (0.1ms) RELEASE SAVEPOINT active_record_1  (0.1ms) SAVEPOINT active_record_1 SQL (0.4ms) UPDATE "accounts" SET "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["oauth_access_token", nil], ["oauth_refresh_token", nil], ["oauth_expires_at", nil]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.6ms) rollback transaction  (0.4ms) begin transaction  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 8ms (Views: 7.6ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.3ms) begin transaction  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 6ms (Views: 5.9ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.5ms) begin transaction Processing by SessionsController#failure as HTML Rendered /Users/grk/code/bookingsync-engine/app/views/sessions/failure.html.erb within layouts/application (0.3ms) Completed 200 OK in 7ms (Views: 6.3ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 2ms (Views: 1.2ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.3ms) begin transaction Processing by SessionsController#destroy as HTML Completed 500 Internal Server Error in 2ms  (0.1ms) rollback transaction  (0.3ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 1ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.5ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 1ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 1ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 7ms (Views: 6.7ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 1ms (Views: 1.1ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.3ms) begin transaction  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 1ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 1ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 6ms (Views: 5.6ms | ActiveRecord: 0.0ms)  (0.2ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 1ms (Views: 0.8ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.4ms) begin transaction  (0.1ms) rollback transaction  (0.4ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 1ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 1ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 10ms (Views: 9.8ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 1ms (Views: 0.8ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.3ms) begin transaction  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 1ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 1ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 6ms (Views: 6.2ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 1ms (Views: 1.1ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.3ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 1ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 1ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 7ms (Views: 7.1ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 1ms (Views: 0.8ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.3ms) begin transaction  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 1ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 1ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 10ms (Views: 9.2ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 1ms (Views: 0.8ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.3ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 1ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 1ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 6ms (Views: 5.9ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 1ms (Views: 0.8ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.3ms) begin transaction Processing by SessionsController#failure as HTML Rendered /Users/grk/code/bookingsync-engine/app/views/sessions/failure.html.erb within layouts/application (0.3ms) Completed 200 OK in 7ms (Views: 6.0ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 1ms (Views: 0.7ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 0ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 0ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction  (0.1ms) rollback transaction  (0.3ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Completed 500 Internal Server Error in 1ms  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 7ms (Views: 6.6ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 2ms (Views: 1.2ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 1ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 1ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.3ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.5ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123545 ORDER BY "accounts"."id" ASC LIMIT 1 Completed 500 Internal Server Error in 16ms  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 1ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 1ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 7ms (Views: 7.0ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 1ms (Views: 0.8ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.3ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (4.8ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.2ms) RELEASE SAVEPOINT active_record_1 Account Load (0.3ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (1.2ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.6ms) rollback transaction  (0.1ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (0.5ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (0.3ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.4ms) rollback transaction  (0.1ms) begin transaction  (0.2ms) SAVEPOINT active_record_1 SQL (0.4ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (0.4ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"]]  (0.1ms) RELEASE SAVEPOINT active_record_1  (0.5ms) rollback transaction  (0.1ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (0.5ms) INSERT INTO "accounts" ("oauth_access_token", "oauth_expires_at", "oauth_refresh_token") VALUES (?, ?, ?) [["oauth_access_token", "token"], ["oauth_expires_at", "expires"], ["oauth_refresh_token", "refresh"]]  (0.1ms) RELEASE SAVEPOINT active_record_1  (0.1ms) SAVEPOINT active_record_1 SQL (0.7ms) UPDATE "accounts" SET "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["oauth_access_token", nil], ["oauth_refresh_token", nil], ["oauth_expires_at", nil]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.5ms) rollback transaction  (0.3ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (2.2ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (1.0ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (1.7ms) rollback transaction  (0.1ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (0.4ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (0.4ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"]]  (0.1ms) RELEASE SAVEPOINT active_record_1  (0.5ms) rollback transaction  (0.1ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (0.3ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.5ms) rollback transaction  (0.1ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (0.4ms) INSERT INTO "accounts" ("oauth_access_token", "oauth_expires_at", "oauth_refresh_token") VALUES (?, ?, ?) [["oauth_access_token", "token"], ["oauth_expires_at", "expires"], ["oauth_refresh_token", "refresh"]]  (0.0ms) RELEASE SAVEPOINT active_record_1  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) UPDATE "accounts" SET "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["oauth_access_token", nil], ["oauth_refresh_token", nil], ["oauth_expires_at", nil]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.5ms) rollback transaction  (0.6ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (2.0ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (1.4ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (1.8ms) rollback transaction  (0.1ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (0.5ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.2ms) RELEASE SAVEPOINT active_record_1 Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (0.4ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.4ms) rollback transaction  (0.1ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (0.5ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (0.3ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"]]  (0.1ms) RELEASE SAVEPOINT active_record_1  (0.4ms) rollback transaction  (0.1ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (0.5ms) INSERT INTO "accounts" ("oauth_access_token", "oauth_expires_at", "oauth_refresh_token") VALUES (?, ?, ?) [["oauth_access_token", "token"], ["oauth_expires_at", "expires"], ["oauth_refresh_token", "refresh"]]  (0.1ms) RELEASE SAVEPOINT active_record_1  (0.1ms) SAVEPOINT active_record_1 SQL (0.5ms) UPDATE "accounts" SET "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["oauth_access_token", nil], ["oauth_refresh_token", nil], ["oauth_expires_at", nil]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.5ms) rollback transaction  (0.3ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (2.0ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 17ms (ActiveRecord: 3.3ms)  (2.0ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 1ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 1ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 10ms (Views: 10.0ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 2ms (Views: 1.2ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.3ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (3.0ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 23ms (ActiveRecord: 5.1ms)  (2.0ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 4ms (ActiveRecord: 0.6ms)  (0.4ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 1ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 1ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 6ms (Views: 5.9ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 1ms (Views: 0.8ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.3ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 1ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 1ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (2.0ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 19ms (ActiveRecord: 3.3ms)  (2.0ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.3ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 4ms (ActiveRecord: 0.7ms)  (0.4ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 4ms (ActiveRecord: 0.6ms)  (0.4ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 7ms (Views: 7.0ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 1ms (Views: 0.8ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.4ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (3.1ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 22ms (ActiveRecord: 4.6ms)  (0.4ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.3ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (0.4ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 4ms (ActiveRecord: 0.8ms)  (0.4ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.3ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 4ms (ActiveRecord: 0.8ms)  (0.6ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 10ms (Views: 9.6ms | ActiveRecord: 0.0ms)  (0.2ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 2ms (Views: 1.2ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 1ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 1ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.3ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (2.1ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 18ms (ActiveRecord: 3.4ms)  (1.7ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.3ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 4ms (ActiveRecord: 0.7ms)  (0.4ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 4ms (ActiveRecord: 0.6ms)  (0.5ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 1ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 1ms (ActiveRecord: 0.0ms)  (0.2ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 8ms (Views: 7.2ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 1ms (Views: 0.8ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.3ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (2.1ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 22ms (ActiveRecord: 3.6ms)  (0.4ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 3ms (ActiveRecord: 0.6ms)  (0.3ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 3ms (ActiveRecord: 0.5ms)  (0.5ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 0ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 0ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 7ms (Views: 6.5ms | ActiveRecord: 0.0ms)  (0.2ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 1ms (Views: 0.8ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (0.4ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (1.1ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"]]  (0.1ms) RELEASE SAVEPOINT active_record_1  (0.4ms) rollback transaction  (0.1ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (0.3ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.5ms) rollback transaction  (0.1ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (0.3ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.4ms) rollback transaction  (0.1ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("oauth_access_token", "oauth_expires_at", "oauth_refresh_token") VALUES (?, ?, ?) [["oauth_access_token", "token"], ["oauth_expires_at", "expires"], ["oauth_refresh_token", "refresh"]]  (0.0ms) RELEASE SAVEPOINT active_record_1  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) UPDATE "accounts" SET "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["oauth_access_token", nil], ["oauth_refresh_token", nil], ["oauth_expires_at", nil]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.4ms) rollback transaction  (0.4ms) begin transaction Processing by SessionsController#failure as HTML Rendered /Users/grk/code/bookingsync-engine/app/views/sessions/failure.html.erb within layouts/application (0.3ms) Completed 200 OK in 7ms (Views: 6.5ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 1ms (Views: 0.8ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 0ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 0ms (ActiveRecord: 0.0ms)  (0.2ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (2.2ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 17ms (ActiveRecord: 3.5ms)  (2.4ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (0.5ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.8ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 5ms (ActiveRecord: 1.6ms)  (0.4ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 3ms (ActiveRecord: 0.7ms)  (0.4ms) rollback transaction  (0.1ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (0.4ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (1.0ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.4ms) rollback transaction  (0.1ms) begin transaction  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.2ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Account Load (0.0ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.4ms) rollback transaction  (0.1ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"]]  (0.0ms) RELEASE SAVEPOINT active_record_1  (0.4ms) rollback transaction  (0.1ms) begin transaction  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("oauth_access_token", "oauth_expires_at", "oauth_refresh_token") VALUES (?, ?, ?) [["oauth_access_token", "token"], ["oauth_expires_at", "expires"], ["oauth_refresh_token", "refresh"]]  (0.1ms) RELEASE SAVEPOINT active_record_1  (0.0ms) SAVEPOINT active_record_1 SQL (0.4ms) UPDATE "accounts" SET "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["oauth_access_token", nil], ["oauth_refresh_token", nil], ["oauth_expires_at", nil]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.5ms) rollback transaction  (0.4ms) begin transaction Processing by SessionsController#failure as HTML Rendered /Users/grk/code/bookingsync-engine/app/views/sessions/failure.html.erb within layouts/application (0.3ms) Completed 200 OK in 7ms (Views: 6.2ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 1ms (Views: 1.2ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 1ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 0ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (2.6ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 19ms (ActiveRecord: 3.9ms)  (100.5ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 3ms (ActiveRecord: 0.5ms)  (0.5ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 3ms (ActiveRecord: 0.7ms)  (0.4ms) rollback transaction  (0.3ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (2.4ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 17ms (ActiveRecord: 3.7ms)  (2.2ms) rollback transaction  (0.2ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 3ms (ActiveRecord: 0.6ms)  (0.4ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 3ms (ActiveRecord: 0.6ms)  (0.4ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 0ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 0ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.0ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 14ms (Views: 13.9ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 1ms (Views: 0.7ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.3ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (2.4ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 17ms (ActiveRecord: 3.7ms)  (100.9ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 3ms (ActiveRecord: 0.6ms)  (0.4ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (0.5ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 4ms (ActiveRecord: 0.9ms)  (0.4ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 1ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 0ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.0ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 17ms (Views: 16.3ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 1ms (Views: 1.2ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.3ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (0.4ms) INSERT INTO "accounts" ("oauth_access_token", "oauth_expires_at", "oauth_refresh_token") VALUES (?, ?, ?) [["oauth_access_token", "token"], ["oauth_expires_at", "expires"], ["oauth_refresh_token", "refresh"]]  (0.1ms) RELEASE SAVEPOINT active_record_1  (0.0ms) SAVEPOINT active_record_1 SQL (3.4ms) UPDATE "accounts" SET "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["oauth_access_token", nil], ["oauth_refresh_token", nil], ["oauth_expires_at", nil]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (2.8ms) rollback transaction  (0.1ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.4ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Account Load (0.0ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.6ms) rollback transaction  (0.1ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.0ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.5ms) rollback transaction  (0.1ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"]]  (0.1ms) RELEASE SAVEPOINT active_record_1  (0.4ms) rollback transaction  (0.0ms) begin transaction Processing by SessionsController#failure as HTML Rendered /Users/grk/code/bookingsync-engine/app/views/sessions/failure.html.erb within layouts/application (0.3ms) Completed 200 OK in 8ms (Views: 7.8ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 1ms (Views: 0.8ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.0ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 0ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 0ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.0ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 3ms (ActiveRecord: 0.6ms)  (0.4ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 2ms (ActiveRecord: 0.5ms)  (0.4ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 3ms (ActiveRecord: 0.6ms)  (0.4ms) rollback transaction  (0.5ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 1ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 0ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 6ms (Views: 6.0ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 1ms (Views: 0.7ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.0ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (2.2ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 17ms (ActiveRecord: 3.5ms)  (2.2ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 3ms (ActiveRecord: 0.6ms)  (0.4ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 3ms (ActiveRecord: 0.6ms)  (0.4ms) rollback transaction  (0.1ms) begin transaction  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (1.3ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.5ms) rollback transaction  (0.1ms) begin transaction  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Account Load (0.0ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.4ms) rollback transaction  (0.1ms) begin transaction  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"]]  (0.0ms) RELEASE SAVEPOINT active_record_1  (0.5ms) rollback transaction  (0.1ms) begin transaction  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("oauth_access_token", "oauth_expires_at", "oauth_refresh_token") VALUES (?, ?, ?) [["oauth_access_token", "token"], ["oauth_expires_at", "expires"], ["oauth_refresh_token", "refresh"]]  (0.1ms) RELEASE SAVEPOINT active_record_1  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) UPDATE "accounts" SET "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["oauth_access_token", nil], ["oauth_refresh_token", nil], ["oauth_expires_at", nil]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Account Load (0.0ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.4ms) rollback transaction  (0.3ms) begin transaction Processing by SessionsController#failure as HTML Rendered /Users/grk/code/bookingsync-engine/app/views/sessions/failure.html.erb within layouts/application (0.3ms) Completed 200 OK in 7ms (Views: 6.1ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 1ms (Views: 0.7ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 0ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 0ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.0ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (2.4ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 22ms (ActiveRecord: 4.3ms)  (2.3ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 3ms (ActiveRecord: 0.6ms)  (0.4ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 3ms (ActiveRecord: 0.6ms)  (0.4ms) rollback transaction  (0.4ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (0.4ms) INSERT INTO "accounts" ("oauth_access_token", "oauth_expires_at", "oauth_refresh_token") VALUES (?, ?, ?) [["oauth_access_token", "token"], ["oauth_expires_at", "expires"], ["oauth_refresh_token", "refresh"]]  (0.1ms) RELEASE SAVEPOINT active_record_1  (0.0ms) SAVEPOINT active_record_1 SQL (3.3ms) UPDATE "accounts" SET "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["oauth_access_token", nil], ["oauth_refresh_token", nil], ["oauth_expires_at", nil]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (2.2ms) rollback transaction  (0.1ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (0.4ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (0.4ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"]]  (0.1ms) RELEASE SAVEPOINT active_record_1  (0.6ms) rollback transaction  (0.1ms) begin transaction  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.4ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.5ms) rollback transaction  (0.1ms) begin transaction  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Account Load (0.0ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.4ms) rollback transaction  (0.0ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 3ms (ActiveRecord: 0.6ms)  (0.4ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.2ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 3ms (ActiveRecord: 0.5ms)  (0.4ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 3ms (ActiveRecord: 0.6ms)  (0.4ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 0ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 0ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 7ms (Views: 6.6ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.0ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 1ms (Views: 0.7ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.3ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (2.3ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 17ms (ActiveRecord: 3.7ms)  (99.6ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 3ms (ActiveRecord: 0.6ms)  (0.6ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 3ms (ActiveRecord: 0.6ms)  (0.4ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 1ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 0ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 7ms (Views: 6.5ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 1ms (Views: 0.8ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.3ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (2.3ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 17ms (ActiveRecord: 3.6ms)  (99.8ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.4ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 3ms (ActiveRecord: 0.7ms)  (0.4ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/admin Completed 302 Found in 3ms (ActiveRecord: 0.6ms)  (0.4ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 0ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 0ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 9ms (Views: 9.0ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 1ms (Views: 0.8ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.3ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (2.3ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/admin Completed 302 Found in 17ms (ActiveRecord: 3.6ms)  (2.6ms) rollback transaction  (0.4ms) begin transaction Processing by SessionsController#failure as HTML Rendered /Users/grk/code/bookingsync-engine/app/views/sessions/failure.html.erb within layouts/application (0.3ms) Completed 200 OK in 9ms (Views: 8.2ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 1ms (Views: 0.8ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.4ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (3.1ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/admin Completed 302 Found in 21ms (ActiveRecord: 5.2ms)  (0.4ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 3ms (ActiveRecord: 0.6ms)  (0.4ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 3ms (ActiveRecord: 0.6ms)  (0.5ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 0ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 1ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.3ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (2.3ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 16ms (ActiveRecord: 3.6ms)  (0.6ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 3ms (ActiveRecord: 0.6ms)  (0.7ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/admin Completed 302 Found in 2ms (ActiveRecord: 0.5ms)  (0.5ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 1ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.0ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 0ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.0ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 6ms (Views: 6.1ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 1ms (Views: 0.8ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.0ms) begin transaction  (0.0ms) SAVEPOINT active_record_1 SQL (0.4ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (1.1ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"]]  (0.1ms) RELEASE SAVEPOINT active_record_1  (0.5ms) rollback transaction  (0.1ms) begin transaction  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.4ms) rollback transaction  (0.1ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Account Load (0.0ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.5ms) rollback transaction  (0.1ms) begin transaction  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("oauth_access_token", "oauth_expires_at", "oauth_refresh_token") VALUES (?, ?, ?) [["oauth_access_token", "token"], ["oauth_expires_at", "expires"], ["oauth_refresh_token", "refresh"]]  (0.0ms) RELEASE SAVEPOINT active_record_1  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) UPDATE "accounts" SET "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["oauth_access_token", nil], ["oauth_refresh_token", nil], ["oauth_expires_at", nil]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Account Load (0.0ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.4ms) rollback transaction  (0.5ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/signed_out Completed 302 Found in 1ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.4ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (2.8ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 24ms (ActiveRecord: 4.7ms)  (0.5ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 3ms (ActiveRecord: 0.6ms)  (0.4ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/admin Completed 302 Found in 2ms (ActiveRecord: 0.6ms)  (0.4ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 0ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.0ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/signed_out Completed 302 Found in 0ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 6ms (Views: 6.1ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.0ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 1ms (Views: 0.7ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.0ms) begin transaction  (0.0ms) SAVEPOINT active_record_1 SQL (0.4ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (1.3ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"]]  (0.1ms) RELEASE SAVEPOINT active_record_1  (0.5ms) rollback transaction  (0.1ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.3ms) rollback transaction  (0.1ms) begin transaction  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.5ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.4ms) rollback transaction  (0.0ms) begin transaction  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("oauth_access_token", "oauth_expires_at", "oauth_refresh_token") VALUES (?, ?, ?) [["oauth_access_token", "token"], ["oauth_expires_at", "expires"], ["oauth_refresh_token", "refresh"]]  (0.0ms) RELEASE SAVEPOINT active_record_1  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) UPDATE "accounts" SET "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["oauth_access_token", nil], ["oauth_refresh_token", nil], ["oauth_expires_at", nil]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Account Load (0.0ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.4ms) rollback transaction  (0.4ms) begin transaction Processing by SessionsController#failure as HTML Rendered /Users/grk/code/bookingsync-engine/app/views/sessions/failure.html.erb within layouts/application (0.4ms) Completed 200 OK in 10ms (Views: 9.1ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 1ms (Views: 0.8ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.0ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.3ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (3.5ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/admin Completed 302 Found in 20ms (ActiveRecord: 5.4ms)  (1.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (0.4ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 4ms (ActiveRecord: 0.8ms)  (0.5ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 3ms (ActiveRecord: 0.5ms)  (0.4ms) rollback transaction  (0.0ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 0ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/signed_out Completed 302 Found in 1ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (1.0ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.4ms) rollback transaction  (0.1ms) begin transaction  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.2ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"]]  (0.0ms) RELEASE SAVEPOINT active_record_1  (0.4ms) rollback transaction  (0.1ms) begin transaction  (0.0ms) SAVEPOINT active_record_1 SQL (0.4ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.4ms) rollback transaction  (0.1ms) begin transaction  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("oauth_access_token", "oauth_expires_at", "oauth_refresh_token") VALUES (?, ?, ?) [["oauth_access_token", "token"], ["oauth_expires_at", "expires"], ["oauth_refresh_token", "refresh"]]  (0.0ms) RELEASE SAVEPOINT active_record_1  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) UPDATE "accounts" SET "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["oauth_access_token", nil], ["oauth_refresh_token", nil], ["oauth_expires_at", nil]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.4ms) rollback transaction  (0.3ms) begin transaction Processing by SessionsController#failure as HTML Rendered /Users/grk/code/bookingsync-engine/app/views/sessions/failure.html.erb within layouts/application (0.3ms) Completed 200 OK in 8ms (Views: 8.0ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 1ms (Views: 0.7ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 0ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/signed_out Completed 302 Found in 0ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.5ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (3.9ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/admin Completed 302 Found in 24ms (ActiveRecord: 6.4ms)  (0.4ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 3ms (ActiveRecord: 0.6ms)  (0.5ms) rollback transaction  (0.2ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 3ms (ActiveRecord: 0.6ms)  (0.4ms) rollback transaction  (0.1ms) begin transaction  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (1.1ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.4ms) rollback transaction  (0.0ms) begin transaction  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (0.4ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.0ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.4ms) rollback transaction  (0.1ms) begin transaction  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"]]  (0.0ms) RELEASE SAVEPOINT active_record_1  (0.4ms) rollback transaction  (0.0ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("oauth_access_token", "oauth_expires_at", "oauth_refresh_token") VALUES (?, ?, ?) [["oauth_access_token", "token"], ["oauth_expires_at", "expires"], ["oauth_refresh_token", "refresh"]]  (0.0ms) RELEASE SAVEPOINT active_record_1  (0.0ms) SAVEPOINT active_record_1 SQL (0.4ms) UPDATE "accounts" SET "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["oauth_access_token", nil], ["oauth_refresh_token", nil], ["oauth_expires_at", nil]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.8ms) rollback transaction  (0.3ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 1ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/signed_out Completed 302 Found in 0ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.4ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (3.1ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 21ms (ActiveRecord: 5.8ms)  (1.6ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 3ms (ActiveRecord: 0.6ms)  (0.4ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/admin Completed 302 Found in 3ms (ActiveRecord: 0.7ms)  (0.4ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 12ms (Views: 11.5ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.0ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 1ms (Views: 0.8ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (0.4ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (1.5ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.6ms) rollback transaction  (0.1ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (0.8ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"]]  (0.1ms) RELEASE SAVEPOINT active_record_1  (0.4ms) rollback transaction  (0.1ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Account Load (0.0ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.4ms) rollback transaction  (0.1ms) begin transaction  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("oauth_access_token", "oauth_expires_at", "oauth_refresh_token") VALUES (?, ?, ?) [["oauth_access_token", "token"], ["oauth_expires_at", "expires"], ["oauth_refresh_token", "refresh"]]  (0.0ms) RELEASE SAVEPOINT active_record_1  (0.0ms) SAVEPOINT active_record_1 SQL (0.7ms) UPDATE "accounts" SET "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["oauth_access_token", nil], ["oauth_refresh_token", nil], ["oauth_expires_at", nil]]  (0.2ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.5ms) rollback transaction  (0.4ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.3ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (3.3ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 21ms (ActiveRecord: 5.1ms)  (0.4ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/admin Completed 302 Found in 2ms (ActiveRecord: 0.5ms)  (0.5ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 3ms (ActiveRecord: 0.6ms)  (0.4ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 9ms (Views: 8.4ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 1ms (Views: 0.8ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 0ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.2ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/signed_out Completed 302 Found in 0ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (0.4ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (6.3ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"]]  (0.1ms) RELEASE SAVEPOINT active_record_1  (0.6ms) rollback transaction  (0.1ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (0.5ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (0.4ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.4ms) rollback transaction  (0.1ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (0.4ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (0.4ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.7ms) rollback transaction  (0.1ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (0.5ms) INSERT INTO "accounts" ("oauth_access_token", "oauth_expires_at", "oauth_refresh_token") VALUES (?, ?, ?) [["oauth_access_token", "token"], ["oauth_expires_at", "expires"], ["oauth_refresh_token", "refresh"]]  (0.1ms) RELEASE SAVEPOINT active_record_1  (0.1ms) SAVEPOINT active_record_1 SQL (0.5ms) UPDATE "accounts" SET "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["oauth_access_token", nil], ["oauth_refresh_token", nil], ["oauth_expires_at", nil]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.5ms) rollback transaction  (1.1ms) CREATE TABLE "accounts" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "provider" varchar(255), "uid" integer, "name" varchar(255), "oauth_access_token" varchar(255), "oauth_refresh_token" varchar(255), "oauth_expires_at" varchar(255))   (0.8ms) CREATE INDEX "index_accounts_on_uid" ON "accounts" ("uid")  (0.7ms) CREATE TABLE "schema_migrations" ("version" varchar(255) NOT NULL)   (0.6ms) CREATE UNIQUE INDEX "unique_schema_migrations" ON "schema_migrations" ("version")  (0.1ms) SELECT version FROM "schema_migrations"  (0.8ms) INSERT INTO "schema_migrations" (version) VALUES ('20140312093436')  (0.3ms) begin transaction Processing by SessionsController#failure as HTML Rendered /Users/grk/code/bookingsync-engine/app/views/sessions/failure.html.erb within layouts/application (0.3ms) Completed 200 OK in 9ms (Views: 8.2ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.0ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 1ms (Views: 0.7ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.0ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 0ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/signed_out Completed 302 Found in 0ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.0ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (3.1ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/admin Completed 302 Found in 24ms (ActiveRecord: 4.6ms)  (0.4ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 3ms (ActiveRecord: 0.6ms)  (0.3ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.2ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 3ms (ActiveRecord: 0.6ms)  (0.3ms) rollback transaction  (0.1ms) begin transaction  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (1.0ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.5ms) rollback transaction  (0.1ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Account Load (0.0ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.4ms) rollback transaction  (0.0ms) begin transaction  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"]]  (0.0ms) RELEASE SAVEPOINT active_record_1  (0.4ms) rollback transaction  (0.1ms) begin transaction  (0.0ms) SAVEPOINT active_record_1 SQL (0.4ms) INSERT INTO "accounts" ("oauth_access_token", "oauth_expires_at", "oauth_refresh_token") VALUES (?, ?, ?) [["oauth_access_token", "token"], ["oauth_expires_at", "expires"], ["oauth_refresh_token", "refresh"]]  (0.0ms) RELEASE SAVEPOINT active_record_1  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) UPDATE "accounts" SET "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["oauth_access_token", nil], ["oauth_refresh_token", nil], ["oauth_expires_at", nil]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Account Load (0.0ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.6ms) rollback transaction  (0.4ms) begin transaction Processing by SessionsController#failure as HTML Rendered /Users/grk/code/bookingsync-engine/app/views/sessions/failure.html.erb within layouts/application (0.3ms) Completed 200 OK in 6ms (Views: 6.1ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 1ms (Views: 0.7ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 0ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.0ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/signed_out Completed 302 Found in 0ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (3.0ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/admin Completed 302 Found in 21ms (ActiveRecord: 4.3ms)  (2.3ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 3ms (ActiveRecord: 0.7ms)  (1.0ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 2ms (ActiveRecord: 0.6ms)  (0.5ms) rollback transaction  (0.1ms) begin transaction  (0.0ms) SAVEPOINT active_record_1 SQL (0.4ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (1.0ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.6ms) rollback transaction  (0.1ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.4ms) rollback transaction  (0.1ms) begin transaction  (0.0ms) SAVEPOINT active_record_1 SQL (0.4ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"]]  (0.0ms) RELEASE SAVEPOINT active_record_1  (0.4ms) rollback transaction  (0.1ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("oauth_access_token", "oauth_expires_at", "oauth_refresh_token") VALUES (?, ?, ?) [["oauth_access_token", "token"], ["oauth_expires_at", "expires"], ["oauth_refresh_token", "refresh"]]  (0.0ms) RELEASE SAVEPOINT active_record_1  (0.0ms) SAVEPOINT active_record_1 SQL (0.4ms) UPDATE "accounts" SET "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["oauth_access_token", nil], ["oauth_refresh_token", nil], ["oauth_expires_at", nil]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.5ms) rollback transaction  (0.3ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.4ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (3.2ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 24ms (ActiveRecord: 5.6ms)  (0.4ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (0.4ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 3ms (ActiveRecord: 0.7ms)  (0.7ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/admin Completed 302 Found in 3ms (ActiveRecord: 0.6ms)  (0.5ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 0ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/signed_out Completed 302 Found in 0ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 8ms (Views: 8.2ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 1ms (Views: 0.9ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.0ms) begin transaction  (0.0ms) SAVEPOINT active_record_1 SQL (0.4ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (1.3ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"]]  (0.1ms) RELEASE SAVEPOINT active_record_1  (0.5ms) rollback transaction  (0.1ms) begin transaction  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (0.3ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.4ms) rollback transaction  (0.1ms) begin transaction  (0.0ms) SAVEPOINT active_record_1 SQL (0.4ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.5ms) rollback transaction  (0.0ms) begin transaction  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("oauth_access_token", "oauth_expires_at", "oauth_refresh_token") VALUES (?, ?, ?) [["oauth_access_token", "token"], ["oauth_expires_at", "expires"], ["oauth_refresh_token", "refresh"]]  (0.0ms) RELEASE SAVEPOINT active_record_1  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) UPDATE "accounts" SET "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["oauth_access_token", nil], ["oauth_refresh_token", nil], ["oauth_expires_at", nil]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.4ms) rollback transaction  (0.4ms) begin transaction Processing by SessionsController#failure as HTML Rendered /Users/grk/code/bookingsync-engine/app/views/sessions/failure.html.erb within layouts/application (0.3ms) Completed 200 OK in 9ms (Views: 8.7ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 1ms (Views: 0.9ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 1ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.0ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/signed_out Completed 302 Found in 0ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.0ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (2.6ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/admin Completed 302 Found in 18ms (ActiveRecord: 4.0ms)  (0.4ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.2ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 2ms (ActiveRecord: 0.5ms)  (0.4ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 3ms (ActiveRecord: 0.5ms)  (0.4ms) rollback transaction  (0.1ms) begin transaction  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (0.9ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.4ms) rollback transaction  (0.1ms) begin transaction  (0.0ms) SAVEPOINT active_record_1 SQL (0.4ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Account Load (0.0ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.4ms) rollback transaction  (0.1ms) begin transaction  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.2ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"]]  (0.0ms) RELEASE SAVEPOINT active_record_1  (0.4ms) rollback transaction  (0.1ms) begin transaction  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("oauth_access_token", "oauth_expires_at", "oauth_refresh_token") VALUES (?, ?, ?) [["oauth_access_token", "token"], ["oauth_expires_at", "expires"], ["oauth_refresh_token", "refresh"]]  (0.0ms) RELEASE SAVEPOINT active_record_1  (0.0ms) SAVEPOINT active_record_1 SQL (0.9ms) UPDATE "accounts" SET "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["oauth_access_token", nil], ["oauth_refresh_token", nil], ["oauth_expires_at", nil]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.5ms) rollback transaction  (0.4ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (0.5ms) INSERT INTO "accounts" ("oauth_access_token", "oauth_expires_at", "oauth_refresh_token") VALUES (?, ?, ?) [["oauth_access_token", "token"], ["oauth_expires_at", "expires"], ["oauth_refresh_token", "refresh"]]  (0.0ms) RELEASE SAVEPOINT active_record_1  (0.0ms) SAVEPOINT active_record_1 SQL (3.9ms) UPDATE "accounts" SET "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["oauth_access_token", nil], ["oauth_refresh_token", nil], ["oauth_expires_at", nil]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.9ms) rollback transaction  (0.1ms) begin transaction  (0.0ms) SAVEPOINT active_record_1 SQL (0.4ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (0.3ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Account Load (0.0ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.5ms) rollback transaction  (0.1ms) begin transaction  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.6ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"]]  (0.1ms) RELEASE SAVEPOINT active_record_1  (0.6ms) rollback transaction  (0.1ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (0.5ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (0.8ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.7ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/signed_out Completed 302 Found in 1ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 0ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.3ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (0.4ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 4ms (ActiveRecord: 0.9ms)  (0.4ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 3ms (ActiveRecord: 0.5ms)  (0.4ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.2ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/admin Completed 302 Found in 3ms (ActiveRecord: 0.6ms)  (0.5ms) rollback transaction  (0.2ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 13ms (Views: 12.7ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 1ms (Views: 1.0ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.4ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (0.6ms) INSERT INTO "accounts" ("oauth_access_token", "oauth_expires_at", "oauth_refresh_token") VALUES (?, ?, ?) [["oauth_access_token", "token"], ["oauth_expires_at", "expires"], ["oauth_refresh_token", "refresh"]]  (0.1ms) RELEASE SAVEPOINT active_record_1  (0.0ms) SAVEPOINT active_record_1 SQL (3.8ms) UPDATE "accounts" SET "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["oauth_access_token", nil], ["oauth_refresh_token", nil], ["oauth_expires_at", nil]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.9ms) rollback transaction  (0.1ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"]]  (0.0ms) RELEASE SAVEPOINT active_record_1  (0.4ms) rollback transaction  (0.1ms) begin transaction  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.4ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.4ms) rollback transaction  (0.1ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.4ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (0.4ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 3ms (ActiveRecord: 0.7ms)  (0.4ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/admin Completed 302 Found in 3ms (ActiveRecord: 0.6ms)  (0.5ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.4ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 4ms (ActiveRecord: 0.8ms)  (0.5ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 9ms (Views: 9.2ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 1ms (Views: 0.8ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.0ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/signed_out Completed 302 Found in 0ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.0ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 0ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.4ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.4ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (3.7ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 25ms (ActiveRecord: 6.1ms)  (0.4ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.4ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 3ms (ActiveRecord: 0.6ms)  (0.4ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (0.4ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/admin Completed 302 Found in 4ms (ActiveRecord: 0.8ms)  (0.5ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 0ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/signed_out Completed 302 Found in 0ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 10ms (Views: 9.4ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 1ms (Views: 0.8ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction  (0.0ms) SAVEPOINT active_record_1 SQL (0.4ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (1.5ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"]]  (0.1ms) RELEASE SAVEPOINT active_record_1  (0.5ms) rollback transaction  (0.1ms) begin transaction  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (0.5ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.3ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.5ms) rollback transaction  (0.1ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (0.4ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Account Load (0.0ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.5ms) rollback transaction  (0.1ms) begin transaction  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("oauth_access_token", "oauth_expires_at", "oauth_refresh_token") VALUES (?, ?, ?) [["oauth_access_token", "token"], ["oauth_expires_at", "expires"], ["oauth_refresh_token", "refresh"]]  (0.0ms) RELEASE SAVEPOINT active_record_1  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) UPDATE "accounts" SET "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["oauth_access_token", nil], ["oauth_refresh_token", nil], ["oauth_expires_at", nil]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Account Load (0.0ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.3ms) rollback transaction  (0.5ms) begin transaction Processing by SessionsController#failure as HTML Rendered /Users/grk/code/bookingsync-engine/app/views/sessions/failure.html.erb within layouts/application (0.3ms) Completed 200 OK in 8ms (Views: 8.1ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 1ms (Views: 0.8ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 0ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/signed_out Completed 302 Found in 0ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.0ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (3.2ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/admin Completed 302 Found in 19ms (ActiveRecord: 4.9ms)  (0.7ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (0.5ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 3ms (ActiveRecord: 0.8ms)  (0.4ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid") VALUES (?, ?, ?, ?, ?, ?) [["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 3ms (ActiveRecord: 0.6ms)  (0.5ms) rollback transaction  (0.1ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (0.5ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (1.0ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.5ms) rollback transaction  (0.1ms) begin transaction  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (0.3ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Account Load (0.0ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.5ms) rollback transaction  (0.1ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "accounts" ("provider", "uid") VALUES (?, ?) [["provider", "bookingsync"], ["uid", 123]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"]]  (0.0ms) RELEASE SAVEPOINT active_record_1  (0.5ms) rollback transaction  (0.1ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (0.4ms) INSERT INTO "accounts" ("oauth_access_token", "oauth_expires_at", "oauth_refresh_token") VALUES (?, ?, ?) [["oauth_access_token", "token"], ["oauth_expires_at", "expires"], ["oauth_refresh_token", "refresh"]]  (0.1ms) RELEASE SAVEPOINT active_record_1  (0.1ms) SAVEPOINT active_record_1 SQL (0.5ms) UPDATE "accounts" SET "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ? WHERE "accounts"."id" = 1 [["oauth_access_token", nil], ["oauth_refresh_token", nil], ["oauth_expires_at", nil]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.5ms) rollback transaction  (0.3ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1 SQLite3::SQLException: no such table: accounts: SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1 Completed 500 Internal Server Error in 6ms  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1 SQLite3::SQLException: no such table: accounts: SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1 Completed 500 Internal Server Error in 1ms  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1 SQLite3::SQLException: no such table: accounts: SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1 Completed 500 Internal Server Error in 1ms  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 8ms (Views: 8.0ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 1ms (Views: 0.7ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 0ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/signed_out Completed 302 Found in 0ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction  (0.0ms) rollback transaction  (0.0ms) begin transaction  (0.0ms) rollback transaction  (0.0ms) begin transaction  (0.0ms) rollback transaction  (0.0ms) begin transaction  (0.0ms) rollback transaction  (3.3ms) CREATE TABLE "accounts" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "created_at" datetime, "updated_at" datetime, "provider" varchar(255), "uid" integer, "name" varchar(255), "oauth_access_token" varchar(255), "oauth_refresh_token" varchar(255), "oauth_expires_at" varchar(255))   (1.1ms) CREATE INDEX "index_accounts_on_uid" ON "accounts" ("uid")  (0.8ms) CREATE TABLE "schema_migrations" ("version" varchar(255) NOT NULL)   (0.7ms) CREATE UNIQUE INDEX "unique_schema_migrations" ON "schema_migrations" ("version")  (0.2ms) SELECT version FROM "schema_migrations"  (0.9ms) INSERT INTO "schema_migrations" (version) VALUES ('20140522110454')  (0.9ms) INSERT INTO "schema_migrations" (version) VALUES ('20140522110326') ActiveRecord::SchemaMigration Load (0.2ms) SELECT "schema_migrations".* FROM "schema_migrations"  (0.3ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (7.8ms) INSERT INTO "accounts" ("created_at", "name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid", "updated_at") VALUES (?, ?, ?, ?, ?, ?, ?, ?) [["created_at", Thu, 22 May 2014 11:09:58 UTC +00:00], ["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123], ["updated_at", Thu, 22 May 2014 11:09:58 UTC +00:00]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 24ms (ActiveRecord: 9.2ms)  (0.7ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (0.8ms) INSERT INTO "accounts" ("created_at", "name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid", "updated_at") VALUES (?, ?, ?, ?, ?, ?, ?, ?) [["created_at", Thu, 22 May 2014 11:09:58 UTC +00:00], ["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123], ["updated_at", Thu, 22 May 2014 11:09:58 UTC +00:00]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 4ms (ActiveRecord: 1.2ms)  (0.4ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.5ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (0.5ms) INSERT INTO "accounts" ("created_at", "name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid", "updated_at") VALUES (?, ?, ?, ?, ?, ?, ?, ?) [["created_at", Thu, 22 May 2014 11:09:58 UTC +00:00], ["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123], ["updated_at", Thu, 22 May 2014 11:09:58 UTC +00:00]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/admin Completed 302 Found in 6ms (ActiveRecord: 1.1ms)  (0.4ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 1ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/signed_out Completed 302 Found in 1ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 8ms (Views: 8.0ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 1ms (Views: 0.8ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction  (0.0ms) SAVEPOINT active_record_1 SQL (0.6ms) INSERT INTO "accounts" ("created_at", "provider", "uid", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Thu, 22 May 2014 11:09:58 UTC +00:00], ["provider", "bookingsync"], ["uid", 123], ["updated_at", Thu, 22 May 2014 11:09:58 UTC +00:00]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (1.3ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ?, "updated_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"], ["updated_at", Thu, 22 May 2014 11:09:58 UTC +00:00]]  (0.1ms) RELEASE SAVEPOINT active_record_1  (0.5ms) rollback transaction  (0.1ms) begin transaction  (0.0ms) SAVEPOINT active_record_1 SQL (0.8ms) INSERT INTO "accounts" ("created_at", "provider", "uid", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Thu, 22 May 2014 11:09:58 UTC +00:00], ["provider", "bookingsync"], ["uid", 123], ["updated_at", Thu, 22 May 2014 11:09:58 UTC +00:00]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (0.6ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ?, "updated_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"], ["updated_at", Thu, 22 May 2014 11:09:58 UTC +00:00]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.3ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.5ms) rollback transaction  (0.1ms) begin transaction  (0.2ms) SAVEPOINT active_record_1 SQL (0.6ms) INSERT INTO "accounts" ("created_at", "provider", "uid", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Thu, 22 May 2014 11:09:58 UTC +00:00], ["provider", "bookingsync"], ["uid", 123], ["updated_at", Thu, 22 May 2014 11:09:58 UTC +00:00]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.0ms) SAVEPOINT active_record_1 SQL (0.4ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ?, "updated_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"], ["updated_at", Thu, 22 May 2014 11:09:58 UTC +00:00]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.4ms) rollback transaction  (0.1ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (1.1ms) INSERT INTO "accounts" ("created_at", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "updated_at") VALUES (?, ?, ?, ?, ?) [["created_at", Thu, 22 May 2014 11:09:58 UTC +00:00], ["oauth_access_token", "token"], ["oauth_expires_at", "expires"], ["oauth_refresh_token", "refresh"], ["updated_at", Thu, 22 May 2014 11:09:58 UTC +00:00]]  (0.2ms) RELEASE SAVEPOINT active_record_1  (0.3ms) SAVEPOINT active_record_1 SQL (0.8ms) UPDATE "accounts" SET "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ?, "updated_at" = ? WHERE "accounts"."id" = 1 [["oauth_access_token", nil], ["oauth_refresh_token", nil], ["oauth_expires_at", nil], ["updated_at", Thu, 22 May 2014 11:09:58 UTC +00:00]]  (0.3ms) RELEASE SAVEPOINT active_record_1 Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.5ms) rollback transaction  (0.4ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.5ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (5.6ms) INSERT INTO "accounts" ("created_at", "name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid", "updated_at") VALUES (?, ?, ?, ?, ?, ?, ?, ?) [["created_at", Fri, 23 May 2014 13:38:30 UTC +00:00], ["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123], ["updated_at", Fri, 23 May 2014 13:38:30 UTC +00:00]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 26ms (ActiveRecord: 7.8ms)  (0.8ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (0.4ms) INSERT INTO "accounts" ("created_at", "name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid", "updated_at") VALUES (?, ?, ?, ?, ?, ?, ?, ?) [["created_at", Fri, 23 May 2014 13:38:30 UTC +00:00], ["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123], ["updated_at", Fri, 23 May 2014 13:38:30 UTC +00:00]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 3ms (ActiveRecord: 0.7ms)  (0.4ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (0.4ms) INSERT INTO "accounts" ("created_at", "name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid", "updated_at") VALUES (?, ?, ?, ?, ?, ?, ?, ?) [["created_at", Fri, 23 May 2014 13:38:30 UTC +00:00], ["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123], ["updated_at", Fri, 23 May 2014 13:38:30 UTC +00:00]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/admin Completed 302 Found in 3ms (ActiveRecord: 0.7ms)  (0.4ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 0ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/signed_out Completed 302 Found in 0ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 10ms (Views: 9.4ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 1ms (Views: 0.9ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (0.5ms) INSERT INTO "accounts" ("created_at", "provider", "uid", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Fri, 23 May 2014 13:38:31 UTC +00:00], ["provider", "bookingsync"], ["uid", 123], ["updated_at", Fri, 23 May 2014 13:38:31 UTC +00:00]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (1.5ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ?, "updated_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"], ["updated_at", Fri, 23 May 2014 13:38:31 UTC +00:00]]  (0.1ms) RELEASE SAVEPOINT active_record_1  (0.6ms) rollback transaction  (0.1ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (0.4ms) INSERT INTO "accounts" ("created_at", "provider", "uid", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Fri, 23 May 2014 13:38:31 UTC +00:00], ["provider", "bookingsync"], ["uid", 123], ["updated_at", Fri, 23 May 2014 13:38:31 UTC +00:00]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (0.3ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ?, "updated_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"], ["updated_at", Fri, 23 May 2014 13:38:31 UTC +00:00]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.6ms) rollback transaction  (0.1ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (0.4ms) INSERT INTO "accounts" ("created_at", "provider", "uid", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Fri, 23 May 2014 13:38:31 UTC +00:00], ["provider", "bookingsync"], ["uid", 123], ["updated_at", Fri, 23 May 2014 13:38:31 UTC +00:00]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (0.3ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ?, "updated_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"], ["updated_at", Fri, 23 May 2014 13:38:31 UTC +00:00]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.0ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.5ms) rollback transaction  (0.1ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (0.4ms) INSERT INTO "accounts" ("created_at", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "updated_at") VALUES (?, ?, ?, ?, ?) [["created_at", Fri, 23 May 2014 13:38:31 UTC +00:00], ["oauth_access_token", "token"], ["oauth_expires_at", "expires"], ["oauth_refresh_token", "refresh"], ["updated_at", Fri, 23 May 2014 13:38:31 UTC +00:00]]  (0.1ms) RELEASE SAVEPOINT active_record_1  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) UPDATE "accounts" SET "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ?, "updated_at" = ? WHERE "accounts"."id" = 1 [["oauth_access_token", nil], ["oauth_refresh_token", nil], ["oauth_expires_at", nil], ["updated_at", Fri, 23 May 2014 13:38:31 UTC +00:00]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Account Load (0.0ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.4ms) rollback transaction  (0.3ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.4ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (5.6ms) INSERT INTO "accounts" ("created_at", "name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid", "updated_at") VALUES (?, ?, ?, ?, ?, ?, ?, ?) [["created_at", Wed, 11 Jun 2014 09:56:54 UTC +00:00], ["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123], ["updated_at", Wed, 11 Jun 2014 09:56:54 UTC +00:00]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 23ms (ActiveRecord: 7.5ms)  (0.7ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (0.6ms) INSERT INTO "accounts" ("created_at", "name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid", "updated_at") VALUES (?, ?, ?, ?, ?, ?, ?, ?) [["created_at", Wed, 11 Jun 2014 09:56:54 UTC +00:00], ["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123], ["updated_at", Wed, 11 Jun 2014 09:56:54 UTC +00:00]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/admin Completed 302 Found in 5ms (ActiveRecord: 1.0ms)  (0.5ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#create as HTML Parameters: {"provider"=>"bookingsync"} Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (0.4ms) INSERT INTO "accounts" ("created_at", "name", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "provider", "uid", "updated_at") VALUES (?, ?, ?, ?, ?, ?, ?, ?) [["created_at", Wed, 11 Jun 2014 09:56:54 UTC +00:00], ["name", "business name"], ["oauth_access_token", "token"], ["oauth_expires_at", "expires at"], ["oauth_refresh_token", "refresh token"], ["provider", "bookingsync"], ["uid", 123], ["updated_at", Wed, 11 Jun 2014 09:56:54 UTC +00:00]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/ Completed 302 Found in 3ms (ActiveRecord: 0.8ms)  (0.6ms) rollback transaction  (0.2ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 10ms (Views: 9.6ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (8.3ms) begin transaction Processing by SessionsController#failure as HTML Completed 200 OK in 3ms (Views: 2.4ms | ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/ Completed 302 Found in 1ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction Processing by SessionsController#destroy as HTML Redirected to http://test.host/signed_out Completed 302 Found in 0ms (ActiveRecord: 0.0ms)  (0.1ms) rollback transaction  (0.0ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (0.6ms) INSERT INTO "accounts" ("created_at", "provider", "uid", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Wed, 11 Jun 2014 09:56:54 UTC +00:00], ["provider", "bookingsync"], ["uid", 123], ["updated_at", Wed, 11 Jun 2014 09:56:54 UTC +00:00]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (1.4ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ?, "updated_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"], ["updated_at", Wed, 11 Jun 2014 09:56:54 UTC +00:00]]  (0.1ms) RELEASE SAVEPOINT active_record_1  (0.4ms) rollback transaction  (0.3ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (0.6ms) INSERT INTO "accounts" ("created_at", "provider", "uid", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Wed, 11 Jun 2014 09:56:54 UTC +00:00], ["provider", "bookingsync"], ["uid", 123], ["updated_at", Wed, 11 Jun 2014 09:56:54 UTC +00:00]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.3ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.1ms) SAVEPOINT active_record_1 SQL (0.4ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ?, "updated_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"], ["updated_at", Wed, 11 Jun 2014 09:56:54 UTC +00:00]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.4ms) rollback transaction  (0.2ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (0.6ms) INSERT INTO "accounts" ("created_at", "provider", "uid", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Wed, 11 Jun 2014 09:56:54 UTC +00:00], ["provider", "bookingsync"], ["uid", 123], ["updated_at", Wed, 11 Jun 2014 09:56:54 UTC +00:00]]  (0.2ms) RELEASE SAVEPOINT active_record_1 Account Load (0.2ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."provider" = 'bookingsync' AND "accounts"."uid" = 123 ORDER BY "accounts"."id" ASC LIMIT 1  (0.2ms) SAVEPOINT active_record_1 SQL (0.6ms) UPDATE "accounts" SET "name" = ?, "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ?, "updated_at" = ? WHERE "accounts"."id" = 1 [["name", "business name"], ["oauth_access_token", "token"], ["oauth_refresh_token", "refresh token"], ["oauth_expires_at", "expires at"], ["updated_at", Wed, 11 Jun 2014 09:56:54 UTC +00:00]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.6ms) rollback transaction  (0.1ms) begin transaction  (0.1ms) rollback transaction  (0.1ms) begin transaction  (0.1ms) SAVEPOINT active_record_1 SQL (0.6ms) INSERT INTO "accounts" ("created_at", "oauth_access_token", "oauth_expires_at", "oauth_refresh_token", "updated_at") VALUES (?, ?, ?, ?, ?) [["created_at", Wed, 11 Jun 2014 09:56:54 UTC +00:00], ["oauth_access_token", "token"], ["oauth_expires_at", "expires"], ["oauth_refresh_token", "refresh"], ["updated_at", Wed, 11 Jun 2014 09:56:54 UTC +00:00]]  (0.1ms) RELEASE SAVEPOINT active_record_1  (0.1ms) SAVEPOINT active_record_1 SQL (1.3ms) UPDATE "accounts" SET "oauth_access_token" = ?, "oauth_refresh_token" = ?, "oauth_expires_at" = ?, "updated_at" = ? WHERE "accounts"."id" = 1 [["oauth_access_token", nil], ["oauth_refresh_token", nil], ["oauth_expires_at", nil], ["updated_at", Wed, 11 Jun 2014 09:56:54 UTC +00:00]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Account Load (0.1ms) SELECT "accounts".* FROM "accounts" WHERE "accounts"."id" = ? LIMIT 1 [["id", 1]]  (0.5ms) rollback transaction