test/dummy/log/test.log in devise-verifiable-0.0.1 vs test/dummy/log/test.log in devise-verifiable-0.0.2
- old
+ new
@@ -14130,5 +14130,788 @@
[1m[35m (0.1ms)[0m begin transaction
-----------------------------------------
VerifiableTest: test_Devise_configuration
-----------------------------------------
[1m[36m (0.1ms)[0m [1mrollback transaction[0m
+ [1m[36mActiveRecord::SchemaMigration Load (0.5ms)[0m [1mSELECT "schema_migrations".* FROM "schema_migrations"[0m
+ [1m[35m (0.1ms)[0m begin transaction
+ [1m[36mFixture Delete (1.6ms)[0m [1mDELETE FROM "users"[0m
+ [1m[35mFixture Insert (0.7ms)[0m INSERT INTO "users" ("email", "encrypted_password", "created_at", "updated_at", "id") VALUES ('john@gmail.com', '$2a$04$Yde6klMcVO5U1k9Vkx/IPeALPU8D.gDJBa4RhKTyiYrda9J7mk9sa', '2016-04-07 20:09:27', '2016-04-07 20:09:27', 830138774)
+ [1m[36mFixture Insert (0.2ms)[0m [1mINSERT INTO "users" ("email", "encrypted_password", "full_name", "address", "created_at", "updated_at", "id") VALUES ('verified-john@gmail.com', '$2a$04$eWVWaG6YdPmAqYop8sigC.2x3FFjm6Xkeej3nWcmxPSwUuXO7ZDu6', 'Verified John Doe', '551, 5th Street', '2016-04-07 20:09:27', '2016-04-07 20:09:27', 778254699)[0m
+ [1m[35m (3.8ms)[0m commit transaction
+ [1m[36m (0.2ms)[0m [1mbegin transaction[0m
+------------------------------------------------------------
+NavigationTest: test_shows_errors_messages_when_invalid_user
+------------------------------------------------------------
+ [1m[35mUser Load (0.2ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", 830138774]]
+Started GET "/users/sign_in" for 127.0.0.1 at 2016-04-07 17:09:27 -0300
+Processing by Devise::SessionsController#new as HTML
+ Rendered /Users/rodrigora/.rvm/gems/ruby-2.2.4@devise-verifiable/gems/devise-3.5.6/app/views/devise/shared/_links.html.erb (2.6ms)
+ Rendered /Users/rodrigora/.rvm/gems/ruby-2.2.4@devise-verifiable/gems/devise-3.5.6/app/views/devise/sessions/new.html.erb within layouts/application (53.5ms)
+Completed 200 OK in 340ms (Views: 334.0ms | ActiveRecord: 0.0ms)
+Started POST "/users/sign_in" for 127.0.0.1 at 2016-04-07 17:09:27 -0300
+Processing by Devise::SessionsController#create as HTML
+ Parameters: {"utf8"=>"✓", "user"=>{"email"=>"john@gmail.com", "password"=>"[FILTERED]", "remember_me"=>"0"}, "commit"=>"Log in"}
+ [1m[36mUser Load (0.3ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."email" = ? ORDER BY "users"."id" ASC LIMIT 1[0m [["email", "john@gmail.com"]]
+ [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.4ms)[0m [1mUPDATE "users" SET "last_sign_in_at" = ?, "current_sign_in_at" = ?, "last_sign_in_ip" = ?, "current_sign_in_ip" = ?, "sign_in_count" = ?, "updated_at" = ? WHERE "users"."id" = ?[0m [["last_sign_in_at", "2016-04-07 20:09:27.582284"], ["current_sign_in_at", "2016-04-07 20:09:27.582284"], ["last_sign_in_ip", "127.0.0.1"], ["current_sign_in_ip", "127.0.0.1"], ["sign_in_count", 1], ["updated_at", "2016-04-07 20:09:27.583394"], ["id", 830138774]]
+ [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+Redirected to http://www.example.com/
+Completed 302 Found in 24ms (ActiveRecord: 1.0ms)
+Started GET "/" for 127.0.0.1 at 2016-04-07 17:09:27 -0300
+Processing by HomeController#index as HTML
+ [1m[36mUser Load (0.2ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? ORDER BY "users"."id" ASC LIMIT 1[0m [["id", 830138774]]
+Redirected to http://www.example.com/users/verification/new
+Filter chain halted as :authenticate_verified_user! rendered or redirected
+Completed 302 Found in 2ms (ActiveRecord: 0.2ms)
+Started GET "/users/verification/new" for 127.0.0.1 at 2016-04-07 17:09:27 -0300
+Processing by Devise::VerificationController#new as HTML
+ [1m[35mUser Load (0.1ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? ORDER BY "users"."id" ASC LIMIT 1 [["id", 830138774]]
+ Rendered /Users/rodrigora/Projects/devise-verifiable/app/views/devise/verification/new.erb within layouts/application (2.5ms)
+Completed 200 OK in 14ms (Views: 12.4ms | ActiveRecord: 0.1ms)
+Started GET "/users/verification/new" for 127.0.0.1 at 2016-04-07 17:09:27 -0300
+Processing by Devise::VerificationController#new as HTML
+ [1m[36mUser Load (0.1ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? ORDER BY "users"."id" ASC LIMIT 1[0m [["id", 830138774]]
+ Rendered /Users/rodrigora/Projects/devise-verifiable/app/views/devise/verification/new.erb within layouts/application (1.3ms)
+Completed 200 OK in 5ms (Views: 3.4ms | ActiveRecord: 0.1ms)
+Started POST "/users/verification" for 127.0.0.1 at 2016-04-07 17:09:27 -0300
+Processing by Devise::VerificationController#create as HTML
+ Parameters: {"utf8"=>"✓", "user"=>{"full_name"=>"", "address"=>""}, "commit"=>"Verify"}
+ [1m[35mUser Load (0.1ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? ORDER BY "users"."id" ASC LIMIT 1 [["id", 830138774]]
+ Rendered /Users/rodrigora/Projects/devise-verifiable/app/views/devise/verification/new.erb within layouts/application (2.2ms)
+Completed 200 OK in 5ms (Views: 3.5ms | ActiveRecord: 0.1ms)
+ [1m[36m (1.1ms)[0m [1mrollback transaction[0m
+ [1m[35m (0.2ms)[0m begin transaction
+--------------------------------------------------------------------------
+NavigationTest: test_verifies_the_user_filling_all_fields_for_verification
+--------------------------------------------------------------------------
+ [1m[36mUser Load (0.1ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1[0m [["id", 830138774]]
+Started GET "/users/sign_in" for 127.0.0.1 at 2016-04-07 17:09:27 -0300
+Processing by Devise::SessionsController#new as HTML
+ Rendered /Users/rodrigora/.rvm/gems/ruby-2.2.4@devise-verifiable/gems/devise-3.5.6/app/views/devise/shared/_links.html.erb (0.4ms)
+ Rendered /Users/rodrigora/.rvm/gems/ruby-2.2.4@devise-verifiable/gems/devise-3.5.6/app/views/devise/sessions/new.html.erb within layouts/application (2.6ms)
+Completed 200 OK in 5ms (Views: 4.1ms | ActiveRecord: 0.0ms)
+Started POST "/users/sign_in" for 127.0.0.1 at 2016-04-07 17:09:27 -0300
+Processing by Devise::SessionsController#create as HTML
+ Parameters: {"utf8"=>"✓", "user"=>{"email"=>"john@gmail.com", "password"=>"[FILTERED]", "remember_me"=>"0"}, "commit"=>"Log in"}
+ [1m[35mUser Load (0.1ms)[0m SELECT "users".* FROM "users" WHERE "users"."email" = ? ORDER BY "users"."id" ASC LIMIT 1 [["email", "john@gmail.com"]]
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.2ms)[0m UPDATE "users" SET "last_sign_in_at" = ?, "current_sign_in_at" = ?, "last_sign_in_ip" = ?, "current_sign_in_ip" = ?, "sign_in_count" = ?, "updated_at" = ? WHERE "users"."id" = ? [["last_sign_in_at", "2016-04-07 20:09:27.682447"], ["current_sign_in_at", "2016-04-07 20:09:27.682447"], ["last_sign_in_ip", "127.0.0.1"], ["current_sign_in_ip", "127.0.0.1"], ["sign_in_count", 1], ["updated_at", "2016-04-07 20:09:27.683065"], ["id", 830138774]]
+ [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Redirected to http://www.example.com/
+Completed 302 Found in 6ms (ActiveRecord: 0.5ms)
+Started GET "/" for 127.0.0.1 at 2016-04-07 17:09:27 -0300
+Processing by HomeController#index as HTML
+ [1m[35mUser Load (0.0ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? ORDER BY "users"."id" ASC LIMIT 1 [["id", 830138774]]
+Redirected to http://www.example.com/users/verification/new
+Filter chain halted as :authenticate_verified_user! rendered or redirected
+Completed 302 Found in 1ms (ActiveRecord: 0.0ms)
+Started GET "/users/verification/new" for 127.0.0.1 at 2016-04-07 17:09:27 -0300
+Processing by Devise::VerificationController#new as HTML
+ [1m[36mUser Load (0.1ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? ORDER BY "users"."id" ASC LIMIT 1[0m [["id", 830138774]]
+ Rendered /Users/rodrigora/Projects/devise-verifiable/app/views/devise/verification/new.erb within layouts/application (1.4ms)
+Completed 200 OK in 4ms (Views: 3.2ms | ActiveRecord: 0.1ms)
+Started GET "/users/verification/new" for 127.0.0.1 at 2016-04-07 17:09:27 -0300
+Processing by Devise::VerificationController#new as HTML
+ [1m[35mUser Load (0.1ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? ORDER BY "users"."id" ASC LIMIT 1 [["id", 830138774]]
+ Rendered /Users/rodrigora/Projects/devise-verifiable/app/views/devise/verification/new.erb within layouts/application (1.4ms)
+Completed 200 OK in 5ms (Views: 4.0ms | ActiveRecord: 0.1ms)
+Started POST "/users/verification" for 127.0.0.1 at 2016-04-07 17:09:27 -0300
+Processing by Devise::VerificationController#create as HTML
+ Parameters: {"utf8"=>"✓", "user"=>{"full_name"=>"John Doe", "address"=>"555, 5th Street"}, "commit"=>"Verify"}
+ [1m[36mUser Load (0.1ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? ORDER BY "users"."id" ASC LIMIT 1[0m [["id", 830138774]]
+ [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.7ms)[0m [1mUPDATE "users" SET "full_name" = ?, "address" = ?, "updated_at" = ? WHERE "users"."id" = ?[0m [["full_name", "John Doe"], ["address", "555, 5th Street"], ["updated_at", "2016-04-07 20:09:27.711257"], ["id", 830138774]]
+ [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+Redirected to http://www.example.com/
+Completed 302 Found in 5ms (ActiveRecord: 0.9ms)
+Started GET "/" for 127.0.0.1 at 2016-04-07 17:09:27 -0300
+Processing by HomeController#index as HTML
+ [1m[36mUser Load (0.1ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? ORDER BY "users"."id" ASC LIMIT 1[0m [["id", 830138774]]
+ Rendered home/index.html.erb within layouts/application (0.5ms)
+Completed 200 OK in 12ms (Views: 10.2ms | ActiveRecord: 0.1ms)
+ [1m[35m (0.7ms)[0m rollback transaction
+ [1m[36m (0.1ms)[0m [1mbegin transaction[0m
+------------------------------------------------------------------
+NavigationTest: test_unverified_user_is_redirected_to_verification
+------------------------------------------------------------------
+ [1m[35mUser Load (0.1ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", 830138774]]
+Started GET "/users/sign_in" for 127.0.0.1 at 2016-04-07 17:09:27 -0300
+Processing by Devise::SessionsController#new as HTML
+ Rendered /Users/rodrigora/.rvm/gems/ruby-2.2.4@devise-verifiable/gems/devise-3.5.6/app/views/devise/shared/_links.html.erb (0.3ms)
+ Rendered /Users/rodrigora/.rvm/gems/ruby-2.2.4@devise-verifiable/gems/devise-3.5.6/app/views/devise/sessions/new.html.erb within layouts/application (2.4ms)
+Completed 200 OK in 5ms (Views: 4.1ms | ActiveRecord: 0.0ms)
+Started POST "/users/sign_in" for 127.0.0.1 at 2016-04-07 17:09:27 -0300
+Processing by Devise::SessionsController#create as HTML
+ Parameters: {"utf8"=>"✓", "user"=>{"email"=>"john@gmail.com", "password"=>"[FILTERED]", "remember_me"=>"0"}, "commit"=>"Log in"}
+ [1m[36mUser Load (0.1ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."email" = ? ORDER BY "users"."id" ASC LIMIT 1[0m [["email", "john@gmail.com"]]
+ [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mUPDATE "users" SET "last_sign_in_at" = ?, "current_sign_in_at" = ?, "last_sign_in_ip" = ?, "current_sign_in_ip" = ?, "sign_in_count" = ?, "updated_at" = ? WHERE "users"."id" = ?[0m [["last_sign_in_at", "2016-04-07 20:09:27.755579"], ["current_sign_in_at", "2016-04-07 20:09:27.755579"], ["last_sign_in_ip", "127.0.0.1"], ["current_sign_in_ip", "127.0.0.1"], ["sign_in_count", 1], ["updated_at", "2016-04-07 20:09:27.756144"], ["id", 830138774]]
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+Redirected to http://www.example.com/
+Completed 302 Found in 7ms (ActiveRecord: 0.4ms)
+Started GET "/" for 127.0.0.1 at 2016-04-07 17:09:27 -0300
+Processing by HomeController#index as HTML
+ [1m[36mUser Load (0.1ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? ORDER BY "users"."id" ASC LIMIT 1[0m [["id", 830138774]]
+Redirected to http://www.example.com/users/verification/new
+Filter chain halted as :authenticate_verified_user! rendered or redirected
+Completed 302 Found in 1ms (ActiveRecord: 0.1ms)
+Started GET "/users/verification/new" for 127.0.0.1 at 2016-04-07 17:09:27 -0300
+Processing by Devise::VerificationController#new as HTML
+ [1m[35mUser Load (0.1ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? ORDER BY "users"."id" ASC LIMIT 1 [["id", 830138774]]
+ Rendered /Users/rodrigora/Projects/devise-verifiable/app/views/devise/verification/new.erb within layouts/application (1.1ms)
+Completed 200 OK in 4ms (Views: 2.7ms | ActiveRecord: 0.1ms)
+Started GET "/" for 127.0.0.1 at 2016-04-07 17:09:27 -0300
+Processing by HomeController#index as HTML
+ [1m[36mUser Load (0.1ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? ORDER BY "users"."id" ASC LIMIT 1[0m [["id", 830138774]]
+Redirected to http://www.example.com/users/verification/new
+Filter chain halted as :authenticate_verified_user! rendered or redirected
+Completed 302 Found in 2ms (ActiveRecord: 0.1ms)
+Started GET "/users/verification/new" for 127.0.0.1 at 2016-04-07 17:09:27 -0300
+Processing by Devise::VerificationController#new as HTML
+ [1m[35mUser Load (0.1ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? ORDER BY "users"."id" ASC LIMIT 1 [["id", 830138774]]
+ Rendered /Users/rodrigora/Projects/devise-verifiable/app/views/devise/verification/new.erb within layouts/application (1.3ms)
+Completed 200 OK in 4ms (Views: 2.8ms | ActiveRecord: 0.1ms)
+ [1m[36m (0.6ms)[0m [1mrollback transaction[0m
+ [1m[35m (0.1ms)[0m begin transaction
+------------------------------------------------------------------------------
+NavigationTest: test_verification_page_shows_form_with_fields_for_verification
+------------------------------------------------------------------------------
+ [1m[36mUser Load (0.1ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1[0m [["id", 830138774]]
+Started GET "/users/sign_in" for 127.0.0.1 at 2016-04-07 17:09:27 -0300
+Processing by Devise::SessionsController#new as HTML
+ Rendered /Users/rodrigora/.rvm/gems/ruby-2.2.4@devise-verifiable/gems/devise-3.5.6/app/views/devise/shared/_links.html.erb (0.4ms)
+ Rendered /Users/rodrigora/.rvm/gems/ruby-2.2.4@devise-verifiable/gems/devise-3.5.6/app/views/devise/sessions/new.html.erb within layouts/application (2.7ms)
+Completed 200 OK in 5ms (Views: 4.3ms | ActiveRecord: 0.0ms)
+Started POST "/users/sign_in" for 127.0.0.1 at 2016-04-07 17:09:27 -0300
+Processing by Devise::SessionsController#create as HTML
+ Parameters: {"utf8"=>"✓", "user"=>{"email"=>"john@gmail.com", "password"=>"[FILTERED]", "remember_me"=>"0"}, "commit"=>"Log in"}
+ [1m[35mUser Load (0.1ms)[0m SELECT "users".* FROM "users" WHERE "users"."email" = ? ORDER BY "users"."id" ASC LIMIT 1 [["email", "john@gmail.com"]]
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.3ms)[0m UPDATE "users" SET "last_sign_in_at" = ?, "current_sign_in_at" = ?, "last_sign_in_ip" = ?, "current_sign_in_ip" = ?, "sign_in_count" = ?, "updated_at" = ? WHERE "users"."id" = ? [["last_sign_in_at", "2016-04-07 20:09:27.806427"], ["current_sign_in_at", "2016-04-07 20:09:27.806427"], ["last_sign_in_ip", "127.0.0.1"], ["current_sign_in_ip", "127.0.0.1"], ["sign_in_count", 1], ["updated_at", "2016-04-07 20:09:27.807085"], ["id", 830138774]]
+ [1m[36m (0.2ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Redirected to http://www.example.com/
+Completed 302 Found in 8ms (ActiveRecord: 0.6ms)
+Started GET "/" for 127.0.0.1 at 2016-04-07 17:09:27 -0300
+Processing by HomeController#index as HTML
+ [1m[35mUser Load (0.1ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? ORDER BY "users"."id" ASC LIMIT 1 [["id", 830138774]]
+Redirected to http://www.example.com/users/verification/new
+Filter chain halted as :authenticate_verified_user! rendered or redirected
+Completed 302 Found in 1ms (ActiveRecord: 0.1ms)
+Started GET "/users/verification/new" for 127.0.0.1 at 2016-04-07 17:09:27 -0300
+Processing by Devise::VerificationController#new as HTML
+ [1m[36mUser Load (0.0ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? ORDER BY "users"."id" ASC LIMIT 1[0m [["id", 830138774]]
+ Rendered /Users/rodrigora/Projects/devise-verifiable/app/views/devise/verification/new.erb within layouts/application (1.7ms)
+Completed 200 OK in 4ms (Views: 3.4ms | ActiveRecord: 0.0ms)
+Started GET "/users/verification/new" for 127.0.0.1 at 2016-04-07 17:09:27 -0300
+Processing by Devise::VerificationController#new as HTML
+ [1m[35mUser Load (0.1ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? ORDER BY "users"."id" ASC LIMIT 1 [["id", 830138774]]
+ Rendered /Users/rodrigora/Projects/devise-verifiable/app/views/devise/verification/new.erb within layouts/application (1.6ms)
+Completed 200 OK in 4ms (Views: 2.7ms | ActiveRecord: 0.1ms)
+ [1m[36m (0.4ms)[0m [1mrollback transaction[0m
+ [1m[35m (0.1ms)[0m begin transaction
+--------------------------------------------------------------------
+NavigationTest: test_verified_user_is_not_redirected_to_verification
+--------------------------------------------------------------------
+ [1m[36mUser Load (0.1ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1[0m [["id", 778254699]]
+Started GET "/users/sign_in" for 127.0.0.1 at 2016-04-07 17:09:27 -0300
+Processing by Devise::SessionsController#new as HTML
+ Rendered /Users/rodrigora/.rvm/gems/ruby-2.2.4@devise-verifiable/gems/devise-3.5.6/app/views/devise/shared/_links.html.erb (0.3ms)
+ Rendered /Users/rodrigora/.rvm/gems/ruby-2.2.4@devise-verifiable/gems/devise-3.5.6/app/views/devise/sessions/new.html.erb within layouts/application (2.5ms)
+Completed 200 OK in 5ms (Views: 4.0ms | ActiveRecord: 0.0ms)
+Started POST "/users/sign_in" for 127.0.0.1 at 2016-04-07 17:09:27 -0300
+Processing by Devise::SessionsController#create as HTML
+ Parameters: {"utf8"=>"✓", "user"=>{"email"=>"verified-john@gmail.com", "password"=>"[FILTERED]", "remember_me"=>"0"}, "commit"=>"Log in"}
+ [1m[35mUser Load (0.1ms)[0m SELECT "users".* FROM "users" WHERE "users"."email" = ? ORDER BY "users"."id" ASC LIMIT 1 [["email", "verified-john@gmail.com"]]
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.4ms)[0m UPDATE "users" SET "last_sign_in_at" = ?, "current_sign_in_at" = ?, "last_sign_in_ip" = ?, "current_sign_in_ip" = ?, "sign_in_count" = ?, "updated_at" = ? WHERE "users"."id" = ? [["last_sign_in_at", "2016-04-07 20:09:27.854909"], ["current_sign_in_at", "2016-04-07 20:09:27.854909"], ["last_sign_in_ip", "127.0.0.1"], ["current_sign_in_ip", "127.0.0.1"], ["sign_in_count", 1], ["updated_at", "2016-04-07 20:09:27.855644"], ["id", 778254699]]
+ [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Redirected to http://www.example.com/
+Completed 302 Found in 9ms (ActiveRecord: 0.6ms)
+Started GET "/" for 127.0.0.1 at 2016-04-07 17:09:27 -0300
+Processing by HomeController#index as HTML
+ [1m[35mUser Load (0.1ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? ORDER BY "users"."id" ASC LIMIT 1 [["id", 778254699]]
+ Rendered home/index.html.erb within layouts/application (0.1ms)
+Completed 200 OK in 2ms (Views: 1.4ms | ActiveRecord: 0.1ms)
+Started GET "/" for 127.0.0.1 at 2016-04-07 17:09:27 -0300
+Processing by HomeController#index as HTML
+ [1m[36mUser Load (0.1ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? ORDER BY "users"."id" ASC LIMIT 1[0m [["id", 778254699]]
+ Rendered home/index.html.erb within layouts/application (0.1ms)
+Completed 200 OK in 4ms (Views: 2.3ms | ActiveRecord: 0.1ms)
+ [1m[35m (0.5ms)[0m rollback transaction
+ [1m[36m (0.1ms)[0m [1mbegin transaction[0m
+------------------------------------------------------------
+NavigationTest: test_root_path_requires_users_authentication
+------------------------------------------------------------
+Started GET "/" for 127.0.0.1 at 2016-04-07 17:09:27 -0300
+Processing by HomeController#index as HTML
+Completed 401 Unauthorized in 0ms (ActiveRecord: 0.0ms)
+Started GET "/users/sign_in" for 127.0.0.1 at 2016-04-07 17:09:27 -0300
+Processing by Devise::SessionsController#new as HTML
+ Rendered /Users/rodrigora/.rvm/gems/ruby-2.2.4@devise-verifiable/gems/devise-3.5.6/app/views/devise/shared/_links.html.erb (0.4ms)
+ Rendered /Users/rodrigora/.rvm/gems/ruby-2.2.4@devise-verifiable/gems/devise-3.5.6/app/views/devise/sessions/new.html.erb within layouts/application (3.2ms)
+Completed 200 OK in 6ms (Views: 4.8ms | ActiveRecord: 0.0ms)
+ [1m[35m (0.1ms)[0m rollback transaction
+ [1m[36m (0.1ms)[0m [1mbegin transaction[0m
+--------------------------------
+DeviseVerifiableTest: test_truth
+--------------------------------
+ [1m[35m (0.0ms)[0m rollback transaction
+ [1m[36m (0.1ms)[0m [1mbegin transaction[0m
+-----------------------------------------
+VerifiableTest: test_Devise_configuration
+-----------------------------------------
+ [1m[35m (0.1ms)[0m rollback transaction
+ [1m[36m (0.1ms)[0m [1mbegin transaction[0m
+-----------------------------------------------------
+VerifiableTest: test_refuting_when_user_isnt_verified
+-----------------------------------------------------
+ [1m[35m (0.1ms)[0m rollback transaction
+ [1m[36m (0.1ms)[0m [1mbegin transaction[0m
+----------------------------------------------------
+VerifiableTest: test_asserting_when_user_is_verified
+----------------------------------------------------
+ [1m[35m (0.1ms)[0m rollback transaction
+ [1m[36m (0.1ms)[0m [1mbegin transaction[0m
+--------------------------------------------------------------------
+VerifiableTest: test_adding_errors_for_empty_fields_for_verification
+--------------------------------------------------------------------
+ [1m[35mUser Load (0.1ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", 830138774]]
+ [1m[36m (0.1ms)[0m [1mrollback transaction[0m
+ [1m[35m (0.1ms)[0m begin transaction
+--------------------------------------------------
+DefaultRoutingTest: test_map_new_user_verification
+--------------------------------------------------
+ [1m[36m (0.1ms)[0m [1mrollback transaction[0m
+ [1m[35m (0.3ms)[0m begin transaction
+----------------------------------------------
+DefaultRoutingTest: test_map_user_verification
+----------------------------------------------
+ [1m[36m (0.1ms)[0m [1mrollback transaction[0m
+ [1m[36mActiveRecord::SchemaMigration Load (0.6ms)[0m [1mSELECT "schema_migrations".* FROM "schema_migrations"[0m
+ [1m[35m (0.1ms)[0m begin transaction
+ [1m[36mFixture Delete (1.4ms)[0m [1mDELETE FROM "users"[0m
+ [1m[35mFixture Insert (0.6ms)[0m INSERT INTO "users" ("email", "encrypted_password", "created_at", "updated_at", "id") VALUES ('john@gmail.com', '$2a$04$clVZDhA0QS8.l5e1lCEIb.68Vpfmaa./XAKVwFqeRoi2OsuH6cYWi', '2016-12-10 14:22:55', '2016-12-10 14:22:55', 830138774)
+ [1m[36mFixture Insert (0.2ms)[0m [1mINSERT INTO "users" ("email", "encrypted_password", "full_name", "address", "created_at", "updated_at", "id") VALUES ('verified-john@gmail.com', '$2a$04$d8zJSRQhJayyUIgq4ogxZO6F4ypls2rzadURf/hi4uWW7GJgLSbTW', 'Verified John Doe', '551, 5th Street', '2016-12-10 14:22:55', '2016-12-10 14:22:55', 778254699)[0m
+ [1m[35m (5.9ms)[0m commit transaction
+ [1m[36m (0.1ms)[0m [1mbegin transaction[0m
+--------------------------------
+DeviseVerifiableTest: test_truth
+--------------------------------
+ [1m[35m (0.1ms)[0m rollback transaction
+ [1m[36m (0.1ms)[0m [1mbegin transaction[0m
+----------------------------------------------------
+VerifiableTest: test_asserting_when_user_is_verified
+----------------------------------------------------
+ [1m[35m (0.1ms)[0m rollback transaction
+ [1m[36m (0.1ms)[0m [1mbegin transaction[0m
+-----------------------------------------------------
+VerifiableTest: test_refuting_when_user_isnt_verified
+-----------------------------------------------------
+ [1m[35m (0.1ms)[0m rollback transaction
+ [1m[36m (0.1ms)[0m [1mbegin transaction[0m
+-----------------------------------------
+VerifiableTest: test_Devise_configuration
+-----------------------------------------
+ [1m[35m (0.1ms)[0m rollback transaction
+ [1m[36m (0.1ms)[0m [1mbegin transaction[0m
+--------------------------------------------------------------------
+VerifiableTest: test_adding_errors_for_empty_fields_for_verification
+--------------------------------------------------------------------
+ [1m[35mUser Load (0.2ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", 830138774]]
+ [1m[36m (0.1ms)[0m [1mrollback transaction[0m
+ [1m[35m (0.1ms)[0m begin transaction
+--------------------------------------------------------------------------
+NavigationTest: test_verifies_the_user_filling_all_fields_for_verification
+--------------------------------------------------------------------------
+ [1m[36mUser Load (0.2ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1[0m [["id", 830138774]]
+Started GET "/users/sign_in" for 127.0.0.1 at 2016-12-10 12:22:56 -0200
+Processing by Devise::SessionsController#new as HTML
+ Rendered /Users/rodrigora/.rvm/gems/ruby-2.2.4@devise-verifiable/gems/devise-3.5.6/app/views/devise/shared/_links.html.erb (2.7ms)
+ Rendered /Users/rodrigora/.rvm/gems/ruby-2.2.4@devise-verifiable/gems/devise-3.5.6/app/views/devise/sessions/new.html.erb within layouts/application (39.2ms)
+Completed 200 OK in 416ms (Views: 406.8ms | ActiveRecord: 0.0ms)
+Started POST "/users/sign_in" for 127.0.0.1 at 2016-12-10 12:22:56 -0200
+Processing by Devise::SessionsController#create as HTML
+ Parameters: {"utf8"=>"✓", "user"=>{"email"=>"john@gmail.com", "password"=>"[FILTERED]", "remember_me"=>"0"}, "commit"=>"Log in"}
+ [1m[35mUser Load (0.2ms)[0m SELECT "users".* FROM "users" WHERE "users"."email" = ? ORDER BY "users"."id" ASC LIMIT 1 [["email", "john@gmail.com"]]
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.4ms)[0m UPDATE "users" SET "last_sign_in_at" = ?, "current_sign_in_at" = ?, "last_sign_in_ip" = ?, "current_sign_in_ip" = ?, "sign_in_count" = ?, "updated_at" = ? WHERE "users"."id" = ? [["last_sign_in_at", "2016-12-10 14:22:56.526812"], ["current_sign_in_at", "2016-12-10 14:22:56.526812"], ["last_sign_in_ip", "127.0.0.1"], ["current_sign_in_ip", "127.0.0.1"], ["sign_in_count", 1], ["updated_at", "2016-12-10 14:22:56.527544"], ["id", 830138774]]
+ [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Redirected to http://www.example.com/
+Completed 302 Found in 22ms (ActiveRecord: 0.8ms)
+Started GET "/" for 127.0.0.1 at 2016-12-10 12:22:56 -0200
+Processing by HomeController#index as HTML
+ [1m[35mUser Load (0.3ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? ORDER BY "users"."id" ASC LIMIT 1 [["id", 830138774]]
+Redirected to http://www.example.com/users/verification/new
+Filter chain halted as :authenticate_verified_user! rendered or redirected
+Completed 302 Found in 3ms (ActiveRecord: 0.3ms)
+Started GET "/users/verification/new" for 127.0.0.1 at 2016-12-10 12:22:56 -0200
+Processing by Devise::VerificationController#new as HTML
+ [1m[36mUser Load (0.1ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? ORDER BY "users"."id" ASC LIMIT 1[0m [["id", 830138774]]
+ Rendered /Users/rodrigora/Projects/devise-verifiable/app/views/devise/verification/new.erb within layouts/application (3.1ms)
+Completed 200 OK in 16ms (Views: 14.4ms | ActiveRecord: 0.1ms)
+Started GET "/users/verification/new" for 127.0.0.1 at 2016-12-10 12:22:56 -0200
+Processing by Devise::VerificationController#new as HTML
+ [1m[35mUser Load (0.1ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? ORDER BY "users"."id" ASC LIMIT 1 [["id", 830138774]]
+ Rendered /Users/rodrigora/Projects/devise-verifiable/app/views/devise/verification/new.erb within layouts/application (2.4ms)
+Completed 200 OK in 7ms (Views: 4.5ms | ActiveRecord: 0.1ms)
+Started POST "/users/verification" for 127.0.0.1 at 2016-12-10 12:22:56 -0200
+Processing by Devise::VerificationController#create as HTML
+ Parameters: {"utf8"=>"✓", "user"=>{"full_name"=>"John Doe", "address"=>"555, 5th Street"}, "commit"=>"Verify"}
+ [1m[36mUser Load (0.1ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? ORDER BY "users"."id" ASC LIMIT 1[0m [["id", 830138774]]
+ [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.1ms)[0m [1mUPDATE "users" SET "full_name" = ?, "address" = ?, "updated_at" = ? WHERE "users"."id" = ?[0m [["full_name", "John Doe"], ["address", "555, 5th Street"], ["updated_at", "2016-12-10 14:22:56.608868"], ["id", 830138774]]
+ [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+Redirected to http://www.example.com/
+Completed 302 Found in 4ms (ActiveRecord: 0.3ms)
+Started GET "/" for 127.0.0.1 at 2016-12-10 12:22:56 -0200
+Processing by HomeController#index as HTML
+ [1m[36mUser Load (0.1ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? ORDER BY "users"."id" ASC LIMIT 1[0m [["id", 830138774]]
+ Rendered home/index.html.erb within layouts/application (0.4ms)
+Completed 200 OK in 10ms (Views: 8.7ms | ActiveRecord: 0.1ms)
+ [1m[35m (0.5ms)[0m rollback transaction
+ [1m[36m (0.1ms)[0m [1mbegin transaction[0m
+------------------------------------------------------------------
+NavigationTest: test_unverified_user_is_redirected_to_verification
+------------------------------------------------------------------
+ [1m[35mUser Load (0.1ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", 830138774]]
+Started GET "/users/sign_in" for 127.0.0.1 at 2016-12-10 12:22:56 -0200
+Processing by Devise::SessionsController#new as HTML
+ Rendered /Users/rodrigora/.rvm/gems/ruby-2.2.4@devise-verifiable/gems/devise-3.5.6/app/views/devise/shared/_links.html.erb (0.4ms)
+ Rendered /Users/rodrigora/.rvm/gems/ruby-2.2.4@devise-verifiable/gems/devise-3.5.6/app/views/devise/sessions/new.html.erb within layouts/application (2.5ms)
+Completed 200 OK in 5ms (Views: 4.4ms | ActiveRecord: 0.0ms)
+Started POST "/users/sign_in" for 127.0.0.1 at 2016-12-10 12:22:56 -0200
+Processing by Devise::SessionsController#create as HTML
+ Parameters: {"utf8"=>"✓", "user"=>{"email"=>"john@gmail.com", "password"=>"[FILTERED]", "remember_me"=>"0"}, "commit"=>"Log in"}
+ [1m[36mUser Load (0.1ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."email" = ? ORDER BY "users"."id" ASC LIMIT 1[0m [["email", "john@gmail.com"]]
+ [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.5ms)[0m [1mUPDATE "users" SET "last_sign_in_at" = ?, "current_sign_in_at" = ?, "last_sign_in_ip" = ?, "current_sign_in_ip" = ?, "sign_in_count" = ?, "updated_at" = ? WHERE "users"."id" = ?[0m [["last_sign_in_at", "2016-12-10 14:22:56.649251"], ["current_sign_in_at", "2016-12-10 14:22:56.649251"], ["last_sign_in_ip", "127.0.0.1"], ["current_sign_in_ip", "127.0.0.1"], ["sign_in_count", 1], ["updated_at", "2016-12-10 14:22:56.649939"], ["id", 830138774]]
+ [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+Redirected to http://www.example.com/
+Completed 302 Found in 8ms (ActiveRecord: 0.7ms)
+Started GET "/" for 127.0.0.1 at 2016-12-10 12:22:56 -0200
+Processing by HomeController#index as HTML
+ [1m[36mUser Load (0.1ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? ORDER BY "users"."id" ASC LIMIT 1[0m [["id", 830138774]]
+Redirected to http://www.example.com/users/verification/new
+Filter chain halted as :authenticate_verified_user! rendered or redirected
+Completed 302 Found in 2ms (ActiveRecord: 0.1ms)
+Started GET "/users/verification/new" for 127.0.0.1 at 2016-12-10 12:22:56 -0200
+Processing by Devise::VerificationController#new as HTML
+ [1m[35mUser Load (0.1ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? ORDER BY "users"."id" ASC LIMIT 1 [["id", 830138774]]
+ Rendered /Users/rodrigora/Projects/devise-verifiable/app/views/devise/verification/new.erb within layouts/application (1.7ms)
+Completed 200 OK in 5ms (Views: 3.7ms | ActiveRecord: 0.1ms)
+Started GET "/" for 127.0.0.1 at 2016-12-10 12:22:56 -0200
+Processing by HomeController#index as HTML
+ [1m[36mUser Load (0.1ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? ORDER BY "users"."id" ASC LIMIT 1[0m [["id", 830138774]]
+Redirected to http://www.example.com/users/verification/new
+Filter chain halted as :authenticate_verified_user! rendered or redirected
+Completed 302 Found in 2ms (ActiveRecord: 0.1ms)
+Started GET "/users/verification/new" for 127.0.0.1 at 2016-12-10 12:22:56 -0200
+Processing by Devise::VerificationController#new as HTML
+ [1m[35mUser Load (0.1ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? ORDER BY "users"."id" ASC LIMIT 1 [["id", 830138774]]
+ Rendered /Users/rodrigora/Projects/devise-verifiable/app/views/devise/verification/new.erb within layouts/application (1.3ms)
+Completed 200 OK in 4ms (Views: 2.7ms | ActiveRecord: 0.1ms)
+ [1m[36m (0.4ms)[0m [1mrollback transaction[0m
+ [1m[35m (0.1ms)[0m begin transaction
+------------------------------------------------------------------------------
+NavigationTest: test_verification_page_shows_form_with_fields_for_verification
+------------------------------------------------------------------------------
+ [1m[36mUser Load (0.1ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1[0m [["id", 830138774]]
+Started GET "/users/sign_in" for 127.0.0.1 at 2016-12-10 12:22:56 -0200
+Processing by Devise::SessionsController#new as HTML
+ Rendered /Users/rodrigora/.rvm/gems/ruby-2.2.4@devise-verifiable/gems/devise-3.5.6/app/views/devise/shared/_links.html.erb (0.3ms)
+ Rendered /Users/rodrigora/.rvm/gems/ruby-2.2.4@devise-verifiable/gems/devise-3.5.6/app/views/devise/sessions/new.html.erb within layouts/application (2.5ms)
+Completed 200 OK in 5ms (Views: 3.9ms | ActiveRecord: 0.0ms)
+Started POST "/users/sign_in" for 127.0.0.1 at 2016-12-10 12:22:56 -0200
+Processing by Devise::SessionsController#create as HTML
+ Parameters: {"utf8"=>"✓", "user"=>{"email"=>"john@gmail.com", "password"=>"[FILTERED]", "remember_me"=>"0"}, "commit"=>"Log in"}
+ [1m[35mUser Load (0.1ms)[0m SELECT "users".* FROM "users" WHERE "users"."email" = ? ORDER BY "users"."id" ASC LIMIT 1 [["email", "john@gmail.com"]]
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.3ms)[0m UPDATE "users" SET "last_sign_in_at" = ?, "current_sign_in_at" = ?, "last_sign_in_ip" = ?, "current_sign_in_ip" = ?, "sign_in_count" = ?, "updated_at" = ? WHERE "users"."id" = ? [["last_sign_in_at", "2016-12-10 14:22:56.701455"], ["current_sign_in_at", "2016-12-10 14:22:56.701455"], ["last_sign_in_ip", "127.0.0.1"], ["current_sign_in_ip", "127.0.0.1"], ["sign_in_count", 1], ["updated_at", "2016-12-10 14:22:56.702163"], ["id", 830138774]]
+ [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Redirected to http://www.example.com/
+Completed 302 Found in 7ms (ActiveRecord: 0.5ms)
+Started GET "/" for 127.0.0.1 at 2016-12-10 12:22:56 -0200
+Processing by HomeController#index as HTML
+ [1m[35mUser Load (0.1ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? ORDER BY "users"."id" ASC LIMIT 1 [["id", 830138774]]
+Redirected to http://www.example.com/users/verification/new
+Filter chain halted as :authenticate_verified_user! rendered or redirected
+Completed 302 Found in 3ms (ActiveRecord: 0.1ms)
+Started GET "/users/verification/new" for 127.0.0.1 at 2016-12-10 12:22:56 -0200
+Processing by Devise::VerificationController#new as HTML
+ [1m[36mUser Load (0.1ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? ORDER BY "users"."id" ASC LIMIT 1[0m [["id", 830138774]]
+ Rendered /Users/rodrigora/Projects/devise-verifiable/app/views/devise/verification/new.erb within layouts/application (2.2ms)
+Completed 200 OK in 6ms (Views: 4.9ms | ActiveRecord: 0.1ms)
+Started GET "/users/verification/new" for 127.0.0.1 at 2016-12-10 12:22:56 -0200
+Processing by Devise::VerificationController#new as HTML
+ [1m[35mUser Load (0.1ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? ORDER BY "users"."id" ASC LIMIT 1 [["id", 830138774]]
+ Rendered /Users/rodrigora/Projects/devise-verifiable/app/views/devise/verification/new.erb within layouts/application (1.9ms)
+Completed 200 OK in 6ms (Views: 4.1ms | ActiveRecord: 0.1ms)
+ [1m[36m (0.6ms)[0m [1mrollback transaction[0m
+ [1m[35m (0.1ms)[0m begin transaction
+------------------------------------------------------------
+NavigationTest: test_root_path_requires_users_authentication
+------------------------------------------------------------
+Started GET "/" for 127.0.0.1 at 2016-12-10 12:22:56 -0200
+Processing by HomeController#index as HTML
+Completed 401 Unauthorized in 1ms (ActiveRecord: 0.0ms)
+Started GET "/users/sign_in" for 127.0.0.1 at 2016-12-10 12:22:56 -0200
+Processing by Devise::SessionsController#new as HTML
+ Rendered /Users/rodrigora/.rvm/gems/ruby-2.2.4@devise-verifiable/gems/devise-3.5.6/app/views/devise/shared/_links.html.erb (0.5ms)
+ Rendered /Users/rodrigora/.rvm/gems/ruby-2.2.4@devise-verifiable/gems/devise-3.5.6/app/views/devise/sessions/new.html.erb within layouts/application (3.1ms)
+Completed 200 OK in 7ms (Views: 5.0ms | ActiveRecord: 0.0ms)
+ [1m[36m (0.1ms)[0m [1mrollback transaction[0m
+ [1m[35m (0.1ms)[0m begin transaction
+--------------------------------------------------------------------
+NavigationTest: test_verified_user_is_not_redirected_to_verification
+--------------------------------------------------------------------
+ [1m[36mUser Load (0.1ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1[0m [["id", 778254699]]
+Started GET "/users/sign_in" for 127.0.0.1 at 2016-12-10 12:22:56 -0200
+Processing by Devise::SessionsController#new as HTML
+ Rendered /Users/rodrigora/.rvm/gems/ruby-2.2.4@devise-verifiable/gems/devise-3.5.6/app/views/devise/shared/_links.html.erb (0.4ms)
+ Rendered /Users/rodrigora/.rvm/gems/ruby-2.2.4@devise-verifiable/gems/devise-3.5.6/app/views/devise/sessions/new.html.erb within layouts/application (2.3ms)
+Completed 200 OK in 7ms (Views: 6.3ms | ActiveRecord: 0.0ms)
+Started POST "/users/sign_in" for 127.0.0.1 at 2016-12-10 12:22:56 -0200
+Processing by Devise::SessionsController#create as HTML
+ Parameters: {"utf8"=>"✓", "user"=>{"email"=>"verified-john@gmail.com", "password"=>"[FILTERED]", "remember_me"=>"0"}, "commit"=>"Log in"}
+ [1m[35mUser Load (0.1ms)[0m SELECT "users".* FROM "users" WHERE "users"."email" = ? ORDER BY "users"."id" ASC LIMIT 1 [["email", "verified-john@gmail.com"]]
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.3ms)[0m UPDATE "users" SET "last_sign_in_at" = ?, "current_sign_in_at" = ?, "last_sign_in_ip" = ?, "current_sign_in_ip" = ?, "sign_in_count" = ?, "updated_at" = ? WHERE "users"."id" = ? [["last_sign_in_at", "2016-12-10 14:22:56.792724"], ["current_sign_in_at", "2016-12-10 14:22:56.792724"], ["last_sign_in_ip", "127.0.0.1"], ["current_sign_in_ip", "127.0.0.1"], ["sign_in_count", 1], ["updated_at", "2016-12-10 14:22:56.793349"], ["id", 778254699]]
+ [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Redirected to http://www.example.com/
+Completed 302 Found in 7ms (ActiveRecord: 0.5ms)
+Started GET "/" for 127.0.0.1 at 2016-12-10 12:22:56 -0200
+Processing by HomeController#index as HTML
+ [1m[35mUser Load (0.1ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? ORDER BY "users"."id" ASC LIMIT 1 [["id", 778254699]]
+ Rendered home/index.html.erb within layouts/application (0.1ms)
+Completed 200 OK in 3ms (Views: 1.4ms | ActiveRecord: 0.1ms)
+Started GET "/" for 127.0.0.1 at 2016-12-10 12:22:56 -0200
+Processing by HomeController#index as HTML
+ [1m[36mUser Load (0.1ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? ORDER BY "users"."id" ASC LIMIT 1[0m [["id", 778254699]]
+ Rendered home/index.html.erb within layouts/application (0.1ms)
+Completed 200 OK in 4ms (Views: 1.9ms | ActiveRecord: 0.1ms)
+ [1m[35m (0.5ms)[0m rollback transaction
+ [1m[36m (0.1ms)[0m [1mbegin transaction[0m
+------------------------------------------------------------
+NavigationTest: test_shows_errors_messages_when_invalid_user
+------------------------------------------------------------
+ [1m[35mUser Load (0.1ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", 830138774]]
+Started GET "/users/sign_in" for 127.0.0.1 at 2016-12-10 12:22:56 -0200
+Processing by Devise::SessionsController#new as HTML
+ Rendered /Users/rodrigora/.rvm/gems/ruby-2.2.4@devise-verifiable/gems/devise-3.5.6/app/views/devise/shared/_links.html.erb (0.3ms)
+ Rendered /Users/rodrigora/.rvm/gems/ruby-2.2.4@devise-verifiable/gems/devise-3.5.6/app/views/devise/sessions/new.html.erb within layouts/application (2.4ms)
+Completed 200 OK in 5ms (Views: 3.9ms | ActiveRecord: 0.0ms)
+Started POST "/users/sign_in" for 127.0.0.1 at 2016-12-10 12:22:56 -0200
+Processing by Devise::SessionsController#create as HTML
+ Parameters: {"utf8"=>"✓", "user"=>{"email"=>"john@gmail.com", "password"=>"[FILTERED]", "remember_me"=>"0"}, "commit"=>"Log in"}
+ [1m[36mUser Load (0.3ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."email" = ? ORDER BY "users"."id" ASC LIMIT 1[0m [["email", "john@gmail.com"]]
+ [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (1.2ms)[0m [1mUPDATE "users" SET "last_sign_in_at" = ?, "current_sign_in_at" = ?, "last_sign_in_ip" = ?, "current_sign_in_ip" = ?, "sign_in_count" = ?, "updated_at" = ? WHERE "users"."id" = ?[0m [["last_sign_in_at", "2016-12-10 14:22:56.834586"], ["current_sign_in_at", "2016-12-10 14:22:56.834586"], ["last_sign_in_ip", "127.0.0.1"], ["current_sign_in_ip", "127.0.0.1"], ["sign_in_count", 1], ["updated_at", "2016-12-10 14:22:56.835236"], ["id", 830138774]]
+ [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+Redirected to http://www.example.com/
+Completed 302 Found in 9ms (ActiveRecord: 1.7ms)
+Started GET "/" for 127.0.0.1 at 2016-12-10 12:22:56 -0200
+Processing by HomeController#index as HTML
+ [1m[36mUser Load (0.1ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? ORDER BY "users"."id" ASC LIMIT 1[0m [["id", 830138774]]
+Redirected to http://www.example.com/users/verification/new
+Filter chain halted as :authenticate_verified_user! rendered or redirected
+Completed 302 Found in 1ms (ActiveRecord: 0.1ms)
+Started GET "/users/verification/new" for 127.0.0.1 at 2016-12-10 12:22:56 -0200
+Processing by Devise::VerificationController#new as HTML
+ [1m[35mUser Load (0.1ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? ORDER BY "users"."id" ASC LIMIT 1 [["id", 830138774]]
+ Rendered /Users/rodrigora/Projects/devise-verifiable/app/views/devise/verification/new.erb within layouts/application (1.2ms)
+Completed 200 OK in 4ms (Views: 2.8ms | ActiveRecord: 0.1ms)
+Started GET "/users/verification/new" for 127.0.0.1 at 2016-12-10 12:22:56 -0200
+Processing by Devise::VerificationController#new as HTML
+ [1m[36mUser Load (0.1ms)[0m [1mSELECT "users".* FROM "users" WHERE "users"."id" = ? ORDER BY "users"."id" ASC LIMIT 1[0m [["id", 830138774]]
+ Rendered /Users/rodrigora/Projects/devise-verifiable/app/views/devise/verification/new.erb within layouts/application (1.1ms)
+Completed 200 OK in 3ms (Views: 2.4ms | ActiveRecord: 0.1ms)
+Started POST "/users/verification" for 127.0.0.1 at 2016-12-10 12:22:56 -0200
+Processing by Devise::VerificationController#create as HTML
+ Parameters: {"utf8"=>"✓", "user"=>{"full_name"=>"", "address"=>""}, "commit"=>"Verify"}
+ [1m[35mUser Load (0.1ms)[0m SELECT "users".* FROM "users" WHERE "users"."id" = ? ORDER BY "users"."id" ASC LIMIT 1 [["id", 830138774]]
+ Rendered /Users/rodrigora/Projects/devise-verifiable/app/views/devise/verification/new.erb within layouts/application (2.9ms)
+Completed 200 OK in 6ms (Views: 4.5ms | ActiveRecord: 0.1ms)
+ [1m[36m (0.4ms)[0m [1mrollback transaction[0m
+ [1m[35m (0.1ms)[0m begin transaction
+--------------------------------------------------
+DefaultRoutingTest: test_map_new_user_verification
+--------------------------------------------------
+ [1m[36m (0.1ms)[0m [1mrollback transaction[0m
+ [1m[35m (0.1ms)[0m begin transaction
+----------------------------------------------
+DefaultRoutingTest: test_map_user_verification
+----------------------------------------------
+ [1m[36m (0.1ms)[0m [1mrollback transaction[0m
+ [1m[36mActiveRecord::SchemaMigration Load (0.7ms)[0m [1m[34mSELECT "schema_migrations".* FROM "schema_migrations"[0m
+ [1m[35m (0.1ms)[0m [1m[36mbegin transaction[0m
+ [1m[36mFixture Delete (1.6ms)[0m [1m[31mDELETE FROM "users"[0m
+ [1m[36mFixture Insert (0.7ms)[0m [1m[32mINSERT INTO "users" ("email", "encrypted_password", "created_at", "updated_at", "id") VALUES ('john@gmail.com', '$2a$04$o1lLQ8tAUtsiDrh5ZZfve.UI5mg1NEivIqGjeAArW/yBSN5OjT23i', '2016-12-10 15:01:36.453088', '2016-12-10 15:01:36.453088', 830138774)[0m
+ [1m[36mFixture Insert (0.1ms)[0m [1m[32mINSERT INTO "users" ("email", "encrypted_password", "full_name", "address", "created_at", "updated_at", "id") VALUES ('verified-john@gmail.com', '$2a$04$QIA60.iK6RiuX4CCYwKyL.pHf5uSZ8UFYevFFXLwFbtdUL9P3hsMS', 'Verified John Doe', '551, 5th Street', '2016-12-10 15:01:36.453088', '2016-12-10 15:01:36.453088', 778254699)[0m
+ [1m[35m (3.6ms)[0m [1m[36mcommit transaction[0m
+ [1m[35m (0.1ms)[0m [1m[36mbegin transaction[0m
+--------------------------------------------------
+DefaultRoutingTest: test_map_new_user_verification
+--------------------------------------------------
+ [1m[35m (0.1ms)[0m [1m[31mrollback transaction[0m
+ [1m[35m (0.1ms)[0m [1m[36mbegin transaction[0m
+----------------------------------------------
+DefaultRoutingTest: test_map_user_verification
+----------------------------------------------
+ [1m[35m (0.1ms)[0m [1m[31mrollback transaction[0m
+ [1m[35m (0.1ms)[0m [1m[36mbegin transaction[0m
+------------------------------------------------------------
+NavigationTest: test_shows_errors_messages_when_invalid_user
+------------------------------------------------------------
+ [1m[36mUser Load (0.3ms)[0m [1m[34mSELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT ?[0m [["id", 830138774], ["LIMIT", 1]]
+Started GET "/users/sign_in" for 127.0.0.1 at 2016-12-10 13:01:36 -0200
+Processing by Devise::SessionsController#new as HTML
+ Rendering /Users/rodrigora/.rvm/gems/ruby-2.2.4@devise-verifiable/gems/devise-4.2.0/app/views/devise/sessions/new.html.erb within layouts/application
+ Rendered /Users/rodrigora/.rvm/gems/ruby-2.2.4@devise-verifiable/gems/devise-4.2.0/app/views/devise/shared/_links.html.erb (2.2ms)
+ Rendered /Users/rodrigora/.rvm/gems/ruby-2.2.4@devise-verifiable/gems/devise-4.2.0/app/views/devise/sessions/new.html.erb within layouts/application (53.5ms)
+Completed 200 OK in 404ms (Views: 396.0ms | ActiveRecord: 0.0ms)
+Started POST "/users/sign_in" for 127.0.0.1 at 2016-12-10 13:01:37 -0200
+Processing by Devise::SessionsController#create as HTML
+ Parameters: {"utf8"=>"✓", "user"=>{"email"=>"john@gmail.com", "password"=>"[FILTERED]", "remember_me"=>"0"}, "commit"=>"Log in"}
+ [1m[36mUser Load (0.3ms)[0m [1m[34mSELECT "users".* FROM "users" WHERE "users"."email" = ? ORDER BY "users"."id" ASC LIMIT ?[0m [["email", "john@gmail.com"], ["LIMIT", 1]]
+ [1m[35m (0.1ms)[0m [1m[35mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.6ms)[0m [1m[33mUPDATE "users" SET "current_sign_in_at" = ?, "last_sign_in_at" = ?, "current_sign_in_ip" = ?, "last_sign_in_ip" = ?, "sign_in_count" = ?, "updated_at" = ? WHERE "users"."id" = ?[0m [["current_sign_in_at", 2016-12-10 15:01:37 UTC], ["last_sign_in_at", 2016-12-10 15:01:37 UTC], ["current_sign_in_ip", "127.0.0.1"], ["last_sign_in_ip", "127.0.0.1"], ["sign_in_count", 1], ["updated_at", 2016-12-10 15:01:37 UTC], ["id", 830138774]]
+ [1m[35m (0.1ms)[0m [1m[35mRELEASE SAVEPOINT active_record_1[0m
+Redirected to http://www.example.com/
+Completed 302 Found in 25ms (ActiveRecord: 1.0ms)
+Started GET "/" for 127.0.0.1 at 2016-12-10 13:01:37 -0200
+Processing by HomeController#index as HTML
+ [1m[36mUser Load (0.2ms)[0m [1m[34mSELECT "users".* FROM "users" WHERE "users"."id" = ? ORDER BY "users"."id" ASC LIMIT ?[0m [["id", 830138774], ["LIMIT", 1]]
+Redirected to http://www.example.com/users/verification/new
+Filter chain halted as :authenticate_verified_user! rendered or redirected
+Completed 302 Found in 2ms (ActiveRecord: 0.2ms)
+Started GET "/users/verification/new" for 127.0.0.1 at 2016-12-10 13:01:37 -0200
+Processing by Devise::VerificationController#new as HTML
+ [1m[36mUser Load (0.1ms)[0m [1m[34mSELECT "users".* FROM "users" WHERE "users"."id" = ? ORDER BY "users"."id" ASC LIMIT ?[0m [["id", 830138774], ["LIMIT", 1]]
+ Rendering /Users/rodrigora/Projects/devise-verifiable/app/views/devise/verification/new.erb within layouts/application
+ Rendered /Users/rodrigora/Projects/devise-verifiable/app/views/devise/verification/new.erb within layouts/application (2.3ms)
+Completed 200 OK in 15ms (Views: 11.6ms | ActiveRecord: 0.1ms)
+Started GET "/users/verification/new" for 127.0.0.1 at 2016-12-10 13:01:37 -0200
+Processing by Devise::VerificationController#new as HTML
+ [1m[36mUser Load (0.2ms)[0m [1m[34mSELECT "users".* FROM "users" WHERE "users"."id" = ? ORDER BY "users"."id" ASC LIMIT ?[0m [["id", 830138774], ["LIMIT", 1]]
+ Rendering /Users/rodrigora/Projects/devise-verifiable/app/views/devise/verification/new.erb within layouts/application
+ Rendered /Users/rodrigora/Projects/devise-verifiable/app/views/devise/verification/new.erb within layouts/application (2.1ms)
+Completed 200 OK in 16ms (Views: 11.7ms | ActiveRecord: 0.2ms)
+Started POST "/users/verification" for 127.0.0.1 at 2016-12-10 13:01:37 -0200
+Processing by Devise::VerificationController#create as HTML
+ Parameters: {"utf8"=>"✓", "user"=>{"full_name"=>"", "address"=>""}, "commit"=>"Verify"}
+ [1m[36mUser Load (0.2ms)[0m [1m[34mSELECT "users".* FROM "users" WHERE "users"."id" = ? ORDER BY "users"."id" ASC LIMIT ?[0m [["id", 830138774], ["LIMIT", 1]]
+ Rendering /Users/rodrigora/Projects/devise-verifiable/app/views/devise/verification/new.erb within layouts/application
+ Rendered /Users/rodrigora/Projects/devise-verifiable/app/views/devise/verification/new.erb within layouts/application (2.5ms)
+Completed 200 OK in 14ms (Views: 11.7ms | ActiveRecord: 0.2ms)
+ [1m[35m (0.6ms)[0m [1m[31mrollback transaction[0m
+ [1m[35m (0.1ms)[0m [1m[36mbegin transaction[0m
+--------------------------------------------------------------------------
+NavigationTest: test_verifies_the_user_filling_all_fields_for_verification
+--------------------------------------------------------------------------
+ [1m[36mUser Load (0.2ms)[0m [1m[34mSELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT ?[0m [["id", 830138774], ["LIMIT", 1]]
+Started GET "/users/sign_in" for 127.0.0.1 at 2016-12-10 13:01:37 -0200
+Processing by Devise::SessionsController#new as HTML
+ Rendering /Users/rodrigora/.rvm/gems/ruby-2.2.4@devise-verifiable/gems/devise-4.2.0/app/views/devise/sessions/new.html.erb within layouts/application
+ Rendered /Users/rodrigora/.rvm/gems/ruby-2.2.4@devise-verifiable/gems/devise-4.2.0/app/views/devise/shared/_links.html.erb (1.2ms)
+ Rendered /Users/rodrigora/.rvm/gems/ruby-2.2.4@devise-verifiable/gems/devise-4.2.0/app/views/devise/sessions/new.html.erb within layouts/application (6.8ms)
+Completed 200 OK in 21ms (Views: 19.7ms | ActiveRecord: 0.0ms)
+Started POST "/users/sign_in" for 127.0.0.1 at 2016-12-10 13:01:37 -0200
+Processing by Devise::SessionsController#create as HTML
+ Parameters: {"utf8"=>"✓", "user"=>{"email"=>"john@gmail.com", "password"=>"[FILTERED]", "remember_me"=>"0"}, "commit"=>"Log in"}
+ [1m[36mUser Load (0.2ms)[0m [1m[34mSELECT "users".* FROM "users" WHERE "users"."email" = ? ORDER BY "users"."id" ASC LIMIT ?[0m [["email", "john@gmail.com"], ["LIMIT", 1]]
+ [1m[35m (0.1ms)[0m [1m[35mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.3ms)[0m [1m[33mUPDATE "users" SET "current_sign_in_at" = ?, "last_sign_in_at" = ?, "current_sign_in_ip" = ?, "last_sign_in_ip" = ?, "sign_in_count" = ?, "updated_at" = ? WHERE "users"."id" = ?[0m [["current_sign_in_at", 2016-12-10 15:01:37 UTC], ["last_sign_in_at", 2016-12-10 15:01:37 UTC], ["current_sign_in_ip", "127.0.0.1"], ["last_sign_in_ip", "127.0.0.1"], ["sign_in_count", 1], ["updated_at", 2016-12-10 15:01:37 UTC], ["id", 830138774]]
+ [1m[35m (0.1ms)[0m [1m[35mRELEASE SAVEPOINT active_record_1[0m
+Redirected to http://www.example.com/
+Completed 302 Found in 14ms (ActiveRecord: 0.7ms)
+Started GET "/" for 127.0.0.1 at 2016-12-10 13:01:37 -0200
+Processing by HomeController#index as HTML
+ [1m[36mUser Load (0.2ms)[0m [1m[34mSELECT "users".* FROM "users" WHERE "users"."id" = ? ORDER BY "users"."id" ASC LIMIT ?[0m [["id", 830138774], ["LIMIT", 1]]
+Redirected to http://www.example.com/users/verification/new
+Filter chain halted as :authenticate_verified_user! rendered or redirected
+Completed 302 Found in 2ms (ActiveRecord: 0.1ms)
+Started GET "/users/verification/new" for 127.0.0.1 at 2016-12-10 13:01:37 -0200
+Processing by Devise::VerificationController#new as HTML
+ [1m[36mUser Load (0.2ms)[0m [1m[34mSELECT "users".* FROM "users" WHERE "users"."id" = ? ORDER BY "users"."id" ASC LIMIT ?[0m [["id", 830138774], ["LIMIT", 1]]
+ Rendering /Users/rodrigora/Projects/devise-verifiable/app/views/devise/verification/new.erb within layouts/application
+ Rendered /Users/rodrigora/Projects/devise-verifiable/app/views/devise/verification/new.erb within layouts/application (1.9ms)
+Completed 200 OK in 17ms (Views: 11.8ms | ActiveRecord: 0.2ms)
+Started GET "/users/verification/new" for 127.0.0.1 at 2016-12-10 13:01:37 -0200
+Processing by Devise::VerificationController#new as HTML
+ [1m[36mUser Load (0.2ms)[0m [1m[34mSELECT "users".* FROM "users" WHERE "users"."id" = ? ORDER BY "users"."id" ASC LIMIT ?[0m [["id", 830138774], ["LIMIT", 1]]
+ Rendering /Users/rodrigora/Projects/devise-verifiable/app/views/devise/verification/new.erb within layouts/application
+ Rendered /Users/rodrigora/Projects/devise-verifiable/app/views/devise/verification/new.erb within layouts/application (1.8ms)
+Completed 200 OK in 15ms (Views: 10.3ms | ActiveRecord: 0.2ms)
+Started POST "/users/verification" for 127.0.0.1 at 2016-12-10 13:01:37 -0200
+Processing by Devise::VerificationController#create as HTML
+ Parameters: {"utf8"=>"✓", "user"=>{"full_name"=>"John Doe", "address"=>"555, 5th Street"}, "commit"=>"Verify"}
+ [1m[36mUser Load (0.3ms)[0m [1m[34mSELECT "users".* FROM "users" WHERE "users"."id" = ? ORDER BY "users"."id" ASC LIMIT ?[0m [["id", 830138774], ["LIMIT", 1]]
+ [1m[35m (0.1ms)[0m [1m[35mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.2ms)[0m [1m[33mUPDATE "users" SET "full_name" = ?, "address" = ?, "updated_at" = ? WHERE "users"."id" = ?[0m [["full_name", "John Doe"], ["address", "555, 5th Street"], ["updated_at", 2016-12-10 15:01:37 UTC], ["id", 830138774]]
+ [1m[35m (0.1ms)[0m [1m[35mRELEASE SAVEPOINT active_record_1[0m
+Redirected to http://www.example.com/
+Completed 302 Found in 6ms (ActiveRecord: 0.6ms)
+Started GET "/" for 127.0.0.1 at 2016-12-10 13:01:37 -0200
+Processing by HomeController#index as HTML
+ [1m[36mUser Load (0.1ms)[0m [1m[34mSELECT "users".* FROM "users" WHERE "users"."id" = ? ORDER BY "users"."id" ASC LIMIT ?[0m [["id", 830138774], ["LIMIT", 1]]
+ Rendering home/index.html.erb within layouts/application
+ Rendered home/index.html.erb within layouts/application (0.4ms)
+Completed 200 OK in 11ms (Views: 7.3ms | ActiveRecord: 0.1ms)
+ [1m[35m (0.6ms)[0m [1m[31mrollback transaction[0m
+ [1m[35m (0.1ms)[0m [1m[36mbegin transaction[0m
+------------------------------------------------------------------------------
+NavigationTest: test_verification_page_shows_form_with_fields_for_verification
+------------------------------------------------------------------------------
+ [1m[36mUser Load (0.2ms)[0m [1m[34mSELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT ?[0m [["id", 830138774], ["LIMIT", 1]]
+Started GET "/users/sign_in" for 127.0.0.1 at 2016-12-10 13:01:37 -0200
+Processing by Devise::SessionsController#new as HTML
+ Rendering /Users/rodrigora/.rvm/gems/ruby-2.2.4@devise-verifiable/gems/devise-4.2.0/app/views/devise/sessions/new.html.erb within layouts/application
+ Rendered /Users/rodrigora/.rvm/gems/ruby-2.2.4@devise-verifiable/gems/devise-4.2.0/app/views/devise/shared/_links.html.erb (1.1ms)
+ Rendered /Users/rodrigora/.rvm/gems/ruby-2.2.4@devise-verifiable/gems/devise-4.2.0/app/views/devise/sessions/new.html.erb within layouts/application (6.9ms)
+Completed 200 OK in 20ms (Views: 18.9ms | ActiveRecord: 0.0ms)
+Started POST "/users/sign_in" for 127.0.0.1 at 2016-12-10 13:01:37 -0200
+Processing by Devise::SessionsController#create as HTML
+ Parameters: {"utf8"=>"✓", "user"=>{"email"=>"john@gmail.com", "password"=>"[FILTERED]", "remember_me"=>"0"}, "commit"=>"Log in"}
+ [1m[36mUser Load (0.2ms)[0m [1m[34mSELECT "users".* FROM "users" WHERE "users"."email" = ? ORDER BY "users"."id" ASC LIMIT ?[0m [["email", "john@gmail.com"], ["LIMIT", 1]]
+ [1m[35m (0.1ms)[0m [1m[35mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.3ms)[0m [1m[33mUPDATE "users" SET "current_sign_in_at" = ?, "last_sign_in_at" = ?, "current_sign_in_ip" = ?, "last_sign_in_ip" = ?, "sign_in_count" = ?, "updated_at" = ? WHERE "users"."id" = ?[0m [["current_sign_in_at", 2016-12-10 15:01:37 UTC], ["last_sign_in_at", 2016-12-10 15:01:37 UTC], ["current_sign_in_ip", "127.0.0.1"], ["last_sign_in_ip", "127.0.0.1"], ["sign_in_count", 1], ["updated_at", 2016-12-10 15:01:37 UTC], ["id", 830138774]]
+ [1m[35m (0.0ms)[0m [1m[35mRELEASE SAVEPOINT active_record_1[0m
+Redirected to http://www.example.com/
+Completed 302 Found in 15ms (ActiveRecord: 0.6ms)
+Started GET "/" for 127.0.0.1 at 2016-12-10 13:01:37 -0200
+Processing by HomeController#index as HTML
+ [1m[36mUser Load (0.2ms)[0m [1m[34mSELECT "users".* FROM "users" WHERE "users"."id" = ? ORDER BY "users"."id" ASC LIMIT ?[0m [["id", 830138774], ["LIMIT", 1]]
+Redirected to http://www.example.com/users/verification/new
+Filter chain halted as :authenticate_verified_user! rendered or redirected
+Completed 302 Found in 2ms (ActiveRecord: 0.2ms)
+Started GET "/users/verification/new" for 127.0.0.1 at 2016-12-10 13:01:37 -0200
+Processing by Devise::VerificationController#new as HTML
+ [1m[36mUser Load (0.1ms)[0m [1m[34mSELECT "users".* FROM "users" WHERE "users"."id" = ? ORDER BY "users"."id" ASC LIMIT ?[0m [["id", 830138774], ["LIMIT", 1]]
+ Rendering /Users/rodrigora/Projects/devise-verifiable/app/views/devise/verification/new.erb within layouts/application
+ Rendered /Users/rodrigora/Projects/devise-verifiable/app/views/devise/verification/new.erb within layouts/application (2.4ms)
+Completed 200 OK in 16ms (Views: 12.8ms | ActiveRecord: 0.1ms)
+Started GET "/users/verification/new" for 127.0.0.1 at 2016-12-10 13:01:37 -0200
+Processing by Devise::VerificationController#new as HTML
+ [1m[36mUser Load (0.2ms)[0m [1m[34mSELECT "users".* FROM "users" WHERE "users"."id" = ? ORDER BY "users"."id" ASC LIMIT ?[0m [["id", 830138774], ["LIMIT", 1]]
+ Rendering /Users/rodrigora/Projects/devise-verifiable/app/views/devise/verification/new.erb within layouts/application
+ Rendered /Users/rodrigora/Projects/devise-verifiable/app/views/devise/verification/new.erb within layouts/application (1.6ms)
+Completed 200 OK in 12ms (Views: 9.1ms | ActiveRecord: 0.2ms)
+ [1m[35m (0.5ms)[0m [1m[31mrollback transaction[0m
+ [1m[35m (0.1ms)[0m [1m[36mbegin transaction[0m
+------------------------------------------------------------------
+NavigationTest: test_unverified_user_is_redirected_to_verification
+------------------------------------------------------------------
+ [1m[36mUser Load (0.1ms)[0m [1m[34mSELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT ?[0m [["id", 830138774], ["LIMIT", 1]]
+Started GET "/users/sign_in" for 127.0.0.1 at 2016-12-10 13:01:37 -0200
+Processing by Devise::SessionsController#new as HTML
+ Rendering /Users/rodrigora/.rvm/gems/ruby-2.2.4@devise-verifiable/gems/devise-4.2.0/app/views/devise/sessions/new.html.erb within layouts/application
+ Rendered /Users/rodrigora/.rvm/gems/ruby-2.2.4@devise-verifiable/gems/devise-4.2.0/app/views/devise/shared/_links.html.erb (1.0ms)
+ Rendered /Users/rodrigora/.rvm/gems/ruby-2.2.4@devise-verifiable/gems/devise-4.2.0/app/views/devise/sessions/new.html.erb within layouts/application (5.9ms)
+Completed 200 OK in 18ms (Views: 16.9ms | ActiveRecord: 0.0ms)
+Started POST "/users/sign_in" for 127.0.0.1 at 2016-12-10 13:01:37 -0200
+Processing by Devise::SessionsController#create as HTML
+ Parameters: {"utf8"=>"✓", "user"=>{"email"=>"john@gmail.com", "password"=>"[FILTERED]", "remember_me"=>"0"}, "commit"=>"Log in"}
+ [1m[36mUser Load (0.2ms)[0m [1m[34mSELECT "users".* FROM "users" WHERE "users"."email" = ? ORDER BY "users"."id" ASC LIMIT ?[0m [["email", "john@gmail.com"], ["LIMIT", 1]]
+ [1m[35m (0.0ms)[0m [1m[35mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.5ms)[0m [1m[33mUPDATE "users" SET "current_sign_in_at" = ?, "last_sign_in_at" = ?, "current_sign_in_ip" = ?, "last_sign_in_ip" = ?, "sign_in_count" = ?, "updated_at" = ? WHERE "users"."id" = ?[0m [["current_sign_in_at", 2016-12-10 15:01:37 UTC], ["last_sign_in_at", 2016-12-10 15:01:37 UTC], ["current_sign_in_ip", "127.0.0.1"], ["last_sign_in_ip", "127.0.0.1"], ["sign_in_count", 1], ["updated_at", 2016-12-10 15:01:37 UTC], ["id", 830138774]]
+ [1m[35m (0.1ms)[0m [1m[35mRELEASE SAVEPOINT active_record_1[0m
+Redirected to http://www.example.com/
+Completed 302 Found in 16ms (ActiveRecord: 0.8ms)
+Started GET "/" for 127.0.0.1 at 2016-12-10 13:01:37 -0200
+Processing by HomeController#index as HTML
+ [1m[36mUser Load (0.2ms)[0m [1m[34mSELECT "users".* FROM "users" WHERE "users"."id" = ? ORDER BY "users"."id" ASC LIMIT ?[0m [["id", 830138774], ["LIMIT", 1]]
+Redirected to http://www.example.com/users/verification/new
+Filter chain halted as :authenticate_verified_user! rendered or redirected
+Completed 302 Found in 3ms (ActiveRecord: 0.2ms)
+Started GET "/users/verification/new" for 127.0.0.1 at 2016-12-10 13:01:37 -0200
+Processing by Devise::VerificationController#new as HTML
+ [1m[36mUser Load (0.2ms)[0m [1m[34mSELECT "users".* FROM "users" WHERE "users"."id" = ? ORDER BY "users"."id" ASC LIMIT ?[0m [["id", 830138774], ["LIMIT", 1]]
+ Rendering /Users/rodrigora/Projects/devise-verifiable/app/views/devise/verification/new.erb within layouts/application
+ Rendered /Users/rodrigora/Projects/devise-verifiable/app/views/devise/verification/new.erb within layouts/application (1.8ms)
+Completed 200 OK in 14ms (Views: 9.7ms | ActiveRecord: 0.2ms)
+Started GET "/" for 127.0.0.1 at 2016-12-10 13:01:37 -0200
+Processing by HomeController#index as HTML
+ [1m[36mUser Load (0.3ms)[0m [1m[34mSELECT "users".* FROM "users" WHERE "users"."id" = ? ORDER BY "users"."id" ASC LIMIT ?[0m [["id", 830138774], ["LIMIT", 1]]
+Redirected to http://www.example.com/users/verification/new
+Filter chain halted as :authenticate_verified_user! rendered or redirected
+Completed 302 Found in 2ms (ActiveRecord: 0.2ms)
+Started GET "/users/verification/new" for 127.0.0.1 at 2016-12-10 13:01:37 -0200
+Processing by Devise::VerificationController#new as HTML
+ [1m[36mUser Load (0.2ms)[0m [1m[34mSELECT "users".* FROM "users" WHERE "users"."id" = ? ORDER BY "users"."id" ASC LIMIT ?[0m [["id", 830138774], ["LIMIT", 1]]
+ Rendering /Users/rodrigora/Projects/devise-verifiable/app/views/devise/verification/new.erb within layouts/application
+ Rendered /Users/rodrigora/Projects/devise-verifiable/app/views/devise/verification/new.erb within layouts/application (2.0ms)
+Completed 200 OK in 14ms (Views: 9.8ms | ActiveRecord: 0.2ms)
+ [1m[35m (0.4ms)[0m [1m[31mrollback transaction[0m
+ [1m[35m (0.1ms)[0m [1m[36mbegin transaction[0m
+------------------------------------------------------------
+NavigationTest: test_root_path_requires_users_authentication
+------------------------------------------------------------
+Started GET "/" for 127.0.0.1 at 2016-12-10 13:01:37 -0200
+Processing by HomeController#index as HTML
+Completed 401 Unauthorized in 0ms (ActiveRecord: 0.0ms)
+Started GET "/users/sign_in" for 127.0.0.1 at 2016-12-10 13:01:37 -0200
+Processing by Devise::SessionsController#new as HTML
+ Rendering /Users/rodrigora/.rvm/gems/ruby-2.2.4@devise-verifiable/gems/devise-4.2.0/app/views/devise/sessions/new.html.erb within layouts/application
+ Rendered /Users/rodrigora/.rvm/gems/ruby-2.2.4@devise-verifiable/gems/devise-4.2.0/app/views/devise/shared/_links.html.erb (1.0ms)
+ Rendered /Users/rodrigora/.rvm/gems/ruby-2.2.4@devise-verifiable/gems/devise-4.2.0/app/views/devise/sessions/new.html.erb within layouts/application (6.9ms)
+Completed 200 OK in 24ms (Views: 22.8ms | ActiveRecord: 0.0ms)
+ [1m[35m (0.1ms)[0m [1m[31mrollback transaction[0m
+ [1m[35m (0.1ms)[0m [1m[36mbegin transaction[0m
+--------------------------------------------------------------------
+NavigationTest: test_verified_user_is_not_redirected_to_verification
+--------------------------------------------------------------------
+ [1m[36mUser Load (0.1ms)[0m [1m[34mSELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT ?[0m [["id", 778254699], ["LIMIT", 1]]
+Started GET "/users/sign_in" for 127.0.0.1 at 2016-12-10 13:01:37 -0200
+Processing by Devise::SessionsController#new as HTML
+ Rendering /Users/rodrigora/.rvm/gems/ruby-2.2.4@devise-verifiable/gems/devise-4.2.0/app/views/devise/sessions/new.html.erb within layouts/application
+ Rendered /Users/rodrigora/.rvm/gems/ruby-2.2.4@devise-verifiable/gems/devise-4.2.0/app/views/devise/shared/_links.html.erb (1.1ms)
+ Rendered /Users/rodrigora/.rvm/gems/ruby-2.2.4@devise-verifiable/gems/devise-4.2.0/app/views/devise/sessions/new.html.erb within layouts/application (7.4ms)
+Completed 200 OK in 19ms (Views: 18.1ms | ActiveRecord: 0.0ms)
+Started POST "/users/sign_in" for 127.0.0.1 at 2016-12-10 13:01:37 -0200
+Processing by Devise::SessionsController#create as HTML
+ Parameters: {"utf8"=>"✓", "user"=>{"email"=>"verified-john@gmail.com", "password"=>"[FILTERED]", "remember_me"=>"0"}, "commit"=>"Log in"}
+ [1m[36mUser Load (0.2ms)[0m [1m[34mSELECT "users".* FROM "users" WHERE "users"."email" = ? ORDER BY "users"."id" ASC LIMIT ?[0m [["email", "verified-john@gmail.com"], ["LIMIT", 1]]
+ [1m[35m (0.1ms)[0m [1m[35mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.5ms)[0m [1m[33mUPDATE "users" SET "current_sign_in_at" = ?, "last_sign_in_at" = ?, "current_sign_in_ip" = ?, "last_sign_in_ip" = ?, "sign_in_count" = ?, "updated_at" = ? WHERE "users"."id" = ?[0m [["current_sign_in_at", 2016-12-10 15:01:37 UTC], ["last_sign_in_at", 2016-12-10 15:01:37 UTC], ["current_sign_in_ip", "127.0.0.1"], ["last_sign_in_ip", "127.0.0.1"], ["sign_in_count", 1], ["updated_at", 2016-12-10 15:01:37 UTC], ["id", 778254699]]
+ [1m[35m (0.2ms)[0m [1m[35mRELEASE SAVEPOINT active_record_1[0m
+Redirected to http://www.example.com/
+Completed 302 Found in 20ms (ActiveRecord: 1.0ms)
+Started GET "/" for 127.0.0.1 at 2016-12-10 13:01:37 -0200
+Processing by HomeController#index as HTML
+ [1m[36mUser Load (0.2ms)[0m [1m[34mSELECT "users".* FROM "users" WHERE "users"."id" = ? ORDER BY "users"."id" ASC LIMIT ?[0m [["id", 778254699], ["LIMIT", 1]]
+ Rendering home/index.html.erb within layouts/application
+ Rendered home/index.html.erb within layouts/application (0.3ms)
+Completed 200 OK in 8ms (Views: 5.5ms | ActiveRecord: 0.2ms)
+Started GET "/" for 127.0.0.1 at 2016-12-10 13:01:37 -0200
+Processing by HomeController#index as HTML
+ [1m[36mUser Load (0.2ms)[0m [1m[34mSELECT "users".* FROM "users" WHERE "users"."id" = ? ORDER BY "users"."id" ASC LIMIT ?[0m [["id", 778254699], ["LIMIT", 1]]
+ Rendering home/index.html.erb within layouts/application
+ Rendered home/index.html.erb within layouts/application (0.3ms)
+Completed 200 OK in 8ms (Views: 5.7ms | ActiveRecord: 0.2ms)
+ [1m[35m (8.4ms)[0m [1m[31mrollback transaction[0m
+ [1m[35m (0.1ms)[0m [1m[36mbegin transaction[0m
+--------------------------------
+DeviseVerifiableTest: test_truth
+--------------------------------
+ [1m[35m (0.1ms)[0m [1m[31mrollback transaction[0m
+ [1m[35m (0.1ms)[0m [1m[36mbegin transaction[0m
+----------------------------------------------------
+VerifiableTest: test_asserting_when_user_is_verified
+----------------------------------------------------
+ [1m[35m (0.1ms)[0m [1m[31mrollback transaction[0m
+ [1m[35m (0.1ms)[0m [1m[36mbegin transaction[0m
+-----------------------------------------
+VerifiableTest: test_Devise_configuration
+-----------------------------------------
+ [1m[35m (0.1ms)[0m [1m[31mrollback transaction[0m
+ [1m[35m (0.1ms)[0m [1m[36mbegin transaction[0m
+--------------------------------------------------------------------
+VerifiableTest: test_adding_errors_for_empty_fields_for_verification
+--------------------------------------------------------------------
+ [1m[36mUser Load (0.3ms)[0m [1m[34mSELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT ?[0m [["id", 830138774], ["LIMIT", 1]]
+ [1m[35m (0.1ms)[0m [1m[31mrollback transaction[0m
+ [1m[35m (0.1ms)[0m [1m[36mbegin transaction[0m
+-----------------------------------------------------
+VerifiableTest: test_refuting_when_user_isnt_verified
+-----------------------------------------------------
+ [1m[35m (0.1ms)[0m [1m[31mrollback transaction[0m