desktop-packages team mailing list archive

Thread
Date
[Bug 878943] Re: Empathy fails to start jabber audio and video calls

To: desktop-packages@xxxxxxxxxxxxxxxxxxx
From: Johannes Albert <878943@xxxxxxxxxxxxxxxxxx>
Date: Mon, 24 Oct 2011 10:27:23 -0000
Reply-to: Bug 878943 <878943@xxxxxxxxxxxxxxxxxx>
Sender: bounces@xxxxxxxxxxxxx
Apparently, this issue was fixed with a batch of updates earlier today
including empathy 3.2.0.1-0ubuntu1. I still have some audio and video
issues to look into, but it's possible to establish a call now so I'd
consider this bug resolved...

** Changed in: empathy (Ubuntu)
       Status: Confirmed => Fix Released

-- 
You received this bug notification because you are a member of Desktop
Packages, which is subscribed to empathy in Ubuntu.
https://bugs.launchpad.net/bugs/878943

Title:
  Empathy fails to start jabber audio and video calls

Status in “empathy” package in Ubuntu:
  Fix Released

Bug description:
  When trying to launch an audio or video call via jabber, a pop-up
  states that "There was an error starting the call".

  mission-control log of failed audio call:

  mcd-DEBUG: 20.10.2011 18:06:38.927711: dispatcher_channel_request_acl_start: start /org/freedesktop/Telepathy/Account/gabble/jabber/***_2e***_40jabber_2eorg0.org.freedesktop.Telepathy.Connection.Interface.Requests.CreateChannel acl (0x1152cc0)
  mcd-DEBUG: 20.10.2011 18:06:38.927865: dispatcher_channel_request_acl_success: complete acl (0x1152cc0)
  mcd-DEBUG: 20.10.2011 18:06:38.928067: _mcd_request_init: 0x12fba40
  mcd-DEBUG: 20.10.2011 18:06:38.928301: _mcd_request_new: 0x12fba40 (for 0x1186780)
  mcd-DEBUG: 20.10.2011 18:06:38.928432: _mcd_channel_set_status: 0x127b580, 1
  mcd-DEBUG: 20.10.2011 18:06:38.928644: _mcd_request_predict_handler: No known handler for request /com/nokia/MissionControl/requests/r13
  mcd-DEBUG: 20.10.2011 18:06:38.928742: dispatcher_channel_request_acl_cleanup: cleanup acl (0x1152cc0)
  mcd-DEBUG: 20.10.2011 18:06:38.944937: ready_to_request_cb: Starting online request
  mcd-DEBUG: 20.10.2011 18:06:38.945008: _mcd_account_online_request: connection status for gabble/jabber/***_2e***_40jabber_2eorg0 is 0
  mcd-DEBUG: 20.10.2011 18:06:38.945064: _mcd_account_online_request: gabble/jabber/***_2e***_40jabber_2eorg0 is already connected
  mcd-DEBUG: 20.10.2011 18:06:38.945117: online_request_cb: called
  mcd-DEBUG: 20.10.2011 18:06:38.945174: _mcd_mission_set_parent: child = 0x127b580, parent = 0x12108d0
  mcd-DEBUG: 20.10.2011 18:06:38.945339: _mcd_channel_set_status: 0x127b580, 2
  mcd-DEBUG: 20.10.2011 18:06:38.959177: common_request_channel_cb: 0x127b580, object /org/freedesktop/Telepathy/Connection/gabble/jabber/***_2e***_40jabber_2eorg_2f3121af7e/CallChannel8
  mcd-DEBUG: 20.10.2011 18:06:38.969230: _mcd_dispatcher_take_channels: requested channel 0x127b580 (only): /org/freedesktop/Telepathy/Connection/gabble/jabber/***_2e***_40jabber_2eorg_2f3121af7e/CallChannel8
  mcd-DEBUG: 20.10.2011 18:06:38.969338: _mcd_dispatcher_take_channels: One channel, which cannot be handled
  mcd-DEBUG: 20.10.2011 18:06:38.969399: _mcd_channel_undispatchable: 0x127b580: /org/freedesktop/Telepathy/Connection/gabble/jabber/***_2e***_40jabber_2eorg_2f3121af7e/CallChannel8
  mcd-DEBUG: 20.10.2011 18:06:38.969455: _mcd_channel_undispatchable: calling Close()
  mcd-DEBUG: 20.10.2011 18:06:38.973386: on_channel_ready: channel 0x127b580 is ready
  mcd-DEBUG: 20.10.2011 18:06:38.980263: proxy_destroyed: Channel proxy invalidated: tp_dbus_errors_quark 8: Channel was closed
  mcd-DEBUG: 20.10.2011 18:06:38.980349: mcd_channel_abort: 0x127b580
  mcd-DEBUG: 20.10.2011 18:06:38.980406: _mcd_channel_set_status: 0x127b580, 6
  mcd-DEBUG: 20.10.2011 18:06:38.980468: _mcd_request_set_failure: Request failed: tp_errors 5: Channel aborted
  mcd-DEBUG: 20.10.2011 18:06:38.980691: _mcd_channel_set_status: 0x127b580, 7
  mcd-DEBUG: 20.10.2011 18:06:38.980760: _mcd_mission_set_parent: child = 0x127b580, parent = (nil)
  mcd-DEBUG: 20.10.2011 18:06:38.980819: _mcd_operation_remove_mission: removing mission: 0x127b580
  mcd-DEBUG: 20.10.2011 18:06:38.980875: _mcd_channel_dispose: 0x127b580 (is disposed = 0)
  mcd-DEBUG: 20.10.2011 18:06:38.980933: _mcd_mission_dispose: mission disposed 0x127b580
  mcd-DEBUG: 20.10.2011 18:06:38.980992: _mcd_request_dispose: 0x12fba40
  mcd-DEBUG: 20.10.2011 18:06:38.981049: _mcd_request_finalize: 0x12fba40
  mcd-DEBUG: 20.10.2011 18:06:38.981106: _mcd_mission_finalize: mission finalized 0x127b580
  mcd-WARNING: 20.10.2011 18:06:38.980617: Channel request /com/nokia/MissionControl/requests/r13 failed, error: Channel aborted

  gabble (jabber) log:

  gabble/media-channel-DEBUG: 20.10.2011 18:07:18.345813: gabble_media_factory_create_call (media-factory.c:856): Creating a new call channel
  tp-yell/call-DEBUG: 20.10.2011 18:07:18.346120: tpy_base_call_channel_add_member: Member 2 (flags: 0) added
  gabble/jid-DEBUG: 20.10.2011 18:07:18.346200: gabble_signal_connect_weak (util.c:966): connecting to 0x15a0180:flags-changed with context 0x1549640
  gabble/media-channel-DEBUG: 20.10.2011 18:07:18.346328: gabble_jingle_session_init (jingle-session.c:191): Initializing the jingle session 0x12346d0
  gabble/media-channel-DEBUG: 20.10.2011 18:07:18.346519: create_session (jingle-factory.c:835): new session (***@jabber.org/c4382b92, 1339534884) @ 0x12346d0
  gabble/media-channel-DEBUG: 20.10.2011 18:07:18.346580: gabble_call_member_set_session (call-member.c:344): Setting session: 0x15a0180 -> 0x12346d0
  gabble/jid-DEBUG: 20.10.2011 18:07:18.346643: gabble_signal_connect_weak (util.c:966): connecting to 0x12346d0:remote-state-changed with context 0xbcdce0
  gabble/jid-DEBUG: 20.10.2011 18:07:18.346705: gabble_signal_connect_weak (util.c:966): connecting to 0x12346d0:new-content with context 0xbcdc40
  gabble/media-channel-DEBUG: 20.10.2011 18:07:18.346772: gabble_call_member_create_content (call-member.c:454): Creating new content audio, type 1
  gabble/media-channel-DEBUG: 20.10.2011 18:07:18.346827: gabble_call_member_create_content (call-member.c:457): existing call, using peer resource c4382b92
  gabble/media-channel-DEBUG: 20.10.2011 18:07:18.346885: gabble_call_member_create_content (call-member.c:473): Creating new jingle content with ns urn:xmpp:jingle:apps:rtp:1 : http://www.google.com/transport/p2p
  gabble/media-channel-DEBUG: 20.10.2011 18:07:18.346945: create_content (jingle-session.c:816): session creating new content name audio, type 1, conn 0xb92420, jf 0xb6c480
  gabble/media-channel-DEBUG: 20.10.2011 18:07:18.347018: gabble_jingle_content_init (jingle-content.c:115): 0xb711d0
  gabble/media-channel-DEBUG: 20.10.2011 18:07:18.347121: create_content (jingle-session.c:855): inserting content audio into initiator_contents
  gabble/jid-DEBUG: 20.10.2011 18:07:18.347206: gabble_signal_connect_weak (util.c:966): connecting to 0x15a0180:notify::session with context 0x1551ca0
  gabble/jid-DEBUG: 20.10.2011 18:07:18.347275: gabble_signal_connect_weak (util.c:966): connecting to 0xb711d0:removed with context 0x1551c60
  gabble/jid-DEBUG: 20.10.2011 18:07:18.347337: gabble_signal_connect_weak (util.c:966): connecting to 0xb711d0:remote-media-description with context 0xee1460
  gabble/jid-DEBUG: 20.10.2011 18:07:18.347399: gabble_signal_connect_weak (util.c:966): connecting to 0x15a01e0:removed with context 0x1538a00
  gabble/jid-DEBUG: 20.10.2011 18:07:18.347464: gabble_signal_connect_weak (util.c:966): connecting to 0x12346d0:notify::state with context 0x1549860
  tp-yell/call-DEBUG: 20.10.2011 18:07:18.347567: tpy_base_call_content_constructed: Registering /org/freedesktop/Telepathy/Connection/gabble/jabber/***_2e***_40jabber_2eorg_2f3121af7e/CallChannel9/Content_audio_1
  tp-yell/call-DEBUG: 20.10.2011 18:07:18.347728: tpy_base_call_stream_constructed: Registering /org/freedesktop/Telepathy/Connection/gabble/jabber/***_2e***_40jabber_2eorg_2f3121af7e/CallChannel9/Content_audio_1/Stream0xb711d0
  tp-yell/call-DEBUG: 20.10.2011 18:07:18.347902: tpy_call_stream_endpoint_constructed: Registering /org/freedesktop/Telepathy/Connection/gabble/jabber/***_2e***_40jabber_2eorg_2f3121af7e/CallChannel9/Content_audio_1/Stream0xb711d0/Endpoint
  gabble/media-channel-DEBUG: 20.10.2011 18:07:18.348093: gabble_call_stream_constructed (call-stream.c:348): Attempting to create Google relay session
  gabble/media-channel-DEBUG: 20.10.2011 18:07:18.348157: gabble_jingle_factory_create_google_relay_session (jingle-factory.c:1159): No relay server provided, not creating google relay session
  gabble/media-channel-DEBUG: 20.10.2011 18:07:18.348282: call_stream_update_member_states (call-stream.c:394): Created by us?: 1, State: 0
  tp-yell/call-DEBUG: 20.10.2011 18:07:18.348366: tpy_base_call_stream_remote_member_update_state: Updating remote member 2 state: 0 => 1
  gabble/jid-DEBUG: 20.10.2011 18:07:18.348423: gabble_signal_connect_weak (util.c:966): connecting to 0xb711d0:notify::state with context 0xf01d00
  gabble/jid-DEBUG: 20.10.2011 18:07:18.348489: gabble_signal_connect_weak (util.c:966): connecting to 0xb711d0:notify::senders with context 0x1553580
  gabble/jid-DEBUG: 20.10.2011 18:07:18.348551: gabble_signal_connect_weak (util.c:966): connecting to 0xb6c480:stun-server-changed with context 0x1522da0
  gabble/jid-DEBUG: 20.10.2011 18:07:18.348659: gabble_signal_connect_weak (util.c:966): connecting to 0x15a01e0:codecs-changed with context 0x15d2c00
  gabble/jid-DEBUG: 20.10.2011 18:07:18.348722: gabble_signal_connect_weak (util.c:966): connecting to 0x15a01e0:got-jingle-content with context 0xbd58a0
  gabble/jid-DEBUG: 20.10.2011 18:07:18.348783: gabble_signal_connect_weak (util.c:966): connecting to 0x15a01e0:removed with context 0x15aaaa0
  tp-yell/call-DEBUG: 20.10.2011 18:07:18.348881: tpy_call_content_codec_offer_offer: Registering /org/freedesktop/Telepathy/Connection/gabble/jabber/***_2e***_40jabber_2eorg_2f3121af7e/CallChannel9/Content_audio_1/Offer0
  tp-yell/call-DEBUG: 20.10.2011 18:07:18.348978: tpy_base_media_call_content_next_offer: emitting NewCodecOffer: /org/freedesktop/Telepathy/Connection/gabble/jabber/***_2e***_40jabber_2eorg_2f3121af7e/CallChannel9/Content_audio_1/Offer0
  gabble/jid-DEBUG: 20.10.2011 18:07:18.349109: gabble_signal_connect_weak (util.c:966): connecting to 0x15a0180:content-added with context 0x1534a60
  gabble/jid-DEBUG: 20.10.2011 18:07:18.349174: gabble_signal_connect_weak (util.c:966): connecting to 0x15a0180:content-removed with context 0x15718c0
  gabble/media-channel-DEBUG: 20.10.2011 18:07:18.388169: gabble_jingle_session_terminate (jingle-session.c:2106): we are terminating this session
  gabble/media-channel-DEBUG: 20.10.2011 18:07:18.388251: set_state (jingle-session.c:2024): Setting state of JingleSession: 0x12346d0 (priv = 0x1234700) from 0 to 5
  gabble/media-channel-DEBUG: 20.10.2011 18:07:18.388426: session_terminated_cb (jingle-factory.c:901): removing terminated session with key 2
  ***@jabber.org/c4382b92
  1339534884
  gabble/media-channel-DEBUG: 20.10.2011 18:07:18.388489: _content_remove (jingle-content.c:1196): called for 0xb711d0 (audio)
  gabble/media-channel-DEBUG: 20.10.2011 18:07:18.388545: _content_remove (jingle-content.c:1231): signalling removed with 3 refs
  gabble/jid-DEBUG: 20.10.2011 18:07:18.388731: user_data_destroyed_cb (util.c:935): user_data for 0x1522da0 destroyed; disconnecting
  gabble/jid-DEBUG: 20.10.2011 18:07:18.388794: user_data_destroyed_cb (util.c:935): user_data for 0xf01d00 destroyed; disconnecting
  gabble/jid-DEBUG: 20.10.2011 18:07:18.388853: user_data_destroyed_cb (util.c:935): user_data for 0x1553580 destroyed; disconnecting
  gabble/media-channel-DEBUG: 20.10.2011 18:07:18.388927: gabble_jingle_media_rtp_dispose (jingle-media-rtp.c:216): dispose called
  gabble/media-channel-DEBUG: 20.10.2011 18:07:18.388986: gabble_jingle_content_dispose (jingle-content.c:137): 0xb711d0
  gabble/jid-DEBUG: 20.10.2011 18:07:18.389045: instance_destroyed_cb (util.c:922): instance for 0x1551c60 destroyed; cleaning up
  gabble/jid-DEBUG: 20.10.2011 18:07:18.389102: instance_destroyed_cb (util.c:922): instance for 0xee1460 destroyed; cleaning up
  gabble/jid-DEBUG: 20.10.2011 18:07:18.389162: user_data_destroyed_cb (util.c:935): user_data for 0x1551ca0 destroyed; disconnecting
  gabble/jid-DEBUG: 20.10.2011 18:07:18.389219: instance_destroyed_cb (util.c:922): instance for 0x15aaaa0 destroyed; cleaning up
  gabble/jid-DEBUG: 20.10.2011 18:07:18.389273: instance_destroyed_cb (util.c:922): instance for 0xbd58a0 destroyed; cleaning up
  gabble/jid-DEBUG: 20.10.2011 18:07:18.389328: instance_destroyed_cb (util.c:922): instance for 0x1538a00 destroyed; cleaning up
  gabble/jid-DEBUG: 20.10.2011 18:07:18.389383: instance_destroyed_cb (util.c:922): instance for 0x15d2c00 destroyed; cleaning up
  tp-yell/call-DEBUG: 20.10.2011 18:07:18.389442: tpy_base_call_channel_close: Closing media channel /org/freedesktop/Telepathy/Connection/gabble/jabber/***_2e***_40jabber_2eorg_2f3121af7e/CallChannel9
  gabble/media-channel-DEBUG: 20.10.2011 18:07:18.389555: call_channel_closed_cb (media-factory.c:320): removing media channel 0xb97570 with ref count 4
  gabble/media-channel-DEBUG: 20.10.2011 18:07:18.389621: gabble_base_call_channel_dispose (base-call-channel.c:188): hello thar
  gabble/media-channel-DEBUG: 20.10.2011 18:07:18.389678: gabble_jingle_session_dispose (jingle-session.c:215): called
  gabble/jid-DEBUG: 20.10.2011 18:07:18.389738: instance_destroyed_cb (util.c:922): instance for 0xbcdce0 destroyed; cleaning up
  gabble/jid-DEBUG: 20.10.2011 18:07:18.389794: instance_destroyed_cb (util.c:922): instance for 0xbcdc40 destroyed; cleaning up
  gabble/jid-DEBUG: 20.10.2011 18:07:18.389847: instance_destroyed_cb (util.c:922): instance for 0x1549860 destroyed; cleaning up
  gabble/jid-DEBUG: 20.10.2011 18:07:18.389906: instance_destroyed_cb (util.c:922): instance for 0x1549640 destroyed; cleaning up
  gabble/jid-DEBUG: 20.10.2011 18:07:18.389960: instance_destroyed_cb (util.c:922): instance for 0x1534a60 destroyed; cleaning up
  gabble/jid-DEBUG: 20.10.2011 18:07:18.390013: instance_destroyed_cb (util.c:922): instance for 0x15718c0 destroyed; cleaning up
  tp-yell/call-DEBUG: 20.10.2011 18:07:18.390070: tpy_base_call_channel_dispose: hello thar

  This worked on the same machines and between the same accounts before
  updating to oneiric...

  ProblemType: Bug
  DistroRelease: Ubuntu 11.10
  Package: empathy 3.2.0-0ubuntu1
  ProcVersionSignature: Ubuntu 3.0.0-12.20-generic 3.0.4
  Uname: Linux 3.0.0-12-generic x86_64
  ApportVersion: 1.23-0ubuntu3
  Architecture: amd64
  Date: Thu Oct 20 18:02:25 2011
  ExecutablePath: /usr/bin/empathy
  InstallationMedia: Ubuntu 10.04 LTS "Lucid Lynx" - Release amd64 (20100429)
  ProcEnviron:
   PATH=(custom, user)
   LANG=de_DE.UTF-8
   SHELL=/bin/bash
  SourcePackage: empathy
  UpgradeStatus: Upgraded to oneiric on 2011-10-14 (6 days ago)

To manage notifications about this bug go to:
https://bugs.launchpad.net/ubuntu/+source/empathy/+bug/878943/+subscriptions
References

[Bug 878943] [NEW] Empathy fails to start jabber audio/video calls
From: Johannes Albert, 2011-10-20