(1.9ms) CREATE TABLE "schema_migrations" ("version" varchar NOT NULL)   (0.1ms) select sqlite_version(*)  (3.4ms) CREATE UNIQUE INDEX "unique_schema_migrations" ON "schema_migrations" ("version") ActiveRecord::SchemaMigration Load (0.1ms) SELECT "schema_migrations".* FROM "schema_migrations" Migrating to CreateAccounts (20150319132530)  (0.1ms) begin transaction  (0.5ms) CREATE TABLE "accounts" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "company_name" varchar, "qb_token" varchar, "qb_secret" varchar, "qb_company_id" varchar, "created_at" datetime NOT NULL, "updated_at" datetime NOT NULL) SQL (0.3ms) INSERT INTO "schema_migrations" ("version") VALUES (?) [["version", "20150319132530"]]  (1.2ms) commit transaction Migrating to CreateCustomers (20150319132650)  (0.1ms) begin transaction  (0.5ms) CREATE TABLE "customers" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "firstname" varchar, "lastname" varchar, "email" varchar, "phone" varchar, "mobile" varchar, "address_1" varchar, "city" varchar, "state" varchar, "zip" varchar, "created_at" datetime NOT NULL, "updated_at" datetime NOT NULL) SQL (0.3ms) INSERT INTO "schema_migrations" ("version") VALUES (?) [["version", "20150319132650"]]  (1.0ms) commit transaction ActiveRecord::SchemaMigration Load (0.1ms) SELECT "schema_migrations".* FROM "schema_migrations" Customer Load (1.9ms) SELECT "customers".* FROM "customers" Customer Load (0.2ms) SELECT "customers".* FROM "customers" ORDER BY "customers"."id" ASC LIMIT 1 ActiveRecord::SchemaMigration Load (0.6ms) SELECT "schema_migrations".* FROM "schema_migrations" Migrating to AddQboIdToCustomer (20150328125013)  (0.1ms) begin transaction  (1.0ms) ALTER TABLE "customers" ADD "qbo_id" integer SQL (0.2ms) INSERT INTO "schema_migrations" ("version") VALUES (?) [["version", "20150328125013"]]  (1.0ms) commit transaction ActiveRecord::SchemaMigration Load (0.1ms) SELECT "schema_migrations".* FROM "schema_migrations"  (1.6ms) CREATE TABLE "accounts" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "company_name" varchar, "qb_token" varchar, "qb_secret" varchar, "qb_company_id" varchar, "created_at" datetime NOT NULL, "updated_at" datetime NOT NULL)   (1.3ms) CREATE TABLE "customers" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "firstname" varchar, "lastname" varchar, "email" varchar, "phone" varchar, "mobile" varchar, "address_1" varchar, "city" varchar, "state" varchar, "zip" varchar, "created_at" datetime NOT NULL, "updated_at" datetime NOT NULL, "qbo_id" integer)  (1.2ms) CREATE TABLE "schema_migrations" ("version" varchar NOT NULL)   (0.1ms) select sqlite_version(*)  (1.0ms) CREATE UNIQUE INDEX "unique_schema_migrations" ON "schema_migrations" ("version")  (0.1ms) SELECT version FROM "schema_migrations"  (1.0ms) INSERT INTO "schema_migrations" (version) VALUES ('20150328125013')  (0.7ms) INSERT INTO "schema_migrations" (version) VALUES ('20150319132530')  (0.8ms) INSERT INTO "schema_migrations" (version) VALUES ('20150319132650') Account Load (1.7ms) SELECT "accounts".* FROM "accounts" ActiveRecord::SchemaMigration Load (0.4ms) SELECT "schema_migrations".* FROM "schema_migrations" Migrating to CreateQboErrors (20150418124251) ActiveRecord::SchemaMigration Load (0.6ms) SELECT "schema_migrations".* FROM "schema_migrations" Migrating to CreateQboErrors (20150418134516)  (0.1ms) begin transaction  (0.4ms) CREATE TABLE "qbo_errors" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "message" varchar, "body" text, "resource_type" varchar(100), "resource_id" integer, "request_xml" text, "created_at" datetime NOT NULL, "updated_at" datetime NOT NULL)  SQL (0.2ms) INSERT INTO "schema_migrations" ("version") VALUES (?) [["version", "20150418134516"]]  (1.0ms) commit transaction ActiveRecord::SchemaMigration Load (0.1ms) SELECT "schema_migrations".* FROM "schema_migrations"  (0.1ms) begin transaction SQL (1.2ms) INSERT INTO "accounts" ("company_name", "qb_token", "qb_company_id", "created_at", "updated_at") VALUES (?, ?, ?, ?, ?) [["company_name", "Nelson Hockey Club"], ["qb_token", "qyprdYDw6JOa6Q4SAzRJTsYtLbutwBq3qxUMtFHfgw2Bal1H"], ["qb_company_id", "1292740145"], ["created_at", "2015-04-18 18:38:37.262503"], ["updated_at", "2015-04-18 18:38:37.262503"]]  (0.6ms) commit transaction  (0.1ms) begin transaction SQL (0.5ms) INSERT INTO "accounts" ("company_name", "qb_token", "qb_company_id", "created_at", "updated_at") VALUES (?, ?, ?, ?, ?) [["company_name", "Nelson Hockey Club"], ["qb_token", "qyprdYDw6JOa6Q4SAzRJTsYtLbutwBq3qxUMtFHfgw2Bal1H"], ["qb_company_id", "1292740145"], ["created_at", "2015-04-18 18:40:39.809499"], ["updated_at", "2015-04-18 18:40:39.809499"]]  (1.0ms) commit transaction  (0.1ms) begin transaction SQL (0.4ms) INSERT INTO "accounts" ("company_name", "qb_token", "qb_secret", "qb_company_id", "created_at", "updated_at") VALUES (?, ?, ?, ?, ?, ?) [["company_name", "Nelson Hockey Club"], ["qb_token", "qyprdYDw6JOa6Q4SAzRJTsYtLbutwBq3qxUMtFHfgw2Bal1H"], ["qb_secret", "XjrMCpPakHMPpYIDsuNHvftutBO6UrjpgrL6Bmhb"], ["qb_company_id", "1292740145"], ["created_at", "2015-04-18 18:42:22.742626"], ["updated_at", "2015-04-18 18:42:22.742626"]]  (1.0ms) commit transaction  (0.1ms) begin transaction SQL (1.2ms) INSERT INTO "accounts" ("company_name", "qb_token", "qb_secret", "qb_company_id", "created_at", "updated_at") VALUES (?, ?, ?, ?, ?, ?) [["company_name", "Nelson Hockey Club"], ["qb_token", "qyprdYDw6JOa6Q4SAzRJTsYtLbutwBq3qxUMtFHfgw2Bal1H"], ["qb_secret", "XjrMCpPakHMPpYIDsuNHvftutBO6UrjpgrL6Bmhb"], ["qb_company_id", "1292740145"], ["created_at", "2015-04-18 18:47:15.822606"], ["updated_at", "2015-04-18 18:47:15.822606"]]  (0.6ms) commit transaction Started GET "/" for ::1 at 2015-07-28 07:55:51 -0400 ActiveRecord::SchemaMigration Load (0.6ms) SELECT "schema_migrations".* FROM "schema_migrations" AbstractController::ActionNotFound (The action 'index' could not be found for SettingsController): actionpack (4.2.1) lib/abstract_controller/base.rb:132:in `process' actionview (4.2.1) lib/action_view/rendering.rb:30:in `process' actionpack (4.2.1) lib/action_controller/metal.rb:196:in `dispatch' actionpack (4.2.1) lib/action_controller/metal/rack_delegation.rb:13:in `dispatch' actionpack (4.2.1) lib/action_controller/metal.rb:237:in `block in action' actionpack (4.2.1) lib/action_dispatch/routing/route_set.rb:74:in `call' actionpack (4.2.1) lib/action_dispatch/routing/route_set.rb:74:in `dispatch' actionpack (4.2.1) lib/action_dispatch/routing/route_set.rb:43:in `serve' actionpack (4.2.1) lib/action_dispatch/journey/router.rb:43:in `block in serve' actionpack (4.2.1) lib/action_dispatch/journey/router.rb:30:in `each' actionpack (4.2.1) lib/action_dispatch/journey/router.rb:30:in `serve' actionpack (4.2.1) lib/action_dispatch/routing/route_set.rb:819:in `call' rack (1.6.0) lib/rack/etag.rb:24:in `call' rack (1.6.0) lib/rack/conditionalget.rb:25:in `call' rack (1.6.0) lib/rack/head.rb:13:in `call' actionpack (4.2.1) lib/action_dispatch/middleware/params_parser.rb:27:in `call' actionpack (4.2.1) lib/action_dispatch/middleware/flash.rb:260:in `call' rack (1.6.0) lib/rack/session/abstract/id.rb:225:in `context' rack (1.6.0) lib/rack/session/abstract/id.rb:220:in `call' actionpack (4.2.1) lib/action_dispatch/middleware/cookies.rb:560:in `call' activerecord (4.2.1) lib/active_record/query_cache.rb:36:in `call' activerecord (4.2.1) lib/active_record/connection_adapters/abstract/connection_pool.rb:649:in `call' activerecord (4.2.1) lib/active_record/migration.rb:378:in `call' actionpack (4.2.1) lib/action_dispatch/middleware/callbacks.rb:29:in `block in call' activesupport (4.2.1) lib/active_support/callbacks.rb:88:in `call' activesupport (4.2.1) lib/active_support/callbacks.rb:88:in `_run_callbacks' activesupport (4.2.1) lib/active_support/callbacks.rb:776:in `_run_call_callbacks' activesupport (4.2.1) lib/active_support/callbacks.rb:81:in `run_callbacks' actionpack (4.2.1) lib/action_dispatch/middleware/callbacks.rb:27:in `call' actionpack (4.2.1) lib/action_dispatch/middleware/reloader.rb:73:in `call' actionpack (4.2.1) lib/action_dispatch/middleware/remote_ip.rb:78:in `call' actionpack (4.2.1) lib/action_dispatch/middleware/debug_exceptions.rb:17:in `call' actionpack (4.2.1) lib/action_dispatch/middleware/show_exceptions.rb:30:in `call' railties (4.2.1) lib/rails/rack/logger.rb:38:in `call_app' railties (4.2.1) lib/rails/rack/logger.rb:20:in `block in call' activesupport (4.2.1) lib/active_support/tagged_logging.rb:68:in `block in tagged' activesupport (4.2.1) lib/active_support/tagged_logging.rb:26:in `tagged' activesupport (4.2.1) lib/active_support/tagged_logging.rb:68:in `tagged' railties (4.2.1) lib/rails/rack/logger.rb:20:in `call' actionpack (4.2.1) lib/action_dispatch/middleware/request_id.rb:21:in `call' rack (1.6.0) lib/rack/methodoverride.rb:22:in `call' rack (1.6.0) lib/rack/runtime.rb:18:in `call' activesupport (4.2.1) lib/active_support/cache/strategy/local_cache_middleware.rb:28:in `call' rack (1.6.0) lib/rack/lock.rb:17:in `call' actionpack (4.2.1) lib/action_dispatch/middleware/static.rb:113:in `call' rack (1.6.0) lib/rack/sendfile.rb:113:in `call' railties (4.2.1) lib/rails/engine.rb:518:in `call' railties (4.2.1) lib/rails/application.rb:164:in `call' rack (1.6.0) lib/rack/lock.rb:17:in `call' rack (1.6.0) lib/rack/content_length.rb:15:in `call' rack (1.6.0) lib/rack/handler/webrick.rb:89:in `service' /Users/christian/.rvm/rubies/ruby-2.1.5/lib/ruby/2.1.0/webrick/httpserver.rb:138:in `service' /Users/christian/.rvm/rubies/ruby-2.1.5/lib/ruby/2.1.0/webrick/httpserver.rb:94:in `run' /Users/christian/.rvm/rubies/ruby-2.1.5/lib/ruby/2.1.0/webrick/server.rb:295:in `block in start_thread' Rendered /Users/christian/.rvm/gems/ruby-2.1.5/gems/actionpack-4.2.1/lib/action_dispatch/middleware/templates/rescues/unknown_action.html.erb within rescues/layout (0.6ms) Started GET "/" for ::1 at 2015-07-28 07:56:31 -0400 Processing by SettingsController#index as HTML Rendered settings/index.html.erb within layouts/application (1.6ms) Completed 500 Internal Server Error in 6ms (ActiveRecord: 0.0ms) SyntaxError (/Users/christian/github/qbo_rails/spec/dummy/app/views/settings/index.html.erb:31: syntax error, unexpected keyword_ensure, expecting end-of-input): app/views/settings/index.html.erb:31: syntax error, unexpected keyword_ensure, expecting end-of-input Rendered /Users/christian/.rvm/gems/ruby-2.1.5/gems/actionpack-4.2.1/lib/action_dispatch/middleware/templates/rescues/_source.erb (8.7ms) Rendered /Users/christian/.rvm/gems/ruby-2.1.5/gems/actionpack-4.2.1/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (3.1ms) Rendered /Users/christian/.rvm/gems/ruby-2.1.5/gems/actionpack-4.2.1/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (10.7ms) Rendered /Users/christian/.rvm/gems/ruby-2.1.5/gems/actionpack-4.2.1/lib/action_dispatch/middleware/templates/rescues/diagnostics.html.erb within rescues/layout (37.6ms) Started GET "/" for ::1 at 2015-07-28 07:56:52 -0400 Processing by SettingsController#index as HTML Rendered settings/index.html.erb within layouts/application (2.7ms) Completed 200 OK in 38ms (Views: 38.2ms | ActiveRecord: 0.0ms) Started GET "/assets/application-5266d2988799ecc8fe6e81eaab412e7d.css?body=1" for ::1 at 2015-07-28 07:56:52 -0400 Started GET "/assets/application-5f1f3a0d9f2a8d9e8fcda8edadddaf68.js?body=1" for ::1 at 2015-07-28 07:56:52 -0400 Started GET "/" for ::1 at 2015-07-28 07:59:11 -0400 Processing by SettingsController#index as HTML Rendered settings/index.html.erb within layouts/application (2.8ms) Completed 200 OK in 24ms (Views: 24.2ms | ActiveRecord: 0.0ms) Started GET "/assets/application-5266d2988799ecc8fe6e81eaab412e7d.css?body=1" for ::1 at 2015-07-28 07:59:11 -0400 Started GET "/assets/application-5f1f3a0d9f2a8d9e8fcda8edadddaf68.js?body=1" for ::1 at 2015-07-28 07:59:11 -0400 Started GET "/oauth_start" for ::1 at 2015-07-28 07:59:15 -0400 Processing by SettingsController#oauth_start as HTML Completed 500 Internal Server Error in 4ms (ActiveRecord: 0.0ms) WebMock::NetConnectNotAllowedError (Real HTTP connections are disabled. Unregistered request: POST https://oauth.intuit.com/oauth/v1/get_request_token with headers {'Accept'=>'*/*', 'Accept-Encoding'=>'gzip;q=1.0,deflate;q=0.6,identity;q=0.3', 'Authorization'=>'OAuth oauth_body_hash="2jmj7l5rSw0yVb%2FvlWAYkK%2FYBwk%3D", oauth_callback="http%3A%2F%2Flocalhost%3A3000%2Foauth_callback", oauth_consumer_key="qyprdhobqczMYO48EHGKyw40TRExem", oauth_nonce="f59ISHDHOkwOERl2rmCEpd6MTiQzqEVkBhKm5RYoUo", oauth_signature="yn%2FAoiVeRstAhv0n61MfPpfrUfI%3D", oauth_signature_method="HMAC-SHA1", oauth_timestamp="1438084755", oauth_version="1.0"', 'Content-Length'=>'0', 'User-Agent'=>'OAuth gem v0.4.7'} You can stub this request with the following snippet: stub_request(:post, "https://oauth.intuit.com/oauth/v1/get_request_token"). with(:headers => {'Accept'=>'*/*', 'Accept-Encoding'=>'gzip;q=1.0,deflate;q=0.6,identity;q=0.3', 'Authorization'=>'OAuth oauth_body_hash="2jmj7l5rSw0yVb%2FvlWAYkK%2FYBwk%3D", oauth_callback="http%3A%2F%2Flocalhost%3A3000%2Foauth_callback", oauth_consumer_key="qyprdhobqczMYO48EHGKyw40TRExem", oauth_nonce="f59ISHDHOkwOERl2rmCEpd6MTiQzqEVkBhKm5RYoUo", oauth_signature="yn%2FAoiVeRstAhv0n61MfPpfrUfI%3D", oauth_signature_method="HMAC-SHA1", oauth_timestamp="1438084755", oauth_version="1.0"', 'Content-Length'=>'0', 'User-Agent'=>'OAuth gem v0.4.7'}). to_return(:status => 200, :body => "", :headers => {}) ============================================================): app/controllers/settings_controller.rb:4:in `oauth_start' Rendered /Users/christian/.rvm/gems/ruby-2.1.5/gems/actionpack-4.2.1/lib/action_dispatch/middleware/templates/rescues/_source.erb (6.5ms) Rendered /Users/christian/.rvm/gems/ruby-2.1.5/gems/actionpack-4.2.1/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (2.7ms) Rendered /Users/christian/.rvm/gems/ruby-2.1.5/gems/actionpack-4.2.1/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (1.5ms) Rendered /Users/christian/.rvm/gems/ruby-2.1.5/gems/actionpack-4.2.1/lib/action_dispatch/middleware/templates/rescues/diagnostics.html.erb within rescues/layout (20.6ms) Started GET "/" for ::1 at 2015-07-28 08:00:44 -0400 Processing by SettingsController#index as HTML Rendered settings/index.html.erb within layouts/application (1.3ms) Completed 200 OK in 15ms (Views: 14.4ms | ActiveRecord: 0.0ms) Started GET "/assets/application-5266d2988799ecc8fe6e81eaab412e7d.css?body=1" for ::1 at 2015-07-28 08:00:44 -0400 Started GET "/assets/application-5f1f3a0d9f2a8d9e8fcda8edadddaf68.js?body=1" for ::1 at 2015-07-28 08:00:44 -0400 Started GET "/" for ::1 at 2015-07-28 08:00:47 -0400 Processing by SettingsController#index as HTML Rendered settings/index.html.erb within layouts/application (1.3ms) Completed 200 OK in 16ms (Views: 15.4ms | ActiveRecord: 0.0ms) Started GET "/assets/application-5f1f3a0d9f2a8d9e8fcda8edadddaf68.js?body=1" for ::1 at 2015-07-28 08:00:47 -0400 Started GET "/assets/application-5266d2988799ecc8fe6e81eaab412e7d.css?body=1" for ::1 at 2015-07-28 08:00:47 -0400 Started GET "/" for ::1 at 2015-07-28 08:01:20 -0400 Processing by SettingsController#index as HTML Rendered settings/index.html.erb within layouts/application (2.3ms) Completed 200 OK in 15ms (Views: 14.5ms | ActiveRecord: 0.0ms) Started GET "/assets/application-5266d2988799ecc8fe6e81eaab412e7d.css?body=1" for ::1 at 2015-07-28 08:01:21 -0400 Started GET "/assets/application-5f1f3a0d9f2a8d9e8fcda8edadddaf68.js?body=1" for ::1 at 2015-07-28 08:01:21 -0400 Started GET "/" for ::1 at 2015-07-28 08:04:26 -0400 Processing by SettingsController#index as HTML Rendered settings/index.html.erb within layouts/application (1.4ms) Completed 200 OK in 10ms (Views: 9.9ms | ActiveRecord: 0.0ms) Started GET "/assets/application-5266d2988799ecc8fe6e81eaab412e7d.css?body=1" for ::1 at 2015-07-28 08:04:26 -0400 Started GET "/assets/application-5f1f3a0d9f2a8d9e8fcda8edadddaf68.js?body=1" for ::1 at 2015-07-28 08:04:26 -0400 Started GET "/oauth_start" for ::1 at 2015-07-28 08:04:29 -0400 Processing by SettingsController#oauth_start as HTML Completed 500 Internal Server Error in 2ms (ActiveRecord: 0.0ms) WebMock::NetConnectNotAllowedError (Real HTTP connections are disabled. Unregistered request: POST https://oauth.intuit.com/oauth/v1/get_request_token with headers {'Accept'=>'*/*', 'Accept-Encoding'=>'gzip;q=1.0,deflate;q=0.6,identity;q=0.3', 'Authorization'=>'OAuth oauth_body_hash="2jmj7l5rSw0yVb%2FvlWAYkK%2FYBwk%3D", oauth_callback="http%3A%2F%2Flocalhost%3A3000%2Foauth_callback", oauth_consumer_key="qyprdhobqczMYO48EHGKyw40TRExem", oauth_nonce="CvJBm9t91kVo2y2IQvG0jPUGzCa9ZSmGmAxqxInzRw", oauth_signature="nuDh7gyaYchBGg%2BEVHhvp5UXax0%3D", oauth_signature_method="HMAC-SHA1", oauth_timestamp="1438085069", oauth_version="1.0"', 'Content-Length'=>'0', 'User-Agent'=>'OAuth gem v0.4.7'} You can stub this request with the following snippet: stub_request(:post, "https://oauth.intuit.com/oauth/v1/get_request_token"). with(:headers => {'Accept'=>'*/*', 'Accept-Encoding'=>'gzip;q=1.0,deflate;q=0.6,identity;q=0.3', 'Authorization'=>'OAuth oauth_body_hash="2jmj7l5rSw0yVb%2FvlWAYkK%2FYBwk%3D", oauth_callback="http%3A%2F%2Flocalhost%3A3000%2Foauth_callback", oauth_consumer_key="qyprdhobqczMYO48EHGKyw40TRExem", oauth_nonce="CvJBm9t91kVo2y2IQvG0jPUGzCa9ZSmGmAxqxInzRw", oauth_signature="nuDh7gyaYchBGg%2BEVHhvp5UXax0%3D", oauth_signature_method="HMAC-SHA1", oauth_timestamp="1438085069", oauth_version="1.0"', 'Content-Length'=>'0', 'User-Agent'=>'OAuth gem v0.4.7'}). to_return(:status => 200, :body => "", :headers => {}) ============================================================): app/controllers/settings_controller.rb:4:in `oauth_start' Rendered /Users/christian/.rvm/gems/ruby-2.1.5/gems/actionpack-4.2.1/lib/action_dispatch/middleware/templates/rescues/_source.erb (6.0ms) Rendered /Users/christian/.rvm/gems/ruby-2.1.5/gems/actionpack-4.2.1/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (2.8ms) Rendered /Users/christian/.rvm/gems/ruby-2.1.5/gems/actionpack-4.2.1/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (1.9ms) Rendered /Users/christian/.rvm/gems/ruby-2.1.5/gems/actionpack-4.2.1/lib/action_dispatch/middleware/templates/rescues/diagnostics.html.erb within rescues/layout (20.7ms) Started GET "/oauth_start" for ::1 at 2015-07-28 08:04:59 -0400 ActiveRecord::SchemaMigration Load (0.2ms) SELECT "schema_migrations".* FROM "schema_migrations" Processing by SettingsController#oauth_start as HTML Redirected to https://appcenter.intuit.com/Connect/Begin?oauth_token=qyprd8UcdBS34L2R5e4vR2oJiL5J1zVv3ESflKmkAUXJBUWL Completed 302 Found in 988ms (ActiveRecord: 0.0ms) Started GET "/" for ::1 at 2015-07-28 08:06:08 -0400 Processing by SettingsController#index as HTML Rendered settings/index.html.erb within layouts/application (9.7ms) Completed 200 OK in 65ms (Views: 64.6ms | ActiveRecord: 0.0ms) Started GET "/assets/application-5266d2988799ecc8fe6e81eaab412e7d.css?body=1" for ::1 at 2015-07-28 08:06:08 -0400 Started GET "/assets/application-5f1f3a0d9f2a8d9e8fcda8edadddaf68.js?body=1" for ::1 at 2015-07-28 08:06:08 -0400 Started GET "/oauth_start" for ::1 at 2015-07-28 08:06:12 -0400 Processing by SettingsController#oauth_start as HTML Redirected to https://appcenter.intuit.com/Connect/Begin?oauth_token=qyprdRkNwvXl7etPSfi4vzhlMgTe2OXjsX94M6mkJmzVU69X Completed 302 Found in 483ms (ActiveRecord: 0.0ms) Started GET "/oauth_callback?oauth_token=qyprdRkNwvXl7etPSfi4vzhlMgTe2OXjsX94M6mkJmzVU69X&oauth_verifier=ev0kbn0&realmId=1411324040&dataSource=QBO" for ::1 at 2015-07-28 08:06:50 -0400 Processing by SettingsController#oauth_callback as HTML Parameters: {"oauth_token"=>"qyprdRkNwvXl7etPSfi4vzhlMgTe2OXjsX94M6mkJmzVU69X", "oauth_verifier"=>"ev0kbn0", "realmId"=>"1411324040", "dataSource"=>"QBO"} Completed 500 Internal Server Error in 901ms (ActiveRecord: 0.0ms) ActionView::MissingTemplate (Missing template layouts/basic with {:locale=>[:en], :formats=>[:html], :variants=>[], :handlers=>[:erb, :builder, :raw, :ruby]}. Searched in: * "/Users/christian/github/qbo_rails/spec/dummy/app/views" ): app/controllers/settings_controller.rb:18:in `rescue in oauth_callback' app/controllers/settings_controller.rb:10:in `oauth_callback' Rendered /Users/christian/.rvm/gems/ruby-2.1.5/gems/actionpack-4.2.1/lib/action_dispatch/middleware/templates/rescues/_source.erb (7.4ms) Rendered /Users/christian/.rvm/gems/ruby-2.1.5/gems/actionpack-4.2.1/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (4.1ms) Rendered /Users/christian/.rvm/gems/ruby-2.1.5/gems/actionpack-4.2.1/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (1.9ms) Rendered /Users/christian/.rvm/gems/ruby-2.1.5/gems/actionpack-4.2.1/lib/action_dispatch/middleware/templates/rescues/missing_template.html.erb within rescues/layout (25.6ms) Started GET "/oauth_callback?oauth_token=qyprdRkNwvXl7etPSfi4vzhlMgTe2OXjsX94M6mkJmzVU69X&oauth_verifier=ev0kbn0&realmId=1411324040&dataSource=QBO" for ::1 at 2015-07-28 08:08:49 -0400 Processing by SettingsController#oauth_callback as HTML Parameters: {"oauth_token"=>"qyprdRkNwvXl7etPSfi4vzhlMgTe2OXjsX94M6mkJmzVU69X", "oauth_verifier"=>"ev0kbn0", "realmId"=>"1411324040", "dataSource"=>"QBO"} Completed 500 Internal Server Error in 955ms (ActiveRecord: 0.0ms) ActionView::MissingTemplate (Missing template layouts/basic with {:locale=>[:en], :formats=>[:html], :variants=>[], :handlers=>[:erb, :builder, :raw, :ruby]}. Searched in: * "/Users/christian/github/qbo_rails/spec/dummy/app/views" ): app/controllers/settings_controller.rb:18:in `rescue in oauth_callback' app/controllers/settings_controller.rb:10:in `oauth_callback' Rendered /Users/christian/.rvm/gems/ruby-2.1.5/gems/actionpack-4.2.1/lib/action_dispatch/middleware/templates/rescues/_source.erb (7.6ms) Rendered /Users/christian/.rvm/gems/ruby-2.1.5/gems/actionpack-4.2.1/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (3.1ms) Rendered /Users/christian/.rvm/gems/ruby-2.1.5/gems/actionpack-4.2.1/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (1.1ms) Rendered /Users/christian/.rvm/gems/ruby-2.1.5/gems/actionpack-4.2.1/lib/action_dispatch/middleware/templates/rescues/missing_template.html.erb within rescues/layout (21.4ms) Started GET "/oauth_callback?oauth_token=qyprdRkNwvXl7etPSfi4vzhlMgTe2OXjsX94M6mkJmzVU69X&oauth_verifier=ev0kbn0&realmId=1411324040&dataSource=QBO" for ::1 at 2015-07-28 08:09:21 -0400 Processing by SettingsController#oauth_callback as HTML Parameters: {"oauth_token"=>"qyprdRkNwvXl7etPSfi4vzhlMgTe2OXjsX94M6mkJmzVU69X", "oauth_verifier"=>"ev0kbn0", "realmId"=>"1411324040", "dataSource"=>"QBO"} Rendered settings/close_and_redirect.html.erb within layouts/application (0.6ms) Completed 200 OK in 697ms (Views: 9.9ms | ActiveRecord: 0.0ms) Started GET "/assets/application-5266d2988799ecc8fe6e81eaab412e7d.css?body=1" for ::1 at 2015-07-28 08:09:21 -0400 Started GET "/assets/application-5f1f3a0d9f2a8d9e8fcda8edadddaf68.js?body=1" for ::1 at 2015-07-28 08:09:21 -0400 Started GET "/oauth_callback?oauth_token=qyprdRkNwvXl7etPSfi4vzhlMgTe2OXjsX94M6mkJmzVU69X&oauth_verifier=ev0kbn0&realmId=1411324040&dataSource=QBO" for ::1 at 2015-07-28 08:09:26 -0400 Processing by SettingsController#oauth_callback as HTML Parameters: {"oauth_token"=>"qyprdRkNwvXl7etPSfi4vzhlMgTe2OXjsX94M6mkJmzVU69X", "oauth_verifier"=>"ev0kbn0", "realmId"=>"1411324040", "dataSource"=>"QBO"} Rendered settings/close_and_redirect.html.erb within layouts/application (0.1ms) Completed 200 OK in 598ms (Views: 16.3ms | ActiveRecord: 0.0ms) Started GET "/assets/application-5f1f3a0d9f2a8d9e8fcda8edadddaf68.js?body=1" for ::1 at 2015-07-28 08:09:27 -0400 Started GET "/assets/application-5266d2988799ecc8fe6e81eaab412e7d.css?body=1" for ::1 at 2015-07-28 08:09:27 -0400 Started GET "/oauth_callback?oauth_token=qyprdRkNwvXl7etPSfi4vzhlMgTe2OXjsX94M6mkJmzVU69X&oauth_verifier=ev0kbn0&realmId=1411324040&dataSource=QBO" for ::1 at 2015-07-28 08:09:32 -0400 Processing by SettingsController#oauth_callback as HTML Parameters: {"oauth_token"=>"qyprdRkNwvXl7etPSfi4vzhlMgTe2OXjsX94M6mkJmzVU69X", "oauth_verifier"=>"ev0kbn0", "realmId"=>"1411324040", "dataSource"=>"QBO"} Rendered settings/close_and_redirect.html.erb within layouts/application (0.1ms) Completed 200 OK in 660ms (Views: 9.3ms | ActiveRecord: 0.0ms) Started GET "/assets/application-5266d2988799ecc8fe6e81eaab412e7d.css?body=1" for ::1 at 2015-07-28 08:09:33 -0400 Started GET "/assets/application-5f1f3a0d9f2a8d9e8fcda8edadddaf68.js?body=1" for ::1 at 2015-07-28 08:09:33 -0400 Started GET "/oauth_callback?oauth_token=qyprdRkNwvXl7etPSfi4vzhlMgTe2OXjsX94M6mkJmzVU69X&oauth_verifier=ev0kbn0&realmId=1411324040&dataSource=QBO" for ::1 at 2015-07-28 08:09:38 -0400 Processing by SettingsController#oauth_callback as HTML Parameters: {"oauth_token"=>"qyprdRkNwvXl7etPSfi4vzhlMgTe2OXjsX94M6mkJmzVU69X", "oauth_verifier"=>"ev0kbn0", "realmId"=>"1411324040", "dataSource"=>"QBO"} Rendered settings/close_and_redirect.html.erb within layouts/application (0.1ms) Completed 200 OK in 694ms (Views: 8.8ms | ActiveRecord: 0.0ms) Started GET "/assets/application-5f1f3a0d9f2a8d9e8fcda8edadddaf68.js?body=1" for ::1 at 2015-07-28 08:09:38 -0400 Started GET "/assets/application-5266d2988799ecc8fe6e81eaab412e7d.css?body=1" for ::1 at 2015-07-28 08:09:38 -0400 Started GET "/oauth_callback?oauth_token=qyprdRkNwvXl7etPSfi4vzhlMgTe2OXjsX94M6mkJmzVU69X&oauth_verifier=ev0kbn0&realmId=1411324040&dataSource=QBO" for ::1 at 2015-07-28 08:09:43 -0400 Processing by SettingsController#oauth_callback as HTML Parameters: {"oauth_token"=>"qyprdRkNwvXl7etPSfi4vzhlMgTe2OXjsX94M6mkJmzVU69X", "oauth_verifier"=>"ev0kbn0", "realmId"=>"1411324040", "dataSource"=>"QBO"} Rendered settings/close_and_redirect.html.erb within layouts/application (0.1ms) Completed 200 OK in 694ms (Views: 11.5ms | ActiveRecord: 0.0ms) Started GET "/assets/application-5266d2988799ecc8fe6e81eaab412e7d.css?body=1" for ::1 at 2015-07-28 08:09:44 -0400 Started GET "/assets/application-5f1f3a0d9f2a8d9e8fcda8edadddaf68.js?body=1" for ::1 at 2015-07-28 08:09:44 -0400 Started GET "/oauth_callback?oauth_token=qyprdRkNwvXl7etPSfi4vzhlMgTe2OXjsX94M6mkJmzVU69X&oauth_verifier=ev0kbn0&realmId=1411324040&dataSource=QBO" for ::1 at 2015-07-28 08:09:49 -0400 Processing by SettingsController#oauth_callback as HTML Parameters: {"oauth_token"=>"qyprdRkNwvXl7etPSfi4vzhlMgTe2OXjsX94M6mkJmzVU69X", "oauth_verifier"=>"ev0kbn0", "realmId"=>"1411324040", "dataSource"=>"QBO"} Rendered settings/close_and_redirect.html.erb within layouts/application (0.1ms) Completed 200 OK in 533ms (Views: 9.1ms | ActiveRecord: 0.0ms) Started GET "/assets/application-5f1f3a0d9f2a8d9e8fcda8edadddaf68.js?body=1" for ::1 at 2015-07-28 08:09:50 -0400 Started GET "/assets/application-5266d2988799ecc8fe6e81eaab412e7d.css?body=1" for ::1 at 2015-07-28 08:09:50 -0400 Started GET "/oauth_callback?oauth_token=qyprdRkNwvXl7etPSfi4vzhlMgTe2OXjsX94M6mkJmzVU69X&oauth_verifier=ev0kbn0&realmId=1411324040&dataSource=QBO" for ::1 at 2015-07-28 08:09:55 -0400 Processing by SettingsController#oauth_callback as HTML Parameters: {"oauth_token"=>"qyprdRkNwvXl7etPSfi4vzhlMgTe2OXjsX94M6mkJmzVU69X", "oauth_verifier"=>"ev0kbn0", "realmId"=>"1411324040", "dataSource"=>"QBO"} Rendered settings/close_and_redirect.html.erb within layouts/application (0.2ms) Completed 200 OK in 566ms (Views: 11.6ms | ActiveRecord: 0.0ms) Started GET "/assets/application-5266d2988799ecc8fe6e81eaab412e7d.css?body=1" for ::1 at 2015-07-28 08:09:55 -0400 Started GET "/assets/application-5f1f3a0d9f2a8d9e8fcda8edadddaf68.js?body=1" for ::1 at 2015-07-28 08:09:55 -0400 Started GET "/oauth_callback?oauth_token=qyprdRkNwvXl7etPSfi4vzhlMgTe2OXjsX94M6mkJmzVU69X&oauth_verifier=ev0kbn0&realmId=1411324040&dataSource=QBO" for ::1 at 2015-07-28 08:10:00 -0400 Processing by SettingsController#oauth_callback as HTML Parameters: {"oauth_token"=>"qyprdRkNwvXl7etPSfi4vzhlMgTe2OXjsX94M6mkJmzVU69X", "oauth_verifier"=>"ev0kbn0", "realmId"=>"1411324040", "dataSource"=>"QBO"} Rendered settings/close_and_redirect.html.erb within layouts/application (0.1ms) Completed 200 OK in 932ms (Views: 11.0ms | ActiveRecord: 0.0ms) Started GET "/assets/application-5266d2988799ecc8fe6e81eaab412e7d.css?body=1" for ::1 at 2015-07-28 08:10:01 -0400 Started GET "/assets/application-5f1f3a0d9f2a8d9e8fcda8edadddaf68.js?body=1" for ::1 at 2015-07-28 08:10:01 -0400 Started GET "/oauth_callback?oauth_token=qyprdRkNwvXl7etPSfi4vzhlMgTe2OXjsX94M6mkJmzVU69X&oauth_verifier=ev0kbn0&realmId=1411324040&dataSource=QBO" for ::1 at 2015-07-28 08:10:06 -0400 Processing by SettingsController#oauth_callback as HTML Parameters: {"oauth_token"=>"qyprdRkNwvXl7etPSfi4vzhlMgTe2OXjsX94M6mkJmzVU69X", "oauth_verifier"=>"ev0kbn0", "realmId"=>"1411324040", "dataSource"=>"QBO"} Rendered settings/close_and_redirect.html.erb within layouts/application (0.1ms) Completed 200 OK in 644ms (Views: 46.3ms | ActiveRecord: 0.0ms) Started GET "/assets/application-5f1f3a0d9f2a8d9e8fcda8edadddaf68.js?body=1" for ::1 at 2015-07-28 08:10:07 -0400 Started GET "/assets/application-5266d2988799ecc8fe6e81eaab412e7d.css?body=1" for ::1 at 2015-07-28 08:10:07 -0400 Started GET "/oauth_callback?oauth_token=qyprdRkNwvXl7etPSfi4vzhlMgTe2OXjsX94M6mkJmzVU69X&oauth_verifier=ev0kbn0&realmId=1411324040&dataSource=QBO" for ::1 at 2015-07-28 08:10:12 -0400 Processing by SettingsController#oauth_callback as HTML Parameters: {"oauth_token"=>"qyprdRkNwvXl7etPSfi4vzhlMgTe2OXjsX94M6mkJmzVU69X", "oauth_verifier"=>"ev0kbn0", "realmId"=>"1411324040", "dataSource"=>"QBO"} Rendered settings/close_and_redirect.html.erb within layouts/application (0.1ms) Completed 200 OK in 543ms (Views: 11.6ms | ActiveRecord: 0.0ms) Started GET "/assets/application-5266d2988799ecc8fe6e81eaab412e7d.css?body=1" for ::1 at 2015-07-28 08:10:12 -0400 Started GET "/assets/application-5f1f3a0d9f2a8d9e8fcda8edadddaf68.js?body=1" for ::1 at 2015-07-28 08:10:13 -0400 Started GET "/oauth_callback?oauth_token=qyprdRkNwvXl7etPSfi4vzhlMgTe2OXjsX94M6mkJmzVU69X&oauth_verifier=ev0kbn0&realmId=1411324040&dataSource=QBO" for ::1 at 2015-07-28 08:10:18 -0400 Processing by SettingsController#oauth_callback as HTML Parameters: {"oauth_token"=>"qyprdRkNwvXl7etPSfi4vzhlMgTe2OXjsX94M6mkJmzVU69X", "oauth_verifier"=>"ev0kbn0", "realmId"=>"1411324040", "dataSource"=>"QBO"} Rendered settings/close_and_redirect.html.erb within layouts/application (0.1ms) Completed 200 OK in 687ms (Views: 9.2ms | ActiveRecord: 0.0ms) Started GET "/assets/application-5f1f3a0d9f2a8d9e8fcda8edadddaf68.js?body=1" for ::1 at 2015-07-28 08:10:18 -0400 Started GET "/assets/application-5266d2988799ecc8fe6e81eaab412e7d.css?body=1" for ::1 at 2015-07-28 08:10:18 -0400 Started GET "/oauth_callback?oauth_token=qyprdRkNwvXl7etPSfi4vzhlMgTe2OXjsX94M6mkJmzVU69X&oauth_verifier=ev0kbn0&realmId=1411324040&dataSource=QBO" for ::1 at 2015-07-28 08:10:23 -0400 Processing by SettingsController#oauth_callback as HTML Parameters: {"oauth_token"=>"qyprdRkNwvXl7etPSfi4vzhlMgTe2OXjsX94M6mkJmzVU69X", "oauth_verifier"=>"ev0kbn0", "realmId"=>"1411324040", "dataSource"=>"QBO"} Rendered settings/close_and_redirect.html.erb within layouts/application (0.1ms) Completed 200 OK in 545ms (Views: 9.8ms | ActiveRecord: 0.0ms) Started GET "/assets/application-5f1f3a0d9f2a8d9e8fcda8edadddaf68.js?body=1" for ::1 at 2015-07-28 08:10:24 -0400 Started GET "/assets/application-5266d2988799ecc8fe6e81eaab412e7d.css?body=1" for ::1 at 2015-07-28 08:10:24 -0400 Started GET "/oauth_callback?oauth_token=qyprdRkNwvXl7etPSfi4vzhlMgTe2OXjsX94M6mkJmzVU69X&oauth_verifier=ev0kbn0&realmId=1411324040&dataSource=QBO" for ::1 at 2015-07-28 08:10:29 -0400 Processing by SettingsController#oauth_callback as HTML Parameters: {"oauth_token"=>"qyprdRkNwvXl7etPSfi4vzhlMgTe2OXjsX94M6mkJmzVU69X", "oauth_verifier"=>"ev0kbn0", "realmId"=>"1411324040", "dataSource"=>"QBO"} Rendered settings/close_and_redirect.html.erb within layouts/application (0.1ms) Completed 200 OK in 641ms (Views: 9.0ms | ActiveRecord: 0.0ms) Started GET "/assets/application-5266d2988799ecc8fe6e81eaab412e7d.css?body=1" for ::1 at 2015-07-28 08:10:29 -0400 Started GET "/assets/application-5f1f3a0d9f2a8d9e8fcda8edadddaf68.js?body=1" for ::1 at 2015-07-28 08:10:29 -0400 Started GET "/oauth_callback?oauth_token=qyprdRkNwvXl7etPSfi4vzhlMgTe2OXjsX94M6mkJmzVU69X&oauth_verifier=ev0kbn0&realmId=1411324040&dataSource=QBO" for ::1 at 2015-07-28 08:10:35 -0400 Processing by SettingsController#oauth_callback as HTML Parameters: {"oauth_token"=>"qyprdRkNwvXl7etPSfi4vzhlMgTe2OXjsX94M6mkJmzVU69X", "oauth_verifier"=>"ev0kbn0", "realmId"=>"1411324040", "dataSource"=>"QBO"} Rendered settings/close_and_redirect.html.erb within layouts/application (0.1ms) Completed 200 OK in 591ms (Views: 10.1ms | ActiveRecord: 0.0ms) Started GET "/assets/application-5266d2988799ecc8fe6e81eaab412e7d.css?body=1" for ::1 at 2015-07-28 08:10:35 -0400 Started GET "/assets/application-5f1f3a0d9f2a8d9e8fcda8edadddaf68.js?body=1" for ::1 at 2015-07-28 08:10:35 -0400 Started GET "/" for ::1 at 2015-07-28 08:10:37 -0400 Processing by SettingsController#index as HTML Rendered settings/index.html.erb within layouts/application (0.6ms) Completed 200 OK in 12ms (Views: 11.9ms | ActiveRecord: 0.0ms) Started GET "/assets/application-5266d2988799ecc8fe6e81eaab412e7d.css?body=1" for ::1 at 2015-07-28 08:10:37 -0400 Started GET "/assets/application-5f1f3a0d9f2a8d9e8fcda8edadddaf68.js?body=1" for ::1 at 2015-07-28 08:10:37 -0400 Started GET "/oauth_start" for ::1 at 2015-07-28 08:10:47 -0400 Processing by SettingsController#oauth_start as HTML Redirected to https://appcenter.intuit.com/Connect/Begin?oauth_token=qyprdsbsHPZNViCb0vqEioyKMfQLD65wB9koW9KLjPysIphH Completed 302 Found in 355ms (ActiveRecord: 0.0ms) Started GET "/oauth_callback?oauth_token=qyprdsbsHPZNViCb0vqEioyKMfQLD65wB9koW9KLjPysIphH&oauth_verifier=x1w47r4&realmId=1411324040&dataSource=QBO" for ::1 at 2015-07-28 08:11:18 -0400 Processing by SettingsController#oauth_callback as HTML Parameters: {"oauth_token"=>"qyprdsbsHPZNViCb0vqEioyKMfQLD65wB9koW9KLjPysIphH", "oauth_verifier"=>"x1w47r4", "realmId"=>"1411324040", "dataSource"=>"QBO"} Rendered settings/close_and_redirect.html.erb within layouts/application (0.1ms) Completed 200 OK in 972ms (Views: 10.7ms | ActiveRecord: 0.0ms) Started GET "/assets/application-5f1f3a0d9f2a8d9e8fcda8edadddaf68.js?body=1" for ::1 at 2015-07-28 08:11:19 -0400 Started GET "/assets/application-5266d2988799ecc8fe6e81eaab412e7d.css?body=1" for ::1 at 2015-07-28 08:11:19 -0400 Started GET "/" for ::1 at 2015-07-28 08:11:24 -0400 Processing by SettingsController#index as HTML Rendered settings/index.html.erb within layouts/application (0.9ms) Completed 200 OK in 12ms (Views: 12.0ms | ActiveRecord: 0.0ms) Started GET "/assets/application-5f1f3a0d9f2a8d9e8fcda8edadddaf68.js?body=1" for ::1 at 2015-07-28 08:11:24 -0400 Started GET "/assets/application-5266d2988799ecc8fe6e81eaab412e7d.css?body=1" for ::1 at 2015-07-28 08:11:24 -0400 Started GET "/" for ::1 at 2015-07-28 08:12:52 -0400 Processing by SettingsController#index as HTML Rendered settings/index.html.erb within layouts/application (6.3ms) Completed 200 OK in 20ms (Views: 19.7ms | ActiveRecord: 0.0ms) Started GET "/assets/application-5266d2988799ecc8fe6e81eaab412e7d.css?body=1" for ::1 at 2015-07-28 08:12:52 -0400 Started GET "/assets/application-5f1f3a0d9f2a8d9e8fcda8edadddaf68.js?body=1" for ::1 at 2015-07-28 08:12:52 -0400 Started GET "/" for ::1 at 2015-07-28 08:13:05 -0400 Processing by SettingsController#index as HTML Rendered settings/index.html.erb within layouts/application (2.0ms) Completed 200 OK in 16ms (Views: 15.3ms | ActiveRecord: 0.0ms) Started GET "/assets/application-5266d2988799ecc8fe6e81eaab412e7d.css?body=1" for ::1 at 2015-07-28 08:13:05 -0400 Started GET "/assets/application-5f1f3a0d9f2a8d9e8fcda8edadddaf68.js?body=1" for ::1 at 2015-07-28 08:13:05 -0400 Started GET "/" for ::1 at 2015-07-28 08:13:34 -0400 Processing by SettingsController#index as HTML Rendered settings/index.html.erb within layouts/application (1.4ms) Completed 200 OK in 14ms (Views: 13.3ms | ActiveRecord: 0.0ms) Started GET "/assets/application-5266d2988799ecc8fe6e81eaab412e7d.css?body=1" for ::1 at 2015-07-28 08:13:34 -0400 Started GET "/assets/application-5f1f3a0d9f2a8d9e8fcda8edadddaf68.js?body=1" for ::1 at 2015-07-28 08:13:34 -0400 Started GET "/" for 127.0.0.1 at 2015-07-28 08:14:07 -0400 Processing by SettingsController#index as HTML Rendered settings/index.html.erb within layouts/application (1.4ms) Completed 200 OK in 16ms (Views: 15.3ms | ActiveRecord: 0.0ms) Started GET "/assets/application-5266d2988799ecc8fe6e81eaab412e7d.css?body=1" for 127.0.0.1 at 2015-07-28 08:14:07 -0400 Started GET "/assets/application-5f1f3a0d9f2a8d9e8fcda8edadddaf68.js?body=1" for 127.0.0.1 at 2015-07-28 08:14:07 -0400 QboError Load (1.3ms) SELECT "qbo_errors".* FROM "qbo_errors"