Started GET "/avatar" for 127.0.0.1 at 2011-09-17 12:34:13 +0800 Processing by AvatarsController#show as HTML User Load (0.2ms) SELECT "users".* FROM "users" ORDER BY "users"."id" DESC LIMIT 1 Rendered /Users/linhe/Projects/buddies_avatar/app/views/avatars/show.html.erb within layouts/application (24.0ms) Completed 200 OK in 329ms (Views: 62.4ms | ActiveRecord: 1.2ms) Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2011-09-17 12:34:14 +0800 Served asset /application.css - 304 Not Modified (0ms) Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2011-09-17 12:34:14 +0800 Served asset /jquery.js - 404 Not Found (3ms) ActionController::RoutingError (No route matches [GET] "/assets/jquery.js"): Rendered /Users/linhe/.rvm/gems/ruby-1.9.2-p0/gems/actionpack-3.1.0/lib/action_dispatch/middleware/templates/rescues/routing_error.erb within rescues/layout (1.1ms) Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2011-09-17 12:34:14 +0800 Served asset /jquery_ujs.js - 404 Not Found (3ms) ActionController::RoutingError (No route matches [GET] "/assets/jquery_ujs.js"): Rendered /Users/linhe/.rvm/gems/ruby-1.9.2-p0/gems/actionpack-3.1.0/lib/action_dispatch/middleware/templates/rescues/routing_error.erb within rescues/layout (0.8ms) Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2011-09-17 12:34:14 +0800 Served asset /application.js - 304 Not Modified (0ms) Started GET "/uploads/user/avatar/1/thumb_meme.JPG" for 127.0.0.1 at 2011-09-17 12:34:14 +0800 ActionController::RoutingError (No route matches [GET] "/uploads/user/avatar/1/thumb_meme.JPG"): Rendered /Users/linhe/.rvm/gems/ruby-1.9.2-p0/gems/actionpack-3.1.0/lib/action_dispatch/middleware/templates/rescues/routing_error.erb within rescues/layout (1.0ms) Started PUT "/avatar" for 127.0.0.1 at 2011-09-17 12:34:44 +0800 Processing by AvatarsController#update as HTML Parameters: {"utf8"=>"✓", "authenticity_token"=>"iGKenOMiPQqyRFBIP6NP1s1GByZNBeuORTlEJS051xc=", "user"=>{"avatar"=>#>, "avatar_cache"=>""}, "commit"=>"Upload"} User Load (0.1ms) SELECT "users".* FROM "users" ORDER BY "users"."id" DESC LIMIT 1 User Load (0.4ms) SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", 1]]  (0.4ms) UPDATE "users" SET "avatar" = 'panda.jpg', "updated_at" = '2011-09-17 04:34:44.235211' WHERE "users"."id" = 1 Redirected to http://localhost:3000/avatar/crop Completed 302 Found in 164ms Started GET "/avatar/crop" for 127.0.0.1 at 2011-09-17 12:34:44 +0800 Processing by AvatarsController#crop as HTML User Load (0.1ms) SELECT "users".* FROM "users" ORDER BY "users"."id" DESC LIMIT 1 Compiled jquery.Jcrop (0ms) (pid 2092) Compiled jquery.Jcrop.min (0ms) (pid 2092) Rendered /Users/linhe/Projects/buddies_avatar/app/views/avatars/crop.html.erb within layouts/application (93.1ms) Completed 200 OK in 118ms (Views: 100.7ms | ActiveRecord: 0.9ms) Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2011-09-17 12:34:44 +0800 Served asset /application.css - 304 Not Modified (0ms) Started GET "/assets/jquery.Jcrop?body=1" for 127.0.0.1 at 2011-09-17 12:34:44 +0800 Served asset /jquery.Jcrop - 200 OK (8ms) Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2011-09-17 12:34:44 +0800 Served asset /jquery_ujs.js - 404 Not Found (3ms) ActionController::RoutingError (No route matches [GET] "/assets/jquery_ujs.js"): Rendered /Users/linhe/.rvm/gems/ruby-1.9.2-p0/gems/actionpack-3.1.0/lib/action_dispatch/middleware/templates/rescues/routing_error.erb within rescues/layout (0.7ms) Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2011-09-17 12:34:44 +0800 Served asset /jquery.js - 404 Not Found (3ms) ActionController::RoutingError (No route matches [GET] "/assets/jquery.js"): Rendered /Users/linhe/.rvm/gems/ruby-1.9.2-p0/gems/actionpack-3.1.0/lib/action_dispatch/middleware/templates/rescues/routing_error.erb within rescues/layout (1.1ms) Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2011-09-17 12:34:44 +0800 Served asset /application.js - 304 Not Modified (0ms) Started GET "/assets/jquery.Jcrop.min?body=1" for 127.0.0.1 at 2011-09-17 12:34:44 +0800 Served asset /jquery.Jcrop.min - 304 Not Modified (0ms) Started PUT "/avatar" for 127.0.0.1 at 2011-09-17 12:35:10 +0800 Processing by AvatarsController#update as HTML Parameters: {"utf8"=>"✓", "authenticity_token"=>"iGKenOMiPQqyRFBIP6NP1s1GByZNBeuORTlEJS051xc=", "user"=>{"crop_x"=>"", "crop_y"=>"", "crop_w"=>"", "crop_h"=>""}, "commit"=>"Crop"} User Load (0.1ms) SELECT "users".* FROM "users" ORDER BY "users"."id" DESC LIMIT 1 Redirected to http://localhost:3000/avatar Completed 302 Found in 23ms Started GET "/avatar" for 127.0.0.1 at 2011-09-17 12:35:10 +0800 Processing by AvatarsController#show as HTML User Load (0.1ms) SELECT "users".* FROM "users" ORDER BY "users"."id" DESC LIMIT 1 Rendered /Users/linhe/Projects/buddies_avatar/app/views/avatars/show.html.erb within layouts/application (5.8ms) Completed 200 OK in 75ms (Views: 12.2ms | ActiveRecord: 0.9ms) Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2011-09-17 12:35:10 +0800 Served asset /application.css - 304 Not Modified (0ms) Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2011-09-17 12:35:10 +0800 Served asset /jquery_ujs.js - 404 Not Found (4ms) ActionController::RoutingError (No route matches [GET] "/assets/jquery_ujs.js"): Rendered /Users/linhe/.rvm/gems/ruby-1.9.2-p0/gems/actionpack-3.1.0/lib/action_dispatch/middleware/templates/rescues/routing_error.erb within rescues/layout (0.7ms) Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2011-09-17 12:35:10 +0800 Served asset /jquery.js - 404 Not Found (2ms) ActionController::RoutingError (No route matches [GET] "/assets/jquery.js"): Rendered /Users/linhe/.rvm/gems/ruby-1.9.2-p0/gems/actionpack-3.1.0/lib/action_dispatch/middleware/templates/rescues/routing_error.erb within rescues/layout (0.9ms) Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2011-09-17 12:35:10 +0800 Served asset /application.js - 304 Not Modified (0ms) Started GET "/avatar" for 127.0.0.1 at 2011-09-17 12:36:32 +0800 Processing by AvatarsController#show as HTML User Load (0.1ms) SELECT "users".* FROM "users" ORDER BY "users"."id" DESC LIMIT 1 Rendered /Users/linhe/Projects/buddies_avatar/app/views/avatars/show.html.erb within layouts/application (25.4ms) Completed 200 OK in 289ms (Views: 70.9ms | ActiveRecord: 1.0ms) Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2011-09-17 12:36:33 +0800 Served asset /application.css - 304 Not Modified (0ms) Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2011-09-17 12:36:33 +0800 Served asset /jquery.js - 200 OK (5ms) Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2011-09-17 12:36:33 +0800 Served asset /application.js - 304 Not Modified (0ms) Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2011-09-17 12:36:33 +0800 Served asset /jquery_ujs.js - 200 OK (3ms) Started PUT "/avatar" for 127.0.0.1 at 2011-09-17 12:36:41 +0800 Processing by AvatarsController#update as HTML Parameters: {"utf8"=>"✓", "authenticity_token"=>"iGKenOMiPQqyRFBIP6NP1s1GByZNBeuORTlEJS051xc=", "user"=>{"avatar"=>#>, "avatar_cache"=>""}, "commit"=>"Upload"} User Load (0.1ms) SELECT "users".* FROM "users" ORDER BY "users"."id" DESC LIMIT 1 User Load (0.4ms) SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", 1]]  (0.4ms) UPDATE "users" SET "avatar" = 'panda.jpg', "updated_at" = '2011-09-17 04:36:41.533176' WHERE "users"."id" = 1 Redirected to http://localhost:3000/avatar/crop Completed 302 Found in 207ms Started GET "/avatar/crop" for 127.0.0.1 at 2011-09-17 12:36:41 +0800 Processing by AvatarsController#crop as HTML User Load (0.2ms) SELECT "users".* FROM "users" ORDER BY "users"."id" DESC LIMIT 1 Rendered /Users/linhe/Projects/buddies_avatar/app/views/avatars/crop.html.erb within layouts/application (90.2ms) Completed 200 OK in 118ms (Views: 98.1ms | ActiveRecord: 1.2ms) Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2011-09-17 12:36:41 +0800 Served asset /application.css - 304 Not Modified (0ms) Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2011-09-17 12:36:41 +0800 Served asset /application.js - 304 Not Modified (0ms) Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2011-09-17 12:36:41 +0800 Served asset /jquery.js - 304 Not Modified (0ms) Started GET "/assets/jquery.Jcrop.min?body=1" for 127.0.0.1 at 2011-09-17 12:36:41 +0800 Served asset /jquery.Jcrop.min - 304 Not Modified (0ms) Started GET "/assets/Jcrop.gif" for 127.0.0.1 at 2011-09-17 12:36:41 +0800 Served asset /Jcrop.gif - 304 Not Modified (5ms) Started PUT "/avatar" for 127.0.0.1 at 2011-09-17 12:36:49 +0800 Processing by AvatarsController#update as HTML Parameters: {"utf8"=>"✓", "authenticity_token"=>"iGKenOMiPQqyRFBIP6NP1s1GByZNBeuORTlEJS051xc=", "user"=>{"crop_x"=>"102", "crop_y"=>"10", "crop_w"=>"109", "crop_h"=>"109"}, "commit"=>"Crop"} User Load (0.1ms) SELECT "users".* FROM "users" ORDER BY "users"."id" DESC LIMIT 1 Redirected to http://localhost:3000/avatar Completed 302 Found in 349ms Started GET "/avatar" for 127.0.0.1 at 2011-09-17 12:36:49 +0800 Processing by AvatarsController#show as HTML User Load (0.1ms) SELECT "users".* FROM "users" ORDER BY "users"."id" DESC LIMIT 1 Rendered /Users/linhe/Projects/buddies_avatar/app/views/avatars/show.html.erb within layouts/application (7.2ms) Completed 200 OK in 34ms (Views: 14.5ms | ActiveRecord: 0.8ms) Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2011-09-17 12:36:49 +0800 Served asset /application.css - 304 Not Modified (0ms) Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2011-09-17 12:36:49 +0800 Served asset /application.js - 304 Not Modified (1ms) Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2011-09-17 12:36:49 +0800 Served asset /jquery.js - 304 Not Modified (0ms) Started GET "/avatar" for 127.0.0.1 at 2011-09-17 12:37:10 +0800 Processing by AvatarsController#show as HTML User Load (0.1ms) SELECT "users".* FROM "users" ORDER BY "users"."id" DESC LIMIT 1 Rendered /Users/linhe/Projects/buddies_avatar/app/views/avatars/show.html.erb within layouts/application (26.1ms) Completed 200 OK in 281ms (Views: 66.5ms | ActiveRecord: 1.0ms) Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2011-09-17 12:37:11 +0800 Served asset /application.css - 304 Not Modified (0ms) Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2011-09-17 12:37:11 +0800 Served asset /jquery.js - 304 Not Modified (3ms) Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2011-09-17 12:37:11 +0800 Served asset /application.js - 304 Not Modified (0ms) Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2011-09-17 12:37:11 +0800 Served asset /jquery_ujs.js - 304 Not Modified (3ms)