(11.3ms) CREATE TABLE "schema_migrations" ("version" varchar NOT NULL)   (0.1ms) select sqlite_version(*)  (10.1ms) CREATE UNIQUE INDEX "unique_schema_migrations" ON "schema_migrations" ("version") ActiveRecord::SchemaMigration Load (2.4ms) SELECT "schema_migrations".* FROM "schema_migrations" Migrating to CreateApptCalendars (20150804002016)  (0.1ms) begin transaction  (5.1ms) CREATE TABLE "appt_calendars" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "name" varchar, "created_at" datetime NOT NULL, "updated_at" datetime NOT NULL) SQL (0.9ms) INSERT INTO "schema_migrations" ("version") VALUES (?) [["version", "20150804002016"]]  (6.5ms) commit transaction Migrating to CreateApptBlocks (20150804003348)  (0.1ms) begin transaction  (5.2ms) CREATE TABLE "appt_blocks" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "created_at" datetime NOT NULL, "updated_at" datetime NOT NULL) SQL (1.0ms) INSERT INTO "schema_migrations" ("version") VALUES (?) [["version", "20150804003348"]]  (6.0ms) commit transaction Migrating to CreateApptAppointments (20150804003846)  (0.1ms) begin transaction  (4.8ms) CREATE TABLE "appt_appointments" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "created_at" datetime NOT NULL, "updated_at" datetime NOT NULL) SQL (0.9ms) INSERT INTO "schema_migrations" ("version") VALUES (?) [["version", "20150804003846"]]  (6.2ms) commit transaction ActiveRecord::SchemaMigration Load (2.0ms) SELECT "schema_migrations".* FROM "schema_migrations" Started GET "/" for 10.0.2.2 at 2015-08-04 01:11:27 +0000 Started GET "/appt" for 10.0.2.2 at 2015-08-04 01:11:27 +0000 ActionController::RoutingError (uninitialized constant RatioCustomerService::BaseController): /vagrant/appt/app/controllers/appt/home_controller.rb:4:in `' /vagrant/appt/app/controllers/appt/home_controller.rb:3:in `' activesupport (4.2.3) lib/active_support/inflector/methods.rb:263:in `const_get' activesupport (4.2.3) lib/active_support/inflector/methods.rb:263:in `block in constantize' activesupport (4.2.3) lib/active_support/inflector/methods.rb:259:in `each' activesupport (4.2.3) lib/active_support/inflector/methods.rb:259:in `inject' activesupport (4.2.3) lib/active_support/inflector/methods.rb:259:in `constantize' actionpack (4.2.3) lib/action_dispatch/routing/route_set.rb:72:in `controller_reference' actionpack (4.2.3) lib/action_dispatch/routing/route_set.rb:62:in `controller' actionpack (4.2.3) lib/action_dispatch/routing/route_set.rb:41:in `serve' actionpack (4.2.3) lib/action_dispatch/journey/router.rb:43:in `block in serve' actionpack (4.2.3) lib/action_dispatch/journey/router.rb:30:in `each' actionpack (4.2.3) lib/action_dispatch/journey/router.rb:30:in `serve' actionpack (4.2.3) lib/action_dispatch/routing/route_set.rb:821:in `call' railties (4.2.3) lib/rails/engine.rb:518:in `call' railties (4.2.3) lib/rails/railtie.rb:194:in `public_send' railties (4.2.3) lib/rails/railtie.rb:194:in `method_missing' actionpack (4.2.3) lib/action_dispatch/routing/mapper.rb:51:in `serve' actionpack (4.2.3) lib/action_dispatch/journey/router.rb:43:in `block in serve' actionpack (4.2.3) lib/action_dispatch/journey/router.rb:30:in `each' actionpack (4.2.3) lib/action_dispatch/journey/router.rb:30:in `serve' actionpack (4.2.3) lib/action_dispatch/routing/route_set.rb:821:in `call' rack (1.6.4) lib/rack/etag.rb:24:in `call' rack (1.6.4) lib/rack/conditionalget.rb:25:in `call' rack (1.6.4) lib/rack/head.rb:13:in `call' actionpack (4.2.3) lib/action_dispatch/middleware/params_parser.rb:27:in `call' actionpack (4.2.3) lib/action_dispatch/middleware/flash.rb:260:in `call' rack (1.6.4) lib/rack/session/abstract/id.rb:225:in `context' rack (1.6.4) lib/rack/session/abstract/id.rb:220:in `call' actionpack (4.2.3) lib/action_dispatch/middleware/cookies.rb:560:in `call' activerecord (4.2.3) lib/active_record/query_cache.rb:36:in `call' activerecord (4.2.3) lib/active_record/connection_adapters/abstract/connection_pool.rb:653:in `call' activerecord (4.2.3) lib/active_record/migration.rb:377:in `call' actionpack (4.2.3) lib/action_dispatch/middleware/callbacks.rb:29:in `block in call' activesupport (4.2.3) lib/active_support/callbacks.rb:84:in `run_callbacks' actionpack (4.2.3) lib/action_dispatch/middleware/callbacks.rb:27:in `call' actionpack (4.2.3) lib/action_dispatch/middleware/reloader.rb:73:in `call' actionpack (4.2.3) lib/action_dispatch/middleware/remote_ip.rb:78:in `call' actionpack (4.2.3) lib/action_dispatch/middleware/debug_exceptions.rb:17:in `call' actionpack (4.2.3) lib/action_dispatch/middleware/show_exceptions.rb:30:in `call' railties (4.2.3) lib/rails/rack/logger.rb:38:in `call_app' railties (4.2.3) lib/rails/rack/logger.rb:20:in `block in call' activesupport (4.2.3) lib/active_support/tagged_logging.rb:68:in `block in tagged' activesupport (4.2.3) lib/active_support/tagged_logging.rb:26:in `tagged' activesupport (4.2.3) lib/active_support/tagged_logging.rb:68:in `tagged' railties (4.2.3) lib/rails/rack/logger.rb:20:in `call' actionpack (4.2.3) lib/action_dispatch/middleware/request_id.rb:21:in `call' rack (1.6.4) lib/rack/methodoverride.rb:22:in `call' rack (1.6.4) lib/rack/runtime.rb:18:in `call' activesupport (4.2.3) lib/active_support/cache/strategy/local_cache_middleware.rb:28:in `call' rack (1.6.4) lib/rack/lock.rb:17:in `call' actionpack (4.2.3) lib/action_dispatch/middleware/static.rb:116:in `call' rack (1.6.4) lib/rack/sendfile.rb:113:in `call' railties (4.2.3) lib/rails/engine.rb:518:in `call' railties (4.2.3) lib/rails/application.rb:165:in `call' rack (1.6.4) lib/rack/lock.rb:17:in `call' rack (1.6.4) lib/rack/content_length.rb:15:in `call' rack (1.6.4) lib/rack/handler/webrick.rb:88:in `service' /usr/local/rvm/rubies/ruby-2.2.2/lib/ruby/2.2.0/webrick/httpserver.rb:138:in `service' /usr/local/rvm/rubies/ruby-2.2.2/lib/ruby/2.2.0/webrick/httpserver.rb:94:in `run' /usr/local/rvm/rubies/ruby-2.2.2/lib/ruby/2.2.0/webrick/server.rb:294:in `block in start_thread' Rendered /usr/local/rvm/gems/ruby-2.2.2/gems/actionpack-4.2.3/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (2.2ms) Rendered /usr/local/rvm/gems/ruby-2.2.2/gems/actionpack-4.2.3/lib/action_dispatch/middleware/templates/routes/_route.html.erb (0.7ms) Rendered /usr/local/rvm/gems/ruby-2.2.2/gems/actionpack-4.2.3/lib/action_dispatch/middleware/templates/routes/_route.html.erb (1.3ms) Rendered /usr/local/rvm/gems/ruby-2.2.2/gems/actionpack-4.2.3/lib/action_dispatch/middleware/templates/routes/_table.html.erb (21.1ms) Rendered /usr/local/rvm/gems/ruby-2.2.2/gems/actionpack-4.2.3/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (22.1ms) Rendered /usr/local/rvm/gems/ruby-2.2.2/gems/actionpack-4.2.3/lib/action_dispatch/middleware/templates/rescues/routing_error.html.erb within rescues/layout (102.7ms) Started GET "/appt" for 10.0.2.2 at 2015-08-04 01:13:31 +0000 Processing by Appt::HomeController#index as HTML Completed 500 Internal Server Error in 76ms (ActiveRecord: 0.0ms) ActionView::MissingTemplate (Missing template appt/home/index, appt/base/index, application/index with {:locale=>[:en], :formats=>[:html], :variants=>[], :handlers=>[:erb, :builder, :raw, :ruby, :haml]}. Searched in: * "/vagrant/appt/test/dummy/app/views" * "/vagrant/appt/app/views" * "/usr/local/rvm/gems/ruby-2.2.2/gems/kaminari-0.16.3/app/views" ): actionview (4.2.3) lib/action_view/path_set.rb:46:in `find' actionview (4.2.3) lib/action_view/lookup_context.rb:121:in `find' actionview (4.2.3) lib/action_view/renderer/abstract_renderer.rb:18:in `find_template' actionview (4.2.3) lib/action_view/renderer/template_renderer.rb:40:in `determine_template' actionview (4.2.3) lib/action_view/renderer/template_renderer.rb:8:in `render' actionview (4.2.3) lib/action_view/renderer/renderer.rb:42:in `render_template' actionview (4.2.3) lib/action_view/renderer/renderer.rb:23:in `render' actionview (4.2.3) lib/action_view/rendering.rb:100:in `_render_template' actionpack (4.2.3) lib/action_controller/metal/streaming.rb:217:in `_render_template' actionview (4.2.3) lib/action_view/rendering.rb:83:in `render_to_body' actionpack (4.2.3) lib/action_controller/metal/rendering.rb:32:in `render_to_body' actionpack (4.2.3) lib/action_controller/metal/renderers.rb:37:in `render_to_body' actionpack (4.2.3) lib/abstract_controller/rendering.rb:25:in `render' actionpack (4.2.3) lib/action_controller/metal/rendering.rb:16:in `render' actionpack (4.2.3) lib/action_controller/metal/instrumentation.rb:44:in `block (2 levels) in render' activesupport (4.2.3) lib/active_support/core_ext/benchmark.rb:12:in `block in ms' /usr/local/rvm/rubies/ruby-2.2.2/lib/ruby/2.2.0/benchmark.rb:303:in `realtime' activesupport (4.2.3) lib/active_support/core_ext/benchmark.rb:12:in `ms' actionpack (4.2.3) lib/action_controller/metal/instrumentation.rb:44:in `block in render' actionpack (4.2.3) lib/action_controller/metal/instrumentation.rb:87:in `cleanup_view_runtime' activerecord (4.2.3) lib/active_record/railties/controller_runtime.rb:25:in `cleanup_view_runtime' actionpack (4.2.3) lib/action_controller/metal/instrumentation.rb:43:in `render' actionpack (4.2.3) lib/action_controller/metal/implicit_render.rb:10:in `default_render' actionpack (4.2.3) lib/action_controller/metal/implicit_render.rb:5:in `send_action' actionpack (4.2.3) lib/abstract_controller/base.rb:198:in `process_action' actionpack (4.2.3) lib/action_controller/metal/rendering.rb:10:in `process_action' actionpack (4.2.3) lib/abstract_controller/callbacks.rb:20:in `block in process_action' activesupport (4.2.3) lib/active_support/callbacks.rb:115:in `call' activesupport (4.2.3) lib/active_support/callbacks.rb:115:in `call' activesupport (4.2.3) lib/active_support/callbacks.rb:553:in `block (2 levels) in compile' activesupport (4.2.3) lib/active_support/callbacks.rb:503:in `call' activesupport (4.2.3) lib/active_support/callbacks.rb:503:in `call' activesupport (4.2.3) lib/active_support/callbacks.rb:88:in `run_callbacks' actionpack (4.2.3) lib/abstract_controller/callbacks.rb:19:in `process_action' actionpack (4.2.3) lib/action_controller/metal/rescue.rb:29:in `process_action' actionpack (4.2.3) lib/action_controller/metal/instrumentation.rb:32:in `block in process_action' activesupport (4.2.3) lib/active_support/notifications.rb:164:in `block in instrument' activesupport (4.2.3) lib/active_support/notifications/instrumenter.rb:20:in `instrument' activesupport (4.2.3) lib/active_support/notifications.rb:164:in `instrument' actionpack (4.2.3) lib/action_controller/metal/instrumentation.rb:30:in `process_action' actionpack (4.2.3) lib/action_controller/metal/params_wrapper.rb:250:in `process_action' activerecord (4.2.3) lib/active_record/railties/controller_runtime.rb:18:in `process_action' actionpack (4.2.3) lib/abstract_controller/base.rb:137:in `process' actionview (4.2.3) lib/action_view/rendering.rb:30:in `process' actionpack (4.2.3) lib/action_controller/metal.rb:196:in `dispatch' actionpack (4.2.3) lib/action_controller/metal/rack_delegation.rb:13:in `dispatch' actionpack (4.2.3) lib/action_controller/metal.rb:237:in `block in action' actionpack (4.2.3) lib/action_dispatch/routing/route_set.rb:76:in `call' actionpack (4.2.3) lib/action_dispatch/routing/route_set.rb:76:in `dispatch' actionpack (4.2.3) lib/action_dispatch/routing/route_set.rb:45:in `serve' actionpack (4.2.3) lib/action_dispatch/journey/router.rb:43:in `block in serve' actionpack (4.2.3) lib/action_dispatch/journey/router.rb:30:in `each' actionpack (4.2.3) lib/action_dispatch/journey/router.rb:30:in `serve' actionpack (4.2.3) lib/action_dispatch/routing/route_set.rb:821:in `call' railties (4.2.3) lib/rails/engine.rb:518:in `call' railties (4.2.3) lib/rails/railtie.rb:194:in `public_send' railties (4.2.3) lib/rails/railtie.rb:194:in `method_missing' actionpack (4.2.3) lib/action_dispatch/routing/mapper.rb:51:in `serve' actionpack (4.2.3) lib/action_dispatch/journey/router.rb:43:in `block in serve' actionpack (4.2.3) lib/action_dispatch/journey/router.rb:30:in `each' actionpack (4.2.3) lib/action_dispatch/journey/router.rb:30:in `serve' actionpack (4.2.3) lib/action_dispatch/routing/route_set.rb:821:in `call' rack (1.6.4) lib/rack/etag.rb:24:in `call' rack (1.6.4) lib/rack/conditionalget.rb:25:in `call' rack (1.6.4) lib/rack/head.rb:13:in `call' actionpack (4.2.3) lib/action_dispatch/middleware/params_parser.rb:27:in `call' actionpack (4.2.3) lib/action_dispatch/middleware/flash.rb:260:in `call' rack (1.6.4) lib/rack/session/abstract/id.rb:225:in `context' rack (1.6.4) lib/rack/session/abstract/id.rb:220:in `call' actionpack (4.2.3) lib/action_dispatch/middleware/cookies.rb:560:in `call' activerecord (4.2.3) lib/active_record/query_cache.rb:36:in `call' activerecord (4.2.3) lib/active_record/connection_adapters/abstract/connection_pool.rb:653:in `call' activerecord (4.2.3) lib/active_record/migration.rb:377:in `call' actionpack (4.2.3) lib/action_dispatch/middleware/callbacks.rb:29:in `block in call' activesupport (4.2.3) lib/active_support/callbacks.rb:84:in `run_callbacks' actionpack (4.2.3) lib/action_dispatch/middleware/callbacks.rb:27:in `call' actionpack (4.2.3) lib/action_dispatch/middleware/reloader.rb:73:in `call' actionpack (4.2.3) lib/action_dispatch/middleware/remote_ip.rb:78:in `call' actionpack (4.2.3) lib/action_dispatch/middleware/debug_exceptions.rb:17:in `call' actionpack (4.2.3) lib/action_dispatch/middleware/show_exceptions.rb:30:in `call' railties (4.2.3) lib/rails/rack/logger.rb:38:in `call_app' railties (4.2.3) lib/rails/rack/logger.rb:20:in `block in call' activesupport (4.2.3) lib/active_support/tagged_logging.rb:68:in `block in tagged' activesupport (4.2.3) lib/active_support/tagged_logging.rb:26:in `tagged' activesupport (4.2.3) lib/active_support/tagged_logging.rb:68:in `tagged' railties (4.2.3) lib/rails/rack/logger.rb:20:in `call' actionpack (4.2.3) lib/action_dispatch/middleware/request_id.rb:21:in `call' rack (1.6.4) lib/rack/methodoverride.rb:22:in `call' rack (1.6.4) lib/rack/runtime.rb:18:in `call' activesupport (4.2.3) lib/active_support/cache/strategy/local_cache_middleware.rb:28:in `call' rack (1.6.4) lib/rack/lock.rb:17:in `call' actionpack (4.2.3) lib/action_dispatch/middleware/static.rb:116:in `call' rack (1.6.4) lib/rack/sendfile.rb:113:in `call' railties (4.2.3) lib/rails/engine.rb:518:in `call' railties (4.2.3) lib/rails/application.rb:165:in `call' rack (1.6.4) lib/rack/lock.rb:17:in `call' rack (1.6.4) lib/rack/content_length.rb:15:in `call' rack (1.6.4) lib/rack/handler/webrick.rb:88:in `service' /usr/local/rvm/rubies/ruby-2.2.2/lib/ruby/2.2.0/webrick/httpserver.rb:138:in `service' /usr/local/rvm/rubies/ruby-2.2.2/lib/ruby/2.2.0/webrick/httpserver.rb:94:in `run' /usr/local/rvm/rubies/ruby-2.2.2/lib/ruby/2.2.0/webrick/server.rb:294:in `block in start_thread' Rendered /usr/local/rvm/gems/ruby-2.2.2/gems/actionpack-4.2.3/lib/action_dispatch/middleware/templates/rescues/_source.erb (5.8ms) Rendered /usr/local/rvm/gems/ruby-2.2.2/gems/actionpack-4.2.3/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (2.5ms) Rendered /usr/local/rvm/gems/ruby-2.2.2/gems/actionpack-4.2.3/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (1.0ms) Rendered /usr/local/rvm/gems/ruby-2.2.2/gems/actionpack-4.2.3/lib/action_dispatch/middleware/templates/rescues/missing_template.html.erb within rescues/layout (25.2ms) Started GET "/appt" for 10.0.2.2 at 2015-08-04 01:13:55 +0000 Processing by Appt::HomeController#index as HTML Rendered /vagrant/appt/app/views/appt/home/index.html.haml within layouts/appt/application (1.0ms) Completed 500 Internal Server Error in 134ms (ActiveRecord: 0.0ms) ActionView::Template::Error (undefined local variable or method `title' for #<#:0x00000001a1bc00>): 4: %meta{:charset => "utf-8"}/ 5: %meta{:content => "IE=edge", "http-equiv" => "X-UA-Compatible"}/ 6: %meta{:content => "width=device-width, initial-scale=1", :name => "viewport"}/ 7: %title= title ? title : "Appt" 8: = csrf_meta_tags 9: = stylesheet_link_tag "appt/application", media: "all" 10: = content_for :stylesheets /vagrant/appt/app/views/layouts/appt/application.html.haml:7:in `__vagrant_appt_app_views_layouts_appt_application_html_haml___2916401083482830137_13612400' actionview (4.2.3) lib/action_view/template.rb:145:in `block in render' activesupport (4.2.3) lib/active_support/notifications.rb:166:in `instrument' actionview (4.2.3) lib/action_view/template.rb:333:in `instrument' actionview (4.2.3) lib/action_view/template.rb:143:in `render' actionview (4.2.3) lib/action_view/renderer/template_renderer.rb:66:in `render_with_layout' actionview (4.2.3) lib/action_view/renderer/template_renderer.rb:52:in `render_template' actionview (4.2.3) lib/action_view/renderer/template_renderer.rb:14:in `render' actionview (4.2.3) lib/action_view/renderer/renderer.rb:42:in `render_template' actionview (4.2.3) lib/action_view/renderer/renderer.rb:23:in `render' actionview (4.2.3) lib/action_view/rendering.rb:100:in `_render_template' actionpack (4.2.3) lib/action_controller/metal/streaming.rb:217:in `_render_template' actionview (4.2.3) lib/action_view/rendering.rb:83:in `render_to_body' actionpack (4.2.3) lib/action_controller/metal/rendering.rb:32:in `render_to_body' actionpack (4.2.3) lib/action_controller/metal/renderers.rb:37:in `render_to_body' actionpack (4.2.3) lib/abstract_controller/rendering.rb:25:in `render' actionpack (4.2.3) lib/action_controller/metal/rendering.rb:16:in `render' actionpack (4.2.3) lib/action_controller/metal/instrumentation.rb:44:in `block (2 levels) in render' activesupport (4.2.3) lib/active_support/core_ext/benchmark.rb:12:in `block in ms' /usr/local/rvm/rubies/ruby-2.2.2/lib/ruby/2.2.0/benchmark.rb:303:in `realtime' activesupport (4.2.3) lib/active_support/core_ext/benchmark.rb:12:in `ms' actionpack (4.2.3) lib/action_controller/metal/instrumentation.rb:44:in `block in render' actionpack (4.2.3) lib/action_controller/metal/instrumentation.rb:87:in `cleanup_view_runtime' activerecord (4.2.3) lib/active_record/railties/controller_runtime.rb:25:in `cleanup_view_runtime' actionpack (4.2.3) lib/action_controller/metal/instrumentation.rb:43:in `render' actionpack (4.2.3) lib/action_controller/metal/implicit_render.rb:10:in `default_render' actionpack (4.2.3) lib/action_controller/metal/implicit_render.rb:5:in `send_action' actionpack (4.2.3) lib/abstract_controller/base.rb:198:in `process_action' actionpack (4.2.3) lib/action_controller/metal/rendering.rb:10:in `process_action' actionpack (4.2.3) lib/abstract_controller/callbacks.rb:20:in `block in process_action' activesupport (4.2.3) lib/active_support/callbacks.rb:115:in `call' activesupport (4.2.3) lib/active_support/callbacks.rb:115:in `call' activesupport (4.2.3) lib/active_support/callbacks.rb:553:in `block (2 levels) in compile' activesupport (4.2.3) lib/active_support/callbacks.rb:503:in `call' activesupport (4.2.3) lib/active_support/callbacks.rb:503:in `call' activesupport (4.2.3) lib/active_support/callbacks.rb:88:in `run_callbacks' actionpack (4.2.3) lib/abstract_controller/callbacks.rb:19:in `process_action' actionpack (4.2.3) lib/action_controller/metal/rescue.rb:29:in `process_action' actionpack (4.2.3) lib/action_controller/metal/instrumentation.rb:32:in `block in process_action' activesupport (4.2.3) lib/active_support/notifications.rb:164:in `block in instrument' activesupport (4.2.3) lib/active_support/notifications/instrumenter.rb:20:in `instrument' activesupport (4.2.3) lib/active_support/notifications.rb:164:in `instrument' actionpack (4.2.3) lib/action_controller/metal/instrumentation.rb:30:in `process_action' actionpack (4.2.3) lib/action_controller/metal/params_wrapper.rb:250:in `process_action' activerecord (4.2.3) lib/active_record/railties/controller_runtime.rb:18:in `process_action' actionpack (4.2.3) lib/abstract_controller/base.rb:137:in `process' actionview (4.2.3) lib/action_view/rendering.rb:30:in `process' actionpack (4.2.3) lib/action_controller/metal.rb:196:in `dispatch' actionpack (4.2.3) lib/action_controller/metal/rack_delegation.rb:13:in `dispatch' actionpack (4.2.3) lib/action_controller/metal.rb:237:in `block in action' actionpack (4.2.3) lib/action_dispatch/routing/route_set.rb:76:in `call' actionpack (4.2.3) lib/action_dispatch/routing/route_set.rb:76:in `dispatch' actionpack (4.2.3) lib/action_dispatch/routing/route_set.rb:45:in `serve' actionpack (4.2.3) lib/action_dispatch/journey/router.rb:43:in `block in serve' actionpack (4.2.3) lib/action_dispatch/journey/router.rb:30:in `each' actionpack (4.2.3) lib/action_dispatch/journey/router.rb:30:in `serve' actionpack (4.2.3) lib/action_dispatch/routing/route_set.rb:821:in `call' railties (4.2.3) lib/rails/engine.rb:518:in `call' railties (4.2.3) lib/rails/railtie.rb:194:in `public_send' railties (4.2.3) lib/rails/railtie.rb:194:in `method_missing' actionpack (4.2.3) lib/action_dispatch/routing/mapper.rb:51:in `serve' actionpack (4.2.3) lib/action_dispatch/journey/router.rb:43:in `block in serve' actionpack (4.2.3) lib/action_dispatch/journey/router.rb:30:in `each' actionpack (4.2.3) lib/action_dispatch/journey/router.rb:30:in `serve' actionpack (4.2.3) lib/action_dispatch/routing/route_set.rb:821:in `call' rack (1.6.4) lib/rack/etag.rb:24:in `call' rack (1.6.4) lib/rack/conditionalget.rb:25:in `call' rack (1.6.4) lib/rack/head.rb:13:in `call' actionpack (4.2.3) lib/action_dispatch/middleware/params_parser.rb:27:in `call' actionpack (4.2.3) lib/action_dispatch/middleware/flash.rb:260:in `call' rack (1.6.4) lib/rack/session/abstract/id.rb:225:in `context' rack (1.6.4) lib/rack/session/abstract/id.rb:220:in `call' actionpack (4.2.3) lib/action_dispatch/middleware/cookies.rb:560:in `call' activerecord (4.2.3) lib/active_record/query_cache.rb:36:in `call' activerecord (4.2.3) lib/active_record/connection_adapters/abstract/connection_pool.rb:653:in `call' activerecord (4.2.3) lib/active_record/migration.rb:377:in `call' actionpack (4.2.3) lib/action_dispatch/middleware/callbacks.rb:29:in `block in call' activesupport (4.2.3) lib/active_support/callbacks.rb:84:in `run_callbacks' actionpack (4.2.3) lib/action_dispatch/middleware/callbacks.rb:27:in `call' actionpack (4.2.3) lib/action_dispatch/middleware/reloader.rb:73:in `call' actionpack (4.2.3) lib/action_dispatch/middleware/remote_ip.rb:78:in `call' actionpack (4.2.3) lib/action_dispatch/middleware/debug_exceptions.rb:17:in `call' actionpack (4.2.3) lib/action_dispatch/middleware/show_exceptions.rb:30:in `call' railties (4.2.3) lib/rails/rack/logger.rb:38:in `call_app' railties (4.2.3) lib/rails/rack/logger.rb:20:in `block in call' activesupport (4.2.3) lib/active_support/tagged_logging.rb:68:in `block in tagged' activesupport (4.2.3) lib/active_support/tagged_logging.rb:26:in `tagged' activesupport (4.2.3) lib/active_support/tagged_logging.rb:68:in `tagged' railties (4.2.3) lib/rails/rack/logger.rb:20:in `call' actionpack (4.2.3) lib/action_dispatch/middleware/request_id.rb:21:in `call' rack (1.6.4) lib/rack/methodoverride.rb:22:in `call' rack (1.6.4) lib/rack/runtime.rb:18:in `call' activesupport (4.2.3) lib/active_support/cache/strategy/local_cache_middleware.rb:28:in `call' rack (1.6.4) lib/rack/lock.rb:17:in `call' actionpack (4.2.3) lib/action_dispatch/middleware/static.rb:116:in `call' rack (1.6.4) lib/rack/sendfile.rb:113:in `call' railties (4.2.3) lib/rails/engine.rb:518:in `call' railties (4.2.3) lib/rails/application.rb:165:in `call' rack (1.6.4) lib/rack/lock.rb:17:in `call' rack (1.6.4) lib/rack/content_length.rb:15:in `call' rack (1.6.4) lib/rack/handler/webrick.rb:88:in `service' /usr/local/rvm/rubies/ruby-2.2.2/lib/ruby/2.2.0/webrick/httpserver.rb:138:in `service' /usr/local/rvm/rubies/ruby-2.2.2/lib/ruby/2.2.0/webrick/httpserver.rb:94:in `run' /usr/local/rvm/rubies/ruby-2.2.2/lib/ruby/2.2.0/webrick/server.rb:294:in `block in start_thread' Rendered /usr/local/rvm/gems/ruby-2.2.2/gems/actionpack-4.2.3/lib/action_dispatch/middleware/templates/rescues/_source.erb (5.5ms) Rendered /usr/local/rvm/gems/ruby-2.2.2/gems/actionpack-4.2.3/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (1.9ms) Rendered /usr/local/rvm/gems/ruby-2.2.2/gems/actionpack-4.2.3/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (2.2ms) Rendered /usr/local/rvm/gems/ruby-2.2.2/gems/actionpack-4.2.3/lib/action_dispatch/middleware/templates/rescues/template_error.html.erb within rescues/layout (25.4ms) Started GET "/appt" for 10.0.2.2 at 2015-08-04 01:15:23 +0000 Processing by Appt::HomeController#index as HTML Rendered /vagrant/appt/app/views/appt/home/index.html.haml within layouts/appt/application (0.9ms) Rendered /vagrant/appt/app/views/appt/shared/_navbar.html.haml (148.1ms) Rendered /vagrant/appt/app/views/appt/shared/_flash.html.haml (1.8ms) Completed 200 OK in 7835ms (Views: 7835.2ms | ActiveRecord: 0.0ms) Started GET "/assets/appt/application.self-15f2e46bedcc8be3427411401defe280d89e86abd7b1774b366c7285e54c906d.css?body=1" for 10.0.2.2 at 2015-08-04 01:15:31 +0000 Started GET "/assets/jquery.self-4c7649dd655c61cb850cfd2e71f937c3bbf3e3a752a3499ed8bb9884473fe1dd.js?body=1" for 10.0.2.2 at 2015-08-04 01:15:31 +0000 Started GET "/assets/bootstrap/alert.self-896ab026e6823f5cef2441e07dac53d0692a5b772ac58b1ce20aa624c342d3f4.js?body=1" for 10.0.2.2 at 2015-08-04 01:15:32 +0000 Started GET "/assets/bootstrap/affix.self-f7aef9d98ee5ece34a6a92a6a15bba777d93e8d908b75c95a85088277f394200.js?body=1" for 10.0.2.2 at 2015-08-04 01:15:32 +0000 Started GET "/assets/bootstrap/button.self-d19f3e2bcd3a7a4d75c11b9141b3fabd2c11987da1e99c85548ec3ecf8db30c3.js?body=1" for 10.0.2.2 at 2015-08-04 01:15:32 +0000 Started GET "/assets/bootstrap/carousel.self-b2e5e14483e6c31343a83861b7d487620f143d6fc2d07d5ae7544b6b225ba6be.js?body=1" for 10.0.2.2 at 2015-08-04 01:15:32 +0000 Started GET "/assets/bootstrap/collapse.self-93820e9b486e375a7fb4477602def3a6f8381fa6d50938d5378297ffbe4a1248.js?body=1" for 10.0.2.2 at 2015-08-04 01:15:32 +0000 Started GET "/assets/bootstrap/dropdown.self-30536ae4d54b2685c26b5787ed0eb549a9075717fe690cce6270873bedf2df00.js?body=1" for 10.0.2.2 at 2015-08-04 01:15:32 +0000 Started GET "/assets/bootstrap/tab.self-9b77df34cbbb08ec93a806d6cdb741f04e3dbf3389978a0679146f2d2987bc89.js?body=1" for 10.0.2.2 at 2015-08-04 01:15:32 +0000 Started GET "/assets/bootstrap/transition.self-9616c4e856b57659b67da3c6f2adcd584b5601ef4bebcdadab8ebb387d80bb25.js?body=1" for 10.0.2.2 at 2015-08-04 01:15:32 +0000 Started GET "/assets/bootstrap/scrollspy.self-c5c6ed008955656d345067e9821d79f1216b8383134d08465d4aa1a33a2b93b4.js?body=1" for 10.0.2.2 at 2015-08-04 01:15:32 +0000 Started GET "/assets/bootstrap/modal.self-bcfe54f3132bf16a8c5ce4289e47eba488f6522a08f49f378a037061c6c7aa4c.js?body=1" for 10.0.2.2 at 2015-08-04 01:15:32 +0000 Started GET "/assets/bootstrap/tooltip.self-3aa41fbe871573b34e0ebddf31598cd5a11a9841ca85f90934ea46326e46626d.js?body=1" for 10.0.2.2 at 2015-08-04 01:15:33 +0000 Started GET "/assets/bootstrap/popover.self-b73e9c9111d01148e24bbc46e096782e024dc5db630e7078cf11ed2587ef8551.js?body=1" for 10.0.2.2 at 2015-08-04 01:15:33 +0000 Started GET "/assets/bootstrap-sprockets.self-fbfa5ad7d9aa0afe439ec4ff3883acc4cb92b62cb67c40d674320c9aa1d4642d.js?body=1" for 10.0.2.2 at 2015-08-04 01:15:33 +0000 Started GET "/assets/appt/application.self-75a11da44c802486bc6f65640aa48a730f0f684c5c07a42ba3cd1735eb3fb070.js?body=1" for 10.0.2.2 at 2015-08-04 01:15:33 +0000 Started GET "/appt" for 10.0.2.2 at 2015-08-04 01:15:41 +0000 Processing by Appt::HomeController#index as HTML Rendered /vagrant/appt/app/views/appt/home/index.html.haml within layouts/appt/application (1.1ms) Rendered /vagrant/appt/app/views/appt/shared/_navbar.html.haml (2.2ms) Rendered /vagrant/appt/app/views/appt/shared/_flash.html.haml (0.1ms) Completed 200 OK in 760ms (Views: 759.5ms | ActiveRecord: 0.0ms) Started GET "/assets/bootstrap/alert.self-896ab026e6823f5cef2441e07dac53d0692a5b772ac58b1ce20aa624c342d3f4.js?body=1" for 10.0.2.2 at 2015-08-04 01:15:42 +0000 Started GET "/assets/appt/application.self-15f2e46bedcc8be3427411401defe280d89e86abd7b1774b366c7285e54c906d.css?body=1" for 10.0.2.2 at 2015-08-04 01:15:42 +0000 Started GET "/assets/jquery.self-4c7649dd655c61cb850cfd2e71f937c3bbf3e3a752a3499ed8bb9884473fe1dd.js?body=1" for 10.0.2.2 at 2015-08-04 01:15:42 +0000 Started GET "/assets/bootstrap/carousel.self-b2e5e14483e6c31343a83861b7d487620f143d6fc2d07d5ae7544b6b225ba6be.js?body=1" for 10.0.2.2 at 2015-08-04 01:15:42 +0000 Started GET "/assets/bootstrap/button.self-d19f3e2bcd3a7a4d75c11b9141b3fabd2c11987da1e99c85548ec3ecf8db30c3.js?body=1" for 10.0.2.2 at 2015-08-04 01:15:43 +0000 Started GET "/assets/bootstrap/affix.self-f7aef9d98ee5ece34a6a92a6a15bba777d93e8d908b75c95a85088277f394200.js?body=1" for 10.0.2.2 at 2015-08-04 01:15:43 +0000 Started GET "/assets/bootstrap/collapse.self-93820e9b486e375a7fb4477602def3a6f8381fa6d50938d5378297ffbe4a1248.js?body=1" for 10.0.2.2 at 2015-08-04 01:15:43 +0000 Started GET "/assets/bootstrap/dropdown.self-30536ae4d54b2685c26b5787ed0eb549a9075717fe690cce6270873bedf2df00.js?body=1" for 10.0.2.2 at 2015-08-04 01:15:43 +0000 Started GET "/assets/bootstrap/tab.self-9b77df34cbbb08ec93a806d6cdb741f04e3dbf3389978a0679146f2d2987bc89.js?body=1" for 10.0.2.2 at 2015-08-04 01:15:43 +0000 Started GET "/assets/bootstrap/transition.self-9616c4e856b57659b67da3c6f2adcd584b5601ef4bebcdadab8ebb387d80bb25.js?body=1" for 10.0.2.2 at 2015-08-04 01:15:43 +0000 Started GET "/assets/bootstrap/scrollspy.self-c5c6ed008955656d345067e9821d79f1216b8383134d08465d4aa1a33a2b93b4.js?body=1" for 10.0.2.2 at 2015-08-04 01:15:43 +0000 Started GET "/assets/bootstrap/modal.self-bcfe54f3132bf16a8c5ce4289e47eba488f6522a08f49f378a037061c6c7aa4c.js?body=1" for 10.0.2.2 at 2015-08-04 01:15:43 +0000 Started GET "/assets/bootstrap/tooltip.self-3aa41fbe871573b34e0ebddf31598cd5a11a9841ca85f90934ea46326e46626d.js?body=1" for 10.0.2.2 at 2015-08-04 01:15:43 +0000 Started GET "/assets/bootstrap/popover.self-b73e9c9111d01148e24bbc46e096782e024dc5db630e7078cf11ed2587ef8551.js?body=1" for 10.0.2.2 at 2015-08-04 01:15:43 +0000 Started GET "/assets/bootstrap-sprockets.self-fbfa5ad7d9aa0afe439ec4ff3883acc4cb92b62cb67c40d674320c9aa1d4642d.js?body=1" for 10.0.2.2 at 2015-08-04 01:15:43 +0000 Started GET "/assets/appt/application.self-75a11da44c802486bc6f65640aa48a730f0f684c5c07a42ba3cd1735eb3fb070.js?body=1" for 10.0.2.2 at 2015-08-04 01:15:44 +0000 Started GET "/appt" for 10.0.2.2 at 2015-08-04 01:16:25 +0000 Processing by Appt::HomeController#index as HTML Rendered /vagrant/appt/app/views/appt/home/index.html.haml within layouts/appt/application (0.2ms) Rendered /vagrant/appt/app/views/appt/shared/_navbar.html.haml (20.8ms) Rendered /vagrant/appt/app/views/appt/shared/_flash.html.haml (0.2ms) Completed 200 OK in 653ms (Views: 653.0ms | ActiveRecord: 0.0ms) Started GET "/assets/bootstrap/affix.self-f7aef9d98ee5ece34a6a92a6a15bba777d93e8d908b75c95a85088277f394200.js?body=1" for 10.0.2.2 at 2015-08-04 01:16:26 +0000 Started GET "/assets/jquery.self-4c7649dd655c61cb850cfd2e71f937c3bbf3e3a752a3499ed8bb9884473fe1dd.js?body=1" for 10.0.2.2 at 2015-08-04 01:16:26 +0000 Started GET "/assets/bootstrap/alert.self-896ab026e6823f5cef2441e07dac53d0692a5b772ac58b1ce20aa624c342d3f4.js?body=1" for 10.0.2.2 at 2015-08-04 01:16:26 +0000 Started GET "/assets/bootstrap/carousel.self-b2e5e14483e6c31343a83861b7d487620f143d6fc2d07d5ae7544b6b225ba6be.js?body=1" for 10.0.2.2 at 2015-08-04 01:16:26 +0000 Started GET "/assets/appt/application.self-15f2e46bedcc8be3427411401defe280d89e86abd7b1774b366c7285e54c906d.css?body=1" for 10.0.2.2 at 2015-08-04 01:16:26 +0000 Started GET "/assets/bootstrap/button.self-d19f3e2bcd3a7a4d75c11b9141b3fabd2c11987da1e99c85548ec3ecf8db30c3.js?body=1" for 10.0.2.2 at 2015-08-04 01:16:26 +0000 Started GET "/assets/bootstrap/collapse.self-93820e9b486e375a7fb4477602def3a6f8381fa6d50938d5378297ffbe4a1248.js?body=1" for 10.0.2.2 at 2015-08-04 01:16:26 +0000 Started GET "/assets/bootstrap/dropdown.self-30536ae4d54b2685c26b5787ed0eb549a9075717fe690cce6270873bedf2df00.js?body=1" for 10.0.2.2 at 2015-08-04 01:16:26 +0000 Started GET "/assets/bootstrap/tab.self-9b77df34cbbb08ec93a806d6cdb741f04e3dbf3389978a0679146f2d2987bc89.js?body=1" for 10.0.2.2 at 2015-08-04 01:16:26 +0000 Started GET "/assets/bootstrap/transition.self-9616c4e856b57659b67da3c6f2adcd584b5601ef4bebcdadab8ebb387d80bb25.js?body=1" for 10.0.2.2 at 2015-08-04 01:16:27 +0000 Started GET "/assets/bootstrap/scrollspy.self-c5c6ed008955656d345067e9821d79f1216b8383134d08465d4aa1a33a2b93b4.js?body=1" for 10.0.2.2 at 2015-08-04 01:16:27 +0000 Started GET "/assets/bootstrap/modal.self-bcfe54f3132bf16a8c5ce4289e47eba488f6522a08f49f378a037061c6c7aa4c.js?body=1" for 10.0.2.2 at 2015-08-04 01:16:27 +0000 Started GET "/assets/bootstrap/tooltip.self-3aa41fbe871573b34e0ebddf31598cd5a11a9841ca85f90934ea46326e46626d.js?body=1" for 10.0.2.2 at 2015-08-04 01:16:27 +0000 Started GET "/assets/bootstrap/popover.self-b73e9c9111d01148e24bbc46e096782e024dc5db630e7078cf11ed2587ef8551.js?body=1" for 10.0.2.2 at 2015-08-04 01:16:27 +0000 Started GET "/assets/bootstrap-sprockets.self-fbfa5ad7d9aa0afe439ec4ff3883acc4cb92b62cb67c40d674320c9aa1d4642d.js?body=1" for 10.0.2.2 at 2015-08-04 01:16:27 +0000 Started GET "/assets/appt/application.self-75a11da44c802486bc6f65640aa48a730f0f684c5c07a42ba3cd1735eb3fb070.js?body=1" for 10.0.2.2 at 2015-08-04 01:16:27 +0000 Started GET "/appt" for 10.0.2.2 at 2015-08-04 01:17:00 +0000 Processing by Appt::HomeController#index as HTML Rendered /vagrant/appt/app/views/appt/home/index.html.haml within layouts/appt/application (0.2ms) Rendered /vagrant/appt/app/views/appt/shared/_navbar.html.haml (19.8ms) Rendered /vagrant/appt/app/views/appt/shared/_flash.html.haml (0.1ms) Completed 200 OK in 666ms (Views: 665.3ms | ActiveRecord: 0.0ms) Started GET "/assets/jquery.self-4c7649dd655c61cb850cfd2e71f937c3bbf3e3a752a3499ed8bb9884473fe1dd.js?body=1" for 10.0.2.2 at 2015-08-04 01:17:01 +0000 Started GET "/assets/appt/application.self-15f2e46bedcc8be3427411401defe280d89e86abd7b1774b366c7285e54c906d.css?body=1" for 10.0.2.2 at 2015-08-04 01:17:01 +0000 Started GET "/assets/bootstrap/affix.self-f7aef9d98ee5ece34a6a92a6a15bba777d93e8d908b75c95a85088277f394200.js?body=1" for 10.0.2.2 at 2015-08-04 01:17:01 +0000 Started GET "/assets/bootstrap/alert.self-896ab026e6823f5cef2441e07dac53d0692a5b772ac58b1ce20aa624c342d3f4.js?body=1" for 10.0.2.2 at 2015-08-04 01:17:01 +0000 Started GET "/assets/bootstrap/button.self-d19f3e2bcd3a7a4d75c11b9141b3fabd2c11987da1e99c85548ec3ecf8db30c3.js?body=1" for 10.0.2.2 at 2015-08-04 01:17:01 +0000 Started GET "/assets/bootstrap/carousel.self-b2e5e14483e6c31343a83861b7d487620f143d6fc2d07d5ae7544b6b225ba6be.js?body=1" for 10.0.2.2 at 2015-08-04 01:17:02 +0000 Started GET "/assets/bootstrap/collapse.self-93820e9b486e375a7fb4477602def3a6f8381fa6d50938d5378297ffbe4a1248.js?body=1" for 10.0.2.2 at 2015-08-04 01:17:02 +0000 Started GET "/assets/bootstrap/dropdown.self-30536ae4d54b2685c26b5787ed0eb549a9075717fe690cce6270873bedf2df00.js?body=1" for 10.0.2.2 at 2015-08-04 01:17:02 +0000 Started GET "/assets/bootstrap/tab.self-9b77df34cbbb08ec93a806d6cdb741f04e3dbf3389978a0679146f2d2987bc89.js?body=1" for 10.0.2.2 at 2015-08-04 01:17:02 +0000 Started GET "/assets/bootstrap/transition.self-9616c4e856b57659b67da3c6f2adcd584b5601ef4bebcdadab8ebb387d80bb25.js?body=1" for 10.0.2.2 at 2015-08-04 01:17:02 +0000 Started GET "/assets/bootstrap/scrollspy.self-c5c6ed008955656d345067e9821d79f1216b8383134d08465d4aa1a33a2b93b4.js?body=1" for 10.0.2.2 at 2015-08-04 01:17:02 +0000 Started GET "/assets/bootstrap/modal.self-bcfe54f3132bf16a8c5ce4289e47eba488f6522a08f49f378a037061c6c7aa4c.js?body=1" for 10.0.2.2 at 2015-08-04 01:17:02 +0000 Started GET "/assets/bootstrap/tooltip.self-3aa41fbe871573b34e0ebddf31598cd5a11a9841ca85f90934ea46326e46626d.js?body=1" for 10.0.2.2 at 2015-08-04 01:17:02 +0000 Started GET "/assets/bootstrap/popover.self-b73e9c9111d01148e24bbc46e096782e024dc5db630e7078cf11ed2587ef8551.js?body=1" for 10.0.2.2 at 2015-08-04 01:17:02 +0000 Started GET "/assets/bootstrap-sprockets.self-fbfa5ad7d9aa0afe439ec4ff3883acc4cb92b62cb67c40d674320c9aa1d4642d.js?body=1" for 10.0.2.2 at 2015-08-04 01:17:02 +0000 Started GET "/assets/appt/application.self-75a11da44c802486bc6f65640aa48a730f0f684c5c07a42ba3cd1735eb3fb070.js?body=1" for 10.0.2.2 at 2015-08-04 01:17:02 +0000  (10.9ms) CREATE TABLE "schema_migrations" ("version" varchar NOT NULL)   (0.1ms) select sqlite_version(*)  (10.0ms) CREATE UNIQUE INDEX "unique_schema_migrations" ON "schema_migrations" ("version") ActiveRecord::SchemaMigration Load (2.0ms) SELECT "schema_migrations".* FROM "schema_migrations" Migrating to CreateApptCalendars (20150804002016)  (0.0ms) begin transaction  (5.5ms) CREATE TABLE "appt_calendars" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "name" varchar, "created_at" datetime NOT NULL, "updated_at" datetime NOT NULL) SQL (1.0ms) INSERT INTO "schema_migrations" ("version") VALUES (?) [["version", "20150804002016"]]  (5.5ms) commit transaction Migrating to CreateApptBlocks (20150804003348)  (0.1ms) begin transaction  (4.7ms) CREATE TABLE "appt_blocks" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "created_at" datetime NOT NULL, "updated_at" datetime NOT NULL) SQL (0.9ms) INSERT INTO "schema_migrations" ("version") VALUES (?) [["version", "20150804003348"]]  (4.9ms) commit transaction Migrating to CreateApptAppointments (20150804003846)  (0.1ms) begin transaction  (6.1ms) CREATE TABLE "appt_appointments" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "created_at" datetime NOT NULL, "updated_at" datetime NOT NULL) SQL (1.0ms) INSERT INTO "schema_migrations" ("version") VALUES (?) [["version", "20150804003846"]]  (5.6ms) commit transaction ActiveRecord::SchemaMigration Load (1.3ms) SELECT "schema_migrations".* FROM "schema_migrations"  (9.5ms) CREATE TABLE "schema_migrations" ("version" varchar NOT NULL)   (0.1ms) select sqlite_version(*)  (9.4ms) CREATE UNIQUE INDEX "unique_schema_migrations" ON "schema_migrations" ("version") ActiveRecord::SchemaMigration Load (2.1ms) SELECT "schema_migrations".* FROM "schema_migrations" Migrating to CreateApptCalendars (20150804002016)  (0.1ms) begin transaction  (5.0ms) CREATE TABLE "appt_calendars" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "name" varchar, "created_at" datetime NOT NULL, "updated_at" datetime NOT NULL) SQL (0.8ms) INSERT INTO "schema_migrations" ("version") VALUES (?) [["version", "20150804002016"]]  (5.2ms) commit transaction Migrating to CreateApptBlocks (20150804003348)  (0.1ms) begin transaction  (3.8ms) CREATE TABLE "appt_blocks" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "created_at" datetime NOT NULL, "updated_at" datetime NOT NULL) SQL (0.6ms) INSERT INTO "schema_migrations" ("version") VALUES (?) [["version", "20150804003348"]]  (6.9ms) commit transaction Migrating to CreateApptAppointments (20150804003846)  (0.1ms) begin transaction  (4.1ms) CREATE TABLE "appt_appointments" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "created_at" datetime NOT NULL, "updated_at" datetime NOT NULL) SQL (0.7ms) INSERT INTO "schema_migrations" ("version") VALUES (?) [["version", "20150804003846"]]  (5.3ms) commit transaction ActiveRecord::SchemaMigration Load (1.7ms) SELECT "schema_migrations".* FROM "schema_migrations"  (5.4ms) CREATE TABLE "schema_migrations" ("version" character varying NOT NULL)   (2.7ms) CREATE UNIQUE INDEX "unique_schema_migrations" ON "schema_migrations" ("version") ActiveRecord::SchemaMigration Load (0.4ms) SELECT "schema_migrations".* FROM "schema_migrations" Migrating to CreateApptCalendars (20150804002016)  (0.3ms) BEGIN  (5.7ms) CREATE TABLE "appt_calendars" ("id" serial primary key, "name" character varying, "created_at" timestamp NOT NULL, "updated_at" timestamp NOT NULL)  SQL (0.6ms) INSERT INTO "schema_migrations" ("version") VALUES ($1) [["version", "20150804002016"]]  (0.9ms) COMMIT Migrating to CreateApptBlocks (20150804003348)  (0.3ms) BEGIN  (3.6ms) CREATE TABLE "appt_blocks" ("id" serial primary key, "created_at" timestamp NOT NULL, "updated_at" timestamp NOT NULL)  SQL (0.4ms) INSERT INTO "schema_migrations" ("version") VALUES ($1) [["version", "20150804003348"]]  (0.8ms) COMMIT Migrating to CreateApptAppointments (20150804003846)  (0.4ms) BEGIN  (10.3ms) CREATE TABLE "appt_appointments" ("id" serial primary key, "created_at" timestamp NOT NULL, "updated_at" timestamp NOT NULL)  SQL (0.3ms) INSERT INTO "schema_migrations" ("version") VALUES ($1) [["version", "20150804003846"]]  (0.8ms) COMMIT ActiveRecord::SchemaMigration Load (0.4ms) SELECT "schema_migrations".* FROM "schema_migrations"  (3.1ms) SELECT t2.oid::regclass::text AS to_table, a1.attname AS column, a2.attname AS primary_key, c.conname AS name, c.confupdtype AS on_update, c.confdeltype AS on_delete FROM pg_constraint c JOIN pg_class t1 ON c.conrelid = t1.oid JOIN pg_class t2 ON c.confrelid = t2.oid JOIN pg_attribute a1 ON a1.attnum = c.conkey[1] AND a1.attrelid = t1.oid JOIN pg_attribute a2 ON a2.attnum = c.confkey[1] AND a2.attrelid = t2.oid JOIN pg_namespace t3 ON c.connamespace = t3.oid WHERE c.contype = 'f' AND t1.relname = 'appt_appointments' AND t3.nspname = ANY (current_schemas(false)) ORDER BY c.conname   (2.9ms) SELECT t2.oid::regclass::text AS to_table, a1.attname AS column, a2.attname AS primary_key, c.conname AS name, c.confupdtype AS on_update, c.confdeltype AS on_delete FROM pg_constraint c JOIN pg_class t1 ON c.conrelid = t1.oid JOIN pg_class t2 ON c.confrelid = t2.oid JOIN pg_attribute a1 ON a1.attnum = c.conkey[1] AND a1.attrelid = t1.oid JOIN pg_attribute a2 ON a2.attnum = c.confkey[1] AND a2.attrelid = t2.oid JOIN pg_namespace t3 ON c.connamespace = t3.oid WHERE c.contype = 'f' AND t1.relname = 'appt_blocks' AND t3.nspname = ANY (current_schemas(false)) ORDER BY c.conname  (2.9ms) SELECT t2.oid::regclass::text AS to_table, a1.attname AS column, a2.attname AS primary_key, c.conname AS name, c.confupdtype AS on_update, c.confdeltype AS on_delete FROM pg_constraint c JOIN pg_class t1 ON c.conrelid = t1.oid JOIN pg_class t2 ON c.confrelid = t2.oid JOIN pg_attribute a1 ON a1.attnum = c.conkey[1] AND a1.attrelid = t1.oid JOIN pg_attribute a2 ON a2.attnum = c.confkey[1] AND a2.attrelid = t2.oid JOIN pg_namespace t3 ON c.connamespace = t3.oid WHERE c.contype = 'f' AND t1.relname = 'appt_calendars' AND t3.nspname = ANY (current_schemas(false)) ORDER BY c.conname