Bug 40323 - Can't establish audio/video stream
Summary: Can't establish audio/video stream
Status: REOPENED
Alias: None
Product: Telepathy
Classification: Unclassified
Component: gabble (show other bugs)
Version: 0.13
Hardware: x86-64 (AMD64) Linux (All)
: medium normal
Assignee: Telepathy bugs list
QA Contact: Telepathy bugs list
URL:
Whiteboard:
Keywords:
: 40197 43092 (view as bug list)
Depends on:
Blocks:
 
Reported: 2011-08-23 13:12 UTC by Manuel.Bilderbeek
Modified: 2011-11-21 06:01 UTC (History)
3 users (show)

See Also:
i915 platform:
i915 features:


Attachments
Messages in call window (46.93 KB, image/png)
2011-08-23 13:12 UTC, Manuel.Bilderbeek
Details

Note You need to log in before you can comment on or make changes to this bug.
Description Manuel.Bilderbeek 2011-08-23 13:12:05 UTC
Created attachment 50508 [details]
Messages in call window

Hi,

When trying to make a call via Gtalk, I got the messages from the attachment. This is what the Debug log says:

empathy/Voip-DEBUG: 08/23/2011 21:50:47.880511: empathy_tp_call_accept_incoming_call: Accepting incoming call
empathy/Voip-DEBUG: 08/23/2011 21:50:47.883272: enable_camera: Enable camera
empathy/Voip-DEBUG: 08/23/2011 21:50:47.883367: display_video_preview: Show video preview
empathy/Voip-DEBUG: 08/23/2011 21:50:47.883441: empathy_call_window_setup_video_preview: Create video preview
empathy/Voip-DEBUG: 08/23/2011 21:50:47.954111: tp_call_stream_direction_changed_cb: Stream direction changed - stream: 1, direction: 3
empathy/Voip-DEBUG: 08/23/2011 21:50:47.954196: tp_call_stream_direction_changed_cb: Stream direction changed - stream: 2, direction: 3
tp-fs-DEBUG: 08/23/2011 21:50:48.3454: GetSessionHandlers replied: 
tp-fs-DEBUG: 08/23/2011 21:50:48.3474:   - session /org/freedesktop/Telepathy/Connection/gabble/jabber/manuel_2ebilderbeek_40gmail_2ecom_2ff2cd6f74/MediaChannel8
tp-fs-DEBUG: 08/23/2011 21:50:48.3495:     type rtp
tp-fs-DEBUG: 08/23/2011 21:50:48.3515: adding session handler /org/freedesktop/Telepathy/Connection/gabble/jabber/manuel_2ebilderbeek_40gmail_2ecom_2ff2cd6f74/MediaChannel8, type rtp
tp-fs-DEBUG: 08/23/2011 21:50:48.3791: calling MediaSessionHandler::Ready
tp-fs-DEBUG: 08/23/2011 21:50:48.4317: New stream, stream_id=1, media_type=0, direction=3
tp-fs-DEBUG: 08/23/2011 21:50:48.4971: New stream, stream_id=2, media_type=1, direction=3
tp-fs-DEBUG: 08/23/2011 21:50:48.6896: stream 1 0x138e510 (audio) get_all_properties_cb: Adding STUN server 209.85.147.126:19302
tp-fs-DEBUG: 08/23/2011 21:50:48.6930: stream 1 0x138e510 (audio) get_all_properties_cb: Adding relay (udp) 209.85.229.126:19295 cABsIF2VHEfLPaUd:U8CPbVsYqFAIZqpN 1
tp-fs-DEBUG: 08/23/2011 21:50:48.6961: stream 1 0x138e510 (audio) get_all_properties_cb: Adding relay (tcp) 209.85.229.126:19294 cABsIF2VHEfLPaUd:U8CPbVsYqFAIZqpN 1
tp-fs-DEBUG: 08/23/2011 21:50:48.6989: stream 1 0x138e510 (audio) get_all_properties_cb: Adding relay (tls) 209.85.229.126:443 cABsIF2VHEfLPaUd:U8CPbVsYqFAIZqpN 1
tp-fs-DEBUG: 08/23/2011 21:50:48.7019: stream 1 0x138e510 (audio) get_all_properties_cb: Adding relay (udp) 209.85.229.126:19295 z1CtXecD6duD7ALr:b1kBKckEKxPR1r8B 2
tp-fs-DEBUG: 08/23/2011 21:50:48.7047: stream 1 0x138e510 (audio) get_all_properties_cb: Adding relay (tcp) 209.85.229.126:19294 z1CtXecD6duD7ALr:b1kBKckEKxPR1r8B 2
tp-fs-DEBUG: 08/23/2011 21:50:48.7076: stream 1 0x138e510 (audio) get_all_properties_cb: Adding relay (tls) 209.85.229.126:443 z1CtXecD6duD7ALr:b1kBKckEKxPR1r8B 2
tp-fs-DEBUG: 08/23/2011 21:50:48.28023: stream 1 0x138e510 (audio) _tf_stream_try_sending_codecs: called (send_local:1 send_supported:0)
tp-fs-DEBUG: 08/23/2011 21:50:48.28083: stream 1 0x138e510 (audio) _tf_stream_try_sending_codecs: 103: audio SPEEX clock:8000 channels:1
tp-fs-DEBUG: 08/23/2011 21:50:48.28104: stream 1 0x138e510 (audio) _tf_stream_try_sending_codecs: 104: audio SPEEX clock:16000 channels:1
tp-fs-DEBUG: 08/23/2011 21:50:48.28125: stream 1 0x138e510 (audio) _tf_stream_try_sending_codecs: 99: audio AMR clock:8000 channels:1
tp-fs-DEBUG: 08/23/2011 21:50:48.28153: stream 1 0x138e510 (audio) _tf_stream_try_sending_codecs: 96: audio SIREN clock:16000 channels:0 bitrate=16000
tp-fs-DEBUG: 08/23/2011 21:50:48.28179: stream 1 0x138e510 (audio) _tf_stream_try_sending_codecs: 0: audio PCMU clock:8000 channels:0
tp-fs-DEBUG: 08/23/2011 21:50:48.28206: stream 1 0x138e510 (audio) _tf_stream_try_sending_codecs: 8: audio PCMA clock:8000 channels:0
tp-fs-DEBUG: 08/23/2011 21:50:48.28228: stream 1 0x138e510 (audio) _tf_stream_try_sending_codecs: 3: audio GSM clock:8000 channels:0
tp-fs-DEBUG: 08/23/2011 21:50:48.28251: stream 1 0x138e510 (audio) _tf_stream_try_sending_codecs: 100: audio telephone-event clock:16000 channels:0 events=0-15
tp-fs-DEBUG: 08/23/2011 21:50:48.28275: stream 1 0x138e510 (audio) _tf_stream_try_sending_codecs: 101: audio telephone-event clock:8000 channels:0 events=0-15
tp-fs-DEBUG: 08/23/2011 21:50:48.28322: stream 1 0x138e510 (audio) fs_codecs_to_tp: adding codec 103: audio SPEEX clock:8000 channels:1 params:(nil)
tp-fs-DEBUG: 08/23/2011 21:50:48.28357: stream 1 0x138e510 (audio) fs_codecs_to_tp: adding codec 104: audio SPEEX clock:16000 channels:1 params:(nil)
tp-fs-DEBUG: 08/23/2011 21:50:48.28393: stream 1 0x138e510 (audio) fs_codecs_to_tp: adding codec 99: audio AMR clock:8000 channels:1 params:(nil)
tp-fs-DEBUG: 08/23/2011 21:50:48.28433: stream 1 0x138e510 (audio) fs_codecs_to_tp: adding codec 96: audio SIREN clock:16000 channels:0 params:0x1759fa0
tp-fs-DEBUG: 08/23/2011 21:50:48.28469: stream 1 0x138e510 (audio) fs_codecs_to_tp: adding codec 0: audio PCMU clock:8000 channels:0 params:(nil)
tp-fs-DEBUG: 08/23/2011 21:50:48.28503: stream 1 0x138e510 (audio) fs_codecs_to_tp: adding codec 8: audio PCMA clock:8000 channels:0 params:(nil)
tp-fs-DEBUG: 08/23/2011 21:50:48.28538: stream 1 0x138e510 (audio) fs_codecs_to_tp: adding codec 3: audio GSM clock:8000 channels:0 params:(nil)
tp-fs-DEBUG: 08/23/2011 21:50:48.28577: stream 1 0x138e510 (audio) fs_codecs_to_tp: adding codec 100: audio telephone-event clock:16000 channels:0 params:0x2d45040
tp-fs-DEBUG: 08/23/2011 21:50:48.28614: stream 1 0x138e510 (audio) fs_codecs_to_tp: adding codec 101: audio telephone-event clock:8000 channels:0 params:0x2d45180
tp-fs-DEBUG: 08/23/2011 21:50:48.28636: stream 1 0x138e510 (audio) _tf_stream_try_sending_codecs: calling MediaStreamHandler::Ready
tp-fs-DEBUG: 08/23/2011 21:50:48.30409: stream 2 0x138ed60 (video) get_all_properties_cb: Adding STUN server 209.85.147.126:19302
tp-fs-DEBUG: 08/23/2011 21:50:48.30440: stream 2 0x138ed60 (video) get_all_properties_cb: Adding relay (udp) 209.85.147.126:19295 V6qcx3PkR2yrnPQ4:AE5QWa0V3fEpFvGo 1
tp-fs-DEBUG: 08/23/2011 21:50:48.30467: stream 2 0x138ed60 (video) get_all_properties_cb: Adding relay (tcp) 209.85.147.126:19294 V6qcx3PkR2yrnPQ4:AE5QWa0V3fEpFvGo 1
tp-fs-DEBUG: 08/23/2011 21:50:48.30492: stream 2 0x138ed60 (video) get_all_properties_cb: Adding relay (tls) 209.85.147.126:443 V6qcx3PkR2yrnPQ4:AE5QWa0V3fEpFvGo 1
tp-fs-DEBUG: 08/23/2011 21:50:48.30517: stream 2 0x138ed60 (video) get_all_properties_cb: Adding relay (udp) 209.85.229.126:19295 GaGO82VRDrQ2fmMA:ZZbgpauCIKY4tj9p 2
tp-fs-DEBUG: 08/23/2011 21:50:48.30546: stream 2 0x138ed60 (video) get_all_properties_cb: Adding relay (tcp) 209.85.229.126:19294 GaGO82VRDrQ2fmMA:ZZbgpauCIKY4tj9p 2
tp-fs-DEBUG: 08/23/2011 21:50:48.30572: stream 2 0x138ed60 (video) get_all_properties_cb: Adding relay (tls) 209.85.229.126:443 GaGO82VRDrQ2fmMA:ZZbgpauCIKY4tj9p 2
tp-fs-DEBUG: 08/23/2011 21:50:48.44804: stream 2 0x138ed60 (video) _tf_stream_try_sending_codecs: called (send_local:1 send_supported:0)
tp-fs-DEBUG: 08/23/2011 21:50:48.44851: stream 2 0x138ed60 (video) _tf_stream_try_sending_codecs: 97: video H264 clock:90000 channels:0
tp-fs-DEBUG: 08/23/2011 21:50:48.44867: stream 2 0x138ed60 (video) _tf_stream_try_sending_codecs: 34: video H263 clock:90000 channels:0
tp-fs-DEBUG: 08/23/2011 21:50:48.44886: stream 2 0x138ed60 (video) _tf_stream_try_sending_codecs: 96: video THEORA clock:90000 channels:0
tp-fs-DEBUG: 08/23/2011 21:50:48.44907: stream 2 0x138ed60 (video) _tf_stream_try_sending_codecs: 98: video H263-1998 clock:90000 channels:0
tp-fs-DEBUG: 08/23/2011 21:50:48.44929: stream 2 0x138ed60 (video) _tf_stream_try_sending_codecs: 100: video VP8-DRAFT-0-3-2 clock:90000 channels:0
tp-fs-DEBUG: 08/23/2011 21:50:48.44969: stream 2 0x138ed60 (video) fs_codecs_to_tp: adding codec 97: video H264 clock:90000 channels:0 params:(nil)
tp-fs-DEBUG: 08/23/2011 21:50:48.44996: stream 2 0x138ed60 (video) fs_codecs_to_tp: adding codec 34: video H263 clock:90000 channels:0 params:(nil)
tp-fs-DEBUG: 08/23/2011 21:50:48.45023: stream 2 0x138ed60 (video) fs_codecs_to_tp: adding codec 96: video THEORA clock:90000 channels:0 params:(nil)
tp-fs-DEBUG: 08/23/2011 21:50:48.45051: stream 2 0x138ed60 (video) fs_codecs_to_tp: adding codec 98: video H263-1998 clock:90000 channels:0 params:(nil)
tp-fs-DEBUG: 08/23/2011 21:50:48.45078: stream 2 0x138ed60 (video) fs_codecs_to_tp: adding codec 100: video VP8-DRAFT-0-3-2 clock:90000 channels:0 params:(nil)
tp-fs-DEBUG: 08/23/2011 21:50:48.45097: stream 2 0x138ed60 (video) _tf_stream_try_sending_codecs: calling MediaStreamHandler::Ready
tp-fs-DEBUG: 08/23/2011 21:50:48.48207: stream 1 0x138e510 (audio) set_remote_codecs: called
tp-fs-DEBUG: 08/23/2011 21:50:48.48234: stream 1 0x138e510 (audio) set_remote_codecs: adding remote codec ISAC [103]
tp-fs-DEBUG: 08/23/2011 21:50:48.48249: stream 1 0x138e510 (audio) set_remote_codecs: adding remote codec ISAC [104]
tp-fs-DEBUG: 08/23/2011 21:50:48.48270: stream 1 0x138e510 (audio) set_remote_codecs: adding remote codec ISACLC [119]
tp-fs-DEBUG: 08/23/2011 21:50:48.48285: stream 1 0x138e510 (audio) set_remote_codecs: adding remote codec speex [99]
tp-fs-DEBUG: 08/23/2011 21:50:48.48306: stream 1 0x138e510 (audio) set_remote_codecs: adding remote codec IPCMWB [97]
tp-fs-DEBUG: 08/23/2011 21:50:48.48321: stream 1 0x138e510 (audio) set_remote_codecs: adding remote codec G722 [9]
tp-fs-DEBUG: 08/23/2011 21:50:48.48342: stream 1 0x138e510 (audio) set_remote_codecs: adding remote codec iLBC [102]
tp-fs-DEBUG: 08/23/2011 21:50:48.48357: stream 1 0x138e510 (audio) set_remote_codecs: adding remote codec speex [98]
tp-fs-DEBUG: 08/23/2011 21:50:48.48377: stream 1 0x138e510 (audio) set_remote_codecs: adding remote codec GSM [3]
tp-fs-DEBUG: 08/23/2011 21:50:48.48393: stream 1 0x138e510 (audio) set_remote_codecs: adding remote codec EG711U [100]
tp-fs-DEBUG: 08/23/2011 21:50:48.48413: stream 1 0x138e510 (audio) set_remote_codecs: adding remote codec EG711A [101]
tp-fs-DEBUG: 08/23/2011 21:50:48.48429: stream 1 0x138e510 (audio) set_remote_codecs: adding remote codec PCMU [0]
tp-fs-DEBUG: 08/23/2011 21:50:48.48444: stream 1 0x138e510 (audio) set_remote_codecs: adding remote codec PCMA [8]
tp-fs-DEBUG: 08/23/2011 21:50:48.48460: stream 1 0x138e510 (audio) set_remote_codecs: adding remote codec red [117]
tp-fs-DEBUG: 08/23/2011 21:50:48.48474: stream 1 0x138e510 (audio) set_remote_codecs: adding remote codec telephone-event [106]
tp-fs-DEBUG: 08/23/2011 21:50:48.48989: stream 1 0x138e510 (audio) _tf_stream_try_sending_codecs: called (send_local:0 send_supported:1)
tp-fs-DEBUG: 08/23/2011 21:50:48.49012: stream 1 0x138e510 (audio) _tf_stream_try_sending_codecs: 99: audio speex clock:16000 channels:1 bitrate=22000
tp-fs-DEBUG: 08/23/2011 21:50:48.49027: stream 1 0x138e510 (audio) _tf_stream_try_sending_codecs: 98: audio speex clock:8000 channels:1 bitrate=11000
tp-fs-DEBUG: 08/23/2011 21:50:48.49041: stream 1 0x138e510 (audio) _tf_stream_try_sending_codecs: 3: audio GSM clock:8000 channels:0 bitrate=13200
tp-fs-DEBUG: 08/23/2011 21:50:48.49056: stream 1 0x138e510 (audio) _tf_stream_try_sending_codecs: 0: audio PCMU clock:8000 channels:0 bitrate=64000
tp-fs-DEBUG: 08/23/2011 21:50:48.49068: stream 1 0x138e510 (audio) _tf_stream_try_sending_codecs: 8: audio PCMA clock:8000 channels:0 bitrate=64000
tp-fs-DEBUG: 08/23/2011 21:50:48.49082: stream 1 0x138e510 (audio) _tf_stream_try_sending_codecs: 106: audio telephone-event clock:8000 channels:0 events=0-15
tp-fs-DEBUG: 08/23/2011 21:50:48.49113: stream 1 0x138e510 (audio) fs_codecs_to_tp: adding codec 99: audio speex clock:16000 channels:1 params:0x1730760
tp-fs-DEBUG: 08/23/2011 21:50:48.49139: stream 1 0x138e510 (audio) fs_codecs_to_tp: adding codec 98: audio speex clock:8000 channels:1 params:0x17305a0
tp-fs-DEBUG: 08/23/2011 21:50:48.49165: stream 1 0x138e510 (audio) fs_codecs_to_tp: adding codec 3: audio GSM clock:8000 channels:0 params:0x2049b00
tp-fs-DEBUG: 08/23/2011 21:50:48.49190: stream 1 0x138e510 (audio) fs_codecs_to_tp: adding codec 0: audio PCMU clock:8000 channels:0 params:0x7f9314078040
tp-fs-DEBUG: 08/23/2011 21:50:48.49217: stream 1 0x138e510 (audio) fs_codecs_to_tp: adding codec 8: audio PCMA clock:8000 channels:0 params:0x1e2b480
tp-fs-DEBUG: 08/23/2011 21:50:48.49243: stream 1 0x138e510 (audio) fs_codecs_to_tp: adding codec 106: audio telephone-event clock:8000 channels:0 params:0x1e2b160
tp-fs-DEBUG: 08/23/2011 21:50:48.49257: stream 1 0x138e510 (audio) _tf_stream_try_sending_codecs: calling MediaStreamHandler::SupportedCodecs
tp-fs-DEBUG: 08/23/2011 21:50:48.52110: stream 1 0x138e510 (audio) add_remote_candidate: adding remote candidate R1
tp-fs-DEBUG: 08/23/2011 21:50:48.52272: stream 1 0x138e510 (audio) add_remote_candidate: adding remote candidate R2
tp-fs-DEBUG: 08/23/2011 21:50:48.52411: stream 1 0x138e510 (audio) add_remote_candidate: adding remote candidate R3
tp-fs-DEBUG: 08/23/2011 21:50:48.52546: stream 1 0x138e510 (audio) add_remote_candidate: adding remote candidate R4
tp-fs-DEBUG: 08/23/2011 21:50:48.52644: stream 1 0x138e510 (audio) set_stream_playing: 0
tp-fs-DEBUG: 08/23/2011 21:50:48.52743: stream 1 0x138e510 (audio) set_stream_sending: 0
tp-fs-DEBUG: 08/23/2011 21:50:48.53152: stream 2 0x138ed60 (video) set_remote_codecs: called
tp-fs-DEBUG: 08/23/2011 21:50:48.53173: stream 2 0x138ed60 (video) set_remote_codecs: adding remote codec H264-SVC [99]
tp-fs-DEBUG: 08/23/2011 21:50:48.53193: stream 2 0x138ed60 (video) set_remote_codecs: adding remote codec H264-SVC-draft-02 [96]
tp-fs-DEBUG: 08/23/2011 21:50:48.53211: stream 2 0x138ed60 (video) set_remote_codecs: adding remote codec H264 [97]
tp-fs-DEBUG: 08/23/2011 21:50:48.53231: stream 2 0x138ed60 (video) set_remote_codecs: adding remote codec H263 [98]
tp-fs-DEBUG: 08/23/2011 21:50:48.53616: stream 2 0x138ed60 (video) _tf_stream_try_sending_codecs: called (send_local:0 send_supported:1)
tp-fs-DEBUG: 08/23/2011 21:50:48.53647: stream 2 0x138ed60 (video) _tf_stream_try_sending_codecs: 97: video H264 clock:90000 channels:0 width=320 height=200 framerate=30
tp-fs-DEBUG: 08/23/2011 21:50:48.53668: stream 2 0x138ed60 (video) _tf_stream_try_sending_codecs: 98: video H263 clock:90000 channels:0 width=320 height=200 framerate=30
tp-fs-DEBUG: 08/23/2011 21:50:48.53725: stream 2 0x138ed60 (video) fs_codecs_to_tp: adding codec 97: video H264 clock:90000 channels:0 params:0x7f931409fe00
tp-fs-DEBUG: 08/23/2011 21:50:48.53765: stream 2 0x138ed60 (video) fs_codecs_to_tp: adding codec 98: video H263 clock:90000 channels:0 params:0x7f93140818c0
tp-fs-DEBUG: 08/23/2011 21:50:48.53786: stream 2 0x138ed60 (video) _tf_stream_try_sending_codecs: calling MediaStreamHandler::SupportedCodecs
tp-fs-DEBUG: 08/23/2011 21:50:48.54768: stream 2 0x138ed60 (video) add_remote_candidate: adding remote candidate R1
tp-fs-DEBUG: 08/23/2011 21:50:48.54986: stream 2 0x138ed60 (video) add_remote_candidate: adding remote candidate R2
tp-fs-DEBUG: 08/23/2011 21:50:48.55183: stream 2 0x138ed60 (video) add_remote_candidate: adding remote candidate R3
tp-fs-DEBUG: 08/23/2011 21:50:48.55320: stream 2 0x138ed60 (video) add_remote_candidate: adding remote candidate R4
tp-fs-DEBUG: 08/23/2011 21:50:48.55418: stream 2 0x138ed60 (video) set_stream_playing: 0
tp-fs-DEBUG: 08/23/2011 21:50:48.55510: stream 2 0x138ed60 (video) set_stream_sending: 0
tp-fs-DEBUG: 08/23/2011 21:50:48.55687: stream 1 0x138e510 (audio) _tf_stream_bus_message: Codecs changed
tp-fs-DEBUG: 08/23/2011 21:50:48.55702: stream 1 0x138e510 (audio) _tf_stream_try_sending_codecs: called (send_local:0 send_supported:0)
tp-fs-DEBUG: 08/23/2011 21:50:48.55738: stream 1 0x138e510 (audio) _tf_stream_try_sending_codecs: 99: audio speex clock:16000 channels:1 bitrate=22000
tp-fs-DEBUG: 08/23/2011 21:50:48.55757: stream 1 0x138e510 (audio) _tf_stream_try_sending_codecs: 98: audio speex clock:8000 channels:1 bitrate=11000
tp-fs-DEBUG: 08/23/2011 21:50:48.55775: stream 1 0x138e510 (audio) _tf_stream_try_sending_codecs: 3: audio GSM clock:8000 channels:0 bitrate=13200
tp-fs-DEBUG: 08/23/2011 21:50:48.55793: stream 1 0x138e510 (audio) _tf_stream_try_sending_codecs: 0: audio PCMU clock:8000 channels:0 bitrate=64000
tp-fs-DEBUG: 08/23/2011 21:50:48.55810: stream 1 0x138e510 (audio) _tf_stream_try_sending_codecs: 8: audio PCMA clock:8000 channels:0 bitrate=64000
tp-fs-DEBUG: 08/23/2011 21:50:48.55829: stream 1 0x138e510 (audio) _tf_stream_try_sending_codecs: 106: audio telephone-event clock:8000 channels:0 events=0-15
tp-fs-DEBUG: 08/23/2011 21:50:48.56596: stream 1 0x138e510 (audio) _tf_stream_bus_message: Codecs changed
tp-fs-DEBUG: 08/23/2011 21:50:48.56612: stream 1 0x138e510 (audio) _tf_stream_try_sending_codecs: called (send_local:0 send_supported:0)
tp-fs-DEBUG: 08/23/2011 21:50:48.56646: stream 1 0x138e510 (audio) _tf_stream_try_sending_codecs: 99: audio speex clock:16000 channels:1 bitrate=22000
tp-fs-DEBUG: 08/23/2011 21:50:48.56663: stream 1 0x138e510 (audio) _tf_stream_try_sending_codecs: 98: audio speex clock:8000 channels:1 bitrate=11000
tp-fs-DEBUG: 08/23/2011 21:50:48.56682: stream 1 0x138e510 (audio) _tf_stream_try_sending_codecs: 3: audio GSM clock:8000 channels:0 bitrate=13200
tp-fs-DEBUG: 08/23/2011 21:50:48.56699: stream 1 0x138e510 (audio) _tf_stream_try_sending_codecs: 0: audio PCMU clock:8000 channels:0 bitrate=64000
tp-fs-DEBUG: 08/23/2011 21:50:48.56716: stream 1 0x138e510 (audio) _tf_stream_try_sending_codecs: 8: audio PCMA clock:8000 channels:0 bitrate=64000
tp-fs-DEBUG: 08/23/2011 21:50:48.56735: stream 1 0x138e510 (audio) _tf_stream_try_sending_codecs: 106: audio telephone-event clock:8000 channels:0 events=0-15
empathy/Voip-DEBUG: 08/23/2011 21:50:48.57105: tp_call_stream_state_changed_cb: Stream state changed - stream id: 1, state state: 1
tp-fs-DEBUG: 08/23/2011 21:50:48.57542: stream 2 0x138ed60 (video) _tf_stream_bus_message: Codecs changed
tp-fs-DEBUG: 08/23/2011 21:50:48.57557: stream 2 0x138ed60 (video) _tf_stream_try_sending_codecs: called (send_local:0 send_supported:0)
tp-fs-DEBUG: 08/23/2011 21:50:48.57589: stream 2 0x138ed60 (video) _tf_stream_try_sending_codecs: 97: video H264 clock:90000 channels:0 width=320 height=200 framerate=30
tp-fs-DEBUG: 08/23/2011 21:50:48.57609: stream 2 0x138ed60 (video) _tf_stream_try_sending_codecs: 98: video H263 clock:90000 channels:0 width=320 height=200 framerate=30
tp-fs-DEBUG: 08/23/2011 21:50:48.58248: stream 2 0x138ed60 (video) _tf_stream_bus_message: Codecs changed
tp-fs-DEBUG: 08/23/2011 21:50:48.58265: stream 2 0x138ed60 (video) _tf_stream_try_sending_codecs: called (send_local:0 send_supported:0)
tp-fs-DEBUG: 08/23/2011 21:50:48.58300: stream 2 0x138ed60 (video) _tf_stream_try_sending_codecs: 97: video H264 clock:90000 channels:0 width=320 height=200 framerate=30
tp-fs-DEBUG: 08/23/2011 21:50:48.58320: stream 2 0x138ed60 (video) _tf_stream_try_sending_codecs: 98: video H263 clock:90000 channels:0 width=320 height=200 framerate=30
tp-fs-DEBUG: 08/23/2011 21:50:48.58521: stream 1 0x138e510 (audio) _tf_stream_bus_message: Codecs changed
tp-fs-DEBUG: 08/23/2011 21:50:48.58536: stream 1 0x138e510 (audio) _tf_stream_try_sending_codecs: called (send_local:0 send_supported:0)
tp-fs-DEBUG: 08/23/2011 21:50:48.58568: stream 1 0x138e510 (audio) _tf_stream_try_sending_codecs: 99: audio speex clock:16000 channels:1 bitrate=22000
tp-fs-DEBUG: 08/23/2011 21:50:48.58587: stream 1 0x138e510 (audio) _tf_stream_try_sending_codecs: 98: audio speex clock:8000 channels:1 bitrate=11000
tp-fs-DEBUG: 08/23/2011 21:50:48.58604: stream 1 0x138e510 (audio) _tf_stream_try_sending_codecs: 3: audio GSM clock:8000 channels:0 bitrate=13200
tp-fs-DEBUG: 08/23/2011 21:50:48.58623: stream 1 0x138e510 (audio) _tf_stream_try_sending_codecs: 0: audio PCMU clock:8000 channels:0 bitrate=64000
tp-fs-DEBUG: 08/23/2011 21:50:48.58640: stream 1 0x138e510 (audio) _tf_stream_try_sending_codecs: 8: audio PCMA clock:8000 channels:0 bitrate=64000
tp-fs-DEBUG: 08/23/2011 21:50:48.58659: stream 1 0x138e510 (audio) _tf_stream_try_sending_codecs: 106: audio telephone-event clock:8000 channels:0 events=0-15
empathy/Voip-DEBUG: 08/23/2011 21:50:48.66063: tp_call_stream_state_changed_cb: Stream state changed - stream id: 2, state state: 1
tp-fs-DEBUG: 08/23/2011 21:50:48.59019: stream 2 0x138ed60 (video) _tf_stream_bus_message: Codecs changed
tp-fs-DEBUG: 08/23/2011 21:50:48.65897: stream 2 0x138ed60 (video) _tf_stream_try_sending_codecs: called (send_local:0 send_supported:0)
tp-fs-DEBUG: 08/23/2011 21:50:48.66004: stream 2 0x138ed60 (video) _tf_stream_try_sending_codecs: 97: video H264 clock:90000 channels:0 width=320 height=200 framerate=30
tp-fs-DEBUG: 08/23/2011 21:50:48.66032: stream 2 0x138ed60 (video) _tf_stream_try_sending_codecs: 98: video H263 clock:90000 channels:0 width=320 height=200 framerate=30
tp-fs-DEBUG: 08/23/2011 21:50:48.78253: stream 1 0x138e510 (audio) _tf_stream_bus_message: Send codec changed: 99: audio speex clock:16000 channels:1 params:0x13a74c0
empathy/Other-DEBUG: 08/23/2011 21:50:48.173491: main_window_flash_stop: Stop flashing
tp-fs-DEBUG: 08/23/2011 21:50:48.209105: stream 2 0x138ed60 (video) _tf_stream_bus_message: Send codec changed: 97: video H264 clock:90000 channels:0 params:0x182c380
tp-fs-DEBUG: 08/23/2011 21:50:48.240375: stream 1 0x138e510 (audio) cb_fs_new_local_candidate: called
tp-fs-DEBUG: 08/23/2011 21:50:48.240685: stream 1 0x138e510 (audio) cb_fs_new_local_candidate: called
tp-fs-DEBUG: 08/23/2011 21:50:48.240859: stream 1 0x138e510 (audio) cb_fs_new_local_candidate: called
tp-fs-DEBUG: 08/23/2011 21:50:48.241003: stream 1 0x138e510 (audio) cb_fs_new_local_candidate: called
tp-fs-DEBUG: 08/23/2011 21:50:48.241168: stream 1 0x138e510 (audio) cb_fs_new_local_candidate: called
tp-fs-DEBUG: 08/23/2011 21:50:48.241337: stream 1 0x138e510 (audio) cb_fs_new_local_candidate: called
tp-fs-DEBUG: 08/23/2011 21:50:48.242464: stream 1 0x138e510 (audio) cb_fs_new_local_candidate: called
tp-fs-DEBUG: 08/23/2011 21:50:48.242605: stream 1 0x138e510 (audio) cb_fs_new_local_candidate: called
tp-fs-DEBUG: 08/23/2011 21:50:48.242743: stream 1 0x138e510 (audio) cb_fs_new_local_candidate: called
tp-fs-DEBUG: 08/23/2011 21:50:48.242882: stream 1 0x138e510 (audio) cb_fs_new_local_candidate: called
tp-fs-DEBUG: 08/23/2011 21:50:48.243016: stream 1 0x138e510 (audio) cb_fs_local_candidates_prepared: called
tp-fs-DEBUG: 08/23/2011 21:50:48.243047: stream 1 0x138e510 (audio) cb_fs_local_candidates_prepared: ip = '209.85.229.126 port = 19295 component = 2'
tp-fs-DEBUG: 08/23/2011 21:50:48.243807: stream 1 0x138e510 (audio) cb_fs_local_candidates_prepared: ip = '209.85.229.126 port = 19295 component = 1'
tp-fs-DEBUG: 08/23/2011 21:50:48.244329: stream 1 0x138e510 (audio) cb_fs_local_candidates_prepared: ip = '209.85.229.126 port = 19295 component = 2'
tp-fs-DEBUG: 08/23/2011 21:50:48.244870: stream 1 0x138e510 (audio) cb_fs_local_candidates_prepared: ip = '209.85.229.126 port = 19295 component = 1'
tp-fs-DEBUG: 08/23/2011 21:50:48.245398: stream 1 0x138e510 (audio) cb_fs_local_candidates_prepared: ip = '209.85.229.126 port = 19295 component = 2'
tp-fs-DEBUG: 08/23/2011 21:50:48.245903: stream 1 0x138e510 (audio) cb_fs_local_candidates_prepared: ip = '209.85.229.126 port = 19295 component = 1'
tp-fs-DEBUG: 08/23/2011 21:50:48.246304: stream 1 0x138e510 (audio) cb_fs_local_candidates_prepared: ip = '85.151.238.68 port = 38769 component = 2'
tp-fs-DEBUG: 08/23/2011 21:50:48.246331: stream 1 0x138e510 (audio) cb_fs_local_candidates_prepared: ip = '85.151.238.68 port = 37077 component = 1'
tp-fs-DEBUG: 08/23/2011 21:50:48.246913: stream 1 0x138e510 (audio) cb_fs_local_candidates_prepared: ip = '192.168.1.10 port = 38769 component = 2'
tp-fs-DEBUG: 08/23/2011 21:50:48.246942: stream 1 0x138e510 (audio) cb_fs_local_candidates_prepared: ip = '192.168.1.10 port = 37077 component = 1'
tp-fs-DEBUG: 08/23/2011 21:50:48.253261: stream 2 0x138ed60 (video) cb_fs_new_local_candidate: called
tp-fs-DEBUG: 08/23/2011 21:50:48.253432: stream 2 0x138ed60 (video) cb_fs_new_local_candidate: called
tp-fs-DEBUG: 08/23/2011 21:50:48.253590: stream 2 0x138ed60 (video) cb_fs_new_local_candidate: called
tp-fs-DEBUG: 08/23/2011 21:50:48.253765: stream 2 0x138ed60 (video) cb_fs_new_local_candidate: called
tp-fs-DEBUG: 08/23/2011 21:50:48.253907: stream 2 0x138ed60 (video) cb_fs_new_local_candidate: called
tp-fs-DEBUG: 08/23/2011 21:50:48.254054: stream 2 0x138ed60 (video) cb_fs_new_local_candidate: called
tp-fs-DEBUG: 08/23/2011 21:50:48.254200: stream 2 0x138ed60 (video) cb_fs_new_local_candidate: called
tp-fs-DEBUG: 08/23/2011 21:50:48.254347: stream 2 0x138ed60 (video) cb_fs_new_local_candidate: called
tp-fs-DEBUG: 08/23/2011 21:50:48.254492: stream 2 0x138ed60 (video) cb_fs_new_local_candidate: called
tp-fs-DEBUG: 08/23/2011 21:50:48.254637: stream 2 0x138ed60 (video) cb_fs_new_local_candidate: called
tp-fs-DEBUG: 08/23/2011 21:50:48.254775: stream 2 0x138ed60 (video) cb_fs_local_candidates_prepared: called
tp-fs-DEBUG: 08/23/2011 21:50:48.254832: stream 2 0x138ed60 (video) cb_fs_local_candidates_prepared: ip = '209.85.229.126 port = 19295 component = 2'
tp-fs-DEBUG: 08/23/2011 21:50:48.255050: stream 2 0x138ed60 (video) cb_fs_local_candidates_prepared: ip = '209.85.147.126 port = 19295 component = 1'
tp-fs-DEBUG: 08/23/2011 21:50:48.255223: stream 2 0x138ed60 (video) cb_fs_local_candidates_prepared: ip = '209.85.229.126 port = 19295 component = 2'
tp-fs-DEBUG: 08/23/2011 21:50:48.255410: stream 2 0x138ed60 (video) cb_fs_local_candidates_prepared: ip = '209.85.147.126 port = 19295 component = 1'
tp-fs-DEBUG: 08/23/2011 21:50:48.255588: stream 2 0x138ed60 (video) cb_fs_local_candidates_prepared: ip = '209.85.229.126 port = 19295 component = 2'
tp-fs-DEBUG: 08/23/2011 21:50:48.255695: stream 2 0x138ed60 (video) cb_fs_local_candidates_prepared: ip = '85.151.238.68 port = 54291 component = 2'
tp-fs-DEBUG: 08/23/2011 21:50:48.255723: stream 2 0x138ed60 (video) cb_fs_local_candidates_prepared: ip = '85.151.238.68 port = 42623 component = 1'
tp-fs-DEBUG: 08/23/2011 21:50:48.255819: stream 2 0x138ed60 (video) cb_fs_local_candidates_prepared: ip = '209.85.147.126 port = 19295 component = 1'
tp-fs-DEBUG: 08/23/2011 21:50:48.255927: stream 2 0x138ed60 (video) cb_fs_local_candidates_prepared: ip = '192.168.1.10 port = 54291 component = 2'
tp-fs-DEBUG: 08/23/2011 21:50:48.255954: stream 2 0x138ed60 (video) cb_fs_local_candidates_prepared: ip = '192.168.1.10 port = 42623 component = 1'
empathy/Voip-DEBUG: 08/23/2011 21:50:48.257749: tp_call_stream_state_changed_cb: Stream state changed - stream id: 1, state state: 1
empathy/Voip-DEBUG: 08/23/2011 21:50:48.257880: tp_call_stream_state_changed_cb: Stream state changed - stream id: 2, state state: 1
tp-fs-DEBUG: 08/23/2011 21:50:48.779017: stream 1 0x138e510 (audio) cb_fs_new_active_candidate_pair: called: c:2 local: 5 209.85.229.126:19295  remote: 1 76.175.190.17:56644
tp-fs-DEBUG: 08/23/2011 21:50:48.780139: stream 1 0x138e510 (audio) cb_fs_new_active_candidate_pair: called: c:1 local: 4 209.85.229.126:19295  remote: 1 76.175.190.17:56646
empathy/Voip-DEBUG: 08/23/2011 21:50:48.780911: tp_call_stream_state_changed_cb: Stream state changed - stream id: 1, state state: 1
tp-fs-DEBUG: 08/23/2011 21:50:48.900957: stream 1 0x138e510 (audio) cb_fs_new_active_candidate_pair: called: c:2 local: 3 85.151.238.68:38769  remote: 1 76.175.190.17:56644
tp-fs-DEBUG: 08/23/2011 21:50:48.931674: stream 1 0x138e510 (audio) cb_fs_new_active_candidate_pair: called: c:1 local: 3 85.151.238.68:37077  remote: 1 76.175.190.17:56646
tp-fs-DEBUG: 08/23/2011 21:50:49.150024: stream 2 0x138ed60 (video) cb_fs_new_active_candidate_pair: called: c:1 local: 7 209.85.147.126:19295  remote: 1 76.175.190.17:56650
empathy/Voip-DEBUG: 08/23/2011 21:50:49.150521: tp_call_stream_state_changed_cb: Stream state changed - stream id: 2, state state: 1
tp-fs-DEBUG: 08/23/2011 21:50:49.155036: stream 2 0x138ed60 (video) cb_fs_new_active_candidate_pair: called: c:2 local: 8 209.85.229.126:19295  remote: 1 76.175.190.17:56648
tp-fs-DEBUG: 08/23/2011 21:50:49.166554: stream 1 0x138e510 (audio) cb_fs_new_active_candidate_pair: called: c:1 local: 3 85.151.238.68:37077  remote: R4 76.175.190.17:56647
tp-fs-DEBUG: 08/23/2011 21:50:49.207647: stream 2 0x138ed60 (video) cb_fs_new_active_candidate_pair: called: c:2 local: 8 209.85.229.126:19295  remote: R4 76.175.190.17:56649
tp-fs-DEBUG: 08/23/2011 21:50:49.208205: stream 2 0x138ed60 (video) cb_fs_new_active_candidate_pair: called: c:1 local: 7 209.85.147.126:19295  remote: R3 76.175.190.17:56651
tp-fs-DEBUG: 08/23/2011 21:50:49.216422: stream 1 0x138e510 (audio) cb_fs_new_active_candidate_pair: called: c:2 local: 3 85.151.238.68:38769  remote: R3 76.175.190.17:56645
tp-fs-DEBUG: 08/23/2011 21:50:49.217005: stream 2 0x138ed60 (video) cb_fs_new_active_candidate_pair: called: c:1 local: 6 85.151.238.68:42623  remote: R3 76.175.190.17:56651
tp-fs-DEBUG: 08/23/2011 21:50:49.256124: stream 2 0x138ed60 (video) cb_fs_new_active_candidate_pair: called: c:2 local: 6 85.151.238.68:54291  remote: R4 76.175.190.17:56649
tp-fs-DEBUG: 08/23/2011 21:50:49.658866: stream 1 0x138e510 (audio) add_remote_candidate: adding remote candidate R5
tp-fs-DEBUG: 08/23/2011 21:50:49.777667: stream 1 0x138e510 (audio) add_remote_candidate: adding remote candidate R6
tp-fs-DEBUG: 08/23/2011 21:50:49.778266: stream 2 0x138ed60 (video) add_remote_candidate: adding remote candidate R5
tp-fs-DEBUG: 08/23/2011 21:50:49.780143: stream 2 0x138ed60 (video) add_remote_candidate: adding remote candidate R6
tp-fs-DEBUG: 08/23/2011 21:50:50.631710: stream 1 0x138e510 (audio) add_remote_candidate: adding remote candidate R7
tp-fs-DEBUG: 08/23/2011 21:50:50.632096: stream 1 0x138e510 (audio) add_remote_candidate: adding remote candidate R8
tp-fs-MESSAGE: 08/23/2011 21:50:50.632116: tf_stream_error: stream error errorno=6 error=Invalid remote candidates passed
tp-fs-DEBUG: 08/23/2011 21:50:50.632306: stream 1 0x138e510 (audio) add_remote_candidate: adding remote candidate R9
tp-fs-DEBUG: 08/23/2011 21:50:50.632632: stream 1 0x138e510 (audio) add_remote_candidate: adding remote candidate R10
tp-fs-MESSAGE: 08/23/2011 21:50:50.632644: tf_stream_error: stream error errorno=6 error=Invalid remote candidates passed
empathy/Voip-DEBUG: 08/23/2011 21:50:50.633600: tp_call_stream_error_cb: Stream error on stream 1: Invalid remote candidates passed (code: 6)
empathy/Voip-DEBUG: 08/23/2011 21:50:50.636856: tp_call_stream_error_cb: Stream error on stream 1: Invalid remote candidates passed (code: 0)
tp-fs-DEBUG: 08/23/2011 21:50:50.639566: stream 1 0x138e510 (audio) stream_close: close requested by connection manager
empathy/Voip-DEBUG: 08/23/2011 21:50:50.642982: tp_call_stream_removed_cb: Stream removed - stream id: 1
empathy/Voip-DEBUG: 08/23/2011 21:50:50.643199: tp_call_stream_error_cb: Stream error on stream 2: Invalid remote candidates passed (code: 0)
tp-fs-DEBUG: 08/23/2011 21:50:50.645956: stream 2 0x138ed60 (video) stream_close: close requested by connection manager
empathy/Voip-DEBUG: 08/23/2011 21:50:50.735918: tp_call_stream_removed_cb: Stream removed - stream id: 2
empathy/Dispatcher-DEBUG: 08/23/2011 21:50:50.736018: dispatcher_channel_invalidated_cb: Channel /org/freedesktop/Telepathy/Connection/gabble/jabber/manuel_2ebilderbeek_40gmail_2ecom_2ff2cd6f74/MediaChannel8 invalidated
empathy/Voip-DEBUG: 08/23/2011 21:50:50.736052: tp_call_channel_invalidated_cb: Channel invalidated: Invalid remote candidates passed
empathy/Other-DEBUG: 08/23/2011 21:50:50.790323: instance_destroyed_cb: instance for 0x129f080 destroyed; cleaning up
empathy/Voip-DEBUG: 08/23/2011 21:50:50.790841: disable_camera: Disable camera

I hope this helps....

If there's any extra info I should provide, please let me know.
Comment 1 Olivier Crête 2011-11-01 08:58:21 UTC
Upgrade to the newest farsight2 release.. The problem here is that Google sometimes passes candidates with port 0 and we reject them and kill the call.
Comment 2 Will Thompson 2011-11-01 09:08:34 UTC
*** Bug 40197 has been marked as a duplicate of this bug. ***
Comment 3 Manuel.Bilderbeek 2011-11-01 11:27:01 UTC
OK, I tried again (I have the latest farsight2 installed now) and now I get another issue: Could not link source. Logging:

mcd-DEBUG: 11/01/2011 19:23:08.374424: dispatcher_channel_request_acl_start: start /org/freedesktop/Telepathy/Account/gabble/jabber/manuel_2ebilderbeek_40gmail_2ecom1.org.freedesktop.Telepathy.Connection.Interface.Requests.CreateChannel acl (0xd46e40)
mcd-DEBUG: 11/01/2011 19:23:08.374430: dispatcher_channel_request_acl_success: complete acl (0xd46e40)
mcd-DEBUG: 11/01/2011 19:23:08.374464: _mcd_request_init: 0xde0390
mcd-DEBUG: 11/01/2011 19:23:08.374516: _mcd_request_new: 0xde0390 (for 0xd6f030)
mcd-DEBUG: 11/01/2011 19:23:08.374530: _mcd_channel_set_status: 0xdaab60, 1
mcd-DEBUG: 11/01/2011 19:23:08.374569: _mcd_request_predict_handler: Default handler org.freedesktop.Telepathy.Client.Empathy.AudioVideo for request /com/nokia/MissionControl/requests/r3 doesn't want AddRequest
mcd-DEBUG: 11/01/2011 19:23:08.374572: dispatcher_channel_request_acl_cleanup: cleanup acl (0xd46e40)
mcd-DEBUG: 11/01/2011 19:23:08.376121: ready_to_request_cb: Starting online request
mcd-DEBUG: 11/01/2011 19:23:08.376126: _mcd_account_online_request: connection status for gabble/jabber/manuel_2ebilderbeek_40gmail_2ecom1 is 0
mcd-DEBUG: 11/01/2011 19:23:08.376127: _mcd_account_online_request: gabble/jabber/manuel_2ebilderbeek_40gmail_2ecom1 is already connected
mcd-DEBUG: 11/01/2011 19:23:08.376127: online_request_cb: called
mcd-DEBUG: 11/01/2011 19:23:08.376132: _mcd_mission_set_parent: child = 0xdaab60, parent = 0xd690d0
mcd-DEBUG: 11/01/2011 19:23:08.376197: _mcd_channel_set_status: 0xdaab60, 2
mcd-DEBUG: 11/01/2011 19:23:08.464819: common_request_channel_cb: 0xdaab60, object /org/freedesktop/Telepathy/Connection/gabble/jabber/manuel_2ebilderbeek_40gmail_2ecom_2ff2cd6f74/MediaChannel1
mcd-DEBUG: 11/01/2011 19:23:08.465290: _mcd_dispatcher_take_channels: requested channel 0xdaab60 (only): /org/freedesktop/Telepathy/Connection/gabble/jabber/manuel_2ebilderbeek_40gmail_2ecom_2ff2cd6f74/MediaChannel1
mcd-DEBUG: 11/01/2011 19:23:08.465311: _mcd_dispatcher_take_channels: possible handler(s) found, dispatching 1 channels
mcd-DEBUG: 11/01/2011 19:23:08.465312: _mcd_channel_set_status: 0xdaab60, 3
mcd-DEBUG: 11/01/2011 19:23:08.465318: _mcd_dispatcher_enter_state_machine: CTXREF11 on 0xd53d60
mcd-DEBUG: 11/01/2011 19:23:08.465321: _mcd_dispatcher_enter_state_machine: new dispatcher context 0xd53d60 for requested channel 0xdaab60 (only): /org/freedesktop/Telepathy/Connection/gabble/jabber/manuel_2ebilderbeek_40gmail_2ecom_2ff2cd6f74/MediaChannel1
mcd-DEBUG: 11/01/2011 19:23:08.465336: mcd_dispatch_operation_set_property: Extracted preferred handler: org.freedesktop.Telepathy.Client.Empathy.AudioVideo
mcd-DEBUG: 11/01/2011 19:23:08.465342: mcd_dispatch_operation_constructor: do10/0xdc7170: needs_approval=F
mcd-DEBUG: 11/01/2011 19:23:08.465347: _mcd_plugin_dispatch_operation_init: 0xd3f2c0
mcd-DEBUG: 11/01/2011 19:23:08.465349: _mcd_plugin_dispatch_operation_new: 0xd3f2c0 (for 0xdc7170)
mcd-DEBUG: 11/01/2011 19:23:08.465353: _mcd_dispatcher_enter_state_machine: entering state machine for context 0xd53d60
mcd-DEBUG: 11/01/2011 19:23:08.465356: mcd_dispatcher_context_ref: CTXREF01 on 0xd53d60 (ref = 1)
mcd-DEBUG: 11/01/2011 19:23:08.465358: _mcd_dispatch_operation_run_clients: do10 0xdc7170
mcd-DEBUG: 11/01/2011 19:23:08.465359: _mcd_dispatch_operation_handlers_can_bypass_observers: org.freedesktop.Telepathy.Client.Empathy.AudioVideo has BypassObservers=F
mcd-DEBUG: 11/01/2011 19:23:08.465362: _mcd_dispatch_operation_run_clients: Running observers
mcd-DEBUG: 11/01/2011 19:23:08.465414: _mcd_dispatch_operation_inc_observers_pending: 0 -> 1
mcd-DEBUG: 11/01/2011 19:23:08.465415: _mcd_dispatch_operation_run_observers: calling ObserveChannels on org.freedesktop.Telepathy.Client.Logger for CDO 0xdc7170
mcd-DEBUG: 11/01/2011 19:23:08.465637: _mcd_dispatch_operation_inc_observers_pending: 1 -> 2
mcd-DEBUG: 11/01/2011 19:23:08.465640: _mcd_dispatch_operation_run_observers: calling ObserveChannels on org.freedesktop.Telepathy.Client.Empathy.CallObserver for CDO 0xdc7170
mcd-DEBUG: 11/01/2011 19:23:08.465809: _mcd_dispatch_operation_run_clients: All necessary observers invoked
mcd-DEBUG: 11/01/2011 19:23:08.465811: _mcd_dispatch_operation_run_clients: Checking finished/locks
mcd-DEBUG: 11/01/2011 19:23:08.465812: _mcd_dispatch_operation_handlers_can_bypass_approval: org.freedesktop.Telepathy.Client.Empathy.AudioVideo has BypassApproval=F
mcd-DEBUG: 11/01/2011 19:23:08.465815: mcd_dispatcher_context_unref: CTXREF01 on 0xd53d60 (ref = 2)
mcd-DEBUG: 11/01/2011 19:23:08.465816: mcd_dispatcher_context_unref: CTXREF11 on 0xd53d60 (ref = 1)
mcd-DEBUG: 11/01/2011 19:23:08.465817: mcd_dispatcher_context_unref: freeing the context 0xd53d60
mcd-DEBUG: 11/01/2011 19:23:08.465940: on_channel_ready: channel 0xdaab60 is ready
mcd-DEBUG: 11/01/2011 19:23:08.467369: observe_channels_cb: success from /org/freedesktop/Telepathy/Client/Empathy/CallObserver
mcd-DEBUG: 11/01/2011 19:23:08.467370: _mcd_dispatch_operation_dec_observers_pending: 2 -> 1
mcd-DEBUG: 11/01/2011 19:23:08.467374: _mcd_dispatch_operation_handlers_can_bypass_approval: org.freedesktop.Telepathy.Client.Empathy.AudioVideo has BypassApproval=F
mcd-DEBUG: 11/01/2011 19:23:08.467525: observe_channels_cb: success from /org/freedesktop/Telepathy/Client/Logger
mcd-DEBUG: 11/01/2011 19:23:08.467526: _mcd_dispatch_operation_dec_observers_pending: 1 -> 0
mcd-DEBUG: 11/01/2011 19:23:08.467528: _mcd_plugin_dispatch_operation_observers_finished: 0xd3f2c0
mcd-DEBUG: 11/01/2011 19:23:08.467530: _mcd_dispatch_operation_check_client_locks: trying next handler
mcd-DEBUG: 11/01/2011 19:23:08.467531: _mcd_dispatch_operation_try_next_handler: Approved handler is org.freedesktop.Telepathy.Client.Empathy.AudioVideo (still exists: Y, already failed: N)
mcd-DEBUG: 11/01/2011 19:23:08.467535: mcd_dispatch_operation_try_handler: do10: channel ACL verification [1 channels]
mcd-DEBUG: 11/01/2011 19:23:08.467552: _mcd_client_proxy_handle_channels: calling HandleChannels on org.freedesktop.Telepathy.Client.Empathy.AudioVideo
mcd-DEBUG: 11/01/2011 19:23:08.467586: _mcd_channel_set_status: 0xdaab60, 4
mcd-DEBUG: 11/01/2011 19:23:08.507028: dbusprop_get_all: org.freedesktop.Telepathy.AccountManager
mcd-DEBUG: 11/01/2011 19:23:08.507034: get_valid_accounts: called
mcd-DEBUG: 11/01/2011 19:23:08.507045: get_invalid_accounts: called
mcd-DEBUG: 11/01/2011 19:23:08.507047: mcd_dbus_get_interfaces: called
mcd-DEBUG: 11/01/2011 19:23:08.510706: dbusprop_get_all: org.freedesktop.Telepathy.Account
mcd-DEBUG: 11/01/2011 19:23:08.510710: mcd_dbus_get_interfaces: called
mcd-DEBUG: 11/01/2011 19:23:08.510715: mcd_dbus_get_interfaces: skipping inactive optional iface org.freedesktop.Telepathy.Account.Interface.ExternalPasswordStorage.DRAFT
mcd-DEBUG: 11/01/2011 19:23:08.510734: _mcd_account_dup_parameters: called
mcd-DEBUG: 11/01/2011 19:23:08.510786: get_connect_automatically: called for gabble/jabber/ankemanuel_40gmail_2ecom1
mcd-DEBUG: 11/01/2011 19:23:08.511020: dbusprop_get_all: org.freedesktop.Telepathy.Account
mcd-DEBUG: 11/01/2011 19:23:08.511023: mcd_dbus_get_interfaces: called
mcd-DEBUG: 11/01/2011 19:23:08.511027: mcd_dbus_get_interfaces: skipping inactive optional iface org.freedesktop.Telepathy.Account.Interface.ExternalPasswordStorage.DRAFT
mcd-DEBUG: 11/01/2011 19:23:08.511039: _mcd_account_dup_parameters: called
mcd-DEBUG: 11/01/2011 19:23:08.511079: get_connect_automatically: called for gabble/jabber/manuel_2ebilderbeek_40gmail_2ecom1
mcd-DEBUG: 11/01/2011 19:23:08.512384: dbusprop_get_all: org.freedesktop.Telepathy.Account.Interface.Addressing
mcd-DEBUG: 11/01/2011 19:23:08.512537: dbusprop_get_all: org.freedesktop.Telepathy.Account.Interface.Addressing
mcd-DEBUG: 11/01/2011 19:23:08.515059: _mcd_channel_set_status: 0xdaab60, 5
mcd-DEBUG: 11/01/2011 19:23:08.515067: _mcd_request_set_success: Request succeeded
mcd-DEBUG: 11/01/2011 19:23:08.515197: _mcd_dispatch_operation_finish: Result: Channel successfully handled by org.freedesktop.Telepathy.Client.Empathy.AudioVideo
mcd-DEBUG: 11/01/2011 19:23:08.515199: _mcd_dispatch_operation_finish: do10/0xdc7170 has finished
mcd-DEBUG: 11/01/2011 19:23:08.515201: mcd_dispatch_operation_actually_finish: do10/0xdc7170: finished
mcd-DEBUG: 11/01/2011 19:23:08.515206: _mcd_dispatch_operation_check_client_locks: waiting for handler_is_suitable or HandleChannels to return
mcd-DEBUG: 11/01/2011 19:23:08.515208: _mcd_dispatch_operation_check_client_locks: already finished (or finishing): Channel successfully handled by org.freedesktop.Telepathy.Client.Empathy.AudioVideo
mcd-DEBUG: 11/01/2011 19:23:08.515211: plugin_do_finalize: 0xd3f2c0
mcd-DEBUG: 11/01/2011 19:23:08.861757: on_members_changed: called (actor 1, reason 6, self_handle 1, conn_self_handle 1)
mcd-DEBUG: 11/01/2011 19:23:08.861761: on_members_changed: removed member 1
mcd-DEBUG: 11/01/2011 19:23:08.861852: proxy_destroyed: Channel proxy invalidated: tp_errors 3: Could not link source
mcd-DEBUG: 11/01/2011 19:23:08.861856: mcd_channel_abort: 0xdaab60
mcd-DEBUG: 11/01/2011 19:23:08.861859: _mcd_channel_set_status: 0xdaab60, 7
mcd-DEBUG: 11/01/2011 19:23:08.861871: _mcd_mission_set_parent: child = 0xdaab60, parent = (nil)
mcd-DEBUG: 11/01/2011 19:23:08.861877: _mcd_operation_remove_mission: removing mission: 0xdaab60
mcd-DEBUG: 11/01/2011 19:23:08.861880: _mcd_channel_dispose: 0xdaab60 (is disposed = 0)
mcd-DEBUG: 11/01/2011 19:23:08.861884: _mcd_mission_dispose: mission disposed 0xdaab60
mcd-DEBUG: 11/01/2011 19:23:08.861888: _mcd_request_dispose: 0xde0390
mcd-DEBUG: 11/01/2011 19:23:08.861893: _mcd_request_finalize: 0xde0390
mcd-DEBUG: 11/01/2011 19:23:08.861898: _mcd_mission_finalize: mission finalized 0xdaab60
Comment 4 Olivier Crête 2011-11-01 11:47:43 UTC
Do you have the log from empathy-av ? I assume you're using empathy ?
Comment 5 Manuel.Bilderbeek 2011-11-01 13:03:28 UTC
Yes, I've been running empathy and copied the log from empathy. So I'm not sure what you're asking me to do...
Comment 6 Olivier Crête 2011-11-01 13:12:31 UTC
In the empathy debug window, you can select various debug logs.. on of them is empathy-av
Comment 7 Manuel.Bilderbeek 2011-11-01 15:52:42 UTC
You mean Empathy.AudioVideo?

The only thing that appears there is:

The selected connection manager does not support the remote debugging session.

... that doesn't help, I suppose...
Comment 8 Olivier Crête 2011-11-01 16:01:25 UTC
hmm..
Which version of empathy, farsight2, gst-plugins-good, gst-plugins-bad, gstreamer, telepathy-gabble are you using ?

Does cheese work? (ie, is your webcam working? Where you trying to do an audio only call? or an audio and video call ?
Comment 9 Manuel.Bilderbeek 2011-11-02 10:43:57 UTC
The ones from current Debian testing:

ii  empathy                               3.2.0.1-1                          GNOME multi-protocol chat and call client
ii  libgstfarsight0.10-0                  0.0.31-1                           Audio/Video communications framework: core library
ii  gstreamer0.10-plugins-good            0.10.30-1                          GStreamer plugins from the "good" set
ii  gstreamer0.10-plugins-bad             0.10.22-3                          GStreamer plugins from the "bad" set
ii  gstreamer0.10-x                       0.10.35-1                          GStreamer plugins for X11 and Pango
ii  telepathy-gabble                      0.13.7-1                           Jabber/XMPP connection manager

My webcam works fine with e.g. Google Talk plugin.

I was trying to do an audio and video call.

Anything else I can provide? :)
Comment 10 Will Thompson 2011-11-21 06:01:12 UTC
*** Bug 43092 has been marked as a duplicate of this bug. ***


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