mcd-DEBUG: 12/07/11 11:07:41.576755: _mcd_client_proxy_parse_client_file: File found for org.freedesktop.Telepathy.Client.Empathy.AudioVideo: /usr/share/telepathy/clients/Empathy.AudioVideo.client
mcd-DEBUG: 12/07/11 11:07:41.576778: _mcd_client_proxy_add_interfaces: org.freedesktop.Telepathy.Client.Empathy.AudioVideo: org.freedesktop.Telepathy.Client.Handler
mcd-DEBUG: 12/07/11 11:07:41.576977: mcd_client_proxy_introspect: org.freedesktop.Telepathy.Client.Empathy.AudioVideo is a Handler but not active
mcd-DEBUG: 12/07/11 11:07:41.577003: mcd_client_registry_ready_cb: org.freedesktop.Telepathy.Client.Empathy.AudioVideo
mcd-DEBUG: 12/07/11 11:07:41.577018: _mcd_client_registry_dec_startup_lock: 3 -> 2
mcd-DEBUG: 12/07/11 11:07:41.628892: on_manager_ready: manager gabble is ready
mcd-DEBUG: 12/07/11 11:07:41.628906: mcd_account_check_parameters: called for gabble/jabber/robrob15_40chat_2efacebook_2ecom0
mcd-DEBUG: 12/07/11 11:07:41.629003: release_load_accounts_lock: called, count is now 1
mcd-DEBUG: 12/07/11 11:07:41.629089: _mcd_account_maybe_autoconnect: gabble/jabber/robrob15_40chat_2efacebook_2ecom0 does not ConnectAutomatically
mcd-DEBUG: 12/07/11 11:07:41.629126: on_manager_ready: manager salut is ready
mcd-DEBUG: 12/07/11 11:07:41.629129: mcd_account_check_parameters: called for salut/local_xmpp/account0
mcd-DEBUG: 12/07/11 11:07:41.629152: release_load_accounts_lock: called, count is now 0
mcd-DEBUG: 12/07/11 11:07:41.631804: _mcd_account_maybe_autoconnect: salut/local_xmpp/account0 does not ConnectAutomatically
mcd-DEBUG: 12/07/11 11:07:41.632025: dbusprop_get_all: org.freedesktop.Telepathy.AccountManager
mcd-DEBUG: 12/07/11 11:07:41.632039: get_valid_accounts: called
mcd-DEBUG: 12/07/11 11:07:41.632081: get_invalid_accounts: called
mcd-DEBUG: 12/07/11 11:07:41.632091: mcd_dbus_get_interfaces: called
mcd-DEBUG: 12/07/11 11:07:41.741228: dbusprop_get_all: org.freedesktop.Telepathy.AccountManager
mcd-DEBUG: 12/07/11 11:07:41.741240: get_valid_accounts: called
mcd-DEBUG: 12/07/11 11:07:41.741266: get_invalid_accounts: called
mcd-DEBUG: 12/07/11 11:07:41.741276: mcd_dbus_get_interfaces: called
mcd-DEBUG: 12/07/11 11:07:41.759099: dbusprop_get_all: org.freedesktop.Telepathy.Account
mcd-DEBUG: 12/07/11 11:07:41.759109: mcd_dbus_get_interfaces: called
mcd-DEBUG: 12/07/11 11:07:41.759135: mcd_dbus_get_interfaces: skipping inactive optional iface org.freedesktop.Telepathy.Account.Interface.ExternalPasswordStorage.DRAFT
mcd-DEBUG: 12/07/11 11:07:41.759186: _mcd_account_dup_parameters: called
mcd-DEBUG: 12/07/11 11:07:41.759373: get_connect_automatically: called for gabble/jabber/robrob15_40chat_2efacebook_2ecom0
mcd-DEBUG: 12/07/11 11:07:41.760328: dbusprop_get_all: org.freedesktop.Telepathy.Account
mcd-DEBUG: 12/07/11 11:07:41.760334: mcd_dbus_get_interfaces: called
mcd-DEBUG: 12/07/11 11:07:41.760344: mcd_dbus_get_interfaces: skipping inactive optional iface org.freedesktop.Telepathy.Account.Interface.ExternalPasswordStorage.DRAFT
mcd-DEBUG: 12/07/11 11:07:41.760375: _mcd_account_dup_parameters: called
mcd-DEBUG: 12/07/11 11:07:41.760510: get_connect_automatically: called for gabble/jabber/robrob15_40chat_2efacebook_2ecom0
mcd-DEBUG: 12/07/11 11:07:41.772150: dbusprop_get_all: org.freedesktop.Telepathy.Account
mcd-DEBUG: 12/07/11 11:07:41.772161: mcd_dbus_get_interfaces: called
mcd-DEBUG: 12/07/11 11:07:41.772177: mcd_dbus_get_interfaces: skipping inactive optional iface org.freedesktop.Telepathy.Account.Interface.ExternalPasswordStorage.DRAFT
mcd-DEBUG: 12/07/11 11:07:41.772232: _mcd_account_dup_parameters: called
mcd-DEBUG: 12/07/11 11:07:41.772324: get_connect_automatically: called for salut/local_xmpp/account0
mcd-DEBUG: 12/07/11 11:07:41.778193: dbusprop_get_all: org.freedesktop.Telepathy.Account
mcd-DEBUG: 12/07/11 11:07:41.778206: mcd_dbus_get_interfaces: called
mcd-DEBUG: 12/07/11 11:07:41.778234: mcd_dbus_get_interfaces: skipping inactive optional iface org.freedesktop.Telepathy.Account.Interface.ExternalPasswordStorage.DRAFT
mcd-DEBUG: 12/07/11 11:07:41.778292: _mcd_account_dup_parameters: called
mcd-DEBUG: 12/07/11 11:07:41.778382: get_connect_automatically: called for salut/local_xmpp/account0
mcd-DEBUG: 12/07/11 11:07:41.918373: _mcd_client_registry_found_name: Registering client org.freedesktop.Telepathy.Client.Empathy.CallObserver
mcd-DEBUG: 12/07/11 11:07:41.918534: mcd_client_proxy_constructed: org.freedesktop.Telepathy.Client.Empathy.CallObserver
mcd-DEBUG: 12/07/11 11:07:41.918664: _mcd_client_registry_inc_startup_lock: 2 -> 3
mcd-DEBUG: 12/07/11 11:07:41.918807: mcd_client_proxy_introspect: No .client file for org.freedesktop.Telepathy.Client.Empathy.CallObserver. Ask on D-Bus.
mcd-DEBUG: 12/07/11 11:07:41.940134: _mcd_client_registry_found_name: Registering client org.freedesktop.Telepathy.Client.Empathy.EventManager
mcd-DEBUG: 12/07/11 11:07:41.940385: mcd_client_proxy_constructed: org.freedesktop.Telepathy.Client.Empathy.EventManager
mcd-DEBUG: 12/07/11 11:07:41.940584: _mcd_client_registry_inc_startup_lock: 3 -> 4
mcd-DEBUG: 12/07/11 11:07:41.940778: mcd_client_proxy_introspect: No .client file for org.freedesktop.Telepathy.Client.Empathy.EventManager. Ask on D-Bus.
mcd-DEBUG: 12/07/11 11:07:41.951934: _mcd_client_registry_found_name: Registering client org.freedesktop.Telepathy.Client.Empathy.AuthEventManager
mcd-DEBUG: 12/07/11 11:07:41.952100: mcd_client_proxy_constructed: org.freedesktop.Telepathy.Client.Empathy.AuthEventManager
mcd-DEBUG: 12/07/11 11:07:41.952230: _mcd_client_registry_inc_startup_lock: 4 -> 5
mcd-DEBUG: 12/07/11 11:07:41.952359: mcd_client_proxy_introspect: No .client file for org.freedesktop.Telepathy.Client.Empathy.AuthEventManager. Ask on D-Bus.
mcd-DEBUG: 12/07/11 11:07:42.172523: _mcd_client_proxy_handler_get_all_cb: org.freedesktop.Telepathy.Client.Empathy.FileTransfer has 1 HandlerChannelFilter entries
mcd-DEBUG: 12/07/11 11:07:42.172550: _mcd_client_proxy_handler_get_all_cb: org.freedesktop.Telepathy.Client.Empathy.FileTransfer has BypassApproval=F
mcd-DEBUG: 12/07/11 11:07:42.172557: _mcd_client_proxy_handler_get_all_cb: org.freedesktop.Telepathy.Client.Empathy.FileTransfer has BypassObservers=F
mcd-DEBUG: 12/07/11 11:07:42.172584: mcd_client_registry_ready_cb: org.freedesktop.Telepathy.Client.Empathy.FileTransfer
mcd-DEBUG: 12/07/11 11:07:42.172594: _mcd_client_registry_dec_startup_lock: 5 -> 4
mcd-DEBUG: 12/07/11 11:07:42.173021: _mcd_client_proxy_add_interfaces: org.freedesktop.Telepathy.Client.Empathy.ChatroomManager._3a1_2e70.n0: org.freedesktop.Telepathy.Client.Observer
mcd-DEBUG: 12/07/11 11:07:42.173031: _mcd_client_proxy_get_interfaces_cb: Client org.freedesktop.Telepathy.Client.Empathy.ChatroomManager._3a1_2e70.n0
mcd-DEBUG: 12/07/11 11:07:42.173038: _mcd_client_proxy_get_interfaces_cb: org.freedesktop.Telepathy.Client.Empathy.ChatroomManager._3a1_2e70.n0 is an Observer
mcd-DEBUG: 12/07/11 11:07:42.174860: dbusprop_get_all: org.freedesktop.Telepathy.Account
mcd-DEBUG: 12/07/11 11:07:42.174870: mcd_dbus_get_interfaces: called
mcd-DEBUG: 12/07/11 11:07:42.174882: mcd_dbus_get_interfaces: skipping inactive optional iface org.freedesktop.Telepathy.Account.Interface.ExternalPasswordStorage.DRAFT
mcd-DEBUG: 12/07/11 11:07:42.174966: _mcd_account_dup_parameters: called
mcd-DEBUG: 12/07/11 11:07:42.175129: get_connect_automatically: called for gabble/jabber/robrob15_40chat_2efacebook_2ecom0
mcd-DEBUG: 12/07/11 11:07:42.175967: dbusprop_get_all: org.freedesktop.Telepathy.Account
mcd-DEBUG: 12/07/11 11:07:42.175973: mcd_dbus_get_interfaces: called
mcd-DEBUG: 12/07/11 11:07:42.175982: mcd_dbus_get_interfaces: skipping inactive optional iface org.freedesktop.Telepathy.Account.Interface.ExternalPasswordStorage.DRAFT
mcd-DEBUG: 12/07/11 11:07:42.176012: _mcd_account_dup_parameters: called
mcd-DEBUG: 12/07/11 11:07:42.176148: get_connect_automatically: called for gabble/jabber/robrob15_40chat_2efacebook_2ecom0
mcd-DEBUG: 12/07/11 11:07:42.177776: dbusprop_get_all: org.freedesktop.Telepathy.Account
mcd-DEBUG: 12/07/11 11:07:42.177783: mcd_dbus_get_interfaces: called
mcd-DEBUG: 12/07/11 11:07:42.177793: mcd_dbus_get_interfaces: skipping inactive optional iface org.freedesktop.Telepathy.Account.Interface.ExternalPasswordStorage.DRAFT
mcd-DEBUG: 12/07/11 11:07:42.177839: _mcd_account_dup_parameters: called
mcd-DEBUG: 12/07/11 11:07:42.177916: get_connect_automatically: called for salut/local_xmpp/account0
mcd-DEBUG: 12/07/11 11:07:42.178694: dbusprop_get_all: org.freedesktop.Telepathy.Account
mcd-DEBUG: 12/07/11 11:07:42.178702: mcd_dbus_get_interfaces: called
mcd-DEBUG: 12/07/11 11:07:42.178709: mcd_dbus_get_interfaces: skipping inactive optional iface org.freedesktop.Telepathy.Account.Interface.ExternalPasswordStorage.DRAFT
mcd-DEBUG: 12/07/11 11:07:42.178744: _mcd_account_dup_parameters: called
mcd-DEBUG: 12/07/11 11:07:42.178812: get_connect_automatically: called for salut/local_xmpp/account0
mcd-DEBUG: 12/07/11 11:07:42.180609: _mcd_client_proxy_add_interfaces: org.freedesktop.Telepathy.Client.Empathy.CallObserver: org.freedesktop.Telepathy.Client.Observer
mcd-DEBUG: 12/07/11 11:07:42.180620: _mcd_client_proxy_get_interfaces_cb: Client org.freedesktop.Telepathy.Client.Empathy.CallObserver
mcd-DEBUG: 12/07/11 11:07:42.180629: _mcd_client_proxy_get_interfaces_cb: org.freedesktop.Telepathy.Client.Empathy.CallObserver is an Observer
mcd-DEBUG: 12/07/11 11:07:42.330714: _mcd_client_proxy_add_interfaces: org.freedesktop.Telepathy.Client.Empathy.EventManager: org.freedesktop.Telepathy.Client.Approver
mcd-DEBUG: 12/07/11 11:07:42.330730: _mcd_client_proxy_get_interfaces_cb: Client org.freedesktop.Telepathy.Client.Empathy.EventManager
mcd-DEBUG: 12/07/11 11:07:42.330739: _mcd_client_proxy_get_interfaces_cb: org.freedesktop.Telepathy.Client.Empathy.EventManager is an Approver
mcd-DEBUG: 12/07/11 11:07:42.330910: _mcd_client_proxy_add_interfaces: org.freedesktop.Telepathy.Client.Empathy.AuthEventManager: org.freedesktop.Telepathy.Client.Approver
mcd-DEBUG: 12/07/11 11:07:42.331100: _mcd_client_proxy_get_interfaces_cb: Client org.freedesktop.Telepathy.Client.Empathy.AuthEventManager
mcd-DEBUG: 12/07/11 11:07:42.331110: _mcd_client_proxy_get_interfaces_cb: org.freedesktop.Telepathy.Client.Empathy.AuthEventManager is an Approver
mcd-DEBUG: 12/07/11 11:07:42.332134: _mcd_client_proxy_observer_get_all_cb: org.freedesktop.Telepathy.Client.Empathy.ChatroomManager._3a1_2e70.n0 has DelayApprovers=F
mcd-DEBUG: 12/07/11 11:07:42.332145: _mcd_client_proxy_observer_get_all_cb: org.freedesktop.Telepathy.Client.Empathy.ChatroomManager._3a1_2e70.n0 has 1 ObserverChannelFilter entries
mcd-DEBUG: 12/07/11 11:07:42.332160: _mcd_client_proxy_observer_get_all_cb: org.freedesktop.Telepathy.Client.Empathy.ChatroomManager._3a1_2e70.n0 has Recover=T
mcd-DEBUG: 12/07/11 11:07:42.332170: mcd_client_registry_ready_cb: org.freedesktop.Telepathy.Client.Empathy.ChatroomManager._3a1_2e70.n0
mcd-DEBUG: 12/07/11 11:07:42.332180: _mcd_client_registry_dec_startup_lock: 4 -> 3
mcd-DEBUG: 12/07/11 11:07:42.332201: mcd_dispatcher_client_needs_recovery_cb: called
mcd-DEBUG: 12/07/11 11:07:42.377005: _mcd_client_proxy_observer_get_all_cb: org.freedesktop.Telepathy.Client.Empathy.CallObserver has DelayApprovers=T
mcd-DEBUG: 12/07/11 11:07:42.377026: _mcd_client_proxy_observer_get_all_cb: org.freedesktop.Telepathy.Client.Empathy.CallObserver has 2 ObserverChannelFilter entries
mcd-DEBUG: 12/07/11 11:07:42.377064: _mcd_client_proxy_observer_get_all_cb: org.freedesktop.Telepathy.Client.Empathy.CallObserver has Recover=T
mcd-DEBUG: 12/07/11 11:07:42.377085: mcd_client_registry_ready_cb: org.freedesktop.Telepathy.Client.Empathy.CallObserver
mcd-DEBUG: 12/07/11 11:07:42.377101: _mcd_client_registry_dec_startup_lock: 3 -> 2
mcd-DEBUG: 12/07/11 11:07:42.377124: mcd_dispatcher_client_needs_recovery_cb: called
mcd-DEBUG: 12/07/11 11:07:42.378617: get_mcddbusprop: org.freedesktop.Telepathy.Account, RequestedPresence
mcd-DEBUG: 12/07/11 11:07:42.378633: set_requested_presence: called for gabble/jabber/robrob15_40chat_2efacebook_2ecom0
mcd-DEBUG: 12/07/11 11:07:42.378652: set_requested_presence: setting requested presence: 2, available, 
mcd-DEBUG: 12/07/11 11:07:42.378669: mcd_account_request_presence_int: Requested presence: 2 available 
mcd-DEBUG: 12/07/11 11:07:42.378690: mcd_account_changed_property: called: ChangingPresence
mcd-DEBUG: 12/07/11 11:07:42.378699: mcd_account_changed_property: First changed property
mcd-DEBUG: 12/07/11 11:07:42.378730: _mcd_account_dup_parameters: called
mcd-DEBUG: 12/07/11 11:07:42.379472: _mcd_mission_set_parent: child = 0x9e11c80, parent = 0x9e0f840
mcd-DEBUG: 12/07/11 11:07:42.379514: mcd_manager_create_connection: Created a connection 0x9e11c80 for account: gabble/jabber/robrob15_40chat_2efacebook_2ecom0
mcd-DEBUG: 12/07/11 11:07:42.379533: _mcd_connection_connect: called for 0x9e11c80, account gabble/jabber/robrob15_40chat_2efacebook_2ecom0
mcd-DEBUG: 12/07/11 11:07:42.379547: _mcd_connection_connect_with_params: Trying connect account: gabble/jabber/robrob15_40chat_2efacebook_2ecom0
mcd-DEBUG: 12/07/11 11:07:42.379573: _mcd_account_set_connection_status: gabble/jabber/robrob15_40chat_2efacebook_2ecom0: 1 because 1
mcd-DEBUG: 12/07/11 11:07:42.379582: mcd_account_freeze_properties: gabble/jabber/robrob15_40chat_2efacebook_2ecom0
mcd-DEBUG: 12/07/11 11:07:42.379606: _mcd_account_set_connection_status: changing connection status from 2 to 1
mcd-DEBUG: 12/07/11 11:07:42.379616: mcd_account_changed_property: called: Connection
mcd-DEBUG: 12/07/11 11:07:42.379837: mcd_account_changed_property: called: ConnectionStatus
mcd-DEBUG: 12/07/11 11:07:42.379851: mcd_account_changed_property: called: ConnectionStatusReason
mcd-DEBUG: 12/07/11 11:07:42.379863: mcd_account_changed_property: called: ConnectionError
mcd-DEBUG: 12/07/11 11:07:42.379892: mcd_account_changed_property: called: ConnectionErrorDetails
mcd-DEBUG: 12/07/11 11:07:42.379919: mcd_account_thaw_properties: gabble/jabber/robrob15_40chat_2efacebook_2ecom0
mcd-DEBUG: 12/07/11 11:07:42.379928: emit_property_changed: called
mcd-DEBUG: 12/07/11 11:07:42.384200: mcd_account_changed_property: called: RequestedPresence
mcd-DEBUG: 12/07/11 11:07:42.384210: mcd_account_changed_property: First changed property
mcd-DEBUG: 12/07/11 11:07:42.386614: get_mcddbusprop: org.freedesktop.Telepathy.Account, RequestedPresence
mcd-DEBUG: 12/07/11 11:07:42.386626: set_requested_presence: called for salut/local_xmpp/account0
mcd-DEBUG: 12/07/11 11:07:42.386635: set_requested_presence: setting requested presence: 2, available, 
mcd-DEBUG: 12/07/11 11:07:42.386641: mcd_account_request_presence_int: Requested presence: 2 available 
mcd-DEBUG: 12/07/11 11:07:42.386646: mcd_account_changed_property: called: ChangingPresence
mcd-DEBUG: 12/07/11 11:07:42.386651: mcd_account_changed_property: First changed property
mcd-DEBUG: 12/07/11 11:07:42.386666: _mcd_account_dup_parameters: called
mcd-DEBUG: 12/07/11 11:07:42.386807: _mcd_mission_set_parent: child = 0x9e11cf8, parent = 0x9e0f880
mcd-DEBUG: 12/07/11 11:07:42.386826: mcd_manager_create_connection: Created a connection 0x9e11cf8 for account: salut/local_xmpp/account0
mcd-DEBUG: 12/07/11 11:07:42.386831: _mcd_connection_connect: called for 0x9e11cf8, account salut/local_xmpp/account0
mcd-DEBUG: 12/07/11 11:07:42.386835: _mcd_connection_connect_with_params: Trying connect account: salut/local_xmpp/account0
mcd-DEBUG: 12/07/11 11:07:42.386845: _mcd_account_set_connection_status: salut/local_xmpp/account0: 1 because 1
mcd-DEBUG: 12/07/11 11:07:42.386848: mcd_account_freeze_properties: salut/local_xmpp/account0
mcd-DEBUG: 12/07/11 11:07:42.386852: _mcd_account_set_connection_status: changing connection status from 2 to 1
mcd-DEBUG: 12/07/11 11:07:42.386858: mcd_account_changed_property: called: Connection
mcd-DEBUG: 12/07/11 11:07:42.386979: mcd_account_changed_property: called: ConnectionStatus
mcd-DEBUG: 12/07/11 11:07:42.386985: mcd_account_changed_property: called: ConnectionStatusReason
mcd-DEBUG: 12/07/11 11:07:42.386990: mcd_account_changed_property: called: ConnectionError
mcd-DEBUG: 12/07/11 11:07:42.387005: mcd_account_changed_property: called: ConnectionErrorDetails
mcd-DEBUG: 12/07/11 11:07:42.387017: mcd_account_thaw_properties: salut/local_xmpp/account0
mcd-DEBUG: 12/07/11 11:07:42.387021: emit_property_changed: called
mcd-DEBUG: 12/07/11 11:07:42.391259: mcd_account_changed_property: called: RequestedPresence
mcd-DEBUG: 12/07/11 11:07:42.391268: mcd_account_changed_property: First changed property
mcd-DEBUG: 12/07/11 11:07:42.391562: get_mcddbusprop: org.freedesktop.Telepathy.Account, RequestedPresence
mcd-DEBUG: 12/07/11 11:07:42.391572: set_requested_presence: called for gabble/jabber/robrob15_40chat_2efacebook_2ecom0
mcd-DEBUG: 12/07/11 11:07:42.391580: set_requested_presence: setting requested presence: 2, available, 
mcd-DEBUG: 12/07/11 11:07:42.391586: mcd_account_request_presence_int: Requested presence: 2 available 
mcd-DEBUG: 12/07/11 11:07:42.391591: _mcd_connection_request_presence: Presence requested: 2
mcd-DEBUG: 12/07/11 11:07:42.391603: _mcd_connection_set_presence: tp_conn is NULL
mcd-DEBUG: 12/07/11 11:07:42.391611: _mcd_connection_attempt: called for 0x9e11c80, account gabble/jabber/robrob15_40chat_2efacebook_2ecom0
mcd-DEBUG: 12/07/11 11:07:42.391616: _mcd_connection_attempt: Not connecting because not disconnected (1)
mcd-DEBUG: 12/07/11 11:07:42.395231: emit_property_changed: called
mcd-DEBUG: 12/07/11 11:07:42.395451: get_mcddbusprop: org.freedesktop.Telepathy.Account, RequestedPresence
mcd-DEBUG: 12/07/11 11:07:42.395458: set_requested_presence: called for salut/local_xmpp/account0
mcd-DEBUG: 12/07/11 11:07:42.395467: set_requested_presence: setting requested presence: 2, available, 
mcd-DEBUG: 12/07/11 11:07:42.395473: mcd_account_request_presence_int: Requested presence: 2 available 
mcd-DEBUG: 12/07/11 11:07:42.395478: _mcd_connection_request_presence: Presence requested: 2
mcd-DEBUG: 12/07/11 11:07:42.395483: _mcd_connection_set_presence: tp_conn is NULL
mcd-DEBUG: 12/07/11 11:07:42.395488: _mcd_connection_attempt: called for 0x9e11cf8, account salut/local_xmpp/account0
mcd-DEBUG: 12/07/11 11:07:42.395492: _mcd_connection_attempt: Not connecting because not disconnected (1)
mcd-DEBUG: 12/07/11 11:07:42.395682: mcd_client_registry_ready_cb: org.freedesktop.Telepathy.Client.Empathy.EventManager
mcd-DEBUG: 12/07/11 11:07:42.395693: _mcd_client_registry_dec_startup_lock: 2 -> 1
mcd-DEBUG: 12/07/11 11:07:42.398583: mcd_client_registry_ready_cb: org.freedesktop.Telepathy.Client.Empathy.AuthEventManager
mcd-DEBUG: 12/07/11 11:07:42.398600: _mcd_client_registry_dec_startup_lock: 1 -> 0
mcd-DEBUG: 12/07/11 11:07:42.398607: mcd_dispatcher_client_registry_ready_cb: All initial clients have been inspected
mcd-DEBUG: 12/07/11 11:07:42.401937: emit_property_changed: called
mcd-DEBUG: 12/07/11 11:07:42.811434: request_connection_cb: created /org/freedesktop/Telepathy/Connection/salut/local_xmpp/rob
mcd-DEBUG: 12/07/11 11:07:42.812407: _mcd_connection_set_tp_connection: new connection is 0x9e2f848
mcd-DEBUG: 12/07/11 11:07:42.812417: mcd_account_changed_property: called: Connection
mcd-DEBUG: 12/07/11 11:07:42.812422: mcd_account_changed_property: First changed property
mcd-DEBUG: 12/07/11 11:07:42.813817: on_connection_status_changed: status_changed called from tp (2)
mcd-DEBUG: 12/07/11 11:07:42.814615: _mcd_connection_update_client_caps: Sending client caps to connection
mcd-DEBUG: 12/07/11 11:07:42.817203: mcd_connection_early_get_statuses_cb: /org/freedesktop/Telepathy/Connection/salut/local_xmpp/rob: Early Get(Statuses) succeeded
mcd-DEBUG: 12/07/11 11:07:42.817445: presence_get_statuses_cb: account salut/local_xmpp/account0:
mcd-DEBUG: 12/07/11 11:07:42.817451: presence_get_statuses_cb:   available
mcd-DEBUG: 12/07/11 11:07:42.817456: presence_get_statuses_cb:   dnd
mcd-DEBUG: 12/07/11 11:07:42.817461: presence_get_statuses_cb:   away
mcd-DEBUG: 12/07/11 11:07:42.817470: _mcd_connection_set_presence: Setting status 'available' of type 2 ('available' was requested)
mcd-DEBUG: 12/07/11 11:07:42.817991: _mcd_dispatcher_add_connection: 0x9e024a0: 0x9e11cf8 (/org/freedesktop/Telepathy/Connection/salut/local_xmpp/rob)
mcd-DEBUG: 12/07/11 11:07:42.818094: _mcd_connection_start_dispatching: 0x9e11cf8
mcd-DEBUG: 12/07/11 11:07:42.818545: _mcd_connection_update_client_caps: Sending client caps to connection
mcd-DEBUG: 12/07/11 11:07:42.820841: mcd_connection_done_task_before_connect: /org/freedesktop/Telepathy/Connection/salut/local_xmpp/rob: Calling Connect()
mcd-DEBUG: 12/07/11 11:07:42.822691: emit_property_changed: called
mcd-DEBUG: 12/07/11 11:07:42.866636: on_connection_status_changed: status_changed called from tp (1)
mcd-DEBUG: 12/07/11 11:07:42.866655: _mcd_account_set_connection_status: salut/local_xmpp/account0: 1 because 1
mcd-DEBUG: 12/07/11 11:07:42.866658: mcd_account_freeze_properties: salut/local_xmpp/account0
mcd-DEBUG: 12/07/11 11:07:42.866669: mcd_account_changed_property: called: Connection
mcd-DEBUG: 12/07/11 11:07:42.866673: mcd_account_changed_property: First changed property
mcd-DEBUG: 12/07/11 11:07:42.866869: mcd_account_changed_property: called: ConnectionStatus
mcd-DEBUG: 12/07/11 11:07:42.866877: mcd_account_changed_property: called: ConnectionStatusReason
mcd-DEBUG: 12/07/11 11:07:42.866883: mcd_account_changed_property: called: ConnectionError
mcd-DEBUG: 12/07/11 11:07:42.866900: mcd_account_changed_property: called: ConnectionErrorDetails
mcd-DEBUG: 12/07/11 11:07:42.866913: mcd_account_thaw_properties: salut/local_xmpp/account0
mcd-DEBUG: 12/07/11 11:07:42.866946: emit_property_changed: called
mcd-DEBUG: 12/07/11 11:07:42.876765: connect_cb: called for connection 0x9e11cf8
mcd-DEBUG: 12/07/11 11:07:42.882873: request_connection_cb: created /org/freedesktop/Telepathy/Connection/gabble/jabber/robrob15_40chat_2efacebook_2ecom_2fbc2796f1
mcd-DEBUG: 12/07/11 11:07:42.883825: _mcd_connection_set_tp_connection: new connection is 0x9e2f8e8
mcd-DEBUG: 12/07/11 11:07:42.883833: mcd_account_changed_property: called: Connection
mcd-DEBUG: 12/07/11 11:07:42.883837: mcd_account_changed_property: First changed property
mcd-DEBUG: 12/07/11 11:07:42.885262: on_connection_status_changed: status_changed called from tp (2)
mcd-DEBUG: 12/07/11 11:07:42.886110: _mcd_connection_update_client_caps: Sending client caps to connection
mcd-DEBUG: 12/07/11 11:07:42.890450: mcd_connection_early_get_statuses_cb: /org/freedesktop/Telepathy/Connection/gabble/jabber/robrob15_40chat_2efacebook_2ecom_2fbc2796f1: Early Get(Statuses) succeeded
mcd-DEBUG: 12/07/11 11:07:42.890460: presence_get_statuses_cb: account gabble/jabber/robrob15_40chat_2efacebook_2ecom0:
mcd-DEBUG: 12/07/11 11:07:42.890465: presence_get_statuses_cb:   offline
mcd-DEBUG: 12/07/11 11:07:42.890471: presence_get_statuses_cb:   chat
mcd-DEBUG: 12/07/11 11:07:42.890475: presence_get_statuses_cb:   xa
mcd-DEBUG: 12/07/11 11:07:42.890480: presence_get_statuses_cb:   unknown
mcd-DEBUG: 12/07/11 11:07:42.890484: presence_get_statuses_cb:   error
mcd-DEBUG: 12/07/11 11:07:42.890487: presence_get_statuses_cb:   hidden
mcd-DEBUG: 12/07/11 11:07:42.890491: presence_get_statuses_cb:   available
mcd-DEBUG: 12/07/11 11:07:42.890496: presence_get_statuses_cb:   away
mcd-DEBUG: 12/07/11 11:07:42.890501: presence_get_statuses_cb:   dnd
mcd-DEBUG: 12/07/11 11:07:42.890511: _mcd_connection_set_presence: Setting status 'available' of type 2 ('available' was requested)
mcd-DEBUG: 12/07/11 11:07:42.891062: _mcd_dispatcher_add_connection: 0x9e024a0: 0x9e11c80 (/org/freedesktop/Telepathy/Connection/gabble/jabber/robrob15_40chat_2efacebook_2ecom_2fbc2796f1)
mcd-DEBUG: 12/07/11 11:07:42.891185: _mcd_connection_start_dispatching: 0x9e11c80
mcd-DEBUG: 12/07/11 11:07:42.891618: _mcd_connection_update_client_caps: Sending client caps to connection
mcd-DEBUG: 12/07/11 11:07:42.894529: mcd_connection_done_task_before_connect: /org/freedesktop/Telepathy/Connection/gabble/jabber/robrob15_40chat_2efacebook_2ecom_2fbc2796f1: Calling Connect()
mcd-DEBUG: 12/07/11 11:07:42.894794: emit_property_changed: called
mcd-DEBUG: 12/07/11 11:07:42.950575: on_connection_status_changed: status_changed called from tp (1)
mcd-DEBUG: 12/07/11 11:07:42.950589: _mcd_account_set_connection_status: gabble/jabber/robrob15_40chat_2efacebook_2ecom0: 1 because 1
mcd-DEBUG: 12/07/11 11:07:42.950594: mcd_account_freeze_properties: gabble/jabber/robrob15_40chat_2efacebook_2ecom0
mcd-DEBUG: 12/07/11 11:07:42.950606: mcd_account_changed_property: called: Connection
mcd-DEBUG: 12/07/11 11:07:42.950609: mcd_account_changed_property: First changed property
mcd-DEBUG: 12/07/11 11:07:42.950784: mcd_account_changed_property: called: ConnectionStatus
mcd-DEBUG: 12/07/11 11:07:42.950790: mcd_account_changed_property: called: ConnectionStatusReason
mcd-DEBUG: 12/07/11 11:07:42.950797: mcd_account_changed_property: called: ConnectionError
mcd-DEBUG: 12/07/11 11:07:42.950815: mcd_account_changed_property: called: ConnectionErrorDetails
mcd-DEBUG: 12/07/11 11:07:42.950826: mcd_account_thaw_properties: gabble/jabber/robrob15_40chat_2efacebook_2ecom0
mcd-DEBUG: 12/07/11 11:07:42.950830: emit_property_changed: called
mcd-DEBUG: 12/07/11 11:07:42.953572: connect_cb: called for connection 0x9e11c80
mcd-DEBUG: 12/07/11 11:07:43.664386: on_connection_status_changed: status_changed called from tp (0)
mcd-DEBUG: 12/07/11 11:07:43.664400: _mcd_account_set_connection_status: salut/local_xmpp/account0: 0 because 1
mcd-DEBUG: 12/07/11 11:07:43.664403: mcd_account_freeze_properties: salut/local_xmpp/account0
mcd-DEBUG: 12/07/11 11:07:43.664410: _mcd_account_dup_parameters: called
mcd-DEBUG: 12/07/11 11:07:43.664469: _mcd_account_set_connection_status: clearing connection error details
mcd-DEBUG: 12/07/11 11:07:43.664474: _mcd_account_set_connection_status: changing connection status from 1 to 0
mcd-DEBUG: 12/07/11 11:07:43.664482: mcd_account_changed_property: called: Connection
mcd-DEBUG: 12/07/11 11:07:43.664485: mcd_account_changed_property: First changed property
mcd-DEBUG: 12/07/11 11:07:43.664690: mcd_account_changed_property: called: ConnectionStatus
mcd-DEBUG: 12/07/11 11:07:43.664695: mcd_account_changed_property: called: ConnectionStatusReason
mcd-DEBUG: 12/07/11 11:07:43.664701: mcd_account_changed_property: called: ConnectionError
mcd-DEBUG: 12/07/11 11:07:43.664714: mcd_account_changed_property: called: ConnectionErrorDetails
mcd-DEBUG: 12/07/11 11:07:43.664725: mcd_account_thaw_properties: salut/local_xmpp/account0
mcd-DEBUG: 12/07/11 11:07:43.664729: emit_property_changed: called
mcd-DEBUG: 12/07/11 11:07:43.664891: on_connection_status_changed: setting probation timer (120) seconds, for /org/freedesktop/Telepathy/Connection/salut/local_xmpp/rob
mcd-DEBUG: 12/07/11 11:07:43.664997: on_connection_ready: connection is ready
mcd-DEBUG: 12/07/11 11:07:43.665379: _mcd_account_get_avatar_filename: data dir: /home/rob/.mission-control/accounts/salut/local_xmpp/account0
mcd-DEBUG: 12/07/11 11:07:43.665608: request_unrequested_channels: called
mcd-DEBUG: 12/07/11 11:07:43.665621: _mcd_account_set_connection_status: salut/local_xmpp/account0: 0 because 1
mcd-DEBUG: 12/07/11 11:07:43.665626: mcd_account_freeze_properties: salut/local_xmpp/account0
mcd-DEBUG: 12/07/11 11:07:43.665630: _mcd_account_dup_parameters: called
mcd-DEBUG: 12/07/11 11:07:43.665672: _mcd_account_set_connection_status: clearing connection error details
mcd-DEBUG: 12/07/11 11:07:43.665677: mcd_account_thaw_properties: salut/local_xmpp/account0
mcd-DEBUG: 12/07/11 11:07:43.665802: _mcd_connection_set_nickname: setting nickname 'Rob' using Aliasing
mcd-DEBUG: 12/07/11 11:07:43.685405: _mcd_mission_set_parent: child = 0x9e0fcc8, parent = 0x9e11cf8
mcd-DEBUG: 12/07/11 11:07:43.685436: _mcd_dispatcher_take_channels: requested channel 0x9e0fcc8 (only): /org/freedesktop/Telepathy/Connection/salut/local_xmpp/rob/ContactChannel/publish
mcd-DEBUG: 12/07/11 11:07:43.685444: _mcd_dispatcher_enter_state_machine: CTXREF11 on 0x9e44c48
mcd-DEBUG: 12/07/11 11:07:43.685450: _mcd_dispatcher_enter_state_machine: new dispatcher context 0x9e44c48 for requested channel 0x9e0fcc8 (only): /org/freedesktop/Telepathy/Connection/salut/local_xmpp/rob/ContactChannel/publish
mcd-DEBUG: 12/07/11 11:07:43.685620: mcd_dispatch_operation_constructor: do0/0x9e151d0: needs_approval=F
mcd-DEBUG: 12/07/11 11:07:43.685662: plugin_iface_init: called
mcd-DEBUG: 12/07/11 11:07:43.685679: _mcd_plugin_dispatch_operation_init: 0x9e13660
mcd-DEBUG: 12/07/11 11:07:43.685689: _mcd_plugin_dispatch_operation_new: 0x9e13660 (for 0x9e151d0)
mcd-DEBUG: 12/07/11 11:07:43.685707: _mcd_dispatcher_enter_state_machine: entering state machine for context 0x9e44c48
mcd-DEBUG: 12/07/11 11:07:43.685713: mcd_dispatcher_context_ref: CTXREF01 on 0x9e44c48 (ref = 1)
mcd-DEBUG: 12/07/11 11:07:43.685720: _mcd_dispatch_operation_run_clients: do0 0x9e151d0
mcd-DEBUG: 12/07/11 11:07:43.685724: _mcd_dispatch_operation_run_clients: Running observers
mcd-DEBUG: 12/07/11 11:07:43.685760: _mcd_dispatch_operation_run_clients: All necessary observers invoked
mcd-DEBUG: 12/07/11 11:07:43.685764: _mcd_dispatch_operation_run_clients: Checking finished/locks
mcd-DEBUG: 12/07/11 11:07:43.685774: _mcd_plugin_dispatch_operation_observers_finished: 0x9e13660
mcd-DEBUG: 12/07/11 11:07:43.685780: _mcd_dispatch_operation_check_client_locks: only observing
mcd-DEBUG: 12/07/11 11:07:43.685785: mcd_dispatcher_context_unref: CTXREF01 on 0x9e44c48 (ref = 2)
mcd-DEBUG: 12/07/11 11:07:43.685789: mcd_dispatcher_context_unref: CTXREF11 on 0x9e44c48 (ref = 1)
mcd-DEBUG: 12/07/11 11:07:43.685791: mcd_dispatcher_context_unref: freeing the context 0x9e44c48
mcd-DEBUG: 12/07/11 11:07:43.685815: _mcd_dispatch_operation_check_client_locks: only observing
mcd-DEBUG: 12/07/11 11:07:43.685822: plugin_do_finalize: 0x9e13660
mcd-DEBUG: 12/07/11 11:07:43.696854: _mcd_mission_set_parent: child = 0x9e0fb00, parent = 0x9e11cf8
mcd-DEBUG: 12/07/11 11:07:43.696875: _mcd_dispatcher_take_channels: requested channel 0x9e0fb00 (only): /org/freedesktop/Telepathy/Connection/salut/local_xmpp/rob/ContactChannel/subscribe
mcd-DEBUG: 12/07/11 11:07:43.696881: _mcd_dispatcher_enter_state_machine: CTXREF11 on 0x9df82b8
mcd-DEBUG: 12/07/11 11:07:43.696887: _mcd_dispatcher_enter_state_machine: new dispatcher context 0x9df82b8 for requested channel 0x9e0fb00 (only): /org/freedesktop/Telepathy/Connection/salut/local_xmpp/rob/ContactChannel/subscribe
mcd-DEBUG: 12/07/11 11:07:43.696928: mcd_dispatch_operation_constructor: do1/0x9e15300: needs_approval=F
mcd-DEBUG: 12/07/11 11:07:43.696940: _mcd_plugin_dispatch_operation_init: 0x9e13aa0
mcd-DEBUG: 12/07/11 11:07:43.696949: _mcd_plugin_dispatch_operation_new: 0x9e13aa0 (for 0x9e15300)
mcd-DEBUG: 12/07/11 11:07:43.696960: _mcd_dispatcher_enter_state_machine: entering state machine for context 0x9df82b8
mcd-DEBUG: 12/07/11 11:07:43.696965: mcd_dispatcher_context_ref: CTXREF01 on 0x9df82b8 (ref = 1)
mcd-DEBUG: 12/07/11 11:07:43.696971: _mcd_dispatch_operation_run_clients: do1 0x9e15300
mcd-DEBUG: 12/07/11 11:07:43.696975: _mcd_dispatch_operation_run_clients: Running observers
mcd-DEBUG: 12/07/11 11:07:43.697006: _mcd_dispatch_operation_run_clients: All necessary observers invoked
mcd-DEBUG: 12/07/11 11:07:43.697010: _mcd_dispatch_operation_run_clients: Checking finished/locks
mcd-DEBUG: 12/07/11 11:07:43.697015: _mcd_plugin_dispatch_operation_observers_finished: 0x9e13aa0
mcd-DEBUG: 12/07/11 11:07:43.697021: _mcd_dispatch_operation_check_client_locks: only observing
mcd-DEBUG: 12/07/11 11:07:43.697026: mcd_dispatcher_context_unref: CTXREF01 on 0x9df82b8 (ref = 2)
mcd-DEBUG: 12/07/11 11:07:43.697030: mcd_dispatcher_context_unref: CTXREF11 on 0x9df82b8 (ref = 1)
mcd-DEBUG: 12/07/11 11:07:43.697032: mcd_dispatcher_context_unref: freeing the context 0x9df82b8
mcd-DEBUG: 12/07/11 11:07:43.697052: _mcd_dispatch_operation_check_client_locks: only observing
mcd-DEBUG: 12/07/11 11:07:43.697060: plugin_do_finalize: 0x9e13aa0
mcd-DEBUG: 12/07/11 11:07:43.703964: mcd_account_changed_property: called: CurrentPresence
mcd-DEBUG: 12/07/11 11:07:43.703972: mcd_account_changed_property: First changed property
mcd-DEBUG: 12/07/11 11:07:43.708091: presence_get_statuses_cb: account salut/local_xmpp/account0:
mcd-DEBUG: 12/07/11 11:07:43.708101: presence_get_statuses_cb:   available
mcd-DEBUG: 12/07/11 11:07:43.708106: presence_get_statuses_cb:   dnd
mcd-DEBUG: 12/07/11 11:07:43.708111: presence_get_statuses_cb:   away
mcd-DEBUG: 12/07/11 11:07:43.708121: _mcd_connection_set_presence: Setting status 'available' of type 2 ('available' was requested)
mcd-DEBUG: 12/07/11 11:07:43.708127: mcd_account_changed_property: called: ChangingPresence
mcd-DEBUG: 12/07/11 11:07:43.714849: emit_property_changed: called
mcd-DEBUG: 12/07/11 11:07:43.718210: _mcd_mission_set_parent: child = 0x9e0f800, parent = 0x9e11cf8
mcd-DEBUG: 12/07/11 11:07:43.718233: _mcd_dispatcher_take_channels: unrequested channel 0x9e0f800 (only): /org/freedesktop/Telepathy/Connection/salut/local_xmpp/rob/ContactChannel/known
mcd-DEBUG: 12/07/11 11:07:43.718277: _mcd_dispatcher_take_channels: One channel, which cannot be handled
mcd-DEBUG: 12/07/11 11:07:43.718300: _mcd_tp_channel_should_close: Not destroying 0x9e15398:/org/freedesktop/Telepathy/Connection/salut/local_xmpp/rob/ContactChannel/known, it's a ContactList
mcd-DEBUG: 12/07/11 11:07:43.728734: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:43.733616: _mcd_connection_get_aliases_cb: called
mcd-DEBUG: 12/07/11 11:07:43.737920: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:43.740267: _mcd_account_set_normalized_name: called (rob@talkie)
mcd-DEBUG: 12/07/11 11:07:43.740391: update_storage: MCP:default-gkeyfile -> store salut/local_xmpp/account0.NormalizedName
mcd-DEBUG: 12/07/11 11:07:43.740398: _storage_commit: flushing plugin default-gkeyfile salut/local_xmpp/account0 to long term storage
mcd-DEBUG: 12/07/11 11:07:43.740427: _have_config: checking for /home/rob/.mission-control/accounts/accounts.cfg
mcd-DEBUG: 12/07/11 11:07:43.760601: mcd_account_changed_property: called: NormalizedName
mcd-DEBUG: 12/07/11 11:07:43.760611: mcd_account_changed_property: First changed property
mc-plugins-DEBUG: 12/07/11 11:07:43.740354: mcp_account_storage_set: default-gkeyfile: 
mc-plugins-DEBUG: 12/07/11 11:07:43.740420: mcp_account_storage_commit_one: default-gkeyfile: called for salut/local_xmpp/account0
mcd-DEBUG: 12/07/11 11:07:43.761866: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:43.771250: emit_property_changed: called
mcd-DEBUG: 12/07/11 11:07:43.804616: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:43.834139: on_channel_ready: channel 0x9e0fcc8 is ready
mcd-DEBUG: 12/07/11 11:07:43.835164: on_channel_ready: channel 0x9e0fb00 is ready
mcd-DEBUG: 12/07/11 11:07:43.839104: mcd_account_changed_property: called: ChangingPresence
mcd-DEBUG: 12/07/11 11:07:43.839112: mcd_account_changed_property: First changed property
mcd-DEBUG: 12/07/11 11:07:43.842549: on_channel_ready: channel 0x9e0f800 is ready
mcd-DEBUG: 12/07/11 11:07:43.849709: emit_property_changed: called
mcd-DEBUG: 12/07/11 11:07:44.380892: _mcd_mission_set_parent: child = 0x9e0f900, parent = 0x9e11c80
mcd-DEBUG: 12/07/11 11:07:44.380937: _mcd_dispatcher_take_channels: unrequested channel 0x9e0f900 (only): /org/freedesktop/Telepathy/Connection/gabble/jabber/robrob15_40chat_2efacebook_2ecom_2fbc2796f1/ServerTLSChannel
mcd-DEBUG: 12/07/11 11:07:44.381031: _mcd_dispatcher_take_channels: possible handler(s) found, dispatching 1 channels
mcd-DEBUG: 12/07/11 11:07:44.381041: _mcd_channel_set_status: 0x9e0f900, 3
mcd-DEBUG: 12/07/11 11:07:44.381068: _mcd_dispatcher_enter_state_machine: CTXREF11 on 0x9e33e88
mcd-DEBUG: 12/07/11 11:07:44.381083: _mcd_dispatcher_enter_state_machine: new dispatcher context 0x9e33e88 for unrequested channel 0x9e0f900 (only): /org/freedesktop/Telepathy/Connection/gabble/jabber/robrob15_40chat_2efacebook_2ecom_2fbc2796f1/ServerTLSChannel
mcd-DEBUG: 12/07/11 11:07:44.381195: mcd_dispatch_operation_constructor: do2/0x9e154c8: needs_approval=T
mcd-DEBUG: 12/07/11 11:07:44.381298: _mcd_plugin_dispatch_operation_init: 0x9e578a0
mcd-DEBUG: 12/07/11 11:07:44.381319: _mcd_plugin_dispatch_operation_new: 0x9e578a0 (for 0x9e154c8)
mcd-DEBUG: 12/07/11 11:07:44.381356: _mcd_dispatcher_enter_state_machine: entering state machine for context 0x9e33e88
mcd-DEBUG: 12/07/11 11:07:44.381367: mcd_dispatcher_context_ref: CTXREF01 on 0x9e33e88 (ref = 1)
mcd-DEBUG: 12/07/11 11:07:44.381378: _mcd_dispatch_operation_run_clients: do2 0x9e154c8
mcd-DEBUG: 12/07/11 11:07:44.381392: _mcd_dispatch_operation_handlers_can_bypass_observers: org.freedesktop.Telepathy.Client.Empathy.Auth has BypassObservers=F
mcd-DEBUG: 12/07/11 11:07:44.381401: _mcd_dispatch_operation_run_clients: Running observers
mcd-DEBUG: 12/07/11 11:07:44.381448: _mcd_dispatch_operation_run_clients: All necessary observers invoked
mcd-DEBUG: 12/07/11 11:07:44.381457: _mcd_dispatch_operation_run_clients: Checking finished/locks
mcd-DEBUG: 12/07/11 11:07:44.381467: _mcd_plugin_dispatch_operation_observers_finished: 0x9e578a0
mcd-DEBUG: 12/07/11 11:07:44.381480: _mcd_dispatch_operation_handlers_can_bypass_approval: org.freedesktop.Telepathy.Client.Empathy.Auth has BypassApproval=F
mcd-DEBUG: 12/07/11 11:07:44.381501: mcd_dispatcher_context_unref: CTXREF01 on 0x9e33e88 (ref = 2)
mcd-DEBUG: 12/07/11 11:07:44.381511: mcd_dispatcher_context_unref: CTXREF11 on 0x9e33e88 (ref = 1)
mcd-DEBUG: 12/07/11 11:07:44.381520: mcd_dispatcher_context_unref: freeing the context 0x9e33e88
mcd-DEBUG: 12/07/11 11:07:44.381573: _mcd_dispatch_operation_inc_ado_pending: 0 -> 1
mcd-DEBUG: 12/07/11 11:07:44.381609: _mcd_dispatch_operation_dec_ado_pending: 1 -> 0
mcd-DEBUG: 12/07/11 11:07:44.381620: _mcd_dispatch_operation_dec_ado_pending: No approver accepted the channels; considering them to be approved
mcd-DEBUG: 12/07/11 11:07:44.381635: _mcd_dispatch_operation_check_client_locks: trying next handler
mcd-DEBUG: 12/07/11 11:07:44.381649: _mcd_dispatch_operation_try_next_handler: Possible handler: org.freedesktop.Telepathy.Client.Empathy.Auth (still exists: Y, already failed: N)
mcd-DEBUG: 12/07/11 11:07:44.381663: mcd_dispatch_operation_try_handler: do2: channel ACL verification [1 channels]
mcd-DEBUG: 12/07/11 11:07:44.381753: _mcd_client_proxy_handle_channels: calling HandleChannels on org.freedesktop.Telepathy.Client.Empathy.Auth
mcd-DEBUG: 12/07/11 11:07:44.382004: _mcd_channel_set_status: 0x9e0f900, 4
mcd-DEBUG: 12/07/11 11:07:44.388422: on_channel_ready: channel 0x9e0f900 is ready
mcd-DEBUG: 12/07/11 11:07:44.560554: dbusprop_get_all: org.freedesktop.Telepathy.AccountManager
mcd-DEBUG: 12/07/11 11:07:44.560565: get_valid_accounts: called
mcd-DEBUG: 12/07/11 11:07:44.560591: get_invalid_accounts: called
mcd-DEBUG: 12/07/11 11:07:44.560600: mcd_dbus_get_interfaces: called
mcd-DEBUG: 12/07/11 11:07:44.565845: dbusprop_get_all: org.freedesktop.Telepathy.Account
mcd-DEBUG: 12/07/11 11:07:44.565855: mcd_dbus_get_interfaces: called
mcd-DEBUG: 12/07/11 11:07:44.565869: mcd_dbus_get_interfaces: skipping inactive optional iface org.freedesktop.Telepathy.Account.Interface.ExternalPasswordStorage.DRAFT
mcd-DEBUG: 12/07/11 11:07:44.565913: _mcd_account_dup_parameters: called
mcd-DEBUG: 12/07/11 11:07:44.566087: get_connect_automatically: called for gabble/jabber/robrob15_40chat_2efacebook_2ecom0
mcd-DEBUG: 12/07/11 11:07:44.567399: dbusprop_get_all: org.freedesktop.Telepathy.Account
mcd-DEBUG: 12/07/11 11:07:44.567408: mcd_dbus_get_interfaces: called
mcd-DEBUG: 12/07/11 11:07:44.567419: mcd_dbus_get_interfaces: skipping inactive optional iface org.freedesktop.Telepathy.Account.Interface.ExternalPasswordStorage.DRAFT
mcd-DEBUG: 12/07/11 11:07:44.567455: _mcd_account_dup_parameters: called
mcd-DEBUG: 12/07/11 11:07:44.567598: get_connect_automatically: called for gabble/jabber/robrob15_40chat_2efacebook_2ecom0
mcd-DEBUG: 12/07/11 11:07:44.569088: dbusprop_get_all: org.freedesktop.Telepathy.Account
mcd-DEBUG: 12/07/11 11:07:44.569094: mcd_dbus_get_interfaces: called
mcd-DEBUG: 12/07/11 11:07:44.569104: mcd_dbus_get_interfaces: skipping inactive optional iface org.freedesktop.Telepathy.Account.Interface.ExternalPasswordStorage.DRAFT
mcd-DEBUG: 12/07/11 11:07:44.569152: _mcd_account_dup_parameters: called
mcd-DEBUG: 12/07/11 11:07:44.569225: get_connect_automatically: called for salut/local_xmpp/account0
mcd-DEBUG: 12/07/11 11:07:44.570029: dbusprop_get_all: org.freedesktop.Telepathy.Account
mcd-DEBUG: 12/07/11 11:07:44.570034: mcd_dbus_get_interfaces: called
mcd-DEBUG: 12/07/11 11:07:44.570044: mcd_dbus_get_interfaces: skipping inactive optional iface org.freedesktop.Telepathy.Account.Interface.ExternalPasswordStorage.DRAFT
mcd-DEBUG: 12/07/11 11:07:44.570080: _mcd_account_dup_parameters: called
mcd-DEBUG: 12/07/11 11:07:44.570148: get_connect_automatically: called for salut/local_xmpp/account0
mcd-DEBUG: 12/07/11 11:07:44.583342: _mcd_channel_set_status: 0x9e0f900, 5
mcd-DEBUG: 12/07/11 11:07:44.583494: _mcd_dispatch_operation_finish: Result: Channel successfully handled by org.freedesktop.Telepathy.Client.Empathy.Auth
mcd-DEBUG: 12/07/11 11:07:44.583503: _mcd_dispatch_operation_finish: do2/0x9e154c8 has finished
mcd-DEBUG: 12/07/11 11:07:44.583507: mcd_dispatch_operation_actually_finish: do2/0x9e154c8: finished
mcd-DEBUG: 12/07/11 11:07:44.583556: _mcd_dispatch_operation_check_client_locks: waiting for handler_is_suitable or HandleChannels to return
mcd-DEBUG: 12/07/11 11:07:44.583574: _mcd_dispatch_operation_check_client_locks: already finished (or finishing): Channel successfully handled by org.freedesktop.Telepathy.Client.Empathy.Auth
mcd-DEBUG: 12/07/11 11:07:44.583585: plugin_do_finalize: 0x9e578a0
mcd-DEBUG: 12/07/11 11:07:47.353524: _mcd_mission_set_parent: child = 0x9e0f9c0, parent = 0x9e11c80
mcd-DEBUG: 12/07/11 11:07:47.353570: _mcd_dispatcher_take_channels: unrequested channel 0x9e0f9c0 (only): /org/freedesktop/Telepathy/Connection/gabble/jabber/robrob15_40chat_2efacebook_2ecom_2fbc2796f1/ServerSASLChannel
mcd-DEBUG: 12/07/11 11:07:47.353642: _mcd_dispatcher_take_channels: possible handler(s) found, dispatching 1 channels
mcd-DEBUG: 12/07/11 11:07:47.353652: _mcd_channel_set_status: 0x9e0f9c0, 3
mcd-DEBUG: 12/07/11 11:07:47.353679: _mcd_dispatcher_enter_state_machine: CTXREF11 on 0x9df8248
mcd-DEBUG: 12/07/11 11:07:47.353694: _mcd_dispatcher_enter_state_machine: new dispatcher context 0x9df8248 for unrequested channel 0x9e0f9c0 (only): /org/freedesktop/Telepathy/Connection/gabble/jabber/robrob15_40chat_2efacebook_2ecom_2fbc2796f1/ServerSASLChannel
mcd-DEBUG: 12/07/11 11:07:47.353787: mcd_dispatch_operation_constructor: do3/0x9e154c8: needs_approval=T
mcd-DEBUG: 12/07/11 11:07:47.353888: _mcd_plugin_dispatch_operation_init: 0x9e57900
mcd-DEBUG: 12/07/11 11:07:47.353912: _mcd_plugin_dispatch_operation_new: 0x9e57900 (for 0x9e154c8)
mcd-DEBUG: 12/07/11 11:07:47.353950: _mcd_dispatcher_enter_state_machine: entering state machine for context 0x9df8248
mcd-DEBUG: 12/07/11 11:07:47.353961: mcd_dispatcher_context_ref: CTXREF01 on 0x9df8248 (ref = 1)
mcd-DEBUG: 12/07/11 11:07:47.353972: _mcd_dispatch_operation_run_clients: do3 0x9e154c8
mcd-DEBUG: 12/07/11 11:07:47.353986: _mcd_dispatch_operation_handlers_can_bypass_observers: org.freedesktop.Telepathy.Client.Empathy.Auth has BypassObservers=F
mcd-DEBUG: 12/07/11 11:07:47.353995: _mcd_dispatch_operation_run_clients: Running observers
mcd-DEBUG: 12/07/11 11:07:47.356787: _mcd_dispatch_operation_inc_observers_pending: 0 -> 1
mcd-DEBUG: 12/07/11 11:07:47.356806: _mcd_dispatch_operation_run_observers: calling ObserveChannels on org.freedesktop.Telepathy.Client.Empathy.Auth for CDO 0x9e154c8
mcd-DEBUG: 12/07/11 11:07:47.371071: _mcd_dispatch_operation_run_clients: All necessary observers invoked
mcd-DEBUG: 12/07/11 11:07:47.371081: _mcd_dispatch_operation_run_clients: Checking finished/locks
mcd-DEBUG: 12/07/11 11:07:47.371093: _mcd_dispatch_operation_handlers_can_bypass_approval: org.freedesktop.Telepathy.Client.Empathy.Auth has BypassApproval=F
mcd-DEBUG: 12/07/11 11:07:47.371103: mcd_dispatcher_context_unref: CTXREF01 on 0x9df8248 (ref = 2)
mcd-DEBUG: 12/07/11 11:07:47.371108: mcd_dispatcher_context_unref: CTXREF11 on 0x9df8248 (ref = 1)
mcd-DEBUG: 12/07/11 11:07:47.371112: mcd_dispatcher_context_unref: freeing the context 0x9df8248
mcd-DEBUG: 12/07/11 11:07:47.371440: on_channel_ready: channel 0x9e0f9c0 is ready
mcd-DEBUG: 12/07/11 11:07:47.457617: dbusprop_get_all: org.freedesktop.Telepathy.ChannelDispatchOperation
mcd-DEBUG: 12/07/11 11:07:47.457629: mcd_dbus_get_interfaces: called
mcd-DEBUG: 12/07/11 11:07:47.457645: get_connection: called for do3
mcd-DEBUG: 12/07/11 11:07:47.457660: get_channels: called for do3
mcd-DEBUG: 12/07/11 11:07:47.457880: get_possible_handlers: called for do3
mcd-DEBUG: 12/07/11 11:07:47.458611: observe_channels_cb: success from /org/freedesktop/Telepathy/Client/Empathy/Auth
mcd-DEBUG: 12/07/11 11:07:47.458619: _mcd_dispatch_operation_dec_observers_pending: 1 -> 0
mcd-DEBUG: 12/07/11 11:07:47.458627: _mcd_plugin_dispatch_operation_observers_finished: 0x9e57900
mcd-DEBUG: 12/07/11 11:07:47.458636: _mcd_dispatch_operation_handlers_can_bypass_approval: org.freedesktop.Telepathy.Client.Empathy.Auth has BypassApproval=F
mcd-DEBUG: 12/07/11 11:07:47.458656: _mcd_dispatch_operation_inc_ado_pending: 0 -> 1
mcd-DEBUG: 12/07/11 11:07:47.458673: mcd_dbus_get_interfaces: called
mcd-DEBUG: 12/07/11 11:07:47.458682: get_connection: called for do3
mcd-DEBUG: 12/07/11 11:07:47.458692: get_possible_handlers: called for do3
mcd-DEBUG: 12/07/11 11:07:47.458826: _mcd_dispatch_operation_run_approvers: Calling AddDispatchOperation on approver org.freedesktop.Telepathy.Client.Empathy.AuthEventManager for CDO /org/freedesktop/Telepathy/DispatchOperation/do3 @ 0x9e154c8
mcd-DEBUG: 12/07/11 11:07:47.458831: _mcd_dispatch_operation_inc_ado_pending: 1 -> 2
mcd-DEBUG: 12/07/11 11:07:47.462902: _mcd_dispatch_operation_dec_ado_pending: 2 -> 1
mcd-DEBUG: 12/07/11 11:07:47.462909: _mcd_dispatch_operation_check_client_locks: waiting for AddDispatchOperation to return
mcd-DEBUG: 12/07/11 11:07:47.462913: _mcd_dispatch_operation_check_client_locks: waiting for AddDispatchOperation to return
mcd-DEBUG: 12/07/11 11:07:47.463059: dbusprop_get_all: org.freedesktop.Telepathy.ChannelDispatchOperation
mcd-DEBUG: 12/07/11 11:07:47.463067: mcd_dbus_get_interfaces: called
mcd-DEBUG: 12/07/11 11:07:47.463078: get_connection: called for do3
mcd-DEBUG: 12/07/11 11:07:47.463090: get_channels: called for do3
mcd-DEBUG: 12/07/11 11:07:47.463287: get_possible_handlers: called for do3
mcd-DEBUG: 12/07/11 11:07:47.469593: dbusprop_get_all: org.freedesktop.Telepathy.Account
mcd-DEBUG: 12/07/11 11:07:47.469604: mcd_dbus_get_interfaces: called
mcd-DEBUG: 12/07/11 11:07:47.469616: mcd_dbus_get_interfaces: skipping inactive optional iface org.freedesktop.Telepathy.Account.Interface.ExternalPasswordStorage.DRAFT
mcd-DEBUG: 12/07/11 11:07:47.469660: _mcd_account_dup_parameters: called
mcd-DEBUG: 12/07/11 11:07:47.469821: get_connect_automatically: called for gabble/jabber/robrob15_40chat_2efacebook_2ecom0
mcd-DEBUG: 12/07/11 11:07:47.471894: _mcd_dispatch_operation_check_client_locks: waiting for AddDispatchOperation to return
mcd-DEBUG: 12/07/11 11:07:47.614084: add_dispatch_operation_cb: Approver /org/freedesktop/Telepathy/Client/Empathy/AuthEventManager accepted AddDispatchOperation /org/freedesktop/Telepathy/DispatchOperation/do3 (0x9e154c8)
mcd-DEBUG: 12/07/11 11:07:47.614094: _mcd_dispatch_operation_dec_ado_pending: 1 -> 0
mcd-DEBUG: 12/07/11 11:07:47.614109: _mcd_channel_set_status: 0x9e0f9c0, 5
mcd-DEBUG: 12/07/11 11:07:47.614144: _mcd_dispatch_operation_check_client_locks: Replying to Claim call from :1.85
mcd-DEBUG: 12/07/11 11:07:47.614183: _mcd_dispatch_operation_finish: Result: Channel successfully claimed by :1.85
mcd-DEBUG: 12/07/11 11:07:47.614187: _mcd_dispatch_operation_finish: do3/0x9e154c8 has finished
mcd-DEBUG: 12/07/11 11:07:47.614192: mcd_dispatch_operation_actually_finish: do3/0x9e154c8: finished
mcd-DEBUG: 12/07/11 11:07:47.614234: _mcd_dispatch_operation_check_client_locks: already finished (or finishing): Channel successfully claimed by :1.85
mcd-DEBUG: 12/07/11 11:07:47.614244: plugin_do_finalize: 0x9e57900
mcd-DEBUG: 12/07/11 11:07:48.183032: proxy_destroyed: Channel proxy invalidated: tp_dbus_errors_quark 8: Channel was closed
mcd-DEBUG: 12/07/11 11:07:48.183048: mcd_channel_abort: 0x9e0f9c0
mcd-DEBUG: 12/07/11 11:07:48.183056: _mcd_channel_set_status: 0x9e0f9c0, 7
mcd-DEBUG: 12/07/11 11:07:48.183104: _mcd_mission_set_parent: child = 0x9e0f9c0, parent = (nil)
mcd-DEBUG: 12/07/11 11:07:48.183130: _mcd_operation_remove_mission: removing mission: 0x9e0f9c0
mcd-DEBUG: 12/07/11 11:07:48.183144: _mcd_channel_dispose: 0x9e0f9c0 (is disposed = 0)
mcd-DEBUG: 12/07/11 11:07:48.183159: _mcd_mission_dispose: mission disposed 0x9e0f9c0
mcd-DEBUG: 12/07/11 11:07:48.183173: _mcd_mission_finalize: mission finalized 0x9e0f9c0
mcd-DEBUG: 12/07/11 11:07:49.324573: on_connection_status_changed: status_changed called from tp (0)
mcd-DEBUG: 12/07/11 11:07:49.324603: _mcd_account_set_connection_status: gabble/jabber/robrob15_40chat_2efacebook_2ecom0: 0 because 1
mcd-DEBUG: 12/07/11 11:07:49.324606: mcd_account_freeze_properties: gabble/jabber/robrob15_40chat_2efacebook_2ecom0
mcd-DEBUG: 12/07/11 11:07:49.324611: _mcd_account_dup_parameters: called
mcd-DEBUG: 12/07/11 11:07:49.324750: _mcd_account_set_connection_status: clearing connection error details
mcd-DEBUG: 12/07/11 11:07:49.324758: _mcd_account_set_connection_status: changing connection status from 1 to 0
mcd-DEBUG: 12/07/11 11:07:49.324765: mcd_account_changed_property: called: Connection
mcd-DEBUG: 12/07/11 11:07:49.324769: mcd_account_changed_property: First changed property
mcd-DEBUG: 12/07/11 11:07:49.324973: mcd_account_changed_property: called: ConnectionStatus
mcd-DEBUG: 12/07/11 11:07:49.324980: mcd_account_changed_property: called: ConnectionStatusReason
mcd-DEBUG: 12/07/11 11:07:49.324985: mcd_account_changed_property: called: ConnectionError
mcd-DEBUG: 12/07/11 11:07:49.324997: mcd_account_changed_property: called: ConnectionErrorDetails
mcd-DEBUG: 12/07/11 11:07:49.325009: mcd_account_thaw_properties: gabble/jabber/robrob15_40chat_2efacebook_2ecom0
mcd-DEBUG: 12/07/11 11:07:49.325014: emit_property_changed: called
mcd-DEBUG: 12/07/11 11:07:49.325171: on_connection_status_changed: setting probation timer (120) seconds, for /org/freedesktop/Telepathy/Connection/gabble/jabber/robrob15_40chat_2efacebook_2ecom_2fbc2796f1
mcd-DEBUG: 12/07/11 11:07:49.325270: on_connection_ready: connection is ready
mcd-DEBUG: 12/07/11 11:07:49.325469: _mcd_connection_setup_capabilities: ContactCapabilities in use, avoiding Capabilities
mcd-DEBUG: 12/07/11 11:07:49.325639: _mcd_account_get_avatar_filename: data dir: /home/rob/.mission-control/accounts/gabble/jabber/robrob15_40chat_2efacebook_2ecom0
mcd-DEBUG: 12/07/11 11:07:49.381293: _mcd_connection_setup_avatar: checking for server token
mcd-DEBUG: 12/07/11 11:07:49.381683: _mcd_connection_setup_power_saving: is active
mcd-DEBUG: 12/07/11 11:07:49.381690: request_unrequested_channels: called
mcd-DEBUG: 12/07/11 11:07:49.381705: _mcd_account_set_connection_status: gabble/jabber/robrob15_40chat_2efacebook_2ecom0: 0 because 1
mcd-DEBUG: 12/07/11 11:07:49.381709: mcd_account_freeze_properties: gabble/jabber/robrob15_40chat_2efacebook_2ecom0
mcd-DEBUG: 12/07/11 11:07:49.381714: _mcd_account_dup_parameters: called
mcd-DEBUG: 12/07/11 11:07:49.381840: _mcd_account_set_connection_status: clearing connection error details
mcd-DEBUG: 12/07/11 11:07:49.381846: mcd_account_thaw_properties: gabble/jabber/robrob15_40chat_2efacebook_2ecom0
mcd-DEBUG: 12/07/11 11:07:49.381957: _mcd_connection_set_nickname: setting nickname 'Rob Totoro Sharp' using Aliasing
mcd-DEBUG: 12/07/11 11:07:49.382323: mcd_account_changed_property: called: CurrentPresence
mcd-DEBUG: 12/07/11 11:07:49.382333: mcd_account_changed_property: First changed property
mcd-DEBUG: 12/07/11 11:07:49.382549: presence_get_statuses_cb: account gabble/jabber/robrob15_40chat_2efacebook_2ecom0:
mcd-DEBUG: 12/07/11 11:07:49.382559: presence_get_statuses_cb:   offline
mcd-DEBUG: 12/07/11 11:07:49.382563: presence_get_statuses_cb:   chat
mcd-DEBUG: 12/07/11 11:07:49.382566: presence_get_statuses_cb:   xa
mcd-DEBUG: 12/07/11 11:07:49.382570: presence_get_statuses_cb:   unknown
mcd-DEBUG: 12/07/11 11:07:49.382575: presence_get_statuses_cb:   error
mcd-DEBUG: 12/07/11 11:07:49.382577: presence_get_statuses_cb:   available
mcd-DEBUG: 12/07/11 11:07:49.382581: presence_get_statuses_cb:   away
mcd-DEBUG: 12/07/11 11:07:49.382586: presence_get_statuses_cb:   dnd
mcd-DEBUG: 12/07/11 11:07:49.382594: _mcd_connection_set_presence: Setting status 'available' of type 2 ('available' was requested)
mcd-DEBUG: 12/07/11 11:07:49.382599: mcd_account_changed_property: called: ChangingPresence
mcd-DEBUG: 12/07/11 11:07:49.384879: _mcd_connection_get_aliases_cb: called
mcd-DEBUG: 12/07/11 11:07:49.384995: update_storage: MCP:default-gkeyfile -> store gabble/jabber/robrob15_40chat_2efacebook_2ecom0.Nickname
mcd-DEBUG: 12/07/11 11:07:49.385004: _storage_commit: flushing plugin default-gkeyfile gabble/jabber/robrob15_40chat_2efacebook_2ecom0 to long term storage
mcd-DEBUG: 12/07/11 11:07:49.385032: _have_config: checking for /home/rob/.mission-control/accounts/accounts.cfg
mcd-DEBUG: 12/07/11 11:07:49.390180: mcd_account_changed_property: called: Nickname
mc-plugins-DEBUG: 12/07/11 11:07:49.384964: mcp_account_storage_set: default-gkeyfile: 
mc-plugins-DEBUG: 12/07/11 11:07:49.385025: mcp_account_storage_commit_one: default-gkeyfile: called for gabble/jabber/robrob15_40chat_2efacebook_2ecom0
mcd-DEBUG: 12/07/11 11:07:49.390275: _mcd_account_set_normalized_name: called (robrob15@chat.facebook.com)
mcd-DEBUG: 12/07/11 11:07:49.390296: _storage_commit: flushing plugin default-gkeyfile gabble/jabber/robrob15_40chat_2efacebook_2ecom0 to long term storage
mcd-DEBUG: 12/07/11 11:07:49.390355: mcd_account_changed_property: called: NormalizedName
mc-plugins-DEBUG: 12/07/11 11:07:49.390347: mcp_account_storage_commit_one: default-gkeyfile: called for gabble/jabber/robrob15_40chat_2efacebook_2ecom0
mcd-DEBUG: 12/07/11 11:07:49.392606: emit_property_changed: called
mcd-DEBUG: 12/07/11 11:07:49.646089: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.647059: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.647739: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.648351: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.648961: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.649395: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.650007: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.651179: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.651850: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.652731: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.653348: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.653974: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.654613: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.655256: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.655865: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.656472: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.657079: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.657696: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.658307: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.658910: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.659563: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.660176: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.660787: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.661401: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.662018: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.662800: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.663465: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.664762: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.665399: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.666022: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.666699: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.667351: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.667968: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.668579: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.669209: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.669823: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.670439: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.671078: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.671695: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.672302: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.673098: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.673722: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.674334: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.674985: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.675621: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.676234: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.676850: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.677571: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.678184: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.678785: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.679414: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.680008: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.680612: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.681241: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.681862: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.682476: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.683337: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.683964: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.684567: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.685189: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.685787: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.686398: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.687097: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.687794: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.688410: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.689014: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.689629: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.690253: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.691015: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.691637: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.692248: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.692852: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.693639: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.694251: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.694861: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.695509: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.696125: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.696734: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.697339: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.697954: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.698575: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.699227: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.699852: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.700476: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.701087: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.701704: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.702311: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.702941: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.703861: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.704516: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.705133: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.706691: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.707592: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.708245: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.708882: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.709492: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.710122: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.710745: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.711414: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.712021: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.712630: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.713263: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.714129: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.714751: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.715394: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.716018: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.716645: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.718035: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.718674: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.719331: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.719990: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.720614: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.721231: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.721858: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.722481: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.723160: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.723972: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.724612: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.725231: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.725874: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.726521: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.727173: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.727788: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.836513: _mcd_mission_set_parent: child = 0x9e0fdc8, parent = 0x9e11c80
mcd-DEBUG: 12/07/11 11:07:49.836536: _mcd_dispatcher_take_channels: unrequested channel 0x9e0fdc8 (only): /org/freedesktop/Telepathy/Connection/gabble/jabber/robrob15_40chat_2efacebook_2ecom_2fbc2796f1/ContactList/subscribe
mcd-DEBUG: 12/07/11 11:07:49.836575: _mcd_dispatcher_take_channels: One channel, which cannot be handled
mcd-DEBUG: 12/07/11 11:07:49.836582: _mcd_tp_channel_should_close: Not destroying 0x9e15300:/org/freedesktop/Telepathy/Connection/gabble/jabber/robrob15_40chat_2efacebook_2ecom_2fbc2796f1/ContactList/subscribe, it's a ContactList
mcd-DEBUG: 12/07/11 11:07:49.843556: _mcd_mission_set_parent: child = 0x9e0fd48, parent = 0x9e11c80
mcd-DEBUG: 12/07/11 11:07:49.843579: _mcd_dispatcher_take_channels: unrequested channel 0x9e0fd48 (only): /org/freedesktop/Telepathy/Connection/gabble/jabber/robrob15_40chat_2efacebook_2ecom_2fbc2796f1/ContactList/publish
mcd-DEBUG: 12/07/11 11:07:49.843614: _mcd_dispatcher_take_channels: One channel, which cannot be handled
mcd-DEBUG: 12/07/11 11:07:49.843621: _mcd_tp_channel_should_close: Not destroying 0x9e151d0:/org/freedesktop/Telepathy/Connection/gabble/jabber/robrob15_40chat_2efacebook_2ecom_2fbc2796f1/ContactList/publish, it's a ContactList
mcd-DEBUG: 12/07/11 11:07:49.848226: _mcd_mission_set_parent: child = 0x9e0fb40, parent = 0x9e11c80
mcd-DEBUG: 12/07/11 11:07:49.848247: _mcd_dispatcher_take_channels: unrequested channel 0x9e0fb40 (only): /org/freedesktop/Telepathy/Connection/gabble/jabber/robrob15_40chat_2efacebook_2ecom_2fbc2796f1/ContactList/stored
mcd-DEBUG: 12/07/11 11:07:49.848277: _mcd_dispatcher_take_channels: One channel, which cannot be handled
mcd-DEBUG: 12/07/11 11:07:49.848283: _mcd_tp_channel_should_close: Not destroying 0x9e15560:/org/freedesktop/Telepathy/Connection/gabble/jabber/robrob15_40chat_2efacebook_2ecom_2fbc2796f1/ContactList/stored, it's a ContactList
mcd-DEBUG: 12/07/11 11:07:49.853856: _mcd_mission_set_parent: child = 0x9e0f940, parent = 0x9e11c80
mcd-DEBUG: 12/07/11 11:07:49.853877: _mcd_dispatcher_take_channels: unrequested channel 0x9e0f940 (only): /org/freedesktop/Telepathy/Connection/gabble/jabber/robrob15_40chat_2efacebook_2ecom_2fbc2796f1/Group/1
mcd-DEBUG: 12/07/11 11:07:49.853912: _mcd_dispatcher_take_channels: One channel, which cannot be handled
mcd-DEBUG: 12/07/11 11:07:49.853919: _mcd_tp_channel_should_close: Not destroying 0x9e154c8:/org/freedesktop/Telepathy/Connection/gabble/jabber/robrob15_40chat_2efacebook_2ecom_2fbc2796f1/Group/1, it's a ContactList
mcd-DEBUG: 12/07/11 11:07:49.859700: _mcd_mission_set_parent: child = 0x9e0fa80, parent = 0x9e11c80
mcd-DEBUG: 12/07/11 11:07:49.859723: _mcd_dispatcher_take_channels: unrequested channel 0x9e0fa80 (only): /org/freedesktop/Telepathy/Connection/gabble/jabber/robrob15_40chat_2efacebook_2ecom_2fbc2796f1/Group/2
mcd-DEBUG: 12/07/11 11:07:49.859760: _mcd_dispatcher_take_channels: One channel, which cannot be handled
mcd-DEBUG: 12/07/11 11:07:49.859769: _mcd_tp_channel_should_close: Not destroying 0x9e155f8:/org/freedesktop/Telepathy/Connection/gabble/jabber/robrob15_40chat_2efacebook_2ecom_2fbc2796f1/Group/2, it's a ContactList
mcd-DEBUG: 12/07/11 11:07:49.867799: _mcd_dispatcher_take_channels: unrequested channel 0x9e0f940 (only): /org/freedesktop/Telepathy/Connection/gabble/jabber/robrob15_40chat_2efacebook_2ecom_2fbc2796f1/Group/1
mcd-DEBUG: 12/07/11 11:07:49.867841: _mcd_dispatcher_take_channels: One channel, which cannot be handled
mcd-DEBUG: 12/07/11 11:07:49.867849: _mcd_tp_channel_should_close: Not destroying 0x9e154c8:/org/freedesktop/Telepathy/Connection/gabble/jabber/robrob15_40chat_2efacebook_2ecom_2fbc2796f1/Group/1, it's a ContactList
mcd-DEBUG: 12/07/11 11:07:49.870588: _mcd_dispatcher_take_channels: unrequested channel 0x9e0fa80 (only): /org/freedesktop/Telepathy/Connection/gabble/jabber/robrob15_40chat_2efacebook_2ecom_2fbc2796f1/Group/2
mcd-DEBUG: 12/07/11 11:07:49.870621: _mcd_dispatcher_take_channels: One channel, which cannot be handled
mcd-DEBUG: 12/07/11 11:07:49.870629: _mcd_tp_channel_should_close: Not destroying 0x9e155f8:/org/freedesktop/Telepathy/Connection/gabble/jabber/robrob15_40chat_2efacebook_2ecom_2fbc2796f1/Group/2, it's a ContactList
mcd-DEBUG: 12/07/11 11:07:49.877836: on_channel_ready: channel 0x9e0fdc8 is ready
mcd-DEBUG: 12/07/11 11:07:49.880151: on_channel_ready: channel 0x9e0fd48 is ready
mcd-DEBUG: 12/07/11 11:07:49.880923: on_channel_ready: channel 0x9e0fb40 is ready
mcd-DEBUG: 12/07/11 11:07:49.885600: on_channel_ready: channel 0x9e0f940 is ready
mcd-DEBUG: 12/07/11 11:07:49.886275: on_channel_ready: channel 0x9e0fa80 is ready
mcd-DEBUG: 12/07/11 11:07:49.895684: on_aliases_changed: called
mcd-DEBUG: 12/07/11 11:07:49.895697: on_aliases_changed: Our alias on /org/freedesktop/Telepathy/Connection/gabble/jabber/robrob15_40chat_2efacebook_2ecom_2fbc2796f1 changed to Rob Totoro Sharp
mcd-DEBUG: 12/07/11 11:07:49.895834: update_storage: MCP:default-gkeyfile -> store gabble/jabber/robrob15_40chat_2efacebook_2ecom0.Nickname
mcd-DEBUG: 12/07/11 11:07:49.895842: _storage_commit: flushing plugin default-gkeyfile gabble/jabber/robrob15_40chat_2efacebook_2ecom0 to long term storage
mcd-DEBUG: 12/07/11 11:07:49.895872: _have_config: checking for /home/rob/.mission-control/accounts/accounts.cfg
mcd-DEBUG: 12/07/11 11:07:49.897743: mcd_account_changed_property: called: Nickname
mcd-DEBUG: 12/07/11 11:07:49.897752: mcd_account_changed_property: First changed property
mc-plugins-DEBUG: 12/07/11 11:07:49.895802: mcp_account_storage_set: default-gkeyfile: 
mc-plugins-DEBUG: 12/07/11 11:07:49.895864: mcp_account_storage_commit_one: default-gkeyfile: called for gabble/jabber/robrob15_40chat_2efacebook_2ecom0
mcd-DEBUG: 12/07/11 11:07:49.897919: on_avatar_updated: contact 1, token: 25952369e14ba10c0086145f4f1abbdc67ffdc21
mcd-DEBUG: 12/07/11 11:07:49.898669: on_avatar_updated: contact 1, token: 25952369e14ba10c0086145f4f1abbdc67ffdc21
mcd-DEBUG: 12/07/11 11:07:49.908802: emit_property_changed: called
mcd-DEBUG: 12/07/11 11:08:44.465116: _mcd_handler_map_set_handler_crashed: /org/freedesktop/Telepathy/Connection/gabble/jabber/robrob15_40chat_2efacebook_2ecom_2fbc2796f1/ServerTLSChannel lost its handler :1.85
mcd-DEBUG: 12/07/11 11:08:44.465153: _mcd_handler_map_set_handler_crashed: Closing channel /org/freedesktop/Telepathy/Connection/gabble/jabber/robrob15_40chat_2efacebook_2ecom_2fbc2796f1/ServerTLSChannel
mcd-DEBUG: 12/07/11 11:08:44.468910: proxy_destroyed: Channel proxy invalidated: tp_dbus_errors_quark 8: Channel was closed
mcd-DEBUG: 12/07/11 11:08:44.468919: mcd_channel_abort: 0x9e0f900
mcd-DEBUG: 12/07/11 11:08:44.468924: _mcd_channel_set_status: 0x9e0f900, 7
mcd-DEBUG: 12/07/11 11:08:44.468950: _mcd_mission_set_parent: child = 0x9e0f900, parent = (nil)
mcd-DEBUG: 12/07/11 11:08:44.468962: _mcd_operation_remove_mission: removing mission: 0x9e0f900
mcd-DEBUG: 12/07/11 11:08:44.468970: _mcd_channel_dispose: 0x9e0f900 (is disposed = 0)
mcd-DEBUG: 12/07/11 11:08:44.468976: _mcd_mission_dispose: mission disposed 0x9e0f900
mcd-DEBUG: 12/07/11 11:08:44.468983: _mcd_mission_finalize: mission finalized 0x9e0f900
mcd-DEBUG: 12/07/11 11:09:04.203411: _mcd_mission_set_parent: child = 0x9e0f9c0, parent = 0x9e11cf8
mcd-DEBUG: 12/07/11 11:09:04.203458: _mcd_dispatcher_take_channels: unrequested channel 0x9e0f9c0 (only): /org/freedesktop/Telepathy/Connection/salut/local_xmpp/rob/IMChannel/4
mcd-DEBUG: 12/07/11 11:09:04.203532: _mcd_dispatcher_take_channels: possible handler(s) found, dispatching 1 channels
mcd-DEBUG: 12/07/11 11:09:04.203542: _mcd_channel_set_status: 0x9e0f9c0, 3
mcd-DEBUG: 12/07/11 11:09:04.203569: _mcd_dispatcher_enter_state_machine: CTXREF11 on 0x9e680a8
mcd-DEBUG: 12/07/11 11:09:04.203583: _mcd_dispatcher_enter_state_machine: new dispatcher context 0x9e680a8 for unrequested channel 0x9e0f9c0 (only): /org/freedesktop/Telepathy/Connection/salut/local_xmpp/rob/IMChannel/4
mcd-DEBUG: 12/07/11 11:09:04.203679: mcd_dispatch_operation_constructor: do4/0x9e15728: needs_approval=T
mcd-DEBUG: 12/07/11 11:09:04.203778: _mcd_plugin_dispatch_operation_init: 0x9e6c820
mcd-DEBUG: 12/07/11 11:09:04.203799: _mcd_plugin_dispatch_operation_new: 0x9e6c820 (for 0x9e15728)
mcd-DEBUG: 12/07/11 11:09:04.203838: _mcd_dispatcher_enter_state_machine: entering state machine for context 0x9e680a8
mcd-DEBUG: 12/07/11 11:09:04.203849: mcd_dispatcher_context_ref: CTXREF01 on 0x9e680a8 (ref = 1)
mcd-DEBUG: 12/07/11 11:09:04.203860: _mcd_dispatch_operation_run_clients: do4 0x9e15728
mcd-DEBUG: 12/07/11 11:09:04.203874: _mcd_dispatch_operation_handlers_can_bypass_observers: org.freedesktop.Telepathy.Client.Empathy.Chat has BypassObservers=F
mcd-DEBUG: 12/07/11 11:09:04.203882: _mcd_dispatch_operation_run_clients: Running observers
mcd-DEBUG: 12/07/11 11:09:04.204193: _mcd_dispatch_operation_inc_observers_pending: 0 -> 1
mcd-DEBUG: 12/07/11 11:09:04.204206: _mcd_dispatch_operation_run_observers: calling ObserveChannels on org.freedesktop.Telepathy.Client.Logger for CDO 0x9e15728
mcd-DEBUG: 12/07/11 11:09:04.216806: _mcd_dispatch_operation_run_clients: All necessary observers invoked
mcd-DEBUG: 12/07/11 11:09:04.216819: _mcd_dispatch_operation_run_clients: Checking finished/locks
mcd-DEBUG: 12/07/11 11:09:04.216836: _mcd_dispatch_operation_handlers_can_bypass_approval: org.freedesktop.Telepathy.Client.Empathy.Chat has BypassApproval=F
mcd-DEBUG: 12/07/11 11:09:04.216861: mcd_dispatcher_context_unref: CTXREF01 on 0x9e680a8 (ref = 2)
mcd-DEBUG: 12/07/11 11:09:04.216872: mcd_dispatcher_context_unref: CTXREF11 on 0x9e680a8 (ref = 1)
mcd-DEBUG: 12/07/11 11:09:04.216881: mcd_dispatcher_context_unref: freeing the context 0x9e680a8
mcd-DEBUG: 12/07/11 11:09:04.216943: _mcd_dispatch_operation_inc_ado_pending: 0 -> 1
mcd-DEBUG: 12/07/11 11:09:04.216986: mcd_dbus_get_interfaces: called
mcd-DEBUG: 12/07/11 11:09:04.217006: get_connection: called for do4
mcd-DEBUG: 12/07/11 11:09:04.217029: get_possible_handlers: called for do4
mcd-DEBUG: 12/07/11 11:09:04.217288: _mcd_dispatch_operation_run_approvers: Calling AddDispatchOperation on approver org.freedesktop.Telepathy.Client.Empathy.EventManager for CDO /org/freedesktop/Telepathy/DispatchOperation/do4 @ 0x9e15728
mcd-DEBUG: 12/07/11 11:09:04.217300: _mcd_dispatch_operation_inc_ado_pending: 1 -> 2
mcd-DEBUG: 12/07/11 11:09:04.218413: _mcd_dispatch_operation_dec_ado_pending: 2 -> 1
mcd-DEBUG: 12/07/11 11:09:04.230659: on_channel_ready: channel 0x9e0f9c0 is ready
mcd-DEBUG: 12/07/11 11:09:04.230736: dbusprop_get_all: org.freedesktop.Telepathy.ChannelDispatchOperation
mcd-DEBUG: 12/07/11 11:09:04.230745: mcd_dbus_get_interfaces: called
mcd-DEBUG: 12/07/11 11:09:04.230756: get_connection: called for do4
mcd-DEBUG: 12/07/11 11:09:04.230770: get_channels: called for do4
mcd-DEBUG: 12/07/11 11:09:04.231372: get_possible_handlers: called for do4
mcd-DEBUG: 12/07/11 11:09:04.483370: add_dispatch_operation_cb: Approver /org/freedesktop/Telepathy/Client/Empathy/EventManager accepted AddDispatchOperation /org/freedesktop/Telepathy/DispatchOperation/do4 (0x9e15728)
mcd-DEBUG: 12/07/11 11:09:04.483381: _mcd_dispatch_operation_dec_ado_pending: 1 -> 0
mcd-DEBUG: 12/07/11 11:09:11.516843: dispatch_operation_handle_with_time: do4/0x9e15728
mcd-DEBUG: 12/07/11 11:09:17.530395: dispatch_operation_handle_with_time: do4/0x9e15728
mcd-DEBUG: 12/07/11 11:09:17.530411: mcd_dispatch_operation_check_handle_with: NotYours: already finished or approved
mcd-DEBUG: 12/07/11 11:09:27.608098: dispatch_operation_handle_with_time: do4/0x9e15728
mcd-DEBUG: 12/07/11 11:09:27.608114: mcd_dispatch_operation_check_handle_with: NotYours: already finished or approved
mcd-DEBUG: 12/07/11 11:09:29.210206: observe_channels_cb: Observer /org/freedesktop/Telepathy/Client/Logger returned error: Did not receive a reply. Possible causes include: the remote application did not send a reply, the message bus security policy blocked the reply, the reply timeout expired, or the network connection was broken.
mcd-DEBUG: 12/07/11 11:09:29.210231: _mcd_dispatch_operation_dec_observers_pending: 1 -> 0
mcd-DEBUG: 12/07/11 11:09:29.210246: _mcd_plugin_dispatch_operation_observers_finished: 0x9e6c820
mcd-DEBUG: 12/07/11 11:09:29.210261: _mcd_dispatch_operation_check_client_locks: trying next handler
mcd-DEBUG: 12/07/11 11:09:29.210279: _mcd_dispatch_operation_try_next_handler: Possible handler: org.freedesktop.Telepathy.Client.Empathy.Chat (still exists: Y, already failed: N)
mcd-DEBUG: 12/07/11 11:09:29.210295: mcd_dispatch_operation_try_handler: do4: channel ACL verification [1 channels]
mcd-DEBUG: 12/07/11 11:09:29.210338: _mcd_client_proxy_handle_channels: calling HandleChannels on org.freedesktop.Telepathy.Client.Empathy.Chat
mcd-DEBUG: 12/07/11 11:09:29.210622: _mcd_channel_set_status: 0x9e0f9c0, 4
mcd-DEBUG: 12/07/11 11:09:29.444633: dbusprop_get_all: org.freedesktop.Telepathy.AccountManager
mcd-DEBUG: 12/07/11 11:09:29.444647: get_valid_accounts: called
mcd-DEBUG: 12/07/11 11:09:29.444674: get_invalid_accounts: called
mcd-DEBUG: 12/07/11 11:09:29.444683: mcd_dbus_get_interfaces: called
mcd-DEBUG: 12/07/11 11:09:29.472651: _mcd_client_registry_found_name: Registering client org.freedesktop.Telepathy.Client.Empathy.ChatroomManager._3a1_2e91.n0
mcd-DEBUG: 12/07/11 11:09:29.472820: mcd_client_proxy_constructed: org.freedesktop.Telepathy.Client.Empathy.ChatroomManager._3a1_2e91.n0
mcd-DEBUG: 12/07/11 11:09:29.473100: mcd_client_proxy_introspect: No .client file for org.freedesktop.Telepathy.Client.Empathy.ChatroomManager._3a1_2e91.n0. Ask on D-Bus.
mcd-DEBUG: 12/07/11 11:09:29.485063: dbusprop_get_all: org.freedesktop.Telepathy.Account
mcd-DEBUG: 12/07/11 11:09:29.485075: mcd_dbus_get_interfaces: called
mcd-DEBUG: 12/07/11 11:09:29.485093: mcd_dbus_get_interfaces: skipping inactive optional iface org.freedesktop.Telepathy.Account.Interface.ExternalPasswordStorage.DRAFT
mcd-DEBUG: 12/07/11 11:09:29.485138: _mcd_account_dup_parameters: called
mcd-DEBUG: 12/07/11 11:09:29.485301: get_connect_automatically: called for gabble/jabber/robrob15_40chat_2efacebook_2ecom0
mcd-DEBUG: 12/07/11 11:09:29.486352: dbusprop_get_all: org.freedesktop.Telepathy.Account
mcd-DEBUG: 12/07/11 11:09:29.486361: mcd_dbus_get_interfaces: called
mcd-DEBUG: 12/07/11 11:09:29.486371: mcd_dbus_get_interfaces: skipping inactive optional iface org.freedesktop.Telepathy.Account.Interface.ExternalPasswordStorage.DRAFT
mcd-DEBUG: 12/07/11 11:09:29.486407: _mcd_account_dup_parameters: called
mcd-DEBUG: 12/07/11 11:09:29.486596: get_connect_automatically: called for gabble/jabber/robrob15_40chat_2efacebook_2ecom0
mcd-DEBUG: 12/07/11 11:09:29.488086: dbusprop_get_all: org.freedesktop.Telepathy.Account
mcd-DEBUG: 12/07/11 11:09:29.488094: mcd_dbus_get_interfaces: called
mcd-DEBUG: 12/07/11 11:09:29.488106: mcd_dbus_get_interfaces: skipping inactive optional iface org.freedesktop.Telepathy.Account.Interface.ExternalPasswordStorage.DRAFT
mcd-DEBUG: 12/07/11 11:09:29.488149: _mcd_account_dup_parameters: called
mcd-DEBUG: 12/07/11 11:09:29.488228: get_connect_automatically: called for salut/local_xmpp/account0
mcd-DEBUG: 12/07/11 11:09:29.489031: dbusprop_get_all: org.freedesktop.Telepathy.Account
mcd-DEBUG: 12/07/11 11:09:29.489038: mcd_dbus_get_interfaces: called
mcd-DEBUG: 12/07/11 11:09:29.489048: mcd_dbus_get_interfaces: skipping inactive optional iface org.freedesktop.Telepathy.Account.Interface.ExternalPasswordStorage.DRAFT
mcd-DEBUG: 12/07/11 11:09:29.489084: _mcd_account_dup_parameters: called
mcd-DEBUG: 12/07/11 11:09:29.489156: get_connect_automatically: called for salut/local_xmpp/account0
mcd-DEBUG: 12/07/11 11:09:29.490607: _mcd_client_proxy_add_interfaces: org.freedesktop.Telepathy.Client.Empathy.ChatroomManager._3a1_2e91.n0: org.freedesktop.Telepathy.Client.Observer
mcd-DEBUG: 12/07/11 11:09:29.490618: _mcd_client_proxy_get_interfaces_cb: Client org.freedesktop.Telepathy.Client.Empathy.ChatroomManager._3a1_2e91.n0
mcd-DEBUG: 12/07/11 11:09:29.490662: _mcd_client_proxy_get_interfaces_cb: org.freedesktop.Telepathy.Client.Empathy.ChatroomManager._3a1_2e91.n0 is an Observer
mcd-DEBUG: 12/07/11 11:09:29.498780: _mcd_client_proxy_observer_get_all_cb: org.freedesktop.Telepathy.Client.Empathy.ChatroomManager._3a1_2e91.n0 has DelayApprovers=F
mcd-DEBUG: 12/07/11 11:09:29.498792: _mcd_client_proxy_observer_get_all_cb: org.freedesktop.Telepathy.Client.Empathy.ChatroomManager._3a1_2e91.n0 has 1 ObserverChannelFilter entries
mcd-DEBUG: 12/07/11 11:09:29.498809: _mcd_client_proxy_observer_get_all_cb: org.freedesktop.Telepathy.Client.Empathy.ChatroomManager._3a1_2e91.n0 has Recover=T
mcd-DEBUG: 12/07/11 11:09:29.498821: mcd_client_registry_ready_cb: org.freedesktop.Telepathy.Client.Empathy.ChatroomManager._3a1_2e91.n0
mcd-DEBUG: 12/07/11 11:09:29.498836: mcd_dispatcher_client_needs_recovery_cb: called
mcd-DEBUG: 12/07/11 11:09:40.796402: dbusprop_get_all: org.freedesktop.Telepathy.AccountManager
mcd-DEBUG: 12/07/11 11:09:40.796416: get_valid_accounts: called
mcd-DEBUG: 12/07/11 11:09:40.796442: get_invalid_accounts: called
mcd-DEBUG: 12/07/11 11:09:40.796452: mcd_dbus_get_interfaces: called
mcd-DEBUG: 12/07/11 11:09:40.798572: dbusprop_get_all: org.freedesktop.Telepathy.Account
mcd-DEBUG: 12/07/11 11:09:40.798583: mcd_dbus_get_interfaces: called
mcd-DEBUG: 12/07/11 11:09:40.798602: mcd_dbus_get_interfaces: skipping inactive optional iface org.freedesktop.Telepathy.Account.Interface.ExternalPasswordStorage.DRAFT
mcd-DEBUG: 12/07/11 11:09:40.798643: _mcd_account_dup_parameters: called
mcd-DEBUG: 12/07/11 11:09:40.798801: get_connect_automatically: called for gabble/jabber/robrob15_40chat_2efacebook_2ecom0
mcd-DEBUG: 12/07/11 11:09:40.799696: dbusprop_get_all: org.freedesktop.Telepathy.Account
mcd-DEBUG: 12/07/11 11:09:40.799705: mcd_dbus_get_interfaces: called
mcd-DEBUG: 12/07/11 11:09:40.799715: mcd_dbus_get_interfaces: skipping inactive optional iface org.freedesktop.Telepathy.Account.Interface.ExternalPasswordStorage.DRAFT
mcd-DEBUG: 12/07/11 11:09:40.799747: _mcd_account_dup_parameters: called
mcd-DEBUG: 12/07/11 11:09:40.799885: get_connect_automatically: called for gabble/jabber/robrob15_40chat_2efacebook_2ecom0
mcd-DEBUG: 12/07/11 11:09:40.802323: dbusprop_get_all: org.freedesktop.Telepathy.Account
mcd-DEBUG: 12/07/11 11:09:40.802335: mcd_dbus_get_interfaces: called
mcd-DEBUG: 12/07/11 11:09:40.802347: mcd_dbus_get_interfaces: skipping inactive optional iface org.freedesktop.Telepathy.Account.Interface.ExternalPasswordStorage.DRAFT
mcd-DEBUG: 12/07/11 11:09:40.802398: _mcd_account_dup_parameters: called
mcd-DEBUG: 12/07/11 11:09:40.802479: get_connect_automatically: called for salut/local_xmpp/account0
mcd-DEBUG: 12/07/11 11:09:40.803332: dbusprop_get_all: org.freedesktop.Telepathy.Account
mcd-DEBUG: 12/07/11 11:09:40.803339: mcd_dbus_get_interfaces: called
mcd-DEBUG: 12/07/11 11:09:40.803349: mcd_dbus_get_interfaces: skipping inactive optional iface org.freedesktop.Telepathy.Account.Interface.ExternalPasswordStorage.DRAFT
mcd-DEBUG: 12/07/11 11:09:40.803385: _mcd_account_dup_parameters: called
mcd-DEBUG: 12/07/11 11:09:40.803455: get_connect_automatically: called for salut/local_xmpp/account0
mcd-DEBUG: 12/07/11 11:09:43.451682: mcd_connection_probation_ended_cb: probation finished, assuming connection is stable: /org/freedesktop/Telepathy/Connection/salut/local_xmpp/rob
mcd-DEBUG: 12/07/11 11:09:49.455025: mcd_connection_probation_ended_cb: probation finished, assuming connection is stable: /org/freedesktop/Telepathy/Connection/gabble/jabber/robrob15_40chat_2efacebook_2ecom_2fbc2796f1
mcd-DEBUG: 12/07/11 11:09:54.217051: _mcd_dispatch_operation_handle_channels_cb: error: Did not receive a reply. Possible causes include: the remote application did not send a reply, the message bus security policy blocked the reply, the reply timeout expired, or the network connection was broken.
mcd-DEBUG: 12/07/11 11:09:54.217381: _mcd_dispatch_operation_set_handler_failed: All possible handlers failed: failing with the last error
mcd-DEBUG: 12/07/11 11:09:54.217611: _mcd_dispatch_operation_close_as_undispatchable: Did not receive a reply. Possible causes include: the remote application did not send a reply, the message bus security policy blocked the reply, the reply timeout expired, or the network connection was broken.
mcd-DEBUG: 12/07/11 11:09:54.217842: _mcd_dispatch_operation_finish: Result: Did not receive a reply. Possible causes include: the remote application did not send a reply, the message bus security policy blocked the reply, the reply timeout expired, or the network connection was broken.
mcd-DEBUG: 12/07/11 11:09:54.218070: _mcd_dispatch_operation_finish: HandleWith -> error: dbus-glib-error-quark 4: Did not receive a reply. Possible causes include: the remote application did not send a reply, the message bus security policy blocked the reply, the reply timeout expired, or the network connection was broken.
mcd-DEBUG: 12/07/11 11:09:54.218359: _mcd_dispatch_operation_finish: do4/0x9e15728 has finished
mcd-DEBUG: 12/07/11 11:09:54.218580: mcd_dispatch_operation_actually_finish: do4/0x9e15728: finished
mcd-DEBUG: 12/07/11 11:09:54.218866: _mcd_dispatch_operation_check_client_locks: waiting for handler_is_suitable or HandleChannels to return
mcd-DEBUG: 12/07/11 11:09:54.227246: _mcd_channel_set_status: 0x9e0f9c0, 6
mcd-DEBUG: 12/07/11 11:09:54.227511: _mcd_channel_undispatchable: 0x9e0f9c0: /org/freedesktop/Telepathy/Connection/salut/local_xmpp/rob/IMChannel/4
mcd-DEBUG: 12/07/11 11:09:54.227745: _mcd_channel_undispatchable: calling Close()
mcd-DEBUG: 12/07/11 11:09:54.228028: _mcd_dispatch_operation_check_client_locks: already finished (or finishing): Did not receive a reply. Possible causes include: the remote application did not send a reply, the message bus security policy blocked the reply, the reply timeout expired, or the network connection was broken.
mcd-DEBUG: 12/07/11 11:09:54.228261: plugin_do_finalize: 0x9e6c820
mcd-DEBUG: 12/07/11 11:09:54.243194: proxy_destroyed: Channel proxy invalidated: tp_dbus_errors_quark 8: Channel was closed
mcd-DEBUG: 12/07/11 11:09:54.243323: mcd_channel_abort: 0x9e0f9c0
mcd-DEBUG: 12/07/11 11:09:54.243412: _mcd_channel_set_status: 0x9e0f9c0, 7
mcd-DEBUG: 12/07/11 11:09:54.243520: _mcd_mission_set_parent: child = 0x9e0f9c0, parent = (nil)
mcd-DEBUG: 12/07/11 11:09:54.243616: _mcd_operation_remove_mission: removing mission: 0x9e0f9c0
mcd-DEBUG: 12/07/11 11:09:54.243705: _mcd_channel_dispose: 0x9e0f9c0 (is disposed = 0)
mcd-DEBUG: 12/07/11 11:09:54.243798: _mcd_mission_dispose: mission disposed 0x9e0f9c0
mcd-DEBUG: 12/07/11 11:09:54.243889: _mcd_mission_finalize: mission finalized 0x9e0f9c0
