[packagekit] Installing and removing packages always failes

Fri Oct 19 18:26:25 PDT 2007

Hi.
Sorry for the long time I off. I'm learning and practicing for my
driver's license and therefore am rather bussy (I'm looking forward to
my holidays starting the week after next though)... and ohh! Congrats on
the 0.1 release :)
I hope I can implement some of the new functions this weekend.
So here's my problem:
When I try to remove or install a package I immediately get an error
dialogue box (pk-application). No matter whether I'm using the dummy or
the alpm backend the according function doesn't even get called. And
there is no usefull debug output. I have attached the messages anyway. I
know It's rather unlikely you can guess the problem, but maybe you can
give me some hints what i should check on my system? I start packagekitd
and pk-application as root. Searching works for both backends.
ck-list-sessions shows my root gnome session. Any ideas before I must
dive into the code?

Andreas

-------------- next part --------------
[pk_debug_init] pk-debug.c:140 (18:03:55):       Verbose debugging enabled
[pk_conf_init] pk-conf.c:129 (18:03:55):         config file not found '../etc/PackageKit.conf'
[pk_conf_init] pk-conf.c:136 (18:03:55):         using config file '/etc/PackageKit/PackageKit.conf'
[main] pk-main.c:214 (18:03:55):         daemon shutdown set to 60 seconds
[main] pk-main.c:218 (18:03:55):         using default backend dummy
[New Thread -1212589168 (LWP 18644)]
[pk_transaction_db_init] pk-transaction-db.c:372 (18:03:55):     trying to open database '/usr/var/lib/PackageKit/transactions.db'
[New Thread -1220981872 (LWP 18645)]
[New Thread -1229374576 (LWP 18646)]
[Thread -1220981872 (LWP 18645) exited]
[Thread -1229374576 (LWP 18646) exited]
[pk_engine_use_backend] pk-engine.c:163 (18:03:55):      trying backend dummy
[pk_backend_load] pk-backend.c:156 (18:03:55):   Trying to load : dummy
[pk_backend_build_library_path] pk-backend.c:132 (18:03:55):     dlopening '/usr/lib/packagekit-backend/libpk_backend_dummy.so'
[pk_engine_reset_timer] pk-engine.c:185 (18:03:55):      reset timer
[pk_backend_finalize] pk-backend.c:1638 (18:03:55):      freeing dummy (0x8077800)
[pk_inhibit_remove] pk-inhibit.c:201 (18:03:55):         cannot find item 0x8077800
[pk_engine_get_transaction_list] pk-engine.c:2100 (18:03:55):    getting transaction list
[pk_transaction_list_get_array] pk-transaction-list.c:271 (18:03:55):    0 active transactions
[pk_engine_get_transaction_list] pk-engine.c:2100 (18:03:55):    getting transaction list
[pk_transaction_list_get_array] pk-transaction-list.c:271 (18:03:55):    0 active transactions
[pk_engine_get_seconds_idle] pk-engine.c:2412 (18:04:01):        engine idle=5
[pk_main_timeout_check_cb] pk-main.c:121 (18:04:01):     idle is 5
[pk_engine_get_seconds_idle] pk-engine.c:2412 (18:04:06):        engine idle=10
[pk_main_timeout_check_cb] pk-main.c:121 (18:04:06):     idle is 10
[pk_engine_get_seconds_idle] pk-engine.c:2412 (18:04:11):        engine idle=15
[pk_main_timeout_check_cb] pk-main.c:121 (18:04:11):     idle is 15
[pk_engine_get_seconds_idle] pk-engine.c:2412 (18:04:16):        engine idle=20
[pk_main_timeout_check_cb] pk-main.c:121 (18:04:16):     idle is 20
[pk_transaction_id_load_job_count] pk-transaction-id.c:83 (18:04:19):    job=7
[pk_transaction_id_save_job_count] pk-transaction-id.c:97 (18:04:19):    saving 8
[pk_engine_get_tid] pk-engine.c:783 (18:04:19):  sending tid: '7;ceaeaedd;data'
[pk_backend_load] pk-backend.c:156 (18:04:19):   Trying to load : dummy
[pk_backend_build_library_path] pk-backend.c:132 (18:04:19):     dlopening '/usr/lib/packagekit-backend/libpk_backend_dummy.so'
[pk_engine_reset_timer] pk-engine.c:185 (18:04:19):      reset timer
[pk_backend_set_role] pk-backend.c:649 (18:04:19):       setting role to search-group
[pk_transaction_list_commit] pk-transaction-list.c:209 (18:04:19):       marking transaction 7;ceaeaedd;data as committed
[pk_transaction_list_commit] pk-transaction-list.c:213 (18:04:19):       emmitting ::changed
[pk_transaction_list_get_array] pk-transaction-list.c:271 (18:04:19):    1 active transactions
[pk_engine_transaction_list_changed_cb] pk-engine.c:202 (18:04:19):      emitting transaction-list-changed
[pk_engine_reset_timer] pk-engine.c:185 (18:04:19):      reset timer
[pk_transaction_list_commit] pk-transaction-list.c:233 (18:04:19):       running 7;ceaeaedd;data
[pk_backend_package] pk-backend.c:683 (18:04:19):        emit package 1, vips-doc;7.12.4-2.fc8;noarch;linva, The vips documentation package.
[pk_package_list_add] pk-package-list.c:66 (18:04:19):   adding to cache array package 1, vips-doc;7.12.4-2.fc8;noarch;linva, The vips documentation package.
[pk_engine_package_cb] pk-engine.c:347 (18:04:19):       emitting package tid:7;ceaeaedd;data info=available vips-doc;7.12.4-2.fc8;noarch;linva, The vips documentation package.
[pk_engine_reset_timer] pk-engine.c:185 (18:04:19):      reset timer
[pk_inhibit_remove] pk-inhibit.c:201 (18:04:19):         cannot find item 0x8077898
[pk_backend_finished] pk-backend.c:961 (18:04:19):       adding finished 0x8077898 to timeout loop
[pk_inhibit_lock] pk-inhibit.c:86 (18:04:19):    Trying to AcquireInterfaceLock
[pk_inhibit_lock] pk-inhibit.c:108 (18:04:19):   emit lock 1
[pk_engine_inhibit_locked_cb] pk-engine.c:215 (18:04:19):        emitting locked 1
[pk_backend_finished_delay] pk-backend.c:924 (18:04:19):         emit finished 0
[pk_transaction_db_sql_statement] pk-transaction-db.c:185 (18:04:19):    statement=UPDATE transactions SET data = "availablevips-doc;7.12.4-2.fc8;noarch;linva      The vips documentation package." WHERE transaction_id = '7;ceaeaedd;data'
[pk_engine_finished_cb] pk-engine.c:573 (18:04:19):      backend was running for 0.113660 seconds
[pk_transaction_db_sql_statement] pk-transaction-db.c:185 (18:04:19):    statement=UPDATE transactions SET succeeded = 1, duration = 0 WHERE transaction_id = '7;ceaeaedd;data'
[pk_engine_finished_cb] pk-engine.c:584 (18:04:19):      emitting finished transaction:7;ceaeaedd;data, 'success', 0
[pk_engine_reset_timer] pk-engine.c:185 (18:04:19):      reset timer
[pk_transaction_list_backend_finished_cb] pk-transaction-list.c:156 (18:04:19):  transaction 7;ceaeaedd;data completed, removing
[pk_transaction_list_remove] pk-transaction-list.c:133 (18:04:19):       emmitting ::changed
[pk_transaction_list_get_array] pk-transaction-list.c:271 (18:04:19):    0 active transactions
[pk_engine_transaction_list_changed_cb] pk-engine.c:202 (18:04:19):      emitting transaction-list-changed
[pk_engine_reset_timer] pk-engine.c:185 (18:04:19):      reset timer
[pk_backend_finalize] pk-backend.c:1638 (18:04:19):      freeing dummy (0x8077898)
[pk_inhibit_unlock] pk-inhibit.c:127 (18:04:19):         Trying to ReleaseInterfaceLock
[pk_inhibit_unlock] pk-inhibit.c:149 (18:04:19):         emit lock 0
[pk_engine_inhibit_locked_cb] pk-engine.c:215 (18:04:19):        emitting locked 0
[pk_engine_get_seconds_idle] pk-engine.c:2412 (18:04:21):        engine idle=1
[pk_main_timeout_check_cb] pk-main.c:121 (18:04:21):     idle is 1
[pk_transaction_id_load_job_count] pk-transaction-id.c:83 (18:04:23):    job=8
[pk_transaction_id_save_job_count] pk-transaction-id.c:97 (18:04:23):    saving 9
[pk_engine_get_tid] pk-engine.c:783 (18:04:23):  sending tid: '8;baaabbbb;data'
[pk_backend_load] pk-backend.c:156 (18:04:23):   Trying to load : dummy
[pk_backend_build_library_path] pk-backend.c:132 (18:04:23):     dlopening '/usr/lib/packagekit-backend/libpk_backend_dummy.so'
[pk_engine_reset_timer] pk-engine.c:185 (18:04:23):      reset timer
[pk_backend_set_role] pk-backend.c:649 (18:04:23):       setting role to get-description
[pk_transaction_list_commit] pk-transaction-list.c:209 (18:04:23):       marking transaction 8;baaabbbb;data as committed
[pk_transaction_list_commit] pk-transaction-list.c:213 (18:04:23):       emmitting ::changed
[pk_transaction_list_get_array] pk-transaction-list.c:271 (18:04:23):    1 active transactions
[pk_engine_transaction_list_changed_cb] pk-engine.c:202 (18:04:23):      emitting transaction-list-changed
[pk_engine_reset_timer] pk-engine.c:185 (18:04:23):      reset timer
[pk_transaction_list_commit] pk-transaction-list.c:242 (18:04:23):       running 8;baaabbbb;data
[pk_backend_description] pk-backend.c:801 (18:04:23):    emit description gnome-power-manager;2.6.19;i386;fedora, GPL2, 8, Scribus is an desktop open source page layout program with the aim of producing commercial grade output in PDF and Postscript, primarily, though not exclusively for Linux.

While the goals of the program are for ease of use and simple easy to understand tools, Scribus offers support for professional publishing features, such as CMYK color, easy PDF creation, Encapsulated Postscript import/export and creation of color separations., http://live.gnome.org/GnomePowerManager, 11214665, /usr/share/man/man1;/usr/share/man/man1/gnome-power-manager.1.gz
[pk_engine_description_cb] pk-engine.c:493 (18:04:23):   emitting description tid:8;baaabbbb;data, gnome-power-manager;2.6.19;i386;fedora, GPL2, programming, Scribus is an desktop open source page layout program with the aim of producing commercial grade output in PDF and Postscript, primarily, though not exclusively for Linux.

While the goals of the program are for ease of use and simple easy to understand tools, Scribus offers support for professional publishing features, such as CMYK color, easy PDF creation, Encapsulated Postscript import/export and creation of color separations., http://live.gnome.org/GnomePowerManager, 11214665, /usr/share/man/man1;/usr/share/man/man1/gnome-power-manager.1.gz
[pk_inhibit_remove] pk-inhibit.c:201 (18:04:23):         cannot find item 0x8077930
[pk_backend_finished] pk-backend.c:961 (18:04:23):       adding finished 0x8077930 to timeout loop
[pk_inhibit_lock] pk-inhibit.c:86 (18:04:23):    Trying to AcquireInterfaceLock
[pk_inhibit_lock] pk-inhibit.c:108 (18:04:23):   emit lock 1
[pk_engine_inhibit_locked_cb] pk-engine.c:215 (18:04:23):        emitting locked 1
[pk_backend_finished_delay] pk-backend.c:924 (18:04:23):         emit finished 0
[pk_engine_finished_cb] pk-engine.c:573 (18:04:23):      backend was running for 0.065424 seconds
[pk_transaction_db_sql_statement] pk-transaction-db.c:185 (18:04:23):    statement=UPDATE transactions SET succeeded = 1, duration = 0 WHERE transaction_id = '8;baaabbbb;data'
[pk_engine_finished_cb] pk-engine.c:584 (18:04:23):      emitting finished transaction:8;baaabbbb;data, 'success', 0
[pk_engine_reset_timer] pk-engine.c:185 (18:04:23):      reset timer
[pk_transaction_list_backend_finished_cb] pk-transaction-list.c:156 (18:04:23):  transaction 8;baaabbbb;data completed, removing
[pk_transaction_list_remove] pk-transaction-list.c:133 (18:04:23):       emmitting ::changed
[pk_transaction_list_get_array] pk-transaction-list.c:271 (18:04:23):    0 active transactions
[pk_engine_transaction_list_changed_cb] pk-engine.c:202 (18:04:23):      emitting transaction-list-changed
[pk_engine_reset_timer] pk-engine.c:185 (18:04:23):      reset timer
[pk_backend_finalize] pk-backend.c:1638 (18:04:23):      freeing dummy (0x8077930)
[pk_inhibit_unlock] pk-inhibit.c:127 (18:04:23):         Trying to ReleaseInterfaceLock
[pk_inhibit_unlock] pk-inhibit.c:149 (18:04:23):         emit lock 0
[pk_engine_inhibit_locked_cb] pk-engine.c:215 (18:04:23):        emitting locked 0
[pk_transaction_id_load_job_count] pk-transaction-id.c:83 (18:04:25):    job=9
[pk_transaction_id_save_job_count] pk-transaction-id.c:97 (18:04:25):    saving 10
[pk_engine_get_tid] pk-engine.c:783 (18:04:25):  sending tid: '9;acdaeedd;data'
[pk_engine_can_do_action] pk-engine.c:804 (18:04:25):    using caller :1.111
[pk_engine_can_do_action] pk-engine.c:815 (18:04:25):    PolicyKit result = 'auth_admin_keep_always'
[pk_engine_get_seconds_idle] pk-engine.c:2407 (18:04:26):        engine idle zero as 1 transactions in progress
[pk_main_timeout_check_cb] pk-main.c:121 (18:04:26):     idle is 0
[pk_engine_get_seconds_idle] pk-engine.c:2407 (18:04:31):        engine idle zero as 1 transactions in progress
[pk_main_timeout_check_cb] pk-main.c:121 (18:04:31):     idle is 0
[pk_engine_get_seconds_idle] pk-engine.c:2407 (18:04:36):        engine idle zero as 1 transactions in progress
[pk_main_timeout_check_cb] pk-main.c:121 (18:04:36):     idle is 0
[pk_engine_get_seconds_idle] pk-engine.c:2407 (18:04:41):        engine idle zero as 1 transactions in progress
[pk_main_timeout_check_cb] pk-main.c:121 (18:04:41):     idle is 0
[pk_engine_get_seconds_idle] pk-engine.c:2407 (18:04:46):        engine idle zero as 1 transactions in progress
[pk_main_timeout_check_cb] pk-main.c:121 (18:04:46):     idle is 0
[pk_engine_get_seconds_idle] pk-engine.c:2407 (18:04:51):        engine idle zero as 1 transactions in progress
[pk_main_timeout_check_cb] pk-main.c:121 (18:04:51):     idle is 0
[pk_engine_get_seconds_idle] pk-engine.c:2407 (18:04:56):        engine idle zero as 1 transactions in progress
[pk_main_timeout_check_cb] pk-main.c:121 (18:04:56):     idle is 0
[pk_engine_get_seconds_idle] pk-engine.c:2407 (18:05:01):        engine idle zero as 1 transactions in progress
[pk_main_timeout_check_cb] pk-main.c:121 (18:05:01):     idle is 0
[pk_engine_get_seconds_idle] pk-engine.c:2407 (18:05:06):        engine idle zero as 1 transactions in progress
[pk_main_timeout_check_cb] pk-main.c:121 (18:05:06):     idle is 0

              ....and so on, the transaction will never finishes