

Processing InfoController#who_bought (for 127.0.0.1 at 2007-02-18 23:49:54) [GET]
  Session ID: 845a03fc834f689e743eaa7ba22d8c4a
  Parameters: {"action"=>"who_bought", "id"=>"1", "controller"=>"info"}
  [4;36;1mProduct Columns (0.251000)[0m   [0;1mSHOW FIELDS FROM products[0m
  [4;35;1mProduct Load (0.010000)[0m   [0mSELECT * FROM products WHERE (products.id = 1) [0m


ActiveRecord::RecordNotFound (Couldn't find Product with ID=1):
    G:/usr/bin/ruby/lib/ruby/gems/1.8/gems/activerecord-1.15.1/lib/active_record/base.rb:1028:in `find_one'
    G:/usr/bin/ruby/lib/ruby/gems/1.8/gems/activerecord-1.15.1/lib/active_record/base.rb:1011:in `find_from_ids'
    G:/usr/bin/ruby/lib/ruby/gems/1.8/gems/activerecord-1.15.1/lib/active_record/base.rb:416:in `find'
    /app/controllers/info_controller.rb:4:in `who_bought'
    G:/usr/bin/ruby/lib/ruby/gems/1.8/gems/actionpack-1.13.1/lib/action_controller/base.rb:1095:in `perform_action_without_filters'
    G:/usr/bin/ruby/lib/ruby/gems/1.8/gems/actionpack-1.13.1/lib/action_controller/filters.rb:632:in `call_filter'
    G:/usr/bin/ruby/lib/ruby/gems/1.8/gems/actionpack-1.13.1/lib/action_controller/filters.rb:619:in `perform_action_without_benchmark'
    G:/usr/bin/ruby/lib/ruby/gems/1.8/gems/actionpack-1.13.1/lib/action_controller/benchmarking.rb:66:in `perform_action_without_rescue'
    G:/usr/bin/ruby/lib/ruby/1.8/benchmark.rb:293:in `measure'
    G:/usr/bin/ruby/lib/ruby/gems/1.8/gems/actionpack-1.13.1/lib/action_controller/benchmarking.rb:66:in `perform_action_without_rescue'
    G:/usr/bin/ruby/lib/ruby/gems/1.8/gems/actionpack-1.13.1/lib/action_controller/rescue.rb:83:in `perform_action'
    G:/usr/bin/ruby/lib/ruby/gems/1.8/gems/actionpack-1.13.1/lib/action_controller/base.rb:430:in `process_without_filters'
    G:/usr/bin/ruby/lib/ruby/gems/1.8/gems/actionpack-1.13.1/lib/action_controller/filters.rb:624:in `process_without_session_management_support'
    G:/usr/bin/ruby/lib/ruby/gems/1.8/gems/actionpack-1.13.1/lib/action_controller/session_management.rb:114:in `process'
    G:/usr/bin/ruby/lib/ruby/gems/1.8/gems/actionpack-1.13.1/lib/action_controller/base.rb:330:in `process'
    G:/usr/bin/ruby/lib/ruby/gems/1.8/gems/rails-1.2.1/lib/dispatcher.rb:41:in `dispatch'
    G:/usr/bin/ruby/lib/ruby/gems/1.8/gems/rails-1.2.1/lib/webrick_server.rb:113:in `handle_dispatch'
    G:/usr/bin/ruby/lib/ruby/gems/1.8/gems/rails-1.2.1/lib/webrick_server.rb:79:in `service'
    G:/usr/bin/ruby/lib/ruby/1.8/webrick/httpserver.rb:104:in `service'
    G:/usr/bin/ruby/lib/ruby/1.8/webrick/httpserver.rb:65:in `run'
    G:/usr/bin/ruby/lib/ruby/1.8/webrick/server.rb:173:in `start_thread'
    G:/usr/bin/ruby/lib/ruby/1.8/webrick/server.rb:162:in `start_thread'
    G:/usr/bin/ruby/lib/ruby/1.8/webrick/server.rb:95:in `start'
    G:/usr/bin/ruby/lib/ruby/1.8/webrick/server.rb:92:in `start'
    G:/usr/bin/ruby/lib/ruby/1.8/webrick/server.rb:23:in `start'
    G:/usr/bin/ruby/lib/ruby/1.8/webrick/server.rb:82:in `start'
    G:/usr/bin/ruby/lib/ruby/gems/1.8/gems/rails-1.2.1/lib/webrick_server.rb:63:in `dispatch'
    G:/usr/bin/ruby/lib/ruby/gems/1.8/gems/rails-1.2.1/lib/commands/servers/webrick.rb:59
    G:/usr/bin/ruby/lib/ruby/site_ruby/1.8/rubygems/custom_require.rb:27:in `require'
    G:/usr/bin/ruby/lib/ruby/gems/1.8/gems/activesupport-1.4.0/lib/active_support/dependencies.rb:496:in `require'
    G:/usr/bin/ruby/lib/ruby/gems/1.8/gems/activesupport-1.4.0/lib/active_support/dependencies.rb:343:in `new_constants_in'
    G:/usr/bin/ruby/lib/ruby/gems/1.8/gems/activesupport-1.4.0/lib/active_support/dependencies.rb:496:in `require'
    G:/usr/bin/ruby/lib/ruby/gems/1.8/gems/rails-1.2.1/lib/commands/server.rb:39
    G:/usr/bin/ruby/lib/ruby/site_ruby/1.8/rubygems/custom_require.rb:27:in `require'
    G:/usr/bin/ruby/lib/ruby/gems/1.8/gems/activesupport-1.4.0/lib/active_support/dependencies.rb:496:in `require'
    G:/usr/bin/ruby/lib/ruby/gems/1.8/gems/activesupport-1.4.0/lib/active_support/dependencies.rb:343:in `new_constants_in'
    G:/usr/bin/ruby/lib/ruby/gems/1.8/gems/activesupport-1.4.0/lib/active_support/dependencies.rb:496:in `require'
    script/server:3


Rendering G:/usr/bin/ruby/lib/ruby/gems/1.8/gems/actionpack-1.13.1/lib/action_controller/templates/rescues/layout.rhtml (500 Internal Error)


Processing StoreController#index (for 127.0.0.1 at 2007-02-18 23:50:20) [GET]
  Session ID: 845a03fc834f689e743eaa7ba22d8c4a
  Parameters: {"action"=>"index", "controller"=>"store"}
  [4;36;1mProduct Load (0.020000)[0m   [0;1mSELECT * FROM products ORDER BY title[0m
Rendering  within layouts/store
Rendering store/index
  [4;35;1mProduct Columns (0.020000)[0m   [0mSHOW FIELDS FROM products[0m
Rendered store/_cart (0.00000)
Completed in 0.13000 (7 reqs/sec) | Rendering: 0.06000 (46%) | DB: 0.30100 (231%) | 200 OK [http://localhost/store]
  [4;36;1mSQL (0.120000)[0m   [0;1mCREATE TABLE schema_info (version int(11))[0m
  [4;35;1mSQL (0.030000)[0m   [0mINSERT INTO schema_info (version) VALUES(0)[0m
  [4;36;1mSQL (0.000000)[0m   [0;1mMysql::Error: Table 'schema_info' already exists: CREATE TABLE schema_info (version int(11))[0m
  [4;35;1mSQL (0.000000)[0m   [0mSELECT version FROM schema_info[0m
Migrating to CreateProducts (1)
  [4;36;1mSQL (0.070000)[0m   [0;1mCREATE TABLE products (`id` int(11) DEFAULT NULL auto_increment PRIMARY KEY, `title` varchar(255) DEFAULT NULL, `description` text DEFAULT NULL, `image_url` varchar(255) DEFAULT NULL) ENGINE=InnoDB[0m
  [4;35;1mSQL (0.020000)[0m   [0mUPDATE schema_info SET version = 1[0m
  [4;36;1mSQL (0.000000)[0m   [0;1mSELECT version FROM schema_info[0m
Migrating to AddPrice (2)
  [4;35;1mSQL (0.160000)[0m   [0mALTER TABLE products ADD `price` decimal(8,2) DEFAULT 0[0m
  [4;36;1mSQL (0.010000)[0m   [0;1mUPDATE schema_info SET version = 2[0m
  [4;35;1mSQL (0.000000)[0m   [0mSELECT version FROM schema_info[0m
Migrating to AddTestData (3)
  [4;36;1mProduct Columns (0.000000)[0m   [0;1mSHOW FIELDS FROM products[0m
  [4;35;1mSQL (0.000000)[0m   [0mBEGIN[0m
  [4;36;1mProduct Load (0.000000)[0m   [0;1mSELECT * FROM products WHERE (products.title = 'Programowanie w języku Ruby') LIMIT 1[0m
  [4;35;1mSQL (0.000000)[0m   [0mINSERT INTO products (`image_url`, `price`, `title`, `description`) VALUES('/images/prruby.jpg', '99.0', 'Programowanie w języku Ruby', '<p>\n Książka <em>Programowanie w języku Ruby</em> to jeden z\n najpopularniejszych na świecie podręczników opisujących ten\n język. Czytając ją, opanujesz wszystkie zagadnienia związane z\n tworzeniem aplikacji w Rubym. Poznasz zasady programowania obiektowego,\n korzystania z wyrażeń regularnych, obsługi wyjątków oraz pracy\n wielowątkowej.\n </p>')[0m
  [4;36;1mSQL (0.010000)[0m   [0;1mCOMMIT[0m
  [4;35;1mSQL (0.000000)[0m   [0mBEGIN[0m
  [4;36;1mProduct Load (0.000000)[0m   [0;1mSELECT * FROM products WHERE (products.title = 'Ruby on Rails. Wprowadzenie') LIMIT 1[0m
  [4;35;1mSQL (0.000000)[0m   [0mINSERT INTO products (`image_url`, `price`, `title`, `description`) VALUES('/images/rubywp.jpg', '29.0', 'Ruby on Rails. Wprowadzenie', '<p>\n <em>Ruby on Rails. Wprowadzenie</em> to podręcznik, dzięki któremu\n zdobędziesz wiedzę niezbędną do tego, aby szybko budować wydajne\n aplikacje w technologii Ruby on Rails. Omówiono w nim wszystkie elementy\n tworzenia oprogramowania internetowego — połączenia z bazami danych,\n szkielet aplikacji, interfejsy użytkownika oraz testowanie.\n </p>')[0m
  [4;36;1mSQL (0.020000)[0m   [0;1mCOMMIT[0m
  [4;35;1mSQL (0.000000)[0m   [0mBEGIN[0m
  [4;36;1mProduct Load (0.000000)[0m   [0;1mSELECT * FROM products WHERE (products.title = 'Ruby on Rails. Ćwiczenia') LIMIT 1[0m
  [4;35;1mSQL (0.000000)[0m   [0mINSERT INTO products (`image_url`, `price`, `title`, `description`) VALUES('/images/cruby.jpg', '19.0', 'Ruby on Rails. Ćwiczenia', '<p>\n Dzięki książce <em>Ruby on Rails. Ćwiczenia</em> opanujesz podstawy tworzenia\n aplikacji internetowych za pomocą tej technologii. Nauczysz się\n programować w języku Ruby: poznasz jego elementy i zasady projektowania\n obiektowego, metody przetwarzania danych tekstowych, pracy z plikami i\n katalogami oraz obsługi błędów i wyjątków.\n </p>')[0m
  [4;36;1mSQL (0.021000)[0m   [0;1mCOMMIT[0m
  [4;35;1mSQL (0.020000)[0m   [0mUPDATE schema_info SET version = 3[0m
  [4;36;1mSQL (0.000000)[0m   [0;1mSELECT version FROM schema_info[0m
Migrating to AddSessions (4)
  [4;35;1mSQL (0.070000)[0m   [0mCREATE TABLE sessions (`id` int(11) DEFAULT NULL auto_increment PRIMARY KEY, `session_id` varchar(255) DEFAULT NULL, `data` text DEFAULT NULL, `updated_at` datetime DEFAULT NULL) ENGINE=InnoDB[0m
  [4;36;1mSQL (0.130000)[0m   [0;1mCREATE INDEX `index_sessions_on_session_id` ON sessions (`session_id`)[0m
  [4;35;1mSQL (0.140000)[0m   [0mCREATE INDEX `index_sessions_on_updated_at` ON sessions (`updated_at`)[0m
  [4;36;1mSQL (0.010000)[0m   [0;1mUPDATE schema_info SET version = 4[0m
  [4;35;1mSQL (0.000000)[0m   [0mSELECT version FROM schema_info[0m
Migrating to CreateOrders (5)
  [4;36;1mSQL (0.070000)[0m   [0;1mCREATE TABLE orders (`id` int(11) DEFAULT NULL auto_increment PRIMARY KEY, `name` varchar(255) DEFAULT NULL, `address` text DEFAULT NULL, `email` varchar(255) DEFAULT NULL, `pay_type` varchar(10) DEFAULT NULL) ENGINE=InnoDB[0m
  [4;35;1mSQL (0.020000)[0m   [0mUPDATE schema_info SET version = 5[0m
  [4;36;1mSQL (0.000000)[0m   [0;1mSELECT version FROM schema_info[0m
Migrating to CreateLineItems (6)
  [4;35;1mSQL (0.060000)[0m   [0mCREATE TABLE line_items (`id` int(11) DEFAULT NULL auto_increment PRIMARY KEY, `product_id` int(11) NOT NULL, `order_id` int(11) NOT NULL, `quantity` int(11) NOT NULL, `total_price` decimal(8,2) NOT NULL) ENGINE=InnoDB[0m
  [4;36;1mSQL (0.161000)[0m   [0;1malter table line_items add constraint fk_line_item_products
 foreign key (product_id) references products(id)[0m
  [4;35;1mSQL (0.150000)[0m   [0malter table line_items add constraint fk_line_item_orders
 foreign key (order_id) references orders(id)[0m
  [4;36;1mSQL (0.010000)[0m   [0;1mUPDATE schema_info SET version = 6[0m
  [4;35;1mSQL (0.000000)[0m   [0mSELECT version FROM schema_info[0m
Migrating to CreateUsers (7)
  [4;36;1mSQL (0.060000)[0m   [0;1mCREATE TABLE users (`id` int(11) DEFAULT NULL auto_increment PRIMARY KEY, `name` varchar(255) DEFAULT NULL, `hashed_password` varchar(255) DEFAULT NULL, `salt` varchar(255) DEFAULT NULL) ENGINE=InnoDB[0m
  [4;35;1mSQL (0.020000)[0m   [0mUPDATE schema_info SET version = 7[0m
  [4;36;1mSQL (0.010000)[0m   [0;1mSELECT * FROM schema_info[0m
  [4;35;1mSQL (0.000000)[0m   [0mSHOW TABLES[0m
  [4;36;1mSQL (0.010000)[0m   [0;1mSHOW FIELDS FROM line_items[0m
  [4;35;1mSQL (0.000000)[0m   [0mSHOW KEYS FROM line_items[0m
  [4;36;1mSQL (0.010000)[0m   [0;1mSHOW FIELDS FROM orders[0m
  [4;35;1mSQL (0.000000)[0m   [0mSHOW KEYS FROM orders[0m
  [4;36;1mSQL (0.000000)[0m   [0;1mSHOW FIELDS FROM products[0m
  [4;35;1mSQL (0.000000)[0m   [0mSHOW KEYS FROM products[0m
  [4;36;1mSQL (0.000000)[0m   [0;1mSHOW FIELDS FROM sessions[0m
  [4;35;1mSQL (0.000000)[0m   [0mSHOW KEYS FROM sessions[0m
  [4;36;1mSQL (0.010000)[0m   [0;1mSHOW FIELDS FROM users[0m
  [4;35;1mSQL (0.000000)[0m   [0mSHOW KEYS FROM users[0m


Processing StoreController#index (for 127.0.0.1 at 2007-02-18 23:56:17) [GET]
  Session ID: 90cf49bea3a57b4cff0db506cb25917e
  Parameters: {"action"=>"index", "controller"=>"store"}
  [4;36;1mProduct Load (0.000000)[0m   [0;1mSELECT * FROM products ORDER BY title[0m
Rendering  within layouts/store
Rendering store/index
  [4;35;1mProduct Columns (0.000000)[0m   [0mSHOW FIELDS FROM products[0m
Rendered store/_cart (0.00000)
Completed in 0.08000 (12 reqs/sec) | Rendering: 0.04000 (49%) | DB: 0.00000 (0%) | 200 OK [http://localhost/store]


Processing InfoController#who_bought (for 127.0.0.1 at 2007-02-18 23:56:22) [GET]
  Session ID: 90cf49bea3a57b4cff0db506cb25917e
  Parameters: {"action"=>"who_bought", "id"=>"1", "controller"=>"info"}
  [4;36;1mProduct Columns (0.000000)[0m   [0;1mSHOW FIELDS FROM products[0m
  [4;35;1mProduct Load (0.000000)[0m   [0mSELECT * FROM products WHERE (products.id = 1) [0m
Rendering info/who_bought
  [4;36;1mOrder Load (0.020000)[0m   [0;1mSELECT orders.* FROM orders INNER JOIN line_items ON orders.id = line_items.order_id WHERE ((line_items.product_id = 1)) [0m
Completed in 0.15000 (6 reqs/sec) | Rendering: 0.08000 (53%) | DB: 0.02000 (13%) | 200 OK [http://localhost/info/who_bought/1]


Processing StoreController#add_to_cart (for 127.0.0.1 at 2007-02-18 23:56:52) [POST]
  Session ID: 90cf49bea3a57b4cff0db506cb25917e
  Parameters: {"commit"=>"Dodaj do koszyka", "action"=>"add_to_cart", "id"=>"1", "controller"=>"store"}
  [4;35;1mProduct Columns (0.010000)[0m   [0mSHOW FIELDS FROM products[0m
  [4;36;1mProduct Load (0.000000)[0m   [0;1mSELECT * FROM products WHERE (products.id = 1) [0m
Rendering store/add_to_cart
Rendered store/_cart_item (0.02000)
Rendered store/_cart (0.03000)
Completed in 0.10000 (9 reqs/sec) | Rendering: 0.05000 (50%) | DB: 0.01000 (9%) | 200 OK [http://localhost/store/add_to_cart/1]


Processing StoreController#checkout (for 127.0.0.1 at 2007-02-18 23:56:58) [POST]
  Session ID: 90cf49bea3a57b4cff0db506cb25917e
  Parameters: {"action"=>"checkout", "controller"=>"store"}
  [4;35;1mOrder Columns (0.010000)[0m   [0mSHOW FIELDS FROM orders[0m
Rendering  within layouts/store
Rendering store/checkout
  [4;36;1mProduct Columns (0.000000)[0m   [0;1mSHOW FIELDS FROM products[0m
Rendered store/_cart_item (0.01000)
Rendered store/_cart (0.03000)
Completed in 0.24000 (4 reqs/sec) | Rendering: 0.20000 (83%) | DB: 0.01000 (4%) | 200 OK [http://localhost/store/checkout]


Processing StoreController#save_order (for 127.0.0.1 at 2007-02-18 23:58:09) [POST]
  Session ID: 90cf49bea3a57b4cff0db506cb25917e
  Parameters: {"commit"=>"Złóż zamówienie", "order"=>{"name"=>"Jan Kowalski", "pay_type"=>"check", "address"=>"Ul. Główna 123", "email"=>"klient@domena.pl"}, "action"=>"save_order", "controller"=>"store"}
  [4;35;1mOrder Columns (0.010000)[0m   [0mSHOW FIELDS FROM orders[0m
  [4;36;1mLineItem Columns (0.000000)[0m   [0;1mSHOW FIELDS FROM line_items[0m
  [4;35;1mProduct Columns (0.000000)[0m   [0mSHOW FIELDS FROM products[0m
  [4;36;1mSQL (0.000000)[0m   [0;1mBEGIN[0m
  [4;35;1mSQL (0.000000)[0m   [0mCOMMIT[0m
  [4;36;1mSQL (0.000000)[0m   [0;1mBEGIN[0m
  [4;35;1mSQL (0.000000)[0m   [0mINSERT INTO orders (`name`, `pay_type`, `address`, `email`) VALUES('Jan Kowalski', 'check', 'Ul. Główna 123', 'klient@domena.pl')[0m
  [4;36;1mSQL (0.000000)[0m   [0;1mINSERT INTO line_items (`order_id`, `total_price`, `product_id`, `quantity`) VALUES(1, '99.0', 1, 1)[0m
  [4;35;1mSQL (0.040000)[0m   [0mCOMMIT[0m
Redirected to http://localhost:3000/store
Completed in 0.15000 (6 reqs/sec) | DB: 0.05000 (33%) | 302 Found [http://localhost/store/save_order]


Processing StoreController#index (for 127.0.0.1 at 2007-02-18 23:58:10) [GET]
  Session ID: 90cf49bea3a57b4cff0db506cb25917e
  Parameters: {"action"=>"index", "controller"=>"store"}
  [4;36;1mProduct Load (0.000000)[0m   [0;1mSELECT * FROM products ORDER BY title[0m
Rendering  within layouts/store
Rendering store/index
  [4;35;1mProduct Columns (0.000000)[0m   [0mSHOW FIELDS FROM products[0m
Rendered store/_cart (0.00000)
Completed in 0.06000 (16 reqs/sec) | Rendering: 0.03000 (50%) | DB: 0.00000 (0%) | 200 OK [http://localhost/store]
  [4;36;1mSQL (0.050000)[0m   [0;1mDELETE FROM sessions[0m


Processing StoreController#add_to_cart (for 127.0.0.1 at 2007-02-18 23:58:47) [POST]
  Session ID: b3a8c8d2f3774cbc3fc17ef32c74113d
  Parameters: {"commit"=>"Dodaj do koszyka", "action"=>"add_to_cart", "id"=>"1", "controller"=>"store"}
  [4;36;1mProduct Columns (0.010000)[0m   [0;1mSHOW FIELDS FROM products[0m
  [4;35;1mProduct Load (0.000000)[0m   [0mSELECT * FROM products WHERE (products.id = 1) [0m
Rendering store/add_to_cart
Rendered store/_cart_item (0.00000)
Rendered store/_cart (0.01000)
Completed in 0.08000 (12 reqs/sec) | Rendering: 0.03000 (37%) | DB: 0.01000 (12%) | 200 OK [http://localhost/store/add_to_cart/1]


Processing StoreController#checkout (for 127.0.0.1 at 2007-02-18 23:58:50) [POST]
  Session ID: b3a8c8d2f3774cbc3fc17ef32c74113d
  Parameters: {"action"=>"checkout", "controller"=>"store"}
  [4;36;1mOrder Columns (0.010000)[0m   [0;1mSHOW FIELDS FROM orders[0m
Rendering  within layouts/store
Rendering store/checkout
  [4;35;1mProduct Columns (0.010000)[0m   [0mSHOW FIELDS FROM products[0m
Rendered store/_cart_item (0.01000)
Rendered store/_cart (0.01000)
Completed in 0.05000 (20 reqs/sec) | Rendering: 0.01000 (20%) | DB: 0.02000 (40%) | 200 OK [http://localhost/store/checkout]


Processing StoreController#save_order (for 127.0.0.1 at 2007-02-18 23:59:31) [POST]
  Session ID: b3a8c8d2f3774cbc3fc17ef32c74113d
  Parameters: {"commit"=>"Złóż zamówienie", "order"=>{"name"=>"Fred Flinstone", "pay_type"=>"check", "address"=>"Bedrock 123", "email"=>"twardziel@bedrock.com"}, "action"=>"save_order", "controller"=>"store"}
  [4;36;1mOrder Columns (0.010000)[0m   [0;1mSHOW FIELDS FROM orders[0m
  [4;35;1mLineItem Columns (0.000000)[0m   [0mSHOW FIELDS FROM line_items[0m
  [4;36;1mProduct Columns (0.000000)[0m   [0;1mSHOW FIELDS FROM products[0m
  [4;35;1mSQL (0.000000)[0m   [0mBEGIN[0m
  [4;36;1mSQL (0.000000)[0m   [0;1mCOMMIT[0m
  [4;35;1mSQL (0.000000)[0m   [0mBEGIN[0m
  [4;36;1mSQL (0.000000)[0m   [0;1mINSERT INTO orders (`name`, `pay_type`, `address`, `email`) VALUES('Fred Flinstone', 'check', 'Bedrock 123', 'twardziel@bedrock.com')[0m
  [4;35;1mSQL (0.000000)[0m   [0mINSERT INTO line_items (`order_id`, `total_price`, `product_id`, `quantity`) VALUES(2, '99.0', 1, 1)[0m
  [4;36;1mSQL (0.040000)[0m   [0;1mCOMMIT[0m
Redirected to http://localhost:3000/store
Completed in 0.26000 (3 reqs/sec) | DB: 0.05000 (19%) | 302 Found [http://localhost/store/save_order]


Processing StoreController#index (for 127.0.0.1 at 2007-02-18 23:59:31) [GET]
  Session ID: b3a8c8d2f3774cbc3fc17ef32c74113d
  Parameters: {"action"=>"index", "controller"=>"store"}
  [4;35;1mProduct Load (0.000000)[0m   [0mSELECT * FROM products ORDER BY title[0m
Rendering  within layouts/store
Rendering store/index
  [4;36;1mProduct Columns (0.000000)[0m   [0;1mSHOW FIELDS FROM products[0m
Rendered store/_cart (0.00000)
Completed in 0.08000 (12 reqs/sec) | Rendering: 0.03000 (37%) | DB: 0.00000 (0%) | 200 OK [http://localhost/store]


Processing InfoController#who_bought (for 127.0.0.1 at 2007-02-18 23:59:41) [GET]
  Session ID: b3a8c8d2f3774cbc3fc17ef32c74113d
  Parameters: {"action"=>"who_bought", "id"=>"1", "controller"=>"info"}
  [4;35;1mProduct Columns (0.000000)[0m   [0mSHOW FIELDS FROM products[0m
  [4;36;1mProduct Load (0.000000)[0m   [0;1mSELECT * FROM products WHERE (products.id = 1) [0m
Rendering info/who_bought
  [4;35;1mOrder Load (0.010000)[0m   [0mSELECT orders.* FROM orders INNER JOIN line_items ON orders.id = line_items.order_id WHERE ((line_items.product_id = 1)) [0m
  [4;36;1mOrder Columns (0.000000)[0m   [0;1mSHOW FIELDS FROM orders[0m
Completed in 0.09000 (11 reqs/sec) | Rendering: 0.03000 (33%) | DB: 0.01000 (11%) | 200 OK [http://localhost/info/who_bought/1]


Processing InfoController#who_bought (for 127.0.0.1 at 2007-02-19 00:10:44) [GET]
  Session ID: b3a8c8d2f3774cbc3fc17ef32c74113d
  Parameters: {"action"=>"who_bought", "id"=>"1", "controller"=>"info"}
  [4;35;1mProduct Columns (0.021000)[0m   [0mSHOW FIELDS FROM products[0m
  [4;36;1mProduct Load (0.000000)[0m   [0;1mSELECT * FROM products WHERE (products.id = 1) [0m
Rendering info/who_bought
  [4;35;1mOrder Load (0.000000)[0m   [0mSELECT orders.* FROM orders INNER JOIN line_items ON orders.id = line_items.order_id WHERE ((line_items.product_id = 1)) [0m
  [4;36;1mOrder Columns (0.000000)[0m   [0;1mSHOW FIELDS FROM orders[0m
Completed in 0.09100 (10 reqs/sec) | Rendering: 0.03000 (32%) | DB: 0.02100 (23%) | 200 OK [http://localhost/info/who_bought/1]


Processing InfoController#who_bought (for 127.0.0.1 at 2007-02-19 00:12:20) [GET]
  Session ID: b3a8c8d2f3774cbc3fc17ef32c74113d
  Parameters: {"format"=>"xml", "action"=>"who_bought", "id"=>"1", "controller"=>"info"}
  [4;36;1mProduct Columns (0.000000)[0m   [0;1mSHOW FIELDS FROM products[0m
  [4;35;1mProduct Load (0.010000)[0m   [0mSELECT * FROM products WHERE (products.id = 1) [0m
Rendering info/who_bought.rxml
  [4;36;1mOrder Load (0.010000)[0m   [0;1mSELECT orders.* FROM orders INNER JOIN line_items ON orders.id = line_items.order_id WHERE ((line_items.product_id = 1)) [0m
  [4;35;1mOrder Columns (0.000000)[0m   [0mSHOW FIELDS FROM orders[0m
Completed in 0.19000 (5 reqs/sec) | Rendering: 0.02000 (10%) | DB: 0.02000 (10%) | 200 OK [http://localhost/info/who_bought/1.xml]


Processing InfoController#who_bought (for 127.0.0.1 at 2007-02-19 00:13:05) [GET]
  Session ID: b3a8c8d2f3774cbc3fc17ef32c74113d
  Parameters: {"format"=>"xml", "action"=>"who_bought", "id"=>"1", "controller"=>"info"}
  [4;36;1mProduct Columns (0.010000)[0m   [0;1mSHOW FIELDS FROM products[0m
  [4;35;1mProduct Load (0.000000)[0m   [0mSELECT * FROM products WHERE (products.id = 1) [0m
  [4;36;1mOrder Load (0.000000)[0m   [0;1mSELECT orders.* FROM orders INNER JOIN line_items ON orders.id = line_items.order_id WHERE ((line_items.product_id = 1)) [0m
  [4;35;1mOrder Columns (0.000000)[0m   [0mSHOW FIELDS FROM orders[0m
Completed in 0.09000 (11 reqs/sec) | Rendering: 0.00000 (0%) | DB: 0.01000 (11%) | 200 OK [http://localhost/info/who_bought/1.xml]
  [4;36;1mSQL (0.020000)[0m   [0;1mSELECT * FROM schema_info[0m
  [4;35;1mSQL (0.010000)[0m   [0mSHOW TABLES[0m
  [4;36;1mSQL (0.150000)[0m   [0;1mSHOW FIELDS FROM line_items[0m
  [4;35;1mSQL (0.000000)[0m   [0mSHOW KEYS FROM line_items[0m
  [4;36;1mSQL (0.040000)[0m   [0;1mSHOW FIELDS FROM orders[0m
  [4;35;1mSQL (0.000000)[0m   [0mSHOW KEYS FROM orders[0m
  [4;36;1mSQL (0.000000)[0m   [0;1mSHOW FIELDS FROM products[0m
  [4;35;1mSQL (0.010000)[0m   [0mSHOW KEYS FROM products[0m
  [4;36;1mSQL (0.040000)[0m   [0;1mSHOW FIELDS FROM sessions[0m
  [4;35;1mSQL (0.000000)[0m   [0mSHOW KEYS FROM sessions[0m
  [4;36;1mSQL (0.020000)[0m   [0;1mSHOW FIELDS FROM users[0m
  [4;35;1mSQL (0.000000)[0m   [0mSHOW KEYS FROM users[0m
  [4;36;1mSQL (0.201000)[0m   [0;1mDROP DATABASE IF EXISTS `depot_test`[0m
  [4;35;1mSQL (0.070000)[0m   [0mCREATE DATABASE `depot_test`[0m
  [4;36;1mSQL (0.000000)[0m   [0;1mMysql::Error: Unknown table 'line_items': DROP TABLE line_items[0m
  [4;35;1mSQL (0.140000)[0m   [0mCREATE TABLE line_items (`id` int(11) DEFAULT NULL auto_increment PRIMARY KEY, `product_id` int(11) NOT NULL, `order_id` int(11) NOT NULL, `quantity` int(11) NOT NULL, `total_price` decimal(8,2) NOT NULL) ENGINE=InnoDB[0m
  [4;36;1mSQL (0.130000)[0m   [0;1mCREATE INDEX `fk_line_item_products` ON line_items (`product_id`)[0m
  [4;35;1mSQL (0.140000)[0m   [0mCREATE INDEX `fk_line_item_orders` ON line_items (`order_id`)[0m
  [4;36;1mSQL (0.000000)[0m   [0;1mMysql::Error: Unknown table 'orders': DROP TABLE orders[0m
  [4;35;1mSQL (0.070000)[0m   [0mCREATE TABLE orders (`id` int(11) DEFAULT NULL auto_increment PRIMARY KEY, `name` varchar(255) DEFAULT NULL, `address` text DEFAULT NULL, `email` varchar(255) DEFAULT NULL, `pay_type` varchar(10) DEFAULT NULL) ENGINE=InnoDB[0m
  [4;36;1mSQL (0.000000)[0m   [0;1mMysql::Error: Unknown table 'products': DROP TABLE products[0m
  [4;35;1mSQL (0.071000)[0m   [0mCREATE TABLE products (`id` int(11) DEFAULT NULL auto_increment PRIMARY KEY, `title` varchar(255) DEFAULT NULL, `description` text DEFAULT NULL, `image_url` varchar(255) DEFAULT NULL, `price` decimal(8,2) DEFAULT 0.0) ENGINE=InnoDB[0m
  [4;36;1mSQL (0.000000)[0m   [0;1mMysql::Error: Unknown table 'sessions': DROP TABLE sessions[0m
  [4;35;1mSQL (0.060000)[0m   [0mCREATE TABLE sessions (`id` int(11) DEFAULT NULL auto_increment PRIMARY KEY, `session_id` varchar(255) DEFAULT NULL, `data` text DEFAULT NULL, `updated_at` datetime DEFAULT NULL) ENGINE=InnoDB[0m
  [4;36;1mSQL (0.130000)[0m   [0;1mCREATE INDEX `index_sessions_on_session_id` ON sessions (`session_id`)[0m
  [4;35;1mSQL (0.140000)[0m   [0mCREATE INDEX `index_sessions_on_updated_at` ON sessions (`updated_at`)[0m
  [4;36;1mSQL (0.000000)[0m   [0;1mMysql::Error: Unknown table 'users': DROP TABLE users[0m
  [4;35;1mSQL (0.060000)[0m   [0mCREATE TABLE users (`id` int(11) DEFAULT NULL auto_increment PRIMARY KEY, `name` varchar(255) DEFAULT NULL, `hashed_password` varchar(255) DEFAULT NULL, `salt` varchar(255) DEFAULT NULL) ENGINE=InnoDB[0m
  [4;36;1mSQL (0.070000)[0m   [0;1mCREATE TABLE schema_info (version int(11))[0m
  [4;35;1mSQL (0.020000)[0m   [0mINSERT INTO schema_info (version) VALUES(0)[0m
  [4;36;1mSQL (0.010000)[0m   [0;1mSHOW FIELDS FROM schema_info[0m
  [4;35;1mSQL (0.020000)[0m   [0mUPDATE schema_info SET version = 7[0m
