[Spacewalk-list] failing yum update through 1.8 proxy

[Maria Iano]

I bumped up the debugging on the proxy server to level 3. Here are  
more excerpts from logs when I encounter this problem:

https://docs.google.com/document/d/1EuzLDALBNpNQeik9XdNI5uax9kDotsM9LKmMDag1rfQ/edit

Thanks for any help you can provide.

On Dec 12, 2012, at 4:50 PM, Maria Iano wrote:

> I have just activated a 1.8 spacewalk proxy server on CentOS 5 i386.  
> I am able to register a new system to it, and I am able to list  
> updates, but if I try to install them they fail to download. If I  
> edit up2date to point to the spacewalk server itself the update  
> downloads successfully and installs. This only happens when I point  
> to the proxy server.
>
> It looked like this was https://bugzilla.redhat.com/show_bug.cgi?id=872721 
>  but I implemented the fix at http://git.fedorahosted.org/cgit/spacewalk.git/commit/?id=5f00038675c58c5a401d0c4a5cbfa332c28a4405 
>  and it has not fixed this for me.
>
> Here is the error message I see in /var/log/squid/cache.log
>
> 2012/12/12 16:30:18| WARNING: Forwarding loop detected for:
> Client: 127.0.0.1 http_port: 127.0.0.1:8080
> GET http://127.0.0.1/XMLRPC/$RHN/rpmforge-el5-i386/listAllPackages/20121212070700 
>  HTTP/1.1
> Host: 127.0.0.1
> Accept-Encoding: identity
> x-info: RPC Processor (C) Red Hat, Inc (version 2.5.55-1.el5)
> x-client-version: 1
> Accept-Encoding: identity
> x-rhn-server-id: 1000010030
> X-Forwarded-For: 127.0.0.1
> X-RHN-Proxy-Version: 5.5.0
> x-rhn-auth-server-time: 1355347818.01
> x-transport-info: Extended Capabilities Transport (C) Red Hat, Inc  
> (version 2.5.55-1.el5)
> X-RHN-IP-Path: 159.54.39.21
> Connection: keep-alive
> Via: 1.1 proxy.hostname.com:8080 (squid/2.6.STABLE21)
> x-rhn-auth: +9TU4XS8IuGFhE9lFyyaVw==
> Cache-Control: max-age=31557600
> X-RHN-Transport-Capability: follow-redirects=3
> x-rhn-auth-user-id:
> User-Agent: rhn.rpclib.py/2.5.55-1.el5
> Content-Type: text/xml
> x-rhn-auth-expire-offset: 3600.0
> X-RHN-Proxy-Auth:  
> 1000010038 
> ::1355342082.91:21600.0:bc6J73TVQ7hUZdxxAIl6RQ==:proxy.hostname.com
>
> and here is the tail end of the errors in /var/log/http/error_log:
>
> Wed Dec 12 16:30:22 2012] [error] Exception Handler Information
> [Wed Dec 12 16:30:22 2012] [error] Traceback (most recent call last):
> [Wed Dec 12 16:30:22 2012] [error]   File "/usr/lib/python2.4/site- 
> packages/spacewalk/server/apacheRequest.py", line 122, in  
> call_function
> [Wed Dec 12 16:30:22 2012] [error]     response = apply(func, params)
> [Wed Dec 12 16:30:22 2012] [error]   File "/usr/lib/python2.4/site- 
> packages/spacewalk/server/rhnRepository.py", line 148, in  
> listAllPackages
> [Wed Dec 12 16:30:22 2012] [error]     packages =  
> rhnChannel.list_all_packages(self.channelName)
> [Wed Dec 12 16:30:22 2012] [error]   File "/usr/lib/python2.4/site- 
> packages/spacewalk/server/rhnChannel.py", line 1298, in  
> list_all_packages
> [Wed Dec 12 16:30:22 2012] [error]     function=list_all_packages_sql)
> [Wed Dec 12 16:30:22 2012] [error]   File "/usr/lib/python2.4/site- 
> packages/spacewalk/server/rhnChannel.py", line 1336, in _list_packages
> [Wed Dec 12 16:30:22 2012] [error]     rhnCache.set(cache_entry,  
> ret, c_info["last_modified"])
> [Wed Dec 12 16:30:22 2012] [error]   File "/usr/lib/python2.4/site- 
> packages/spacewalk/common/rhnCache.py", line 85, in set
> [Wed Dec 12 16:30:22 2012] [error]     cache.set(name, value,  
> modified, user, group, mode)
> [Wed Dec 12 16:30:22 2012] [error]   File "/usr/lib/python2.4/site- 
> packages/spacewalk/common/rhnCache.py", line 373, in set
> [Wed Dec 12 16:30:22 2012] [error]     self.cache.set(name, pickled,  
> modified, user, group, mode)
> [Wed Dec 12 16:30:22 2012] [error]   File "/usr/lib/python2.4/site- 
> packages/spacewalk/common/rhnCache.py", line 259, in set
> [Wed Dec 12 16:30:22 2012] [error]     fd = self.set_file(name,  
> modified, user, group, mode)
> [Wed Dec 12 16:30:22 2012] [error]   File "/usr/lib/python2.4/site- 
> packages/spacewalk/common/rhnCache.py", line 296, in set_file
> [Wed Dec 12 16:30:22 2012] [error]     fd = WriteLockedFile(name,  
> modified, user, group, mode)
> [Wed Dec 12 16:30:22 2012] [error]   File "/usr/lib/python2.4/site- 
> packages/spacewalk/common/rhnCache.py", line 184, in __init__
> [Wed Dec 12 16:30:22 2012] [error]     self.fd = self.get_fd(name,  
> user, group, mode)
> [Wed Dec 12 16:30:22 2012] [error]   File "/usr/lib/python2.4/site- 
> packages/spacewalk/common/rhnCache.py", line 229, in get_fd
> [Wed Dec 12 16:30:22 2012] [error]     fd = _safe_create(self.fname,  
> user, group, mode)
> [Wed Dec 12 16:30:22 2012] [error]   File "/usr/lib/python2.4/site- 
> packages/spacewalk/common/rhnCache.py", line 156, in _safe_create
> [Wed Dec 12 16:30:22 2012] [error]     fd = os.open(fname,  
> os.O_WRONLY | os.O_CREAT | os.O_EXCL, 0644)
> [Wed Dec 12 16:30:22 2012] [error] OSError: [Errno 13] Permission  
> denied: '/var/cache/rhn/list_all_packages-rpmforge-el5-i386'
>
> What should be my next step in debugging this?
>
> Thanks,
> Maria
>