test/dummy/log/test.log in ominous-0.0.1 vs test/dummy/log/test.log in ominous-0.0.2

- old
+ new

@@ -16540,5 +16540,806 @@  (1.6ms) SAVEPOINT active_record_1  (0.3ms) RELEASE SAVEPOINT active_record_1 Redirected to http://test.host/things/1 Completed 302 Found in 6ms (ActiveRecord: 2.4ms)  (0.3ms) ROLLBACK +Connecting to database specified by database.yml +  (0.4ms) SELECT @@FOREIGN_KEY_CHECKS +  (0.3ms) SET FOREIGN_KEY_CHECKS = 0 +  (0.3ms) BEGIN + Fixture Delete (1.0ms) DELETE FROM `ominous_warnings` + Fixture Insert (0.8ms) INSERT INTO `ominous_warnings` (`id`, `name`, `created_at`, `updated_at`) VALUES (1, 'thing_alert', '2012-12-10 15:30:34', '2012-12-10 15:30:34') + Fixture Insert (0.4ms) INSERT INTO `ominous_warnings` (`id`, `name`, `created_at`, `updated_at`) VALUES (2, 'other_alert', '2012-12-10 15:30:34', '2012-12-10 15:30:34') + Fixture Delete (0.5ms) DELETE FROM `ominous_warning_closers` + Fixture Insert (0.4ms) INSERT INTO `ominous_warning_closers` (`warning_id`, `closer_id`, `position`, `created_at`, `updated_at`, `id`) VALUES (1, 1, 1, '2012-12-10 15:30:34', '2012-12-10 15:30:34', 980190962) + Fixture Insert (0.4ms) INSERT INTO `ominous_warning_closers` (`warning_id`, `closer_id`, `position`, `created_at`, `updated_at`, `id`) VALUES (1, 2, 2, '2012-12-10 15:30:34', '2012-12-10 15:30:34', 298486374) + Fixture Insert (0.5ms) INSERT INTO `ominous_warning_closers` (`warning_id`, `closer_id`, `position`, `created_at`, `updated_at`, `id`) VALUES (2, 2, 1, '2012-12-10 15:30:34', '2012-12-10 15:30:34', 113629430) + Fixture Delete (0.3ms) DELETE FROM `ominous_closers` + Fixture Insert (0.7ms) INSERT INTO `ominous_closers` (`id`, `name`, `closure_method`, `created_at`, `updated_at`) VALUES (1, 'closer_one', 'close_and_dismiss_warning', '2012-12-10 15:30:34', '2012-12-10 15:30:34') + Fixture Insert (0.4ms) INSERT INTO `ominous_closers` (`id`, `name`, `url`, `closure_method`, `created_at`, `updated_at`) VALUES (2, 'closer_two', 'http://undervale.co.uk', 'redirect', '2012-12-10 15:30:34', '2012-12-10 15:30:34') + Fixture Delete (0.3ms) DELETE FROM `things` + Fixture Insert (0.3ms) INSERT INTO `things` (`id`, `name`, `has_warning`, `created_at`, `updated_at`) VALUES (1, 'Foo', 0, '2012-12-10 15:30:34', '2012-12-10 15:30:34') + Fixture Insert (0.3ms) INSERT INTO `things` (`id`, `name`, `has_warning`, `created_at`, `updated_at`) VALUES (2, 'Bar', 1, '2012-12-10 15:30:34', '2012-12-10 15:30:34') +  (56.0ms) COMMIT +  (3.3ms) SET FOREIGN_KEY_CHECKS = 1 +  (2.5ms) BEGIN + Ominous::Warning Load (2.5ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 + Ominous::Closer Load (1.5ms) SELECT `ominous_closers`.* FROM `ominous_closers` WHERE `ominous_closers`.`id` = 1 LIMIT 1 +  (0.8ms) SELECT COUNT(*) FROM `ominous_warning_closers` +  (0.4ms) SAVEPOINT active_record_1 + Ominous::WarningCloser Load (0.9ms) SELECT `ominous_warning_closers`.* FROM `ominous_warning_closers` WHERE (`ominous_warning_closers`.`warning_id` = 1) ORDER BY ominous_warning_closers.position DESC LIMIT 1 + SQL (0.5ms) INSERT INTO `ominous_warning_closers` (`closer_id`, `created_at`, `position`, `updated_at`, `warning_id`) VALUES (1, '2012-12-10 15:30:34', 3, '2012-12-10 15:30:34', 1) +  (0.3ms) RELEASE SAVEPOINT active_record_1 +  (0.4ms) SELECT COUNT(*) FROM `ominous_warning_closers`  +  (31.4ms) ROLLBACK +  (0.2ms) BEGIN + Ominous::Warning Load (0.3ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 + Ominous::Closer Load (0.3ms) SELECT `ominous_closers`.* FROM `ominous_closers` WHERE `ominous_closers`.`id` = 1 LIMIT 1 + Ominous::Closer Exists (8.2ms) SELECT 1 AS one FROM `ominous_closers` INNER JOIN `ominous_warning_closers` ON `ominous_closers`.`id` = `ominous_warning_closers`.`closer_id` WHERE `ominous_warning_closers`.`warning_id` = 1 AND `ominous_closers`.`id` = 1 LIMIT 1 +  (0.3ms) ROLLBACK +  (0.3ms) BEGIN + Ominous::Warning Load (0.3ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 + Ominous::Closer Load (0.3ms) SELECT `ominous_closers`.* FROM `ominous_closers` WHERE `ominous_closers`.`id` = 1 LIMIT 1 + Ominous::Closer Load (7.0ms) SELECT `ominous_closers`.* FROM `ominous_closers` INNER JOIN `ominous_warning_closers` ON `ominous_closers`.`id` = `ominous_warning_closers`.`closer_id` WHERE `ominous_warning_closers`.`warning_id` = 1 AND `ominous_closers`.`id` = 1 ORDER BY position LIMIT 1 +  (0.4ms) ROLLBACK +  (0.3ms) BEGIN + Ominous::Warning Load (0.3ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 + Ominous::Closer Load (0.4ms) SELECT `ominous_closers`.* FROM `ominous_closers` WHERE `ominous_closers`.`id` = 1 LIMIT 1 + Ominous::Closer Load (1.5ms) SELECT `ominous_closers`.* FROM `ominous_closers` WHERE `ominous_closers`.`id` = 1 LIMIT 1 + Ominous::Closer Load (5.1ms) SELECT `ominous_closers`.* FROM `ominous_closers` WHERE `ominous_closers`.`id` = 2 LIMIT 1 + Ominous::Closer Load (0.7ms) SELECT `ominous_closers`.* FROM `ominous_closers` INNER JOIN `ominous_warning_closers` ON `ominous_closers`.`id` = `ominous_warning_closers`.`closer_id` WHERE `ominous_warning_closers`.`warning_id` = 1 ORDER BY position + Ominous::WarningCloser Load (0.5ms) SELECT DISTINCT `ominous_warning_closers`.* FROM `ominous_warning_closers` WHERE `ominous_warning_closers`.`warning_id` = 1 AND `ominous_warning_closers`.`closer_id` = 2 ORDER BY position LIMIT 1 +  (0.3ms) SAVEPOINT active_record_1 + SQL (7.6ms) UPDATE `ominous_warning_closers` SET position = (position + 1) WHERE (`ominous_warning_closers`.`warning_id` = 1 AND position < 2) +  (0.5ms) UPDATE `ominous_warning_closers` SET `position` = 1, `updated_at` = '2012-12-10 15:30:35' WHERE `ominous_warning_closers`.`id` = 298486374 +  (0.5ms) SELECT COUNT(*) FROM `ominous_warning_closers` WHERE (`ominous_warning_closers`.`warning_id` = 1 AND position = 1) +  (0.2ms) RELEASE SAVEPOINT active_record_1 + Ominous::Warning Load (0.3ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 + Ominous::Closer Load (0.6ms) SELECT `ominous_closers`.* FROM `ominous_closers` INNER JOIN `ominous_warning_closers` ON `ominous_closers`.`id` = `ominous_warning_closers`.`closer_id` WHERE `ominous_warning_closers`.`warning_id` = 1 ORDER BY position +  (42.0ms) ROLLBACK +  (0.2ms) BEGIN + Ominous::Warning Load (0.3ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 + Ominous::Closer Load (0.3ms) SELECT `ominous_closers`.* FROM `ominous_closers` WHERE `ominous_closers`.`id` = 1 LIMIT 1 +  (0.3ms) ROLLBACK +  (0.8ms) BEGIN + Ominous::Warning Load (0.4ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 + Ominous::Closer Load (0.4ms) SELECT `ominous_closers`.* FROM `ominous_closers` WHERE `ominous_closers`.`id` = 1 LIMIT 1 + Ominous::Warning Exists (0.6ms) SELECT 1 AS one FROM `ominous_warnings` WHERE `ominous_warnings`.`name` = 'thing_alert' LIMIT 1 +  (0.3ms) ROLLBACK +  (0.3ms) BEGIN + Ominous::Warning Load (0.3ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 + Ominous::Closer Load (0.3ms) SELECT `ominous_closers`.* FROM `ominous_closers` WHERE `ominous_closers`.`id` = 1 LIMIT 1 + Ominous::Warning Exists (0.6ms) SELECT 1 AS one FROM `ominous_warnings` WHERE `ominous_warnings`.`name` = 'does_not_exist' LIMIT 1 +  (0.3ms) ROLLBACK +  (0.3ms) BEGIN + Ominous::Warning Load (0.3ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 +Processing by Ominous::WarningsController#dismiss as HTML + Parameters: {"id"=>"1"} + Ominous::Warning Load (0.5ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 + Rendered text template (0.0ms) +Completed 200 OK in 45ms (Views: 42.1ms | ActiveRecord: 0.5ms) +  (0.4ms) ROLLBACK +  (0.3ms) BEGIN +  (0.3ms) ROLLBACK +  (0.3ms) BEGIN + Thing Load (0.5ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 1 LIMIT 1 + Thing Load (0.6ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 2 LIMIT 1 + Ominous::Warning Load (0.4ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 +  (0.7ms) SELECT COUNT(*) FROM `things` +Processing by ThingsController#create as HTML + Parameters: {"thing"=>{"name"=>"Foo"}} +  (0.5ms) SAVEPOINT active_record_1 + SQL (0.5ms) INSERT INTO `things` (`created_at`, `has_warning`, `name`, `updated_at`) VALUES ('2012-12-10 15:30:35', NULL, 'Foo', '2012-12-10 15:30:35') +  (0.3ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/things/5 +Completed 302 Found in 10ms (ActiveRecord: 1.2ms) +  (0.5ms) SELECT COUNT(*) FROM `things` +  (47.5ms) ROLLBACK +  (4.9ms) BEGIN + Thing Load (3.5ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 1 LIMIT 1 + Thing Load (1.4ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 2 LIMIT 1 + Ominous::Warning Load (0.9ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 +  (1.2ms) SELECT COUNT(*) FROM `things` +Processing by ThingsController#destroy as HTML + Parameters: {"id"=>"1"} + Thing Load (0.5ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 1 LIMIT 1 +  (0.4ms) SAVEPOINT active_record_1 + SQL (0.9ms) DELETE FROM `things` WHERE `things`.`id` = 1 +  (0.4ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/things +Completed 302 Found in 9ms (ActiveRecord: 2.2ms) +  (0.6ms) SELECT COUNT(*) FROM `things`  +  (40.5ms) ROLLBACK +  (0.4ms) BEGIN + Thing Load (0.9ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 1 LIMIT 1 + Thing Load (2.5ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 2 LIMIT 1 + Ominous::Warning Load (0.5ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 +Processing by ThingsController#edit as HTML + Parameters: {"id"=>"1"} + Thing Load (0.5ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 1 LIMIT 1 + Rendered things/_form.html.erb (12.9ms) + Ominous::Warning Load (0.5ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`name` = 'thing_alert' LIMIT 1 + Ominous::Closer Load (0.7ms) SELECT `ominous_closers`.* FROM `ominous_closers` INNER JOIN `ominous_warning_closers` ON `ominous_closers`.`id` = `ominous_warning_closers`.`closer_id` WHERE `ominous_warning_closers`.`warning_id` = 1 ORDER BY position + Rendered /home/rob/web/ominous/app/views/ominous/warnings/_list.html.erb (7.7ms) +Completed 200 OK in 44ms (Views: 39.6ms | ActiveRecord: 1.7ms) +  (0.3ms) ROLLBACK +  (0.3ms) BEGIN + Thing Load (0.4ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 1 LIMIT 1 + Thing Load (0.3ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 2 LIMIT 1 + Ominous::Warning Load (0.3ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 +Processing by ThingsController#index as HTML + Thing Load (0.5ms) SELECT `things`.* FROM `things`  +Completed 200 OK in 8ms (Views: 5.9ms | ActiveRecord: 0.5ms) +  (0.3ms) ROLLBACK +  (0.5ms) BEGIN + Thing Load (0.3ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 1 LIMIT 1 + Thing Load (0.3ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 2 LIMIT 1 + Ominous::Warning Load (0.3ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 +Processing by ThingsController#new as HTML + Rendered things/_form.html.erb (4.6ms) +Completed 200 OK in 8ms (Views: 7.9ms | ActiveRecord: 0.0ms) +  (0.3ms) ROLLBACK +  (0.2ms) BEGIN + Thing Load (0.4ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 1 LIMIT 1 + Thing Load (0.3ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 2 LIMIT 1 + Ominous::Warning Load (0.4ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 +Processing by ThingsController#show as HTML + Parameters: {"id"=>"1"} + Thing Load (0.5ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 1 LIMIT 1 + Ominous::Warning Load (0.5ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`name` = 'thing_alert' LIMIT 1 + Ominous::Closer Load (0.4ms) SELECT `ominous_closers`.* FROM `ominous_closers` INNER JOIN `ominous_warning_closers` ON `ominous_closers`.`id` = `ominous_warning_closers`.`closer_id` WHERE `ominous_warning_closers`.`warning_id` = 1 ORDER BY position + Rendered /home/rob/web/ominous/app/views/ominous/warnings/_list.html.erb (3.3ms) +Completed 200 OK in 42ms (Views: 38.6ms | ActiveRecord: 1.5ms) +  (0.4ms) ROLLBACK +  (0.2ms) BEGIN + Thing Load (0.4ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 1 LIMIT 1 + Thing Load (0.4ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 2 LIMIT 1 + Ominous::Warning Load (1.8ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 +Processing by ThingsController#show as HTML + Parameters: {"id"=>"1"} + Thing Load (4.1ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 1 LIMIT 1 +Completed 200 OK in 7ms (Views: 2.4ms | ActiveRecord: 4.1ms) +  (0.4ms) ROLLBACK +  (0.3ms) BEGIN + Thing Load (1.9ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 1 LIMIT 1 + Thing Load (4.6ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 2 LIMIT 1 + Ominous::Warning Load (0.4ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 +Processing by ThingsController#show as HTML + Parameters: {"id"=>"2"} + Thing Load (0.4ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 2 LIMIT 1 + Ominous::Warning Exists (6.8ms) SELECT 1 AS one FROM `ominous_warnings` WHERE `ominous_warnings`.`name` = 'thing_alert' LIMIT 1 + Ominous::Warning Load (0.5ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`name` = 'thing_alert' LIMIT 1 + Ominous::Closer Load (3.3ms) SELECT `ominous_closers`.* FROM `ominous_closers` INNER JOIN `ominous_warning_closers` ON `ominous_closers`.`id` = `ominous_warning_closers`.`closer_id` WHERE `ominous_warning_closers`.`warning_id` = 1 ORDER BY position + Rendered /home/rob/web/ominous/app/views/ominous/warnings/_list.html.erb (6.4ms) +Completed 200 OK in 23ms (Views: 9.1ms | ActiveRecord: 11.0ms) +  (1.1ms) ROLLBACK +  (0.2ms) BEGIN + Thing Load (1.7ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 1 LIMIT 1 + Thing Load (0.4ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 2 LIMIT 1 + Ominous::Warning Load (0.4ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 +Processing by ThingsController#show as HTML + Parameters: {"id"=>"1"} + Thing Load (0.4ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 1 LIMIT 1 +Completed 200 OK in 3ms (Views: 2.0ms | ActiveRecord: 0.4ms) +  (0.6ms) ROLLBACK +  (0.3ms) BEGIN + Thing Load (0.4ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 1 LIMIT 1 + Thing Load (0.6ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 2 LIMIT 1 + Ominous::Warning Load (0.4ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 +Processing by ThingsController#show as HTML + Parameters: {"id"=>"2"} + Thing Load (0.4ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 2 LIMIT 1 + Ominous::Warning Exists (0.4ms) SELECT 1 AS one FROM `ominous_warnings` WHERE `ominous_warnings`.`name` = 'thing_alert' LIMIT 1 +Completed 200 OK in 5ms (Views: 2.0ms | ActiveRecord: 0.8ms) +  (0.4ms) ROLLBACK +  (3.8ms) BEGIN + Thing Load (0.4ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 1 LIMIT 1 + Thing Load (1.0ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 2 LIMIT 1 + Ominous::Warning Load (1.0ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 +Processing by ThingsController#update as HTML + Parameters: {"thing"=>{"name"=>"Foo"}, "id"=>"1"} + Thing Load (0.7ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 1 LIMIT 1 +  (0.4ms) SAVEPOINT active_record_1 +  (0.4ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/things/1 +Completed 302 Found in 17ms (ActiveRecord: 1.4ms) +  (0.5ms) ROLLBACK +Connecting to database specified by database.yml +  (0.5ms) SELECT @@FOREIGN_KEY_CHECKS +  (7.7ms) SET FOREIGN_KEY_CHECKS = 0 +  (0.4ms) BEGIN + Fixture Delete (0.9ms) DELETE FROM `ominous_warnings` + Fixture Insert (0.5ms) INSERT INTO `ominous_warnings` (`id`, `name`, `created_at`, `updated_at`) VALUES (1, 'thing_alert', '2012-12-10 15:31:02', '2012-12-10 15:31:02') + Fixture Insert (0.6ms) INSERT INTO `ominous_warnings` (`id`, `name`, `created_at`, `updated_at`) VALUES (2, 'other_alert', '2012-12-10 15:31:02', '2012-12-10 15:31:02') + Fixture Delete (0.5ms) DELETE FROM `ominous_warning_closers` + Fixture Insert (0.5ms) INSERT INTO `ominous_warning_closers` (`warning_id`, `closer_id`, `position`, `created_at`, `updated_at`, `id`) VALUES (1, 1, 1, '2012-12-10 15:31:02', '2012-12-10 15:31:02', 980190962) + Fixture Insert (0.3ms) INSERT INTO `ominous_warning_closers` (`warning_id`, `closer_id`, `position`, `created_at`, `updated_at`, `id`) VALUES (1, 2, 2, '2012-12-10 15:31:02', '2012-12-10 15:31:02', 298486374) + Fixture Insert (0.3ms) INSERT INTO `ominous_warning_closers` (`warning_id`, `closer_id`, `position`, `created_at`, `updated_at`, `id`) VALUES (2, 2, 1, '2012-12-10 15:31:02', '2012-12-10 15:31:02', 113629430) + Fixture Delete (0.3ms) DELETE FROM `ominous_closers` + Fixture Insert (0.2ms) INSERT INTO `ominous_closers` (`id`, `name`, `closure_method`, `created_at`, `updated_at`) VALUES (1, 'closer_one', 'close_and_dismiss_warning', '2012-12-10 15:31:02', '2012-12-10 15:31:02') + Fixture Insert (2.0ms) INSERT INTO `ominous_closers` (`id`, `name`, `url`, `closure_method`, `created_at`, `updated_at`) VALUES (2, 'closer_two', 'http://undervale.co.uk', 'redirect', '2012-12-10 15:31:02', '2012-12-10 15:31:02') + Fixture Delete (0.3ms) DELETE FROM `things` + Fixture Insert (0.3ms) INSERT INTO `things` (`id`, `name`, `has_warning`, `created_at`, `updated_at`) VALUES (1, 'Foo', 0, '2012-12-10 15:31:02', '2012-12-10 15:31:02') + Fixture Insert (1.2ms) INSERT INTO `things` (`id`, `name`, `has_warning`, `created_at`, `updated_at`) VALUES (2, 'Bar', 1, '2012-12-10 15:31:02', '2012-12-10 15:31:02') +  (50.8ms) COMMIT +  (0.3ms) SET FOREIGN_KEY_CHECKS = 1 +  (0.2ms) BEGIN + Ominous::Warning Load (0.7ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 + Ominous::Closer Load (0.7ms) SELECT `ominous_closers`.* FROM `ominous_closers` WHERE `ominous_closers`.`id` = 1 LIMIT 1 +  (0.7ms) SELECT COUNT(*) FROM `ominous_warning_closers` +  (0.4ms) SAVEPOINT active_record_1 + Ominous::WarningCloser Load (7.0ms) SELECT `ominous_warning_closers`.* FROM `ominous_warning_closers` WHERE (`ominous_warning_closers`.`warning_id` = 1) ORDER BY ominous_warning_closers.position DESC LIMIT 1 + SQL (0.5ms) INSERT INTO `ominous_warning_closers` (`closer_id`, `created_at`, `position`, `updated_at`, `warning_id`) VALUES (1, '2012-12-10 15:31:02', 3, '2012-12-10 15:31:02', 1) +  (4.2ms) RELEASE SAVEPOINT active_record_1 +  (0.5ms) SELECT COUNT(*) FROM `ominous_warning_closers`  +  (32.5ms) ROLLBACK +  (0.2ms) BEGIN + Ominous::Warning Load (0.4ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 + Ominous::Closer Load (2.1ms) SELECT `ominous_closers`.* FROM `ominous_closers` WHERE `ominous_closers`.`id` = 1 LIMIT 1 + Ominous::Closer Exists (0.7ms) SELECT DISTINCT 1 AS one FROM `ominous_closers` INNER JOIN `ominous_warning_closers` ON `ominous_closers`.`id` = `ominous_warning_closers`.`closer_id` WHERE `ominous_warning_closers`.`warning_id` = 1 AND `ominous_closers`.`id` = 1 LIMIT 1 +  (0.3ms) ROLLBACK +  (0.3ms) BEGIN + Ominous::Warning Load (0.5ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 + Ominous::Closer Load (0.3ms) SELECT `ominous_closers`.* FROM `ominous_closers` WHERE `ominous_closers`.`id` = 1 LIMIT 1 + Ominous::Closer Load (0.6ms) SELECT DISTINCT `ominous_closers`.* FROM `ominous_closers` INNER JOIN `ominous_warning_closers` ON `ominous_closers`.`id` = `ominous_warning_closers`.`closer_id` WHERE `ominous_warning_closers`.`warning_id` = 1 AND `ominous_closers`.`id` = 1 ORDER BY position LIMIT 1 +  (0.4ms) ROLLBACK +  (0.3ms) BEGIN + Ominous::Warning Load (0.3ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 + Ominous::Closer Load (0.3ms) SELECT `ominous_closers`.* FROM `ominous_closers` WHERE `ominous_closers`.`id` = 1 LIMIT 1 + Ominous::Closer Load (0.3ms) SELECT `ominous_closers`.* FROM `ominous_closers` WHERE `ominous_closers`.`id` = 1 LIMIT 1 + Ominous::Closer Load (0.4ms) SELECT `ominous_closers`.* FROM `ominous_closers` WHERE `ominous_closers`.`id` = 2 LIMIT 1 + Ominous::Closer Load (2.7ms) SELECT DISTINCT `ominous_closers`.* FROM `ominous_closers` INNER JOIN `ominous_warning_closers` ON `ominous_closers`.`id` = `ominous_warning_closers`.`closer_id` WHERE `ominous_warning_closers`.`warning_id` = 1 ORDER BY position + Ominous::WarningCloser Load (0.6ms) SELECT DISTINCT `ominous_warning_closers`.* FROM `ominous_warning_closers` WHERE `ominous_warning_closers`.`warning_id` = 1 AND `ominous_warning_closers`.`closer_id` = 2 ORDER BY position LIMIT 1 +  (0.5ms) SAVEPOINT active_record_1 + SQL (0.4ms) UPDATE `ominous_warning_closers` SET position = (position + 1) WHERE (`ominous_warning_closers`.`warning_id` = 1 AND position < 2) +  (0.6ms) UPDATE `ominous_warning_closers` SET `position` = 1, `updated_at` = '2012-12-10 15:31:02' WHERE `ominous_warning_closers`.`id` = 298486374 +  (4.0ms) SELECT COUNT(*) FROM `ominous_warning_closers` WHERE (`ominous_warning_closers`.`warning_id` = 1 AND position = 1) +  (0.5ms) RELEASE SAVEPOINT active_record_1 + Ominous::Warning Load (0.3ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 + Ominous::Closer Load (0.7ms) SELECT DISTINCT `ominous_closers`.* FROM `ominous_closers` INNER JOIN `ominous_warning_closers` ON `ominous_closers`.`id` = `ominous_warning_closers`.`closer_id` WHERE `ominous_warning_closers`.`warning_id` = 1 ORDER BY position +  (41.8ms) ROLLBACK +  (0.3ms) BEGIN + Ominous::Warning Load (0.3ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 + Ominous::Closer Load (0.3ms) SELECT `ominous_closers`.* FROM `ominous_closers` WHERE `ominous_closers`.`id` = 1 LIMIT 1 +  (0.7ms) ROLLBACK +  (0.2ms) BEGIN + Ominous::Warning Load (0.3ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 + Ominous::Closer Load (0.3ms) SELECT `ominous_closers`.* FROM `ominous_closers` WHERE `ominous_closers`.`id` = 1 LIMIT 1 + Ominous::Warning Exists (0.5ms) SELECT 1 AS one FROM `ominous_warnings` WHERE `ominous_warnings`.`name` = 'thing_alert' LIMIT 1 +  (0.3ms) ROLLBACK +  (0.2ms) BEGIN + Ominous::Warning Load (0.5ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 + Ominous::Closer Load (0.3ms) SELECT `ominous_closers`.* FROM `ominous_closers` WHERE `ominous_closers`.`id` = 1 LIMIT 1 + Ominous::Warning Exists (0.4ms) SELECT 1 AS one FROM `ominous_warnings` WHERE `ominous_warnings`.`name` = 'does_not_exist' LIMIT 1 +  (0.3ms) ROLLBACK +  (0.3ms) BEGIN + Ominous::Warning Load (0.3ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 +Processing by Ominous::WarningsController#dismiss as HTML + Parameters: {"id"=>"1"} + Ominous::Warning Load (0.6ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 + Rendered text template (0.0ms) +Completed 200 OK in 47ms (Views: 44.1ms | ActiveRecord: 0.6ms) +  (0.4ms) ROLLBACK +  (0.4ms) BEGIN +  (0.5ms) ROLLBACK +  (0.3ms) BEGIN + Thing Load (0.5ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 1 LIMIT 1 + Thing Load (0.8ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 2 LIMIT 1 + Ominous::Warning Load (0.5ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 +  (0.5ms) SELECT COUNT(*) FROM `things` +Processing by ThingsController#create as HTML + Parameters: {"thing"=>{"name"=>"Foo"}} +  (0.6ms) SAVEPOINT active_record_1 + SQL (0.6ms) INSERT INTO `things` (`created_at`, `has_warning`, `name`, `updated_at`) VALUES ('2012-12-10 15:31:03', NULL, 'Foo', '2012-12-10 15:31:03') +  (0.3ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/things/6 +Completed 302 Found in 13ms (ActiveRecord: 1.5ms) +  (1.4ms) SELECT COUNT(*) FROM `things` +  (41.1ms) ROLLBACK +  (1.1ms) BEGIN + Thing Load (3.0ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 1 LIMIT 1 + Thing Load (1.7ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 2 LIMIT 1 + Ominous::Warning Load (1.2ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 +  (0.5ms) SELECT COUNT(*) FROM `things` +Processing by ThingsController#destroy as HTML + Parameters: {"id"=>"1"} + Thing Load (0.5ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 1 LIMIT 1 +  (0.5ms) SAVEPOINT active_record_1 + SQL (0.7ms) DELETE FROM `things` WHERE `things`.`id` = 1 +  (0.3ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/things +Completed 302 Found in 7ms (ActiveRecord: 1.9ms) +  (0.5ms) SELECT COUNT(*) FROM `things`  +  (42.2ms) ROLLBACK +  (0.3ms) BEGIN + Thing Load (0.5ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 1 LIMIT 1 + Thing Load (0.6ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 2 LIMIT 1 + Ominous::Warning Load (0.3ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 +Processing by ThingsController#edit as HTML + Parameters: {"id"=>"1"} + Thing Load (0.3ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 1 LIMIT 1 + Rendered things/_form.html.erb (10.8ms) + Ominous::Warning Load (0.6ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`name` = 'thing_alert' LIMIT 1 + Ominous::Closer Load (0.8ms) SELECT DISTINCT `ominous_closers`.* FROM `ominous_closers` INNER JOIN `ominous_warning_closers` ON `ominous_closers`.`id` = `ominous_warning_closers`.`closer_id` WHERE `ominous_warning_closers`.`warning_id` = 1 ORDER BY position + Rendered /home/rob/web/ominous/app/views/ominous/warnings/_list.html.erb (7.5ms) +Completed 200 OK in 36ms (Views: 32.6ms | ActiveRecord: 1.7ms) +  (0.3ms) ROLLBACK +  (0.2ms) BEGIN + Thing Load (0.3ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 1 LIMIT 1 + Thing Load (0.3ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 2 LIMIT 1 + Ominous::Warning Load (0.3ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 +Processing by ThingsController#index as HTML + Thing Load (0.5ms) SELECT `things`.* FROM `things`  +Completed 200 OK in 10ms (Views: 8.3ms | ActiveRecord: 0.5ms) +  (0.4ms) ROLLBACK +  (0.3ms) BEGIN + Thing Load (1.7ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 1 LIMIT 1 + Thing Load (0.4ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 2 LIMIT 1 + Ominous::Warning Load (0.3ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 +Processing by ThingsController#new as HTML + Rendered things/_form.html.erb (2.0ms) +Completed 200 OK in 8ms (Views: 7.4ms | ActiveRecord: 0.0ms) +  (0.6ms) ROLLBACK +  (0.4ms) BEGIN + Thing Load (0.5ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 1 LIMIT 1 + Thing Load (0.4ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 2 LIMIT 1 + Ominous::Warning Load (0.4ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 +Processing by ThingsController#show as HTML + Parameters: {"id"=>"1"} + Thing Load (0.4ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 1 LIMIT 1 + Ominous::Warning Load (0.5ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`name` = 'thing_alert' LIMIT 1 + Ominous::Closer Load (0.5ms) SELECT DISTINCT `ominous_closers`.* FROM `ominous_closers` INNER JOIN `ominous_warning_closers` ON `ominous_closers`.`id` = `ominous_warning_closers`.`closer_id` WHERE `ominous_warning_closers`.`warning_id` = 1 ORDER BY position + Rendered /home/rob/web/ominous/app/views/ominous/warnings/_list.html.erb (3.7ms) +Completed 200 OK in 40ms (Views: 36.5ms | ActiveRecord: 1.4ms) +  (0.5ms) ROLLBACK +  (0.3ms) BEGIN + Thing Load (0.5ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 1 LIMIT 1 + Thing Load (0.5ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 2 LIMIT 1 + Ominous::Warning Load (0.3ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 +Processing by ThingsController#show as HTML + Parameters: {"id"=>"1"} + Thing Load (0.4ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 1 LIMIT 1 +Completed 200 OK in 4ms (Views: 2.4ms | ActiveRecord: 0.4ms) +  (0.4ms) ROLLBACK +  (0.3ms) BEGIN + Thing Load (0.4ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 1 LIMIT 1 + Thing Load (0.6ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 2 LIMIT 1 + Ominous::Warning Load (0.4ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 +Processing by ThingsController#show as HTML + Parameters: {"id"=>"2"} + Thing Load (0.4ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 2 LIMIT 1 + Ominous::Warning Exists (0.4ms) SELECT 1 AS one FROM `ominous_warnings` WHERE `ominous_warnings`.`name` = 'thing_alert' LIMIT 1 + Ominous::Warning Load (0.5ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`name` = 'thing_alert' LIMIT 1 + Ominous::Closer Load (0.7ms) SELECT DISTINCT `ominous_closers`.* FROM `ominous_closers` INNER JOIN `ominous_warning_closers` ON `ominous_closers`.`id` = `ominous_warning_closers`.`closer_id` WHERE `ominous_warning_closers`.`warning_id` = 1 ORDER BY position + Rendered /home/rob/web/ominous/app/views/ominous/warnings/_list.html.erb (3.6ms) +Completed 200 OK in 12ms (Views: 8.3ms | ActiveRecord: 2.0ms) +  (1.2ms) ROLLBACK +  (0.3ms) BEGIN + Thing Load (0.4ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 1 LIMIT 1 + Thing Load (0.3ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 2 LIMIT 1 + Ominous::Warning Load (0.4ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 +Processing by ThingsController#show as HTML + Parameters: {"id"=>"1"} + Thing Load (0.4ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 1 LIMIT 1 +Completed 200 OK in 3ms (Views: 1.9ms | ActiveRecord: 0.4ms) +  (0.6ms) ROLLBACK +  (0.3ms) BEGIN + Thing Load (0.6ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 1 LIMIT 1 + Thing Load (0.4ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 2 LIMIT 1 + Ominous::Warning Load (0.7ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 +Processing by ThingsController#show as HTML + Parameters: {"id"=>"2"} + Thing Load (4.5ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 2 LIMIT 1 + Ominous::Warning Exists (4.6ms) SELECT 1 AS one FROM `ominous_warnings` WHERE `ominous_warnings`.`name` = 'thing_alert' LIMIT 1 +Completed 200 OK in 14ms (Views: 2.0ms | ActiveRecord: 9.1ms) +  (5.2ms) ROLLBACK +  (0.3ms) BEGIN + Thing Load (0.4ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 1 LIMIT 1 + Thing Load (0.3ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 2 LIMIT 1 + Ominous::Warning Load (5.3ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 +Processing by ThingsController#update as HTML + Parameters: {"thing"=>{"name"=>"Foo"}, "id"=>"1"} + Thing Load (1.0ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 1 LIMIT 1 +  (0.4ms) SAVEPOINT active_record_1 +  (0.6ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/things/1 +Completed 302 Found in 8ms (ActiveRecord: 2.0ms) +  (1.4ms) ROLLBACK +Connecting to database specified by database.yml +  (0.7ms) SELECT @@FOREIGN_KEY_CHECKS +  (0.3ms) SET FOREIGN_KEY_CHECKS = 0 +  (0.4ms) BEGIN + Fixture Delete (1.3ms) DELETE FROM `ominous_warnings` + Fixture Insert (0.5ms) INSERT INTO `ominous_warnings` (`id`, `name`, `created_at`, `updated_at`) VALUES (1, 'thing_alert', '2012-12-10 15:58:09', '2012-12-10 15:58:09') + Fixture Insert (0.6ms) INSERT INTO `ominous_warnings` (`id`, `name`, `created_at`, `updated_at`) VALUES (2, 'other_alert', '2012-12-10 15:58:09', '2012-12-10 15:58:09') + Fixture Delete (0.4ms) DELETE FROM `ominous_warning_closers` + Fixture Insert (0.6ms) INSERT INTO `ominous_warning_closers` (`warning_id`, `closer_id`, `position`, `created_at`, `updated_at`, `id`) VALUES (1, 1, 1, '2012-12-10 15:58:10', '2012-12-10 15:58:10', 980190962) + Fixture Insert (0.4ms) INSERT INTO `ominous_warning_closers` (`warning_id`, `closer_id`, `position`, `created_at`, `updated_at`, `id`) VALUES (1, 2, 2, '2012-12-10 15:58:10', '2012-12-10 15:58:10', 298486374) + Fixture Insert (0.4ms) INSERT INTO `ominous_warning_closers` (`warning_id`, `closer_id`, `position`, `created_at`, `updated_at`, `id`) VALUES (2, 2, 1, '2012-12-10 15:58:10', '2012-12-10 15:58:10', 113629430) + Fixture Delete (0.5ms) DELETE FROM `ominous_closers` + Fixture Insert (0.4ms) INSERT INTO `ominous_closers` (`id`, `name`, `closure_method`, `created_at`, `updated_at`) VALUES (1, 'closer_one', 'close_and_dismiss_warning', '2012-12-10 15:58:10', '2012-12-10 15:58:10') + Fixture Insert (0.4ms) INSERT INTO `ominous_closers` (`id`, `name`, `url`, `closure_method`, `created_at`, `updated_at`) VALUES (2, 'closer_two', 'http://undervale.co.uk', 'redirect', '2012-12-10 15:58:10', '2012-12-10 15:58:10') + Fixture Delete (0.4ms) DELETE FROM `things` + Fixture Insert (0.7ms) INSERT INTO `things` (`id`, `name`, `has_warning`, `created_at`, `updated_at`) VALUES (1, 'Foo', 0, '2012-12-10 15:58:10', '2012-12-10 15:58:10') + Fixture Insert (0.5ms) INSERT INTO `things` (`id`, `name`, `has_warning`, `created_at`, `updated_at`) VALUES (2, 'Bar', 1, '2012-12-10 15:58:10', '2012-12-10 15:58:10') +  (80.5ms) COMMIT +  (0.8ms) SET FOREIGN_KEY_CHECKS = 1 +  (1.2ms) BEGIN + Ominous::Warning Load (1.9ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 + Ominous::Closer Load (0.9ms) SELECT `ominous_closers`.* FROM `ominous_closers` WHERE `ominous_closers`.`id` = 1 LIMIT 1 +  (1.3ms) SELECT COUNT(*) FROM `ominous_warning_closers` +  (0.5ms) SAVEPOINT active_record_1 + Ominous::WarningCloser Exists (0.7ms) SELECT 1 AS one FROM `ominous_warning_closers` WHERE (`ominous_warning_closers`.`closer_id` = BINARY 1 AND `ominous_warning_closers`.`warning_id` = 1) LIMIT 1 +  (0.4ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.4ms) ROLLBACK +  (4.1ms) BEGIN + Ominous::Warning Load (0.4ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 + Ominous::Closer Load (0.4ms) SELECT `ominous_closers`.* FROM `ominous_closers` WHERE `ominous_closers`.`id` = 1 LIMIT 1 + Ominous::Closer Exists (0.7ms) SELECT DISTINCT 1 AS one FROM `ominous_closers` INNER JOIN `ominous_warning_closers` ON `ominous_closers`.`id` = `ominous_warning_closers`.`closer_id` WHERE `ominous_warning_closers`.`warning_id` = 1 AND `ominous_closers`.`id` = 1 LIMIT 1 +  (0.3ms) ROLLBACK +  (0.3ms) BEGIN + Ominous::Warning Load (0.4ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 + Ominous::Closer Load (0.4ms) SELECT `ominous_closers`.* FROM `ominous_closers` WHERE `ominous_closers`.`id` = 1 LIMIT 1 + Ominous::Closer Load (0.8ms) SELECT DISTINCT `ominous_closers`.* FROM `ominous_closers` INNER JOIN `ominous_warning_closers` ON `ominous_closers`.`id` = `ominous_warning_closers`.`closer_id` WHERE `ominous_warning_closers`.`warning_id` = 1 AND `ominous_closers`.`id` = 1 ORDER BY position LIMIT 1 +  (0.4ms) ROLLBACK +  (0.3ms) BEGIN + Ominous::Warning Load (1.6ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 + Ominous::Closer Load (7.6ms) SELECT `ominous_closers`.* FROM `ominous_closers` WHERE `ominous_closers`.`id` = 1 LIMIT 1 + Ominous::Closer Load (0.4ms) SELECT `ominous_closers`.* FROM `ominous_closers` WHERE `ominous_closers`.`id` = 1 LIMIT 1 + Ominous::Closer Load (0.5ms) SELECT `ominous_closers`.* FROM `ominous_closers` WHERE `ominous_closers`.`id` = 2 LIMIT 1 + Ominous::Closer Load (0.9ms) SELECT DISTINCT `ominous_closers`.* FROM `ominous_closers` INNER JOIN `ominous_warning_closers` ON `ominous_closers`.`id` = `ominous_warning_closers`.`closer_id` WHERE `ominous_warning_closers`.`warning_id` = 1 ORDER BY position + Ominous::WarningCloser Load (0.6ms) SELECT DISTINCT `ominous_warning_closers`.* FROM `ominous_warning_closers` WHERE `ominous_warning_closers`.`warning_id` = 1 AND `ominous_warning_closers`.`closer_id` = 2 ORDER BY position LIMIT 1 +  (0.4ms) SAVEPOINT active_record_1 + SQL (0.5ms) UPDATE `ominous_warning_closers` SET position = (position + 1) WHERE (`ominous_warning_closers`.`warning_id` = 1 AND position < 2) + Ominous::WarningCloser Exists (0.7ms) SELECT 1 AS one FROM `ominous_warning_closers` WHERE (`ominous_warning_closers`.`closer_id` = BINARY 2 AND `ominous_warning_closers`.`id` != 298486374 AND `ominous_warning_closers`.`warning_id` = 1) LIMIT 1 +  (0.6ms) UPDATE `ominous_warning_closers` SET `position` = 1, `updated_at` = '2012-12-10 15:58:10' WHERE `ominous_warning_closers`.`id` = 298486374 +  (3.5ms) SELECT COUNT(*) FROM `ominous_warning_closers` WHERE (`ominous_warning_closers`.`warning_id` = 1 AND position = 1) +  (7.1ms) RELEASE SAVEPOINT active_record_1 + Ominous::Warning Load (2.8ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 + Ominous::Closer Load (0.9ms) SELECT DISTINCT `ominous_closers`.* FROM `ominous_closers` INNER JOIN `ominous_warning_closers` ON `ominous_closers`.`id` = `ominous_warning_closers`.`closer_id` WHERE `ominous_warning_closers`.`warning_id` = 1 ORDER BY position +  (67.9ms) ROLLBACK +  (1.0ms) BEGIN + Ominous::Warning Load (1.5ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 + Ominous::Closer Load (9.2ms) SELECT `ominous_closers`.* FROM `ominous_closers` WHERE `ominous_closers`.`id` = 1 LIMIT 1 +  (3.1ms) ROLLBACK +  (0.6ms) BEGIN + Ominous::Warning Load (0.5ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 + Ominous::Closer Load (2.0ms) SELECT `ominous_closers`.* FROM `ominous_closers` WHERE `ominous_closers`.`id` = 1 LIMIT 1 + Ominous::Warning Exists (0.8ms) SELECT 1 AS one FROM `ominous_warnings` WHERE `ominous_warnings`.`name` = 'thing_alert' LIMIT 1 +  (0.5ms) ROLLBACK +  (0.7ms) BEGIN + Ominous::Warning Load (0.5ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 + Ominous::Closer Load (0.5ms) SELECT `ominous_closers`.* FROM `ominous_closers` WHERE `ominous_closers`.`id` = 1 LIMIT 1 + Ominous::Warning Exists (0.7ms) SELECT 1 AS one FROM `ominous_warnings` WHERE `ominous_warnings`.`name` = 'does_not_exist' LIMIT 1 +  (1.1ms) ROLLBACK +  (0.5ms) BEGIN + Ominous::Warning Load (0.4ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 +Processing by Ominous::WarningsController#dismiss as HTML + Parameters: {"id"=>"1"} + Ominous::Warning Load (0.7ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 + Rendered text template (0.0ms) +Completed 200 OK in 40ms (Views: 37.4ms | ActiveRecord: 0.7ms) +  (0.7ms) ROLLBACK +  (0.3ms) BEGIN +  (0.3ms) ROLLBACK +  (0.3ms) BEGIN + Thing Load (1.8ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 1 LIMIT 1 + Thing Load (0.6ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 2 LIMIT 1 + Ominous::Warning Load (0.4ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 +  (0.5ms) SELECT COUNT(*) FROM `things`  +Processing by ThingsController#create as HTML + Parameters: {"thing"=>{"name"=>"Foo"}} +  (1.6ms) SAVEPOINT active_record_1 + SQL (0.5ms) INSERT INTO `things` (`created_at`, `has_warning`, `name`, `updated_at`) VALUES ('2012-12-10 15:58:10', NULL, 'Foo', '2012-12-10 15:58:10') +  (0.3ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/things/7 +Completed 302 Found in 10ms (ActiveRecord: 2.5ms) +  (0.7ms) SELECT COUNT(*) FROM `things`  +  (45.7ms) ROLLBACK +  (0.3ms) BEGIN + Thing Load (0.7ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 1 LIMIT 1 + Thing Load (1.4ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 2 LIMIT 1 + Ominous::Warning Load (0.4ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 +  (0.5ms) SELECT COUNT(*) FROM `things`  +Processing by ThingsController#destroy as HTML + Parameters: {"id"=>"1"} + Thing Load (0.4ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 1 LIMIT 1 +  (0.3ms) SAVEPOINT active_record_1 + SQL (0.5ms) DELETE FROM `things` WHERE `things`.`id` = 1 +  (0.3ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/things +Completed 302 Found in 6ms (ActiveRecord: 1.6ms) +  (0.5ms) SELECT COUNT(*) FROM `things` +  (46.5ms) ROLLBACK +  (0.3ms) BEGIN + Thing Load (0.6ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 1 LIMIT 1 + Thing Load (0.4ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 2 LIMIT 1 + Ominous::Warning Load (0.5ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 +Processing by ThingsController#edit as HTML + Parameters: {"id"=>"1"} + Thing Load (0.5ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 1 LIMIT 1 + Rendered things/_form.html.erb (3.9ms) + Ominous::Warning Load (2.7ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`name` = 'thing_alert' LIMIT 1 + Ominous::Closer Load (1.2ms) SELECT DISTINCT `ominous_closers`.* FROM `ominous_closers` INNER JOIN `ominous_warning_closers` ON `ominous_closers`.`id` = `ominous_warning_closers`.`closer_id` WHERE `ominous_warning_closers`.`warning_id` = 1 ORDER BY position + Rendered /home/rob/web/ominous/app/views/ominous/warnings/_list.html.erb (11.2ms) +Completed 200 OK in 35ms (Views: 28.8ms | ActiveRecord: 4.4ms) +  (0.4ms) ROLLBACK +  (0.3ms) BEGIN + Thing Load (0.4ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 1 LIMIT 1 + Thing Load (0.3ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 2 LIMIT 1 + Ominous::Warning Load (0.4ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 +Processing by ThingsController#index as HTML + Thing Load (0.6ms) SELECT `things`.* FROM `things` +Completed 200 OK in 11ms (Views: 8.9ms | ActiveRecord: 0.6ms) +  (0.4ms) ROLLBACK +  (0.3ms) BEGIN + Thing Load (0.6ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 1 LIMIT 1 + Thing Load (1.6ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 2 LIMIT 1 + Ominous::Warning Load (0.4ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 +Processing by ThingsController#new as HTML + Rendered things/_form.html.erb (2.8ms) +Completed 200 OK in 7ms (Views: 6.4ms | ActiveRecord: 0.0ms) +  (0.4ms) ROLLBACK +  (0.3ms) BEGIN + Thing Load (0.4ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 1 LIMIT 1 + Thing Load (0.3ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 2 LIMIT 1 + Ominous::Warning Load (28.2ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 +Processing by ThingsController#show as HTML + Parameters: {"id"=>"1"} + Thing Load (0.6ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 1 LIMIT 1 + Ominous::Warning Load (0.5ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`name` = 'thing_alert' LIMIT 1 + Ominous::Closer Load (0.5ms) SELECT DISTINCT `ominous_closers`.* FROM `ominous_closers` INNER JOIN `ominous_warning_closers` ON `ominous_closers`.`id` = `ominous_warning_closers`.`closer_id` WHERE `ominous_warning_closers`.`warning_id` = 1 ORDER BY position + Rendered /home/rob/web/ominous/app/views/ominous/warnings/_list.html.erb (5.8ms) +Completed 200 OK in 14ms (Views: 10.6ms | ActiveRecord: 1.6ms) +  (0.4ms) ROLLBACK +  (0.3ms) BEGIN + Thing Load (6.5ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 1 LIMIT 1 + Thing Load (0.5ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 2 LIMIT 1 + Ominous::Warning Load (0.4ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 +Processing by ThingsController#show as HTML + Parameters: {"id"=>"1"} + Thing Load (0.5ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 1 LIMIT 1 +Completed 200 OK in 4ms (Views: 2.2ms | ActiveRecord: 0.5ms) +  (9.4ms) ROLLBACK +  (0.3ms) BEGIN + Thing Load (0.4ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 1 LIMIT 1 + Thing Load (0.3ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 2 LIMIT 1 + Ominous::Warning Load (1.1ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 +Processing by ThingsController#show as HTML + Parameters: {"id"=>"2"} + Thing Load (4.2ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 2 LIMIT 1 + Ominous::Warning Exists (0.4ms) SELECT 1 AS one FROM `ominous_warnings` WHERE `ominous_warnings`.`name` = 'thing_alert' LIMIT 1 + Ominous::Warning Load (0.6ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`name` = 'thing_alert' LIMIT 1 + Ominous::Closer Load (4.1ms) SELECT DISTINCT `ominous_closers`.* FROM `ominous_closers` INNER JOIN `ominous_warning_closers` ON `ominous_closers`.`id` = `ominous_warning_closers`.`closer_id` WHERE `ominous_warning_closers`.`warning_id` = 1 ORDER BY position + Rendered /home/rob/web/ominous/app/views/ominous/warnings/_list.html.erb (12.8ms) +Completed 200 OK in 24ms (Views: 11.8ms | ActiveRecord: 9.3ms) +  (0.4ms) ROLLBACK +  (0.3ms) BEGIN + Thing Load (1.4ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 1 LIMIT 1 + Thing Load (3.5ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 2 LIMIT 1 + Ominous::Warning Load (0.4ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 +Processing by ThingsController#show as HTML + Parameters: {"id"=>"1"} + Thing Load (2.9ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 1 LIMIT 1 +Completed 200 OK in 6ms (Views: 1.4ms | ActiveRecord: 2.9ms) +  (0.4ms) ROLLBACK +  (0.3ms) BEGIN + Thing Load (1.8ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 1 LIMIT 1 + Thing Load (0.4ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 2 LIMIT 1 + Ominous::Warning Load (2.6ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 +Processing by ThingsController#show as HTML + Parameters: {"id"=>"2"} + Thing Load (1.0ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 2 LIMIT 1 + Ominous::Warning Exists (3.6ms) SELECT 1 AS one FROM `ominous_warnings` WHERE `ominous_warnings`.`name` = 'thing_alert' LIMIT 1 +Completed 200 OK in 10ms (Views: 2.2ms | ActiveRecord: 4.5ms) +  (4.1ms) ROLLBACK +  (0.3ms) BEGIN + Thing Load (0.3ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 1 LIMIT 1 + Thing Load (1.1ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 2 LIMIT 1 + Ominous::Warning Load (2.5ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 +Processing by ThingsController#update as HTML + Parameters: {"thing"=>{"name"=>"Foo"}, "id"=>"1"} + Thing Load (0.6ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 1 LIMIT 1 +  (0.4ms) SAVEPOINT active_record_1 +  (2.9ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/things/1 +Completed 302 Found in 13ms (ActiveRecord: 3.9ms) +  (2.7ms) ROLLBACK +Connecting to database specified by database.yml +  (0.4ms) SELECT @@FOREIGN_KEY_CHECKS +  (0.3ms) SET FOREIGN_KEY_CHECKS = 0 +  (0.3ms) BEGIN + Fixture Delete (1.0ms) DELETE FROM `ominous_warnings` + Fixture Insert (0.8ms) INSERT INTO `ominous_warnings` (`id`, `name`, `created_at`, `updated_at`) VALUES (1, 'thing_alert', '2012-12-10 15:58:56', '2012-12-10 15:58:56') + Fixture Insert (0.4ms) INSERT INTO `ominous_warnings` (`id`, `name`, `created_at`, `updated_at`) VALUES (2, 'other_alert', '2012-12-10 15:58:56', '2012-12-10 15:58:56') + Fixture Delete (0.4ms) DELETE FROM `ominous_warning_closers` + Fixture Insert (0.4ms) INSERT INTO `ominous_warning_closers` (`warning_id`, `closer_id`, `position`, `created_at`, `updated_at`, `id`) VALUES (1, 1, 1, '2012-12-10 15:58:56', '2012-12-10 15:58:56', 980190962) + Fixture Insert (0.4ms) INSERT INTO `ominous_warning_closers` (`warning_id`, `closer_id`, `position`, `created_at`, `updated_at`, `id`) VALUES (1, 2, 2, '2012-12-10 15:58:56', '2012-12-10 15:58:56', 298486374) + Fixture Insert (0.4ms) INSERT INTO `ominous_warning_closers` (`warning_id`, `closer_id`, `position`, `created_at`, `updated_at`, `id`) VALUES (2, 2, 1, '2012-12-10 15:58:56', '2012-12-10 15:58:56', 113629430) + Fixture Delete (0.5ms) DELETE FROM `ominous_closers` + Fixture Insert (0.4ms) INSERT INTO `ominous_closers` (`id`, `name`, `closure_method`, `created_at`, `updated_at`) VALUES (1, 'closer_one', 'close_and_dismiss_warning', '2012-12-10 15:58:56', '2012-12-10 15:58:56') + Fixture Insert (0.4ms) INSERT INTO `ominous_closers` (`id`, `name`, `url`, `closure_method`, `created_at`, `updated_at`) VALUES (2, 'closer_two', 'http://undervale.co.uk', 'redirect', '2012-12-10 15:58:56', '2012-12-10 15:58:56') + Fixture Delete (0.9ms) DELETE FROM `things` + Fixture Insert (0.4ms) INSERT INTO `things` (`id`, `name`, `has_warning`, `created_at`, `updated_at`) VALUES (1, 'Foo', 0, '2012-12-10 15:58:56', '2012-12-10 15:58:56') + Fixture Insert (1.8ms) INSERT INTO `things` (`id`, `name`, `has_warning`, `created_at`, `updated_at`) VALUES (2, 'Bar', 1, '2012-12-10 15:58:56', '2012-12-10 15:58:56') +  (43.9ms) COMMIT +  (0.2ms) SET FOREIGN_KEY_CHECKS = 1 +  (0.3ms) BEGIN + Ominous::Warning Load (0.5ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 + Ominous::Closer Load (5.0ms) SELECT `ominous_closers`.* FROM `ominous_closers` WHERE `ominous_closers`.`id` = 1 LIMIT 1 +  (0.5ms) SAVEPOINT active_record_1 + Ominous::WarningCloser Exists (0.6ms) SELECT 1 AS one FROM `ominous_warning_closers` WHERE (`ominous_warning_closers`.`closer_id` = BINARY 1 AND `ominous_warning_closers`.`warning_id` = 1) LIMIT 1 +  (0.4ms) ROLLBACK TO SAVEPOINT active_record_1 +  (0.3ms) ROLLBACK +  (0.3ms) BEGIN + Ominous::Warning Load (0.3ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 + Ominous::Closer Load (0.3ms) SELECT `ominous_closers`.* FROM `ominous_closers` WHERE `ominous_closers`.`id` = 1 LIMIT 1 + Ominous::Closer Exists (0.8ms) SELECT DISTINCT 1 AS one FROM `ominous_closers` INNER JOIN `ominous_warning_closers` ON `ominous_closers`.`id` = `ominous_warning_closers`.`closer_id` WHERE `ominous_warning_closers`.`warning_id` = 1 AND `ominous_closers`.`id` = 1 LIMIT 1 +  (0.5ms) ROLLBACK +  (0.3ms) BEGIN + Ominous::Warning Load (0.3ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 + Ominous::Closer Load (0.3ms) SELECT `ominous_closers`.* FROM `ominous_closers` WHERE `ominous_closers`.`id` = 1 LIMIT 1 + Ominous::Closer Load (0.7ms) SELECT DISTINCT `ominous_closers`.* FROM `ominous_closers` INNER JOIN `ominous_warning_closers` ON `ominous_closers`.`id` = `ominous_warning_closers`.`closer_id` WHERE `ominous_warning_closers`.`warning_id` = 1 AND `ominous_closers`.`id` = 1 ORDER BY position LIMIT 1 +  (0.3ms) ROLLBACK +  (0.3ms) BEGIN + Ominous::Warning Load (0.5ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 + Ominous::Closer Load (0.3ms) SELECT `ominous_closers`.* FROM `ominous_closers` WHERE `ominous_closers`.`id` = 1 LIMIT 1 + Ominous::Closer Load (0.3ms) SELECT `ominous_closers`.* FROM `ominous_closers` WHERE `ominous_closers`.`id` = 1 LIMIT 1 + Ominous::Closer Load (0.4ms) SELECT `ominous_closers`.* FROM `ominous_closers` WHERE `ominous_closers`.`id` = 2 LIMIT 1 + Ominous::Closer Load (0.6ms) SELECT DISTINCT `ominous_closers`.* FROM `ominous_closers` INNER JOIN `ominous_warning_closers` ON `ominous_closers`.`id` = `ominous_warning_closers`.`closer_id` WHERE `ominous_warning_closers`.`warning_id` = 1 ORDER BY position + Ominous::WarningCloser Load (1.7ms) SELECT DISTINCT `ominous_warning_closers`.* FROM `ominous_warning_closers` WHERE `ominous_warning_closers`.`warning_id` = 1 AND `ominous_warning_closers`.`closer_id` = 2 ORDER BY position LIMIT 1 +  (0.3ms) SAVEPOINT active_record_1 + SQL (0.6ms) UPDATE `ominous_warning_closers` SET position = (position + 1) WHERE (`ominous_warning_closers`.`warning_id` = 1 AND position < 2) + Ominous::WarningCloser Exists (0.6ms) SELECT 1 AS one FROM `ominous_warning_closers` WHERE (`ominous_warning_closers`.`closer_id` = BINARY 2 AND `ominous_warning_closers`.`id` != 298486374 AND `ominous_warning_closers`.`warning_id` = 1) LIMIT 1 +  (0.7ms) UPDATE `ominous_warning_closers` SET `position` = 1, `updated_at` = '2012-12-10 15:58:56' WHERE `ominous_warning_closers`.`id` = 298486374 +  (0.6ms) SELECT COUNT(*) FROM `ominous_warning_closers` WHERE (`ominous_warning_closers`.`warning_id` = 1 AND position = 1) +  (0.3ms) RELEASE SAVEPOINT active_record_1 + Ominous::Warning Load (0.3ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 + Ominous::Closer Load (0.6ms) SELECT DISTINCT `ominous_closers`.* FROM `ominous_closers` INNER JOIN `ominous_warning_closers` ON `ominous_closers`.`id` = `ominous_warning_closers`.`closer_id` WHERE `ominous_warning_closers`.`warning_id` = 1 ORDER BY position +  (41.9ms) ROLLBACK +  (0.3ms) BEGIN + Ominous::Warning Load (0.9ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 + Ominous::Closer Load (0.6ms) SELECT `ominous_closers`.* FROM `ominous_closers` WHERE `ominous_closers`.`id` = 1 LIMIT 1 +  (0.4ms) ROLLBACK +  (0.2ms) BEGIN + Ominous::Warning Load (0.3ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 + Ominous::Closer Load (0.3ms) SELECT `ominous_closers`.* FROM `ominous_closers` WHERE `ominous_closers`.`id` = 1 LIMIT 1 + Ominous::Warning Exists (0.5ms) SELECT 1 AS one FROM `ominous_warnings` WHERE `ominous_warnings`.`name` = 'thing_alert' LIMIT 1 +  (0.3ms) ROLLBACK +  (0.3ms) BEGIN + Ominous::Warning Load (0.6ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 + Ominous::Closer Load (0.5ms) SELECT `ominous_closers`.* FROM `ominous_closers` WHERE `ominous_closers`.`id` = 1 LIMIT 1 + Ominous::Warning Exists (0.4ms) SELECT 1 AS one FROM `ominous_warnings` WHERE `ominous_warnings`.`name` = 'does_not_exist' LIMIT 1 +  (0.3ms) ROLLBACK +  (0.2ms) BEGIN + Ominous::Warning Load (0.3ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 +Processing by Ominous::WarningsController#dismiss as HTML + Parameters: {"id"=>"1"} + Ominous::Warning Load (0.4ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 + Rendered text template (0.0ms) +Completed 200 OK in 36ms (Views: 34.2ms | ActiveRecord: 0.4ms) +  (0.3ms) ROLLBACK +  (0.5ms) BEGIN +  (0.3ms) ROLLBACK +  (0.3ms) BEGIN + Thing Load (0.7ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 1 LIMIT 1 + Thing Load (0.5ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 2 LIMIT 1 + Ominous::Warning Load (0.3ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 +  (0.5ms) SELECT COUNT(*) FROM `things` +Processing by ThingsController#create as HTML + Parameters: {"thing"=>{"name"=>"Foo"}} +  (0.3ms) SAVEPOINT active_record_1 + SQL (0.5ms) INSERT INTO `things` (`created_at`, `has_warning`, `name`, `updated_at`) VALUES ('2012-12-10 15:58:56', NULL, 'Foo', '2012-12-10 15:58:56') +  (0.3ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/things/8 +Completed 302 Found in 11ms (ActiveRecord: 1.0ms) +  (0.5ms) SELECT COUNT(*) FROM `things` +  (47.0ms) ROLLBACK +  (0.3ms) BEGIN + Thing Load (0.5ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 1 LIMIT 1 + Thing Load (0.5ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 2 LIMIT 1 + Ominous::Warning Load (0.3ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 +  (0.3ms) SELECT COUNT(*) FROM `things` +Processing by ThingsController#destroy as HTML + Parameters: {"id"=>"1"} + Thing Load (0.4ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 1 LIMIT 1 +  (0.3ms) SAVEPOINT active_record_1 + SQL (0.4ms) DELETE FROM `things` WHERE `things`.`id` = 1 +  (0.3ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/things +Completed 302 Found in 5ms (ActiveRecord: 1.3ms) +  (0.5ms) SELECT COUNT(*) FROM `things`  +  (40.0ms) ROLLBACK +  (2.6ms) BEGIN + Thing Load (1.0ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 1 LIMIT 1 + Thing Load (0.8ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 2 LIMIT 1 + Ominous::Warning Load (0.6ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 +Processing by ThingsController#edit as HTML + Parameters: {"id"=>"1"} + Thing Load (0.4ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 1 LIMIT 1 + Rendered things/_form.html.erb (4.3ms) + Ominous::Warning Load (0.5ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`name` = 'thing_alert' LIMIT 1 + Ominous::Closer Load (0.8ms) SELECT DISTINCT `ominous_closers`.* FROM `ominous_closers` INNER JOIN `ominous_warning_closers` ON `ominous_closers`.`id` = `ominous_warning_closers`.`closer_id` WHERE `ominous_warning_closers`.`warning_id` = 1 ORDER BY position + Rendered /home/rob/web/ominous/app/views/ominous/warnings/_list.html.erb (7.6ms) +Completed 200 OK in 32ms (Views: 28.7ms | ActiveRecord: 1.7ms) +  (0.3ms) ROLLBACK +  (0.3ms) BEGIN + Thing Load (0.6ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 1 LIMIT 1 + Thing Load (0.3ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 2 LIMIT 1 + Ominous::Warning Load (0.3ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 +Processing by ThingsController#index as HTML + Thing Load (0.5ms) SELECT `things`.* FROM `things`  +Completed 200 OK in 8ms (Views: 6.3ms | ActiveRecord: 0.5ms) +  (0.3ms) ROLLBACK +  (0.2ms) BEGIN + Thing Load (0.3ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 1 LIMIT 1 + Thing Load (0.3ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 2 LIMIT 1 + Ominous::Warning Load (0.4ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 +Processing by ThingsController#new as HTML + Rendered things/_form.html.erb (4.3ms) +Completed 200 OK in 8ms (Views: 7.5ms | ActiveRecord: 0.0ms) +  (0.3ms) ROLLBACK +  (0.3ms) BEGIN + Thing Load (0.3ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 1 LIMIT 1 + Thing Load (0.4ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 2 LIMIT 1 + Ominous::Warning Load (0.4ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 +Processing by ThingsController#show as HTML + Parameters: {"id"=>"1"} + Thing Load (0.4ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 1 LIMIT 1 + Ominous::Warning Load (0.4ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`name` = 'thing_alert' LIMIT 1 + Ominous::Closer Load (0.4ms) SELECT DISTINCT `ominous_closers`.* FROM `ominous_closers` INNER JOIN `ominous_warning_closers` ON `ominous_closers`.`id` = `ominous_warning_closers`.`closer_id` WHERE `ominous_warning_closers`.`warning_id` = 1 ORDER BY position + Rendered /home/rob/web/ominous/app/views/ominous/warnings/_list.html.erb (3.6ms) +Completed 200 OK in 13ms (Views: 9.7ms | ActiveRecord: 1.2ms) +  (0.4ms) ROLLBACK +  (0.2ms) BEGIN + Thing Load (0.4ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 1 LIMIT 1 + Thing Load (0.3ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 2 LIMIT 1 + Ominous::Warning Load (0.3ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 +Processing by ThingsController#show as HTML + Parameters: {"id"=>"1"} + Thing Load (0.4ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 1 LIMIT 1 +Completed 200 OK in 5ms (Views: 3.9ms | ActiveRecord: 0.4ms) +  (0.4ms) ROLLBACK +  (0.3ms) BEGIN + Thing Load (0.4ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 1 LIMIT 1 + Thing Load (0.7ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 2 LIMIT 1 + Ominous::Warning Load (0.3ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 +Processing by ThingsController#show as HTML + Parameters: {"id"=>"2"} + Thing Load (2.9ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 2 LIMIT 1 + Ominous::Warning Exists (0.4ms) SELECT 1 AS one FROM `ominous_warnings` WHERE `ominous_warnings`.`name` = 'thing_alert' LIMIT 1 + Ominous::Warning Load (3.7ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`name` = 'thing_alert' LIMIT 1 + Ominous::Closer Load (4.7ms) SELECT DISTINCT `ominous_closers`.* FROM `ominous_closers` INNER JOIN `ominous_warning_closers` ON `ominous_closers`.`id` = `ominous_warning_closers`.`closer_id` WHERE `ominous_warning_closers`.`warning_id` = 1 ORDER BY position + Rendered /home/rob/web/ominous/app/views/ominous/warnings/_list.html.erb (7.3ms) +Completed 200 OK in 21ms (Views: 6.2ms | ActiveRecord: 11.6ms) +  (0.4ms) ROLLBACK +  (0.3ms) BEGIN + Thing Load (1.5ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 1 LIMIT 1 + Thing Load (4.0ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 2 LIMIT 1 + Ominous::Warning Load (0.4ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 +Processing by ThingsController#show as HTML + Parameters: {"id"=>"1"} + Thing Load (3.9ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 1 LIMIT 1 +Completed 200 OK in 8ms (Views: 4.2ms | ActiveRecord: 3.9ms) +  (5.4ms) ROLLBACK +  (0.3ms) BEGIN + Thing Load (0.4ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 1 LIMIT 1 + Thing Load (0.4ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 2 LIMIT 1 + Ominous::Warning Load (0.3ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 +Processing by ThingsController#show as HTML + Parameters: {"id"=>"2"} + Thing Load (6.2ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 2 LIMIT 1 + Ominous::Warning Exists (0.4ms) SELECT 1 AS one FROM `ominous_warnings` WHERE `ominous_warnings`.`name` = 'thing_alert' LIMIT 1 +Completed 200 OK in 10ms (Views: 2.0ms | ActiveRecord: 6.6ms) +  (10.7ms) ROLLBACK +  (0.3ms) BEGIN + Thing Load (0.4ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 1 LIMIT 1 + Thing Load (0.3ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 2 LIMIT 1 + Ominous::Warning Load (0.4ms) SELECT `ominous_warnings`.* FROM `ominous_warnings` WHERE `ominous_warnings`.`id` = 1 LIMIT 1 +Processing by ThingsController#update as HTML + Parameters: {"thing"=>{"name"=>"Foo"}, "id"=>"1"} + Thing Load (5.3ms) SELECT `things`.* FROM `things` WHERE `things`.`id` = 1 LIMIT 1 +  (0.4ms) SAVEPOINT active_record_1 +  (0.3ms) RELEASE SAVEPOINT active_record_1 +Redirected to http://test.host/things/1 +Completed 302 Found in 12ms (ActiveRecord: 6.0ms) +  (0.4ms) ROLLBACK