Attachment 309102 Details for Bug 450931 – Output of /usr/sbin/packagekitd --verbose > pkd.out &

Output of /usr/sbin/packagekitd --verbose > pkd.out &

pkd.out (text/plain), 24.86 KB, created by Nicola Soranzo on 2008-06-12 17:01:34 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Nicola Soranzo

Created: 2008-06-12 17:01:34 UTC

Size: 24.86 KB

patch

obsolete

>TI:18:54:13	TH:0x8751458	FI:pk-debug.c	FN:pk_debug_init,248
> - Verbose debugging 1 (on console 0)
>TI:18:54:13	TH:0x8751458	FI:pk-conf.c	FN:pk_conf_init,187
> - using config file '/etc/PackageKit/PackageKit.conf'
>TI:18:54:13	TH:0x8751458	FI:pk-main.c	FN:main,239
> - Log all transactions: 1
>TI:18:54:13	TH:0x8751458	FI:pk-main.c	FN:main,244
> - daemon shutdown set to 300 seconds
>TI:18:54:13	TH:0x8751458	FI:pk-main.c	FN:main,248
> - using default backend yum
>TI:18:54:13	TH:0x8751458	FI:pk-backend.c	FN:pk_backend_new,1310
> - new object
>TI:18:54:13	TH:0x8751458	FI:pk-backend.c	FN:pk_backend_set_name,198
> - Trying to load : yum
>TI:18:54:13	TH:0x8751458	FI:pk-backend.c	FN:pk_backend_build_library_path,172
> - dlopening '/usr/lib/packagekit-backend/libpk_backend_yum.so'
>TI:18:54:13	TH:0x8751458	FI:pk-backend.c	FN:pk_backend_new,1310
> - new object
>TI:18:54:13	TH:0x8751458	FI:pk-backend-yum.c	FN:backend_initialize,38
> - FILTER: initialize
>TI:18:54:13	TH:0x8751458	FI:pk-network-nm.c	FN:pk_network_init,146
> - ctx=0x875d7a0, id=1
>TI:18:54:13	TH:0x8751458	FI:pk-backend.c	FN:pk_backend_new,1310
> - new object
>TI:18:54:13	TH:0x8751458	FI:pk-backend.c	FN:pk_backend_new,1310
> - new object
>TI:18:54:13	TH:0x8751458	FI:pk-inhibit.c	FN:pk_inhibit_remove,198
> - cannot find item 0x8762000
>TI:18:54:13	TH:0x8751458	FI:pk-security-polkit.c	FN:pk_security_init,248
> - Using PolicyKit security framework
>TI:18:54:13	TH:0x8751458	FI:pk-restart-gio.c	FN:pk_restart_init,125
> - watching for changes: /etc/PackageKit/PackageKit.conf
>TI:18:54:13	TH:0x8751458	FI:pk-backend.c	FN:pk_backend_new,1310
> - new object
>TI:18:54:13	TH:0x8751458	FI:pk-transaction-db.c	FN:pk_transaction_db_init,498
> - trying to open database '/var/lib/PackageKit/transactions.db'
>TI:18:54:13	TH:0x8751458	FI:pk-common.c	FN:pk_iso8601_present,154
> - timespec=2008-06-12T16:54:13Z
>TI:18:54:18	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_get_seconds_idle,2844
> - engine idle=4
>TI:18:54:18	TH:0x8751458	FI:pk-main.c	FN:pk_main_timeout_check_cb,126
> - idle is 4
>TI:18:54:23	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_get_seconds_idle,2844
> - engine idle=9
>TI:18:54:23	TH:0x8751458	FI:pk-main.c	FN:pk_main_timeout_check_cb,126
> - idle is 9
>TI:18:54:28	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_get_seconds_idle,2844
> - engine idle=14
>TI:18:54:28	TH:0x8751458	FI:pk-main.c	FN:pk_main_timeout_check_cb,126
> - idle is 14
>TI:18:54:33	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_get_seconds_idle,2844
> - engine idle=19
>TI:18:54:33	TH:0x8751458	FI:pk-main.c	FN:pk_main_timeout_check_cb,126
> - idle is 19
>TI:18:54:35	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_get_transaction_list,2417
> - GetTransactionList method called
>TI:18:54:35	TH:0x8751458	FI:pk-transaction-list.c	FN:pk_transaction_list_get_array,311
> - 0 active transactions
>TI:18:54:35	TH:0x8751458	FI:pk-transaction-db.c	FN:pk_transaction_db_action_time_since,246
> - get_time_since_action=refresh-cache
>TI:18:54:35	TH:0x8751458	FI:pk-common.c	FN:pk_iso8601_difference,185
> - difference=12073
>TI:18:54:35	TH:0x8751458	FI:pk-transaction-db.c	FN:pk_transaction_db_action_time_since,263
> - timespec=2008-06-12T13:33:22Z, difference=12073
>TI:18:54:35	TH:0x8751458	FI:pk-transaction-db.c	FN:pk_transaction_db_action_time_since,246
> - get_time_since_action=update-system
>TI:18:54:35	TH:0x8751458	FI:pk-common.c	FN:pk_iso8601_difference,185
> - difference=363337
>TI:18:54:35	TH:0x8751458	FI:pk-transaction-db.c	FN:pk_transaction_db_action_time_since,263
> - timespec=2008-06-08T11:58:58Z, difference=363337
>TI:18:54:35	TH:0x8751458	FI:pk-transaction-db.c	FN:pk_transaction_db_action_time_since,246
> - get_time_since_action=update-package
>TI:18:54:35	TH:0x8751458	FI:pk-common.c	FN:pk_iso8601_difference,185
> - difference=27199
>TI:18:54:35	TH:0x8751458	FI:pk-transaction-db.c	FN:pk_transaction_db_action_time_since,263
> - timespec=2008-06-12T09:21:16Z, difference=27199
>TI:18:54:35	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_get_tid,759
> - GetTid method called
>TI:18:54:35	TH:0x8751458	FI:pk-transaction-id.c	FN:pk_transaction_id_load_job_count,86
> - job=29
>TI:18:54:35	TH:0x8751458	FI:pk-transaction-id.c	FN:pk_transaction_id_save_job_count,100
> - saving 30
>TI:18:54:35	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_get_tid,762
> - sending tid: '29;cddeccaa;data'
>TI:18:54:35	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_get_updates,901
> - GetUpdates method called: 29;cddeccaa;data
>TI:18:54:35	TH:0x8751458	FI:pk-backend.c	FN:pk_backend_new,1310
> - new object
>TI:18:54:35	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_reset_timer,183
> - reset timer
>TI:18:54:35	TH:0x8751458	FI:pk-runner.c	FN:pk_runner_set_dbus_name,923
> - assigning :1.3589 to 0x8762090
>TI:18:54:35	TH:0x8751458	FI:pk-transaction-list.c	FN:pk_transaction_list_commit,269
> - marking transaction 29;cddeccaa;data as committed
>TI:18:54:35	TH:0x8751458	FI:pk-transaction-list.c	FN:pk_transaction_list_commit,273
> - emmitting ::changed
>TI:18:54:35	TH:0x8751458	FI:pk-transaction-list.c	FN:pk_transaction_list_get_array,311
> - 1 active transactions
>TI:18:54:35	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_transaction_list_changed_cb,199
> - emitting transaction-list-changed
>TI:18:54:35	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_reset_timer,183
> - reset timer
>TI:18:54:35	TH:0x8751458	FI:pk-transaction-list.c	FN:pk_transaction_list_commit,278
> - running 29;cddeccaa;data
>TI:18:54:35	TH:0x8751458	FI:pk-backend.c	FN:pk_backend_set_current_tid,1138
> - setting backend tid as 29;cddeccaa;data
>TI:18:54:35	TH:0x8751458	FI:pk-backend.c	FN:pk_backend_set_role,941
> - setting role to get-updates
>TI:18:54:35	TH:0x8751458	FI:pk-backend.c	FN:pk_backend_set_status,512
> - emiting status-changed setup
>TI:18:54:35	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_status_changed_cb,233
> - emitting status-changed tid:29;cddeccaa;data, 'setup'
>TI:18:54:35	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_reset_timer,183
> - reset timer
>TI:18:54:35	TH:0x8751458	FI:pk-common.c	FN:pk_va_list_to_argv,720
> - number of strings=2
>TI:18:54:35	TH:0x8751458	FI:pk-backend-spawn.c	FN:pk_backend_spawn_helper_va_list,467
> - using spawn filename /usr/share/PackageKit/helpers/yum/get-updates.py
>TI:18:54:35	TH:0x8751458	FI:pk-backend-spawn.c	FN:pk_backend_spawn_helper_new,427
> - allocating spawn 0x875bd20
>TI:18:54:35	TH:0x8751458	FI:pk-spawn.c	FN:pk_spawn_argv,283
> - argv[0] '/usr/share/PackageKit/helpers/yum/get-updates.py'
>TI:18:54:35	TH:0x8751458	FI:pk-inhibit.c	FN:pk_inhibit_lock,84
> - Trying to AcquireInterfaceLock
>TI:18:54:35	TH:0x8751458	FI:pk-inhibit.c	FN:pk_inhibit_lock,106
> - emit lock 1
>TI:18:54:35	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_inhibit_locked_cb,211
> - emitting locked 1
>TI:18:54:35	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_get_role,2463
> - GetRole method called: 29;cddeccaa;data
>TI:18:54:35	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_get_status,2435
> - GetStatus method called: 29;cddeccaa;data
>TI:18:54:35	TH:0x8751458	FI:pk-spawn.c	FN:pk_spawn_emit_whole_lines,131
> - emitting stdout allow-cancel	true
>TI:18:54:35	TH:0x8751458	FI:pk-backend-spawn.c	FN:pk_backend_spawn_stdout_cb,407
> - stdout from 0x875bd20 = 'allow-cancel	true'
>TI:18:54:35	TH:0x8751458	FI:pk-backend.c	FN:pk_backend_set_allow_cancel,905
> - emit allow-cancel 1
>TI:18:54:35	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_allow_cancel_cb,625
> - emitting allow-interrpt tid:29;cddeccaa;data, 1
>TI:18:54:35	TH:0x8751458	FI:pk-inhibit.c	FN:pk_inhibit_unlock,124
> - Trying to ReleaseInterfaceLock
>TI:18:54:35	TH:0x8751458	FI:pk-inhibit.c	FN:pk_inhibit_unlock,146
> - emit lock 0
>TI:18:54:35	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_inhibit_locked_cb,211
> - emitting locked 0
>TI:18:54:35	TH:0x8751458	FI:pk-runner.c	FN:pk_runner_allow_cancel_cb,1083
> - AllowCancel now 1
>TI:18:54:35	TH:0x8751458	FI:pk-spawn.c	FN:pk_spawn_emit_whole_lines,131
> - emitting stdout no-percentage-updates
>TI:18:54:35	TH:0x8751458	FI:pk-backend-spawn.c	FN:pk_backend_spawn_stdout_cb,407
> - stdout from 0x875bd20 = 'no-percentage-updates'
>TI:18:54:35	TH:0x8751458	FI:pk-backend.c	FN:pk_backend_emit_progress_changed,319
> - emit progress 101, 101, 513, 0
>TI:18:54:35	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_progress_changed_cb,255
> - emitting percentage-changed tid:29;cddeccaa;data 101, 101, 513, 0
>TI:18:54:35	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_reset_timer,183
> - reset timer
>TI:18:54:35	TH:0x8751458	FI:pk-spawn.c	FN:pk_spawn_emit_whole_lines,131
> - emitting stdout status	info
>TI:18:54:35	TH:0x8751458	FI:pk-backend-spawn.c	FN:pk_backend_spawn_stdout_cb,407
> - stdout from 0x875bd20 = 'status	info'
>TI:18:54:35	TH:0x8751458	FI:pk-backend.c	FN:pk_backend_set_status,505
> - emiting status-changed running
>TI:18:54:35	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_status_changed_cb,233
> - emitting status-changed tid:29;cddeccaa;data, 'running'
>TI:18:54:35	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_reset_timer,183
> - reset timer
>TI:18:54:35	TH:0x8751458	FI:pk-backend.c	FN:pk_backend_set_status,512
> - emiting status-changed info
>TI:18:54:35	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_status_changed_cb,233
> - emitting status-changed tid:29;cddeccaa;data, 'info'
>TI:18:54:35	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_reset_timer,183
> - reset timer
>TI:18:54:38	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_get_seconds_idle,2832
> - engine idle zero as 1 transactions in progress
>TI:18:54:38	TH:0x8751458	FI:pk-main.c	FN:pk_main_timeout_check_cb,126
> - idle is 0
>TI:18:54:39	TH:0x8751458	FI:pk-spawn.c	FN:pk_spawn_emit_whole_lines,131
> - emitting stdout package	bugfix	file-roller;2.22.3-1.fc9;i386;updates	File Roller is a tool for viewing and creating archives
>TI:18:54:39	TH:0x8751458	FI:pk-backend-spawn.c	FN:pk_backend_spawn_stdout_cb,407
> - stdout from 0x875bd20 = 'package	bugfix	file-roller;2.22.3-1.fc9;i386;updates	File Roller is a tool for viewing and creating archives'
>TI:18:54:39	TH:0x8751458	FI:pk-backend.c	FN:pk_backend_package,564
> - emit package bugfix, file-roller;2.22.3-1.fc9;i386;updates, File Roller is a tool for viewing and creating archives
>TI:18:54:39	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_package_cb,279
> - emitting package tid:29;cddeccaa;data info=bugfix file-roller;2.22.3-1.fc9;i386;updates, File Roller is a tool for viewing and creating archives
>TI:18:54:39	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_reset_timer,183
> - reset timer
>TI:18:54:39	TH:0x8751458	FI:pk-package-list.c	FN:pk_package_list_add,80
> - adding to cache array package bugfix, file-roller;2.22.3-1.fc9;i386;updates, File Roller is a tool for viewing and creating archives
>TI:18:54:39	TH:0x8751458	FI:pk-runner.c	FN:pk_runner_package_cb,1021
> - caching package info=bugfix file-roller;2.22.3-1.fc9;i386;updates, File Roller is a tool for viewing and creating archives
>TI:18:54:39	TH:0x8751458	FI:pk-spawn.c	FN:pk_spawn_check_child,178
> - Running fork successful
>TI:18:54:39	TH:0x8751458	FI:pk-spawn.c	FN:pk_spawn_check_child,193
> - emitting finished 0
>TI:18:54:39	TH:0x8751458	FI:pk-backend-spawn.c	FN:pk_backend_spawn_finished_cb,380
> - deleting spawn 0x8752f90, exit success
>TI:18:54:39	TH:0x8751458	FI:pk-backend-spawn.c	FN:pk_backend_spawn_helper_delete,364
> - deleting spawn 0x875bd20
>TI:18:54:39	TH:0x8751458	FI:pk-backend.c	FN:pk_backend_finished,1023
> - finished role get-updates
>TI:18:54:39	TH:0x8751458	FI:pk-backend.c	FN:pk_backend_set_allow_cancel,905
> - emit allow-cancel 0
>TI:18:54:39	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_allow_cancel_cb,625
> - emitting allow-interrpt tid:29;cddeccaa;data, 0
>TI:18:54:39	TH:0x8751458	FI:pk-inhibit.c	FN:pk_inhibit_lock,84
> - Trying to AcquireInterfaceLock
>TI:18:54:39	TH:0x8751458	FI:pk-inhibit.c	FN:pk_inhibit_lock,106
> - emit lock 1
>TI:18:54:39	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_inhibit_locked_cb,211
> - emitting locked 1
>TI:18:54:39	TH:0x8751458	FI:pk-runner.c	FN:pk_runner_allow_cancel_cb,1083
> - AllowCancel now 0
>TI:18:54:39	TH:0x8751458	FI:pk-backend.c	FN:pk_backend_set_status,512
> - emiting status-changed finished
>TI:18:54:39	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_status_changed_cb,233
> - emitting status-changed tid:29;cddeccaa;data, 'finished'
>TI:18:54:39	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_reset_timer,183
> - reset timer
>TI:18:54:39	TH:0x8751458	FI:pk-backend.c	FN:pk_backend_finished,1073
> - adding finished 0x875b400 to timeout loop
>TI:18:54:39	TH:0x8751458	FI:pk-backend.c	FN:pk_backend_finished_delay,996
> - emit finished 0
>TI:18:54:39	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_finish_invalidate_caches,479
> - invalidating caches
>TI:18:54:39	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_finish_invalidate_caches,488
> - reffing updates cache
>TI:18:54:39	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_finished_cb,568
> - backend was running for 4116 ms
>TI:18:54:39	TH:0x8751458	FI:pk-common.c	FN:pk_iso8601_present,154
> - timespec=2008-06-12T16:54:39Z
>TI:18:54:39	TH:0x8751458	FI:pk-transaction-db.c	FN:pk_transaction_db_action_time_reset,286
> - reset action time=get-updates to 2008-06-12T16:54:39Z
>TI:18:54:39	TH:0x8751458	FI:pk-transaction-db.c	FN:pk_transaction_db_sql_statement,196
> - statement=UPDATE transactions SET succeeded = 1, duration = 4116 WHERE transaction_id = '29;cddeccaa;data'
>TI:18:54:39	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_finished_cb,602
> - emitting finished transaction:29;cddeccaa;data, 'success', 4116
>TI:18:54:39	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_reset_timer,183
> - reset timer
>TI:18:54:39	TH:0x8751458	FI:pk-transaction-list.c	FN:pk_transaction_list_backend_finished_cb,197
> - transaction 29;cddeccaa;data completed, marking finished
>TI:18:54:39	TH:0x8751458	FI:pk-transaction-list.c	FN:pk_transaction_list_backend_finished_cb,201
> - emmitting ::changed
>TI:18:54:39	TH:0x8751458	FI:pk-transaction-list.c	FN:pk_transaction_list_get_array,311
> - 1 active transactions
>TI:18:54:39	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_transaction_list_changed_cb,199
> - emitting transaction-list-changed
>TI:18:54:39	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_reset_timer,183
> - reset timer
>TI:18:54:39	TH:0x8751458	FI:pk-inhibit.c	FN:pk_inhibit_unlock,124
> - Trying to ReleaseInterfaceLock
>TI:18:54:39	TH:0x8751458	FI:pk-inhibit.c	FN:pk_inhibit_unlock,146
> - emit lock 0
>TI:18:54:39	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_inhibit_locked_cb,211
> - emitting locked 0
>TI:18:54:41	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_get_tid,759
> - GetTid method called
>TI:18:54:41	TH:0x8751458	FI:pk-transaction-id.c	FN:pk_transaction_id_load_job_count,86
> - job=30
>TI:18:54:41	TH:0x8751458	FI:pk-transaction-id.c	FN:pk_transaction_id_save_job_count,100
> - saving 31
>TI:18:54:41	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_get_tid,762
> - sending tid: '30;aaabdbba;data'
>TI:18:54:41	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_get_update_detail,1603
> - GetUpdateDetail method called: 30;aaabdbba;data, file-roller;2.22.3-1.fc9;i386;updates
>TI:18:54:41	TH:0x8751458	FI:pk-backend.c	FN:pk_backend_new,1310
> - new object
>TI:18:54:41	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_reset_timer,183
> - reset timer
>TI:18:54:41	TH:0x8751458	FI:pk-runner.c	FN:pk_runner_set_dbus_name,923
> - assigning :1.3589 to 0x8762120
>TI:18:54:41	TH:0x8751458	FI:pk-transaction-list.c	FN:pk_transaction_list_commit,269
> - marking transaction 30;aaabdbba;data as committed
>TI:18:54:41	TH:0x8751458	FI:pk-transaction-list.c	FN:pk_transaction_list_commit,273
> - emmitting ::changed
>TI:18:54:41	TH:0x8751458	FI:pk-transaction-list.c	FN:pk_transaction_list_get_array,311
> - 2 active transactions
>TI:18:54:41	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_transaction_list_changed_cb,199
> - emitting transaction-list-changed
>TI:18:54:41	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_reset_timer,183
> - reset timer
>TI:18:54:41	TH:0x8751458	FI:pk-transaction-list.c	FN:pk_transaction_list_commit,278
> - running 30;aaabdbba;data
>TI:18:54:41	TH:0x8751458	FI:pk-backend.c	FN:pk_backend_set_current_tid,1138
> - setting backend tid as 30;aaabdbba;data
>TI:18:54:41	TH:0x8751458	FI:pk-backend.c	FN:pk_backend_set_role,941
> - setting role to get-update-detail
>TI:18:54:41	TH:0x8751458	FI:pk-backend.c	FN:pk_backend_set_status,512
> - emiting status-changed setup
>TI:18:54:41	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_status_changed_cb,233
> - emitting status-changed tid:30;aaabdbba;data, 'setup'
>TI:18:54:41	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_reset_timer,183
> - reset timer
>TI:18:54:41	TH:0x8751458	FI:pk-runner.c	FN:pk_runner_tid_valid,972
> - Already finished, so it can't be us
>TI:18:54:41	TH:0x8751458	FI:pk-common.c	FN:pk_va_list_to_argv,720
> - number of strings=2
>TI:18:54:41	TH:0x8751458	FI:pk-backend-spawn.c	FN:pk_backend_spawn_helper_va_list,467
> - using spawn filename /usr/share/PackageKit/helpers/yum/get-update-detail.py
>TI:18:54:41	TH:0x8751458	FI:pk-backend-spawn.c	FN:pk_backend_spawn_helper_new,427
> - allocating spawn 0x875bd50
>TI:18:54:41	TH:0x8751458	FI:pk-spawn.c	FN:pk_spawn_argv,283
> - argv[0] '/usr/share/PackageKit/helpers/yum/get-update-detail.py'
>TI:18:54:41	TH:0x8751458	FI:pk-inhibit.c	FN:pk_inhibit_lock,84
> - Trying to AcquireInterfaceLock
>TI:18:54:41	TH:0x8751458	FI:pk-inhibit.c	FN:pk_inhibit_lock,106
> - emit lock 1
>TI:18:54:41	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_inhibit_locked_cb,211
> - emitting locked 1
>TI:18:54:41	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_get_role,2463
> - GetRole method called: 30;aaabdbba;data
>TI:18:54:41	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_get_status,2435
> - GetStatus method called: 30;aaabdbba;data
>TI:18:54:42	TH:0x8751458	FI:pk-spawn.c	FN:pk_spawn_emit_whole_lines,131
> - emitting stdout allow-cancel	true
>TI:18:54:42	TH:0x8751458	FI:pk-backend-spawn.c	FN:pk_backend_spawn_stdout_cb,407
> - stdout from 0x875bd50 = 'allow-cancel	true'
>TI:18:54:42	TH:0x8751458	FI:pk-backend.c	FN:pk_backend_set_allow_cancel,905
> - emit allow-cancel 1
>TI:18:54:42	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_allow_cancel_cb,625
> - emitting allow-interrpt tid:30;aaabdbba;data, 1
>TI:18:54:42	TH:0x8751458	FI:pk-inhibit.c	FN:pk_inhibit_remove,198
> - cannot find item 0x8762090
>TI:18:54:42	TH:0x8751458	FI:pk-runner.c	FN:pk_runner_allow_cancel_cb,1083
> - AllowCancel now 1
>TI:18:54:42	TH:0x8751458	FI:pk-inhibit.c	FN:pk_inhibit_unlock,124
> - Trying to ReleaseInterfaceLock
>TI:18:54:42	TH:0x8751458	FI:pk-inhibit.c	FN:pk_inhibit_unlock,146
> - emit lock 0
>TI:18:54:42	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_inhibit_locked_cb,211
> - emitting locked 0
>TI:18:54:42	TH:0x8751458	FI:pk-runner.c	FN:pk_runner_allow_cancel_cb,1083
> - AllowCancel now 1
>TI:18:54:42	TH:0x8751458	FI:pk-spawn.c	FN:pk_spawn_emit_whole_lines,131
> - emitting stdout no-percentage-updates
>TI:18:54:42	TH:0x8751458	FI:pk-backend-spawn.c	FN:pk_backend_spawn_stdout_cb,407
> - stdout from 0x875bd50 = 'no-percentage-updates'
>TI:18:54:42	TH:0x8751458	FI:pk-backend.c	FN:pk_backend_emit_progress_changed,319
> - emit progress 101, 101, 472, 0
>TI:18:54:42	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_progress_changed_cb,255
> - emitting percentage-changed tid:30;aaabdbba;data 101, 101, 472, 0
>TI:18:54:42	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_reset_timer,183
> - reset timer
>TI:18:54:42	TH:0x8751458	FI:pk-spawn.c	FN:pk_spawn_emit_whole_lines,131
> - emitting stdout status	info
>TI:18:54:42	TH:0x8751458	FI:pk-backend-spawn.c	FN:pk_backend_spawn_stdout_cb,407
> - stdout from 0x875bd50 = 'status	info'
>TI:18:54:42	TH:0x8751458	FI:pk-backend.c	FN:pk_backend_set_status,505
> - emiting status-changed running
>TI:18:54:42	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_status_changed_cb,233
> - emitting status-changed tid:30;aaabdbba;data, 'running'
>TI:18:54:42	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_reset_timer,183
> - reset timer
>TI:18:54:42	TH:0x8751458	FI:pk-runner.c	FN:pk_runner_tid_valid,972
> - Already finished, so it can't be us
>TI:18:54:42	TH:0x8751458	FI:pk-backend.c	FN:pk_backend_set_status,512
> - emiting status-changed info
>TI:18:54:42	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_status_changed_cb,233
> - emitting status-changed tid:30;aaabdbba;data, 'info'
>TI:18:54:42	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_reset_timer,183
> - reset timer
>TI:18:54:42	TH:0x8751458	FI:pk-runner.c	FN:pk_runner_tid_valid,972
> - Already finished, so it can't be us
>TI:18:54:43	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_get_seconds_idle,2832
> - engine idle zero as 2 transactions in progress
>TI:18:54:43	TH:0x8751458	FI:pk-main.c	FN:pk_main_timeout_check_cb,126
> - idle is 0
>TI:18:54:45	TH:0x8751458	FI:pk-transaction-list.c	FN:pk_transaction_list_remove_item_timeout,158
> - transaction 29;cddeccaa;data completed, removing
>TI:18:54:45	TH:0x8751458	FI:pk-inhibit.c	FN:pk_inhibit_remove,198
> - cannot find item 0x8762090
>*** WARNING ***
>TI:18:54:45	TH:0x8751458	FI:pk-spawn.c	FN:pk_spawn_emit_whole_lines,129
> - cannot covert line to UTF8: updatedetail	file-roller;2.22.3-1.fc9;i386;updates	file-roller;2.22.1-1.fc9;i386;installed					none	The latest stable upstream release of file-roller fixes a number of bugs:;; * Fixed bug #523158 â exclamation mark in RAR passwords; * Provide and install a 24x24 application icon to prevent a blurry launcher icon in the menu; * Fixed bug #480190 â files added to archive are wrongly placed in root
>TI:18:54:45	TH:0x8751458	FI:pk-spawn.c	FN:pk_spawn_check_child,178
> - Running fork successful
>TI:18:54:45	TH:0x8751458	FI:pk-spawn.c	FN:pk_spawn_check_child,193
> - emitting finished 0
>TI:18:54:45	TH:0x8751458	FI:pk-backend-spawn.c	FN:pk_backend_spawn_finished_cb,380
> - deleting spawn 0x8752f90, exit success
>TI:18:54:45	TH:0x8751458	FI:pk-backend-spawn.c	FN:pk_backend_spawn_helper_delete,364
> - deleting spawn 0x875bd50
>TI:18:54:45	TH:0x8751458	FI:pk-backend.c	FN:pk_backend_finished,1023
> - finished role get-update-detail
>TI:18:54:45	TH:0x8751458	FI:pk-backend.c	FN:pk_backend_set_allow_cancel,905
> - emit allow-cancel 0
>TI:18:54:45	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_allow_cancel_cb,625
> - emitting allow-interrpt tid:30;aaabdbba;data, 0
>TI:18:54:45	TH:0x8751458	FI:pk-inhibit.c	FN:pk_inhibit_lock,84
> - Trying to AcquireInterfaceLock
>TI:18:54:45	TH:0x8751458	FI:pk-inhibit.c	FN:pk_inhibit_lock,106
> - emit lock 1
>TI:18:54:45	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_inhibit_locked_cb,211
> - emitting locked 1
>TI:18:54:45	TH:0x8751458	FI:pk-runner.c	FN:pk_runner_allow_cancel_cb,1083
> - AllowCancel now 0
>TI:18:54:45	TH:0x8751458	FI:pk-backend.c	FN:pk_backend_set_status,512
> - emiting status-changed finished
>TI:18:54:45	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_status_changed_cb,233
> - emitting status-changed tid:30;aaabdbba;data, 'finished'
>TI:18:54:45	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_reset_timer,183
> - reset timer
>TI:18:54:45	TH:0x8751458	FI:pk-backend.c	FN:pk_backend_finished,1073
> - adding finished 0x875b400 to timeout loop
>TI:18:54:46	TH:0x8751458	FI:pk-backend.c	FN:pk_backend_finished_delay,996
> - emit finished 0
>TI:18:54:46	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_finish_invalidate_caches,479
> - invalidating caches
>TI:18:54:46	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_finished_cb,568
> - backend was running for 4173 ms
>TI:18:54:46	TH:0x8751458	FI:pk-common.c	FN:pk_iso8601_present,154
> - timespec=2008-06-12T16:54:46Z
>TI:18:54:46	TH:0x8751458	FI:pk-transaction-db.c	FN:pk_transaction_db_action_time_reset,286
> - reset action time=get-update-detail to 2008-06-12T16:54:46Z
>TI:18:54:46	TH:0x8751458	FI:pk-transaction-db.c	FN:pk_transaction_db_sql_statement,196
> - statement=UPDATE transactions SET succeeded = 1, duration = 4173 WHERE transaction_id = '30;aaabdbba;data'
>TI:18:54:46	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_finished_cb,602
> - emitting finished transaction:30;aaabdbba;data, 'success', 4173
>TI:18:54:46	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_reset_timer,183
> - reset timer
>TI:18:54:46	TH:0x8751458	FI:pk-transaction-list.c	FN:pk_transaction_list_backend_finished_cb,197
> - transaction 30;aaabdbba;data completed, marking finished
>TI:18:54:46	TH:0x8751458	FI:pk-transaction-list.c	FN:pk_transaction_list_backend_finished_cb,201
> - emmitting ::changed
>TI:18:54:46	TH:0x8751458	FI:pk-transaction-list.c	FN:pk_transaction_list_get_array,311
> - 1 active transactions
>TI:18:54:46	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_transaction_list_changed_cb,199
> - emitting transaction-list-changed
>TI:18:54:46	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_reset_timer,183
> - reset timer
>TI:18:54:46	TH:0x8751458	FI:pk-inhibit.c	FN:pk_inhibit_unlock,124
> - Trying to ReleaseInterfaceLock
>TI:18:54:46	TH:0x8751458	FI:pk-inhibit.c	FN:pk_inhibit_unlock,146
> - emit lock 0
>TI:18:54:46	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_inhibit_locked_cb,211
> - emitting locked 0
>TI:18:54:47	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_cancel,2615
> - Cancel method called: 30;aaabdbba;data
>TI:18:54:47	TH:0x8751458	FI:pk-runner.c	FN:pk_runner_connection_changed_cb,947
> - client disconnected....
>TI:18:54:47	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_caller_active_changed_cb,646
> - emitting caller-active-changed tid:30;aaabdbba;data, 0
>TI:18:54:48	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_get_seconds_idle,2832
> - engine idle zero as 1 transactions in progress
>TI:18:54:48	TH:0x8751458	FI:pk-main.c	FN:pk_main_timeout_check_cb,126
> - idle is 0
>TI:18:54:51	TH:0x8751458	FI:pk-transaction-list.c	FN:pk_transaction_list_remove_item_timeout,158
> - transaction 30;aaabdbba;data completed, removing
>TI:18:54:51	TH:0x8751458	FI:pk-inhibit.c	FN:pk_inhibit_remove,198
> - cannot find item 0x8762120
>TI:18:54:53	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_get_seconds_idle,2844
> - engine idle=6
>TI:18:54:53	TH:0x8751458	FI:pk-main.c	FN:pk_main_timeout_check_cb,126
> - idle is 6
>TI:18:54:58	TH:0x8751458	FI:pk-engine.c	FN:pk_engine_get_seconds_idle,2844
> - engine idle=11
>TI:18:54:58	TH:0x8751458	FI:pk-main.c	FN:pk_main_timeout_check_cb,126
> - idle is 11

Actions: View

Attachments on bug 450931: 309069 | 309102 | 309104