[Spacewalk-list] IntegrityError: new row for relation "rhnserveractionverifyresult" violates check constraint "rhn_sactionvr_attr_ck"

Fri Feb 24 21:37:56 UTC 2012

I'm experiencing a problem during rhn_check after requesting package
verification via the spacewalk web interface. I'm running spacewalk
1.6 on Centos 6.2 on x86_64 platform with a postgresql database. All
packages are current. I have searched the archives of this list and
the spacewalk-devel list and found no prior references to this error.
I am able to install packages and manage configuration as expected,
but when I schedule package verification I get the following error on
the client (hostname skylab):

[daniel at skylab ~]$ sudo rhn_check
[sudo] password for daniel:
XMLRPC ProtocolError: <ProtocolError for juno /XMLRPC: 500 Internal
Server Error>

On the server (hostname Juno), /var/log/httpd/error_log shows the
following corresponding error:

[Fri Feb 24 13:08:32 2012] [error] Exception reported from juno
[Fri Feb 24 13:08:32 2012] [error] Time: Fri Feb 24 13:08:32 2012
[Fri Feb 24 13:08:32 2012] [error] Exception type <class
'psycopg2.IntegrityError'>
[Fri Feb 24 13:08:32 2012] [error] Exception while handling function
queue.submit
[Fri Feb 24 13:08:32 2012] [error] Request object information:
[Fri Feb 24 13:08:32 2012] [error] URI: /XMLRPC
[Fri Feb 24 13:08:32 2012] [error] Remote Host: 192.168.168.42
[Fri Feb 24 13:08:32 2012] [error] Server Name: juno:443
[Fri Feb 24 13:08:32 2012] [error] Headers passed in:
[Fri Feb 24 13:08:32 2012] [error] \tAccept-Encoding: identity
[Fri Feb 24 13:08:32 2012] [error] \tCONTENT_LENGTH: 146819
[Fri Feb 24 13:08:32 2012] [error] \tCONTENT_TYPE: text/xml
[Fri Feb 24 13:08:32 2012] [error] \tDOCUMENT_ROOT: /var/www/html
[Fri Feb 24 13:08:32 2012] [error] \tGATEWAY_INTERFACE: CGI/1.1
[Fri Feb 24 13:08:32 2012] [error] \tHTTPS: 1
[Fri Feb 24 13:08:32 2012] [error] \tHTTP_ACCEPT_ENCODING: identity
[Fri Feb 24 13:08:32 2012] [error] \tHTTP_HOST: juno
[Fri Feb 24 13:08:32 2012] [error] \tHTTP_USER_AGENT: rhn.rpclib.py/$Revision$
[Fri Feb 24 13:08:32 2012] [error] \tHTTP_X_CLIENT_VERSION: 1
[Fri Feb 24 13:08:32 2012] [error] \tHTTP_X_INFO: RPC Processor (C)
Red Hat, Inc (version $Revision$)
[Fri Feb 24 13:08:32 2012] [error] \tHTTP_X_RHN_CLIENT_CAPABILITY:
packages.verify(1)=1,packages.extended_profile(2)=1,configfiles.base64_enc(1)=1,reboot.reboot(1)=1,configfiles.deploy(1)=1,caneatCheese(1)=1,packages.rollBack(1)=1,configfiles.mtime_upload(1)=1,configfiles.diff(1)=1,packages.update(2)=2,script.run(1)=1,configfiles.upload(1)=1,packages.runTransaction(1)=1,packages.verify(1)=1,packages.extended_profile(2)=1,configfiles.base64_enc(1)=1,reboot.reboot(1)=1,configfiles.deploy(1)=1,caneatCheese(1)=1,packages.rollBack(1)=1,configfiles.mtime_upload(1)=1,configfiles.diff(1)=1,packages.update(2)=2,script.run(1)=1,configfiles.upload(1)=1,packages.runTransaction(1)=1
[Fri Feb 24 13:08:32 2012] [error] \tHTTP_X_RHN_TRANSPORT_CAPABILITY:
follow-redirects=3
[Fri Feb 24 13:08:32 2012] [error] \tHTTP_X_TRANSPORT_INFO: Extended
Capabilities Transport (C) Red Hat, Inc (version $Revision$)
[Fri Feb 24 13:08:32 2012] [error] \tHTTP_X_UP2DATE_VERSION: 1.6.47-1.el6
[Fri Feb 24 13:08:32 2012] [error] \tHost: juno
[Fri Feb 24 13:08:32 2012] [error] \tPATH_INFO:
[Fri Feb 24 13:08:32 2012] [error] \tQUERY_STRING:
[Fri Feb 24 13:08:32 2012] [error] \tREMOTE_ADDR: 192.168.168.42
[Fri Feb 24 13:08:32 2012] [error] \tREMOTE_PORT: 52336
[Fri Feb 24 13:08:32 2012] [error] \tREQUEST_METHOD: POST
[Fri Feb 24 13:08:32 2012] [error] \tREQUEST_URI: /XMLRPC
[Fri Feb 24 13:08:32 2012] [error] \tSCRIPT_FILENAME:
/usr/share/rhn/wsgi/xmlrpc.py
[Fri Feb 24 13:08:32 2012] [error] \tSCRIPT_NAME: /XMLRPC
[Fri Feb 24 13:08:32 2012] [error] \tSCRIPT_URI: https://juno/XMLRPC
[Fri Feb 24 13:08:32 2012] [error] \tSCRIPT_URL: /XMLRPC
[Fri Feb 24 13:08:32 2012] [error] \tSERVER_ADDR: 192.168.168.24
[Fri Feb 24 13:08:32 2012] [error] \tSERVER_ADMIN: root at localhost
[Fri Feb 24 13:08:32 2012] [error] \tSERVER_NAME: juno
[Fri Feb 24 13:08:32 2012] [error] \tSERVER_PORT: 443
[Fri Feb 24 13:08:32 2012] [error] \tSERVER_PROTOCOL: HTTP/1.1
[Fri Feb 24 13:08:32 2012] [error] \tSERVER_SIGNATURE: <address>Apache
Server at juno Port 443</address>
[Fri Feb 24 13:08:32 2012] [error]
[Fri Feb 24 13:08:32 2012] [error] \tSERVER_SOFTWARE: Apache
[Fri Feb 24 13:08:32 2012] [error] \tUser-Agent: rhn.rpclib.py/$Revision$
[Fri Feb 24 13:08:32 2012] [error] \tX-Client-Version: 1
[Fri Feb 24 13:08:32 2012] [error] \tX-Info: RPC Processor (C) Red
Hat, Inc (version $Revision$)
[Fri Feb 24 13:08:32 2012] [error] \tX-RHN-Client-Capability:
packages.verify(1)=1,packages.extended_profile(2)=1,configfiles.base64_enc(1)=1,reboot.reboot(1)=1,configfiles.deploy(1)=1,caneatCheese(1)=1,packages.rollBack(1)=1,configfiles.mtime_upload(1)=1,configfiles.diff(1)=1,packages.update(2)=2,script.run(1)=1,configfiles.upload(1)=1,packages.runTransaction(1)=1,packages.verify(1)=1,packages.extended_profile(2)=1,configfiles.base64_enc(1)=1,reboot.reboot(1)=1,configfiles.deploy(1)=1,caneatCheese(1)=1,packages.rollBack(1)=1,configfiles.mtime_upload(1)=1,configfiles.diff(1)=1,packages.update(2)=2,script.run(1)=1,configfiles.upload(1)=1,packages.runTransaction(1)=1
[Fri Feb 24 13:08:32 2012] [error] \tX-RHN-Transport-Capability:
follow-redirects=3
[Fri Feb 24 13:08:32 2012] [error] \tX-Transport-Info: Extended
Capabilities Transport (C) Red Hat, Inc (version $Revision$)
[Fri Feb 24 13:08:32 2012] [error] \tX-Up2Date-Version: 1.6.47-1.el6
[Fri Feb 24 13:08:32 2012] [error] \tmod_wsgi.application_group:
juno.doreydesign.local|/xmlrpc
[Fri Feb 24 13:08:32 2012] [error] \tmod_wsgi.callable_object: application
[Fri Feb 24 13:08:32 2012] [error] \tmod_wsgi.handler_script:
[Fri Feb 24 13:08:32 2012] [error] \tmod_wsgi.input_chunked: 0
[Fri Feb 24 13:08:32 2012] [error] \tmod_wsgi.listener_host:
[Fri Feb 24 13:08:32 2012] [error] \tmod_wsgi.listener_port: 443
[Fri Feb 24 13:08:32 2012] [error] \tmod_wsgi.process_group:
[Fri Feb 24 13:08:32 2012] [error] \tmod_wsgi.request_handler: wsgi-script
[Fri Feb 24 13:08:32 2012] [error] \tmod_wsgi.script_reloading: 1
[Fri Feb 24 13:08:32 2012] [error] \tmod_wsgi.version: (3, 2)
[Fri Feb 24 13:08:32 2012] [error] \twsgi.errors: <mod_wsgi.Log object
at 0x7f5d2ce0ffb0>
[Fri Feb 24 13:08:32 2012] [error] \twsgi.file_wrapper: <built-in
method file_wrapper of mod_wsgi.Adapter object at 0x7f5d2cc3bcd8>
[Fri Feb 24 13:08:32 2012] [error] \twsgi.input: <mod_wsgi.Input
object at 0x7f5d2d192330>
[Fri Feb 24 13:08:32 2012] [error] \twsgi.multiprocess: True
[Fri Feb 24 13:08:32 2012] [error] \twsgi.multithread: False
[Fri Feb 24 13:08:32 2012] [error] \twsgi.run_once: False
[Fri Feb 24 13:08:32 2012] [error] \twsgi.url_scheme: https
[Fri Feb 24 13:08:32 2012] [error] \twsgi.version: (1, 1)
[Fri Feb 24 13:08:32 2012] [error]
[Fri Feb 24 13:08:32 2012] [error] Exception Handler Information
[Fri Feb 24 13:08:32 2012] [error] Traceback (most recent call last):
[Fri Feb 24 13:08:32 2012] [error]   File
"/usr/lib/python2.6/site-packages/spacewalk/server/apacheRequest.py",
line 122, in call_function
[Fri Feb 24 13:08:32 2012] [error]     response = apply(func, params)
[Fri Feb 24 13:08:32 2012] [error]   File
"/usr/share/rhn/server/handlers/xmlrpc/queue.py", line 470, in submit
[Fri Feb 24 13:08:32 2012] [error]     action_type=action_type)
[Fri Feb 24 13:08:32 2012] [error]   File
"/usr/share/rhn/server/handlers/xmlrpc/queue.py", line 515, in
process_extra_data
[Fri Feb 24 13:08:32 2012] [error]     result = method(self.server_id,
action_id, data=data)
[Fri Feb 24 13:08:32 2012] [error]   File
"/usr/lib/python2.6/site-packages/spacewalk/server/action_extra_data/packages.py",
line 171, in verify
[Fri Feb 24 13:08:32 2012] [error]     apply(h.executemany, (), verify_attribs)
[Fri Feb 24 13:08:32 2012] [error]   File
"/usr/lib/python2.6/site-packages/spacewalk/server/rhnSQL/sql_base.py",
line 172, in executemany
[Fri Feb 24 13:08:32 2012] [error]     return
apply(self._execute_wrapper, (self._executemany, ) + p, kw)
[Fri Feb 24 13:08:32 2012] [error]   File
"/usr/lib/python2.6/site-packages/spacewalk/server/rhnSQL/driver_postgresql.py",
line 282, in _execute_wrapper
[Fri Feb 24 13:08:32 2012] [error]     retval = apply(function, p, kw)
[Fri Feb 24 13:08:32 2012] [error]   File
"/usr/lib/python2.6/site-packages/spacewalk/server/rhnSQL/driver_postgresql.py",
line 318, in _executemany
[Fri Feb 24 13:08:32 2012] [error]
self._real_cursor.executemany(self.sql, all_kwargs)
[Fri Feb 24 13:08:32 2012] [error] IntegrityError: new row for
relation "rhnserveractionverifyresult" violates check constraint
"rhn_sactionvr_attr_ck"
[Fri Feb 24 13:08:32 2012] [error]
[Fri Feb 24 13:08:32 2012] [error]

In case it's useful, the verification request is attempting to check
the following packages:

Packages to be verified:
dmidecode-2.11-2.el6:1
libpcap-1.0.0-6.20091201git117cb5.el6:14
vim-enhanced-7.2.411-1.6.el6:2
wireless-tools-29-5.1.1.el6:1
microcode_ctl-1.17-9.el6:1
samba-winbind-clients-3.5.10-114.el6:0
perl-Module-Pluggable-3.90-119.el6_1.1:1
samba-3.5.10-114.el6:0
perl-Pod-Simple-3.13-119.el6_1.1:1
bind-libs-9.7.3-8.P3.el6:32
vim-minimal-7.2.411-1.6.el6:2
samba-common-3.5.10-114.el6:0
nfs-utils-1.2.3-15.el6:1
dbus-libs-1.2.24-5.el6_1:1
bind-utils-9.7.3-8.P3.el6:32
perl-libs-5.10.1-119.el6_1.1:4
shadow-utils-4.1.4.2-13.el6:2
samba-client-3.5.10-114.el6:0
quota-3.17-16.el6:1
qemu-img-0.12.1.2-2.209.el6_2.4:2
dhcp-common-4.1.1-25.P1.el6:12
traceroute-2.0.14-2.el6:3
samba-winbind-krb5-locator-3.5.10-114.el6:0
ethtool-2.6.33-0.3.el6:2
ivtv-firmware-20080701-20.2:2
libertas-usb8388-firmware-5.110.22.p23-3.1.el6:2
libpng-1.2.46-1.el6_1:2
iwl1000-firmware-39.31.5.1-1.el6:1
postfix-2.6.6-2.2.el6_1:2
tar-1.23-3.el6:2
vim-common-7.2.411-1.6.el6:2
readahead-1.5.6-1.el6:1
samba-doc-3.5.10-114.el6:0
cups-libs-1.4.2-44.el6:1
mtr-0.75-5.el6:2
cpuspeed-1.5-15.el6:1
grub-0.97-75.el6:1
pkgconfig-0.23-9.1.el6:1
perl-version-0.77-119.el6_1.1:3
tcpdump-4.0.0-3.20090921gitdf3cb4.1.el6:14
samba-winbind-3.5.10-114.el6:0
dhclient-4.1.1-25.P1.el6:12
findutils-4.4.2-6.el6:1
busybox-1.15.1-11.el6:1
smartmontools-5.39.1-5.el6:1
irqbalance-0.55-29.el6:2
perl-Pod-Escapes-1.04-119.el6_1.1:1
dbus-1.2.24-5.el6_1:1
perl-5.10.1-119.el6_1.1:4

Any help is appreciated. My hunch is that this is a postgresql related
issue, but I really can't back that up. Please let me know what
further information would be useful toward reproducing the problem.

Sincerely,

Daniel Dreier