Bug 744060

Summary: autosubscribe is reporting the product certs' version instead of status in the rhsm.log
Product: Red Hat Enterprise Linux 5 Reporter: John Sefler <jsefler>
Component: subscription-managerAssignee: Devan Goodwin <dgoodwin>
Status: CLOSED ERRATA QA Contact: IDM QE LIST <seceng-idm-qe-list>
Severity: unspecified Docs Contact:
Priority: unspecified    
Version: 5.8CC: dgoodwin, skallesh, spandey, wpoteat
Target Milestone: rc   
Target Release: ---   
Hardware: Unspecified   
OS: Unspecified   
Whiteboard:
Fixed In Version: Doc Type: Bug Fix
Doc Text:
No description necessary
Story Points: ---
Clone Of: Environment:
Last Closed: 2012-02-21 06:41:48 UTC Type: ---
Regression: --- Mount Type: ---
Documentation: --- CRM:
Verified Versions: Category: ---
oVirt Team: --- RHEL 7.3 requirements from Atomic Host:
Cloudforms Team: --- Target Upstream Version:
Bug Depends On:    
Bug Blocks: 715031    

Description John Sefler 2011-10-06 20:52:51 UTC
Description of problem:
A follow up to bug 740877.... when I restart the rhsmcertd (which will trigger an auto-heal check), the status of all of the installed products get echoed to the rhsm.log as shown below.   However if you look at the Status field.  It is reporting the product cert's version rather than the status.


[root@jsefler-onprem-62server ~]# service rhsmcertd restart
Stopping rhsmcertd                                         [  OK  ]
Starting rhsmcertd 1 1440                                  [  OK  ]

[root@jsefler-onprem-62server ~]# tail -f /var/log/rhsm/rhsm.log

2011-10-06 16:40:57,508 [DEBUG]  @connection.py:209 - Making request: POST /candlepin/consumers/8e1a3e01-c1aa-4297-b506-8cdab03d13e4/entitlements?futuredate=2011-10-06T20%3A40%3A57.504649%2B00%3A00
2011-10-06 16:40:57,896 [DEBUG]  @connection.py:218 - Response status: 200
2011-10-06 16:40:57,898 [INFO]  @certlib.py:153 - Auto-heal check complete.
2011-10-06 16:40:57,899 [DEBUG]  @cert_sorter.py:89 - Sorting product and entitlement cert status for: 2011-10-06 20:40:57.899548+00:00
2011-10-06 16:40:57,938 [DEBUG]  @cert_sorter.py:165 - Installed product IDs: ['100000000000006', '1000000000000023', '1144', '100000000000011', '100000000000010', '100000000000013', '100000000000012', '100000000000015', '27060', '69', '37090', '1', '37069', '37068', '37080', '37065', '37067', '37060', '37062', '100000000000060', '100000000000007', '100000000000004', '100000000000005', '100000000000002', '100000000000003', '100000000000000', '100000000000001', '100000000000020', '100000000000008', '100000000000009', '100000000000022', '917571', '37070']
2011-10-06 16:40:58,125 [DEBUG]  @cert_sorter.py:93 - valid entitled products: ['1000000000000023', '100000000000011', '100000000000010', '100000000000013', '100000000000012', '100000000000015', '27060', '37069', '37068', '37080', '37065', '37067', '37060', '100000000000006', '100000000000007', '100000000000002', '100000000000003', '100000000000001', '100000000000020', '100000000000008', '100000000000009', '100000000000022', '37090', '37070']
2011-10-06 16:40:58,125 [DEBUG]  @cert_sorter.py:94 - expired entitled products: []
2011-10-06 16:40:58,125 [DEBUG]  @cert_sorter.py:95 - partially entitled products: []
2011-10-06 16:40:58,126 [DEBUG]  @cert_sorter.py:96 - unentitled products: ['100000000000060', '917571', '100000000000004', '100000000000005', '100000000000000', '1144', '1', '69', '37062']
2011-10-06 16:40:58,126 [DEBUG]  @cert_sorter.py:97 - future products: []
2011-10-06 16:41:06,105 [INFO]  @certlib.py:157 - Current installed product status:
2011-10-06 16:41:06,105 [INFO]  @certlib.py:160 - 
ProductName:         	Awesome OS for ia64 Bits 
Status:               	3.11                     

2011-10-06 16:41:06,105 [INFO]  @certlib.py:160 - 
ProductName:         	Stackable with Awesome OS for x86_64 Bits
Status:               	3.11                     

2011-10-06 16:41:06,106 [INFO]  @certlib.py:160 - 
ProductName:         	Awesome OS Developer Basic
Status:               	1.0                      

2011-10-06 16:41:06,106 [INFO]  @certlib.py:160 - 
ProductName:         	Awesome OS for x86_64/i686/ia64/ppc/ppc64/s390x/s390 Bits
Status:               	3.11                     

2011-10-06 16:41:06,106 [INFO]  @certlib.py:160 - 
ProductName:         	Awesome OS for z80/x86_64 Bits
Status:               	3.11                     

2011-10-06 16:41:06,106 [INFO]  @certlib.py:160 - 
ProductName:         	Awesome OS for z80/ALL Bits
Status:               	3.11                     

2011-10-06 16:41:06,107 [INFO]  @certlib.py:160 - 
ProductName:         	Awesome OS for x86_64/ALL Bits
Status:               	3.11                     

2011-10-06 16:41:06,107 [INFO]  @certlib.py:160 - 
ProductName:         	Awesome OS for x86_64/ALL Bits for ZERO sockets
Status:               	3.11                     

2011-10-06 16:41:06,107 [INFO]  @certlib.py:160 - 
ProductName:         	Awesome OS Workstation Bits
Status:               	6.1                      

2011-10-06 16:41:06,107 [INFO]  @certlib.py:160 - 
ProductName:         	Red Hat Enterprise Linux Server
Status:               	6.2 Beta                 

2011-10-06 16:41:06,107 [INFO]  @certlib.py:160 - 
ProductName:         	Awesome OS Scalable Filesystem Bits
Status:               	1.0                      

2011-10-06 16:41:06,108 [INFO]  @certlib.py:160 - 
ProductName:         	Awesome OS Developer Bits
Status:               	1.0                      

2011-10-06 16:41:06,108 [INFO]  @certlib.py:160 - 
ProductName:         	Management Bits          
Status:               	1.0                      

2011-10-06 16:41:06,108 [INFO]  @certlib.py:160 - 
ProductName:         	Large File Support Bits  
Status:               	1.0                      

2011-10-06 16:41:06,108 [INFO]  @certlib.py:160 - 
ProductName:         	Awesome OS Modifier Bits 
Status:               	6.1                      

2011-10-06 16:41:06,109 [INFO]  @certlib.py:160 - 
ProductName:         	Clustering Bits          
Status:               	1.0                      

2011-10-06 16:41:06,109 [INFO]  @certlib.py:160 - 
ProductName:         	Shared Storage Bits      
Status:               	1.0                      

2011-10-06 16:41:06,109 [INFO]  @certlib.py:160 - 
ProductName:         	Awesome OS Server Bits   
Status:               	6.1                      

2011-10-06 16:41:06,109 [INFO]  @certlib.py:160 - 
ProductName:         	Awesome OS Premium Architecture Bits
Status:               	6.1                      

2011-10-06 16:41:06,109 [INFO]  @certlib.py:160 - 
ProductName:         	Awesome OS for S390 Bits 
Status:               	3.11                     

2011-10-06 16:41:06,110 [INFO]  @certlib.py:160 - 
ProductName:         	Awesome OS for i686/x86_64 Bits
Status:               	3.11                     

2011-10-06 16:41:06,110 [INFO]  @certlib.py:160 - 
ProductName:         	Awesome OS for z80 Bits  
Status:               	3.11                     

2011-10-06 16:41:06,110 [INFO]  @certlib.py:160 - 
ProductName:         	Awesome OS for i686 Bits 
Status:               	3.11                     

2011-10-06 16:41:06,110 [INFO]  @certlib.py:160 - 
ProductName:         	Awesome OS for x86_64 Bits
Status:               	3.11                     

2011-10-06 16:41:06,110 [INFO]  @certlib.py:160 - 
ProductName:         	Awesome OS for ppc64 Bits
Status:               	3.11                     

2011-10-06 16:41:06,111 [INFO]  @certlib.py:160 - 
ProductName:         	Awesome OS for S390X Bits
Status:               	3.11                     

2011-10-06 16:41:06,111 [INFO]  @certlib.py:160 - 
ProductName:         	Awesome OS for i386 Bits 
Status:               	3.11                     

2011-10-06 16:41:06,111 [INFO]  @certlib.py:160 - 
ProductName:         	Awesome OS for x86 Bits  
Status:               	8.6                      

2011-10-06 16:41:06,111 [INFO]  @certlib.py:160 - 
ProductName:         	Awesome OS for x86_64/s390x Bits
Status:               	3.11                     

2011-10-06 16:41:06,111 [INFO]  @certlib.py:160 - 
ProductName:         	Awesome OS for Intel x86_64/i686/ia64 Bits
Status:               	3.11                     

2011-10-06 16:41:06,112 [INFO]  @certlib.py:160 - 
ProductName:         	Awesome OS for x86/x64_64 Bits
Status:               	8.64                     

2011-10-06 16:41:06,112 [INFO]  @certlib.py:160 - 
ProductName:         	Multiplier Product Bits  
Status:               	1.0                      

2011-10-06 16:41:06,112 [INFO]  @certlib.py:160 - 
ProductName:         	Load Balancing Bits      
Status:               	1.0                      

2011-10-06 16:41:06,172 [DEBUG]  @connection.py:188 - Loading CA PEM certificates from: /etc/rhsm/ca/
2011-10-06 16:41:06,172 [DEBUG]  @connection.py:171 - Loading CA certificate: '/etc/rhsm/ca/candlepin-stage.pem'
2011-10-06 16:41:06,173 [DEBUG]  @connection.py:171 - Loading CA certificate: '/etc/rhsm/ca/jsefler-onprem-62candlepin.pem'
2011-10-06 16:41:06,173 [DEBUG]  @connection.py:171 - Loading CA certificate: '/etc/rhsm/ca/redhat-uep.pem'
2011-10-06 16:41:06,175 [DEBUG]  @connection.py:209 - Making request: GET /candlepin/consumers/8e1a3e01-c1aa-4297-b506-8cdab03d13e4/certificates/serials
2011-10-06 16:41:06,287 [DEBUG]  @connection.py:218 - Response status: 200
2011-10-06 16:41:06,362 [INFO]  @certlib.py:207 - certs updated:
Total updates: 0
Found (local) serial# [8666380550809865349L, 2448001123428941347L, 2742000035800045756L, 8880200027346690379L, 7113373191799244371L, 5142314036724205987L, 6893490785865400785L, 1018913122144869041L, 3266522101546310888L, 8329975532703688385L, 9142936872907441825L, 2258522804357288619L, 2935926575473320756L, 5666793972496109234L, 5748731340664919269L]
Expected (UEP) serial# [2742000035800045756, 5748731340664919269, 5666793972496109234, 1018913122144869041, 2448001123428941347, 2258522804357288619, 3266522101546310888, 9142936872907441825, 6893490785865400785, 8666380550809865349, 2935926575473320756, 5142314036724205987, 8329975532703688385, 7113373191799244371, 8880200027346690379]
Added (new)
  <NONE>
Deleted (rogue):
  <NONE>
Expired (not deleted):
  <NONE>
Expired (deleted):
  <NONE>




Version-Release number of selected component (if applicable):
[root@jsefler-onprem-62server ~]# rpm -q subscription-manager
subscription-manager-0.96.13-1.git.0.b1b0502.el6.x86_64

Comment 1 Devan Goodwin 2011-11-21 20:11:25 UTC
This fickle code was removed in 13ade4fdba878d6c79c6fb63e91ca02a140073ba which is already in subscription-manager-0.98.2-1. The output was broken for some time, not really necessary, and somewhat inaccurate as you may have just healed for tomorrow (but we print status for right now). 

No product status should get logged after healing now.

Comment 2 spandey 2011-11-28 11:45:55 UTC
Verified for rhel5.8 using following rpm 

subscription-manager-migration-data-1.4-1.el5
subscription-manager-gnome-0.98.3-1.el5
subscription-manager-firstboot-0.98.3-1.el5
subscription-manager-migration-0.98.3-1.el5
subscription-manager-0.98.3-1.el5

No product status found 
Working fine resolving defect as verified

Comment 3 William Poteat 2012-01-23 13:09:39 UTC
    Technical note added. If any revisions are required, please edit the "Technical Notes" field
    accordingly. All revisions will be proofread by the Engineering Content Services team.
    
    New Contents:
No description necessary

Comment 4 errata-xmlrpc 2012-02-21 06:41:48 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.

http://rhn.redhat.com/errata/RHBA-2012-0154.html