Bug 666254 - (pk-command-not-found:2259): PackageKit-DEBUG: role now search-file huge vomit of debug messages
Summary: (pk-command-not-found:2259): PackageKit-DEBUG: role now search-file huge vomi...
Keywords:
Status: CLOSED ERRATA
Alias: None
Product: Fedora
Classification: Fedora
Component: PackageKit
Version: 14
Hardware: Unspecified
OS: Unspecified
low
medium
Target Milestone: ---
Assignee: Richard Hughes
QA Contact: Fedora Extras Quality Assurance
URL:
Whiteboard:
: 666554 676299 (view as bug list)
Depends On:
Blocks:
TreeView+ depends on / blocked
 
Reported: 2010-12-29 21:44 UTC by Wendell Baker
Modified: 2011-02-09 20:19 UTC (History)
6 users (show)

Fixed In Version: PackageKit-0.6.12-2.fc14
Doc Type: Bug Fix
Doc Text:
Clone Of:
Environment:
Last Closed: 2011-02-09 20:19:50 UTC
Type: ---
Embargoed:


Attachments (Terms of Use)
exhibition on host1 with PackageKit-command-not-found-0.6.11-1.fc14.i686 (4.67 KB, text/plain)
2010-12-29 21:45 UTC, Wendell Baker
no flags Details
a second exhibition on host1 with PackageKit-command-not-found-0.6.11-1.fc14.i686 with but also a comparison with host2 with PackageKit-command-not-found-0.6.9-4.fc14.i686 (20.58 KB, text/plain)
2010-12-29 21:46 UTC, Wendell Baker
no flags Details

Description Wendell Baker 2010-12-29 21:44:05 UTC
Description of problem:

From time to time PackageKit emits copious amounts of debug messages on the pty (gnome terminal).  This has something to do with the command-not-found hook.  But it doesn't always happen and it doesn't happen on every command.  But once it is reproducible, it seems deterministic in that and new tabs (new ptys)

Just now I reproduced it with a mis-pasted command.  I reproduce that here directly as the 'udo' command for clarity.  Of course, I intended to cut & paste the 'sudo' command.    Note that 'udo date' following does not exhibit the problem.  Repeated 'udo' with the giant tcpdump command exhibits the problem in this gnome terminal tab and new tabs created afresh.

[on host1]
$ udo tcpdump -i eth0 ' ! (port ntp || port http || port domain || port smtp || port ssh || port imaps || host 0.0.0.0 || host 255.255.255.255 || port netbios-dgm || port syslog || port ssdp || arp || host IGMP.MCAST.NET || port mdns || port ipp || port nfs || port sunrpc || port tivoconnect || port pop3 || port pop3s  || port https)' 2>&1 | tee ~/tmp/o.tcpdump_$(hostname -s).out
bash: udo: command not found...
(pk-command-not-found:2249): PackageKit-DEBUG: role now search-file
(pk-command-not-found:2249): PackageKit-DEBUG: state array add 0x8f636f0 (0x1)
(pk-command-not-found:2249): PackageKit-DEBUG: notify::connected
(pk-command-not-found:2249): PackageKit-DEBUG: state array remove 0x8f636f0
... lots of output, included separately
Getting the list of files failed: no-cache, failed to search sack: database disk image is malformed
$ udo date
bash: udo: command not found...
$ sudo date
[sudo] password for wbaker: 
Wed Dec 29 13:22:00 PST 2010




On a separate Fedora 14 host, pasting this command has the following correct (enough) behavior. 


[on host2]
$ udo tcpdump -i eth0 ' ! (port ntp || port http || port domain || port smtp || port ssh || port imaps || host 0.0.0.0 || host 255.255.255.255 || port netbios-dgm || port syslog || port ssdp || arp || host IGMP.MCAST.NET || port mdns || port ipp || port nfs || port sunrpc || port tivoconnect || port pop3 || port pop3s  || port https)' 2>&1 | tee ~/tmp/o.tcpdump_$(hostname -s).out
tee: /home/wbaker/tmp/o.tcpdump_baggie.out: No such file or directory
Command not found. 
 * Downloading details about the software sources... 
 * Downloading list of packages.. 
 * Downloading details about the software sources... 
 * Downloading list of packages.. 
 * Downloading details about the software sources... 
 * Downloading list of packages.. 
<done>

(that it went all that way to "download lists of 'packages'" (?) and then just finish up with neither a success nor failure indicator is fodder for another bug report)


Version-Release number of selected component (if applicable):


[host1 & host2]
$ cat /etc/fedora-release 
Fedora release 14 (Laughlin)

[host1]
$ rpm -q -a | grep -iEe '(packagekit|pk-command|CommandNot)' | sort
gnome-packagekit-2.32.0-2.fc14.i686
PackageKit-0.6.11-1.fc14.i686
PackageKit-command-not-found-0.6.11-1.fc14.i686 <-------- newer (problems?)
PackageKit-device-rebind-0.6.11-1.fc14.i686
PackageKit-glib-0.6.11-1.fc14.i686
PackageKit-gstreamer-plugin-0.6.11-1.fc14.i686
PackageKit-gtk-module-0.6.11-1.fc14.i686
PackageKit-yum-0.6.11-1.fc14.i686
PackageKit-yum-plugin-0.6.11-1.fc14.i686

[host2] (actually not the same as host1)
$ rpm -q -a | grep -iEe '(packagekit|pk-command|CommandNot)' | sort
gnome-packagekit-2.32.0-2.fc14.i686
PackageKit-0.6.9-4.fc14.i686
PackageKit-command-not-found-0.6.9-4.fc14.i686 <-------- older
PackageKit-device-rebind-0.6.9-4.fc14.i686
PackageKit-glib-0.6.9-4.fc14.i686
PackageKit-gstreamer-plugin-0.6.9-4.fc14.i686
PackageKit-gtk-module-0.6.9-4.fc14.i686
PackageKit-yum-0.6.9-4.fc14.i686
PackageKit-yum-plugin-0.6.9-4.fc14.i686

I am reporting this problem against
$ rpm -q -f /usr/libexec/pk-command-not-found
PackageKit-command-not-found-0.6.11-1.fc14.i686


How reproducible:

Once the effect starts, it is reproducible.
It is unclear how to get the effect to start

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

as above

Expected results:

PackageKit-command-not-found-0.6.9-4.fc14.i686

Additional info:


A claim is made that:
http://fedoraforum.org/forum/showthread.php?t=240982

# sed -i 's/SoftwareSourceSearch=true/SoftwareSourceSearch=false/' /etc/PackageKit/CommandNotFound.conf

That sounds like a swell workaround for those that need it.

Comment 1 Wendell Baker 2010-12-29 21:45:23 UTC
Created attachment 471109 [details]
exhibition on host1 with PackageKit-command-not-found-0.6.11-1.fc14.i686

Comment 2 Wendell Baker 2010-12-29 21:46:38 UTC
Created attachment 471110 [details]
a second exhibition on host1 with PackageKit-command-not-found-0.6.11-1.fc14.i686 with but also a comparison with host2 with PackageKit-command-not-found-0.6.9-4.fc14.i686

Comment 3 Richard Hughes 2011-01-04 12:37:03 UTC
commit 0414a053c0e4f0ec361e86f6a57d43cf5f5ad948
Author: Richard Hughes <richard>
Date:   Tue Jan 4 12:37:32 2011 +0000

    cnf: do not enable debugging unless VERBOSE is present in the environment. Fixes rh#666254

Comment 4 Richard Hughes 2011-01-04 18:24:27 UTC
*** Bug 666554 has been marked as a duplicate of this bug. ***

Comment 5 Fedora Update System 2011-02-01 15:10:46 UTC
PackageKit-0.6.12-2.fc14 has been submitted as an update for Fedora 14.
https://admin.fedoraproject.org/updates/PackageKit-0.6.12-2.fc14

Comment 6 Fedora Update System 2011-02-01 20:55:25 UTC
PackageKit-0.6.12-2.fc14 has been pushed to the Fedora 14 testing repository.  If problems still persist, please make note of it in this bug report.
 If you want to test the update, you can install it with 
 su -c 'yum --enablerepo=updates-testing update PackageKit'.  You can provide feedback for this update here: https://admin.fedoraproject.org/updates/PackageKit-0.6.12-2.fc14

Comment 7 Richard Hughes 2011-02-09 12:50:49 UTC
*** Bug 676299 has been marked as a duplicate of this bug. ***

Comment 8 Fedora Update System 2011-02-09 20:19:41 UTC
PackageKit-0.6.12-2.fc14 has been pushed to the Fedora 14 stable repository.  If problems still persist, please make note of it in this bug report.


Note You need to log in before you can comment on or make changes to this bug.