Bug 469170

Summary: Internal Server Error when registering client.
Product: [Community] Spacewalk Reporter: Frank Ederveen <frank>
Component: ServerAssignee: Jesus M. Rodriguez <jesusr>
Status: CLOSED NOTABUG QA Contact: Red Hat Satellite QA List <satqe-list>
Severity: medium Docs Contact:
Priority: medium    
Version: 0.2   
Target Milestone: ---   
Target Release: ---   
Hardware: x86_64   
OS: Linux   
Whiteboard:
Fixed In Version: Doc Type: Bug Fix
Doc Text:
Story Points: ---
Clone Of: Environment:
Last Closed: 2008-10-30 15:57:40 UTC Type: ---
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: 456551    

Description Frank Ederveen 2008-10-30 13:16:10 UTC
Description of problem:

When I register a client to the spacewalk server, it fails during the process. Details below.


Version-Release number of selected component (if applicable):
Client and Server are CentOS5.2, Spacewalk is 0.2, Oracle 10g_64.

How reproducible:
Not sure, it happens every time when I try to register a server.

Steps to Reproduce:
1.
2.
3.
  
Actual results:

[root@dhcp05 rhn]# rhnreg_ks --serverUrl=http://spacewalk.isg.informa.com/XMLRPC --username=admin --password=admin --nohardware  --force
Error reading hardware information: dbus_bindings.DBusException
Error reading DMI information: dbus_bindings.DBusException
An error has occurred:
Internal Server Error
See /var/log/up2date for more information


[Thu Oct 30 13:12:46 2008] up2date A protocol error occurred: Internal Server Error , attempt #1,
[Thu Oct 30 13:12:53 2008] up2date A protocol error occurred: Internal Server Error , attempt #2,
[Thu Oct 30 13:13:01 2008] up2date A protocol error occurred: Internal Server Error , attempt #3,
[Thu Oct 30 13:13:08 2008] up2date A protocol error occurred: Internal Server Error , attempt #4,
[Thu Oct 30 13:13:15 2008] up2date A protocol error occurred: Internal Server Error , attempt #5,
[Thu Oct 30 13:13:15 2008] up2date Error communicating with server. The message was:
Internal Server Error
[Thu Oct 30 13:13:15 2008] up2date
Traceback (most recent call last):
  File "/usr/sbin/rhnreg_ks", line 267, in ?
    cli.run()
  File "rhncli.py", line 65, in run
  File "/usr/sbin/rhnreg_ks", line 155, in main
    rhnreg.sendPackages(systemId, packageList)
  File "rhnreg.py", line 644, in sendPackages
  File "rhnserver.py", line 50, in __call__
  File "rpcServer.py", line 263, in doCall
up2date_client.up2dateErrors.CommunicationError: Error communicating with server. The message was:
Internal Server Error


Traceback emails:

Exception reported from spacewalk.isg.informa.com
Time: Thu Oct 30 13:13:14 2008
Exception type cx_Oracle.DatabaseError
Exception while handling function handler
Request object information:
URI: /XMLRPC
Remote Host: 192.168.56.135
Server Name: spacewalk.isg.informa.com:0
Headers passed in:
	Accept-Encoding: identity
	Content-Length: 130438
	Host: spacewalk.isg.informa.com
	content-type: text/xml
	user-agent: rhn.rpclib.py/$Revision: 102540 $
	x-client-version: 1
	x-info: RPC Processor (C) Red Hat, Inc (version 102540)
	x-rhn-client-capability: packages.verifyAll(1)=1,caneatCheese(1)=1,packages.extended_profile(1)=1,reboot.reboot(1)=1,packages.verify(1)=1,packages.runTransaction(1)=1,packages.rollBack(1)=1
	x-rhn-transport-capability: follow-redirects=2
	x-transport-info: Extended Capabilities Transport (C) Red Hat, Inc (version 102540)
	x-up2date-version: 0.4.17-8
Extra information about this error:
Unhandled exception type

Exception Handler Information
Traceback (most recent call last):
  File "/usr/share/rhn/server/apacheServer.py", line 57, in __call__
    ret = f(req)
  File "/usr/share/rhn/server/apacheHandler.py", line 201, in handler
    rhnSQL.rollback()
  File "/usr/share/rhn/server/rhnSQL/__init__.py", line 150, in rollback
    return db.rollback(name)
  File "/usr/share/rhn/server/rhnSQL/int_oracle.py", line 402, in rollback
    return self.dbh.rollback()
DatabaseError: ORA-03114: not connected to ORACLE


Local variables by frame
Frame rollback in /usr/share/rhn/server/rhnSQL/int_oracle.py at line 402
	                self = <type 'instance'> <server.rhnSQL.driver_cx_Oracle.Database instance at 0x2af39e3ecfc8>
	                name = <type 'NoneType'> None

Frame rollback in /usr/share/rhn/server/rhnSQL/__init__.py at line 150
	                  db = <type 'instance'> <server.rhnSQL.driver_cx_Oracle.Database instance at 0x2af39e3ecfc8>
	                name = <type 'NoneType'> None

Frame handler in /usr/share/rhn/server/apacheHandler.py at line 201
	                   h = <type 'instance'> <__builtin__.OracleCursor on <cx_Oracle.Connection to spacewalk@SW>>
	                self = <type 'instance'> <server.apacheHandler.apacheHandler instance at 0x2af39de45c20>
	                 req = <type 'mp_request'> <mp_request object at 0x2af39a46e050>
	                 ret = <type 'int'> 0
	     templateStrings = <type 'dict'> {'email_account_info': '\nAccount Information:\n  Your Spacewalk login:         <login />\n  Your Spacewalk email address: <email-address />', 'email_footer': '--the Spacewalk Team', 'hostname': 'spacewalk.isg.informa.com'}
	                 row = <type 'NoneType'> None

Frame __call__ in /usr/share/rhn/server/apacheServer.py at line 62
	                self = <type 'instance'> <server.apacheServer.HandlerWrap instance at 0x2af39de278c0>
	                 req = <type 'mp_request'> <mp_request object at 0x2af39a46e050>
	                   f = <type 'instancemethod'> <bound method apacheHandler.handler of <server.apacheHandler.apacheHandler instance at 0x2af39de45c20>>

Frame HandlerDispatch in /usr/lib64/python2.4/site-packages/mod_python/apache.py at line 299
	                 req = <type 'mp_request'> <mp_request object at 0x2af39a46e050>
	              config = <type 'mp_table'> {'PythonInterpreter': 'rhn.server', 'PythonPath': 'sys.path+['/usr/share/rhn']'}
	                self = <type 'instance'> <mod_python.apache.CallBack instance at 0x2af39a467bd8>
	              object = <type 'instance'> <server.apacheServer.HandlerWrap instance at 0x2af39de278c0>
	                   l = <type 'list'> ['server.apacheServer', 'Handler']
	              module = <type 'module'> <module 'server.apacheServer' from '/usr/share/rhn/server/apacheServer.pyc'>
	               hlist = <type 'mp_hlist'> {'handler:'server.apacheServer::Handler','directory':'/XMLRPC/','silent':0}
	          object_str = <type 'str'> Handler
	               debug = <type 'int'> 0
	         module_name = <type 'str'> server.apacheServer
	          pathstring = <type 'str'> sys.path+['/usr/share/rhn']
	              result = <type 'int'> 500


Environment for PID=24846 on exception:
LANG = C
NLS_LANG = english.UTF8
ORACLE_HOME = /opt/oracle
PATH = /sbin:/usr/sbin:/bin:/usr/bin
PERL_BADFREE = 0
PWD = /
SHLVL = 2
TERM = xterm
_ = /usr/sbin/httpd



/var/log/http/error_log:
[root@spacewalk httpd]# tail error_log
[Thu Oct 30 13:14:24 2008] (25206) Apache2::SizeLimit httpd process too big, exiting at SIZE=529688 KB  SHARE=13896 KB  REQUESTS=2 LIFETIME=0 seconds
[Thu Oct 30 13:14:25 2008] (25213) Apache2::SizeLimit httpd process too big, exiting at SIZE=444964 KB  SHARE=10212 KB  REQUESTS=2 LIFETIME=0 seconds
[Thu Oct 30 13:14:25 2008] (25219) Apache2::SizeLimit httpd process too big, exiting at SIZE=529688 KB  SHARE=13896 KB  REQUESTS=2 LIFETIME=0 seconds
[Thu Oct 30 13:14:26 2008] (25220) Apache2::SizeLimit httpd process too big, exiting at SIZE=529688 KB  SHARE=13896 KB  REQUESTS=2 LIFETIME=0 seconds

NOTE: it could be that those are from the rhnpush that is still running in the background. It is very very slow...


Expected results:
A registered client.

Additional info:

Comment 1 Frank Ederveen 2008-10-30 15:57:40 UTC
Sorry, I think there may have been some issues with the database. It seems to work now.

Still getting these though, when uploading rpm's:

[Thu Oct 30 15:57:21 2008] (20062) Apache2::SizeLimit httpd process too big, exiting at SIZE=444864 KB  SHARE=10216 KB  REQUESTS=2 LIFETIME=0 seconds
[Thu Oct 30 15:57:21 2008] (20063) Apache2::SizeLimit httpd process too big, exiting at SIZE=529588 KB  SHARE=13888 KB  REQUESTS=2 LIFETIME=0 seconds
[Thu Oct 30 15:57:22 2008] (20073) Apache2::SizeLimit httpd process too big, exiting at SIZE=529588 KB  SHARE=13888 KB  REQUESTS=2 LIFETIME=0 seconds
[Thu Oct 30 15:57:22 2008] (20111) Apache2::SizeLimit httpd process too big, exiting at SIZE=529588 KB  SHARE=13884 KB  REQUESTS=2 LIFETIME=0 seconds
[Thu Oct 30 15:57:23 2008] (20112) Apache2::SizeLimit httpd process too big, exiting at SIZE=529588 KB  SHARE=13916 KB  REQUESTS=2 LIFETIME=0 seconds


But that is a seperate issue.

Frank