Skip to content

Instantly share code, notes, and snippets.

@shelleyvadams
Last active July 21, 2017 17:53
Show Gist options
  • Select an option

  • Save shelleyvadams/cae9426a18eddfd69e0747b9f1d8984e to your computer and use it in GitHub Desktop.

Select an option

Save shelleyvadams/cae9426a18eddfd69e0747b9f1d8984e to your computer and use it in GitHub Desktop.
Log of two if me server runs for debugging https://github.com/julianguyen/ifme/issues/499
(gdesk)shelley@localhost:~/Development/ifme$ rails s
=> Booting WEBrick
=> Rails 4.2.9 application starting in development on http://localhost:3000
=> Run `rails server -h` for more startup options
=> Ctrl-C to shutdown server
[2017-07-20 09:50:24] INFO WEBrick 1.3.1
[2017-07-20 09:50:24] INFO ruby 2.3.4 (2017-03-30) [x86_64-linux]
[2017-07-20 09:50:24] INFO WEBrick::HTTPServer#start: pid=17327 port=3000
Started GET "/" for ::1 at 2017-07-20 09:50:49 -0400
ActiveRecord::SchemaMigration Load (3.9ms) SELECT "schema_migrations".* FROM "schema_migrations"
Processing by PagesController#home as HTML
User Load (2.3ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 1]]
Allyship Load (1.0ms) SELECT "allyships".* FROM "allyships" WHERE "allyships"."user_id" = $1 AND "allyships"."status" = $2 [["user_id", 1], ["status", 0]]
User Load (1.2ms) SELECT "users".* FROM "users" WHERE "users"."id" IN (2, 3)
Moment Load (1.8ms) SELECT "moments".* FROM "moments" WHERE "moments"."userid" = $1 ORDER BY created_at DESC [["userid", 2]]
Strategy Load (1.3ms) SELECT "strategies".* FROM "strategies" WHERE "strategies"."userid" = $1 ORDER BY created_at DESC [["userid", 2]]
Moment Load (0.8ms) SELECT "moments".* FROM "moments" WHERE "moments"."userid" = $1 ORDER BY created_at DESC [["userid", 3]]
Strategy Load (0.7ms) SELECT "strategies".* FROM "strategies" WHERE "strategies"."userid" = $1 ORDER BY created_at DESC [["userid", 3]]
Moment Load (0.7ms) SELECT "moments".* FROM "moments" WHERE "moments"."userid" = $1 ORDER BY created_at DESC [["userid", 1]]
Strategy Load (0.7ms) SELECT "strategies".* FROM "strategies" WHERE "strategies"."userid" = $1 ORDER BY created_at DESC [["userid", 1]]
(1.0ms) SELECT COUNT(*) FROM "moments" WHERE "moments"."id" IN (1, 2)
Moment Load (1.0ms) SELECT "moments".* FROM "moments" WHERE "moments"."id" IN (1, 2) ORDER BY created_at DESC
Strategy Load (0.9ms) SELECT "strategies".* FROM "strategies" WHERE 1=0 ORDER BY created_at DESC
Rendered shared/_character_count.html.erb (2.0ms)
Category Load (1.2ms) SELECT "categories".* FROM "categories" WHERE "categories"."userid" = $1 ORDER BY "categories"."created_at" DESC [["userid", 1]]
Mood Load (1.2ms) SELECT "moods".* FROM "moods" WHERE "moods"."userid" = $1 ORDER BY "moods"."created_at" DESC [["userid", 1]]
Rendered shared/_modal.html.erb (2.1ms)
Rendered shared/_modal.html.erb (2.0ms)
Rendered notifications/_preview.html.erb (7.1ms)
Rendered shared/_modal.html.erb (0.1ms)
Rendered notifications/_preview.html.erb (2.7ms)
Rendered shared/_modal.html.erb (0.1ms)
Rendered notifications/_preview.html.erb (3.4ms)
Rendered notifications/_categories_moods.html.erb (88.1ms)
Rendered moments/_quick_moment.html.erb (148.0ms)
User Load (1.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 LIMIT 1 [["id", 1]]
User Load (0.9ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 LIMIT 1 [["id", 2]]
CACHE (0.0ms) SELECT "allyships".* FROM "allyships" WHERE "allyships"."user_id" = $1 AND "allyships"."status" = $2 [["user_id", 1], ["status", 0]]
CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" IN (2, 3)
Allyship Load (0.7ms) SELECT "allyships".* FROM "allyships" WHERE "allyships"."user_id" = $1 AND "allyships"."status" = $2 [["user_id", 2], ["status", 0]]
User Load (1.1ms) SELECT "users".* FROM "users" WHERE "users"."id" IN (1)
Rendered shared/_viewers_hover.html.erb (1.0ms)
User Load (1.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 2]]
CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 2]]
Category Load (0.8ms) SELECT "categories".* FROM "categories" WHERE "categories"."id" = $1 ORDER BY "categories"."id" ASC LIMIT 1 [["id", 2]]
CACHE (0.0ms) SELECT "categories".* FROM "categories" WHERE "categories"."id" = $1 ORDER BY "categories"."id" ASC LIMIT 1 [["id", 2]]
Rendered shared/_modal.html.erb (0.1ms)
CACHE (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 2]]
CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 2]]
Rendered notifications/_preview.html.erb (9.0ms)
Mood Load (0.7ms) SELECT "moods".* FROM "moods" WHERE "moods"."id" = $1 ORDER BY "moods"."id" ASC LIMIT 1 [["id", 3]]
CACHE (0.1ms) SELECT "moods".* FROM "moods" WHERE "moods"."id" = $1 ORDER BY "moods"."id" ASC LIMIT 1 [["id", 3]]
Rendered shared/_modal.html.erb (0.1ms)
CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 2]]
CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 2]]
Rendered notifications/_preview.html.erb (6.8ms)
Rendered moments/_info.html.erb (68.3ms)
CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 LIMIT 1 [["id", 2]]
User Load (1.3ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 LIMIT 1 [["id", 3]]
Rendered shared/_viewers_hover.html.erb (6.0ms)
Category Load (0.9ms) SELECT "categories".* FROM "categories" WHERE "categories"."id" = $1 ORDER BY "categories"."id" ASC LIMIT 1 [["id", 1]]
CACHE (0.1ms) SELECT "categories".* FROM "categories" WHERE "categories"."id" = $1 ORDER BY "categories"."id" ASC LIMIT 1 [["id", 1]]
Rendered shared/_modal.html.erb (0.2ms)
Rendered notifications/_preview.html.erb (2.7ms)
Mood Load (0.8ms) SELECT "moods".* FROM "moods" WHERE "moods"."id" = $1 ORDER BY "moods"."id" ASC LIMIT 1 [["id", 1]]
CACHE (0.0ms) SELECT "moods".* FROM "moods" WHERE "moods"."id" = $1 ORDER BY "moods"."id" ASC LIMIT 1 [["id", 1]]
Rendered shared/_modal.html.erb (0.1ms)
Rendered notifications/_preview.html.erb (1.9ms)
Mood Load (0.8ms) SELECT "moods".* FROM "moods" WHERE "moods"."id" = $1 ORDER BY "moods"."id" ASC LIMIT 1 [["id", 2]]
CACHE (0.1ms) SELECT "moods".* FROM "moods" WHERE "moods"."id" = $1 ORDER BY "moods"."id" ASC LIMIT 1 [["id", 2]]
Rendered shared/_modal.html.erb (0.1ms)
Rendered notifications/_preview.html.erb (1.9ms)
Rendered moments/_info.html.erb (34.7ms)
Rendered pages/home.html.erb within layouts/application (338.0ms)
Rendered layouts/_title.html.erb (5.2ms)
(3.3ms) SELECT COUNT(*) FROM "notifications"
Rendered shared/_modal.html.erb (131.6ms)
Rendered notifications/_list.html.erb (139.7ms)
Rendered shared/_menu_logo.html.erb (1.0ms)
Rendered shared/_header.html.erb (978.0ms)
Rendered shared/_locale.html.erb (1.4ms)
Rendered shared/_footer.html.erb (16.8ms)
Completed 200 OK in 6644ms (Views: 6134.1ms | ActiveRecord: 149.9ms)
Started GET "/" for ::1 at 2017-07-20 09:50:57 -0400
Processing by PagesController#home as HTML
User Load (3.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 1]]
Allyship Load (0.8ms) SELECT "allyships".* FROM "allyships" WHERE "allyships"."user_id" = $1 AND "allyships"."status" = $2 [["user_id", 1], ["status", 0]]
User Load (2.2ms) SELECT "users".* FROM "users" WHERE "users"."id" IN (2, 3)
Moment Load (1.6ms) SELECT "moments".* FROM "moments" WHERE "moments"."userid" = $1 ORDER BY created_at DESC [["userid", 2]]
Strategy Load (0.7ms) SELECT "strategies".* FROM "strategies" WHERE "strategies"."userid" = $1 ORDER BY created_at DESC [["userid", 2]]
Moment Load (0.7ms) SELECT "moments".* FROM "moments" WHERE "moments"."userid" = $1 ORDER BY created_at DESC [["userid", 3]]
Strategy Load (0.7ms) SELECT "strategies".* FROM "strategies" WHERE "strategies"."userid" = $1 ORDER BY created_at DESC [["userid", 3]]
Moment Load (0.8ms) SELECT "moments".* FROM "moments" WHERE "moments"."userid" = $1 ORDER BY created_at DESC [["userid", 1]]
Strategy Load (0.7ms) SELECT "strategies".* FROM "strategies" WHERE "strategies"."userid" = $1 ORDER BY created_at DESC [["userid", 1]]
(0.9ms) SELECT COUNT(*) FROM "moments" WHERE "moments"."id" IN (1, 2)
Moment Load (1.3ms) SELECT "moments".* FROM "moments" WHERE "moments"."id" IN (1, 2) ORDER BY created_at DESC
Strategy Load (0.8ms) SELECT "strategies".* FROM "strategies" WHERE 1=0 ORDER BY created_at DESC
Rendered shared/_character_count.html.erb (0.4ms)
Category Load (4.3ms) SELECT "categories".* FROM "categories" WHERE "categories"."userid" = $1 ORDER BY "categories"."created_at" DESC [["userid", 1]]
Mood Load (0.8ms) SELECT "moods".* FROM "moods" WHERE "moods"."userid" = $1 ORDER BY "moods"."created_at" DESC [["userid", 1]]
Rendered shared/_modal.html.erb (0.2ms)
Rendered shared/_modal.html.erb (0.2ms)
Rendered notifications/_preview.html.erb (2.4ms)
Rendered shared/_modal.html.erb (0.2ms)
Rendered notifications/_preview.html.erb (2.3ms)
Rendered shared/_modal.html.erb (0.2ms)
Rendered notifications/_preview.html.erb (2.3ms)
Rendered notifications/_categories_moods.html.erb (30.6ms)
Rendered moments/_quick_moment.html.erb (38.6ms)
User Load (1.2ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 LIMIT 1 [["id", 1]]
User Load (5.4ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 LIMIT 1 [["id", 2]]
CACHE (0.0ms) SELECT "allyships".* FROM "allyships" WHERE "allyships"."user_id" = $1 AND "allyships"."status" = $2 [["user_id", 1], ["status", 0]]
CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" IN (2, 3)
Allyship Load (0.7ms) SELECT "allyships".* FROM "allyships" WHERE "allyships"."user_id" = $1 AND "allyships"."status" = $2 [["user_id", 2], ["status", 0]]
User Load (1.7ms) SELECT "users".* FROM "users" WHERE "users"."id" IN (1)
Rendered shared/_viewers_hover.html.erb (0.2ms)
User Load (1.2ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 2]]
CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 2]]
Category Load (1.6ms) SELECT "categories".* FROM "categories" WHERE "categories"."id" = $1 ORDER BY "categories"."id" ASC LIMIT 1 [["id", 2]]
CACHE (0.1ms) SELECT "categories".* FROM "categories" WHERE "categories"."id" = $1 ORDER BY "categories"."id" ASC LIMIT 1 [["id", 2]]
Rendered shared/_modal.html.erb (0.2ms)
CACHE (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 2]]
CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 2]]
Rendered notifications/_preview.html.erb (9.6ms)
Mood Load (1.0ms) SELECT "moods".* FROM "moods" WHERE "moods"."id" = $1 ORDER BY "moods"."id" ASC LIMIT 1 [["id", 3]]
CACHE (0.1ms) SELECT "moods".* FROM "moods" WHERE "moods"."id" = $1 ORDER BY "moods"."id" ASC LIMIT 1 [["id", 3]]
Rendered shared/_modal.html.erb (0.2ms)
CACHE (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 2]]
CACHE (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 2]]
Rendered notifications/_preview.html.erb (22.1ms)
Rendered moments/_info.html.erb (76.1ms)
CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 LIMIT 1 [["id", 2]]
User Load (1.4ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 LIMIT 1 [["id", 3]]
Rendered shared/_viewers_hover.html.erb (12.0ms)
Category Load (1.4ms) SELECT "categories".* FROM "categories" WHERE "categories"."id" = $1 ORDER BY "categories"."id" ASC LIMIT 1 [["id", 1]]
CACHE (0.0ms) SELECT "categories".* FROM "categories" WHERE "categories"."id" = $1 ORDER BY "categories"."id" ASC LIMIT 1 [["id", 1]]
Rendered shared/_modal.html.erb (0.2ms)
Rendered notifications/_preview.html.erb (3.5ms)
Mood Load (1.5ms) SELECT "moods".* FROM "moods" WHERE "moods"."id" = $1 ORDER BY "moods"."id" ASC LIMIT 1 [["id", 1]]
CACHE (0.1ms) SELECT "moods".* FROM "moods" WHERE "moods"."id" = $1 ORDER BY "moods"."id" ASC LIMIT 1 [["id", 1]]
Rendered shared/_modal.html.erb (0.2ms)
Rendered notifications/_preview.html.erb (2.6ms)
Mood Load (1.0ms) SELECT "moods".* FROM "moods" WHERE "moods"."id" = $1 ORDER BY "moods"."id" ASC LIMIT 1 [["id", 2]]
CACHE (0.0ms) SELECT "moods".* FROM "moods" WHERE "moods"."id" = $1 ORDER BY "moods"."id" ASC LIMIT 1 [["id", 2]]
Rendered shared/_modal.html.erb (0.1ms)
Rendered notifications/_preview.html.erb (2.1ms)
Rendered moments/_info.html.erb (38.5ms)
Rendered pages/home.html.erb within layouts/application (217.0ms)
Rendered layouts/_title.html.erb (1.5ms)
(22.0ms) SELECT COUNT(*) FROM "notifications"
Rendered shared/_modal.html.erb (26.1ms)
Rendered notifications/_list.html.erb (30.1ms)
Rendered shared/_menu_logo.html.erb (0.2ms)
Rendered shared/_header.html.erb (62.1ms)
Rendered shared/_locale.html.erb (1.8ms)
Rendered shared/_footer.html.erb (23.7ms)
Completed 200 OK in 1638ms (Views: 1540.2ms | ActiveRecord: 60.2ms)
Started DELETE "/users/sign_out" for ::1 at 2017-07-20 09:50:59 -0400
Processing by Devise::SessionsController#destroy as HTML
Parameters: {"authenticity_token"=>"N8/IaLD1tRu1aTJAzEIIv8bPP/GDt46ddQ7ySClOUFvOPulwCfZPIUL0xODG6dO86vigXandYY1BzM2cqVZ8Wg=="}
User Load (31.4ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 1]]
(2.2ms) BEGIN
(0.5ms) COMMIT
Redirected to http://localhost:3000/
Completed 302 Found in 88ms (ActiveRecord: 34.1ms)
Started GET "/" for ::1 at 2017-07-20 09:50:59 -0400
Processing by PagesController#home as HTML
User Load (1.2ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 1]]
Allyship Load (0.8ms) SELECT "allyships".* FROM "allyships" WHERE "allyships"."user_id" = $1 AND "allyships"."status" = $2 [["user_id", 1], ["status", 0]]
User Load (8.3ms) SELECT "users".* FROM "users" WHERE "users"."id" IN (2, 3)
Moment Load (0.7ms) SELECT "moments".* FROM "moments" WHERE "moments"."userid" = $1 ORDER BY created_at DESC [["userid", 2]]
Strategy Load (1.6ms) SELECT "strategies".* FROM "strategies" WHERE "strategies"."userid" = $1 ORDER BY created_at DESC [["userid", 2]]
Moment Load (15.2ms) SELECT "moments".* FROM "moments" WHERE "moments"."userid" = $1 ORDER BY created_at DESC [["userid", 3]]
Strategy Load (5.0ms) SELECT "strategies".* FROM "strategies" WHERE "strategies"."userid" = $1 ORDER BY created_at DESC [["userid", 3]]
Moment Load (20.7ms) SELECT "moments".* FROM "moments" WHERE "moments"."userid" = $1 ORDER BY created_at DESC [["userid", 1]]
Strategy Load (8.9ms) SELECT "strategies".* FROM "strategies" WHERE "strategies"."userid" = $1 ORDER BY created_at DESC [["userid", 1]]
(1.0ms) SELECT COUNT(*) FROM "moments" WHERE "moments"."id" IN (1, 2)
Moment Load (8.4ms) SELECT "moments".* FROM "moments" WHERE "moments"."id" IN (1, 2) ORDER BY created_at DESC
Strategy Load (4.4ms) SELECT "strategies".* FROM "strategies" WHERE 1=0 ORDER BY created_at DESC
Rendered shared/_character_count.html.erb (3.1ms)
Category Load (1.0ms) SELECT "categories".* FROM "categories" WHERE "categories"."userid" = $1 ORDER BY "categories"."created_at" DESC [["userid", 1]]
Mood Load (1.0ms) SELECT "moods".* FROM "moods" WHERE "moods"."userid" = $1 ORDER BY "moods"."created_at" DESC [["userid", 1]]
Rendered shared/_modal.html.erb (1.9ms)
Rendered shared/_modal.html.erb (1.8ms)
Rendered notifications/_preview.html.erb (6.4ms)
Rendered shared/_modal.html.erb (0.1ms)
Rendered notifications/_preview.html.erb (2.1ms)
Rendered shared/_modal.html.erb (0.2ms)
Rendered notifications/_preview.html.erb (2.0ms)
Rendered notifications/_categories_moods.html.erb (35.6ms)
Rendered moments/_quick_moment.html.erb (61.1ms)
User Load (0.8ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 LIMIT 1 [["id", 1]]
User Load (0.7ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 LIMIT 1 [["id", 2]]
CACHE (0.1ms) SELECT "allyships".* FROM "allyships" WHERE "allyships"."user_id" = $1 AND "allyships"."status" = $2 [["user_id", 1], ["status", 0]]
CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" IN (2, 3)
Allyship Load (0.7ms) SELECT "allyships".* FROM "allyships" WHERE "allyships"."user_id" = $1 AND "allyships"."status" = $2 [["user_id", 2], ["status", 0]]
User Load (1.1ms) SELECT "users".* FROM "users" WHERE "users"."id" IN (1)
Rendered shared/_viewers_hover.html.erb (1.0ms)
User Load (0.7ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 2]]
CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 2]]
Category Load (0.8ms) SELECT "categories".* FROM "categories" WHERE "categories"."id" = $1 ORDER BY "categories"."id" ASC LIMIT 1 [["id", 2]]
CACHE (0.1ms) SELECT "categories".* FROM "categories" WHERE "categories"."id" = $1 ORDER BY "categories"."id" ASC LIMIT 1 [["id", 2]]
Rendered shared/_modal.html.erb (0.2ms)
CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 2]]
CACHE (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 2]]
Rendered notifications/_preview.html.erb (8.5ms)
Mood Load (0.6ms) SELECT "moods".* FROM "moods" WHERE "moods"."id" = $1 ORDER BY "moods"."id" ASC LIMIT 1 [["id", 3]]
CACHE (0.0ms) SELECT "moods".* FROM "moods" WHERE "moods"."id" = $1 ORDER BY "moods"."id" ASC LIMIT 1 [["id", 3]]
Rendered shared/_modal.html.erb (0.1ms)
CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 2]]
CACHE (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 2]]
Rendered notifications/_preview.html.erb (7.7ms)
Rendered moments/_info.html.erb (71.0ms)
CACHE (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 LIMIT 1 [["id", 2]]
User Load (0.8ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 LIMIT 1 [["id", 3]]
Rendered shared/_viewers_hover.html.erb (10.4ms)
Category Load (1.2ms) SELECT "categories".* FROM "categories" WHERE "categories"."id" = $1 ORDER BY "categories"."id" ASC LIMIT 1 [["id", 1]]
CACHE (0.0ms) SELECT "categories".* FROM "categories" WHERE "categories"."id" = $1 ORDER BY "categories"."id" ASC LIMIT 1 [["id", 1]]
Rendered shared/_modal.html.erb (0.1ms)
Rendered notifications/_preview.html.erb (2.1ms)
Mood Load (0.6ms) SELECT "moods".* FROM "moods" WHERE "moods"."id" = $1 ORDER BY "moods"."id" ASC LIMIT 1 [["id", 1]]
CACHE (0.1ms) SELECT "moods".* FROM "moods" WHERE "moods"."id" = $1 ORDER BY "moods"."id" ASC LIMIT 1 [["id", 1]]
Rendered shared/_modal.html.erb (0.2ms)
Rendered notifications/_preview.html.erb (2.1ms)
Mood Load (0.6ms) SELECT "moods".* FROM "moods" WHERE "moods"."id" = $1 ORDER BY "moods"."id" ASC LIMIT 1 [["id", 2]]
CACHE (0.0ms) SELECT "moods".* FROM "moods" WHERE "moods"."id" = $1 ORDER BY "moods"."id" ASC LIMIT 1 [["id", 2]]
Rendered shared/_modal.html.erb (0.1ms)
Rendered notifications/_preview.html.erb (2.1ms)
Rendered moments/_info.html.erb (31.2ms)
Rendered pages/home.html.erb within layouts/application (228.3ms)
Rendered layouts/_title.html.erb (3.7ms)
(1.5ms) SELECT COUNT(*) FROM "notifications"
Rendered shared/_modal.html.erb (5.7ms)
Rendered notifications/_list.html.erb (8.8ms)
Rendered shared/_menu_logo.html.erb (2.1ms)
Rendered shared/_header.html.erb (67.2ms)
Rendered shared/_locale.html.erb (2.2ms)
Rendered shared/_footer.html.erb (16.8ms)
Completed 200 OK in 1398ms (Views: 1217.2ms | ActiveRecord: 89.4ms)
Started GET "/notifications/signed_in" for ::1 at 2017-07-20 09:51:07 -0400
Processing by NotificationsController#signed_in as JSON
User Load (59.8ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 1]]
Completed 200 OK in 92ms (Views: 2.9ms | ActiveRecord: 59.8ms)
Started GET "/notifications/fetch_notifications" for ::1 at 2017-07-20 09:51:08 -0400
Processing by NotificationsController#fetch_notifications as TEXT
User Load (0.9ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 1]]
Notification Load (8.1ms) SELECT "notifications".* FROM "notifications" WHERE "notifications"."userid" = $1 ORDER BY created_at ASC [["userid", 1]]
Completed 200 OK in 42ms (Views: 25.4ms | ActiveRecord: 9.0ms)
Started DELETE "/users/sign_out" for ::1 at 2017-07-20 09:51:14 -0400
Processing by Devise::SessionsController#destroy as HTML
Parameters: {"authenticity_token"=>"ypjiHVSOi5pWX39KM8i+WkUnkQ+V9q4/qwfszG6L3f4zacMF7Y1xoKHCieo5Y2VZaRAOo7+cQS+fxdMY7pPx/w=="}
User Load (0.9ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 1]]
(1.0ms) BEGIN
(1.0ms) COMMIT
Redirected to http://localhost:3000/
Completed 302 Found in 20ms (ActiveRecord: 2.9ms)
Started GET "/" for ::1 at 2017-07-20 09:51:14 -0400
Processing by PagesController#home as HTML
Rendered pages/_not_signed_in.html.erb (15.9ms)
Rendered pages/home.html.erb within layouts/application (20.7ms)
Rendered layouts/_title.html.erb (1.2ms)
(35.2ms) SELECT COUNT(*) FROM "notifications"
Rendered shared/_modal.html.erb (37.3ms)
Rendered notifications/_list.html.erb (39.6ms)
Rendered shared/_menu_logo.html.erb (0.4ms)
Rendered shared/_header.html.erb (7.8ms)
Rendered shared/_locale.html.erb (0.6ms)
Rendered shared/_footer.html.erb (10.2ms)
Completed 200 OK in 1825ms (Views: 838.0ms | ActiveRecord: 35.2ms)
Started GET "/notifications/signed_in" for ::1 at 2017-07-20 09:51:19 -0400
Processing by NotificationsController#signed_in as JSON
Filter chain halted as :if_not_signed_in rendered or redirected
Completed 204 No Content in 10ms (ActiveRecord: 0.0ms)
Started GET "/users/sign_up" for ::1 at 2017-07-20 09:51:31 -0400
Processing by RegistrationsController#new as HTML
Rendered devise/shared/_links.erb (189.8ms)
Rendered devise/registrations/new.html.erb within layouts/application (263.8ms)
Rendered layouts/_title.html.erb (1.2ms)
(9.4ms) SELECT COUNT(*) FROM "notifications"
Rendered shared/_modal.html.erb (15.6ms)
Rendered notifications/_list.html.erb (18.2ms)
Rendered shared/_menu_logo.html.erb (0.4ms)
Rendered shared/_header.html.erb (9.2ms)
Rendered shared/_locale.html.erb (0.7ms)
Rendered shared/_footer.html.erb (25.1ms)
Completed 200 OK in 1888ms (Views: 1830.0ms | ActiveRecord: 9.4ms)
Started GET "/notifications/signed_in" for ::1 at 2017-07-20 09:51:34 -0400
Processing by NotificationsController#signed_in as JSON
Filter chain halted as :if_not_signed_in rendered or redirected
Completed 204 No Content in 17ms (ActiveRecord: 0.0ms)
Started POST "/users/auth/google_oauth2" for ::1 at 2017-07-20 09:51:42 -0400
I, [2017-07-20T09:51:42.459975 #17327] INFO -- omniauth: (google_oauth2) Request phase initiated.
Started GET "/users/auth/google_oauth2/callback?state=e5c8da9589095f59fd890da7133f7792ef6332e72f7606fe&code=4/8wlSOiiQRwh5G67EmoD2vA32-y_QkXI2rqXH8XSAVBk" for ::1 at 2017-07-20 09:52:04 -0400
I, [2017-07-20T09:52:04.714683 #17327] INFO -- omniauth: (google_oauth2) Callback phase initiated.
Processing by OmniauthCallbacksController#google_oauth2 as HTML
Parameters: {"state"=>"e5c8da9589095f59fd890da7133f7792ef6332e72f7606fe", "code"=>"4/8wlSOiiQRwh5G67EmoD2vA32-y_QkXI2rqXH8XSAVBk"}
User Load (7.7ms) SELECT "users".* FROM "users" WHERE "users"."email" = $1 LIMIT 1 [["email", "shelleyvadams@gmail.com"]]
(8.1ms) BEGIN
User Exists (14.7ms) SELECT 1 AS one FROM "users" WHERE "users"."email" = 'shelleyvadams@gmail.com' LIMIT 1
SQL (33.2ms) INSERT INTO "users" ("email", "name", "encrypted_password", "provider", "token", "uid", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5, $6, $7, $8) RETURNING "id" [["email", "shelleyvadams@gmail.com"], ["name", "Shelley Adams"], ["encrypted_password", "$2a$10$epe1tTWou5JfQ5xPkQWXve9YONzABsocHJExTlZv4HUI7l5Z6tGw2"], ["provider", "google_oauth2"], ["token", "ya29.GluNBPOibKqNLW8pK_O7dyx5l3nTI5f72uHWj7HJK35mcLwZt0kslBeuAinMrcdaXkQdkZk66T1-7DciwXDz6gHuHm-tj4f2aDviW2kumBreafWP5W6aCi7lid7h"], ["uid", "114367087881681965892"], ["created_at", "2017-07-20 13:52:07.012679"], ["updated_at", "2017-07-20 13:52:07.012679"]]
(15.0ms) COMMIT
(5.9ms) BEGIN
SQL (13.5ms) UPDATE "users" SET "last_sign_in_at" = $1, "current_sign_in_at" = $2, "last_sign_in_ip" = $3, "current_sign_in_ip" = $4, "sign_in_count" = $5, "updated_at" = $6 WHERE "users"."id" = $7 [["last_sign_in_at", "2017-07-20 13:52:07.115330"], ["current_sign_in_at", "2017-07-20 13:52:07.115330"], ["last_sign_in_ip", "::1"], ["current_sign_in_ip", "::1"], ["sign_in_count", 1], ["updated_at", "2017-07-20 13:52:07.129173"], ["id", 4]]
(5.2ms) COMMIT
Redirected to http://localhost:3000/
Completed 302 Found in 528ms (ActiveRecord: 103.2ms)
Started GET "/" for ::1 at 2017-07-20 09:52:08 -0400
Processing by PagesController#home as HTML
User Load (3.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 4]]
Allyship Load (4.8ms) SELECT "allyships".* FROM "allyships" WHERE "allyships"."user_id" = $1 AND "allyships"."status" = $2 [["user_id", 4], ["status", 0]]
Moment Load (1.9ms) SELECT "moments".* FROM "moments" WHERE "moments"."userid" = $1 ORDER BY created_at DESC [["userid", 4]]
Strategy Load (2.0ms) SELECT "strategies".* FROM "strategies" WHERE "strategies"."userid" = $1 ORDER BY created_at DESC [["userid", 4]]
(10.2ms) SELECT COUNT(*) FROM "moments" WHERE 1=0
Strategy Load (5.4ms) SELECT "strategies".* FROM "strategies" WHERE 1=0 ORDER BY created_at DESC
Rendered pages/_signed_in_empty.html.erb (22.9ms)
Rendered pages/home.html.erb within layouts/application (38.2ms)
Rendered layouts/_title.html.erb (2.4ms)
(6.9ms) SELECT COUNT(*) FROM "notifications"
Rendered shared/_modal.html.erb (9.2ms)
Rendered notifications/_list.html.erb (12.3ms)
Rendered shared/_menu_logo.html.erb (0.2ms)
Rendered shared/_header.html.erb (44.5ms)
Rendered shared/_locale.html.erb (0.5ms)
Rendered shared/_footer.html.erb (9.8ms)
Completed 200 OK in 1514ms (Views: 1423.6ms | ActiveRecord: 34.2ms)
Started GET "/notifications/signed_in" for ::1 at 2017-07-20 09:52:15 -0400
Processing by NotificationsController#signed_in as JSON
User Load (4.9ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 4]]
Completed 200 OK in 17ms (Views: 4.9ms | ActiveRecord: 4.9ms)
Started GET "/notifications/fetch_notifications" for ::1 at 2017-07-20 09:52:15 -0400
Processing by NotificationsController#fetch_notifications as TEXT
User Load (1.7ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 4]]
Notification Load (20.5ms) SELECT "notifications".* FROM "notifications" WHERE "notifications"."userid" = $1 ORDER BY created_at ASC [["userid", 4]]
Completed 200 OK in 46ms (Views: 4.9ms | ActiveRecord: 22.1ms)
Started GET "/medications" for ::1 at 2017-07-20 09:52:26 -0400
Processing by MedicationsController#index as HTML
User Load (20.4ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 4]]
Medication Exists (17.9ms) SELECT 1 AS one FROM "medications" WHERE (name ilike '%%' AND userid = 4) LIMIT 1
Medication Load (1.0ms) SELECT "medications".* FROM "medications" WHERE "medications"."userid" = $1 ORDER BY created_at DESC LIMIT 6 OFFSET 0 [["userid", 4]]
Rendered medications/index.html.erb within layouts/application (19.8ms)
Rendered layouts/_title.html.erb (1.9ms)
(1.3ms) SELECT COUNT(*) FROM "notifications"
Rendered shared/_modal.html.erb (4.7ms)
Rendered notifications/_list.html.erb (7.9ms)
Rendered shared/_menu_logo.html.erb (0.3ms)
Rendered shared/_header.html.erb (44.9ms)
Rendered shared/_locale.html.erb (0.7ms)
Rendered shared/_footer.html.erb (12.4ms)
Completed 200 OK in 1904ms (Views: 1618.1ms | ActiveRecord: 62.4ms)
Started GET "/notifications/signed_in" for ::1 at 2017-07-20 09:52:29 -0400
Processing by NotificationsController#signed_in as JSON
User Load (4.6ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 4]]
Completed 200 OK in 19ms (Views: 2.3ms | ActiveRecord: 4.6ms)
Started GET "/medications/new" for ::1 at 2017-07-20 09:53:06 -0400
Processing by MedicationsController#new as HTML
User Load (12.6ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 4]]
Rendered medications/_form.html.erb (67.9ms)
Rendered medications/new.html.erb within layouts/application (77.5ms)
Rendered layouts/_title.html.erb (3.5ms)
(1.2ms) SELECT COUNT(*) FROM "notifications"
Rendered shared/_modal.html.erb (4.3ms)
Rendered notifications/_list.html.erb (7.0ms)
Rendered shared/_menu_logo.html.erb (0.1ms)
Rendered shared/_header.html.erb (36.0ms)
Rendered shared/_locale.html.erb (0.5ms)
Rendered shared/_footer.html.erb (9.6ms)
Completed 200 OK in 1388ms (Views: 956.4ms | ActiveRecord: 32.6ms)
Started GET "/notifications/signed_in" for ::1 at 2017-07-20 09:53:08 -0400
Processing by NotificationsController#signed_in as JSON
User Load (1.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 4]]
Completed 200 OK in 22ms (Views: 0.9ms | ActiveRecord: 1.1ms)
Started POST "/medications" for ::1 at 2017-07-20 09:53:48 -0400
Processing by MedicationsController#create as HTML
Parameters: {"utf8"=>"���", "authenticity_token"=>"eAxI8hJS0xR0tu+McKta6S6zwCuA/yoNjH1QOi4OJyMuEF2Zwc6KccJTbdEx0Y1qP6ikZ1ba+qM0U4WSt5VJbg==", "medication"=>{"name"=>"Tylenol", "strength"=>"500", "strength_unit"=>"mg", "total"=>"150", "total_unit"=>"tablets", "dosage"=>"8", "dosage_unit"=>"tablets", "refill"=>"08/31/2017", "comments"=>"", "refill_reminder_attributes"=>{"active"=>"false"}, "take_medication_reminder_attributes"=>{"active"=>"false"}, "add_to_google_cal"=>"0", "userid"=>"4"}, "commit"=>"Submit"}
User Load (2.8ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 4]]
(2.4ms) BEGIN
Medication Exists (3.5ms) SELECT 1 AS one FROM "medications" WHERE ("medications"."id" IS NOT NULL) AND "medications"."slug" = $1 LIMIT 1 [["slug", "tylenol"]]
SQL (2.6ms) INSERT INTO "medications" ("name", "dosage", "refill", "userid", "total", "strength", "dosage_unit", "total_unit", "strength_unit", "comments", "slug", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5, $6, $7, $8, $9, $10, $11, $12, $13) RETURNING "id" [["name", "Tylenol"], ["dosage", 8], ["refill", "08/31/2017"], ["userid", 4], ["total", 150], ["strength", 500], ["dosage_unit", "tablets"], ["total_unit", "tablets"], ["strength_unit", "mg"], ["comments", ""], ["slug", "tylenol"], ["created_at", "2017-07-20 13:53:48.954727"], ["updated_at", "2017-07-20 13:53:48.954727"]]
SQL (3.1ms) INSERT INTO "take_medication_reminders" ("active", "medication_id", "created_at", "updated_at") VALUES ($1, $2, $3, $4) RETURNING "id" [["active", "f"], ["medication_id", 3], ["created_at", "2017-07-20 13:53:48.965822"], ["updated_at", "2017-07-20 13:53:48.965822"]]
SQL (1.5ms) INSERT INTO "refill_reminders" ("active", "medication_id", "created_at", "updated_at") VALUES ($1, $2, $3, $4) RETURNING "id" [["active", "f"], ["medication_id", 3], ["created_at", "2017-07-20 13:53:48.973856"], ["updated_at", "2017-07-20 13:53:48.973856"]]
(3.7ms) COMMIT
Redirected to http://localhost:3000/medications/tylenol
Completed 302 Found in 1982ms (ActiveRecord: 19.6ms)
Started GET "/medications/tylenol" for ::1 at 2017-07-20 09:53:50 -0400
Processing by MedicationsController#show as HTML
Parameters: {"id"=>"tylenol"}
User Load (0.9ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 4]]
Medication Load (1.4ms) SELECT "medications".* FROM "medications" WHERE "medications"."slug" = $1 ORDER BY "medications"."id" ASC LIMIT 1 [["slug", "tylenol"]]
RefillReminder Load (1.8ms) SELECT "refill_reminders".* FROM "refill_reminders" WHERE "refill_reminders"."medication_id" = $1 LIMIT 1 [["medication_id", 3]]
TakeMedicationReminder Load (0.8ms) SELECT "take_medication_reminders".* FROM "take_medication_reminders" WHERE "take_medication_reminders"."medication_id" = $1 LIMIT 1 [["medication_id", 3]]
Rendered medications/show.html.erb within layouts/application (15.6ms)
Rendered layouts/_title.html.erb (1.3ms)
(1.0ms) SELECT COUNT(*) FROM "notifications"
Rendered shared/_modal.html.erb (4.4ms)
Rendered notifications/_list.html.erb (6.6ms)
Rendered shared/_menu_logo.html.erb (0.2ms)
Rendered shared/_header.html.erb (81.7ms)
Rendered shared/_locale.html.erb (1.6ms)
Rendered shared/_footer.html.erb (26.0ms)
Completed 200 OK in 1187ms (Views: 1169.6ms | ActiveRecord: 5.9ms)
Started GET "/notifications/signed_in" for ::1 at 2017-07-20 09:53:56 -0400
Processing by NotificationsController#signed_in as JSON
User Load (23.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 4]]
Completed 200 OK in 52ms (Views: 3.4ms | ActiveRecord: 23.1ms)
Started GET "/medications" for ::1 at 2017-07-20 10:11:23 -0400
Processing by MedicationsController#index as HTML
User Load (7.4ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 4]]
Medication Exists (6.4ms) SELECT 1 AS one FROM "medications" WHERE (name ilike '%%' AND userid = 4) LIMIT 1
Medication Load (2.2ms) SELECT "medications".* FROM "medications" WHERE "medications"."userid" = $1 ORDER BY created_at DESC LIMIT 6 OFFSET 0 [["userid", 4]]
Rendered search/_posts.html.erb (38.3ms)
RefillReminder Load (1.2ms) SELECT "refill_reminders".* FROM "refill_reminders" WHERE "refill_reminders"."medication_id" = $1 LIMIT 1 [["medication_id", 3]]
TakeMedicationReminder Load (1.0ms) SELECT "take_medication_reminders".* FROM "take_medication_reminders" WHERE "take_medication_reminders"."medication_id" = $1 LIMIT 1 [["medication_id", 3]]
Rendered medications/_medication.html.erb (30.1ms)
(1.1ms) SELECT COUNT(*) FROM "medications" WHERE "medications"."userid" = $1 [["userid", 4]]
Rendered medications/index.html.erb within layouts/application (246.0ms)
Rendered layouts/_title.html.erb (4.3ms)
(2.6ms) SELECT COUNT(*) FROM "notifications"
Rendered shared/_modal.html.erb (6.6ms)
Rendered notifications/_list.html.erb (12.1ms)
Rendered shared/_menu_logo.html.erb (0.4ms)
Rendered shared/_header.html.erb (35.8ms)
Rendered shared/_locale.html.erb (0.7ms)
Rendered shared/_footer.html.erb (10.4ms)
Completed 200 OK in 1989ms (Views: 1874.7ms | ActiveRecord: 21.9ms)
Started GET "/notifications/signed_in" for ::1 at 2017-07-20 10:11:27 -0400
Processing by NotificationsController#signed_in as JSON
User Load (6.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 4]]
Completed 200 OK in 22ms (Views: 0.6ms | ActiveRecord: 6.0ms)
Started DELETE "/medications/tylenol" for ::1 at 2017-07-20 10:14:00 -0400
Processing by MedicationsController#destroy as HTML
Parameters: {"authenticity_token"=>"SNQ5Ksk+D7zNCljC57we7P5jryN191oyLD3UXyMTIPEeyCxBGqJW2Xvv2p+mxslv73jLb6PSipyUEwH3uohOvA==", "id"=>"tylenol"}
User Load (6.7ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 4]]
Medication Load (9.0ms) SELECT "medications".* FROM "medications" WHERE "medications"."slug" = $1 ORDER BY "medications"."id" ASC LIMIT 1 [["slug", "tylenol"]]
(1.5ms) BEGIN
SQL (1.2ms) DELETE FROM "medications" WHERE "medications"."id" = $1 [["id", 3]]
(5.6ms) COMMIT
Redirected to http://localhost:3000/medications
Completed 302 Found in 154ms (ActiveRecord: 24.0ms)
Started GET "/medications" for ::1 at 2017-07-20 10:14:01 -0400
Processing by MedicationsController#index as HTML
User Load (1.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 4]]
Medication Exists (5.7ms) SELECT 1 AS one FROM "medications" WHERE (name ilike '%%' AND userid = 4) LIMIT 1
Medication Load (1.9ms) SELECT "medications".* FROM "medications" WHERE "medications"."userid" = $1 ORDER BY created_at DESC LIMIT 6 OFFSET 0 [["userid", 4]]
Rendered medications/index.html.erb within layouts/application (29.4ms)
Rendered layouts/_title.html.erb (16.9ms)
(5.3ms) SELECT COUNT(*) FROM "notifications"
Rendered shared/_modal.html.erb (9.3ms)
Rendered notifications/_list.html.erb (12.4ms)
Rendered shared/_menu_logo.html.erb (0.2ms)
Rendered shared/_header.html.erb (46.4ms)
Rendered shared/_locale.html.erb (0.9ms)
Rendered shared/_footer.html.erb (11.6ms)
Completed 200 OK in 1186ms (Views: 1142.1ms | ActiveRecord: 14.0ms)
Started GET "/notifications/signed_in" for ::1 at 2017-07-20 10:14:07 -0400
Processing by NotificationsController#signed_in as JSON
User Load (37.5ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 4]]
Completed 200 OK in 58ms (Views: 2.4ms | ActiveRecord: 37.5ms)
Started GET "/medications/new" for ::1 at 2017-07-20 10:17:58 -0400
Processing by MedicationsController#new as HTML
User Load (6.8ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 4]]
Rendered medications/_form.html.erb (57.6ms)
Rendered medications/new.html.erb within layouts/application (64.3ms)
Rendered layouts/_title.html.erb (4.4ms)
(29.7ms) SELECT COUNT(*) FROM "notifications"
Rendered shared/_modal.html.erb (36.3ms)
Rendered notifications/_list.html.erb (41.3ms)
Rendered shared/_menu_logo.html.erb (0.2ms)
Rendered shared/_header.html.erb (47.1ms)
Rendered shared/_locale.html.erb (2.1ms)
Rendered shared/_footer.html.erb (16.2ms)
Completed 200 OK in 1530ms (Views: 1413.4ms | ActiveRecord: 36.5ms)
Started GET "/notifications/signed_in" for ::1 at 2017-07-20 10:18:01 -0400
Processing by NotificationsController#signed_in as JSON
User Load (13.3ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 4]]
Completed 200 OK in 32ms (Views: 1.5ms | ActiveRecord: 13.3ms)
Started GET "/medications/new" for ::1 at 2017-07-20 10:39:28 -0400
Processing by MedicationsController#new as HTML
User Load (10.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 4]]
Rendered medications/_form.html.erb (66.6ms)
Rendered medications/new.html.erb within layouts/application (73.0ms)
Rendered layouts/_title.html.erb (8.5ms)
(30.2ms) SELECT COUNT(*) FROM "notifications"
Rendered shared/_modal.html.erb (38.3ms)
Rendered notifications/_list.html.erb (46.7ms)
Rendered shared/_menu_logo.html.erb (0.3ms)
Rendered shared/_header.html.erb (185.0ms)
Rendered shared/_locale.html.erb (0.6ms)
Rendered shared/_footer.html.erb (19.9ms)
Completed 200 OK in 1597ms (Views: 1469.5ms | ActiveRecord: 40.1ms)
Started GET "/notifications/signed_in" for ::1 at 2017-07-20 10:39:31 -0400
Processing by NotificationsController#signed_in as JSON
User Load (18.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 4]]
Completed 200 OK in 36ms (Views: 2.1ms | ActiveRecord: 18.1ms)
Started POST "/medications" for ::1 at 2017-07-20 10:40:03 -0400
Processing by MedicationsController#create as HTML
Parameters: {"utf8"=>"���", "authenticity_token"=>"DDWn3yC0VswJ5BbwqTbjpe/qlhGCQsH0GPU1+skdnKdaKbK08ygPqb8BlK3oTDQm/vHyXVRnEVqg2+BSUIby6g==", "medication"=>{"name"=>"Asprin", "strength"=>"84", "strength_unit"=>"mg", "total"=>"30", "total_unit"=>"tablets", "dosage"=>"1", "dosage_unit"=>"tablets", "refill"=>"07/21/2017", "comments"=>"", "refill_reminder_attributes"=>{"active"=>"false"}, "take_medication_reminder_attributes"=>{"active"=>"false"}, "add_to_google_cal"=>"0", "userid"=>"4"}, "commit"=>"Submit"}
User Load (18.6ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 4]]
(3.3ms) BEGIN
Medication Exists (9.3ms) SELECT 1 AS one FROM "medications" WHERE ("medications"."id" IS NOT NULL) AND "medications"."slug" = $1 LIMIT 1 [["slug", "asprin"]]
SQL (10.0ms) INSERT INTO "medications" ("name", "dosage", "refill", "userid", "total", "strength", "dosage_unit", "total_unit", "strength_unit", "comments", "slug", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5, $6, $7, $8, $9, $10, $11, $12, $13) RETURNING "id" [["name", "Asprin"], ["dosage", 1], ["refill", "07/21/2017"], ["userid", 4], ["total", 30], ["strength", 84], ["dosage_unit", "tablets"], ["total_unit", "tablets"], ["strength_unit", "mg"], ["comments", ""], ["slug", "asprin"], ["created_at", "2017-07-20 14:40:03.756099"], ["updated_at", "2017-07-20 14:40:03.756099"]]
SQL (1.2ms) INSERT INTO "take_medication_reminders" ("active", "medication_id", "created_at", "updated_at") VALUES ($1, $2, $3, $4) RETURNING "id" [["active", "f"], ["medication_id", 4], ["created_at", "2017-07-20 14:40:03.785489"], ["updated_at", "2017-07-20 14:40:03.785489"]]
SQL (5.1ms) INSERT INTO "refill_reminders" ("active", "medication_id", "created_at", "updated_at") VALUES ($1, $2, $3, $4) RETURNING "id" [["active", "f"], ["medication_id", 4], ["created_at", "2017-07-20 14:40:03.806046"], ["updated_at", "2017-07-20 14:40:03.806046"]]
(5.3ms) COMMIT
Redirected to http://localhost:3000/medications/asprin
Completed 302 Found in 1730ms (ActiveRecord: 52.9ms)
Started GET "/medications/asprin" for ::1 at 2017-07-20 10:40:05 -0400
Processing by MedicationsController#show as HTML
Parameters: {"id"=>"asprin"}
User Load (0.7ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 4]]
Medication Load (1.5ms) SELECT "medications".* FROM "medications" WHERE "medications"."slug" = $1 ORDER BY "medications"."id" ASC LIMIT 1 [["slug", "asprin"]]
RefillReminder Load (1.0ms) SELECT "refill_reminders".* FROM "refill_reminders" WHERE "refill_reminders"."medication_id" = $1 LIMIT 1 [["medication_id", 4]]
TakeMedicationReminder Load (0.8ms) SELECT "take_medication_reminders".* FROM "take_medication_reminders" WHERE "take_medication_reminders"."medication_id" = $1 LIMIT 1 [["medication_id", 4]]
Rendered medications/show.html.erb within layouts/application (10.6ms)
Rendered layouts/_title.html.erb (3.0ms)
(22.2ms) SELECT COUNT(*) FROM "notifications"
Rendered shared/_modal.html.erb (26.2ms)
Rendered notifications/_list.html.erb (29.7ms)
Rendered shared/_menu_logo.html.erb (0.3ms)
Rendered shared/_header.html.erb (59.8ms)
Rendered shared/_locale.html.erb (0.8ms)
Rendered shared/_footer.html.erb (14.4ms)
Completed 200 OK in 1202ms (Views: 1166.7ms | ActiveRecord: 26.3ms)
Started GET "/notifications/signed_in" for ::1 at 2017-07-20 10:40:14 -0400
Processing by NotificationsController#signed_in as JSON
User Load (11.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 4]]
Completed 200 OK in 29ms (Views: 1.8ms | ActiveRecord: 11.1ms)
Started GET "/medications" for ::1 at 2017-07-20 10:40:47 -0400
Processing by MedicationsController#index as HTML
User Load (7.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 4]]
Medication Exists (6.1ms) SELECT 1 AS one FROM "medications" WHERE (name ilike '%%' AND userid = 4) LIMIT 1
Medication Load (1.7ms) SELECT "medications".* FROM "medications" WHERE "medications"."userid" = $1 ORDER BY created_at DESC LIMIT 6 OFFSET 0 [["userid", 4]]
Rendered search/_posts.html.erb (8.7ms)
RefillReminder Load (3.9ms) SELECT "refill_reminders".* FROM "refill_reminders" WHERE "refill_reminders"."medication_id" = $1 LIMIT 1 [["medication_id", 4]]
TakeMedicationReminder Load (1.0ms) SELECT "take_medication_reminders".* FROM "take_medication_reminders" WHERE "take_medication_reminders"."medication_id" = $1 LIMIT 1 [["medication_id", 4]]
Rendered medications/_medication.html.erb (28.1ms)
(0.9ms) SELECT COUNT(*) FROM "medications" WHERE "medications"."userid" = $1 [["userid", 4]]
Rendered medications/index.html.erb within layouts/application (69.5ms)
Rendered layouts/_title.html.erb (2.5ms)
(1.9ms) SELECT COUNT(*) FROM "notifications"
Rendered shared/_modal.html.erb (4.2ms)
Rendered notifications/_list.html.erb (7.2ms)
Rendered shared/_menu_logo.html.erb (0.2ms)
Rendered shared/_header.html.erb (38.9ms)
Rendered shared/_locale.html.erb (2.2ms)
Rendered shared/_footer.html.erb (13.0ms)
Completed 200 OK in 1224ms (Views: 1137.4ms | ActiveRecord: 22.4ms)
Started GET "/notifications/signed_in" for ::1 at 2017-07-20 10:40:49 -0400
Processing by NotificationsController#signed_in as JSON
User Load (1.6ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 4]]
Completed 200 OK in 20ms (Views: 1.5ms | ActiveRecord: 1.6ms)
Started GET "/medications/asprin/edit" for ::1 at 2017-07-20 10:41:03 -0400
Processing by MedicationsController#edit as HTML
Parameters: {"id"=>"asprin"}
User Load (3.7ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 4]]
Medication Load (6.7ms) SELECT "medications".* FROM "medications" WHERE "medications"."slug" = $1 ORDER BY "medications"."id" ASC LIMIT 1 [["slug", "asprin"]]
TakeMedicationReminder Load (0.7ms) SELECT "take_medication_reminders".* FROM "take_medication_reminders" WHERE "take_medication_reminders"."medication_id" = $1 LIMIT 1 [["medication_id", 4]]
RefillReminder Load (0.7ms) SELECT "refill_reminders".* FROM "refill_reminders" WHERE "refill_reminders"."medication_id" = $1 LIMIT 1 [["medication_id", 4]]
CACHE (0.0ms) SELECT "refill_reminders".* FROM "refill_reminders" WHERE "refill_reminders"."medication_id" = $1 LIMIT 1 [["medication_id", 4]]
CACHE (0.0ms) SELECT "take_medication_reminders".* FROM "take_medication_reminders" WHERE "take_medication_reminders"."medication_id" = $1 LIMIT 1 [["medication_id", 4]]
Rendered medications/_form.html.erb (29.1ms)
Rendered medications/edit.html.erb within layouts/application (37.9ms)
Rendered layouts/_title.html.erb (1.2ms)
(0.9ms) SELECT COUNT(*) FROM "notifications"
Rendered shared/_modal.html.erb (2.6ms)
Rendered notifications/_list.html.erb (5.0ms)
Rendered shared/_menu_logo.html.erb (0.2ms)
Rendered shared/_header.html.erb (35.4ms)
Rendered shared/_locale.html.erb (0.6ms)
Rendered shared/_footer.html.erb (9.5ms)
Completed 200 OK in 749ms (Views: 721.0ms | ActiveRecord: 12.9ms)
Started GET "/notifications/signed_in" for ::1 at 2017-07-20 10:41:05 -0400
Processing by NotificationsController#signed_in as JSON
User Load (0.7ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 4]]
Completed 200 OK in 8ms (Views: 0.5ms | ActiveRecord: 0.7ms)
Started PATCH "/medications/asprin" for ::1 at 2017-07-20 10:41:16 -0400
Processing by MedicationsController#update as HTML
Parameters: {"utf8"=>"���", "authenticity_token"=>"eOyBz1IDysMcf0foOSHBDOIGLz60Bokztw6h9wynzh4u8JSkgZ+TpqqaxbV4WxaP8x1LcmIjWZ0PIHRflTygUw==", "medication"=>{"name"=>"Asprin", "strength"=>"84", "strength_unit"=>"mg", "total"=>"30", "total_unit"=>"tablets", "dosage"=>"1", "dosage_unit"=>"tablets", "refill"=>"07/22/2017", "comments"=>"", "refill_reminder_attributes"=>{"active"=>"false", "id"=>"4"}, "take_medication_reminder_attributes"=>{"active"=>"false", "id"=>"4"}, "add_to_google_cal"=>"0", "userid"=>"4"}, "commit"=>"Submit", "id"=>"asprin"}
User Load (0.8ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 4]]
Medication Load (0.9ms) SELECT "medications".* FROM "medications" WHERE "medications"."slug" = $1 ORDER BY "medications"."id" ASC LIMIT 1 [["slug", "asprin"]]
(0.6ms) BEGIN
TakeMedicationReminder Load (3.1ms) SELECT "take_medication_reminders".* FROM "take_medication_reminders" WHERE "take_medication_reminders"."medication_id" = $1 LIMIT 1 [["medication_id", 4]]
RefillReminder Load (1.4ms) SELECT "refill_reminders".* FROM "refill_reminders" WHERE "refill_reminders"."medication_id" = $1 LIMIT 1 [["medication_id", 4]]
SQL (1.2ms) UPDATE "medications" SET "refill" = $1, "updated_at" = $2 WHERE "medications"."id" = $3 [["refill", "07/22/2017"], ["updated_at", "2017-07-20 14:41:16.622795"], ["id", 4]]
(3.0ms) COMMIT
Redirected to http://localhost:3000/medications/asprin
Completed 302 Found in 1174ms (ActiveRecord: 11.1ms)
Started GET "/medications/asprin" for ::1 at 2017-07-20 10:41:17 -0400
Processing by MedicationsController#show as HTML
Parameters: {"id"=>"asprin"}
User Load (0.8ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 4]]
Medication Load (1.0ms) SELECT "medications".* FROM "medications" WHERE "medications"."slug" = $1 ORDER BY "medications"."id" ASC LIMIT 1 [["slug", "asprin"]]
RefillReminder Load (0.5ms) SELECT "refill_reminders".* FROM "refill_reminders" WHERE "refill_reminders"."medication_id" = $1 LIMIT 1 [["medication_id", 4]]
TakeMedicationReminder Load (0.6ms) SELECT "take_medication_reminders".* FROM "take_medication_reminders" WHERE "take_medication_reminders"."medication_id" = $1 LIMIT 1 [["medication_id", 4]]
Rendered medications/show.html.erb within layouts/application (7.5ms)
Rendered layouts/_title.html.erb (3.3ms)
(9.0ms) SELECT COUNT(*) FROM "notifications"
Rendered shared/_modal.html.erb (10.6ms)
Rendered notifications/_list.html.erb (12.8ms)
Rendered shared/_menu_logo.html.erb (0.1ms)
Rendered shared/_header.html.erb (32.5ms)
Rendered shared/_locale.html.erb (0.4ms)
Rendered shared/_footer.html.erb (7.8ms)
Completed 200 OK in 945ms (Views: 922.4ms | ActiveRecord: 11.9ms)
Started GET "/notifications/signed_in" for ::1 at 2017-07-20 10:41:22 -0400
Processing by NotificationsController#signed_in as JSON
User Load (25.7ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 4]]
Completed 200 OK in 46ms (Views: 6.3ms | ActiveRecord: 25.7ms)
Started GET "/medications/asprin/edit" for ::1 at 2017-07-20 10:42:23 -0400
Processing by MedicationsController#edit as HTML
Parameters: {"id"=>"asprin"}
User Load (8.8ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 4]]
Medication Load (2.9ms) SELECT "medications".* FROM "medications" WHERE "medications"."slug" = $1 ORDER BY "medications"."id" ASC LIMIT 1 [["slug", "asprin"]]
TakeMedicationReminder Load (1.0ms) SELECT "take_medication_reminders".* FROM "take_medication_reminders" WHERE "take_medication_reminders"."medication_id" = $1 LIMIT 1 [["medication_id", 4]]
RefillReminder Load (1.1ms) SELECT "refill_reminders".* FROM "refill_reminders" WHERE "refill_reminders"."medication_id" = $1 LIMIT 1 [["medication_id", 4]]
CACHE (0.1ms) SELECT "refill_reminders".* FROM "refill_reminders" WHERE "refill_reminders"."medication_id" = $1 LIMIT 1 [["medication_id", 4]]
CACHE (0.0ms) SELECT "take_medication_reminders".* FROM "take_medication_reminders" WHERE "take_medication_reminders"."medication_id" = $1 LIMIT 1 [["medication_id", 4]]
Rendered medications/_form.html.erb (68.0ms)
Rendered medications/edit.html.erb within layouts/application (74.4ms)
Rendered layouts/_title.html.erb (3.4ms)
(7.1ms) SELECT COUNT(*) FROM "notifications"
Rendered shared/_modal.html.erb (11.5ms)
Rendered notifications/_list.html.erb (14.5ms)
Rendered shared/_menu_logo.html.erb (0.3ms)
Rendered shared/_header.html.erb (42.2ms)
Rendered shared/_locale.html.erb (0.7ms)
Rendered shared/_footer.html.erb (14.1ms)
Completed 200 OK in 1753ms (Views: 1661.9ms | ActiveRecord: 20.9ms)
Started GET "/notifications/signed_in" for ::1 at 2017-07-20 10:42:26 -0400
Processing by NotificationsController#signed_in as JSON
User Load (5.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 4]]
Completed 200 OK in 27ms (Views: 2.1ms | ActiveRecord: 5.1ms)
Started PATCH "/medications/asprin" for ::1 at 2017-07-20 10:42:35 -0400
Processing by MedicationsController#update as HTML
Parameters: {"utf8"=>"���", "authenticity_token"=>"kkSwdFH5W40yYA7iO2ac/E9rJnrRiFCS2W+1T+Qfob/EWKUfgmUC6ISFjL96HEt/XnBCNgetgDxhQWDnfYTP8g==", "medication"=>{"name"=>"Asprin", "strength"=>"84", "strength_unit"=>"mg", "total"=>"30", "total_unit"=>"tablets", "dosage"=>"1", "dosage_unit"=>"tablets", "refill"=>"07/22/2017", "comments"=>"", "refill_reminder_attributes"=>{"active"=>"false", "id"=>"4"}, "take_medication_reminder_attributes"=>{"active"=>"false", "id"=>"4"}, "add_to_google_cal"=>"1", "userid"=>"4"}, "commit"=>"Submit", "id"=>"asprin"}
User Load (7.2ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 4]]
Medication Load (5.4ms) SELECT "medications".* FROM "medications" WHERE "medications"."slug" = $1 ORDER BY "medications"."id" ASC LIMIT 1 [["slug", "asprin"]]
(3.7ms) BEGIN
TakeMedicationReminder Load (0.9ms) SELECT "take_medication_reminders".* FROM "take_medication_reminders" WHERE "take_medication_reminders"."medication_id" = $1 LIMIT 1 [["medication_id", 4]]
RefillReminder Load (3.3ms) SELECT "refill_reminders".* FROM "refill_reminders" WHERE "refill_reminders"."medication_id" = $1 LIMIT 1 [["medication_id", 4]]
(0.5ms) COMMIT
Redirected to http://localhost:3000/medications/asprin
Completed 302 Found in 1222ms (ActiveRecord: 21.0ms)
Started GET "/medications/asprin" for ::1 at 2017-07-20 10:42:37 -0400
Processing by MedicationsController#show as HTML
Parameters: {"id"=>"asprin"}
User Load (2.2ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 4]]
Medication Load (2.2ms) SELECT "medications".* FROM "medications" WHERE "medications"."slug" = $1 ORDER BY "medications"."id" ASC LIMIT 1 [["slug", "asprin"]]
RefillReminder Load (1.2ms) SELECT "refill_reminders".* FROM "refill_reminders" WHERE "refill_reminders"."medication_id" = $1 LIMIT 1 [["medication_id", 4]]
TakeMedicationReminder Load (0.6ms) SELECT "take_medication_reminders".* FROM "take_medication_reminders" WHERE "take_medication_reminders"."medication_id" = $1 LIMIT 1 [["medication_id", 4]]
Rendered medications/show.html.erb within layouts/application (12.9ms)
Rendered layouts/_title.html.erb (3.8ms)
(29.4ms) SELECT COUNT(*) FROM "notifications"
Rendered shared/_modal.html.erb (33.1ms)
Rendered notifications/_list.html.erb (44.9ms)
Rendered shared/_menu_logo.html.erb (0.2ms)
Rendered shared/_header.html.erb (76.5ms)
Rendered shared/_locale.html.erb (0.6ms)
Rendered shared/_footer.html.erb (10.7ms)
Completed 200 OK in 1211ms (Views: 1155.8ms | ActiveRecord: 35.6ms)
Started GET "/notifications/signed_in" for ::1 at 2017-07-20 10:42:42 -0400
Processing by NotificationsController#signed_in as JSON
User Load (8.6ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 4]]
Completed 200 OK in 31ms (Views: 2.6ms | ActiveRecord: 8.6ms)
Started GET "/medications/asprin/edit" for ::1 at 2017-07-20 10:42:59 -0400
Processing by MedicationsController#edit as HTML
Parameters: {"id"=>"asprin"}
User Load (7.2ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 4]]
Medication Load (8.3ms) SELECT "medications".* FROM "medications" WHERE "medications"."slug" = $1 ORDER BY "medications"."id" ASC LIMIT 1 [["slug", "asprin"]]
TakeMedicationReminder Load (2.2ms) SELECT "take_medication_reminders".* FROM "take_medication_reminders" WHERE "take_medication_reminders"."medication_id" = $1 LIMIT 1 [["medication_id", 4]]
RefillReminder Load (11.7ms) SELECT "refill_reminders".* FROM "refill_reminders" WHERE "refill_reminders"."medication_id" = $1 LIMIT 1 [["medication_id", 4]]
CACHE (0.1ms) SELECT "refill_reminders".* FROM "refill_reminders" WHERE "refill_reminders"."medication_id" = $1 LIMIT 1 [["medication_id", 4]]
CACHE (0.1ms) SELECT "take_medication_reminders".* FROM "take_medication_reminders" WHERE "take_medication_reminders"."medication_id" = $1 LIMIT 1 [["medication_id", 4]]
Rendered medications/_form.html.erb (147.4ms)
Rendered medications/edit.html.erb within layouts/application (160.6ms)
Rendered layouts/_title.html.erb (5.0ms)
(170.3ms) SELECT COUNT(*) FROM "notifications"
Rendered shared/_modal.html.erb (186.8ms)
Rendered notifications/_list.html.erb (196.6ms)
Rendered shared/_menu_logo.html.erb (0.2ms)
Rendered shared/_header.html.erb (67.6ms)
Rendered shared/_locale.html.erb (5.1ms)
Rendered shared/_footer.html.erb (39.4ms)
Completed 200 OK in 2446ms (Views: 2082.4ms | ActiveRecord: 199.9ms)
Started GET "/notifications/signed_in" for ::1 at 2017-07-20 10:43:03 -0400
Processing by NotificationsController#signed_in as JSON
User Load (4.2ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 4]]
Completed 200 OK in 16ms (Views: 1.8ms | ActiveRecord: 4.2ms)
^C[2017-07-20 11:03:11] INFO going to shutdown ...
[2017-07-20 11:03:11] INFO WEBrick::HTTPServer#start done.
Exiting
(gdesk)shelley@localhost:~/Development/ifme$ rails s
=> Booting WEBrick
=> Rails 4.2.9 application starting in development on http://localhost:3000
=> Run `rails server -h` for more startup options
=> Ctrl-C to shutdown server
[2017-07-20 17:25:41] INFO WEBrick 1.3.1
[2017-07-20 17:25:41] INFO ruby 2.3.4 (2017-03-30) [x86_64-linux]
[2017-07-20 17:25:41] INFO WEBrick::HTTPServer#start: pid=20544 port=3000
Started GET "/" for ::1 at 2017-07-20 17:26:48 -0400
ActiveRecord::SchemaMigration Load (2.1ms) SELECT "schema_migrations".* FROM "schema_migrations"
Processing by PagesController#home as HTML
Rendered pages/_not_signed_in.html.erb (12.0ms)
Rendered pages/home.html.erb within layouts/application (33.7ms)
Rendered layouts/_title.html.erb (4.7ms)
(2.6ms) SELECT COUNT(*) FROM "notifications"
Rendered shared/_modal.html.erb (18.0ms)
Rendered notifications/_list.html.erb (21.4ms)
Rendered shared/_menu_logo.html.erb (1.4ms)
Rendered shared/_header.html.erb (112.2ms)
Rendered shared/_locale.html.erb (1.2ms)
Rendered shared/_footer.html.erb (12.8ms)
Completed 200 OK in 4644ms (Views: 3612.4ms | ActiveRecord: 5.4ms)
Started GET "/notifications/signed_in" for ::1 at 2017-07-20 17:26:58 -0400
Processing by NotificationsController#signed_in as JSON
Filter chain halted as :if_not_signed_in rendered or redirected
Completed 204 No Content in 51ms (ActiveRecord: 0.0ms)
Started GET "/users/sign_in" for ::1 at 2017-07-20 17:30:31 -0400
Processing by Devise::SessionsController#new as HTML
Rendered devise/shared/_links.erb (7.8ms)
Rendered devise/sessions/new.html.erb within layouts/application (228.9ms)
Rendered layouts/_title.html.erb (0.7ms)
(1.2ms) SELECT COUNT(*) FROM "notifications"
Rendered shared/_modal.html.erb (6.8ms)
Rendered notifications/_list.html.erb (10.2ms)
Rendered shared/_menu_logo.html.erb (0.6ms)
Rendered shared/_header.html.erb (12.4ms)
Rendered shared/_locale.html.erb (0.9ms)
Rendered shared/_footer.html.erb (17.2ms)
Completed 200 OK in 1458ms (Views: 1214.2ms | ActiveRecord: 25.3ms)
Started GET "/notifications/signed_in" for ::1 at 2017-07-20 17:30:33 -0400
Processing by NotificationsController#signed_in as JSON
Filter chain halted as :if_not_signed_in rendered or redirected
Completed 204 No Content in 4ms (ActiveRecord: 0.0ms)
Started POST "/users/auth/google_oauth2" for ::1 at 2017-07-20 17:30:37 -0400
I, [2017-07-20T17:30:37.174817 #20544] INFO -- omniauth: (google_oauth2) Request phase initiated.
Started GET "/users/auth/google_oauth2/callback?state=008c2330341ec826bce62a8b2a60ebfc7a7a6a510154703d&code=4/Sms7QSpxSfMMooO0IX-kOw9fVDW-8NExaIQxx-6iazk" for ::1 at 2017-07-20 17:30:45 -0400
I, [2017-07-20T17:30:45.912625 #20544] INFO -- omniauth: (google_oauth2) Callback phase initiated.
Processing by OmniauthCallbacksController#google_oauth2 as HTML
Parameters: {"state"=>"008c2330341ec826bce62a8b2a60ebfc7a7a6a510154703d", "code"=>"4/Sms7QSpxSfMMooO0IX-kOw9fVDW-8NExaIQxx-6iazk"}
User Load (9.2ms) SELECT "users".* FROM "users" WHERE "users"."email" = $1 LIMIT 1 [["email", "shelleyvadams@gmail.com"]]
(0.5ms) BEGIN
SQL (5.0ms) UPDATE "users" SET "token" = $1, "updated_at" = $2 WHERE "users"."id" = $3 [["token", "ya29.GlyNBLMSK8r0Q4DTEHhat_HxZgq80MyU9iN0CRtDNWHpuyS7KfeKCa5Gl6nDo3_D6QYbpgq9_ym60hMuZF2pDg8Sk89LsjO-mFe0k6NwgJ0vhvZRt9iGBGRfK4Z1PQ"], ["updated_at", "2017-07-20 21:30:47.356820"], ["id", 4]]
(3.1ms) COMMIT
(0.4ms) BEGIN
SQL (1.0ms) UPDATE "users" SET "current_sign_in_at" = $1, "sign_in_count" = $2, "updated_at" = $3 WHERE "users"."id" = $4 [["current_sign_in_at", "2017-07-20 21:30:47.380237"], ["sign_in_count", 2], ["updated_at", "2017-07-20 21:30:47.384712"], ["id", 4]]
(1.3ms) COMMIT
Redirected to http://localhost:3000/
Completed 302 Found in 125ms (ActiveRecord: 33.5ms)
Started GET "/" for ::1 at 2017-07-20 17:30:47 -0400
Processing by PagesController#home as HTML
User Load (1.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 4]]
Allyship Load (1.2ms) SELECT "allyships".* FROM "allyships" WHERE "allyships"."user_id" = $1 AND "allyships"."status" = $2 [["user_id", 4], ["status", 0]]
Moment Load (1.8ms) SELECT "moments".* FROM "moments" WHERE "moments"."userid" = $1 ORDER BY created_at DESC [["userid", 4]]
Strategy Load (1.4ms) SELECT "strategies".* FROM "strategies" WHERE "strategies"."userid" = $1 ORDER BY created_at DESC [["userid", 4]]
(0.9ms) SELECT COUNT(*) FROM "moments" WHERE 1=0
Strategy Load (0.9ms) SELECT "strategies".* FROM "strategies" WHERE 1=0 ORDER BY created_at DESC
Rendered pages/_signed_in_empty.html.erb (9.1ms)
Rendered pages/home.html.erb within layouts/application (12.9ms)
Rendered layouts/_title.html.erb (2.0ms)
(0.9ms) SELECT COUNT(*) FROM "notifications"
Rendered shared/_modal.html.erb (2.8ms)
Rendered notifications/_list.html.erb (5.1ms)
Rendered shared/_menu_logo.html.erb (0.1ms)
Rendered shared/_header.html.erb (531.3ms)
Rendered shared/_locale.html.erb (0.6ms)
Rendered shared/_footer.html.erb (10.4ms)
Completed 200 OK in 1486ms (Views: 1331.2ms | ActiveRecord: 14.6ms)
Started GET "/notifications/signed_in" for ::1 at 2017-07-20 17:30:52 -0400
Processing by NotificationsController#signed_in as JSON
User Load (1.3ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 4]]
Completed 200 OK in 9ms (Views: 0.7ms | ActiveRecord: 1.3ms)
Started GET "/notifications/fetch_notifications" for ::1 at 2017-07-20 17:30:52 -0400
Processing by NotificationsController#fetch_notifications as TEXT
User Load (1.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 4]]
Notification Load (1.1ms) SELECT "notifications".* FROM "notifications" WHERE "notifications"."userid" = $1 ORDER BY created_at ASC [["userid", 4]]
Completed 200 OK in 15ms (Views: 3.3ms | ActiveRecord: 2.2ms)
Started GET "/medications" for ::1 at 2017-07-21 12:58:41 -0400
Processing by MedicationsController#index as HTML
User Load (10.2ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 4]]
Medication Exists (14.6ms) SELECT 1 AS one FROM "medications" WHERE (name ilike '%%' AND userid = 4) LIMIT 1
Medication Load (0.8ms) SELECT "medications".* FROM "medications" WHERE "medications"."userid" = $1 ORDER BY created_at DESC LIMIT 6 OFFSET 0 [["userid", 4]]
Rendered search/_posts.html.erb (16.2ms)
RefillReminder Load (1.1ms) SELECT "refill_reminders".* FROM "refill_reminders" WHERE "refill_reminders"."medication_id" = $1 LIMIT 1 [["medication_id", 4]]
TakeMedicationReminder Load (3.9ms) SELECT "take_medication_reminders".* FROM "take_medication_reminders" WHERE "take_medication_reminders"."medication_id" = $1 LIMIT 1 [["medication_id", 4]]
Rendered medications/_medication.html.erb (119.5ms)
(0.8ms) SELECT COUNT(*) FROM "medications" WHERE "medications"."userid" = $1 [["userid", 4]]
Rendered medications/index.html.erb within layouts/application (260.9ms)
Rendered layouts/_title.html.erb (10.6ms)
(1.0ms) SELECT COUNT(*) FROM "notifications"
Rendered shared/_modal.html.erb (4.4ms)
Rendered notifications/_list.html.erb (7.9ms)
Rendered shared/_menu_logo.html.erb (1.0ms)
Rendered shared/_header.html.erb (38.8ms)
Rendered shared/_locale.html.erb (1.4ms)
Rendered shared/_footer.html.erb (13.1ms)
Completed 200 OK in 1839ms (Views: 1505.1ms | ActiveRecord: 51.0ms)
Started GET "/notifications/signed_in" for ::1 at 2017-07-21 12:58:44 -0400
Processing by NotificationsController#signed_in as JSON
User Load (1.8ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 4]]
Completed 200 OK in 14ms (Views: 0.5ms | ActiveRecord: 1.8ms)
Started GET "/medications/new" for ::1 at 2017-07-21 12:59:01 -0400
Processing by MedicationsController#new as HTML
User Load (5.8ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 4]]
Rendered medications/_form.html.erb (352.4ms)
Rendered medications/new.html.erb within layouts/application (358.3ms)
Rendered layouts/_title.html.erb (2.7ms)
(1.1ms) SELECT COUNT(*) FROM "notifications"
Rendered shared/_modal.html.erb (3.1ms)
Rendered notifications/_list.html.erb (5.9ms)
Rendered shared/_menu_logo.html.erb (0.1ms)
Rendered shared/_header.html.erb (34.8ms)
Rendered shared/_locale.html.erb (0.5ms)
Rendered shared/_footer.html.erb (9.1ms)
Completed 200 OK in 1243ms (Views: 1223.0ms | ActiveRecord: 6.9ms)
Started GET "/notifications/signed_in" for ::1 at 2017-07-21 12:59:08 -0400
Processing by NotificationsController#signed_in as JSON
User Load (1.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 4]]
Completed 200 OK in 14ms (Views: 0.9ms | ActiveRecord: 1.1ms)
Started POST "/medications" for ::1 at 2017-07-21 12:59:36 -0400
Processing by MedicationsController#create as HTML
Parameters: {"utf8"=>"���", "authenticity_token"=>"llXymCYVfTM3DS8RqGUsoGlEzMkejlOdCaBSzPhIQckGOyCN3VkEzGkGXc6ClidIAoPbiMnFxtSyoAW/2Rewyg==", "medication"=>{"name"=>"Tylenol", "strength"=>"500", "strength_unit"=>"mg", "total"=>"150", "total_unit"=>"tablets", "dosage"=>"8", "dosage_unit"=>"tablets", "refill"=>"07/22/2017", "comments"=>"", "refill_reminder_attributes"=>{"active"=>"false"}, "take_medication_reminder_attributes"=>{"active"=>"false"}, "add_to_google_cal"=>"0", "userid"=>"4"}, "commit"=>"Submit"}
User Load (3.3ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 4]]
(3.7ms) BEGIN
Medication Exists (1.2ms) SELECT 1 AS one FROM "medications" WHERE ("medications"."id" IS NOT NULL) AND "medications"."slug" = $1 LIMIT 1 [["slug", "tylenol"]]
SQL (1.5ms) INSERT INTO "medications" ("name", "dosage", "refill", "userid", "total", "strength", "dosage_unit", "total_unit", "strength_unit", "comments", "slug", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5, $6, $7, $8, $9, $10, $11, $12, $13) RETURNING "id" [["name", "Tylenol"], ["dosage", 8], ["refill", "07/22/2017"], ["userid", 4], ["total", 150], ["strength", 500], ["dosage_unit", "tablets"], ["total_unit", "tablets"], ["strength_unit", "mg"], ["comments", ""], ["slug", "tylenol"], ["created_at", "2017-07-21 16:59:37.287015"], ["updated_at", "2017-07-21 16:59:37.287015"]]
SQL (1.1ms) INSERT INTO "take_medication_reminders" ("active", "medication_id", "created_at", "updated_at") VALUES ($1, $2, $3, $4) RETURNING "id" [["active", "f"], ["medication_id", 5], ["created_at", "2017-07-21 16:59:37.296213"], ["updated_at", "2017-07-21 16:59:37.296213"]]
SQL (1.1ms) INSERT INTO "refill_reminders" ("active", "medication_id", "created_at", "updated_at") VALUES ($1, $2, $3, $4) RETURNING "id" [["active", "f"], ["medication_id", 5], ["created_at", "2017-07-21 16:59:37.302482"], ["updated_at", "2017-07-21 16:59:37.302482"]]
(5.2ms) COMMIT
Completed 500 Internal Server Error in 1989ms (ActiveRecord: 17.1ms)
Google::APIClient::AuthorizationError (Invalid Credentials):
app/services/calendar_uploader.rb:34:in `upload_event'
app/controllers/medications_controller.rb:97:in `save_refill_to_google_calendar'
app/controllers/medications_controller.rb:56:in `block in create'
app/controllers/medications_controller.rb:54:in `create'
app/controllers/application_controller.rb:31:in `block in with_timezone'
app/controllers/application_controller.rb:31:in `with_timezone'
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment