rendered paste bodybht-opensuse-vm:/home/boyd/projects/PackageKit/src # ./run-pk.sh zypp
packagekitd: no process killed
[pk_debug_init] pk-debug.c:136 (13:45:36): Verbose debugging enabled
[pk_conf_init] pk-conf.c:136 (13:45:36): using config file '../etc/PackageKit.conf'
[main] pk-main.c:214 (13:45:36): daemon shutdown set to 60 seconds
libnm_glib_nm_state_cb: dbus returned an error.
(org.freedesktop.DBus.Error.ServiceUnknown) The name org.freedesktop.NetworkManager was not provided by any .service files
[pk_security_init] pk-security-polkit.c:204 (13:45:36): Using PolicyKit security framework
[pk_transaction_db_init] pk-transaction-db.c:383 (13:45:36): trying to open database '/usr/local/var/lib/PackageKit/transactions.db'
[pk_engine_use_backend] pk-engine.c:162 (13:45:36): trying backend zypp
[pk_backend_load] pk-backend.c:164 (13:45:36): Trying to load : zypp
[pk_backend_build_library_path] pk-backend.c:140 (13:45:36): dlopening '../backends/zypp/.libs/libpk_backend_zypp.so'
[pk_engine_reset_timer] pk-engine.c:184 (13:45:36): reset timer
[pk_backend_finalize] pk-backend.c:1893 (13:45:36): freeing zypp (0x97e1800)
[pk_inhibit_remove] pk-inhibit.c:201 (13:45:36): cannot find item 0x97e1800
[pk_engine_get_tid] pk-engine.c:824 (13:45:46): GetTid method called
[pk_strnumber] pk-common.c:169 (13:45:46): not a number '
' in text!
*** WARNING ***
[pk_transaction_id_load_job_count] pk-transaction-id.c:77 (13:45:46): failed to convert
[pk_transaction_id_load_job_count] pk-transaction-id.c:86 (13:45:46): job=0
[pk_transaction_id_save_job_count] pk-transaction-id.c:100 (13:45:46): saving 1
[pk_engine_get_tid] pk-engine.c:827 (13:45:46): sending tid: '0;bbaebdad;data'
[pk_engine_resolve] pk-engine.c:1334 (13:45:46): Resolve method called: 0;bbaebdad;data, ~installed, lynx
[pk_backend_load] pk-backend.c:164 (13:45:46): Trying to load : zypp
[pk_backend_build_library_path] pk-backend.c:140 (13:45:46): dlopening '../backends/zypp/.libs/libpk_backend_zypp.so'
[pk_engine_reset_timer] pk-engine.c:184 (13:45:46): reset timer
[pk_backend_set_dbus_name] pk-backend.c:1849 (13:45:46): assiging :1.141 to 0x97e18a8
*** WARNING ***
[pk_backend_connection_changed_cb] pk-backend.c:1871 (13:45:46): client disconnected.... 1
[pk_engine_caller_active_changed_cb] pk-engine.c:651 (13:45:46): emitting caller-active-changed tid:0;bbaebdad;data, 0
[pk_backend_set_role] pk-backend.c:748 (13:45:46): setting role to resolve
[pk_transaction_list_commit] pk-transaction-list.c:258 (13:45:46): marking transaction 0;bbaebdad;data as committed
[pk_transaction_list_commit] pk-transaction-list.c:262 (13:45:46): emmitting ::changed
[pk_transaction_list_get_array] pk-transaction-list.c:320 (13:45:46): 1 active transactions
[pk_engine_transaction_list_changed_cb] pk-engine.c:201 (13:45:46): emitting transaction-list-changed
[pk_engine_reset_timer] pk-engine.c:184 (13:45:46): reset timer
[pk_transaction_list_commit] pk-transaction-list.c:291 (13:45:46): running 0;bbaebdad;data
[pk_thread_list_create] pk-thread-list.c:101 (13:45:46): created thread 0x9802da8
[pk_backend_thread_helper] pk-backend.c:247 (13:45:46): waiting for all threads in this backend
[pk_thread_list_wait] pk-thread-list.c:123 (13:45:46): joining thread 0x9802da8
[pk_thread_list_item_new] pk-thread-list.c:72 (13:45:46): running 0xb7f75b20
[pk_backend_change_status] pk-backend.c:771 (13:45:46): emiting transaction-status-changed 2
[pk_engine_transaction_status_changed_cb] pk-engine.c:237 (13:45:46): emitting transaction-status-changed tid:0;bbaebdad;data, 'query'
[pk_engine_reset_timer] pk-engine.c:184 (13:45:46): reset timer
[pk_backend_package] pk-backend.c:809 (13:45:46): emit package 1, lynx;2.8.6-61;i586;Factory, description generated by zypp backend
[pk_package_list_add] pk-package-list.c:67 (13:45:46): adding to cache array package 1, lynx;2.8.6-61;i586;Factory, description generated by zypp backend
[pk_engine_package_cb] pk-engine.c:308 (13:45:46): emitting package tid:0;bbaebdad;data info=available lynx;2.8.6-61;i586;Factory, description generated by zypp backend
[pk_engine_reset_timer] pk-engine.c:184 (13:45:46): reset timer
[pk_thread_list_item_new] pk-thread-list.c:74 (13:45:46): finished 0xb7f75b20, ret is 1
[pk_backend_finished] pk-backend.c:1083 (13:45:46): finished role resolve
[pk_inhibit_remove] pk-inhibit.c:201 (13:45:46): cannot find item 0x97e18a8
[pk_backend_finished] pk-backend.c:1136 (13:45:46): adding finished 0x97e18a8 to timeout loop
[pk_inhibit_lock] pk-inhibit.c:86 (13:45:46): Trying to AcquireInterfaceLock
[pk_inhibit_lock] pk-inhibit.c:108 (13:45:46): emit lock 1
[pk_engine_inhibit_locked_cb] pk-engine.c:214 (13:45:46): emitting locked 1
[pk_backend_finished_delay] pk-backend.c:1065 (13:45:46): emit finished 0
[pk_engine_finish_invalidate_caches] pk-engine.c:511 (13:45:46): invalidating caches
[pk_transaction_db_sql_statement] pk-transaction-db.c:195 (13:45:46): statement=UPDATE transactions SET data = "available lynx;2.8.6-61;i586;Factory description generated by zypp backend" WHERE transaction_id = '0;bbaebdad;data'
[pk_engine_finished_cb] pk-engine.c:602 (13:45:46): backend was running for 93 ms
[pk_transaction_db_sql_statement] pk-transaction-db.c:195 (13:45:46): statement=UPDATE transactions SET succeeded = 1, duration = 93 WHERE transaction_id = '0;bbaebdad;data'
[pk_engine_finished_cb] pk-engine.c:606 (13:45:46): emitting finished transaction:0;bbaebdad;data, 'success', 93
[pk_engine_reset_timer] pk-engine.c:184 (13:45:46): reset timer
[pk_transaction_list_backend_finished_cb] pk-transaction-list.c:191 (13:45:46): transaction 0;bbaebdad;data completed, marking finished
[pk_transaction_list_backend_finished_cb] pk-transaction-list.c:195 (13:45:46): emmitting ::changed
[pk_transaction_list_get_array] pk-transaction-list.c:320 (13:45:46): 1 active transactions
[pk_engine_transaction_list_changed_cb] pk-engine.c:201 (13:45:46): emitting transaction-list-changed
[pk_engine_reset_timer] pk-engine.c:184 (13:45:46): reset timer
[pk_engine_get_tid] pk-engine.c:824 (13:45:46): GetTid method called
[pk_transaction_id_load_job_count] pk-transaction-id.c:86 (13:45:46): job=1
[pk_transaction_id_save_job_count] pk-transaction-id.c:100 (13:45:46): saving 2
[pk_engine_get_tid] pk-engine.c:827 (13:45:46): sending tid: '1;cdddedaa;data'
[pk_engine_install_package] pk-engine.c:1872 (13:45:46): method called: 1;cdddedaa;data, lynx;2.8.6-61;i586;Factory
[pk_security_can_do_action] pk-security-polkit.c:75 (13:45:46): using caller :1.141
[pk_security_can_do_action] pk-security-polkit.c:88 (13:45:46): PolicyKit result = 'auth_admin_keep_always'
[pk_engine_install_package] pk-engine.c:1872 (13:45:48): method called: 1;cdddedaa;data, lynx;2.8.6-61;i586;Factory
[pk_security_can_do_action] pk-security-polkit.c:75 (13:45:48): using caller :1.141
[pk_security_can_do_action] pk-security-polkit.c:88 (13:45:48): PolicyKit result = 'yes'
[pk_backend_load] pk-backend.c:164 (13:45:48): Trying to load : zypp
[pk_backend_build_library_path] pk-backend.c:140 (13:45:48): dlopening '../backends/zypp/.libs/libpk_backend_zypp.so'
[pk_engine_reset_timer] pk-engine.c:184 (13:45:48): reset timer
[pk_backend_set_dbus_name] pk-backend.c:1849 (13:45:48): assiging :1.141 to 0x97e1950
*** WARNING ***
[pk_backend_connection_changed_cb] pk-backend.c:1871 (13:45:48): client disconnected.... 1
[pk_engine_caller_active_changed_cb] pk-engine.c:651 (13:45:48): emitting caller-active-changed tid:1;cdddedaa;data, 0
[pk_backend_set_role] pk-backend.c:748 (13:45:48): setting role to install-package
[pk_transaction_list_commit] pk-transaction-list.c:258 (13:45:48): marking transaction 1;cdddedaa;data as committed
[pk_transaction_list_commit] pk-transaction-list.c:262 (13:45:48): emmitting ::changed
[pk_transaction_list_get_array] pk-transaction-list.c:320 (13:45:48): 2 active transactions
[pk_engine_transaction_list_changed_cb] pk-engine.c:201 (13:45:48): emitting transaction-list-changed
[pk_engine_reset_timer] pk-engine.c:184 (13:45:48): reset timer
[pk_transaction_list_commit] pk-transaction-list.c:291 (13:45:48): running 1;cdddedaa;data
Enter backend_resolve - filter:~installed, package_id:lynx
about to return package_id of:lynx;2.8.6-61;i586;Factory
[pk_thread_list_create] pk-thread-list.c:101 (13:45:48): created thread 0x98032e0
[pk_backend_thread_helper] pk-backend.c:247 (13:45:48): waiting for all threads in this backend
[pk_thread_list_wait] pk-thread-list.c:123 (13:45:48): joining thread 0x98032e0
[pk_thread_list_item_new] pk-thread-list.c:72 (13:45:48): running 0xb7f76ea0
[pk_backend_change_status] pk-backend.c:771 (13:45:48): emiting transaction-status-changed 2
[pk_engine_transaction_status_changed_cb] pk-engine.c:237 (13:45:48): emitting transaction-status-changed tid:1;cdddedaa;data, 'query'
[pk_engine_reset_timer] pk-engine.c:184 (13:45:48): reset timer
[pk_backend_change_status] pk-backend.c:771 (13:45:50): emiting transaction-status-changed 1
[pk_engine_transaction_status_changed_cb] pk-engine.c:237 (13:45:50): emitting transaction-status-changed tid:1;cdddedaa;data, 'wait'
[pk_engine_reset_timer] pk-engine.c:184 (13:45:50): reset timer
[pk_backend_change_status] pk-backend.c:771 (13:45:53): emiting transaction-status-changed 11
[pk_engine_transaction_status_changed_cb] pk-engine.c:237 (13:45:53): emitting transaction-status-changed tid:1;cdddedaa;data, 'dep-resolve'
[pk_engine_reset_timer] pk-engine.c:184 (13:45:53): reset timer
[pk_backend_change_status] pk-backend.c:771 (13:45:53): emiting transaction-status-changed 13
[pk_engine_transaction_status_changed_cb] pk-engine.c:237 (13:45:53): emitting transaction-status-changed tid:1;cdddedaa;data, 'commit'
[pk_engine_reset_timer] pk-engine.c:184 (13:45:53): reset timer
[pk_backend_change_status] pk-backend.c:771 (13:45:53): emiting transaction-status-changed 7
[pk_engine_transaction_status_changed_cb] pk-engine.c:237 (13:45:53): emitting transaction-status-changed tid:1;cdddedaa;data, 'install'
[pk_engine_reset_timer] pk-engine.c:184 (13:45:53): reset timer
[pk_backend_package] pk-backend.c:809 (13:45:53): emit package 9, lynx;2.8.6-61;i586;Factory, TODO: Put the package summary here
[pk_package_list_add] pk-package-list.c:67 (13:45:53): adding to cache array package 9, lynx;2.8.6-61;i586;Factory, TODO: Put the package summary here
[pk_engine_package_cb] pk-engine.c:308 (13:45:53): emitting package tid:1;cdddedaa;data info=installing lynx;2.8.6-61;i586;Factory, TODO: Put the package summary here
[pk_engine_reset_timer] pk-engine.c:184 (13:45:53): reset timer
[pk_backend_package] pk-backend.c:809 (13:46:08): emit package 0, lynx;2.8.6-61;i586;Factory, TODO: Put the package summary here
[pk_thread_list_item_new] pk-thread-list.c:74 (13:46:08): finished 0xb7f76ea0, ret is 1
[pk_backend_finished] pk-backend.c:1083 (13:46:08): finished role install-package
[pk_inhibit_remove] pk-inhibit.c:201 (13:46:08): cannot find item 0x97e1950
[pk_backend_finished] pk-backend.c:1136 (13:46:08): adding finished 0x97e1950 to timeout loop
[pk_transaction_db_add] pk-transaction-db.c:242 (13:46:08): adding transaction 1;cdddedaa;data
[pk_transaction_db_add] pk-transaction-db.c:247 (13:46:08): timespec=2007-11-16T20:46:08Z
[pk_transaction_db_sql_statement] pk-transaction-db.c:195 (13:46:08): statement=INSERT INTO transactions (transaction_id, timespec) VALUES ('1;cdddedaa;data', '2007-11-16T20:46:08Z')
[pk_transaction_db_sql_statement] pk-transaction-db.c:195 (13:46:08): statement=UPDATE transactions SET role = 'install-package' WHERE transaction_id = '1;cdddedaa;data'
[pk_transaction_list_remove_item_timeout] pk-transaction-list.c:159 (13:46:08): transaction 0;bbaebdad;data completed, removing
[pk_backend_finalize] pk-backend.c:1893 (13:46:08): freeing zypp (0x97e18a8)
[pk_backend_finished_delay] pk-backend.c:1065 (13:46:08): emit finished 0
[pk_engine_finish_invalidate_caches] pk-engine.c:511 (13:46:08): invalidating caches
[pk_transaction_db_sql_statement] pk-transaction-db.c:195 (13:46:08): statement=UPDATE transactions SET data = "installing lynx;2.8.6-61;i586;Factory TODO: Put the package summary here" WHERE transaction_id = '1;cdddedaa;data'
[pk_engine_finished_cb] pk-engine.c:602 (13:46:08): backend was running for 20372 ms
[pk_transaction_db_sql_statement] pk-transaction-db.c:195 (13:46:08): statement=UPDATE transactions SET succeeded = 1, duration = 20372 WHERE transaction_id = '1;cdddedaa;data'
[pk_engine_finished_cb] pk-engine.c:606 (13:46:08): emitting finished transaction:1;cdddedaa;data, 'success', 20372
[pk_engine_reset_timer] pk-engine.c:184 (13:46:08): reset timer
[pk_transaction_list_backend_finished_cb] pk-transaction-list.c:191 (13:46:08): transaction 1;cdddedaa;data completed, marking finished
[pk_transaction_list_backend_finished_cb] pk-transaction-list.c:195 (13:46:08): emmitting ::changed
[pk_transaction_list_get_array] pk-transaction-list.c:320 (13:46:08): 1 active transactions
[pk_engine_transaction_list_changed_cb] pk-engine.c:201 (13:46:08): emitting transaction-list-changed
[pk_engine_reset_timer] pk-engine.c:184 (13:46:08): reset timer
[pk_engine_get_role] pk-engine.c:2386 (13:46:08): GetRole method called: 1;cdddedaa;data
[pk_engine_get_status] pk-engine.c:2358 (13:46:08): GetStatus method called: 1;cdddedaa;data
[pk_engine_get_progress] pk-engine.c:2422 (13:46:08): GetProgress method called: 1;cdddedaa;data
[pk_engine_get_package] pk-engine.c:2452 (13:46:08): GetPackage method called: 1;cdddedaa;data
[pk_transaction_list_remove_item_timeout] pk-transaction-list.c:159 (13:46:14): transaction 1;cdddedaa;data completed, removing
[pk_backend_finalize] pk-backend.c:1893 (13:46:14): freeing zypp (0x97e1950)
package_id is lynx;2.8.6-61;i586;Factory
WOOT! Marking the package to be installed!
Resolving dependencies...
Performing installation...
Finished the installation.
[pk_inhibit_unlock] pk-inhibit.c:127 (13:46:14): Trying to ReleaseInterfaceLock
[pk_inhibit_unlock] pk-inhibit.c:149 (13:46:14): emit lock 0
[pk_engine_inhibit_locked_cb] pk-engine.c:214 (13:46:14): emitting locked 0