Started GET "/" for ::1 at 2017-12-15 12:56:40 +0900
  
ActiveRecord::PendingMigrationError (

Migrations are pending. To resolve this issue, run:

        bin/rails db:migrate RAILS_ENV=development

):
  
activerecord (5.1.4) lib/active_record/migration.rb:576:in `check_pending!'
activerecord (5.1.4) lib/active_record/migration.rb:553:in `call'
actionpack (5.1.4) lib/action_dispatch/middleware/callbacks.rb:26:in `block in call'
activesupport (5.1.4) lib/active_support/callbacks.rb:97:in `run_callbacks'
actionpack (5.1.4) lib/action_dispatch/middleware/callbacks.rb:24:in `call'
actionpack (5.1.4) lib/action_dispatch/middleware/executor.rb:12:in `call'
actionpack (5.1.4) lib/action_dispatch/middleware/debug_exceptions.rb:59:in `call'
actionpack (5.1.4) lib/action_dispatch/middleware/show_exceptions.rb:31:in `call'
railties (5.1.4) lib/rails/rack/logger.rb:36:in `call_app'
railties (5.1.4) lib/rails/rack/logger.rb:24:in `block in call'
activesupport (5.1.4) lib/active_support/tagged_logging.rb:69:in `block in tagged'
activesupport (5.1.4) lib/active_support/tagged_logging.rb:26:in `tagged'
activesupport (5.1.4) lib/active_support/tagged_logging.rb:69:in `tagged'
railties (5.1.4) lib/rails/rack/logger.rb:24:in `call'
actionpack (5.1.4) lib/action_dispatch/middleware/remote_ip.rb:79:in `call'
actionpack (5.1.4) lib/action_dispatch/middleware/request_id.rb:25:in `call'
rack (2.0.3) lib/rack/method_override.rb:22:in `call'
rack (2.0.3) lib/rack/runtime.rb:22:in `call'
activesupport (5.1.4) lib/active_support/cache/strategy/local_cache_middleware.rb:27:in `call'
actionpack (5.1.4) lib/action_dispatch/middleware/executor.rb:12:in `call'
actionpack (5.1.4) lib/action_dispatch/middleware/static.rb:125:in `call'
rack (2.0.3) lib/rack/sendfile.rb:111:in `call'
railties (5.1.4) lib/rails/engine.rb:522:in `call'
rack (2.0.3) lib/rack/handler/webrick.rb:86:in `service'
/Users/madmax/.rbenv/versions/2.4.1/lib/ruby/2.4.0/webrick/httpserver.rb:140:in `service'
/Users/madmax/.rbenv/versions/2.4.1/lib/ruby/2.4.0/webrick/httpserver.rb:96:in `run'
/Users/madmax/.rbenv/versions/2.4.1/lib/ruby/2.4.0/webrick/server.rb:290:in `block in start_thread'
   (1.7ms)  SELECT sqlite_version(*)
   (1.5ms)  CREATE TABLE "schema_migrations" ("version" varchar NOT NULL PRIMARY KEY)
   (1.2ms)  CREATE TABLE "ar_internal_metadata" ("key" varchar NOT NULL PRIMARY KEY, "value" varchar, "created_at" datetime NOT NULL, "updated_at" datetime NOT NULL)
   (0.1ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
Migrating to CreateItems (20131223124841)
   (0.0ms)  begin transaction
   (0.3ms)  CREATE TABLE "items" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "title" varchar, "sort" integer, "created_at" datetime NOT NULL, "updated_at" datetime NOT NULL)
  SQL (0.1ms)  INSERT INTO "schema_migrations" ("version") VALUES (?)  [["version", "20131223124841"]]
   (1.1ms)  commit transaction
Migrating to CreateSequencedItems (20170414031946)
   (0.1ms)  begin transaction
   (0.4ms)  CREATE TABLE "sequenced_items" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "title" varchar, "sequence" integer, "created_at" datetime NOT NULL, "updated_at" datetime NOT NULL)
  SQL (0.2ms)  INSERT INTO "schema_migrations" ("version") VALUES (?)  [["version", "20170414031946"]]
   (0.9ms)  commit transaction
  ActiveRecord::InternalMetadata Load (0.1ms)  SELECT  "ar_internal_metadata".* FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = ? LIMIT ?  [["key", "environment"], ["LIMIT", 1]]
   (0.0ms)  begin transaction
  SQL (0.3ms)  INSERT INTO "ar_internal_metadata" ("key", "value", "created_at", "updated_at") VALUES (?, ?, ?, ?)  [["key", "environment"], ["value", "development"], ["created_at", "2017-12-15 03:57:19.617937"], ["updated_at", "2017-12-15 03:57:19.617937"]]
   (0.6ms)  commit transaction
   (0.1ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
   (0.1ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
  ActiveRecord::InternalMetadata Load (0.1ms)  SELECT  "ar_internal_metadata".* FROM "ar_internal_metadata" WHERE "ar_internal_metadata"."key" = ? LIMIT ?  [["key", "environment"], ["LIMIT", 1]]
   (0.0ms)  begin transaction
   (0.0ms)  commit transaction
   (0.0ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
Started GET "/" for ::1 at 2017-12-15 12:57:45 +0900
   (0.1ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
Processing by Rails::WelcomeController#index as HTML
  Rendering /Users/madmax/Programs/itmammoth/rails_sortable/vendor/bundle/ruby/2.4.0/gems/railties-5.1.4/lib/rails/templates/rails/welcome/index.html.erb
  Rendered /Users/madmax/Programs/itmammoth/rails_sortable/vendor/bundle/ruby/2.4.0/gems/railties-5.1.4/lib/rails/templates/rails/welcome/index.html.erb (2.2ms)
Completed 200 OK in 8ms (Views: 5.1ms | ActiveRecord: 0.0ms)


Started GET "/" for ::1 at 2017-12-16 20:18:08 +0900
   (0.1ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
Processing by Rails::WelcomeController#index as HTML
  Rendering /Users/madmax/Programs/itmammoth/rails_sortable/vendor/bundle/ruby/2.4.0/gems/railties-5.1.4/lib/rails/templates/rails/welcome/index.html.erb
  Rendered /Users/madmax/Programs/itmammoth/rails_sortable/vendor/bundle/ruby/2.4.0/gems/railties-5.1.4/lib/rails/templates/rails/welcome/index.html.erb (3.6ms)
Completed 200 OK in 13ms (Views: 7.2ms | ActiveRecord: 0.0ms)


Started GET "/items" for ::1 at 2017-12-16 20:18:12 +0900
Processing by ItemsController#index as HTML
  Rendering items/index.html.erb within layouts/application
  Item Load (0.1ms)  SELECT "items".* FROM "items" ORDER BY "items"."sort" ASC
  Rendered items/index.html.erb within layouts/application (1.7ms)
Completed 200 OK in 400ms (Views: 394.6ms | ActiveRecord: 0.3ms)


Started GET "/assets/application.self-f9e7c1541e1b8783561468c59162bd896007380f5a3799ef2169d3a3fdf40bed.css?body=1" for ::1 at 2017-12-16 20:18:12 +0900
Started GET "/assets/scaffold.self-83b741db49389dc7cfdf85bf7537a0219cce48e085c4116afc83d55c9af47c78.css?body=1" for ::1 at 2017-12-16 20:18:12 +0900
Started GET "/assets/jquery.self-bd7ddd393353a8d2480a622e80342adf488fb6006d667e8b42e4c0073393abee.js?body=1" for ::1 at 2017-12-16 20:18:12 +0900
Started GET "/assets/jquery_ujs.self-784a997f6726036b1993eb2217c9cb558e1cbb801c6da88105588c56f13b466a.js?body=1" for ::1 at 2017-12-16 20:18:12 +0900
Started GET "/assets/jquery-ui/version.self-c8e3d1203da26ea7efdf83c1eabb3f0ba55cb68e463f5ccf0d77bd15ce6a8e61.js?body=1" for ::1 at 2017-12-16 20:18:12 +0900
Started GET "/assets/jquery-ui/widgets/mouse.self-f0790a202dcf54fab051e71b042335d5346f9cceb0f645223c1dab93f349a04b.js?body=1" for ::1 at 2017-12-16 20:18:12 +0900
Started GET "/assets/jquery-ui/ie.self-163eb039dcb1e0c3471b7d91386eabb8753da6906e84824c019f9ff56bdb83a6.js?body=1" for ::1 at 2017-12-16 20:18:12 +0900
Started GET "/assets/jquery-ui/widget.self-fca20bcec06d192f97cffa6e734e24360e227237b8ae7d7e7e60754df7d5444f.js?body=1" for ::1 at 2017-12-16 20:18:12 +0900
Started GET "/assets/jquery-ui/data.self-2067c82e6fe39a9cba5623206a5dc28d5c60d26b95cd100855b78cacf72865b8.js?body=1" for ::1 at 2017-12-16 20:18:12 +0900
Started GET "/assets/jquery-ui/scroll-parent.self-38e26a71a450a29fb63425e8f589a7046862f927eb0a1dbf6a6c44da05196d2e.js?body=1" for ::1 at 2017-12-16 20:18:12 +0900
Started GET "/assets/plugin.self-84bdbacb1efd558ee0dac9e9a39c3f2acc7a75ef4b01112739eec325ddfa2429.js?body=1" for ::1 at 2017-12-16 20:18:12 +0900
Started GET "/assets/rails_sortable.self-e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855.js?body=1" for ::1 at 2017-12-16 20:18:12 +0900
Started GET "/assets/sequenced_items.self-3f5ee897a5a4a74ee2d01575104d7e38daf09a55678ea0eec89cd57028db5471.js?body=1" for ::1 at 2017-12-16 20:18:12 +0900
Started GET "/assets/jquery-ui/widgets/sortable.self-6e5e1f07a29b5a89ec1d359363d2800904e3ae548a38ab2f8eded36746d1adbe.js?body=1" for ::1 at 2017-12-16 20:18:12 +0900
Started GET "/assets/application.self-120f3cf1cb67bea53c4a2a57336b34ca04b04b55a55c38cf76ce20a147e5eff9.js?body=1" for ::1 at 2017-12-16 20:18:12 +0900
Started GET "/assets/items.self-3f5ee897a5a4a74ee2d01575104d7e38daf09a55678ea0eec89cd57028db5471.js?body=1" for ::1 at 2017-12-16 20:18:12 +0900
   (0.1ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
   (0.0ms)  begin transaction
  SQL (0.3ms)  INSERT INTO "items" ("title", "sort", "created_at", "updated_at") VALUES (?, ?, ?, ?)  [["title", "Title0"], ["sort", 0], ["created_at", "2017-12-16 11:19:06.102946"], ["updated_at", "2017-12-16 11:19:06.102946"]]
   (1.1ms)  commit transaction
   (0.0ms)  begin transaction
  SQL (0.2ms)  INSERT INTO "items" ("title", "sort", "created_at", "updated_at") VALUES (?, ?, ?, ?)  [["title", "Title1"], ["sort", 1], ["created_at", "2017-12-16 11:19:06.105613"], ["updated_at", "2017-12-16 11:19:06.105613"]]
   (1.2ms)  commit transaction
   (0.0ms)  begin transaction
  SQL (0.2ms)  INSERT INTO "items" ("title", "sort", "created_at", "updated_at") VALUES (?, ?, ?, ?)  [["title", "Title2"], ["sort", 2], ["created_at", "2017-12-16 11:19:06.108048"], ["updated_at", "2017-12-16 11:19:06.108048"]]
   (0.8ms)  commit transaction
   (0.0ms)  begin transaction
  SQL (0.2ms)  INSERT INTO "items" ("title", "sort", "created_at", "updated_at") VALUES (?, ?, ?, ?)  [["title", "Title3"], ["sort", 3], ["created_at", "2017-12-16 11:19:06.109965"], ["updated_at", "2017-12-16 11:19:06.109965"]]
   (0.5ms)  commit transaction
   (0.0ms)  begin transaction
  SQL (0.2ms)  INSERT INTO "items" ("title", "sort", "created_at", "updated_at") VALUES (?, ?, ?, ?)  [["title", "Title4"], ["sort", 4], ["created_at", "2017-12-16 11:19:06.111703"], ["updated_at", "2017-12-16 11:19:06.111703"]]
   (0.8ms)  commit transaction
   (0.0ms)  begin transaction
  SQL (0.2ms)  INSERT INTO "items" ("title", "sort", "created_at", "updated_at") VALUES (?, ?, ?, ?)  [["title", "Title5"], ["sort", 5], ["created_at", "2017-12-16 11:19:06.113596"], ["updated_at", "2017-12-16 11:19:06.113596"]]
   (0.6ms)  commit transaction
   (0.0ms)  begin transaction
  SQL (0.2ms)  INSERT INTO "items" ("title", "sort", "created_at", "updated_at") VALUES (?, ?, ?, ?)  [["title", "Title6"], ["sort", 6], ["created_at", "2017-12-16 11:19:06.115153"], ["updated_at", "2017-12-16 11:19:06.115153"]]
   (0.5ms)  commit transaction
   (0.0ms)  begin transaction
  SQL (0.2ms)  INSERT INTO "items" ("title", "sort", "created_at", "updated_at") VALUES (?, ?, ?, ?)  [["title", "Title7"], ["sort", 7], ["created_at", "2017-12-16 11:19:06.116699"], ["updated_at", "2017-12-16 11:19:06.116699"]]
   (1.0ms)  commit transaction
   (0.0ms)  begin transaction
  SQL (0.2ms)  INSERT INTO "items" ("title", "sort", "created_at", "updated_at") VALUES (?, ?, ?, ?)  [["title", "Title8"], ["sort", 8], ["created_at", "2017-12-16 11:19:06.118808"], ["updated_at", "2017-12-16 11:19:06.118808"]]
   (0.7ms)  commit transaction
   (0.0ms)  begin transaction
  SQL (0.2ms)  INSERT INTO "items" ("title", "sort", "created_at", "updated_at") VALUES (?, ?, ?, ?)  [["title", "Title9"], ["sort", 9], ["created_at", "2017-12-16 11:19:06.120688"], ["updated_at", "2017-12-16 11:19:06.120688"]]
   (0.6ms)  commit transaction
   (0.0ms)  begin transaction
  SQL (0.2ms)  INSERT INTO "sequenced_items" ("title", "sequence", "created_at", "updated_at") VALUES (?, ?, ?, ?)  [["title", "OtherTitle0"], ["sequence", 0], ["created_at", "2017-12-16 11:19:06.126822"], ["updated_at", "2017-12-16 11:19:06.126822"]]
   (0.7ms)  commit transaction
   (0.0ms)  begin transaction
  SQL (0.2ms)  INSERT INTO "sequenced_items" ("title", "sequence", "created_at", "updated_at") VALUES (?, ?, ?, ?)  [["title", "OtherTitle1"], ["sequence", 1], ["created_at", "2017-12-16 11:19:06.128673"], ["updated_at", "2017-12-16 11:19:06.128673"]]
   (0.5ms)  commit transaction
   (0.0ms)  begin transaction
  SQL (0.2ms)  INSERT INTO "sequenced_items" ("title", "sequence", "created_at", "updated_at") VALUES (?, ?, ?, ?)  [["title", "OtherTitle2"], ["sequence", 2], ["created_at", "2017-12-16 11:19:06.130237"], ["updated_at", "2017-12-16 11:19:06.130237"]]
   (1.1ms)  commit transaction
   (0.0ms)  begin transaction
  SQL (0.2ms)  INSERT INTO "sequenced_items" ("title", "sequence", "created_at", "updated_at") VALUES (?, ?, ?, ?)  [["title", "OtherTitle3"], ["sequence", 3], ["created_at", "2017-12-16 11:19:06.132577"], ["updated_at", "2017-12-16 11:19:06.132577"]]
   (0.7ms)  commit transaction
   (0.0ms)  begin transaction
  SQL (0.2ms)  INSERT INTO "sequenced_items" ("title", "sequence", "created_at", "updated_at") VALUES (?, ?, ?, ?)  [["title", "OtherTitle4"], ["sequence", 4], ["created_at", "2017-12-16 11:19:06.134454"], ["updated_at", "2017-12-16 11:19:06.134454"]]
   (0.5ms)  commit transaction
   (0.0ms)  begin transaction
  SQL (0.1ms)  INSERT INTO "sequenced_items" ("title", "sequence", "created_at", "updated_at") VALUES (?, ?, ?, ?)  [["title", "OtherTitle5"], ["sequence", 5], ["created_at", "2017-12-16 11:19:06.136026"], ["updated_at", "2017-12-16 11:19:06.136026"]]
   (0.7ms)  commit transaction
   (0.0ms)  begin transaction
  SQL (0.2ms)  INSERT INTO "sequenced_items" ("title", "sequence", "created_at", "updated_at") VALUES (?, ?, ?, ?)  [["title", "OtherTitle6"], ["sequence", 6], ["created_at", "2017-12-16 11:19:06.137901"], ["updated_at", "2017-12-16 11:19:06.137901"]]
   (0.5ms)  commit transaction
   (0.0ms)  begin transaction
  SQL (0.2ms)  INSERT INTO "sequenced_items" ("title", "sequence", "created_at", "updated_at") VALUES (?, ?, ?, ?)  [["title", "OtherTitle7"], ["sequence", 7], ["created_at", "2017-12-16 11:19:06.139493"], ["updated_at", "2017-12-16 11:19:06.139493"]]
   (0.6ms)  commit transaction
   (0.0ms)  begin transaction
  SQL (0.2ms)  INSERT INTO "sequenced_items" ("title", "sequence", "created_at", "updated_at") VALUES (?, ?, ?, ?)  [["title", "OtherTitle8"], ["sequence", 8], ["created_at", "2017-12-16 11:19:06.141010"], ["updated_at", "2017-12-16 11:19:06.141010"]]
   (0.7ms)  commit transaction
   (0.0ms)  begin transaction
  SQL (0.2ms)  INSERT INTO "sequenced_items" ("title", "sequence", "created_at", "updated_at") VALUES (?, ?, ?, ?)  [["title", "OtherTitle9"], ["sequence", 9], ["created_at", "2017-12-16 11:19:06.142828"], ["updated_at", "2017-12-16 11:19:06.142828"]]
   (0.7ms)  commit transaction
Started GET "/items" for ::1 at 2017-12-16 20:19:08 +0900
Processing by ItemsController#index as HTML
  Rendering items/index.html.erb within layouts/application
  Item Load (0.2ms)  SELECT "items".* FROM "items" ORDER BY "items"."sort" ASC
  Rendered items/index.html.erb within layouts/application (8.3ms)
Completed 200 OK in 43ms (Views: 41.0ms | ActiveRecord: 0.4ms)


Started POST "/sortable/reorder" for ::1 at 2017-12-16 20:19:13 +0900
Processing by SortableController#reorder as */*
  Parameters: {"Item"=>["7", "1", "2", "3", "4", "5", "6", "8", "9", "10"]}
  Item Load (0.3ms)  SELECT "items".* FROM "items" ORDER BY "items"."sort" ASC
   (0.0ms)  begin transaction
  SQL (0.3ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 0], ["updated_at", "2017-12-16 11:19:13.054219"], ["id", 7]]
   (2.4ms)  commit transaction
   (0.0ms)  begin transaction
  SQL (0.2ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 1], ["updated_at", "2017-12-16 11:19:13.058739"], ["id", 1]]
   (1.0ms)  commit transaction
   (0.0ms)  begin transaction
  SQL (0.2ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 2], ["updated_at", "2017-12-16 11:19:13.061379"], ["id", 2]]
   (0.7ms)  commit transaction
   (0.0ms)  begin transaction
  SQL (0.2ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 3], ["updated_at", "2017-12-16 11:19:13.063859"], ["id", 3]]
   (0.6ms)  commit transaction
   (0.0ms)  begin transaction
  SQL (0.2ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 4], ["updated_at", "2017-12-16 11:19:13.065814"], ["id", 4]]
   (1.1ms)  commit transaction
   (0.1ms)  begin transaction
  SQL (0.2ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 5], ["updated_at", "2017-12-16 11:19:13.068752"], ["id", 5]]
   (0.6ms)  commit transaction
   (0.0ms)  begin transaction
  SQL (0.2ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 6], ["updated_at", "2017-12-16 11:19:13.070912"], ["id", 6]]
   (0.7ms)  commit transaction
Completed 200 OK in 21ms (ActiveRecord: 9.4ms)


Started POST "/sortable/reorder" for ::1 at 2017-12-16 20:19:15 +0900
Processing by SortableController#reorder as */*
  Parameters: {"Item"=>["7", "4", "1", "2", "3", "5", "6", "8", "9", "10"]}
  Item Load (0.2ms)  SELECT "items".* FROM "items" ORDER BY "items"."sort" ASC
   (0.0ms)  begin transaction
  SQL (0.2ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 1], ["updated_at", "2017-12-16 11:19:15.208316"], ["id", 4]]
   (2.1ms)  commit transaction
   (0.0ms)  begin transaction
  SQL (0.2ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 2], ["updated_at", "2017-12-16 11:19:15.212156"], ["id", 1]]
   (0.5ms)  commit transaction
   (0.0ms)  begin transaction
  SQL (0.2ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 3], ["updated_at", "2017-12-16 11:19:15.214347"], ["id", 2]]
   (0.8ms)  commit transaction
   (0.0ms)  begin transaction
  SQL (0.2ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 4], ["updated_at", "2017-12-16 11:19:15.216508"], ["id", 3]]
   (0.6ms)  commit transaction
Completed 200 OK in 12ms (ActiveRecord: 5.3ms)


Started GET "/items" for ::1 at 2017-12-16 20:19:18 +0900
Processing by ItemsController#index as HTML
  Rendering items/index.html.erb within layouts/application
  Item Load (0.5ms)  SELECT "items".* FROM "items" ORDER BY "items"."sort" ASC
  Rendered items/index.html.erb within layouts/application (3.6ms)
Completed 200 OK in 29ms (Views: 26.7ms | ActiveRecord: 0.5ms)


Started GET "/" for ::1 at 2018-02-16 16:25:09 +0900
   (0.1ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" ORDER BY "schema_migrations"."version" ASC
Processing by Rails::WelcomeController#index as HTML
  Rendering /Users/madmax/Programs/itmammoth/rails_sortable/vendor/bundle/ruby/2.5.0/gems/railties-5.1.4/lib/rails/templates/rails/welcome/index.html.erb
  Rendered /Users/madmax/Programs/itmammoth/rails_sortable/vendor/bundle/ruby/2.5.0/gems/railties-5.1.4/lib/rails/templates/rails/welcome/index.html.erb (2.9ms)
Completed 200 OK in 9ms (Views: 7.2ms | ActiveRecord: 0.0ms)


Started GET "/items" for ::1 at 2018-02-16 16:25:13 +0900
Processing by ItemsController#index as HTML
  Rendering items/index.html.erb within layouts/application
  Item Load (0.2ms)  SELECT "items".* FROM "items" ORDER BY "items"."sort" ASC
  Rendered items/index.html.erb within layouts/application (8.1ms)
Completed 200 OK in 357ms (Views: 351.4ms | ActiveRecord: 0.6ms)


Started GET "/assets/scaffold.self-83b741db49389dc7cfdf85bf7537a0219cce48e085c4116afc83d55c9af47c78.css?body=1" for ::1 at 2018-02-16 16:25:13 +0900
Started GET "/assets/application.self-f9e7c1541e1b8783561468c59162bd896007380f5a3799ef2169d3a3fdf40bed.css?body=1" for ::1 at 2018-02-16 16:25:13 +0900
Started GET "/assets/jquery.self-bd7ddd393353a8d2480a622e80342adf488fb6006d667e8b42e4c0073393abee.js?body=1" for ::1 at 2018-02-16 16:25:13 +0900
Started GET "/assets/jquery_ujs.self-784a997f6726036b1993eb2217c9cb558e1cbb801c6da88105588c56f13b466a.js?body=1" for ::1 at 2018-02-16 16:25:13 +0900
Started GET "/assets/jquery-ui/version.self-c8e3d1203da26ea7efdf83c1eabb3f0ba55cb68e463f5ccf0d77bd15ce6a8e61.js?body=1" for ::1 at 2018-02-16 16:25:13 +0900
Started GET "/assets/jquery-ui/ie.self-163eb039dcb1e0c3471b7d91386eabb8753da6906e84824c019f9ff56bdb83a6.js?body=1" for ::1 at 2018-02-16 16:25:13 +0900
Started GET "/assets/jquery-ui/widget.self-fca20bcec06d192f97cffa6e734e24360e227237b8ae7d7e7e60754df7d5444f.js?body=1" for ::1 at 2018-02-16 16:25:13 +0900
Started GET "/assets/jquery-ui/widgets/mouse.self-f0790a202dcf54fab051e71b042335d5346f9cceb0f645223c1dab93f349a04b.js?body=1" for ::1 at 2018-02-16 16:25:13 +0900
Started GET "/assets/jquery-ui/data.self-2067c82e6fe39a9cba5623206a5dc28d5c60d26b95cd100855b78cacf72865b8.js?body=1" for ::1 at 2018-02-16 16:25:13 +0900
Started GET "/assets/jquery-ui/scroll-parent.self-38e26a71a450a29fb63425e8f589a7046862f927eb0a1dbf6a6c44da05196d2e.js?body=1" for ::1 at 2018-02-16 16:25:13 +0900
Started GET "/assets/jquery-ui/widgets/sortable.self-6e5e1f07a29b5a89ec1d359363d2800904e3ae548a38ab2f8eded36746d1adbe.js?body=1" for ::1 at 2018-02-16 16:25:13 +0900
Started GET "/assets/plugin.self-84bdbacb1efd558ee0dac9e9a39c3f2acc7a75ef4b01112739eec325ddfa2429.js?body=1" for ::1 at 2018-02-16 16:25:14 +0900
Started GET "/assets/rails_sortable.self-e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855.js?body=1" for ::1 at 2018-02-16 16:25:14 +0900
Started GET "/assets/items.self-3f5ee897a5a4a74ee2d01575104d7e38daf09a55678ea0eec89cd57028db5471.js?body=1" for ::1 at 2018-02-16 16:25:14 +0900
Started GET "/assets/sequenced_items.self-3f5ee897a5a4a74ee2d01575104d7e38daf09a55678ea0eec89cd57028db5471.js?body=1" for ::1 at 2018-02-16 16:25:14 +0900
Started GET "/assets/application.self-120f3cf1cb67bea53c4a2a57336b34ca04b04b55a55c38cf76ce20a147e5eff9.js?body=1" for ::1 at 2018-02-16 16:25:14 +0900
Started POST "/sortable/reorder" for ::1 at 2018-02-16 16:25:19 +0900
Processing by SortableController#reorder as */*
  Parameters: {"Item"=>["1", "7", "4", "2", "3", "5", "6", "8", "9", "10"]}
  Item Load (0.3ms)  SELECT "items".* FROM "items" WHERE "items"."id" IN (1, 7, 4, 2, 3, 5, 6, 8, 9, 10) ORDER BY "items"."sort" ASC
   (0.0ms)  begin transaction
  SQL (0.5ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 0], ["updated_at", "2018-02-16 07:25:19.400928"], ["id", 1]]
   (1.8ms)  commit transaction
   (0.0ms)  begin transaction
  SQL (0.2ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 1], ["updated_at", "2018-02-16 07:25:19.404795"], ["id", 7]]
   (1.0ms)  commit transaction
   (0.1ms)  begin transaction
  SQL (0.3ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 2], ["updated_at", "2018-02-16 07:25:19.407208"], ["id", 4]]
   (1.2ms)  commit transaction
Completed 200 OK in 11ms (ActiveRecord: 5.4ms)


Started POST "/sortable/reorder" for ::1 at 2018-02-16 16:25:22 +0900
Processing by SortableController#reorder as */*
  Parameters: {"Item"=>["1", "2", "7", "4", "3", "5", "6", "8", "9", "10"]}
  Item Load (0.2ms)  SELECT "items".* FROM "items" WHERE "items"."id" IN (1, 2, 7, 4, 3, 5, 6, 8, 9, 10) ORDER BY "items"."sort" ASC
   (0.0ms)  begin transaction
  SQL (0.3ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 1], ["updated_at", "2018-02-16 07:25:22.215357"], ["id", 2]]
   (0.7ms)  commit transaction
   (0.1ms)  begin transaction
  SQL (0.4ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 2], ["updated_at", "2018-02-16 07:25:22.217623"], ["id", 7]]
   (0.6ms)  commit transaction
   (0.0ms)  begin transaction
  SQL (0.2ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 3], ["updated_at", "2018-02-16 07:25:22.219932"], ["id", 4]]
   (1.0ms)  commit transaction
Completed 200 OK in 8ms (ActiveRecord: 3.6ms)


Started POST "/sortable/reorder" for ::1 at 2018-02-16 16:25:24 +0900
Processing by SortableController#reorder as */*
  Parameters: {"Item"=>["1", "2", "3", "7", "4", "5", "6", "8", "9", "10"]}
  Item Load (0.2ms)  SELECT "items".* FROM "items" WHERE "items"."id" IN (1, 2, 3, 7, 4, 5, 6, 8, 9, 10) ORDER BY "items"."sort" ASC
   (0.0ms)  begin transaction
  SQL (0.2ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 2], ["updated_at", "2018-02-16 07:25:24.042044"], ["id", 3]]
   (2.3ms)  commit transaction
   (0.1ms)  begin transaction
  SQL (0.3ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 3], ["updated_at", "2018-02-16 07:25:24.046020"], ["id", 7]]
   (0.9ms)  commit transaction
   (0.1ms)  begin transaction
  SQL (0.5ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 4], ["updated_at", "2018-02-16 07:25:24.048729"], ["id", 4]]
   (0.8ms)  commit transaction
Completed 200 OK in 11ms (ActiveRecord: 5.5ms)


Started POST "/sortable/reorder" for ::1 at 2018-02-16 16:25:25 +0900
Processing by SortableController#reorder as */*
  Parameters: {"Item"=>["1", "2", "3", "4", "7", "5", "6", "8", "9", "10"]}
  Item Load (0.2ms)  SELECT "items".* FROM "items" WHERE "items"."id" IN (1, 2, 3, 4, 7, 5, 6, 8, 9, 10) ORDER BY "items"."sort" ASC
   (0.0ms)  begin transaction
  SQL (0.2ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 3], ["updated_at", "2018-02-16 07:25:25.222388"], ["id", 4]]
   (2.1ms)  commit transaction
   (0.1ms)  begin transaction
  SQL (0.3ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 4], ["updated_at", "2018-02-16 07:25:25.225974"], ["id", 7]]
   (0.8ms)  commit transaction
Completed 200 OK in 7ms (ActiveRecord: 3.7ms)


Started POST "/sortable/reorder" for ::1 at 2018-02-16 16:25:26 +0900
Processing by SortableController#reorder as */*
  Parameters: {"Item"=>["1", "2", "3", "4", "5", "7", "6", "8", "9", "10"]}
  Item Load (0.2ms)  SELECT "items".* FROM "items" WHERE "items"."id" IN (1, 2, 3, 4, 5, 7, 6, 8, 9, 10) ORDER BY "items"."sort" ASC
   (0.0ms)  begin transaction
  SQL (0.3ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 4], ["updated_at", "2018-02-16 07:25:26.345063"], ["id", 5]]
   (2.2ms)  commit transaction
   (0.1ms)  begin transaction
  SQL (0.3ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 5], ["updated_at", "2018-02-16 07:25:26.348864"], ["id", 7]]
   (0.7ms)  commit transaction
Completed 200 OK in 8ms (ActiveRecord: 3.8ms)


Started POST "/sortable/reorder" for ::1 at 2018-02-16 16:25:27 +0900
Processing by SortableController#reorder as */*
  Parameters: {"Item"=>["1", "2", "3", "4", "5", "6", "7", "8", "9", "10"]}
  Item Load (0.3ms)  SELECT "items".* FROM "items" WHERE "items"."id" IN (1, 2, 3, 4, 5, 6, 7, 8, 9, 10) ORDER BY "items"."sort" ASC
   (0.1ms)  begin transaction
  SQL (0.3ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 5], ["updated_at", "2018-02-16 07:25:27.472665"], ["id", 6]]
   (2.4ms)  commit transaction
   (0.1ms)  begin transaction
  SQL (0.3ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 6], ["updated_at", "2018-02-16 07:25:27.476698"], ["id", 7]]
   (1.1ms)  commit transaction
Completed 200 OK in 9ms (ActiveRecord: 4.4ms)


Started GET "/items" for ::1 at 2018-02-16 16:25:30 +0900
Processing by ItemsController#index as HTML
  Rendering items/index.html.erb within layouts/application
  Item Load (0.2ms)  SELECT "items".* FROM "items" ORDER BY "items"."sort" ASC
  Rendered items/index.html.erb within layouts/application (2.8ms)
Completed 200 OK in 23ms (Views: 20.9ms | ActiveRecord: 0.2ms)