empathy 3.8.6-0ubuntu9.2 does not connect to ejabberd 15.09

raw

README.rst

After upgrading from ejabberd 2.x to ejabberd 15.09, empathy does not connect anymore.

Solution

Disabling X-OAUTH2 made empathy connect again:

disable_sasl_mechanisms: ["digest-md5", "X-OAUTH2"]
raw

empathy.log

1
2
3
4
5
6
7
8
9
10
11
12
13
14
15
16
17
18
19
20
21
22
23
24
25
26
27
28
29
30
31
32
33
34
35
36
37
38
39
40
41
42
43
44
45
46
47
48
49
50
51
52
53
54
55
56
57
58
59
60
61
62
63
64
65
66
67
68
69
70
71
72
73
74
75
76
77
78
79
80
81
82
83
84
85
86
87
88
89
90
91
92
93
94
95
96
97
98
99
100
101
102
103
104
105
106
107
108
109
110
111
112
113
114
115
116
117
118
gabbleplugins-DEBUG: 23.11.2015 21:13:17.477456: gabble_plugin_loader_probe (plugin-loader.c:136): probing /usr/lib/telepathy/gabble-0/plugins
gabbleplugins-DEBUG: 23.11.2015 21:13:17.477904: plugin_loader_try_to_load (plugin-loader.c:100): loaded 'XMPP console' version 0.18.3 (/usr/lib/telepathy/gabble-0/plugins/libconsole.so), implementing these sidecars: org.freedesktop.Telepathy.Gabble.Plugin.Console
gabbleplugins-DEBUG: 23.11.2015 21:13:17.478178: plugin_loader_try_to_load (plugin-loader.c:100): loaded 'Gateway registration plugin' version 0.18.3 (/usr/lib/telepathy/gabble-0/plugins/libgateways.so), implementing these sidecars: org.freedesktop.Telepathy.Gabble.Plugin.Gateways
tp-glib/-DEBUG: 23.11.2015 21:13:17.479618: started version 0.18.3 (telepathy-glib version 0.22.1)
gabbleconnection-DEBUG: 23.11.2015 21:13:17.480386: gabble_connection_class_init (connection.c:1001): Initializing (GabbleConnectionClass *)0x1213800
gabbleconnection-DEBUG: 23.11.2015 21:13:17.480693: gabble_connection_init (connection.c:557): Initializing (GabbleConnection *)0x121c250
gabblepresence-DEBUG: 23.11.2015 21:13:17.480732: gabble_capabilities_init (capabilities.c:249): 0x121c250
gabblemuc-DEBUG: 23.11.2015 21:13:17.481153: gabble_roomlist_manager_constructed (roomlist-manager.c:208): 0x11e62e0
gabblejid-DEBUG: 23.11.2015 21:13:17.481172: gabble_signal_connect_weak (util.c:666): connecting to 0x121c250:status-changed with context 0x1211b40
gabblejid-DEBUG: 23.11.2015 21:13:17.481252: gabble_signal_connect_weak (util.c:666): connecting to 0x121c250:status-changed with context 0x1211ae0
gabbletls-DEBUG: 23.11.2015 21:13:17.487112: gabble_server_tls_manager_constructed (server-tls-manager.c:454): Server TLS Manager constructed
gabblejid-DEBUG: 23.11.2015 21:13:17.487118: gabble_signal_connect_weak (util.c:666): connecting to 0x121c250:status-changed with context 0x7fbc60001760
gabbleconnection-DEBUG: 23.11.2015 21:13:17.487297: gabble_connection_constructor (connection.c:425): Post-construction: (GabbleConnection *)0x121c250
gabblejid-DEBUG: 23.11.2015 21:13:17.487665: gabble_signal_connect_weak (util.c:666): connecting to 0x11e65a0:item-found with context 0x12448a0
gabblejid-DEBUG: 23.11.2015 21:13:17.487672: gabble_signal_connect_weak (util.c:666): connecting to 0x121c250:status-changed with context 0x1244900
gabbleconnection-DEBUG: 23.11.2015 21:13:17.487734: gabble_connection_constructed (connection.c:540): defaulted resource to c919228a
wocky/-DEBUG: 23.11.2015 21:13:17.522671: wocky_xmpp_writer_stream_open: wocky-xmpp-writer.c:302: Writing stream opening: <?xml version='1.0' encoding='UTF-8'?>
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' to="cweiske.de" version="1.0">
wocky/-DEBUG: 23.11.2015 21:13:17.543667: handle_stream_open: wocky-xmpp-reader.c:481: Received stream opening: stream, prefix: stream, uri: http://etherx.jabber.org/streams
wocky/-DEBUG: 23.11.2015 21:13:17.543732: handle_stream_open: wocky-xmpp-reader.c:500: Stream opening attribute: id = '768664846' (prefix: <no prefix>, uri: <no uri>)
wocky/-DEBUG: 23.11.2015 21:13:17.543792: handle_stream_open: wocky-xmpp-reader.c:500: Stream opening attribute: from = 'cweiske.de' (prefix: <no prefix>, uri: <no uri>)
wocky/-DEBUG: 23.11.2015 21:13:17.543831: handle_stream_open: wocky-xmpp-reader.c:500: Stream opening attribute: version = '1.0' (prefix: <no prefix>, uri: <no uri>)
wocky/-DEBUG: 23.11.2015 21:13:17.543869: handle_stream_open: wocky-xmpp-reader.c:500: Stream opening attribute: lang = 'de' (prefix: xml, uri: http://www.w3.org/XML/1998/namespace)
wocky/-DEBUG: 23.11.2015 21:13:17.544066: _end_element_ns: Received stanza
* features xmlns='http://etherx.jabber.org/streams'
    * c xmlns='http://jabber.org/protocol/caps' hash='sha-1' node='http://www.process-one.net/en/ejabberd/' ver='tRd4XMJSw6lNM0CpWa5zvZ9Ca8Y='
    * starttls xmlns='urn:ietf:params:xml:ns:xmpp-tls'
        * required
    * compression xmlns='http://jabber.org/features/compress'
        * method
            "zlib"
wocky/-DEBUG: 23.11.2015 21:13:17.544156: _write_node_tree: Serializing tree:
* starttls xmlns='urn:ietf:params:xml:ns:xmpp-tls'
wocky/-DEBUG: 23.11.2015 21:13:17.564246: _end_element_ns: Received stanza
* proceed xmlns='urn:ietf:params:xml:ns:xmpp-tls'
gabbletls-DEBUG: 23.11.2015 21:13:17.798598: gabble_server_tls_manager_verify_async (server-tls-manager.c:341): verify_async() called on the GabbleServerTLSManager.
gabbletls-DEBUG: 23.11.2015 21:13:17.799010: gabble_server_tls_channel_constructed (server-tls-channel.c:202): Server TLS channel constructed at /org/freedesktop/Telepathy/Connection/gabble/jabber/cweiske_40cweiske_2ede_2fc919228a/ServerTLSChannel1
gabbletls-DEBUG: 23.11.2015 21:13:18.43037: gabble_tls_certificate_accept (tls-certificate.c:264): Accept() called on the TLS certificate; current state 0
gabbletls-DEBUG: 23.11.2015 21:13:18.43087: tls_certificate_accepted_cb (server-tls-manager.c:243): TLS certificate accepted
wocky/-DEBUG: 23.11.2015 21:13:18.43193: wocky_xmpp_writer_stream_open: wocky-xmpp-writer.c:302: Writing stream opening: <?xml version='1.0' encoding='UTF-8'?>
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' to="cweiske.de" version="1.0">
wocky/-DEBUG: 23.11.2015 21:13:18.66281: handle_stream_open: wocky-xmpp-reader.c:481: Received stream opening: stream, prefix: stream, uri: http://etherx.jabber.org/streams
wocky/-DEBUG: 23.11.2015 21:13:18.66431: handle_stream_open: wocky-xmpp-reader.c:500: Stream opening attribute: id = '1126058090' (prefix: <no prefix>, uri: <no uri>)
wocky/-DEBUG: 23.11.2015 21:13:18.66529: handle_stream_open: wocky-xmpp-reader.c:500: Stream opening attribute: from = 'cweiske.de' (prefix: <no prefix>, uri: <no uri>)
wocky/-DEBUG: 23.11.2015 21:13:18.66673: handle_stream_open: wocky-xmpp-reader.c:500: Stream opening attribute: version = '1.0' (prefix: <no prefix>, uri: <no uri>)
wocky/-DEBUG: 23.11.2015 21:13:18.66767: handle_stream_open: wocky-xmpp-reader.c:500: Stream opening attribute: lang = 'de' (prefix: xml, uri: http://www.w3.org/XML/1998/namespace)
wocky/-DEBUG: 23.11.2015 21:13:18.67224: _end_element_ns: Received stanza
* features xmlns='http://etherx.jabber.org/streams'
    * c xmlns='http://jabber.org/protocol/caps' hash='sha-1' node='http://www.process-one.net/en/ejabberd/' ver='tRd4XMJSw6lNM0CpWa5zvZ9Ca8Y='
    * register xmlns='http://jabber.org/features/iq-register'
    * compression xmlns='http://jabber.org/features/compress'
        * method
            "zlib"
    * mechanisms xmlns='urn:ietf:params:xml:ns:xmpp-sasl'
        * mechanism
            "PLAIN"
        * mechanism
            "X-OAUTH2"
        * mechanism
            "SCRAM-SHA-1"
gabbleauthentication-DEBUG: 23.11.2015 21:13:18.67991: gabble_server_sasl_channel_start_auth_async (server-sasl-channel.c:836): Starting authentication
gabbletls-DEBUG: 23.11.2015 21:14:17.823328: gabble_server_tls_channel_close (server-tls-channel.c:300): Close() called on the TLS channel 0x1262640
gabbletls-DEBUG: 23.11.2015 21:14:17.823508: server_tls_channel_closed_cb (server-tls-manager.c:197): Server TLS channel closed.
gabbletls-DEBUG: 23.11.2015 21:14:17.823700: gabble_server_tls_channel_dispose (server-tls-channel.c:140): Dispose TLS channel
gabbletls-DEBUG: 23.11.2015 21:14:17.823834: gabble_server_tls_channel_finalize (server-tls-channel.c:123): Finalize TLS channel
gabbleauthentication-DEBUG: 23.11.2015 21:14:17.823985: gabble_server_sasl_channel_close (server-sasl-channel.c:998): called on 0x11f2630
gabbleauthentication-DEBUG: 23.11.2015 21:14:17.824096: gabble_server_sasl_channel_close (server-sasl-channel.c:1022): closed channel
wocky/-DEBUG: 23.11.2015 21:14:17.824350: auth_failed: wocky-sasl-auth.c:274: Authentication failed!: Client aborted authentication.
gabbleconnection-DEBUG: 23.11.2015 21:14:17.824486: connector_error_disconnect (connection.c:1764): Interactive authentication error, reason 3, dbus error org.freedesktop.Telepathy.Error.AuthenticationFailed
gabbleroster-DEBUG: 23.11.2015 21:14:17.824807: gabble_roster_close_all (roster.c:1672): closing channels
gabblemuc-DEBUG: 23.11.2015 21:14:17.824924: connection_status_changed_cb (roomlist-manager.c:191): disconnected, closing room lists
gabblemuc-DEBUG: 23.11.2015 21:14:17.824995: gabble_roomlist_manager_close_all (roomlist-manager.c:85): 0x11e62e0
gabblesearch-DEBUG: 23.11.2015 21:14:17.825026: gabble_search_manager_close_all (search-manager.c:99): closing channels
gabbleauthentication-DEBUG: 23.11.2015 21:14:17.825061: gabble_auth_manager_close_all (auth-manager.c:92): called
gabbletls-DEBUG: 23.11.2015 21:14:17.825092: connection_status_changed_cb (server-tls-manager.c:147): Connection status changed, now 2
gabblemuc-DEBUG: 23.11.2015 21:14:17.825124: gabble_muc_factory_close_all (muc-factory.c:892): closing channels
gabbletubes-DEBUG: 23.11.2015 21:14:17.825155: gabble_private_tubes_factory_close_all (private-tubes-factory.c:374): closing 1-1 tubes channels
gabblemedia-channel-DEBUG: 23.11.2015 21:14:17.825191: gabble_media_factory_close_all (media-factory.c:423): closing channels
gabbleconnection-DEBUG: 23.11.2015 21:14:17.825249: connection_shut_down (connection.c:2367): neither porter nor connector is alive: clean up the base connection
gabbleconnection-DEBUG: 23.11.2015 21:14:17.832967: gabble_connection_dispose (connection.c:1269): called
gabblebytestream-DEBUG: 23.11.2015 21:14:17.833036: gabble_bytestream_factory_dispose (bytestream-factory.c:683): dispose called
gabblejid-DEBUG: 23.11.2015 21:14:17.833081: user_data_destroyed_cb (util.c:635): user_data for 0x12448a0 destroyed; disconnecting
gabblejid-DEBUG: 23.11.2015 21:14:17.833115: user_data_destroyed_cb (util.c:635): user_data for 0x1244900 destroyed; disconnecting
gabbledisco-DEBUG: 23.11.2015 21:14:17.833147: gabble_disco_dispose (disco.c:227): dispose called
gabblejid-DEBUG: 23.11.2015 21:14:17.833177: instance_destroyed_cb (util.c:622): instance for 0x1244b40 destroyed; cleaning up
gabblejid-DEBUG: 23.11.2015 21:14:17.833209: instance_destroyed_cb (util.c:622): instance for 0x11e5120 destroyed; cleaning up
gabbledisco-DEBUG: 23.11.2015 21:14:17.833241: gabble_disco_finalize (disco.c:254): called with 0x11e65a0
gabblepipeline-DEBUG: 23.11.2015 21:14:17.833273: gabble_request_pipeline_dispose (request-pipeline.c:275): disposing request-pipeline
gabblevcard-DEBUG: 23.11.2015 21:14:17.833317: gabble_vcard_manager_dispose (vcard-manager.c:548): 0x123c760
gabblevcard-DEBUG: 23.11.2015 21:14:17.833357: gabble_vcard_manager_finalize (vcard-manager.c:579): 0x123c760
gabblepresence-DEBUG: 23.11.2015 21:14:17.833408: gabble_presence_cache_dispose (presence-cache.c:548): dispose called
gabblepresence-DEBUG: 23.11.2015 21:14:17.833457: gabble_presence_cache_finalize (presence-cache.c:579): called with 0x12159a0
gabbleroster-DEBUG: 23.11.2015 21:14:17.833525: gabble_roster_dispose (roster.c:200): dispose called
gabbleroster-DEBUG: 23.11.2015 21:14:17.833558: gabble_roster_close_all (roster.c:1672): closing channels
gabbleroster-DEBUG: 23.11.2015 21:14:17.833595: gabble_roster_finalize (roster.c:221): called with 0x1222140
gabbleim-DEBUG: 23.11.2015 21:14:17.833628: gabble_im_factory_dispose (im-factory.c:120): dispose called
gabblemuc-DEBUG: 23.11.2015 21:14:17.833668: gabble_roomlist_manager_dispose (roomlist-manager.c:127): running
gabblemuc-DEBUG: 23.11.2015 21:14:17.833700: gabble_roomlist_manager_close_all (roomlist-manager.c:85): 0x11e62e0
gabblesearch-DEBUG: 23.11.2015 21:14:17.833735: gabble_search_manager_dispose (search-manager.c:213): dispose called
gabblesearch-DEBUG: 23.11.2015 21:14:17.833765: gabble_search_manager_close_all (search-manager.c:99): closing channels
gabblejid-DEBUG: 23.11.2015 21:14:17.833800: user_data_destroyed_cb (util.c:635): user_data for 0x1211b40 destroyed; disconnecting
gabbleauthentication-DEBUG: 23.11.2015 21:14:17.833833: gabble_auth_manager_dispose (auth-manager.c:161): dispose called
gabbleauthentication-DEBUG: 23.11.2015 21:14:17.833864: gabble_auth_manager_close_all (auth-manager.c:92): called
gabblejid-DEBUG: 23.11.2015 21:14:17.833899: user_data_destroyed_cb (util.c:635): user_data for 0x1211ae0 destroyed; disconnecting
gabbletls-DEBUG: 23.11.2015 21:14:17.833934: gabble_server_tls_manager_dispose (server-tls-manager.c:416): 0x11f2270
gabblejid-DEBUG: 23.11.2015 21:14:17.833966: user_data_destroyed_cb (util.c:635): user_data for 0x7fbc60001760 destroyed; disconnecting
gabbletls-DEBUG: 23.11.2015 21:14:17.834000: gabble_server_tls_manager_finalize (server-tls-manager.c:434): 0x11f2270
gabblemuc-DEBUG: 23.11.2015 21:14:17.834033: gabble_muc_factory_dispose (muc-factory.c:148): dispose called
gabblemuc-DEBUG: 23.11.2015 21:14:17.834064: gabble_muc_factory_close_all (muc-factory.c:892): closing channels
gabbletubes-DEBUG: 23.11.2015 21:14:17.834101: gabble_private_tubes_factory_dispose (private-tubes-factory.c:288): dispose called
gabbletubes-DEBUG: 23.11.2015 21:14:17.834132: gabble_private_tubes_factory_close_all (private-tubes-factory.c:374): closing 1-1 tubes channels
gabblemedia-channel-DEBUG: 23.11.2015 21:14:17.834170: gabble_media_factory_dispose (media-factory.c:158): dispose called
gabblemedia-channel-DEBUG: 23.11.2015 21:14:17.834199: gabble_media_factory_close_all (media-factory.c:423): closing channels
gabbleconnection-DEBUG: 23.11.2015 21:14:17.834284: gabble_connection_finalize (connection.c:1348): called with 0x121c250
gabblepresence-DEBUG: 23.11.2015 21:14:17.834342: gabble_capabilities_finalize (capabilities.c:337): 0x121c250
tp-glib/-DEBUG: 23.11.2015 21:14:22.830497: no connections, and timed out
tp-glib/-MESSAGE: 23.11.2015 21:14:22.830977: Exiting
 
Christian Weiske Christian Weiske
owner

History