mcd-DEBUG: 18/09/11 22:03:00.983618: dispatcher_channel_request_acl_start: start /org/freedesktop/Telepathy/Account/gabble/jabber/NJamesBridge_40gmail_2ecom0.org.freedesktop.Telepathy.Connection.Interface.Requests.EnsureChannel acl (0x1e140c0) mcd-DEBUG: 18/09/11 22:03:00.983756: dispatcher_channel_request_acl_success: complete acl (0x1e140c0) mcd-DEBUG: 18/09/11 22:03:00.984309: _mcd_request_init: 0x1e202d0 mcd-DEBUG: 18/09/11 22:03:00.984548: _mcd_request_new: 0x1e202d0 (for 0x1e3b0a0) mcd-DEBUG: 18/09/11 22:03:00.984684: _mcd_channel_set_status: 0x1e862a0, 1 mcd-DEBUG: 18/09/11 22:03:00.984886: _mcd_request_predict_handler: Default handler org.freedesktop.Telepathy.Client.Empathy.Chat for request /com/nokia/MissionControl/requests/r1 doesn't want AddRequest mcd-DEBUG: 18/09/11 22:03:00.984997: dispatcher_channel_request_acl_cleanup: cleanup acl (0x1e140c0) mcd-DEBUG: 18/09/11 22:03:00.994522: ready_to_request_cb: Starting online request mcd-DEBUG: 18/09/11 22:03:00.994647: _mcd_account_online_request: connection status for gabble/jabber/NJamesBridge_40gmail_2ecom0 is 0 mcd-DEBUG: 18/09/11 22:03:00.994754: _mcd_account_online_request: gabble/jabber/NJamesBridge_40gmail_2ecom0 is already connected mcd-DEBUG: 18/09/11 22:03:00.994862: online_request_cb: called mcd-DEBUG: 18/09/11 22:03:00.994980: _mcd_mission_set_parent: child = 0x1e862a0, parent = 0x1e340d0 mcd-DEBUG: 18/09/11 22:03:00.995286: _mcd_channel_set_status: 0x1e862a0, 2 mcd-DEBUG: 18/09/11 22:03:01.3705: common_request_channel_cb: 0x1e862a0, object /org/freedesktop/Telepathy/Connection/gabble/jabber/njamesbridge_40gmail_2ecom_2f07b5fd0f/ImChannel4 mcd-DEBUG: 18/09/11 22:03:01.4997: _mcd_dispatcher_take_channels: requested channel 0x1e862a0 (only): /org/freedesktop/Telepathy/Connection/gabble/jabber/njamesbridge_40gmail_2ecom_2f07b5fd0f/ImChannel4 mcd-DEBUG: 18/09/11 22:03:01.5186: _mcd_dispatcher_take_channels: possible handler(s) found, dispatching 1 channels mcd-DEBUG: 18/09/11 22:03:01.5299: _mcd_channel_set_status: 0x1e862a0, 3 mcd-DEBUG: 18/09/11 22:03:01.5418: _mcd_dispatcher_enter_state_machine: CTXREF11 on 0x1e4b720 mcd-DEBUG: 18/09/11 22:03:01.5533: _mcd_dispatcher_enter_state_machine: new dispatcher context 0x1e4b720 for requested channel 0x1e862a0 (only): /org/freedesktop/Telepathy/Connection/gabble/jabber/njamesbridge_40gmail_2ecom_2f07b5fd0f/ImChannel4 mcd-DEBUG: 18/09/11 22:03:01.5688: mcd_dispatch_operation_set_property: Extracted preferred handler: org.freedesktop.Telepathy.Client.Empathy.Chat mcd-DEBUG: 18/09/11 22:03:01.5825: mcd_dispatch_operation_constructor: do6/0x1e3bb40: needs_approval=F mcd-DEBUG: 18/09/11 22:03:01.5944: _mcd_plugin_dispatch_operation_init: 0x1ea3c10 mcd-DEBUG: 18/09/11 22:03:01.6063: _mcd_plugin_dispatch_operation_new: 0x1ea3c10 (for 0x1e3bb40) mcd-DEBUG: 18/09/11 22:03:01.6205: _mcd_dispatcher_enter_state_machine: entering state machine for context 0x1e4b720 mcd-DEBUG: 18/09/11 22:03:01.6315: mcd_dispatcher_context_ref: CTXREF01 on 0x1e4b720 (ref = 1) mcd-DEBUG: 18/09/11 22:03:01.6422: _mcd_dispatch_operation_run_clients: do6 0x1e3bb40 mcd-DEBUG: 18/09/11 22:03:01.6540: _mcd_dispatch_operation_handlers_can_bypass_observers: org.freedesktop.Telepathy.Client.Empathy.Chat has BypassObservers=F mcd-DEBUG: 18/09/11 22:03:01.6647: _mcd_dispatch_operation_run_clients: Running observers mcd-DEBUG: 18/09/11 22:03:01.7002: _mcd_dispatch_operation_inc_observers_pending: 0 -> 1 mcd-DEBUG: 18/09/11 22:03:01.7117: _mcd_dispatch_operation_run_observers: calling ObserveChannels on org.freedesktop.Telepathy.Client.Logger for CDO 0x1e3bb40 mcd-DEBUG: 18/09/11 22:03:01.8347: _mcd_dispatch_operation_inc_observers_pending: 1 -> 2 mcd-DEBUG: 18/09/11 22:03:01.8471: _mcd_dispatch_operation_run_observers: calling ObserveChannels on org.freedesktop.Telepathy.Client.GnomeShell._3a1_2e39.n0 for CDO 0x1e3bb40 mcd-DEBUG: 18/09/11 22:03:01.9434: _mcd_dispatch_operation_run_clients: All necessary observers invoked mcd-DEBUG: 18/09/11 22:03:01.9546: _mcd_dispatch_operation_run_clients: Checking finished/locks mcd-DEBUG: 18/09/11 22:03:01.9655: _mcd_dispatch_operation_handlers_can_bypass_approval: org.freedesktop.Telepathy.Client.Empathy.Chat has BypassApproval=F mcd-DEBUG: 18/09/11 22:03:01.9763: mcd_dispatcher_context_unref: CTXREF01 on 0x1e4b720 (ref = 2) mcd-DEBUG: 18/09/11 22:03:01.9865: mcd_dispatcher_context_unref: CTXREF11 on 0x1e4b720 (ref = 1) mcd-DEBUG: 18/09/11 22:03:01.9959: mcd_dispatcher_context_unref: freeing the context 0x1e4b720 mcd-DEBUG: 18/09/11 22:03:01.26092: on_channel_ready: channel 0x1e862a0 is ready mcd-DEBUG: 18/09/11 22:03:01.61873: observe_channels_cb: success from /org/freedesktop/Telepathy/Client/Logger mcd-DEBUG: 18/09/11 22:03:01.62002: _mcd_dispatch_operation_dec_observers_pending: 2 -> 1 mcd-DEBUG: 18/09/11 22:03:01.67476: observe_channels_cb: success from /org/freedesktop/Telepathy/Client/GnomeShell/_3a1_2e39/n0 mcd-DEBUG: 18/09/11 22:03:01.67606: _mcd_dispatch_operation_dec_observers_pending: 1 -> 0 mcd-DEBUG: 18/09/11 22:03:01.67722: _mcd_plugin_dispatch_operation_observers_finished: 0x1ea3c10 mcd-DEBUG: 18/09/11 22:03:01.67830: _mcd_dispatch_operation_check_client_locks: trying next handler mcd-DEBUG: 18/09/11 22:03:01.67943: _mcd_dispatch_operation_try_next_handler: Approved handler is org.freedesktop.Telepathy.Client.Empathy.Chat (still exists: Y, already failed: N) mcd-DEBUG: 18/09/11 22:03:01.68054: mcd_dispatch_operation_try_handler: do6: channel ACL verification [1 channels] mcd-DEBUG: 18/09/11 22:03:01.68279: _mcd_client_proxy_handle_channels: calling HandleChannels on org.freedesktop.Telepathy.Client.Empathy.Chat mcd-DEBUG: 18/09/11 22:03:01.68546: _mcd_channel_set_status: 0x1e862a0, 4 mcd-DEBUG: 18/09/11 22:03:01.330569: dbusprop_get_all: org.freedesktop.Telepathy.AccountManager mcd-DEBUG: 18/09/11 22:03:01.330698: get_valid_accounts: called mcd-DEBUG: 18/09/11 22:03:01.330826: get_invalid_accounts: called mcd-DEBUG: 18/09/11 22:03:01.330931: mcd_dbus_get_interfaces: called mcd-DEBUG: 18/09/11 22:03:01.556854: _mcd_client_registry_found_name: Registering client org.freedesktop.Telepathy.Client.Empathy.ChatroomManager._3a1_2e102.n0 mcd-DEBUG: 18/09/11 22:03:01.557185: mcd_client_proxy_constructed: org.freedesktop.Telepathy.Client.Empathy.ChatroomManager._3a1_2e102.n0 mcd-DEBUG: 18/09/11 22:03:01.557609: mcd_client_proxy_introspect: No .client file for org.freedesktop.Telepathy.Client.Empathy.ChatroomManager._3a1_2e102.n0. Ask on D-Bus. mcd-DEBUG: 18/09/11 22:03:01.571263: dbusprop_get_all: org.freedesktop.Telepathy.Account mcd-DEBUG: 18/09/11 22:03:01.571398: mcd_dbus_get_interfaces: called mcd-DEBUG: 18/09/11 22:03:01.571515: mcd_dbus_get_interfaces: skipping inactive optional iface org.freedesktop.Telepathy.Account.Interface.ExternalPasswordStorage.DRAFT mcd-DEBUG: 18/09/11 22:03:01.571671: _mcd_account_dup_parameters: called mcd-DEBUG: 18/09/11 22:03:01.572025: get_connect_automatically: called for gabble/jabber/NJamesBridge_40gmail_2ecom0 mcd-DEBUG: 18/09/11 22:03:01.574114: dbusprop_get_all: org.freedesktop.Telepathy.Account mcd-DEBUG: 18/09/11 22:03:01.574286: mcd_dbus_get_interfaces: called mcd-DEBUG: 18/09/11 22:03:01.574398: mcd_dbus_get_interfaces: skipping inactive optional iface org.freedesktop.Telepathy.Account.Interface.ExternalPasswordStorage.DRAFT mcd-DEBUG: 18/09/11 22:03:01.574546: _mcd_account_dup_parameters: called mcd-DEBUG: 18/09/11 22:03:01.574881: get_connect_automatically: called for gabble/jabber/NJamesBridge_40gmail_2ecom0 mcd-DEBUG: 18/09/11 22:03:01.575505: dbusprop_get_all: org.freedesktop.Telepathy.Account mcd-DEBUG: 18/09/11 22:03:01.575615: mcd_dbus_get_interfaces: called mcd-DEBUG: 18/09/11 22:03:01.575722: mcd_dbus_get_interfaces: skipping inactive optional iface org.freedesktop.Telepathy.Account.Interface.ExternalPasswordStorage.DRAFT mcd-DEBUG: 18/09/11 22:03:01.575862: _mcd_account_dup_parameters: called mcd-DEBUG: 18/09/11 22:03:01.576154: get_connect_automatically: called for gabble/jabber/NJamesBridge_40chat_2efacebook_2ecom0 mcd-DEBUG: 18/09/11 22:03:01.576723: dbusprop_get_all: org.freedesktop.Telepathy.Account mcd-DEBUG: 18/09/11 22:03:01.576828: mcd_dbus_get_interfaces: called mcd-DEBUG: 18/09/11 22:03:01.576932: mcd_dbus_get_interfaces: skipping inactive optional iface org.freedesktop.Telepathy.Account.Interface.ExternalPasswordStorage.DRAFT mcd-DEBUG: 18/09/11 22:03:01.577065: _mcd_account_dup_parameters: called mcd-DEBUG: 18/09/11 22:03:01.577387: get_connect_automatically: called for gabble/jabber/NJamesBridge_40chat_2efacebook_2ecom0 mcd-DEBUG: 18/09/11 22:03:01.584625: dbusprop_get_all: org.freedesktop.Telepathy.Account mcd-DEBUG: 18/09/11 22:03:01.584752: mcd_dbus_get_interfaces: called mcd-DEBUG: 18/09/11 22:03:01.584861: mcd_dbus_get_interfaces: skipping inactive optional iface org.freedesktop.Telepathy.Account.Interface.ExternalPasswordStorage.DRAFT mcd-DEBUG: 18/09/11 22:03:01.585015: _mcd_account_dup_parameters: called mcd-DEBUG: 18/09/11 22:03:01.585270: get_connect_automatically: called for salut/local_xmpp/account0 mcd-DEBUG: 18/09/11 22:03:01.585864: dbusprop_get_all: org.freedesktop.Telepathy.Account mcd-DEBUG: 18/09/11 22:03:01.585977: mcd_dbus_get_interfaces: called mcd-DEBUG: 18/09/11 22:03:01.586082: mcd_dbus_get_interfaces: skipping inactive optional iface org.freedesktop.Telepathy.Account.Interface.ExternalPasswordStorage.DRAFT mcd-DEBUG: 18/09/11 22:03:01.586241: _mcd_account_dup_parameters: called mcd-DEBUG: 18/09/11 22:03:01.586458: get_connect_automatically: called for salut/local_xmpp/account0 mcd-DEBUG: 18/09/11 22:03:01.601917: _mcd_client_proxy_add_interfaces: org.freedesktop.Telepathy.Client.Empathy.ChatroomManager._3a1_2e102.n0: org.freedesktop.Telepathy.Client.Observer mcd-DEBUG: 18/09/11 22:03:01.602050: _mcd_client_proxy_get_interfaces_cb: Client org.freedesktop.Telepathy.Client.Empathy.ChatroomManager._3a1_2e102.n0 mcd-DEBUG: 18/09/11 22:03:01.602155: _mcd_client_proxy_get_interfaces_cb: org.freedesktop.Telepathy.Client.Empathy.ChatroomManager._3a1_2e102.n0 is an Observer mcd-DEBUG: 18/09/11 22:03:01.628254: _mcd_client_proxy_observer_get_all_cb: org.freedesktop.Telepathy.Client.Empathy.ChatroomManager._3a1_2e102.n0 has DelayApprovers=F mcd-DEBUG: 18/09/11 22:03:01.628384: _mcd_client_proxy_observer_get_all_cb: org.freedesktop.Telepathy.Client.Empathy.ChatroomManager._3a1_2e102.n0 has 1 ObserverChannelFilter entries mcd-DEBUG: 18/09/11 22:03:01.628508: _mcd_client_proxy_observer_get_all_cb: org.freedesktop.Telepathy.Client.Empathy.ChatroomManager._3a1_2e102.n0 has Recover=T mcd-DEBUG: 18/09/11 22:03:01.628611: mcd_client_registry_ready_cb: org.freedesktop.Telepathy.Client.Empathy.ChatroomManager._3a1_2e102.n0 mcd-DEBUG: 18/09/11 22:03:01.628717: mcd_dispatcher_client_needs_recovery_cb: called mcd-DEBUG: 18/09/11 22:03:01.641844: _mcd_channel_set_status: 0x1e862a0, 5 mcd-DEBUG: 18/09/11 22:03:01.641997: _mcd_request_set_success: Request succeeded mcd-DEBUG: 18/09/11 22:03:01.642744: _mcd_dispatch_operation_finish: Result: Channel successfully handled by org.freedesktop.Telepathy.Client.Empathy.Chat mcd-DEBUG: 18/09/11 22:03:01.642847: _mcd_dispatch_operation_finish: do6/0x1e3bb40 has finished mcd-DEBUG: 18/09/11 22:03:01.642941: mcd_dispatch_operation_actually_finish: do6/0x1e3bb40: finished mcd-DEBUG: 18/09/11 22:03:01.643043: _mcd_dispatch_operation_check_client_locks: waiting for handler_is_suitable or HandleChannels to return mcd-DEBUG: 18/09/11 22:03:01.643156: _mcd_dispatch_operation_check_client_locks: already finished (or finishing): Channel successfully handled by org.freedesktop.Telepathy.Client.Empathy.Chat mcd-DEBUG: 18/09/11 22:03:01.643297: plugin_do_finalize: 0x1ea3c10 mcd-DEBUG: 18/09/11 22:03:20.53033: dispatcher_channel_request_acl_start: start /org/freedesktop/Telepathy/Account/gabble/jabber/NJamesBridge_40gmail_2ecom0.org.freedesktop.Telepathy.Connection.Interface.Requests.CreateChannel acl (0x1e14140) mcd-DEBUG: 18/09/11 22:03:20.53200: dispatcher_channel_request_acl_success: complete acl (0x1e14140) mcd-DEBUG: 18/09/11 22:03:20.53396: _mcd_request_init: 0x1e20380 mcd-DEBUG: 18/09/11 22:03:20.53649: _mcd_request_new: 0x1e20380 (for 0x1e3b0a0) mcd-DEBUG: 18/09/11 22:03:20.53797: _mcd_channel_set_status: 0x1e1eb00, 1 mcd-DEBUG: 18/09/11 22:03:20.53998: _mcd_request_predict_handler: Default handler org.freedesktop.Telepathy.Client.Empathy.AudioVideo for request /com/nokia/MissionControl/requests/r2 doesn't want AddRequest mcd-DEBUG: 18/09/11 22:03:20.54105: dispatcher_channel_request_acl_cleanup: cleanup acl (0x1e14140) mcd-DEBUG: 18/09/11 22:03:20.68439: ready_to_request_cb: Starting online request mcd-DEBUG: 18/09/11 22:03:20.68567: _mcd_account_online_request: connection status for gabble/jabber/NJamesBridge_40gmail_2ecom0 is 0 mcd-DEBUG: 18/09/11 22:03:20.68675: _mcd_account_online_request: gabble/jabber/NJamesBridge_40gmail_2ecom0 is already connected mcd-DEBUG: 18/09/11 22:03:20.68777: online_request_cb: called mcd-DEBUG: 18/09/11 22:03:20.68892: _mcd_mission_set_parent: child = 0x1e1eb00, parent = 0x1e340d0 mcd-DEBUG: 18/09/11 22:03:20.70205: _mcd_channel_set_status: 0x1e1eb00, 2 mcd-DEBUG: 18/09/11 22:03:25.216120: common_request_channel_cb: 0x1e1eb00, object /org/freedesktop/Telepathy/Connection/gabble/jabber/njamesbridge_40gmail_2ecom_2f07b5fd0f/MediaChannel0 mcd-DEBUG: 18/09/11 22:03:25.222819: _mcd_dispatcher_take_channels: requested channel 0x1e1eb00 (only): /org/freedesktop/Telepathy/Connection/gabble/jabber/njamesbridge_40gmail_2ecom_2f07b5fd0f/MediaChannel0 mcd-DEBUG: 18/09/11 22:03:25.222994: _mcd_dispatcher_take_channels: possible handler(s) found, dispatching 1 channels mcd-DEBUG: 18/09/11 22:03:25.223100: _mcd_channel_set_status: 0x1e1eb00, 3 mcd-DEBUG: 18/09/11 22:03:25.223254: _mcd_dispatcher_enter_state_machine: CTXREF11 on 0x1e46030 mcd-DEBUG: 18/09/11 22:03:25.223364: _mcd_dispatcher_enter_state_machine: new dispatcher context 0x1e46030 for requested channel 0x1e1eb00 (only): /org/freedesktop/Telepathy/Connection/gabble/jabber/njamesbridge_40gmail_2ecom_2f07b5fd0f/MediaChannel0 mcd-DEBUG: 18/09/11 22:03:25.223517: mcd_dispatch_operation_set_property: Extracted preferred handler: org.freedesktop.Telepathy.Client.Empathy.AudioVideo mcd-DEBUG: 18/09/11 22:03:25.223653: mcd_dispatch_operation_constructor: do7/0x1e3bb40: needs_approval=F mcd-DEBUG: 18/09/11 22:03:25.223772: _mcd_plugin_dispatch_operation_init: 0x1ebb760 mcd-DEBUG: 18/09/11 22:03:25.223891: _mcd_plugin_dispatch_operation_new: 0x1ebb760 (for 0x1e3bb40) mcd-DEBUG: 18/09/11 22:03:25.224015: _mcd_dispatcher_enter_state_machine: entering state machine for context 0x1e46030 mcd-DEBUG: 18/09/11 22:03:25.224123: mcd_dispatcher_context_ref: CTXREF01 on 0x1e46030 (ref = 1) mcd-DEBUG: 18/09/11 22:03:25.224296: _mcd_dispatch_operation_run_clients: do7 0x1e3bb40 mcd-DEBUG: 18/09/11 22:03:25.224412: _mcd_dispatch_operation_handlers_can_bypass_observers: org.freedesktop.Telepathy.Client.Empathy.AudioVideo has BypassObservers=F mcd-DEBUG: 18/09/11 22:03:25.224515: _mcd_dispatch_operation_run_clients: Running observers mcd-DEBUG: 18/09/11 22:03:25.224839: _mcd_dispatch_operation_inc_observers_pending: 0 -> 1 mcd-DEBUG: 18/09/11 22:03:25.224948: _mcd_dispatch_operation_run_observers: calling ObserveChannels on org.freedesktop.Telepathy.Client.Empathy.CallObserver for CDO 0x1e3bb40 mcd-DEBUG: 18/09/11 22:03:25.225925: _mcd_dispatch_operation_run_clients: All necessary observers invoked mcd-DEBUG: 18/09/11 22:03:25.226042: _mcd_dispatch_operation_run_clients: Checking finished/locks mcd-DEBUG: 18/09/11 22:03:25.232392: _mcd_dispatch_operation_handlers_can_bypass_approval: org.freedesktop.Telepathy.Client.Empathy.AudioVideo has BypassApproval=F mcd-DEBUG: 18/09/11 22:03:25.232553: mcd_dispatcher_context_unref: CTXREF01 on 0x1e46030 (ref = 2) mcd-DEBUG: 18/09/11 22:03:25.232666: mcd_dispatcher_context_unref: CTXREF11 on 0x1e46030 (ref = 1) mcd-DEBUG: 18/09/11 22:03:25.232775: mcd_dispatcher_context_unref: freeing the context 0x1e46030 mcd-DEBUG: 18/09/11 22:03:25.241662: on_channel_ready: channel 0x1e1eb00 is ready mcd-DEBUG: 18/09/11 22:03:25.245965: observe_channels_cb: success from /org/freedesktop/Telepathy/Client/Empathy/CallObserver mcd-DEBUG: 18/09/11 22:03:25.246109: _mcd_dispatch_operation_dec_observers_pending: 1 -> 0 mcd-DEBUG: 18/09/11 22:03:25.246254: _mcd_plugin_dispatch_operation_observers_finished: 0x1ebb760 mcd-DEBUG: 18/09/11 22:03:25.246371: _mcd_dispatch_operation_handlers_can_bypass_approval: org.freedesktop.Telepathy.Client.Empathy.AudioVideo has BypassApproval=F mcd-DEBUG: 18/09/11 22:03:25.246496: _mcd_dispatch_operation_check_client_locks: trying next handler mcd-DEBUG: 18/09/11 22:03:25.246608: _mcd_dispatch_operation_try_next_handler: Approved handler is org.freedesktop.Telepathy.Client.Empathy.AudioVideo (still exists: Y, already failed: N) mcd-DEBUG: 18/09/11 22:03:25.246721: mcd_dispatch_operation_try_handler: do7: channel ACL verification [1 channels] mcd-DEBUG: 18/09/11 22:03:25.246916: _mcd_client_proxy_handle_channels: calling HandleChannels on org.freedesktop.Telepathy.Client.Empathy.AudioVideo mcd-DEBUG: 18/09/11 22:03:25.247190: _mcd_channel_set_status: 0x1e1eb00, 4 mcd-DEBUG: 18/09/11 22:03:25.567519: dbusprop_get_all: org.freedesktop.Telepathy.AccountManager mcd-DEBUG: 18/09/11 22:03:25.567641: get_valid_accounts: called mcd-DEBUG: 18/09/11 22:03:25.567756: get_invalid_accounts: called mcd-DEBUG: 18/09/11 22:03:25.567847: mcd_dbus_get_interfaces: called mcd-DEBUG: 18/09/11 22:03:25.575797: dbusprop_get_all: org.freedesktop.Telepathy.Account mcd-DEBUG: 18/09/11 22:03:25.575937: mcd_dbus_get_interfaces: called mcd-DEBUG: 18/09/11 22:03:25.576056: mcd_dbus_get_interfaces: skipping inactive optional iface org.freedesktop.Telepathy.Account.Interface.ExternalPasswordStorage.DRAFT mcd-DEBUG: 18/09/11 22:03:25.577064: _mcd_account_dup_parameters: called mcd-DEBUG: 18/09/11 22:03:25.577483: get_connect_automatically: called for gabble/jabber/NJamesBridge_40gmail_2ecom0 mcd-DEBUG: 18/09/11 22:03:25.595197: dbusprop_get_all: org.freedesktop.Telepathy.Account mcd-DEBUG: 18/09/11 22:03:25.595335: mcd_dbus_get_interfaces: called mcd-DEBUG: 18/09/11 22:03:25.595449: mcd_dbus_get_interfaces: skipping inactive optional iface org.freedesktop.Telepathy.Account.Interface.ExternalPasswordStorage.DRAFT mcd-DEBUG: 18/09/11 22:03:25.595593: _mcd_account_dup_parameters: called mcd-DEBUG: 18/09/11 22:03:25.595953: get_connect_automatically: called for gabble/jabber/NJamesBridge_40gmail_2ecom0 mcd-DEBUG: 18/09/11 22:03:25.596997: dbusprop_get_all: org.freedesktop.Telepathy.Account mcd-DEBUG: 18/09/11 22:03:25.597115: mcd_dbus_get_interfaces: called mcd-DEBUG: 18/09/11 22:03:25.597248: mcd_dbus_get_interfaces: skipping inactive optional iface org.freedesktop.Telepathy.Account.Interface.ExternalPasswordStorage.DRAFT mcd-DEBUG: 18/09/11 22:03:25.597393: _mcd_account_dup_parameters: called mcd-DEBUG: 18/09/11 22:03:25.597707: get_connect_automatically: called for gabble/jabber/NJamesBridge_40chat_2efacebook_2ecom0 mcd-DEBUG: 18/09/11 22:03:25.598521: dbusprop_get_all: org.freedesktop.Telepathy.Account mcd-DEBUG: 18/09/11 22:03:25.598644: mcd_dbus_get_interfaces: called mcd-DEBUG: 18/09/11 22:03:25.598759: mcd_dbus_get_interfaces: skipping inactive optional iface org.freedesktop.Telepathy.Account.Interface.ExternalPasswordStorage.DRAFT mcd-DEBUG: 18/09/11 22:03:25.598906: _mcd_account_dup_parameters: called mcd-DEBUG: 18/09/11 22:03:25.599244: get_connect_automatically: called for gabble/jabber/NJamesBridge_40chat_2efacebook_2ecom0 mcd-DEBUG: 18/09/11 22:03:25.601237: dbusprop_get_all: org.freedesktop.Telepathy.Account mcd-DEBUG: 18/09/11 22:03:25.601378: mcd_dbus_get_interfaces: called mcd-DEBUG: 18/09/11 22:03:25.601495: mcd_dbus_get_interfaces: skipping inactive optional iface org.freedesktop.Telepathy.Account.Interface.ExternalPasswordStorage.DRAFT mcd-DEBUG: 18/09/11 22:03:25.601666: _mcd_account_dup_parameters: called mcd-DEBUG: 18/09/11 22:03:25.601910: get_connect_automatically: called for salut/local_xmpp/account0 mcd-DEBUG: 18/09/11 22:03:25.607422: dbusprop_get_all: org.freedesktop.Telepathy.Account mcd-DEBUG: 18/09/11 22:03:25.607559: mcd_dbus_get_interfaces: called mcd-DEBUG: 18/09/11 22:03:25.607683: mcd_dbus_get_interfaces: skipping inactive optional iface org.freedesktop.Telepathy.Account.Interface.ExternalPasswordStorage.DRAFT mcd-DEBUG: 18/09/11 22:03:25.607853: _mcd_account_dup_parameters: called mcd-DEBUG: 18/09/11 22:03:25.608099: get_connect_automatically: called for salut/local_xmpp/account0 mcd-DEBUG: 18/09/11 22:03:25.623539: _mcd_channel_set_status: 0x1e1eb00, 5 mcd-DEBUG: 18/09/11 22:03:25.623684: _mcd_request_set_success: Request succeeded mcd-DEBUG: 18/09/11 22:03:25.624416: _mcd_dispatch_operation_finish: Result: Channel successfully handled by org.freedesktop.Telepathy.Client.Empathy.AudioVideo mcd-DEBUG: 18/09/11 22:03:25.624545: _mcd_dispatch_operation_finish: do7/0x1e3bb40 has finished mcd-DEBUG: 18/09/11 22:03:25.624665: mcd_dispatch_operation_actually_finish: do7/0x1e3bb40: finished mcd-DEBUG: 18/09/11 22:03:25.624790: _mcd_dispatch_operation_check_client_locks: waiting for handler_is_suitable or HandleChannels to return mcd-DEBUG: 18/09/11 22:03:25.624910: _mcd_dispatch_operation_check_client_locks: already finished (or finishing): Channel successfully handled by org.freedesktop.Telepathy.Client.Empathy.AudioVideo mcd-DEBUG: 18/09/11 22:03:25.625021: plugin_do_finalize: 0x1ebb760 mcd-DEBUG: 18/09/11 22:03:29.512111: on_members_changed: called (actor 1, reason 4, self_handle 1, conn_self_handle 1) mcd-DEBUG: 18/09/11 22:03:37.432069: on_members_changed: called (actor 1, reason 6, self_handle 1, conn_self_handle 1) mcd-DEBUG: 18/09/11 22:03:37.432223: on_members_changed: removed member 1 mcd-DEBUG: 18/09/11 22:03:37.449424: proxy_destroyed: Channel proxy invalidated: tp_errors 3: Invalid remote candidates passed mcd-DEBUG: 18/09/11 22:03:37.449561: mcd_channel_abort: 0x1e1eb00 mcd-DEBUG: 18/09/11 22:03:37.449662: _mcd_channel_set_status: 0x1e1eb00, 7 mcd-DEBUG: 18/09/11 22:03:37.449790: _mcd_mission_set_parent: child = 0x1e1eb00, parent = (nil) mcd-DEBUG: 18/09/11 22:03:37.449904: _mcd_operation_remove_mission: removing mission: 0x1e1eb00 mcd-DEBUG: 18/09/11 22:03:37.450047: _mcd_channel_dispose: 0x1e1eb00 (is disposed = 0) mcd-DEBUG: 18/09/11 22:03:37.450156: _mcd_mission_dispose: mission disposed 0x1e1eb00 mcd-DEBUG: 18/09/11 22:03:37.450292: _mcd_request_dispose: 0x1e20380 mcd-DEBUG: 18/09/11 22:03:37.450406: _mcd_request_finalize: 0x1e20380 mcd-DEBUG: 18/09/11 22:03:37.450515: _mcd_mission_finalize: mission finalized 0x1e1eb00 mcd-DEBUG: 18/09/11 22:34:20.567397: get_mcddbusprop: org.freedesktop.Telepathy.Account, RequestedPresence mcd-DEBUG: 18/09/11 22:34:20.567548: set_requested_presence: called for gabble/jabber/NJamesBridge_40gmail_2ecom0 mcd-DEBUG: 18/09/11 22:34:20.567653: set_requested_presence: setting requested presence: 3, away, mcd-DEBUG: 18/09/11 22:34:20.567760: mcd_account_changed_property: called: RequestedPresence mcd-DEBUG: 18/09/11 22:34:20.567859: mcd_account_changed_property: First changed property mcd-DEBUG: 18/09/11 22:34:20.567986: mcd_account_request_presence_int: Requested presence: 3 away mcd-DEBUG: 18/09/11 22:34:20.568099: mcd_account_changed_property: called: ChangingPresence mcd-DEBUG: 18/09/11 22:34:20.568243: _mcd_connection_request_presence: Presence requested: 3 mcd-DEBUG: 18/09/11 22:34:20.568360: _mcd_connection_set_presence: Setting status 'away' of type 3 ('away' was requested) mcd-DEBUG: 18/09/11 22:34:20.578032: emit_property_changed: called mcd-DEBUG: 18/09/11 22:34:20.578423: mcd_account_changed_property: called: ChangingPresence mcd-DEBUG: 18/09/11 22:34:20.578526: mcd_account_changed_property: First changed property mcd-DEBUG: 18/09/11 22:34:20.578635: mcd_account_changed_property: called: CurrentPresence mcd-DEBUG: 18/09/11 22:34:20.582120: mcd_account_changed_property: called: ChangingPresence mcd-DEBUG: 18/09/11 22:34:20.582250: mcd_account_changed_property: Forcibly emit PropertiesChanged now mcd-DEBUG: 18/09/11 22:34:20.582340: emit_property_changed: called mcd-DEBUG: 18/09/11 22:34:20.582595: mcd_account_changed_property: First changed property mcd-DEBUG: 18/09/11 22:34:20.582823: get_mcddbusprop: org.freedesktop.Telepathy.Account, RequestedPresence mcd-DEBUG: 18/09/11 22:34:20.582937: set_requested_presence: called for salut/local_xmpp/account0 mcd-DEBUG: 18/09/11 22:34:20.583045: set_requested_presence: setting requested presence: 3, away, mcd-DEBUG: 18/09/11 22:34:20.583151: mcd_account_changed_property: called: RequestedPresence mcd-DEBUG: 18/09/11 22:34:20.583271: mcd_account_changed_property: First changed property mcd-DEBUG: 18/09/11 22:34:20.583384: mcd_account_request_presence_int: Requested presence: 3 away mcd-DEBUG: 18/09/11 22:34:20.583486: mcd_account_changed_property: called: ChangingPresence mcd-DEBUG: 18/09/11 22:34:20.583591: _mcd_connection_request_presence: Presence requested: 3 mcd-DEBUG: 18/09/11 22:34:20.583697: _mcd_connection_set_presence: Setting status 'away' of type 3 ('away' was requested) mcd-DEBUG: 18/09/11 22:34:20.584047: get_mcddbusprop: org.freedesktop.Telepathy.Account, RequestedPresence mcd-DEBUG: 18/09/11 22:34:20.585311: set_requested_presence: called for gabble/jabber/NJamesBridge_40chat_2efacebook_2ecom0 mcd-DEBUG: 18/09/11 22:34:20.585437: set_requested_presence: setting requested presence: 3, away, mcd-DEBUG: 18/09/11 22:34:20.585544: mcd_account_changed_property: called: RequestedPresence mcd-DEBUG: 18/09/11 22:34:20.585645: mcd_account_changed_property: First changed property mcd-DEBUG: 18/09/11 22:34:20.585758: mcd_account_request_presence_int: Requested presence: 3 away mcd-DEBUG: 18/09/11 22:34:20.585860: mcd_account_changed_property: called: ChangingPresence mcd-DEBUG: 18/09/11 22:34:20.585968: _mcd_connection_request_presence: Presence requested: 3 mcd-DEBUG: 18/09/11 22:34:20.586074: _mcd_connection_set_presence: Setting status 'away' of type 3 ('away' was requested) mcd-DEBUG: 18/09/11 22:34:20.593480: emit_property_changed: called mcd-DEBUG: 18/09/11 22:34:20.593744: emit_property_changed: called mcd-DEBUG: 18/09/11 22:34:20.598366: emit_property_changed: called mcd-DEBUG: 18/09/11 22:34:20.607928: mcd_account_changed_property: called: ChangingPresence mcd-DEBUG: 18/09/11 22:34:20.608033: mcd_account_changed_property: First changed property mcd-DEBUG: 18/09/11 22:34:20.608125: mcd_account_changed_property: called: CurrentPresence mcd-DEBUG: 18/09/11 22:34:20.615575: mcd_account_changed_property: called: ChangingPresence mcd-DEBUG: 18/09/11 22:34:20.615700: mcd_account_changed_property: First changed property mcd-DEBUG: 18/09/11 22:34:20.615808: mcd_account_changed_property: called: CurrentPresence mcd-DEBUG: 18/09/11 22:34:20.619090: emit_property_changed: called mcd-DEBUG: 18/09/11 22:34:20.626547: emit_property_changed: called mcd-DEBUG: 18/09/11 23:04:20.505265: get_mcddbusprop: org.freedesktop.Telepathy.Account, RequestedPresence mcd-DEBUG: 18/09/11 23:04:20.505366: set_requested_presence: called for gabble/jabber/NJamesBridge_40gmail_2ecom0 mcd-DEBUG: 18/09/11 23:04:20.505472: set_requested_presence: setting requested presence: 4, xa, mcd-DEBUG: 18/09/11 23:04:20.505592: mcd_account_changed_property: called: RequestedPresence mcd-DEBUG: 18/09/11 23:04:20.505697: mcd_account_changed_property: First changed property mcd-DEBUG: 18/09/11 23:04:20.505810: mcd_account_request_presence_int: Requested presence: 4 xa mcd-DEBUG: 18/09/11 23:04:20.505903: mcd_account_changed_property: called: ChangingPresence mcd-DEBUG: 18/09/11 23:04:20.506006: _mcd_connection_request_presence: Presence requested: 4 mcd-DEBUG: 18/09/11 23:04:20.506108: _mcd_connection_set_presence: Setting status 'xa' of type 4 ('xa' was requested) mcd-DEBUG: 18/09/11 23:04:20.506479: get_mcddbusprop: org.freedesktop.Telepathy.Account, RequestedPresence mcd-DEBUG: 18/09/11 23:04:20.506594: set_requested_presence: called for salut/local_xmpp/account0 mcd-DEBUG: 18/09/11 23:04:20.506704: set_requested_presence: setting requested presence: 4, xa, mcd-DEBUG: 18/09/11 23:04:20.506858: mcd_account_changed_property: called: RequestedPresence mcd-DEBUG: 18/09/11 23:04:20.506963: mcd_account_changed_property: First changed property mcd-DEBUG: 18/09/11 23:04:20.507083: mcd_account_request_presence_int: Requested presence: 4 xa mcd-DEBUG: 18/09/11 23:04:20.507221: mcd_account_changed_property: called: ChangingPresence mcd-DEBUG: 18/09/11 23:04:20.507333: _mcd_connection_request_presence: Presence requested: 4 mcd-DEBUG: 18/09/11 23:04:20.507435: _check_presence: account salut/local_xmpp/account0: presence xa not supported, setting away mcd-DEBUG: 18/09/11 23:04:20.507534: _mcd_connection_set_presence: Setting status 'away' of type 4 ('xa' was requested) mcd-DEBUG: 18/09/11 23:04:20.507857: get_mcddbusprop: org.freedesktop.Telepathy.Account, RequestedPresence mcd-DEBUG: 18/09/11 23:04:20.507962: set_requested_presence: called for gabble/jabber/NJamesBridge_40chat_2efacebook_2ecom0 mcd-DEBUG: 18/09/11 23:04:20.508064: set_requested_presence: setting requested presence: 4, xa, mcd-DEBUG: 18/09/11 23:04:20.508193: mcd_account_changed_property: called: RequestedPresence mcd-DEBUG: 18/09/11 23:04:20.508296: mcd_account_changed_property: First changed property mcd-DEBUG: 18/09/11 23:04:20.508409: mcd_account_request_presence_int: Requested presence: 4 xa mcd-DEBUG: 18/09/11 23:04:20.508513: mcd_account_changed_property: called: ChangingPresence mcd-DEBUG: 18/09/11 23:04:20.508618: _mcd_connection_request_presence: Presence requested: 4 mcd-DEBUG: 18/09/11 23:04:20.508719: _mcd_connection_set_presence: Setting status 'xa' of type 4 ('xa' was requested) mcd-DEBUG: 18/09/11 23:04:20.518938: emit_property_changed: called mcd-DEBUG: 18/09/11 23:04:20.519269: emit_property_changed: called mcd-DEBUG: 18/09/11 23:04:20.519511: emit_property_changed: called mcd-DEBUG: 18/09/11 23:04:20.529835: mcd_account_changed_property: called: ChangingPresence mcd-DEBUG: 18/09/11 23:04:20.529967: mcd_account_changed_property: First changed property mcd-DEBUG: 18/09/11 23:04:20.530092: mcd_account_changed_property: called: CurrentPresence mcd-DEBUG: 18/09/11 23:04:20.533430: mcd_account_changed_property: called: ChangingPresence mcd-DEBUG: 18/09/11 23:04:20.533560: mcd_account_changed_property: Forcibly emit PropertiesChanged now mcd-DEBUG: 18/09/11 23:04:20.533677: emit_property_changed: called mcd-DEBUG: 18/09/11 23:04:20.533929: mcd_account_changed_property: First changed property mcd-DEBUG: 18/09/11 23:04:20.544331: emit_property_changed: called mcd-DEBUG: 18/09/11 23:04:20.557354: mcd_account_changed_property: called: ChangingPresence mcd-DEBUG: 18/09/11 23:04:20.557492: mcd_account_changed_property: First changed property mcd-DEBUG: 18/09/11 23:04:20.562489: mcd_account_changed_property: called: ChangingPresence mcd-DEBUG: 18/09/11 23:04:20.562619: mcd_account_changed_property: First changed property mcd-DEBUG: 18/09/11 23:04:20.562778: mcd_account_changed_property: called: CurrentPresence mcd-DEBUG: 18/09/11 23:04:20.572910: emit_property_changed: called mcd-DEBUG: 18/09/11 23:04:20.573203: emit_property_changed: called mcd-DEBUG: 18/09/11 23:04:48.298815: get_mcddbusprop: org.freedesktop.Telepathy.Account, RequestedPresence mcd-DEBUG: 18/09/11 23:04:48.298966: set_requested_presence: called for gabble/jabber/NJamesBridge_40gmail_2ecom0 mcd-DEBUG: 18/09/11 23:04:48.299072: set_requested_presence: setting requested presence: 2, available, mcd-DEBUG: 18/09/11 23:04:48.299216: mcd_account_changed_property: called: RequestedPresence mcd-DEBUG: 18/09/11 23:04:48.299321: mcd_account_changed_property: First changed property mcd-DEBUG: 18/09/11 23:04:48.299438: mcd_account_request_presence_int: Requested presence: 2 available mcd-DEBUG: 18/09/11 23:04:48.299545: mcd_account_changed_property: called: ChangingPresence mcd-DEBUG: 18/09/11 23:04:48.299659: _mcd_connection_request_presence: Presence requested: 2 mcd-DEBUG: 18/09/11 23:04:48.299760: _mcd_connection_set_presence: Setting status 'available' of type 2 ('available' was requested) mcd-DEBUG: 18/09/11 23:04:48.300126: get_mcddbusprop: org.freedesktop.Telepathy.Account, RequestedPresence mcd-DEBUG: 18/09/11 23:04:48.300286: set_requested_presence: called for salut/local_xmpp/account0 mcd-DEBUG: 18/09/11 23:04:48.300395: set_requested_presence: setting requested presence: 2, available, mcd-DEBUG: 18/09/11 23:04:48.300507: mcd_account_changed_property: called: RequestedPresence mcd-DEBUG: 18/09/11 23:04:48.300607: mcd_account_changed_property: First changed property mcd-DEBUG: 18/09/11 23:04:48.300724: mcd_account_request_presence_int: Requested presence: 2 available mcd-DEBUG: 18/09/11 23:04:48.300827: mcd_account_changed_property: called: ChangingPresence mcd-DEBUG: 18/09/11 23:04:48.300930: _mcd_connection_request_presence: Presence requested: 2 mcd-DEBUG: 18/09/11 23:04:48.301033: _mcd_connection_set_presence: Setting status 'available' of type 2 ('available' was requested) mcd-DEBUG: 18/09/11 23:04:48.301417: get_mcddbusprop: org.freedesktop.Telepathy.Account, RequestedPresence mcd-DEBUG: 18/09/11 23:04:48.301630: set_requested_presence: called for gabble/jabber/NJamesBridge_40chat_2efacebook_2ecom0 mcd-DEBUG: 18/09/11 23:04:48.301740: set_requested_presence: setting requested presence: 2, available, mcd-DEBUG: 18/09/11 23:04:48.301851: mcd_account_changed_property: called: RequestedPresence mcd-DEBUG: 18/09/11 23:04:48.301939: mcd_account_changed_property: First changed property mcd-DEBUG: 18/09/11 23:04:48.302038: mcd_account_request_presence_int: Requested presence: 2 available mcd-DEBUG: 18/09/11 23:04:48.302138: mcd_account_changed_property: called: ChangingPresence mcd-DEBUG: 18/09/11 23:04:48.302268: _mcd_connection_request_presence: Presence requested: 2 mcd-DEBUG: 18/09/11 23:04:48.302370: _mcd_connection_set_presence: Setting status 'available' of type 2 ('available' was requested) mcd-DEBUG: 18/09/11 23:04:48.309762: emit_property_changed: called mcd-DEBUG: 18/09/11 23:04:48.311940: emit_property_changed: called mcd-DEBUG: 18/09/11 23:04:48.312252: emit_property_changed: called mcd-DEBUG: 18/09/11 23:04:48.329978: mcd_account_changed_property: called: ChangingPresence mcd-DEBUG: 18/09/11 23:04:48.330115: mcd_account_changed_property: First changed property mcd-DEBUG: 18/09/11 23:04:48.330271: mcd_account_changed_property: called: CurrentPresence mcd-DEBUG: 18/09/11 23:04:48.332895: mcd_account_changed_property: called: ChangingPresence mcd-DEBUG: 18/09/11 23:04:48.333024: mcd_account_changed_property: First changed property mcd-DEBUG: 18/09/11 23:04:48.333148: mcd_account_changed_property: called: CurrentPresence mcd-DEBUG: 18/09/11 23:04:48.340504: emit_property_changed: called mcd-DEBUG: 18/09/11 23:04:48.347202: emit_property_changed: called mcd-DEBUG: 18/09/11 23:04:48.444130: mcd_account_changed_property: called: ChangingPresence mcd-DEBUG: 18/09/11 23:04:48.444268: mcd_account_changed_property: First changed property mcd-DEBUG: 18/09/11 23:04:48.444360: mcd_account_changed_property: called: CurrentPresence mcd-DEBUG: 18/09/11 23:04:48.454565: emit_property_changed: called