ActiveRecord::SchemaMigration Load (0.4ms) SELECT "schema_migrations".* FROM "schema_migrations" Migrating to LadyJosephineImage (20160222151500)  (0.1ms) begin transaction  (0.5ms) CREATE TABLE "lady_josephine_images" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "block_uuid" varchar, "file" varchar, "uploadable_type" varchar, "uploadable_uuid" varchar, "uploadable_id" integer, "uploadable_attribute" varchar, "file_metadata" text, "created_at" datetime NOT NULL, "updated_at" datetime NOT NULL)  SQL (0.2ms) INSERT INTO "schema_migrations" ("version") VALUES (?) [["version", "20160222151500"]]  (2.8ms) commit transaction ActiveRecord::SchemaMigration Load (0.1ms) SELECT "schema_migrations".* FROM "schema_migrations" ActiveRecord::SchemaMigration Load (0.1ms) SELECT "schema_migrations".* FROM "schema_migrations" Migrating to CreateArticles (20160307143232)  (0.1ms) begin transaction  (0.4ms) CREATE TABLE "articles" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "title" varchar, "created_at" datetime NOT NULL, "updated_at" datetime NOT NULL)  SQL (0.1ms) INSERT INTO "schema_migrations" ("version") VALUES (?) [["version", "20160307143232"]]  (2.0ms) commit transaction Migrating to AddLadyJosephineToArticles (20160307143714)  (0.0ms) begin transaction  (0.2ms) ALTER TABLE "articles" ADD "content_data" varchar DEFAULT '{}'  (0.1ms) ALTER TABLE "articles" ADD "lady_josephine_ping_date" datetime  (0.1ms) ALTER TABLE "articles" ADD "lady_josephine_ping_user_id" integer  (0.1ms) ALTER TABLE "articles" ADD "lady_josephine_server_uuid" varchar  (0.1ms) ALTER TABLE "articles" ADD "lady_josephine_server_version" varchar SQL (0.1ms) INSERT INTO "schema_migrations" ("version") VALUES (?) [["version", "20160307143714"]]  (0.6ms) commit transaction ActiveRecord::SchemaMigration Load (0.0ms) SELECT "schema_migrations".* FROM "schema_migrations"  (1.1ms) CREATE TABLE "schema_migrations" ("version" varchar NOT NULL)   (0.1ms) select sqlite_version(*)  (1.0ms) CREATE UNIQUE INDEX "unique_schema_migrations" ON "schema_migrations" ("version") ActiveRecord::SchemaMigration Load (0.1ms) SELECT "schema_migrations".* FROM "schema_migrations" Migrating to LadyJosephineImage (20160222151500)  (0.1ms) begin transaction  (0.4ms) CREATE TABLE "lady_josephine_images" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "block_uuid" varchar, "file" varchar, "uploadable_type" varchar, "uploadable_uuid" varchar, "uploadable_id" integer, "uploadable_attribute" varchar, "file_metadata" text, "created_at" datetime NOT NULL, "updated_at" datetime NOT NULL) SQL (0.1ms) INSERT INTO "schema_migrations" ("version") VALUES (?) [["version", "20160222151500"]]  (0.9ms) commit transaction Migrating to CreateArticles (20160307143232)  (0.1ms) begin transaction  (0.3ms) CREATE TABLE "articles" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "title" varchar, "created_at" datetime NOT NULL, "updated_at" datetime NOT NULL) SQL (0.1ms) INSERT INTO "schema_migrations" ("version") VALUES (?) [["version", "20160307143232"]]  (0.7ms) commit transaction Migrating to AddLadyJosephineToArticles (20160307143714)  (0.1ms) begin transaction  (0.3ms) ALTER TABLE "articles" ADD "content_data" varchar DEFAULT '{}'  (0.1ms) ALTER TABLE "articles" ADD "lady_josephine_ping_date" datetime  (0.1ms) ALTER TABLE "articles" ADD "lady_josephine_ping_user_id" integer  (0.1ms) ALTER TABLE "articles" ADD "lady_josephine_server_uuid" varchar  (0.1ms) ALTER TABLE "articles" ADD "lady_josephine_server_version" varchar SQL (0.1ms) INSERT INTO "schema_migrations" ("version") VALUES (?) [["version", "20160307143714"]]  (0.8ms) commit transaction Migrating to CreateUsers (20160308091107)  (0.1ms) begin transaction  (0.3ms) CREATE TABLE "users" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "first_name" varchar, "last_name" varchar, "created_at" datetime NOT NULL, "updated_at" datetime NOT NULL) SQL (0.1ms) INSERT INTO "schema_migrations" ("version") VALUES (?) [["version", "20160308091107"]]  (0.7ms) commit transaction ActiveRecord::SchemaMigration Load (0.1ms) SELECT "schema_migrations".* FROM "schema_migrations" Started POST "/josephine/content/article/1/ping" for ::1 at 2016-03-08 15:19:10 +0100 ActiveRecord::SchemaMigration Load (0.3ms) SELECT "schema_migrations".* FROM "schema_migrations" ActiveRecord::PendingMigrationError ( Migrations are pending. To resolve this issue, run: bin/rake db:migrate RAILS_ENV=development ): activerecord (4.2.5.1) lib/active_record/migration.rb:392:in `check_pending!' activerecord (4.2.5.1) lib/active_record/migration.rb:373:in `call' actionpack (4.2.5.1) lib/action_dispatch/middleware/callbacks.rb:29:in `block in call' activesupport (4.2.5.1) lib/active_support/callbacks.rb:88:in `__run_callbacks__' activesupport (4.2.5.1) lib/active_support/callbacks.rb:778:in `_run_call_callbacks' activesupport (4.2.5.1) lib/active_support/callbacks.rb:81:in `run_callbacks' actionpack (4.2.5.1) lib/action_dispatch/middleware/callbacks.rb:27:in `call' actionpack (4.2.5.1) lib/action_dispatch/middleware/reloader.rb:73:in `call' actionpack (4.2.5.1) lib/action_dispatch/middleware/remote_ip.rb:78:in `call' actionpack (4.2.5.1) lib/action_dispatch/middleware/debug_exceptions.rb:17:in `call' actionpack (4.2.5.1) lib/action_dispatch/middleware/show_exceptions.rb:30:in `call' railties (4.2.5.1) lib/rails/rack/logger.rb:38:in `call_app' railties (4.2.5.1) lib/rails/rack/logger.rb:20:in `block in call' activesupport (4.2.5.1) lib/active_support/tagged_logging.rb:68:in `block in tagged' activesupport (4.2.5.1) lib/active_support/tagged_logging.rb:26:in `tagged' activesupport (4.2.5.1) lib/active_support/tagged_logging.rb:68:in `tagged' railties (4.2.5.1) lib/rails/rack/logger.rb:20:in `call' actionpack (4.2.5.1) lib/action_dispatch/middleware/request_id.rb:21:in `call' rack (1.6.4) lib/rack/methodoverride.rb:22:in `call' rack (1.6.4) lib/rack/runtime.rb:18:in `call' activesupport (4.2.5.1) lib/active_support/cache/strategy/local_cache_middleware.rb:28:in `call' rack (1.6.4) lib/rack/lock.rb:17:in `call' actionpack (4.2.5.1) lib/action_dispatch/middleware/static.rb:116:in `call' rack (1.6.4) lib/rack/sendfile.rb:113:in `call' railties (4.2.5.1) lib/rails/engine.rb:518:in `call' railties (4.2.5.1) lib/rails/application.rb:165:in `call' rack (1.6.4) lib/rack/lock.rb:17:in `call' rack (1.6.4) lib/rack/content_length.rb:15:in `call' rack (1.6.4) lib/rack/handler/webrick.rb:88:in `service' /Users/bodo/.rbenv/versions/2.1.3/lib/ruby/2.1.0/webrick/httpserver.rb:138:in `service' /Users/bodo/.rbenv/versions/2.1.3/lib/ruby/2.1.0/webrick/httpserver.rb:94:in `run' /Users/bodo/.rbenv/versions/2.1.3/lib/ruby/2.1.0/webrick/server.rb:295:in `block in start_thread' Rendered /Users/bodo/.rbenv/versions/2.1.3/lib/ruby/gems/2.1.0/gems/actionpack-4.2.5.1/lib/action_dispatch/middleware/templates/rescues/_source.erb (2.5ms) Rendered /Users/bodo/.rbenv/versions/2.1.3/lib/ruby/gems/2.1.0/gems/actionpack-4.2.5.1/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (1.0ms) Rendered /Users/bodo/.rbenv/versions/2.1.3/lib/ruby/gems/2.1.0/gems/actionpack-4.2.5.1/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (0.6ms) Rendered /Users/bodo/.rbenv/versions/2.1.3/lib/ruby/gems/2.1.0/gems/actionpack-4.2.5.1/lib/action_dispatch/middleware/templates/rescues/diagnostics.html.erb within rescues/layout (16.0ms) ActiveRecord::SchemaMigration Load (0.1ms) SELECT "schema_migrations".* FROM "schema_migrations" Migrating to AddDeviseToUsers (20160308131853)  (0.0ms) begin transaction  (0.3ms) ALTER TABLE "users" ADD "email" varchar DEFAULT '' NOT NULL  (0.1ms) ALTER TABLE "users" ADD "encrypted_password" varchar DEFAULT '' NOT NULL  (0.1ms) ALTER TABLE "users" ADD "reset_password_token" varchar  (0.1ms) ALTER TABLE "users" ADD "reset_password_sent_at" datetime  (0.1ms) ALTER TABLE "users" ADD "remember_created_at" datetime  (0.2ms) ALTER TABLE "users" ADD "sign_in_count" integer DEFAULT 0 NOT NULL  (0.1ms) ALTER TABLE "users" ADD "current_sign_in_at" datetime  (0.1ms) ALTER TABLE "users" ADD "last_sign_in_at" datetime  (0.1ms) ALTER TABLE "users" ADD "current_sign_in_ip" varchar  (0.1ms) ALTER TABLE "users" ADD "last_sign_in_ip" varchar  (0.0ms) select sqlite_version(*)  (1.3ms) CREATE UNIQUE INDEX "index_users_on_email" ON "users" ("email")  (0.1ms)  SELECT sql FROM sqlite_master WHERE name='index_users_on_email' AND type='index' UNION ALL SELECT sql FROM sqlite_temp_master WHERE name='index_users_on_email' AND type='index'   (0.1ms) CREATE UNIQUE INDEX "index_users_on_reset_password_token" ON "users" ("reset_password_token") SQL (0.1ms) INSERT INTO "schema_migrations" ("version") VALUES (?) [["version", "20160308131853"]]  (3.0ms) commit transaction ActiveRecord::SchemaMigration Load (0.1ms) SELECT "schema_migrations".* FROM "schema_migrations"  (0.1ms) SELECT sql FROM sqlite_master WHERE name='index_users_on_reset_password_token' AND type='index' UNION ALL SELECT sql FROM sqlite_temp_master WHERE name='index_users_on_reset_password_token' AND type='index'  (0.1ms)  SELECT sql FROM sqlite_master WHERE name='index_users_on_email' AND type='index' UNION ALL SELECT sql FROM sqlite_temp_master WHERE name='index_users_on_email' AND type='index'  Started POST "/josephine/content/article/1/ping" for ::1 at 2016-03-08 15:19:22 +0100 ActiveRecord::SchemaMigration Load (0.1ms) SELECT "schema_migrations".* FROM "schema_migrations" ActionController::RoutingError (No route matches [POST] "/josephine/content/article/1/ping"): actionpack (4.2.5.1) lib/action_dispatch/middleware/debug_exceptions.rb:21:in `call' actionpack (4.2.5.1) lib/action_dispatch/middleware/show_exceptions.rb:30:in `call' railties (4.2.5.1) lib/rails/rack/logger.rb:38:in `call_app' railties (4.2.5.1) lib/rails/rack/logger.rb:20:in `block in call' activesupport (4.2.5.1) lib/active_support/tagged_logging.rb:68:in `block in tagged' activesupport (4.2.5.1) lib/active_support/tagged_logging.rb:26:in `tagged' activesupport (4.2.5.1) lib/active_support/tagged_logging.rb:68:in `tagged' railties (4.2.5.1) lib/rails/rack/logger.rb:20:in `call' actionpack (4.2.5.1) lib/action_dispatch/middleware/request_id.rb:21:in `call' rack (1.6.4) lib/rack/methodoverride.rb:22:in `call' rack (1.6.4) lib/rack/runtime.rb:18:in `call' activesupport (4.2.5.1) lib/active_support/cache/strategy/local_cache_middleware.rb:28:in `call' rack (1.6.4) lib/rack/lock.rb:17:in `call' actionpack (4.2.5.1) lib/action_dispatch/middleware/static.rb:116:in `call' rack (1.6.4) lib/rack/sendfile.rb:113:in `call' railties (4.2.5.1) lib/rails/engine.rb:518:in `call' railties (4.2.5.1) lib/rails/application.rb:165:in `call' rack (1.6.4) lib/rack/lock.rb:17:in `call' rack (1.6.4) lib/rack/content_length.rb:15:in `call' rack (1.6.4) lib/rack/handler/webrick.rb:88:in `service' /Users/bodo/.rbenv/versions/2.1.3/lib/ruby/2.1.0/webrick/httpserver.rb:138:in `service' /Users/bodo/.rbenv/versions/2.1.3/lib/ruby/2.1.0/webrick/httpserver.rb:94:in `run' /Users/bodo/.rbenv/versions/2.1.3/lib/ruby/2.1.0/webrick/server.rb:295:in `block in start_thread' Rendered /Users/bodo/.rbenv/versions/2.1.3/lib/ruby/gems/2.1.0/gems/actionpack-4.2.5.1/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (1.6ms) Rendered /Users/bodo/.rbenv/versions/2.1.3/lib/ruby/gems/2.1.0/gems/actionpack-4.2.5.1/lib/action_dispatch/middleware/templates/routes/_route.html.erb (1.0ms) Rendered /Users/bodo/.rbenv/versions/2.1.3/lib/ruby/gems/2.1.0/gems/actionpack-4.2.5.1/lib/action_dispatch/middleware/templates/routes/_route.html.erb (0.3ms) Rendered /Users/bodo/.rbenv/versions/2.1.3/lib/ruby/gems/2.1.0/gems/actionpack-4.2.5.1/lib/action_dispatch/middleware/templates/routes/_table.html.erb (3.0ms) Rendered /Users/bodo/.rbenv/versions/2.1.3/lib/ruby/gems/2.1.0/gems/actionpack-4.2.5.1/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (7.4ms) Rendered /Users/bodo/.rbenv/versions/2.1.3/lib/ruby/gems/2.1.0/gems/actionpack-4.2.5.1/lib/action_dispatch/middleware/templates/rescues/routing_error.html.erb within rescues/layout (35.1ms) Started POST "/josephine/content/article/1/ping" for ::1 at 2016-03-08 15:19:48 +0100 Processing by LadyJosephine::EditorController#ping as */* Parameters: {"resource"=>"article", "id"=>"1"} Can't verify CSRF token authenticity Completed 422 Unprocessable Entity in 0ms (ActiveRecord: 0.0ms) ActionController::InvalidAuthenticityToken (ActionController::InvalidAuthenticityToken): actionpack (4.2.5.1) lib/action_controller/metal/request_forgery_protection.rb:181:in `handle_unverified_request' actionpack (4.2.5.1) lib/action_controller/metal/request_forgery_protection.rb:209:in `handle_unverified_request' devise (3.5.1) lib/devise/controllers/helpers.rb:251:in `handle_unverified_request' actionpack (4.2.5.1) lib/action_controller/metal/request_forgery_protection.rb:204:in `verify_authenticity_token' activesupport (4.2.5.1) lib/active_support/callbacks.rb:432:in `block in make_lambda' activesupport (4.2.5.1) lib/active_support/callbacks.rb:164:in `call' activesupport (4.2.5.1) lib/active_support/callbacks.rb:164:in `block in halting' activesupport (4.2.5.1) lib/active_support/callbacks.rb:504:in `call' activesupport (4.2.5.1) lib/active_support/callbacks.rb:504:in `block in call' activesupport (4.2.5.1) lib/active_support/callbacks.rb:504:in `each' activesupport (4.2.5.1) lib/active_support/callbacks.rb:504:in `call' activesupport (4.2.5.1) lib/active_support/callbacks.rb:92:in `__run_callbacks__' activesupport (4.2.5.1) lib/active_support/callbacks.rb:778:in `_run_process_action_callbacks' activesupport (4.2.5.1) lib/active_support/callbacks.rb:81:in `run_callbacks' actionpack (4.2.5.1) lib/abstract_controller/callbacks.rb:19:in `process_action' actionpack (4.2.5.1) lib/action_controller/metal/rescue.rb:29:in `process_action' actionpack (4.2.5.1) lib/action_controller/metal/instrumentation.rb:32:in `block in process_action' activesupport (4.2.5.1) lib/active_support/notifications.rb:164:in `block in instrument' activesupport (4.2.5.1) lib/active_support/notifications/instrumenter.rb:20:in `instrument' activesupport (4.2.5.1) lib/active_support/notifications.rb:164:in `instrument' actionpack (4.2.5.1) lib/action_controller/metal/instrumentation.rb:30:in `process_action' actionpack (4.2.5.1) lib/action_controller/metal/params_wrapper.rb:250:in `process_action' activerecord (4.2.5.1) lib/active_record/railties/controller_runtime.rb:18:in `process_action' actionpack (4.2.5.1) lib/abstract_controller/base.rb:137:in `process' actionview (4.2.5.1) lib/action_view/rendering.rb:30:in `process' actionpack (4.2.5.1) lib/action_controller/metal.rb:196:in `dispatch' actionpack (4.2.5.1) lib/action_controller/metal/rack_delegation.rb:13:in `dispatch' actionpack (4.2.5.1) lib/action_controller/metal.rb:237:in `block in action' actionpack (4.2.5.1) lib/action_dispatch/routing/route_set.rb:74:in `call' actionpack (4.2.5.1) lib/action_dispatch/routing/route_set.rb:74:in `dispatch' actionpack (4.2.5.1) lib/action_dispatch/routing/route_set.rb:43:in `serve' actionpack (4.2.5.1) lib/action_dispatch/journey/router.rb:43:in `block in serve' actionpack (4.2.5.1) lib/action_dispatch/journey/router.rb:30:in `each' actionpack (4.2.5.1) lib/action_dispatch/journey/router.rb:30:in `serve' actionpack (4.2.5.1) lib/action_dispatch/routing/route_set.rb:815:in `call' railties (4.2.5.1) lib/rails/engine.rb:518:in `call' railties (4.2.5.1) lib/rails/railtie.rb:194:in `public_send' railties (4.2.5.1) lib/rails/railtie.rb:194:in `method_missing' actionpack (4.2.5.1) lib/action_dispatch/routing/mapper.rb:51:in `serve' actionpack (4.2.5.1) lib/action_dispatch/journey/router.rb:43:in `block in serve' actionpack (4.2.5.1) lib/action_dispatch/journey/router.rb:30:in `each' actionpack (4.2.5.1) lib/action_dispatch/journey/router.rb:30:in `serve' actionpack (4.2.5.1) lib/action_dispatch/routing/route_set.rb:815:in `call' warden (1.2.3) lib/warden/manager.rb:35:in `block in call' warden (1.2.3) lib/warden/manager.rb:34:in `catch' warden (1.2.3) lib/warden/manager.rb:34:in `call' rack (1.6.4) lib/rack/etag.rb:24:in `call' rack (1.6.4) lib/rack/conditionalget.rb:38:in `call' rack (1.6.4) lib/rack/head.rb:13:in `call' actionpack (4.2.5.1) lib/action_dispatch/middleware/params_parser.rb:27:in `call' actionpack (4.2.5.1) lib/action_dispatch/middleware/flash.rb:260:in `call' rack (1.6.4) lib/rack/session/abstract/id.rb:225:in `context' rack (1.6.4) lib/rack/session/abstract/id.rb:220:in `call' actionpack (4.2.5.1) lib/action_dispatch/middleware/cookies.rb:560:in `call' activerecord (4.2.5.1) lib/active_record/query_cache.rb:36:in `call' activerecord (4.2.5.1) lib/active_record/connection_adapters/abstract/connection_pool.rb:653:in `call' activerecord (4.2.5.1) lib/active_record/migration.rb:377:in `call' actionpack (4.2.5.1) lib/action_dispatch/middleware/callbacks.rb:29:in `block in call' activesupport (4.2.5.1) lib/active_support/callbacks.rb:88:in `__run_callbacks__' activesupport (4.2.5.1) lib/active_support/callbacks.rb:778:in `_run_call_callbacks' activesupport (4.2.5.1) lib/active_support/callbacks.rb:81:in `run_callbacks' actionpack (4.2.5.1) lib/action_dispatch/middleware/callbacks.rb:27:in `call' actionpack (4.2.5.1) lib/action_dispatch/middleware/reloader.rb:73:in `call' actionpack (4.2.5.1) lib/action_dispatch/middleware/remote_ip.rb:78:in `call' actionpack (4.2.5.1) lib/action_dispatch/middleware/debug_exceptions.rb:17:in `call' actionpack (4.2.5.1) lib/action_dispatch/middleware/show_exceptions.rb:30:in `call' railties (4.2.5.1) lib/rails/rack/logger.rb:38:in `call_app' railties (4.2.5.1) lib/rails/rack/logger.rb:20:in `block in call' activesupport (4.2.5.1) lib/active_support/tagged_logging.rb:68:in `block in tagged' activesupport (4.2.5.1) lib/active_support/tagged_logging.rb:26:in `tagged' activesupport (4.2.5.1) lib/active_support/tagged_logging.rb:68:in `tagged' railties (4.2.5.1) lib/rails/rack/logger.rb:20:in `call' actionpack (4.2.5.1) lib/action_dispatch/middleware/request_id.rb:21:in `call' rack (1.6.4) lib/rack/methodoverride.rb:22:in `call' rack (1.6.4) lib/rack/runtime.rb:18:in `call' activesupport (4.2.5.1) lib/active_support/cache/strategy/local_cache_middleware.rb:28:in `call' rack (1.6.4) lib/rack/lock.rb:17:in `call' actionpack (4.2.5.1) lib/action_dispatch/middleware/static.rb:116:in `call' rack (1.6.4) lib/rack/sendfile.rb:113:in `call' railties (4.2.5.1) lib/rails/engine.rb:518:in `call' railties (4.2.5.1) lib/rails/application.rb:165:in `call' rack (1.6.4) lib/rack/lock.rb:17:in `call' rack (1.6.4) lib/rack/content_length.rb:15:in `call' rack (1.6.4) lib/rack/handler/webrick.rb:88:in `service' /Users/bodo/.rbenv/versions/2.1.3/lib/ruby/2.1.0/webrick/httpserver.rb:138:in `service' /Users/bodo/.rbenv/versions/2.1.3/lib/ruby/2.1.0/webrick/httpserver.rb:94:in `run' /Users/bodo/.rbenv/versions/2.1.3/lib/ruby/2.1.0/webrick/server.rb:295:in `block in start_thread' Rendered /Users/bodo/.rbenv/versions/2.1.3/lib/ruby/gems/2.1.0/gems/actionpack-4.2.5.1/lib/action_dispatch/middleware/templates/rescues/_source.erb (3.3ms) Rendered /Users/bodo/.rbenv/versions/2.1.3/lib/ruby/gems/2.1.0/gems/actionpack-4.2.5.1/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (1.6ms) Rendered /Users/bodo/.rbenv/versions/2.1.3/lib/ruby/gems/2.1.0/gems/actionpack-4.2.5.1/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (0.7ms) Rendered /Users/bodo/.rbenv/versions/2.1.3/lib/ruby/gems/2.1.0/gems/actionpack-4.2.5.1/lib/action_dispatch/middleware/templates/rescues/diagnostics.html.erb within rescues/layout (12.6ms)