Started GET "/orders/new" for 127.0.0.1 at 2014-12-25 03:57:30 +0200 ActiveRecord::SchemaMigration Load (0.0ms) SELECT "schema_migrations".* FROM "schema_migrations" Processing by OrdersController#new as HTML Rendered orders/_form.html.erb (105.0ms) Rendered orders/new.html.erb within layouts/application (109.0ms) Completed 500 Internal Server Error in 54001ms ActionView::Template::Error ( (in D:/mmx/projects/www/myrails/bootstrap3_autocomplete_input/test/dummy/app/assets/javascripts/application.js)): 3: 4: Dummy 5: <%= stylesheet_link_tag 'application', media: 'all', 'data-turbolinks-track' => true %> 6: <%= javascript_include_tag 'application', 'data-turbolinks-track' => true %> 7: <%= csrf_meta_tags %> 8: 9: app/views/layouts/application.html.erb:6:in `_app_views_layouts_application_html_erb___166866100_43449204' Rendered D:/Ruby200p451x32/lib/ruby/gems/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (2.0ms) Rendered D:/Ruby200p451x32/lib/ruby/gems/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (1.0ms) Rendered D:/Ruby200p451x32/lib/ruby/gems/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/middleware/templates/rescues/template_error.html.erb within rescues/layout (18.0ms) Started GET "/orders/new" for 127.0.0.1 at 2014-12-25 03:58:24 +0200 Processing by OrdersController#new as HTML Rendered orders/_form.html.erb (8.0ms) Rendered orders/new.html.erb within layouts/application (10.0ms) Completed in 129ms Started GET "/orders/new" for 127.0.0.1 at 2014-12-25 03:58:41 +0200 ActiveRecord::SchemaMigration Load (0.0ms) SELECT "schema_migrations".* FROM "schema_migrations" Processing by OrdersController#new as HTML Rendered orders/_form.html.erb (80.0ms) Rendered orders/new.html.erb within layouts/application (85.0ms) Completed 500 Internal Server Error in 61472ms ActionView::Template::Error ( (in D:/mmx/projects/www/myrails/bootstrap3_autocomplete_input/test/dummy/app/assets/javascripts/application.js)): 3: 4: Dummy 5: <%= stylesheet_link_tag 'application', media: 'all', 'data-turbolinks-track' => true %> 6: <%= javascript_include_tag 'application', 'data-turbolinks-track' => true %> 7: <%= csrf_meta_tags %> 8: 9: app/views/layouts/application.html.erb:6:in `_app_views_layouts_application_html_erb___117824639_33822924' Rendered D:/Ruby200p451x32/lib/ruby/gems/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (1.0ms) Rendered D:/Ruby200p451x32/lib/ruby/gems/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (1.0ms) Rendered D:/Ruby200p451x32/lib/ruby/gems/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/middleware/templates/rescues/template_error.html.erb within rescues/layout (17.0ms) Started GET "/orders/new" for 127.0.0.1 at 2014-12-25 03:59:43 +0200 Processing by OrdersController#new as HTML Rendered orders/_form.html.erb (12.0ms) Rendered orders/new.html.erb within layouts/application (13.0ms) Completed in 100ms Started GET "/orders/new" for 127.0.0.1 at 2014-12-25 04:02:36 +0200 ActiveRecord::SchemaMigration Load (0.0ms) SELECT "schema_migrations".* FROM "schema_migrations" Processing by OrdersController#new as HTML Rendered orders/_form.html.erb (147.0ms) Rendered orders/new.html.erb within layouts/application (154.0ms) Completed 500 Internal Server Error in 57309ms ActionView::Template::Error ( (in D:/Ruby200p451x32/lib/ruby/gems/2.0.0/gems/jquery-rails-3.1.2/vendor/assets/javascripts/jquery.js)): 3: 4: Dummy 5: <%= stylesheet_link_tag 'application', media: 'all', 'data-turbolinks-track' => true %> 6: <%= javascript_include_tag 'application', 'data-turbolinks-track' => true %> 7: <%= csrf_meta_tags %> 8: 9: app/views/layouts/application.html.erb:6:in `_app_views_layouts_application_html_erb___315908633_43324008' Rendered D:/Ruby200p451x32/lib/ruby/gems/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/middleware/templates/rescues/template_error.html.erb within rescues/layout (1.0ms) Started GET "/orders/new" for 127.0.0.1 at 2014-12-25 04:04:24 +0200 ActiveRecord::SchemaMigration Load (0.0ms) SELECT "schema_migrations".* FROM "schema_migrations" Processing by OrdersController#new as HTML Rendered orders/_form.html.erb (176.0ms) Rendered orders/new.html.erb within layouts/application (186.0ms) Completed 200 OK in 473ms (Views: 463.0ms | ActiveRecord: 1.0ms) Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2014-12-25 04:04:25 +0200 Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2014-12-25 04:04:25 +0200 Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2014-12-25 04:04:25 +0200 Started GET "/assets/bootstrap.js?body=1" for 127.0.0.1 at 2014-12-25 04:04:25 +0200 Started GET "/assets/bootstrap3-typeahead.js?body=1" for 127.0.0.1 at 2014-12-25 04:04:25 +0200 Started GET "/assets/bootstrap3-autocomplete-input.js?body=1" for 127.0.0.1 at 2014-12-25 04:04:25 +0200 Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2014-12-25 04:04:25 +0200 Started GET "/orders/autocomplete_client_name?q=b" for 127.0.0.1 at 2014-12-25 04:04:29 +0200 Processing by OrdersController#autocomplete_client_name as JSON Parameters: {"q"=>"b"} Client Load (1.0ms) SELECT clients.id, clients.name FROM "clients" WHERE (LOWER(clients.name) LIKE 'b%') ORDER BY clients.name ASC LIMIT 10 Completed 200 OK in 11ms (Views: 0.0ms | ActiveRecord: 2.0ms) Started GET "/orders/autocomplete_client_name?q=ba" for 127.0.0.1 at 2014-12-25 04:04:30 +0200 Processing by OrdersController#autocomplete_client_name as JSON Parameters: {"q"=>"ba"} Client Load (1.0ms) SELECT clients.id, clients.name FROM "clients" WHERE (LOWER(clients.name) LIKE 'ba%') ORDER BY clients.name ASC LIMIT 10 Completed 200 OK in 2ms (Views: 0.0ms | ActiveRecord: 1.0ms) Started GET "/orders/new" for 127.0.0.1 at 2014-12-25 04:17:30 +0200 ActiveRecord::SchemaMigration Load (0.0ms) SELECT "schema_migrations".* FROM "schema_migrations" Processing by OrdersController#new as HTML Rendered orders/_form.html.erb (215.0ms) Rendered orders/new.html.erb within layouts/application (226.0ms) Completed 200 OK in 618ms (Views: 608.0ms | ActiveRecord: 1.0ms) Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2014-12-25 04:17:32 +0200 Started GET "/assets/bootstrap3-typeahead.min.js?body=1" for 127.0.0.1 at 2014-12-25 04:17:32 +0200 Started GET "/assets/bootstrap3-autocomplete-input.min.js?body=1" for 127.0.0.1 at 2014-12-25 04:17:32 +0200 Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2014-12-25 04:17:32 +0200 Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2014-12-25 04:17:32 +0200 Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2014-12-25 04:17:32 +0200 Started GET "/assets/bootstrap.js?body=1" for 127.0.0.1 at 2014-12-25 04:17:32 +0200 Started GET "/orders/autocomplete_client_name?q=b" for 127.0.0.1 at 2014-12-25 04:17:45 +0200 Processing by OrdersController#autocomplete_client_name as JSON Parameters: {"q"=>"b"} Client Load (0.0ms) SELECT clients.id, clients.name FROM "clients" WHERE (LOWER(clients.name) LIKE 'b%') ORDER BY clients.name ASC LIMIT 10 Completed 200 OK in 25ms (Views: 1.0ms | ActiveRecord: 1.0ms) Started GET "/" for 127.0.0.1 at 2015-03-04 02:02:00 +0200 Gem::LoadError (Specified 'sqlite3' for database adapter, but the gem is not loaded. Add `gem 'sqlite3'` to your Gemfile (and ensure its version is at the minimum required by ActiveRecord).): activerecord (4.1.8) lib/active_record/connection_adapters/connection_specification.rb:190:in `rescue in spec' activerecord (4.1.8) lib/active_record/connection_adapters/connection_specification.rb:187:in `spec' activerecord (4.1.8) lib/active_record/connection_handling.rb:50:in `establish_connection' activerecord (4.1.8) lib/active_record/railtie.rb:129:in `block (2 levels) in ' activesupport (4.1.8) lib/active_support/lazy_load_hooks.rb:38:in `instance_eval' activesupport (4.1.8) lib/active_support/lazy_load_hooks.rb:38:in `execute_hook' activesupport (4.1.8) lib/active_support/lazy_load_hooks.rb:45:in `block in run_load_hooks' activesupport (4.1.8) lib/active_support/lazy_load_hooks.rb:44:in `each' activesupport (4.1.8) lib/active_support/lazy_load_hooks.rb:44:in `run_load_hooks' activerecord (4.1.8) lib/active_record/base.rb:326:in `' activerecord (4.1.8) lib/active_record/base.rb:23:in `' activerecord (4.1.8) lib/active_record/migration.rb:388:in `check_pending!' activerecord (4.1.8) lib/active_record/migration.rb:377:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/callbacks.rb:29:in `block in call' activesupport (4.1.8) lib/active_support/callbacks.rb:82:in `run_callbacks' actionpack (4.1.8) lib/action_dispatch/middleware/callbacks.rb:27:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/reloader.rb:73:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/remote_ip.rb:76:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/debug_exceptions.rb:17:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/show_exceptions.rb:30:in `call' railties (4.1.8) lib/rails/rack/logger.rb:38:in `call_app' railties (4.1.8) lib/rails/rack/logger.rb:20:in `block in call' activesupport (4.1.8) lib/active_support/tagged_logging.rb:68:in `block in tagged' activesupport (4.1.8) lib/active_support/tagged_logging.rb:26:in `tagged' activesupport (4.1.8) lib/active_support/tagged_logging.rb:68:in `tagged' railties (4.1.8) lib/rails/rack/logger.rb:20:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/request_id.rb:21:in `call' rack (1.5.2) lib/rack/methodoverride.rb:21:in `call' rack (1.5.2) lib/rack/runtime.rb:17:in `call' activesupport (4.1.8) lib/active_support/cache/strategy/local_cache_middleware.rb:26:in `call' rack (1.5.2) lib/rack/lock.rb:17:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/static.rb:84:in `call' rack (1.5.2) lib/rack/sendfile.rb:112:in `call' railties (4.1.8) lib/rails/engine.rb:514:in `call' railties (4.1.8) lib/rails/application.rb:144:in `call' rack (1.5.2) lib/rack/lock.rb:17:in `call' rack (1.5.2) lib/rack/content_length.rb:14:in `call' rack (1.5.2) lib/rack/handler/webrick.rb:60:in `service' D:/Ruby200p451x32/lib/ruby/2.0.0/webrick/httpserver.rb:138:in `service' D:/Ruby200p451x32/lib/ruby/2.0.0/webrick/httpserver.rb:94:in `run' D:/Ruby200p451x32/lib/ruby/2.0.0/webrick/server.rb:295:in `block in start_thread' Rendered D:/Ruby200p451x32/lib/ruby/gems/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/middleware/templates/rescues/_source.erb (2.0ms) Rendered D:/Ruby200p451x32/lib/ruby/gems/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (1.0ms) Rendered D:/Ruby200p451x32/lib/ruby/gems/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (1.0ms) Rendered D:/Ruby200p451x32/lib/ruby/gems/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/middleware/templates/rescues/diagnostics.erb within rescues/layout (97.0ms) Started GET "/" for 127.0.0.1 at 2015-03-04 02:03:45 +0200 Gem::LoadError (Specified 'sqlite3' for database adapter, but the gem is not loaded. Add `gem 'sqlite3'` to your Gemfile (and ensure its version is at the minimum required by ActiveRecord).): activerecord (4.1.8) lib/active_record/connection_adapters/connection_specification.rb:190:in `rescue in spec' activerecord (4.1.8) lib/active_record/connection_adapters/connection_specification.rb:187:in `spec' activerecord (4.1.8) lib/active_record/connection_handling.rb:50:in `establish_connection' activerecord (4.1.8) lib/active_record/railtie.rb:129:in `block (2 levels) in ' activesupport (4.1.8) lib/active_support/lazy_load_hooks.rb:38:in `instance_eval' activesupport (4.1.8) lib/active_support/lazy_load_hooks.rb:38:in `execute_hook' activesupport (4.1.8) lib/active_support/lazy_load_hooks.rb:45:in `block in run_load_hooks' activesupport (4.1.8) lib/active_support/lazy_load_hooks.rb:44:in `each' activesupport (4.1.8) lib/active_support/lazy_load_hooks.rb:44:in `run_load_hooks' activerecord (4.1.8) lib/active_record/base.rb:326:in `' activerecord (4.1.8) lib/active_record/base.rb:23:in `' activerecord (4.1.8) lib/active_record/migration.rb:388:in `check_pending!' activerecord (4.1.8) lib/active_record/migration.rb:377:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/callbacks.rb:29:in `block in call' activesupport (4.1.8) lib/active_support/callbacks.rb:82:in `run_callbacks' actionpack (4.1.8) lib/action_dispatch/middleware/callbacks.rb:27:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/reloader.rb:73:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/remote_ip.rb:76:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/debug_exceptions.rb:17:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/show_exceptions.rb:30:in `call' railties (4.1.8) lib/rails/rack/logger.rb:38:in `call_app' railties (4.1.8) lib/rails/rack/logger.rb:20:in `block in call' activesupport (4.1.8) lib/active_support/tagged_logging.rb:68:in `block in tagged' activesupport (4.1.8) lib/active_support/tagged_logging.rb:26:in `tagged' activesupport (4.1.8) lib/active_support/tagged_logging.rb:68:in `tagged' railties (4.1.8) lib/rails/rack/logger.rb:20:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/request_id.rb:21:in `call' rack (1.5.2) lib/rack/methodoverride.rb:21:in `call' rack (1.5.2) lib/rack/runtime.rb:17:in `call' activesupport (4.1.8) lib/active_support/cache/strategy/local_cache_middleware.rb:26:in `call' rack (1.5.2) lib/rack/lock.rb:17:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/static.rb:84:in `call' rack (1.5.2) lib/rack/sendfile.rb:112:in `call' railties (4.1.8) lib/rails/engine.rb:514:in `call' railties (4.1.8) lib/rails/application.rb:144:in `call' rack (1.5.2) lib/rack/lock.rb:17:in `call' rack (1.5.2) lib/rack/content_length.rb:14:in `call' rack (1.5.2) lib/rack/handler/webrick.rb:60:in `service' D:/Ruby200p451x32/lib/ruby/2.0.0/webrick/httpserver.rb:138:in `service' D:/Ruby200p451x32/lib/ruby/2.0.0/webrick/httpserver.rb:94:in `run' D:/Ruby200p451x32/lib/ruby/2.0.0/webrick/server.rb:295:in `block in start_thread' Rendered D:/Ruby200p451x32/lib/ruby/gems/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/middleware/templates/rescues/_source.erb (0.0ms) Rendered D:/Ruby200p451x32/lib/ruby/gems/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (1.0ms) Rendered D:/Ruby200p451x32/lib/ruby/gems/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (1.0ms) Rendered D:/Ruby200p451x32/lib/ruby/gems/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/middleware/templates/rescues/diagnostics.erb within rescues/layout (19.0ms) Started GET "/" for 127.0.0.1 at 2015-03-18 02:41:56 +0200 Gem::LoadError (Specified 'sqlite3' for database adapter, but the gem is not loaded. Add `gem 'sqlite3'` to your Gemfile (and ensure its version is at the minimum required by ActiveRecord).): activerecord (4.1.8) lib/active_record/connection_adapters/connection_specification.rb:190:in `rescue in spec' activerecord (4.1.8) lib/active_record/connection_adapters/connection_specification.rb:187:in `spec' activerecord (4.1.8) lib/active_record/connection_handling.rb:50:in `establish_connection' activerecord (4.1.8) lib/active_record/railtie.rb:129:in `block (2 levels) in ' activesupport (4.1.8) lib/active_support/lazy_load_hooks.rb:38:in `instance_eval' activesupport (4.1.8) lib/active_support/lazy_load_hooks.rb:38:in `execute_hook' activesupport (4.1.8) lib/active_support/lazy_load_hooks.rb:45:in `block in run_load_hooks' activesupport (4.1.8) lib/active_support/lazy_load_hooks.rb:44:in `each' activesupport (4.1.8) lib/active_support/lazy_load_hooks.rb:44:in `run_load_hooks' activerecord (4.1.8) lib/active_record/base.rb:326:in `' activerecord (4.1.8) lib/active_record/base.rb:23:in `' activerecord (4.1.8) lib/active_record/migration.rb:388:in `check_pending!' activerecord (4.1.8) lib/active_record/migration.rb:377:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/callbacks.rb:29:in `block in call' activesupport (4.1.8) lib/active_support/callbacks.rb:82:in `run_callbacks' actionpack (4.1.8) lib/action_dispatch/middleware/callbacks.rb:27:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/reloader.rb:73:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/remote_ip.rb:76:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/debug_exceptions.rb:17:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/show_exceptions.rb:30:in `call' railties (4.1.8) lib/rails/rack/logger.rb:38:in `call_app' railties (4.1.8) lib/rails/rack/logger.rb:20:in `block in call' activesupport (4.1.8) lib/active_support/tagged_logging.rb:68:in `block in tagged' activesupport (4.1.8) lib/active_support/tagged_logging.rb:26:in `tagged' activesupport (4.1.8) lib/active_support/tagged_logging.rb:68:in `tagged' railties (4.1.8) lib/rails/rack/logger.rb:20:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/request_id.rb:21:in `call' rack (1.5.2) lib/rack/methodoverride.rb:21:in `call' rack (1.5.2) lib/rack/runtime.rb:17:in `call' activesupport (4.1.8) lib/active_support/cache/strategy/local_cache_middleware.rb:26:in `call' rack (1.5.2) lib/rack/lock.rb:17:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/static.rb:84:in `call' rack (1.5.2) lib/rack/sendfile.rb:112:in `call' railties (4.1.8) lib/rails/engine.rb:514:in `call' railties (4.1.8) lib/rails/application.rb:144:in `call' rack (1.5.2) lib/rack/lock.rb:17:in `call' rack (1.5.2) lib/rack/content_length.rb:14:in `call' rack (1.5.2) lib/rack/handler/webrick.rb:60:in `service' D:/Ruby200p451x32/lib/ruby/2.0.0/webrick/httpserver.rb:138:in `service' D:/Ruby200p451x32/lib/ruby/2.0.0/webrick/httpserver.rb:94:in `run' D:/Ruby200p451x32/lib/ruby/2.0.0/webrick/server.rb:295:in `block in start_thread' Rendered D:/Ruby200p451x32/lib/ruby/gems/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/middleware/templates/rescues/_source.erb (0.0ms) Rendered D:/Ruby200p451x32/lib/ruby/gems/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (1.0ms) Rendered D:/Ruby200p451x32/lib/ruby/gems/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (1.0ms) Rendered D:/Ruby200p451x32/lib/ruby/gems/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/middleware/templates/rescues/diagnostics.erb within rescues/layout (64.0ms) Started GET "/" for 127.0.0.1 at 2015-03-18 02:45:34 +0200 Gem::LoadError (Specified 'sqlite3' for database adapter, but the gem is not loaded. Add `gem 'sqlite3'` to your Gemfile (and ensure its version is at the minimum required by ActiveRecord).): activerecord (4.1.8) lib/active_record/connection_adapters/connection_specification.rb:190:in `rescue in spec' activerecord (4.1.8) lib/active_record/connection_adapters/connection_specification.rb:187:in `spec' activerecord (4.1.8) lib/active_record/connection_handling.rb:50:in `establish_connection' activerecord (4.1.8) lib/active_record/railtie.rb:129:in `block (2 levels) in ' activesupport (4.1.8) lib/active_support/lazy_load_hooks.rb:38:in `instance_eval' activesupport (4.1.8) lib/active_support/lazy_load_hooks.rb:38:in `execute_hook' activesupport (4.1.8) lib/active_support/lazy_load_hooks.rb:45:in `block in run_load_hooks' activesupport (4.1.8) lib/active_support/lazy_load_hooks.rb:44:in `each' activesupport (4.1.8) lib/active_support/lazy_load_hooks.rb:44:in `run_load_hooks' activerecord (4.1.8) lib/active_record/base.rb:326:in `' activerecord (4.1.8) lib/active_record/base.rb:23:in `' activerecord (4.1.8) lib/active_record/migration.rb:388:in `check_pending!' activerecord (4.1.8) lib/active_record/migration.rb:377:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/callbacks.rb:29:in `block in call' activesupport (4.1.8) lib/active_support/callbacks.rb:82:in `run_callbacks' actionpack (4.1.8) lib/action_dispatch/middleware/callbacks.rb:27:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/reloader.rb:73:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/remote_ip.rb:76:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/debug_exceptions.rb:17:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/show_exceptions.rb:30:in `call' railties (4.1.8) lib/rails/rack/logger.rb:38:in `call_app' railties (4.1.8) lib/rails/rack/logger.rb:20:in `block in call' activesupport (4.1.8) lib/active_support/tagged_logging.rb:68:in `block in tagged' activesupport (4.1.8) lib/active_support/tagged_logging.rb:26:in `tagged' activesupport (4.1.8) lib/active_support/tagged_logging.rb:68:in `tagged' railties (4.1.8) lib/rails/rack/logger.rb:20:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/request_id.rb:21:in `call' rack (1.5.2) lib/rack/methodoverride.rb:21:in `call' rack (1.5.2) lib/rack/runtime.rb:17:in `call' activesupport (4.1.8) lib/active_support/cache/strategy/local_cache_middleware.rb:26:in `call' rack (1.5.2) lib/rack/lock.rb:17:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/static.rb:84:in `call' rack (1.5.2) lib/rack/sendfile.rb:112:in `call' railties (4.1.8) lib/rails/engine.rb:514:in `call' railties (4.1.8) lib/rails/application.rb:144:in `call' rack (1.5.2) lib/rack/lock.rb:17:in `call' rack (1.5.2) lib/rack/content_length.rb:14:in `call' rack (1.5.2) lib/rack/handler/webrick.rb:60:in `service' D:/Ruby200p451x32/lib/ruby/2.0.0/webrick/httpserver.rb:138:in `service' D:/Ruby200p451x32/lib/ruby/2.0.0/webrick/httpserver.rb:94:in `run' D:/Ruby200p451x32/lib/ruby/2.0.0/webrick/server.rb:295:in `block in start_thread' Rendered D:/Ruby200p451x32/lib/ruby/gems/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/middleware/templates/rescues/_source.erb (1.0ms) Rendered D:/Ruby200p451x32/lib/ruby/gems/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (0.0ms) Rendered D:/Ruby200p451x32/lib/ruby/gems/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (1.0ms) Rendered D:/Ruby200p451x32/lib/ruby/gems/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/middleware/templates/rescues/diagnostics.erb within rescues/layout (18.0ms) Started GET "/" for 127.0.0.1 at 2015-03-18 02:46:18 +0200 Gem::LoadError (Specified 'sqlite3' for database adapter, but the gem is not loaded. Add `gem 'sqlite3'` to your Gemfile (and ensure its version is at the minimum required by ActiveRecord).): activerecord (4.1.8) lib/active_record/connection_adapters/connection_specification.rb:190:in `rescue in spec' activerecord (4.1.8) lib/active_record/connection_adapters/connection_specification.rb:187:in `spec' activerecord (4.1.8) lib/active_record/connection_handling.rb:50:in `establish_connection' activerecord (4.1.8) lib/active_record/railtie.rb:129:in `block (2 levels) in ' activesupport (4.1.8) lib/active_support/lazy_load_hooks.rb:38:in `instance_eval' activesupport (4.1.8) lib/active_support/lazy_load_hooks.rb:38:in `execute_hook' activesupport (4.1.8) lib/active_support/lazy_load_hooks.rb:45:in `block in run_load_hooks' activesupport (4.1.8) lib/active_support/lazy_load_hooks.rb:44:in `each' activesupport (4.1.8) lib/active_support/lazy_load_hooks.rb:44:in `run_load_hooks' activerecord (4.1.8) lib/active_record/base.rb:326:in `' activerecord (4.1.8) lib/active_record/base.rb:23:in `' activerecord (4.1.8) lib/active_record/migration.rb:388:in `check_pending!' activerecord (4.1.8) lib/active_record/migration.rb:377:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/callbacks.rb:29:in `block in call' activesupport (4.1.8) lib/active_support/callbacks.rb:82:in `run_callbacks' actionpack (4.1.8) lib/action_dispatch/middleware/callbacks.rb:27:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/reloader.rb:73:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/remote_ip.rb:76:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/debug_exceptions.rb:17:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/show_exceptions.rb:30:in `call' railties (4.1.8) lib/rails/rack/logger.rb:38:in `call_app' railties (4.1.8) lib/rails/rack/logger.rb:20:in `block in call' activesupport (4.1.8) lib/active_support/tagged_logging.rb:68:in `block in tagged' activesupport (4.1.8) lib/active_support/tagged_logging.rb:26:in `tagged' activesupport (4.1.8) lib/active_support/tagged_logging.rb:68:in `tagged' railties (4.1.8) lib/rails/rack/logger.rb:20:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/request_id.rb:21:in `call' rack (1.5.2) lib/rack/methodoverride.rb:21:in `call' rack (1.5.2) lib/rack/runtime.rb:17:in `call' activesupport (4.1.8) lib/active_support/cache/strategy/local_cache_middleware.rb:26:in `call' rack (1.5.2) lib/rack/lock.rb:17:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/static.rb:84:in `call' rack (1.5.2) lib/rack/sendfile.rb:112:in `call' railties (4.1.8) lib/rails/engine.rb:514:in `call' railties (4.1.8) lib/rails/application.rb:144:in `call' rack (1.5.2) lib/rack/lock.rb:17:in `call' rack (1.5.2) lib/rack/content_length.rb:14:in `call' rack (1.5.2) lib/rack/handler/webrick.rb:60:in `service' D:/Ruby200p451x32/lib/ruby/2.0.0/webrick/httpserver.rb:138:in `service' D:/Ruby200p451x32/lib/ruby/2.0.0/webrick/httpserver.rb:94:in `run' D:/Ruby200p451x32/lib/ruby/2.0.0/webrick/server.rb:295:in `block in start_thread' Rendered D:/Ruby200p451x32/lib/ruby/gems/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/middleware/templates/rescues/_source.erb (0.0ms) Rendered D:/Ruby200p451x32/lib/ruby/gems/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (1.0ms) Rendered D:/Ruby200p451x32/lib/ruby/gems/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (1.0ms) Rendered D:/Ruby200p451x32/lib/ruby/gems/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/middleware/templates/rescues/diagnostics.erb within rescues/layout (18.0ms) Started GET "/" for 127.0.0.1 at 2015-03-18 02:46:45 +0200 Gem::LoadError (Specified 'sqlite3' for database adapter, but the gem is not loaded. Add `gem 'sqlite3'` to your Gemfile (and ensure its version is at the minimum required by ActiveRecord).): activerecord (4.1.8) lib/active_record/connection_adapters/connection_specification.rb:190:in `rescue in spec' activerecord (4.1.8) lib/active_record/connection_adapters/connection_specification.rb:187:in `spec' activerecord (4.1.8) lib/active_record/connection_handling.rb:50:in `establish_connection' activerecord (4.1.8) lib/active_record/railtie.rb:129:in `block (2 levels) in ' activesupport (4.1.8) lib/active_support/lazy_load_hooks.rb:38:in `instance_eval' activesupport (4.1.8) lib/active_support/lazy_load_hooks.rb:38:in `execute_hook' activesupport (4.1.8) lib/active_support/lazy_load_hooks.rb:45:in `block in run_load_hooks' activesupport (4.1.8) lib/active_support/lazy_load_hooks.rb:44:in `each' activesupport (4.1.8) lib/active_support/lazy_load_hooks.rb:44:in `run_load_hooks' activerecord (4.1.8) lib/active_record/base.rb:326:in `' activerecord (4.1.8) lib/active_record/base.rb:23:in `' activerecord (4.1.8) lib/active_record/migration.rb:388:in `check_pending!' activerecord (4.1.8) lib/active_record/migration.rb:377:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/callbacks.rb:29:in `block in call' activesupport (4.1.8) lib/active_support/callbacks.rb:82:in `run_callbacks' actionpack (4.1.8) lib/action_dispatch/middleware/callbacks.rb:27:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/reloader.rb:73:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/remote_ip.rb:76:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/debug_exceptions.rb:17:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/show_exceptions.rb:30:in `call' railties (4.1.8) lib/rails/rack/logger.rb:38:in `call_app' railties (4.1.8) lib/rails/rack/logger.rb:20:in `block in call' activesupport (4.1.8) lib/active_support/tagged_logging.rb:68:in `block in tagged' activesupport (4.1.8) lib/active_support/tagged_logging.rb:26:in `tagged' activesupport (4.1.8) lib/active_support/tagged_logging.rb:68:in `tagged' railties (4.1.8) lib/rails/rack/logger.rb:20:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/request_id.rb:21:in `call' rack (1.5.2) lib/rack/methodoverride.rb:21:in `call' rack (1.5.2) lib/rack/runtime.rb:17:in `call' activesupport (4.1.8) lib/active_support/cache/strategy/local_cache_middleware.rb:26:in `call' rack (1.5.2) lib/rack/lock.rb:17:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/static.rb:84:in `call' rack (1.5.2) lib/rack/sendfile.rb:112:in `call' railties (4.1.8) lib/rails/engine.rb:514:in `call' railties (4.1.8) lib/rails/application.rb:144:in `call' rack (1.5.2) lib/rack/lock.rb:17:in `call' rack (1.5.2) lib/rack/content_length.rb:14:in `call' rack (1.5.2) lib/rack/handler/webrick.rb:60:in `service' D:/Ruby200p451x32/lib/ruby/2.0.0/webrick/httpserver.rb:138:in `service' D:/Ruby200p451x32/lib/ruby/2.0.0/webrick/httpserver.rb:94:in `run' D:/Ruby200p451x32/lib/ruby/2.0.0/webrick/server.rb:295:in `block in start_thread' Rendered D:/Ruby200p451x32/lib/ruby/gems/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/middleware/templates/rescues/_source.erb (0.0ms) Rendered D:/Ruby200p451x32/lib/ruby/gems/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (1.0ms) Rendered D:/Ruby200p451x32/lib/ruby/gems/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (0.0ms) Rendered D:/Ruby200p451x32/lib/ruby/gems/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/middleware/templates/rescues/diagnostics.erb within rescues/layout (19.0ms) Started GET "/" for 127.0.0.1 at 2015-03-18 02:46:47 +0200 Gem::LoadError (Specified 'sqlite3' for database adapter, but the gem is not loaded. Add `gem 'sqlite3'` to your Gemfile (and ensure its version is at the minimum required by ActiveRecord).): activerecord (4.1.8) lib/active_record/connection_adapters/connection_specification.rb:190:in `rescue in spec' activerecord (4.1.8) lib/active_record/connection_adapters/connection_specification.rb:187:in `spec' activerecord (4.1.8) lib/active_record/connection_handling.rb:50:in `establish_connection' activerecord (4.1.8) lib/active_record/railtie.rb:129:in `block (2 levels) in ' activesupport (4.1.8) lib/active_support/lazy_load_hooks.rb:38:in `instance_eval' activesupport (4.1.8) lib/active_support/lazy_load_hooks.rb:38:in `execute_hook' activesupport (4.1.8) lib/active_support/lazy_load_hooks.rb:45:in `block in run_load_hooks' activesupport (4.1.8) lib/active_support/lazy_load_hooks.rb:44:in `each' activesupport (4.1.8) lib/active_support/lazy_load_hooks.rb:44:in `run_load_hooks' activerecord (4.1.8) lib/active_record/base.rb:326:in `' activerecord (4.1.8) lib/active_record/base.rb:23:in `' activerecord (4.1.8) lib/active_record/migration.rb:388:in `check_pending!' activerecord (4.1.8) lib/active_record/migration.rb:377:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/callbacks.rb:29:in `block in call' activesupport (4.1.8) lib/active_support/callbacks.rb:82:in `run_callbacks' actionpack (4.1.8) lib/action_dispatch/middleware/callbacks.rb:27:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/reloader.rb:73:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/remote_ip.rb:76:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/debug_exceptions.rb:17:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/show_exceptions.rb:30:in `call' railties (4.1.8) lib/rails/rack/logger.rb:38:in `call_app' railties (4.1.8) lib/rails/rack/logger.rb:20:in `block in call' activesupport (4.1.8) lib/active_support/tagged_logging.rb:68:in `block in tagged' activesupport (4.1.8) lib/active_support/tagged_logging.rb:26:in `tagged' activesupport (4.1.8) lib/active_support/tagged_logging.rb:68:in `tagged' railties (4.1.8) lib/rails/rack/logger.rb:20:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/request_id.rb:21:in `call' rack (1.5.2) lib/rack/methodoverride.rb:21:in `call' rack (1.5.2) lib/rack/runtime.rb:17:in `call' activesupport (4.1.8) lib/active_support/cache/strategy/local_cache_middleware.rb:26:in `call' rack (1.5.2) lib/rack/lock.rb:17:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/static.rb:84:in `call' rack (1.5.2) lib/rack/sendfile.rb:112:in `call' railties (4.1.8) lib/rails/engine.rb:514:in `call' railties (4.1.8) lib/rails/application.rb:144:in `call' rack (1.5.2) lib/rack/lock.rb:17:in `call' rack (1.5.2) lib/rack/content_length.rb:14:in `call' rack (1.5.2) lib/rack/handler/webrick.rb:60:in `service' D:/Ruby200p451x32/lib/ruby/2.0.0/webrick/httpserver.rb:138:in `service' D:/Ruby200p451x32/lib/ruby/2.0.0/webrick/httpserver.rb:94:in `run' D:/Ruby200p451x32/lib/ruby/2.0.0/webrick/server.rb:295:in `block in start_thread' Rendered D:/Ruby200p451x32/lib/ruby/gems/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/middleware/templates/rescues/_source.erb (0.0ms) Rendered D:/Ruby200p451x32/lib/ruby/gems/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (1.0ms) Rendered D:/Ruby200p451x32/lib/ruby/gems/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (1.0ms) Rendered D:/Ruby200p451x32/lib/ruby/gems/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/middleware/templates/rescues/diagnostics.erb within rescues/layout (18.0ms) Started GET "/" for 127.0.0.1 at 2015-03-18 02:48:15 +0200 Gem::LoadError (Specified 'sqlite3' for database adapter, but the gem is not loaded. Add `gem 'sqlite3'` to your Gemfile (and ensure its version is at the minimum required by ActiveRecord).): activerecord (4.1.8) lib/active_record/connection_adapters/connection_specification.rb:190:in `rescue in spec' activerecord (4.1.8) lib/active_record/connection_adapters/connection_specification.rb:187:in `spec' activerecord (4.1.8) lib/active_record/connection_handling.rb:50:in `establish_connection' activerecord (4.1.8) lib/active_record/railtie.rb:129:in `block (2 levels) in ' activesupport (4.1.8) lib/active_support/lazy_load_hooks.rb:38:in `instance_eval' activesupport (4.1.8) lib/active_support/lazy_load_hooks.rb:38:in `execute_hook' activesupport (4.1.8) lib/active_support/lazy_load_hooks.rb:45:in `block in run_load_hooks' activesupport (4.1.8) lib/active_support/lazy_load_hooks.rb:44:in `each' activesupport (4.1.8) lib/active_support/lazy_load_hooks.rb:44:in `run_load_hooks' activerecord (4.1.8) lib/active_record/base.rb:326:in `' activerecord (4.1.8) lib/active_record/base.rb:23:in `' activerecord (4.1.8) lib/active_record/migration.rb:388:in `check_pending!' activerecord (4.1.8) lib/active_record/migration.rb:377:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/callbacks.rb:29:in `block in call' activesupport (4.1.8) lib/active_support/callbacks.rb:82:in `run_callbacks' actionpack (4.1.8) lib/action_dispatch/middleware/callbacks.rb:27:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/reloader.rb:73:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/remote_ip.rb:76:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/debug_exceptions.rb:17:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/show_exceptions.rb:30:in `call' railties (4.1.8) lib/rails/rack/logger.rb:38:in `call_app' railties (4.1.8) lib/rails/rack/logger.rb:20:in `block in call' activesupport (4.1.8) lib/active_support/tagged_logging.rb:68:in `block in tagged' activesupport (4.1.8) lib/active_support/tagged_logging.rb:26:in `tagged' activesupport (4.1.8) lib/active_support/tagged_logging.rb:68:in `tagged' railties (4.1.8) lib/rails/rack/logger.rb:20:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/request_id.rb:21:in `call' rack (1.5.2) lib/rack/methodoverride.rb:21:in `call' rack (1.5.2) lib/rack/runtime.rb:17:in `call' activesupport (4.1.8) lib/active_support/cache/strategy/local_cache_middleware.rb:26:in `call' rack (1.5.2) lib/rack/lock.rb:17:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/static.rb:84:in `call' rack (1.5.2) lib/rack/sendfile.rb:112:in `call' railties (4.1.8) lib/rails/engine.rb:514:in `call' railties (4.1.8) lib/rails/application.rb:144:in `call' rack (1.5.2) lib/rack/lock.rb:17:in `call' rack (1.5.2) lib/rack/content_length.rb:14:in `call' rack (1.5.2) lib/rack/handler/webrick.rb:60:in `service' D:/Ruby200p451x32/lib/ruby/2.0.0/webrick/httpserver.rb:138:in `service' D:/Ruby200p451x32/lib/ruby/2.0.0/webrick/httpserver.rb:94:in `run' D:/Ruby200p451x32/lib/ruby/2.0.0/webrick/server.rb:295:in `block in start_thread' Rendered D:/Ruby200p451x32/lib/ruby/gems/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/middleware/templates/rescues/_source.erb (1.0ms) Rendered D:/Ruby200p451x32/lib/ruby/gems/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (1.0ms) Rendered D:/Ruby200p451x32/lib/ruby/gems/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (1.0ms) Rendered D:/Ruby200p451x32/lib/ruby/gems/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/middleware/templates/rescues/diagnostics.erb within rescues/layout (21.0ms) Started GET "/" for 127.0.0.1 at 2015-03-18 02:48:41 +0200 Gem::LoadError (Specified 'sqlite3' for database adapter, but the gem is not loaded. Add `gem 'sqlite3'` to your Gemfile (and ensure its version is at the minimum required by ActiveRecord).): activerecord (4.1.8) lib/active_record/connection_adapters/connection_specification.rb:190:in `rescue in spec' activerecord (4.1.8) lib/active_record/connection_adapters/connection_specification.rb:187:in `spec' activerecord (4.1.8) lib/active_record/connection_handling.rb:50:in `establish_connection' activerecord (4.1.8) lib/active_record/railtie.rb:129:in `block (2 levels) in ' activesupport (4.1.8) lib/active_support/lazy_load_hooks.rb:38:in `instance_eval' activesupport (4.1.8) lib/active_support/lazy_load_hooks.rb:38:in `execute_hook' activesupport (4.1.8) lib/active_support/lazy_load_hooks.rb:45:in `block in run_load_hooks' activesupport (4.1.8) lib/active_support/lazy_load_hooks.rb:44:in `each' activesupport (4.1.8) lib/active_support/lazy_load_hooks.rb:44:in `run_load_hooks' activerecord (4.1.8) lib/active_record/base.rb:326:in `' activerecord (4.1.8) lib/active_record/base.rb:23:in `' activerecord (4.1.8) lib/active_record/migration.rb:388:in `check_pending!' activerecord (4.1.8) lib/active_record/migration.rb:377:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/callbacks.rb:29:in `block in call' activesupport (4.1.8) lib/active_support/callbacks.rb:82:in `run_callbacks' actionpack (4.1.8) lib/action_dispatch/middleware/callbacks.rb:27:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/reloader.rb:73:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/remote_ip.rb:76:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/debug_exceptions.rb:17:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/show_exceptions.rb:30:in `call' railties (4.1.8) lib/rails/rack/logger.rb:38:in `call_app' railties (4.1.8) lib/rails/rack/logger.rb:20:in `block in call' activesupport (4.1.8) lib/active_support/tagged_logging.rb:68:in `block in tagged' activesupport (4.1.8) lib/active_support/tagged_logging.rb:26:in `tagged' activesupport (4.1.8) lib/active_support/tagged_logging.rb:68:in `tagged' railties (4.1.8) lib/rails/rack/logger.rb:20:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/request_id.rb:21:in `call' rack (1.5.2) lib/rack/methodoverride.rb:21:in `call' rack (1.5.2) lib/rack/runtime.rb:17:in `call' activesupport (4.1.8) lib/active_support/cache/strategy/local_cache_middleware.rb:26:in `call' rack (1.5.2) lib/rack/lock.rb:17:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/static.rb:84:in `call' rack (1.5.2) lib/rack/sendfile.rb:112:in `call' railties (4.1.8) lib/rails/engine.rb:514:in `call' railties (4.1.8) lib/rails/application.rb:144:in `call' rack (1.5.2) lib/rack/lock.rb:17:in `call' rack (1.5.2) lib/rack/content_length.rb:14:in `call' rack (1.5.2) lib/rack/handler/webrick.rb:60:in `service' D:/Ruby200p451x32/lib/ruby/2.0.0/webrick/httpserver.rb:138:in `service' D:/Ruby200p451x32/lib/ruby/2.0.0/webrick/httpserver.rb:94:in `run' D:/Ruby200p451x32/lib/ruby/2.0.0/webrick/server.rb:295:in `block in start_thread' Rendered D:/Ruby200p451x32/lib/ruby/gems/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/middleware/templates/rescues/_source.erb (1.0ms) Rendered D:/Ruby200p451x32/lib/ruby/gems/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (1.0ms) Rendered D:/Ruby200p451x32/lib/ruby/gems/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (1.0ms) Rendered D:/Ruby200p451x32/lib/ruby/gems/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/middleware/templates/rescues/diagnostics.erb within rescues/layout (18.0ms) Started GET "/" for 127.0.0.1 at 2015-03-18 02:48:42 +0200 Gem::LoadError (Specified 'sqlite3' for database adapter, but the gem is not loaded. Add `gem 'sqlite3'` to your Gemfile (and ensure its version is at the minimum required by ActiveRecord).): activerecord (4.1.8) lib/active_record/connection_adapters/connection_specification.rb:190:in `rescue in spec' activerecord (4.1.8) lib/active_record/connection_adapters/connection_specification.rb:187:in `spec' activerecord (4.1.8) lib/active_record/connection_handling.rb:50:in `establish_connection' activerecord (4.1.8) lib/active_record/railtie.rb:129:in `block (2 levels) in ' activesupport (4.1.8) lib/active_support/lazy_load_hooks.rb:38:in `instance_eval' activesupport (4.1.8) lib/active_support/lazy_load_hooks.rb:38:in `execute_hook' activesupport (4.1.8) lib/active_support/lazy_load_hooks.rb:45:in `block in run_load_hooks' activesupport (4.1.8) lib/active_support/lazy_load_hooks.rb:44:in `each' activesupport (4.1.8) lib/active_support/lazy_load_hooks.rb:44:in `run_load_hooks' activerecord (4.1.8) lib/active_record/base.rb:326:in `' activerecord (4.1.8) lib/active_record/base.rb:23:in `' activerecord (4.1.8) lib/active_record/migration.rb:388:in `check_pending!' activerecord (4.1.8) lib/active_record/migration.rb:377:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/callbacks.rb:29:in `block in call' activesupport (4.1.8) lib/active_support/callbacks.rb:82:in `run_callbacks' actionpack (4.1.8) lib/action_dispatch/middleware/callbacks.rb:27:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/reloader.rb:73:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/remote_ip.rb:76:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/debug_exceptions.rb:17:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/show_exceptions.rb:30:in `call' railties (4.1.8) lib/rails/rack/logger.rb:38:in `call_app' railties (4.1.8) lib/rails/rack/logger.rb:20:in `block in call' activesupport (4.1.8) lib/active_support/tagged_logging.rb:68:in `block in tagged' activesupport (4.1.8) lib/active_support/tagged_logging.rb:26:in `tagged' activesupport (4.1.8) lib/active_support/tagged_logging.rb:68:in `tagged' railties (4.1.8) lib/rails/rack/logger.rb:20:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/request_id.rb:21:in `call' rack (1.5.2) lib/rack/methodoverride.rb:21:in `call' rack (1.5.2) lib/rack/runtime.rb:17:in `call' activesupport (4.1.8) lib/active_support/cache/strategy/local_cache_middleware.rb:26:in `call' rack (1.5.2) lib/rack/lock.rb:17:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/static.rb:84:in `call' rack (1.5.2) lib/rack/sendfile.rb:112:in `call' railties (4.1.8) lib/rails/engine.rb:514:in `call' railties (4.1.8) lib/rails/application.rb:144:in `call' rack (1.5.2) lib/rack/lock.rb:17:in `call' rack (1.5.2) lib/rack/content_length.rb:14:in `call' rack (1.5.2) lib/rack/handler/webrick.rb:60:in `service' D:/Ruby200p451x32/lib/ruby/2.0.0/webrick/httpserver.rb:138:in `service' D:/Ruby200p451x32/lib/ruby/2.0.0/webrick/httpserver.rb:94:in `run' D:/Ruby200p451x32/lib/ruby/2.0.0/webrick/server.rb:295:in `block in start_thread' Rendered D:/Ruby200p451x32/lib/ruby/gems/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/middleware/templates/rescues/_source.erb (1.0ms) Rendered D:/Ruby200p451x32/lib/ruby/gems/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (1.0ms) Rendered D:/Ruby200p451x32/lib/ruby/gems/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (1.0ms) Rendered D:/Ruby200p451x32/lib/ruby/gems/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/middleware/templates/rescues/diagnostics.erb within rescues/layout (17.0ms) Started GET "/" for 127.0.0.1 at 2015-03-18 02:49:42 +0200 Gem::LoadError (Specified 'sqlite3' for database adapter, but the gem is not loaded. Add `gem 'sqlite3'` to your Gemfile (and ensure its version is at the minimum required by ActiveRecord).): activerecord (4.1.8) lib/active_record/connection_adapters/connection_specification.rb:190:in `rescue in spec' activerecord (4.1.8) lib/active_record/connection_adapters/connection_specification.rb:187:in `spec' activerecord (4.1.8) lib/active_record/connection_handling.rb:50:in `establish_connection' activerecord (4.1.8) lib/active_record/railtie.rb:129:in `block (2 levels) in ' activesupport (4.1.8) lib/active_support/lazy_load_hooks.rb:38:in `instance_eval' activesupport (4.1.8) lib/active_support/lazy_load_hooks.rb:38:in `execute_hook' activesupport (4.1.8) lib/active_support/lazy_load_hooks.rb:45:in `block in run_load_hooks' activesupport (4.1.8) lib/active_support/lazy_load_hooks.rb:44:in `each' activesupport (4.1.8) lib/active_support/lazy_load_hooks.rb:44:in `run_load_hooks' activerecord (4.1.8) lib/active_record/base.rb:326:in `' activerecord (4.1.8) lib/active_record/base.rb:23:in `' activerecord (4.1.8) lib/active_record/migration.rb:388:in `check_pending!' activerecord (4.1.8) lib/active_record/migration.rb:377:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/callbacks.rb:29:in `block in call' activesupport (4.1.8) lib/active_support/callbacks.rb:82:in `run_callbacks' actionpack (4.1.8) lib/action_dispatch/middleware/callbacks.rb:27:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/reloader.rb:73:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/remote_ip.rb:76:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/debug_exceptions.rb:17:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/show_exceptions.rb:30:in `call' railties (4.1.8) lib/rails/rack/logger.rb:38:in `call_app' railties (4.1.8) lib/rails/rack/logger.rb:20:in `block in call' activesupport (4.1.8) lib/active_support/tagged_logging.rb:68:in `block in tagged' activesupport (4.1.8) lib/active_support/tagged_logging.rb:26:in `tagged' activesupport (4.1.8) lib/active_support/tagged_logging.rb:68:in `tagged' railties (4.1.8) lib/rails/rack/logger.rb:20:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/request_id.rb:21:in `call' rack (1.5.2) lib/rack/methodoverride.rb:21:in `call' rack (1.5.2) lib/rack/runtime.rb:17:in `call' activesupport (4.1.8) lib/active_support/cache/strategy/local_cache_middleware.rb:26:in `call' rack (1.5.2) lib/rack/lock.rb:17:in `call' actionpack (4.1.8) lib/action_dispatch/middleware/static.rb:84:in `call' rack (1.5.2) lib/rack/sendfile.rb:112:in `call' railties (4.1.8) lib/rails/engine.rb:514:in `call' railties (4.1.8) lib/rails/application.rb:144:in `call' rack (1.5.2) lib/rack/lock.rb:17:in `call' rack (1.5.2) lib/rack/content_length.rb:14:in `call' rack (1.5.2) lib/rack/handler/webrick.rb:60:in `service' D:/Ruby200p451x32/lib/ruby/2.0.0/webrick/httpserver.rb:138:in `service' D:/Ruby200p451x32/lib/ruby/2.0.0/webrick/httpserver.rb:94:in `run' D:/Ruby200p451x32/lib/ruby/2.0.0/webrick/server.rb:295:in `block in start_thread' Rendered D:/Ruby200p451x32/lib/ruby/gems/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/middleware/templates/rescues/_source.erb (1.0ms) Rendered D:/Ruby200p451x32/lib/ruby/gems/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (1.0ms) Rendered D:/Ruby200p451x32/lib/ruby/gems/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (1.0ms) Rendered D:/Ruby200p451x32/lib/ruby/gems/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/middleware/templates/rescues/diagnostics.erb within rescues/layout (18.0ms) Started GET "/" for 127.0.0.1 at 2015-03-18 02:50:04 +0200 ActiveRecord::SchemaMigration Load (0.0ms) SELECT "schema_migrations".* FROM "schema_migrations" Processing by Rails::WelcomeController#index as HTML Rendered D:/Ruby200p451x32/lib/ruby/gems/2.0.0/gems/railties-4.1.8/lib/rails/templates/rails/welcome/index.html.erb (2.0ms) Completed 200 OK in 73ms (Views: 73.0ms | ActiveRecord: 0.0ms) Started GET "/orders" for 127.0.0.1 at 2015-03-18 02:50:22 +0200 Processing by OrdersController#index as HTML Order Load (0.0ms) SELECT "orders".* FROM "orders" Rendered orders/index.html.erb within layouts/application (2.0ms) Completed 200 OK in 3461ms (Views: 3379.2ms | ActiveRecord: 0.0ms) Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2015-03-18 02:50:26 +0200 Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2015-03-18 02:50:26 +0200 Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2015-03-18 02:50:26 +0200 Started GET "/assets/bootstrap.js?body=1" for 127.0.0.1 at 2015-03-18 02:50:26 +0200 Started GET "/assets/bootstrap3-typeahead.min.js?body=1" for 127.0.0.1 at 2015-03-18 02:50:26 +0200 Started GET "/assets/bootstrap3-autocomplete-input.min.js?body=1" for 127.0.0.1 at 2015-03-18 02:50:26 +0200 Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2015-03-18 02:50:26 +0200 Started GET "/orders/new" for 127.0.0.1 at 2015-03-18 02:50:27 +0200 Processing by OrdersController#new as HTML Rendered orders/_form.html.erb (639.0ms) Rendered orders/new.html.erb within layouts/application (738.0ms) Completed 200 OK in 811ms (Views: 810.0ms | ActiveRecord: 0.0ms) Started GET "/assets/bootstrap3-typeahead.min.js?body=1" for 127.0.0.1 at 2015-03-18 02:50:28 +0200 Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2015-03-18 02:50:28 +0200 Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2015-03-18 02:50:28 +0200 Started GET "/assets/bootstrap3-autocomplete-input.min.js?body=1" for 127.0.0.1 at 2015-03-18 02:50:28 +0200 Started GET "/assets/bootstrap.js?body=1" for 127.0.0.1 at 2015-03-18 02:50:28 +0200 Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2015-03-18 02:50:28 +0200 Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2015-03-18 02:50:28 +0200 Started GET "/orders/autocomplete_client_name?q=i" for 127.0.0.1 at 2015-03-18 02:50:32 +0200 Processing by OrdersController#autocomplete_client_name as JSON Parameters: {"q"=>"i"} Client Load (0.0ms) SELECT clients.id, clients.name FROM "clients" WHERE (LOWER(clients.name) LIKE 'i%') ORDER BY clients.name ASC LIMIT 10 Completed 200 OK in 3ms (Views: 0.0ms | ActiveRecord: 0.0ms) Started GET "/orders/autocomplete_client_name?q=iv" for 127.0.0.1 at 2015-03-18 02:50:33 +0200 Processing by OrdersController#autocomplete_client_name as JSON Parameters: {"q"=>"iv"} Client Load (0.0ms) SELECT clients.id, clients.name FROM "clients" WHERE (LOWER(clients.name) LIKE 'iv%') ORDER BY clients.name ASC LIMIT 10 Completed 200 OK in 2ms (Views: 1.0ms | ActiveRecord: 0.0ms) Started GET "/orders/autocomplete_client_name?q=iva" for 127.0.0.1 at 2015-03-18 02:50:34 +0200 Processing by OrdersController#autocomplete_client_name as JSON Parameters: {"q"=>"iva"} Client Load (0.0ms) SELECT clients.id, clients.name FROM "clients" WHERE (LOWER(clients.name) LIKE 'iva%') ORDER BY clients.name ASC LIMIT 10 Completed 200 OK in 1ms (Views: 0.0ms | ActiveRecord: 0.0ms) Started GET "/orders/autocomplete_client_name?q=iva" for 127.0.0.1 at 2015-03-18 02:50:35 +0200 Processing by OrdersController#autocomplete_client_name as JSON Parameters: {"q"=>"iva"} Client Load (0.0ms) SELECT clients.id, clients.name FROM "clients" WHERE (LOWER(clients.name) LIKE 'iva%') ORDER BY clients.name ASC LIMIT 10 Completed 200 OK in 1ms (Views: 0.0ms | ActiveRecord: 0.0ms) Started GET "/clients" for 127.0.0.1 at 2015-03-18 02:50:44 +0200 Processing by ClientsController#index as HTML Client Load (0.0ms) SELECT "clients".* FROM "clients" Rendered clients/index.html.erb within layouts/application (34.0ms) Completed 200 OK in 83ms (Views: 83.0ms | ActiveRecord: 0.0ms) Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2015-03-18 02:50:45 +0200 Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2015-03-18 02:50:45 +0200 Started GET "/assets/bootstrap.js?body=1" for 127.0.0.1 at 2015-03-18 02:50:45 +0200 Started GET "/assets/bootstrap3-autocomplete-input.min.js?body=1" for 127.0.0.1 at 2015-03-18 02:50:45 +0200 Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2015-03-18 02:50:45 +0200 Started GET "/assets/bootstrap3-typeahead.min.js?body=1" for 127.0.0.1 at 2015-03-18 02:50:45 +0200 Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2015-03-18 02:50:45 +0200 Started GET "/orders/autocomplete_client_name?q=b" for 127.0.0.1 at 2015-03-18 02:50:50 +0200 Processing by OrdersController#autocomplete_client_name as JSON Parameters: {"q"=>"b"} Client Load (1.0ms) SELECT clients.id, clients.name FROM "clients" WHERE (LOWER(clients.name) LIKE 'b%') ORDER BY clients.name ASC LIMIT 10 Completed 200 OK in 2ms (Views: 0.0ms | ActiveRecord: 1.0ms) Started GET "/orders/autocomplete_client_name?q=Banana" for 127.0.0.1 at 2015-03-18 02:51:09 +0200 Processing by OrdersController#autocomplete_client_name as JSON Parameters: {"q"=>"Banana"} Client Load (0.0ms) SELECT clients.id, clients.name FROM "clients" WHERE (LOWER(clients.name) LIKE 'banana%') ORDER BY clients.name ASC LIMIT 10 Completed 200 OK in 1ms (Views: 0.0ms | ActiveRecord: 0.0ms) Started GET "/orders/new" for 127.0.0.1 at 2015-03-18 02:52:02 +0200 Processing by OrdersController#new as HTML Rendered orders/_form.html.erb (7.0ms) Rendered orders/new.html.erb within layouts/application (32.0ms) Completed 200 OK in 150ms (Views: 150.0ms | ActiveRecord: 0.0ms) Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2015-03-18 02:52:02 +0200 Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2015-03-18 02:52:02 +0200 Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2015-03-18 02:52:02 +0200 Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2015-03-18 02:52:02 +0200 Started GET "/assets/bootstrap.js?body=1" for 127.0.0.1 at 2015-03-18 02:52:03 +0200 Started GET "/assets/bootstrap3-typeahead.min.js?body=1" for 127.0.0.1 at 2015-03-18 02:52:03 +0200 Started GET "/assets/bootstrap3-autocomplete-input.min.js?body=1" for 127.0.0.1 at 2015-03-18 02:52:03 +0200 Started GET "/assets/bootstrap3-autocomplete-input.min.js?body=1" for 127.0.0.1 at 2015-03-18 02:52:06 +0200 Started GET "/orders/autocomplete_client_name?q=b" for 127.0.0.1 at 2015-03-18 02:52:38 +0200 Processing by OrdersController#autocomplete_client_name as JSON Parameters: {"q"=>"b"} Client Load (0.0ms) SELECT clients.id, clients.name FROM "clients" WHERE (LOWER(clients.name) LIKE 'b%') ORDER BY clients.name ASC LIMIT 10 Completed 200 OK in 3ms (Views: 0.0ms | ActiveRecord: 0.0ms) Started GET "/orders/new" for 127.0.0.1 at 2015-03-18 02:58:16 +0200 Processing by OrdersController#new as HTML Rendered orders/_form.html.erb (6.0ms) Rendered orders/new.html.erb within layouts/application (8.0ms) Completed 200 OK in 79ms (Views: 79.0ms | ActiveRecord: 0.0ms) Started GET "/assets/bootstrap.js?body=1" for 127.0.0.1 at 2015-03-18 02:58:16 +0200 Started GET "/assets/bootstrap3-autocomplete-input.min.js?body=1" for 127.0.0.1 at 2015-03-18 02:58:16 +0200 Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2015-03-18 02:58:16 +0200 Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2015-03-18 02:58:16 +0200 Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2015-03-18 02:58:17 +0200 Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2015-03-18 02:58:17 +0200 Started GET "/assets/bootstrap3-typeahead.min.js?body=1" for 127.0.0.1 at 2015-03-18 02:58:17 +0200 Started GET "/orders/autocomplete_client_name?q=b" for 127.0.0.1 at 2015-03-18 02:58:21 +0200 Processing by OrdersController#autocomplete_client_name as JSON Parameters: {"q"=>"b"} Client Load (0.0ms) SELECT clients.id, clients.name FROM "clients" WHERE (LOWER(clients.name) LIKE 'b%') ORDER BY clients.name ASC LIMIT 10 Completed 200 OK in 2ms (Views: 0.0ms | ActiveRecord: 0.0ms) Started GET "/orders/new" for 127.0.0.1 at 2015-03-18 02:58:38 +0200 ActiveRecord::SchemaMigration Load (0.0ms) SELECT "schema_migrations".* FROM "schema_migrations" Processing by OrdersController#new as HTML Rendered orders/_form.html.erb (109.0ms) Rendered orders/new.html.erb within layouts/application (115.0ms) Completed 200 OK in 273ms (Views: 266.0ms | ActiveRecord: 0.0ms) Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2015-03-18 02:58:39 +0200 Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2015-03-18 02:58:39 +0200 Started GET "/assets/bootstrap.js?body=1" for 127.0.0.1 at 2015-03-18 02:58:39 +0200 Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2015-03-18 02:58:39 +0200 Started GET "/assets/bootstrap3-typeahead.min.js?body=1" for 127.0.0.1 at 2015-03-18 02:58:39 +0200 Started GET "/assets/bootstrap3-autocomplete-input.min.js?body=1" for 127.0.0.1 at 2015-03-18 02:58:39 +0200 Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2015-03-18 02:58:39 +0200 Started GET "/orders/autocomplete_client_name?q=b" for 127.0.0.1 at 2015-03-18 02:58:56 +0200 Processing by OrdersController#autocomplete_client_name as JSON Parameters: {"q"=>"b"} Client Load (0.0ms) SELECT clients.id, clients.name FROM "clients" WHERE (LOWER(clients.name) LIKE 'b%') ORDER BY clients.name ASC LIMIT 10 Completed 200 OK in 6ms (Views: 1.0ms | ActiveRecord: 0.0ms) Started GET "/orders/new" for 127.0.0.1 at 2015-03-18 03:00:22 +0200 ActiveRecord::SchemaMigration Load (0.0ms) SELECT "schema_migrations".* FROM "schema_migrations" Processing by OrdersController#new as HTML Rendered orders/_form.html.erb (107.0ms) Rendered orders/new.html.erb within layouts/application (111.0ms) Completed 200 OK in 286ms (Views: 281.0ms | ActiveRecord: 0.0ms) Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2015-03-18 03:00:22 +0200 Started GET "/assets/bootstrap3-autocomplete-input.js?body=1" for 127.0.0.1 at 2015-03-18 03:00:22 +0200 Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2015-03-18 03:00:22 +0200 Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2015-03-18 03:00:22 +0200 Started GET "/assets/bootstrap.js?body=1" for 127.0.0.1 at 2015-03-18 03:00:22 +0200 Started GET "/assets/bootstrap3-typeahead.min.js?body=1" for 127.0.0.1 at 2015-03-18 03:00:22 +0200 Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2015-03-18 03:00:22 +0200 Started GET "/orders/autocomplete_client_name?q=b" for 127.0.0.1 at 2015-03-18 03:00:25 +0200 Processing by OrdersController#autocomplete_client_name as JSON Parameters: {"q"=>"b"} Client Load (0.0ms) SELECT clients.id, clients.name FROM "clients" WHERE (LOWER(clients.name) LIKE 'b%') ORDER BY clients.name ASC LIMIT 10 Completed 200 OK in 5ms (Views: 0.0ms | ActiveRecord: 0.0ms) Started GET "/orders/new" for 127.0.0.1 at 2015-03-18 03:07:02 +0200 ActiveRecord::SchemaMigration Load (0.0ms) SELECT "schema_migrations".* FROM "schema_migrations" Processing by OrdersController#new as HTML Rendered orders/_form.html.erb (107.0ms) Rendered orders/new.html.erb within layouts/application (112.0ms) Completed 200 OK in 305ms (Views: 300.0ms | ActiveRecord: 1.0ms) Started GET "/assets/bootstrap.js?body=1" for 127.0.0.1 at 2015-03-18 03:07:03 +0200 Started GET "/assets/bootstrap3-autocomplete-input.js?body=1" for 127.0.0.1 at 2015-03-18 03:07:03 +0200 Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2015-03-18 03:07:03 +0200 Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2015-03-18 03:07:03 +0200 Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2015-03-18 03:07:03 +0200 Started GET "/assets/bootstrap3-typeahead.min.js?body=1" for 127.0.0.1 at 2015-03-18 03:07:03 +0200 Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2015-03-18 03:07:03 +0200 Started GET "/orders/autocomplete_client_name?q=b" for 127.0.0.1 at 2015-03-18 03:07:05 +0200 Processing by OrdersController#autocomplete_client_name as JSON Parameters: {"q"=>"b"} Client Load (0.0ms) SELECT clients.id, clients.name FROM "clients" WHERE (LOWER(clients.name) LIKE 'b%') ORDER BY clients.name ASC LIMIT 10 Completed 200 OK in 5ms (Views: 0.0ms | ActiveRecord: 0.0ms) Started GET "/orders/new" for 127.0.0.1 at 2015-03-18 03:08:47 +0200 ActiveRecord::SchemaMigration Load (0.0ms) SELECT "schema_migrations".* FROM "schema_migrations" Processing by OrdersController#new as HTML Rendered orders/_form.html.erb (112.0ms) Rendered orders/new.html.erb within layouts/application (116.0ms) Completed 200 OK in 293ms (Views: 287.0ms | ActiveRecord: 0.0ms) Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2015-03-18 03:08:47 +0200 Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2015-03-18 03:08:48 +0200 Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2015-03-18 03:08:48 +0200 Started GET "/assets/bootstrap.js?body=1" for 127.0.0.1 at 2015-03-18 03:08:48 +0200 Started GET "/assets/bootstrap3-typeahead.min.js?body=1" for 127.0.0.1 at 2015-03-18 03:08:48 +0200 Started GET "/assets/bootstrap3-autocomplete-input.js?body=1" for 127.0.0.1 at 2015-03-18 03:08:48 +0200 Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2015-03-18 03:08:48 +0200 Started GET "/orders/autocomplete_client_name?q=b" for 127.0.0.1 at 2015-03-18 03:11:31 +0200 Processing by OrdersController#autocomplete_client_name as JSON Parameters: {"q"=>"b"} Client Load (0.0ms) SELECT clients.id, clients.name FROM "clients" WHERE (LOWER(clients.name) LIKE 'b%') ORDER BY clients.name ASC LIMIT 10 Completed 200 OK in 5ms (Views: 0.0ms | ActiveRecord: 0.0ms) Started GET "/orders/new" for 127.0.0.1 at 2015-03-18 03:11:43 +0200 Processing by OrdersController#new as HTML Rendered orders/_form.html.erb (7.0ms) Rendered orders/new.html.erb within layouts/application (9.0ms) Completed 200 OK in 84ms (Views: 83.0ms | ActiveRecord: 0.0ms) Started GET "/orders/autocomplete_client_name?q=Banana" for 127.0.0.1 at 2015-03-18 03:11:43 +0200 Processing by OrdersController#autocomplete_client_name as JSON Parameters: {"q"=>"Banana"} Client Load (1.0ms) SELECT clients.id, clients.name FROM "clients" WHERE (LOWER(clients.name) LIKE 'banana%') ORDER BY clients.name ASC LIMIT 10 Completed 200 OK in 1ms (Views: 0.0ms | ActiveRecord: 1.0ms) Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2015-03-18 03:11:43 +0200 Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2015-03-18 03:11:43 +0200 Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2015-03-18 03:11:43 +0200 Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2015-03-18 03:11:43 +0200 Started GET "/assets/bootstrap.js?body=1" for 127.0.0.1 at 2015-03-18 03:11:43 +0200 Started GET "/assets/bootstrap3-typeahead.min.js?body=1" for 127.0.0.1 at 2015-03-18 03:11:43 +0200 Started GET "/assets/bootstrap3-autocomplete-input.js?body=1" for 127.0.0.1 at 2015-03-18 03:11:43 +0200 Started GET "/orders/autocomplete_client_name?q=b" for 127.0.0.1 at 2015-03-18 03:11:44 +0200 Processing by OrdersController#autocomplete_client_name as JSON Parameters: {"q"=>"b"} Client Load (0.0ms) SELECT clients.id, clients.name FROM "clients" WHERE (LOWER(clients.name) LIKE 'b%') ORDER BY clients.name ASC LIMIT 10 Completed 200 OK in 1ms (Views: 0.0ms | ActiveRecord: 0.0ms) Started GET "/orders/new" for 127.0.0.1 at 2015-03-18 03:11:54 +0200 Processing by OrdersController#new as HTML Rendered orders/_form.html.erb (7.0ms) Rendered orders/new.html.erb within layouts/application (9.0ms) Completed 200 OK in 92ms (Views: 91.0ms | ActiveRecord: 0.0ms) Started GET "/orders/autocomplete_client_name?q=Banana" for 127.0.0.1 at 2015-03-18 03:11:54 +0200 Processing by OrdersController#autocomplete_client_name as JSON Parameters: {"q"=>"Banana"} Client Load (1.0ms) SELECT clients.id, clients.name FROM "clients" WHERE (LOWER(clients.name) LIKE 'banana%') ORDER BY clients.name ASC LIMIT 10 Completed 200 OK in 1ms (Views: 0.0ms | ActiveRecord: 1.0ms) Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2015-03-18 03:11:54 +0200 Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2015-03-18 03:11:54 +0200 Started GET "/assets/bootstrap.js?body=1" for 127.0.0.1 at 2015-03-18 03:11:54 +0200 Started GET "/assets/bootstrap3-typeahead.min.js?body=1" for 127.0.0.1 at 2015-03-18 03:11:54 +0200 Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2015-03-18 03:11:54 +0200 Started GET "/assets/bootstrap3-autocomplete-input.js?body=1" for 127.0.0.1 at 2015-03-18 03:11:54 +0200 Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2015-03-18 03:11:54 +0200 Started GET "/orders/autocomplete_client_name?q=v" for 127.0.0.1 at 2015-03-18 03:11:56 +0200 Processing by OrdersController#autocomplete_client_name as JSON Parameters: {"q"=>"v"} Client Load (0.0ms) SELECT clients.id, clients.name FROM "clients" WHERE (LOWER(clients.name) LIKE 'v%') ORDER BY clients.name ASC LIMIT 10 Completed 200 OK in 2ms (Views: 0.0ms | ActiveRecord: 0.0ms) Started GET "/orders/autocomplete_client_name?q=b" for 127.0.0.1 at 2015-03-18 03:11:58 +0200 Processing by OrdersController#autocomplete_client_name as JSON Parameters: {"q"=>"b"} Client Load (0.0ms) SELECT clients.id, clients.name FROM "clients" WHERE (LOWER(clients.name) LIKE 'b%') ORDER BY clients.name ASC LIMIT 10 Completed 200 OK in 2ms (Views: 0.0ms | ActiveRecord: 0.0ms) Started GET "/orders/new" for 127.0.0.1 at 2015-03-18 03:13:21 +0200 Processing by OrdersController#new as HTML Rendered orders/_form.html.erb (6.0ms) Rendered orders/new.html.erb within layouts/application (7.0ms) Completed 200 OK in 118ms (Views: 118.0ms | ActiveRecord: 0.0ms) Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2015-03-18 03:13:21 +0200 Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2015-03-18 03:13:21 +0200 Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2015-03-18 03:13:21 +0200 Started GET "/assets/bootstrap.js?body=1" for 127.0.0.1 at 2015-03-18 03:13:21 +0200 Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2015-03-18 03:13:21 +0200 Started GET "/assets/bootstrap3-typeahead.min.js?body=1" for 127.0.0.1 at 2015-03-18 03:13:21 +0200 Started GET "/assets/bootstrap3-autocomplete-input.js?body=1" for 127.0.0.1 at 2015-03-18 03:13:21 +0200 Started GET "/orders/autocomplete_client_name?q=b" for 127.0.0.1 at 2015-03-18 03:13:24 +0200 Processing by OrdersController#autocomplete_client_name as JSON Parameters: {"q"=>"b"} Client Load (0.0ms) SELECT clients.id, clients.name FROM "clients" WHERE (LOWER(clients.name) LIKE 'b%') ORDER BY clients.name ASC LIMIT 10 Completed 200 OK in 2ms (Views: 0.0ms | ActiveRecord: 0.0ms) Started GET "/orders/new" for 127.0.0.1 at 2015-03-18 03:13:34 +0200 Processing by OrdersController#new as HTML Rendered orders/_form.html.erb (8.0ms) Rendered orders/new.html.erb within layouts/application (9.0ms) Completed 200 OK in 61ms (Views: 60.0ms | ActiveRecord: 0.0ms) Started GET "/orders/autocomplete_client_name?q=Banana" for 127.0.0.1 at 2015-03-18 03:13:34 +0200 Processing by OrdersController#autocomplete_client_name as JSON Parameters: {"q"=>"Banana"} Client Load (1.0ms) SELECT clients.id, clients.name FROM "clients" WHERE (LOWER(clients.name) LIKE 'banana%') ORDER BY clients.name ASC LIMIT 10 Completed 200 OK in 60ms (Views: 58.0ms | ActiveRecord: 1.0ms) Started GET "/assets/bootstrap.js?body=1" for 127.0.0.1 at 2015-03-18 03:13:34 +0200 Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2015-03-18 03:13:34 +0200 Started GET "/assets/bootstrap3-typeahead.min.js?body=1" for 127.0.0.1 at 2015-03-18 03:13:34 +0200 Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2015-03-18 03:13:34 +0200 Started GET "/assets/bootstrap3-autocomplete-input.js?body=1" for 127.0.0.1 at 2015-03-18 03:13:34 +0200 Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2015-03-18 03:13:34 +0200 Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2015-03-18 03:13:34 +0200 Started GET "/orders/autocomplete_client_name?q=b" for 127.0.0.1 at 2015-03-18 03:13:36 +0200 Processing by OrdersController#autocomplete_client_name as JSON Parameters: {"q"=>"b"} Client Load (0.0ms) SELECT clients.id, clients.name FROM "clients" WHERE (LOWER(clients.name) LIKE 'b%') ORDER BY clients.name ASC LIMIT 10 Completed 200 OK in 2ms (Views: 0.0ms | ActiveRecord: 0.0ms) Started GET "/orders/new" for 127.0.0.1 at 2015-03-18 03:14:15 +0200 Processing by OrdersController#new as HTML Rendered orders/_form.html.erb (11.0ms) Rendered orders/new.html.erb within layouts/application (12.0ms) Completed 200 OK in 180ms (Views: 180.0ms | ActiveRecord: 0.0ms) Started GET "/orders/autocomplete_client_name?q=Banana" for 127.0.0.1 at 2015-03-18 03:14:15 +0200 Processing by OrdersController#autocomplete_client_name as JSON Parameters: {"q"=>"Banana"} Client Load (0.0ms) SELECT clients.id, clients.name FROM "clients" WHERE (LOWER(clients.name) LIKE 'banana%') ORDER BY clients.name ASC LIMIT 10 Completed 200 OK in 2ms (Views: 0.0ms | ActiveRecord: 0.0ms) Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2015-03-18 03:14:15 +0200 Started GET "/assets/bootstrap.js?body=1" for 127.0.0.1 at 2015-03-18 03:14:15 +0200 Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2015-03-18 03:14:15 +0200 Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2015-03-18 03:14:15 +0200 Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2015-03-18 03:14:15 +0200 Started GET "/assets/bootstrap3-typeahead.min.js?body=1" for 127.0.0.1 at 2015-03-18 03:14:15 +0200 Started GET "/assets/bootstrap3-autocomplete-input.js?body=1" for 127.0.0.1 at 2015-03-18 03:14:15 +0200 Started GET "/orders/autocomplete_client_name?q=b" for 127.0.0.1 at 2015-03-18 03:14:17 +0200 Processing by OrdersController#autocomplete_client_name as JSON Parameters: {"q"=>"b"} Client Load (0.0ms) SELECT clients.id, clients.name FROM "clients" WHERE (LOWER(clients.name) LIKE 'b%') ORDER BY clients.name ASC LIMIT 10 Completed 200 OK in 2ms (Views: 1.0ms | ActiveRecord: 0.0ms) Started GET "/orders/new" for 127.0.0.1 at 2015-03-18 03:14:22 +0200 Processing by OrdersController#new as HTML Rendered orders/_form.html.erb (7.0ms) Rendered orders/new.html.erb within layouts/application (9.0ms) Completed 200 OK in 80ms (Views: 80.0ms | ActiveRecord: 0.0ms) Started GET "/orders/autocomplete_client_name?q=Banana" for 127.0.0.1 at 2015-03-18 03:14:22 +0200 Processing by OrdersController#autocomplete_client_name as JSON Parameters: {"q"=>"Banana"} Client Load (0.0ms) SELECT clients.id, clients.name FROM "clients" WHERE (LOWER(clients.name) LIKE 'banana%') ORDER BY clients.name ASC LIMIT 10 Completed 200 OK in 2ms (Views: 0.0ms | ActiveRecord: 0.0ms) Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2015-03-18 03:14:23 +0200 Started GET "/assets/bootstrap.js?body=1" for 127.0.0.1 at 2015-03-18 03:14:23 +0200 Started GET "/assets/bootstrap3-typeahead.min.js?body=1" for 127.0.0.1 at 2015-03-18 03:14:23 +0200 Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2015-03-18 03:14:23 +0200 Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2015-03-18 03:14:23 +0200 Started GET "/assets/bootstrap3-autocomplete-input.js?body=1" for 127.0.0.1 at 2015-03-18 03:14:23 +0200 Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2015-03-18 03:14:23 +0200 Started GET "/orders/autocomplete_client_name?q=b" for 127.0.0.1 at 2015-03-18 03:14:24 +0200 Processing by OrdersController#autocomplete_client_name as JSON Parameters: {"q"=>"b"} Client Load (0.0ms) SELECT clients.id, clients.name FROM "clients" WHERE (LOWER(clients.name) LIKE 'b%') ORDER BY clients.name ASC LIMIT 10 Completed 200 OK in 2ms (Views: 0.0ms | ActiveRecord: 0.0ms) Started GET "/orders/new" for 127.0.0.1 at 2015-03-18 03:14:28 +0200 Processing by OrdersController#new as HTML Rendered orders/_form.html.erb (9.0ms) Rendered orders/new.html.erb within layouts/application (25.0ms) Completed 200 OK in 76ms (Views: 76.0ms | ActiveRecord: 0.0ms) Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2015-03-18 03:14:28 +0200 Started GET "/assets/bootstrap3-typeahead.min.js?body=1" for 127.0.0.1 at 2015-03-18 03:14:28 +0200 Started GET "/assets/bootstrap3-autocomplete-input.js?body=1" for 127.0.0.1 at 2015-03-18 03:14:28 +0200 Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2015-03-18 03:14:28 +0200 Started GET "/assets/bootstrap.js?body=1" for 127.0.0.1 at 2015-03-18 03:14:28 +0200 Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2015-03-18 03:14:28 +0200 Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2015-03-18 03:14:28 +0200 Started GET "/orders/autocomplete_client_name?q=b" for 127.0.0.1 at 2015-03-18 03:14:30 +0200 Processing by OrdersController#autocomplete_client_name as JSON Parameters: {"q"=>"b"} Client Load (0.0ms) SELECT clients.id, clients.name FROM "clients" WHERE (LOWER(clients.name) LIKE 'b%') ORDER BY clients.name ASC LIMIT 10 Completed 200 OK in 2ms (Views: 0.0ms | ActiveRecord: 0.0ms) Started GET "/orders/new" for 127.0.0.1 at 2015-03-18 03:17:15 +0200 Processing by OrdersController#new as HTML Rendered orders/_form.html.erb (7.0ms) Rendered orders/new.html.erb within layouts/application (7.0ms) Completed 200 OK in 147ms (Views: 146.0ms | ActiveRecord: 0.0ms) Started GET "/orders/autocomplete_client_name?q=Banana" for 127.0.0.1 at 2015-03-18 03:17:16 +0200 Processing by OrdersController#autocomplete_client_name as JSON Parameters: {"q"=>"Banana"} Client Load (0.0ms) SELECT clients.id, clients.name FROM "clients" WHERE (LOWER(clients.name) LIKE 'banana%') ORDER BY clients.name ASC LIMIT 10 Completed 200 OK in 2ms (Views: 0.0ms | ActiveRecord: 0.0ms) Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2015-03-18 03:17:16 +0200 Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2015-03-18 03:17:16 +0200 Started GET "/assets/bootstrap3-autocomplete-input.min.js?body=1" for 127.0.0.1 at 2015-03-18 03:17:16 +0200 Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2015-03-18 03:17:16 +0200 Started GET "/assets/bootstrap.js?body=1" for 127.0.0.1 at 2015-03-18 03:17:16 +0200 Started GET "/assets/bootstrap3-typeahead.min.js?body=1" for 127.0.0.1 at 2015-03-18 03:17:16 +0200 Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2015-03-18 03:17:16 +0200 Started GET "/orders/autocomplete_client_name?q=v" for 127.0.0.1 at 2015-03-18 03:17:19 +0200 Processing by OrdersController#autocomplete_client_name as JSON Parameters: {"q"=>"v"} Client Load (0.0ms) SELECT clients.id, clients.name FROM "clients" WHERE (LOWER(clients.name) LIKE 'v%') ORDER BY clients.name ASC LIMIT 10 Completed 200 OK in 2ms (Views: 0.0ms | ActiveRecord: 0.0ms) Started GET "/orders/autocomplete_client_name?q=b" for 127.0.0.1 at 2015-03-18 03:17:19 +0200 Processing by OrdersController#autocomplete_client_name as JSON Parameters: {"q"=>"b"} Client Load (1.0ms) SELECT clients.id, clients.name FROM "clients" WHERE (LOWER(clients.name) LIKE 'b%') ORDER BY clients.name ASC LIMIT 10 Completed 200 OK in 1ms (Views: 0.0ms | ActiveRecord: 1.0ms) Started GET "/orders/autocomplete_client_name?q=Banana" for 127.0.0.1 at 2015-03-18 03:17:25 +0200 Processing by OrdersController#autocomplete_client_name as JSON Parameters: {"q"=>"Banana"} Client Load (0.0ms) SELECT clients.id, clients.name FROM "clients" WHERE (LOWER(clients.name) LIKE 'banana%') ORDER BY clients.name ASC LIMIT 10 Completed 200 OK in 2ms (Views: 0.0ms | ActiveRecord: 0.0ms) Started GET "/" for 127.0.0.1 at 2015-07-14 10:44:28 +0300 ActiveRecord::SchemaMigration Load (0.0ms) SELECT "schema_migrations".* FROM "schema_migrations" Processing by Rails::WelcomeController#index as HTML Rendered D:/Ruby215/lib/ruby/gems/2.1.0/gems/railties-4.2.1/lib/rails/templates/rails/welcome/index.html.erb (24.0ms) Completed 200 OK in 210ms (Views: 210.0ms | ActiveRecord: 0.0ms) Started GET "/orders" for 127.0.0.1 at 2015-07-14 10:44:44 +0300 Processing by OrdersController#index as HTML Order Load (0.0ms) SELECT "orders".* FROM "orders" Rendered orders/index.html.erb within layouts/application (3.0ms) Completed 200 OK in 4120ms (Views: 4086.2ms | ActiveRecord: 0.0ms) Started GET "/assets/application.self.css?body=1" for 127.0.0.1 at 2015-07-14 10:44:48 +0300 Started GET "/assets/jquery.self.js?body=1" for 127.0.0.1 at 2015-07-14 10:44:48 +0300 Started GET "/assets/jquery_ujs.self.js?body=1" for 127.0.0.1 at 2015-07-14 10:44:48 +0300 Started GET "/assets/application.self.js?body=1" for 127.0.0.1 at 2015-07-14 10:44:48 +0300 Started GET "/assets/bootstrap.self.js?body=1" for 127.0.0.1 at 2015-07-14 10:44:48 +0300 Started GET "/assets/bootstrap3-typeahead.min.self.js?body=1" for 127.0.0.1 at 2015-07-14 10:44:48 +0300 Started GET "/assets/bootstrap3-autocomplete-input.min.self.js?body=1" for 127.0.0.1 at 2015-07-14 10:44:48 +0300 Started GET "/orders/new" for 127.0.0.1 at 2015-07-14 10:44:49 +0300 Processing by OrdersController#new as HTML Rendered orders/_form.html.erb (906.1ms) Rendered orders/new.html.erb within layouts/application (998.1ms) Completed 200 OK in 1082ms (Views: 1078.1ms | ActiveRecord: 0.0ms) Started GET "/assets/bootstrap3-autocomplete-input.min.self.js?body=1" for 127.0.0.1 at 2015-07-14 10:44:50 +0300 Started GET "/assets/jquery_ujs.self.js?body=1" for 127.0.0.1 at 2015-07-14 10:44:51 +0300 Started GET "/assets/jquery.self.js?body=1" for 127.0.0.1 at 2015-07-14 10:44:51 +0300 Started GET "/assets/bootstrap3-typeahead.min.self.js?body=1" for 127.0.0.1 at 2015-07-14 10:44:51 +0300 Started GET "/assets/bootstrap.self.js?body=1" for 127.0.0.1 at 2015-07-14 10:44:51 +0300 Started GET "/assets/application.self.css?body=1" for 127.0.0.1 at 2015-07-14 10:44:51 +0300 Started GET "/assets/application.self.js?body=1" for 127.0.0.1 at 2015-07-14 10:44:51 +0300 Started GET "/orders/autocomplete_client_name?q=a" for 127.0.0.1 at 2015-07-14 10:45:06 +0300 Processing by OrdersController#autocomplete_client_name as JSON Parameters: {"q"=>"a"} Client Load (317.0ms) SELECT clients.id, clients.name FROM "clients" WHERE (LOWER(clients.name) LIKE 'a%') ORDER BY clients.name ASC LIMIT 10 Completed 200 OK in 330ms (Views: 1.0ms | ActiveRecord: 318.0ms) Started GET "/orders/autocomplete_client_name?q=a" for 127.0.0.1 at 2015-07-14 10:45:25 +0300 Processing by OrdersController#autocomplete_client_name as JSON Parameters: {"q"=>"a"} Client Load (0.0ms) SELECT clients.id, clients.name FROM "clients" WHERE (LOWER(clients.name) LIKE 'a%') ORDER BY clients.name ASC LIMIT 10 Completed 200 OK in 1ms (Views: 0.0ms | ActiveRecord: 0.0ms) Started GET "/ac/orders/new" for 127.0.0.1 at 2015-07-14 10:45:33 +0300 ActionController::RoutingError (No route matches [GET] "/ac/orders/new"): actionpack (4.2.1) lib/action_dispatch/middleware/debug_exceptions.rb:21:in `call' actionpack (4.2.1) lib/action_dispatch/middleware/show_exceptions.rb:30:in `call' railties (4.2.1) lib/rails/rack/logger.rb:38:in `call_app' railties (4.2.1) lib/rails/rack/logger.rb:20:in `block in call' activesupport (4.2.1) lib/active_support/tagged_logging.rb:68:in `block in tagged' activesupport (4.2.1) lib/active_support/tagged_logging.rb:26:in `tagged' activesupport (4.2.1) lib/active_support/tagged_logging.rb:68:in `tagged' railties (4.2.1) lib/rails/rack/logger.rb:20:in `call' actionpack (4.2.1) 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.1) 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.1) lib/action_dispatch/middleware/static.rb:113:in `call' rack (1.6.4) lib/rack/sendfile.rb:113:in `call' railties (4.2.1) lib/rails/engine.rb:518:in `call' railties (4.2.1) lib/rails/application.rb:164: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' D:/Ruby215/lib/ruby/2.1.0/webrick/httpserver.rb:138:in `service' D:/Ruby215/lib/ruby/2.1.0/webrick/httpserver.rb:94:in `run' D:/Ruby215/lib/ruby/2.1.0/webrick/server.rb:295:in `block in start_thread' Rendered D:/Ruby215/lib/ruby/gems/2.1.0/gems/actionpack-4.2.1/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (2.0ms) Rendered D:/Ruby215/lib/ruby/gems/2.1.0/gems/actionpack-4.2.1/lib/action_dispatch/middleware/templates/routes/_route.html.erb (2.0ms) Rendered D:/Ruby215/lib/ruby/gems/2.1.0/gems/actionpack-4.2.1/lib/action_dispatch/middleware/templates/routes/_table.html.erb (6.0ms) Rendered D:/Ruby215/lib/ruby/gems/2.1.0/gems/actionpack-4.2.1/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (1.0ms) Rendered D:/Ruby215/lib/ruby/gems/2.1.0/gems/actionpack-4.2.1/lib/action_dispatch/middleware/templates/rescues/routing_error.html.erb within rescues/layout (119.0ms) Started GET "/orders/new" for 127.0.0.1 at 2015-07-14 10:45:37 +0300 Processing by OrdersController#new as HTML Rendered orders/_form.html.erb (6.0ms) Rendered orders/new.html.erb within layouts/application (7.0ms) Completed 200 OK in 74ms (Views: 74.0ms | ActiveRecord: 0.0ms) Started GET "/assets/application.self.css?body=1" for 127.0.0.1 at 2015-07-14 10:45:37 +0300 Started GET "/assets/jquery.self.js?body=1" for 127.0.0.1 at 2015-07-14 10:45:37 +0300 Started GET "/assets/jquery_ujs.self.js?body=1" for 127.0.0.1 at 2015-07-14 10:45:37 +0300 Started GET "/assets/bootstrap.self.js?body=1" for 127.0.0.1 at 2015-07-14 10:45:37 +0300 Started GET "/assets/bootstrap3-typeahead.min.self.js?body=1" for 127.0.0.1 at 2015-07-14 10:45:37 +0300 Started GET "/assets/application.self.js?body=1" for 127.0.0.1 at 2015-07-14 10:45:37 +0300 Started GET "/assets/bootstrap3-autocomplete-input.min.self.js?body=1" for 127.0.0.1 at 2015-07-14 10:45:37 +0300 Started GET "/orders/autocomplete_client_name?q=a" for 127.0.0.1 at 2015-07-14 10:45:42 +0300 Processing by OrdersController#autocomplete_client_name as JSON Parameters: {"q"=>"a"} Client Load (1.0ms) SELECT clients.id, clients.name FROM "clients" WHERE (LOWER(clients.name) LIKE 'a%') ORDER BY clients.name ASC LIMIT 10 Completed 200 OK in 2ms (Views: 1.0ms | ActiveRecord: 1.0ms) Started GET "/orders/new" for 127.0.0.1 at 2015-07-14 10:46:49 +0300 Processing by OrdersController#new as HTML Rendered orders/_form.html.erb (6.0ms) Rendered orders/new.html.erb within layouts/application (7.0ms) Completed 200 OK in 213ms (Views: 213.0ms | ActiveRecord: 0.0ms) Started GET "/assets/jquery.self.js?body=1" for 127.0.0.1 at 2015-07-14 10:46:50 +0300 Started GET "/assets/jquery_ujs.self.js?body=1" for 127.0.0.1 at 2015-07-14 10:46:50 +0300 Started GET "/assets/application.self.css?body=1" for 127.0.0.1 at 2015-07-14 10:46:50 +0300 Started GET "/assets/bootstrap.self.js?body=1" for 127.0.0.1 at 2015-07-14 10:46:50 +0300 Started GET "/assets/bootstrap3-typeahead.self.js?body=1" for 127.0.0.1 at 2015-07-14 10:46:50 +0300 Started GET "/assets/application.self.js?body=1" for 127.0.0.1 at 2015-07-14 10:46:50 +0300 Started GET "/assets/bootstrap3-autocomplete-input.min.self.js?body=1" for 127.0.0.1 at 2015-07-14 10:46:50 +0300 Started GET "/orders/autocomplete_client_name?q=a" for 127.0.0.1 at 2015-07-14 10:46:52 +0300 Processing by OrdersController#autocomplete_client_name as JSON Parameters: {"q"=>"a"} Client Load (1.0ms) SELECT clients.id, clients.name FROM "clients" WHERE (LOWER(clients.name) LIKE 'a%') ORDER BY clients.name ASC LIMIT 10 Completed 200 OK in 1ms (Views: 0.0ms | ActiveRecord: 1.0ms) Started GET "/orders/new" for 127.0.0.1 at 2015-07-14 10:47:16 +0300 Processing by OrdersController#new as HTML Rendered orders/_form.html.erb (10.0ms) Rendered orders/new.html.erb within layouts/application (12.0ms) Completed 200 OK in 84ms (Views: 78.0ms | ActiveRecord: 1.0ms) Started GET "/assets/application.self.css?body=1" for 127.0.0.1 at 2015-07-14 10:47:17 +0300 Started GET "/assets/jquery.self.js?body=1" for 127.0.0.1 at 2015-07-14 10:47:17 +0300 Started GET "/assets/bootstrap.self.js?body=1" for 127.0.0.1 at 2015-07-14 10:47:17 +0300 Started GET "/assets/jquery_ujs.self.js?body=1" for 127.0.0.1 at 2015-07-14 10:47:17 +0300 Started GET "/assets/bootstrap3-typeahead.self.js?body=1" for 127.0.0.1 at 2015-07-14 10:47:17 +0300 Started GET "/assets/bootstrap3-autocomplete-input.min.self.js?body=1" for 127.0.0.1 at 2015-07-14 10:47:17 +0300 Started GET "/assets/application.self.js?body=1" for 127.0.0.1 at 2015-07-14 10:47:17 +0300 Started GET "/orders/autocomplete_client_name?q=a" for 127.0.0.1 at 2015-07-14 10:47:18 +0300 AbstractController::ActionNotFound (The action 'autocomplete_client_name' could not be found for OrdersController): actionpack (4.2.1) lib/abstract_controller/base.rb:132:in `process' actionview (4.2.1) lib/action_view/rendering.rb:30:in `process' actionpack (4.2.1) lib/action_controller/metal.rb:196:in `dispatch' actionpack (4.2.1) lib/action_controller/metal/rack_delegation.rb:13:in `dispatch' actionpack (4.2.1) lib/action_controller/metal.rb:237:in `block in action' actionpack (4.2.1) lib/action_dispatch/routing/route_set.rb:74:in `call' actionpack (4.2.1) lib/action_dispatch/routing/route_set.rb:74:in `dispatch' actionpack (4.2.1) lib/action_dispatch/routing/route_set.rb:43:in `serve' actionpack (4.2.1) lib/action_dispatch/journey/router.rb:43:in `block in serve' actionpack (4.2.1) lib/action_dispatch/journey/router.rb:30:in `each' actionpack (4.2.1) lib/action_dispatch/journey/router.rb:30:in `serve' actionpack (4.2.1) lib/action_dispatch/routing/route_set.rb:819: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.1) lib/action_dispatch/middleware/params_parser.rb:27:in `call' actionpack (4.2.1) 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.1) lib/action_dispatch/middleware/cookies.rb:560:in `call' activerecord (4.2.1) lib/active_record/query_cache.rb:36:in `call' activerecord (4.2.1) lib/active_record/connection_adapters/abstract/connection_pool.rb:649:in `call' activerecord (4.2.1) lib/active_record/migration.rb:378:in `call' actionpack (4.2.1) lib/action_dispatch/middleware/callbacks.rb:29:in `block in call' activesupport (4.2.1) lib/active_support/callbacks.rb:88:in `call' activesupport (4.2.1) lib/active_support/callbacks.rb:88:in `_run_callbacks' activesupport (4.2.1) lib/active_support/callbacks.rb:776:in `_run_call_callbacks' activesupport (4.2.1) lib/active_support/callbacks.rb:81:in `run_callbacks' actionpack (4.2.1) lib/action_dispatch/middleware/callbacks.rb:27:in `call' actionpack (4.2.1) lib/action_dispatch/middleware/reloader.rb:73:in `call' actionpack (4.2.1) lib/action_dispatch/middleware/remote_ip.rb:78:in `call' actionpack (4.2.1) lib/action_dispatch/middleware/debug_exceptions.rb:17:in `call' actionpack (4.2.1) lib/action_dispatch/middleware/show_exceptions.rb:30:in `call' railties (4.2.1) lib/rails/rack/logger.rb:38:in `call_app' railties (4.2.1) lib/rails/rack/logger.rb:20:in `block in call' activesupport (4.2.1) lib/active_support/tagged_logging.rb:68:in `block in tagged' activesupport (4.2.1) lib/active_support/tagged_logging.rb:26:in `tagged' activesupport (4.2.1) lib/active_support/tagged_logging.rb:68:in `tagged' railties (4.2.1) lib/rails/rack/logger.rb:20:in `call' actionpack (4.2.1) 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.1) 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.1) lib/action_dispatch/middleware/static.rb:113:in `call' rack (1.6.4) lib/rack/sendfile.rb:113:in `call' railties (4.2.1) lib/rails/engine.rb:518:in `call' railties (4.2.1) lib/rails/application.rb:164: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' D:/Ruby215/lib/ruby/2.1.0/webrick/httpserver.rb:138:in `service' D:/Ruby215/lib/ruby/2.1.0/webrick/httpserver.rb:94:in `run' D:/Ruby215/lib/ruby/2.1.0/webrick/server.rb:295:in `block in start_thread' Rendered D:/Ruby215/lib/ruby/gems/2.1.0/gems/actionpack-4.2.1/lib/action_dispatch/middleware/templates/rescues/unknown_action.text.erb (1.0ms) Started GET "/orders/autocomplete_client_name?q=a" for 127.0.0.1 at 2015-07-14 10:49:04 +0300 Processing by OrdersController#autocomplete_client_name as JSON Parameters: {"q"=>"a"} Client Load (0.0ms) SELECT clients.id, clients.name FROM "clients" WHERE (LOWER(clients.name) LIKE 'a%') ORDER BY clients.name ASC LIMIT 10 Completed 200 OK in 7ms (Views: 0.0ms | ActiveRecord: 1.0ms) Started GET "/orders/autocomplete_client_name?q=d" for 127.0.0.1 at 2015-07-14 10:49:22 +0300 Processing by OrdersController#autocomplete_client_name as JSON Parameters: {"q"=>"d"} Client Load (1.0ms) SELECT clients.id, clients.name FROM "clients" WHERE (LOWER(clients.name) LIKE 'd%') ORDER BY clients.name ASC LIMIT 10 Completed 200 OK in 1ms (Views: 0.0ms | ActiveRecord: 1.0ms) Started GET "/orders/autocomplete_client_name?q=b" for 127.0.0.1 at 2015-07-14 10:49:24 +0300 Processing by OrdersController#autocomplete_client_name as JSON Parameters: {"q"=>"b"} Client Load (0.0ms) SELECT clients.id, clients.name FROM "clients" WHERE (LOWER(clients.name) LIKE 'b%') ORDER BY clients.name ASC LIMIT 10 Completed 200 OK in 1ms (Views: 0.0ms | ActiveRecord: 0.0ms) Started GET "/orders/autocomplete_client_name?q=a" for 127.0.0.1 at 2015-07-14 10:49:36 +0300 Processing by OrdersController#autocomplete_client_name as JSON Parameters: {"q"=>"a"} Client Load (0.0ms) SELECT clients.id, clients.name FROM "clients" WHERE (LOWER(clients.name) LIKE 'a%') ORDER BY clients.name ASC LIMIT 10 Completed 200 OK in 1ms (Views: 0.0ms | ActiveRecord: 0.0ms) Started GET "/orders/new" for 127.0.0.1 at 2015-07-14 10:49:45 +0300 Processing by OrdersController#new as HTML Rendered orders/_form.html.erb (9.0ms) Rendered orders/new.html.erb within layouts/application (9.0ms) Completed 200 OK in 299ms (Views: 294.0ms | ActiveRecord: 1.0ms) Started GET "/orders/autocomplete_client_name?q=a" for 127.0.0.1 at 2015-07-14 10:49:45 +0300 Processing by OrdersController#autocomplete_client_name as JSON Parameters: {"q"=>"a"} Client Load (0.0ms) SELECT clients.id, clients.name FROM "clients" WHERE (LOWER(clients.name) LIKE 'a%') ORDER BY clients.name ASC LIMIT 10 Completed 200 OK in 2ms (Views: 0.0ms | ActiveRecord: 0.0ms) Started GET "/assets/jquery2.self.js?body=1" for 127.0.0.1 at 2015-07-14 10:49:45 +0300 Started GET "/assets/application.self.css?body=1" for 127.0.0.1 at 2015-07-14 10:49:45 +0300 Started GET "/assets/application.self.js?body=1" for 127.0.0.1 at 2015-07-14 10:49:45 +0300 Started GET "/assets/jquery_ujs.self.js?body=1" for 127.0.0.1 at 2015-07-14 10:49:45 +0300 Started GET "/assets/bootstrap.self.js?body=1" for 127.0.0.1 at 2015-07-14 10:49:45 +0300 Started GET "/assets/bootstrap3-typeahead.self.js?body=1" for 127.0.0.1 at 2015-07-14 10:49:45 +0300 Started GET "/assets/bootstrap3-autocomplete-input.min.self.js?body=1" for 127.0.0.1 at 2015-07-14 10:49:45 +0300 Started GET "/orders/autocomplete_client_name?q=b" for 127.0.0.1 at 2015-07-14 10:49:47 +0300 Processing by OrdersController#autocomplete_client_name as JSON Parameters: {"q"=>"b"} Client Load (0.0ms) SELECT clients.id, clients.name FROM "clients" WHERE (LOWER(clients.name) LIKE 'b%') ORDER BY clients.name ASC LIMIT 10 Completed 200 OK in 1ms (Views: 0.0ms | ActiveRecord: 0.0ms) Started GET "/orders/new" for 127.0.0.1 at 2015-07-14 10:50:53 +0300 Processing by OrdersController#new as HTML Rendered orders/_form.html.erb (10.0ms) Rendered orders/new.html.erb within layouts/application (12.0ms) Completed 200 OK in 559ms (Views: 553.0ms | ActiveRecord: 1.0ms) Started GET "/orders/autocomplete_client_name?q=b" for 127.0.0.1 at 2015-07-14 10:50:54 +0300 Processing by OrdersController#autocomplete_client_name as JSON Parameters: {"q"=>"b"} Client Load (0.0ms) SELECT "clients".* FROM "clients" WHERE (LOWER(clients.event_type_name) LIKE 'b%') ORDER BY clients.event_type_name ASC LIMIT 10 SQLite3::SQLException: no such column: clients.event_type_name: SELECT "clients".* FROM "clients" WHERE (LOWER(clients.event_type_name) LIKE 'b%') ORDER BY clients.event_type_name ASC LIMIT 10 Completed 500 Internal Server Error in 2ms (ActiveRecord: 0.0ms) ActiveRecord::StatementInvalid (SQLite3::SQLException: no such column: clients.event_type_name: SELECT "clients".* FROM "clients" WHERE (LOWER(clients.event_type_name) LIKE 'b%') ORDER BY clients.event_type_name ASC LIMIT 10): sqlite3-1.3.10-x86 (mingw32) lib/sqlite3/database.rb:91:in `initialize' sqlite3-1.3.10-x86 (mingw32) lib/sqlite3/database.rb:91:in `new' sqlite3-1.3.10-x86 (mingw32) lib/sqlite3/database.rb:91:in `prepare' activerecord (4.2.1) lib/active_record/connection_adapters/sqlite3_adapter.rb:296:in `block in exec_query' activerecord (4.2.1) lib/active_record/connection_adapters/abstract_adapter.rb:473:in `block in log' activesupport (4.2.1) lib/active_support/notifications/instrumenter.rb:20:in `instrument' activerecord (4.2.1) lib/active_record/connection_adapters/abstract_adapter.rb:467:in `log' activerecord (4.2.1) lib/active_record/connection_adapters/sqlite3_adapter.rb:293:in `exec_query' activerecord (4.2.1) lib/active_record/connection_adapters/abstract/database_statements.rb:347:in `select' activerecord (4.2.1) lib/active_record/connection_adapters/abstract/database_statements.rb:32:in `select_all' activerecord (4.2.1) lib/active_record/connection_adapters/abstract/query_cache.rb:68:in `block in select_all' activerecord (4.2.1) lib/active_record/connection_adapters/abstract/query_cache.rb:83:in `cache_sql' activerecord (4.2.1) lib/active_record/connection_adapters/abstract/query_cache.rb:68:in `select_all' activerecord (4.2.1) lib/active_record/querying.rb:39:in `find_by_sql' activerecord (4.2.1) lib/active_record/relation.rb:638:in `exec_queries' activerecord (4.2.1) lib/active_record/relation.rb:514:in `load' activerecord (4.2.1) lib/active_record/relation.rb:243:in `to_a' D:in `collect' D:/mmx/projects/www/myrails/mygems/bootstrap3_autocomplete_input/lib/bootstrap3_autocomplete_input/controllers/autocomplete.rb:59:in `items_to_json' D:/mmx/projects/www/myrails/mygems/bootstrap3_autocomplete_input/lib/bootstrap3_autocomplete_input/controllers/autocomplete.rb:39:in `block in autocomplete' actionpack (4.2.1) lib/action_controller/metal/implicit_render.rb:4:in `send_action' actionpack (4.2.1) lib/abstract_controller/base.rb:198:in `process_action' actionpack (4.2.1) lib/action_controller/metal/rendering.rb:10:in `process_action' actionpack (4.2.1) lib/abstract_controller/callbacks.rb:20:in `block in process_action' activesupport (4.2.1) lib/active_support/callbacks.rb:117:in `call' activesupport (4.2.1) lib/active_support/callbacks.rb:117:in `call' activesupport (4.2.1) lib/active_support/callbacks.rb:555:in `block (2 levels) in compile' activesupport (4.2.1) lib/active_support/callbacks.rb:505:in `call' activesupport (4.2.1) lib/active_support/callbacks.rb:505:in `call' activesupport (4.2.1) lib/active_support/callbacks.rb:92:in `_run_callbacks' activesupport (4.2.1) lib/active_support/callbacks.rb:776:in `_run_process_action_callbacks' activesupport (4.2.1) lib/active_support/callbacks.rb:81:in `run_callbacks' actionpack (4.2.1) lib/abstract_controller/callbacks.rb:19:in `process_action' actionpack (4.2.1) lib/action_controller/metal/rescue.rb:29:in `process_action' actionpack (4.2.1) lib/action_controller/metal/instrumentation.rb:32:in `block in process_action' activesupport (4.2.1) lib/active_support/notifications.rb:164:in `block in instrument' activesupport (4.2.1) lib/active_support/notifications/instrumenter.rb:20:in `instrument' activesupport (4.2.1) lib/active_support/notifications.rb:164:in `instrument' actionpack (4.2.1) lib/action_controller/metal/instrumentation.rb:30:in `process_action' actionpack (4.2.1) lib/action_controller/metal/params_wrapper.rb:250:in `process_action' activerecord (4.2.1) lib/active_record/railties/controller_runtime.rb:18:in `process_action' actionpack (4.2.1) lib/abstract_controller/base.rb:137:in `process' actionview (4.2.1) lib/action_view/rendering.rb:30:in `process' actionpack (4.2.1) lib/action_controller/metal.rb:196:in `dispatch' actionpack (4.2.1) lib/action_controller/metal/rack_delegation.rb:13:in `dispatch' actionpack (4.2.1) lib/action_controller/metal.rb:237:in `block in action' actionpack (4.2.1) lib/action_dispatch/routing/route_set.rb:74:in `call' actionpack (4.2.1) lib/action_dispatch/routing/route_set.rb:74:in `dispatch' actionpack (4.2.1) lib/action_dispatch/routing/route_set.rb:43:in `serve' actionpack (4.2.1) lib/action_dispatch/journey/router.rb:43:in `block in serve' actionpack (4.2.1) lib/action_dispatch/journey/router.rb:30:in `each' actionpack (4.2.1) lib/action_dispatch/journey/router.rb:30:in `serve' actionpack (4.2.1) lib/action_dispatch/routing/route_set.rb:819: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.1) lib/action_dispatch/middleware/params_parser.rb:27:in `call' actionpack (4.2.1) 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.1) lib/action_dispatch/middleware/cookies.rb:560:in `call' activerecord (4.2.1) lib/active_record/query_cache.rb:36:in `call' activerecord (4.2.1) lib/active_record/connection_adapters/abstract/connection_pool.rb:649:in `call' activerecord (4.2.1) lib/active_record/migration.rb:378:in `call' actionpack (4.2.1) lib/action_dispatch/middleware/callbacks.rb:29:in `block in call' activesupport (4.2.1) lib/active_support/callbacks.rb:88:in `call' activesupport (4.2.1) lib/active_support/callbacks.rb:88:in `_run_callbacks' activesupport (4.2.1) lib/active_support/callbacks.rb:776:in `_run_call_callbacks' activesupport (4.2.1) lib/active_support/callbacks.rb:81:in `run_callbacks' actionpack (4.2.1) lib/action_dispatch/middleware/callbacks.rb:27:in `call' actionpack (4.2.1) lib/action_dispatch/middleware/reloader.rb:73:in `call' actionpack (4.2.1) lib/action_dispatch/middleware/remote_ip.rb:78:in `call' actionpack (4.2.1) lib/action_dispatch/middleware/debug_exceptions.rb:17:in `call' actionpack (4.2.1) lib/action_dispatch/middleware/show_exceptions.rb:30:in `call' railties (4.2.1) lib/rails/rack/logger.rb:38:in `call_app' railties (4.2.1) lib/rails/rack/logger.rb:20:in `block in call' activesupport (4.2.1) lib/active_support/tagged_logging.rb:68:in `block in tagged' activesupport (4.2.1) lib/active_support/tagged_logging.rb:26:in `tagged' activesupport (4.2.1) lib/active_support/tagged_logging.rb:68:in `tagged' railties (4.2.1) lib/rails/rack/logger.rb:20:in `call' actionpack (4.2.1) 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.1) 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.1) lib/action_dispatch/middleware/static.rb:113:in `call' rack (1.6.4) lib/rack/sendfile.rb:113:in `call' railties (4.2.1) lib/rails/engine.rb:518:in `call' railties (4.2.1) lib/rails/application.rb:164: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' D:/Ruby215/lib/ruby/2.1.0/webrick/httpserver.rb:138:in `service' D:/Ruby215/lib/ruby/2.1.0/webrick/httpserver.rb:94:in `run' D:/Ruby215/lib/ruby/2.1.0/webrick/server.rb:295:in `block in start_thread' Rendered D:/Ruby215/lib/ruby/gems/2.1.0/gems/actionpack-4.2.1/lib/action_dispatch/middleware/templates/rescues/_source.erb (0.0ms) Rendered D:/Ruby215/lib/ruby/gems/2.1.0/gems/actionpack-4.2.1/lib/action_dispatch/middleware/templates/rescues/_trace.text.erb (0.0ms) Rendered D:/Ruby215/lib/ruby/gems/2.1.0/gems/actionpack-4.2.1/lib/action_dispatch/middleware/templates/rescues/_request_and_response.text.erb (1.0ms) Rendered D:/Ruby215/lib/ruby/gems/2.1.0/gems/actionpack-4.2.1/lib/action_dispatch/middleware/templates/rescues/diagnostics.text.erb (44.0ms) Started GET "/assets/application.self.css?body=1" for 127.0.0.1 at 2015-07-14 10:50:54 +0300 Started GET "/assets/jquery2.self.js?body=1" for 127.0.0.1 at 2015-07-14 10:50:54 +0300 Started GET "/assets/jquery_ujs.self.js?body=1" for 127.0.0.1 at 2015-07-14 10:50:54 +0300 Started GET "/assets/bootstrap.self.js?body=1" for 127.0.0.1 at 2015-07-14 10:50:54 +0300 Started GET "/assets/bootstrap3-typeahead.self.js?body=1" for 127.0.0.1 at 2015-07-14 10:50:54 +0300 Started GET "/assets/bootstrap3-autocomplete-input.min.self.js?body=1" for 127.0.0.1 at 2015-07-14 10:50:54 +0300 Started GET "/assets/application.self.js?body=1" for 127.0.0.1 at 2015-07-14 10:50:54 +0300 Started GET "/orders/new" for 127.0.0.1 at 2015-07-14 10:50:58 +0300 Processing by OrdersController#new as HTML Rendered orders/_form.html.erb (6.0ms) Rendered orders/new.html.erb within layouts/application (8.0ms) Completed 200 OK in 81ms (Views: 81.0ms | ActiveRecord: 0.0ms) Started GET "/assets/bootstrap.self.js?body=1" for 127.0.0.1 at 2015-07-14 10:50:58 +0300 Started GET "/assets/jquery2.self.js?body=1" for 127.0.0.1 at 2015-07-14 10:50:58 +0300 Started GET "/assets/jquery_ujs.self.js?body=1" for 127.0.0.1 at 2015-07-14 10:50:58 +0300 Started GET "/assets/bootstrap3-typeahead.self.js?body=1" for 127.0.0.1 at 2015-07-14 10:50:58 +0300 Started GET "/assets/bootstrap3-autocomplete-input.min.self.js?body=1" for 127.0.0.1 at 2015-07-14 10:50:58 +0300 Started GET "/assets/application.self.css?body=1" for 127.0.0.1 at 2015-07-14 10:50:58 +0300 Started GET "/assets/application.self.js?body=1" for 127.0.0.1 at 2015-07-14 10:50:58 +0300 Started GET "/orders/autocomplete_client_name?q=a" for 127.0.0.1 at 2015-07-14 10:51:01 +0300 Processing by OrdersController#autocomplete_client_name as JSON Parameters: {"q"=>"a"} Client Load (1.0ms) SELECT "clients".* FROM "clients" WHERE (LOWER(clients.event_type_name) LIKE 'a%') ORDER BY clients.event_type_name ASC LIMIT 10 SQLite3::SQLException: no such column: clients.event_type_name: SELECT "clients".* FROM "clients" WHERE (LOWER(clients.event_type_name) LIKE 'a%') ORDER BY clients.event_type_name ASC LIMIT 10 Completed 500 Internal Server Error in 1ms (ActiveRecord: 1.0ms) ActiveRecord::StatementInvalid (SQLite3::SQLException: no such column: clients.event_type_name: SELECT "clients".* FROM "clients" WHERE (LOWER(clients.event_type_name) LIKE 'a%') ORDER BY clients.event_type_name ASC LIMIT 10): sqlite3-1.3.10-x86 (mingw32) lib/sqlite3/database.rb:91:in `initialize' sqlite3-1.3.10-x86 (mingw32) lib/sqlite3/database.rb:91:in `new' sqlite3-1.3.10-x86 (mingw32) lib/sqlite3/database.rb:91:in `prepare' activerecord (4.2.1) lib/active_record/connection_adapters/sqlite3_adapter.rb:296:in `block in exec_query' activerecord (4.2.1) lib/active_record/connection_adapters/abstract_adapter.rb:473:in `block in log' activesupport (4.2.1) lib/active_support/notifications/instrumenter.rb:20:in `instrument' activerecord (4.2.1) lib/active_record/connection_adapters/abstract_adapter.rb:467:in `log' activerecord (4.2.1) lib/active_record/connection_adapters/sqlite3_adapter.rb:293:in `exec_query' activerecord (4.2.1) lib/active_record/connection_adapters/abstract/database_statements.rb:347:in `select' activerecord (4.2.1) lib/active_record/connection_adapters/abstract/database_statements.rb:32:in `select_all' activerecord (4.2.1) lib/active_record/connection_adapters/abstract/query_cache.rb:68:in `block in select_all' activerecord (4.2.1) lib/active_record/connection_adapters/abstract/query_cache.rb:83:in `cache_sql' activerecord (4.2.1) lib/active_record/connection_adapters/abstract/query_cache.rb:68:in `select_all' activerecord (4.2.1) lib/active_record/querying.rb:39:in `find_by_sql' activerecord (4.2.1) lib/active_record/relation.rb:638:in `exec_queries' activerecord (4.2.1) lib/active_record/relation.rb:514:in `load' activerecord (4.2.1) lib/active_record/relation.rb:243:in `to_a' D:in `collect' D:/mmx/projects/www/myrails/mygems/bootstrap3_autocomplete_input/lib/bootstrap3_autocomplete_input/controllers/autocomplete.rb:59:in `items_to_json' D:/mmx/projects/www/myrails/mygems/bootstrap3_autocomplete_input/lib/bootstrap3_autocomplete_input/controllers/autocomplete.rb:39:in `block in autocomplete' actionpack (4.2.1) lib/action_controller/metal/implicit_render.rb:4:in `send_action' actionpack (4.2.1) lib/abstract_controller/base.rb:198:in `process_action' actionpack (4.2.1) lib/action_controller/metal/rendering.rb:10:in `process_action' actionpack (4.2.1) lib/abstract_controller/callbacks.rb:20:in `block in process_action' activesupport (4.2.1) lib/active_support/callbacks.rb:117:in `call' activesupport (4.2.1) lib/active_support/callbacks.rb:117:in `call' activesupport (4.2.1) lib/active_support/callbacks.rb:555:in `block (2 levels) in compile' activesupport (4.2.1) lib/active_support/callbacks.rb:505:in `call' activesupport (4.2.1) lib/active_support/callbacks.rb:505:in `call' activesupport (4.2.1) lib/active_support/callbacks.rb:92:in `_run_callbacks' activesupport (4.2.1) lib/active_support/callbacks.rb:776:in `_run_process_action_callbacks' activesupport (4.2.1) lib/active_support/callbacks.rb:81:in `run_callbacks' actionpack (4.2.1) lib/abstract_controller/callbacks.rb:19:in `process_action' actionpack (4.2.1) lib/action_controller/metal/rescue.rb:29:in `process_action' actionpack (4.2.1) lib/action_controller/metal/instrumentation.rb:32:in `block in process_action' activesupport (4.2.1) lib/active_support/notifications.rb:164:in `block in instrument' activesupport (4.2.1) lib/active_support/notifications/instrumenter.rb:20:in `instrument' activesupport (4.2.1) lib/active_support/notifications.rb:164:in `instrument' actionpack (4.2.1) lib/action_controller/metal/instrumentation.rb:30:in `process_action' actionpack (4.2.1) lib/action_controller/metal/params_wrapper.rb:250:in `process_action' activerecord (4.2.1) lib/active_record/railties/controller_runtime.rb:18:in `process_action' actionpack (4.2.1) lib/abstract_controller/base.rb:137:in `process' actionview (4.2.1) lib/action_view/rendering.rb:30:in `process' actionpack (4.2.1) lib/action_controller/metal.rb:196:in `dispatch' actionpack (4.2.1) lib/action_controller/metal/rack_delegation.rb:13:in `dispatch' actionpack (4.2.1) lib/action_controller/metal.rb:237:in `block in action' actionpack (4.2.1) lib/action_dispatch/routing/route_set.rb:74:in `call' actionpack (4.2.1) lib/action_dispatch/routing/route_set.rb:74:in `dispatch' actionpack (4.2.1) lib/action_dispatch/routing/route_set.rb:43:in `serve' actionpack (4.2.1) lib/action_dispatch/journey/router.rb:43:in `block in serve' actionpack (4.2.1) lib/action_dispatch/journey/router.rb:30:in `each' actionpack (4.2.1) lib/action_dispatch/journey/router.rb:30:in `serve' actionpack (4.2.1) lib/action_dispatch/routing/route_set.rb:819: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.1) lib/action_dispatch/middleware/params_parser.rb:27:in `call' actionpack (4.2.1) 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.1) lib/action_dispatch/middleware/cookies.rb:560:in `call' activerecord (4.2.1) lib/active_record/query_cache.rb:36:in `call' activerecord (4.2.1) lib/active_record/connection_adapters/abstract/connection_pool.rb:649:in `call' activerecord (4.2.1) lib/active_record/migration.rb:378:in `call' actionpack (4.2.1) lib/action_dispatch/middleware/callbacks.rb:29:in `block in call' activesupport (4.2.1) lib/active_support/callbacks.rb:88:in `call' activesupport (4.2.1) lib/active_support/callbacks.rb:88:in `_run_callbacks' activesupport (4.2.1) lib/active_support/callbacks.rb:776:in `_run_call_callbacks' activesupport (4.2.1) lib/active_support/callbacks.rb:81:in `run_callbacks' actionpack (4.2.1) lib/action_dispatch/middleware/callbacks.rb:27:in `call' actionpack (4.2.1) lib/action_dispatch/middleware/reloader.rb:73:in `call' actionpack (4.2.1) lib/action_dispatch/middleware/remote_ip.rb:78:in `call' actionpack (4.2.1) lib/action_dispatch/middleware/debug_exceptions.rb:17:in `call' actionpack (4.2.1) lib/action_dispatch/middleware/show_exceptions.rb:30:in `call' railties (4.2.1) lib/rails/rack/logger.rb:38:in `call_app' railties (4.2.1) lib/rails/rack/logger.rb:20:in `block in call' activesupport (4.2.1) lib/active_support/tagged_logging.rb:68:in `block in tagged' activesupport (4.2.1) lib/active_support/tagged_logging.rb:26:in `tagged' activesupport (4.2.1) lib/active_support/tagged_logging.rb:68:in `tagged' railties (4.2.1) lib/rails/rack/logger.rb:20:in `call' actionpack (4.2.1) 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.1) 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.1) lib/action_dispatch/middleware/static.rb:113:in `call' rack (1.6.4) lib/rack/sendfile.rb:113:in `call' railties (4.2.1) lib/rails/engine.rb:518:in `call' railties (4.2.1) lib/rails/application.rb:164: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' D:/Ruby215/lib/ruby/2.1.0/webrick/httpserver.rb:138:in `service' D:/Ruby215/lib/ruby/2.1.0/webrick/httpserver.rb:94:in `run' D:/Ruby215/lib/ruby/2.1.0/webrick/server.rb:295:in `block in start_thread' Rendered D:/Ruby215/lib/ruby/gems/2.1.0/gems/actionpack-4.2.1/lib/action_dispatch/middleware/templates/rescues/_source.erb (1.0ms) Rendered D:/Ruby215/lib/ruby/gems/2.1.0/gems/actionpack-4.2.1/lib/action_dispatch/middleware/templates/rescues/_trace.text.erb (1.0ms) Rendered D:/Ruby215/lib/ruby/gems/2.1.0/gems/actionpack-4.2.1/lib/action_dispatch/middleware/templates/rescues/_request_and_response.text.erb (1.0ms) Rendered D:/Ruby215/lib/ruby/gems/2.1.0/gems/actionpack-4.2.1/lib/action_dispatch/middleware/templates/rescues/diagnostics.text.erb (16.0ms) Started GET "/orders/autocomplete_client_name?q=b" for 127.0.0.1 at 2015-07-14 10:51:38 +0300 Processing by OrdersController#autocomplete_client_name as JSON Parameters: {"q"=>"b"} Client Load (0.0ms) SELECT "clients".* FROM "clients" WHERE (LOWER(clients.name) LIKE 'b%') ORDER BY clients.name ASC LIMIT 10 Completed 500 Internal Server Error in 7ms (ActiveRecord: 0.0ms) NoMethodError (undefined method `occasion_name' for #): activemodel (4.2.1) lib/active_model/attribute_methods.rb:433:in `method_missing' D:/mmx/projects/www/myrails/mygems/bootstrap3_autocomplete_input/lib/bootstrap3_autocomplete_input/controllers/autocomplete.rb:60:in `block in items_to_json' D:in `collect' D:in `collect' D:/mmx/projects/www/myrails/mygems/bootstrap3_autocomplete_input/lib/bootstrap3_autocomplete_input/controllers/autocomplete.rb:59:in `items_to_json' D:/mmx/projects/www/myrails/mygems/bootstrap3_autocomplete_input/lib/bootstrap3_autocomplete_input/controllers/autocomplete.rb:39:in `block in autocomplete' actionpack (4.2.1) lib/action_controller/metal/implicit_render.rb:4:in `send_action' actionpack (4.2.1) lib/abstract_controller/base.rb:198:in `process_action' actionpack (4.2.1) lib/action_controller/metal/rendering.rb:10:in `process_action' actionpack (4.2.1) lib/abstract_controller/callbacks.rb:20:in `block in process_action' activesupport (4.2.1) lib/active_support/callbacks.rb:117:in `call' activesupport (4.2.1) lib/active_support/callbacks.rb:117:in `call' activesupport (4.2.1) lib/active_support/callbacks.rb:555:in `block (2 levels) in compile' activesupport (4.2.1) lib/active_support/callbacks.rb:505:in `call' activesupport (4.2.1) lib/active_support/callbacks.rb:505:in `call' activesupport (4.2.1) lib/active_support/callbacks.rb:92:in `_run_callbacks' activesupport (4.2.1) lib/active_support/callbacks.rb:776:in `_run_process_action_callbacks' activesupport (4.2.1) lib/active_support/callbacks.rb:81:in `run_callbacks' actionpack (4.2.1) lib/abstract_controller/callbacks.rb:19:in `process_action' actionpack (4.2.1) lib/action_controller/metal/rescue.rb:29:in `process_action' actionpack (4.2.1) lib/action_controller/metal/instrumentation.rb:32:in `block in process_action' activesupport (4.2.1) lib/active_support/notifications.rb:164:in `block in instrument' activesupport (4.2.1) lib/active_support/notifications/instrumenter.rb:20:in `instrument' activesupport (4.2.1) lib/active_support/notifications.rb:164:in `instrument' actionpack (4.2.1) lib/action_controller/metal/instrumentation.rb:30:in `process_action' actionpack (4.2.1) lib/action_controller/metal/params_wrapper.rb:250:in `process_action' activerecord (4.2.1) lib/active_record/railties/controller_runtime.rb:18:in `process_action' actionpack (4.2.1) lib/abstract_controller/base.rb:137:in `process' actionview (4.2.1) lib/action_view/rendering.rb:30:in `process' actionpack (4.2.1) lib/action_controller/metal.rb:196:in `dispatch' actionpack (4.2.1) lib/action_controller/metal/rack_delegation.rb:13:in `dispatch' actionpack (4.2.1) lib/action_controller/metal.rb:237:in `block in action' actionpack (4.2.1) lib/action_dispatch/routing/route_set.rb:74:in `call' actionpack (4.2.1) lib/action_dispatch/routing/route_set.rb:74:in `dispatch' actionpack (4.2.1) lib/action_dispatch/routing/route_set.rb:43:in `serve' actionpack (4.2.1) lib/action_dispatch/journey/router.rb:43:in `block in serve' actionpack (4.2.1) lib/action_dispatch/journey/router.rb:30:in `each' actionpack (4.2.1) lib/action_dispatch/journey/router.rb:30:in `serve' actionpack (4.2.1) lib/action_dispatch/routing/route_set.rb:819: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.1) lib/action_dispatch/middleware/params_parser.rb:27:in `call' actionpack (4.2.1) 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.1) lib/action_dispatch/middleware/cookies.rb:560:in `call' activerecord (4.2.1) lib/active_record/query_cache.rb:36:in `call' activerecord (4.2.1) lib/active_record/connection_adapters/abstract/connection_pool.rb:649:in `call' activerecord (4.2.1) lib/active_record/migration.rb:378:in `call' actionpack (4.2.1) lib/action_dispatch/middleware/callbacks.rb:29:in `block in call' activesupport (4.2.1) lib/active_support/callbacks.rb:88:in `call' activesupport (4.2.1) lib/active_support/callbacks.rb:88:in `_run_callbacks' activesupport (4.2.1) lib/active_support/callbacks.rb:776:in `_run_call_callbacks' activesupport (4.2.1) lib/active_support/callbacks.rb:81:in `run_callbacks' actionpack (4.2.1) lib/action_dispatch/middleware/callbacks.rb:27:in `call' actionpack (4.2.1) lib/action_dispatch/middleware/reloader.rb:73:in `call' actionpack (4.2.1) lib/action_dispatch/middleware/remote_ip.rb:78:in `call' actionpack (4.2.1) lib/action_dispatch/middleware/debug_exceptions.rb:17:in `call' actionpack (4.2.1) lib/action_dispatch/middleware/show_exceptions.rb:30:in `call' railties (4.2.1) lib/rails/rack/logger.rb:38:in `call_app' railties (4.2.1) lib/rails/rack/logger.rb:20:in `block in call' activesupport (4.2.1) lib/active_support/tagged_logging.rb:68:in `block in tagged' activesupport (4.2.1) lib/active_support/tagged_logging.rb:26:in `tagged' activesupport (4.2.1) lib/active_support/tagged_logging.rb:68:in `tagged' railties (4.2.1) lib/rails/rack/logger.rb:20:in `call' actionpack (4.2.1) 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.1) 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.1) lib/action_dispatch/middleware/static.rb:113:in `call' rack (1.6.4) lib/rack/sendfile.rb:113:in `call' railties (4.2.1) lib/rails/engine.rb:518:in `call' railties (4.2.1) lib/rails/application.rb:164: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' D:/Ruby215/lib/ruby/2.1.0/webrick/httpserver.rb:138:in `service' D:/Ruby215/lib/ruby/2.1.0/webrick/httpserver.rb:94:in `run' D:/Ruby215/lib/ruby/2.1.0/webrick/server.rb:295:in `block in start_thread' Rendered D:/Ruby215/lib/ruby/gems/2.1.0/gems/actionpack-4.2.1/lib/action_dispatch/middleware/templates/rescues/_source.erb (1.0ms) Rendered D:/Ruby215/lib/ruby/gems/2.1.0/gems/actionpack-4.2.1/lib/action_dispatch/middleware/templates/rescues/_trace.text.erb (1.0ms) Rendered D:/Ruby215/lib/ruby/gems/2.1.0/gems/actionpack-4.2.1/lib/action_dispatch/middleware/templates/rescues/_request_and_response.text.erb (1.0ms) Rendered D:/Ruby215/lib/ruby/gems/2.1.0/gems/actionpack-4.2.1/lib/action_dispatch/middleware/templates/rescues/diagnostics.text.erb (17.0ms) Started GET "/orders/new" for 127.0.0.1 at 2015-07-14 10:51:52 +0300 Processing by OrdersController#new as HTML Rendered orders/_form.html.erb (11.0ms) Rendered orders/new.html.erb within layouts/application (13.0ms) Completed 200 OK in 103ms (Views: 96.0ms | ActiveRecord: 1.0ms) Started GET "/assets/jquery2.self.js?body=1" for 127.0.0.1 at 2015-07-14 10:51:52 +0300 Started GET "/assets/jquery_ujs.self.js?body=1" for 127.0.0.1 at 2015-07-14 10:51:52 +0300 Started GET "/assets/application.self.css?body=1" for 127.0.0.1 at 2015-07-14 10:51:52 +0300 Started GET "/assets/bootstrap.self.js?body=1" for 127.0.0.1 at 2015-07-14 10:51:52 +0300 Started GET "/assets/bootstrap3-typeahead.self.js?body=1" for 127.0.0.1 at 2015-07-14 10:51:52 +0300 Started GET "/assets/application.self.js?body=1" for 127.0.0.1 at 2015-07-14 10:51:52 +0300 Started GET "/assets/bootstrap3-autocomplete-input.min.self.js?body=1" for 127.0.0.1 at 2015-07-14 10:51:52 +0300 Started GET "/orders/autocomplete_client_name?q=b" for 127.0.0.1 at 2015-07-14 10:51:54 +0300 Processing by OrdersController#autocomplete_client_name as JSON Parameters: {"q"=>"b"} Client Load (1.0ms) SELECT "clients".* FROM "clients" WHERE (LOWER(clients.name) LIKE 'b%') ORDER BY clients.name ASC LIMIT 10 Completed 200 OK in 4ms (Views: 0.0ms | ActiveRecord: 1.0ms) Started GET "/orders/new" for 127.0.0.1 at 2015-07-14 11:11:53 +0300 ActiveRecord::SchemaMigration Load (0.0ms) SELECT "schema_migrations".* FROM "schema_migrations" Processing by OrdersController#new as HTML Rendered orders/_form.html.erb (85.0ms) Rendered orders/new.html.erb within layouts/application (91.0ms) Completed 200 OK in 343ms (Views: 334.0ms | ActiveRecord: 0.0ms) Started GET "/assets/application.self.css?body=1" for 127.0.0.1 at 2015-07-14 11:11:54 +0300 Started GET "/assets/jquery2.self.js?body=1" for 127.0.0.1 at 2015-07-14 11:11:54 +0300 Started GET "/assets/jquery_ujs.self.js?body=1" for 127.0.0.1 at 2015-07-14 11:11:54 +0300 Started GET "/assets/application.self.js?body=1" for 127.0.0.1 at 2015-07-14 11:11:54 +0300 Started GET "/assets/bootstrap.self.js?body=1" for 127.0.0.1 at 2015-07-14 11:11:54 +0300 Started GET "/assets/bootstrap3-typeahead.self.js?body=1" for 127.0.0.1 at 2015-07-14 11:11:54 +0300 Started GET "/assets/bootstrap3-autocomplete-input.min.self.js?body=1" for 127.0.0.1 at 2015-07-14 11:11:54 +0300 Started GET "/clients/autocomplete_name?q=a" for 127.0.0.1 at 2015-07-14 11:11:55 +0300 AbstractController::ActionNotFound (The action 'autocomplete_name' could not be found for ClientsController): actionpack (4.2.1) lib/abstract_controller/base.rb:132:in `process' actionview (4.2.1) lib/action_view/rendering.rb:30:in `process' actionpack (4.2.1) lib/action_controller/metal.rb:196:in `dispatch' actionpack (4.2.1) lib/action_controller/metal/rack_delegation.rb:13:in `dispatch' actionpack (4.2.1) lib/action_controller/metal.rb:237:in `block in action' actionpack (4.2.1) lib/action_dispatch/routing/route_set.rb:74:in `call' actionpack (4.2.1) lib/action_dispatch/routing/route_set.rb:74:in `dispatch' actionpack (4.2.1) lib/action_dispatch/routing/route_set.rb:43:in `serve' actionpack (4.2.1) lib/action_dispatch/journey/router.rb:43:in `block in serve' actionpack (4.2.1) lib/action_dispatch/journey/router.rb:30:in `each' actionpack (4.2.1) lib/action_dispatch/journey/router.rb:30:in `serve' actionpack (4.2.1) lib/action_dispatch/routing/route_set.rb:819: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.1) lib/action_dispatch/middleware/params_parser.rb:27:in `call' actionpack (4.2.1) 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.1) lib/action_dispatch/middleware/cookies.rb:560:in `call' activerecord (4.2.1) lib/active_record/query_cache.rb:36:in `call' activerecord (4.2.1) lib/active_record/connection_adapters/abstract/connection_pool.rb:649:in `call' activerecord (4.2.1) lib/active_record/migration.rb:378:in `call' actionpack (4.2.1) lib/action_dispatch/middleware/callbacks.rb:29:in `block in call' activesupport (4.2.1) lib/active_support/callbacks.rb:88:in `call' activesupport (4.2.1) lib/active_support/callbacks.rb:88:in `_run_callbacks' activesupport (4.2.1) lib/active_support/callbacks.rb:776:in `_run_call_callbacks' activesupport (4.2.1) lib/active_support/callbacks.rb:81:in `run_callbacks' actionpack (4.2.1) lib/action_dispatch/middleware/callbacks.rb:27:in `call' actionpack (4.2.1) lib/action_dispatch/middleware/reloader.rb:73:in `call' actionpack (4.2.1) lib/action_dispatch/middleware/remote_ip.rb:78:in `call' actionpack (4.2.1) lib/action_dispatch/middleware/debug_exceptions.rb:17:in `call' actionpack (4.2.1) lib/action_dispatch/middleware/show_exceptions.rb:30:in `call' railties (4.2.1) lib/rails/rack/logger.rb:38:in `call_app' railties (4.2.1) lib/rails/rack/logger.rb:20:in `block in call' activesupport (4.2.1) lib/active_support/tagged_logging.rb:68:in `block in tagged' activesupport (4.2.1) lib/active_support/tagged_logging.rb:26:in `tagged' activesupport (4.2.1) lib/active_support/tagged_logging.rb:68:in `tagged' railties (4.2.1) lib/rails/rack/logger.rb:20:in `call' actionpack (4.2.1) 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.1) 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.1) lib/action_dispatch/middleware/static.rb:113:in `call' rack (1.6.4) lib/rack/sendfile.rb:113:in `call' railties (4.2.1) lib/rails/engine.rb:518:in `call' railties (4.2.1) lib/rails/application.rb:164: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' D:/Ruby215/lib/ruby/2.1.0/webrick/httpserver.rb:138:in `service' D:/Ruby215/lib/ruby/2.1.0/webrick/httpserver.rb:94:in `run' D:/Ruby215/lib/ruby/2.1.0/webrick/server.rb:295:in `block in start_thread' Rendered D:/Ruby215/lib/ruby/gems/2.1.0/gems/actionpack-4.2.1/lib/action_dispatch/middleware/templates/rescues/unknown_action.text.erb (0.0ms) Started GET "/orders/new" for 127.0.0.1 at 2015-07-14 11:12:18 +0300 Processing by OrdersController#new as HTML Rendered orders/_form.html.erb (38.0ms) Rendered orders/new.html.erb within layouts/application (40.0ms) Completed 500 Internal Server Error in 47ms (ActiveRecord: 1.0ms) ActionView::Template::Error (undefined local variable or method `autocomplete_name_clients_url' for #<#:0x9648f18>): 39:
40: 41: <%#= f.input :client, :as => :autocomplete, :source_query => autocomplete_client_name_orders_url, :items => 2, :minLength=>1, :afterSelect=>'after_select_client' %> 42: <%= f.input :client, :as => :autocomplete, :source_query => autocomplete_name_clients_url %> 43: 44: 45:
app/views/orders/_form.html.erb:42:in `block in _app_views_orders__form_html_erb___303085134_56769420' app/views/orders/_form.html.erb:25:in `_app_views_orders__form_html_erb___303085134_56769420' app/views/orders/new.html.erb:3:in `_app_views_orders_new_html_erb___223930380_56949120' Rendered D:/Ruby215/lib/ruby/gems/2.1.0/gems/actionpack-4.2.1/lib/action_dispatch/middleware/templates/rescues/_source.erb (1.0ms) Rendered D:/Ruby215/lib/ruby/gems/2.1.0/gems/actionpack-4.2.1/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (6.0ms) Rendered D:/Ruby215/lib/ruby/gems/2.1.0/gems/actionpack-4.2.1/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (1.0ms) Rendered D:/Ruby215/lib/ruby/gems/2.1.0/gems/actionpack-4.2.1/lib/action_dispatch/middleware/templates/rescues/template_error.html.erb within rescues/layout (32.0ms) Started GET "/orders/new" for 127.0.0.1 at 2015-07-14 11:12:34 +0300 Processing by OrdersController#new as HTML Rendered orders/_form.html.erb (12.0ms) Rendered orders/new.html.erb within layouts/application (13.0ms) Completed 200 OK in 81ms (Views: 81.0ms | ActiveRecord: 0.0ms) Started GET "/assets/application.self.css?body=1" for 127.0.0.1 at 2015-07-14 11:12:34 +0300 Started GET "/assets/jquery2.self.js?body=1" for 127.0.0.1 at 2015-07-14 11:12:34 +0300 Started GET "/assets/jquery_ujs.self.js?body=1" for 127.0.0.1 at 2015-07-14 11:12:34 +0300 Started GET "/assets/application.self.js?body=1" for 127.0.0.1 at 2015-07-14 11:12:34 +0300 Started GET "/assets/bootstrap.self.js?body=1" for 127.0.0.1 at 2015-07-14 11:12:34 +0300 Started GET "/assets/bootstrap3-typeahead.self.js?body=1" for 127.0.0.1 at 2015-07-14 11:12:34 +0300 Started GET "/assets/bootstrap3-autocomplete-input.min.self.js?body=1" for 127.0.0.1 at 2015-07-14 11:12:34 +0300 Started GET "/clients/autocomplete_client_name?q=a" for 127.0.0.1 at 2015-07-14 11:12:37 +0300 Processing by ClientsController#autocomplete_client_name as JSON Parameters: {"q"=>"a"} Client Load (0.0ms) SELECT clients.id, clients.name FROM "clients" WHERE (LOWER(clients.name) LIKE 'a%') ORDER BY clients.name ASC LIMIT 10 Completed 200 OK in 6ms (Views: 1.0ms | ActiveRecord: 0.0ms) Started GET "/" for 127.0.0.1 at 2015-07-14 17:49:23 +0300 ActiveRecord::SchemaMigration Load (1.0ms) SELECT "schema_migrations".* FROM "schema_migrations" Processing by Rails::WelcomeController#index as HTML Rendered D:/Ruby215/lib/ruby/gems/2.1.0/gems/railties-4.2.1/lib/rails/templates/rails/welcome/index.html.erb (8.0ms) Completed 200 OK in 45ms (Views: 45.0ms | ActiveRecord: 0.0ms) Started GET "/orders/new" for 127.0.0.1 at 2015-07-14 17:49:28 +0300 Processing by OrdersController#new as HTML Rendered orders/_form.html.erb (231.0ms) Rendered orders/new.html.erb within layouts/application (237.0ms) Completed 200 OK in 557ms (Views: 548.0ms | ActiveRecord: 1.0ms) Started GET "/assets/application.self.css?body=1" for 127.0.0.1 at 2015-07-14 17:49:29 +0300 Started GET "/assets/jquery2.self.js?body=1" for 127.0.0.1 at 2015-07-14 17:49:29 +0300 Started GET "/assets/jquery_ujs.self.js?body=1" for 127.0.0.1 at 2015-07-14 17:49:29 +0300 Started GET "/assets/bootstrap.self.js?body=1" for 127.0.0.1 at 2015-07-14 17:49:29 +0300 Started GET "/assets/application.self.js?body=1" for 127.0.0.1 at 2015-07-14 17:49:29 +0300 Started GET "/assets/bootstrap3-typeahead.self.js?body=1" for 127.0.0.1 at 2015-07-14 17:49:29 +0300 Started GET "/assets/bootstrap3-autocomplete-input.min.self.js?body=1" for 127.0.0.1 at 2015-07-14 17:49:29 +0300 Started GET "/clients/autocomplete_client_name?q=a" for 127.0.0.1 at 2015-07-14 17:49:31 +0300 Processing by ClientsController#autocomplete_client_name as JSON Parameters: {"q"=>"a"} Client Load (26.0ms) SELECT clients.id, clients.name FROM "clients" WHERE (LOWER(clients.name) LIKE 'a%') ORDER BY clients.name ASC LIMIT 10 Completed 200 OK in 31ms (Views: 0.0ms | ActiveRecord: 26.0ms) Started GET "/" for 127.0.0.1 at 2015-07-14 17:50:57 +0300 Processing by Rails::WelcomeController#index as HTML Rendered D:/Ruby215/lib/ruby/gems/2.1.0/gems/railties-4.2.1/lib/rails/templates/rails/welcome/index.html.erb (0.0ms) Completed 200 OK in 1ms (Views: 1.0ms | ActiveRecord: 0.0ms) Started GET "/orders/new" for 127.0.0.1 at 2015-07-14 17:50:59 +0300 Processing by OrdersController#new as HTML Rendered orders/_form.html.erb (6.0ms) Rendered orders/new.html.erb within layouts/application (8.0ms) Completed 200 OK in 75ms (Views: 75.0ms | ActiveRecord: 0.0ms) Started GET "/assets/jquery_ujs.self.js?body=1" for 127.0.0.1 at 2015-07-14 17:50:59 +0300 Started GET "/assets/jquery2.self.js?body=1" for 127.0.0.1 at 2015-07-14 17:50:59 +0300 Started GET "/assets/application.self.css?body=1" for 127.0.0.1 at 2015-07-14 17:50:59 +0300 Started GET "/assets/bootstrap3-autocomplete-input.min.self.js?body=1" for 127.0.0.1 at 2015-07-14 17:50:59 +0300 Started GET "/assets/bootstrap3-typeahead.self.js?body=1" for 127.0.0.1 at 2015-07-14 17:50:59 +0300 Started GET "/orders/new" for 127.0.0.1 at 2015-07-14 17:51:16 +0300 Processing by OrdersController#new as HTML Rendered orders/_form.html.erb (6.0ms) Rendered orders/new.html.erb within layouts/application (7.0ms) Completed 200 OK in 216ms (Views: 215.0ms | ActiveRecord: 0.0ms) Started GET "/assets/application.self.css?body=1" for 127.0.0.1 at 2015-07-14 17:51:16 +0300 Started GET "/assets/jquery_ujs.self.js?body=1" for 127.0.0.1 at 2015-07-14 17:51:16 +0300 Started GET "/assets/bootstrap.self.js?body=1" for 127.0.0.1 at 2015-07-14 17:51:16 +0300 Started GET "/assets/jquery.self.js?body=1" for 127.0.0.1 at 2015-07-14 17:51:16 +0300 Started GET "/assets/bootstrap3-autocomplete-input.min.self.js?body=1" for 127.0.0.1 at 2015-07-14 17:51:16 +0300 Started GET "/assets/bootstrap3-typeahead.self.js?body=1" for 127.0.0.1 at 2015-07-14 17:51:16 +0300 Started GET "/assets/application.self.js?body=1" for 127.0.0.1 at 2015-07-14 17:51:16 +0300 Started GET "/clients/autocomplete_client_name?q=a" for 127.0.0.1 at 2015-07-14 17:51:33 +0300 Processing by ClientsController#autocomplete_client_name as JSON Parameters: {"q"=>"a"} Client Load (0.0ms) SELECT clients.id, clients.name FROM "clients" WHERE (LOWER(clients.name) LIKE 'a%') ORDER BY clients.name ASC LIMIT 10 Completed 200 OK in 2ms (Views: 1.0ms | ActiveRecord: 0.0ms) Started GET "/clients/autocomplete_client_name?q=b" for 127.0.0.1 at 2015-07-14 17:51:37 +0300 Processing by ClientsController#autocomplete_client_name as JSON Parameters: {"q"=>"b"} Client Load (0.0ms) SELECT clients.id, clients.name FROM "clients" WHERE (LOWER(clients.name) LIKE 'b%') ORDER BY clients.name ASC LIMIT 10 Completed 200 OK in 5ms (Views: 1.0ms | ActiveRecord: 0.0ms) Started GET "/clients/autocomplete_client_name?q=c" for 127.0.0.1 at 2015-07-14 17:51:42 +0300 Processing by ClientsController#autocomplete_client_name as JSON Parameters: {"q"=>"c"} Client Load (0.0ms) SELECT clients.id, clients.name FROM "clients" WHERE (LOWER(clients.name) LIKE 'c%') ORDER BY clients.name ASC LIMIT 10 Completed 200 OK in 2ms (Views: 0.0ms | ActiveRecord: 0.0ms) Started GET "/clients/autocomplete_client_name?q=d" for 127.0.0.1 at 2015-07-14 17:51:45 +0300 Processing by ClientsController#autocomplete_client_name as JSON Parameters: {"q"=>"d"} Client Load (1.0ms) SELECT clients.id, clients.name FROM "clients" WHERE (LOWER(clients.name) LIKE 'd%') ORDER BY clients.name ASC LIMIT 10 Completed 200 OK in 5ms (Views: 0.0ms | ActiveRecord: 1.0ms) Started GET "/clients/autocomplete_client_name?q=a" for 127.0.0.1 at 2015-07-14 17:51:48 +0300 Processing by ClientsController#autocomplete_client_name as JSON Parameters: {"q"=>"a"} Client Load (1.0ms) SELECT clients.id, clients.name FROM "clients" WHERE (LOWER(clients.name) LIKE 'a%') ORDER BY clients.name ASC LIMIT 10 Completed 200 OK in 2ms (Views: 1.0ms | ActiveRecord: 1.0ms) Started GET "/orders/new" for 127.0.0.1 at 2015-07-14 17:52:08 +0300 Processing by OrdersController#new as HTML Rendered orders/_form.html.erb (6.0ms) Rendered orders/new.html.erb within layouts/application (8.0ms) Completed 200 OK in 81ms (Views: 81.0ms | ActiveRecord: 0.0ms) Started GET "/clients/autocomplete_client_name?q=a" for 127.0.0.1 at 2015-07-14 17:52:08 +0300 Processing by ClientsController#autocomplete_client_name as JSON Parameters: {"q"=>"a"} Client Load (0.0ms) SELECT clients.id, clients.name FROM "clients" WHERE (LOWER(clients.name) LIKE 'a%') ORDER BY clients.name ASC LIMIT 10 Completed 200 OK in 1ms (Views: 0.0ms | ActiveRecord: 0.0ms) Started GET "/assets/jquery2.self.js?body=1" for 127.0.0.1 at 2015-07-14 17:52:08 +0300 Started GET "/assets/application.self.css?body=1" for 127.0.0.1 at 2015-07-14 17:52:08 +0300 Started GET "/assets/jquery_ujs.self.js?body=1" for 127.0.0.1 at 2015-07-14 17:52:08 +0300 Started GET "/assets/application.self.js?body=1" for 127.0.0.1 at 2015-07-14 17:52:08 +0300 Started GET "/assets/bootstrap.self.js?body=1" for 127.0.0.1 at 2015-07-14 17:52:08 +0300 Started GET "/assets/bootstrap3-typeahead.self.js?body=1" for 127.0.0.1 at 2015-07-14 17:52:08 +0300 Started GET "/assets/bootstrap3-autocomplete-input.min.self.js?body=1" for 127.0.0.1 at 2015-07-14 17:52:08 +0300 Started GET "/clients/autocomplete_client_name?q=a" for 127.0.0.1 at 2015-07-14 17:52:10 +0300 Processing by ClientsController#autocomplete_client_name as JSON Parameters: {"q"=>"a"} Client Load (1.0ms) SELECT clients.id, clients.name FROM "clients" WHERE (LOWER(clients.name) LIKE 'a%') ORDER BY clients.name ASC LIMIT 10 Completed 200 OK in 2ms (Views: 1.0ms | ActiveRecord: 1.0ms) Started GET "/clients/" for 127.0.0.1 at 2015-07-14 17:54:23 +0300 Processing by ClientsController#index as HTML Client Load (1.0ms) SELECT "clients".* FROM "clients" Rendered clients/index.html.erb within layouts/application (3.0ms) Completed 200 OK in 70ms (Views: 68.0ms | ActiveRecord: 1.0ms) Started GET "/assets/application.self.css?body=1" for 127.0.0.1 at 2015-07-14 17:54:24 +0300 Started GET "/assets/jquery2.self.js?body=1" for 127.0.0.1 at 2015-07-14 17:54:24 +0300 Started GET "/assets/bootstrap.self.js?body=1" for 127.0.0.1 at 2015-07-14 17:54:24 +0300 Started GET "/assets/jquery_ujs.self.js?body=1" for 127.0.0.1 at 2015-07-14 17:54:24 +0300 Started GET "/assets/bootstrap3-typeahead.self.js?body=1" for 127.0.0.1 at 2015-07-14 17:54:24 +0300 Started GET "/assets/application.self.js?body=1" for 127.0.0.1 at 2015-07-14 17:54:24 +0300 Started GET "/assets/bootstrap3-autocomplete-input.min.self.js?body=1" for 127.0.0.1 at 2015-07-14 17:54:24 +0300 Started GET "/clients/2/edit" for 127.0.0.1 at 2015-07-14 17:54:28 +0300 Processing by ClientsController#edit as HTML Parameters: {"id"=>"2"} Client Load (0.0ms) SELECT "clients".* FROM "clients" WHERE "clients"."id" = ? LIMIT 1 [["id", 2]] Rendered clients/_form.html.erb (2.0ms) Rendered clients/edit.html.erb within layouts/application (3.0ms) Completed 200 OK in 84ms (Views: 74.0ms | ActiveRecord: 0.0ms) Started GET "/assets/application.self.css?body=1" for 127.0.0.1 at 2015-07-14 17:54:29 +0300 Started GET "/assets/jquery_ujs.self.js?body=1" for 127.0.0.1 at 2015-07-14 17:54:29 +0300 Started GET "/assets/bootstrap.self.js?body=1" for 127.0.0.1 at 2015-07-14 17:54:29 +0300 Started GET "/assets/bootstrap3-autocomplete-input.min.self.js?body=1" for 127.0.0.1 at 2015-07-14 17:54:29 +0300 Started GET "/assets/jquery2.self.js?body=1" for 127.0.0.1 at 2015-07-14 17:54:29 +0300 Started GET "/assets/bootstrap3-typeahead.self.js?body=1" for 127.0.0.1 at 2015-07-14 17:54:29 +0300 Started GET "/assets/application.self.js?body=1" for 127.0.0.1 at 2015-07-14 17:54:29 +0300 Started GET "/clients/autocomplete_client_name?q=a" for 127.0.0.1 at 2015-07-14 21:30:48 +0300 Processing by ClientsController#autocomplete_client_name as HTML Parameters: {"q"=>"a"} Client Load (0.0ms) SELECT clients.id, clients.name FROM "clients" WHERE (LOWER(clients.name) LIKE 'a%') ORDER BY clients.name ASC LIMIT 10 Completed 200 OK in 5ms (Views: 0.0ms | ActiveRecord: 0.0ms) Started GET "/orders/new" for 127.0.0.1 at 2015-07-14 21:36:02 +0300 Processing by OrdersController#new as HTML Rendered orders/_form.html.erb (6.0ms) Rendered orders/new.html.erb within layouts/application (8.0ms) Completed 200 OK in 349ms (Views: 349.0ms | ActiveRecord: 0.0ms) Started GET "/assets/application.self.css?body=1" for 127.0.0.1 at 2015-07-14 21:36:03 +0300 Started GET "/assets/jquery2.self.js?body=1" for 127.0.0.1 at 2015-07-14 21:36:03 +0300 Started GET "/assets/bootstrap.self.js?body=1" for 127.0.0.1 at 2015-07-14 21:36:03 +0300 Started GET "/assets/jquery_ujs.self.js?body=1" for 127.0.0.1 at 2015-07-14 21:36:03 +0300 Started GET "/assets/application.self.js?body=1" for 127.0.0.1 at 2015-07-14 21:36:03 +0300 Started GET "/assets/bootstrap3-autocomplete-input.min.self.js?body=1" for 127.0.0.1 at 2015-07-14 21:36:03 +0300 Started GET "/assets/bootstrap3-typeahead.self.js?body=1" for 127.0.0.1 at 2015-07-14 21:36:03 +0300 Started GET "/clients/autocomplete_client_name?q=a" for 127.0.0.1 at 2015-07-14 21:36:04 +0300 Processing by ClientsController#autocomplete_client_name as JSON Parameters: {"q"=>"a"} Client Load (0.0ms) SELECT clients.id, clients.name FROM "clients" WHERE (LOWER(clients.name) LIKE 'a%') ORDER BY clients.name ASC LIMIT 10 Completed 200 OK in 1ms (Views: 0.0ms | ActiveRecord: 0.0ms) Started GET "/assets/application.self.js?body=1" for 127.0.0.1 at 2015-07-14 21:56:09 +0300 Started GET "/assets/bootstrap.self.js?body=1" for 127.0.0.1 at 2015-07-14 21:56:22 +0300 Started GET "/assets/bootstrap.self.js?body=1" for 127.0.0.1 at 2015-07-14 22:12:25 +0300 ActiveRecord::SchemaMigration Load (0.0ms) SELECT "schema_migrations".* FROM "schema_migrations" Started GET "/orders/new" for 127.0.0.1 at 2015-07-14 22:12:30 +0300 Processing by OrdersController#new as HTML Rendered orders/_form.html.erb (765.0ms) Rendered orders/new.html.erb within layouts/application (826.0ms) Completed 200 OK in 6437ms (Views: 6365.4ms | ActiveRecord: 2.0ms) Started GET "/clients/autocomplete_client_name?q=a" for 127.0.0.1 at 2015-07-14 22:12:36 +0300 Processing by ClientsController#autocomplete_client_name as JSON Parameters: {"q"=>"a"} Client Load (1.0ms) SELECT clients.id, clients.name FROM "clients" WHERE (LOWER(clients.name) LIKE 'a%') ORDER BY clients.name ASC LIMIT 10 Completed 200 OK in 6ms (Views: 0.0ms | ActiveRecord: 1.0ms) Started GET "/assets/application.self.js?body=1" for 127.0.0.1 at 2015-07-14 22:12:36 +0300 Started GET "/assets/application.self.css?body=1" for 127.0.0.1 at 2015-07-14 22:12:36 +0300 Started GET "/assets/bootstrap.self.js?body=1" for 127.0.0.1 at 2015-07-14 22:12:37 +0300 Started GET "/assets/jquery2.self.js?body=1" for 127.0.0.1 at 2015-07-14 22:12:37 +0300 Started GET "/assets/bootstrap3-autocomplete-input.min.self.js?body=1" for 127.0.0.1 at 2015-07-14 22:12:37 +0300 Started GET "/assets/jquery_ujs.self.js?body=1" for 127.0.0.1 at 2015-07-14 22:12:37 +0300 Started GET "/assets/bootstrap3-typeahead.self.js?body=1" for 127.0.0.1 at 2015-07-14 22:12:37 +0300 Started GET "/clients/autocomplete_client_name?q=a" for 127.0.0.1 at 2015-07-14 22:12:38 +0300 Processing by ClientsController#autocomplete_client_name as JSON Parameters: {"q"=>"a"} Client Load (0.0ms) SELECT clients.id, clients.name FROM "clients" WHERE (LOWER(clients.name) LIKE 'a%') ORDER BY clients.name ASC LIMIT 10 Completed 200 OK in 1ms (Views: 0.0ms | ActiveRecord: 0.0ms) Started GET "/clients/autocomplete_client_name?q=a" for 127.0.0.1 at 2015-07-14 22:12:42 +0300 Processing by ClientsController#autocomplete_client_name as JSON Parameters: {"q"=>"a"} Client Load (1.0ms) SELECT clients.id, clients.name FROM "clients" WHERE (LOWER(clients.name) LIKE 'a%') ORDER BY clients.name ASC LIMIT 10 Completed 200 OK in 2ms (Views: 1.0ms | ActiveRecord: 1.0ms) Started GET "/clients/autocomplete_client_name?q=5" for 127.0.0.1 at 2015-07-14 22:12:51 +0300 Processing by ClientsController#autocomplete_client_name as JSON Parameters: {"q"=>"5"} Client Load (0.0ms) SELECT clients.id, clients.name FROM "clients" WHERE (LOWER(clients.name) LIKE '5%') ORDER BY clients.name ASC LIMIT 10 Completed 200 OK in 2ms (Views: 0.0ms | ActiveRecord: 0.0ms) Started GET "/clients/autocomplete_client_name?q=a" for 127.0.0.1 at 2015-07-14 22:12:57 +0300 Processing by ClientsController#autocomplete_client_name as JSON Parameters: {"q"=>"a"} Client Load (0.0ms) SELECT clients.id, clients.name FROM "clients" WHERE (LOWER(clients.name) LIKE 'a%') ORDER BY clients.name ASC LIMIT 10 Completed 200 OK in 2ms (Views: 0.0ms | ActiveRecord: 0.0ms) Started GET "/clients/autocomplete_client_name?q=g" for 127.0.0.1 at 2015-07-14 22:15:47 +0300 Processing by ClientsController#autocomplete_client_name as JSON Parameters: {"q"=>"g"} Client Load (0.0ms) SELECT clients.id, clients.name FROM "clients" WHERE (LOWER(clients.name) LIKE 'g%') ORDER BY clients.name ASC LIMIT 10 Completed 200 OK in 2ms (Views: 0.0ms | ActiveRecord: 0.0ms) Started GET "/orders/new" for 127.0.0.1 at 2015-07-14 22:20:48 +0300 Processing by OrdersController#new as HTML Rendered orders/_form.html.erb (6.0ms) Rendered orders/new.html.erb within layouts/application (8.0ms) Completed 200 OK in 76ms (Views: 76.0ms | ActiveRecord: 0.0ms) Started GET "/assets/application.self.css?body=1" for 127.0.0.1 at 2015-07-14 22:20:48 +0300 Started GET "/assets/jquery2.self.js?body=1" for 127.0.0.1 at 2015-07-14 22:20:48 +0300 Started GET "/assets/jquery_ujs.self.js?body=1" for 127.0.0.1 at 2015-07-14 22:20:48 +0300 Started GET "/assets/application.self.js?body=1" for 127.0.0.1 at 2015-07-14 22:20:48 +0300 Started GET "/assets/bootstrap.self.js?body=1" for 127.0.0.1 at 2015-07-14 22:20:48 +0300 Started GET "/assets/bootstrap3-typeahead.self.js?body=1" for 127.0.0.1 at 2015-07-14 22:20:48 +0300 Started GET "/assets/bootstrap3-autocomplete-input.min.self.js?body=1" for 127.0.0.1 at 2015-07-14 22:20:48 +0300 Started GET "/clients/autocomplete_client_name?q=a" for 127.0.0.1 at 2015-07-14 22:20:51 +0300 Processing by ClientsController#autocomplete_client_name as JSON Parameters: {"q"=>"a"} Client Load (0.0ms) SELECT clients.id, clients.name FROM "clients" WHERE (LOWER(clients.name) LIKE 'a%') ORDER BY clients.name ASC LIMIT 10 Completed 200 OK in 1ms (Views: 0.0ms | ActiveRecord: 0.0ms) Started GET "/clients/autocomplete_client_name?q=a" for 127.0.0.1 at 2015-07-14 22:20:54 +0300 Processing by ClientsController#autocomplete_client_name as HTML Parameters: {"q"=>"a"} Client Load (0.0ms) SELECT clients.id, clients.name FROM "clients" WHERE (LOWER(clients.name) LIKE 'a%') ORDER BY clients.name ASC LIMIT 10 Completed 200 OK in 2ms (Views: 0.0ms | ActiveRecord: 0.0ms) Started GET "/clients/autocomplete_client_name?q=a" for 127.0.0.1 at 2015-07-14 22:26:08 +0300 SyntaxError (D:/mmx/projects/www/myrails/mygems/bootstrap3_autocomplete_input/test/dummy/app/controllers/clients_controller.rb:7: syntax error, unexpected ':', expecting => a = {"events": [["b11fd919-2837-422a-a2c9-9... ^ D:/mmx/projects/www/myrails/mygems/bootstrap3_autocomplete_input/test/dummy/app/controllers/clients_controller.rb:7: syntax error, unexpected '}', expecting keyword_end): app/controllers/clients_controller.rb:7: syntax error, unexpected ':', expecting => app/controllers/clients_controller.rb:7: syntax error, unexpected '}', expecting keyword_end Rendered D:/Ruby215/lib/ruby/gems/2.1.0/gems/actionpack-4.2.1/lib/action_dispatch/middleware/templates/rescues/_source.erb (1.0ms) Rendered D:/Ruby215/lib/ruby/gems/2.1.0/gems/actionpack-4.2.1/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (2.0ms) Rendered D:/Ruby215/lib/ruby/gems/2.1.0/gems/actionpack-4.2.1/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (2.0ms) Rendered D:/Ruby215/lib/ruby/gems/2.1.0/gems/actionpack-4.2.1/lib/action_dispatch/middleware/templates/rescues/diagnostics.html.erb within rescues/layout (52.0ms) Started GET "/clients/autocomplete_client_name?q=a" for 127.0.0.1 at 2015-07-14 22:26:30 +0300 Processing by ClientsController#autocomplete_client_name as HTML Parameters: {"q"=>"a"} Completed 200 OK in 0ms (Views: 0.0ms | ActiveRecord: 0.0ms) Started GET "/orders/new" for 127.0.0.1 at 2015-07-14 22:26:33 +0300 Processing by OrdersController#new as HTML Rendered orders/_form.html.erb (10.0ms) Rendered orders/new.html.erb within layouts/application (11.0ms) Completed 200 OK in 87ms (Views: 81.0ms | ActiveRecord: 1.0ms) Started GET "/clients/autocomplete_client_name?q=a" for 127.0.0.1 at 2015-07-14 22:26:33 +0300 Processing by ClientsController#autocomplete_client_name as JSON Parameters: {"q"=>"a"} Completed 200 OK in 0ms (Views: 0.0ms | ActiveRecord: 0.0ms) Started GET "/assets/jquery2.self.js?body=1" for 127.0.0.1 at 2015-07-14 22:26:34 +0300 Started GET "/assets/application.self.css?body=1" for 127.0.0.1 at 2015-07-14 22:26:34 +0300 Started GET "/assets/jquery_ujs.self.js?body=1" for 127.0.0.1 at 2015-07-14 22:26:34 +0300 Started GET "/assets/application.self.js?body=1" for 127.0.0.1 at 2015-07-14 22:26:34 +0300 Started GET "/assets/bootstrap.self.js?body=1" for 127.0.0.1 at 2015-07-14 22:26:34 +0300 Started GET "/assets/bootstrap3-autocomplete-input.min.self.js?body=1" for 127.0.0.1 at 2015-07-14 22:26:34 +0300 Started GET "/assets/bootstrap3-typeahead.self.js?body=1" for 127.0.0.1 at 2015-07-14 22:26:34 +0300 Started GET "/clients/autocomplete_client_name?q=a" for 127.0.0.1 at 2015-07-14 22:26:44 +0300 Processing by ClientsController#autocomplete_client_name as JSON Parameters: {"q"=>"a"} Completed 200 OK in 0ms (Views: 0.0ms | ActiveRecord: 0.0ms) Started GET "/orders/new" for 127.0.0.1 at 2015-07-14 22:29:30 +0300 Processing by OrdersController#new as HTML Rendered orders/_form.html.erb (11.0ms) Rendered orders/new.html.erb within layouts/application (12.0ms) Completed 200 OK in 86ms (Views: 80.0ms | ActiveRecord: 1.0ms) Started GET "/assets/application.self.css?body=1" for 127.0.0.1 at 2015-07-14 22:29:30 +0300 Started GET "/assets/jquery2.self.js?body=1" for 127.0.0.1 at 2015-07-14 22:29:30 +0300 Started GET "/assets/jquery_ujs.self.js?body=1" for 127.0.0.1 at 2015-07-14 22:29:30 +0300 Started GET "/assets/application.self.js?body=1" for 127.0.0.1 at 2015-07-14 22:29:30 +0300 Started GET "/assets/bootstrap.self.js?body=1" for 127.0.0.1 at 2015-07-14 22:29:30 +0300 Started GET "/assets/bootstrap3-autocomplete-input.min.self.js?body=1" for 127.0.0.1 at 2015-07-14 22:29:30 +0300 Started GET "/assets/bootstrap3-typeahead.self.js?body=1" for 127.0.0.1 at 2015-07-14 22:29:30 +0300 Started GET "/clients/autocomplete_client_name?q=a" for 127.0.0.1 at 2015-07-14 22:29:32 +0300 Processing by ClientsController#autocomplete_client_name as JSON Parameters: {"q"=>"a"} Completed 200 OK in 1ms (Views: 0.0ms | ActiveRecord: 0.0ms) Started GET "/clients/autocomplete_client_name?q=a" for 127.0.0.1 at 2015-07-14 22:45:36 +0300 Processing by ClientsController#autocomplete_client_name as HTML Parameters: {"q"=>"a"} Completed 200 OK in 0ms (Views: 0.0ms | ActiveRecord: 0.0ms) Started GET "/orders/new" for 127.0.0.1 at 2015-07-14 22:45:39 +0300 Processing by OrdersController#new as HTML Rendered orders/_form.html.erb (11.0ms) Rendered orders/new.html.erb within layouts/application (11.0ms) Completed 200 OK in 88ms (Views: 82.0ms | ActiveRecord: 0.0ms) Started GET "/clients/autocomplete_client_name?q=a" for 127.0.0.1 at 2015-07-14 22:45:39 +0300 Processing by ClientsController#autocomplete_client_name as JSON Parameters: {"q"=>"a"} Completed 200 OK in 1ms (Views: 0.0ms | ActiveRecord: 0.0ms) Started GET "/assets/application.self.css?body=1" for 127.0.0.1 at 2015-07-14 22:45:39 +0300 Started GET "/assets/jquery2.self.js?body=1" for 127.0.0.1 at 2015-07-14 22:45:39 +0300 Started GET "/assets/jquery_ujs.self.js?body=1" for 127.0.0.1 at 2015-07-14 22:45:39 +0300 Started GET "/assets/bootstrap.self.js?body=1" for 127.0.0.1 at 2015-07-14 22:45:39 +0300 Started GET "/assets/bootstrap3-typeahead.self.js?body=1" for 127.0.0.1 at 2015-07-14 22:45:39 +0300 Started GET "/assets/application.self.js?body=1" for 127.0.0.1 at 2015-07-14 22:45:39 +0300 Started GET "/assets/bootstrap3-autocomplete-input.min.self.js?body=1" for 127.0.0.1 at 2015-07-14 22:45:39 +0300 Started GET "/clients/autocomplete_client_name?q=a" for 127.0.0.1 at 2015-07-14 22:45:40 +0300 Processing by ClientsController#autocomplete_client_name as JSON Parameters: {"q"=>"a"} Completed 200 OK in 0ms (Views: 0.0ms | ActiveRecord: 0.0ms) Started GET "/clients/autocomplete_client_name?q=a" for 127.0.0.1 at 2015-07-14 22:46:49 +0300 Processing by ClientsController#autocomplete_client_name as JSON Parameters: {"q"=>"a"} Completed 200 OK in 1ms (Views: 1.0ms | ActiveRecord: 0.0ms) Started GET "/clients/autocomplete_client_name?q=a" for 127.0.0.1 at 2015-07-14 22:46:53 +0300 Processing by ClientsController#autocomplete_client_name as HTML Parameters: {"q"=>"a"} Completed 200 OK in 0ms (Views: 0.0ms | ActiveRecord: 0.0ms) Started GET "/clients/autocomplete_client_name?q=a" for 127.0.0.1 at 2015-07-14 22:55:10 +0300 ActiveRecord::SchemaMigration Load (0.0ms) SELECT "schema_migrations".* FROM "schema_migrations" Processing by ClientsController#autocomplete_client_name as HTML Parameters: {"q"=>"a"} Completed 200 OK in 0ms (Views: 0.0ms | ActiveRecord: 0.0ms) Started GET "/orders/new" for 127.0.0.1 at 2015-07-14 22:55:25 +0300 Processing by OrdersController#new as HTML Rendered orders/_form.html.erb (90.0ms) Rendered orders/new.html.erb within layouts/application (95.0ms) Completed 200 OK in 386ms (Views: 377.0ms | ActiveRecord: 1.0ms) Started GET "/clients/autocomplete_client_name?q=a" for 127.0.0.1 at 2015-07-14 22:55:26 +0300 Processing by ClientsController#autocomplete_client_name as JSON Parameters: {"q"=>"a"} Client Load (1.0ms) SELECT clients.id, clients.name FROM "clients" WHERE (LOWER(clients.name) LIKE 'a%') ORDER BY clients.name ASC LIMIT 10 Completed 200 OK in 5ms (Views: 0.0ms | ActiveRecord: 1.0ms) Started GET "/assets/jquery2.self.js?body=1" for 127.0.0.1 at 2015-07-14 22:55:26 +0300 Started GET "/assets/application.self.css?body=1" for 127.0.0.1 at 2015-07-14 22:55:26 +0300 Started GET "/assets/application.self.js?body=1" for 127.0.0.1 at 2015-07-14 22:55:26 +0300 Started GET "/assets/jquery_ujs.self.js?body=1" for 127.0.0.1 at 2015-07-14 22:55:26 +0300 Started GET "/assets/bootstrap.self.js?body=1" for 127.0.0.1 at 2015-07-14 22:55:26 +0300 Started GET "/assets/bootstrap3-typeahead.self.js?body=1" for 127.0.0.1 at 2015-07-14 22:55:26 +0300 Started GET "/assets/bootstrap3-autocomplete-input.min.self.js?body=1" for 127.0.0.1 at 2015-07-14 22:55:26 +0300 Started GET "/clients/autocomplete_client_name?q=a" for 127.0.0.1 at 2015-07-14 22:55:27 +0300 Processing by ClientsController#autocomplete_client_name as JSON Parameters: {"q"=>"a"} Client Load (0.0ms) SELECT clients.id, clients.name FROM "clients" WHERE (LOWER(clients.name) LIKE 'a%') ORDER BY clients.name ASC LIMIT 10 Completed 200 OK in 2ms (Views: 0.0ms | ActiveRecord: 0.0ms)