(no commit message)
authorNeil Smith <neil.git@njae.me.uk>
Fri, 6 Feb 2009 16:02:00 +0000 (16:02 +0000)
committerNeil Smith <neil.git@njae.me.uk>
Fri, 6 Feb 2009 16:02:00 +0000 (16:02 +0000)
log/development.log [deleted file]
log/production.log [deleted file]
log/server.log [deleted file]
log/test.log [deleted file]

diff --git a/log/development.log b/log/development.log
deleted file mode 100644 (file)
index 92b6afa..0000000
+++ /dev/null
@@ -1,2652 +0,0 @@
-  \e[4;36;1mSQL (0.2ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mSQL (4.4ms)\e[0m   \e[0;1mSHOW TABLES\e[0m
-  \e[4;35;1mSQL (7.1ms)\e[0m   \e[0mCREATE TABLE `schema_migrations` (`version` varchar(255) NOT NULL) ENGINE=InnoDB\e[0m
-  \e[4;36;1mSQL (41.8ms)\e[0m   \e[0;1mCREATE UNIQUE INDEX `unique_schema_migrations` ON `schema_migrations` (`version`)\e[0m
-  \e[4;35;1mSQL (0.3ms)\e[0m   \e[0mSHOW TABLES\e[0m
-  \e[4;36;1mSQL (0.4ms)\e[0m   \e[0;1mSELECT version FROM schema_migrations\e[0m
-Migrating to CreateProducts (20090202160210)
-  \e[4;36;1mSQL (0.2ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mSQL (0.4ms)\e[0m   \e[0;1mSHOW TABLES\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSELECT version FROM schema_migrations\e[0m
-Migrating to CreateProducts (20090202160210)
-  \e[4;36;1mSQL (0.2ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mSQL (0.3ms)\e[0m   \e[0;1mSHOW TABLES\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSELECT version FROM schema_migrations\e[0m
-  \e[4;36;1mSQL (0.3ms)\e[0m   \e[0;1mSHOW TABLES\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSELECT version FROM schema_migrations\e[0m
-Migrating to CreateProducts (20090202160210)
-  \e[4;36;1mSQL (0.2ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mSQL (0.4ms)\e[0m   \e[0;1mSHOW TABLES\e[0m
-  \e[4;35;1mSQL (0.2ms)\e[0m   \e[0mSELECT version FROM schema_migrations\e[0m
-Migrating to CreateProducts (20090202160210)
-  \e[4;36;1mSQL (22.1ms)\e[0m   \e[0;1mCREATE TABLE `products` (`id` int(11) DEFAULT NULL auto_increment PRIMARY KEY, `title` varchar(255), `description` text, `image_url` varchar(255), `created_at` datetime, `updated_at` datetime) ENGINE=InnoDB\e[0m
-  \e[4;35;1mSQL (0.7ms)\e[0m   \e[0mINSERT INTO schema_migrations (version) VALUES ('20090202160210')\e[0m
-  \e[4;36;1mSQL (0.4ms)\e[0m   \e[0;1mSHOW TABLES\e[0m
-  \e[4;35;1mSQL (0.3ms)\e[0m   \e[0mSELECT version FROM schema_migrations\e[0m
-  \e[4;36;1mSQL (0.3ms)\e[0m   \e[0;1mSHOW TABLES\e[0m
-  \e[4;35;1mSQL (1.1ms)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
-  \e[4;36;1mSQL (1.2ms)\e[0m   \e[0;1mdescribe `products`\e[0m
-  \e[4;35;1mSQL (0.4ms)\e[0m   \e[0mSHOW KEYS FROM `products`\e[0m
-
-
-Processing ProductsController#index (for 127.0.0.1 at 2009-02-02 16:05:24) [GET]
-
-
-CGI::Session::CookieStore::TamperedWithCookie (CGI::Session::CookieStore::TamperedWithCookie):
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/session/cookie_store.rb:145:in `unmarshal'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/session/cookie_store.rb:102:in `restore'
-    /usr/lib/ruby/1.8/cgi/session.rb:304:in `[]'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/cgi_process.rb:98:in `session'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/cgi_process.rb:130:in `stale_session_check!'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/cgi_process.rb:78:in `session'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/base.rb:1205:in `assign_shortcuts_without_flash'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/flash.rb:166:in `assign_shortcuts'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/base.rb:519:in `process_without_filters'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/filters.rb:606:in `process_without_session_management_support'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/session_management.rb:134:in `process'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/base.rb:392:in `process'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:183:in `handle_request'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:110:in `dispatch_unlocked'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:123:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:122:in `synchronize'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:122:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:132:in `dispatch_cgi'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:39:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:103:in `handle_dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:74:in `service'
-    /usr/lib/ruby/1.8/webrick/httpserver.rb:104:in `service'
-    /usr/lib/ruby/1.8/webrick/httpserver.rb:65:in `run'
-    /usr/lib/ruby/1.8/webrick/server.rb:173:in `start_thread'
-    /usr/lib/ruby/1.8/webrick/server.rb:162:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:162:in `start_thread'
-    /usr/lib/ruby/1.8/webrick/server.rb:95:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:92:in `each'
-    /usr/lib/ruby/1.8/webrick/server.rb:92:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:23:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:82:in `start'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:60:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/commands/servers/webrick.rb:66
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `gem_original_require'
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `require'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:153:in `require'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:521:in `new_constants_in'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:153:in `require'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/commands/server.rb:49
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `gem_original_require'
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `require'
-    script/server:3
-
-Rendered /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/templates/rescues/_trace (45.0ms)
-Rendered /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/templates/rescues/_request_and_response (1.3ms)
-Rendering /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/templates/rescues/layout.erb (internal_server_error)
-
-
-Processing ProductsController#index (for 127.0.0.1 at 2009-02-02 16:06:12) [GET]
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mProduct Load (0.4ms)\e[0m   \e[0;1mSELECT * FROM `products` \e[0m
-Rendering template within layouts/products
-Rendering products/index
-Completed in 22ms (View: 8, DB: 1) | 200 OK [http://localhost/products]
-
-
-Processing ApplicationController#index (for 127.0.0.1 at 2009-02-02 16:06:21) [GET]
-
-
-ActionController::RoutingError (No route matches "/store/index" with {:method=>:get}):
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/routing/recognition_optimisation.rb:66:in `recognize_path'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/routing/route_set.rb:386:in `recognize'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:182:in `handle_request'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:110:in `dispatch_unlocked'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:123:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:122:in `synchronize'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:122:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:132:in `dispatch_cgi'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:39:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:103:in `handle_dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:74:in `service'
-    /usr/lib/ruby/1.8/webrick/httpserver.rb:104:in `service'
-    /usr/lib/ruby/1.8/webrick/httpserver.rb:65:in `run'
-    /usr/lib/ruby/1.8/webrick/server.rb:173:in `start_thread'
-    /usr/lib/ruby/1.8/webrick/server.rb:162:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:162:in `start_thread'
-    /usr/lib/ruby/1.8/webrick/server.rb:95:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:92:in `each'
-    /usr/lib/ruby/1.8/webrick/server.rb:92:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:23:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:82:in `start'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:60:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/commands/servers/webrick.rb:66
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `gem_original_require'
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `require'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:153:in `require'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:521:in `new_constants_in'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:153:in `require'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/commands/server.rb:49
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `gem_original_require'
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `require'
-    script/server:3
-
-Rendering /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/templates/rescues/layout.erb (not_found)
-
-
-Processing ApplicationController#index (for 127.0.0.1 at 2009-02-02 16:06:28) [GET]
-
-
-ActionController::RoutingError (No route matches "/store/index" with {:method=>:get}):
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/routing/recognition_optimisation.rb:66:in `recognize_path'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/routing/route_set.rb:386:in `recognize'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:182:in `handle_request'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:110:in `dispatch_unlocked'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:123:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:122:in `synchronize'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:122:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:132:in `dispatch_cgi'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:39:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:103:in `handle_dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:74:in `service'
-    /usr/lib/ruby/1.8/webrick/httpserver.rb:104:in `service'
-    /usr/lib/ruby/1.8/webrick/httpserver.rb:65:in `run'
-    /usr/lib/ruby/1.8/webrick/server.rb:173:in `start_thread'
-    /usr/lib/ruby/1.8/webrick/server.rb:162:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:162:in `start_thread'
-    /usr/lib/ruby/1.8/webrick/server.rb:95:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:92:in `each'
-    /usr/lib/ruby/1.8/webrick/server.rb:92:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:23:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:82:in `start'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:60:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/commands/servers/webrick.rb:66
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `gem_original_require'
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `require'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:153:in `require'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:521:in `new_constants_in'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:153:in `require'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/commands/server.rb:49
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `gem_original_require'
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `require'
-    script/server:3
-
-Rendering /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/templates/rescues/layout.erb (not_found)
-  \e[4;36;1mSQL (0.2ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.2ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mSQL (0.6ms)\e[0m   \e[0;1mSHOW TABLES\e[0m
-  \e[4;35;1mSQL (0.2ms)\e[0m   \e[0mSELECT version FROM schema_migrations\e[0m
-Migrating to CreateProducts (20090202160210)
-Migrating to AddPriceToProduct (20090202160745)
-  \e[4;36;1mSQL (47.0ms)\e[0m   \e[0;1mALTER TABLE `products` ADD `price` decimal(8,2) DEFAULT 2\e[0m
-  \e[4;35;1mSQL (0.8ms)\e[0m   \e[0mINSERT INTO schema_migrations (version) VALUES ('20090202160745')\e[0m
-Migrating to AddDateAvailableToProduct (20090202160925)
-  \e[4;36;1mSQL (8.3ms)\e[0m   \e[0;1mALTER TABLE `products` ADD `date_available` date\e[0m
-  \e[4;35;1mSQL (0.8ms)\e[0m   \e[0mINSERT INTO schema_migrations (version) VALUES ('20090202160925')\e[0m
-  \e[4;36;1mSQL (0.5ms)\e[0m   \e[0;1mSHOW TABLES\e[0m
-  \e[4;35;1mSQL (0.4ms)\e[0m   \e[0mSELECT version FROM schema_migrations\e[0m
-  \e[4;36;1mSQL (0.6ms)\e[0m   \e[0;1mSHOW TABLES\e[0m
-  \e[4;35;1mSQL (1.9ms)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
-  \e[4;36;1mSQL (1.8ms)\e[0m   \e[0;1mdescribe `products`\e[0m
-  \e[4;35;1mSQL (0.6ms)\e[0m   \e[0mSHOW KEYS FROM `products`\e[0m
-
-
-Processing ProductsController#index (for 127.0.0.1 at 2009-02-02 16:15:31) [GET]
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSET NAMES 'utf8'\e[0m
-  \e[4;36;1mSQL (0.2ms)\e[0m   \e[0;1mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;35;1mProduct Load (0.6ms)\e[0m   \e[0mSELECT * FROM `products` \e[0m
-Rendering template within layouts/products
-Rendering products/index
-Completed in 22ms (View: 8, DB: 1) | 200 OK [http://localhost/products]
-
-
-Processing ProductsController#index (for 127.0.0.1 at 2009-02-02 16:15:56) [GET]
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mProduct Load (0.2ms)\e[0m   \e[0;1mSELECT * FROM `products` \e[0m
-Rendering template within layouts/products
-Rendering products/index
-Completed in 22ms (View: 11, DB: 0) | 200 OK [http://localhost/products]
-
-
-Processing ProductsController#new (for 127.0.0.1 at 2009-02-02 16:16:00) [GET]
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSET NAMES 'utf8'\e[0m
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;35;1mProduct Columns (2.5ms)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
-Rendering template within layouts/products
-Rendering products/new
-Completed in 57ms (View: 34, DB: 3) | 200 OK [http://localhost/products/new]
-
-
-Processing ProductsController#create (for 127.0.0.1 at 2009-02-02 16:16:18) [POST]
-  Parameters: {"commit"=>"Create", "authenticity_token"=>"8cca4a5b8c4003866a07c7a42d5a3b724d9e5d00", "product"=>{"image_url"=>"", "price"=>"2.0", "title"=>"frist produce", "date_available(1i)"=>"2009", "date_available(2i)"=>"2", "description"=>"a bunch of descirpiton", "date_available(3i)"=>"2"}}
-  \e[4;36;1mSQL (0.2ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.2ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mProduct Columns (1.5ms)\e[0m   \e[0;1mSHOW FIELDS FROM `products`\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mBEGIN\e[0m
-  \e[4;36;1mProduct Create (0.3ms)\e[0m   \e[0;1mINSERT INTO `products` (`image_url`, `updated_at`, `title`, `price`, `date_available`, `description`, `created_at`) VALUES('', '2009-02-02 16:16:18', 'frist produce', 2.0, '2009-02-02', 'a bunch of descirpiton', '2009-02-02 16:16:18')\e[0m
-  \e[4;35;1mSQL (4.4ms)\e[0m   \e[0mCOMMIT\e[0m
-Redirected to #<Product:0xb71dba48>
-Completed in 27ms (DB: 7) | 302 Found [http://localhost/products]
-
-
-Processing ProductsController#show (for 127.0.0.1 at 2009-02-02 16:16:18) [GET]
-  Parameters: {"id"=>"1"}
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mProduct Columns (1.1ms)\e[0m   \e[0;1mSHOW FIELDS FROM `products`\e[0m
-  \e[4;35;1mProduct Load (0.4ms)\e[0m   \e[0mSELECT * FROM `products` WHERE (`products`.`id` = 1) \e[0m
-Rendering template within layouts/products
-Rendering products/show
-Completed in 30ms (View: 12, DB: 2) | 200 OK [http://localhost/products/1]
-
-
-Processing ProductsController#index (for 127.0.0.1 at 2009-02-02 16:16:20) [GET]
-  \e[4;36;1mSQL (0.2ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.2ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mProduct Load (0.5ms)\e[0m   \e[0;1mSELECT * FROM `products` \e[0m
-Rendering template within layouts/products
-Rendering products/index
-  \e[4;35;1mProduct Columns (1.1ms)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
-Completed in 32ms (View: 18, DB: 2) | 200 OK [http://localhost/products]
-  \e[4;36;1mSQL (0.2ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mSQL (0.4ms)\e[0m   \e[0;1mSHOW TABLES\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSELECT version FROM schema_migrations\e[0m
-  \e[4;36;1mSQL (0.3ms)\e[0m   \e[0;1mSHOW TABLES\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSELECT version FROM schema_migrations\e[0m
-Migrating to AddDateAvailableToProduct (20090202160925)
-  \e[4;36;1mSQL (29.2ms)\e[0m   \e[0;1mALTER TABLE `products` DROP `date_available`\e[0m
-  \e[4;35;1mSQL (7.7ms)\e[0m   \e[0mDELETE FROM schema_migrations WHERE version = '20090202160925'\e[0m
-Migrating to AddPriceToProduct (20090202160745)
-  \e[4;36;1mSQL (24.1ms)\e[0m   \e[0;1mALTER TABLE `products` DROP `price`\e[0m
-  \e[4;35;1mSQL (0.7ms)\e[0m   \e[0mDELETE FROM schema_migrations WHERE version = '20090202160745'\e[0m
-Migrating to CreateProducts (20090202160210)
-  \e[4;36;1mSQL (1.4ms)\e[0m   \e[0;1mDROP TABLE `products`\e[0m
-  \e[4;35;1mSQL (0.7ms)\e[0m   \e[0mDELETE FROM schema_migrations WHERE version = '20090202160210'\e[0m
-  \e[4;36;1mSQL (0.4ms)\e[0m   \e[0;1mSHOW TABLES\e[0m
-  \e[4;35;1mSQL (0.3ms)\e[0m   \e[0mSELECT version FROM schema_migrations\e[0m
-  \e[4;36;1mSQL (0.5ms)\e[0m   \e[0;1mSHOW TABLES\e[0m
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mSQL (0.8ms)\e[0m   \e[0;1mSHOW TABLES\e[0m
-  \e[4;35;1mSQL (0.2ms)\e[0m   \e[0mSELECT version FROM schema_migrations\e[0m
-Migrating to CreateProducts (20090202160210)
-  \e[4;36;1mSQL (175.4ms)\e[0m   \e[0;1mCREATE TABLE `products` (`id` int(11) DEFAULT NULL auto_increment PRIMARY KEY, `title` varchar(255), `description` text, `image_url` varchar(255), `created_at` datetime, `updated_at` datetime) ENGINE=InnoDB\e[0m
-  \e[4;35;1mSQL (7.5ms)\e[0m   \e[0mINSERT INTO schema_migrations (version) VALUES ('20090202160210')\e[0m
-Migrating to AddPriceToProduct (20090202160745)
-  \e[4;36;1mSQL (7.8ms)\e[0m   \e[0;1mALTER TABLE `products` ADD `price` decimal(8,2) DEFAULT 0\e[0m
-  \e[4;35;1mSQL (0.6ms)\e[0m   \e[0mINSERT INTO schema_migrations (version) VALUES ('20090202160745')\e[0m
-Migrating to AddDateAvailableToProduct (20090202160925)
-  \e[4;36;1mSQL (12.4ms)\e[0m   \e[0;1mALTER TABLE `products` ADD `date_available` date\e[0m
-  \e[4;35;1mSQL (4.0ms)\e[0m   \e[0mINSERT INTO schema_migrations (version) VALUES ('20090202160925')\e[0m
-  \e[4;36;1mSQL (0.4ms)\e[0m   \e[0;1mSHOW TABLES\e[0m
-  \e[4;35;1mSQL (0.4ms)\e[0m   \e[0mSELECT version FROM schema_migrations\e[0m
-  \e[4;36;1mSQL (0.3ms)\e[0m   \e[0;1mSHOW TABLES\e[0m
-  \e[4;35;1mSQL (1.7ms)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
-  \e[4;36;1mSQL (1.1ms)\e[0m   \e[0;1mdescribe `products`\e[0m
-  \e[4;35;1mSQL (0.4ms)\e[0m   \e[0mSHOW KEYS FROM `products`\e[0m
-
-
-Processing ProductsController#index (for 127.0.0.1 at 2009-02-02 16:18:14) [GET]
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mProduct Load (0.3ms)\e[0m   \e[0;1mSELECT * FROM `products` \e[0m
-Rendering template within layouts/products
-Rendering products/index
-Completed in 19ms (View: 8, DB: 1) | 200 OK [http://localhost/products]
-
-
-Processing ProductsController#new (for 127.0.0.1 at 2009-02-02 16:18:16) [GET]
-  \e[4;35;1mSQL (0.2ms)\e[0m   \e[0mSET NAMES 'utf8'\e[0m
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;35;1mProduct Columns (1.1ms)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
-Rendering template within layouts/products
-Rendering products/new
-Completed in 41ms (View: 28, DB: 1) | 200 OK [http://localhost/products/new]
-
-
-Processing ProductsController#create (for 127.0.0.1 at 2009-02-02 16:18:39) [POST]
-  Parameters: {"commit"=>"Create", "authenticity_token"=>"8cca4a5b8c4003866a07c7a42d5a3b724d9e5d00", "product"=>{"image_url"=>"ss.png", "price"=>"10", "title"=>"fist prod", "date_available(1i)"=>"2009", "date_available(2i)"=>"2", "description"=>"desription and stuff", "date_available(3i)"=>"2"}}
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.2ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mProduct Columns (1.5ms)\e[0m   \e[0;1mSHOW FIELDS FROM `products`\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mBEGIN\e[0m
-  \e[4;36;1mProduct Create (0.5ms)\e[0m   \e[0;1mINSERT INTO `products` (`image_url`, `updated_at`, `title`, `price`, `date_available`, `description`, `created_at`) VALUES('ss.png', '2009-02-02 16:18:39', 'fist prod', 10.0, '2009-02-02', 'desription and stuff', '2009-02-02 16:18:39')\e[0m
-  \e[4;35;1mSQL (5.2ms)\e[0m   \e[0mCOMMIT\e[0m
-Redirected to #<Product:0xb70345b4>
-Completed in 37ms (DB: 8) | 302 Found [http://localhost/products]
-
-
-Processing ProductsController#show (for 127.0.0.1 at 2009-02-02 16:18:39) [GET]
-  Parameters: {"id"=>"1"}
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mProduct Columns (2.3ms)\e[0m   \e[0;1mSHOW FIELDS FROM `products`\e[0m
-  \e[4;35;1mProduct Load (0.6ms)\e[0m   \e[0mSELECT * FROM `products` WHERE (`products`.`id` = 1) \e[0m
-Rendering template within layouts/products
-Rendering products/show
-Completed in 49ms (View: 29, DB: 3) | 200 OK [http://localhost/products/1]
-
-
-Processing ProductsController#index (for 127.0.0.1 at 2009-02-02 16:18:41) [GET]
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mProduct Load (0.4ms)\e[0m   \e[0;1mSELECT * FROM `products` \e[0m
-Rendering template within layouts/products
-Rendering products/index
-  \e[4;35;1mProduct Columns (1.2ms)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
-Completed in 33ms (View: 20, DB: 2) | 200 OK [http://localhost/products]
-
-
-Processing ApplicationController#index (for 127.0.0.1 at 2009-02-02 16:18:47) [GET]
-
-
-ActionController::RoutingError (No route matches "/store/index" with {:method=>:get}):
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/routing/recognition_optimisation.rb:66:in `recognize_path'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/routing/route_set.rb:386:in `recognize'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:182:in `handle_request'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:110:in `dispatch_unlocked'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:123:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:122:in `synchronize'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:122:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:132:in `dispatch_cgi'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:39:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:103:in `handle_dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:74:in `service'
-    /usr/lib/ruby/1.8/webrick/httpserver.rb:104:in `service'
-    /usr/lib/ruby/1.8/webrick/httpserver.rb:65:in `run'
-    /usr/lib/ruby/1.8/webrick/server.rb:173:in `start_thread'
-    /usr/lib/ruby/1.8/webrick/server.rb:162:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:162:in `start_thread'
-    /usr/lib/ruby/1.8/webrick/server.rb:95:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:92:in `each'
-    /usr/lib/ruby/1.8/webrick/server.rb:92:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:23:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:82:in `start'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:60:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/commands/servers/webrick.rb:66
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `gem_original_require'
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `require'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:153:in `require'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:521:in `new_constants_in'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:153:in `require'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/commands/server.rb:49
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `gem_original_require'
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `require'
-    script/server:3
-
-Rendering /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/templates/rescues/layout.erb (not_found)
-
-
-Processing ApplicationController#index (for 127.0.0.1 at 2009-02-02 16:18:51) [GET]
-
-
-ActionController::RoutingError (No route matches "/store" with {:method=>:get}):
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/routing/recognition_optimisation.rb:66:in `recognize_path'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/routing/route_set.rb:386:in `recognize'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:182:in `handle_request'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:110:in `dispatch_unlocked'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:123:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:122:in `synchronize'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:122:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:132:in `dispatch_cgi'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:39:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:103:in `handle_dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:74:in `service'
-    /usr/lib/ruby/1.8/webrick/httpserver.rb:104:in `service'
-    /usr/lib/ruby/1.8/webrick/httpserver.rb:65:in `run'
-    /usr/lib/ruby/1.8/webrick/server.rb:173:in `start_thread'
-    /usr/lib/ruby/1.8/webrick/server.rb:162:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:162:in `start_thread'
-    /usr/lib/ruby/1.8/webrick/server.rb:95:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:92:in `each'
-    /usr/lib/ruby/1.8/webrick/server.rb:92:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:23:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:82:in `start'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:60:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/commands/servers/webrick.rb:66
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `gem_original_require'
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `require'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:153:in `require'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:521:in `new_constants_in'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:153:in `require'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/commands/server.rb:49
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `gem_original_require'
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `require'
-    script/server:3
-
-Rendering /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/templates/rescues/layout.erb (not_found)
-
-
-Processing ProductsController#new (for 127.0.0.1 at 2009-02-02 16:24:25) [GET]
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-
-
-SyntaxError (/home/neil/programming/rails/depot/app/models/product.rb:7: syntax error, unexpected $undefined
-                      :with %r{\.(gif|jpg|png)$}i,
-                                ^
-/home/neil/programming/rails/depot/app/models/product.rb:7: syntax error, unexpected ')', expecting '}'
-                      :with %r{\.(gif|jpg|png)$}i,
-                                              ^
-/home/neil/programming/rails/depot/app/models/product.rb:8: syntax error, unexpected tSTRING_BEG, expecting tCOLON2 or '[' or '.'
-                      :message "must be a URL for GIF, JPG, or PNG image."
-                                ^
-/home/neil/programming/rails/depot/app/models/product.rb:14: syntax error, unexpected kEND, expecting '}'):
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:382:in `load_without_new_constant_marking'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:382:in `load_file'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:521:in `new_constants_in'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:381:in `load_file'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:256:in `require_or_load'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:427:in `load_missing_constant'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:77:in `const_missing'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:89:in `const_missing'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:439:in `load_missing_constant'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:93:in `const_missing'
-    /app/controllers/products_controller.rb:27:in `new'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/base.rb:1253:in `send'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/base.rb:1253:in `perform_action_without_filters'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/filters.rb:617:in `call_filters'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/filters.rb:610:in `perform_action_without_benchmark'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/benchmarking.rb:68:in `perform_action_without_rescue'
-    /usr/lib/ruby/1.8/benchmark.rb:293:in `measure'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/benchmarking.rb:68:in `perform_action_without_rescue'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/rescue.rb:136:in `perform_action_without_caching'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/caching/sql_cache.rb:13:in `perform_action'
-    /usr/lib/ruby/gems/1.8/gems/activerecord-2.2.2/lib/active_record/connection_adapters/abstract/query_cache.rb:34:in `cache'
-    /usr/lib/ruby/gems/1.8/gems/activerecord-2.2.2/lib/active_record/query_cache.rb:8:in `cache'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/caching/sql_cache.rb:12:in `perform_action'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/base.rb:524:in `send'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/base.rb:524:in `process_without_filters'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/filters.rb:606:in `process_without_session_management_support'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/session_management.rb:134:in `process'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/base.rb:392:in `process'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:183:in `handle_request'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:110:in `dispatch_unlocked'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:123:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:122:in `synchronize'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:122:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:132:in `dispatch_cgi'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:39:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:103:in `handle_dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:74:in `service'
-    /usr/lib/ruby/1.8/webrick/httpserver.rb:104:in `service'
-    /usr/lib/ruby/1.8/webrick/httpserver.rb:65:in `run'
-    /usr/lib/ruby/1.8/webrick/server.rb:173:in `start_thread'
-    /usr/lib/ruby/1.8/webrick/server.rb:162:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:162:in `start_thread'
-    /usr/lib/ruby/1.8/webrick/server.rb:95:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:92:in `each'
-    /usr/lib/ruby/1.8/webrick/server.rb:92:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:23:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:82:in `start'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:60:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/commands/servers/webrick.rb:66
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `gem_original_require'
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `require'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:153:in `require'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:521:in `new_constants_in'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:153:in `require'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/commands/server.rb:49
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `gem_original_require'
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `require'
-    script/server:3
-
-Rendered /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/templates/rescues/_trace (91.3ms)
-Rendered /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/templates/rescues/_request_and_response (2.1ms)
-Rendering /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/templates/rescues/layout.erb (internal_server_error)
-
-
-Processing ProductsController#new (for 127.0.0.1 at 2009-02-02 16:25:14) [GET]
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mProduct Columns (2.9ms)\e[0m   \e[0;1mSHOW FIELDS FROM `products`\e[0m
-Rendering template within layouts/products
-Rendering products/new
-Completed in 53ms (View: 33, DB: 3) | 200 OK [http://localhost/products/new]
-
-
-Processing ProductsController#create (for 127.0.0.1 at 2009-02-02 16:25:16) [POST]
-  Parameters: {"commit"=>"Create", "authenticity_token"=>"8cca4a5b8c4003866a07c7a42d5a3b724d9e5d00", "product"=>{"image_url"=>"", "price"=>"0.0", "title"=>"", "date_available(1i)"=>"2009", "date_available(2i)"=>"2", "description"=>"", "date_available(3i)"=>"2"}}
-  \e[4;35;1mSQL (0.2ms)\e[0m   \e[0mSET NAMES 'utf8'\e[0m
-  \e[4;36;1mSQL (0.2ms)\e[0m   \e[0;1mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;35;1mProduct Columns (1.5ms)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mBEGIN\e[0m
-  \e[4;35;1mProduct Exists (0.5ms)\e[0m   \e[0mSELECT `products`.id FROM `products` WHERE (`products`.`title` = BINARY '') LIMIT 1\e[0m
-  \e[4;36;1mSQL (0.2ms)\e[0m   \e[0;1mROLLBACK\e[0m
-Rendering template within layouts/products
-Rendering products/new
-Completed in 67ms (View: 24, DB: 3) | 200 OK [http://localhost/products]
-
-
-Processing ProductsController#new (for 127.0.0.1 at 2009-02-02 16:26:36) [GET]
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSET NAMES 'utf8'\e[0m
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;35;1mProduct Columns (2.3ms)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
-Rendering template within layouts/products
-Rendering products/new
-Completed in 39ms (View: 21, DB: 3) | 200 OK [http://localhost/products/new]
-
-
-Processing ProductsController#create (for 127.0.0.1 at 2009-02-02 16:26:45) [POST]
-  Parameters: {"commit"=>"Create", "authenticity_token"=>"8cca4a5b8c4003866a07c7a42d5a3b724d9e5d00", "product"=>{"image_url"=>"", "price"=>"0.0", "title"=>"Second product", "date_available(1i)"=>"2009", "date_available(2i)"=>"2", "description"=>"kjhkjh", "date_available(3i)"=>"2"}}
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mProduct Columns (1.1ms)\e[0m   \e[0;1mSHOW FIELDS FROM `products`\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mBEGIN\e[0m
-  \e[4;36;1mProduct Exists (0.6ms)\e[0m   \e[0;1mSELECT `products`.id FROM `products` WHERE (`products`.`title` = BINARY 'Second product') LIMIT 1\e[0m
-  \e[4;35;1mSQL (0.2ms)\e[0m   \e[0mROLLBACK\e[0m
-Rendering template within layouts/products
-Rendering products/new
-Completed in 47ms (View: 17, DB: 2) | 200 OK [http://localhost/products]
-
-
-Processing ProductsController#create (for 127.0.0.1 at 2009-02-02 16:26:56) [POST]
-  Parameters: {"commit"=>"Create", "authenticity_token"=>"8cca4a5b8c4003866a07c7a42d5a3b724d9e5d00", "product"=>{"image_url"=>"host.png", "price"=>"aardvark", "title"=>"Second product", "date_available(1i)"=>"2009", "date_available(2i)"=>"2", "description"=>"kjhkjh", "date_available(3i)"=>"2"}}
-  \e[4;36;1mSQL (0.2ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.2ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mProduct Columns (1.3ms)\e[0m   \e[0;1mSHOW FIELDS FROM `products`\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mBEGIN\e[0m
-  \e[4;36;1mProduct Exists (0.2ms)\e[0m   \e[0;1mSELECT `products`.id FROM `products` WHERE (`products`.`title` = BINARY 'Second product') LIMIT 1\e[0m
-  \e[4;35;1mSQL (0.2ms)\e[0m   \e[0mROLLBACK\e[0m
-Rendering template within layouts/products
-Rendering products/new
-Completed in 62ms (View: 24, DB: 2) | 200 OK [http://localhost/products]
-
-
-Processing ProductsController#create (for 127.0.0.1 at 2009-02-02 16:27:03) [POST]
-  Parameters: {"commit"=>"Create", "authenticity_token"=>"8cca4a5b8c4003866a07c7a42d5a3b724d9e5d00", "product"=>{"image_url"=>"host.png", "price"=>"22", "title"=>"Second product", "date_available(1i)"=>"2009", "date_available(2i)"=>"2", "description"=>"kjhkjh", "date_available(3i)"=>"2"}}
-  \e[4;36;1mSQL (0.2ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.2ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mProduct Columns (1.6ms)\e[0m   \e[0;1mSHOW FIELDS FROM `products`\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mBEGIN\e[0m
-  \e[4;36;1mProduct Exists (0.1ms)\e[0m   \e[0;1mSELECT `products`.id FROM `products` WHERE (`products`.`title` = BINARY 'Second product') LIMIT 1\e[0m
-  \e[4;35;1mProduct Create (0.3ms)\e[0m   \e[0mINSERT INTO `products` (`image_url`, `updated_at`, `title`, `price`, `date_available`, `description`, `created_at`) VALUES('host.png', '2009-02-02 16:27:03', 'Second product', 22.0, '2009-02-02', 'kjhkjh', '2009-02-02 16:27:03')\e[0m
-  \e[4;36;1mSQL (45.2ms)\e[0m   \e[0;1mCOMMIT\e[0m
-Redirected to #<Product:0xb71ca720>
-Completed in 80ms (DB: 48) | 302 Found [http://localhost/products]
-
-
-Processing ProductsController#show (for 127.0.0.1 at 2009-02-02 16:27:03) [GET]
-  Parameters: {"id"=>"2"}
-  \e[4;35;1mSQL (0.2ms)\e[0m   \e[0mSET NAMES 'utf8'\e[0m
-  \e[4;36;1mSQL (0.2ms)\e[0m   \e[0;1mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;35;1mProduct Columns (2.1ms)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
-  \e[4;36;1mProduct Load (0.6ms)\e[0m   \e[0;1mSELECT * FROM `products` WHERE (`products`.`id` = 2) \e[0m
-Rendering template within layouts/products
-Rendering products/show
-Completed in 43ms (View: 19, DB: 3) | 200 OK [http://localhost/products/2]
-
-
-Processing ProductsController#index (for 127.0.0.1 at 2009-02-02 16:27:04) [GET]
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSET NAMES 'utf8'\e[0m
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;35;1mProduct Load (0.4ms)\e[0m   \e[0mSELECT * FROM `products` \e[0m
-Rendering template within layouts/products
-Rendering products/index
-  \e[4;36;1mProduct Columns (1.1ms)\e[0m   \e[0;1mSHOW FIELDS FROM `products`\e[0m
-Completed in 33ms (View: 17, DB: 2) | 200 OK [http://localhost/products]
-
-
-Processing ProductsController#edit (for 127.0.0.1 at 2009-02-02 16:27:10) [GET]
-  Parameters: {"id"=>"1"}
-  \e[4;35;1mSQL (0.2ms)\e[0m   \e[0mSET NAMES 'utf8'\e[0m
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;35;1mProduct Columns (1.2ms)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
-  \e[4;36;1mProduct Load (0.5ms)\e[0m   \e[0;1mSELECT * FROM `products` WHERE (`products`.`id` = 1) \e[0m
-Rendering template within layouts/products
-Rendering products/edit
-Completed in 39ms (View: 25, DB: 2) | 200 OK [http://localhost/products/1/edit]
-
-
-Processing ProductsController#update (for 127.0.0.1 at 2009-02-02 16:27:18) [PUT]
-  Parameters: {"commit"=>"Update", "authenticity_token"=>"8cca4a5b8c4003866a07c7a42d5a3b724d9e5d00", "product"=>{"image_url"=>"ss.png", "price"=>"10.00", "title"=>"fist prod", "date_available(1i)"=>"2009", "date_available(2i)"=>"2", "description"=>"desription and stuff", "date_available(3i)"=>"31"}, "id"=>"1"}
-  \e[4;35;1mSQL (0.2ms)\e[0m   \e[0mSET NAMES 'utf8'\e[0m
-  \e[4;36;1mSQL (0.2ms)\e[0m   \e[0;1mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;35;1mProduct Columns (1.1ms)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
-  \e[4;36;1mProduct Load (0.1ms)\e[0m   \e[0;1mSELECT * FROM `products` WHERE (`products`.`id` = 1) \e[0m
-  \e[4;35;1mSQL (0.2ms)\e[0m   \e[0mBEGIN\e[0m
-  \e[4;36;1mProduct Exists (0.5ms)\e[0m   \e[0;1mSELECT `products`.id FROM `products` WHERE (`products`.`title` = BINARY 'fist prod' AND `products`.id <> 1) LIMIT 1\e[0m
-  \e[4;35;1mProduct Update (0.4ms)\e[0m   \e[0mUPDATE `products` SET `date_available` = '2009-03-03', `updated_at` = '2009-02-02 16:27:18' WHERE `id` = 1\e[0m
-  \e[4;36;1mSQL (2.2ms)\e[0m   \e[0;1mCOMMIT\e[0m
-Redirected to #<Product:0xb7060790>
-Completed in 37ms (DB: 5) | 302 Found [http://localhost/products/1]
-
-
-Processing ProductsController#show (for 127.0.0.1 at 2009-02-02 16:27:18) [GET]
-  Parameters: {"id"=>"1"}
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSET NAMES 'utf8'\e[0m
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;35;1mProduct Columns (1.3ms)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
-  \e[4;36;1mProduct Load (0.5ms)\e[0m   \e[0;1mSELECT * FROM `products` WHERE (`products`.`id` = 1) \e[0m
-Rendering template within layouts/products
-Rendering products/show
-Completed in 37ms (View: 20, DB: 2) | 200 OK [http://localhost/products/1]
-
-
-Processing ProductsController#index (for 127.0.0.1 at 2009-02-02 16:27:22) [GET]
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSET NAMES 'utf8'\e[0m
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;35;1mProduct Load (0.4ms)\e[0m   \e[0mSELECT * FROM `products` \e[0m
-Rendering template within layouts/products
-Rendering products/index
-  \e[4;36;1mProduct Columns (1.1ms)\e[0m   \e[0;1mSHOW FIELDS FROM `products`\e[0m
-Completed in 35ms (View: 22, DB: 2) | 200 OK [http://localhost/products]
-  \e[4;36;1mSQL (0.5ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mSQL (16.7ms)\e[0m   \e[0;1mSHOW TABLES\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSELECT version FROM schema_migrations\e[0m
-Migrating to CreateProducts (20090202160210)
-Migrating to AddPriceToProduct (20090202160745)
-Migrating to AddDateAvailableToProduct (20090202160925)
-Migrating to AddTestData (20090202163608)
-  \e[4;36;1mProduct Delete all (44.9ms)\e[0m   \e[0;1mDELETE FROM `products` \e[0m
-  \e[4;35;1mProduct Columns (1.1ms)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mBEGIN\e[0m
-  \e[4;35;1mProduct Exists (0.6ms)\e[0m   \e[0mSELECT `products`.id FROM `products` WHERE (`products`.`title` = BINARY 'Snowball') LIMIT 1\e[0m
-  \e[4;36;1mProduct Create (0.4ms)\e[0m   \e[0;1mINSERT INTO `products` (`image_url`, `updated_at`, `title`, `price`, `date_available`, `description`, `created_at`) VALUES('/images/nowball.jpg', '2009-02-02 17:21:21', 'Snowball', 12.0, '2008-12-31 00:00:00', '<p>\n The perfect gift for a hot summer\'s day. What could be better \n than to surprise a loved one a gift of winter coolness? This\n snowball has been loving crafted from the purest snow, hand-collected\n from the pristine lawn of our back garden. \n </p>\n <p>\n Note that this is a perisiable item and some melting may occur \n while the snowball is in transit. \n </p>\n ', '2009-02-02 17:21:21')\e[0m
-  \e[4;35;1mSQL (5.9ms)\e[0m   \e[0mCOMMIT\e[0m
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mBEGIN\e[0m
-  \e[4;35;1mProduct Exists (0.4ms)\e[0m   \e[0mSELECT `products`.id FROM `products` WHERE (`products`.`title` = BINARY 'Daisy') LIMIT 1\e[0m
-  \e[4;36;1mProduct Create (0.4ms)\e[0m   \e[0;1mINSERT INTO `products` (`image_url`, `updated_at`, `title`, `price`, `date_available`, `description`, `created_at`) VALUES('/images/daisy.gif', '2009-02-02 17:21:21', 'Daisy', 5.0, '2011-07-01 00:00:00', '<p>\n All the world is better for having flowers in it. And your home \n will be the better for having this fine example of <i>Bellis \n perennis</i> gracing its walls. The range of uses of this item are\n truly remarkable. You can place it in an eggcup of water, you can \n insert it in a jacket for a subtle buttonhole posy, or you even \n purchase a multi-pack to create your own daisy chain!\n </p>\n ', '2009-02-02 17:21:21')\e[0m
-  \e[4;35;1mSQL (0.6ms)\e[0m   \e[0mCOMMIT\e[0m
-  \e[4;36;1mSQL (0.2ms)\e[0m   \e[0;1mBEGIN\e[0m
-  \e[4;35;1mProduct Exists (0.4ms)\e[0m   \e[0mSELECT `products`.id FROM `products` WHERE (`products`.`title` = BINARY 'Cardboard Box') LIMIT 1\e[0m
-  \e[4;36;1mProduct Create (0.3ms)\e[0m   \e[0;1mINSERT INTO `products` (`image_url`, `updated_at`, `title`, `price`, `date_available`, `description`, `created_at`) VALUES('/images/cardboard-box.jpg', '2009-02-02 17:21:21', 'Cardboard Box', 10.0, '2007-01-01 00:00:00', '<p>The gift that keeps on giving, you\'ll wonder how you ever did \n without a cardboard box in your home. Us it for a range of uses, \n including putting things in and keeping things in. We can provide\n you with a cardboard box that is versatile and suitable for any\n occasion. Some of our directors even use them for sleeping in!\n </p>\n ', '2009-02-02 17:21:21')\e[0m
-  \e[4;35;1mSQL (0.5ms)\e[0m   \e[0mCOMMIT\e[0m
-  \e[4;36;1mSQL (0.2ms)\e[0m   \e[0;1mBEGIN\e[0m
-  \e[4;35;1mProduct Exists (0.4ms)\e[0m   \e[0mSELECT `products`.id FROM `products` WHERE (`products`.`title` = BINARY 'Air') LIMIT 1\e[0m
-  \e[4;36;1mProduct Create (0.6ms)\e[0m   \e[0;1mINSERT INTO `products` (`image_url`, `updated_at`, `title`, `price`, `date_available`, `description`, `created_at`) VALUES('/images/can-of-air.jpg', '2009-02-02 17:21:21', 'Air', 5000.0, '2009-01-01 00:00:00', '<p>An essential for all activities, <i>Air</i> is vital for your\n wellbeing and vitality. Our air is carefully packaged to contain\n only 100% pure air, with no artificial colours or preservatives.\n </p>\n <p>May contain nuts.\n </p>\n ', '2009-02-02 17:21:21')\e[0m
-  \e[4;35;1mSQL (11.8ms)\e[0m   \e[0mCOMMIT\e[0m
-  \e[4;36;1mSQL (0.6ms)\e[0m   \e[0;1mINSERT INTO schema_migrations (version) VALUES ('20090202163608')\e[0m
-  \e[4;35;1mSQL (0.4ms)\e[0m   \e[0mSHOW TABLES\e[0m
-  \e[4;36;1mSQL (0.3ms)\e[0m   \e[0;1mSELECT version FROM schema_migrations\e[0m
-  \e[4;35;1mSQL (0.3ms)\e[0m   \e[0mSHOW TABLES\e[0m
-  \e[4;36;1mSQL (1.5ms)\e[0m   \e[0;1mSHOW FIELDS FROM `products`\e[0m
-  \e[4;35;1mSQL (1.5ms)\e[0m   \e[0mdescribe `products`\e[0m
-  \e[4;36;1mSQL (0.7ms)\e[0m   \e[0;1mSHOW KEYS FROM `products`\e[0m
-
-
-Processing ProductsController#index (for 127.0.0.1 at 2009-02-02 17:21:25) [GET]
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSET NAMES 'utf8'\e[0m
-  \e[4;36;1mSQL (0.2ms)\e[0m   \e[0;1mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;35;1mProduct Load (0.5ms)\e[0m   \e[0mSELECT * FROM `products` \e[0m
-Rendering template within layouts/products
-Rendering products/index
-  \e[4;36;1mProduct Columns (1.1ms)\e[0m   \e[0;1mSHOW FIELDS FROM `products`\e[0m
-Completed in 166ms (View: 150, DB: 2) | 200 OK [http://localhost/products]
-
-
-Processing ProductsController#index (for 127.0.0.1 at 2009-02-02 17:36:09) [GET]
-  \e[4;35;1mSQL (0.2ms)\e[0m   \e[0mSET NAMES 'utf8'\e[0m
-  \e[4;36;1mSQL (0.2ms)\e[0m   \e[0;1mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;35;1mProduct Load (0.2ms)\e[0m   \e[0mSELECT * FROM `products` \e[0m
-Rendering template within layouts/products
-Rendering products/index
-  \e[4;36;1mProduct Columns (1.1ms)\e[0m   \e[0;1mSHOW FIELDS FROM `products`\e[0m
-Completed in 55ms (View: 38, DB: 2) | 200 OK [http://localhost/products]
-
-
-Processing ApplicationController#index (for 127.0.0.1 at 2009-02-02 17:36:09) [GET]
-
-
-ActionController::RoutingError (No route matches "/images/nowball.jpg" with {:method=>:get}):
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/routing/recognition_optimisation.rb:66:in `recognize_path'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/routing/route_set.rb:386:in `recognize'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:182:in `handle_request'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:110:in `dispatch_unlocked'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:123:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:122:in `synchronize'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:122:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:132:in `dispatch_cgi'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:39:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:103:in `handle_dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:74:in `service'
-    /usr/lib/ruby/1.8/webrick/httpserver.rb:104:in `service'
-    /usr/lib/ruby/1.8/webrick/httpserver.rb:65:in `run'
-    /usr/lib/ruby/1.8/webrick/server.rb:173:in `start_thread'
-    /usr/lib/ruby/1.8/webrick/server.rb:162:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:162:in `start_thread'
-    /usr/lib/ruby/1.8/webrick/server.rb:95:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:92:in `each'
-    /usr/lib/ruby/1.8/webrick/server.rb:92:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:23:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:82:in `start'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:60:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/commands/servers/webrick.rb:66
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `gem_original_require'
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `require'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:153:in `require'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:521:in `new_constants_in'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:153:in `require'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/commands/server.rb:49
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `gem_original_require'
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `require'
-    script/server:3
-
-Rendering /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/templates/rescues/layout.erb (not_found)
-  \e[4;36;1mSQL (0.2ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mSQL (0.4ms)\e[0m   \e[0;1mSHOW TABLES\e[0m
-  \e[4;35;1mSQL (0.2ms)\e[0m   \e[0mSELECT version FROM schema_migrations\e[0m
-  \e[4;36;1mSQL (0.3ms)\e[0m   \e[0;1mSHOW TABLES\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSELECT version FROM schema_migrations\e[0m
-Migrating to AddTestData (20090202163608)
-  \e[4;36;1mProduct Delete all (28.7ms)\e[0m   \e[0;1mDELETE FROM `products` \e[0m
-  \e[4;35;1mSQL (5.7ms)\e[0m   \e[0mDELETE FROM schema_migrations WHERE version = '20090202163608'\e[0m
-Migrating to AddDateAvailableToProduct (20090202160925)
-  \e[4;36;1mSQL (60.2ms)\e[0m   \e[0;1mALTER TABLE `products` DROP `date_available`\e[0m
-  \e[4;35;1mSQL (3.3ms)\e[0m   \e[0mDELETE FROM schema_migrations WHERE version = '20090202160925'\e[0m
-Migrating to AddPriceToProduct (20090202160745)
-  \e[4;36;1mSQL (33.2ms)\e[0m   \e[0;1mALTER TABLE `products` DROP `price`\e[0m
-  \e[4;35;1mSQL (0.7ms)\e[0m   \e[0mDELETE FROM schema_migrations WHERE version = '20090202160745'\e[0m
-Migrating to CreateProducts (20090202160210)
-  \e[4;36;1mSQL (1.4ms)\e[0m   \e[0;1mDROP TABLE `products`\e[0m
-  \e[4;35;1mSQL (0.8ms)\e[0m   \e[0mDELETE FROM schema_migrations WHERE version = '20090202160210'\e[0m
-  \e[4;36;1mSQL (0.4ms)\e[0m   \e[0;1mSHOW TABLES\e[0m
-  \e[4;35;1mSQL (0.3ms)\e[0m   \e[0mSELECT version FROM schema_migrations\e[0m
-  \e[4;36;1mSQL (0.3ms)\e[0m   \e[0;1mSHOW TABLES\e[0m
-  \e[4;36;1mSQL (0.2ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mSQL (0.7ms)\e[0m   \e[0;1mSHOW TABLES\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSELECT version FROM schema_migrations\e[0m
-Migrating to CreateProducts (20090202160210)
-  \e[4;36;1mSQL (9.2ms)\e[0m   \e[0;1mCREATE TABLE `products` (`id` int(11) DEFAULT NULL auto_increment PRIMARY KEY, `title` varchar(255), `description` text, `image_url` varchar(255), `created_at` datetime, `updated_at` datetime) ENGINE=InnoDB\e[0m
-  \e[4;35;1mSQL (0.7ms)\e[0m   \e[0mINSERT INTO schema_migrations (version) VALUES ('20090202160210')\e[0m
-Migrating to AddPriceToProduct (20090202160745)
-  \e[4;36;1mSQL (29.7ms)\e[0m   \e[0;1mALTER TABLE `products` ADD `price` decimal(8,2) DEFAULT 0\e[0m
-  \e[4;35;1mSQL (7.3ms)\e[0m   \e[0mINSERT INTO schema_migrations (version) VALUES ('20090202160745')\e[0m
-Migrating to AddDateAvailableToProduct (20090202160925)
-  \e[4;36;1mSQL (6.3ms)\e[0m   \e[0;1mALTER TABLE `products` ADD `date_available` date\e[0m
-  \e[4;35;1mSQL (12.2ms)\e[0m   \e[0mINSERT INTO schema_migrations (version) VALUES ('20090202160925')\e[0m
-Migrating to AddTestData (20090202163608)
-  \e[4;36;1mProduct Delete all (0.3ms)\e[0m   \e[0;1mDELETE FROM `products` \e[0m
-  \e[4;35;1mProduct Columns (1.1ms)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
-  \e[4;36;1mSQL (0.2ms)\e[0m   \e[0;1mBEGIN\e[0m
-  \e[4;35;1mProduct Exists (0.5ms)\e[0m   \e[0mSELECT `products`.id FROM `products` WHERE (`products`.`title` = BINARY 'Snowball') LIMIT 1\e[0m
-  \e[4;36;1mProduct Create (0.6ms)\e[0m   \e[0;1mINSERT INTO `products` (`image_url`, `updated_at`, `title`, `price`, `date_available`, `description`, `created_at`) VALUES('/images/snowball.jpg', '2009-02-02 17:36:52', 'Snowball', 12.0, '2008-12-31 00:00:00', '<p>\n The perfect gift for a hot summer\'s day. What could be better \n than to surprise a loved one a gift of winter coolness? This\n snowball has been loving crafted from the purest snow, hand-collected\n from the pristine lawn of our back garden. \n </p>\n <p>\n Note that this is a perisiable item and some melting may occur \n while the snowball is in transit. \n </p>\n ', '2009-02-02 17:36:52')\e[0m
-  \e[4;35;1mSQL (1.1ms)\e[0m   \e[0mCOMMIT\e[0m
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mBEGIN\e[0m
-  \e[4;35;1mProduct Exists (0.3ms)\e[0m   \e[0mSELECT `products`.id FROM `products` WHERE (`products`.`title` = BINARY 'Daisy') LIMIT 1\e[0m
-  \e[4;36;1mProduct Create (0.4ms)\e[0m   \e[0;1mINSERT INTO `products` (`image_url`, `updated_at`, `title`, `price`, `date_available`, `description`, `created_at`) VALUES('/images/daisy.gif', '2009-02-02 17:36:52', 'Daisy', 5.0, '2011-07-01 00:00:00', '<p>\n All the world is better for having flowers in it. And your home \n will be the better for having this fine example of <i>Bellis \n perennis</i> gracing its walls. The range of uses of this item are\n truly remarkable. You can place it in an eggcup of water, you can \n insert it in a jacket for a subtle buttonhole posy, or you even \n purchase a multi-pack to create your own daisy chain!\n </p>\n ', '2009-02-02 17:36:52')\e[0m
-  \e[4;35;1mSQL (0.6ms)\e[0m   \e[0mCOMMIT\e[0m
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mBEGIN\e[0m
-  \e[4;35;1mProduct Exists (0.3ms)\e[0m   \e[0mSELECT `products`.id FROM `products` WHERE (`products`.`title` = BINARY 'Cardboard Box') LIMIT 1\e[0m
-  \e[4;36;1mProduct Create (0.3ms)\e[0m   \e[0;1mINSERT INTO `products` (`image_url`, `updated_at`, `title`, `price`, `date_available`, `description`, `created_at`) VALUES('/images/cardboard-box.jpg', '2009-02-02 17:36:52', 'Cardboard Box', 10.0, '2007-01-01 00:00:00', '<p>The gift that keeps on giving, you\'ll wonder how you ever did \n without a cardboard box in your home. Us it for a range of uses, \n including putting things in and keeping things in. We can provide\n you with a cardboard box that is versatile and suitable for any\n occasion. Some of our directors even use them for sleeping in!\n </p>\n ', '2009-02-02 17:36:52')\e[0m
-  \e[4;35;1mSQL (5.4ms)\e[0m   \e[0mCOMMIT\e[0m
-  \e[4;36;1mSQL (0.3ms)\e[0m   \e[0;1mBEGIN\e[0m
-  \e[4;35;1mProduct Exists (0.3ms)\e[0m   \e[0mSELECT `products`.id FROM `products` WHERE (`products`.`title` = BINARY 'Air') LIMIT 1\e[0m
-  \e[4;36;1mProduct Create (0.3ms)\e[0m   \e[0;1mINSERT INTO `products` (`image_url`, `updated_at`, `title`, `price`, `date_available`, `description`, `created_at`) VALUES('/images/can-of-air.jpg', '2009-02-02 17:36:52', 'Air', 5000.0, '2009-01-01 00:00:00', '<p>An essential for all activities, <i>Air</i> is vital for your\n wellbeing and vitality. Our air is carefully packaged to contain\n only 100% pure air, with no artificial colours or preservatives.\n </p>\n <p>May contain nuts.\n </p>\n ', '2009-02-02 17:36:52')\e[0m
-  \e[4;35;1mSQL (0.7ms)\e[0m   \e[0mCOMMIT\e[0m
-  \e[4;36;1mSQL (0.7ms)\e[0m   \e[0;1mINSERT INTO schema_migrations (version) VALUES ('20090202163608')\e[0m
-  \e[4;35;1mSQL (0.4ms)\e[0m   \e[0mSHOW TABLES\e[0m
-  \e[4;36;1mSQL (3.5ms)\e[0m   \e[0;1mSELECT version FROM schema_migrations\e[0m
-  \e[4;35;1mSQL (0.5ms)\e[0m   \e[0mSHOW TABLES\e[0m
-  \e[4;36;1mSQL (2.4ms)\e[0m   \e[0;1mSHOW FIELDS FROM `products`\e[0m
-  \e[4;35;1mSQL (2.3ms)\e[0m   \e[0mdescribe `products`\e[0m
-  \e[4;36;1mSQL (1.5ms)\e[0m   \e[0;1mSHOW KEYS FROM `products`\e[0m
-
-
-Processing ProductsController#index (for 127.0.0.1 at 2009-02-02 17:36:57) [GET]
-  \e[4;35;1mSQL (0.2ms)\e[0m   \e[0mSET NAMES 'utf8'\e[0m
-  \e[4;36;1mSQL (0.2ms)\e[0m   \e[0;1mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;35;1mProduct Load (0.7ms)\e[0m   \e[0mSELECT * FROM `products` \e[0m
-Rendering template within layouts/products
-Rendering products/index
-  \e[4;36;1mProduct Columns (1.1ms)\e[0m   \e[0;1mSHOW FIELDS FROM `products`\e[0m
-Completed in 48ms (View: 35, DB: 2) | 200 OK [http://localhost/products]
-
-
-Processing ProductsController#index (for 127.0.0.1 at 2009-02-02 20:17:43) [GET]
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSET NAMES 'utf8'\e[0m
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;35;1mProduct Load (0.2ms)\e[0m   \e[0mSELECT * FROM `products` \e[0m
-Rendering template within layouts/products
-Rendering products/index
-  \e[4;36;1mProduct Columns (1.7ms)\e[0m   \e[0;1mSHOW FIELDS FROM `products`\e[0m
-Completed in 59ms (View: 41, DB: 2) | 200 OK [http://localhost/products]
-  \e[4;36;1mSQL (0.2ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mSQL (0.3ms)\e[0m   \e[0;1mSHOW TABLES\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSELECT version FROM schema_migrations\e[0m
-  \e[4;36;1mSQL (0.3ms)\e[0m   \e[0;1mSHOW TABLES\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSELECT version FROM schema_migrations\e[0m
-Migrating to AddTestData (20090202163608)
-  \e[4;36;1mProduct Delete all (28.1ms)\e[0m   \e[0;1mDELETE FROM `products` \e[0m
-  \e[4;35;1mSQL (0.7ms)\e[0m   \e[0mDELETE FROM schema_migrations WHERE version = '20090202163608'\e[0m
-Migrating to AddDateAvailableToProduct (20090202160925)
-  \e[4;36;1mSQL (38.8ms)\e[0m   \e[0;1mALTER TABLE `products` DROP `date_available`\e[0m
-  \e[4;35;1mSQL (1.1ms)\e[0m   \e[0mDELETE FROM schema_migrations WHERE version = '20090202160925'\e[0m
-Migrating to AddPriceToProduct (20090202160745)
-  \e[4;36;1mSQL (6.4ms)\e[0m   \e[0;1mALTER TABLE `products` DROP `price`\e[0m
-  \e[4;35;1mSQL (0.8ms)\e[0m   \e[0mDELETE FROM schema_migrations WHERE version = '20090202160745'\e[0m
-Migrating to CreateProducts (20090202160210)
-  \e[4;36;1mSQL (1.4ms)\e[0m   \e[0;1mDROP TABLE `products`\e[0m
-  \e[4;35;1mSQL (0.9ms)\e[0m   \e[0mDELETE FROM schema_migrations WHERE version = '20090202160210'\e[0m
-  \e[4;36;1mSQL (0.4ms)\e[0m   \e[0;1mSHOW TABLES\e[0m
-  \e[4;35;1mSQL (0.3ms)\e[0m   \e[0mSELECT version FROM schema_migrations\e[0m
-  \e[4;36;1mSQL (0.3ms)\e[0m   \e[0;1mSHOW TABLES\e[0m
-  \e[4;36;1mSQL (0.2ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mSQL (0.4ms)\e[0m   \e[0;1mSHOW TABLES\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSELECT version FROM schema_migrations\e[0m
-Migrating to CreateProducts (20090202160210)
-  \e[4;36;1mSQL (37.1ms)\e[0m   \e[0;1mCREATE TABLE `products` (`id` int(11) DEFAULT NULL auto_increment PRIMARY KEY, `title` varchar(255), `description` text, `image_url` varchar(255), `created_at` datetime, `updated_at` datetime) ENGINE=InnoDB\e[0m
-  \e[4;35;1mSQL (0.7ms)\e[0m   \e[0mINSERT INTO schema_migrations (version) VALUES ('20090202160210')\e[0m
-Migrating to AddPriceToProduct (20090202160745)
-  \e[4;36;1mSQL (21.6ms)\e[0m   \e[0;1mALTER TABLE `products` ADD `price` decimal(8,2) DEFAULT 0\e[0m
-  \e[4;35;1mSQL (0.6ms)\e[0m   \e[0mINSERT INTO schema_migrations (version) VALUES ('20090202160745')\e[0m
-Migrating to AddDateAvailableToProduct (20090202160925)
-  \e[4;36;1mSQL (6.7ms)\e[0m   \e[0;1mALTER TABLE `products` ADD `date_available` date\e[0m
-  \e[4;35;1mSQL (0.6ms)\e[0m   \e[0mINSERT INTO schema_migrations (version) VALUES ('20090202160925')\e[0m
-Migrating to AddTestData (20090202163608)
-  \e[4;36;1mProduct Delete all (0.3ms)\e[0m   \e[0;1mDELETE FROM `products` \e[0m
-  \e[4;35;1mProduct Columns (1.1ms)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
-  \e[4;36;1mSQL (0.2ms)\e[0m   \e[0;1mBEGIN\e[0m
-  \e[4;35;1mProduct Exists (0.3ms)\e[0m   \e[0mSELECT `products`.id FROM `products` WHERE (`products`.`title` = BINARY 'Snowball') LIMIT 1\e[0m
-  \e[4;36;1mProduct Create (0.4ms)\e[0m   \e[0;1mINSERT INTO `products` (`image_url`, `updated_at`, `title`, `price`, `date_available`, `description`, `created_at`) VALUES('/images/snowball.jpg', '2009-02-02 22:16:01', 'Snowball', 12.0, '2008-12-31 00:00:00', '<p>The perfect gift for a hot summer\'s day. What could be better \n than to surprise a loved one a gift of winter coolness? This\n snowball has been loving crafted from the purest snow, hand-collected\n from the pristine lawn of our back garden. \n </p>\n <p>\n Note that this is a perisiable item and some melting may occur \n while the snowball is in transit. \n </p>\n ', '2009-02-02 22:16:01')\e[0m
-  \e[4;35;1mSQL (0.6ms)\e[0m   \e[0mCOMMIT\e[0m
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mBEGIN\e[0m
-  \e[4;35;1mProduct Exists (0.4ms)\e[0m   \e[0mSELECT `products`.id FROM `products` WHERE (`products`.`title` = BINARY 'Daisy') LIMIT 1\e[0m
-  \e[4;36;1mProduct Create (0.6ms)\e[0m   \e[0;1mINSERT INTO `products` (`image_url`, `updated_at`, `title`, `price`, `date_available`, `description`, `created_at`) VALUES('/images/daisy.gif', '2009-02-02 22:16:01', 'Daisy', 5.0, '2011-07-01 00:00:00', '<p>All the world is better for having flowers in it. And your home \n will be the better for having this fine example of <i>Bellis \n perennis</i> gracing its walls. The range of uses of this item are\n truly remarkable. You can place it in an eggcup of water, you can \n insert it in a jacket for a subtle buttonhole posy, or you even \n purchase a multi-pack to create your own daisy chain!\n </p>\n ', '2009-02-02 22:16:01')\e[0m
-  \e[4;35;1mSQL (1.1ms)\e[0m   \e[0mCOMMIT\e[0m
-  \e[4;36;1mSQL (0.3ms)\e[0m   \e[0;1mBEGIN\e[0m
-  \e[4;35;1mProduct Exists (0.9ms)\e[0m   \e[0mSELECT `products`.id FROM `products` WHERE (`products`.`title` = BINARY 'Cardboard Box') LIMIT 1\e[0m
-  \e[4;36;1mProduct Create (0.5ms)\e[0m   \e[0;1mINSERT INTO `products` (`image_url`, `updated_at`, `title`, `price`, `date_available`, `description`, `created_at`) VALUES('/images/cardboard-box.jpg', '2009-02-02 22:16:01', 'Cardboard Box', 10.0, '2007-01-01 00:00:00', '<p>The gift that keeps on giving, you\'ll wonder how you ever did \n without a cardboard box in your home. Us it for a range of uses, \n including putting things in and keeping things in. We can provide\n you with a cardboard box that is versatile and suitable for any\n occasion. Some of our directors even use them for sleeping in!\n </p>\n ', '2009-02-02 22:16:01')\e[0m
-  \e[4;35;1mSQL (0.8ms)\e[0m   \e[0mCOMMIT\e[0m
-  \e[4;36;1mSQL (0.2ms)\e[0m   \e[0;1mBEGIN\e[0m
-  \e[4;35;1mProduct Exists (0.5ms)\e[0m   \e[0mSELECT `products`.id FROM `products` WHERE (`products`.`title` = BINARY 'Air') LIMIT 1\e[0m
-  \e[4;36;1mProduct Create (0.3ms)\e[0m   \e[0;1mINSERT INTO `products` (`image_url`, `updated_at`, `title`, `price`, `date_available`, `description`, `created_at`) VALUES('/images/can-of-air.jpg', '2009-02-02 22:16:01', 'Air', 5000.0, '2009-01-01 00:00:00', '<p>An essential for all activities, <i>Air</i> is vital for your\n wellbeing and vitality. Our air is carefully packaged to contain\n only 100% pure air, with no artificial colours or preservatives.\n </p>\n <p>May contain nuts.\n </p>\n ', '2009-02-02 22:16:01')\e[0m
-  \e[4;35;1mSQL (0.5ms)\e[0m   \e[0mCOMMIT\e[0m
-  \e[4;36;1mSQL (0.6ms)\e[0m   \e[0;1mINSERT INTO schema_migrations (version) VALUES ('20090202163608')\e[0m
-  \e[4;35;1mSQL (0.3ms)\e[0m   \e[0mSHOW TABLES\e[0m
-  \e[4;36;1mSQL (0.3ms)\e[0m   \e[0;1mSELECT version FROM schema_migrations\e[0m
-  \e[4;35;1mSQL (0.3ms)\e[0m   \e[0mSHOW TABLES\e[0m
-  \e[4;36;1mSQL (1.1ms)\e[0m   \e[0;1mSHOW FIELDS FROM `products`\e[0m
-  \e[4;35;1mSQL (1.0ms)\e[0m   \e[0mdescribe `products`\e[0m
-  \e[4;36;1mSQL (0.4ms)\e[0m   \e[0;1mSHOW KEYS FROM `products`\e[0m
-
-
-Processing ProductsController#index (for 127.0.0.1 at 2009-02-02 22:16:08) [GET]
-  \e[4;35;1mSQL (0.2ms)\e[0m   \e[0mSET NAMES 'utf8'\e[0m
-  \e[4;36;1mSQL (0.2ms)\e[0m   \e[0;1mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;35;1mProduct Load (0.5ms)\e[0m   \e[0mSELECT * FROM `products` \e[0m
-Rendering template within layouts/products
-Rendering products/index
-  \e[4;36;1mProduct Columns (1.1ms)\e[0m   \e[0;1mSHOW FIELDS FROM `products`\e[0m
-Completed in 56ms (View: 38, DB: 2) | 200 OK [http://localhost/products]
-
-
-Processing ProductsController#edit (for 127.0.0.1 at 2009-02-02 22:16:31) [GET]
-  Parameters: {"id"=>"1"}
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSET NAMES 'utf8'\e[0m
-  \e[4;36;1mSQL (1.3ms)\e[0m   \e[0;1mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;35;1mProduct Columns (1.8ms)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
-  \e[4;36;1mProduct Load (0.4ms)\e[0m   \e[0;1mSELECT * FROM `products` WHERE (`products`.`id` = 1) \e[0m
-Rendering template within layouts/products
-Rendering products/edit
-Completed in 57ms (View: 37, DB: 4) | 200 OK [http://localhost/products/1/edit]
-  \e[4;36;1mSQL (0.2ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mSQL (0.4ms)\e[0m   \e[0;1mSHOW TABLES\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSELECT version FROM schema_migrations\e[0m
-  \e[4;36;1mSQL (0.3ms)\e[0m   \e[0;1mSHOW TABLES\e[0m
-  \e[4;35;1mSQL (0.2ms)\e[0m   \e[0mSELECT version FROM schema_migrations\e[0m
-Migrating to AddTestData (20090202163608)
-  \e[4;36;1mProduct Delete all (38.0ms)\e[0m   \e[0;1mDELETE FROM `products` \e[0m
-  \e[4;35;1mSQL (0.8ms)\e[0m   \e[0mDELETE FROM schema_migrations WHERE version = '20090202163608'\e[0m
-Migrating to AddDateAvailableToProduct (20090202160925)
-  \e[4;36;1mSQL (26.5ms)\e[0m   \e[0;1mALTER TABLE `products` DROP `date_available`\e[0m
-  \e[4;35;1mSQL (0.7ms)\e[0m   \e[0mDELETE FROM schema_migrations WHERE version = '20090202160925'\e[0m
-Migrating to AddPriceToProduct (20090202160745)
-  \e[4;36;1mSQL (14.0ms)\e[0m   \e[0;1mALTER TABLE `products` DROP `price`\e[0m
-  \e[4;35;1mSQL (0.7ms)\e[0m   \e[0mDELETE FROM schema_migrations WHERE version = '20090202160745'\e[0m
-Migrating to CreateProducts (20090202160210)
-  \e[4;36;1mSQL (1.5ms)\e[0m   \e[0;1mDROP TABLE `products`\e[0m
-  \e[4;35;1mSQL (0.7ms)\e[0m   \e[0mDELETE FROM schema_migrations WHERE version = '20090202160210'\e[0m
-  \e[4;36;1mSQL (0.3ms)\e[0m   \e[0;1mSHOW TABLES\e[0m
-  \e[4;35;1mSQL (0.3ms)\e[0m   \e[0mSELECT version FROM schema_migrations\e[0m
-  \e[4;36;1mSQL (0.3ms)\e[0m   \e[0;1mSHOW TABLES\e[0m
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mSQL (0.4ms)\e[0m   \e[0;1mSHOW TABLES\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSELECT version FROM schema_migrations\e[0m
-Migrating to CreateProducts (20090202160210)
-  \e[4;36;1mSQL (7.7ms)\e[0m   \e[0;1mCREATE TABLE `products` (`id` int(11) DEFAULT NULL auto_increment PRIMARY KEY, `title` varchar(255), `description` text, `image_url` varchar(255), `created_at` datetime, `updated_at` datetime) ENGINE=InnoDB\e[0m
-  \e[4;35;1mSQL (1.3ms)\e[0m   \e[0mINSERT INTO schema_migrations (version) VALUES ('20090202160210')\e[0m
-Migrating to AddPriceToProduct (20090202160745)
-  \e[4;36;1mSQL (23.0ms)\e[0m   \e[0;1mALTER TABLE `products` ADD `price` decimal(8,2) DEFAULT 0\e[0m
-  \e[4;35;1mSQL (12.3ms)\e[0m   \e[0mINSERT INTO schema_migrations (version) VALUES ('20090202160745')\e[0m
-Migrating to AddDateAvailableToProduct (20090202160925)
-  \e[4;36;1mSQL (17.7ms)\e[0m   \e[0;1mALTER TABLE `products` ADD `date_available` date\e[0m
-  \e[4;35;1mSQL (2.5ms)\e[0m   \e[0mINSERT INTO schema_migrations (version) VALUES ('20090202160925')\e[0m
-Migrating to AddTestData (20090202163608)
-  \e[4;36;1mProduct Delete all (0.3ms)\e[0m   \e[0;1mDELETE FROM `products` \e[0m
-  \e[4;35;1mProduct Columns (1.1ms)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mBEGIN\e[0m
-  \e[4;35;1mProduct Exists (2.3ms)\e[0m   \e[0mSELECT `products`.id FROM `products` WHERE (`products`.`title` = BINARY 'Snowball') LIMIT 1\e[0m
-  \e[4;36;1mProduct Create (0.8ms)\e[0m   \e[0;1mINSERT INTO `products` (`image_url`, `updated_at`, `title`, `price`, `date_available`, `description`, `created_at`) VALUES('/images/snowball.jpg', '2009-02-02 22:17:07', 'Snowball', 12.0, '2008-12-31 00:00:00', '<p>The perfect gift for a hot summer\'s day. What could be better \n than to surprise a loved one a gift of winter coolness? This\n snowball has been loving crafted from the purest snow, hand-collected\n from the pristine lawn of our back garden. \n </p>\n <p>\n Note that this is a perishiable item and some melting may occur \n while the snowball is in transit. \n </p>\n ', '2009-02-02 22:17:07')\e[0m
-  \e[4;35;1mSQL (1.0ms)\e[0m   \e[0mCOMMIT\e[0m
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mBEGIN\e[0m
-  \e[4;35;1mProduct Exists (0.3ms)\e[0m   \e[0mSELECT `products`.id FROM `products` WHERE (`products`.`title` = BINARY 'Daisy') LIMIT 1\e[0m
-  \e[4;36;1mProduct Create (0.7ms)\e[0m   \e[0;1mINSERT INTO `products` (`image_url`, `updated_at`, `title`, `price`, `date_available`, `description`, `created_at`) VALUES('/images/daisy.gif', '2009-02-02 22:17:07', 'Daisy', 5.0, '2011-07-01 00:00:00', '<p>All the world is better for having flowers in it. And your home \n will be the better for having this fine example of <i>Bellis \n perennis</i> gracing its walls. The range of uses of this item are\n truly remarkable. You can place it in an eggcup of water, you can \n insert it in a jacket for a subtle buttonhole posy, or you even \n purchase a multi-pack to create your own daisy chain!\n </p>\n ', '2009-02-02 22:17:07')\e[0m
-  \e[4;35;1mSQL (0.5ms)\e[0m   \e[0mCOMMIT\e[0m
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mBEGIN\e[0m
-  \e[4;35;1mProduct Exists (0.3ms)\e[0m   \e[0mSELECT `products`.id FROM `products` WHERE (`products`.`title` = BINARY 'Cardboard Box') LIMIT 1\e[0m
-  \e[4;36;1mProduct Create (0.3ms)\e[0m   \e[0;1mINSERT INTO `products` (`image_url`, `updated_at`, `title`, `price`, `date_available`, `description`, `created_at`) VALUES('/images/cardboard-box.jpg', '2009-02-02 22:17:07', 'Cardboard Box', 10.0, '2007-01-01 00:00:00', '<p>The gift that keeps on giving, you\'ll wonder how you ever did \n without a cardboard box in your home. Us it for a range of uses, \n including putting things in and keeping things in. We can provide\n you with a cardboard box that is versatile and suitable for any\n occasion. Some of our directors even use them for sleeping in!\n </p>\n ', '2009-02-02 22:17:07')\e[0m
-  \e[4;35;1mSQL (0.5ms)\e[0m   \e[0mCOMMIT\e[0m
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mBEGIN\e[0m
-  \e[4;35;1mProduct Exists (0.4ms)\e[0m   \e[0mSELECT `products`.id FROM `products` WHERE (`products`.`title` = BINARY 'Air') LIMIT 1\e[0m
-  \e[4;36;1mProduct Create (0.3ms)\e[0m   \e[0;1mINSERT INTO `products` (`image_url`, `updated_at`, `title`, `price`, `date_available`, `description`, `created_at`) VALUES('/images/can-of-air.jpg', '2009-02-02 22:17:07', 'Air', 5000.0, '2009-01-01 00:00:00', '<p>An essential for all activities, <i>Air</i> is vital for your\n wellbeing and vitality. Our air is carefully packaged to contain\n only 100% pure air, with no artificial colours or preservatives.\n </p>\n <p>May contain nuts.\n </p>\n ', '2009-02-02 22:17:07')\e[0m
-  \e[4;35;1mSQL (8.3ms)\e[0m   \e[0mCOMMIT\e[0m
-  \e[4;36;1mSQL (0.6ms)\e[0m   \e[0;1mINSERT INTO schema_migrations (version) VALUES ('20090202163608')\e[0m
-  \e[4;35;1mSQL (9.7ms)\e[0m   \e[0mSHOW TABLES\e[0m
-  \e[4;36;1mSQL (0.8ms)\e[0m   \e[0;1mSELECT version FROM schema_migrations\e[0m
-  \e[4;35;1mSQL (0.7ms)\e[0m   \e[0mSHOW TABLES\e[0m
-  \e[4;36;1mSQL (1.7ms)\e[0m   \e[0;1mSHOW FIELDS FROM `products`\e[0m
-  \e[4;35;1mSQL (2.1ms)\e[0m   \e[0mdescribe `products`\e[0m
-  \e[4;36;1mSQL (0.5ms)\e[0m   \e[0;1mSHOW KEYS FROM `products`\e[0m
-
-
-Processing ProductsController#edit (for 127.0.0.1 at 2009-02-02 22:17:11) [GET]
-  Parameters: {"id"=>"1"}
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSET NAMES 'utf8'\e[0m
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;35;1mProduct Columns (1.4ms)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
-  \e[4;36;1mProduct Load (0.4ms)\e[0m   \e[0;1mSELECT * FROM `products` WHERE (`products`.`id` = 1) \e[0m
-Rendering template within layouts/products
-Rendering products/edit
-Completed in 43ms (View: 26, DB: 2) | 200 OK [http://localhost/products/1/edit]
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mSQL (0.4ms)\e[0m   \e[0;1mSHOW TABLES\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSELECT version FROM schema_migrations\e[0m
-  \e[4;36;1mSQL (0.3ms)\e[0m   \e[0;1mSHOW TABLES\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSELECT version FROM schema_migrations\e[0m
-Migrating to AddTestData (20090202163608)
-  \e[4;36;1mProduct Delete all (2.2ms)\e[0m   \e[0;1mDELETE FROM `products` \e[0m
-  \e[4;35;1mSQL (0.7ms)\e[0m   \e[0mDELETE FROM schema_migrations WHERE version = '20090202163608'\e[0m
-Migrating to AddDateAvailableToProduct (20090202160925)
-  \e[4;36;1mSQL (7.5ms)\e[0m   \e[0;1mALTER TABLE `products` DROP `date_available`\e[0m
-  \e[4;35;1mSQL (0.9ms)\e[0m   \e[0mDELETE FROM schema_migrations WHERE version = '20090202160925'\e[0m
-Migrating to AddPriceToProduct (20090202160745)
-  \e[4;36;1mSQL (23.4ms)\e[0m   \e[0;1mALTER TABLE `products` DROP `price`\e[0m
-  \e[4;35;1mSQL (0.7ms)\e[0m   \e[0mDELETE FROM schema_migrations WHERE version = '20090202160745'\e[0m
-Migrating to CreateProducts (20090202160210)
-  \e[4;36;1mSQL (2.9ms)\e[0m   \e[0;1mDROP TABLE `products`\e[0m
-  \e[4;35;1mSQL (0.7ms)\e[0m   \e[0mDELETE FROM schema_migrations WHERE version = '20090202160210'\e[0m
-  \e[4;36;1mSQL (0.8ms)\e[0m   \e[0;1mSHOW TABLES\e[0m
-  \e[4;35;1mSQL (0.5ms)\e[0m   \e[0mSELECT version FROM schema_migrations\e[0m
-  \e[4;36;1mSQL (0.4ms)\e[0m   \e[0;1mSHOW TABLES\e[0m
-  \e[4;36;1mSQL (0.2ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mSQL (0.5ms)\e[0m   \e[0;1mSHOW TABLES\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSELECT version FROM schema_migrations\e[0m
-Migrating to CreateProducts (20090202160210)
-  \e[4;36;1mSQL (37.0ms)\e[0m   \e[0;1mCREATE TABLE `products` (`id` int(11) DEFAULT NULL auto_increment PRIMARY KEY, `title` varchar(255), `description` text, `image_url` varchar(255), `created_at` datetime, `updated_at` datetime) ENGINE=InnoDB\e[0m
-  \e[4;35;1mSQL (1.3ms)\e[0m   \e[0mINSERT INTO schema_migrations (version) VALUES ('20090202160210')\e[0m
-Migrating to AddPriceToProduct (20090202160745)
-  \e[4;36;1mSQL (17.0ms)\e[0m   \e[0;1mALTER TABLE `products` ADD `price` decimal(8,2) DEFAULT 0\e[0m
-  \e[4;35;1mSQL (1.9ms)\e[0m   \e[0mINSERT INTO schema_migrations (version) VALUES ('20090202160745')\e[0m
-Migrating to AddDateAvailableToProduct (20090202160925)
-  \e[4;36;1mSQL (6.5ms)\e[0m   \e[0;1mALTER TABLE `products` ADD `date_available` date\e[0m
-  \e[4;35;1mSQL (0.6ms)\e[0m   \e[0mINSERT INTO schema_migrations (version) VALUES ('20090202160925')\e[0m
-Migrating to AddTestData (20090202163608)
-  \e[4;36;1mProduct Delete all (0.3ms)\e[0m   \e[0;1mDELETE FROM `products` \e[0m
-  \e[4;35;1mProduct Columns (1.1ms)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mBEGIN\e[0m
-  \e[4;35;1mProduct Exists (0.3ms)\e[0m   \e[0mSELECT `products`.id FROM `products` WHERE (`products`.`title` = BINARY 'Snowball') LIMIT 1\e[0m
-  \e[4;36;1mProduct Create (0.4ms)\e[0m   \e[0;1mINSERT INTO `products` (`image_url`, `updated_at`, `title`, `price`, `date_available`, `description`, `created_at`) VALUES('/images/snowball.jpg', '2009-02-02 22:17:43', 'Snowball', 12.0, '2008-12-31 00:00:00', '<p>The perfect gift for a hot summer\'s day. What could be better \n than to surprise a loved one a gift of winter coolness? This\n snowball has been loving crafted from the purest snow, hand-collected\n from the pristine lawn of our back garden. \n </p>\n <p>Note that this is a perishable item and some melting may occur \n while the snowball is in transit. \n </p>\n ', '2009-02-02 22:17:43')\e[0m
-  \e[4;35;1mSQL (0.5ms)\e[0m   \e[0mCOMMIT\e[0m
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mBEGIN\e[0m
-  \e[4;35;1mProduct Exists (0.5ms)\e[0m   \e[0mSELECT `products`.id FROM `products` WHERE (`products`.`title` = BINARY 'Daisy') LIMIT 1\e[0m
-  \e[4;36;1mProduct Create (0.4ms)\e[0m   \e[0;1mINSERT INTO `products` (`image_url`, `updated_at`, `title`, `price`, `date_available`, `description`, `created_at`) VALUES('/images/daisy.gif', '2009-02-02 22:17:43', 'Daisy', 5.0, '2011-07-01 00:00:00', '<p>All the world is better for having flowers in it. And your home \n will be the better for having this fine example of <i>Bellis \n perennis</i> gracing its walls. The range of uses of this item are\n truly remarkable. You can place it in an eggcup of water, you can \n insert it in a jacket for a subtle buttonhole posy, or you even \n purchase a multi-pack to create your own daisy chain!\n </p>\n ', '2009-02-02 22:17:43')\e[0m
-  \e[4;35;1mSQL (0.5ms)\e[0m   \e[0mCOMMIT\e[0m
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mBEGIN\e[0m
-  \e[4;35;1mProduct Exists (0.4ms)\e[0m   \e[0mSELECT `products`.id FROM `products` WHERE (`products`.`title` = BINARY 'Cardboard Box') LIMIT 1\e[0m
-  \e[4;36;1mProduct Create (0.5ms)\e[0m   \e[0;1mINSERT INTO `products` (`image_url`, `updated_at`, `title`, `price`, `date_available`, `description`, `created_at`) VALUES('/images/cardboard-box.jpg', '2009-02-02 22:17:43', 'Cardboard Box', 10.0, '2007-01-01 00:00:00', '<p>The gift that keeps on giving, you\'ll wonder how you ever did \n without a cardboard box in your home. Us it for a range of uses, \n including putting things in and keeping things in. We can provide\n you with a cardboard box that is versatile and suitable for any\n occasion. Some of our directors even use them for sleeping in!\n </p>\n ', '2009-02-02 22:17:43')\e[0m
-  \e[4;35;1mSQL (1.3ms)\e[0m   \e[0mCOMMIT\e[0m
-  \e[4;36;1mSQL (0.2ms)\e[0m   \e[0;1mBEGIN\e[0m
-  \e[4;35;1mProduct Exists (0.7ms)\e[0m   \e[0mSELECT `products`.id FROM `products` WHERE (`products`.`title` = BINARY 'Air') LIMIT 1\e[0m
-  \e[4;36;1mProduct Create (0.7ms)\e[0m   \e[0;1mINSERT INTO `products` (`image_url`, `updated_at`, `title`, `price`, `date_available`, `description`, `created_at`) VALUES('/images/can-of-air.jpg', '2009-02-02 22:17:43', 'Air', 5000.0, '2009-01-01 00:00:00', '<p>An essential for all activities, <i>Air</i> is vital for your\n wellbeing and vitality. Our air is carefully packaged to contain\n only 100% pure air, with no artificial colours or preservatives.\n </p>\n <p>May contain nuts.\n </p>\n ', '2009-02-02 22:17:43')\e[0m
-  \e[4;35;1mSQL (9.4ms)\e[0m   \e[0mCOMMIT\e[0m
-  \e[4;36;1mSQL (0.6ms)\e[0m   \e[0;1mINSERT INTO schema_migrations (version) VALUES ('20090202163608')\e[0m
-  \e[4;35;1mSQL (0.4ms)\e[0m   \e[0mSHOW TABLES\e[0m
-  \e[4;36;1mSQL (0.3ms)\e[0m   \e[0;1mSELECT version FROM schema_migrations\e[0m
-  \e[4;35;1mSQL (0.3ms)\e[0m   \e[0mSHOW TABLES\e[0m
-  \e[4;36;1mSQL (1.0ms)\e[0m   \e[0;1mSHOW FIELDS FROM `products`\e[0m
-  \e[4;35;1mSQL (1.1ms)\e[0m   \e[0mdescribe `products`\e[0m
-  \e[4;36;1mSQL (0.4ms)\e[0m   \e[0;1mSHOW KEYS FROM `products`\e[0m
-
-
-Processing ProductsController#edit (for 127.0.0.1 at 2009-02-02 22:17:48) [GET]
-  Parameters: {"id"=>"1"}
-  \e[4;35;1mSQL (0.2ms)\e[0m   \e[0mSET NAMES 'utf8'\e[0m
-  \e[4;36;1mSQL (0.2ms)\e[0m   \e[0;1mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;35;1mProduct Columns (1.6ms)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
-  \e[4;36;1mProduct Load (0.4ms)\e[0m   \e[0;1mSELECT * FROM `products` WHERE (`products`.`id` = 1) \e[0m
-Rendering template within layouts/products
-Rendering products/edit
-Completed in 44ms (View: 27, DB: 2) | 200 OK [http://localhost/products/1/edit]
-
-
-Processing ProductsController#edit (for 127.0.0.1 at 2009-02-02 22:17:52) [GET]
-  Parameters: {"id"=>"2"}
-  \e[4;35;1mSQL (0.2ms)\e[0m   \e[0mSET NAMES 'utf8'\e[0m
-  \e[4;36;1mSQL (0.2ms)\e[0m   \e[0;1mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;35;1mProduct Columns (2.6ms)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
-  \e[4;36;1mProduct Load (0.8ms)\e[0m   \e[0;1mSELECT * FROM `products` WHERE (`products`.`id` = 2) \e[0m
-Rendering template within layouts/products
-Rendering products/edit
-Completed in 62ms (View: 37, DB: 4) | 200 OK [http://localhost/products/2/edit]
-
-
-Processing ProductsController#edit (for 127.0.0.1 at 2009-02-02 22:17:56) [GET]
-  Parameters: {"id"=>"3"}
-  \e[4;35;1mSQL (0.2ms)\e[0m   \e[0mSET NAMES 'utf8'\e[0m
-  \e[4;36;1mSQL (0.2ms)\e[0m   \e[0;1mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;35;1mProduct Columns (1.6ms)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
-  \e[4;36;1mProduct Load (0.5ms)\e[0m   \e[0;1mSELECT * FROM `products` WHERE (`products`.`id` = 3) \e[0m
-Rendering template within layouts/products
-Rendering products/edit
-Completed in 77ms (View: 50, DB: 3) | 200 OK [http://localhost/products/3/edit]
-
-
-Processing ProductsController#edit (for 127.0.0.1 at 2009-02-02 22:18:00) [GET]
-  Parameters: {"id"=>"4"}
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSET NAMES 'utf8'\e[0m
-  \e[4;36;1mSQL (0.2ms)\e[0m   \e[0;1mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;35;1mProduct Columns (1.9ms)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
-  \e[4;36;1mProduct Load (0.6ms)\e[0m   \e[0;1mSELECT * FROM `products` WHERE (`products`.`id` = 4) \e[0m
-Rendering template within layouts/products
-Rendering products/edit
-Completed in 58ms (View: 37, DB: 3) | 200 OK [http://localhost/products/4/edit]
-
-
-Processing ProductsController#index (for 127.0.0.1 at 2009-02-03 08:54:41) [GET]
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSET NAMES 'utf8'\e[0m
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;35;1mProduct Load (18.9ms)\e[0m   \e[0mSELECT * FROM `products` \e[0m
-Rendering template within layouts/products
-Rendering products/index
-  \e[4;36;1mProduct Columns (28.5ms)\e[0m   \e[0;1mSHOW FIELDS FROM `products`\e[0m
-Completed in 190ms (View: 126, DB: 48) | 200 OK [http://localhost/products]
-  \e[4;36;1mSQL (0.2ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mSQL (0.4ms)\e[0m   \e[0;1mSHOW TABLES\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSELECT version FROM schema_migrations\e[0m
-  \e[4;36;1mSQL (0.3ms)\e[0m   \e[0;1mSHOW TABLES\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSELECT version FROM schema_migrations\e[0m
-Migrating to AddTestData (20090202163608)
-  \e[4;36;1mProduct Delete all (54.6ms)\e[0m   \e[0;1mDELETE FROM `products` \e[0m
-  \e[4;35;1mSQL (0.7ms)\e[0m   \e[0mDELETE FROM schema_migrations WHERE version = '20090202163608'\e[0m
-Migrating to AddDateAvailableToProduct (20090202160925)
-  \e[4;36;1mSQL (82.6ms)\e[0m   \e[0;1mALTER TABLE `products` DROP `date_available`\e[0m
-  \e[4;35;1mSQL (0.9ms)\e[0m   \e[0mDELETE FROM schema_migrations WHERE version = '20090202160925'\e[0m
-Migrating to AddPriceToProduct (20090202160745)
-  \e[4;36;1mSQL (23.1ms)\e[0m   \e[0;1mALTER TABLE `products` DROP `price`\e[0m
-  \e[4;35;1mSQL (0.7ms)\e[0m   \e[0mDELETE FROM schema_migrations WHERE version = '20090202160745'\e[0m
-Migrating to CreateProducts (20090202160210)
-  \e[4;36;1mSQL (1.6ms)\e[0m   \e[0;1mDROP TABLE `products`\e[0m
-  \e[4;35;1mSQL (0.7ms)\e[0m   \e[0mDELETE FROM schema_migrations WHERE version = '20090202160210'\e[0m
-  \e[4;36;1mSQL (0.4ms)\e[0m   \e[0;1mSHOW TABLES\e[0m
-  \e[4;35;1mSQL (0.3ms)\e[0m   \e[0mSELECT version FROM schema_migrations\e[0m
-  \e[4;36;1mSQL (0.5ms)\e[0m   \e[0;1mSHOW TABLES\e[0m
-  \e[4;36;1mSQL (0.2ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mSQL (0.4ms)\e[0m   \e[0;1mSHOW TABLES\e[0m
-  \e[4;35;1mSQL (0.2ms)\e[0m   \e[0mSELECT version FROM schema_migrations\e[0m
-Migrating to CreateProducts (20090202160210)
-  \e[4;36;1mSQL (40.6ms)\e[0m   \e[0;1mCREATE TABLE `products` (`id` int(11) DEFAULT NULL auto_increment PRIMARY KEY, `title` varchar(255), `description` text, `image_url` varchar(255), `created_at` datetime, `updated_at` datetime) ENGINE=InnoDB\e[0m
-  \e[4;35;1mSQL (10.8ms)\e[0m   \e[0mINSERT INTO schema_migrations (version) VALUES ('20090202160210')\e[0m
-Migrating to AddPriceToProduct (20090202160745)
-  \e[4;36;1mSQL (11.9ms)\e[0m   \e[0;1mALTER TABLE `products` ADD `price` decimal(8,2) DEFAULT 0\e[0m
-  \e[4;35;1mSQL (0.7ms)\e[0m   \e[0mINSERT INTO schema_migrations (version) VALUES ('20090202160745')\e[0m
-Migrating to AddDateAvailableToProduct (20090202160925)
-  \e[4;36;1mSQL (34.6ms)\e[0m   \e[0;1mALTER TABLE `products` ADD `date_available` date\e[0m
-  \e[4;35;1mSQL (3.8ms)\e[0m   \e[0mINSERT INTO schema_migrations (version) VALUES ('20090202160925')\e[0m
-Migrating to AddTestData (20090202163608)
-  \e[4;36;1mProduct Delete all (0.4ms)\e[0m   \e[0;1mDELETE FROM `products` \e[0m
-  \e[4;35;1mProduct Columns (1.1ms)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mBEGIN\e[0m
-  \e[4;35;1mProduct Exists (0.3ms)\e[0m   \e[0mSELECT `products`.id FROM `products` WHERE (`products`.`title` = BINARY 'Snowball') LIMIT 1\e[0m
-  \e[4;36;1mProduct Create (0.4ms)\e[0m   \e[0;1mINSERT INTO `products` (`image_url`, `updated_at`, `title`, `price`, `date_available`, `description`, `created_at`) VALUES('/images/snowball.jpg', '2009-02-03 08:55:34', 'Snowball', 11.99, '2008-12-31 00:00:00', '<p>The perfect gift for a hot summer\'s day. What could be better \n than to surprise a loved one a gift of winter coolness? This\n snowball has been loving crafted from the purest snow, hand-collected\n from the pristine lawn of our back garden. \n </p>\n <p>Note that this is a perishable item and some melting may occur \n while the snowball is in transit. \n </p>\n ', '2009-02-03 08:55:34')\e[0m
-  \e[4;35;1mSQL (0.7ms)\e[0m   \e[0mCOMMIT\e[0m
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mBEGIN\e[0m
-  \e[4;35;1mProduct Exists (0.5ms)\e[0m   \e[0mSELECT `products`.id FROM `products` WHERE (`products`.`title` = BINARY 'Daisy') LIMIT 1\e[0m
-  \e[4;36;1mProduct Create (0.4ms)\e[0m   \e[0;1mINSERT INTO `products` (`image_url`, `updated_at`, `title`, `price`, `date_available`, `description`, `created_at`) VALUES('/images/daisy.gif', '2009-02-03 08:55:34', 'Daisy', 5.0, '2011-07-01 00:00:00', '<p>All the world is better for having flowers in it. And your home \n will be the better for having this fine example of <i>Bellis \n perennis</i> gracing its walls. The range of uses of this item are\n truly remarkable. You can place it in an eggcup of water, you can \n insert it in a jacket for a subtle buttonhole posy, or you even \n purchase a multi-pack to create your own daisy chain!\n </p>\n ', '2009-02-03 08:55:34')\e[0m
-  \e[4;35;1mSQL (1.5ms)\e[0m   \e[0mCOMMIT\e[0m
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mBEGIN\e[0m
-  \e[4;35;1mProduct Exists (0.3ms)\e[0m   \e[0mSELECT `products`.id FROM `products` WHERE (`products`.`title` = BINARY 'Cardboard Box') LIMIT 1\e[0m
-  \e[4;36;1mProduct Create (0.4ms)\e[0m   \e[0;1mINSERT INTO `products` (`image_url`, `updated_at`, `title`, `price`, `date_available`, `description`, `created_at`) VALUES('/images/cardboard-box.jpg', '2009-02-03 08:55:34', 'Cardboard Box', 10.0, '2007-01-01 00:00:00', '<p>The gift that keeps on giving, you\'ll wonder how you ever did \n without a cardboard box in your home. Us it for a range of uses, \n including putting things in and keeping things in. We can provide\n you with a cardboard box that is versatile and suitable for any\n occasion. Some of our directors even use them for sleeping in!\n </p>\n ', '2009-02-03 08:55:34')\e[0m
-  \e[4;35;1mSQL (0.5ms)\e[0m   \e[0mCOMMIT\e[0m
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mBEGIN\e[0m
-  \e[4;35;1mProduct Exists (0.4ms)\e[0m   \e[0mSELECT `products`.id FROM `products` WHERE (`products`.`title` = BINARY 'Air') LIMIT 1\e[0m
-  \e[4;36;1mProduct Create (0.5ms)\e[0m   \e[0;1mINSERT INTO `products` (`image_url`, `updated_at`, `title`, `price`, `date_available`, `description`, `created_at`) VALUES('/images/can-of-air.jpg', '2009-02-03 08:55:34', 'Air', 5000.0, '2009-01-01 00:00:00', '<p>An essential for all activities, <i>Air</i> is vital for your\n wellbeing and vitality. Our air is carefully packaged to contain\n only 100% pure air, with no artificial colours or preservatives.\n </p>\n <p>May contain nuts.\n </p>\n ', '2009-02-03 08:55:34')\e[0m
-  \e[4;35;1mSQL (3.5ms)\e[0m   \e[0mCOMMIT\e[0m
-  \e[4;36;1mSQL (0.9ms)\e[0m   \e[0;1mINSERT INTO schema_migrations (version) VALUES ('20090202163608')\e[0m
-  \e[4;35;1mSQL (0.4ms)\e[0m   \e[0mSHOW TABLES\e[0m
-  \e[4;36;1mSQL (0.4ms)\e[0m   \e[0;1mSELECT version FROM schema_migrations\e[0m
-  \e[4;35;1mSQL (0.4ms)\e[0m   \e[0mSHOW TABLES\e[0m
-  \e[4;36;1mSQL (1.1ms)\e[0m   \e[0;1mSHOW FIELDS FROM `products`\e[0m
-  \e[4;35;1mSQL (1.1ms)\e[0m   \e[0mdescribe `products`\e[0m
-  \e[4;36;1mSQL (0.5ms)\e[0m   \e[0;1mSHOW KEYS FROM `products`\e[0m
-
-
-Processing ProductsController#index (for 127.0.0.1 at 2009-02-03 08:55:37) [GET]
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSET NAMES 'utf8'\e[0m
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;35;1mProduct Load (0.5ms)\e[0m   \e[0mSELECT * FROM `products` \e[0m
-Rendering template within layouts/products
-Rendering products/index
-  \e[4;36;1mProduct Columns (1.2ms)\e[0m   \e[0;1mSHOW FIELDS FROM `products`\e[0m
-Completed in 58ms (View: 42, DB: 2) | 200 OK [http://localhost/products]
-  \e[4;36;1mSQL (0.2ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.3ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mSQL (0.4ms)\e[0m   \e[0;1mSHOW TABLES\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSELECT version FROM schema_migrations\e[0m
-  \e[4;36;1mSQL (0.3ms)\e[0m   \e[0;1mSHOW TABLES\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSELECT version FROM schema_migrations\e[0m
-Migrating to AddTestData (20090202163608)
-  \e[4;36;1mProduct Delete all (27.5ms)\e[0m   \e[0;1mDELETE FROM `products` \e[0m
-  \e[4;35;1mSQL (29.7ms)\e[0m   \e[0mDELETE FROM schema_migrations WHERE version = '20090202163608'\e[0m
-Migrating to AddDateAvailableToProduct (20090202160925)
-  \e[4;36;1mSQL (20.7ms)\e[0m   \e[0;1mALTER TABLE `products` DROP `date_available`\e[0m
-  \e[4;35;1mSQL (10.0ms)\e[0m   \e[0mDELETE FROM schema_migrations WHERE version = '20090202160925'\e[0m
-Migrating to AddPriceToProduct (20090202160745)
-  \e[4;36;1mSQL (6.5ms)\e[0m   \e[0;1mALTER TABLE `products` DROP `price`\e[0m
-  \e[4;35;1mSQL (5.6ms)\e[0m   \e[0mDELETE FROM schema_migrations WHERE version = '20090202160745'\e[0m
-Migrating to CreateProducts (20090202160210)
-  \e[4;36;1mSQL (1.4ms)\e[0m   \e[0;1mDROP TABLE `products`\e[0m
-  \e[4;35;1mSQL (0.8ms)\e[0m   \e[0mDELETE FROM schema_migrations WHERE version = '20090202160210'\e[0m
-  \e[4;36;1mSQL (0.3ms)\e[0m   \e[0;1mSHOW TABLES\e[0m
-  \e[4;35;1mSQL (0.3ms)\e[0m   \e[0mSELECT version FROM schema_migrations\e[0m
-  \e[4;36;1mSQL (0.3ms)\e[0m   \e[0;1mSHOW TABLES\e[0m
-  \e[4;36;1mSQL (0.2ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mSQL (0.4ms)\e[0m   \e[0;1mSHOW TABLES\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSELECT version FROM schema_migrations\e[0m
-Migrating to CreateProducts (20090202160210)
-  \e[4;36;1mSQL (43.0ms)\e[0m   \e[0;1mCREATE TABLE `products` (`id` int(11) DEFAULT NULL auto_increment PRIMARY KEY, `title` varchar(255), `description` text, `image_url` varchar(255), `created_at` datetime, `updated_at` datetime) ENGINE=InnoDB\e[0m
-  \e[4;35;1mSQL (13.7ms)\e[0m   \e[0mINSERT INTO schema_migrations (version) VALUES ('20090202160210')\e[0m
-Migrating to AddPriceToProduct (20090202160745)
-  \e[4;36;1mSQL (8.1ms)\e[0m   \e[0;1mALTER TABLE `products` ADD `price` decimal(8,2) DEFAULT 0\e[0m
-  \e[4;35;1mSQL (2.7ms)\e[0m   \e[0mINSERT INTO schema_migrations (version) VALUES ('20090202160745')\e[0m
-Migrating to AddDateAvailableToProduct (20090202160925)
-  \e[4;36;1mSQL (41.8ms)\e[0m   \e[0;1mALTER TABLE `products` ADD `date_available` date\e[0m
-  \e[4;35;1mSQL (1.3ms)\e[0m   \e[0mINSERT INTO schema_migrations (version) VALUES ('20090202160925')\e[0m
-Migrating to AddTestData (20090202163608)
-  \e[4;36;1mProduct Delete all (0.4ms)\e[0m   \e[0;1mDELETE FROM `products` \e[0m
-  \e[4;35;1mProduct Columns (1.1ms)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
-  \e[4;36;1mSQL (0.2ms)\e[0m   \e[0;1mBEGIN\e[0m
-  \e[4;35;1mProduct Exists (0.3ms)\e[0m   \e[0mSELECT `products`.id FROM `products` WHERE (`products`.`title` = BINARY 'Snowball') LIMIT 1\e[0m
-  \e[4;36;1mProduct Create (0.4ms)\e[0m   \e[0;1mINSERT INTO `products` (`image_url`, `updated_at`, `title`, `price`, `date_available`, `description`, `created_at`) VALUES('/images/snowball.jpg', '2009-02-03 08:56:57', 'Snowball', 11.99, '2008-12-31 00:00:00', '<p>The perfect gift for a hot summer\'s day. What could be better \n than to surprise a loved one a gift of winter coolness? This\n snowball has been loving crafted from the purest snow, hand-collected\n from the pristine lawn of our back garden. \n </p>\n <p>Note that this is a perishable item and some melting may occur \n while the snowball is in transit. \n </p>\n ', '2009-02-03 08:56:57')\e[0m
-  \e[4;35;1mSQL (0.7ms)\e[0m   \e[0mCOMMIT\e[0m
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mBEGIN\e[0m
-  \e[4;35;1mProduct Exists (0.4ms)\e[0m   \e[0mSELECT `products`.id FROM `products` WHERE (`products`.`title` = BINARY 'Daisy') LIMIT 1\e[0m
-  \e[4;36;1mProduct Create (0.4ms)\e[0m   \e[0;1mINSERT INTO `products` (`image_url`, `updated_at`, `title`, `price`, `date_available`, `description`, `created_at`) VALUES('/images/daisy.gif', '2009-02-03 08:56:57', 'Daisy', 5.0, '2011-07-01 00:00:00', '<p>All the world is better for having flowers in it. And your home \n will be the better for having this fine example of <i>Bellis \n perennis</i> gracing its walls. The range of uses of this item are\n truly remarkable. You can place it in an eggcup of water, you can \n insert it in a jacket for a subtle buttonhole posy, or you even \n purchase a multi-pack to create your own daisy chain!\n </p>\n ', '2009-02-03 08:56:57')\e[0m
-  \e[4;35;1mSQL (0.9ms)\e[0m   \e[0mCOMMIT\e[0m
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mBEGIN\e[0m
-  \e[4;35;1mProduct Exists (0.5ms)\e[0m   \e[0mSELECT `products`.id FROM `products` WHERE (`products`.`title` = BINARY 'Cardboard Box') LIMIT 1\e[0m
-  \e[4;36;1mProduct Create (0.6ms)\e[0m   \e[0;1mINSERT INTO `products` (`image_url`, `updated_at`, `title`, `price`, `date_available`, `description`, `created_at`) VALUES('/images/cardboard-box.jpg', '2009-02-03 08:56:57', 'Cardboard Box', 10.0, '2007-01-01 00:00:00', '<p>The gift that keeps on giving, you\'ll wonder how you ever did \n without a cardboard box in your home. Us it for a range of uses, \n including putting things in and keeping things in. We can provide\n you with a cardboard box that is versatile and suitable for any\n occasion. Some of our directors even use them for sleeping in!\n </p>\n ', '2009-02-03 08:56:57')\e[0m
-  \e[4;35;1mSQL (7.1ms)\e[0m   \e[0mCOMMIT\e[0m
-  \e[4;36;1mSQL (2.4ms)\e[0m   \e[0;1mBEGIN\e[0m
-  \e[4;35;1mProduct Exists (4.7ms)\e[0m   \e[0mSELECT `products`.id FROM `products` WHERE (`products`.`title` = BINARY 'Air in a Can') LIMIT 1\e[0m
-  \e[4;36;1mProduct Create (0.4ms)\e[0m   \e[0;1mINSERT INTO `products` (`image_url`, `updated_at`, `title`, `price`, `date_available`, `description`, `created_at`) VALUES('/images/can-of-air.jpg', '2009-02-03 08:56:57', 'Air in a Can', 5000.0, '2009-01-01 00:00:00', '<p>An essential for all activities, <i>Air</i> is vital for your\n wellbeing and vitality. Our air is carefully packaged to contain\n only 100% pure air, with no artificial colours or preservatives.\n </p>\n <p>May contain nuts.\n </p>\n ', '2009-02-03 08:56:57')\e[0m
-  \e[4;35;1mSQL (0.9ms)\e[0m   \e[0mCOMMIT\e[0m
-  \e[4;36;1mSQL (0.8ms)\e[0m   \e[0;1mINSERT INTO schema_migrations (version) VALUES ('20090202163608')\e[0m
-  \e[4;35;1mSQL (0.4ms)\e[0m   \e[0mSHOW TABLES\e[0m
-  \e[4;36;1mSQL (0.3ms)\e[0m   \e[0;1mSELECT version FROM schema_migrations\e[0m
-  \e[4;35;1mSQL (0.3ms)\e[0m   \e[0mSHOW TABLES\e[0m
-  \e[4;36;1mSQL (1.1ms)\e[0m   \e[0;1mSHOW FIELDS FROM `products`\e[0m
-  \e[4;35;1mSQL (1.1ms)\e[0m   \e[0mdescribe `products`\e[0m
-  \e[4;36;1mSQL (0.5ms)\e[0m   \e[0;1mSHOW KEYS FROM `products`\e[0m
-
-
-Processing ProductsController#index (for 127.0.0.1 at 2009-02-03 08:57:00) [GET]
-  \e[4;35;1mSQL (0.2ms)\e[0m   \e[0mSET NAMES 'utf8'\e[0m
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;35;1mProduct Load (0.5ms)\e[0m   \e[0mSELECT * FROM `products` \e[0m
-Rendering template within layouts/products
-Rendering products/index
-  \e[4;36;1mProduct Columns (1.1ms)\e[0m   \e[0;1mSHOW FIELDS FROM `products`\e[0m
-Completed in 53ms (View: 40, DB: 2) | 200 OK [http://localhost/products]
-
-
-Processing ProductsController#index (for 127.0.0.1 at 2009-02-03 10:08:16) [GET]
-  \e[4;35;1mSQL (0.2ms)\e[0m   \e[0mSET NAMES 'utf8'\e[0m
-  \e[4;36;1mSQL (0.3ms)\e[0m   \e[0;1mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;35;1mProduct Load (0.3ms)\e[0m   \e[0mSELECT * FROM `products` \e[0m
-Rendering template within layouts/products
-Rendering products/index
-  \e[4;36;1mProduct Columns (2.4ms)\e[0m   \e[0;1mSHOW FIELDS FROM `products`\e[0m
-Completed in 118ms (View: 80, DB: 3) | 200 OK [http://localhost/products]
-
-
-Processing ApplicationController#index (for 127.0.0.1 at 2009-02-03 10:08:16) [GET]
-
-
-ActionController::RoutingError (No route matches "/store" with {:method=>:get}):
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/routing/recognition_optimisation.rb:66:in `recognize_path'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/routing/route_set.rb:386:in `recognize'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:182:in `handle_request'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:110:in `dispatch_unlocked'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:123:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:122:in `synchronize'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:122:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:132:in `dispatch_cgi'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:39:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:103:in `handle_dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:74:in `service'
-    /usr/lib/ruby/1.8/webrick/httpserver.rb:104:in `service'
-    /usr/lib/ruby/1.8/webrick/httpserver.rb:65:in `run'
-    /usr/lib/ruby/1.8/webrick/server.rb:173:in `start_thread'
-    /usr/lib/ruby/1.8/webrick/server.rb:162:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:162:in `start_thread'
-    /usr/lib/ruby/1.8/webrick/server.rb:95:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:92:in `each'
-    /usr/lib/ruby/1.8/webrick/server.rb:92:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:23:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:82:in `start'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:60:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/commands/servers/webrick.rb:66
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `gem_original_require'
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `require'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:153:in `require'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:521:in `new_constants_in'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:153:in `require'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/commands/server.rb:49
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `gem_original_require'
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `require'
-    script/server:3
-
-Rendering /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/templates/rescues/layout.erb (not_found)
-
-
-Processing ApplicationController#index (for 127.0.0.1 at 2009-02-04 13:58:28) [GET]
-
-
-ActionController::RoutingError (No route matches "/store" with {:method=>:get}):
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/routing/recognition_optimisation.rb:66:in `recognize_path'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/routing/route_set.rb:386:in `recognize'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:182:in `handle_request'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:110:in `dispatch_unlocked'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:123:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:122:in `synchronize'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:122:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:132:in `dispatch_cgi'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:39:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:103:in `handle_dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:74:in `service'
-    /usr/lib/ruby/1.8/webrick/httpserver.rb:104:in `service'
-    /usr/lib/ruby/1.8/webrick/httpserver.rb:65:in `run'
-    /usr/lib/ruby/1.8/webrick/server.rb:173:in `start_thread'
-    /usr/lib/ruby/1.8/webrick/server.rb:162:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:162:in `start_thread'
-    /usr/lib/ruby/1.8/webrick/server.rb:95:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:92:in `each'
-    /usr/lib/ruby/1.8/webrick/server.rb:92:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:23:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:82:in `start'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:60:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/commands/servers/webrick.rb:66
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `gem_original_require'
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `require'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:153:in `require'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:521:in `new_constants_in'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:153:in `require'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/commands/server.rb:49
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `gem_original_require'
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `require'
-    script/server:3
-
-Rendering /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/templates/rescues/layout.erb (not_found)
-
-
-Processing ProductsController#index (for 127.0.0.1 at 2009-02-04 13:59:23) [GET]
-  \e[4;35;1mSQL (0.2ms)\e[0m   \e[0mSET NAMES 'utf8'\e[0m
-  \e[4;36;1mSQL (0.2ms)\e[0m   \e[0;1mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;35;1mProduct Load (0.3ms)\e[0m   \e[0mSELECT * FROM `products` \e[0m
-Rendering template within layouts/products
-Rendering products/index
-  \e[4;36;1mProduct Columns (4.4ms)\e[0m   \e[0;1mSHOW FIELDS FROM `products`\e[0m
-Completed in 189ms (View: 154, DB: 5) | 200 OK [http://localhost/products]
-
-
-Processing ProductsController#show (for 127.0.0.1 at 2009-02-04 13:59:27) [GET]
-  Parameters: {"id"=>"1"}
-  \e[4;35;1mSQL (0.2ms)\e[0m   \e[0mSET NAMES 'utf8'\e[0m
-  \e[4;36;1mSQL (0.2ms)\e[0m   \e[0;1mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;35;1mProduct Columns (1.5ms)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
-  \e[4;36;1mProduct Load (0.5ms)\e[0m   \e[0;1mSELECT * FROM `products` WHERE (`products`.`id` = 1) \e[0m
-Rendering template within layouts/products
-Rendering products/show
-Completed in 49ms (View: 30, DB: 2) | 200 OK [http://localhost/products/1]
-
-
-Processing ProductsController#index (for 127.0.0.1 at 2009-02-04 13:59:29) [GET]
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSET NAMES 'utf8'\e[0m
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;35;1mProduct Load (0.3ms)\e[0m   \e[0mSELECT * FROM `products` \e[0m
-Rendering template within layouts/products
-Rendering products/index
-  \e[4;36;1mProduct Columns (2.0ms)\e[0m   \e[0;1mSHOW FIELDS FROM `products`\e[0m
-Completed in 70ms (View: 49, DB: 2) | 200 OK [http://localhost/products]
-
-
-Processing ApplicationController#index (for 127.0.0.1 at 2009-02-04 13:59:32) [GET]
-
-
-ActionController::RoutingError (No route matches "/store" with {:method=>:get}):
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/routing/recognition_optimisation.rb:66:in `recognize_path'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/routing/route_set.rb:386:in `recognize'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:182:in `handle_request'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:110:in `dispatch_unlocked'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:123:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:122:in `synchronize'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:122:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:132:in `dispatch_cgi'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:39:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:103:in `handle_dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:74:in `service'
-    /usr/lib/ruby/1.8/webrick/httpserver.rb:104:in `service'
-    /usr/lib/ruby/1.8/webrick/httpserver.rb:65:in `run'
-    /usr/lib/ruby/1.8/webrick/server.rb:173:in `start_thread'
-    /usr/lib/ruby/1.8/webrick/server.rb:162:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:162:in `start_thread'
-    /usr/lib/ruby/1.8/webrick/server.rb:95:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:92:in `each'
-    /usr/lib/ruby/1.8/webrick/server.rb:92:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:23:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:82:in `start'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:60:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/commands/servers/webrick.rb:66
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `gem_original_require'
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `require'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:153:in `require'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:521:in `new_constants_in'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:153:in `require'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/commands/server.rb:49
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `gem_original_require'
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `require'
-    script/server:3
-
-Rendering /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/templates/rescues/layout.erb (not_found)
-
-
-Processing ApplicationController#index (for 127.0.0.1 at 2009-02-04 13:59:36) [GET]
-
-
-ActionController::RoutingError (No route matches "/store" with {:method=>:get}):
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/routing/recognition_optimisation.rb:66:in `recognize_path'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/routing/route_set.rb:386:in `recognize'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:182:in `handle_request'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:110:in `dispatch_unlocked'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:123:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:122:in `synchronize'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:122:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:132:in `dispatch_cgi'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:39:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:103:in `handle_dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:74:in `service'
-    /usr/lib/ruby/1.8/webrick/httpserver.rb:104:in `service'
-    /usr/lib/ruby/1.8/webrick/httpserver.rb:65:in `run'
-    /usr/lib/ruby/1.8/webrick/server.rb:173:in `start_thread'
-    /usr/lib/ruby/1.8/webrick/server.rb:162:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:162:in `start_thread'
-    /usr/lib/ruby/1.8/webrick/server.rb:95:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:92:in `each'
-    /usr/lib/ruby/1.8/webrick/server.rb:92:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:23:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:82:in `start'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:60:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/commands/servers/webrick.rb:66
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `gem_original_require'
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `require'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:153:in `require'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:521:in `new_constants_in'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:153:in `require'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/commands/server.rb:49
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `gem_original_require'
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `require'
-    script/server:3
-
-Rendering /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/templates/rescues/layout.erb (not_found)
-
-
-Processing StoreController#index (for 127.0.0.1 at 2009-02-04 14:01:27) [GET]
-  \e[4;36;1mSQL (0.2ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.2ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-Rendering store/index
-Completed in 7ms (View: 3, DB: 0) | 200 OK [http://localhost/store]
-
-
-Processing StoreController#index (for 127.0.0.1 at 2009-02-04 14:12:04) [GET]
-  \e[4;36;1mSQL (1.8ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.2ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mSQL (14.7ms)\e[0m   \e[0;1mSHOW TABLES\e[0m
-  \e[4;35;1mProduct Columns (3.8ms)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
-
-
-NameError (undefined local variable or method `conditions' for #<Class:0xb70fec24>):
-    /usr/lib/ruby/gems/1.8/gems/activerecord-2.2.2/lib/active_record/base.rb:1833:in `method_missing'
-    /app/models/product.rb:12:in `find_products_for_sale'
-    /app/controllers/store_controller.rb:3:in `index'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/base.rb:1253:in `send'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/base.rb:1253:in `perform_action_without_filters'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/filters.rb:617:in `call_filters'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/filters.rb:610:in `perform_action_without_benchmark'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/benchmarking.rb:68:in `perform_action_without_rescue'
-    /usr/lib/ruby/1.8/benchmark.rb:293:in `measure'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/benchmarking.rb:68:in `perform_action_without_rescue'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/rescue.rb:136:in `perform_action_without_caching'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/caching/sql_cache.rb:13:in `perform_action'
-    /usr/lib/ruby/gems/1.8/gems/activerecord-2.2.2/lib/active_record/connection_adapters/abstract/query_cache.rb:34:in `cache'
-    /usr/lib/ruby/gems/1.8/gems/activerecord-2.2.2/lib/active_record/query_cache.rb:8:in `cache'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/caching/sql_cache.rb:12:in `perform_action'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/base.rb:524:in `send'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/base.rb:524:in `process_without_filters'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/filters.rb:606:in `process_without_session_management_support'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/session_management.rb:134:in `process'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/base.rb:392:in `process'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:183:in `handle_request'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:110:in `dispatch_unlocked'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:123:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:122:in `synchronize'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:122:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:132:in `dispatch_cgi'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:39:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:103:in `handle_dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:74:in `service'
-    /usr/lib/ruby/1.8/webrick/httpserver.rb:104:in `service'
-    /usr/lib/ruby/1.8/webrick/httpserver.rb:65:in `run'
-    /usr/lib/ruby/1.8/webrick/server.rb:173:in `start_thread'
-    /usr/lib/ruby/1.8/webrick/server.rb:162:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:162:in `start_thread'
-    /usr/lib/ruby/1.8/webrick/server.rb:95:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:92:in `each'
-    /usr/lib/ruby/1.8/webrick/server.rb:92:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:23:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:82:in `start'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:60:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/commands/servers/webrick.rb:66
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `gem_original_require'
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `require'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:153:in `require'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:521:in `new_constants_in'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:153:in `require'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/commands/server.rb:49
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `gem_original_require'
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `require'
-    script/server:3
-
-Rendered /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/templates/rescues/_trace (172.9ms)
-Rendered /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/templates/rescues/_request_and_response (2.9ms)
-Rendering /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/templates/rescues/layout.erb (internal_server_error)
-
-
-Processing StoreController#index (for 127.0.0.1 at 2009-02-04 14:12:32) [GET]
-  \e[4;36;1mSQL (0.2ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.2ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mProduct Load (141.7ms)\e[0m   \e[0;1mSELECT * FROM `products` WHERE (date_available <= now()) ORDER BY title\e[0m
-Rendering store/index
-  \e[4;35;1mProduct Columns (2.0ms)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
-Completed in 172ms (View: 18, DB: 142) | 200 OK [http://localhost/store]
-
-
-Processing StoreController#index (for 127.0.0.1 at 2009-02-04 14:12:53) [GET]
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mProduct Load (0.6ms)\e[0m   \e[0;1mSELECT * FROM `products` ORDER BY title\e[0m
-Rendering store/index
-  \e[4;35;1mProduct Columns (1.3ms)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
-Completed in 27ms (View: 15, DB: 1) | 200 OK [http://localhost/store]
-
-
-Processing StoreController#index (for 127.0.0.1 at 2009-02-04 14:13:05) [GET]
-  \e[4;36;1mSQL (0.2ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.2ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mProduct Load (0.9ms)\e[0m   \e[0;1mSELECT * FROM `products` WHERE (date_available <= now()) ORDER BY title\e[0m
-Rendering store/index
-  \e[4;35;1mProduct Columns (1.9ms)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
-Completed in 39ms (View: 19, DB: 1) | 200 OK [http://localhost/store]
-
-
-Processing StoreController#index (for 127.0.0.1 at 2009-02-04 14:15:08) [GET]
-  \e[4;36;1mSQL (0.2ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.2ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mProduct Load (0.8ms)\e[0m   \e[0;1mSELECT * FROM `products` WHERE (date_available <= now()) ORDER BY title\e[0m
-Rendering store/index
-  \e[4;35;1mProduct Columns (2.0ms)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
-Completed in 50ms (View: 29, DB: 1) | 200 OK [http://localhost/store]
-
-
-Processing StoreController#index (for 127.0.0.1 at 2009-02-04 21:32:09) [GET]
-  \e[4;36;1mSQL (0.2ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.3ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mProduct Load (0.9ms)\e[0m   \e[0;1mSELECT * FROM `products` WHERE (date_available <= now()) ORDER BY title\e[0m
-Rendering template within layouts/store
-Rendering store/index
-  \e[4;35;1mProduct Columns (2.2ms)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
-Completed in 39ms (View: 27, DB: 1) | 200 OK [http://localhost/store]
-
-
-Processing StoreController#index (for 127.0.0.1 at 2009-02-04 21:33:51) [GET]
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.2ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mProduct Load (0.6ms)\e[0m   \e[0;1mSELECT * FROM `products` WHERE (date_available <= now()) ORDER BY title\e[0m
-Rendering template within layouts/store
-Rendering store/index
-  \e[4;35;1mProduct Columns (1.2ms)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
-Completed in 39ms (View: 25, DB: 1) | 200 OK [http://localhost/store]
-
-
-Processing StoreController#index (for 127.0.0.1 at 2009-02-04 21:35:16) [GET]
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.2ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mProduct Load (0.9ms)\e[0m   \e[0;1mSELECT * FROM `products` WHERE (date_available <= now()) ORDER BY title\e[0m
-Rendering template within layouts/store
-Rendering store/index
-  \e[4;35;1mProduct Columns (1.9ms)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
-Completed in 49ms (View: 31, DB: 1) | 200 OK [http://localhost/store]
-
-
-Processing StoreController#index (for 127.0.0.1 at 2009-02-04 21:38:26) [GET]
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.2ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mProduct Load (0.8ms)\e[0m   \e[0;1mSELECT * FROM `products` WHERE (date_available <= now()) ORDER BY title\e[0m
-Rendering template within layouts/store
-Rendering store/index
-  \e[4;35;1mProduct Columns (2.1ms)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
-Completed in 57ms (View: 38, DB: 1) | 200 OK [http://localhost/store]
-
-
-Processing StoreController#index (for 127.0.0.1 at 2009-02-04 21:40:47) [GET]
-  \e[4;36;1mSQL (0.2ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.2ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mProduct Load (0.9ms)\e[0m   \e[0;1mSELECT * FROM `products` WHERE (date_available <= now()) ORDER BY title\e[0m
-Rendering template within layouts/store
-Rendering store/index
-  \e[4;35;1mProduct Columns (2.1ms)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
-Completed in 51ms (View: 33, DB: 1) | 200 OK [http://localhost/store]
-
-
-Processing StoreController#index (for 127.0.0.1 at 2009-02-04 21:41:01) [GET]
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mProduct Load (0.6ms)\e[0m   \e[0;1mSELECT * FROM `products` WHERE (date_available <= now()) ORDER BY title\e[0m
-Rendering template within layouts/store
-Rendering store/index
-  \e[4;35;1mProduct Columns (1.4ms)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
-Completed in 40ms (View: 26, DB: 1) | 200 OK [http://localhost/store]
-
-
-Processing StoreController#index (for 127.0.0.1 at 2009-02-04 21:41:26) [GET]
-  \e[4;36;1mSQL (0.2ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mProduct Load (0.6ms)\e[0m   \e[0;1mSELECT * FROM `products` WHERE (date_available <= now()) ORDER BY title\e[0m
-Rendering template within layouts/store
-Rendering store/index
-  \e[4;35;1mProduct Columns (1.1ms)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
-Completed in 38ms (View: 27, DB: 1) | 200 OK [http://localhost/store]
-
-
-Processing StoreController#index (for 127.0.0.1 at 2009-02-04 21:41:32) [POST]
-  Parameters: {"authenticity_token"=>"e5d513dc6072444247eccfd6ee064972eb3383d9"}
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mProduct Load (0.6ms)\e[0m   \e[0;1mSELECT * FROM `products` WHERE (date_available <= now()) ORDER BY title\e[0m
-Rendering template within layouts/store
-Rendering store/index
-  \e[4;35;1mProduct Columns (1.1ms)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
-Completed in 39ms (View: 28, DB: 1) | 200 OK [http://localhost/store]
-
-
-Processing StoreController#index (for 127.0.0.1 at 2009-02-04 21:52:17) [POST]
-  Parameters: {"authenticity_token"=>"e5d513dc6072444247eccfd6ee064972eb3383d9"}
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.2ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mProduct Load (0.9ms)\e[0m   \e[0;1mSELECT * FROM `products` WHERE (date_available <= now()) ORDER BY title\e[0m
-Rendering template within layouts/store
-Rendering store/index
-  \e[4;35;1mProduct Columns (2.0ms)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
-
-
-ActionView::TemplateError (undefined local variable or method `post' for #<ActionView::Base:0xb7046584>) on line #5 of app/views/store/index.html.erb:
-2: 
-3: <% for product in @products -%>
-4:   <div class="entry">
-5:     <%= link_to image_tag(product.image_url), :method => post %>
-6:     <h3><%=h product.title %></h3>
-7:     <%= product.description %>
-8:     <div class="price-line">
-
-    app/views/store/index.html.erb:5
-    app/views/store/index.html.erb:3:in `each'
-    app/views/store/index.html.erb:3
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_view/renderable.rb:39:in `send'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_view/renderable.rb:39:in `render'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_view/template.rb:73:in `render_template'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_view/base.rb:256:in `render'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_view/base.rb:367:in `_render_with_layout'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_view/base.rb:254:in `render'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/base.rb:1174:in `render_for_file'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/base.rb:896:in `render_without_benchmark'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/benchmarking.rb:51:in `render'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/core_ext/benchmark.rb:8:in `realtime'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/benchmarking.rb:51:in `render'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/base.rb:868:in `render_without_benchmark'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/benchmarking.rb:51:in `render'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/core_ext/benchmark.rb:8:in `realtime'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/benchmarking.rb:51:in `render'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/base.rb:1248:in `default_render'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/base.rb:1254:in `perform_action_without_filters'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/filters.rb:617:in `call_filters'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/filters.rb:610:in `perform_action_without_benchmark'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/benchmarking.rb:68:in `perform_action_without_rescue'
-    /usr/lib/ruby/1.8/benchmark.rb:293:in `measure'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/benchmarking.rb:68:in `perform_action_without_rescue'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/rescue.rb:136:in `perform_action_without_caching'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/caching/sql_cache.rb:13:in `perform_action'
-    /usr/lib/ruby/gems/1.8/gems/activerecord-2.2.2/lib/active_record/connection_adapters/abstract/query_cache.rb:34:in `cache'
-    /usr/lib/ruby/gems/1.8/gems/activerecord-2.2.2/lib/active_record/query_cache.rb:8:in `cache'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/caching/sql_cache.rb:12:in `perform_action'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/base.rb:524:in `send'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/base.rb:524:in `process_without_filters'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/filters.rb:606:in `process_without_session_management_support'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/session_management.rb:134:in `process'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/base.rb:392:in `process'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:183:in `handle_request'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:110:in `dispatch_unlocked'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:123:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:122:in `synchronize'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:122:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:132:in `dispatch_cgi'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:39:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:103:in `handle_dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:74:in `service'
-    /usr/lib/ruby/1.8/webrick/httpserver.rb:104:in `service'
-    /usr/lib/ruby/1.8/webrick/httpserver.rb:65:in `run'
-    /usr/lib/ruby/1.8/webrick/server.rb:173:in `start_thread'
-    /usr/lib/ruby/1.8/webrick/server.rb:162:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:162:in `start_thread'
-    /usr/lib/ruby/1.8/webrick/server.rb:95:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:92:in `each'
-    /usr/lib/ruby/1.8/webrick/server.rb:92:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:23:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:82:in `start'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:60:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/commands/servers/webrick.rb:66
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `gem_original_require'
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `require'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:153:in `require'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:521:in `new_constants_in'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:153:in `require'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/commands/server.rb:49
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `gem_original_require'
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `require'
-    script/server:3
-
-Rendered /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/templates/rescues/_trace (98.4ms)
-Rendered /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/templates/rescues/_request_and_response (2.4ms)
-Rendering /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/templates/rescues/layout.erb (internal_server_error)
-
-
-Processing StoreController#index (for 127.0.0.1 at 2009-02-04 21:52:32) [POST]
-  Parameters: {"authenticity_token"=>"e5d513dc6072444247eccfd6ee064972eb3383d9"}
-  \e[4;36;1mSQL (0.2ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.2ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mProduct Load (1.0ms)\e[0m   \e[0;1mSELECT * FROM `products` WHERE (date_available <= now()) ORDER BY title\e[0m
-Rendering template within layouts/store
-Rendering store/index
-  \e[4;35;1mProduct Columns (1.8ms)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
-Completed in 60ms (View: 41, DB: 1) | 200 OK [http://localhost/store]
-
-
-Processing StoreController#index (for 127.0.0.1 at 2009-02-04 21:52:36) [POST]
-  Parameters: {"authenticity_token"=>"e5d513dc6072444247eccfd6ee064972eb3383d9"}
-  \e[4;36;1mSQL (0.2ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.4ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mProduct Load (0.8ms)\e[0m   \e[0;1mSELECT * FROM `products` WHERE (date_available <= now()) ORDER BY title\e[0m
-Rendering template within layouts/store
-Rendering store/index
-  \e[4;35;1mProduct Columns (1.6ms)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
-Completed in 41ms (View: 27, DB: 1) | 200 OK [http://localhost/store]
-
-
-Processing StoreController#index (for 127.0.0.1 at 2009-02-04 21:52:37) [POST]
-  Parameters: {"authenticity_token"=>"e5d513dc6072444247eccfd6ee064972eb3383d9"}
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.3ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mProduct Load (0.6ms)\e[0m   \e[0;1mSELECT * FROM `products` WHERE (date_available <= now()) ORDER BY title\e[0m
-Rendering template within layouts/store
-Rendering store/index
-  \e[4;35;1mProduct Columns (2.2ms)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
-Completed in 43ms (View: 31, DB: 1) | 200 OK [http://localhost/store]
-
-
-Processing StoreController#index (for 127.0.0.1 at 2009-02-04 21:52:38) [GET]
-  Parameters: {"method"=>"post"}
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mProduct Load (0.8ms)\e[0m   \e[0;1mSELECT * FROM `products` WHERE (date_available <= now()) ORDER BY title\e[0m
-Rendering template within layouts/store
-Rendering store/index
-  \e[4;35;1mProduct Columns (1.3ms)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
-Completed in 46ms (View: 26, DB: 1) | 200 OK [http://localhost/store?method=post]
-
-
-Processing StoreController#index (for 127.0.0.1 at 2009-02-04 21:52:40) [GET]
-  Parameters: {"method"=>"post"}
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mProduct Load (0.5ms)\e[0m   \e[0;1mSELECT * FROM `products` WHERE (date_available <= now()) ORDER BY title\e[0m
-Rendering template within layouts/store
-Rendering store/index
-  \e[4;35;1mProduct Columns (1.9ms)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
-Completed in 43ms (View: 30, DB: 1) | 200 OK [http://localhost/store?method=post]
-
-
-Processing StoreController#index (for 127.0.0.1 at 2009-02-04 21:52:41) [POST]
-  Parameters: {"authenticity_token"=>"e5d513dc6072444247eccfd6ee064972eb3383d9"}
-  \e[4;36;1mSQL (0.2ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.2ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mProduct Load (0.5ms)\e[0m   \e[0;1mSELECT * FROM `products` WHERE (date_available <= now()) ORDER BY title\e[0m
-Rendering template within layouts/store
-Rendering store/index
-  \e[4;35;1mProduct Columns (1.1ms)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
-Completed in 42ms (View: 28, DB: 1) | 200 OK [http://localhost/store]
-
-
-Processing StoreController#index (for 127.0.0.1 at 2009-02-04 21:52:42) [POST]
-  Parameters: {"authenticity_token"=>"e5d513dc6072444247eccfd6ee064972eb3383d9"}
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.2ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mProduct Load (0.8ms)\e[0m   \e[0;1mSELECT * FROM `products` WHERE (date_available <= now()) ORDER BY title\e[0m
-Rendering template within layouts/store
-Rendering store/index
-  \e[4;35;1mProduct Columns (1.8ms)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
-Completed in 50ms (View: 33, DB: 1) | 200 OK [http://localhost/store]
-
-
-Processing StoreController#index (for 127.0.0.1 at 2009-02-04 21:52:44) [POST]
-  Parameters: {"authenticity_token"=>"e5d513dc6072444247eccfd6ee064972eb3383d9"}
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mProduct Load (0.5ms)\e[0m   \e[0;1mSELECT * FROM `products` WHERE (date_available <= now()) ORDER BY title\e[0m
-Rendering template within layouts/store
-Rendering store/index
-  \e[4;35;1mProduct Columns (1.8ms)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
-Completed in 48ms (View: 28, DB: 1) | 200 OK [http://localhost/store]
-
-
-Processing StoreController#index (for 127.0.0.1 at 2009-02-04 21:52:46) [GET]
-  Parameters: {"method"=>"post"}
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.2ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mProduct Load (0.6ms)\e[0m   \e[0;1mSELECT * FROM `products` WHERE (date_available <= now()) ORDER BY title\e[0m
-Rendering template within layouts/store
-Rendering store/index
-  \e[4;35;1mProduct Columns (1.9ms)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
-Completed in 52ms (View: 37, DB: 1) | 200 OK [http://localhost/store?method=post]
-
-
-Processing StoreController#index (for 127.0.0.1 at 2009-02-04 21:55:16) [GET]
-  Parameters: {"method"=>"post"}
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mProduct Load (0.6ms)\e[0m   \e[0;1mSELECT * FROM `products` WHERE (date_available <= now()) ORDER BY title\e[0m
-Rendering template within layouts/store
-Rendering store/index
-  \e[4;35;1mProduct Columns (2.2ms)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
-Completed in 37ms (View: 26, DB: 1) | 200 OK [http://localhost/store?method=post]
-
-
-Processing StoreController#index (for 127.0.0.1 at 2009-02-04 21:55:23) [POST]
-  Parameters: {"authenticity_token"=>"e5d513dc6072444247eccfd6ee064972eb3383d9"}
-  \e[4;36;1mSQL (0.2ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.2ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mProduct Load (0.7ms)\e[0m   \e[0;1mSELECT * FROM `products` WHERE (date_available <= now()) ORDER BY title\e[0m
-Rendering template within layouts/store
-Rendering store/index
-  \e[4;35;1mProduct Columns (2.1ms)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
-Completed in 50ms (View: 33, DB: 1) | 200 OK [http://localhost/store]
-
-
-Processing StoreController#add_to_cart (for 127.0.0.1 at 2009-02-04 21:55:24) [GET]
-  Parameters: {"method"=>"post"}
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.2ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-
-
-ActionController::UnknownAction (No action responded to add_to_cart. Actions: index):
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/filters.rb:617:in `call_filters'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/filters.rb:610:in `perform_action_without_benchmark'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/benchmarking.rb:68:in `perform_action_without_rescue'
-    /usr/lib/ruby/1.8/benchmark.rb:293:in `measure'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/benchmarking.rb:68:in `perform_action_without_rescue'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/rescue.rb:136:in `perform_action_without_caching'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/caching/sql_cache.rb:13:in `perform_action'
-    /usr/lib/ruby/gems/1.8/gems/activerecord-2.2.2/lib/active_record/connection_adapters/abstract/query_cache.rb:34:in `cache'
-    /usr/lib/ruby/gems/1.8/gems/activerecord-2.2.2/lib/active_record/query_cache.rb:8:in `cache'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/caching/sql_cache.rb:12:in `perform_action'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/base.rb:524:in `send'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/base.rb:524:in `process_without_filters'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/filters.rb:606:in `process_without_session_management_support'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/session_management.rb:134:in `process'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/base.rb:392:in `process'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:183:in `handle_request'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:110:in `dispatch_unlocked'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:123:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:122:in `synchronize'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:122:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:132:in `dispatch_cgi'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:39:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:103:in `handle_dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:74:in `service'
-    /usr/lib/ruby/1.8/webrick/httpserver.rb:104:in `service'
-    /usr/lib/ruby/1.8/webrick/httpserver.rb:65:in `run'
-    /usr/lib/ruby/1.8/webrick/server.rb:173:in `start_thread'
-    /usr/lib/ruby/1.8/webrick/server.rb:162:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:162:in `start_thread'
-    /usr/lib/ruby/1.8/webrick/server.rb:95:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:92:in `each'
-    /usr/lib/ruby/1.8/webrick/server.rb:92:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:23:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:82:in `start'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:60:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/commands/servers/webrick.rb:66
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `gem_original_require'
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `require'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:153:in `require'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:521:in `new_constants_in'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:153:in `require'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/commands/server.rb:49
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `gem_original_require'
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `require'
-    script/server:3
-
-Rendering /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/templates/rescues/layout.erb (not_found)
-
-
-Processing StoreController#index (for 127.0.0.1 at 2009-02-04 21:57:05) [POST]
-  Parameters: {"authenticity_token"=>"e5d513dc6072444247eccfd6ee064972eb3383d9"}
-  \e[4;36;1mSQL (0.2ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.3ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mProduct Load (0.9ms)\e[0m   \e[0;1mSELECT * FROM `products` WHERE (date_available <= now()) ORDER BY title\e[0m
-Rendering template within layouts/store
-Rendering store/index
-  \e[4;35;1mProduct Columns (2.0ms)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
-Completed in 71ms (View: 51, DB: 1) | 200 OK [http://localhost/store]
-
-
-Processing StoreController#index (for 127.0.0.1 at 2009-02-04 21:58:21) [POST]
-  Parameters: {"authenticity_token"=>"e5d513dc6072444247eccfd6ee064972eb3383d9"}
-  \e[4;36;1mSQL (0.8ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.4ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mProduct Load (0.9ms)\e[0m   \e[0;1mSELECT * FROM `products` WHERE (date_available <= now()) ORDER BY title\e[0m
-Rendering template within layouts/store
-Rendering store/index
-  \e[4;35;1mProduct Columns (2.2ms)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
-Completed in 63ms (View: 43, DB: 2) | 200 OK [http://localhost/store]
-
-
-Processing StoreController#add_to_cart (for 127.0.0.1 at 2009-02-04 21:58:23) [GET]
-  Parameters: {"id"=>"4", "method"=>"post"}
-  \e[4;36;1mSQL (0.2ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.2ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-
-
-ActionController::UnknownAction (No action responded to add_to_cart. Actions: index):
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/filters.rb:617:in `call_filters'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/filters.rb:610:in `perform_action_without_benchmark'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/benchmarking.rb:68:in `perform_action_without_rescue'
-    /usr/lib/ruby/1.8/benchmark.rb:293:in `measure'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/benchmarking.rb:68:in `perform_action_without_rescue'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/rescue.rb:136:in `perform_action_without_caching'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/caching/sql_cache.rb:13:in `perform_action'
-    /usr/lib/ruby/gems/1.8/gems/activerecord-2.2.2/lib/active_record/connection_adapters/abstract/query_cache.rb:34:in `cache'
-    /usr/lib/ruby/gems/1.8/gems/activerecord-2.2.2/lib/active_record/query_cache.rb:8:in `cache'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/caching/sql_cache.rb:12:in `perform_action'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/base.rb:524:in `send'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/base.rb:524:in `process_without_filters'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/filters.rb:606:in `process_without_session_management_support'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/session_management.rb:134:in `process'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/base.rb:392:in `process'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:183:in `handle_request'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:110:in `dispatch_unlocked'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:123:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:122:in `synchronize'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:122:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:132:in `dispatch_cgi'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:39:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:103:in `handle_dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:74:in `service'
-    /usr/lib/ruby/1.8/webrick/httpserver.rb:104:in `service'
-    /usr/lib/ruby/1.8/webrick/httpserver.rb:65:in `run'
-    /usr/lib/ruby/1.8/webrick/server.rb:173:in `start_thread'
-    /usr/lib/ruby/1.8/webrick/server.rb:162:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:162:in `start_thread'
-    /usr/lib/ruby/1.8/webrick/server.rb:95:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:92:in `each'
-    /usr/lib/ruby/1.8/webrick/server.rb:92:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:23:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:82:in `start'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:60:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/commands/servers/webrick.rb:66
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `gem_original_require'
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `require'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:153:in `require'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:521:in `new_constants_in'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:153:in `require'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/commands/server.rb:49
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `gem_original_require'
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `require'
-    script/server:3
-
-Rendering /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/templates/rescues/layout.erb (not_found)
-
-
-Processing StoreController#add_to_cart (for 127.0.0.1 at 2009-02-04 21:58:27) [POST]
-  Parameters: {"authenticity_token"=>"e5d513dc6072444247eccfd6ee064972eb3383d9", "id"=>"4"}
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-
-
-ActionController::UnknownAction (No action responded to add_to_cart. Actions: index):
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/filters.rb:617:in `call_filters'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/filters.rb:610:in `perform_action_without_benchmark'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/benchmarking.rb:68:in `perform_action_without_rescue'
-    /usr/lib/ruby/1.8/benchmark.rb:293:in `measure'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/benchmarking.rb:68:in `perform_action_without_rescue'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/rescue.rb:136:in `perform_action_without_caching'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/caching/sql_cache.rb:13:in `perform_action'
-    /usr/lib/ruby/gems/1.8/gems/activerecord-2.2.2/lib/active_record/connection_adapters/abstract/query_cache.rb:34:in `cache'
-    /usr/lib/ruby/gems/1.8/gems/activerecord-2.2.2/lib/active_record/query_cache.rb:8:in `cache'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/caching/sql_cache.rb:12:in `perform_action'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/base.rb:524:in `send'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/base.rb:524:in `process_without_filters'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/filters.rb:606:in `process_without_session_management_support'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/session_management.rb:134:in `process'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/base.rb:392:in `process'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:183:in `handle_request'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:110:in `dispatch_unlocked'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:123:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:122:in `synchronize'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:122:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:132:in `dispatch_cgi'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:39:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:103:in `handle_dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:74:in `service'
-    /usr/lib/ruby/1.8/webrick/httpserver.rb:104:in `service'
-    /usr/lib/ruby/1.8/webrick/httpserver.rb:65:in `run'
-    /usr/lib/ruby/1.8/webrick/server.rb:173:in `start_thread'
-    /usr/lib/ruby/1.8/webrick/server.rb:162:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:162:in `start_thread'
-    /usr/lib/ruby/1.8/webrick/server.rb:95:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:92:in `each'
-    /usr/lib/ruby/1.8/webrick/server.rb:92:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:23:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:82:in `start'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:60:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/commands/servers/webrick.rb:66
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `gem_original_require'
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `require'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:153:in `require'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:521:in `new_constants_in'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:153:in `require'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/commands/server.rb:49
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `gem_original_require'
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `require'
-    script/server:3
-
-Rendering /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/templates/rescues/layout.erb (not_found)
-
-
-Processing StoreController#index (for 127.0.0.1 at 2009-02-04 21:58:48) [POST]
-  Parameters: {"authenticity_token"=>"e5d513dc6072444247eccfd6ee064972eb3383d9"}
-  \e[4;36;1mSQL (0.2ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.2ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mProduct Load (0.8ms)\e[0m   \e[0;1mSELECT * FROM `products` WHERE (date_available <= now()) ORDER BY title\e[0m
-Rendering template within layouts/store
-Rendering store/index
-  \e[4;35;1mProduct Columns (2.1ms)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
-Completed in 61ms (View: 43, DB: 1) | 200 OK [http://localhost/store]
-
-
-Processing StoreController#add_to_cart (for 127.0.0.1 at 2009-02-04 21:58:50) [POST]
-  Parameters: {"authenticity_token"=>"e5d513dc6072444247eccfd6ee064972eb3383d9", "id"=>"4"}
-  \e[4;36;1mSQL (0.2ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.2ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-
-
-ActionController::UnknownAction (No action responded to add_to_cart. Actions: index):
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/filters.rb:617:in `call_filters'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/filters.rb:610:in `perform_action_without_benchmark'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/benchmarking.rb:68:in `perform_action_without_rescue'
-    /usr/lib/ruby/1.8/benchmark.rb:293:in `measure'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/benchmarking.rb:68:in `perform_action_without_rescue'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/rescue.rb:136:in `perform_action_without_caching'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/caching/sql_cache.rb:13:in `perform_action'
-    /usr/lib/ruby/gems/1.8/gems/activerecord-2.2.2/lib/active_record/connection_adapters/abstract/query_cache.rb:34:in `cache'
-    /usr/lib/ruby/gems/1.8/gems/activerecord-2.2.2/lib/active_record/query_cache.rb:8:in `cache'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/caching/sql_cache.rb:12:in `perform_action'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/base.rb:524:in `send'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/base.rb:524:in `process_without_filters'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/filters.rb:606:in `process_without_session_management_support'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/session_management.rb:134:in `process'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/base.rb:392:in `process'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:183:in `handle_request'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:110:in `dispatch_unlocked'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:123:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:122:in `synchronize'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:122:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:132:in `dispatch_cgi'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:39:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:103:in `handle_dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:74:in `service'
-    /usr/lib/ruby/1.8/webrick/httpserver.rb:104:in `service'
-    /usr/lib/ruby/1.8/webrick/httpserver.rb:65:in `run'
-    /usr/lib/ruby/1.8/webrick/server.rb:173:in `start_thread'
-    /usr/lib/ruby/1.8/webrick/server.rb:162:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:162:in `start_thread'
-    /usr/lib/ruby/1.8/webrick/server.rb:95:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:92:in `each'
-    /usr/lib/ruby/1.8/webrick/server.rb:92:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:23:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:82:in `start'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:60:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/commands/servers/webrick.rb:66
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `gem_original_require'
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `require'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:153:in `require'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:521:in `new_constants_in'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:153:in `require'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/commands/server.rb:49
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `gem_original_require'
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `require'
-    script/server:3
-
-Rendering /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/templates/rescues/layout.erb (not_found)
-
-
-Processing StoreController#add_to_cart (for 127.0.0.1 at 2009-02-04 21:58:53) [POST]
-  Parameters: {"authenticity_token"=>"e5d513dc6072444247eccfd6ee064972eb3383d9", "id"=>"4"}
-  \e[4;36;1mSQL (0.2ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-
-
-ActionController::UnknownAction (No action responded to add_to_cart. Actions: index):
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/filters.rb:617:in `call_filters'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/filters.rb:610:in `perform_action_without_benchmark'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/benchmarking.rb:68:in `perform_action_without_rescue'
-    /usr/lib/ruby/1.8/benchmark.rb:293:in `measure'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/benchmarking.rb:68:in `perform_action_without_rescue'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/rescue.rb:136:in `perform_action_without_caching'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/caching/sql_cache.rb:13:in `perform_action'
-    /usr/lib/ruby/gems/1.8/gems/activerecord-2.2.2/lib/active_record/connection_adapters/abstract/query_cache.rb:34:in `cache'
-    /usr/lib/ruby/gems/1.8/gems/activerecord-2.2.2/lib/active_record/query_cache.rb:8:in `cache'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/caching/sql_cache.rb:12:in `perform_action'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/base.rb:524:in `send'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/base.rb:524:in `process_without_filters'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/filters.rb:606:in `process_without_session_management_support'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/session_management.rb:134:in `process'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/base.rb:392:in `process'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:183:in `handle_request'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:110:in `dispatch_unlocked'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:123:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:122:in `synchronize'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:122:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:132:in `dispatch_cgi'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:39:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:103:in `handle_dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:74:in `service'
-    /usr/lib/ruby/1.8/webrick/httpserver.rb:104:in `service'
-    /usr/lib/ruby/1.8/webrick/httpserver.rb:65:in `run'
-    /usr/lib/ruby/1.8/webrick/server.rb:173:in `start_thread'
-    /usr/lib/ruby/1.8/webrick/server.rb:162:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:162:in `start_thread'
-    /usr/lib/ruby/1.8/webrick/server.rb:95:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:92:in `each'
-    /usr/lib/ruby/1.8/webrick/server.rb:92:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:23:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:82:in `start'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:60:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/commands/servers/webrick.rb:66
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `gem_original_require'
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `require'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:153:in `require'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:521:in `new_constants_in'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:153:in `require'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/commands/server.rb:49
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `gem_original_require'
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `require'
-    script/server:3
-
-Rendering /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/templates/rescues/layout.erb (not_found)
-
-
-Processing StoreController#add_to_cart (for 127.0.0.1 at 2009-02-04 21:58:57) [POST]
-  Parameters: {"authenticity_token"=>"e5d513dc6072444247eccfd6ee064972eb3383d9", "id"=>"4"}
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-
-
-ActionController::UnknownAction (No action responded to add_to_cart. Actions: index):
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/filters.rb:617:in `call_filters'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/filters.rb:610:in `perform_action_without_benchmark'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/benchmarking.rb:68:in `perform_action_without_rescue'
-    /usr/lib/ruby/1.8/benchmark.rb:293:in `measure'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/benchmarking.rb:68:in `perform_action_without_rescue'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/rescue.rb:136:in `perform_action_without_caching'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/caching/sql_cache.rb:13:in `perform_action'
-    /usr/lib/ruby/gems/1.8/gems/activerecord-2.2.2/lib/active_record/connection_adapters/abstract/query_cache.rb:34:in `cache'
-    /usr/lib/ruby/gems/1.8/gems/activerecord-2.2.2/lib/active_record/query_cache.rb:8:in `cache'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/caching/sql_cache.rb:12:in `perform_action'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/base.rb:524:in `send'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/base.rb:524:in `process_without_filters'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/filters.rb:606:in `process_without_session_management_support'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/session_management.rb:134:in `process'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/base.rb:392:in `process'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:183:in `handle_request'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:110:in `dispatch_unlocked'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:123:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:122:in `synchronize'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:122:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:132:in `dispatch_cgi'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:39:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:103:in `handle_dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:74:in `service'
-    /usr/lib/ruby/1.8/webrick/httpserver.rb:104:in `service'
-    /usr/lib/ruby/1.8/webrick/httpserver.rb:65:in `run'
-    /usr/lib/ruby/1.8/webrick/server.rb:173:in `start_thread'
-    /usr/lib/ruby/1.8/webrick/server.rb:162:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:162:in `start_thread'
-    /usr/lib/ruby/1.8/webrick/server.rb:95:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:92:in `each'
-    /usr/lib/ruby/1.8/webrick/server.rb:92:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:23:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:82:in `start'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:60:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/commands/servers/webrick.rb:66
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `gem_original_require'
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `require'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:153:in `require'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:521:in `new_constants_in'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:153:in `require'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/commands/server.rb:49
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `gem_original_require'
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `require'
-    script/server:3
-
-Rendering /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/templates/rescues/layout.erb (not_found)
-
-
-Processing StoreController#index (for 127.0.0.1 at 2009-02-04 21:59:50) [POST]
-  Parameters: {"authenticity_token"=>"e5d513dc6072444247eccfd6ee064972eb3383d9"}
-  \e[4;36;1mSQL (0.2ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.2ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mProduct Load (1.0ms)\e[0m   \e[0;1mSELECT * FROM `products` WHERE (date_available <= now()) ORDER BY title\e[0m
-Rendering template within layouts/store
-Rendering store/index
-  \e[4;35;1mProduct Columns (2.1ms)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
-Completed in 61ms (View: 41, DB: 1) | 200 OK [http://localhost/store]
-
-
-Processing StoreController#add_to_cart (for 127.0.0.1 at 2009-02-04 21:59:54) [POST]
-  Parameters: {"authenticity_token"=>"e5d513dc6072444247eccfd6ee064972eb3383d9", "id"=>"4"}
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.2ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-
-
-ActionController::UnknownAction (No action responded to add_to_cart. Actions: index):
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/filters.rb:617:in `call_filters'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/filters.rb:610:in `perform_action_without_benchmark'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/benchmarking.rb:68:in `perform_action_without_rescue'
-    /usr/lib/ruby/1.8/benchmark.rb:293:in `measure'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/benchmarking.rb:68:in `perform_action_without_rescue'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/rescue.rb:136:in `perform_action_without_caching'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/caching/sql_cache.rb:13:in `perform_action'
-    /usr/lib/ruby/gems/1.8/gems/activerecord-2.2.2/lib/active_record/connection_adapters/abstract/query_cache.rb:34:in `cache'
-    /usr/lib/ruby/gems/1.8/gems/activerecord-2.2.2/lib/active_record/query_cache.rb:8:in `cache'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/caching/sql_cache.rb:12:in `perform_action'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/base.rb:524:in `send'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/base.rb:524:in `process_without_filters'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/filters.rb:606:in `process_without_session_management_support'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/session_management.rb:134:in `process'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/base.rb:392:in `process'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:183:in `handle_request'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:110:in `dispatch_unlocked'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:123:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:122:in `synchronize'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:122:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:132:in `dispatch_cgi'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:39:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:103:in `handle_dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:74:in `service'
-    /usr/lib/ruby/1.8/webrick/httpserver.rb:104:in `service'
-    /usr/lib/ruby/1.8/webrick/httpserver.rb:65:in `run'
-    /usr/lib/ruby/1.8/webrick/server.rb:173:in `start_thread'
-    /usr/lib/ruby/1.8/webrick/server.rb:162:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:162:in `start_thread'
-    /usr/lib/ruby/1.8/webrick/server.rb:95:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:92:in `each'
-    /usr/lib/ruby/1.8/webrick/server.rb:92:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:23:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:82:in `start'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:60:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/commands/servers/webrick.rb:66
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `gem_original_require'
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `require'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:153:in `require'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:521:in `new_constants_in'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:153:in `require'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/commands/server.rb:49
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `gem_original_require'
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `require'
-    script/server:3
-
-Rendering /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/templates/rescues/layout.erb (not_found)
-
-
-Processing StoreController#index (for 127.0.0.1 at 2009-02-04 22:00:51) [POST]
-  Parameters: {"authenticity_token"=>"e5d513dc6072444247eccfd6ee064972eb3383d9"}
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.2ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mProduct Load (0.8ms)\e[0m   \e[0;1mSELECT * FROM `products` WHERE (date_available <= now()) ORDER BY title\e[0m
-Rendering template within layouts/store
-Rendering store/index
-  \e[4;35;1mProduct Columns (2.1ms)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
-Completed in 64ms (View: 45, DB: 1) | 200 OK [http://localhost/store]
-
-
-Processing StoreController#index (for 127.0.0.1 at 2009-02-04 22:05:28) [POST]
-  Parameters: {"authenticity_token"=>"e5d513dc6072444247eccfd6ee064972eb3383d9"}
-  \e[4;36;1mSQL (0.2ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.2ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mProduct Load (0.9ms)\e[0m   \e[0;1mSELECT * FROM `products` WHERE (date_available <= now()) ORDER BY title\e[0m
-Rendering template within layouts/store
-Rendering store/index
-  \e[4;35;1mProduct Columns (2.1ms)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
-Completed in 72ms (View: 53, DB: 1) | 200 OK [http://localhost/store]
-
-
-Processing StoreController#add_to_cart (for 127.0.0.1 at 2009-02-04 22:05:32) [POST]
-  Parameters: {"authenticity_token"=>"e5d513dc6072444247eccfd6ee064972eb3383d9", "id"=>"4"}
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-
-
-ActionController::UnknownAction (No action responded to add_to_cart. Actions: index):
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/filters.rb:617:in `call_filters'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/filters.rb:610:in `perform_action_without_benchmark'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/benchmarking.rb:68:in `perform_action_without_rescue'
-    /usr/lib/ruby/1.8/benchmark.rb:293:in `measure'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/benchmarking.rb:68:in `perform_action_without_rescue'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/rescue.rb:136:in `perform_action_without_caching'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/caching/sql_cache.rb:13:in `perform_action'
-    /usr/lib/ruby/gems/1.8/gems/activerecord-2.2.2/lib/active_record/connection_adapters/abstract/query_cache.rb:34:in `cache'
-    /usr/lib/ruby/gems/1.8/gems/activerecord-2.2.2/lib/active_record/query_cache.rb:8:in `cache'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/caching/sql_cache.rb:12:in `perform_action'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/base.rb:524:in `send'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/base.rb:524:in `process_without_filters'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/filters.rb:606:in `process_without_session_management_support'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/session_management.rb:134:in `process'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/base.rb:392:in `process'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:183:in `handle_request'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:110:in `dispatch_unlocked'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:123:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:122:in `synchronize'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:122:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:132:in `dispatch_cgi'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:39:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:103:in `handle_dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:74:in `service'
-    /usr/lib/ruby/1.8/webrick/httpserver.rb:104:in `service'
-    /usr/lib/ruby/1.8/webrick/httpserver.rb:65:in `run'
-    /usr/lib/ruby/1.8/webrick/server.rb:173:in `start_thread'
-    /usr/lib/ruby/1.8/webrick/server.rb:162:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:162:in `start_thread'
-    /usr/lib/ruby/1.8/webrick/server.rb:95:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:92:in `each'
-    /usr/lib/ruby/1.8/webrick/server.rb:92:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:23:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:82:in `start'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:60:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/commands/servers/webrick.rb:66
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `gem_original_require'
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `require'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:153:in `require'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:521:in `new_constants_in'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:153:in `require'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/commands/server.rb:49
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `gem_original_require'
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `require'
-    script/server:3
-
-Rendering /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/templates/rescues/layout.erb (not_found)
-
-
-Processing StoreController#add_to_cart (for 127.0.0.1 at 2009-02-04 22:05:38) [POST]
-  Parameters: {"authenticity_token"=>"e5d513dc6072444247eccfd6ee064972eb3383d9", "id"=>"3"}
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-
-
-ActionController::UnknownAction (No action responded to add_to_cart. Actions: index):
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/filters.rb:617:in `call_filters'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/filters.rb:610:in `perform_action_without_benchmark'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/benchmarking.rb:68:in `perform_action_without_rescue'
-    /usr/lib/ruby/1.8/benchmark.rb:293:in `measure'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/benchmarking.rb:68:in `perform_action_without_rescue'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/rescue.rb:136:in `perform_action_without_caching'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/caching/sql_cache.rb:13:in `perform_action'
-    /usr/lib/ruby/gems/1.8/gems/activerecord-2.2.2/lib/active_record/connection_adapters/abstract/query_cache.rb:34:in `cache'
-    /usr/lib/ruby/gems/1.8/gems/activerecord-2.2.2/lib/active_record/query_cache.rb:8:in `cache'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/caching/sql_cache.rb:12:in `perform_action'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/base.rb:524:in `send'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/base.rb:524:in `process_without_filters'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/filters.rb:606:in `process_without_session_management_support'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/session_management.rb:134:in `process'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/base.rb:392:in `process'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:183:in `handle_request'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:110:in `dispatch_unlocked'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:123:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:122:in `synchronize'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:122:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:132:in `dispatch_cgi'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:39:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:103:in `handle_dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:74:in `service'
-    /usr/lib/ruby/1.8/webrick/httpserver.rb:104:in `service'
-    /usr/lib/ruby/1.8/webrick/httpserver.rb:65:in `run'
-    /usr/lib/ruby/1.8/webrick/server.rb:173:in `start_thread'
-    /usr/lib/ruby/1.8/webrick/server.rb:162:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:162:in `start_thread'
-    /usr/lib/ruby/1.8/webrick/server.rb:95:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:92:in `each'
-    /usr/lib/ruby/1.8/webrick/server.rb:92:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:23:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:82:in `start'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:60:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/commands/servers/webrick.rb:66
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `gem_original_require'
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `require'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:153:in `require'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:521:in `new_constants_in'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:153:in `require'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/commands/server.rb:49
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `gem_original_require'
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `require'
-    script/server:3
-
-Rendering /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/templates/rescues/layout.erb (not_found)
-
-
-Processing StoreController#add_to_cart (for 127.0.0.1 at 2009-02-04 22:05:42) [POST]
-  Parameters: {"authenticity_token"=>"e5d513dc6072444247eccfd6ee064972eb3383d9", "id"=>"3"}
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-
-
-ActionController::UnknownAction (No action responded to add_to_cart. Actions: index):
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/filters.rb:617:in `call_filters'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/filters.rb:610:in `perform_action_without_benchmark'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/benchmarking.rb:68:in `perform_action_without_rescue'
-    /usr/lib/ruby/1.8/benchmark.rb:293:in `measure'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/benchmarking.rb:68:in `perform_action_without_rescue'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/rescue.rb:136:in `perform_action_without_caching'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/caching/sql_cache.rb:13:in `perform_action'
-    /usr/lib/ruby/gems/1.8/gems/activerecord-2.2.2/lib/active_record/connection_adapters/abstract/query_cache.rb:34:in `cache'
-    /usr/lib/ruby/gems/1.8/gems/activerecord-2.2.2/lib/active_record/query_cache.rb:8:in `cache'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/caching/sql_cache.rb:12:in `perform_action'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/base.rb:524:in `send'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/base.rb:524:in `process_without_filters'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/filters.rb:606:in `process_without_session_management_support'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/session_management.rb:134:in `process'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/base.rb:392:in `process'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:183:in `handle_request'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:110:in `dispatch_unlocked'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:123:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:122:in `synchronize'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:122:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:132:in `dispatch_cgi'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:39:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:103:in `handle_dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:74:in `service'
-    /usr/lib/ruby/1.8/webrick/httpserver.rb:104:in `service'
-    /usr/lib/ruby/1.8/webrick/httpserver.rb:65:in `run'
-    /usr/lib/ruby/1.8/webrick/server.rb:173:in `start_thread'
-    /usr/lib/ruby/1.8/webrick/server.rb:162:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:162:in `start_thread'
-    /usr/lib/ruby/1.8/webrick/server.rb:95:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:92:in `each'
-    /usr/lib/ruby/1.8/webrick/server.rb:92:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:23:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:82:in `start'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:60:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/commands/servers/webrick.rb:66
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `gem_original_require'
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `require'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:153:in `require'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:521:in `new_constants_in'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:153:in `require'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/commands/server.rb:49
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `gem_original_require'
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `require'
-    script/server:3
-
-Rendering /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/templates/rescues/layout.erb (not_found)
-
-
-Processing StoreController#add_to_cart (for 127.0.0.1 at 2009-02-04 22:05:44) [POST]
-  Parameters: {"authenticity_token"=>"e5d513dc6072444247eccfd6ee064972eb3383d9", "id"=>"3"}
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-
-
-ActionController::UnknownAction (No action responded to add_to_cart. Actions: index):
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/filters.rb:617:in `call_filters'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/filters.rb:610:in `perform_action_without_benchmark'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/benchmarking.rb:68:in `perform_action_without_rescue'
-    /usr/lib/ruby/1.8/benchmark.rb:293:in `measure'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/benchmarking.rb:68:in `perform_action_without_rescue'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/rescue.rb:136:in `perform_action_without_caching'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/caching/sql_cache.rb:13:in `perform_action'
-    /usr/lib/ruby/gems/1.8/gems/activerecord-2.2.2/lib/active_record/connection_adapters/abstract/query_cache.rb:34:in `cache'
-    /usr/lib/ruby/gems/1.8/gems/activerecord-2.2.2/lib/active_record/query_cache.rb:8:in `cache'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/caching/sql_cache.rb:12:in `perform_action'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/base.rb:524:in `send'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/base.rb:524:in `process_without_filters'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/filters.rb:606:in `process_without_session_management_support'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/session_management.rb:134:in `process'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/base.rb:392:in `process'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:183:in `handle_request'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:110:in `dispatch_unlocked'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:123:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:122:in `synchronize'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:122:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:132:in `dispatch_cgi'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:39:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:103:in `handle_dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:74:in `service'
-    /usr/lib/ruby/1.8/webrick/httpserver.rb:104:in `service'
-    /usr/lib/ruby/1.8/webrick/httpserver.rb:65:in `run'
-    /usr/lib/ruby/1.8/webrick/server.rb:173:in `start_thread'
-    /usr/lib/ruby/1.8/webrick/server.rb:162:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:162:in `start_thread'
-    /usr/lib/ruby/1.8/webrick/server.rb:95:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:92:in `each'
-    /usr/lib/ruby/1.8/webrick/server.rb:92:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:23:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:82:in `start'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:60:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/commands/servers/webrick.rb:66
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `gem_original_require'
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `require'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:153:in `require'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:521:in `new_constants_in'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:153:in `require'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/commands/server.rb:49
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `gem_original_require'
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `require'
-    script/server:3
-
-Rendering /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/templates/rescues/layout.erb (not_found)
-
-
-Processing ApplicationController#index (for 127.0.0.1 at 2009-02-05 14:36:54) [GET]
-
-
-ActionController::RoutingError (No route matches "/admin/list" with {:method=>:get}):
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/routing/recognition_optimisation.rb:66:in `recognize_path'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/routing/route_set.rb:386:in `recognize'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:182:in `handle_request'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:110:in `dispatch_unlocked'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:123:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:122:in `synchronize'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:122:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:132:in `dispatch_cgi'
-    /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/dispatcher.rb:39:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:103:in `handle_dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:74:in `service'
-    /usr/lib/ruby/1.8/webrick/httpserver.rb:104:in `service'
-    /usr/lib/ruby/1.8/webrick/httpserver.rb:65:in `run'
-    /usr/lib/ruby/1.8/webrick/server.rb:173:in `start_thread'
-    /usr/lib/ruby/1.8/webrick/server.rb:162:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:162:in `start_thread'
-    /usr/lib/ruby/1.8/webrick/server.rb:95:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:92:in `each'
-    /usr/lib/ruby/1.8/webrick/server.rb:92:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:23:in `start'
-    /usr/lib/ruby/1.8/webrick/server.rb:82:in `start'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/webrick_server.rb:60:in `dispatch'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/commands/servers/webrick.rb:66
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `gem_original_require'
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `require'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:153:in `require'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:521:in `new_constants_in'
-    /usr/lib/ruby/gems/1.8/gems/activesupport-2.2.2/lib/active_support/dependencies.rb:153:in `require'
-    /usr/lib/ruby/gems/1.8/gems/rails-2.2.2/lib/commands/server.rb:49
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `gem_original_require'
-    /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:31:in `require'
-    script/server:3
-
-Rendering /usr/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/action_controller/templates/rescues/layout.erb (not_found)
-
-
-Processing StoreController#index (for 127.0.0.1 at 2009-02-05 14:37:09) [GET]
-  \e[4;36;1mSQL (0.3ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.3ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mProduct Load (1.2ms)\e[0m   \e[0;1mSELECT * FROM `products` WHERE (date_available <= now()) ORDER BY title\e[0m
-Rendering template within layouts/store
-Rendering store/index
-  \e[4;35;1mProduct Columns (2.0ms)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
-Completed in 186ms (View: 152, DB: 2) | 200 OK [http://localhost/store]
-
-
-Processing ProductsController#index (for 127.0.0.1 at 2009-02-05 14:37:13) [GET]
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mProduct Load (0.3ms)\e[0m   \e[0;1mSELECT * FROM `products` \e[0m
-Rendering template within layouts/products
-Rendering products/index
-  \e[4;35;1mProduct Columns (2.5ms)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
-Completed in 274ms (View: 257, DB: 3) | 200 OK [http://localhost/products]
-
-
-Processing ProductsController#edit (for 127.0.0.1 at 2009-02-05 14:37:58) [GET]
-  Parameters: {"id"=>"3"}
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mProduct Columns (2.3ms)\e[0m   \e[0;1mSHOW FIELDS FROM `products`\e[0m
-  \e[4;35;1mProduct Load (0.6ms)\e[0m   \e[0mSELECT * FROM `products` WHERE (`products`.`id` = 3) \e[0m
-Rendering template within layouts/products
-Rendering products/edit
-Completed in 58ms (View: 39, DB: 3) | 200 OK [http://localhost/products/3/edit]
-
-
-Processing ProductsController#update (for 127.0.0.1 at 2009-02-05 14:38:05) [PUT]
-  Parameters: {"commit"=>"Update", "authenticity_token"=>"e5d513dc6072444247eccfd6ee064972eb3383d9", "product"=>{"image_url"=>"/images/cardboard-box.jpg", "price"=>"10.05", "title"=>"Cardboard Box", "date_available(1i)"=>"2007", "date_available(2i)"=>"1", "description"=>"<p>The gift that keeps on giving, you'll wonder how you ever did \r\n            without a cardboard box in your home.  Us it for a range of uses, \r\n            including putting things in and keeping things in.  We can provide\r\n            you with a cardboard box that is versatile and suitable for any\r\n            occasion.  Some of our directors even use them for sleeping in!\r\n          </p>\r\n        ", "date_available(3i)"=>"1"}, "id"=>"3"}
-  \e[4;36;1mSQL (0.7ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.2ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mProduct Columns (2.1ms)\e[0m   \e[0;1mSHOW FIELDS FROM `products`\e[0m
-  \e[4;35;1mProduct Load (0.4ms)\e[0m   \e[0mSELECT * FROM `products` WHERE (`products`.`id` = 3) \e[0m
-  \e[4;36;1mSQL (0.2ms)\e[0m   \e[0;1mBEGIN\e[0m
-  \e[4;35;1mProduct Exists (60.0ms)\e[0m   \e[0mSELECT `products`.id FROM `products` WHERE (`products`.`title` = BINARY 'Cardboard Box' AND `products`.id <> 3) LIMIT 1\e[0m
-  \e[4;36;1mProduct Update (33.7ms)\e[0m   \e[0;1mUPDATE `products` SET `price` = 10.05, `description` = '<p>The gift that keeps on giving, you\'ll wonder how you ever did \r\n without a cardboard box in your home. Us it for a range of uses, \r\n including putting things in and keeping things in. We can provide\r\n you with a cardboard box that is versatile and suitable for any\r\n occasion. Some of our directors even use them for sleeping in!\r\n </p>\r\n ', `updated_at` = '2009-02-05 14:38:05' WHERE `id` = 3\e[0m
-  \e[4;35;1mSQL (55.2ms)\e[0m   \e[0mCOMMIT\e[0m
-Redirected to #<Product:0xb72486ac>
-Completed in 196ms (DB: 153) | 302 Found [http://localhost/products/3]
-
-
-Processing ProductsController#show (for 127.0.0.1 at 2009-02-05 14:38:05) [GET]
-  Parameters: {"id"=>"3"}
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mProduct Columns (1.2ms)\e[0m   \e[0;1mSHOW FIELDS FROM `products`\e[0m
-  \e[4;35;1mProduct Load (0.4ms)\e[0m   \e[0mSELECT * FROM `products` WHERE (`products`.`id` = 3) \e[0m
-Rendering template within layouts/products
-Rendering products/show
-Completed in 46ms (View: 29, DB: 2) | 200 OK [http://localhost/products/3]
-
-
-Processing ProductsController#index (for 127.0.0.1 at 2009-02-05 14:38:09) [GET]
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mProduct Load (0.4ms)\e[0m   \e[0;1mSELECT * FROM `products` \e[0m
-Rendering template within layouts/products
-Rendering products/index
-  \e[4;35;1mProduct Columns (1.1ms)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
-Completed in 51ms (View: 37, DB: 2) | 200 OK [http://localhost/products]
-
-
-Processing StoreController#index (for 127.0.0.1 at 2009-02-05 14:38:12) [GET]
-  \e[4;36;1mSQL (0.2ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.2ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mProduct Load (0.5ms)\e[0m   \e[0;1mSELECT * FROM `products` WHERE (date_available <= now()) ORDER BY title\e[0m
-Rendering template within layouts/store
-Rendering store/index
-  \e[4;35;1mProduct Columns (1.1ms)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
-Completed in 44ms (View: 32, DB: 1) | 200 OK [http://localhost/store]
-
-
-Processing StoreController#index (for 127.0.0.1 at 2009-02-05 14:40:38) [GET]
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mProduct Load (0.6ms)\e[0m   \e[0;1mSELECT * FROM `products` WHERE (date_available <= now()) ORDER BY title\e[0m
-Rendering template within layouts/store
-Rendering store/index
-  \e[4;35;1mProduct Columns (1.1ms)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
-Completed in 49ms (View: 33, DB: 1) | 200 OK [http://localhost/store]
-
-
-Processing StoreController#index (for 127.0.0.1 at 2009-02-05 14:40:53) [GET]
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mProduct Load (0.5ms)\e[0m   \e[0;1mSELECT * FROM `products` WHERE (date_available <= now()) ORDER BY title\e[0m
-Rendering template within layouts/store
-Rendering store/index
-  \e[4;35;1mProduct Columns (1.3ms)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
-Completed in 41ms (View: 29, DB: 1) | 200 OK [http://localhost/store]
-
-
-Processing StoreController#index (for 127.0.0.1 at 2009-02-05 14:41:43) [GET]
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mProduct Load (0.8ms)\e[0m   \e[0;1mSELECT * FROM `products` WHERE (date_available <= now()) ORDER BY title\e[0m
-Rendering template within layouts/store
-Rendering store/index
-  \e[4;35;1mProduct Columns (1.1ms)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
-Completed in 142ms (View: 29, DB: 1) | 200 OK [http://localhost/store]
-
-
-Processing StoreController#index (for 127.0.0.1 at 2009-02-05 14:41:59) [GET]
-  \e[4;36;1mSQL (0.1ms)\e[0m   \e[0;1mSET NAMES 'utf8'\e[0m
-  \e[4;35;1mSQL (0.1ms)\e[0m   \e[0mSET SQL_AUTO_IS_NULL=0\e[0m
-  \e[4;36;1mProduct Load (1.0ms)\e[0m   \e[0;1mSELECT * FROM `products` WHERE (date_available <= now()) ORDER BY title\e[0m
-Rendering template within layouts/store
-Rendering store/index
-  \e[4;35;1mProduct Columns (2.5ms)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
-Completed in 44ms (View: 30, DB: 1) | 200 OK [http://localhost/store]
diff --git a/log/production.log b/log/production.log
deleted file mode 100644 (file)
index e69de29..0000000
diff --git a/log/server.log b/log/server.log
deleted file mode 100644 (file)
index e69de29..0000000
diff --git a/log/test.log b/log/test.log
deleted file mode 100644 (file)
index e69de29..0000000