Bug 1099226

Summary: updates/errata applied via Satellite (UI) do not log to messages/yum.log
Product: Red Hat Satellite Reporter: Erik M Jacobs <ejacobs>
Component: Errata ManagementAssignee: Jeff Ortel <jortel>
Status: CLOSED ERRATA QA Contact: Tazim Kolhar <tkolhar>
Severity: high Docs Contact:
Priority: high    
Version: 6.0.3CC: aupadhye, bbuckingham, bkearney, bmbouter, bscalio, chpeters, cwelton, daviddavis, dkliban, ggainey, ipanova, jlyle, jortel, mburgerh, mhrivnak, mmccune, mmello, pcreech, rchan, syamamot, tkolhar, tkubota, ttereshc
Target Milestone: UnspecifiedKeywords: Triaged
Target Release: Unused   
Hardware: Unspecified   
OS: Unspecified   
Whiteboard:
Fixed In Version: Doc Type: Bug Fix
Doc Text:
Story Points: ---
Clone Of: Environment:
Last Closed: 2015-10-15 18:40:02 UTC Type: Bug
Regression: --- Mount Type: ---
Documentation: --- CRM:
Verified Versions: Category: ---
oVirt Team: --- RHEL 7.3 requirements from Atomic Host:
Cloudforms Team: --- Target Upstream Version:
Embargoed:
Bug Depends On:    
Bug Blocks: 1115190    

Description Erik M Jacobs 2014-05-19 19:56:15 UTC 
Description of problem:
When applying an update from the Satellite UI, the client will successfully update but no information is written to any log file. Specifically, the changed packages are not written to /var/log/messages or to /var/log/yum.log

The only indication of anything on the client-side is a message in gofer's log:
2014-05-19 15:50:59,410 [INFO][worker-0] sendreply() @ rmi.py:172 - c7eb4269-961b-4d8b-a774-33dec5c603ca processed in: 8.306 (seconds)

Version-Release number of selected component (if applicable):
katello-agent-1.5.3-1.el6sat.noarch

How reproducible:
100%

Steps to Reproduce:
1. Select an errata to apply from the Satellite UI
2. Click "Apply selected"

Actual results:
Errata is successfully applied but no information is written to the logs.

Expected results:
/var/log/messages and /var/log/yum.log should indicate that package(s) were installed/updated.
Comment 1 RHEL Program Management 2014-05-19 20:05:30 UTC 
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.
Comment 4 pulp-infra@redhat.com 2015-09-10 17:30:18 UTC 
The Pulp upstream bug status is at NEW. Updating the external tracker on this bug.
Comment 5 pulp-infra@redhat.com 2015-09-10 17:30:20 UTC 
The Pulp upstream bug priority is at High. Updating the external tracker on this bug.
Comment 6 pulp-infra@redhat.com 2015-09-10 23:00:40 UTC 
The Pulp upstream bug status is at POST. Updating the external tracker on this bug.
Comment 7 Jeff Ortel 2015-09-11 19:33:36 UTC 
Fixed upstream.
Comment 8 Jeff Ortel 2015-09-11 19:35:00 UTC 
(In reply to Jeff Ortel from comment #7)
> Fixed upstream.

Gofer 2.6.4.
Comment 10 Jeff Ortel 2015-09-24 15:43:08 UTC 
FYI, My comments #7 and #8 are not correct.  This was fixed in pulp-rpm.

The commit: 58c1ee40bbf02f454b30339818fb912a8c978126
Comment 11 pulp-infra@redhat.com 2015-09-24 16:00:19 UTC 
The Pulp upstream bug status is at MODIFIED. Updating the external tracker on this bug.
Comment 12 Chris Peters 2015-09-29 19:43:18 UTC 
The commit provided in comment 10 is a merge commit. Please provide the commit hash of the changes for inclusion.
Comment 13 Mike McCune 2015-10-01 00:42:20 UTC 
Chris, in most cases you can take the right hash from the commit for merges, eg:

$ git show 58c1ee40bbf02f454b30339818fb912a8c978126
commit 58c1ee40bbf02f454b30339818fb912a8c978126
Merge: 1db686b 9a9cd48
Author: Jeff Ortel <jortel>
Date:   Thu Sep 24 10:29:22 2015 -0500

    Merge pull request #711 from jortel/issue-1243
    
    Log package changes in both system log and /var/log/yum.log.

$ git show 9a9cd48
commit 9a9cd483d21afb1576d5db20f4f086089ab06ff8
Author: Jeff Ortel <jortel>
Date:   Thu Sep 10 17:54:43 2015 -0500

    ref #1243 - package changes logged in system log and /var/log/yum.log.

diff --git a/handlers/pulp_rpm/handlers/rpmtools.py b/handlers/pulp_rpm/handlers/rpmtools.py
index bed1a37..522cfef 100644
--- a/handlers/pulp_rpm/handlers/rpmtools.py
+++ b/handlers/pulp_rpm/handlers/rpmtools.py
@@ -7,6 +7,7 @@ collections of classes:
    package and package group operations.
 """
 
+from gettext import gettext as _
 from logging import getLogger, Logger
....

I'll cherry-pick 9a9cd48
Comment 16 Tazim Kolhar 2015-10-07 13:57:51 UTC 
VERIFIED:
# rpm -qa | grep foreman
ruby193-rubygem-foreman_gutterball-0.0.1.9-1.el7sat.noarch
rhsm-qe-2.rhq.lab.eng.bos.redhat.com-foreman-proxy-1.0-1.noarch
ruby193-rubygem-foreman-redhat_access-0.2.3-1.el7sat.noarch
foreman-postgresql-1.7.2.41-1.el7sat.noarch
ruby193-rubygem-foreman_bootdisk-4.0.2.13-1.el7sat.noarch
rubygem-hammer_cli_foreman_tasks-0.0.3.5-1.el7sat.noarch
puppet-foreman_scap_client-0.3.3-9.el7sat.noarch
ruby193-rubygem-foreman_hooks-0.3.7-2.el7sat.noarch
rubygem-hammer_cli_foreman_discovery-0.0.1.10-1.el7sat.noarch
foreman-1.7.2.41-1.el7sat.noarch
foreman-vmware-1.7.2.41-1.el7sat.noarch
foreman-selinux-1.7.2.14-1.el7sat.noarch
ruby193-rubygem-foreman-tasks-0.6.15.7-1.el7sat.noarch
rubygem-hammer_cli_foreman_bootdisk-0.1.2.7-1.el7sat.noarch
rubygem-hammer_cli_foreman_docker-0.0.3.9-1.el7sat.noarch
foreman-debug-1.7.2.41-1.el7sat.noarch
foreman-libvirt-1.7.2.41-1.el7sat.noarch
foreman-proxy-1.7.2.6-1.el7sat.noarch
rhsm-qe-2.rhq.lab.eng.bos.redhat.com-foreman-client-1.0-1.noarch
rhsm-qe-2.rhq.lab.eng.bos.redhat.com-foreman-proxy-client-1.0-1.noarch
foreman-discovery-image-2.1.0-36.el7sat.noarch
ruby193-rubygem-foreman_docker-1.2.0.22-1.el7sat.noarch
rubygem-hammer_cli_foreman-0.1.4.14-1.el7sat.noarch
ruby193-rubygem-foreman_openscap-0.3.2.11-1.el7sat.noarch
foreman-gce-1.7.2.41-1.el7sat.noarch
ruby193-rubygem-foreman_discovery-2.0.0.19-1.el7sat.noarch
foreman-compute-1.7.2.41-1.el7sat.noarch
foreman-ovirt-1.7.2.41-1.el7sat.noarch


steps:
1. Select an errata to apply from the Satellite UI
2. Click "Apply selected"


# tail -50 yum.log
Oct 07 09:10:00 Installed: pam-1.1.8-12.el7_1.1.x86_64
Oct 07 09:10:00 Installed: 1:NetworkManager-tui-1.0.0-16.git20150121.b4ea599c.el7_1.x86_64
Oct 07 09:10:00 Installed: gnutls-3.3.8-12.el7_1.1.x86_64
Oct 07 09:10:00 Installed: 1:openssl-1.0.1e-42.el7_1.9.x86_64
Oct 07 09:10:00 Installed: nss-tools-3.19.1-5.el7_1.x86_64
Oct 07 09:10:00 Installed: mesa-libgbm-10.2.7-5.20140910.el7_1.1.x86_64
Oct 07 09:10:00 Installed: sqlite-3.7.17-6.el7_1.1.x86_64
Oct 07 09:10:00 Installed: libXfont-1.4.7-3.el7_1.x86_64
Oct 07 09:10:00 Installed: libmount-2.23.2-22.el7_1.1.x86_64
Oct 07 09:10:00 Installed: openldap-2.4.39-7.el7_1.x86_64
Oct 07 09:10:00 Installed: 1:NetworkManager-libnm-1.0.0-16.git20150121.b4ea599c.el7_1.x86_64
Oct 07 09:10:00 Installed: 1:cups-client-1.6.3-17.el7_1.1.x86_64
Oct 07 09:10:00 Installed: dnsmasq-2.66-14.el7_1.x86_64
Oct 07 09:10:00 Installed: iputils-20121221-6.el7_1.1.x86_64
Oct 07 09:10:00 Installed: python-2.7.5-18.el7_1.1.x86_64
Oct 07 09:10:00 Installed: mesa-libglapi-10.2.7-5.20140910.el7_1.1.x86_64
Oct 07 09:10:00 Installed: ntp-4.2.6p5-19.el7_1.1.x86_64
Oct 07 09:10:00 Installed: systemd-sysv-208-20.el7_1.6.x86_64
Oct 07 09:10:00 Installed: 7:device-mapper-1.02.93-3.el7_1.1.x86_64
Oct 07 09:10:00 Installed: ca-certificates-2015.2.4-70.0.el7_1.noarch
Oct 07 09:10:00 Installed: dracut-033-241.el7_1.5.x86_64
Oct 07 09:10:00 Installed: 1:grub2-tools-2.02-0.17.el7_1.4.x86_64
Oct 07 09:10:00 Installed: ntpdate-4.2.6p5-19.el7_1.1.x86_64
Oct 07 09:10:00 Installed: 1:NetworkManager-config-server-1.0.0-16.git20150121.b4ea599c.el7_1.x86_64
Oct 07 09:10:00 Installed: subversion-1.7.14-7.el7_1.1.x86_64
Oct 07 09:10:00 Installed: dracut-network-033-241.el7_1.5.x86_64
Oct 07 09:10:00 Installed: util-linux-2.23.2-22.el7_1.1.x86_64
Oct 07 09:10:00 Installed: 32:bind-license-9.9.4-18.el7_1.5.noarch
Oct 07 09:10:00 Installed: numactl-libs-2.0.9-5.el7_1.x86_64
Oct 07 09:10:00 Installed: 7:device-mapper-event-libs-1.02.93-3.el7_1.1.x86_64
Oct 07 09:10:00 Installed: kexec-tools-2.0.7-19.el7_1.2.x86_64
Oct 07 09:10:00 Installed: expect-5.45-14.el7_1.x86_64
Oct 07 09:10:00 Installed: systemd-libs-208-20.el7_1.6.x86_64
Oct 07 09:10:00 Installed: 1:grub2-2.02-0.17.el7_1.4.x86_64
Oct 07 09:10:00 Installed: 1:wpa_supplicant-2.0-17.el7_1.x86_64
Oct 07 09:10:00 Installed: kernel-headers-3.10.0-229.14.1.el7.x86_64
Oct 07 09:10:00 Installed: libgcrypt-1.5.3-12.el7_1.1.x86_64
Oct 07 09:10:00 Installed: 7:device-mapper-libs-1.02.93-3.el7_1.1.x86_64
Oct 07 09:10:00 Installed: kpartx-0.4.9-77.el7_1.1.x86_64
Oct 07 09:10:00 Installed: libuuid-2.23.2-22.el7_1.1.x86_64
Oct 07 09:10:00 Installed: nss-util-3.19.1-3.el7_1.x86_64
Oct 07 09:10:00 Installed: selinux-policy-targeted-3.13.1-23.el7_1.18.noarch
Oct 07 09:10:00 Installed: selinux-policy-3.13.1-23.el7_1.18.noarch
Oct 07 09:10:00 Installed: 1:cups-libs-1.6.3-17.el7_1.1.x86_64
Oct 07 09:10:00 Installed: kernel-tools-3.10.0-229.14.1.el7.x86_64
Oct 07 09:10:00 Installed: 1:NetworkManager-team-1.0.0-16.git20150121.b4ea599c.el7_1.x86_64
Oct 07 09:10:00 Installed: krb5-libs-1.12.2-15.el7_1.x86_64
Oct 07 09:10:00 Installed: python-chardet-2.2.1-1.el7_1.noarch
Oct 07 09:10:00 Installed: nss-softokn-freebl-3.16.2.3-13.el7_1.x86_64
Oct 07 09:10:00 Installed: libblkid-2.23.2-22.el7_1.1.x86_64
[root@beast log]# tail -100 yum.log
Oct 05 11:23:50 Installed: python-twisted-core-12.2.0-4.el7.x86_64
Oct 05 11:23:52 Installed: python-twisted-web-12.1.0-4.el7.x86_64
Oct 05 11:23:53 Installed: rhts-python-4.67-1.el7.noarch
Oct 05 11:24:25 Installed: rhts-test-env-4.67-1.el7.noarch
Oct 05 11:24:59 Installed: beah-0.7.9-2.el7.noarch
Oct 05 11:25:00 Installed: beakerlib-1.10-2.el7eso.noarch
Oct 05 11:25:15 Installed: python-chardet-2.0.1-7.el7.noarch
Oct 05 11:25:16 Installed: python-kitchen-1.1.1-5.el7.noarch
Oct 05 11:25:16 Installed: yum-utils-1.1.31-29.el7.noarch
Oct 05 11:25:17 Installed: beakerlib-redhat-1-18.el7eso.noarch
Oct 05 11:29:21 Installed: beaker-distribution-install-1.12-2.noarch
Oct 05 11:29:59 Installed: beaker-distribution-reservesys-3.4-5.noarch
Oct 07 08:38:52 Installed: katello-ca-consumer-rhsm-qe-2.rhq.lab.eng.bos.redhat.com-1.0-1.noarch
Oct 07 08:44:02 Installed: python-gofer-2.6.6-2.el7sat.noarch
Oct 07 08:44:03 Installed: gofer-2.6.6-2.el7sat.noarch
Oct 07 08:44:04 Installed: python-isodate-0.5.0-4.pulp.el7sat.noarch
Oct 07 08:44:04 Installed: python-pulp-common-2.6.0.16-1.el7sat.noarch
Oct 07 08:44:05 Installed: python-pulp-agent-lib-2.6.0.16-1.el7sat.noarch
Oct 07 08:44:06 Installed: python-pulp-rpm-common-2.6.0.16-1.el7sat.noarch
Oct 07 08:44:06 Installed: pulp-rpm-handlers-2.6.0.16-1.el7sat.noarch
Oct 07 08:44:11 Installed: qpid-proton-c-0.9-7.el7.x86_64
Oct 07 08:44:12 Installed: python-qpid-proton-0.9-7.el7.x86_64
Oct 07 08:44:12 Installed: python-gofer-proton-2.6.6-2.el7sat.noarch
Oct 07 08:44:13 Installed: katello-agent-2.2.5-1.el7sat.noarch
Oct 07 09:10:00 Installed: 1:openssl-libs-1.0.1e-42.el7_1.9.x86_64
Oct 07 09:10:00 Installed: 7:lvm2-2.02.115-3.el7_1.1.x86_64
Oct 07 09:10:00 Installed: dracut-config-rescue-033-241.el7_1.5.x86_64
Oct 07 09:10:00 Installed: 14:libpcap-1.5.3-4.el7_1.2.x86_64
Oct 07 09:10:00 Installed: kernel-tools-libs-3.10.0-229.14.1.el7.x86_64
Oct 07 09:10:00 Installed: trousers-0.3.11.2-4.el7_1.x86_64
Oct 07 09:10:00 Installed: coreutils-8.22-12.el7_1.2.x86_64
Oct 07 09:10:00 Installed: mesa-libEGL-10.2.7-5.20140910.el7_1.1.x86_64
Oct 07 09:10:00 Installed: subversion-libs-1.7.14-7.el7_1.1.x86_64
Oct 07 09:10:00 Installed: 2:irqbalance-1.0.7-2.el7_1.x86_64
Oct 07 09:10:00 Installed: nspr-4.10.8-1.el7_1.x86_64
Oct 07 09:10:00 Installed: libgudev1-208-20.el7_1.6.x86_64
Oct 07 09:10:00 Installed: nss-3.19.1-5.el7_1.x86_64
Oct 07 09:10:00 Installed: libuser-0.60-7.el7_1.x86_64
Oct 07 09:10:00 Installed: nss-sysinit-3.19.1-5.el7_1.x86_64
Oct 07 09:10:00 Installed: python-libs-2.7.5-18.el7_1.1.x86_64
Oct 07 09:10:00 Installed: 7:lvm2-libs-2.02.115-3.el7_1.1.x86_64
Oct 07 09:10:00 Installed: 7:device-mapper-event-1.02.93-3.el7_1.1.x86_64
Oct 07 09:10:00 Installed: systemd-208-20.el7_1.6.x86_64
Oct 07 09:10:00 Installed: mesa-libGL-10.2.7-5.20140910.el7_1.1.x86_64
Oct 07 09:10:00 Installed: nss-softokn-3.16.2.3-13.el7_1.x86_64
Oct 07 09:10:00 Installed: gdk-pixbuf2-2.28.2-5.el7_1.x86_64
Oct 07 09:10:00 Installed: tzdata-2015f-1.el7.noarch
Oct 07 09:10:00 Installed: 1:mariadb-libs-5.5.44-1.el7_1.x86_64
Oct 07 09:10:00 Installed: 1:NetworkManager-1.0.0-16.git20150121.b4ea599c.el7_1.x86_64
Oct 07 09:10:00 Installed: 32:bind-libs-lite-9.9.4-18.el7_1.5.x86_64
Oct 07 09:10:00 Installed: pam-1.1.8-12.el7_1.1.x86_64
Oct 07 09:10:00 Installed: 1:NetworkManager-tui-1.0.0-16.git20150121.b4ea599c.el7_1.x86_64
Oct 07 09:10:00 Installed: gnutls-3.3.8-12.el7_1.1.x86_64
Oct 07 09:10:00 Installed: 1:openssl-1.0.1e-42.el7_1.9.x86_64
Oct 07 09:10:00 Installed: nss-tools-3.19.1-5.el7_1.x86_64
Oct 07 09:10:00 Installed: mesa-libgbm-10.2.7-5.20140910.el7_1.1.x86_64
Oct 07 09:10:00 Installed: sqlite-3.7.17-6.el7_1.1.x86_64
Oct 07 09:10:00 Installed: libXfont-1.4.7-3.el7_1.x86_64
Oct 07 09:10:00 Installed: libmount-2.23.2-22.el7_1.1.x86_64
Oct 07 09:10:00 Installed: openldap-2.4.39-7.el7_1.x86_64
Oct 07 09:10:00 Installed: 1:NetworkManager-libnm-1.0.0-16.git20150121.b4ea599c.el7_1.x86_64
Oct 07 09:10:00 Installed: 1:cups-client-1.6.3-17.el7_1.1.x86_64
Oct 07 09:10:00 Installed: dnsmasq-2.66-14.el7_1.x86_64
Oct 07 09:10:00 Installed: iputils-20121221-6.el7_1.1.x86_64
Oct 07 09:10:00 Installed: python-2.7.5-18.el7_1.1.x86_64
Oct 07 09:10:00 Installed: mesa-libglapi-10.2.7-5.20140910.el7_1.1.x86_64
Oct 07 09:10:00 Installed: ntp-4.2.6p5-19.el7_1.1.x86_64
Oct 07 09:10:00 Installed: systemd-sysv-208-20.el7_1.6.x86_64
Oct 07 09:10:00 Installed: 7:device-mapper-1.02.93-3.el7_1.1.x86_64
Oct 07 09:10:00 Installed: ca-certificates-2015.2.4-70.0.el7_1.noarch
Oct 07 09:10:00 Installed: dracut-033-241.el7_1.5.x86_64
Oct 07 09:10:00 Installed: 1:grub2-tools-2.02-0.17.el7_1.4.x86_64
Oct 07 09:10:00 Installed: ntpdate-4.2.6p5-19.el7_1.1.x86_64
Oct 07 09:10:00 Installed: 1:NetworkManager-config-server-1.0.0-16.git20150121.b4ea599c.el7_1.x86_64
Oct 07 09:10:00 Installed: subversion-1.7.14-7.el7_1.1.x86_64
Oct 07 09:10:00 Installed: dracut-network-033-241.el7_1.5.x86_64
Oct 07 09:10:00 Installed: util-linux-2.23.2-22.el7_1.1.x86_64
Oct 07 09:10:00 Installed: 32:bind-license-9.9.4-18.el7_1.5.noarch
Oct 07 09:10:00 Installed: numactl-libs-2.0.9-5.el7_1.x86_64
Oct 07 09:10:00 Installed: 7:device-mapper-event-libs-1.02.93-3.el7_1.1.x86_64
Oct 07 09:10:00 Installed: kexec-tools-2.0.7-19.el7_1.2.x86_64
Oct 07 09:10:00 Installed: expect-5.45-14.el7_1.x86_64
Oct 07 09:10:00 Installed: systemd-libs-208-20.el7_1.6.x86_64
Oct 07 09:10:00 Installed: 1:grub2-2.02-0.17.el7_1.4.x86_64
Oct 07 09:10:00 Installed: 1:wpa_supplicant-2.0-17.el7_1.x86_64
Oct 07 09:10:00 Installed: kernel-headers-3.10.0-229.14.1.el7.x86_64
Oct 07 09:10:00 Installed: libgcrypt-1.5.3-12.el7_1.1.x86_64
Oct 07 09:10:00 Installed: 7:device-mapper-libs-1.02.93-3.el7_1.1.x86_64
Oct 07 09:10:00 Installed: kpartx-0.4.9-77.el7_1.1.x86_64
Oct 07 09:10:00 Installed: libuuid-2.23.2-22.el7_1.1.x86_64
Oct 07 09:10:00 Installed: nss-util-3.19.1-3.el7_1.x86_64
Oct 07 09:10:00 Installed: selinux-policy-targeted-3.13.1-23.el7_1.18.noarch
Oct 07 09:10:00 Installed: selinux-policy-3.13.1-23.el7_1.18.noarch
Oct 07 09:10:00 Installed: 1:cups-libs-1.6.3-17.el7_1.1.x86_64
Oct 07 09:10:00 Installed: kernel-tools-3.10.0-229.14.1.el7.x86_64
Oct 07 09:10:00 Installed: 1:NetworkManager-team-1.0.0-16.git20150121.b4ea599c.el7_1.x86_64
Oct 07 09:10:00 Installed: krb5-libs-1.12.2-15.el7_1.x86_64
Oct 07 09:10:00 Installed: python-chardet-2.2.1-1.el7_1.noarch
Oct 07 09:10:00 Installed: nss-softokn-freebl-3.16.2.3-13.el7_1.x86_64
Oct 07 09:10:00 Installed: libblkid-2.23.2-22.el7_1.1.x86_64
Comment 17 Bryan Kearney 2015-10-08 13:43:30 UTC 
*** Bug 1206111 has been marked as a duplicate of this bug. ***
Comment 19 errata-xmlrpc 2015-10-15 18:40:02 UTC 
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/RHBA-2015:1910
Comment 20 pulp-infra@redhat.com 2015-10-22 15:00:47 UTC 
The Pulp upstream bug status is at ON_QA. Updating the external tracker on this bug.
Comment 21 pulp-infra@redhat.com 2015-11-09 21:00:40 UTC 
The Pulp upstream bug status is at CLOSED - CURRENTRELEASE. Updating the external tracker on this bug.