Bug 1101093

Since this issue was entered in Red Hat Bugzilla, the release flag has been
set to ? to ensure that it is properly evaluated for this release.

Created redmine issue http://projects.theforeman.org/issues/6044 from this bug

Same request applies to /run/foreman/pids/dynflow_executor.output that lacks timestamps. Let me know if I should file a new BZ for that.

Created attachment 994739 [details]
Proposed patch

Possible patch for: /usr/share/foreman/config/environment.rb

(In reply to Johan Swensson from comment #6)
> Created attachment 994739 [details]
> Proposed patch
> 
> Possible patch for: /usr/share/foreman/config/environment.rb

Smoke-tested it on my Sat6: I like it:) Added log severity is cool - it should be there as well though the BZ does not request it.

Example of logs:

2015-02-24 16:15:51 +0100 (INFO) Processing by Katello::Api::V2::ContentViewsController#index as JSON
2015-02-24 16:15:51 +0100 (INFO)   Parameters: {"nondefault"=>"true", "organization_id"=>"1", "page"=>"1", "search"=>"", "sort_by"=>"name", "sort_order"=>"ASC", "api_version"=>"v2"}
2015-02-24 16:15:51 +0100 (INFO) Just before yield
2015-02-24 16:15:51 +0100 (DEBUG)   User Load (0.8ms)  SELECT "users".* FROM "users" WHERE "users"."id" = $1 LIMIT 1  [["id", 3]]
2015-02-24 16:15:51 +0100 (DEBUG) Setting current user thread-local variable to Admin User
2015-02-24 16:15:51 +0100 (DEBUG) Setting locale: en
2015-02-24 16:15:51 +0100 (DEBUG)   Organization Load (0.7ms)  SELECT "taxonomies".* FROM "taxonomies" WHERE "taxonomies"."type" IN ('Organization') AND "taxonomies"."id" = 1 ORDER BY title LIMIT 1
2015-02-24 16:15:51 +0100 (DEBUG)    (0.4ms)  SELECT katello_content_views.id FROM "katello_content_views" WHERE "katello_content_views"."organization_id" = 1

(In reply to Pavel Moravec from comment #7)
> (In reply to Johan Swensson from comment #6)
> > Created attachment 994739 [details]
> > Proposed patch
> > 
> > Possible patch for: /usr/share/foreman/config/environment.rb
> 
> Smoke-tested it on my Sat6: I like it:) Added log severity is cool - it
> should be there as well though the BZ does not request it.

Agreed, having the severity there helps a lot when troubleshooting a issue.

Moving to POST since upstream bug http://projects.theforeman.org/issues/6044 has been closed
-------------
Anonymous
Applied in changeset commit:70a602462261f6e9404c408e296618997c1e7ba5.

VERIFIED :
# rpm -q foreman
foreman-1.7.2.8-1.el6_6sat.noarch


# tail -f /var/log/foreman/production.log
2015-03-04 02:36:20 [I] Processing by OperatingsystemsController#index as HTML
2015-03-04 02:36:20 [I]   Parameters: {"utf8"=>"✓", "search"=>"name = \"﷐[U+26BEF]﷑\""}
2015-03-04 02:36:20 [I]   Rendered operatingsystems/index.html.erb within layouts/application (4.5ms)
2015-03-04 02:36:20 [I]   Rendered common/_searchbar.html.erb (3.1ms)
2015-03-04 02:36:20 [I]   Rendered home/_submenu.html.erb (2.8ms)
2015-03-04 02:36:20 [I]   Rendered home/_user_dropdown.html.erb (1.5ms)
2015-03-04 02:36:20 [I] Read fragment views/tabs_and_title_records-3 (0.2ms)
2015-03-04 02:36:20 [I]   Rendered home/_topbar.html.erb (5.9ms)
2015-03-04 02:36:20 [I]   Rendered layouts/base.html.erb (7.3ms)
2015-03-04 02:36:20 [I] Completed 200 OK in 31ms (Views: 16.5ms | ActiveRecord: 2.5ms)

2015-03-04 02:36:35 [I] Processing by DashboardController#index as HTML
2015-03-04 02:36:35 [I] Redirected to https://qe-sat6-rhel66.usersys.redhat.com/users/login
2015-03-04 02:36:35 [I] Filter chain halted as :require_login rendered or redirected
2015-03-04 02:36:35 [I] Completed 302 Found in 3ms (ActiveRecord: 0.0ms)
2015-03-04 02:36:35 [I] Processing by UsersController#login as HTML
2015-03-04 02:36:35 [I]   Rendered users/login.html.erb within layouts/login (4.8ms)
2015-03-04 02:36:35 [I]   Rendered layouts/base.html.erb (1.9ms)
2015-03-04 02:36:35 [I] Completed 200 OK in 11ms (Views: 9.0ms | ActiveRecord: 0.0ms)
2015-03-04 02:36:36 [I] Processing by Api::V2::OperatingsystemsController#create as JSON
2015-03-04 02:36:36 [I]   Parameters: {"operatingsystem"=>{"major"=>"55", "name"=>"﷐[U+21F94]﷑﷐[U+2A7EB]﷑놶﷐[U+26CBE]﷑﷐[U+2946E]﷑﷐[U+2B5E3]﷑ꤾꊨ묒뿾묂ꝏ쎜﷐[U+28E75]﷑"}, "apiv"=>"v2"}
2015-03-04 02:36:36 [I] Authorized user admin(Admin User)
2015-03-04 02:36:36 [I]   Rendered api/v2/operatingsystems/create.json.rabl (14.8ms)
2015-03-04 02:36:36 [I] Completed 200 OK in 62ms (Views: 14.1ms | ActiveRecord: 9.5ms)
2015-03-04 02:36:37 [I] Processing by UsersController#login as HTML
2015-03-04 02:36:37 [I]   Parameters: {"utf8"=>"✓", "authenticity_token"=>"z42jBmCzoeM9Pw4xdfmWW7ki3wwUUXFhJ4FmN2XRAIA=", "login"=>{"login"=>"admin", "password"=>"[FILTERED]"}, "commit"=>"Login"}
2015-03-04 02:36:37 [I] Expire fragment views/tabs_and_title_records-3 (0.7ms)
2015-03-04 02:36:37 [I] Expire fragment views/tabs_and_title_records-3 (0.2ms)
2015-03-04 02:36:37 [I] Redirected to https://qe-sat6-rhel66.usersys.redhat.com/
2015-03-04 02:36:37 [I] Completed 302 Found in 36ms (ActiveRecord: 5.2ms)
2015-03-04 02:36:37 [I] Processing by DashboardController#index as HTML
2015-03-04 02:36:37 [I]   Rendered dashboard/welcome.html.erb within layouts/application (8.2ms)
2015-03-04 02:36:37 [I]   Rendered home/_submenu.html.erb (3.0ms)
2015-03-04 02:36:37 [I]   Rendered home/_user_dropdown.html.erb (1.6ms)
2015-03-04 02:36:37 [I] Read fragment views/tabs_and_title_records-3 (0.1ms)
2015-03-04 02:36:37 [I]   Rendered home/_organization_dropdown.html.erb (123.0ms)
2015-03-04 02:36:38 [I]   Rendered home/_location_dropdown.html.erb (15.1ms)
2015-03-04 02:36:38 [I]   Rendered home/_org_switcher.html.erb (138.8ms)
2015-03-04 02:36:38 [I]   Rendered home/_submenu.html.erb (4.1ms)
2015-03-04 02:36:38 [I]   Rendered home/_submenu.html.erb (4.2ms)
2015-03-04 02:36:38 [I]   Rendered home/_submenu.html.erb (2.0ms)
2015-03-04 02:36:38 [I]   Rendered home/_submenu.html.erb (4.2ms)
2015-03-04 02:36:38 [I]   Rendered home/_submenu.html.erb (3.4ms)
2015-03-04 02:36:38 [I]   Rendered home/_submenu.html.erb (3.0ms)
2015-03-04 02:36:38 [I]   Rendered home/_submenu.html.erb (4.2ms)
2015-03-04 02:36:38 [I] Write fragment views/tabs_and_title_records-3 (1.7ms)
2015-03-04 02:36:38 [I]   Rendered home/_topbar.html.erb (176.5ms)
2015-03-04 02:36:38 [I]   Rendered layouts/base.html.erb (178.8ms)
2015-03-04 02:36:38 [I] Filter chain halted as :welcome rendered or redirected
2015-03-04 02:36:38 [I] Completed 200 OK in 405ms (Views: 378.2ms | ActiveRecord: 9.1ms)
2015-03-04 02:36:39 [I] Processing by OperatingsystemsController#index as HTML
2015-03-04 02:36:39 [I]   Rendered operatingsystems/index.html.erb within layouts/application (46.8ms)
2015-03-04 02:36:39 [I]   Rendered common/_searchbar.html.erb (4.7ms)
2015-03-04 02:36:39 [I]   Rendered home/_submenu.html.erb (3.2ms)
2015-03-04 02:36:39 [I]   Rendered home/_user_dropdown.html.erb (5.5ms)
2015-03-04 02:36:39 [I] Read fragment views/tabs_and_title_records-3 (0.8ms)
2015-03-04 02:36:39 [I]   Rendered home/_topbar.html.erb (11.8ms)
2015-03-04 02:36:39 [I]   Rendered layouts/base.html.erb (14.0ms)
2015-03-04 02:36:39 [I] Completed 200 OK in 311ms (Views: 284.0ms | ActiveRecord: 5.5ms)

This bug is slated to be released with Satellite 6.1.

Since the problem described in this bug report should be
resolved in a recent advisory, it has been closed with a
resolution of ERRATA.

For information on the advisory, and where to find the updated
files, follow the link below.

If the solution does not work for you, open a new bug report.

https://access.redhat.com/errata/RHSA-2015:1592