DEPRECATION WARNING: config.action_view.debug_rjs will be removed in 3.1, from 3.1 onwards you will need to install prototype-rails to continue to use RJS templates . (called from service at /Users/joe/.rvm/rubies/ruby-1.9.2-p180/lib/ruby/1.9.1/webrick/httpserver.rb:111)
  [1m[36mSQL (0.5ms)[0m  [1m SELECT name
 FROM sqlite_master
 WHERE type = 'table' AND NOT name = 'sqlite_sequence'
[0m
  [1m[35mSQL (0.2ms)[0m  select sqlite_version(*)
  [1m[36mSQL (2.0ms)[0m  [1mCREATE TABLE "schema_migrations" ("version" varchar(255) NOT NULL) [0m
  [1m[35mSQL (0.0ms)[0m  PRAGMA index_list("schema_migrations")
  [1m[36mSQL (2.4ms)[0m  [1mCREATE UNIQUE INDEX "unique_schema_migrations" ON "schema_migrations" ("version")[0m
  [1m[35mSQL (0.1ms)[0m   SELECT name
 FROM sqlite_master
 WHERE type = 'table' AND NOT name = 'sqlite_sequence'
  [1m[36mSQL (0.1ms)[0m  [1m SELECT name
 FROM sqlite_master
 WHERE type = 'table' AND NOT name = 'sqlite_sequence'
[0m
  [1m[35mSQL (0.1ms)[0m  SELECT "schema_migrations"."version" FROM "schema_migrations"
Migrating to CreateShouts (20120311210010)
  [1m[36mSQL (0.5ms)[0m  [1mCREATE TABLE "shouts" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "name" varchar(255), "shout_date" date, "shout_message" varchar(255), "created_at" datetime, "updated_at" datetime) [0m
  [1m[35mSQL (0.1ms)[0m  INSERT INTO "schema_migrations" ("version") VALUES ('20120311210010')
  [1m[36mSQL (0.4ms)[0m  [1m SELECT name
 FROM sqlite_master
 WHERE type = 'table' AND NOT name = 'sqlite_sequence'
[0m
  [1m[35mSQL (0.2ms)[0m  SELECT "schema_migrations"."version" FROM "schema_migrations"
  [1m[36mSQL (0.2ms)[0m  [1m SELECT name
 FROM sqlite_master
 WHERE type = 'table' AND NOT name = 'sqlite_sequence'
[0m
  [1m[35mSQL (0.1ms)[0m  PRAGMA index_list("shouts")
DEPRECATION WARNING: config.action_view.debug_rjs will be removed in 3.1, from 3.1 onwards you will need to install prototype-rails to continue to use RJS templates . (called from service at /Users/joe/.rvm/rubies/ruby-1.9.2-p180/lib/ruby/1.9.1/webrick/httpserver.rb:111)
DEPRECATION WARNING: config.action_view.debug_rjs will be removed in 3.1, from 3.1 onwards you will need to install prototype-rails to continue to use RJS templates . (called from service at /Users/joe/.rvm/rubies/ruby-1.9.2-p180/lib/ruby/1.9.1/webrick/httpserver.rb:111)


Started GET "/" for 127.0.0.1 at 2012-03-11 15:07:07 -0600
  Processing by ShoutsController#index as HTML
  [1m[36mShout Load (18.3ms)[0m  [1mSELECT "shouts".* FROM "shouts"[0m
Rendered shouts/index.html.erb within layouts/application (18.6ms)
Completed 200 OK in 167ms (Views: 58.6ms | ActiveRecord: 18.3ms)


Started GET "/shouts/new" for 127.0.0.1 at 2012-03-11 15:11:56 -0600
  Processing by ShoutsController#new as HTML
Rendered shouts/_form.html.erb (1074.8ms)
Rendered shouts/new.html.erb within layouts/application (1138.3ms)
Completed 200 OK in 1344ms (Views: 1242.3ms | ActiveRecord: 0.0ms)


Started POST "/shouts" for 127.0.0.1 at 2012-03-11 15:13:18 -0600
  Processing by ShoutsController#create as HTML
  Parameters: {"utf8"=>"✓", "authenticity_token"=>"feM637KoiZqnG6jQNRDh2BnipfIPOr1q4xxvvRsrFh0=", "shout"=>{"name"=>"Joe", "shout_date(1i)"=>"2012", "shout_date(2i)"=>"3", "shout_date(3i)"=>"11", "shout_message"=>"My first shout!"}, "commit"=>"Create Shout"}
  [1m[35mSQL (0.2ms)[0m   SELECT name
 FROM sqlite_master
 WHERE type = 'table' AND NOT name = 'sqlite_sequence'
  [1m[36mAREL (34.8ms)[0m  [1mINSERT INTO "shouts" ("name", "shout_date", "shout_message", "created_at", "updated_at") VALUES ('Joe', '2012-03-11', 'My first shout!', '2012-03-11 21:13:18.843797', '2012-03-11 21:13:18.843797')[0m
Redirected to http://0.0.0.0:3000/shouts/1
Completed 302 Found in 277ms


Started GET "/shouts/1" for 127.0.0.1 at 2012-03-11 15:13:27 -0600
  Processing by ShoutsController#show as HTML
  Parameters: {"id"=>"1"}
  [1m[35mShout Load (0.2ms)[0m  SELECT "shouts".* FROM "shouts" WHERE "shouts"."id" = 1 LIMIT 1
Rendered shouts/show.html.erb within layouts/application (11.1ms)
Completed 200 OK in 66ms (Views: 55.7ms | ActiveRecord: 35.3ms)


Started GET "/shouts" for 127.0.0.1 at 2012-03-11 15:13:50 -0600
  Processing by ShoutsController#index as HTML
  [1m[36mShout Load (0.4ms)[0m  [1mSELECT "shouts".* FROM "shouts"[0m
Rendered shouts/index.html.erb within layouts/application (12.9ms)
Completed 200 OK in 103ms (Views: 95.4ms | ActiveRecord: 0.4ms)
  [1m[36mSQL (0.7ms)[0m  [1m SELECT name
 FROM sqlite_master
 WHERE type = 'table' AND NOT name = 'sqlite_sequence'
[0m
  [1m[35mSQL (0.1ms)[0m   SELECT name
 FROM sqlite_master
 WHERE type = 'table' AND NOT name = 'sqlite_sequence'
  [1m[36mSQL (0.6ms)[0m  [1mSELECT "schema_migrations"."version" FROM "schema_migrations"[0m
Migrating to CreateShouts (20120311210010)
Migrating to CreateDevices (20120311212505)
  [1m[35mSQL (0.1ms)[0m  select sqlite_version(*)
  [1m[36mSQL (0.7ms)[0m  [1mCREATE TABLE "devices" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "name" varchar(255), "token" varchar(255), "created_at" datetime, "updated_at" datetime) [0m
  [1m[35mSQL (0.5ms)[0m  INSERT INTO "schema_migrations" ("version") VALUES ('20120311212505')
  [1m[36mSQL (0.3ms)[0m  [1m SELECT name
 FROM sqlite_master
 WHERE type = 'table' AND NOT name = 'sqlite_sequence'
[0m
  [1m[35mSQL (0.2ms)[0m  SELECT "schema_migrations"."version" FROM "schema_migrations"
  [1m[36mSQL (0.2ms)[0m  [1m SELECT name
 FROM sqlite_master
 WHERE type = 'table' AND NOT name = 'sqlite_sequence'
[0m
  [1m[35mSQL (0.1ms)[0m  PRAGMA index_list("devices")
  [1m[36mSQL (0.1ms)[0m  [1mPRAGMA index_list("shouts")[0m
  [1m[36mSQL (0.7ms)[0m  [1m SELECT name
 FROM sqlite_master
 WHERE type = 'table' AND NOT name = 'sqlite_sequence'
[0m
  [1m[35mSQL (0.2ms)[0m   SELECT name
 FROM sqlite_master
 WHERE type = 'table' AND NOT name = 'sqlite_sequence'
  [1m[36mSQL (24.9ms)[0m  [1mSELECT "schema_migrations"."version" FROM "schema_migrations"[0m
Migrating to CreateShouts (20120311210010)
Migrating to CreateDevices (20120311212505)
  [1m[35mSQL (0.1ms)[0m  select sqlite_version(*)
  [1m[36mSQL (0.2ms)[0m  [1m SELECT name
 FROM sqlite_master
 WHERE type = 'table' AND NOT name = 'sqlite_sequence'
[0m
  [1m[35mSQL (0.1ms)[0m  SELECT "schema_migrations"."version" FROM "schema_migrations"
  [1m[36mSQL (0.1ms)[0m  [1m SELECT name
 FROM sqlite_master
 WHERE type = 'table' AND NOT name = 'sqlite_sequence'
[0m
  [1m[35mSQL (0.0ms)[0m  PRAGMA index_list("devices")
  [1m[36mSQL (0.0ms)[0m  [1mPRAGMA index_list("shouts")[0m
  [1m[36mSQL (0.6ms)[0m  [1m SELECT name
 FROM sqlite_master
 WHERE type = 'table' AND NOT name = 'sqlite_sequence'
[0m
  [1m[35mSQL (0.2ms)[0m   SELECT name
 FROM sqlite_master
 WHERE type = 'table' AND NOT name = 'sqlite_sequence'
  [1m[36mSQL (0.2ms)[0m  [1mSELECT "schema_migrations"."version" FROM "schema_migrations"[0m
Migrating to CreateShouts (20120311210010)
Migrating to CreateDevices (20120311212505)
Migrating to CreateApnDevices (20120312032431)
  [1m[35mSQL (0.1ms)[0m  select sqlite_version(*)
  [1m[36mSQL (0.5ms)[0m  [1mCREATE TABLE "apn_devices" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "token" text NOT NULL, "created_at" datetime, "updated_at" datetime) [0m
  [1m[35mSQL (12.5ms)[0m  INSERT INTO "schema_migrations" ("version") VALUES ('20120312032431')
Migrating to CreateApnNotifications (20120312032432)
  [1m[36mSQL (0.5ms)[0m  [1mCREATE TABLE "apn_notifications" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "device_id" integer NOT NULL, "errors_nb" integer DEFAULT 0, "device_language" varchar(255), "sound" varchar(255), "alert" varchar(255), "badge" integer, "custom_properties" text, "sent_at" datetime, "created_at" datetime, "updated_at" datetime) [0m
  [1m[35mSQL (0.1ms)[0m  PRAGMA index_list("apn_notifications")
  [1m[36mSQL (0.2ms)[0m  [1mCREATE INDEX "index_apn_notifications_on_device_id" ON "apn_notifications" ("device_id")[0m
  [1m[35mSQL (0.1ms)[0m  INSERT INTO "schema_migrations" ("version") VALUES ('20120312032432')
Migrating to AlterApnDevices (20120312032433)
  [1m[36mSQL (27.2ms)[0m  [1mALTER TABLE "apn_devices" ADD "last_registered_at" datetime[0m
  [1m[35mAlterApnDevices::APN::Device Load (0.1ms)[0m  SELECT "apn_devices".* FROM "apn_devices"
  [1m[36mSQL (26.0ms)[0m  [1mCREATE TEMPORARY TABLE "altered_apn_devices" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "token" text NOT NULL, "created_at" datetime, "updated_at" datetime, "last_registered_at" datetime) [0m
  [1m[35mSQL (0.1ms)[0m  PRAGMA index_list("apn_devices")
  [1m[36mSQL (27.0ms)[0m  [1mDROP TABLE "apn_devices"[0m
  [1m[35mSQL (0.2ms)[0m  CREATE TABLE "apn_devices" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "token" varchar(255) NOT NULL, "created_at" datetime, "updated_at" datetime, "last_registered_at" datetime) 
  [1m[36mSQL (0.0ms)[0m  [1mPRAGMA index_list("altered_apn_devices")[0m
  [1m[35mSQL (0.6ms)[0m  DROP TABLE "altered_apn_devices"
  [1m[36mSQL (0.1ms)[0m  [1mPRAGMA index_list("apn_devices")[0m
  [1m[35mSQL (0.2ms)[0m  CREATE UNIQUE INDEX "index_apn_devices_on_token" ON "apn_devices" ("token")
  [1m[36mSQL (0.1ms)[0m  [1mINSERT INTO "schema_migrations" ("version") VALUES ('20120312032433')[0m
  [1m[35mSQL (0.4ms)[0m   SELECT name
 FROM sqlite_master
 WHERE type = 'table' AND NOT name = 'sqlite_sequence'
  [1m[36mSQL (0.1ms)[0m  [1mSELECT "schema_migrations"."version" FROM "schema_migrations"[0m
  [1m[35mSQL (0.2ms)[0m   SELECT name
 FROM sqlite_master
 WHERE type = 'table' AND NOT name = 'sqlite_sequence'
  [1m[36mSQL (0.1ms)[0m  [1mPRAGMA index_list("apn_devices")[0m
  [1m[35mSQL (0.0ms)[0m  PRAGMA index_info('index_apn_devices_on_token')
  [1m[36mSQL (0.1ms)[0m  [1mPRAGMA index_list("apn_notifications")[0m
  [1m[35mSQL (0.0ms)[0m  PRAGMA index_info('index_apn_notifications_on_device_id')
  [1m[36mSQL (0.0ms)[0m  [1mPRAGMA index_list("devices")[0m
  [1m[35mSQL (0.0ms)[0m  PRAGMA index_list("shouts")
DEPRECATION WARNING: config.action_view.debug_rjs will be removed in 3.1, from 3.1 onwards you will need to install prototype-rails to continue to use RJS templates . (called from service at /Users/joe/.rvm/rubies/ruby-1.9.2-p180/lib/ruby/1.9.1/webrick/httpserver.rb:111)


Started GET "/" for 127.0.0.1 at 2012-03-18 10:06:16 -0600
  Processing by ShoutsController#index as HTML
  [1m[36mShout Load (23.7ms)[0m  [1mSELECT "shouts".* FROM "shouts"[0m
Rendered shouts/index.html.erb within layouts/application (186.8ms)
Completed 200 OK in 435ms (Views: 243.1ms | ActiveRecord: 23.7ms)


Started GET "/" for 127.0.0.1 at 2012-03-18 10:14:00 -0600
  Processing by ShoutsController#index as HTML
  [1m[35mShout Load (0.8ms)[0m  SELECT "shouts".* FROM "shouts"
Rendered shouts/index.html.erb within layouts/application (21.3ms)
Completed 200 OK in 45ms (Views: 26.8ms | ActiveRecord: 0.8ms)


Started GET "/shouts/new" for 127.0.0.1 at 2012-03-18 10:32:54 -0600
  Processing by ShoutsController#new as HTML
Rendered shouts/_form.html.erb (296.9ms)
Rendered shouts/new.html.erb within layouts/application (301.2ms)
Completed 200 OK in 334ms (Views: 307.7ms | ActiveRecord: 0.0ms)


Started GET "/" for 127.0.0.1 at 2012-03-18 11:33:05 -0600
  Processing by ShoutsController#index as HTML
  [1m[36mShout Load (21.2ms)[0m  [1mSELECT "shouts".* FROM "shouts"[0m
Rendered shouts/index.html.erb within layouts/application (115.0ms)
Completed 200 OK in 409ms (Views: 176.2ms | ActiveRecord: 21.2ms)


Started POST "/" for 127.0.0.1 at 2012-03-18 11:33:55 -0600
  Processing by ShoutsController#index as 
  Parameters: {"shout"=>{"shout_date(2i)"=>"March", "shout_message"=>"Shout from App in Sim!", "shout_date(1i)"=>"2012", "name"=>"Joe", "shout_date(3i)"=>"18"}}
  [1m[35mShout Load (0.6ms)[0m  SELECT "shouts".* FROM "shouts"
Rendered shouts/index.html.erb within layouts/application (137.6ms)
Completed 200 OK in 185ms (Views: 148.0ms | ActiveRecord: 0.6ms)


Started GET "/" for 127.0.0.1 at 2012-03-18 11:34:24 -0600
  Processing by ShoutsController#index as HTML
  [1m[36mShout Load (0.5ms)[0m  [1mSELECT "shouts".* FROM "shouts"[0m
Rendered shouts/index.html.erb within layouts/application (11.2ms)
Completed 200 OK in 25ms (Views: 15.6ms | ActiveRecord: 0.5ms)


Started GET "/" for 127.0.0.1 at 2012-03-18 11:38:35 -0600
  Processing by ShoutsController#index as HTML
  [1m[35mShout Load (14.8ms)[0m  SELECT "shouts".* FROM "shouts"
Rendered shouts/index.html.erb within layouts/application (14.1ms)
Completed 200 OK in 98ms (Views: 21.5ms | ActiveRecord: 14.8ms)


Started POST "/shouts/new" for 127.0.0.1 at 2012-03-18 11:39:01 -0600

ActionController::RoutingError (No route matches "/shouts/new"):
  

Rendered /Users/joe/.rvm/gems/ruby-1.9.2-p180/gems/actionpack-3.0.9/lib/action_dispatch/middleware/templates/rescues/routing_error.erb within rescues/layout (1.1ms)


Started GET "/" for 127.0.0.1 at 2012-03-18 11:40:06 -0600
  Processing by ShoutsController#index as HTML
  [1m[36mShout Load (1.0ms)[0m  [1mSELECT "shouts".* FROM "shouts"[0m
Rendered shouts/index.html.erb within layouts/application (12.8ms)
Completed 200 OK in 94ms (Views: 64.2ms | ActiveRecord: 1.0ms)


Started POST "/shouts" for 127.0.0.1 at 2012-03-18 11:40:39 -0600
  Processing by ShoutsController#create as 
  Parameters: {"shout"=>{"shout_date(2i)"=>"March", "shout_message"=>"Test Shout from App in Sim", "shout_date(1i)"=>"2012", "name"=>"Joe", "shout_date(3i)"=>"18"}}
Completed 500 Internal Server Error in 61ms

ActiveRecord::MultiparameterAssignmentErrors (1 error(s) on assignment of multiparameter attributes):
  app/controllers/shouts_controller.rb:43:in `new'
  app/controllers/shouts_controller.rb:43:in `create'

Rendered /Users/joe/.rvm/gems/ruby-1.9.2-p180/gems/actionpack-3.0.9/lib/action_dispatch/middleware/templates/rescues/_trace.erb (1.2ms)
Rendered /Users/joe/.rvm/gems/ruby-1.9.2-p180/gems/actionpack-3.0.9/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (17.6ms)
Rendered /Users/joe/.rvm/gems/ruby-1.9.2-p180/gems/actionpack-3.0.9/lib/action_dispatch/middleware/templates/rescues/diagnostics.erb within rescues/layout (61.8ms)


Started GET "/" for 127.0.0.1 at 2012-03-18 11:44:57 -0600
  Processing by ShoutsController#index as HTML
  [1m[35mShout Load (0.9ms)[0m  SELECT "shouts".* FROM "shouts"
Rendered shouts/index.html.erb within layouts/application (12.1ms)
Completed 200 OK in 39ms (Views: 18.6ms | ActiveRecord: 0.9ms)


Started POST "/shouts" for 127.0.0.1 at 2012-03-18 11:45:37 -0600
  Processing by ShoutsController#create as 
  Parameters: {"shout"=>{"shout_date(2i)"=>"03", "shout_message"=>"Test Shout from Sim", "shout_date(1i)"=>"2012", "name"=>"Joe", "shout_date(3i)"=>"18"}}
  [1m[36mSQL (0.3ms)[0m  [1m SELECT name
 FROM sqlite_master
 WHERE type = 'table' AND NOT name = 'sqlite_sequence'
[0m
  [1m[35mAREL (35.4ms)[0m  INSERT INTO "shouts" ("name", "shout_date", "shout_message", "created_at", "updated_at") VALUES ('Joe', '2012-03-18', 'Test Shout from Sim', '2012-03-18 17:45:37.573980', '2012-03-18 17:45:37.573980')
Redirected to http://0.0.0.0:3000/shouts/2
Completed 302 Found in 255ms


Started GET "/shouts/2" for 127.0.0.1 at 2012-03-18 11:45:45 -0600
  Processing by ShoutsController#show as 
  Parameters: {"id"=>"2"}
  [1m[36mShout Load (0.5ms)[0m  [1mSELECT "shouts".* FROM "shouts" WHERE "shouts"."id" = 2 LIMIT 1[0m
Rendered shouts/show.html.erb within layouts/application (17.1ms)
Completed 200 OK in 123ms (Views: 45.8ms | ActiveRecord: 36.2ms)


Started GET "/" for 127.0.0.1 at 2012-03-18 11:46:14 -0600
  Processing by ShoutsController#index as HTML
  [1m[35mShout Load (0.6ms)[0m  SELECT "shouts".* FROM "shouts"
Rendered shouts/index.html.erb within layouts/application (12.6ms)
Completed 200 OK in 25ms (Views: 17.8ms | ActiveRecord: 0.6ms)


Started GET "/" for 127.0.0.1 at 2012-03-18 12:02:29 -0600
  Processing by ShoutsController#index as HTML
  [1m[36mShout Load (22.6ms)[0m  [1mSELECT "shouts".* FROM "shouts"[0m
Rendered shouts/index.html.erb within layouts/application (18.7ms)
Completed 200 OK in 150ms (Views: 81.9ms | ActiveRecord: 22.6ms)


Started GET "/" for 192.168.0.5 at 2012-03-18 12:04:08 -0600
  Processing by ShoutsController#index as HTML
  [1m[35mShout Load (46.4ms)[0m  SELECT "shouts".* FROM "shouts"
Rendered shouts/index.html.erb within layouts/application (12.6ms)
Completed 200 OK in 993ms (Views: 785.8ms | ActiveRecord: 46.4ms)


Started GET "/" for 127.0.0.1 at 2012-03-18 12:05:05 -0600
  Processing by ShoutsController#index as HTML
  [1m[36mShout Load (1.0ms)[0m  [1mSELECT "shouts".* FROM "shouts"[0m
Rendered shouts/index.html.erb within layouts/application (20.6ms)
Completed 200 OK in 70ms (Views: 39.7ms | ActiveRecord: 1.0ms)


Started GET "/" for 192.168.0.4 at 2012-03-18 12:05:37 -0600
  Processing by ShoutsController#index as HTML
  [1m[35mShout Load (0.7ms)[0m  SELECT "shouts".* FROM "shouts"
Rendered shouts/index.html.erb within layouts/application (88.4ms)
Completed 200 OK in 101ms (Views: 93.7ms | ActiveRecord: 0.7ms)


Started GET "/" for 192.168.0.5 at 2012-03-18 13:23:16 -0600
  Processing by ShoutsController#index as HTML
  [1m[36mShout Load (398.2ms)[0m  [1mSELECT "shouts".* FROM "shouts"[0m
Rendered shouts/index.html.erb within layouts/application (5063.6ms)
Completed 200 OK in 13806ms (Views: 6649.9ms | ActiveRecord: 398.2ms)


Started GET "/" for 127.0.0.1 at 2012-03-18 13:26:18 -0600
  Processing by ShoutsController#index as HTML
  [1m[35mShout Load (13.5ms)[0m  SELECT "shouts".* FROM "shouts"
Rendered shouts/index.html.erb within layouts/application (70.0ms)
Completed 200 OK in 153ms (Views: 119.5ms | ActiveRecord: 13.5ms)


Started GET "/devices/new" for 192.168.0.5 at 2012-03-18 13:26:35 -0600
  Processing by DevicesController#new as HTML
Rendered devices/_form.html.erb (290.1ms)
Rendered devices/new.html.erb within layouts/application (323.8ms)
Completed 200 OK in 451ms (Views: 342.3ms | ActiveRecord: 0.0ms)


Started GET "/" for 127.0.0.1 at 2012-03-18 16:37:28 -0600
  Processing by ShoutsController#index as HTML
  [1m[36mShout Load (13.7ms)[0m  [1mSELECT "shouts".* FROM "shouts"[0m
Rendered shouts/index.html.erb within layouts/application (263.7ms)
Completed 200 OK in 354ms (Views: 292.7ms | ActiveRecord: 13.7ms)


Started GET "/" for 192.168.0.5 at 2012-03-18 16:38:13 -0600
  Processing by ShoutsController#index as HTML
  [1m[35mShout Load (24.7ms)[0m  SELECT "shouts".* FROM "shouts"
Rendered shouts/index.html.erb within layouts/application (14.7ms)
Completed 200 OK in 124ms (Views: 78.1ms | ActiveRecord: 24.7ms)


Started POST "/devices" for 192.168.0.4 at 2012-03-18 16:44:54 -0600
  Processing by DevicesController#create as 
  Parameters: {"device"=>{"name"=>"Joe", "token"=>"<a51cc895 05c75fd4 517f89bb 07766f8f caca3a3a 11ca08f8 ed6d5905 17267c61>"}}
  [1m[36mAREL (15.6ms)[0m  [1mINSERT INTO "devices" ("name", "token", "created_at", "updated_at") VALUES ('Joe', '<a51cc895 05c75fd4 517f89bb 07766f8f caca3a3a 11ca08f8 ed6d5905 17267c61>', '2012-03-18 22:44:54.705795', '2012-03-18 22:44:54.705795')[0m
Redirected to http://twiki.local:3000/devices/1
Completed 302 Found in 266ms


Started GET "/" for 192.168.0.4 at 2012-03-18 16:44:54 -0600
  Processing by ShoutsController#index as HTML
  [1m[35mShout Load (47.0ms)[0m  SELECT "shouts".* FROM "shouts"
Rendered shouts/index.html.erb within layouts/application (16.8ms)
Completed 200 OK in 211ms (Views: 136.4ms | ActiveRecord: 47.0ms)


Started GET "/devices/1" for 192.168.0.4 at 2012-03-18 16:45:03 -0600
  Processing by DevicesController#show as 
  Parameters: {"id"=>"1"}
  [1m[36mDevice Load (0.3ms)[0m  [1mSELECT "devices".* FROM "devices" WHERE "devices"."id" = 1 LIMIT 1[0m
Rendered devices/show.html.erb within layouts/application (19.5ms)
Completed 200 OK in 205ms (Views: 77.3ms | ActiveRecord: 15.9ms)


Started POST "/shouts" for 192.168.0.4 at 2012-03-18 16:45:59 -0600
  Processing by ShoutsController#create as 
  Parameters: {"shout"=>{"shout_date(2i)"=>"03", "shout_message"=>"test shout from device", "shout_date(1i)"=>"2012", "name"=>"Joe", "shout_date(3i)"=>"18"}}
  [1m[35mAREL (184.0ms)[0m  INSERT INTO "shouts" ("name", "shout_date", "shout_message", "created_at", "updated_at") VALUES ('Joe', '2012-03-18', 'test shout from device', '2012-03-18 22:45:59.454326', '2012-03-18 22:45:59.454326')
Redirected to http://twiki.local:3000/shouts/3
Completed 302 Found in 440ms


Started GET "/shouts/3" for 192.168.0.4 at 2012-03-18 16:46:07 -0600
  Processing by ShoutsController#show as 
  Parameters: {"id"=>"3"}
  [1m[36mShout Load (0.2ms)[0m  [1mSELECT "shouts".* FROM "shouts" WHERE "shouts"."id" = 3 LIMIT 1[0m
Rendered shouts/show.html.erb within layouts/application (12.4ms)
Completed 200 OK in 118ms (Views: 78.8ms | ActiveRecord: 184.2ms)


Started GET "/" for 192.168.0.4 at 2012-03-18 16:46:20 -0600
  Processing by ShoutsController#index as HTML
  [1m[35mShout Load (0.6ms)[0m  SELECT "shouts".* FROM "shouts"
Rendered shouts/index.html.erb within layouts/application (13.5ms)
Completed 200 OK in 26ms (Views: 18.8ms | ActiveRecord: 0.6ms)


Started POST "/devices" for 192.168.0.4 at 2012-03-18 17:44:06 -0600
  Processing by DevicesController#create as 
  Parameters: {"device"=>{"name"=>"Joe", "token"=>"<a51cc895 05c75fd4 517f89bb 07766f8f caca3a3a 11ca08f8 ed6d5905 17267c61>"}}
  [1m[36mAREL (53.9ms)[0m  [1mINSERT INTO "devices" ("name", "token", "created_at", "updated_at") VALUES ('Joe', '<a51cc895 05c75fd4 517f89bb 07766f8f caca3a3a 11ca08f8 ed6d5905 17267c61>', '2012-03-18 23:44:24.073768', '2012-03-18 23:44:24.073768')[0m
Redirected to http://twiki.local:3000/devices/2
Completed 302 Found in 303ms


Started GET "/" for 192.168.0.4 at 2012-03-18 17:44:24 -0600
  Processing by ShoutsController#index as HTML
  [1m[35mShout Load (19.7ms)[0m  SELECT "shouts".* FROM "shouts"
Rendered shouts/index.html.erb within layouts/application (167.6ms)
Completed 200 OK in 316ms (Views: 243.4ms | ActiveRecord: 19.7ms)


Started GET "/devices/2" for 192.168.0.4 at 2012-03-18 17:44:32 -0600
  Processing by DevicesController#show as 
  Parameters: {"id"=>"2"}
  [1m[36mDevice Load (0.4ms)[0m  [1mSELECT "devices".* FROM "devices" WHERE "devices"."id" = 2 LIMIT 1[0m
Rendered devices/show.html.erb within layouts/application (110.2ms)
Completed 200 OK in 236ms (Views: 147.7ms | ActiveRecord: 54.3ms)


Started POST "/shouts" for 192.168.0.4 at 2012-03-18 17:45:02 -0600
  Processing by ShoutsController#create as 
  Parameters: {"shout"=>{"shout_date(2i)"=>"03", "shout_message"=>"test for notification", "shout_date(1i)"=>"2012", "name"=>"Joe", "shout_date(3i)"=>"18"}}
  [1m[35mDevice Load (0.3ms)[0m  SELECT "devices".* FROM "devices"
  [1m[36mAPN::Device Load (0.3ms)[0m  [1mSELECT "apn_devices".* FROM "apn_devices" WHERE "apn_devices"."token" = '<a51cc895 05c75fd4 517f89bb 07766f8f caca3a3a 11ca08f8 ed6d5905 17267c61>' LIMIT 1[0m
  [1m[35mSQL (0.3ms)[0m  SELECT 1 FROM "apn_devices" WHERE ("apn_devices"."token" = 'a51cc895 05c75fd4 517f89bb 07766f8f caca3a3a 11ca08f8 ed6d5905 17267c61') LIMIT 1
  [1m[36mAREL (0.6ms)[0m  [1mINSERT INTO "apn_devices" ("token", "created_at", "updated_at", "last_registered_at") VALUES ('a51cc895 05c75fd4 517f89bb 07766f8f caca3a3a 11ca08f8 ed6d5905 17267c61', '2012-03-18 23:45:02.982187', '2012-03-18 23:45:02.982187', '2012-03-18 23:45:02.957018')[0m
  [1m[35mAREL (0.5ms)[0m  INSERT INTO "apn_notifications" ("device_id", "errors_nb", "device_language", "sound", "alert", "badge", "custom_properties", "sent_at", "created_at", "updated_at") VALUES (1, 0, NULL, 'default', 'Joe just shouted test for notification', 1, NULL, NULL, '2012-03-18 23:45:03.132380', '2012-03-18 23:45:03.132380')
  [1m[36mAPN::Device Load (0.2ms)[0m  [1mSELECT "apn_devices".* FROM "apn_devices" WHERE "apn_devices"."token" = '<a51cc895 05c75fd4 517f89bb 07766f8f caca3a3a 11ca08f8 ed6d5905 17267c61>' LIMIT 1[0m
  [1m[35mSQL (0.1ms)[0m  SELECT 1 FROM "apn_devices" WHERE ("apn_devices"."token" = 'a51cc895 05c75fd4 517f89bb 07766f8f caca3a3a 11ca08f8 ed6d5905 17267c61') LIMIT 1
  [1m[36mCACHE (0.0ms)[0m  [1mSELECT 1 FROM "apn_devices" WHERE ("apn_devices"."token" = 'a51cc895 05c75fd4 517f89bb 07766f8f caca3a3a 11ca08f8 ed6d5905 17267c61') LIMIT 1[0m
  [1m[35mAREL (137.5ms)[0m  INSERT INTO "apn_notifications" ("device_id", "errors_nb", "device_language", "sound", "alert", "badge", "custom_properties", "sent_at", "created_at", "updated_at") VALUES (NULL, 0, NULL, 'default', 'Joe just shouted test for notification', 1, NULL, NULL, '2012-03-18 23:45:03.211251', '2012-03-18 23:45:03.211251')
SQLite3::ConstraintException: apn_notifications.device_id may not be NULL: INSERT INTO "apn_notifications" ("device_id", "errors_nb", "device_language", "sound", "alert", "badge", "custom_properties", "sent_at", "created_at", "updated_at") VALUES (NULL, 0, NULL, 'default', 'Joe just shouted test for notification', 1, NULL, NULL, '2012-03-18 23:45:03.211251', '2012-03-18 23:45:03.211251')
Completed 500 Internal Server Error in 1210ms

ActiveRecord::StatementInvalid (SQLite3::ConstraintException: apn_notifications.device_id may not be NULL: INSERT INTO "apn_notifications" ("device_id", "errors_nb", "device_language", "sound", "alert", "badge", "custom_properties", "sent_at", "created_at", "updated_at") VALUES (NULL, 0, NULL, 'default', 'Joe just shouted test for notification', 1, NULL, NULL, '2012-03-18 23:45:03.211251', '2012-03-18 23:45:03.211251')):
  app/controllers/shouts_controller.rb:51:in `block in sendPush'
  app/controllers/shouts_controller.rb:43:in `each'
  app/controllers/shouts_controller.rb:43:in `sendPush'
  app/controllers/shouts_controller.rb:60:in `create'

Rendered /Users/joe/.rvm/gems/ruby-1.9.2-p180/gems/actionpack-3.0.9/lib/action_dispatch/middleware/templates/rescues/_trace.erb (18.0ms)
Rendered /Users/joe/.rvm/gems/ruby-1.9.2-p180/gems/actionpack-3.0.9/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (31.8ms)
Rendered /Users/joe/.rvm/gems/ruby-1.9.2-p180/gems/actionpack-3.0.9/lib/action_dispatch/middleware/templates/rescues/diagnostics.erb within rescues/layout (75.6ms)


Started GET "/" for 127.0.0.1 at 2012-03-18 21:08:14 -0600
  Processing by ShoutsController#index as HTML
  [1m[36mShout Load (36.5ms)[0m  [1mSELECT "shouts".* FROM "shouts"[0m
Rendered shouts/index.html.erb within layouts/application (73.0ms)
Completed 200 OK in 261ms (Views: 203.7ms | ActiveRecord: 36.5ms)


Started GET "/" for 192.168.0.5 at 2012-03-18 21:08:30 -0600
  Processing by ShoutsController#index as HTML
  [1m[35mShout Load (12.4ms)[0m  SELECT "shouts".* FROM "shouts"
Rendered shouts/index.html.erb within layouts/application (13.8ms)
Completed 200 OK in 63ms (Views: 21.3ms | ActiveRecord: 12.4ms)


Started GET "/" for 192.168.0.4 at 2012-03-18 21:44:08 -0600
  Processing by ShoutsController#index as HTML
  [1m[36mShout Load (46.8ms)[0m  [1mSELECT "shouts".* FROM "shouts"[0m
Rendered shouts/index.html.erb within layouts/application (17.0ms)
Completed 200 OK in 123ms (Views: 23.4ms | ActiveRecord: 46.8ms)


Started POST "/devices" for 192.168.0.4 at 2012-03-18 21:44:09 -0600
  Processing by DevicesController#create as 
  Parameters: {"device"=>{"name"=>"Joe", "token"=>"<a51cc895 05c75fd4 517f89bb 07766f8f caca3a3a 11ca08f8 ed6d5905 17267c61>"}}
  [1m[35mDevice Load (0.2ms)[0m  SELECT "devices".* FROM "devices" WHERE "devices"."token" = '<a51cc895 05c75fd4 517f89bb 07766f8f caca3a3a 11ca08f8 ed6d5905 17267c61>'
Completed 500 Internal Server Error in 43ms

NoMethodError (undefined method `first_or_initialize' for []:ActiveRecord::Relation):
  app/controllers/devices_controller.rb:43:in `create'

Rendered /Users/joe/.rvm/gems/ruby-1.9.2-p180/gems/actionpack-3.0.9/lib/action_dispatch/middleware/templates/rescues/_trace.erb (1.2ms)
Rendered /Users/joe/.rvm/gems/ruby-1.9.2-p180/gems/actionpack-3.0.9/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (3.0ms)
Rendered /Users/joe/.rvm/gems/ruby-1.9.2-p180/gems/actionpack-3.0.9/lib/action_dispatch/middleware/templates/rescues/diagnostics.erb within rescues/layout (9.0ms)


Started POST "/shouts" for 192.168.0.4 at 2012-03-18 21:45:07 -0600
  Processing by ShoutsController#create as 
  Parameters: {"shout"=>{"shout_date(2i)"=>"03", "shout_message"=>"Test for notification", "shout_date(1i)"=>"2012", "name"=>"Joe", "shout_date(3i)"=>"18"}}
  [1m[36mDevice Load (0.2ms)[0m  [1mSELECT "devices".* FROM "devices"[0m
  [1m[35mAREL (32.7ms)[0m  INSERT INTO "shouts" ("name", "shout_date", "shout_message", "created_at", "updated_at") VALUES ('Joe', '2012-03-18', 'Test for notification', '2012-03-19 03:45:08.231240', '2012-03-19 03:45:08.231240')
Redirected to http://twiki.local:3000/shouts/4
Completed 302 Found in 166ms


Started GET "/shouts/4" for 192.168.0.4 at 2012-03-18 21:45:16 -0600
  Processing by ShoutsController#show as 
  Parameters: {"id"=>"4"}
  [1m[36mShout Load (0.2ms)[0m  [1mSELECT "shouts".* FROM "shouts" WHERE "shouts"."id" = 4 LIMIT 1[0m
Rendered shouts/show.html.erb within layouts/application (27.9ms)
Completed 200 OK in 95ms (Views: 84.0ms | ActiveRecord: 33.1ms)


Started GET "/" for 192.168.0.4 at 2012-03-18 21:45:28 -0600
  Processing by ShoutsController#index as HTML
  [1m[35mShout Load (0.6ms)[0m  SELECT "shouts".* FROM "shouts"
Rendered shouts/index.html.erb within layouts/application (17.9ms)
Completed 200 OK in 32ms (Views: 22.9ms | ActiveRecord: 0.6ms)
  [1m[36mSQL (0.3ms)[0m  [1m SELECT name
 FROM sqlite_master
 WHERE type = 'table' AND NOT name = 'sqlite_sequence'
[0m
  [1m[35mAPN::Notification Load (13.9ms)[0m  SELECT "apn_notifications".* FROM "apn_notifications" WHERE "apn_notifications"."sent_at" IS NULL


Started POST "/devices" for 192.168.0.4 at 2012-03-19 08:31:54 -0600
  Processing by DevicesController#create as 
  Parameters: {"device"=>{"name"=>"joe", "token"=>"<a51cc895 05c75fd4 517f89bb 07766f8f caca3a3a 11ca08f8 ed6d5905 17267c61>"}}
  [1m[36mDevice Load (21.0ms)[0m  [1mSELECT "devices".* FROM "devices" WHERE "devices"."token" = '<a51cc895 05c75fd4 517f89bb 07766f8f caca3a3a 11ca08f8 ed6d5905 17267c61>' LIMIT 1[0m
  [1m[35mAREL (1.0ms)[0m  INSERT INTO "devices" ("name", "token", "created_at", "updated_at") VALUES ('joe', '<a51cc895 05c75fd4 517f89bb 07766f8f caca3a3a 11ca08f8 ed6d5905 17267c61>', '2012-03-19 14:31:54.588128', '2012-03-19 14:31:54.588128')
Redirected to http://twiki.local:3000/devices/3
Completed 302 Found in 83ms


Started GET "/" for 192.168.0.4 at 2012-03-19 08:31:54 -0600
  Processing by ShoutsController#index as HTML
  [1m[36mShout Load (45.9ms)[0m  [1mSELECT "shouts".* FROM "shouts"[0m
Rendered shouts/index.html.erb within layouts/application (18.6ms)
Completed 200 OK in 113ms (Views: 47.2ms | ActiveRecord: 45.9ms)


Started GET "/devices/3" for 192.168.0.4 at 2012-03-19 08:32:02 -0600
  Processing by DevicesController#show as 
  Parameters: {"id"=>"3"}
  [1m[35mDevice Load (0.3ms)[0m  SELECT "devices".* FROM "devices" WHERE "devices"."id" = 3 LIMIT 1
Rendered devices/show.html.erb within layouts/application (12.9ms)
Completed 200 OK in 67ms (Views: 55.4ms | ActiveRecord: 22.3ms)


Started GET "/shouts/new" for 192.168.0.4 at 2012-03-19 08:34:00 -0600
  Processing by ShoutsController#new as HTML
Rendered shouts/_form.html.erb (269.0ms)
Rendered shouts/new.html.erb within layouts/application (306.2ms)
Completed 200 OK in 410ms (Views: 357.4ms | ActiveRecord: 0.0ms)


Started GET "/" for 192.168.0.4 at 2012-03-19 08:34:19 -0600
  Processing by ShoutsController#index as HTML
  [1m[36mShout Load (0.6ms)[0m  [1mSELECT "shouts".* FROM "shouts"[0m
Rendered shouts/index.html.erb within layouts/application (16.0ms)
Completed 200 OK in 101ms (Views: 93.9ms | ActiveRecord: 0.6ms)


Started POST "/devices" for 192.168.0.4 at 2012-03-19 08:34:23 -0600
  Processing by DevicesController#create as 
  Parameters: {"device"=>{"name"=>"joe", "token"=>"<a51cc895 05c75fd4 517f89bb 07766f8f caca3a3a 11ca08f8 ed6d5905 17267c61>"}}
  [1m[35mDevice Load (0.2ms)[0m  SELECT "devices".* FROM "devices" WHERE "devices"."token" = '<a51cc895 05c75fd4 517f89bb 07766f8f caca3a3a 11ca08f8 ed6d5905 17267c61>' LIMIT 1
Completed 500 Internal Server Error in 36ms

NoMethodError (undefined method `save' for nil:NilClass):
  app/controllers/devices_controller.rb:48:in `block in create'
  app/controllers/devices_controller.rb:47:in `create'

Rendered /Users/joe/.rvm/gems/ruby-1.9.2-p180/gems/actionpack-3.0.9/lib/action_dispatch/middleware/templates/rescues/_trace.erb (2.3ms)
Rendered /Users/joe/.rvm/gems/ruby-1.9.2-p180/gems/actionpack-3.0.9/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (34.3ms)
Rendered /Users/joe/.rvm/gems/ruby-1.9.2-p180/gems/actionpack-3.0.9/lib/action_dispatch/middleware/templates/rescues/diagnostics.erb within rescues/layout (67.5ms)


Started POST "/shouts" for 192.168.0.4 at 2012-03-19 08:36:32 -0600
  Processing by ShoutsController#create as 
  Parameters: {"shout"=>{"shout_date(2i)"=>"03", "shout_message"=>"Test for Notification", "shout_date(1i)"=>"2012", "name"=>"joe", "shout_date(3i)"=>"19"}}
  [1m[36mDevice Load (0.3ms)[0m  [1mSELECT "devices".* FROM "devices"[0m
  [1m[35mAPN::Device Load (11.3ms)[0m  SELECT "apn_devices".* FROM "apn_devices" WHERE "apn_devices"."token" = '<a51cc895 05c75fd4 517f89bb 07766f8f caca3a3a 11ca08f8 ed6d5905 17267c61>' LIMIT 1
  [1m[36mSQL (0.2ms)[0m  [1mSELECT 1 FROM "apn_devices" WHERE ("apn_devices"."token" = 'a51cc895 05c75fd4 517f89bb 07766f8f caca3a3a 11ca08f8 ed6d5905 17267c61') LIMIT 1[0m
  [1m[35mCACHE (0.0ms)[0m  SELECT 1 FROM "apn_devices" WHERE ("apn_devices"."token" = 'a51cc895 05c75fd4 517f89bb 07766f8f caca3a3a 11ca08f8 ed6d5905 17267c61') LIMIT 1
  [1m[36mAREL (0.5ms)[0m  [1mINSERT INTO "apn_notifications" ("device_id", "errors_nb", "device_language", "sound", "alert", "badge", "custom_properties", "sent_at", "created_at", "updated_at") VALUES (NULL, 0, NULL, 'default', 'joe just shouted Test for Notification', 1, NULL, NULL, '2012-03-19 14:36:32.732332', '2012-03-19 14:36:32.732332')[0m
SQLite3::ConstraintException: apn_notifications.device_id may not be NULL: INSERT INTO "apn_notifications" ("device_id", "errors_nb", "device_language", "sound", "alert", "badge", "custom_properties", "sent_at", "created_at", "updated_at") VALUES (NULL, 0, NULL, 'default', 'joe just shouted Test for Notification', 1, NULL, NULL, '2012-03-19 14:36:32.732332', '2012-03-19 14:36:32.732332')
Completed 500 Internal Server Error in 77ms

ActiveRecord::StatementInvalid (SQLite3::ConstraintException: apn_notifications.device_id may not be NULL: INSERT INTO "apn_notifications" ("device_id", "errors_nb", "device_language", "sound", "alert", "badge", "custom_properties", "sent_at", "created_at", "updated_at") VALUES (NULL, 0, NULL, 'default', 'joe just shouted Test for Notification', 1, NULL, NULL, '2012-03-19 14:36:32.732332', '2012-03-19 14:36:32.732332')):
  app/controllers/shouts_controller.rb:51:in `block in sendPush'
  app/controllers/shouts_controller.rb:43:in `each'
  app/controllers/shouts_controller.rb:43:in `sendPush'
  app/controllers/shouts_controller.rb:60:in `create'

Rendered /Users/joe/.rvm/gems/ruby-1.9.2-p180/gems/actionpack-3.0.9/lib/action_dispatch/middleware/templates/rescues/_trace.erb (2.0ms)
Rendered /Users/joe/.rvm/gems/ruby-1.9.2-p180/gems/actionpack-3.0.9/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (5.0ms)
Rendered /Users/joe/.rvm/gems/ruby-1.9.2-p180/gems/actionpack-3.0.9/lib/action_dispatch/middleware/templates/rescues/diagnostics.erb within rescues/layout (13.4ms)


Started POST "/devices" for 192.168.0.4 at 2012-03-20 08:19:58 -0600
  Processing by DevicesController#create as 
  Parameters: {"device"=>{"name"=>"Joe", "token"=>"<a51cc895 05c75fd4 517f89bb 07766f8f caca3a3a 11ca08f8 ed6d5905 17267c61>"}}
Completed 500 Internal Server Error in 271ms

NameError (uninitialized constant DevicesController::Register):
  app/controllers/devices_controller.rb:49:in `create'

Rendered /Users/joe/.rvm/gems/ruby-1.9.2-p180/gems/actionpack-3.0.9/lib/action_dispatch/middleware/templates/rescues/_trace.erb (2282.9ms)
Rendered /Users/joe/.rvm/gems/ruby-1.9.2-p180/gems/actionpack-3.0.9/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (94.1ms)
Rendered /Users/joe/.rvm/gems/ruby-1.9.2-p180/gems/actionpack-3.0.9/lib/action_dispatch/middleware/templates/rescues/diagnostics.erb within rescues/layout (2608.7ms)


Started GET "/" for 192.168.0.4 at 2012-03-20 08:20:18 -0600
  Processing by ShoutsController#index as HTML
  [1m[35mShout Load (33.8ms)[0m  SELECT "shouts".* FROM "shouts"
Rendered shouts/index.html.erb within layouts/application (61.4ms)
Completed 200 OK in 259ms (Views: 143.4ms | ActiveRecord: 33.8ms)


Started GET "/" for 192.168.0.4 at 2012-03-20 08:24:30 -0600
  Processing by ShoutsController#index as HTML
  [1m[36mShout Load (1.2ms)[0m  [1mSELECT "shouts".* FROM "shouts"[0m
Rendered shouts/index.html.erb within layouts/application (273.1ms)
Completed 200 OK in 390ms (Views: 329.6ms | ActiveRecord: 1.2ms)


Started POST "/devices" for 192.168.0.4 at 2012-03-20 08:24:31 -0600
  Processing by DevicesController#create as 
  Parameters: {"device"=>{"name"=>"Joe", "token"=>"<a51cc895 05c75fd4 517f89bb 07766f8f caca3a3a 11ca08f8 ed6d5905 17267c61>"}}
  [1m[35mDevice Load (24.3ms)[0m  SELECT "devices".* FROM "devices" WHERE "devices"."token" = 'a51cc895 05c75fd4 517f89bb 07766f8f caca3a3a 11ca08f8 ed6d5905 17267c61' LIMIT 1
Completed 500 Internal Server Error in 175ms

NameError (uninitialized constant DevicesController::Register):
  app/controllers/devices_controller.rb:54:in `create'

Rendered /Users/joe/.rvm/gems/ruby-1.9.2-p180/gems/actionpack-3.0.9/lib/action_dispatch/middleware/templates/rescues/_trace.erb (1.3ms)
Rendered /Users/joe/.rvm/gems/ruby-1.9.2-p180/gems/actionpack-3.0.9/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (29.5ms)
Rendered /Users/joe/.rvm/gems/ruby-1.9.2-p180/gems/actionpack-3.0.9/lib/action_dispatch/middleware/templates/rescues/diagnostics.erb within rescues/layout (41.3ms)


Started GET "/" for 192.168.0.4 at 2012-03-20 08:26:06 -0600
  Processing by ShoutsController#index as HTML
  [1m[36mShout Load (0.8ms)[0m  [1mSELECT "shouts".* FROM "shouts"[0m
Rendered shouts/index.html.erb within layouts/application (150.5ms)
Completed 200 OK in 279ms (Views: 199.5ms | ActiveRecord: 0.8ms)


Started POST "/devices" for 192.168.0.4 at 2012-03-20 08:26:07 -0600
  Processing by DevicesController#create as 
  Parameters: {"device"=>{"name"=>"Joe", "token"=>"<a51cc895 05c75fd4 517f89bb 07766f8f caca3a3a 11ca08f8 ed6d5905 17267c61>"}}
  [1m[35mDevice Load (13.8ms)[0m  SELECT "devices".* FROM "devices" WHERE "devices"."token" = 'a51cc895 05c75fd4 517f89bb 07766f8f caca3a3a 11ca08f8 ed6d5905 17267c61' LIMIT 1
  [1m[36mAREL (15.2ms)[0m  [1mINSERT INTO "devices" ("name", "token", "created_at", "updated_at") VALUES ('Joe', 'a51cc895 05c75fd4 517f89bb 07766f8f caca3a3a 11ca08f8 ed6d5905 17267c61', '2012-03-20 14:26:07.479778', '2012-03-20 14:26:07.479778')[0m
Redirected to http://twiki.local:3000/devices/4
Completed 302 Found in 86ms


Started GET "/devices/4" for 192.168.0.4 at 2012-03-20 08:26:15 -0600
  Processing by DevicesController#show as 
  Parameters: {"id"=>"4"}
  [1m[35mDevice Load (0.2ms)[0m  SELECT "devices".* FROM "devices" WHERE "devices"."id" = 4 LIMIT 1
Rendered devices/show.html.erb within layouts/application (35.0ms)
Completed 200 OK in 92ms (Views: 83.0ms | ActiveRecord: 29.1ms)


Started POST "/shouts" for 192.168.0.4 at 2012-03-20 08:26:36 -0600
  Processing by ShoutsController#create as 
  Parameters: {"shout"=>{"shout_date(2i)"=>"03", "shout_message"=>"Test for Notification", "shout_date(1i)"=>"2012", "name"=>"Joe", "shout_date(3i)"=>"20"}}
  [1m[36mDevice Load (0.3ms)[0m  [1mSELECT "devices".* FROM "devices"[0m
  [1m[35mAPN::Device Load (0.2ms)[0m  SELECT "apn_devices".* FROM "apn_devices" WHERE "apn_devices"."token" = 'a51cc895 05c75fd4 517f89bb 07766f8f caca3a3a 11ca08f8 ed6d5905 17267c61' LIMIT 1
  [1m[36mSQL (0.2ms)[0m  [1mSELECT 1 FROM "apn_devices" WHERE ("apn_devices"."token" = 'a51cc895 05c75fd4 517f89bb 07766f8f caca3a3a 11ca08f8 ed6d5905 17267c61') LIMIT 1[0m
  [1m[35mAREL (20.6ms)[0m  INSERT INTO "apn_devices" ("token", "created_at", "updated_at", "last_registered_at") VALUES ('a51cc895 05c75fd4 517f89bb 07766f8f caca3a3a 11ca08f8 ed6d5905 17267c61', '2012-03-20 14:26:37.218047', '2012-03-20 14:26:37.218047', '2012-03-20 14:26:37.193505')
  [1m[36mAREL (32.1ms)[0m  [1mINSERT INTO "apn_notifications" ("device_id", "errors_nb", "device_language", "sound", "alert", "badge", "custom_properties", "sent_at", "created_at", "updated_at") VALUES (2, 0, NULL, 'default', 'Joe just shouted Test for Notification', 1, NULL, NULL, '2012-03-20 14:26:37.262499', '2012-03-20 14:26:37.262499')[0m
  [1m[35mAREL (0.4ms)[0m  INSERT INTO "shouts" ("name", "shout_date", "shout_message", "created_at", "updated_at") VALUES ('Joe', '2012-03-20', 'Test for Notification', '2012-03-20 14:26:37.299498', '2012-03-20 14:26:37.299498')
Redirected to http://twiki.local:3000/shouts/5
Completed 302 Found in 312ms


Started GET "/shouts/5" for 192.168.0.4 at 2012-03-20 08:26:45 -0600
  Processing by ShoutsController#show as 
  Parameters: {"id"=>"5"}
  [1m[36mShout Load (0.2ms)[0m  [1mSELECT "shouts".* FROM "shouts" WHERE "shouts"."id" = 5 LIMIT 1[0m
Rendered shouts/show.html.erb within layouts/application (14.1ms)
Completed 200 OK in 99ms (Views: 89.6ms | ActiveRecord: 54.0ms)


Started GET "/" for 192.168.0.4 at 2012-03-20 08:26:58 -0600
  Processing by ShoutsController#index as HTML
  [1m[35mShout Load (0.6ms)[0m  SELECT "shouts".* FROM "shouts"
Rendered shouts/index.html.erb within layouts/application (48.4ms)
Completed 200 OK in 60ms (Views: 53.2ms | ActiveRecord: 0.6ms)
  [1m[36mSQL (0.4ms)[0m  [1m SELECT name
 FROM sqlite_master
 WHERE type = 'table' AND NOT name = 'sqlite_sequence'
[0m
  [1m[35mAPN::Notification Load (21.8ms)[0m  SELECT "apn_notifications".* FROM "apn_notifications" WHERE "apn_notifications"."sent_at" IS NULL
  [1m[36mAPN::Device Load (13.9ms)[0m  [1mSELECT "apn_devices".* FROM "apn_devices" WHERE "apn_devices"."id" = 2 LIMIT 1[0m
  [1m[35mAREL (0.5ms)[0m  UPDATE "apn_notifications" SET "sent_at" = '2012-03-20 14:28:20.760302', "updated_at" = '2012-03-20 14:28:20.760861', "custom_properties" = NULL WHERE "apn_notifications"."id" = 2


Started GET "/" for 192.168.0.4 at 2012-03-20 08:33:21 -0600
  Processing by ShoutsController#index as HTML
  [1m[36mShout Load (169.2ms)[0m  [1mSELECT "shouts".* FROM "shouts"[0m
Rendered shouts/index.html.erb within layouts/application (16.4ms)
Completed 200 OK in 288ms (Views: 90.2ms | ActiveRecord: 169.2ms)


Started POST "/devices" for 192.168.0.4 at 2012-03-20 08:33:21 -0600
  Processing by DevicesController#create as 
  Parameters: {"device"=>{"name"=>"Scarlett", "token"=>"<a51cc895 05c75fd4 517f89bb 07766f8f caca3a3a 11ca08f8 ed6d5905 17267c61>"}}
  [1m[35mDevice Load (25.2ms)[0m  SELECT "devices".* FROM "devices" WHERE "devices"."token" = 'a51cc895 05c75fd4 517f89bb 07766f8f caca3a3a 11ca08f8 ed6d5905 17267c61' LIMIT 1
  [1m[36mAREL (0.4ms)[0m  [1mUPDATE "devices" SET "name" = 'Scarlett', "updated_at" = '2012-03-20 14:33:22.017709' WHERE "devices"."id" = 4[0m
Redirected to http://twiki.local:3000/devices/4
Completed 302 Found in 685ms


Started GET "/devices/4" for 192.168.0.4 at 2012-03-20 08:33:30 -0600
  Processing by DevicesController#show as 
  Parameters: {"id"=>"4"}
  [1m[35mDevice Load (0.2ms)[0m  SELECT "devices".* FROM "devices" WHERE "devices"."id" = 4 LIMIT 1
Rendered devices/show.html.erb within layouts/application (12.8ms)
Completed 200 OK in 125ms (Views: 100.4ms | ActiveRecord: 25.7ms)


Started POST "/shouts" for 192.168.0.4 at 2012-03-20 08:34:10 -0600
  Processing by ShoutsController#create as 
  Parameters: {"shout"=>{"shout_date(2i)"=>"03", "shout_message"=>"scarlett test", "shout_date(1i)"=>"2012", "name"=>"Scarlett", "shout_date(3i)"=>"20"}}
  [1m[36mDevice Load (0.4ms)[0m  [1mSELECT "devices".* FROM "devices"[0m
  [1m[35mAPN::Device Load (7.7ms)[0m  SELECT "apn_devices".* FROM "apn_devices" WHERE "apn_devices"."token" = 'a51cc895 05c75fd4 517f89bb 07766f8f caca3a3a 11ca08f8 ed6d5905 17267c61' LIMIT 1
  [1m[36mAREL (2.0ms)[0m  [1mINSERT INTO "apn_notifications" ("device_id", "errors_nb", "device_language", "sound", "alert", "badge", "custom_properties", "sent_at", "created_at", "updated_at") VALUES (2, 0, NULL, 'default', 'Scarlett just shouted scarlett test', 1, NULL, NULL, '2012-03-20 14:34:10.946401', '2012-03-20 14:34:10.946401')[0m
  [1m[35mAREL (24.9ms)[0m  INSERT INTO "shouts" ("name", "shout_date", "shout_message", "created_at", "updated_at") VALUES ('Scarlett', '2012-03-20', 'scarlett test', '2012-03-20 14:34:10.953931', '2012-03-20 14:34:10.953931')
Redirected to http://twiki.local:3000/shouts/6
Completed 302 Found in 196ms


Started GET "/shouts/6" for 192.168.0.4 at 2012-03-20 08:34:19 -0600
  Processing by ShoutsController#show as 
  Parameters: {"id"=>"6"}
  [1m[36mShout Load (0.2ms)[0m  [1mSELECT "shouts".* FROM "shouts" WHERE "shouts"."id" = 6 LIMIT 1[0m
Rendered shouts/show.html.erb within layouts/application (10.4ms)
Completed 200 OK in 116ms (Views: 106.6ms | ActiveRecord: 35.3ms)


Started GET "/" for 192.168.0.4 at 2012-03-20 08:34:31 -0600
  Processing by ShoutsController#index as HTML
  [1m[35mShout Load (0.6ms)[0m  SELECT "shouts".* FROM "shouts"
Rendered shouts/index.html.erb within layouts/application (21.0ms)
Completed 200 OK in 55ms (Views: 47.1ms | ActiveRecord: 0.6ms)
  [1m[36mSQL (0.4ms)[0m  [1m SELECT name
 FROM sqlite_master
 WHERE type = 'table' AND NOT name = 'sqlite_sequence'
[0m
  [1m[35mAPN::Notification Load (22.0ms)[0m  SELECT "apn_notifications".* FROM "apn_notifications" WHERE "apn_notifications"."sent_at" IS NULL
  [1m[36mAPN::Device Load (22.0ms)[0m  [1mSELECT "apn_devices".* FROM "apn_devices" WHERE "apn_devices"."id" = 2 LIMIT 1[0m
  [1m[35mAREL (0.5ms)[0m  UPDATE "apn_notifications" SET "sent_at" = '2012-03-20 14:35:25.430976', "updated_at" = '2012-03-20 14:35:25.431783', "custom_properties" = NULL WHERE "apn_notifications"."id" = 3


Started GET "/" for 127.0.0.1 at 2012-03-20 20:15:32 -0600
  Processing by ShoutsController#index as HTML
  [1m[36mShout Load (1.2ms)[0m  [1mSELECT "shouts".* FROM "shouts"[0m
Rendered shouts/index.html.erb within layouts/application (16.6ms)
Completed 200 OK in 85ms (Views: 56.2ms | ActiveRecord: 1.2ms)


Started GET "/" for 192.168.0.5 at 2012-03-20 20:16:05 -0600
  Processing by ShoutsController#index as HTML
  [1m[35mShout Load (0.6ms)[0m  SELECT "shouts".* FROM "shouts"
Rendered shouts/index.html.erb within layouts/application (31.8ms)
Completed 200 OK in 45ms (Views: 36.3ms | ActiveRecord: 0.6ms)


Started POST "/devices" for 192.168.0.4 at 2012-03-22 07:48:17 -0600
DEPRECATION WARNING: config.action_view.debug_rjs will be removed in 3.1, from 3.1 onwards you will need to install prototype-rails to continue to use RJS templates . (called from <top (required)> at /Users/joe/Documents/Book Project/Chapter 9 Code/icf_shout_out_server/app/controllers/application_controller.rb:1)
  Processing by DevicesController#create as 
  Parameters: {"device"=>{"name"=>"Joe", "token"=>"<a51cc895 05c75fd4 517f89bb 07766f8f caca3a3a 11ca08f8 ed6d5905 17267c61>"}}
  [1m[36mSQL (0.3ms)[0m  [1m SELECT name
 FROM sqlite_master
 WHERE type = 'table' AND NOT name = 'sqlite_sequence'
[0m
  [1m[35mDevice Load (22.6ms)[0m  SELECT "devices".* FROM "devices" WHERE "devices"."token" = 'a51cc895 05c75fd4 517f89bb 07766f8f caca3a3a 11ca08f8 ed6d5905 17267c61' LIMIT 1
  [1m[36mAREL (24.2ms)[0m  [1mUPDATE "devices" SET "name" = 'Joe', "updated_at" = '2012-03-22 13:48:22.223062' WHERE "devices"."id" = 4[0m
Redirected to http://twiki.local:3000/devices/4
Completed 302 Found in 390ms


Started GET "/devices/4" for 192.168.0.4 at 2012-03-22 07:48:30 -0600
  Processing by DevicesController#show as 
  Parameters: {"id"=>"4"}
  [1m[35mDevice Load (0.2ms)[0m  SELECT "devices".* FROM "devices" WHERE "devices"."id" = 4 LIMIT 1
Rendered devices/show.html.erb within layouts/application (28.2ms)
Completed 200 OK in 112ms (Views: 90.2ms | ActiveRecord: 47.4ms)


Started GET "/" for 192.168.0.4 at 2012-03-22 07:48:44 -0600
  Processing by ShoutsController#index as HTML
  [1m[36mShout Load (12.0ms)[0m  [1mSELECT "shouts".* FROM "shouts"[0m
Rendered shouts/index.html.erb within layouts/application (62.7ms)
Completed 200 OK in 138ms (Views: 103.1ms | ActiveRecord: 12.0ms)


Started POST "/shouts" for 192.168.0.4 at 2012-03-22 07:49:55 -0600
  Processing by ShoutsController#create as 
  Parameters: {"shout"=>{"shout_date(2i)"=>"03", "shout_message"=>"My test shout", "shout_date(1i)"=>"2012", "name"=>"Joe", "shout_date(3i)"=>"22"}}
  [1m[35mDevice Load (0.3ms)[0m  SELECT "devices".* FROM "devices"
  [1m[36mAPN::Device Load (15.2ms)[0m  [1mSELECT "apn_devices".* FROM "apn_devices" WHERE "apn_devices"."token" = 'a51cc895 05c75fd4 517f89bb 07766f8f caca3a3a 11ca08f8 ed6d5905 17267c61' LIMIT 1[0m
  [1m[35mAREL (1.7ms)[0m  INSERT INTO "apn_notifications" ("device_id", "errors_nb", "device_language", "sound", "alert", "badge", "custom_properties", "sent_at", "created_at", "updated_at") VALUES (2, 0, NULL, 'default', 'Joe just shouted My test shout', 1, NULL, NULL, '2012-03-22 13:49:55.925441', '2012-03-22 13:49:55.925441')
  [1m[36mAREL (0.4ms)[0m  [1mINSERT INTO "shouts" ("name", "shout_date", "shout_message", "created_at", "updated_at") VALUES ('Joe', '2012-03-22', 'My test shout', '2012-03-22 13:49:55.968637', '2012-03-22 13:49:55.968637')[0m
Redirected to http://twiki.local:3000/shouts/7
Completed 302 Found in 286ms


Started GET "/shouts/7" for 192.168.0.4 at 2012-03-22 07:50:04 -0600
  Processing by ShoutsController#show as 
  Parameters: {"id"=>"7"}
  [1m[35mShout Load (0.2ms)[0m  SELECT "shouts".* FROM "shouts" WHERE "shouts"."id" = 7 LIMIT 1
Rendered shouts/show.html.erb within layouts/application (9.9ms)
Completed 200 OK in 42ms (Views: 32.7ms | ActiveRecord: 17.9ms)


Started GET "/" for 192.168.0.4 at 2012-03-22 07:50:16 -0600
  Processing by ShoutsController#index as HTML
  [1m[36mShout Load (0.6ms)[0m  [1mSELECT "shouts".* FROM "shouts"[0m
Rendered shouts/index.html.erb within layouts/application (48.2ms)
Completed 200 OK in 60ms (Views: 52.5ms | ActiveRecord: 0.6ms)
  [1m[36mSQL (0.2ms)[0m  [1m SELECT name
 FROM sqlite_master
 WHERE type = 'table' AND NOT name = 'sqlite_sequence'
[0m
  [1m[35mAPN::Notification Load (0.4ms)[0m  SELECT "apn_notifications".* FROM "apn_notifications" WHERE "apn_notifications"."sent_at" IS NULL
  [1m[36mAPN::Device Load (0.2ms)[0m  [1mSELECT "apn_devices".* FROM "apn_devices" WHERE "apn_devices"."id" = 2 LIMIT 1[0m
  [1m[35mAREL (0.5ms)[0m  UPDATE "apn_notifications" SET "sent_at" = '2012-03-22 13:51:11.107020', "updated_at" = '2012-03-22 13:51:11.107536', "custom_properties" = NULL WHERE "apn_notifications"."id" = 4


Started POST "/devices" for 192.168.0.4 at 2012-03-22 08:00:14 -0600
  Processing by DevicesController#create as 
  Parameters: {"device"=>{"name"=>"Joe", "token"=>"<a51cc895 05c75fd4 517f89bb 07766f8f caca3a3a 11ca08f8 ed6d5905 17267c61>"}}
  [1m[35mDevice Load (0.6ms)[0m  SELECT "devices".* FROM "devices" WHERE "devices"."token" = 'a51cc895 05c75fd4 517f89bb 07766f8f caca3a3a 11ca08f8 ed6d5905 17267c61' LIMIT 1
Redirected to http://twiki.local:3000/devices/4
Completed 302 Found in 20ms


Started GET "/devices/4" for 192.168.0.4 at 2012-03-22 08:00:22 -0600
  Processing by DevicesController#show as 
  Parameters: {"id"=>"4"}
  [1m[36mDevice Load (0.2ms)[0m  [1mSELECT "devices".* FROM "devices" WHERE "devices"."id" = 4 LIMIT 1[0m
Rendered devices/show.html.erb within layouts/application (10.4ms)
Completed 200 OK in 80ms (Views: 70.4ms | ActiveRecord: 0.8ms)


Started GET "/" for 192.168.0.4 at 2012-03-22 08:00:36 -0600
  Processing by ShoutsController#index as HTML
  [1m[35mShout Load (14.0ms)[0m  SELECT "shouts".* FROM "shouts"
Rendered shouts/index.html.erb within layouts/application (22.3ms)
Completed 200 OK in 100ms (Views: 63.0ms | ActiveRecord: 14.0ms)


Started POST "/devices" for 192.168.0.4 at 2012-03-22 08:40:42 -0600
  Processing by DevicesController#create as 
  Parameters: {"device"=>{"name"=>"Joe", "token"=>"<a51cc895 05c75fd4 517f89bb 07766f8f caca3a3a 11ca08f8 ed6d5905 17267c61>"}}
  [1m[36mDevice Load (0.7ms)[0m  [1mSELECT "devices".* FROM "devices" WHERE "devices"."token" = 'a51cc895 05c75fd4 517f89bb 07766f8f caca3a3a 11ca08f8 ed6d5905 17267c61' LIMIT 1[0m
Redirected to http://twiki.local:3000/devices/4
Completed 302 Found in 28ms


Started GET "/devices/4" for 192.168.0.4 at 2012-03-22 08:40:51 -0600
  Processing by DevicesController#show as 
  Parameters: {"id"=>"4"}
  [1m[35mDevice Load (0.2ms)[0m  SELECT "devices".* FROM "devices" WHERE "devices"."id" = 4 LIMIT 1
Rendered devices/show.html.erb within layouts/application (11.6ms)
Completed 200 OK in 87ms (Views: 77.5ms | ActiveRecord: 0.9ms)


Started GET "/" for 192.168.0.4 at 2012-03-22 08:41:05 -0600
  Processing by ShoutsController#index as HTML
  [1m[36mShout Load (13.7ms)[0m  [1mSELECT "shouts".* FROM "shouts"[0m
Rendered shouts/index.html.erb within layouts/application (18.3ms)
Completed 200 OK in 97ms (Views: 58.4ms | ActiveRecord: 13.7ms)
DEPRECATION WARNING: config.action_view.debug_rjs will be removed in 3.1, from 3.1 onwards you will need to install prototype-rails to continue to use RJS templates . (called from service at /Users/joe/.rvm/rubies/ruby-1.9.2-p180/lib/ruby/1.9.1/webrick/httpserver.rb:111)


Started GET "/" for 127.0.0.1 at 2012-03-22 15:30:14 -0600
  Processing by ShoutsController#index as HTML
  [1m[36mShout Load (15.7ms)[0m  [1mSELECT "shouts".* FROM "shouts"[0m
Rendered shouts/index.html.erb within layouts/application (2.9ms)
Completed 200 OK in 160ms (Views: 24.1ms | ActiveRecord: 15.7ms)


Started GET "/" for 127.0.0.1 at 2012-03-22 15:30:14 -0600
  Processing by ShoutsController#index as HTML
  [1m[35mShout Load (0.6ms)[0m  SELECT "shouts".* FROM "shouts"
Rendered shouts/index.html.erb within layouts/application (3.6ms)
Completed 200 OK in 39ms (Views: 17.0ms | ActiveRecord: 0.6ms)


Started GET "/" for 192.168.0.5 at 2012-03-22 15:30:43 -0600
  Processing by ShoutsController#index as HTML
  [1m[36mShout Load (0.6ms)[0m  [1mSELECT "shouts".* FROM "shouts"[0m
Rendered shouts/index.html.erb within layouts/application (2.5ms)
Completed 200 OK in 21ms (Views: 6.8ms | ActiveRecord: 0.6ms)


Started GET "/" for 127.0.0.1 at 2012-03-22 15:33:03 -0600
  Processing by ShoutsController#index as HTML
  [1m[35mShout Load (0.6ms)[0m  SELECT "shouts".* FROM "shouts"
Rendered shouts/index.html.erb within layouts/application (2.5ms)
Completed 200 OK in 21ms (Views: 6.9ms | ActiveRecord: 0.6ms)


Started POST "/devices" for 192.168.0.4 at 2012-03-29 14:28:06 -0600
DEPRECATION WARNING: config.action_view.debug_rjs will be removed in 3.1, from 3.1 onwards you will need to install prototype-rails to continue to use RJS templates . (called from <top (required)> at /Users/joe/Documents/Book Project/Chapter 9 Code/icf_shout_out_server/app/controllers/application_controller.rb:1)
  Processing by DevicesController#create as 
  Parameters: {"device"=>{"name"=>"Joe", "token"=>"<a51cc895 05c75fd4 517f89bb 07766f8f caca3a3a 11ca08f8 ed6d5905 17267c61>"}}
  [1m[36mSQL (0.3ms)[0m  [1m SELECT name
 FROM sqlite_master
 WHERE type = 'table' AND NOT name = 'sqlite_sequence'
[0m
  [1m[35mDevice Load (18.0ms)[0m  SELECT "devices".* FROM "devices" WHERE "devices"."token" = 'a51cc895 05c75fd4 517f89bb 07766f8f caca3a3a 11ca08f8 ed6d5905 17267c61' LIMIT 1
Redirected to http://twiki.local:3000/devices/4
Completed 302 Found in 279ms


Started GET "/devices/4" for 192.168.0.4 at 2012-03-29 14:28:16 -0600
  Processing by DevicesController#show as 
  Parameters: {"id"=>"4"}
  [1m[36mDevice Load (0.2ms)[0m  [1mSELECT "devices".* FROM "devices" WHERE "devices"."id" = 4 LIMIT 1[0m
Rendered devices/show.html.erb within layouts/application (31.3ms)
Completed 200 OK in 63ms (Views: 45.3ms | ActiveRecord: 18.4ms)


Started GET "/" for 192.168.0.4 at 2012-03-29 14:28:30 -0600
  Processing by ShoutsController#index as HTML
  [1m[35mShout Load (12.8ms)[0m  SELECT "shouts".* FROM "shouts"
Rendered shouts/index.html.erb within layouts/application (3.8ms)
Completed 200 OK in 141ms (Views: 49.0ms | ActiveRecord: 12.8ms)


Started POST "/shouts" for 192.168.0.4 at 2012-03-29 14:29:54 -0600
  Processing by ShoutsController#create as 
  Parameters: {"shout"=>{"shout_date(2i)"=>"03", "shout_message"=>"shouting now", "shout_date(1i)"=>"2012", "name"=>"Joe", "shout_date(3i)"=>"29"}}
  [1m[36mDevice Load (0.3ms)[0m  [1mSELECT "devices".* FROM "devices"[0m
  [1m[35mAPN::Device Load (35.9ms)[0m  SELECT "apn_devices".* FROM "apn_devices" WHERE "apn_devices"."token" = 'a51cc895 05c75fd4 517f89bb 07766f8f caca3a3a 11ca08f8 ed6d5905 17267c61' LIMIT 1
  [1m[36mAREL (15.9ms)[0m  [1mINSERT INTO "apn_notifications" ("device_id", "errors_nb", "device_language", "sound", "alert", "badge", "custom_properties", "sent_at", "created_at", "updated_at") VALUES (2, 0, NULL, 'shout_out.caf', 'Joe just shouted shouting now', 1, NULL, NULL, '2012-03-29 20:29:54.564532', '2012-03-29 20:29:54.564532')[0m
  [1m[35mAREL (0.6ms)[0m  INSERT INTO "shouts" ("name", "shout_date", "shout_message", "created_at", "updated_at") VALUES ('Joe', '2012-03-29', 'shouting now', '2012-03-29 20:29:54.715083', '2012-03-29 20:29:54.715083')
Redirected to http://twiki.local:3000/shouts/8
Completed 302 Found in 316ms


Started GET "/shouts/8" for 192.168.0.4 at 2012-03-29 14:30:02 -0600
  Processing by ShoutsController#show as 
  Parameters: {"id"=>"8"}
  [1m[36mShout Load (0.2ms)[0m  [1mSELECT "shouts".* FROM "shouts" WHERE "shouts"."id" = 8 LIMIT 1[0m
Rendered shouts/show.html.erb within layouts/application (14.2ms)
Completed 200 OK in 110ms (Views: 100.5ms | ActiveRecord: 52.8ms)


Started GET "/" for 192.168.0.4 at 2012-03-29 14:30:15 -0600
  Processing by ShoutsController#index as HTML
  [1m[35mShout Load (0.9ms)[0m  SELECT "shouts".* FROM "shouts"
Rendered shouts/index.html.erb within layouts/application (2.4ms)
Completed 200 OK in 21ms (Views: 6.8ms | ActiveRecord: 0.9ms)
  [1m[36mSQL (0.3ms)[0m  [1m SELECT name
 FROM sqlite_master
 WHERE type = 'table' AND NOT name = 'sqlite_sequence'
[0m
  [1m[35mAPN::Notification Load (21.6ms)[0m  SELECT "apn_notifications".* FROM "apn_notifications" WHERE "apn_notifications"."sent_at" IS NULL
  [1m[36mAPN::Device Load (10.6ms)[0m  [1mSELECT "apn_devices".* FROM "apn_devices" WHERE "apn_devices"."id" = 2 LIMIT 1[0m
  [1m[35mAREL (0.5ms)[0m  UPDATE "apn_notifications" SET "sent_at" = '2012-03-29 20:30:53.935037', "updated_at" = '2012-03-29 20:30:53.936003', "custom_properties" = NULL WHERE "apn_notifications"."id" = 5


Started POST "/devices" for 192.168.0.4 at 2012-03-29 14:33:38 -0600
  Processing by DevicesController#create as 
  Parameters: {"device"=>{"name"=>"Joe Keeley", "token"=>"<a51cc895 05c75fd4 517f89bb 07766f8f caca3a3a 11ca08f8 ed6d5905 17267c61>"}}
  [1m[36mDevice Load (6.6ms)[0m  [1mSELECT "devices".* FROM "devices" WHERE "devices"."token" = 'a51cc895 05c75fd4 517f89bb 07766f8f caca3a3a 11ca08f8 ed6d5905 17267c61' LIMIT 1[0m
  [1m[35mAREL (0.4ms)[0m  UPDATE "devices" SET "name" = 'Joe Keeley', "updated_at" = '2012-03-29 20:33:38.629111' WHERE "devices"."id" = 4
Redirected to http://twiki.local:3000/devices/4
Completed 302 Found in 54ms


Started GET "/devices/4" for 192.168.0.4 at 2012-03-29 14:33:46 -0600
  Processing by DevicesController#show as 
  Parameters: {"id"=>"4"}
  [1m[36mDevice Load (0.2ms)[0m  [1mSELECT "devices".* FROM "devices" WHERE "devices"."id" = 4 LIMIT 1[0m
Rendered devices/show.html.erb within layouts/application (9.7ms)
Completed 200 OK in 121ms (Views: 111.4ms | ActiveRecord: 7.1ms)


Started GET "/" for 192.168.0.4 at 2012-03-29 14:34:00 -0600
  Processing by ShoutsController#index as HTML
  [1m[35mShout Load (1.0ms)[0m  SELECT "shouts".* FROM "shouts"
Rendered shouts/index.html.erb within layouts/application (2.5ms)
Completed 200 OK in 93ms (Views: 23.7ms | ActiveRecord: 1.0ms)


Started POST "/shouts" for 192.168.0.4 at 2012-03-29 14:34:54 -0600
  Processing by ShoutsController#create as 
  Parameters: {"shout"=>{"shout_date(2i)"=>"03", "shout_message"=>"Here my shout!", "shout_date(1i)"=>"2012", "name"=>"Joe Keeley", "shout_date(3i)"=>"29"}}
  [1m[36mDevice Load (0.3ms)[0m  [1mSELECT "devices".* FROM "devices"[0m
  [1m[35mAPN::Device Load (0.3ms)[0m  SELECT "apn_devices".* FROM "apn_devices" WHERE "apn_devices"."token" = 'a51cc895 05c75fd4 517f89bb 07766f8f caca3a3a 11ca08f8 ed6d5905 17267c61' LIMIT 1
  [1m[36mAREL (0.4ms)[0m  [1mINSERT INTO "apn_notifications" ("device_id", "errors_nb", "device_language", "sound", "alert", "badge", "custom_properties", "sent_at", "created_at", "updated_at") VALUES (2, 0, NULL, 'shout_out.caf', 'Joe Keeley just shouted Here my shout!', 1, NULL, NULL, '2012-03-29 20:34:54.598584', '2012-03-29 20:34:54.598584')[0m
  [1m[35mAREL (0.4ms)[0m  INSERT INTO "shouts" ("name", "shout_date", "shout_message", "created_at", "updated_at") VALUES ('Joe Keeley', '2012-03-29', 'Here my shout!', '2012-03-29 20:34:54.603025', '2012-03-29 20:34:54.603025')
Redirected to http://twiki.local:3000/shouts/9
Completed 302 Found in 43ms


Started GET "/shouts/9" for 192.168.0.4 at 2012-03-29 14:35:02 -0600
  Processing by ShoutsController#show as 
  Parameters: {"id"=>"9"}
  [1m[36mShout Load (0.3ms)[0m  [1mSELECT "shouts".* FROM "shouts" WHERE "shouts"."id" = 9 LIMIT 1[0m
Rendered shouts/show.html.erb within layouts/application (14.2ms)
Completed 200 OK in 140ms (Views: 98.4ms | ActiveRecord: 1.7ms)


Started GET "/" for 192.168.0.4 at 2012-03-29 14:35:15 -0600
  Processing by ShoutsController#index as HTML
  [1m[35mShout Load (0.7ms)[0m  SELECT "shouts".* FROM "shouts"
Rendered shouts/index.html.erb within layouts/application (2.4ms)
Completed 200 OK in 21ms (Views: 6.9ms | ActiveRecord: 0.7ms)
  [1m[36mSQL (0.2ms)[0m  [1m SELECT name
 FROM sqlite_master
 WHERE type = 'table' AND NOT name = 'sqlite_sequence'
[0m
  [1m[35mAPN::Notification Load (0.8ms)[0m  SELECT "apn_notifications".* FROM "apn_notifications" WHERE "apn_notifications"."sent_at" IS NULL
  [1m[36mAPN::Device Load (23.0ms)[0m  [1mSELECT "apn_devices".* FROM "apn_devices" WHERE "apn_devices"."id" = 2 LIMIT 1[0m
  [1m[35mAREL (0.5ms)[0m  UPDATE "apn_notifications" SET "sent_at" = '2012-03-29 20:35:50.663886', "updated_at" = '2012-03-29 20:35:50.664679', "custom_properties" = NULL WHERE "apn_notifications"."id" = 6
