Attachment 23809 Details for Bug 20635 – gabble log from the second attached test failure

gabble log from the second attached test failure

gabble-testing.log (text/x-log), 101.84 KB, created by Will Thompson on 2009-03-12 13:17:23 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Will Thompson

Created: 2009-03-12 13:17:23 UTC

Size: 101.84 KB

patch

obsolete

>(telepathy-gabble:22588): tp-glib-DEBUG: tp_proxy_borrow_interface_by_id: 0x26084e0: org.freedesktop.DBus DBusGProxy is 0x26086a0
>(telepathy-gabble:22588): tp-glib-DEBUG: started version 0.7.22.1 (telepathy-glib version 0.7.26)
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_cm_param_setter_offset: account = "test@localhost/Resource"
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_cm_param_setter_offset: password = <hidden>
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_cm_param_setter_offset: server = "localhost"
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_cm_param_setter_offset: resource = "Resource"
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_cm_param_setter_offset: priority = 0 = 0x0
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_cm_param_setter_offset: port = 4242 = 0x1092
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_cm_param_setter_offset: old-ssl = FALSE
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_cm_param_setter_offset: require-encryption = FALSE
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_cm_param_setter_offset: register = FALSE
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_cm_param_setter_offset: low-bandwidth = FALSE
>(telepathy-gabble:22588): tp-glib-DEBUG: parse_parameters: https-proxy-server not given, using default behaviour
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_cm_param_setter_offset: https-proxy-port = 443 = 0x1bb
>(telepathy-gabble:22588): tp-glib-DEBUG: parse_parameters: fallback-conference-server not given, using default behaviour
>(telepathy-gabble:22588): tp-glib-DEBUG: parse_parameters: stun-server not given, using default behaviour
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_cm_param_setter_offset: stun-port = 3478 = 0xd96
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_cm_param_setter_offset: fallback-stun-server = "stun.collabora.co.uk"
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_cm_param_setter_offset: fallback-stun-port = 3478 = 0xd96
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_cm_param_setter_offset: ignore-ssl-errors = FALSE
>(telepathy-gabble:22588): tp-glib-DEBUG: parse_parameters: alias not given, using default behaviour
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_class_init: Initializing (TpBaseConnectionClass *)0x2610560
>** (telepathy-gabble:22588): DEBUG: gabble_connection_class_init: Initializing (GabbleConnectionClass *)0x2612000
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_presence_mixin_class_init: called.
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_init: Initializing (TpBaseConnection *)0x2618130
>** (telepathy-gabble:22588): DEBUG: gabble_connection_init: Initializing (GabbleConnection *)0x2618130
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_constructor: Post-construction: (TpBaseConnection *)0x2618130
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_constructor: Handle repo for type #0 at (nil)
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_constructor: Handle repo for type #1 at 0x2611a40
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_constructor: Handle repo for type #2 at 0x2611aa0
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_constructor: Handle repo for type #3 at 0x260a810
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_constructor: Handle repo for type #4 at 0x2611b00
>** (telepathy-gabble:22588): DEBUG: gabble_roomlist_manager_constructed: 0x2607d40
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_constructor: Channel manager #0 at 0x2616740
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_constructor: Channel manager #1 at 0x2607de0
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_constructor: Channel manager #2 at 0x2607d40
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_constructor: Channel manager #3 at 0x260f0c0
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_constructor: Channel manager #4 at 0x2608320
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_constructor: Channel manager #5 at 0x261d450
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_constructor: Channel manager #6 at 0x261bec0
>** (telepathy-gabble:22588): DEBUG: gabble_connection_constructor: Post-construction: (GabbleConnection *)0x2618130
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_presence_mixin_init: called.
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_register: bus name org.freedesktop.Telepathy.Connection.gabble.jabber.test_40localhost_2fResource
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_register: object path /org/freedesktop/Telepathy/Connection/gabble/jabber/test_40localhost_2fResource
>** (telepathy-gabble:22588): DEBUG: _gabble_connection_connect: disabling SRV because "server" or "port" parameter specified, will connect to localhost
>** (telepathy-gabble:22588): DEBUG: do_connect: calling lm_connection_open
>Going to connect to localhost:4242
>Trying ::1 port 4242...
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_change_status: was 4294967295, now 1, for reason 1
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_change_status: emitting status-changed to 1, for reason 1
>** (telepathy-gabble:22588): DEBUG: connection_status_changed_cb: adding callbacks
>** (telepathy-gabble:22588): DEBUG: connection_status_changed_cb: adding callbacks
>** (telepathy-gabble:22588): DEBUG: connection_status_changed_cb: adding callbacks
>Connection failed.
>Connection failed: Connection refused (error 111)
>Freeing up IOChannel and file descriptor
>Trying 127.0.0.1 port 4242...
>Connection success (1).
>
>SEND:
>-----------------------------------
><?xml version='1.0' encoding='UTF-8'?>
>-----------------------------------
>
>SEND:
>-----------------------------------
><stream:stream version="1.0" xmlns="jabber:client" xmlns:stream="http://etherx.jabber.org/streams" to="localhost" id="90180356804">
>-----------------------------------
>
>RECV [106]:
>-----------------------------------
>'<stream:stream xmlns:stream='http://etherx.jabber.org/streams' xmlns='jabber:client' id='bff0b9f623cb606'>'
>-----------------------------------
>** (telepathy-gabble:22588): DEBUG: do_auth: authenticating with username: test, password: <hidden>, resource: Resource
>
>SEND:
>-----------------------------------
><iq type="get" id="66567362287"> <query xmlns="jabber:iq:auth"> <username>test</username>
></query>
></iq>
>
>-----------------------------------
>
>RECV [134]:
>-----------------------------------
>'<iq type='result' id='66567362287'><query xmlns='jabber:iq:auth'><username>test</username><password/><digest/><resource/></query></iq>'
>-----------------------------------
>
>SEND:
>-----------------------------------
><iq type="set" id="67604366643"> <query xmlns="jabber:iq:auth"> <username>test</username>
> <digest>973f6512113686c9bf0953ee492e99ff4c0441dd</digest>
> <resource>Resource</resource>
></query>
></iq>
>
>-----------------------------------
>
>RECV [36]:
>-----------------------------------
>'<iq type='result' id='67604366643'/>'
>-----------------------------------
>** (telepathy-gabble:22588): DEBUG: connection_auth_cb: Created self handle 1, our JID is test@localhost/Resource
>** (telepathy-gabble:22588): DEBUG: gabble_presence_set_capabilities: about to add caps 9189 to resource Resource with serial 1
>** (telepathy-gabble:22588): DEBUG: gabble_presence_set_capabilities: found resource Resource
>** (telepathy-gabble:22588): DEBUG: gabble_presence_set_capabilities: new serial 1, old 0, clearing caps
>** (telepathy-gabble:22588): DEBUG: gabble_presence_set_capabilities: adding caps 9189 to resource Resource
>** (telepathy-gabble:22588): DEBUG: gabble_presence_set_capabilities: resource Resource caps now 9189
>** (telepathy-gabble:22588): DEBUG: gabble_presence_set_capabilities: total caps now 9189
>** (telepathy-gabble:22588): DEBUG: gabble_disco_request_with_timeout: Creating disco request 0x2623d80 for localhost
>
>SEND:
>-----------------------------------
><iq type="get" to="localhost" id="73731372736"> <query xmlns="http://jabber.org/protocol/disco#info"></query>
></iq>
>
>-----------------------------------
>
>RECV [158]:
>-----------------------------------
>'<iq to='localhost' type='result' id='73731372736'> <query xmlns='http://jabber.org/protocol/disco#info'><identity category='pubsub' type='pep'/></query>
></iq>'
>-----------------------------------
>** (telepathy-gabble:22588): DEBUG: connection_disco_cb: got:
><query xmlns="http://jabber.org/protocol/disco#info"> <identity type="pep" category="pubsub"></identity>
></query>
>
>** (telepathy-gabble:22588): DEBUG: connection_disco_cb: set features flags to 16
>
>SEND:
>-----------------------------------
><presence id="75862375771"> <x xmlns="vcard-temp:x:update"></x>
> <c ver="8JLvg+nSJV0Gy/WEK3/RXaWBoLI=" node="http://telepathy.freedesktop.org/caps" hash="sha-1" xmlns="http://jabber.org/protocol/caps"></c>
></presence>
>
>-----------------------------------
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_change_status: was 1, now 0, for reason 1
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_change_status: emitting status-changed to 0, for reason 1
>** (telepathy-gabble:22588): DEBUG: connection_status_changed_cb: requesting roster
>
>SEND:
>-----------------------------------
><iq type="get" id="81927377603"> <query xmlns="jabber:iq:roster"></query>
></iq>
>
>-----------------------------------
>** (telepathy-gabble:22588): DEBUG: gabble_disco_conn_status_changed_cb: connected, initiating service discovery on localhost
>** (telepathy-gabble:22588): DEBUG: gabble_disco_request_with_timeout: Creating disco request 0x2623e00 for localhost
>
>SEND:
>-----------------------------------
><iq type="get" to="localhost" id="82012377855"> <query xmlns="http://jabber.org/protocol/disco#items"></query>
></iq>
>
>-----------------------------------
>** (telepathy-gabble:22588): DEBUG: gabble_vcard_manager_request: Created request 0x2624700 to retrieve <1>'s vCard
>** (telepathy-gabble:22588): DEBUG: cache_entry_ensure_queued: Cache entry 0x26246d0 is my own, not setting @to
>** (telepathy-gabble:22588): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x2624730
>** (telepathy-gabble:22588): DEBUG: cache_entry_ensure_queued: adding request to cache entry 0x26246d0 and queueing the <iq>
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_presence_mixin_emit_presence_update: called.
>(telepathy-gabble:22588): tp-glib-DEBUG: construct_presence_hash: called.
>(telepathy-gabble:22588): tp-glib-DEBUG: construct_simple_presence_hash: called.
>
>SEND:
>-----------------------------------
><iq type="set" id="82010381395"> <pubsub xmlns="http://jabber.org/protocol/pubsub"> <publish node="http://laptop.org/xmpp/activities"> <item> <activities xmlns="http://laptop.org/xmpp/activities"></activities>
></item>
></publish>
></pubsub>
></iq>
>
>-----------------------------------
>
>SEND:
>-----------------------------------
><iq type="set" id="81951381599"> <pubsub xmlns="http://jabber.org/protocol/pubsub"> <publish node="http://laptop.org/xmpp/activity-properties"> <item> <activities xmlns="http://laptop.org/xmpp/activity-properties"></activities>
></item>
></publish>
></pubsub>
></iq>
>
>-----------------------------------
>** (telepathy-gabble:22588): DEBUG: send_next_request: processing request 0x2624730
>
>SEND:
>-----------------------------------
><iq type="get" id="82955378149"> <vCard xmlns="vcard-temp"></vCard>
></iq>
>
>-----------------------------------
>
>RECV [381]:
>-----------------------------------
>'<iq type='result' id='82955378149'><vCard xmlns='vcard-temp'/></iq><iq type='result' id='81927377603'> <query xmlns='jabber:iq:roster'><item jid='bob@localhost' subscription='both'/></query>
></iq><presence to='test@localhost/Resource' from='bob@localhost/Bob'><c node='http://example.com/ICantBelieveItsNotTelepathy' xmlns='http://jabber.org/protocol/caps' ver='1.2.3'/></presence>'
>-----------------------------------
>** (telepathy-gabble:22588): DEBUG: response_cb: got reply for request 0x2624730
>** (telepathy-gabble:22588): DEBUG: pipeline_reply_cb: called for entry 0x26246d0
>** (telepathy-gabble:22588): DEBUG: observe_vcard: got no vCard alias for handle 1
>
>SEND:
>-----------------------------------
><presence id="2140432755"> <x xmlns="vcard-temp:x:update"> <photo></photo>
></x>
> <c ver="8JLvg+nSJV0Gy/WEK3/RXaWBoLI=" node="http://telepathy.freedesktop.org/caps" hash="sha-1" xmlns="http://jabber.org/protocol/caps"></c>
></presence>
>
>-----------------------------------
>** (telepathy-gabble:22588): DEBUG: delete_request: Discarding request 0x2624700
>** (telepathy-gabble:22588): DEBUG: cache_entry_attempt_to_free: Not freeing vCard cache entry 0x26246d0: it has a cached vCard 0x262a170
>** (telepathy-gabble:22588): DEBUG: delete_item: deleting item 0x2624730
>** (telepathy-gabble:22588): DEBUG: _gabble_roster_get_channel: Looking up channel 3:1 "publish"
>** (telepathy-gabble:22588): DEBUG: _gabble_roster_create_channel: Instantiating channel 3:1 "publish"
>[1m[37mtp_group_mixin_change_flags: emitting group flags changed
>  added    : [[22mCAN_REMOVE|MESSAGE_REMOVE|MESSAGE_ACCEPT|PROPERTIES[1m]
>  removed  : [[22m[1m]
>  flags now: [[22mCAN_REMOVE|MESSAGE_REMOVE|MESSAGE_ACCEPT|PROPERTIES[1m]
>[0m** (telepathy-gabble:22588): DEBUG: _gabble_roster_create_channel: created /org/freedesktop/Telepathy/Connection/gabble/jabber/test_40localhost_2fResource/RosterChannel/List/publish
>** (telepathy-gabble:22588): DEBUG: _gabble_roster_create_channel: roster not yet received, not emitting signal for publish list channel
>** (telepathy-gabble:22588): DEBUG: _gabble_roster_get_channel: Looking up channel 3:2 "subscribe"
>** (telepathy-gabble:22588): DEBUG: _gabble_roster_create_channel: Instantiating channel 3:2 "subscribe"
>[1m[37mtp_group_mixin_change_flags: emitting group flags changed
>  added    : [[22mCAN_ADD|CAN_REMOVE|CAN_RESCIND|MESSAGE_ADD|MESSAGE_REMOVE|MESSAGE_RESCIND|PROPERTIES[1m]
>  removed  : [[22m[1m]
>  flags now: [[22mCAN_ADD|CAN_REMOVE|CAN_RESCIND|MESSAGE_ADD|MESSAGE_REMOVE|MESSAGE_RESCIND|PROPERTIES[1m]
>[0m** (telepathy-gabble:22588): DEBUG: _gabble_roster_create_channel: created /org/freedesktop/Telepathy/Connection/gabble/jabber/test_40localhost_2fResource/RosterChannel/List/subscribe
>** (telepathy-gabble:22588): DEBUG: _gabble_roster_create_channel: roster not yet received, not emitting signal for subscribe list channel
>** (telepathy-gabble:22588): DEBUG: _gabble_roster_item_update: Checking which groups contact#2 was just added to:
>** (telepathy-gabble:22588): DEBUG: _gabble_roster_item_update: Checking which groups contact#2 was just removed from:
>** (telepathy-gabble:22588): DEBUG: gabble_roster_iq_cb: jid: bob@localhost, subscription: both
>** (telepathy-gabble:22588): DEBUG: gabble_roster_iq_cb: calling change members on publish channel
>[1m[36memit_members_changed_signals: emitting members changed
>  message       : ""
>  added         : [[22m2 (bob@localhost)[1m]
>  removed       : [[22m[1m]
>  local_pending : [[22m[1m]
>  remote_pending: [[22m[1m]
>  actor         : 0
>  reason        : 0: unspecified reason
>[0m** (telepathy-gabble:22588): DEBUG: gabble_roster_iq_cb: calling change members on subscribe channel
>[1m[36memit_members_changed_signals: emitting members changed
>  message       : ""
>  added         : [[22m2 (bob@localhost)[1m]
>  removed       : [[22m[1m]
>  local_pending : [[22m[1m]
>  remote_pending: [[22m[1m]
>  actor         : 0
>  reason        : 0: unspecified reason
>[0m** (telepathy-gabble:22588): DEBUG: _gabble_roster_get_channel: Looking up channel 3:3 "known"
>** (telepathy-gabble:22588): DEBUG: _gabble_roster_create_channel: Instantiating channel 3:3 "known"
>[1m[37mtp_group_mixin_change_flags: emitting group flags changed
>  added    : [[22mCAN_REMOVE|PROPERTIES[1m]
>  removed  : [[22m[1m]
>  flags now: [[22mCAN_REMOVE|PROPERTIES[1m]
>[0m** (telepathy-gabble:22588): DEBUG: _gabble_roster_create_channel: created /org/freedesktop/Telepathy/Connection/gabble/jabber/test_40localhost_2fResource/RosterChannel/List/known
>** (telepathy-gabble:22588): DEBUG: _gabble_roster_create_channel: roster not yet received, not emitting signal for known list channel
>** (telepathy-gabble:22588): DEBUG: gabble_roster_iq_cb: calling change members on known channel
>[1m[36memit_members_changed_signals: emitting members changed
>  message       : ""
>  added         : [[22m2 (bob@localhost)[1m]
>  removed       : [[22m[1m]
>  local_pending : [[22m[1m]
>  remote_pending: [[22m[1m]
>  actor         : 0
>  reason        : 0: unspecified reason
>[0m** (telepathy-gabble:22588): DEBUG: gabble_roster_iq_cb: calling change members on any group channels
>** (telepathy-gabble:22588): DEBUG: _gabble_roster_emit_one: roster now received, emitting signal signal for publish list channel
>** (telepathy-gabble:22588): DEBUG: _gabble_roster_emit_one: roster now received, emitting signal signal for subscribe list channel
>** (telepathy-gabble:22588): DEBUG: _gabble_roster_emit_one: roster now received, emitting signal signal for known list channel
>** (telepathy-gabble:22588): DEBUG: gabble_presence_cache_do_update: bob@localhost (2) resource Bob prio 0 presence 7 message "(null)"
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_presence_mixin_emit_presence_update: called.
>(telepathy-gabble:22588): tp-glib-DEBUG: construct_presence_hash: called.
>(telepathy-gabble:22588): tp-glib-DEBUG: construct_simple_presence_hash: called.
>** (telepathy-gabble:22588): DEBUG: _process_caps_uri: not enough trust for URI http://example.com/ICantBelieveItsNotTelepathy#1.2.3
>** (telepathy-gabble:22588): DEBUG: disco_waiter_new: created waiter 0x262f230 for handle 2 with serial 1
>** (telepathy-gabble:22588): DEBUG: _process_caps_uri: only 0 trust out of 5 possible thus far, sending disco for URI http://example.com/ICantBelieveItsNotTelepathy#1.2.3
>** (telepathy-gabble:22588): DEBUG: gabble_disco_request_with_timeout: Creating disco request 0x2632a00 for bob@localhost/Bob
>
>SEND:
>-----------------------------------
><iq type="get" to="bob@localhost/Bob" id="16411442520"> <query node="http://example.com/ICantBelieveItsNotTelepathy#1.2.3" xmlns="http://jabber.org/protocol/disco#info"></query>
></iq>
>
>-----------------------------------
>** (telepathy-gabble:22588): DEBUG: _process_caps: Emitting caps update: handle 2, old 0, new 0
>
>RECV [329]:
>-----------------------------------
>'<iq to='bob@localhost/Bob' type='result' id='16411442520'> <query xmlns='http://jabber.org/protocol/disco#info' node='http://example.com/ICantBelieveItsNotTelepathy#1.2.3'><feature var='http://telepathy.freedesktop.org/xmpp/tubes'/></query>
></iq><iq type='get' id='H_3'><query xmlns='http://jabber.org/protocol/disco#info'/></iq>'
>-----------------------------------
>** (telepathy-gabble:22588): DEBUG: _caps_disco_cb: setting caps for 2 (thanks to 2 bob@localhost/Bob) to 512 (save_caps 0)
>** (telepathy-gabble:22588): DEBUG: gabble_presence_set_capabilities: about to add caps 512 to resource Bob with serial 1
>** (telepathy-gabble:22588): DEBUG: gabble_presence_set_capabilities: found resource Bob
>** (telepathy-gabble:22588): DEBUG: gabble_presence_set_capabilities: new serial 1, old 0, clearing caps
>** (telepathy-gabble:22588): DEBUG: gabble_presence_set_capabilities: adding caps 512 to resource Bob
>** (telepathy-gabble:22588): DEBUG: gabble_presence_set_capabilities: resource Bob caps now 512
>** (telepathy-gabble:22588): DEBUG: gabble_presence_set_capabilities: total caps now 512
>** (telepathy-gabble:22588): DEBUG: _caps_disco_cb: caps for 2 (thanks to 2 bob@localhost/Bob) now 512
>** (telepathy-gabble:22588): DEBUG: disco_waiter_free: freeing waiter 0x262f230 for handle 2 with serial 1
>** (telepathy-gabble:22588): DEBUG: connection_iq_disco_cb: got disco request for node (null), caps are 23e5
>** (telepathy-gabble:22588): DEBUG: connection_iq_disco_cb: caps now 9189
>** (telepathy-gabble:22588): DEBUG: connection_iq_disco_cb: sending disco response:
><iq type="result" id="H_3"> <query xmlns="http://jabber.org/protocol/disco#info"> <identity type="pc" name="Telepathy Gabble 0.7.22.1" category="client"></identity>
> <feature var="http://www.google.com/xmpp/protocol/session"></feature>
> <feature var="http://www.google.com/transport/p2p"></feature>
> <feature var="http://jabber.org/protocol/jingle"></feature>
> <feature var="urn:xmpp:jingle:0"></feature>
> <feature var="http://jabber.org/protocol/chatstates"></feature>
> <feature var="http://jabber.org/protocol/nick"></feature>
> <feature var="http://jabber.org/protocol/nick+notify"></feature>
> <feature var="http://jabber.org/protocol/si"></feature>
> <feature var="http://jabber.org/protocol/ibb"></feature>
> <feature var="http://telepathy.freedesktop.org/xmpp/tubes"></feature>
> <feature var="http://jabber.org/protocol/bytestreams"></feature>
></query>
></iq>
>
>
>SEND:
>-----------------------------------
><iq type="result" id="H_3"> <query xmlns="http://jabber.org/protocol/disco#info"> <identity type="pc" name="Telepathy Gabble 0.7.22.1" category="client"></identity>
> <feature var="http://www.google.com/xmpp/protocol/session"></feature>
> <feature var="http://www.google.com/transport/p2p"></feature>
> <feature var="http://jabber.org/protocol/jingle"></feature>
> <feature var="urn:xmpp:jingle:0"></feature>
> <feature var="http://jabber.org/protocol/chatstates"></feature>
> <feature var="http://jabber.org/protocol/nick"></feature>
> <feature var="http://jabber.org/protocol/nick+notify"></feature>
> <feature var="http://jabber.org/protocol/si"></feature>
> <feature var="http://jabber.org/protocol/ibb"></feature>
> <feature var="http://telepathy.freedesktop.org/xmpp/tubes"></feature>
> <feature var="http://jabber.org/protocol/bytestreams"></feature>
></query>
></iq>
>
>-----------------------------------
>
>RECV [609]:
>-----------------------------------
>'<iq from='bob@localhost/Bob' type='set' id='H_4' to='test@localhost/Reource'><si xmlns='http://jabber.org/protocol/si' profile='http://telepathy.freedesktop.org/xmpp/tubes' id='beta'><feature xmlns='http://jabber.org/protocol/feature-neg'><x xmlns='jabber:x:data' type='form'><field var='stream-method' type='list-single'><option><value>http://jabber.org/protocol/ibb</value></option></field></x></feature><tube xmlns='http://telepathy.freedesktop.org/xmpp/tubes' type='dbus' id='69' service='com.example.TestCase2'><parameters><parameter type='str' name='login'>TEST</parameter></parameters></tube></si></iq>'
>-----------------------------------
>** (telepathy-gabble:22588): DEBUG: streaminit_parse_request: Got stream-method http://jabber.org/protocol/ibb
>** (telepathy-gabble:22588): DEBUG: bytestream_factory_iq_si_cb: received a SI request
>** (telepathy-gabble:22588): DEBUG: bytestream_factory_iq_si_cb: Receiver doesn't support multi bytestreams. He chose http://jabber.org/protocol/ibb
>** (telepathy-gabble:22588): DEBUG: gabble_signal_connect_weak: connecting to 0x262aa20:state-changed with context 0x2631d80
>** (telepathy-gabble:22588): DEBUG: gabble_bytestream_factory_create_ibb: add IBB bytestream <beta> from <bob@localhost/Bob>
>** (telepathy-gabble:22588): DEBUG: gabble_private_tubes_factory_handle_si_tube_request: contact#2 stream beta
>** (telepathy-gabble:22588): DEBUG: gabble_tubes_channel_constructor: Called
>** (telepathy-gabble:22588): DEBUG: gabble_tubes_channel_set_property: Setting object_path: /org/freedesktop/Telepathy/Connection/gabble/jabber/test_40localhost_2fResource/SITubesChannel2
>** (telepathy-gabble:22588): DEBUG: gabble_tubes_channel_constructor: Registering at '/org/freedesktop/Telepathy/Connection/gabble/jabber/test_40localhost_2fResource/SITubesChannel2'
>** (telepathy-gabble:22588): DEBUG: new_tubes_channel: object path /org/freedesktop/Telepathy/Connection/gabble/jabber/test_40localhost_2fResource/SITubesChannel2
>** (telepathy-gabble:22588): DEBUG: gabble_tube_dbus_constructor: Registering at '/org/freedesktop/Telepathy/Connection/gabble/jabber/test_40localhost_2fResource/DBusTubeChannel_2_69'
>** (telepathy-gabble:22588): DEBUG: create_new_tube: create tube 69
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_dbus_request_handles: 1 handles of type 1, for :1.0
>** (telepathy-gabble:22588): DEBUG: gabble_tube_dbus_accept: accept the SI request
>
>SEND:
>-----------------------------------
><iq type="result" to="bob@localhost/Bob" id="H_4"> <si xmlns="http://jabber.org/protocol/si"> <feature xmlns="http://jabber.org/protocol/feature-neg"> <x type="submit" xmlns="jabber:x:data"> <field var="stream-method"> <value>http://jabber.org/protocol/ibb</value>
></field>
></x>
></feature>
> <tube xmlns="http://telepathy.freedesktop.org/xmpp/tubes"></tube>
></si>
></iq>
>
>-----------------------------------
>** (telepathy-gabble:22588): DEBUG: gabble_bytestream_ibb_accept: stream beta with bob@localhost/Bob is now accepted
>** (telepathy-gabble:22588): DEBUG: create_dbus_server: listening on unix:path=/tmp/dbus-gabble-pk60SlaX
>
>RECV [154]:
>-----------------------------------
>'<iq to='test@localhost/Reource' type='set' id='H_5' from='bob@localhost/Bob'><open xmlns='http://jabber.org/protocol/ibb' block-size='1' sid='beta'/></iq>'
>-----------------------------------
>
>SEND:
>-----------------------------------
><iq type="result" to="bob@localhost/Bob" id="H_5"></iq>
>
>-----------------------------------
>
>RECV [611]:
>-----------------------------------
>'<iq from='bob@localhost/Bob' type='set' id='H_6' to='test@localhost/Resource'><si xmlns='http://jabber.org/protocol/si' profile='http://telepathy.freedesktop.org/xmpp/tubes' id='gamma'><feature xmlns='http://jabber.org/protocol/feature-neg'><x xmlns='jabber:x:data' type='form'><field var='stream-method' type='list-single'><option><value>http://jabber.org/protocol/ibb</value></option></field></x></feature><tube xmlns='http://telepathy.freedesktop.org/xmpp/tubes' type='dbus' id='70' service='com.example.TestCase2'><parameters><parameter type='str' name='login'>TEST</parameter></parameters></tube></si></iq>'
>-----------------------------------
>** (telepathy-gabble:22588): DEBUG: streaminit_parse_request: Got stream-method http://jabber.org/protocol/ibb
>** (telepathy-gabble:22588): DEBUG: bytestream_factory_iq_si_cb: received a SI request
>** (telepathy-gabble:22588): DEBUG: bytestream_factory_iq_si_cb: Receiver doesn't support multi bytestreams. He chose http://jabber.org/protocol/ibb
>** (telepathy-gabble:22588): DEBUG: gabble_signal_connect_weak: connecting to 0x262aac0:state-changed with context 0x26374e0
>** (telepathy-gabble:22588): DEBUG: gabble_bytestream_factory_create_ibb: add IBB bytestream <gamma> from <bob@localhost/Bob>
>** (telepathy-gabble:22588): DEBUG: gabble_private_tubes_factory_handle_si_tube_request: contact#2 stream gamma
>** (telepathy-gabble:22588): DEBUG: gabble_tube_dbus_constructor: Registering at '/org/freedesktop/Telepathy/Connection/gabble/jabber/test_40localhost_2fResource/DBusTubeChannel_2_70'
>** (telepathy-gabble:22588): DEBUG: create_new_tube: create tube 70
>** (telepathy-gabble:22588): DEBUG: gabble_tube_dbus_accept: accept the SI request
>
>SEND:
>-----------------------------------
><iq type="result" to="bob@localhost/Bob" id="H_6"> <si xmlns="http://jabber.org/protocol/si"> <feature xmlns="http://jabber.org/protocol/feature-neg"> <x type="submit" xmlns="jabber:x:data"> <field var="stream-method"> <value>http://jabber.org/protocol/ibb</value>
></field>
></x>
></feature>
> <tube xmlns="http://telepathy.freedesktop.org/xmpp/tubes"></tube>
></si>
></iq>
>
>-----------------------------------
>** (telepathy-gabble:22588): DEBUG: gabble_bytestream_ibb_accept: stream gamma with bob@localhost/Bob is now accepted
>** (telepathy-gabble:22588): DEBUG: create_dbus_server: listening on unix:path=/tmp/dbus-gabble-UfFiOnAp
>
>RECV [156]:
>-----------------------------------
>'<iq to='test@localhost/Resource' type='set' id='H_7' from='bob@localhost/Bob'><open xmlns='http://jabber.org/protocol/ibb' block-size='1' sid='gamma'/></iq>'
>-----------------------------------
>
>SEND:
>-----------------------------------
><iq type="result" to="bob@localhost/Bob" id="H_7"></iq>
>
>-----------------------------------
>** (telepathy-gabble:22588): DEBUG: send_close_stanza: send IBB close stanza
>
>SEND:
>-----------------------------------
><iq type="set" to="bob@localhost/Bob" id="542823547199"> <close sid="gamma" xmlns="http://jabber.org/protocol/ibb"></close>
></iq>
>
>-----------------------------------
>** (telepathy-gabble:22588): DEBUG: remove_bytestream: removing bytestream: <gamma> from <bob@localhost/Bob>
>** (telepathy-gabble:22588): DEBUG: tube_closed_cb: tube 70 removed
>** (telepathy-gabble:22588): DEBUG: instance_destroyed_cb: instance for 0x26374e0 destroyed; cleaning up
>** (telepathy-gabble:22588): DEBUG: gabble_tube_dbus_dispose: unlink of /tmp/dbus-gabble-UfFiOnAp failed: No such file or directory
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_change_status: was 0, now 2, for reason 1
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_change_status: emitting status-changed to 2, for reason 1
>** (telepathy-gabble:22588): DEBUG: gabble_roster_close_all: closing channels
>** (telepathy-gabble:22588): DEBUG: roster_channel_closed_cb: 0x2616740, channel 0x2616b50
>** (telepathy-gabble:22588): DEBUG: roster_channel_closed_cb: 0x2616740, channel 0x262d000
>** (telepathy-gabble:22588): DEBUG: roster_channel_closed_cb: 0x2616740, channel 0x262d070
>** (telepathy-gabble:22588): DEBUG: gabble_roster_close_all: removing callbacks
>** (telepathy-gabble:22588): DEBUG: gabble_im_factory_close_all: closing channels
>** (telepathy-gabble:22588): DEBUG: gabble_im_factory_close_all: removing callbacks
>** (telepathy-gabble:22588): DEBUG: connection_status_changed_cb: disconnected, closing room lists
>** (telepathy-gabble:22588): DEBUG: gabble_roomlist_manager_close_all: 0x2607d40
>** (telepathy-gabble:22588): DEBUG: gabble_muc_factory_close_all: closing channels
>** (telepathy-gabble:22588): DEBUG: gabble_muc_factory_close_all: removing callbacks
>** (telepathy-gabble:22588): DEBUG: gabble_private_tubes_factory_close_all: closing 1-1 tubes channels
>** (telepathy-gabble:22588): DEBUG: gabble_tubes_channel_close: called on 0x262d480
>** (telepathy-gabble:22588): DEBUG: send_close_stanza: send IBB close stanza
>
>SEND:
>-----------------------------------
><iq type="set" to="bob@localhost/Bob" id="548888553391"> <close sid="beta" xmlns="http://jabber.org/protocol/ibb"></close>
></iq>
>
>-----------------------------------
>** (telepathy-gabble:22588): DEBUG: remove_bytestream: removing bytestream: <beta> from <bob@localhost/Bob>
>** (telepathy-gabble:22588): DEBUG: instance_destroyed_cb: instance for 0x2631d80 destroyed; cleaning up
>** (telepathy-gabble:22588): DEBUG: gabble_tube_dbus_dispose: unlink of /tmp/dbus-gabble-pk60SlaX failed: No such file or directory
>** (telepathy-gabble:22588): DEBUG: gabble_media_factory_close_all: closing channels
>** (telepathy-gabble:22588): DEBUG: connection_shut_down: still open; calling lm_connection_close
>
>SEND:
>-----------------------------------
></stream:stream>
>-----------------------------------
>Freeing up IOChannel and file descriptor
>** (telepathy-gabble:22588): DEBUG: connection_disconnected_cb: called with reason 0
>** (telepathy-gabble:22588): DEBUG: connection_disconnected_cb: expected; emitting DISCONNECTED
>(telepathy-gabble:22588): tp-glib-DEBUG: connection_shutdown_finished_cb: dereferenced connection
>** (telepathy-gabble:22588): DEBUG: gabble_connection_dispose: called
>** (telepathy-gabble:22588): DEBUG: gabble_bytestream_factory_dispose: dispose called
>** (telepathy-gabble:22588): DEBUG: gabble_disco_dispose: dispose called
>** (telepathy-gabble:22588): DEBUG: disco_items_cb: Got error on items request: Request for items on localhost cancelled
>** (telepathy-gabble:22588): DEBUG: gabble_disco_finalize: called with 0x261bf80
>** (telepathy-gabble:22588): DEBUG: gabble_request_pipeline_dispose: disposing request-pipeline
>** (telepathy-gabble:22588): DEBUG: gabble_vcard_manager_dispose: 0x2616840
>** (telepathy-gabble:22588): DEBUG: gabble_vcard_manager_finalize: 0x2616840
>** (telepathy-gabble:22588): DEBUG: gabble_jingle_factory_dispose: dispose called
>** (telepathy-gabble:22588): DEBUG: gabble_presence_cache_dispose: dispose called
>** (telepathy-gabble:22588): DEBUG: disco_waiter_list_free: list (nil)
>** (telepathy-gabble:22588): DEBUG: gabble_presence_cache_finalize: called with 0x260f140
>** (telepathy-gabble:22588): DEBUG: gabble_roster_dispose: dispose called
>** (telepathy-gabble:22588): DEBUG: gabble_roster_close_all: closing channels
>** (telepathy-gabble:22588): DEBUG: gabble_roster_finalize: called with 0x2616740
>** (telepathy-gabble:22588): DEBUG: gabble_im_factory_dispose: dispose called
>** (telepathy-gabble:22588): DEBUG: gabble_roomlist_manager_dispose: running
>** (telepathy-gabble:22588): DEBUG: gabble_roomlist_manager_close_all: 0x2607d40
>** (telepathy-gabble:22588): DEBUG: gabble_muc_factory_dispose: dispose called
>** (telepathy-gabble:22588): DEBUG: gabble_muc_factory_close_all: closing channels
>** (telepathy-gabble:22588): DEBUG: gabble_private_tubes_factory_dispose: dispose called
>** (telepathy-gabble:22588): DEBUG: gabble_private_tubes_factory_close_all: closing 1-1 tubes channels
>** (telepathy-gabble:22588): DEBUG: gabble_media_factory_dispose: dispose called
>** (telepathy-gabble:22588): DEBUG: gabble_media_factory_close_all: closing channels
>** (telepathy-gabble:22588): DEBUG: gabble_olpc_gadget_manager_dispose: running
>** (telepathy-gabble:22588): DEBUG: gabble_olpc_gadget_manager_close_all: 0x261bec0
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_proxy_signal_connection_lost_weak_ref: 0x26165f0: lost weak ref to 0x2611a40
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_proxy_signal_connection_lost_weak_ref: 0x2616660: lost weak ref to 0x2611aa0
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_proxy_signal_connection_lost_weak_ref: 0x26166d0: lost weak ref to 0x2611b00
>** (telepathy-gabble:22588): DEBUG: gabble_connection_finalize: called with 0x2618130
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_contacts_mixin_finalize: 0x2618130
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_presence_mixin_finalize: 0x2618130
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_cm_param_setter_offset: account = "test@localhost/Resource"
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_cm_param_setter_offset: password = <hidden>
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_cm_param_setter_offset: server = "localhost"
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_cm_param_setter_offset: resource = "Resource"
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_cm_param_setter_offset: priority = 0 = 0x0
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_cm_param_setter_offset: port = 4242 = 0x1092
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_cm_param_setter_offset: old-ssl = FALSE
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_cm_param_setter_offset: require-encryption = FALSE
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_cm_param_setter_offset: register = FALSE
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_cm_param_setter_offset: low-bandwidth = FALSE
>(telepathy-gabble:22588): tp-glib-DEBUG: parse_parameters: https-proxy-server not given, using default behaviour
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_cm_param_setter_offset: https-proxy-port = 443 = 0x1bb
>(telepathy-gabble:22588): tp-glib-DEBUG: parse_parameters: fallback-conference-server not given, using default behaviour
>(telepathy-gabble:22588): tp-glib-DEBUG: parse_parameters: stun-server not given, using default behaviour
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_cm_param_setter_offset: stun-port = 3478 = 0xd96
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_cm_param_setter_offset: fallback-stun-server = "stun.collabora.co.uk"
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_cm_param_setter_offset: fallback-stun-port = 3478 = 0xd96
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_cm_param_setter_offset: ignore-ssl-errors = FALSE
>(telepathy-gabble:22588): tp-glib-DEBUG: parse_parameters: alias not given, using default behaviour
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_init: Initializing (TpBaseConnection *)0x26183b0
>** (telepathy-gabble:22588): DEBUG: gabble_connection_init: Initializing (GabbleConnection *)0x26183b0
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_constructor: Post-construction: (TpBaseConnection *)0x26183b0
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_constructor: Handle repo for type #0 at (nil)
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_constructor: Handle repo for type #1 at 0x2638580
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_constructor: Handle repo for type #2 at 0x26385e0
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_constructor: Handle repo for type #3 at 0x260a810
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_constructor: Handle repo for type #4 at 0x2638640
>** (telepathy-gabble:22588): DEBUG: gabble_roomlist_manager_constructed: 0x2639940
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_constructor: Channel manager #0 at 0x2638d50
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_constructor: Channel manager #1 at 0x26398f0
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_constructor: Channel manager #2 at 0x2639940
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_constructor: Channel manager #3 at 0x260f340
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_constructor: Channel manager #4 at 0x2639990
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_constructor: Channel manager #5 at 0x26399e0
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_constructor: Channel manager #6 at 0x261bec0
>** (telepathy-gabble:22588): DEBUG: gabble_connection_constructor: Post-construction: (GabbleConnection *)0x26183b0
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_presence_mixin_init: called.
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_register: bus name org.freedesktop.Telepathy.Connection.gabble.jabber.test_40localhost_2fResource
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_register: object path /org/freedesktop/Telepathy/Connection/gabble/jabber/test_40localhost_2fResource
>** (telepathy-gabble:22588): DEBUG: _gabble_connection_connect: disabling SRV because "server" or "port" parameter specified, will connect to localhost
>** (telepathy-gabble:22588): DEBUG: do_connect: calling lm_connection_open
>Going to connect to localhost:4242
>Trying ::1 port 4242...
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_change_status: was 4294967295, now 1, for reason 1
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_change_status: emitting status-changed to 1, for reason 1
>** (telepathy-gabble:22588): DEBUG: connection_status_changed_cb: adding callbacks
>** (telepathy-gabble:22588): DEBUG: connection_status_changed_cb: adding callbacks
>** (telepathy-gabble:22588): DEBUG: connection_status_changed_cb: adding callbacks
>Connection failed.
>Connection failed: Connection refused (error 111)
>Freeing up IOChannel and file descriptor
>Trying 127.0.0.1 port 4242...
>Connection success (1).
>
>SEND:
>-----------------------------------
><?xml version='1.0' encoding='UTF-8'?>
>-----------------------------------
>
>SEND:
>-----------------------------------
><stream:stream version="1.0" xmlns="jabber:client" xmlns:stream="http://etherx.jabber.org/streams" to="localhost" id="551973588819">
>-----------------------------------
>
>RECV [107]:
>-----------------------------------
>'<stream:stream xmlns:stream='http://etherx.jabber.org/streams' xmlns='jabber:client' id='4277459d1dcc4995'>'
>-----------------------------------
>** (telepathy-gabble:22588): DEBUG: do_auth: authenticating with username: test, password: <hidden>, resource: Resource
>
>SEND:
>-----------------------------------
><iq type="get" id="591898592807"> <query xmlns="jabber:iq:auth"> <username>test</username>
></query>
></iq>
>
>-----------------------------------
>
>RECV [135]:
>-----------------------------------
>'<iq type='result' id='591898592807'><query xmlns='jabber:iq:auth'><username>test</username><password/><digest/><resource/></query></iq>'
>-----------------------------------
>
>SEND:
>-----------------------------------
><iq type="set" id="591957596680"> <query xmlns="jabber:iq:auth"> <username>test</username>
> <digest>e129cb35a47acb370fa7daadc501ff320c24a7e8</digest>
> <resource>Resource</resource>
></query>
></iq>
>
>-----------------------------------
>
>RECV [37]:
>-----------------------------------
>'<iq type='result' id='591957596680'/>'
>-----------------------------------
>** (telepathy-gabble:22588): DEBUG: connection_auth_cb: Created self handle 1, our JID is test@localhost/Resource
>** (telepathy-gabble:22588): DEBUG: gabble_presence_set_capabilities: about to add caps 9189 to resource Resource with serial 1
>** (telepathy-gabble:22588): DEBUG: gabble_presence_set_capabilities: found resource Resource
>** (telepathy-gabble:22588): DEBUG: gabble_presence_set_capabilities: new serial 1, old 0, clearing caps
>** (telepathy-gabble:22588): DEBUG: gabble_presence_set_capabilities: adding caps 9189 to resource Resource
>** (telepathy-gabble:22588): DEBUG: gabble_presence_set_capabilities: resource Resource caps now 9189
>** (telepathy-gabble:22588): DEBUG: gabble_presence_set_capabilities: total caps now 9189
>** (telepathy-gabble:22588): DEBUG: gabble_disco_request_with_timeout: Creating disco request 0x2632a80 for localhost
>
>SEND:
>-----------------------------------
><iq type="get" to="localhost" id="600152601066"> <query xmlns="http://jabber.org/protocol/disco#info"></query>
></iq>
>
>-----------------------------------
>
>RECV [159]:
>-----------------------------------
>'<iq to='localhost' type='result' id='600152601066'> <query xmlns='http://jabber.org/protocol/disco#info'><identity category='pubsub' type='pep'/></query>
></iq>'
>-----------------------------------
>** (telepathy-gabble:22588): DEBUG: connection_disco_cb: got:
><query xmlns="http://jabber.org/protocol/disco#info"> <identity type="pep" category="pubsub"></identity>
></query>
>
>** (telepathy-gabble:22588): DEBUG: connection_disco_cb: set features flags to 16
>
>SEND:
>-----------------------------------
><presence id="599133603974"> <x xmlns="vcard-temp:x:update"></x>
> <c ver="8JLvg+nSJV0Gy/WEK3/RXaWBoLI=" node="http://telepathy.freedesktop.org/caps" hash="sha-1" xmlns="http://jabber.org/protocol/caps"></c>
></presence>
>
>-----------------------------------
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_change_status: was 1, now 0, for reason 1
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_change_status: emitting status-changed to 0, for reason 1
>** (telepathy-gabble:22588): DEBUG: connection_status_changed_cb: requesting roster
>
>SEND:
>-----------------------------------
><iq type="get" id="600104604336"> <query xmlns="jabber:iq:roster"></query>
></iq>
>
>-----------------------------------
>** (telepathy-gabble:22588): DEBUG: gabble_disco_conn_status_changed_cb: connected, initiating service discovery on localhost
>** (telepathy-gabble:22588): DEBUG: gabble_disco_request_with_timeout: Creating disco request 0x2623d40 for localhost
>
>SEND:
>-----------------------------------
><iq type="get" to="localhost" id="600105604569"> <query xmlns="http://jabber.org/protocol/disco#items"></query>
></iq>
>
>-----------------------------------
>** (telepathy-gabble:22588): DEBUG: gabble_vcard_manager_request: Created request 0x260a900 to retrieve <1>'s vCard
>** (telepathy-gabble:22588): DEBUG: cache_entry_ensure_queued: Cache entry 0x260a930 is my own, not setting @to
>** (telepathy-gabble:22588): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x262f380
>** (telepathy-gabble:22588): DEBUG: cache_entry_ensure_queued: adding request to cache entry 0x260a930 and queueing the <iq>
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_presence_mixin_emit_presence_update: called.
>(telepathy-gabble:22588): tp-glib-DEBUG: construct_presence_hash: called.
>(telepathy-gabble:22588): tp-glib-DEBUG: construct_simple_presence_hash: called.
>
>SEND:
>-----------------------------------
><iq type="set" id="601199605308"> <pubsub xmlns="http://jabber.org/protocol/pubsub"> <publish node="http://laptop.org/xmpp/activities"> <item> <activities xmlns="http://laptop.org/xmpp/activities"></activities>
></item>
></publish>
></pubsub>
></iq>
>
>-----------------------------------
>
>SEND:
>-----------------------------------
><iq type="set" id="601134605491"> <pubsub xmlns="http://jabber.org/protocol/pubsub"> <publish node="http://laptop.org/xmpp/activity-properties"> <item> <activities xmlns="http://laptop.org/xmpp/activity-properties"></activities>
></item>
></publish>
></pubsub>
></iq>
>
>-----------------------------------
>** (telepathy-gabble:22588): DEBUG: send_next_request: processing request 0x262f380
>
>SEND:
>-----------------------------------
><iq type="get" id="600094604813"> <vCard xmlns="vcard-temp"></vCard>
></iq>
>
>-----------------------------------
>
>RECV [383]:
>-----------------------------------
>'<iq type='result' id='600094604813'><vCard xmlns='vcard-temp'/></iq><iq type='result' id='600104604336'> <query xmlns='jabber:iq:roster'><item jid='bob@localhost' subscription='both'/></query>
></iq><presence to='test@localhost/Resource' from='bob@localhost/Bob'><c node='http://example.com/ICantBelieveItsNotTelepathy' xmlns='http://jabber.org/protocol/caps' ver='1.2.3'/></presence>'
>-----------------------------------
>** (telepathy-gabble:22588): DEBUG: response_cb: got reply for request 0x262f380
>** (telepathy-gabble:22588): DEBUG: pipeline_reply_cb: called for entry 0x260a930
>** (telepathy-gabble:22588): DEBUG: observe_vcard: got no vCard alias for handle 1
>
>SEND:
>-----------------------------------
><presence id="614493651752"> <x xmlns="vcard-temp:x:update"> <photo></photo>
></x>
> <c ver="8JLvg+nSJV0Gy/WEK3/RXaWBoLI=" node="http://telepathy.freedesktop.org/caps" hash="sha-1" xmlns="http://jabber.org/protocol/caps"></c>
></presence>
>
>-----------------------------------
>** (telepathy-gabble:22588): DEBUG: delete_request: Discarding request 0x260a900
>** (telepathy-gabble:22588): DEBUG: cache_entry_attempt_to_free: Not freeing vCard cache entry 0x260a930: it has a cached vCard 0x262b790
>** (telepathy-gabble:22588): DEBUG: delete_item: deleting item 0x262f380
>** (telepathy-gabble:22588): DEBUG: _gabble_roster_get_channel: Looking up channel 3:1 "publish"
>** (telepathy-gabble:22588): DEBUG: _gabble_roster_create_channel: Instantiating channel 3:1 "publish"
>[1m[37mtp_group_mixin_change_flags: emitting group flags changed
>  added    : [[22mCAN_REMOVE|MESSAGE_REMOVE|MESSAGE_ACCEPT|PROPERTIES[1m]
>  removed  : [[22m[1m]
>  flags now: [[22mCAN_REMOVE|MESSAGE_REMOVE|MESSAGE_ACCEPT|PROPERTIES[1m]
>[0m** (telepathy-gabble:22588): DEBUG: _gabble_roster_create_channel: created /org/freedesktop/Telepathy/Connection/gabble/jabber/test_40localhost_2fResource/RosterChannel/List/publish
>** (telepathy-gabble:22588): DEBUG: _gabble_roster_create_channel: roster not yet received, not emitting signal for publish list channel
>** (telepathy-gabble:22588): DEBUG: _gabble_roster_get_channel: Looking up channel 3:2 "subscribe"
>** (telepathy-gabble:22588): DEBUG: _gabble_roster_create_channel: Instantiating channel 3:2 "subscribe"
>[1m[37mtp_group_mixin_change_flags: emitting group flags changed
>  added    : [[22mCAN_ADD|CAN_REMOVE|CAN_RESCIND|MESSAGE_ADD|MESSAGE_REMOVE|MESSAGE_RESCIND|PROPERTIES[1m]
>  removed  : [[22m[1m]
>  flags now: [[22mCAN_ADD|CAN_REMOVE|CAN_RESCIND|MESSAGE_ADD|MESSAGE_REMOVE|MESSAGE_RESCIND|PROPERTIES[1m]
>[0m** (telepathy-gabble:22588): DEBUG: _gabble_roster_create_channel: created /org/freedesktop/Telepathy/Connection/gabble/jabber/test_40localhost_2fResource/RosterChannel/List/subscribe
>** (telepathy-gabble:22588): DEBUG: _gabble_roster_create_channel: roster not yet received, not emitting signal for subscribe list channel
>** (telepathy-gabble:22588): DEBUG: _gabble_roster_item_update: Checking which groups contact#2 was just added to:
>** (telepathy-gabble:22588): DEBUG: _gabble_roster_item_update: Checking which groups contact#2 was just removed from:
>** (telepathy-gabble:22588): DEBUG: gabble_roster_iq_cb: jid: bob@localhost, subscription: both
>** (telepathy-gabble:22588): DEBUG: gabble_roster_iq_cb: calling change members on publish channel
>[1m[36memit_members_changed_signals: emitting members changed
>  message       : ""
>  added         : [[22m2 (bob@localhost)[1m]
>  removed       : [[22m[1m]
>  local_pending : [[22m[1m]
>  remote_pending: [[22m[1m]
>  actor         : 0
>  reason        : 0: unspecified reason
>[0m** (telepathy-gabble:22588): DEBUG: gabble_roster_iq_cb: calling change members on subscribe channel
>[1m[36memit_members_changed_signals: emitting members changed
>  message       : ""
>  added         : [[22m2 (bob@localhost)[1m]
>  removed       : [[22m[1m]
>  local_pending : [[22m[1m]
>  remote_pending: [[22m[1m]
>  actor         : 0
>  reason        : 0: unspecified reason
>[0m** (telepathy-gabble:22588): DEBUG: _gabble_roster_get_channel: Looking up channel 3:3 "known"
>** (telepathy-gabble:22588): DEBUG: _gabble_roster_create_channel: Instantiating channel 3:3 "known"
>[1m[37mtp_group_mixin_change_flags: emitting group flags changed
>  added    : [[22mCAN_REMOVE|PROPERTIES[1m]
>  removed  : [[22m[1m]
>  flags now: [[22mCAN_REMOVE|PROPERTIES[1m]
>[0m** (telepathy-gabble:22588): DEBUG: _gabble_roster_create_channel: created /org/freedesktop/Telepathy/Connection/gabble/jabber/test_40localhost_2fResource/RosterChannel/List/known
>** (telepathy-gabble:22588): DEBUG: _gabble_roster_create_channel: roster not yet received, not emitting signal for known list channel
>** (telepathy-gabble:22588): DEBUG: gabble_roster_iq_cb: calling change members on known channel
>[1m[36memit_members_changed_signals: emitting members changed
>  message       : ""
>  added         : [[22m2 (bob@localhost)[1m]
>  removed       : [[22m[1m]
>  local_pending : [[22m[1m]
>  remote_pending: [[22m[1m]
>  actor         : 0
>  reason        : 0: unspecified reason
>[0m** (telepathy-gabble:22588): DEBUG: gabble_roster_iq_cb: calling change members on any group channels
>** (telepathy-gabble:22588): DEBUG: _gabble_roster_emit_one: roster now received, emitting signal signal for publish list channel
>** (telepathy-gabble:22588): DEBUG: _gabble_roster_emit_one: roster now received, emitting signal signal for subscribe list channel
>** (telepathy-gabble:22588): DEBUG: _gabble_roster_emit_one: roster now received, emitting signal signal for known list channel
>** (telepathy-gabble:22588): DEBUG: gabble_presence_cache_do_update: bob@localhost (2) resource Bob prio 0 presence 7 message "(null)"
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_presence_mixin_emit_presence_update: called.
>(telepathy-gabble:22588): tp-glib-DEBUG: construct_presence_hash: called.
>(telepathy-gabble:22588): tp-glib-DEBUG: construct_simple_presence_hash: called.
>** (telepathy-gabble:22588): DEBUG: _process_caps_uri: not enough trust for URI http://example.com/ICantBelieveItsNotTelepathy#1.2.3
>** (telepathy-gabble:22588): DEBUG: disco_waiter_new: created waiter 0x263b190 for handle 2 with serial 1
>** (telepathy-gabble:22588): DEBUG: _process_caps_uri: only 0 trust out of 5 possible thus far, sending disco for URI http://example.com/ICantBelieveItsNotTelepathy#1.2.3
>** (telepathy-gabble:22588): DEBUG: gabble_disco_request_with_timeout: Creating disco request 0x261bc00 for bob@localhost/Bob
>
>SEND:
>-----------------------------------
><iq type="get" to="bob@localhost/Bob" id="525360657307"> <query node="http://example.com/ICantBelieveItsNotTelepathy#1.2.3" xmlns="http://jabber.org/protocol/disco#info"></query>
></iq>
>
>-----------------------------------
>** (telepathy-gabble:22588): DEBUG: _process_caps: Emitting caps update: handle 2, old 0, new 0
>
>RECV [331]:
>-----------------------------------
>'<iq to='bob@localhost/Bob' type='result' id='525360657307'> <query xmlns='http://jabber.org/protocol/disco#info' node='http://example.com/ICantBelieveItsNotTelepathy#1.2.3'><feature var='http://telepathy.freedesktop.org/xmpp/tubes'/></query>
></iq><iq type='get' id='H_11'><query xmlns='http://jabber.org/protocol/disco#info'/></iq>'
>-----------------------------------
>** (telepathy-gabble:22588): DEBUG: _caps_disco_cb: setting caps for 2 (thanks to 2 bob@localhost/Bob) to 512 (save_caps 0)
>** (telepathy-gabble:22588): DEBUG: gabble_presence_set_capabilities: about to add caps 512 to resource Bob with serial 1
>** (telepathy-gabble:22588): DEBUG: gabble_presence_set_capabilities: found resource Bob
>** (telepathy-gabble:22588): DEBUG: gabble_presence_set_capabilities: new serial 1, old 0, clearing caps
>** (telepathy-gabble:22588): DEBUG: gabble_presence_set_capabilities: adding caps 512 to resource Bob
>** (telepathy-gabble:22588): DEBUG: gabble_presence_set_capabilities: resource Bob caps now 512
>** (telepathy-gabble:22588): DEBUG: gabble_presence_set_capabilities: total caps now 512
>** (telepathy-gabble:22588): DEBUG: _caps_disco_cb: caps for 2 (thanks to 2 bob@localhost/Bob) now 512
>** (telepathy-gabble:22588): DEBUG: disco_waiter_free: freeing waiter 0x263b190 for handle 2 with serial 1
>** (telepathy-gabble:22588): DEBUG: connection_iq_disco_cb: got disco request for node (null), caps are 23e5
>** (telepathy-gabble:22588): DEBUG: connection_iq_disco_cb: caps now 9189
>** (telepathy-gabble:22588): DEBUG: connection_iq_disco_cb: sending disco response:
><iq type="result" id="H_11"> <query xmlns="http://jabber.org/protocol/disco#info"> <identity type="pc" name="Telepathy Gabble 0.7.22.1" category="client"></identity>
> <feature var="http://www.google.com/xmpp/protocol/session"></feature>
> <feature var="http://www.google.com/transport/p2p"></feature>
> <feature var="http://jabber.org/protocol/jingle"></feature>
> <feature var="urn:xmpp:jingle:0"></feature>
> <feature var="http://jabber.org/protocol/chatstates"></feature>
> <feature var="http://jabber.org/protocol/nick"></feature>
> <feature var="http://jabber.org/protocol/nick+notify"></feature>
> <feature var="http://jabber.org/protocol/si"></feature>
> <feature var="http://jabber.org/protocol/ibb"></feature>
> <feature var="http://telepathy.freedesktop.org/xmpp/tubes"></feature>
> <feature var="http://jabber.org/protocol/bytestreams"></feature>
></query>
></iq>
>
>
>SEND:
>-----------------------------------
><iq type="result" id="H_11"> <query xmlns="http://jabber.org/protocol/disco#info"> <identity type="pc" name="Telepathy Gabble 0.7.22.1" category="client"></identity>
> <feature var="http://www.google.com/xmpp/protocol/session"></feature>
> <feature var="http://www.google.com/transport/p2p"></feature>
> <feature var="http://jabber.org/protocol/jingle"></feature>
> <feature var="urn:xmpp:jingle:0"></feature>
> <feature var="http://jabber.org/protocol/chatstates"></feature>
> <feature var="http://jabber.org/protocol/nick"></feature>
> <feature var="http://jabber.org/protocol/nick+notify"></feature>
> <feature var="http://jabber.org/protocol/si"></feature>
> <feature var="http://jabber.org/protocol/ibb"></feature>
> <feature var="http://telepathy.freedesktop.org/xmpp/tubes"></feature>
> <feature var="http://jabber.org/protocol/bytestreams"></feature>
></query>
></iq>
>
>-----------------------------------
>
>RECV [610]:
>-----------------------------------
>'<iq from='bob@localhost/Bob' type='set' id='H_12' to='test@localhost/Reource'><si xmlns='http://jabber.org/protocol/si' profile='http://telepathy.freedesktop.org/xmpp/tubes' id='beta'><feature xmlns='http://jabber.org/protocol/feature-neg'><x xmlns='jabber:x:data' type='form'><field var='stream-method' type='list-single'><option><value>http://jabber.org/protocol/ibb</value></option></field></x></feature><tube xmlns='http://telepathy.freedesktop.org/xmpp/tubes' type='dbus' id='69' service='com.example.TestCase2'><parameters><parameter type='str' name='login'>TEST</parameter></parameters></tube></si></iq>'
>-----------------------------------
>** (telepathy-gabble:22588): DEBUG: streaminit_parse_request: Got stream-method http://jabber.org/protocol/ibb
>** (telepathy-gabble:22588): DEBUG: bytestream_factory_iq_si_cb: received a SI request
>** (telepathy-gabble:22588): DEBUG: bytestream_factory_iq_si_cb: Receiver doesn't support multi bytestreams. He chose http://jabber.org/protocol/ibb
>** (telepathy-gabble:22588): DEBUG: gabble_signal_connect_weak: connecting to 0x262ad40:state-changed with context 0x2634380
>** (telepathy-gabble:22588): DEBUG: gabble_bytestream_factory_create_ibb: add IBB bytestream <beta> from <bob@localhost/Bob>
>** (telepathy-gabble:22588): DEBUG: gabble_private_tubes_factory_handle_si_tube_request: contact#2 stream beta
>** (telepathy-gabble:22588): DEBUG: gabble_tubes_channel_constructor: Called
>** (telepathy-gabble:22588): DEBUG: gabble_tubes_channel_set_property: Setting object_path: /org/freedesktop/Telepathy/Connection/gabble/jabber/test_40localhost_2fResource/SITubesChannel2
>** (telepathy-gabble:22588): DEBUG: gabble_tubes_channel_constructor: Registering at '/org/freedesktop/Telepathy/Connection/gabble/jabber/test_40localhost_2fResource/SITubesChannel2'
>** (telepathy-gabble:22588): DEBUG: new_tubes_channel: object path /org/freedesktop/Telepathy/Connection/gabble/jabber/test_40localhost_2fResource/SITubesChannel2
>** (telepathy-gabble:22588): DEBUG: gabble_tube_dbus_constructor: Registering at '/org/freedesktop/Telepathy/Connection/gabble/jabber/test_40localhost_2fResource/DBusTubeChannel_2_69'
>** (telepathy-gabble:22588): DEBUG: create_new_tube: create tube 69
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_dbus_request_handles: 1 handles of type 1, for :1.0
>** (telepathy-gabble:22588): DEBUG: gabble_tube_dbus_accept: accept the SI request
>
>SEND:
>-----------------------------------
><iq type="result" to="bob@localhost/Bob" id="H_12"> <si xmlns="http://jabber.org/protocol/si"> <feature xmlns="http://jabber.org/protocol/feature-neg"> <x type="submit" xmlns="jabber:x:data"> <field var="stream-method"> <value>http://jabber.org/protocol/ibb</value>
></field>
></x>
></feature>
> <tube xmlns="http://telepathy.freedesktop.org/xmpp/tubes"></tube>
></si>
></iq>
>
>-----------------------------------
>** (telepathy-gabble:22588): DEBUG: gabble_bytestream_ibb_accept: stream beta with bob@localhost/Bob is now accepted
>** (telepathy-gabble:22588): DEBUG: create_dbus_server: listening on unix:path=/tmp/dbus-gabble--M35M_UT
>
>RECV [155]:
>-----------------------------------
>'<iq to='test@localhost/Reource' type='set' id='H_13' from='bob@localhost/Bob'><open xmlns='http://jabber.org/protocol/ibb' block-size='1' sid='beta'/></iq>'
>-----------------------------------
>
>SEND:
>-----------------------------------
><iq type="result" to="bob@localhost/Bob" id="H_13"></iq>
>
>-----------------------------------
>
>RECV [612]:
>-----------------------------------
>'<iq from='bob@localhost/Bob' type='set' id='H_14' to='test@localhost/Resource'><si xmlns='http://jabber.org/protocol/si' profile='http://telepathy.freedesktop.org/xmpp/tubes' id='gamma'><feature xmlns='http://jabber.org/protocol/feature-neg'><x xmlns='jabber:x:data' type='form'><field var='stream-method' type='list-single'><option><value>http://jabber.org/protocol/ibb</value></option></field></x></feature><tube xmlns='http://telepathy.freedesktop.org/xmpp/tubes' type='dbus' id='70' service='com.example.TestCase2'><parameters><parameter type='str' name='login'>TEST</parameter></parameters></tube></si></iq>'
>-----------------------------------
>** (telepathy-gabble:22588): DEBUG: streaminit_parse_request: Got stream-method http://jabber.org/protocol/ibb
>** (telepathy-gabble:22588): DEBUG: bytestream_factory_iq_si_cb: received a SI request
>** (telepathy-gabble:22588): DEBUG: bytestream_factory_iq_si_cb: Receiver doesn't support multi bytestreams. He chose http://jabber.org/protocol/ibb
>** (telepathy-gabble:22588): DEBUG: gabble_signal_connect_weak: connecting to 0x262ade0:state-changed with context 0x263bc60
>** (telepathy-gabble:22588): DEBUG: gabble_bytestream_factory_create_ibb: add IBB bytestream <gamma> from <bob@localhost/Bob>
>** (telepathy-gabble:22588): DEBUG: gabble_private_tubes_factory_handle_si_tube_request: contact#2 stream gamma
>** (telepathy-gabble:22588): DEBUG: gabble_tube_dbus_constructor: Registering at '/org/freedesktop/Telepathy/Connection/gabble/jabber/test_40localhost_2fResource/DBusTubeChannel_2_70'
>** (telepathy-gabble:22588): DEBUG: create_new_tube: create tube 70
>** (telepathy-gabble:22588): DEBUG: gabble_tube_dbus_accept: accept the SI request
>
>SEND:
>-----------------------------------
><iq type="result" to="bob@localhost/Bob" id="H_14"> <si xmlns="http://jabber.org/protocol/si"> <feature xmlns="http://jabber.org/protocol/feature-neg"> <x type="submit" xmlns="jabber:x:data"> <field var="stream-method"> <value>http://jabber.org/protocol/ibb</value>
></field>
></x>
></feature>
> <tube xmlns="http://telepathy.freedesktop.org/xmpp/tubes"></tube>
></si>
></iq>
>
>-----------------------------------
>** (telepathy-gabble:22588): DEBUG: gabble_bytestream_ibb_accept: stream gamma with bob@localhost/Bob is now accepted
>** (telepathy-gabble:22588): DEBUG: create_dbus_server: listening on unix:path=/tmp/dbus-gabble-okqo8ZmO
>
>RECV [157]:
>-----------------------------------
>'<iq to='test@localhost/Resource' type='set' id='H_15' from='bob@localhost/Bob'><open xmlns='http://jabber.org/protocol/ibb' block-size='1' sid='gamma'/></iq>'
>-----------------------------------
>
>SEND:
>-----------------------------------
><iq type="result" to="bob@localhost/Bob" id="H_15"></iq>
>
>-----------------------------------
>** (telepathy-gabble:22588): DEBUG: send_close_stanza: send IBB close stanza
>
>SEND:
>-----------------------------------
><iq type="set" to="bob@localhost/Bob" id="591910759842"> <close sid="gamma" xmlns="http://jabber.org/protocol/ibb"></close>
></iq>
>
>-----------------------------------
>** (telepathy-gabble:22588): DEBUG: remove_bytestream: removing bytestream: <gamma> from <bob@localhost/Bob>
>** (telepathy-gabble:22588): DEBUG: tube_closed_cb: tube 70 removed
>** (telepathy-gabble:22588): DEBUG: instance_destroyed_cb: instance for 0x263bc60 destroyed; cleaning up
>** (telepathy-gabble:22588): DEBUG: gabble_tube_dbus_dispose: unlink of /tmp/dbus-gabble-okqo8ZmO failed: No such file or directory
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_change_status: was 0, now 2, for reason 1
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_change_status: emitting status-changed to 2, for reason 1
>** (telepathy-gabble:22588): DEBUG: gabble_roster_close_all: closing channels
>** (telepathy-gabble:22588): DEBUG: roster_channel_closed_cb: 0x2638d50, channel 0x2638ea0
>** (telepathy-gabble:22588): DEBUG: roster_channel_closed_cb: 0x2638d50, channel 0x2638f10
>** (telepathy-gabble:22588): DEBUG: roster_channel_closed_cb: 0x2638d50, channel 0x26166d0
>** (telepathy-gabble:22588): DEBUG: gabble_roster_close_all: removing callbacks
>** (telepathy-gabble:22588): DEBUG: gabble_im_factory_close_all: closing channels
>** (telepathy-gabble:22588): DEBUG: gabble_im_factory_close_all: removing callbacks
>** (telepathy-gabble:22588): DEBUG: connection_status_changed_cb: disconnected, closing room lists
>** (telepathy-gabble:22588): DEBUG: gabble_roomlist_manager_close_all: 0x2639940
>** (telepathy-gabble:22588): DEBUG: gabble_muc_factory_close_all: closing channels
>** (telepathy-gabble:22588): DEBUG: gabble_muc_factory_close_all: removing callbacks
>** (telepathy-gabble:22588): DEBUG: gabble_private_tubes_factory_close_all: closing 1-1 tubes channels
>** (telepathy-gabble:22588): DEBUG: gabble_tubes_channel_close: called on 0x2616660
>** (telepathy-gabble:22588): DEBUG: send_close_stanza: send IBB close stanza
>
>SEND:
>-----------------------------------
><iq type="set" to="bob@localhost/Bob" id="598121766949"> <close sid="beta" xmlns="http://jabber.org/protocol/ibb"></close>
></iq>
>
>-----------------------------------
>** (telepathy-gabble:22588): DEBUG: remove_bytestream: removing bytestream: <beta> from <bob@localhost/Bob>
>** (telepathy-gabble:22588): DEBUG: instance_destroyed_cb: instance for 0x2634380 destroyed; cleaning up
>** (telepathy-gabble:22588): DEBUG: gabble_tube_dbus_dispose: unlink of /tmp/dbus-gabble--M35M_UT failed: No such file or directory
>** (telepathy-gabble:22588): DEBUG: gabble_media_factory_close_all: closing channels
>** (telepathy-gabble:22588): DEBUG: connection_shut_down: still open; calling lm_connection_close
>
>SEND:
>-----------------------------------
></stream:stream>
>-----------------------------------
>Freeing up IOChannel and file descriptor
>** (telepathy-gabble:22588): DEBUG: connection_disconnected_cb: called with reason 0
>** (telepathy-gabble:22588): DEBUG: connection_disconnected_cb: expected; emitting DISCONNECTED
>(telepathy-gabble:22588): tp-glib-DEBUG: connection_shutdown_finished_cb: dereferenced connection
>** (telepathy-gabble:22588): DEBUG: gabble_connection_dispose: called
>** (telepathy-gabble:22588): DEBUG: gabble_bytestream_factory_dispose: dispose called
>** (telepathy-gabble:22588): DEBUG: gabble_disco_dispose: dispose called
>** (telepathy-gabble:22588): DEBUG: disco_items_cb: Got error on items request: Request for items on localhost cancelled
>** (telepathy-gabble:22588): DEBUG: gabble_disco_finalize: called with 0x25fd9c0
>** (telepathy-gabble:22588): DEBUG: gabble_request_pipeline_dispose: disposing request-pipeline
>** (telepathy-gabble:22588): DEBUG: gabble_vcard_manager_dispose: 0x2638dc0
>** (telepathy-gabble:22588): DEBUG: gabble_vcard_manager_finalize: 0x2638dc0
>** (telepathy-gabble:22588): DEBUG: gabble_jingle_factory_dispose: dispose called
>** (telepathy-gabble:22588): DEBUG: gabble_presence_cache_dispose: dispose called
>** (telepathy-gabble:22588): DEBUG: disco_waiter_list_free: list (nil)
>** (telepathy-gabble:22588): DEBUG: gabble_presence_cache_finalize: called with 0x260f3c0
>** (telepathy-gabble:22588): DEBUG: gabble_roster_dispose: dispose called
>** (telepathy-gabble:22588): DEBUG: gabble_roster_close_all: closing channels
>** (telepathy-gabble:22588): DEBUG: gabble_roster_finalize: called with 0x2638d50
>** (telepathy-gabble:22588): DEBUG: gabble_im_factory_dispose: dispose called
>** (telepathy-gabble:22588): DEBUG: gabble_roomlist_manager_dispose: running
>** (telepathy-gabble:22588): DEBUG: gabble_roomlist_manager_close_all: 0x2639940
>** (telepathy-gabble:22588): DEBUG: gabble_muc_factory_dispose: dispose called
>** (telepathy-gabble:22588): DEBUG: gabble_muc_factory_close_all: closing channels
>** (telepathy-gabble:22588): DEBUG: gabble_private_tubes_factory_dispose: dispose called
>** (telepathy-gabble:22588): DEBUG: gabble_private_tubes_factory_close_all: closing 1-1 tubes channels
>** (telepathy-gabble:22588): DEBUG: gabble_media_factory_dispose: dispose called
>** (telepathy-gabble:22588): DEBUG: gabble_media_factory_close_all: closing channels
>** (telepathy-gabble:22588): DEBUG: gabble_olpc_gadget_manager_dispose: running
>** (telepathy-gabble:22588): DEBUG: gabble_olpc_gadget_manager_close_all: 0x261bec0
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_proxy_signal_connection_lost_weak_ref: 0x2638c00: lost weak ref to 0x2638580
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_proxy_signal_connection_lost_weak_ref: 0x2638c70: lost weak ref to 0x26385e0
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_proxy_signal_connection_lost_weak_ref: 0x2638ce0: lost weak ref to 0x2638640
>** (telepathy-gabble:22588): DEBUG: gabble_connection_finalize: called with 0x26183b0
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_contacts_mixin_finalize: 0x26183b0
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_presence_mixin_finalize: 0x26183b0
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_cm_param_setter_offset: account = "test@localhost/Resource"
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_cm_param_setter_offset: password = <hidden>
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_cm_param_setter_offset: server = "localhost"
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_cm_param_setter_offset: resource = "Resource"
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_cm_param_setter_offset: priority = 0 = 0x0
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_cm_param_setter_offset: port = 4242 = 0x1092
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_cm_param_setter_offset: old-ssl = FALSE
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_cm_param_setter_offset: require-encryption = FALSE
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_cm_param_setter_offset: register = FALSE
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_cm_param_setter_offset: low-bandwidth = FALSE
>(telepathy-gabble:22588): tp-glib-DEBUG: parse_parameters: https-proxy-server not given, using default behaviour
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_cm_param_setter_offset: https-proxy-port = 443 = 0x1bb
>(telepathy-gabble:22588): tp-glib-DEBUG: parse_parameters: fallback-conference-server not given, using default behaviour
>(telepathy-gabble:22588): tp-glib-DEBUG: parse_parameters: stun-server not given, using default behaviour
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_cm_param_setter_offset: stun-port = 3478 = 0xd96
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_cm_param_setter_offset: fallback-stun-server = "stun.collabora.co.uk"
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_cm_param_setter_offset: fallback-stun-port = 3478 = 0xd96
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_cm_param_setter_offset: ignore-ssl-errors = FALSE
>(telepathy-gabble:22588): tp-glib-DEBUG: parse_parameters: alias not given, using default behaviour
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_init: Initializing (TpBaseConnection *)0x2618630
>** (telepathy-gabble:22588): DEBUG: gabble_connection_init: Initializing (GabbleConnection *)0x2618630
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_constructor: Post-construction: (TpBaseConnection *)0x2618630
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_constructor: Handle repo for type #0 at (nil)
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_constructor: Handle repo for type #1 at 0x2638700
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_constructor: Handle repo for type #2 at 0x2638760
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_constructor: Handle repo for type #3 at 0x260a810
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_constructor: Handle repo for type #4 at 0x2638800
>** (telepathy-gabble:22588): DEBUG: gabble_roomlist_manager_constructed: 0x2639b20
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_constructor: Channel manager #0 at 0x26168b0
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_constructor: Channel manager #1 at 0x2639b70
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_constructor: Channel manager #2 at 0x2639b20
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_constructor: Channel manager #3 at 0x260f5c0
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_constructor: Channel manager #4 at 0x2639ad0
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_constructor: Channel manager #5 at 0x2639a80
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_constructor: Channel manager #6 at 0x261bec0
>** (telepathy-gabble:22588): DEBUG: gabble_connection_constructor: Post-construction: (GabbleConnection *)0x2618630
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_presence_mixin_init: called.
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_register: bus name org.freedesktop.Telepathy.Connection.gabble.jabber.test_40localhost_2fResource
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_register: object path /org/freedesktop/Telepathy/Connection/gabble/jabber/test_40localhost_2fResource
>** (telepathy-gabble:22588): DEBUG: _gabble_connection_connect: disabling SRV because "server" or "port" parameter specified, will connect to localhost
>** (telepathy-gabble:22588): DEBUG: do_connect: calling lm_connection_open
>Going to connect to localhost:4242
>Trying ::1 port 4242...
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_change_status: was 4294967295, now 1, for reason 1
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_change_status: emitting status-changed to 1, for reason 1
>** (telepathy-gabble:22588): DEBUG: connection_status_changed_cb: adding callbacks
>** (telepathy-gabble:22588): DEBUG: connection_status_changed_cb: adding callbacks
>** (telepathy-gabble:22588): DEBUG: connection_status_changed_cb: adding callbacks
>Connection failed.
>Connection failed: Connection refused (error 111)
>Freeing up IOChannel and file descriptor
>Trying 127.0.0.1 port 4242...
>Connection success (1).
>
>SEND:
>-----------------------------------
><?xml version='1.0' encoding='UTF-8'?>
>-----------------------------------
>
>SEND:
>-----------------------------------
><stream:stream version="1.0" xmlns="jabber:client" xmlns:stream="http://etherx.jabber.org/streams" to="localhost" id="542760809763">
>-----------------------------------
>
>RECV [107]:
>-----------------------------------
>'<stream:stream xmlns:stream='http://etherx.jabber.org/streams' xmlns='jabber:client' id='5c8056c60a68b4bb'>'
>-----------------------------------
>** (telepathy-gabble:22588): DEBUG: do_auth: authenticating with username: test, password: <hidden>, resource: Resource
>
>SEND:
>-----------------------------------
><iq type="get" id="551015814049"> <query xmlns="jabber:iq:auth"> <username>test</username>
></query>
></iq>
>
>-----------------------------------
>
>RECV [135]:
>-----------------------------------
>'<iq type='result' id='551015814049'><query xmlns='jabber:iq:auth'><username>test</username><password/><digest/><resource/></query></iq>'
>-----------------------------------
>
>SEND:
>-----------------------------------
><iq type="set" id="550970817690"> <query xmlns="jabber:iq:auth"> <username>test</username>
> <digest>019c9a72d7411927167ae787de6042652ae1abc3</digest>
> <resource>Resource</resource>
></query>
></iq>
>
>-----------------------------------
>
>RECV [37]:
>-----------------------------------
>'<iq type='result' id='550970817690'/>'
>-----------------------------------
>** (telepathy-gabble:22588): DEBUG: connection_auth_cb: Created self handle 1, our JID is test@localhost/Resource
>** (telepathy-gabble:22588): DEBUG: gabble_presence_set_capabilities: about to add caps 9189 to resource Resource with serial 1
>** (telepathy-gabble:22588): DEBUG: gabble_presence_set_capabilities: found resource Resource
>** (telepathy-gabble:22588): DEBUG: gabble_presence_set_capabilities: new serial 1, old 0, clearing caps
>** (telepathy-gabble:22588): DEBUG: gabble_presence_set_capabilities: adding caps 9189 to resource Resource
>** (telepathy-gabble:22588): DEBUG: gabble_presence_set_capabilities: resource Resource caps now 9189
>** (telepathy-gabble:22588): DEBUG: gabble_presence_set_capabilities: total caps now 9189
>** (telepathy-gabble:22588): DEBUG: gabble_disco_request_with_timeout: Creating disco request 0x261bc80 for localhost
>
>SEND:
>-----------------------------------
><iq type="get" to="localhost" id="526441821992"> <query xmlns="http://jabber.org/protocol/disco#info"></query>
></iq>
>
>-----------------------------------
>
>RECV [159]:
>-----------------------------------
>'<iq to='localhost' type='result' id='526441821992'> <query xmlns='http://jabber.org/protocol/disco#info'><identity category='pubsub' type='pep'/></query>
></iq>'
>-----------------------------------
>** (telepathy-gabble:22588): DEBUG: connection_disco_cb: got:
><query xmlns="http://jabber.org/protocol/disco#info"> <identity type="pep" category="pubsub"></identity>
></query>
>
>** (telepathy-gabble:22588): DEBUG: connection_disco_cb: set features flags to 16
>
>SEND:
>-----------------------------------
><presence id="525372824850"> <x xmlns="vcard-temp:x:update"></x>
> <c ver="8JLvg+nSJV0Gy/WEK3/RXaWBoLI=" node="http://telepathy.freedesktop.org/caps" hash="sha-1" xmlns="http://jabber.org/protocol/caps"></c>
></presence>
>
>-----------------------------------
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_change_status: was 1, now 0, for reason 1
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_change_status: emitting status-changed to 0, for reason 1
>** (telepathy-gabble:22588): DEBUG: connection_status_changed_cb: requesting roster
>
>SEND:
>-----------------------------------
><iq type="get" id="525441825215"> <query xmlns="jabber:iq:roster"></query>
></iq>
>
>-----------------------------------
>** (telepathy-gabble:22588): DEBUG: gabble_disco_conn_status_changed_cb: connected, initiating service discovery on localhost
>** (telepathy-gabble:22588): DEBUG: gabble_disco_request_with_timeout: Creating disco request 0x2632ac0 for localhost
>
>SEND:
>-----------------------------------
><iq type="get" to="localhost" id="526450825447"> <query xmlns="http://jabber.org/protocol/disco#items"></query>
></iq>
>
>-----------------------------------
>** (telepathy-gabble:22588): DEBUG: gabble_vcard_manager_request: Created request 0x260a600 to retrieve <1>'s vCard
>** (telepathy-gabble:22588): DEBUG: cache_entry_ensure_queued: Cache entry 0x260a630 is my own, not setting @to
>** (telepathy-gabble:22588): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x263b470
>** (telepathy-gabble:22588): DEBUG: cache_entry_ensure_queued: adding request to cache entry 0x260a630 and queueing the <iq>
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_presence_mixin_emit_presence_update: called.
>(telepathy-gabble:22588): tp-glib-DEBUG: construct_presence_hash: called.
>(telepathy-gabble:22588): tp-glib-DEBUG: construct_simple_presence_hash: called.
>
>SEND:
>-----------------------------------
><iq type="set" id="526468826199"> <pubsub xmlns="http://jabber.org/protocol/pubsub"> <publish node="http://laptop.org/xmpp/activities"> <item> <activities xmlns="http://laptop.org/xmpp/activities"></activities>
></item>
></publish>
></pubsub>
></iq>
>
>-----------------------------------
>
>SEND:
>-----------------------------------
><iq type="set" id="527423826384"> <pubsub xmlns="http://jabber.org/protocol/pubsub"> <publish node="http://laptop.org/xmpp/activity-properties"> <item> <activities xmlns="http://laptop.org/xmpp/activity-properties"></activities>
></item>
></publish>
></pubsub>
></iq>
>
>-----------------------------------
>** (telepathy-gabble:22588): DEBUG: send_next_request: processing request 0x263b470
>
>SEND:
>-----------------------------------
><iq type="get" id="526465825693"> <vCard xmlns="vcard-temp"></vCard>
></iq>
>
>-----------------------------------
>
>RECV [383]:
>-----------------------------------
>'<iq type='result' id='526465825693'><vCard xmlns='vcard-temp'/></iq><iq type='result' id='525441825215'> <query xmlns='jabber:iq:roster'><item jid='bob@localhost' subscription='both'/></query>
></iq><presence to='test@localhost/Resource' from='bob@localhost/Bob'><c node='http://example.com/ICantBelieveItsNotTelepathy' xmlns='http://jabber.org/protocol/caps' ver='1.2.3'/></presence>'
>-----------------------------------
>** (telepathy-gabble:22588): DEBUG: response_cb: got reply for request 0x263b470
>** (telepathy-gabble:22588): DEBUG: pipeline_reply_cb: called for entry 0x260a630
>** (telepathy-gabble:22588): DEBUG: observe_vcard: got no vCard alias for handle 1
>
>SEND:
>-----------------------------------
><presence id="589890885011"> <x xmlns="vcard-temp:x:update"> <photo></photo>
></x>
> <c ver="8JLvg+nSJV0Gy/WEK3/RXaWBoLI=" node="http://telepathy.freedesktop.org/caps" hash="sha-1" xmlns="http://jabber.org/protocol/caps"></c>
></presence>
>
>-----------------------------------
>** (telepathy-gabble:22588): DEBUG: delete_request: Discarding request 0x260a600
>** (telepathy-gabble:22588): DEBUG: cache_entry_attempt_to_free: Not freeing vCard cache entry 0x260a630: it has a cached vCard 0x2626780
>** (telepathy-gabble:22588): DEBUG: delete_item: deleting item 0x263b470
>** (telepathy-gabble:22588): DEBUG: _gabble_roster_get_channel: Looking up channel 3:1 "publish"
>** (telepathy-gabble:22588): DEBUG: _gabble_roster_create_channel: Instantiating channel 3:1 "publish"
>[1m[37mtp_group_mixin_change_flags: emitting group flags changed
>  added    : [[22mCAN_REMOVE|MESSAGE_REMOVE|MESSAGE_ACCEPT|PROPERTIES[1m]
>  removed  : [[22m[1m]
>  flags now: [[22mCAN_REMOVE|MESSAGE_REMOVE|MESSAGE_ACCEPT|PROPERTIES[1m]
>[0m** (telepathy-gabble:22588): DEBUG: _gabble_roster_create_channel: created /org/freedesktop/Telepathy/Connection/gabble/jabber/test_40localhost_2fResource/RosterChannel/List/publish
>** (telepathy-gabble:22588): DEBUG: _gabble_roster_create_channel: roster not yet received, not emitting signal for publish list channel
>** (telepathy-gabble:22588): DEBUG: _gabble_roster_get_channel: Looking up channel 3:2 "subscribe"
>** (telepathy-gabble:22588): DEBUG: _gabble_roster_create_channel: Instantiating channel 3:2 "subscribe"
>[1m[37mtp_group_mixin_change_flags: emitting group flags changed
>  added    : [[22mCAN_ADD|CAN_REMOVE|CAN_RESCIND|MESSAGE_ADD|MESSAGE_REMOVE|MESSAGE_RESCIND|PROPERTIES[1m]
>  removed  : [[22m[1m]
>  flags now: [[22mCAN_ADD|CAN_REMOVE|CAN_RESCIND|MESSAGE_ADD|MESSAGE_REMOVE|MESSAGE_RESCIND|PROPERTIES[1m]
>[0m** (telepathy-gabble:22588): DEBUG: _gabble_roster_create_channel: created /org/freedesktop/Telepathy/Connection/gabble/jabber/test_40localhost_2fResource/RosterChannel/List/subscribe
>** (telepathy-gabble:22588): DEBUG: _gabble_roster_create_channel: roster not yet received, not emitting signal for subscribe list channel
>** (telepathy-gabble:22588): DEBUG: _gabble_roster_item_update: Checking which groups contact#2 was just added to:
>** (telepathy-gabble:22588): DEBUG: _gabble_roster_item_update: Checking which groups contact#2 was just removed from:
>** (telepathy-gabble:22588): DEBUG: gabble_roster_iq_cb: jid: bob@localhost, subscription: both
>** (telepathy-gabble:22588): DEBUG: gabble_roster_iq_cb: calling change members on publish channel
>[1m[36memit_members_changed_signals: emitting members changed
>  message       : ""
>  added         : [[22m2 (bob@localhost)[1m]
>  removed       : [[22m[1m]
>  local_pending : [[22m[1m]
>  remote_pending: [[22m[1m]
>  actor         : 0
>  reason        : 0: unspecified reason
>[0m** (telepathy-gabble:22588): DEBUG: gabble_roster_iq_cb: calling change members on subscribe channel
>[1m[36memit_members_changed_signals: emitting members changed
>  message       : ""
>  added         : [[22m2 (bob@localhost)[1m]
>  removed       : [[22m[1m]
>  local_pending : [[22m[1m]
>  remote_pending: [[22m[1m]
>  actor         : 0
>  reason        : 0: unspecified reason
>[0m** (telepathy-gabble:22588): DEBUG: _gabble_roster_get_channel: Looking up channel 3:3 "known"
>** (telepathy-gabble:22588): DEBUG: _gabble_roster_create_channel: Instantiating channel 3:3 "known"
>[1m[37mtp_group_mixin_change_flags: emitting group flags changed
>  added    : [[22mCAN_REMOVE|PROPERTIES[1m]
>  removed  : [[22m[1m]
>  flags now: [[22mCAN_REMOVE|PROPERTIES[1m]
>[0m** (telepathy-gabble:22588): DEBUG: _gabble_roster_create_channel: created /org/freedesktop/Telepathy/Connection/gabble/jabber/test_40localhost_2fResource/RosterChannel/List/known
>** (telepathy-gabble:22588): DEBUG: _gabble_roster_create_channel: roster not yet received, not emitting signal for known list channel
>** (telepathy-gabble:22588): DEBUG: gabble_roster_iq_cb: calling change members on known channel
>[1m[36memit_members_changed_signals: emitting members changed
>  message       : ""
>  added         : [[22m2 (bob@localhost)[1m]
>  removed       : [[22m[1m]
>  local_pending : [[22m[1m]
>  remote_pending: [[22m[1m]
>  actor         : 0
>  reason        : 0: unspecified reason
>[0m** (telepathy-gabble:22588): DEBUG: gabble_roster_iq_cb: calling change members on any group channels
>** (telepathy-gabble:22588): DEBUG: _gabble_roster_emit_one: roster now received, emitting signal signal for publish list channel
>** (telepathy-gabble:22588): DEBUG: _gabble_roster_emit_one: roster now received, emitting signal signal for subscribe list channel
>** (telepathy-gabble:22588): DEBUG: _gabble_roster_emit_one: roster now received, emitting signal signal for known list channel
>** (telepathy-gabble:22588): DEBUG: gabble_presence_cache_do_update: bob@localhost (2) resource Bob prio 0 presence 7 message "(null)"
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_presence_mixin_emit_presence_update: called.
>(telepathy-gabble:22588): tp-glib-DEBUG: construct_presence_hash: called.
>(telepathy-gabble:22588): tp-glib-DEBUG: construct_simple_presence_hash: called.
>** (telepathy-gabble:22588): DEBUG: _process_caps_uri: not enough trust for URI http://example.com/ICantBelieveItsNotTelepathy#1.2.3
>** (telepathy-gabble:22588): DEBUG: disco_waiter_new: created waiter 0x26248c0 for handle 2 with serial 1
>** (telepathy-gabble:22588): DEBUG: _process_caps_uri: only 0 trust out of 5 possible thus far, sending disco for URI http://example.com/ICantBelieveItsNotTelepathy#1.2.3
>** (telepathy-gabble:22588): DEBUG: gabble_disco_request_with_timeout: Creating disco request 0x261bd40 for bob@localhost/Bob
>
>SEND:
>-----------------------------------
><iq type="get" to="bob@localhost/Bob" id="590981890613"> <query node="http://example.com/ICantBelieveItsNotTelepathy#1.2.3" xmlns="http://jabber.org/protocol/disco#info"></query>
></iq>
>
>-----------------------------------
>** (telepathy-gabble:22588): DEBUG: _process_caps: Emitting caps update: handle 2, old 0, new 0
>
>RECV [331]:
>-----------------------------------
>'<iq to='bob@localhost/Bob' type='result' id='590981890613'> <query xmlns='http://jabber.org/protocol/disco#info' node='http://example.com/ICantBelieveItsNotTelepathy#1.2.3'><feature var='http://telepathy.freedesktop.org/xmpp/tubes'/></query>
></iq><iq type='get' id='H_19'><query xmlns='http://jabber.org/protocol/disco#info'/></iq>'
>-----------------------------------
>** (telepathy-gabble:22588): DEBUG: _caps_disco_cb: setting caps for 2 (thanks to 2 bob@localhost/Bob) to 512 (save_caps 0)
>** (telepathy-gabble:22588): DEBUG: gabble_presence_set_capabilities: about to add caps 512 to resource Bob with serial 1
>** (telepathy-gabble:22588): DEBUG: gabble_presence_set_capabilities: found resource Bob
>** (telepathy-gabble:22588): DEBUG: gabble_presence_set_capabilities: new serial 1, old 0, clearing caps
>** (telepathy-gabble:22588): DEBUG: gabble_presence_set_capabilities: adding caps 512 to resource Bob
>** (telepathy-gabble:22588): DEBUG: gabble_presence_set_capabilities: resource Bob caps now 512
>** (telepathy-gabble:22588): DEBUG: gabble_presence_set_capabilities: total caps now 512
>** (telepathy-gabble:22588): DEBUG: _caps_disco_cb: caps for 2 (thanks to 2 bob@localhost/Bob) now 512
>** (telepathy-gabble:22588): DEBUG: disco_waiter_free: freeing waiter 0x26248c0 for handle 2 with serial 1
>** (telepathy-gabble:22588): DEBUG: connection_iq_disco_cb: got disco request for node (null), caps are 23e5
>** (telepathy-gabble:22588): DEBUG: connection_iq_disco_cb: caps now 9189
>** (telepathy-gabble:22588): DEBUG: connection_iq_disco_cb: sending disco response:
><iq type="result" id="H_19"> <query xmlns="http://jabber.org/protocol/disco#info"> <identity type="pc" name="Telepathy Gabble 0.7.22.1" category="client"></identity>
> <feature var="http://www.google.com/xmpp/protocol/session"></feature>
> <feature var="http://www.google.com/transport/p2p"></feature>
> <feature var="http://jabber.org/protocol/jingle"></feature>
> <feature var="urn:xmpp:jingle:0"></feature>
> <feature var="http://jabber.org/protocol/chatstates"></feature>
> <feature var="http://jabber.org/protocol/nick"></feature>
> <feature var="http://jabber.org/protocol/nick+notify"></feature>
> <feature var="http://jabber.org/protocol/si"></feature>
> <feature var="http://jabber.org/protocol/ibb"></feature>
> <feature var="http://telepathy.freedesktop.org/xmpp/tubes"></feature>
> <feature var="http://jabber.org/protocol/bytestreams"></feature>
></query>
></iq>
>
>
>SEND:
>-----------------------------------
><iq type="result" id="H_19"> <query xmlns="http://jabber.org/protocol/disco#info"> <identity type="pc" name="Telepathy Gabble 0.7.22.1" category="client"></identity>
> <feature var="http://www.google.com/xmpp/protocol/session"></feature>
> <feature var="http://www.google.com/transport/p2p"></feature>
> <feature var="http://jabber.org/protocol/jingle"></feature>
> <feature var="urn:xmpp:jingle:0"></feature>
> <feature var="http://jabber.org/protocol/chatstates"></feature>
> <feature var="http://jabber.org/protocol/nick"></feature>
> <feature var="http://jabber.org/protocol/nick+notify"></feature>
> <feature var="http://jabber.org/protocol/si"></feature>
> <feature var="http://jabber.org/protocol/ibb"></feature>
> <feature var="http://telepathy.freedesktop.org/xmpp/tubes"></feature>
> <feature var="http://jabber.org/protocol/bytestreams"></feature>
></query>
></iq>
>
>-----------------------------------
>
>RECV [618]:
>-----------------------------------
>'<iq from='bob@localhost/Bob' type='set' id='H_20' to='test@localhost/Reource'><si xmlns='http://jabber.org/protocol/si' profile='http://telepathy.freedesktop.org/xmpp/tubes' id='beta'><feature xmlns='http://jabber.org/protocol/feature-neg'><x xmlns='jabber:x:data' type='form'><field var='stream-method' type='list-single'><option><value>http://jabber.org/protocol/bytestreams</value></option></field></x></feature><tube xmlns='http://telepathy.freedesktop.org/xmpp/tubes' type='dbus' id='69' service='com.example.TestCase2'><parameters><parameter type='str' name='login'>TEST</parameter></parameters></tube></si></iq>'
>-----------------------------------
>** (telepathy-gabble:22588): DEBUG: streaminit_parse_request: Got stream-method http://jabber.org/protocol/bytestreams
>** (telepathy-gabble:22588): DEBUG: bytestream_factory_iq_si_cb: received a SI request
>** (telepathy-gabble:22588): DEBUG: bytestream_factory_iq_si_cb: Receiver doesn't support multi bytestreams. He chose http://jabber.org/protocol/bytestreams
>** (telepathy-gabble:22588): DEBUG: gabble_signal_connect_weak: connecting to 0x262ac00:state-changed with context 0x26230c0
>** (telepathy-gabble:22588): DEBUG: gabble_bytestream_factory_create_socks5: add SOCKS5 bytestream <beta> from <bob@localhost/Bob>
>** (telepathy-gabble:22588): DEBUG: gabble_private_tubes_factory_handle_si_tube_request: contact#2 stream beta
>** (telepathy-gabble:22588): DEBUG: gabble_tubes_channel_constructor: Called
>** (telepathy-gabble:22588): DEBUG: gabble_tubes_channel_set_property: Setting object_path: /org/freedesktop/Telepathy/Connection/gabble/jabber/test_40localhost_2fResource/SITubesChannel2
>** (telepathy-gabble:22588): DEBUG: gabble_tubes_channel_constructor: Registering at '/org/freedesktop/Telepathy/Connection/gabble/jabber/test_40localhost_2fResource/SITubesChannel2'
>** (telepathy-gabble:22588): DEBUG: new_tubes_channel: object path /org/freedesktop/Telepathy/Connection/gabble/jabber/test_40localhost_2fResource/SITubesChannel2
>** (telepathy-gabble:22588): DEBUG: gabble_tube_dbus_constructor: Registering at '/org/freedesktop/Telepathy/Connection/gabble/jabber/test_40localhost_2fResource/DBusTubeChannel_2_69'
>** (telepathy-gabble:22588): DEBUG: create_new_tube: create tube 69
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_dbus_request_handles: 1 handles of type 1, for :1.0
>** (telepathy-gabble:22588): DEBUG: gabble_tube_dbus_accept: accept the SI request
>
>SEND:
>-----------------------------------
><iq type="result" to="bob@localhost/Bob" id="H_20"> <si xmlns="http://jabber.org/protocol/si"> <feature xmlns="http://jabber.org/protocol/feature-neg"> <x type="submit" xmlns="jabber:x:data"> <field var="stream-method"> <value>http://jabber.org/protocol/bytestreams</value>
></field>
></x>
></feature>
> <tube xmlns="http://telepathy.freedesktop.org/xmpp/tubes"></tube>
></si>
></iq>
>
>-----------------------------------
>** (telepathy-gabble:22588): DEBUG: gabble_bytestream_socks5_accept: stream beta with bob@localhost/Bob is now accepted
>** (telepathy-gabble:22588): DEBUG: create_dbus_server: listening on unix:path=/tmp/dbus-gabble-DStqdn3M
>
>RECV [358]:
>-----------------------------------
>'<iq to='test@localhost/Reource' type='set' id='H_21' from='bob@localhost/Bob'><query xmlns='http://jabber.org/protocol/bytestreams' mode='tcp' sid='beta'><streamhost jid='invalid.invalid' host='invalid.invalid' port='5000'/><streamhost jid='bob@localhost/Bob' host='127.0.0.1' port='5000'/><streamhost jid='Not me' host='127.0.0.1' port='5000'/></query></iq>'
>-----------------------------------
>** (telepathy-gabble:22588): DEBUG: gabble_bytestream_socks5_add_streamhost: streamhost with jid invalid.invalid, host invalid.invalid and port 5000 added
>** (telepathy-gabble:22588): DEBUG: gabble_bytestream_socks5_add_streamhost: streamhost with jid bob@localhost/Bob, host 127.0.0.1 and port 5000 added
>** (telepathy-gabble:22588): DEBUG: gabble_bytestream_socks5_add_streamhost: streamhost with jid Not me, host 127.0.0.1 and port 5000 added
>** (telepathy-gabble:22588): DEBUG: socks5_connect: Trying streamhost invalid.invalid on port 5000
>** (telepathy-gabble:22588): DEBUG: gibber_tcp_transport_connect: getaddrinfo failed: Name or service not known
>** (telepathy-gabble:22588): DEBUG: transport_disconnected_cb: Sock5 transport disconnected
>** (telepathy-gabble:22588): DEBUG: socks5_error: connection to streamhost failed, trying the next one
>** (telepathy-gabble:22588): DEBUG: socks5_connect: Trying streamhost 127.0.0.1 on port 5000
>** (telepathy-gabble:22588): DEBUG: new_connect_attempt: Trying 127.0.0.1 port 5000...
>** (telepathy-gabble:22588): DEBUG: try_to_connect: connect succeeded
>** (telepathy-gabble:22588): DEBUG: transport_connected_cb: transport is connected. Sending auth request
>** (telepathy-gabble:22588): DEBUG: _writeout: Writing out 3 bytes
>** (telepathy-gabble:22588): DEBUG: gibber_fd_transport_read: Received 2 bytes
>** (telepathy-gabble:22588): DEBUG: transport_handler: got 2 bytes from sock5 transport
>** (telepathy-gabble:22588): DEBUG: _writeout: Writing out 47 bytes
>** (telepathy-gabble:22588): DEBUG: gibber_fd_transport_read: Received 2 bytes
>** (telepathy-gabble:22588): DEBUG: transport_handler: got 2 bytes from sock5 transport
>** (telepathy-gabble:22588): DEBUG: socks5_handle_received_data: sock5 stream connected. Bytestream is now open
>
>SEND:
>-----------------------------------
><iq type="result" to="bob@localhost/Bob" id="H_21"> <query xmlns="http://jabber.org/protocol/bytestreams"> <streamhost-used jid="bob@localhost/Bob"></streamhost-used>
></query>
></iq>
>
>-----------------------------------
>
>RECV [620]:
>-----------------------------------
>'<iq from='bob@localhost/Bob' type='set' id='H_22' to='test@localhost/Resource'><si xmlns='http://jabber.org/protocol/si' profile='http://telepathy.freedesktop.org/xmpp/tubes' id='gamma'><feature xmlns='http://jabber.org/protocol/feature-neg'><x xmlns='jabber:x:data' type='form'><field var='stream-method' type='list-single'><option><value>http://jabber.org/protocol/bytestreams</value></option></field></x></feature><tube xmlns='http://telepathy.freedesktop.org/xmpp/tubes' type='dbus' id='70' service='com.example.TestCase2'><parameters><parameter type='str' name='login'>TEST</parameter></parameters></tube></si></iq>'
>-----------------------------------
>** (telepathy-gabble:22588): DEBUG: streaminit_parse_request: Got stream-method http://jabber.org/protocol/bytestreams
>** (telepathy-gabble:22588): DEBUG: bytestream_factory_iq_si_cb: received a SI request
>** (telepathy-gabble:22588): DEBUG: bytestream_factory_iq_si_cb: Receiver doesn't support multi bytestreams. He chose http://jabber.org/protocol/bytestreams
>** (telepathy-gabble:22588): DEBUG: gabble_signal_connect_weak: connecting to 0x262a980:state-changed with context 0x263bba0
>** (telepathy-gabble:22588): DEBUG: gabble_bytestream_factory_create_socks5: add SOCKS5 bytestream <gamma> from <bob@localhost/Bob>
>** (telepathy-gabble:22588): DEBUG: gabble_private_tubes_factory_handle_si_tube_request: contact#2 stream gamma
>** (telepathy-gabble:22588): DEBUG: gabble_tube_dbus_constructor: Registering at '/org/freedesktop/Telepathy/Connection/gabble/jabber/test_40localhost_2fResource/DBusTubeChannel_2_70'
>** (telepathy-gabble:22588): DEBUG: create_new_tube: create tube 70
>** (telepathy-gabble:22588): DEBUG: gabble_tube_dbus_accept: accept the SI request
>
>SEND:
>-----------------------------------
><iq type="result" to="bob@localhost/Bob" id="H_22"> <si xmlns="http://jabber.org/protocol/si"> <feature xmlns="http://jabber.org/protocol/feature-neg"> <x type="submit" xmlns="jabber:x:data"> <field var="stream-method"> <value>http://jabber.org/protocol/bytestreams</value>
></field>
></x>
></feature>
> <tube xmlns="http://telepathy.freedesktop.org/xmpp/tubes"></tube>
></si>
></iq>
>
>-----------------------------------
>** (telepathy-gabble:22588): DEBUG: gabble_bytestream_socks5_accept: stream gamma with bob@localhost/Bob is now accepted
>** (telepathy-gabble:22588): DEBUG: create_dbus_server: listening on unix:path=/tmp/dbus-gabble-M4zzFN0_
>
>RECV [360]:
>-----------------------------------
>'<iq to='test@localhost/Resource' type='set' id='H_23' from='bob@localhost/Bob'><query xmlns='http://jabber.org/protocol/bytestreams' mode='tcp' sid='gamma'><streamhost jid='invalid.invalid' host='invalid.invalid' port='5001'/><streamhost jid='bob@localhost/Bob' host='127.0.0.1' port='5001'/><streamhost jid='Not me' host='127.0.0.1' port='5001'/></query></iq>'
>-----------------------------------
>** (telepathy-gabble:22588): DEBUG: gabble_bytestream_socks5_add_streamhost: streamhost with jid invalid.invalid, host invalid.invalid and port 5001 added
>** (telepathy-gabble:22588): DEBUG: gabble_bytestream_socks5_add_streamhost: streamhost with jid bob@localhost/Bob, host 127.0.0.1 and port 5001 added
>** (telepathy-gabble:22588): DEBUG: gabble_bytestream_socks5_add_streamhost: streamhost with jid Not me, host 127.0.0.1 and port 5001 added
>** (telepathy-gabble:22588): DEBUG: socks5_connect: Trying streamhost invalid.invalid on port 5001
>** (telepathy-gabble:22588): DEBUG: gibber_tcp_transport_connect: getaddrinfo failed: Name or service not known
>** (telepathy-gabble:22588): DEBUG: transport_disconnected_cb: Sock5 transport disconnected
>** (telepathy-gabble:22588): DEBUG: socks5_error: connection to streamhost failed, trying the next one
>** (telepathy-gabble:22588): DEBUG: socks5_connect: Trying streamhost 127.0.0.1 on port 5001
>** (telepathy-gabble:22588): DEBUG: new_connect_attempt: Trying 127.0.0.1 port 5001...
>** (telepathy-gabble:22588): DEBUG: try_to_connect: connect succeeded
>** (telepathy-gabble:22588): DEBUG: transport_connected_cb: transport is connected. Sending auth request
>** (telepathy-gabble:22588): DEBUG: _writeout: Writing out 3 bytes
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_change_status: was 0, now 2, for reason 1
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_base_connection_change_status: emitting status-changed to 2, for reason 1
>** (telepathy-gabble:22588): DEBUG: gabble_roster_close_all: closing channels
>** (telepathy-gabble:22588): DEBUG: roster_channel_closed_cb: 0x26168b0, channel 0x262d000
>** (telepathy-gabble:22588): DEBUG: roster_channel_closed_cb: 0x26168b0, channel 0x2616b50
>** (telepathy-gabble:22588): DEBUG: roster_channel_closed_cb: 0x26168b0, channel 0x2638ce0
>** (telepathy-gabble:22588): DEBUG: gabble_roster_close_all: removing callbacks
>** (telepathy-gabble:22588): DEBUG: gabble_im_factory_close_all: closing channels
>** (telepathy-gabble:22588): DEBUG: gabble_im_factory_close_all: removing callbacks
>** (telepathy-gabble:22588): DEBUG: connection_status_changed_cb: disconnected, closing room lists
>** (telepathy-gabble:22588): DEBUG: gabble_roomlist_manager_close_all: 0x2639b20
>** (telepathy-gabble:22588): DEBUG: gabble_muc_factory_close_all: closing channels
>** (telepathy-gabble:22588): DEBUG: gabble_muc_factory_close_all: removing callbacks
>** (telepathy-gabble:22588): DEBUG: gabble_private_tubes_factory_close_all: closing 1-1 tubes channels
>** (telepathy-gabble:22588): DEBUG: gabble_tubes_channel_close: called on 0x2638d50
>** (telepathy-gabble:22588): DEBUG: gabble_bytestream_socks5_close: Transport buffer is empty, we can close the bytestream
>** (telepathy-gabble:22588): DEBUG: _do_disconnect: Closing the fd transport
>** (telepathy-gabble:22588): DEBUG: remove_bytestream: removing bytestream: <beta> from <bob@localhost/Bob>
>** (telepathy-gabble:22588): DEBUG: instance_destroyed_cb: instance for 0x26230c0 destroyed; cleaning up
>** (telepathy-gabble:22588): DEBUG: gabble_tube_dbus_dispose: unlink of /tmp/dbus-gabble-DStqdn3M failed: No such file or directory
>** (telepathy-gabble:22588): DEBUG: gabble_bytestream_socks5_close: Transport buffer is empty, we can close the bytestream
>** (telepathy-gabble:22588): DEBUG: _do_disconnect: Closing the fd transport
>** (telepathy-gabble:22588): DEBUG: remove_bytestream: removing bytestream: <gamma> from <bob@localhost/Bob>
>** (telepathy-gabble:22588): DEBUG: instance_destroyed_cb: instance for 0x263bba0 destroyed; cleaning up
>** (telepathy-gabble:22588): DEBUG: gabble_tube_dbus_dispose: unlink of /tmp/dbus-gabble-M4zzFN0_ failed: No such file or directory
>** (telepathy-gabble:22588): DEBUG: gabble_media_factory_close_all: closing channels
>** (telepathy-gabble:22588): DEBUG: connection_shut_down: still open; calling lm_connection_close
>
>SEND:
>-----------------------------------
></stream:stream>
>-----------------------------------
>Freeing up IOChannel and file descriptor
>** (telepathy-gabble:22588): DEBUG: connection_disconnected_cb: called with reason 0
>** (telepathy-gabble:22588): DEBUG: connection_disconnected_cb: expected; emitting DISCONNECTED
>(telepathy-gabble:22588): tp-glib-DEBUG: connection_shutdown_finished_cb: dereferenced connection
>** (telepathy-gabble:22588): DEBUG: gabble_connection_dispose: called
>** (telepathy-gabble:22588): DEBUG: gabble_bytestream_factory_dispose: dispose called
>** (telepathy-gabble:22588): DEBUG: gabble_disco_dispose: dispose called
>** (telepathy-gabble:22588): DEBUG: disco_items_cb: Got error on items request: Request for items on localhost cancelled
>** (telepathy-gabble:22588): DEBUG: gabble_disco_finalize: called with 0x261c240
>** (telepathy-gabble:22588): DEBUG: gabble_request_pipeline_dispose: disposing request-pipeline
>** (telepathy-gabble:22588): DEBUG: gabble_vcard_manager_dispose: 0x262d480
>** (telepathy-gabble:22588): DEBUG: gabble_vcard_manager_finalize: 0x262d480
>** (telepathy-gabble:22588): DEBUG: gabble_jingle_factory_dispose: dispose called
>** (telepathy-gabble:22588): DEBUG: gabble_presence_cache_dispose: dispose called
>** (telepathy-gabble:22588): DEBUG: disco_waiter_list_free: list (nil)
>** (telepathy-gabble:22588): DEBUG: gabble_presence_cache_finalize: called with 0x260f340
>** (telepathy-gabble:22588): DEBUG: gabble_roster_dispose: dispose called
>** (telepathy-gabble:22588): DEBUG: gabble_roster_close_all: closing channels
>** (telepathy-gabble:22588): DEBUG: gabble_roster_finalize: called with 0x26168b0
>** (telepathy-gabble:22588): DEBUG: gabble_im_factory_dispose: dispose called
>** (telepathy-gabble:22588): DEBUG: gabble_roomlist_manager_dispose: running
>** (telepathy-gabble:22588): DEBUG: gabble_roomlist_manager_close_all: 0x2639b20
>** (telepathy-gabble:22588): DEBUG: gabble_muc_factory_dispose: dispose called
>** (telepathy-gabble:22588): DEBUG: gabble_muc_factory_close_all: closing channels
>** (telepathy-gabble:22588): DEBUG: gabble_private_tubes_factory_dispose: dispose called
>** (telepathy-gabble:22588): DEBUG: gabble_private_tubes_factory_close_all: closing 1-1 tubes channels
>** (telepathy-gabble:22588): DEBUG: gabble_media_factory_dispose: dispose called
>** (telepathy-gabble:22588): DEBUG: gabble_media_factory_close_all: closing channels
>** (telepathy-gabble:22588): DEBUG: gabble_olpc_gadget_manager_dispose: running
>** (telepathy-gabble:22588): DEBUG: gabble_olpc_gadget_manager_close_all: 0x261bec0
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_proxy_signal_connection_lost_weak_ref: 0x26165f0: lost weak ref to 0x2638700
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_proxy_signal_connection_lost_weak_ref: 0x2616740: lost weak ref to 0x2638760
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_proxy_signal_connection_lost_weak_ref: 0x2616840: lost weak ref to 0x2638800
>** (telepathy-gabble:22588): DEBUG: gabble_connection_finalize: called with 0x2618630
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_contacts_mixin_finalize: 0x2618630
>(telepathy-gabble:22588): tp-glib-DEBUG: tp_presence_mixin_finalize: 0x2618630

Actions: View

Attachments on bug 20635: 23807 | 23808 | 23809 | 32819

Use of freedesktop.org services, including Bugzilla, is subject to our Code of Conduct. How we collect and use information is described in our Privacy Policy.