rendered paste bodyunix:abstract=/tmp/dbus-Q2AP8qoQGs,guid=b4477994c3669db05c61b79547f13236** (process:10409): DEBUG: Could not open plugin directory: Error opening directory '/usr/lib64/mission-control': No such file or directory** (process:10409): DEBUG: Could not open plugin directory: Error opening directory '/usr/lib64/mission-control': No such file or directory** (process:10409): DEBUG: _mcd_mission_set_parent: child = 0x614320, parent = 0x60c9e0** (process:10409): DEBUG: _mcd_mission_set_parent: child = 0x619030, parent = 0x60c9e0** (process:10409): DEBUG: Nuking possible stale connections** (process:10409): DEBUG: _mcd_mission_set_parent: child = 0x619660, parent = 0x60f880** (process:10409): DEBUG: mcd_manager_add_account: 0 accounts in total** (process:10409): DEBUG: mcd_manager_add_account: adding account 0x621800** (process:10409): DEBUG: mcd_manager_add_account: 1 accounts in total** (process:10409): DEBUG: _mcd_master_init_managers: Added account: Name "jabber1" Profile "jabber" Proto "jabber" Manager "gabble"** (process:10409): DEBUG: Requesting MC dbus service** (process:10409): DEBUG: Registering MC object** (process:10409): DEBUG: Registered MC object** (process:10409): DEBUG: _mcd_manager_connect: delay_presence_request = 0** (process:10409): DEBUG: mcd_presence_frame_request_presence: updated last_presence = 0, msg = (null)** (process:10409): DEBUG: _mcd_presence_frame_request_presence: Presence 2 is being requested** (process:10409): DEBUG: on_presence_requested: Current connectivity status is 1** (process:10409): DEBUG: on_presence_requested_idle: 2, 0** (process:10409): DEBUG: _mcd_manager_create_connection: Manager gabble created** (process:10409): DEBUG: _mcd_mission_set_parent: child = 0x62e090, parent = 0x619660** (process:10409): DEBUG: Emitting account status changed for jabber1: status = 1, reason = 1** (process:10409): DEBUG: _mcd_presence_frame_update_actual_status called** (process:10409): DEBUG: _mcd_presence_frame_update_actual_status: status actual: 1** (process:10409): DEBUG: _mcd_presence_frame_update_stable: account_presence = 0x61db80** (process:10409): DEBUG: _mcd_presence_frame_check_stable: status = 1** (process:10409): DEBUG: on_presence_stable called** (process:10409): DEBUG: mcd_connection_get_params_and_connect: Trying connect account: jabber1** (process:10409): DEBUG: _mcd_connection_connect: Trying connect account: jabber1** (process:10409): DEBUG: _mcd_manager_create_connection: Created a connection 0x62e090 for account: jabber1** (process:10409): DEBUG: mcd_master_set_offline_on_idle: setting offline_on_idle to 0(telepathy-gabble:10415): tp-glib-DEBUG: started version 0.7.2.1 (telepathy-glib version 0.7.5)(telepathy-gabble:10415): tp-glib-DEBUG: tp_cm_param_setter_offset: account = "alice@localhost"(telepathy-gabble:10415): tp-glib-DEBUG: tp_cm_param_setter_offset: password = <hidden>(telepathy-gabble:10415): tp-glib-DEBUG: tp_cm_param_setter_offset: server = "localhost"(telepathy-gabble:10415): tp-glib-DEBUG: tp_cm_param_setter_offset: resource = "Telepathy"(telepathy-gabble:10415): tp-glib-DEBUG: tp_cm_param_setter_offset: priority = 0 = 0x0(telepathy-gabble:10415): tp-glib-DEBUG: parse_parameters: port not given, using default behaviour(telepathy-gabble:10415): tp-glib-DEBUG: tp_cm_param_setter_offset: old-ssl = FALSE(telepathy-gabble:10415): tp-glib-DEBUG: tp_cm_param_setter_offset: require-encryption = FALSE(telepathy-gabble:10415): tp-glib-DEBUG: tp_cm_param_setter_offset: register = FALSE(telepathy-gabble:10415): tp-glib-DEBUG: tp_cm_param_setter_offset: low-bandwidth = FALSE(telepathy-gabble:10415): tp-glib-DEBUG: parse_parameters: https-proxy-server not given, using default behaviour(telepathy-gabble:10415): tp-glib-DEBUG: tp_cm_param_setter_offset: https-proxy-port = 443 = 0x1bb(telepathy-gabble:10415): tp-glib-DEBUG: tp_cm_param_setter_offset: fallback-conference-server = "conference.jabber.org"(telepathy-gabble:10415): tp-glib-DEBUG: parse_parameters: stun-server not given, using default behaviour(telepathy-gabble:10415): tp-glib-DEBUG: tp_cm_param_setter_offset: stun-port = 3478 = 0xd96(telepathy-gabble:10415): tp-glib-DEBUG: tp_cm_param_setter_offset: ignore-ssl-errors = FALSE(telepathy-gabble:10415): tp-glib-DEBUG: parse_parameters: alias not given, using default behaviour(telepathy-gabble:10415): tp-glib-DEBUG: tp_base_connection_class_init: Initializing (TpBaseConnectionClass *)0x681490** (telepathy-gabble:10415): DEBUG: gabble_connection_class_init: Initializing (GabbleConnectionClass *)0x6818d0(telepathy-gabble:10415): tp-glib-DEBUG: tp_presence_mixin_class_init: called.(telepathy-gabble:10415): tp-glib-DEBUG: tp_base_connection_init: Initializing (TpBaseConnection *)0x686080** (telepathy-gabble:10415): DEBUG: gabble_connection_init: Initializing (GabbleConnection *)0x686080(telepathy-gabble:10415): tp-glib-DEBUG: tp_base_connection_constructor: Post-construction: (TpBaseConnection *)0x686080(telepathy-gabble:10415): tp-glib-DEBUG: tp_proxy_borrow_interface_by_id: 0x687400: org.freedesktop.DBus DBusGProxy is 0x67e2a0(telepathy-gabble:10415): tp-glib-DEBUG: tp_base_connection_constructor: Handle repo for type #0 at (nil)(telepathy-gabble:10415): tp-glib-DEBUG: tp_base_connection_constructor: Handle repo for type #1 at 0x67e240(telepathy-gabble:10415): tp-glib-DEBUG: tp_base_connection_constructor: Handle repo for type #2 at 0x67e300(telepathy-gabble:10415): tp-glib-DEBUG: tp_base_connection_constructor: Handle repo for type #3 at 0x679610(telepathy-gabble:10415): tp-glib-DEBUG: tp_base_connection_constructor: Handle repo for type #4 at 0x67e360(telepathy-gabble:10415): tp-glib-DEBUG: tp_base_connection_constructor: Channel factory #0 at 0x67e400(telepathy-gabble:10415): tp-glib-DEBUG: tp_base_connection_constructor: Channel factory #1 at 0x687630(telepathy-gabble:10415): tp-glib-DEBUG: tp_base_connection_constructor: Channel factory #2 at 0x68c820(telepathy-gabble:10415): tp-glib-DEBUG: tp_base_connection_constructor: Channel factory #3 at 0x68ac40(telepathy-gabble:10415): tp-glib-DEBUG: tp_base_connection_constructor: Channel factory #4 at 0x68acc0** (telepathy-gabble:10415): DEBUG: gabble_connection_constructor: Post-construction: (GabbleConnection *)0x686080(telepathy-gabble:10415): tp-glib-DEBUG: tp_presence_mixin_init: called.(telepathy-gabble:10415): tp-glib-DEBUG: tp_base_connection_register: bus name org.freedesktop.Telepathy.Connection.gabble.jabber.alice_40localhost_2fTelepathy(telepathy-gabble:10415): tp-glib-DEBUG: tp_base_connection_register: object path /org/freedesktop/Telepathy/Connection/gabble/jabber/alice_40localhost_2fTelepathy** (telepathy-gabble:10415): DEBUG: _gabble_connection_connect: disabling SRV because "server" or "port" parameter specified, will connect to localhost** (telepathy-gabble:10415): DEBUG: do_connect: calling lm_connection_openGoing to connect to localhost:5222Trying 127.0.0.1 port 5222...(telepathy-gabble:10415): tp-glib-DEBUG: tp_base_connection_change_status: was 4294967295, now 1, for reason 1(telepathy-gabble:10415): tp-glib-DEBUG: tp_base_connection_change_status: emitting status-changed to 1, for reason 1** (telepathy-gabble:10415): DEBUG: gabble_roster_factory_iface_connecting: adding callbacks** (telepathy-gabble:10415): DEBUG: gabble_muc_factory_iface_connecting: adding callbacks** (telepathy-gabble:10415): DEBUG: gabble_media_factory_iface_connecting: adding callbacks** (telepathy-gabble:10415): DEBUG: gabble_im_factory_iface_connecting: adding callbacksConnection success (2).SEND:-----------------------------------<?xml version='1.0' encoding='UTF-8'?>-----------------------------------SEND:-----------------------------------<stream:stream version="1.0" xmlns="jabber:client" xmlns:stream="http://etherx.jabber.org/streams" to="localhost" id="65596459964">-----------------------------------** (process:10409): DEBUG: on_connection_status_changed: status_changed called from tp (2)** (process:10409): DEBUG: on_connection_status_changed: status_changed called from tp (1)** (process:10409): DEBUG: connect_cb called for connection 0x62e090RECV [438]:-----------------------------------'<?xml version='1.0'?><stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='3166553682' from='localhost' version='1.0' xml:lang='en'><stream:features><starttls xmlns='urn:ietf:params:xml:ns:xmpp-tls'/><mechanisms xmlns='urn:ietf:params:xml:ns:xmpp-sasl'><mechanism>DIGEST-MD5</mechanism><mechanism>PLAIN</mechanism></mechanisms><register xmlns='http://jabber.org/features/iq-register'/></stream:features>'-----------------------------------** (telepathy-gabble:10415): DEBUG: do_auth: authenticating with username: alice, password: <hidden>, resource: TelepathySEND:-----------------------------------<starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls" id="66074461337"></starttls>-----------------------------------RECV [50]:-----------------------------------'<proceed xmlns='urn:ietf:params:xml:ns:xmpp-tls'/>'-----------------------------------** (telepathy-gabble:10415): DEBUG: connection_ssl_cb: called: The certificate can not be trusted.** (telepathy-gabble:10415): DEBUG: connection_ssl_cb: called: The server hostname doesn't match the one in the certificate.SEND:-----------------------------------<stream:stream version="1.0" xmlns="jabber:client" xmlns:stream="http://etherx.jabber.org/streams" to="localhost" id="78394524026">-----------------------------------RECV [167]:-----------------------------------'<?xml version='1.0'?><stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='1942645137' from='localhost' version='1.0' xml:lang='en'>'-----------------------------------RECV [220]:-----------------------------------'<stream:features><mechanisms xmlns='urn:ietf:params:xml:ns:xmpp-sasl'><mechanism>DIGEST-MD5</mechanism><mechanism>PLAIN</mechanism></mechanisms><register xmlns='http://jabber.org/features/iq-register'/></stream:features>'-----------------------------------SEND:-----------------------------------<auth mechanism="DIGEST-MD5" xmlns="urn:ietf:params:xml:ns:xmpp-sasl" id="15525582"></auth>-----------------------------------RECV [148]:-----------------------------------'<challenge xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>bm9uY2U9IjUzNjI1MTU5OCIscW9wPSJhdXRoIixjaGFyc2V0PXV0Zi04LGFsZ29yaXRobT1tZDUtc2Vzcw==</challenge>'-----------------------------------SEND:-----------------------------------<response xmlns="urn:ietf:params:xml:ns:xmpp-sasl" id="4132528608">dXNlcm5hbWU9ImFsaWNlIixyZWFsbT0ibG9jYWxob3N0IixkaWdlc3QtdXJpPSJ4bXBwL2xvY2FsaG9zdCIsbm9uY2U9IjUzNjI1MTU5OCIsbmM9MDAwMDAwMDEsY25vbmNlPSJLQWppckh3RUhaUFRaQ2tNYlVScW9GeDRkRVR0WkJuNGRuMDJacm5qMkRFPSIscW9wPWF1dGgsY2hhcnNldD11dGYtOCxyZXNwb25zZT1kOGU3OTZmOWJkODc4MGJiYzA0N2IxNDliMzgxZjgzYw==</response>-----------------------------------RECV [120]:-----------------------------------'<challenge xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>cnNwYXV0aD1jZjdlNTIyODdkMmNiNmNiYmY3NjA0OWZkNGU0YjUzMA==</challenge>'-----------------------------------SEND:-----------------------------------<response xmlns="urn:ietf:params:xml:ns:xmpp-sasl" id="4154531637"></response>-----------------------------------RECV [51]:-----------------------------------'<success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>'-----------------------------------SEND:-----------------------------------<stream:stream version="1.0" xmlns="jabber:client" xmlns:stream="http://etherx.jabber.org/streams" to="localhost" id="4623532427">-----------------------------------RECV [167]:-----------------------------------'<?xml version='1.0'?><stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='3860164569' from='localhost' version='1.0' xml:lang='en'>'-----------------------------------RECV [137]:-----------------------------------'<stream:features><bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'/><session xmlns='urn:ietf:params:xml:ns:xmpp-session'/></stream:features>'-----------------------------------SEND:-----------------------------------<iq type="set" id="8220533527"> <bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"> <resource>Telepathy</resource></bind></iq>-----------------------------------RECV [129]:-----------------------------------'<iq id='8220533527' type='result'><bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'><jid>alice@localhost/Telepathy</jid></bind></iq>'-----------------------------------SEND:-----------------------------------<iq type="set" id="8200534528"> <session xmlns="urn:ietf:params:xml:ns:xmpp-session"></session></iq>-----------------------------------** (telepathy-gabble:10415): DEBUG: connection_auth_cb: Created self handle 1, our JID is alice@localhost/Telepathy** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: about to add caps 869 to resource Telepathy with serial 1** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: found resource Telepathy** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: new serial 1, old 0, clearing caps** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: adding caps 869 to resource Telepathy** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: resource Telepathy caps now 869** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: total caps now 869** (telepathy-gabble:10415): DEBUG: gabble_disco_request_with_timeout: Creating disco request 0x68b100 for localhostSEND:-----------------------------------<iq type="get" to="localhost" id="8745535136"> <query xmlns="http://jabber.org/protocol/disco#info"></query></iq>-----------------------------------RECV [95]:-----------------------------------'<iq type='result' id='8200534528'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/></iq>'-----------------------------------** (telepathy-gabble:10415): DEBUG: connection_iq_unknown_cb: got unknown iq:<iq id="8200534528" type="result"> <session xmlns="urn:ietf:params:xml:ns:xmpp-session"></session></iq>RECV [1023]:-----------------------------------'<iq from='localhost' to='alice@localhost/Telepathy' id='8745535136' type='result'><query xmlns='http://jabber.org/protocol/disco#info'><identity category='pubsub' type='pep'/><identity category='server' type='im' name='ejabberd'/><feature var='http://jabber.org/protocol/commands'/><feature var='http://jabber.org/protocol/disco#info'/><feature var='http://jabber.org/protocol/disco#items'/><feature var='http://jabber.org/protocol/disco#publish'/><feature var='http://jabber.org/protocol/pubsub'/><feature var='http://jabber.org/protocol/pubsub#owner'/><feature var='http://jabber.org/protocol/stats'/><feature var='iq'/><feature var='jabber:iq:last'/><feature var='jabber:iq:register'/><feature var='jabber:iq:time'/><feature var='jabber:iq:version'/><feature var='presence'/><feature var='presence-invisible'/><feature var='vcard-temp'/><feature var='http://jabber.org/protocol/pubsub#access-open'/><feature var='http://jabber.org/protocol/pubsub#auto-create'/><feature var='http://jabber.org/protocol/pubsub#auto-subscr'-----------------------------------RECV [1023]:-----------------------------------'ibe'/><feature var='http://jabber.org/protocol/pubsub#collections'/><feature var='http://jabber.org/protocol/pubsub#config-node'/><feature var='http://jabber.org/protocol/pubsub#create-and-configure'/><feature var='http://jabber.org/protocol/pubsub#create-nodes'/><feature var='http://jabber.org/protocol/pubsub#delete-nodes'/><feature var='http://jabber.org/protocol/pubsub#filtered-notifications'/><feature var='http://jabber.org/protocol/pubsub#instant-nodes'/><feature var='http://jabber.org/protocol/pubsub#item-ids'/><feature var='http://jabber.org/protocol/pubsub#last-published'/><feature var='http://jabber.org/protocol/pubsub#manage-subscriptions'/><feature var='http://jabber.org/protocol/pubsub#modify-affiliations'/><feature var='http://jabber.org/protocol/pubsub#outcast-affiliation'/><feature var='http://jabber.org/protocol/pubsub#persistent-items'/><feature var='http://jabber.org/protocol/pubsub#presence-notifications'/><feature var='http://jabber.org/protocol/pubsub#presence-subscribe'/><feature var='h'-----------------------------------RECV [720]:-----------------------------------'ttp://jabber.org/protocol/pubsub#publish'/><feature var='http://jabber.org/protocol/pubsub#publisher-affiliation'/><feature var='http://jabber.org/protocol/pubsub#purge-nodes'/><feature var='http://jabber.org/protocol/pubsub#retract-items'/><feature var='http://jabber.org/protocol/pubsub#retrieve-affiliations'/><feature var='http://jabber.org/protocol/pubsub#retrieve-default'/><feature var='http://jabber.org/protocol/pubsub#retrieve-items'/><feature var='http://jabber.org/protocol/pubsub#retrieve-subscriptions'/><feature var='http://jabber.org/protocol/pubsub#subscribe'/><feature var='http://jabber.org/protocol/pubsub#subscription-notifications'/><feature var='http://jabber.org/protocol/commands'/></query></iq>'-----------------------------------** (telepathy-gabble:10415): 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#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:10415): DEBUG: connection_disco_cb: set features flags to 20SEND:-----------------------------------<presence id="12858539442"> <x xmlns="vcard-temp:x:update"></x> <c ver="0.7.2.1" node="http://telepathy.freedesktop.org/caps" xmlns="http://jabber.org/protocol/caps"></c></presence>-----------------------------------(telepathy-gabble:10415): tp-glib-DEBUG: tp_base_connection_change_status: was 1, now 0, for reason 1(telepathy-gabble:10415): tp-glib-DEBUG: tp_base_connection_change_status: emitting status-changed to 0, for reason 1** (telepathy-gabble:10415): DEBUG: gabble_disco_conn_status_changed_cb: connected, initiating service discovery on localhost** (telepathy-gabble:10415): DEBUG: gabble_disco_request_with_timeout: Creating disco request 0x671300 for localhostSEND:-----------------------------------<iq type="get" to="localhost" id="12303539908"> <query xmlns="http://jabber.org/protocol/disco#items"></query></iq>-----------------------------------** (telepathy-gabble:10415): DEBUG: gabble_vcard_manager_request: Created request 0x68f8f0 to retrieve <1>'s vCard** (telepathy-gabble:10415): DEBUG: cache_entry_ensure_queued: Cache entry 0x68f8c0 is my own, not setting @to** (telepathy-gabble:10415): DEBUG: gabble_request_pipeline_enqueue: enqueued new request as item 0x68f920** (telepathy-gabble:10415): DEBUG: cache_entry_ensure_queued: adding request to cache entry 0x68f8c0 and queueing the <iq>(telepathy-gabble:10415): tp-glib-DEBUG: tp_presence_mixin_emit_presence_update: called.(telepathy-gabble:10415): tp-glib-DEBUG: construct_presence_hash: called.SEND:-----------------------------------<iq type="set" id="12857540654"> <pubsub xmlns="http://jabber.org/protocol/pubsub"> <publish node="http://laptop.org/xmpp/activities"> <item> <activities xmlns="http://laptop.org/xmpp/activities"></activities></item></publish></pubsub></iq>-----------------------------------SEND:-----------------------------------<iq type="set" id="34540950"> <pubsub xmlns="http://jabber.org/protocol/pubsub"> <publish node="http://laptop.org/xmpp/activity-properties"> <item> <activities xmlns="http://laptop.org/xmpp/activity-properties"></activities></item></publish></pubsub></iq>-----------------------------------** (telepathy-gabble:10415): DEBUG: gabble_roster_factory_iface_connected: requesting rosterSEND:-----------------------------------<iq type="get" id="552541273"> <query xmlns="jabber:iq:roster"></query></iq>-----------------------------------** (process:10409): DEBUG: on_connection_status_changed: status_changed called from tp (0)** (process:10409): DEBUG: Emitting account status changed for jabber1: status = 0, reason = 1** (process:10409): DEBUG: _mcd_presence_frame_update_actual_status called** (process:10409): DEBUG: _mcd_presence_frame_update_actual_status: status actual: 0** (process:10409): DEBUG: mcd_presence_frame_set_account_presence: changing presence of account jabber1 from 0 to 2** (process:10409): DEBUG: Emitting presence changed for jabber1: presence = 2, message = (null)** (process:10409): DEBUG: _mcd_presence_frame_update_actual_presence called** (process:10409): DEBUG: _mcd_presence_frame_update_actual_presence: presence actual: 2** (process:10409): DEBUG: _mcd_presence_frame_update_stable: account_presence = 0x61db80** (process:10409): DEBUG: _mcd_presence_frame_check_stable: status = 0** (process:10409): DEBUG: on_presence_stable called** (telepathy-gabble:10415): DEBUG: send_next_request: processing request 0x68f920SEND:-----------------------------------<iq type="get" id="12841540253"> <vCard xmlns="vcard-temp"></vCard></iq>-----------------------------------** (process:10409): DEBUG: on_connection_ready_notify: 1** (process:10409): DEBUG: _mcd_connection_setup_capabilities: advertising capabilities** (process:10409): DEBUG: checking for server token(telepathy-gabble:10415): tp-glib-DEBUG: tp_presence_mixin_get_statuses: called.** (process:10409): DEBUG: Account jabber1 changed** (telepathy-gabble:10415): DEBUG: gabble_connection_advertise_capabilities: caps before: 365** (telepathy-gabble:10415): DEBUG: gabble_connection_advertise_capabilities: caps to add: 1a** (telepathy-gabble:10415): DEBUG: gabble_connection_advertise_capabilities: caps to remove: 0** (telepathy-gabble:10415): DEBUG: gabble_connection_advertise_capabilities: caps after: 37f** (telepathy-gabble:10415): DEBUG: gabble_connection_advertise_capabilities: before != after, changing** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: about to add caps 895 to resource Telepathy with serial 2** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: found resource Telepathy** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: new serial 2, old 1, clearing caps** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: adding caps 895 to resource Telepathy** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: resource Telepathy caps now 895** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: total caps now 895** (telepathy-gabble:10415): DEBUG: gabble_connection_advertise_capabilities: set caps: 37fSEND:-----------------------------------<presence id="4633548619"> <x xmlns="vcard-temp:x:update"></x> <c ext="voice-v1 jingle-audio jingle-video" ver="0.7.2.1" node="http://telepathy.freedesktop.org/caps" xmlns="http://jabber.org/protocol/caps"></c></presence>-----------------------------------** (process:10409): DEBUG: Using offline status for McPresence 1** (process:10409): DEBUG: Using available status for McPresence 2** (process:10409): DEBUG: Using away status for McPresence 3** (process:10409): DEBUG: Using xa status for McPresence 4** (process:10409): DEBUG: Using hidden status for McPresence 5** (process:10409): DEBUG: Using dnd status for McPresence 6(telepathy-gabble:10415): tp-glib-DEBUG: tp_presence_mixin_set_status: called.(telepathy-gabble:10415): tp-glib-DEBUG: set_status_foreach: called.(telepathy-gabble:10415): tp-glib-DEBUG: set_status_foreach: Found status "available", checking if it's available...(telepathy-gabble:10415): tp-glib-DEBUG: set_status_foreach: The status is available.(telepathy-gabble:10415): tp-glib-DEBUG: set_status_foreach: Got optional argument ("message", "")(telepathy-gabble:10415): tp-glib-DEBUG: set_status_foreach: About to try setting status "available"(telepathy-gabble:10415): tp-glib-DEBUG: tp_presence_mixin_emit_presence_update: called.(telepathy-gabble:10415): tp-glib-DEBUG: construct_presence_hash: called.SEND:-----------------------------------<presence id="8729551818"> <status></status> <x xmlns="vcard-temp:x:update"></x> <c ext="voice-v1 jingle-audio jingle-video" ver="0.7.2.1" node="http://telepathy.freedesktop.org/caps" xmlns="http://jabber.org/protocol/caps"></c></presence>-----------------------------------** (process:10409): DEBUG: mcd_presence_frame_set_account_presence: changing presence of account jabber1 from 2 to 2** (process:10409): DEBUG: Emitting presence changed for jabber1: presence = 2, message = ** (process:10409): DEBUG: _mcd_presence_frame_update_actual_presence called** (process:10409): DEBUG: _mcd_presence_frame_update_actual_presence: presence actual: 2** (process:10409): DEBUG: mcd_service_register_filter: Registering new filter** (process:10409): DEBUG: mcd_service_register_filter: Registering new filterRECV [241]:-----------------------------------'<presence from='alice@localhost/Telepathy' to='alice@localhost/Telepathy' id='12858539442'> <x xmlns='vcard-temp:x:update'/> <c ver='0.7.2.1' node='http://telepathy.freedesktop.org/caps' xmlns='http://jabber.org/protocol/caps'/></presence>'-----------------------------------** (telepathy-gabble:10415): DEBUG: gabble_roster_presence_cb: ignoring presence from ourselves on another resource:<presence id="12858539442" to="alice@localhost/Telepathy" from="alice@localhost/Telepathy"> <x xmlns="vcard-temp:x:update"></x> <c xmlns="http://jabber.org/protocol/caps" node="http://telepathy.freedesktop.org/caps" ver="0.7.2.1"></c></presence>** (telepathy-gabble:10415): DEBUG: gabble_presence_cache_update: alice@localhost (1) resource Telepathy prio 0 presence 5 message "(null)"(telepathy-gabble:10415): tp-glib-DEBUG: tp_presence_mixin_emit_presence_update: called.(telepathy-gabble:10415): tp-glib-DEBUG: construct_presence_hash: called.** (telepathy-gabble:10415): DEBUG: _process_caps_uri: enough trust for URI http://telepathy.freedesktop.org/caps#0.7.2.1, setting caps for 1 (alice@localhost/Telepathy) to 869** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: about to add caps 869 to resource Telepathy with serial 1** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: found resource Telepathy** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: new serial 1, old 0, clearing caps** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: adding caps 869 to resource Telepathy** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: resource Telepathy caps now 869** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: total caps now 869** (telepathy-gabble:10415): DEBUG: _process_caps_uri: caps for 1 (alice@localhost/Telepathy) now 869** (telepathy-gabble:10415): DEBUG: _process_caps: Emitting caps update: handle 1, old 0, new 869RECV [308]:-----------------------------------'<presence from='bernard@localhost/Telepathy' to='alice@localhost/Telepathy' id='65848331563'> <status/> <x xmlns='vcard-temp:x:update'> <photo/></x> <c ext='voice-v1 jingle-audio jingle-video' ver='0.7.2.1' node='http://telepathy.freedesktop.org/caps' xmlns='http://jabber.org/protocol/caps'/></presence>'-----------------------------------** (telepathy-gabble:10415): DEBUG: gabble_presence_cache_update: bernard@localhost (2) resource Telepathy prio 0 presence 5 message "(null)"(telepathy-gabble:10415): tp-glib-DEBUG: tp_presence_mixin_emit_presence_update: called.(telepathy-gabble:10415): tp-glib-DEBUG: construct_presence_hash: called.** (telepathy-gabble:10415): DEBUG: _process_caps_uri: enough trust for URI http://telepathy.freedesktop.org/caps#jingle-video, setting caps for 2 (bernard@localhost/Telepathy) to 16** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: about to add caps 16 to resource Telepathy with serial 2** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: found resource Telepathy** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: new serial 2, old 0, clearing caps** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: adding caps 16 to resource Telepathy** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: resource Telepathy caps now 16** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: total caps now 16** (telepathy-gabble:10415): DEBUG: _process_caps_uri: caps for 2 (bernard@localhost/Telepathy) now 16** (telepathy-gabble:10415): DEBUG: _process_caps_uri: enough trust for URI http://telepathy.freedesktop.org/caps#jingle-audio, setting caps for 2 (bernard@localhost/Telepathy) to 8** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: about to add caps 8 to resource Telepathy with serial 2** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: found resource Telepathy** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: adding caps 8 to resource Telepathy** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: resource Telepathy caps now 24** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: total caps now 24** (telepathy-gabble:10415): DEBUG: _process_caps_uri: caps for 2 (bernard@localhost/Telepathy) now 24** (telepathy-gabble:10415): DEBUG: _process_caps_uri: enough trust for URI http://telepathy.freedesktop.org/caps#voice-v1, setting caps for 2 (bernard@localhost/Telepathy) to 2** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: about to add caps 2 to resource Telepathy with serial 2** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: found resource Telepathy** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: adding caps 2 to resource Telepathy** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: resource Telepathy caps now 26** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: total caps now 26** (telepathy-gabble:10415): DEBUG: _process_caps_uri: caps for 2 (bernard@localhost/Telepathy) now 26** (telepathy-gabble:10415): DEBUG: _process_caps_uri: enough trust for URI http://telepathy.freedesktop.org/caps#0.7.2.1, setting caps for 2 (bernard@localhost/Telepathy) to 869** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: about to add caps 869 to resource Telepathy with serial 2** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: found resource Telepathy** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: adding caps 869 to resource Telepathy** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: resource Telepathy caps now 895** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: total caps now 895** (telepathy-gabble:10415): DEBUG: _process_caps_uri: caps for 2 (bernard@localhost/Telepathy) now 895** (telepathy-gabble:10415): DEBUG: _process_caps: Emitting caps update: handle 2, old 0, new 895RECV [298]:-----------------------------------'<iq from='localhost' to='alice@localhost/Telepathy' id='12303539908' type='result'><query xmlns='http://jabber.org/protocol/disco#items'><item jid='conference.localhost'/><item jid='irc.localhost'/><item jid='proxy.localhost'/><item jid='pubsub.localhost'/><item jid='vjud.localhost'/></query></iq>'-----------------------------------** (telepathy-gabble:10415): DEBUG: disco_items_cb: discovered service item: conference.localhost** (telepathy-gabble:10415): DEBUG: disco_items_cb: discovered service item: irc.localhost** (telepathy-gabble:10415): DEBUG: disco_items_cb: discovered service item: proxy.localhost** (telepathy-gabble:10415): DEBUG: disco_items_cb: discovered service item: pubsub.localhost** (telepathy-gabble:10415): DEBUG: disco_items_cb: discovered service item: vjud.localhost** (telepathy-gabble:10415): DEBUG: gabble_disco_request_with_timeout: Creating disco request 0x68b140 for irc.localhostSEND:-----------------------------------<iq type="get" to="irc.localhost" id="65611640123"> <query xmlns="http://jabber.org/protocol/disco#info"></query></iq>-----------------------------------** (telepathy-gabble:10415): DEBUG: gabble_disco_request_with_timeout: Creating disco request 0x68b380 for proxy.localhostSEND:-----------------------------------<iq type="get" to="proxy.localhost" id="65560640455"> <query xmlns="http://jabber.org/protocol/disco#info"></query></iq>-----------------------------------** (telepathy-gabble:10415): DEBUG: gabble_disco_request_with_timeout: Creating disco request 0x722f40 for pubsub.localhostSEND:-----------------------------------<iq type="get" to="pubsub.localhost" id="66121640695"> <query xmlns="http://jabber.org/protocol/disco#info"></query></iq>-----------------------------------** (telepathy-gabble:10415): DEBUG: gabble_disco_request_with_timeout: Creating disco request 0x722f00 for conference.localhostSEND:-----------------------------------<iq type="get" to="conference.localhost" id="65570641039"> <query xmlns="http://jabber.org/protocol/disco#info"></query></iq>-----------------------------------** (telepathy-gabble:10415): DEBUG: gabble_disco_request_with_timeout: Creating disco request 0x722ec0 for vjud.localhostSEND:-----------------------------------<iq type="get" to="vjud.localhost" id="65614641272"> <query xmlns="http://jabber.org/protocol/disco#info"></query></iq>-----------------------------------RECV [208]:-----------------------------------'<iq from='alice@localhost/Telepathy' to='alice@localhost/Telepathy' id='552541273' type='result'><query xmlns='jabber:iq:roster'><item subscription='both' name='bernard' jid='bernard@localhost'/></query></iq>'-----------------------------------** (telepathy-gabble:10415): DEBUG: _gabble_roster_get_channel: Looking up channel 3:1 "publish"** (telepathy-gabble:10415): DEBUG: _gabble_roster_create_channel: Instantiating channel 3:1 "publish"[37mtp_group_mixin_change_flags: emitting group flags changed added : [[22mCAN_REMOVE|MESSAGE_REMOVE|MESSAGE_ACCEPT[1m] removed : [[22m[1m] flags now: [[22mCAN_REMOVE|MESSAGE_REMOVE|MESSAGE_ACCEPT[1m][0m** (telepathy-gabble:10415): DEBUG: _gabble_roster_create_channel: created /org/freedesktop/Telepathy/Connection/gabble/jabber/alice_40localhost_2fTelepathy/RosterChannel/List/publish** (telepathy-gabble:10415): DEBUG: _gabble_roster_create_channel: roster not yet received, not emitting signal for publish list channel** (telepathy-gabble:10415): DEBUG: _gabble_roster_get_channel: Looking up channel 3:2 "subscribe"** (telepathy-gabble:10415): DEBUG: _gabble_roster_create_channel: Instantiating channel 3:2 "subscribe"[37mtp_group_mixin_change_flags: emitting group flags changed added : [[22mCAN_ADD|CAN_REMOVE|CAN_RESCIND|MESSAGE_ADD|MESSAGE_REMOVE|MESSAGE_RESCIND[1m] removed : [[22m[1m] flags now: [[22mCAN_ADD|CAN_REMOVE|CAN_RESCIND|MESSAGE_ADD|MESSAGE_REMOVE|MESSAGE_RESCIND[1m][0m** (telepathy-gabble:10415): DEBUG: _gabble_roster_create_channel: created /org/freedesktop/Telepathy/Connection/gabble/jabber/alice_40localhost_2fTelepathy/RosterChannel/List/subscribe** (telepathy-gabble:10415): DEBUG: _gabble_roster_create_channel: roster not yet received, not emitting signal for subscribe list channel** (telepathy-gabble:10415): DEBUG: _gabble_roster_item_update: name for contact#2 changed to bernard** (telepathy-gabble:10415): DEBUG: _gabble_roster_item_update: Checking which groups contact#2 was just added to:** (telepathy-gabble:10415): DEBUG: _gabble_roster_item_update: Checking which groups contact#2 was just removed from:** (telepathy-gabble:10415): DEBUG: gabble_roster_iq_cb: jid: bernard@localhost, subscription: both, name: bernard** (telepathy-gabble:10415): DEBUG: gabble_roster_iq_cb: calling change members on publish channel[36mtp_group_mixin_change_members: emitting members changed message : "" added : [[22m2 (bernard@localhost)[1m] removed : [[22m[1m] local_pending : [[22m[1m] remote_pending: [[22m[1m] actor : 0 reason : 0: unspecified reason[0m** (telepathy-gabble:10415): DEBUG: gabble_roster_iq_cb: calling change members on subscribe channel[36mtp_group_mixin_change_members: emitting members changed message : "" added : [[22m2 (bernard@localhost)[1m] removed : [[22m[1m] local_pending : [[22m[1m] remote_pending: [[22m[1m] actor : 0 reason : 0: unspecified reason[0m** (telepathy-gabble:10415): DEBUG: _gabble_roster_get_channel: Looking up channel 3:3 "known"** (telepathy-gabble:10415): DEBUG: _gabble_roster_create_channel: Instantiating channel 3:3 "known"[37mtp_group_mixin_change_flags: emitting group flags changed added : [[22mCAN_REMOVE[1m] removed : [[22m[1m] flags now: [[22mCAN_REMOVE[1m][0m** (telepathy-gabble:10415): DEBUG: _gabble_roster_create_channel: created /org/freedesktop/Telepathy/Connection/gabble/jabber/alice_40localhost_2fTelepathy/RosterChannel/List/known** (telepathy-gabble:10415): DEBUG: _gabble_roster_create_channel: roster not yet received, not emitting signal for known list channel** (telepathy-gabble:10415): DEBUG: gabble_roster_iq_cb: calling change members on known channel[36mtp_group_mixin_change_members: emitting members changed message : "" added : [[22m2 (bernard@localhost)[1m] removed : [[22m[1m] local_pending : [[22m[1m] remote_pending: [[22m[1m] actor : 0 reason : 0: unspecified reason[0m** (telepathy-gabble:10415): DEBUG: gabble_roster_iq_cb: calling change members on any group channels** (telepathy-gabble:10415): DEBUG: _gabble_roster_emit_one: roster now received, emitting signal signal for publish list channel(telepathy-gabble:10415): tp-glib-DEBUG: satisfy_requests: called for /org/freedesktop/Telepathy/Connection/gabble/jabber/alice_40localhost_2fTelepathy/RosterChannel/List/publish** (telepathy-gabble:10415): DEBUG: _gabble_roster_emit_one: roster now received, emitting signal signal for subscribe list channel(telepathy-gabble:10415): tp-glib-DEBUG: satisfy_requests: called for /org/freedesktop/Telepathy/Connection/gabble/jabber/alice_40localhost_2fTelepathy/RosterChannel/List/subscribe** (telepathy-gabble:10415): DEBUG: _gabble_roster_emit_one: roster now received, emitting signal signal for known list channel(telepathy-gabble:10415): tp-glib-DEBUG: satisfy_requests: called for /org/freedesktop/Telepathy/Connection/gabble/jabber/alice_40localhost_2fTelepathy/RosterChannel/List/knownRECV [281]:-----------------------------------'<presence from='alice@localhost/Telepathy' to='alice@localhost/Telepathy' id='4633548619'> <x xmlns='vcard-temp:x:update'/> <c ext='voice-v1 jingle-audio jingle-video' ver='0.7.2.1' node='http://telepathy.freedesktop.org/caps' xmlns='http://jabber.org/protocol/caps'/></presence>'-----------------------------------** (telepathy-gabble:10415): DEBUG: gabble_roster_presence_cb: ignoring presence from ourselves on another resource:<presence id="4633548619" to="alice@localhost/Telepathy" from="alice@localhost/Telepathy"> <x xmlns="vcard-temp:x:update"></x> <c xmlns="http://jabber.org/protocol/caps" node="http://telepathy.freedesktop.org/caps" ver="0.7.2.1" ext="voice-v1 jingle-audio jingle-video"></c></presence>** (telepathy-gabble:10415): DEBUG: gabble_presence_cache_update: alice@localhost (1) resource Telepathy prio 0 presence 5 message "(null)"** (telepathy-gabble:10415): DEBUG: _process_caps_uri: enough trust for URI http://telepathy.freedesktop.org/caps#jingle-video, setting caps for 1 (alice@localhost/Telepathy) to 16** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: about to add caps 16 to resource Telepathy with serial 3** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: found resource Telepathy** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: new serial 3, old 1, clearing caps** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: adding caps 16 to resource Telepathy** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: resource Telepathy caps now 16** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: total caps now 16** (telepathy-gabble:10415): DEBUG: _process_caps_uri: caps for 1 (alice@localhost/Telepathy) now 16** (telepathy-gabble:10415): DEBUG: _process_caps_uri: enough trust for URI http://telepathy.freedesktop.org/caps#jingle-audio, setting caps for 1 (alice@localhost/Telepathy) to 8** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: about to add caps 8 to resource Telepathy with serial 3** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: found resource Telepathy** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: adding caps 8 to resource Telepathy** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: resource Telepathy caps now 24** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: total caps now 24** (telepathy-gabble:10415): DEBUG: _process_caps_uri: caps for 1 (alice@localhost/Telepathy) now 24** (telepathy-gabble:10415): DEBUG: _process_caps_uri: enough trust for URI http://telepathy.freedesktop.org/caps#voice-v1, setting caps for 1 (alice@localhost/Telepathy) to 2** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: about to add caps 2 to resource Telepathy with serial 3** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: found resource Telepathy** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: adding caps 2 to resource Telepathy** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: resource Telepathy caps now 26** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: total caps now 26** (telepathy-gabble:10415): DEBUG: _process_caps_uri: caps for 1 (alice@localhost/Telepathy) now 26** (telepathy-gabble:10415): DEBUG: _process_caps_uri: enough trust for URI http://telepathy.freedesktop.org/caps#0.7.2.1, setting caps for 1 (alice@localhost/Telepathy) to 869** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: about to add caps 869 to resource Telepathy with serial 3** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: found resource Telepathy** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: adding caps 869 to resource Telepathy** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: resource Telepathy caps now 895** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: total caps now 895** (telepathy-gabble:10415): DEBUG: _process_caps_uri: caps for 1 (alice@localhost/Telepathy) now 895** (telepathy-gabble:10415): DEBUG: _process_caps: Emitting caps update: handle 1, old 869, new 895RECV [281]:-----------------------------------'<presence from='alice@localhost/Telepathy' to='alice@localhost/Telepathy' id='4633548619'> <x xmlns='vcard-temp:x:update'/> <c ext='voice-v1 jingle-audio jingle-video' ver='0.7.2.1' node='http://telepathy.freedesktop.org/caps' xmlns='http://jabber.org/protocol/caps'/></presence>'-----------------------------------** (telepathy-gabble:10415): DEBUG: gabble_roster_presence_cb: ignoring presence from ourselves on another resource:<presence id="4633548619" to="alice@localhost/Telepathy" from="alice@localhost/Telepathy"> <x xmlns="vcard-temp:x:update"></x> <c xmlns="http://jabber.org/protocol/caps" node="http://telepathy.freedesktop.org/caps" ver="0.7.2.1" ext="voice-v1 jingle-audio jingle-video"></c></presence>** (telepathy-gabble:10415): DEBUG: gabble_presence_cache_update: alice@localhost (1) resource Telepathy prio 0 presence 5 message "(null)"** (telepathy-gabble:10415): DEBUG: _process_caps_uri: enough trust for URI http://telepathy.freedesktop.org/caps#jingle-video, setting caps for 1 (alice@localhost/Telepathy) to 16** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: about to add caps 16 to resource Telepathy with serial 4** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: found resource Telepathy** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: new serial 4, old 3, clearing caps** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: adding caps 16 to resource Telepathy** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: resource Telepathy caps now 16** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: total caps now 16** (telepathy-gabble:10415): DEBUG: _process_caps_uri: caps for 1 (alice@localhost/Telepathy) now 16** (telepathy-gabble:10415): DEBUG: _process_caps_uri: enough trust for URI http://telepathy.freedesktop.org/caps#jingle-audio, setting caps for 1 (alice@localhost/Telepathy) to 8** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: about to add caps 8 to resource Telepathy with serial 4** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: found resource Telepathy** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: adding caps 8 to resource Telepathy** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: resource Telepathy caps now 24** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: total caps now 24** (telepathy-gabble:10415): DEBUG: _process_caps_uri: caps for 1 (alice@localhost/Telepathy) now 24** (telepathy-gabble:10415): DEBUG: _process_caps_uri: enough trust for URI http://telepathy.freedesktop.org/caps#voice-v1, setting caps for 1 (alice@localhost/Telepathy) to 2** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: about to add caps 2 to resource Telepathy with serial 4** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: found resource Telepathy** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: adding caps 2 to resource Telepathy** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: resource Telepathy caps now 26** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: total caps now 26** (telepathy-gabble:10415): DEBUG: _process_caps_uri: caps for 1 (alice@localhost/Telepathy) now 26** (telepathy-gabble:10415): DEBUG: _process_caps_uri: enough trust for URI http://telepathy.freedesktop.org/caps#0.7.2.1, setting caps for 1 (alice@localhost/Telepathy) to 869** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: about to add caps 869 to resource Telepathy with serial 4** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: found resource Telepathy** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: adding caps 869 to resource Telepathy** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: resource Telepathy caps now 895** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: total caps now 895** (telepathy-gabble:10415): DEBUG: _process_caps_uri: caps for 1 (alice@localhost/Telepathy) now 895** (telepathy-gabble:10415): DEBUG: _process_caps: No change in caps 895 for handle 1, not updatingRECV [178]:-----------------------------------'<iq from='alice@localhost' to='alice@localhost/Telepathy' id='12841540253' type='result'><vCard xmlns='vcard-temp' version='2.0' prodid='-//HandGen//NONSGML vGen v1.0//EN'/></iq>'-----------------------------------** (telepathy-gabble:10415): DEBUG: response_cb: got reply for request 0x68f920** (telepathy-gabble:10415): DEBUG: pipeline_reply_cb: called for entry 0x68f8c0** (telepathy-gabble:10415): DEBUG: observe_vcard: got no vCard alias for handle 1SEND:-----------------------------------<presence id="74268648135"> <status></status> <x xmlns="vcard-temp:x:update"> <photo></photo></x> <c ext="voice-v1 jingle-audio jingle-video" ver="0.7.2.1" node="http://telepathy.freedesktop.org/caps" xmlns="http://jabber.org/protocol/caps"></c></presence>-----------------------------------** (telepathy-gabble:10415): DEBUG: delete_request: Discarding request 0x68f8f0** (telepathy-gabble:10415): DEBUG: cache_entry_attempt_to_free: Not freeing vCard cache entry 0x68f8c0: it has a cached vCard 0x722250** (telepathy-gabble:10415): DEBUG: delete_item: deleting item 0x68f920RECV [90]:-----------------------------------'<iq from='alice@localhost' to='alice@localhost/Telepathy' id='12857540654' type='result'/>'-----------------------------------RECV [87]:-----------------------------------'<iq from='alice@localhost' to='alice@localhost/Telepathy' id='34540950' type='result'/>'-----------------------------------** (process:10409): DEBUG: on_aliases_changed called** (process:10409): DEBUG: Got alias for contact 2: bernard** (process:10409): DEBUG: _mcd_mission_set_parent: child = 0x626a40, parent = 0x62e090** (process:10409): DEBUG: _mcd_dispatcher_get_filter_chain: No chains for interface org.freedesktop.Telepathy.Channel.Type.ContactList** (process:10409): DEBUG: No filters found for type org.freedesktop.Telepathy.Channel.Type.ContactList, starting the channel handler(process:10409): GLib-CRITICAL **: g_hash_table_lookup: assertion `hash_table != NULL' failed(process:10409): GLib-CRITICAL **: g_hash_table_lookup: assertion `hash_table != NULL' failed** (process:10409): DEBUG: No handler for channel type org.freedesktop.Telepathy.Channel.Type.ContactList** (process:10409): DEBUG: _on_dispatcher_channel_dispatch_failed** (process:10409): DEBUG: MC ERROR (channel request): No handler for channel type org.freedesktop.Telepathy.Channel.Type.ContactList** (process:10409): DEBUG: _mcd_mission_set_parent: child = 0x626af0, parent = 0x62e090** (process:10409): DEBUG: _mcd_dispatcher_get_filter_chain: No chains for interface org.freedesktop.Telepathy.Channel.Type.ContactList** (process:10409): DEBUG: No filters found for type org.freedesktop.Telepathy.Channel.Type.ContactList, starting the channel handler(process:10409): GLib-CRITICAL **: g_hash_table_lookup: assertion `hash_table != NULL' failed(process:10409): GLib-CRITICAL **: g_hash_table_lookup: assertion `hash_table != NULL' failed** (process:10409): DEBUG: No handler for channel type org.freedesktop.Telepathy.Channel.Type.ContactList** (process:10409): DEBUG: _on_dispatcher_channel_dispatch_failed** (process:10409): DEBUG: MC ERROR (channel request): No handler for channel type org.freedesktop.Telepathy.Channel.Type.ContactList** (process:10409): DEBUG: _mcd_mission_set_parent: child = 0x626ba0, parent = 0x62e090** (process:10409): DEBUG: _mcd_dispatcher_get_filter_chain: No chains for interface org.freedesktop.Telepathy.Channel.Type.ContactList** (process:10409): DEBUG: No filters found for type org.freedesktop.Telepathy.Channel.Type.ContactList, starting the channel handler(process:10409): GLib-CRITICAL **: g_hash_table_lookup: assertion `hash_table != NULL' failed(process:10409): GLib-CRITICAL **: g_hash_table_lookup: assertion `hash_table != NULL' failed** (process:10409): DEBUG: No handler for channel type org.freedesktop.Telepathy.Channel.Type.ContactList** (process:10409): DEBUG: _on_dispatcher_channel_dispatch_failed** (process:10409): DEBUG: MC ERROR (channel request): No handler for channel type org.freedesktop.Telepathy.Channel.Type.ContactList** (process:10409): DEBUG: on_avatar_updated: contact 1, token: ** (process:10409): DEBUG: _mcd_channel_ready: handle 3, type 1** (process:10409): DEBUG: _mcd_channel_ready: handle 3, type 2** (process:10409): DEBUG: _mcd_channel_ready: handle 3, type 3** (process:10409): DEBUG: channel 0x626a40: got self handle 0** (process:10409): DEBUG: 0 local pending members, adding** (process:10409): DEBUG: lookup_actor called** (process:10409): DEBUG: lookup_actor: inviter not found** (process:10409): DEBUG: channel 0x626af0: got self handle 0** (process:10409): DEBUG: 0 local pending members, adding** (process:10409): DEBUG: lookup_actor called** (process:10409): DEBUG: lookup_actor: inviter not found** (process:10409): DEBUG: channel 0x626ba0: got self handle 0** (process:10409): DEBUG: 0 local pending members, adding** (process:10409): DEBUG: lookup_actor called** (process:10409): DEBUG: lookup_actor: inviter not found(telepathy-gabble:10415): tp-glib-DEBUG: tp_presence_mixin_get_presence: called.(telepathy-gabble:10415): tp-glib-DEBUG: construct_presence_hash: called.RECV [292]:-----------------------------------'<presence from='alice@localhost/Telepathy' to='alice@localhost/Telepathy' id='8729551818'> <status/> <x xmlns='vcard-temp:x:update'/> <c ext='voice-v1 jingle-audio jingle-video' ver='0.7.2.1' node='http://telepathy.freedesktop.org/caps' xmlns='http://jabber.org/protocol/caps'/></presence>'-----------------------------------** (telepathy-gabble:10415): DEBUG: gabble_roster_presence_cb: ignoring presence from ourselves on another resource:<presence id="8729551818" to="alice@localhost/Telepathy" from="alice@localhost/Telepathy"> <status></status> <x xmlns="vcard-temp:x:update"></x> <c xmlns="http://jabber.org/protocol/caps" node="http://telepathy.freedesktop.org/caps" ver="0.7.2.1" ext="voice-v1 jingle-audio jingle-video"></c></presence>** (telepathy-gabble:10415): DEBUG: gabble_presence_cache_update: alice@localhost (1) resource Telepathy prio 0 presence 5 message "(null)"** (telepathy-gabble:10415): DEBUG: _process_caps_uri: enough trust for URI http://telepathy.freedesktop.org/caps#jingle-video, setting caps for 1 (alice@localhost/Telepathy) to 16** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: about to add caps 16 to resource Telepathy with serial 5** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: found resource Telepathy** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: new serial 5, old 4, clearing caps** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: adding caps 16 to resource Telepathy** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: resource Telepathy caps now 16** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: total caps now 16** (telepathy-gabble:10415): DEBUG: _process_caps_uri: caps for 1 (alice@localhost/Telepathy) now 16** (telepathy-gabble:10415): DEBUG: _process_caps_uri: enough trust for URI http://telepathy.freedesktop.org/caps#jingle-audio, setting caps for 1 (alice@localhost/Telepathy) to 8** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: about to add caps 8 to resource Telepathy with serial 5** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: found resource Telepathy** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: adding caps 8 to resource Telepathy** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: resource Telepathy caps now 24** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: total caps now 24** (telepathy-gabble:10415): DEBUG: _process_caps_uri: caps for 1 (alice@localhost/Telepathy) now 24** (telepathy-gabble:10415): DEBUG: _process_caps_uri: enough trust for URI http://telepathy.freedesktop.org/caps#voice-v1, setting caps for 1 (alice@localhost/Telepathy) to 2** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: about to add caps 2 to resource Telepathy with serial 5** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: found resource Telepathy** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: adding caps 2 to resource Telepathy** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: resource Telepathy caps now 26** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: total caps now 26** (telepathy-gabble:10415): DEBUG: _process_caps_uri: caps for 1 (alice@localhost/Telepathy) now 26** (telepathy-gabble:10415): DEBUG: _process_caps_uri: enough trust for URI http://telepathy.freedesktop.org/caps#0.7.2.1, setting caps for 1 (alice@localhost/Telepathy) to 869** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: about to add caps 869 to resource Telepathy with serial 5** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: found resource Telepathy** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: adding caps 869 to resource Telepathy** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: resource Telepathy caps now 895** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: total caps now 895** (telepathy-gabble:10415): DEBUG: _process_caps_uri: caps for 1 (alice@localhost/Telepathy) now 895** (telepathy-gabble:10415): DEBUG: _process_caps: No change in caps 895 for handle 1, not updatingRECV [306]:-----------------------------------'<presence from='alice@localhost/Telepathy' to='alice@localhost/Telepathy' id='74268648135'> <status/> <x xmlns='vcard-temp:x:update'> <photo/></x> <c ext='voice-v1 jingle-audio jingle-video' ver='0.7.2.1' node='http://telepathy.freedesktop.org/caps' xmlns='http://jabber.org/protocol/caps'/></presence>'-----------------------------------** (telepathy-gabble:10415): DEBUG: gabble_roster_presence_cb: ignoring presence from ourselves on another resource:<presence id="74268648135" to="alice@localhost/Telepathy" from="alice@localhost/Telepathy"> <status></status> <x xmlns="vcard-temp:x:update"> <photo></photo></x> <c xmlns="http://jabber.org/protocol/caps" node="http://telepathy.freedesktop.org/caps" ver="0.7.2.1" ext="voice-v1 jingle-audio jingle-video"></c></presence>** (telepathy-gabble:10415): DEBUG: gabble_presence_cache_update: alice@localhost (1) resource Telepathy prio 0 presence 5 message "(null)"** (telepathy-gabble:10415): DEBUG: _process_caps_uri: enough trust for URI http://telepathy.freedesktop.org/caps#jingle-video, setting caps for 1 (alice@localhost/Telepathy) to 16** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: about to add caps 16 to resource Telepathy with serial 6** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: found resource Telepathy** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: new serial 6, old 5, clearing caps** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: adding caps 16 to resource Telepathy** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: resource Telepathy caps now 16** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: total caps now 16** (telepathy-gabble:10415): DEBUG: _process_caps_uri: caps for 1 (alice@localhost/Telepathy) now 16** (telepathy-gabble:10415): DEBUG: _process_caps_uri: enough trust for URI http://telepathy.freedesktop.org/caps#jingle-audio, setting caps for 1 (alice@localhost/Telepathy) to 8** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: about to add caps 8 to resource Telepathy with serial 6** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: found resource Telepathy** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: adding caps 8 to resource Telepathy** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: resource Telepathy caps now 24** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: total caps now 24** (telepathy-gabble:10415): DEBUG: _process_caps_uri: caps for 1 (alice@localhost/Telepathy) now 24** (telepathy-gabble:10415): DEBUG: _process_caps_uri: enough trust for URI http://telepathy.freedesktop.org/caps#voice-v1, setting caps for 1 (alice@localhost/Telepathy) to 2** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: about to add caps 2 to resource Telepathy with serial 6** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: found resource Telepathy** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: adding caps 2 to resource Telepathy** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: resource Telepathy caps now 26** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: total caps now 26** (telepathy-gabble:10415): DEBUG: _process_caps_uri: caps for 1 (alice@localhost/Telepathy) now 26** (telepathy-gabble:10415): DEBUG: _process_caps_uri: enough trust for URI http://telepathy.freedesktop.org/caps#0.7.2.1, setting caps for 1 (alice@localhost/Telepathy) to 869** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: about to add caps 869 to resource Telepathy with serial 6** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: found resource Telepathy** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: adding caps 869 to resource Telepathy** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: resource Telepathy caps now 895** (telepathy-gabble:10415): DEBUG: gabble_presence_set_capabilities: total caps now 895** (telepathy-gabble:10415): DEBUG: _process_caps_uri: caps for 1 (alice@localhost/Telepathy) now 895** (telepathy-gabble:10415): DEBUG: _process_caps: No change in caps 895 for handle 1, not updatingRECV [327]:-----------------------------------'<iq from='irc.localhost' to='alice@localhost/Telepathy' id='65611640123' type='result'><query xmlns='http://jabber.org/protocol/disco#info'><identity category='conference' type='irc' name='IRC Transport'/><feature var='http://jabber.org/protocol/muc'/><feature var='jabber:iq:register'/><feature var='vcard-temp'/></query></iq>'-----------------------------------** (telepathy-gabble:10415): DEBUG: item_info_cb: got item identity, jid=irc.localhost, name=IRC Transport, category=conference, type=ircRECV [419]:-----------------------------------'<iq from='proxy.localhost' to='alice@localhost/Telepathy' id='65560640455' type='result'><query xmlns='http://jabber.org/protocol/disco#info'><identity category='proxy' type='bytestreams' name='SOCKS5 Bytestreams'/><feature var='http://jabber.org/protocol/disco#info'/><feature var='http://jabber.org/protocol/disco#items'/><feature var='vcard-temp'/><feature var='http://jabber.org/protocol/bytestreams'/></query></iq>'-----------------------------------** (telepathy-gabble:10415): DEBUG: item_info_cb: got item identity, jid=proxy.localhost, name=SOCKS5 Bytestreams, category=proxy, type=bytestreamsRECV [1023]:-----------------------------------'<iq from='pubsub.localhost' to='alice@localhost/Telepathy' id='66121640695' type='result'><query xmlns='http://jabber.org/protocol/disco#info'><identity category='pubsub' type='service' name='Publish-Subscribe'/><feature var='http://jabber.org/protocol/pubsub'/><feature var='vcard-temp'/><feature var='http://jabber.org/protocol/pubsub#access-open'/><feature var='http://jabber.org/protocol/pubsub#auto-create'/><feature var='http://jabber.org/protocol/pubsub#auto-subscribe'/><feature var='http://jabber.org/protocol/pubsub#collections'/><feature var='http://jabber.org/protocol/pubsub#config-node'/><feature var='http://jabber.org/protocol/pubsub#create-and-configure'/><feature var='http://jabber.org/protocol/pubsub#create-nodes'/><feature var='http://jabber.org/protocol/pubsub#delete-nodes'/><feature var='http://jabber.org/protocol/pubsub#filtered-notifications'/><feature var='http://jabber.org/protocol/pubsub#instant-nodes'/><feature var='http://jabber.org/protocol/pubsub#item-ids'/><feature var='http://jabber.'-----------------------------------RECV [1023]:-----------------------------------'org/protocol/pubsub#last-published'/><feature var='http://jabber.org/protocol/pubsub#manage-subscriptions'/><feature var='http://jabber.org/protocol/pubsub#modify-affiliations'/><feature var='http://jabber.org/protocol/pubsub#outcast-affiliation'/><feature var='http://jabber.org/protocol/pubsub#persistent-items'/><feature var='http://jabber.org/protocol/pubsub#presence-notifications'/><feature var='http://jabber.org/protocol/pubsub#presence-subscribe'/><feature var='http://jabber.org/protocol/pubsub#publish'/><feature var='http://jabber.org/protocol/pubsub#publisher-affiliation'/><feature var='http://jabber.org/protocol/pubsub#purge-nodes'/><feature var='http://jabber.org/protocol/pubsub#retract-items'/><feature var='http://jabber.org/protocol/pubsub#retrieve-affiliations'/><feature var='http://jabber.org/protocol/pubsub#retrieve-default'/><feature var='http://jabber.org/protocol/pubsub#retrieve-items'/><feature var='http://jabber.org/protocol/pubsub#retrieve-subscriptions'/><feature var='http://jabber.org/p'-----------------------------------RECV [117]:-----------------------------------'rotocol/pubsub#subscribe'/><feature var='http://jabber.org/protocol/pubsub#subscription-notifications'/></query></iq>'-----------------------------------** (telepathy-gabble:10415): DEBUG: item_info_cb: got item identity, jid=pubsub.localhost, name=Publish-Subscribe, category=pubsub, type=serviceRECV [331]:-----------------------------------'<iq from='conference.localhost' to='alice@localhost/Telepathy' id='65570641039' type='result'><query xmlns='http://jabber.org/protocol/disco#info'><identity category='conference' type='text' name='Chatrooms'/><feature var='http://jabber.org/protocol/muc'/><feature var='jabber:iq:register'/><feature var='vcard-temp'/></query></iq>'-----------------------------------** (telepathy-gabble:10415): DEBUG: item_info_cb: got item identity, jid=conference.localhost, name=Chatrooms, category=conference, type=textRECV [283]:-----------------------------------'<iq from='vjud.localhost' to='alice@localhost/Telepathy' id='65614641272' type='result'><query xmlns='http://jabber.org/protocol/disco#info'><identity category='directory' type='user' name='vCard User Search'/><feature var='jabber:iq:search'/><feature var='vcard-temp'/></query></iq>'-----------------------------------** (telepathy-gabble:10415): DEBUG: item_info_cb: got item identity, jid=vjud.localhost, name=vCard User Search, category=directory, type=user** (process:10409): DEBUG: on_capabilities_timeout: got_capabilities is 0(telepathy-gabble:10415): tp-glib-DEBUG: channel_request_new: New channel request at 0x728e80: ctype=org.freedesktop.Telepathy.Channel.Type.StreamedMedia htype=0 handle=0 suppress=0[36mtp_properties_mixin_emit_changed: emitting properties changed for property: nat-traversal[37mtp_properties_mixin_emit_flags: emitting properties flags changed for property: nat-traversal's flags now: [[22mREAD[1m][36mtp_group_mixin_change_members: emitting members changed message : "" added : [[22m1 (alice@localhost)[1m] removed : [[22m[1m] local_pending : [[22m[1m] remote_pending: [[22m[1m] actor : 0 reason : 0: unspecified reason[37mtp_group_mixin_change_flags: emitting group flags changed added : [[22mCAN_ADD[1m] removed : [[22m[1m] flags now: [[22mCAN_ADD[1m][0m** (telepathy-gabble:10415): DEBUG: new_media_channel: object path /org/freedesktop/Telepathy/Connection/gabble/jabber/alice_40localhost_2fTelepathy/MediaChannel0(telepathy-gabble:10415): tp-glib-DEBUG: satisfy_requests: called for /org/freedesktop/Telepathy/Connection/gabble/jabber/alice_40localhost_2fTelepathy/MediaChannel0(telepathy-gabble:10415): tp-glib-DEBUG: satisfy_requests: completing queued request 0x728e80 with success, channel_type=org.freedesktop.Telepathy.Channel.Type.StreamedMedia, handle_type=0, handle=0, suppress_handler=0(telepathy-gabble:10415): tp-glib-DEBUG: channel_request_free: Freeing channel request at 0x728e80: ctype=org.freedesktop.Telepathy.Channel.Type.StreamedMedia htype=0 handle=0 suppress=0** (process:10409): DEBUG: _mcd_mission_set_parent: child = 0x626c50, parent = 0x62e090** (process:10409): DEBUG: entering state machine for channel of type: org.freedesktop.Telepathy.Channel.Type.StreamedMedia** (process:10409): DEBUG: Next filter** (process:10409): DEBUG: _on_filter_new_channel: Filtering new channel** (process:10409): DEBUG: _mcd_channel_ready: handle 0, type 0** (process:10409): DEBUG: channel 0x626c50: got self handle 1** (process:10409): DEBUG: 0 local pending members, adding** (process:10409): DEBUG: lookup_actor called** (process:10409): DEBUG: lookup_actor: inviter not found(telepathy-gabble:10415): tp-glib-DEBUG: tp_presence_mixin_get_presence: called.(telepathy-gabble:10415): tp-glib-DEBUG: construct_presence_hash: called.[36mtp_group_mixin_change_members: emitting members changed message : "" added : [[22m[1m] removed : [[22m[1m] local_pending : [[22m[1m] remote_pending: [[22m2 (bernard@localhost)[1m] actor : 0 reason : 0: unspecified reason[37mtp_group_mixin_change_flags: emitting group flags changed added : [[22mCAN_REMOVE|CAN_RESCIND[1m] removed : [[22mCAN_ADD[1m] flags now: [[22mCAN_REMOVE|CAN_RESCIND[1m][0m(telepathy-gabble:10415): tp-glib-DEBUG: tp_group_mixin_add_members: handle 1 cannot be added to members without GROUP_FLAG_CAN_ADD** (process:10409): DEBUG: mcd_service_get_account_for_connection: object_path = /org/freedesktop/Telepathy/Connection/gabble/jabber/alice_40localhost_2fTelepathy(telepathy-gabble:10415): tp-glib-DEBUG: tp_presence_mixin_get_presence: called.(telepathy-gabble:10415): tp-glib-DEBUG: construct_presence_hash: called.** (process:10409): DEBUG: _on_filter_process: Process channel 1** (process:10409): DEBUG: Starting chan handler (bus = org.gnome.Empathy.CallChandler, obj = '/org/gnome/Empathy/CallChandler'): conn = /org/freedesktop/Telepathy/Connection/gabble/jabber/alice_40localhost_2fTelepathy, chan_type = org.freedesktop.Telepathy.Channel.Type.StreamedMedia, obj_path = /org/freedesktop/Telepathy/Connection/gabble/jabber/alice_40localhost_2fTelepathy/MediaChannel0, handle_type = 0, handle = 0(telepathy-gabble:10415): tp-glib-DEBUG: tp_presence_mixin_get_presence: called.(telepathy-gabble:10415): tp-glib-DEBUG: construct_presence_hash: called.CallChandler: Ready to handle new streamed media channels(empathy-call-chandler:10426): tp-glib-DEBUG: tp_proxy_borrow_interface_by_id: 0x623240: org.freedesktop.DBus DBusGProxy is 0x632c00(empathy-call-chandler:10426): tp-glib-DEBUG: tp_connection_init: 0x6278c0(empathy-call-chandler:10426): tp-glib-DEBUG: tp_connection_constructor: Connecting to StatusChanged(empathy-call-chandler:10426): tp-glib-DEBUG: tp_proxy_borrow_interface_by_id: 0x6278c0: org.freedesktop.Telepathy.Connection DBusGProxy is 0x632d20(empathy-call-chandler:10426): tp-glib-DEBUG: tp_connection_constructor: Calling GetStatus(empathy-call-chandler:10426): tp-glib-DEBUG: tp_connection_constructor: Returning 0x6278c0EmpathyChandler: New channel to be handled: type=org.freedesktop.Telepathy.Channel.Type.StreamedMedia handle=0** (process:10409): DEBUG: mcd_service_get_account_for_connection: object_path = /org/freedesktop/Telepathy/Connection/gabble/jabber/alice_40localhost_2fTelepathyTpCall: Revving up the stream engine(empathy-call-chandler:10426): tp-glib-DEBUG: tp_proxy_borrow_interface_by_id: 0x647870: org.freedesktop.DBus DBusGProxy is 0x6332a0(empathy-call-chandler:10426): tp-glib-DEBUG: tp_proxy_borrow_interface_by_id: 0x633240: org.freedesktop.Telepathy.ChannelHandler DBusGProxy is 0x633360TpCall: Identifying audio/video streamsUiUtils: Loading glade file /usr/share/empathy/empathy-call-window.gladeCallWindow: Preview socket realizedTpCall: Adding preview video(empathy-call-chandler:10426): tp-glib-DEBUG: tp_proxy_borrow_interface_by_id: 0x633240: org.freedesktop.Telepathy.StreamEngine DBusGProxy is 0x6a25e0** (process:10409): DEBUG: Adding the destroy handler support.(empathy-call-chandler:10426): tp-glib-DEBUG: _tp_proxy_pending_call_dgproxy_destroy: 0x632d80: DBusGProxy 0x632d20 invalidated(empathy-call-chandler:10426): tp-glib-DEBUG: tp_connection_got_status_cb: 0x6278c0(empathy-call-chandler:10426): tp-glib-DEBUG: tp_connection_got_status_cb: 0x6278c0: Initial status is 0(empathy-call-chandler:10426): tp-glib-DEBUG: tp_connection_status_changed: 0x6278c0: -1 -> 0 because 0** (telepathy-stream-engine-wrapped:10428): DEBUG: not using realtime scheduling, enable through STREAM_ENGINE_REALTIME env(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_proxy_borrow_interface_by_id: 0x62ad60: org.freedesktop.DBus DBusGProxy is 0x62e4c0** (telepathy-stream-engine:10428): DEBUG: registering StreamEngine at /org/freedesktop/Telepathy/StreamEngine** (telepathy-stream-engine:10428): DEBUG: Requesting org.freedesktop.Telepathy.StreamEngine** (telepathy-stream-engine:10428): DEBUG: HandleChannel called(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_connection_init: 0x737020(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_connection_constructor: Connecting to StatusChanged(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_proxy_borrow_interface_by_id: 0x737020: org.freedesktop.Telepathy.Connection DBusGProxy is 0x62e6a0(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_connection_constructor: Calling GetStatus(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_connection_constructor: Returning 0x737020(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_channel_init: 0x63a8b0(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_proxy_borrow_interface_by_id: 0x63a8b0: org.freedesktop.Telepathy.Channel DBusGProxy is 0x62e860(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_channel_constructor: 0x63a8b0: constructed with channel type "org.freedesktop.Telepathy.Channel.Type.StreamedMedia", handle #0 of type 0** (telepathy-stream-engine:10428): DEBUG: making video src with pipeline "videotestsrc is-live=true"(empathy-call-chandler:10426): tp-glib-DEBUG: _tp_proxy_pending_call_dgproxy_destroy: 0x633300: DBusGProxy 0x6332a0 invalidatedTpCall: Watch SE: name='org.freedesktop.Telepathy.StreamEngine' SE started='no' new_owner=''TpGroup: Members changed for list (null): added-len=1, current-len=0 removed-len=0 local-pending-len=0, current-len=0 remote-pending-len=0, current-len=0(empathy-call-chandler:10426): tp-glib-DEBUG: tp_connection_init: 0x7ba420(empathy-call-chandler:10426): tp-glib-DEBUG: tp_connection_constructor: Connecting to StatusChanged(empathy-call-chandler:10426): tp-glib-DEBUG: tp_proxy_borrow_interface_by_id: 0x7ba420: org.freedesktop.Telepathy.Connection DBusGProxy is 0x6a2700(empathy-call-chandler:10426): tp-glib-DEBUG: tp_connection_constructor: Calling GetStatus(empathy-call-chandler:10426): tp-glib-DEBUG: tp_connection_constructor: Returning 0x7ba420TpContactFactory: Contact added: alice@localhost (1)TpCall: New member added callback 0x7bcb60TpGroup: Members changed done for list (null): members-len=1 local-pendings-len=0 remote-pendings-len=0TpGroup: Members changed for list (null): added-len=0, current-len=1 removed-len=0 local-pending-len=0, current-len=0 remote-pending-len=1, current-len=0(telepathy-gabble:10415): tp-glib-DEBUG: tp_presence_mixin_get_presence: called.(telepathy-gabble:10415): tp-glib-DEBUG: construct_presence_hash: called.TpContactFactory: Contact added: bernard@localhost (2)TpCall: New remote pending added callback 0x7bcc00TpCall: Outgoing call is ready - 0x7bcc00TpCall: Requesting appropriate audio/video streams from contactCallWindow: Status changed - status: 1, stream state: 0TpGroup: Members changed done for list (null): members-len=1 local-pendings-len=0 remote-pendings-len=1(empathy-call-chandler:10426): tp-glib-DEBUG: _tp_proxy_pending_call_dgproxy_destroy: 0x6a26a0: DBusGProxy 0x632d20 invalidated(empathy-call-chandler:10426): tp-glib-DEBUG: tp_connection_got_interfaces_cb: 0x6278c0: Introspected interfaces(empathy-call-chandler:10426): tp-glib-DEBUG: tp_proxy_borrow_interface_by_id: 0x6278c0: org.freedesktop.Telepathy.Connection.Interface.Aliasing DBusGProxy is 0x7bcc60TpCall: Watch SE: name='org.freedesktop.Telepathy.StreamEngine' SE started='no' new_owner=':1.4'(empathy-call-chandler:10426): tp-glib-DEBUG: _tp_proxy_pending_call_dgproxy_destroy: 0x6a2760: DBusGProxy 0x6a2700 invalidated(empathy-call-chandler:10426): tp-glib-DEBUG: tp_connection_got_status_cb: 0x7ba420(empathy-call-chandler:10426): tp-glib-DEBUG: tp_connection_got_status_cb: 0x7ba420: Initial status is 0(empathy-call-chandler:10426): tp-glib-DEBUG: tp_connection_status_changed: 0x7ba420: -1 -> 0 because 0TpContactFactory: Changing presence for contact alice@localhost (1) to (2)TpContactFactory: Renaming contact alice@localhost (1) to alice (request cb)TpContactFactory: Got 1 tokens, need to request 0 avatarsTpContactFactory: Changing capabilities for contact alice@localhost (1) to 3TpContactFactory: Changing capabilities for contact alice@localhost (1) to 3(telepathy-gabble:10415): tp-glib-DEBUG: tp_presence_mixin_get_presence: called.(telepathy-gabble:10415): tp-glib-DEBUG: construct_presence_hash: called.** (telepathy-stream-engine:10428): DEBUG: state_ret: 2[37m19:49:56[0m] [30m[47mJS_STATE_PENDING_CREATED [0m [37mstream audio1 connection state 0[37m19:49:56[0m] [30m[47mJS_STATE_PENDING_CREATED [0m [37mstream audio1 sig_state 0->0[37m19:49:56[0m] [30m[47mJS_STATE_PENDING_CREATED [0m [37mcreating new jingle video stream called "video1" with id 2[37m19:49:56[0m] [30m[47mJS_STATE_PENDING_CREATED [0m [37mstream video1 connection state 0[37m19:49:56[0m] [30m[47mJS_STATE_PENDING_CREATED [0m [37mstream video1 sig_state 0->0TpContactFactory: Changing capabilities for contact bernard@localhost (2) to 3(empathy-call-chandler:10426): tp-glib-DEBUG: _tp_proxy_pending_call_dgproxy_destroy: 0x7bccc0: DBusGProxy 0x7bcc60 invalidated(empathy-call-chandler:10426): tp-glib-DEBUG: got_aliasing_flags: Introspected aliasing flags: 0x1(empathy-call-chandler:10426): tp-glib-DEBUG: tp_connection_continue_introspection: 0x6278c0: connection ready(empathy-call-chandler:10426): tp-glib-DEBUG: _tp_proxy_pending_call_dgproxy_destroy: 0x6a26a0: DBusGProxy 0x6a2700 invalidated(empathy-call-chandler:10426): tp-glib-DEBUG: tp_connection_got_interfaces_cb: 0x7ba420: Introspected interfaces(empathy-call-chandler:10426): tp-glib-DEBUG: tp_proxy_borrow_interface_by_id: 0x7ba420: org.freedesktop.Telepathy.Connection.Interface.Aliasing DBusGProxy is 0x632d80TpCall: Stream added - stream id: 1, contact handle: 2, stream type: 0TpCall: Identifying audio/video streamsTpCall: Audio stream - id: 1, state: 0, direction: 3TpCall: Video stream - id: 2, state: 0, direction: 3TpCall: Stream added - stream id: 2, contact handle: 2, stream type: 1TpCall: Identifying audio/video streams** (telepathy-stream-engine:10428): DEBUG: linking ffmpegcolorspaceTpCall: Audio stream - id: 1, state: 0, direction: 3TpCall: Video stream - id: 2, state: 0, direction: 3(empathy-call-chandler:10426): tp-glib-DEBUG: _tp_proxy_pending_call_dgproxy_destroy: 0x7bccc0: DBusGProxy 0x632d80 invalidated(empathy-call-chandler:10426): tp-glib-DEBUG: got_aliasing_flags: Introspected aliasing flags: 0x1(empathy-call-chandler:10426): tp-glib-DEBUG: tp_connection_continue_introspection: 0x7ba420: connection ready** (telepathy-stream-engine:10428): DEBUG: linking videoscale** (telepathy-stream-engine:10428): DEBUG: tp_stream_engine_add_preview_window: called for 92274738** (telepathy-stream-engine:10428): DEBUG: tp_stream_engine_add_preview_window: pipeline playing, adding now** (telepathy-stream-engine:10428): DEBUG: Adding to windowpair list sink (nil) window_id 92274738** (telepathy-stream-engine:10428): DEBUG: _add_preview_window: called for window id 92274738** (telepathy-stream-engine:10428): DEBUG: adding preview in window 92274738** (telepathy-stream-engine:10428): DEBUG: made video sink element ximagesink0** (telepathy-stream-engine:10428): DEBUG: setting sync to FALSE** (telepathy-stream-engine:10428): DEBUG: setting qos to FALSE** (telepathy-stream-engine:10428): DEBUG: setting force-aspect-ratio to TRUE** (telepathy-stream-engine:10428): DEBUG: setting async to FALSE** (telepathy-stream-engine:10428): DEBUG: linking videoscale** (telepathy-stream-engine:10428): DEBUG: linking ffmpegcolorspace** (telepathy-stream-engine:10428): DEBUG: trying to set sink to PLAYING** (telepathy-stream-engine:10428): DEBUG: trying to link tee and sink** (telepathy-stream-engine:10428): DEBUG: linked tee and sink** (telepathy-stream-engine:10428): DEBUG: Starting source(telepathy-stream-engine:10428): tp-glib-DEBUG: _tp_proxy_pending_call_dgproxy_destroy: 0x62e580: DBusGProxy 0x62e4c0 invalidated** (telepathy-stream-engine:10428): DEBUG: started(telepathy-stream-engine:10428): tp-glib-DEBUG: _tp_proxy_pending_call_dgproxy_destroy: 0x62e700: DBusGProxy 0x62e6a0 invalidated(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_connection_got_status_cb: 0x737020(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_connection_got_status_cb: 0x737020: Initial status is 0(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_connection_status_changed: 0x737020: -1 -> 0 because 0(telepathy-stream-engine:10428): tp-glib-DEBUG: _tp_proxy_pending_call_dgproxy_destroy: 0x62e8c0: DBusGProxy 0x62e860 invalidated(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_channel_got_interfaces_cb: - org.freedesktop.Telepathy.Channel.Interface.Group(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_channel_got_interfaces_cb: - org.freedesktop.Telepathy.Channel.Interface.MediaSignalling(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_channel_got_interfaces_cb: - org.freedesktop.Telepathy.Properties(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_channel_got_interfaces_cb: 0x63a8b0: channel ready(empathy-call-chandler:10426): tp-glib-DEBUG: _tp_proxy_pending_call_dgproxy_destroy: 0x6a2640: DBusGProxy 0x6a25e0 invalidated(empathy-call-chandler:10426): tp-glib-DEBUG: _tp_proxy_pending_call_dgproxy_destroy: 0x646c00: DBusGProxy 0x633360 invalidated(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_proxy_borrow_interface_by_id: 0x63a8b0: org.freedesktop.Telepathy.Properties DBusGProxy is 0x75f980(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_proxy_borrow_interface_by_id: 0x63a8b0: org.freedesktop.Telepathy.Channel.Interface.MediaSignalling DBusGProxy is 0x75fa40(telepathy-stream-engine:10428): tp-glib-DEBUG: _tp_proxy_pending_call_dgproxy_destroy: 0x75f920: DBusGProxy 0x62e6a0 invalidated(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_connection_got_interfaces_cb: 0x737020: Introspected interfaces(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_proxy_borrow_interface_by_id: 0x737020: org.freedesktop.Telepathy.Connection.Interface.Aliasing DBusGProxy is 0x62e8c0(telepathy-stream-engine:10428): tp-glib-DEBUG: _tp_proxy_pending_call_dgproxy_destroy: 0x75f9e0: DBusGProxy 0x75f980 invalidated(telepathy-stream-engine:10428): tp-glib-DEBUG: _tp_proxy_pending_call_dgproxy_destroy: 0x75faa0: DBusGProxy 0x75fa40 invalidated** (telepathy-stream-engine:10428): DEBUG: GetSessionHandlers replied: ** (telepathy-stream-engine:10428): DEBUG: - session /org/freedesktop/Telepathy/Connection/gabble/jabber/alice_40localhost_2fTelepathy/MediaChannel0/MediaSession2** (telepathy-stream-engine:10428): DEBUG: type rtp** (telepathy-stream-engine:10428): DEBUG: adding session handler /org/freedesktop/Telepathy/Connection/gabble/jabber/alice_40localhost_2fTelepathy/MediaChannel0/MediaSession2, type rtpfarsight-Message: looking for plugins in /usr/lib64/farsight-0.1-3opening module /usr/lib64/farsight-0.1-3/librtp-session.so: succeeded** (telepathy-stream-engine:10428): DEBUG: plugin details: name: rtp-session description: Farsight RTP plugin author: Farsight Project(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_proxy_borrow_interface_by_id: 0x75f9e0: org.freedesktop.Telepathy.Media.SessionHandler DBusGProxy is 0x75fb00** (telepathy-stream-engine:10428): DEBUG: calling MediaSessionHandler::Ready(telepathy-stream-engine:10428): tp-glib-DEBUG: _tp_proxy_pending_call_dgproxy_destroy: 0x62e700: DBusGProxy 0x62e8c0 invalidated(telepathy-stream-engine:10428): tp-glib-DEBUG: got_aliasing_flags: Introspected aliasing flags: 0x1(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_connection_continue_introspection: 0x737020: connection ready(telepathy-stream-engine:10428): tp-glib-DEBUG: _tp_proxy_pending_call_dgproxy_destroy: 0x62e580: DBusGProxy 0x75f980 invalidated** (telepathy-stream-engine:10428): DEBUG: New stream, stream_id=1, media_type=0, direction=3(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_proxy_borrow_interface_by_id: 0x7b0000: org.freedesktop.Telepathy.Media.StreamHandler DBusGProxy is 0x7b0180** (telepathy-stream-engine:10428): DEBUG: stream 1 (audio) make_src: making audio src with pipeline "audiotestsrc is-live=true"** (telepathy-stream-engine:10428): DEBUG: stream 1 (audio) make_src: made audio src element bin2** (telepathy-stream-engine:10428): DEBUG: stream 1 (audio) make_volume_bin: Putting the src into a bin with a volume element** (telepathy-stream-engine:10428): DEBUG: stream 1 (audio) make_sink: made audio sink element gconfaudiosink0** (telepathy-stream-engine:10428): DEBUG: stream 1 (audio) make_volume_bin: Putting the sink into a bin with a volume element** (telepathy-stream-engine:10428): DEBUG: stream 1 (audio) tp_stream_engine_stream_constructor: setting source on Farsight stream(telepathy-stream-engine:10428): farsight-rtp-DEBUG: AUDIO - ensure_local_codecs: media type is 0(telepathy-stream-engine:10428): farsight-rtp-DEBUG: load_config_file: looking for /home/alice/.farsight/gstelements.conf(telepathy-stream-engine:10428): farsight-rtp-DEBUG: load_config_file: looking for /etc/farsight/gstelements.conf(telepathy-stream-engine:10428): farsight-rtp-DEBUG: load_codecs_cache: Codecs cache /home/alice/.farsight/codecs.audio.x86_64.cache is outdated or does not exist(telepathy-stream-engine:10428): farsight-rtp-DEBUG: create_codec_cap_list: skipping rtpdepay(telepathy-stream-engine:10428): farsight-rtp-DEBUG: create_codec_cap_list: skipping rtspsrc(telepathy-stream-engine:10428): farsight-rtp-DEBUG: create_codec_cap_list: skipping rtpdtmfsrc(telepathy-stream-engine:10428): farsight-rtp-DEBUG: parse_codec_cap_list: skipping codec audio/MSGSM, no encoding name specified (pt: -1 clock_rate:0(telepathy-stream-engine:10428): farsight-rtp-DEBUG: parse_codec_cap_list: adding codec GSM with pt 3, send_pipeline 0x805f00, receive_pipeline 0x7f4600(telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: pipeline: (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: 0x678b40:5:gsmenc (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: 0x6a65a0:5:rtpgsmpay (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: pipeline: (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: 0x678c60:5:gsmdec (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: 0x6a6480:5:rtpgsmdepay (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: (telepathy-stream-engine:10428): farsight-rtp-DEBUG: parse_codec_cap_list: adding codec MPEG4-GENERIC with pt -1, send_pipeline 0x7ce920, receive_pipeline 0x7fba80(telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: pipeline: (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: 0x71ea20:4:ffenc_mpeg4 (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: 0x6b0360:4:rtpmp4gpay (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: pipeline: (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: 0x712240:4:ffdec_mpeg4 (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: 0x6b0240:4:rtpmp4gdepay (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: (telepathy-stream-engine:10428): farsight-rtp-DEBUG: parse_codec_cap_list: skipping codec audio/unknown, no encoding name specified (pt: 14 clock_rate:90000(telepathy-stream-engine:10428): farsight-rtp-DEBUG: parse_codec_cap_list: adding codec MPA with pt -1, send_pipeline 0x7ced40, receive_pipeline 0x7cfe80(telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: pipeline: (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: 0x722480:6:ffenc_mp2 (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: 0x6a6ea0:6:rtpmpapay (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: pipeline: (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: 0x704c60:6:ffdec_mp3 (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: 0x6a6d80:6:rtpmpadepay (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: (telepathy-stream-engine:10428): farsight-rtp-DEBUG: parse_codec_cap_list: adding codec PCMA with pt 8, send_pipeline 0x79a180, receive_pipeline 0x7d0e00(telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: pipeline: (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: 0x678480:5:alawenc (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: 0x6a6c60:5:rtppcmapay (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: pipeline: (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: 0x6785a0:5:alawdec (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: 0x6a6900:5:rtppcmadepay (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: (telepathy-stream-engine:10428): farsight-rtp-DEBUG: parse_codec_cap_list: adding codec PCMU with pt 0, send_pipeline 0x7fba20, receive_pipeline 0x7fb900(telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: pipeline: (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: 0x664240:5:mulawenc (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: 0x6a6b40:5:rtppcmupay (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: pipeline: (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: 0x664360:5:mulawdec (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: 0x6a6a20:5:rtppcmudepay (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: (telepathy-stream-engine:10428): farsight-rtp-DEBUG: parse_codec_cap_list: adding codec SPEEX with pt -1, send_pipeline 0x7cf100, receive_pipeline 0x7cde60(telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: pipeline: (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: 0x69e900:4:speexenc (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: 0x6b0480:4:rtpspeexpay (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: pipeline: (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: 0x69ea20:4:speexdec (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: 0x6b05a0:4:rtpspeexdepay (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: (telepathy-stream-engine:10428): farsight-rtp-DEBUG: parse_codec_cap_list: adding codec VORBIS with pt -1, send_pipeline 0x7ce120, receive_pipeline 0x7b9360(telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: pipeline: (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: 0x680ea0:4:vorbisenc (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: 0x6b0b40:4:rtpvorbispay (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: pipeline: (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: 0x686000:4:vorbisdec (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: 0x6b0a20:4:rtpvorbisdepay (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: (telepathy-stream-engine:10428): farsight-rtp-DEBUG: save_codecs_cache: Saving codecs cache to /home/alice/.farsight/codecs.audio.x86_64.cache(telepathy-stream-engine:10428): farsight-rtp-DEBUG: save_codecs_cache: Wrote binary codecs cache(telepathy-stream-engine:10428): farsight-rtp-DEBUG: load_codecs_configuration: Trying to load /home/alice/.farsight/gstcodecs.conf(telepathy-stream-engine:10428): farsight-DEBUG: Unable to read file /home/alice/.farsight/gstcodecs.conf: No such file or directory(telepathy-stream-engine:10428): farsight-rtp-DEBUG: load_codecs_configuration: Trying to load /etc/farsight/gstcodecs.conf(telepathy-stream-engine:10428): farsight-rtp-DEBUG: validate_codecs_configuration: Prefered codec -1: audio iLBC clock:8000 channels:0 mode=30 could not be matched with an installed encoder/decoder/payloader/depayloader quatuor(telepathy-stream-engine:10428): farsight-rtp-DEBUG: validate_codecs_configuration: Prefered codec -1: audio AMR clock:8000 channels:0 could not be matched with an installed encoder/decoder/payloader/depayloader quatuor(telepathy-stream-engine:10428): farsight-rtp-DEBUG: validate_codecs_configuration: Prefered codec -1: audio G729 clock:8000 channels:0 could not be matched with an installed encoder/decoder/payloader/depayloader quatuor(telepathy-stream-engine:10428): farsight-rtp-DEBUG: validate_codecs_configuration: Prefered codec -1: audio PCMU clock:16000 channels:0 could not be matched with an installed encoder/decoder/payloader/depayloader quatuor(telepathy-stream-engine:10428): farsight-rtp-DEBUG: validate_codecs_configuration: Prefered codec -2: video THEORA clock:0 channels:0 could not be matched with an installed encoder/decoder/payloader/depayloader quatuor(telepathy-stream-engine:10428): farsight-rtp-DEBUG: validate_codecs_configuration: Prefered codec 1: audio VORBIS clock:0 channels:0 could not be matched with an installed encoder/decoder/payloader/depayloader quatuor(telepathy-stream-engine:10428): farsight-rtp-DEBUG: AUDIO - farsight_rtp_stream_set_source: setting src** (telepathy-stream-engine:10428): DEBUG: stream 1 (audio) tp_stream_engine_stream_constructor: setting sink on Farsight stream(telepathy-stream-engine:10428): farsight-rtp-DEBUG: AUDIO - farsight_rtp_stream_set_sink: setting sink bin4(telepathy-stream-engine:10428): farsight-rtp-DEBUG: AUDIO - farsight_rtp_stream_set_sink: No capsfilter, setting sink for future use** (telepathy-stream-engine:10428): DEBUG: stream 1 (audio) set_nat_properties: setting farsight transmitter to libjinglefarsight-Message: looking for plugins in /usr/lib64/farsight-0.1-3opening module /usr/lib64/farsight-0.1-3/libjingle-transmitter: succeeded(telepathy-stream-engine:10428): farsight-rtp-DEBUG: AUDIO - farsight_rtp_stream_prepare_transports: Preparing transmitterfarsight-transmitter-Message: Init and running jinglep2p to prepare native candiates, using stun stun.l.google.com : 19302** (telepathy-stream-engine:10428): DEBUG: got prepare-xwindow-id message from ximagesink0** (telepathy-stream-engine:10428): DEBUG: Giving video sink 0x74d150 window id 92274738farsight-transmitter-Message: No socket created yet! SocketState not connected(telepathy-stream-engine:10428): farsight-rtp-DEBUG: AUDIO - farsight_rtp_stream_transmitter_state_changed: connect state changed to 1** (telepathy-stream-engine:10428): DEBUG: stream 1 (audio) cb_fs_state_changed: stream 0x74f340, state: connecting, direction: none[37m19:50:07[0m] [30m[47mJS_STATE_PENDING_CREATED [0m [37mstream audio1 connection state 0TpCall: Stream state changed - stream id: 1, state state: 1CallWindow: Status changed - status: 1, stream state: 1(telepathy-stream-engine:10428): farsight-rtp-DEBUG: AUDIO - farsight_rtp_stream_build_base_pipeline: creating core RTP pipeline(telepathy-stream-engine:10428): farsight-rtp-DEBUG: AUDIO - farsight_rtp_stream_build_base_pipeline: added transmitter_src 0x866020 to pipeline 0x73b210** (telepathy-stream-engine:10428): DEBUG: stream 1 (audio) fs_codecs_to_tp: adding codec speex [96]** (telepathy-stream-engine:10428): DEBUG: stream 1 (audio) fs_codecs_to_tp: adding codec GSM [3]** (telepathy-stream-engine:10428): DEBUG: stream 1 (audio) fs_codecs_to_tp: adding codec PCMA [8]** (telepathy-stream-engine:10428): DEBUG: stream 1 (audio) fs_codecs_to_tp: adding codec MPA [97]** (telepathy-stream-engine:10428): DEBUG: stream 1 (audio) fs_codecs_to_tp: adding codec PCMU [0]** (telepathy-stream-engine:10428): DEBUG: stream 1 (audio) fs_codecs_to_tp: adding codec telephone-event [98]** (telepathy-stream-engine:10428): DEBUG: stream 1 (audio) prepare_transports: calling MediaStreamHandler::Ready[37m19:50:07[0m] [30m[47mJS_STATE_PENDING_CREATED [0m [37mready called[37m19:50:07[0m] [30m[47mJS_STATE_PENDING_CREATED [0m [37mstream audio1 emitting SetStreamPlaying(false)[37m19:50:07[0m] [30m[47mJS_STATE_PENDING_CREATED [0m [37mstream audio1 emitting SetStreamSending(false)[37m19:50:07[0m] [30m[47mJS_STATE_PENDING_CREATED [0m [37mputting list of all 6 locally supported codecs from stream-engine into cache[37m19:50:07[0m] [30m[47mJS_STATE_PENDING_CREATED [0m [37mstream audio1 has got local codecs[37m19:50:07[0m] [30m[47mJS_STATE_PENDING_CREATED [0m [37mstream video1 does not yet have local codecs[37m19:50:07[0m] [30m[47mJS_STATE_PENDING_CREATED [0m [37mnot sending initiate yet, found a stream which was missing local codecs** (telepathy-stream-engine:10428): DEBUG: New stream, stream_id=2, media_type=1, direction=3(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_proxy_borrow_interface_by_id: 0x7c9060: org.freedesktop.Telepathy.Media.StreamHandler DBusGProxy is 0x7c90c0** (telepathy-stream-engine:10428): DEBUG: stream 2 (video) make_sink: not making a video sink** (telepathy-stream-engine:10428): DEBUG: stream 2 (video) tp_stream_engine_stream_constructor: setting source on Farsight stream(telepathy-stream-engine:10428): farsight-rtp-DEBUG: VIDEO - ensure_local_codecs: media type is 1(telepathy-stream-engine:10428): farsight-rtp-DEBUG: load_codecs_cache: Codecs cache /home/alice/.farsight/codecs.video.x86_64.cache is outdated or does not exist(telepathy-stream-engine:10428): farsight-rtp-DEBUG: create_codec_cap_list: skipping rtpdepay(telepathy-stream-engine:10428): farsight-rtp-DEBUG: create_codec_cap_list: skipping rtspsrc(telepathy-stream-engine:10428): farsight-rtp-DEBUG: create_codec_cap_list: skipping rtpdtmfsrc(telepathy-stream-engine:10428): farsight-rtp-DEBUG: parse_codec_cap_list: skipping codec video/unknown, no encoding name specified (pt: -1 clock_rate:9000(telepathy-stream-engine:10428): farsight-rtp-DEBUG: parse_codec_cap_list: adding codec H263 with pt 34, send_pipeline 0x87b620, receive_pipeline 0x87d160(telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: pipeline: (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: 0x722000:9:ffenc_h263 (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: 0x6ab5a0:5:rtph263pay (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: pipeline: (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: 0x712480:9:ffdec_h263 (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: 0x6ab480:5:rtph263depay (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: (telepathy-stream-engine:10428): farsight-rtp-DEBUG: parse_codec_cap_list: adding codec H263-1998 with pt -1, send_pipeline 0x7fbb80, receive_pipeline 0x6c8980(telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: pipeline: (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: 0x722000:10:ffenc_h263 (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: 0x6ab240:6:rtph263ppay (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: pipeline: (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: 0x712480:10:ffdec_h263 (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: 0x6ab360:6:rtph263pdepay (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: (telepathy-stream-engine:10428): farsight-rtp-DEBUG: parse_codec_cap_list: adding codec H263-N800 with pt -1, send_pipeline 0x7cdda0, receive_pipeline 0x7f8cc0(telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: pipeline: (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: 0x722000:11:ffenc_h263 (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: 0x6ab240:7:rtph263ppay (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: pipeline: (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: 0x712480:11:ffdec_h263 (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: 0x6ab360:7:rtph263pdepay (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: (telepathy-stream-engine:10428): farsight-rtp-DEBUG: parse_codec_cap_list: adding codec H264 with pt -1, send_pipeline 0x87d1a0, receive_pipeline 0x87d0c0(telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: pipeline: (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: 0x6595a0:4:x264enc (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: 0x6ab7e0:4:rtph264pay (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: pipeline: (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: 0x704120:4:ffdec_h264 (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: 0x6ab6c0:4:rtph264depay (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: (telepathy-stream-engine:10428): farsight-rtp-DEBUG: parse_codec_cap_list: adding codec MPEG4-GENERIC with pt -1, send_pipeline 0x7bfe60, receive_pipeline 0x7d8e00(telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: pipeline: (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: 0x71ea20:7:ffenc_mpeg4 (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: 0x6b0360:5:rtpmp4gpay (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: pipeline: (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: 0x712240:7:ffdec_mpeg4 (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: 0x6b0240:5:rtpmp4gdepay (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: (telepathy-stream-engine:10428): farsight-rtp-DEBUG: parse_codec_cap_list: adding codec MP4V-ES with pt -1, send_pipeline 0x7d05a0, receive_pipeline 0x7d02e0(telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: pipeline: (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: 0x71ea20:8:ffenc_mpeg4 (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: 0x6abea0:4:rtpmp4vpay (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: pipeline: (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: 0x712240:8:ffdec_mpeg4 (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: 0x6b0000:4:rtpmp4vdepay (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: (telepathy-stream-engine:10428): farsight-rtp-DEBUG: parse_codec_cap_list: adding codec MPV with pt 32, send_pipeline 0x7d0e20, receive_pipeline 0x874ba0(telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: pipeline: (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: 0x722240:4:ffenc_mpeg2video (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: 0x6ab120:4:rtpmpvpay (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: pipeline: (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: 0x709240:5:ffdec_mpegvideo (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: 0x6ab000:5:rtpmpvdepay (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: (telepathy-stream-engine:10428): farsight-rtp-DEBUG: parse_codec_cap_list: adding codec THEORA with pt -1, send_pipeline 0x7d43a0, receive_pipeline 0x7ce800(telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: pipeline: (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: 0x68dd80:4:theoraenc (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: 0x6b0900:4:rtptheorapay (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: pipeline: (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: 0x68dc60:4:theoradec (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: 0x6b07e0:4:rtptheoradepay (telepathy-stream-engine:10428): farsight-rtp-DEBUG: debug_pipeline: (telepathy-stream-engine:10428): farsight-rtp-DEBUG: save_codecs_cache: Saving codecs cache to /home/alice/.farsight/codecs.video.x86_64.cache(telepathy-stream-engine:10428): farsight-rtp-DEBUG: save_codecs_cache: Wrote binary codecs cache(telepathy-stream-engine:10428): farsight-rtp-DEBUG: load_codecs_configuration: Trying to load /home/alice/.farsight/gstcodecs.conf(telepathy-stream-engine:10428): farsight-DEBUG: Unable to read file /home/alice/.farsight/gstcodecs.conf: No such file or directory(telepathy-stream-engine:10428): farsight-rtp-DEBUG: load_codecs_configuration: Trying to load /etc/farsight/gstcodecs.conf(telepathy-stream-engine:10428): farsight-rtp-DEBUG: validate_codecs_configuration: Prefered codec -1: audio speex clock:8000 channels:0 could not be matched with an installed encoder/decoder/payloader/depayloader quatuor(telepathy-stream-engine:10428): farsight-rtp-DEBUG: validate_codecs_configuration: Prefered codec -1: audio iLBC clock:8000 channels:0 mode=30 could not be matched with an installed encoder/decoder/payloader/depayloader quatuor(telepathy-stream-engine:10428): farsight-rtp-DEBUG: validate_codecs_configuration: Prefered codec -1: audio AMR clock:8000 channels:0 could not be matched with an installed encoder/decoder/payloader/depayloader quatuor(telepathy-stream-engine:10428): farsight-rtp-DEBUG: validate_codecs_configuration: Prefered codec -1: audio GSM clock:8000 channels:0 could not be matched with an installed encoder/decoder/payloader/depayloader quatuor(telepathy-stream-engine:10428): farsight-rtp-DEBUG: validate_codecs_configuration: Prefered codec -1: audio G729 clock:8000 channels:0 could not be matched with an installed encoder/decoder/payloader/depayloader quatuor(telepathy-stream-engine:10428): farsight-rtp-DEBUG: validate_codecs_configuration: Prefered codec -1: audio PCMA clock:8000 channels:0 could not be matched with an installed encoder/decoder/payloader/depayloader quatuor(telepathy-stream-engine:10428): farsight-rtp-DEBUG: validate_codecs_configuration: Prefered codec -1: audio PCMU clock:16000 channels:0 could not be matched with an installed encoder/decoder/payloader/depayloader quatuor(telepathy-stream-engine:10428): farsight-rtp-DEBUG: validate_codecs_configuration: Prefered codec 1: audio VORBIS clock:0 channels:0 could not be matched with an installed encoder/decoder/payloader/depayloader quatuor(telepathy-stream-engine:10428): farsight-rtp-DEBUG: Codec -1: video THEORA clock:90000 channels:0 disabled by config(telepathy-stream-engine:10428): farsight-rtp-DEBUG: VIDEO - farsight_rtp_stream_set_source: setting src** (telepathy-stream-engine:10428): DEBUG: stream 2 (video) tp_stream_engine_stream_constructor: not setting sink on Farsight stream** (telepathy-stream-engine:10428): DEBUG: stream 2 (video) set_nat_properties: setting farsight transmitter to libjingle(telepathy-stream-engine:10428): farsight-rtp-DEBUG: VIDEO - farsight_rtp_stream_prepare_transports: Preparing transmitterfarsight-transmitter-Message: Init and running jinglep2p to prepare native candiates, using stun stun.l.google.com : 19302farsight-transmitter-Message: No socket created yet! SocketState not connected(telepathy-stream-engine:10428): farsight-rtp-DEBUG: VIDEO - farsight_rtp_stream_transmitter_state_changed: connect state changed to 1** (telepathy-stream-engine:10428): DEBUG: stream 2 (video) cb_fs_state_changed: stream 0x74fe30, state: connecting, direction: none(telepathy-stream-engine:10428): farsight-rtp-DEBUG: VIDEO - farsight_rtp_stream_build_base_pipeline: creating core RTP pipeline[37m19:50:17[0m] [30m[47mJS_STATE_PENDING_CREATED [0m [37mstream video1 connection state 0TpCall: Stream state changed - stream id: 2, state state: 1CallWindow: Status changed - status: 1, stream state: 1(telepathy-stream-engine:10428): farsight-rtp-DEBUG: VIDEO - farsight_rtp_stream_build_base_pipeline: added transmitter_src 0x866660 to pipeline 0x74d690** (telepathy-stream-engine:10428): DEBUG: stream 2 (video) fs_codecs_to_tp: adding codec H263 [34]** (telepathy-stream-engine:10428): DEBUG: stream 2 (video) fs_codecs_to_tp: adding codec H263-1998 [96]** (telepathy-stream-engine:10428): DEBUG: stream 2 (video) fs_codecs_to_tp: adding codec H263-N800 [97]** (telepathy-stream-engine:10428): DEBUG: stream 2 (video) fs_codecs_to_tp: adding codec H264 [98]** (telepathy-stream-engine:10428): DEBUG: stream 2 (video) fs_codecs_to_tp: adding codec MPV [32]** (telepathy-stream-engine:10428): DEBUG: stream 2 (video) prepare_transports: calling MediaStreamHandler::Ready[37m19:50:17[0m] [30m[47mJS_STATE_PENDING_CREATED [0m [37mready called[37m19:50:17[0m] [30m[47mJS_STATE_PENDING_CREATED [0m [37mstream video1 emitting SetStreamPlaying(false)[37m19:50:17[0m] [30m[47mJS_STATE_PENDING_CREATED [0m [37mstream video1 emitting SetStreamSending(false)[37m19:50:17[0m] [30m[47mJS_STATE_PENDING_CREATED [0m [37mputting list of all 5 locally supported codecs from stream-engine into cache[37m19:50:17[0m] [30m[47mJS_STATE_PENDING_CREATED [0m [37mstream video1 has got local codecs[37m19:50:17[0m] [30m[47mJS_STATE_PENDING_CREATED [0m [37msending jingle action "session-initiate" to peerSEND:-----------------------------------<iq type="set" to="bernard@localhost/Telepathy" id="96183646"> <jingle xmlns="http://jabber.org/protocol/jingle" initiator="alice@localhost/Telepathy" action="session-initiate" sid="76393035"> <content creator="initiator" name="audio1"> <description xmlns="http://jabber.org/protocol/jingle/description/audio"> <payload-type channels="1" rate="8000" name="speex" id="96"></payload-type> <payload-type rate="8000" name="GSM" id="3"></payload-type> <payload-type rate="8000" name="PCMA" id="8"></payload-type> <payload-type rate="90000" name="MPA" id="97"></payload-type> <payload-type rate="8000" name="PCMU" id="0"></payload-type> <payload-type channels="1" rate="8000" name="telephone-event" id="98"></payload-type></description> <transport xmlns="http://www.google.com/transport/p2p"></transport></content> <content creator="initiator" name="video1"> <description xmlns="http://jabber.org/protocol/jingle/description/video"> <payload-type rate="90000" name="H263" id="34"></payload-type> <payload-type rate="90000" name="H263-1998" id="96"></payload-type> <payload-type rate="90000" name="H263-N800" id="97"></payload-type> <payload-type rate="90000" name="H264" id="98"></payload-type> <payload-type rate="90000" name="MPV" id="32"></payload-type></description> <transport xmlns="http://www.google.com/transport/p2p"></transport></content></jingle></iq>-----------------------------------[37m19:50:17[0m] [30m[47mJS_STATE_PENDING_CREATED [0m [37mmarking local stream audio1 as signalled[37m19:50:17[0m] [30m[47mJS_STATE_PENDING_CREATED [0m [37mstream audio1 sig_state 0->1[37m19:50:17[0m] [30m[47mJS_STATE_PENDING_CREATED [0m [37mmarking local stream video1 as signalled[37m19:50:17[0m] [30m[47mJS_STATE_PENDING_CREATED [0m [37mstream video1 sig_state 0->1[37m19:50:17[0m] [46mJS_STATE_PENDING_INITIATE_SENT[0m [36mstate changed from JS_STATE_PENDING_CREATED to JS_STATE_PENDING_INITIATE_SENT** (telepathy-gabble:10415): DEBUG: session_state_changed: add a timer: 60s(telepathy-stream-engine:10428): tp-glib-DEBUG: _tp_proxy_pending_call_dgproxy_destroy: 0x75fb60: DBusGProxy 0x75fb00 invalidated(telepathy-stream-engine:10428): farsight-rtp-DEBUG: VIDEO - farsight_rtp_stream_bus_watch_cb: Clock provider found(telepathy-stream-engine:10428): tp-glib-DEBUG: _tp_proxy_pending_call_dgproxy_destroy: 0x7c6c00: DBusGProxy 0x7b0180 invalidated** (telepathy-stream-engine:10428): DEBUG: stream 1 (audio) set_stream_playing: 0** (telepathy-stream-engine:10428): DEBUG: stream 1 (audio) set_stream_sending: 0farsight-rtp-Message: send codec bin not created yet, will set sending later(telepathy-stream-engine:10428): tp-glib-DEBUG: _tp_proxy_pending_call_dgproxy_destroy: 0x7c9000: DBusGProxy 0x7b0180 invalidated(telepathy-stream-engine:10428): tp-glib-DEBUG: _tp_proxy_pending_call_dgproxy_destroy: 0x7c9120: DBusGProxy 0x7c90c0 invalidated** (telepathy-stream-engine:10428): DEBUG: stream 2 (video) set_stream_playing: 0** (telepathy-stream-engine:10428): DEBUG: stream 2 (video) set_stream_sending: 0farsight-rtp-Message: send codec bin not created yet, will set sending later(telepathy-stream-engine:10428): tp-glib-DEBUG: _tp_proxy_pending_call_dgproxy_destroy: 0x7c9180: DBusGProxy 0x7c90c0 invalidatedOnRequestsignaling called, sending SignalingReadyfarsight-transmitter-Message: OnCandidatesReady called with 3 candidates in list(telepathy-stream-engine:10428): farsight-rtp-DEBUG: AUDIO - farsight_rtp_stream_new_native_candidate: Called farsight_rtp_stream_new_native_candidate(telepathy-stream-engine:10428): farsight-rtp-DEBUG: AUDIO - farsight_rtp_stream_new_native_candidate: Native candidates found, adding to list0x7a98c0** (telepathy-stream-engine:10428): DEBUG: stream 1 (audio) cb_fs_new_native_candidate: fs_transport->ip = '127.0.0.1'RECV [99]:-----------------------------------'<iq from='bernard@localhost/Telepathy' to='alice@localhost/Telepathy' type='result' id='96183646'/>'-----------------------------------[37m19:50:17[0m] [46mJS_STATE_PENDING_INITIATE_SENT[0m [33mgabble_media_stream_new_native_candidate: ignoring native localhost candidate[37m19:50:17[0m] [45mJS_STATE_PENDING_INITIATED[0m [36mstate changed from JS_STATE_PENDING_INITIATE_SENT to JS_STATE_PENDING_INITIATED[37m19:50:17[0m] [45mJS_STATE_PENDING_INITIATED[0m [37mmarking local stream audio1 as acknowledged[37m19:50:17[0m] [45mJS_STATE_PENDING_INITIATED[0m [37mstream audio1 sig_state 1->2[37m19:50:17[0m] [45mJS_STATE_PENDING_INITIATED[0m [37mmarking local stream video1 as acknowledged[37m19:50:17[0m] [45mJS_STATE_PENDING_INITIATED[0m [37mstream video1 sig_state 1->2(telepathy-stream-engine:10428): farsight-rtp-DEBUG: AUDIO - farsight_rtp_stream_new_native_candidate: Called farsight_rtp_stream_new_native_candidate(telepathy-stream-engine:10428): farsight-rtp-DEBUG: AUDIO - farsight_rtp_stream_new_native_candidate: Native candidates found, adding to list0x7a5840** (telepathy-stream-engine:10428): DEBUG: stream 1 (audio) cb_fs_new_native_candidate: fs_transport->ip = '10.0.0.200'[37m19:50:17[0m] [45mJS_STATE_PENDING_INITIATED[0m [37mput 1 native candidate from stream-engine into cache[37m19:50:17[0m] [45mJS_STATE_PENDING_INITIATED[0m [32m from Telepathy D-Bus struct: [[22m"L2", [1m[[22m1, "10.0.0.200", 41860, TP_MEDIA_STREAM_BASE_PROTO_UDP (0), "RTP", "AVP", 1.000000, TP_MEDIA_STREAM_TRANSPORT_TYPE_LOCAL (0), "A4lSgiOm4kptaX/b", "9rPGrPdu5RN78HwH"[1m]][37m19:50:17[0m] [45mJS_STATE_PENDING_INITIATED[0m [32m to Jingle XML: [[22m<candidate generation="0" network="0" type="local" protocol="udp" preference="1.000000" password="9rPGrPdu5RN78HwH" username="A4lSgiOm4kptaX/b" port="41860" address="10.0.0.200" name="rtp"></candidate>[1m][37m19:50:17[0m] [45mJS_STATE_PENDING_INITIATED[0m [37msending jingle session action "transport-info" to peerSEND:-----------------------------------<iq type="set" to="bernard@localhost/Telepathy" id="12314195971"> <jingle xmlns="http://jabber.org/protocol/jingle" initiator="alice@localhost/Telepathy" action="transport-info" sid="76393035"> <content creator="initiator" name="audio1"> <transport xmlns="http://www.google.com/transport/p2p"> <candidate generation="0" network="0" type="local" protocol="udp" preference="1.000000" password="9rPGrPdu5RN78HwH" username="A4lSgiOm4kptaX/b" port="41860" address="10.0.0.200" name="rtp"></candidate></transport></content></jingle></iq>-----------------------------------(telepathy-stream-engine:10428): farsight-rtp-DEBUG: AUDIO - farsight_rtp_stream_new_native_candidate: Called farsight_rtp_stream_new_native_candidate(telepathy-stream-engine:10428): farsight-rtp-DEBUG: AUDIO - farsight_rtp_stream_new_native_candidate: Native candidates found, adding to list0x8834e0** (telepathy-stream-engine:10428): DEBUG: stream 1 (audio) cb_fs_new_native_candidate: fs_transport->ip = '88.97.242.46'[37m19:50:17[0m] [45mJS_STATE_PENDING_INITIATED[0m [37mput 1 native candidate from stream-engine into cache[37m19:50:17[0m] [45mJS_STATE_PENDING_INITIATED[0m [32m from Telepathy D-Bus struct: [[22m"L3", [1m[[22m1, "88.97.242.46", 60161, TP_MEDIA_STREAM_BASE_PROTO_UDP (0), "RTP", "AVP", 0.900000, TP_MEDIA_STREAM_TRANSPORT_TYPE_DERIVED (1), "6tecfPF/xqAtGOsk", "1G3lK755+WIymlHz"[1m]][37m19:50:17[0m] [45mJS_STATE_PENDING_INITIATED[0m [32m to Jingle XML: [[22m<candidate generation="0" network="0" type="stun" protocol="udp" preference="0.900000" password="1G3lK755+WIymlHz" username="6tecfPF/xqAtGOsk" port="60161" address="88.97.242.46" name="rtp"></candidate>[1m][37m19:50:17[0m] [45mJS_STATE_PENDING_INITIATED[0m [37msending jingle session action "transport-info" to peerSEND:-----------------------------------<iq type="set" to="bernard@localhost/Telepathy" id="65595197683"> <jingle xmlns="http://jabber.org/protocol/jingle" initiator="alice@localhost/Telepathy" action="transport-info" sid="76393035"> <content creator="initiator" name="audio1"> <transport xmlns="http://www.google.com/transport/p2p"> <candidate generation="0" network="0" type="stun" protocol="udp" preference="0.900000" password="1G3lK755+WIymlHz" username="6tecfPF/xqAtGOsk" port="60161" address="88.97.242.46" name="rtp"></candidate></transport></content></jingle></iq>-----------------------------------OnRequestsignaling called, sending SignalingReadyfarsight-transmitter-Message: OnCandidatesReady called with 2 candidates in list(telepathy-stream-engine:10428): farsight-rtp-DEBUG: VIDEO - farsight_rtp_stream_new_native_candidate: Called farsight_rtp_stream_new_native_candidate(telepathy-stream-engine:10428): farsight-rtp-DEBUG: VIDEO - farsight_rtp_stream_new_native_candidate: Native candidates found, adding to list0x80cce0** (telepathy-stream-engine:10428): DEBUG: stream 2 (video) cb_fs_new_native_candidate: fs_transport->ip = '127.0.0.1'[37m19:50:17[0m] [45mJS_STATE_PENDING_INITIATED[0m [33mgabble_media_stream_new_native_candidate: ignoring native localhost candidate(telepathy-stream-engine:10428): farsight-rtp-DEBUG: VIDEO - farsight_rtp_stream_new_native_candidate: Called farsight_rtp_stream_new_native_candidate(telepathy-stream-engine:10428): farsight-rtp-DEBUG: VIDEO - farsight_rtp_stream_new_native_candidate: Native candidates found, adding to list0x7a24a0** (telepathy-stream-engine:10428): DEBUG: stream 2 (video) cb_fs_new_native_candidate: fs_transport->ip = '10.0.0.200'RECV [102]:-----------------------------------'<iq from='bernard@localhost/Telepathy' to='alice@localhost/Telepathy' type='result' id='12314195971'/>'-----------------------------------[37m19:50:17[0m] [45mJS_STATE_PENDING_INITIATED[0m [37mput 1 native candidate from stream-engine into cache[37m19:50:17[0m] [45mJS_STATE_PENDING_INITIATED[0m [32m from Telepathy D-Bus struct: [[22m"L2", [1m[[22m1, "10.0.0.200", 45865, TP_MEDIA_STREAM_BASE_PROTO_UDP (0), "RTP", "AVP", 1.000000, TP_MEDIA_STREAM_TRANSPORT_TYPE_LOCAL (0), "CLziNXI6D4fIk8cv", "PV9KJK676tw/4N/G"[1m]][37m19:50:17[0m] [45mJS_STATE_PENDING_INITIATED[0m [32m to Jingle XML: [[22m<candidate generation="0" network="0" type="local" protocol="udp" preference="1.000000" password="PV9KJK676tw/4N/G" username="CLziNXI6D4fIk8cv" port="45865" address="10.0.0.200" name="rtp"></candidate>[1m][37m19:50:17[0m] [45mJS_STATE_PENDING_INITIATED[0m [37msending jingle session action "transport-info" to peerSEND:-----------------------------------<iq type="set" to="bernard@localhost/Telepathy" id="70212201535"> <jingle xmlns="http://jabber.org/protocol/jingle" initiator="alice@localhost/Telepathy" action="transport-info" sid="76393035"> <content creator="initiator" name="video1"> <transport xmlns="http://www.google.com/transport/p2p"> <candidate generation="0" network="0" type="local" protocol="udp" preference="1.000000" password="PV9KJK676tw/4N/G" username="CLziNXI6D4fIk8cv" port="45865" address="10.0.0.200" name="rtp"></candidate></transport></content></jingle></iq>-----------------------------------(telepathy-stream-engine:10428): tp-glib-DEBUG: _tp_proxy_pending_call_dgproxy_destroy: 0x7c91e0: DBusGProxy 0x7b0180 invalidated(telepathy-stream-engine:10428): tp-glib-DEBUG: _tp_proxy_pending_call_dgproxy_destroy: 0x7c9240: DBusGProxy 0x7b0180 invalidated(telepathy-stream-engine:10428): tp-glib-DEBUG: _tp_proxy_pending_call_dgproxy_destroy: 0x7c92a0: DBusGProxy 0x7b0180 invalidated(telepathy-stream-engine:10428): tp-glib-DEBUG: _tp_proxy_pending_call_dgproxy_destroy: 0x7c9300: DBusGProxy 0x7c90c0 invalidated(telepathy-stream-engine:10428): tp-glib-DEBUG: _tp_proxy_pending_call_dgproxy_destroy: 0x7c9360: DBusGProxy 0x7c90c0 invalidatedfarsight-transmitter-Message: OnCandidatesReady called with 1 candidates in list(telepathy-stream-engine:10428): farsight-rtp-DEBUG: VIDEO - farsight_rtp_stream_new_native_candidate: Called farsight_rtp_stream_new_native_candidate(telepathy-stream-engine:10428): farsight-rtp-DEBUG: VIDEO - farsight_rtp_stream_new_native_candidate: Native candidates found, adding to list0x79b370** (telepathy-stream-engine:10428): DEBUG: stream 2 (video) cb_fs_new_native_candidate: fs_transport->ip = '88.97.242.46'[37m19:50:17[0m] [45mJS_STATE_PENDING_INITIATED[0m [37mput 1 native candidate from stream-engine into cache[37m19:50:17[0m] [45mJS_STATE_PENDING_INITIATED[0m [32m from Telepathy D-Bus struct: [[22m"L3", [1m[[22m1, "88.97.242.46", 48445, TP_MEDIA_STREAM_BASE_PROTO_UDP (0), "RTP", "AVP", 0.900000, TP_MEDIA_STREAM_TRANSPORT_TYPE_DERIVED (1), "IsxCi0c/1lJyrSVU", "uNYxrgF7W+Rlu4Yt"[1m]][37m19:50:17[0m] [45mJS_STATE_PENDING_INITIATED[0m [32m to Jingle XML: [[22m<candidate generation="0" network="0" type="stun" protocol="udp" preference="0.900000" password="uNYxrgF7W+Rlu4Yt" username="IsxCi0c/1lJyrSVU" port="48445" address="88.97.242.46" name="rtp"></candidate>[1m][37m19:50:17[0m] [45mJS_STATE_PENDING_INITIATED[0m [37msending jingle session action "transport-info" to peerSEND:-----------------------------------<iq type="set" to="bernard@localhost/Telepathy" id="4636300932"> <jingle xmlns="http://jabber.org/protocol/jingle" initiator="alice@localhost/Telepathy" action="transport-info" sid="76393035"> <content creator="initiator" name="video1"> <transport xmlns="http://www.google.com/transport/p2p"> <candidate generation="0" network="0" type="stun" protocol="udp" preference="0.900000" password="uNYxrgF7W+Rlu4Yt" username="IsxCi0c/1lJyrSVU" port="48445" address="88.97.242.46" name="rtp"></candidate></transport></content></jingle></iq>-----------------------------------(telepathy-stream-engine:10428): tp-glib-DEBUG: _tp_proxy_pending_call_dgproxy_destroy: 0x81dc00: DBusGProxy 0x7c90c0 invalidatedRECV [102]:-----------------------------------'<iq from='bernard@localhost/Telepathy' to='alice@localhost/Telepathy' type='result' id='65595197683'/>'-----------------------------------RECV [102]:-----------------------------------'<iq from='bernard@localhost/Telepathy' to='alice@localhost/Telepathy' type='result' id='70212201535'/>'-----------------------------------RECV [101]:-----------------------------------'<iq from='bernard@localhost/Telepathy' to='alice@localhost/Telepathy' type='result' id='4636300932'/>'-----------------------------------OnRequestsignaling called, sending SignalingReadyfarsight-transmitter-Message: OnCandidatesReady called with 1 candidates in list(telepathy-stream-engine:10428): farsight-rtp-DEBUG: AUDIO - farsight_rtp_stream_new_native_candidate: Called farsight_rtp_stream_new_native_candidate(telepathy-stream-engine:10428): farsight-rtp-DEBUG: AUDIO - farsight_rtp_stream_new_native_candidate: Native candidates found, adding to list0x881650** (telepathy-stream-engine:10428): DEBUG: stream 1 (audio) cb_fs_new_native_candidate: fs_transport->ip = '127.0.0.1'farsight-transmitter-Message: OnCandidatesReady called with 1 candidates in list(telepathy-stream-engine:10428): farsight-rtp-DEBUG: AUDIO - farsight_rtp_stream_new_native_candidate: Called farsight_rtp_stream_new_native_candidate(telepathy-stream-engine:10428): farsight-rtp-DEBUG: AUDIO - farsight_rtp_stream_new_native_candidate: Native candidates found, adding to list0x887c90** (telepathy-stream-engine:10428): DEBUG: stream 1 (audio) cb_fs_new_native_candidate: fs_transport->ip = '10.0.0.200'[37m19:50:27[0m] [45mJS_STATE_PENDING_INITIATED[0m [33mgabble_media_stream_new_native_candidate: ignoring native localhost candidate[37m19:50:27[0m] [45mJS_STATE_PENDING_INITIATED[0m [37mput 1 native candidate from stream-engine into cache[37m19:50:27[0m] [45mJS_STATE_PENDING_INITIATED[0m [32m from Telepathy D-Bus struct: [[22m"L5", [1m[[22m1, "10.0.0.200", 51765, TP_MEDIA_STREAM_BASE_PROTO_UDP (0), "RTP", "AVP", 1.000000, TP_MEDIA_STREAM_TRANSPORT_TYPE_LOCAL (0), "8ObXsB067vZ0N3Fo", "J3qPYEXHpefu5j4w"[1m]][37m19:50:27[0m] [45mJS_STATE_PENDING_INITIATED[0m [32m to Jingle XML: [[22m<candidate generation="0" network="0" type="local" protocol="udp" preference="1.000000" password="J3qPYEXHpefu5j4w" username="8ObXsB067vZ0N3Fo" port="51765" address="10.0.0.200" name="rtp"></candidate>[1m][37m19:50:27[0m] [45mJS_STATE_PENDING_INITIATED[0m [37msending jingle session action "transport-info" to peerSEND:-----------------------------------<iq type="set" to="bernard@localhost/Telepathy" id="5592718"> <jingle xmlns="http://jabber.org/protocol/jingle" initiator="alice@localhost/Telepathy" action="transport-info" sid="76393035"> <content creator="initiator" name="audio1"> <transport xmlns="http://www.google.com/transport/p2p"> <candidate generation="0" network="0" type="local" protocol="udp" preference="1.000000" password="J3qPYEXHpefu5j4w" username="8ObXsB067vZ0N3Fo" port="51765" address="10.0.0.200" name="rtp"></candidate></transport></content></jingle></iq>-----------------------------------(telepathy-stream-engine:10428): tp-glib-DEBUG: _tp_proxy_pending_call_dgproxy_destroy: 0x81dc60: DBusGProxy 0x7b0180 invalidated(telepathy-stream-engine:10428): tp-glib-DEBUG: _tp_proxy_pending_call_dgproxy_destroy: 0x81dcc0: DBusGProxy 0x7b0180 invalidatedRECV [98]:-----------------------------------'<iq from='bernard@localhost/Telepathy' to='alice@localhost/Telepathy' type='result' id='5592718'/>'-----------------------------------farsight-transmitter-Message: OnCandidatesReady called with 1 candidates in list(telepathy-stream-engine:10428): farsight-rtp-DEBUG: AUDIO - farsight_rtp_stream_new_native_candidate: Called farsight_rtp_stream_new_native_candidate(telepathy-stream-engine:10428): farsight-rtp-DEBUG: AUDIO - farsight_rtp_stream_new_native_candidate: Native candidates found, adding to list0x881420** (telepathy-stream-engine:10428): DEBUG: stream 1 (audio) cb_fs_new_native_candidate: fs_transport->ip = '88.97.242.46'[37m19:50:27[0m] [45mJS_STATE_PENDING_INITIATED[0m [37mput 1 native candidate from stream-engine into cache[37m19:50:27[0m] [45mJS_STATE_PENDING_INITIATED[0m [32m from Telepathy D-Bus struct: [[22m"L6", [1m[[22m1, "88.97.242.46", 53982, TP_MEDIA_STREAM_BASE_PROTO_UDP (0), "RTP", "AVP", 0.900000, TP_MEDIA_STREAM_TRANSPORT_TYPE_DERIVED (1), "RChdQzI/qlqqx48U", "TtKnlbeVfjjsnlKq"[1m]][37m19:50:27[0m] [45mJS_STATE_PENDING_INITIATED[0m [32m to Jingle XML: [[22m<candidate generation="0" network="0" type="stun" protocol="udp" preference="0.900000" password="TtKnlbeVfjjsnlKq" username="RChdQzI/qlqqx48U" port="53982" address="88.97.242.46" name="rtp"></candidate>[1m][37m19:50:27[0m] [45mJS_STATE_PENDING_INITIATED[0m [37msending jingle session action "transport-info" to peerSEND:-----------------------------------<iq type="set" to="bernard@localhost/Telepathy" id="4735137193"> <jingle xmlns="http://jabber.org/protocol/jingle" initiator="alice@localhost/Telepathy" action="transport-info" sid="76393035"> <content creator="initiator" name="audio1"> <transport xmlns="http://www.google.com/transport/p2p"> <candidate generation="0" network="0" type="stun" protocol="udp" preference="0.900000" password="TtKnlbeVfjjsnlKq" username="RChdQzI/qlqqx48U" port="53982" address="88.97.242.46" name="rtp"></candidate></transport></content></jingle></iq>-----------------------------------RECV [101]:-----------------------------------'<iq from='bernard@localhost/Telepathy' to='alice@localhost/Telepathy' type='result' id='4735137193'/>'-----------------------------------(telepathy-stream-engine:10428): tp-glib-DEBUG: _tp_proxy_pending_call_dgproxy_destroy: 0x81dd20: DBusGProxy 0x7b0180 invalidatedOnRequestsignaling called, sending SignalingReadyfarsight-transmitter-Message: OnCandidatesReady called with 1 candidates in list(telepathy-stream-engine:10428): farsight-rtp-DEBUG: VIDEO - farsight_rtp_stream_new_native_candidate: Called farsight_rtp_stream_new_native_candidate(telepathy-stream-engine:10428): farsight-rtp-DEBUG: VIDEO - farsight_rtp_stream_new_native_candidate: Native candidates found, adding to list0x882280** (telepathy-stream-engine:10428): DEBUG: stream 2 (video) cb_fs_new_native_candidate: fs_transport->ip = '127.0.0.1'farsight-transmitter-Message: OnCandidatesReady called with 1 candidates in list(telepathy-stream-engine:10428): farsight-rtp-DEBUG: VIDEO - farsight_rtp_stream_new_native_candidate: Called farsight_rtp_stream_new_native_candidate(telepathy-stream-engine:10428): farsight-rtp-DEBUG: VIDEO - farsight_rtp_stream_new_native_candidate: Native candidates found, adding to list0x889c30** (telepathy-stream-engine:10428): DEBUG: stream 2 (video) cb_fs_new_native_candidate: fs_transport->ip = '10.0.0.200'[37m19:50:37[0m] [45mJS_STATE_PENDING_INITIATED[0m [33mgabble_media_stream_new_native_candidate: ignoring native localhost candidate[37m19:50:37[0m] [45mJS_STATE_PENDING_INITIATED[0m [37mput 1 native candidate from stream-engine into cache[37m19:50:37[0m] [45mJS_STATE_PENDING_INITIATED[0m [32m from Telepathy D-Bus struct: [[22m"L5", [1m[[22m1, "10.0.0.200", 51423, TP_MEDIA_STREAM_BASE_PROTO_UDP (0), "RTP", "AVP", 1.000000, TP_MEDIA_STREAM_TRANSPORT_TYPE_LOCAL (0), "k5uhAoRlsB6Vcvyl", "Hi8blA4p4XH6JXwL"[1m]][37m19:50:37[0m] [45mJS_STATE_PENDING_INITIATED[0m [32m to Jingle XML: [[22m<candidate generation="0" network="0" type="local" protocol="udp" preference="1.000000" password="Hi8blA4p4XH6JXwL" username="k5uhAoRlsB6Vcvyl" port="51423" address="10.0.0.200" name="rtp"></candidate>[1m][37m19:50:37[0m] [45mJS_STATE_PENDING_INITIATED[0m [37msending jingle session action "transport-info" to peerSEND:-----------------------------------<iq type="set" to="bernard@localhost/Telepathy" id="12835178054"> <jingle xmlns="http://jabber.org/protocol/jingle" initiator="alice@localhost/Telepathy" action="transport-info" sid="76393035"> <content creator="initiator" name="video1"> <transport xmlns="http://www.google.com/transport/p2p"> <candidate generation="0" network="0" type="local" protocol="udp" preference="1.000000" password="Hi8blA4p4XH6JXwL" username="k5uhAoRlsB6Vcvyl" port="51423" address="10.0.0.200" name="rtp"></candidate></transport></content></jingle></iq>-----------------------------------RECV [102]:-----------------------------------'<iq from='bernard@localhost/Telepathy' to='alice@localhost/Telepathy' type='result' id='12835178054'/>'-----------------------------------(telepathy-stream-engine:10428): tp-glib-DEBUG: _tp_proxy_pending_call_dgproxy_destroy: 0x81dd80: DBusGProxy 0x7c90c0 invalidated(telepathy-stream-engine:10428): tp-glib-DEBUG: _tp_proxy_pending_call_dgproxy_destroy: 0x81dde0: DBusGProxy 0x7c90c0 invalidatedfarsight-transmitter-Message: OnCandidatesReady called with 1 candidates in list(telepathy-stream-engine:10428): farsight-rtp-DEBUG: VIDEO - farsight_rtp_stream_new_native_candidate: Called farsight_rtp_stream_new_native_candidate(telepathy-stream-engine:10428): farsight-rtp-DEBUG: VIDEO - farsight_rtp_stream_new_native_candidate: Native candidates found, adding to list0x882830** (telepathy-stream-engine:10428): DEBUG: stream 2 (video) cb_fs_new_native_candidate: fs_transport->ip = '88.97.242.46'[37m19:50:37[0m] [45mJS_STATE_PENDING_INITIATED[0m [37mput 1 native candidate from stream-engine into cache[37m19:50:37[0m] [45mJS_STATE_PENDING_INITIATED[0m [32m from Telepathy D-Bus struct: [[22m"L6", [1m[[22m1, "88.97.242.46", 52368, TP_MEDIA_STREAM_BASE_PROTO_UDP (0), "RTP", "AVP", 0.900000, TP_MEDIA_STREAM_TRANSPORT_TYPE_DERIVED (1), "0+D8mT8nmXpwS5Pd", "sJLpVv1TXdJ8pCJx"[1m]][37m19:50:37[0m] [45mJS_STATE_PENDING_INITIATED[0m [32m to Jingle XML: [[22m<candidate generation="0" network="0" type="stun" protocol="udp" preference="0.900000" password="sJLpVv1TXdJ8pCJx" username="0+D8mT8nmXpwS5Pd" port="52368" address="88.97.242.46" name="rtp"></candidate>[1m][37m19:50:37[0m] [45mJS_STATE_PENDING_INITIATED[0m [37msending jingle session action "transport-info" to peerSEND:-----------------------------------<iq type="set" to="bernard@localhost/Telepathy" id="8229305157"> <jingle xmlns="http://jabber.org/protocol/jingle" initiator="alice@localhost/Telepathy" action="transport-info" sid="76393035"> <content creator="initiator" name="video1"> <transport xmlns="http://www.google.com/transport/p2p"> <candidate generation="0" network="0" type="stun" protocol="udp" preference="0.900000" password="sJLpVv1TXdJ8pCJx" username="0+D8mT8nmXpwS5Pd" port="52368" address="88.97.242.46" name="rtp"></candidate></transport></content></jingle></iq>-----------------------------------RECV [101]:-----------------------------------'<iq from='bernard@localhost/Telepathy' to='alice@localhost/Telepathy' type='result' id='8229305157'/>'-----------------------------------(telepathy-stream-engine:10428): tp-glib-DEBUG: _tp_proxy_pending_call_dgproxy_destroy: 0x81de40: DBusGProxy 0x7c90c0 invalidatedRECV [553]:-----------------------------------'<iq from='bernard@localhost/Telepathy' to='alice@localhost/Telepathy' type='set' id='1633527'> <jingle xmlns='http://jabber.org/protocol/jingle' initiator='alice@localhost/Telepathy' action='transport-info' sid='76393035'> <content creator='initiator' name='audio1'> <transport xmlns='http://www.google.com/transport/p2p'> <candidate generation='0' network='0' type='local' protocol='udp' preference='1.000000' password='XIX0x0rzBUWOe48p' username='k630SkdYj/k7TlOm' port='40523' address='10.0.0.200' name='rtp'/></transport></content></jingle></iq>'-----------------------------------** (telepathy-gabble:10415): DEBUG: media_factory_jingle_cb: dispatching to session 76393035[37m19:50:42[0m] [45mJS_STATE_PENDING_INITIATED[0m [37mgot jingle session action "transport-info" from peer[37m19:50:42[0m] [45mJS_STATE_PENDING_INITIATED[0m [37mput 1 remote candidate from peer into cache[37m19:50:42[0m] [45mJS_STATE_PENDING_INITIATED[0m [32m from Jingle XML: [[22m<candidate name="rtp" address="10.0.0.200" port="40523" username="k630SkdYj/k7TlOm" password="XIX0x0rzBUWOe48p" preference="1.000000" protocol="udp" type="local" network="0" generation="0"></candidate>[1m][37m19:50:42[0m] [45mJS_STATE_PENDING_INITIATED[0m [32m to Telepathy D-Bus struct: [[22m"R1", [1m[[22m1, "10.0.0.200", 40523, TP_MEDIA_STREAM_BASE_PROTO_UDP (0), "RTP", "AVP", 1.000000, TP_MEDIA_STREAM_TRANSPORT_TYPE_LOCAL (0), "k630SkdYj/k7TlOm", "XIX0x0rzBUWOe48p"[1m]][37m19:50:42[0m] [45mJS_STATE_PENDING_INITIATED[0m [36mpassing 1 remote candidate to stream-engineSEND:-----------------------------------<iq type="result" to="bernard@localhost/Telepathy" id="1633527"></iq>-----------------------------------RECV [555]:-----------------------------------'<iq from='bernard@localhost/Telepathy' to='alice@localhost/Telepathy' type='set' id='47705024'> <jingle xmlns='http://jabber.org/protocol/jingle' initiator='alice@localhost/Telepathy' action='transport-info' sid='76393035'> <content creator='initiator' name='audio1'> <transport xmlns='http://www.google.com/transport/p2p'> <candidate generation='0' network='0' type='stun' protocol='udp' preference='0.900000' password='DDsp5iOGaXhwudKJ' username='lVKNRNsFMxBHFFMX' port='59394' address='88.97.242.46' name='rtp'/></transport></content></jingle></iq>'-----------------------------------** (telepathy-gabble:10415): DEBUG: media_factory_jingle_cb: dispatching to session 76393035[37m19:50:42[0m] [45mJS_STATE_PENDING_INITIATED[0m [37mgot jingle session action "transport-info" from peer[37m19:50:42[0m] [45mJS_STATE_PENDING_INITIATED[0m [37mput 1 remote candidate from peer into cache[37m19:50:42[0m] [45mJS_STATE_PENDING_INITIATED[0m [32m from Jingle XML: [[22m<candidate name="rtp" address="88.97.242.46" port="59394" username="lVKNRNsFMxBHFFMX" password="DDsp5iOGaXhwudKJ" preference="0.900000" protocol="udp" type="stun" network="0" generation="0"></candidate>[1m][37m19:50:42[0m] [45mJS_STATE_PENDING_INITIATED[0m [32m to Telepathy D-Bus struct: [[22m"R2", [1m[[22m1, "88.97.242.46", 59394, TP_MEDIA_STREAM_BASE_PROTO_UDP (0), "RTP", "AVP", 0.900000, TP_MEDIA_STREAM_TRANSPORT_TYPE_DERIVED (1), "lVKNRNsFMxBHFFMX", "DDsp5iOGaXhwudKJ"[1m]][37m19:50:42[0m] [45mJS_STATE_PENDING_INITIATED[0m [36mpassing 1 remote candidate to stream-engine** (telepathy-stream-engine:10428): DEBUG: stream 1 (audio) add_remote_candidate: adding remote candidate R1(telepathy-stream-engine:10428): farsight-rtp-DEBUG: AUDIO - farsight_rtp_stream_add_remote_candidate: adding remote candidate 10.0.0.200 40523SEND:-----------------------------------<iq type="result" to="bernard@localhost/Telepathy" id="47705024"></iq>-----------------------------------** (telepathy-stream-engine:10428): DEBUG: stream 1 (audio) add_remote_candidate: adding remote candidate R2(telepathy-stream-engine:10428): farsight-rtp-DEBUG: AUDIO - farsight_rtp_stream_add_remote_candidate: adding remote candidate 88.97.242.46 59394(telepathy-stream-engine:10428): farsight-rtp-DEBUG: AUDIO - farsight_rtp_stream_add_remote_candidate: Added remote candidatefarsight-transmitter-Message: socket state changed to 1** (telepathy-stream-engine:10428): DEBUG: stream 1 (audio) cb_fs_new_active_candidate_pair: stream=0x74f340(telepathy-stream-engine:10428): farsight-rtp-DEBUG: AUDIO - farsight_rtp_stream_transmitter_state_changed: connect state changed to 2** (telepathy-stream-engine:10428): DEBUG: stream 1 (audio) cb_fs_state_changed: stream 0x74f340, state: connected, direction: none** Message: Connected to ReadPacket** Message: mutex is 0x87a490[37m19:50:42[0m] [45mJS_STATE_PENDING_INITIATED[0m [37mstream audio1 connection state 1[37m19:50:42[0m] [45mJS_STATE_PENDING_INITIATED[0m [37mstream audio1 has gone connected[37m19:50:42[0m] [45mJS_STATE_PENDING_INITIATED[0m [37msession initiated by us, so we're not going to consider sending an accept(telepathy-stream-engine:10428): farsight-rtp-DEBUG: AUDIO - farsight_rtp_stream_transmitter_state_changed: Setting pipeline to PLAYING returned 1TpCall: Stream state changed - stream id: 1, state state: 2CallWindow: Status changed - status: 1, stream state: 2(telepathy-stream-engine:10428): tp-glib-DEBUG: _tp_proxy_pending_call_dgproxy_destroy: 0x81dea0: DBusGProxy 0x7b0180 invalidated(telepathy-stream-engine:10428): tp-glib-DEBUG: _tp_proxy_pending_call_dgproxy_destroy: 0x81df00: DBusGProxy 0x7b0180 invalidatedRECV [554]:-----------------------------------'<iq from='bernard@localhost/Telepathy' to='alice@localhost/Telepathy' type='set' id='46436704'> <jingle xmlns='http://jabber.org/protocol/jingle' initiator='alice@localhost/Telepathy' action='transport-info' sid='76393035'> <content creator='initiator' name='video1'> <transport xmlns='http://www.google.com/transport/p2p'> <candidate generation='0' network='0' type='local' protocol='udp' preference='1.000000' password='KnG0+UmmzSQ1ZlPT' username='EmBfpLTmbhSkyqL/' port='40512' address='10.0.0.200' name='rtp'/></transport></content></jingle></iq>'-----------------------------------** (telepathy-gabble:10415): DEBUG: media_factory_jingle_cb: dispatching to session 76393035[37m19:50:42[0m] [45mJS_STATE_PENDING_INITIATED[0m [37mgot jingle session action "transport-info" from peer[37m19:50:42[0m] [45mJS_STATE_PENDING_INITIATED[0m [37mput 1 remote candidate from peer into cache[37m19:50:42[0m] [45mJS_STATE_PENDING_INITIATED[0m [32m from Jingle XML: [[22m<candidate name="rtp" address="10.0.0.200" port="40512" username="EmBfpLTmbhSkyqL/" password="KnG0+UmmzSQ1ZlPT" preference="1.000000" protocol="udp" type="local" network="0" generation="0"></candidate>[1m][37m19:50:42[0m] [45mJS_STATE_PENDING_INITIATED[0m [32m to Telepathy D-Bus struct: [[22m"R1", [1m[[22m1, "10.0.0.200", 40512, TP_MEDIA_STREAM_BASE_PROTO_UDP (0), "RTP", "AVP", 1.000000, TP_MEDIA_STREAM_TRANSPORT_TYPE_LOCAL (0), "EmBfpLTmbhSkyqL/", "KnG0+UmmzSQ1ZlPT"[1m]][37m19:50:42[0m] [45mJS_STATE_PENDING_INITIATED[0m [36mpassing 1 remote candidate to stream-engineSEND:-----------------------------------<iq type="result" to="bernard@localhost/Telepathy" id="46436704"></iq>-----------------------------------RECV [555]:-----------------------------------'<iq from='bernard@localhost/Telepathy' to='alice@localhost/Telepathy' type='set' id='83569413'> <jingle xmlns='http://jabber.org/protocol/jingle' initiator='alice@localhost/Telepathy' action='transport-info' sid='76393035'> <content creator='initiator' name='video1'> <transport xmlns='http://www.google.com/transport/p2p'> <candidate generation='0' network='0' type='stun' protocol='udp' preference='0.900000' password='vLeiIxW0oYQ9oCQB' username='tf3TCcJDCwX8vep3' port='48506' address='88.97.242.46' name='rtp'/></transport></content></jingle></iq>'-----------------------------------** (telepathy-gabble:10415): DEBUG: media_factory_jingle_cb: dispatching to session 76393035[37m19:50:42[0m] [45mJS_STATE_PENDING_INITIATED[0m [37mgot jingle session action "transport-info" from peer[37m19:50:42[0m] [45mJS_STATE_PENDING_INITIATED[0m [37mput 1 remote candidate from peer into cache[37m19:50:42[0m] [45mJS_STATE_PENDING_INITIATED[0m [32m from Jingle XML: [[22m<candidate name="rtp" address="88.97.242.46" port="48506" username="tf3TCcJDCwX8vep3" password="vLeiIxW0oYQ9oCQB" preference="0.900000" protocol="udp" type="stun" network="0" generation="0"></candidate>[1m][37m19:50:42[0m] [45mJS_STATE_PENDING_INITIATED[0m [32m to Telepathy D-Bus struct: [[22m"R2", [1m[[22m1, "88.97.242.46", 48506, TP_MEDIA_STREAM_BASE_PROTO_UDP (0), "RTP", "AVP", 0.900000, TP_MEDIA_STREAM_TRANSPORT_TYPE_DERIVED (1), "tf3TCcJDCwX8vep3", "vLeiIxW0oYQ9oCQB"[1m]][37m19:50:42[0m] [45mJS_STATE_PENDING_INITIATED[0m [36mpassing 1 remote candidate to stream-engineSEND:-----------------------------------<iq type="result" to="bernard@localhost/Telepathy" id="83569413"></iq>-----------------------------------** (telepathy-stream-engine:10428): DEBUG: stream 2 (video) add_remote_candidate: adding remote candidate R1(telepathy-stream-engine:10428): farsight-rtp-DEBUG: VIDEO - farsight_rtp_stream_add_remote_candidate: adding remote candidate 10.0.0.200 40512** (telepathy-stream-engine:10428): DEBUG: stream 2 (video) add_remote_candidate: adding remote candidate R2(telepathy-stream-engine:10428): farsight-rtp-DEBUG: VIDEO - farsight_rtp_stream_add_remote_candidate: adding remote candidate 88.97.242.46 48506(telepathy-stream-engine:10428): farsight-rtp-DEBUG: VIDEO - farsight_rtp_stream_add_remote_candidate: Added remote candidatefarsight-transmitter-Message: socket state changed to 1** (telepathy-stream-engine:10428): DEBUG: stream 2 (video) cb_fs_new_active_candidate_pair: stream=0x74fe30(telepathy-stream-engine:10428): farsight-rtp-DEBUG: VIDEO - farsight_rtp_stream_transmitter_state_changed: connect state changed to 2** (telepathy-stream-engine:10428): DEBUG: stream 2 (video) cb_fs_state_changed: stream 0x74fe30, state: connected, direction: none** Message: Connected to ReadPacket** Message: mutex is 0x88f5e0[37m19:50:42[0m] [45mJS_STATE_PENDING_INITIATED[0m [37mstream video1 connection state 1[37m19:50:42[0m] [45mJS_STATE_PENDING_INITIATED[0m [37mstream video1 has gone connected[37m19:50:42[0m] [45mJS_STATE_PENDING_INITIATED[0m [37msession initiated by us, so we're not going to consider sending an accept(telepathy-stream-engine:10428): farsight-rtp-DEBUG: VIDEO - farsight_rtp_stream_transmitter_state_changed: Setting pipeline to PLAYING returned 1TpCall: Stream state changed - stream id: 2, state state: 2TpCall: RECEIVINGCallWindow: Receiving video signal receivedCallWindow: Setting output video is drawing - 1CallWindow: Output socket realizedTpCall: Adding output video - socket: 92275113TpCall: SENDINGCallWindow: Sending video signal receivedCallWindow: Status changed - status: 1, stream state: 2(telepathy-stream-engine:10428): tp-glib-DEBUG: _tp_proxy_pending_call_dgproxy_destroy: 0x81de40: DBusGProxy 0x7c90c0 invalidated(telepathy-stream-engine:10428): tp-glib-DEBUG: _tp_proxy_pending_call_dgproxy_destroy: 0x81dde0: DBusGProxy 0x7c90c0 invalidated** (telepathy-stream-engine:10428): DEBUG: tp_stream_engine_set_output_window: channel_path=/org/freedesktop/Telepathy/Connection/gabble/jabber/alice_40localhost_2fTelepathy/MediaChannel0, stream_id=2, window_id=92275113** (telepathy-stream-engine:10428): DEBUG: made video sink element gconfvideosink0** (telepathy-stream-engine:10428): DEBUG: linking videoscale** (telepathy-stream-engine:10428): DEBUG: linking ffmpegcolorspace** (telepathy-stream-engine:10428): DEBUG: stream 2 (video) tp_stream_engine_stream_set_output_window: putting video output in window 92275113** (telepathy-stream-engine:10428): DEBUG: Adding to windowpair list sink 0x74d7e0 window_id 92275113** (telepathy-stream-engine:10428): DEBUG: setting sync to FALSE** (telepathy-stream-engine:10428): DEBUG: setting qos to FALSE** (telepathy-stream-engine:10428): DEBUG: setting async to FALSE** (telepathy-stream-engine:10428): DEBUG: setting sync to FALSE** (telepathy-stream-engine:10428): DEBUG: setting qos to FALSE** (telepathy-stream-engine:10428): DEBUG: setting async to FALSE** (telepathy-stream-engine:10428): DEBUG: setting sync to FALSE** (telepathy-stream-engine:10428): DEBUG: setting qos to FALSE** (telepathy-stream-engine:10428): DEBUG: setting force-aspect-ratio to TRUE** (telepathy-stream-engine:10428): DEBUG: setting async to FALSE(telepathy-stream-engine:10428): farsight-rtp-DEBUG: VIDEO - farsight_rtp_stream_set_sink: setting sink bin6(telepathy-stream-engine:10428): farsight-rtp-DEBUG: VIDEO - farsight_rtp_stream_set_sink: No capsfilter, setting sink for future use(empathy-call-chandler:10426): tp-glib-DEBUG: _tp_proxy_pending_call_dgproxy_destroy: 0x6a2760: DBusGProxy 0x6a25e0 invalidated** (telepathy-gabble:10415): DEBUG: timeout_session: session timed out** (telepathy-gabble:10415): DEBUG: timeout_session: ... but let the session continueRECV [236]:-----------------------------------'<iq from='bernard@localhost/Telepathy' to='alice@localhost/Telepathy' type='set' id='12475572854'> <jingle xmlns='http://jabber.org/protocol/jingle' initiator='alice@localhost/Telepathy' action='session-terminate' sid='76393035'/></iq>'-----------------------------------** (telepathy-gabble:10415): DEBUG: media_factory_jingle_cb: dispatching to session 76393035[37m19:52:06[0m] [45mJS_STATE_PENDING_INITIATED[0m [37mgot jingle session action "session-terminate" from peer** (telepathy-gabble:10415): DEBUG: _handle_terminate: called for (null)[37m19:52:06[0m] [41mJS_STATE_ENDED [0m [36mstate changed from JS_STATE_PENDING_INITIATED to JS_STATE_ENDED[36mtp_group_mixin_change_members: emitting members changed message : "" added : [[22m[1m] removed : [[22m1 (alice@localhost) 2 (bernard@localhost)[1m] local_pending : [[22m[1m] remote_pending: [[22m[1m] actor : 2 reason : 0: unspecified reason[37mtp_group_mixin_change_flags: emitting group flags changed added : [[22mCAN_ADD[1m] removed : [[22mCAN_REMOVE[1m] flags now: [[22mCAN_ADD|CAN_RESCIND[1m][0m** (telepathy-gabble:10415): DEBUG: gabble_media_channel_close: called on 0x72b810** (telepathy-gabble:10415): DEBUG: media_channel_closed_cb: removing media channel 0x72b810 with ref count 3SEND:-----------------------------------<iq type="result" to="bernard@localhost/Telepathy" id="12475572854"></iq>-----------------------------------** (telepathy-gabble:10415): DEBUG: gabble_media_session_dispose: calledTpGroup: Members changed for list (null): added-len=0, current-len=1 removed-len=2 local-pending-len=0, current-len=0 remote-pending-len=0, current-len=1TpContactFactory: Remove finalized contact 0x7bcb60Contact: finalize: 0x7bcb60TpGroup: Members changed done for list (null): members-len=0 local-pendings-len=0 remote-pendings-len=0TpCall: Channel closedCallWindow: Status changed - status: 3, stream state: 2CallWindow: Setting output video is drawing - 0TpCall: Adding output video - socket: 0TpGroup: Account disconnected or CM crashed** (process:10409): DEBUG: Channel proxy destroyed (Channel was closed)!** (process:10409): DEBUG: _mcd_mission_set_parent: child = 0x626c50, parent = (nil)** (process:10409): DEBUG: removing mission: 0x626c50** (process:10409): DEBUG: Abort Channel; Removing channel from list** (process:10409): DEBUG: _mcd_channel_dispose for 0x626c50 (is disposed = 0)** (process:10409): DEBUG: _mcd_channel_release_tp_channel: Requesting telepathy to close the channel** (process:10409): DEBUG: mission disposed 0x626c50** (process:10409): DEBUG: mission finalized 0x626c50** (process:10409): DEBUG: Channel closed(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_proxy_invalidate: 0x63a8b0: Channel was closed(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_proxy_signal_connection_proxy_invalidated: 0x62b170: TpProxy 0x63a8b0 invalidated (I have 0x63a8b0): Channel was closed** (telepathy-stream-engine:10428): DEBUG: channel /org/freedesktop/Telepathy/Connection/gabble/jabber/alice_40localhost_2fTelepathy/MediaChannel0 (0x63d8d0) closed** (telepathy-stream-engine:10428): DEBUG: channels remaining: 0** (telepathy-stream-engine:10428): DEBUG: preview windows remaining: 1** (telepathy-stream-engine:10428): DEBUG: tp_stream_engine_channel_dispose** (telepathy-stream-engine:10428): DEBUG: tp_stream_engine_session_dispose(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_proxy_signal_connection_lost_weak_ref: 0x76e120: lost weak ref to 0x764500(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_proxy_dispose: 0x7b0000(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_proxy_invalidate: 0x7b0000: Proxy unreferenced(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_proxy_signal_connection_proxy_invalidated: 0x76e0b0: TpProxy 0x7b0000 invalidated (I have 0x7b0000): Proxy unreferenced(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_proxy_signal_connection_proxy_invalidated: 0x76e040: TpProxy 0x7b0000 invalidated (I have 0x7b0000): Proxy unreferenced(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_proxy_signal_connection_proxy_invalidated: 0x76cb40: TpProxy 0x7b0000 invalidated (I have 0x7b0000): Proxy unreferenced(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_proxy_signal_connection_proxy_invalidated: 0x76cad0: TpProxy 0x7b0000 invalidated (I have 0x7b0000): Proxy unreferenced(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_proxy_signal_connection_proxy_invalidated: 0x76ca60: TpProxy 0x7b0000 invalidated (I have 0x7b0000): Proxy unreferenced(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_proxy_signal_connection_proxy_invalidated: 0x76c9f0: TpProxy 0x7b0000 invalidated (I have 0x7b0000): Proxy unreferenced(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_proxy_signal_connection_proxy_invalidated: 0x76c980: TpProxy 0x7b0000 invalidated (I have 0x7b0000): Proxy unreferenced(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_proxy_signal_connection_proxy_invalidated: 0x76c910: TpProxy 0x7b0000 invalidated (I have 0x7b0000): Proxy unreferenced(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_proxy_signal_connection_proxy_invalidated: 0x76c8a0: TpProxy 0x7b0000 invalidated (I have 0x7b0000): Proxy unreferenced(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_proxy_signal_connection_proxy_invalidated: 0x76c830: TpProxy 0x7b0000 invalidated (I have 0x7b0000): Proxy unreferenced(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_proxy_finalize: 0x7b0000** (telepathy-stream-engine:10428): DEBUG: stream 1 (audio) stop_stream: calling stop on farsight stream 0x74f340(telepathy-stream-engine:10428): farsight-rtp-DEBUG: AUDIO - farsight_rtp_stream_set_source: setting src(telepathy-stream-engine:10428): farsight-rtp-DEBUG: AUDIO - farsight_rtp_stream_destroy: stopping media pipeline(telepathy-stream-engine:10428): farsight-rtp-DEBUG: AUDIO - farsight_rtp_stream_destroy: Setting state to NULL(telepathy-stream-engine:10428): farsight-rtp-DEBUG: AUDIO - farsight_rtp_stream_destroy: DONE Setting state to NULL returned 1(telepathy-stream-engine:10428): farsight-rtp-DEBUG: AUDIO - farsight_rtp_stream_destroy: Changed pipeline state to NULL succesfully(telepathy-stream-engine:10428): farsight-transmitter-DEBUG: farsight_lj_transmitter_stop (248): destroying socket client(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_proxy_signal_connection_lost_weak_ref: 0x76e0b0: lost weak ref to 0x7370a0(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_proxy_signal_connection_lost_weak_ref: 0x76e040: lost weak ref to 0x7370a0(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_proxy_signal_connection_lost_weak_ref: 0x76cb40: lost weak ref to 0x7370a0(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_proxy_signal_connection_lost_weak_ref: 0x76cad0: lost weak ref to 0x7370a0(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_proxy_signal_connection_lost_weak_ref: 0x76ca60: lost weak ref to 0x7370a0(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_proxy_signal_connection_lost_weak_ref: 0x76c9f0: lost weak ref to 0x7370a0(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_proxy_signal_connection_lost_weak_ref: 0x76c980: lost weak ref to 0x7370a0(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_proxy_signal_connection_lost_weak_ref: 0x76c910: lost weak ref to 0x7370a0(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_proxy_signal_connection_lost_weak_ref: 0x76c8a0: lost weak ref to 0x7370a0(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_proxy_signal_connection_lost_weak_ref: 0x76c830: lost weak ref to 0x7370a0(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_proxy_dispose: 0x7c9060(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_proxy_invalidate: 0x7c9060: Proxy unreferenced(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_proxy_signal_connection_proxy_invalidated: 0x7986a0: TpProxy 0x7c9060 invalidated (I have 0x7c9060): Proxy unreferenced(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_proxy_signal_connection_proxy_invalidated: 0x798710: TpProxy 0x7c9060 invalidated (I have 0x7c9060): Proxy unreferenced(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_proxy_signal_connection_proxy_invalidated: 0x7b8410: TpProxy 0x7c9060 invalidated (I have 0x7c9060): Proxy unreferenced(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_proxy_signal_connection_proxy_invalidated: 0x7b8480: TpProxy 0x7c9060 invalidated (I have 0x7c9060): Proxy unreferenced(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_proxy_signal_connection_proxy_invalidated: 0x7692b0: TpProxy 0x7c9060 invalidated (I have 0x7c9060): Proxy unreferenced(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_proxy_signal_connection_proxy_invalidated: 0x798630: TpProxy 0x7c9060 invalidated (I have 0x7c9060): Proxy unreferenced(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_proxy_signal_connection_proxy_invalidated: 0x798400: TpProxy 0x7c9060 invalidated (I have 0x7c9060): Proxy unreferenced(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_proxy_signal_connection_proxy_invalidated: 0x76e270: TpProxy 0x7c9060 invalidated (I have 0x7c9060): Proxy unreferenced(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_proxy_signal_connection_proxy_invalidated: 0x76c0f0: TpProxy 0x7c9060 invalidated (I have 0x7c9060): Proxy unreferenced(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_proxy_signal_connection_proxy_invalidated: 0x76c160: TpProxy 0x7c9060 invalidated (I have 0x7c9060): Proxy unreferenced(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_proxy_finalize: 0x7c9060** (telepathy-stream-engine:10428): DEBUG: stream 2 (video) stop_stream: calling stop on farsight stream 0x74fe30(telepathy-stream-engine:10428): farsight-rtp-DEBUG: VIDEO - farsight_rtp_stream_set_source: setting src** (telepathy-stream-engine:10428): DEBUG: stream 2 (video) _remove_video_sink: removing video sink(telepathy-stream-engine:10428): farsight-rtp-DEBUG: VIDEO - farsight_rtp_stream_destroy: stopping media pipeline(telepathy-stream-engine:10428): farsight-rtp-DEBUG: VIDEO - farsight_rtp_stream_destroy: Setting state to NULL(telepathy-stream-engine:10428): farsight-rtp-DEBUG: VIDEO - farsight_rtp_stream_destroy: DONE Setting state to NULL returned 1(telepathy-stream-engine:10428): farsight-rtp-DEBUG: VIDEO - farsight_rtp_stream_destroy: Changed pipeline state to NULL succesfully(telepathy-stream-engine:10428): farsight-transmitter-DEBUG: farsight_lj_transmitter_stop (248): destroying socket clientfarsight-Message: Unloading plugin libjingle-transmitterfarsight-Message: Unloading plugin rtp-session(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_proxy_signal_connection_lost_weak_ref: 0x7986a0: lost weak ref to 0x7371a0(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_proxy_signal_connection_lost_weak_ref: 0x798710: lost weak ref to 0x7371a0(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_proxy_signal_connection_lost_weak_ref: 0x7b8410: lost weak ref to 0x7371a0(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_proxy_signal_connection_lost_weak_ref: 0x7b8480: lost weak ref to 0x7371a0(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_proxy_signal_connection_lost_weak_ref: 0x7692b0: lost weak ref to 0x7371a0(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_proxy_signal_connection_lost_weak_ref: 0x798630: lost weak ref to 0x7371a0(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_proxy_signal_connection_lost_weak_ref: 0x798400: lost weak ref to 0x7371a0(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_proxy_signal_connection_lost_weak_ref: 0x76e270: lost weak ref to 0x7371a0(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_proxy_signal_connection_lost_weak_ref: 0x76c0f0: lost weak ref to 0x7371a0(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_proxy_signal_connection_lost_weak_ref: 0x76c160: lost weak ref to 0x7371a0(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_proxy_signal_connection_lost_weak_ref: 0x755f20: lost weak ref to 0x63d8d0(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_proxy_signal_connection_lost_weak_ref: 0x755eb0: lost weak ref to 0x63d8d0(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_channel_dispose: 0x63a8b0(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_connection_dispose: 0x737020(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_proxy_dispose: 0x737020(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_proxy_invalidate: 0x737020: Proxy unreferenced(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_proxy_signal_connection_proxy_invalidated: 0x62b020: TpProxy 0x737020 invalidated (I have 0x737020): Proxy unreferenced(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_proxy_finalize: 0x737020(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_proxy_dispose: 0x63a8b0(telepathy-stream-engine:10428): tp-glib-DEBUG: tp_proxy_finalize: 0x63a8b0** (telepathy-stream-engine:10428): DEBUG: tp_stream_engine_set_output_window: channel_path=/org/freedesktop/Telepathy/Connection/gabble/jabber/alice_40localhost_2fTelepathy/MediaChannel0, stream_id=2, window_id=0(empathy-call-chandler:10426): tp-glib-DEBUG: _tp_proxy_pending_call_dgproxy_destroy: 0x6a26a0: DBusGProxy 0x6a25e0 invalidatedTpCall: Error setting output window: org.freedesktop.Telepathy.Error.NotAvailable: stream-engine is not handling the channel /org/freedesktop/Telepathy/Connection/gabble/jabber/alice_40localhost_2fTelepathy/MediaChannel0(empathy-call-chandler:10426): tp-glib-DEBUG: tp_proxy_dispose: 0x633240(empathy-call-chandler:10426): tp-glib-DEBUG: tp_proxy_invalidate: 0x633240: Proxy unreferenced(empathy-call-chandler:10426): tp-glib-DEBUG: tp_proxy_finalize: 0x633240