gistfile1.txt

+ bundle exec rake db:drop db:create db:migrate db:seed AUTO_ACCEPT=true RAILS_ENV=development --trace
/home/touch/.rvm/gems/ruby-1.9.2-p318@rails321/gems/ffaker-1.12.1/lib/ffaker.rb:2: warning: already initialized constant VERSION
** Invoke db:drop (first_time)
** Invoke db:load_config (first_time)
** Invoke rails_env (first_time)
** Execute rails_env
** Execute db:load_config
** Execute db:drop
** Invoke db:create (first_time)
** Invoke db:load_config 
** Execute db:create
** Invoke db:migrate (first_time)
** Invoke environment (first_time)
** Execute environment
** Invoke db:load_config 
** Execute db:migrate
[DEPRECATION] Your applications public directory contains an assets/products and/or assets/taxons subdirectory. 
    Run `rake spree:assets:relocate_images` to relocate the images.
==  SpreeZeroNineZero: migrating ==============================================
-- create_table(:addresses, {:force=>true})
   -> 0.0102s
-- create_table(:adjustments, {:force=>true})
   -> 0.0247s
-- create_table(:assets, {:force=>true})
   -> 0.0080s
-- create_table(:calculators, {:force=>true})
   -> 0.0072s
-- create_table(:checkouts, {:force=>true})
   -> 0.0074s
-- create_table(:configurations, {:force=>true})
   -> 0.0071s
-- add_index(:configurations, [:name, :type], {:name=>"index_configurations_on_name_and_type"})
   -> 0.0108s
-- create_table(:countries, {:force=>true})
   -> 0.0080s
-- create_table(:coupons, {:force=>true})
   -> 0.0074s
-- create_table(:creditcard_txns, {:force=>true})
   -> 0.0081s
-- create_table(:creditcards, {:force=>true})
   -> 0.0083s
-- create_table(:gateway_configurations, {:force=>true})
   -> 0.0080s
-- create_table(:gateway_option_values, {:force=>true})
   -> 0.0077s
-- create_table(:gateway_options, {:force=>true})
   -> 0.0074s
-- create_table(:gateways, {:force=>true})
   -> 0.0077s
-- create_table(:inventory_units, {:force=>true})
   -> 0.0079s
-- create_table(:line_items, {:force=>true})
   -> 0.0080s
-- add_index(:line_items, :order_id, {:name=>"index_line_items_on_order_id"})
   -> 0.0117s
-- add_index(:line_items, :variant_id, {:name=>"index_line_items_on_variant_id"})
   -> 0.0109s
-- create_table(:option_types, {:force=>true})
   -> 0.0078s
-- create_table(:option_types_prototypes, {:id=>false, :force=>true})
   -> 0.0070s
-- create_table(:option_values, {:force=>true})
   -> 0.0069s
-- create_table(:option_values_variants, {:id=>false, :force=>true})
   -> 0.0068s
-- add_index(:option_values_variants, :variant_id, {:name=>"index_option_values_variants_on_variant_id"})
   -> 0.0105s
-- create_table(:orders, {:force=>true})
   -> 0.0077s
-- add_index(:orders, :number, {:name=>"index_orders_on_number"})
   -> 0.0102s
-- create_table(:payments, {:force=>true})
   -> 0.0097s
-- create_table(:preferences, {:force=>true})
   -> 0.0072s
-- add_index(:preferences, [:owner_id, :owner_type, :attribute, :group_id, :group_type], {:name=>"index_preferences_on_owner_and_attribute_and_preference", :unique=>true})
   -> 0.0120s
-- create_table(:product_option_types, {:force=>true})
   -> 0.0077s
-- create_table(:product_properties, {:force=>true})
   -> 0.0078s
-- create_table(:products, {:force=>true})
   -> 0.0082s
-- add_index(:products, :available_on, {:name=>"index_products_on_available_on"})
   -> 0.0104s
-- add_index(:products, :deleted_at, {:name=>"index_products_on_deleted_at"})
   -> 0.0114s
-- add_index(:products, :name, {:name=>"index_products_on_name"})
   -> 0.0118s
-- add_index(:products, :permalink, {:name=>"index_products_on_permalink"})
   -> 0.0124s
-- create_table(:products_taxons, {:id=>false, :force=>true})
   -> 0.0073s
-- add_index(:products_taxons, :product_id, {:name=>"index_products_taxons_on_product_id"})
   -> 0.0104s
-- add_index(:products_taxons, :taxon_id, {:name=>"index_products_taxons_on_taxon_id"})
   -> 0.0124s
-- create_table(:properties, {:force=>true})
   -> 0.0093s
-- create_table(:properties_prototypes, {:id=>false, :force=>true})
   -> 0.0072s
-- create_table(:prototypes, {:force=>true})
   -> 0.0078s
-- create_table(:roles, {:force=>true})
   -> 0.0080s
-- create_table(:roles_users, {:id=>false, :force=>true})
   -> 0.0073s
-- add_index(:roles_users, :role_id, {:name=>"index_roles_users_on_role_id"})
   -> 0.0107s
-- add_index(:roles_users, :user_id, {:name=>"index_roles_users_on_user_id"})
   -> 0.0111s
-- create_table(:shipments, {:force=>true})
   -> 0.0077s
-- create_table(:shipping_categories, {:force=>true})
   -> 0.0072s
-- create_table(:shipping_methods, {:force=>true})
   -> 0.0937s
-- create_table(:state_events, {:force=>true})
   -> 0.0074s
-- create_table(:states, {:force=>true})
   -> 0.0073s
-- create_table(:tax_categories, {:force=>true})
   -> 0.0070s
-- create_table(:tax_rates, {:force=>true})
   -> 0.0078s
-- create_table(:taxonomies, {:force=>true})
   -> 0.0074s
-- create_table(:taxons, {:force=>true})
   -> 0.0074s
-- create_table(:users, {:force=>true})
   -> 0.0077s
-- create_table(:variants, {:force=>true})
   -> 0.0087s
-- add_index(:variants, :product_id, {:name=>"index_variants_on_product_id"})
   -> 0.0106s
-- create_table(:zone_members, {:force=>true})
   -> 0.0091s
-- create_table(:zones, {:force=>true})
   -> 0.0083s
==  SpreeZeroNineZero: migrated (0.6237s) =====================================

==  CreateIndexesForInventoryUnits: migrating =================================
-- add_index(:inventory_units, :variant_id)
   -> 0.0117s
-- add_index(:inventory_units, :order_id)
   -> 0.0108s
==  CreateIndexesForInventoryUnits: migrated (0.0226s) ========================

==  AddCountOnHandToVariantsAndProducts: migrating ============================
-- add_column(:variants, :count_on_hand, :integer, {:default=>0, :null=>false})
   -> 0.0106s
-- add_column(:products, :count_on_hand, :integer, {:default=>0, :null=>false})
   -> 0.0115s
-- Transfering inventory units with status on_hand to variants table...
   -> 0.1561s
-- Updating products count on hand
   -> 0.0037s
==  AddCountOnHandToVariantsAndProducts: migrated (0.2044s) ===================

==  ChangeTaxonsToNestedSet: migrating ========================================
-- add_column(:taxons, :lft, :integer)
   -> 0.0116s
-- add_column(:taxons, :rgt, :integer)
   -> 0.0119s
==  ChangeTaxonsToNestedSet: migrated (0.0275s) ===============================

==  MoveToConfigurableGateways: migrating =====================================
-- drop_table(:gateways)
   -> 0.0020s
-- drop_table(:gateway_options)
   -> 0.0015s
-- drop_table(:gateway_option_values)
   -> 0.0017s
-- drop_table(:gateway_configurations)
   -> 0.0016s
-- create_table(:gateways, {:force=>true})
   -> 0.0095s
==  MoveToConfigurableGateways: migrated (0.0166s) ============================

==  AddOpenIdAuthenticationTables: migrating ==================================
-- create_table(:open_id_authentication_associations, {:force=>true})
   -> 0.0086s
-- create_table(:open_id_authentication_nonces, {:force=>true})
   -> 0.0078s
==  AddOpenIdAuthenticationTables: migrated (0.0166s) =========================

==  AddOpenidFieldToUsers: migrating ==========================================
-- add_column(:users, :openid_identifier, :string)
   -> 0.0457s
-- add_index(:users, :openid_identifier)
   -> 0.0125s
-- change_column(:users, :login, :string, {:default=>nil, :null=>true})
   -> 0.0101s
-- change_column(:users, :crypted_password, :string, {:default=>nil, :null=>true})
   -> 0.0141s
-- change_column(:users, :salt, :string, {:default=>nil, :null=>true})
   -> 0.0149s
==  AddOpenidFieldToUsers: migrated (0.0977s) =================================

==  ChangePreferenceValueType: migrating ======================================
-- remove_index(:preferences, {:name=>"index_preferences_on_owner_and_attribute_and_preference"})
   -> 0.0110s
-- change_column(:preferences, :value, :text)
   -> 0.0131s
==  ChangePreferenceValueType: migrated (0.0242s) =============================

==  CreateBillingIntegrations: migrating ======================================
-- create_table(:billing_integrations)
   -> 0.0080s
==  CreateBillingIntegrations: migrated (0.0080s) =============================

==  ChargeRefactoring: migrating ==============================================
-- add_column(:orders, :completed_at, :timestamp)
   -> 0.0123s
-- remove_column(:checkouts, :completed_at)
   -> 0.0107s
-- change_column(:adjustments, :amount, :decimal, {:null=>true, :default=>nil, :precision=>8, :scale=>2})
   -> 0.1529s
-- remove_column(:adjustments, :secondary_type)
   -> 0.0112s
==  ChargeRefactoring: migrated (0.1957s) =====================================

==  AddSomeIndexes: migrating =================================================
-- add_index(:taxons, :permalink)
   -> 0.0134s
-- add_index(:taxons, :parent_id)
   -> 0.0110s
-- add_index(:taxons, :taxonomy_id)
   -> 0.0124s
-- add_index(:assets, :viewable_id)
   -> 0.0116s
-- add_index(:assets, [:viewable_type, :type])
   -> 0.0117s
-- add_index(:product_properties, :product_id)
   -> 0.0118s
-- add_index(:option_values_variants, [:variant_id, :option_value_id])
   -> 0.0109s
==  AddSomeIndexes: migrated (0.0833s) ========================================

==  CheckoutStateMachine: migrating ===========================================
-- add_column(:checkouts, :state, :string)
   -> 0.0107s
==  CheckoutStateMachine: migrated (0.0108s) ==================================

==  StateForShipments: migrating ==============================================
-- add_column(:shipments, :state, :string)
   -> 0.0106s
==  StateForShipments: migrated (0.0107s) =====================================

==  MakeStateEventsPolymorphic: migrating =====================================
-- rename_column(:state_events, :order_id, :stateful_id)
   -> 0.0129s
-- add_column(:state_events, :stateful_type, :string)
   -> 0.0103s
-- execute("UPDATE state_events SET stateful_type = 'Order'")
   -> 0.0003s
==  MakeStateEventsPolymorphic: migrated (0.0237s) ============================

==  ShipAddressIdForCheckouts: migrating ======================================
-- add_column(:checkouts, :ship_address_id, :integer)
   -> 0.0109s
==  ShipAddressIdForCheckouts: migrated (0.0109s) =============================

==  ShippingMethodIdForCheckouts: migrating ===================================
-- add_column(:checkouts, :shipping_method_id, :integer)
   -> 0.0110s
==  ShippingMethodIdForCheckouts: migrated (0.0110s) ==========================

==  CreditcardLastFourDigits: migrating =======================================
-- rename_column(:creditcards, :display_number, :last_digits)
   -> 0.0139s
-- select_all("SELECT * FROM creditcards")
   -> 0.0006s
==  CreditcardLastFourDigits: migrated (0.0146s) ==============================

==  PopulateLegacyShipmentState: migrating ====================================
-- select_all("SELECT * FROM shipments")
   -> 0.0006s
==  PopulateLegacyShipmentState: migrated (0.0007s) ===========================

==  AddCostPrice: migrating ===================================================
-- add_column(:variants, :cost_price, :decimal, {:null=>true, :default=>nil, :precision=>8, :scale=>2})
   -> 0.0704s
==  AddCostPrice: migrated (0.0705s) ==========================================

==  ShipmentIdForInventoryUnits: migrating ====================================
-- add_column(:inventory_units, :shipment_id, :integer)
   -> 0.0110s
-- add_index(:inventory_units, :shipment_id)
   -> 0.0112s
==  ShipmentIdForInventoryUnits: migrated (0.0547s) ===========================

==  CimFieldsForCreditcards: migrating ========================================
-- add_column(:creditcards, :gateway_customer_profile_id, :string)
   -> 0.0115s
-- add_column(:creditcards, :gateway_payment_profile_id, :string)
   -> 0.0111s
==  CimFieldsForCreditcards: migrated (0.0227s) ===============================

==  CreateReturnAuthorizations: migrating =====================================
-- create_table(:return_authorizations)
   -> 0.0077s
==  CreateReturnAuthorizations: migrated (0.0077s) ============================

==  AddReturnAuthorizationToInventoryUnits: migrating =========================
-- add_column(:inventory_units, :return_authorization_id, :integer)
   -> 0.0125s
==  AddReturnAuthorizationToInventoryUnits: migrated (0.0125s) ================

==  CreateTrackers: migrating =================================================
-- create_table(:trackers)
   -> 0.0083s
==  CreateTrackers: migrated (0.0083s) ========================================

==  CreditcardIdForCreditcardTxns: migrating ==================================
-- add_column(:creditcard_txns, :creditcard_id, :integer)
   -> 0.0116s
==  CreditcardIdForCreditcardTxns: migrated (0.0117s) =========================

==  OriginalCreditcardTxnIdForCreditcardTxns: migrating =======================
-- add_column(:creditcard_txns, :original_creditcard_txn_id, :integer)
   -> 0.0119s
==  OriginalCreditcardTxnIdForCreditcardTxns: migrated (0.0119s) ==============

==  AddTestModeToBillingIntegration: migrating ================================
-- add_column(:billing_integrations, :test_mode, :boolean, {:default=>true})
   -> 0.0111s
-- add_column(:billing_integrations, :server, :string, {:default=>"test"})
   -> 0.0112s
==  AddTestModeToBillingIntegration: migrated (0.0225s) =======================

==  CreatePaymentMethods: migrating ===========================================
-- create_table(:payment_methods)
   -> 0.0077s
==  CreatePaymentMethods: migrated (0.0077s) ==================================

==  PolymorphicPayments: migrating ============================================
-- remove_column(:payments, :type)
   -> 0.0115s
-- remove_column(:payments, :creditcard_id)
   -> 0.0111s
-- rename_column(:payments, :order_id, :payable_id)
   -> 0.0131s
-- change_table(:payments)
   -> 0.0408s
-- execute("UPDATE payments SET payable_type = 'Order'")
   -> 0.0003s
-- remove_column(:creditcards, :checkout_id)
   -> 0.0115s
==  PolymorphicPayments: migrated (0.1030s) ===================================

==  ChangePaymentsPaymentMethodToBelongsTo: migrating =========================
-- remove_column(:payments, :payment_method)
   -> 0.0110s
-- add_column(:payments, :payment_method_id, :integer)
   -> 0.0107s
==  ChangePaymentsPaymentMethodToBelongsTo: migrated (0.0219s) ================

==  AssignCreditcardTxnsToPayment: migrating ==================================
-- add_column(:creditcard_txns, :payment_id, :integer)
   -> 0.0107s
-- remove_column(:creditcard_txns, :creditcard_payment_id)
   -> 0.0123s
==  AssignCreditcardTxnsToPayment: migrated (0.0237s) =========================

==  StiForTransactions: migrating =============================================
-- rename_table(:creditcard_txns, :transactions)
   -> 0.0016s
-- add_column(:transactions, :type, :string)
   -> 0.0150s
-- remove_column(:transactions, :creditcard_id)
   -> 0.0116s
-- execute("UPDATE transactions SET type = 'CreditcardTxn'")
   -> 0.0003s
==  StiForTransactions: migrated (0.0288s) ====================================

==  DropBillingIntegrations: migrating ========================================
-- drop_table(:billing_integrations)
   -> 0.0018s
==  DropBillingIntegrations: migrated (0.0018s) ===============================

==  DeletedAtForPaymentMethods: migrating =====================================
-- change_table(:payment_methods)
   -> 0.0110s
==  DeletedAtForPaymentMethods: migrated (0.0111s) ============================

==  AddAdjustmentsIndex: migrating ============================================
-- add_index(:adjustments, :order_id)
   -> 0.0113s
==  AddAdjustmentsIndex: migrated (0.0113s) ===================================

==  AddAltTextToImages: migrating =============================================
-- add_column(:assets, :alt, :text)
   -> 0.0115s
==  AddAltTextToImages: migrated (0.0116s) ====================================

==  FixExistingCouponCredits: migrating =======================================
-- execute("UPDATE adjustments SET type='PromotionCredit' WHERE type='CouponCredit'")
   -> 0.0005s
-- execute("UPDATE adjustments SET adjustment_source_type='Promotion' WHERE adjustment_source_type='Coupon'")
   -> 0.0003s
==  FixExistingCouponCredits: migrated (0.0009s) ==============================

==  AddDisplayToPaymentMethods: migrating =====================================
-- add_column(:payment_methods, :display, :string, {:default=>nil})
   -> 0.0162s
==  AddDisplayToPaymentMethods: migrated (0.0163s) ============================

==  AddAddressesCheckoutsIndexes: migrating ===================================
-- add_index(:addresses, :firstname)
   -> 0.0114s
-- add_index(:addresses, :lastname)
   -> 0.0113s
-- add_index(:checkouts, :order_id)
   -> 0.0117s
-- add_index(:checkouts, :bill_address_id)
   -> 0.0129s
==  AddAddressesCheckoutsIndexes: migrated (0.0475s) ==========================

==  AddIconToTaxons: migrating ================================================
-- column_exists?(:taxons, :icon_file_name)
   -> 0.0015s
-- add_column(:taxons, :icon_file_name, :string)
   -> 0.0131s
-- add_column(:taxons, :icon_content_type, :string)
   -> 0.0110s
-- add_column(:taxons, :icon_file_size, :integer)
   -> 0.0108s
-- add_column(:taxons, :icon_updated_at, :datetime)
   -> 0.0113s
==  AddIconToTaxons: migrated (0.0482s) =======================================

==  AddDescriptionToTaxons: migrating =========================================
-- column_exists?(:taxons, :description)
   -> 0.0017s
-- add_column(:taxons, :description, :text)
   -> 0.0130s
==  AddDescriptionToTaxons: migrated (0.0149s) ================================

==  IndexForShipmentsNumber: migrating ========================================
-- add_index(:shipments, :number)
   -> 0.0132s
==  IndexForShipmentsNumber: migrated (0.0132s) ===============================

==  AddIndexOnUsersPersistenceToken: migrating ================================
-- add_index(:users, :persistence_token)
   -> 0.0130s
==  AddIndexOnUsersPersistenceToken: migrated (0.0131s) =======================

==  AddDefaultToTaxCategories: migrating ======================================
-- add_column(:tax_categories, :is_default, :boolean, {:default=>false})
   -> 0.0104s
==  AddDefaultToTaxCategories: migrated (0.0105s) =============================

==  AddDisplayToShippingMethods: migrating ====================================
-- add_column(:shipping_methods, :display_on, :string, {:default=>nil})
   -> 0.0105s
==  AddDisplayToShippingMethods: migrated (0.0105s) ===========================

==  RenamePaymentMethodDisplay: migrating =====================================
-- rename_column(:payment_methods, :display, :display_on)
   -> 0.0145s
==  RenamePaymentMethodDisplay: migrated (0.0146s) ============================

==  RenamePreferencesField: migrating =========================================
-- rename_column(:preferences, :attribute, :name)
   -> 0.0168s
==  RenamePreferencesField: migrated (0.0169s) ================================

==  AddGuestFlag: migrating ===================================================
-- add_column(:users, :guest, :boolean)
   -> 0.0111s
==  AddGuestFlag: migrated (0.0112s) ==========================================

==  DropOrderToken: migrating =================================================
-- remove_column(:orders, :token)
   -> 0.0116s
==  DropOrderToken: migrated (0.0117s) ========================================

==  PaymentsStateAndAssignedToOrderOnly: migrating ============================
-- rename_column(:payments, :payable_id, :order_id)
   -> 0.0148s
-- remove_column(:payments, :payable_type)
   -> 0.0109s
-- add_column(:payments, :state, :string)
   -> 0.0102s
==  PaymentsStateAndAssignedToOrderOnly: migrated (0.0361s) ===================

==  CreateAddressKeysForOrder: migrating ======================================
-- add_column(:orders, :bill_address_id, :integer)
   -> 0.0109s
-- add_column(:orders, :ship_address_id, :integer)
   -> 0.0104s
==  CreateAddressKeysForOrder: migrated (0.0214s) =============================

==  PaymentTotalForOrders: migrating ==========================================
-- add_column(:orders, :payment_total, :decimal, {:precision=>8, :scale=>2, :default=>0.0})
   -> 0.0113s
==  PaymentTotalForOrders: migrated (0.0114s) =================================

==  ShippingMethodIdForOrders: migrating ======================================
-- add_column(:orders, :shipping_method_id, :integer)
   -> 0.0112s
==  ShippingMethodIdForOrders: migrated (0.0112s) =============================

==  AddShipmentAndPaymentState: migrating =====================================
-- add_column(:orders, :shipment_state, :string)
   -> 0.0110s
-- add_column(:orders, :payment_state, :string)
   -> 0.0110s
==  AddShipmentAndPaymentState: migrated (0.0221s) ============================

==  RefactorAdjustments: migrating ============================================
-- change_table(:adjustments)
   -> 0.2487s
==  RefactorAdjustments: migrated (0.2488s) ===================================

==  ResponseCodeAndAvsResponseForPayments: migrating ==========================
-- add_column(:payments, :response_code, :string)
   -> 0.0103s
-- add_column(:payments, :avs_response, :string)
   -> 0.0107s
==  ResponseCodeAndAvsResponseForPayments: migrated (0.0211s) =================

==  ChangeGuestFlagToAnonymous: migrating =====================================
-- rename_column(:users, :guest, :anonymous)
   -> 0.0144s
==  ChangeGuestFlagToAnonymous: migrated (0.0145s) ============================

==  EmailForOrders: migrating =================================================
-- add_column(:orders, :email, :string)
   -> 0.0110s
==  EmailForOrders: migrated (0.0111s) ========================================

==  CreateMailMethods: migrating ==============================================
-- create_table(:mail_methods)
   -> 0.0072s
==  CreateMailMethods: migrated (0.0073s) =====================================

==  RenameFrozenToLocked: migrating ===========================================
-- rename_column(:adjustments, :frozen, :locked)
   -> 0.0126s
==  RenameFrozenToLocked: migrated (0.0127s) ==================================

==  MoveSpecialInstructionsToOrders: migrating ================================
-- add_column(:orders, :special_instructions, :text)
   -> 0.0137s
-- execute("UPDATE orders SET special_instructions = (SELECT special_instructions FROM checkouts WHERE order_id = orders.id)")
   -> 0.0005s
==  MoveSpecialInstructionsToOrders: migrated (0.0142s) =======================

==  CreateLogEntries: migrating ===============================================
-- create_table(:log_entries)
   -> 0.0077s
==  CreateLogEntries: migrated (0.0077s) ======================================

==  MigrateTransactionsToPaymentState: migrating ==============================
==  MigrateTransactionsToPaymentState: migrated (0.0030s) =====================

==  DeleteInProgressOrders: migrating =========================================
-- execute("DELETE FROM orders WHERE orders.state = 'in_progress'")
   -> 0.0003s
-- execute("DELETE FROM adjustments WHERE order_id NOT IN (SELECT id FROM orders)")
   -> 0.0003s
-- execute("DELETE FROM checkouts WHERE order_id NOT IN (SELECT id FROM orders)")
   -> 0.0002s
-- execute("DELETE FROM shipments WHERE order_id NOT IN (SELECT id FROM orders)")
   -> 0.0003s
-- execute("DELETE FROM payments WHERE order_id NOT IN (SELECT id FROM orders)")
   -> 0.0003s
-- execute("DELETE FROM line_items WHERE order_id NOT IN (SELECT id FROM orders)")
   -> 0.0003s
-- execute("DELETE FROM inventory_units WHERE order_id NOT IN (SELECT id FROM orders)")
   -> 0.0003s
==  DeleteInProgressOrders: migrated (0.0023s) ================================

==  MigrateCheckoutToOrders: migrating ========================================
-- select_all("SELECT * FROM orders")
   -> 0.0005s
==  MigrateCheckoutToOrders: migrated (0.0005s) ===============================

==  RemoveShippedState: migrating =============================================
-- execute("UPDATE orders SET state = 'complete' WHERE state = 'shipped'")
   -> 0.0005s
-- select_all("SELECT shipments.id FROM shipments WHERE order_id IN (SELECT orders.id FROM orders WHERE orders.state = 'shipped')")
   -> 0.0005s
==  RemoveShippedState: migrated (0.0011s) ====================================

==  PreventNilPaymentTotal: migrating =========================================
-- execute("UPDATE orders SET payment_total = 0.0 WHERE payment_total IS NULL")
   -> 0.0003s
==  PreventNilPaymentTotal: migrated (0.0004s) ================================

==  PreventNilEmail: migrating ================================================
-- execute("UPDATE orders SET email = 'guest@example.com' WHERE email IS NULL")
   -> 0.0005s
-- execute("UPDATE orders SET email = 'guest@example.com' WHERE email = ''")
   -> 0.0002s
==  PreventNilEmail: migrated (0.0009s) =======================================

==  GenerateAnonymousUsers: migrating =========================================
==  GenerateAnonymousUsers: migrated (0.0040s) ================================

==  UpdateOrderState: migrating ===============================================
==  UpdateOrderState: migrated (0.0030s) ======================================

==  CleanupLegacyTables: migrating ============================================
-- drop_table(:checkouts)
   -> 0.0020s
-- drop_table(:transactions)
   -> 0.0016s
-- drop_table(:open_id_authentication_associations)
   -> 0.0016s
-- drop_table(:open_id_authentication_nonces)
   -> 0.0015s
==  CleanupLegacyTables: migrated (0.0068s) ===================================

==  RemoveNumberAndCvvFromCredicard: migrating ================================
-- remove_column(:creditcards, :number)
   -> 0.0126s
-- remove_column(:creditcards, :verification_value)
   -> 0.0113s
==  RemoveNumberAndCvvFromCredicard: migrated (0.0240s) =======================

==  DropAnonymousFieldForUser: migrating ======================================
-- remove_column(:users, :anonymous)
   -> 0.0106s
==  DropAnonymousFieldForUser: migrated (0.0107s) =============================

==  RenamedRmaCancelledState: migrating =======================================
-- execute("UPDATE return_authorizations SET state = 'canceled' WHERE state = 'cancelled'")
   -> 0.0004s
==  RenamedRmaCancelledState: migrated (0.0005s) ==============================

==  FixProblematicIndexNames: migrating =======================================
-- remove_index(:preferences, {:name=>"index_preferences_on_owner_and_attribute_and_preference"})
-- add_index(:preferences, [:owner_id, :owner_type, :name, :group_id, :group_type], {:name=>"ix_prefs_on_owner_attr_pref", :unique=>true})
   -> 0.0114s
==  FixProblematicIndexNames: migrated (0.0122s) ==============================

==  AddPositionToVariants: migrating ==========================================
-- add_column(:variants, :position, :integer)
   -> 0.0110s
==  AddPositionToVariants: migrated (0.0111s) =================================

==  AddNextStateToStateEvents: migrating ======================================
-- add_column(:state_events, :next_state, :string)
   -> 0.0113s
==  AddNextStateToStateEvents: migrated (0.0114s) =============================

==  AddPositionToOptionTypes: migrating =======================================
-- add_column(:option_types, :position, :integer, {:null=>false, :default=>0})
   -> 0.0107s
==  AddPositionToOptionTypes: migrated (0.0109s) ==============================

==  RemoveTrailingSlashesInTaxonPermalinks: migrating =========================
-- select_all("SELECT * FROM taxons")
   -> 0.0009s
==  RemoveTrailingSlashesInTaxonPermalinks: migrated (0.0010s) ================

==  CreateActivators: migrating ===============================================
-- create_table(:activators, {:force=>true})
   -> 0.0087s
==  CreateActivators: migrated (0.0088s) ======================================

==  EligibleForAdjustments: migrating =========================================
-- add_column(:adjustments, :eligible, :boolean, {:default=>true})
   -> 0.0118s
==  EligibleForAdjustments: migrated (0.0119s) ================================

==  NamespaceTopLevelModels: migrating ========================================
-- rename_table(:activators, :spree_activators)
   -> 0.0019s
-- rename_table(:addresses, :spree_addresses)
   -> 0.0018s
-- rename_table(:adjustments, :spree_adjustments)
   -> 0.0015s
-- rename_table(:configurations, :spree_configurations)
   -> 0.0015s
-- rename_table(:assets, :spree_assets)
   -> 0.0020s
-- rename_table(:calculators, :spree_calculators)
   -> 0.0015s
-- rename_table(:countries, :spree_countries)
   -> 0.0020s
-- rename_table(:creditcards, :spree_creditcards)
   -> 0.0016s
-- rename_table(:gateways, :spree_gateways)
   -> 0.0018s
-- rename_table(:inventory_units, :spree_inventory_units)
   -> 0.0017s
-- rename_table(:line_items, :spree_line_items)
   -> 0.0016s
-- rename_table(:log_entries, :spree_log_entries)
   -> 0.0016s
-- rename_table(:mail_methods, :spree_mail_methods)
   -> 0.0017s
-- rename_table(:option_types, :spree_option_types)
   -> 0.0018s
-- rename_table(:option_values, :spree_option_values)
   -> 0.0017s
-- rename_table(:option_types_prototypes, :spree_option_types_prototypes)
   -> 0.0016s
-- rename_table(:option_values_variants, :spree_option_values_variants)
   -> 0.0015s
-- rename_table(:orders, :spree_orders)
   -> 0.0016s
-- rename_table(:payments, :spree_payments)
   -> 0.0017s
-- rename_table(:payment_methods, :spree_payment_methods)
   -> 0.0020s
-- rename_table(:preferences, :spree_preferences)
   -> 0.0016s
-- rename_table(:products, :spree_products)
   -> 0.0020s
-- rename_table(:product_option_types, :spree_product_option_types)
   -> 0.0017s
-- rename_table(:product_properties, :spree_product_properties)
   -> 0.0017s
-- rename_table(:products_taxons, :spree_products_taxons)
   -> 0.0016s
-- rename_table(:properties, :spree_properties)
   -> 0.0025s
-- rename_table(:prototypes, :spree_prototypes)
   -> 0.0015s
-- rename_table(:properties_prototypes, :spree_properties_prototypes)
   -> 0.0014s
-- rename_table(:return_authorizations, :spree_return_authorizations)
   -> 0.0021s
-- rename_table(:roles, :spree_roles)
   -> 0.0016s
-- rename_table(:roles_users, :spree_roles_users)
   -> 0.0015s
-- rename_table(:shipments, :spree_shipments)
   -> 0.0017s
-- rename_table(:shipping_categories, :spree_shipping_categories)
   -> 0.0016s
-- rename_table(:shipping_methods, :spree_shipping_methods)
   -> 0.0015s
-- rename_table(:states, :spree_states)
   -> 0.0017s
-- rename_table(:state_events, :spree_state_events)
   -> 0.0015s
-- rename_table(:tax_categories, :spree_tax_categories)
   -> 0.0014s
-- rename_table(:tax_rates, :spree_tax_rates)
   -> 0.0015s
-- rename_table(:taxons, :spree_taxons)
   -> 0.0016s
-- rename_table(:taxonomies, :spree_taxonomies)
   -> 0.0017s
-- rename_table(:trackers, :spree_trackers)
   -> 0.0016s
-- rename_table(:users, :spree_users)
   -> 0.0020s
-- rename_table(:variants, :spree_variants)
   -> 0.0016s
-- rename_table(:zones, :spree_zones)
   -> 0.0017s
-- rename_table(:zone_members, :spree_zone_members)
   -> 0.0019s
==  NamespaceTopLevelModels: migrated (0.0778s) ===============================

==  MigrateNamespacedPolymorphicModels: migrating =============================
-- execute("UPDATE spree_payments SET source_type = CONCAT('Spree::', source_type) where source_type NOT LIKE 'Spree::%' AND source_type IS NOT NULL")
   -> 0.0007s
-- execute("UPDATE spree_adjustments SET source_type = CONCAT('Spree::', source_type) where source_type NOT LIKE 'Spree::%' AND source_type IS NOT NULL")
   -> 0.0003s
-- execute("UPDATE spree_log_entries SET source_type = CONCAT('Spree::', source_type) where source_type NOT LIKE 'Spree::%' AND source_type IS NOT NULL")
   -> 0.0003s
-- execute("UPDATE spree_adjustments SET originator_type = CONCAT('Spree::', originator_type) where originator_type NOT LIKE 'Spree::%' AND originator_type IS NOT NULL")
   -> 0.0002s
-- execute("UPDATE spree_calculators SET calculable_type = CONCAT('Spree::', calculable_type) where calculable_type NOT LIKE 'Spree::%' AND calculable_type IS NOT NULL")
   -> 0.0004s
-- execute("UPDATE spree_preferences SET owner_type = CONCAT('Spree::', owner_type) where owner_type NOT LIKE 'Spree::%' AND owner_type IS NOT NULL")
   -> 0.0005s
-- execute("UPDATE spree_state_events SET stateful_type = CONCAT('Spree::', stateful_type) where stateful_type NOT LIKE 'Spree::%' AND stateful_type IS NOT NULL")
   -> 0.0003s
-- execute("UPDATE spree_activators SET type = CONCAT('Spree::', type) where type NOT LIKE 'Spree::%' AND type IS NOT NULL")
   -> 0.0003s
-- execute("UPDATE spree_assets SET type = CONCAT('Spree::', type) where type NOT LIKE 'Spree::%' AND type IS NOT NULL")
   -> 0.0004s
-- execute("UPDATE spree_calculators SET type = CONCAT('Spree::', type) where type NOT LIKE 'Spree::%' AND type IS NOT NULL")
   -> 0.0006s
-- execute("UPDATE spree_configurations SET type = CONCAT('Spree::', type) where type NOT LIKE 'Spree::%' AND type IS NOT NULL")
   -> 0.0003s
-- execute("UPDATE spree_gateways SET type = CONCAT('Spree::', type) where type NOT LIKE 'Spree::%' AND type IS NOT NULL")
   -> 0.0003s
-- execute("UPDATE spree_payment_methods SET type = CONCAT('Spree::', type) where type NOT LIKE 'Spree::%' AND type IS NOT NULL")
   -> 0.0003s
-- execute("UPDATE spree_assets SET viewable_type = CONCAT('Spree::', viewable_type) where viewable_type NOT LIKE 'Spree::%' AND viewable_type IS NOT NULL")
   -> 0.0003s
-- execute("UPDATE spree_zone_members SET zoneable_type = CONCAT('Spree::', zoneable_type) where zoneable_type NOT LIKE 'Spree::%' AND zoneable_type IS NOT NULL")
   -> 0.0003s
==  MigrateNamespacedPolymorphicModels: migrated (0.2456s) ====================

==  MakeAdjustmentsPolymorphic: migrating =====================================
-- add_column(:spree_adjustments, :adjustable_type, :string)
   -> 0.0156s
-- rename_column(:spree_adjustments, :order_id, :adjustable_id)
   -> 0.0129s
-- execute("UPDATE spree_adjustments SET adjustable_type = 'Spree::Order'")
   -> 0.0003s
==  MakeAdjustmentsPolymorphic: migrated (0.0289s) ============================

==  AddCompanyToAddresses: migrating ==========================================
-- add_column(:spree_addresses, :company, :string)
   -> 0.0126s
==  AddCompanyToAddresses: migrated (0.0127s) =================================

==  AddIncTaxToTaxRates: migrating ============================================
-- add_column(:spree_tax_rates, :inc_tax, :boolean, {:default=>false})
   -> 0.0111s
==  AddIncTaxToTaxRates: migrated (0.0111s) ===================================

==  RenameIncPriceAttribute: migrating ========================================
-- rename_column(:spree_tax_rates, :inc_tax, :included_in_price)
   -> 0.0139s
==  RenameIncPriceAttribute: migrated (0.0140s) ===============================

==  AddDefaultTaxZone: migrating ==============================================
-- add_column(:spree_zones, :default_tax, :boolean, {:default=>false})
   -> 0.0115s
==  AddDefaultTaxZone: migrated (0.0116s) =====================================

==  AssociateShippingMethodsAndShippingCategories: migrating ==================
-- change_table(:spree_shipping_methods)
   -> 0.0118s
==  AssociateShippingMethodsAndShippingCategories: migrated (0.0119s) =========

==  AddMatchRulesToShippingMethods: migrating =================================
-- add_column(:spree_shipping_methods, :match_none, :boolean)
   -> 0.0136s
-- add_column(:spree_shipping_methods, :match_all, :boolean)
   -> 0.0112s
-- add_column(:spree_shipping_methods, :match_one, :boolean)
   -> 0.0111s
==  AddMatchRulesToShippingMethods: migrated (0.0361s) ========================

==  NewPreferences: migrating =================================================
-- add_column(:spree_preferences, :key, :string)
   -> 0.0125s
-- add_column(:spree_preferences, :value_type, :string)
   -> 0.0111s
-- add_index(:spree_preferences, :key, {:unique=>true})
   -> 0.0117s
-- remove_index(:spree_preferences, {:name=>"ix_prefs_on_owner_attr_pref"})
   -> 0.0121s
-- change_column(:spree_preferences, :name, :string, {:null=>true})
   -> 0.0134s
-- change_column(:spree_preferences, :owner_id, :integer, {:null=>true})
   -> 0.0122s
-- change_column(:spree_preferences, :owner_type, :string, {:null=>true})
   -> 0.0151s
-- change_column(:spree_preferences, :group_id, :integer, {:null=>true})
   -> 0.0080s
-- change_column(:spree_preferences, :group_type, :string, {:null=>true})
   -> 0.0123s
-- execute("select id, type from spree_configurations")
   -> 0.0003s
-- execute("select id, owner_id, name from spree_preferences where owner_type = 'Spree::Configuration'")
   -> 0.0003s
==  NewPreferences: migrated (0.1137s) ========================================

==  AddDeletedAtToTaxCategory: migrating ======================================
-- add_column(:spree_tax_categories, :deleted_at, :datetime)
   -> 0.0114s
==  AddDeletedAtToTaxCategory: migrated (0.0114s) =============================

==  RenameColumnsForDevise: migrating =========================================
-- column_exists?(:spree_users, :password_salt)
   -> 0.0021s
-- rename_column(:spree_users, :crypted_password, :encrypted_password)
   -> 0.0164s
-- rename_column(:spree_users, :salt, :password_salt)
   -> 0.0155s
-- rename_column(:spree_users, :remember_token_expires_at, :remember_created_at)
   -> 0.0140s
-- rename_column(:spree_users, :login_count, :sign_in_count)
   -> 0.1028s
-- rename_column(:spree_users, :failed_login_count, :failed_attempts)
   -> 0.0184s
-- rename_column(:spree_users, :single_access_token, :reset_password_token)
   -> 0.0155s
-- rename_column(:spree_users, :current_login_at, :current_sign_in_at)
   -> 0.0189s
-- rename_column(:spree_users, :last_login_at, :last_sign_in_at)
   -> 0.0169s
-- rename_column(:spree_users, :current_login_ip, :current_sign_in_ip)
   -> 0.0158s
-- rename_column(:spree_users, :last_login_ip, :last_sign_in_ip)
   -> 0.0176s
-- add_column(:spree_users, :authentication_token, :string)
   -> 0.0135s
-- add_column(:spree_users, :unlock_token, :string)
   -> 0.0140s
-- add_column(:spree_users, :locked_at, :datetime)
   -> 0.0155s
-- column_exists?(:spree_users, :api_key)
   -> 0.0022s
-- remove_column(:spree_users, :openid_identifier)
   -> 0.0140s
==  RenameColumnsForDevise: migrated (0.3139s) ================================

==  ConvertUserRememberField: migrating =======================================
-- remove_column(:spree_users, :remember_created_at)
   -> 0.0130s
-- add_column(:spree_users, :remember_created_at, :datetime)
   -> 0.0156s
==  ConvertUserRememberField: migrated (0.0287s) ==============================

==  CreateTokenizedPermissions: migrating =====================================
-- create_table(:tokenized_permissions)
   -> 0.0090s
-- add_index(:tokenized_permissions, [:permissable_id, :permissable_type], {:name=>"index_tokenized_name_and_type"})
   -> 0.0128s
==  CreateTokenizedPermissions: migrated (0.0219s) ============================

==  TokensForLegacyOrders: migrating ==========================================
==  TokensForLegacyOrders: migrated (0.0055s) =================================

==  NamespaceTokenizedPermission: migrating ===================================
-- rename_table(:tokenized_permissions, :spree_tokenized_permissions)
   -> 0.0020s
==  NamespaceTokenizedPermission: migrated (0.0021s) ==========================

==  MigrateTokenizedPermissions: migrating ====================================
-- execute("UPDATE spree_tokenized_permissions SET permissable_type = CONCAT('Spree::', permissable_type) WHERE permissable_type NOT LIKE 'Spree::%' AND permissable_type IS NOT NULL")
   -> 0.0005s
==  MigrateTokenizedPermissions: migrated (0.0015s) ===========================

==  AddApiKeyToUsers: migrating ===============================================
-- add_column(:spree_users, :api_key, :string, {:limit=>40})
   -> 0.0146s
==  AddApiKeyToUsers: migrated (0.0147s) ======================================

==  RenameCouponsToPromotions: migrating ======================================
-- table_exists?(:promotions)
   -> 0.0010s
-- rename_table(:coupons, :promotions)
   -> 0.0025s
==  RenameCouponsToPromotions: migrated (0.0036s) =============================

==  CreatePromotionRules: migrating ===========================================
-- create_table(:promotion_rules)
   -> 0.0075s
-- add_index(:promotion_rules, :product_group_id)
   -> 0.0118s
-- add_index(:promotion_rules, :user_id)
   -> 0.0110s
-- create_table(:products_promotion_rules)
   -> 0.0067s
-- remove_column(:products_promotion_rules, :id)
   -> 0.0110s
-- add_index(:products_promotion_rules, :product_id)
   -> 0.0101s
-- add_index(:products_promotion_rules, :promotion_rule_id)
   -> 0.0108s
==  CreatePromotionRules: migrated (0.0693s) ==================================

==  MatchPolicyForPromotions: migrating =======================================
-- add_column(:promotions, :match_policy, :string, {:default=>"all"})
   -> 0.0116s
==  MatchPolicyForPromotions: migrated (0.0117s) ==============================

==  CreatePromotionRulesUsers: migrating ======================================
-- create_table(:promotion_rules_users)
   -> 0.0071s
-- remove_column(:promotion_rules_users, :id)
   -> 0.0098s
-- add_index(:promotion_rules_users, :user_id)
   -> 0.0105s
-- add_index(:promotion_rules_users, :promotion_rule_id)
   -> 0.0111s
==  CreatePromotionRulesUsers: migrated (0.0386s) =============================

==  NameForPromotions: migrating ==============================================
-- add_column(:promotions, :name, :string)
   -> 0.0124s
==  NameForPromotions: migrated (0.0125s) =====================================

==  UpdateCalculableTypeForPromotions: migrating ==============================
-- execute("UPDATE spree_calculators SET calculable_type = 'Promotion' WHERE calculable_type = 'Coupon'")
   -> 0.0004s
==  UpdateCalculableTypeForPromotions: migrated (0.0004s) =====================

==  MigrateAdjustments: migrating =============================================
-- execute("UPDATE spree_adjustments SET amount = 0.0 WHERE amount IS NULL")
   -> 0.0003s
-- execute("UPDATE spree_adjustments SET mandatory = 't' WHERE locked = 't'")
   -> 0.0003s
==  MigrateAdjustments: migrated (0.0007s) ====================================

==  PromotionChangesToSubclassOfActivator: migrating ==========================
-- drop_table(:promotions)
   -> 0.0017s
-- rename_column(:promotion_rules, :promotion_id, :activator_id)
   -> 0.0128s
==  PromotionChangesToSubclassOfActivator: migrated (0.0145s) =================

==  CreatePromotionActions: migrating =========================================
-- create_table(:promotion_actions)
   -> 0.0070s
==  CreatePromotionActions: migrated (0.0071s) ================================

==  CreatePromotionActionLineItems: migrating =================================
-- create_table(:promotion_action_line_items)
   -> 0.0082s
==  CreatePromotionActionLineItems: migrated (0.0083s) ========================

==  NamespacePromoTables: migrating ===========================================
-- rename_table(:promotion_actions, :spree_promotion_actions)
   -> 0.0019s
-- rename_table(:promotion_rules, :spree_promotion_rules)
   -> 0.0016s
-- rename_table(:promotion_rules_users, :spree_promotion_rules_users)
   -> 0.0016s
-- rename_table(:promotion_action_line_items, :spree_promotion_action_line_items)
   -> 0.0016s
-- rename_table(:products_promotion_rules, :spree_products_promotion_rules)
   -> 0.0016s
-- execute("UPDATE spree_promotion_actions SET type = CONCAT('Spree::', type) where type NOT LIKE 'Spree::%' AND type IS NOT NULL")
   -> 0.0004s
-- execute("UPDATE spree_promotion_rules SET type = CONCAT('Spree::', type) where type NOT LIKE 'Spree::%' AND type IS NOT NULL")
   -> 0.0003s
-- add_column(:spree_activators, :usage_limit, :integer)
   -> 0.0104s
-- add_column(:spree_activators, :match_policy, :string, {:default=>"all"})
   -> 0.0111s
-- add_column(:spree_activators, :code, :string)
   -> 0.0112s
-- add_column(:spree_activators, :advertise, :boolean, {:default=>false})
   -> 0.0136s
-- remove_column(:spree_preferences, :group_id)
   -> 0.0107s
-- remove_column(:spree_preferences, :group_type)
   -> 0.0112s
==  NamespacePromoTables: migrated (0.0830s) ==================================

==  CreateSpreePendingPromotions: migrating ===================================
-- create_table(:spree_pending_promotions)
   -> 0.0075s
-- add_index(:spree_pending_promotions, :user_id)
   -> 0.0113s
-- add_index(:spree_pending_promotions, :promotion_id)
   -> 0.0115s
==  CreateSpreePendingPromotions: migrated (0.0305s) ==========================

==  ContentVisitedEvent: migrating ============================================
-- add_column(:spree_activators, :path, :string)
   -> 0.0123s
==  ContentVisitedEvent: migrated (0.0160s) ===================================

==  CreateSkrillTransactions: migrating =======================================
-- create_table(:spree_skrill_transactions)
   -> 0.0088s
==  CreateSkrillTransactions: migrated (0.0089s) ==============================

==  CreateRelationTypes: migrating ============================================
-- create_table(:relation_types)
   -> 0.0109s
==  CreateRelationTypes: migrated (0.0110s) ===================================

==  CreateRelations: migrating ================================================
-- create_table(:relations, {:force=>true})
   -> 0.0081s
==  CreateRelations: migrated (0.0082s) =======================================

==  AddDiscountToRelation: migrating ==========================================
-- add_column(:relations, :discount_amount, :decimal, {:precision=>8, :scale=>2, :default=>0.0})
   -> 0.0111s
==  AddDiscountToRelation: migrated (0.0112s) =================================

==  PrefixTablesWithSpree: migrating ==========================================
-- rename_table(:relation_types, :spree_relation_types)
   -> 0.0017s
-- rename_table(:relations, :spree_relations)
   -> 0.0015s
==  PrefixTablesWithSpree: migrated (0.0033s) =================================

==  UpdateRelationTypes: migrating ============================================
==  UpdateRelationTypes: migrated (0.0095s) ===================================

==  CreateWishlists: migrating ================================================
-- create_table(:wishlists)
   -> 0.0077s
==  CreateWishlists: migrated (0.0078s) =======================================

==  CreateWishedProducts: migrating ===========================================
-- create_table(:wished_products)
   -> 0.0073s
==  CreateWishedProducts: migrated (0.0074s) ==================================

==  PrefixWishlistTablesWithSpree: migrating ==================================
-- rename_table(:wishlists, :spree_wishlists)
   -> 0.0019s
-- rename_table(:wished_products, :spree_wished_products)
   -> 0.0016s
==  PrefixWishlistTablesWithSpree: migrated (0.0036s) =========================

==  CreateViewables: migrating ================================================
-- create_table(:viewables)
   -> 0.0076s
-- add_index(:viewables, :title)
   -> 0.0111s
==  CreateViewables: migrated (0.0188s) =======================================

==  AddRowAndColumnToViewable: migrating ======================================
-- add_column(:viewables, :row, :integer)
   -> 0.0109s
-- add_column(:viewables, :column, :integer)
   -> 0.0101s
==  AddRowAndColumnToViewable: migrated (0.0211s) =============================

==  AddAttachmentImageToViewable: migrating ===================================
-- add_column(:viewables, :image_file_name, :string)
   -> 0.0110s
-- add_column(:viewables, :image_content_type, :string)
   -> 0.0114s
-- add_column(:viewables, :image_file_size, :integer)
   -> 0.0109s
-- add_column(:viewables, :image_updated_at, :datetime)
   -> 0.0110s
==  AddAttachmentImageToViewable: migrated (0.0446s) ==========================

==  AddImageFingerprintToViewable: migrating ==================================
-- add_column(:viewables, :image_fingerprint, :string)
   -> 0.0113s
==  AddImageFingerprintToViewable: migrated (0.0113s) =========================

==  AddWholesalePriceToSpreeVariants: migrating ===============================
-- add_column(:spree_variants, :wholesale_price, :decimal, {:precision=>8, :scale=>2})
   -> 0.0113s
==  AddWholesalePriceToSpreeVariants: migrated (0.0114s) ======================

==  ChangeViewablesTableNameToSpreeViewables: migrating =======================
-- rename_table(:viewables, :spree_viewables)
   -> 0.0023s
==  ChangeViewablesTableNameToSpreeViewables: migrated (0.0024s) ==============

==  AddTypeToSpreeViewable: migrating =========================================
-- add_column(:spree_viewables, :type, :integer)
   -> 0.0110s
==  AddTypeToSpreeViewable: migrated (0.0111s) ================================

==  RenameTypeFieldToPlacementTypeOnSpreeViewables: migrating =================
-- add_column(:spree_viewables, :placement_type, :integer)
   -> 0.0110s
==  RenameTypeFieldToPlacementTypeOnSpreeViewables: migrated (0.0110s) ========

==  AddUnavailableOnToSpreeProduct: migrating =================================
-- add_column(:spree_products, :unavailable_on, :datetime)
   -> 0.0119s
==  AddUnavailableOnToSpreeProduct: migrated (0.0119s) ========================

==  AddBackorderThresholdToSpreeProduct: migrating ============================
-- add_column(:spree_products, :backorder_threshold, :integer)
   -> 0.0115s
==  AddBackorderThresholdToSpreeProduct: migrated (0.0115s) ===================

==  AddHrefToSpreeViewable: migrating =========================================** Invoke db:_dump (first_time)
** Execute db:_dump
** Invoke db:schema:dump (first_time)
** Invoke environment 
** Invoke db:load_config 
** Execute db:schema:dump
** Invoke db:seed (first_time)
** Execute db:seed
** Invoke db:abort_if_pending_migrations (first_time)
** Invoke environment 
** Execute db:abort_if_pending_migrations
** Invoke db:load_dir (first_time)
** Invoke environment 
** Execute db:load_dir
** Execute db:load_file
** Execute db:load_file
** Execute db:load_file
** Execute db:load_file
** Execute db:load_file
** Invoke db:load_dir (first_time)
** Invoke environment 
** Execute db:load_dir
** Execute db:load_file
rake aborted!
undefined local variable or method `unavailable_on' for #<Spree::Taxon:0x0000000790d4c0>
/home/touch/.rvm/gems/ruby-1.9.2-p318@rails321/gems/activemodel-3.2.3/lib/active_model/attribute_methods.rb:407:in `method_missing'
/home/touch/.rvm/gems/ruby-1.9.2-p318@rails321/gems/activerecord-3.2.3/lib/active_record/attribute_methods.rb:148:in `method_missing'
/home/touch/.rvm/gems/ruby-1.9.2-p318@rails321/gems/activesupport-3.2.3/lib/active_support/callbacks.rb:447:in `_run__3713931543126648009__validate__1065146383661211557__callbacks'
/home/touch/.rvm/gems/ruby-1.9.2-p318@rails321/gems/activesupport-3.2.3/lib/active_support/callbacks.rb:405:in `__run_callback'
/home/touch/.rvm/gems/ruby-1.9.2-p318@rails321/gems/activesupport-3.2.3/lib/active_support/callbacks.rb:385:in `_run_validate_callbacks'
/home/touch/.rvm/gems/ruby-1.9.2-p318@rails321/gems/activesupport-3.2.3/lib/active_support/callbacks.rb:81:in `run_callbacks'
/home/touch/.rvm/gems/ruby-1.9.2-p318@rails321/gems/activemodel-3.2.3/lib/active_model/validations.rb:212:in `run_validations!'
/home/touch/.rvm/gems/ruby-1.9.2-p318@rails321/gems/activemodel-3.2.3/lib/active_model/validations/callbacks.rb:53:in `block in run_validations!'