(telepathy-gabble:21749): tp-glib-DEBUG: tp_proxy_borrow_interface_by_id: 0x9686a80: org.freedesktop.DBus DBusGProxy is 0x9686b60
(telepathy-gabble:21749): tp-glib-DEBUG: started version 0.7.26 (telepathy-glib version 0.7.29)
(telepathy-gabble:21749): tp-glib-DEBUG: tp_cm_param_setter_offset: account = "beff817f350152acaa47f2174d73f2a946ced204@jabber.sugarlabs.org"
(telepathy-gabble:21749): tp-glib-DEBUG: tp_cm_param_setter_offset: password = <hidden>
(telepathy-gabble:21749): tp-glib-DEBUG: parse_parameters: server not given, using default behaviour
(telepathy-gabble:21749): tp-glib-DEBUG: tp_cm_param_setter_offset: resource = "Telepathy"
(telepathy-gabble:21749): tp-glib-DEBUG: tp_cm_param_setter_offset: priority = 0 = 0x0
(telepathy-gabble:21749): tp-glib-DEBUG: tp_cm_param_setter_offset: port = 5223 = 0x1467
(telepathy-gabble:21749): tp-glib-DEBUG: tp_cm_param_setter_offset: old-ssl = TRUE
(telepathy-gabble:21749): tp-glib-DEBUG: tp_cm_param_setter_offset: require-encryption = FALSE
(telepathy-gabble:21749): tp-glib-DEBUG: tp_cm_param_setter_offset: register = FALSE
(telepathy-gabble:21749): tp-glib-DEBUG: tp_cm_param_setter_offset: low-bandwidth = FALSE
(telepathy-gabble:21749): tp-glib-DEBUG: parse_parameters: https-proxy-server not given, using default behaviour
(telepathy-gabble:21749): tp-glib-DEBUG: tp_cm_param_setter_offset: https-proxy-port = 443 = 0x1bb
(telepathy-gabble:21749): tp-glib-DEBUG: tp_cm_param_setter_offset: fallback-conference-server = "conference.jabber.sugarlabs.org"
(telepathy-gabble:21749): tp-glib-DEBUG: parse_parameters: stun-server not given, using default behaviour
(telepathy-gabble:21749): tp-glib-DEBUG: tp_cm_param_setter_offset: stun-port = 3478 = 0xd96
(telepathy-gabble:21749): tp-glib-DEBUG: tp_cm_param_setter_offset: fallback-stun-server = "stun.collabora.co.uk"
(telepathy-gabble:21749): tp-glib-DEBUG: tp_cm_param_setter_offset: fallback-stun-port = 3478 = 0xd96
(telepathy-gabble:21749): tp-glib-DEBUG: tp_cm_param_setter_offset: ignore-ssl-errors = TRUE
(telepathy-gabble:21749): tp-glib-DEBUG: parse_parameters: alias not given, using default behaviour
(telepathy-gabble:21749): 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:21749): tp-glib-DEBUG: tp_base_connection_class_init: Initializing (TpBaseConnectionClass *)0x968cb00
** (telepathy-gabble:21749): DEBUG: gabble_connection_class_init: Initializing (GabbleConnectionClass *)0x968dca8
(telepathy-gabble:21749): tp-glib-DEBUG: tp_presence_mixin_class_init: called.
(telepathy-gabble:21749): tp-glib-DEBUG: tp_base_connection_init: Initializing (TpBaseConnection *)0x9690028
** (telepathy-gabble:21749): DEBUG: gabble_connection_init: Initializing (GabbleConnection *)0x9690028
(telepathy-gabble:21749): tp-glib-DEBUG: tp_base_connection_constructor: Post-construction: (TpBaseConnection *)0x9690028
(telepathy-gabble:21749): tp-glib-DEBUG: tp_base_connection_constructor: Handle repo for type #0 at (nil)
(telepathy-gabble:21749): tp-glib-DEBUG: tp_base_connection_constructor: Handle repo for type #1 at 0x9680090
(telepathy-gabble:21749): tp-glib-DEBUG: tp_base_connection_constructor: Handle repo for type #2 at 0x9680120
(telepathy-gabble:21749): tp-glib-DEBUG: tp_base_connection_constructor: Handle repo for type #3 at 0x9688480
(telepathy-gabble:21749): tp-glib-DEBUG: tp_base_connection_constructor: Handle repo for type #4 at 0x96801b0
** (telepathy-gabble:21749): DEBUG: gabble_roomlist_manager_constructed: 0x9686400
(telepathy-gabble:21749): tp-glib-DEBUG: tp_base_connection_constructor: Channel manager #0 at 0x9687118
(telepathy-gabble:21749): tp-glib-DEBUG: tp_base_connection_constructor: Channel manager #1 at 0x9686390
(telepathy-gabble:21749): tp-glib-DEBUG: tp_base_connection_constructor: Channel manager #2 at 0x9686400
(telepathy-gabble:21749): tp-glib-DEBUG: tp_base_connection_constructor: Channel manager #3 at 0x9689908
(telepathy-gabble:21749): tp-glib-DEBUG: tp_base_connection_constructor: Channel manager #4 at 0x9686478
(telepathy-gabble:21749): tp-glib-DEBUG: tp_base_connection_constructor: Channel manager #5 at 0x96864f0
(telepathy-gabble:21749): tp-glib-DEBUG: tp_base_connection_constructor: Channel manager #6 at 0x96885a0
(telepathy-gabble:21749): tp-glib-DEBUG: tp_base_connection_constructor: Channel manager #7 at 0x96885c0
** (telepathy-gabble:21749): DEBUG: gabble_connection_constructor: Post-construction: (GabbleConnection *)0x9690028
(telepathy-gabble:21749): tp-glib-DEBUG: tp_presence_mixin_init: called.
** (telepathy-gabble:21749): DEBUG: gabble_signal_connect_weak: connecting to 0x9696460:item-found with context 0x9683160
** (telepathy-gabble:21749): DEBUG: gabble_signal_connect_weak: connecting to 0x9690028:status-changed with context 0x9683140
(telepathy-gabble:21749): tp-glib-DEBUG: tp_base_connection_register: bus name org.freedesktop.Telepathy.Connection.gabble.jabber.beff817f350152acaa47f2174d73f2a946ced204_40jabber_2esugarlabs_2eorg_2fTelepathy
(telepathy-gabble:21749): tp-glib-DEBUG: tp_base_connection_register: object path /org/freedesktop/Telepathy/Connection/gabble/jabber/beff817f350152acaa47f2174d73f2a946ced204_40jabber_2esugarlabs_2eorg_2fTelepathy
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_set_properties: called
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_set_properties: Not connected: will perform OLPC buddy property update later
** (telepathy-gabble:21749): DEBUG: _gabble_connection_connect: disabling SRV because "server" or "port" parameter specified, will connect to jabber.sugarlabs.org
** (telepathy-gabble:21749): DEBUG: do_connect: calling lm_connection_open
(telepathy-gabble:21749): tp-glib-DEBUG: tp_base_connection_change_status: was 4294967295, now 1, for reason 1
(telepathy-gabble:21749): tp-glib-DEBUG: tp_base_connection_change_status: emitting status-changed to 1, for reason 1
** (telepathy-gabble:21749): DEBUG: connection_status_changed_cb: adding callbacks
** (telepathy-gabble:21749): DEBUG: connection_status_changed_cb: adding callbacks
** (telepathy-gabble:21749): DEBUG: connection_status_changed_cb: adding callbacks
** (telepathy-gabble:21749): DEBUG: connection_ssl_cb: called: The certificate can not be trusted.
** (telepathy-gabble:21749): DEBUG: connection_ssl_cb: called: The server hostname doesn't match the one in the certificate.
** (telepathy-gabble:21749): DEBUG: do_auth: authenticating with username: beff817f350152acaa47f2174d73f2a946ced204, password: <hidden>, resource: Telepathy
** (telepathy-gabble:21749): DEBUG: connection_auth_cb: Created self handle 1, our JID is beff817f350152acaa47f2174d73f2a946ced204@jabber.sugarlabs.org/Telepathy
** (telepathy-gabble:21749): DEBUG: gabble_presence_set_capabilities: about to add caps 140261 to resource Telepathy with serial 1
** (telepathy-gabble:21749): DEBUG: gabble_presence_set_capabilities: found resource Telepathy
** (telepathy-gabble:21749): DEBUG: gabble_presence_set_capabilities: new serial 1, old 0, clearing caps
** (telepathy-gabble:21749): DEBUG: gabble_presence_set_capabilities: adding caps 140261 to resource Telepathy
** (telepathy-gabble:21749): DEBUG: gabble_presence_set_capabilities: resource Telepathy caps now 140261
** (telepathy-gabble:21749): DEBUG: gabble_presence_set_capabilities: total caps now 140261
** (telepathy-gabble:21749): DEBUG: gabble_disco_request_with_timeout: Creating disco request 0x96969a0 for jabber.sugarlabs.org
** (telepathy-gabble:21749): DEBUG: connection_iq_unknown_cb: got unknown iq:
<iq id="3416742359" type="result">
 <session xmlns="urn:ietf:params:xml:ns:xmpp-session"></session>
</iq>

** (telepathy-gabble:21749): 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:21749): DEBUG: connection_disco_cb: set features flags to 20
(telepathy-gabble:21749): tp-glib-DEBUG: tp_base_connection_change_status: was 1, now 0, for reason 1
(telepathy-gabble:21749): tp-glib-DEBUG: tp_base_connection_change_status: emitting status-changed to 0, for reason 1
** (telepathy-gabble:21749): DEBUG: connection_status_changed_cb: requesting roster
** (telepathy-gabble:21749): DEBUG: gabble_disco_conn_status_changed_cb: connected, initiating service discovery on jabber.sugarlabs.org
** (telepathy-gabble:21749): DEBUG: gabble_disco_request_with_timeout: Creating disco request 0x96969c0 for jabber.sugarlabs.org
** (telepathy-gabble:21749): DEBUG: gabble_vcard_manager_request: Created request 0x97d0e00 to retrieve <1>'s vCard
** (telepathy-gabble:21749): DEBUG: cache_entry_ensure_queued: Cache entry 0x9687648 is my own, not setting @to
** (telepathy-gabble:21749): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x97d0e20
** (telepathy-gabble:21749): DEBUG: cache_entry_ensure_queued: adding request to cache entry 0x9687648 and queueing the <iq>
(telepathy-gabble:21749): tp-glib-DEBUG: tp_presence_mixin_emit_presence_update: called.
(telepathy-gabble:21749): tp-glib-DEBUG: construct_presence_hash: called.
(telepathy-gabble:21749): tp-glib-DEBUG: construct_simple_presence_hash: called.
** (telepathy-gabble:21749): DEBUG: send_proxy_query: send SOCKS5 query to proxy.jabber.org
** (telepathy-gabble:21749): DEBUG: send_proxy_query: send SOCKS5 query to proxy.jabberfr.org
** (telepathy-gabble:21749): DEBUG: send_proxy_query: send SOCKS5 query to proxy.isgeek.info
** (telepathy-gabble:21749): DEBUG: send_proxy_query: send SOCKS5 query to proxy2.isgeek.info
** (telepathy-gabble:21749): DEBUG: send_proxy_query: send SOCKS5 query to proxy65.rooyee.biz
** (telepathy-gabble:21749): DEBUG: send_proxy_query: send SOCKS5 query to proxy.jabbim.cz
** (telepathy-gabble:21749): DEBUG: send_proxy_query: send SOCKS5 query to proxy.911910.cn
** (telepathy-gabble:21749): DEBUG: send_proxy_query: send SOCKS5 query to proxy.aszlig.net
** (telepathy-gabble:21749): DEBUG: send_proxy_query: send SOCKS5 query to proxy.brauchen.info
** (telepathy-gabble:21749): DEBUG: send_proxy_query: send SOCKS5 query to proxy.core.im
** (telepathy-gabble:21749): DEBUG: send_proxy_query: send SOCKS5 query to proxy.deshalbfrei.org
** (telepathy-gabble:21749): DEBUG: send_proxy_query: send SOCKS5 query to proxy.downtempo.de
** (telepathy-gabble:21749): DEBUG: send_proxy_query: send SOCKS5 query to proxy.draugr.de
** (telepathy-gabble:21749): DEBUG: send_proxy_query: send SOCKS5 query to proxy.egbers.info
** (telepathy-gabble:21749): DEBUG: send_proxy_query: send SOCKS5 query to proxy.headcounter.org
** (telepathy-gabble:21749): DEBUG: send_proxy_query: send SOCKS5 query to proxy.im.flosoft.biz
** (telepathy-gabble:21749): DEBUG: send_proxy_query: send SOCKS5 query to proxy.jabber-hispano.org
** (telepathy-gabble:21749): DEBUG: send_proxy_query: send SOCKS5 query to proxy.jabber.bluendo.com
** (telepathy-gabble:21749): DEBUG: send_proxy_query: send SOCKS5 query to proxy.jabber.dk
** (telepathy-gabble:21749): DEBUG: send_proxy_query: send SOCKS5 query to proxy.jabber.freenet.de
** (telepathy-gabble:21749): DEBUG: send_proxy_query: send SOCKS5 query to proxy.fsinf.at
** (telepathy-gabble:21749): DEBUG: send_proxy_query: send SOCKS5 query to proxy.jabber.kg
** (telepathy-gabble:21749): DEBUG: send_proxy_query: send SOCKS5 query to proxy.jabber.minus273.org
** (telepathy-gabble:21749): DEBUG: send_proxy_query: send SOCKS5 query to proxy.jabber.planetteamspeak.com
** (telepathy-gabble:21749): DEBUG: send_proxy_query: send SOCKS5 query to proxy.jabber.tf-network.de
** (telepathy-gabble:21749): DEBUG: send_proxy_query: send SOCKS5 query to proxy.jabjab.de
** (telepathy-gabble:21749): DEBUG: send_proxy_query: send SOCKS5 query to proxy.jabster.pl
** (telepathy-gabble:21749): DEBUG: send_proxy_query: send SOCKS5 query to proxy.noicq.org
** (telepathy-gabble:21749): DEBUG: send_proxy_query: send SOCKS5 query to proxy.schokokeks.org
** (telepathy-gabble:21749): DEBUG: send_proxy_query: send SOCKS5 query to proxy.silper.cz
** (telepathy-gabble:21749): DEBUG: send_proxy_query: send SOCKS5 query to proxy.ubuntu-jabber.de
** (telepathy-gabble:21749): DEBUG: send_proxy_query: send SOCKS5 query to proxy.ubuntu-jabber.net
** (telepathy-gabble:21749): DEBUG: send_proxy_query: send SOCKS5 query to proxy65.unstable.nl
** (telepathy-gabble:21749): DEBUG: send_proxy_query: send SOCKS5 query to proxy.verdammung.org
** (telepathy-gabble:21749): DEBUG: send_proxy_query: send SOCKS5 query to proxy.vke.ru
** (telepathy-gabble:21749): DEBUG: send_proxy_query: send SOCKS5 query to proxy.vodka-pomme.net
** (telepathy-gabble:21749): DEBUG: send_proxy_query: send SOCKS5 query to proxy.xabber.de
** (telepathy-gabble:21749): DEBUG: send_proxy_query: send SOCKS5 query to proxy.jabbernet.eu
** (telepathy-gabble:21749): DEBUG: gabble_presence_set_capabilities: about to add caps 142309 to resource Telepathy with serial 2
** (telepathy-gabble:21749): DEBUG: gabble_presence_set_capabilities: found resource Telepathy
** (telepathy-gabble:21749): DEBUG: gabble_presence_set_capabilities: new serial 2, old 1, clearing caps
** (telepathy-gabble:21749): DEBUG: gabble_presence_set_capabilities: adding caps 142309 to resource Telepathy
** (telepathy-gabble:21749): DEBUG: gabble_presence_set_capabilities: resource Telepathy caps now 142309
** (telepathy-gabble:21749): DEBUG: gabble_presence_set_capabilities: total caps now 142309
** (telepathy-gabble:21749): DEBUG: send_next_request: processing request 0x97d0e20
(telepathy-gabble:21749): tp-glib-DEBUG: tp_base_connection_dbus_request_handles: 1 handles of type 4, for :1.4
(telepathy-gabble:21749): tp-glib-DEBUG: channel_request_new: New channel request at 0x9828ec8: ctype=org.freedesktop.Telepathy.Channel.Type.ContactList htype=4 handle=1 suppress=1
** (telepathy-gabble:21749): DEBUG: _gabble_roster_get_channel: Looking up channel 4:1 "Friends"
** (telepathy-gabble:21749): DEBUG: _gabble_roster_create_channel: Instantiating channel 4:1 "Friends"
tp_group_mixin_change_flags: emitting group flags changed
  added    : [CAN_ADD|CAN_REMOVE|PROPERTIES]
  removed  : []
  flags now: [CAN_ADD|CAN_REMOVE|PROPERTIES]
** (telepathy-gabble:21749): DEBUG: _gabble_roster_create_channel: created /org/freedesktop/Telepathy/Connection/gabble/jabber/beff817f350152acaa47f2174d73f2a946ced204_40jabber_2esugarlabs_2eorg_2fTelepathy/RosterChannel/Group/Friends
** (telepathy-gabble:21749): DEBUG: _gabble_roster_create_channel: roster not yet received, not emitting signal for Friends list channel
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_set_properties: called
** (telepathy-gabble:21749): DEBUG: gabble_vcard_manager_edit: called; invalidating cache
** (telepathy-gabble:21749): DEBUG: cache_entry_attempt_to_free: Not freeing vCard cache entry 0x9687648: it has a pipeline_item 0x97d0e20
** (telepathy-gabble:21749): DEBUG: gabble_vcard_manager_edit: checking if we have pending requests already
** (telepathy-gabble:21749): DEBUG: gabble_vcard_manager_edit: NICKNAME => value of length 5 starting uwog2
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_set_activities: called
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_set_current_activity: called
** (telepathy-gabble:21749): DEBUG: gabble_normalize_contact: jid gadget.jabber.sugarlabs.org has invalid username or server
** (telepathy-gabble:21749): DEBUG: gabble_presence_cache_lm_message_cb: ignoring message from malformed jid:
<message type="notice" to="beff817f350152acaa47f2174d73f2a946ced204@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:30:07" xmlns="jabber:x:delay"></x>
</message>

** (telepathy-gabble:21749): DEBUG: gabble_normalize_room: invalid room JID gadget.jabber.sugarlabs.org: does not contain '@'
** (telepathy-gabble:21749): DEBUG: gabble_normalize_contact: jid gadget.jabber.sugarlabs.org has invalid username or server
** (telepathy-gabble:21749): DEBUG: gabble_presence_cache_lm_message_cb: ignoring message from malformed jid:
<message type="notice" to="beff817f350152acaa47f2174d73f2a946ced204@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">#FF8F00,#BE9E00</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:30:07" xmlns="jabber:x:delay"></x>
</message>

** (telepathy-gabble:21749): DEBUG: gabble_normalize_room: invalid room JID gadget.jabber.sugarlabs.org: does not contain '@'
** (telepathy-gabble:21749): DEBUG: gabble_normalize_contact: jid gadget.jabber.sugarlabs.org has invalid username or server
** (telepathy-gabble:21749): DEBUG: gabble_presence_cache_lm_message_cb: ignoring message from malformed jid:
<message type="notice" to="beff817f350152acaa47f2174d73f2a946ced204@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>
 <activity room="a5f797349e2245ffea0a5ce4ff20bf6516dcfa7f@conference.jabber.sugarlabs.org" id="a5f797349e2245ffea0a5ce4ff20bf6516dcfa7f" view="2" xmlns="http://laptop.org/xmpp/activity"> <left jid="25aabee27fed34446d30e2a0c16764ee02a3a81e@jabber.sugarlabs.org"></left>
</activity>
 <x stamp="20090903T09:30:07" xmlns="jabber:x:delay"></x>
</message>

** (telepathy-gabble:21749): DEBUG: gabble_normalize_room: invalid room JID gadget.jabber.sugarlabs.org: does not contain '@'
** (telepathy-gabble:21749): DEBUG: gabble_presence_cache_do_update: beff817f350152acaa47f2174d73f2a946ced204@jabber.sugarlabs.org (1) resource Telepathy prio 0 presence 7 message "(null)"
(telepathy-gabble:21749): tp-glib-DEBUG: tp_presence_mixin_emit_presence_update: called.
(telepathy-gabble:21749): tp-glib-DEBUG: construct_presence_hash: called.
(telepathy-gabble:21749): tp-glib-DEBUG: construct_simple_presence_hash: called.
** (telepathy-gabble:21749): DEBUG: _process_caps_uri: not enough trust for URI http://telepathy.freedesktop.org/caps#eRnpKxqz6IQNnGJzY89+Sxz2UA4=
** (telepathy-gabble:21749): DEBUG: disco_waiter_new: created waiter 0x97d0f40 for handle 1 with serial 1
** (telepathy-gabble:21749): 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:21749): DEBUG: gabble_disco_request_with_timeout: Creating disco request 0x97d0f60 for beff817f350152acaa47f2174d73f2a946ced204@jabber.sugarlabs.org/Telepathy
** (telepathy-gabble:21749): DEBUG: _process_caps: Emitting caps update: handle 1, old 0, new 0
** (telepathy-gabble:21749): DEBUG: _gabble_roster_get_channel: Looking up channel 3:1 "publish"
** (telepathy-gabble:21749): DEBUG: _gabble_roster_create_channel: Instantiating channel 3:1 "publish"
tp_group_mixin_change_flags: emitting group flags changed
  added    : [CAN_REMOVE|MESSAGE_REMOVE|MESSAGE_ACCEPT|PROPERTIES]
  removed  : []
  flags now: [CAN_REMOVE|MESSAGE_REMOVE|MESSAGE_ACCEPT|PROPERTIES]
** (telepathy-gabble:21749): DEBUG: _gabble_roster_create_channel: created /org/freedesktop/Telepathy/Connection/gabble/jabber/beff817f350152acaa47f2174d73f2a946ced204_40jabber_2esugarlabs_2eorg_2fTelepathy/RosterChannel/List/publish
** (telepathy-gabble:21749): DEBUG: _gabble_roster_create_channel: roster not yet received, not emitting signal for publish list channel
** (telepathy-gabble:21749): DEBUG: _gabble_roster_get_channel: Looking up channel 3:2 "subscribe"
** (telepathy-gabble:21749): DEBUG: _gabble_roster_create_channel: Instantiating channel 3:2 "subscribe"
tp_group_mixin_change_flags: emitting group flags changed
  added    : [CAN_ADD|CAN_REMOVE|CAN_RESCIND|MESSAGE_ADD|MESSAGE_REMOVE|MESSAGE_RESCIND|PROPERTIES]
  removed  : []
  flags now: [CAN_ADD|CAN_REMOVE|CAN_RESCIND|MESSAGE_ADD|MESSAGE_REMOVE|MESSAGE_RESCIND|PROPERTIES]
** (telepathy-gabble:21749): DEBUG: _gabble_roster_create_channel: created /org/freedesktop/Telepathy/Connection/gabble/jabber/beff817f350152acaa47f2174d73f2a946ced204_40jabber_2esugarlabs_2eorg_2fTelepathy/RosterChannel/List/subscribe
** (telepathy-gabble:21749): DEBUG: _gabble_roster_create_channel: roster not yet received, not emitting signal for subscribe list channel
** (telepathy-gabble:21749): DEBUG: gabble_normalize_contact: jid gadget.jabber.sugarlabs.org has invalid username or server
** (telepathy-gabble:21749): DEBUG: gabble_roster_iq_cb: item jid is malformed, skipping:
<item jid="gadget.jabber.sugarlabs.org" subscription="both"></item>

** (telepathy-gabble:21749): DEBUG: gabble_roster_iq_cb: calling change members on publish channel
(telepathy-gabble:21749): tp-glib-DEBUG: change_members: not emitting signal, nothing changed
** (telepathy-gabble:21749): DEBUG: gabble_roster_iq_cb: calling change members on subscribe channel
(telepathy-gabble:21749): tp-glib-DEBUG: change_members: not emitting signal, nothing changed
** (telepathy-gabble:21749): DEBUG: _gabble_roster_get_channel: Looking up channel 3:3 "known"
** (telepathy-gabble:21749): DEBUG: _gabble_roster_create_channel: Instantiating channel 3:3 "known"
tp_group_mixin_change_flags: emitting group flags changed
  added    : [CAN_REMOVE|PROPERTIES]
  removed  : []
  flags now: [CAN_REMOVE|PROPERTIES]
** (telepathy-gabble:21749): DEBUG: _gabble_roster_create_channel: created /org/freedesktop/Telepathy/Connection/gabble/jabber/beff817f350152acaa47f2174d73f2a946ced204_40jabber_2esugarlabs_2eorg_2fTelepathy/RosterChannel/List/known
** (telepathy-gabble:21749): DEBUG: _gabble_roster_create_channel: roster not yet received, not emitting signal for known list channel
** (telepathy-gabble:21749): DEBUG: gabble_roster_iq_cb: calling change members on known channel
(telepathy-gabble:21749): tp-glib-DEBUG: change_members: not emitting signal, nothing changed
** (telepathy-gabble:21749): DEBUG: gabble_roster_iq_cb: calling change members on any group channels
** (telepathy-gabble:21749): DEBUG: _gabble_roster_emit_one: roster now received, emitting signal signal for publish list channel
** (telepathy-gabble:21749): DEBUG: _gabble_roster_emit_one: roster now received, emitting signal signal for subscribe list channel
** (telepathy-gabble:21749): DEBUG: _gabble_roster_emit_one: roster now received, emitting signal signal for known list channel
** (telepathy-gabble:21749): DEBUG: _gabble_roster_emit_one: roster now received, emitting signal signal for Friends list channel
(telepathy-gabble:21749): tp-glib-DEBUG: satisfy_request: completing queued request 0x9828ec8 with success, channel_type=org.freedesktop.Telepathy.Channel.Type.ContactList, handle_type=4, handle=1, suppress_handler=1
(telepathy-gabble:21749): tp-glib-DEBUG: channel_request_free: Freeing channel request at 0x9828ec8: ctype=org.freedesktop.Telepathy.Channel.Type.ContactList htype=4 handle=1 suppress=1
** (telepathy-gabble:21749): DEBUG: disco_items_cb: discovered service item: conference.jabber.sugarlabs.org
** (telepathy-gabble:21749): DEBUG: disco_items_cb: discovered service item: gadget.jabber.sugarlabs.org
** (telepathy-gabble:21749): DEBUG: disco_items_cb: discovered service item: irc.jabber.sugarlabs.org
** (telepathy-gabble:21749): DEBUG: disco_items_cb: discovered service item: pubsub.jabber.sugarlabs.org
** (telepathy-gabble:21749): DEBUG: disco_items_cb: discovered service item: vjud.jabber.sugarlabs.org
** (telepathy-gabble:21749): DEBUG: gabble_disco_request_with_timeout: Creating disco request 0x97d1260 for pubsub.jabber.sugarlabs.org
** (telepathy-gabble:21749): DEBUG: gabble_disco_request_with_timeout: Creating disco request 0x97d1280 for irc.jabber.sugarlabs.org
** (telepathy-gabble:21749): DEBUG: gabble_disco_request_with_timeout: Creating disco request 0x97d12a0 for vjud.jabber.sugarlabs.org
** (telepathy-gabble:21749): DEBUG: gabble_disco_request_with_timeout: Creating disco request 0x97d12c0 for conference.jabber.sugarlabs.org
** (telepathy-gabble:21749): DEBUG: gabble_disco_request_with_timeout: Creating disco request 0x97d12e0 for gadget.jabber.sugarlabs.org
(telepathy-gabble:21749): tp-glib-DEBUG: tp_presence_mixin_request_presence: called.
** (telepathy-gabble:21749): DEBUG: gabble_presence_cache_do_update: beff817f350152acaa47f2174d73f2a946ced204@jabber.sugarlabs.org (1) resource Telepathy prio 0 presence 7 message "(null)"
** (telepathy-gabble:21749): DEBUG: _process_caps_uri: not enough trust for URI http://telepathy.freedesktop.org/caps#fL4hzIC3FAqjApGlCg6uHgZturQ=
** (telepathy-gabble:21749): DEBUG: disco_waiter_new: created waiter 0x97d1300 for handle 1 with serial 2
** (telepathy-gabble:21749): 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:21749): DEBUG: gabble_disco_request_with_timeout: Creating disco request 0x97d1320 for beff817f350152acaa47f2174d73f2a946ced204@jabber.sugarlabs.org/Telepathy
** (telepathy-gabble:21749): DEBUG: _process_caps: Emitting caps update: handle 1, old 0, new 0
** (telepathy-gabble:21749): DEBUG: response_cb: got reply for request 0x97d0e20
** (telepathy-gabble:21749): DEBUG: pipeline_reply_cb: called for entry 0x9687648
** (telepathy-gabble:21749): DEBUG: pipeline_reply_cb: will patch vcard
** (telepathy-gabble:21749): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x97d1340
** (telepathy-gabble:21749): DEBUG: observe_vcard: got vCard alias "uwog2" for handle 1 from <NICKNAME>
** (telepathy-gabble:21749): DEBUG: delete_request: Discarding request 0x97d0e00
** (telepathy-gabble:21749): DEBUG: cache_entry_attempt_to_free: Not freeing vCard cache entry 0x9687648: it has a cached vCard 0x9828558
** (telepathy-gabble:21749): DEBUG: delete_item: deleting item 0x97d0e20
** (telepathy-gabble:21749): DEBUG: send_next_request: processing request 0x97d1340
** (telepathy-gabble:21749): DEBUG: connection_iq_disco_cb: got disco request for node http://telepathy.freedesktop.org/caps#eRnpKxqz6IQNnGJzY89+Sxz2UA4=, caps are 22be5
** (telepathy-gabble:21749): DEBUG: connection_iq_disco_cb: caps now 142309
** (telepathy-gabble:21749): DEBUG: item_info_cb: got item identity, jid=pubsub.jabber.sugarlabs.org, name=Publish-Subscribe, category=pubsub, type=service
** (telepathy-gabble:21749): DEBUG: item_info_cb: got item identity, jid=irc.jabber.sugarlabs.org, name=IRC Transport, category=conference, type=irc
** (telepathy-gabble:21749): DEBUG: item_info_cb: got item identity, jid=vjud.jabber.sugarlabs.org, name=vCard User Search, category=directory, type=user
** (telepathy-gabble:21749): DEBUG: item_info_cb: got item identity, jid=conference.jabber.sugarlabs.org, name=Chatrooms, category=conference, type=text
** (telepathy-gabble:21749): DEBUG: connection_iq_disco_cb: got disco request for node http://telepathy.freedesktop.org/caps#fL4hzIC3FAqjApGlCg6uHgZturQ=, caps are 22be5
** (telepathy-gabble:21749): DEBUG: connection_iq_disco_cb: caps now 142309
** (telepathy-gabble:21749): DEBUG: connection_iq_disco_cb: sending disco response:
<iq type="result" to="beff817f350152acaa47f2174d73f2a946ced204@jabber.sugarlabs.org/Telepathy" id="854353867223"> <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:21749): DEBUG: gabble_presence_cache_do_update: beff817f350152acaa47f2174d73f2a946ced204@jabber.sugarlabs.org (1) resource Telepathy prio 0 presence 7 message "(null)"
** (telepathy-gabble:21749): DEBUG: _process_caps_uri: not enough trust for URI http://telepathy.freedesktop.org/caps#fL4hzIC3FAqjApGlCg6uHgZturQ=
** (telepathy-gabble:21749): DEBUG: disco_waiter_new: created waiter 0x97d1360 for handle 1 with serial 3
** (telepathy-gabble:21749): DEBUG: _process_caps: Emitting caps update: handle 1, old 0, new 0
** (telepathy-gabble:21749): DEBUG: connection_iq_unknown_cb: got unknown iq:
<iq id="491675495719" type="error" to="beff817f350152acaa47f2174d73f2a946ced204@jabber.sugarlabs.org/Telepathy" from="beff817f350152acaa47f2174d73f2a946ced204@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:21749): DEBUG: response_cb: got reply for request 0x97d1340
** (telepathy-gabble:21749): DEBUG: replace_reply_cb: called: no error
** (telepathy-gabble:21749): DEBUG: observe_vcard: no change to vCard alias "uwog2" for handle 1
** (telepathy-gabble:21749): DEBUG: gabble_vcard_manager_remove_edit_request: request == 0x9829008
** (telepathy-gabble:21749): DEBUG: delete_item: deleting item 0x97d1340
** (telepathy-gabble:21749): DEBUG: connection_iq_unknown_cb: got unknown iq:
<iq id="854353867223" type="result" to="beff817f350152acaa47f2174d73f2a946ced204@jabber.sugarlabs.org/Telepathy" from="beff817f350152acaa47f2174d73f2a946ced204@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:21749): DEBUG: gabble_normalize_room: invalid room JID gadget.jabber.sugarlabs.org: does not contain '@'
** (telepathy-gabble:21749): DEBUG: gabble_normalize_contact: jid gadget.jabber.sugarlabs.org has invalid username or server
** (telepathy-gabble:21749): DEBUG: gabble_presence_cache_lm_message_cb: ignoring message from malformed jid:
<presence to="beff817f350152acaa47f2174d73f2a946ced204@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:21749): DEBUG: gabble_normalize_contact: jid gadget.jabber.sugarlabs.org has invalid username or server
** (telepathy-gabble:21749): DEBUG: gabble_roster_presence_cb: ignoring presence from malformed jid:
<presence to="beff817f350152acaa47f2174d73f2a946ced204@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:21749): DEBUG: item_info_cb: got item identity, jid=gadget.jabber.sugarlabs.org, name=OLPC Gadget, category=collaboration, type=gadget
** (telepathy-gabble:21749): DEBUG: disco_item_found_cb: buddy gadget discovered
** (telepathy-gabble:21749): DEBUG: disco_item_found_cb: activity gadget discovered
(telepathy-gabble:21749): tp-glib-DEBUG: channel_request_new: New channel request at 0x9687768: ctype=org.laptop.Telepathy.Channel.Type.BuddyView htype=0 handle=0 suppress=1
(telepathy-gabble:21749): tp-glib-DEBUG: satisfy_request: completing queued request 0x9687768 with success, channel_type=org.laptop.Telepathy.Channel.Type.BuddyView, handle_type=0, handle=0, suppress_handler=1
(telepathy-gabble:21749): tp-glib-DEBUG: channel_request_free: Freeing channel request at 0x9687768: ctype=org.laptop.Telepathy.Channel.Type.BuddyView htype=0 handle=0 suppress=1
(telepathy-gabble:21749): tp-glib-DEBUG: channel_request_new: New channel request at 0x9828f90: ctype=org.laptop.Telepathy.Channel.Type.ActivityView htype=0 handle=0 suppress=1
(telepathy-gabble:21749): tp-glib-DEBUG: satisfy_request: completing queued request 0x9828f90 with success, channel_type=org.laptop.Telepathy.Channel.Type.ActivityView, handle_type=0, handle=0, suppress_handler=1
(telepathy-gabble:21749): tp-glib-DEBUG: channel_request_free: Freeing channel request at 0x9828f90: ctype=org.laptop.Telepathy.Channel.Type.ActivityView htype=0 handle=0 suppress=1
** (telepathy-gabble:21749): DEBUG: _caps_disco_cb: disco query failed: Request for info on beff817f350152acaa47f2174d73f2a946ced204@jabber.sugarlabs.org/Telepathy timed out
** (telepathy-gabble:21749): 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:21749): DEBUG: disco_waiter_list_free: list 0x97c9d10
** (telepathy-gabble:21749): DEBUG: disco_waiter_free: freeing waiter 0x97d0f40 for handle 1 with serial 1
** (telepathy-gabble:21749): DEBUG: _caps_disco_cb: disco query failed: Request for info on beff817f350152acaa47f2174d73f2a946ced204@jabber.sugarlabs.org/Telepathy timed out
** (telepathy-gabble:21749): DEBUG: gabble_disco_request_with_timeout: Creating disco request 0x97d1280 for beff817f350152acaa47f2174d73f2a946ced204@jabber.sugarlabs.org/Telepathy
** (telepathy-gabble:21749): DEBUG: _caps_disco_cb: sent a retry disco request to beff817f350152acaa47f2174d73f2a946ced204@jabber.sugarlabs.org/Telepathy for URI http://telepathy.freedesktop.org/caps#fL4hzIC3FAqjApGlCg6uHgZturQ=
** (telepathy-gabble:21749): DEBUG: connection_iq_disco_cb: got disco request for node http://telepathy.freedesktop.org/caps#fL4hzIC3FAqjApGlCg6uHgZturQ=, caps are 22be5
** (telepathy-gabble:21749): DEBUG: connection_iq_disco_cb: caps now 142309
** (telepathy-gabble:21749): DEBUG: connection_iq_disco_cb: sending disco response:
<iq type="result" to="beff817f350152acaa47f2174d73f2a946ced204@jabber.sugarlabs.org/Telepathy" id="855377867642"> <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:21749): DEBUG: connection_iq_unknown_cb: got unknown iq:
<iq id="855377867642" type="result" to="beff817f350152acaa47f2174d73f2a946ced204@jabber.sugarlabs.org/Telepathy" from="beff817f350152acaa47f2174d73f2a946ced204@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:21749): tp-glib-DEBUG: tp_presence_mixin_emit_presence_update: called.
(telepathy-gabble:21749): tp-glib-DEBUG: construct_presence_hash: called.
(telepathy-gabble:21749): tp-glib-DEBUG: construct_simple_presence_hash: called.
** (telepathy-gabble:21749): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x97d0e20
** (telepathy-gabble:21749): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x97d0e00
** (telepathy-gabble:21749): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x96969c0
** (telepathy-gabble:21749): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x96969a0
** (telepathy-gabble:21749): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x97d1320
** (telepathy-gabble:21749): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x97d0f60
** (telepathy-gabble:21749): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x97d0f40
** (telepathy-gabble:21749): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x97d1460
** (telepathy-gabble:21749): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x97d1480
** (telepathy-gabble:21749): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x97d14a0
** (telepathy-gabble:21749): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x97d14c0
** (telepathy-gabble:21749): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x97d14e0
** (telepathy-gabble:21749): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x97d1500
** (telepathy-gabble:21749): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x97d1520
** (telepathy-gabble:21749): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x97d1540
** (telepathy-gabble:21749): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x97d1560
** (telepathy-gabble:21749): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x97d1580
** (telepathy-gabble:21749): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x97d15a0
** (telepathy-gabble:21749): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x97d15c0
** (telepathy-gabble:21749): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x9828000
** (telepathy-gabble:21749): DEBUG: send_next_request: processing request 0x97d0e20
** (telepathy-gabble:21749): DEBUG: send_next_request: processing request 0x97d0e00
** (telepathy-gabble:21749): DEBUG: send_next_request: processing request 0x96969c0
** (telepathy-gabble:21749): DEBUG: send_next_request: processing request 0x96969a0
** (telepathy-gabble:21749): DEBUG: send_next_request: processing request 0x97d1320
** (telepathy-gabble:21749): DEBUG: response_cb: got reply for request 0x97d0e20
** (telepathy-gabble:21749): DEBUG: aliases_request_cache_pep: Error getting alias from PEP:
<iq type="error" id="622667635496" to="beff817f350152acaa47f2174d73f2a946ced204@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:21749): DEBUG: aliases_request_pep_cb: Got cached alias 194e49fe8344cd6c53d28f9d70a225cb20f04a91 with priority 1
** (telepathy-gabble:21749): DEBUG: gabble_vcard_manager_request: Created request 0x9828020 to retrieve <2>'s vCard
** (telepathy-gabble:21749): DEBUG: cache_entry_ensure_queued: Cache entry 0x9829050 is not mine, @to = 194e49fe8344cd6c53d28f9d70a225cb20f04a91@jabber.sugarlabs.org
** (telepathy-gabble:21749): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x9828040
** (telepathy-gabble:21749): DEBUG: cache_entry_ensure_queued: adding request to cache entry 0x9829050 and queueing the <iq>
** (telepathy-gabble:21749): DEBUG: delete_item: deleting item 0x97d0e20
** (telepathy-gabble:21749): DEBUG: send_next_request: processing request 0x97d0f60
** (telepathy-gabble:21749): DEBUG: response_cb: got reply for request 0x97d0e00
** (telepathy-gabble:21749): DEBUG: aliases_request_cache_pep: Error getting alias from PEP:
<iq type="error" id="622813635633" to="beff817f350152acaa47f2174d73f2a946ced204@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:21749): DEBUG: aliases_request_pep_cb: Got cached alias 515e4a6d097a34d3483d72fd4fb290be06b37c8c with priority 1
** (telepathy-gabble:21749): DEBUG: gabble_vcard_manager_request: Created request 0x9828060 to retrieve <3>'s vCard
** (telepathy-gabble:21749): DEBUG: cache_entry_ensure_queued: Cache entry 0x98290c8 is not mine, @to = 515e4a6d097a34d3483d72fd4fb290be06b37c8c@jabber.sugarlabs.org
** (telepathy-gabble:21749): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x9828080
** (telepathy-gabble:21749): DEBUG: cache_entry_ensure_queued: adding request to cache entry 0x98290c8 and queueing the <iq>
** (telepathy-gabble:21749): DEBUG: delete_item: deleting item 0x97d0e00
** (telepathy-gabble:21749): DEBUG: send_next_request: processing request 0x97d0f40
** (telepathy-gabble:21749): DEBUG: response_cb: got reply for request 0x96969c0
** (telepathy-gabble:21749): DEBUG: aliases_request_cache_pep: Error getting alias from PEP:
<iq type="error" id="622942635679" to="beff817f350152acaa47f2174d73f2a946ced204@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:21749): DEBUG: aliases_request_pep_cb: Got cached alias daca347bc76f17834b2cb216e5abca31a3472471 with priority 1
** (telepathy-gabble:21749): DEBUG: gabble_vcard_manager_request: Created request 0x98280a0 to retrieve <4>'s vCard
** (telepathy-gabble:21749): DEBUG: cache_entry_ensure_queued: Cache entry 0x9828ec8 is not mine, @to = daca347bc76f17834b2cb216e5abca31a3472471@jabber.sugarlabs.org
** (telepathy-gabble:21749): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x98280c0
** (telepathy-gabble:21749): DEBUG: cache_entry_ensure_queued: adding request to cache entry 0x9828ec8 and queueing the <iq>
** (telepathy-gabble:21749): DEBUG: delete_item: deleting item 0x96969c0
** (telepathy-gabble:21749): DEBUG: send_next_request: processing request 0x97d1460
** (telepathy-gabble:21749): DEBUG: response_cb: got reply for request 0x96969a0
** (telepathy-gabble:21749): DEBUG: aliases_request_cache_pep: Error getting alias from PEP:
<iq type="error" id="622927635725" to="beff817f350152acaa47f2174d73f2a946ced204@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:21749): DEBUG: aliases_request_pep_cb: Got cached alias ae6da8eda397b06dc101737322b9f7954eb98837 with priority 1
** (telepathy-gabble:21749): DEBUG: gabble_vcard_manager_request: Created request 0x98280e0 to retrieve <5>'s vCard
** (telepathy-gabble:21749): DEBUG: cache_entry_ensure_queued: Cache entry 0x9828dc0 is not mine, @to = ae6da8eda397b06dc101737322b9f7954eb98837@jabber.sugarlabs.org
** (telepathy-gabble:21749): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x9828100
** (telepathy-gabble:21749): DEBUG: cache_entry_ensure_queued: adding request to cache entry 0x9828dc0 and queueing the <iq>
** (telepathy-gabble:21749): DEBUG: delete_item: deleting item 0x96969a0
** (telepathy-gabble:21749): DEBUG: send_next_request: processing request 0x97d1480
** (telepathy-gabble:21749): DEBUG: response_cb: got reply for request 0x97d1320
** (telepathy-gabble:21749): DEBUG: aliases_request_cache_pep: Error getting alias from PEP:
<iq type="error" id="622944635769" to="beff817f350152acaa47f2174d73f2a946ced204@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:21749): DEBUG: aliases_request_pep_cb: Got cached alias 99d9825f896b3b9a0cac9567e8ea2b60838f6eb5 with priority 1
** (telepathy-gabble:21749): DEBUG: gabble_vcard_manager_request: Created request 0x9828120 to retrieve <6>'s vCard
** (telepathy-gabble:21749): DEBUG: cache_entry_ensure_queued: Cache entry 0x9828e98 is not mine, @to = 99d9825f896b3b9a0cac9567e8ea2b60838f6eb5@jabber.sugarlabs.org
** (telepathy-gabble:21749): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x9828140
** (telepathy-gabble:21749): DEBUG: cache_entry_ensure_queued: adding request to cache entry 0x9828e98 and queueing the <iq>
** (telepathy-gabble:21749): DEBUG: delete_item: deleting item 0x97d1320
** (telepathy-gabble:21749): DEBUG: send_next_request: processing request 0x97d14a0
** (telepathy-gabble:21749): DEBUG: response_cb: got reply for request 0x97d0f60
** (telepathy-gabble:21749): DEBUG: aliases_request_cache_pep: Error getting alias from PEP:
<iq type="error" id="623056635814" to="beff817f350152acaa47f2174d73f2a946ced204@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:21749): DEBUG: aliases_request_pep_cb: Got cached alias f2590cda9e125cba49ef690bce1dfb57176803b7 with priority 1
** (telepathy-gabble:21749): DEBUG: gabble_vcard_manager_request: Created request 0x9828160 to retrieve <7>'s vCard
** (telepathy-gabble:21749): DEBUG: cache_entry_ensure_queued: Cache entry 0x9828f48 is not mine, @to = f2590cda9e125cba49ef690bce1dfb57176803b7@jabber.sugarlabs.org
** (telepathy-gabble:21749): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x9828180
** (telepathy-gabble:21749): DEBUG: cache_entry_ensure_queued: adding request to cache entry 0x9828f48 and queueing the <iq>
** (telepathy-gabble:21749): DEBUG: delete_item: deleting item 0x97d0f60
** (telepathy-gabble:21749): DEBUG: send_next_request: processing request 0x97d14c0
** (telepathy-gabble:21749): DEBUG: response_cb: got reply for request 0x97d0f40
** (telepathy-gabble:21749): DEBUG: aliases_request_cache_pep: Error getting alias from PEP:
<iq type="error" id="623074635859" to="beff817f350152acaa47f2174d73f2a946ced204@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:21749): DEBUG: aliases_request_pep_cb: Got cached alias 997bc415bec0566fd38c87ea7934e0020c638a65 with priority 1
** (telepathy-gabble:21749): DEBUG: gabble_vcard_manager_request: Created request 0x98281a0 to retrieve <8>'s vCard
** (telepathy-gabble:21749): DEBUG: cache_entry_ensure_queued: Cache entry 0x9828f18 is not mine, @to = 997bc415bec0566fd38c87ea7934e0020c638a65@jabber.sugarlabs.org
** (telepathy-gabble:21749): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x98281c0
** (telepathy-gabble:21749): DEBUG: cache_entry_ensure_queued: adding request to cache entry 0x9828f18 and queueing the <iq>
** (telepathy-gabble:21749): DEBUG: delete_item: deleting item 0x97d0f40
** (telepathy-gabble:21749): DEBUG: send_next_request: processing request 0x97d14e0
** (telepathy-gabble:21749): DEBUG: response_cb: got reply for request 0x97d1460
** (telepathy-gabble:21749): DEBUG: aliases_request_cache_pep: Error getting alias from PEP:
<iq type="error" id="623074635902" to="beff817f350152acaa47f2174d73f2a946ced204@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:21749): DEBUG: aliases_request_pep_cb: Got cached alias 602a20ca705b4b94320bdfa7bfbec47dedea2a82 with priority 1
** (telepathy-gabble:21749): DEBUG: gabble_vcard_manager_request: Created request 0x983dc00 to retrieve <9>'s vCard
** (telepathy-gabble:21749): DEBUG: cache_entry_ensure_queued: Cache entry 0x9828f00 is not mine, @to = 602a20ca705b4b94320bdfa7bfbec47dedea2a82@jabber.sugarlabs.org
** (telepathy-gabble:21749): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x983dc20
** (telepathy-gabble:21749): DEBUG: cache_entry_ensure_queued: adding request to cache entry 0x9828f00 and queueing the <iq>
** (telepathy-gabble:21749): DEBUG: delete_item: deleting item 0x97d1460
** (telepathy-gabble:21749): DEBUG: send_next_request: processing request 0x97d1500
** (telepathy-gabble:21749): DEBUG: response_cb: got reply for request 0x97d1480
** (telepathy-gabble:21749): DEBUG: aliases_request_cache_pep: Error getting alias from PEP:
<iq type="error" id="623716635953" to="beff817f350152acaa47f2174d73f2a946ced204@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:21749): DEBUG: aliases_request_pep_cb: Got cached alias b90a48b21766fadeade57c7e070a6c5cff28ba80 with priority 1
** (telepathy-gabble:21749): DEBUG: gabble_vcard_manager_request: Created request 0x983dc40 to retrieve <10>'s vCard
** (telepathy-gabble:21749): DEBUG: cache_entry_ensure_queued: Cache entry 0x9829148 is not mine, @to = b90a48b21766fadeade57c7e070a6c5cff28ba80@jabber.sugarlabs.org
** (telepathy-gabble:21749): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x983dc60
** (telepathy-gabble:21749): DEBUG: cache_entry_ensure_queued: adding request to cache entry 0x9829148 and queueing the <iq>
** (telepathy-gabble:21749): DEBUG: delete_item: deleting item 0x97d1480
** (telepathy-gabble:21749): DEBUG: send_next_request: processing request 0x97d1520
** (telepathy-gabble:21749): DEBUG: response_cb: got reply for request 0x97d14a0
** (telepathy-gabble:21749): DEBUG: aliases_request_cache_pep: Error getting alias from PEP:
<iq type="error" id="623700636012" to="beff817f350152acaa47f2174d73f2a946ced204@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:21749): DEBUG: aliases_request_pep_cb: Got cached alias d8b6cce2d6335b39e9f0541e5302f3c46d38ee46 with priority 1
** (telepathy-gabble:21749): DEBUG: gabble_vcard_manager_request: Created request 0x983dc80 to retrieve <11>'s vCard
** (telepathy-gabble:21749): DEBUG: cache_entry_ensure_queued: Cache entry 0x9829178 is not mine, @to = d8b6cce2d6335b39e9f0541e5302f3c46d38ee46@jabber.sugarlabs.org
** (telepathy-gabble:21749): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x983dca0
** (telepathy-gabble:21749): DEBUG: cache_entry_ensure_queued: adding request to cache entry 0x9829178 and queueing the <iq>
** (telepathy-gabble:21749): DEBUG: delete_item: deleting item 0x97d14a0
** (telepathy-gabble:21749): DEBUG: send_next_request: processing request 0x97d1540
** (telepathy-gabble:21749): DEBUG: response_cb: got reply for request 0x97d14c0
** (telepathy-gabble:21749): DEBUG: aliases_request_cache_pep: Error getting alias from PEP:
<iq type="error" id="623846636057" to="beff817f350152acaa47f2174d73f2a946ced204@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:21749): DEBUG: aliases_request_pep_cb: Got cached alias dcf4a68574e2281fc0446c2cc8ace9baa5dcf4bd with priority 1
** (telepathy-gabble:21749): DEBUG: gabble_vcard_manager_request: Created request 0x983dcc0 to retrieve <12>'s vCard
** (telepathy-gabble:21749): DEBUG: cache_entry_ensure_queued: Cache entry 0x9829238 is not mine, @to = dcf4a68574e2281fc0446c2cc8ace9baa5dcf4bd@jabber.sugarlabs.org
** (telepathy-gabble:21749): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x983dce0
** (telepathy-gabble:21749): DEBUG: cache_entry_ensure_queued: adding request to cache entry 0x9829238 and queueing the <iq>
** (telepathy-gabble:21749): DEBUG: delete_item: deleting item 0x97d14c0
** (telepathy-gabble:21749): DEBUG: send_next_request: processing request 0x97d1560
** (telepathy-gabble:21749): DEBUG: response_cb: got reply for request 0x97d14e0
** (telepathy-gabble:21749): DEBUG: aliases_request_cache_pep: Error getting alias from PEP:
<iq type="error" id="623830636100" to="beff817f350152acaa47f2174d73f2a946ced204@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:21749): DEBUG: aliases_request_pep_cb: Got cached alias ec72d62d7f844272bffd427913b3128eec781ef3 with priority 1
** (telepathy-gabble:21749): DEBUG: gabble_vcard_manager_request: Created request 0x983dd00 to retrieve <13>'s vCard
** (telepathy-gabble:21749): DEBUG: cache_entry_ensure_queued: Cache entry 0x98291a8 is not mine, @to = ec72d62d7f844272bffd427913b3128eec781ef3@jabber.sugarlabs.org
** (telepathy-gabble:21749): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x983dd20
** (telepathy-gabble:21749): DEBUG: cache_entry_ensure_queued: adding request to cache entry 0x98291a8 and queueing the <iq>
** (telepathy-gabble:21749): DEBUG: delete_item: deleting item 0x97d14e0
** (telepathy-gabble:21749): DEBUG: send_next_request: processing request 0x97d1580
** (telepathy-gabble:21749): DEBUG: response_cb: got reply for request 0x97d1500
** (telepathy-gabble:21749): DEBUG: aliases_request_cache_pep: Error getting alias from PEP:
<iq type="error" id="623847636144" to="beff817f350152acaa47f2174d73f2a946ced204@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:21749): DEBUG: aliases_request_pep_cb: Got cached alias fe527670d7ad82d4503b4b231c4350e8f793b57f with priority 1
** (telepathy-gabble:21749): DEBUG: gabble_vcard_manager_request: Created request 0x983dd40 to retrieve <14>'s vCard
** (telepathy-gabble:21749): DEBUG: cache_entry_ensure_queued: Cache entry 0x9687798 is not mine, @to = fe527670d7ad82d4503b4b231c4350e8f793b57f@jabber.sugarlabs.org
** (telepathy-gabble:21749): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x983dd60
** (telepathy-gabble:21749): DEBUG: cache_entry_ensure_queued: adding request to cache entry 0x9687798 and queueing the <iq>
** (telepathy-gabble:21749): DEBUG: delete_item: deleting item 0x97d1500
** (telepathy-gabble:21749): DEBUG: send_next_request: processing request 0x97d15a0
** (telepathy-gabble:21749): DEBUG: response_cb: got reply for request 0x97d1520
** (telepathy-gabble:21749): DEBUG: aliases_request_cache_pep: Error getting alias from PEP:
<iq type="error" id="623976636188" to="beff817f350152acaa47f2174d73f2a946ced204@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:21749): DEBUG: aliases_request_pep_cb: Got cached alias 6608159f3d2c008dc3b541bb63e45964ac9dccff with priority 1
** (telepathy-gabble:21749): DEBUG: gabble_vcard_manager_request: Created request 0x983dd80 to retrieve <15>'s vCard
** (telepathy-gabble:21749): DEBUG: cache_entry_ensure_queued: Cache entry 0x9829220 is not mine, @to = 6608159f3d2c008dc3b541bb63e45964ac9dccff@jabber.sugarlabs.org
** (telepathy-gabble:21749): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x983dda0
** (telepathy-gabble:21749): DEBUG: cache_entry_ensure_queued: adding request to cache entry 0x9829220 and queueing the <iq>
** (telepathy-gabble:21749): DEBUG: delete_item: deleting item 0x97d1520
** (telepathy-gabble:21749): DEBUG: send_next_request: processing request 0x97d15c0
** (telepathy-gabble:21749): DEBUG: response_cb: got reply for request 0x97d1540
** (telepathy-gabble:21749): DEBUG: aliases_request_cache_pep: Error getting alias from PEP:
<iq type="error" id="623962636233" to="beff817f350152acaa47f2174d73f2a946ced204@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:21749): DEBUG: aliases_request_pep_cb: Got cached alias e0d2c7e034c25383d885625d7c9697ccfdbe313a with priority 1
** (telepathy-gabble:21749): DEBUG: gabble_vcard_manager_request: Created request 0x983ddc0 to retrieve <16>'s vCard
** (telepathy-gabble:21749): DEBUG: cache_entry_ensure_queued: Cache entry 0x9828fa8 is not mine, @to = e0d2c7e034c25383d885625d7c9697ccfdbe313a@jabber.sugarlabs.org
** (telepathy-gabble:21749): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x9832200
** (telepathy-gabble:21749): DEBUG: cache_entry_ensure_queued: adding request to cache entry 0x9828fa8 and queueing the <iq>
** (telepathy-gabble:21749): DEBUG: delete_item: deleting item 0x97d1540
** (telepathy-gabble:21749): DEBUG: send_next_request: processing request 0x9828000
** (telepathy-gabble:21749): DEBUG: response_cb: got reply for request 0x97d1560
** (telepathy-gabble:21749): DEBUG: aliases_request_cache_pep: Error getting alias from PEP:
<iq type="error" id="623978636276" to="beff817f350152acaa47f2174d73f2a946ced204@jabber.sugarlabs.org/Telepathy" from="25aabee27fed34446d30e2a0c16764ee02a3a81e@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:21749): DEBUG: aliases_request_pep_cb: Got cached alias 25aabee27fed34446d30e2a0c16764ee02a3a81e with priority 1
** (telepathy-gabble:21749): DEBUG: gabble_vcard_manager_request: Created request 0x9832220 to retrieve <17>'s vCard
** (telepathy-gabble:21749): DEBUG: cache_entry_ensure_queued: Cache entry 0x9828f78 is not mine, @to = 25aabee27fed34446d30e2a0c16764ee02a3a81e@jabber.sugarlabs.org
** (telepathy-gabble:21749): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x9832240
** (telepathy-gabble:21749): DEBUG: cache_entry_ensure_queued: adding request to cache entry 0x9828f78 and queueing the <iq>
** (telepathy-gabble:21749): DEBUG: delete_item: deleting item 0x97d1560
** (telepathy-gabble:21749): DEBUG: send_next_request: processing request 0x9828040
** (telepathy-gabble:21749): DEBUG: response_cb: got reply for request 0x97d1580
** (telepathy-gabble:21749): DEBUG: aliases_request_cache_pep: Error getting alias from PEP:
<iq type="error" id="624091636320" to="beff817f350152acaa47f2174d73f2a946ced204@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:21749): DEBUG: aliases_request_pep_cb: Got cached alias ca4568a8217760a14b12b848a90af493fb05ac5a with priority 1
** (telepathy-gabble:21749): DEBUG: gabble_vcard_manager_request: Created request 0x9832260 to retrieve <18>'s vCard
** (telepathy-gabble:21749): DEBUG: cache_entry_ensure_queued: Cache entry 0x9828e80 is not mine, @to = ca4568a8217760a14b12b848a90af493fb05ac5a@jabber.sugarlabs.org
** (telepathy-gabble:21749): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x9832280
** (telepathy-gabble:21749): DEBUG: cache_entry_ensure_queued: adding request to cache entry 0x9828e80 and queueing the <iq>
** (telepathy-gabble:21749): DEBUG: delete_item: deleting item 0x97d1580
** (telepathy-gabble:21749): DEBUG: send_next_request: processing request 0x9828080
** (telepathy-gabble:21749): DEBUG: response_cb: got reply for request 0x97d15a0
** (telepathy-gabble:21749): DEBUG: aliases_request_cache_pep: Error getting alias from PEP:
<iq type="error" id="624092636364" to="beff817f350152acaa47f2174d73f2a946ced204@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:21749): DEBUG: aliases_request_pep_cb: Got cached alias b2ae1310b921ca77355499c0fda7085d7cac7ab5 with priority 1
** (telepathy-gabble:21749): DEBUG: gabble_vcard_manager_request: Created request 0x98322a0 to retrieve <19>'s vCard
** (telepathy-gabble:21749): DEBUG: cache_entry_ensure_queued: Cache entry 0x9828f30 is not mine, @to = b2ae1310b921ca77355499c0fda7085d7cac7ab5@jabber.sugarlabs.org
** (telepathy-gabble:21749): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x98322c0
** (telepathy-gabble:21749): DEBUG: cache_entry_ensure_queued: adding request to cache entry 0x9828f30 and queueing the <iq>
** (telepathy-gabble:21749): DEBUG: delete_item: deleting item 0x97d15a0
** (telepathy-gabble:21749): DEBUG: send_next_request: processing request 0x98280c0
** (telepathy-gabble:21749): DEBUG: response_cb: got reply for request 0x97d15c0
** (telepathy-gabble:21749): DEBUG: aliases_request_cache_pep: Error getting alias from PEP:
<iq type="error" id="624109636408" to="beff817f350152acaa47f2174d73f2a946ced204@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:21749): DEBUG: aliases_request_pep_cb: Got cached alias 422be991b7dbcc39c58ad24fb46c309ee08267cb with priority 1
** (telepathy-gabble:21749): DEBUG: gabble_vcard_manager_request: Created request 0x98322e0 to retrieve <20>'s vCard
** (telepathy-gabble:21749): DEBUG: cache_entry_ensure_queued: Cache entry 0x9687738 is not mine, @to = 422be991b7dbcc39c58ad24fb46c309ee08267cb@jabber.sugarlabs.org
** (telepathy-gabble:21749): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x9832300
** (telepathy-gabble:21749): DEBUG: cache_entry_ensure_queued: adding request to cache entry 0x9687738 and queueing the <iq>
** (telepathy-gabble:21749): DEBUG: delete_item: deleting item 0x97d15c0
** (telepathy-gabble:21749): DEBUG: send_next_request: processing request 0x9828100
** (telepathy-gabble:21749): DEBUG: response_cb: got reply for request 0x9828000
** (telepathy-gabble:21749): DEBUG: aliases_request_cache_pep: Error getting alias from PEP:
<iq type="error" id="623710636452" to="beff817f350152acaa47f2174d73f2a946ced204@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:21749): DEBUG: aliases_request_pep_cb: Got cached alias 261292d4666efd9964a4ce0af24ebc68441d5373 with priority 1
** (telepathy-gabble:21749): DEBUG: gabble_vcard_manager_request: Created request 0x97d15c0 to retrieve <21>'s vCard
** (telepathy-gabble:21749): DEBUG: cache_entry_ensure_queued: Cache entry 0x9829208 is not mine, @to = 261292d4666efd9964a4ce0af24ebc68441d5373@jabber.sugarlabs.org
** (telepathy-gabble:21749): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x97d15a0
** (telepathy-gabble:21749): DEBUG: cache_entry_ensure_queued: adding request to cache entry 0x9829208 and queueing the <iq>
** (telepathy-gabble:21749): DEBUG: delete_item: deleting item 0x9828000
** (telepathy-gabble:21749): DEBUG: send_next_request: processing request 0x9828140
** (telepathy-gabble:21749): DEBUG: response_cb: got reply for request 0x9828040
** (telepathy-gabble:21749): DEBUG: pipeline_reply_cb: called for entry 0x9829050
** (telepathy-gabble:21749): DEBUG: observe_vcard: got vCard alias "erich" for handle 2 from <NICKNAME>
** (telepathy-gabble:21749): DEBUG: delete_request: Discarding request 0x9828020
** (telepathy-gabble:21749): DEBUG: cache_entry_attempt_to_free: Not freeing vCard cache entry 0x9829050: it has a cached vCard 0x97d36f8
** (telepathy-gabble:21749): DEBUG: delete_item: deleting item 0x9828040
** (telepathy-gabble:21749): DEBUG: send_next_request: processing request 0x9828180
** (telepathy-gabble:21749): DEBUG: response_cb: got reply for request 0x9828080
** (telepathy-gabble:21749): DEBUG: pipeline_reply_cb: called for entry 0x98290c8
** (telepathy-gabble:21749): DEBUG: observe_vcard: got vCard alias "benzea" for handle 3 from <NICKNAME>
** (telepathy-gabble:21749): DEBUG: delete_request: Discarding request 0x9828060
** (telepathy-gabble:21749): DEBUG: cache_entry_attempt_to_free: Not freeing vCard cache entry 0x98290c8: it has a cached vCard 0x983cb00
** (telepathy-gabble:21749): DEBUG: delete_item: deleting item 0x9828080
** (telepathy-gabble:21749): DEBUG: send_next_request: processing request 0x98281c0
** (telepathy-gabble:21749): DEBUG: response_cb: got reply for request 0x98280c0
** (telepathy-gabble:21749): DEBUG: pipeline_reply_cb: called for entry 0x9828ec8
** (telepathy-gabble:21749): DEBUG: observe_vcard: got vCard alias "satellit_SD" for handle 4 from <NICKNAME>
** (telepathy-gabble:21749): DEBUG: delete_request: Discarding request 0x98280a0
** (telepathy-gabble:21749): DEBUG: cache_entry_attempt_to_free: Not freeing vCard cache entry 0x9828ec8: it has a cached vCard 0x9828898
** (telepathy-gabble:21749): DEBUG: delete_item: deleting item 0x98280c0
** (telepathy-gabble:21749): DEBUG: send_next_request: processing request 0x983dc20
** (telepathy-gabble:21749): DEBUG: response_cb: got reply for request 0x9828100
** (telepathy-gabble:21749): DEBUG: pipeline_reply_cb: called for entry 0x9828dc0
** (telepathy-gabble:21749): DEBUG: observe_vcard: got vCard alias "donghee" for handle 5 from <NICKNAME>
** (telepathy-gabble:21749): DEBUG: delete_request: Discarding request 0x98280e0
** (telepathy-gabble:21749): DEBUG: cache_entry_attempt_to_free: Not freeing vCard cache entry 0x9828dc0: it has a cached vCard 0x98263b8
** (telepathy-gabble:21749): DEBUG: delete_item: deleting item 0x9828100
** (telepathy-gabble:21749): DEBUG: send_next_request: processing request 0x983dc60
** (telepathy-gabble:21749): DEBUG: response_cb: got reply for request 0x9828140
** (telepathy-gabble:21749): DEBUG: pipeline_reply_cb: called for entry 0x9828e98
** (telepathy-gabble:21749): DEBUG: observe_vcard: got vCard alias "Epson" for handle 6 from <NICKNAME>
** (telepathy-gabble:21749): DEBUG: delete_request: Discarding request 0x9828120
** (telepathy-gabble:21749): DEBUG: cache_entry_attempt_to_free: Not freeing vCard cache entry 0x9828e98: it has a cached vCard 0x9834f00
** (telepathy-gabble:21749): DEBUG: delete_item: deleting item 0x9828140
** (telepathy-gabble:21749): DEBUG: send_next_request: processing request 0x983dca0
** (telepathy-gabble:21749): DEBUG: response_cb: got reply for request 0x9828180
** (telepathy-gabble:21749): DEBUG: pipeline_reply_cb: called for entry 0x9828f48
** (telepathy-gabble:21749): DEBUG: observe_vcard: got vCard alias "kushal" for handle 7 from <NICKNAME>
** (telepathy-gabble:21749): DEBUG: delete_request: Discarding request 0x9828160
** (telepathy-gabble:21749): DEBUG: cache_entry_attempt_to_free: Not freeing vCard cache entry 0x9828f48: it has a cached vCard 0x98282e0
** (telepathy-gabble:21749): DEBUG: delete_item: deleting item 0x9828180
** (telepathy-gabble:21749): DEBUG: send_next_request: processing request 0x983dce0
** (telepathy-gabble:21749): DEBUG: response_cb: got reply for request 0x98281c0
** (telepathy-gabble:21749): DEBUG: pipeline_reply_cb: called for entry 0x9828f18
** (telepathy-gabble:21749): DEBUG: observe_vcard: got vCard alias "Caroline VM on iMac" for handle 8 from <NICKNAME>
** (telepathy-gabble:21749): DEBUG: delete_request: Discarding request 0x98281a0
** (telepathy-gabble:21749): DEBUG: cache_entry_attempt_to_free: Not freeing vCard cache entry 0x9828f18: it has a cached vCard 0x9829b60
** (telepathy-gabble:21749): DEBUG: delete_item: deleting item 0x98281c0
** (telepathy-gabble:21749): DEBUG: send_next_request: processing request 0x983dd20
** (telepathy-gabble:21749): DEBUG: response_cb: got reply for request 0x983dc20
** (telepathy-gabble:21749): DEBUG: pipeline_reply_cb: called for entry 0x9828f00
** (telepathy-gabble:21749): DEBUG: observe_vcard: got vCard alias "carl" for handle 9 from <NICKNAME>
** (telepathy-gabble:21749): DEBUG: delete_request: Discarding request 0x983dc00
** (telepathy-gabble:21749): DEBUG: cache_entry_attempt_to_free: Not freeing vCard cache entry 0x9828f00: it has a cached vCard 0x98253c0
** (telepathy-gabble:21749): DEBUG: delete_item: deleting item 0x983dc20
** (telepathy-gabble:21749): DEBUG: send_next_request: processing request 0x983dd60
** (telepathy-gabble:21749): DEBUG: response_cb: got reply for request 0x983dc60
** (telepathy-gabble:21749): DEBUG: pipeline_reply_cb: called for entry 0x9829148
** (telepathy-gabble:21749): DEBUG: observe_vcard: got vCard alias "schampijer" for handle 10 from <NICKNAME>
** (telepathy-gabble:21749): DEBUG: delete_request: Discarding request 0x983dc40
** (telepathy-gabble:21749): DEBUG: cache_entry_attempt_to_free: Not freeing vCard cache entry 0x9829148: it has a cached vCard 0x98283e8
** (telepathy-gabble:21749): DEBUG: delete_item: deleting item 0x983dc60
** (telepathy-gabble:21749): DEBUG: send_next_request: processing request 0x983dda0
** (telepathy-gabble:21749): DEBUG: response_cb: got reply for request 0x983dca0
** (telepathy-gabble:21749): DEBUG: pipeline_reply_cb: called for entry 0x9829178
** (telepathy-gabble:21749): DEBUG: observe_vcard: got vCard alias "tomeu?" for handle 11 from <NICKNAME>
** (telepathy-gabble:21749): DEBUG: delete_request: Discarding request 0x983dc80
** (telepathy-gabble:21749): DEBUG: cache_entry_attempt_to_free: Not freeing vCard cache entry 0x9829178: it has a cached vCard 0x9828988
** (telepathy-gabble:21749): DEBUG: delete_item: deleting item 0x983dca0
** (telepathy-gabble:21749): DEBUG: send_next_request: processing request 0x9832200
** (telepathy-gabble:21749): DEBUG: response_cb: got reply for request 0x983dce0
** (telepathy-gabble:21749): DEBUG: pipeline_reply_cb: called for entry 0x9829238
** (telepathy-gabble:21749): DEBUG: observe_vcard: got vCard alias "kushal" for handle 12 from <NICKNAME>
** (telepathy-gabble:21749): DEBUG: delete_request: Discarding request 0x983dcc0
** (telepathy-gabble:21749): DEBUG: cache_entry_attempt_to_free: Not freeing vCard cache entry 0x9829238: it has a cached vCard 0x982d8e0
** (telepathy-gabble:21749): DEBUG: delete_item: deleting item 0x983dce0
** (telepathy-gabble:21749): DEBUG: send_next_request: processing request 0x9832240
** (telepathy-gabble:21749): DEBUG: response_cb: got reply for request 0x983dd20
** (telepathy-gabble:21749): DEBUG: pipeline_reply_cb: called for entry 0x98291a8
** (telepathy-gabble:21749): DEBUG: observe_vcard: got vCard alias "anders" for handle 13 from <NICKNAME>
** (telepathy-gabble:21749): DEBUG: delete_request: Discarding request 0x983dd00
** (telepathy-gabble:21749): DEBUG: cache_entry_attempt_to_free: Not freeing vCard cache entry 0x98291a8: it has a cached vCard 0x9823b78
** (telepathy-gabble:21749): DEBUG: delete_item: deleting item 0x983dd20
** (telepathy-gabble:21749): DEBUG: send_next_request: processing request 0x9832280
** (telepathy-gabble:21749): DEBUG: response_cb: got reply for request 0x983dd60
** (telepathy-gabble:21749): DEBUG: pipeline_reply_cb: called for entry 0x9687798
** (telepathy-gabble:21749): DEBUG: observe_vcard: got vCard alias "Rachael" for handle 14 from <NICKNAME>
** (telepathy-gabble:21749): DEBUG: delete_request: Discarding request 0x983dd40
** (telepathy-gabble:21749): DEBUG: cache_entry_attempt_to_free: Not freeing vCard cache entry 0x9687798: it has a cached vCard 0x982f258
** (telepathy-gabble:21749): DEBUG: delete_item: deleting item 0x983dd60
** (telepathy-gabble:21749): DEBUG: send_next_request: processing request 0x98322c0
** (telepathy-gabble:21749): DEBUG: response_cb: got reply for request 0x983dda0
** (telepathy-gabble:21749): DEBUG: pipeline_reply_cb: called for entry 0x9829220
** (telepathy-gabble:21749): DEBUG: observe_vcard: got vCard alias "rab" for handle 15 from <NICKNAME>
** (telepathy-gabble:21749): DEBUG: delete_request: Discarding request 0x983dd80
** (telepathy-gabble:21749): DEBUG: cache_entry_attempt_to_free: Not freeing vCard cache entry 0x9829220: it has a cached vCard 0x9823ba0
** (telepathy-gabble:21749): DEBUG: delete_item: deleting item 0x983dda0
** (telepathy-gabble:21749): DEBUG: send_next_request: processing request 0x9832300
** (telepathy-gabble:21749): DEBUG: response_cb: got reply for request 0x9832200
** (telepathy-gabble:21749): DEBUG: pipeline_reply_cb: called for entry 0x9828fa8
** (telepathy-gabble:21749): DEBUG: observe_vcard: got vCard alias "name" for handle 16 from <NICKNAME>
** (telepathy-gabble:21749): DEBUG: delete_request: Discarding request 0x983ddc0
** (telepathy-gabble:21749): DEBUG: cache_entry_attempt_to_free: Not freeing vCard cache entry 0x9828fa8: it has a cached vCard 0x9697220
** (telepathy-gabble:21749): DEBUG: delete_item: deleting item 0x9832200
** (telepathy-gabble:21749): DEBUG: send_next_request: processing request 0x97d15a0
** (telepathy-gabble:21749): DEBUG: response_cb: got reply for request 0x9832240
** (telepathy-gabble:21749): DEBUG: pipeline_reply_cb: called for entry 0x9828f78
** (telepathy-gabble:21749): DEBUG: observe_vcard: got vCard alias "uwog" for handle 17 from <NICKNAME>
** (telepathy-gabble:21749): DEBUG: delete_request: Discarding request 0x9832220
** (telepathy-gabble:21749): DEBUG: cache_entry_attempt_to_free: Not freeing vCard cache entry 0x9828f78: it has a cached vCard 0x9826408
** (telepathy-gabble:21749): DEBUG: delete_item: deleting item 0x9832240
** (telepathy-gabble:21749): DEBUG: response_cb: got reply for request 0x9832280
** (telepathy-gabble:21749): DEBUG: pipeline_reply_cb: called for entry 0x9828e80
** (telepathy-gabble:21749): DEBUG: observe_vcard: got vCard alias "j" for handle 18 from <NICKNAME>
** (telepathy-gabble:21749): DEBUG: delete_request: Discarding request 0x9832260
** (telepathy-gabble:21749): DEBUG: cache_entry_attempt_to_free: Not freeing vCard cache entry 0x9828e80: it has a cached vCard 0x982d938
** (telepathy-gabble:21749): DEBUG: delete_item: deleting item 0x9832280
** (telepathy-gabble:21749): DEBUG: response_cb: got reply for request 0x98322c0
** (telepathy-gabble:21749): DEBUG: pipeline_reply_cb: called for entry 0x9828f30
** (telepathy-gabble:21749): DEBUG: observe_vcard: got vCard alias "walter" for handle 19 from <NICKNAME>
** (telepathy-gabble:21749): DEBUG: delete_request: Discarding request 0x98322a0
** (telepathy-gabble:21749): DEBUG: cache_entry_attempt_to_free: Not freeing vCard cache entry 0x9828f30: it has a cached vCard 0x98254b0
** (telepathy-gabble:21749): DEBUG: delete_item: deleting item 0x98322c0
** (telepathy-gabble:21749): DEBUG: response_cb: got reply for request 0x9832300
** (telepathy-gabble:21749): DEBUG: pipeline_reply_cb: called for entry 0x9687738
** (telepathy-gabble:21749): DEBUG: observe_vcard: got vCard alias "simpoir" for handle 20 from <NICKNAME>
** (telepathy-gabble:21749): DEBUG: delete_request: Discarding request 0x98322e0
** (telepathy-gabble:21749): DEBUG: cache_entry_attempt_to_free: Not freeing vCard cache entry 0x9687738: it has a cached vCard 0x982d100
** (telepathy-gabble:21749): DEBUG: delete_item: deleting item 0x9832300
** (telepathy-gabble:21749): DEBUG: response_cb: got reply for request 0x97d15a0
** (telepathy-gabble:21749): DEBUG: pipeline_reply_cb: called for entry 0x9829208
** (telepathy-gabble:21749): DEBUG: observe_vcard: got vCard alias "ignacio          rios" for handle 21 from <NICKNAME>
** (telepathy-gabble:21749): DEBUG: delete_request: Discarding request 0x97d15c0
** (telepathy-gabble:21749): DEBUG: cache_entry_attempt_to_free: Not freeing vCard cache entry 0x9829208: it has a cached vCard 0x97c9a78
** (telepathy-gabble:21749): DEBUG: delete_item: deleting item 0x97d15a0
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_properties: called
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_current_activity: called for contact#2
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_current_activity: current activity not in cache, query PEP node
** (telepathy-gabble:21749): DEBUG: get_current_activity_reply_cb: Failed to query PEP node. No current activity
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_activities: called
** (telepathy-gabble:21749): DEBUG: get_activities_reply_cb: Failed to query PEP node. Compute activities list using views
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_properties: called
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_current_activity: called for contact#3
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_current_activity: current activity not in cache, query PEP node
** (telepathy-gabble:21749): DEBUG: get_current_activity_reply_cb: Failed to query PEP node. No current activity
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_activities: called
** (telepathy-gabble:21749): DEBUG: get_activities_reply_cb: Failed to query PEP node. Compute activities list using views
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_properties: called
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_current_activity: called for contact#4
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_current_activity: current activity not in cache, query PEP node
** (telepathy-gabble:21749): DEBUG: get_current_activity_reply_cb: Failed to query PEP node. No current activity
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_activities: called
** (telepathy-gabble:21749): DEBUG: get_activities_reply_cb: Failed to query PEP node. Compute activities list using views
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_properties: called
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_current_activity: called for contact#5
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_current_activity: current activity not in cache, query PEP node
** (telepathy-gabble:21749): DEBUG: get_current_activity_reply_cb: Failed to query PEP node. No current activity
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_activities: called
** (telepathy-gabble:21749): DEBUG: get_activities_reply_cb: Failed to query PEP node. Compute activities list using views
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_properties: called
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_current_activity: called for contact#6
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_current_activity: current activity not in cache, query PEP node
** (telepathy-gabble:21749): DEBUG: get_current_activity_reply_cb: Failed to query PEP node. No current activity
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_activities: called
** (telepathy-gabble:21749): DEBUG: get_activities_reply_cb: Failed to query PEP node. Compute activities list using views
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_properties: called
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_current_activity: called for contact#7
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_current_activity: current activity not in cache, query PEP node
** (telepathy-gabble:21749): DEBUG: get_current_activity_reply_cb: Failed to query PEP node. No current activity
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_activities: called
** (telepathy-gabble:21749): DEBUG: get_activities_reply_cb: Failed to query PEP node. Compute activities list using views
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_properties: called
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_current_activity: called for contact#8
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_current_activity: current activity not in cache, query PEP node
** (telepathy-gabble:21749): DEBUG: get_current_activity_reply_cb: Failed to query PEP node. No current activity
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_activities: called
** (telepathy-gabble:21749): DEBUG: get_activities_reply_cb: Failed to query PEP node. Compute activities list using views
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_properties: called
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_current_activity: called for contact#9
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_current_activity: current activity not in cache, query PEP node
** (telepathy-gabble:21749): DEBUG: get_current_activity_reply_cb: Failed to query PEP node. No current activity
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_activities: called
** (telepathy-gabble:21749): DEBUG: get_activities_reply_cb: Failed to query PEP node. Compute activities list using views
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_properties: called
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_current_activity: called for contact#10
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_current_activity: current activity not in cache, query PEP node
** (telepathy-gabble:21749): DEBUG: get_current_activity_reply_cb: Failed to query PEP node. No current activity
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_activities: called
** (telepathy-gabble:21749): DEBUG: get_activities_reply_cb: Failed to query PEP node. Compute activities list using views
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_properties: called
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_current_activity: called for contact#11
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_current_activity: current activity not in cache, query PEP node
** (telepathy-gabble:21749): DEBUG: get_current_activity_reply_cb: Failed to query PEP node. No current activity
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_activities: called
** (telepathy-gabble:21749): DEBUG: get_activities_reply_cb: Failed to query PEP node. Compute activities list using views
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_properties: called
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_current_activity: called for contact#12
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_current_activity: current activity not in cache, query PEP node
** (telepathy-gabble:21749): DEBUG: get_current_activity_reply_cb: Failed to query PEP node. No current activity
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_activities: called
** (telepathy-gabble:21749): DEBUG: get_activities_reply_cb: Failed to query PEP node. Compute activities list using views
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_properties: called
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_current_activity: called for contact#13
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_current_activity: current activity not in cache, query PEP node
** (telepathy-gabble:21749): DEBUG: get_current_activity_reply_cb: Failed to query PEP node. No current activity
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_activities: called
** (telepathy-gabble:21749): DEBUG: get_activities_reply_cb: Failed to query PEP node. Compute activities list using views
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_properties: called
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_current_activity: called for contact#14
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_current_activity: current activity not in cache, query PEP node
** (telepathy-gabble:21749): DEBUG: get_current_activity_reply_cb: Failed to query PEP node. No current activity
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_activities: called
** (telepathy-gabble:21749): DEBUG: get_activities_reply_cb: Failed to query PEP node. Compute activities list using views
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_properties: called
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_current_activity: called for contact#15
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_current_activity: current activity not in cache, query PEP node
** (telepathy-gabble:21749): DEBUG: get_current_activity_reply_cb: Failed to query PEP node. No current activity
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_activities: called
** (telepathy-gabble:21749): DEBUG: get_activities_reply_cb: Failed to query PEP node. Compute activities list using views
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_properties: called
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_current_activity: called for contact#16
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_current_activity: current activity not in cache, query PEP node
** (telepathy-gabble:21749): DEBUG: get_current_activity_reply_cb: Failed to query PEP node. No current activity
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_activities: called
** (telepathy-gabble:21749): DEBUG: get_activities_reply_cb: Failed to query PEP node. Compute activities list using views
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_properties: called
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_current_activity: called for contact#17
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_current_activity: current activity not in cache, query PEP node
** (telepathy-gabble:21749): DEBUG: get_current_activity_reply_cb: Failed to query PEP node. No current activity
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_activities: called
** (telepathy-gabble:21749): DEBUG: get_activities_reply_cb: Failed to query PEP node. Compute activities list using views
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_properties: called
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_current_activity: called for contact#18
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_current_activity: current activity not in cache, query PEP node
** (telepathy-gabble:21749): DEBUG: get_current_activity_reply_cb: Failed to query PEP node. No current activity
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_activities: called
** (telepathy-gabble:21749): DEBUG: get_activities_reply_cb: Failed to query PEP node. Compute activities list using views
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_properties: called
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_current_activity: called for contact#19
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_current_activity: current activity not in cache, query PEP node
** (telepathy-gabble:21749): DEBUG: get_current_activity_reply_cb: Failed to query PEP node. No current activity
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_activities: called
** (telepathy-gabble:21749): DEBUG: get_activities_reply_cb: Failed to query PEP node. Compute activities list using views
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_properties: called
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_current_activity: called for contact#20
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_current_activity: current activity not in cache, query PEP node
** (telepathy-gabble:21749): DEBUG: get_current_activity_reply_cb: Failed to query PEP node. No current activity
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_activities: called
** (telepathy-gabble:21749): DEBUG: get_activities_reply_cb: Failed to query PEP node. Compute activities list using views
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_properties: called
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_current_activity: called for contact#21
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_current_activity: current activity not in cache, query PEP node
** (telepathy-gabble:21749): DEBUG: get_current_activity_reply_cb: Failed to query PEP node. No current activity
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_activities: called
** (telepathy-gabble:21749): DEBUG: get_activities_reply_cb: Failed to query PEP node. Compute activities list using views
** (telepathy-gabble:21749): DEBUG: gabble_presence_cache_maybe_remove: discarding cached presence for unavailable jid f2590cda9e125cba49ef690bce1dfb57176803b7@jabber.sugarlabs.org
(telepathy-gabble:21749): tp-glib-DEBUG: tp_presence_mixin_emit_presence_update: called.
(telepathy-gabble:21749): tp-glib-DEBUG: construct_presence_hash: called.
(telepathy-gabble:21749): tp-glib-DEBUG: construct_simple_presence_hash: called.
(telepathy-gabble:21749): tp-glib-DEBUG: tp_presence_mixin_emit_presence_update: called.
(telepathy-gabble:21749): tp-glib-DEBUG: construct_presence_hash: called.
(telepathy-gabble:21749): tp-glib-DEBUG: construct_simple_presence_hash: called.
** (telepathy-gabble:21749): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x97d1560
** (telepathy-gabble:21749): DEBUG: send_next_request: processing request 0x97d1560
** (telepathy-gabble:21749): DEBUG: response_cb: got reply for request 0x97d1560
** (telepathy-gabble:21749): DEBUG: aliases_request_cache_pep: Error getting alias from PEP:
<iq type="error" id="351423935" to="beff817f350152acaa47f2174d73f2a946ced204@jabber.sugarlabs.org/Telepathy" from="74bbf417b63c97c93eafc4abc9bf435e92d03beb@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:21749): DEBUG: aliases_request_pep_cb: Got cached alias 74bbf417b63c97c93eafc4abc9bf435e92d03beb with priority 1
** (telepathy-gabble:21749): DEBUG: gabble_vcard_manager_request: Created request 0x97d1540 to retrieve <22>'s vCard
** (telepathy-gabble:21749): DEBUG: cache_entry_ensure_queued: Cache entry 0x9829068 is not mine, @to = 74bbf417b63c97c93eafc4abc9bf435e92d03beb@jabber.sugarlabs.org
** (telepathy-gabble:21749): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x97d1520
** (telepathy-gabble:21749): DEBUG: cache_entry_ensure_queued: adding request to cache entry 0x9829068 and queueing the <iq>
** (telepathy-gabble:21749): DEBUG: delete_item: deleting item 0x97d1560
** (telepathy-gabble:21749): DEBUG: send_next_request: processing request 0x97d1520
** (telepathy-gabble:21749): DEBUG: response_cb: got reply for request 0x97d1520
** (telepathy-gabble:21749): DEBUG: pipeline_reply_cb: called for entry 0x9829068
** (telepathy-gabble:21749): DEBUG: observe_vcard: got vCard alias "xenofon" for handle 22 from <NICKNAME>
** (telepathy-gabble:21749): DEBUG: delete_request: Discarding request 0x97d1540
** (telepathy-gabble:21749): DEBUG: cache_entry_attempt_to_free: Not freeing vCard cache entry 0x9829068: it has a cached vCard 0x983eb48
** (telepathy-gabble:21749): DEBUG: delete_item: deleting item 0x97d1520
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_properties: called
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_current_activity: called for contact#22
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_current_activity: current activity not in cache, query PEP node
** (telepathy-gabble:21749): DEBUG: _caps_disco_cb: disco query failed: Request for info on beff817f350152acaa47f2174d73f2a946ced204@jabber.sugarlabs.org/Telepathy timed out
** (telepathy-gabble:21749): DEBUG: _caps_disco_cb: failed to find a suitable candidate to retry disco request for URI http://telepathy.freedesktop.org/caps#fL4hzIC3FAqjApGlCg6uHgZturQ=
** (telepathy-gabble:21749): DEBUG: disco_waiter_list_free: list 0x97c6638
** (telepathy-gabble:21749): DEBUG: disco_waiter_free: freeing waiter 0x97d1360 for handle 1 with serial 3
** (telepathy-gabble:21749): DEBUG: disco_waiter_free: freeing waiter 0x97d1300 for handle 1 with serial 2
** (telepathy-gabble:21749): DEBUG: get_current_activity_reply_cb: Failed to query PEP node. No current activity
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_activities: called
** (telepathy-gabble:21749): DEBUG: get_activities_reply_cb: Failed to query PEP node. Compute activities list using views
** (telepathy-gabble:21749): DEBUG: gabble_olpc_activity_constructor: new activity 95a09ec3347ad28434909ad14d4d1696282276c7@conference.jabber.sugarlabs.org (1)
** (telepathy-gabble:21749): DEBUG: add_activities_to_view_from_node: Assigning new ID <95a09ec3347ad28434909ad14d4d1696282276c7> to room #1
** (telepathy-gabble:21749): DEBUG: copy_activity_to_array: ... activity #1 (ID 95a09ec3347ad28434909ad14d4d1696282276c7)
** (telepathy-gabble:21749): DEBUG: olpc_activity_properties_get_properties: called
(telepathy-gabble:21749): tp-glib-DEBUG: channel_request_new: New channel request at 0x97d2500: ctype=org.freedesktop.Telepathy.Channel.Type.Text htype=2 handle=1 suppress=1
** (telepathy-gabble:21749): DEBUG: new_muc_channel: creating new chan, object path /org/freedesktop/Telepathy/Connection/gabble/jabber/beff817f350152acaa47f2174d73f2a946ced204_40jabber_2esugarlabs_2eorg_2fTelepathy/MucChannel1
tp_group_mixin_change_flags: emitting group flags changed
  added    : [CAN_ADD|CHANNEL_SPECIFIC_HANDLES|HANDLE_OWNERS_NOT_AVAILABLE|PROPERTIES]
  removed  : []
  flags now: [CAN_ADD|CHANNEL_SPECIFIC_HANDLES|HANDLE_OWNERS_NOT_AVAILABLE|PROPERTIES]
emit_members_changed_signals: emitting members changed
  message       : ""
  added         : []
  removed       : []
  local_pending : []
  remote_pending: [23 (95a09ec3347ad28434909ad14d4d1696282276c7@conference.jabber.sugarlabs.org/uwog2)]
  actor         : 0
  reason        : 0: unspecified reason
** (telepathy-gabble:21749): DEBUG: send_join_request: join request sent
** (telepathy-gabble:21749): DEBUG: channel_state_changed: state changed from MUC_STATE_CREATED to MUC_STATE_INITIATED
tp_group_mixin_change_flags: emitting group flags changed
  added    : []
  removed  : [CAN_ADD]
  flags now: [CHANNEL_SPECIFIC_HANDLES|HANDLE_OWNERS_NOT_AVAILABLE|PROPERTIES]
** (telepathy-gabble:21749): DEBUG: _gabble_muc_channel_receive: ignoring message from muc:
<message type="groupchat" to="beff817f350152acaa47f2174d73f2a946ced204@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:21749): DEBUG: _gabble_muc_channel_member_presence_updated: called
tp_group_mixin_change_flags: emitting group flags changed
  added    : []
  removed  : [HANDLE_OWNERS_NOT_AVAILABLE]
  flags now: [CHANNEL_SPECIFIC_HANDLES|PROPERTIES]
** (telepathy-gabble:21749): DEBUG: new_tubes_channel: creating new tubes chan, object path /org/freedesktop/Telepathy/Connection/gabble/jabber/beff817f350152acaa47f2174d73f2a946ced204_40jabber_2esugarlabs_2eorg_2fTelepathy/MucTubesChannel1
** (telepathy-gabble:21749): DEBUG: gabble_tubes_channel_constructor: Called
** (telepathy-gabble:21749): DEBUG: gabble_tubes_channel_set_property: Setting object_path: /org/freedesktop/Telepathy/Connection/gabble/jabber/beff817f350152acaa47f2174d73f2a946ced204_40jabber_2esugarlabs_2eorg_2fTelepathy/MucTubesChannel1
** (telepathy-gabble:21749): DEBUG: gabble_tubes_channel_constructor: Registering at '/org/freedesktop/Telepathy/Connection/gabble/jabber/beff817f350152acaa47f2174d73f2a946ced204_40jabber_2esugarlabs_2eorg_2fTelepathy/MucTubesChannel1'
** (telepathy-gabble:21749): DEBUG: gabble_tube_dbus_constructor: Registering at '/org/freedesktop/Telepathy/Connection/gabble/jabber/beff817f350152acaa47f2174d73f2a946ced204_40jabber_2esugarlabs_2eorg_2fTelepathy/DBusTubeChannel_1_1736093172'
** (telepathy-gabble:21749): DEBUG: gabble_tube_dbus_constructor: local name: :2.dXdvZzIA
** (telepathy-gabble:21749): DEBUG: gabble_signal_connect_weak: connecting to 0x9827a90:state-changed with context 0x982a0b0
** (telepathy-gabble:21749): DEBUG: gabble_bytestream_factory_create_muc: add muc bytestream <1251970491-2896628767> from <95a09ec3347ad28434909ad14d4d1696282276c7@conference.jabber.sugarlabs.org>
** (telepathy-gabble:21749): DEBUG: create_new_tube: create tube 1736093172
** (telepathy-gabble:21749): DEBUG: gabble_presence_cache_do_update: 95a09ec3347ad28434909ad14d4d1696282276c7@conference.jabber.sugarlabs.org/uwog (26) resource uwog prio 0 presence 7 message "(null)"
(telepathy-gabble:21749): tp-glib-DEBUG: tp_presence_mixin_emit_presence_update: called.
(telepathy-gabble:21749): tp-glib-DEBUG: construct_presence_hash: called.
(telepathy-gabble:21749): tp-glib-DEBUG: construct_simple_presence_hash: called.
** (telepathy-gabble:21749): DEBUG: _process_caps: Emitting caps update: handle 26, old 0, new 0
** (telepathy-gabble:21749): DEBUG: _gabble_muc_channel_member_presence_updated: called
emit_members_changed_signals: emitting members changed
  message       : ""
  added         : [23 (95a09ec3347ad28434909ad14d4d1696282276c7@conference.jabber.sugarlabs.org/uwog2)
                   26 (95a09ec3347ad28434909ad14d4d1696282276c7@conference.jabber.sugarlabs.org/uwog)]
  removed       : []
  local_pending : []
  remote_pending: []
  actor         : 0
  reason        : 0: unspecified reason
** (telepathy-gabble:21749): DEBUG: channel_state_changed: state changed from MUC_STATE_INITIATED to MUC_STATE_JOINED
** (telepathy-gabble:21749): DEBUG: change_password_flags: emitting password flags changed, added 0x0, removed 0x0
** (telepathy-gabble:21749): DEBUG: muc_ready_cb: text chan=0x9824360
(telepathy-gabble:21749): tp-glib-DEBUG: satisfy_request: completing queued request 0x97d2500 with success, channel_type=org.freedesktop.Telepathy.Channel.Type.Text, handle_type=2, handle=1, suppress_handler=1
(telepathy-gabble:21749): tp-glib-DEBUG: channel_request_free: Freeing channel request at 0x97d2500: ctype=org.freedesktop.Telepathy.Channel.Type.Text htype=2 handle=1 suppress=1
** (telepathy-gabble:21749): DEBUG: gabble_disco_request_with_timeout: Creating disco request 0x9828140 for 95a09ec3347ad28434909ad14d4d1696282276c7@conference.jabber.sugarlabs.org
tp_group_mixin_change_flags: emitting group flags changed
  added    : [CAN_ADD|MESSAGE_ADD]
  removed  : []
  flags now: [CAN_ADD|MESSAGE_ADD|CHANNEL_SPECIFIC_HANDLES|PROPERTIES]
tp_properties_mixin_emit_flags: emitting properties flags changed for property:
  subject's flags now: []
** (telepathy-gabble:21749): DEBUG: gabble_presence_cache_do_update: 95a09ec3347ad28434909ad14d4d1696282276c7@conference.jabber.sugarlabs.org/uwog2 (23) resource uwog2 prio 0 presence 7 message "(null)"
(telepathy-gabble:21749): tp-glib-DEBUG: tp_presence_mixin_emit_presence_update: called.
(telepathy-gabble:21749): tp-glib-DEBUG: construct_presence_hash: called.
(telepathy-gabble:21749): tp-glib-DEBUG: construct_simple_presence_hash: called.
** (telepathy-gabble:21749): DEBUG: _process_caps: Emitting caps update: handle 23, old 0, new 0
** (telepathy-gabble:21749): DEBUG: conn_olpc_process_activity_properties_message: Found <properties> node in <message>
** (telepathy-gabble:21749): DEBUG: conn_olpc_process_activity_properties_message: Activity properties message was in a chatroom
(telepathy-gabble:21749): tp-glib-DEBUG: channel_request_new: New channel request at 0x97d44c8: ctype=org.freedesktop.Telepathy.Channel.Type.Tubes htype=2 handle=1 suppress=1
(telepathy-gabble:21749): tp-glib-DEBUG: satisfy_request: completing queued request 0x97d44c8 with success, channel_type=org.freedesktop.Telepathy.Channel.Type.Tubes, handle_type=2, handle=1, suppress_handler=1
(telepathy-gabble:21749): tp-glib-DEBUG: channel_request_free: Freeing channel request at 0x97d44c8: ctype=org.freedesktop.Telepathy.Channel.Type.Tubes htype=2 handle=1 suppress=1
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_set_activities: called
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_set_activities: ref: 95a09ec3347ad28434909ad14d4d1696282276c7@conference.jabber.sugarlabs.org (1) refcount: 3

** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_set_current_activity: called
** (telepathy-gabble:21749): DEBUG: gabble_tube_dbus_accept: no SI, bytestream open
** (telepathy-gabble:21749): DEBUG: create_dbus_server: listening on unix:path=/tmp/dbus-gabble-Y4fhFtkU
** (telepathy-gabble:21749): DEBUG: new_connection_cb: got connection
** (telepathy-gabble:21749): DEBUG: new_connection_cb: 0 messages in the queue (0 bytes)
** (telepathy-gabble:21749): DEBUG: send_data_to: send 166 bytes
** (telepathy-gabble:21749): DEBUG: send_data_to: finished to send 166 bytes (1 stanzas needed)
tp_properties_mixin_emit_changed: emitting properties changed for properties:
  anonymous
  invite-only
  moderated
  name
  password-required
  persistent
  private
tp_properties_mixin_emit_flags: emitting properties flags changed for properties:
  anonymous's flags now: [READ]
  invite-only's flags now: [READ]
  moderated's flags now: [READ]
  name's flags now: [READ]
  password-required's flags now: [READ]
  persistent's flags now: [READ]
  private's flags now: [READ]
** (telepathy-gabble:21749): DEBUG: _gabble_muc_channel_member_presence_updated: called
** (telepathy-gabble:21749): DEBUG: gabble_disco_request_with_timeout: Creating disco request 0x98280e0 for 95a09ec3347ad28434909ad14d4d1696282276c7@conference.jabber.sugarlabs.org
** (telepathy-gabble:21749): DEBUG: gabble_presence_cache_do_update: 95a09ec3347ad28434909ad14d4d1696282276c7@conference.jabber.sugarlabs.org/uwog2 (23) resource uwog2 prio 0 presence 7 message "(null)"
** (telepathy-gabble:21749): DEBUG: _process_caps: Emitting caps update: handle 23, old 0, new 0
** (telepathy-gabble:21749): DEBUG: gabble_bytestream_muc_receive: fully received 166 bytes of data
** (telepathy-gabble:21749): DEBUG: message_received: delivering message from ':2.dXdvZzIA' to '(null)'
** (telepathy-gabble:21749): DEBUG: send_data_to: send 194 bytes
** (telepathy-gabble:21749): DEBUG: send_data_to: finished to send 194 bytes (1 stanzas needed)
** (telepathy-gabble:21749): DEBUG: copy_activity_to_array: ... activity #1 (ID 95a09ec3347ad28434909ad14d4d1696282276c7)
** (telepathy-gabble:21749): DEBUG: gabble_bytestream_muc_receive: fully received 194 bytes of data
** (telepathy-gabble:21749): DEBUG: message_received: delivering message from ':2.dXdvZzIA' to ':2.dXdvZzIA'
** (telepathy-gabble:21749): DEBUG: gabble_bytestream_muc_receive: fully received 232 bytes of data
** (telepathy-gabble:21749): DEBUG: message_received: delivering message from ':2.dXdvZwAA' to ':2.dXdvZzIA'
** (telepathy-gabble:21749): DEBUG: send_data_to: send 227 bytes
** (telepathy-gabble:21749): DEBUG: send_data_to: finished to send 227 bytes (1 stanzas needed)
** (telepathy-gabble:21749): DEBUG: gabble_bytestream_muc_receive: fully received 1254 bytes of data
** (telepathy-gabble:21749): DEBUG: message_received: delivering message from ':2.dXdvZwAA' to ':2.dXdvZzIA'
** (telepathy-gabble:21749): DEBUG: send_data_to: send 227 bytes
** (telepathy-gabble:21749): DEBUG: send_data_to: finished to send 227 bytes (1 stanzas needed)
** (telepathy-gabble:21749): DEBUG: send_data_to: send 290 bytes
** (telepathy-gabble:21749): DEBUG: send_data_to: finished to send 290 bytes (1 stanzas needed)
** (telepathy-gabble:21749): DEBUG: send_data_to: send 326 bytes
** (telepathy-gabble:21749): DEBUG: send_data_to: finished to send 326 bytes (1 stanzas needed)
** (telepathy-gabble:21749): DEBUG: send_data_to: send 265 bytes
** (telepathy-gabble:21749): DEBUG: send_data_to: finished to send 265 bytes (1 stanzas needed)
** (telepathy-gabble:21749): DEBUG: send_data_to: send 292 bytes
** (telepathy-gabble:21749): DEBUG: send_data_to: finished to send 292 bytes (1 stanzas needed)
** (telepathy-gabble:21749): DEBUG: send_data_to: send 265 bytes
** (telepathy-gabble:21749): DEBUG: send_data_to: finished to send 265 bytes (1 stanzas needed)
** (telepathy-gabble:21749): DEBUG: gabble_bytestream_muc_receive: fully received 269 bytes of data
** (telepathy-gabble:21749): DEBUG: message_received: delivering message from ':2.dXdvZwAA' to ':2.dXdvZzIA'
** (telepathy-gabble:21749): DEBUG: send_data_to: send 264 bytes
** (telepathy-gabble:21749): DEBUG: send_data_to: finished to send 264 bytes (1 stanzas needed)
** (telepathy-gabble:21749): DEBUG: gabble_bytestream_muc_receive: fully received 264 bytes of data
** (telepathy-gabble:21749): DEBUG: message_received: delivering message from ':2.dXdvZwAA' to ':2.dXdvZzIA'
** (telepathy-gabble:21749): DEBUG: _gabble_muc_channel_member_presence_updated: called
emit_members_changed_signals: emitting members changed
  message       : ""
  added         : []
  removed       : [26 (95a09ec3347ad28434909ad14d4d1696282276c7@conference.jabber.sugarlabs.org/uwog)]
  local_pending : []
  remote_pending: []
  actor         : 0
  reason        : 0: unspecified reason
** (telepathy-gabble:21749): DEBUG: contact_left_muc: 95a09ec3347ad28434909ad14d4d1696282276c7@conference.jabber.sugarlabs.org/uwog left muc and so left all its tube
** (telepathy-gabble:21749): DEBUG: gabble_presence_cache_do_update: 95a09ec3347ad28434909ad14d4d1696282276c7@conference.jabber.sugarlabs.org/uwog (26) resource uwog prio 0 presence 1 message "(null)"
(telepathy-gabble:21749): tp-glib-DEBUG: tp_presence_mixin_emit_presence_update: called.
(telepathy-gabble:21749): tp-glib-DEBUG: construct_presence_hash: called.
(telepathy-gabble:21749): tp-glib-DEBUG: construct_simple_presence_hash: called.
** (telepathy-gabble:21749): DEBUG: gabble_presence_cache_maybe_remove: discarding cached presence for unavailable jid 95a09ec3347ad28434909ad14d4d1696282276c7@conference.jabber.sugarlabs.org/uwog
** (telepathy-gabble:21749): DEBUG: gabble_presence_cache_maybe_remove: discarding cached presence for unavailable jid ae6da8eda397b06dc101737322b9f7954eb98837@jabber.sugarlabs.org
(telepathy-gabble:21749): tp-glib-DEBUG: tp_presence_mixin_emit_presence_update: called.
(telepathy-gabble:21749): tp-glib-DEBUG: construct_presence_hash: called.
(telepathy-gabble:21749): tp-glib-DEBUG: construct_simple_presence_hash: called.
(telepathy-gabble:21749): tp-glib-DEBUG: tp_presence_mixin_emit_presence_update: called.
(telepathy-gabble:21749): tp-glib-DEBUG: construct_presence_hash: called.
(telepathy-gabble:21749): tp-glib-DEBUG: construct_simple_presence_hash: called.
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_properties: called
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_current_activity: called for contact#7
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_current_activity: current activity not in cache, query PEP node
** (telepathy-gabble:21749): DEBUG: get_current_activity_reply_cb: Failed to query PEP node. No current activity
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_activities: called
** (telepathy-gabble:21749): DEBUG: get_activities_reply_cb: Failed to query PEP node. Compute activities list using views
** (telepathy-gabble:21749): DEBUG: timeout_poll: polling for room properties
** (telepathy-gabble:21749): DEBUG: gabble_disco_request_with_timeout: Creating disco request 0x98280a0 for 95a09ec3347ad28434909ad14d4d1696282276c7@conference.jabber.sugarlabs.org
** (telepathy-gabble:21749): DEBUG: gabble_presence_cache_maybe_remove: discarding cached presence for unavailable jid 25aabee27fed34446d30e2a0c16764ee02a3a81e@jabber.sugarlabs.org
(telepathy-gabble:21749): tp-glib-DEBUG: tp_presence_mixin_emit_presence_update: called.
(telepathy-gabble:21749): tp-glib-DEBUG: construct_presence_hash: called.
(telepathy-gabble:21749): tp-glib-DEBUG: construct_simple_presence_hash: called.
(telepathy-gabble:21749): tp-glib-DEBUG: tp_presence_mixin_emit_presence_update: called.
(telepathy-gabble:21749): tp-glib-DEBUG: construct_presence_hash: called.
(telepathy-gabble:21749): tp-glib-DEBUG: construct_simple_presence_hash: called.
** (telepathy-gabble:21749): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x9828060
** (telepathy-gabble:21749): DEBUG: send_next_request: processing request 0x9828060
** (telepathy-gabble:21749): DEBUG: response_cb: got reply for request 0x9828060
** (telepathy-gabble:21749): DEBUG: aliases_request_cache_pep: Error getting alias from PEP:
<iq type="error" id="459956459982" to="beff817f350152acaa47f2174d73f2a946ced204@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:21749): DEBUG: aliases_request_pep_cb: Got cached alias ae6da8eda397b06dc101737322b9f7954eb98837 with priority 1
** (telepathy-gabble:21749): DEBUG: gabble_vcard_manager_request: Created request 0x9828040 to retrieve <5>'s vCard
** (telepathy-gabble:21749): DEBUG: cache_entry_ensure_queued: Cache entry 0x9827cc0 is not mine, @to = ae6da8eda397b06dc101737322b9f7954eb98837@jabber.sugarlabs.org
** (telepathy-gabble:21749): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x9828020
** (telepathy-gabble:21749): DEBUG: cache_entry_ensure_queued: adding request to cache entry 0x9827cc0 and queueing the <iq>
** (telepathy-gabble:21749): DEBUG: delete_item: deleting item 0x9828060
** (telepathy-gabble:21749): DEBUG: send_next_request: processing request 0x9828020
** (telepathy-gabble:21749): DEBUG: response_cb: got reply for request 0x9828020
** (telepathy-gabble:21749): DEBUG: pipeline_reply_cb: called for entry 0x9827cc0
** (telepathy-gabble:21749): DEBUG: observe_vcard: got vCard alias "donghee" for handle 5 from <NICKNAME>
** (telepathy-gabble:21749): DEBUG: delete_request: Discarding request 0x9828040
** (telepathy-gabble:21749): DEBUG: cache_entry_attempt_to_free: Not freeing vCard cache entry 0x9827cc0: it has a cached vCard 0x97c9a78
** (telepathy-gabble:21749): DEBUG: delete_item: deleting item 0x9828020
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_properties: called
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_current_activity: called for contact#5
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_current_activity: current activity not in cache, query PEP node
** (telepathy-gabble:21749): DEBUG: get_current_activity_reply_cb: Failed to query PEP node. No current activity
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_activities: called
** (telepathy-gabble:21749): DEBUG: get_activities_reply_cb: Failed to query PEP node. Compute activities list using views
** (telepathy-gabble:21749): DEBUG: gabble_presence_cache_maybe_remove: discarding cached presence for unavailable jid ae6da8eda397b06dc101737322b9f7954eb98837@jabber.sugarlabs.org
(telepathy-gabble:21749): tp-glib-DEBUG: tp_presence_mixin_emit_presence_update: called.
(telepathy-gabble:21749): tp-glib-DEBUG: construct_presence_hash: called.
(telepathy-gabble:21749): tp-glib-DEBUG: construct_simple_presence_hash: called.
(telepathy-gabble:21749): tp-glib-DEBUG: tp_presence_mixin_emit_presence_update: called.
(telepathy-gabble:21749): tp-glib-DEBUG: construct_presence_hash: called.
(telepathy-gabble:21749): tp-glib-DEBUG: construct_simple_presence_hash: called.
** (telepathy-gabble:21749): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x9828020
** (telepathy-gabble:21749): DEBUG: send_next_request: processing request 0x9828020
** (telepathy-gabble:21749): DEBUG: response_cb: got reply for request 0x9828020
** (telepathy-gabble:21749): DEBUG: aliases_request_cache_pep: Error getting alias from PEP:
<iq type="error" id="625882646638" to="beff817f350152acaa47f2174d73f2a946ced204@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:21749): DEBUG: aliases_request_pep_cb: Got cached alias c16c4bcd29d044ee83db5bb4bcf63e03870fdb31 with priority 1
** (telepathy-gabble:21749): DEBUG: gabble_vcard_manager_request: Created request 0x9828040 to retrieve <17>'s vCard
** (telepathy-gabble:21749): DEBUG: cache_entry_ensure_queued: Cache entry 0x9829148 is not mine, @to = c16c4bcd29d044ee83db5bb4bcf63e03870fdb31@jabber.sugarlabs.org
** (telepathy-gabble:21749): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x9828080
** (telepathy-gabble:21749): DEBUG: cache_entry_ensure_queued: adding request to cache entry 0x9829148 and queueing the <iq>
** (telepathy-gabble:21749): DEBUG: delete_item: deleting item 0x9828020
** (telepathy-gabble:21749): DEBUG: send_next_request: processing request 0x9828080
** (telepathy-gabble:21749): DEBUG: response_cb: got reply for request 0x9828080
** (telepathy-gabble:21749): DEBUG: pipeline_reply_cb: called for entry 0x9829148
** (telepathy-gabble:21749): DEBUG: observe_vcard: got vCard alias "soas=2=beta-4gb-sh2" for handle 17 from <NICKNAME>
** (telepathy-gabble:21749): DEBUG: delete_request: Discarding request 0x9828040
** (telepathy-gabble:21749): DEBUG: cache_entry_attempt_to_free: Not freeing vCard cache entry 0x9829148: it has a cached vCard 0x9824dd8
** (telepathy-gabble:21749): DEBUG: delete_item: deleting item 0x9828080
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_properties: called
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_current_activity: called for contact#17
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_current_activity: current activity not in cache, query PEP node
** (telepathy-gabble:21749): DEBUG: get_current_activity_reply_cb: Failed to query PEP node. No current activity
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_activities: called
** (telepathy-gabble:21749): DEBUG: get_activities_reply_cb: Failed to query PEP node. Compute activities list using views
** (telepathy-gabble:21749): DEBUG: timeout_poll: polling for room properties
** (telepathy-gabble:21749): DEBUG: gabble_disco_request_with_timeout: Creating disco request 0x9828060 for 95a09ec3347ad28434909ad14d4d1696282276c7@conference.jabber.sugarlabs.org
** (telepathy-gabble:21749): DEBUG: _gabble_muc_channel_member_presence_updated: called
emit_members_changed_signals: emitting members changed
  message       : ""
  added         : [26 (95a09ec3347ad28434909ad14d4d1696282276c7@conference.jabber.sugarlabs.org/uwog)]
  removed       : []
  local_pending : []
  remote_pending: []
  actor         : 0
  reason        : 0: unspecified reason
(telepathy-gabble:21749): tp-glib-DEBUG: tp_group_mixin_change_flags: No change: 2313 includes all the bits of 0 and none of 1024
** (telepathy-gabble:21749): DEBUG: gabble_presence_cache_do_update: 95a09ec3347ad28434909ad14d4d1696282276c7@conference.jabber.sugarlabs.org/uwog (26) resource uwog prio 0 presence 7 message "(null)"
(telepathy-gabble:21749): tp-glib-DEBUG: tp_presence_mixin_emit_presence_update: called.
(telepathy-gabble:21749): tp-glib-DEBUG: construct_presence_hash: called.
(telepathy-gabble:21749): tp-glib-DEBUG: construct_simple_presence_hash: called.
** (telepathy-gabble:21749): DEBUG: _process_caps: Emitting caps update: handle 26, old 0, new 0
(telepathy-gabble:21749): tp-glib-DEBUG: tp_presence_mixin_emit_presence_update: called.
(telepathy-gabble:21749): tp-glib-DEBUG: construct_presence_hash: called.
(telepathy-gabble:21749): tp-glib-DEBUG: construct_simple_presence_hash: called.
** (telepathy-gabble:21749): DEBUG: copy_activity_to_array: ... activity #1 (ID 95a09ec3347ad28434909ad14d4d1696282276c7)
** (telepathy-gabble:21749): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x98281c0
** (telepathy-gabble:21749): DEBUG: send_next_request: processing request 0x98281c0
** (telepathy-gabble:21749): DEBUG: response_cb: got reply for request 0x98281c0
** (telepathy-gabble:21749): DEBUG: aliases_request_cache_pep: Error getting alias from PEP:
<iq type="error" id="6578765788" to="beff817f350152acaa47f2174d73f2a946ced204@jabber.sugarlabs.org/Telepathy" from="25aabee27fed34446d30e2a0c16764ee02a3a81e@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:21749): DEBUG: aliases_request_pep_cb: Got cached alias 25aabee27fed34446d30e2a0c16764ee02a3a81e with priority 1
** (telepathy-gabble:21749): DEBUG: gabble_vcard_manager_request: Created request 0x98280e0 to retrieve <5>'s vCard
** (telepathy-gabble:21749): DEBUG: cache_entry_ensure_queued: Cache entry 0x9687798 is not mine, @to = 25aabee27fed34446d30e2a0c16764ee02a3a81e@jabber.sugarlabs.org
** (telepathy-gabble:21749): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x9828140
** (telepathy-gabble:21749): DEBUG: cache_entry_ensure_queued: adding request to cache entry 0x9687798 and queueing the <iq>
** (telepathy-gabble:21749): DEBUG: delete_item: deleting item 0x98281c0
** (telepathy-gabble:21749): DEBUG: send_next_request: processing request 0x9828140
** (telepathy-gabble:21749): DEBUG: response_cb: got reply for request 0x9828140
** (telepathy-gabble:21749): DEBUG: pipeline_reply_cb: called for entry 0x9687798
** (telepathy-gabble:21749): DEBUG: observe_vcard: got vCard alias "uwog" for handle 5 from <NICKNAME>
** (telepathy-gabble:21749): DEBUG: delete_request: Discarding request 0x98280e0
** (telepathy-gabble:21749): DEBUG: cache_entry_attempt_to_free: Not freeing vCard cache entry 0x9687798: it has a cached vCard 0x9829ba0
** (telepathy-gabble:21749): DEBUG: delete_item: deleting item 0x9828140
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_properties: called
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_current_activity: called for contact#5
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_current_activity: current activity not in cache, query PEP node
** (telepathy-gabble:21749): DEBUG: get_current_activity_reply_cb: Failed to query PEP node. No current activity
** (telepathy-gabble:21749): DEBUG: olpc_buddy_info_get_activities: called
** (telepathy-gabble:21749): DEBUG: get_activities_reply_cb: Failed to query PEP node. Compute activities list using views
** (telepathy-gabble:21749): DEBUG: copy_activity_to_array: ... activity #1 (ID 95a09ec3347ad28434909ad14d4d1696282276c7)
** (telepathy-gabble:21749): DEBUG: timeout_poll: polling for room properties
** (telepathy-gabble:21749): DEBUG: gabble_disco_request_with_timeout: Creating disco request 0x9828140 for 95a09ec3347ad28434909ad14d4d1696282276c7@conference.jabber.sugarlabs.org
** (telepathy-gabble:21749): DEBUG: gabble_presence_cache_maybe_remove: discarding cached presence for unavailable jid 74bbf417b63c97c93eafc4abc9bf435e92d03beb@jabber.sugarlabs.org
(telepathy-gabble:21749): tp-glib-DEBUG: tp_presence_mixin_emit_presence_update: called.
(telepathy-gabble:21749): tp-glib-DEBUG: construct_presence_hash: called.
(telepathy-gabble:21749): tp-glib-DEBUG: construct_simple_presence_hash: called.
(telepathy-gabble:21749): tp-glib-DEBUG: tp_presence_mixin_emit_presence_update: called.
(telepathy-gabble:21749): tp-glib-DEBUG: construct_presence_hash: called.
(telepathy-gabble:21749): tp-glib-DEBUG: construct_simple_presence_hash: called.
** (telepathy-gabble:21749): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x98280c0
** (telepathy-gabble:21749): DEBUG: send_next_request: processing request 0x98280c0
** (telepathy-gabble:21749): DEBUG: response_cb: got reply for request 0x98280c0
** (telepathy-gabble:21749): DEBUG: aliases_request_cache_pep: Error getting alias from PEP:
<iq type="error" id="953040953206" to="beff817f350152acaa47f2174d73f2a946ced204@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:21749): DEBUG: aliases_request_pep_cb: Got cached alias ae6da8eda397b06dc101737322b9f7954eb98837 with priority 1
** (telepathy-gabble:21749): DEBUG: gabble_vcard_manager_request: Created request 0x98281c0 to retrieve <22>'s vCard
** (telepathy-gabble:21749): DEBUG: cache_entry_ensure_queued: Cache entry 0x97d44b0 is not mine, @to = ae6da8eda397b06dc101737322b9f7954eb98837@jabber.sugarlabs.org
** (telepathy-gabble:21749): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x9828060
** (telepathy-gabble:21749): DEBUG: cache_entry_ensure_queued: adding request to cache entry 0x97d44b0 and queueing the <iq>
** (telepathy-gabble:21749): DEBUG: delete_item: deleting item 0x98280c0
** (telepathy-gabble:21749): DEBUG: send_next_request: processing request 0x9828060