Bug 20079

Summary: gabble crashes after call if the other end has crashed/failed
Product: Telepathy Reporter: Olivier Crête <olivier.crete>
Component: gabbleAssignee: Telepathy bugs list <telepathy-bugs>
Status: RESOLVED FIXED QA Contact: Telepathy bugs list <telepathy-bugs>
Severity: normal    
Priority: medium    
Version: unspecified   
Hardware: Other   
OS: All   
Whiteboard:
i915 platform: i915 features:

Description Olivier Crête 2009-02-12 05:28:46 UTC
Using gabble master 5772bdb4997774618d4799483a0788c354cedc01 + ptlo/codecs-updated branch as of Feb 12. 

This is the end of the log + stack trace with GABBLE_DEBUG=all LM_DEBUG=net

To reproduce, make an audio call between this gabble and a Diablo N810, start the video on this side, have the N810 somehow crash. And close the call interface (and I guess the channel too) on this side and see gabble crash.



telepathy-gabble[2436]: GLIB DEBUG default - _gabble_roster_get_channel: Looking up channel 3:3 "known"
telepathy-gabble[2436]: GLIB DEBUG default - _gabble_roster_create_channel: Instantiating channel 3:3 "known"
tp_group_mixin_change_flags: emitting group flags changed
  added    : [CAN_REMOVE|PROPERTIES]
  removed  : []
  flags now: [CAN_REMOVE|PROPERTIES]
telepathy-gabble[2436]: GLIB DEBUG default - _gabble_roster_create_channel: created /org/freedesktop/Telepathy/Connection/gabble/jabber/tester_2ecolltest4_40gmail_2ecom_2fTelepathy/RosterChannel/List/known
telepathy-gabble[2436]: GLIB DEBUG default - _gabble_roster_create_channel: roster not yet received, not emitting signal for known list channel
telepathy-gabble[2436]: GLIB DEBUG default - gabble_roster_iq_cb: calling change members on known channel
emit_members_changed_signals: emitting members changed
  message       : ""
  added         : [2 (tester.colltest5@gmail.com)
                   3 (cassidy@jabber.belnet.be)
                   4 (iceman@jabber.belnet.be)
                   5 (tester.test1@collabora.co.uk)
                   6 (tester@collabora.co.uk)
                   7 (burger.colltest1@gmail.com)
                   8 (burger.colltest2@gmail.com)
                   9 (colltest2@gmail.com)
                   10 (kakaroto.test1@gmail.com)
                   11 (kakaroto.test2@gmail.com)
                   12 (tester.colltest1@gmail.com)
                   13 (tester.colltest3@gmail.com)]
  removed       : []
  local_pending : []
  remote_pending: []
  actor         : 0
  reason        : 0: unspecified reason
telepathy-gabble[2436]: GLIB DEBUG default - gabble_roster_iq_cb: calling change members on any group channels
telepathy-gabble[2436]: GLIB DEBUG default - _gabble_roster_get_channel: Looking up channel 4:1 "Others"
telepathy-gabble[2436]: GLIB DEBUG default - _gabble_roster_create_channel: Instantiating channel 4:1 "Others"
tp_group_mixin_change_flags: emitting group flags changed
  added    : [CAN_ADD|CAN_REMOVE|PROPERTIES]
  removed  : []
  flags now: [CAN_ADD|CAN_REMOVE|PROPERTIES]
telepathy-gabble[2436]: GLIB DEBUG default - _gabble_roster_create_channel: created /org/freedesktop/Telepathy/Connection/gabble/jabber/tester_2ecolltest4_40gmail_2ecom_2fTelepathy/RosterChannel/Group/Others
telepathy-gabble[2436]: GLIB DEBUG default - _gabble_roster_create_channel: roster not yet received, not emitting signal for Others list channel
telepathy-gabble[2436]: GLIB DEBUG default - _update_group: Updating group channel 1 now message has been received
emit_members_changed_signals: emitting members changed
  message       : ""
  added         : [4 (iceman@jabber.belnet.be)
                   9 (colltest2@gmail.com)]
  removed       : []
  local_pending : []
  remote_pending: []
  actor         : 0
  reason        : 0: unspecified reason
telepathy-gabble[2436]: GLIB DEBUG default - _gabble_roster_get_channel: Looking up channel 4:2 "Poly"
telepathy-gabble[2436]: GLIB DEBUG default - _gabble_roster_create_channel: Instantiating channel 4:2 "Poly"
tp_group_mixin_change_flags: emitting group flags changed
  added    : [CAN_ADD|CAN_REMOVE|PROPERTIES]
  removed  : []
  flags now: [CAN_ADD|CAN_REMOVE|PROPERTIES]
telepathy-gabble[2436]: GLIB DEBUG default - _gabble_roster_create_channel: created /org/freedesktop/Telepathy/Connection/gabble/jabber/tester_2ecolltest4_40gmail_2ecom_2fTelepathy/RosterChannel/Group/Poly
telepathy-gabble[2436]: GLIB DEBUG default - _gabble_roster_create_channel: roster not yet received, not emitting signal for Poly list channel
telepathy-gabble[2436]: GLIB DEBUG default - _update_group: Updating group channel 2 now message has been received
emit_members_changed_signals: emitting members changed
  message       : ""
  added         : [10 (kakaroto.test1@gmail.com)]
  removed       : []
  local_pending : []
  remote_pending: []
  actor         : 0
  reason        : 0: unspecified reason
telepathy-gabble[2436]: GLIB DEBUG default - _gabble_roster_get_channel: Looking up channel 3:4 "deny"
telepathy-gabble[2436]: GLIB DEBUG default - _gabble_roster_create_channel: Instantiating channel 3:4 "deny"
tp_group_mixin_change_flags: emitting group flags changed
  added    : [CAN_ADD|CAN_REMOVE|PROPERTIES]
  removed  : []
  flags now: [CAN_ADD|CAN_REMOVE|PROPERTIES]
telepathy-gabble[2436]: GLIB DEBUG default - _gabble_roster_create_channel: created /org/freedesktop/Telepathy/Connection/gabble/jabber/tester_2ecolltest4_40gmail_2ecom_2fTelepathy/RosterChannel/List/deny
telepathy-gabble[2436]: GLIB DEBUG default - _gabble_roster_create_channel: roster not yet received, not emitting signal for deny list channel
telepathy-gabble[2436]: GLIB DEBUG default - gabble_roster_iq_cb: calling change members on deny channel
telepathy-gabble[2436]: GLIB DEBUG tp-glib - change_members: not emitting signal, nothing changed
telepathy-gabble[2436]: GLIB DEBUG default - _gabble_roster_emit_one: roster now received, emitting signal signal for publish list channel
telepathy-gabble[2436]: GLIB DEBUG tp-glib - satisfy_request: completing queued request 0xa8318 with success, channel_type=org.freedesktop.Telepathy.Channel.Type.ContactList, handle_type=3, handle=1, suppress_handler=1
telepathy-gabble[2436]: GLIB DEBUG tp-glib - channel_request_free: Freeing channel request at 0xa8318: ctype=org.freedesktop.Telepathy.Channel.Type.ContactList htype=3 handle=1 suppress=1
telepathy-gabble[2436]: GLIB DEBUG default - _gabble_roster_emit_one: roster now received, emitting signal signal for subscribe list channel
telepathy-gabble[2436]: GLIB DEBUG tp-glib - satisfy_request: completing queued request 0xd4a30 with success, channel_type=org.freedesktop.Telepathy.Channel.Type.ContactList, handle_type=3, handle=2, suppress_handler=1
telepathy-gabble[2436]: GLIB DEBUG tp-glib - channel_request_free: Freeing channel request at 0xd4a30: ctype=org.freedesktop.Telepathy.Channel.Type.ContactList htype=3 handle=2 suppress=1
telepathy-gabble[2436]: GLIB DEBUG default - _gabble_roster_emit_one: roster now received, emitting signal signal for known list channel
telepathy-gabble[2436]: GLIB DEBUG default - _gabble_roster_emit_one: roster now received, emitting signal signal for deny list channel
telepathy-gabble[2436]: GLIB DEBUG default - _gabble_roster_emit_one: roster now received, emitting signal signal for Others list channel
telepathy-gabble[2436]: GLIB DEBUG default - _gabble_roster_emit_one: roster now received, emitting signal signal for Poly list channel
telepathy-gabble[2436]: GLIB DEBUG tp-glib - tp_base_connection_dbus_request_handles: 1 handles of type 3, for :1.25
telepathy-gabble[2436]: GLIB DEBUG default - disco_items_cb: Got error on items request: the feature requested is not implemented by the recipient or server and therefore cannot be processed

RECV [270]:
-----------------------------------
'<iq type="get" to="tester.colltest4@gmail.com/TelepathyD972DB41" id="262216350250" from="tester.colltest5@gmail.com/TelepathyF29023C5"> <query node="http://telepathy.freedesktop.org/caps#vRZ6i9Nj4/q1+QQ99Di3a88ncFY=" xmlns="http://jabber.org/protocol/disco#info"/>
</iq>'
-----------------------------------

RECV [334]:
-----------------------------------
'<iq type="result" to="tester.colltest4@gmail.com/TelepathyD972DB41" id="368911516998" from="tester.colltest5@gmail.com/TelepathyF29023C5"> <query node="http://telepathy.freedesktop.org/caps#jingle-video" xmlns="http://jabber.org/protocol/disco#info"> <feature var="http://jabber.org/protocol/jingle/description/video"/>
</query>
</iq>'
-----------------------------------

RECV [1]:
-----------------------------------
' '
-----------------------------------

RECV [334]:
-----------------------------------
'<iq type="result" to="tester.colltest4@gmail.com/TelepathyD972DB41" id="525593548187" from="tester.colltest5@gmail.com/TelepathyF29023C5"> <query node="http://telepathy.freedesktop.org/caps#jingle-audio" xmlns="http://jabber.org/protocol/disco#info"> <feature var="http://jabber.org/protocol/jingle/description/audio"/>
</query>
</iq>'
-----------------------------------

RECV [804]:
-----------------------------------
'<iq from="cassidy@jabber.belnet.be/Laptop" to="tester.colltest4@gmail.com/TelepathyD972DB41" type="result" id="532756663909"> <query node="http://telepathy.freedesktop.org/caps#9fJSx1YKw9uqv6TVxzgC0uH0BXM=" xmlns="http://jabber.org/protocol/disco#info"> <identity type="pc" name="Telepathy Gabble 0.7.20" category="client"/>
 <feature var="http://www.google.com/xmpp/protocol/session"/>
 <feature var="http://www.google.com/transport/p2p"/>
 <feature var="http://jabber.org/protocol/jingle"/>
 <feature var="urn:xmpp:jingle:0"/>
 <feature var="http://jabber.org/protocol/chatstates"/>
 <feature var="http://jabber.org/protocol/nick"/>
 <feature var="http://jabber.org/protocol/nick+notify"/>
 <feature var="http://jabber.org/protocol/si"/>
 <feature var="http://jabber.org/protocol/ibb"/>
 <feature var="'
-----------------------------------

RECV [366]:
-----------------------------------
'http://telepathy.freedesktop.org/xmpp/tubes"/>
 <feature var="http://jabber.org/protocol/bytestreams"/>
 <feature var="http://www.google.com/xmpp/protocol/voice/v1"/>
 <feature var="http://jabber.org/protocol/jingle/description/audio"/>
 <feature var="http://jabber.org/protocol/jingle/description/video"/>
 <feature var="urn:xmpp:jingle:apps:rtp:0"/>
</query>
</iq>'
-----------------------------------

RECV [334]:
-----------------------------------
'<iq from="iceman@jabber.belnet.be/sLaptop" to="tester.colltest4@gmail.com/TelepathyD972DB41" id="623646775817" type="result"><query node="http://gajim.org/caps#cstates" xmlns="http://jabber.org/protocol/disco#info"><identity category="client" type="pc" name="Gajim"/><feature var="http://jabber.org/protocol/chatstates"/></query></iq>'
-----------------------------------

RECV [601]:
-----------------------------------
'<iq from="iceman@jabber.belnet.be/sLaptop" to="tester.colltest4@gmail.com/TelepathyD972DB41" id="786455792785" type="result"><query node="http://gajim.org/caps#0.11.4" xmlns="http://jabber.org/protocol/disco#info"><identity category="client" type="pc" name="Gajim"/><feature var="http://jabber.org/protocol/bytestreams"/><feature var="http://jabber.org/protocol/si"/><feature var="http://jabber.org/protocol/si/profile/file-transfer"/><feature var="http://jabber.org/protocol/muc"/><feature var="http://jabber.org/protocol/commands"/><feature var="http://jabber.org/protocol/disco#info"/></query></iq>'
-----------------------------------
telepathy-gabble[2436]: GLIB DEBUG tp-glib - channel_request_new: New channel request at 0xa86c8: ctype=org.freedesktop.Telepathy.Channel.Type.ContactList htype=3 handle=3 suppress=1
telepathy-gabble[2436]: GLIB DEBUG default - _gabble_roster_get_channel: Looking up channel 3:3 "known"
telepathy-gabble[2436]: GLIB DEBUG tp-glib - satisfy_request: completing queued request 0xa86c8 with success, channel_type=org.freedesktop.Telepathy.Channel.Type.ContactList, handle_type=3, handle=3, suppress_handler=1
telepathy-gabble[2436]: GLIB DEBUG tp-glib - channel_request_free: Freeing channel request at 0xa86c8: ctype=org.freedesktop.Telepathy.Channel.Type.ContactList htype=3 handle=3 suppress=1
telepathy-gabble[2436]: GLIB DEBUG tp-glib - channel_request_new: New channel request at 0xd4b80: ctype=org.freedesktop.Telepathy.Channel.Type.ContactList htype=3 handle=4 suppress=1
telepathy-gabble[2436]: GLIB DEBUG default - _gabble_roster_get_channel: Looking up channel 3:4 "deny"
telepathy-gabble[2436]: GLIB DEBUG tp-glib - satisfy_request: completing queued request 0xd4b80 with success, channel_type=org.freedesktop.Telepathy.Channel.Type.ContactList, handle_type=3, handle=4, suppress_handler=1
telepathy-gabble[2436]: GLIB DEBUG tp-glib - channel_request_free: Freeing channel request at 0xd4b80: ctype=org.freedesktop.Telepathy.Channel.Type.ContactList htype=3 handle=4 suppress=1
telepathy-gabble[2436]: GLIB DEBUG tp-glib - channel_request_new: New channel request at 0xd4a18: ctype=org.freedesktop.Telepathy.Channel.Type.ContactList htype=3 handle=1 suppress=1
telepathy-gabble[2436]: GLIB DEBUG default - _gabble_roster_get_channel: Looking up channel 3:1 "publish"
telepathy-gabble[2436]: GLIB DEBUG tp-glib - satisfy_request: completing queued request 0xd4a18 with success, channel_type=org.freedesktop.Telepathy.Channel.Type.ContactList, handle_type=3, handle=1, suppress_handler=1
telepathy-gabble[2436]: GLIB DEBUG tp-glib - channel_request_free: Freeing channel request at 0xd4a18: ctype=org.freedesktop.Telepathy.Channel.Type.ContactList htype=3 handle=1 suppress=1
telepathy-gabble[2436]: GLIB DEBUG default - connection_iq_disco_cb: got disco request for node http://telepathy.freedesktop.org/caps#vRZ6i9Nj4/q1+QQ99Di3a88ncFY=, caps are 33ff
telepathy-gabble[2436]: GLIB DEBUG default - connection_iq_disco_cb: caps now 13311

SEND:
-----------------------------------
<iq type="error" to="tester.colltest5@gmail.com/TelepathyF29023C5" id="262216350250"> <query xmlns="http://jabber.org/protocol/disco#info" node="http://telepathy.freedesktop.org/caps#vRZ6i9Nj4/q1+QQ99Di3a88ncFY="></query>
 <error type="cancel" code="404"> <item-not-found xmlns="urn:ietf:params:xml:ns:xmpp-stanzas"></item-not-found>
</error>
</iq>

-----------------------------------
telepathy-gabble[2436]: GLIB DEBUG default - _caps_disco_cb: setting caps for 2 (thanks to 2 tester.colltest5@gmail.com/TelepathyF29023C5) to 16 (save_caps 0)
telepathy-gabble[2436]: GLIB DEBUG default - gabble_presence_set_capabilities: about to add caps 16 to resource TelepathyF29023C5 with serial 1
telepathy-gabble[2436]: GLIB DEBUG default - gabble_presence_set_capabilities: found resource TelepathyF29023C5
telepathy-gabble[2436]: GLIB DEBUG default - gabble_presence_set_capabilities: new serial 1, old 0, clearing caps
telepathy-gabble[2436]: GLIB DEBUG default - gabble_presence_set_capabilities: adding caps 16 to resource TelepathyF29023C5
telepathy-gabble[2436]: GLIB DEBUG default - gabble_presence_set_capabilities: resource TelepathyF29023C5 caps now 16
telepathy-gabble[2436]: GLIB DEBUG default - gabble_presence_set_capabilities: total caps now 16
telepathy-gabble[2436]: GLIB DEBUG default - _caps_disco_cb: caps for 2 (thanks to 2 tester.colltest5@gmail.com/TelepathyF29023C5) now 16
telepathy-gabble[2436]: GLIB DEBUG default - disco_waiter_free: freeing waiter 0xb4160 for handle 2 with serial 1
telepathy-gabble[2436]: GLIB DEBUG default - _caps_disco_cb: setting caps for 2 (thanks to 2 tester.colltest5@gmail.com/TelepathyF29023C5) to 8 (save_caps 16)
telepathy-gabble[2436]: GLIB DEBUG default - gabble_presence_set_capabilities: about to add caps 8 to resource TelepathyF29023C5 with serial 1
telepathy-gabble[2436]: GLIB DEBUG default - gabble_presence_set_capabilities: found resource TelepathyF29023C5
telepathy-gabble[2436]: GLIB DEBUG default - gabble_presence_set_capabilities: adding caps 8 to resource TelepathyF29023C5
telepathy-gabble[2436]: GLIB DEBUG default - gabble_presence_set_capabilities: resource TelepathyF29023C5 caps now 24
telepathy-gabble[2436]: GLIB DEBUG default - gabble_presence_set_capabilities: total caps now 24
telepathy-gabble[2436]: GLIB DEBUG default - _caps_disco_cb: caps for 2 (thanks to 2 tester.colltest5@gmail.com/TelepathyF29023C5) now 24
telepathy-gabble[2436]: GLIB DEBUG default - disco_waiter_free: freeing waiter 0xb4180 for handle 2 with serial 1
telepathy-gabble[2436]: GLIB DEBUG default - _caps_disco_cb: setting caps for 3 (thanks to 3 cassidy@jabber.belnet.be/Laptop) to 13311 (save_caps 0)
telepathy-gabble[2436]: GLIB DEBUG default - gabble_presence_set_capabilities: about to add caps 13311 to resource Laptop with serial 2
telepathy-gabble[2436]: GLIB DEBUG default - gabble_presence_set_capabilities: found resource Laptop
telepathy-gabble[2436]: GLIB DEBUG default - gabble_presence_set_capabilities: new serial 2, old 0, clearing caps
telepathy-gabble[2436]: GLIB DEBUG default - gabble_presence_set_capabilities: adding caps 13311 to resource Laptop
telepathy-gabble[2436]: GLIB DEBUG default - gabble_presence_set_capabilities: resource Laptop caps now 13311
telepathy-gabble[2436]: GLIB DEBUG default - gabble_presence_set_capabilities: total caps now 13311
telepathy-gabble[2436]: GLIB DEBUG default - _caps_disco_cb: caps for 3 (thanks to 3 cassidy@jabber.belnet.be/Laptop) now 13311
telepathy-gabble[2436]: GLIB DEBUG default - disco_waiter_free: freeing waiter 0xcbe80 for handle 3 with serial 2
telepathy-gabble[2436]: GLIB DEBUG default - disco_waiter_list_free: list (nil)
telepathy-gabble[2436]: GLIB DEBUG default - _caps_disco_cb: setting caps for 4 (thanks to 4 iceman@jabber.belnet.be/sLaptop) to 32 (save_caps 0)
telepathy-gabble[2436]: GLIB DEBUG default - gabble_presence_set_capabilities: about to add caps 32 to resource sLaptop with serial 3
telepathy-gabble[2436]: GLIB DEBUG default - gabble_presence_set_capabilities: found resource sLaptop
telepathy-gabble[2436]: GLIB DEBUG default - gabble_presence_set_capabilities: new serial 3, old 0, clearing caps
telepathy-gabble[2436]: GLIB DEBUG default - gabble_presence_set_capabilities: adding caps 32 to resource sLaptop
telepathy-gabble[2436]: GLIB DEBUG default - gabble_presence_set_capabilities: resource sLaptop caps now 32
telepathy-gabble[2436]: GLIB DEBUG default - gabble_presence_set_capabilities: total caps now 32
telepathy-gabble[2436]: GLIB DEBUG default - _caps_disco_cb: caps for 4 (thanks to 4 iceman@jabber.belnet.be/sLaptop) now 32
telepathy-gabble[2436]: GLIB DEBUG default - disco_waiter_free: freeing waiter 0xcbee0 for handle 4 with serial 3
telepathy-gabble[2436]: GLIB DEBUG default - _caps_disco_cb: setting caps for 4 (thanks to 4 iceman@jabber.belnet.be/sLaptop) to 192 (save_caps 32)
telepathy-gabble[2436]: GLIB DEBUG default - gabble_presence_set_capabilities: about to add caps 192 to resource sLaptop with serial 3
telepathy-gabble[2436]: GLIB DEBUG default - gabble_presence_set_capabilities: found resource sLaptop
telepathy-gabble[2436]: GLIB DEBUG default - gabble_presence_set_capabilities: adding caps 192 to resource sLaptop
telepathy-gabble[2436]: GLIB DEBUG default - gabble_presence_set_capabilities: resource sLaptop caps now 224
telepathy-gabble[2436]: GLIB DEBUG default - gabble_presence_set_capabilities: total caps now 224
telepathy-gabble[2436]: GLIB DEBUG default - _caps_disco_cb: caps for 4 (thanks to 4 iceman@jabber.belnet.be/sLaptop) now 224
telepathy-gabble[2436]: GLIB DEBUG default - disco_waiter_free: freeing waiter 0xcbf20 for handle 4 with serial 3
telepathy-gabble[2436]: GLIB DEBUG default - send_next_request: processing request 0xb4120

SEND:
-----------------------------------
<iq type="get" id="828692976654"> <vCard xmlns="vcard-temp"></vCard>
</iq>

-----------------------------------

RECV [323]:
-----------------------------------
'<iq type="result" to="tester.colltest4@gmail.com/TelepathyD972DB41" id="558097562866" from="tester.colltest5@gmail.com/TelepathyF29023C5"> <query node="http://telepathy.freedesktop.org/caps#voice-v1" xmlns="http://jabber.org/protocol/disco#info"> <feature var="http://www.google.com/xmpp/protocol/voice/v1"/>
</query>
</iq>'
-----------------------------------

RECV [825]:
-----------------------------------
'<iq type="result" to="tester.colltest4@gmail.com/TelepathyD972DB41" id="558355574951" from="tester.colltest5@gmail.com/TelepathyF29023C5"> <query node="http://telepathy.freedesktop.org/caps#0.6.2.1" xmlns="http://jabber.org/protocol/disco#info"> <feature var="http://www.google.com/xmpp/protocol/session"/>
 <feature var="http://www.google.com/transport/p2p"/>
 <feature var="http://jabber.org/protocol/jingle"/>
 <feature var="http://jabber.org/protocol/chatstates"/>
 <feature var="http://jabber.org/protocol/nick"/>
 <feature var="http://jabber.org/protocol/nick+notify"/>
 <feature var="http://laptop.org/xmpp/buddy-properties"/>
 <feature var="http://laptop.org/xmpp/buddy-properties+notify"/>
 <feature var="http://laptop.org/xmpp/activities"/>
 <feature var="http://laptop.org/xmpp/activities+notify"/>
 <feature var="'
-----------------------------------

RECV [251]:
-----------------------------------
'http://laptop.org/xmpp/current-activity"/>
 <feature var="http://laptop.org/xmpp/current-activity+notify"/>
 <feature var="http://laptop.org/xmpp/activity-properties"/>
 <feature var="http://laptop.org/xmpp/activity-properties+notify"/>
</query>
</iq>'
-----------------------------------
telepathy-gabble[2436]: GLIB DEBUG default - _caps_disco_cb: setting caps for 2 (thanks to 2 tester.colltest5@gmail.com/TelepathyF29023C5) to 2 (save_caps 24)
telepathy-gabble[2436]: GLIB DEBUG default - gabble_presence_set_capabilities: about to add caps 2 to resource TelepathyF29023C5 with serial 1
telepathy-gabble[2436]: GLIB DEBUG default - gabble_presence_set_capabilities: found resource TelepathyF29023C5
telepathy-gabble[2436]: GLIB DEBUG default - gabble_presence_set_capabilities: adding caps 2 to resource TelepathyF29023C5
telepathy-gabble[2436]: GLIB DEBUG default - gabble_presence_set_capabilities: resource TelepathyF29023C5 caps now 26
telepathy-gabble[2436]: GLIB DEBUG default - gabble_presence_set_capabilities: total caps now 26
telepathy-gabble[2436]: GLIB DEBUG default - _caps_disco_cb: caps for 2 (thanks to 2 tester.colltest5@gmail.com/TelepathyF29023C5) now 26
telepathy-gabble[2436]: GLIB DEBUG default - disco_waiter_free: freeing waiter 0xb41c0 for handle 2 with serial 1
telepathy-gabble[2436]: GLIB DEBUG default - _caps_disco_cb: setting caps for 2 (thanks to 2 tester.colltest5@gmail.com/TelepathyF29023C5) to 2085 (save_caps 26)
telepathy-gabble[2436]: GLIB DEBUG default - gabble_presence_set_capabilities: about to add caps 2085 to resource TelepathyF29023C5 with serial 1
telepathy-gabble[2436]: GLIB DEBUG default - gabble_presence_set_capabilities: found resource TelepathyF29023C5
telepathy-gabble[2436]: GLIB DEBUG default - gabble_presence_set_capabilities: adding caps 2085 to resource TelepathyF29023C5
telepathy-gabble[2436]: GLIB DEBUG default - gabble_presence_set_capabilities: resource TelepathyF29023C5 caps now 2111
telepathy-gabble[2436]: GLIB DEBUG default - gabble_presence_set_capabilities: total caps now 2111
telepathy-gabble[2436]: GLIB DEBUG default - _caps_disco_cb: caps for 2 (thanks to 2 tester.colltest5@gmail.com/TelepathyF29023C5) now 2111
telepathy-gabble[2436]: GLIB DEBUG default - disco_waiter_free: freeing waiter 0xcbe20 for handle 2 with serial 1

RECV [150]:
-----------------------------------
'<iq to="tester.colltest4@gmail.com/TelepathyD972DB41" id="828692976654" type="result"><vCard xmlns="vcard-temp"><FN>Tester Colltest4</FN></vCard></iq>'
-----------------------------------
telepathy-gabble[2436]: GLIB DEBUG default - response_cb: got reply for request 0xb4120
telepathy-gabble[2436]: GLIB DEBUG default - pipeline_reply_cb: called for entry 0xa81c8
telepathy-gabble[2436]: GLIB DEBUG default - pipeline_reply_cb: will patch vcard
telepathy-gabble[2436]: GLIB DEBUG default - gabble_request_pipeline_enqueue: enqueued new request as item 0xc8900
telepathy-gabble[2436]: GLIB DEBUG default - observe_vcard: got vCard alias "Tester Colltest4" for handle 1 from <FN>

SEND:
-----------------------------------
<presence id="271389292480"> <x xmlns="vcard-temp:x:update"> <photo></photo>
</x>
 <c ext="voice-v1" ver="9fJSx1YKw9uqv6TVxzgC0uH0BXM=" node="http://telepathy.freedesktop.org/caps" hash="sha-1" xmlns="http://jabber.org/protocol/caps"></c>
</presence>

-----------------------------------
telepathy-gabble[2436]: GLIB DEBUG default - delete_request: Discarding request 0xb4100
telepathy-gabble[2436]: GLIB DEBUG default - cache_entry_attempt_to_free: Not freeing vCard cache entry 0xa81c8: it has a cached vCard 0xe3f10
telepathy-gabble[2436]: GLIB DEBUG default - delete_item: deleting item 0xb4120
telepathy-gabble[2436]: GLIB DEBUG default - send_next_request: processing request 0xc8900

SEND:
-----------------------------------
<iq type="set" id="262175284759"> <vCard xmlns="vcard-temp"> <FN>Tester Colltest4</FN>
 <NICKNAME>Tester Colltest4</NICKNAME>
 <PHOTO></PHOTO>
</vCard>
</iq>

-----------------------------------

RECV [87]:
-----------------------------------
'<iq to="tester.colltest4@gmail.com/TelepathyD972DB41" id="262175284759" type="result"/>'
-----------------------------------
telepathy-gabble[2436]: GLIB DEBUG default - response_cb: got reply for request 0xc8900
telepathy-gabble[2436]: GLIB DEBUG default - replace_reply_cb: called: no error
telepathy-gabble[2436]: GLIB DEBUG default - observe_vcard: no change to vCard alias "Tester Colltest4" for handle 1

SEND:
-----------------------------------
<presence id="590110727508"> <x xmlns="vcard-temp:x:update"></x>
 <c ext="voice-v1" ver="9fJSx1YKw9uqv6TVxzgC0uH0BXM=" node="http://telepathy.freedesktop.org/caps" hash="sha-1" xmlns="http://jabber.org/protocol/caps"></c>
</presence>

-----------------------------------
telepathy-gabble[2436]: GLIB DEBUG default - gabble_vcard_manager_remove_edit_request: request == 0xa8438
telepathy-gabble[2436]: GLIB DEBUG default - gabble_vcard_manager_remove_edit_request: request == 0xa8668
telepathy-gabble[2436]: GLIB DEBUG default - delete_item: deleting item 0xc8900

RECV [1]:
-----------------------------------
' '
-----------------------------------

RECV [830]:
-----------------------------------
'<iq type="set" to="tester.colltest4@gmail.com/TelepathyD972DB41" id="262313857269" from="tester.colltest5@gmail.com/TelepathyF29023C5"> <jingle initiator="tester.colltest5@gmail.com/TelepathyF29023C5" action="session-initiate" sid="1935368496" xmlns="http://jabber.org/protocol/jingle"> <content creator="initiator" name="audio1"> <description xmlns="http://jabber.org/protocol/jingle/description/audio"> <payload-type rate="8000" name="iLBC" id="96"/>
 <payload-type rate="8000" name="G729" id="18"/>
 <payload-type rate="8000" name="PCMA" id="8"/>
 <payload-type rate="8000" name="PCMU" id="0"/>
 <payload-type channels="1" rate="8000" name="CN" id="13"/>
 <payload-type channels="1" rate="8000" name="telephone-event" id="97"/>
</description>
 <transport xmlns="http://www.google.com/transport/p2p"/>
</content>
</jingle>
</iq>'
-----------------------------------

RECV [1]:
-----------------------------------
' '
-----------------------------------

RECV [615]:
-----------------------------------
'<iq type="set" to="tester.colltest4@gmail.com/TelepathyD972DB41" id="855448980" from="tester.colltest5@gmail.com/TelepathyF29023C5"> <jingle initiator="tester.colltest5@gmail.com/TelepathyF29023C5" action="transport-info" sid="1935368496" xmlns="http://jabber.org/protocol/jingle"> <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="S/9j/uIy83uF9Odd" username="ccvvzLJwHNP+ByeO" port="51067" address="172.22.64.127" name="rtp"/>
</transport>
</content>
</jingle>
</iq>'
-----------------------------------

RECV [616]:
-----------------------------------
'<iq type="set" to="tester.colltest4@gmail.com/TelepathyD972DB41" id="8488146697" from="tester.colltest5@gmail.com/TelepathyF29023C5"> <jingle initiator="tester.colltest5@gmail.com/TelepathyF29023C5" action="transport-info" sid="1935368496" xmlns="http://jabber.org/protocol/jingle"> <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="n3ywbaJkR/CEQltt" username="Jt5bQTUh+Nb0Q0Nk" port="51068" address="78.105.107.120" name="rtp"/>
</transport>
</content>
</jingle>
</iq>'
-----------------------------------
telepathy-gabble[2436]: GLIB DEBUG default - create_session: new session 1935368496 @ 0xe7408 created
telepathy-gabble[2436]: GLIB DEBUG default - gabble_jingle_session_parse: jingle action 'session-initiate' from 'tester.colltest5@gmail.com/TelepathyF29023C5' in session '1935368496' dialect 3 state 0
telepathy-gabble[2436]: GLIB DEBUG default - _each_content_add: namespace: http://jabber.org/protocol/jingle/description/audio
telepathy-gabble[2436]: GLIB DEBUG default - create_content: session creating new content type, conn == 0xae0a8, jf == 0xb1c58
telepathy-gabble[2436]: GLIB DEBUG default - parse_description: node: description
telepathy-gabble[2436]: GLIB DEBUG default - parse_description: detected media type 1
telepathy-gabble[2436]: GLIB DEBUG default - parse_description: new remote codec: id = 96, name = iLBC, clockrate = 8000, channels = 1
telepathy-gabble[2436]: GLIB DEBUG default - parse_description: new remote codec: id = 18, name = G729, clockrate = 8000, channels = 1
telepathy-gabble[2436]: GLIB DEBUG default - parse_description: new remote codec: id = 8, name = PCMA, clockrate = 8000, channels = 1
telepathy-gabble[2436]: GLIB DEBUG default - parse_description: new remote codec: id = 0, name = PCMU, clockrate = 8000, channels = 1
telepathy-gabble[2436]: GLIB DEBUG default - parse_description: new remote codec: id = 13, name = CN, clockrate = 8000, channels = 1
telepathy-gabble[2436]: GLIB DEBUG default - parse_description: new remote codec: id = 97, name = telephone-event, clockrate = 8000, channels = 1
telepathy-gabble[2436]: GLIB DEBUG default - parse_description: emitting remote-codecs signal
telepathy-gabble[2436]: GLIB DEBUG default - gabble_jingle_content_parse_add: content creating new transport type GabbleJingleTransportGoogle
telepathy-gabble[2436]: GLIB DEBUG default - parse_candidates: emitting 0 new remote candidates
telepathy-gabble[2436]: GLIB DEBUG default - set_state: Setting state of JingleSession: 0xe7408 (priv = 0xe7420) from 0 to 2
tp_properties_mixin_emit_changed: emitting properties changed for property:
  nat-traversal
tp_properties_mixin_emit_flags: emitting properties flags changed for property:
  nat-traversal's flags now: [READ]
emit_members_changed_signals: emitting members changed
  message       : ""
  added         : [2 (tester.colltest5@gmail.com)]
  removed       : []
  local_pending : []
  remote_pending: []
  actor         : 0
  reason        : 0: unspecified reason
tp_group_mixin_change_flags: emitting group flags changed
  added    : [CAN_ADD|PROPERTIES]
  removed  : []
  flags now: [CAN_ADD|PROPERTIES]
tp_properties_mixin_emit_changed: emitting properties changed for property:
  stun-server
tp_properties_mixin_emit_flags: emitting properties flags changed for property:
  stun-server's flags now: [READ]
tp_properties_mixin_emit_changed: emitting properties changed for property:
  stun-port
tp_properties_mixin_emit_flags: emitting properties flags changed for property:
  stun-port's flags now: [READ]
tp_properties_mixin_emit_changed: emitting properties changed for property:
  gtalk-p2p-relay-token
tp_properties_mixin_emit_flags: emitting properties flags changed for property:
  gtalk-p2p-relay-token's flags now: [READ]
emit_members_changed_signals: emitting members changed
  message       : ""
  added         : []
  removed       : []
  local_pending : [1 (tester.colltest4@gmail.com)]
  remote_pending: []
  actor         : 2
  reason        : 0: unspecified reason
tp_group_mixin_change_flags: emitting group flags changed
  added    : [CAN_REMOVE]
  removed  : []
  flags now: [CAN_ADD|CAN_REMOVE|PROPERTIES]
telepathy-gabble[2436]: GLIB DEBUG default - _latch_to_session: 0xe7c98: Latching onto session 0xe7408
telepathy-gabble[2436]: GLIB DEBUG default - new_media_channel: object path /org/freedesktop/Telepathy/Connection/gabble/jabber/tester_2ecolltest4_40gmail_2ecom_2fTelepathy/MediaChannel0

SEND:
-----------------------------------
<iq type="result" to="tester.colltest5@gmail.com/TelepathyF29023C5" id="262313857269"></iq>

-----------------------------------
telepathy-gabble[2436]: GLIB DEBUG default - gabble_jingle_session_parse: jingle action 'transport-info' from 'tester.colltest5@gmail.com/TelepathyF29023C5' in session '1935368496' dialect 3 state 2
telepathy-gabble[2436]: GLIB DEBUG default - parse_candidates: emitting 1 new remote candidates

SEND:
-----------------------------------
<iq type="result" to="tester.colltest5@gmail.com/TelepathyF29023C5" id="855448980"></iq>

-----------------------------------
telepathy-gabble[2436]: GLIB DEBUG default - gabble_jingle_session_parse: jingle action 'transport-info' from 'tester.colltest5@gmail.com/TelepathyF29023C5' in session '1935368496' dialect 3 state 2
telepathy-gabble[2436]: GLIB DEBUG default - parse_candidates: emitting 1 new remote candidates

SEND:
-----------------------------------
<iq type="result" to="tester.colltest5@gmail.com/TelepathyF29023C5" id="8488146697"></iq>

-----------------------------------
telepathy-gabble[2436]: GLIB DEBUG default - gabble_media_stream_set_property: 0xf3800: connecting to content 0xe7c30 signals
telepathy-gabble[2436]: GLIB DEBUG default - gabble_media_stream_set_property: stream audio1 connection state 0
telepathy-gabble[2436]: GLIB DEBUG default - update_direction: called
telepathy-gabble[2436]: GLIB DEBUG default - update_direction: setting pending local send flag
telepathy-gabble[2436]: GLIB DEBUG default - create_stream_from_content: 0xe7c98: created new MediaStream 0xf3800 for content 'audio1'
telepathy-gabble[2436]: GLIB DEBUG default - create_stream_from_content: emitting StreamAdded with type 'audio'
telepathy-gabble[2436]: GLIB DEBUG default - stream_hold_state_changed: Stream at index 0 has local-hold=0
telepathy-gabble[2436]: GLIB DEBUG default - stream_hold_state_changed: all_held=0, any_held=0
telepathy-gabble[2436]: GLIB DEBUG default - new_remote_codecs_cb: called
telepathy-gabble[2436]: GLIB DEBUG default - new_remote_codecs_cb: new remote audio codec: 96 'iLBC' 0 8000 1
telepathy-gabble[2436]: GLIB DEBUG default - new_remote_codecs_cb: new remote audio codec: 18 'G729' 0 8000 1
telepathy-gabble[2436]: GLIB DEBUG default - new_remote_codecs_cb: new remote audio codec: 8 'PCMA' 0 8000 1
telepathy-gabble[2436]: GLIB DEBUG default - new_remote_codecs_cb: new remote audio codec: 0 'PCMU' 0 8000 1
telepathy-gabble[2436]: GLIB DEBUG default - new_remote_codecs_cb: new remote audio codec: 13 'CN' 0 8000 1
telepathy-gabble[2436]: GLIB DEBUG default - new_remote_codecs_cb: new remote audio codec: 97 'telephone-event' 0 8000 1
telepathy-gabble[2436]: GLIB DEBUG default - new_remote_codecs_cb: pushing remote codecs
telepathy-gabble[2436]: GLIB DEBUG default - new_remote_candidates_cb: got new remote candidates
telepathy-gabble[2436]: GLIB DEBUG tp-glib - tp_presence_mixin_get_contacts_dbus_property: called.
telepathy-gabble[2436]: GLIB DEBUG tp-glib - tp_presence_mixin_get_contacts_dbus_property: called.
telepathy-gabble[2436]: GLIB DEBUG default - _emit_new_stream: emitting MediaSessionHandler:NewStreamHandler signal for audio stream 1 
telepathy-gabble[2436]: GLIB DEBUG default - gabble_media_stream_ready: ready called
telepathy-gabble[2436]: GLIB DEBUG default - push_remote_codecs: passing 6 remote codecs to stream-engine
telepathy-gabble[2436]: GLIB DEBUG default - push_remote_candidates: passing 1 remote candidate to stream engine: R1
telepathy-gabble[2436]: GLIB DEBUG default - push_remote_candidates: passing 1 remote candidate to stream engine: R2
telepathy-gabble[2436]: GLIB DEBUG default - push_playing: stream audio1 emitting SetStreamPlaying(false)
telepathy-gabble[2436]: GLIB DEBUG default - push_sending: stream audio1 emitting SetStreamSending(false)
telepathy-gabble[2436]: GLIB DEBUG default - pass_local_codecs: ignoring local codecs, waiting for codec intersection
telepathy-gabble[2436]: GLIB DEBUG default - pass_local_codecs: putting list of 3 supported codecs from stream-engine into cache
telepathy-gabble[2436]: GLIB DEBUG default - pass_local_codecs: adding codec PCMA (8 8000 1)
telepathy-gabble[2436]: GLIB DEBUG default - pass_local_codecs: adding codec PCMU (0 8000 1)
telepathy-gabble[2436]: GLIB DEBUG default - pass_local_codecs: adding codec telephone-event (97 8000 1)
telepathy-gabble[2436]: GLIB DEBUG default - jingle_media_rtp_set_local_codecs: setting new local codecs
emit_members_changed_signals: emitting members changed
  message       : ""
  added         : [1 (tester.colltest4@gmail.com)]
  removed       : []
  local_pending : []
  remote_pending: []
  actor         : 0
  reason        : 0: unspecified reason
tp_group_mixin_change_flags: emitting group flags changed
  added    : []
  removed  : [CAN_ADD]
  flags now: [CAN_REMOVE|PROPERTIES]
telepathy-gabble[2436]: GLIB DEBUG default - gabble_media_stream_new_native_candidate: google p2p connections only support the concept of one transport per candidate, ignoring other components
telepathy-gabble[2436]: GLIB DEBUG default - gabble_media_stream_new_native_candidate: put 1 native candidate from stream-engine into cache
telepathy-gabble[2436]: GLIB DEBUG default - add_candidates: content already signalled, transmitting candidates

SEND:
-----------------------------------
<iq type="set" to="tester.colltest5@gmail.com/TelepathyF29023C5" id="533794540008"> <jingle action="transport-info" sid="1935368496" initiator="tester.colltest5@gmail.com/TelepathyF29023C5" xmlns="http://jabber.org/protocol/jingle"> <content name="audio1" xmlns="http://jabber.org/protocol/jingle/description/audio"> <transport xmlns="http://www.google.com/transport/p2p"> <candidate generation="0" network="0" name="rtp" component="1" type="local" protocol="udp" preference="0.015259" password="" username="rCTHgylKDTFctzDq" port="50884" address="172.22.64.106"></candidate>
</transport>
</content>
</jingle>
</iq>

-----------------------------------

RECV [139]:
-----------------------------------
'<iq type="result" to="tester.colltest4@gmail.com/TelepathyD972DB41" id="533794540008" from="tester.colltest5@gmail.com/TelepathyF29023C5"/>'
-----------------------------------
telepathy-gabble[2436]: GLIB DEBUG default - connection_iq_unknown_cb: got unknown iq:
<iq from="tester.colltest5@gmail.com/TelepathyF29023C5" id="533794540008" to="tester.colltest4@gmail.com/TelepathyD972DB41" type="result"></iq>
telepathy-gabble[2436]: GLIB DEBUG default - gabble_media_stream_set_property: stream audio1 connection state 0
telepathy-gabble[2436]: GLIB DEBUG default - content_ready_cb: called
telepathy-gabble[2436]: GLIB DEBUG default - content_state_changed_cb: called
telepathy-gabble[2436]: GLIB DEBUG default - push_sending: stream audio1 emitting SetStreamSending(true)
telepathy-gabble[2436]: GLIB DEBUG default - push_playing: stream audio1 emitting SetStreamPlaying(true)
telepathy-gabble[2436]: GLIB DEBUG default - push_sending: stream audio1 emitting SetStreamSending(true)

SEND:
-----------------------------------
<iq type="set" to="tester.colltest5@gmail.com/TelepathyF29023C5" id="3382750689"> <jingle action="session-accept" sid="1935368496" initiator="tester.colltest5@gmail.com/TelepathyF29023C5" xmlns="http://jabber.org/protocol/jingle"> <content senders="both" name="audio1" creator="initiator"> <description xmlns="http://jabber.org/protocol/jingle/description/audio"> <payload-type channels="1" rate="8000" name="PCMA" id="8"></payload-type>
 <payload-type channels="1" rate="8000" name="PCMU" id="0"></payload-type>
 <payload-type channels="1" rate="8000" name="telephone-event" id="97"> <parameter value="0-15" name="events"></parameter>
</payload-type>
</description>
 <transport xmlns="http://www.google.com/transport/p2p"></transport>
</content>
</jingle>
</iq>

-----------------------------------
telepathy-gabble[2436]: GLIB DEBUG default - set_state: Setting state of JingleSession: 0xe7408 (priv = 0xe7420) from 2 to 3
telepathy-gabble[2436]: GLIB DEBUG default - session_state_changed_cb: called

SEND:
-----------------------------------
<iq type="set" to="tester.colltest5@gmail.com/TelepathyF29023C5" id="33076170806"> <jingle action="transport-info" sid="1935368496" initiator="tester.colltest5@gmail.com/TelepathyF29023C5" xmlns="http://jabber.org/protocol/jingle"> <content name="audio1" xmlns="http://jabber.org/protocol/jingle/description/audio"> <transport xmlns="http://www.google.com/transport/p2p"> <candidate generation="0" network="0" name="rtp" component="1" type="local" protocol="udp" preference="0.015259" password="" username="rCTHgylKDTFctzDq" port="50884" address="172.22.64.106"></candidate>
</transport>
</content>
</jingle>
</iq>

-----------------------------------

RECV [137]:
-----------------------------------
'<iq type="result" to="tester.colltest4@gmail.com/TelepathyD972DB41" id="3382750689" from="tester.colltest5@gmail.com/TelepathyF29023C5"/>'
-----------------------------------

RECV [138]:
-----------------------------------
'<iq type="result" to="tester.colltest4@gmail.com/TelepathyD972DB41" id="33076170806" from="tester.colltest5@gmail.com/TelepathyF29023C5"/>'
-----------------------------------
telepathy-gabble[2436]: GLIB DEBUG default - set_state: Setting state of JingleSession: 0xe7408 (priv = 0xe7420) from 3 to 4
telepathy-gabble[2436]: GLIB DEBUG default - session_state_changed_cb: called
telepathy-gabble[2436]: GLIB DEBUG default - connection_iq_unknown_cb: got unknown iq:
<iq from="tester.colltest5@gmail.com/TelepathyF29023C5" id="33076170806" to="tester.colltest4@gmail.com/TelepathyD972DB41" type="result"></iq>
telepathy-gabble[2436]: GLIB DEBUG tp-glib - tp_base_connection_release_handles: 1 handles of type 1, for :1.38
telepathy-gabble[2436]: GLIB DEBUG tp-glib - tp_base_connection_release_handles: 1 handles of type 1, for :1.38
telepathy-gabble[2436]: GLIB DEBUG tp-glib - tp_base_connection_release_handles: 1 handles of type 1, for :1.38
telepathy-gabble[2436]: GLIB DEBUG tp-glib - tp_base_connection_release_handles: 1 handles of type 1, for :1.38
telepathy-gabble[2436]: GLIB DEBUG tp-glib - tp_base_connection_release_handles: 1 handles of type 1, for :1.38
telepathy-gabble[2436]: GLIB DEBUG tp-glib - tp_base_connection_release_handles: 1 handles of type 1, for :1.38
telepathy-gabble[2436]: GLIB DEBUG tp-glib - tp_base_connection_release_handles: 1 handles of type 1, for :1.38
telepathy-gabble[2436]: GLIB DEBUG tp-glib - tp_base_connection_release_handles: 1 handles of type 1, for :1.38
telepathy-gabble[2436]: GLIB DEBUG tp-glib - tp_base_connection_release_handles: 1 handles of type 1, for :1.38
telepathy-gabble[2436]: GLIB DEBUG tp-glib - tp_base_connection_release_handles: 1 handles of type 1, for :1.38
telepathy-gabble[2436]: GLIB DEBUG tp-glib - tp_base_connection_release_handles: 1 handles of type 1, for :1.38
telepathy-gabble[2436]: GLIB DEBUG tp-glib - tp_base_connection_release_handles: 1 handles of type 1, for :1.38


telepathy-gabble[2436]: GLIB DEBUG default - _gabble_media_channel_request_streams: called
telepathy-gabble[2436]: GLIB DEBUG default - _gabble_media_channel_request_streams: Creating new jingle content with ns http://jabber.org/protocol/jingle/description/video : http://www.google.com/transport/p2p
telepathy-gabble[2436]: GLIB DEBUG default - create_content: session creating new content type, conn == 0xae0a8, jf == 0xb1c58
telepathy-gabble[2436]: GLIB DEBUG default - session_new_content_cb: called
telepathy-gabble[2436]: GLIB DEBUG default - gabble_media_stream_set_property: 0xf38b8: connecting to content 0xe7d00 signals
telepathy-gabble[2436]: GLIB DEBUG default - gabble_media_stream_set_property: stream stream2 connection state 0
telepathy-gabble[2436]: GLIB DEBUG default - update_direction: called
telepathy-gabble[2436]: GLIB DEBUG default - update_direction: setting pending local send flag
telepathy-gabble[2436]: GLIB DEBUG default - create_stream_from_content: 0xe7c98: created new MediaStream 0xf38b8 for content 'stream2'
telepathy-gabble[2436]: GLIB DEBUG default - create_stream_from_content: emitting StreamAdded with type 'video'
telepathy-gabble[2436]: GLIB DEBUG default - stream_hold_state_changed: Stream at index 0 has local-hold=0
telepathy-gabble[2436]: GLIB DEBUG default - stream_hold_state_changed: Stream at index 1 has local-hold=0
telepathy-gabble[2436]: GLIB DEBUG default - stream_hold_state_changed: all_held=0, any_held=0
telepathy-gabble[2436]: GLIB DEBUG default - create_stream_from_content: emitting MediaSessionHandler:NewStreamHandler signal for stream 2
telepathy-gabble[2436]: GLIB DEBUG default - new_remote_codecs_cb: called
telepathy-gabble[2436]: GLIB DEBUG default - new_remote_codecs_cb: pushing remote codecs
telepathy-gabble[2436]: GLIB DEBUG default - new_remote_candidates_cb: got new remote candidates
telepathy-gabble[2436]: GLIB DEBUG default - gabble_media_stream_ready: ready called
telepathy-gabble[2436]: GLIB DEBUG default - push_playing: stream stream2 emitting SetStreamPlaying(false)
telepathy-gabble[2436]: GLIB DEBUG default - push_sending: stream stream2 emitting SetStreamSending(false)
telepathy-gabble[2436]: GLIB DEBUG default - pass_local_codecs: putting list of 5 supported codecs from stream-engine into cache
telepathy-gabble[2436]: GLIB DEBUG default - pass_local_codecs: adding codec H263 (34 90000 0)
telepathy-gabble[2436]: GLIB DEBUG default - pass_local_codecs: adding codec H264 (96 90000 0)
telepathy-gabble[2436]: GLIB DEBUG default - pass_local_codecs: adding codec H263-1998 (97 90000 0)
telepathy-gabble[2436]: GLIB DEBUG default - pass_local_codecs: adding codec H263-N800 (98 90000 0)
telepathy-gabble[2436]: GLIB DEBUG default - pass_local_codecs: adding codec H263-2000 (99 90000 0)
telepathy-gabble[2436]: GLIB DEBUG default - jingle_media_rtp_set_local_codecs: setting new local codecs

SEND:
-----------------------------------
<iq type="set" to="tester.colltest5@gmail.com/TelepathyF29023C5" id="884906903839"> <jingle action="content-add" sid="1935368496" initiator="tester.colltest5@gmail.com/TelepathyF29023C5" xmlns="http://jabber.org/protocol/jingle"> <content senders="both" name="stream2" creator="initiator"> <description xmlns="http://jabber.org/protocol/jingle/description/video"> <payload-type rate="90000" name="H263" id="34"></payload-type>
 <payload-type rate="90000" name="H264" id="96"></payload-type>
 <payload-type rate="90000" name="H263-1998" id="97"></payload-type>
 <payload-type rate="90000" name="H263-N800" id="98"></payload-type>
 <payload-type rate="90000" name="H263-2000" id="99"></payload-type>
</description>
 <transport xmlns="http://www.google.com/transport/p2p"></transport>
</content>
</jingle>
</iq>

-----------------------------------
telepathy-gabble[2436]: GLIB DEBUG default - content_state_changed_cb: called
telepathy-gabble[2436]: GLIB DEBUG default - gabble_media_stream_new_native_candidate: google p2p connections only support the concept of one transport per candidate, ignoring other components
telepathy-gabble[2436]: GLIB DEBUG default - gabble_media_stream_new_native_candidate: put 1 native candidate from stream-engine into cache
telepathy-gabble[2436]: GLIB DEBUG default - add_candidates: content already signalled, transmitting candidates

SEND:
-----------------------------------
<iq type="set" to="tester.colltest5@gmail.com/TelepathyF29023C5" id="106732125183"> <jingle action="transport-info" sid="1935368496" initiator="tester.colltest5@gmail.com/TelepathyF29023C5" xmlns="http://jabber.org/protocol/jingle"> <content name="stream2" xmlns="http://jabber.org/protocol/jingle/description/video"> <transport xmlns="http://www.google.com/transport/p2p"> <candidate generation="0" network="0" name="rtp" component="1" type="local" protocol="udp" preference="0.015259" password="" username="R48GEFiAAPg8dJU0" port="60165" address="172.22.64.106"></candidate>
</transport>
</content>
</jingle>
</iq>

-----------------------------------

RECV [836]:
-----------------------------------
'<iq type="error" to="tester.colltest4@gmail.com/TelepathyD972DB41" id="884906903839" from="tester.colltest5@gmail.com/TelepathyF29023C5"> <jingle initiator="tester.colltest5@gmail.com/TelepathyF29023C5" sid="1935368496" action="content-add" xmlns="http://jabber.org/protocol/jingle">
 <content creator="initiator" name="stream2" senders="both">
 <description xmlns="http://jabber.org/protocol/jingle/description/video">
 <payload-type id="34" name="H263" rate="90000"/>
 <payload-type id="96" name="H264" rate="90000"/>
 <payload-type id="97" name="H263-1998" rate="90000"/>
 <payload-type id="98" name="H263-N800" rate="90000"/>
 <payload-type id="99" name="H263-2000" rate="90000"/>
</description>
 <transport xmlns="http://www.google.com/transport/p2p"/>
</content>
</jingle>
 <error type="cancel" code="404"> <item-not-found xmlns="'
-----------------------------------

RECV [137]:
-----------------------------------
'urn:ietf:params:xml:ns:xmpp-stanzas"/>
 <text>unable to handle action for unknown locally-created stream "stream2" </text>
</error>
</iq>'
-----------------------------------

RECV [139]:
-----------------------------------
'<iq type="result" to="tester.colltest4@gmail.com/TelepathyD972DB41" id="106732125183" from="tester.colltest5@gmail.com/TelepathyF29023C5"/>'
-----------------------------------
telepathy-gabble[2436]: GLIB DEBUG default - connection_iq_unknown_cb: got unknown iq:
<iq from="tester.colltest5@gmail.com/TelepathyF29023C5" id="884906903839" to="tester.colltest4@gmail.com/TelepathyD972DB41" type="error">
 <jingle xmlns="http://jabber.org/protocol/jingle" action="content-add" sid="1935368496" initiator="tester.colltest5@gmail.com/TelepathyF29023C5">
 <content senders="both" name="stream2" creator="initiator">
 <description xmlns="http://jabber.org/protocol/jingle/description/video">
 <payload-type rate="90000" name="H263" id="34"></payload-type>
 <payload-type rate="90000" name="H264" id="96"></payload-type>
 <payload-type rate="90000" name="H263-1998" id="97"></payload-type>
 <payload-type rate="90000" name="H263-N800" id="98"></payload-type>
 <payload-type rate="90000" name="H263-2000" id="99"></payload-type>
</description>
 <transport xmlns="http://www.google.com/transport/p2p"></transport>
</content>
</jingle>
 <error code="404" type="cancel">
 <item-not-found xmlns="urn:ietf:params:xml:ns:xmpp-stanzas"></item-not-found>
 <text>unable to handle action for unknown locally-created stream &quot;stream2&quot; </text>
</error>
</iq>
telepathy-gabble[2436]: GLIB DEBUG default - connection_iq_unknown_cb: got unknown iq:
<iq from="tester.colltest5@gmail.com/TelepathyF29023C5" id="106732125183" to="tester.colltest4@gmail.com/TelepathyD972DB41" type="result"></iq>

RECV [617]:
-----------------------------------
'<iq type="set" to="tester.colltest4@gmail.com/TelepathyD972DB41" id="8784718627" from="tester.colltest5@gmail.com/TelepathyF29023C5"> <jingle initiator="tester.colltest5@gmail.com/TelepathyF29023C5" action="transport-info" sid="1935368496" xmlns="http://jabber.org/protocol/jingle"> <content creator="responder" name="stream2"> <transport xmlns="http://www.google.com/transport/p2p"> <candidate generation="0" network="0" type="local" protocol="udp" preference="1.000000" password="9cb3KHfbPql9KXFo" username="eOMXYfZqpGNQ1u5i" port="51071" address="172.22.64.127" name="rtp"/>
</transport>
</content>
</jingle>
</iq>'
-----------------------------------

RECV [619]:
-----------------------------------
'<iq type="set" to="tester.colltest4@gmail.com/TelepathyD972DB41" id="262279787933" from="tester.colltest5@gmail.com/TelepathyF29023C5"> <jingle initiator="tester.colltest5@gmail.com/TelepathyF29023C5" action="transport-info" sid="1935368496" xmlns="http://jabber.org/protocol/jingle"> <content creator="responder" name="stream2"> <transport xmlns="http://www.google.com/transport/p2p"> <candidate generation="0" network="0" type="stun" protocol="udp" preference="0.900000" password="Roe7aJKPVvMl8BGq" username="rOQ14OZ+wr1Vuh+2" port="51073" address="78.105.107.120" name="rtp"/>
</transport>
</content>
</jingle>
</iq>'
-----------------------------------
telepathy-gabble[2436]: GLIB DEBUG default - gabble_jingle_session_parse: jingle action 'transport-info' from 'tester.colltest5@gmail.com/TelepathyF29023C5' in session '1935368496' dialect 3 state 4
telepathy-gabble[2436]: GLIB DEBUG default - parse_candidates: emitting 1 new remote candidates
telepathy-gabble[2436]: GLIB DEBUG default - new_remote_candidates_cb: got new remote candidates
telepathy-gabble[2436]: GLIB DEBUG default - push_remote_candidates: passing 1 remote candidate to stream engine: R1

SEND:
-----------------------------------
<iq type="result" to="tester.colltest5@gmail.com/TelepathyF29023C5" id="8784718627"></iq>

-----------------------------------
telepathy-gabble[2436]: GLIB DEBUG default - gabble_jingle_session_parse: jingle action 'transport-info' from 'tester.colltest5@gmail.com/TelepathyF29023C5' in session '1935368496' dialect 3 state 4
telepathy-gabble[2436]: GLIB DEBUG default - parse_candidates: emitting 1 new remote candidates
telepathy-gabble[2436]: GLIB DEBUG default - new_remote_candidates_cb: got new remote candidates
telepathy-gabble[2436]: GLIB DEBUG default - push_remote_candidates: passing 1 remote candidate to stream engine: R2

SEND:
-----------------------------------
<iq type="result" to="tester.colltest5@gmail.com/TelepathyF29023C5" id="262279787933"></iq>

-----------------------------------
telepathy-gabble[2436]: GLIB DEBUG default - gabble_media_stream_set_property: stream stream2 connection state 0

RECV [114]:
-----------------------------------
'<presence from="tester.colltest5@gmail.com/TelepathyF29023C5" type="unavailable" to="tester.colltest4@gmail.com"/>'
-----------------------------------
telepathy-gabble[2436]: GLIB DEBUG default - gabble_presence_cache_do_update: tester.colltest5@gmail.com (2) resource TelepathyF29023C5 prio 0 presence 0 message "(null)"
telepathy-gabble[2436]: GLIB DEBUG tp-glib - tp_presence_mixin_emit_presence_update: called.
telepathy-gabble[2436]: GLIB DEBUG tp-glib - construct_presence_hash: called.
telepathy-gabble[2436]: GLIB DEBUG tp-glib - construct_simple_presence_hash: called.
telepathy-gabble[2436]: GLIB DEBUG default - gabble_presence_cache_maybe_remove: discarding cached presence for unavailable jid tester.colltest5@gmail.com


telepathy-gabble[2436]: GLIB DEBUG default - gabble_media_channel_close_async: called
telepathy-gabble[2436]: GLIB DEBUG default - gabble_media_channel_close: called on 0xe7c98

SEND:
-----------------------------------
<iq type="set" to="tester.colltest5@gmail.com/TelepathyF29023C5" id="828730963897"> <jingle action="session-terminate" sid="1935368496" initiator="tester.colltest5@gmail.com/TelepathyF29023C5" xmlns="http://jabber.org/protocol/jingle"></jingle>
</iq>

-----------------------------------
telepathy-gabble[2436]: GLIB DEBUG default - gabble_jingle_session_terminate: we are terminating this session
telepathy-gabble[2436]: GLIB DEBUG default - set_state: Setting state of JingleSession: 0xe7408 (priv = 0xe7420) from 4 to 5
telepathy-gabble[2436]: GLIB DEBUG default - session_state_changed_cb: called
telepathy-gabble[2436]: GLIB DEBUG default - session_terminated_cb: removing terminated session
telepathy-gabble[2436]: GLIB DEBUG default - session_terminated_cb: called
emit_members_changed_signals: emitting members changed
  message       : ""
  added         : []
  removed       : [1 (tester.colltest4@gmail.com)
                   2 (tester.colltest5@gmail.com)]
  local_pending : []
  remote_pending: []
  actor         : 1
  reason        : 0: unspecified reason
tp_group_mixin_change_flags: emitting group flags changed
  added    : [CAN_ADD]
  removed  : [CAN_REMOVE]
  flags now: [CAN_ADD|PROPERTIES]
telepathy-gabble[2436]: GLIB DEBUG default - session_terminated_cb: unreffing streams
telepathy-gabble[2436]: GLIB DEBUG default - gabble_media_stream_dispose: called
telepathy-gabble[2436]: GLIB DEBUG default - gabble_media_stream_dispose: called
telepathy-gabble[2436]: GLIB DEBUG default - gabble_jingle_session_dispose: called
telepathy-gabble[2436]: GLIB DEBUG default - gabble_jingle_media_rtp_dispose: dispose called
telepathy-gabble[2436]: GLIB DEBUG default - gabble_jingle_content_dispose: dispose called
**
ERROR:jingle-content.c:130:gabble_jingle_content_dispose: assertion failed: (priv->timer_id == 0)

Program received signal SIGABRT, Aborted.
0x402a9388 in raise () from /lib/libc.so.6
(gdb) 
(gdb) 
(gdb) 
(gdb) 
(gdb) bt
#0  0x402a9388 in raise () from /lib/libc.so.6
#1  0x402aa9ac in abort () from /lib/libc.so.6
#2  0x40203994 in IA__g_assertion_message (domain=<value optimized out>, 
    file=0x403a0000 "\030\017\022", line=<value optimized out>, func=0x403a0be4 "", 
    message=0xf7588 "assertion failed: (priv->timer_id == 0)") at gtestutils.c:1301
#3  0x40203e90 in IA__g_assertion_message_expr (domain=0x403a0be4 "", 
    file=0x1 <Address 0x1 out of bounds>, line=1077545956, 
    func=0x1 <Address 0x1 out of bounds>, expr=0x7cd58 "priv->timer_id == 0")
    at gtestutils.c:1312
#4  0x0006429c in gabble_jingle_content_dispose (object=0x403a0000) at jingle-content.c:130
#5  0x0001f2fc in gabble_jingle_media_rtp_dispose (object=0xe7d00) at jingle-media-rtp.c:145
#6  0x40168d70 in IA__g_object_unref (_object=<value optimized out>) at gobject.c:2389
#7  0x401cd6f8 in g_hash_table_remove_node (hash_table=0xc22c8, node_ptr_ptr=0x984, notify=6)
    at ghash.c:204
#8  0x401cd768 in g_hash_table_remove_all_nodes (hash_table=0xc22c8, notify=1) at ghash.c:231
#9  0x401cdd1c in IA__g_hash_table_remove_all (hash_table=0xc22c8) at ghash.c:919
#10 0x401cddcc in IA__g_hash_table_destroy (hash_table=0xc22c8) at ghash.c:644
#11 0x00022ae0 in gabble_jingle_session_dispose (object=0xe7408) at jingle-session.c:166
#12 0x40168d70 in IA__g_object_unref (_object=<value optimized out>) at gobject.c:2389
#13 0x40168f88 in g_value_object_free_value (value=<value optimized out>) at gobject.c:2663
#14 0x4018e088 in IA__g_value_unset (value=0xfa350) at gvalue.c:276
#15 0x4017f3b0 in IA__g_signal_emit_valist (instance=0xe7408, signal_id=<value optimized out>, 
    detail=0, var_args=0xbec97fe8) at gsignal.c:3007
#16 0x4017f708 in IA__g_signal_emit (instance=0x0, signal_id=2436, detail=947232)
    at gsignal.c:3034
#17 0x00020478 in set_state (sess=0xe7408, state=JINGLE_STATE_ENDED) at jingle-session.c:1510
#18 0x00022168 in gabble_jingle_session_terminate (sess=0xe7408) at jingle-session.c:1547
---Type <return> to continue, or q <return> to quit---
#19 0x0006745c in gabble_media_channel_close (self=0xe7c98) at media-channel.c:806
#20 0x000676a0 in gabble_media_channel_close_async (iface=<value optimized out>, 
    context=0xf6760) at media-channel.c:782
#21 0x400d7ff0 in tp_svc_channel_close (self=0xe7c98, context=0xf6760)
    at _gen/tp-svc-channel.c:66
#22 0x4017410c in IA__g_cclosure_marshal_VOID__POINTER (closure=0xbec982b4, 
    return_value=<value optimized out>, n_param_values=<value optimized out>, 
    param_values=0xf72d0, invocation_hint=0x0, marshal_data=0x400d7fb4) at gmarshal.c:601
#23 0x40108e9c in gobject_message_function (connection=0xa49e0, message=0xa7e18, 
    user_data=<value optimized out>) at dbus-gobject.c:1347
#24 0x4013c6b0 in _dbus_object_tree_dispatch_and_unlock (tree=0xa0780, message=0xa7e18)
    at dbus-object-tree.c:856
#25 0x4012eaac in dbus_connection_dispatch (connection=0xa49e0) at dbus-connection.c:4447
#26 0x40105c40 in message_queue_dispatch (source=<value optimized out>, 
    callback=<value optimized out>, user_data=<value optimized out>) at dbus-gmain.c:101
#27 0x401db9dc in IA__g_main_context_dispatch (context=0xa2b00) at gmain.c:2142
#28 0x401df470 in g_main_context_iterate (context=0xa2b00, block=1, dispatch=1, 
    self=<value optimized out>) at gmain.c:2776
#29 0x401df84c in IA__g_main_loop_run (loop=0xa0fe0) at gmain.c:2984
#30 0x400d03b0 in tp_run_connection_manager (prog_name=<value optimized out>, 
    version=0x8a8dc "0.7.20", construct_cm=0x14a10 <construct_cm>, argc=<value optimized out>, 
    argv=0xbec98694) at run.c:264
#31 0x000149e8 in gabble_main (argc=1, argv=0xbec98694) at gabble.c:76
#32 0x00014948 in main (argc=0, argv=0x984) at main.c:27
(gdb)
Comment 1 Olivier Crête 2009-02-12 06:05:19 UTC
Here is the related part of the gabble log  on the diablo side:

RECV [1]:
-----------------------------------
' '
-----------------------------------
telepathy-gabble[15852]: GLIB DEBUG default - response_cb: got reply for request 0x6eec0
telepathy-gabble[15852]: GLIB DEBUG default - pipeline_reply_cb: called for entry 0x676c0
telepathy-gabble[15852]: GLIB DEBUG default - pipeline_reply_cb: will patch vcard
telepathy-gabble[15852]: GLIB DEBUG default - gabble_request_pipeline_enqueue: enqueued new request as item 0x6efa0
telepathy-gabble[15852]: GLIB DEBUG default - observe_vcard: no change to vCard alias "Tester Colltest5" for handle 1
telepathy-gabble[15852]: GLIB DEBUG default - delete_request: Discarding request 0x6ed60
telepathy-gabble[15852]: GLIB DEBUG default - cache_entry_attempt_to_free: Not freeing vCard cache entry 0x676c0: it has a cached vCard 0x8c7b8
telepathy-gabble[15852]: GLIB DEBUG default - delete_item: deleting item 0x6eec0
telepathy-gabble[15852]: GLIB DEBUG default - send_next_request: processing request 0x6efa0

SEND:
-----------------------------------
<iq type="set" id="313840313"> <vCard xmlns="vcard-temp"> <FN>Tester Colltest5</FN>
 <NICKNAME>Tester Colltest5</NICKNAME>
</vCard>
</iq>

-----------------------------------

RECV [254]:
-----------------------------------
'<iq type="get" to="tester.colltest5@gmail.com/Telepathy9578EE55" id="822654953826" from="tester.colltest4@gmail.com/TelepathyB7999AA7"> <query node="http://telepathy.freedesktop.org/caps#jingle-video" xmlns="http://jabber.org/protocol/disco#info"/>
</iq>'
-----------------------------------
telepathy-gabble[15852]: GLIB DEBUG default - connection_iq_disco_cb: got disco request for bundle http://telepathy.freedesktop.org/caps#jingle-video, caps are 5f
telepathy-gabble[15852]: GLIB DEBUG default - connection_iq_disco_cb: caps now 95
telepathy-gabble[15852]: GLIB DEBUG default - connection_iq_disco_cb: sending disco response:
<iq type="result" to="tester.colltest4@gmail.com/TelepathyB7999AA7" id="822654953826"> <query node="http://telepathy.freedesktop.org/caps#jingle-video" xmlns="http://jabber.org/protocol/disco#info"> <feature var="http://jabber.org/protocol/jingle/description/video"></feature>
</query>
</iq>

SEND:
-----------------------------------
<iq type="result" to="tester.colltest4@gmail.com/TelepathyB7999AA7" id="822654953826"> <query node="http://telepathy.freedesktop.org/caps#jingle-video" xmlns="http://jabber.org/protocol/disco#info"> <feature var="http://jabber.org/protocol/jingle/description/video"></feature>
</query>
</iq>

-----------------------------------

RECV [84]:
-----------------------------------
'<iq to="tester.colltest5@gmail.com/Telepathy9578EE55" id="313840313" type="result"/>'
-----------------------------------
telepathy-gabble[15852]: GLIB DEBUG default - response_cb: got reply for request 0x6efa0
telepathy-gabble[15852]: GLIB DEBUG default - replace_reply_cb: called: no error
telepathy-gabble[15852]: GLIB DEBUG default - observe_vcard: no change to vCard alias "Tester Colltest5" for handle 1
telepathy-gabble[15852]: GLIB DEBUG default - gabble_vcard_manager_remove_edit_request: request == 0x8cb00
telepathy-gabble[15852]: GLIB DEBUG default - delete_item: deleting item 0x6efa0

RECV [254]:
-----------------------------------
'<iq type="get" to="tester.colltest5@gmail.com/Telepathy9578EE55" id="830077961120" from="tester.colltest4@gmail.com/TelepathyB7999AA7"> <query node="http://telepathy.freedesktop.org/caps#jingle-audio" xmlns="http://jabber.org/protocol/disco#info"/>
</iq>'
-----------------------------------

RECV [250]:
-----------------------------------
'<iq type="get" to="tester.colltest5@gmail.com/Telepathy9578EE55" id="827952963226" from="tester.colltest4@gmail.com/TelepathyB7999AA7"> <query node="http://telepathy.freedesktop.org/caps#voice-v1" xmlns="http://jabber.org/protocol/disco#info"/>
</iq>'
-----------------------------------
telepathy-gabble[15852]: GLIB DEBUG default - connection_iq_disco_cb: got disco request for bundle http://telepathy.freedesktop.org/caps#jingle-audio, caps are 5f
telepathy-gabble[15852]: GLIB DEBUG default - connection_iq_disco_cb: caps now 95
telepathy-gabble[15852]: GLIB DEBUG default - connection_iq_disco_cb: sending disco response:
<iq type="result" to="tester.colltest4@gmail.com/TelepathyB7999AA7" id="830077961120"> <query node="http://telepathy.freedesktop.org/caps#jingle-audio" xmlns="http://jabber.org/protocol/disco#info"> <feature var="http://jabber.org/protocol/jingle/description/audio"></feature>
</query>
</iq>

SEND:
-----------------------------------
<iq type="result" to="tester.colltest4@gmail.com/TelepathyB7999AA7" id="830077961120"> <query node="http://telepathy.freedesktop.org/caps#jingle-audio" xmlns="http://jabber.org/protocol/disco#info"> <feature var="http://jabber.org/protocol/jingle/description/audio"></feature>
</query>
</iq>

-----------------------------------
telepathy-gabble[15852]: GLIB DEBUG default - connection_iq_disco_cb: got disco request for bundle http://telepathy.freedesktop.org/caps#voice-v1, caps are 5f
telepathy-gabble[15852]: GLIB DEBUG default - connection_iq_disco_cb: caps now 95
telepathy-gabble[15852]: GLIB DEBUG default - connection_iq_disco_cb: sending disco response:
<iq type="result" to="tester.colltest4@gmail.com/TelepathyB7999AA7" id="827952963226"> <query node="http://telepathy.freedesktop.org/caps#voice-v1" xmlns="http://jabber.org/protocol/disco#info"> <feature var="http://www.google.com/xmpp/protocol/voice/v1"></feature>
</query>
</iq>

SEND:
-----------------------------------
<iq type="result" to="tester.colltest4@gmail.com/TelepathyB7999AA7" id="827952963226"> <query node="http://telepathy.freedesktop.org/caps#voice-v1" xmlns="http://jabber.org/protocol/disco#info"> <feature var="http://www.google.com/xmpp/protocol/voice/v1"></feature>
</query>
</iq>

-----------------------------------
telepathy-gabble[15852]: GLIB DEBUG default - tp_presence_mixin_get_presence: called.
telepathy-gabble[15852]: GLIB DEBUG default - construct_presence_hash: called.
telepathy-gabble[15852]: GLIB DEBUG default - channel_request_new: New channel request at 0x672a8: ctype=org.freedesktop.Telepathy.Channel.Type.ContactList htype=3 handle=1 suppress=0
telepathy-gabble[15852]: GLIB DEBUG default - _gabble_roster_get_channel: Looking up channel 3:1 "publish"
telepathy-gabble[15852]: GLIB DEBUG default - satisfy_requests: called for /org/freedesktop/Telepathy/Connection/gabble/jabber/tester_2ecolltest5_40gmail_2ecom_2fTelepathy/RosterChannel/List/publish
telepathy-gabble[15852]: GLIB DEBUG default - satisfy_requests: completing queued request 0x672a8 with success, channel_type=org.freedesktop.Telepathy.Channel.Type.ContactList, handle_type=3, handle=1, suppress_handler=0
telepathy-gabble[15852]: GLIB DEBUG default - channel_request_free: Freeing channel request at 0x672a8: ctype=org.freedesktop.Telepathy.Channel.Type.ContactList htype=3 handle=1 suppress=0
telepathy-gabble[15852]: GLIB DEBUG default - channel_request_new: New channel request at 0x67550: ctype=org.freedesktop.Telepathy.Channel.Type.ContactList htype=3 handle=3 suppress=0
telepathy-gabble[15852]: GLIB DEBUG default - _gabble_roster_get_channel: Looking up channel 3:3 "known"
telepathy-gabble[15852]: GLIB DEBUG default - satisfy_requests: called for /org/freedesktop/Telepathy/Connection/gabble/jabber/tester_2ecolltest5_40gmail_2ecom_2fTelepathy/RosterChannel/List/known
telepathy-gabble[15852]: GLIB DEBUG default - satisfy_requests: completing queued request 0x67550 with success, channel_type=org.freedesktop.Telepathy.Channel.Type.ContactList, handle_type=3, handle=3, suppress_handler=0
telepathy-gabble[15852]: GLIB DEBUG default - channel_request_free: Freeing channel request at 0x67550: ctype=org.freedesktop.Telepathy.Channel.Type.ContactList htype=3 handle=3 suppress=0
telepathy-gabble[15852]: GLIB DEBUG default - channel_request_new: New channel request at 0x8cc38: ctype=org.freedesktop.Telepathy.Channel.Type.ContactList htype=3 handle=4 suppress=0
telepathy-gabble[15852]: GLIB DEBUG default - _gabble_roster_get_channel: Looking up channel 3:4 "deny"
telepathy-gabble[15852]: GLIB DEBUG default - satisfy_requests: called for /org/freedesktop/Telepathy/Connection/gabble/jabber/tester_2ecolltest5_40gmail_2ecom_2fTelepathy/RosterChannel/List/deny
telepathy-gabble[15852]: GLIB DEBUG default - satisfy_requests: completing queued request 0x8cc38 with success, channel_type=org.freedesktop.Telepathy.Channel.Type.ContactList, handle_type=3, handle=4, suppress_handler=0
telepathy-gabble[15852]: GLIB DEBUG default - channel_request_free: Freeing channel request at 0x8cc38: ctype=org.freedesktop.Telepathy.Channel.Type.ContactList htype=3 handle=4 suppress=0
telepathy-gabble[15852]: GLIB DEBUG default - gabble_vcard_manager_edit: called; invalidating cache
telepathy-gabble[15852]: GLIB DEBUG default - gabble_vcard_manager_edit: checking if we have pending requests already
telepathy-gabble[15852]: GLIB DEBUG default - gabble_vcard_manager_edit: we don't, create one
telepathy-gabble[15852]: GLIB DEBUG default - gabble_vcard_manager_request: Created request 0x89640 to retrieve <1>'s vCard
telepathy-gabble[15852]: GLIB DEBUG default - cache_entry_ensure_queued: Cache entry 0x67550 is my own, not setting @to
telepathy-gabble[15852]: GLIB DEBUG default - gabble_request_pipeline_enqueue: enqueued new request as item 0x8c1c0
telepathy-gabble[15852]: GLIB DEBUG default - cache_entry_ensure_queued: adding request to cache entry 0x67550 and queueing the <iq>
telepathy-gabble[15852]: GLIB DEBUG default - gabble_vcard_manager_edit: NICKNAME => value of length 16 starting Tester Colltest5
telepathy-gabble[15852]: GLIB DEBUG default - send_next_request: processing request 0x8c1c0

SEND:
-----------------------------------
<iq type="get" id="2118756286"> <vCard xmlns="vcard-temp"></vCard>
</iq>

-----------------------------------

RECV [148]:
-----------------------------------
'<iq to="tester.colltest5@gmail.com/Telepathy9578EE55" id="2118756286" type="result"><vCard xmlns="vcard-temp"><FN>Tester Colltest5</FN></vCard></iq>'
-----------------------------------
telepathy-gabble[15852]: GLIB DEBUG default - response_cb: got reply for request 0x8c1c0
telepathy-gabble[15852]: GLIB DEBUG default - pipeline_reply_cb: called for entry 0x67550
telepathy-gabble[15852]: GLIB DEBUG default - pipeline_reply_cb: will patch vcard
telepathy-gabble[15852]: GLIB DEBUG default - gabble_request_pipeline_enqueue: enqueued new request as item 0x89700
telepathy-gabble[15852]: GLIB DEBUG default - observe_vcard: no change to vCard alias "Tester Colltest5" for handle 1
telepathy-gabble[15852]: GLIB DEBUG default - delete_request: Discarding request 0x89640
telepathy-gabble[15852]: GLIB DEBUG default - cache_entry_attempt_to_free: Not freeing vCard cache entry 0x67550: it has a cached vCard 0x882b8
telepathy-gabble[15852]: GLIB DEBUG default - delete_item: deleting item 0x8c1c0
telepathy-gabble[15852]: GLIB DEBUG default - send_next_request: processing request 0x89700

SEND:
-----------------------------------
<iq type="set" id="265280954101"> <vCard xmlns="vcard-temp"> <FN>Tester Colltest5</FN>
 <NICKNAME>Tester Colltest5</NICKNAME>
</vCard>
</iq>

-----------------------------------

RECV [87]:
-----------------------------------
'<iq to="tester.colltest5@gmail.com/Telepathy9578EE55" id="265280954101" type="result"/>'
-----------------------------------
telepathy-gabble[15852]: GLIB DEBUG default - response_cb: got reply for request 0x89700
telepathy-gabble[15852]: GLIB DEBUG default - replace_reply_cb: called: no error
telepathy-gabble[15852]: GLIB DEBUG default - observe_vcard: no change to vCard alias "Tester Colltest5" for handle 1
telepathy-gabble[15852]: GLIB DEBUG default - gabble_vcard_manager_remove_edit_request: request == 0x8cc98
telepathy-gabble[15852]: GLIB DEBUG default - delete_item: deleting item 0x89700
telepathy-gabble[15852]: GLIB DEBUG default - channel_request_new: New channel request at 0x8cc38: ctype=org.freedesktop.Telepathy.Channel.Type.StreamedMedia htype=1 handle=2 suppress=1
tp_properties_mixin_emit_changed: emitting properties changed for property:
  nat-traversal
tp_properties_mixin_emit_flags: emitting properties flags changed for property:
  nat-traversal's flags now: [READ]
tp_group_mixin_change_members: emitting members changed
  message       : ""
  added         : [1 (tester.colltest5@gmail.com)]
  removed       : []
  local_pending : []
  remote_pending: []
  actor         : 0
  reason        : 0: unspecified reason
tp_group_mixin_change_flags: emitting group flags changed
  added    : [CAN_ADD]
  removed  : []
  flags now: [CAN_ADD]
tp_properties_mixin_emit_changed: emitting properties changed for property:
  stun-server
tp_properties_mixin_emit_flags: emitting properties flags changed for property:
  stun-server's flags now: [READ]
tp_properties_mixin_emit_changed: emitting properties changed for property:
  stun-port
tp_properties_mixin_emit_flags: emitting properties flags changed for property:
  stun-port's flags now: [READ]
tp_properties_mixin_emit_changed: emitting properties changed for property:
  gtalk-p2p-relay-token
tp_properties_mixin_emit_flags: emitting properties flags changed for property:
  gtalk-p2p-relay-token's flags now: [READ]
telepathy-gabble[15852]: GLIB DEBUG default - new_media_channel: object path /org/freedesktop/Telepathy/Connection/gabble/jabber/tester_2ecolltest5_40gmail_2ecom_2fTelepathy/MediaChannel0
tp_group_mixin_change_members: emitting members changed
  message       : ""
  added         : []
  removed       : []
  local_pending : []
  remote_pending: [2 (tester.colltest4@gmail.com)]
  actor         : 0
  reason        : 0: unspecified reason
tp_group_mixin_change_flags: emitting group flags changed
  added    : [CAN_REMOVE|CAN_RESCIND]
  removed  : [CAN_ADD]
  flags now: [CAN_REMOVE|CAN_RESCIND]
telepathy-gabble[15852]: GLIB DEBUG default - satisfy_requests: called for /org/freedesktop/Telepathy/Connection/gabble/jabber/tester_2ecolltest5_40gmail_2ecom_2fTelepathy/MediaChannel0
telepathy-gabble[15852]: GLIB DEBUG default - satisfy_requests: completing queued request 0x8cc38 with success, channel_type=org.freedesktop.Telepathy.Channel.Type.StreamedMedia, handle_type=1, handle=2, suppress_handler=1
telepathy-gabble[15852]: GLIB DEBUG default - channel_request_free: Freeing channel request at 0x8cc38: ctype=org.freedesktop.Telepathy.Channel.Type.StreamedMedia htype=1 handle=2 suppress=1
[15:03:26] JS_STATE_PENDING_CREATED   stream audio1 connection state 0
[15:03:26] JS_STATE_PENDING_CREATED   stream audio1 sig_state 0->0
[15:03:28] JS_STATE_PENDING_CREATED   stream audio1 connection state 0
[15:03:28] JS_STATE_PENDING_CREATED   ready called
[15:03:28] JS_STATE_PENDING_CREATED   stream audio1 emitting SetStreamPlaying(false)
[15:03:28] JS_STATE_PENDING_CREATED   stream audio1 emitting SetStreamSending(false)
[15:03:28] JS_STATE_PENDING_CREATED   putting list of all 6 locally supported codecs from stream-engine into cache
telepathy-gabble[15852]: GLIB DEBUG default - codec_params_from_tp_foreach: ignoring mode=30 for jingle audio stream

SEND:
-----------------------------------
<iq type="set" to="tester.colltest4@gmail.com/TelepathyB7999AA7" id="271392882049"> <jingle xmlns="http://jabber.org/protocol/jingle" initiator="tester.colltest5@gmail.com/Telepathy9578EE55" action="session-initiate" sid="1609767046"> <content creator="initiator" name="audio1"> <description xmlns="http://jabber.org/protocol/jingle/description/audio"> <payload-type rate="8000" name="iLBC" id="96"></payload-type>
 <payload-type rate="8000" name="G729" id="18"></payload-type>
 <payload-type rate="8000" name="PCMA" id="8"></payload-type>
 <payload-type rate="8000" name="PCMU" id="0"></payload-type>
 <payload-type channels="1" rate="8000" name="CN" id="13"></payload-type>
 <payload-type channels="1" rate="8000" name="telephone-event" id="97"></payload-type>
</description>
 <transport xmlns="http://www.google.com/transport/p2p"></transport>
</content>
</jingle>
</iq>

-----------------------------------
[15:03:28] JS_STATE_PENDING_CREATED   stream audio1 sig_state 0->1
[15:03:29] JS_STATE_PENDING_INITIATE_SENT gabble_media_stream_new_native_candidate: ignoring native localhost candidate
[15:03:29] JS_STATE_PENDING_INITIATE_SENT put 1 native candidate from stream-engine into cache
[15:03:29] JS_STATE_PENDING_INITIATE_SENT   from Telepathy D-Bus struct: ["L2", [1, "172.22.64.127", 51112, TP_MEDIA_STREAM_BASE_PROTO_UDP (0), "RTP", "AVP", 1.000000, TP_MEDIA_STREAM_TRANSPORT_TYPE_LOCAL (0), "fr6nEqzdBbqalhH0", "+d36y1ZXLU65TxEz"]]
[15:03:29] JS_STATE_PENDING_INITIATE_SENT   to Jingle XML: [<candidate generation="0" network="0" type="local" protocol="udp" preference="1.000000" password="+d36y1ZXLU65TxEz" username="fr6nEqzdBbqalhH0" port="51112" address="172.22.64.127" name="rtp"></candidate>
]
[15:03:29] JS_STATE_PENDING_INITIATE_SENT sending jingle session action "transport-info" to peer

SEND:
-----------------------------------
<iq type="set" to="tester.colltest4@gmail.com/TelepathyB7999AA7" id="315419775"> <jingle xmlns="http://jabber.org/protocol/jingle" initiator="tester.colltest5@gmail.com/Telepathy9578EE55" action="transport-info" sid="1609767046"> <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="+d36y1ZXLU65TxEz" username="fr6nEqzdBbqalhH0" port="51112" address="172.22.64.127" name="rtp"></candidate>
</transport>
</content>
</jingle>
</iq>

-----------------------------------
[15:03:29] JS_STATE_PENDING_INITIATE_SENT put 1 native candidate from stream-engine into cache
[15:03:29] JS_STATE_PENDING_INITIATE_SENT   from Telepathy D-Bus struct: ["L3", [1, "78.105.107.120", 51113, TP_MEDIA_STREAM_BASE_PROTO_UDP (0), "RTP", "AVP", 0.900000, TP_MEDIA_STREAM_TRANSPORT_TYPE_DERIVED (1), "hVygyXHK8qAK+bHw", "cTpkqjKOHBY0sN9i"]]
[15:03:29] JS_STATE_PENDING_INITIATE_SENT   to Jingle XML: [<candidate generation="0" network="0" type="stun" protocol="udp" preference="0.900000" password="cTpkqjKOHBY0sN9i" username="hVygyXHK8qAK+bHw" port="51113" address="78.105.107.120" name="rtp"></candidate>
]
[15:03:29] JS_STATE_PENDING_INITIATE_SENT sending jingle session action "transport-info" to peer

SEND:
-----------------------------------
<iq type="set" to="tester.colltest4@gmail.com/TelepathyB7999AA7" id="929958807"> <jingle xmlns="http://jabber.org/protocol/jingle" initiator="tester.colltest5@gmail.com/Telepathy9578EE55" action="transport-info" sid="1609767046"> <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="cTpkqjKOHBY0sN9i" username="hVygyXHK8qAK+bHw" port="51113" address="78.105.107.120" name="rtp"></candidate>
</transport>
</content>
</jingle>
</iq>

-----------------------------------

RECV [139]:
-----------------------------------
'<iq type="result" to="tester.colltest5@gmail.com/Telepathy9578EE55" id="271392882049" from="tester.colltest4@gmail.com/TelepathyB7999AA7"/>'
-----------------------------------

RECV [136]:
-----------------------------------
'<iq type="result" to="tester.colltest5@gmail.com/Telepathy9578EE55" id="315419775" from="tester.colltest4@gmail.com/TelepathyB7999AA7"/>'
-----------------------------------
[15:03:29] JS_STATE_PENDING_INITIATED stream audio1 sig_state 1->2

RECV [136]:
-----------------------------------
'<iq type="result" to="tester.colltest5@gmail.com/Telepathy9578EE55" id="929958807" from="tester.colltest4@gmail.com/TelepathyB7999AA7"/>'
-----------------------------------

RECV [656]:
-----------------------------------
'<iq type="set" to="tester.colltest5@gmail.com/Telepathy9578EE55" id="633261768463" from="tester.colltest4@gmail.com/TelepathyB7999AA7"> <jingle action="transport-info" sid="1609767046" initiator="tester.colltest5@gmail.com/Telepathy9578EE55" xmlns="http://jabber.org/protocol/jingle"> <content name="audio1" xmlns="http://jabber.org/protocol/jingle/description/audio"> <transport xmlns="http://www.google.com/transport/p2p"> <candidate generation="0" network="0" name="rtp" component="1" type="local" protocol="udp" preference="0.015259" password="" username="04c5SB73CajIquoZ" port="57282" address="172.22.64.106"/>
</transport>
</content>
</jingle>
</iq>'
-----------------------------------
telepathy-gabble[15852]: GLIB DEBUG default - media_factory_jingle_cb: dispatching to session 1609767046
[15:03:44] JS_STATE_PENDING_INITIATED put 1 remote candidate from peer into cache
[15:03:44] JS_STATE_PENDING_INITIATED   from Jingle XML: [<candidate address="172.22.64.106" port="57282" username="04c5SB73CajIquoZ" password="" preference="0.015259" protocol="udp" type="local" component="1" name="rtp" network="0" generation="0"></candidate>
]
[15:03:44] JS_STATE_PENDING_INITIATED   to Telepathy D-Bus struct: ["R1", [1, "172.22.64.106", 57282, TP_MEDIA_STREAM_BASE_PROTO_UDP (0), "RTP", "AVP", 0.015259, TP_MEDIA_STREAM_TRANSPORT_TYPE_LOCAL (0), "04c5SB73CajIquoZ", ""]]
[15:03:44] JS_STATE_PENDING_INITIATED passing 1 remote candidate to stream-engine

SEND:
-----------------------------------
<iq type="result" to="tester.colltest4@gmail.com/TelepathyB7999AA7" id="633261768463"></iq>

-----------------------------------
[15:03:44] JS_STATE_PENDING_INITIATED stream audio1 connection state 1

RECV [766]:
-----------------------------------
'<iq type="set" to="tester.colltest5@gmail.com/Telepathy9578EE55" id="329380460449" from="tester.colltest4@gmail.com/TelepathyB7999AA7"> <jingle action="session-accept" sid="1609767046" initiator="tester.colltest5@gmail.com/Telepathy9578EE55" xmlns="http://jabber.org/protocol/jingle"> <content senders="both" name="audio1" creator="initiator"> <description xmlns="http://jabber.org/protocol/jingle/description/audio"> <payload-type channels="1" rate="8000" name="PCMA" id="8"/>
 <payload-type channels="1" rate="8000" name="PCMU" id="0"/>
 <payload-type channels="1" rate="8000" name="telephone-event" id="97"> <parameter value="0-15" name="events"/>
</payload-type>
</description>
 <transport xmlns="http://www.google.com/transport/p2p"/>
</content>
</jingle>
</iq>'
-----------------------------------
telepathy-gabble[15852]: GLIB DEBUG default - media_factory_jingle_cb: dispatching to session 1609767046
[15:03:45] JS_STATE_PENDING_INITIATED put 3 remote codecs from peer into cache
[15:03:45] JS_STATE_PENDING_INITIATED passing 3 remote codecs to stream-engine
[15:03:45] JS_STATE_PENDING_INITIATED stream audio1 emitting SetStreamPlaying(true)
[15:03:45] JS_STATE_PENDING_INITIATED stream audio1 emitting SetStreamSending(true)

SEND:
-----------------------------------
<iq type="result" to="tester.colltest4@gmail.com/TelepathyB7999AA7" id="329380460449"></iq>

-----------------------------------
tp_group_mixin_change_members: emitting members changed
  message       : ""
  added         : [2 (tester.colltest4@gmail.com)]
  removed       : []
  local_pending : []
  remote_pending: []
  actor         : 0
  reason        : 0: unspecified reason
tp_group_mixin_change_flags: emitting group flags changed
  added    : []
  removed  : [CAN_RESCIND]
  flags now: [CAN_REMOVE]

RECV [656]:
-----------------------------------
'<iq type="set" to="tester.colltest5@gmail.com/Telepathy9578EE55" id="337956468994" from="tester.colltest4@gmail.com/TelepathyB7999AA7"> <jingle action="transport-info" sid="1609767046" initiator="tester.colltest5@gmail.com/Telepathy9578EE55" xmlns="http://jabber.org/protocol/jingle"> <content name="audio1" xmlns="http://jabber.org/protocol/jingle/description/audio"> <transport xmlns="http://www.google.com/transport/p2p"> <candidate generation="0" network="0" name="rtp" component="1" type="local" protocol="udp" preference="0.015259" password="" username="04c5SB73CajIquoZ" port="57282" address="172.22.64.106"/>
</transport>
</content>
</jingle>
</iq>'
-----------------------------------
telepathy-gabble[15852]: GLIB DEBUG default - media_factory_jingle_cb: dispatching to session 1609767046
[15:03:45] JS_STATE_ACTIVE            put 1 remote candidate from peer into cache
[15:03:45] JS_STATE_ACTIVE              from Jingle XML: [<candidate address="172.22.64.106" port="57282" username="04c5SB73CajIquoZ" password="" preference="0.015259" protocol="udp" type="local" component="1" name="rtp" network="0" generation="0"></candidate>
]
[15:03:45] JS_STATE_ACTIVE              to Telepathy D-Bus struct: ["R2", [1, "172.22.64.106", 57282, TP_MEDIA_STREAM_BASE_PROTO_UDP (0), "RTP", "AVP", 0.015259, TP_MEDIA_STREAM_TRANSPORT_TYPE_LOCAL (0), "04c5SB73CajIquoZ", ""]]
[15:03:45] JS_STATE_ACTIVE            passing 1 remote candidate to stream-engine

SEND:
-----------------------------------
<iq type="result" to="tester.colltest4@gmail.com/TelepathyB7999AA7" id="337956468994"></iq>

-----------------------------------
[15:03:46] JS_STATE_ACTIVE            got codec intersection containing 4 codecs from stream-engine










RECV [779]:
-----------------------------------
'<iq type="set" to="tester.colltest5@gmail.com/Telepathy9578EE55" id="862535878906" from="tester.colltest4@gmail.com/TelepathyB7999AA7"> <jingle action="content-add" sid="1609767046" initiator="tester.colltest5@gmail.com/Telepathy9578EE55" xmlns="http://jabber.org/protocol/jingle"> <content senders="both" name="stream2" creator="initiator"> <description xmlns="http://jabber.org/protocol/jingle/description/video"> <payload-type rate="90000" name="H263" id="34"/>
 <payload-type rate="90000" name="H264" id="96"/>
 <payload-type rate="90000" name="H263-1998" id="97"/>
 <payload-type rate="90000" name="H263-N800" id="98"/>
 <payload-type rate="90000" name="H263-2000" id="99"/>
</description>
 <transport xmlns="http://www.google.com/transport/p2p"/>
</content>
</jingle>
</iq>'
-----------------------------------
telepathy-gabble[15852]: GLIB DEBUG default - media_factory_jingle_cb: dispatching to session 1609767046
[15:04:11] JS_STATE_ACTIVE            stream stream2 connection state 0
[15:04:11] JS_STATE_ACTIVE            stream stream2 sig_state 0->0
[15:04:11] JS_STATE_ACTIVE            stream stream2 sig_state 0->2

SEND:
-----------------------------------
<iq type="error" to="tester.colltest4@gmail.com/TelepathyB7999AA7" id="862535878906"> <jingle xmlns="http://jabber.org/protocol/jingle" initiator="tester.colltest5@gmail.com/Telepathy9578EE55" sid="1609767046" action="content-add">
 <content creator="initiator" name="stream2" senders="both">
 <description xmlns="http://jabber.org/protocol/jingle/description/video">
 <payload-type id="34" name="H263" rate="90000"></payload-type>
 <payload-type id="96" name="H264" rate="90000"></payload-type>
 <payload-type id="97" name="H263-1998" rate="90000"></payload-type>
 <payload-type id="98" name="H263-N800" rate="90000"></payload-type>
 <payload-type id="99" name="H263-2000" rate="90000"></payload-type>
</description>
 <transport xmlns="http://www.google.com/transport/p2p"></transport>
</content>
</jingle>
 <error type="cancel" code="404"> <item-not-found xmlns="urn:ietf:params:xml:ns:xmpp-stanzas"></item-not-found>
 <text>unable to handle action for unknown locally-created stream &quot;stream2&quot; </text>
</error>
</iq>

-----------------------------------

RECV [654]:
-----------------------------------
'<iq type="set" to="tester.colltest5@gmail.com/Telepathy9578EE55" id="915825512" from="tester.colltest4@gmail.com/TelepathyB7999AA7"> <jingle action="transport-info" sid="1609767046" initiator="tester.colltest5@gmail.com/Telepathy9578EE55" xmlns="http://jabber.org/protocol/jingle"> <content name="stream2" xmlns="http://jabber.org/protocol/jingle/description/video"> <transport xmlns="http://www.google.com/transport/p2p"> <candidate generation="0" network="0" name="rtp" component="1" type="local" protocol="udp" preference="0.015259" password="" username="uAUOlSZqH7jQkc3q" port="64891" address="172.22.64.106"/>
</transport>
</content>
</jingle>
</iq>'
-----------------------------------
telepathy-gabble[15852]: GLIB DEBUG default - media_factory_jingle_cb: dispatching to session 1609767046
[15:04:11] JS_STATE_ACTIVE            put 1 remote candidate from peer into cache
[15:04:11] JS_STATE_ACTIVE              from Jingle XML: [<candidate address="172.22.64.106" port="64891" username="uAUOlSZqH7jQkc3q" password="" preference="0.015259" protocol="udp" type="local" component="1" name="rtp" network="0" generation="0"></candidate>
]
[15:04:11] JS_STATE_ACTIVE              to Telepathy D-Bus struct: ["R1", [1, "172.22.64.106", 64891, TP_MEDIA_STREAM_BASE_PROTO_UDP (0), "RTP", "AVP", 0.015259, TP_MEDIA_STREAM_TRANSPORT_TYPE_LOCAL (0), "uAUOlSZqH7jQkc3q", ""]]

SEND:
-----------------------------------
<iq type="result" to="tester.colltest4@gmail.com/TelepathyB7999AA7" id="915825512"></iq>

-----------------------------------
[15:04:11] JS_STATE_ACTIVE            stream stream2 connection state 0
[15:04:11] JS_STATE_ACTIVE            ready called
[15:04:11] JS_STATE_ACTIVE            passing 1 remote candidate to stream-engine
[15:04:11] JS_STATE_ACTIVE            stream stream2 emitting SetStreamPlaying(false)
[15:04:11] JS_STATE_ACTIVE            stream stream2 emitting SetStreamSending(false)
[15:04:11] JS_STATE_ACTIVE            putting list of all 3 locally supported codecs from stream-engine into cache
[15:04:12] JS_STATE_ACTIVE            gabble_media_stream_new_native_candidate: ignoring native localhost candidate
[15:04:12] JS_STATE_ACTIVE            put 1 native candidate from stream-engine into cache
[15:04:12] JS_STATE_ACTIVE              from Telepathy D-Bus struct: ["L2", [1, "172.22.64.127", 51116, TP_MEDIA_STREAM_BASE_PROTO_UDP (0), "RTP", "AVP", 1.000000, TP_MEDIA_STREAM_TRANSPORT_TYPE_LOCAL (0), "80RcEkpZBSyIXiPO", "rzxsJ1V2D/PGbcHx"]]
[15:04:12] JS_STATE_ACTIVE              to Jingle XML: [<candidate generation="0" network="0" type="local" protocol="udp" preference="1.000000" password="rzxsJ1V2D/PGbcHx" username="80RcEkpZBSyIXiPO" port="51116" address="172.22.64.127" name="rtp"></candidate>
]
[15:04:12] JS_STATE_ACTIVE            sending jingle session action "transport-info" to peer

SEND:
-----------------------------------
<iq type="set" to="tester.colltest4@gmail.com/TelepathyB7999AA7" id="8240553131"> <jingle xmlns="http://jabber.org/protocol/jingle" initiator="tester.colltest5@gmail.com/Telepathy9578EE55" action="transport-info" sid="1609767046"> <content creator="responder" name="stream2"> <transport xmlns="http://www.google.com/transport/p2p"> <candidate generation="0" network="0" type="local" protocol="udp" preference="1.000000" password="rzxsJ1V2D/PGbcHx" username="80RcEkpZBSyIXiPO" port="51116" address="172.22.64.127" name="rtp"></candidate>
</transport>
</content>
</jingle>
</iq>

-----------------------------------
[15:04:12] JS_STATE_ACTIVE            put 1 native candidate from stream-engine into cache
[15:04:12] JS_STATE_ACTIVE              from Telepathy D-Bus struct: ["L3", [1, "78.105.107.120", 51117, TP_MEDIA_STREAM_BASE_PROTO_UDP (0), "RTP", "AVP", 0.900000, TP_MEDIA_STREAM_TRANSPORT_TYPE_DERIVED (1), "kmB6jXhG7buQKqWe", "OUy0MdMHyMe07/dy"]]
[15:04:12] JS_STATE_ACTIVE              to Jingle XML: [<candidate generation="0" network="0" type="stun" protocol="udp" preference="0.900000" password="OUy0MdMHyMe07/dy" username="kmB6jXhG7buQKqWe" port="51117" address="78.105.107.120" name="rtp"></candidate>
]
[15:04:12] JS_STATE_ACTIVE            sending jingle session action "transport-info" to peer

SEND:
-----------------------------------
<iq type="set" to="tester.colltest4@gmail.com/TelepathyB7999AA7" id="3113609954"> <jingle xmlns="http://jabber.org/protocol/jingle" initiator="tester.colltest5@gmail.com/Telepathy9578EE55" action="transport-info" sid="1609767046"> <content creator="responder" name="stream2"> <transport xmlns="http://www.google.com/transport/p2p"> <candidate generation="0" network="0" type="stun" protocol="udp" preference="0.900000" password="OUy0MdMHyMe07/dy" username="kmB6jXhG7buQKqWe" port="51117" address="78.105.107.120" name="rtp"></candidate>
</transport>
</content>
</jingle>
</iq>

-----------------------------------
[15:04:12] JS_STATE_ACTIVE            stream stream2 connection state 1
telepathy-gabble[15852]: GLIB ERROR ** default - file gabble-media-session.c: line 2774 (_direction_to_senders): should not be reached
aborting...
Aborted
Comment 2 Will Thompson 2009-03-20 06:38:46 UTC
The crash in new Gabble was fixed a few releases ago, and I believe this is the crash in Diablo's Gabble that Sjoerd stopped modern Gabbles triggering.

Reopen if I'm wrong.

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.