Attachment 35562 Details for Bug 28026 – empathy.log

empathy.log

empathy.log (text/plain), 102.13 KB, created by Nicolò Chieffo on 2010-05-11 03:45:56 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Nicolò Chieffo

Created: 2010-05-11 03:45:56 UTC

Size: 102.13 KB

patch

obsolete

>empathy/Contact-DEBUG: 11/05/2010 12:39:25.628726: contact_list_store_contact_update: Set active (contact updated offline -> online)
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.628782: contact_list_store_contact_set_active: Set item active
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.628806: contact_list_store_contact_active_new: Contact:'Chievo!' now active, and WILL NOT be removed
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.628828: contact_list_store_members_changed_cb: Contact bazooka00@hotmail.com (13) added
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.628854: contact_list_store_members_changed_cb: Contact mattia.massa@hotmail.it (14) added
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.628875: contact_list_store_members_changed_cb: Contact nicolo.sacchi@hotmail.it (15) added
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.628895: contact_list_store_members_changed_cb: Contact andrea.zaccheroni@hotmail.it (16) added
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.628918: contact_list_store_members_changed_cb: Contact jevad@libero.it (17) added
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.629051: contact_list_store_contact_update: Contact:'Jonathan' in list:YES, should be:YES
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.629055: contact_list_store_contact_update: Set active (contact updated offline -> online)
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.629093: contact_list_store_contact_set_active: Set item active
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.629100: contact_list_store_contact_active_new: Contact:'Jonathan' now active, and WILL NOT be removed
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.629121: contact_list_store_members_changed_cb: Contact ros.mat@hotmail.it (18) added
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.629143: contact_list_store_members_changed_cb: Contact matteo.collina@gmail.com (19) added
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.629168: contact_list_store_members_changed_cb: Contact anna.derosa@gmail.com (20) added
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.629188: contact_list_store_members_changed_cb: Contact francesco_calore@hotmail.com (21) added
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.629206: contact_list_store_members_changed_cb: Contact gnappo_g@libero.it (22) added
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.629229: contact_list_store_members_changed_cb: Contact mikibraglia@hotmail.it (23) added
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.629249: contact_list_store_members_changed_cb: Contact enrico.donati85@hotmail.it (24) added
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.629268: contact_list_store_members_changed_cb: Contact piergiorgio.massari@hotmail.com (25) added
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.629391: contact_list_store_contact_update: Contact:'Piergiorgio' in list:YES, should be:YES
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.629395: contact_list_store_contact_update: Set active (contact updated offline -> online)
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.629431: contact_list_store_contact_set_active: Set item active
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.629437: contact_list_store_contact_active_new: Contact:'Piergiorgio' now active, and WILL NOT be removed
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.629457: contact_list_store_members_changed_cb: Contact sailor__neptune@hotmail.it (26) added
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.629477: contact_list_store_members_changed_cb: Contact yelo_3@yahoo.it (27) added
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.629498: contact_list_store_members_changed_cb: Contact pietrino84@hotmail.it (28) added
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.629520: contact_list_store_members_changed_cb: Contact fedux-86@hotmail.it (29) added
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.629544: contact_list_store_members_changed_cb: Contact celli-the-best-@hotmail.it (30) added
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.629564: contact_list_store_members_changed_cb: Contact vesperta@hotmail.com (31) added
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.629582: contact_list_store_members_changed_cb: Contact watson86@msn.com (32) added
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.629606: contact_list_store_members_changed_cb: Contact mattia889@hotmail.com (33) added
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.629746: contact_list_store_contact_update: Contact:'Mattia' in list:YES, should be:YES
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.629751: contact_list_store_contact_update: Set active (contact updated offline -> online)
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.629792: contact_list_store_contact_set_active: Set item active
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.629798: contact_list_store_contact_active_new: Contact:'Mattia' now active, and WILL NOT be removed
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.629818: contact_list_store_members_changed_cb: Contact ci-francy@hotmail.it (34) added
>empathy/(null)-DEBUG: 11/05/2010 12:39:25.630013: tp_contact_factory_got_known_avatar_tokens: Got 0 tokens, need to request 0 avatars
>empathy/(null)-DEBUG: 11/05/2010 12:39:25.630103: update_contact_capabilities: Changing capabilities for contact chieffo.nicolo@studio.unibo.it (12) to 0
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.630115: contact_list_store_contact_updated_cb: Contact:'Chievo!' updated, checking roster is in sync...
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.630139: contact_list_store_contact_update: Contact:'Chievo!' in list:YES, should be:YES
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.630142: contact_list_store_contact_update: Set active (contact updated)
>empathy/(null)-DEBUG: 11/05/2010 12:39:25.630220: tp_contact_factory_got_known_avatar_tokens: Got 0 tokens, need to request 0 avatars
>empathy/(null)-DEBUG: 11/05/2010 12:39:25.633318: update_contact_capabilities: Changing capabilities for contact bazooka00@hotmail.com (13) to 0
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.633332: contact_list_store_contact_updated_cb: Contact:'Dr. BazookA' updated, checking roster is in sync...
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.633359: contact_list_store_contact_update: Contact:'Dr. BazookA' in list:NO, should be:NO
>empathy/(null)-DEBUG: 11/05/2010 12:39:25.633443: tp_contact_factory_got_known_avatar_tokens: Got 0 tokens, need to request 0 avatars
>empathy/(null)-DEBUG: 11/05/2010 12:39:25.633514: update_contact_capabilities: Changing capabilities for contact mattia.massa@hotmail.it (14) to 0
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.633524: contact_list_store_contact_updated_cb: Contact:'Mattia Massa' updated, checking roster is in sync...
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.633547: contact_list_store_contact_update: Contact:'Mattia Massa' in list:NO, should be:NO
>empathy/(null)-DEBUG: 11/05/2010 12:39:25.633620: tp_contact_factory_got_known_avatar_tokens: Got 0 tokens, need to request 0 avatars
>empathy/(null)-DEBUG: 11/05/2010 12:39:25.633692: update_contact_capabilities: Changing capabilities for contact nicolo.sacchi@hotmail.it (15) to 0
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.633701: contact_list_store_contact_updated_cb: Contact:'Sacco' updated, checking roster is in sync...
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.633723: contact_list_store_contact_update: Contact:'Sacco' in list:NO, should be:NO
>empathy/(null)-DEBUG: 11/05/2010 12:39:25.633768: tp_contact_factory_got_known_avatar_tokens: Got 0 tokens, need to request 0 avatars
>empathy/(null)-DEBUG: 11/05/2010 12:39:25.633868: update_contact_capabilities: Changing capabilities for contact andrea.zaccheroni@hotmail.it (16) to 0
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.633878: contact_list_store_contact_updated_cb: Contact:'Zakko' updated, checking roster is in sync...
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.633900: contact_list_store_contact_update: Contact:'Zakko' in list:NO, should be:NO
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.634016: empathy_contact_load_avatar_cache: Avatar loaded from /home/yelo3/.cache/telepathy/avatars/butterfly/msn/e9259efff75044daed53b272b0ac1926443950ce
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.634027: contact_list_store_contact_updated_cb: Contact:'Jonathan' updated, checking roster is in sync...
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.634051: contact_list_store_contact_update: Contact:'Jonathan' in list:YES, should be:YES
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.634053: contact_list_store_contact_update: Set active (contact updated)
>empathy/(null)-DEBUG: 11/05/2010 12:39:25.635081: tp_contact_factory_got_known_avatar_tokens: Got 1 tokens, need to request 0 avatars
>empathy/(null)-DEBUG: 11/05/2010 12:39:25.635261: update_contact_capabilities: Changing capabilities for contact jevad@libero.it (17) to 0
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.635273: contact_list_store_contact_updated_cb: Contact:'Jonathan' updated, checking roster is in sync...
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.635302: contact_list_store_contact_update: Contact:'Jonathan' in list:YES, should be:YES
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.635304: contact_list_store_contact_update: Set active (contact updated)
>empathy/(null)-DEBUG: 11/05/2010 12:39:25.635727: tp_contact_factory_got_known_avatar_tokens: Got 0 tokens, need to request 0 avatars
>empathy/(null)-DEBUG: 11/05/2010 12:39:25.635802: update_contact_capabilities: Changing capabilities for contact ros.mat@hotmail.it (18) to 0
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.635813: contact_list_store_contact_updated_cb: Contact:'Matteo' updated, checking roster is in sync...
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.635838: contact_list_store_contact_update: Contact:'Matteo' in list:NO, should be:NO
>empathy/(null)-DEBUG: 11/05/2010 12:39:25.635907: tp_contact_factory_got_known_avatar_tokens: Got 0 tokens, need to request 0 avatars
>empathy/(null)-DEBUG: 11/05/2010 12:39:25.635977: update_contact_capabilities: Changing capabilities for contact matteo.collina@gmail.com (19) to 0
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.635988: contact_list_store_contact_updated_cb: Contact:'Matteo' updated, checking roster is in sync...
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.636010: contact_list_store_contact_update: Contact:'Matteo' in list:NO, should be:NO
>empathy/(null)-DEBUG: 11/05/2010 12:39:25.636084: tp_contact_factory_got_known_avatar_tokens: Got 0 tokens, need to request 0 avatars
>empathy/(null)-DEBUG: 11/05/2010 12:39:25.636152: update_contact_capabilities: Changing capabilities for contact anna.derosa@gmail.com (20) to 0
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.636162: contact_list_store_contact_updated_cb: Contact:'Anna' updated, checking roster is in sync...
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.636184: contact_list_store_contact_update: Contact:'Anna' in list:NO, should be:NO
>empathy/(null)-DEBUG: 11/05/2010 12:39:25.636226: tp_contact_factory_got_known_avatar_tokens: Got 0 tokens, need to request 0 avatars
>empathy/(null)-DEBUG: 11/05/2010 12:39:25.636295: update_contact_capabilities: Changing capabilities for contact francesco_calore@hotmail.com (21) to 0
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.636305: contact_list_store_contact_updated_cb: Contact:'Phil Jackson: tra studio e allenamenti' updated, checking roster is in sync...
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.636327: contact_list_store_contact_update: Contact:'Phil Jackson: tra studio e allenamenti' in list:NO, should be:NO
>empathy/(null)-DEBUG: 11/05/2010 12:39:25.636394: tp_contact_factory_got_known_avatar_tokens: Got 0 tokens, need to request 0 avatars
>empathy/(null)-DEBUG: 11/05/2010 12:39:25.636464: update_contact_capabilities: Changing capabilities for contact gnappo_g@libero.it (22) to 0
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.636472: contact_list_store_contact_updated_cb: Contact:'Patta' updated, checking roster is in sync...
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.636496: contact_list_store_contact_update: Contact:'Patta' in list:NO, should be:NO
>empathy/(null)-DEBUG: 11/05/2010 12:39:25.636568: tp_contact_factory_got_known_avatar_tokens: Got 0 tokens, need to request 0 avatars
>empathy/(null)-DEBUG: 11/05/2010 12:39:25.636635: update_contact_capabilities: Changing capabilities for contact mikibraglia@hotmail.it (23) to 0
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.636651: contact_list_store_contact_updated_cb: Contact:'michele' updated, checking roster is in sync...
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.636673: contact_list_store_contact_update: Contact:'michele' in list:NO, should be:NO
>empathy/(null)-DEBUG: 11/05/2010 12:39:25.636714: tp_contact_factory_got_known_avatar_tokens: Got 0 tokens, need to request 0 avatars
>empathy/(null)-DEBUG: 11/05/2010 12:39:25.636780: update_contact_capabilities: Changing capabilities for contact enrico.donati85@hotmail.it (24) to 0
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.636790: contact_list_store_contact_updated_cb: Contact:'Dona' updated, checking roster is in sync...
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.636812: contact_list_store_contact_update: Contact:'Dona' in list:NO, should be:NO
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.636954: empathy_contact_load_avatar_cache: Avatar loaded from /home/yelo3/.cache/telepathy/avatars/butterfly/msn/e99376e99ae0d7cf4e91b85b3763dde49e57e95f
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.636965: contact_list_store_contact_updated_cb: Contact:'Piergiorgio' updated, checking roster is in sync...
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.636989: contact_list_store_contact_update: Contact:'Piergiorgio' in list:YES, should be:YES
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.636992: contact_list_store_contact_update: Set active (contact updated)
>empathy/(null)-DEBUG: 11/05/2010 12:39:25.637763: tp_contact_factory_got_known_avatar_tokens: Got 1 tokens, need to request 0 avatars
>empathy/(null)-DEBUG: 11/05/2010 12:39:25.637904: update_contact_capabilities: Changing capabilities for contact piergiorgio.massari@hotmail.com (25) to 0
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.637914: contact_list_store_contact_updated_cb: Contact:'Piergiorgio' updated, checking roster is in sync...
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.637938: contact_list_store_contact_update: Contact:'Piergiorgio' in list:YES, should be:YES
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.637942: contact_list_store_contact_update: Set active (contact updated)
>empathy/(null)-DEBUG: 11/05/2010 12:39:25.638766: tp_contact_factory_got_known_avatar_tokens: Got 0 tokens, need to request 0 avatars
>empathy/(null)-DEBUG: 11/05/2010 12:39:25.638834: update_contact_capabilities: Changing capabilities for contact sailor__neptune@hotmail.it (26) to 0
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.638845: contact_list_store_contact_updated_cb: Contact:'sailor__neptune@hotmail.it' updated, checking roster is in sync...
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.638869: contact_list_store_contact_update: Contact:'sailor__neptune@hotmail.it' in list:NO, should be:NO
>empathy/(null)-DEBUG: 11/05/2010 12:39:25.638909: tp_contact_factory_got_known_avatar_tokens: Got 0 tokens, need to request 0 avatars
>empathy/(null)-DEBUG: 11/05/2010 12:39:25.638973: update_contact_capabilities: Changing capabilities for contact yelo_3@yahoo.it (27) to 0
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.638983: contact_list_store_contact_updated_cb: Contact:'yelo_3@yahoo.it' updated, checking roster is in sync...
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.639007: contact_list_store_contact_update: Contact:'yelo_3@yahoo.it' in list:NO, should be:NO
>empathy/(null)-DEBUG: 11/05/2010 12:39:25.639046: tp_contact_factory_got_known_avatar_tokens: Got 0 tokens, need to request 0 avatars
>empathy/(null)-DEBUG: 11/05/2010 12:39:25.639108: update_contact_capabilities: Changing capabilities for contact pietrino84@hotmail.it (28) to 0
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.639117: contact_list_store_contact_updated_cb: Contact:'Pietrino' updated, checking roster is in sync...
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.639139: contact_list_store_contact_update: Contact:'Pietrino' in list:NO, should be:NO
>empathy/(null)-DEBUG: 11/05/2010 12:39:25.639213: tp_contact_factory_got_known_avatar_tokens: Got 0 tokens, need to request 0 avatars
>empathy/(null)-DEBUG: 11/05/2010 12:39:25.639278: update_contact_capabilities: Changing capabilities for contact fedux-86@hotmail.it (29) to 0
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.639288: contact_list_store_contact_updated_cb: Contact:'Fedux----Born to Perform!' updated, checking roster is in sync...
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.639312: contact_list_store_contact_update: Contact:'Fedux----Born to Perform!' in list:NO, should be:NO
>empathy/(null)-DEBUG: 11/05/2010 12:39:25.639350: tp_contact_factory_got_known_avatar_tokens: Got 0 tokens, need to request 0 avatars
>empathy/(null)-DEBUG: 11/05/2010 12:39:25.639822: update_contact_capabilities: Changing capabilities for contact celli-the-best-@hotmail.it (30) to 0
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.639834: contact_list_store_contact_updated_cb: Contact:'andrea' updated, checking roster is in sync...
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.639862: contact_list_store_contact_update: Contact:'andrea' in list:NO, should be:NO
>empathy/(null)-DEBUG: 11/05/2010 12:39:25.639934: tp_contact_factory_got_known_avatar_tokens: Got 0 tokens, need to request 0 avatars
>empathy/(null)-DEBUG: 11/05/2010 12:39:25.640000: update_contact_capabilities: Changing capabilities for contact vesperta@hotmail.com (31) to 0
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.640011: contact_list_store_contact_updated_cb: Contact:'(*) vespertine' updated, checking roster is in sync...
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.640033: contact_list_store_contact_update: Contact:'(*) vespertine' in list:NO, should be:NO
>empathy/(null)-DEBUG: 11/05/2010 12:39:25.640070: tp_contact_factory_got_known_avatar_tokens: Got 0 tokens, need to request 0 avatars
>empathy/(null)-DEBUG: 11/05/2010 12:39:25.640134: update_contact_capabilities: Changing capabilities for contact watson86@msn.com (32) to 0
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.640142: contact_list_store_contact_updated_cb: Contact:'The Dreamer' updated, checking roster is in sync...
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.640165: contact_list_store_contact_update: Contact:'The Dreamer' in list:NO, should be:NO
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.640297: empathy_contact_load_avatar_cache: Avatar loaded from /home/yelo3/.cache/telepathy/avatars/butterfly/msn/_39392b53bfa946e7e6e19002119d387bccc8c028b
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.640310: contact_list_store_contact_updated_cb: Contact:'Mattia' updated, checking roster is in sync...
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.640332: contact_list_store_contact_update: Contact:'Mattia' in list:YES, should be:YES
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.640336: contact_list_store_contact_update: Set active (contact updated)
>empathy/(null)-DEBUG: 11/05/2010 12:39:25.640695: tp_contact_factory_got_known_avatar_tokens: Got 1 tokens, need to request 0 avatars
>empathy/(null)-DEBUG: 11/05/2010 12:39:25.640794: update_contact_capabilities: Changing capabilities for contact mattia889@hotmail.com (33) to 0
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.640810: contact_list_store_contact_updated_cb: Contact:'Mattia' updated, checking roster is in sync...
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.640832: contact_list_store_contact_update: Contact:'Mattia' in list:YES, should be:YES
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.640836: contact_list_store_contact_update: Set active (contact updated)
>empathy/(null)-DEBUG: 11/05/2010 12:39:25.641145: tp_contact_factory_got_known_avatar_tokens: Got 0 tokens, need to request 0 avatars
>empathy/(null)-DEBUG: 11/05/2010 12:39:25.641206: update_contact_capabilities: Changing capabilities for contact ci-francy@hotmail.it (34) to 0
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.641216: contact_list_store_contact_updated_cb: Contact:'Francesca' updated, checking roster is in sync...
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.641237: contact_list_store_contact_update: Contact:'Francesca' in list:NO, should be:NO
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.795129: contact_list_store_contact_updated_cb: Contact:'Piergiorgio' updated, checking roster is in sync...
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.795226: contact_list_store_contact_update: Contact:'Piergiorgio' in list:YES, should be:YES
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.795236: contact_list_store_contact_update: Set active (contact updated)
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.801867: contact_list_store_contact_updated_cb: Contact:'Piergiorgio' updated, checking roster is in sync...
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.801950: contact_list_store_contact_update: Contact:'Piergiorgio' in list:YES, should be:YES
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.801960: contact_list_store_contact_update: Set active (contact updated)
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.803908: contact_list_store_contact_updated_cb: Contact:'Piergiorgio' updated, checking roster is in sync...
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.803936: contact_list_store_contact_update: Contact:'Piergiorgio' in list:YES, should be:YES
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.803940: contact_list_store_contact_update: Set active (contact updated)
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.804781: contact_list_store_contact_updated_cb: Contact:'Piergiorgio' updated, checking roster is in sync...
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.804805: contact_list_store_contact_update: Contact:'Piergiorgio' in list:YES, should be:YES
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.804810: contact_list_store_contact_update: Set active (contact updated)
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.805551: contact_list_store_contact_updated_cb: Contact:'Piergiorgio' updated, checking roster is in sync...
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.805573: contact_list_store_contact_update: Contact:'Piergiorgio' in list:YES, should be:YES
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.805577: contact_list_store_contact_update: Set active (contact updated)
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.958153: contact_list_store_contact_updated_cb: Contact:'Jonathan' updated, checking roster is in sync...
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.958250: contact_list_store_contact_update: Contact:'Jonathan' in list:YES, should be:YES
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.958260: contact_list_store_contact_update: Set active (contact updated)
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.959748: contact_list_store_contact_updated_cb: Contact:'Jonathan' updated, checking roster is in sync...
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.959817: contact_list_store_contact_update: Contact:'Jonathan' in list:YES, should be:YES
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.959826: contact_list_store_contact_update: Set active (contact updated)
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.969266: contact_list_store_contact_updated_cb: Contact:'Chievo!' updated, checking roster is in sync...
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.969362: contact_list_store_contact_update: Contact:'Chievo!' in list:YES, should be:YES
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.969372: contact_list_store_contact_update: Set active (contact updated)
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.969547: contact_list_store_contact_updated_cb: Contact:'Chievo!' updated, checking roster is in sync...
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.969609: contact_list_store_contact_update: Contact:'Chievo!' in list:YES, should be:YES
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.969749: contact_list_store_contact_update: Set active (contact updated)
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.972592: contact_list_store_contact_updated_cb: Contact:'Mattia' updated, checking roster is in sync...
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.972670: contact_list_store_contact_update: Contact:'Mattia' in list:YES, should be:YES
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.972680: contact_list_store_contact_update: Set active (contact updated)
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.974067: contact_list_store_contact_updated_cb: Contact:'Mattia' updated, checking roster is in sync...
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.974096: contact_list_store_contact_update: Contact:'Mattia' in list:YES, should be:YES
>empathy/Contact-DEBUG: 11/05/2010 12:39:25.974101: contact_list_store_contact_update: Set active (contact updated)
>empathy/Contact-DEBUG: 11/05/2010 12:39:33.180092: contact_list_store_contact_active_cb: Contact:'Chievo!' no longer active
>empathy/Contact-DEBUG: 11/05/2010 12:39:33.180284: contact_list_store_contact_set_active: Set item inactive
>empathy/Contact-DEBUG: 11/05/2010 12:39:33.180306: contact_list_store_contact_active_cb: Contact:'Jonathan' no longer active
>empathy/Contact-DEBUG: 11/05/2010 12:39:33.180392: contact_list_store_contact_set_active: Set item inactive
>empathy/Contact-DEBUG: 11/05/2010 12:39:33.180409: contact_list_store_contact_active_cb: Contact:'Piergiorgio' no longer active
>empathy/Contact-DEBUG: 11/05/2010 12:39:33.180490: contact_list_store_contact_set_active: Set item inactive
>empathy/Contact-DEBUG: 11/05/2010 12:39:33.180507: contact_list_store_contact_active_cb: Contact:'Mattia' no longer active
>empathy/Contact-DEBUG: 11/05/2010 12:39:33.180587: contact_list_store_contact_set_active: Set item inactive
>empathy/Dispatcher-DEBUG: 11/05/2010 12:39:36.951230: status_icon_activate_cb: toggle
>empathy/Other-DEBUG: 11/05/2010 12:39:36.951242: empathy_conf_set_bool: Setting bool:'/apps/empathy/ui/main_window_hidden' to 0 ---> false
>empathy/Other-DEBUG: 11/05/2010 12:39:37.355369: builder_get_file_valist: Loading file /usr/share/empathy/empathy-contact-widget.ui
>empathy/(null)-DEBUG: 11/05/2010 12:40:46.215276: update_contact_capabilities: Changing capabilities for contact 84yelo3@gmail.com (414) to 0
>empathy/Contact-DEBUG: 11/05/2010 12:40:46.216470: contact_list_store_contact_updated_cb: Contact:'NicolÃ² Chieffo' updated, checking roster is in sync...
>empathy/Contact-DEBUG: 11/05/2010 12:40:46.216563: contact_list_store_contact_update: Contact:'NicolÃ² Chieffo' in list:YES, should be:NO
>empathy/Contact-DEBUG: 11/05/2010 12:40:46.216569: contact_list_store_contact_update: Remove item (after timeout)
>empathy/Contact-DEBUG: 11/05/2010 12:40:46.220063: contact_list_store_contact_set_active: Set item active
>empathy/Contact-DEBUG: 11/05/2010 12:40:46.220086: contact_list_store_contact_active_new: Contact:'NicolÃ² Chieffo' now active, and WILL be removed
>empathy/Contact-DEBUG: 11/05/2010 12:40:46.220295: contact_list_store_contact_updated_cb: Contact:'NicolÃ² Chieffo' updated, checking roster is in sync...
>empathy/Contact-DEBUG: 11/05/2010 12:40:46.220360: contact_list_store_contact_update: Contact:'NicolÃ² Chieffo' in list:YES, should be:NO
>empathy/Contact-DEBUG: 11/05/2010 12:40:46.220366: contact_list_store_contact_update: Remove item (after timeout)
>empathy/Contact-DEBUG: 11/05/2010 12:40:46.220489: contact_list_store_contact_set_active: Set item active
>empathy/Contact-DEBUG: 11/05/2010 12:40:46.220506: contact_list_store_contact_active_new: Contact:'NicolÃ² Chieffo' now active, and WILL be removed
>empathy/Contact-DEBUG: 11/05/2010 12:40:53.181014: contact_list_store_contact_active_cb: Contact:'NicolÃ² Chieffo' active timeout, removing item
>empathy/Contact-DEBUG: 11/05/2010 12:40:53.181247: contact_list_store_contact_active_cb: Contact:'NicolÃ² Chieffo' no longer active
>empathy/Contact-DEBUG: 11/05/2010 12:40:53.181314: contact_list_store_contact_active_cb: Contact:'NicolÃ² Chieffo' active timeout, removing item
>empathy/Contact-DEBUG: 11/05/2010 12:40:53.181370: contact_list_store_contact_active_cb: Contact:'NicolÃ² Chieffo' no longer active
>empathy/Contact-DEBUG: 11/05/2010 12:41:36.19166: contact_list_store_contact_updated_cb: Contact:'Mattia' updated, checking roster is in sync...
>empathy/Contact-DEBUG: 11/05/2010 12:41:36.19262: contact_list_store_contact_update: Contact:'Mattia' in list:YES, should be:YES
>empathy/Contact-DEBUG: 11/05/2010 12:41:36.19273: contact_list_store_contact_update: Set active (contact updated)
>empathy/Contact-DEBUG: 11/05/2010 12:41:36.24425: contact_list_store_contact_updated_cb: Contact:'Mattia' updated, checking roster is in sync...
>empathy/Contact-DEBUG: 11/05/2010 12:41:36.24497: contact_list_store_contact_update: Contact:'Mattia' in list:YES, should be:YES
>empathy/Contact-DEBUG: 11/05/2010 12:41:36.24506: contact_list_store_contact_update: Set active (contact updated)
>empathy/Contact-DEBUG: 11/05/2010 12:41:47.173285: contact_list_store_contact_updated_cb: Contact:'NicolÃ² Chieffo' updated, checking roster is in sync...
>empathy/Contact-DEBUG: 11/05/2010 12:41:47.173376: contact_list_store_contact_update: Contact:'NicolÃ² Chieffo' in list:NO, should be:YES
>empathy/Contact-DEBUG: 11/05/2010 12:41:47.173686: contact_list_store_contact_update: Contact:'NicolÃ² Chieffo' in list:YES, should be:YES
>empathy/Contact-DEBUG: 11/05/2010 12:41:47.173697: contact_list_store_contact_update: Set active (contact updated offline -> online)
>empathy/Contact-DEBUG: 11/05/2010 12:41:47.173851: contact_list_store_contact_set_active: Set item active
>empathy/Contact-DEBUG: 11/05/2010 12:41:47.173870: contact_list_store_contact_active_new: Contact:'NicolÃ² Chieffo' now active, and WILL NOT be removed
>empathy/Contact-DEBUG: 11/05/2010 12:41:47.173882: contact_list_store_contact_update: Set active (contact added)
>empathy/Contact-DEBUG: 11/05/2010 12:41:47.173974: contact_list_store_contact_set_active: Set item active
>empathy/Contact-DEBUG: 11/05/2010 12:41:47.173983: contact_list_store_contact_active_new: Contact:'NicolÃ² Chieffo' now active, and WILL NOT be removed
>empathy/Contact-DEBUG: 11/05/2010 12:41:47.174197: contact_list_store_contact_updated_cb: Contact:'NicolÃ² Chieffo' updated, checking roster is in sync...
>empathy/Contact-DEBUG: 11/05/2010 12:41:47.174263: contact_list_store_contact_update: Contact:'NicolÃ² Chieffo' in list:YES, should be:YES
>empathy/Contact-DEBUG: 11/05/2010 12:41:47.174273: contact_list_store_contact_update: Set active (contact updated)
>empathy/Contact-DEBUG: 11/05/2010 12:41:47.174813: empathy_contact_load_avatar_cache: Avatar loaded from /home/yelo3/.cache/telepathy/avatars/gabble/jabber/c48e24322e063832ae97754e70ff2737b23897bf
>empathy/Contact-DEBUG: 11/05/2010 12:41:47.174844: contact_list_store_contact_updated_cb: Contact:'NicolÃ² Chieffo' updated, checking roster is in sync...
>empathy/Contact-DEBUG: 11/05/2010 12:41:47.174910: contact_list_store_contact_update: Contact:'NicolÃ² Chieffo' in list:YES, should be:YES
>empathy/Contact-DEBUG: 11/05/2010 12:41:47.174920: contact_list_store_contact_update: Set active (contact updated)
>empathy/(null)-DEBUG: 11/05/2010 12:41:47.179600: update_contact_capabilities: Changing capabilities for contact 84yelo3@gmail.com (414) to 0
>empathy/Contact-DEBUG: 11/05/2010 12:41:54.180803: contact_list_store_contact_active_cb: Contact:'NicolÃ² Chieffo' no longer active
>empathy/Contact-DEBUG: 11/05/2010 12:41:54.180996: contact_list_store_contact_set_active: Set item inactive
>empathy/Contact-DEBUG: 11/05/2010 12:41:54.181020: contact_list_store_contact_active_cb: Contact:'NicolÃ² Chieffo' no longer active
>empathy/Contact-DEBUG: 11/05/2010 12:41:54.181113: contact_list_store_contact_set_active: Set item inactive
>empathy/(null)-DEBUG: 11/05/2010 12:41:59.147789: update_contact_capabilities: Changing capabilities for contact 84yelo3@gmail.com (414) to 0
>empathy/Contact-DEBUG: 11/05/2010 12:41:59.148078: contact_list_store_contact_updated_cb: Contact:'NicolÃ² Chieffo' updated, checking roster is in sync...
>empathy/Contact-DEBUG: 11/05/2010 12:41:59.148170: contact_list_store_contact_update: Contact:'NicolÃ² Chieffo' in list:YES, should be:NO
>empathy/Contact-DEBUG: 11/05/2010 12:41:59.148178: contact_list_store_contact_update: Remove item (after timeout)
>empathy/Contact-DEBUG: 11/05/2010 12:41:59.150352: contact_list_store_contact_set_active: Set item active
>empathy/Contact-DEBUG: 11/05/2010 12:41:59.150372: contact_list_store_contact_active_new: Contact:'NicolÃ² Chieffo' now active, and WILL be removed
>empathy/Contact-DEBUG: 11/05/2010 12:41:59.150583: contact_list_store_contact_updated_cb: Contact:'NicolÃ² Chieffo' updated, checking roster is in sync...
>empathy/Contact-DEBUG: 11/05/2010 12:41:59.150646: contact_list_store_contact_update: Contact:'NicolÃ² Chieffo' in list:YES, should be:NO
>empathy/Contact-DEBUG: 11/05/2010 12:41:59.150652: contact_list_store_contact_update: Remove item (after timeout)
>empathy/Contact-DEBUG: 11/05/2010 12:41:59.152236: contact_list_store_contact_set_active: Set item active
>empathy/Contact-DEBUG: 11/05/2010 12:41:59.152255: contact_list_store_contact_active_new: Contact:'NicolÃ² Chieffo' now active, and WILL be removed
>empathy/Contact-DEBUG: 11/05/2010 12:42:06.178607: contact_list_store_contact_active_cb: Contact:'NicolÃ² Chieffo' active timeout, removing item
>empathy/Contact-DEBUG: 11/05/2010 12:42:06.178822: contact_list_store_contact_active_cb: Contact:'NicolÃ² Chieffo' no longer active
>empathy/Contact-DEBUG: 11/05/2010 12:42:06.178884: contact_list_store_contact_active_cb: Contact:'NicolÃ² Chieffo' active timeout, removing item
>empathy/Contact-DEBUG: 11/05/2010 12:42:06.178937: contact_list_store_contact_active_cb: Contact:'NicolÃ² Chieffo' no longer active
>empathy/Contact-DEBUG: 11/05/2010 12:42:11.444102: contact_list_store_contact_updated_cb: Contact:'NicolÃ² Chieffo' updated, checking roster is in sync...
>empathy/Contact-DEBUG: 11/05/2010 12:42:11.444190: contact_list_store_contact_update: Contact:'NicolÃ² Chieffo' in list:NO, should be:YES
>empathy/Contact-DEBUG: 11/05/2010 12:42:11.444499: contact_list_store_contact_update: Contact:'NicolÃ² Chieffo' in list:YES, should be:YES
>empathy/Contact-DEBUG: 11/05/2010 12:42:11.444511: contact_list_store_contact_update: Set active (contact updated offline -> online)
>empathy/Contact-DEBUG: 11/05/2010 12:42:11.446214: contact_list_store_contact_set_active: Set item active
>empathy/Contact-DEBUG: 11/05/2010 12:42:11.446234: contact_list_store_contact_active_new: Contact:'NicolÃ² Chieffo' now active, and WILL NOT be removed
>empathy/Contact-DEBUG: 11/05/2010 12:42:11.446247: contact_list_store_contact_update: Set active (contact added)
>empathy/Contact-DEBUG: 11/05/2010 12:42:11.447788: contact_list_store_contact_set_active: Set item active
>empathy/Contact-DEBUG: 11/05/2010 12:42:11.447797: contact_list_store_contact_active_new: Contact:'NicolÃ² Chieffo' now active, and WILL NOT be removed
>empathy/Contact-DEBUG: 11/05/2010 12:42:11.448009: contact_list_store_contact_updated_cb: Contact:'NicolÃ² Chieffo' updated, checking roster is in sync...
>empathy/Contact-DEBUG: 11/05/2010 12:42:11.448379: contact_list_store_contact_update: Contact:'NicolÃ² Chieffo' in list:YES, should be:YES
>empathy/Contact-DEBUG: 11/05/2010 12:42:11.448390: contact_list_store_contact_update: Set active (contact updated)
>empathy/(null)-DEBUG: 11/05/2010 12:42:11.450731: update_contact_capabilities: Changing capabilities for contact 84yelo3@gmail.com (414) to 0
>empathy/(null)-DEBUG: 11/05/2010 12:42:11.733637: update_contact_capabilities: Changing capabilities for contact 84yelo3@gmail.com (414) to 0
>empathy/(null)-DEBUG: 11/05/2010 12:42:12.19105: update_contact_capabilities: Changing capabilities for contact 84yelo3@gmail.com (414) to 1
>empathy/Contact-DEBUG: 11/05/2010 12:42:12.19124: contact_list_store_contact_updated_cb: Contact:'NicolÃ² Chieffo' updated, checking roster is in sync...
>empathy/Contact-DEBUG: 11/05/2010 12:42:12.19165: contact_list_store_contact_update: Contact:'NicolÃ² Chieffo' in list:YES, should be:YES
>empathy/Contact-DEBUG: 11/05/2010 12:42:12.19170: contact_list_store_contact_update: Set active (contact updated)
>empathy/(null)-DEBUG: 11/05/2010 12:42:12.121084: update_contact_capabilities: Changing capabilities for contact 84yelo3@gmail.com (414) to 3
>empathy/Contact-DEBUG: 11/05/2010 12:42:12.121124: contact_list_store_contact_updated_cb: Contact:'NicolÃ² Chieffo' updated, checking roster is in sync...
>empathy/Contact-DEBUG: 11/05/2010 12:42:12.121218: contact_list_store_contact_update: Contact:'NicolÃ² Chieffo' in list:YES, should be:YES
>empathy/Contact-DEBUG: 11/05/2010 12:42:12.121229: contact_list_store_contact_update: Set active (contact updated)
>empathy/(null)-DEBUG: 11/05/2010 12:42:12.123337: update_contact_capabilities: Changing capabilities for contact 84yelo3@gmail.com (414) to 3
>empathy/Contact-DEBUG: 11/05/2010 12:42:19.177232: contact_list_store_contact_active_cb: Contact:'NicolÃ² Chieffo' no longer active
>empathy/Contact-DEBUG: 11/05/2010 12:42:19.177416: contact_list_store_contact_set_active: Set item inactive
>empathy/Contact-DEBUG: 11/05/2010 12:42:19.177439: contact_list_store_contact_active_cb: Contact:'NicolÃ² Chieffo' no longer active
>empathy/Contact-DEBUG: 11/05/2010 12:42:19.177532: contact_list_store_contact_set_active: Set item inactive
>empathy/Other-DEBUG: 11/05/2010 12:42:20.503185: builder_get_file_valist: Loading file /usr/share/empathy/empathy-call-window.ui
>empathy/Other-DEBUG: 11/05/2010 12:42:20.652031: empathy_signal_connect_weak: connecting to 0x2c8bc40:peak-level-changed with context 0x2f1f520
>empathy/Other-DEBUG: 11/05/2010 12:42:20.659531: builder_get_file_valist: Loading file /usr/share/empathy/empathy-call-window-fullscreen.ui
>empathy/Other-DEBUG: 11/05/2010 12:42:20.661639: empathy_sound_play_internal: Play sound "phone-outgoing-calling" (Outgoing voice call)
>empathy/Voip-DEBUG: 11/05/2010 12:42:20.678958: enable_camera: Enable camera
>empathy/Voip-DEBUG: 11/05/2010 12:42:20.678963: display_video_preview: Show video preview
>empathy/Voip-DEBUG: 11/05/2010 12:42:20.678967: empathy_call_window_setup_video_preview: Create video preview
>empathy/(null)-DEBUG: 11/05/2010 12:42:21.32756: tp_contact_factory_add_contact: Contact added: nicolo.chieffo@gmail.com (1)
>empathy/(null)-DEBUG: 11/05/2010 12:42:21.44500: tp_contact_factory_weak_notify: Remove finalized contact 0x7fb690001720
>empathy/Contact-DEBUG: 11/05/2010 12:42:21.44523: contact_finalize: finalize: 0x7fb690001720
>empathy/(null)-DEBUG: 11/05/2010 12:42:21.45452: tp_contact_factory_got_known_avatar_tokens: Got 1 tokens, need to request 0 avatars
>empathy/Dispatcher-DEBUG: 11/05/2010 12:42:21.49936: dispatcher_connection_new_channel: outgoing channel of type org.freedesktop.Telepathy.Channel.Type.StreamedMedia on /org/freedesktop/Telepathy/Connection/gabble/jabber/nicolo_2echieffo_40gmail_2ecom_2fb6df5ac1/MediaChannel0
>empathy/Dispatcher-DEBUG: 11/05/2010 12:42:21.50415: dispatcher_connection_new_channel: Channel satified request /com/nokia/MissionControl/requests/r6(already dispatched: 0)
>empathy/Dispatcher-DEBUG: 11/05/2010 12:42:21.50420: dispatcher_start_dispatching: Dispatching process started for /org/freedesktop/Telepathy/Connection/gabble/jabber/nicolo_2echieffo_40gmail_2ecom_2fb6df5ac1/MediaChannel0
>empathy/Dispatcher-DEBUG: 11/05/2010 12:42:21.51748: dispatcher_channel_request_succeeded_cb: Request succeeded: /com/nokia/MissionControl/requests/r6
>empathy/Dispatcher-DEBUG: 11/05/2010 12:42:21.96404: empathy_dispatch_operation_set_status: Dispatch operation /org/freedesktop/Telepathy/Connection/gabble/jabber/nicolo_2echieffo_40gmail_2ecom_2fb6df5ac1/MediaChannel0 status: 0 -> 1
>empathy/Dispatcher-DEBUG: 11/05/2010 12:42:21.96426: dispatch_operation_ready_cb: Send to observers: /org/freedesktop/Telepathy/Connection/gabble/jabber/nicolo_2echieffo_40gmail_2ecom_2fb6df5ac1/MediaChannel0
>empathy/Dispatcher-DEBUG: 11/05/2010 12:42:21.96440: empathy_dispatch_operation_set_status: Dispatch operation /org/freedesktop/Telepathy/Connection/gabble/jabber/nicolo_2echieffo_40gmail_2ecom_2fb6df5ac1/MediaChannel0 status: 1 -> 3
>empathy/Other-DEBUG: 11/05/2010 12:42:21.96462: empathy_signal_connect_weak: connecting to 0x2fc55e0:audio-stream-error with context 0x3016800
>empathy/Other-DEBUG: 11/05/2010 12:42:21.96472: empathy_signal_connect_weak: connecting to 0x2fc55e0:video-stream-error with context 0x3016600
>empathy/Voip-DEBUG: 11/05/2010 12:42:21.96681: tp_call_request_streams_for_capabilities: Requesting new stream for capabilities 3
>empathy/Dispatcher-DEBUG: 11/05/2010 12:42:21.96779: empathy_dispatch_operation_set_status: Dispatch operation /org/freedesktop/Telepathy/Connection/gabble/jabber/nicolo_2echieffo_40gmail_2ecom_2fb6df5ac1/MediaChannel0 status: 3 -> 4
>empathy/Dispatcher-DEBUG: 11/05/2010 12:42:21.96796: dispatch_operation_claimed_cb: Channel claimed: /org/freedesktop/Telepathy/Connection/gabble/jabber/nicolo_2echieffo_40gmail_2ecom_2fb6df5ac1/MediaChannel0
>tp-fs-DEBUG: 11/05/2010 12:42:21.99890: GetSessionHandlers replied: 
>tp-fs-DEBUG: 11/05/2010 12:42:21.99956:   - session /org/freedesktop/Telepathy/Connection/gabble/jabber/nicolo_2echieffo_40gmail_2ecom_2fb6df5ac1/MediaChannel0
>tp-fs-DEBUG: 11/05/2010 12:42:21.99997:     type rtp
>tp-fs-DEBUG: 11/05/2010 12:42:21.100020: adding session handler /org/freedesktop/Telepathy/Connection/gabble/jabber/nicolo_2echieffo_40gmail_2ecom_2fb6df5ac1/MediaChannel0, type rtp
>tp-fs-DEBUG: 11/05/2010 12:42:21.103199: calling MediaSessionHandler::Ready
>empathy/Voip-DEBUG: 11/05/2010 12:42:21.404755: tp_call_stream_added_cb: Stream added - stream id: 1, contact handle: 414, stream type: 0
>empathy/Voip-DEBUG: 11/05/2010 12:42:21.404762: tp_call_add_stream: Audio stream - id: 1, state: 0, direction: 0
>empathy/Voip-DEBUG: 11/05/2010 12:42:21.404808: tp_call_stream_direction_changed_cb: Stream direction changed - stream: 1, direction: 3
>tp-fs-DEBUG: 11/05/2010 12:42:21.404911: New stream, stream_id=1, media_type=0, direction=3
>tp-fs-DEBUG: 11/05/2010 12:42:21.421530: stream 1 0x2e60220 (audio) get_all_properties_cb: Adding STUN server 209.85.137.126:19302
>tp-fs-DEBUG: 11/05/2010 12:42:21.421684: stream 1 0x2e60220 (audio) get_all_properties_cb: Adding relay (udp) 209.85.229.126:19295 dIZfoHcpoi10TpnF:IIjIfcXnBo1uLeg0 1
>tp-fs-DEBUG: 11/05/2010 12:42:21.421737: stream 1 0x2e60220 (audio) get_all_properties_cb: Adding relay (tcp) 209.85.229.126:19294 dIZfoHcpoi10TpnF:IIjIfcXnBo1uLeg0 1
>tp-fs-DEBUG: 11/05/2010 12:42:21.421775: stream 1 0x2e60220 (audio) get_all_properties_cb: Adding relay (tls) 209.85.229.126:443 dIZfoHcpoi10TpnF:IIjIfcXnBo1uLeg0 1
>tp-fs-DEBUG: 11/05/2010 12:42:21.421809: stream 1 0x2e60220 (audio) get_all_properties_cb: Adding relay (udp) 209.85.137.126:19295 uHGZfub1lXiFVzme:xhSUe7VnygPLGJC7 2
>tp-fs-DEBUG: 11/05/2010 12:42:21.421845: stream 1 0x2e60220 (audio) get_all_properties_cb: Adding relay (tcp) 209.85.137.126:19294 uHGZfub1lXiFVzme:xhSUe7VnygPLGJC7 2
>tp-fs-DEBUG: 11/05/2010 12:42:21.421880: stream 1 0x2e60220 (audio) get_all_properties_cb: Adding relay (tls) 209.85.137.126:443 uHGZfub1lXiFVzme:xhSUe7VnygPLGJC7 2
>tp-fs-DEBUG: 11/05/2010 12:42:21.609848: stream 1 0x2e60220 (audio) _tf_stream_try_sending_codecs: called (send_local:1 send_supported:0)
>tp-fs-DEBUG: 11/05/2010 12:42:21.609905: stream 1 0x2e60220 (audio) _tf_stream_try_sending_codecs: 103: audio SPEEX clock:8000 channels:1
>tp-fs-DEBUG: 11/05/2010 12:42:21.609920: stream 1 0x2e60220 (audio) _tf_stream_try_sending_codecs: 104: audio SPEEX clock:16000 channels:1
>tp-fs-DEBUG: 11/05/2010 12:42:21.609935: stream 1 0x2e60220 (audio) _tf_stream_try_sending_codecs: 98: audio AMR clock:8000 channels:1
>tp-fs-DEBUG: 11/05/2010 12:42:21.609963: stream 1 0x2e60220 (audio) _tf_stream_try_sending_codecs: 96: audio SIREN clock:16000 channels:0 bitrate=16000
>tp-fs-DEBUG: 11/05/2010 12:42:21.609977: stream 1 0x2e60220 (audio) _tf_stream_try_sending_codecs: 0: audio PCMU clock:8000 channels:0
>tp-fs-DEBUG: 11/05/2010 12:42:21.609992: stream 1 0x2e60220 (audio) _tf_stream_try_sending_codecs: 8: audio PCMA clock:8000 channels:0
>tp-fs-DEBUG: 11/05/2010 12:42:21.610007: stream 1 0x2e60220 (audio) _tf_stream_try_sending_codecs: 3: audio GSM clock:8000 channels:0
>tp-fs-DEBUG: 11/05/2010 12:42:21.610023: stream 1 0x2e60220 (audio) _tf_stream_try_sending_codecs: 100: audio telephone-event clock:16000 channels:0 events=0-15
>tp-fs-DEBUG: 11/05/2010 12:42:21.610038: stream 1 0x2e60220 (audio) _tf_stream_try_sending_codecs: 101: audio telephone-event clock:8000 channels:0 events=0-15
>tp-fs-DEBUG: 11/05/2010 12:42:21.610146: stream 1 0x2e60220 (audio) fs_codecs_to_tp: adding codec SPEEX [103]
>tp-fs-DEBUG: 11/05/2010 12:42:21.610177: stream 1 0x2e60220 (audio) fs_codecs_to_tp: adding codec SPEEX [104]
>tp-fs-DEBUG: 11/05/2010 12:42:21.610205: stream 1 0x2e60220 (audio) fs_codecs_to_tp: adding codec AMR [98]
>tp-fs-DEBUG: 11/05/2010 12:42:21.610244: stream 1 0x2e60220 (audio) fs_codecs_to_tp: adding codec SIREN [96]
>tp-fs-DEBUG: 11/05/2010 12:42:21.610272: stream 1 0x2e60220 (audio) fs_codecs_to_tp: adding codec PCMU [0]
>tp-fs-DEBUG: 11/05/2010 12:42:21.610301: stream 1 0x2e60220 (audio) fs_codecs_to_tp: adding codec PCMA [8]
>tp-fs-DEBUG: 11/05/2010 12:42:21.610330: stream 1 0x2e60220 (audio) fs_codecs_to_tp: adding codec GSM [3]
>tp-fs-DEBUG: 11/05/2010 12:42:21.610371: stream 1 0x2e60220 (audio) fs_codecs_to_tp: adding codec telephone-event [100]
>tp-fs-DEBUG: 11/05/2010 12:42:21.610402: stream 1 0x2e60220 (audio) fs_codecs_to_tp: adding codec telephone-event [101]
>tp-fs-DEBUG: 11/05/2010 12:42:21.610415: stream 1 0x2e60220 (audio) _tf_stream_try_sending_codecs: calling MediaStreamHandler::Ready
>empathy/Voip-DEBUG: 11/05/2010 12:42:21.612487: tp_call_add_stream: Audio stream - id: 1, state: 0, direction: 3
>empathy/Voip-DEBUG: 11/05/2010 12:42:21.612498: tp_call_add_stream: Video stream - id: 2, state: 0, direction: 3
>empathy/Voip-DEBUG: 11/05/2010 12:42:21.612560: tp_call_stream_added_cb: Stream added - stream id: 2, contact handle: 414, stream type: 1
>empathy/Voip-DEBUG: 11/05/2010 12:42:21.612564: tp_call_add_stream: Video stream - id: 2, state: 0, direction: 0
>empathy/Voip-DEBUG: 11/05/2010 12:42:21.612610: tp_call_stream_direction_changed_cb: Stream direction changed - stream: 2, direction: 3
>tp-fs-DEBUG: 11/05/2010 12:42:21.612695: New stream, stream_id=2, media_type=1, direction=3
>tp-fs-DEBUG: 11/05/2010 12:42:21.617907: stream 1 0x2e60220 (audio) set_stream_playing: 0
>tp-fs-DEBUG: 11/05/2010 12:42:21.618017: stream 1 0x2e60220 (audio) set_stream_sending: 0
>tp-fs-DEBUG: 11/05/2010 12:42:21.620171: stream 2 0x2e60310 (video) get_all_properties_cb: Adding STUN server 209.85.137.126:19302
>tp-fs-DEBUG: 11/05/2010 12:42:21.620208: stream 2 0x2e60310 (video) get_all_properties_cb: Adding relay (udp) 209.85.229.126:19295 O38Dto1H8A2QGzHN:z4hziveN0fkPeqtQ 1
>tp-fs-DEBUG: 11/05/2010 12:42:21.620235: stream 2 0x2e60310 (video) get_all_properties_cb: Adding relay (tcp) 209.85.229.126:19294 O38Dto1H8A2QGzHN:z4hziveN0fkPeqtQ 1
>tp-fs-DEBUG: 11/05/2010 12:42:21.620260: stream 2 0x2e60310 (video) get_all_properties_cb: Adding relay (tls) 209.85.229.126:443 O38Dto1H8A2QGzHN:z4hziveN0fkPeqtQ 1
>tp-fs-DEBUG: 11/05/2010 12:42:21.620284: stream 2 0x2e60310 (video) get_all_properties_cb: Adding relay (udp) 209.85.229.126:19295 cfcUjWcUgxV9IK1z:pryxhhxnpJUBD9GC 2
>tp-fs-DEBUG: 11/05/2010 12:42:21.620307: stream 2 0x2e60310 (video) get_all_properties_cb: Adding relay (tcp) 209.85.229.126:19294 cfcUjWcUgxV9IK1z:pryxhhxnpJUBD9GC 2
>tp-fs-DEBUG: 11/05/2010 12:42:21.620332: stream 2 0x2e60310 (video) get_all_properties_cb: Adding relay (tls) 209.85.229.126:443 cfcUjWcUgxV9IK1z:pryxhhxnpJUBD9GC 2
>tp-fs-DEBUG: 11/05/2010 12:42:21.647440: stream 2 0x2e60310 (video) _tf_stream_try_sending_codecs: called (send_local:1 send_supported:0)
>tp-fs-DEBUG: 11/05/2010 12:42:21.647480: stream 2 0x2e60310 (video) _tf_stream_try_sending_codecs: 98: video H264 clock:90000 channels:0
>tp-fs-DEBUG: 11/05/2010 12:42:21.647497: stream 2 0x2e60310 (video) _tf_stream_try_sending_codecs: 34: video H263 clock:90000 channels:0
>tp-fs-DEBUG: 11/05/2010 12:42:21.647512: stream 2 0x2e60310 (video) _tf_stream_try_sending_codecs: 96: video THEORA clock:90000 channels:0
>tp-fs-DEBUG: 11/05/2010 12:42:21.647527: stream 2 0x2e60310 (video) _tf_stream_try_sending_codecs: 97: video JPEG2000 clock:90000 channels:0
>tp-fs-DEBUG: 11/05/2010 12:42:21.647542: stream 2 0x2e60310 (video) _tf_stream_try_sending_codecs: 99: video H263-1998 clock:90000 channels:0
>tp-fs-DEBUG: 11/05/2010 12:42:21.647581: stream 2 0x2e60310 (video) fs_codecs_to_tp: adding codec H264 [98]
>tp-fs-DEBUG: 11/05/2010 12:42:21.647609: stream 2 0x2e60310 (video) fs_codecs_to_tp: adding codec H263 [34]
>tp-fs-DEBUG: 11/05/2010 12:42:21.647638: stream 2 0x2e60310 (video) fs_codecs_to_tp: adding codec THEORA [96]
>tp-fs-DEBUG: 11/05/2010 12:42:21.647666: stream 2 0x2e60310 (video) fs_codecs_to_tp: adding codec JPEG2000 [97]
>tp-fs-DEBUG: 11/05/2010 12:42:21.647695: stream 2 0x2e60310 (video) fs_codecs_to_tp: adding codec H263-1998 [99]
>tp-fs-DEBUG: 11/05/2010 12:42:21.647707: stream 2 0x2e60310 (video) _tf_stream_try_sending_codecs: calling MediaStreamHandler::Ready
>tp-fs-DEBUG: 11/05/2010 12:42:21.648802: stream 2 0x2e60310 (video) set_stream_playing: 0
>tp-fs-DEBUG: 11/05/2010 12:42:21.648860: stream 2 0x2e60310 (video) set_stream_sending: 0
>tp-fs-DEBUG: 11/05/2010 12:42:21.649468: stream 1 0x2e60220 (audio) cb_fs_new_local_candidate: called
>tp-fs-DEBUG: 11/05/2010 12:42:21.649514: stream 1 0x2e60220 (audio) cb_fs_new_local_candidate: called
>tp-fs-DEBUG: 11/05/2010 12:42:21.649786: stream 1 0x2e60220 (audio) _tf_stream_bus_message: Codecs changed
>tp-fs-DEBUG: 11/05/2010 12:42:21.649801: stream 1 0x2e60220 (audio) _tf_stream_try_sending_codecs: called (send_local:0 send_supported:0)
>tp-fs-DEBUG: 11/05/2010 12:42:21.649976: stream 1 0x2e60220 (audio) _tf_stream_try_sending_codecs: 103: audio SPEEX clock:8000 channels:1
>tp-fs-DEBUG: 11/05/2010 12:42:21.649991: stream 1 0x2e60220 (audio) _tf_stream_try_sending_codecs: 104: audio SPEEX clock:16000 channels:1
>tp-fs-DEBUG: 11/05/2010 12:42:21.650007: stream 1 0x2e60220 (audio) _tf_stream_try_sending_codecs: 98: audio AMR clock:8000 channels:1
>tp-fs-DEBUG: 11/05/2010 12:42:21.650024: stream 1 0x2e60220 (audio) _tf_stream_try_sending_codecs: 96: audio SIREN clock:16000 channels:0 bitrate=16000
>tp-fs-DEBUG: 11/05/2010 12:42:21.650038: stream 1 0x2e60220 (audio) _tf_stream_try_sending_codecs: 0: audio PCMU clock:8000 channels:0
>tp-fs-DEBUG: 11/05/2010 12:42:21.650053: stream 1 0x2e60220 (audio) _tf_stream_try_sending_codecs: 8: audio PCMA clock:8000 channels:0
>tp-fs-DEBUG: 11/05/2010 12:42:21.650068: stream 1 0x2e60220 (audio) _tf_stream_try_sending_codecs: 3: audio GSM clock:8000 channels:0
>tp-fs-DEBUG: 11/05/2010 12:42:21.650085: stream 1 0x2e60220 (audio) _tf_stream_try_sending_codecs: 100: audio telephone-event clock:16000 channels:0 events=0-15
>tp-fs-DEBUG: 11/05/2010 12:42:21.650114: stream 1 0x2e60220 (audio) _tf_stream_try_sending_codecs: 101: audio telephone-event clock:8000 channels:0 events=0-15
>empathy/Voip-DEBUG: 11/05/2010 12:42:21.650227: tp_call_stream_state_changed_cb: Stream state changed - stream id: 1, state state: 1
>tp-fs-DEBUG: 11/05/2010 12:42:21.650341: stream 1 0x2e60220 (audio) cb_fs_new_local_candidate: called
>tp-fs-DEBUG: 11/05/2010 12:42:21.650377: stream 1 0x2e60220 (audio) cb_fs_new_local_candidate: called
>tp-fs-DEBUG: 11/05/2010 12:42:21.650408: stream 1 0x2e60220 (audio) cb_fs_new_local_candidate: called
>tp-fs-DEBUG: 11/05/2010 12:42:21.650439: stream 1 0x2e60220 (audio) cb_fs_new_local_candidate: called
>tp-fs-DEBUG: 11/05/2010 12:42:21.650473: stream 1 0x2e60220 (audio) cb_fs_new_local_candidate: called
>tp-fs-DEBUG: 11/05/2010 12:42:21.650505: stream 1 0x2e60220 (audio) cb_fs_new_local_candidate: called
>tp-fs-DEBUG: 11/05/2010 12:42:21.650535: stream 1 0x2e60220 (audio) cb_fs_new_local_candidate: called
>tp-fs-DEBUG: 11/05/2010 12:42:21.650566: stream 1 0x2e60220 (audio) cb_fs_new_local_candidate: called
>tp-fs-DEBUG: 11/05/2010 12:42:21.650598: stream 1 0x2e60220 (audio) cb_fs_new_local_candidate: called
>tp-fs-DEBUG: 11/05/2010 12:42:21.650629: stream 1 0x2e60220 (audio) cb_fs_new_local_candidate: called
>tp-fs-DEBUG: 11/05/2010 12:42:21.650659: stream 1 0x2e60220 (audio) cb_fs_local_candidates_prepared: called
>tp-fs-DEBUG: 11/05/2010 12:42:21.650701: stream 1 0x2e60220 (audio) cb_fs_local_candidates_prepared: candidate->ip = '192.168.1.2'
>tp-fs-DEBUG: 11/05/2010 12:42:21.650747: stream 1 0x2e60220 (audio) cb_fs_local_candidates_prepared: candidate->ip = '192.168.1.2'
>tp-fs-DEBUG: 11/05/2010 12:42:21.650998: stream 1 0x2e60220 (audio) cb_fs_local_candidates_prepared: candidate->ip = '151.16.55.68'
>tp-fs-DEBUG: 11/05/2010 12:42:21.651139: stream 1 0x2e60220 (audio) cb_fs_local_candidates_prepared: candidate->ip = '151.16.55.68'
>tp-fs-DEBUG: 11/05/2010 12:42:21.651175: stream 1 0x2e60220 (audio) cb_fs_local_candidates_prepared: candidate->ip = '151.16.55.68'
>tp-fs-DEBUG: 11/05/2010 12:42:21.651206: stream 1 0x2e60220 (audio) cb_fs_local_candidates_prepared: candidate->ip = '151.16.55.68'
>tp-fs-DEBUG: 11/05/2010 12:42:21.651453: stream 1 0x2e60220 (audio) cb_fs_local_candidates_prepared: candidate->ip = '209.85.137.126'
>tp-fs-DEBUG: 11/05/2010 12:42:21.651734: stream 1 0x2e60220 (audio) cb_fs_local_candidates_prepared: candidate->ip = '209.85.229.126'
>tp-fs-DEBUG: 11/05/2010 12:42:21.652005: stream 1 0x2e60220 (audio) cb_fs_local_candidates_prepared: candidate->ip = '209.85.137.126'
>tp-fs-DEBUG: 11/05/2010 12:42:21.652275: stream 1 0x2e60220 (audio) cb_fs_local_candidates_prepared: candidate->ip = '209.85.229.126'
>tp-fs-DEBUG: 11/05/2010 12:42:21.652558: stream 1 0x2e60220 (audio) cb_fs_local_candidates_prepared: candidate->ip = '209.85.137.126'
>tp-fs-DEBUG: 11/05/2010 12:42:21.652827: stream 1 0x2e60220 (audio) cb_fs_local_candidates_prepared: candidate->ip = '209.85.229.126'
>tp-fs-DEBUG: 11/05/2010 12:42:21.654078: stream 2 0x2e60310 (video) cb_fs_new_local_candidate: called
>tp-fs-DEBUG: 11/05/2010 12:42:21.654110: stream 2 0x2e60310 (video) cb_fs_new_local_candidate: called
>tp-fs-DEBUG: 11/05/2010 12:42:21.654439: stream 2 0x2e60310 (video) _tf_stream_bus_message: Codecs changed
>tp-fs-DEBUG: 11/05/2010 12:42:21.654458: stream 2 0x2e60310 (video) _tf_stream_try_sending_codecs: called (send_local:0 send_supported:0)
>tp-fs-DEBUG: 11/05/2010 12:42:21.654485: stream 2 0x2e60310 (video) _tf_stream_try_sending_codecs: 98: video H264 clock:90000 channels:0
>tp-fs-DEBUG: 11/05/2010 12:42:21.654500: stream 2 0x2e60310 (video) _tf_stream_try_sending_codecs: 34: video H263 clock:90000 channels:0
>tp-fs-DEBUG: 11/05/2010 12:42:21.654515: stream 2 0x2e60310 (video) _tf_stream_try_sending_codecs: 96: video THEORA clock:90000 channels:0
>tp-fs-DEBUG: 11/05/2010 12:42:21.654531: stream 2 0x2e60310 (video) _tf_stream_try_sending_codecs: 97: video JPEG2000 clock:90000 channels:0
>tp-fs-DEBUG: 11/05/2010 12:42:21.654546: stream 2 0x2e60310 (video) _tf_stream_try_sending_codecs: 99: video H263-1998 clock:90000 channels:0
>empathy/Voip-DEBUG: 11/05/2010 12:42:21.654649: tp_call_stream_state_changed_cb: Stream state changed - stream id: 2, state state: 1
>tp-fs-DEBUG: 11/05/2010 12:42:21.680721: stream 2 0x2e60310 (video) cb_fs_new_local_candidate: called
>tp-fs-DEBUG: 11/05/2010 12:42:21.682811: stream 2 0x2e60310 (video) cb_fs_new_local_candidate: called
>tp-fs-DEBUG: 11/05/2010 12:42:21.692538: stream 2 0x2e60310 (video) cb_fs_new_local_candidate: called
>tp-fs-DEBUG: 11/05/2010 12:42:21.696248: stream 2 0x2e60310 (video) cb_fs_new_local_candidate: called
>tp-fs-DEBUG: 11/05/2010 12:42:21.727606: stream 2 0x2e60310 (video) cb_fs_new_local_candidate: called
>tp-fs-DEBUG: 11/05/2010 12:42:21.737649: stream 2 0x2e60310 (video) cb_fs_new_local_candidate: called
>tp-fs-DEBUG: 11/05/2010 12:42:21.763639: stream 2 0x2e60310 (video) cb_fs_new_local_candidate: called
>tp-fs-DEBUG: 11/05/2010 12:42:21.773096: stream 2 0x2e60310 (video) cb_fs_new_local_candidate: called
>tp-fs-DEBUG: 11/05/2010 12:42:21.777661: stream 2 0x2e60310 (video) cb_fs_new_local_candidate: called
>tp-fs-DEBUG: 11/05/2010 12:42:21.782126: stream 2 0x2e60310 (video) cb_fs_new_local_candidate: called
>tp-fs-DEBUG: 11/05/2010 12:42:21.801311: stream 2 0x2e60310 (video) cb_fs_local_candidates_prepared: called
>tp-fs-DEBUG: 11/05/2010 12:42:21.801342: stream 2 0x2e60310 (video) cb_fs_local_candidates_prepared: candidate->ip = '192.168.1.2'
>tp-fs-DEBUG: 11/05/2010 12:42:21.801374: stream 2 0x2e60310 (video) cb_fs_local_candidates_prepared: candidate->ip = '192.168.1.2'
>tp-fs-DEBUG: 11/05/2010 12:42:21.801537: stream 2 0x2e60310 (video) cb_fs_local_candidates_prepared: candidate->ip = '151.16.55.68'
>tp-fs-DEBUG: 11/05/2010 12:42:21.801569: stream 2 0x2e60310 (video) cb_fs_local_candidates_prepared: candidate->ip = '151.16.55.68'
>tp-fs-DEBUG: 11/05/2010 12:42:21.801600: stream 2 0x2e60310 (video) cb_fs_local_candidates_prepared: candidate->ip = '151.16.55.68'
>tp-fs-DEBUG: 11/05/2010 12:42:21.801631: stream 2 0x2e60310 (video) cb_fs_local_candidates_prepared: candidate->ip = '151.16.55.68'
>tp-fs-DEBUG: 11/05/2010 12:42:21.801789: stream 2 0x2e60310 (video) cb_fs_local_candidates_prepared: candidate->ip = '209.85.229.126'
>tp-fs-DEBUG: 11/05/2010 12:42:21.801897: stream 2 0x2e60310 (video) cb_fs_local_candidates_prepared: candidate->ip = '209.85.229.126'
>tp-fs-DEBUG: 11/05/2010 12:42:21.802002: stream 2 0x2e60310 (video) cb_fs_local_candidates_prepared: candidate->ip = '209.85.229.126'
>tp-fs-DEBUG: 11/05/2010 12:42:21.802109: stream 2 0x2e60310 (video) cb_fs_local_candidates_prepared: candidate->ip = '209.85.229.126'
>tp-fs-DEBUG: 11/05/2010 12:42:21.802212: stream 2 0x2e60310 (video) cb_fs_local_candidates_prepared: candidate->ip = '209.85.229.126'
>tp-fs-DEBUG: 11/05/2010 12:42:21.802318: stream 2 0x2e60310 (video) cb_fs_local_candidates_prepared: candidate->ip = '209.85.229.126'
>tp-fs-DEBUG: 11/05/2010 12:42:23.405412: stream 1 0x2e60220 (audio) add_remote_candidate: adding remote candidate R1
>tp-fs-DEBUG: 11/05/2010 12:42:23.408051: stream 1 0x2e60220 (audio) add_remote_candidate: adding remote candidate R2
>tp-fs-DEBUG: 11/05/2010 12:42:23.409663: stream 1 0x2e60220 (audio) cb_fs_new_active_candidate_pair: called: c:2 local: 1 192.168.1.2:37016  remote: R1 192.168.1.83:64822
>empathy/Voip-DEBUG: 11/05/2010 12:42:23.409732: tp_call_stream_state_changed_cb: Stream state changed - stream id: 1, state state: 1
>tp-fs-DEBUG: 11/05/2010 12:42:23.412022: stream 2 0x2e60310 (video) add_remote_candidate: adding remote candidate R1
>tp-fs-DEBUG: 11/05/2010 12:42:23.413081: stream 1 0x2e60220 (audio) cb_fs_new_active_candidate_pair: called: c:1 local: 1 192.168.1.2:34756  remote: R2 192.168.1.83:64824
>tp-fs-DEBUG: 11/05/2010 12:42:23.415483: stream 2 0x2e60310 (video) add_remote_candidate: adding remote candidate R2
>empathy/Voip-DEBUG: 11/05/2010 12:42:23.417208: tp_call_stream_state_changed_cb: Stream state changed - stream id: 1, state state: 1
>empathy/Voip-DEBUG: 11/05/2010 12:42:23.417340: tp_call_stream_state_changed_cb: Stream state changed - stream id: 1, state state: 2
>empathy/Voip-DEBUG: 11/05/2010 12:42:23.417552: tp_call_stream_state_changed_cb: Stream state changed - stream id: 2, state state: 1
>tp-fs-DEBUG: 11/05/2010 12:42:23.421421: stream 2 0x2e60310 (video) cb_fs_new_active_candidate_pair: called: c:2 local: 9 192.168.1.2:53068  remote: R1 192.168.1.83:64826
>tp-fs-DEBUG: 11/05/2010 12:42:23.422183: stream 2 0x2e60310 (video) cb_fs_new_active_candidate_pair: called: c:1 local: 9 192.168.1.2:43968  remote: R2 192.168.1.83:64828
>empathy/Voip-DEBUG: 11/05/2010 12:42:23.423002: tp_call_stream_state_changed_cb: Stream state changed - stream id: 2, state state: 1
>empathy/Voip-DEBUG: 11/05/2010 12:42:23.423398: tp_call_stream_state_changed_cb: Stream state changed - stream id: 2, state state: 2
>tp-fs-DEBUG: 11/05/2010 12:42:23.612078: stream 2 0x2e60310 (video) add_remote_candidate: adding remote candidate R3
>tp-fs-DEBUG: 11/05/2010 12:42:23.614811: stream 1 0x2e60220 (audio) add_remote_candidate: adding remote candidate R3
>tp-fs-DEBUG: 11/05/2010 12:42:23.617371: stream 1 0x2e60220 (audio) add_remote_candidate: adding remote candidate R4
>empathy/Voip-DEBUG: 11/05/2010 12:42:23.618644: tp_call_stream_state_changed_cb: Stream state changed - stream id: 1, state state: 1
>empathy/Voip-DEBUG: 11/05/2010 12:42:23.705666: tp_call_stream_state_changed_cb: Stream state changed - stream id: 1, state state: 2
>tp-fs-DEBUG: 11/05/2010 12:42:23.960328: stream 2 0x2e60310 (video) add_remote_candidate: adding remote candidate R4
>empathy/Voip-DEBUG: 11/05/2010 12:42:23.963119: tp_call_stream_state_changed_cb: Stream state changed - stream id: 2, state state: 1
>empathy/Voip-DEBUG: 11/05/2010 12:42:24.121212: tp_call_stream_state_changed_cb: Stream state changed - stream id: 2, state state: 2
>tp-fs-DEBUG: 11/05/2010 12:42:24.566773: stream 1 0x2e60220 (audio) cb_fs_stream_src_pad_added: New pad src_1_548248702_103: 103: audio SPEEX clock:8000 channels:1 params:(nil)
>empathy/Voip-DEBUG: 11/05/2010 12:42:24.634968: tp_call_stream_state_changed_cb: Stream state changed - stream id: 1, state state: 2
>tp-fs-DEBUG: 11/05/2010 12:42:24.671272: stream 2 0x2e60310 (video) set_remote_codecs: called
>tp-fs-DEBUG: 11/05/2010 12:42:24.671375: stream 2 0x2e60310 (video) set_remote_codecs: adding remote codec H264 [97]
>tp-fs-DEBUG: 11/05/2010 12:42:24.672866: stream 2 0x2e60310 (video) _tf_stream_try_sending_codecs: called (send_local:0 send_supported:1)
>tp-fs-DEBUG: 11/05/2010 12:42:24.672955: stream 2 0x2e60310 (video) _tf_stream_try_sending_codecs: 97: video H264 clock:90000 channels:0
>tp-fs-DEBUG: 11/05/2010 12:42:24.673054: stream 2 0x2e60310 (video) fs_codecs_to_tp: adding codec H264 [97]
>tp-fs-DEBUG: 11/05/2010 12:42:24.673099: stream 2 0x2e60310 (video) _tf_stream_try_sending_codecs: calling MediaStreamHandler::SupportedCodecs
>tp-fs-DEBUG: 11/05/2010 12:42:24.673571: stream 2 0x2e60310 (video) _tf_stream_bus_message: Codecs changed
>tp-fs-DEBUG: 11/05/2010 12:42:24.673585: stream 2 0x2e60310 (video) _tf_stream_try_sending_codecs: called (send_local:0 send_supported:0)
>tp-fs-DEBUG: 11/05/2010 12:42:24.673608: stream 2 0x2e60310 (video) _tf_stream_try_sending_codecs: 97: video H264 clock:90000 channels:0
>tp-fs-DEBUG: 11/05/2010 12:42:24.673671: stream 2 0x2e60310 (video) set_stream_sending: 1
>tp-fs-DEBUG: 11/05/2010 12:42:24.673691: stream 2 0x2e60310 (video) tf_stream_request_resource: Requesting resource for direction 1
>tp-fs-DEBUG: 11/05/2010 12:42:24.673728: stream 2 0x2e60310 (video) tf_stream_request_resource: Requesting resource for direction 1 returned 1
>tp-fs-DEBUG: 11/05/2010 12:42:24.673887: stream 2 0x2e60310 (video) set_stream_playing: 1
>tp-fs-DEBUG: 11/05/2010 12:42:24.673904: stream 2 0x2e60310 (video) tf_stream_request_resource: Requesting resource for direction 2
>tp-fs-DEBUG: 11/05/2010 12:42:24.673926: stream 2 0x2e60310 (video) tf_stream_request_resource: Requesting resource for direction 2 returned 1
>tp-fs-DEBUG: 11/05/2010 12:42:24.673981: stream 2 0x2e60310 (video) set_stream_sending: 1
>tp-fs-DEBUG: 11/05/2010 12:42:24.674588: stream 1 0x2e60220 (audio) set_remote_codecs: called
>tp-fs-DEBUG: 11/05/2010 12:42:24.674607: stream 1 0x2e60220 (audio) set_remote_codecs: adding remote codec speex [103]
>tp-fs-DEBUG: 11/05/2010 12:42:24.674624: stream 1 0x2e60220 (audio) set_remote_codecs: adding remote codec speex [104]
>tp-fs-DEBUG: 11/05/2010 12:42:24.674640: stream 1 0x2e60220 (audio) set_remote_codecs: adding remote codec PCMU [0]
>tp-fs-DEBUG: 11/05/2010 12:42:24.674658: stream 1 0x2e60220 (audio) set_remote_codecs: adding remote codec PCMA [8]
>tp-fs-DEBUG: 11/05/2010 12:42:24.674674: stream 1 0x2e60220 (audio) set_remote_codecs: adding remote codec GSM [3]
>tp-fs-DEBUG: 11/05/2010 12:42:24.674691: stream 1 0x2e60220 (audio) set_remote_codecs: adding remote codec telephone-event [101]
>tp-fs-DEBUG: 11/05/2010 12:42:24.674947: stream 1 0x2e60220 (audio) _tf_stream_try_sending_codecs: called (send_local:0 send_supported:1)
>tp-fs-DEBUG: 11/05/2010 12:42:24.674972: stream 1 0x2e60220 (audio) _tf_stream_try_sending_codecs: 103: audio SPEEX clock:8000 channels:1
>tp-fs-DEBUG: 11/05/2010 12:42:24.674987: stream 1 0x2e60220 (audio) _tf_stream_try_sending_codecs: 104: audio SPEEX clock:16000 channels:1
>tp-fs-DEBUG: 11/05/2010 12:42:24.675002: stream 1 0x2e60220 (audio) _tf_stream_try_sending_codecs: 0: audio PCMU clock:8000 channels:0
>tp-fs-DEBUG: 11/05/2010 12:42:24.675017: stream 1 0x2e60220 (audio) _tf_stream_try_sending_codecs: 8: audio PCMA clock:8000 channels:0
>tp-fs-DEBUG: 11/05/2010 12:42:24.675031: stream 1 0x2e60220 (audio) _tf_stream_try_sending_codecs: 3: audio GSM clock:8000 channels:0
>tp-fs-DEBUG: 11/05/2010 12:42:24.675048: stream 1 0x2e60220 (audio) _tf_stream_try_sending_codecs: 101: audio telephone-event clock:8000 channels:0 events=0-15
>tp-fs-DEBUG: 11/05/2010 12:42:24.675081: stream 1 0x2e60220 (audio) fs_codecs_to_tp: adding codec SPEEX [103]
>tp-fs-DEBUG: 11/05/2010 12:42:24.675110: stream 1 0x2e60220 (audio) fs_codecs_to_tp: adding codec SPEEX [104]
>tp-fs-DEBUG: 11/05/2010 12:42:24.675139: stream 1 0x2e60220 (audio) fs_codecs_to_tp: adding codec PCMU [0]
>tp-fs-DEBUG: 11/05/2010 12:42:24.675168: stream 1 0x2e60220 (audio) fs_codecs_to_tp: adding codec PCMA [8]
>tp-fs-DEBUG: 11/05/2010 12:42:24.675198: stream 1 0x2e60220 (audio) fs_codecs_to_tp: adding codec GSM [3]
>tp-fs-DEBUG: 11/05/2010 12:42:24.675230: stream 1 0x2e60220 (audio) fs_codecs_to_tp: adding codec telephone-event [101]
>tp-fs-DEBUG: 11/05/2010 12:42:24.675245: stream 1 0x2e60220 (audio) _tf_stream_try_sending_codecs: calling MediaStreamHandler::SupportedCodecs
>tp-fs-DEBUG: 11/05/2010 12:42:24.675513: stream 1 0x2e60220 (audio) _tf_stream_bus_message: Codecs changed
>tp-fs-DEBUG: 11/05/2010 12:42:24.675528: stream 1 0x2e60220 (audio) _tf_stream_try_sending_codecs: called (send_local:0 send_supported:0)
>tp-fs-DEBUG: 11/05/2010 12:42:24.675551: stream 1 0x2e60220 (audio) _tf_stream_try_sending_codecs: 103: audio SPEEX clock:8000 channels:1
>tp-fs-DEBUG: 11/05/2010 12:42:24.677006: stream 1 0x2e60220 (audio) _tf_stream_try_sending_codecs: 104: audio SPEEX clock:16000 channels:1
>tp-fs-DEBUG: 11/05/2010 12:42:24.677022: stream 1 0x2e60220 (audio) _tf_stream_try_sending_codecs: 0: audio PCMU clock:8000 channels:0
>tp-fs-DEBUG: 11/05/2010 12:42:24.677038: stream 1 0x2e60220 (audio) _tf_stream_try_sending_codecs: 8: audio PCMA clock:8000 channels:0
>tp-fs-DEBUG: 11/05/2010 12:42:24.677054: stream 1 0x2e60220 (audio) _tf_stream_try_sending_codecs: 3: audio GSM clock:8000 channels:0
>tp-fs-DEBUG: 11/05/2010 12:42:24.677073: stream 1 0x2e60220 (audio) _tf_stream_try_sending_codecs: 101: audio telephone-event clock:8000 channels:0 events=0-15
>tp-fs-DEBUG: 11/05/2010 12:42:24.677103: stream 1 0x2e60220 (audio) set_stream_sending: 1
>tp-fs-DEBUG: 11/05/2010 12:42:24.677122: stream 1 0x2e60220 (audio) tf_stream_request_resource: Requesting resource for direction 1
>tp-fs-DEBUG: 11/05/2010 12:42:24.677150: stream 1 0x2e60220 (audio) tf_stream_request_resource: Requesting resource for direction 1 returned 1
>tp-fs-DEBUG: 11/05/2010 12:42:24.677375: stream 1 0x2e60220 (audio) set_stream_playing: 1
>tp-fs-DEBUG: 11/05/2010 12:42:24.677392: stream 1 0x2e60220 (audio) tf_stream_request_resource: Requesting resource for direction 2
>tp-fs-DEBUG: 11/05/2010 12:42:24.677413: stream 1 0x2e60220 (audio) tf_stream_request_resource: Requesting resource for direction 2 returned 1
>tp-fs-DEBUG: 11/05/2010 12:42:24.677478: stream 1 0x2e60220 (audio) set_stream_sending: 1
>tp-fs-DEBUG: 11/05/2010 12:42:24.717098: stream 2 0x2e60310 (video) _tf_stream_bus_message: Send codec changed: 97: video H264 clock:90000 channels:0 params:(nil)
>tp-fs-DEBUG: 11/05/2010 12:42:24.722688: stream 1 0x2e60220 (audio) _tf_stream_bus_message: Send codec changed: 103: audio SPEEX clock:8000 channels:1 params:(nil)
>tp-fs-DEBUG: 11/05/2010 12:42:25.96939: stream 2 0x2e60310 (video) cb_fs_stream_src_pad_added: New pad src_2_3989586402_98: 98: video H264 clock:90000 channels:0 params:(nil)
>empathy/Voip-DEBUG: 11/05/2010 12:42:25.97851: tp_call_stream_state_changed_cb: Stream state changed - stream id: 2, state state: 2
>empathy/Voip-DEBUG: 11/05/2010 12:42:25.97866: empathy_call_window_video_stream_changed_cb: video stream changed
>tp-fs-DEBUG: 11/05/2010 12:42:26.381979: stream 2 0x2e60310 (video) _tf_stream_bus_message: Codecs changed
>tp-fs-DEBUG: 11/05/2010 12:42:26.381999: stream 2 0x2e60310 (video) _tf_stream_try_sending_codecs: called (send_local:0 send_supported:0)
>tp-fs-DEBUG: 11/05/2010 12:42:26.382030: stream 2 0x2e60310 (video) _tf_stream_try_sending_codecs: 97: video H264 clock:90000 channels:0 sprop-parameter-sets=Z01ADZJUCg/YCIAAAAMAgAAAHgeKFVA=,aM88gA==
>tp-fs-DEBUG: 11/05/2010 12:42:26.382076: stream 2 0x2e60310 (video) fs_codecs_to_tp: adding codec H264 [97]
>tp-fs-DEBUG: 11/05/2010 12:42:26.382091: stream 2 0x2e60310 (video) _tf_stream_try_sending_codecs: calling MediaStreamHandler::CodecsUpdated
>tp-fs-WARNING: 11/05/2010 12:42:26.383009: Error calling Media.StreamHandler::CodecsUpdated: tried to change codec 97's name from JPEG2000 to H264
>tp-fs-DEBUG: 11/05/2010 12:42:26.496431: stream 2 0x2e60310 (video) _tf_stream_bus_message: Codecs changed
>tp-fs-DEBUG: 11/05/2010 12:42:26.496460: stream 2 0x2e60310 (video) _tf_stream_try_sending_codecs: called (send_local:0 send_supported:0)
>tp-fs-DEBUG: 11/05/2010 12:42:26.496494: stream 2 0x2e60310 (video) _tf_stream_try_sending_codecs: 97: video H264 clock:90000 channels:0 sprop-parameter-sets=Z01ADZJUCg/YCIAAAAMAgAAAHgeKFVA=,aM88gA==
>empathy/Other-DEBUG: 11/05/2010 12:42:34.96481: instance_destroyed_cb: instance for 0x2f1f520 destroyed; cleaning up
>empathy/Voip-DEBUG: 11/05/2010 12:42:34.97043: disable_camera: Disable camera
>empathy/Voip-DEBUG: 11/05/2010 12:42:34.97048: display_video_preview: Show self avatar
>empathy/Voip-DEBUG: 11/05/2010 12:42:34.97064: display_video_preview: Show self avatar
>tp-fs-DEBUG: 11/05/2010 12:42:34.97493: tf_channel_dispose
>tp-fs-MESSAGE: 11/05/2010 12:42:34.97512: tf_stream_error: stream error errorno=0 error=UI stopped channel
>tp-fs-MESSAGE: 11/05/2010 12:42:34.100488: tf_stream_error: stream error errorno=0 error=UI stopped channel
>tp-fs-DEBUG: 11/05/2010 12:42:34.103087: _tf_session_dispose
>empathy/Voip-DEBUG: 11/05/2010 12:42:34.103143: empathy_tp_call_close: Closing channel
>empathy/Other-DEBUG: 11/05/2010 12:42:34.107714: user_data_destroyed_cb: user_data for 0x3016600 destroyed; disconnecting
>empathy/Other-DEBUG: 11/05/2010 12:42:34.107722: user_data_destroyed_cb: user_data for 0x3016800 destroyed; disconnecting
>empathy/Voip-DEBUG: 11/05/2010 12:42:34.108366: tp_call_stream_error_cb: Stream error on stream 1: UI stopped channel (code: 0)
>empathy/Voip-DEBUG: 11/05/2010 12:42:34.108776: tp_call_stream_removed_cb: Stream removed - stream id: 1
>empathy/Voip-DEBUG: 11/05/2010 12:42:34.108829: tp_call_stream_removed_cb: Stream removed - stream id: 2
>empathy/Dispatcher-DEBUG: 11/05/2010 12:42:34.108975: dispatcher_channel_invalidated_cb: Channel /org/freedesktop/Telepathy/Connection/gabble/jabber/nicolo_2echieffo_40gmail_2ecom_2fb6df5ac1/MediaChannel0 invalidated
>empathy/Voip-DEBUG: 11/05/2010 12:42:34.108982: tp_call_dispose: Disposing: 0x2fc55e0, 0
>empathy/Voip-DEBUG: 11/05/2010 12:42:34.109014: tp_call_finalize: Finalizing: 0x2fc55e0
>empathy/Other-DEBUG: 11/05/2010 12:42:49.80604: builder_get_file_valist: Loading file /usr/share/empathy/empathy-call-window.ui
>empathy/Other-DEBUG: 11/05/2010 12:42:49.214219: empathy_signal_connect_weak: connecting to 0x302ec40:peak-level-changed with context 0x32abe60
>empathy/Other-DEBUG: 11/05/2010 12:42:49.221194: builder_get_file_valist: Loading file /usr/share/empathy/empathy-call-window-fullscreen.ui
>empathy/Voip-DEBUG: 11/05/2010 12:42:49.237895: enable_camera: Enable camera
>empathy/Voip-DEBUG: 11/05/2010 12:42:49.237900: display_video_preview: Show video preview
>empathy/Voip-DEBUG: 11/05/2010 12:42:49.237904: empathy_call_window_setup_video_preview: Create video preview
>empathy/(null)-DEBUG: 11/05/2010 12:42:49.578501: tp_contact_factory_add_contact: Contact added: nicolo.chieffo@gmail.com (1)
>empathy/(null)-DEBUG: 11/05/2010 12:42:49.583935: tp_contact_factory_weak_notify: Remove finalized contact 0x2fcfa30
>empathy/Contact-DEBUG: 11/05/2010 12:42:49.583945: contact_finalize: finalize: 0x2fcfa30
>empathy/(null)-DEBUG: 11/05/2010 12:42:49.592283: tp_contact_factory_got_known_avatar_tokens: Got 1 tokens, need to request 0 avatars
>empathy/Dispatcher-DEBUG: 11/05/2010 12:42:49.616853: dispatcher_connection_new_channel: outgoing channel of type org.freedesktop.Telepathy.Channel.Type.StreamedMedia on /org/freedesktop/Telepathy/Connection/gabble/jabber/nicolo_2echieffo_40gmail_2ecom_2fb6df5ac1/MediaChannel1
>empathy/Dispatcher-DEBUG: 11/05/2010 12:42:49.617331: dispatcher_connection_new_channel: Channel satified request /com/nokia/MissionControl/requests/r7(already dispatched: 0)
>empathy/Dispatcher-DEBUG: 11/05/2010 12:42:49.617336: dispatcher_start_dispatching: Dispatching process started for /org/freedesktop/Telepathy/Connection/gabble/jabber/nicolo_2echieffo_40gmail_2ecom_2fb6df5ac1/MediaChannel1
>empathy/Dispatcher-DEBUG: 11/05/2010 12:42:49.630644: dispatcher_channel_request_succeeded_cb: Request succeeded: /com/nokia/MissionControl/requests/r7
>empathy/Dispatcher-DEBUG: 11/05/2010 12:42:49.675654: empathy_dispatch_operation_set_status: Dispatch operation /org/freedesktop/Telepathy/Connection/gabble/jabber/nicolo_2echieffo_40gmail_2ecom_2fb6df5ac1/MediaChannel1 status: 0 -> 1
>empathy/Dispatcher-DEBUG: 11/05/2010 12:42:49.675785: dispatch_operation_ready_cb: Send to observers: /org/freedesktop/Telepathy/Connection/gabble/jabber/nicolo_2echieffo_40gmail_2ecom_2fb6df5ac1/MediaChannel1
>empathy/Dispatcher-DEBUG: 11/05/2010 12:42:49.675801: empathy_dispatch_operation_set_status: Dispatch operation /org/freedesktop/Telepathy/Connection/gabble/jabber/nicolo_2echieffo_40gmail_2ecom_2fb6df5ac1/MediaChannel1 status: 1 -> 3
>empathy/Other-DEBUG: 11/05/2010 12:42:49.675820: empathy_signal_connect_weak: connecting to 0x30fa400:audio-stream-error with context 0x2f59200
>empathy/Other-DEBUG: 11/05/2010 12:42:49.675829: empathy_signal_connect_weak: connecting to 0x30fa400:video-stream-error with context 0x3112c40
>empathy/Voip-DEBUG: 11/05/2010 12:42:49.675877: tp_call_request_streams_for_capabilities: Requesting new stream for capabilities 3
>empathy/Dispatcher-DEBUG: 11/05/2010 12:42:49.675936: empathy_dispatch_operation_set_status: Dispatch operation /org/freedesktop/Telepathy/Connection/gabble/jabber/nicolo_2echieffo_40gmail_2ecom_2fb6df5ac1/MediaChannel1 status: 3 -> 4
>empathy/Dispatcher-DEBUG: 11/05/2010 12:42:49.675954: dispatch_operation_claimed_cb: Channel claimed: /org/freedesktop/Telepathy/Connection/gabble/jabber/nicolo_2echieffo_40gmail_2ecom_2fb6df5ac1/MediaChannel1
>tp-fs-DEBUG: 11/05/2010 12:42:49.681529: GetSessionHandlers replied: 
>tp-fs-DEBUG: 11/05/2010 12:42:49.681560:   - session /org/freedesktop/Telepathy/Connection/gabble/jabber/nicolo_2echieffo_40gmail_2ecom_2fb6df5ac1/MediaChannel1
>tp-fs-DEBUG: 11/05/2010 12:42:49.681576:     type rtp
>tp-fs-DEBUG: 11/05/2010 12:42:49.681592: adding session handler /org/freedesktop/Telepathy/Connection/gabble/jabber/nicolo_2echieffo_40gmail_2ecom_2fb6df5ac1/MediaChannel1, type rtp
>tp-fs-DEBUG: 11/05/2010 12:42:49.681890: calling MediaSessionHandler::Ready
>empathy/Voip-DEBUG: 11/05/2010 12:42:49.785845: tp_call_stream_added_cb: Stream added - stream id: 1, contact handle: 414, stream type: 0
>empathy/Voip-DEBUG: 11/05/2010 12:42:49.785854: tp_call_add_stream: Audio stream - id: 1, state: 0, direction: 0
>empathy/Voip-DEBUG: 11/05/2010 12:42:49.786437: tp_call_stream_direction_changed_cb: Stream direction changed - stream: 1, direction: 3
>tp-fs-DEBUG: 11/05/2010 12:42:49.786815: New stream, stream_id=1, media_type=0, direction=3
>tp-fs-DEBUG: 11/05/2010 12:42:49.791795: stream 1 0x2e60400 (audio) get_all_properties_cb: Adding STUN server 209.85.137.126:19302
>tp-fs-DEBUG: 11/05/2010 12:42:49.791826: stream 1 0x2e60400 (audio) get_all_properties_cb: Adding relay (udp) 209.85.137.126:19295 WnKAEGWNaBLW4OwV:Qw8WcmtU6WmAYXT2 1
>tp-fs-DEBUG: 11/05/2010 12:42:49.791860: stream 1 0x2e60400 (audio) get_all_properties_cb: Adding relay (tcp) 209.85.137.126:19294 WnKAEGWNaBLW4OwV:Qw8WcmtU6WmAYXT2 1
>tp-fs-DEBUG: 11/05/2010 12:42:49.791886: stream 1 0x2e60400 (audio) get_all_properties_cb: Adding relay (tls) 209.85.137.126:443 WnKAEGWNaBLW4OwV:Qw8WcmtU6WmAYXT2 1
>tp-fs-DEBUG: 11/05/2010 12:42:49.791909: stream 1 0x2e60400 (audio) get_all_properties_cb: Adding relay (udp) 209.85.137.126:19295 j5yA4WdocVjOdU6u:O2u1hAN1qauem0DO 2
>tp-fs-DEBUG: 11/05/2010 12:42:49.791934: stream 1 0x2e60400 (audio) get_all_properties_cb: Adding relay (tcp) 209.85.137.126:19294 j5yA4WdocVjOdU6u:O2u1hAN1qauem0DO 2
>tp-fs-DEBUG: 11/05/2010 12:42:49.791956: stream 1 0x2e60400 (audio) get_all_properties_cb: Adding relay (tls) 209.85.137.126:443 j5yA4WdocVjOdU6u:O2u1hAN1qauem0DO 2
>tp-fs-DEBUG: 11/05/2010 12:42:50.7417: stream 1 0x2e60400 (audio) _tf_stream_try_sending_codecs: called (send_local:1 send_supported:0)
>tp-fs-DEBUG: 11/05/2010 12:42:50.7468: stream 1 0x2e60400 (audio) _tf_stream_try_sending_codecs: 103: audio SPEEX clock:8000 channels:1
>tp-fs-DEBUG: 11/05/2010 12:42:50.7486: stream 1 0x2e60400 (audio) _tf_stream_try_sending_codecs: 104: audio SPEEX clock:16000 channels:1
>tp-fs-DEBUG: 11/05/2010 12:42:50.7500: stream 1 0x2e60400 (audio) _tf_stream_try_sending_codecs: 98: audio AMR clock:8000 channels:1
>tp-fs-DEBUG: 11/05/2010 12:42:50.7519: stream 1 0x2e60400 (audio) _tf_stream_try_sending_codecs: 96: audio SIREN clock:16000 channels:0 bitrate=16000
>tp-fs-DEBUG: 11/05/2010 12:42:50.7534: stream 1 0x2e60400 (audio) _tf_stream_try_sending_codecs: 0: audio PCMU clock:8000 channels:0
>tp-fs-DEBUG: 11/05/2010 12:42:50.7555: stream 1 0x2e60400 (audio) _tf_stream_try_sending_codecs: 8: audio PCMA clock:8000 channels:0
>tp-fs-DEBUG: 11/05/2010 12:42:50.7571: stream 1 0x2e60400 (audio) _tf_stream_try_sending_codecs: 3: audio GSM clock:8000 channels:0
>tp-fs-DEBUG: 11/05/2010 12:42:50.7591: stream 1 0x2e60400 (audio) _tf_stream_try_sending_codecs: 100: audio telephone-event clock:16000 channels:0 events=0-15
>tp-fs-DEBUG: 11/05/2010 12:42:50.7608: stream 1 0x2e60400 (audio) _tf_stream_try_sending_codecs: 101: audio telephone-event clock:8000 channels:0 events=0-15
>tp-fs-DEBUG: 11/05/2010 12:42:50.7649: stream 1 0x2e60400 (audio) fs_codecs_to_tp: adding codec SPEEX [103]
>tp-fs-DEBUG: 11/05/2010 12:42:50.7683: stream 1 0x2e60400 (audio) fs_codecs_to_tp: adding codec SPEEX [104]
>tp-fs-DEBUG: 11/05/2010 12:42:50.7715: stream 1 0x2e60400 (audio) fs_codecs_to_tp: adding codec AMR [98]
>tp-fs-DEBUG: 11/05/2010 12:42:50.7751: stream 1 0x2e60400 (audio) fs_codecs_to_tp: adding codec SIREN [96]
>tp-fs-DEBUG: 11/05/2010 12:42:50.7781: stream 1 0x2e60400 (audio) fs_codecs_to_tp: adding codec PCMU [0]
>tp-fs-DEBUG: 11/05/2010 12:42:50.7811: stream 1 0x2e60400 (audio) fs_codecs_to_tp: adding codec PCMA [8]
>tp-fs-DEBUG: 11/05/2010 12:42:50.7843: stream 1 0x2e60400 (audio) fs_codecs_to_tp: adding codec GSM [3]
>tp-fs-DEBUG: 11/05/2010 12:42:50.7885: stream 1 0x2e60400 (audio) fs_codecs_to_tp: adding codec telephone-event [100]
>tp-fs-DEBUG: 11/05/2010 12:42:50.7919: stream 1 0x2e60400 (audio) fs_codecs_to_tp: adding codec telephone-event [101]
>tp-fs-DEBUG: 11/05/2010 12:42:50.7934: stream 1 0x2e60400 (audio) _tf_stream_try_sending_codecs: calling MediaStreamHandler::Ready
>empathy/Voip-DEBUG: 11/05/2010 12:42:50.11348: tp_call_add_stream: Audio stream - id: 1, state: 0, direction: 3
>empathy/Voip-DEBUG: 11/05/2010 12:42:50.11360: tp_call_add_stream: Video stream - id: 2, state: 0, direction: 3
>empathy/Voip-DEBUG: 11/05/2010 12:42:50.11420: tp_call_stream_added_cb: Stream added - stream id: 2, contact handle: 414, stream type: 1
>empathy/Voip-DEBUG: 11/05/2010 12:42:50.11430: tp_call_add_stream: Video stream - id: 2, state: 0, direction: 0
>empathy/Voip-DEBUG: 11/05/2010 12:42:50.11475: tp_call_stream_direction_changed_cb: Stream direction changed - stream: 2, direction: 3
>tp-fs-DEBUG: 11/05/2010 12:42:50.11562: New stream, stream_id=2, media_type=1, direction=3
>tp-fs-DEBUG: 11/05/2010 12:42:50.11962: stream 1 0x2e60400 (audio) set_stream_playing: 0
>tp-fs-DEBUG: 11/05/2010 12:42:50.12022: stream 1 0x2e60400 (audio) set_stream_sending: 0
>tp-fs-DEBUG: 11/05/2010 12:42:50.12530: stream 1 0x2e60400 (audio) _tf_stream_bus_message: Codecs changed
>tp-fs-DEBUG: 11/05/2010 12:42:50.12545: stream 1 0x2e60400 (audio) _tf_stream_try_sending_codecs: called (send_local:0 send_supported:0)
>tp-fs-DEBUG: 11/05/2010 12:42:50.12578: stream 1 0x2e60400 (audio) _tf_stream_try_sending_codecs: 103: audio SPEEX clock:8000 channels:1
>tp-fs-DEBUG: 11/05/2010 12:42:50.12593: stream 1 0x2e60400 (audio) _tf_stream_try_sending_codecs: 104: audio SPEEX clock:16000 channels:1
>tp-fs-DEBUG: 11/05/2010 12:42:50.12609: stream 1 0x2e60400 (audio) _tf_stream_try_sending_codecs: 98: audio AMR clock:8000 channels:1
>tp-fs-DEBUG: 11/05/2010 12:42:50.12626: stream 1 0x2e60400 (audio) _tf_stream_try_sending_codecs: 96: audio SIREN clock:16000 channels:0 bitrate=16000
>tp-fs-DEBUG: 11/05/2010 12:42:50.12643: stream 1 0x2e60400 (audio) _tf_stream_try_sending_codecs: 0: audio PCMU clock:8000 channels:0
>tp-fs-DEBUG: 11/05/2010 12:42:50.12658: stream 1 0x2e60400 (audio) _tf_stream_try_sending_codecs: 8: audio PCMA clock:8000 channels:0
>tp-fs-DEBUG: 11/05/2010 12:42:50.12672: stream 1 0x2e60400 (audio) _tf_stream_try_sending_codecs: 3: audio GSM clock:8000 channels:0
>tp-fs-DEBUG: 11/05/2010 12:42:50.12690: stream 1 0x2e60400 (audio) _tf_stream_try_sending_codecs: 100: audio telephone-event clock:16000 channels:0 events=0-15
>tp-fs-DEBUG: 11/05/2010 12:42:50.12706: stream 1 0x2e60400 (audio) _tf_stream_try_sending_codecs: 101: audio telephone-event clock:8000 channels:0 events=0-15
>tp-fs-DEBUG: 11/05/2010 12:42:50.12789: stream 1 0x2e60400 (audio) cb_fs_new_local_candidate: called
>tp-fs-DEBUG: 11/05/2010 12:42:50.12825: stream 1 0x2e60400 (audio) cb_fs_new_local_candidate: called
>tp-fs-DEBUG: 11/05/2010 12:42:50.12988: stream 1 0x2e60400 (audio) cb_fs_new_local_candidate: called
>tp-fs-DEBUG: 11/05/2010 12:42:50.13020: stream 1 0x2e60400 (audio) cb_fs_new_local_candidate: called
>tp-fs-DEBUG: 11/05/2010 12:42:50.13056: stream 1 0x2e60400 (audio) cb_fs_new_local_candidate: called
>tp-fs-DEBUG: 11/05/2010 12:42:50.13108: stream 1 0x2e60400 (audio) cb_fs_new_local_candidate: called
>tp-fs-DEBUG: 11/05/2010 12:42:50.13147: stream 1 0x2e60400 (audio) cb_fs_new_local_candidate: called
>tp-fs-DEBUG: 11/05/2010 12:42:50.13500: stream 1 0x2e60400 (audio) cb_fs_new_local_candidate: called
>tp-fs-DEBUG: 11/05/2010 12:42:50.13580: stream 1 0x2e60400 (audio) cb_fs_new_local_candidate: called
>tp-fs-DEBUG: 11/05/2010 12:42:50.13618: stream 1 0x2e60400 (audio) cb_fs_new_local_candidate: called
>tp-fs-DEBUG: 11/05/2010 12:42:50.13654: stream 1 0x2e60400 (audio) cb_fs_new_local_candidate: called
>tp-fs-DEBUG: 11/05/2010 12:42:50.13686: stream 1 0x2e60400 (audio) cb_fs_new_local_candidate: called
>tp-fs-DEBUG: 11/05/2010 12:42:50.13721: stream 1 0x2e60400 (audio) cb_fs_local_candidates_prepared: called
>tp-fs-DEBUG: 11/05/2010 12:42:50.14267: stream 1 0x2e60400 (audio) cb_fs_local_candidates_prepared: candidate->ip = '192.168.1.2'
>tp-fs-DEBUG: 11/05/2010 12:42:50.14319: stream 1 0x2e60400 (audio) cb_fs_local_candidates_prepared: candidate->ip = '192.168.1.2'
>tp-fs-DEBUG: 11/05/2010 12:42:50.14586: stream 1 0x2e60400 (audio) cb_fs_local_candidates_prepared: candidate->ip = '151.16.55.68'
>tp-fs-DEBUG: 11/05/2010 12:42:50.14625: stream 1 0x2e60400 (audio) cb_fs_local_candidates_prepared: candidate->ip = '151.16.55.68'
>tp-fs-DEBUG: 11/05/2010 12:42:50.14657: stream 1 0x2e60400 (audio) cb_fs_local_candidates_prepared: candidate->ip = '151.16.55.68'
>tp-fs-DEBUG: 11/05/2010 12:42:50.14691: stream 1 0x2e60400 (audio) cb_fs_local_candidates_prepared: candidate->ip = '151.16.55.68'
>tp-fs-DEBUG: 11/05/2010 12:42:50.15500: stream 1 0x2e60400 (audio) cb_fs_local_candidates_prepared: candidate->ip = '209.85.137.126'
>tp-fs-DEBUG: 11/05/2010 12:42:50.15723: stream 1 0x2e60400 (audio) cb_fs_local_candidates_prepared: candidate->ip = '209.85.137.126'
>tp-fs-DEBUG: 11/05/2010 12:42:50.15949: stream 1 0x2e60400 (audio) cb_fs_local_candidates_prepared: candidate->ip = '209.85.137.126'
>tp-fs-DEBUG: 11/05/2010 12:42:50.16170: stream 1 0x2e60400 (audio) cb_fs_local_candidates_prepared: candidate->ip = '209.85.137.126'
>tp-fs-DEBUG: 11/05/2010 12:42:50.16438: stream 1 0x2e60400 (audio) cb_fs_local_candidates_prepared: candidate->ip = '209.85.137.126'
>tp-fs-DEBUG: 11/05/2010 12:42:50.16688: stream 1 0x2e60400 (audio) cb_fs_local_candidates_prepared: candidate->ip = '209.85.137.126'
>tp-fs-DEBUG: 11/05/2010 12:42:50.19768: stream 2 0x2e604f0 (video) get_all_properties_cb: Adding STUN server 209.85.137.126:19302
>tp-fs-DEBUG: 11/05/2010 12:42:50.19809: stream 2 0x2e604f0 (video) get_all_properties_cb: Adding relay (udp) 209.85.137.126:19295 QQB17TYi3TUQPZrO:KUSzJxsQsrGTls3E 1
>tp-fs-DEBUG: 11/05/2010 12:42:50.19838: stream 2 0x2e604f0 (video) get_all_properties_cb: Adding relay (tcp) 209.85.137.126:19294 QQB17TYi3TUQPZrO:KUSzJxsQsrGTls3E 1
>tp-fs-DEBUG: 11/05/2010 12:42:50.19862: stream 2 0x2e604f0 (video) get_all_properties_cb: Adding relay (tls) 209.85.137.126:443 QQB17TYi3TUQPZrO:KUSzJxsQsrGTls3E 1
>tp-fs-DEBUG: 11/05/2010 12:42:50.19889: stream 2 0x2e604f0 (video) get_all_properties_cb: Adding relay (udp) 209.85.137.126:19295 l5br5KqT8GrcuR66:NcxpkarwMLHeyshg 2
>tp-fs-DEBUG: 11/05/2010 12:42:50.19912: stream 2 0x2e604f0 (video) get_all_properties_cb: Adding relay (tcp) 209.85.137.126:19294 l5br5KqT8GrcuR66:NcxpkarwMLHeyshg 2
>tp-fs-DEBUG: 11/05/2010 12:42:50.19937: stream 2 0x2e604f0 (video) get_all_properties_cb: Adding relay (tls) 209.85.137.126:443 l5br5KqT8GrcuR66:NcxpkarwMLHeyshg 2
>tp-fs-DEBUG: 11/05/2010 12:42:50.47847: stream 2 0x2e604f0 (video) _tf_stream_try_sending_codecs: called (send_local:1 send_supported:0)
>tp-fs-DEBUG: 11/05/2010 12:42:50.47899: stream 2 0x2e604f0 (video) _tf_stream_try_sending_codecs: 98: video H264 clock:90000 channels:0
>tp-fs-DEBUG: 11/05/2010 12:42:50.47916: stream 2 0x2e604f0 (video) _tf_stream_try_sending_codecs: 34: video H263 clock:90000 channels:0
>tp-fs-DEBUG: 11/05/2010 12:42:50.47933: stream 2 0x2e604f0 (video) _tf_stream_try_sending_codecs: 96: video THEORA clock:90000 channels:0
>tp-fs-DEBUG: 11/05/2010 12:42:50.47949: stream 2 0x2e604f0 (video) _tf_stream_try_sending_codecs: 97: video JPEG2000 clock:90000 channels:0
>tp-fs-DEBUG: 11/05/2010 12:42:50.47964: stream 2 0x2e604f0 (video) _tf_stream_try_sending_codecs: 99: video H263-1998 clock:90000 channels:0
>tp-fs-DEBUG: 11/05/2010 12:42:50.48007: stream 2 0x2e604f0 (video) fs_codecs_to_tp: adding codec H264 [98]
>tp-fs-DEBUG: 11/05/2010 12:42:50.48037: stream 2 0x2e604f0 (video) fs_codecs_to_tp: adding codec H263 [34]
>tp-fs-DEBUG: 11/05/2010 12:42:50.48067: stream 2 0x2e604f0 (video) fs_codecs_to_tp: adding codec THEORA [96]
>tp-fs-DEBUG: 11/05/2010 12:42:50.48101: stream 2 0x2e604f0 (video) fs_codecs_to_tp: adding codec JPEG2000 [97]
>tp-fs-DEBUG: 11/05/2010 12:42:50.48130: stream 2 0x2e604f0 (video) fs_codecs_to_tp: adding codec H263-1998 [99]
>tp-fs-DEBUG: 11/05/2010 12:42:50.48149: stream 2 0x2e604f0 (video) _tf_stream_try_sending_codecs: calling MediaStreamHandler::Ready
>empathy/Voip-DEBUG: 11/05/2010 12:42:50.49436: tp_call_stream_state_changed_cb: Stream state changed - stream id: 1, state state: 1
>tp-fs-DEBUG: 11/05/2010 12:42:50.51201: stream 2 0x2e604f0 (video) set_stream_playing: 0
>tp-fs-DEBUG: 11/05/2010 12:42:50.51279: stream 2 0x2e604f0 (video) set_stream_sending: 0
>tp-fs-DEBUG: 11/05/2010 12:42:50.51615: stream 2 0x2e604f0 (video) cb_fs_new_local_candidate: called
>tp-fs-DEBUG: 11/05/2010 12:42:50.51650: stream 2 0x2e604f0 (video) cb_fs_new_local_candidate: called
>tp-fs-DEBUG: 11/05/2010 12:42:50.52560: stream 2 0x2e604f0 (video) _tf_stream_bus_message: Codecs changed
>tp-fs-DEBUG: 11/05/2010 12:42:50.52576: stream 2 0x2e604f0 (video) _tf_stream_try_sending_codecs: called (send_local:0 send_supported:0)
>tp-fs-DEBUG: 11/05/2010 12:42:50.52670: stream 2 0x2e604f0 (video) _tf_stream_try_sending_codecs: 98: video H264 clock:90000 channels:0
>tp-fs-DEBUG: 11/05/2010 12:42:50.52687: stream 2 0x2e604f0 (video) _tf_stream_try_sending_codecs: 34: video H263 clock:90000 channels:0
>tp-fs-DEBUG: 11/05/2010 12:42:50.52704: stream 2 0x2e604f0 (video) _tf_stream_try_sending_codecs: 96: video THEORA clock:90000 channels:0
>tp-fs-DEBUG: 11/05/2010 12:42:50.52720: stream 2 0x2e604f0 (video) _tf_stream_try_sending_codecs: 97: video JPEG2000 clock:90000 channels:0
>tp-fs-DEBUG: 11/05/2010 12:42:50.52736: stream 2 0x2e604f0 (video) _tf_stream_try_sending_codecs: 99: video H263-1998 clock:90000 channels:0
>empathy/Voip-DEBUG: 11/05/2010 12:42:50.52752: tp_call_stream_state_changed_cb: Stream state changed - stream id: 2, state state: 1
>tp-fs-DEBUG: 11/05/2010 12:42:50.108827: stream 2 0x2e604f0 (video) cb_fs_new_local_candidate: called
>tp-fs-DEBUG: 11/05/2010 12:42:50.111596: stream 2 0x2e604f0 (video) cb_fs_new_local_candidate: called
>tp-fs-DEBUG: 11/05/2010 12:42:50.113059: stream 2 0x2e604f0 (video) cb_fs_new_local_candidate: called
>tp-fs-DEBUG: 11/05/2010 12:42:50.116067: stream 2 0x2e604f0 (video) cb_fs_new_local_candidate: called
>tp-fs-DEBUG: 11/05/2010 12:42:50.146411: stream 2 0x2e604f0 (video) cb_fs_new_local_candidate: called
>tp-fs-DEBUG: 11/05/2010 12:42:50.149353: stream 2 0x2e604f0 (video) cb_fs_new_local_candidate: called
>tp-fs-DEBUG: 11/05/2010 12:42:50.151649: stream 2 0x2e604f0 (video) cb_fs_new_local_candidate: called
>tp-fs-DEBUG: 11/05/2010 12:42:50.163944: stream 2 0x2e604f0 (video) cb_fs_new_local_candidate: called
>tp-fs-DEBUG: 11/05/2010 12:42:50.171005: stream 2 0x2e604f0 (video) cb_fs_new_local_candidate: called
>tp-fs-DEBUG: 11/05/2010 12:42:50.184078: stream 2 0x2e604f0 (video) cb_fs_new_local_candidate: called
>tp-fs-DEBUG: 11/05/2010 12:42:50.200249: stream 2 0x2e604f0 (video) cb_fs_local_candidates_prepared: called
>tp-fs-DEBUG: 11/05/2010 12:42:50.200283: stream 2 0x2e604f0 (video) cb_fs_local_candidates_prepared: candidate->ip = '192.168.1.2'
>tp-fs-DEBUG: 11/05/2010 12:42:50.200319: stream 2 0x2e604f0 (video) cb_fs_local_candidates_prepared: candidate->ip = '192.168.1.2'
>tp-fs-DEBUG: 11/05/2010 12:42:50.200494: stream 2 0x2e604f0 (video) cb_fs_local_candidates_prepared: candidate->ip = '151.16.55.68'
>tp-fs-DEBUG: 11/05/2010 12:42:50.200527: stream 2 0x2e604f0 (video) cb_fs_local_candidates_prepared: candidate->ip = '151.16.55.68'
>tp-fs-DEBUG: 11/05/2010 12:42:50.200566: stream 2 0x2e604f0 (video) cb_fs_local_candidates_prepared: candidate->ip = '151.16.55.68'
>tp-fs-DEBUG: 11/05/2010 12:42:50.200598: stream 2 0x2e604f0 (video) cb_fs_local_candidates_prepared: candidate->ip = '151.16.55.68'
>tp-fs-DEBUG: 11/05/2010 12:42:50.200763: stream 2 0x2e604f0 (video) cb_fs_local_candidates_prepared: candidate->ip = '209.85.137.126'
>tp-fs-DEBUG: 11/05/2010 12:42:50.200871: stream 2 0x2e604f0 (video) cb_fs_local_candidates_prepared: candidate->ip = '209.85.137.126'
>tp-fs-DEBUG: 11/05/2010 12:42:50.200980: stream 2 0x2e604f0 (video) cb_fs_local_candidates_prepared: candidate->ip = '209.85.137.126'
>tp-fs-DEBUG: 11/05/2010 12:42:50.201090: stream 2 0x2e604f0 (video) cb_fs_local_candidates_prepared: candidate->ip = '209.85.137.126'
>tp-fs-DEBUG: 11/05/2010 12:42:50.201198: stream 2 0x2e604f0 (video) cb_fs_local_candidates_prepared: candidate->ip = '209.85.137.126'
>tp-fs-DEBUG: 11/05/2010 12:42:50.201307: stream 2 0x2e604f0 (video) cb_fs_local_candidates_prepared: candidate->ip = '209.85.137.126'
>tp-fs-DEBUG: 11/05/2010 12:42:51.254882: stream 1 0x2e60400 (audio) add_remote_candidate: adding remote candidate R1
>tp-fs-DEBUG: 11/05/2010 12:42:51.257721: stream 1 0x2e60400 (audio) cb_fs_new_active_candidate_pair: called: c:2 local: 1 192.168.1.2:53413  remote: R1 192.168.1.83:59844
>tp-fs-DEBUG: 11/05/2010 12:42:51.268016: stream 1 0x2e60400 (audio) add_remote_candidate: adding remote candidate R2
>tp-fs-DEBUG: 11/05/2010 12:42:51.271358: stream 1 0x2e60400 (audio) cb_fs_new_active_candidate_pair: called: c:1 local: 1 192.168.1.2:49430  remote: R2 192.168.1.83:59846
>tp-fs-DEBUG: 11/05/2010 12:42:51.281686: stream 2 0x2e604f0 (video) add_remote_candidate: adding remote candidate R1
>empathy/Voip-DEBUG: 11/05/2010 12:42:51.282552: tp_call_stream_state_changed_cb: Stream state changed - stream id: 1, state state: 1
>tp-fs-DEBUG: 11/05/2010 12:42:51.284998: stream 2 0x2e604f0 (video) cb_fs_new_active_candidate_pair: called: c:2 local: 9 192.168.1.2:42992  remote: R1 192.168.1.83:59848
>tp-fs-DEBUG: 11/05/2010 12:42:51.297936: stream 2 0x2e604f0 (video) add_remote_candidate: adding remote candidate R2
>empathy/Voip-DEBUG: 11/05/2010 12:42:51.299020: tp_call_stream_state_changed_cb: Stream state changed - stream id: 1, state state: 1
>tp-fs-DEBUG: 11/05/2010 12:42:51.300646: stream 2 0x2e604f0 (video) cb_fs_new_active_candidate_pair: called: c:1 local: 9 192.168.1.2:46696  remote: R2 192.168.1.83:59850
>tp-fs-DEBUG: 11/05/2010 12:42:51.314781: stream 1 0x2e60400 (audio) add_remote_candidate: adding remote candidate R3
>empathy/Voip-DEBUG: 11/05/2010 12:42:51.316091: tp_call_stream_state_changed_cb: Stream state changed - stream id: 1, state state: 2
>tp-fs-DEBUG: 11/05/2010 12:42:51.330874: stream 2 0x2e604f0 (video) add_remote_candidate: adding remote candidate R3
>empathy/Voip-DEBUG: 11/05/2010 12:42:51.332250: tp_call_stream_state_changed_cb: Stream state changed - stream id: 2, state state: 1
>tp-fs-DEBUG: 11/05/2010 12:42:51.346546: stream 1 0x2e60400 (audio) add_remote_candidate: adding remote candidate R4
>empathy/Voip-DEBUG: 11/05/2010 12:42:51.348218: tp_call_stream_state_changed_cb: Stream state changed - stream id: 2, state state: 1
>tp-fs-DEBUG: 11/05/2010 12:42:51.358376: stream 2 0x2e604f0 (video) add_remote_candidate: adding remote candidate R4
>empathy/Voip-DEBUG: 11/05/2010 12:42:51.359967: tp_call_stream_state_changed_cb: Stream state changed - stream id: 2, state state: 2
>empathy/Voip-DEBUG: 11/05/2010 12:42:51.360399: tp_call_stream_state_changed_cb: Stream state changed - stream id: 1, state state: 1
>empathy/Voip-DEBUG: 11/05/2010 12:42:51.361243: tp_call_stream_state_changed_cb: Stream state changed - stream id: 2, state state: 1
>tp-fs-DEBUG: 11/05/2010 12:42:51.739061: stream 1 0x2e60400 (audio) cb_fs_stream_src_pad_added: New pad src_1_310009376_103: 103: audio SPEEX clock:8000 channels:1 params:(nil)
>empathy/Voip-DEBUG: 11/05/2010 12:42:51.770236: tp_call_stream_state_changed_cb: Stream state changed - stream id: 1, state state: 2
>empathy/Voip-DEBUG: 11/05/2010 12:42:51.832174: tp_call_stream_state_changed_cb: Stream state changed - stream id: 1, state state: 2
>empathy/Voip-DEBUG: 11/05/2010 12:42:51.843961: tp_call_stream_state_changed_cb: Stream state changed - stream id: 2, state state: 2
>empathy/Voip-DEBUG: 11/05/2010 12:42:51.843976: empathy_call_window_video_stream_changed_cb: video stream changed
>tp-fs-DEBUG: 11/05/2010 12:42:52.57569: stream 2 0x2e604f0 (video) set_remote_codecs: called
>tp-fs-DEBUG: 11/05/2010 12:42:52.57595: stream 2 0x2e604f0 (video) set_remote_codecs: adding remote codec H264 [97]
>tp-fs-DEBUG: 11/05/2010 12:42:52.57791: stream 2 0x2e604f0 (video) _tf_stream_try_sending_codecs: called (send_local:0 send_supported:1)
>tp-fs-DEBUG: 11/05/2010 12:42:52.57813: stream 2 0x2e604f0 (video) _tf_stream_try_sending_codecs: 97: video H264 clock:90000 channels:0
>tp-fs-DEBUG: 11/05/2010 12:42:52.57847: stream 2 0x2e604f0 (video) fs_codecs_to_tp: adding codec H264 [97]
>tp-fs-DEBUG: 11/05/2010 12:42:52.57866: stream 2 0x2e604f0 (video) _tf_stream_try_sending_codecs: calling MediaStreamHandler::SupportedCodecs
>tp-fs-DEBUG: 11/05/2010 12:42:52.58001: stream 2 0x2e604f0 (video) _tf_stream_bus_message: Codecs changed
>tp-fs-DEBUG: 11/05/2010 12:42:52.58022: stream 2 0x2e604f0 (video) _tf_stream_try_sending_codecs: called (send_local:0 send_supported:0)
>tp-fs-DEBUG: 11/05/2010 12:42:52.58043: stream 2 0x2e604f0 (video) _tf_stream_try_sending_codecs: 97: video H264 clock:90000 channels:0
>tp-fs-DEBUG: 11/05/2010 12:42:52.58923: stream 2 0x2e604f0 (video) set_stream_sending: 1
>tp-fs-DEBUG: 11/05/2010 12:42:52.58945: stream 2 0x2e604f0 (video) tf_stream_request_resource: Requesting resource for direction 1
>tp-fs-DEBUG: 11/05/2010 12:42:52.58974: stream 2 0x2e604f0 (video) tf_stream_request_resource: Requesting resource for direction 1 returned 1
>tp-fs-DEBUG: 11/05/2010 12:42:52.59777: stream 2 0x2e604f0 (video) set_stream_playing: 1
>tp-fs-DEBUG: 11/05/2010 12:42:52.59798: stream 2 0x2e604f0 (video) tf_stream_request_resource: Requesting resource for direction 2
>tp-fs-DEBUG: 11/05/2010 12:42:52.59823: stream 2 0x2e604f0 (video) tf_stream_request_resource: Requesting resource for direction 2 returned 1
>tp-fs-DEBUG: 11/05/2010 12:42:52.60163: stream 2 0x2e604f0 (video) set_stream_sending: 1
>tp-fs-DEBUG: 11/05/2010 12:42:52.62661: stream 1 0x2e60400 (audio) set_remote_codecs: called
>tp-fs-DEBUG: 11/05/2010 12:42:52.62683: stream 1 0x2e60400 (audio) set_remote_codecs: adding remote codec speex [103]
>tp-fs-DEBUG: 11/05/2010 12:42:52.62700: stream 1 0x2e60400 (audio) set_remote_codecs: adding remote codec speex [104]
>tp-fs-DEBUG: 11/05/2010 12:42:52.62716: stream 1 0x2e60400 (audio) set_remote_codecs: adding remote codec PCMU [0]
>tp-fs-DEBUG: 11/05/2010 12:42:52.62733: stream 1 0x2e60400 (audio) set_remote_codecs: adding remote codec PCMA [8]
>tp-fs-DEBUG: 11/05/2010 12:42:52.62751: stream 1 0x2e60400 (audio) set_remote_codecs: adding remote codec GSM [3]
>tp-fs-DEBUG: 11/05/2010 12:42:52.62767: stream 1 0x2e60400 (audio) set_remote_codecs: adding remote codec telephone-event [101]
>tp-fs-DEBUG: 11/05/2010 12:42:52.63080: stream 1 0x2e60400 (audio) _tf_stream_try_sending_codecs: called (send_local:0 send_supported:1)
>tp-fs-DEBUG: 11/05/2010 12:42:52.63106: stream 1 0x2e60400 (audio) _tf_stream_try_sending_codecs: 103: audio SPEEX clock:8000 channels:1
>tp-fs-DEBUG: 11/05/2010 12:42:52.63121: stream 1 0x2e60400 (audio) _tf_stream_try_sending_codecs: 104: audio SPEEX clock:16000 channels:1
>tp-fs-DEBUG: 11/05/2010 12:42:52.63137: stream 1 0x2e60400 (audio) _tf_stream_try_sending_codecs: 0: audio PCMU clock:8000 channels:0
>tp-fs-DEBUG: 11/05/2010 12:42:52.63150: stream 1 0x2e60400 (audio) _tf_stream_try_sending_codecs: 8: audio PCMA clock:8000 channels:0
>tp-fs-DEBUG: 11/05/2010 12:42:52.63165: stream 1 0x2e60400 (audio) _tf_stream_try_sending_codecs: 3: audio GSM clock:8000 channels:0
>tp-fs-DEBUG: 11/05/2010 12:42:52.63210: stream 1 0x2e60400 (audio) _tf_stream_try_sending_codecs: 101: audio telephone-event clock:8000 channels:0 events=0-15
>tp-fs-DEBUG: 11/05/2010 12:42:52.63245: stream 1 0x2e60400 (audio) fs_codecs_to_tp: adding codec SPEEX [103]
>tp-fs-DEBUG: 11/05/2010 12:42:52.63275: stream 1 0x2e60400 (audio) fs_codecs_to_tp: adding codec SPEEX [104]
>tp-fs-DEBUG: 11/05/2010 12:42:52.63307: stream 1 0x2e60400 (audio) fs_codecs_to_tp: adding codec PCMU [0]
>tp-fs-DEBUG: 11/05/2010 12:42:52.63335: stream 1 0x2e60400 (audio) fs_codecs_to_tp: adding codec PCMA [8]
>tp-fs-DEBUG: 11/05/2010 12:42:52.63364: stream 1 0x2e60400 (audio) fs_codecs_to_tp: adding codec GSM [3]
>tp-fs-DEBUG: 11/05/2010 12:42:52.63400: stream 1 0x2e60400 (audio) fs_codecs_to_tp: adding codec telephone-event [101]
>tp-fs-DEBUG: 11/05/2010 12:42:52.63415: stream 1 0x2e60400 (audio) _tf_stream_try_sending_codecs: calling MediaStreamHandler::SupportedCodecs
>tp-fs-DEBUG: 11/05/2010 12:42:52.63644: stream 1 0x2e60400 (audio) _tf_stream_bus_message: Codecs changed
>tp-fs-DEBUG: 11/05/2010 12:42:52.63662: stream 1 0x2e60400 (audio) _tf_stream_try_sending_codecs: called (send_local:0 send_supported:0)
>tp-fs-DEBUG: 11/05/2010 12:42:52.63687: stream 1 0x2e60400 (audio) _tf_stream_try_sending_codecs: 103: audio SPEEX clock:8000 channels:1
>tp-fs-DEBUG: 11/05/2010 12:42:52.63703: stream 1 0x2e60400 (audio) _tf_stream_try_sending_codecs: 104: audio SPEEX clock:16000 channels:1
>tp-fs-DEBUG: 11/05/2010 12:42:52.63719: stream 1 0x2e60400 (audio) _tf_stream_try_sending_codecs: 0: audio PCMU clock:8000 channels:0
>tp-fs-DEBUG: 11/05/2010 12:42:52.63735: stream 1 0x2e60400 (audio) _tf_stream_try_sending_codecs: 8: audio PCMA clock:8000 channels:0
>tp-fs-DEBUG: 11/05/2010 12:42:52.63750: stream 1 0x2e60400 (audio) _tf_stream_try_sending_codecs: 3: audio GSM clock:8000 channels:0
>tp-fs-DEBUG: 11/05/2010 12:42:52.63767: stream 1 0x2e60400 (audio) _tf_stream_try_sending_codecs: 101: audio telephone-event clock:8000 channels:0 events=0-15
>tp-fs-DEBUG: 11/05/2010 12:42:52.64430: stream 1 0x2e60400 (audio) set_stream_sending: 1
>tp-fs-DEBUG: 11/05/2010 12:42:52.64456: stream 1 0x2e60400 (audio) tf_stream_request_resource: Requesting resource for direction 1
>tp-fs-DEBUG: 11/05/2010 12:42:52.64483: stream 1 0x2e60400 (audio) tf_stream_request_resource: Requesting resource for direction 1 returned 1
>tp-fs-DEBUG: 11/05/2010 12:42:52.64964: stream 1 0x2e60400 (audio) set_stream_playing: 1
>tp-fs-DEBUG: 11/05/2010 12:42:52.64984: stream 1 0x2e60400 (audio) tf_stream_request_resource: Requesting resource for direction 2
>tp-fs-DEBUG: 11/05/2010 12:42:52.65009: stream 1 0x2e60400 (audio) tf_stream_request_resource: Requesting resource for direction 2 returned 1
>tp-fs-DEBUG: 11/05/2010 12:42:52.65366: stream 1 0x2e60400 (audio) set_stream_sending: 1
>tp-fs-DEBUG: 11/05/2010 12:42:52.87032: stream 1 0x2e60400 (audio) _tf_stream_bus_message: Send codec changed: 103: audio SPEEX clock:8000 channels:1 params:(nil)
>tp-fs-DEBUG: 11/05/2010 12:42:52.141516: stream 2 0x2e604f0 (video) _tf_stream_bus_message: Send codec changed: 97: video H264 clock:90000 channels:0 params:(nil)
>tp-fs-DEBUG: 11/05/2010 12:42:52.258460: stream 2 0x2e604f0 (video) cb_fs_stream_src_pad_added: New pad src_2_731575174_98: 98: video H264 clock:90000 channels:0 params:(nil)
>empathy/Voip-DEBUG: 11/05/2010 12:42:52.264918: tp_call_stream_state_changed_cb: Stream state changed - stream id: 2, state state: 2
>empathy/Voip-DEBUG: 11/05/2010 12:42:52.264934: empathy_call_window_video_stream_changed_cb: video stream changed
>tp-fs-DEBUG: 11/05/2010 12:42:53.738078: stream 2 0x2e604f0 (video) _tf_stream_bus_message: Codecs changed
>tp-fs-DEBUG: 11/05/2010 12:42:53.738097: stream 2 0x2e604f0 (video) _tf_stream_try_sending_codecs: called (send_local:0 send_supported:0)
>tp-fs-DEBUG: 11/05/2010 12:42:53.738123: stream 2 0x2e604f0 (video) _tf_stream_try_sending_codecs: 97: video H264 clock:90000 channels:0
>tp-fs-DEBUG: 11/05/2010 12:42:53.843627: stream 2 0x2e604f0 (video) _tf_stream_bus_message: Codecs changed
>tp-fs-DEBUG: 11/05/2010 12:42:53.843647: stream 2 0x2e604f0 (video) _tf_stream_try_sending_codecs: called (send_local:0 send_supported:0)
>tp-fs-DEBUG: 11/05/2010 12:42:53.843677: stream 2 0x2e604f0 (video) _tf_stream_try_sending_codecs: 97: video H264 clock:90000 channels:0
>empathy/Other-DEBUG: 11/05/2010 12:43:00.824304: instance_destroyed_cb: instance for 0x32abe60 destroyed; cleaning up
>empathy/Voip-DEBUG: 11/05/2010 12:43:00.824907: disable_camera: Disable camera
>empathy/Voip-DEBUG: 11/05/2010 12:43:00.824911: display_video_preview: Show self avatar
>empathy/Voip-DEBUG: 11/05/2010 12:43:00.824928: display_video_preview: Show self avatar
>tp-fs-DEBUG: 11/05/2010 12:43:00.825453: tf_channel_dispose
>tp-fs-MESSAGE: 11/05/2010 12:43:00.825474: tf_stream_error: stream error errorno=0 error=UI stopped channel
>tp-fs-MESSAGE: 11/05/2010 12:43:00.827460: tf_stream_error: stream error errorno=0 error=UI stopped channel
>tp-fs-DEBUG: 11/05/2010 12:43:00.830024: _tf_session_dispose
>empathy/Voip-DEBUG: 11/05/2010 12:43:00.830070: empathy_tp_call_close: Closing channel
>empathy/Other-DEBUG: 11/05/2010 12:43:00.835743: user_data_destroyed_cb: user_data for 0x3112c40 destroyed; disconnecting
>empathy/Other-DEBUG: 11/05/2010 12:43:00.835752: user_data_destroyed_cb: user_data for 0x2f59200 destroyed; disconnecting
>empathy/Voip-DEBUG: 11/05/2010 12:43:00.844315: tp_call_stream_error_cb: Stream error on stream 1: UI stopped channel (code: 0)
>empathy/Voip-DEBUG: 11/05/2010 12:43:00.844466: tp_call_stream_removed_cb: Stream removed - stream id: 1
>empathy/Voip-DEBUG: 11/05/2010 12:43:00.844544: tp_call_stream_removed_cb: Stream removed - stream id: 2
>empathy/Dispatcher-DEBUG: 11/05/2010 12:43:00.844619: dispatcher_channel_invalidated_cb: Channel /org/freedesktop/Telepathy/Connection/gabble/jabber/nicolo_2echieffo_40gmail_2ecom_2fb6df5ac1/MediaChannel1 invalidated
>empathy/Voip-DEBUG: 11/05/2010 12:43:00.844625: tp_call_dispose: Disposing: 0x30fa400, 0
>empathy/Voip-DEBUG: 11/05/2010 12:43:00.844657: tp_call_finalize: Finalizing: 0x30fa400

Actions: View

Attachments on bug 28026: 35506 | 35561 | 35562 | 35563

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.