spec/dummy/log/development.log in mechanize_store-0.0.4 vs spec/dummy/log/development.log in mechanize_store-0.0.5

- old
+ new

@@ -24927,5 +24927,485 @@ ActiveRecord::SchemaMigration Load (0.1ms) SELECT "schema_migrations".* FROM "schema_migrations" ActiveRecord::SchemaMigration Load (0.1ms) SELECT "schema_migrations".* FROM "schema_migrations" MechanizeStore::Product Load (0.2ms) SELECT "mechanize_store_products".* FROM "mechanize_store_products" ORDER BY "mechanize_store_products"."id" ASC LIMIT 1 MechanizeStore::Product Load (0.3ms) SELECT "mechanize_store_products".* FROM "mechanize_store_products" ORDER BY "mechanize_store_products"."id" ASC LIMIT 1 MechanizeStore::Product Load (0.2ms) SELECT "mechanize_store_products".* FROM "mechanize_store_products" ORDER BY "mechanize_store_products"."id" ASC LIMIT 1 + + +Started GET "/" for 127.0.0.1 at 2014-05-08 10:55:30 -0300 + ActiveRecord::SchemaMigration Load (0.2ms) SELECT "schema_migrations".* FROM "schema_migrations" + +ActiveRecord::PendingMigrationError (Migrations are pending; run 'bin/rake db:migrate RAILS_ENV=development' to resolve this issue.): + activerecord (4.0.4) lib/active_record/migration.rb:383:in `check_pending!' + activerecord (4.0.4) lib/active_record/migration.rb:370:in `call' + actionpack (4.0.4) lib/action_dispatch/middleware/callbacks.rb:29:in `block in call' + activesupport (4.0.4) lib/active_support/callbacks.rb:373:in `_run__4138770746872140624__call__callbacks' + activesupport (4.0.4) lib/active_support/callbacks.rb:80:in `run_callbacks' + actionpack (4.0.4) lib/action_dispatch/middleware/callbacks.rb:27:in `call' + actionpack (4.0.4) lib/action_dispatch/middleware/reloader.rb:64:in `call' + actionpack (4.0.4) lib/action_dispatch/middleware/remote_ip.rb:76:in `call' + actionpack (4.0.4) lib/action_dispatch/middleware/debug_exceptions.rb:17:in `call' + actionpack (4.0.4) lib/action_dispatch/middleware/show_exceptions.rb:30:in `call' + railties (4.0.4) lib/rails/rack/logger.rb:38:in `call_app' + railties (4.0.4) lib/rails/rack/logger.rb:20:in `block in call' + activesupport (4.0.4) lib/active_support/tagged_logging.rb:68:in `block in tagged' + activesupport (4.0.4) lib/active_support/tagged_logging.rb:26:in `tagged' + activesupport (4.0.4) lib/active_support/tagged_logging.rb:68:in `tagged' + railties (4.0.4) lib/rails/rack/logger.rb:20:in `call' + actionpack (4.0.4) lib/action_dispatch/middleware/request_id.rb:21:in `call' + rack (1.5.2) lib/rack/methodoverride.rb:21:in `call' + rack (1.5.2) lib/rack/runtime.rb:17:in `call' + activesupport (4.0.4) lib/active_support/cache/strategy/local_cache.rb:83:in `call' + rack (1.5.2) lib/rack/lock.rb:17:in `call' + actionpack (4.0.4) lib/action_dispatch/middleware/static.rb:64:in `call' + rack (1.5.2) lib/rack/sendfile.rb:112:in `call' + railties (4.0.4) lib/rails/engine.rb:511:in `call' + railties (4.0.4) lib/rails/application.rb:97:in `call' + rack (1.5.2) lib/rack/lock.rb:17:in `call' + rack (1.5.2) lib/rack/content_length.rb:14:in `call' + rack (1.5.2) lib/rack/handler/webrick.rb:60:in `service' + /Users/wilbert/.rvm/rubies/ruby-1.9.3-p545/lib/ruby/1.9.1/webrick/httpserver.rb:138:in `service' + /Users/wilbert/.rvm/rubies/ruby-1.9.3-p545/lib/ruby/1.9.1/webrick/httpserver.rb:94:in `run' + /Users/wilbert/.rvm/rubies/ruby-1.9.3-p545/lib/ruby/1.9.1/webrick/server.rb:191:in `block in start_thread' + + + Rendered /Users/wilbert/.rvm/gems/ruby-1.9.3-p545/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_source.erb (0.6ms) + Rendered /Users/wilbert/.rvm/gems/ruby-1.9.3-p545/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_trace.erb (0.9ms) + Rendered /Users/wilbert/.rvm/gems/ruby-1.9.3-p545/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (0.9ms) + Rendered /Users/wilbert/.rvm/gems/ruby-1.9.3-p545/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/diagnostics.erb within rescues/layout (20.6ms) + ActiveRecord::SchemaMigration Load (0.1ms) SELECT "schema_migrations".* FROM "schema_migrations" +Migrating to CreateMechanizeStoreFreights (20140424193635) +  (0.1ms) begin transaction +  (0.1ms) CREATE TABLE "mechanize_store_freights" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "value" float, "service" varchar(255), "order_id" integer, "zipcode" varchar(255), "created_at" datetime, "updated_at" datetime)  +SQLite3::SQLException: table "mechanize_store_freights" already exists: CREATE TABLE "mechanize_store_freights" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "value" float, "service" varchar(255), "order_id" integer, "zipcode" varchar(255), "created_at" datetime, "updated_at" datetime) +  (0.0ms) rollback transaction +  (7.2ms) CREATE TABLE "schema_migrations" ("version" varchar(255) NOT NULL)  +  (0.8ms) CREATE UNIQUE INDEX "unique_schema_migrations" ON "schema_migrations" ("version") + ActiveRecord::SchemaMigration Load (0.2ms) SELECT "schema_migrations".* FROM "schema_migrations" +Migrating to CreateMechanizeStoreFreights (20140508135625) +  (0.1ms) begin transaction +  (0.4ms) CREATE TABLE "mechanize_store_freights" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "value" float, "service" varchar(255), "order_id" integer, "zipcode" varchar(255), "created_at" datetime, "updated_at" datetime)  +  (0.1ms) CREATE INDEX "index_mechanize_store_freights_on_order_id" ON "mechanize_store_freights" ("order_id") + SQL (2.0ms) INSERT INTO "schema_migrations" ("version") VALUES (?) [["version", "20140508135625"]] +  (0.8ms) commit transaction +Migrating to CreateMechanizeStoreOrderStatuses (20140508135626) +  (0.1ms) begin transaction +  (0.3ms) CREATE TABLE "mechanize_store_order_statuses" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "name" varchar(255), "created_at" datetime, "updated_at" datetime) + SQL (0.1ms) INSERT INTO "schema_migrations" ("version") VALUES (?) [["version", "20140508135626"]] +  (0.7ms) commit transaction +Migrating to CreateMechanizeStorePaymentStatuses (20140508135627) +  (0.1ms) begin transaction +  (0.3ms) CREATE TABLE "mechanize_store_payment_statuses" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "name" varchar(255), "created_at" datetime, "updated_at" datetime) + SQL (0.1ms) INSERT INTO "schema_migrations" ("version") VALUES (?) [["version", "20140508135627"]] +  (0.7ms) commit transaction +Migrating to CreateMechanizeStorePaymentTypes (20140508135628) +  (0.1ms) begin transaction +  (0.3ms) CREATE TABLE "mechanize_store_payment_types" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "name" varchar(255), "created_at" datetime, "updated_at" datetime) + SQL (0.1ms) INSERT INTO "schema_migrations" ("version") VALUES (?) [["version", "20140508135628"]] +  (0.8ms) commit transaction +Migrating to CreateMechanizeStorePayments (20140508135629) +  (0.1ms) begin transaction +  (0.3ms) CREATE TABLE "mechanize_store_payments" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "order_id" integer, "payment_status_id" integer, "value" float, "paid_value" float, "paid_in" datetime, "plot" integer, "flag_id" integer, "created_at" datetime, "updated_at" datetime) +  (0.1ms) CREATE INDEX "index_mechanize_store_payments_on_payment_status_id" ON "mechanize_store_payments" ("payment_status_id") +  (0.1ms) CREATE INDEX "index_mechanize_store_payments_on_flag_id" ON "mechanize_store_payments" ("flag_id") + SQL (0.1ms) INSERT INTO "schema_migrations" ("version") VALUES (?) [["version", "20140508135629"]] +  (0.7ms) commit transaction +Migrating to CreateMechanizeStoreFlags (20140508135630) +  (0.1ms) begin transaction +  (0.3ms) CREATE TABLE "mechanize_store_flags" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "name" varchar(255), "created_at" datetime, "updated_at" datetime) + SQL (0.1ms) INSERT INTO "schema_migrations" ("version") VALUES (?) [["version", "20140508135630"]] +  (0.7ms) commit transaction +Migrating to CreateMechanizeStoreProducts (20140508135631) +  (0.1ms) begin transaction +  (0.3ms) CREATE TABLE "mechanize_store_products" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "name" varchar(255), "description" text, "short_description" varchar(255), "price" float, "weight" float, "lenght" float, "height" float, "product_category_id" integer, "created_at" datetime, "updated_at" datetime) +  (0.1ms) CREATE INDEX "index_mechanize_store_products_on_product_category_id" ON "mechanize_store_products" ("product_category_id") + SQL (0.2ms) INSERT INTO "schema_migrations" ("version") VALUES (?) [["version", "20140508135631"]] +  (0.7ms) commit transaction +Migrating to CreateMechanizeStoreProductPhotos (20140508135632) +  (0.1ms) begin transaction +  (0.3ms) CREATE TABLE "mechanize_store_product_photos" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "file_file_name" varchar(255), "file_content_type" varchar(255), "file_file_size" integer, "file_updated_at" datetime, "product_id" integer, "created_at" datetime, "updated_at" datetime)  +  (0.1ms) CREATE INDEX "index_mechanize_store_product_photos_on_product_id" ON "mechanize_store_product_photos" ("product_id") + SQL (0.2ms) INSERT INTO "schema_migrations" ("version") VALUES (?) [["version", "20140508135632"]] +  (0.8ms) commit transaction +Migrating to CreateMechanizeStoreOrders (20140508135633) +  (0.1ms) begin transaction +  (0.3ms) CREATE TABLE "mechanize_store_orders" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "order_status_id" integer, "store_id" integer, "delivery_date" datetime, "created_at" datetime, "updated_at" datetime) +  (0.1ms) CREATE INDEX "index_mechanize_store_orders_on_order_status_id" ON "mechanize_store_orders" ("order_status_id") +  (0.1ms) CREATE INDEX "index_mechanize_store_orders_on_store_id" ON "mechanize_store_orders" ("store_id") + SQL (0.1ms) INSERT INTO "schema_migrations" ("version") VALUES (?) [["version", "20140508135633"]] +  (0.7ms) commit transaction +Migrating to CreateMechanizeStoreProductCategories (20140508135634) +  (0.1ms) begin transaction +  (0.3ms) CREATE TABLE "mechanize_store_product_categories" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "name" varchar(255), "product_category_id" integer, "created_at" datetime, "updated_at" datetime) + SQL (0.2ms) INSERT INTO "schema_migrations" ("version") VALUES (?) [["version", "20140508135634"]] +  (0.8ms) commit transaction +Migrating to AddWidthToMechanizeStoreProduct (20140508135635) +  (0.1ms) begin transaction +  (0.4ms) ALTER TABLE "mechanize_store_products" ADD "width" float + SQL (0.1ms) INSERT INTO "schema_migrations" ("version") VALUES (?) [["version", "20140508135635"]] +  (0.6ms) commit transaction +Migrating to CreateMechanizeStoreOrderItems (20140508135636) +  (0.1ms) begin transaction +  (0.6ms) CREATE TABLE "mechanize_store_order_items" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "quantity" integer, "price" float, "order_id" integer, "product_id" integer, "created_at" datetime, "updated_at" datetime) +  (0.3ms) CREATE INDEX "index_mechanize_store_order_items_on_order_id" ON "mechanize_store_order_items" ("order_id") +  (0.2ms) CREATE INDEX "index_mechanize_store_order_items_on_product_id" ON "mechanize_store_order_items" ("product_id") + SQL (0.2ms) INSERT INTO "schema_migrations" ("version") VALUES (?) [["version", "20140508135636"]] +  (0.8ms) commit transaction +Migrating to AddPaymentTypeIdToPayment (20140508135637) +  (0.1ms) begin transaction +  (0.4ms) ALTER TABLE "mechanize_store_payments" ADD "payment_type_id" integer +  (0.2ms) CREATE INDEX "index_mechanize_store_payments_on_payment_type_id" ON "mechanize_store_payments" ("payment_type_id") + SQL (0.1ms) INSERT INTO "schema_migrations" ("version") VALUES (?) [["version", "20140508135637"]] +  (0.8ms) commit transaction +Migrating to AddTimeToFreight (20140508135638) +  (0.1ms) begin transaction +  (0.5ms) ALTER TABLE "mechanize_store_freights" ADD "delivery_time" integer + SQL (0.2ms) INSERT INTO "schema_migrations" ("version") VALUES (?) [["version", "20140508135638"]] +  (0.8ms) commit transaction + ActiveRecord::SchemaMigration Load (0.1ms) SELECT "schema_migrations".* FROM "schema_migrations" + + +Started GET "/" for 127.0.0.1 at 2014-05-08 10:56:44 -0300 + ActiveRecord::SchemaMigration Load (0.2ms) SELECT "schema_migrations".* FROM "schema_migrations" +Processing by Rails::WelcomeController#index as HTML + Rendered /Users/wilbert/.rvm/gems/ruby-1.9.3-p545/gems/railties-4.0.4/lib/rails/templates/rails/welcome/index.html.erb (2.6ms) +Completed 200 OK in 54ms (Views: 13.3ms | ActiveRecord: 0.0ms) + + +Started GET "/products/" for 127.0.0.1 at 2014-05-08 10:56:48 -0300 + +ActionController::RoutingError (No route matches [GET] "/products"): + actionpack (4.0.4) lib/action_dispatch/middleware/debug_exceptions.rb:21:in `call' + actionpack (4.0.4) lib/action_dispatch/middleware/show_exceptions.rb:30:in `call' + railties (4.0.4) lib/rails/rack/logger.rb:38:in `call_app' + railties (4.0.4) lib/rails/rack/logger.rb:20:in `block in call' + activesupport (4.0.4) lib/active_support/tagged_logging.rb:68:in `block in tagged' + activesupport (4.0.4) lib/active_support/tagged_logging.rb:26:in `tagged' + activesupport (4.0.4) lib/active_support/tagged_logging.rb:68:in `tagged' + railties (4.0.4) lib/rails/rack/logger.rb:20:in `call' + actionpack (4.0.4) lib/action_dispatch/middleware/request_id.rb:21:in `call' + rack (1.5.2) lib/rack/methodoverride.rb:21:in `call' + rack (1.5.2) lib/rack/runtime.rb:17:in `call' + activesupport (4.0.4) lib/active_support/cache/strategy/local_cache.rb:83:in `call' + rack (1.5.2) lib/rack/lock.rb:17:in `call' + actionpack (4.0.4) lib/action_dispatch/middleware/static.rb:64:in `call' + rack (1.5.2) lib/rack/sendfile.rb:112:in `call' + railties (4.0.4) lib/rails/engine.rb:511:in `call' + railties (4.0.4) lib/rails/application.rb:97:in `call' + rack (1.5.2) lib/rack/lock.rb:17:in `call' + rack (1.5.2) lib/rack/content_length.rb:14:in `call' + rack (1.5.2) lib/rack/handler/webrick.rb:60:in `service' + /Users/wilbert/.rvm/rubies/ruby-1.9.3-p545/lib/ruby/1.9.1/webrick/httpserver.rb:138:in `service' + /Users/wilbert/.rvm/rubies/ruby-1.9.3-p545/lib/ruby/1.9.1/webrick/httpserver.rb:94:in `run' + /Users/wilbert/.rvm/rubies/ruby-1.9.3-p545/lib/ruby/1.9.1/webrick/server.rb:191:in `block in start_thread' + + + Rendered /Users/wilbert/.rvm/gems/ruby-1.9.3-p545/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_trace.erb (1.1ms) + Rendered /Users/wilbert/.rvm/gems/ruby-1.9.3-p545/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/routes/_route.html.erb (0.7ms) + Rendered /Users/wilbert/.rvm/gems/ruby-1.9.3-p545/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/routes/_route.html.erb (4.7ms) + Rendered /Users/wilbert/.rvm/gems/ruby-1.9.3-p545/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/routes/_table.html.erb (9.6ms) + Rendered /Users/wilbert/.rvm/gems/ruby-1.9.3-p545/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/routing_error.erb within rescues/layout (61.2ms) + + +Started GET "/store/products/" for 127.0.0.1 at 2014-05-08 10:56:53 -0300 + +ActionController::RoutingError (No route matches [GET] "/store/products"): + actionpack (4.0.4) lib/action_dispatch/middleware/debug_exceptions.rb:21:in `call' + actionpack (4.0.4) lib/action_dispatch/middleware/show_exceptions.rb:30:in `call' + railties (4.0.4) lib/rails/rack/logger.rb:38:in `call_app' + railties (4.0.4) lib/rails/rack/logger.rb:20:in `block in call' + activesupport (4.0.4) lib/active_support/tagged_logging.rb:68:in `block in tagged' + activesupport (4.0.4) lib/active_support/tagged_logging.rb:26:in `tagged' + activesupport (4.0.4) lib/active_support/tagged_logging.rb:68:in `tagged' + railties (4.0.4) lib/rails/rack/logger.rb:20:in `call' + actionpack (4.0.4) lib/action_dispatch/middleware/request_id.rb:21:in `call' + rack (1.5.2) lib/rack/methodoverride.rb:21:in `call' + rack (1.5.2) lib/rack/runtime.rb:17:in `call' + activesupport (4.0.4) lib/active_support/cache/strategy/local_cache.rb:83:in `call' + rack (1.5.2) lib/rack/lock.rb:17:in `call' + actionpack (4.0.4) lib/action_dispatch/middleware/static.rb:64:in `call' + rack (1.5.2) lib/rack/sendfile.rb:112:in `call' + railties (4.0.4) lib/rails/engine.rb:511:in `call' + railties (4.0.4) lib/rails/application.rb:97:in `call' + rack (1.5.2) lib/rack/lock.rb:17:in `call' + rack (1.5.2) lib/rack/content_length.rb:14:in `call' + rack (1.5.2) lib/rack/handler/webrick.rb:60:in `service' + /Users/wilbert/.rvm/rubies/ruby-1.9.3-p545/lib/ruby/1.9.1/webrick/httpserver.rb:138:in `service' + /Users/wilbert/.rvm/rubies/ruby-1.9.3-p545/lib/ruby/1.9.1/webrick/httpserver.rb:94:in `run' + /Users/wilbert/.rvm/rubies/ruby-1.9.3-p545/lib/ruby/1.9.1/webrick/server.rb:191:in `block in start_thread' + + + Rendered /Users/wilbert/.rvm/gems/ruby-1.9.3-p545/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_trace.erb (36.0ms) + Rendered /Users/wilbert/.rvm/gems/ruby-1.9.3-p545/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/routes/_route.html.erb (0.7ms) + Rendered /Users/wilbert/.rvm/gems/ruby-1.9.3-p545/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/routes/_route.html.erb (3.0ms) + Rendered /Users/wilbert/.rvm/gems/ruby-1.9.3-p545/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/routes/_table.html.erb (1.0ms) + Rendered /Users/wilbert/.rvm/gems/ruby-1.9.3-p545/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/routing_error.erb within rescues/layout (72.0ms) + + +Started GET "/mechanize_store/products/" for 127.0.0.1 at 2014-05-08 10:57:05 -0300 +Processing by MechanizeStore::ProductsController#index as HTML + MechanizeStore::Product Load (0.2ms) SELECT "mechanize_store_products".* FROM "mechanize_store_products" LIMIT 30 OFFSET 0 + Rendered /Users/wilbert/apps/mechanize_store/app/views/mechanize_store/products/index.html.erb (13.0ms) +Completed 200 OK in 29ms (Views: 15.9ms | ActiveRecord: 0.2ms) + + +Started GET "/mechanize_store/products/new" for 127.0.0.1 at 2014-05-08 10:57:37 -0300 +Processing by MechanizeStore::ProductsController#new as HTML + Rendered /Users/wilbert/apps/mechanize_store/app/views/mechanize_store/products/_form.html.erb (187.4ms) + Rendered /Users/wilbert/apps/mechanize_store/app/views/mechanize_store/products/new.html.erb (190.5ms) +Completed 500 Internal Server Error in 197ms + +ActionView::Template::Error (undefined method `length' for #<MechanizeStore::Product:0x007f929b938f48>): + 7: <%= f.input :short_description %> + 8: <%= f.input :price %> + 9: <%= f.input :weight %> + 10: <%= f.input :length %> + 11: <%= f.input :width %> + 12: <%= f.input :height %> + 13: <%= f.association :product_category %> + activemodel (4.0.4) lib/active_model/attribute_methods.rb:439:in `method_missing' + activerecord (4.0.4) lib/active_record/attribute_methods.rb:167:in `method_missing' + actionpack (4.0.4) lib/action_view/helpers/tags/base.rb:28:in `value' + actionpack (4.0.4) lib/action_view/helpers/tags/base.rb:37:in `value_before_type_cast' + actionpack (4.0.4) lib/action_view/helpers/tags/text_field.rb:9:in `block in render' + actionpack (4.0.4) lib/action_view/helpers/tags/text_field.rb:9:in `fetch' + actionpack (4.0.4) lib/action_view/helpers/tags/text_field.rb:9:in `render' + actionpack (4.0.4) lib/action_view/helpers/form_helper.rb:771:in `text_field' + actionpack (4.0.4) lib/action_view/helpers/form_helper.rb:1262:in `text_field' + simple_form (3.0.1) lib/simple_form/inputs/string_input.rb:12:in `input' + simple_form (3.0.1) lib/simple_form/components/label_input.rb:11:in `label_input' + simple_form (3.0.1) lib/simple_form/wrappers/many.rb:29:in `block in render' + simple_form (3.0.1) lib/simple_form/wrappers/many.rb:27:in `each' + simple_form (3.0.1) lib/simple_form/wrappers/many.rb:27:in `render' + simple_form (3.0.1) lib/simple_form/wrappers/root.rb:15:in `render' + simple_form (3.0.1) lib/simple_form/form_builder.rb:120:in `input' + /Users/wilbert/apps/mechanize_store/app/views/mechanize_store/products/_form.html.erb:10:in `block in ___sers_wilbert_apps_mechanize_store_app_views_mechanize_store_products__form_html_erb__499618614516975847_70133825557440' + actionpack (4.0.4) lib/action_view/helpers/capture_helper.rb:38:in `block in capture' + actionpack (4.0.4) lib/action_view/helpers/capture_helper.rb:200:in `with_output_buffer' + actionpack (4.0.4) lib/action_view/helpers/capture_helper.rb:38:in `capture' + actionpack (4.0.4) lib/action_view/helpers/form_helper.rb:435:in `form_for' + simple_form (3.0.1) lib/simple_form/action_view_extensions/form_helper.rb:22:in `block in simple_form_for' + simple_form (3.0.1) lib/simple_form/action_view_extensions/form_helper.rb:41:in `with_simple_form_field_error_proc' + simple_form (3.0.1) lib/simple_form/action_view_extensions/form_helper.rb:21:in `simple_form_for' + /Users/wilbert/apps/mechanize_store/app/views/mechanize_store/products/_form.html.erb:1:in `___sers_wilbert_apps_mechanize_store_app_views_mechanize_store_products__form_html_erb__499618614516975847_70133825557440' + actionpack (4.0.4) lib/action_view/template.rb:143:in `block in render' + activesupport (4.0.4) lib/active_support/notifications.rb:161:in `instrument' + actionpack (4.0.4) lib/action_view/template.rb:141:in `render' + actionpack (4.0.4) lib/action_view/renderer/partial_renderer.rb:306:in `render_partial' + actionpack (4.0.4) lib/action_view/renderer/partial_renderer.rb:279:in `block in render' + actionpack (4.0.4) lib/action_view/renderer/abstract_renderer.rb:38:in `block in instrument' + activesupport (4.0.4) lib/active_support/notifications.rb:159:in `block in instrument' + activesupport (4.0.4) lib/active_support/notifications/instrumenter.rb:20:in `instrument' + activesupport (4.0.4) lib/active_support/notifications.rb:159:in `instrument' + actionpack (4.0.4) lib/action_view/renderer/abstract_renderer.rb:38:in `instrument' + actionpack (4.0.4) lib/action_view/renderer/partial_renderer.rb:278:in `render' + actionpack (4.0.4) lib/action_view/renderer/renderer.rb:47:in `render_partial' + actionpack (4.0.4) lib/action_view/helpers/rendering_helper.rb:27:in `render' + /Users/wilbert/apps/mechanize_store/app/views/mechanize_store/products/new.html.erb:9:in `___sers_wilbert_apps_mechanize_store_app_views_mechanize_store_products_new_html_erb__3246596182593902060_70133826054780' + actionpack (4.0.4) lib/action_view/template.rb:143:in `block in render' + activesupport (4.0.4) lib/active_support/notifications.rb:161:in `instrument' + actionpack (4.0.4) lib/action_view/template.rb:141:in `render' + actionpack (4.0.4) lib/action_view/renderer/template_renderer.rb:49:in `block (2 levels) in render_template' + actionpack (4.0.4) lib/action_view/renderer/abstract_renderer.rb:38:in `block in instrument' + activesupport (4.0.4) lib/active_support/notifications.rb:159:in `block in instrument' + activesupport (4.0.4) lib/active_support/notifications/instrumenter.rb:20:in `instrument' + activesupport (4.0.4) lib/active_support/notifications.rb:159:in `instrument' + actionpack (4.0.4) lib/action_view/renderer/abstract_renderer.rb:38:in `instrument' + actionpack (4.0.4) lib/action_view/renderer/template_renderer.rb:48:in `block in render_template' + actionpack (4.0.4) lib/action_view/renderer/template_renderer.rb:56:in `render_with_layout' + actionpack (4.0.4) lib/action_view/renderer/template_renderer.rb:47:in `render_template' + actionpack (4.0.4) lib/action_view/renderer/template_renderer.rb:17:in `render' + actionpack (4.0.4) lib/action_view/renderer/renderer.rb:42:in `render_template' + actionpack (4.0.4) lib/action_view/renderer/renderer.rb:23:in `render' + actionpack (4.0.4) lib/abstract_controller/rendering.rb:127:in `_render_template' + actionpack (4.0.4) lib/action_controller/metal/streaming.rb:219:in `_render_template' + actionpack (4.0.4) lib/abstract_controller/rendering.rb:120:in `render_to_body' + actionpack (4.0.4) lib/action_controller/metal/rendering.rb:33:in `render_to_body' + actionpack (4.0.4) lib/action_controller/metal/renderers.rb:26:in `render_to_body' + actionpack (4.0.4) lib/abstract_controller/rendering.rb:97:in `render' + actionpack (4.0.4) lib/action_controller/metal/rendering.rb:16:in `render' + actionpack (4.0.4) lib/action_controller/metal/instrumentation.rb:41:in `block (2 levels) in render' + activesupport (4.0.4) lib/active_support/core_ext/benchmark.rb:12:in `block in ms' + /Users/wilbert/.rvm/rubies/ruby-1.9.3-p545/lib/ruby/1.9.1/benchmark.rb:295:in `realtime' + activesupport (4.0.4) lib/active_support/core_ext/benchmark.rb:12:in `ms' + actionpack (4.0.4) lib/action_controller/metal/instrumentation.rb:41:in `block in render' + actionpack (4.0.4) lib/action_controller/metal/instrumentation.rb:84:in `cleanup_view_runtime' + activerecord (4.0.4) lib/active_record/railties/controller_runtime.rb:25:in `cleanup_view_runtime' + actionpack (4.0.4) lib/action_controller/metal/instrumentation.rb:40:in `render' + actionpack (4.0.4) lib/action_controller/metal/implicit_render.rb:10:in `default_render' + actionpack (4.0.4) lib/action_controller/metal/responder.rb:233:in `default_render' + actionpack (4.0.4) lib/action_controller/metal/responder.rb:161:in `to_html' + actionpack (4.0.4) lib/action_controller/metal/responder.rb:154:in `respond' + actionpack (4.0.4) lib/action_controller/metal/responder.rb:147:in `call' + actionpack (4.0.4) lib/action_controller/metal/mime_responds.rb:330:in `respond_with' + /Users/wilbert/apps/mechanize_store/app/controllers/mechanize_store/products_controller.rb:21:in `new' + actionpack (4.0.4) lib/action_controller/metal/implicit_render.rb:4:in `send_action' + actionpack (4.0.4) lib/abstract_controller/base.rb:189:in `process_action' + actionpack (4.0.4) lib/action_controller/metal/rendering.rb:10:in `process_action' + actionpack (4.0.4) lib/abstract_controller/callbacks.rb:18:in `block in process_action' + activesupport (4.0.4) lib/active_support/callbacks.rb:403:in `_run__3904820799887369030__process_action__callbacks' + activesupport (4.0.4) lib/active_support/callbacks.rb:80:in `run_callbacks' + actionpack (4.0.4) lib/abstract_controller/callbacks.rb:17:in `process_action' + actionpack (4.0.4) lib/action_controller/metal/rescue.rb:29:in `process_action' + actionpack (4.0.4) lib/action_controller/metal/instrumentation.rb:31:in `block in process_action' + activesupport (4.0.4) lib/active_support/notifications.rb:159:in `block in instrument' + activesupport (4.0.4) lib/active_support/notifications/instrumenter.rb:20:in `instrument' + activesupport (4.0.4) lib/active_support/notifications.rb:159:in `instrument' + actionpack (4.0.4) lib/action_controller/metal/instrumentation.rb:30:in `process_action' + actionpack (4.0.4) lib/action_controller/metal/params_wrapper.rb:250:in `process_action' + activerecord (4.0.4) lib/active_record/railties/controller_runtime.rb:18:in `process_action' + actionpack (4.0.4) lib/abstract_controller/base.rb:136:in `process' + actionpack (4.0.4) lib/abstract_controller/rendering.rb:44:in `process' + actionpack (4.0.4) lib/action_controller/metal.rb:195:in `dispatch' + actionpack (4.0.4) lib/action_controller/metal/rack_delegation.rb:13:in `dispatch' + actionpack (4.0.4) lib/action_controller/metal.rb:231:in `block in action' + actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:80:in `call' + actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:80:in `dispatch' + actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:48:in `call' + actionpack (4.0.4) lib/action_dispatch/journey/router.rb:71:in `block in call' + actionpack (4.0.4) lib/action_dispatch/journey/router.rb:59:in `each' + actionpack (4.0.4) lib/action_dispatch/journey/router.rb:59:in `call' + actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:674:in `call' + railties (4.0.4) lib/rails/engine.rb:511:in `call' + railties (4.0.4) lib/rails/railtie/configurable.rb:30:in `method_missing' + actionpack (4.0.4) lib/action_dispatch/journey/router.rb:71:in `block in call' + actionpack (4.0.4) lib/action_dispatch/journey/router.rb:59:in `each' + actionpack (4.0.4) lib/action_dispatch/journey/router.rb:59:in `call' + actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:674:in `call' + rack (1.5.2) lib/rack/etag.rb:23:in `call' + rack (1.5.2) lib/rack/conditionalget.rb:25:in `call' + rack (1.5.2) lib/rack/head.rb:11:in `call' + actionpack (4.0.4) lib/action_dispatch/middleware/params_parser.rb:27:in `call' + actionpack (4.0.4) lib/action_dispatch/middleware/flash.rb:241:in `call' + rack (1.5.2) lib/rack/session/abstract/id.rb:225:in `context' + rack (1.5.2) lib/rack/session/abstract/id.rb:220:in `call' + actionpack (4.0.4) lib/action_dispatch/middleware/cookies.rb:486:in `call' + activerecord (4.0.4) lib/active_record/query_cache.rb:36:in `call' + activerecord (4.0.4) lib/active_record/connection_adapters/abstract/connection_pool.rb:626:in `call' + activerecord (4.0.4) lib/active_record/migration.rb:373:in `call' + actionpack (4.0.4) lib/action_dispatch/middleware/callbacks.rb:29:in `block in call' + activesupport (4.0.4) lib/active_support/callbacks.rb:373:in `_run__3327147194253802824__call__callbacks' + activesupport (4.0.4) lib/active_support/callbacks.rb:80:in `run_callbacks' + actionpack (4.0.4) lib/action_dispatch/middleware/callbacks.rb:27:in `call' + actionpack (4.0.4) lib/action_dispatch/middleware/reloader.rb:64:in `call' + actionpack (4.0.4) lib/action_dispatch/middleware/remote_ip.rb:76:in `call' + actionpack (4.0.4) lib/action_dispatch/middleware/debug_exceptions.rb:17:in `call' + actionpack (4.0.4) lib/action_dispatch/middleware/show_exceptions.rb:30:in `call' + railties (4.0.4) lib/rails/rack/logger.rb:38:in `call_app' + railties (4.0.4) lib/rails/rack/logger.rb:20:in `block in call' + activesupport (4.0.4) lib/active_support/tagged_logging.rb:68:in `block in tagged' + activesupport (4.0.4) lib/active_support/tagged_logging.rb:26:in `tagged' + activesupport (4.0.4) lib/active_support/tagged_logging.rb:68:in `tagged' + railties (4.0.4) lib/rails/rack/logger.rb:20:in `call' + actionpack (4.0.4) lib/action_dispatch/middleware/request_id.rb:21:in `call' + rack (1.5.2) lib/rack/methodoverride.rb:21:in `call' + rack (1.5.2) lib/rack/runtime.rb:17:in `call' + activesupport (4.0.4) lib/active_support/cache/strategy/local_cache.rb:83:in `call' + rack (1.5.2) lib/rack/lock.rb:17:in `call' + actionpack (4.0.4) lib/action_dispatch/middleware/static.rb:64:in `call' + rack (1.5.2) lib/rack/sendfile.rb:112:in `call' + railties (4.0.4) lib/rails/engine.rb:511:in `call' + railties (4.0.4) lib/rails/application.rb:97:in `call' + rack (1.5.2) lib/rack/lock.rb:17:in `call' + rack (1.5.2) lib/rack/content_length.rb:14:in `call' + rack (1.5.2) lib/rack/handler/webrick.rb:60:in `service' + /Users/wilbert/.rvm/rubies/ruby-1.9.3-p545/lib/ruby/1.9.1/webrick/httpserver.rb:138:in `service' + /Users/wilbert/.rvm/rubies/ruby-1.9.3-p545/lib/ruby/1.9.1/webrick/httpserver.rb:94:in `run' + /Users/wilbert/.rvm/rubies/ruby-1.9.3-p545/lib/ruby/1.9.1/webrick/server.rb:191:in `block in start_thread' + + + Rendered /Users/wilbert/.rvm/gems/ruby-1.9.3-p545/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_trace.erb (1.2ms) + Rendered /Users/wilbert/.rvm/gems/ruby-1.9.3-p545/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (0.9ms) + Rendered /Users/wilbert/.rvm/gems/ruby-1.9.3-p545/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/template_error.erb within rescues/layout (9.8ms) +  (7.1ms) CREATE TABLE "schema_migrations" ("version" varchar(255) NOT NULL)  +  (0.9ms) CREATE UNIQUE INDEX "unique_schema_migrations" ON "schema_migrations" ("version") + ActiveRecord::SchemaMigration Load (0.1ms) SELECT "schema_migrations".* FROM "schema_migrations" +Migrating to CreateMechanizeStoreFreights (20140508135827) +  (0.1ms) begin transaction +  (0.4ms) CREATE TABLE "mechanize_store_freights" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "value" float, "service" varchar(255), "order_id" integer, "zipcode" varchar(255), "created_at" datetime, "updated_at" datetime)  +  (0.1ms) CREATE INDEX "index_mechanize_store_freights_on_order_id" ON "mechanize_store_freights" ("order_id") + SQL (1.8ms) INSERT INTO "schema_migrations" ("version") VALUES (?) [["version", "20140508135827"]] +  (0.7ms) commit transaction +Migrating to CreateMechanizeStoreOrderStatuses (20140508135828) +  (0.1ms) begin transaction +  (0.4ms) CREATE TABLE "mechanize_store_order_statuses" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "name" varchar(255), "created_at" datetime, "updated_at" datetime) + SQL (0.1ms) INSERT INTO "schema_migrations" ("version") VALUES (?) [["version", "20140508135828"]] +  (0.7ms) commit transaction +Migrating to CreateMechanizeStorePaymentStatuses (20140508135829) +  (0.1ms) begin transaction +  (0.3ms) CREATE TABLE "mechanize_store_payment_statuses" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "name" varchar(255), "created_at" datetime, "updated_at" datetime) + SQL (0.1ms) INSERT INTO "schema_migrations" ("version") VALUES (?) [["version", "20140508135829"]] +  (0.7ms) commit transaction +Migrating to CreateMechanizeStorePaymentTypes (20140508135830) +  (0.1ms) begin transaction +  (0.3ms) CREATE TABLE "mechanize_store_payment_types" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "name" varchar(255), "created_at" datetime, "updated_at" datetime) + SQL (0.1ms) INSERT INTO "schema_migrations" ("version") VALUES (?) [["version", "20140508135830"]] +  (0.7ms) commit transaction +Migrating to CreateMechanizeStorePayments (20140508135831) +  (0.1ms) begin transaction +  (0.4ms) CREATE TABLE "mechanize_store_payments" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "order_id" integer, "payment_status_id" integer, "value" float, "paid_value" float, "paid_in" datetime, "plot" integer, "flag_id" integer, "created_at" datetime, "updated_at" datetime) +  (0.1ms) CREATE INDEX "index_mechanize_store_payments_on_payment_status_id" ON "mechanize_store_payments" ("payment_status_id") +  (0.1ms) CREATE INDEX "index_mechanize_store_payments_on_flag_id" ON "mechanize_store_payments" ("flag_id") + SQL (0.1ms) INSERT INTO "schema_migrations" ("version") VALUES (?) [["version", "20140508135831"]] +  (0.7ms) commit transaction +Migrating to CreateMechanizeStoreFlags (20140508135832) +  (0.1ms) begin transaction +  (0.3ms) CREATE TABLE "mechanize_store_flags" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "name" varchar(255), "created_at" datetime, "updated_at" datetime) + SQL (0.2ms) INSERT INTO "schema_migrations" ("version") VALUES (?) [["version", "20140508135832"]] +  (0.7ms) commit transaction +Migrating to CreateMechanizeStoreProducts (20140508135833) +  (0.1ms) begin transaction +  (0.4ms) CREATE TABLE "mechanize_store_products" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "name" varchar(255), "description" text, "short_description" varchar(255), "price" float, "weight" float, "length" float, "height" float, "product_category_id" integer, "created_at" datetime, "updated_at" datetime) +  (0.1ms) CREATE INDEX "index_mechanize_store_products_on_product_category_id" ON "mechanize_store_products" ("product_category_id") + SQL (0.1ms) INSERT INTO "schema_migrations" ("version") VALUES (?) [["version", "20140508135833"]] +  (0.7ms) commit transaction +Migrating to CreateMechanizeStoreProductPhotos (20140508135834) +  (0.1ms) begin transaction +  (0.5ms) CREATE TABLE "mechanize_store_product_photos" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "file_file_name" varchar(255), "file_content_type" varchar(255), "file_file_size" integer, "file_updated_at" datetime, "product_id" integer, "created_at" datetime, "updated_at" datetime)  +  (0.1ms) CREATE INDEX "index_mechanize_store_product_photos_on_product_id" ON "mechanize_store_product_photos" ("product_id") + SQL (0.1ms) INSERT INTO "schema_migrations" ("version") VALUES (?) [["version", "20140508135834"]] +  (0.8ms) commit transaction +Migrating to CreateMechanizeStoreOrders (20140508135835) +  (0.1ms) begin transaction +  (0.5ms) CREATE TABLE "mechanize_store_orders" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "order_status_id" integer, "store_id" integer, "delivery_date" datetime, "created_at" datetime, "updated_at" datetime) +  (0.2ms) CREATE INDEX "index_mechanize_store_orders_on_order_status_id" ON "mechanize_store_orders" ("order_status_id") +  (0.2ms) CREATE INDEX "index_mechanize_store_orders_on_store_id" ON "mechanize_store_orders" ("store_id") + SQL (0.1ms) INSERT INTO "schema_migrations" ("version") VALUES (?) [["version", "20140508135835"]] +  (0.7ms) commit transaction +Migrating to CreateMechanizeStoreProductCategories (20140508135836) +  (0.1ms) begin transaction +  (0.3ms) CREATE TABLE "mechanize_store_product_categories" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "name" varchar(255), "product_category_id" integer, "created_at" datetime, "updated_at" datetime) + SQL (0.2ms) INSERT INTO "schema_migrations" ("version") VALUES (?) [["version", "20140508135836"]] +  (0.7ms) commit transaction +Migrating to AddWidthToMechanizeStoreProduct (20140508135837) +  (0.1ms) begin transaction +  (0.6ms) ALTER TABLE "mechanize_store_products" ADD "width" float + SQL (0.2ms) INSERT INTO "schema_migrations" ("version") VALUES (?) [["version", "20140508135837"]] +  (0.8ms) commit transaction +Migrating to CreateMechanizeStoreOrderItems (20140508135838) +  (0.1ms) begin transaction +  (0.4ms) CREATE TABLE "mechanize_store_order_items" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "quantity" integer, "price" float, "order_id" integer, "product_id" integer, "created_at" datetime, "updated_at" datetime) +  (0.1ms) CREATE INDEX "index_mechanize_store_order_items_on_order_id" ON "mechanize_store_order_items" ("order_id") +  (0.1ms) CREATE INDEX "index_mechanize_store_order_items_on_product_id" ON "mechanize_store_order_items" ("product_id") + SQL (0.1ms) INSERT INTO "schema_migrations" ("version") VALUES (?) [["version", "20140508135838"]] +  (0.8ms) commit transaction +Migrating to AddPaymentTypeIdToPayment (20140508135839) +  (0.1ms) begin transaction +  (0.5ms) ALTER TABLE "mechanize_store_payments" ADD "payment_type_id" integer +  (0.2ms) CREATE INDEX "index_mechanize_store_payments_on_payment_type_id" ON "mechanize_store_payments" ("payment_type_id") + SQL (0.2ms) INSERT INTO "schema_migrations" ("version") VALUES (?) [["version", "20140508135839"]] +  (0.9ms) commit transaction +Migrating to AddTimeToFreight (20140508135840) +  (0.1ms) begin transaction +  (0.4ms) ALTER TABLE "mechanize_store_freights" ADD "delivery_time" integer + SQL (0.2ms) INSERT INTO "schema_migrations" ("version") VALUES (?) [["version", "20140508135840"]] +  (0.7ms) commit transaction + ActiveRecord::SchemaMigration Load (0.1ms) SELECT "schema_migrations".* FROM "schema_migrations" + + +Started GET "/mechanize_store/products/new" for 127.0.0.1 at 2014-05-08 10:59:02 -0300 + ActiveRecord::SchemaMigration Load (0.3ms) SELECT "schema_migrations".* FROM "schema_migrations" +Processing by MechanizeStore::ProductsController#new as HTML + MechanizeStore::ProductCategory Load (0.2ms) SELECT "mechanize_store_product_categories".* FROM "mechanize_store_product_categories" + Rendered /Users/wilbert/apps/mechanize_store/app/views/mechanize_store/products/_form.html.erb (218.5ms) + Rendered /Users/wilbert/apps/mechanize_store/app/views/mechanize_store/products/new.html.erb (242.4ms) +Completed 200 OK in 285ms (Views: 256.7ms | ActiveRecord: 0.8ms)