(62.3ms) CREATE TABLE "schema_migrations" ("version" varchar(255) NOT NULL)   (0.9ms) select sqlite_version(*)  (34.5ms) CREATE UNIQUE INDEX "unique_schema_migrations" ON "schema_migrations" ("version") ActiveRecord::SchemaMigration Load (8.2ms) SELECT "schema_migrations".* FROM "schema_migrations" Migrating to DeviseCreateUsers (20140417074003)  (0.3ms) begin transaction  (17.7ms) CREATE TABLE "users" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "email" varchar(255) DEFAULT '' NOT NULL, "encrypted_password" varchar(255) DEFAULT '' NOT NULL, "reset_password_token" varchar(255), "reset_password_sent_at" datetime, "remember_created_at" datetime, "sign_in_count" integer DEFAULT 0 NOT NULL, "current_sign_in_at" datetime, "last_sign_in_at" datetime, "current_sign_in_ip" varchar(255), "last_sign_in_ip" varchar(255), "created_at" datetime, "updated_at" datetime)  (1.2ms) CREATE UNIQUE INDEX "index_users_on_email" ON "users" ("email")  (0.2ms) SELECT sql FROM sqlite_master WHERE name='index_users_on_email' AND type='index' UNION ALL SELECT sql FROM sqlite_temp_master WHERE name='index_users_on_email' AND type='index'  (0.1ms) CREATE UNIQUE INDEX "index_users_on_reset_password_token" ON "users" ("reset_password_token") SQL (109.5ms) INSERT INTO "schema_migrations" ("version") VALUES (?) [["version", "20140417074003"]]  (25.5ms) commit transaction ActiveRecord::SchemaMigration Load (15.0ms) SELECT "schema_migrations".* FROM "schema_migrations"  (4.0ms)  SELECT sql FROM sqlite_master WHERE name='index_users_on_reset_password_token' AND type='index' UNION ALL SELECT sql FROM sqlite_temp_master WHERE name='index_users_on_reset_password_token' AND type='index'   (6.6ms) SELECT sql FROM sqlite_master WHERE name='index_users_on_email' AND type='index' UNION ALL SELECT sql FROM sqlite_temp_master WHERE name='index_users_on_email' AND type='index' ActiveRecord::SchemaMigration Load (6.3ms) SELECT "schema_migrations".* FROM "schema_migrations" Migrating to CreateLeads (20140417073703)  (0.2ms) begin transaction  (54.3ms) CREATE TABLE "leads" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "name" varchar(255), "last_name" varchar(255), "email" varchar(255), "company" varchar(255), "job_title" varchar(255), "phone" varchar(255), "website" varchar(255), "created_at" datetime, "updated_at" datetime)  SQL (111.3ms) INSERT INTO "schema_migrations" ("version") VALUES (?) [["version", "20140417073703"]]  (31.8ms) commit transaction Migrating to AddHighriseSiteAndHighriseUserToUser (20140417074432)  (0.2ms) begin transaction  (46.7ms) ALTER TABLE "users" ADD "highrise_site" varchar(255)  (0.4ms) ALTER TABLE "users" ADD "highrise_user" varchar(255) SQL (4.0ms) INSERT INTO "schema_migrations" ("version") VALUES (?) [["version", "20140417074432"]]  (13.5ms) commit transaction ActiveRecord::SchemaMigration Load (5.8ms) SELECT "schema_migrations".* FROM "schema_migrations"  (6.0ms) SELECT sql FROM sqlite_master WHERE name='index_users_on_reset_password_token' AND type='index' UNION ALL SELECT sql FROM sqlite_temp_master WHERE name='index_users_on_reset_password_token' AND type='index'  (6.5ms)  SELECT sql FROM sqlite_master WHERE name='index_users_on_email' AND type='index' UNION ALL SELECT sql FROM sqlite_temp_master WHERE name='index_users_on_email' AND type='index'  Started GET "/leads_to_highrise/leads" for 10.0.2.2 at 2014-04-17 07:49:38 +0000 ActiveRecord::SchemaMigration Load (7.6ms) SELECT "schema_migrations".* FROM "schema_migrations" ActionController::RoutingError (No route matches [GET] "/leads_to_highrise/leads"): actionpack (4.1.0) lib/action_dispatch/middleware/debug_exceptions.rb:21:in `call' actionpack (4.1.0) lib/action_dispatch/middleware/show_exceptions.rb:30:in `call' railties (4.1.0) lib/rails/rack/logger.rb:38:in `call_app' railties (4.1.0) lib/rails/rack/logger.rb:20:in `block in call' activesupport (4.1.0) lib/active_support/tagged_logging.rb:68:in `block in tagged' activesupport (4.1.0) lib/active_support/tagged_logging.rb:26:in `tagged' activesupport (4.1.0) lib/active_support/tagged_logging.rb:68:in `tagged' railties (4.1.0) lib/rails/rack/logger.rb:20:in `call' actionpack (4.1.0) lib/action_dispatch/middleware/request_id.rb:21:in `call' rack (1.5.2) lib/rack/methodoverride.rb:21:in `call' rack (1.5.2) lib/rack/runtime.rb:17:in `call' activesupport (4.1.0) lib/active_support/cache/strategy/local_cache_middleware.rb:26:in `call' rack (1.5.2) lib/rack/lock.rb:17:in `call' actionpack (4.1.0) lib/action_dispatch/middleware/static.rb:64:in `call' rack (1.5.2) lib/rack/sendfile.rb:112:in `call' railties (4.1.0) lib/rails/engine.rb:514:in `call' railties (4.1.0) lib/rails/application.rb:144:in `call' rack (1.5.2) lib/rack/lock.rb:17:in `call' rack (1.5.2) lib/rack/content_length.rb:14:in `call' rack (1.5.2) lib/rack/handler/webrick.rb:60:in `service' /home/vagrant/.rvm/rubies/ruby-1.9.3-p484/lib/ruby/1.9.1/webrick/httpserver.rb:138:in `service' /home/vagrant/.rvm/rubies/ruby-1.9.3-p484/lib/ruby/1.9.1/webrick/httpserver.rb:94:in `run' /home/vagrant/.rvm/rubies/ruby-1.9.3-p484/lib/ruby/1.9.1/webrick/server.rb:191:in `block in start_thread' Rendered /home/vagrant/.rvm/gems/ruby-1.9.3-p484/gems/actionpack-4.1.0/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (3.6ms) Rendered /home/vagrant/.rvm/gems/ruby-1.9.3-p484/gems/actionpack-4.1.0/lib/action_dispatch/middleware/templates/routes/_route.html.erb (7.3ms) Rendered /home/vagrant/.rvm/gems/ruby-1.9.3-p484/gems/actionpack-4.1.0/lib/action_dispatch/middleware/templates/routes/_table.html.erb (350.9ms) Rendered /home/vagrant/.rvm/gems/ruby-1.9.3-p484/gems/actionpack-4.1.0/lib/action_dispatch/middleware/templates/rescues/routing_error.html.erb within rescues/layout (932.0ms) Started GET "/leads" for 10.0.2.2 at 2014-04-17 07:50:02 +0000 Processing by LeadsController#index as HTML Lead Load (9.6ms) SELECT "leads".* FROM "leads" Rendered /vagrant/engine/leads_to_highrise/app/views/leads/index.html.erb within layouts/application (17.6ms) Completed 200 OK in 1893ms (Views: 1611.6ms | ActiveRecord: 9.6ms) Started GET "/assets/application.css?body=1" for 10.0.2.2 at 2014-04-17 07:50:05 +0000 Started GET "/assets/application.js?body=1" for 10.0.2.2 at 2014-04-17 07:50:05 +0000 Started GET "/leads/new" for 10.0.2.2 at 2014-04-17 07:50:09 +0000 Processing by LeadsController#new as HTML Rendered /vagrant/engine/leads_to_highrise/app/views/leads/_form.html.erb (352.7ms) Rendered /vagrant/engine/leads_to_highrise/app/views/leads/new.html.erb within layouts/application (601.0ms) Completed 200 OK in 1412ms (Views: 1399.5ms | ActiveRecord: 6.5ms) Started GET "/assets/application.js?body=1" for 10.0.2.2 at 2014-04-17 07:50:11 +0000 Started GET "/assets/application.css?body=1" for 10.0.2.2 at 2014-04-17 07:50:11 +0000 Started POST "/leads" for 10.0.2.2 at 2014-04-17 07:50:32 +0000 Processing by LeadsController#create as HTML Parameters: {"utf8"=>"✓", "authenticity_token"=>"h7Hg4BJhz4hBTU1oDxw7PGmnVkKc9VDDskwoZAPV/xs=", "lead"=>{"name"=>"Bruno", "last_name"=>"Tripoloni", "email"=>"bruno.tripoloni@gmail.com", "company"=>"brunolandia", "job_title"=>"empresaria", "phone"=>"(18) 3528-5172", "website"=>"site.com.br"}, "commit"=>"Create Lead"}  (1.2ms) begin transaction SQL (18.5ms) INSERT INTO "leads" ("company", "created_at", "email", "job_title", "last_name", "name", "phone", "updated_at", "website") VALUES (?, ?, ?, ?, ?, ?, ?, ?, ?) [["company", "brunolandia"], ["created_at", "2014-04-17 07:50:32.614099"], ["email", "bruno.tripoloni@gmail.com"], ["job_title", "empresaria"], ["last_name", "Tripoloni"], ["name", "Bruno"], ["phone", "(18) 3528-5172"], ["updated_at", "2014-04-17 07:50:32.614099"], ["website", "site.com.br"]]  (19.8ms) commit transaction Redirected to http://localhost:3000/leads/1 Completed 302 Found in 233ms (ActiveRecord: 39.5ms) Started GET "/leads/1" for 10.0.2.2 at 2014-04-17 07:50:32 +0000 Processing by LeadsController#show as HTML Parameters: {"id"=>"1"} Lead Load (57.7ms) SELECT "leads".* FROM "leads" WHERE "leads"."id" = ? LIMIT 1 [["id", 1]] Rendered /vagrant/engine/leads_to_highrise/app/views/leads/show.html.erb within layouts/application (6.2ms) Completed 200 OK in 833ms (Views: 759.6ms | ActiveRecord: 57.7ms) Started GET "/assets/application.css?body=1" for 10.0.2.2 at 2014-04-17 07:50:34 +0000 Started GET "/assets/application.js?body=1" for 10.0.2.2 at 2014-04-17 07:50:34 +0000 Started GET "/leads" for 10.0.2.2 at 2014-04-17 07:50:37 +0000 Processing by LeadsController#index as HTML Lead Load (8.4ms) SELECT "leads".* FROM "leads" Rendered /vagrant/engine/leads_to_highrise/app/views/leads/index.html.erb within layouts/application (24.8ms) Completed 200 OK in 874ms (Views: 861.5ms | ActiveRecord: 8.4ms) Started GET "/assets/application.css?body=1" for 10.0.2.2 at 2014-04-17 07:50:38 +0000 Started GET "/assets/application.js?body=1" for 10.0.2.2 at 2014-04-17 07:50:39 +0000 Started GET "/leads" for 10.0.2.2 at 2014-04-17 07:53:20 +0000 Processing by LeadsController#index as HTML Lead Load (30.3ms) SELECT "leads".* FROM "leads" Rendered /vagrant/engine/leads_to_highrise/app/views/leads/index.html.erb within layouts/application (191.3ms) Completed 200 OK in 1312ms (Views: 1026.9ms | ActiveRecord: 40.6ms) Started GET "/assets/application.css?body=1" for 10.0.2.2 at 2014-04-17 07:53:24 +0000 Started GET "/assets/application.js?body=1" for 10.0.2.2 at 2014-04-17 07:53:25 +0000 Started GET "/users/sign_up" for 10.0.2.2 at 2014-04-17 07:55:30 +0000 Processing by Devise::RegistrationsController#new as HTML Rendered /home/vagrant/.rvm/gems/ruby-1.9.3-p484/gems/devise-3.2.4/app/views/devise/shared/_links.erb (2.6ms) Rendered /home/vagrant/.rvm/gems/ruby-1.9.3-p484/gems/devise-3.2.4/app/views/devise/registrations/new.html.erb within layouts/application (544.1ms) Completed 200 OK in 1415ms (Views: 1383.8ms | ActiveRecord: 19.4ms) Started GET "/assets/application.js?body=1" for 10.0.2.2 at 2014-04-17 07:55:33 +0000 Started GET "/assets/application.css?body=1" for 10.0.2.2 at 2014-04-17 07:55:33 +0000 Started POST "/users" for 10.0.2.2 at 2014-04-17 07:55:42 +0000 Processing by Devise::RegistrationsController#create as HTML Parameters: {"utf8"=>"✓", "authenticity_token"=>"h7Hg4BJhz4hBTU1oDxw7PGmnVkKc9VDDskwoZAPV/xs=", "user"=>{"email"=>"bruno.tripoloni@gmail.com", "password"=>"[FILTERED]", "password_confirmation"=>"[FILTERED]"}, "commit"=>"Sign up"}  (0.4ms) begin transaction User Exists (6.9ms) SELECT 1 AS one FROM "users" WHERE "users"."email" = 'bruno.tripoloni@gmail.com' LIMIT 1 Binary data inserted for `string` type on column `encrypted_password` SQL (40.5ms) INSERT INTO "users" ("created_at", "email", "encrypted_password", "updated_at") VALUES (?, ?, ?, ?) [["created_at", "2014-04-17 07:55:44.397954"], ["email", "bruno.tripoloni@gmail.com"], ["encrypted_password", "$2a$10$sk7u/sunhTWBliO2CsRSquG0qCsCTW.SDF6z3sUYsEJT/pYyqrql6"], ["updated_at", "2014-04-17 07:55:44.397954"]]  (51.5ms) commit transaction  (0.2ms) begin transaction Binary data inserted for `string` type on column `current_sign_in_ip` Binary data inserted for `string` type on column `last_sign_in_ip` SQL (82.7ms) UPDATE "users" SET "current_sign_in_at" = ?, "current_sign_in_ip" = ?, "last_sign_in_at" = ?, "last_sign_in_ip" = ?, "sign_in_count" = ?, "updated_at" = ? WHERE "users"."id" = 1 [["current_sign_in_at", "2014-04-17 07:55:44.502309"], ["current_sign_in_ip", "10.0.2.2"], ["last_sign_in_at", "2014-04-17 07:55:44.502309"], ["last_sign_in_ip", "10.0.2.2"], ["sign_in_count", 1], ["updated_at", "2014-04-17 07:55:44.556125"]]  (40.8ms) commit transaction Redirected to http://localhost:3000/ Completed 302 Found in 2234ms (ActiveRecord: 222.9ms) Started GET "/" for 10.0.2.2 at 2014-04-17 07:55:45 +0000 Processing by Rails::WelcomeController#index as HTML Rendered /home/vagrant/.rvm/gems/ruby-1.9.3-p484/gems/railties-4.1.0/lib/rails/templates/rails/welcome/index.html.erb (6.1ms) Completed 200 OK in 121ms (Views: 119.7ms | ActiveRecord: 0.0ms) Started GET "/" for 10.0.2.2 at 2014-04-17 07:57:04 +0000 Processing by LeadsController#index as HTML Lead Load (17.3ms) SELECT "leads".* FROM "leads" User Load (8.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 ORDER BY "users"."id" ASC LIMIT 1 Rendered /vagrant/engine/leads_to_highrise/app/views/leads/index.html.erb within layouts/application (619.4ms) Completed 200 OK in 1547ms (Views: 1258.6ms | ActiveRecord: 71.4ms) Started GET "/assets/application.css?body=1" for 10.0.2.2 at 2014-04-17 07:57:08 +0000 Started GET "/assets/application.js?body=1" for 10.0.2.2 at 2014-04-17 07:57:08 +0000 User Load (7.5ms) SELECT "users".* FROM "users" ORDER BY "users"."id" DESC LIMIT 1  (0.5ms) begin transaction SQL (15.2ms) UPDATE "users" SET "highrise_site" = ?, "highrise_user" = ?, "updated_at" = ? WHERE "users"."id" = 1 [["highrise_site", "https://brunotripoloni.highrisehq.com"], ["highrise_user", "ac3c0c23c6333683a221dc75b70be717"], ["updated_at", "2014-04-17 07:59:53.614049"]]  (13.8ms) commit transaction Started GET "/" for 10.0.2.2 at 2014-04-17 08:01:05 +0000 Processing by LeadsController#index as HTML Lead Load (15.9ms) SELECT "leads".* FROM "leads" User Load (6.7ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 ORDER BY "users"."id" ASC LIMIT 1 Rendered /vagrant/engine/leads_to_highrise/app/views/leads/index.html.erb within layouts/application (33.2ms) Completed 200 OK in 901ms (Views: 865.6ms | ActiveRecord: 22.6ms) Started GET "/assets/application.css?body=1" for 10.0.2.2 at 2014-04-17 08:01:07 +0000 Started GET "/assets/application.js?body=1" for 10.0.2.2 at 2014-04-17 08:01:07 +0000 Started GET "/leads/1/to_highrise" for 10.0.2.2 at 2014-04-17 08:01:09 +0000 Processing by LeadsController#to_highrise as HTML Parameters: {"id"=>"1"} Lead Load (4.5ms) SELECT "leads".* FROM "leads" WHERE "leads"."id" = ? LIMIT 1 [["id", 1]] Completed 500 Internal Server Error in 365ms NameError (uninitialized constant LeadsController::Highrise): /vagrant/engine/leads_to_highrise/app/controllers/leads_controller.rb:56:in `add_person' /vagrant/engine/leads_to_highrise/app/controllers/leads_controller.rb:50:in `to_highrise' actionpack (4.1.0) lib/action_controller/metal/implicit_render.rb:4:in `send_action' actionpack (4.1.0) lib/abstract_controller/base.rb:189:in `process_action' actionpack (4.1.0) lib/action_controller/metal/rendering.rb:10:in `process_action' actionpack (4.1.0) lib/abstract_controller/callbacks.rb:20:in `block in process_action' activesupport (4.1.0) lib/active_support/callbacks.rb:113:in `call' activesupport (4.1.0) lib/active_support/callbacks.rb:113:in `call' activesupport (4.1.0) lib/active_support/callbacks.rb:149:in `block in halting_and_conditional' activesupport (4.1.0) lib/active_support/callbacks.rb:229:in `call' activesupport (4.1.0) lib/active_support/callbacks.rb:229:in `block in halting' activesupport (4.1.0) lib/active_support/callbacks.rb:166:in `call' activesupport (4.1.0) lib/active_support/callbacks.rb:166:in `block in halting' activesupport (4.1.0) lib/active_support/callbacks.rb:86:in `call' activesupport (4.1.0) lib/active_support/callbacks.rb:86:in `run_callbacks' actionpack (4.1.0) lib/abstract_controller/callbacks.rb:19:in `process_action' actionpack (4.1.0) lib/action_controller/metal/rescue.rb:29:in `process_action' actionpack (4.1.0) lib/action_controller/metal/instrumentation.rb:31:in `block in process_action' activesupport (4.1.0) lib/active_support/notifications.rb:159:in `block in instrument' activesupport (4.1.0) lib/active_support/notifications/instrumenter.rb:20:in `instrument' activesupport (4.1.0) lib/active_support/notifications.rb:159:in `instrument' actionpack (4.1.0) lib/action_controller/metal/instrumentation.rb:30:in `process_action' actionpack (4.1.0) lib/action_controller/metal/params_wrapper.rb:250:in `process_action' activerecord (4.1.0) lib/active_record/railties/controller_runtime.rb:18:in `process_action' actionpack (4.1.0) lib/abstract_controller/base.rb:136:in `process' actionview (4.1.0) lib/action_view/rendering.rb:30:in `process' actionpack (4.1.0) lib/action_controller/metal.rb:195:in `dispatch' actionpack (4.1.0) lib/action_controller/metal/rack_delegation.rb:13:in `dispatch' actionpack (4.1.0) lib/action_controller/metal.rb:231:in `block in action' actionpack (4.1.0) lib/action_dispatch/routing/route_set.rb:80:in `call' actionpack (4.1.0) lib/action_dispatch/routing/route_set.rb:80:in `dispatch' actionpack (4.1.0) lib/action_dispatch/routing/route_set.rb:48:in `call' actionpack (4.1.0) lib/action_dispatch/journey/router.rb:71:in `block in call' actionpack (4.1.0) lib/action_dispatch/journey/router.rb:59:in `each' actionpack (4.1.0) lib/action_dispatch/journey/router.rb:59:in `call' actionpack (4.1.0) lib/action_dispatch/routing/route_set.rb:676:in `call' warden (1.2.3) lib/warden/manager.rb:35:in `block in call' warden (1.2.3) lib/warden/manager.rb:34:in `catch' warden (1.2.3) lib/warden/manager.rb:34:in `call' rack (1.5.2) lib/rack/etag.rb:23:in `call' rack (1.5.2) lib/rack/conditionalget.rb:25:in `call' rack (1.5.2) lib/rack/head.rb:11:in `call' actionpack (4.1.0) lib/action_dispatch/middleware/params_parser.rb:27:in `call' actionpack (4.1.0) lib/action_dispatch/middleware/flash.rb:254:in `call' rack (1.5.2) lib/rack/session/abstract/id.rb:225:in `context' rack (1.5.2) lib/rack/session/abstract/id.rb:220:in `call' actionpack (4.1.0) lib/action_dispatch/middleware/cookies.rb:560:in `call' activerecord (4.1.0) lib/active_record/query_cache.rb:36:in `call' activerecord (4.1.0) lib/active_record/connection_adapters/abstract/connection_pool.rb:621:in `call' activerecord (4.1.0) lib/active_record/migration.rb:380:in `call' actionpack (4.1.0) lib/action_dispatch/middleware/callbacks.rb:29:in `block in call' activesupport (4.1.0) lib/active_support/callbacks.rb:82:in `run_callbacks' actionpack (4.1.0) lib/action_dispatch/middleware/callbacks.rb:27:in `call' actionpack (4.1.0) lib/action_dispatch/middleware/reloader.rb:73:in `call' actionpack (4.1.0) lib/action_dispatch/middleware/remote_ip.rb:76:in `call' actionpack (4.1.0) lib/action_dispatch/middleware/debug_exceptions.rb:17:in `call' actionpack (4.1.0) lib/action_dispatch/middleware/show_exceptions.rb:30:in `call' railties (4.1.0) lib/rails/rack/logger.rb:38:in `call_app' railties (4.1.0) lib/rails/rack/logger.rb:20:in `block in call' activesupport (4.1.0) lib/active_support/tagged_logging.rb:68:in `block in tagged' activesupport (4.1.0) lib/active_support/tagged_logging.rb:26:in `tagged' activesupport (4.1.0) lib/active_support/tagged_logging.rb:68:in `tagged' railties (4.1.0) lib/rails/rack/logger.rb:20:in `call' actionpack (4.1.0) lib/action_dispatch/middleware/request_id.rb:21:in `call' rack (1.5.2) lib/rack/methodoverride.rb:21:in `call' rack (1.5.2) lib/rack/runtime.rb:17:in `call' activesupport (4.1.0) lib/active_support/cache/strategy/local_cache_middleware.rb:26:in `call' rack (1.5.2) lib/rack/lock.rb:17:in `call' actionpack (4.1.0) lib/action_dispatch/middleware/static.rb:64:in `call' rack (1.5.2) lib/rack/sendfile.rb:112:in `call' railties (4.1.0) lib/rails/engine.rb:514:in `call' railties (4.1.0) lib/rails/application.rb:144:in `call' rack (1.5.2) lib/rack/lock.rb:17:in `call' rack (1.5.2) lib/rack/content_length.rb:14:in `call' rack (1.5.2) lib/rack/handler/webrick.rb:60:in `service' /home/vagrant/.rvm/rubies/ruby-1.9.3-p484/lib/ruby/1.9.1/webrick/httpserver.rb:138:in `service' /home/vagrant/.rvm/rubies/ruby-1.9.3-p484/lib/ruby/1.9.1/webrick/httpserver.rb:94:in `run' /home/vagrant/.rvm/rubies/ruby-1.9.3-p484/lib/ruby/1.9.1/webrick/server.rb:191:in `block in start_thread' Rendered /home/vagrant/.rvm/gems/ruby-1.9.3-p484/gems/actionpack-4.1.0/lib/action_dispatch/middleware/templates/rescues/_source.erb (2.1ms) Rendered /home/vagrant/.rvm/gems/ruby-1.9.3-p484/gems/actionpack-4.1.0/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (15.9ms) Rendered /home/vagrant/.rvm/gems/ruby-1.9.3-p484/gems/actionpack-4.1.0/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (20.3ms) Rendered /home/vagrant/.rvm/gems/ruby-1.9.3-p484/gems/actionpack-4.1.0/lib/action_dispatch/middleware/templates/rescues/diagnostics.erb within rescues/layout (277.1ms) Started GET "/leads/1/to_highrise" for 10.0.2.2 at 2014-04-17 08:01:36 +0000 Processing by LeadsController#to_highrise as HTML Parameters: {"id"=>"1"} Lead Load (6.7ms) SELECT "leads".* FROM "leads" WHERE "leads"."id" = ? LIMIT 1 [["id", 1]] User Load (19.4ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 ORDER BY "users"."id" ASC LIMIT 1 Redirected to http://localhost:3000/ Completed 302 Found in 6068ms (ActiveRecord: 72.7ms) Started GET "/" for 10.0.2.2 at 2014-04-17 08:01:48 +0000 Processing by LeadsController#index as HTML Lead Load (40.8ms) SELECT "leads".* FROM "leads" User Load (5.8ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 ORDER BY "users"."id" ASC LIMIT 1 Rendered /vagrant/engine/leads_to_highrise/app/views/leads/index.html.erb within layouts/application (221.4ms) Completed 200 OK in 835ms (Views: 787.7ms | ActiveRecord: 46.6ms) Started GET "/assets/application.css?body=1" for 10.0.2.2 at 2014-04-17 08:01:49 +0000 Started GET "/assets/application.js?body=1" for 10.0.2.2 at 2014-04-17 08:01:49 +0000 Started GET "/leads/1" for 10.0.2.2 at 2014-04-17 08:02:46 +0000 Processing by LeadsController#show as HTML Parameters: {"id"=>"1"} Lead Load (20.3ms) SELECT "leads".* FROM "leads" WHERE "leads"."id" = ? LIMIT 1 [["id", 1]] Rendered /vagrant/engine/leads_to_highrise/app/views/leads/show.html.erb within layouts/application (6.2ms) Completed 200 OK in 847ms (Views: 795.2ms | ActiveRecord: 20.3ms) Started GET "/assets/application.css?body=1" for 10.0.2.2 at 2014-04-17 08:02:47 +0000 Started GET "/assets/application.js?body=1" for 10.0.2.2 at 2014-04-17 08:02:48 +0000 Started GET "/" for 10.0.2.2 at 2014-04-17 08:18:56 +0000 Processing by LeadsController#index as HTML Lead Load (13.3ms) SELECT "leads".* FROM "leads" User Load (21.8ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 ORDER BY "users"."id" ASC LIMIT 1 Rendered /vagrant/engine/leads_to_highrise/app/views/leads/index.html.erb within layouts/application (82.8ms) Completed 200 OK in 861ms (Views: 825.3ms | ActiveRecord: 35.1ms) Started GET "/assets/application.css?body=1" for 10.0.2.2 at 2014-04-17 08:18:58 +0000 Started GET "/assets/application.js?body=1" for 10.0.2.2 at 2014-04-17 08:18:59 +0000 Started GET "/xfrsg" for 10.0.2.2 at 2014-04-17 08:19:07 +0000 ActionController::RoutingError (No route matches [GET] "/xfrsg"): actionpack (4.1.0) lib/action_dispatch/middleware/debug_exceptions.rb:21:in `call' actionpack (4.1.0) lib/action_dispatch/middleware/show_exceptions.rb:30:in `call' railties (4.1.0) lib/rails/rack/logger.rb:38:in `call_app' railties (4.1.0) lib/rails/rack/logger.rb:20:in `block in call' activesupport (4.1.0) lib/active_support/tagged_logging.rb:68:in `block in tagged' activesupport (4.1.0) lib/active_support/tagged_logging.rb:26:in `tagged' activesupport (4.1.0) lib/active_support/tagged_logging.rb:68:in `tagged' railties (4.1.0) lib/rails/rack/logger.rb:20:in `call' actionpack (4.1.0) lib/action_dispatch/middleware/request_id.rb:21:in `call' rack (1.5.2) lib/rack/methodoverride.rb:21:in `call' rack (1.5.2) lib/rack/runtime.rb:17:in `call' activesupport (4.1.0) lib/active_support/cache/strategy/local_cache_middleware.rb:26:in `call' rack (1.5.2) lib/rack/lock.rb:17:in `call' actionpack (4.1.0) lib/action_dispatch/middleware/static.rb:64:in `call' rack (1.5.2) lib/rack/sendfile.rb:112:in `call' railties (4.1.0) lib/rails/engine.rb:514:in `call' railties (4.1.0) lib/rails/application.rb:144:in `call' rack (1.5.2) lib/rack/lock.rb:17:in `call' rack (1.5.2) lib/rack/content_length.rb:14:in `call' rack (1.5.2) lib/rack/handler/webrick.rb:60:in `service' /home/vagrant/.rvm/rubies/ruby-1.9.3-p484/lib/ruby/1.9.1/webrick/httpserver.rb:138:in `service' /home/vagrant/.rvm/rubies/ruby-1.9.3-p484/lib/ruby/1.9.1/webrick/httpserver.rb:94:in `run' /home/vagrant/.rvm/rubies/ruby-1.9.3-p484/lib/ruby/1.9.1/webrick/server.rb:191:in `block in start_thread' Rendered /home/vagrant/.rvm/gems/ruby-1.9.3-p484/gems/actionpack-4.1.0/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (11.6ms) Rendered /home/vagrant/.rvm/gems/ruby-1.9.3-p484/gems/actionpack-4.1.0/lib/action_dispatch/middleware/templates/routes/_route.html.erb (4.3ms) Rendered /home/vagrant/.rvm/gems/ruby-1.9.3-p484/gems/actionpack-4.1.0/lib/action_dispatch/middleware/templates/routes/_table.html.erb (4.6ms) Rendered /home/vagrant/.rvm/gems/ruby-1.9.3-p484/gems/actionpack-4.1.0/lib/action_dispatch/middleware/templates/rescues/routing_error.html.erb within rescues/layout (181.9ms) Started GET "/leads" for 10.0.2.2 at 2014-04-17 08:19:24 +0000 Processing by LeadsController#index as HTML Lead Load (8.0ms) SELECT "leads".* FROM "leads" User Load (16.7ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 ORDER BY "users"."id" ASC LIMIT 1 Rendered /vagrant/engine/leads_to_highrise/app/views/leads/index.html.erb within layouts/application (52.5ms) Completed 200 OK in 1035ms (Views: 1008.5ms | ActiveRecord: 24.7ms) Started GET "/assets/application.css?body=1" for 10.0.2.2 at 2014-04-17 08:19:25 +0000 Started GET "/assets/application.js?body=1" for 10.0.2.2 at 2014-04-17 08:19:26 +0000