spec/dummy/log/development.log in cadenero-0.0.2.a2 vs spec/dummy/log/development.log in cadenero-0.0.2.a3

- old
+ new

@@ -1,325 +1,85 @@ Connecting to database specified by database.yml -Started GET "/" for 127.0.0.1 at 2013-06-27 22:27:20 -0500 -Processing by Cadenero::V1::Account::DashboardController#index as HTML - Parameters: {"default"=>:json} -env['warden'].authenticated?(:user): false -Filter chain halted as :authenticate_user! rendered or redirected -Completed 422 Unprocessable Entity in 7ms (Views: 0.5ms | ActiveRecord: 0.0ms) +Started POST "/v1/accounts" for 127.0.0.1 at 2013-06-28 21:05:24 -0500 +Processing by Cadenero::V1::AccountsController#create as JSON + Parameters: {"{\"account\": { \"name\": \"Testy\", \"subdomain\": \"tested\", \"owner_attributes\": {\"email\": \"testy2@example.com\", \"password\": \"changeme\", \"password_confirmation\": \"changeme\"}}}"=>"[FILTERED]", "default"=>:json} +AccountsController params[:account]: +  (0.1ms) BEGIN + Cadenero::V1::Account Exists (0.7ms) SELECT 1 AS one FROM "public"."cadenero_accounts" WHERE "public"."cadenero_accounts"."subdomain" IS NULL LIMIT 1 +  (0.1ms) ROLLBACK + CACHE (0.0ms) SELECT 1 AS one FROM "public"."cadenero_accounts" WHERE "public"."cadenero_accounts"."subdomain" IS NULL LIMIT 1 +Completed 422 Unprocessable Entity in 206ms (Views: 0.3ms | ActiveRecord: 53.9ms) -Started POST "/v1/sessions" for 127.0.0.1 at 2013-06-27 22:27:54 -0500 -Processing by Cadenero::V1::Account::SessionsController#create as HTML - Parameters: {"user"=>{"email"=>"testy3@example.com", "password"=>"[FILTERED]"}, "default"=>:json} -params: {"user"=>{"email"=>"testy3@example.com", "password"=>"changeme"}, "default"=>:json, "controller"=>"cadenero/v1/account/sessions", "action"=>"create"} -valid? subdomain: ["test3"] -json_params: {} -valid? json_params: {"user"=>{"email"=>"testy3@example.com", "password"=>"changeme"}} -json_params: {} -Completed 500 Internal Server Error in 1ms +Started POST "/v1/accounts" for 127.0.0.1 at 2013-06-28 21:07:22 -0500 +Processing by Cadenero::V1::AccountsController#create as JSON + Parameters: {"{account: { name: \"Testy\", subdomain: \"tested\", owner_attributes: {email: \"testy2@example.com\", password: \"changeme\", password_confirmation: \"changeme\"}}}"=>"[FILTERED]", "default"=>:json} +AccountsController params[:account]: +  (0.9ms) BEGIN + Cadenero::V1::Account Exists (0.2ms) SELECT 1 AS one FROM "public"."cadenero_accounts" WHERE "public"."cadenero_accounts"."subdomain" IS NULL LIMIT 1 +  (0.1ms) ROLLBACK + CACHE (0.0ms) SELECT 1 AS one FROM "public"."cadenero_accounts" WHERE "public"."cadenero_accounts"."subdomain" IS NULL LIMIT 1 +Completed 422 Unprocessable Entity in 23ms (Views: 0.3ms | ActiveRecord: 3.4ms) -TypeError (can't convert nil into String): - /Users/manuelevidaurrea/.rbenv/versions/1.9.3-p429/lib/ruby/1.9.1/json/common.rb:148:in `initialize' - /Users/manuelevidaurrea/.rbenv/versions/1.9.3-p429/lib/ruby/1.9.1/json/common.rb:148:in `new' - /Users/manuelevidaurrea/.rbenv/versions/1.9.3-p429/lib/ruby/1.9.1/json/common.rb:148:in `parse' - /Users/manuelevidaurrea/Documents/work/agiltec/workspace/ruby/rails/cadenero/config/initializers/warden/strategies/password.rb:12:in `json_params' - /Users/manuelevidaurrea/Documents/work/agiltec/workspace/ruby/rails/cadenero/config/initializers/warden/strategies/password.rb:19:in `valid?' - warden (1.2.1) lib/warden/proxy.rb:351:in `block in _run_strategies_for' - warden (1.2.1) lib/warden/proxy.rb:349:in `each' - warden (1.2.1) lib/warden/proxy.rb:349:in `_run_strategies_for' - warden (1.2.1) lib/warden/proxy.rb:319:in `_perform_authentication' - warden (1.2.1) lib/warden/proxy.rb:104:in `authenticate' - /Users/manuelevidaurrea/Documents/work/agiltec/workspace/ruby/rails/cadenero/app/controllers/cadenero/v1/account/sessions_controller.rb:7:in `create' - actionpack (3.2.13) lib/abstract_controller/base.rb:167:in `process_action' - actionpack (3.2.13) lib/action_controller/metal/rendering.rb:10:in `process_action' - actionpack (3.2.13) lib/abstract_controller/callbacks.rb:18:in `block in process_action' - activesupport (3.2.13) lib/active_support/callbacks.rb:403:in `_run__1930556790785450317__process_action__3783338458040428985__callbacks' - activesupport (3.2.13) lib/active_support/callbacks.rb:405:in `__run_callback' - activesupport (3.2.13) lib/active_support/callbacks.rb:385:in `_run_process_action_callbacks' - activesupport (3.2.13) lib/active_support/callbacks.rb:81:in `run_callbacks' - actionpack (3.2.13) lib/abstract_controller/callbacks.rb:17:in `process_action' - actionpack (3.2.13) lib/action_controller/metal/rescue.rb:29:in `process_action' - actionpack (3.2.13) lib/action_controller/metal/instrumentation.rb:30:in `block in process_action' - activesupport (3.2.13) lib/active_support/notifications.rb:123:in `block in instrument' - activesupport (3.2.13) lib/active_support/notifications/instrumenter.rb:20:in `instrument' - activesupport (3.2.13) lib/active_support/notifications.rb:123:in `instrument' - actionpack (3.2.13) lib/action_controller/metal/instrumentation.rb:29:in `process_action' - activerecord (3.2.13) lib/active_record/railties/controller_runtime.rb:18:in `process_action' - actionpack (3.2.13) lib/abstract_controller/base.rb:121:in `process' - actionpack (3.2.13) lib/abstract_controller/rendering.rb:45:in `process' - actionpack (3.2.13) lib/action_controller/metal.rb:203:in `dispatch' - actionpack (3.2.13) lib/action_controller/metal/rack_delegation.rb:14:in `dispatch' - actionpack (3.2.13) lib/action_controller/metal.rb:246:in `block in action' - actionpack (3.2.13) lib/action_dispatch/routing/route_set.rb:73:in `call' - actionpack (3.2.13) lib/action_dispatch/routing/route_set.rb:73:in `dispatch' - actionpack (3.2.13) lib/action_dispatch/routing/route_set.rb:36:in `call' - actionpack (3.2.13) lib/action_dispatch/routing/mapper.rb:42:in `call' - journey (1.0.4) lib/journey/router.rb:68:in `block in call' - journey (1.0.4) lib/journey/router.rb:56:in `each' - journey (1.0.4) lib/journey/router.rb:56:in `call' - actionpack (3.2.13) lib/action_dispatch/routing/route_set.rb:612:in `call' - rack (1.4.5) lib/rack/session/abstract/id.rb:210:in `context' - rack (1.4.5) lib/rack/session/abstract/id.rb:205:in `call' - actionpack (3.2.13) lib/action_dispatch/middleware/cookies.rb:341:in `call' - warden (1.2.1) lib/warden/manager.rb:31:in `call' - railties (3.2.13) lib/rails/engine.rb:479:in `call' - railties (3.2.13) lib/rails/railtie/configurable.rb:30:in `method_missing' - journey (1.0.4) lib/journey/router.rb:68:in `block in call' - journey (1.0.4) lib/journey/router.rb:56:in `each' - journey (1.0.4) lib/journey/router.rb:56:in `call' - actionpack (3.2.13) lib/action_dispatch/routing/route_set.rb:612:in `call' - warden (1.2.1) lib/warden/manager.rb:35:in `block in call' - warden (1.2.1) lib/warden/manager.rb:34:in `catch' - warden (1.2.1) lib/warden/manager.rb:34:in `call' - apartment (0.21.1) lib/apartment/elevators/generic.rb:19:in `call' - apartment (0.21.1) lib/apartment/reloader.rb:19:in `call' - rack (1.4.5) lib/rack/etag.rb:23:in `call' - rack (1.4.5) lib/rack/conditionalget.rb:35:in `call' - actionpack (3.2.13) lib/action_dispatch/middleware/head.rb:14:in `call' - actionpack (3.2.13) lib/action_dispatch/middleware/params_parser.rb:21:in `call' - activerecord (3.2.13) lib/active_record/query_cache.rb:64:in `call' - activerecord (3.2.13) lib/active_record/connection_adapters/abstract/connection_pool.rb:479:in `call' - actionpack (3.2.13) lib/action_dispatch/middleware/callbacks.rb:28:in `block in call' - activesupport (3.2.13) lib/active_support/callbacks.rb:405:in `_run__1957069703945298240__call__3451355860951162812__callbacks' - activesupport (3.2.13) lib/active_support/callbacks.rb:405:in `__run_callback' - activesupport (3.2.13) lib/active_support/callbacks.rb:385:in `_run_call_callbacks' - activesupport (3.2.13) lib/active_support/callbacks.rb:81:in `run_callbacks' - actionpack (3.2.13) lib/action_dispatch/middleware/callbacks.rb:27:in `call' - actionpack (3.2.13) lib/action_dispatch/middleware/reloader.rb:65:in `call' - actionpack (3.2.13) lib/action_dispatch/middleware/remote_ip.rb:31:in `call' - actionpack (3.2.13) lib/action_dispatch/middleware/debug_exceptions.rb:16:in `call' - actionpack (3.2.13) lib/action_dispatch/middleware/show_exceptions.rb:56:in `call' - railties (3.2.13) lib/rails/rack/logger.rb:32:in `call_app' - railties (3.2.13) lib/rails/rack/logger.rb:16:in `block in call' - activesupport (3.2.13) lib/active_support/tagged_logging.rb:22:in `tagged' - railties (3.2.13) lib/rails/rack/logger.rb:16:in `call' - actionpack (3.2.13) lib/action_dispatch/middleware/request_id.rb:22:in `call' - rack (1.4.5) lib/rack/runtime.rb:17:in `call' - activesupport (3.2.13) lib/active_support/cache/strategy/local_cache.rb:72:in `call' - rack (1.4.5) lib/rack/lock.rb:15:in `call' - actionpack (3.2.13) lib/action_dispatch/middleware/static.rb:63:in `call' - railties (3.2.13) lib/rails/engine.rb:479:in `call' - railties (3.2.13) lib/rails/application.rb:223:in `call' - railties (3.2.13) lib/rails/railtie/configurable.rb:30:in `method_missing' - /Users/manuelevidaurrea/Library/Application Support/Pow/Versions/0.4.0/node_modules/nack/lib/nack/server.rb:147:in `handle' - /Users/manuelevidaurrea/Library/Application Support/Pow/Versions/0.4.0/node_modules/nack/lib/nack/server.rb:99:in `rescue in block (2 levels) in start' - /Users/manuelevidaurrea/Library/Application Support/Pow/Versions/0.4.0/node_modules/nack/lib/nack/server.rb:96:in `block (2 levels) in start' - /Users/manuelevidaurrea/Library/Application Support/Pow/Versions/0.4.0/node_modules/nack/lib/nack/server.rb:86:in `each' - /Users/manuelevidaurrea/Library/Application Support/Pow/Versions/0.4.0/node_modules/nack/lib/nack/server.rb:86:in `block in start' - /Users/manuelevidaurrea/Library/Application Support/Pow/Versions/0.4.0/node_modules/nack/lib/nack/server.rb:66:in `loop' - /Users/manuelevidaurrea/Library/Application Support/Pow/Versions/0.4.0/node_modules/nack/lib/nack/server.rb:66:in `start' - /Users/manuelevidaurrea/Library/Application Support/Pow/Versions/0.4.0/node_modules/nack/lib/nack/server.rb:13:in `run' - /Users/manuelevidaurrea/Library/Application Support/Pow/Versions/0.4.0/node_modules/nack/bin/nack_worker:4:in `<main>' +Started POST "/v1/accounts" for 127.0.0.1 at 2013-06-28 21:08:47 -0500 +Processing by Cadenero::V1::AccountsController#create as HTML + Parameters: {"account"=>{"name"=>"Testy", "subdomain"=>"test2", "owner_attributes"=>{"email"=>"testy2@example.com", "password"=>"[FILTERED]", "password_confirmation"=>"[FILTERED]"}}, "default"=>:json} +AccountsController params[:account]: {"name"=>"Testy", "subdomain"=>"test2", "owner_attributes"=>{"email"=>"testy2@example.com", "password"=>"changeme", "password_confirmation"=>"changeme"}} +  (0.2ms) BEGIN + Cadenero::V1::Account Exists (8.8ms) SELECT 1 AS one FROM "public"."cadenero_accounts" WHERE "public"."cadenero_accounts"."subdomain" = 'test2' LIMIT 1 + SQL (30.8ms) INSERT INTO "public"."cadenero_users" ("created_at", "email", "password_digest", "updated_at") VALUES ($1, $2, $3, $4) RETURNING "id" [["created_at", Sat, 29 Jun 2013 02:08:48 UTC +00:00], ["email", "testy2@example.com"], ["password_digest", "$2a$10$wgSMh7Xkg5G/Gu4dCFEhz.JpCjRTfmtZTDiOle.UEVZQojQQBMOpy"], ["updated_at", Sat, 29 Jun 2013 02:08:48 UTC +00:00]] + SQL (17.7ms) INSERT INTO "public"."cadenero_accounts" ("authentication_token", "created_at", "name", "owner_id", "subdomain", "updated_at") VALUES ($1, $2, $3, $4, $5, $6) RETURNING "id" [["authentication_token", nil], ["created_at", Sat, 29 Jun 2013 02:08:48 UTC +00:00], ["name", "Testy"], ["owner_id", 4], ["subdomain", "test2"], ["updated_at", Sat, 29 Jun 2013 02:08:48 UTC +00:00]] + Cadenero::V1::Account Load (0.5ms) SELECT "public"."cadenero_accounts".* FROM "public"."cadenero_accounts" WHERE "public"."cadenero_accounts"."authentication_token" = 'dggwaxfQZ2QupEyd2qcs' LIMIT 1 +  (0.5ms) UPDATE "public"."cadenero_accounts" SET "name" = 'Testy', "subdomain" = 'test2', "owner_id" = 4, "created_at" = '2013-06-29 02:08:48.424365', "updated_at" = '2013-06-29 02:08:48.424365' WHERE "public"."cadenero_accounts"."id" = 4 +  (14.2ms) COMMIT +  (1.5ms) BEGIN + SQL (3.6ms) INSERT INTO "public"."cadenero_members" ("account_id", "created_at", "updated_at", "user_id") VALUES ($1, $2, $3, $4) RETURNING "id" [["account_id", 4], ["created_at", Sat, 29 Jun 2013 02:08:48 UTC +00:00], ["updated_at", Sat, 29 Jun 2013 02:08:48 UTC +00:00], ["user_id", 4]] +  (21.9ms) COMMIT + Cadenero::V1::Account Exists (0.5ms) SELECT 1 AS one FROM "public"."cadenero_accounts" WHERE ("public"."cadenero_accounts"."subdomain" = 'test2' AND "public"."cadenero_accounts"."id" != 4) LIMIT 1 +  (22.3ms) CREATE SCHEMA "test2" +  (75.3ms) CREATE TABLE "cadenero_accounts" ("id" serial primary key, "name" character varying(255), "subdomain" character varying(255), "authentication_token" character varying(255), "owner_id" integer, "created_at" timestamp NOT NULL, "updated_at" timestamp NOT NULL)  +  (16.7ms) CREATE INDEX "index_cadenero_accounts_on_authentication_token" ON "cadenero_accounts" ("authentication_token") +  (41.3ms) CREATE INDEX "index_cadenero_accounts_on_owner_id" ON "cadenero_accounts" ("owner_id") +  (4.8ms) CREATE TABLE "cadenero_members" ("id" serial primary key, "account_id" integer, "user_id" integer, "created_at" timestamp NOT NULL, "updated_at" timestamp NOT NULL) +  (7.8ms) CREATE INDEX "index_cadenero_members_on_account_id" ON "cadenero_members" ("account_id") +  (24.8ms) CREATE INDEX "index_cadenero_members_on_user_id" ON "cadenero_members" ("user_id") +  (7.4ms) CREATE TABLE "cadenero_users" ("id" serial primary key, "email" character varying(255), "password_digest" character varying(255), "created_at" timestamp NOT NULL, "updated_at" timestamp NOT NULL)  +  (5.6ms) CREATE TABLE "schema_migrations" ("version" character varying(255) NOT NULL) +  (3.0ms) CREATE UNIQUE INDEX "unique_schema_migrations" ON "schema_migrations" ("version") +  (0.4ms) SELECT version FROM "schema_migrations" +  (10.8ms) INSERT INTO "schema_migrations" (version) VALUES ('20130612073709') + Cadenero::V1::Account Load (0.5ms) SELECT "public"."cadenero_accounts".* FROM "public"."cadenero_accounts" WHERE "public"."cadenero_accounts"."authentication_token" = 'yhJzssan6ExxfuGDPeuq' LIMIT 1 +  (0.1ms) BEGIN +  (0.1ms) COMMIT +  (0.1ms) BEGIN + SQL (1.1ms) INSERT INTO "public"."cadenero_members" ("account_id", "created_at", "updated_at", "user_id") VALUES ($1, $2, $3, $4) RETURNING "id" [["account_id", 4], ["created_at", Sat, 29 Jun 2013 02:08:49 UTC +00:00], ["updated_at", Sat, 29 Jun 2013 02:08:49 UTC +00:00], ["user_id", 4]] +  (0.5ms) COMMIT +Completed 201 Created in 1127ms (Views: 0.4ms | ActiveRecord: 413.2ms) - Rendered /Users/manuelevidaurrea/Documents/work/agiltec/workspace/ruby/rails/cadenero/vendor/bundle/gems/actionpack-3.2.13/lib/action_dispatch/middleware/templates/rescues/_trace.erb (2.3ms) - Rendered /Users/manuelevidaurrea/Documents/work/agiltec/workspace/ruby/rails/cadenero/vendor/bundle/gems/actionpack-3.2.13/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (1.7ms) - Rendered /Users/manuelevidaurrea/Documents/work/agiltec/workspace/ruby/rails/cadenero/vendor/bundle/gems/actionpack-3.2.13/lib/action_dispatch/middleware/templates/rescues/diagnostics.erb within rescues/layout (117.3ms) -Connecting to database specified by database.yml +Started POST "/v1/accounts" for 127.0.0.1 at 2013-06-28 21:10:32 -0500 +Error occurred while parsing request parameters. +Contents: -Started GET "/" for 127.0.0.1 at 2013-06-27 22:30:27 -0500 -Processing by Cadenero::V1::Account::DashboardController#index as HTML - Parameters: {"default"=>:json} -env['warden'].authenticated?(:user): false -Filter chain halted as :authenticate_user! rendered or redirected -Completed 422 Unprocessable Entity in 6ms (Views: 0.3ms | ActiveRecord: 0.0ms) -Started POST "/v1/sessions" for 127.0.0.1 at 2013-06-27 22:30:33 -0500 -Processing by Cadenero::V1::Account::SessionsController#create as HTML - Parameters: {"user"=>{"email"=>"testy3@example.com", "password"=>"[FILTERED]"}, "default"=>:json} -params: {"user"=>{"email"=>"testy3@example.com", "password"=>"changeme"}, "default"=>:json, "controller"=>"cadenero/v1/account/sessions", "action"=>"create"} -valid? subdomain: ["test3"] -json_params: {} -params.empty?: true -env['rack.input'].gets: {"user": {"email": "testy3@example.com", "password": "changeme"}} -Completed 500 Internal Server Error in 1ms - -TypeError (can't convert nil into String): - /Users/manuelevidaurrea/.rbenv/versions/1.9.3-p429/lib/ruby/1.9.1/json/common.rb:148:in `initialize' - /Users/manuelevidaurrea/.rbenv/versions/1.9.3-p429/lib/ruby/1.9.1/json/common.rb:148:in `new' +MultiJson::LoadError (784: unexpected token at '{account: { name: "Testy", subdomain: "tested1", owner_attributes: {email: "testy2@example.com", password: "changeme", password_confirmation: "changeme"}}}'): /Users/manuelevidaurrea/.rbenv/versions/1.9.3-p429/lib/ruby/1.9.1/json/common.rb:148:in `parse' - /Users/manuelevidaurrea/Documents/work/agiltec/workspace/ruby/rails/cadenero/config/initializers/warden/strategies/password.rb:13:in `json_params' - /Users/manuelevidaurrea/Documents/work/agiltec/workspace/ruby/rails/cadenero/config/initializers/warden/strategies/password.rb:19:in `valid?' - warden (1.2.1) lib/warden/proxy.rb:351:in `block in _run_strategies_for' - warden (1.2.1) lib/warden/proxy.rb:349:in `each' - warden (1.2.1) lib/warden/proxy.rb:349:in `_run_strategies_for' - warden (1.2.1) lib/warden/proxy.rb:319:in `_perform_authentication' - warden (1.2.1) lib/warden/proxy.rb:104:in `authenticate' - /Users/manuelevidaurrea/Documents/work/agiltec/workspace/ruby/rails/cadenero/app/controllers/cadenero/v1/account/sessions_controller.rb:7:in `create' - actionpack (3.2.13) lib/abstract_controller/base.rb:167:in `process_action' - actionpack (3.2.13) lib/action_controller/metal/rendering.rb:10:in `process_action' - actionpack (3.2.13) lib/abstract_controller/callbacks.rb:18:in `block in process_action' - activesupport (3.2.13) lib/active_support/callbacks.rb:403:in `_run__718181710820714038__process_action__4579058258704994523__callbacks' - activesupport (3.2.13) lib/active_support/callbacks.rb:405:in `__run_callback' - activesupport (3.2.13) lib/active_support/callbacks.rb:385:in `_run_process_action_callbacks' - activesupport (3.2.13) lib/active_support/callbacks.rb:81:in `run_callbacks' - actionpack (3.2.13) lib/abstract_controller/callbacks.rb:17:in `process_action' - actionpack (3.2.13) lib/action_controller/metal/rescue.rb:29:in `process_action' - actionpack (3.2.13) lib/action_controller/metal/instrumentation.rb:30:in `block in process_action' - activesupport (3.2.13) lib/active_support/notifications.rb:123:in `block in instrument' - activesupport (3.2.13) lib/active_support/notifications/instrumenter.rb:20:in `instrument' - activesupport (3.2.13) lib/active_support/notifications.rb:123:in `instrument' - actionpack (3.2.13) lib/action_controller/metal/instrumentation.rb:29:in `process_action' - activerecord (3.2.13) lib/active_record/railties/controller_runtime.rb:18:in `process_action' - actionpack (3.2.13) lib/abstract_controller/base.rb:121:in `process' - actionpack (3.2.13) lib/abstract_controller/rendering.rb:45:in `process' - actionpack (3.2.13) lib/action_controller/metal.rb:203:in `dispatch' - actionpack (3.2.13) lib/action_controller/metal/rack_delegation.rb:14:in `dispatch' - actionpack (3.2.13) lib/action_controller/metal.rb:246:in `block in action' - actionpack (3.2.13) lib/action_dispatch/routing/route_set.rb:73:in `call' - actionpack (3.2.13) lib/action_dispatch/routing/route_set.rb:73:in `dispatch' - actionpack (3.2.13) lib/action_dispatch/routing/route_set.rb:36:in `call' - actionpack (3.2.13) lib/action_dispatch/routing/mapper.rb:42:in `call' - journey (1.0.4) lib/journey/router.rb:68:in `block in call' - journey (1.0.4) lib/journey/router.rb:56:in `each' - journey (1.0.4) lib/journey/router.rb:56:in `call' - actionpack (3.2.13) lib/action_dispatch/routing/route_set.rb:612:in `call' - rack (1.4.5) lib/rack/session/abstract/id.rb:210:in `context' - rack (1.4.5) lib/rack/session/abstract/id.rb:205:in `call' - actionpack (3.2.13) lib/action_dispatch/middleware/cookies.rb:341:in `call' - warden (1.2.1) lib/warden/manager.rb:31:in `call' - railties (3.2.13) lib/rails/engine.rb:479:in `call' - railties (3.2.13) lib/rails/railtie/configurable.rb:30:in `method_missing' - journey (1.0.4) lib/journey/router.rb:68:in `block in call' - journey (1.0.4) lib/journey/router.rb:56:in `each' - journey (1.0.4) lib/journey/router.rb:56:in `call' - actionpack (3.2.13) lib/action_dispatch/routing/route_set.rb:612:in `call' - warden (1.2.1) lib/warden/manager.rb:35:in `block in call' - warden (1.2.1) lib/warden/manager.rb:34:in `catch' - warden (1.2.1) lib/warden/manager.rb:34:in `call' - apartment (0.21.1) lib/apartment/elevators/generic.rb:19:in `call' - apartment (0.21.1) lib/apartment/reloader.rb:19:in `call' - rack (1.4.5) lib/rack/etag.rb:23:in `call' - rack (1.4.5) lib/rack/conditionalget.rb:35:in `call' - actionpack (3.2.13) lib/action_dispatch/middleware/head.rb:14:in `call' - actionpack (3.2.13) lib/action_dispatch/middleware/params_parser.rb:21:in `call' - activerecord (3.2.13) lib/active_record/query_cache.rb:64:in `call' - activerecord (3.2.13) lib/active_record/connection_adapters/abstract/connection_pool.rb:479:in `call' - actionpack (3.2.13) lib/action_dispatch/middleware/callbacks.rb:28:in `block in call' - activesupport (3.2.13) lib/active_support/callbacks.rb:405:in `_run__2774346958201521148__call__1414120328066642717__callbacks' - activesupport (3.2.13) lib/active_support/callbacks.rb:405:in `__run_callback' - activesupport (3.2.13) lib/active_support/callbacks.rb:385:in `_run_call_callbacks' - activesupport (3.2.13) lib/active_support/callbacks.rb:81:in `run_callbacks' - actionpack (3.2.13) lib/action_dispatch/middleware/callbacks.rb:27:in `call' - actionpack (3.2.13) lib/action_dispatch/middleware/reloader.rb:65:in `call' - actionpack (3.2.13) lib/action_dispatch/middleware/remote_ip.rb:31:in `call' - actionpack (3.2.13) lib/action_dispatch/middleware/debug_exceptions.rb:16:in `call' - actionpack (3.2.13) lib/action_dispatch/middleware/show_exceptions.rb:56:in `call' - railties (3.2.13) lib/rails/rack/logger.rb:32:in `call_app' - railties (3.2.13) lib/rails/rack/logger.rb:16:in `block in call' - activesupport (3.2.13) lib/active_support/tagged_logging.rb:22:in `tagged' - railties (3.2.13) lib/rails/rack/logger.rb:16:in `call' - actionpack (3.2.13) lib/action_dispatch/middleware/request_id.rb:22:in `call' - rack (1.4.5) lib/rack/runtime.rb:17:in `call' - activesupport (3.2.13) lib/active_support/cache/strategy/local_cache.rb:72:in `call' - rack (1.4.5) lib/rack/lock.rb:15:in `call' - actionpack (3.2.13) lib/action_dispatch/middleware/static.rb:63:in `call' - railties (3.2.13) lib/rails/engine.rb:479:in `call' - railties (3.2.13) lib/rails/application.rb:223:in `call' - railties (3.2.13) lib/rails/railtie/configurable.rb:30:in `method_missing' - /Users/manuelevidaurrea/Library/Application Support/Pow/Versions/0.4.0/node_modules/nack/lib/nack/server.rb:147:in `handle' - /Users/manuelevidaurrea/Library/Application Support/Pow/Versions/0.4.0/node_modules/nack/lib/nack/server.rb:99:in `rescue in block (2 levels) in start' - /Users/manuelevidaurrea/Library/Application Support/Pow/Versions/0.4.0/node_modules/nack/lib/nack/server.rb:96:in `block (2 levels) in start' - /Users/manuelevidaurrea/Library/Application Support/Pow/Versions/0.4.0/node_modules/nack/lib/nack/server.rb:86:in `each' - /Users/manuelevidaurrea/Library/Application Support/Pow/Versions/0.4.0/node_modules/nack/lib/nack/server.rb:86:in `block in start' - /Users/manuelevidaurrea/Library/Application Support/Pow/Versions/0.4.0/node_modules/nack/lib/nack/server.rb:66:in `loop' - /Users/manuelevidaurrea/Library/Application Support/Pow/Versions/0.4.0/node_modules/nack/lib/nack/server.rb:66:in `start' - /Users/manuelevidaurrea/Library/Application Support/Pow/Versions/0.4.0/node_modules/nack/lib/nack/server.rb:13:in `run' - /Users/manuelevidaurrea/Library/Application Support/Pow/Versions/0.4.0/node_modules/nack/bin/nack_worker:4:in `<main>' - - - Rendered /Users/manuelevidaurrea/Documents/work/agiltec/workspace/ruby/rails/cadenero/vendor/bundle/gems/actionpack-3.2.13/lib/action_dispatch/middleware/templates/rescues/_trace.erb (1.9ms) - Rendered /Users/manuelevidaurrea/Documents/work/agiltec/workspace/ruby/rails/cadenero/vendor/bundle/gems/actionpack-3.2.13/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (1.5ms) - Rendered /Users/manuelevidaurrea/Documents/work/agiltec/workspace/ruby/rails/cadenero/vendor/bundle/gems/actionpack-3.2.13/lib/action_dispatch/middleware/templates/rescues/diagnostics.erb within rescues/layout (160.4ms) -Connecting to database specified by database.yml - - -Started GET "/" for 127.0.0.1 at 2013-06-27 22:32:51 -0500 -Processing by Cadenero::V1::Account::DashboardController#index as HTML - Parameters: {"default"=>:json} -env['warden'].authenticated?(:user): false -Filter chain halted as :authenticate_user! rendered or redirected -Completed 422 Unprocessable Entity in 5ms (Views: 0.3ms | ActiveRecord: 0.0ms) - - -Started POST "/v1/sessions" for 127.0.0.1 at 2013-06-27 22:33:38 -0500 -Processing by Cadenero::V1::Account::SessionsController#create as HTML - Parameters: {"user"=>{"email"=>"testy3@example.com", "password"=>"[FILTERED]"}, "default"=>:json} -params: {"user"=>{"email"=>"testy3@example.com", "password"=>"changeme"}, "default"=>:json, "controller"=>"cadenero/v1/account/sessions", "action"=>"create"} -valid? subdomain: ["test3"] -json_params: {} -params.empty?: true -env['rack.input'].gets: {"user": {"email": "testy3@example.com", "password": "changeme"}} -Completed 500 Internal Server Error in 1ms - -TypeError (can't convert nil into String): - /Users/manuelevidaurrea/.rbenv/versions/1.9.3-p429/lib/ruby/1.9.1/json/common.rb:148:in `initialize' - /Users/manuelevidaurrea/.rbenv/versions/1.9.3-p429/lib/ruby/1.9.1/json/common.rb:148:in `new' /Users/manuelevidaurrea/.rbenv/versions/1.9.3-p429/lib/ruby/1.9.1/json/common.rb:148:in `parse' - /Users/manuelevidaurrea/Documents/work/agiltec/workspace/ruby/rails/cadenero/config/initializers/warden/strategies/password.rb:13:in `json_params' - /Users/manuelevidaurrea/Documents/work/agiltec/workspace/ruby/rails/cadenero/config/initializers/warden/strategies/password.rb:19:in `valid?' - warden (1.2.1) lib/warden/proxy.rb:351:in `block in _run_strategies_for' - warden (1.2.1) lib/warden/proxy.rb:349:in `each' - warden (1.2.1) lib/warden/proxy.rb:349:in `_run_strategies_for' - warden (1.2.1) lib/warden/proxy.rb:319:in `_perform_authentication' - warden (1.2.1) lib/warden/proxy.rb:104:in `authenticate' - /Users/manuelevidaurrea/Documents/work/agiltec/workspace/ruby/rails/cadenero/app/controllers/cadenero/v1/account/sessions_controller.rb:7:in `create' - actionpack (3.2.13) lib/abstract_controller/base.rb:167:in `process_action' - actionpack (3.2.13) lib/action_controller/metal/rendering.rb:10:in `process_action' - actionpack (3.2.13) lib/abstract_controller/callbacks.rb:18:in `block in process_action' - activesupport (3.2.13) lib/active_support/callbacks.rb:403:in `_run__1518042003092558342__process_action__1356531673523270988__callbacks' - activesupport (3.2.13) lib/active_support/callbacks.rb:405:in `__run_callback' - activesupport (3.2.13) lib/active_support/callbacks.rb:385:in `_run_process_action_callbacks' - activesupport (3.2.13) lib/active_support/callbacks.rb:81:in `run_callbacks' - actionpack (3.2.13) lib/abstract_controller/callbacks.rb:17:in `process_action' - actionpack (3.2.13) lib/action_controller/metal/rescue.rb:29:in `process_action' - actionpack (3.2.13) lib/action_controller/metal/instrumentation.rb:30:in `block in process_action' - activesupport (3.2.13) lib/active_support/notifications.rb:123:in `block in instrument' - activesupport (3.2.13) lib/active_support/notifications/instrumenter.rb:20:in `instrument' - activesupport (3.2.13) lib/active_support/notifications.rb:123:in `instrument' - actionpack (3.2.13) lib/action_controller/metal/instrumentation.rb:29:in `process_action' - activerecord (3.2.13) lib/active_record/railties/controller_runtime.rb:18:in `process_action' - actionpack (3.2.13) lib/abstract_controller/base.rb:121:in `process' - actionpack (3.2.13) lib/abstract_controller/rendering.rb:45:in `process' - actionpack (3.2.13) lib/action_controller/metal.rb:203:in `dispatch' - actionpack (3.2.13) lib/action_controller/metal/rack_delegation.rb:14:in `dispatch' - actionpack (3.2.13) lib/action_controller/metal.rb:246:in `block in action' - actionpack (3.2.13) lib/action_dispatch/routing/route_set.rb:73:in `call' - actionpack (3.2.13) lib/action_dispatch/routing/route_set.rb:73:in `dispatch' - actionpack (3.2.13) lib/action_dispatch/routing/route_set.rb:36:in `call' - actionpack (3.2.13) lib/action_dispatch/routing/mapper.rb:42:in `call' - journey (1.0.4) lib/journey/router.rb:68:in `block in call' - journey (1.0.4) lib/journey/router.rb:56:in `each' - journey (1.0.4) lib/journey/router.rb:56:in `call' - actionpack (3.2.13) lib/action_dispatch/routing/route_set.rb:612:in `call' - rack (1.4.5) lib/rack/session/abstract/id.rb:210:in `context' - rack (1.4.5) lib/rack/session/abstract/id.rb:205:in `call' - actionpack (3.2.13) lib/action_dispatch/middleware/cookies.rb:341:in `call' - warden (1.2.1) lib/warden/manager.rb:31:in `call' - railties (3.2.13) lib/rails/engine.rb:479:in `call' - railties (3.2.13) lib/rails/railtie/configurable.rb:30:in `method_missing' - journey (1.0.4) lib/journey/router.rb:68:in `block in call' - journey (1.0.4) lib/journey/router.rb:56:in `each' - journey (1.0.4) lib/journey/router.rb:56:in `call' - actionpack (3.2.13) lib/action_dispatch/routing/route_set.rb:612:in `call' - warden (1.2.1) lib/warden/manager.rb:35:in `block in call' - warden (1.2.1) lib/warden/manager.rb:34:in `catch' - warden (1.2.1) lib/warden/manager.rb:34:in `call' - apartment (0.21.1) lib/apartment/elevators/generic.rb:19:in `call' - apartment (0.21.1) lib/apartment/reloader.rb:19:in `call' - rack (1.4.5) lib/rack/etag.rb:23:in `call' - rack (1.4.5) lib/rack/conditionalget.rb:35:in `call' - actionpack (3.2.13) lib/action_dispatch/middleware/head.rb:14:in `call' - actionpack (3.2.13) lib/action_dispatch/middleware/params_parser.rb:21:in `call' + multi_json (1.7.7) lib/multi_json/adapters/json_common.rb:16:in `load' + multi_json (1.7.7) lib/multi_json/adapter.rb:19:in `load' + multi_json (1.7.7) lib/multi_json.rb:130:in `load' + activesupport (3.2.13) lib/active_support/json/decoding.rb:15:in `decode' + actionpack (3.2.13) lib/action_dispatch/middleware/params_parser.rb:47:in `parse_formatted_parameters' + actionpack (3.2.13) lib/action_dispatch/middleware/params_parser.rb:17:in `call' activerecord (3.2.13) lib/active_record/query_cache.rb:64:in `call' activerecord (3.2.13) lib/active_record/connection_adapters/abstract/connection_pool.rb:479:in `call' actionpack (3.2.13) lib/action_dispatch/middleware/callbacks.rb:28:in `block in call' - activesupport (3.2.13) lib/active_support/callbacks.rb:405:in `_run__3083495747163351369__call__2690404325020222033__callbacks' + activesupport (3.2.13) lib/active_support/callbacks.rb:405:in `_run__1796019582061484670__call__3517173794547040874__callbacks' activesupport (3.2.13) lib/active_support/callbacks.rb:405:in `__run_callback' activesupport (3.2.13) lib/active_support/callbacks.rb:385:in `_run_call_callbacks' activesupport (3.2.13) lib/active_support/callbacks.rb:81:in `run_callbacks' actionpack (3.2.13) lib/action_dispatch/middleware/callbacks.rb:27:in `call' actionpack (3.2.13) lib/action_dispatch/middleware/reloader.rb:65:in `call' @@ -347,269 +107,44 @@ /Users/manuelevidaurrea/Library/Application Support/Pow/Versions/0.4.0/node_modules/nack/lib/nack/server.rb:66:in `start' /Users/manuelevidaurrea/Library/Application Support/Pow/Versions/0.4.0/node_modules/nack/lib/nack/server.rb:13:in `run' /Users/manuelevidaurrea/Library/Application Support/Pow/Versions/0.4.0/node_modules/nack/bin/nack_worker:4:in `<main>' - Rendered /Users/manuelevidaurrea/Documents/work/agiltec/workspace/ruby/rails/cadenero/vendor/bundle/gems/actionpack-3.2.13/lib/action_dispatch/middleware/templates/rescues/_trace.erb (6.0ms) - Rendered /Users/manuelevidaurrea/Documents/work/agiltec/workspace/ruby/rails/cadenero/vendor/bundle/gems/actionpack-3.2.13/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (5.7ms) - Rendered /Users/manuelevidaurrea/Documents/work/agiltec/workspace/ruby/rails/cadenero/vendor/bundle/gems/actionpack-3.2.13/lib/action_dispatch/middleware/templates/rescues/diagnostics.erb within rescues/layout (67.3ms) -Connecting to database specified by database.yml -Connecting to database specified by database.yml - - -Started GET "/" for 127.0.0.1 at 2013-06-27 22:36:21 -0500 -Processing by Cadenero::V1::Account::DashboardController#index as HTML - Parameters: {"default"=>:json} -env['warden'].authenticated?(:user): false -Filter chain halted as :authenticate_user! rendered or redirected -Completed 422 Unprocessable Entity in 6ms (Views: 0.3ms | ActiveRecord: 0.0ms) - - -Started POST "/v1/sessions" for 127.0.0.1 at 2013-06-27 22:37:19 -0500 -Processing by Cadenero::V1::Account::SessionsController#create as HTML - Parameters: {"user"=>{"email"=>"testy3@example.com", "password"=>"[FILTERED]"}, "default"=>:json} -params: {"user"=>{"email"=>"testy3@example.com", "password"=>"changeme"}, "default"=>:json, "controller"=>"cadenero/v1/account/sessions", "action"=>"create"} -valid? subdomain: ["test3"] -json_params: {} -params.empty?: true -env['rack.input'].gets: {"user": {"email": "testy3@example.com", "password": "changeme"}} -valid? json_params: {"user"=>{"email"=>"testy3@example.com", "password"=>"changeme"}} -json_params: {} -params.empty?: true -env['rack.input'].gets: -Completed 500 Internal Server Error in 1ms - -TypeError (can't convert nil into String): - /Users/manuelevidaurrea/.rbenv/versions/1.9.3-p429/lib/ruby/1.9.1/json/common.rb:148:in `initialize' - /Users/manuelevidaurrea/.rbenv/versions/1.9.3-p429/lib/ruby/1.9.1/json/common.rb:148:in `new' - /Users/manuelevidaurrea/.rbenv/versions/1.9.3-p429/lib/ruby/1.9.1/json/common.rb:148:in `parse' - /Users/manuelevidaurrea/Documents/work/agiltec/workspace/ruby/rails/cadenero/config/initializers/warden/strategies/password.rb:14:in `json_params' - /Users/manuelevidaurrea/Documents/work/agiltec/workspace/ruby/rails/cadenero/config/initializers/warden/strategies/password.rb:21:in `valid?' - warden (1.2.1) lib/warden/proxy.rb:351:in `block in _run_strategies_for' - warden (1.2.1) lib/warden/proxy.rb:349:in `each' - warden (1.2.1) lib/warden/proxy.rb:349:in `_run_strategies_for' - warden (1.2.1) lib/warden/proxy.rb:319:in `_perform_authentication' - warden (1.2.1) lib/warden/proxy.rb:104:in `authenticate' - /Users/manuelevidaurrea/Documents/work/agiltec/workspace/ruby/rails/cadenero/app/controllers/cadenero/v1/account/sessions_controller.rb:7:in `create' - actionpack (3.2.13) lib/abstract_controller/base.rb:167:in `process_action' - actionpack (3.2.13) lib/action_controller/metal/rendering.rb:10:in `process_action' - actionpack (3.2.13) lib/abstract_controller/callbacks.rb:18:in `block in process_action' - activesupport (3.2.13) lib/active_support/callbacks.rb:403:in `_run__1143065384374630641__process_action__4077513184528746036__callbacks' - activesupport (3.2.13) lib/active_support/callbacks.rb:405:in `__run_callback' - activesupport (3.2.13) lib/active_support/callbacks.rb:385:in `_run_process_action_callbacks' - activesupport (3.2.13) lib/active_support/callbacks.rb:81:in `run_callbacks' - actionpack (3.2.13) lib/abstract_controller/callbacks.rb:17:in `process_action' - actionpack (3.2.13) lib/action_controller/metal/rescue.rb:29:in `process_action' - actionpack (3.2.13) lib/action_controller/metal/instrumentation.rb:30:in `block in process_action' - activesupport (3.2.13) lib/active_support/notifications.rb:123:in `block in instrument' - activesupport (3.2.13) lib/active_support/notifications/instrumenter.rb:20:in `instrument' - activesupport (3.2.13) lib/active_support/notifications.rb:123:in `instrument' - actionpack (3.2.13) lib/action_controller/metal/instrumentation.rb:29:in `process_action' - activerecord (3.2.13) lib/active_record/railties/controller_runtime.rb:18:in `process_action' - actionpack (3.2.13) lib/abstract_controller/base.rb:121:in `process' - actionpack (3.2.13) lib/abstract_controller/rendering.rb:45:in `process' - actionpack (3.2.13) lib/action_controller/metal.rb:203:in `dispatch' - actionpack (3.2.13) lib/action_controller/metal/rack_delegation.rb:14:in `dispatch' - actionpack (3.2.13) lib/action_controller/metal.rb:246:in `block in action' - actionpack (3.2.13) lib/action_dispatch/routing/route_set.rb:73:in `call' - actionpack (3.2.13) lib/action_dispatch/routing/route_set.rb:73:in `dispatch' - actionpack (3.2.13) lib/action_dispatch/routing/route_set.rb:36:in `call' - actionpack (3.2.13) lib/action_dispatch/routing/mapper.rb:42:in `call' - journey (1.0.4) lib/journey/router.rb:68:in `block in call' - journey (1.0.4) lib/journey/router.rb:56:in `each' - journey (1.0.4) lib/journey/router.rb:56:in `call' - actionpack (3.2.13) lib/action_dispatch/routing/route_set.rb:612:in `call' - rack (1.4.5) lib/rack/session/abstract/id.rb:210:in `context' - rack (1.4.5) lib/rack/session/abstract/id.rb:205:in `call' - actionpack (3.2.13) lib/action_dispatch/middleware/cookies.rb:341:in `call' - warden (1.2.1) lib/warden/manager.rb:31:in `call' - railties (3.2.13) lib/rails/engine.rb:479:in `call' - railties (3.2.13) lib/rails/railtie/configurable.rb:30:in `method_missing' - journey (1.0.4) lib/journey/router.rb:68:in `block in call' - journey (1.0.4) lib/journey/router.rb:56:in `each' - journey (1.0.4) lib/journey/router.rb:56:in `call' - actionpack (3.2.13) lib/action_dispatch/routing/route_set.rb:612:in `call' - warden (1.2.1) lib/warden/manager.rb:35:in `block in call' - warden (1.2.1) lib/warden/manager.rb:34:in `catch' - warden (1.2.1) lib/warden/manager.rb:34:in `call' - apartment (0.21.1) lib/apartment/elevators/generic.rb:19:in `call' - apartment (0.21.1) lib/apartment/reloader.rb:19:in `call' - rack (1.4.5) lib/rack/etag.rb:23:in `call' - rack (1.4.5) lib/rack/conditionalget.rb:35:in `call' - actionpack (3.2.13) lib/action_dispatch/middleware/head.rb:14:in `call' - actionpack (3.2.13) lib/action_dispatch/middleware/params_parser.rb:21:in `call' - activerecord (3.2.13) lib/active_record/query_cache.rb:64:in `call' - activerecord (3.2.13) lib/active_record/connection_adapters/abstract/connection_pool.rb:479:in `call' - actionpack (3.2.13) lib/action_dispatch/middleware/callbacks.rb:28:in `block in call' - activesupport (3.2.13) lib/active_support/callbacks.rb:405:in `_run__971631749194060911__call__215474630939641209__callbacks' - activesupport (3.2.13) lib/active_support/callbacks.rb:405:in `__run_callback' - activesupport (3.2.13) lib/active_support/callbacks.rb:385:in `_run_call_callbacks' - activesupport (3.2.13) lib/active_support/callbacks.rb:81:in `run_callbacks' - actionpack (3.2.13) lib/action_dispatch/middleware/callbacks.rb:27:in `call' - actionpack (3.2.13) lib/action_dispatch/middleware/reloader.rb:65:in `call' - actionpack (3.2.13) lib/action_dispatch/middleware/remote_ip.rb:31:in `call' - actionpack (3.2.13) lib/action_dispatch/middleware/debug_exceptions.rb:16:in `call' - actionpack (3.2.13) lib/action_dispatch/middleware/show_exceptions.rb:56:in `call' - railties (3.2.13) lib/rails/rack/logger.rb:32:in `call_app' - railties (3.2.13) lib/rails/rack/logger.rb:16:in `block in call' - activesupport (3.2.13) lib/active_support/tagged_logging.rb:22:in `tagged' - railties (3.2.13) lib/rails/rack/logger.rb:16:in `call' - actionpack (3.2.13) lib/action_dispatch/middleware/request_id.rb:22:in `call' - rack (1.4.5) lib/rack/runtime.rb:17:in `call' - activesupport (3.2.13) lib/active_support/cache/strategy/local_cache.rb:72:in `call' - rack (1.4.5) lib/rack/lock.rb:15:in `call' - actionpack (3.2.13) lib/action_dispatch/middleware/static.rb:63:in `call' - railties (3.2.13) lib/rails/engine.rb:479:in `call' - railties (3.2.13) lib/rails/application.rb:223:in `call' - railties (3.2.13) lib/rails/railtie/configurable.rb:30:in `method_missing' - /Users/manuelevidaurrea/Library/Application Support/Pow/Versions/0.4.0/node_modules/nack/lib/nack/server.rb:147:in `handle' - /Users/manuelevidaurrea/Library/Application Support/Pow/Versions/0.4.0/node_modules/nack/lib/nack/server.rb:99:in `rescue in block (2 levels) in start' - /Users/manuelevidaurrea/Library/Application Support/Pow/Versions/0.4.0/node_modules/nack/lib/nack/server.rb:96:in `block (2 levels) in start' - /Users/manuelevidaurrea/Library/Application Support/Pow/Versions/0.4.0/node_modules/nack/lib/nack/server.rb:86:in `each' - /Users/manuelevidaurrea/Library/Application Support/Pow/Versions/0.4.0/node_modules/nack/lib/nack/server.rb:86:in `block in start' - /Users/manuelevidaurrea/Library/Application Support/Pow/Versions/0.4.0/node_modules/nack/lib/nack/server.rb:66:in `loop' - /Users/manuelevidaurrea/Library/Application Support/Pow/Versions/0.4.0/node_modules/nack/lib/nack/server.rb:66:in `start' - /Users/manuelevidaurrea/Library/Application Support/Pow/Versions/0.4.0/node_modules/nack/lib/nack/server.rb:13:in `run' - /Users/manuelevidaurrea/Library/Application Support/Pow/Versions/0.4.0/node_modules/nack/bin/nack_worker:4:in `<main>' - - - Rendered /Users/manuelevidaurrea/Documents/work/agiltec/workspace/ruby/rails/cadenero/vendor/bundle/gems/actionpack-3.2.13/lib/action_dispatch/middleware/templates/rescues/_trace.erb (1.8ms) + Rendered /Users/manuelevidaurrea/Documents/work/agiltec/workspace/ruby/rails/cadenero/vendor/bundle/gems/actionpack-3.2.13/lib/action_dispatch/middleware/templates/rescues/_trace.erb (1.7ms) Rendered /Users/manuelevidaurrea/Documents/work/agiltec/workspace/ruby/rails/cadenero/vendor/bundle/gems/actionpack-3.2.13/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (1.5ms) - Rendered /Users/manuelevidaurrea/Documents/work/agiltec/workspace/ruby/rails/cadenero/vendor/bundle/gems/actionpack-3.2.13/lib/action_dispatch/middleware/templates/rescues/diagnostics.erb within rescues/layout (97.3ms) -Connecting to database specified by database.yml + Rendered /Users/manuelevidaurrea/Documents/work/agiltec/workspace/ruby/rails/cadenero/vendor/bundle/gems/actionpack-3.2.13/lib/action_dispatch/middleware/templates/rescues/diagnostics.erb within rescues/layout (23.7ms) -Started GET "/" for 127.0.0.1 at 2013-06-27 22:38:31 -0500 -Processing by Cadenero::V1::Account::DashboardController#index as HTML - Parameters: {"default"=>:json} -env['warden'].authenticated?(:user): false -Filter chain halted as :authenticate_user! rendered or redirected -Completed 422 Unprocessable Entity in 5ms (Views: 0.3ms | ActiveRecord: 0.0ms) - - -Started POST "/v1/sessions" for 127.0.0.1 at 2013-06-27 22:38:37 -0500 -Processing by Cadenero::V1::Account::SessionsController#create as HTML - Parameters: {"user"=>{"email"=>"testy3@example.com", "password"=>"[FILTERED]"}, "default"=>:json} -params: {"user"=>{"email"=>"testy3@example.com", "password"=>"changeme"}, "default"=>:json, "controller"=>"cadenero/v1/account/sessions", "action"=>"create"} -valid? subdomain: ["test3"] -json_params: {} -params.empty?: true -env['rack.input'].gets: {"user": {"email": "testy3@example.com", "password": "changeme"}} -valid? json_params: {"user"=>{"email"=>"testy3@example.com", "password"=>"changeme"}} -json_params: {} -params.empty?: true -env['rack.input'].gets: {"user": {"email": "testy3@example.com", "password": "changeme"}} -subdomain: ["test3"] - Cadenero::V1::Account Load (2.0ms) SELECT "public"."cadenero_accounts".* FROM "public"."cadenero_accounts" WHERE "public"."cadenero_accounts"."subdomain" IN ('test3') LIMIT 1 - Cadenero::V1::Account Load (0.5ms) SELECT "public"."cadenero_accounts".* FROM "public"."cadenero_accounts" WHERE "public"."cadenero_accounts"."authentication_token" = 'cxiYZpGPQ6NofqEmM8n2' LIMIT 1 -account: {"account":{"authentication_token":"cxiYZpGPQ6NofqEmM8n2","created_at":"2013-06-28T01:08:50Z","id":2,"name":"Testy","owner_id":2,"subdomain":"test3","updated_at":"2013-06-28T01:08:50Z"}} -json_params: {} -params.empty?: true -env['rack.input'].gets: {"user": {"email": "testy3@example.com", "password": "changeme"}} - Cadenero::User Load (6.2ms) SELECT "public"."cadenero_users".* FROM "public"."cadenero_users" INNER JOIN "public"."cadenero_members" ON "public"."cadenero_users"."id" = "public"."cadenero_members"."user_id" WHERE "public"."cadenero_members"."account_id" = 2 AND "public"."cadenero_users"."email" = 'testy3@example.com' LIMIT 1 -user: {"user":{"created_at":"2013-06-28T01:08:50Z","email":"testy3@example.com","id":2,"password_digest":"$2a$10$pgArrNXaaxznDs865cVjEuSnRomFzOuVsBCYi3rLvrv5OeQNmIiym","updated_at":"2013-06-28T01:08:50Z"}} -authenticate user! not null: {"user":{"created_at":"2013-06-28T01:08:50Z","email":"testy3@example.com","id":2,"password_digest":"$2a$10$pgArrNXaaxznDs865cVjEuSnRomFzOuVsBCYi3rLvrv5OeQNmIiym","updated_at":"2013-06-28T01:08:50Z"}} -json_params: {} -params.empty?: true -env['rack.input'].gets: {"user": {"email": "testy3@example.com", "password": "changeme"}} - Cadenero::User Load (1.3ms) SELECT "public"."cadenero_users".* FROM "public"."cadenero_users" WHERE "public"."cadenero_users"."id" = 2 LIMIT 1 - Cadenero::Member Load (1.4ms) SELECT "public"."cadenero_members".* FROM "public"."cadenero_members" WHERE "public"."cadenero_members"."user_id" = 2 - Cadenero::V1::Account Load (1.8ms) SELECT "public"."cadenero_accounts".* FROM "public"."cadenero_accounts" INNER JOIN "public"."cadenero_members" ON "public"."cadenero_accounts"."id" = "public"."cadenero_members"."account_id" WHERE "public"."cadenero_members"."user_id" = 2 -Completed 201 Created in 617ms (Views: 95.4ms | ActiveRecord: 79.6ms) - - -Started GET "/" for 127.0.0.1 at 2013-06-27 22:39:10 -0500 -Processing by Cadenero::V1::Account::DashboardController#index as HTML - Parameters: {"default"=>:json} -env['warden'].authenticated?(:user): false -Filter chain halted as :authenticate_user! rendered or redirected -Completed 422 Unprocessable Entity in 1ms (Views: 0.2ms | ActiveRecord: 0.0ms) - - -Started GET "/" for 127.0.0.1 at 2013-06-27 22:39:17 -0500 -Processing by Cadenero::V1::Account::DashboardController#index as HTML - Parameters: {"default"=>:json} -env['warden'].authenticated?(:user): false -Filter chain halted as :authenticate_user! rendered or redirected -Completed 422 Unprocessable Entity in 1ms (Views: 0.2ms | ActiveRecord: 0.0ms) -Connecting to database specified by database.yml - - -Started POST "/v1/sessions" for 127.0.0.1 at 2013-06-27 23:43:41 -0500 - -Apartment::SchemaNotFound (One of the following schema(s) is invalid: test3): - apartment (0.21.1) lib/apartment/adapters/postgresql_adapter.rb:82:in `rescue in connect_to_new' - apartment (0.21.1) lib/apartment/adapters/postgresql_adapter.rb:75:in `connect_to_new' - apartment (0.21.1) lib/apartment/adapters/abstract_adapter.rb:93:in `switch' - apartment (0.21.1) lib/apartment/elevators/generic.rb:17:in `call' - apartment (0.21.1) lib/apartment/reloader.rb:19:in `call' - rack (1.4.5) lib/rack/etag.rb:23:in `call' - rack (1.4.5) lib/rack/conditionalget.rb:35:in `call' - actionpack (3.2.13) lib/action_dispatch/middleware/head.rb:14:in `call' - actionpack (3.2.13) lib/action_dispatch/middleware/params_parser.rb:21:in `call' - activerecord (3.2.13) lib/active_record/query_cache.rb:64:in `call' - activerecord (3.2.13) lib/active_record/connection_adapters/abstract/connection_pool.rb:479:in `call' - actionpack (3.2.13) lib/action_dispatch/middleware/callbacks.rb:28:in `block in call' - activesupport (3.2.13) lib/active_support/callbacks.rb:405:in `_run__756117718638477808__call__3994278690128380133__callbacks' - activesupport (3.2.13) lib/active_support/callbacks.rb:405:in `__run_callback' - activesupport (3.2.13) lib/active_support/callbacks.rb:385:in `_run_call_callbacks' - activesupport (3.2.13) lib/active_support/callbacks.rb:81:in `run_callbacks' - actionpack (3.2.13) lib/action_dispatch/middleware/callbacks.rb:27:in `call' - actionpack (3.2.13) lib/action_dispatch/middleware/reloader.rb:65:in `call' - actionpack (3.2.13) lib/action_dispatch/middleware/remote_ip.rb:31:in `call' - actionpack (3.2.13) lib/action_dispatch/middleware/debug_exceptions.rb:16:in `call' - actionpack (3.2.13) lib/action_dispatch/middleware/show_exceptions.rb:56:in `call' - railties (3.2.13) lib/rails/rack/logger.rb:32:in `call_app' - railties (3.2.13) lib/rails/rack/logger.rb:16:in `block in call' - activesupport (3.2.13) lib/active_support/tagged_logging.rb:22:in `tagged' - railties (3.2.13) lib/rails/rack/logger.rb:16:in `call' - actionpack (3.2.13) lib/action_dispatch/middleware/request_id.rb:22:in `call' - rack (1.4.5) lib/rack/runtime.rb:17:in `call' - activesupport (3.2.13) lib/active_support/cache/strategy/local_cache.rb:72:in `call' - rack (1.4.5) lib/rack/lock.rb:15:in `call' - actionpack (3.2.13) lib/action_dispatch/middleware/static.rb:63:in `call' - railties (3.2.13) lib/rails/engine.rb:479:in `call' - railties (3.2.13) lib/rails/application.rb:223:in `call' - railties (3.2.13) lib/rails/railtie/configurable.rb:30:in `method_missing' - /Users/manuelevidaurrea/Library/Application Support/Pow/Versions/0.4.0/node_modules/nack/lib/nack/server.rb:147:in `handle' - /Users/manuelevidaurrea/Library/Application Support/Pow/Versions/0.4.0/node_modules/nack/lib/nack/server.rb:99:in `rescue in block (2 levels) in start' - /Users/manuelevidaurrea/Library/Application Support/Pow/Versions/0.4.0/node_modules/nack/lib/nack/server.rb:96:in `block (2 levels) in start' - /Users/manuelevidaurrea/Library/Application Support/Pow/Versions/0.4.0/node_modules/nack/lib/nack/server.rb:86:in `each' - /Users/manuelevidaurrea/Library/Application Support/Pow/Versions/0.4.0/node_modules/nack/lib/nack/server.rb:86:in `block in start' - /Users/manuelevidaurrea/Library/Application Support/Pow/Versions/0.4.0/node_modules/nack/lib/nack/server.rb:66:in `loop' - /Users/manuelevidaurrea/Library/Application Support/Pow/Versions/0.4.0/node_modules/nack/lib/nack/server.rb:66:in `start' - /Users/manuelevidaurrea/Library/Application Support/Pow/Versions/0.4.0/node_modules/nack/lib/nack/server.rb:13:in `run' - /Users/manuelevidaurrea/Library/Application Support/Pow/Versions/0.4.0/node_modules/nack/bin/nack_worker:4:in `<main>' - - - Rendered /Users/manuelevidaurrea/Documents/work/agiltec/workspace/ruby/rails/cadenero/vendor/bundle/gems/actionpack-3.2.13/lib/action_dispatch/middleware/templates/rescues/_trace.erb (1.8ms) - Rendered /Users/manuelevidaurrea/Documents/work/agiltec/workspace/ruby/rails/cadenero/vendor/bundle/gems/actionpack-3.2.13/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (1.2ms) - Rendered /Users/manuelevidaurrea/Documents/work/agiltec/workspace/ruby/rails/cadenero/vendor/bundle/gems/actionpack-3.2.13/lib/action_dispatch/middleware/templates/rescues/diagnostics.erb within rescues/layout (20.2ms) - - -Started POST "/v1/accounts" for 127.0.0.1 at 2013-06-27 23:45:05 -0500 -Processing by Cadenero::V1::AccountsController#create as HTML - Parameters: {"account"=>{"name"=>"Testy", "subdomain"=>"test", "owner_attributes"=>{"email"=>"testy@example.com", "password"=>"[FILTERED]", "password_confirmation"=>"[FILTERED]"}}, "default"=>:json} -  (0.2ms) BEGIN - Cadenero::V1::Account Exists (0.5ms) SELECT 1 AS one FROM "public"."cadenero_accounts" WHERE "public"."cadenero_accounts"."subdomain" = 'test' LIMIT 1 - SQL (2.3ms) INSERT INTO "public"."cadenero_users" ("created_at", "email", "password_digest", "updated_at") VALUES ($1, $2, $3, $4) RETURNING "id" [["created_at", Fri, 28 Jun 2013 04:45:05 UTC +00:00], ["email", "testy@example.com"], ["password_digest", "$2a$10$ItllcpD13XNrNciXgTwWc.tyyvFtfjaTd6xNuM0Rq5b6cMKdm3DWa"], ["updated_at", Fri, 28 Jun 2013 04:45:05 UTC +00:00]] - SQL (0.8ms) INSERT INTO "public"."cadenero_accounts" ("authentication_token", "created_at", "name", "owner_id", "subdomain", "updated_at") VALUES ($1, $2, $3, $4, $5, $6) RETURNING "id" [["authentication_token", nil], ["created_at", Fri, 28 Jun 2013 04:45:06 UTC +00:00], ["name", "Testy"], ["owner_id", 3], ["subdomain", "test"], ["updated_at", Fri, 28 Jun 2013 04:45:06 UTC +00:00]] +Started POST "/v1/accounts" for 127.0.0.1 at 2013-06-28 21:11:29 -0500 +Processing by Cadenero::V1::AccountsController#create as */* + Parameters: {"account"=>{"name"=>"Testy", "subdomain"=>"tested1", "owner_attributes"=>{"email"=>"testy2@example.com", "password"=>"[FILTERED]", "password_confirmation"=>"[FILTERED]"}}, "default"=>:json} +AccountsController params[:account]: {"name"=>"Testy", "subdomain"=>"tested1", "owner_attributes"=>{"email"=>"testy2@example.com", "password"=>"changeme", "password_confirmation"=>"changeme"}} +  (0.1ms) BEGIN + Cadenero::V1::Account Exists (0.2ms) SELECT 1 AS one FROM "public"."cadenero_accounts" WHERE "public"."cadenero_accounts"."subdomain" = 'tested1' LIMIT 1 + SQL (0.6ms) INSERT INTO "public"."cadenero_users" ("created_at", "email", "password_digest", "updated_at") VALUES ($1, $2, $3, $4) RETURNING "id" [["created_at", Sat, 29 Jun 2013 02:11:29 UTC +00:00], ["email", "testy2@example.com"], ["password_digest", "$2a$10$jxGVrWyvKjETuIjMP8Nkmuqea8NUo.JQ9soPMsHskN4Xk/ilR7You"], ["updated_at", Sat, 29 Jun 2013 02:11:29 UTC +00:00]] + SQL (0.6ms) INSERT INTO "public"."cadenero_accounts" ("authentication_token", "created_at", "name", "owner_id", "subdomain", "updated_at") VALUES ($1, $2, $3, $4, $5, $6) RETURNING "id" [["authentication_token", nil], ["created_at", Sat, 29 Jun 2013 02:11:29 UTC +00:00], ["name", "Testy"], ["owner_id", 5], ["subdomain", "tested1"], ["updated_at", Sat, 29 Jun 2013 02:11:29 UTC +00:00]] + Cadenero::V1::Account Load (0.3ms) SELECT "public"."cadenero_accounts".* FROM "public"."cadenero_accounts" WHERE "public"."cadenero_accounts"."authentication_token" = '7Yyb4MCNW9nfa46sW5aP' LIMIT 1 +  (0.2ms) UPDATE "public"."cadenero_accounts" SET "name" = 'Testy', "subdomain" = 'tested1', "owner_id" = 5, "created_at" = '2013-06-29 02:11:29.978495', "updated_at" = '2013-06-29 02:11:29.978495' WHERE "public"."cadenero_accounts"."id" = 5 +  (2.0ms) COMMIT +  (0.1ms) BEGIN + SQL (1.2ms) INSERT INTO "public"."cadenero_members" ("account_id", "created_at", "updated_at", "user_id") VALUES ($1, $2, $3, $4) RETURNING "id" [["account_id", 5], ["created_at", Sat, 29 Jun 2013 02:11:29 UTC +00:00], ["updated_at", Sat, 29 Jun 2013 02:11:29 UTC +00:00], ["user_id", 5]]  (0.7ms) COMMIT -  (0.2ms) BEGIN - SQL (1.0ms) INSERT INTO "public"."cadenero_members" ("account_id", "created_at", "updated_at", "user_id") VALUES ($1, $2, $3, $4) RETURNING "id" [["account_id", 3], ["created_at", Fri, 28 Jun 2013 04:45:06 UTC +00:00], ["updated_at", Fri, 28 Jun 2013 04:45:06 UTC +00:00], ["user_id", 3]] -  (0.9ms) COMMIT - Cadenero::V1::Account Exists (0.5ms) SELECT 1 AS one FROM "public"."cadenero_accounts" WHERE ("public"."cadenero_accounts"."subdomain" = 'test' AND "public"."cadenero_accounts"."id" != 3) LIMIT 1 -  (1.3ms) CREATE SCHEMA "test" -  (13.7ms) CREATE TABLE "cadenero_accounts" ("id" serial primary key, "name" character varying(255), "subdomain" character varying(255), "authentication_token" character varying(255), "owner_id" integer, "created_at" timestamp NOT NULL, "updated_at" timestamp NOT NULL)  -  (1.5ms) CREATE INDEX "index_cadenero_accounts_on_authentication_token" ON "cadenero_accounts" ("authentication_token") -  (2.3ms) CREATE INDEX "index_cadenero_accounts_on_owner_id" ON "cadenero_accounts" ("owner_id") -  (4.6ms) CREATE TABLE "cadenero_members" ("id" serial primary key, "account_id" integer, "user_id" integer, "created_at" timestamp NOT NULL, "updated_at" timestamp NOT NULL) -  (1.5ms) CREATE INDEX "index_cadenero_members_on_account_id" ON "cadenero_members" ("account_id") -  (8.9ms) CREATE INDEX "index_cadenero_members_on_user_id" ON "cadenero_members" ("user_id") -  (5.8ms) CREATE TABLE "cadenero_users" ("id" serial primary key, "email" character varying(255), "password_digest" character varying(255), "created_at" timestamp NOT NULL, "updated_at" timestamp NOT NULL)  -  (4.5ms) CREATE TABLE "schema_migrations" ("version" character varying(255) NOT NULL) -  (5.2ms) CREATE UNIQUE INDEX "unique_schema_migrations" ON "schema_migrations" ("version") -  (0.3ms) SELECT version FROM "schema_migrations" -  (0.8ms) INSERT INTO "schema_migrations" (version) VALUES ('20130612073709') - Cadenero::V1::Account Load (0.5ms) SELECT "public"."cadenero_accounts".* FROM "public"."cadenero_accounts" WHERE "public"."cadenero_accounts"."authentication_token" = 'uugLhBDmxWtCPAbbqUps' LIMIT 1 - Cadenero::V1::Account Load (0.2ms) SELECT "public"."cadenero_accounts".* FROM "public"."cadenero_accounts" WHERE "public"."cadenero_accounts"."authentication_token" = 'i4tz4J5zEFMc21WfrLPs' LIMIT 1 -Completed 201 Created in 423ms (Views: 0.2ms | ActiveRecord: 78.7ms) + Cadenero::V1::Account Exists (0.3ms) SELECT 1 AS one FROM "public"."cadenero_accounts" WHERE ("public"."cadenero_accounts"."subdomain" = 'tested1' AND "public"."cadenero_accounts"."id" != 5) LIMIT 1 +  (0.7ms) CREATE SCHEMA "tested1" +  (8.6ms) CREATE TABLE "cadenero_accounts" ("id" serial primary key, "name" character varying(255), "subdomain" character varying(255), "authentication_token" character varying(255), "owner_id" integer, "created_at" timestamp NOT NULL, "updated_at" timestamp NOT NULL) +  (4.3ms) CREATE INDEX "index_cadenero_accounts_on_authentication_token" ON "cadenero_accounts" ("authentication_token") +  (1.3ms) CREATE INDEX "index_cadenero_accounts_on_owner_id" ON "cadenero_accounts" ("owner_id") +  (3.6ms) CREATE TABLE "cadenero_members" ("id" serial primary key, "account_id" integer, "user_id" integer, "created_at" timestamp NOT NULL, "updated_at" timestamp NOT NULL)  +  (1.4ms) CREATE INDEX "index_cadenero_members_on_account_id" ON "cadenero_members" ("account_id") +  (1.1ms) CREATE INDEX "index_cadenero_members_on_user_id" ON "cadenero_members" ("user_id") +  (9.0ms) CREATE TABLE "cadenero_users" ("id" serial primary key, "email" character varying(255), "password_digest" character varying(255), "created_at" timestamp NOT NULL, "updated_at" timestamp NOT NULL) +  (3.8ms) CREATE TABLE "schema_migrations" ("version" character varying(255) NOT NULL)  +  (1.2ms) CREATE UNIQUE INDEX "unique_schema_migrations" ON "schema_migrations" ("version") +  (0.3ms) SELECT version FROM "schema_migrations" +  (0.6ms) INSERT INTO "schema_migrations" (version) VALUES ('20130612073709') + Cadenero::V1::Account Load (0.5ms) SELECT "public"."cadenero_accounts".* FROM "public"."cadenero_accounts" WHERE "public"."cadenero_accounts"."authentication_token" = 'd2xUVTsHdwULLQJYW2z3' LIMIT 1 +  (0.1ms) BEGIN +  (0.1ms) COMMIT +  (0.6ms) BEGIN + SQL (0.5ms) INSERT INTO "public"."cadenero_members" ("account_id", "created_at", "updated_at", "user_id") VALUES ($1, $2, $3, $4) RETURNING "id" [["account_id", 5], ["created_at", Sat, 29 Jun 2013 02:11:30 UTC +00:00], ["updated_at", Sat, 29 Jun 2013 02:11:30 UTC +00:00], ["user_id", 5]] +  (1.2ms) COMMIT +Completed 201 Created in 292ms (Views: 0.3ms | ActiveRecord: 77.7ms)