Plugins » Katello

I recently ran out of Red Hat Subscriptions on my system. When I log in to RHN and 1) Delete the existing 17 subscriptions assigned to my organization (to return them to the available pool) and then Add 17+3 of those same subscriptions back into my pool and re-import the manifest, going to Content -> Red Hat Subscriptions still only shows 17 available subscriptions instead of 20. If I only add 3 subscriptions in RHN, these should appear as two separate lines, of 17 subscriptions and then 3 subscriptions, but then I have to go update my activation keys (which is undesired). If I try to update in this manner however, I still do not see those additional 3 subscriptions appear.

Deleting all subscriptions out of Foreman/Katello makes the problem even worse: Now when I re-import the manifest, I don't even have the old subscriptions showing. If I go to a content host, I do however see an "undefined" subscription that I can attach the content host to. If I want to get this to show up under Content -> Red Hat Subscriptions I have to manually insert an entry into foreman's tables:

insert into katello_subscriptions (name, product_id, cp_id, organization_id, instance_multiplier, created_at, updated_at) values ('Red Hat Enterprise Linux Server', 69, '4989add1809f4f24ae756caee47c8601', 1, 1, '2018-01-19 11:53:40.625070', '2018-01-19 11:53:40.625070');

If I use this 3rd method however, I then have to go around and reattach the subscription to all 20 content hosts and re-add the Red Hat repository to the server. Then I have to log in to each host and do a "subscription-manager refresh" (auto-attach doesn't work to restore the Red Hat repo). Candlepin and foreman logs during manifest (re)import as shown below:

Candlepin logs during upload:

2018-01-26 09:55:00,021 [thread=QuartzScheduler_Worker-3] [job=SweepBarJob-ed8dd20d-f2a0-4459-9288-c749fb9a74de, org=, csid=] INFO  org.candlepin.pinsetter.tasks.KingpinJob - Starting job: org.candlepin.pinsetter.tasks.SweepBarJob
2018-01-26 09:55:00,021 [thread=QuartzScheduler_Worker-3] [job=SweepBarJob-ed8dd20d-f2a0-4459-9288-c749fb9a74de, org=, csid=] INFO  org.candlepin.pinsetter.tasks.KingpinJob - Job completed: time=0
2018-01-26 09:56:51,556 [thread=http-bio-8443-exec-4] [req=7a404e0b-0c2b-455b-83dc-c86ced047c85, org=, csid=] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/owners/Foobar
2018-01-26 09:56:51,567 [thread=http-bio-8443-exec-4] [req=7a404e0b-0c2b-455b-83dc-c86ced047c85, org=Foobar, csid=] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=11
2018-01-26 09:56:51,573 [thread=http-bio-8443-exec-9] [req=fae87f76-372b-4bd2-9b83-3dee125c54e0, org=, csid=7828f5ec] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/owners/Foobar/imports
2018-01-26 09:56:51,581 [thread=http-bio-8443-exec-5] [req=60b1ec70-ba70-41a2-a3de-5beffe948494, org=, csid=61d35746] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/owners/Foobar/servicelevels
2018-01-26 09:56:51,587 [thread=http-bio-8443-exec-9] [req=fae87f76-372b-4bd2-9b83-3dee125c54e0, org=Foobar, csid=7828f5ec] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=14
2018-01-26 09:56:51,591 [thread=http-bio-8443-exec-5] [req=60b1ec70-ba70-41a2-a3de-5beffe948494, org=Foobar, csid=61d35746] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=10
2018-01-26 09:56:51,599 [thread=http-bio-8443-exec-5] [req=fa8e8738-4a14-4259-957f-58cb9bcbe616, org=, csid=] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/owners/Foobar
2018-01-26 09:56:51,608 [thread=http-bio-8443-exec-5] [req=fa8e8738-4a14-4259-957f-58cb9bcbe616, org=Foobar, csid=] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=9
2018-01-26 09:59:19,132 [thread=http-bio-8443-exec-10] [req=1ca7f8bf-a895-4ec0-b2a1-02edbb7615ff, org=, csid=] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/status
2018-01-26 09:59:19,133 [thread=http-bio-8443-exec-10] [req=1ca7f8bf-a895-4ec0-b2a1-02edbb7615ff, org=, csid=] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=1
2018-01-26 09:59:19,146 [thread=http-bio-8443-exec-6] [req=212b2d46-f078-4f3d-bc39-9805d56f0476, org=, csid=] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/status
2018-01-26 09:59:19,147 [thread=http-bio-8443-exec-6] [req=212b2d46-f078-4f3d-bc39-9805d56f0476, org=, csid=] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=1
2018-01-26 09:59:19,310 [thread=http-bio-8443-exec-1] [req=06ad3c79-2f8e-4dff-bd0d-78892813ee2f, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/owners/Foobar/subscriptions?include=certificate&include=product.id&include=providedProducts.id&include=derivedProvidedProducts.id
2018-01-26 09:59:19,359 [thread=http-bio-8443-exec-1] [req=06ad3c79-2f8e-4dff-bd0d-78892813ee2f, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=49
2018-01-26 09:59:19,875 [thread=http-bio-8443-exec-3] [req=84c9d3a9-a72f-47fa-98ae-1025e0749177, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/owners/Foobar/subscriptions?include=certificate&include=product.id&include=providedProducts.id&include=derivedProvidedProducts.id
2018-01-26 09:59:19,932 [thread=http-bio-8443-exec-3] [req=84c9d3a9-a72f-47fa-98ae-1025e0749177, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=57
2018-01-26 09:59:20,357 [thread=http-bio-8443-exec-8] [req=a964cb8b-37be-44b0-be4c-e1d6467aaba8, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/owners/Foobar/subscriptions?include=certificate&include=product.id&include=providedProducts.id&include=derivedProvidedProducts.id
2018-01-26 09:59:20,401 [thread=http-bio-8443-exec-8] [req=a964cb8b-37be-44b0-be4c-e1d6467aaba8, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=44
2018-01-26 09:59:20,524 [thread=http-bio-8443-exec-2] [req=5a68ac35-d758-46ba-a13b-1b42ad189733, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/owners/Foobar/subscriptions?include=certificate&include=product.id&include=providedProducts.id&include=derivedProvidedProducts.id
2018-01-26 09:59:20,564 [thread=http-bio-8443-exec-2] [req=5a68ac35-d758-46ba-a13b-1b42ad189733, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=40
2018-01-26 09:59:26,848 [thread=http-bio-8443-exec-4] [req=e4af4ebd-9f33-4784-8816-ae38852e60ea, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/owners/Foobar/subscriptions?include=certificate&include=product.id&include=providedProducts.id&include=derivedProvidedProducts.id
2018-01-26 09:59:26,885 [thread=http-bio-8443-exec-4] [req=e4af4ebd-9f33-4784-8816-ae38852e60ea, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=37
2018-01-26 09:59:33,934 [thread=http-bio-8443-exec-9] [req=677ae7fb-3e55-4d03-ab3e-537f7b239a52, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=POST, uri=/candlepin/owners/Foobar/imports
2018-01-26 09:59:33,962 [thread=http-bio-8443-exec-9] [req=677ae7fb-3e55-4d03-ab3e-537f7b239a52, org=Foobar, csid=9e9cafbb] INFO  org.candlepin.sync.RulesImporter - Importing new rules from manifest, current version: 5.26 new version: 5.26
2018-01-26 09:59:33,974 [thread=http-bio-8443-exec-9] [req=677ae7fb-3e55-4d03-ab3e-537f7b239a52, org=Foobar, csid=9e9cafbb] INFO  org.candlepin.policy.js.JsRunnerProvider - Recompiling rules with timestamp: 2018-01-26 09:59:33.963
2018-01-26 09:59:34,274 [thread=http-bio-8443-exec-9] [req=677ae7fb-3e55-4d03-ab3e-537f7b239a52, org=Foobar, csid=9e9cafbb] WARN  org.candlepin.sync.SubscriptionReconciler - Subscription for incoming entitlement id [8a85f9876132476b01613365b84b678c] does not have an entitlement id match in the current subscriptions for the upstream pool id [8a85f9815d78f0b9015d798a46584207]
2018-01-26 09:59:34,274 [thread=http-bio-8443-exec-9] [req=677ae7fb-3e55-4d03-ab3e-537f7b239a52, org=Foobar, csid=9e9cafbb] WARN  org.candlepin.sync.SubscriptionReconciler - Subscription for incoming entitlement id [8a85f9876132476b01613365b84b678c] does not have an exact quantity match in the current subscriptions for the upstream pool id [8a85f9815d78f0b9015d798a46584207]
2018-01-26 09:59:34,275 [thread=http-bio-8443-exec-9] [req=677ae7fb-3e55-4d03-ab3e-537f7b239a52, org=Foobar, csid=9e9cafbb] INFO  org.candlepin.sync.SubscriptionReconciler - Merging subscription for incoming entitlement id [8a85f9876132476b01613365b84b678c] into subscription with existing entitlement id [8a85f983610e2a640161102c2cde01a8] Ordered quantity match.
2018-01-26 09:59:34,281 [thread=http-bio-8443-exec-9] [req=677ae7fb-3e55-4d03-ab3e-537f7b239a52, org=Foobar, csid=9e9cafbb] INFO  org.candlepin.controller.CandlepinPoolManager - Refreshing pools for owner: Owner [id: 8a8381d960c7c97b0160c7c9cca20001, key: Foobar]
2018-01-26 09:59:34,411 [thread=http-bio-8443-exec-9] [req=677ae7fb-3e55-4d03-ab3e-537f7b239a52, org=Foobar, csid=9e9cafbb] INFO  org.candlepin.policy.js.pool.PoolRules - Checking if pools need to be created for: Pool [id=null, type=NORMAL, product=RH00004RN, productName=Red Hat Enterprise Linux Server, Standard (Physical or Virtual Nodes), quantity=20]
2018-01-26 09:59:34,411 [thread=http-bio-8443-exec-9] [req=677ae7fb-3e55-4d03-ab3e-537f7b239a52, org=Foobar, csid=9e9cafbb] WARN  org.candlepin.policy.js.pool.PoolRules - Invalid virt_limit attribute specified.
2018-01-26 09:59:34,411 [thread=http-bio-8443-exec-9] [req=677ae7fb-3e55-4d03-ab3e-537f7b239a52, org=Foobar, csid=9e9cafbb] INFO  org.candlepin.policy.js.pool.PoolRules - Checking if bonus pools need to be created for pool: Pool [id=null, type=NORMAL, product=RH00004RN, productName=Red Hat Enterprise Linux Server, Standard (Physical or Virtual Nodes), quantity=20]
2018-01-26 09:59:34,432 [thread=http-bio-8443-exec-9] [req=677ae7fb-3e55-4d03-ab3e-537f7b239a52, org=Foobar, csid=9e9cafbb] INFO  org.candlepin.controller.CandlepinPoolManager - Pool changed: PoolUpdate[pool: 8a8381d961101a210161102fa7600008, changes:quantity]
2018-01-26 09:59:34,476 [thread=http-bio-8443-exec-9] [req=677ae7fb-3e55-4d03-ab3e-537f7b239a52, org=Foobar, csid=9e9cafbb] INFO  org.candlepin.controller.CandlepinPoolManager - Refresh pools for owner: Foobar completed in: 201ms
2018-01-26 09:59:34,501 [thread=http-bio-8443-exec-9] [req=677ae7fb-3e55-4d03-ab3e-537f7b239a52, org=Foobar, csid=9e9cafbb] INFO  org.candlepin.resource.OwnerResource - Import attempt completed for owner Foobar
2018-01-26 09:59:34,504 [thread=http-bio-8443-exec-9] [req=677ae7fb-3e55-4d03-ab3e-537f7b239a52, org=Foobar, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=571
2018-01-26 09:59:34,534 [thread=http-bio-8443-exec-7] [req=276942f4-37d7-4fa0-9d11-bae74ea62d71, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/owners/Foobar/pools?add_future=true&attribute=unmapped_guests_only:!true
2018-01-26 09:59:34,582 [thread=http-bio-8443-exec-7] [req=276942f4-37d7-4fa0-9d11-bae74ea62d71, org=Foobar, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=48
2018-01-26 09:59:34,600 [thread=http-bio-8443-exec-5] [req=fee41ced-e1fd-4190-8bff-7f16947e47e5, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/owners/Foobar/products/271/?
2018-01-26 09:59:34,605 [thread=http-bio-8443-exec-5] [req=fee41ced-e1fd-4190-8bff-7f16947e47e5, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=5
2018-01-26 09:59:34,612 [thread=http-bio-8443-exec-10] [req=7dd8b3cc-3f9b-41e9-8efa-cb75791d163e, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/owners/Foobar/products/395/?
2018-01-26 09:59:34,617 [thread=http-bio-8443-exec-10] [req=7dd8b3cc-3f9b-41e9-8efa-cb75791d163e, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=5
2018-01-26 09:59:34,623 [thread=http-bio-8443-exec-6] [req=0f3b16b1-874b-4ba4-bdf3-e5f436c1c776, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/owners/Foobar/products/273/?
2018-01-26 09:59:34,626 [thread=http-bio-8443-exec-6] [req=0f3b16b1-874b-4ba4-bdf3-e5f436c1c776, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=3
2018-01-26 09:59:34,633 [thread=http-bio-8443-exec-9] [req=e56ca2e7-2745-4e75-821e-5076d2a3d0a8, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/owners/Foobar/products/176/?
2018-01-26 09:59:34,636 [thread=http-bio-8443-exec-9] [req=e56ca2e7-2745-4e75-821e-5076d2a3d0a8, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=3
2018-01-26 09:59:35,681 [thread=http-bio-8443-exec-7] [req=e0058b35-260c-4eb3-967f-ac0cf5d5d594, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/owners/Foobar/products/272/?
2018-01-26 09:59:35,685 [thread=http-bio-8443-exec-7] [req=e0058b35-260c-4eb3-967f-ac0cf5d5d594, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=4
2018-01-26 09:59:35,692 [thread=http-bio-8443-exec-8] [req=aec56553-dc41-471b-8ebf-98be279cf44b, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/owners/Foobar/products/205/?
2018-01-26 09:59:35,695 [thread=http-bio-8443-exec-8] [req=aec56553-dc41-471b-8ebf-98be279cf44b, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=3
2018-01-26 09:59:35,702 [thread=http-bio-8443-exec-2] [req=675cdec6-b3c1-45fc-8da8-26d56568c2d0, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/owners/Foobar/products/201/?
2018-01-26 09:59:35,706 [thread=http-bio-8443-exec-2] [req=675cdec6-b3c1-45fc-8da8-26d56568c2d0, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=4
2018-01-26 09:59:35,713 [thread=http-bio-8443-exec-4] [req=e44a7fe3-8ed3-4eef-ad08-a8049336a742, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/owners/Foobar/products/274/?
2018-01-26 09:59:35,716 [thread=http-bio-8443-exec-4] [req=e44a7fe3-8ed3-4eef-ad08-a8049336a742, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=3
2018-01-26 09:59:35,723 [thread=http-bio-8443-exec-1] [req=a520cc77-8b9d-4fb3-b44e-4d236881cf79, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/owners/Foobar/products/394/?
2018-01-26 09:59:35,726 [thread=http-bio-8443-exec-1] [req=a520cc77-8b9d-4fb3-b44e-4d236881cf79, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=3
2018-01-26 09:59:35,814 [thread=http-bio-8443-exec-3] [req=0d31c69b-b354-4d3c-986b-b849456f1a80, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/owners/Foobar/subscriptions?
2018-01-26 09:59:35,859 [thread=http-bio-8443-exec-3] [req=0d31c69b-b354-4d3c-986b-b849456f1a80, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=45
2018-01-26 09:59:35,877 [thread=http-bio-8443-exec-5] [req=6d9b882e-52db-4df4-9d6c-6317f85ef2da, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/owners/Foobar/subscriptions?
2018-01-26 09:59:35,920 [thread=http-bio-8443-exec-5] [req=6d9b882e-52db-4df4-9d6c-6317f85ef2da, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=43
2018-01-26 09:59:35,935 [thread=http-bio-8443-exec-2] [req=6fec6cc0-6b73-4b81-ab6b-1fc79b2b3cd0, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/subscriptions/57ec04679d634e5a83d894709d9310e3
2018-01-26 09:59:35,958 [thread=http-bio-8443-exec-2] [req=6fec6cc0-6b73-4b81-ab6b-1fc79b2b3cd0, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=23
2018-01-26 09:59:35,969 [thread=http-bio-8443-exec-6] [req=be7d66d5-ed53-4721-ac04-e98cadc4bf8f, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/subscriptions/57ec04679d634e5a83d894709d9310e3
2018-01-26 09:59:35,992 [thread=http-bio-8443-exec-6] [req=be7d66d5-ed53-4721-ac04-e98cadc4bf8f, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=23
2018-01-26 09:59:35,999 [thread=http-bio-8443-exec-9] [req=2708f254-81f7-401f-83d6-9366d837cb95, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/subscriptions/57ec04679d634e5a83d894709d9310e3
2018-01-26 09:59:36,021 [thread=http-bio-8443-exec-9] [req=2708f254-81f7-401f-83d6-9366d837cb95, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=22
2018-01-26 09:59:36,031 [thread=http-bio-8443-exec-7] [req=67cb5316-f1f2-482a-9d88-5bd69b7de419, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/subscriptions/1cca7c18336e456faba7dac8c9cd0629
2018-01-26 09:59:36,054 [thread=http-bio-8443-exec-7] [req=67cb5316-f1f2-482a-9d88-5bd69b7de419, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=23
2018-01-26 09:59:36,064 [thread=http-bio-8443-exec-8] [req=d20e38f8-fd44-4591-a84f-94d1ab482576, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/subscriptions/1cca7c18336e456faba7dac8c9cd0629
2018-01-26 09:59:36,087 [thread=http-bio-8443-exec-8] [req=d20e38f8-fd44-4591-a84f-94d1ab482576, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=23
2018-01-26 09:59:36,094 [thread=http-bio-8443-exec-10] [req=190b7557-f2e2-4eb1-88b4-7d452985e527, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/subscriptions/1cca7c18336e456faba7dac8c9cd0629
2018-01-26 09:59:36,117 [thread=http-bio-8443-exec-10] [req=190b7557-f2e2-4eb1-88b4-7d452985e527, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=23
2018-01-26 09:59:36,126 [thread=http-bio-8443-exec-4] [req=9a849e15-aadb-4a39-88c0-4ce6bf8ad04e, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/subscriptions/24e43c7d3c7049ce80a3fbf2634d3285
2018-01-26 09:59:36,149 [thread=http-bio-8443-exec-4] [req=9a849e15-aadb-4a39-88c0-4ce6bf8ad04e, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=23
2018-01-26 09:59:36,159 [thread=http-bio-8443-exec-1] [req=ddea14c4-94dc-4185-9a9e-26155bb8e012, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/subscriptions/24e43c7d3c7049ce80a3fbf2634d3285
2018-01-26 09:59:36,184 [thread=http-bio-8443-exec-1] [req=ddea14c4-94dc-4185-9a9e-26155bb8e012, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=25
2018-01-26 09:59:36,191 [thread=http-bio-8443-exec-3] [req=7e9cc4d7-bc37-4cd5-8bbe-234fc160d53a, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/subscriptions/24e43c7d3c7049ce80a3fbf2634d3285
2018-01-26 09:59:36,214 [thread=http-bio-8443-exec-3] [req=7e9cc4d7-bc37-4cd5-8bbe-234fc160d53a, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=23
2018-01-26 09:59:36,223 [thread=http-bio-8443-exec-5] [req=5650aab5-44c0-4609-bdba-1478288f5397, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/subscriptions/e9883eed36a84bf0937ab204bbf44744
2018-01-26 09:59:36,246 [thread=http-bio-8443-exec-5] [req=5650aab5-44c0-4609-bdba-1478288f5397, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=23
2018-01-26 09:59:36,270 [thread=http-bio-8443-exec-2] [req=450e1aed-e18b-45a7-844a-7b704bcf77e1, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/subscriptions/e9883eed36a84bf0937ab204bbf44744
2018-01-26 09:59:36,294 [thread=http-bio-8443-exec-2] [req=450e1aed-e18b-45a7-844a-7b704bcf77e1, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=24
2018-01-26 09:59:36,301 [thread=http-bio-8443-exec-6] [req=eb9741f3-f755-4648-abdd-5edbd924738e, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/subscriptions/e9883eed36a84bf0937ab204bbf44744
2018-01-26 09:59:36,324 [thread=http-bio-8443-exec-6] [req=eb9741f3-f755-4648-abdd-5edbd924738e, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=23
2018-01-26 09:59:36,333 [thread=http-bio-8443-exec-9] [req=e5f3df6e-6ffb-4db0-9365-7f0ea0df7508, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/subscriptions/1b3f6a4fd41a4c1790b46a62187cfd8a
2018-01-26 09:59:36,355 [thread=http-bio-8443-exec-9] [req=e5f3df6e-6ffb-4db0-9365-7f0ea0df7508, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=22
2018-01-26 09:59:36,366 [thread=http-bio-8443-exec-7] [req=d0155b51-492b-4b60-a65e-3b1503c83f80, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/subscriptions/1b3f6a4fd41a4c1790b46a62187cfd8a
2018-01-26 09:59:36,388 [thread=http-bio-8443-exec-7] [req=d0155b51-492b-4b60-a65e-3b1503c83f80, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=22
2018-01-26 09:59:36,395 [thread=http-bio-8443-exec-8] [req=41deada8-2827-4e35-bb91-b08a3d6a034f, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/subscriptions/1b3f6a4fd41a4c1790b46a62187cfd8a
2018-01-26 09:59:36,417 [thread=http-bio-8443-exec-8] [req=41deada8-2827-4e35-bb91-b08a3d6a034f, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=22
2018-01-26 09:59:36,426 [thread=http-bio-8443-exec-10] [req=7d15a824-c866-44ca-87de-928287e77e86, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/subscriptions/30395be426da49a6a98ddb0b9c94e715
2018-01-26 09:59:36,449 [thread=http-bio-8443-exec-10] [req=7d15a824-c866-44ca-87de-928287e77e86, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=23
2018-01-26 09:59:36,460 [thread=http-bio-8443-exec-4] [req=e3ece9cc-c7c6-4713-8063-00697e97d55d, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/subscriptions/30395be426da49a6a98ddb0b9c94e715
2018-01-26 09:59:36,482 [thread=http-bio-8443-exec-4] [req=e3ece9cc-c7c6-4713-8063-00697e97d55d, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=22
2018-01-26 09:59:36,489 [thread=http-bio-8443-exec-1] [req=0b93b589-492f-4ec5-bf17-fad3b2f864b2, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/subscriptions/30395be426da49a6a98ddb0b9c94e715
2018-01-26 09:59:36,511 [thread=http-bio-8443-exec-1] [req=0b93b589-492f-4ec5-bf17-fad3b2f864b2, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=22
2018-01-26 09:59:36,520 [thread=http-bio-8443-exec-3] [req=6b9ca3e0-f727-4553-aa8a-7169d5ea32b4, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/subscriptions/1078a0483b584491829ac5abbf3688b3
2018-01-26 09:59:36,542 [thread=http-bio-8443-exec-3] [req=6b9ca3e0-f727-4553-aa8a-7169d5ea32b4, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=22
2018-01-26 09:59:36,552 [thread=http-bio-8443-exec-5] [req=f6f8c366-f733-4716-ab39-9ab9bbaf6734, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/subscriptions/1078a0483b584491829ac5abbf3688b3
2018-01-26 09:59:36,574 [thread=http-bio-8443-exec-5] [req=f6f8c366-f733-4716-ab39-9ab9bbaf6734, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=22
2018-01-26 09:59:36,581 [thread=http-bio-8443-exec-2] [req=537dc24c-8672-4212-9680-ec492ea284cb, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/subscriptions/1078a0483b584491829ac5abbf3688b3
2018-01-26 09:59:36,603 [thread=http-bio-8443-exec-2] [req=537dc24c-8672-4212-9680-ec492ea284cb, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=22
2018-01-26 09:59:36,612 [thread=http-bio-8443-exec-6] [req=2d8d6530-a3b2-49b3-b640-80f36f4f97f2, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/subscriptions/4989add1809f4f24ae756caee47c8601
2018-01-26 09:59:36,640 [thread=http-bio-8443-exec-6] [req=2d8d6530-a3b2-49b3-b640-80f36f4f97f2, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=28
2018-01-26 09:59:37,692 [thread=http-bio-8443-exec-9] [req=96a1de6d-990e-4c88-b657-7ac652f4831d, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/subscriptions/4989add1809f4f24ae756caee47c8601
2018-01-26 09:59:37,724 [thread=http-bio-8443-exec-9] [req=96a1de6d-990e-4c88-b657-7ac652f4831d, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=32
2018-01-26 09:59:37,740 [thread=http-bio-8443-exec-7] [req=43713f92-ed8f-4d87-8b0a-1d5ebe3f1266, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/subscriptions/4989add1809f4f24ae756caee47c8601
2018-01-26 09:59:37,768 [thread=http-bio-8443-exec-7] [req=43713f92-ed8f-4d87-8b0a-1d5ebe3f1266, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=28
2018-01-26 09:59:37,799 [thread=http-bio-8443-exec-8] [req=ed7d9fef-68b1-4f8a-82e6-0b749816715a, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/owners/Foobar/pools?add_future=true&attribute=unmapped_guests_only:!true
2018-01-26 09:59:37,855 [thread=http-bio-8443-exec-8] [req=ed7d9fef-68b1-4f8a-82e6-0b749816715a, org=Foobar, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=56
2018-01-26 09:59:37,868 [thread=http-bio-8443-exec-10] [req=402f6da3-da82-47a9-af44-8682e3083b8b, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/owners/Foobar/pools?add_future=true&attribute=unmapped_guests_only:!true
2018-01-26 09:59:37,911 [thread=http-bio-8443-exec-10] [req=402f6da3-da82-47a9-af44-8682e3083b8b, org=Foobar, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=43
2018-01-26 09:59:37,927 [thread=http-bio-8443-exec-4] [req=d377c0ef-b7db-4443-969c-a23aa9177cd3, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/pools/8a8381d960c7c97b0160c7cda2470006
2018-01-26 09:59:37,944 [thread=http-bio-8443-exec-4] [req=d377c0ef-b7db-4443-969c-a23aa9177cd3, org=Foobar, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=17
2018-01-26 09:59:37,957 [thread=http-bio-8443-exec-1] [req=26ebffc1-91cf-465f-9a9f-827c686ea3cb, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/activation_keys/?include=id&include=pools.pool.id
2018-01-26 09:59:38,180 [thread=http-bio-8443-exec-1] [req=26ebffc1-91cf-465f-9a9f-827c686ea3cb, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=223
2018-01-26 09:59:38,199 [thread=http-bio-8443-exec-3] [req=3fd72d96-ecf5-4c08-901b-0422c239a253, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/pools/8a8381d960c7c97b0160c7cda2470006/entitlements?include=consumer.uuid
2018-01-26 09:59:38,224 [thread=http-bio-8443-exec-3] [req=3fd72d96-ecf5-4c08-901b-0422c239a253, org=Foobar, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=25
2018-01-26 09:59:38,238 [thread=http-bio-8443-exec-5] [req=5a57f0de-970f-4d91-a1ba-7976748cb676, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/pools/8a8381d960c7c97b0160c7cdbfb50011
2018-01-26 09:59:38,255 [thread=http-bio-8443-exec-5] [req=5a57f0de-970f-4d91-a1ba-7976748cb676, org=Foobar, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=17
2018-01-26 09:59:38,268 [thread=http-bio-8443-exec-2] [req=be0e2a59-788d-41a2-a9ad-229a79a61319, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/activation_keys/?include=id&include=pools.pool.id
2018-01-26 09:59:38,482 [thread=http-bio-8443-exec-2] [req=be0e2a59-788d-41a2-a9ad-229a79a61319, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=214
2018-01-26 09:59:38,492 [thread=http-bio-8443-exec-6] [req=122bbbdc-4955-4c37-a7b8-b6c9a0a472a2, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/pools/8a8381d960c7c97b0160c7cdbfb50011/entitlements?include=consumer.uuid
2018-01-26 09:59:38,512 [thread=http-bio-8443-exec-6] [req=122bbbdc-4955-4c37-a7b8-b6c9a0a472a2, org=Foobar, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=20
2018-01-26 09:59:38,522 [thread=http-bio-8443-exec-9] [req=a8411cfa-0903-4cd9-961b-dd2583d227c6, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/pools/8a8381d960c7c97b0160c7ce07100070
2018-01-26 09:59:38,539 [thread=http-bio-8443-exec-9] [req=a8411cfa-0903-4cd9-961b-dd2583d227c6, org=Foobar, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=17
2018-01-26 09:59:38,551 [thread=http-bio-8443-exec-7] [req=36ade3c2-e38a-40fb-a003-98b5baa0d28a, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/activation_keys/?include=id&include=pools.pool.id
2018-01-26 09:59:38,755 [thread=http-bio-8443-exec-7] [req=36ade3c2-e38a-40fb-a003-98b5baa0d28a, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=204
2018-01-26 09:59:39,696 [thread=http-bio-8443-exec-8] [req=246e35af-21be-4308-a157-c2f2dcef918f, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/pools/8a8381d960c7c97b0160c7ce07100070/entitlements?include=consumer.uuid
2018-01-26 09:59:39,719 [thread=http-bio-8443-exec-8] [req=246e35af-21be-4308-a157-c2f2dcef918f, org=Foobar, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=24
2018-01-26 09:59:39,743 [thread=http-bio-8443-exec-10] [req=5c9cde72-ef1a-4986-8c23-e36aa1e3edbb, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/pools/8a8381d960c7c97b0160c7ce283f007b
2018-01-26 09:59:39,759 [thread=http-bio-8443-exec-10] [req=5c9cde72-ef1a-4986-8c23-e36aa1e3edbb, org=Foobar, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=16
2018-01-26 09:59:39,772 [thread=http-bio-8443-exec-4] [req=ca94f946-e837-4184-a05c-6c0497992b16, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/activation_keys/?include=id&include=pools.pool.id
2018-01-26 09:59:39,991 [thread=http-bio-8443-exec-4] [req=ca94f946-e837-4184-a05c-6c0497992b16, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=219
2018-01-26 09:59:40,003 [thread=http-bio-8443-exec-9] [req=9fc74b71-3534-42cd-b018-8f4e4c8a7dbb, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/pools/8a8381d960c7c97b0160c7ce283f007b/entitlements?include=consumer.uuid
2018-01-26 09:59:40,026 [thread=http-bio-8443-exec-9] [req=9fc74b71-3534-42cd-b018-8f4e4c8a7dbb, org=Foobar, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=23
2018-01-26 09:59:40,038 [thread=http-bio-8443-exec-3] [req=43a4dcf1-7606-43b2-843b-4eca7b5a689d, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/pools/8a8381d960c7c97b0160c7ce602a0086
2018-01-26 09:59:40,054 [thread=http-bio-8443-exec-3] [req=43a4dcf1-7606-43b2-843b-4eca7b5a689d, org=Foobar, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=16
2018-01-26 09:59:40,066 [thread=http-bio-8443-exec-8] [req=c035cbd6-86a3-41a4-8216-150a6e938e90, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/activation_keys/?include=id&include=pools.pool.id
2018-01-26 09:59:40,275 [thread=http-bio-8443-exec-8] [req=c035cbd6-86a3-41a4-8216-150a6e938e90, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=209
2018-01-26 09:59:40,290 [thread=http-bio-8443-exec-2] [req=185a9f33-5f38-4f47-884b-04b62d9542cb, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/pools/8a8381d960c7c97b0160c7ce602a0086/entitlements?include=consumer.uuid
2018-01-26 09:59:40,309 [thread=http-bio-8443-exec-2] [req=185a9f33-5f38-4f47-884b-04b62d9542cb, org=Foobar, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=19
2018-01-26 09:59:40,318 [thread=http-bio-8443-exec-6] [req=2e89ebe6-3a31-40de-89aa-003a45eabca7, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/pools/8a8381d960c7c97b0160c7ceb38500a5
2018-01-26 09:59:40,333 [thread=http-bio-8443-exec-6] [req=2e89ebe6-3a31-40de-89aa-003a45eabca7, org=Foobar, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=15
2018-01-26 09:59:40,345 [thread=http-bio-8443-exec-1] [req=a712004c-73cc-4175-84de-df187d2782a2, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/activation_keys/?include=id&include=pools.pool.id
2018-01-26 09:59:40,559 [thread=http-bio-8443-exec-1] [req=a712004c-73cc-4175-84de-df187d2782a2, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=214
2018-01-26 09:59:40,571 [thread=http-bio-8443-exec-7] [req=e51159c9-0271-43dd-a11c-a756a95314a0, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/pools/8a8381d960c7c97b0160c7ceb38500a5/entitlements?include=consumer.uuid
2018-01-26 09:59:40,592 [thread=http-bio-8443-exec-7] [req=e51159c9-0271-43dd-a11c-a756a95314a0, org=Foobar, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=21
2018-01-26 09:59:40,603 [thread=http-bio-8443-exec-5] [req=f98b9756-1d62-4d49-a978-738d8ca79daf, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/pools/8a8381d960c8c6cf0160dc16658c0140
2018-01-26 09:59:40,619 [thread=http-bio-8443-exec-5] [req=f98b9756-1d62-4d49-a978-738d8ca79daf, org=Foobar, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=16
2018-01-26 09:59:40,631 [thread=http-bio-8443-exec-10] [req=3c0c595e-ba99-47ba-8f91-8ea940db32cd, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/activation_keys/?include=id&include=pools.pool.id
2018-01-26 09:59:40,831 [thread=http-bio-8443-exec-10] [req=3c0c595e-ba99-47ba-8f91-8ea940db32cd, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=200
2018-01-26 09:59:41,700 [thread=http-bio-8443-exec-4] [req=79a6ac79-895b-49a1-a662-1c8bf4aed0a3, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/pools/8a8381d960c8c6cf0160dc16658c0140/entitlements?include=consumer.uuid
2018-01-26 09:59:41,722 [thread=http-bio-8443-exec-4] [req=79a6ac79-895b-49a1-a662-1c8bf4aed0a3, org=Foobar, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=22
2018-01-26 09:59:41,733 [thread=http-bio-8443-exec-9] [req=21017f6a-206c-475b-9404-75c39ccba273, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/pools/8a8381d961101a210161102fa7600008
2018-01-26 09:59:41,751 [thread=http-bio-8443-exec-9] [req=21017f6a-206c-475b-9404-75c39ccba273, org=Foobar, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=18
2018-01-26 09:59:41,765 [thread=http-bio-8443-exec-3] [req=b4ffd307-e137-4733-95c1-6ece143f1ddd, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/activation_keys/?include=id&include=pools.pool.id
2018-01-26 09:59:41,978 [thread=http-bio-8443-exec-3] [req=b4ffd307-e137-4733-95c1-6ece143f1ddd, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=213
2018-01-26 09:59:41,989 [thread=http-bio-8443-exec-8] [req=a794b1ad-2057-4a87-b68f-713fb61605de, org=, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/pools/8a8381d961101a210161102fa7600008/entitlements?include=consumer.uuid
2018-01-26 09:59:42,014 [thread=http-bio-8443-exec-8] [req=a794b1ad-2057-4a87-b68f-713fb61605de, org=Foobar, csid=9e9cafbb] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=25
2018-01-26 10:00:00,007 [thread=QuartzScheduler_Worker-11] [job=ActiveEntitlementJob-4dad08ab-7d61-4264-b910-78f32733f03b, org=, csid=] INFO  org.candlepin.pinsetter.tasks.KingpinJob - Starting job: org.candlepin.pinsetter.tasks.ActiveEntitlementJob
2018-01-26 10:00:00,009 [thread=QuartzScheduler_Worker-11] [job=ActiveEntitlementJob-4dad08ab-7d61-4264-b910-78f32733f03b, org=, csid=] INFO  org.candlepin.pinsetter.tasks.KingpinJob - Job completed: time=2
2018-01-26 10:00:00,037 [thread=QuartzScheduler_Worker-15] [job=ExpiredPoolsJob-d72e6254-0376-4dea-bd14-e8df98792a42, org=, csid=] INFO  org.candlepin.pinsetter.tasks.KingpinJob - Starting job: org.candlepin.pinsetter.tasks.ExpiredPoolsJob
2018-01-26 10:00:00,053 [thread=QuartzScheduler_Worker-15] [job=ExpiredPoolsJob-d72e6254-0376-4dea-bd14-e8df98792a42, org=, csid=] INFO  org.candlepin.pinsetter.tasks.KingpinJob - Job completed: time=16
2018-01-26 10:00:00,057 [thread=QuartzScheduler_Worker-9] [job=SweepBarJob-ed8dd20d-f2a0-4459-9288-c749fb9a74de, org=, csid=] INFO  org.candlepin.pinsetter.tasks.KingpinJob - Starting job: org.candlepin.pinsetter.tasks.SweepBarJob
2018-01-26 10:00:00,058 [thread=QuartzScheduler_Worker-9] [job=SweepBarJob-ed8dd20d-f2a0-4459-9288-c749fb9a74de, org=, csid=] INFO  org.candlepin.pinsetter.tasks.KingpinJob - Job completed: time=1
2018-01-26 10:00:46,355 [thread=http-bio-8443-exec-2] [req=a88d8849-3183-44b9-8601-35a083b3090d, org=, csid=] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/owners/Foobar
2018-01-26 10:00:46,363 [thread=http-bio-8443-exec-10] [req=5d0f8ff5-869f-47a1-8277-9bd127e88ed3, org=, csid=fb2fc4ef] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/owners/Foobar/imports
2018-01-26 10:00:46,367 [thread=http-bio-8443-exec-2] [req=a88d8849-3183-44b9-8601-35a083b3090d, org=Foobar, csid=] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=12
2018-01-26 10:00:46,375 [thread=http-bio-8443-exec-10] [req=5d0f8ff5-869f-47a1-8277-9bd127e88ed3, org=Foobar, csid=fb2fc4ef] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=12
2018-01-26 10:00:46,378 [thread=http-bio-8443-exec-4] [req=44632ab4-dd24-45b6-9bcc-44ced117701a, org=, csid=89610f16] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/owners/Foobar/servicelevels
2018-01-26 10:00:46,389 [thread=http-bio-8443-exec-4] [req=44632ab4-dd24-45b6-9bcc-44ced117701a, org=Foobar, csid=89610f16] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=11
2018-01-26 10:00:46,397 [thread=http-bio-8443-exec-7] [req=354a40b8-5889-47ca-a34a-0a5557671109, org=, csid=] INFO  org.candlepin.common.filter.LoggingFilter - Request: verb=GET, uri=/candlepin/owners/Foobar
2018-01-26 10:00:46,406 [thread=http-bio-8443-exec-7] [req=354a40b8-5889-47ca-a34a-0a5557671109, org=Foobar, csid=] INFO  org.candlepin.common.filter.LoggingFilter - Response: status=200, content-type="application/json", time=9

Foreman logs during manifest import:

2018-01-26 09:56:48 9cc7067b [app] [I] Started GET "/notification_recipients" for 192.35.179.122 at 2018-01-26 09:56:48 -0700
2018-01-26 09:56:48 9cc7067b [app] [I] Processing by NotificationRecipientsController#index as JSON
2018-01-26 09:56:48 9cc7067b [app] [I] Current user: jshewey (administrator)
2018-01-26 09:56:48 9cc7067b [app] [I] Completed 200 OK in 6ms (Views: 0.1ms | ActiveRecord: 0.5ms)
2018-01-26 09:56:51 5f89b70b [app] [I] Started GET "/subscriptions/manifest/views/manifest.html" for 192.35.179.122 at 2018-01-26 09:56:51 -0700
2018-01-26 09:56:51 75160259 [app] [I] Started GET "/subscriptions/manifest/views/manifest-import.html" for 192.35.179.122 at 2018-01-26 09:56:51 -0700
2018-01-26 09:56:51 61d35746 [app] [I] Started GET "/katello/api/v2/organizations/1" for 192.35.179.122 at 2018-01-26 09:56:51 -0700
2018-01-26 09:56:51 61d35746 [app] [I] Processing by Katello::Api::V2::OrganizationsController#show as JSON
2018-01-26 09:56:51 61d35746 [app] [I]   Parameters: {"api_version"=>"v2", "id"=>"1"}
2018-01-26 09:56:51 61d35746 [app] [I] Current user: jshewey (administrator)
2018-01-26 09:56:51 7828f5ec [app] [I] Started GET "/katello/api/v2/organizations/1/subscriptions/manifest_history" for 192.35.179.122 at 2018-01-26 09:56:51 -0700
2018-01-26 09:56:51 7828f5ec [app] [I] Processing by Katello::Api::V2::SubscriptionsController#manifest_history as JSON
2018-01-26 09:56:51 7828f5ec [app] [I]   Parameters: {"api_version"=>"v2", "organization_id"=>"1"}
2018-01-26 09:56:51 7828f5ec [app] [I] Current user: jshewey (administrator)
2018-01-26 09:56:51 7828f5ec [app] [I]   Rendered /opt/theforeman/tfm/root/usr/share/gems/gems/katello-3.5.0.1/app/views/katello/api/v2/subscriptions/manifest_history.json.rabl within katello/api/v2/layouts/collection (1.0ms)
2018-01-26 09:56:51 7828f5ec [app] [I] Completed 200 OK in 34ms (Views: 3.4ms | ActiveRecord: 1.5ms)
2018-01-26 09:56:51 a7a2d03e [app] [I] Started GET "/subscriptions/manifest/views/manifest-import-history.html" for 192.35.179.122 at 2018-01-26 09:56:51 -0700
2018-01-26 09:56:51 61d35746 [app] [I]   Rendered /opt/theforeman/tfm/root/usr/share/gems/gems/katello-3.5.0.1/app/views/katello/api/v2/organizations/show.json.rabl (293.5ms)
2018-01-26 09:56:51 61d35746 [app] [I] Completed 200 OK in 323ms (Views: 281.9ms | ActiveRecord: 28.6ms)
2018-01-26 09:56:52  [foreman-tasks/dynflow] [I] start terminating throttle_limiter...
2018-01-26 09:56:52  [foreman-tasks/dynflow] [I] start terminating client dispatcher...
2018-01-26 09:56:52  [foreman-tasks/dynflow] [I] stop listening for new events...
2018-01-26 09:56:52  [foreman-tasks/dynflow] [I] start terminating clock...
2018-01-26 09:56:52  [foreman-tasks/dynflow] [I] start terminating throttle_limiter...
2018-01-26 09:56:52  [foreman-tasks/dynflow] [I] start terminating client dispatcher...
2018-01-26 09:56:52  [foreman-tasks/dynflow] [I] stop listening for new events...
2018-01-26 09:56:52  [foreman-tasks/dynflow] [I] start terminating throttle_limiter...
2018-01-26 09:56:52  [foreman-tasks/dynflow] [I] start terminating client dispatcher...
2018-01-26 09:56:52  [foreman-tasks/dynflow] [I] stop listening for new events...
2018-01-26 09:56:52  [foreman-tasks/dynflow] [I] start terminating clock...
2018-01-26 09:56:52  [foreman-tasks/dynflow] [I] start terminating clock...
2018-01-26 09:56:58 d66dd329 [app] [I] Started GET "/notification_recipients" for 192.35.179.122 at 2018-01-26 09:56:58 -0700
2018-01-26 09:56:58 d66dd329 [app] [I] Processing by NotificationRecipientsController#index as JSON
2018-01-26 09:56:58 d66dd329 [app] [I] Current user: jshewey (administrator)
2018-01-26 09:56:58 d66dd329 [app] [I] Completed 200 OK in 4ms (Views: 0.1ms | ActiveRecord: 0.3ms)
2018-01-26 09:57:08 abbb179c [app] [I] Started GET "/notification_recipients" for 192.35.179.122 at 2018-01-26 09:57:08 -0700
2018-01-26 09:57:08 abbb179c [app] [I] Processing by NotificationRecipientsController#index as JSON
2018-01-26 09:57:08 abbb179c [app] [I] Current user: jshewey (administrator)
2018-01-26 09:57:08 abbb179c [app] [I] Completed 200 OK in 7ms (Views: 0.1ms | ActiveRecord: 0.5ms)
2018-01-26 09:57:18 2e64a9bb [app] [I] Started GET "/notification_recipients" for 192.35.179.122 at 2018-01-26 09:57:18 -0700
2018-01-26 09:57:18 2e64a9bb [app] [I] Processing by NotificationRecipientsController#index as JSON
2018-01-26 09:57:18 2e64a9bb [app] [I] Current user: jshewey (administrator)
2018-01-26 09:57:18 2e64a9bb [app] [I] Completed 200 OK in 8ms (Views: 0.2ms | ActiveRecord: 0.8ms)
2018-01-26 09:57:28 65c9175e [app] [I] Started GET "/notification_recipients" for 192.35.179.122 at 2018-01-26 09:57:28 -0700
2018-01-26 09:57:28 65c9175e [app] [I] Processing by NotificationRecipientsController#index as JSON
2018-01-26 09:57:28 65c9175e [app] [I] Current user: jshewey (administrator)
2018-01-26 09:57:28 65c9175e [app] [I] Completed 200 OK in 7ms (Views: 0.1ms | ActiveRecord: 0.5ms)
2018-01-26 09:57:38 6dff49f6 [app] [I] Started GET "/notification_recipients" for 192.35.179.122 at 2018-01-26 09:57:38 -0700
2018-01-26 09:57:38 6dff49f6 [app] [I] Processing by NotificationRecipientsController#index as JSON
2018-01-26 09:57:38 6dff49f6 [app] [I] Current user: jshewey (administrator)
2018-01-26 09:57:38 6dff49f6 [app] [I] Completed 200 OK in 4ms (Views: 0.1ms | ActiveRecord: 0.3ms)
2018-01-26 09:57:48 13f913b4 [app] [I] Started GET "/notification_recipients" for 192.35.179.122 at 2018-01-26 09:57:48 -0700
2018-01-26 09:57:48 13f913b4 [app] [I] Processing by NotificationRecipientsController#index as JSON
2018-01-26 09:57:48 13f913b4 [app] [I] Current user: jshewey (administrator)
2018-01-26 09:57:48 13f913b4 [app] [I] Completed 200 OK in 8ms (Views: 0.2ms | ActiveRecord: 0.6ms)
2018-01-26 09:57:58 55ae5446 [app] [I] Started GET "/notification_recipients" for 192.35.179.122 at 2018-01-26 09:57:58 -0700
2018-01-26 09:57:58 55ae5446 [app] [I] Processing by NotificationRecipientsController#index as JSON
2018-01-26 09:57:58 55ae5446 [app] [I] Current user: jshewey (administrator)
2018-01-26 09:57:58 55ae5446 [app] [I] Completed 200 OK in 8ms (Views: 0.2ms | ActiveRecord: 0.6ms)
2018-01-26 09:58:08 6fe2a44c [app] [I] Started GET "/notification_recipients" for 192.35.179.122 at 2018-01-26 09:58:08 -0700
2018-01-26 09:58:08 6fe2a44c [app] [I] Processing by NotificationRecipientsController#index as JSON
2018-01-26 09:58:08 6fe2a44c [app] [I] Current user: jshewey (administrator)
2018-01-26 09:58:08 6fe2a44c [app] [I] Completed 200 OK in 8ms (Views: 0.2ms | ActiveRecord: 0.6ms)
2018-01-26 09:58:18 b7c00ba0 [app] [I] Started GET "/notification_recipients" for 192.35.179.122 at 2018-01-26 09:58:18 -0700
2018-01-26 09:58:18 b7c00ba0 [app] [I] Processing by NotificationRecipientsController#index as JSON
2018-01-26 09:58:18 b7c00ba0 [app] [I] Current user: jshewey (administrator)
2018-01-26 09:58:18 b7c00ba0 [app] [I] Completed 200 OK in 9ms (Views: 0.2ms | ActiveRecord: 0.6ms)
2018-01-26 09:58:28 c3988b26 [app] [I] Started GET "/notification_recipients" for 192.35.179.122 at 2018-01-26 09:58:28 -0700
2018-01-26 09:58:28 c3988b26 [app] [I] Processing by NotificationRecipientsController#index as JSON
2018-01-26 09:58:28 c3988b26 [app] [I] Current user: jshewey (administrator)
2018-01-26 09:58:28 c3988b26 [app] [I] Completed 200 OK in 8ms (Views: 0.2ms | ActiveRecord: 0.6ms)
2018-01-26 09:58:40 5ae730c5 [app] [I] Started GET "/notification_recipients" for 192.35.179.122 at 2018-01-26 09:58:40 -0700
2018-01-26 09:58:40 5ae730c5 [app] [I] Processing by NotificationRecipientsController#index as JSON
2018-01-26 09:58:40 5ae730c5 [app] [I] Current user: jshewey (administrator)
2018-01-26 09:58:40 5ae730c5 [app] [I] Completed 200 OK in 8ms (Views: 0.2ms | ActiveRecord: 0.6ms)
2018-01-26 09:58:50 cb5cd0ec [app] [I] Started GET "/notification_recipients" for 192.35.179.122 at 2018-01-26 09:58:50 -0700
2018-01-26 09:58:50 cb5cd0ec [app] [I] Processing by NotificationRecipientsController#index as JSON
2018-01-26 09:58:50 cb5cd0ec [app] [I] Current user: jshewey (administrator)
2018-01-26 09:58:50 cb5cd0ec [app] [I] Completed 200 OK in 7ms (Views: 0.1ms | ActiveRecord: 0.6ms)
2018-01-26 09:59:00 262ac207 [app] [I] Started GET "/notification_recipients" for 192.35.179.122 at 2018-01-26 09:59:00 -0700
2018-01-26 09:59:00 262ac207 [app] [I] Processing by NotificationRecipientsController#index as JSON
2018-01-26 09:59:00 262ac207 [app] [I] Current user: jshewey (administrator)
2018-01-26 09:59:00 262ac207 [app] [I] Completed 200 OK in 8ms (Views: 0.3ms | ActiveRecord: 0.7ms)
2018-01-26 09:59:10 aa420a20 [app] [I] Started GET "/notification_recipients" for 192.35.179.122 at 2018-01-26 09:59:10 -0700
2018-01-26 09:59:10 aa420a20 [app] [I] Processing by NotificationRecipientsController#index as JSON
2018-01-26 09:59:10 aa420a20 [app] [I] Current user: jshewey (administrator)
2018-01-26 09:59:10 aa420a20 [app] [I] Completed 200 OK in 6ms (Views: 0.1ms | ActiveRecord: 0.5ms)
2018-01-26 09:59:19 9e9cafbb [app] [I] Started POST "/katello/api/v2/organizations/1/subscriptions/upload" for 192.35.179.122 at 2018-01-26 09:59:19 -0700
2018-01-26 09:59:19 9e9cafbb [app] [I] Processing by Katello::Api::V2::SubscriptionsController#upload as HTML
2018-01-26 09:59:19 9e9cafbb [app] [I]   Parameters: {"content"=>#<ActionDispatch::Http::UploadedFile:0x007efbed0c6c88 @tempfile=#<Tempfile:/tmp/RackMultipart20180126-92320-1f0ub8b.zip>, @original_filename="manifest.zip", @content_type="application/x-zip-compressed", @headers="Content-Disposition: form-data; name=\"content\"; filename=\"manifest.zip\"\r\nContent-Type: application/x-zip-compressed\r\n">, "authenticity_token"=>"FY9OqqgCNfYhM+mIDmFC1vA2VbYgdyPCuWFTKPb9QlM2IBtpMEcMEn3YMxtud6PJHgj9nHry8up1ca8hd6J36g==", "api_version"=>"v2", "organization_id"=>"1"}
2018-01-26 09:59:19 9e9cafbb [app] [I] Current user: jshewey (administrator)
2018-01-26 09:59:19 9e9cafbb [app] [I] Current user: foreman_admin (administrator)
2018-01-26 09:59:19 9e9cafbb [app] [I] Current user: jshewey (administrator)
2018-01-26 09:59:19 9e9cafbb [app] [I] Current user: foreman_admin (administrator)
2018-01-26 09:59:19 9e9cafbb [app] [I] Current user: foreman_admin (administrator)
2018-01-26 09:59:19 9e9cafbb [app] [I] Current user: foreman_admin (administrator)
2018-01-26 09:59:19 9e9cafbb [app] [I] Current user: jshewey (administrator)
2018-01-26 09:59:19 9e9cafbb [app] [I] Current user: foreman_admin (administrator)
2018-01-26 09:59:19 9e9cafbb [app] [I] Current user: jshewey (administrator)
2018-01-26 09:59:19 9e9cafbb [app] [I] Current user: foreman_admin (administrator)
2018-01-26 09:59:20 9e9cafbb [app] [I] Current user: jshewey (administrator)
2018-01-26 09:59:20 9e9cafbb [app] [I] Current user: foreman_admin (administrator)
2018-01-26 09:59:20 9e9cafbb [app] [I] Current user: jshewey (administrator)
2018-01-26 09:59:20 9e9cafbb [app] [I] Current user: foreman_admin (administrator)
2018-01-26 09:59:20 9d87f0d8 [app] [I] Started GET "/notification_recipients" for 192.35.179.122 at 2018-01-26 09:59:20 -0700
2018-01-26 09:59:20 9e9cafbb [app] [I] Current user: jshewey (administrator)
2018-01-26 09:59:20 9d87f0d8 [app] [I] Processing by NotificationRecipientsController#index as JSON
2018-01-26 09:59:20 9e9cafbb [app] [I] Current user: foreman_admin (administrator)
2018-01-26 09:59:20 9d87f0d8 [app] [I] Current user: jshewey (administrator)
2018-01-26 09:59:20 9d87f0d8 [app] [I] Completed 200 OK in 5ms (Views: 0.1ms | ActiveRecord: 0.3ms)
2018-01-26 09:59:21 9e9cafbb [app] [I] Current user: jshewey (administrator)
2018-01-26 09:59:21 9e9cafbb [app] [I] Current user: foreman_admin (administrator)
2018-01-26 09:59:21 9e9cafbb [app] [I] Current user: jshewey (administrator)
2018-01-26 09:59:21 9e9cafbb [app] [I] Current user: foreman_admin (administrator)
2018-01-26 09:59:21 9e9cafbb [app] [I] Current user: jshewey (administrator)
2018-01-26 09:59:21 9e9cafbb [app] [I] Current user: foreman_admin (administrator)
2018-01-26 09:59:21 9e9cafbb [app] [I] Current user: jshewey (administrator)
2018-01-26 09:59:21 9e9cafbb [app] [I] Current user: foreman_admin (administrator)
2018-01-26 09:59:22 9e9cafbb [app] [I] Current user: jshewey (administrator)
2018-01-26 09:59:22 9e9cafbb [app] [I] Current user: foreman_admin (administrator)
2018-01-26 09:59:22 9e9cafbb [app] [I] Current user: jshewey (administrator)
2018-01-26 09:59:22 9e9cafbb [app] [I] Current user: foreman_admin (administrator)
2018-01-26 09:59:22 9e9cafbb [app] [I] Current user: jshewey (administrator)
2018-01-26 09:59:22 9e9cafbb [app] [I] Current user: foreman_admin (administrator)
2018-01-26 09:59:22 9e9cafbb [app] [I] Current user: jshewey (administrator)
2018-01-26 09:59:22 9e9cafbb [app] [I] Current user: foreman_admin (administrator)
2018-01-26 09:59:22 9e9cafbb [app] [I] Current user: jshewey (administrator)
2018-01-26 09:59:22 9e9cafbb [app] [I] Current user: foreman_admin (administrator)
2018-01-26 09:59:23 9e9cafbb [app] [I] Current user: jshewey (administrator)
2018-01-26 09:59:23 9e9cafbb [app] [I] Current user: foreman_admin (administrator)
2018-01-26 09:59:23 9e9cafbb [app] [I] Current user: jshewey (administrator)
2018-01-26 09:59:23 9e9cafbb [app] [I] Current user: foreman_admin (administrator)
2018-01-26 09:59:24 9e9cafbb [app] [I] Current user: jshewey (administrator)
2018-01-26 09:59:24 9e9cafbb [app] [I] Current user: foreman_admin (administrator)
2018-01-26 09:59:24 9e9cafbb [app] [I] Current user: jshewey (administrator)
2018-01-26 09:59:24 9e9cafbb [app] [I] Current user: foreman_admin (administrator)
2018-01-26 09:59:24 9e9cafbb [app] [I] Current user: jshewey (administrator)
2018-01-26 09:59:24 9e9cafbb [app] [I] Current user: foreman_admin (administrator)
2018-01-26 09:59:24 9e9cafbb [app] [I] Current user: jshewey (administrator)
2018-01-26 09:59:24 9e9cafbb [app] [I] Current user: foreman_admin (administrator)
2018-01-26 09:59:24 9e9cafbb [app] [I] Current user: jshewey (administrator)
2018-01-26 09:59:24 9e9cafbb [app] [I] Current user: foreman_admin (administrator)
2018-01-26 09:59:25 9e9cafbb [app] [I] Current user: jshewey (administrator)
2018-01-26 09:59:25 9e9cafbb [app] [I] Current user: foreman_admin (administrator)
2018-01-26 09:59:25 9e9cafbb [app] [I] Current user: jshewey (administrator)
2018-01-26 09:59:25 9e9cafbb [app] [I] Current user: foreman_admin (administrator)
2018-01-26 09:59:25 9e9cafbb [app] [I] Current user: jshewey (administrator)
2018-01-26 09:59:25 9e9cafbb [app] [I] Current user: foreman_admin (administrator)
2018-01-26 09:59:25 9e9cafbb [app] [I] Current user: jshewey (administrator)
2018-01-26 09:59:25 9e9cafbb [app] [I] Current user: foreman_admin (administrator)
2018-01-26 09:59:25 9e9cafbb [app] [I] Current user: jshewey (administrator)
2018-01-26 09:59:26 9e9cafbb [app] [I] Current user: foreman_admin (administrator)
2018-01-26 09:59:26 9e9cafbb [app] [I] Current user: jshewey (administrator)
2018-01-26 09:59:26 9e9cafbb [app] [I] Current user: foreman_admin (administrator)
2018-01-26 09:59:26 9e9cafbb [app] [I] Current user: jshewey (administrator)
2018-01-26 09:59:26 9e9cafbb [app] [I] Current user: foreman_admin (administrator)
2018-01-26 09:59:26 9e9cafbb [app] [I] Current user: jshewey (administrator)
2018-01-26 09:59:26 9e9cafbb [app] [I] Current user: foreman_admin (administrator)
2018-01-26 09:59:26 9e9cafbb [app] [I] Current user: jshewey (administrator)
2018-01-26 09:59:26 9e9cafbb [app] [I] Current user: foreman_admin (administrator)
2018-01-26 09:59:27 9e9cafbb [app] [I] Current user: jshewey (administrator)
2018-01-26 09:59:27 9e9cafbb [app] [I] Current user: foreman_admin (administrator)
2018-01-26 09:59:27 9e9cafbb [app] [I] Current user: jshewey (administrator)
2018-01-26 09:59:27 9e9cafbb [app] [I] Current user: foreman_admin (administrator)
2018-01-26 09:59:27 9e9cafbb [app] [I] Current user: jshewey (administrator)
2018-01-26 09:59:27 9e9cafbb [app] [I] Current user: foreman_admin (administrator)
2018-01-26 09:59:27 9e9cafbb [app] [I] Current user: jshewey (administrator)
2018-01-26 09:59:27 9e9cafbb [app] [I] Current user: foreman_admin (administrator)
2018-01-26 09:59:28 9e9cafbb [app] [I] Current user: jshewey (administrator)
2018-01-26 09:59:28 9e9cafbb [app] [I] Current user: foreman_admin (administrator)
2018-01-26 09:59:28 9e9cafbb [app] [I] Current user: jshewey (administrator)
2018-01-26 09:59:28 9e9cafbb [app] [I] Current user: foreman_admin (administrator)
2018-01-26 09:59:28 9e9cafbb [app] [I] Current user: jshewey (administrator)
2018-01-26 09:59:28 9e9cafbb [app] [I] Current user: foreman_admin (administrator)
2018-01-26 09:59:28 9e9cafbb [app] [I] Current user: jshewey (administrator)
2018-01-26 09:59:28 9e9cafbb [app] [I] Current user: foreman_admin (administrator)
2018-01-26 09:59:29 9e9cafbb [app] [I] Current user: jshewey (administrator)
2018-01-26 09:59:29 9e9cafbb [app] [I] Current user: foreman_admin (administrator)
2018-01-26 09:59:29 9e9cafbb [app] [I] Current user: jshewey (administrator)
2018-01-26 09:59:29 9e9cafbb [app] [I] Current user: foreman_admin (administrator)
2018-01-26 09:59:29 9e9cafbb [app] [I] Current user: jshewey (administrator)
2018-01-26 09:59:29 9e9cafbb [app] [I] Current user: foreman_admin (administrator)
2018-01-26 09:59:30 9e9cafbb [app] [I] Current user: jshewey (administrator)
2018-01-26 09:59:30 9e9cafbb [app] [I] Current user: foreman_admin (administrator)
2018-01-26 09:59:30 9e9cafbb [app] [I] Current user: jshewey (administrator)
2018-01-26 09:59:30 9e9cafbb [app] [I] Current user: foreman_admin (administrator)
2018-01-26 09:59:30 9e9cafbb [app] [I] Current user: jshewey (administrator)
2018-01-26 09:59:30 9e9cafbb [app] [I] Current user: foreman_admin (administrator)
2018-01-26 09:59:30 9e9cafbb [app] [I] Current user: jshewey (administrator)
2018-01-26 09:59:30 9e9cafbb [app] [I] Current user: foreman_admin (administrator)
2018-01-26 09:59:30 9e9cafbb [app] [I] Current user: jshewey (administrator)
2018-01-26 09:59:30 9e9cafbb [app] [I] Current user: foreman_admin (administrator)
2018-01-26 09:59:30 50c19c7f [app] [I] Started GET "/notification_recipients" for 192.35.179.122 at 2018-01-26 09:59:30 -0700
2018-01-26 09:59:30 50c19c7f [app] [I] Processing by NotificationRecipientsController#index as JSON
2018-01-26 09:59:30 50c19c7f [app] [I] Current user: jshewey (administrator)
2018-01-26 09:59:30 50c19c7f [app] [I] Completed 200 OK in 4ms (Views: 0.1ms | ActiveRecord: 0.3ms)
2018-01-26 09:59:31 9e9cafbb [app] [I] Current user: jshewey (administrator)
2018-01-26 09:59:31 9e9cafbb [app] [I] Current user: foreman_admin (administrator)
2018-01-26 09:59:31 9e9cafbb [app] [I] Current user: jshewey (administrator)
2018-01-26 09:59:31 9e9cafbb [app] [I] Current user: foreman_admin (administrator)
2018-01-26 09:59:31 9e9cafbb [app] [I] Current user: jshewey (administrator)
2018-01-26 09:59:31 9e9cafbb [app] [I] Current user: foreman_admin (administrator)
2018-01-26 09:59:32 9e9cafbb [app] [I] Current user: jshewey (administrator)
2018-01-26 09:59:32 9e9cafbb [app] [I] Current user: foreman_admin (administrator)
2018-01-26 09:59:32 9e9cafbb [app] [I] Current user: jshewey (administrator)
2018-01-26 09:59:33 9e9cafbb [app] [I]   Rendered /opt/theforeman/tfm/root/usr/share/gems/gems/katello-3.5.0.1/app/views/katello/api/v2/common/async.json.rabl within katello/api/v2/layouts/resource (70.9ms)
2018-01-26 09:59:33 9e9cafbb [app] [I] Completed 202 Accepted in 14083ms (Views: 72.3ms | ActiveRecord: 53.0ms)
2018-01-26 09:59:35 9e9cafbb [katello/manifest_import_logger] [I] import of product 'Red Hat Enterprise Linux Atomic Host' from Candlepin OK
2018-01-26 09:59:35 9e9cafbb [katello/manifest_import_logger] [I] import of product 'Red Hat Developer Tools Beta (for RHEL Server)' from Candlepin OK
2018-01-26 09:59:35 9e9cafbb [katello/manifest_import_logger] [I] import of product 'Red Hat Container Images' from Candlepin OK
2018-01-26 09:59:35 9e9cafbb [katello/manifest_import_logger] [I] import of product 'Red Hat Developer Toolset (for RHEL Server)' from Candlepin OK
2018-01-26 09:59:35 9e9cafbb [katello/manifest_import_logger] [I] import of product 'Red Hat Enterprise Linux Atomic Host Beta' from Candlepin OK
2018-01-26 09:59:35 9e9cafbb [katello/manifest_import_logger] [I] import of product 'Red Hat Software Collections Beta (for RHEL Server)' from Candlepin OK
2018-01-26 09:59:35 9e9cafbb [katello/manifest_import_logger] [I] import of product 'Red Hat Software Collections (for RHEL Server)' from Candlepin OK
2018-01-26 09:59:35 9e9cafbb [katello/manifest_import_logger] [I] import of product 'Red Hat Container Images Beta' from Candlepin OK
2018-01-26 09:59:35 9e9cafbb [katello/manifest_import_logger] [I] import of product 'Red Hat Developer Tools (for RHEL Server)' from Candlepin OK
2018-01-26 10:00:09  [app] [I] Current user: foreman_admin (administrator)
2018-01-26 10:00:09  [app] [I] Current user: foreman_admin (administrator)
2018-01-26 10:00:09  [app] [I] Current user: foreman_admin (administrator)
2018-01-26 10:00:09  [app] [I] Current user: foreman_admin (administrator)
2018-01-26 10:00:11  [app] [I] Current user: foreman_admin (administrator)
2018-01-26 10:00:11  [app] [I] Current user: foreman_admin (administrator)
2018-01-26 10:00:11  [app] [I] Current user: foreman_admin (administrator)
2018-01-26 10:00:11  [app] [I] Current user: foreman_admin (administrator)
2018-01-26 10:00:14  [foreman-tasks/dynflow] [I] start terminating throttle_limiter...
2018-01-26 10:00:14  [foreman-tasks/dynflow] [I] start terminating client dispatcher...
2018-01-26 10:00:14  [foreman-tasks/dynflow] [I] stop listening for new events...
2018-01-26 10:00:14  [foreman-tasks/dynflow] [I] start terminating clock...
2018-01-26 10:00:15  [foreman-tasks/dynflow] [I] start terminating throttle_limiter...
2018-01-26 10:00:15  [foreman-tasks/dynflow] [I] start terminating client dispatcher...
2018-01-26 10:00:15  [foreman-tasks/dynflow] [I] stop listening for new events...
2018-01-26 10:00:15  [foreman-tasks/dynflow] [I] start terminating clock...
2018-01-26 10:00:46 702a1cb1 [app] [I] Started GET "/notification_recipients" for 192.35.179.122 at 2018-01-26 10:00:46 -0700
2018-01-26 10:00:46 3f4518b0 [app] [I] Started POST "/foreman_tasks/api/tasks/bulk_search" for 192.35.179.122 at 2018-01-26 10:00:46 -0700
2018-01-26 10:00:46 702a1cb1 [app] [I] Processing by NotificationRecipientsController#index as JSON
2018-01-26 10:00:46 702a1cb1 [app] [I] Current user: jshewey (administrator)
2018-01-26 10:00:46 702a1cb1 [app] [I] Completed 200 OK in 4ms (Views: 0.1ms | ActiveRecord: 0.3ms)
2018-01-26 10:00:46 3f4518b0 [app] [I] Processing by ForemanTasks::Api::TasksController#bulk_search as JSON
2018-01-26 10:00:46 3f4518b0 [app] [I]   Parameters: {"searches"=>[{"type"=>"task", "task_id"=>"27e999cd-121b-42f4-a1be-f87112241fff", "search_id"=>"1"}], "task"=>{}}
2018-01-26 10:00:46 3f4518b0 [app] [I] Current user: jshewey (administrator)
2018-01-26 10:00:46 3f4518b0 [app] [I] Completed 200 OK in 96ms (Views: 0.6ms | ActiveRecord: 1.6ms)
2018-01-26 10:00:46 89610f16 [app] [I] Started GET "/katello/api/v2/organizations/1" for 192.35.179.122 at 2018-01-26 10:00:46 -0700
2018-01-26 10:00:46 89610f16 [app] [I] Processing by Katello::Api::V2::OrganizationsController#show as JSON
2018-01-26 10:00:46 89610f16 [app] [I]   Parameters: {"api_version"=>"v2", "id"=>"1"}
2018-01-26 10:00:46 fb2fc4ef [app] [I] Started GET "/katello/api/v2/organizations/1/subscriptions/manifest_history" for 192.35.179.122 at 2018-01-26 10:00:46 -0700
2018-01-26 10:00:46 89610f16 [app] [I] Current user: jshewey (administrator)
2018-01-26 10:00:46 fb2fc4ef [app] [I] Processing by Katello::Api::V2::SubscriptionsController#manifest_history as JSON
2018-01-26 10:00:46 fb2fc4ef [app] [I]   Parameters: {"api_version"=>"v2", "organization_id"=>"1"}
2018-01-26 10:00:46 fb2fc4ef [app] [I] Current user: jshewey (administrator)
2018-01-26 10:00:46 fb2fc4ef [app] [I]   Rendered /opt/theforeman/tfm/root/usr/share/gems/gems/katello-3.5.0.1/app/views/katello/api/v2/subscriptions/manifest_history.json.rabl within katello/api/v2/layouts/collection (1.0ms)
2018-01-26 10:00:46 fb2fc4ef [app] [I] Completed 200 OK in 33ms (Views: 2.8ms | ActiveRecord: 3.4ms)
2018-01-26 10:00:46 89610f16 [app] [I]   Rendered /opt/theforeman/tfm/root/usr/share/gems/gems/katello-3.5.0.1/app/views/katello/api/v2/organizations/show.json.rabl (201.5ms)
2018-01-26 10:00:46 89610f16 [app] [I] Completed 200 OK in 211ms (Views: 190.3ms | ActiveRecord: 14.0ms)