Bug 747880

Summary: "Next Sync" set to Unknown while running repo sync
Product: Red Hat Update Infrastructure for Cloud Providers Reporter: Sachin Ghai <sghai>
Component: ToolsAssignee: James Slagle <jslagle>
Status: CLOSED ERRATA QA Contact: mkovacik
Severity: unspecified Docs Contact:
Priority: high    
Version: 2.0.1CC: igulina, kbidarka, sghai, tsanders
Target Milestone: ---   
Target Release: ---   
Hardware: Unspecified   
OS: Unspecified   
Whiteboard:
Fixed In Version: Doc Type: Bug Fix
Doc Text:
Story Points: ---
Clone Of: Environment:
Last Closed: 2017-03-01 22:07:24 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: 746803    
Attachments:
Description Flags
pulp.logs are attached.
none
rhui.log attached none

Description Sachin Ghai 2011-10-21 09:02:05 UTC
Description of problem:
I started a repo sync for around 18 repos. Sync was running from last 40+ hours and due to some reason sync finished with 'Unknown' state.


I didn't change the configuration for sync frequency. The default freq was set as 6 hours. System date was correct this time.

------------------------------------------------------------------------------
             -= Red Hat Update Infrastructure Management Tool =-


-= Repository Synchronization Status =-

Last Refreshed: 14:20:49
(updated every 5 seconds, ctrl+c to exit)

Next Sync                    Last Sync                    Last Result         
------------------------------------------------------------------------------
Red Hat Enterprise Linux Server 5 (RPMs) (5.6-i386)
Unknown                      10-20-2011 20:07             Success    

Red Hat Enterprise Linux Server 5 (RPMs) (5.6-x86_64)
Unknown                      10-20-2011 20:14             Success    

Red Hat Enterprise Linux Server 5 (RPMs) (5.7-i386)
Unknown                      10-20-2011 20:07             Success    

Red Hat Enterprise Linux Server 5 (RPMs) (5.7-x86_64)
Unknown                      10-20-2011 20:15             Success    

Red Hat Enterprise Linux Server 5 (RPMs) (5Server-i386)
Unknown                      10-20-2011 20:39             Success    

Red Hat Enterprise Linux Server 5 (RPMs) (5Server-x86_64)
Unknown                      10-21-2011 03:15             Success    

Red Hat Enterprise Linux Server 6 (RPMs) (6.0-i386)
Unknown                      10-21-2011 01:15             Success    

Red Hat Enterprise Linux Server 6 (RPMs) (6.0-x86_64)
Unknown                      10-21-2011 01:11             Success    

Red Hat Enterprise Linux Server 6 (RPMs) (6.1-i386)
Unknown                      10-21-2011 04:54             Success    

Red Hat Enterprise Linux Server 6 (RPMs) (6.1-x86_64)
Unknown                      10-21-2011 05:18             Success    

Red Hat Enterprise Linux Server 6 (RPMs) (6Server-i386)
Unknown                      10-21-2011 02:43             Success    

Red Hat Enterprise Linux Server 6 (RPMs) (6Server-x86_64)
Unknown                      10-21-2011 03:04             Success    

Red Hat Enterprise Linux Server 6 Optional (RPMs) (6.0-i386)
Unknown                      10-21-2011 00:18             Success    

Red Hat Enterprise Linux Server 6 Optional (RPMs) (6.0-x86_64)
Unknown                      10-21-2011 00:39             Success    

Red Hat Enterprise Linux Server 6 Optional (RPMs) (6.1-i386)
Unknown                      10-21-2011 01:03             Success    

Red Hat Enterprise Linux Server 6 Optional (RPMs) (6.1-x86_64)
Unknown                      10-21-2011 01:01             Success    

Red Hat Enterprise Linux Server 6 Optional (RPMs) (6Server-i386)
Unknown                      10-21-2011 00:47             Success    

Red Hat Enterprise Linux Server 6 Optional (RPMs) (6Server-x86_64)
Unknown                      10-21-2011 01:01             Success    


                                  Connected: dhcp201-152.englab.pnq.redhat.com
------------------------------------------------------------------------------

ssl_error_logs:
==============

[root@dhcp201-152 ~]# tail -f /var/log/httpd/ssl_error_log 
[Fri Oct 21 02:51:33 2011] [error] [client 10.65.201.152] Premature end of script headers: webservices.wsgi


/var/log/httpd/error_log: 
============
[Fri Oct 21 02:52:00 2011] [error]   import sha
[Fri Oct 21 02:52:13 2011] [error] mod_wsgi (pid=14335): Target WSGI script '/srv/pulp/webservices.wsgi' cannot be loaded as Python module.
[Fri Oct 21 02:52:13 2011] [error] mod_wsgi (pid=14335): Exception occurred processing WSGI script '/srv/pulp/webservices.wsgi'.
[Fri Oct 21 02:52:13 2011] [error] Traceback (most recent call last):
[Fri Oct 21 02:52:13 2011] [error]   File "/srv/pulp/webservices.wsgi", line 20, in <module>
[Fri Oct 21 02:52:13 2011] [error]     application = wsgi_application()
[Fri Oct 21 02:52:13 2011] [error]   File "/usr/lib/python2.6/site-packages/pulp/server/webservices/application.py", line 198, in wsgi_application
[Fri Oct 21 02:52:13 2011] [error]     _initialize_pulp()
[Fri Oct 21 02:52:13 2011] [error]   File "/usr/lib/python2.6/site-packages/pulp/server/webservices/application.py", line 186, in _initialize_pulp
[Fri Oct 21 02:52:13 2011] [error]     _update_sync_schedules()
[Fri Oct 21 02:52:13 2011] [error]   File "/usr/lib/python2.6/site-packages/pulp/server/webservices/application.py", line 130, in _update_sync_schedules
[Fri Oct 21 02:52:13 2011] [error]     param = _sync_schedule_param(_repo["sync_schedule"], repo_sync_freq_iso)
[Fri Oct 21 02:52:13 2011] [error]   File "/usr/lib/python2.6/site-packages/pulp/server/webservices/application.py", line 117, in _sync_schedule_param
[Fri Oct 21 02:52:13 2011] [error]     interval, start, runs = parse_iso8601_interval(sync_schedule)
[Fri Oct 21 02:52:13 2011] [error]   File "/usr/lib/python2.6/site-packages/pulp/common/dateutils.py", line 195, in parse_iso8601_interval
[Fri Oct 21 02:52:13 2011] [error]     for part in _iso8601_delimiter.split(interval_str):
[Fri Oct 21 02:52:13 2011] [error] TypeError: expected string or buffer
Traceback (most recent call last):
  File "/usr/lib/python2.6/site-packages/grinder/activeobject.py", line 499, in <module>
    main()
  File "/usr/lib/python2.6/site-packages/grinder/activeobject.py", line 496, in main
    process()
  File "/usr/lib/python2.6/site-packages/grinder/activeobject.py", line 454, in process
    sys.stdout.flush()
IOError: [Errno 32] Broken pipe

Traceback (most recent call last):
  File "/usr/lib/python2.6/site-packages/grinder/activeobject.py", line 499, in <module>
    main()
  File "/usr/lib/python2.6/site-packages/grinder/activeobject.py", line 496, in main
    process()
  File "/usr/lib/python2.6/site-packages/grinder/activeobject.py", line 454, in process
    sys.stdout.flush()
IOError: [Errno 32] Broken pipe
Traceback (most recent call last):
  File "/usr/lib/python2.6/site-packages/grinder/activeobject.py", line 499, in <module>
    main()
  File "/usr/lib/python2.6/site-packages/grinder/activeobject.py", line 496, in main
    process()
  File "/usr/lib/python2.6/site-packages/grinder/activeobject.py", line 454, in process
    sys.stdout.flush()
IOError: [Errno 32] Broken pipe
Traceback (most recent call last):
Traceback (most recent call last):
  File "/usr/lib/python2.6/site-packages/grinder/activeobject.py", line 499, in <module>
    main()
  File "/usr/lib/python2.6/site-packages/grinder/activeobject.py", line 496, in main
    process()
  File "/usr/lib/python2.6/site-packages/grinder/activeobject.py", line 454, in process
    sys.stdout.flush()
IOError: [Errno 32] Broken pipe
  File "/usr/lib/python2.6/site-packages/grinder/WriteFunction.py", line 48, in callback
    LOG.debug("processing chunk %s" % len(chunk))
  File "/usr/lib/python2.6/site-packages/grinder/activeobject.py", line 369, in __call__
    self.__send(msg, args)
  File "/usr/lib/python2.6/site-packages/grinder/activeobject.py", line 421, in __send
    sys.stdout.flush()
IOError: [Errno 32] Broken pipe
Traceback (most recent call last):
  File "/usr/lib/python2.6/site-packages/grinder/activeobject.py", line 499, in <module>
    main()
  File "/usr/lib/python2.6/site-packages/grinder/activeobject.py", line 496, in main
    process()
  File "/usr/lib/python2.6/site-packages/grinder/activeobject.py", line 454, in process
    sys.stdout.flush()
IOError: [Errno 32] Broken pipe
[root@dhcp201-152 ~]# 








Version-Release number of selected component (if applicable):
RHEL-6.1-RHUI-2.0.1-20111017.0-Server-x86_64-DVD1.iso

How reproducible:


Steps to Reproduce:
1. 
2.
3.
  
Actual results:
Next sync showing 'Unknown' 

Expected results:
Sync should finish without any error.

Additional info:

Comment 1 Sachin Ghai 2011-10-21 09:02:55 UTC
Created attachment 529456 [details]
pulp.logs are attached.

Comment 2 Sachin Ghai 2011-10-21 09:07:04 UTC
Created attachment 529457 [details]
rhui.log attached

Comment 3 James Slagle 2011-10-21 14:32:58 UTC
This was caused by a custom repo, which has no sync schedule.  I added a check in the code to account for this.

commit 4bfc6423ca1c1eba13d22db2b8a7789f2c64308f
Author: James Slagle <jslagle>
Date:   Fri Oct 21 10:32:41 2011 -0400

    747880 Allow for custom repos to have no sync schedule

Comment 4 James Slagle 2011-10-25 12:20:06 UTC
To verify, change the sync schedule again in the tools config file and restart the pulp-server service.  The repos should then be showing the new schedule in rhui-manager.

Comment 5 Kedar Bidarkar 2011-10-26 12:00:18 UTC
                                  Connected: dhcp201-133.englab.pnq.redhat.com
------------------------------------------------------------------------------
rhui (home) => s


------------------------------------------------------------------------------
             -= Red Hat Update Infrastructure Management Tool =-


-= Synchronization Status =-

   dr  display repo sync summary
   vr  view the details of the last repository sync
   sr  sync an individual repository immediately
   dc  display CDS sync summary
   vc  view the details of the last CDS sync
   sc  sync an individual CDS immediately

                                  Connected: dhcp201-133.englab.pnq.redhat.com
------------------------------------------------------------------------------
rhui (sync) => dr

------------------------------------------------------------------------------
             -= Red Hat Update Infrastructure Management Tool =-


-= Repository Synchronization Status =-

Last Refreshed: 17:28:37
(updated every 5 seconds, ctrl+c to exit)

Next Sync                    Last Sync                    Last Result         
------------------------------------------------------------------------------
Red Hat Enterprise Linux Server 6 Optional (RPMs) (6.1-i386)
10-26-2011 17:39             10-21-2011 21:41             Success    

Red Hat Enterprise Linux Server 6 Optional (RPMs) (6Server-x86_64)
10-26-2011 19:00             10-21-2011 22:23             Success    

Red Hat Update Infrastructure 2.0 (RPMs) (6.0-i386)
10-26-2011 19:26             10-26-2011 17:27             Success    

Red Hat Update Infrastructure 2.0 (RPMs) (6.0-x86_64)
10-26-2011 19:26             10-26-2011 17:27             Success    

Red Hat Update Infrastructure 2.0 (RPMs) (6.1-i386)
10-26-2011 19:26             10-26-2011 17:27             Success    

Red Hat Update Infrastructure 2.0 (RPMs) (6.1-x86_64)
10-26-2011 19:26             10-26-2011 17:27             Success    

Red Hat Update Infrastructure 2.0 (RPMs) (6Server-i386)
10-26-2011 19:26             10-26-2011 17:27             Success    

Red Hat Update Infrastructure 2.0 (RPMs) (6Server-x86_64)
10-26-2011 19:26             10-26-2011 17:27             Success    


                                  Connected: dhcp201-133.englab.pnq.redhat.com

Comment 6 Kedar Bidarkar 2011-10-26 12:01:06 UTC
[root@dhcp201-133 ~]# rpm -qav | grep -ie rhui -ie pulp 
rh-rhel6optional-rhui12-2.7-1.el6.noarch
pulp-0.0.214-7.el6.noarch
pulp-common-0.0.214-7.el6.noarch
rh-rhui-tools-2.0.44-1.el6.noarch
pulp-client-0.0.214-7.el6.noarch

Comment 10 errata-xmlrpc 2017-03-01 22:07:24 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-2017:0367