test/dummy/log/test.log in phonelib-0.2.3 vs test/dummy/log/test.log in phonelib-0.2.4

- old
+ new

@@ -5444,5 +5444,530 @@  (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.2ms) DELETE FROM "phones" + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', '972541234567', '2013-10-14 10:49:14', '2013-10-14 10:49:14', 450723037) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "created_at", "updated_at", "id") VALUES ('wrong', '2013-10-14 10:49:14', '2013-10-14 10:49:14', 667262234) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "created_at", "updated_at", "id") VALUES ('972541234567', '2013-10-14 10:49:14', '2013-10-14 10:49:14', 512636273) + Fixture Insert (0.1ms) INSERT INTO "phones" ("possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', '2013-10-14 10:49:14', '2013-10-14 10:49:14', 23760034) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', 'wrong', '2013-10-14 10:49:14', '2013-10-14 10:49:14', 703612349) +  (4.3ms) 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.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 (0.9ms) INSERT INTO "phones" ("created_at", "number", "possible_number", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Mon, 14 Oct 2013 10:49:14 UTC +00:00], ["number", "972541234567"], ["possible_number", nil], ["updated_at", Mon, 14 Oct 2013 10:49:14 UTC +00:00]] +  (0.0ms) 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", 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.0ms) 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 + 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.4ms) INSERT INTO "phones" ("created_at", "number", "possible_number", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Mon, 14 Oct 2013 10:49:14 UTC +00:00], ["number", "972541234567"], ["possible_number", nil], ["updated_at", Mon, 14 Oct 2013 10:49:14 UTC +00:00]] +  (0.0ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones/703612350 +Completed 302 Found in 4ms (ActiveRecord: 0.5ms) +  (0.1ms) SELECT COUNT(*) FROM "phones"  +  (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.2ms) 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.4ms) +  (0.1ms) SELECT COUNT(*) FROM "phones" +  (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#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 (2.9ms) +Completed 200 OK in 13ms (Views: 12.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 7ms (Views: 5.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 (1.9ms) +Completed 200 OK in 5ms (Views: 4.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 4ms (Views: 2.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#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 4ms (ActiveRecord: 0.2ms) +  (0.0ms) 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-10-16 15:35:45', '2013-10-16 15:35:45', 450723037) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "created_at", "updated_at", "id") VALUES ('wrong', '2013-10-16 15:35:45', '2013-10-16 15:35:45', 667262234) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "created_at", "updated_at", "id") VALUES ('972541234567', '2013-10-16 15:35:45', '2013-10-16 15:35:45', 512636273) + Fixture Insert (0.1ms) INSERT INTO "phones" ("possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', '2013-10-16 15:35:45', '2013-10-16 15:35:45', 23760034) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', 'wrong', '2013-10-16 15:35:45', '2013-10-16 15:35:45', 703612349) +  (12.3ms) commit transaction +  (0.1ms) begin transaction + Phone Load (0.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.1ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) SAVEPOINT active_record_1 + SQL (1.3ms) INSERT INTO "phones" ("created_at", "number", "possible_number", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Wed, 16 Oct 2013 15:35:45 UTC +00:00], ["number", "972541234567"], ["possible_number", nil], ["updated_at", Wed, 16 Oct 2013 15:35:45 UTC +00:00]] +  (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", 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.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 + 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.4ms) INSERT INTO "phones" ("created_at", "number", "possible_number", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Wed, 16 Oct 2013 15:35:45 UTC +00:00], ["number", "972541234567"], ["possible_number", nil], ["updated_at", Wed, 16 Oct 2013 15:35:45 UTC +00:00]] +  (0.0ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones/703612350 +Completed 302 Found in 5ms (ActiveRecord: 0.5ms) +  (0.1ms) SELECT COUNT(*) FROM "phones"  +  (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.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.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#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 (3.3ms) +Completed 200 OK in 18ms (Views: 16.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#index as HTML + Phone Load (0.2ms) SELECT "phones".* FROM "phones" +Completed 200 OK in 8ms (Views: 6.5ms | 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: 2.9ms | 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.6ms) begin transaction + Fixture Delete (0.3ms) DELETE FROM "phones" + Fixture Insert (0.4ms) INSERT INTO "phones" ("number", "possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', '972541234567', '2013-10-16 15:35:57', '2013-10-16 15:35:57', 450723037) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "created_at", "updated_at", "id") VALUES ('wrong', '2013-10-16 15:35:57', '2013-10-16 15:35:57', 667262234) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "created_at", "updated_at", "id") VALUES ('972541234567', '2013-10-16 15:35:57', '2013-10-16 15:35:57', 512636273) + Fixture Insert (0.1ms) INSERT INTO "phones" ("possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', '2013-10-16 15:35:57', '2013-10-16 15:35:57', 23760034) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', 'wrong', '2013-10-16 15:35:57', '2013-10-16 15:35:57', 703612349) +  (5.5ms) 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.1ms) SAVEPOINT active_record_1 +  (0.1ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.1ms) begin transaction +  (0.1ms) SAVEPOINT active_record_1 + SQL (1.6ms) INSERT INTO "phones" ("created_at", "number", "possible_number", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Wed, 16 Oct 2013 15:35:58 UTC +00:00], ["number", "972541234567"], ["possible_number", nil], ["updated_at", Wed, 16 Oct 2013 15:35:58 UTC +00:00]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +  (0.2ms) 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.3ms) 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.1ms) begin transaction + Phone Load (0.1ms) SELECT "phones".* FROM "phones" WHERE "phones"."id" = ? LIMIT 1 [["id", 667262234]] +  (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", 703612349]] +  (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.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", Wed, 16 Oct 2013 15:35:58 UTC +00:00], ["number", "972541234567"], ["possible_number", nil], ["updated_at", Wed, 16 Oct 2013 15:35:58 UTC +00:00]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones/703612350 +Completed 302 Found in 8ms (ActiveRecord: 0.7ms) +  (0.5ms) SELECT COUNT(*) FROM "phones"  +  (0.2ms) 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.5ms) 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 6ms (ActiveRecord: 0.8ms) +  (0.2ms) SELECT COUNT(*) FROM "phones" +  (0.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 (5.3ms) +Completed 200 OK in 27ms (Views: 24.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.3ms) SELECT "phones".* FROM "phones" +Completed 200 OK in 13ms (Views: 11.0ms | ActiveRecord: 0.3ms) +  (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 (4.1ms) +Completed 200 OK in 9ms (Views: 8.4ms | 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: 5.2ms | 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.3ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones/450723037 +Completed 302 Found in 9ms (ActiveRecord: 0.5ms) +  (0.1ms) rollback transaction +Connecting to database specified by database.yml +  (0.4ms) begin transaction + Fixture Delete (0.2ms) DELETE FROM "phones" + Fixture Insert (0.2ms) INSERT INTO "phones" ("number", "possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', '972541234567', '2013-10-16 15:44:32', '2013-10-16 15:44:32', 450723037) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "created_at", "updated_at", "id") VALUES ('wrong', '2013-10-16 15:44:32', '2013-10-16 15:44:32', 667262234) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "created_at", "updated_at", "id") VALUES ('972541234567', '2013-10-16 15:44:32', '2013-10-16 15:44:32', 512636273) + Fixture Insert (0.1ms) INSERT INTO "phones" ("possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', '2013-10-16 15:44:32', '2013-10-16 15:44:32', 23760034) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', 'wrong', '2013-10-16 15:44:32', '2013-10-16 15:44:32', 703612349) +  (4.4ms) 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.0ms) begin transaction +  (0.0ms) 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 + SQL (1.0ms) INSERT INTO "phones" ("created_at", "number", "possible_number", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Wed, 16 Oct 2013 15:44:32 UTC +00:00], ["number", "972541234567"], ["possible_number", nil], ["updated_at", Wed, 16 Oct 2013 15:44:32 UTC +00:00]] +  (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", 450723037]] +  (0.1ms) 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.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 + 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.4ms) INSERT INTO "phones" ("created_at", "number", "possible_number", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Wed, 16 Oct 2013 15:44:32 UTC +00:00], ["number", "972541234567"], ["possible_number", nil], ["updated_at", Wed, 16 Oct 2013 15:44:32 UTC +00:00]] +  (0.1ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones/703612350 +Completed 302 Found in 43ms (ActiveRecord: 0.5ms) +  (0.6ms) SELECT COUNT(*) FROM "phones"  +  (0.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.4ms) +  (0.1ms) SELECT COUNT(*) FROM "phones" +  (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#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 (3.5ms) +Completed 200 OK in 16ms (Views: 14.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#index as HTML + Phone Load (0.2ms) SELECT "phones".* FROM "phones" +Completed 200 OK in 8ms (Views: 6.5ms | 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 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 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) 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.2ms) DELETE FROM "phones" + Fixture Insert (0.2ms) INSERT INTO "phones" ("number", "possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', '972541234567', '2013-10-16 15:45:51', '2013-10-16 15:45:51', 450723037) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "created_at", "updated_at", "id") VALUES ('wrong', '2013-10-16 15:45:51', '2013-10-16 15:45:51', 667262234) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "created_at", "updated_at", "id") VALUES ('972541234567', '2013-10-16 15:45:51', '2013-10-16 15:45:51', 512636273) + Fixture Insert (0.1ms) INSERT INTO "phones" ("possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', '2013-10-16 15:45:51', '2013-10-16 15:45:51', 23760034) + Fixture Insert (0.1ms) INSERT INTO "phones" ("number", "possible_number", "created_at", "updated_at", "id") VALUES ('972541234567', 'wrong', '2013-10-16 15:45:51', '2013-10-16 15:45:51', 703612349) +  (3.6ms) commit transaction +  (0.1ms) begin transaction + Phone Load (0.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.1ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.1ms) rollback transaction +  (0.0ms) begin transaction +  (0.0ms) SAVEPOINT active_record_1 + SQL (1.0ms) INSERT INTO "phones" ("created_at", "number", "possible_number", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Wed, 16 Oct 2013 15:45:51 UTC +00:00], ["number", "972541234567"], ["possible_number", nil], ["updated_at", Wed, 16 Oct 2013 15:45:51 UTC +00:00]] +  (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", 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 + 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.4ms) INSERT INTO "phones" ("created_at", "number", "possible_number", "updated_at") VALUES (?, ?, ?, ?) [["created_at", Wed, 16 Oct 2013 15:45:51 UTC +00:00], ["number", "972541234567"], ["possible_number", nil], ["updated_at", Wed, 16 Oct 2013 15:45:51 UTC +00:00]] +  (0.0ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/phones/703612350 +Completed 302 Found in 43ms (ActiveRecord: 0.5ms) +  (0.2ms) SELECT COUNT(*) FROM "phones"  +  (0.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.2ms) 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.4ms) +  (0.1ms) SELECT COUNT(*) FROM "phones" +  (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#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 (3.4ms) +Completed 200 OK in 15ms (Views: 14.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.2ms) SELECT "phones".* FROM "phones" +Completed 200 OK in 8ms (Views: 6.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.3ms) +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: 2.9ms | 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