This forum has been archived. All content is frozen. Please use KDE Discuss instead.

Can't connect properly: XMPP

Tags: None
(comma "," separated)
User avatar
moofang
Registered Member
Posts
50
Karma
1

Can't connect properly: XMPP

Mon Dec 01, 2014 6:11 pm
Hi,

I'm using a service called "slack" (http://slack.com) at work, which exposes an XMPP gateway for the IM portion. I'm trying to connect to the gateway with ktp but it doesn't quite work right - it stays on "connecting" forever, doesn't show any contacts, and seems to detect incoming messages but show blank windows for them. Kopete seems to work with the gateway fine. ktp-debugger log as follows:

Code: Select all
12/02/2014 01:18:13.33874 - [mcd] get_mcddbusprop: org.freedesktop.Telepathy.Account, RequestedPresence
12/02/2014 01:18:13.34074 - [mcd] set_requested_presence: called for gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0
12/02/2014 01:18:13.34276 - [mcd] set_requested_presence: setting requested presence: 2, available,
12/02/2014 01:18:13.34454 - [mcd] mcd_account_changed_property: called: RequestedPresence
12/02/2014 01:18:13.34605 - [mcd] mcd_account_changed_property: First changed property
12/02/2014 01:18:13.34774 - [mcd] mcd_account_request_presence_int: Requested presence: 2 available
12/02/2014 01:18:13.34920 - [mcd] mcd_account_changed_property: called: ChangingPresence
12/02/2014 01:18:13.35063 - [mcd] _mcd_account_dup_parameters: called
12/02/2014 01:18:13.35514 - [mcd] _mcd_account_set_connection_status: gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0: 1 because 1
12/02/2014 01:18:13.35680 - [mcd] mcd_account_freeze_properties: gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0
12/02/2014 01:18:13.35830 - [mcd] _mcd_account_set_connection_status: changing connection status from 2 to 1
12/02/2014 01:18:13.35974 - [mcd] mcd_account_changed_property: called: Connection
12/02/2014 01:18:13.36340 - [mcd] mcd_account_changed_property: called: ConnectionStatus
12/02/2014 01:18:13.36407 - [mcd] mcd_account_changed_property: called: ConnectionStatusReason
12/02/2014 01:18:13.36463 - [mcd] mcd_account_changed_property: called: ConnectionError
12/02/2014 01:18:13.36526 - [mcd] mcd_account_changed_property: called: ConnectionErrorDetails
12/02/2014 01:18:13.36588 - [mcd] mcd_account_thaw_properties: gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0
12/02/2014 01:18:13.36647 - [mcd] emit_property_changed: called
12/02/2014 01:18:13.36839 - [mcd] mcd_account_connection_proceed_with_reason: gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0 wants to connect and we're online - go for it
12/02/2014 01:18:13.36951 - [mcd] _mcd_mission_set_parent: child = 0x7f833c01e620, parent = 0x16e76f0
12/02/2014 01:18:13.37024 - [mcd] mcd_manager_create_connection: Created a connection 0x7f833c01e620 for account: gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0
12/02/2014 01:18:13.37086 - [mcd] _mcd_connection_connect: called for 0x7f833c01e620, account gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0
12/02/2014 01:18:13.37141 - [mcd] _mcd_connection_connect_with_params: Trying connect account: gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0
12/02/2014 01:18:13.37204 - [mcd] _mcd_account_set_connection_status: gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0: 1 because 1
12/02/2014 01:18:13.37271 - [mcd] mcd_account_freeze_properties: gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0
12/02/2014 01:18:13.37328 - [mcd] mcd_account_thaw_properties: gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0
12/02/2014 01:18:13.61875 - [mcd] request_connection_cb: created /org/freedesktop/Telepathy/Connection/gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom_2fkde_2dtelepathy_2d388069
12/02/2014 01:18:13.62675 - [mcd] _mcd_connection_set_tp_connection: new connection is 0x1724170
12/02/2014 01:18:13.62746 - [mcd] mcd_account_changed_property: called: Connection
12/02/2014 01:18:13.62804 - [mcd] mcd_account_changed_property: First changed property
12/02/2014 01:18:13.64342 - [mcd] on_connection_status_changed: status_changed called from tp (2)
12/02/2014 01:18:13.64774 - [mcd] _mcd_connection_update_client_caps: Sending client caps to connection
12/02/2014 01:18:13.66025 - [mcd] mcd_connection_early_get_statuses_cb: /org/freedesktop/Telepathy/Connection/gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom_2fkde_2dtelepathy_2d388069: Early Get(Statuses) succeeded
12/02/2014 01:18:13.66104 - [mcd] presence_get_statuses_cb: account gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0:
12/02/2014 01:18:13.66162 - [mcd] presence_get_statuses_cb:   offline
12/02/2014 01:18:13.66217 - [mcd] presence_get_statuses_cb:   chat
12/02/2014 01:18:13.66422 - [mcd] presence_get_statuses_cb:   xa
12/02/2014 01:18:13.66481 - [mcd] presence_get_statuses_cb:   unknown
12/02/2014 01:18:13.66534 - [mcd] presence_get_statuses_cb:   error
12/02/2014 01:18:13.66586 - [mcd] presence_get_statuses_cb:   hidden
12/02/2014 01:18:13.66638 - [mcd] presence_get_statuses_cb:   available
12/02/2014 01:18:13.66690 - [mcd] presence_get_statuses_cb:   away
12/02/2014 01:18:13.66746 - [mcd] presence_get_statuses_cb:   dnd
12/02/2014 01:18:13.66782 - [mcd] _mcd_connection_set_presence: Setting status 'available' of type 2 ('available' was requested)
12/02/2014 01:18:13.66924 - [mcd] _mcd_dispatcher_add_connection: 0x1700ca0: 0x7f833c01e620 (/org/freedesktop/Telepathy/Connection/gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom_2fkde_2dtelepathy_2d388069)
12/02/2014 01:18:13.67002 - [mcd] _mcd_connection_start_dispatching: 0x7f833c01e620
12/02/2014 01:18:13.67128 - [mcd] _mcd_connection_update_client_caps: Sending client caps to connection
12/02/2014 01:18:13.67502 - [mcd] mcd_connection_done_task_before_connect: /org/freedesktop/Telepathy/Connection/gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom_2fkde_2dtelepathy_2d388069: Calling Connect()
12/02/2014 01:18:13.73983 - [mcd] emit_property_changed: called
12/02/2014 01:18:13.90781 - [mcd] on_connection_status_changed: status_changed called from tp (1)
12/02/2014 01:18:13.90873 - [mcd] _mcd_account_set_connection_status: gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0: 1 because 1
12/02/2014 01:18:13.90939 - [mcd] mcd_account_freeze_properties: gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0
12/02/2014 01:18:13.91005 - [mcd] mcd_account_changed_property: called: Connection
12/02/2014 01:18:13.91067 - [mcd] mcd_account_changed_property: First changed property
12/02/2014 01:18:13.91352 - [mcd] mcd_account_changed_property: called: ConnectionStatus
12/02/2014 01:18:13.91423 - [mcd] mcd_account_changed_property: called: ConnectionStatusReason
12/02/2014 01:18:13.91485 - [mcd] mcd_account_changed_property: called: ConnectionError
12/02/2014 01:18:13.91559 - [mcd] mcd_account_changed_property: called: ConnectionErrorDetails
12/02/2014 01:18:13.91624 - [mcd] mcd_account_thaw_properties: gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0
12/02/2014 01:18:13.91680 - [mcd] emit_property_changed: called
12/02/2014 01:18:13.91880 - [mcd] connect_cb: called for connection 0x7f833c01e620
12/02/2014 01:18:15.741017 - [mcd] _mcd_mission_set_parent: child = 0x7f833400e740, parent = 0x7f833c01e620
12/02/2014 01:18:15.741106 - [mcd] _mcd_dispatcher_add_channel: unrequested channel 0x7f833400e740: /org/freedesktop/Telepathy/Connection/gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom_2fkde_2dtelepathy_2d388069/ServerSASLChannel
12/02/2014 01:18:15.742434 - [mcd] _mcd_dispatcher_add_channel: possible handler(s) found, dispatching channel
12/02/2014 01:18:15.742506 - [mcd] _mcd_channel_set_status: 0x7f833400e740, 3
12/02/2014 01:18:15.742592 - [mcd] _mcd_dispatcher_enter_state_machine: new dispatch operation for unrequested channel 0x7f833400e740: /org/freedesktop/Telepathy/Connection/gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom_2fkde_2dtelepathy_2d388069/ServerSASLChannel
12/02/2014 01:18:15.742713 - [mcd] mcd_dispatch_operation_constructor: do36/0x16ca610: needs_approval=T
12/02/2014 01:18:15.742783 - [mcd] mcd_dispatch_operation_constructor: Channel: /org/freedesktop/Telepathy/Connection/gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom_2fkde_2dtelepathy_2d388069/ServerSASLChannel
12/02/2014 01:18:15.742923 - [mcd] _mcd_plugin_dispatch_operation_init: 0x16a8590
12/02/2014 01:18:15.742989 - [mcd] _mcd_plugin_dispatch_operation_new: 0x16a8590 (for 0x16ca610)
12/02/2014 01:18:15.743088 - [mcd] _mcd_dispatch_operation_run_clients: do36 0x16ca610
12/02/2014 01:18:15.743161 - [mcd] _mcd_dispatch_operation_handlers_can_bypass_observers: org.freedesktop.Telepathy.Client.KTp.SASLHandler has BypassObservers=F
12/02/2014 01:18:15.743247 - [mcd] _mcd_dispatch_operation_run_clients: Running observers
12/02/2014 01:18:15.744029 - [mcd] _mcd_dispatch_operation_run_clients: All necessary observers invoked
12/02/2014 01:18:15.744090 - [mcd] _mcd_dispatch_operation_run_clients: Checking finished/locks
12/02/2014 01:18:15.744169 - [mcd] _mcd_plugin_dispatch_operation_observers_finished: 0x16a8590
12/02/2014 01:18:15.744261 - [mcd] _mcd_dispatch_operation_handlers_can_bypass_approval: org.freedesktop.Telepathy.Client.KTp.SASLHandler has BypassApproval=F
12/02/2014 01:18:15.744371 - [mcd] _mcd_dispatch_operation_inc_ado_pending: 0 -> 1
12/02/2014 01:18:15.744815 - [mcd] _mcd_dispatch_operation_dec_ado_pending: 1 -> 0
12/02/2014 01:18:15.744875 - [mcd] _mcd_dispatch_operation_dec_ado_pending: No approver accepted the channel; considering it to be approved
12/02/2014 01:18:15.744957 - [mcd] _mcd_dispatch_operation_check_client_locks: trying next handler
12/02/2014 01:18:15.745038 - [mcd] _mcd_dispatch_operation_try_next_handler: Possible handler: org.freedesktop.Telepathy.Client.KTp.SASLHandler (still exists: Y, already failed: N)
12/02/2014 01:18:15.745115 - [mcd] mcd_dispatch_operation_try_handler: do36: channel ACL verification
12/02/2014 01:18:15.745201 - [mcd] _mcd_client_proxy_handle_channels: calling HandleChannels on org.freedesktop.Telepathy.Client.KTp.SASLHandler
12/02/2014 01:18:15.745541 - [mcd] _mcd_channel_set_status: 0x7f833400e740, 4
12/02/2014 01:18:15.746162 - [mcd] on_channel_ready: channel 0x7f833400e740 is ready
12/02/2014 01:18:15.911020 - [mcd] dbusprop_get_all: org.freedesktop.Telepathy.Account
12/02/2014 01:18:15.911106 - [mcd] mcd_dbus_get_interfaces: called
12/02/2014 01:18:15.911174 - [mcd] mcd_dbus_get_interfaces: skipping inactive optional iface org.freedesktop.Telepathy.Account.Interface.ExternalPasswordStorage.DRAFT
12/02/2014 01:18:15.911252 - [mcd] _mcd_account_dup_parameters: called
12/02/2014 01:18:15.911400 - [mcd] get_connect_automatically: called for gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0
12/02/2014 01:18:15.919892 - [mcd] _mcd_channel_set_status: 0x7f833400e740, 5
12/02/2014 01:18:15.920062 - [mcd] _mcd_dispatch_operation_finish: Result: Channel successfully handled by org.freedesktop.Telepathy.Client.KTp.SASLHandler
12/02/2014 01:18:15.920123 - [mcd] _mcd_dispatch_operation_finish: do36/0x16ca610 has finished
12/02/2014 01:18:15.920181 - [mcd] mcd_dispatch_operation_actually_finish: do36/0x16ca610: finished
12/02/2014 01:18:15.920274 - [mcd] _mcd_dispatch_operation_check_client_locks: waiting for handler_is_suitable or HandleChannels to return
12/02/2014 01:18:15.920330 - [mcd] _mcd_dispatch_operation_check_client_locks: already finished (or finishing): Channel successfully handled by org.freedesktop.Telepathy.Client.KTp.SASLHandler
12/02/2014 01:18:15.920392 - [mcd] plugin_do_finalize: 0x16a8590
12/02/2014 01:18:16.290895 - [mcd] proxy_destroyed: Channel proxy invalidated: tp_dbus_errors_quark 8: Channel was closed
12/02/2014 01:18:16.291009 - [mcd] mcd_channel_abort: 0x7f833400e740
12/02/2014 01:18:16.291096 - [mcd] _mcd_channel_set_status: 0x7f833400e740, 7
12/02/2014 01:18:16.291196 - [mcd] _mcd_mission_set_parent: child = 0x7f833400e740, parent = (nil)
12/02/2014 01:18:16.291311 - [mcd] mcd_operation_remove_mission: removing mission: 0x7f833400e740
12/02/2014 01:18:16.291402 - [mcd] _mcd_channel_dispose: 0x7f833400e740 (is disposed = 0)
12/02/2014 01:18:16.291465 - [mcd] _mcd_mission_dispose: mission disposed 0x7f833400e740
12/02/2014 01:18:16.291512 - [mcd] _mcd_mission_finalize: mission finalized 0x7f833400e740
12/02/2014 01:18:17.44673 - [mcd] on_connection_status_changed: status_changed called from tp (2)
12/02/2014 01:18:17.45015 - [mcd] mcd_connection_invalidated_cb: Proxy destroyed (WOCKY_CONNECTOR_ERROR_SESSION_FAILED (#14): Session iq response invalid)!
12/02/2014 01:18:17.45125 - [mcd] _mcd_connection_release_tp_connection: 0x7f833c01e620
12/02/2014 01:18:17.45222 - [mcd] _mcd_account_set_connection_status: gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0: 2 because 2
12/02/2014 01:18:17.45335 - [mcd] mcd_account_freeze_properties: gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0
12/02/2014 01:18:17.45418 - [mcd] _mcd_account_set_connection_status: changing detailed D-Bus error from '' to 'org.freedesktop.Telepathy.Error.NetworkError'
12/02/2014 01:18:17.45497 - [mcd] _mcd_account_set_connection_status: changing error details
12/02/2014 01:18:17.45583 - [mcd] _mcd_account_set_connection_status: changing connection status from 1 to 2
12/02/2014 01:18:17.45675 - [mcd] _mcd_account_set_connection_status: changing connection status reason from 1 to 2
12/02/2014 01:18:17.45824 - [mcd] mcd_account_changed_property: called: Connection
12/02/2014 01:18:17.45974 - [mcd] mcd_account_changed_property: First changed property
12/02/2014 01:18:17.46435 - [mcd] mcd_account_changed_property: called: ConnectionStatus
12/02/2014 01:18:17.46505 - [mcd] mcd_account_changed_property: called: ConnectionStatusReason
12/02/2014 01:18:17.46561 - [mcd] mcd_account_changed_property: called: ConnectionError
12/02/2014 01:18:17.46627 - [mcd] mcd_account_changed_property: called: ConnectionErrorDetails
12/02/2014 01:18:17.46689 - [mcd] mcd_account_thaw_properties: gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0
12/02/2014 01:18:17.46742 - [mcd] emit_property_changed: called
12/02/2014 01:18:17.46907 - [mcd] connection_should_reconnect: error code org.freedesktop.Telepathy.Error.NetworkError, reconnecting
12/02/2014 01:18:17.46962 - [mcd] mcd_connection_invalidated_cb: Preparing for reconnection in 3 seconds
12/02/2014 01:18:17.47301 - [mcd] on_connection_ready: got error: WOCKY_CONNECTOR_ERROR_SESSION_FAILED (#14): Session iq response invalid
12/02/2014 01:18:17.53327 - [mcd] account_reconnect: gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0
12/02/2014 01:18:17.53420 - [mcd] _mcd_connection_release_tp_connection: 0x7f833c01e620
12/02/2014 01:18:17.53483 - [mcd] _mcd_account_set_connection_status: gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0: 2 because 1
12/02/2014 01:18:17.53517 - [mcd] mcd_account_freeze_properties: gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0
12/02/2014 01:18:17.53549 - [mcd] _mcd_account_set_connection_status: changing detailed D-Bus error from 'org.freedesktop.Telepathy.Error.NetworkError' to ''
12/02/2014 01:18:17.53580 - [mcd] _mcd_account_set_connection_status: changing error details
12/02/2014 01:18:17.53610 - [mcd] _mcd_account_set_connection_status: changing connection status reason from 2 to 1
12/02/2014 01:18:17.53641 - [mcd] mcd_account_changed_property: called: Connection
12/02/2014 01:18:17.53669 - [mcd] mcd_account_changed_property: First changed property
12/02/2014 01:18:17.53771 - [mcd] mcd_account_changed_property: called: ConnectionStatus
12/02/2014 01:18:17.53811 - [mcd] mcd_account_changed_property: called: ConnectionStatusReason
12/02/2014 01:18:17.53841 - [mcd] mcd_account_changed_property: called: ConnectionError
12/02/2014 01:18:17.53878 - [mcd] mcd_account_changed_property: called: ConnectionErrorDetails
12/02/2014 01:18:17.53911 - [mcd] mcd_account_thaw_properties: gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0
12/02/2014 01:18:17.53941 - [mcd] emit_property_changed: called
12/02/2014 01:18:17.54045 - [mcd] _mcd_operation_abort: Operation abort received, aborting all children
12/02/2014 01:18:17.54080 - [mcd] on_connection_abort: called (0x7f833c01e620, account gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0)
12/02/2014 01:18:17.54117 - [mcd] _mcd_mission_set_parent: child = 0x7f833c01e620, parent = (nil)
12/02/2014 01:18:17.54151 - [mcd] mcd_operation_remove_mission: removing mission: 0x7f833c01e620
12/02/2014 01:18:17.54182 - [mcd] _mcd_account_dup_parameters: called
12/02/2014 01:18:17.54327 - [mcd] _mcd_account_set_connection_status: gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0: 1 because 1
12/02/2014 01:18:17.54394 - [mcd] mcd_account_freeze_properties: gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0
12/02/2014 01:18:17.54450 - [mcd] _mcd_account_set_connection_status: changing connection status from 2 to 1
12/02/2014 01:18:17.54507 - [mcd] mcd_account_changed_property: called: Connection
12/02/2014 01:18:17.54559 - [mcd] mcd_account_changed_property: First changed property
12/02/2014 01:18:17.54667 - [mcd] mcd_account_changed_property: called: ConnectionStatus
12/02/2014 01:18:17.54735 - [mcd] mcd_account_changed_property: called: ConnectionStatusReason
12/02/2014 01:18:17.54797 - [mcd] mcd_account_changed_property: called: ConnectionError
12/02/2014 01:18:17.54860 - [mcd] mcd_account_changed_property: called: ConnectionErrorDetails
12/02/2014 01:18:17.54920 - [mcd] mcd_account_thaw_properties: gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0
12/02/2014 01:18:17.54974 - [mcd] emit_property_changed: called
12/02/2014 01:18:17.55126 - [mcd] mcd_account_connection_proceed_with_reason: gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0 wants to connect and we're online - go for it
12/02/2014 01:18:17.55249 - [mcd] _mcd_mission_set_parent: child = 0x7f833c01e200, parent = 0x16e76f0
12/02/2014 01:18:17.55325 - [mcd] mcd_manager_create_connection: Created a connection 0x7f833c01e200 for account: gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0
12/02/2014 01:18:17.55386 - [mcd] _mcd_connection_connect: called for 0x7f833c01e200, account gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0
12/02/2014 01:18:17.55439 - [mcd] _mcd_connection_connect_with_params: Trying connect account: gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0
12/02/2014 01:18:17.55501 - [mcd] _mcd_account_set_connection_status: gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0: 1 because 1
12/02/2014 01:18:17.55556 - [mcd] mcd_account_freeze_properties: gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0
12/02/2014 01:18:17.55608 - [mcd] mcd_account_thaw_properties: gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0
12/02/2014 01:18:17.59772 - [mcd] request_connection_cb: created /org/freedesktop/Telepathy/Connection/gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom_2fkde_2dtelepathy_2d388069
12/02/2014 01:18:17.60374 - [mcd] _mcd_connection_set_tp_connection: new connection is 0x1724680
12/02/2014 01:18:17.60451 - [mcd] mcd_account_changed_property: called: Connection
12/02/2014 01:18:17.60507 - [mcd] mcd_account_changed_property: First changed property
12/02/2014 01:18:17.61014 - [mcd] on_connection_status_changed: status_changed called from tp (2)
12/02/2014 01:18:17.61389 - [mcd] _mcd_connection_update_client_caps: Sending client caps to connection
12/02/2014 01:18:17.62370 - [mcd] mcd_connection_early_get_statuses_cb: /org/freedesktop/Telepathy/Connection/gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom_2fkde_2dtelepathy_2d388069: Early Get(Statuses) succeeded
12/02/2014 01:18:17.62448 - [mcd] presence_get_statuses_cb: account gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0:
12/02/2014 01:18:17.62505 - [mcd] presence_get_statuses_cb:   offline
12/02/2014 01:18:17.62560 - [mcd] presence_get_statuses_cb:   chat
12/02/2014 01:18:17.62612 - [mcd] presence_get_statuses_cb:   xa
12/02/2014 01:18:17.62665 - [mcd] presence_get_statuses_cb:   unknown
12/02/2014 01:18:17.62716 - [mcd] presence_get_statuses_cb:   error
12/02/2014 01:18:17.62767 - [mcd] presence_get_statuses_cb:   hidden
12/02/2014 01:18:17.62818 - [mcd] presence_get_statuses_cb:   available
12/02/2014 01:18:17.62870 - [mcd] presence_get_statuses_cb:   away
12/02/2014 01:18:17.62925 - [mcd] presence_get_statuses_cb:   dnd
12/02/2014 01:18:17.62978 - [mcd] _mcd_connection_set_presence: Setting status 'available' of type 2 ('available' was requested)
12/02/2014 01:18:17.63189 - [mcd] _mcd_dispatcher_add_connection: 0x1700ca0: 0x7f833c01e200 (/org/freedesktop/Telepathy/Connection/gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom_2fkde_2dtelepathy_2d388069)
12/02/2014 01:18:17.63319 - [mcd] _mcd_connection_start_dispatching: 0x7f833c01e200
12/02/2014 01:18:17.63546 - [mcd] _mcd_connection_update_client_caps: Sending client caps to connection
12/02/2014 01:18:17.64116 - [mcd] mcd_connection_done_task_before_connect: /org/freedesktop/Telepathy/Connection/gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom_2fkde_2dtelepathy_2d388069: Calling Connect()
12/02/2014 01:18:17.66351 - [mcd] on_connection_status_changed: status_changed called from tp (1)
12/02/2014 01:18:17.66415 - [mcd] _mcd_account_set_connection_status: gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0: 1 because 1
12/02/2014 01:18:17.66474 - [mcd] mcd_account_freeze_properties: gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0
12/02/2014 01:18:17.66535 - [mcd] mcd_account_changed_property: called: Connection
12/02/2014 01:18:17.66596 - [mcd] mcd_account_changed_property: Forcibly emit PropertiesChanged now
12/02/2014 01:18:17.66656 - [mcd] emit_property_changed: called
12/02/2014 01:18:17.66778 - [mcd] mcd_account_changed_property: First changed property
12/02/2014 01:18:17.67027 - [mcd] mcd_account_changed_property: called: ConnectionStatus
12/02/2014 01:18:17.67099 - [mcd] mcd_account_changed_property: called: ConnectionStatusReason
12/02/2014 01:18:17.67154 - [mcd] mcd_account_changed_property: called: ConnectionError
12/02/2014 01:18:17.67214 - [mcd] mcd_account_changed_property: called: ConnectionErrorDetails
12/02/2014 01:18:17.67286 - [mcd] mcd_account_thaw_properties: gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0
12/02/2014 01:18:17.67341 - [mcd] emit_property_changed: called
12/02/2014 01:18:17.67548 - [mcd] connect_cb: called for connection 0x7f833c01e200
12/02/2014 01:18:18.936691 - [mcd] _mcd_mission_set_parent: child = 0x7f833400e620, parent = 0x7f833c01e200
12/02/2014 01:18:18.936769 - [mcd] _mcd_dispatcher_add_channel: unrequested channel 0x7f833400e620: /org/freedesktop/Telepathy/Connection/gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom_2fkde_2dtelepathy_2d388069/ServerSASLChannel
12/02/2014 01:18:18.938364 - [mcd] _mcd_dispatcher_add_channel: possible handler(s) found, dispatching channel
12/02/2014 01:18:18.938463 - [mcd] _mcd_channel_set_status: 0x7f833400e620, 3
12/02/2014 01:18:18.938539 - [mcd] _mcd_dispatcher_enter_state_machine: new dispatch operation for unrequested channel 0x7f833400e620: /org/freedesktop/Telepathy/Connection/gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom_2fkde_2dtelepathy_2d388069/ServerSASLChannel
12/02/2014 01:18:18.938642 - [mcd] mcd_dispatch_operation_constructor: do37/0x16ca720: needs_approval=T
12/02/2014 01:18:18.938710 - [mcd] mcd_dispatch_operation_constructor: Channel: /org/freedesktop/Telepathy/Connection/gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom_2fkde_2dtelepathy_2d388069/ServerSASLChannel
12/02/2014 01:18:18.938823 - [mcd] _mcd_plugin_dispatch_operation_init: 0x7f833400c4d0
12/02/2014 01:18:18.938896 - [mcd] _mcd_plugin_dispatch_operation_new: 0x7f833400c4d0 (for 0x16ca720)
12/02/2014 01:18:18.938977 - [mcd] _mcd_dispatch_operation_run_clients: do37 0x16ca720
12/02/2014 01:18:18.939045 - [mcd] _mcd_dispatch_operation_handlers_can_bypass_observers: org.freedesktop.Telepathy.Client.KTp.SASLHandler has BypassObservers=F
12/02/2014 01:18:18.939110 - [mcd] _mcd_dispatch_operation_run_clients: Running observers
12/02/2014 01:18:18.940927 - [mcd] _mcd_dispatch_operation_run_clients: All necessary observers invoked
12/02/2014 01:18:18.941050 - [mcd] _mcd_dispatch_operation_run_clients: Checking finished/locks
12/02/2014 01:18:18.941132 - [mcd] _mcd_plugin_dispatch_operation_observers_finished: 0x7f833400c4d0
12/02/2014 01:18:18.941214 - [mcd] _mcd_dispatch_operation_handlers_can_bypass_approval: org.freedesktop.Telepathy.Client.KTp.SASLHandler has BypassApproval=F
12/02/2014 01:18:18.941385 - [mcd] _mcd_dispatch_operation_inc_ado_pending: 0 -> 1
12/02/2014 01:18:18.942190 - [mcd] _mcd_dispatch_operation_dec_ado_pending: 1 -> 0
12/02/2014 01:18:18.942308 - [mcd] _mcd_dispatch_operation_dec_ado_pending: No approver accepted the channel; considering it to be approved
12/02/2014 01:18:18.942393 - [mcd] _mcd_dispatch_operation_check_client_locks: trying next handler
12/02/2014 01:18:18.942473 - [mcd] _mcd_dispatch_operation_try_next_handler: Possible handler: org.freedesktop.Telepathy.Client.KTp.SASLHandler (still exists: Y, already failed: N)
12/02/2014 01:18:18.942553 - [mcd] mcd_dispatch_operation_try_handler: do37: channel ACL verification
12/02/2014 01:18:18.942646 - [mcd] _mcd_client_proxy_handle_channels: calling HandleChannels on org.freedesktop.Telepathy.Client.KTp.SASLHandler
12/02/2014 01:18:18.943188 - [mcd] _mcd_channel_set_status: 0x7f833400e620, 4
12/02/2014 01:18:18.944174 - [mcd] on_channel_ready: channel 0x7f833400e620 is ready
12/02/2014 01:18:19.102369 - [mcd] dbusprop_get_all: org.freedesktop.Telepathy.Account
12/02/2014 01:18:19.102453 - [mcd] mcd_dbus_get_interfaces: called
12/02/2014 01:18:19.102521 - [mcd] mcd_dbus_get_interfaces: skipping inactive optional iface org.freedesktop.Telepathy.Account.Interface.ExternalPasswordStorage.DRAFT
12/02/2014 01:18:19.102592 - [mcd] _mcd_account_dup_parameters: called
12/02/2014 01:18:19.102727 - [mcd] get_connect_automatically: called for gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0
12/02/2014 01:18:19.111165 - [mcd] _mcd_channel_set_status: 0x7f833400e620, 5
12/02/2014 01:18:19.111366 - [mcd] _mcd_dispatch_operation_finish: Result: Channel successfully handled by org.freedesktop.Telepathy.Client.KTp.SASLHandler
12/02/2014 01:18:19.111417 - [mcd] _mcd_dispatch_operation_finish: do37/0x16ca720 has finished
12/02/2014 01:18:19.111458 - [mcd] mcd_dispatch_operation_actually_finish: do37/0x16ca720: finished
12/02/2014 01:18:19.111519 - [mcd] _mcd_dispatch_operation_check_client_locks: waiting for handler_is_suitable or HandleChannels to return
12/02/2014 01:18:19.111558 - [mcd] _mcd_dispatch_operation_check_client_locks: already finished (or finishing): Channel successfully handled by org.freedesktop.Telepathy.Client.KTp.SASLHandler
12/02/2014 01:18:19.111604 - [mcd] plugin_do_finalize: 0x7f833400c4d0
12/02/2014 01:18:19.409723 - [mcd] proxy_destroyed: Channel proxy invalidated: tp_dbus_errors_quark 8: Channel was closed
12/02/2014 01:18:19.409805 - [mcd] mcd_channel_abort: 0x7f833400e620
12/02/2014 01:18:19.409853 - [mcd] _mcd_channel_set_status: 0x7f833400e620, 7
12/02/2014 01:18:19.409910 - [mcd] _mcd_mission_set_parent: child = 0x7f833400e620, parent = (nil)
12/02/2014 01:18:19.409961 - [mcd] mcd_operation_remove_mission: removing mission: 0x7f833400e620
12/02/2014 01:18:19.410006 - [mcd] _mcd_channel_dispose: 0x7f833400e620 (is disposed = 0)
12/02/2014 01:18:19.410052 - [mcd] _mcd_mission_dispose: mission disposed 0x7f833400e620
12/02/2014 01:18:19.410096 - [mcd] _mcd_mission_finalize: mission finalized 0x7f833400e620
12/02/2014 01:18:20.154717 - [mcd] on_connection_status_changed: status_changed called from tp (2)
12/02/2014 01:18:20.155054 - [mcd] mcd_connection_invalidated_cb: Proxy destroyed (WOCKY_CONNECTOR_ERROR_SESSION_FAILED (#14): Session iq response invalid)!
12/02/2014 01:18:20.155203 - [mcd] _mcd_connection_release_tp_connection: 0x7f833c01e200
12/02/2014 01:18:20.155405 - [mcd] _mcd_account_set_connection_status: gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0: 2 because 2
12/02/2014 01:18:20.155560 - [mcd] mcd_account_freeze_properties: gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0
12/02/2014 01:18:20.155719 - [mcd] _mcd_account_set_connection_status: changing detailed D-Bus error from '' to 'org.freedesktop.Telepathy.Error.NetworkError'
12/02/2014 01:18:20.155875 - [mcd] _mcd_account_set_connection_status: changing error details
12/02/2014 01:18:20.156039 - [mcd] _mcd_account_set_connection_status: changing connection status from 1 to 2
12/02/2014 01:18:20.156191 - [mcd] _mcd_account_set_connection_status: changing connection status reason from 1 to 2
12/02/2014 01:18:20.156373 - [mcd] mcd_account_changed_property: called: Connection
12/02/2014 01:18:20.156450 - [mcd] mcd_account_changed_property: First changed property
12/02/2014 01:18:20.156780 - [mcd] mcd_account_changed_property: called: ConnectionStatus
12/02/2014 01:18:20.156879 - [mcd] mcd_account_changed_property: called: ConnectionStatusReason
12/02/2014 01:18:20.156958 - [mcd] mcd_account_changed_property: called: ConnectionError
12/02/2014 01:18:20.157047 - [mcd] mcd_account_changed_property: called: ConnectionErrorDetails
12/02/2014 01:18:20.157140 - [mcd] mcd_account_thaw_properties: gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0
12/02/2014 01:18:20.157218 - [mcd] emit_property_changed: called
12/02/2014 01:18:20.157479 - [mcd] connection_should_reconnect: error code org.freedesktop.Telepathy.Error.NetworkError, reconnecting
12/02/2014 01:18:20.157561 - [mcd] mcd_connection_invalidated_cb: Preparing for reconnection in 3 seconds
12/02/2014 01:18:20.158005 - [mcd] on_connection_ready: got error: WOCKY_CONNECTOR_ERROR_SESSION_FAILED (#14): Session iq response invalid
12/02/2014 01:18:20.459530 - [mcd] mcd_connection_reconnect: 0x7f833c01e620
12/02/2014 01:18:20.459758 - [mcd] _mcd_connection_attempt: called for 0x7f833c01e620, account gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0
12/02/2014 01:18:20.459919 - [mcd] _mcd_account_dup_parameters: called
12/02/2014 01:18:20.460395 - [mcd] _mcd_account_set_connection_status: gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0: 1 because 1
12/02/2014 01:18:20.460520 - [mcd] mcd_account_freeze_properties: gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0
12/02/2014 01:18:20.460670 - [mcd] _mcd_account_set_connection_status: changing connection status from 2 to 1
12/02/2014 01:18:20.460830 - [mcd] _mcd_account_set_connection_status: changing connection status reason from 2 to 1
12/02/2014 01:18:20.460999 - [mcd] mcd_account_changed_property: called: Connection
12/02/2014 01:18:20.461160 - [mcd] mcd_account_changed_property: First changed property
12/02/2014 01:18:20.461571 - [mcd] mcd_account_changed_property: called: ConnectionStatus
12/02/2014 01:18:20.461702 - [mcd] mcd_account_changed_property: called: ConnectionStatusReason
12/02/2014 01:18:20.461879 - [mcd] mcd_account_changed_property: called: ConnectionError
12/02/2014 01:18:20.462069 - [mcd] mcd_account_changed_property: called: ConnectionErrorDetails
12/02/2014 01:18:20.462263 - [mcd] mcd_account_thaw_properties: gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0
12/02/2014 01:18:20.462415 - [mcd] emit_property_changed: called
12/02/2014 01:18:20.462829 - [mcd] mcd_account_connection_proceed_with_reason: gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0 wants to connect and we're online - go for it
12/02/2014 01:18:20.462996 - [mcd] _mcd_connection_connect: called for 0x7f833c01e200, account gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0
12/02/2014 01:18:20.463155 - [mcd] _mcd_connection_connect_with_params: Trying connect account: gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0
12/02/2014 01:18:20.463351 - [mcd] _mcd_account_set_connection_status: gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0: 1 because 1
12/02/2014 01:18:20.463504 - [mcd] mcd_account_freeze_properties: gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0
12/02/2014 01:18:20.463650 - [mcd] mcd_account_thaw_properties: gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0
12/02/2014 01:18:20.469111 - [mcd] request_connection_cb: created /org/freedesktop/Telepathy/Connection/gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom_2fkde_2dtelepathy_2d388069
12/02/2014 01:18:20.469866 - [mcd] _mcd_connection_set_tp_connection: new connection is 0x17244d0
12/02/2014 01:18:20.469933 - [mcd] mcd_account_changed_property: called: Connection
12/02/2014 01:18:20.469989 - [mcd] mcd_account_changed_property: First changed property
12/02/2014 01:18:20.471352 - [mcd] on_connection_status_changed: status_changed called from tp (2)
12/02/2014 01:18:20.471731 - [mcd] _mcd_connection_update_client_caps: Sending client caps to connection
12/02/2014 01:18:20.472733 - [mcd] mcd_connection_early_get_statuses_cb: /org/freedesktop/Telepathy/Connection/gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom_2fkde_2dtelepathy_2d388069: Early Get(Statuses) succeeded
12/02/2014 01:18:20.472810 - [mcd] presence_get_statuses_cb: account gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0:
12/02/2014 01:18:20.472868 - [mcd] presence_get_statuses_cb:   offline
12/02/2014 01:18:20.472923 - [mcd] presence_get_statuses_cb:   chat
12/02/2014 01:18:20.472980 - [mcd] presence_get_statuses_cb:   xa
12/02/2014 01:18:20.473033 - [mcd] presence_get_statuses_cb:   unknown
12/02/2014 01:18:20.473090 - [mcd] presence_get_statuses_cb:   error
12/02/2014 01:18:20.473145 - [mcd] presence_get_statuses_cb:   hidden
12/02/2014 01:18:20.473200 - [mcd] presence_get_statuses_cb:   available
12/02/2014 01:18:20.473265 - [mcd] presence_get_statuses_cb:   away
12/02/2014 01:18:20.473323 - [mcd] presence_get_statuses_cb:   dnd
12/02/2014 01:18:20.473380 - [mcd] _mcd_connection_set_presence: Setting status 'available' of type 2 ('available' was requested)
12/02/2014 01:18:20.473583 - [mcd] _mcd_dispatcher_add_connection: 0x1700ca0: 0x7f833c01e200 (/org/freedesktop/Telepathy/Connection/gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom_2fkde_2dtelepathy_2d388069)
12/02/2014 01:18:20.473697 - [mcd] _mcd_connection_start_dispatching: 0x7f833c01e200
12/02/2014 01:18:20.473891 - [mcd] _mcd_connection_update_client_caps: Sending client caps to connection
12/02/2014 01:18:20.474468 - [mcd] mcd_connection_done_task_before_connect: /org/freedesktop/Telepathy/Connection/gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom_2fkde_2dtelepathy_2d388069: Calling Connect()
12/02/2014 01:18:20.477448 - [mcd] on_connection_status_changed: status_changed called from tp (1)
12/02/2014 01:18:20.477536 - [mcd] _mcd_account_set_connection_status: gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0: 1 because 1
12/02/2014 01:18:20.477591 - [mcd] mcd_account_freeze_properties: gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0
12/02/2014 01:18:20.477643 - [mcd] mcd_account_changed_property: called: Connection
12/02/2014 01:18:20.477691 - [mcd] mcd_account_changed_property: Forcibly emit PropertiesChanged now
12/02/2014 01:18:20.477744 - [mcd] emit_property_changed: called
12/02/2014 01:18:20.477868 - [mcd] mcd_account_changed_property: First changed property
12/02/2014 01:18:20.478164 - [mcd] mcd_account_changed_property: called: ConnectionStatus
12/02/2014 01:18:20.478246 - [mcd] mcd_account_changed_property: called: ConnectionStatusReason
12/02/2014 01:18:20.478302 - [mcd] mcd_account_changed_property: called: ConnectionError
12/02/2014 01:18:20.478365 - [mcd] mcd_account_changed_property: called: ConnectionErrorDetails
12/02/2014 01:18:20.478429 - [mcd] mcd_account_thaw_properties: gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0
12/02/2014 01:18:20.478483 - [mcd] emit_property_changed: called
12/02/2014 01:18:20.478686 - [mcd] connect_cb: called for connection 0x7f833c01e200
12/02/2014 01:18:22.369961 - [mcd] _mcd_mission_set_parent: child = 0x1722a20, parent = 0x7f833c01e200
12/02/2014 01:18:22.370111 - [mcd] _mcd_dispatcher_add_channel: unrequested channel 0x1722a20: /org/freedesktop/Telepathy/Connection/gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom_2fkde_2dtelepathy_2d388069/ServerSASLChannel
12/02/2014 01:18:22.372642 - [mcd] _mcd_dispatcher_add_channel: possible handler(s) found, dispatching channel
12/02/2014 01:18:22.372767 - [mcd] _mcd_channel_set_status: 0x1722a20, 3
12/02/2014 01:18:22.372864 - [mcd] _mcd_dispatcher_enter_state_machine: new dispatch operation for unrequested channel 0x1722a20: /org/freedesktop/Telepathy/Connection/gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom_2fkde_2dtelepathy_2d388069/ServerSASLChannel
12/02/2014 01:18:22.373007 - [mcd] mcd_dispatch_operation_constructor: do38/0x16ca720: needs_approval=T
12/02/2014 01:18:22.373091 - [mcd] mcd_dispatch_operation_constructor: Channel: /org/freedesktop/Telepathy/Connection/gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom_2fkde_2dtelepathy_2d388069/ServerSASLChannel
12/02/2014 01:18:22.373265 - [mcd] _mcd_plugin_dispatch_operation_init: 0x7f83340078d0
12/02/2014 01:18:22.373370 - [mcd] _mcd_plugin_dispatch_operation_new: 0x7f83340078d0 (for 0x16ca720)
12/02/2014 01:18:22.373476 - [mcd] _mcd_dispatch_operation_run_clients: do38 0x16ca720
12/02/2014 01:18:22.373559 - [mcd] _mcd_dispatch_operation_handlers_can_bypass_observers: org.freedesktop.Telepathy.Client.KTp.SASLHandler has BypassObservers=F
12/02/2014 01:18:22.373637 - [mcd] _mcd_dispatch_operation_run_clients: Running observers
12/02/2014 01:18:22.375108 - [mcd] _mcd_dispatch_operation_run_clients: All necessary observers invoked
12/02/2014 01:18:22.375216 - [mcd] _mcd_dispatch_operation_run_clients: Checking finished/locks
12/02/2014 01:18:22.375418 - [mcd] _mcd_plugin_dispatch_operation_observers_finished: 0x7f83340078d0
12/02/2014 01:18:22.375531 - [mcd] _mcd_dispatch_operation_handlers_can_bypass_approval: org.freedesktop.Telepathy.Client.KTp.SASLHandler has BypassApproval=F
12/02/2014 01:18:22.375663 - [mcd] _mcd_dispatch_operation_inc_ado_pending: 0 -> 1
12/02/2014 01:18:22.376388 - [mcd] _mcd_dispatch_operation_dec_ado_pending: 1 -> 0
12/02/2014 01:18:22.376437 - [mcd] _mcd_dispatch_operation_dec_ado_pending: No approver accepted the channel; considering it to be approved
12/02/2014 01:18:22.376476 - [mcd] _mcd_dispatch_operation_check_client_locks: trying next handler
12/02/2014 01:18:22.376513 - [mcd] _mcd_dispatch_operation_try_next_handler: Possible handler: org.freedesktop.Telepathy.Client.KTp.SASLHandler (still exists: Y, already failed: N)
12/02/2014 01:18:22.376550 - [mcd] mcd_dispatch_operation_try_handler: do38: channel ACL verification
12/02/2014 01:18:22.376595 - [mcd] _mcd_client_proxy_handle_channels: calling HandleChannels on org.freedesktop.Telepathy.Client.KTp.SASLHandler
12/02/2014 01:18:22.376846 - [mcd] _mcd_channel_set_status: 0x1722a20, 4
12/02/2014 01:18:22.377340 - [mcd] on_channel_ready: channel 0x1722a20 is ready
12/02/2014 01:18:22.554152 - [mcd] dbusprop_get_all: org.freedesktop.Telepathy.Account
12/02/2014 01:18:22.554224 - [mcd] mcd_dbus_get_interfaces: called
12/02/2014 01:18:22.554311 - [mcd] mcd_dbus_get_interfaces: skipping inactive optional iface org.freedesktop.Telepathy.Account.Interface.ExternalPasswordStorage.DRAFT
12/02/2014 01:18:22.554409 - [mcd] _mcd_account_dup_parameters: called
12/02/2014 01:18:22.554642 - [mcd] get_connect_automatically: called for gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0
12/02/2014 01:18:22.564999 - [mcd] _mcd_channel_set_status: 0x1722a20, 5
12/02/2014 01:18:22.565160 - [mcd] _mcd_dispatch_operation_finish: Result: Channel successfully handled by org.freedesktop.Telepathy.Client.KTp.SASLHandler
12/02/2014 01:18:22.565253 - [mcd] _mcd_dispatch_operation_finish: do38/0x16ca720 has finished
12/02/2014 01:18:22.565332 - [mcd] mcd_dispatch_operation_actually_finish: do38/0x16ca720: finished
12/02/2014 01:18:22.565438 - [mcd] _mcd_dispatch_operation_check_client_locks: waiting for handler_is_suitable or HandleChannels to return
12/02/2014 01:18:22.565521 - [mcd] _mcd_dispatch_operation_check_client_locks: already finished (or finishing): Channel successfully handled by org.freedesktop.Telepathy.Client.KTp.SASLHandler
12/02/2014 01:18:22.565598 - [mcd] plugin_do_finalize: 0x7f83340078d0
12/02/2014 01:18:22.856544 - [mcd] proxy_destroyed: Channel proxy invalidated: tp_dbus_errors_quark 8: Channel was closed
12/02/2014 01:18:22.856679 - [mcd] mcd_channel_abort: 0x1722a20
12/02/2014 01:18:22.856779 - [mcd] _mcd_channel_set_status: 0x1722a20, 7
12/02/2014 01:18:22.856893 - [mcd] _mcd_mission_set_parent: child = 0x1722a20, parent = (nil)
12/02/2014 01:18:22.856998 - [mcd] mcd_operation_remove_mission: removing mission: 0x1722a20
12/02/2014 01:18:22.857093 - [mcd] _mcd_channel_dispose: 0x1722a20 (is disposed = 0)
12/02/2014 01:18:22.857183 - [mcd] _mcd_mission_dispose: mission disposed 0x1722a20
12/02/2014 01:18:22.857332 - [mcd] _mcd_mission_finalize: mission finalized 0x1722a20
12/02/2014 01:18:23.597587 - [mcd] on_connection_status_changed: status_changed called from tp (2)
12/02/2014 01:18:23.597681 - [mcd] mcd_connection_invalidated_cb: Proxy destroyed (WOCKY_CONNECTOR_ERROR_SESSION_FAILED (#14): Session iq response invalid)!
12/02/2014 01:18:23.597716 - [mcd] _mcd_connection_release_tp_connection: 0x7f833c01e200
12/02/2014 01:18:23.597760 - [mcd] _mcd_account_set_connection_status: gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0: 2 because 2
12/02/2014 01:18:23.597819 - [mcd] mcd_account_freeze_properties: gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0
12/02/2014 01:18:23.597877 - [mcd] _mcd_account_set_connection_status: changing error details
12/02/2014 01:18:23.597929 - [mcd] _mcd_account_set_connection_status: changing connection status from 1 to 2
12/02/2014 01:18:23.597979 - [mcd] _mcd_account_set_connection_status: changing connection status reason from 1 to 2
12/02/2014 01:18:23.598016 - [mcd] mcd_account_changed_property: called: Connection
12/02/2014 01:18:23.598043 - [mcd] mcd_account_changed_property: First changed property
12/02/2014 01:18:23.598262 - [mcd] mcd_account_changed_property: called: ConnectionStatus
12/02/2014 01:18:23.598329 - [mcd] mcd_account_changed_property: called: ConnectionStatusReason
12/02/2014 01:18:23.598380 - [mcd] mcd_account_changed_property: called: ConnectionError
12/02/2014 01:18:23.598447 - [mcd] mcd_account_changed_property: called: ConnectionErrorDetails
12/02/2014 01:18:23.598500 - [mcd] mcd_account_thaw_properties: gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0
12/02/2014 01:18:23.598531 - [mcd] emit_property_changed: called
12/02/2014 01:18:23.598644 - [mcd] connection_should_reconnect: error code org.freedesktop.Telepathy.Error.NetworkError, reconnecting
12/02/2014 01:18:23.598675 - [mcd] mcd_connection_invalidated_cb: Preparing for reconnection in 9 seconds
12/02/2014 01:18:23.598907 - [mcd] on_connection_ready: got error: WOCKY_CONNECTOR_ERROR_SESSION_FAILED (#14): Session iq response invalid
12/02/2014 01:18:32.461694 - [mcd] mcd_connection_reconnect: 0x7f833c01e200
12/02/2014 01:18:32.461932 - [mcd] _mcd_connection_attempt: called for 0x7f833c01e200, account gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0
12/02/2014 01:18:32.462162 - [mcd] _mcd_account_dup_parameters: called
12/02/2014 01:18:32.462707 - [mcd] _mcd_account_set_connection_status: gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0: 1 because 1
12/02/2014 01:18:32.462836 - [mcd] mcd_account_freeze_properties: gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0
12/02/2014 01:18:32.462987 - [mcd] _mcd_account_set_connection_status: changing connection status from 2 to 1
12/02/2014 01:18:32.463145 - [mcd] _mcd_account_set_connection_status: changing connection status reason from 2 to 1
12/02/2014 01:18:32.463349 - [mcd] mcd_account_changed_property: called: Connection
12/02/2014 01:18:32.463507 - [mcd] mcd_account_changed_property: First changed property
12/02/2014 01:18:32.463898 - [mcd] mcd_account_changed_property: called: ConnectionStatus
12/02/2014 01:18:32.464026 - [mcd] mcd_account_changed_property: called: ConnectionStatusReason
12/02/2014 01:18:32.464202 - [mcd] mcd_account_changed_property: called: ConnectionError
12/02/2014 01:18:32.464412 - [mcd] mcd_account_changed_property: called: ConnectionErrorDetails
12/02/2014 01:18:32.464587 - [mcd] mcd_account_thaw_properties: gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0
12/02/2014 01:18:32.464735 - [mcd] emit_property_changed: called
12/02/2014 01:18:32.465142 - [mcd] mcd_account_connection_proceed_with_reason: gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0 wants to connect and we're online - go for it
12/02/2014 01:18:32.465333 - [mcd] _mcd_connection_connect: called for 0x7f833c01e200, account gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0
12/02/2014 01:18:32.465491 - [mcd] _mcd_connection_connect_with_params: Trying connect account: gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0
12/02/2014 01:18:32.465666 - [mcd] _mcd_account_set_connection_status: gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0: 1 because 1
12/02/2014 01:18:32.465818 - [mcd] mcd_account_freeze_properties: gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0
12/02/2014 01:18:32.465965 - [mcd] mcd_account_thaw_properties: gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0
12/02/2014 01:18:32.493859 - [mcd] request_connection_cb: created /org/freedesktop/Telepathy/Connection/gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom_2fkde_2dtelepathy_2d388069
12/02/2014 01:18:32.494504 - [mcd] _mcd_connection_set_tp_connection: new connection is 0x1724320
12/02/2014 01:18:32.494584 - [mcd] mcd_account_changed_property: called: Connection
12/02/2014 01:18:32.494641 - [mcd] mcd_account_changed_property: First changed property
12/02/2014 01:18:32.495289 - [mcd] on_connection_status_changed: status_changed called from tp (2)
12/02/2014 01:18:32.495693 - [mcd] _mcd_connection_update_client_caps: Sending client caps to connection
12/02/2014 01:18:32.496706 - [mcd] mcd_connection_early_get_statuses_cb: /org/freedesktop/Telepathy/Connection/gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom_2fkde_2dtelepathy_2d388069: Early Get(Statuses) succeeded
12/02/2014 01:18:32.496786 - [mcd] presence_get_statuses_cb: account gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0:
12/02/2014 01:18:32.496849 - [mcd] presence_get_statuses_cb:   offline
12/02/2014 01:18:32.496912 - [mcd] presence_get_statuses_cb:   chat
12/02/2014 01:18:32.496975 - [mcd] presence_get_statuses_cb:   xa
12/02/2014 01:18:32.497040 - [mcd] presence_get_statuses_cb:   unknown
12/02/2014 01:18:32.497103 - [mcd] presence_get_statuses_cb:   error
12/02/2014 01:18:32.497165 - [mcd] presence_get_statuses_cb:   hidden
12/02/2014 01:18:32.497236 - [mcd] presence_get_statuses_cb:   available
12/02/2014 01:18:32.497298 - [mcd] presence_get_statuses_cb:   away
12/02/2014 01:18:32.497361 - [mcd] presence_get_statuses_cb:   dnd
12/02/2014 01:18:32.497426 - [mcd] _mcd_connection_set_presence: Setting status 'available' of type 2 ('available' was requested)
12/02/2014 01:18:32.497658 - [mcd] _mcd_dispatcher_add_connection: 0x1700ca0: 0x7f833c01e200 (/org/freedesktop/Telepathy/Connection/gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom_2fkde_2dtelepathy_2d388069)
12/02/2014 01:18:32.497783 - [mcd] _mcd_connection_start_dispatching: 0x7f833c01e200
12/02/2014 01:18:32.498019 - [mcd] _mcd_connection_update_client_caps: Sending client caps to connection
12/02/2014 01:18:32.498600 - [mcd] mcd_connection_done_task_before_connect: /org/freedesktop/Telepathy/Connection/gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom_2fkde_2dtelepathy_2d388069: Calling Connect()
12/02/2014 01:18:32.505588 - [mcd] emit_property_changed: called
12/02/2014 01:18:32.515892 - [mcd] on_connection_status_changed: status_changed called from tp (1)
12/02/2014 01:18:32.515975 - [mcd] _mcd_account_set_connection_status: gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0: 1 because 1
12/02/2014 01:18:32.516035 - [mcd] mcd_account_freeze_properties: gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0
12/02/2014 01:18:32.516092 - [mcd] mcd_account_changed_property: called: Connection
12/02/2014 01:18:32.516146 - [mcd] mcd_account_changed_property: First changed property
12/02/2014 01:18:32.516787 - [mcd] mcd_account_changed_property: called: ConnectionStatus
12/02/2014 01:18:32.516870 - [mcd] mcd_account_changed_property: called: ConnectionStatusReason
12/02/2014 01:18:32.516937 - [mcd] mcd_account_changed_property: called: ConnectionError
12/02/2014 01:18:32.517015 - [mcd] mcd_account_changed_property: called: ConnectionErrorDetails
12/02/2014 01:18:32.517092 - [mcd] mcd_account_thaw_properties: gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0
12/02/2014 01:18:32.517153 - [mcd] emit_property_changed: called
12/02/2014 01:18:32.517407 - [mcd] connect_cb: called for connection 0x7f833c01e200
12/02/2014 01:18:34.459530 - [mcd] _mcd_mission_set_parent: child = 0x177bca0, parent = 0x7f833c01e200
12/02/2014 01:18:34.459618 - [mcd] _mcd_dispatcher_add_channel: unrequested channel 0x177bca0: /org/freedesktop/Telepathy/Connection/gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom_2fkde_2dtelepathy_2d388069/ServerSASLChannel
12/02/2014 01:18:34.460591 - [mcd] _mcd_dispatcher_add_channel: possible handler(s) found, dispatching channel
12/02/2014 01:18:34.460642 - [mcd] _mcd_channel_set_status: 0x177bca0, 3
12/02/2014 01:18:34.460705 - [mcd] _mcd_dispatcher_enter_state_machine: new dispatch operation for unrequested channel 0x177bca0: /org/freedesktop/Telepathy/Connection/gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom_2fkde_2dtelepathy_2d388069/ServerSASLChannel
12/02/2014 01:18:34.460805 - [mcd] mcd_dispatch_operation_constructor: do39/0x16ca610: needs_approval=T
12/02/2014 01:18:34.460855 - [mcd] mcd_dispatch_operation_constructor: Channel: /org/freedesktop/Telepathy/Connection/gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom_2fkde_2dtelepathy_2d388069/ServerSASLChannel
12/02/2014 01:18:34.460959 - [mcd] _mcd_plugin_dispatch_operation_init: 0x7f833400d690
12/02/2014 01:18:34.461009 - [mcd] _mcd_plugin_dispatch_operation_new: 0x7f833400d690 (for 0x16ca610)
12/02/2014 01:18:34.461083 - [mcd] _mcd_dispatch_operation_run_clients: do39 0x16ca610
12/02/2014 01:18:34.461139 - [mcd] _mcd_dispatch_operation_handlers_can_bypass_observers: org.freedesktop.Telepathy.Client.KTp.SASLHandler has BypassObservers=F
12/02/2014 01:18:34.461199 - [mcd] _mcd_dispatch_operation_run_clients: Running observers
12/02/2014 01:18:34.461808 - [mcd] _mcd_dispatch_operation_run_clients: All necessary observers invoked
12/02/2014 01:18:34.461854 - [mcd] _mcd_dispatch_operation_run_clients: Checking finished/locks
12/02/2014 01:18:34.461915 - [mcd] _mcd_plugin_dispatch_operation_observers_finished: 0x7f833400d690
12/02/2014 01:18:34.461972 - [mcd] _mcd_dispatch_operation_handlers_can_bypass_approval: org.freedesktop.Telepathy.Client.KTp.SASLHandler has BypassApproval=F
12/02/2014 01:18:34.462058 - [mcd] _mcd_dispatch_operation_inc_ado_pending: 0 -> 1
12/02/2014 01:18:34.462418 - [mcd] _mcd_dispatch_operation_dec_ado_pending: 1 -> 0
12/02/2014 01:18:34.462465 - [mcd] _mcd_dispatch_operation_dec_ado_pending: No approver accepted the channel; considering it to be approved
12/02/2014 01:18:34.462527 - [mcd] _mcd_dispatch_operation_check_client_locks: trying next handler
12/02/2014 01:18:34.462587 - [mcd] _mcd_dispatch_operation_try_next_handler: Possible handler: org.freedesktop.Telepathy.Client.KTp.SASLHandler (still exists: Y, already failed: N)
12/02/2014 01:18:34.462646 - [mcd] mcd_dispatch_operation_try_handler: do39: channel ACL verification
12/02/2014 01:18:34.462713 - [mcd] _mcd_client_proxy_handle_channels: calling HandleChannels on org.freedesktop.Telepathy.Client.KTp.SASLHandler
12/02/2014 01:18:34.462963 - [mcd] _mcd_channel_set_status: 0x177bca0, 4
12/02/2014 01:18:34.463430 - [mcd] on_channel_ready: channel 0x177bca0 is ready
12/02/2014 01:18:34.639592 - [mcd] dbusprop_get_all: org.freedesktop.Telepathy.Account
12/02/2014 01:18:34.639663 - [mcd] mcd_dbus_get_interfaces: called
12/02/2014 01:18:34.639709 - [mcd] mcd_dbus_get_interfaces: skipping inactive optional iface org.freedesktop.Telepathy.Account.Interface.ExternalPasswordStorage.DRAFT
12/02/2014 01:18:34.639770 - [mcd] _mcd_account_dup_parameters: called
12/02/2014 01:18:34.639926 - [mcd] get_connect_automatically: called for gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0
12/02/2014 01:18:34.649847 - [mcd] _mcd_channel_set_status: 0x177bca0, 5
12/02/2014 01:18:34.650008 - [mcd] _mcd_dispatch_operation_finish: Result: Channel successfully handled by org.freedesktop.Telepathy.Client.KTp.SASLHandler
12/02/2014 01:18:34.650087 - [mcd] _mcd_dispatch_operation_finish: do39/0x16ca610 has finished
12/02/2014 01:18:34.650146 - [mcd] mcd_dispatch_operation_actually_finish: do39/0x16ca610: finished
12/02/2014 01:18:34.650202 - [mcd] _mcd_dispatch_operation_check_client_locks: waiting for handler_is_suitable or HandleChannels to return
12/02/2014 01:18:34.650255 - [mcd] _mcd_dispatch_operation_check_client_locks: already finished (or finishing): Channel successfully handled by org.freedesktop.Telepathy.Client.KTp.SASLHandler
12/02/2014 01:18:34.650299 - [mcd] plugin_do_finalize: 0x7f833400d690
12/02/2014 01:18:34.955674 - [mcd] proxy_destroyed: Channel proxy invalidated: tp_dbus_errors_quark 8: Channel was closed
12/02/2014 01:18:34.955902 - [mcd] mcd_channel_abort: 0x177bca0
12/02/2014 01:18:34.956068 - [mcd] _mcd_channel_set_status: 0x177bca0, 7
12/02/2014 01:18:34.956321 - [mcd] _mcd_mission_set_parent: child = 0x177bca0, parent = (nil)
12/02/2014 01:18:34.956407 - [mcd] mcd_operation_remove_mission: removing mission: 0x177bca0
12/02/2014 01:18:34.956481 - [mcd] _mcd_channel_dispose: 0x177bca0 (is disposed = 0)
12/02/2014 01:18:34.956553 - [mcd] _mcd_mission_dispose: mission disposed 0x177bca0
12/02/2014 01:18:34.956597 - [mcd] _mcd_mission_finalize: mission finalized 0x177bca0
12/02/2014 01:18:35.745611 - [mcd] on_connection_status_changed: status_changed called from tp (2)
12/02/2014 01:18:35.745945 - [mcd] mcd_connection_invalidated_cb: Proxy destroyed (WOCKY_CONNECTOR_ERROR_SESSION_FAILED (#14): Session iq response invalid)!
12/02/2014 01:18:35.746094 - [mcd] _mcd_connection_release_tp_connection: 0x7f833c01e200
12/02/2014 01:18:35.746293 - [mcd] _mcd_account_set_connection_status: gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0: 2 because 2
12/02/2014 01:18:35.746354 - [mcd] mcd_account_freeze_properties: gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0
12/02/2014 01:18:35.746413 - [mcd] _mcd_account_set_connection_status: changing error details
12/02/2014 01:18:35.746475 - [mcd] _mcd_account_set_connection_status: changing connection status from 1 to 2
12/02/2014 01:18:35.746532 - [mcd] _mcd_account_set_connection_status: changing connection status reason from 1 to 2
12/02/2014 01:18:35.746589 - [mcd] mcd_account_changed_property: called: Connection
12/02/2014 01:18:35.746640 - [mcd] mcd_account_changed_property: First changed property
12/02/2014 01:18:35.746906 - [mcd] mcd_account_changed_property: called: ConnectionStatus
12/02/2014 01:18:35.746982 - [mcd] mcd_account_changed_property: called: ConnectionStatusReason
12/02/2014 01:18:35.747042 - [mcd] mcd_account_changed_property: called: ConnectionError
12/02/2014 01:18:35.747112 - [mcd] mcd_account_changed_property: called: ConnectionErrorDetails
12/02/2014 01:18:35.747181 - [mcd] mcd_account_thaw_properties: gabble/jabber/jasonmoofang_40mokomomo_2exmpp_2eslack_2ecom0
12/02/2014 01:18:35.747251 - [mcd] emit_property_changed: called
12/02/2014 01:18:35.747421 - [mcd] connection_should_reconnect: error code org.freedesktop.Telepathy.Error.NetworkError, reconnecting
12/02/2014 01:18:35.747472 - [mcd] mcd_connection_invalidated_cb: Preparing for reconnection in 27 seconds
12/02/2014 01:18:35.747778 - [mcd] on_connection_ready: got error: WOCKY_CONNECTOR_ERROR_SESSION_FAILED (#14): Session iq response invalid


Anyone can give me pointers on what gives? :)


vutkin
Registered Member
Posts
1
Karma
0

Re: Can't connect properly: XMPP

Thu Dec 25, 2014 8:08 pm
I have the same problem with slack.com. Kopete, PSI+ and Pidgin work well. I suppose that it is a bug in Telepathy.
thermopyle
Registered Member
Posts
9
Karma
0

Re: Can't connect properly: XMPP

Wed Jan 28, 2015 9:37 am
Same problem here; slack.com and XMPP using Telepathy doesn't work. It would be nice to know if I could do something about it. Right now I'm using Konversation for slack.com (IRC instead of XMPP) and Telepathy for Hangouts, Facebook and Lync. I would like to use only Telepathy of course.

/Micke.
shmerl
Registered Member
Posts
251
Karma
1
OS

Re: Can't connect properly: XMPP

Tue Mar 10, 2015 5:50 pm
I have the same problem with Slack. Did anyone report this bug to KDE bug tracker? Also, where can actually check the Telepathy log?
shmerl
Registered Member
Posts
251
Karma
1
OS

Re: Can't connect properly: XMPP

Tue Apr 14, 2015 6:37 pm


Bookmarks



Who is online

Registered users: bartoloni, Bing [Bot], Google [Bot], Yahoo [Bot]