test/dummy/log/test.log in sidejobs-4.0.0.0 vs test/dummy/log/test.log in sidejobs-4.0.0.1
- old
+ new
@@ -776,5 +776,1685 @@
[1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
[1m[35m (0.2ms)[0m SELECT COUNT(*) FROM "sidejobs" WHERE "sidejobs"."status" = $1 [["status", "complete"]]
[1m[36m (0.2ms)[0m [1mSELECT COUNT(*) FROM "sidejobs" WHERE "sidejobs"."status" = $1[0m [["status", "processing"]]
[1m[35m (0.2ms)[0m SELECT COUNT(*) FROM "sidejobs" WHERE "sidejobs"."status" = $1 [["status", "pending"]]
[1m[36m (0.1ms)[0m [1mROLLBACK[0m
+ [1m[36mActiveRecord::SchemaMigration Load (2.6ms)[0m [1mSELECT "schema_migrations".* FROM "schema_migrations"[0m
+ [1m[35m (0.2ms)[0m BEGIN
+------------------------
+DaemonTest: test_process
+------------------------
+ [1m[36mSidejobs::Job Load (4.4ms)[0m [1mSELECT "sidejobs".* FROM "sidejobs" WHERE "sidejobs"."status" IN ('pending', 'failing') AND (attempts < 3) AND (scheduled_at <= '2016-12-11 05:28:01.075226' OR scheduled_at IS NULL) ORDER BY "sidejobs"."priority" DESC LIMIT 20[0m
+ [1m[36mSidejobs::Job Load (1.1ms)[0m [1mSELECT "sidejobs".* FROM "sidejobs" WHERE "sidejobs"."status" IN ('pending', 'failing') AND (attempts < 3) AND (scheduled_at <= '2016-12-11 05:28:05.084421' OR scheduled_at IS NULL) ORDER BY "sidejobs"."priority" DESC LIMIT 20[0m
+ [1m[36mActiveRecord::SchemaMigration Load (0.3ms)[0m [1mSELECT "schema_migrations".* FROM "schema_migrations"[0m
+ [1m[35m (0.3ms)[0m BEGIN
+------------------------
+DaemonTest: test_process
+------------------------
+ [1m[35mSidejobs::Job Load (0.5ms)[0m SELECT "sidejobs".* FROM "sidejobs" WHERE "sidejobs"."status" IN ('pending', 'failing') AND (attempts < 3) AND (scheduled_at <= '2016-12-11 05:28:20.098248' OR scheduled_at IS NULL) ORDER BY "sidejobs"."priority" DESC LIMIT 20
+ [1m[36mSidejobs::Job Load (1.2ms)[0m [1mSELECT "sidejobs".* FROM "sidejobs" WHERE "sidejobs"."status" IN ('pending', 'failing') AND (attempts < 3) AND (scheduled_at <= '2016-12-11 05:28:23.313842' OR scheduled_at IS NULL) ORDER BY "sidejobs"."priority" DESC LIMIT 20[0m
+ [1m[36m (0.1ms)[0m [1mBEGIN[0m
+------------------------
+DaemonTest: test_pulling
+------------------------
+ [1m[35m (0.2ms)[0m ROLLBACK
+ [1m[36m (0.1ms)[0m [1mBEGIN[0m
+-----------------------
+QueueTest: test_enqueue
+-----------------------
+[ActiveJob] [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+[ActiveJob] [1m[36mSQL (22.8ms)[0m [1mINSERT INTO "sidejobs" ("data", "queue", "priority", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id"[0m [["data", "{\"job_class\":\"ActionMailer::DeliveryJob\",\"job_id\":\"9652df1f-ed6f-49de-9df1-3592e561b6aa\",\"queue_name\":\"mailers\",\"arguments\":[\"UserMailer\",\"invite\",\"deliver_now\",\"test@mail.com\"],\"locale\":\"en\"}"], ["queue", "mailers"], ["priority", 80], ["created_at", "2016-12-11 05:28:43.335531"], ["updated_at", "2016-12-11 05:28:43.335531"]]
+[ActiveJob] [1m[35m (0.2ms)[0m RELEASE SAVEPOINT active_record_1
+[ActiveJob] Enqueued ActionMailer::DeliveryJob (Job ID: 9652df1f-ed6f-49de-9df1-3592e561b6aa) to Sidejobs(mailers) with arguments: "UserMailer", "invite", "deliver_now", "test@mail.com"
+ [1m[36mSidejobs::Job Load (0.5ms)[0m [1mSELECT "sidejobs".* FROM "sidejobs" ORDER BY "sidejobs"."id" DESC LIMIT 1[0m
+[ActiveJob] [1m[35m (0.2ms)[0m SAVEPOINT active_record_1
+[ActiveJob] [1m[36mSQL (0.3ms)[0m [1mINSERT INTO "sidejobs" ("data", "queue", "priority", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id"[0m [["data", "{\"job_class\":\"ChargeSubscriptionsJob\",\"job_id\":\"70fa2f43-afc8-4913-b08e-4d11e2b336dd\",\"queue_name\":\"high_priority\",\"arguments\":[],\"locale\":\"en\"}"], ["queue", "high_priority"], ["priority", 60], ["created_at", "2016-12-11 05:28:43.366191"], ["updated_at", "2016-12-11 05:28:43.366191"]]
+[ActiveJob] [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+[ActiveJob] Enqueued ChargeSubscriptionsJob (Job ID: 70fa2f43-afc8-4913-b08e-4d11e2b336dd) to Sidejobs(high_priority)
+ [1m[36mSidejobs::Job Load (0.3ms)[0m [1mSELECT "sidejobs".* FROM "sidejobs" ORDER BY "sidejobs"."id" DESC LIMIT 1[0m
+[ActiveJob] [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+[ActiveJob] [1m[36mSQL (0.2ms)[0m [1mINSERT INTO "sidejobs" ("data", "queue", "priority", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id"[0m [["data", "{\"job_class\":\"SendNewslettersJob\",\"job_id\":\"7523fbe7-f4e0-48d5-90d0-f45e99fe34d9\",\"queue_name\":\"default\",\"arguments\":[],\"locale\":\"en\"}"], ["queue", "default"], ["priority", 40], ["created_at", "2016-12-11 05:28:43.370433"], ["updated_at", "2016-12-11 05:28:43.370433"]]
+[ActiveJob] [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+[ActiveJob] Enqueued SendNewslettersJob (Job ID: 7523fbe7-f4e0-48d5-90d0-f45e99fe34d9) to Sidejobs(default)
+ [1m[36mSidejobs::Job Load (0.3ms)[0m [1mSELECT "sidejobs".* FROM "sidejobs" ORDER BY "sidejobs"."id" DESC LIMIT 1[0m
+[ActiveJob] [1m[35m (0.2ms)[0m SAVEPOINT active_record_1
+[ActiveJob] [1m[36mSQL (0.2ms)[0m [1mINSERT INTO "sidejobs" ("data", "queue", "priority", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id"[0m [["data", "{\"job_class\":\"UpdateExchangesJob\",\"job_id\":\"a43e349e-1c52-474d-8f43-2a6c2c104981\",\"queue_name\":\"low_priority\",\"arguments\":[],\"locale\":\"en\"}"], ["queue", "low_priority"], ["priority", 20], ["created_at", "2016-12-11 05:28:43.374460"], ["updated_at", "2016-12-11 05:28:43.374460"]]
+[ActiveJob] [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+[ActiveJob] Enqueued UpdateExchangesJob (Job ID: a43e349e-1c52-474d-8f43-2a6c2c104981) to Sidejobs(low_priority)
+ [1m[36mSidejobs::Job Load (0.2ms)[0m [1mSELECT "sidejobs".* FROM "sidejobs" ORDER BY "sidejobs"."id" DESC LIMIT 1[0m
+[ActiveJob] [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+[ActiveJob] [1m[36mSQL (0.2ms)[0m [1mINSERT INTO "sidejobs" ("data", "queue", "created_at", "updated_at") VALUES ($1, $2, $3, $4) RETURNING "id"[0m [["data", "{\"job_class\":\"ClearGuestUsersJob\",\"job_id\":\"c6990fb9-ee95-4288-9bd6-3c227bcf3269\",\"queue_name\":\"other\",\"arguments\":[],\"locale\":\"en\"}"], ["queue", "other"], ["created_at", "2016-12-11 05:28:43.378107"], ["updated_at", "2016-12-11 05:28:43.378107"]]
+[ActiveJob] [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+[ActiveJob] Enqueued ClearGuestUsersJob (Job ID: c6990fb9-ee95-4288-9bd6-3c227bcf3269) to Sidejobs(other)
+ [1m[36mSidejobs::Job Load (0.2ms)[0m [1mSELECT "sidejobs".* FROM "sidejobs" ORDER BY "sidejobs"."id" DESC LIMIT 1[0m
+[ActiveJob] [1m[35m (0.2ms)[0m SAVEPOINT active_record_1
+[ActiveJob] [1m[36mSQL (0.2ms)[0m [1mINSERT INTO "sidejobs" ("data", "queue", "priority", "scheduled_at", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5, $6) RETURNING "id"[0m [["data", "{\"job_class\":\"ActionMailer::DeliveryJob\",\"job_id\":\"d9619ad6-264f-4f62-a6d0-3d5babb0ac61\",\"queue_name\":\"mailers\",\"arguments\":[\"UserMailer\",\"invite\",\"deliver_now\",\"test@mail.com\"],\"locale\":\"en\"}"], ["queue", "mailers"], ["priority", 80], ["scheduled_at", "2016-12-11 15:28:43.386530"], ["created_at", "2016-12-11 05:28:43.387932"], ["updated_at", "2016-12-11 05:28:43.387932"]]
+[ActiveJob] [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+[ActiveJob] Enqueued ActionMailer::DeliveryJob (Job ID: d9619ad6-264f-4f62-a6d0-3d5babb0ac61) to Sidejobs(mailers) at 2016-12-11 15:28:43 UTC with arguments: "UserMailer", "invite", "deliver_now", "test@mail.com"
+ [1m[36mSidejobs::Job Load (0.2ms)[0m [1mSELECT "sidejobs".* FROM "sidejobs" ORDER BY "sidejobs"."id" DESC LIMIT 1[0m
+[ActiveJob] [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+[ActiveJob] [1m[36mSQL (0.3ms)[0m [1mINSERT INTO "sidejobs" ("data", "queue", "priority", "scheduled_at", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5, $6) RETURNING "id"[0m [["data", "{\"job_class\":\"ChargeSubscriptionsJob\",\"job_id\":\"8d537c48-d522-4342-918c-7013878a446e\",\"queue_name\":\"high_priority\",\"arguments\":[],\"locale\":\"en\"}"], ["queue", "high_priority"], ["priority", 60], ["scheduled_at", "2016-12-11 15:28:43.386530"], ["created_at", "2016-12-11 05:28:43.391224"], ["updated_at", "2016-12-11 05:28:43.391224"]]
+[ActiveJob] [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+[ActiveJob] Enqueued ChargeSubscriptionsJob (Job ID: 8d537c48-d522-4342-918c-7013878a446e) to Sidejobs(high_priority) at 2016-12-11 15:28:43 UTC
+ [1m[36mSidejobs::Job Load (0.3ms)[0m [1mSELECT "sidejobs".* FROM "sidejobs" ORDER BY "sidejobs"."id" DESC LIMIT 1[0m
+[ActiveJob] [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+[ActiveJob] [1m[36mSQL (0.3ms)[0m [1mINSERT INTO "sidejobs" ("data", "queue", "priority", "scheduled_at", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5, $6) RETURNING "id"[0m [["data", "{\"job_class\":\"SendNewslettersJob\",\"job_id\":\"034e09a8-0eec-447a-88f0-2b811dccd934\",\"queue_name\":\"default\",\"arguments\":[],\"locale\":\"en\"}"], ["queue", "default"], ["priority", 40], ["scheduled_at", "2016-12-11 15:28:43.386530"], ["created_at", "2016-12-11 05:28:43.394714"], ["updated_at", "2016-12-11 05:28:43.394714"]]
+[ActiveJob] [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+[ActiveJob] Enqueued SendNewslettersJob (Job ID: 034e09a8-0eec-447a-88f0-2b811dccd934) to Sidejobs(default) at 2016-12-11 15:28:43 UTC
+ [1m[36mSidejobs::Job Load (0.3ms)[0m [1mSELECT "sidejobs".* FROM "sidejobs" ORDER BY "sidejobs"."id" DESC LIMIT 1[0m
+[ActiveJob] [1m[35m (0.2ms)[0m SAVEPOINT active_record_1
+[ActiveJob] [1m[36mSQL (0.3ms)[0m [1mINSERT INTO "sidejobs" ("data", "queue", "priority", "scheduled_at", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5, $6) RETURNING "id"[0m [["data", "{\"job_class\":\"UpdateExchangesJob\",\"job_id\":\"dc0b46c7-c3d6-47c8-9f4d-8c2e5f02bc4a\",\"queue_name\":\"low_priority\",\"arguments\":[],\"locale\":\"en\"}"], ["queue", "low_priority"], ["priority", 20], ["scheduled_at", "2016-12-11 15:28:43.386530"], ["created_at", "2016-12-11 05:28:43.398431"], ["updated_at", "2016-12-11 05:28:43.398431"]]
+[ActiveJob] [1m[35m (0.2ms)[0m RELEASE SAVEPOINT active_record_1
+[ActiveJob] Enqueued UpdateExchangesJob (Job ID: dc0b46c7-c3d6-47c8-9f4d-8c2e5f02bc4a) to Sidejobs(low_priority) at 2016-12-11 15:28:43 UTC
+ [1m[36mSidejobs::Job Load (0.3ms)[0m [1mSELECT "sidejobs".* FROM "sidejobs" ORDER BY "sidejobs"."id" DESC LIMIT 1[0m
+[ActiveJob] [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+[ActiveJob] [1m[36mSQL (0.3ms)[0m [1mINSERT INTO "sidejobs" ("data", "queue", "scheduled_at", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id"[0m [["data", "{\"job_class\":\"ClearGuestUsersJob\",\"job_id\":\"8ebf2ce1-db1d-48ac-8b75-749557206d29\",\"queue_name\":\"other\",\"arguments\":[],\"locale\":\"en\"}"], ["queue", "other"], ["scheduled_at", "2016-12-11 15:28:43.386530"], ["created_at", "2016-12-11 05:28:43.402263"], ["updated_at", "2016-12-11 05:28:43.402263"]]
+[ActiveJob] [1m[35m (0.2ms)[0m RELEASE SAVEPOINT active_record_1
+[ActiveJob] Enqueued ClearGuestUsersJob (Job ID: 8ebf2ce1-db1d-48ac-8b75-749557206d29) to Sidejobs(other) at 2016-12-11 15:28:43 UTC
+ [1m[36mSidejobs::Job Load (0.3ms)[0m [1mSELECT "sidejobs".* FROM "sidejobs" ORDER BY "sidejobs"."id" DESC LIMIT 1[0m
+ [1m[35m (0.2ms)[0m ROLLBACK
+ [1m[36m (0.1ms)[0m [1mBEGIN[0m
+-------------------------
+ProcessorTest: test_batch
+-------------------------
+[ActiveJob] [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+[ActiveJob] [1m[36mSQL (0.2ms)[0m [1mINSERT INTO "sidejobs" ("data", "queue", "priority", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id"[0m [["data", "{\"job_class\":\"ActionMailer::DeliveryJob\",\"job_id\":\"d31c0400-23f5-47ac-8e25-9ba4fdaa5bf8\",\"queue_name\":\"mailers\",\"arguments\":[\"UserMailer\",\"invite\",\"deliver_now\",\"test@mail.com\"],\"locale\":\"en\"}"], ["queue", "mailers"], ["priority", 80], ["created_at", "2016-12-11 05:28:43.407327"], ["updated_at", "2016-12-11 05:28:43.407327"]]
+[ActiveJob] [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+[ActiveJob] Enqueued ActionMailer::DeliveryJob (Job ID: d31c0400-23f5-47ac-8e25-9ba4fdaa5bf8) to Sidejobs(mailers) with arguments: "UserMailer", "invite", "deliver_now", "test@mail.com"
+[ActiveJob] [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+[ActiveJob] [1m[35mSQL (0.3ms)[0m INSERT INTO "sidejobs" ("data", "queue", "priority", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id" [["data", "{\"job_class\":\"ActionMailer::DeliveryJob\",\"job_id\":\"7ad3ec88-b52b-47c8-8255-b21455cbe079\",\"queue_name\":\"mailers\",\"arguments\":[\"UserMailer\",\"invite\",\"deliver_now\",\"test@mail.com\"],\"locale\":\"en\"}"], ["queue", "mailers"], ["priority", 80], ["created_at", "2016-12-11 05:28:43.409540"], ["updated_at", "2016-12-11 05:28:43.409540"]]
+[ActiveJob] [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+[ActiveJob] Enqueued ActionMailer::DeliveryJob (Job ID: 7ad3ec88-b52b-47c8-8255-b21455cbe079) to Sidejobs(mailers) with arguments: "UserMailer", "invite", "deliver_now", "test@mail.com"
+[ActiveJob] [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+[ActiveJob] [1m[36mSQL (0.2ms)[0m [1mINSERT INTO "sidejobs" ("data", "queue", "priority", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id"[0m [["data", "{\"job_class\":\"ActionMailer::DeliveryJob\",\"job_id\":\"e982290c-9173-4dd7-ba14-a6aa2e478f7e\",\"queue_name\":\"mailers\",\"arguments\":[\"UserMailer\",\"invite\",\"deliver_now\",\"test@mail.com\"],\"locale\":\"en\"}"], ["queue", "mailers"], ["priority", 80], ["created_at", "2016-12-11 05:28:43.412223"], ["updated_at", "2016-12-11 05:28:43.412223"]]
+[ActiveJob] [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+[ActiveJob] Enqueued ActionMailer::DeliveryJob (Job ID: e982290c-9173-4dd7-ba14-a6aa2e478f7e) to Sidejobs(mailers) with arguments: "UserMailer", "invite", "deliver_now", "test@mail.com"
+[ActiveJob] [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+[ActiveJob] [1m[35mSQL (0.2ms)[0m INSERT INTO "sidejobs" ("data", "queue", "priority", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id" [["data", "{\"job_class\":\"ActionMailer::DeliveryJob\",\"job_id\":\"45046116-7d7f-4210-8ed6-9b689adef59d\",\"queue_name\":\"mailers\",\"arguments\":[\"UserMailer\",\"invite\",\"deliver_now\",\"test@mail.com\"],\"locale\":\"en\"}"], ["queue", "mailers"], ["priority", 80], ["created_at", "2016-12-11 05:28:43.414529"], ["updated_at", "2016-12-11 05:28:43.414529"]]
+[ActiveJob] [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+[ActiveJob] Enqueued ActionMailer::DeliveryJob (Job ID: 45046116-7d7f-4210-8ed6-9b689adef59d) to Sidejobs(mailers) with arguments: "UserMailer", "invite", "deliver_now", "test@mail.com"
+[ActiveJob] [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+[ActiveJob] [1m[36mSQL (0.2ms)[0m [1mINSERT INTO "sidejobs" ("data", "queue", "priority", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id"[0m [["data", "{\"job_class\":\"ActionMailer::DeliveryJob\",\"job_id\":\"bcc33a4b-a11b-4df8-a6f0-189003655e2b\",\"queue_name\":\"mailers\",\"arguments\":[\"UserMailer\",\"invite\",\"deliver_now\",\"test@mail.com\"],\"locale\":\"en\"}"], ["queue", "mailers"], ["priority", 80], ["created_at", "2016-12-11 05:28:43.416611"], ["updated_at", "2016-12-11 05:28:43.416611"]]
+[ActiveJob] [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+[ActiveJob] Enqueued ActionMailer::DeliveryJob (Job ID: bcc33a4b-a11b-4df8-a6f0-189003655e2b) to Sidejobs(mailers) with arguments: "UserMailer", "invite", "deliver_now", "test@mail.com"
+[ActiveJob] [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+[ActiveJob] [1m[35mSQL (0.2ms)[0m INSERT INTO "sidejobs" ("data", "queue", "priority", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id" [["data", "{\"job_class\":\"ActionMailer::DeliveryJob\",\"job_id\":\"50fe348e-158e-4a29-a908-2130a0942ff1\",\"queue_name\":\"mailers\",\"arguments\":[\"UserMailer\",\"invite\",\"deliver_now\",\"test@mail.com\"],\"locale\":\"en\"}"], ["queue", "mailers"], ["priority", 80], ["created_at", "2016-12-11 05:28:43.418631"], ["updated_at", "2016-12-11 05:28:43.418631"]]
+[ActiveJob] [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+[ActiveJob] Enqueued ActionMailer::DeliveryJob (Job ID: 50fe348e-158e-4a29-a908-2130a0942ff1) to Sidejobs(mailers) with arguments: "UserMailer", "invite", "deliver_now", "test@mail.com"
+[ActiveJob] [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+[ActiveJob] [1m[36mSQL (0.2ms)[0m [1mINSERT INTO "sidejobs" ("data", "queue", "priority", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id"[0m [["data", "{\"job_class\":\"ActionMailer::DeliveryJob\",\"job_id\":\"a26c25f7-9094-4e33-b3fc-2e90f90f0bc2\",\"queue_name\":\"mailers\",\"arguments\":[\"UserMailer\",\"invite\",\"deliver_now\",\"test@mail.com\"],\"locale\":\"en\"}"], ["queue", "mailers"], ["priority", 80], ["created_at", "2016-12-11 05:28:43.420703"], ["updated_at", "2016-12-11 05:28:43.420703"]]
+[ActiveJob] [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+[ActiveJob] Enqueued ActionMailer::DeliveryJob (Job ID: a26c25f7-9094-4e33-b3fc-2e90f90f0bc2) to Sidejobs(mailers) with arguments: "UserMailer", "invite", "deliver_now", "test@mail.com"
+[ActiveJob] [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+[ActiveJob] [1m[35mSQL (0.2ms)[0m INSERT INTO "sidejobs" ("data", "queue", "priority", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id" [["data", "{\"job_class\":\"ActionMailer::DeliveryJob\",\"job_id\":\"ec99cdd6-8c19-42e1-9c25-73c4f59a7542\",\"queue_name\":\"mailers\",\"arguments\":[\"UserMailer\",\"invite\",\"deliver_now\",\"test@mail.com\"],\"locale\":\"en\"}"], ["queue", "mailers"], ["priority", 80], ["created_at", "2016-12-11 05:28:43.422852"], ["updated_at", "2016-12-11 05:28:43.422852"]]
+[ActiveJob] [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+[ActiveJob] Enqueued ActionMailer::DeliveryJob (Job ID: ec99cdd6-8c19-42e1-9c25-73c4f59a7542) to Sidejobs(mailers) with arguments: "UserMailer", "invite", "deliver_now", "test@mail.com"
+[ActiveJob] [1m[35m (0.2ms)[0m SAVEPOINT active_record_1
+[ActiveJob] [1m[36mSQL (0.2ms)[0m [1mINSERT INTO "sidejobs" ("data", "queue", "priority", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id"[0m [["data", "{\"job_class\":\"ActionMailer::DeliveryJob\",\"job_id\":\"9a63e6b9-3676-4bf5-abbb-ecaab6dffffe\",\"queue_name\":\"mailers\",\"arguments\":[\"UserMailer\",\"invite\",\"deliver_now\",\"test@mail.com\"],\"locale\":\"en\"}"], ["queue", "mailers"], ["priority", 80], ["created_at", "2016-12-11 05:28:43.424926"], ["updated_at", "2016-12-11 05:28:43.424926"]]
+[ActiveJob] [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+[ActiveJob] Enqueued ActionMailer::DeliveryJob (Job ID: 9a63e6b9-3676-4bf5-abbb-ecaab6dffffe) to Sidejobs(mailers) with arguments: "UserMailer", "invite", "deliver_now", "test@mail.com"
+[ActiveJob] [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+[ActiveJob] [1m[35mSQL (0.2ms)[0m INSERT INTO "sidejobs" ("data", "queue", "priority", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id" [["data", "{\"job_class\":\"ActionMailer::DeliveryJob\",\"job_id\":\"607abc0c-66fc-4ce9-81e8-68e2397c8294\",\"queue_name\":\"mailers\",\"arguments\":[\"UserMailer\",\"invite\",\"deliver_now\",\"test@mail.com\"],\"locale\":\"en\"}"], ["queue", "mailers"], ["priority", 80], ["created_at", "2016-12-11 05:28:43.426932"], ["updated_at", "2016-12-11 05:28:43.426932"]]
+[ActiveJob] [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+[ActiveJob] Enqueued ActionMailer::DeliveryJob (Job ID: 607abc0c-66fc-4ce9-81e8-68e2397c8294) to Sidejobs(mailers) with arguments: "UserMailer", "invite", "deliver_now", "test@mail.com"
+[ActiveJob] [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+[ActiveJob] [1m[36mSQL (0.2ms)[0m [1mINSERT INTO "sidejobs" ("data", "queue", "priority", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id"[0m [["data", "{\"job_class\":\"ActionMailer::DeliveryJob\",\"job_id\":\"84369914-8d7f-4dc4-add1-893c5eaf5618\",\"queue_name\":\"mailers\",\"arguments\":[\"UserMailer\",\"invite\",\"deliver_now\",\"test@mail.com\"],\"locale\":\"en\"}"], ["queue", "mailers"], ["priority", 80], ["created_at", "2016-12-11 05:28:43.429083"], ["updated_at", "2016-12-11 05:28:43.429083"]]
+[ActiveJob] [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+[ActiveJob] Enqueued ActionMailer::DeliveryJob (Job ID: 84369914-8d7f-4dc4-add1-893c5eaf5618) to Sidejobs(mailers) with arguments: "UserMailer", "invite", "deliver_now", "test@mail.com"
+[ActiveJob] [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+[ActiveJob] [1m[35mSQL (0.2ms)[0m INSERT INTO "sidejobs" ("data", "queue", "priority", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id" [["data", "{\"job_class\":\"ActionMailer::DeliveryJob\",\"job_id\":\"7fee8452-a8af-426f-8de9-ba859305d126\",\"queue_name\":\"mailers\",\"arguments\":[\"UserMailer\",\"invite\",\"deliver_now\",\"test@mail.com\"],\"locale\":\"en\"}"], ["queue", "mailers"], ["priority", 80], ["created_at", "2016-12-11 05:28:43.431246"], ["updated_at", "2016-12-11 05:28:43.431246"]]
+[ActiveJob] [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+[ActiveJob] Enqueued ActionMailer::DeliveryJob (Job ID: 7fee8452-a8af-426f-8de9-ba859305d126) to Sidejobs(mailers) with arguments: "UserMailer", "invite", "deliver_now", "test@mail.com"
+[ActiveJob] [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+[ActiveJob] [1m[36mSQL (0.2ms)[0m [1mINSERT INTO "sidejobs" ("data", "queue", "priority", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id"[0m [["data", "{\"job_class\":\"ActionMailer::DeliveryJob\",\"job_id\":\"a1e1fb49-45be-418d-a1f9-eb24df8b3313\",\"queue_name\":\"mailers\",\"arguments\":[\"UserMailer\",\"invite\",\"deliver_now\",\"test@mail.com\"],\"locale\":\"en\"}"], ["queue", "mailers"], ["priority", 80], ["created_at", "2016-12-11 05:28:43.433404"], ["updated_at", "2016-12-11 05:28:43.433404"]]
+[ActiveJob] [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+[ActiveJob] Enqueued ActionMailer::DeliveryJob (Job ID: a1e1fb49-45be-418d-a1f9-eb24df8b3313) to Sidejobs(mailers) with arguments: "UserMailer", "invite", "deliver_now", "test@mail.com"
+[ActiveJob] [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+[ActiveJob] [1m[35mSQL (0.2ms)[0m INSERT INTO "sidejobs" ("data", "queue", "priority", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id" [["data", "{\"job_class\":\"ActionMailer::DeliveryJob\",\"job_id\":\"23f35e75-35bb-4537-8a0e-ac3bf2a71745\",\"queue_name\":\"mailers\",\"arguments\":[\"UserMailer\",\"invite\",\"deliver_now\",\"test@mail.com\"],\"locale\":\"en\"}"], ["queue", "mailers"], ["priority", 80], ["created_at", "2016-12-11 05:28:43.435506"], ["updated_at", "2016-12-11 05:28:43.435506"]]
+[ActiveJob] [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+[ActiveJob] Enqueued ActionMailer::DeliveryJob (Job ID: 23f35e75-35bb-4537-8a0e-ac3bf2a71745) to Sidejobs(mailers) with arguments: "UserMailer", "invite", "deliver_now", "test@mail.com"
+[ActiveJob] [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+[ActiveJob] [1m[36mSQL (0.2ms)[0m [1mINSERT INTO "sidejobs" ("data", "queue", "priority", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id"[0m [["data", "{\"job_class\":\"ActionMailer::DeliveryJob\",\"job_id\":\"82ec2978-02ba-4aa6-a733-4f3c5dfe4403\",\"queue_name\":\"mailers\",\"arguments\":[\"UserMailer\",\"invite\",\"deliver_now\",\"test@mail.com\"],\"locale\":\"en\"}"], ["queue", "mailers"], ["priority", 80], ["created_at", "2016-12-11 05:28:43.437514"], ["updated_at", "2016-12-11 05:28:43.437514"]]
+[ActiveJob] [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+[ActiveJob] Enqueued ActionMailer::DeliveryJob (Job ID: 82ec2978-02ba-4aa6-a733-4f3c5dfe4403) to Sidejobs(mailers) with arguments: "UserMailer", "invite", "deliver_now", "test@mail.com"
+[ActiveJob] [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+[ActiveJob] [1m[35mSQL (0.2ms)[0m INSERT INTO "sidejobs" ("data", "queue", "priority", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id" [["data", "{\"job_class\":\"ActionMailer::DeliveryJob\",\"job_id\":\"ca0a43b4-809f-46ee-a6a5-113fcf765999\",\"queue_name\":\"mailers\",\"arguments\":[\"UserMailer\",\"invite\",\"deliver_now\",\"test@mail.com\"],\"locale\":\"en\"}"], ["queue", "mailers"], ["priority", 80], ["created_at", "2016-12-11 05:28:43.439742"], ["updated_at", "2016-12-11 05:28:43.439742"]]
+[ActiveJob] [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+[ActiveJob] Enqueued ActionMailer::DeliveryJob (Job ID: ca0a43b4-809f-46ee-a6a5-113fcf765999) to Sidejobs(mailers) with arguments: "UserMailer", "invite", "deliver_now", "test@mail.com"
+[ActiveJob] [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+[ActiveJob] [1m[36mSQL (0.2ms)[0m [1mINSERT INTO "sidejobs" ("data", "queue", "priority", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id"[0m [["data", "{\"job_class\":\"ActionMailer::DeliveryJob\",\"job_id\":\"e5736afa-83a2-4dc5-9695-507dbd7208e2\",\"queue_name\":\"mailers\",\"arguments\":[\"UserMailer\",\"invite\",\"deliver_now\",\"test@mail.com\"],\"locale\":\"en\"}"], ["queue", "mailers"], ["priority", 80], ["created_at", "2016-12-11 05:28:43.441811"], ["updated_at", "2016-12-11 05:28:43.441811"]]
+[ActiveJob] [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+[ActiveJob] Enqueued ActionMailer::DeliveryJob (Job ID: e5736afa-83a2-4dc5-9695-507dbd7208e2) to Sidejobs(mailers) with arguments: "UserMailer", "invite", "deliver_now", "test@mail.com"
+[ActiveJob] [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+[ActiveJob] [1m[35mSQL (0.2ms)[0m INSERT INTO "sidejobs" ("data", "queue", "priority", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id" [["data", "{\"job_class\":\"ActionMailer::DeliveryJob\",\"job_id\":\"f273d577-c349-4926-9b99-598397b95f54\",\"queue_name\":\"mailers\",\"arguments\":[\"UserMailer\",\"invite\",\"deliver_now\",\"test@mail.com\"],\"locale\":\"en\"}"], ["queue", "mailers"], ["priority", 80], ["created_at", "2016-12-11 05:28:43.443834"], ["updated_at", "2016-12-11 05:28:43.443834"]]
+[ActiveJob] [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+[ActiveJob] Enqueued ActionMailer::DeliveryJob (Job ID: f273d577-c349-4926-9b99-598397b95f54) to Sidejobs(mailers) with arguments: "UserMailer", "invite", "deliver_now", "test@mail.com"
+[ActiveJob] [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+[ActiveJob] [1m[36mSQL (0.3ms)[0m [1mINSERT INTO "sidejobs" ("data", "queue", "priority", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id"[0m [["data", "{\"job_class\":\"ActionMailer::DeliveryJob\",\"job_id\":\"e4fec455-7004-4f6d-90ee-8cce00b964c7\",\"queue_name\":\"mailers\",\"arguments\":[\"UserMailer\",\"invite\",\"deliver_now\",\"test@mail.com\"],\"locale\":\"en\"}"], ["queue", "mailers"], ["priority", 80], ["created_at", "2016-12-11 05:28:43.445932"], ["updated_at", "2016-12-11 05:28:43.445932"]]
+[ActiveJob] [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+[ActiveJob] Enqueued ActionMailer::DeliveryJob (Job ID: e4fec455-7004-4f6d-90ee-8cce00b964c7) to Sidejobs(mailers) with arguments: "UserMailer", "invite", "deliver_now", "test@mail.com"
+[ActiveJob] [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+[ActiveJob] [1m[35mSQL (0.2ms)[0m INSERT INTO "sidejobs" ("data", "queue", "priority", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id" [["data", "{\"job_class\":\"ActionMailer::DeliveryJob\",\"job_id\":\"194de21a-db39-471e-b8df-985d7dd488fa\",\"queue_name\":\"mailers\",\"arguments\":[\"UserMailer\",\"invite\",\"deliver_now\",\"test@mail.com\"],\"locale\":\"en\"}"], ["queue", "mailers"], ["priority", 80], ["created_at", "2016-12-11 05:28:43.448124"], ["updated_at", "2016-12-11 05:28:43.448124"]]
+[ActiveJob] [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+[ActiveJob] Enqueued ActionMailer::DeliveryJob (Job ID: 194de21a-db39-471e-b8df-985d7dd488fa) to Sidejobs(mailers) with arguments: "UserMailer", "invite", "deliver_now", "test@mail.com"
+[ActiveJob] [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+[ActiveJob] [1m[36mSQL (0.2ms)[0m [1mINSERT INTO "sidejobs" ("data", "queue", "priority", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id"[0m [["data", "{\"job_class\":\"ActionMailer::DeliveryJob\",\"job_id\":\"652748f1-fb91-44bb-87d0-427b4129a02c\",\"queue_name\":\"mailers\",\"arguments\":[\"UserMailer\",\"invite\",\"deliver_now\",\"test@mail.com\"],\"locale\":\"en\"}"], ["queue", "mailers"], ["priority", 80], ["created_at", "2016-12-11 05:28:43.450122"], ["updated_at", "2016-12-11 05:28:43.450122"]]
+[ActiveJob] [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+[ActiveJob] Enqueued ActionMailer::DeliveryJob (Job ID: 652748f1-fb91-44bb-87d0-427b4129a02c) to Sidejobs(mailers) with arguments: "UserMailer", "invite", "deliver_now", "test@mail.com"
+[ActiveJob] [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+[ActiveJob] [1m[35mSQL (0.2ms)[0m INSERT INTO "sidejobs" ("data", "queue", "priority", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id" [["data", "{\"job_class\":\"ActionMailer::DeliveryJob\",\"job_id\":\"b7a74d30-0608-48bd-9f2b-18b0f7342834\",\"queue_name\":\"mailers\",\"arguments\":[\"UserMailer\",\"invite\",\"deliver_now\",\"test@mail.com\"],\"locale\":\"en\"}"], ["queue", "mailers"], ["priority", 80], ["created_at", "2016-12-11 05:28:43.452107"], ["updated_at", "2016-12-11 05:28:43.452107"]]
+[ActiveJob] [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+[ActiveJob] Enqueued ActionMailer::DeliveryJob (Job ID: b7a74d30-0608-48bd-9f2b-18b0f7342834) to Sidejobs(mailers) with arguments: "UserMailer", "invite", "deliver_now", "test@mail.com"
+[ActiveJob] [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+[ActiveJob] [1m[36mSQL (0.2ms)[0m [1mINSERT INTO "sidejobs" ("data", "queue", "priority", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id"[0m [["data", "{\"job_class\":\"ActionMailer::DeliveryJob\",\"job_id\":\"5bebfecc-1d2a-4f47-819d-4dd4cba11a62\",\"queue_name\":\"mailers\",\"arguments\":[\"UserMailer\",\"invite\",\"deliver_now\",\"test@mail.com\"],\"locale\":\"en\"}"], ["queue", "mailers"], ["priority", 80], ["created_at", "2016-12-11 05:28:43.454127"], ["updated_at", "2016-12-11 05:28:43.454127"]]
+[ActiveJob] [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+[ActiveJob] Enqueued ActionMailer::DeliveryJob (Job ID: 5bebfecc-1d2a-4f47-819d-4dd4cba11a62) to Sidejobs(mailers) with arguments: "UserMailer", "invite", "deliver_now", "test@mail.com"
+[ActiveJob] [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+[ActiveJob] [1m[35mSQL (0.2ms)[0m INSERT INTO "sidejobs" ("data", "queue", "priority", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id" [["data", "{\"job_class\":\"ActionMailer::DeliveryJob\",\"job_id\":\"3b019d07-3ccc-4c7c-b268-8ce25271891c\",\"queue_name\":\"mailers\",\"arguments\":[\"UserMailer\",\"invite\",\"deliver_now\",\"test@mail.com\"],\"locale\":\"en\"}"], ["queue", "mailers"], ["priority", 80], ["created_at", "2016-12-11 05:28:43.456123"], ["updated_at", "2016-12-11 05:28:43.456123"]]
+[ActiveJob] [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+[ActiveJob] Enqueued ActionMailer::DeliveryJob (Job ID: 3b019d07-3ccc-4c7c-b268-8ce25271891c) to Sidejobs(mailers) with arguments: "UserMailer", "invite", "deliver_now", "test@mail.com"
+ [1m[35mSidejobs::Job Load (0.8ms)[0m SELECT "sidejobs".* FROM "sidejobs" WHERE "sidejobs"."status" IN ('pending', 'failing') AND (attempts < 3) AND (scheduled_at <= '2016-12-11 05:28:43.459184' OR scheduled_at IS NULL) ORDER BY "sidejobs"."priority" DESC LIMIT 20
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.2ms)[0m UPDATE "sidejobs" SET "status" = $1, "processed_at" = $2, "attempts" = $3, "updated_at" = $4 WHERE "sidejobs"."id" = $5 [["status", "processing"], ["processed_at", "2016-12-11 05:28:43.460912"], ["attempts", 1], ["updated_at", "2016-12-11 05:28:43.461595"], ["id", 674]]
+ [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ Rendered user_mailer/invite.text.erb (1.0ms)
+
+UserMailer#invite: processed outbound mail in 153.9ms
+
+Sent mail to test@mail.com (7.4ms)
+Date: Sun, 11 Dec 2016 02:28:43 -0300
+From: test@mail.com
+To: test@mail.com
+Message-ID: <584ce40b99b38_36633fefbc43f9f4617d7@imac-de-matt.mail>
+Subject: Invite
+Mime-Version: 1.0
+Content-Type: text/plain;
+ charset=UTF-8
+Content-Transfer-Encoding: 7bit
+
+Test
+
+ [1m[35m (0.2ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.3ms)[0m [1mUPDATE "sidejobs" SET "status" = $1, "completed_at" = $2, "updated_at" = $3 WHERE "sidejobs"."id" = $4[0m [["status", "complete"], ["completed_at", "2016-12-11 05:28:43.632262"], ["updated_at", "2016-12-11 05:28:43.633125"], ["id", 674]]
+ [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.2ms)[0m UPDATE "sidejobs" SET "status" = $1, "processed_at" = $2, "attempts" = $3, "updated_at" = $4 WHERE "sidejobs"."id" = $5 [["status", "processing"], ["processed_at", "2016-12-11 05:28:43.634855"], ["attempts", 1], ["updated_at", "2016-12-11 05:28:43.635457"], ["id", 675]]
+ [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ Rendered user_mailer/invite.text.erb (0.0ms)
+
+UserMailer#invite: processed outbound mail in 0.8ms
+
+Sent mail to test@mail.com (1.1ms)
+Date: Sun, 11 Dec 2016 02:28:43 -0300
+From: test@mail.com
+To: test@mail.com
+Message-ID: <584ce40b9be5a_36633fefbc43f9f46184e@imac-de-matt.mail>
+Subject: Invite
+Mime-Version: 1.0
+Content-Type: text/plain;
+ charset=UTF-8
+Content-Transfer-Encoding: 7bit
+
+Test
+
+ [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.3ms)[0m [1mUPDATE "sidejobs" SET "status" = $1, "completed_at" = $2, "updated_at" = $3 WHERE "sidejobs"."id" = $4[0m [["status", "complete"], ["completed_at", "2016-12-11 05:28:43.639209"], ["updated_at", "2016-12-11 05:28:43.639990"], ["id", 675]]
+ [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.2ms)[0m UPDATE "sidejobs" SET "status" = $1, "processed_at" = $2, "attempts" = $3, "updated_at" = $4 WHERE "sidejobs"."id" = $5 [["status", "processing"], ["processed_at", "2016-12-11 05:28:43.641563"], ["attempts", 1], ["updated_at", "2016-12-11 05:28:43.642165"], ["id", 676]]
+ [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ Rendered user_mailer/invite.text.erb (0.0ms)
+
+UserMailer#invite: processed outbound mail in 0.7ms
+
+Sent mail to test@mail.com (1.3ms)
+Date: Sun, 11 Dec 2016 02:28:43 -0300
+From: test@mail.com
+To: test@mail.com
+Message-ID: <584ce40b9d8ca_36633fefbc43f9f4619e0@imac-de-matt.mail>
+Subject: Invite
+Mime-Version: 1.0
+Content-Type: text/plain;
+ charset=UTF-8
+Content-Transfer-Encoding: 7bit
+
+Test
+
+ [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.3ms)[0m [1mUPDATE "sidejobs" SET "status" = $1, "completed_at" = $2, "updated_at" = $3 WHERE "sidejobs"."id" = $4[0m [["status", "complete"], ["completed_at", "2016-12-11 05:28:43.646076"], ["updated_at", "2016-12-11 05:28:43.646691"], ["id", 676]]
+ [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.2ms)[0m UPDATE "sidejobs" SET "status" = $1, "processed_at" = $2, "attempts" = $3, "updated_at" = $4 WHERE "sidejobs"."id" = $5 [["status", "processing"], ["processed_at", "2016-12-11 05:28:43.648154"], ["attempts", 1], ["updated_at", "2016-12-11 05:28:43.648776"], ["id", 677]]
+ [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ Rendered user_mailer/invite.text.erb (0.0ms)
+
+UserMailer#invite: processed outbound mail in 0.7ms
+
+Sent mail to test@mail.com (1.2ms)
+Date: Sun, 11 Dec 2016 02:28:43 -0300
+From: test@mail.com
+To: test@mail.com
+Message-ID: <584ce40b9f22a_36633fefbc43f9f462087@imac-de-matt.mail>
+Subject: Invite
+Mime-Version: 1.0
+Content-Type: text/plain;
+ charset=UTF-8
+Content-Transfer-Encoding: 7bit
+
+Test
+
+ [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mUPDATE "sidejobs" SET "status" = $1, "completed_at" = $2, "updated_at" = $3 WHERE "sidejobs"."id" = $4[0m [["status", "complete"], ["completed_at", "2016-12-11 05:28:43.652524"], ["updated_at", "2016-12-11 05:28:43.653097"], ["id", 677]]
+ [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.2ms)[0m UPDATE "sidejobs" SET "status" = $1, "processed_at" = $2, "attempts" = $3, "updated_at" = $4 WHERE "sidejobs"."id" = $5 [["status", "processing"], ["processed_at", "2016-12-11 05:28:43.654456"], ["attempts", 1], ["updated_at", "2016-12-11 05:28:43.655065"], ["id", 678]]
+ [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ Rendered user_mailer/invite.text.erb (0.0ms)
+
+UserMailer#invite: processed outbound mail in 0.7ms
+
+Sent mail to test@mail.com (1.3ms)
+Date: Sun, 11 Dec 2016 02:28:43 -0300
+From: test@mail.com
+To: test@mail.com
+Message-ID: <584ce40ba0ad4_36633fefbc43f9f46214e@imac-de-matt.mail>
+Subject: Invite
+Mime-Version: 1.0
+Content-Type: text/plain;
+ charset=UTF-8
+Content-Transfer-Encoding: 7bit
+
+Test
+
+ [1m[35m (0.2ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mUPDATE "sidejobs" SET "status" = $1, "completed_at" = $2, "updated_at" = $3 WHERE "sidejobs"."id" = $4[0m [["status", "complete"], ["completed_at", "2016-12-11 05:28:43.658846"], ["updated_at", "2016-12-11 05:28:43.659477"], ["id", 678]]
+ [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.2ms)[0m UPDATE "sidejobs" SET "status" = $1, "processed_at" = $2, "attempts" = $3, "updated_at" = $4 WHERE "sidejobs"."id" = $5 [["status", "processing"], ["processed_at", "2016-12-11 05:28:43.660820"], ["attempts", 1], ["updated_at", "2016-12-11 05:28:43.661447"], ["id", 679]]
+ [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ Rendered user_mailer/invite.text.erb (0.0ms)
+
+UserMailer#invite: processed outbound mail in 0.7ms
+
+Sent mail to test@mail.com (1.1ms)
+Date: Sun, 11 Dec 2016 02:28:43 -0300
+From: test@mail.com
+To: test@mail.com
+Message-ID: <584ce40ba2314_36633fefbc43f9f462278@imac-de-matt.mail>
+Subject: Invite
+Mime-Version: 1.0
+Content-Type: text/plain;
+ charset=UTF-8
+Content-Transfer-Encoding: 7bit
+
+Test
+
+ [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mUPDATE "sidejobs" SET "status" = $1, "completed_at" = $2, "updated_at" = $3 WHERE "sidejobs"."id" = $4[0m [["status", "complete"], ["completed_at", "2016-12-11 05:28:43.665021"], ["updated_at", "2016-12-11 05:28:43.665682"], ["id", 679]]
+ [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.2ms)[0m UPDATE "sidejobs" SET "status" = $1, "processed_at" = $2, "attempts" = $3, "updated_at" = $4 WHERE "sidejobs"."id" = $5 [["status", "processing"], ["processed_at", "2016-12-11 05:28:43.667043"], ["attempts", 1], ["updated_at", "2016-12-11 05:28:43.667644"], ["id", 680]]
+ [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ Rendered user_mailer/invite.text.erb (0.0ms)
+
+UserMailer#invite: processed outbound mail in 0.7ms
+
+Sent mail to test@mail.com (1.1ms)
+Date: Sun, 11 Dec 2016 02:28:43 -0300
+From: test@mail.com
+To: test@mail.com
+Message-ID: <584ce40ba3b29_36633fefbc43f9f462372@imac-de-matt.mail>
+Subject: Invite
+Mime-Version: 1.0
+Content-Type: text/plain;
+ charset=UTF-8
+Content-Transfer-Encoding: 7bit
+
+Test
+
+ [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mUPDATE "sidejobs" SET "status" = $1, "completed_at" = $2, "updated_at" = $3 WHERE "sidejobs"."id" = $4[0m [["status", "complete"], ["completed_at", "2016-12-11 05:28:43.671203"], ["updated_at", "2016-12-11 05:28:43.671853"], ["id", 680]]
+ [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.2ms)[0m UPDATE "sidejobs" SET "status" = $1, "processed_at" = $2, "attempts" = $3, "updated_at" = $4 WHERE "sidejobs"."id" = $5 [["status", "processing"], ["processed_at", "2016-12-11 05:28:43.673156"], ["attempts", 1], ["updated_at", "2016-12-11 05:28:43.673795"], ["id", 681]]
+ [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ Rendered user_mailer/invite.text.erb (0.0ms)
+
+UserMailer#invite: processed outbound mail in 0.6ms
+
+Sent mail to test@mail.com (1.1ms)
+Date: Sun, 11 Dec 2016 02:28:43 -0300
+From: test@mail.com
+To: test@mail.com
+Message-ID: <584ce40ba530d_36633fefbc43f9f4624d3@imac-de-matt.mail>
+Subject: Invite
+Mime-Version: 1.0
+Content-Type: text/plain;
+ charset=UTF-8
+Content-Transfer-Encoding: 7bit
+
+Test
+
+ [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mUPDATE "sidejobs" SET "status" = $1, "completed_at" = $2, "updated_at" = $3 WHERE "sidejobs"."id" = $4[0m [["status", "complete"], ["completed_at", "2016-12-11 05:28:43.677296"], ["updated_at", "2016-12-11 05:28:43.677867"], ["id", 681]]
+ [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.2ms)[0m UPDATE "sidejobs" SET "status" = $1, "processed_at" = $2, "attempts" = $3, "updated_at" = $4 WHERE "sidejobs"."id" = $5 [["status", "processing"], ["processed_at", "2016-12-11 05:28:43.679059"], ["attempts", 1], ["updated_at", "2016-12-11 05:28:43.679612"], ["id", 682]]
+ [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ Rendered user_mailer/invite.text.erb (0.0ms)
+
+UserMailer#invite: processed outbound mail in 0.6ms
+
+Sent mail to test@mail.com (1.0ms)
+Date: Sun, 11 Dec 2016 02:28:43 -0300
+From: test@mail.com
+To: test@mail.com
+Message-ID: <584ce40ba6911_36633fefbc43f9f462594@imac-de-matt.mail>
+Subject: Invite
+Mime-Version: 1.0
+Content-Type: text/plain;
+ charset=UTF-8
+Content-Transfer-Encoding: 7bit
+
+Test
+
+ [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mUPDATE "sidejobs" SET "status" = $1, "completed_at" = $2, "updated_at" = $3 WHERE "sidejobs"."id" = $4[0m [["status", "complete"], ["completed_at", "2016-12-11 05:28:43.682892"], ["updated_at", "2016-12-11 05:28:43.683508"], ["id", 682]]
+ [1m[35m (0.2ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.2ms)[0m UPDATE "sidejobs" SET "status" = $1, "processed_at" = $2, "attempts" = $3, "updated_at" = $4 WHERE "sidejobs"."id" = $5 [["status", "processing"], ["processed_at", "2016-12-11 05:28:43.684797"], ["attempts", 1], ["updated_at", "2016-12-11 05:28:43.685373"], ["id", 683]]
+ [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ Rendered user_mailer/invite.text.erb (0.0ms)
+
+UserMailer#invite: processed outbound mail in 0.6ms
+
+Sent mail to test@mail.com (1.0ms)
+Date: Sun, 11 Dec 2016 02:28:43 -0300
+From: test@mail.com
+To: test@mail.com
+Message-ID: <584ce40ba7fa2_36633fefbc43f9f4626fa@imac-de-matt.mail>
+Subject: Invite
+Mime-Version: 1.0
+Content-Type: text/plain;
+ charset=UTF-8
+Content-Transfer-Encoding: 7bit
+
+Test
+
+ [1m[35m (0.2ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mUPDATE "sidejobs" SET "status" = $1, "completed_at" = $2, "updated_at" = $3 WHERE "sidejobs"."id" = $4[0m [["status", "complete"], ["completed_at", "2016-12-11 05:28:43.688661"], ["updated_at", "2016-12-11 05:28:43.689283"], ["id", 683]]
+ [1m[35m (0.2ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.2ms)[0m UPDATE "sidejobs" SET "status" = $1, "processed_at" = $2, "attempts" = $3, "updated_at" = $4 WHERE "sidejobs"."id" = $5 [["status", "processing"], ["processed_at", "2016-12-11 05:28:43.690543"], ["attempts", 1], ["updated_at", "2016-12-11 05:28:43.691085"], ["id", 684]]
+ [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ Rendered user_mailer/invite.text.erb (0.0ms)
+
+UserMailer#invite: processed outbound mail in 0.6ms
+
+Sent mail to test@mail.com (1.0ms)
+Date: Sun, 11 Dec 2016 02:28:43 -0300
+From: test@mail.com
+To: test@mail.com
+Message-ID: <584ce40ba958f_36633fefbc43f9f462718@imac-de-matt.mail>
+Subject: Invite
+Mime-Version: 1.0
+Content-Type: text/plain;
+ charset=UTF-8
+Content-Transfer-Encoding: 7bit
+
+Test
+
+ [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mUPDATE "sidejobs" SET "status" = $1, "completed_at" = $2, "updated_at" = $3 WHERE "sidejobs"."id" = $4[0m [["status", "complete"], ["completed_at", "2016-12-11 05:28:43.694254"], ["updated_at", "2016-12-11 05:28:43.694844"], ["id", 684]]
+ [1m[35m (0.2ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.2ms)[0m UPDATE "sidejobs" SET "status" = $1, "processed_at" = $2, "attempts" = $3, "updated_at" = $4 WHERE "sidejobs"."id" = $5 [["status", "processing"], ["processed_at", "2016-12-11 05:28:43.696039"], ["attempts", 1], ["updated_at", "2016-12-11 05:28:43.696620"], ["id", 685]]
+ [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ Rendered user_mailer/invite.text.erb (0.0ms)
+
+UserMailer#invite: processed outbound mail in 0.6ms
+
+Sent mail to test@mail.com (1.0ms)
+Date: Sun, 11 Dec 2016 02:28:43 -0300
+From: test@mail.com
+To: test@mail.com
+Message-ID: <584ce40baabc5_36633fefbc43f9f4628c3@imac-de-matt.mail>
+Subject: Invite
+Mime-Version: 1.0
+Content-Type: text/plain;
+ charset=UTF-8
+Content-Transfer-Encoding: 7bit
+
+Test
+
+ [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mUPDATE "sidejobs" SET "status" = $1, "completed_at" = $2, "updated_at" = $3 WHERE "sidejobs"."id" = $4[0m [["status", "complete"], ["completed_at", "2016-12-11 05:28:43.699992"], ["updated_at", "2016-12-11 05:28:43.700620"], ["id", 685]]
+ [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.2ms)[0m UPDATE "sidejobs" SET "status" = $1, "processed_at" = $2, "attempts" = $3, "updated_at" = $4 WHERE "sidejobs"."id" = $5 [["status", "processing"], ["processed_at", "2016-12-11 05:28:43.701901"], ["attempts", 1], ["updated_at", "2016-12-11 05:28:43.702448"], ["id", 686]]
+ [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ Rendered user_mailer/invite.text.erb (0.0ms)
+
+UserMailer#invite: processed outbound mail in 0.6ms
+
+Sent mail to test@mail.com (1.0ms)
+Date: Sun, 11 Dec 2016 02:28:43 -0300
+From: test@mail.com
+To: test@mail.com
+Message-ID: <584ce40bac225_36633fefbc43f9f4629e9@imac-de-matt.mail>
+Subject: Invite
+Mime-Version: 1.0
+Content-Type: text/plain;
+ charset=UTF-8
+Content-Transfer-Encoding: 7bit
+
+Test
+
+ [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mUPDATE "sidejobs" SET "status" = $1, "completed_at" = $2, "updated_at" = $3 WHERE "sidejobs"."id" = $4[0m [["status", "complete"], ["completed_at", "2016-12-11 05:28:43.705684"], ["updated_at", "2016-12-11 05:28:43.706248"], ["id", 686]]
+ [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.2ms)[0m UPDATE "sidejobs" SET "status" = $1, "processed_at" = $2, "attempts" = $3, "updated_at" = $4 WHERE "sidejobs"."id" = $5 [["status", "processing"], ["processed_at", "2016-12-11 05:28:43.707425"], ["attempts", 1], ["updated_at", "2016-12-11 05:28:43.707976"], ["id", 687]]
+ [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ Rendered user_mailer/invite.text.erb (0.0ms)
+
+UserMailer#invite: processed outbound mail in 0.6ms
+
+Sent mail to test@mail.com (1.0ms)
+Date: Sun, 11 Dec 2016 02:28:43 -0300
+From: test@mail.com
+To: test@mail.com
+Message-ID: <584ce40bad787_36633fefbc43f9f4630c8@imac-de-matt.mail>
+Subject: Invite
+Mime-Version: 1.0
+Content-Type: text/plain;
+ charset=UTF-8
+Content-Transfer-Encoding: 7bit
+
+Test
+
+ [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mUPDATE "sidejobs" SET "status" = $1, "completed_at" = $2, "updated_at" = $3 WHERE "sidejobs"."id" = $4[0m [["status", "complete"], ["completed_at", "2016-12-11 05:28:43.711142"], ["updated_at", "2016-12-11 05:28:43.711671"], ["id", 687]]
+ [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.2ms)[0m UPDATE "sidejobs" SET "status" = $1, "processed_at" = $2, "attempts" = $3, "updated_at" = $4 WHERE "sidejobs"."id" = $5 [["status", "processing"], ["processed_at", "2016-12-11 05:28:43.712912"], ["attempts", 1], ["updated_at", "2016-12-11 05:28:43.713497"], ["id", 688]]
+ [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ Rendered user_mailer/invite.text.erb (0.0ms)
+
+UserMailer#invite: processed outbound mail in 0.6ms
+
+Sent mail to test@mail.com (1.0ms)
+Date: Sun, 11 Dec 2016 02:28:43 -0300
+From: test@mail.com
+To: test@mail.com
+Message-ID: <584ce40baed3c_36633fefbc43f9f463158@imac-de-matt.mail>
+Subject: Invite
+Mime-Version: 1.0
+Content-Type: text/plain;
+ charset=UTF-8
+Content-Transfer-Encoding: 7bit
+
+Test
+
+ [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mUPDATE "sidejobs" SET "status" = $1, "completed_at" = $2, "updated_at" = $3 WHERE "sidejobs"."id" = $4[0m [["status", "complete"], ["completed_at", "2016-12-11 05:28:43.716705"], ["updated_at", "2016-12-11 05:28:43.717233"], ["id", 688]]
+ [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.2ms)[0m UPDATE "sidejobs" SET "status" = $1, "processed_at" = $2, "attempts" = $3, "updated_at" = $4 WHERE "sidejobs"."id" = $5 [["status", "processing"], ["processed_at", "2016-12-11 05:28:43.718375"], ["attempts", 1], ["updated_at", "2016-12-11 05:28:43.718920"], ["id", 689]]
+ [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ Rendered user_mailer/invite.text.erb (0.0ms)
+
+UserMailer#invite: processed outbound mail in 0.6ms
+
+Sent mail to test@mail.com (1.1ms)
+Date: Sun, 11 Dec 2016 02:28:43 -0300
+From: test@mail.com
+To: test@mail.com
+Message-ID: <584ce40bb0216_36633fefbc43f9f46325c@imac-de-matt.mail>
+Subject: Invite
+Mime-Version: 1.0
+Content-Type: text/plain;
+ charset=UTF-8
+Content-Transfer-Encoding: 7bit
+
+Test
+
+ [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mUPDATE "sidejobs" SET "status" = $1, "completed_at" = $2, "updated_at" = $3 WHERE "sidejobs"."id" = $4[0m [["status", "complete"], ["completed_at", "2016-12-11 05:28:43.722063"], ["updated_at", "2016-12-11 05:28:43.722580"], ["id", 689]]
+ [1m[35m (0.2ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.2ms)[0m UPDATE "sidejobs" SET "status" = $1, "processed_at" = $2, "attempts" = $3, "updated_at" = $4 WHERE "sidejobs"."id" = $5 [["status", "processing"], ["processed_at", "2016-12-11 05:28:43.723756"], ["attempts", 1], ["updated_at", "2016-12-11 05:28:43.724310"], ["id", 690]]
+ [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ Rendered user_mailer/invite.text.erb (0.0ms)
+
+UserMailer#invite: processed outbound mail in 0.7ms
+
+Sent mail to test@mail.com (1.1ms)
+Date: Sun, 11 Dec 2016 02:28:43 -0300
+From: test@mail.com
+To: test@mail.com
+Message-ID: <584ce40bb18c6_36633fefbc43f9f4633d0@imac-de-matt.mail>
+Subject: Invite
+Mime-Version: 1.0
+Content-Type: text/plain;
+ charset=UTF-8
+Content-Transfer-Encoding: 7bit
+
+Test
+
+ [1m[35m (0.2ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mUPDATE "sidejobs" SET "status" = $1, "completed_at" = $2, "updated_at" = $3 WHERE "sidejobs"."id" = $4[0m [["status", "complete"], ["completed_at", "2016-12-11 05:28:43.727911"], ["updated_at", "2016-12-11 05:28:43.728552"], ["id", 690]]
+ [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.2ms)[0m UPDATE "sidejobs" SET "status" = $1, "processed_at" = $2, "attempts" = $3, "updated_at" = $4 WHERE "sidejobs"."id" = $5 [["status", "processing"], ["processed_at", "2016-12-11 05:28:43.729772"], ["attempts", 1], ["updated_at", "2016-12-11 05:28:43.730334"], ["id", 691]]
+ [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ Rendered user_mailer/invite.text.erb (0.0ms)
+
+UserMailer#invite: processed outbound mail in 0.6ms
+
+Sent mail to test@mail.com (1.1ms)
+Date: Sun, 11 Dec 2016 02:28:43 -0300
+From: test@mail.com
+To: test@mail.com
+Message-ID: <584ce40bb2f61_36633fefbc43f9f46341d@imac-de-matt.mail>
+Subject: Invite
+Mime-Version: 1.0
+Content-Type: text/plain;
+ charset=UTF-8
+Content-Transfer-Encoding: 7bit
+
+Test
+
+ [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mUPDATE "sidejobs" SET "status" = $1, "completed_at" = $2, "updated_at" = $3 WHERE "sidejobs"."id" = $4[0m [["status", "complete"], ["completed_at", "2016-12-11 05:28:43.733681"], ["updated_at", "2016-12-11 05:28:43.734235"], ["id", 691]]
+ [1m[35m (0.2ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.2ms)[0m UPDATE "sidejobs" SET "status" = $1, "processed_at" = $2, "attempts" = $3, "updated_at" = $4 WHERE "sidejobs"."id" = $5 [["status", "processing"], ["processed_at", "2016-12-11 05:28:43.735400"], ["attempts", 1], ["updated_at", "2016-12-11 05:28:43.736004"], ["id", 692]]
+ [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ Rendered user_mailer/invite.text.erb (0.0ms)
+
+UserMailer#invite: processed outbound mail in 0.6ms
+
+Sent mail to test@mail.com (1.1ms)
+Date: Sun, 11 Dec 2016 02:28:43 -0300
+From: test@mail.com
+To: test@mail.com
+Message-ID: <584ce40bb453e_36633fefbc43f9f46356d@imac-de-matt.mail>
+Subject: Invite
+Mime-Version: 1.0
+Content-Type: text/plain;
+ charset=UTF-8
+Content-Transfer-Encoding: 7bit
+
+Test
+
+ [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mUPDATE "sidejobs" SET "status" = $1, "completed_at" = $2, "updated_at" = $3 WHERE "sidejobs"."id" = $4[0m [["status", "complete"], ["completed_at", "2016-12-11 05:28:43.739305"], ["updated_at", "2016-12-11 05:28:43.739837"], ["id", 692]]
+ [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.2ms)[0m UPDATE "sidejobs" SET "status" = $1, "processed_at" = $2, "attempts" = $3, "updated_at" = $4 WHERE "sidejobs"."id" = $5 [["status", "processing"], ["processed_at", "2016-12-11 05:28:43.740986"], ["attempts", 1], ["updated_at", "2016-12-11 05:28:43.741556"], ["id", 693]]
+ [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ Rendered user_mailer/invite.text.erb (0.0ms)
+
+UserMailer#invite: processed outbound mail in 0.6ms
+
+Sent mail to test@mail.com (1.2ms)
+Date: Sun, 11 Dec 2016 02:28:43 -0300
+From: test@mail.com
+To: test@mail.com
+Message-ID: <584ce40bb5acb_36633fefbc43f9f4636d7@imac-de-matt.mail>
+Subject: Invite
+Mime-Version: 1.0
+Content-Type: text/plain;
+ charset=UTF-8
+Content-Transfer-Encoding: 7bit
+
+Test
+
+ [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mUPDATE "sidejobs" SET "status" = $1, "completed_at" = $2, "updated_at" = $3 WHERE "sidejobs"."id" = $4[0m [["status", "complete"], ["completed_at", "2016-12-11 05:28:43.744856"], ["updated_at", "2016-12-11 05:28:43.745391"], ["id", 693]]
+ [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.3ms)[0m [1mSELECT COUNT(*) FROM "sidejobs" WHERE "sidejobs"."status" = $1[0m [["status", "complete"]]
+ [1m[35m (0.2ms)[0m SELECT COUNT(*) FROM "sidejobs" WHERE "sidejobs"."status" = $1 [["status", "processing"]]
+ [1m[36m (0.2ms)[0m [1mSELECT COUNT(*) FROM "sidejobs" WHERE "sidejobs"."status" = $1[0m [["status", "pending"]]
+ [1m[35mSidejobs::Job Load (0.2ms)[0m SELECT "sidejobs".* FROM "sidejobs" ORDER BY "sidejobs"."id" DESC LIMIT 1
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.3ms)[0m UPDATE "sidejobs" SET "status" = $1, "processed_at" = $2, "updated_at" = $3 WHERE "sidejobs"."id" = $4 [["status", "processing"], ["processed_at", "2016-12-11 05:28:43.749571"], ["updated_at", "2016-12-11 05:28:43.750414"], ["id", 697]]
+ [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35mSidejobs::Job Load (0.4ms)[0m SELECT "sidejobs".* FROM "sidejobs" WHERE "sidejobs"."status" IN ('pending', 'failing') AND (attempts < 3) AND (scheduled_at <= '2016-12-11 05:28:43.752089' OR scheduled_at IS NULL) ORDER BY "sidejobs"."priority" DESC LIMIT 20
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.2ms)[0m UPDATE "sidejobs" SET "status" = $1, "processed_at" = $2, "attempts" = $3, "updated_at" = $4 WHERE "sidejobs"."id" = $5 [["status", "processing"], ["processed_at", "2016-12-11 05:28:43.752939"], ["attempts", 1], ["updated_at", "2016-12-11 05:28:43.753532"], ["id", 694]]
+ [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ Rendered user_mailer/invite.text.erb (0.0ms)
+
+UserMailer#invite: processed outbound mail in 0.7ms
+
+Sent mail to test@mail.com (1.2ms)
+Date: Sun, 11 Dec 2016 02:28:43 -0300
+From: test@mail.com
+To: test@mail.com
+Message-ID: <584ce40bb8ae3_36633fefbc43f9f463740@imac-de-matt.mail>
+Subject: Invite
+Mime-Version: 1.0
+Content-Type: text/plain;
+ charset=UTF-8
+Content-Transfer-Encoding: 7bit
+
+Test
+
+ [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mUPDATE "sidejobs" SET "status" = $1, "completed_at" = $2, "updated_at" = $3 WHERE "sidejobs"."id" = $4[0m [["status", "complete"], ["completed_at", "2016-12-11 05:28:43.757139"], ["updated_at", "2016-12-11 05:28:43.757695"], ["id", 694]]
+ [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.2ms)[0m UPDATE "sidejobs" SET "status" = $1, "processed_at" = $2, "attempts" = $3, "updated_at" = $4 WHERE "sidejobs"."id" = $5 [["status", "processing"], ["processed_at", "2016-12-11 05:28:43.758937"], ["attempts", 1], ["updated_at", "2016-12-11 05:28:43.759531"], ["id", 695]]
+ [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ Rendered user_mailer/invite.text.erb (0.0ms)
+
+UserMailer#invite: processed outbound mail in 0.6ms
+
+Sent mail to test@mail.com (1.1ms)
+Date: Sun, 11 Dec 2016 02:28:43 -0300
+From: test@mail.com
+To: test@mail.com
+Message-ID: <584ce40bba127_36633fefbc43f9f4638c6@imac-de-matt.mail>
+Subject: Invite
+Mime-Version: 1.0
+Content-Type: text/plain;
+ charset=UTF-8
+Content-Transfer-Encoding: 7bit
+
+Test
+
+ [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mUPDATE "sidejobs" SET "status" = $1, "completed_at" = $2, "updated_at" = $3 WHERE "sidejobs"."id" = $4[0m [["status", "complete"], ["completed_at", "2016-12-11 05:28:43.762786"], ["updated_at", "2016-12-11 05:28:43.763320"], ["id", 695]]
+ [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.2ms)[0m UPDATE "sidejobs" SET "status" = $1, "processed_at" = $2, "attempts" = $3, "updated_at" = $4 WHERE "sidejobs"."id" = $5 [["status", "processing"], ["processed_at", "2016-12-11 05:28:43.764549"], ["attempts", 1], ["updated_at", "2016-12-11 05:28:43.765116"], ["id", 696]]
+ [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ Rendered user_mailer/invite.text.erb (0.0ms)
+
+UserMailer#invite: processed outbound mail in 0.7ms
+
+Sent mail to test@mail.com (1.1ms)
+Date: Sun, 11 Dec 2016 02:28:43 -0300
+From: test@mail.com
+To: test@mail.com
+Message-ID: <584ce40bbb73a_36633fefbc43f9f463921@imac-de-matt.mail>
+Subject: Invite
+Mime-Version: 1.0
+Content-Type: text/plain;
+ charset=UTF-8
+Content-Transfer-Encoding: 7bit
+
+Test
+
+ [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mUPDATE "sidejobs" SET "status" = $1, "completed_at" = $2, "updated_at" = $3 WHERE "sidejobs"."id" = $4[0m [["status", "complete"], ["completed_at", "2016-12-11 05:28:43.768457"], ["updated_at", "2016-12-11 05:28:43.768978"], ["id", 696]]
+ [1m[35m (0.2ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.2ms)[0m [1mSELECT COUNT(*) FROM "sidejobs" WHERE "sidejobs"."status" = $1[0m [["status", "complete"]]
+ [1m[35m (0.2ms)[0m SELECT COUNT(*) FROM "sidejobs" WHERE "sidejobs"."status" = $1 [["status", "processing"]]
+ [1m[36m (0.2ms)[0m [1mSELECT COUNT(*) FROM "sidejobs" WHERE "sidejobs"."status" = $1[0m [["status", "pending"]]
+ [1m[35m (0.1ms)[0m ROLLBACK
+ [1m[36m (0.1ms)[0m [1mBEGIN[0m
+---------------------------
+ProcessorTest: test_retries
+---------------------------
+[ActiveJob] [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+[ActiveJob] [1m[36mSQL (0.2ms)[0m [1mINSERT INTO "sidejobs" ("data", "queue", "priority", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id"[0m [["data", "{\"job_class\":\"ShareProductsJob\",\"job_id\":\"31245125-e0f6-44d6-a511-9218231e0f24\",\"queue_name\":\"default\",\"arguments\":[],\"locale\":\"en\"}"], ["queue", "default"], ["priority", 40], ["created_at", "2016-12-11 05:28:43.773911"], ["updated_at", "2016-12-11 05:28:43.773911"]]
+[ActiveJob] [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+[ActiveJob] Enqueued ShareProductsJob (Job ID: 31245125-e0f6-44d6-a511-9218231e0f24) to Sidejobs(default)
+ [1m[36mSidejobs::Job Load (0.4ms)[0m [1mSELECT "sidejobs".* FROM "sidejobs" WHERE "sidejobs"."status" IN ('pending', 'failing') AND (attempts < 3) AND (scheduled_at <= '2016-12-11 05:28:43.775478' OR scheduled_at IS NULL) ORDER BY "sidejobs"."priority" DESC LIMIT 20[0m
+ [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mUPDATE "sidejobs" SET "status" = $1, "processed_at" = $2, "attempts" = $3, "updated_at" = $4 WHERE "sidejobs"."id" = $5[0m [["status", "processing"], ["processed_at", "2016-12-11 05:28:43.776530"], ["attempts", 1], ["updated_at", "2016-12-11 05:28:43.777224"], ["id", 698]]
+ [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.2ms)[0m UPDATE "sidejobs" SET "status" = $1, "failed_at" = $2, "error" = $3, "updated_at" = $4 WHERE "sidejobs"."id" = $5 [["status", "failing"], ["failed_at", "2016-12-11 05:28:43.778860"], ["error", "Social network unavailable"], ["updated_at", "2016-12-11 05:28:43.779424"], ["id", 698]]
+ [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35mSidejobs::Job Load (0.3ms)[0m SELECT "sidejobs".* FROM "sidejobs" WHERE "sidejobs"."status" IN ('pending', 'failing') AND (attempts < 3) AND (scheduled_at <= '2016-12-11 05:28:43.780785' OR scheduled_at IS NULL) ORDER BY "sidejobs"."priority" DESC LIMIT 20
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.2ms)[0m UPDATE "sidejobs" SET "status" = $1, "processed_at" = $2, "attempts" = $3, "updated_at" = $4 WHERE "sidejobs"."id" = $5 [["status", "processing"], ["processed_at", "2016-12-11 05:28:43.781501"], ["attempts", 2], ["updated_at", "2016-12-11 05:28:43.782143"], ["id", 698]]
+ [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mUPDATE "sidejobs" SET "status" = $1, "failed_at" = $2, "updated_at" = $3 WHERE "sidejobs"."id" = $4[0m [["status", "failing"], ["failed_at", "2016-12-11 05:28:43.783408"], ["updated_at", "2016-12-11 05:28:43.783895"], ["id", 698]]
+ [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36mSidejobs::Job Load (0.3ms)[0m [1mSELECT "sidejobs".* FROM "sidejobs" WHERE "sidejobs"."status" IN ('pending', 'failing') AND (attempts < 3) AND (scheduled_at <= '2016-12-11 05:28:43.785245' OR scheduled_at IS NULL) ORDER BY "sidejobs"."priority" DESC LIMIT 20[0m
+ [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mUPDATE "sidejobs" SET "status" = $1, "processed_at" = $2, "attempts" = $3, "updated_at" = $4 WHERE "sidejobs"."id" = $5[0m [["status", "processing"], ["processed_at", "2016-12-11 05:28:43.785983"], ["attempts", 3], ["updated_at", "2016-12-11 05:28:43.786611"], ["id", 698]]
+ [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.2ms)[0m UPDATE "sidejobs" SET "status" = $1, "failed_at" = $2, "updated_at" = $3 WHERE "sidejobs"."id" = $4 [["status", "failing"], ["failed_at", "2016-12-11 05:28:43.788074"], ["updated_at", "2016-12-11 05:28:43.788591"], ["id", 698]]
+ [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35mSidejobs::Job Load (0.3ms)[0m SELECT "sidejobs".* FROM "sidejobs" WHERE "sidejobs"."status" IN ('pending', 'failing') AND (attempts < 3) AND (scheduled_at <= '2016-12-11 05:28:43.789741' OR scheduled_at IS NULL) ORDER BY "sidejobs"."priority" DESC LIMIT 20
+ [1m[36mSidejobs::Job Load (0.2ms)[0m [1mSELECT "sidejobs".* FROM "sidejobs" ORDER BY "sidejobs"."id" DESC LIMIT 1[0m
+ [1m[35m (0.2ms)[0m ROLLBACK
+ [1m[36m (0.1ms)[0m [1mBEGIN[0m
+---------------------------
+ProcessorTest: test_process
+---------------------------
+[ActiveJob] [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+[ActiveJob] [1m[36mSQL (0.2ms)[0m [1mINSERT INTO "sidejobs" ("data", "queue", "priority", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id"[0m [["data", "{\"job_class\":\"ActionMailer::DeliveryJob\",\"job_id\":\"15ca2775-6ca8-4d14-a470-fa0f3ea99336\",\"queue_name\":\"mailers\",\"arguments\":[\"UserMailer\",\"invite\",\"deliver_now\",\"test@mail.com\"],\"locale\":\"en\"}"], ["queue", "mailers"], ["priority", 80], ["created_at", "2016-12-11 05:28:43.792389"], ["updated_at", "2016-12-11 05:28:43.792389"]]
+[ActiveJob] [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+[ActiveJob] Enqueued ActionMailer::DeliveryJob (Job ID: 15ca2775-6ca8-4d14-a470-fa0f3ea99336) to Sidejobs(mailers) with arguments: "UserMailer", "invite", "deliver_now", "test@mail.com"
+ [1m[36mSidejobs::Job Load (0.3ms)[0m [1mSELECT "sidejobs".* FROM "sidejobs" WHERE "sidejobs"."status" IN ('pending', 'failing') AND (attempts < 3) AND (scheduled_at <= '2016-12-11 05:28:43.793881' OR scheduled_at IS NULL) ORDER BY "sidejobs"."priority" DESC LIMIT 20[0m
+ [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mUPDATE "sidejobs" SET "status" = $1, "processed_at" = $2, "attempts" = $3, "updated_at" = $4 WHERE "sidejobs"."id" = $5[0m [["status", "processing"], ["processed_at", "2016-12-11 05:28:43.794619"], ["attempts", 1], ["updated_at", "2016-12-11 05:28:43.795226"], ["id", 699]]
+ [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+ Rendered user_mailer/invite.text.erb (0.0ms)
+
+UserMailer#invite: processed outbound mail in 0.8ms
+
+Sent mail to test@mail.com (1.2ms)
+Date: Sun, 11 Dec 2016 02:28:43 -0300
+From: test@mail.com
+To: test@mail.com
+Message-ID: <584ce40bc2e69_36633fefbc43f9f46404@imac-de-matt.mail>
+Subject: Invite
+Mime-Version: 1.0
+Content-Type: text/plain;
+ charset=UTF-8
+Content-Transfer-Encoding: 7bit
+
+Test
+
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.2ms)[0m UPDATE "sidejobs" SET "status" = $1, "completed_at" = $2, "updated_at" = $3 WHERE "sidejobs"."id" = $4 [["status", "complete"], ["completed_at", "2016-12-11 05:28:43.799008"], ["updated_at", "2016-12-11 05:28:43.799639"], ["id", 699]]
+ [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35mSidejobs::Job Load (0.2ms)[0m SELECT "sidejobs".* FROM "sidejobs" ORDER BY "sidejobs"."id" DESC LIMIT 1
+ [1m[36m (0.1ms)[0m [1mROLLBACK[0m
+ [1m[35m (0.1ms)[0m BEGIN
+----------------------------
+GeneratorsTest: test_install
+----------------------------
+ [1m[36m (0.2ms)[0m [1mROLLBACK[0m
+ [1m[36m (13.9ms)[0m [1mCREATE TABLE "schema_migrations" ("version" character varying NOT NULL) [0m
+ [1m[35m (23.1ms)[0m CREATE UNIQUE INDEX "unique_schema_migrations" ON "schema_migrations" ("version")
+ [1m[36mActiveRecord::SchemaMigration Load (0.3ms)[0m [1mSELECT "schema_migrations".* FROM "schema_migrations"[0m
+Migrating to CreateSidejobs (20161022211612)
+ [1m[35m (0.2ms)[0m BEGIN
+ [1m[36m (14.2ms)[0m [1mCREATE TABLE "sidejobs" ("id" serial primary key, "data" jsonb, "queue" character varying, "status" character varying DEFAULT 'pending', "priority" integer DEFAULT 0, "attempts" integer DEFAULT 0, "error" text, "failed_at" timestamp, "completed_at" timestamp, "processed_at" timestamp, "scheduled_at" timestamp, "created_at" timestamp NOT NULL, "updated_at" timestamp NOT NULL) [0m
+ [1m[35m (6.8ms)[0m CREATE INDEX "index_sidejobs_on_status_and_scheduled_at" ON "sidejobs" ("status", "scheduled_at")
+ [1m[36m (0.7ms)[0m [1mCREATE INDEX "index_sidejobs_on_priority" ON "sidejobs" ("priority")[0m
+ [1m[35mSQL (0.3ms)[0m INSERT INTO "schema_migrations" ("version") VALUES ($1) [["version", "20161022211612"]]
+ [1m[36m (6.4ms)[0m [1mCOMMIT[0m
+ [1m[35mActiveRecord::SchemaMigration Load (0.2ms)[0m SELECT "schema_migrations".* FROM "schema_migrations"
+ [1m[36m (1.8ms)[0m [1mSELECT t2.oid::regclass::text AS to_table, a1.attname AS column, a2.attname AS primary_key, c.conname AS name, c.confupdtype AS on_update, c.confdeltype AS on_delete
+FROM pg_constraint c
+JOIN pg_class t1 ON c.conrelid = t1.oid
+JOIN pg_class t2 ON c.confrelid = t2.oid
+JOIN pg_attribute a1 ON a1.attnum = c.conkey[1] AND a1.attrelid = t1.oid
+JOIN pg_attribute a2 ON a2.attnum = c.confkey[1] AND a2.attrelid = t2.oid
+JOIN pg_namespace t3 ON c.connamespace = t3.oid
+WHERE c.contype = 'f'
+ AND t1.relname = 'sidejobs'
+ AND t3.nspname = ANY (current_schemas(false))
+ORDER BY c.conname
+[0m
+ [1m[36m (167.3ms)[0m [1mDROP DATABASE IF EXISTS "sidejobs_test"[0m
+ [1m[35m (368.8ms)[0m CREATE DATABASE "sidejobs_test" ENCODING = 'utf8'
+ [1m[36mSQL (0.4ms)[0m [1mCREATE EXTENSION IF NOT EXISTS "plpgsql"[0m
+ [1m[35m (4.4ms)[0m CREATE TABLE "sidejobs" ("id" serial primary key, "data" jsonb, "queue" character varying, "status" character varying DEFAULT 'pending', "priority" integer DEFAULT 0, "attempts" integer DEFAULT 0, "error" text, "failed_at" timestamp, "completed_at" timestamp, "processed_at" timestamp, "scheduled_at" timestamp, "created_at" timestamp NOT NULL, "updated_at" timestamp NOT NULL)
+ [1m[36m (1.0ms)[0m [1mCREATE INDEX "index_sidejobs_on_priority" ON "sidejobs" USING btree ("priority")[0m
+ [1m[35m (1.1ms)[0m CREATE INDEX "index_sidejobs_on_status_and_scheduled_at" ON "sidejobs" USING btree ("status", "scheduled_at")
+ [1m[36m (1.4ms)[0m [1mCREATE TABLE "schema_migrations" ("version" character varying NOT NULL) [0m
+ [1m[35m (0.8ms)[0m CREATE UNIQUE INDEX "unique_schema_migrations" ON "schema_migrations" ("version")
+ [1m[36m (0.2ms)[0m [1mSELECT version FROM "schema_migrations"[0m
+ [1m[35m (0.4ms)[0m INSERT INTO "schema_migrations" (version) VALUES ('20161022211612')
+ [1m[36mActiveRecord::SchemaMigration Load (0.4ms)[0m [1mSELECT "schema_migrations".* FROM "schema_migrations"[0m
+ [1m[35m (0.2ms)[0m BEGIN
+------------------------
+DaemonTest: test_process
+------------------------
+ [1m[36m (0.2ms)[0m [1mBEGIN[0m
+------------------------
+DaemonTest: test_pulling
+------------------------
+ [1m[35m (0.2ms)[0m ROLLBACK
+ [1m[36m (0.1ms)[0m [1mBEGIN[0m
+-------------------------
+ProcessorTest: test_batch
+-------------------------
+ [1m[35m (0.2ms)[0m ROLLBACK
+ [1m[36m (0.1ms)[0m [1mBEGIN[0m
+---------------------------
+ProcessorTest: test_process
+---------------------------
+[ActiveJob] [ActionMailer::DeliveryJob] [9588d0a6-4cbd-4435-82d3-0ce740c3f012] Performing ActionMailer::DeliveryJob from Inline(mailers) with arguments: "UserMailer", "invite", "deliver_now", "test@mail.com"
+[ActiveJob] [ActionMailer::DeliveryJob] [9588d0a6-4cbd-4435-82d3-0ce740c3f012] Rendered user_mailer/invite.text.erb (1.1ms)
+[ActiveJob] [ActionMailer::DeliveryJob] [9588d0a6-4cbd-4435-82d3-0ce740c3f012]
+UserMailer#invite: processed outbound mail in 159.5ms
+[ActiveJob] [ActionMailer::DeliveryJob] [9588d0a6-4cbd-4435-82d3-0ce740c3f012]
+Sent mail to test@mail.com (6.9ms)
+[ActiveJob] [ActionMailer::DeliveryJob] [9588d0a6-4cbd-4435-82d3-0ce740c3f012] Date: Tue, 13 Dec 2016 17:23:19 -0300
+From: test@mail.com
+To: test@mail.com
+Message-ID: <585058b7a156a_103173fcbfc43fa14809c2@imac-de-matt.mail>
+Subject: Invite
+Mime-Version: 1.0
+Content-Type: text/plain;
+ charset=UTF-8
+Content-Transfer-Encoding: 7bit
+
+Test
+
+[ActiveJob] [ActionMailer::DeliveryJob] [9588d0a6-4cbd-4435-82d3-0ce740c3f012] Performed ActionMailer::DeliveryJob from Inline(mailers) in 171.6ms
+[ActiveJob] Enqueued ActionMailer::DeliveryJob (Job ID: 9588d0a6-4cbd-4435-82d3-0ce740c3f012) to Inline(mailers) with arguments: "UserMailer", "invite", "deliver_now", "test@mail.com"
+ [1m[35mSidejobs::Job Load (1.1ms)[0m SELECT "sidejobs".* FROM "sidejobs" WHERE "sidejobs"."status" IN ('pending', 'failing') AND (attempts < 3) AND (scheduled_at <= '2016-12-13 20:23:19.667757' OR scheduled_at IS NULL) ORDER BY "sidejobs"."priority" DESC LIMIT 20
+ [1m[36mSidejobs::Job Load (0.3ms)[0m [1mSELECT "sidejobs".* FROM "sidejobs" ORDER BY "sidejobs"."id" DESC LIMIT 1[0m
+ [1m[35m (0.1ms)[0m ROLLBACK
+ [1m[36m (0.1ms)[0m [1mBEGIN[0m
+---------------------------
+ProcessorTest: test_retries
+---------------------------
+[ActiveJob] [ShareProductsJob] [d7bcb85f-4984-41ac-83ed-f07bfac02f12] Performing ShareProductsJob from Inline(default)
+[ActiveJob] [ShareProductsJob] [d7bcb85f-4984-41ac-83ed-f07bfac02f12] Performed ShareProductsJob from Inline(default) in 0.19ms
+ [1m[35m (0.2ms)[0m ROLLBACK
+ [1m[36m (0.1ms)[0m [1mBEGIN[0m
+----------------------------
+GeneratorsTest: test_install
+----------------------------
+ [1m[35m (0.2ms)[0m ROLLBACK
+ [1m[36m (0.1ms)[0m [1mBEGIN[0m
+-----------------------
+QueueTest: test_enqueue
+-----------------------
+[ActiveJob] [ActionMailer::DeliveryJob] [489f871a-9b19-4d2a-a6ae-ca6e92ac9a13] Performing ActionMailer::DeliveryJob from Inline(mailers) with arguments: "UserMailer", "invite", "deliver_now", "test@mail.com"
+[ActiveJob] [ActionMailer::DeliveryJob] [489f871a-9b19-4d2a-a6ae-ca6e92ac9a13] Rendered user_mailer/invite.text.erb (0.0ms)
+[ActiveJob] [ActionMailer::DeliveryJob] [489f871a-9b19-4d2a-a6ae-ca6e92ac9a13]
+UserMailer#invite: processed outbound mail in 0.9ms
+[ActiveJob] [ActionMailer::DeliveryJob] [489f871a-9b19-4d2a-a6ae-ca6e92ac9a13]
+Sent mail to test@mail.com (1.3ms)
+[ActiveJob] [ActionMailer::DeliveryJob] [489f871a-9b19-4d2a-a6ae-ca6e92ac9a13] Date: Tue, 13 Dec 2016 17:23:19 -0300
+From: test@mail.com
+To: test@mail.com
+Message-ID: <585058b7a7b12_103173fcbfc43fa14810c4@imac-de-matt.mail>
+Subject: Invite
+Mime-Version: 1.0
+Content-Type: text/plain;
+ charset=UTF-8
+Content-Transfer-Encoding: 7bit
+
+Test
+
+[ActiveJob] [ActionMailer::DeliveryJob] [489f871a-9b19-4d2a-a6ae-ca6e92ac9a13] Performed ActionMailer::DeliveryJob from Inline(mailers) in 2.47ms
+[ActiveJob] Enqueued ActionMailer::DeliveryJob (Job ID: 489f871a-9b19-4d2a-a6ae-ca6e92ac9a13) to Inline(mailers) with arguments: "UserMailer", "invite", "deliver_now", "test@mail.com"
+ [1m[35mSidejobs::Job Load (0.4ms)[0m SELECT "sidejobs".* FROM "sidejobs" ORDER BY "sidejobs"."id" DESC LIMIT 1
+ [1m[36m (0.1ms)[0m [1mROLLBACK[0m
+ [1m[36mActiveRecord::SchemaMigration Load (0.3ms)[0m [1mSELECT "schema_migrations".* FROM "schema_migrations"[0m
+ [1m[35m (0.2ms)[0m BEGIN
+------------------------
+DaemonTest: test_process
+------------------------
+ [1m[36mSidejobs::Job Load (1.2ms)[0m [1mSELECT "sidejobs".* FROM "sidejobs" WHERE "sidejobs"."status" IN ('pending', 'failing') AND (attempts < 3) AND (scheduled_at <= '2016-12-13 20:24:04.158159' OR scheduled_at IS NULL) ORDER BY "sidejobs"."priority" DESC LIMIT 20[0m
+ [1m[36mSidejobs::Job Load (1.3ms)[0m [1mSELECT "sidejobs".* FROM "sidejobs" WHERE "sidejobs"."status" IN ('pending', 'failing') AND (attempts < 3) AND (scheduled_at <= '2016-12-13 20:24:08.196338' OR scheduled_at IS NULL) ORDER BY "sidejobs"."priority" DESC LIMIT 20[0m
+ [1m[36m (0.2ms)[0m [1mBEGIN[0m
+------------------------
+DaemonTest: test_pulling
+------------------------
+ [1m[35m (0.2ms)[0m ROLLBACK
+ [1m[36m (0.1ms)[0m [1mBEGIN[0m
+-----------------------
+QueueTest: test_enqueue
+-----------------------
+[ActiveJob] [1m[35m (0.2ms)[0m SAVEPOINT active_record_1
+[ActiveJob] [1m[36mSQL (0.7ms)[0m [1mINSERT INTO "sidejobs" ("data", "queue", "priority", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id"[0m [["data", "{\"job_class\":\"ActionMailer::DeliveryJob\",\"job_id\":\"c423a886-5aa8-4c1b-95ae-5b3988443b51\",\"queue_name\":\"mailers\",\"arguments\":[\"UserMailer\",\"invite\",\"deliver_now\",\"test@mail.com\"],\"locale\":\"en\"}"], ["queue", "mailers"], ["priority", 80], ["created_at", "2016-12-13 20:24:28.197425"], ["updated_at", "2016-12-13 20:24:28.197425"]]
+[ActiveJob] [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+[ActiveJob] Enqueued ActionMailer::DeliveryJob (Job ID: c423a886-5aa8-4c1b-95ae-5b3988443b51) to Sidejobs(mailers) with arguments: "UserMailer", "invite", "deliver_now", "test@mail.com"
+ [1m[36mSidejobs::Job Load (0.5ms)[0m [1mSELECT "sidejobs".* FROM "sidejobs" ORDER BY "sidejobs"."id" DESC LIMIT 1[0m
+[ActiveJob] [1m[35m (0.2ms)[0m SAVEPOINT active_record_1
+[ActiveJob] [1m[36mSQL (0.3ms)[0m [1mINSERT INTO "sidejobs" ("data", "queue", "priority", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id"[0m [["data", "{\"job_class\":\"ChargeSubscriptionsJob\",\"job_id\":\"7fe5a591-9a9d-4a5a-8c3b-3606dc599814\",\"queue_name\":\"high_priority\",\"arguments\":[],\"locale\":\"en\"}"], ["queue", "high_priority"], ["priority", 60], ["created_at", "2016-12-13 20:24:28.206063"], ["updated_at", "2016-12-13 20:24:28.206063"]]
+[ActiveJob] [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+[ActiveJob] Enqueued ChargeSubscriptionsJob (Job ID: 7fe5a591-9a9d-4a5a-8c3b-3606dc599814) to Sidejobs(high_priority)
+ [1m[36mSidejobs::Job Load (0.2ms)[0m [1mSELECT "sidejobs".* FROM "sidejobs" ORDER BY "sidejobs"."id" DESC LIMIT 1[0m
+[ActiveJob] [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+[ActiveJob] [1m[36mSQL (0.2ms)[0m [1mINSERT INTO "sidejobs" ("data", "queue", "priority", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id"[0m [["data", "{\"job_class\":\"SendNewslettersJob\",\"job_id\":\"c7b95b1d-cf00-4db7-8467-dcada2412b5a\",\"queue_name\":\"default\",\"arguments\":[],\"locale\":\"en\"}"], ["queue", "default"], ["priority", 40], ["created_at", "2016-12-13 20:24:28.209963"], ["updated_at", "2016-12-13 20:24:28.209963"]]
+[ActiveJob] [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+[ActiveJob] Enqueued SendNewslettersJob (Job ID: c7b95b1d-cf00-4db7-8467-dcada2412b5a) to Sidejobs(default)
+ [1m[36mSidejobs::Job Load (0.2ms)[0m [1mSELECT "sidejobs".* FROM "sidejobs" ORDER BY "sidejobs"."id" DESC LIMIT 1[0m
+[ActiveJob] [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+[ActiveJob] [1m[36mSQL (0.2ms)[0m [1mINSERT INTO "sidejobs" ("data", "queue", "priority", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id"[0m [["data", "{\"job_class\":\"UpdateExchangesJob\",\"job_id\":\"51813574-8ae0-459c-becd-c38b544179c8\",\"queue_name\":\"low_priority\",\"arguments\":[],\"locale\":\"en\"}"], ["queue", "low_priority"], ["priority", 20], ["created_at", "2016-12-13 20:24:28.214123"], ["updated_at", "2016-12-13 20:24:28.214123"]]
+[ActiveJob] [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+[ActiveJob] Enqueued UpdateExchangesJob (Job ID: 51813574-8ae0-459c-becd-c38b544179c8) to Sidejobs(low_priority)
+ [1m[36mSidejobs::Job Load (0.3ms)[0m [1mSELECT "sidejobs".* FROM "sidejobs" ORDER BY "sidejobs"."id" DESC LIMIT 1[0m
+[ActiveJob] [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+[ActiveJob] [1m[36mSQL (0.2ms)[0m [1mINSERT INTO "sidejobs" ("data", "queue", "created_at", "updated_at") VALUES ($1, $2, $3, $4) RETURNING "id"[0m [["data", "{\"job_class\":\"ClearGuestUsersJob\",\"job_id\":\"7030e029-5966-4159-8724-b656963e7831\",\"queue_name\":\"other\",\"arguments\":[],\"locale\":\"en\"}"], ["queue", "other"], ["created_at", "2016-12-13 20:24:28.223048"], ["updated_at", "2016-12-13 20:24:28.223048"]]
+[ActiveJob] [1m[35m (0.2ms)[0m RELEASE SAVEPOINT active_record_1
+[ActiveJob] Enqueued ClearGuestUsersJob (Job ID: 7030e029-5966-4159-8724-b656963e7831) to Sidejobs(other)
+ [1m[36mSidejobs::Job Load (0.3ms)[0m [1mSELECT "sidejobs".* FROM "sidejobs" ORDER BY "sidejobs"."id" DESC LIMIT 1[0m
+[ActiveJob] [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+[ActiveJob] [1m[36mSQL (0.2ms)[0m [1mINSERT INTO "sidejobs" ("data", "queue", "priority", "scheduled_at", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5, $6) RETURNING "id"[0m [["data", "{\"job_class\":\"ActionMailer::DeliveryJob\",\"job_id\":\"753aba9b-a575-4c1f-9c4d-3162e7fe3564\",\"queue_name\":\"mailers\",\"arguments\":[\"UserMailer\",\"invite\",\"deliver_now\",\"test@mail.com\"],\"locale\":\"en\"}"], ["queue", "mailers"], ["priority", 80], ["scheduled_at", "2016-12-14 06:24:28.225541"], ["created_at", "2016-12-13 20:24:28.226395"], ["updated_at", "2016-12-13 20:24:28.226395"]]
+[ActiveJob] [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+[ActiveJob] Enqueued ActionMailer::DeliveryJob (Job ID: 753aba9b-a575-4c1f-9c4d-3162e7fe3564) to Sidejobs(mailers) at 2016-12-14 06:24:28 UTC with arguments: "UserMailer", "invite", "deliver_now", "test@mail.com"
+ [1m[36mSidejobs::Job Load (0.2ms)[0m [1mSELECT "sidejobs".* FROM "sidejobs" ORDER BY "sidejobs"."id" DESC LIMIT 1[0m
+[ActiveJob] [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+[ActiveJob] [1m[36mSQL (0.2ms)[0m [1mINSERT INTO "sidejobs" ("data", "queue", "priority", "scheduled_at", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5, $6) RETURNING "id"[0m [["data", "{\"job_class\":\"ChargeSubscriptionsJob\",\"job_id\":\"e0e35491-9424-4e6a-bab1-bbd46794c259\",\"queue_name\":\"high_priority\",\"arguments\":[],\"locale\":\"en\"}"], ["queue", "high_priority"], ["priority", 60], ["scheduled_at", "2016-12-14 06:24:28.225541"], ["created_at", "2016-12-13 20:24:28.229297"], ["updated_at", "2016-12-13 20:24:28.229297"]]
+[ActiveJob] [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+[ActiveJob] Enqueued ChargeSubscriptionsJob (Job ID: e0e35491-9424-4e6a-bab1-bbd46794c259) to Sidejobs(high_priority) at 2016-12-14 06:24:28 UTC
+ [1m[36mSidejobs::Job Load (0.3ms)[0m [1mSELECT "sidejobs".* FROM "sidejobs" ORDER BY "sidejobs"."id" DESC LIMIT 1[0m
+[ActiveJob] [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+[ActiveJob] [1m[36mSQL (0.2ms)[0m [1mINSERT INTO "sidejobs" ("data", "queue", "priority", "scheduled_at", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5, $6) RETURNING "id"[0m [["data", "{\"job_class\":\"SendNewslettersJob\",\"job_id\":\"c9f1d9b9-34e0-47e6-9c61-166d373b0d4f\",\"queue_name\":\"default\",\"arguments\":[],\"locale\":\"en\"}"], ["queue", "default"], ["priority", 40], ["scheduled_at", "2016-12-14 06:24:28.225541"], ["created_at", "2016-12-13 20:24:28.232092"], ["updated_at", "2016-12-13 20:24:28.232092"]]
+[ActiveJob] [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+[ActiveJob] Enqueued SendNewslettersJob (Job ID: c9f1d9b9-34e0-47e6-9c61-166d373b0d4f) to Sidejobs(default) at 2016-12-14 06:24:28 UTC
+ [1m[36mSidejobs::Job Load (0.3ms)[0m [1mSELECT "sidejobs".* FROM "sidejobs" ORDER BY "sidejobs"."id" DESC LIMIT 1[0m
+[ActiveJob] [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+[ActiveJob] [1m[36mSQL (0.2ms)[0m [1mINSERT INTO "sidejobs" ("data", "queue", "priority", "scheduled_at", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5, $6) RETURNING "id"[0m [["data", "{\"job_class\":\"UpdateExchangesJob\",\"job_id\":\"91804713-9d59-4ab4-9734-8ca8d72711c1\",\"queue_name\":\"low_priority\",\"arguments\":[],\"locale\":\"en\"}"], ["queue", "low_priority"], ["priority", 20], ["scheduled_at", "2016-12-14 06:24:28.225541"], ["created_at", "2016-12-13 20:24:28.234816"], ["updated_at", "2016-12-13 20:24:28.234816"]]
+[ActiveJob] [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+[ActiveJob] Enqueued UpdateExchangesJob (Job ID: 91804713-9d59-4ab4-9734-8ca8d72711c1) to Sidejobs(low_priority) at 2016-12-14 06:24:28 UTC
+ [1m[36mSidejobs::Job Load (0.2ms)[0m [1mSELECT "sidejobs".* FROM "sidejobs" ORDER BY "sidejobs"."id" DESC LIMIT 1[0m
+[ActiveJob] [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+[ActiveJob] [1m[36mSQL (0.2ms)[0m [1mINSERT INTO "sidejobs" ("data", "queue", "scheduled_at", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id"[0m [["data", "{\"job_class\":\"ClearGuestUsersJob\",\"job_id\":\"68f02b80-31a0-4f83-9336-70bdfba07f09\",\"queue_name\":\"other\",\"arguments\":[],\"locale\":\"en\"}"], ["queue", "other"], ["scheduled_at", "2016-12-14 06:24:28.225541"], ["created_at", "2016-12-13 20:24:28.237507"], ["updated_at", "2016-12-13 20:24:28.237507"]]
+[ActiveJob] [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+[ActiveJob] Enqueued ClearGuestUsersJob (Job ID: 68f02b80-31a0-4f83-9336-70bdfba07f09) to Sidejobs(other) at 2016-12-14 06:24:28 UTC
+ [1m[36mSidejobs::Job Load (0.2ms)[0m [1mSELECT "sidejobs".* FROM "sidejobs" ORDER BY "sidejobs"."id" DESC LIMIT 1[0m
+ [1m[35m (0.2ms)[0m ROLLBACK
+ [1m[36m (0.1ms)[0m [1mBEGIN[0m
+----------------------------
+GeneratorsTest: test_install
+----------------------------
+ [1m[35m (0.2ms)[0m ROLLBACK
+ [1m[36m (0.1ms)[0m [1mBEGIN[0m
+-------------------------
+ProcessorTest: test_batch
+-------------------------
+[ActiveJob] [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+[ActiveJob] [1m[36mSQL (0.2ms)[0m [1mINSERT INTO "sidejobs" ("data", "queue", "priority", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id"[0m [["data", "{\"job_class\":\"ActionMailer::DeliveryJob\",\"job_id\":\"e36ae247-7725-4c13-9f67-3f2b012de651\",\"queue_name\":\"mailers\",\"arguments\":[\"UserMailer\",\"invite\",\"deliver_now\",\"test@mail.com\"],\"locale\":\"en\"}"], ["queue", "mailers"], ["priority", 80], ["created_at", "2016-12-13 20:24:28.246258"], ["updated_at", "2016-12-13 20:24:28.246258"]]
+[ActiveJob] [1m[35m (0.2ms)[0m RELEASE SAVEPOINT active_record_1
+[ActiveJob] Enqueued ActionMailer::DeliveryJob (Job ID: e36ae247-7725-4c13-9f67-3f2b012de651) to Sidejobs(mailers) with arguments: "UserMailer", "invite", "deliver_now", "test@mail.com"
+[ActiveJob] [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+[ActiveJob] [1m[35mSQL (0.2ms)[0m INSERT INTO "sidejobs" ("data", "queue", "priority", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id" [["data", "{\"job_class\":\"ActionMailer::DeliveryJob\",\"job_id\":\"92e643ed-7f63-48be-b77a-0d7a3f36e4a7\",\"queue_name\":\"mailers\",\"arguments\":[\"UserMailer\",\"invite\",\"deliver_now\",\"test@mail.com\"],\"locale\":\"en\"}"], ["queue", "mailers"], ["priority", 80], ["created_at", "2016-12-13 20:24:28.248630"], ["updated_at", "2016-12-13 20:24:28.248630"]]
+[ActiveJob] [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+[ActiveJob] Enqueued ActionMailer::DeliveryJob (Job ID: 92e643ed-7f63-48be-b77a-0d7a3f36e4a7) to Sidejobs(mailers) with arguments: "UserMailer", "invite", "deliver_now", "test@mail.com"
+[ActiveJob] [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+[ActiveJob] [1m[36mSQL (0.2ms)[0m [1mINSERT INTO "sidejobs" ("data", "queue", "priority", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id"[0m [["data", "{\"job_class\":\"ActionMailer::DeliveryJob\",\"job_id\":\"76cbf4c5-4991-4b63-b8ed-bf8ce2c8ac45\",\"queue_name\":\"mailers\",\"arguments\":[\"UserMailer\",\"invite\",\"deliver_now\",\"test@mail.com\"],\"locale\":\"en\"}"], ["queue", "mailers"], ["priority", 80], ["created_at", "2016-12-13 20:24:28.251147"], ["updated_at", "2016-12-13 20:24:28.251147"]]
+[ActiveJob] [1m[35m (0.2ms)[0m RELEASE SAVEPOINT active_record_1
+[ActiveJob] Enqueued ActionMailer::DeliveryJob (Job ID: 76cbf4c5-4991-4b63-b8ed-bf8ce2c8ac45) to Sidejobs(mailers) with arguments: "UserMailer", "invite", "deliver_now", "test@mail.com"
+[ActiveJob] [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+[ActiveJob] [1m[35mSQL (0.2ms)[0m INSERT INTO "sidejobs" ("data", "queue", "priority", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id" [["data", "{\"job_class\":\"ActionMailer::DeliveryJob\",\"job_id\":\"eece3fd9-dfaa-4ad8-9aa1-4e8f5c5e27ec\",\"queue_name\":\"mailers\",\"arguments\":[\"UserMailer\",\"invite\",\"deliver_now\",\"test@mail.com\"],\"locale\":\"en\"}"], ["queue", "mailers"], ["priority", 80], ["created_at", "2016-12-13 20:24:28.253808"], ["updated_at", "2016-12-13 20:24:28.253808"]]
+[ActiveJob] [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+[ActiveJob] Enqueued ActionMailer::DeliveryJob (Job ID: eece3fd9-dfaa-4ad8-9aa1-4e8f5c5e27ec) to Sidejobs(mailers) with arguments: "UserMailer", "invite", "deliver_now", "test@mail.com"
+[ActiveJob] [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+[ActiveJob] [1m[36mSQL (0.2ms)[0m [1mINSERT INTO "sidejobs" ("data", "queue", "priority", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id"[0m [["data", "{\"job_class\":\"ActionMailer::DeliveryJob\",\"job_id\":\"b6c9dbc8-253d-498d-a366-a078ba6fa567\",\"queue_name\":\"mailers\",\"arguments\":[\"UserMailer\",\"invite\",\"deliver_now\",\"test@mail.com\"],\"locale\":\"en\"}"], ["queue", "mailers"], ["priority", 80], ["created_at", "2016-12-13 20:24:28.256526"], ["updated_at", "2016-12-13 20:24:28.256526"]]
+[ActiveJob] [1m[35m (0.2ms)[0m RELEASE SAVEPOINT active_record_1
+[ActiveJob] Enqueued ActionMailer::DeliveryJob (Job ID: b6c9dbc8-253d-498d-a366-a078ba6fa567) to Sidejobs(mailers) with arguments: "UserMailer", "invite", "deliver_now", "test@mail.com"
+[ActiveJob] [1m[36m (0.2ms)[0m [1mSAVEPOINT active_record_1[0m
+[ActiveJob] [1m[35mSQL (0.2ms)[0m INSERT INTO "sidejobs" ("data", "queue", "priority", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id" [["data", "{\"job_class\":\"ActionMailer::DeliveryJob\",\"job_id\":\"3e161bb2-e2ee-411b-8889-807d8237aca5\",\"queue_name\":\"mailers\",\"arguments\":[\"UserMailer\",\"invite\",\"deliver_now\",\"test@mail.com\"],\"locale\":\"en\"}"], ["queue", "mailers"], ["priority", 80], ["created_at", "2016-12-13 20:24:28.259666"], ["updated_at", "2016-12-13 20:24:28.259666"]]
+[ActiveJob] [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+[ActiveJob] Enqueued ActionMailer::DeliveryJob (Job ID: 3e161bb2-e2ee-411b-8889-807d8237aca5) to Sidejobs(mailers) with arguments: "UserMailer", "invite", "deliver_now", "test@mail.com"
+[ActiveJob] [1m[35m (0.2ms)[0m SAVEPOINT active_record_1
+[ActiveJob] [1m[36mSQL (0.2ms)[0m [1mINSERT INTO "sidejobs" ("data", "queue", "priority", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id"[0m [["data", "{\"job_class\":\"ActionMailer::DeliveryJob\",\"job_id\":\"1bdd02bf-1cb5-4154-b528-26c207dbb52c\",\"queue_name\":\"mailers\",\"arguments\":[\"UserMailer\",\"invite\",\"deliver_now\",\"test@mail.com\"],\"locale\":\"en\"}"], ["queue", "mailers"], ["priority", 80], ["created_at", "2016-12-13 20:24:28.262444"], ["updated_at", "2016-12-13 20:24:28.262444"]]
+[ActiveJob] [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+[ActiveJob] Enqueued ActionMailer::DeliveryJob (Job ID: 1bdd02bf-1cb5-4154-b528-26c207dbb52c) to Sidejobs(mailers) with arguments: "UserMailer", "invite", "deliver_now", "test@mail.com"
+[ActiveJob] [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+[ActiveJob] [1m[35mSQL (0.2ms)[0m INSERT INTO "sidejobs" ("data", "queue", "priority", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id" [["data", "{\"job_class\":\"ActionMailer::DeliveryJob\",\"job_id\":\"0c65cfb1-d655-4b24-b1e8-33a88d4ac7a4\",\"queue_name\":\"mailers\",\"arguments\":[\"UserMailer\",\"invite\",\"deliver_now\",\"test@mail.com\"],\"locale\":\"en\"}"], ["queue", "mailers"], ["priority", 80], ["created_at", "2016-12-13 20:24:28.264782"], ["updated_at", "2016-12-13 20:24:28.264782"]]
+[ActiveJob] [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+[ActiveJob] Enqueued ActionMailer::DeliveryJob (Job ID: 0c65cfb1-d655-4b24-b1e8-33a88d4ac7a4) to Sidejobs(mailers) with arguments: "UserMailer", "invite", "deliver_now", "test@mail.com"
+[ActiveJob] [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+[ActiveJob] [1m[36mSQL (0.5ms)[0m [1mINSERT INTO "sidejobs" ("data", "queue", "priority", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id"[0m [["data", "{\"job_class\":\"ActionMailer::DeliveryJob\",\"job_id\":\"3a60b713-4300-4ad7-b403-d48b2c33055d\",\"queue_name\":\"mailers\",\"arguments\":[\"UserMailer\",\"invite\",\"deliver_now\",\"test@mail.com\"],\"locale\":\"en\"}"], ["queue", "mailers"], ["priority", 80], ["created_at", "2016-12-13 20:24:28.267615"], ["updated_at", "2016-12-13 20:24:28.267615"]]
+[ActiveJob] [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+[ActiveJob] Enqueued ActionMailer::DeliveryJob (Job ID: 3a60b713-4300-4ad7-b403-d48b2c33055d) to Sidejobs(mailers) with arguments: "UserMailer", "invite", "deliver_now", "test@mail.com"
+[ActiveJob] [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+[ActiveJob] [1m[35mSQL (0.2ms)[0m INSERT INTO "sidejobs" ("data", "queue", "priority", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id" [["data", "{\"job_class\":\"ActionMailer::DeliveryJob\",\"job_id\":\"9d5af0f5-404d-47d8-9db7-0f572a996d58\",\"queue_name\":\"mailers\",\"arguments\":[\"UserMailer\",\"invite\",\"deliver_now\",\"test@mail.com\"],\"locale\":\"en\"}"], ["queue", "mailers"], ["priority", 80], ["created_at", "2016-12-13 20:24:28.270971"], ["updated_at", "2016-12-13 20:24:28.270971"]]
+[ActiveJob] [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+[ActiveJob] Enqueued ActionMailer::DeliveryJob (Job ID: 9d5af0f5-404d-47d8-9db7-0f572a996d58) to Sidejobs(mailers) with arguments: "UserMailer", "invite", "deliver_now", "test@mail.com"
+[ActiveJob] [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+[ActiveJob] [1m[36mSQL (0.2ms)[0m [1mINSERT INTO "sidejobs" ("data", "queue", "priority", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id"[0m [["data", "{\"job_class\":\"ActionMailer::DeliveryJob\",\"job_id\":\"98fc1211-3b39-460e-806c-0d6443cf8f8c\",\"queue_name\":\"mailers\",\"arguments\":[\"UserMailer\",\"invite\",\"deliver_now\",\"test@mail.com\"],\"locale\":\"en\"}"], ["queue", "mailers"], ["priority", 80], ["created_at", "2016-12-13 20:24:28.273492"], ["updated_at", "2016-12-13 20:24:28.273492"]]
+[ActiveJob] [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+[ActiveJob] Enqueued ActionMailer::DeliveryJob (Job ID: 98fc1211-3b39-460e-806c-0d6443cf8f8c) to Sidejobs(mailers) with arguments: "UserMailer", "invite", "deliver_now", "test@mail.com"
+[ActiveJob] [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+[ActiveJob] [1m[35mSQL (0.2ms)[0m INSERT INTO "sidejobs" ("data", "queue", "priority", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id" [["data", "{\"job_class\":\"ActionMailer::DeliveryJob\",\"job_id\":\"d35f7f3d-8550-49c6-b8e2-40c29233c77f\",\"queue_name\":\"mailers\",\"arguments\":[\"UserMailer\",\"invite\",\"deliver_now\",\"test@mail.com\"],\"locale\":\"en\"}"], ["queue", "mailers"], ["priority", 80], ["created_at", "2016-12-13 20:24:28.275933"], ["updated_at", "2016-12-13 20:24:28.275933"]]
+[ActiveJob] [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+[ActiveJob] Enqueued ActionMailer::DeliveryJob (Job ID: d35f7f3d-8550-49c6-b8e2-40c29233c77f) to Sidejobs(mailers) with arguments: "UserMailer", "invite", "deliver_now", "test@mail.com"
+[ActiveJob] [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+[ActiveJob] [1m[36mSQL (0.1ms)[0m [1mINSERT INTO "sidejobs" ("data", "queue", "priority", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id"[0m [["data", "{\"job_class\":\"ActionMailer::DeliveryJob\",\"job_id\":\"aa1eb8d3-c4b6-43f9-bf57-ce198d7f6ada\",\"queue_name\":\"mailers\",\"arguments\":[\"UserMailer\",\"invite\",\"deliver_now\",\"test@mail.com\"],\"locale\":\"en\"}"], ["queue", "mailers"], ["priority", 80], ["created_at", "2016-12-13 20:24:28.278249"], ["updated_at", "2016-12-13 20:24:28.278249"]]
+[ActiveJob] [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+[ActiveJob] Enqueued ActionMailer::DeliveryJob (Job ID: aa1eb8d3-c4b6-43f9-bf57-ce198d7f6ada) to Sidejobs(mailers) with arguments: "UserMailer", "invite", "deliver_now", "test@mail.com"
+[ActiveJob] [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+[ActiveJob] [1m[35mSQL (0.2ms)[0m INSERT INTO "sidejobs" ("data", "queue", "priority", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id" [["data", "{\"job_class\":\"ActionMailer::DeliveryJob\",\"job_id\":\"a0a97263-2dd5-4192-8c34-047408403b6a\",\"queue_name\":\"mailers\",\"arguments\":[\"UserMailer\",\"invite\",\"deliver_now\",\"test@mail.com\"],\"locale\":\"en\"}"], ["queue", "mailers"], ["priority", 80], ["created_at", "2016-12-13 20:24:28.280138"], ["updated_at", "2016-12-13 20:24:28.280138"]]
+[ActiveJob] [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+[ActiveJob] Enqueued ActionMailer::DeliveryJob (Job ID: a0a97263-2dd5-4192-8c34-047408403b6a) to Sidejobs(mailers) with arguments: "UserMailer", "invite", "deliver_now", "test@mail.com"
+[ActiveJob] [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+[ActiveJob] [1m[36mSQL (0.2ms)[0m [1mINSERT INTO "sidejobs" ("data", "queue", "priority", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id"[0m [["data", "{\"job_class\":\"ActionMailer::DeliveryJob\",\"job_id\":\"f067ecf3-36aa-4a12-afc3-fb855e905ac5\",\"queue_name\":\"mailers\",\"arguments\":[\"UserMailer\",\"invite\",\"deliver_now\",\"test@mail.com\"],\"locale\":\"en\"}"], ["queue", "mailers"], ["priority", 80], ["created_at", "2016-12-13 20:24:28.282359"], ["updated_at", "2016-12-13 20:24:28.282359"]]
+[ActiveJob] [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+[ActiveJob] Enqueued ActionMailer::DeliveryJob (Job ID: f067ecf3-36aa-4a12-afc3-fb855e905ac5) to Sidejobs(mailers) with arguments: "UserMailer", "invite", "deliver_now", "test@mail.com"
+[ActiveJob] [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+[ActiveJob] [1m[35mSQL (0.2ms)[0m INSERT INTO "sidejobs" ("data", "queue", "priority", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id" [["data", "{\"job_class\":\"ActionMailer::DeliveryJob\",\"job_id\":\"40911424-a348-46f9-91ed-32a907b2aa2b\",\"queue_name\":\"mailers\",\"arguments\":[\"UserMailer\",\"invite\",\"deliver_now\",\"test@mail.com\"],\"locale\":\"en\"}"], ["queue", "mailers"], ["priority", 80], ["created_at", "2016-12-13 20:24:28.284420"], ["updated_at", "2016-12-13 20:24:28.284420"]]
+[ActiveJob] [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+[ActiveJob] Enqueued ActionMailer::DeliveryJob (Job ID: 40911424-a348-46f9-91ed-32a907b2aa2b) to Sidejobs(mailers) with arguments: "UserMailer", "invite", "deliver_now", "test@mail.com"
+[ActiveJob] [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+[ActiveJob] [1m[36mSQL (0.2ms)[0m [1mINSERT INTO "sidejobs" ("data", "queue", "priority", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id"[0m [["data", "{\"job_class\":\"ActionMailer::DeliveryJob\",\"job_id\":\"aca17d46-92f9-49de-8d59-58844d3f84d9\",\"queue_name\":\"mailers\",\"arguments\":[\"UserMailer\",\"invite\",\"deliver_now\",\"test@mail.com\"],\"locale\":\"en\"}"], ["queue", "mailers"], ["priority", 80], ["created_at", "2016-12-13 20:24:28.286689"], ["updated_at", "2016-12-13 20:24:28.286689"]]
+[ActiveJob] [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+[ActiveJob] Enqueued ActionMailer::DeliveryJob (Job ID: aca17d46-92f9-49de-8d59-58844d3f84d9) to Sidejobs(mailers) with arguments: "UserMailer", "invite", "deliver_now", "test@mail.com"
+[ActiveJob] [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+[ActiveJob] [1m[35mSQL (0.2ms)[0m INSERT INTO "sidejobs" ("data", "queue", "priority", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id" [["data", "{\"job_class\":\"ActionMailer::DeliveryJob\",\"job_id\":\"daf62c33-01dd-447d-a647-23fc14b3036b\",\"queue_name\":\"mailers\",\"arguments\":[\"UserMailer\",\"invite\",\"deliver_now\",\"test@mail.com\"],\"locale\":\"en\"}"], ["queue", "mailers"], ["priority", 80], ["created_at", "2016-12-13 20:24:28.289131"], ["updated_at", "2016-12-13 20:24:28.289131"]]
+[ActiveJob] [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+[ActiveJob] Enqueued ActionMailer::DeliveryJob (Job ID: daf62c33-01dd-447d-a647-23fc14b3036b) to Sidejobs(mailers) with arguments: "UserMailer", "invite", "deliver_now", "test@mail.com"
+[ActiveJob] [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+[ActiveJob] [1m[36mSQL (0.4ms)[0m [1mINSERT INTO "sidejobs" ("data", "queue", "priority", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id"[0m [["data", "{\"job_class\":\"ActionMailer::DeliveryJob\",\"job_id\":\"b04c51b8-461e-4098-9403-c3ccf0d67f36\",\"queue_name\":\"mailers\",\"arguments\":[\"UserMailer\",\"invite\",\"deliver_now\",\"test@mail.com\"],\"locale\":\"en\"}"], ["queue", "mailers"], ["priority", 80], ["created_at", "2016-12-13 20:24:28.291187"], ["updated_at", "2016-12-13 20:24:28.291187"]]
+[ActiveJob] [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+[ActiveJob] Enqueued ActionMailer::DeliveryJob (Job ID: b04c51b8-461e-4098-9403-c3ccf0d67f36) to Sidejobs(mailers) with arguments: "UserMailer", "invite", "deliver_now", "test@mail.com"
+[ActiveJob] [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+[ActiveJob] [1m[35mSQL (0.2ms)[0m INSERT INTO "sidejobs" ("data", "queue", "priority", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id" [["data", "{\"job_class\":\"ActionMailer::DeliveryJob\",\"job_id\":\"d71c71c4-f3af-42e2-a620-1dd529de013d\",\"queue_name\":\"mailers\",\"arguments\":[\"UserMailer\",\"invite\",\"deliver_now\",\"test@mail.com\"],\"locale\":\"en\"}"], ["queue", "mailers"], ["priority", 80], ["created_at", "2016-12-13 20:24:28.293415"], ["updated_at", "2016-12-13 20:24:28.293415"]]
+[ActiveJob] [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+[ActiveJob] Enqueued ActionMailer::DeliveryJob (Job ID: d71c71c4-f3af-42e2-a620-1dd529de013d) to Sidejobs(mailers) with arguments: "UserMailer", "invite", "deliver_now", "test@mail.com"
+[ActiveJob] [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+[ActiveJob] [1m[36mSQL (0.2ms)[0m [1mINSERT INTO "sidejobs" ("data", "queue", "priority", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id"[0m [["data", "{\"job_class\":\"ActionMailer::DeliveryJob\",\"job_id\":\"ad4f9879-2920-4318-802d-0dc793a0b6f7\",\"queue_name\":\"mailers\",\"arguments\":[\"UserMailer\",\"invite\",\"deliver_now\",\"test@mail.com\"],\"locale\":\"en\"}"], ["queue", "mailers"], ["priority", 80], ["created_at", "2016-12-13 20:24:28.295631"], ["updated_at", "2016-12-13 20:24:28.295631"]]
+[ActiveJob] [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+[ActiveJob] Enqueued ActionMailer::DeliveryJob (Job ID: ad4f9879-2920-4318-802d-0dc793a0b6f7) to Sidejobs(mailers) with arguments: "UserMailer", "invite", "deliver_now", "test@mail.com"
+[ActiveJob] [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+[ActiveJob] [1m[35mSQL (0.2ms)[0m INSERT INTO "sidejobs" ("data", "queue", "priority", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id" [["data", "{\"job_class\":\"ActionMailer::DeliveryJob\",\"job_id\":\"ba189cb7-c8b6-4b47-97d7-48a3b1da057e\",\"queue_name\":\"mailers\",\"arguments\":[\"UserMailer\",\"invite\",\"deliver_now\",\"test@mail.com\"],\"locale\":\"en\"}"], ["queue", "mailers"], ["priority", 80], ["created_at", "2016-12-13 20:24:28.297667"], ["updated_at", "2016-12-13 20:24:28.297667"]]
+[ActiveJob] [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+[ActiveJob] Enqueued ActionMailer::DeliveryJob (Job ID: ba189cb7-c8b6-4b47-97d7-48a3b1da057e) to Sidejobs(mailers) with arguments: "UserMailer", "invite", "deliver_now", "test@mail.com"
+[ActiveJob] [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+[ActiveJob] [1m[36mSQL (0.2ms)[0m [1mINSERT INTO "sidejobs" ("data", "queue", "priority", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id"[0m [["data", "{\"job_class\":\"ActionMailer::DeliveryJob\",\"job_id\":\"3c3caa41-6c80-4e81-ab18-1ba9ce1173a5\",\"queue_name\":\"mailers\",\"arguments\":[\"UserMailer\",\"invite\",\"deliver_now\",\"test@mail.com\"],\"locale\":\"en\"}"], ["queue", "mailers"], ["priority", 80], ["created_at", "2016-12-13 20:24:28.299774"], ["updated_at", "2016-12-13 20:24:28.299774"]]
+[ActiveJob] [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+[ActiveJob] Enqueued ActionMailer::DeliveryJob (Job ID: 3c3caa41-6c80-4e81-ab18-1ba9ce1173a5) to Sidejobs(mailers) with arguments: "UserMailer", "invite", "deliver_now", "test@mail.com"
+[ActiveJob] [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+[ActiveJob] [1m[35mSQL (0.2ms)[0m INSERT INTO "sidejobs" ("data", "queue", "priority", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id" [["data", "{\"job_class\":\"ActionMailer::DeliveryJob\",\"job_id\":\"2ad1b9d2-e2ad-436c-953f-6f8df84c635b\",\"queue_name\":\"mailers\",\"arguments\":[\"UserMailer\",\"invite\",\"deliver_now\",\"test@mail.com\"],\"locale\":\"en\"}"], ["queue", "mailers"], ["priority", 80], ["created_at", "2016-12-13 20:24:28.301817"], ["updated_at", "2016-12-13 20:24:28.301817"]]
+[ActiveJob] [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+[ActiveJob] Enqueued ActionMailer::DeliveryJob (Job ID: 2ad1b9d2-e2ad-436c-953f-6f8df84c635b) to Sidejobs(mailers) with arguments: "UserMailer", "invite", "deliver_now", "test@mail.com"
+ [1m[35mSidejobs::Job Load (0.8ms)[0m SELECT "sidejobs".* FROM "sidejobs" WHERE "sidejobs"."status" IN ('pending', 'failing') AND (attempts < 3) AND (scheduled_at <= '2016-12-13 20:24:28.305176' OR scheduled_at IS NULL) ORDER BY "sidejobs"."priority" DESC LIMIT 20
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.2ms)[0m UPDATE "sidejobs" SET "status" = $1, "processed_at" = $2, "attempts" = $3, "updated_at" = $4 WHERE "sidejobs"."id" = $5 [["status", "processing"], ["processed_at", "2016-12-13 20:24:28.306871"], ["attempts", 1], ["updated_at", "2016-12-13 20:24:28.307605"], ["id", 11]]
+ [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ Rendered user_mailer/invite.text.erb (0.6ms)
+
+UserMailer#invite: processed outbound mail in 127.2ms
+
+Sent mail to test@mail.com (3.5ms)
+Date: Tue, 13 Dec 2016 17:24:28 -0300
+From: test@mail.com
+To: test@mail.com
+Message-ID: <585058fc6c3c9_103433fcc2283f9f428353@imac-de-matt.mail>
+Subject: Invite
+Mime-Version: 1.0
+Content-Type: text/plain;
+ charset=UTF-8
+Content-Transfer-Encoding: 7bit
+
+Test
+
+ [1m[35m (0.2ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mUPDATE "sidejobs" SET "status" = $1, "completed_at" = $2, "updated_at" = $3 WHERE "sidejobs"."id" = $4[0m [["status", "complete"], ["completed_at", "2016-12-13 20:24:28.444877"], ["updated_at", "2016-12-13 20:24:28.445726"], ["id", 11]]
+ [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.2ms)[0m UPDATE "sidejobs" SET "status" = $1, "processed_at" = $2, "attempts" = $3, "updated_at" = $4 WHERE "sidejobs"."id" = $5 [["status", "processing"], ["processed_at", "2016-12-13 20:24:28.447414"], ["attempts", 1], ["updated_at", "2016-12-13 20:24:28.448006"], ["id", 12]]
+ [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ Rendered user_mailer/invite.text.erb (0.0ms)
+
+UserMailer#invite: processed outbound mail in 0.7ms
+
+Sent mail to test@mail.com (1.3ms)
+Date: Tue, 13 Dec 2016 17:24:28 -0300
+From: test@mail.com
+To: test@mail.com
+Message-ID: <585058fc6e1b2_103433fcc2283f9f42843f@imac-de-matt.mail>
+Subject: Invite
+Mime-Version: 1.0
+Content-Type: text/plain;
+ charset=UTF-8
+Content-Transfer-Encoding: 7bit
+
+Test
+
+ [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mUPDATE "sidejobs" SET "status" = $1, "completed_at" = $2, "updated_at" = $3 WHERE "sidejobs"."id" = $4[0m [["status", "complete"], ["completed_at", "2016-12-13 20:24:28.451877"], ["updated_at", "2016-12-13 20:24:28.452549"], ["id", 12]]
+ [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.2ms)[0m UPDATE "sidejobs" SET "status" = $1, "processed_at" = $2, "attempts" = $3, "updated_at" = $4 WHERE "sidejobs"."id" = $5 [["status", "processing"], ["processed_at", "2016-12-13 20:24:28.453839"], ["attempts", 1], ["updated_at", "2016-12-13 20:24:28.454396"], ["id", 13]]
+ [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ Rendered user_mailer/invite.text.erb (0.0ms)
+
+UserMailer#invite: processed outbound mail in 0.6ms
+
+Sent mail to test@mail.com (1.2ms)
+Date: Tue, 13 Dec 2016 17:24:28 -0300
+From: test@mail.com
+To: test@mail.com
+Message-ID: <585058fc6fa6a_103433fcc2283f9f42852d@imac-de-matt.mail>
+Subject: Invite
+Mime-Version: 1.0
+Content-Type: text/plain;
+ charset=UTF-8
+Content-Transfer-Encoding: 7bit
+
+Test
+
+ [1m[35m (0.2ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.5ms)[0m [1mUPDATE "sidejobs" SET "status" = $1, "completed_at" = $2, "updated_at" = $3 WHERE "sidejobs"."id" = $4[0m [["status", "complete"], ["completed_at", "2016-12-13 20:24:28.458118"], ["updated_at", "2016-12-13 20:24:28.459321"], ["id", 13]]
+ [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.3ms)[0m UPDATE "sidejobs" SET "status" = $1, "processed_at" = $2, "attempts" = $3, "updated_at" = $4 WHERE "sidejobs"."id" = $5 [["status", "processing"], ["processed_at", "2016-12-13 20:24:28.461429"], ["attempts", 1], ["updated_at", "2016-12-13 20:24:28.462231"], ["id", 14]]
+ [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ Rendered user_mailer/invite.text.erb (0.0ms)
+
+UserMailer#invite: processed outbound mail in 0.7ms
+
+Sent mail to test@mail.com (1.1ms)
+Date: Tue, 13 Dec 2016 17:24:28 -0300
+From: test@mail.com
+To: test@mail.com
+Message-ID: <585058fc71a06_103433fcc2283f9f428652@imac-de-matt.mail>
+Subject: Invite
+Mime-Version: 1.0
+Content-Type: text/plain;
+ charset=UTF-8
+Content-Transfer-Encoding: 7bit
+
+Test
+
+ [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mUPDATE "sidejobs" SET "status" = $1, "completed_at" = $2, "updated_at" = $3 WHERE "sidejobs"."id" = $4[0m [["status", "complete"], ["completed_at", "2016-12-13 20:24:28.466108"], ["updated_at", "2016-12-13 20:24:28.466751"], ["id", 14]]
+ [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.2ms)[0m UPDATE "sidejobs" SET "status" = $1, "processed_at" = $2, "attempts" = $3, "updated_at" = $4 WHERE "sidejobs"."id" = $5 [["status", "processing"], ["processed_at", "2016-12-13 20:24:28.468119"], ["attempts", 1], ["updated_at", "2016-12-13 20:24:28.468692"], ["id", 15]]
+ [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ Rendered user_mailer/invite.text.erb (0.0ms)
+
+UserMailer#invite: processed outbound mail in 0.6ms
+
+Sent mail to test@mail.com (1.1ms)
+Date: Tue, 13 Dec 2016 17:24:28 -0300
+From: test@mail.com
+To: test@mail.com
+Message-ID: <585058fc731f1_103433fcc2283f9f428748@imac-de-matt.mail>
+Subject: Invite
+Mime-Version: 1.0
+Content-Type: text/plain;
+ charset=UTF-8
+Content-Transfer-Encoding: 7bit
+
+Test
+
+ [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mUPDATE "sidejobs" SET "status" = $1, "completed_at" = $2, "updated_at" = $3 WHERE "sidejobs"."id" = $4[0m [["status", "complete"], ["completed_at", "2016-12-13 20:24:28.472249"], ["updated_at", "2016-12-13 20:24:28.472830"], ["id", 15]]
+ [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.2ms)[0m UPDATE "sidejobs" SET "status" = $1, "processed_at" = $2, "attempts" = $3, "updated_at" = $4 WHERE "sidejobs"."id" = $5 [["status", "processing"], ["processed_at", "2016-12-13 20:24:28.474130"], ["attempts", 1], ["updated_at", "2016-12-13 20:24:28.474735"], ["id", 16]]
+ [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ Rendered user_mailer/invite.text.erb (0.0ms)
+
+UserMailer#invite: processed outbound mail in 0.6ms
+
+Sent mail to test@mail.com (1.3ms)
+Date: Tue, 13 Dec 2016 17:24:28 -0300
+From: test@mail.com
+To: test@mail.com
+Message-ID: <585058fc749fb_103433fcc2283f9f428813@imac-de-matt.mail>
+Subject: Invite
+Mime-Version: 1.0
+Content-Type: text/plain;
+ charset=UTF-8
+Content-Transfer-Encoding: 7bit
+
+Test
+
+ [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.3ms)[0m [1mUPDATE "sidejobs" SET "status" = $1, "completed_at" = $2, "updated_at" = $3 WHERE "sidejobs"."id" = $4[0m [["status", "complete"], ["completed_at", "2016-12-13 20:24:28.478448"], ["updated_at", "2016-12-13 20:24:28.479151"], ["id", 16]]
+ [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.2ms)[0m UPDATE "sidejobs" SET "status" = $1, "processed_at" = $2, "attempts" = $3, "updated_at" = $4 WHERE "sidejobs"."id" = $5 [["status", "processing"], ["processed_at", "2016-12-13 20:24:28.480503"], ["attempts", 1], ["updated_at", "2016-12-13 20:24:28.481112"], ["id", 17]]
+ [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ Rendered user_mailer/invite.text.erb (0.0ms)
+
+UserMailer#invite: processed outbound mail in 0.7ms
+
+Sent mail to test@mail.com (1.2ms)
+Date: Tue, 13 Dec 2016 17:24:28 -0300
+From: test@mail.com
+To: test@mail.com
+Message-ID: <585058fc7628b_103433fcc2283f9f4289f3@imac-de-matt.mail>
+Subject: Invite
+Mime-Version: 1.0
+Content-Type: text/plain;
+ charset=UTF-8
+Content-Transfer-Encoding: 7bit
+
+Test
+
+ [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mUPDATE "sidejobs" SET "status" = $1, "completed_at" = $2, "updated_at" = $3 WHERE "sidejobs"."id" = $4[0m [["status", "complete"], ["completed_at", "2016-12-13 20:24:28.484840"], ["updated_at", "2016-12-13 20:24:28.485448"], ["id", 17]]
+ [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.2ms)[0m UPDATE "sidejobs" SET "status" = $1, "processed_at" = $2, "attempts" = $3, "updated_at" = $4 WHERE "sidejobs"."id" = $5 [["status", "processing"], ["processed_at", "2016-12-13 20:24:28.486696"], ["attempts", 1], ["updated_at", "2016-12-13 20:24:28.487338"], ["id", 18]]
+ [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ Rendered user_mailer/invite.text.erb (0.0ms)
+
+UserMailer#invite: processed outbound mail in 0.7ms
+
+Sent mail to test@mail.com (1.1ms)
+Date: Tue, 13 Dec 2016 17:24:28 -0300
+From: test@mail.com
+To: test@mail.com
+Message-ID: <585058fc77a82_103433fcc2283f9f429047@imac-de-matt.mail>
+Subject: Invite
+Mime-Version: 1.0
+Content-Type: text/plain;
+ charset=UTF-8
+Content-Transfer-Encoding: 7bit
+
+Test
+
+ [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mUPDATE "sidejobs" SET "status" = $1, "completed_at" = $2, "updated_at" = $3 WHERE "sidejobs"."id" = $4[0m [["status", "complete"], ["completed_at", "2016-12-13 20:24:28.490765"], ["updated_at", "2016-12-13 20:24:28.491304"], ["id", 18]]
+ [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.2ms)[0m UPDATE "sidejobs" SET "status" = $1, "processed_at" = $2, "attempts" = $3, "updated_at" = $4 WHERE "sidejobs"."id" = $5 [["status", "processing"], ["processed_at", "2016-12-13 20:24:28.492505"], ["attempts", 1], ["updated_at", "2016-12-13 20:24:28.493084"], ["id", 19]]
+ [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ Rendered user_mailer/invite.text.erb (0.0ms)
+
+UserMailer#invite: processed outbound mail in 0.6ms
+
+Sent mail to test@mail.com (1.1ms)
+Date: Tue, 13 Dec 2016 17:24:28 -0300
+From: test@mail.com
+To: test@mail.com
+Message-ID: <585058fc79069_103433fcc2283f9f4291b0@imac-de-matt.mail>
+Subject: Invite
+Mime-Version: 1.0
+Content-Type: text/plain;
+ charset=UTF-8
+Content-Transfer-Encoding: 7bit
+
+Test
+
+ [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mUPDATE "sidejobs" SET "status" = $1, "completed_at" = $2, "updated_at" = $3 WHERE "sidejobs"."id" = $4[0m [["status", "complete"], ["completed_at", "2016-12-13 20:24:28.496380"], ["updated_at", "2016-12-13 20:24:28.496909"], ["id", 19]]
+ [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.2ms)[0m UPDATE "sidejobs" SET "status" = $1, "processed_at" = $2, "attempts" = $3, "updated_at" = $4 WHERE "sidejobs"."id" = $5 [["status", "processing"], ["processed_at", "2016-12-13 20:24:28.498088"], ["attempts", 1], ["updated_at", "2016-12-13 20:24:28.498639"], ["id", 20]]
+ [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ Rendered user_mailer/invite.text.erb (0.0ms)
+
+UserMailer#invite: processed outbound mail in 0.6ms
+
+Sent mail to test@mail.com (1.1ms)
+Date: Tue, 13 Dec 2016 17:24:28 -0300
+From: test@mail.com
+To: test@mail.com
+Message-ID: <585058fc7a5ec_103433fcc2283f9f42927@imac-de-matt.mail>
+Subject: Invite
+Mime-Version: 1.0
+Content-Type: text/plain;
+ charset=UTF-8
+Content-Transfer-Encoding: 7bit
+
+Test
+
+ [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mUPDATE "sidejobs" SET "status" = $1, "completed_at" = $2, "updated_at" = $3 WHERE "sidejobs"."id" = $4[0m [["status", "complete"], ["completed_at", "2016-12-13 20:24:28.501894"], ["updated_at", "2016-12-13 20:24:28.502438"], ["id", 20]]
+ [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.2ms)[0m UPDATE "sidejobs" SET "status" = $1, "processed_at" = $2, "attempts" = $3, "updated_at" = $4 WHERE "sidejobs"."id" = $5 [["status", "processing"], ["processed_at", "2016-12-13 20:24:28.503714"], ["attempts", 1], ["updated_at", "2016-12-13 20:24:28.504337"], ["id", 21]]
+ [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ Rendered user_mailer/invite.text.erb (0.0ms)
+
+UserMailer#invite: processed outbound mail in 0.6ms
+
+Sent mail to test@mail.com (1.1ms)
+Date: Tue, 13 Dec 2016 17:24:28 -0300
+From: test@mail.com
+To: test@mail.com
+Message-ID: <585058fc7bc44_103433fcc2283f9f4293e1@imac-de-matt.mail>
+Subject: Invite
+Mime-Version: 1.0
+Content-Type: text/plain;
+ charset=UTF-8
+Content-Transfer-Encoding: 7bit
+
+Test
+
+ [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mUPDATE "sidejobs" SET "status" = $1, "completed_at" = $2, "updated_at" = $3 WHERE "sidejobs"."id" = $4[0m [["status", "complete"], ["completed_at", "2016-12-13 20:24:28.507632"], ["updated_at", "2016-12-13 20:24:28.508170"], ["id", 21]]
+ [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.2ms)[0m UPDATE "sidejobs" SET "status" = $1, "processed_at" = $2, "attempts" = $3, "updated_at" = $4 WHERE "sidejobs"."id" = $5 [["status", "processing"], ["processed_at", "2016-12-13 20:24:28.509317"], ["attempts", 1], ["updated_at", "2016-12-13 20:24:28.509989"], ["id", 22]]
+ [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ Rendered user_mailer/invite.text.erb (0.0ms)
+
+UserMailer#invite: processed outbound mail in 0.6ms
+
+Sent mail to test@mail.com (1.1ms)
+Date: Tue, 13 Dec 2016 17:24:28 -0300
+From: test@mail.com
+To: test@mail.com
+Message-ID: <585058fc7d20e_103433fcc2283f9f4294d2@imac-de-matt.mail>
+Subject: Invite
+Mime-Version: 1.0
+Content-Type: text/plain;
+ charset=UTF-8
+Content-Transfer-Encoding: 7bit
+
+Test
+
+ [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mUPDATE "sidejobs" SET "status" = $1, "completed_at" = $2, "updated_at" = $3 WHERE "sidejobs"."id" = $4[0m [["status", "complete"], ["completed_at", "2016-12-13 20:24:28.513204"], ["updated_at", "2016-12-13 20:24:28.513772"], ["id", 22]]
+ [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.2ms)[0m UPDATE "sidejobs" SET "status" = $1, "processed_at" = $2, "attempts" = $3, "updated_at" = $4 WHERE "sidejobs"."id" = $5 [["status", "processing"], ["processed_at", "2016-12-13 20:24:28.514885"], ["attempts", 1], ["updated_at", "2016-12-13 20:24:28.515443"], ["id", 23]]
+ [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ Rendered user_mailer/invite.text.erb (0.0ms)
+
+UserMailer#invite: processed outbound mail in 0.5ms
+
+Sent mail to test@mail.com (1.0ms)
+Date: Tue, 13 Dec 2016 17:24:28 -0300
+From: test@mail.com
+To: test@mail.com
+Message-ID: <585058fc7e772_103433fcc2283f9f4295ef@imac-de-matt.mail>
+Subject: Invite
+Mime-Version: 1.0
+Content-Type: text/plain;
+ charset=UTF-8
+Content-Transfer-Encoding: 7bit
+
+Test
+
+ [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mUPDATE "sidejobs" SET "status" = $1, "completed_at" = $2, "updated_at" = $3 WHERE "sidejobs"."id" = $4[0m [["status", "complete"], ["completed_at", "2016-12-13 20:24:28.518634"], ["updated_at", "2016-12-13 20:24:28.519176"], ["id", 23]]
+ [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.2ms)[0m UPDATE "sidejobs" SET "status" = $1, "processed_at" = $2, "attempts" = $3, "updated_at" = $4 WHERE "sidejobs"."id" = $5 [["status", "processing"], ["processed_at", "2016-12-13 20:24:28.520325"], ["attempts", 1], ["updated_at", "2016-12-13 20:24:28.520876"], ["id", 24]]
+ [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ Rendered user_mailer/invite.text.erb (0.0ms)
+
+UserMailer#invite: processed outbound mail in 0.5ms
+
+Sent mail to test@mail.com (0.9ms)
+Date: Tue, 13 Dec 2016 17:24:28 -0300
+From: test@mail.com
+To: test@mail.com
+Message-ID: <585058fc7fc3d_103433fcc2283f9f4296be@imac-de-matt.mail>
+Subject: Invite
+Mime-Version: 1.0
+Content-Type: text/plain;
+ charset=UTF-8
+Content-Transfer-Encoding: 7bit
+
+Test
+
+ [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mUPDATE "sidejobs" SET "status" = $1, "completed_at" = $2, "updated_at" = $3 WHERE "sidejobs"."id" = $4[0m [["status", "complete"], ["completed_at", "2016-12-13 20:24:28.523921"], ["updated_at", "2016-12-13 20:24:28.524494"], ["id", 24]]
+ [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.2ms)[0m UPDATE "sidejobs" SET "status" = $1, "processed_at" = $2, "attempts" = $3, "updated_at" = $4 WHERE "sidejobs"."id" = $5 [["status", "processing"], ["processed_at", "2016-12-13 20:24:28.525635"], ["attempts", 1], ["updated_at", "2016-12-13 20:24:28.526177"], ["id", 25]]
+ [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ Rendered user_mailer/invite.text.erb (0.0ms)
+
+UserMailer#invite: processed outbound mail in 0.6ms
+
+Sent mail to test@mail.com (1.0ms)
+Date: Tue, 13 Dec 2016 17:24:28 -0300
+From: test@mail.com
+To: test@mail.com
+Message-ID: <585058fc8114b_103433fcc2283f9f429726@imac-de-matt.mail>
+Subject: Invite
+Mime-Version: 1.0
+Content-Type: text/plain;
+ charset=UTF-8
+Content-Transfer-Encoding: 7bit
+
+Test
+
+ [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mUPDATE "sidejobs" SET "status" = $1, "completed_at" = $2, "updated_at" = $3 WHERE "sidejobs"."id" = $4[0m [["status", "complete"], ["completed_at", "2016-12-13 20:24:28.529317"], ["updated_at", "2016-12-13 20:24:28.530001"], ["id", 25]]
+ [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.2ms)[0m UPDATE "sidejobs" SET "status" = $1, "processed_at" = $2, "attempts" = $3, "updated_at" = $4 WHERE "sidejobs"."id" = $5 [["status", "processing"], ["processed_at", "2016-12-13 20:24:28.531218"], ["attempts", 1], ["updated_at", "2016-12-13 20:24:28.531761"], ["id", 26]]
+ [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ Rendered user_mailer/invite.text.erb (0.0ms)
+
+UserMailer#invite: processed outbound mail in 0.6ms
+
+Sent mail to test@mail.com (1.0ms)
+Date: Tue, 13 Dec 2016 17:24:28 -0300
+From: test@mail.com
+To: test@mail.com
+Message-ID: <585058fc8276f_103433fcc2283f9f4298aa@imac-de-matt.mail>
+Subject: Invite
+Mime-Version: 1.0
+Content-Type: text/plain;
+ charset=UTF-8
+Content-Transfer-Encoding: 7bit
+
+Test
+
+ [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mUPDATE "sidejobs" SET "status" = $1, "completed_at" = $2, "updated_at" = $3 WHERE "sidejobs"."id" = $4[0m [["status", "complete"], ["completed_at", "2016-12-13 20:24:28.534989"], ["updated_at", "2016-12-13 20:24:28.535526"], ["id", 26]]
+ [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.2ms)[0m UPDATE "sidejobs" SET "status" = $1, "processed_at" = $2, "attempts" = $3, "updated_at" = $4 WHERE "sidejobs"."id" = $5 [["status", "processing"], ["processed_at", "2016-12-13 20:24:28.536666"], ["attempts", 1], ["updated_at", "2016-12-13 20:24:28.537196"], ["id", 27]]
+ [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ Rendered user_mailer/invite.text.erb (0.0ms)
+
+UserMailer#invite: processed outbound mail in 0.6ms
+
+Sent mail to test@mail.com (1.1ms)
+Date: Tue, 13 Dec 2016 17:24:28 -0300
+From: test@mail.com
+To: test@mail.com
+Message-ID: <585058fc83cb4_103433fcc2283f9f42993f@imac-de-matt.mail>
+Subject: Invite
+Mime-Version: 1.0
+Content-Type: text/plain;
+ charset=UTF-8
+Content-Transfer-Encoding: 7bit
+
+Test
+
+ [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mUPDATE "sidejobs" SET "status" = $1, "completed_at" = $2, "updated_at" = $3 WHERE "sidejobs"."id" = $4[0m [["status", "complete"], ["completed_at", "2016-12-13 20:24:28.540443"], ["updated_at", "2016-12-13 20:24:28.541049"], ["id", 27]]
+ [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.2ms)[0m UPDATE "sidejobs" SET "status" = $1, "processed_at" = $2, "attempts" = $3, "updated_at" = $4 WHERE "sidejobs"."id" = $5 [["status", "processing"], ["processed_at", "2016-12-13 20:24:28.542262"], ["attempts", 1], ["updated_at", "2016-12-13 20:24:28.542828"], ["id", 28]]
+ [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ Rendered user_mailer/invite.text.erb (0.0ms)
+
+UserMailer#invite: processed outbound mail in 0.7ms
+
+Sent mail to test@mail.com (1.0ms)
+Date: Tue, 13 Dec 2016 17:24:28 -0300
+From: test@mail.com
+To: test@mail.com
+Message-ID: <585058fc852f6_103433fcc2283f9f4300dc@imac-de-matt.mail>
+Subject: Invite
+Mime-Version: 1.0
+Content-Type: text/plain;
+ charset=UTF-8
+Content-Transfer-Encoding: 7bit
+
+Test
+
+ [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mUPDATE "sidejobs" SET "status" = $1, "completed_at" = $2, "updated_at" = $3 WHERE "sidejobs"."id" = $4[0m [["status", "complete"], ["completed_at", "2016-12-13 20:24:28.546124"], ["updated_at", "2016-12-13 20:24:28.546657"], ["id", 28]]
+ [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.2ms)[0m UPDATE "sidejobs" SET "status" = $1, "processed_at" = $2, "attempts" = $3, "updated_at" = $4 WHERE "sidejobs"."id" = $5 [["status", "processing"], ["processed_at", "2016-12-13 20:24:28.547794"], ["attempts", 1], ["updated_at", "2016-12-13 20:24:28.548359"], ["id", 29]]
+ [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ Rendered user_mailer/invite.text.erb (0.0ms)
+
+UserMailer#invite: processed outbound mail in 0.6ms
+
+Sent mail to test@mail.com (1.1ms)
+Date: Tue, 13 Dec 2016 17:24:28 -0300
+From: test@mail.com
+To: test@mail.com
+Message-ID: <585058fc867b6_103433fcc2283f9f430154@imac-de-matt.mail>
+Subject: Invite
+Mime-Version: 1.0
+Content-Type: text/plain;
+ charset=UTF-8
+Content-Transfer-Encoding: 7bit
+
+Test
+
+ [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mUPDATE "sidejobs" SET "status" = $1, "completed_at" = $2, "updated_at" = $3 WHERE "sidejobs"."id" = $4[0m [["status", "complete"], ["completed_at", "2016-12-13 20:24:28.551485"], ["updated_at", "2016-12-13 20:24:28.552011"], ["id", 29]]
+ [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.2ms)[0m UPDATE "sidejobs" SET "status" = $1, "processed_at" = $2, "attempts" = $3, "updated_at" = $4 WHERE "sidejobs"."id" = $5 [["status", "processing"], ["processed_at", "2016-12-13 20:24:28.553125"], ["attempts", 1], ["updated_at", "2016-12-13 20:24:28.553770"], ["id", 30]]
+ [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ Rendered user_mailer/invite.text.erb (0.0ms)
+
+UserMailer#invite: processed outbound mail in 0.6ms
+
+Sent mail to test@mail.com (1.2ms)
+Date: Tue, 13 Dec 2016 17:24:28 -0300
+From: test@mail.com
+To: test@mail.com
+Message-ID: <585058fc87e0c_103433fcc2283f9f43022e@imac-de-matt.mail>
+Subject: Invite
+Mime-Version: 1.0
+Content-Type: text/plain;
+ charset=UTF-8
+Content-Transfer-Encoding: 7bit
+
+Test
+
+ [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mUPDATE "sidejobs" SET "status" = $1, "completed_at" = $2, "updated_at" = $3 WHERE "sidejobs"."id" = $4[0m [["status", "complete"], ["completed_at", "2016-12-13 20:24:28.557223"], ["updated_at", "2016-12-13 20:24:28.557795"], ["id", 30]]
+ [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.2ms)[0m [1mSELECT COUNT(*) FROM "sidejobs" WHERE "sidejobs"."status" = $1[0m [["status", "complete"]]
+ [1m[35m (0.2ms)[0m SELECT COUNT(*) FROM "sidejobs" WHERE "sidejobs"."status" = $1 [["status", "processing"]]
+ [1m[36m (0.2ms)[0m [1mSELECT COUNT(*) FROM "sidejobs" WHERE "sidejobs"."status" = $1[0m [["status", "pending"]]
+ [1m[35mSidejobs::Job Load (0.2ms)[0m SELECT "sidejobs".* FROM "sidejobs" ORDER BY "sidejobs"."id" DESC LIMIT 1
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.2ms)[0m UPDATE "sidejobs" SET "status" = $1, "processed_at" = $2, "updated_at" = $3 WHERE "sidejobs"."id" = $4 [["status", "processing"], ["processed_at", "2016-12-13 20:24:28.561568"], ["updated_at", "2016-12-13 20:24:28.562207"], ["id", 34]]
+ [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35mSidejobs::Job Load (0.3ms)[0m SELECT "sidejobs".* FROM "sidejobs" WHERE "sidejobs"."status" IN ('pending', 'failing') AND (attempts < 3) AND (scheduled_at <= '2016-12-13 20:24:28.563704' OR scheduled_at IS NULL) ORDER BY "sidejobs"."priority" DESC LIMIT 20
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.2ms)[0m UPDATE "sidejobs" SET "status" = $1, "processed_at" = $2, "attempts" = $3, "updated_at" = $4 WHERE "sidejobs"."id" = $5 [["status", "processing"], ["processed_at", "2016-12-13 20:24:28.564466"], ["attempts", 1], ["updated_at", "2016-12-13 20:24:28.565101"], ["id", 31]]
+ [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ Rendered user_mailer/invite.text.erb (0.0ms)
+
+UserMailer#invite: processed outbound mail in 0.6ms
+
+Sent mail to test@mail.com (1.2ms)
+Date: Tue, 13 Dec 2016 17:24:28 -0300
+From: test@mail.com
+To: test@mail.com
+Message-ID: <585058fc8aa94_103433fcc2283f9f430360@imac-de-matt.mail>
+Subject: Invite
+Mime-Version: 1.0
+Content-Type: text/plain;
+ charset=UTF-8
+Content-Transfer-Encoding: 7bit
+
+Test
+
+ [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mUPDATE "sidejobs" SET "status" = $1, "completed_at" = $2, "updated_at" = $3 WHERE "sidejobs"."id" = $4[0m [["status", "complete"], ["completed_at", "2016-12-13 20:24:28.568670"], ["updated_at", "2016-12-13 20:24:28.569239"], ["id", 31]]
+ [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.2ms)[0m UPDATE "sidejobs" SET "status" = $1, "processed_at" = $2, "attempts" = $3, "updated_at" = $4 WHERE "sidejobs"."id" = $5 [["status", "processing"], ["processed_at", "2016-12-13 20:24:28.570373"], ["attempts", 1], ["updated_at", "2016-12-13 20:24:28.570981"], ["id", 32]]
+ [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ Rendered user_mailer/invite.text.erb (0.0ms)
+
+UserMailer#invite: processed outbound mail in 0.6ms
+
+Sent mail to test@mail.com (1.1ms)
+Date: Tue, 13 Dec 2016 17:24:28 -0300
+From: test@mail.com
+To: test@mail.com
+Message-ID: <585058fc8c037_103433fcc2283f9f43046f@imac-de-matt.mail>
+Subject: Invite
+Mime-Version: 1.0
+Content-Type: text/plain;
+ charset=UTF-8
+Content-Transfer-Encoding: 7bit
+
+Test
+
+ [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mUPDATE "sidejobs" SET "status" = $1, "completed_at" = $2, "updated_at" = $3 WHERE "sidejobs"."id" = $4[0m [["status", "complete"], ["completed_at", "2016-12-13 20:24:28.574182"], ["updated_at", "2016-12-13 20:24:28.574774"], ["id", 32]]
+ [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.2ms)[0m UPDATE "sidejobs" SET "status" = $1, "processed_at" = $2, "attempts" = $3, "updated_at" = $4 WHERE "sidejobs"."id" = $5 [["status", "processing"], ["processed_at", "2016-12-13 20:24:28.575927"], ["attempts", 1], ["updated_at", "2016-12-13 20:24:28.576495"], ["id", 33]]
+ [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ Rendered user_mailer/invite.text.erb (0.0ms)
+
+UserMailer#invite: processed outbound mail in 0.5ms
+
+Sent mail to test@mail.com (1.1ms)
+Date: Tue, 13 Dec 2016 17:24:28 -0300
+From: test@mail.com
+To: test@mail.com
+Message-ID: <585058fc8d5fb_103433fcc2283f9f4305cd@imac-de-matt.mail>
+Subject: Invite
+Mime-Version: 1.0
+Content-Type: text/plain;
+ charset=UTF-8
+Content-Transfer-Encoding: 7bit
+
+Test
+
+ [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mUPDATE "sidejobs" SET "status" = $1, "completed_at" = $2, "updated_at" = $3 WHERE "sidejobs"."id" = $4[0m [["status", "complete"], ["completed_at", "2016-12-13 20:24:28.579758"], ["updated_at", "2016-12-13 20:24:28.580333"], ["id", 33]]
+ [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.2ms)[0m [1mSELECT COUNT(*) FROM "sidejobs" WHERE "sidejobs"."status" = $1[0m [["status", "complete"]]
+ [1m[35m (0.2ms)[0m SELECT COUNT(*) FROM "sidejobs" WHERE "sidejobs"."status" = $1 [["status", "processing"]]
+ [1m[36m (0.2ms)[0m [1mSELECT COUNT(*) FROM "sidejobs" WHERE "sidejobs"."status" = $1[0m [["status", "pending"]]
+ [1m[35m (0.1ms)[0m ROLLBACK
+ [1m[36m (0.1ms)[0m [1mBEGIN[0m
+---------------------------
+ProcessorTest: test_process
+---------------------------
+[ActiveJob] [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+[ActiveJob] [1m[36mSQL (0.2ms)[0m [1mINSERT INTO "sidejobs" ("data", "queue", "priority", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id"[0m [["data", "{\"job_class\":\"ActionMailer::DeliveryJob\",\"job_id\":\"77c690e3-d50a-4e70-9987-c900e46fb5d8\",\"queue_name\":\"mailers\",\"arguments\":[\"UserMailer\",\"invite\",\"deliver_now\",\"test@mail.com\"],\"locale\":\"en\"}"], ["queue", "mailers"], ["priority", 80], ["created_at", "2016-12-13 20:24:28.584499"], ["updated_at", "2016-12-13 20:24:28.584499"]]
+[ActiveJob] [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+[ActiveJob] Enqueued ActionMailer::DeliveryJob (Job ID: 77c690e3-d50a-4e70-9987-c900e46fb5d8) to Sidejobs(mailers) with arguments: "UserMailer", "invite", "deliver_now", "test@mail.com"
+ [1m[36mSidejobs::Job Load (0.3ms)[0m [1mSELECT "sidejobs".* FROM "sidejobs" WHERE "sidejobs"."status" IN ('pending', 'failing') AND (attempts < 3) AND (scheduled_at <= '2016-12-13 20:24:28.585904' OR scheduled_at IS NULL) ORDER BY "sidejobs"."priority" DESC LIMIT 20[0m
+ [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mUPDATE "sidejobs" SET "status" = $1, "processed_at" = $2, "attempts" = $3, "updated_at" = $4 WHERE "sidejobs"."id" = $5[0m [["status", "processing"], ["processed_at", "2016-12-13 20:24:28.586642"], ["attempts", 1], ["updated_at", "2016-12-13 20:24:28.587218"], ["id", 35]]
+ [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+ Rendered user_mailer/invite.text.erb (0.0ms)
+
+UserMailer#invite: processed outbound mail in 0.7ms
+
+Sent mail to test@mail.com (1.0ms)
+Date: Tue, 13 Dec 2016 17:24:28 -0300
+From: test@mail.com
+To: test@mail.com
+Message-ID: <585058fc9008c_103433fcc2283f9f4306f1@imac-de-matt.mail>
+Subject: Invite
+Mime-Version: 1.0
+Content-Type: text/plain;
+ charset=UTF-8
+Content-Transfer-Encoding: 7bit
+
+Test
+
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.2ms)[0m UPDATE "sidejobs" SET "status" = $1, "completed_at" = $2, "updated_at" = $3 WHERE "sidejobs"."id" = $4 [["status", "complete"], ["completed_at", "2016-12-13 20:24:28.590585"], ["updated_at", "2016-12-13 20:24:28.591167"], ["id", 35]]
+ [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35mSidejobs::Job Load (0.2ms)[0m SELECT "sidejobs".* FROM "sidejobs" ORDER BY "sidejobs"."id" DESC LIMIT 1
+ [1m[36m (0.1ms)[0m [1mROLLBACK[0m
+ [1m[35m (0.1ms)[0m BEGIN
+---------------------------
+ProcessorTest: test_retries
+---------------------------
+[ActiveJob] [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+[ActiveJob] [1m[35mSQL (0.3ms)[0m INSERT INTO "sidejobs" ("data", "queue", "priority", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id" [["data", "{\"job_class\":\"ShareProductsJob\",\"job_id\":\"c861417f-88bc-4fa5-9189-bb1471a48f2d\",\"queue_name\":\"default\",\"arguments\":[],\"locale\":\"en\"}"], ["queue", "default"], ["priority", 40], ["created_at", "2016-12-13 20:24:28.594767"], ["updated_at", "2016-12-13 20:24:28.594767"]]
+[ActiveJob] [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+[ActiveJob] Enqueued ShareProductsJob (Job ID: c861417f-88bc-4fa5-9189-bb1471a48f2d) to Sidejobs(default)
+ [1m[35mSidejobs::Job Load (0.3ms)[0m SELECT "sidejobs".* FROM "sidejobs" WHERE "sidejobs"."status" IN ('pending', 'failing') AND (attempts < 3) AND (scheduled_at <= '2016-12-13 20:24:28.596466' OR scheduled_at IS NULL) ORDER BY "sidejobs"."priority" DESC LIMIT 20
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.2ms)[0m UPDATE "sidejobs" SET "status" = $1, "processed_at" = $2, "attempts" = $3, "updated_at" = $4 WHERE "sidejobs"."id" = $5 [["status", "processing"], ["processed_at", "2016-12-13 20:24:28.597317"], ["attempts", 1], ["updated_at", "2016-12-13 20:24:28.597920"], ["id", 36]]
+ [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mUPDATE "sidejobs" SET "status" = $1, "failed_at" = $2, "error" = $3, "updated_at" = $4 WHERE "sidejobs"."id" = $5[0m [["status", "failing"], ["failed_at", "2016-12-13 20:24:28.599461"], ["error", "Social network unavailable"], ["updated_at", "2016-12-13 20:24:28.600057"], ["id", 36]]
+ [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36mSidejobs::Job Load (0.3ms)[0m [1mSELECT "sidejobs".* FROM "sidejobs" WHERE "sidejobs"."status" IN ('pending', 'failing') AND (attempts < 3) AND (scheduled_at <= '2016-12-13 20:24:28.601389' OR scheduled_at IS NULL) ORDER BY "sidejobs"."priority" DESC LIMIT 20[0m
+ [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mUPDATE "sidejobs" SET "status" = $1, "processed_at" = $2, "attempts" = $3, "updated_at" = $4 WHERE "sidejobs"."id" = $5[0m [["status", "processing"], ["processed_at", "2016-12-13 20:24:28.602073"], ["attempts", 2], ["updated_at", "2016-12-13 20:24:28.602721"], ["id", 36]]
+ [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.2ms)[0m UPDATE "sidejobs" SET "status" = $1, "failed_at" = $2, "updated_at" = $3 WHERE "sidejobs"."id" = $4 [["status", "failing"], ["failed_at", "2016-12-13 20:24:28.604081"], ["updated_at", "2016-12-13 20:24:28.604626"], ["id", 36]]
+ [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35mSidejobs::Job Load (0.3ms)[0m SELECT "sidejobs".* FROM "sidejobs" WHERE "sidejobs"."status" IN ('pending', 'failing') AND (attempts < 3) AND (scheduled_at <= '2016-12-13 20:24:28.605937' OR scheduled_at IS NULL) ORDER BY "sidejobs"."priority" DESC LIMIT 20
+ [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
+ [1m[35mSQL (0.2ms)[0m UPDATE "sidejobs" SET "status" = $1, "processed_at" = $2, "attempts" = $3, "updated_at" = $4 WHERE "sidejobs"."id" = $5 [["status", "processing"], ["processed_at", "2016-12-13 20:24:28.606589"], ["attempts", 3], ["updated_at", "2016-12-13 20:24:28.607163"], ["id", 36]]
+ [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
+ [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
+ [1m[36mSQL (0.2ms)[0m [1mUPDATE "sidejobs" SET "status" = $1, "failed_at" = $2, "updated_at" = $3 WHERE "sidejobs"."id" = $4[0m [["status", "failing"], ["failed_at", "2016-12-13 20:24:28.608605"], ["updated_at", "2016-12-13 20:24:28.609140"], ["id", 36]]
+ [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
+ [1m[36mSidejobs::Job Load (0.3ms)[0m [1mSELECT "sidejobs".* FROM "sidejobs" WHERE "sidejobs"."status" IN ('pending', 'failing') AND (attempts < 3) AND (scheduled_at <= '2016-12-13 20:24:28.610305' OR scheduled_at IS NULL) ORDER BY "sidejobs"."priority" DESC LIMIT 20[0m
+ [1m[35mSidejobs::Job Load (0.2ms)[0m SELECT "sidejobs".* FROM "sidejobs" ORDER BY "sidejobs"."id" DESC LIMIT 1
+ [1m[36m (0.1ms)[0m [1mROLLBACK[0m