Attachment 29168 Details for Bug 23678 – Log from the original initiator side

Log from the original initiator side

telepathy-gabble.log (text/plain), 114.61 KB, created by Marc Maurer on 2009-09-03 03:38:43 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Marc Maurer

Created: 2009-09-03 03:38:43 UTC

Size: 114.61 KB

patch

obsolete

>(telepathy-gabble:21866): tp-glib-DEBUG: tp_proxy_borrow_interface_by_id: 0x9b70a80: org.freedesktop.DBus DBusGProxy is 0x9b70b60
>(telepathy-gabble:21866): tp-glib-DEBUG: started version 0.7.26 (telepathy-glib version 0.7.29)
>(telepathy-gabble:21866): tp-glib-DEBUG: tp_cm_param_setter_offset: account = "25aabee27fed34446d30e2a0c16764ee02a3a81e@jabber.sugarlabs.org"
>(telepathy-gabble:21866): tp-glib-DEBUG: tp_cm_param_setter_offset: password = <hidden>
>(telepathy-gabble:21866): tp-glib-DEBUG: parse_parameters: server not given, using default behaviour
>(telepathy-gabble:21866): tp-glib-DEBUG: tp_cm_param_setter_offset: resource = "Telepathy"
>(telepathy-gabble:21866): tp-glib-DEBUG: tp_cm_param_setter_offset: priority = 0 = 0x0
>(telepathy-gabble:21866): tp-glib-DEBUG: tp_cm_param_setter_offset: port = 5223 = 0x1467
>(telepathy-gabble:21866): tp-glib-DEBUG: tp_cm_param_setter_offset: old-ssl = TRUE
>(telepathy-gabble:21866): tp-glib-DEBUG: tp_cm_param_setter_offset: require-encryption = FALSE
>(telepathy-gabble:21866): tp-glib-DEBUG: tp_cm_param_setter_offset: register = FALSE
>(telepathy-gabble:21866): tp-glib-DEBUG: tp_cm_param_setter_offset: low-bandwidth = FALSE
>(telepathy-gabble:21866): tp-glib-DEBUG: parse_parameters: https-proxy-server not given, using default behaviour
>(telepathy-gabble:21866): tp-glib-DEBUG: tp_cm_param_setter_offset: https-proxy-port = 443 = 0x1bb
>(telepathy-gabble:21866): tp-glib-DEBUG: tp_cm_param_setter_offset: fallback-conference-server = "conference.jabber.sugarlabs.org"
>(telepathy-gabble:21866): tp-glib-DEBUG: parse_parameters: stun-server not given, using default behaviour
>(telepathy-gabble:21866): tp-glib-DEBUG: tp_cm_param_setter_offset: stun-port = 3478 = 0xd96
>(telepathy-gabble:21866): tp-glib-DEBUG: tp_cm_param_setter_offset: fallback-stun-server = "stun.collabora.co.uk"
>(telepathy-gabble:21866): tp-glib-DEBUG: tp_cm_param_setter_offset: fallback-stun-port = 3478 = 0xd96
>(telepathy-gabble:21866): tp-glib-DEBUG: tp_cm_param_setter_offset: ignore-ssl-errors = TRUE
>(telepathy-gabble:21866): tp-glib-DEBUG: parse_parameters: alias not given, using default behaviour
>(telepathy-gabble:21866): tp-glib-DEBUG: tp_cm_param_setter_offset: fallback-socks5-proxies = [proxy.jabber.org, proxy.jabberfr.org, proxy.isgeek.info, proxy2.isgeek.info, proxy65.rooyee.biz, proxy.jabbim.cz, proxy.911910.cn, proxy.aszlig.net, proxy.brauchen.info, proxy.core.im, proxy.deshalbfrei.org, proxy.downtempo.de, proxy.draugr.de, proxy.egbers.info, proxy.headcounter.org, proxy.im.flosoft.biz, proxy.jabber-hispano.org, proxy.jabber.bluendo.com, proxy.jabber.dk, proxy.jabber.freenet.de, proxy.fsinf.at, proxy.jabber.kg, proxy.jabber.minus273.org, proxy.jabber.planetteamspeak.com, proxy.jabber.tf-network.de, proxy.jabjab.de, proxy.jabster.pl, proxy.noicq.org, proxy.schokokeks.org, proxy.silper.cz, proxy.ubuntu-jabber.de, proxy.ubuntu-jabber.net, proxy65.unstable.nl, proxy.verdammung.org, proxy.vke.ru, proxy.vodka-pomme.net, proxy.xabber.de, proxy.jabbernet.eu]
>(telepathy-gabble:21866): tp-glib-DEBUG: tp_base_connection_class_init: Initializing (TpBaseConnectionClass *)0x9b76ab8
>** (telepathy-gabble:21866): DEBUG: gabble_connection_class_init: Initializing (GabbleConnectionClass *)0x9b77c78
>(telepathy-gabble:21866): tp-glib-DEBUG: tp_presence_mixin_class_init: called.
>(telepathy-gabble:21866): tp-glib-DEBUG: tp_base_connection_init: Initializing (TpBaseConnection *)0x9b7a028
>** (telepathy-gabble:21866): DEBUG: gabble_connection_init: Initializing (GabbleConnection *)0x9b7a028
>(telepathy-gabble:21866): tp-glib-DEBUG: tp_base_connection_constructor: Post-construction: (TpBaseConnection *)0x9b7a028
>(telepathy-gabble:21866): tp-glib-DEBUG: tp_base_connection_constructor: Handle repo for type #0 at (nil)
>(telepathy-gabble:21866): tp-glib-DEBUG: tp_base_connection_constructor: Handle repo for type #1 at 0x9b6a090
>(telepathy-gabble:21866): tp-glib-DEBUG: tp_base_connection_constructor: Handle repo for type #2 at 0x9b6a120
>(telepathy-gabble:21866): tp-glib-DEBUG: tp_base_connection_constructor: Handle repo for type #3 at 0x9b72680
>(telepathy-gabble:21866): tp-glib-DEBUG: tp_base_connection_constructor: Handle repo for type #4 at 0x9b6a1b0
>** (telepathy-gabble:21866): DEBUG: gabble_roomlist_manager_constructed: 0x9b70400
>(telepathy-gabble:21866): tp-glib-DEBUG: tp_base_connection_constructor: Channel manager #0 at 0x9b71118
>(telepathy-gabble:21866): tp-glib-DEBUG: tp_base_connection_constructor: Channel manager #1 at 0x9b70390
>(telepathy-gabble:21866): tp-glib-DEBUG: tp_base_connection_constructor: Channel manager #2 at 0x9b70400
>(telepathy-gabble:21866): tp-glib-DEBUG: tp_base_connection_constructor: Channel manager #3 at 0x9b73908
>(telepathy-gabble:21866): tp-glib-DEBUG: tp_base_connection_constructor: Channel manager #4 at 0x9b70478
>(telepathy-gabble:21866): tp-glib-DEBUG: tp_base_connection_constructor: Channel manager #5 at 0x9b704f0
>(telepathy-gabble:21866): tp-glib-DEBUG: tp_base_connection_constructor: Channel manager #6 at 0x9b727a0
>(telepathy-gabble:21866): tp-glib-DEBUG: tp_base_connection_constructor: Channel manager #7 at 0x9b727c0
>** (telepathy-gabble:21866): DEBUG: gabble_connection_constructor: Post-construction: (GabbleConnection *)0x9b7a028
>(telepathy-gabble:21866): tp-glib-DEBUG: tp_presence_mixin_init: called.
>** (telepathy-gabble:21866): DEBUG: gabble_signal_connect_weak: connecting to 0x9b80460:item-found with context 0x9b6d160
>** (telepathy-gabble:21866): DEBUG: gabble_signal_connect_weak: connecting to 0x9b7a028:status-changed with context 0x9b6d140
>(telepathy-gabble:21866): tp-glib-DEBUG: tp_base_connection_register: bus name org.freedesktop.Telepathy.Connection.gabble.jabber._325aabee27fed34446d30e2a0c16764ee02a3a81e_40jabber_2esugarlabs_2eorg_2fTelepathy
>(telepathy-gabble:21866): tp-glib-DEBUG: tp_base_connection_register: object path /org/freedesktop/Telepathy/Connection/gabble/jabber/_325aabee27fed34446d30e2a0c16764ee02a3a81e_40jabber_2esugarlabs_2eorg_2fTelepathy
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_set_properties: called
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_set_properties: Not connected: will perform OLPC buddy property update later
>** (telepathy-gabble:21866): DEBUG: _gabble_connection_connect: disabling SRV because "server" or "port" parameter specified, will connect to jabber.sugarlabs.org
>** (telepathy-gabble:21866): DEBUG: do_connect: calling lm_connection_open
>(telepathy-gabble:21866): tp-glib-DEBUG: tp_base_connection_change_status: was 4294967295, now 1, for reason 1
>(telepathy-gabble:21866): tp-glib-DEBUG: tp_base_connection_change_status: emitting status-changed to 1, for reason 1
>** (telepathy-gabble:21866): DEBUG: connection_status_changed_cb: adding callbacks
>** (telepathy-gabble:21866): DEBUG: connection_status_changed_cb: adding callbacks
>** (telepathy-gabble:21866): DEBUG: connection_status_changed_cb: adding callbacks
>** (telepathy-gabble:21866): DEBUG: connection_ssl_cb: called: The certificate can not be trusted.
>** (telepathy-gabble:21866): DEBUG: connection_ssl_cb: called: The server hostname doesn't match the one in the certificate.
>** (telepathy-gabble:21866): DEBUG: do_auth: authenticating with username: 25aabee27fed34446d30e2a0c16764ee02a3a81e, password: <hidden>, resource: Telepathy
>** (telepathy-gabble:21866): DEBUG: connection_auth_cb: Created self handle 1, our JID is 25aabee27fed34446d30e2a0c16764ee02a3a81e@jabber.sugarlabs.org/Telepathy
>** (telepathy-gabble:21866): DEBUG: gabble_presence_set_capabilities: about to add caps 140261 to resource Telepathy with serial 1
>** (telepathy-gabble:21866): DEBUG: gabble_presence_set_capabilities: found resource Telepathy
>** (telepathy-gabble:21866): DEBUG: gabble_presence_set_capabilities: new serial 1, old 0, clearing caps
>** (telepathy-gabble:21866): DEBUG: gabble_presence_set_capabilities: adding caps 140261 to resource Telepathy
>** (telepathy-gabble:21866): DEBUG: gabble_presence_set_capabilities: resource Telepathy caps now 140261
>** (telepathy-gabble:21866): DEBUG: gabble_presence_set_capabilities: total caps now 140261
>** (telepathy-gabble:21866): DEBUG: gabble_disco_request_with_timeout: Creating disco request 0x9b809a0 for jabber.sugarlabs.org
>** (telepathy-gabble:21866): DEBUG: connection_iq_unknown_cb: got unknown iq:
><iq id="493574518594" type="result">
> <session xmlns="urn:ietf:params:xml:ns:xmpp-session"></session>
></iq>
>
>** (telepathy-gabble:21866): DEBUG: connection_disco_cb: got:
><query xmlns="http://jabber.org/protocol/disco#info"> <identity type="pep" category="pubsub"></identity>
> <identity name="ejabberd" type="im" category="server"></identity>
> <feature var="http://jabber.org/protocol/commands"></feature>
> <feature var="http://jabber.org/protocol/disco#info"></feature>
> <feature var="http://jabber.org/protocol/disco#items"></feature>
> <feature var="http://jabber.org/protocol/disco#publish"></feature>
> <feature var="http://jabber.org/protocol/pubsub"></feature>
> <feature var="http://jabber.org/protocol/pubsub#owner"></feature>
> <feature var="http://jabber.org/protocol/stats"></feature>
> <feature var="iq"></feature>
> <feature var="jabber:iq:last"></feature>
> <feature var="jabber:iq:register"></feature>
> <feature var="jabber:iq:time"></feature>
> <feature var="jabber:iq:version"></feature>
> <feature var="presence"></feature>
> <feature var="presence-invisible"></feature>
> <feature var="vcard-temp"></feature>
> <feature var="http://jabber.org/protocol/pubsub#access-open"></feature>
> <feature var="http://jabber.org/protocol/pubsub#access-presence"></feature>
> <feature var="http://jabber.org/protocol/pubsub#auto-create"></feature>
> <feature var="http://jabber.org/protocol/pubsub#auto-subscribe"></feature>
> <feature var="http://jabber.org/protocol/pubsub#collections"></feature>
> <feature var="http://jabber.org/protocol/pubsub#config-node"></feature>
> <feature var="http://jabber.org/protocol/pubsub#create-and-configure"></feature>
> <feature var="http://jabber.org/protocol/pubsub#create-nodes"></feature>
> <feature var="http://jabber.org/protocol/pubsub#delete-nodes"></feature>
> <feature var="http://jabber.org/protocol/pubsub#filtered-notifications"></feature>
> <feature var="http://jabber.org/protocol/pubsub#instant-nodes"></feature>
> <feature var="http://jabber.org/protocol/pubsub#item-ids"></feature>
> <feature var="http://jabber.org/protocol/pubsub#last-published"></feature>
> <feature var="http://jabber.org/protocol/pubsub#manage-subscriptions"></feature>
> <feature var="http://jabber.org/protocol/pubsub#modify-affiliations"></feature>
> <feature var="http://jabber.org/protocol/pubsub#outcast-affiliation"></feature>
> <feature var="http://jabber.org/protocol/pubsub#persistent-items"></feature>
> <feature var="http://jabber.org/protocol/pubsub#presence-notifications"></feature>
> <feature var="http://jabber.org/protocol/pubsub#presence-subscribe"></feature>
> <feature var="http://jabber.org/protocol/pubsub#publish"></feature>
> <feature var="http://jabber.org/protocol/pubsub#publisher-affiliation"></feature>
> <feature var="http://jabber.org/protocol/pubsub#purge-nodes"></feature>
> <feature var="http://jabber.org/protocol/pubsub#retract-items"></feature>
> <feature var="http://jabber.org/protocol/pubsub#retrieve-affiliations"></feature>
> <feature var="http://jabber.org/protocol/pubsub#retrieve-default"></feature>
> <feature var="http://jabber.org/protocol/pubsub#retrieve-items"></feature>
> <feature var="http://jabber.org/protocol/pubsub#retrieve-subscriptions"></feature>
> <feature var="http://jabber.org/protocol/pubsub#subscribe"></feature>
> <feature var="http://jabber.org/protocol/pubsub#subscription-notifications"></feature>
> <feature var="http://jabber.org/protocol/commands"></feature>
></query>
>
>** (telepathy-gabble:21866): DEBUG: connection_disco_cb: set features flags to 20
>(telepathy-gabble:21866): tp-glib-DEBUG: tp_base_connection_change_status: was 1, now 0, for reason 1
>(telepathy-gabble:21866): tp-glib-DEBUG: tp_base_connection_change_status: emitting status-changed to 0, for reason 1
>** (telepathy-gabble:21866): DEBUG: connection_status_changed_cb: requesting roster
>** (telepathy-gabble:21866): DEBUG: gabble_disco_conn_status_changed_cb: connected, initiating service discovery on jabber.sugarlabs.org
>** (telepathy-gabble:21866): DEBUG: gabble_disco_request_with_timeout: Creating disco request 0x9b809c0 for jabber.sugarlabs.org
>** (telepathy-gabble:21866): DEBUG: gabble_vcard_manager_request: Created request 0x9b83600 to retrieve <1>'s vCard
>** (telepathy-gabble:21866): DEBUG: cache_entry_ensure_queued: Cache entry 0x9b71548 is my own, not setting @to
>** (telepathy-gabble:21866): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x9b83620
>** (telepathy-gabble:21866): DEBUG: cache_entry_ensure_queued: adding request to cache entry 0x9b71548 and queueing the <iq>
>(telepathy-gabble:21866): tp-glib-DEBUG: tp_presence_mixin_emit_presence_update: called.
>(telepathy-gabble:21866): tp-glib-DEBUG: construct_presence_hash: called.
>(telepathy-gabble:21866): tp-glib-DEBUG: construct_simple_presence_hash: called.
>** (telepathy-gabble:21866): DEBUG: send_proxy_query: send SOCKS5 query to proxy.jabber.org
>** (telepathy-gabble:21866): DEBUG: send_proxy_query: send SOCKS5 query to proxy.jabberfr.org
>** (telepathy-gabble:21866): DEBUG: send_proxy_query: send SOCKS5 query to proxy.isgeek.info
>** (telepathy-gabble:21866): DEBUG: send_proxy_query: send SOCKS5 query to proxy2.isgeek.info
>** (telepathy-gabble:21866): DEBUG: send_proxy_query: send SOCKS5 query to proxy65.rooyee.biz
>** (telepathy-gabble:21866): DEBUG: send_proxy_query: send SOCKS5 query to proxy.jabbim.cz
>** (telepathy-gabble:21866): DEBUG: send_proxy_query: send SOCKS5 query to proxy.911910.cn
>** (telepathy-gabble:21866): DEBUG: send_proxy_query: send SOCKS5 query to proxy.aszlig.net
>** (telepathy-gabble:21866): DEBUG: send_proxy_query: send SOCKS5 query to proxy.brauchen.info
>** (telepathy-gabble:21866): DEBUG: send_proxy_query: send SOCKS5 query to proxy.core.im
>** (telepathy-gabble:21866): DEBUG: send_proxy_query: send SOCKS5 query to proxy.deshalbfrei.org
>** (telepathy-gabble:21866): DEBUG: send_proxy_query: send SOCKS5 query to proxy.downtempo.de
>** (telepathy-gabble:21866): DEBUG: send_proxy_query: send SOCKS5 query to proxy.draugr.de
>** (telepathy-gabble:21866): DEBUG: send_proxy_query: send SOCKS5 query to proxy.egbers.info
>** (telepathy-gabble:21866): DEBUG: send_proxy_query: send SOCKS5 query to proxy.headcounter.org
>** (telepathy-gabble:21866): DEBUG: send_proxy_query: send SOCKS5 query to proxy.im.flosoft.biz
>** (telepathy-gabble:21866): DEBUG: send_proxy_query: send SOCKS5 query to proxy.jabber-hispano.org
>** (telepathy-gabble:21866): DEBUG: send_proxy_query: send SOCKS5 query to proxy.jabber.bluendo.com
>** (telepathy-gabble:21866): DEBUG: send_proxy_query: send SOCKS5 query to proxy.jabber.dk
>** (telepathy-gabble:21866): DEBUG: send_proxy_query: send SOCKS5 query to proxy.jabber.freenet.de
>** (telepathy-gabble:21866): DEBUG: send_proxy_query: send SOCKS5 query to proxy.fsinf.at
>** (telepathy-gabble:21866): DEBUG: send_proxy_query: send SOCKS5 query to proxy.jabber.kg
>** (telepathy-gabble:21866): DEBUG: send_proxy_query: send SOCKS5 query to proxy.jabber.minus273.org
>** (telepathy-gabble:21866): DEBUG: send_proxy_query: send SOCKS5 query to proxy.jabber.planetteamspeak.com
>** (telepathy-gabble:21866): DEBUG: send_proxy_query: send SOCKS5 query to proxy.jabber.tf-network.de
>** (telepathy-gabble:21866): DEBUG: send_proxy_query: send SOCKS5 query to proxy.jabjab.de
>** (telepathy-gabble:21866): DEBUG: send_proxy_query: send SOCKS5 query to proxy.jabster.pl
>** (telepathy-gabble:21866): DEBUG: send_proxy_query: send SOCKS5 query to proxy.noicq.org
>** (telepathy-gabble:21866): DEBUG: send_proxy_query: send SOCKS5 query to proxy.schokokeks.org
>** (telepathy-gabble:21866): DEBUG: send_proxy_query: send SOCKS5 query to proxy.silper.cz
>** (telepathy-gabble:21866): DEBUG: send_proxy_query: send SOCKS5 query to proxy.ubuntu-jabber.de
>** (telepathy-gabble:21866): DEBUG: send_proxy_query: send SOCKS5 query to proxy.ubuntu-jabber.net
>** (telepathy-gabble:21866): DEBUG: send_proxy_query: send SOCKS5 query to proxy65.unstable.nl
>** (telepathy-gabble:21866): DEBUG: send_proxy_query: send SOCKS5 query to proxy.verdammung.org
>** (telepathy-gabble:21866): DEBUG: send_proxy_query: send SOCKS5 query to proxy.vke.ru
>** (telepathy-gabble:21866): DEBUG: send_proxy_query: send SOCKS5 query to proxy.vodka-pomme.net
>** (telepathy-gabble:21866): DEBUG: send_proxy_query: send SOCKS5 query to proxy.xabber.de
>** (telepathy-gabble:21866): DEBUG: send_proxy_query: send SOCKS5 query to proxy.jabbernet.eu
>** (telepathy-gabble:21866): DEBUG: gabble_presence_set_capabilities: about to add caps 142309 to resource Telepathy with serial 2
>** (telepathy-gabble:21866): DEBUG: gabble_presence_set_capabilities: found resource Telepathy
>** (telepathy-gabble:21866): DEBUG: gabble_presence_set_capabilities: new serial 2, old 1, clearing caps
>** (telepathy-gabble:21866): DEBUG: gabble_presence_set_capabilities: adding caps 142309 to resource Telepathy
>** (telepathy-gabble:21866): DEBUG: gabble_presence_set_capabilities: resource Telepathy caps now 142309
>** (telepathy-gabble:21866): DEBUG: gabble_presence_set_capabilities: total caps now 142309
>** (telepathy-gabble:21866): DEBUG: send_next_request: processing request 0x9b83620
>(telepathy-gabble:21866): tp-glib-DEBUG: tp_base_connection_dbus_request_handles: 1 handles of type 4, for :1.4
>(telepathy-gabble:21866): tp-glib-DEBUG: channel_request_new: New channel request at 0x9d12fa8: ctype=org.freedesktop.Telepathy.Channel.Type.ContactList htype=4 handle=1 suppress=1
>** (telepathy-gabble:21866): DEBUG: _gabble_roster_get_channel: Looking up channel 4:1 "Friends"
>** (telepathy-gabble:21866): DEBUG: _gabble_roster_create_channel: Instantiating channel 4:1 "Friends"
>[1m[37mtp_group_mixin_change_flags: emitting group flags changed
>  added    : [[22mCAN_ADD|CAN_REMOVE|PROPERTIES[1m]
>  removed  : [[22m[1m]
>  flags now: [[22mCAN_ADD|CAN_REMOVE|PROPERTIES[1m]
>[0m** (telepathy-gabble:21866): DEBUG: _gabble_roster_create_channel: created /org/freedesktop/Telepathy/Connection/gabble/jabber/_325aabee27fed34446d30e2a0c16764ee02a3a81e_40jabber_2esugarlabs_2eorg_2fTelepathy/RosterChannel/Group/Friends
>** (telepathy-gabble:21866): DEBUG: _gabble_roster_create_channel: roster not yet received, not emitting signal for Friends list channel
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_set_properties: called
>** (telepathy-gabble:21866): DEBUG: gabble_vcard_manager_edit: called; invalidating cache
>** (telepathy-gabble:21866): DEBUG: cache_entry_attempt_to_free: Not freeing vCard cache entry 0x9b71548: it has a pipeline_item 0x9b83620
>** (telepathy-gabble:21866): DEBUG: gabble_vcard_manager_edit: checking if we have pending requests already
>** (telepathy-gabble:21866): DEBUG: gabble_vcard_manager_edit: NICKNAME => value of length 4 starting uwog
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_set_activities: called
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_set_current_activity: called
>** (telepathy-gabble:21866): DEBUG: gabble_normalize_contact: jid gadget.jabber.sugarlabs.org has invalid username or server
>** (telepathy-gabble:21866): DEBUG: gabble_presence_cache_lm_message_cb: ignoring message from malformed jid:
><message type="notice" to="25aabee27fed34446d30e2a0c16764ee02a3a81e@jabber.sugarlabs.org" from="gadget.jabber.sugarlabs.org"> <amp xmlns="http://jabber.org/protocol/amp"> <rule value="stored" condition="deliver-at" action="error"></rule>
></amp>
> <removed id="1" xmlns="http://laptop.org/xmpp/buddy"> <buddy jid="25aabee27fed34446d30e2a0c16764ee02a3a81e@jabber.sugarlabs.org"></buddy>
></removed>
> <x stamp="20090903T09:36:03" xmlns="jabber:x:delay"></x>
></message>
>
>** (telepathy-gabble:21866): DEBUG: gabble_normalize_room: invalid room JID gadget.jabber.sugarlabs.org: does not contain '@'
>** (telepathy-gabble:21866): DEBUG: gabble_normalize_contact: jid gadget.jabber.sugarlabs.org has invalid username or server
>** (telepathy-gabble:21866): DEBUG: gabble_presence_cache_lm_message_cb: ignoring message from malformed jid:
><message type="notice" to="25aabee27fed34446d30e2a0c16764ee02a3a81e@jabber.sugarlabs.org" from="gadget.jabber.sugarlabs.org"> <amp xmlns="http://jabber.org/protocol/amp"> <rule value="stored" condition="deliver-at" action="error"></rule>
></amp>
> <added id="1" xmlns="http://laptop.org/xmpp/buddy"> <buddy jid="ae6da8eda397b06dc101737322b9f7954eb98837@jabber.sugarlabs.org"> <properties xmlns="http://laptop.org/xmpp/buddy-properties"> <property name="color" type="str">#D1A3FF,#00A0FF</property>
> <property name="ip4-address" type="str">192.168.0.4</property>
> <property name="key" type="bytes">QUFBQUIzTnphQzFrYzNNQUFBQ0JBSVExMUkrQktyMmVOUC9qalF5NFQ0ZkVlNzJ2Y2RNTHpHTFFHS1Z6RHZoMXg4YUdyTTFSSXJOUjExcm5BQlN1K1dyM3pTYWp4Y2tZUFRkK3Q1cGttY2R3K1VHdjZVVmNxc0lYZmZqMTR3MW1pWVRjOENUNFRYMU1DWXJuZXZVaTkyTit4VnVuUmpUVTZXeHg1SytwcjA2WG91VlBZSmxlWUZYYjRUckNpZ3VOQUFBQUZRRGRGVTZudkNVY0pLT0g1eGl5cmNIRGlRMVU5d0FBQUlCQjk3OHFuZFhCQ1A1aU4vZHFML1Uyak40cGpmanVjODNCb0lNSGErSzlFcUp5MzU1cUVNbGw1TTV1cmpyR1RJdmpRckFwZ2FkNVNpSnN1RjBFMkFaTnRhbWxHa3Qwakt0VDFIZ3AvMHZoSDVJYklxd1VtaE1PNVFITHZsVGErRFFNWlNBeXZoRFFUVzByb1VuSjAzMVFISy80T0pRaVlvRnFpajJxWlQrV0VnQUFBSUJURFluY0MxWjkzbzMzdVgzczBiRi90Vk03VVVZY0o3QzZ3blY2MHJHQkt1NSt3TXFjNTJEVmp0TWphYTB4V2RRRjFGMW1kS1VwaGJ6Q29wbDVpQUdYcG9kcm1WS2FYRVpWQ0ZRdmY2VDQ4dk5Qd3I0a28waE5RbkE2ZnhhMC9CcTMzT0ozVllKaWFMUUJOWlZKQWVmbFdVakFYOFBWQnBHU2RwUHNxZTN2QVE9PQ==</property>
></properties>
></buddy>
></added>
> <x stamp="20090903T09:36:03" xmlns="jabber:x:delay"></x>
></message>
>
>** (telepathy-gabble:21866): DEBUG: gabble_normalize_room: invalid room JID gadget.jabber.sugarlabs.org: does not contain '@'
>** (telepathy-gabble:21866): DEBUG: gabble_presence_cache_do_update: 25aabee27fed34446d30e2a0c16764ee02a3a81e@jabber.sugarlabs.org (1) resource Telepathy prio 0 presence 7 message "(null)"
>(telepathy-gabble:21866): tp-glib-DEBUG: tp_presence_mixin_emit_presence_update: called.
>(telepathy-gabble:21866): tp-glib-DEBUG: construct_presence_hash: called.
>(telepathy-gabble:21866): tp-glib-DEBUG: construct_simple_presence_hash: called.
>** (telepathy-gabble:21866): DEBUG: _process_caps_uri: not enough trust for URI http://telepathy.freedesktop.org/caps#eRnpKxqz6IQNnGJzY89+Sxz2UA4=
>** (telepathy-gabble:21866): DEBUG: disco_waiter_new: created waiter 0x9b83740 for handle 1 with serial 1
>** (telepathy-gabble:21866): DEBUG: _process_caps_uri: only 0 trust out of 5 possible thus far, sending disco for URI http://telepathy.freedesktop.org/caps#eRnpKxqz6IQNnGJzY89+Sxz2UA4=
>** (telepathy-gabble:21866): DEBUG: gabble_disco_request_with_timeout: Creating disco request 0x9b83760 for 25aabee27fed34446d30e2a0c16764ee02a3a81e@jabber.sugarlabs.org/Telepathy
>** (telepathy-gabble:21866): DEBUG: _process_caps: Emitting caps update: handle 1, old 0, new 0
>** (telepathy-gabble:21866): DEBUG: _gabble_roster_get_channel: Looking up channel 3:1 "publish"
>** (telepathy-gabble:21866): 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:21866): DEBUG: _gabble_roster_create_channel: created /org/freedesktop/Telepathy/Connection/gabble/jabber/_325aabee27fed34446d30e2a0c16764ee02a3a81e_40jabber_2esugarlabs_2eorg_2fTelepathy/RosterChannel/List/publish
>** (telepathy-gabble:21866): DEBUG: _gabble_roster_create_channel: roster not yet received, not emitting signal for publish list channel
>** (telepathy-gabble:21866): DEBUG: _gabble_roster_get_channel: Looking up channel 3:2 "subscribe"
>** (telepathy-gabble:21866): 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:21866): DEBUG: _gabble_roster_create_channel: created /org/freedesktop/Telepathy/Connection/gabble/jabber/_325aabee27fed34446d30e2a0c16764ee02a3a81e_40jabber_2esugarlabs_2eorg_2fTelepathy/RosterChannel/List/subscribe
>** (telepathy-gabble:21866): DEBUG: _gabble_roster_create_channel: roster not yet received, not emitting signal for subscribe list channel
>** (telepathy-gabble:21866): DEBUG: gabble_normalize_contact: jid gadget.jabber.sugarlabs.org has invalid username or server
>** (telepathy-gabble:21866): DEBUG: gabble_roster_iq_cb: item jid is malformed, skipping:
><item jid="gadget.jabber.sugarlabs.org" subscription="both"></item>
>
>** (telepathy-gabble:21866): DEBUG: gabble_roster_iq_cb: calling change members on publish channel
>(telepathy-gabble:21866): tp-glib-DEBUG: change_members: not emitting signal, nothing changed
>** (telepathy-gabble:21866): DEBUG: gabble_roster_iq_cb: calling change members on subscribe channel
>(telepathy-gabble:21866): tp-glib-DEBUG: change_members: not emitting signal, nothing changed
>** (telepathy-gabble:21866): DEBUG: _gabble_roster_get_channel: Looking up channel 3:3 "known"
>** (telepathy-gabble:21866): 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:21866): DEBUG: _gabble_roster_create_channel: created /org/freedesktop/Telepathy/Connection/gabble/jabber/_325aabee27fed34446d30e2a0c16764ee02a3a81e_40jabber_2esugarlabs_2eorg_2fTelepathy/RosterChannel/List/known
>** (telepathy-gabble:21866): DEBUG: _gabble_roster_create_channel: roster not yet received, not emitting signal for known list channel
>** (telepathy-gabble:21866): DEBUG: gabble_roster_iq_cb: calling change members on known channel
>(telepathy-gabble:21866): tp-glib-DEBUG: change_members: not emitting signal, nothing changed
>** (telepathy-gabble:21866): DEBUG: gabble_roster_iq_cb: calling change members on any group channels
>** (telepathy-gabble:21866): DEBUG: _gabble_roster_emit_one: roster now received, emitting signal signal for publish list channel
>** (telepathy-gabble:21866): DEBUG: _gabble_roster_emit_one: roster now received, emitting signal signal for subscribe list channel
>** (telepathy-gabble:21866): DEBUG: _gabble_roster_emit_one: roster now received, emitting signal signal for known list channel
>** (telepathy-gabble:21866): DEBUG: _gabble_roster_emit_one: roster now received, emitting signal signal for Friends list channel
>(telepathy-gabble:21866): tp-glib-DEBUG: satisfy_request: completing queued request 0x9d12fa8 with success, channel_type=org.freedesktop.Telepathy.Channel.Type.ContactList, handle_type=4, handle=1, suppress_handler=1
>(telepathy-gabble:21866): tp-glib-DEBUG: channel_request_free: Freeing channel request at 0x9d12fa8: ctype=org.freedesktop.Telepathy.Channel.Type.ContactList htype=4 handle=1 suppress=1
>** (telepathy-gabble:21866): DEBUG: disco_items_cb: discovered service item: conference.jabber.sugarlabs.org
>** (telepathy-gabble:21866): DEBUG: disco_items_cb: discovered service item: gadget.jabber.sugarlabs.org
>** (telepathy-gabble:21866): DEBUG: disco_items_cb: discovered service item: irc.jabber.sugarlabs.org
>** (telepathy-gabble:21866): DEBUG: disco_items_cb: discovered service item: pubsub.jabber.sugarlabs.org
>** (telepathy-gabble:21866): DEBUG: disco_items_cb: discovered service item: vjud.jabber.sugarlabs.org
>** (telepathy-gabble:21866): DEBUG: gabble_disco_request_with_timeout: Creating disco request 0x9cb4460 for pubsub.jabber.sugarlabs.org
>** (telepathy-gabble:21866): DEBUG: gabble_disco_request_with_timeout: Creating disco request 0x9cb4480 for irc.jabber.sugarlabs.org
>** (telepathy-gabble:21866): DEBUG: gabble_disco_request_with_timeout: Creating disco request 0x9cb44a0 for vjud.jabber.sugarlabs.org
>** (telepathy-gabble:21866): DEBUG: gabble_disco_request_with_timeout: Creating disco request 0x9cb44c0 for conference.jabber.sugarlabs.org
>** (telepathy-gabble:21866): DEBUG: gabble_disco_request_with_timeout: Creating disco request 0x9cb44e0 for gadget.jabber.sugarlabs.org
>(telepathy-gabble:21866): tp-glib-DEBUG: tp_presence_mixin_request_presence: called.
>** (telepathy-gabble:21866): DEBUG: gabble_presence_cache_do_update: 25aabee27fed34446d30e2a0c16764ee02a3a81e@jabber.sugarlabs.org (1) resource Telepathy prio 0 presence 7 message "(null)"
>** (telepathy-gabble:21866): DEBUG: _process_caps_uri: not enough trust for URI http://telepathy.freedesktop.org/caps#fL4hzIC3FAqjApGlCg6uHgZturQ=
>** (telepathy-gabble:21866): DEBUG: disco_waiter_new: created waiter 0x9cb4500 for handle 1 with serial 2
>** (telepathy-gabble:21866): DEBUG: _process_caps_uri: only 0 trust out of 5 possible thus far, sending disco for URI http://telepathy.freedesktop.org/caps#fL4hzIC3FAqjApGlCg6uHgZturQ=
>** (telepathy-gabble:21866): DEBUG: gabble_disco_request_with_timeout: Creating disco request 0x9cb4520 for 25aabee27fed34446d30e2a0c16764ee02a3a81e@jabber.sugarlabs.org/Telepathy
>** (telepathy-gabble:21866): DEBUG: _process_caps: Emitting caps update: handle 1, old 0, new 0
>** (telepathy-gabble:21866): DEBUG: response_cb: got reply for request 0x9b83620
>** (telepathy-gabble:21866): DEBUG: pipeline_reply_cb: called for entry 0x9b71548
>** (telepathy-gabble:21866): DEBUG: pipeline_reply_cb: will patch vcard
>** (telepathy-gabble:21866): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x9cb4540
>** (telepathy-gabble:21866): DEBUG: observe_vcard: got vCard alias "uwog" for handle 1 from <NICKNAME>
>** (telepathy-gabble:21866): DEBUG: delete_request: Discarding request 0x9b83600
>** (telepathy-gabble:21866): DEBUG: cache_entry_attempt_to_free: Not freeing vCard cache entry 0x9b71548: it has a cached vCard 0x9d0f8e0
>** (telepathy-gabble:21866): DEBUG: delete_item: deleting item 0x9b83620
>** (telepathy-gabble:21866): DEBUG: send_next_request: processing request 0x9cb4540
>** (telepathy-gabble:21866): DEBUG: connection_iq_disco_cb: got disco request for node http://telepathy.freedesktop.org/caps#eRnpKxqz6IQNnGJzY89+Sxz2UA4=, caps are 22be5
>** (telepathy-gabble:21866): DEBUG: connection_iq_disco_cb: caps now 142309
>** (telepathy-gabble:21866): DEBUG: item_info_cb: got item identity, jid=pubsub.jabber.sugarlabs.org, name=Publish-Subscribe, category=pubsub, type=service
>** (telepathy-gabble:21866): DEBUG: item_info_cb: got item identity, jid=irc.jabber.sugarlabs.org, name=IRC Transport, category=conference, type=irc
>** (telepathy-gabble:21866): DEBUG: item_info_cb: got item identity, jid=vjud.jabber.sugarlabs.org, name=vCard User Search, category=directory, type=user
>** (telepathy-gabble:21866): DEBUG: item_info_cb: got item identity, jid=conference.jabber.sugarlabs.org, name=Chatrooms, category=conference, type=text
>** (telepathy-gabble:21866): DEBUG: connection_iq_disco_cb: got disco request for node http://telepathy.freedesktop.org/caps#fL4hzIC3FAqjApGlCg6uHgZturQ=, caps are 22be5
>** (telepathy-gabble:21866): DEBUG: connection_iq_disco_cb: caps now 142309
>** (telepathy-gabble:21866): DEBUG: connection_iq_disco_cb: sending disco response:
><iq type="result" to="25aabee27fed34446d30e2a0c16764ee02a3a81e@jabber.sugarlabs.org/Telepathy" id="363585380151"> <query node="http://telepathy.freedesktop.org/caps#fL4hzIC3FAqjApGlCg6uHgZturQ=" xmlns="http://jabber.org/protocol/disco#info"> <identity type="pc" name="Telepathy Gabble 0.7.26" 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>
> <feature var="http://jabber.org/protocol/si/profile/file-transfer"></feature>
> <feature var="http://laptop.org/xmpp/buddy-properties+notify"></feature>
> <feature var="http://laptop.org/xmpp/activities+notify"></feature>
> <feature var="http://laptop.org/xmpp/current-activity+notify"></feature>
> <feature var="http://laptop.org/xmpp/activity-properties+notify"></feature>
></query>
></iq>
>
>** (telepathy-gabble:21866): DEBUG: gabble_presence_cache_do_update: 25aabee27fed34446d30e2a0c16764ee02a3a81e@jabber.sugarlabs.org (1) resource Telepathy prio 0 presence 7 message "(null)"
>** (telepathy-gabble:21866): DEBUG: _process_caps_uri: not enough trust for URI http://telepathy.freedesktop.org/caps#fL4hzIC3FAqjApGlCg6uHgZturQ=
>** (telepathy-gabble:21866): DEBUG: disco_waiter_new: created waiter 0x9cb4560 for handle 1 with serial 3
>** (telepathy-gabble:21866): DEBUG: _process_caps: Emitting caps update: handle 1, old 0, new 0
>** (telepathy-gabble:21866): DEBUG: connection_iq_unknown_cb: got unknown iq:
><iq id="986178986318" type="error" to="25aabee27fed34446d30e2a0c16764ee02a3a81e@jabber.sugarlabs.org/Telepathy" from="25aabee27fed34446d30e2a0c16764ee02a3a81e@jabber.sugarlabs.org/Telepathy">
> <query node="http://telepathy.freedesktop.org/caps#eRnpKxqz6IQNnGJzY89+Sxz2UA4=" xmlns="http://jabber.org/protocol/disco#info"></query>
> <error code="404" type="cancel">
> <item-not-found xmlns="urn:ietf:params:xml:ns:xmpp-stanzas"></item-not-found>
></error>
></iq>
>
>** (telepathy-gabble:21866): DEBUG: response_cb: got reply for request 0x9cb4540
>** (telepathy-gabble:21866): DEBUG: replace_reply_cb: called: no error
>** (telepathy-gabble:21866): DEBUG: observe_vcard: no change to vCard alias "uwog" for handle 1
>** (telepathy-gabble:21866): DEBUG: gabble_vcard_manager_remove_edit_request: request == 0x9d130c8
>** (telepathy-gabble:21866): DEBUG: delete_item: deleting item 0x9cb4540
>** (telepathy-gabble:21866): DEBUG: connection_iq_unknown_cb: got unknown iq:
><iq id="363585380151" type="result" to="25aabee27fed34446d30e2a0c16764ee02a3a81e@jabber.sugarlabs.org/Telepathy" from="25aabee27fed34446d30e2a0c16764ee02a3a81e@jabber.sugarlabs.org/Telepathy">
> <query xmlns="http://jabber.org/protocol/disco#info" node="http://telepathy.freedesktop.org/caps#fL4hzIC3FAqjApGlCg6uHgZturQ=">
> <identity category="client" name="Telepathy Gabble 0.7.26" type="pc"></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>
> <feature var="http://jabber.org/protocol/si/profile/file-transfer"></feature>
> <feature var="http://laptop.org/xmpp/buddy-properties+notify"></feature>
> <feature var="http://laptop.org/xmpp/activities+notify"></feature>
> <feature var="http://laptop.org/xmpp/current-activity+notify"></feature>
> <feature var="http://laptop.org/xmpp/activity-properties+notify"></feature>
></query>
></iq>
>
>** (telepathy-gabble:21866): DEBUG: gabble_normalize_room: invalid room JID gadget.jabber.sugarlabs.org: does not contain '@'
>** (telepathy-gabble:21866): DEBUG: gabble_normalize_contact: jid gadget.jabber.sugarlabs.org has invalid username or server
>** (telepathy-gabble:21866): DEBUG: gabble_presence_cache_lm_message_cb: ignoring message from malformed jid:
><presence to="25aabee27fed34446d30e2a0c16764ee02a3a81e@jabber.sugarlabs.org/Telepathy" from="gadget.jabber.sugarlabs.org"> <c hash="sha-1" ver="HXvEO2oqALLIDE91YLH3VzSUSOI= " node="http://gadget.laptop.org" xmlns="http://jabber.org/protocol/caps"></c>
></presence>
>
>** (telepathy-gabble:21866): DEBUG: gabble_normalize_contact: jid gadget.jabber.sugarlabs.org has invalid username or server
>** (telepathy-gabble:21866): DEBUG: gabble_roster_presence_cb: ignoring presence from malformed jid:
><presence to="25aabee27fed34446d30e2a0c16764ee02a3a81e@jabber.sugarlabs.org/Telepathy" from="gadget.jabber.sugarlabs.org"> <c hash="sha-1" ver="HXvEO2oqALLIDE91YLH3VzSUSOI= " node="http://gadget.laptop.org" xmlns="http://jabber.org/protocol/caps"></c>
></presence>
>
>** (telepathy-gabble:21866): DEBUG: item_info_cb: got item identity, jid=gadget.jabber.sugarlabs.org, name=OLPC Gadget, category=collaboration, type=gadget
>** (telepathy-gabble:21866): DEBUG: disco_item_found_cb: buddy gadget discovered
>** (telepathy-gabble:21866): DEBUG: disco_item_found_cb: activity gadget discovered
>(telepathy-gabble:21866): tp-glib-DEBUG: channel_request_new: New channel request at 0x9b71650: ctype=org.laptop.Telepathy.Channel.Type.BuddyView htype=0 handle=0 suppress=1
>(telepathy-gabble:21866): tp-glib-DEBUG: satisfy_request: completing queued request 0x9b71650 with success, channel_type=org.laptop.Telepathy.Channel.Type.BuddyView, handle_type=0, handle=0, suppress_handler=1
>(telepathy-gabble:21866): tp-glib-DEBUG: channel_request_free: Freeing channel request at 0x9b71650: ctype=org.laptop.Telepathy.Channel.Type.BuddyView htype=0 handle=0 suppress=1
>(telepathy-gabble:21866): tp-glib-DEBUG: channel_request_new: New channel request at 0x9d13080: ctype=org.laptop.Telepathy.Channel.Type.ActivityView htype=0 handle=0 suppress=1
>(telepathy-gabble:21866): tp-glib-DEBUG: satisfy_request: completing queued request 0x9d13080 with success, channel_type=org.laptop.Telepathy.Channel.Type.ActivityView, handle_type=0, handle=0, suppress_handler=1
>(telepathy-gabble:21866): tp-glib-DEBUG: channel_request_free: Freeing channel request at 0x9d13080: ctype=org.laptop.Telepathy.Channel.Type.ActivityView htype=0 handle=0 suppress=1
>(telepathy-gabble:21866): tp-glib-DEBUG: tp_presence_mixin_emit_presence_update: called.
>(telepathy-gabble:21866): tp-glib-DEBUG: construct_presence_hash: called.
>(telepathy-gabble:21866): tp-glib-DEBUG: construct_simple_presence_hash: called.
>** (telepathy-gabble:21866): DEBUG: gabble_olpc_activity_constructor: new activity 95a09ec3347ad28434909ad14d4d1696282276c7@conference.jabber.sugarlabs.org (1)
>** (telepathy-gabble:21866): DEBUG: add_activities_to_view_from_node: Assigning new ID <95a09ec3347ad28434909ad14d4d1696282276c7> to room #1
>(telepathy-gabble:21866): tp-glib-DEBUG: tp_presence_mixin_emit_presence_update: called.
>(telepathy-gabble:21866): tp-glib-DEBUG: construct_presence_hash: called.
>(telepathy-gabble:21866): tp-glib-DEBUG: construct_simple_presence_hash: called.
>** (telepathy-gabble:21866): DEBUG: copy_activity_to_array: ... activity #1 (ID 95a09ec3347ad28434909ad14d4d1696282276c7)
>** (telepathy-gabble:21866): DEBUG: olpc_activity_properties_get_properties: called
>** (telepathy-gabble:21866): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x9cb4460
>** (telepathy-gabble:21866): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x9b83620
>** (telepathy-gabble:21866): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x9b83600
>** (telepathy-gabble:21866): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x9b809c0
>** (telepathy-gabble:21866): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x9b809a0
>** (telepathy-gabble:21866): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x9cbb660
>** (telepathy-gabble:21866): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x9cbb680
>** (telepathy-gabble:21866): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x9cbb6a0
>** (telepathy-gabble:21866): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x9cbb6c0
>** (telepathy-gabble:21866): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x9cbb6e0
>** (telepathy-gabble:21866): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x9cbb700
>** (telepathy-gabble:21866): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x9cbb720
>** (telepathy-gabble:21866): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x9cbb740
>** (telepathy-gabble:21866): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x9cbb760
>** (telepathy-gabble:21866): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x9cbb780
>** (telepathy-gabble:21866): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x9cbb7a0
>** (telepathy-gabble:21866): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x9cbb7c0
>** (telepathy-gabble:21866): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x9d1c800
>** (telepathy-gabble:21866): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x9d1c820
>** (telepathy-gabble:21866): DEBUG: send_next_request: processing request 0x9cb4460
>** (telepathy-gabble:21866): DEBUG: send_next_request: processing request 0x9b83620
>** (telepathy-gabble:21866): DEBUG: send_next_request: processing request 0x9b83600
>** (telepathy-gabble:21866): DEBUG: send_next_request: processing request 0x9b809c0
>** (telepathy-gabble:21866): DEBUG: send_next_request: processing request 0x9b809a0
>** (telepathy-gabble:21866): DEBUG: response_cb: got reply for request 0x9cb4460
>** (telepathy-gabble:21866): DEBUG: aliases_request_cache_pep: Error getting alias from PEP:
><iq type="error" id="199773199862" to="25aabee27fed34446d30e2a0c16764ee02a3a81e@jabber.sugarlabs.org/Telepathy" from="194e49fe8344cd6c53d28f9d70a225cb20f04a91@jabber.sugarlabs.org"> <error type="auth" code="401"> <not-authorized xmlns="urn:ietf:params:xml:ns:xmpp-stanzas"></not-authorized>
> <presence-subscription-required xmlns="http://jabber.org/protocol/pubsub#errors"></presence-subscription-required>
></error>
> <pubsub xmlns="http://jabber.org/protocol/pubsub">
> <items node="http://jabber.org/protocol/nick"></items>
></pubsub>
></iq>
>
>** (telepathy-gabble:21866): DEBUG: aliases_request_pep_cb: Got cached alias 194e49fe8344cd6c53d28f9d70a225cb20f04a91 with priority 1
>** (telepathy-gabble:21866): DEBUG: gabble_vcard_manager_request: Created request 0x9d1c840 to retrieve <2>'s vCard
>** (telepathy-gabble:21866): DEBUG: cache_entry_ensure_queued: Cache entry 0x9d12f18 is not mine, @to = 194e49fe8344cd6c53d28f9d70a225cb20f04a91@jabber.sugarlabs.org
>** (telepathy-gabble:21866): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x9d1c860
>** (telepathy-gabble:21866): DEBUG: cache_entry_ensure_queued: adding request to cache entry 0x9d12f18 and queueing the <iq>
>** (telepathy-gabble:21866): DEBUG: delete_item: deleting item 0x9cb4460
>** (telepathy-gabble:21866): DEBUG: send_next_request: processing request 0x9cbb660
>** (telepathy-gabble:21866): DEBUG: response_cb: got reply for request 0x9b83620
>** (telepathy-gabble:21866): DEBUG: aliases_request_cache_pep: Error getting alias from PEP:
><iq type="error" id="199774199956" to="25aabee27fed34446d30e2a0c16764ee02a3a81e@jabber.sugarlabs.org/Telepathy" from="515e4a6d097a34d3483d72fd4fb290be06b37c8c@jabber.sugarlabs.org"> <error type="auth" code="401"> <not-authorized xmlns="urn:ietf:params:xml:ns:xmpp-stanzas"></not-authorized>
> <presence-subscription-required xmlns="http://jabber.org/protocol/pubsub#errors"></presence-subscription-required>
></error>
> <pubsub xmlns="http://jabber.org/protocol/pubsub">
> <items node="http://jabber.org/protocol/nick"></items>
></pubsub>
></iq>
>
>** (telepathy-gabble:21866): DEBUG: aliases_request_pep_cb: Got cached alias 515e4a6d097a34d3483d72fd4fb290be06b37c8c with priority 1
>** (telepathy-gabble:21866): DEBUG: gabble_vcard_manager_request: Created request 0x9d1c880 to retrieve <3>'s vCard
>** (telepathy-gabble:21866): DEBUG: cache_entry_ensure_queued: Cache entry 0x9b71530 is not mine, @to = 515e4a6d097a34d3483d72fd4fb290be06b37c8c@jabber.sugarlabs.org
>** (telepathy-gabble:21866): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x9d1c8a0
>** (telepathy-gabble:21866): DEBUG: cache_entry_ensure_queued: adding request to cache entry 0x9b71530 and queueing the <iq>
>** (telepathy-gabble:21866): DEBUG: delete_item: deleting item 0x9b83620
>** (telepathy-gabble:21866): DEBUG: send_next_request: processing request 0x9cbb680
>** (telepathy-gabble:21866): DEBUG: response_cb: got reply for request 0x9b83600
>** (telepathy-gabble:21866): DEBUG: aliases_request_cache_pep: Error getting alias from PEP:
><iq type="error" id="199759200004" to="25aabee27fed34446d30e2a0c16764ee02a3a81e@jabber.sugarlabs.org/Telepathy" from="daca347bc76f17834b2cb216e5abca31a3472471@jabber.sugarlabs.org"> <error type="auth" code="401"> <not-authorized xmlns="urn:ietf:params:xml:ns:xmpp-stanzas"></not-authorized>
> <presence-subscription-required xmlns="http://jabber.org/protocol/pubsub#errors"></presence-subscription-required>
></error>
> <pubsub xmlns="http://jabber.org/protocol/pubsub">
> <items node="http://jabber.org/protocol/nick"></items>
></pubsub>
></iq>
>
>** (telepathy-gabble:21866): DEBUG: aliases_request_pep_cb: Got cached alias daca347bc76f17834b2cb216e5abca31a3472471 with priority 1
>** (telepathy-gabble:21866): DEBUG: gabble_vcard_manager_request: Created request 0x9d1c8c0 to retrieve <4>'s vCard
>** (telepathy-gabble:21866): DEBUG: cache_entry_ensure_queued: Cache entry 0x9d13220 is not mine, @to = daca347bc76f17834b2cb216e5abca31a3472471@jabber.sugarlabs.org
>** (telepathy-gabble:21866): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x9d1c8e0
>** (telepathy-gabble:21866): DEBUG: cache_entry_ensure_queued: adding request to cache entry 0x9d13220 and queueing the <iq>
>** (telepathy-gabble:21866): DEBUG: delete_item: deleting item 0x9b83600
>** (telepathy-gabble:21866): DEBUG: send_next_request: processing request 0x9cbb6a0
>** (telepathy-gabble:21866): DEBUG: response_cb: got reply for request 0x9b809c0
>** (telepathy-gabble:21866): DEBUG: aliases_request_cache_pep: Error getting alias from PEP:
><iq type="error" id="199773200051" to="25aabee27fed34446d30e2a0c16764ee02a3a81e@jabber.sugarlabs.org/Telepathy" from="ae6da8eda397b06dc101737322b9f7954eb98837@jabber.sugarlabs.org"> <error type="auth" code="401"> <not-authorized xmlns="urn:ietf:params:xml:ns:xmpp-stanzas"></not-authorized>
> <presence-subscription-required xmlns="http://jabber.org/protocol/pubsub#errors"></presence-subscription-required>
></error>
> <pubsub xmlns="http://jabber.org/protocol/pubsub">
> <items node="http://jabber.org/protocol/nick"></items>
></pubsub>
></iq>
>
>** (telepathy-gabble:21866): DEBUG: aliases_request_pep_cb: Got cached alias ae6da8eda397b06dc101737322b9f7954eb98837 with priority 1
>** (telepathy-gabble:21866): DEBUG: gabble_vcard_manager_request: Created request 0x9d1c900 to retrieve <5>'s vCard
>** (telepathy-gabble:21866): DEBUG: cache_entry_ensure_queued: Cache entry 0x9d13238 is not mine, @to = ae6da8eda397b06dc101737322b9f7954eb98837@jabber.sugarlabs.org
>** (telepathy-gabble:21866): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x9d1c920
>** (telepathy-gabble:21866): DEBUG: cache_entry_ensure_queued: adding request to cache entry 0x9d13238 and queueing the <iq>
>** (telepathy-gabble:21866): DEBUG: delete_item: deleting item 0x9b809c0
>** (telepathy-gabble:21866): DEBUG: send_next_request: processing request 0x9cbb6c0
>** (telepathy-gabble:21866): DEBUG: response_cb: got reply for request 0x9b809a0
>** (telepathy-gabble:21866): DEBUG: aliases_request_cache_pep: Error getting alias from PEP:
><iq type="error" id="199777200094" to="25aabee27fed34446d30e2a0c16764ee02a3a81e@jabber.sugarlabs.org/Telepathy" from="99d9825f896b3b9a0cac9567e8ea2b60838f6eb5@jabber.sugarlabs.org"> <error type="auth" code="401"> <not-authorized xmlns="urn:ietf:params:xml:ns:xmpp-stanzas"></not-authorized>
> <presence-subscription-required xmlns="http://jabber.org/protocol/pubsub#errors"></presence-subscription-required>
></error>
> <pubsub xmlns="http://jabber.org/protocol/pubsub">
> <items node="http://jabber.org/protocol/nick"></items>
></pubsub>
></iq>
>
>** (telepathy-gabble:21866): DEBUG: aliases_request_pep_cb: Got cached alias 99d9825f896b3b9a0cac9567e8ea2b60838f6eb5 with priority 1
>** (telepathy-gabble:21866): DEBUG: gabble_vcard_manager_request: Created request 0x9d1c940 to retrieve <6>'s vCard
>** (telepathy-gabble:21866): DEBUG: cache_entry_ensure_queued: Cache entry 0x9d12da8 is not mine, @to = 99d9825f896b3b9a0cac9567e8ea2b60838f6eb5@jabber.sugarlabs.org
>** (telepathy-gabble:21866): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x9d1c960
>** (telepathy-gabble:21866): DEBUG: cache_entry_ensure_queued: adding request to cache entry 0x9d12da8 and queueing the <iq>
>** (telepathy-gabble:21866): DEBUG: delete_item: deleting item 0x9b809a0
>** (telepathy-gabble:21866): DEBUG: send_next_request: processing request 0x9cbb6e0
>** (telepathy-gabble:21866): DEBUG: response_cb: got reply for request 0x9cbb660
>** (telepathy-gabble:21866): DEBUG: aliases_request_cache_pep: Error getting alias from PEP:
><iq type="error" id="199759200139" to="25aabee27fed34446d30e2a0c16764ee02a3a81e@jabber.sugarlabs.org/Telepathy" from="f2590cda9e125cba49ef690bce1dfb57176803b7@jabber.sugarlabs.org"> <error type="auth" code="401"> <not-authorized xmlns="urn:ietf:params:xml:ns:xmpp-stanzas"></not-authorized>
> <presence-subscription-required xmlns="http://jabber.org/protocol/pubsub#errors"></presence-subscription-required>
></error>
> <pubsub xmlns="http://jabber.org/protocol/pubsub">
> <items node="http://jabber.org/protocol/nick"></items>
></pubsub>
></iq>
>
>** (telepathy-gabble:21866): DEBUG: aliases_request_pep_cb: Got cached alias f2590cda9e125cba49ef690bce1dfb57176803b7 with priority 1
>** (telepathy-gabble:21866): DEBUG: gabble_vcard_manager_request: Created request 0x9d1c980 to retrieve <7>'s vCard
>** (telepathy-gabble:21866): DEBUG: cache_entry_ensure_queued: Cache entry 0x9d13038 is not mine, @to = f2590cda9e125cba49ef690bce1dfb57176803b7@jabber.sugarlabs.org
>** (telepathy-gabble:21866): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x9d1c9a0
>** (telepathy-gabble:21866): DEBUG: cache_entry_ensure_queued: adding request to cache entry 0x9d13038 and queueing the <iq>
>** (telepathy-gabble:21866): DEBUG: delete_item: deleting item 0x9cbb660
>** (telepathy-gabble:21866): DEBUG: send_next_request: processing request 0x9cbb700
>** (telepathy-gabble:21866): DEBUG: response_cb: got reply for request 0x9cbb680
>** (telepathy-gabble:21866): DEBUG: aliases_request_cache_pep: Error getting alias from PEP:
><iq type="error" id="199779200190" to="25aabee27fed34446d30e2a0c16764ee02a3a81e@jabber.sugarlabs.org/Telepathy" from="997bc415bec0566fd38c87ea7934e0020c638a65@jabber.sugarlabs.org"> <error type="auth" code="401"> <not-authorized xmlns="urn:ietf:params:xml:ns:xmpp-stanzas"></not-authorized>
> <presence-subscription-required xmlns="http://jabber.org/protocol/pubsub#errors"></presence-subscription-required>
></error>
> <pubsub xmlns="http://jabber.org/protocol/pubsub">
> <items node="http://jabber.org/protocol/nick"></items>
></pubsub>
></iq>
>
>** (telepathy-gabble:21866): DEBUG: aliases_request_pep_cb: Got cached alias 997bc415bec0566fd38c87ea7934e0020c638a65 with priority 1
>** (telepathy-gabble:21866): DEBUG: gabble_vcard_manager_request: Created request 0x9d1c9c0 to retrieve <8>'s vCard
>** (telepathy-gabble:21866): DEBUG: cache_entry_ensure_queued: Cache entry 0x9b716c8 is not mine, @to = 997bc415bec0566fd38c87ea7934e0020c638a65@jabber.sugarlabs.org
>** (telepathy-gabble:21866): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x9d0e400
>** (telepathy-gabble:21866): DEBUG: cache_entry_ensure_queued: adding request to cache entry 0x9b716c8 and queueing the <iq>
>** (telepathy-gabble:21866): DEBUG: delete_item: deleting item 0x9cbb680
>** (telepathy-gabble:21866): DEBUG: send_next_request: processing request 0x9cbb720
>** (telepathy-gabble:21866): DEBUG: response_cb: got reply for request 0x9cbb6a0
>** (telepathy-gabble:21866): DEBUG: aliases_request_cache_pep: Error getting alias from PEP:
><iq type="error" id="200273200321" to="25aabee27fed34446d30e2a0c16764ee02a3a81e@jabber.sugarlabs.org/Telepathy" from="602a20ca705b4b94320bdfa7bfbec47dedea2a82@jabber.sugarlabs.org"> <error type="auth" code="401"> <not-authorized xmlns="urn:ietf:params:xml:ns:xmpp-stanzas"></not-authorized>
> <presence-subscription-required xmlns="http://jabber.org/protocol/pubsub#errors"></presence-subscription-required>
></error>
> <pubsub xmlns="http://jabber.org/protocol/pubsub">
> <items node="http://jabber.org/protocol/nick"></items>
></pubsub>
></iq>
>
>** (telepathy-gabble:21866): DEBUG: aliases_request_pep_cb: Got cached alias 602a20ca705b4b94320bdfa7bfbec47dedea2a82 with priority 1
>** (telepathy-gabble:21866): DEBUG: gabble_vcard_manager_request: Created request 0x9d0e420 to retrieve <9>'s vCard
>** (telepathy-gabble:21866): DEBUG: cache_entry_ensure_queued: Cache entry 0x9d12e98 is not mine, @to = 602a20ca705b4b94320bdfa7bfbec47dedea2a82@jabber.sugarlabs.org
>** (telepathy-gabble:21866): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x9d0e440
>** (telepathy-gabble:21866): DEBUG: cache_entry_ensure_queued: adding request to cache entry 0x9d12e98 and queueing the <iq>
>** (telepathy-gabble:21866): DEBUG: delete_item: deleting item 0x9cbb6a0
>** (telepathy-gabble:21866): DEBUG: send_next_request: processing request 0x9cbb740
>** (telepathy-gabble:21866): DEBUG: response_cb: got reply for request 0x9cbb6c0
>** (telepathy-gabble:21866): DEBUG: aliases_request_cache_pep: Error getting alias from PEP:
><iq type="error" id="200277200364" to="25aabee27fed34446d30e2a0c16764ee02a3a81e@jabber.sugarlabs.org/Telepathy" from="c16c4bcd29d044ee83db5bb4bcf63e03870fdb31@jabber.sugarlabs.org"> <error type="auth" code="401"> <not-authorized xmlns="urn:ietf:params:xml:ns:xmpp-stanzas"></not-authorized>
> <presence-subscription-required xmlns="http://jabber.org/protocol/pubsub#errors"></presence-subscription-required>
></error>
> <pubsub xmlns="http://jabber.org/protocol/pubsub">
> <items node="http://jabber.org/protocol/nick"></items>
></pubsub>
></iq>
>
>** (telepathy-gabble:21866): DEBUG: aliases_request_pep_cb: Got cached alias c16c4bcd29d044ee83db5bb4bcf63e03870fdb31 with priority 1
>** (telepathy-gabble:21866): DEBUG: gabble_vcard_manager_request: Created request 0x9d0e460 to retrieve <10>'s vCard
>** (telepathy-gabble:21866): DEBUG: cache_entry_ensure_queued: Cache entry 0x9d12eb0 is not mine, @to = c16c4bcd29d044ee83db5bb4bcf63e03870fdb31@jabber.sugarlabs.org
>** (telepathy-gabble:21866): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x9d0e480
>** (telepathy-gabble:21866): DEBUG: cache_entry_ensure_queued: adding request to cache entry 0x9d12eb0 and queueing the <iq>
>** (telepathy-gabble:21866): DEBUG: delete_item: deleting item 0x9cbb6c0
>** (telepathy-gabble:21866): DEBUG: send_next_request: processing request 0x9cbb760
>** (telepathy-gabble:21866): DEBUG: response_cb: got reply for request 0x9cbb6e0
>** (telepathy-gabble:21866): DEBUG: aliases_request_cache_pep: Error getting alias from PEP:
><iq type="error" id="200291200409" to="25aabee27fed34446d30e2a0c16764ee02a3a81e@jabber.sugarlabs.org/Telepathy" from="b90a48b21766fadeade57c7e070a6c5cff28ba80@jabber.sugarlabs.org"> <error type="auth" code="401"> <not-authorized xmlns="urn:ietf:params:xml:ns:xmpp-stanzas"></not-authorized>
> <presence-subscription-required xmlns="http://jabber.org/protocol/pubsub#errors"></presence-subscription-required>
></error>
> <pubsub xmlns="http://jabber.org/protocol/pubsub">
> <items node="http://jabber.org/protocol/nick"></items>
></pubsub>
></iq>
>
>** (telepathy-gabble:21866): DEBUG: aliases_request_pep_cb: Got cached alias b90a48b21766fadeade57c7e070a6c5cff28ba80 with priority 1
>** (telepathy-gabble:21866): DEBUG: gabble_vcard_manager_request: Created request 0x9d0e4a0 to retrieve <11>'s vCard
>** (telepathy-gabble:21866): DEBUG: cache_entry_ensure_queued: Cache entry 0x9d12d60 is not mine, @to = b90a48b21766fadeade57c7e070a6c5cff28ba80@jabber.sugarlabs.org
>** (telepathy-gabble:21866): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x9d0e4c0
>** (telepathy-gabble:21866): DEBUG: cache_entry_ensure_queued: adding request to cache entry 0x9d12d60 and queueing the <iq>
>** (telepathy-gabble:21866): DEBUG: delete_item: deleting item 0x9cbb6e0
>** (telepathy-gabble:21866): DEBUG: send_next_request: processing request 0x9cbb780
>** (telepathy-gabble:21866): DEBUG: response_cb: got reply for request 0x9cbb700
>** (telepathy-gabble:21866): DEBUG: aliases_request_cache_pep: Error getting alias from PEP:
><iq type="error" id="200279200452" to="25aabee27fed34446d30e2a0c16764ee02a3a81e@jabber.sugarlabs.org/Telepathy" from="d8b6cce2d6335b39e9f0541e5302f3c46d38ee46@jabber.sugarlabs.org"> <error type="auth" code="401"> <not-authorized xmlns="urn:ietf:params:xml:ns:xmpp-stanzas"></not-authorized>
> <presence-subscription-required xmlns="http://jabber.org/protocol/pubsub#errors"></presence-subscription-required>
></error>
> <pubsub xmlns="http://jabber.org/protocol/pubsub">
> <items node="http://jabber.org/protocol/nick"></items>
></pubsub>
></iq>
>
>** (telepathy-gabble:21866): DEBUG: aliases_request_pep_cb: Got cached alias d8b6cce2d6335b39e9f0541e5302f3c46d38ee46 with priority 1
>** (telepathy-gabble:21866): DEBUG: gabble_vcard_manager_request: Created request 0x9d0e4e0 to retrieve <12>'s vCard
>** (telepathy-gabble:21866): DEBUG: cache_entry_ensure_queued: Cache entry 0x9d12f30 is not mine, @to = d8b6cce2d6335b39e9f0541e5302f3c46d38ee46@jabber.sugarlabs.org
>** (telepathy-gabble:21866): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x9d0e500
>** (telepathy-gabble:21866): DEBUG: cache_entry_ensure_queued: adding request to cache entry 0x9d12f30 and queueing the <iq>
>** (telepathy-gabble:21866): DEBUG: delete_item: deleting item 0x9cbb700
>** (telepathy-gabble:21866): DEBUG: send_next_request: processing request 0x9cbb7a0
>** (telepathy-gabble:21866): DEBUG: response_cb: got reply for request 0x9cbb720
>** (telepathy-gabble:21866): DEBUG: aliases_request_cache_pep: Error getting alias from PEP:
><iq type="error" id="200296200510" to="25aabee27fed34446d30e2a0c16764ee02a3a81e@jabber.sugarlabs.org/Telepathy" from="dcf4a68574e2281fc0446c2cc8ace9baa5dcf4bd@jabber.sugarlabs.org"> <error type="auth" code="401"> <not-authorized xmlns="urn:ietf:params:xml:ns:xmpp-stanzas"></not-authorized>
> <presence-subscription-required xmlns="http://jabber.org/protocol/pubsub#errors"></presence-subscription-required>
></error>
> <pubsub xmlns="http://jabber.org/protocol/pubsub">
> <items node="http://jabber.org/protocol/nick"></items>
></pubsub>
></iq>
>
>** (telepathy-gabble:21866): DEBUG: aliases_request_pep_cb: Got cached alias dcf4a68574e2281fc0446c2cc8ace9baa5dcf4bd with priority 1
>** (telepathy-gabble:21866): DEBUG: gabble_vcard_manager_request: Created request 0x9d0e520 to retrieve <13>'s vCard
>** (telepathy-gabble:21866): DEBUG: cache_entry_ensure_queued: Cache entry 0x9d12fc0 is not mine, @to = dcf4a68574e2281fc0446c2cc8ace9baa5dcf4bd@jabber.sugarlabs.org
>** (telepathy-gabble:21866): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x9d0e540
>** (telepathy-gabble:21866): DEBUG: cache_entry_ensure_queued: adding request to cache entry 0x9d12fc0 and queueing the <iq>
>** (telepathy-gabble:21866): DEBUG: delete_item: deleting item 0x9cbb720
>** (telepathy-gabble:21866): DEBUG: send_next_request: processing request 0x9cbb7c0
>** (telepathy-gabble:21866): DEBUG: response_cb: got reply for request 0x9cbb740
>** (telepathy-gabble:21866): DEBUG: aliases_request_cache_pep: Error getting alias from PEP:
><iq type="error" id="200281200556" to="25aabee27fed34446d30e2a0c16764ee02a3a81e@jabber.sugarlabs.org/Telepathy" from="ec72d62d7f844272bffd427913b3128eec781ef3@jabber.sugarlabs.org"> <error type="auth" code="401"> <not-authorized xmlns="urn:ietf:params:xml:ns:xmpp-stanzas"></not-authorized>
> <presence-subscription-required xmlns="http://jabber.org/protocol/pubsub#errors"></presence-subscription-required>
></error>
> <pubsub xmlns="http://jabber.org/protocol/pubsub">
> <items node="http://jabber.org/protocol/nick"></items>
></pubsub>
></iq>
>
>** (telepathy-gabble:21866): DEBUG: aliases_request_pep_cb: Got cached alias ec72d62d7f844272bffd427913b3128eec781ef3 with priority 1
>** (telepathy-gabble:21866): DEBUG: gabble_vcard_manager_request: Created request 0x9d0e560 to retrieve <14>'s vCard
>** (telepathy-gabble:21866): DEBUG: cache_entry_ensure_queued: Cache entry 0x9d12fa8 is not mine, @to = ec72d62d7f844272bffd427913b3128eec781ef3@jabber.sugarlabs.org
>** (telepathy-gabble:21866): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x9d0e580
>** (telepathy-gabble:21866): DEBUG: cache_entry_ensure_queued: adding request to cache entry 0x9d12fa8 and queueing the <iq>
>** (telepathy-gabble:21866): DEBUG: delete_item: deleting item 0x9cbb740
>** (telepathy-gabble:21866): DEBUG: send_next_request: processing request 0x9d1c800
>** (telepathy-gabble:21866): DEBUG: response_cb: got reply for request 0x9cbb760
>** (telepathy-gabble:21866): DEBUG: aliases_request_cache_pep: Error getting alias from PEP:
><iq type="error" id="200298200598" to="25aabee27fed34446d30e2a0c16764ee02a3a81e@jabber.sugarlabs.org/Telepathy" from="fe527670d7ad82d4503b4b231c4350e8f793b57f@jabber.sugarlabs.org"> <error type="auth" code="401"> <not-authorized xmlns="urn:ietf:params:xml:ns:xmpp-stanzas"></not-authorized>
> <presence-subscription-required xmlns="http://jabber.org/protocol/pubsub#errors"></presence-subscription-required>
></error>
> <pubsub xmlns="http://jabber.org/protocol/pubsub">
> <items node="http://jabber.org/protocol/nick"></items>
></pubsub>
></iq>
>
>** (telepathy-gabble:21866): DEBUG: aliases_request_pep_cb: Got cached alias fe527670d7ad82d4503b4b231c4350e8f793b57f with priority 1
>** (telepathy-gabble:21866): DEBUG: gabble_vcard_manager_request: Created request 0x9d0e5a0 to retrieve <15>'s vCard
>** (telepathy-gabble:21866): DEBUG: cache_entry_ensure_queued: Cache entry 0x9d12f48 is not mine, @to = fe527670d7ad82d4503b4b231c4350e8f793b57f@jabber.sugarlabs.org
>** (telepathy-gabble:21866): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x9d0e5c0
>** (telepathy-gabble:21866): DEBUG: cache_entry_ensure_queued: adding request to cache entry 0x9d12f48 and queueing the <iq>
>** (telepathy-gabble:21866): DEBUG: delete_item: deleting item 0x9cbb760
>** (telepathy-gabble:21866): DEBUG: send_next_request: processing request 0x9d1c820
>** (telepathy-gabble:21866): DEBUG: response_cb: got reply for request 0x9cbb780
>** (telepathy-gabble:21866): DEBUG: aliases_request_cache_pep: Error getting alias from PEP:
><iq type="error" id="200296200657" to="25aabee27fed34446d30e2a0c16764ee02a3a81e@jabber.sugarlabs.org/Telepathy" from="6608159f3d2c008dc3b541bb63e45964ac9dccff@jabber.sugarlabs.org"> <error type="auth" code="401"> <not-authorized xmlns="urn:ietf:params:xml:ns:xmpp-stanzas"></not-authorized>
> <presence-subscription-required xmlns="http://jabber.org/protocol/pubsub#errors"></presence-subscription-required>
></error>
> <pubsub xmlns="http://jabber.org/protocol/pubsub">
> <items node="http://jabber.org/protocol/nick"></items>
></pubsub>
></iq>
>
>** (telepathy-gabble:21866): DEBUG: aliases_request_pep_cb: Got cached alias 6608159f3d2c008dc3b541bb63e45964ac9dccff with priority 1
>** (telepathy-gabble:21866): DEBUG: gabble_vcard_manager_request: Created request 0x9cbb800 to retrieve <16>'s vCard
>** (telepathy-gabble:21866): DEBUG: cache_entry_ensure_queued: Cache entry 0x9d13268 is not mine, @to = 6608159f3d2c008dc3b541bb63e45964ac9dccff@jabber.sugarlabs.org
>** (telepathy-gabble:21866): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x9cbb820
>** (telepathy-gabble:21866): DEBUG: cache_entry_ensure_queued: adding request to cache entry 0x9d13268 and queueing the <iq>
>** (telepathy-gabble:21866): DEBUG: delete_item: deleting item 0x9cbb780
>** (telepathy-gabble:21866): DEBUG: send_next_request: processing request 0x9d1c860
>** (telepathy-gabble:21866): DEBUG: response_cb: got reply for request 0x9cbb7a0
>** (telepathy-gabble:21866): DEBUG: aliases_request_cache_pep: Error getting alias from PEP:
><iq type="error" id="200301200701" to="25aabee27fed34446d30e2a0c16764ee02a3a81e@jabber.sugarlabs.org/Telepathy" from="e0d2c7e034c25383d885625d7c9697ccfdbe313a@jabber.sugarlabs.org"> <error type="auth" code="401"> <not-authorized xmlns="urn:ietf:params:xml:ns:xmpp-stanzas"></not-authorized>
> <presence-subscription-required xmlns="http://jabber.org/protocol/pubsub#errors"></presence-subscription-required>
></error>
> <pubsub xmlns="http://jabber.org/protocol/pubsub">
> <items node="http://jabber.org/protocol/nick"></items>
></pubsub>
></iq>
>
>** (telepathy-gabble:21866): DEBUG: aliases_request_pep_cb: Got cached alias e0d2c7e034c25383d885625d7c9697ccfdbe313a with priority 1
>** (telepathy-gabble:21866): DEBUG: gabble_vcard_manager_request: Created request 0x9cbb840 to retrieve <17>'s vCard
>** (telepathy-gabble:21866): DEBUG: cache_entry_ensure_queued: Cache entry 0x9d13298 is not mine, @to = e0d2c7e034c25383d885625d7c9697ccfdbe313a@jabber.sugarlabs.org
>** (telepathy-gabble:21866): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x9cbb860
>** (telepathy-gabble:21866): DEBUG: cache_entry_ensure_queued: adding request to cache entry 0x9d13298 and queueing the <iq>
>** (telepathy-gabble:21866): DEBUG: delete_item: deleting item 0x9cbb7a0
>** (telepathy-gabble:21866): DEBUG: send_next_request: processing request 0x9d1c8a0
>** (telepathy-gabble:21866): DEBUG: response_cb: got reply for request 0x9cbb7c0
>** (telepathy-gabble:21866): DEBUG: aliases_request_cache_pep: Error getting alias from PEP:
><iq type="error" id="196698200745" to="25aabee27fed34446d30e2a0c16764ee02a3a81e@jabber.sugarlabs.org/Telepathy" from="ca4568a8217760a14b12b848a90af493fb05ac5a@jabber.sugarlabs.org"> <error type="auth" code="401"> <not-authorized xmlns="urn:ietf:params:xml:ns:xmpp-stanzas"></not-authorized>
> <presence-subscription-required xmlns="http://jabber.org/protocol/pubsub#errors"></presence-subscription-required>
></error>
> <pubsub xmlns="http://jabber.org/protocol/pubsub">
> <items node="http://jabber.org/protocol/nick"></items>
></pubsub>
></iq>
>
>** (telepathy-gabble:21866): DEBUG: aliases_request_pep_cb: Got cached alias ca4568a8217760a14b12b848a90af493fb05ac5a with priority 1
>** (telepathy-gabble:21866): DEBUG: gabble_vcard_manager_request: Created request 0x9cbb880 to retrieve <18>'s vCard
>** (telepathy-gabble:21866): DEBUG: cache_entry_ensure_queued: Cache entry 0x9d132c8 is not mine, @to = ca4568a8217760a14b12b848a90af493fb05ac5a@jabber.sugarlabs.org
>** (telepathy-gabble:21866): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x9cbb8a0
>** (telepathy-gabble:21866): DEBUG: cache_entry_ensure_queued: adding request to cache entry 0x9d132c8 and queueing the <iq>
>** (telepathy-gabble:21866): DEBUG: delete_item: deleting item 0x9cbb7c0
>** (telepathy-gabble:21866): DEBUG: send_next_request: processing request 0x9d1c8e0
>** (telepathy-gabble:21866): DEBUG: response_cb: got reply for request 0x9d1c800
>** (telepathy-gabble:21866): DEBUG: aliases_request_cache_pep: Error getting alias from PEP:
><iq type="error" id="196715200787" to="25aabee27fed34446d30e2a0c16764ee02a3a81e@jabber.sugarlabs.org/Telepathy" from="b2ae1310b921ca77355499c0fda7085d7cac7ab5@jabber.sugarlabs.org"> <error type="auth" code="401"> <not-authorized xmlns="urn:ietf:params:xml:ns:xmpp-stanzas"></not-authorized>
> <presence-subscription-required xmlns="http://jabber.org/protocol/pubsub#errors"></presence-subscription-required>
></error>
> <pubsub xmlns="http://jabber.org/protocol/pubsub">
> <items node="http://jabber.org/protocol/nick"></items>
></pubsub>
></iq>
>
>** (telepathy-gabble:21866): DEBUG: aliases_request_pep_cb: Got cached alias b2ae1310b921ca77355499c0fda7085d7cac7ab5 with priority 1
>** (telepathy-gabble:21866): DEBUG: gabble_vcard_manager_request: Created request 0x9cbb8c0 to retrieve <19>'s vCard
>** (telepathy-gabble:21866): DEBUG: cache_entry_ensure_queued: Cache entry 0x9d13f18 is not mine, @to = b2ae1310b921ca77355499c0fda7085d7cac7ab5@jabber.sugarlabs.org
>** (telepathy-gabble:21866): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x9cbb8e0
>** (telepathy-gabble:21866): DEBUG: cache_entry_ensure_queued: adding request to cache entry 0x9d13f18 and queueing the <iq>
>** (telepathy-gabble:21866): DEBUG: delete_item: deleting item 0x9d1c800
>** (telepathy-gabble:21866): DEBUG: send_next_request: processing request 0x9d1c920
>** (telepathy-gabble:21866): DEBUG: response_cb: got reply for request 0x9d1c820
>** (telepathy-gabble:21866): DEBUG: aliases_request_cache_pep: Error getting alias from PEP:
><iq type="error" id="196720200831" to="25aabee27fed34446d30e2a0c16764ee02a3a81e@jabber.sugarlabs.org/Telepathy" from="422be991b7dbcc39c58ad24fb46c309ee08267cb@jabber.sugarlabs.org"> <error type="auth" code="401"> <not-authorized xmlns="urn:ietf:params:xml:ns:xmpp-stanzas"></not-authorized>
> <presence-subscription-required xmlns="http://jabber.org/protocol/pubsub#errors"></presence-subscription-required>
></error>
> <pubsub xmlns="http://jabber.org/protocol/pubsub">
> <items node="http://jabber.org/protocol/nick"></items>
></pubsub>
></iq>
>
>** (telepathy-gabble:21866): DEBUG: aliases_request_pep_cb: Got cached alias 422be991b7dbcc39c58ad24fb46c309ee08267cb with priority 1
>** (telepathy-gabble:21866): DEBUG: gabble_vcard_manager_request: Created request 0x9cbb900 to retrieve <20>'s vCard
>** (telepathy-gabble:21866): DEBUG: cache_entry_ensure_queued: Cache entry 0x9d13f48 is not mine, @to = 422be991b7dbcc39c58ad24fb46c309ee08267cb@jabber.sugarlabs.org
>** (telepathy-gabble:21866): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x9d1c800
>** (telepathy-gabble:21866): DEBUG: cache_entry_ensure_queued: adding request to cache entry 0x9d13f48 and queueing the <iq>
>** (telepathy-gabble:21866): DEBUG: delete_item: deleting item 0x9d1c820
>** (telepathy-gabble:21866): DEBUG: send_next_request: processing request 0x9d1c960
>** (telepathy-gabble:21866): DEBUG: response_cb: got reply for request 0x9d1c860
>** (telepathy-gabble:21866): DEBUG: pipeline_reply_cb: called for entry 0x9d12f18
>** (telepathy-gabble:21866): DEBUG: observe_vcard: got vCard alias "erich" for handle 2 from <NICKNAME>
>** (telepathy-gabble:21866): DEBUG: delete_request: Discarding request 0x9d1c840
>** (telepathy-gabble:21866): DEBUG: cache_entry_attempt_to_free: Not freeing vCard cache entry 0x9d12f18: it has a cached vCard 0x9cbcd10
>** (telepathy-gabble:21866): DEBUG: delete_item: deleting item 0x9d1c860
>** (telepathy-gabble:21866): DEBUG: send_next_request: processing request 0x9d1c9a0
>** (telepathy-gabble:21866): DEBUG: response_cb: got reply for request 0x9d1c8a0
>** (telepathy-gabble:21866): DEBUG: pipeline_reply_cb: called for entry 0x9b71530
>** (telepathy-gabble:21866): DEBUG: observe_vcard: got vCard alias "benzea" for handle 3 from <NICKNAME>
>** (telepathy-gabble:21866): DEBUG: delete_request: Discarding request 0x9d1c880
>** (telepathy-gabble:21866): DEBUG: cache_entry_attempt_to_free: Not freeing vCard cache entry 0x9b71530: it has a cached vCard 0x9cb0e68
>** (telepathy-gabble:21866): DEBUG: delete_item: deleting item 0x9d1c8a0
>** (telepathy-gabble:21866): DEBUG: send_next_request: processing request 0x9d0e400
>** (telepathy-gabble:21866): DEBUG: response_cb: got reply for request 0x9d1c8e0
>** (telepathy-gabble:21866): DEBUG: pipeline_reply_cb: called for entry 0x9d13220
>** (telepathy-gabble:21866): DEBUG: observe_vcard: got vCard alias "satellit_SD" for handle 4 from <NICKNAME>
>** (telepathy-gabble:21866): DEBUG: delete_request: Discarding request 0x9d1c8c0
>** (telepathy-gabble:21866): DEBUG: cache_entry_attempt_to_free: Not freeing vCard cache entry 0x9d13220: it has a cached vCard 0x9d25620
>** (telepathy-gabble:21866): DEBUG: delete_item: deleting item 0x9d1c8e0
>** (telepathy-gabble:21866): DEBUG: send_next_request: processing request 0x9d0e440
>** (telepathy-gabble:21866): DEBUG: response_cb: got reply for request 0x9d1c920
>** (telepathy-gabble:21866): DEBUG: pipeline_reply_cb: called for entry 0x9d13238
>** (telepathy-gabble:21866): DEBUG: observe_vcard: got vCard alias "donghee" for handle 5 from <NICKNAME>
>** (telepathy-gabble:21866): DEBUG: delete_request: Discarding request 0x9d1c900
>** (telepathy-gabble:21866): DEBUG: cache_entry_attempt_to_free: Not freeing vCard cache entry 0x9d13238: it has a cached vCard 0x9d143a8
>** (telepathy-gabble:21866): DEBUG: delete_item: deleting item 0x9d1c920
>** (telepathy-gabble:21866): DEBUG: send_next_request: processing request 0x9d0e480
>** (telepathy-gabble:21866): DEBUG: response_cb: got reply for request 0x9d1c960
>** (telepathy-gabble:21866): DEBUG: pipeline_reply_cb: called for entry 0x9d12da8
>** (telepathy-gabble:21866): DEBUG: observe_vcard: got vCard alias "Epson" for handle 6 from <NICKNAME>
>** (telepathy-gabble:21866): DEBUG: delete_request: Discarding request 0x9d1c940
>** (telepathy-gabble:21866): DEBUG: cache_entry_attempt_to_free: Not freeing vCard cache entry 0x9d12da8: it has a cached vCard 0x9d274a0
>** (telepathy-gabble:21866): DEBUG: delete_item: deleting item 0x9d1c960
>** (telepathy-gabble:21866): DEBUG: send_next_request: processing request 0x9d0e4c0
>** (telepathy-gabble:21866): DEBUG: response_cb: got reply for request 0x9d1c9a0
>** (telepathy-gabble:21866): DEBUG: pipeline_reply_cb: called for entry 0x9d13038
>** (telepathy-gabble:21866): DEBUG: observe_vcard: got vCard alias "kushal" for handle 7 from <NICKNAME>
>** (telepathy-gabble:21866): DEBUG: delete_request: Discarding request 0x9d1c980
>** (telepathy-gabble:21866): DEBUG: cache_entry_attempt_to_free: Not freeing vCard cache entry 0x9d13038: it has a cached vCard 0x9b79518
>** (telepathy-gabble:21866): DEBUG: delete_item: deleting item 0x9d1c9a0
>** (telepathy-gabble:21866): DEBUG: send_next_request: processing request 0x9d0e500
>** (telepathy-gabble:21866): DEBUG: response_cb: got reply for request 0x9d0e400
>** (telepathy-gabble:21866): DEBUG: pipeline_reply_cb: called for entry 0x9b716c8
>** (telepathy-gabble:21866): DEBUG: observe_vcard: got vCard alias "Caroline VM on iMac" for handle 8 from <NICKNAME>
>** (telepathy-gabble:21866): DEBUG: delete_request: Discarding request 0x9d1c9c0
>** (telepathy-gabble:21866): DEBUG: cache_entry_attempt_to_free: Not freeing vCard cache entry 0x9b716c8: it has a cached vCard 0x9cbc2b0
>** (telepathy-gabble:21866): DEBUG: delete_item: deleting item 0x9d0e400
>** (telepathy-gabble:21866): DEBUG: send_next_request: processing request 0x9d0e540
>** (telepathy-gabble:21866): DEBUG: response_cb: got reply for request 0x9d0e440
>** (telepathy-gabble:21866): DEBUG: pipeline_reply_cb: called for entry 0x9d12e98
>** (telepathy-gabble:21866): DEBUG: observe_vcard: got vCard alias "carl" for handle 9 from <NICKNAME>
>** (telepathy-gabble:21866): DEBUG: delete_request: Discarding request 0x9d0e420
>** (telepathy-gabble:21866): DEBUG: cache_entry_attempt_to_free: Not freeing vCard cache entry 0x9d12e98: it has a cached vCard 0x9d135a0
>** (telepathy-gabble:21866): DEBUG: delete_item: deleting item 0x9d0e440
>** (telepathy-gabble:21866): DEBUG: send_next_request: processing request 0x9d0e580
>** (telepathy-gabble:21866): DEBUG: response_cb: got reply for request 0x9d0e480
>** (telepathy-gabble:21866): DEBUG: pipeline_reply_cb: called for entry 0x9d12eb0
>** (telepathy-gabble:21866): DEBUG: observe_vcard: got vCard alias "soas=2=beta-4gb-sh2" for handle 10 from <NICKNAME>
>** (telepathy-gabble:21866): DEBUG: delete_request: Discarding request 0x9d0e460
>** (telepathy-gabble:21866): DEBUG: cache_entry_attempt_to_free: Not freeing vCard cache entry 0x9d12eb0: it has a cached vCard 0x9d20640
>** (telepathy-gabble:21866): DEBUG: delete_item: deleting item 0x9d0e480
>** (telepathy-gabble:21866): DEBUG: send_next_request: processing request 0x9d0e5c0
>** (telepathy-gabble:21866): DEBUG: response_cb: got reply for request 0x9d0e4c0
>** (telepathy-gabble:21866): DEBUG: pipeline_reply_cb: called for entry 0x9d12d60
>** (telepathy-gabble:21866): DEBUG: observe_vcard: got vCard alias "schampijer" for handle 11 from <NICKNAME>
>** (telepathy-gabble:21866): DEBUG: delete_request: Discarding request 0x9d0e4a0
>** (telepathy-gabble:21866): DEBUG: cache_entry_attempt_to_free: Not freeing vCard cache entry 0x9d12d60: it has a cached vCard 0x9d25708
>** (telepathy-gabble:21866): DEBUG: delete_item: deleting item 0x9d0e4c0
>** (telepathy-gabble:21866): DEBUG: send_next_request: processing request 0x9cbb820
>** (telepathy-gabble:21866): DEBUG: response_cb: got reply for request 0x9d0e500
>** (telepathy-gabble:21866): DEBUG: pipeline_reply_cb: called for entry 0x9d12f30
>** (telepathy-gabble:21866): DEBUG: observe_vcard: got vCard alias "tomeu?" for handle 12 from <NICKNAME>
>** (telepathy-gabble:21866): DEBUG: delete_request: Discarding request 0x9d0e4e0
>** (telepathy-gabble:21866): DEBUG: cache_entry_attempt_to_free: Not freeing vCard cache entry 0x9d12f30: it has a cached vCard 0x9d1bf20
>** (telepathy-gabble:21866): DEBUG: delete_item: deleting item 0x9d0e500
>** (telepathy-gabble:21866): DEBUG: send_next_request: processing request 0x9cbb860
>** (telepathy-gabble:21866): DEBUG: response_cb: got reply for request 0x9d0e540
>** (telepathy-gabble:21866): DEBUG: pipeline_reply_cb: called for entry 0x9d12fc0
>** (telepathy-gabble:21866): DEBUG: observe_vcard: got vCard alias "kushal" for handle 13 from <NICKNAME>
>** (telepathy-gabble:21866): DEBUG: delete_request: Discarding request 0x9d0e520
>** (telepathy-gabble:21866): DEBUG: cache_entry_attempt_to_free: Not freeing vCard cache entry 0x9d12fc0: it has a cached vCard 0x9d0f7d8
>** (telepathy-gabble:21866): DEBUG: delete_item: deleting item 0x9d0e540
>** (telepathy-gabble:21866): DEBUG: send_next_request: processing request 0x9cbb8a0
>** (telepathy-gabble:21866): DEBUG: response_cb: got reply for request 0x9d0e580
>** (telepathy-gabble:21866): DEBUG: pipeline_reply_cb: called for entry 0x9d12fa8
>** (telepathy-gabble:21866): DEBUG: observe_vcard: got vCard alias "anders" for handle 14 from <NICKNAME>
>** (telepathy-gabble:21866): DEBUG: delete_request: Discarding request 0x9d0e560
>** (telepathy-gabble:21866): DEBUG: cache_entry_attempt_to_free: Not freeing vCard cache entry 0x9d12fa8: it has a cached vCard 0x9d12410
>** (telepathy-gabble:21866): DEBUG: delete_item: deleting item 0x9d0e580
>** (telepathy-gabble:21866): DEBUG: send_next_request: processing request 0x9cbb8e0
>** (telepathy-gabble:21866): DEBUG: response_cb: got reply for request 0x9d0e5c0
>** (telepathy-gabble:21866): DEBUG: pipeline_reply_cb: called for entry 0x9d12f48
>** (telepathy-gabble:21866): DEBUG: observe_vcard: got vCard alias "Rachael" for handle 15 from <NICKNAME>
>** (telepathy-gabble:21866): DEBUG: delete_request: Discarding request 0x9d0e5a0
>** (telepathy-gabble:21866): DEBUG: cache_entry_attempt_to_free: Not freeing vCard cache entry 0x9d12f48: it has a cached vCard 0x9d1a098
>** (telepathy-gabble:21866): DEBUG: delete_item: deleting item 0x9d0e5c0
>** (telepathy-gabble:21866): DEBUG: send_next_request: processing request 0x9d1c800
>** (telepathy-gabble:21866): DEBUG: response_cb: got reply for request 0x9cbb820
>** (telepathy-gabble:21866): DEBUG: pipeline_reply_cb: called for entry 0x9d13268
>** (telepathy-gabble:21866): DEBUG: observe_vcard: got vCard alias "rab" for handle 16 from <NICKNAME>
>** (telepathy-gabble:21866): DEBUG: delete_request: Discarding request 0x9cbb800
>** (telepathy-gabble:21866): DEBUG: cache_entry_attempt_to_free: Not freeing vCard cache entry 0x9d13268: it has a cached vCard 0x9d1c398
>** (telepathy-gabble:21866): DEBUG: delete_item: deleting item 0x9cbb820
>** (telepathy-gabble:21866): DEBUG: response_cb: got reply for request 0x9cbb860
>** (telepathy-gabble:21866): DEBUG: pipeline_reply_cb: called for entry 0x9d13298
>** (telepathy-gabble:21866): DEBUG: observe_vcard: got vCard alias "name" for handle 17 from <NICKNAME>
>** (telepathy-gabble:21866): DEBUG: delete_request: Discarding request 0x9cbb840
>** (telepathy-gabble:21866): DEBUG: cache_entry_attempt_to_free: Not freeing vCard cache entry 0x9d13298: it has a cached vCard 0x9d1a010
>** (telepathy-gabble:21866): DEBUG: delete_item: deleting item 0x9cbb860
>** (telepathy-gabble:21866): DEBUG: response_cb: got reply for request 0x9cbb8a0
>** (telepathy-gabble:21866): DEBUG: pipeline_reply_cb: called for entry 0x9d132c8
>** (telepathy-gabble:21866): DEBUG: observe_vcard: got vCard alias "j" for handle 18 from <NICKNAME>
>** (telepathy-gabble:21866): DEBUG: delete_request: Discarding request 0x9cbb880
>** (telepathy-gabble:21866): DEBUG: cache_entry_attempt_to_free: Not freeing vCard cache entry 0x9d132c8: it has a cached vCard 0x9d0e7a0
>** (telepathy-gabble:21866): DEBUG: delete_item: deleting item 0x9cbb8a0
>** (telepathy-gabble:21866): DEBUG: response_cb: got reply for request 0x9cbb8e0
>** (telepathy-gabble:21866): DEBUG: pipeline_reply_cb: called for entry 0x9d13f18
>** (telepathy-gabble:21866): DEBUG: observe_vcard: got vCard alias "walter" for handle 19 from <NICKNAME>
>** (telepathy-gabble:21866): DEBUG: delete_request: Discarding request 0x9cbb8c0
>** (telepathy-gabble:21866): DEBUG: cache_entry_attempt_to_free: Not freeing vCard cache entry 0x9d13f18: it has a cached vCard 0x9d0f660
>** (telepathy-gabble:21866): DEBUG: delete_item: deleting item 0x9cbb8e0
>** (telepathy-gabble:21866): DEBUG: response_cb: got reply for request 0x9d1c800
>** (telepathy-gabble:21866): DEBUG: pipeline_reply_cb: called for entry 0x9d13f48
>** (telepathy-gabble:21866): DEBUG: observe_vcard: got vCard alias "simpoir" for handle 20 from <NICKNAME>
>** (telepathy-gabble:21866): DEBUG: delete_request: Discarding request 0x9cbb900
>** (telepathy-gabble:21866): DEBUG: cache_entry_attempt_to_free: Not freeing vCard cache entry 0x9d13f48: it has a cached vCard 0x9b795f8
>** (telepathy-gabble:21866): DEBUG: delete_item: deleting item 0x9d1c800
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_properties: called
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_current_activity: called for contact#2
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_current_activity: current activity not in cache, query PEP node
>** (telepathy-gabble:21866): DEBUG: get_current_activity_reply_cb: Failed to query PEP node. No current activity
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_activities: called
>** (telepathy-gabble:21866): DEBUG: get_activities_reply_cb: Failed to query PEP node. Compute activities list using views
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_properties: called
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_current_activity: called for contact#3
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_current_activity: current activity not in cache, query PEP node
>** (telepathy-gabble:21866): DEBUG: get_current_activity_reply_cb: Failed to query PEP node. No current activity
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_activities: called
>** (telepathy-gabble:21866): DEBUG: get_activities_reply_cb: Failed to query PEP node. Compute activities list using views
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_properties: called
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_current_activity: called for contact#4
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_current_activity: current activity not in cache, query PEP node
>** (telepathy-gabble:21866): DEBUG: get_current_activity_reply_cb: Failed to query PEP node. No current activity
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_activities: called
>** (telepathy-gabble:21866): DEBUG: get_activities_reply_cb: Failed to query PEP node. Compute activities list using views
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_properties: called
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_current_activity: called for contact#5
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_current_activity: current activity not in cache, query PEP node
>** (telepathy-gabble:21866): DEBUG: get_current_activity_reply_cb: Failed to query PEP node. No current activity
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_activities: called
>** (telepathy-gabble:21866): DEBUG: get_activities_reply_cb: Failed to query PEP node. Compute activities list using views
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_properties: called
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_current_activity: called for contact#6
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_current_activity: current activity not in cache, query PEP node
>** (telepathy-gabble:21866): DEBUG: get_current_activity_reply_cb: Failed to query PEP node. No current activity
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_activities: called
>** (telepathy-gabble:21866): DEBUG: get_activities_reply_cb: Failed to query PEP node. Compute activities list using views
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_properties: called
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_current_activity: called for contact#7
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_current_activity: current activity not in cache, query PEP node
>** (telepathy-gabble:21866): DEBUG: get_current_activity_reply_cb: Failed to query PEP node. No current activity
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_activities: called
>** (telepathy-gabble:21866): DEBUG: get_activities_reply_cb: Failed to query PEP node. Compute activities list using views
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_properties: called
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_current_activity: called for contact#8
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_current_activity: current activity not in cache, query PEP node
>** (telepathy-gabble:21866): DEBUG: get_current_activity_reply_cb: Failed to query PEP node. No current activity
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_activities: called
>** (telepathy-gabble:21866): DEBUG: get_activities_reply_cb: Failed to query PEP node. Compute activities list using views
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_properties: called
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_current_activity: called for contact#9
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_current_activity: current activity not in cache, query PEP node
>** (telepathy-gabble:21866): DEBUG: get_current_activity_reply_cb: Failed to query PEP node. No current activity
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_activities: called
>** (telepathy-gabble:21866): DEBUG: get_activities_reply_cb: Failed to query PEP node. Compute activities list using views
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_properties: called
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_current_activity: called for contact#10
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_current_activity: current activity not in cache, query PEP node
>** (telepathy-gabble:21866): DEBUG: get_current_activity_reply_cb: Failed to query PEP node. No current activity
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_activities: called
>** (telepathy-gabble:21866): DEBUG: get_activities_reply_cb: Failed to query PEP node. Compute activities list using views
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_properties: called
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_current_activity: called for contact#11
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_current_activity: current activity not in cache, query PEP node
>** (telepathy-gabble:21866): DEBUG: get_current_activity_reply_cb: Failed to query PEP node. No current activity
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_activities: called
>** (telepathy-gabble:21866): DEBUG: get_activities_reply_cb: Failed to query PEP node. Compute activities list using views
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_properties: called
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_current_activity: called for contact#12
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_current_activity: current activity not in cache, query PEP node
>** (telepathy-gabble:21866): DEBUG: get_current_activity_reply_cb: Failed to query PEP node. No current activity
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_activities: called
>** (telepathy-gabble:21866): DEBUG: get_activities_reply_cb: Failed to query PEP node. Compute activities list using views
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_properties: called
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_current_activity: called for contact#13
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_current_activity: current activity not in cache, query PEP node
>** (telepathy-gabble:21866): DEBUG: get_current_activity_reply_cb: Failed to query PEP node. No current activity
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_activities: called
>** (telepathy-gabble:21866): DEBUG: get_activities_reply_cb: Failed to query PEP node. Compute activities list using views
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_properties: called
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_current_activity: called for contact#14
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_current_activity: current activity not in cache, query PEP node
>** (telepathy-gabble:21866): DEBUG: get_current_activity_reply_cb: Failed to query PEP node. No current activity
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_activities: called
>** (telepathy-gabble:21866): DEBUG: get_activities_reply_cb: Failed to query PEP node. Compute activities list using views
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_properties: called
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_current_activity: called for contact#15
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_current_activity: current activity not in cache, query PEP node
>** (telepathy-gabble:21866): DEBUG: get_current_activity_reply_cb: Failed to query PEP node. No current activity
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_activities: called
>** (telepathy-gabble:21866): DEBUG: get_activities_reply_cb: Failed to query PEP node. Compute activities list using views
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_properties: called
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_current_activity: called for contact#16
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_current_activity: current activity not in cache, query PEP node
>** (telepathy-gabble:21866): DEBUG: get_current_activity_reply_cb: Failed to query PEP node. No current activity
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_activities: called
>** (telepathy-gabble:21866): DEBUG: get_activities_reply_cb: Failed to query PEP node. Compute activities list using views
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_properties: called
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_current_activity: called for contact#17
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_current_activity: current activity not in cache, query PEP node
>** (telepathy-gabble:21866): DEBUG: get_current_activity_reply_cb: Failed to query PEP node. No current activity
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_activities: called
>** (telepathy-gabble:21866): DEBUG: get_activities_reply_cb: Failed to query PEP node. Compute activities list using views
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_properties: called
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_current_activity: called for contact#18
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_current_activity: current activity not in cache, query PEP node
>** (telepathy-gabble:21866): DEBUG: get_current_activity_reply_cb: Failed to query PEP node. No current activity
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_activities: called
>** (telepathy-gabble:21866): DEBUG: get_activities_reply_cb: Failed to query PEP node. Compute activities list using views
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_properties: called
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_current_activity: called for contact#19
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_current_activity: current activity not in cache, query PEP node
>** (telepathy-gabble:21866): DEBUG: get_current_activity_reply_cb: Failed to query PEP node. No current activity
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_activities: called
>** (telepathy-gabble:21866): DEBUG: get_activities_reply_cb: Failed to query PEP node. Compute activities list using views
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_properties: called
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_current_activity: called for contact#20
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_current_activity: current activity not in cache, query PEP node
>** (telepathy-gabble:21866): DEBUG: get_current_activity_reply_cb: Failed to query PEP node. No current activity
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_activities: called
>** (telepathy-gabble:21866): DEBUG: get_activities_reply_cb: Failed to query PEP node. Compute activities list using views
>** (telepathy-gabble:21866): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x9cbb7a0
>** (telepathy-gabble:21866): DEBUG: send_next_request: processing request 0x9cbb7a0
>** (telepathy-gabble:21866): DEBUG: response_cb: got reply for request 0x9cbb7a0
>** (telepathy-gabble:21866): DEBUG: aliases_request_cache_pep: Error getting alias from PEP:
><iq type="error" id="855200875723" to="25aabee27fed34446d30e2a0c16764ee02a3a81e@jabber.sugarlabs.org/Telepathy" from="beff817f350152acaa47f2174d73f2a946ced204@jabber.sugarlabs.org"> <error type="auth" code="401"> <not-authorized xmlns="urn:ietf:params:xml:ns:xmpp-stanzas"></not-authorized>
> <presence-subscription-required xmlns="http://jabber.org/protocol/pubsub#errors"></presence-subscription-required>
></error>
> <pubsub xmlns="http://jabber.org/protocol/pubsub">
> <items node="http://jabber.org/protocol/nick"></items>
></pubsub>
></iq>
>
>** (telepathy-gabble:21866): DEBUG: aliases_request_pep_cb: Got cached alias beff817f350152acaa47f2174d73f2a946ced204 with priority 1
>** (telepathy-gabble:21866): DEBUG: gabble_vcard_manager_request: Created request 0x9cbb780 to retrieve <21>'s vCard
>** (telepathy-gabble:21866): DEBUG: cache_entry_ensure_queued: Cache entry 0x9d12ec8 is not mine, @to = beff817f350152acaa47f2174d73f2a946ced204@jabber.sugarlabs.org
>** (telepathy-gabble:21866): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x9cbb760
>** (telepathy-gabble:21866): DEBUG: cache_entry_ensure_queued: adding request to cache entry 0x9d12ec8 and queueing the <iq>
>** (telepathy-gabble:21866): DEBUG: delete_item: deleting item 0x9cbb7a0
>** (telepathy-gabble:21866): DEBUG: send_next_request: processing request 0x9cbb760
>** (telepathy-gabble:21866): DEBUG: response_cb: got reply for request 0x9cbb760
>** (telepathy-gabble:21866): DEBUG: pipeline_reply_cb: called for entry 0x9d12ec8
>** (telepathy-gabble:21866): DEBUG: observe_vcard: got vCard alias "uwog2" for handle 21 from <NICKNAME>
>** (telepathy-gabble:21866): DEBUG: delete_request: Discarding request 0x9cbb780
>** (telepathy-gabble:21866): DEBUG: cache_entry_attempt_to_free: Not freeing vCard cache entry 0x9d12ec8: it has a cached vCard 0x9d0e7e0
>** (telepathy-gabble:21866): DEBUG: delete_item: deleting item 0x9cbb760
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_properties: called
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_current_activity: called for contact#21
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_current_activity: current activity not in cache, query PEP node
>** (telepathy-gabble:21866): DEBUG: get_current_activity_reply_cb: Failed to query PEP node. No current activity
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_activities: called
>** (telepathy-gabble:21866): DEBUG: get_activities_reply_cb: Failed to query PEP node. Compute activities list using views
>** (telepathy-gabble:21866): DEBUG: copy_activity_to_array: ... activity #1 (ID 95a09ec3347ad28434909ad14d4d1696282276c7)
>** (telepathy-gabble:21866): DEBUG: _caps_disco_cb: disco query failed: Request for info on 25aabee27fed34446d30e2a0c16764ee02a3a81e@jabber.sugarlabs.org/Telepathy timed out
>** (telepathy-gabble:21866): DEBUG: _caps_disco_cb: failed to find a suitable candidate to retry disco request for URI http://telepathy.freedesktop.org/caps#eRnpKxqz6IQNnGJzY89+Sxz2UA4=
>** (telepathy-gabble:21866): DEBUG: disco_waiter_list_free: list 0x9cbc5d0
>** (telepathy-gabble:21866): DEBUG: disco_waiter_free: freeing waiter 0x9b83740 for handle 1 with serial 1
>** (telepathy-gabble:21866): DEBUG: _caps_disco_cb: disco query failed: Request for info on 25aabee27fed34446d30e2a0c16764ee02a3a81e@jabber.sugarlabs.org/Telepathy timed out
>** (telepathy-gabble:21866): DEBUG: gabble_disco_request_with_timeout: Creating disco request 0x9cbb740 for 25aabee27fed34446d30e2a0c16764ee02a3a81e@jabber.sugarlabs.org/Telepathy
>** (telepathy-gabble:21866): DEBUG: _caps_disco_cb: sent a retry disco request to 25aabee27fed34446d30e2a0c16764ee02a3a81e@jabber.sugarlabs.org/Telepathy for URI http://telepathy.freedesktop.org/caps#fL4hzIC3FAqjApGlCg6uHgZturQ=
>** (telepathy-gabble:21866): DEBUG: connection_iq_disco_cb: got disco request for node http://telepathy.freedesktop.org/caps#fL4hzIC3FAqjApGlCg6uHgZturQ=, caps are 22be5
>** (telepathy-gabble:21866): DEBUG: connection_iq_disco_cb: caps now 142309
>** (telepathy-gabble:21866): DEBUG: connection_iq_disco_cb: sending disco response:
><iq type="result" to="25aabee27fed34446d30e2a0c16764ee02a3a81e@jabber.sugarlabs.org/Telepathy" id="361141381758"> <query node="http://telepathy.freedesktop.org/caps#fL4hzIC3FAqjApGlCg6uHgZturQ=" xmlns="http://jabber.org/protocol/disco#info"> <identity type="pc" name="Telepathy Gabble 0.7.26" 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>
> <feature var="http://jabber.org/protocol/si/profile/file-transfer"></feature>
> <feature var="http://laptop.org/xmpp/buddy-properties+notify"></feature>
> <feature var="http://laptop.org/xmpp/activities+notify"></feature>
> <feature var="http://laptop.org/xmpp/current-activity+notify"></feature>
> <feature var="http://laptop.org/xmpp/activity-properties+notify"></feature>
></query>
></iq>
>
>** (telepathy-gabble:21866): DEBUG: connection_iq_unknown_cb: got unknown iq:
><iq id="361141381758" type="result" to="25aabee27fed34446d30e2a0c16764ee02a3a81e@jabber.sugarlabs.org/Telepathy" from="25aabee27fed34446d30e2a0c16764ee02a3a81e@jabber.sugarlabs.org/Telepathy">
> <query xmlns="http://jabber.org/protocol/disco#info" node="http://telepathy.freedesktop.org/caps#fL4hzIC3FAqjApGlCg6uHgZturQ=">
> <identity category="client" name="Telepathy Gabble 0.7.26" type="pc"></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>
> <feature var="http://jabber.org/protocol/si/profile/file-transfer"></feature>
> <feature var="http://laptop.org/xmpp/buddy-properties+notify"></feature>
> <feature var="http://laptop.org/xmpp/activities+notify"></feature>
> <feature var="http://laptop.org/xmpp/current-activity+notify"></feature>
> <feature var="http://laptop.org/xmpp/activity-properties+notify"></feature>
></query>
></iq>
>
>** (telepathy-gabble:21866): DEBUG: _caps_disco_cb: disco query failed: Request for info on 25aabee27fed34446d30e2a0c16764ee02a3a81e@jabber.sugarlabs.org/Telepathy timed out
>** (telepathy-gabble:21866): DEBUG: _caps_disco_cb: failed to find a suitable candidate to retry disco request for URI http://telepathy.freedesktop.org/caps#fL4hzIC3FAqjApGlCg6uHgZturQ=
>** (telepathy-gabble:21866): DEBUG: disco_waiter_list_free: list 0x9d19630
>** (telepathy-gabble:21866): DEBUG: disco_waiter_free: freeing waiter 0x9cb4560 for handle 1 with serial 3
>** (telepathy-gabble:21866): DEBUG: disco_waiter_free: freeing waiter 0x9cb4500 for handle 1 with serial 2
>** (telepathy-gabble:21866): DEBUG: gabble_presence_cache_maybe_remove: discarding cached presence for unavailable jid ae6da8eda397b06dc101737322b9f7954eb98837@jabber.sugarlabs.org
>(telepathy-gabble:21866): tp-glib-DEBUG: tp_presence_mixin_emit_presence_update: called.
>(telepathy-gabble:21866): tp-glib-DEBUG: construct_presence_hash: called.
>(telepathy-gabble:21866): tp-glib-DEBUG: construct_simple_presence_hash: called.
>(telepathy-gabble:21866): tp-glib-DEBUG: tp_presence_mixin_emit_presence_update: called.
>(telepathy-gabble:21866): tp-glib-DEBUG: construct_presence_hash: called.
>(telepathy-gabble:21866): tp-glib-DEBUG: construct_simple_presence_hash: called.
>** (telepathy-gabble:21866): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x9cbb700
>** (telepathy-gabble:21866): DEBUG: send_next_request: processing request 0x9cbb700
>** (telepathy-gabble:21866): DEBUG: response_cb: got reply for request 0x9cbb700
>** (telepathy-gabble:21866): DEBUG: aliases_request_cache_pep: Error getting alias from PEP:
><iq type="error" id="622767647390" to="25aabee27fed34446d30e2a0c16764ee02a3a81e@jabber.sugarlabs.org/Telepathy" from="261292d4666efd9964a4ce0af24ebc68441d5373@jabber.sugarlabs.org"> <error type="auth" code="401"> <not-authorized xmlns="urn:ietf:params:xml:ns:xmpp-stanzas"></not-authorized>
> <presence-subscription-required xmlns="http://jabber.org/protocol/pubsub#errors"></presence-subscription-required>
></error>
> <pubsub xmlns="http://jabber.org/protocol/pubsub">
> <items node="http://jabber.org/protocol/nick"></items>
></pubsub>
></iq>
>
>** (telepathy-gabble:21866): DEBUG: aliases_request_pep_cb: Got cached alias 261292d4666efd9964a4ce0af24ebc68441d5373 with priority 1
>** (telepathy-gabble:21866): DEBUG: gabble_vcard_manager_request: Created request 0x9cbb6e0 to retrieve <22>'s vCard
>** (telepathy-gabble:21866): DEBUG: cache_entry_ensure_queued: Cache entry 0x9d1a380 is not mine, @to = 261292d4666efd9964a4ce0af24ebc68441d5373@jabber.sugarlabs.org
>** (telepathy-gabble:21866): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x9cbb6c0
>** (telepathy-gabble:21866): DEBUG: cache_entry_ensure_queued: adding request to cache entry 0x9d1a380 and queueing the <iq>
>** (telepathy-gabble:21866): DEBUG: delete_item: deleting item 0x9cbb700
>** (telepathy-gabble:21866): DEBUG: send_next_request: processing request 0x9cbb6c0
>** (telepathy-gabble:21866): DEBUG: response_cb: got reply for request 0x9cbb6c0
>** (telepathy-gabble:21866): DEBUG: pipeline_reply_cb: called for entry 0x9d1a380
>** (telepathy-gabble:21866): DEBUG: observe_vcard: got vCard alias "ignacio          rios" for handle 22 from <NICKNAME>
>** (telepathy-gabble:21866): DEBUG: delete_request: Discarding request 0x9cbb6e0
>** (telepathy-gabble:21866): DEBUG: cache_entry_attempt_to_free: Not freeing vCard cache entry 0x9d1a380: it has a cached vCard 0x9b796b8
>** (telepathy-gabble:21866): DEBUG: delete_item: deleting item 0x9cbb6c0
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_properties: called
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_current_activity: called for contact#22
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_current_activity: current activity not in cache, query PEP node
>** (telepathy-gabble:21866): DEBUG: get_current_activity_reply_cb: Failed to query PEP node. No current activity
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_get_activities: called
>** (telepathy-gabble:21866): DEBUG: get_activities_reply_cb: Failed to query PEP node. Compute activities list using views
>(telepathy-gabble:21866): tp-glib-DEBUG: channel_request_new: New channel request at 0x9d1a418: ctype=org.freedesktop.Telepathy.Channel.Type.Text htype=2 handle=1 suppress=1
>** (telepathy-gabble:21866): DEBUG: new_muc_channel: creating new chan, object path /org/freedesktop/Telepathy/Connection/gabble/jabber/_325aabee27fed34446d30e2a0c16764ee02a3a81e_40jabber_2esugarlabs_2eorg_2fTelepathy/MucChannel1
>[1m[37mtp_group_mixin_change_flags: emitting group flags changed
>  added    : [[22mCAN_ADD|CHANNEL_SPECIFIC_HANDLES|HANDLE_OWNERS_NOT_AVAILABLE|PROPERTIES[1m]
>  removed  : [[22m[1m]
>  flags now: [[22mCAN_ADD|CHANNEL_SPECIFIC_HANDLES|HANDLE_OWNERS_NOT_AVAILABLE|PROPERTIES[1m]
>[0m[1m[36memit_members_changed_signals: emitting members changed
>  message       : ""
>  added         : [[22m[1m]
>  removed       : [[22m[1m]
>  local_pending : [[22m[1m]
>  remote_pending: [[22m23 (95a09ec3347ad28434909ad14d4d1696282276c7@conference.jabber.sugarlabs.org/uwog)[1m]
>  actor         : 0
>  reason        : 0: unspecified reason
>[0m** (telepathy-gabble:21866): DEBUG: send_join_request: join request sent
>** (telepathy-gabble:21866): DEBUG: channel_state_changed: state changed from MUC_STATE_CREATED to MUC_STATE_INITIATED
>[1m[37mtp_group_mixin_change_flags: emitting group flags changed
>  added    : [[22m[1m]
>  removed  : [[22mCAN_ADD[1m]
>  flags now: [[22mCHANNEL_SPECIFIC_HANDLES|HANDLE_OWNERS_NOT_AVAILABLE|PROPERTIES[1m]
>[0m** (telepathy-gabble:21866): DEBUG: _gabble_muc_channel_receive: ignoring message from muc:
><message type="groupchat" to="25aabee27fed34446d30e2a0c16764ee02a3a81e@jabber.sugarlabs.org/Telepathy" from="95a09ec3347ad28434909ad14d4d1696282276c7@conference.jabber.sugarlabs.org"> <body>This room is not anonymous</body>
> <x xmlns="http://jabber.org/protocol/muc#user"> <status code="100"></status>
></x>
></message>
>
>** (telepathy-gabble:21866): DEBUG: _gabble_muc_channel_member_presence_updated: called
>[1m[37mtp_group_mixin_change_flags: emitting group flags changed
>  added    : [[22m[1m]
>  removed  : [[22mHANDLE_OWNERS_NOT_AVAILABLE[1m]
>  flags now: [[22mCHANNEL_SPECIFIC_HANDLES|PROPERTIES[1m]
>[0m** (telepathy-gabble:21866): DEBUG: new_tubes_channel: creating new tubes chan, object path /org/freedesktop/Telepathy/Connection/gabble/jabber/_325aabee27fed34446d30e2a0c16764ee02a3a81e_40jabber_2esugarlabs_2eorg_2fTelepathy/MucTubesChannel1
>** (telepathy-gabble:21866): DEBUG: gabble_tubes_channel_constructor: Called
>** (telepathy-gabble:21866): DEBUG: gabble_tubes_channel_set_property: Setting object_path: /org/freedesktop/Telepathy/Connection/gabble/jabber/_325aabee27fed34446d30e2a0c16764ee02a3a81e_40jabber_2esugarlabs_2eorg_2fTelepathy/MucTubesChannel1
>** (telepathy-gabble:21866): DEBUG: gabble_tubes_channel_constructor: Registering at '/org/freedesktop/Telepathy/Connection/gabble/jabber/_325aabee27fed34446d30e2a0c16764ee02a3a81e_40jabber_2esugarlabs_2eorg_2fTelepathy/MucTubesChannel1'
>** (telepathy-gabble:21866): DEBUG: gabble_tube_dbus_constructor: Registering at '/org/freedesktop/Telepathy/Connection/gabble/jabber/_325aabee27fed34446d30e2a0c16764ee02a3a81e_40jabber_2esugarlabs_2eorg_2fTelepathy/DBusTubeChannel_1_1736093172'
>** (telepathy-gabble:21866): DEBUG: gabble_tube_dbus_constructor: local name: :2.dXdvZwAA
>** (telepathy-gabble:21866): DEBUG: gabble_signal_connect_weak: connecting to 0x9cbcbb0:state-changed with context 0x9d10250
>** (telepathy-gabble:21866): DEBUG: gabble_bytestream_factory_create_muc: add muc bytestream <1251970491-2896628767> from <95a09ec3347ad28434909ad14d4d1696282276c7@conference.jabber.sugarlabs.org>
>** (telepathy-gabble:21866): DEBUG: create_new_tube: create tube 1736093172
>** (telepathy-gabble:21866): DEBUG: gabble_presence_cache_do_update: 95a09ec3347ad28434909ad14d4d1696282276c7@conference.jabber.sugarlabs.org/uwog2 (26) resource uwog2 prio 0 presence 7 message "(null)"
>(telepathy-gabble:21866): tp-glib-DEBUG: tp_presence_mixin_emit_presence_update: called.
>(telepathy-gabble:21866): tp-glib-DEBUG: construct_presence_hash: called.
>(telepathy-gabble:21866): tp-glib-DEBUG: construct_simple_presence_hash: called.
>** (telepathy-gabble:21866): DEBUG: _process_caps: Emitting caps update: handle 26, old 0, new 0
>** (telepathy-gabble:21866): DEBUG: _gabble_muc_channel_member_presence_updated: called
>[1m[36memit_members_changed_signals: emitting members changed
>  message       : ""
>  added         : [[22m23 (95a09ec3347ad28434909ad14d4d1696282276c7@conference.jabber.sugarlabs.org/uwog)
>                   26 (95a09ec3347ad28434909ad14d4d1696282276c7@conference.jabber.sugarlabs.org/uwog2)[1m]
>  removed       : [[22m[1m]
>  local_pending : [[22m[1m]
>  remote_pending: [[22m[1m]
>  actor         : 0
>  reason        : 0: unspecified reason
>[0m** (telepathy-gabble:21866): DEBUG: channel_state_changed: state changed from MUC_STATE_INITIATED to MUC_STATE_JOINED
>** (telepathy-gabble:21866): DEBUG: change_password_flags: emitting password flags changed, added 0x0, removed 0x0
>** (telepathy-gabble:21866): DEBUG: muc_ready_cb: text chan=0x9cbe360
>(telepathy-gabble:21866): tp-glib-DEBUG: satisfy_request: completing queued request 0x9d1a418 with success, channel_type=org.freedesktop.Telepathy.Channel.Type.Text, handle_type=2, handle=1, suppress_handler=1
>(telepathy-gabble:21866): tp-glib-DEBUG: channel_request_free: Freeing channel request at 0x9d1a418: ctype=org.freedesktop.Telepathy.Channel.Type.Text htype=2 handle=1 suppress=1
>** (telepathy-gabble:21866): DEBUG: gabble_disco_request_with_timeout: Creating disco request 0x9cbb6c0 for 95a09ec3347ad28434909ad14d4d1696282276c7@conference.jabber.sugarlabs.org
>[1m[37mtp_group_mixin_change_flags: emitting group flags changed
>  added    : [[22mCAN_ADD|CAN_REMOVE|MESSAGE_ADD|MESSAGE_REMOVE[1m]
>  removed  : [[22m[1m]
>  flags now: [[22mCAN_ADD|CAN_REMOVE|MESSAGE_ADD|MESSAGE_REMOVE|CHANNEL_SPECIFIC_HANDLES|PROPERTIES[1m]
>[0m[1m[37mtp_properties_mixin_emit_flags: emitting properties flags changed for properties:
>  anonymous's flags now: [[22mWRITE[1m]
>  invite-only's flags now: [[22mWRITE[1m]
>  invite-restricted's flags now: [[22mWRITE[1m]
>  moderated's flags now: [[22mWRITE[1m]
>  name's flags now: [[22mWRITE[1m]
>  password's flags now: [[22mWRITE[1m]
>  password-required's flags now: [[22mWRITE[1m]
>  persistent's flags now: [[22mWRITE[1m]
>  private's flags now: [[22mWRITE[1m]
>  subject's flags now: [[22mWRITE[1m]
>[0m** (telepathy-gabble:21866): DEBUG: gabble_presence_cache_do_update: 95a09ec3347ad28434909ad14d4d1696282276c7@conference.jabber.sugarlabs.org/uwog (23) resource uwog prio 0 presence 7 message "(null)"
>(telepathy-gabble:21866): tp-glib-DEBUG: tp_presence_mixin_emit_presence_update: called.
>(telepathy-gabble:21866): tp-glib-DEBUG: construct_presence_hash: called.
>(telepathy-gabble:21866): tp-glib-DEBUG: construct_simple_presence_hash: called.
>** (telepathy-gabble:21866): DEBUG: _process_caps: Emitting caps update: handle 23, old 0, new 0
>** (telepathy-gabble:21866): DEBUG: conn_olpc_process_activity_properties_message: Found <properties> node in <message>
>** (telepathy-gabble:21866): DEBUG: conn_olpc_process_activity_properties_message: Activity properties message was in a chatroom
>** (telepathy-gabble:21866): DEBUG: conn_olpc_process_activity_properties_message: Ignoring echoed activity properties message from myself
>** (telepathy-gabble:21866): DEBUG: gabble_bytestream_muc_receive: can't receive data through a not open bytestream (state: 0)
>(telepathy-gabble:21866): tp-glib-DEBUG: channel_request_new: New channel request at 0x9d131c0: ctype=org.freedesktop.Telepathy.Channel.Type.Tubes htype=2 handle=1 suppress=1
>(telepathy-gabble:21866): tp-glib-DEBUG: satisfy_request: completing queued request 0x9d131c0 with success, channel_type=org.freedesktop.Telepathy.Channel.Type.Tubes, handle_type=2, handle=1, suppress_handler=1
>(telepathy-gabble:21866): tp-glib-DEBUG: channel_request_free: Freeing channel request at 0x9d131c0: ctype=org.freedesktop.Telepathy.Channel.Type.Tubes htype=2 handle=1 suppress=1
>[1m[36mtp_properties_mixin_emit_changed: emitting properties changed for properties:
>  anonymous
>  invite-only
>  moderated
>  name
>  password-required
>  persistent
>  private
>[0m[1m[37mtp_properties_mixin_emit_flags: emitting properties flags changed for properties:
>  anonymous's flags now: [[22mREAD|WRITE[1m]
>  invite-only's flags now: [[22mREAD|WRITE[1m]
>  moderated's flags now: [[22mREAD|WRITE[1m]
>  name's flags now: [[22mREAD|WRITE[1m]
>  password-required's flags now: [[22mREAD|WRITE[1m]
>  persistent's flags now: [[22mREAD|WRITE[1m]
>  private's flags now: [[22mREAD|WRITE[1m]
>[0m** (telepathy-gabble:21866): DEBUG: request_config_form_reply_cb: skipping node 'title'
>** (telepathy-gabble:21866): DEBUG: request_config_form_reply_cb: ignoring field 'FORM_TYPE'
>** (telepathy-gabble:21866): DEBUG: request_config_form_reply_cb: looking up persistent... has=1
>** (telepathy-gabble:21866): DEBUG: request_config_form_reply_cb: Setting value 0 for muc#roomconfig_persistentroom
>** (telepathy-gabble:21866): DEBUG: request_config_form_reply_cb: looking up private... has=1
>** (telepathy-gabble:21866): DEBUG: request_config_form_reply_cb: Setting value 0 for muc#roomconfig_publicroom
>** (telepathy-gabble:21866): DEBUG: request_config_form_reply_cb: ignoring field 'public_list'
>** (telepathy-gabble:21866): DEBUG: request_config_form_reply_cb: ignoring field 'muc#roomconfig_maxusers'
>** (telepathy-gabble:21866): DEBUG: request_config_form_reply_cb: looking up anonymous... has=1
>** (telepathy-gabble:21866): DEBUG: request_config_form_reply_cb: Setting value anyone for muc#roomconfig_whois
>** (telepathy-gabble:21866): DEBUG: request_config_form_reply_cb: looking up invite-only... has=1
>** (telepathy-gabble:21866): DEBUG: request_config_form_reply_cb: Setting value 0 for muc#roomconfig_membersonly
>** (telepathy-gabble:21866): DEBUG: request_config_form_reply_cb: ignoring field 'members_by_default'
>** (telepathy-gabble:21866): DEBUG: request_config_form_reply_cb: ignoring field 'muc#roomconfig_changesubject'
>** (telepathy-gabble:21866): DEBUG: request_config_form_reply_cb: ignoring field 'allow_private_messages'
>** (telepathy-gabble:21866): DEBUG: request_config_form_reply_cb: ignoring field 'allow_query_users'
>** (telepathy-gabble:21866): DEBUG: request_config_form_reply_cb: looking up invite-restricted... has=1
>** (telepathy-gabble:21866): DEBUG: request_config_form_reply_cb: Setting value 1 for muc#roomconfig_allowinvites
>** (telepathy-gabble:21866): DEBUG: request_config_form_reply_cb: ignoring field 'muc#roomconfig_allowvisitorstatus'
>** (telepathy-gabble:21866): DEBUG: request_config_form_reply_cb: ignoring field 'muc#roomconfig_allowvisitornickchange'
>(telepathy-gabble:21866): tp-glib-DEBUG: tp_properties_context_return: success
>[1m[36mtp_properties_mixin_emit_changed: emitting properties changed for property:
>  invite-restricted
>[0m[1m[37mtp_properties_mixin_emit_flags: emitting properties flags changed for property:
>  invite-restricted's flags now: [[22mREAD|WRITE[1m]
>[0m** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_set_activities: called
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_set_activities: ref: 95a09ec3347ad28434909ad14d4d1696282276c7@conference.jabber.sugarlabs.org (1) refcount: 3
>
>** (telepathy-gabble:21866): DEBUG: olpc_buddy_info_set_current_activity: called
>** (telepathy-gabble:21866): DEBUG: copy_activity_to_array: ... activity #1 (ID 95a09ec3347ad28434909ad14d4d1696282276c7)

Actions: View

Attachments on bug 23678: 29168 | 29169

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.