(0.1ms) begin transaction  (0.0ms) rollback transaction  (0.1ms) begin transaction  (0.0ms) rollback transaction  (0.1ms) begin transaction  (0.0ms) rollback transaction  (0.1ms) begin transaction  (0.0ms) rollback transaction  (0.1ms) begin transaction Started GET "/export_files" for 127.0.0.1 at 2013-11-03 04:19:00 +0900 Processing by ExportFilesController#index as HTML Completed 500 Internal Server Error in 1ms  (0.1ms) rollback transaction  (0.1ms) begin transaction  (0.0ms) rollback transaction  (0.0ms) begin transaction  (0.0ms) rollback transaction  (0.1ms) begin transaction  (0.0ms) rollback transaction  (0.0ms) begin transaction  (0.0ms) rollback transaction  (0.0ms) begin transaction  (0.0ms) rollback transaction  (0.0ms) begin transaction  (0.0ms) rollback transaction  (0.1ms) begin transaction  (0.0ms) rollback transaction  (2.0ms) CREATE TABLE "schema_migrations" ("version" varchar(255) NOT NULL)   (0.8ms) CREATE UNIQUE INDEX "unique_schema_migrations" ON "schema_migrations" ("version") ActiveRecord::SchemaMigration Load (0.2ms) SELECT "schema_migrations".* FROM "schema_migrations" Migrating to CreateLibraryGroups (80)  (0.1ms) begin transaction  (0.5ms) CREATE TABLE "library_groups" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "name" varchar(255) NOT NULL, "display_name" text, "short_name" varchar(255) NOT NULL, "email" varchar(255), "my_networks" text, "use_dsbl" boolean DEFAULT 'f' NOT NULL, "dsbl_list" text, "login_banner" text, "note" text, "valid_period_for_new_user" integer DEFAULT 365 NOT NULL, "post_to_union_catalog" boolean DEFAULT 'f' NOT NULL, "country_id" integer, "created_at" datetime, "updated_at" datetime)   (0.1ms) CREATE INDEX "index_library_groups_on_short_name" ON "library_groups" ("short_name") SQL (0.2ms) INSERT INTO "schema_migrations" ("version") VALUES (?) [["version", "80"]]  (0.7ms) commit transaction Migrating to AddAdminNetworksToLibraryGroup (20100211105551)  (0.1ms) begin transaction  (0.3ms) ALTER TABLE "library_groups" ADD "admin_networks" text SQL (0.1ms) INSERT INTO "schema_migrations" ("version") VALUES (?) [["version", "20100211105551"]]  (0.8ms) commit transaction Migrating to AddAllowBookmarkExternalUrlToLibraryGroup (20100222124420)  (0.1ms) begin transaction  (0.2ms) ALTER TABLE "library_groups" ADD "allow_bookmark_external_url" boolean DEFAULT 'f' NOT NULL SQL (0.1ms) INSERT INTO "schema_migrations" ("version") VALUES (?) [["version", "20100222124420"]]  (0.7ms) commit transaction Migrating to AddPositionToLibraryGroup (20110115022329)  (0.0ms) begin transaction  (0.2ms) ALTER TABLE "library_groups" ADD "position" integer SQL (0.1ms) INSERT INTO "schema_migrations" ("version") VALUES (?) [["version", "20110115022329"]]  (0.7ms) commit transaction Migrating to AddUrlToLibraryGroup (20110222073537)  (0.0ms) begin transaction  (0.2ms) ALTER TABLE "library_groups" ADD "url" varchar(255) DEFAULT 'http://localhost:3000/' SQL (0.1ms) INSERT INTO "schema_migrations" ("version") VALUES (?) [["version", "20110222073537"]]  (0.6ms) commit transaction Migrating to RemoveDsblFromLibraryGroup (20111020063828)  (0.1ms) begin transaction  (0.7ms) CREATE TEMPORARY TABLE "alibrary_groups" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "name" varchar(255) NOT NULL, "display_name" text, "short_name" varchar(255) NOT NULL, "email" varchar(255), "my_networks" text, "use_dsbl" boolean DEFAULT 'f' NOT NULL, "dsbl_list" text, "login_banner" text, "note" text, "valid_period_for_new_user" integer DEFAULT 365 NOT NULL, "post_to_union_catalog" boolean DEFAULT 'f' NOT NULL, "country_id" integer, "created_at" datetime, "updated_at" datetime, "admin_networks" text, "allow_bookmark_external_url" boolean DEFAULT 'f' NOT NULL, "position" integer, "url" varchar(255) DEFAULT 'http://localhost:3000/')  (0.1ms) CREATE INDEX "tindex_alibrary_groups_on_short_name" ON "alibrary_groups" ("short_name")  (0.1ms) SELECT * FROM "library_groups"  (0.2ms) DROP TABLE "library_groups"  (0.1ms) CREATE TABLE "library_groups" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "name" varchar(255) NOT NULL, "display_name" text, "short_name" varchar(255) NOT NULL, "email" varchar(255), "my_networks" text, "dsbl_list" text, "login_banner" text, "note" text, "valid_period_for_new_user" integer DEFAULT 365 NOT NULL, "post_to_union_catalog" boolean DEFAULT 'f' NOT NULL, "country_id" integer, "created_at" datetime, "updated_at" datetime, "admin_networks" text, "allow_bookmark_external_url" boolean DEFAULT 'f' NOT NULL, "position" integer, "url" varchar(255) DEFAULT 'http://localhost:3000/')  (0.1ms) CREATE INDEX "index_library_groups_on_short_name" ON "library_groups" ("short_name")  (0.1ms) SELECT * FROM "alibrary_groups"  (0.3ms) DROP TABLE "alibrary_groups"  (0.1ms) CREATE TEMPORARY TABLE "alibrary_groups" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "name" varchar(255) NOT NULL, "display_name" text, "short_name" varchar(255) NOT NULL, "email" varchar(255), "my_networks" text, "dsbl_list" text, "login_banner" text, "note" text, "valid_period_for_new_user" integer DEFAULT 365 NOT NULL, "post_to_union_catalog" boolean DEFAULT 'f' NOT NULL, "country_id" integer, "created_at" datetime, "updated_at" datetime, "admin_networks" text, "allow_bookmark_external_url" boolean DEFAULT 'f' NOT NULL, "position" integer, "url" varchar(255) DEFAULT 'http://localhost:3000/')  (0.1ms) CREATE INDEX "tindex_alibrary_groups_on_short_name" ON "alibrary_groups" ("short_name")  (0.1ms) SELECT * FROM "library_groups"  (0.3ms) DROP TABLE "library_groups"  (0.3ms) CREATE TABLE "library_groups" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "name" varchar(255) NOT NULL, "display_name" text, "short_name" varchar(255) NOT NULL, "email" varchar(255), "my_networks" text, "login_banner" text, "note" text, "valid_period_for_new_user" integer DEFAULT 365 NOT NULL, "post_to_union_catalog" boolean DEFAULT 'f' NOT NULL, "country_id" integer, "created_at" datetime, "updated_at" datetime, "admin_networks" text, "allow_bookmark_external_url" boolean DEFAULT 'f' NOT NULL, "position" integer, "url" varchar(255) DEFAULT 'http://localhost:3000/')  (0.1ms) CREATE INDEX "index_library_groups_on_short_name" ON "library_groups" ("short_name")  (0.1ms) SELECT * FROM "alibrary_groups"  (0.1ms) DROP TABLE "alibrary_groups" SQL (0.2ms) INSERT INTO "schema_migrations" ("version") VALUES (?) [["version", "20111020063828"]]  (1.1ms) commit transaction Migrating to CreateRoles (20111201121844)  (0.1ms) begin transaction  (0.4ms) CREATE TABLE "roles" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "name" varchar(255), "display_name" text, "note" text, "position" integer, "created_at" datetime, "updated_at" datetime)  SQL (0.1ms) INSERT INTO "schema_migrations" ("version") VALUES (?) [["version", "20111201121844"]]  (0.7ms) commit transaction Migrating to CreateUsers (20111201155456)  (0.1ms) begin transaction  (0.3ms) CREATE TABLE "users" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "user_group_id" integer, "required_role_id" integer, "username" varchar(255), "note" text, "locale" varchar(255), "created_at" datetime, "updated_at" datetime)  SQL (0.1ms) INSERT INTO "schema_migrations" ("version") VALUES (?) [["version", "20111201155456"]]  (0.6ms) commit transaction Migrating to AddDeviseToUsers (20111201155513)  (0.1ms) begin transaction  (0.3ms) ALTER TABLE "users" ADD "email" varchar(255) DEFAULT '' NOT NULL  (0.1ms) ALTER TABLE "users" ADD "encrypted_password" varchar(255) DEFAULT '' NOT NULL  (0.1ms) ALTER TABLE "users" ADD "reset_password_token" varchar(255)  (0.1ms) ALTER TABLE "users" ADD "reset_password_sent_at" datetime  (0.1ms) ALTER TABLE "users" ADD "remember_created_at" datetime  (0.1ms) ALTER TABLE "users" ADD "sign_in_count" integer DEFAULT 0  (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(255)  (0.1ms) ALTER TABLE "users" ADD "last_sign_in_ip" varchar(255)  (0.1ms) ALTER TABLE "users" ADD "password_salt" varchar(255)  (0.1ms) ALTER TABLE "users" ADD "confirmation_token" varchar(255)  (0.1ms) ALTER TABLE "users" ADD "confirmed_at" datetime  (0.1ms) ALTER TABLE "users" ADD "confirmation_sent_at" datetime  (0.1ms) ALTER TABLE "users" ADD "unconfirmed_email" varchar(255)  (0.1ms) ALTER TABLE "users" ADD "failed_attempts" integer DEFAULT 0  (0.1ms) ALTER TABLE "users" ADD "unlock_token" varchar(255)  (0.1ms) ALTER TABLE "users" ADD "locked_at" datetime  (0.1ms) ALTER TABLE "users" ADD "authentication_token" varchar(255)  (0.1ms) CREATE INDEX "index_users_on_email" ON "users" ("email")  (0.3ms) CREATE UNIQUE INDEX "index_users_on_reset_password_token" ON "users" ("reset_password_token") SQL (0.1ms) INSERT INTO "schema_migrations" ("version") VALUES (?) [["version", "20111201155513"]]  (0.7ms) commit transaction Migrating to CreateUserHasRoles (20111201163718)  (0.1ms) begin transaction  (0.2ms) CREATE TABLE "user_has_roles" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "user_id" integer, "role_id" integer, "created_at" datetime, "updated_at" datetime)  SQL (0.1ms) INSERT INTO "schema_migrations" ("version") VALUES (?) [["version", "20111201163718"]]  (0.7ms) commit transaction Migrating to CreateExportFiles (20120610075759)  (0.0ms) begin transaction  (0.2ms) CREATE TABLE "export_files" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "export_file_name" varchar(255), "export_content_type" varchar(255), "export_file_size" varchar(255), "state" varchar(255), "created_at" datetime, "updated_at" datetime)  SQL (0.1ms) INSERT INTO "schema_migrations" ("version") VALUES (?) [["version", "20120610075759"]]  (0.8ms) commit transaction Migrating to AddUserIdToExportFile (20120621224846)  (0.1ms) begin transaction  (0.2ms) ALTER TABLE "export_files" ADD "user_id" integer  (0.1ms) CREATE INDEX "index_export_files_on_user_id" ON "export_files" ("user_id") SQL (0.1ms) INSERT INTO "schema_migrations" ("version") VALUES (?) [["version", "20120621224846"]]  (0.6ms) commit transaction ActiveRecord::SchemaMigration Load (0.2ms) SELECT "schema_migrations".* FROM "schema_migrations"  (0.1ms) begin transaction Fixture Delete (0.3ms) DELETE FROM "library_groups" Fixture Insert (0.3ms) INSERT INTO "library_groups" ("id", "name", "display_name", "short_name", "email", "note", "my_networks", "url", "created_at", "updated_at") VALUES (1, 'enju_library', 'en: Enju Library', 'enju', 'next-l@library.example.jp', NULL, '0.0.0.0/0', 'http://localhost:3000/', '2013-11-02 19:19:22', '2013-11-02 19:19:22') Fixture Delete (0.1ms) DELETE FROM "roles" Fixture Insert (0.1ms) INSERT INTO "roles" ("name", "display_name", "id", "note", "created_at", "updated_at") VALUES ('Guest', 'Guest', 1, NULL, '2013-11-02 19:19:22', '2013-11-02 19:19:22') Fixture Insert (0.1ms) INSERT INTO "roles" ("name", "display_name", "id", "note", "created_at", "updated_at") VALUES ('User', 'User', 2, NULL, '2013-11-02 19:19:22', '2013-11-02 19:19:22') Fixture Insert (48.8ms) INSERT INTO "roles" ("name", "display_name", "id", "note", "created_at", "updated_at") VALUES ('Librarian', 'Librarian', 3, NULL, '2013-11-02 19:19:22', '2013-11-02 19:19:22') Fixture Insert (0.1ms) INSERT INTO "roles" ("name", "display_name", "id", "note", "created_at", "updated_at") VALUES ('Administrator', 'Administrator', 4, NULL, '2013-11-02 19:19:22', '2013-11-02 19:19:22') Fixture Delete (0.1ms) DELETE FROM "user_has_roles" Fixture Insert (0.1ms) INSERT INTO "user_has_roles" ("user_id", "role_id", "created_at", "updated_at", "id") VALUES (1, 4, '2013-11-02 19:19:22', '2013-11-02 19:19:22', 135138680) Fixture Insert (0.0ms) INSERT INTO "user_has_roles" ("user_id", "role_id", "created_at", "updated_at", "id") VALUES (2, 3, '2013-11-02 19:19:22', '2013-11-02 19:19:22', 344583537) Fixture Insert (0.0ms) INSERT INTO "user_has_roles" ("user_id", "role_id", "created_at", "updated_at", "id") VALUES (3, 2, '2013-11-02 19:19:22', '2013-11-02 19:19:22', 206669143) Fixture Insert (0.0ms) INSERT INTO "user_has_roles" ("user_id", "role_id", "created_at", "updated_at", "id") VALUES (4, 3, '2013-11-02 19:19:22', '2013-11-02 19:19:22', 226540757) Fixture Insert (0.0ms) INSERT INTO "user_has_roles" ("user_id", "role_id", "created_at", "updated_at", "id") VALUES (5, 2, '2013-11-02 19:19:22', '2013-11-02 19:19:22', 358143215) Fixture Insert (0.0ms) INSERT INTO "user_has_roles" ("user_id", "role_id", "created_at", "updated_at", "id") VALUES (6, 2, '2013-11-02 19:19:22', '2013-11-02 19:19:22', 576709754) Fixture Insert (0.0ms) INSERT INTO "user_has_roles" ("user_id", "role_id", "created_at", "updated_at", "id") VALUES (7, 2, '2013-11-02 19:19:22', '2013-11-02 19:19:22', 1010528733) Fixture Delete (0.1ms) DELETE FROM "users" Fixture Insert (0.1ms) INSERT INTO "users" ("updated_at", "encrypted_password", "user_group_id", "id", "note", "username", "email", "created_at", "required_role_id") VALUES ('2008-05-31 04:16:30.163731', '$2a$10$vHohD1WflnTIqAa8zMkF9evwAgIZRw3XuR4d3bi29M.jph/MB/AJi', 2, 1, NULL, 'admin', 'tanabe@kamata.lib.teu.ac.jp', '2007-11-19 07:58:32.111941', 4) Fixture Insert (0.1ms) INSERT INTO "users" ("updated_at", "encrypted_password", "user_group_id", "id", "note", "username", "email", "created_at", "required_role_id") VALUES ('2008-05-31 03:41:16.337474', '$2a$10$9O2VuTccN4gHq36ARg0QReSrb1D7WrBBhZZ759RM9moHbB0W5zCzS', 1, 2, NULL, 'librarian1', 'librarian1@kamata.lib.teu.ac.jp', '2007-11-19 07:58:33.172441', 1) Fixture Insert (0.1ms) INSERT INTO "users" ("updated_at", "encrypted_password", "user_group_id", "id", "note", "username", "email", "created_at", "required_role_id") VALUES ('2008-05-31 04:02:25.101261', '$2a$10$JthS59A0BNkDOoFpCXM0V.GhhffKaoWKbzpPahYp/vTFrOyM7h/uW', 1, 3, NULL, 'user1', 'user1@kamata.lib.teu.ac.jp', '2007-11-19 07:58:34.637413', 3) Fixture Insert (0.1ms) INSERT INTO "users" ("updated_at", "encrypted_password", "user_group_id", "id", "note", "username", "created_at", "required_role_id") VALUES ('2008-05-31 03:42:23.340575', '$2a$10$YmmTGrYQ1Ir6oc7wXnp.GuNeO1eYLoP3sv8wMSIrTdaGw2BPwRrpS', 1, 4, NULL, 'librarian2', '2008-01-18 03:24:04.222344', 1) Fixture Insert (0.1ms) INSERT INTO "users" ("updated_at", "encrypted_password", "user_group_id", "id", "note", "username", "created_at", "required_role_id") VALUES ('2008-05-31 03:42:44.711117', '$2a$10$i7UjJhLVrJM/J7qaTwW39OXw1NiwowUEbtNHVDV0sqMLjX9.UO9ca', 1, 5, NULL, 'user2', '2008-01-18 04:29:06.922728', 2) Fixture Insert (0.1ms) INSERT INTO "users" ("updated_at", "encrypted_password", "user_group_id", "id", "note", "username", "email", "created_at", "required_role_id") VALUES ('2008-05-31 04:02:25.101261', 'cc53de0c2d9a1a228daa9a673ec824473747e17507a6c3c4f7e5eff8821f531d4b9e23616b3ddc66fe17006b2298a556fbd567ac080e87f00f37eef8cee6c417', 1, 6, NULL, 'user3', 'user3@kamata.lib.teu.ac.jp', '2007-11-19 07:58:34.637413', 3) Fixture Insert (0.1ms) INSERT INTO "users" ("updated_at", "encrypted_password", "user_group_id", "id", "note", "username", "email", "created_at", "required_role_id") VALUES ('2008-05-31 04:02:25.101261', 'cc53de0c2d9a1a228daa9a673ec824473747e17507a6c3c4f7e5eff8821f531d4b9e23616b3ddc66fe17006b2298a556fbd567ac080e87f00f37eef8cee6c417', 1, 7, NULL, 'user4', 'user4@kamata.lib.teu.ac.jp', '2007-11-19 07:58:34.637413', 3)  (2.5ms) commit transaction  (0.1ms) begin transaction User Load (0.3ms) SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", 1]]  (0.1ms) SAVEPOINT active_record_1 SQL (1.8ms) INSERT INTO "export_files" ("created_at", "state", "updated_at") VALUES (?, ?, ?) [["created_at", Sat, 02 Nov 2013 19:19:22 UTC +00:00], ["state", "pending"], ["updated_at", Sat, 02 Nov 2013 19:19:22 UTC +00:00]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Processing by ExportFilesController#index as HTML LibraryGroup Load (0.2ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] User Load (0.2ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 ORDER BY "users"."id" ASC LIMIT 1 Role Load (0.2ms) SELECT "roles".* FROM "roles" INNER JOIN "user_has_roles" ON "roles"."id" = "user_has_roles"."role_id" WHERE "user_has_roles"."user_id" = ? ORDER BY roles.position LIMIT 1 [["user_id", 1]] LibraryGroup Load (0.1ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.1ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.1ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.1ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.1ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.1ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.1ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.1ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.1ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.1ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] Rendered /Users/kosuke/enju_export/app/views/export_files/index.html.erb within layouts/application (0.2ms) Completed 200 OK in 641ms (Views: 11.4ms | ActiveRecord: 6.9ms | Solr: 0.0ms) ExportFile Load (0.1ms) SELECT "export_files".* FROM "export_files" ORDER BY id DESC LIMIT 25 OFFSET 0  (1.8ms) rollback transaction  (0.1ms) begin transaction User Load (0.2ms) SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", 1]]  (0.1ms) SAVEPOINT active_record_1 SQL (0.4ms) INSERT INTO "export_files" ("created_at", "state", "updated_at") VALUES (?, ?, ?) [["created_at", Sat, 02 Nov 2013 19:19:23 UTC +00:00], ["state", "pending"], ["updated_at", Sat, 02 Nov 2013 19:19:23 UTC +00:00]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Processing by ExportFilesController#show as HTML Parameters: {"id"=>"1"} LibraryGroup Load (0.1ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] User Load (0.2ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 ORDER BY "users"."id" ASC LIMIT 1 ExportFile Load (0.1ms) SELECT "export_files".* FROM "export_files" WHERE "export_files"."id" = ? LIMIT 1 [["id", "1"]] Role Load (0.1ms) SELECT "roles".* FROM "roles" INNER JOIN "user_has_roles" ON "roles"."id" = "user_has_roles"."role_id" WHERE "user_has_roles"."user_id" = ? ORDER BY roles.position LIMIT 1 [["user_id", 1]] LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] ExportFile Load (0.0ms) SELECT "export_files".* FROM "export_files" WHERE "export_files"."id" = ? LIMIT 1 [["id", "1"]] Completed 200 OK in 14ms (Views: 2.3ms | ActiveRecord: 0.7ms | Solr: 0.0ms)  (0.5ms) rollback transaction  (0.0ms) begin transaction User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", 1]]  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "export_files" ("created_at", "state", "updated_at") VALUES (?, ?, ?) [["created_at", Sat, 02 Nov 2013 19:19:23 UTC +00:00], ["state", "pending"], ["updated_at", Sat, 02 Nov 2013 19:19:23 UTC +00:00]]  (0.0ms) RELEASE SAVEPOINT active_record_1  (0.1ms) SELECT COUNT(*) FROM "export_files" Processing by ExportFilesController#destroy as HTML Parameters: {"id"=>"1"} LibraryGroup Load (0.1ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 ORDER BY "users"."id" ASC LIMIT 1 ExportFile Load (0.1ms) SELECT "export_files".* FROM "export_files" WHERE "export_files"."id" = ? LIMIT 1 [["id", "1"]] Role Load (0.1ms) SELECT "roles".* FROM "roles" INNER JOIN "user_has_roles" ON "roles"."id" = "user_has_roles"."role_id" WHERE "user_has_roles"."user_id" = ? ORDER BY roles.position LIMIT 1 [["user_id", 1]] LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] ExportFile Load (0.0ms) SELECT "export_files".* FROM "export_files" WHERE "export_files"."id" = ? LIMIT 1 [["id", "1"]]  (0.0ms) SAVEPOINT active_record_1 SQL (0.9ms) DELETE FROM "export_files" WHERE "export_files"."id" = ? [["id", 1]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/export_files Completed 302 Found in 15ms (ActiveRecord: 1.7ms)  (0.1ms) SELECT COUNT(*) FROM "export_files"  (0.4ms) rollback transaction  (0.0ms) begin transaction User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", 1]]  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "export_files" ("created_at", "state", "updated_at") VALUES (?, ?, ?) [["created_at", Sat, 02 Nov 2013 19:19:23 UTC +00:00], ["state", "pending"], ["updated_at", Sat, 02 Nov 2013 19:19:23 UTC +00:00]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Processing by ExportFilesController#destroy as HTML Parameters: {"id"=>"1"} LibraryGroup Load (0.1ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 ORDER BY "users"."id" ASC LIMIT 1 ExportFile Load (0.1ms) SELECT "export_files".* FROM "export_files" WHERE "export_files"."id" = ? LIMIT 1 [["id", "1"]] Role Load (0.1ms) SELECT "roles".* FROM "roles" INNER JOIN "user_has_roles" ON "roles"."id" = "user_has_roles"."role_id" WHERE "user_has_roles"."user_id" = ? ORDER BY roles.position LIMIT 1 [["user_id", 1]] LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] ExportFile Load (0.0ms) SELECT "export_files".* FROM "export_files" WHERE "export_files"."id" = ? LIMIT 1 [["id", "1"]]  (0.1ms) SAVEPOINT active_record_1 SQL (0.4ms) DELETE FROM "export_files" WHERE "export_files"."id" = ? [["id", 1]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/export_files Completed 302 Found in 13ms (ActiveRecord: 1.1ms)  (0.5ms) rollback transaction  (0.1ms) begin transaction Started GET "/export_files" for 127.0.0.1 at 2013-11-03 04:19:23 +0900 Processing by ExportFilesController#index as HTML LibraryGroup Load (0.1ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] Redirected to http://www.example.com/users/sign_in Completed 302 Found in 34ms (ActiveRecord: 0.1ms)  (0.1ms) rollback transaction  (0.0ms) begin transaction  (0.0ms) rollback transaction  (0.0ms) begin transaction  (0.0ms) rollback transaction  (0.0ms) begin transaction  (0.0ms) rollback transaction  (0.0ms) begin transaction Rendered /Users/kosuke/enju_export/app/views/export_files/_form.html.erb (11.6ms)  (0.1ms) rollback transaction  (0.1ms) begin transaction  (0.1ms) rollback transaction  (0.1ms) begin transaction Rendered /Users/kosuke/enju_export/app/views/export_files/_form.html.erb (5.1ms)  (0.1ms) rollback transaction  (0.0ms) begin transaction  (0.1ms) rollback transaction Connecting to database specified by database.yml Creating scope :in_list. Overwriting existing method Shelf.in_list.  (0.1ms) begin transaction Fixture Delete (0.3ms) DELETE FROM "library_groups" Fixture Insert (0.1ms) INSERT INTO "library_groups" ("id", "name", "display_name", "short_name", "email", "note", "my_networks", "url", "created_at", "updated_at") VALUES (1, 'enju_library', 'en: Enju Library', 'enju', 'next-l@library.example.jp', NULL, '0.0.0.0/0', 'http://localhost:3000/', '2014-02-09 03:09:45', '2014-02-09 03:09:45') Fixture Delete (0.0ms) DELETE FROM "roles" Fixture Insert (0.0ms) INSERT INTO "roles" ("name", "display_name", "id", "note", "created_at", "updated_at") VALUES ('Guest', 'Guest', 1, NULL, '2014-02-09 03:09:45', '2014-02-09 03:09:45') Fixture Insert (0.0ms) INSERT INTO "roles" ("name", "display_name", "id", "note", "created_at", "updated_at") VALUES ('User', 'User', 2, NULL, '2014-02-09 03:09:45', '2014-02-09 03:09:45') Fixture Insert (0.0ms) INSERT INTO "roles" ("name", "display_name", "id", "note", "created_at", "updated_at") VALUES ('Librarian', 'Librarian', 3, NULL, '2014-02-09 03:09:45', '2014-02-09 03:09:45') Fixture Insert (0.1ms) INSERT INTO "roles" ("name", "display_name", "id", "note", "created_at", "updated_at") VALUES ('Administrator', 'Administrator', 4, NULL, '2014-02-09 03:09:45', '2014-02-09 03:09:45') Fixture Delete (0.1ms) DELETE FROM "user_has_roles" Fixture Insert (0.0ms) INSERT INTO "user_has_roles" ("user_id", "role_id", "created_at", "updated_at", "id") VALUES (1, 4, '2014-02-09 03:09:45', '2014-02-09 03:09:45', 135138680) Fixture Insert (0.0ms) INSERT INTO "user_has_roles" ("user_id", "role_id", "created_at", "updated_at", "id") VALUES (2, 3, '2014-02-09 03:09:45', '2014-02-09 03:09:45', 344583537) Fixture Insert (0.1ms) INSERT INTO "user_has_roles" ("user_id", "role_id", "created_at", "updated_at", "id") VALUES (3, 2, '2014-02-09 03:09:45', '2014-02-09 03:09:45', 206669143) Fixture Insert (0.0ms) INSERT INTO "user_has_roles" ("user_id", "role_id", "created_at", "updated_at", "id") VALUES (4, 3, '2014-02-09 03:09:45', '2014-02-09 03:09:45', 226540757) Fixture Insert (0.0ms) INSERT INTO "user_has_roles" ("user_id", "role_id", "created_at", "updated_at", "id") VALUES (5, 2, '2014-02-09 03:09:45', '2014-02-09 03:09:45', 358143215) Fixture Insert (0.0ms) INSERT INTO "user_has_roles" ("user_id", "role_id", "created_at", "updated_at", "id") VALUES (6, 2, '2014-02-09 03:09:45', '2014-02-09 03:09:45', 576709754) Fixture Insert (0.0ms) INSERT INTO "user_has_roles" ("user_id", "role_id", "created_at", "updated_at", "id") VALUES (7, 2, '2014-02-09 03:09:45', '2014-02-09 03:09:45', 1010528733) Fixture Delete (0.1ms) DELETE FROM "users" Fixture Insert (0.1ms) INSERT INTO "users" ("updated_at", "encrypted_password", "user_group_id", "id", "note", "username", "email", "created_at", "required_role_id") VALUES ('2008-05-31 04:16:30.163731', '$2a$10$vHohD1WflnTIqAa8zMkF9evwAgIZRw3XuR4d3bi29M.jph/MB/AJi', 2, 1, NULL, 'admin', 'tanabe@kamata.lib.teu.ac.jp', '2007-11-19 07:58:32.111941', 4) Fixture Insert (0.0ms) INSERT INTO "users" ("updated_at", "encrypted_password", "user_group_id", "id", "note", "username", "email", "created_at", "required_role_id") VALUES ('2008-05-31 03:41:16.337474', '$2a$10$9O2VuTccN4gHq36ARg0QReSrb1D7WrBBhZZ759RM9moHbB0W5zCzS', 1, 2, NULL, 'librarian1', 'librarian1@kamata.lib.teu.ac.jp', '2007-11-19 07:58:33.172441', 1) Fixture Insert (0.0ms) INSERT INTO "users" ("updated_at", "encrypted_password", "user_group_id", "id", "note", "username", "email", "created_at", "required_role_id") VALUES ('2008-05-31 04:02:25.101261', '$2a$10$JthS59A0BNkDOoFpCXM0V.GhhffKaoWKbzpPahYp/vTFrOyM7h/uW', 1, 3, NULL, 'user1', 'user1@kamata.lib.teu.ac.jp', '2007-11-19 07:58:34.637413', 3) Fixture Insert (0.0ms) INSERT INTO "users" ("updated_at", "encrypted_password", "user_group_id", "id", "note", "username", "created_at", "required_role_id") VALUES ('2008-05-31 03:42:23.340575', '$2a$10$YmmTGrYQ1Ir6oc7wXnp.GuNeO1eYLoP3sv8wMSIrTdaGw2BPwRrpS', 1, 4, NULL, 'librarian2', '2008-01-18 03:24:04.222344', 1) Fixture Insert (0.0ms) INSERT INTO "users" ("updated_at", "encrypted_password", "user_group_id", "id", "note", "username", "created_at", "required_role_id") VALUES ('2008-05-31 03:42:44.711117', '$2a$10$i7UjJhLVrJM/J7qaTwW39OXw1NiwowUEbtNHVDV0sqMLjX9.UO9ca', 1, 5, NULL, 'user2', '2008-01-18 04:29:06.922728', 2) Fixture Insert (0.0ms) INSERT INTO "users" ("updated_at", "encrypted_password", "user_group_id", "id", "note", "username", "email", "created_at", "required_role_id") VALUES ('2008-05-31 04:02:25.101261', 'cc53de0c2d9a1a228daa9a673ec824473747e17507a6c3c4f7e5eff8821f531d4b9e23616b3ddc66fe17006b2298a556fbd567ac080e87f00f37eef8cee6c417', 1, 6, NULL, 'user3', 'user3@kamata.lib.teu.ac.jp', '2007-11-19 07:58:34.637413', 3) Fixture Insert (0.1ms) INSERT INTO "users" ("updated_at", "encrypted_password", "user_group_id", "id", "note", "username", "email", "created_at", "required_role_id") VALUES ('2008-05-31 04:02:25.101261', 'cc53de0c2d9a1a228daa9a673ec824473747e17507a6c3c4f7e5eff8821f531d4b9e23616b3ddc66fe17006b2298a556fbd567ac080e87f00f37eef8cee6c417', 1, 7, NULL, 'user4', 'user4@kamata.lib.teu.ac.jp', '2007-11-19 07:58:34.637413', 3)  (5.3ms) commit transaction  (0.0ms) begin transaction User Load (0.2ms) SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", 1]]  (0.0ms) SAVEPOINT active_record_1 SQL (0.8ms) INSERT INTO "export_files" ("created_at", "export_content_type", "export_file_name", "export_file_size", "state", "updated_at", "user_id") VALUES (?, ?, ?, ?, ?, ?, ?) [["created_at", Sun, 09 Feb 2014 03:09:45 UTC +00:00], ["export_content_type", nil], ["export_file_name", nil], ["export_file_size", nil], ["state", "pending"], ["updated_at", Sun, 09 Feb 2014 03:09:45 UTC +00:00], ["user_id", nil]]  (0.1ms) RELEASE SAVEPOINT active_record_1 Processing by ExportFilesController#index as HTML LibraryGroup Load (0.1ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Role Load (0.2ms) SELECT "roles".* FROM "roles" INNER JOIN "user_has_roles" ON "roles"."id" = "user_has_roles"."role_id" WHERE "user_has_roles"."user_id" = 1 ORDER BY roles.position LIMIT 1 LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.1ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] Rendered /Users/kosuke/enju_export/app/views/export_files/index.html.erb within layouts/application (0.3ms) Completed 200 OK in 72.3ms (Views: 10.4ms | ActiveRecord: 0.8ms | Solr: 0.0ms) ExportFile Load (0.1ms) SELECT "export_files".* FROM "export_files" ORDER BY id DESC LIMIT 25 OFFSET 0  (0.3ms) rollback transaction  (0.0ms) begin transaction User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", 1]]  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "export_files" ("created_at", "export_content_type", "export_file_name", "export_file_size", "state", "updated_at", "user_id") VALUES (?, ?, ?, ?, ?, ?, ?) [["created_at", Sun, 09 Feb 2014 03:09:45 UTC +00:00], ["export_content_type", nil], ["export_file_name", nil], ["export_file_size", nil], ["state", "pending"], ["updated_at", Sun, 09 Feb 2014 03:09:45 UTC +00:00], ["user_id", nil]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Processing by ExportFilesController#show as HTML Parameters: {"id"=>"1"} LibraryGroup Load (0.1ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 ExportFile Load (0.1ms) SELECT "export_files".* FROM "export_files" WHERE "export_files"."id" = ? LIMIT 1 [["id", "1"]] Role Load (0.1ms) SELECT "roles".* FROM "roles" INNER JOIN "user_has_roles" ON "roles"."id" = "user_has_roles"."role_id" WHERE "user_has_roles"."user_id" = 1 ORDER BY roles.position LIMIT 1 LibraryGroup Load (0.1ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] ExportFile Load (0.0ms) SELECT "export_files".* FROM "export_files" WHERE "export_files"."id" = ? LIMIT 1 [["id", "1"]] Completed 200 OK in 17.3ms (Views: 1.9ms | ActiveRecord: 0.7ms | Solr: 0.0ms)  (0.3ms) rollback transaction  (0.0ms) begin transaction User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", 1]]  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "export_files" ("created_at", "export_content_type", "export_file_name", "export_file_size", "state", "updated_at", "user_id") VALUES (?, ?, ?, ?, ?, ?, ?) [["created_at", Sun, 09 Feb 2014 03:09:45 UTC +00:00], ["export_content_type", nil], ["export_file_name", nil], ["export_file_size", nil], ["state", "pending"], ["updated_at", Sun, 09 Feb 2014 03:09:45 UTC +00:00], ["user_id", nil]]  (0.0ms) RELEASE SAVEPOINT active_record_1  (0.1ms) SELECT COUNT(*) FROM "export_files" Processing by ExportFilesController#destroy as HTML Parameters: {"id"=>"1"} LibraryGroup Load (0.1ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 ExportFile Load (0.1ms) SELECT "export_files".* FROM "export_files" WHERE "export_files"."id" = ? LIMIT 1 [["id", "1"]] Role Load (0.1ms) SELECT "roles".* FROM "roles" INNER JOIN "user_has_roles" ON "roles"."id" = "user_has_roles"."role_id" WHERE "user_has_roles"."user_id" = 1 ORDER BY roles.position LIMIT 1 LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] ExportFile Load (0.0ms) SELECT "export_files".* FROM "export_files" WHERE "export_files"."id" = ? LIMIT 1 [["id", "1"]]  (0.0ms) SAVEPOINT active_record_1 SQL (0.7ms) DELETE FROM "export_files" WHERE "export_files"."id" = ? [["id", 1]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/export_files Completed 302 Found in 15.1ms (ActiveRecord: 1.3ms)  (0.0ms) SELECT COUNT(*) FROM "export_files"  (0.4ms) rollback transaction  (0.0ms) begin transaction User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", 1]]  (0.0ms) SAVEPOINT active_record_1 SQL (0.4ms) INSERT INTO "export_files" ("created_at", "export_content_type", "export_file_name", "export_file_size", "state", "updated_at", "user_id") VALUES (?, ?, ?, ?, ?, ?, ?) [["created_at", Sun, 09 Feb 2014 03:09:45 UTC +00:00], ["export_content_type", nil], ["export_file_name", nil], ["export_file_size", nil], ["state", "pending"], ["updated_at", Sun, 09 Feb 2014 03:09:45 UTC +00:00], ["user_id", nil]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Processing by ExportFilesController#destroy as HTML Parameters: {"id"=>"1"} LibraryGroup Load (0.1ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 ExportFile Load (0.0ms) SELECT "export_files".* FROM "export_files" WHERE "export_files"."id" = ? LIMIT 1 [["id", "1"]] Role Load (0.1ms) SELECT "roles".* FROM "roles" INNER JOIN "user_has_roles" ON "roles"."id" = "user_has_roles"."role_id" WHERE "user_has_roles"."user_id" = 1 ORDER BY roles.position LIMIT 1 LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.1ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] ExportFile Load (0.0ms) SELECT "export_files".* FROM "export_files" WHERE "export_files"."id" = ? LIMIT 1 [["id", "1"]]  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) DELETE FROM "export_files" WHERE "export_files"."id" = ? [["id", 1]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/export_files Completed 302 Found in 13.3ms (ActiveRecord: 0.9ms)  (0.4ms) rollback transaction  (0.0ms) begin transaction Started GET "/export_files" for 127.0.0.1 at 2014-02-09 12:09:45 +0900 Processing by ExportFilesController#index as HTML LibraryGroup Load (0.1ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] Redirected to http://www.example.com/users/sign_in Completed 302 Found in 14.3ms (ActiveRecord: 0.1ms)  (0.1ms) rollback transaction  (0.0ms) begin transaction  (0.0ms) rollback transaction  (0.0ms) begin transaction  (12.3ms) rollback transaction  (0.0ms) begin transaction  (0.0ms) rollback transaction  (0.0ms) begin transaction Rendered /Users/kosuke/enju_export/app/views/export_files/_form.html.erb (9.4ms)  (0.0ms) rollback transaction  (0.0ms) begin transaction  (0.0ms) rollback transaction  (0.0ms) begin transaction Rendered /Users/kosuke/enju_export/app/views/export_files/_form.html.erb (5.2ms)  (0.0ms) rollback transaction  (0.0ms) begin transaction  (0.0ms) rollback transaction Connecting to database specified by database.yml Creating scope :in_list. Overwriting existing method Shelf.in_list.  (0.1ms) begin transaction Fixture Delete (0.3ms) DELETE FROM "library_groups" Fixture Insert (0.1ms) INSERT INTO "library_groups" ("id", "name", "display_name", "short_name", "email", "note", "my_networks", "url", "created_at", "updated_at") VALUES (1, 'enju_library', 'en: Enju Library', 'enju', 'next-l@library.example.jp', NULL, '0.0.0.0/0', 'http://localhost:3000/', '2014-02-09 06:32:41', '2014-02-09 06:32:41') Fixture Delete (0.0ms) DELETE FROM "roles" Fixture Insert (0.0ms) INSERT INTO "roles" ("name", "display_name", "id", "note", "created_at", "updated_at") VALUES ('Guest', 'Guest', 1, NULL, '2014-02-09 06:32:41', '2014-02-09 06:32:41') Fixture Insert (0.1ms) INSERT INTO "roles" ("name", "display_name", "id", "note", "created_at", "updated_at") VALUES ('User', 'User', 2, NULL, '2014-02-09 06:32:41', '2014-02-09 06:32:41') Fixture Insert (0.0ms) INSERT INTO "roles" ("name", "display_name", "id", "note", "created_at", "updated_at") VALUES ('Librarian', 'Librarian', 3, NULL, '2014-02-09 06:32:41', '2014-02-09 06:32:41') Fixture Insert (0.0ms) INSERT INTO "roles" ("name", "display_name", "id", "note", "created_at", "updated_at") VALUES ('Administrator', 'Administrator', 4, NULL, '2014-02-09 06:32:41', '2014-02-09 06:32:41') Fixture Delete (0.0ms) DELETE FROM "user_has_roles" Fixture Insert (0.0ms) INSERT INTO "user_has_roles" ("user_id", "role_id", "created_at", "updated_at", "id") VALUES (1, 4, '2014-02-09 06:32:41', '2014-02-09 06:32:41', 135138680) Fixture Insert (0.0ms) INSERT INTO "user_has_roles" ("user_id", "role_id", "created_at", "updated_at", "id") VALUES (2, 3, '2014-02-09 06:32:41', '2014-02-09 06:32:41', 344583537) Fixture Insert (0.0ms) INSERT INTO "user_has_roles" ("user_id", "role_id", "created_at", "updated_at", "id") VALUES (3, 2, '2014-02-09 06:32:41', '2014-02-09 06:32:41', 206669143) Fixture Insert (0.0ms) INSERT INTO "user_has_roles" ("user_id", "role_id", "created_at", "updated_at", "id") VALUES (4, 3, '2014-02-09 06:32:41', '2014-02-09 06:32:41', 226540757) Fixture Insert (0.0ms) INSERT INTO "user_has_roles" ("user_id", "role_id", "created_at", "updated_at", "id") VALUES (5, 2, '2014-02-09 06:32:41', '2014-02-09 06:32:41', 358143215) Fixture Insert (0.0ms) INSERT INTO "user_has_roles" ("user_id", "role_id", "created_at", "updated_at", "id") VALUES (6, 2, '2014-02-09 06:32:41', '2014-02-09 06:32:41', 576709754) Fixture Insert (0.0ms) INSERT INTO "user_has_roles" ("user_id", "role_id", "created_at", "updated_at", "id") VALUES (7, 2, '2014-02-09 06:32:41', '2014-02-09 06:32:41', 1010528733) Fixture Delete (0.1ms) DELETE FROM "users" Fixture Insert (0.0ms) INSERT INTO "users" ("updated_at", "encrypted_password", "user_group_id", "id", "note", "username", "email", "created_at", "required_role_id") VALUES ('2008-05-31 04:16:30.163731', '$2a$10$vHohD1WflnTIqAa8zMkF9evwAgIZRw3XuR4d3bi29M.jph/MB/AJi', 2, 1, NULL, 'admin', 'tanabe@kamata.lib.teu.ac.jp', '2007-11-19 07:58:32.111941', 4) Fixture Insert (0.0ms) INSERT INTO "users" ("updated_at", "encrypted_password", "user_group_id", "id", "note", "username", "email", "created_at", "required_role_id") VALUES ('2008-05-31 03:41:16.337474', '$2a$10$9O2VuTccN4gHq36ARg0QReSrb1D7WrBBhZZ759RM9moHbB0W5zCzS', 1, 2, NULL, 'librarian1', 'librarian1@kamata.lib.teu.ac.jp', '2007-11-19 07:58:33.172441', 1) Fixture Insert (0.0ms) INSERT INTO "users" ("updated_at", "encrypted_password", "user_group_id", "id", "note", "username", "email", "created_at", "required_role_id") VALUES ('2008-05-31 04:02:25.101261', '$2a$10$JthS59A0BNkDOoFpCXM0V.GhhffKaoWKbzpPahYp/vTFrOyM7h/uW', 1, 3, NULL, 'user1', 'user1@kamata.lib.teu.ac.jp', '2007-11-19 07:58:34.637413', 3) Fixture Insert (0.0ms) INSERT INTO "users" ("updated_at", "encrypted_password", "user_group_id", "id", "note", "username", "created_at", "required_role_id") VALUES ('2008-05-31 03:42:23.340575', '$2a$10$YmmTGrYQ1Ir6oc7wXnp.GuNeO1eYLoP3sv8wMSIrTdaGw2BPwRrpS', 1, 4, NULL, 'librarian2', '2008-01-18 03:24:04.222344', 1) Fixture Insert (0.0ms) INSERT INTO "users" ("updated_at", "encrypted_password", "user_group_id", "id", "note", "username", "created_at", "required_role_id") VALUES ('2008-05-31 03:42:44.711117', '$2a$10$i7UjJhLVrJM/J7qaTwW39OXw1NiwowUEbtNHVDV0sqMLjX9.UO9ca', 1, 5, NULL, 'user2', '2008-01-18 04:29:06.922728', 2) Fixture Insert (0.0ms) INSERT INTO "users" ("updated_at", "encrypted_password", "user_group_id", "id", "note", "username", "email", "created_at", "required_role_id") VALUES ('2008-05-31 04:02:25.101261', 'cc53de0c2d9a1a228daa9a673ec824473747e17507a6c3c4f7e5eff8821f531d4b9e23616b3ddc66fe17006b2298a556fbd567ac080e87f00f37eef8cee6c417', 1, 6, NULL, 'user3', 'user3@kamata.lib.teu.ac.jp', '2007-11-19 07:58:34.637413', 3) Fixture Insert (0.0ms) INSERT INTO "users" ("updated_at", "encrypted_password", "user_group_id", "id", "note", "username", "email", "created_at", "required_role_id") VALUES ('2008-05-31 04:02:25.101261', 'cc53de0c2d9a1a228daa9a673ec824473747e17507a6c3c4f7e5eff8821f531d4b9e23616b3ddc66fe17006b2298a556fbd567ac080e87f00f37eef8cee6c417', 1, 7, NULL, 'user4', 'user4@kamata.lib.teu.ac.jp', '2007-11-19 07:58:34.637413', 3)  (4.6ms) commit transaction  (0.0ms) begin transaction User Load (0.2ms) SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", 1]]  (0.0ms) SAVEPOINT active_record_1 SQL (0.4ms) INSERT INTO "export_files" ("created_at", "export_content_type", "export_file_name", "export_file_size", "state", "updated_at", "user_id") VALUES (?, ?, ?, ?, ?, ?, ?) [["created_at", Sun, 09 Feb 2014 06:32:41 UTC +00:00], ["export_content_type", nil], ["export_file_name", nil], ["export_file_size", nil], ["state", "pending"], ["updated_at", Sun, 09 Feb 2014 06:32:41 UTC +00:00], ["user_id", nil]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Processing by ExportFilesController#index as HTML LibraryGroup Load (0.1ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 Role Load (0.2ms) SELECT "roles".* FROM "roles" INNER JOIN "user_has_roles" ON "roles"."id" = "user_has_roles"."role_id" WHERE "user_has_roles"."user_id" = 1 ORDER BY roles.position LIMIT 1 LibraryGroup Load (0.1ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] Rendered /Users/kosuke/enju_export/app/views/export_files/index.html.erb within layouts/application (0.3ms) Completed 200 OK in 73.5ms (Views: 14.2ms | ActiveRecord: 0.7ms | Solr: 0.0ms) ExportFile Load (0.1ms) SELECT "export_files".* FROM "export_files" ORDER BY id DESC LIMIT 25 OFFSET 0  (0.4ms) rollback transaction  (0.0ms) begin transaction User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", 1]]  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "export_files" ("created_at", "export_content_type", "export_file_name", "export_file_size", "state", "updated_at", "user_id") VALUES (?, ?, ?, ?, ?, ?, ?) [["created_at", Sun, 09 Feb 2014 06:32:41 UTC +00:00], ["export_content_type", nil], ["export_file_name", nil], ["export_file_size", nil], ["state", "pending"], ["updated_at", Sun, 09 Feb 2014 06:32:41 UTC +00:00], ["user_id", nil]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Processing by ExportFilesController#show as HTML Parameters: {"id"=>"1"} LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 ExportFile Load (0.1ms) SELECT "export_files".* FROM "export_files" WHERE "export_files"."id" = ? LIMIT 1 [["id", "1"]] Role Load (0.1ms) SELECT "roles".* FROM "roles" INNER JOIN "user_has_roles" ON "roles"."id" = "user_has_roles"."role_id" WHERE "user_has_roles"."user_id" = 1 ORDER BY roles.position LIMIT 1 LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] ExportFile Load (0.0ms) SELECT "export_files".* FROM "export_files" WHERE "export_files"."id" = ? LIMIT 1 [["id", "1"]] Completed 200 OK in 17.5ms (Views: 4.7ms | ActiveRecord: 0.5ms | Solr: 0.0ms)  (0.4ms) rollback transaction  (0.0ms) begin transaction User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", 1]]  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "export_files" ("created_at", "export_content_type", "export_file_name", "export_file_size", "state", "updated_at", "user_id") VALUES (?, ?, ?, ?, ?, ?, ?) [["created_at", Sun, 09 Feb 2014 06:32:41 UTC +00:00], ["export_content_type", nil], ["export_file_name", nil], ["export_file_size", nil], ["state", "pending"], ["updated_at", Sun, 09 Feb 2014 06:32:41 UTC +00:00], ["user_id", nil]]  (0.0ms) RELEASE SAVEPOINT active_record_1  (0.1ms) SELECT COUNT(*) FROM "export_files" Processing by ExportFilesController#destroy as HTML Parameters: {"id"=>"1"} LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 ExportFile Load (0.1ms) SELECT "export_files".* FROM "export_files" WHERE "export_files"."id" = ? LIMIT 1 [["id", "1"]] Role Load (0.1ms) SELECT "roles".* FROM "roles" INNER JOIN "user_has_roles" ON "roles"."id" = "user_has_roles"."role_id" WHERE "user_has_roles"."user_id" = 1 ORDER BY roles.position LIMIT 1 LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] ExportFile Load (0.0ms) SELECT "export_files".* FROM "export_files" WHERE "export_files"."id" = ? LIMIT 1 [["id", "1"]]  (0.0ms) SAVEPOINT active_record_1 SQL (1.0ms) DELETE FROM "export_files" WHERE "export_files"."id" = ? [["id", 1]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/export_files Completed 302 Found in 13.5ms (ActiveRecord: 1.6ms)  (0.0ms) SELECT COUNT(*) FROM "export_files"  (0.4ms) rollback transaction  (0.0ms) begin transaction User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", 1]]  (0.0ms) SAVEPOINT active_record_1 SQL (0.3ms) INSERT INTO "export_files" ("created_at", "export_content_type", "export_file_name", "export_file_size", "state", "updated_at", "user_id") VALUES (?, ?, ?, ?, ?, ?, ?) [["created_at", Sun, 09 Feb 2014 06:32:41 UTC +00:00], ["export_content_type", nil], ["export_file_name", nil], ["export_file_size", nil], ["state", "pending"], ["updated_at", Sun, 09 Feb 2014 06:32:41 UTC +00:00], ["user_id", nil]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Processing by ExportFilesController#destroy as HTML Parameters: {"id"=>"1"} LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] User Load (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = 1 LIMIT 1 ExportFile Load (0.0ms) SELECT "export_files".* FROM "export_files" WHERE "export_files"."id" = ? LIMIT 1 [["id", "1"]] Role Load (0.1ms) SELECT "roles".* FROM "roles" INNER JOIN "user_has_roles" ON "roles"."id" = "user_has_roles"."role_id" WHERE "user_has_roles"."user_id" = 1 ORDER BY roles.position LIMIT 1 LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] LibraryGroup Load (0.0ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] ExportFile Load (0.0ms) SELECT "export_files".* FROM "export_files" WHERE "export_files"."id" = ? LIMIT 1 [["id", "1"]]  (0.0ms) SAVEPOINT active_record_1 SQL (0.2ms) DELETE FROM "export_files" WHERE "export_files"."id" = ? [["id", 1]]  (0.0ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/export_files Completed 302 Found in 12.1ms (ActiveRecord: 0.7ms)  (0.5ms) rollback transaction  (0.0ms) begin transaction Started GET "/export_files" for 127.0.0.1 at 2014-02-09 15:32:41 +0900 Processing by ExportFilesController#index as HTML LibraryGroup Load (0.1ms) SELECT "library_groups".* FROM "library_groups" WHERE "library_groups"."id" = ? LIMIT 1 [["id", 1]] Redirected to http://www.example.com/users/sign_in Completed 302 Found in 13.9ms (ActiveRecord: 0.1ms)  (0.1ms) rollback transaction  (0.0ms) begin transaction  (0.0ms) rollback transaction  (0.0ms) begin transaction  (0.0ms) rollback transaction  (0.0ms) begin transaction  (0.0ms) rollback transaction  (0.0ms) begin transaction Rendered /Users/kosuke/enju_export/app/views/export_files/_form.html.erb (13.0ms)  (0.1ms) rollback transaction  (0.0ms) begin transaction  (0.0ms) rollback transaction  (0.0ms) begin transaction Rendered /Users/kosuke/enju_export/app/views/export_files/_form.html.erb (4.9ms)  (0.0ms) rollback transaction  (0.0ms) begin transaction  (0.1ms) rollback transaction