test/dummy/log/test.log in acts_as_citable-1.2.0 vs test/dummy/log/test.log in acts_as_citable-2.0.0
- old
+ new
@@ -7012,5 +7012,681 @@
[1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
[1m[35mSQL (0.0ms)[0m INSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-04-25 18:50:52.409000', 'itemType: book', 'csf', '2013-04-25 18:50:52.409000')
[1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
Sent data 3.ris (1.0ms)
Completed 200 OK in 15ms (Views: 3.0ms | ActiveRecord: 0.0ms)
+Connecting to database specified by database.yml
+ [1m[36m (0.0ms)[0m [1mSELECT name FROM sqlite_master WHERE type = 'table' AND NOT name = 'sqlite_sequence' AND name = "records"[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (1.0ms)[0m [1mINSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-05-20 18:22:57.550000', 'itemType: book', 'csf', '2013-05-20 18:22:57.550000')[0m
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35m (1.0ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.0ms)[0m DELETE FROM "records" WHERE "records"."id" = 3
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (1.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Processing by TestController#test as
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.0ms)[0m [1mINSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-05-20 18:22:57.975000', 'itemType: book', 'csf', '2013-05-20 18:22:57.975000')[0m
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+Completed 406 Not Acceptable in 17ms (ActiveRecord: 0.0ms)
+Processing by TestController#test as BIBTEX
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.0ms)[0m INSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-05-20 18:22:58.002000', 'itemType: book', 'csf', '2013-05-20 18:22:58.002000')
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Sent data 3.bib (10.0ms)
+Completed 200 OK in 53ms (Views: 13.0ms | ActiveRecord: 0.0ms)
+Processing by TestController#test as BIBTEX
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.0ms)[0m [1mINSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-05-20 18:22:58.065000', 'itemType: book', 'csf', '2013-05-20 18:22:58.065000')[0m
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+Sent data 3.bib (1.0ms)
+Completed 200 OK in 16ms (Views: 3.0ms | ActiveRecord: 0.0ms)
+Processing by TestController#test as RIS
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.0ms)[0m INSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-05-20 18:22:58.090000', 'itemType: book', 'csf', '2013-05-20 18:22:58.090000')
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Sent data 3.ris (1.0ms)
+Completed 200 OK in 16ms (Views: 3.0ms | ActiveRecord: 0.0ms)
+Connecting to database specified by database.yml
+ [1m[36m (1.0ms)[0m [1mSELECT name FROM sqlite_master WHERE type = 'table' AND NOT name = 'sqlite_sequence' AND name = "records"[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (1.0ms)[0m [1mINSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-14 22:17:07.983000', 'itemType: book', 'csf', '2013-06-14 22:17:07.983000')[0m
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (1.0ms)[0m DELETE FROM "records" WHERE "records"."id" = 3
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (1.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Processing by TestController#test as
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.0ms)[0m [1mINSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-14 22:17:08.289000', 'itemType: book', 'csf', '2013-06-14 22:17:08.289000')[0m
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+Completed 406 Not Acceptable in 13ms (ActiveRecord: 0.0ms)
+Processing by TestController#test as BIBTEX
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (1.0ms)[0m INSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-14 22:17:08.315000', 'itemType: book', 'csf', '2013-06-14 22:17:08.315000')
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Sent data 3.bib (4.0ms)
+Completed 200 OK in 48ms (Views: 5.0ms | ActiveRecord: 0.0ms)
+Processing by TestController#test as BIBTEX
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (1.0ms)[0m [1mINSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-14 22:17:08.371000', 'itemType: book', 'csf', '2013-06-14 22:17:08.371000')[0m
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+Sent data 3.bib (1.0ms)
+Completed 200 OK in 15ms (Views: 2.0ms | ActiveRecord: 0.0ms)
+Processing by TestController#test as RIS
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (1.0ms)[0m INSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-14 22:17:08.395000', 'itemType: book', 'csf', '2013-06-14 22:17:08.395000')
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Sent data 3.ris (1.0ms)
+Completed 200 OK in 17ms (Views: 5.0ms | ActiveRecord: 0.0ms)
+Connecting to database specified by database.yml
+ [1m[36m (0.0ms)[0m [1mSELECT name FROM sqlite_master WHERE type = 'table' AND NOT name = 'sqlite_sequence' AND name = "records"[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (1.0ms)[0m [1mINSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-14 22:18:54.029000', 'itemType: book', 'csf', '2013-06-14 22:18:54.029000')[0m
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35m (1.0ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.0ms)[0m DELETE FROM "records" WHERE "records"."id" = 3
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (1.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (1.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Processing by TestController#test as
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (1.0ms)[0m [1mINSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-14 22:18:54.359000', 'itemType: book', 'csf', '2013-06-14 22:18:54.359000')[0m
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+Completed 406 Not Acceptable in 11ms (ActiveRecord: 1.0ms)
+Processing by TestController#test as BIBTEX
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.0ms)[0m INSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-14 22:18:54.383000', 'itemType: book', 'csf', '2013-06-14 22:18:54.383000')
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Sent data 3.bib (3.0ms)
+Completed 200 OK in 42ms (Views: 5.0ms | ActiveRecord: 0.0ms)
+Processing by TestController#test as BIBTEX
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (1.0ms)[0m [1mINSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-14 22:18:54.435000', 'itemType: book', 'csf', '2013-06-14 22:18:54.435000')[0m
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+Sent data 3.bib (1.0ms)
+Completed 200 OK in 16ms (Views: 3.0ms | ActiveRecord: 0.0ms)
+Processing by TestController#test as RIS
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.0ms)[0m INSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-14 22:18:54.461000', 'itemType: book', 'csf', '2013-06-14 22:18:54.461000')
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Sent data 3.ris (1.0ms)
+Completed 200 OK in 15ms (Views: 3.0ms | ActiveRecord: 0.0ms)
+Connecting to database specified by database.yml
+ [1m[36m (1.0ms)[0m [1mSELECT name FROM sqlite_master WHERE type = 'table' AND NOT name = 'sqlite_sequence' AND name = "records"[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.0ms)[0m [1mINSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-14 22:19:46.973000', 'itemType: book', 'csf', '2013-06-14 22:19:46.973000')[0m
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (1.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.0ms)[0m DELETE FROM "records" WHERE "records"."id" = 3
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (1.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Processing by TestController#test as
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.0ms)[0m [1mINSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-14 22:19:47.331000', 'itemType: book', 'csf', '2013-06-14 22:19:47.331000')[0m
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+Completed 406 Not Acceptable in 13ms (ActiveRecord: 0.0ms)
+Processing by TestController#test as BIBTEX
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.0ms)[0m INSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-14 22:19:47.361000', 'itemType: book', 'csf', '2013-06-14 22:19:47.361000')
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Sent data 3.bib (3.0ms)
+Completed 200 OK in 38ms (Views: 5.0ms | ActiveRecord: 0.0ms)
+Processing by TestController#test as BIBTEX
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.0ms)[0m [1mINSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-14 22:19:47.412000', 'itemType: book', 'csf', '2013-06-14 22:19:47.412000')[0m
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+Sent data 3.bib (1.0ms)
+Completed 200 OK in 18ms (Views: 3.0ms | ActiveRecord: 0.0ms)
+Processing by TestController#test as RIS
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.0ms)[0m INSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-14 22:19:47.439000', 'itemType: book', 'csf', '2013-06-14 22:19:47.439000')
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Sent data 3.ris (2.0ms)
+Completed 200 OK in 17ms (Views: 5.0ms | ActiveRecord: 0.0ms)
+Connecting to database specified by database.yml
+ [1m[36m (0.0ms)[0m [1mSELECT name FROM sqlite_master WHERE type = 'table' AND NOT name = 'sqlite_sequence' AND name = "records"[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (1.0ms)[0m [1mINSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-14 22:21:25.028000', 'itemType: book', 'csf', '2013-06-14 22:21:25.028000')[0m
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.0ms)[0m DELETE FROM "records" WHERE "records"."id" = 3
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Processing by TestController#test as
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.0ms)[0m [1mINSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-14 22:21:25.337000', 'itemType: book', 'csf', '2013-06-14 22:21:25.337000')[0m
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+Completed 406 Not Acceptable in 12ms (ActiveRecord: 0.0ms)
+Processing by TestController#test as BIBTEX
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (1.0ms)[0m INSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-14 22:21:25.363000', 'itemType: book', 'csf', '2013-06-14 22:21:25.363000')
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Sent data 3.bib (2.0ms)
+Completed 200 OK in 34ms (Views: 5.0ms | ActiveRecord: 0.0ms)
+Processing by TestController#test as BIBTEX
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.0ms)[0m [1mINSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-14 22:21:25.405000', 'itemType: book', 'csf', '2013-06-14 22:21:25.405000')[0m
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+Sent data 3.bib (1.0ms)
+Completed 200 OK in 14ms (Views: 2.0ms | ActiveRecord: 0.0ms)
+Processing by TestController#test as RIS
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (1.0ms)[0m INSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-14 22:21:25.428000', 'itemType: book', 'csf', '2013-06-14 22:21:25.428000')
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Sent data 3.ris (1.0ms)
+Completed 200 OK in 17ms (Views: 5.0ms | ActiveRecord: 0.0ms)
+Connecting to database specified by database.yml
+ [1m[36m (0.0ms)[0m [1mSELECT name FROM sqlite_master WHERE type = 'table' AND NOT name = 'sqlite_sequence' AND name = "records"[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (1.0ms)[0m [1mINSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-14 22:25:40.595000', 'itemType: book', 'csf', '2013-06-14 22:25:40.595000')[0m
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (1.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.0ms)[0m DELETE FROM "records" WHERE "records"."id" = 3
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Processing by TestController#test as
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (1.0ms)[0m [1mINSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-14 22:25:40.888000', 'itemType: book', 'csf', '2013-06-14 22:25:40.888000')[0m
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+Completed 406 Not Acceptable in 14ms (ActiveRecord: 1.0ms)
+Processing by TestController#test as BIBTEX
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.0ms)[0m INSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-14 22:25:40.917000', 'itemType: book', 'csf', '2013-06-14 22:25:40.917000')
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Sent data 3.bib (3.0ms)
+Completed 200 OK in 39ms (Views: 5.0ms | ActiveRecord: 0.0ms)
+Processing by TestController#test as BIBTEX
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (1.0ms)[0m [1mINSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-14 22:25:40.963000', 'itemType: book', 'csf', '2013-06-14 22:25:40.963000')[0m
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+Sent data 3.bib (1.0ms)
+Completed 200 OK in 17ms (Views: 3.0ms | ActiveRecord: 0.0ms)
+Processing by TestController#test as RIS
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.0ms)[0m INSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-14 22:25:40.990000', 'itemType: book', 'csf', '2013-06-14 22:25:40.990000')
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Sent data 3.ris (1.0ms)
+Completed 200 OK in 17ms (Views: 3.0ms | ActiveRecord: 0.0ms)
+Connecting to database specified by database.yml
+ [1m[36m (1.0ms)[0m [1mSELECT name FROM sqlite_master WHERE type = 'table' AND NOT name = 'sqlite_sequence' AND name = "records"[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (1.0ms)[0m [1mINSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-14 22:26:15.890000', 'itemType: book', 'csf', '2013-06-14 22:26:15.890000')[0m
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (1.0ms)[0m DELETE FROM "records" WHERE "records"."id" = 3
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (1.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (1.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (1.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Processing by TestController#test as
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.0ms)[0m [1mINSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-14 22:26:16.170000', 'itemType: book', 'csf', '2013-06-14 22:26:16.170000')[0m
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+Completed 406 Not Acceptable in 11ms (ActiveRecord: 0.0ms)
+Processing by TestController#test as BIBTEX
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (1.0ms)[0m INSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-14 22:26:16.195000', 'itemType: book', 'csf', '2013-06-14 22:26:16.195000')
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Sent data 3.bib (3.0ms)
+Completed 200 OK in 46ms (Views: 6.0ms | ActiveRecord: 0.0ms)
+Processing by TestController#test as BIBTEX
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.0ms)[0m [1mINSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-14 22:26:16.255000', 'itemType: book', 'csf', '2013-06-14 22:26:16.255000')[0m
+ [1m[35m (1.0ms)[0m RELEASE SAVEPOINT active_record_1
+Sent data 3.bib (2.0ms)
+Completed 200 OK in 18ms (Views: 3.0ms | ActiveRecord: 0.0ms)
+Processing by TestController#test as RIS
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.0ms)[0m INSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-14 22:26:16.283000', 'itemType: book', 'csf', '2013-06-14 22:26:16.283000')
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Sent data 3.ris (1.0ms)
+Completed 200 OK in 21ms (Views: 4.0ms | ActiveRecord: 0.0ms)
+Connecting to database specified by database.yml
+Connecting to database specified by database.yml
+Connecting to database specified by database.yml
+ [1m[36m (0.0ms)[0m [1mSELECT name FROM sqlite_master WHERE type = 'table' AND NOT name = 'sqlite_sequence' AND name = "records"[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (1.0ms)[0m [1mINSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-14 22:28:29.665000', 'itemType: book', 'csf', '2013-06-14 22:28:29.665000')[0m
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.0ms)[0m DELETE FROM "records" WHERE "records"."id" = 3
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (1.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (1.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Processing by TestController#test as
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (1.0ms)[0m [1mINSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-14 22:28:29.956000', 'itemType: book', 'csf', '2013-06-14 22:28:29.956000')[0m
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+Completed 406 Not Acceptable in 10ms (ActiveRecord: 1.0ms)
+Processing by TestController#test as BIBTEX
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.0ms)[0m INSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-14 22:28:29.979000', 'itemType: book', 'csf', '2013-06-14 22:28:29.979000')
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Sent data 3.bib (3.0ms)
+Completed 200 OK in 38ms (Views: 5.0ms | ActiveRecord: 0.0ms)
+Processing by TestController#test as BIBTEX
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (1.0ms)[0m [1mINSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-14 22:28:30.027000', 'itemType: book', 'csf', '2013-06-14 22:28:30.027000')[0m
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+Sent data 3.bib (2.0ms)
+Completed 200 OK in 17ms (Views: 3.0ms | ActiveRecord: 0.0ms)
+Processing by TestController#test as RIS
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (1.0ms)[0m INSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-14 22:28:30.053000', 'itemType: book', 'csf', '2013-06-14 22:28:30.053000')
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Sent data 3.ris (7.0ms)
+Completed 200 OK in 25ms (Views: 9.0ms | ActiveRecord: 0.0ms)
+Connecting to database specified by database.yml
+ [1m[36m (0.0ms)[0m [1mSELECT name FROM sqlite_master WHERE type = 'table' AND NOT name = 'sqlite_sequence' AND name = "records"[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (1.0ms)[0m [1mINSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-14 22:34:11.067000', 'itemType: book', 'csf', '2013-06-14 22:34:11.067000')[0m
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (1.0ms)[0m DELETE FROM "records" WHERE "records"."id" = 3
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (1.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Processing by TestController#test as
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (1.0ms)[0m [1mINSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-14 22:34:11.419000', 'itemType: book', 'csf', '2013-06-14 22:34:11.419000')[0m
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+Completed 406 Not Acceptable in 12ms (ActiveRecord: 1.0ms)
+Processing by TestController#test as BIBTEX
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.0ms)[0m INSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-14 22:34:11.440000', 'itemType: book', 'csf', '2013-06-14 22:34:11.440000')
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Sent data 3.bib (10.0ms)
+Completed 200 OK in 54ms (Views: 12.0ms | ActiveRecord: 0.0ms)
+Processing by TestController#test as BIBTEX
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.0ms)[0m [1mINSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-14 22:34:11.504000', 'itemType: book', 'csf', '2013-06-14 22:34:11.504000')[0m
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+Sent data 3.bib (2.0ms)
+Completed 200 OK in 19ms (Views: 3.0ms | ActiveRecord: 0.0ms)
+Processing by TestController#test as RIS
+ [1m[36m (1.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.0ms)[0m INSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-14 22:34:11.536000', 'itemType: book', 'csf', '2013-06-14 22:34:11.536000')
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Sent data 3.ris (2.0ms)
+Completed 200 OK in 26ms (Views: 5.0ms | ActiveRecord: 0.0ms)
+Connecting to database specified by database.yml
+ [1m[36m (0.0ms)[0m [1mSELECT name FROM sqlite_master WHERE type = 'table' AND NOT name = 'sqlite_sequence' AND name = "records"[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (1.0ms)[0m [1mINSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-14 22:48:32.938000', 'itemType: book', 'csf', '2013-06-14 22:48:32.938000')[0m
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.0ms)[0m DELETE FROM "records" WHERE "records"."id" = 3
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (1.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Processing by TestController#test as
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (1.0ms)[0m [1mINSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-14 22:48:33.423000', 'itemType: book', 'csf', '2013-06-14 22:48:33.423000')[0m
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+Completed 406 Not Acceptable in 13ms (ActiveRecord: 1.0ms)
+Processing by TestController#test as BIBTEX
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.0ms)[0m INSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-14 22:48:33.463000', 'itemType: book', 'csf', '2013-06-14 22:48:33.463000')
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Sent data 3.bib (11.0ms)
+Completed 200 OK in 56ms (Views: 13.0ms | ActiveRecord: 0.0ms)
+Processing by TestController#test as BIBTEX
+ [1m[35m (1.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.0ms)[0m [1mINSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-14 22:48:33.528000', 'itemType: book', 'csf', '2013-06-14 22:48:33.528000')[0m
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+Sent data 3.bib (1.0ms)
+Completed 200 OK in 17ms (Views: 3.0ms | ActiveRecord: 0.0ms)
+Processing by TestController#test as RIS
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (1.0ms)[0m INSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-14 22:48:33.552000', 'itemType: book', 'csf', '2013-06-14 22:48:33.552000')
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Sent data 3.ris (5.0ms)
+Completed 200 OK in 21ms (Views: 7.0ms | ActiveRecord: 0.0ms)
+Connecting to database specified by database.yml
+ [1m[36m (1.0ms)[0m [1mSELECT name FROM sqlite_master WHERE type = 'table' AND NOT name = 'sqlite_sequence' AND name = "records"[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (1.0ms)[0m [1mINSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-20 17:58:13.264000', 'itemType: book', 'csf', '2013-06-20 17:58:13.264000')[0m
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (1.0ms)[0m DELETE FROM "records" WHERE "records"."id" = 3
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Processing by TestController#test as
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (1.0ms)[0m [1mINSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-20 17:58:13.615000', 'itemType: book', 'csf', '2013-06-20 17:58:13.615000')[0m
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+Completed 406 Not Acceptable in 13ms (ActiveRecord: 1.0ms)
+Processing by TestController#test as BIBTEX
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.0ms)[0m INSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-20 17:58:13.654000', 'itemType: book', 'csf', '2013-06-20 17:58:13.654000')
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Sent data 3.bib (10.0ms)
+Completed 200 OK in 56ms (Views: 14.0ms | ActiveRecord: 0.0ms)
+Processing by TestController#test as BIBTEX
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.0ms)[0m [1mINSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-20 17:58:13.720000', 'itemType: book', 'csf', '2013-06-20 17:58:13.720000')[0m
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+Sent data 3.bib (1.0ms)
+Completed 200 OK in 21ms (Views: 3.0ms | ActiveRecord: 0.0ms)
+Processing by TestController#test as RIS
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (1.0ms)[0m INSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-20 17:58:13.749000', 'itemType: book', 'csf', '2013-06-20 17:58:13.749000')
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Sent data 3.ris (1.0ms)
+Completed 200 OK in 16ms (Views: 3.0ms | ActiveRecord: 0.0ms)
+Connecting to database specified by database.yml
+ [1m[36m (1.0ms)[0m [1mSELECT name FROM sqlite_master WHERE type = 'table' AND NOT name = 'sqlite_sequence' AND name = "records"[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (1.0ms)[0m [1mINSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-20 18:02:53.851000', 'itemType: book', 'csf', '2013-06-20 18:02:53.851000')[0m
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (1.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.0ms)[0m DELETE FROM "records" WHERE "records"."id" = 3
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Processing by TestController#test as
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (1.0ms)[0m [1mINSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-20 18:02:54.142000', 'itemType: book', 'csf', '2013-06-20 18:02:54.142000')[0m
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+Completed 406 Not Acceptable in 11ms (ActiveRecord: 1.0ms)
+Processing by TestController#test as BIBTEX
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.0ms)[0m INSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-20 18:02:54.165000', 'itemType: book', 'csf', '2013-06-20 18:02:54.165000')
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Sent data 3.bib (3.0ms)
+Completed 200 OK in 35ms (Views: 5.0ms | ActiveRecord: 0.0ms)
+Processing by TestController#test as BIBTEX
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.0ms)[0m [1mINSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-20 18:02:54.214000', 'itemType: book', 'csf', '2013-06-20 18:02:54.214000')[0m
+ [1m[35m (1.0ms)[0m RELEASE SAVEPOINT active_record_1
+Sent data 3.bib (1.0ms)
+Completed 200 OK in 14ms (Views: 3.0ms | ActiveRecord: 0.0ms)
+Processing by TestController#test as RIS
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (1.0ms)[0m INSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-20 18:02:54.239000', 'itemType: book', 'csf', '2013-06-20 18:02:54.239000')
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Sent data 3.ris (1.0ms)
+Completed 200 OK in 16ms (Views: 3.0ms | ActiveRecord: 0.0ms)
+Connecting to database specified by database.yml
+ [1m[36m (0.0ms)[0m [1mSELECT name FROM sqlite_master WHERE type = 'table' AND NOT name = 'sqlite_sequence' AND name = "records"[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.0ms)[0m [1mINSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-20 18:04:05.745000', 'itemType: book', 'csf', '2013-06-20 18:04:05.745000')[0m
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (1.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (1.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.0ms)[0m DELETE FROM "records" WHERE "records"."id" = 3
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (1.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (1.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Processing by TestController#test as
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (1.0ms)[0m [1mINSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-20 18:04:06.024000', 'itemType: book', 'csf', '2013-06-20 18:04:06.024000')[0m
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+Completed 406 Not Acceptable in 12ms (ActiveRecord: 1.0ms)
+Processing by TestController#test as BIBTEX
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (1.0ms)[0m INSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-20 18:04:06.048000', 'itemType: book', 'csf', '2013-06-20 18:04:06.048000')
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Sent data 3.bib (3.0ms)
+Completed 200 OK in 43ms (Views: 7.0ms | ActiveRecord: 0.0ms)
+Processing by TestController#test as BIBTEX
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.0ms)[0m [1mINSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-20 18:04:06.104000', 'itemType: book', 'csf', '2013-06-20 18:04:06.104000')[0m
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+Sent data 3.bib (1.0ms)
+Completed 200 OK in 21ms (Views: 2.0ms | ActiveRecord: 0.0ms)
+Processing by TestController#test as RIS
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (1.0ms)[0m INSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-20 18:04:06.130000', 'itemType: book', 'csf', '2013-06-20 18:04:06.130000')
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Sent data 3.ris (1.0ms)
+Completed 200 OK in 15ms (Views: 3.0ms | ActiveRecord: 0.0ms)
+Connecting to database specified by database.yml
+ [1m[36m (1.0ms)[0m [1mSELECT name FROM sqlite_master WHERE type = 'table' AND NOT name = 'sqlite_sequence' AND name = "records"[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (1.0ms)[0m [1mINSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-20 18:04:53.237000', 'itemType: book', 'csf', '2013-06-20 18:04:53.237000')[0m
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (1.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (1.0ms)[0m DELETE FROM "records" WHERE "records"."id" = 3
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Processing by TestController#test as
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (1.0ms)[0m [1mINSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-20 18:04:53.519000', 'itemType: book', 'csf', '2013-06-20 18:04:53.519000')[0m
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+Completed 406 Not Acceptable in 10ms (ActiveRecord: 1.0ms)
+Processing by TestController#test as BIBTEX
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.0ms)[0m INSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-20 18:04:53.542000', 'itemType: book', 'csf', '2013-06-20 18:04:53.542000')
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Sent data 3.bib (3.0ms)
+Completed 200 OK in 33ms (Views: 5.0ms | ActiveRecord: 0.0ms)
+Processing by TestController#test as BIBTEX
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.0ms)[0m [1mINSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-20 18:04:53.588000', 'itemType: book', 'csf', '2013-06-20 18:04:53.588000')[0m
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+Sent data 3.bib (1.0ms)
+Completed 200 OK in 15ms (Views: 3.0ms | ActiveRecord: 0.0ms)
+Processing by TestController#test as RIS
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.0ms)[0m INSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-20 18:04:53.616000', 'itemType: book', 'csf', '2013-06-20 18:04:53.616000')
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Sent data 3.ris (2.0ms)
+Completed 200 OK in 15ms (Views: 3.0ms | ActiveRecord: 0.0ms)
+Connecting to database specified by database.yml
+ [1m[36m (0.0ms)[0m [1mSELECT name FROM sqlite_master WHERE type = 'table' AND NOT name = 'sqlite_sequence' AND name = "records"[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.0ms)[0m [1mINSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-20 18:16:10.882000', 'itemType: book', 'csf', '2013-06-20 18:16:10.882000')[0m
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (1.0ms)[0m DELETE FROM "records" WHERE "records"."id" = 3
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (1.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Processing by TestController#test as
+ [1m[35m (1.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (1.0ms)[0m [1mINSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-20 18:16:14.465000', 'itemType: book', 'csf', '2013-06-20 18:16:14.465000')[0m
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+Completed 406 Not Acceptable in 12ms (ActiveRecord: 2.0ms)
+Processing by TestController#test as BIBTEX
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.0ms)[0m INSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-20 18:16:14.492000', 'itemType: book', 'csf', '2013-06-20 18:16:14.492000')
+ [1m[36m (1.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Sent data 3.bib (3.0ms)
+Completed 200 OK in 40ms (Views: 5.0ms | ActiveRecord: 0.0ms)
+Processing by TestController#test as BIBTEX
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.0ms)[0m [1mINSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-20 18:16:14.542000', 'itemType: book', 'csf', '2013-06-20 18:16:14.542000')[0m
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+Sent data 3.bib (1.0ms)
+Completed 200 OK in 17ms (Views: 4.0ms | ActiveRecord: 0.0ms)
+Processing by TestController#test as RIS
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (1.0ms)[0m INSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-20 18:16:14.570000', 'itemType: book', 'csf', '2013-06-20 18:16:14.570000')
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Sent data 3.ris (1.0ms)
+Completed 200 OK in 18ms (Views: 4.0ms | ActiveRecord: 0.0ms)
+Connecting to database specified by database.yml
+ [1m[36m (1.0ms)[0m [1mSELECT name FROM sqlite_master WHERE type = 'table' AND NOT name = 'sqlite_sequence' AND name = "records"[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.0ms)[0m [1mINSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-20 18:17:52.774000', 'itemType: book', 'csf', '2013-06-20 18:17:52.774000')[0m
+ [1m[35m (1.0ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (1.0ms)[0m DELETE FROM "records" WHERE "records"."id" = 3
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (1.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Processing by TestController#test as
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.0ms)[0m [1mINSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-20 18:17:56.527000', 'itemType: book', 'csf', '2013-06-20 18:17:56.527000')[0m
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+Completed 406 Not Acceptable in 14ms (ActiveRecord: 0.0ms)
+Processing by TestController#test as BIBTEX
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.0ms)[0m INSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-20 18:17:56.558000', 'itemType: book', 'csf', '2013-06-20 18:17:56.558000')
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Sent data 3.bib (4.0ms)
+Completed 200 OK in 51ms (Views: 7.0ms | ActiveRecord: 0.0ms)
+Processing by TestController#test as BIBTEX
+ [1m[35m (0.0ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (11.0ms)[0m [1mINSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-20 18:17:56.629000', 'itemType: book', 'csf', '2013-06-20 18:17:56.629000')[0m
+ [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1
+Sent data 3.bib (2.0ms)
+Completed 200 OK in 38ms (Views: 5.0ms | ActiveRecord: 0.0ms)
+Processing by TestController#test as RIS
+ [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (1.0ms)[0m INSERT INTO "records" ("created_at", "data", "format", "updated_at") VALUES ('2013-06-20 18:17:56.686000', 'itemType: book', 'csf', '2013-06-20 18:17:56.686000')
+ [1m[36m (0.0ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+Sent data 3.ris (2.0ms)
+Completed 200 OK in 31ms (Views: 9.0ms | ActiveRecord: 0.0ms)