bht-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