(0.9ms)  CREATE TABLE "schema_migrations" ("version" varchar(255) NOT NULL) 
   (0.4ms)  select sqlite_version(*)
   (0.8ms)  CREATE UNIQUE INDEX "unique_schema_migrations" ON "schema_migrations" ("version")
  ActiveRecord::SchemaMigration Load (0.1ms)  SELECT "schema_migrations".* FROM "schema_migrations"
Migrating to CreateQaSubjectMeshTerms (20140620210534)
   (0.1ms)  begin transaction
   (0.3ms)  CREATE TABLE "qa_subject_mesh_terms" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "term_id" varchar(255), "term" varchar(255), "synonyms" text) 
   (0.1ms)  CREATE  INDEX "index_qa_subject_mesh_terms_on_term_id" ON "qa_subject_mesh_terms" ("term_id")
   (0.1ms)              SELECT sql
            FROM sqlite_master
            WHERE name='index_qa_subject_mesh_terms_on_term_id' AND type='index'
            UNION ALL
            SELECT sql
            FROM sqlite_temp_master
            WHERE name='index_qa_subject_mesh_terms_on_term_id' AND type='index'

   (0.1ms)  CREATE  INDEX "index_qa_subject_mesh_terms_on_term" ON "qa_subject_mesh_terms" ("term")
  SQL (0.2ms)  INSERT INTO "schema_migrations" ("version") VALUES (?)  [["version", "20140620210534"]]
   (0.6ms)  commit transaction
Migrating to CreateQaMeshTree (20140620210535)
   (0.0ms)  begin transaction
   (0.2ms)  CREATE TABLE "qa_mesh_trees" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "term_id" varchar(255), "tree_number" varchar(255)) 
   (0.1ms)  CREATE  INDEX "index_qa_mesh_trees_on_term_id" ON "qa_mesh_trees" ("term_id")
   (0.0ms)              SELECT sql
            FROM sqlite_master
            WHERE name='index_qa_mesh_trees_on_term_id' AND type='index'
            UNION ALL
            SELECT sql
            FROM sqlite_temp_master
            WHERE name='index_qa_mesh_trees_on_term_id' AND type='index'

   (0.1ms)  CREATE  INDEX "index_qa_mesh_trees_on_tree_number" ON "qa_mesh_trees" ("tree_number")
  SQL (0.1ms)  INSERT INTO "schema_migrations" ("version") VALUES (?)  [["version", "20140620210535"]]
   (0.7ms)  commit transaction
Migrating to AddTermLowerToQaSubjectMeshTerms (20140620210536)
   (0.0ms)  begin transaction
   (0.3ms)  ALTER TABLE "qa_subject_mesh_terms" ADD "term_lower" varchar(255)
   (0.1ms)              SELECT sql
            FROM sqlite_master
            WHERE name='index_qa_subject_mesh_terms_on_term' AND type='index'
            UNION ALL
            SELECT sql
            FROM sqlite_temp_master
            WHERE name='index_qa_subject_mesh_terms_on_term' AND type='index'

   (0.0ms)              SELECT sql
            FROM sqlite_master
            WHERE name='index_qa_subject_mesh_terms_on_term_id' AND type='index'
            UNION ALL
            SELECT sql
            FROM sqlite_temp_master
            WHERE name='index_qa_subject_mesh_terms_on_term_id' AND type='index'

   (0.1ms)  CREATE  INDEX "index_qa_subject_mesh_terms_on_term_lower" ON "qa_subject_mesh_terms" ("term_lower")
   (0.0ms)              SELECT sql
            FROM sqlite_master
            WHERE name='index_qa_subject_mesh_terms_on_term_lower' AND type='index'
            UNION ALL
            SELECT sql
            FROM sqlite_temp_master
            WHERE name='index_qa_subject_mesh_terms_on_term_lower' AND type='index'

   (0.0ms)              SELECT sql
            FROM sqlite_master
            WHERE name='index_qa_subject_mesh_terms_on_term' AND type='index'
            UNION ALL
            SELECT sql
            FROM sqlite_temp_master
            WHERE name='index_qa_subject_mesh_terms_on_term' AND type='index'

   (0.0ms)              SELECT sql
            FROM sqlite_master
            WHERE name='index_qa_subject_mesh_terms_on_term_id' AND type='index'
            UNION ALL
            SELECT sql
            FROM sqlite_temp_master
            WHERE name='index_qa_subject_mesh_terms_on_term_id' AND type='index'

   (0.6ms)  DROP INDEX "index_qa_subject_mesh_terms_on_term"
  SQL (0.1ms)  INSERT INTO "schema_migrations" ("version") VALUES (?)  [["version", "20140620210536"]]
   (0.7ms)  commit transaction
  ActiveRecord::SchemaMigration Load (0.1ms)  SELECT "schema_migrations".* FROM "schema_migrations"
   (0.1ms)              SELECT sql
            FROM sqlite_master
            WHERE name='index_qa_mesh_trees_on_tree_number' AND type='index'
            UNION ALL
            SELECT sql
            FROM sqlite_temp_master
            WHERE name='index_qa_mesh_trees_on_tree_number' AND type='index'

   (0.1ms)              SELECT sql
            FROM sqlite_master
            WHERE name='index_qa_mesh_trees_on_term_id' AND type='index'
            UNION ALL
            SELECT sql
            FROM sqlite_temp_master
            WHERE name='index_qa_mesh_trees_on_term_id' AND type='index'

   (0.1ms)              SELECT sql
            FROM sqlite_master
            WHERE name='index_qa_subject_mesh_terms_on_term_lower' AND type='index'
            UNION ALL
            SELECT sql
            FROM sqlite_temp_master
            WHERE name='index_qa_subject_mesh_terms_on_term_lower' AND type='index'

   (0.1ms)              SELECT sql
            FROM sqlite_master
            WHERE name='index_qa_subject_mesh_terms_on_term_id' AND type='index'
            UNION ALL
            SELECT sql
            FROM sqlite_temp_master
            WHERE name='index_qa_subject_mesh_terms_on_term_id' AND type='index'

   (1.0ms)  CREATE TABLE "qa_mesh_trees" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "term_id" varchar(255), "tree_number" varchar(255)) 
   (0.1ms)  select sqlite_version(*)
   (0.7ms)  CREATE  INDEX "index_qa_mesh_trees_on_term_id" ON "qa_mesh_trees" ("term_id")
   (0.1ms)              SELECT sql
            FROM sqlite_master
            WHERE name='index_qa_mesh_trees_on_term_id' AND type='index'
            UNION ALL
            SELECT sql
            FROM sqlite_temp_master
            WHERE name='index_qa_mesh_trees_on_term_id' AND type='index'

   (0.6ms)  CREATE  INDEX "index_qa_mesh_trees_on_tree_number" ON "qa_mesh_trees" ("tree_number")
   (0.6ms)  CREATE TABLE "qa_subject_mesh_terms" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "term_id" varchar(255), "term" varchar(255), "synonyms" text, "term_lower" varchar(255)) 
   (0.5ms)  CREATE  INDEX "index_qa_subject_mesh_terms_on_term_id" ON "qa_subject_mesh_terms" ("term_id")
   (0.1ms)              SELECT sql
            FROM sqlite_master
            WHERE name='index_qa_subject_mesh_terms_on_term_id' AND type='index'
            UNION ALL
            SELECT sql
            FROM sqlite_temp_master
            WHERE name='index_qa_subject_mesh_terms_on_term_id' AND type='index'

   (0.6ms)  CREATE  INDEX "index_qa_subject_mesh_terms_on_term_lower" ON "qa_subject_mesh_terms" ("term_lower")
   (0.7ms)  CREATE TABLE "schema_migrations" ("version" varchar(255) NOT NULL) 
   (0.8ms)  CREATE UNIQUE INDEX "unique_schema_migrations" ON "schema_migrations" ("version")
   (0.1ms)  SELECT version FROM "schema_migrations"
   (0.7ms)  INSERT INTO "schema_migrations" (version) VALUES ('20140620210536')
   (1.0ms)  INSERT INTO "schema_migrations" (version) VALUES ('20140620210534')
   (0.8ms)  INSERT INTO "schema_migrations" (version) VALUES ('20140620210535')
  ActiveRecord::SchemaMigration Load (0.1ms)  SELECT "schema_migrations".* FROM "schema_migrations"
  ActiveRecord::SchemaMigration Load (0.1ms)  SELECT "schema_migrations".* FROM "schema_migrations"
   (0.1ms)              SELECT sql
            FROM sqlite_master
            WHERE name='index_qa_mesh_trees_on_tree_number' AND type='index'
            UNION ALL
            SELECT sql
            FROM sqlite_temp_master
            WHERE name='index_qa_mesh_trees_on_tree_number' AND type='index'

   (0.1ms)              SELECT sql
            FROM sqlite_master
            WHERE name='index_qa_mesh_trees_on_term_id' AND type='index'
            UNION ALL
            SELECT sql
            FROM sqlite_temp_master
            WHERE name='index_qa_mesh_trees_on_term_id' AND type='index'

   (0.1ms)              SELECT sql
            FROM sqlite_master
            WHERE name='index_qa_subject_mesh_terms_on_term_lower' AND type='index'
            UNION ALL
            SELECT sql
            FROM sqlite_temp_master
            WHERE name='index_qa_subject_mesh_terms_on_term_lower' AND type='index'

   (0.1ms)              SELECT sql
            FROM sqlite_master
            WHERE name='index_qa_subject_mesh_terms_on_term_id' AND type='index'
            UNION ALL
            SELECT sql
            FROM sqlite_temp_master
            WHERE name='index_qa_subject_mesh_terms_on_term_id' AND type='index'

   (0.9ms)  CREATE TABLE "qa_mesh_trees" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "term_id" varchar(255), "tree_number" varchar(255)) 
   (0.1ms)  select sqlite_version(*)
   (0.8ms)  CREATE  INDEX "index_qa_mesh_trees_on_term_id" ON "qa_mesh_trees" ("term_id")
   (0.1ms)              SELECT sql
            FROM sqlite_master
            WHERE name='index_qa_mesh_trees_on_term_id' AND type='index'
            UNION ALL
            SELECT sql
            FROM sqlite_temp_master
            WHERE name='index_qa_mesh_trees_on_term_id' AND type='index'

   (0.7ms)  CREATE  INDEX "index_qa_mesh_trees_on_tree_number" ON "qa_mesh_trees" ("tree_number")
   (0.7ms)  CREATE TABLE "qa_subject_mesh_terms" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "term_id" varchar(255), "term" varchar(255), "synonyms" text, "term_lower" varchar(255)) 
   (0.8ms)  CREATE  INDEX "index_qa_subject_mesh_terms_on_term_id" ON "qa_subject_mesh_terms" ("term_id")
   (0.1ms)              SELECT sql
            FROM sqlite_master
            WHERE name='index_qa_subject_mesh_terms_on_term_id' AND type='index'
            UNION ALL
            SELECT sql
            FROM sqlite_temp_master
            WHERE name='index_qa_subject_mesh_terms_on_term_id' AND type='index'

   (0.7ms)  CREATE  INDEX "index_qa_subject_mesh_terms_on_term_lower" ON "qa_subject_mesh_terms" ("term_lower")
   (0.7ms)  CREATE TABLE "schema_migrations" ("version" varchar(255) NOT NULL) 
   (0.8ms)  CREATE UNIQUE INDEX "unique_schema_migrations" ON "schema_migrations" ("version")
   (0.1ms)  SELECT version FROM "schema_migrations"
   (0.6ms)  INSERT INTO "schema_migrations" (version) VALUES ('20140620210536')
   (0.6ms)  INSERT INTO "schema_migrations" (version) VALUES ('20140620210534')
   (0.7ms)  INSERT INTO "schema_migrations" (version) VALUES ('20140620210535')


Started GET "/" for 127.0.0.1 at 2014-06-20 17:05:59 -0400
  ActiveRecord::SchemaMigration Load (0.1ms)  SELECT "schema_migrations".* FROM "schema_migrations"
Processing by Rails::WelcomeController#index as HTML
  Rendered /Users/awead/.gem/ruby/2.1.1/gems/railties-4.1.1/lib/rails/templates/rails/welcome/index.html.erb (2.1ms)
Completed 200 OK in 23ms (Views: 11.4ms | ActiveRecord: 0.0ms)


Started GET "/qa/search/local/states?q=search_term" for 127.0.0.1 at 2014-06-20 17:06:01 -0400
Processing by Qa::TermsController#search as HTML
  Parameters: {"q"=>"search_term", "vocab"=>"local", "sub_authority"=>"states"}
  Rendered text template (0.0ms)
Completed 200 OK in 15ms (Views: 1.8ms | ActiveRecord: 0.0ms)


Started GET "/qa/search/local/states?q=No" for 127.0.0.1 at 2014-06-20 17:06:10 -0400
Processing by Qa::TermsController#search as HTML
  Parameters: {"q"=>"No", "vocab"=>"local", "sub_authority"=>"states"}
  Rendered text template (0.0ms)
Completed 200 OK in 1ms (Views: 0.5ms | ActiveRecord: 0.0ms)


Started GET "/qa/search/local/states?q=Nor" for 127.0.0.1 at 2014-06-20 17:06:15 -0400
Processing by Qa::TermsController#search as HTML
  Parameters: {"q"=>"Nor", "vocab"=>"local", "sub_authority"=>"states"}
  Rendered text template (0.0ms)
Completed 200 OK in 2ms (Views: 0.4ms | ActiveRecord: 0.0ms)


Started GET "/qa/index/local/states" for 127.0.0.1 at 2014-06-20 17:07:08 -0400

ActionController::RoutingError (No route matches [GET] "/qa/index/local/states"):
  actionpack (4.1.1) lib/action_dispatch/middleware/debug_exceptions.rb:21:in `call'
  actionpack (4.1.1) lib/action_dispatch/middleware/show_exceptions.rb:30:in `call'
  railties (4.1.1) lib/rails/rack/logger.rb:38:in `call_app'
  railties (4.1.1) lib/rails/rack/logger.rb:20:in `block in call'
  activesupport (4.1.1) lib/active_support/tagged_logging.rb:68:in `block in tagged'
  activesupport (4.1.1) lib/active_support/tagged_logging.rb:26:in `tagged'
  activesupport (4.1.1) lib/active_support/tagged_logging.rb:68:in `tagged'
  railties (4.1.1) lib/rails/rack/logger.rb:20:in `call'
  actionpack (4.1.1) 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.1) 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.1) lib/action_dispatch/middleware/static.rb:64:in `call'
  rack (1.5.2) lib/rack/sendfile.rb:112:in `call'
  railties (4.1.1) lib/rails/engine.rb:514:in `call'
  railties (4.1.1) 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'
  /Users/awead/.rubies/ruby-2.1.1/lib/ruby/2.1.0/webrick/httpserver.rb:138:in `service'
  /Users/awead/.rubies/ruby-2.1.1/lib/ruby/2.1.0/webrick/httpserver.rb:94:in `run'
  /Users/awead/.rubies/ruby-2.1.1/lib/ruby/2.1.0/webrick/server.rb:295:in `block in start_thread'


  Rendered /Users/awead/.gem/ruby/2.1.1/gems/actionpack-4.1.1/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (1.3ms)
  Rendered /Users/awead/.gem/ruby/2.1.1/gems/actionpack-4.1.1/lib/action_dispatch/middleware/templates/routes/_route.html.erb (0.7ms)
  Rendered /Users/awead/.gem/ruby/2.1.1/gems/actionpack-4.1.1/lib/action_dispatch/middleware/templates/routes/_route.html.erb (0.4ms)
  Rendered /Users/awead/.gem/ruby/2.1.1/gems/actionpack-4.1.1/lib/action_dispatch/middleware/templates/routes/_table.html.erb (7.0ms)
  Rendered /Users/awead/.gem/ruby/2.1.1/gems/actionpack-4.1.1/lib/action_dispatch/middleware/templates/rescues/routing_error.html.erb within rescues/layout (34.7ms)


Started GET "/qa/index/local/states/" for 127.0.0.1 at 2014-06-20 17:07:14 -0400

ActionController::RoutingError (No route matches [GET] "/qa/index/local/states"):
  actionpack (4.1.1) lib/action_dispatch/middleware/debug_exceptions.rb:21:in `call'
  actionpack (4.1.1) lib/action_dispatch/middleware/show_exceptions.rb:30:in `call'
  railties (4.1.1) lib/rails/rack/logger.rb:38:in `call_app'
  railties (4.1.1) lib/rails/rack/logger.rb:20:in `block in call'
  activesupport (4.1.1) lib/active_support/tagged_logging.rb:68:in `block in tagged'
  activesupport (4.1.1) lib/active_support/tagged_logging.rb:26:in `tagged'
  activesupport (4.1.1) lib/active_support/tagged_logging.rb:68:in `tagged'
  railties (4.1.1) lib/rails/rack/logger.rb:20:in `call'
  actionpack (4.1.1) 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.1) 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.1) lib/action_dispatch/middleware/static.rb:64:in `call'
  rack (1.5.2) lib/rack/sendfile.rb:112:in `call'
  railties (4.1.1) lib/rails/engine.rb:514:in `call'
  railties (4.1.1) 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'
  /Users/awead/.rubies/ruby-2.1.1/lib/ruby/2.1.0/webrick/httpserver.rb:138:in `service'
  /Users/awead/.rubies/ruby-2.1.1/lib/ruby/2.1.0/webrick/httpserver.rb:94:in `run'
  /Users/awead/.rubies/ruby-2.1.1/lib/ruby/2.1.0/webrick/server.rb:295:in `block in start_thread'


  Rendered /Users/awead/.gem/ruby/2.1.1/gems/actionpack-4.1.1/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (1.0ms)
  Rendered /Users/awead/.gem/ruby/2.1.1/gems/actionpack-4.1.1/lib/action_dispatch/middleware/templates/routes/_route.html.erb (0.6ms)
  Rendered /Users/awead/.gem/ruby/2.1.1/gems/actionpack-4.1.1/lib/action_dispatch/middleware/templates/routes/_route.html.erb (0.3ms)
  Rendered /Users/awead/.gem/ruby/2.1.1/gems/actionpack-4.1.1/lib/action_dispatch/middleware/templates/routes/_table.html.erb (0.8ms)
  Rendered /Users/awead/.gem/ruby/2.1.1/gems/actionpack-4.1.1/lib/action_dispatch/middleware/templates/rescues/routing_error.html.erb within rescues/layout (16.3ms)


Started GET "/qa/local/states/" for 127.0.0.1 at 2014-06-20 17:07:20 -0400

ActionController::RoutingError (No route matches [GET] "/qa/local/states"):
  actionpack (4.1.1) lib/action_dispatch/middleware/debug_exceptions.rb:21:in `call'
  actionpack (4.1.1) lib/action_dispatch/middleware/show_exceptions.rb:30:in `call'
  railties (4.1.1) lib/rails/rack/logger.rb:38:in `call_app'
  railties (4.1.1) lib/rails/rack/logger.rb:20:in `block in call'
  activesupport (4.1.1) lib/active_support/tagged_logging.rb:68:in `block in tagged'
  activesupport (4.1.1) lib/active_support/tagged_logging.rb:26:in `tagged'
  activesupport (4.1.1) lib/active_support/tagged_logging.rb:68:in `tagged'
  railties (4.1.1) lib/rails/rack/logger.rb:20:in `call'
  actionpack (4.1.1) 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.1) 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.1) lib/action_dispatch/middleware/static.rb:64:in `call'
  rack (1.5.2) lib/rack/sendfile.rb:112:in `call'
  railties (4.1.1) lib/rails/engine.rb:514:in `call'
  railties (4.1.1) 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'
  /Users/awead/.rubies/ruby-2.1.1/lib/ruby/2.1.0/webrick/httpserver.rb:138:in `service'
  /Users/awead/.rubies/ruby-2.1.1/lib/ruby/2.1.0/webrick/httpserver.rb:94:in `run'
  /Users/awead/.rubies/ruby-2.1.1/lib/ruby/2.1.0/webrick/server.rb:295:in `block in start_thread'


  Rendered /Users/awead/.gem/ruby/2.1.1/gems/actionpack-4.1.1/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (0.8ms)
  Rendered /Users/awead/.gem/ruby/2.1.1/gems/actionpack-4.1.1/lib/action_dispatch/middleware/templates/routes/_route.html.erb (0.6ms)
  Rendered /Users/awead/.gem/ruby/2.1.1/gems/actionpack-4.1.1/lib/action_dispatch/middleware/templates/routes/_route.html.erb (0.4ms)
  Rendered /Users/awead/.gem/ruby/2.1.1/gems/actionpack-4.1.1/lib/action_dispatch/middleware/templates/routes/_table.html.erb (0.8ms)
  Rendered /Users/awead/.gem/ruby/2.1.1/gems/actionpack-4.1.1/lib/action_dispatch/middleware/templates/rescues/routing_error.html.erb within rescues/layout (15.5ms)


Started GET "/qa/terms/local/states/" for 127.0.0.1 at 2014-06-20 17:07:29 -0400
Processing by Qa::TermsController#index as HTML
  Parameters: {"vocab"=>"local", "sub_authority"=>"states"}
Completed 200 OK in 2ms (Views: 1.2ms | ActiveRecord: 0.0ms)