test/dummy/log/test.log in phonelib-0.0.2 vs test/dummy/log/test.log in phonelib-0.1.0

- old
+ new

@@ -4897,5 +4897,4143 @@  (0.1ms) SAVEPOINT active_record_1  (0.1ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/phones/450723037 Completed 302 Found in 7ms (ActiveRecord: 0.2ms)  (0.1ms) rollback transaction +Connecting to database specified by database.yml +  (0.5ms) begin transaction + Fixture Delete (0.7ms) DELETE FROM "phones" + Fixture Insert (0.7ms) INSERT INTO "phones" ("number", "possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', '972541234567', '2013-02-12 05:46:15', '2013-02-12 05:46:15', 450723037) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "created_at", "updated_at", "id") VALUES ('wrong', '2013-02-12 05:46:15', '2013-02-12 05:46:15', 667262234) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "created_at", "updated_at", "id") VALUES ('972541234567', '2013-02-12 05:46:15', '2013-02-12 05:46:15', 512636273) + Fixture Insert (0.1ms) INSERT INTO "phones" ("possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', '2013-02-12 05:46:15', '2013-02-12 05:46:15', 23760034) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', 'wrong', '2013-02-12 05:46:15', '2013-02-12 05:46:15', 703612349) +  (1.9ms) commit transaction +  (0.1ms) begin transaction + Phone Load (0.4ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 512636273]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.0ms) SAVEPOINT active_record_1 + SQL (4.6ms) INSERT INTO "phones" ("created_at", "number", "possible_number", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Tue, 12 Feb 2013 05:46:17 UTC +00:00], ["number", "972541234567"], ["possible_number", nil], ["updated_at", Tue, 12 Feb 2013 05:46:17 UTC +00:00]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.8ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 23760034]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.1ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 667262234]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 703612349]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.1ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.2ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.1ms) SELECT COUNT(*) FROM "phones"  +Processing by PhonesController#create as HTML + Parameters: {"phone"=>{"number"=>"972541234567"}} +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.7ms) INSERT INTO "phones" ("created_at", "number", "possible_number", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Tue, 12 Feb 2013 05:46:17 UTC +00:00], ["number", "972541234567"], ["possible_number", nil], ["updated_at", Tue, 12 Feb 2013 05:46:17 UTC +00:00]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones/980190963 +Completed 302 Found in 8ms (ActiveRecord: 0.9ms) +  (0.1ms) SELECT COUNT(*) FROM "phones"  +  (0.9ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.2ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.1ms) SELECT COUNT(*) FROM "phones"  +Processing by PhonesController#destroy as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.4ms) DELETE FROM "phones" WHERE "phones"."id" = ? [["id", 450723037]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones +Completed 302 Found in 5ms (ActiveRecord: 0.6ms) +  (0.1ms) SELECT COUNT(*) FROM "phones" +  (0.8ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.2ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#edit as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] + Rendered phones/_form.html.erb (15.2ms) +Completed 200 OK in 94ms (Views: 92.2ms | ActiveRecord: 0.1ms) +  (0.1ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#index as HTML + Phone Load (0.2ms) SELECT "phones".* FROM "phones" +Completed 200 OK in 14ms (Views: 11.6ms | ActiveRecord: 0.2ms) +  (0.1ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#new as HTML + Rendered phones/_form.html.erb (3.5ms) +Completed 200 OK in 9ms (Views: 7.9ms | ActiveRecord: 0.0ms) +  (0.1ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#show as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +Completed 200 OK in 7ms (Views: 4.8ms | ActiveRecord: 0.1ms) +  (0.1ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.2ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#update as HTML + Parameters: {"phone"=>{"number"=>"972541234567"}, "id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones/450723037 +Completed 302 Found in 7ms (ActiveRecord: 0.3ms) +  (0.1ms) rollback transaction +Connecting to database specified by database.yml +  (0.4ms) begin transaction + Fixture Delete (0.4ms) DELETE FROM "phones" + Fixture Insert (0.3ms) INSERT INTO "phones" ("number", "possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', '972541234567', '2013-02-12 05:47:51', '2013-02-12 05:47:51', 450723037) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "created_at", "updated_at", "id") VALUES ('wrong', '2013-02-12 05:47:51', '2013-02-12 05:47:51', 667262234) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "created_at", "updated_at", "id") VALUES ('972541234567', '2013-02-12 05:47:51', '2013-02-12 05:47:51', 512636273) + Fixture Insert (0.1ms) INSERT INTO "phones" ("possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', '2013-02-12 05:47:51', '2013-02-12 05:47:51', 23760034) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', 'wrong', '2013-02-12 05:47:51', '2013-02-12 05:47:51', 703612349) +  (3.6ms) commit transaction +  (0.1ms) begin transaction + Phone Load (0.4ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 512636273]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) SAVEPOINT active_record_1 + SQL (1.9ms) INSERT INTO "phones" ("created_at", "number", "possible_number", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Tue, 12 Feb 2013 05:47:52 UTC +00:00], ["number", "972541234567"], ["possible_number", nil], ["updated_at", Tue, 12 Feb 2013 05:47:52 UTC +00:00]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (2.3ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.5ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 23760034]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.1ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 667262234]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 703612349]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.2ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.1ms) SELECT COUNT(*) FROM "phones"  +Processing by PhonesController#create as HTML + Parameters: {"phone"=>{"number"=>"972541234567"}} +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.6ms) INSERT INTO "phones" ("created_at", "number", "possible_number", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Tue, 12 Feb 2013 05:47:53 UTC +00:00], ["number", "972541234567"], ["possible_number", nil], ["updated_at", Tue, 12 Feb 2013 05:47:53 UTC +00:00]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones/980190963 +Completed 302 Found in 8ms (ActiveRecord: 0.8ms) +  (0.1ms) SELECT COUNT(*) FROM "phones"  +  (2.3ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.3ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.1ms) SELECT COUNT(*) FROM "phones"  +Processing by PhonesController#destroy as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.4ms) DELETE FROM "phones" WHERE "phones"."id" = ? [["id", 450723037]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones +Completed 302 Found in 4ms (ActiveRecord: 0.6ms) +  (0.1ms) SELECT COUNT(*) FROM "phones" +  (0.6ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#edit as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] + Rendered phones/_form.html.erb (60.2ms) +Completed 200 OK in 87ms (Views: 84.8ms | ActiveRecord: 0.1ms) +  (0.1ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.2ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#index as HTML + Phone Load (0.2ms) SELECT "phones".* FROM "phones" +Completed 200 OK in 13ms (Views: 10.8ms | ActiveRecord: 0.2ms) +  (0.1ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#new as HTML + Rendered phones/_form.html.erb (3.6ms) +Completed 200 OK in 9ms (Views: 8.1ms | ActiveRecord: 0.0ms) +  (0.1ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#show as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +Completed 200 OK in 7ms (Views: 4.8ms | ActiveRecord: 0.1ms) +  (0.1ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#update as HTML + Parameters: {"phone"=>{"number"=>"972541234567"}, "id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones/450723037 +Completed 302 Found in 7ms (ActiveRecord: 0.2ms) +  (0.1ms) rollback transaction +Connecting to database specified by database.yml +  (0.5ms) begin transaction + Fixture Delete (0.4ms) DELETE FROM "phones" + Fixture Insert (0.2ms) INSERT INTO "phones" ("number", "possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', '972541234567', '2013-02-12 05:48:14', '2013-02-12 05:48:14', 450723037) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "created_at", "updated_at", "id") VALUES ('wrong', '2013-02-12 05:48:14', '2013-02-12 05:48:14', 667262234) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "created_at", "updated_at", "id") VALUES ('972541234567', '2013-02-12 05:48:14', '2013-02-12 05:48:14', 512636273) + Fixture Insert (0.1ms) INSERT INTO "phones" ("possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', '2013-02-12 05:48:14', '2013-02-12 05:48:14', 23760034) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', 'wrong', '2013-02-12 05:48:14', '2013-02-12 05:48:14', 703612349) +  (3.4ms) commit transaction +  (0.1ms) begin transaction + Phone Load (0.4ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 512636273]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.0ms) SAVEPOINT active_record_1 + SQL (2.1ms) INSERT INTO "phones" ("created_at", "number", "possible_number", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Tue, 12 Feb 2013 05:48:15 UTC +00:00], ["number", "972541234567"], ["possible_number", nil], ["updated_at", Tue, 12 Feb 2013 05:48:15 UTC +00:00]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (2.4ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.2ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 23760034]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.1ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 667262234]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 703612349]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.1ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.1ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.2ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.3ms) SELECT COUNT(*) FROM "phones"  +Processing by PhonesController#create as HTML + Parameters: {"phone"=>{"number"=>"972541234567"}} +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.6ms) INSERT INTO "phones" ("created_at", "number", "possible_number", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Tue, 12 Feb 2013 05:48:15 UTC +00:00], ["number", "972541234567"], ["possible_number", nil], ["updated_at", Tue, 12 Feb 2013 05:48:15 UTC +00:00]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones/980190963 +Completed 302 Found in 8ms (ActiveRecord: 0.8ms) +  (0.1ms) SELECT COUNT(*) FROM "phones"  +  (2.0ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.2ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.1ms) SELECT COUNT(*) FROM "phones"  +Processing by PhonesController#destroy as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.4ms) DELETE FROM "phones" WHERE "phones"."id" = ? [["id", 450723037]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones +Completed 302 Found in 5ms (ActiveRecord: 0.6ms) +  (0.1ms) SELECT COUNT(*) FROM "phones" +  (0.8ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#edit as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] + Rendered phones/_form.html.erb (61.4ms) +Completed 200 OK in 87ms (Views: 85.4ms | ActiveRecord: 0.1ms) +  (0.1ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#index as HTML + Phone Load (0.2ms) SELECT "phones".* FROM "phones" +Completed 200 OK in 13ms (Views: 10.9ms | ActiveRecord: 0.2ms) +  (0.1ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.2ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#new as HTML + Rendered phones/_form.html.erb (3.5ms) +Completed 200 OK in 9ms (Views: 7.7ms | ActiveRecord: 0.0ms) +  (0.1ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.2ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#show as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +Completed 200 OK in 7ms (Views: 4.6ms | ActiveRecord: 0.1ms) +  (0.1ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.2ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#update as HTML + Parameters: {"phone"=>{"number"=>"972541234567"}, "id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones/450723037 +Completed 302 Found in 7ms (ActiveRecord: 0.2ms) +  (0.1ms) rollback transaction +Connecting to database specified by database.yml +  (0.4ms) begin transaction + Fixture Delete (0.4ms) DELETE FROM "phones" + Fixture Insert (0.2ms) INSERT INTO "phones" ("number", "possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', '972541234567', '2013-02-12 06:33:28', '2013-02-12 06:33:28', 450723037) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "created_at", "updated_at", "id") VALUES ('wrong', '2013-02-12 06:33:28', '2013-02-12 06:33:28', 667262234) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "created_at", "updated_at", "id") VALUES ('972541234567', '2013-02-12 06:33:28', '2013-02-12 06:33:28', 512636273) + Fixture Insert (0.1ms) INSERT INTO "phones" ("possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', '2013-02-12 06:33:28', '2013-02-12 06:33:28', 23760034) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', 'wrong', '2013-02-12 06:33:28', '2013-02-12 06:33:28', 703612349) +  (1.6ms) commit transaction +  (0.1ms) begin transaction + Phone Load (0.5ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 512636273]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.1ms) SAVEPOINT active_record_1 + SQL (1.9ms) INSERT INTO "phones" ("created_at", "number", "possible_number", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Tue, 12 Feb 2013 06:33:30 UTC +00:00], ["number", "972541234567"], ["possible_number", nil], ["updated_at", Tue, 12 Feb 2013 06:33:30 UTC +00:00]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (2.2ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.2ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.2ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 23760034]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.1ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 667262234]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 703612349]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.1ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.1ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.1ms) SELECT COUNT(*) FROM "phones"  +Processing by PhonesController#create as HTML + Parameters: {"phone"=>{"number"=>"972541234567"}} +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.6ms) INSERT INTO "phones" ("created_at", "number", "possible_number", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Tue, 12 Feb 2013 06:33:30 UTC +00:00], ["number", "972541234567"], ["possible_number", nil], ["updated_at", Tue, 12 Feb 2013 06:33:30 UTC +00:00]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones/980190963 +Completed 302 Found in 8ms (ActiveRecord: 0.7ms) +  (0.1ms) SELECT COUNT(*) FROM "phones"  +  (2.0ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.2ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.1ms) SELECT COUNT(*) FROM "phones"  +Processing by PhonesController#destroy as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.4ms) DELETE FROM "phones" WHERE "phones"."id" = ? [["id", 450723037]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones +Completed 302 Found in 5ms (ActiveRecord: 0.6ms) +  (0.1ms) SELECT COUNT(*) FROM "phones" +  (0.8ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#edit as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] + Rendered phones/_form.html.erb (63.7ms) +Completed 200 OK in 90ms (Views: 88.1ms | ActiveRecord: 0.1ms) +  (0.1ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#index as HTML + Phone Load (0.2ms) SELECT "phones".* FROM "phones" +Completed 200 OK in 13ms (Views: 10.9ms | ActiveRecord: 0.2ms) +  (0.1ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#new as HTML + Rendered phones/_form.html.erb (3.7ms) +Completed 200 OK in 9ms (Views: 8.1ms | ActiveRecord: 0.0ms) +  (0.1ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.2ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#show as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.2ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +Completed 200 OK in 7ms (Views: 4.6ms | ActiveRecord: 0.2ms) +  (0.1ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#update as HTML + Parameters: {"phone"=>{"number"=>"972541234567"}, "id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones/450723037 +Completed 302 Found in 8ms (ActiveRecord: 0.3ms) +  (0.1ms) rollback transaction +Connecting to database specified by database.yml +  (0.4ms) begin transaction + Fixture Delete (0.5ms) DELETE FROM "phones" + Fixture Insert (0.3ms) INSERT INTO "phones" ("number", "possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', '972541234567', '2013-02-12 06:33:53', '2013-02-12 06:33:53', 450723037) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "created_at", "updated_at", "id") VALUES ('wrong', '2013-02-12 06:33:53', '2013-02-12 06:33:53', 667262234) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "created_at", "updated_at", "id") VALUES ('972541234567', '2013-02-12 06:33:53', '2013-02-12 06:33:53', 512636273) + Fixture Insert (0.1ms) INSERT INTO "phones" ("possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', '2013-02-12 06:33:53', '2013-02-12 06:33:53', 23760034) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', 'wrong', '2013-02-12 06:33:53', '2013-02-12 06:33:53', 703612349) +  (5.2ms) commit transaction +  (0.1ms) begin transaction + Phone Load (1.0ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 512636273]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.0ms) SAVEPOINT active_record_1 + SQL (1.9ms) INSERT INTO "phones" ("created_at", "number", "possible_number", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Tue, 12 Feb 2013 06:33:54 UTC +00:00], ["number", "972541234567"], ["possible_number", nil], ["updated_at", Tue, 12 Feb 2013 06:33:54 UTC +00:00]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (2.3ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 23760034]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.1ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 667262234]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 703612349]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.2ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.1ms) SELECT COUNT(*) FROM "phones"  +Processing by PhonesController#create as HTML + Parameters: {"phone"=>{"number"=>"972541234567"}} +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.7ms) INSERT INTO "phones" ("created_at", "number", "possible_number", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Tue, 12 Feb 2013 06:33:55 UTC +00:00], ["number", "972541234567"], ["possible_number", nil], ["updated_at", Tue, 12 Feb 2013 06:33:55 UTC +00:00]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones/980190963 +Completed 302 Found in 8ms (ActiveRecord: 0.8ms) +  (0.1ms) SELECT COUNT(*) FROM "phones"  +  (2.4ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.2ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.1ms) SELECT COUNT(*) FROM "phones"  +Processing by PhonesController#destroy as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.4ms) DELETE FROM "phones" WHERE "phones"."id" = ? [["id", 450723037]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones +Completed 302 Found in 5ms (ActiveRecord: 0.7ms) +  (0.1ms) SELECT COUNT(*) FROM "phones" +  (0.8ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#edit as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] + Rendered phones/_form.html.erb (61.0ms) +Completed 200 OK in 88ms (Views: 86.0ms | ActiveRecord: 0.1ms) +  (0.1ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.2ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#index as HTML + Phone Load (0.2ms) SELECT "phones".* FROM "phones" +Completed 200 OK in 13ms (Views: 11.2ms | ActiveRecord: 0.2ms) +  (0.1ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#new as HTML + Rendered phones/_form.html.erb (3.5ms) +Completed 200 OK in 9ms (Views: 7.7ms | ActiveRecord: 0.0ms) +  (0.1ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.2ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#show as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +Completed 200 OK in 7ms (Views: 4.7ms | ActiveRecord: 0.1ms) +  (0.1ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.2ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#update as HTML + Parameters: {"phone"=>{"number"=>"972541234567"}, "id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones/450723037 +Completed 302 Found in 8ms (ActiveRecord: 0.2ms) +  (0.1ms) rollback transaction +Connecting to database specified by database.yml +  (0.4ms) begin transaction + Fixture Delete (0.4ms) DELETE FROM "phones" + Fixture Insert (0.3ms) INSERT INTO "phones" ("number", "possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', '972541234567', '2013-02-12 06:34:35', '2013-02-12 06:34:35', 450723037) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "created_at", "updated_at", "id") VALUES ('wrong', '2013-02-12 06:34:35', '2013-02-12 06:34:35', 667262234) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "created_at", "updated_at", "id") VALUES ('972541234567', '2013-02-12 06:34:35', '2013-02-12 06:34:35', 512636273) + Fixture Insert (0.1ms) INSERT INTO "phones" ("possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', '2013-02-12 06:34:35', '2013-02-12 06:34:35', 23760034) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', 'wrong', '2013-02-12 06:34:35', '2013-02-12 06:34:35', 703612349) +  (3.9ms) commit transaction +  (0.1ms) begin transaction + Phone Load (0.4ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 512636273]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.0ms) SAVEPOINT active_record_1 + SQL (1.9ms) INSERT INTO "phones" ("created_at", "number", "possible_number", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Tue, 12 Feb 2013 06:34:36 UTC +00:00], ["number", "972541234567"], ["possible_number", nil], ["updated_at", Tue, 12 Feb 2013 06:34:36 UTC +00:00]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (2.4ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.2ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.2ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 23760034]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.1ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 667262234]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 703612349]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.1ms) begin transaction +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.0ms) rollback transaction +  (0.1ms) begin transaction +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.1ms) SELECT COUNT(*) FROM "phones"  +Processing by PhonesController#create as HTML + Parameters: {"phone"=>{"number"=>"972541234567"}} +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.7ms) INSERT INTO "phones" ("created_at", "number", "possible_number", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Tue, 12 Feb 2013 06:34:36 UTC +00:00], ["number", "972541234567"], ["possible_number", nil], ["updated_at", Tue, 12 Feb 2013 06:34:36 UTC +00:00]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones/980190963 +Completed 302 Found in 8ms (ActiveRecord: 0.9ms) +  (0.1ms) SELECT COUNT(*) FROM "phones"  +  (2.3ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.3ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.1ms) SELECT COUNT(*) FROM "phones"  +Processing by PhonesController#destroy as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.4ms) DELETE FROM "phones" WHERE "phones"."id" = ? [["id", 450723037]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones +Completed 302 Found in 4ms (ActiveRecord: 0.6ms) +  (0.1ms) SELECT COUNT(*) FROM "phones" +  (0.8ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#edit as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] + Rendered phones/_form.html.erb (61.0ms) +Completed 200 OK in 88ms (Views: 86.4ms | ActiveRecord: 0.1ms) +  (0.1ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#index as HTML + Phone Load (0.2ms) SELECT "phones".* FROM "phones" +Completed 200 OK in 13ms (Views: 11.0ms | ActiveRecord: 0.2ms) +  (0.1ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#new as HTML + Rendered phones/_form.html.erb (3.5ms) +Completed 200 OK in 9ms (Views: 7.8ms | ActiveRecord: 0.0ms) +  (0.1ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.2ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#show as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +Completed 200 OK in 7ms (Views: 4.6ms | ActiveRecord: 0.1ms) +  (0.1ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#update as HTML + Parameters: {"phone"=>{"number"=>"972541234567"}, "id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones/450723037 +Completed 302 Found in 8ms (ActiveRecord: 0.2ms) +  (0.1ms) rollback transaction +Connecting to database specified by database.yml +  (0.5ms) begin transaction + Fixture Delete (0.4ms) DELETE FROM "phones" + Fixture Insert (0.3ms) INSERT INTO "phones" ("number", "possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', '972541234567', '2013-04-15 11:32:02', '2013-04-15 11:32:02', 450723037) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "created_at", "updated_at", "id") VALUES ('wrong', '2013-04-15 11:32:02', '2013-04-15 11:32:02', 667262234) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "created_at", "updated_at", "id") VALUES ('972541234567', '2013-04-15 11:32:02', '2013-04-15 11:32:02', 512636273) + Fixture Insert (0.1ms) INSERT INTO "phones" ("possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', '2013-04-15 11:32:02', '2013-04-15 11:32:02', 23760034) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', 'wrong', '2013-04-15 11:32:02', '2013-04-15 11:32:02', 703612349) +  (1.4ms) commit transaction +  (0.1ms) begin transaction + Phone Load (2.0ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 512636273]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) SAVEPOINT active_record_1 + SQL (5.7ms) INSERT INTO "phones" ("created_at", "number", "possible_number", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Mon, 15 Apr 2013 11:32:03 UTC +00:00], ["number", "972541234567"], ["possible_number", nil], ["updated_at", Mon, 15 Apr 2013 11:32:03 UTC +00:00]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.7ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 23760034]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.1ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 667262234]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 703612349]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.1ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.1ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.2ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.1ms) SELECT COUNT(*) FROM "phones"  +Processing by PhonesController#create as HTML + Parameters: {"phone"=>{"number"=>"972541234567"}} +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.5ms) INSERT INTO "phones" ("created_at", "number", "possible_number", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Mon, 15 Apr 2013 11:32:03 UTC +00:00], ["number", "972541234567"], ["possible_number", nil], ["updated_at", Mon, 15 Apr 2013 11:32:03 UTC +00:00]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones/980190963 +Completed 302 Found in 6ms (ActiveRecord: 0.6ms) +  (0.1ms) SELECT COUNT(*) FROM "phones"  +  (0.8ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.2ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.1ms) SELECT COUNT(*) FROM "phones"  +Processing by PhonesController#destroy as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.4ms) DELETE FROM "phones" WHERE "phones"."id" = ? [["id", 450723037]] +  (0.0ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones +Completed 302 Found in 4ms (ActiveRecord: 0.6ms) +  (0.1ms) SELECT COUNT(*) FROM "phones" +  (0.7ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#edit as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] + Rendered phones/_form.html.erb (10.7ms) +Completed 200 OK in 35ms (Views: 33.8ms | ActiveRecord: 0.1ms) +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#index as HTML + Phone Load (0.2ms) SELECT "phones".* FROM "phones" +Completed 200 OK in 9ms (Views: 7.3ms | ActiveRecord: 0.2ms) +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#new as HTML + Rendered phones/_form.html.erb (2.2ms) +Completed 200 OK in 6ms (Views: 5.3ms | ActiveRecord: 0.0ms) +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#show as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +Completed 200 OK in 5ms (Views: 3.1ms | ActiveRecord: 0.1ms) +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#update as HTML + Parameters: {"phone"=>{"number"=>"972541234567"}, "id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones/450723037 +Completed 302 Found in 5ms (ActiveRecord: 0.2ms) +  (0.1ms) rollback transaction +Connecting to database specified by database.yml +  (0.4ms) begin transaction + Fixture Delete (0.4ms) DELETE FROM "phones" + Fixture Insert (0.3ms) INSERT INTO "phones" ("number", "possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', '972541234567', '2013-04-15 12:07:20', '2013-04-15 12:07:20', 450723037) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "created_at", "updated_at", "id") VALUES ('wrong', '2013-04-15 12:07:20', '2013-04-15 12:07:20', 667262234) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "created_at", "updated_at", "id") VALUES ('972541234567', '2013-04-15 12:07:20', '2013-04-15 12:07:20', 512636273) + Fixture Insert (0.1ms) INSERT INTO "phones" ("possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', '2013-04-15 12:07:20', '2013-04-15 12:07:20', 23760034) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', 'wrong', '2013-04-15 12:07:20', '2013-04-15 12:07:20', 703612349) +  (1.8ms) commit transaction +  (0.0ms) begin transaction + Phone Load (2.0ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 512636273]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) SAVEPOINT active_record_1 + SQL (2.8ms) INSERT INTO "phones" ("created_at", "number", "possible_number", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Mon, 15 Apr 2013 12:07:21 UTC +00:00], ["number", "972541234567"], ["possible_number", nil], ["updated_at", Mon, 15 Apr 2013 12:07:21 UTC +00:00]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.6ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 23760034]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.1ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 667262234]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 703612349]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.1ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.2ms) rollback transaction +  (0.1ms) begin transaction +  (0.1ms) rollback transaction +  (0.2ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.1ms) SELECT COUNT(*) FROM "phones"  +Processing by PhonesController#create as HTML + Parameters: {"phone"=>{"number"=>"972541234567"}} +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.5ms) INSERT INTO "phones" ("created_at", "number", "possible_number", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Mon, 15 Apr 2013 12:07:21 UTC +00:00], ["number", "972541234567"], ["possible_number", nil], ["updated_at", Mon, 15 Apr 2013 12:07:21 UTC +00:00]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones/980190963 +Completed 302 Found in 7ms (ActiveRecord: 0.7ms) +  (0.1ms) SELECT COUNT(*) FROM "phones"  +  (0.9ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.2ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.1ms) SELECT COUNT(*) FROM "phones"  +Processing by PhonesController#destroy as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.4ms) DELETE FROM "phones" WHERE "phones"."id" = ? [["id", 450723037]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones +Completed 302 Found in 4ms (ActiveRecord: 0.6ms) +  (0.1ms) SELECT COUNT(*) FROM "phones" +  (2.2ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#edit as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] + Rendered phones/_form.html.erb (10.1ms) +Completed 200 OK in 31ms (Views: 29.7ms | ActiveRecord: 0.1ms) +  (0.1ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#index as HTML + Phone Load (0.2ms) SELECT "phones".* FROM "phones" +Completed 200 OK in 11ms (Views: 8.9ms | ActiveRecord: 0.2ms) +  (0.1ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#new as HTML + Rendered phones/_form.html.erb (2.4ms) +Completed 200 OK in 7ms (Views: 6.0ms | ActiveRecord: 0.0ms) +  (0.1ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.2ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#show as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +Completed 200 OK in 6ms (Views: 3.5ms | ActiveRecord: 0.1ms) +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#update as HTML + Parameters: {"phone"=>{"number"=>"972541234567"}, "id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones/450723037 +Completed 302 Found in 7ms (ActiveRecord: 0.2ms) +  (0.1ms) rollback transaction +Connecting to database specified by database.yml +  (0.4ms) begin transaction + Fixture Delete (0.3ms) DELETE FROM "phones" + Fixture Insert (0.3ms) INSERT INTO "phones" ("number", "possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', '972541234567', '2013-04-17 16:08:25', '2013-04-17 16:08:25', 450723037) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "created_at", "updated_at", "id") VALUES ('wrong', '2013-04-17 16:08:25', '2013-04-17 16:08:25', 667262234) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "created_at", "updated_at", "id") VALUES ('972541234567', '2013-04-17 16:08:25', '2013-04-17 16:08:25', 512636273) + Fixture Insert (0.1ms) INSERT INTO "phones" ("possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', '2013-04-17 16:08:25', '2013-04-17 16:08:25', 23760034) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', 'wrong', '2013-04-17 16:08:25', '2013-04-17 16:08:25', 703612349) +  (4.1ms) commit transaction +  (0.1ms) begin transaction + Phone Load (2.3ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 512636273]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) SAVEPOINT active_record_1 + SQL (1.8ms) INSERT INTO "phones" ("created_at", "number", "possible_number", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Wed, 17 Apr 2013 16:08:26 UTC +00:00], ["number", "972541234567"], ["possible_number", nil], ["updated_at", Wed, 17 Apr 2013 16:08:26 UTC +00:00]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (2.1ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) RELEASE SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 23760034]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.2ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 667262234]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.6ms) rollback transaction +  (0.3ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 703612349]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.1ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.1ms) begin transaction +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.1ms) SELECT COUNT(*) FROM "phones"  +Processing by PhonesController#create as HTML + Parameters: {"phone"=>{"number"=>"972541234567"}} +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.5ms) INSERT INTO "phones" ("created_at", "number", "possible_number", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Wed, 17 Apr 2013 16:08:26 UTC +00:00], ["number", "972541234567"], ["possible_number", nil], ["updated_at", Wed, 17 Apr 2013 16:08:26 UTC +00:00]] +  (0.0ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones/980190963 +Completed 302 Found in 6ms (ActiveRecord: 0.7ms) +  (0.2ms) SELECT COUNT(*) FROM "phones"  +  (2.7ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.2ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.1ms) SELECT COUNT(*) FROM "phones"  +Processing by PhonesController#destroy as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.4ms) DELETE FROM "phones" WHERE "phones"."id" = ? [["id", 450723037]] +  (0.0ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones +Completed 302 Found in 4ms (ActiveRecord: 0.6ms) +  (0.1ms) SELECT COUNT(*) FROM "phones" +  (0.8ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.2ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#edit as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] + Rendered phones/_form.html.erb (7.8ms) +Completed 200 OK in 28ms (Views: 26.7ms | ActiveRecord: 0.1ms) +  (0.1ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.2ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#index as HTML + Phone Load (0.2ms) SELECT "phones".* FROM "phones" +Completed 200 OK in 9ms (Views: 7.1ms | ActiveRecord: 0.2ms) +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.2ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#new as HTML + Rendered phones/_form.html.erb (2.3ms) +Completed 200 OK in 6ms (Views: 5.1ms | ActiveRecord: 0.0ms) +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#show as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +Completed 200 OK in 5ms (Views: 3.3ms | ActiveRecord: 0.1ms) +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#update as HTML + Parameters: {"phone"=>{"number"=>"972541234567"}, "id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones/450723037 +Completed 302 Found in 6ms (ActiveRecord: 0.2ms) +  (0.1ms) rollback transaction +Connecting to database specified by database.yml +  (0.5ms) begin transaction + Fixture Delete (0.4ms) DELETE FROM "phones" + Fixture Insert (0.3ms) INSERT INTO "phones" ("number", "possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', '972541234567', '2013-04-17 16:15:47', '2013-04-17 16:15:47', 450723037) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "created_at", "updated_at", "id") VALUES ('wrong', '2013-04-17 16:15:47', '2013-04-17 16:15:47', 667262234) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "created_at", "updated_at", "id") VALUES ('972541234567', '2013-04-17 16:15:47', '2013-04-17 16:15:47', 512636273) + Fixture Insert (0.1ms) INSERT INTO "phones" ("possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', '2013-04-17 16:15:47', '2013-04-17 16:15:47', 23760034) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', 'wrong', '2013-04-17 16:15:47', '2013-04-17 16:15:47', 703612349) +  (3.4ms) commit transaction +  (0.1ms) begin transaction + Phone Load (2.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 512636273]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) SAVEPOINT active_record_1 + SQL (1.6ms) INSERT INTO "phones" ("created_at", "number", "possible_number", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Wed, 17 Apr 2013 16:15:48 UTC +00:00], ["number", "972541234567"], ["possible_number", nil], ["updated_at", Wed, 17 Apr 2013 16:15:48 UTC +00:00]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (2.4ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 23760034]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.1ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 667262234]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 703612349]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.1ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.1ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.1ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.1ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.1ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.1ms) SELECT COUNT(*) FROM "phones"  +Processing by PhonesController#create as HTML + Parameters: {"phone"=>{"number"=>"972541234567"}} +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.5ms) INSERT INTO "phones" ("created_at", "number", "possible_number", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Wed, 17 Apr 2013 16:15:48 UTC +00:00], ["number", "972541234567"], ["possible_number", nil], ["updated_at", Wed, 17 Apr 2013 16:15:48 UTC +00:00]] +  (0.0ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones/980190963 +Completed 302 Found in 6ms (ActiveRecord: 0.7ms) +  (0.1ms) SELECT COUNT(*) FROM "phones"  +  (2.3ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.2ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.1ms) SELECT COUNT(*) FROM "phones"  +Processing by PhonesController#destroy as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.4ms) DELETE FROM "phones" WHERE "phones"."id" = ? [["id", 450723037]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones +Completed 302 Found in 4ms (ActiveRecord: 0.6ms) +  (0.1ms) SELECT COUNT(*) FROM "phones" +  (0.8ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#edit as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] + Rendered phones/_form.html.erb (8.3ms) +Completed 200 OK in 33ms (Views: 30.7ms | ActiveRecord: 0.1ms) +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#index as HTML + Phone Load (0.2ms) SELECT "phones".* FROM "phones" +Completed 200 OK in 10ms (Views: 8.3ms | ActiveRecord: 0.2ms) +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#new as HTML + Rendered phones/_form.html.erb (2.3ms) +Completed 200 OK in 6ms (Views: 5.1ms | ActiveRecord: 0.0ms) +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#show as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +Completed 200 OK in 5ms (Views: 3.2ms | ActiveRecord: 0.1ms) +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#update as HTML + Parameters: {"phone"=>{"number"=>"972541234567"}, "id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones/450723037 +Completed 302 Found in 5ms (ActiveRecord: 0.2ms) +  (0.1ms) rollback transaction +Connecting to database specified by database.yml +  (0.4ms) begin transaction + Fixture Delete (0.3ms) DELETE FROM "phones" + Fixture Insert (0.3ms) INSERT INTO "phones" ("number", "possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', '972541234567', '2013-04-17 16:48:21', '2013-04-17 16:48:21', 450723037) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "created_at", "updated_at", "id") VALUES ('wrong', '2013-04-17 16:48:21', '2013-04-17 16:48:21', 667262234) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "created_at", "updated_at", "id") VALUES ('972541234567', '2013-04-17 16:48:21', '2013-04-17 16:48:21', 512636273) + Fixture Insert (0.1ms) INSERT INTO "phones" ("possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', '2013-04-17 16:48:21', '2013-04-17 16:48:21', 23760034) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', 'wrong', '2013-04-17 16:48:21', '2013-04-17 16:48:21', 703612349) +  (2.9ms) commit transaction +  (0.1ms) begin transaction + Phone Load (2.0ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 512636273]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) SAVEPOINT active_record_1 + SQL (1.7ms) INSERT INTO "phones" ("created_at", "number", "possible_number", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Wed, 17 Apr 2013 16:48:22 UTC +00:00], ["number", "972541234567"], ["possible_number", nil], ["updated_at", Wed, 17 Apr 2013 16:48:22 UTC +00:00]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (2.8ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.2ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 23760034]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.1ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 667262234]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 703612349]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.1ms) SELECT COUNT(*) FROM "phones"  +Processing by PhonesController#create as HTML + Parameters: {"phone"=>{"number"=>"972541234567"}} +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.5ms) INSERT INTO "phones" ("created_at", "number", "possible_number", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Wed, 17 Apr 2013 16:48:22 UTC +00:00], ["number", "972541234567"], ["possible_number", nil], ["updated_at", Wed, 17 Apr 2013 16:48:22 UTC +00:00]] +  (0.0ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones/980190963 +Completed 302 Found in 49ms (ActiveRecord: 0.6ms) +  (0.1ms) SELECT COUNT(*) FROM "phones"  +  (2.1ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.1ms) SELECT COUNT(*) FROM "phones"  +Processing by PhonesController#destroy as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.3ms) DELETE FROM "phones" WHERE "phones"."id" = ? [["id", 450723037]] +  (0.0ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones +Completed 302 Found in 3ms (ActiveRecord: 0.5ms) +  (0.1ms) SELECT COUNT(*) FROM "phones" +  (0.8ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#edit as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] + Rendered phones/_form.html.erb (8.8ms) +Completed 200 OK in 30ms (Views: 28.2ms | ActiveRecord: 0.1ms) +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#index as HTML + Phone Load (0.1ms) SELECT "phones".* FROM "phones" +Completed 200 OK in 8ms (Views: 6.7ms | ActiveRecord: 0.1ms) +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#new as HTML + Rendered phones/_form.html.erb (2.5ms) +Completed 200 OK in 6ms (Views: 5.6ms | ActiveRecord: 0.0ms) +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#show as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +Completed 200 OK in 4ms (Views: 3.1ms | ActiveRecord: 0.1ms) +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#update as HTML + Parameters: {"phone"=>{"number"=>"972541234567"}, "id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones/450723037 +Completed 302 Found in 5ms (ActiveRecord: 0.2ms) +  (0.1ms) rollback transaction +Connecting to database specified by database.yml +  (0.4ms) begin transaction + Fixture Delete (0.4ms) DELETE FROM "phones" + Fixture Insert (0.2ms) INSERT INTO "phones" ("number", "possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', '972541234567', '2013-04-17 16:49:02', '2013-04-17 16:49:02', 450723037) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "created_at", "updated_at", "id") VALUES ('wrong', '2013-04-17 16:49:02', '2013-04-17 16:49:02', 667262234) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "created_at", "updated_at", "id") VALUES ('972541234567', '2013-04-17 16:49:02', '2013-04-17 16:49:02', 512636273) + Fixture Insert (0.1ms) INSERT INTO "phones" ("possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', '2013-04-17 16:49:02', '2013-04-17 16:49:02', 23760034) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', 'wrong', '2013-04-17 16:49:02', '2013-04-17 16:49:02', 703612349) +  (3.7ms) commit transaction +  (0.1ms) begin transaction + Phone Load (2.0ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 512636273]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) SAVEPOINT active_record_1 + SQL (1.7ms) INSERT INTO "phones" ("created_at", "number", "possible_number", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Wed, 17 Apr 2013 16:49:03 UTC +00:00], ["number", "972541234567"], ["possible_number", nil], ["updated_at", Wed, 17 Apr 2013 16:49:03 UTC +00:00]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (2.0ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 23760034]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.1ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 667262234]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 703612349]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.1ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.1ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.1ms) SELECT COUNT(*) FROM "phones"  +Processing by PhonesController#create as HTML + Parameters: {"phone"=>{"number"=>"972541234567"}} +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.7ms) INSERT INTO "phones" ("created_at", "number", "possible_number", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Wed, 17 Apr 2013 16:49:03 UTC +00:00], ["number", "972541234567"], ["possible_number", nil], ["updated_at", Wed, 17 Apr 2013 16:49:03 UTC +00:00]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones/980190963 +Completed 302 Found in 47ms (ActiveRecord: 0.8ms) +  (0.1ms) SELECT COUNT(*) FROM "phones"  +  (2.4ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.2ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.1ms) SELECT COUNT(*) FROM "phones"  +Processing by PhonesController#destroy as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.3ms) DELETE FROM "phones" WHERE "phones"."id" = ? [["id", 450723037]] +  (0.0ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones +Completed 302 Found in 3ms (ActiveRecord: 0.5ms) +  (0.1ms) SELECT COUNT(*) FROM "phones" +  (0.8ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#edit as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] + Rendered phones/_form.html.erb (8.4ms) +Completed 200 OK in 28ms (Views: 27.0ms | ActiveRecord: 0.1ms) +  (0.2ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.2ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#index as HTML + Phone Load (0.2ms) SELECT "phones".* FROM "phones" +Completed 200 OK in 8ms (Views: 6.7ms | ActiveRecord: 0.2ms) +  (0.1ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#new as HTML + Rendered phones/_form.html.erb (2.2ms) +Completed 200 OK in 6ms (Views: 5.2ms | ActiveRecord: 0.0ms) +  (0.1ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#show as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +Completed 200 OK in 5ms (Views: 3.2ms | ActiveRecord: 0.1ms) +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.2ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#update as HTML + Parameters: {"phone"=>{"number"=>"972541234567"}, "id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones/450723037 +Completed 302 Found in 6ms (ActiveRecord: 0.2ms) +  (0.1ms) rollback transaction +Connecting to database specified by database.yml +  (0.4ms) begin transaction + Fixture Delete (1.0ms) DELETE FROM "phones" + Fixture Insert (0.3ms) INSERT INTO "phones" ("number", "possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', '972541234567', '2013-04-18 16:08:37', '2013-04-18 16:08:37', 450723037) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "created_at", "updated_at", "id") VALUES ('wrong', '2013-04-18 16:08:37', '2013-04-18 16:08:37', 667262234) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "created_at", "updated_at", "id") VALUES ('972541234567', '2013-04-18 16:08:37', '2013-04-18 16:08:37', 512636273) + Fixture Insert (0.1ms) INSERT INTO "phones" ("possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', '2013-04-18 16:08:37', '2013-04-18 16:08:37', 23760034) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', 'wrong', '2013-04-18 16:08:37', '2013-04-18 16:08:37', 703612349) +  (1.4ms) commit transaction +  (0.0ms) begin transaction + Phone Load (7.6ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 512636273]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) SAVEPOINT active_record_1 + SQL (2.4ms) INSERT INTO "phones" ("created_at", "number", "possible_number", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Thu, 18 Apr 2013 16:08:38 UTC +00:00], ["number", "972541234567"], ["possible_number", nil], ["updated_at", Thu, 18 Apr 2013 16:08:38 UTC +00:00]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.8ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 23760034]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 667262234]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 703612349]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.1ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.1ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.2ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.1ms) SELECT COUNT(*) FROM "phones"  +Processing by PhonesController#create as HTML + Parameters: {"phone"=>{"number"=>"972541234567"}} +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.5ms) INSERT INTO "phones" ("created_at", "number", "possible_number", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Thu, 18 Apr 2013 16:08:38 UTC +00:00], ["number", "972541234567"], ["possible_number", nil], ["updated_at", Thu, 18 Apr 2013 16:08:38 UTC +00:00]] +  (0.0ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones/980190963 +Completed 302 Found in 6ms (ActiveRecord: 0.6ms) +  (0.1ms) SELECT COUNT(*) FROM "phones"  +  (0.7ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.1ms) SELECT COUNT(*) FROM "phones"  +Processing by PhonesController#destroy as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.3ms) DELETE FROM "phones" WHERE "phones"."id" = ? [["id", 450723037]] +  (0.0ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones +Completed 302 Found in 4ms (ActiveRecord: 0.5ms) +  (0.1ms) SELECT COUNT(*) FROM "phones" +  (0.8ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#edit as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] + Rendered phones/_form.html.erb (11.7ms) +Completed 200 OK in 38ms (Views: 36.4ms | ActiveRecord: 0.1ms) +  (0.1ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.2ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#index as HTML + Phone Load (0.2ms) SELECT "phones".* FROM "phones" +Completed 200 OK in 9ms (Views: 7.2ms | ActiveRecord: 0.2ms) +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#new as HTML + Rendered phones/_form.html.erb (2.2ms) +Completed 200 OK in 6ms (Views: 5.5ms | ActiveRecord: 0.0ms) +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#show as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +Completed 200 OK in 5ms (Views: 3.6ms | ActiveRecord: 0.1ms) +  (0.1ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.2ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#update as HTML + Parameters: {"phone"=>{"number"=>"972541234567"}, "id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones/450723037 +Completed 302 Found in 5ms (ActiveRecord: 0.2ms) +  (0.1ms) rollback transaction +Connecting to database specified by database.yml +  (0.4ms) begin transaction + Fixture Delete (0.4ms) DELETE FROM "phones" + Fixture Insert (0.3ms) INSERT INTO "phones" ("number", "possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', '972541234567', '2013-04-18 16:12:08', '2013-04-18 16:12:08', 450723037) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "created_at", "updated_at", "id") VALUES ('wrong', '2013-04-18 16:12:08', '2013-04-18 16:12:08', 667262234) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "created_at", "updated_at", "id") VALUES ('972541234567', '2013-04-18 16:12:08', '2013-04-18 16:12:08', 512636273) + Fixture Insert (0.1ms) INSERT INTO "phones" ("possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', '2013-04-18 16:12:08', '2013-04-18 16:12:08', 23760034) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', 'wrong', '2013-04-18 16:12:08', '2013-04-18 16:12:08', 703612349) +  (3.5ms) commit transaction +  (0.1ms) begin transaction + Phone Load (2.2ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 512636273]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) SAVEPOINT active_record_1 + SQL (1.6ms) INSERT INTO "phones" ("created_at", "number", "possible_number", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Thu, 18 Apr 2013 16:12:09 UTC +00:00], ["number", "972541234567"], ["possible_number", nil], ["updated_at", Thu, 18 Apr 2013 16:12:09 UTC +00:00]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (2.2ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 23760034]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 667262234]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 703612349]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.1ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.4ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.2ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.1ms) SELECT COUNT(*) FROM "phones"  +Processing by PhonesController#create as HTML + Parameters: {"phone"=>{"number"=>"972541234567"}} +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.5ms) INSERT INTO "phones" ("created_at", "number", "possible_number", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Thu, 18 Apr 2013 16:12:09 UTC +00:00], ["number", "972541234567"], ["possible_number", nil], ["updated_at", Thu, 18 Apr 2013 16:12:09 UTC +00:00]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones/980190963 +Completed 302 Found in 6ms (ActiveRecord: 0.7ms) +  (0.1ms) SELECT COUNT(*) FROM "phones"  +  (2.4ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.1ms) SELECT COUNT(*) FROM "phones"  +Processing by PhonesController#destroy as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.4ms) DELETE FROM "phones" WHERE "phones"."id" = ? [["id", 450723037]] +  (0.0ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones +Completed 302 Found in 3ms (ActiveRecord: 0.6ms) +  (0.1ms) SELECT COUNT(*) FROM "phones" +  (0.5ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.2ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#edit as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] + Rendered phones/_form.html.erb (7.7ms) +Completed 200 OK in 27ms (Views: 25.3ms | ActiveRecord: 0.1ms) +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#index as HTML + Phone Load (0.2ms) SELECT "phones".* FROM "phones" +Completed 200 OK in 8ms (Views: 6.6ms | ActiveRecord: 0.2ms) +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#new as HTML + Rendered phones/_form.html.erb (2.5ms) +Completed 200 OK in 7ms (Views: 5.9ms | ActiveRecord: 0.0ms) +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#show as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +Completed 200 OK in 5ms (Views: 3.0ms | ActiveRecord: 0.1ms) +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#update as HTML + Parameters: {"phone"=>{"number"=>"972541234567"}, "id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.0ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones/450723037 +Completed 302 Found in 5ms (ActiveRecord: 0.2ms) +  (0.1ms) rollback transaction +Connecting to database specified by database.yml +  (0.4ms) begin transaction + Fixture Delete (0.4ms) DELETE FROM "phones" + Fixture Insert (0.3ms) INSERT INTO "phones" ("number", "possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', '972541234567', '2013-04-18 16:14:00', '2013-04-18 16:14:00', 450723037) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "created_at", "updated_at", "id") VALUES ('wrong', '2013-04-18 16:14:00', '2013-04-18 16:14:00', 667262234) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "created_at", "updated_at", "id") VALUES ('972541234567', '2013-04-18 16:14:00', '2013-04-18 16:14:00', 512636273) + Fixture Insert (0.1ms) INSERT INTO "phones" ("possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', '2013-04-18 16:14:00', '2013-04-18 16:14:00', 23760034) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', 'wrong', '2013-04-18 16:14:00', '2013-04-18 16:14:00', 703612349) +  (4.0ms) commit transaction +  (0.0ms) begin transaction + Phone Load (2.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 512636273]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) SAVEPOINT active_record_1 + SQL (1.6ms) INSERT INTO "phones" ("created_at", "number", "possible_number", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Thu, 18 Apr 2013 16:14:01 UTC +00:00], ["number", "972541234567"], ["possible_number", nil], ["updated_at", Thu, 18 Apr 2013 16:14:01 UTC +00:00]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (2.0ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 23760034]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.1ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 667262234]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 703612349]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.1ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.1ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.1ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.1ms) SELECT COUNT(*) FROM "phones"  +Processing by PhonesController#create as HTML + Parameters: {"phone"=>{"number"=>"972541234567"}} +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.5ms) INSERT INTO "phones" ("created_at", "number", "possible_number", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Thu, 18 Apr 2013 16:14:01 UTC +00:00], ["number", "972541234567"], ["possible_number", nil], ["updated_at", Thu, 18 Apr 2013 16:14:01 UTC +00:00]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones/980190963 +Completed 302 Found in 6ms (ActiveRecord: 0.7ms) +  (0.1ms) SELECT COUNT(*) FROM "phones"  +  (2.2ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.1ms) SELECT COUNT(*) FROM "phones"  +Processing by PhonesController#destroy as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.3ms) DELETE FROM "phones" WHERE "phones"."id" = ? [["id", 450723037]] +  (0.0ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones +Completed 302 Found in 3ms (ActiveRecord: 0.5ms) +  (0.1ms) SELECT COUNT(*) FROM "phones" +  (0.8ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#edit as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] + Rendered phones/_form.html.erb (9.2ms) +Completed 200 OK in 30ms (Views: 28.3ms | ActiveRecord: 0.1ms) +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#index as HTML + Phone Load (0.2ms) SELECT "phones".* FROM "phones" +Completed 200 OK in 8ms (Views: 6.9ms | ActiveRecord: 0.2ms) +  (0.1ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.2ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#new as HTML + Rendered phones/_form.html.erb (2.3ms) +Completed 200 OK in 6ms (Views: 5.2ms | ActiveRecord: 0.0ms) +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#show as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +Completed 200 OK in 5ms (Views: 3.1ms | ActiveRecord: 0.1ms) +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#update as HTML + Parameters: {"phone"=>{"number"=>"972541234567"}, "id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones/450723037 +Completed 302 Found in 6ms (ActiveRecord: 0.2ms) +  (0.1ms) rollback transaction +Connecting to database specified by database.yml +  (0.5ms) begin transaction + Fixture Delete (0.3ms) DELETE FROM "phones" + Fixture Insert (0.3ms) INSERT INTO "phones" ("number", "possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', '972541234567', '2013-04-18 16:15:19', '2013-04-18 16:15:19', 450723037) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "created_at", "updated_at", "id") VALUES ('wrong', '2013-04-18 16:15:19', '2013-04-18 16:15:19', 667262234) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "created_at", "updated_at", "id") VALUES ('972541234567', '2013-04-18 16:15:19', '2013-04-18 16:15:19', 512636273) + Fixture Insert (0.1ms) INSERT INTO "phones" ("possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', '2013-04-18 16:15:19', '2013-04-18 16:15:19', 23760034) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', 'wrong', '2013-04-18 16:15:19', '2013-04-18 16:15:19', 703612349) +  (3.5ms) commit transaction +  (0.0ms) begin transaction + Phone Load (2.0ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 512636273]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) SAVEPOINT active_record_1 + SQL (1.8ms) INSERT INTO "phones" ("created_at", "number", "possible_number", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Thu, 18 Apr 2013 16:15:20 UTC +00:00], ["number", "972541234567"], ["possible_number", nil], ["updated_at", Thu, 18 Apr 2013 16:15:20 UTC +00:00]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (1.9ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 23760034]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.1ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 667262234]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 703612349]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.1ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.1ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.1ms) begin transaction +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.2ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.1ms) SELECT COUNT(*) FROM "phones"  +Processing by PhonesController#create as HTML + Parameters: {"phone"=>{"number"=>"972541234567"}} +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.5ms) INSERT INTO "phones" ("created_at", "number", "possible_number", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Thu, 18 Apr 2013 16:15:20 UTC +00:00], ["number", "972541234567"], ["possible_number", nil], ["updated_at", Thu, 18 Apr 2013 16:15:20 UTC +00:00]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones/980190963 +Completed 302 Found in 6ms (ActiveRecord: 0.6ms) +  (0.1ms) SELECT COUNT(*) FROM "phones"  +  (1.8ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.2ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.1ms) SELECT COUNT(*) FROM "phones"  +Processing by PhonesController#destroy as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.3ms) DELETE FROM "phones" WHERE "phones"."id" = ? [["id", 450723037]] +  (0.0ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones +Completed 302 Found in 3ms (ActiveRecord: 0.5ms) +  (0.1ms) SELECT COUNT(*) FROM "phones" +  (0.6ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#edit as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] + Rendered phones/_form.html.erb (10.1ms) +Completed 200 OK in 30ms (Views: 28.8ms | ActiveRecord: 0.1ms) +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#index as HTML + Phone Load (0.2ms) SELECT "phones".* FROM "phones" +Completed 200 OK in 9ms (Views: 7.4ms | ActiveRecord: 0.2ms) +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#new as HTML + Rendered phones/_form.html.erb (2.5ms) +Completed 200 OK in 7ms (Views: 5.9ms | ActiveRecord: 0.0ms) +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#show as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +Completed 200 OK in 5ms (Views: 3.3ms | ActiveRecord: 0.1ms) +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#update as HTML + Parameters: {"phone"=>{"number"=>"972541234567"}, "id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones/450723037 +Completed 302 Found in 6ms (ActiveRecord: 0.2ms) +  (0.1ms) rollback transaction +Connecting to database specified by database.yml +  (0.4ms) begin transaction + Fixture Delete (0.9ms) DELETE FROM "phones" + Fixture Insert (0.3ms) INSERT INTO "phones" ("number", "possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', '972541234567', '2013-04-18 16:44:37', '2013-04-18 16:44:37', 450723037) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "created_at", "updated_at", "id") VALUES ('wrong', '2013-04-18 16:44:37', '2013-04-18 16:44:37', 667262234) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "created_at", "updated_at", "id") VALUES ('972541234567', '2013-04-18 16:44:37', '2013-04-18 16:44:37', 512636273) + Fixture Insert (0.1ms) INSERT INTO "phones" ("possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', '2013-04-18 16:44:37', '2013-04-18 16:44:37', 23760034) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', 'wrong', '2013-04-18 16:44:37', '2013-04-18 16:44:37', 703612349) +  (1.8ms) commit transaction +  (0.0ms) begin transaction + Phone Load (2.3ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 512636273]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) SAVEPOINT active_record_1 + SQL (4.4ms) INSERT INTO "phones" ("created_at", "number", "possible_number", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Thu, 18 Apr 2013 16:44:38 UTC +00:00], ["number", "972541234567"], ["possible_number", nil], ["updated_at", Thu, 18 Apr 2013 16:44:38 UTC +00:00]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.8ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 23760034]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 667262234]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 703612349]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.1ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.0ms) rollback transaction +  (0.1ms) begin transaction +  (0.0ms) rollback transaction +  (0.1ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.1ms) SELECT COUNT(*) FROM "phones"  +Processing by PhonesController#create as HTML + Parameters: {"phone"=>{"number"=>"972541234567"}} +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.6ms) INSERT INTO "phones" ("created_at", "number", "possible_number", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Thu, 18 Apr 2013 16:44:39 UTC +00:00], ["number", "972541234567"], ["possible_number", nil], ["updated_at", Thu, 18 Apr 2013 16:44:39 UTC +00:00]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones/980190963 +Completed 302 Found in 6ms (ActiveRecord: 0.7ms) +  (0.1ms) SELECT COUNT(*) FROM "phones"  +  (0.8ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.1ms) SELECT COUNT(*) FROM "phones"  +Processing by PhonesController#destroy as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.3ms) DELETE FROM "phones" WHERE "phones"."id" = ? [["id", 450723037]] +  (0.0ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones +Completed 302 Found in 4ms (ActiveRecord: 0.5ms) +  (0.1ms) SELECT COUNT(*) FROM "phones" +  (0.8ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#edit as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] + Rendered phones/_form.html.erb (8.2ms) +Completed 200 OK in 33ms (Views: 31.1ms | ActiveRecord: 0.1ms) +  (0.1ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.2ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#index as HTML + Phone Load (0.2ms) SELECT "phones".* FROM "phones" +Completed 200 OK in 8ms (Views: 6.6ms | ActiveRecord: 0.2ms) +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#new as HTML + Rendered phones/_form.html.erb (2.2ms) +Completed 200 OK in 6ms (Views: 5.1ms | ActiveRecord: 0.0ms) +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#show as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +Completed 200 OK in 5ms (Views: 3.2ms | ActiveRecord: 0.1ms) +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#update as HTML + Parameters: {"phone"=>{"number"=>"972541234567"}, "id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones/450723037 +Completed 302 Found in 6ms (ActiveRecord: 0.2ms) +  (0.1ms) rollback transaction +Connecting to database specified by database.yml +  (0.5ms) begin transaction + Fixture Delete (0.9ms) DELETE FROM "phones" + Fixture Insert (0.3ms) INSERT INTO "phones" ("number", "possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', '972541234567', '2013-04-19 08:17:58', '2013-04-19 08:17:58', 450723037) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "created_at", "updated_at", "id") VALUES ('wrong', '2013-04-19 08:17:58', '2013-04-19 08:17:58', 667262234) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "created_at", "updated_at", "id") VALUES ('972541234567', '2013-04-19 08:17:58', '2013-04-19 08:17:58', 512636273) + Fixture Insert (0.1ms) INSERT INTO "phones" ("possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', '2013-04-19 08:17:58', '2013-04-19 08:17:58', 23760034) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', 'wrong', '2013-04-19 08:17:58', '2013-04-19 08:17:58', 703612349) +  (1.9ms) commit transaction +  (0.0ms) begin transaction + Phone Load (6.0ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 512636273]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.1ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.0ms) SAVEPOINT active_record_1 +  (0.2ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.2ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 23760034]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 667262234]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 703612349]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.1ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.4ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.1ms) SELECT COUNT(*) FROM "phones" +Processing by PhonesController#create as HTML + Parameters: {"phone"=>{"number"=>"972541234567"}} +  (0.1ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +Completed 500 Internal Server Error in 2ms +  (0.1ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.1ms) SELECT COUNT(*) FROM "phones" +Processing by PhonesController#destroy as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.4ms) DELETE FROM "phones" WHERE "phones"."id" = ? [["id", 450723037]] +  (0.0ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones +Completed 302 Found in 4ms (ActiveRecord: 0.6ms) +  (0.1ms) SELECT COUNT(*) FROM "phones"  +  (2.2ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#edit as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] + Rendered phones/_form.html.erb (13.2ms) +Completed 200 OK in 40ms (Views: 37.3ms | ActiveRecord: 0.1ms) +  (0.1ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.3ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#index as HTML + Phone Load (0.2ms) SELECT "phones".* FROM "phones"  +Completed 200 OK in 10ms (Views: 8.3ms | ActiveRecord: 0.2ms) +  (0.1ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#new as HTML + Rendered phones/_form.html.erb (2.5ms) +Completed 200 OK in 7ms (Views: 6.1ms | ActiveRecord: 0.0ms) +  (0.1ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#show as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +Completed 200 OK in 6ms (Views: 4.4ms | ActiveRecord: 0.1ms) +  (3.3ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#update as HTML + Parameters: {"phone"=>{"number"=>"972541234567"}, "id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.1ms) ROLLBACK TO SAVEPOINT active_record_1 +Completed 500 Internal Server Error in 3ms +  (0.1ms) rollback transaction +Connecting to database specified by database.yml +  (0.4ms) begin transaction + Fixture Delete (0.3ms) DELETE FROM "phones" + Fixture Insert (0.5ms) INSERT INTO "phones" ("number", "possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', '972541234567', '2013-04-19 08:20:05', '2013-04-19 08:20:05', 450723037) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "created_at", "updated_at", "id") VALUES ('wrong', '2013-04-19 08:20:05', '2013-04-19 08:20:05', 667262234) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "created_at", "updated_at", "id") VALUES ('972541234567', '2013-04-19 08:20:05', '2013-04-19 08:20:05', 512636273) + Fixture Insert (0.1ms) INSERT INTO "phones" ("possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', '2013-04-19 08:20:05', '2013-04-19 08:20:05', 23760034) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', 'wrong', '2013-04-19 08:20:05', '2013-04-19 08:20:05', 703612349) +  (3.2ms) commit transaction +  (0.0ms) begin transaction + Phone Load (2.2ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 512636273]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.1ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 23760034]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 667262234]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 703612349]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.1ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.1ms) SELECT COUNT(*) FROM "phones" +Processing by PhonesController#create as HTML + Parameters: {"phone"=>{"number"=>"972541234567"}} +  (0.1ms) SAVEPOINT active_record_1 +  (0.1ms) ROLLBACK TO SAVEPOINT active_record_1 +Completed 500 Internal Server Error in 42ms +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.1ms) SELECT COUNT(*) FROM "phones" +Processing by PhonesController#destroy as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.3ms) DELETE FROM "phones" WHERE "phones"."id" = ? [["id", 450723037]] +  (0.0ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones +Completed 302 Found in 3ms (ActiveRecord: 0.5ms) +  (0.1ms) SELECT COUNT(*) FROM "phones"  +  (2.3ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#edit as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] + Rendered phones/_form.html.erb (9.0ms) +Completed 200 OK in 30ms (Views: 28.4ms | ActiveRecord: 0.1ms) +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.2ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#index as HTML + Phone Load (0.2ms) SELECT "phones".* FROM "phones"  +Completed 200 OK in 9ms (Views: 7.3ms | ActiveRecord: 0.2ms) +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#new as HTML + Rendered phones/_form.html.erb (2.3ms) +Completed 200 OK in 6ms (Views: 5.0ms | ActiveRecord: 0.0ms) +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#show as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +Completed 200 OK in 4ms (Views: 3.0ms | ActiveRecord: 0.1ms) +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#update as HTML + Parameters: {"phone"=>{"number"=>"972541234567"}, "id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +Completed 500 Internal Server Error in 3ms +  (0.1ms) rollback transaction +Connecting to database specified by database.yml +  (0.4ms) begin transaction + Fixture Delete (0.3ms) DELETE FROM "phones" + Fixture Insert (0.3ms) INSERT INTO "phones" ("number", "possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', '972541234567', '2013-04-19 08:20:59', '2013-04-19 08:20:59', 450723037) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "created_at", "updated_at", "id") VALUES ('wrong', '2013-04-19 08:20:59', '2013-04-19 08:20:59', 667262234) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "created_at", "updated_at", "id") VALUES ('972541234567', '2013-04-19 08:20:59', '2013-04-19 08:20:59', 512636273) + Fixture Insert (0.1ms) INSERT INTO "phones" ("possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', '2013-04-19 08:20:59', '2013-04-19 08:20:59', 23760034) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', 'wrong', '2013-04-19 08:20:59', '2013-04-19 08:20:59', 703612349) +  (4.2ms) commit transaction +  (0.1ms) begin transaction + Phone Load (2.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 512636273]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) SAVEPOINT active_record_1 + SQL (1.6ms) INSERT INTO "phones" ("created_at", "number", "possible_number", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Fri, 19 Apr 2013 08:21:00 UTC +00:00], ["number", "972541234567"], ["possible_number", nil], ["updated_at", Fri, 19 Apr 2013 08:21:00 UTC +00:00]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (1.9ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) RELEASE SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 23760034]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 667262234]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 703612349]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.1ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.1ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.1ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.1ms) SELECT COUNT(*) FROM "phones"  +Processing by PhonesController#create as HTML + Parameters: {"phone"=>{"number"=>"972541234567"}} +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.5ms) INSERT INTO "phones" ("created_at", "number", "possible_number", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Fri, 19 Apr 2013 08:21:00 UTC +00:00], ["number", "972541234567"], ["possible_number", nil], ["updated_at", Fri, 19 Apr 2013 08:21:00 UTC +00:00]] +  (0.0ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones/980190963 +Completed 302 Found in 6ms (ActiveRecord: 0.7ms) +  (0.1ms) SELECT COUNT(*) FROM "phones"  +  (2.1ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.1ms) SELECT COUNT(*) FROM "phones"  +Processing by PhonesController#destroy as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.3ms) DELETE FROM "phones" WHERE "phones"."id" = ? [["id", 450723037]] +  (0.0ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones +Completed 302 Found in 3ms (ActiveRecord: 0.5ms) +  (0.1ms) SELECT COUNT(*) FROM "phones" +  (0.6ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#edit as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] + Rendered phones/_form.html.erb (7.7ms) +Completed 200 OK in 26ms (Views: 24.6ms | ActiveRecord: 0.1ms) +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#index as HTML + Phone Load (0.2ms) SELECT "phones".* FROM "phones" +Completed 200 OK in 8ms (Views: 6.6ms | ActiveRecord: 0.2ms) +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#new as HTML + Rendered phones/_form.html.erb (2.2ms) +Completed 200 OK in 6ms (Views: 5.2ms | ActiveRecord: 0.0ms) +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#show as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +Completed 200 OK in 5ms (Views: 3.2ms | ActiveRecord: 0.1ms) +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#update as HTML + Parameters: {"phone"=>{"number"=>"972541234567"}, "id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones/450723037 +Completed 302 Found in 5ms (ActiveRecord: 0.2ms) +  (0.1ms) rollback transaction +Connecting to database specified by database.yml +  (0.5ms) begin transaction + Fixture Delete (0.3ms) DELETE FROM "phones" + Fixture Insert (0.2ms) INSERT INTO "phones" ("number", "possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', '972541234567', '2013-04-19 08:23:52', '2013-04-19 08:23:52', 450723037) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "created_at", "updated_at", "id") VALUES ('wrong', '2013-04-19 08:23:52', '2013-04-19 08:23:52', 667262234) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "created_at", "updated_at", "id") VALUES ('972541234567', '2013-04-19 08:23:52', '2013-04-19 08:23:52', 512636273) + Fixture Insert (0.1ms) INSERT INTO "phones" ("possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', '2013-04-19 08:23:52', '2013-04-19 08:23:52', 23760034) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', 'wrong', '2013-04-19 08:23:52', '2013-04-19 08:23:52', 703612349) +  (3.5ms) commit transaction +  (0.0ms) begin transaction + Phone Load (2.0ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 512636273]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) SAVEPOINT active_record_1 + SQL (1.7ms) INSERT INTO "phones" ("created_at", "number", "possible_number", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Fri, 19 Apr 2013 08:23:53 UTC +00:00], ["number", "972541234567"], ["possible_number", nil], ["updated_at", Fri, 19 Apr 2013 08:23:53 UTC +00:00]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (2.5ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 23760034]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.1ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 667262234]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 703612349]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.1ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.1ms) SELECT COUNT(*) FROM "phones"  +Processing by PhonesController#create as HTML + Parameters: {"phone"=>{"number"=>"972541234567"}} +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.5ms) INSERT INTO "phones" ("created_at", "number", "possible_number", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Fri, 19 Apr 2013 08:23:53 UTC +00:00], ["number", "972541234567"], ["possible_number", nil], ["updated_at", Fri, 19 Apr 2013 08:23:53 UTC +00:00]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones/980190963 +Completed 302 Found in 6ms (ActiveRecord: 0.7ms) +  (0.1ms) SELECT COUNT(*) FROM "phones"  +  (2.2ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.1ms) SELECT COUNT(*) FROM "phones"  +Processing by PhonesController#destroy as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.3ms) DELETE FROM "phones" WHERE "phones"."id" = ? [["id", 450723037]] +  (0.0ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones +Completed 302 Found in 3ms (ActiveRecord: 0.5ms) +  (0.1ms) SELECT COUNT(*) FROM "phones" +  (0.8ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#edit as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] + Rendered phones/_form.html.erb (7.7ms) +Completed 200 OK in 27ms (Views: 25.0ms | ActiveRecord: 0.1ms) +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#index as HTML + Phone Load (0.1ms) SELECT "phones".* FROM "phones" +Completed 200 OK in 8ms (Views: 7.1ms | ActiveRecord: 0.1ms) +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#new as HTML + Rendered phones/_form.html.erb (2.4ms) +Completed 200 OK in 6ms (Views: 5.1ms | ActiveRecord: 0.0ms) +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#show as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +Completed 200 OK in 4ms (Views: 3.0ms | ActiveRecord: 0.1ms) +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#update as HTML + Parameters: {"phone"=>{"number"=>"972541234567"}, "id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones/450723037 +Completed 302 Found in 6ms (ActiveRecord: 0.2ms) +  (0.1ms) rollback transaction +Connecting to database specified by database.yml +  (0.4ms) begin transaction + Fixture Delete (0.3ms) DELETE FROM "phones" + Fixture Insert (0.2ms) INSERT INTO "phones" ("number", "possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', '972541234567', '2013-04-19 09:22:22', '2013-04-19 09:22:22', 450723037) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "created_at", "updated_at", "id") VALUES ('wrong', '2013-04-19 09:22:22', '2013-04-19 09:22:22', 667262234) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "created_at", "updated_at", "id") VALUES ('972541234567', '2013-04-19 09:22:22', '2013-04-19 09:22:22', 512636273) + Fixture Insert (0.1ms) INSERT INTO "phones" ("possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', '2013-04-19 09:22:22', '2013-04-19 09:22:22', 23760034) + Fixture Insert (0.2ms) INSERT INTO "phones" ("number", "possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', 'wrong', '2013-04-19 09:22:22', '2013-04-19 09:22:22', 703612349) +  (3.4ms) commit transaction +  (0.1ms) begin transaction + Phone Load (2.0ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 512636273]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) SAVEPOINT active_record_1 + SQL (1.7ms) INSERT INTO "phones" ("created_at", "number", "possible_number", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Fri, 19 Apr 2013 09:22:23 UTC +00:00], ["number", "972541234567"], ["possible_number", nil], ["updated_at", Fri, 19 Apr 2013 09:22:23 UTC +00:00]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (1.9ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 23760034]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.1ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 667262234]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 703612349]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.1ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.1ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.1ms) SELECT COUNT(*) FROM "phones"  +Processing by PhonesController#create as HTML + Parameters: {"phone"=>{"number"=>"972541234567"}} +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.6ms) INSERT INTO "phones" ("created_at", "number", "possible_number", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Fri, 19 Apr 2013 09:22:23 UTC +00:00], ["number", "972541234567"], ["possible_number", nil], ["updated_at", Fri, 19 Apr 2013 09:22:23 UTC +00:00]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones/980190963 +Completed 302 Found in 6ms (ActiveRecord: 0.7ms) +  (0.1ms) SELECT COUNT(*) FROM "phones"  +  (2.2ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.1ms) SELECT COUNT(*) FROM "phones"  +Processing by PhonesController#destroy as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.3ms) DELETE FROM "phones" WHERE "phones"."id" = ? [["id", 450723037]] +  (0.0ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones +Completed 302 Found in 3ms (ActiveRecord: 0.5ms) +  (0.1ms) SELECT COUNT(*) FROM "phones" +  (0.7ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#edit as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] + Rendered phones/_form.html.erb (7.8ms) +Completed 200 OK in 28ms (Views: 26.5ms | ActiveRecord: 0.1ms) +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#index as HTML + Phone Load (0.1ms) SELECT "phones".* FROM "phones" +Completed 200 OK in 8ms (Views: 6.4ms | ActiveRecord: 0.1ms) +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#new as HTML + Rendered phones/_form.html.erb (2.1ms) +Completed 200 OK in 5ms (Views: 4.8ms | ActiveRecord: 0.0ms) +  (0.1ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#show as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +Completed 200 OK in 4ms (Views: 3.0ms | ActiveRecord: 0.1ms) +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#update as HTML + Parameters: {"phone"=>{"number"=>"972541234567"}, "id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones/450723037 +Completed 302 Found in 6ms (ActiveRecord: 0.2ms) +  (0.1ms) rollback transaction +Connecting to database specified by database.yml +  (1.0ms) begin transaction + Fixture Delete (0.4ms) DELETE FROM "phones" + Fixture Insert (0.3ms) INSERT INTO "phones" ("number", "possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', '972541234567', '2013-04-19 09:23:32', '2013-04-19 09:23:32', 450723037) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "created_at", "updated_at", "id") VALUES ('wrong', '2013-04-19 09:23:32', '2013-04-19 09:23:32', 667262234) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "created_at", "updated_at", "id") VALUES ('972541234567', '2013-04-19 09:23:32', '2013-04-19 09:23:32', 512636273) + Fixture Insert (0.1ms) INSERT INTO "phones" ("possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', '2013-04-19 09:23:32', '2013-04-19 09:23:32', 23760034) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', 'wrong', '2013-04-19 09:23:32', '2013-04-19 09:23:32', 703612349) +  (3.2ms) commit transaction +  (0.1ms) begin transaction + Phone Load (2.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 512636273]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) SAVEPOINT active_record_1 + SQL (1.7ms) INSERT INTO "phones" ("created_at", "number", "possible_number", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Fri, 19 Apr 2013 09:23:33 UTC +00:00], ["number", "972541234567"], ["possible_number", nil], ["updated_at", Fri, 19 Apr 2013 09:23:33 UTC +00:00]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (2.5ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 23760034]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.1ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 667262234]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 703612349]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.1ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.1ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.1ms) SELECT COUNT(*) FROM "phones"  +Processing by PhonesController#create as HTML + Parameters: {"phone"=>{"number"=>"972541234567"}} +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.5ms) INSERT INTO "phones" ("created_at", "number", "possible_number", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Fri, 19 Apr 2013 09:23:33 UTC +00:00], ["number", "972541234567"], ["possible_number", nil], ["updated_at", Fri, 19 Apr 2013 09:23:33 UTC +00:00]] +  (0.0ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones/980190963 +Completed 302 Found in 6ms (ActiveRecord: 0.6ms) +  (0.1ms) SELECT COUNT(*) FROM "phones"  +  (2.0ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.1ms) SELECT COUNT(*) FROM "phones"  +Processing by PhonesController#destroy as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.3ms) DELETE FROM "phones" WHERE "phones"."id" = ? [["id", 450723037]] +  (0.0ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones +Completed 302 Found in 3ms (ActiveRecord: 0.5ms) +  (0.1ms) SELECT COUNT(*) FROM "phones" +  (0.8ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#edit as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] + Rendered phones/_form.html.erb (8.0ms) +Completed 200 OK in 28ms (Views: 27.1ms | ActiveRecord: 0.1ms) +  (0.1ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#index as HTML + Phone Load (0.1ms) SELECT "phones".* FROM "phones" +Completed 200 OK in 8ms (Views: 6.8ms | ActiveRecord: 0.1ms) +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#new as HTML + Rendered phones/_form.html.erb (2.2ms) +Completed 200 OK in 5ms (Views: 4.9ms | ActiveRecord: 0.0ms) +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#show as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +Completed 200 OK in 4ms (Views: 3.0ms | ActiveRecord: 0.1ms) +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#update as HTML + Parameters: {"phone"=>{"number"=>"972541234567"}, "id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones/450723037 +Completed 302 Found in 6ms (ActiveRecord: 0.2ms) +  (0.1ms) rollback transaction +Connecting to database specified by database.yml +  (0.4ms) begin transaction + Fixture Delete (0.3ms) DELETE FROM "phones" + Fixture Insert (0.5ms) INSERT INTO "phones" ("number", "possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', '972541234567', '2013-04-19 09:37:54', '2013-04-19 09:37:54', 450723037) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "created_at", "updated_at", "id") VALUES ('wrong', '2013-04-19 09:37:54', '2013-04-19 09:37:54', 667262234) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "created_at", "updated_at", "id") VALUES ('972541234567', '2013-04-19 09:37:54', '2013-04-19 09:37:54', 512636273) + Fixture Insert (0.1ms) INSERT INTO "phones" ("possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', '2013-04-19 09:37:54', '2013-04-19 09:37:54', 23760034) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', 'wrong', '2013-04-19 09:37:54', '2013-04-19 09:37:54', 703612349) +  (2.0ms) commit transaction +  (0.0ms) begin transaction + Phone Load (2.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 512636273]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) SAVEPOINT active_record_1 + SQL (1.6ms) INSERT INTO "phones" ("created_at", "number", "possible_number", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Fri, 19 Apr 2013 09:37:55 UTC +00:00], ["number", "972541234567"], ["possible_number", nil], ["updated_at", Fri, 19 Apr 2013 09:37:55 UTC +00:00]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.6ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) RELEASE SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 23760034]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.1ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 667262234]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 703612349]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.1ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.1ms) SELECT COUNT(*) FROM "phones"  +Processing by PhonesController#create as HTML + Parameters: {"phone"=>{"number"=>"972541234567"}} +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.5ms) INSERT INTO "phones" ("created_at", "number", "possible_number", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Fri, 19 Apr 2013 09:37:55 UTC +00:00], ["number", "972541234567"], ["possible_number", nil], ["updated_at", Fri, 19 Apr 2013 09:37:55 UTC +00:00]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones/980190963 +Completed 302 Found in 6ms (ActiveRecord: 0.7ms) +  (0.1ms) SELECT COUNT(*) FROM "phones"  +  (0.8ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.1ms) SELECT COUNT(*) FROM "phones"  +Processing by PhonesController#destroy as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.3ms) DELETE FROM "phones" WHERE "phones"."id" = ? [["id", 450723037]] +  (0.0ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones +Completed 302 Found in 3ms (ActiveRecord: 0.5ms) +  (0.1ms) SELECT COUNT(*) FROM "phones" +  (0.8ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#edit as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] + Rendered phones/_form.html.erb (7.8ms) +Completed 200 OK in 27ms (Views: 26.0ms | ActiveRecord: 0.1ms) +  (0.1ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#index as HTML + Phone Load (0.1ms) SELECT "phones".* FROM "phones" +Completed 200 OK in 8ms (Views: 6.5ms | ActiveRecord: 0.1ms) +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#new as HTML + Rendered phones/_form.html.erb (2.2ms) +Completed 200 OK in 6ms (Views: 5.0ms | ActiveRecord: 0.0ms) +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#show as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +Completed 200 OK in 4ms (Views: 3.0ms | ActiveRecord: 0.1ms) +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#update as HTML + Parameters: {"phone"=>{"number"=>"972541234567"}, "id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones/450723037 +Completed 302 Found in 6ms (ActiveRecord: 0.2ms) +  (0.1ms) rollback transaction +Connecting to database specified by database.yml +  (0.4ms) begin transaction + Fixture Delete (0.3ms) DELETE FROM "phones" + Fixture Insert (0.3ms) INSERT INTO "phones" ("number", "possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', '972541234567', '2013-04-19 09:41:04', '2013-04-19 09:41:04', 450723037) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "created_at", "updated_at", "id") VALUES ('wrong', '2013-04-19 09:41:04', '2013-04-19 09:41:04', 667262234) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "created_at", "updated_at", "id") VALUES ('972541234567', '2013-04-19 09:41:04', '2013-04-19 09:41:04', 512636273) + Fixture Insert (0.1ms) INSERT INTO "phones" ("possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', '2013-04-19 09:41:04', '2013-04-19 09:41:04', 23760034) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', 'wrong', '2013-04-19 09:41:04', '2013-04-19 09:41:04', 703612349) +  (3.9ms) commit transaction +  (0.1ms) begin transaction + Phone Load (2.0ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 512636273]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) SAVEPOINT active_record_1 + SQL (1.6ms) INSERT INTO "phones" ("created_at", "number", "possible_number", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Fri, 19 Apr 2013 09:41:05 UTC +00:00], ["number", "972541234567"], ["possible_number", nil], ["updated_at", Fri, 19 Apr 2013 09:41:05 UTC +00:00]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (2.2ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 23760034]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.1ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 667262234]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.2ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 703612349]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.1ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.2ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.1ms) SELECT COUNT(*) FROM "phones"  +Processing by PhonesController#create as HTML + Parameters: {"phone"=>{"number"=>"972541234567"}} +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.6ms) INSERT INTO "phones" ("created_at", "number", "possible_number", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Fri, 19 Apr 2013 09:41:05 UTC +00:00], ["number", "972541234567"], ["possible_number", nil], ["updated_at", Fri, 19 Apr 2013 09:41:05 UTC +00:00]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones/980190963 +Completed 302 Found in 6ms (ActiveRecord: 0.7ms) +  (0.1ms) SELECT COUNT(*) FROM "phones"  +  (2.0ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.1ms) SELECT COUNT(*) FROM "phones"  +Processing by PhonesController#destroy as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.3ms) DELETE FROM "phones" WHERE "phones"."id" = ? [["id", 450723037]] +  (0.0ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones +Completed 302 Found in 3ms (ActiveRecord: 0.5ms) +  (0.1ms) SELECT COUNT(*) FROM "phones" +  (0.6ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#edit as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] + Rendered phones/_form.html.erb (7.8ms) +Completed 200 OK in 27ms (Views: 25.3ms | ActiveRecord: 0.1ms) +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#index as HTML + Phone Load (0.2ms) SELECT "phones".* FROM "phones" +Completed 200 OK in 9ms (Views: 6.7ms | ActiveRecord: 0.2ms) +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#new as HTML + Rendered phones/_form.html.erb (2.2ms) +Completed 200 OK in 5ms (Views: 4.9ms | ActiveRecord: 0.0ms) +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#show as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +Completed 200 OK in 4ms (Views: 3.0ms | ActiveRecord: 0.1ms) +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#update as HTML + Parameters: {"phone"=>{"number"=>"972541234567"}, "id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones/450723037 +Completed 302 Found in 6ms (ActiveRecord: 0.2ms) +  (0.1ms) rollback transaction +Connecting to database specified by database.yml +  (0.6ms) begin transaction + Fixture Delete (0.7ms) DELETE FROM "phones" + Fixture Insert (0.4ms) INSERT INTO "phones" ("number", "possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', '972541234567', '2013-04-20 05:38:29', '2013-04-20 05:38:29', 450723037) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "created_at", "updated_at", "id") VALUES ('wrong', '2013-04-20 05:38:29', '2013-04-20 05:38:29', 667262234) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "created_at", "updated_at", "id") VALUES ('972541234567', '2013-04-20 05:38:29', '2013-04-20 05:38:29', 512636273) + Fixture Insert (0.1ms) INSERT INTO "phones" ("possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', '2013-04-20 05:38:29', '2013-04-20 05:38:29', 23760034) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', 'wrong', '2013-04-20 05:38:29', '2013-04-20 05:38:29', 703612349) +  (1.4ms) commit transaction +  (0.1ms) begin transaction + Phone Load (4.7ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 512636273]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) SAVEPOINT active_record_1 + SQL (4.6ms) INSERT INTO "phones" ("created_at", "number", "possible_number", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Sat, 20 Apr 2013 05:38:30 UTC +00:00], ["number", "972541234567"], ["possible_number", nil], ["updated_at", Sat, 20 Apr 2013 05:38:30 UTC +00:00]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.5ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) RELEASE SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 23760034]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 667262234]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 703612349]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.1ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.2ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.1ms) SELECT COUNT(*) FROM "phones"  +Processing by PhonesController#create as HTML + Parameters: {"phone"=>{"number"=>"972541234567"}} +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.5ms) INSERT INTO "phones" ("created_at", "number", "possible_number", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Sat, 20 Apr 2013 05:38:30 UTC +00:00], ["number", "972541234567"], ["possible_number", nil], ["updated_at", Sat, 20 Apr 2013 05:38:30 UTC +00:00]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones/980190963 +Completed 302 Found in 6ms (ActiveRecord: 0.7ms) +  (0.1ms) SELECT COUNT(*) FROM "phones"  +  (0.9ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.1ms) SELECT COUNT(*) FROM "phones"  +Processing by PhonesController#destroy as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.3ms) DELETE FROM "phones" WHERE "phones"."id" = ? [["id", 450723037]] +  (0.0ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones +Completed 302 Found in 3ms (ActiveRecord: 0.5ms) +  (0.1ms) SELECT COUNT(*) FROM "phones" +  (0.8ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#edit as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] + Rendered phones/_form.html.erb (10.6ms) +Completed 200 OK in 37ms (Views: 35.8ms | ActiveRecord: 0.1ms) +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#index as HTML + Phone Load (0.2ms) SELECT "phones".* FROM "phones" +Completed 200 OK in 9ms (Views: 7.3ms | ActiveRecord: 0.2ms) +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#new as HTML + Rendered phones/_form.html.erb (2.2ms) +Completed 200 OK in 6ms (Views: 5.8ms | ActiveRecord: 0.0ms) +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#show as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +Completed 200 OK in 5ms (Views: 3.8ms | ActiveRecord: 0.1ms) +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#update as HTML + Parameters: {"phone"=>{"number"=>"972541234567"}, "id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones/450723037 +Completed 302 Found in 8ms (ActiveRecord: 0.2ms) +  (0.1ms) rollback transaction +Connecting to database specified by database.yml +  (0.4ms) begin transaction + Fixture Delete (0.4ms) DELETE FROM "phones" + Fixture Insert (0.3ms) INSERT INTO "phones" ("number", "possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', '972541234567', '2013-04-20 05:49:44', '2013-04-20 05:49:44', 450723037) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "created_at", "updated_at", "id") VALUES ('wrong', '2013-04-20 05:49:44', '2013-04-20 05:49:44', 667262234) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "created_at", "updated_at", "id") VALUES ('972541234567', '2013-04-20 05:49:44', '2013-04-20 05:49:44', 512636273) + Fixture Insert (0.1ms) INSERT INTO "phones" ("possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', '2013-04-20 05:49:44', '2013-04-20 05:49:44', 23760034) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', 'wrong', '2013-04-20 05:49:44', '2013-04-20 05:49:44', 703612349) +  (4.2ms) commit transaction +  (0.1ms) begin transaction + Phone Load (2.2ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 512636273]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) SAVEPOINT active_record_1 + SQL (1.7ms) INSERT INTO "phones" ("created_at", "number", "possible_number", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Sat, 20 Apr 2013 05:49:45 UTC +00:00], ["number", "972541234567"], ["possible_number", nil], ["updated_at", Sat, 20 Apr 2013 05:49:45 UTC +00:00]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (2.8ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) RELEASE SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 23760034]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.1ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 667262234]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 703612349]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.1ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.1ms) SELECT COUNT(*) FROM "phones"  +Processing by PhonesController#create as HTML + Parameters: {"phone"=>{"number"=>"972541234567"}} +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.6ms) INSERT INTO "phones" ("created_at", "number", "possible_number", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Sat, 20 Apr 2013 05:49:45 UTC +00:00], ["number", "972541234567"], ["possible_number", nil], ["updated_at", Sat, 20 Apr 2013 05:49:45 UTC +00:00]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones/980190963 +Completed 302 Found in 7ms (ActiveRecord: 0.8ms) +  (0.1ms) SELECT COUNT(*) FROM "phones"  +  (2.3ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.2ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.1ms) SELECT COUNT(*) FROM "phones"  +Processing by PhonesController#destroy as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.3ms) DELETE FROM "phones" WHERE "phones"."id" = ? [["id", 450723037]] +  (0.0ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones +Completed 302 Found in 3ms (ActiveRecord: 0.5ms) +  (0.1ms) SELECT COUNT(*) FROM "phones" +  (0.8ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#edit as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] + Rendered phones/_form.html.erb (7.9ms) +Completed 200 OK in 27ms (Views: 25.5ms | ActiveRecord: 0.1ms) +  (0.1ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.2ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#index as HTML + Phone Load (0.2ms) SELECT "phones".* FROM "phones" +Completed 200 OK in 8ms (Views: 6.8ms | ActiveRecord: 0.2ms) +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#new as HTML + Rendered phones/_form.html.erb (2.2ms) +Completed 200 OK in 5ms (Views: 4.9ms | ActiveRecord: 0.0ms) +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#show as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +Completed 200 OK in 4ms (Views: 3.1ms | ActiveRecord: 0.1ms) +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.2ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#update as HTML + Parameters: {"phone"=>{"number"=>"972541234567"}, "id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones/450723037 +Completed 302 Found in 6ms (ActiveRecord: 0.2ms) +  (0.1ms) rollback transaction +Connecting to database specified by database.yml +  (0.5ms) begin transaction + Fixture Delete (0.3ms) DELETE FROM "phones" + Fixture Insert (0.2ms) INSERT INTO "phones" ("number", "possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', '972541234567', '2013-04-20 18:32:38', '2013-04-20 18:32:38', 450723037) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "created_at", "updated_at", "id") VALUES ('wrong', '2013-04-20 18:32:38', '2013-04-20 18:32:38', 667262234) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "created_at", "updated_at", "id") VALUES ('972541234567', '2013-04-20 18:32:38', '2013-04-20 18:32:38', 512636273) + Fixture Insert (0.1ms) INSERT INTO "phones" ("possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', '2013-04-20 18:32:38', '2013-04-20 18:32:38', 23760034) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', 'wrong', '2013-04-20 18:32:38', '2013-04-20 18:32:38', 703612349) +  (1.8ms) commit transaction +  (0.0ms) begin transaction + Phone Load (2.0ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 512636273]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) SAVEPOINT active_record_1 + SQL (4.1ms) INSERT INTO "phones" ("created_at", "number", "possible_number", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Sat, 20 Apr 2013 18:32:39 UTC +00:00], ["number", "972541234567"], ["possible_number", nil], ["updated_at", Sat, 20 Apr 2013 18:32:39 UTC +00:00]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.7ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.2ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 23760034]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 667262234]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.0ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.0ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 703612349]] +  (0.0ms) SAVEPOINT active_record_1 +  (0.1ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.3ms) begin transaction +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.2ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.1ms) rollback transaction +  (0.2ms) begin transaction +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.2ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.1ms) SELECT COUNT(*) FROM "phones"  +Processing by PhonesController#create as HTML + Parameters: {"phone"=>{"number"=>"972541234567"}} +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.6ms) INSERT INTO "phones" ("created_at", "number", "possible_number", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Sat, 20 Apr 2013 18:32:39 UTC +00:00], ["number", "972541234567"], ["possible_number", nil], ["updated_at", Sat, 20 Apr 2013 18:32:39 UTC +00:00]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones/980190963 +Completed 302 Found in 7ms (ActiveRecord: 0.7ms) +  (0.1ms) SELECT COUNT(*) FROM "phones"  +  (0.9ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +  (0.1ms) SELECT COUNT(*) FROM "phones"  +Processing by PhonesController#destroy as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +  (0.1ms) SAVEPOINT active_record_1 + SQL (0.3ms) DELETE FROM "phones" WHERE "phones"."id" = ? [["id", 450723037]] +  (0.0ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones +Completed 302 Found in 3ms (ActiveRecord: 0.5ms) +  (0.1ms) SELECT COUNT(*) FROM "phones" +  (0.6ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.2ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#edit as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] + Rendered phones/_form.html.erb (12.1ms) +Completed 200 OK in 38ms (Views: 36.5ms | ActiveRecord: 0.1ms) +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#index as HTML + Phone Load (0.2ms) SELECT "phones".* FROM "phones" +Completed 200 OK in 11ms (Views: 8.9ms | ActiveRecord: 0.2ms) +  (0.1ms) rollback transaction +  (0.0ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#new as HTML + Rendered phones/_form.html.erb (2.5ms) +Completed 200 OK in 8ms (Views: 7.8ms | ActiveRecord: 0.0ms) +  (0.1ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.2ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#show as HTML + Parameters: {"id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +Completed 200 OK in 5ms (Views: 3.5ms | ActiveRecord: 0.1ms) +  (0.1ms) rollback transaction +  (0.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 450723037]] +Processing by PhonesController#update as HTML + Parameters: {"phone"=>{"number"=>"972541234567"}, "id"=>"450723037"} + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", "450723037"]] +  (0.1ms) SAVEPOINT active_record_1 +  (0.1ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones/450723037 +Completed 302 Found in 6ms (ActiveRecord: 0.2ms) +  (0.1ms) rollback transaction