log/development.log

   1
   2
   3 Processing ProductsController#index (for 127.0.0.1 at 2008-07-24 08:54:29) [GET]
   4   Session ID: 516264dbb9a2fb7792ea3375d071afc7
   5   Parameters: {"action"=>"index", "controller"=>"products"}
   6   \e[4;36;1mSQL (0.000156)\e[0m   \e[0;1mSET SQL_AUTO_IS_NULL=0\e[0m
   7   \e[4;35;1mProduct Load (0.000000)\e[0m   \e[0mMysql::Error: Table 'depot_development.products' doesn't exist: SELECT * FROM `products` \e[0m
   8
   9
  10 ActiveRecord::StatementInvalid (Mysql::Error: Table 'depot_development.products' doesn't exist: SELECT * FROM `products`     ):
  11     /usr/lib/ruby/gems/1.8/gems/activerecord-2.1.0/lib/active_record/connection_adapters/abstract_adapter.rb:147:in `log'
  12     /usr/lib/ruby/gems/1.8/gems/activerecord-2.1.0/lib/active_record/connection_adapters/mysql_adapter.rb:299:in `execute'
  13     /usr/lib/ruby/gems/1.8/gems/activerecord-2.1.0/lib/active_record/connection_adapters/mysql_adapter.rb:515:in `select'
  14     /usr/lib/ruby/gems/1.8/gems/activerecord-2.1.0/lib/active_record/connection_adapters/abstract/database_statements.rb:7:in `select_all_without_query_cache'
  15     /usr/lib/ruby/gems/1.8/gems/activerecord-2.1.0/lib/active_record/connection_adapters/abstract/query_cache.rb:59:in `select_all'
  16     /usr/lib/ruby/gems/1.8/gems/activerecord-2.1.0/lib/active_record/connection_adapters/abstract/query_cache.rb:80:in `cache_sql'
  17     /usr/lib/ruby/gems/1.8/gems/activerecord-2.1.0/lib/active_record/connection_adapters/abstract/query_cache.rb:59:in `select_all'
  18     /usr/lib/ruby/gems/1.8/gems/activerecord-2.1.0/lib/active_record/base.rb:582:in `find_by_sql'
  19     /usr/lib/ruby/gems/1.8/gems/activerecord-2.1.0/lib/active_record/base.rb:1341:in `find_every'
  20     /usr/lib/ruby/gems/1.8/gems/activerecord-2.1.0/lib/active_record/base.rb:536:in `find'
  21     /app/controllers/products_controller.rb:5:in `index'
  22     /usr/lib/ruby/gems/1.8/gems/actionpack-2.1.0/lib/action_controller/base.rb:1162:in `send'
  23     /usr/lib/ruby/gems/1.8/gems/actionpack-2.1.0/lib/action_controller/base.rb:1162:in `perform_action_without_filters'
  24     /usr/lib/ruby/gems/1.8/gems/actionpack-2.1.0/lib/action_controller/filters.rb:580:in `call_filters'
  25     /usr/lib/ruby/gems/1.8/gems/actionpack-2.1.0/lib/action_controller/filters.rb:573:in `perform_action_without_benchmark'
  26     /usr/lib/ruby/gems/1.8/gems/actionpack-2.1.0/lib/action_controller/benchmarking.rb:68:in `perform_action_without_rescue'
  27     /usr/lib/ruby/1.8/benchmark.rb:293:in `measure'
  28     /usr/lib/ruby/gems/1.8/gems/actionpack-2.1.0/lib/action_controller/benchmarking.rb:68:in `perform_action_without_rescue'
  29     /usr/lib/ruby/gems/1.8/gems/actionpack-2.1.0/lib/action_controller/rescue.rb:201:in `perform_action_without_caching'
  30     /usr/lib/ruby/gems/1.8/gems/actionpack-2.1.0/lib/action_controller/caching/sql_cache.rb:13:in `perform_action'
  31     /usr/lib/ruby/gems/1.8/gems/activerecord-2.1.0/lib/active_record/connection_adapters/abstract/query_cache.rb:33:in `cache'
  32     /usr/lib/ruby/gems/1.8/gems/activerecord-2.1.0/lib/active_record/query_cache.rb:8:in `cache'
  33     /usr/lib/ruby/gems/1.8/gems/actionpack-2.1.0/lib/action_controller/caching/sql_cache.rb:12:in `perform_action'
  34     /usr/lib/ruby/gems/1.8/gems/actionpack-2.1.0/lib/action_controller/base.rb:529:in `send'
  35     /usr/lib/ruby/gems/1.8/gems/actionpack-2.1.0/lib/action_controller/base.rb:529:in `process_without_filters'
  36     /usr/lib/ruby/gems/1.8/gems/actionpack-2.1.0/lib/action_controller/filters.rb:569:in `process_without_session_management_support'
  37     /usr/lib/ruby/gems/1.8/gems/actionpack-2.1.0/lib/action_controller/session_management.rb:130:in `process'
  38     /usr/lib/ruby/gems/1.8/gems/actionpack-2.1.0/lib/action_controller/base.rb:389:in `process'
  39     /usr/lib/ruby/gems/1.8/gems/actionpack-2.1.0/lib/action_controller/dispatcher.rb:149:in `handle_request'
  40     /usr/lib/ruby/gems/1.8/gems/actionpack-2.1.0/lib/action_controller/dispatcher.rb:107:in `dispatch'
  41     /usr/lib/ruby/gems/1.8/gems/actionpack-2.1.0/lib/action_controller/dispatcher.rb:104:in `synchronize'
  42     /usr/lib/ruby/gems/1.8/gems/actionpack-2.1.0/lib/action_controller/dispatcher.rb:104:in `dispatch'
  43     /usr/lib/ruby/gems/1.8/gems/actionpack-2.1.0/lib/action_controller/dispatcher.rb:120:in `dispatch_cgi'
  44     /usr/lib/ruby/gems/1.8/gems/actionpack-2.1.0/lib/action_controller/dispatcher.rb:35:in `dispatch'
  45     /usr/lib/ruby/gems/1.8/gems/rails-2.1.0/lib/webrick_server.rb:112:in `handle_dispatch'
  46     /usr/lib/ruby/gems/1.8/gems/rails-2.1.0/lib/webrick_server.rb:78:in `service'
  47     /usr/lib/ruby/1.8/webrick/httpserver.rb:104:in `service'
  48     /usr/lib/ruby/1.8/webrick/httpserver.rb:65:in `run'
  49     /usr/lib/ruby/1.8/webrick/server.rb:173:in `start_thread'
  50     /usr/lib/ruby/1.8/webrick/server.rb:162:in `start'
  51     /usr/lib/ruby/1.8/webrick/server.rb:162:in `start_thread'
  52     /usr/lib/ruby/1.8/webrick/server.rb:95:in `start'
  53     /usr/lib/ruby/1.8/webrick/server.rb:92:in `each'
  54     /usr/lib/ruby/1.8/webrick/server.rb:92:in `start'
  55     /usr/lib/ruby/1.8/webrick/server.rb:23:in `start'
  56     /usr/lib/ruby/1.8/webrick/server.rb:82:in `start'
  57     /usr/lib/ruby/gems/1.8/gems/rails-2.1.0/lib/webrick_server.rb:62:in `dispatch'
  58     /usr/lib/ruby/gems/1.8/gems/rails-2.1.0/lib/commands/servers/webrick.rb:66
  59     /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:27:in `gem_original_require'
  60     /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:27:in `require'
  61     /usr/lib/ruby/gems/1.8/gems/activesupport-2.1.0/lib/active_support/dependencies.rb:509:in `require'
  62     /usr/lib/ruby/gems/1.8/gems/activesupport-2.1.0/lib/active_support/dependencies.rb:354:in `new_constants_in'
  63     /usr/lib/ruby/gems/1.8/gems/activesupport-2.1.0/lib/active_support/dependencies.rb:509:in `require'
  64     /usr/lib/ruby/gems/1.8/gems/rails-2.1.0/lib/commands/server.rb:39
  65     /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:27:in `gem_original_require'
  66     /usr/local/lib/site_ruby/1.8/rubygems/custom_require.rb:27:in `require'
  67     script/server:3
  68
  69 Rendering /usr/lib/ruby/gems/1.8/gems/actionpack-2.1.0/lib/action_controller/templates/rescues/layout.erb (internal_server_error)
  70   \e[4;36;1mSQL (0.000168)\e[0m   \e[0;1mSET SQL_AUTO_IS_NULL=0\e[0m
  71   \e[4;35;1mSQL (0.000306)\e[0m   \e[0mSHOW TABLES\e[0m
  72   \e[4;36;1mSQL (0.043538)\e[0m   \e[0;1mCREATE TABLE `schema_migrations` (`version` varchar(255) NOT NULL) ENGINE=InnoDB\e[0m
  73   \e[4;35;1mSQL (0.004163)\e[0m   \e[0mCREATE UNIQUE INDEX `unique_schema_migrations` ON `schema_migrations` (`version`)\e[0m
  74   \e[4;36;1mSQL (0.000244)\e[0m   \e[0;1mSHOW TABLES\e[0m
  75   \e[4;35;1mSQL (0.000338)\e[0m   \e[0mSELECT version FROM schema_migrations\e[0m
  76 Migrating to CreateProducts (20080724075409)
  77   \e[4;36;1mSQL (0.000068)\e[0m   \e[0;1mSELECT version FROM schema_migrations\e[0m
  78   \e[4;35;1mSQL (0.002555)\e[0m   \e[0mCREATE TABLE `products` (`id` int(11) DEFAULT NULL auto_increment PRIMARY KEY, `title` varchar(255) DEFAULT NULL NULL, `description` text DEFAULT NULL NULL, `image_url` varchar(255) DEFAULT NULL NULL, `created_at` datetime DEFAULT NULL NULL, `updated_at` datetime DEFAULT NULL NULL) ENGINE=InnoDB\e[0m
  79   \e[4;36;1mSQL (0.000787)\e[0m   \e[0;1mINSERT INTO schema_migrations (version) VALUES ('20080724075409')\e[0m
  80   \e[4;35;1mSQL (0.000238)\e[0m   \e[0mSELECT version FROM schema_migrations\e[0m
  81   \e[4;36;1mSQL (0.000215)\e[0m   \e[0;1mSHOW TABLES\e[0m
  82   \e[4;35;1mSQL (0.000852)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
  83   \e[4;36;1mSQL (0.000711)\e[0m   \e[0;1mdescribe `products`\e[0m
  84   \e[4;35;1mSQL (0.000320)\e[0m   \e[0mSHOW KEYS FROM `products`\e[0m
  85
  86
  87 Processing ProductsController#index (for 127.0.0.1 at 2008-07-24 08:54:57) [GET]
  88   Session ID: BAh7BiIKZmxhc2hJQzonQWN0aW9uQ29udHJvbGxlcjo6Rmxhc2g6OkZsYXNo
  89 SGFzaHsABjoKQHVzZWR7AA==--9a7a4cb8d57b822aeb31c468bcb62a33430f150b
  90   Parameters: {"action"=>"index", "controller"=>"products"}
  91   \e[4;36;1mProduct Load (0.000316)\e[0m   \e[0;1mSELECT * FROM `products` \e[0m
  92 Rendering template within layouts/products
  93 Rendering products/index
  94 Completed in 0.01792 (55 reqs/sec) | Rendering: 0.00568 (31%) | DB: 0.00047 (2%) | 200 OK [http://localhost/products]
  95
  96
  97 Processing ProductsController#new (for 127.0.0.1 at 2008-07-24 08:55:01) [GET]
  98   Session ID: BAh7BiIKZmxhc2hJQzonQWN0aW9uQ29udHJvbGxlcjo6Rmxhc2g6OkZsYXNo
  99 SGFzaHsABjoKQHVzZWR7AA==--9a7a4cb8d57b822aeb31c468bcb62a33430f150b
 100   Parameters: {"action"=>"new", "controller"=>"products"}
 101   \e[4;35;1mProduct Columns (0.000866)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
 102 Rendering template within layouts/products
 103 Rendering products/new
 104 Completed in 0.02357 (42 reqs/sec) | Rendering: 0.01115 (47%) | DB: 0.00087 (3%) | 200 OK [http://localhost/products/new]
 105
 106
 107 Processing ProductsController#create (for 127.0.0.1 at 2008-07-24 08:55:07) [POST]
 108   Session ID: BAh7BzoMY3NyZl9pZCIlOWM2MWUxN2RiODdmNDI2MTQxNjIwODM5ZmY2Yzdj
 109 OWIiCmZsYXNoSUM6J0FjdGlvbkNvbnRyb2xsZXI6OkZsYXNoOjpGbGFzaEhh
 110 c2h7AAY6CkB1c2VkewA=--be2cb095a3a64313ddeabee8ee4f7ac896aae350
 111   Parameters: {"commit"=>"Create", "product"=>{"image_url"=>"lkj l;j", "title"=>"lkj ", "description"=>"l;kj lk;j l;kj lj"}, "authenticity_token"=>"466a8d52a74d0603850d0b0d709e5f2c5e3ce774", "action"=>"create", "controller"=>"products"}
 112   \e[4;36;1mProduct Columns (0.000988)\e[0m   \e[0;1mSHOW FIELDS FROM `products`\e[0m
 113   \e[4;35;1mSQL (0.000084)\e[0m   \e[0mBEGIN\e[0m
 114   \e[4;36;1mProduct Create (0.000799)\e[0m   \e[0;1mINSERT INTO `products` (`image_url`, `updated_at`, `title`, `description`, `created_at`) VALUES('lkj l;j', '2008-07-24 07:55:07', 'lkj ', 'l;kj lk;j l;kj lj', '2008-07-24 07:55:07')\e[0m
 115   \e[4;35;1mSQL (0.002049)\e[0m   \e[0mCOMMIT\e[0m
 116 Redirected to http://localhost:3000/products/1
 117 Completed in 0.02044 (48 reqs/sec) | DB: 0.00392 (19%) | 302 Found [http://localhost/products]
 118
 119
 120 Processing ProductsController#show (for 127.0.0.1 at 2008-07-24 08:55:07) [GET]
 121   Session ID: BAh7BzoMY3NyZl9pZCIlOWM2MWUxN2RiODdmNDI2MTQxNjIwODM5ZmY2Yzdj
 122 OWIiCmZsYXNoSUM6J0FjdGlvbkNvbnRyb2xsZXI6OkZsYXNoOjpGbGFzaEhh
 123 c2h7BjoLbm90aWNlIiZQcm9kdWN0IHdhcyBzdWNjZXNzZnVsbHkgY3JlYXRl
 124 ZC4GOgpAdXNlZHsGOwdG--f2c2ee2eb4620b461f69f905e5860ebe7060c7f2
 125   Parameters: {"action"=>"show", "id"=>"1", "controller"=>"products"}
 126   \e[4;36;1mProduct Columns (0.001114)\e[0m   \e[0;1mSHOW FIELDS FROM `products`\e[0m
 127   \e[4;35;1mProduct Load (0.000544)\e[0m   \e[0mSELECT * FROM `products` WHERE (`products`.`id` = 1) \e[0m
 128 Rendering template within layouts/products
 129 Rendering products/show
 130 Completed in 0.02537 (39 reqs/sec) | Rendering: 0.00662 (26%) | DB: 0.00166 (6%) | 200 OK [http://localhost/products/1]
 131
 132
 133 Processing ProductsController#index (for 127.0.0.1 at 2008-07-24 08:55:09) [GET]
 134   Session ID: BAh7BzoMY3NyZl9pZCIlOWM2MWUxN2RiODdmNDI2MTQxNjIwODM5ZmY2Yzdj
 135 OWIiCmZsYXNoSUM6J0FjdGlvbkNvbnRyb2xsZXI6OkZsYXNoOjpGbGFzaEhh
 136 c2h7BjoLbm90aWNlIiZQcm9kdWN0IHdhcyBzdWNjZXNzZnVsbHkgY3JlYXRl
 137 ZC4GOgpAdXNlZHsGOwdU--e278ebd0c668af234fdcc2a973394c40ab1571fd
 138   Parameters: {"action"=>"index", "controller"=>"products"}
 139   \e[4;36;1mProduct Load (0.000324)\e[0m   \e[0;1mSELECT * FROM `products` \e[0m
 140 Rendering template within layouts/products
 141 Rendering products/index
 142   \e[4;35;1mProduct Columns (0.003374)\e[0m   \e[0mSHOW FIELDS FROM `products`\e[0m
 143 Completed in 0.02020 (49 reqs/sec) | Rendering: 0.00515 (25%) | DB: 0.00370 (18%) | 200 OK [http://localhost/products]