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)


Started GET "/" for ::1 at 2018-03-17 18:58:47 +0900
   (0.8ms)  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 (4.1ms)
Completed 200 OK in 23ms (Views: 12.2ms | ActiveRecord: 0.0ms)


Started GET "/items" for ::1 at 2018-03-17 18:58:52 +0900
Processing by ItemsController#index as HTML
  Rendering items/index.html.erb within layouts/application
  Item Load (0.8ms)  SELECT "items".* FROM "items" ORDER BY "items"."sort" ASC
  Rendered items/index.html.erb within layouts/application (8.7ms)
Completed 200 OK in 332ms (Views: 326.8ms | ActiveRecord: 1.2ms)


Started GET "/assets/application.self-f9e7c1541e1b8783561468c59162bd896007380f5a3799ef2169d3a3fdf40bed.css?body=1" for ::1 at 2018-03-17 18:58:52 +0900
Started GET "/assets/scaffold.self-83b741db49389dc7cfdf85bf7537a0219cce48e085c4116afc83d55c9af47c78.css?body=1" for ::1 at 2018-03-17 18:58:52 +0900
Started GET "/assets/jquery.self-bd7ddd393353a8d2480a622e80342adf488fb6006d667e8b42e4c0073393abee.js?body=1" for ::1 at 2018-03-17 18:58:53 +0900
Started GET "/assets/jquery_ujs.self-784a997f6726036b1993eb2217c9cb558e1cbb801c6da88105588c56f13b466a.js?body=1" for ::1 at 2018-03-17 18:58:53 +0900
Started GET "/assets/jquery-ui/version.self-c8e3d1203da26ea7efdf83c1eabb3f0ba55cb68e463f5ccf0d77bd15ce6a8e61.js?body=1" for ::1 at 2018-03-17 18:58:53 +0900
Started GET "/assets/jquery-ui/ie.self-163eb039dcb1e0c3471b7d91386eabb8753da6906e84824c019f9ff56bdb83a6.js?body=1" for ::1 at 2018-03-17 18:58:53 +0900
Started GET "/assets/jquery-ui/widget.self-fca20bcec06d192f97cffa6e734e24360e227237b8ae7d7e7e60754df7d5444f.js?body=1" for ::1 at 2018-03-17 18:58:53 +0900
Started GET "/assets/jquery-ui/widgets/mouse.self-f0790a202dcf54fab051e71b042335d5346f9cceb0f645223c1dab93f349a04b.js?body=1" for ::1 at 2018-03-17 18:58:53 +0900
Started GET "/assets/jquery-ui/data.self-2067c82e6fe39a9cba5623206a5dc28d5c60d26b95cd100855b78cacf72865b8.js?body=1" for ::1 at 2018-03-17 18:58:53 +0900
Started GET "/assets/jquery-ui/scroll-parent.self-38e26a71a450a29fb63425e8f589a7046862f927eb0a1dbf6a6c44da05196d2e.js?body=1" for ::1 at 2018-03-17 18:58:53 +0900
Started GET "/assets/jquery-ui/widgets/sortable.self-6e5e1f07a29b5a89ec1d359363d2800904e3ae548a38ab2f8eded36746d1adbe.js?body=1" for ::1 at 2018-03-17 18:58:53 +0900
Started GET "/assets/items.self-3f5ee897a5a4a74ee2d01575104d7e38daf09a55678ea0eec89cd57028db5471.js?body=1" for ::1 at 2018-03-17 18:58:53 +0900
Started GET "/assets/sequenced_items.self-3f5ee897a5a4a74ee2d01575104d7e38daf09a55678ea0eec89cd57028db5471.js?body=1" for ::1 at 2018-03-17 18:58:53 +0900
Started GET "/assets/rails_sortable.self-e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855.js?body=1" for ::1 at 2018-03-17 18:58:53 +0900
Started GET "/assets/application.self-120f3cf1cb67bea53c4a2a57336b34ca04b04b55a55c38cf76ce20a147e5eff9.js?body=1" for ::1 at 2018-03-17 18:58:53 +0900
Started GET "/assets/plugin.self-8211650e7f8610773fba42d71443e831b2895bd3d41e63d220f0d8cf3ada1e96.js?body=1" for ::1 at 2018-03-17 18:58:53 +0900
Started GET "/items" for ::1 at 2018-03-17 18:58:57 +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 (2.5ms)
Completed 200 OK in 23ms (Views: 20.9ms | ActiveRecord: 0.1ms)


Started GET "/items" for ::1 at 2018-03-17 18:59:19 +0900
Processing by ItemsController#index as HTML
  Rendering items/index.html.erb within layouts/application
  Item Load (0.3ms)  SELECT "items".* FROM "items" ORDER BY "items"."sort" ASC
  Rendered items/index.html.erb within layouts/application (2.9ms)
Completed 200 OK in 22ms (Views: 20.1ms | ActiveRecord: 0.3ms)


Started GET "/items" for ::1 at 2018-03-17 19:01:51 +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 (2.6ms)
Completed 200 OK in 76ms (Views: 74.4ms | ActiveRecord: 0.1ms)


Started GET "/assets/plugin.self-7a7940dd15ae98b294e8ed7a98aacaefdeeb2e759677094bcca792cd40f4d826.js?body=1" for ::1 at 2018-03-17 19:01:51 +0900
Started POST "/sortable/reorder" for ::1 at 2018-03-17 19:01:53 +0900
Processing by SortableController#reorder as */*
  Parameters: {"Item"=>["10", "1", "2", "3", "4", "5", "6", "7", "8", "9"]}
   (0.1ms)  begin transaction
  Item Load (0.2ms)  SELECT "items".* FROM "items" WHERE "items"."id" IN (10, 1, 2, 3, 4, 5, 6, 7, 8, 9) ORDER BY "items"."sort" ASC
  SQL (0.3ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 0], ["updated_at", "2018-03-17 10:01:53.495214"], ["id", 10]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 1], ["updated_at", "2018-03-17 10:01:53.496320"], ["id", 1]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 2], ["updated_at", "2018-03-17 10:01:53.497046"], ["id", 2]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 3], ["updated_at", "2018-03-17 10:01:53.497692"], ["id", 3]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 4], ["updated_at", "2018-03-17 10:01:53.498306"], ["id", 4]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 5], ["updated_at", "2018-03-17 10:01:53.498857"], ["id", 5]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 6], ["updated_at", "2018-03-17 10:01:53.499491"], ["id", 6]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 7], ["updated_at", "2018-03-17 10:01:53.500096"], ["id", 7]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 8], ["updated_at", "2018-03-17 10:01:53.500692"], ["id", 8]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 9], ["updated_at", "2018-03-17 10:01:53.501260"], ["id", 9]]
   (2.3ms)  commit transaction
Completed 200 OK in 11ms (ActiveRecord: 3.5ms)


Started GET "/items" for ::1 at 2018-03-17 19:01:55 +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 27ms (Views: 24.5ms | ActiveRecord: 0.2ms)


Started POST "/sortable/reorder" for ::1 at 2018-03-17 19:01:57 +0900
Processing by SortableController#reorder as */*
  Parameters: {"Item"=>["1", "2", "3", "4", "5", "6", "7", "8", "9", "10"]}
   (0.0ms)  begin transaction
  Item Load (0.2ms)  SELECT "items".* FROM "items" WHERE "items"."id" IN (1, 2, 3, 4, 5, 6, 7, 8, 9, 10) ORDER BY "items"."sort" ASC
  SQL (0.2ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 0], ["updated_at", "2018-03-17 10:01:57.585751"], ["id", 1]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 1], ["updated_at", "2018-03-17 10:01:57.586675"], ["id", 2]]
  SQL (0.0ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 2], ["updated_at", "2018-03-17 10:01:57.587286"], ["id", 3]]
  SQL (0.0ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 3], ["updated_at", "2018-03-17 10:01:57.587880"], ["id", 4]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 4], ["updated_at", "2018-03-17 10:01:57.588502"], ["id", 5]]
  SQL (0.0ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 5], ["updated_at", "2018-03-17 10:01:57.589078"], ["id", 6]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 6], ["updated_at", "2018-03-17 10:01:57.589698"], ["id", 7]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 7], ["updated_at", "2018-03-17 10:01:57.590506"], ["id", 8]]
  SQL (0.0ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 8], ["updated_at", "2018-03-17 10:01:57.591147"], ["id", 9]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 9], ["updated_at", "2018-03-17 10:01:57.591876"], ["id", 10]]
   (1.5ms)  commit transaction
Completed 200 OK in 10ms (ActiveRecord: 2.5ms)


Started GET "/items" for ::1 at 2018-03-17 19:01:58 +0900
Processing by ItemsController#index as HTML
  Rendering items/index.html.erb within layouts/application
  Item Load (0.3ms)  SELECT "items".* FROM "items" ORDER BY "items"."sort" ASC
  Rendered items/index.html.erb within layouts/application (4.1ms)
Completed 200 OK in 28ms (Views: 26.0ms | ActiveRecord: 0.3ms)


Started GET "/items" for ::1 at 2018-03-17 19:06: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 (4.2ms)
Completed 200 OK in 89ms (Views: 86.9ms | ActiveRecord: 0.2ms)


Started GET "/assets/items.self-f1e606000df03307b2de9da3ca82afc5b543b105855f946d80d57dc8caa6c7e4.js?body=1" for ::1 at 2018-03-17 19:06:13 +0900
Started POST "/sortable/reorder" for ::1 at 2018-03-17 19:06:17 +0900
Processing by SortableController#reorder as */*
  Parameters: {"Item"=>["10", "1", "2", "3", "4", "5", "6", "7", "8", "9"]}
   (0.0ms)  begin transaction
  Item Load (0.1ms)  SELECT "items".* FROM "items" WHERE "items"."id" IN (10, 1, 2, 3, 4, 5, 6, 7, 8, 9) ORDER BY "items"."sort" ASC
  SQL (0.2ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 0], ["updated_at", "2018-03-17 10:06:17.609816"], ["id", 10]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 1], ["updated_at", "2018-03-17 10:06:17.613391"], ["id", 1]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 2], ["updated_at", "2018-03-17 10:06:17.614156"], ["id", 2]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 3], ["updated_at", "2018-03-17 10:06:17.614784"], ["id", 3]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 4], ["updated_at", "2018-03-17 10:06:17.615434"], ["id", 4]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 5], ["updated_at", "2018-03-17 10:06:17.616472"], ["id", 5]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 6], ["updated_at", "2018-03-17 10:06:17.617155"], ["id", 6]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 7], ["updated_at", "2018-03-17 10:06:17.617899"], ["id", 7]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 8], ["updated_at", "2018-03-17 10:06:17.618858"], ["id", 8]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 9], ["updated_at", "2018-03-17 10:06:17.620220"], ["id", 9]]
   (1.8ms)  commit transaction
Completed 200 OK in 15ms (ActiveRecord: 2.9ms)


Started GET "/items" for ::1 at 2018-03-17 19:06:28 +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.9ms)
Completed 200 OK in 28ms (Views: 26.7ms | ActiveRecord: 0.2ms)


Started POST "/sortable/reorder" for ::1 at 2018-03-17 19:06:32 +0900
Processing by SortableController#reorder as */*
  Parameters: {"Item"=>["9", "10", "1", "2", "3", "4", "5", "6", "7", "8"]}
   (0.0ms)  begin transaction
  Item Load (0.2ms)  SELECT "items".* FROM "items" WHERE "items"."id" IN (9, 10, 1, 2, 3, 4, 5, 6, 7, 8) ORDER BY "items"."sort" ASC
  SQL (0.3ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 0], ["updated_at", "2018-03-17 10:06:32.583754"], ["id", 9]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 1], ["updated_at", "2018-03-17 10:06:32.584636"], ["id", 10]]
  SQL (0.0ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 2], ["updated_at", "2018-03-17 10:06:32.585183"], ["id", 1]]
  SQL (0.0ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 3], ["updated_at", "2018-03-17 10:06:32.585803"], ["id", 2]]
  SQL (0.0ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 4], ["updated_at", "2018-03-17 10:06:32.586312"], ["id", 3]]
  SQL (0.0ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 5], ["updated_at", "2018-03-17 10:06:32.586929"], ["id", 4]]
  SQL (0.0ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 6], ["updated_at", "2018-03-17 10:06:32.587609"], ["id", 5]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 7], ["updated_at", "2018-03-17 10:06:32.588153"], ["id", 6]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 8], ["updated_at", "2018-03-17 10:06:32.588867"], ["id", 7]]
  SQL (0.2ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 9], ["updated_at", "2018-03-17 10:06:32.589673"], ["id", 8]]
   (2.0ms)  commit transaction
Completed 200 OK in 11ms (ActiveRecord: 3.1ms)


Started POST "/sortable/reorder" for ::1 at 2018-03-17 19:06:35 +0900
Processing by SortableController#reorder as */*
  Parameters: {"Item"=>["9", "1", "2", "3", "4", "5", "6", "7", "8", "10"]}
   (0.0ms)  begin transaction
  Item Load (0.2ms)  SELECT "items".* FROM "items" WHERE "items"."id" IN (9, 1, 2, 3, 4, 5, 6, 7, 8, 10) ORDER BY "items"."sort" ASC
  SQL (0.2ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 1], ["updated_at", "2018-03-17 10:06:35.099201"], ["id", 1]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 2], ["updated_at", "2018-03-17 10:06:35.100143"], ["id", 2]]
  SQL (0.0ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 3], ["updated_at", "2018-03-17 10:06:35.100806"], ["id", 3]]
  SQL (0.3ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 4], ["updated_at", "2018-03-17 10:06:35.101529"], ["id", 4]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 5], ["updated_at", "2018-03-17 10:06:35.102770"], ["id", 5]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 6], ["updated_at", "2018-03-17 10:06:35.103453"], ["id", 6]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 7], ["updated_at", "2018-03-17 10:06:35.104200"], ["id", 7]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 8], ["updated_at", "2018-03-17 10:06:35.105171"], ["id", 8]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 9], ["updated_at", "2018-03-17 10:06:35.105945"], ["id", 10]]
   (2.0ms)  commit transaction
Completed 200 OK in 12ms (ActiveRecord: 3.2ms)


Started POST "/sortable/reorder" for ::1 at 2018-03-17 19:06:37 +0900
Processing by SortableController#reorder as */*
  Parameters: {"Item"=>["1", "2", "3", "4", "5", "6", "7", "8", "9", "10"]}
   (0.1ms)  begin transaction
  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
  SQL (0.3ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 0], ["updated_at", "2018-03-17 10:06:37.343502"], ["id", 1]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 1], ["updated_at", "2018-03-17 10:06:37.344676"], ["id", 2]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 2], ["updated_at", "2018-03-17 10:06:37.345538"], ["id", 3]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 3], ["updated_at", "2018-03-17 10:06:37.346163"], ["id", 4]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 4], ["updated_at", "2018-03-17 10:06:37.346895"], ["id", 5]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 5], ["updated_at", "2018-03-17 10:06:37.347579"], ["id", 6]]
  SQL (0.0ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 6], ["updated_at", "2018-03-17 10:06:37.348293"], ["id", 7]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 7], ["updated_at", "2018-03-17 10:06:37.349097"], ["id", 8]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 8], ["updated_at", "2018-03-17 10:06:37.350112"], ["id", 9]]
   (1.9ms)  commit transaction
Completed 200 OK in 13ms (ActiveRecord: 3.1ms)


Started POST "/sortable/reorder" for ::1 at 2018-03-17 19:06:59 +0900
Processing by SortableController#reorder as */*
  Parameters: {"Item"=>["10", "1", "2", "3", "4", "5", "6", "7", "8", "9"]}
   (0.1ms)  begin transaction
  Item Load (0.2ms)  SELECT "items".* FROM "items" WHERE "items"."id" IN (10, 1, 2, 3, 4, 5, 6, 7, 8, 9) ORDER BY "items"."sort" ASC
  SQL (0.2ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 0], ["updated_at", "2018-03-17 10:06:59.561736"], ["id", 10]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 1], ["updated_at", "2018-03-17 10:06:59.563014"], ["id", 1]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 2], ["updated_at", "2018-03-17 10:06:59.564008"], ["id", 2]]
  SQL (0.3ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 3], ["updated_at", "2018-03-17 10:06:59.564609"], ["id", 3]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 4], ["updated_at", "2018-03-17 10:06:59.566180"], ["id", 4]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 5], ["updated_at", "2018-03-17 10:06:59.567194"], ["id", 5]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 6], ["updated_at", "2018-03-17 10:06:59.568103"], ["id", 6]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 7], ["updated_at", "2018-03-17 10:06:59.568830"], ["id", 7]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 8], ["updated_at", "2018-03-17 10:06:59.569376"], ["id", 8]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 9], ["updated_at", "2018-03-17 10:06:59.570125"], ["id", 9]]
   (2.1ms)  commit transaction
Completed 200 OK in 14ms (ActiveRecord: 3.5ms)


Started POST "/sortable/reorder" for ::1 at 2018-03-17 19:07:01 +0900
Processing by SortableController#reorder as */*
  Parameters: {"Item"=>["1", "2", "3", "4", "5", "6", "7", "8", "9", "10"]}
   (0.0ms)  begin transaction
  Item Load (0.2ms)  SELECT "items".* FROM "items" WHERE "items"."id" IN (1, 2, 3, 4, 5, 6, 7, 8, 9, 10) ORDER BY "items"."sort" ASC
  SQL (0.2ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 0], ["updated_at", "2018-03-17 10:07:01.013207"], ["id", 1]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 1], ["updated_at", "2018-03-17 10:07:01.014302"], ["id", 2]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 2], ["updated_at", "2018-03-17 10:07:01.015271"], ["id", 3]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 3], ["updated_at", "2018-03-17 10:07:01.015973"], ["id", 4]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 4], ["updated_at", "2018-03-17 10:07:01.017004"], ["id", 5]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 5], ["updated_at", "2018-03-17 10:07:01.018026"], ["id", 6]]
  SQL (0.2ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 6], ["updated_at", "2018-03-17 10:07:01.018818"], ["id", 7]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 7], ["updated_at", "2018-03-17 10:07:01.019624"], ["id", 8]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 8], ["updated_at", "2018-03-17 10:07:01.020184"], ["id", 9]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 9], ["updated_at", "2018-03-17 10:07:01.020960"], ["id", 10]]
   (2.4ms)  commit transaction
Completed 200 OK in 13ms (ActiveRecord: 3.6ms)


Started POST "/sortable/reorder" for ::1 at 2018-03-17 19:07:29 +0900
Processing by SortableController#reorder as */*
  Parameters: {"Item"=>["2", "3", "4", "5", "6", "7", "8", "9", "10", "1"]}
   (0.0ms)  begin transaction
  Item Load (0.2ms)  SELECT "items".* FROM "items" WHERE "items"."id" IN (2, 3, 4, 5, 6, 7, 8, 9, 10, 1) ORDER BY "items"."sort" ASC
  SQL (0.6ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 0], ["updated_at", "2018-03-17 10:07:29.464922"], ["id", 2]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 1], ["updated_at", "2018-03-17 10:07:29.466483"], ["id", 3]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 2], ["updated_at", "2018-03-17 10:07:29.467274"], ["id", 4]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 3], ["updated_at", "2018-03-17 10:07:29.468049"], ["id", 5]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 4], ["updated_at", "2018-03-17 10:07:29.468744"], ["id", 6]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 5], ["updated_at", "2018-03-17 10:07:29.469641"], ["id", 7]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 6], ["updated_at", "2018-03-17 10:07:29.470740"], ["id", 8]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 7], ["updated_at", "2018-03-17 10:07:29.471806"], ["id", 9]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 8], ["updated_at", "2018-03-17 10:07:29.473110"], ["id", 10]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 9], ["updated_at", "2018-03-17 10:07:29.474792"], ["id", 1]]
   (1.2ms)  commit transaction
Completed 200 OK in 15ms (ActiveRecord: 2.9ms)


Started POST "/sortable/reorder" for ::1 at 2018-03-17 19:07:53 +0900
Started GET "/items" for ::1 at 2018-03-17 19:07:53 +0900
Processing by SortableController#reorder as */*
  Parameters: {"Item"=>["3", "4", "5", "6", "2", "7", "8", "9", "10", "1"]}
   (0.1ms)  begin transaction
  Item Load (0.2ms)  SELECT "items".* FROM "items" WHERE "items"."id" IN (3, 4, 5, 6, 2, 7, 8, 9, 10, 1) ORDER BY "items"."sort" ASC
Processing by ItemsController#index as HTML
  SQL (0.3ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 0], ["updated_at", "2018-03-17 10:07:53.400683"], ["id", 3]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 1], ["updated_at", "2018-03-17 10:07:53.403642"], ["id", 4]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 2], ["updated_at", "2018-03-17 10:07:53.407376"], ["id", 5]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 3], ["updated_at", "2018-03-17 10:07:53.409154"], ["id", 6]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 4], ["updated_at", "2018-03-17 10:07:53.410447"], ["id", 2]]
   (2.3ms)  commit transaction
Completed 200 OK in 19ms (ActiveRecord: 3.3ms)


  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 (5.3ms)
Completed 200 OK in 51ms (Views: 47.4ms | ActiveRecord: 0.2ms)


Started POST "/sortable/reorder" for ::1 at 2018-03-17 19:08:57 +0900
Processing by SortableController#reorder as */*
  Parameters: {"Item"=>["3", "4", "1", "5", "6", "2", "7", "8", "9", "10"]}
   (0.1ms)  begin transaction
  Item Load (0.2ms)  SELECT "items".* FROM "items" WHERE "items"."id" IN (3, 4, 1, 5, 6, 2, 7, 8, 9, 10) ORDER BY "items"."sort" ASC
  SQL (0.2ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 2], ["updated_at", "2018-03-17 10:08:57.395845"], ["id", 1]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 3], ["updated_at", "2018-03-17 10:08:57.396700"], ["id", 5]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 4], ["updated_at", "2018-03-17 10:08:57.397347"], ["id", 6]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 5], ["updated_at", "2018-03-17 10:08:57.397973"], ["id", 2]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 6], ["updated_at", "2018-03-17 10:08:57.398606"], ["id", 7]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 7], ["updated_at", "2018-03-17 10:08:57.399427"], ["id", 8]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 8], ["updated_at", "2018-03-17 10:08:57.400130"], ["id", 9]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 9], ["updated_at", "2018-03-17 10:08:57.400872"], ["id", 10]]
   (1.0ms)  commit transaction
Completed 200 OK in 9ms (ActiveRecord: 1.9ms)


Started GET "/items" for ::1 at 2018-03-17 19:12:35 +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.9ms)
Completed 200 OK in 27ms (Views: 24.8ms | ActiveRecord: 0.2ms)


Started GET "/items" for ::1 at 2018-03-17 19:17:04 +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.5ms)
Completed 200 OK in 74ms (Views: 71.7ms | ActiveRecord: 0.2ms)


Started GET "/assets/items.self-4876d56a4eec8584619d6908341c8bdd1b0b79e7154842816c9e4bcc3a47b0e0.js?body=1" for ::1 at 2018-03-17 19:17:04 +0900
Started GET "/assets/sequenced_items.self-2ba42af2be59a6571f66dd014ed16f1d963e37dbda043f1de2ab2cfd411c25a4.js?body=1" for ::1 at 2018-03-17 19:17:04 +0900
Started POST "/sortable/reorder" for ::1 at 2018-03-17 19:17:20 +0900
Processing by SortableController#reorder as */*
  Parameters: {"Item"=>["10", "3", "4", "1", "5", "6", "2", "7", "8", "9"]}
   (0.0ms)  begin transaction
  Item Load (0.2ms)  SELECT "items".* FROM "items" WHERE "items"."id" IN (10, 3, 4, 1, 5, 6, 2, 7, 8, 9) ORDER BY "items"."sort" ASC
  SQL (0.2ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 0], ["updated_at", "2018-03-17 10:17:20.792157"], ["id", 10]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 1], ["updated_at", "2018-03-17 10:17:20.793084"], ["id", 3]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 2], ["updated_at", "2018-03-17 10:17:20.794359"], ["id", 4]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 3], ["updated_at", "2018-03-17 10:17:20.795295"], ["id", 1]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 4], ["updated_at", "2018-03-17 10:17:20.796011"], ["id", 5]]
  SQL (0.0ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 5], ["updated_at", "2018-03-17 10:17:20.796588"], ["id", 6]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 6], ["updated_at", "2018-03-17 10:17:20.797117"], ["id", 2]]
  SQL (0.0ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 7], ["updated_at", "2018-03-17 10:17:20.797646"], ["id", 7]]
  SQL (0.0ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 8], ["updated_at", "2018-03-17 10:17:20.798177"], ["id", 8]]
  SQL (0.0ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 9], ["updated_at", "2018-03-17 10:17:20.798697"], ["id", 9]]
   (2.1ms)  commit transaction
Completed 200 OK in 11ms (ActiveRecord: 3.1ms)


Started GET "/sequenced_items" for ::1 at 2018-03-17 19:17:58 +0900
Processing by SequencedItemsController#index as HTML
  Rendering sequenced_items/index.html.erb within layouts/application
  SequencedItem Load (0.2ms)  SELECT "sequenced_items".* FROM "sequenced_items" ORDER BY "sequenced_items"."sequence" ASC
  Rendered sequenced_items/index.html.erb within layouts/application (9.9ms)
Completed 200 OK in 42ms (Views: 37.8ms | ActiveRecord: 0.6ms)


Started POST "/sortable/reorder" for ::1 at 2018-03-17 19:18:06 +0900
Processing by SortableController#reorder as */*
  Parameters: {"SequencedItem"=>["1", "10", "2", "3", "4", "5", "6", "7", "8", "9"]}
   (0.1ms)  begin transaction
  SequencedItem Load (0.2ms)  SELECT "sequenced_items".* FROM "sequenced_items" WHERE "sequenced_items"."id" IN (1, 10, 2, 3, 4, 5, 6, 7, 8, 9) ORDER BY "sequenced_items"."sequence" ASC
  SQL (0.2ms)  UPDATE "sequenced_items" SET "sequence" = ? WHERE "sequenced_items"."id" = ?  [["sequence", 1], ["id", 10]]
  SQL (0.0ms)  UPDATE "sequenced_items" SET "sequence" = ? WHERE "sequenced_items"."id" = ?  [["sequence", 2], ["id", 2]]
  SQL (0.0ms)  UPDATE "sequenced_items" SET "sequence" = ? WHERE "sequenced_items"."id" = ?  [["sequence", 3], ["id", 3]]
  SQL (0.0ms)  UPDATE "sequenced_items" SET "sequence" = ? WHERE "sequenced_items"."id" = ?  [["sequence", 4], ["id", 4]]
  SQL (0.0ms)  UPDATE "sequenced_items" SET "sequence" = ? WHERE "sequenced_items"."id" = ?  [["sequence", 5], ["id", 5]]
  SQL (0.0ms)  UPDATE "sequenced_items" SET "sequence" = ? WHERE "sequenced_items"."id" = ?  [["sequence", 6], ["id", 6]]
  SQL (0.0ms)  UPDATE "sequenced_items" SET "sequence" = ? WHERE "sequenced_items"."id" = ?  [["sequence", 7], ["id", 7]]
  SQL (0.0ms)  UPDATE "sequenced_items" SET "sequence" = ? WHERE "sequenced_items"."id" = ?  [["sequence", 8], ["id", 8]]
  SQL (0.1ms)  UPDATE "sequenced_items" SET "sequence" = ? WHERE "sequenced_items"."id" = ?  [["sequence", 9], ["id", 9]]
   (1.3ms)  commit transaction
Completed 200 OK in 9ms (ActiveRecord: 2.2ms)


Started POST "/sortable/reorder" for ::1 at 2018-03-17 19:18:11 +0900
Processing by SortableController#reorder as */*
  Parameters: {"SequencedItem"=>["10", "2", "3", "4", "5", "6", "1", "7", "8", "9"]}
   (0.0ms)  begin transaction
  SequencedItem Load (0.2ms)  SELECT "sequenced_items".* FROM "sequenced_items" WHERE "sequenced_items"."id" IN (10, 2, 3, 4, 5, 6, 1, 7, 8, 9) ORDER BY "sequenced_items"."sequence" ASC
  SQL (0.3ms)  UPDATE "sequenced_items" SET "sequence" = ? WHERE "sequenced_items"."id" = ?  [["sequence", 0], ["id", 10]]
  SQL (0.1ms)  UPDATE "sequenced_items" SET "sequence" = ? WHERE "sequenced_items"."id" = ?  [["sequence", 1], ["id", 2]]
  SQL (0.1ms)  UPDATE "sequenced_items" SET "sequence" = ? WHERE "sequenced_items"."id" = ?  [["sequence", 2], ["id", 3]]
  SQL (0.0ms)  UPDATE "sequenced_items" SET "sequence" = ? WHERE "sequenced_items"."id" = ?  [["sequence", 3], ["id", 4]]
  SQL (0.1ms)  UPDATE "sequenced_items" SET "sequence" = ? WHERE "sequenced_items"."id" = ?  [["sequence", 4], ["id", 5]]
  SQL (0.0ms)  UPDATE "sequenced_items" SET "sequence" = ? WHERE "sequenced_items"."id" = ?  [["sequence", 5], ["id", 6]]
  SQL (0.1ms)  UPDATE "sequenced_items" SET "sequence" = ? WHERE "sequenced_items"."id" = ?  [["sequence", 6], ["id", 1]]
   (2.0ms)  commit transaction
Completed 200 OK in 9ms (ActiveRecord: 2.9ms)


Started POST "/sortable/reorder" for ::1 at 2018-03-17 19:18:11 +0900
Processing by SortableController#reorder as */*
  Parameters: {"SequencedItem"=>["10", "2", "8", "3", "4", "5", "6", "1", "7", "9"]}
   (0.1ms)  begin transaction
  SequencedItem Load (0.3ms)  SELECT "sequenced_items".* FROM "sequenced_items" WHERE "sequenced_items"."id" IN (10, 2, 8, 3, 4, 5, 6, 1, 7, 9) ORDER BY "sequenced_items"."sequence" ASC
  SQL (0.3ms)  UPDATE "sequenced_items" SET "sequence" = ? WHERE "sequenced_items"."id" = ?  [["sequence", 2], ["id", 8]]
  SQL (0.1ms)  UPDATE "sequenced_items" SET "sequence" = ? WHERE "sequenced_items"."id" = ?  [["sequence", 3], ["id", 3]]
  SQL (0.1ms)  UPDATE "sequenced_items" SET "sequence" = ? WHERE "sequenced_items"."id" = ?  [["sequence", 4], ["id", 4]]
  SQL (0.1ms)  UPDATE "sequenced_items" SET "sequence" = ? WHERE "sequenced_items"."id" = ?  [["sequence", 5], ["id", 5]]
  SQL (0.1ms)  UPDATE "sequenced_items" SET "sequence" = ? WHERE "sequenced_items"."id" = ?  [["sequence", 6], ["id", 6]]
  SQL (0.1ms)  UPDATE "sequenced_items" SET "sequence" = ? WHERE "sequenced_items"."id" = ?  [["sequence", 7], ["id", 1]]
  SQL (0.1ms)  UPDATE "sequenced_items" SET "sequence" = ? WHERE "sequenced_items"."id" = ?  [["sequence", 8], ["id", 7]]
   (0.8ms)  commit transaction
Completed 200 OK in 10ms (ActiveRecord: 1.9ms)


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


Started POST "/sortable/reorder" for ::1 at 2018-03-17 19:18:19 +0900
Processing by SortableController#reorder as */*
  Parameters: {"Item"=>["10", "6", "3", "4", "1", "2", "5", "7", "8", "9"]}
   (0.1ms)  begin transaction
  Item Load (0.3ms)  SELECT "items".* FROM "items" WHERE "items"."id" IN (10, 6, 3, 4, 1, 2, 5, 7, 8, 9) ORDER BY "items"."sort" ASC
  SQL (0.4ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 1], ["updated_at", "2018-03-17 10:18:19.528446"], ["id", 6]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 2], ["updated_at", "2018-03-17 10:18:19.529833"], ["id", 3]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 3], ["updated_at", "2018-03-17 10:18:19.530873"], ["id", 4]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 4], ["updated_at", "2018-03-17 10:18:19.531836"], ["id", 1]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 5], ["updated_at", "2018-03-17 10:18:19.533013"], ["id", 2]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 6], ["updated_at", "2018-03-17 10:18:19.534034"], ["id", 5]]
   (1.1ms)  commit transaction
Completed 200 OK in 11ms (ActiveRecord: 2.4ms)


Started POST "/sortable/reorder" for ::1 at 2018-03-17 19:18:21 +0900
Processing by SortableController#reorder as */*
  Parameters: {"Item"=>["10", "6", "8", "3", "4", "1", "2", "5", "7", "9"]}
   (0.1ms)  begin transaction
  Item Load (0.3ms)  SELECT "items".* FROM "items" WHERE "items"."id" IN (10, 6, 8, 3, 4, 1, 2, 5, 7, 9) ORDER BY "items"."sort" ASC
  SQL (0.3ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 2], ["updated_at", "2018-03-17 10:18:21.466200"], ["id", 8]]
  SQL (0.2ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 3], ["updated_at", "2018-03-17 10:18:21.467459"], ["id", 3]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 4], ["updated_at", "2018-03-17 10:18:21.469185"], ["id", 4]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 5], ["updated_at", "2018-03-17 10:18:21.470458"], ["id", 1]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 6], ["updated_at", "2018-03-17 10:18:21.471583"], ["id", 2]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 7], ["updated_at", "2018-03-17 10:18:21.473373"], ["id", 5]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 8], ["updated_at", "2018-03-17 10:18:21.474581"], ["id", 7]]
   (1.9ms)  commit transaction
Completed 200 OK in 13ms (ActiveRecord: 3.3ms)


Started GET "/items" for ::1 at 2018-03-17 19:21: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 (4.2ms)
Completed 200 OK in 29ms (Views: 26.7ms | ActiveRecord: 0.2ms)


Started GET "/items" for ::1 at 2018-03-17 19:21:22 +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 (3.3ms)
Completed 200 OK in 24ms (Views: 21.6ms | ActiveRecord: 0.2ms)


Started POST "/sortable/reorder" for ::1 at 2018-03-17 19:21:27 +0900
Processing by SortableController#reorder as */*
  Parameters: {"Item"=>["9", "10", "6", "8", "3", "4", "1", "2", "5", "7"]}
   (0.1ms)  begin transaction
  Item Load (0.3ms)  SELECT "items".* FROM "items" WHERE "items"."id" IN (9, 10, 6, 8, 3, 4, 1, 2, 5, 7) ORDER BY "items"."sort" ASC
  SQL (0.3ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 0], ["updated_at", "2018-03-17 10:21:27.296657"], ["id", 9]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 1], ["updated_at", "2018-03-17 10:21:27.297997"], ["id", 10]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 2], ["updated_at", "2018-03-17 10:21:27.299198"], ["id", 6]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 3], ["updated_at", "2018-03-17 10:21:27.300287"], ["id", 8]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 4], ["updated_at", "2018-03-17 10:21:27.301100"], ["id", 3]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 5], ["updated_at", "2018-03-17 10:21:27.301746"], ["id", 4]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 6], ["updated_at", "2018-03-17 10:21:27.302335"], ["id", 1]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 7], ["updated_at", "2018-03-17 10:21:27.302924"], ["id", 2]]
  SQL (0.2ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 8], ["updated_at", "2018-03-17 10:21:27.303813"], ["id", 5]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 9], ["updated_at", "2018-03-17 10:21:27.304985"], ["id", 7]]
   (1.2ms)  commit transaction
Completed 200 OK in 13ms (ActiveRecord: 2.6ms)


Started POST "/sortable/reorder" for ::1 at 2018-03-17 19:21:29 +0900
Processing by SortableController#reorder as */*
  Parameters: {"Item"=>["9", "6", "10", "8", "3", "4", "1", "2", "5", "7"]}
   (0.1ms)  begin transaction
  Item Load (0.2ms)  SELECT "items".* FROM "items" WHERE "items"."id" IN (9, 6, 10, 8, 3, 4, 1, 2, 5, 7) ORDER BY "items"."sort" ASC
  SQL (0.3ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 1], ["updated_at", "2018-03-17 10:21:29.800684"], ["id", 6]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 2], ["updated_at", "2018-03-17 10:21:29.806255"], ["id", 10]]
   (1.6ms)  commit transaction
Completed 200 OK in 11ms (ActiveRecord: 2.3ms)


Started POST "/sortable/reorder" for ::1 at 2018-03-17 19:21:30 +0900
Processing by SortableController#reorder as */*
  Parameters: {"Item"=>["9", "6", "10", "8", "3", "2", "4", "1", "5", "7"]}
   (0.1ms)  begin transaction
  Item Load (0.2ms)  SELECT "items".* FROM "items" WHERE "items"."id" IN (9, 6, 10, 8, 3, 2, 4, 1, 5, 7) ORDER BY "items"."sort" ASC
  SQL (0.2ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 5], ["updated_at", "2018-03-17 10:21:30.703365"], ["id", 2]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 6], ["updated_at", "2018-03-17 10:21:30.704350"], ["id", 4]]
  SQL (0.1ms)  UPDATE "items" SET "sort" = ?, "updated_at" = ? WHERE "items"."id" = ?  [["sort", 7], ["updated_at", "2018-03-17 10:21:30.705109"], ["id", 1]]
   (2.4ms)  commit transaction
Completed 200 OK in 8ms (ActiveRecord: 3.1ms)


Started GET "/sequenced_items" for ::1 at 2018-03-17 19:21:35 +0900
Processing by SequencedItemsController#index as HTML
  Rendering sequenced_items/index.html.erb within layouts/application
  SequencedItem Load (0.2ms)  SELECT "sequenced_items".* FROM "sequenced_items" ORDER BY "sequenced_items"."sequence" ASC
  Rendered sequenced_items/index.html.erb within layouts/application (2.8ms)
Completed 200 OK in 26ms (Views: 23.1ms | ActiveRecord: 0.2ms)


Started GET "/sequenced_items" for ::1 at 2018-03-17 19:21:42 +0900
Processing by SequencedItemsController#index as HTML
  Rendering sequenced_items/index.html.erb within layouts/application
  SequencedItem Load (0.2ms)  SELECT "sequenced_items".* FROM "sequenced_items" ORDER BY "sequenced_items"."sequence" ASC
  Rendered sequenced_items/index.html.erb within layouts/application (2.6ms)
Completed 200 OK in 27ms (Views: 24.1ms | ActiveRecord: 0.2ms)


Started POST "/sortable/reorder" for ::1 at 2018-03-17 19:21:45 +0900
Processing by SortableController#reorder as */*
  Parameters: {"SequencedItem"=>["10", "2", "7", "8", "3", "4", "5", "6", "1", "9"]}
   (0.0ms)  begin transaction
  SequencedItem Load (0.2ms)  SELECT "sequenced_items".* FROM "sequenced_items" WHERE "sequenced_items"."id" IN (10, 2, 7, 8, 3, 4, 5, 6, 1, 9) ORDER BY "sequenced_items"."sequence" ASC
  SQL (0.3ms)  UPDATE "sequenced_items" SET "sequence" = ? WHERE "sequenced_items"."id" = ?  [["sequence", 2], ["id", 7]]
  SQL (0.1ms)  UPDATE "sequenced_items" SET "sequence" = ? WHERE "sequenced_items"."id" = ?  [["sequence", 3], ["id", 8]]
  SQL (0.1ms)  UPDATE "sequenced_items" SET "sequence" = ? WHERE "sequenced_items"."id" = ?  [["sequence", 4], ["id", 3]]
  SQL (0.1ms)  UPDATE "sequenced_items" SET "sequence" = ? WHERE "sequenced_items"."id" = ?  [["sequence", 5], ["id", 4]]
  SQL (0.1ms)  UPDATE "sequenced_items" SET "sequence" = ? WHERE "sequenced_items"."id" = ?  [["sequence", 6], ["id", 5]]
  SQL (0.0ms)  UPDATE "sequenced_items" SET "sequence" = ? WHERE "sequenced_items"."id" = ?  [["sequence", 7], ["id", 6]]
  SQL (0.0ms)  UPDATE "sequenced_items" SET "sequence" = ? WHERE "sequenced_items"."id" = ?  [["sequence", 8], ["id", 1]]
   (2.4ms)  commit transaction
Completed 200 OK in 10ms (ActiveRecord: 3.4ms)


Started POST "/sortable/reorder" for ::1 at 2018-03-17 19:21:46 +0900
Processing by SortableController#reorder as */*
  Parameters: {"SequencedItem"=>["10", "6", "2", "7", "8", "3", "4", "5", "1", "9"]}
   (0.1ms)  begin transaction
  SequencedItem Load (0.2ms)  SELECT "sequenced_items".* FROM "sequenced_items" WHERE "sequenced_items"."id" IN (10, 6, 2, 7, 8, 3, 4, 5, 1, 9) ORDER BY "sequenced_items"."sequence" ASC
  SQL (0.3ms)  UPDATE "sequenced_items" SET "sequence" = ? WHERE "sequenced_items"."id" = ?  [["sequence", 1], ["id", 6]]
  SQL (0.1ms)  UPDATE "sequenced_items" SET "sequence" = ? WHERE "sequenced_items"."id" = ?  [["sequence", 2], ["id", 2]]
  SQL (0.0ms)  UPDATE "sequenced_items" SET "sequence" = ? WHERE "sequenced_items"."id" = ?  [["sequence", 3], ["id", 7]]
  SQL (0.1ms)  UPDATE "sequenced_items" SET "sequence" = ? WHERE "sequenced_items"."id" = ?  [["sequence", 4], ["id", 8]]
  SQL (0.1ms)  UPDATE "sequenced_items" SET "sequence" = ? WHERE "sequenced_items"."id" = ?  [["sequence", 5], ["id", 3]]
  SQL (0.1ms)  UPDATE "sequenced_items" SET "sequence" = ? WHERE "sequenced_items"."id" = ?  [["sequence", 6], ["id", 4]]
  SQL (0.1ms)  UPDATE "sequenced_items" SET "sequence" = ? WHERE "sequenced_items"."id" = ?  [["sequence", 7], ["id", 5]]
   (0.5ms)  commit transaction
Completed 200 OK in 8ms (ActiveRecord: 1.6ms)


Started POST "/sortable/reorder" for ::1 at 2018-03-17 19:21:46 +0900
Processing by SortableController#reorder as */*
  Parameters: {"SequencedItem"=>["10", "5", "6", "2", "7", "8", "3", "4", "1", "9"]}
   (0.1ms)  begin transaction
  SequencedItem Load (0.2ms)  SELECT "sequenced_items".* FROM "sequenced_items" WHERE "sequenced_items"."id" IN (10, 5, 6, 2, 7, 8, 3, 4, 1, 9) ORDER BY "sequenced_items"."sequence" ASC
  SQL (0.2ms)  UPDATE "sequenced_items" SET "sequence" = ? WHERE "sequenced_items"."id" = ?  [["sequence", 1], ["id", 5]]
  SQL (0.1ms)  UPDATE "sequenced_items" SET "sequence" = ? WHERE "sequenced_items"."id" = ?  [["sequence", 2], ["id", 6]]
  SQL (0.0ms)  UPDATE "sequenced_items" SET "sequence" = ? WHERE "sequenced_items"."id" = ?  [["sequence", 3], ["id", 2]]
  SQL (0.1ms)  UPDATE "sequenced_items" SET "sequence" = ? WHERE "sequenced_items"."id" = ?  [["sequence", 4], ["id", 7]]
  SQL (0.1ms)  UPDATE "sequenced_items" SET "sequence" = ? WHERE "sequenced_items"."id" = ?  [["sequence", 5], ["id", 8]]
  SQL (0.0ms)  UPDATE "sequenced_items" SET "sequence" = ? WHERE "sequenced_items"."id" = ?  [["sequence", 6], ["id", 3]]
  SQL (0.1ms)  UPDATE "sequenced_items" SET "sequence" = ? WHERE "sequenced_items"."id" = ?  [["sequence", 7], ["id", 4]]
   (2.0ms)  commit transaction
Completed 200 OK in 9ms (ActiveRecord: 2.8ms)