tpsip/events-DEBUG: 10/05/11 20:10:28.419017: tpsip_connection_sofia_callback: event nua_i_invite: 100 Trying tpsip/events-DEBUG: 10/05/11 20:10:28.419845: tpsip_connection_sofia_callback: connection 0xbf6000, refcount 1 tpsip/events-DEBUG: 10/05/11 20:10:28.420175: tpsip_connection_sofia_callback: dispatching to connection 0xbf6000 (unbound handle 0xc04cb0) tpsip/connection-DEBUG: 10/05/11 20:10:28.420545: tpsip_nua_i_invite_cb: Got incoming invite from tpsip/connection-DEBUG: 10/05/11 20:10:28.420859: new_media_channel: channel object path /org/freedesktop/Telepathy/Connection/sofiasip/sip/_3344782_40eu_2evoxalot_2ecom/MediaChannel0 tpsip/media-channel-DEBUG: 10/05/11 20:10:28.426747: tpsip_media_channel_class_init: enter tpsip/media-channel-DEBUG: 10/05/11 20:10:28.427684: tpsip_media_channel_constructed: registering object to dbus path=/org/freedesktop/Telepathy/Connection/sofiasip/sip/_3344782_40eu_2evoxalot_2ecom/MediaChannel0 tpsip/events-DEBUG: 10/05/11 20:10:28.430442: tpsip_connection_sofia_callback: exit tpsip/events-DEBUG: 10/05/11 20:10:28.430568: tpsip_connection_sofia_callback: event nua_i_state: 100 Trying tpsip/events-DEBUG: 10/05/11 20:10:28.430682: tpsip_connection_sofia_callback: connection 0xbf6000, refcount 2 tpsip/events-DEBUG: 10/05/11 20:10:28.430797: tpsip_connection_sofia_callback: dispatching to target 0xbc58e0 (handle 0xc04cb0) tpsip/media-channel-DEBUG: 10/05/11 20:10:28.430921: priv_nua_i_state_cb: call with handle 0xc04cb0 is received tpsip/media-channel-DEBUG: 10/05/11 20:10:28.432092: tpsip_media_channel_handle_incoming_call: has initial audio tpsip/media-channel-DEBUG: 10/05/11 20:10:28.436181: priv_create_session: enter tpsip/media-channel-DEBUG: 10/05/11 20:10:28.436539: priv_create_session: allocating session, peer=2 tpsip/media-channel-DEBUG: 10/05/11 20:10:28.439538: priv_create_session: exit tpsip/media-channel-DEBUG: 10/05/11 20:10:28.439680: priv_session_state_changed_cb: enter tpsip/media-channel-DEBUG: 10/05/11 20:10:28.440562: tpsip_media_session_set_remote_media: enter tpsip/media-channel-DEBUG: 10/05/11 20:10:28.440692: tpsip_media_session_add_stream: enter tpsip/media-channel-DEBUG: 10/05/11 20:10:28.441272: tpsip_media_session_add_stream: exit tpsip/media-channel-DEBUG: 10/05/11 20:10:28.441390: priv_update_remote_media: setting remote SDP for stream 0 tpsip/media-channel-DEBUG: 10/05/11 20:10:28.441504: tpsip_media_stream_set_remote_media: enter tpsip/media-channel-DEBUG: 10/05/11 20:10:28.441618: push_remote_candidates: enter tpsip/media-channel-DEBUG: 10/05/11 20:10:28.441730: push_remote_candidates: the stream engine is not ready, SetRemoteCandidateList is pending tpsip/media-channel-DEBUG: 10/05/11 20:10:28.441843: push_remote_codecs: enter tpsip/media-channel-DEBUG: 10/05/11 20:10:28.441955: push_remote_codecs: the stream engine is not ready, SetRemoteCodecs is pending tpsip/media-channel-DEBUG: 10/05/11 20:10:28.442795: push_active_candidate_pair: enter tpsip/media-channel-DEBUG: 10/05/11 20:10:28.442919: priv_update_remote_hold: the session is remotely unheld tpsip/media-channel-DEBUG: 10/05/11 20:10:28.443034: priv_update_remote_media: exit tpsip/media-channel-DEBUG: 10/05/11 20:10:28.443146: priv_request_response_step: there are local streams not ready, postponed tpsip/events-DEBUG: 10/05/11 20:10:28.443262: tpsip_connection_sofia_callback: exit tpsip/events-DEBUG: 10/05/11 20:10:28.449467: tpsip_connection_sofia_callback: event nua_i_state: 180 Ringing tpsip/events-DEBUG: 10/05/11 20:10:28.449596: tpsip_connection_sofia_callback: connection 0xbf6000, refcount 2 tpsip/events-DEBUG: 10/05/11 20:10:28.449712: tpsip_connection_sofia_callback: dispatching to target 0xbc58e0 (handle 0xc04cb0) tpsip/media-channel-DEBUG: 10/05/11 20:10:28.449831: priv_nua_i_state_cb: call with handle 0xc04cb0 is early tpsip/events-DEBUG: 10/05/11 20:10:28.449945: tpsip_connection_sofia_callback: exit tpsip/connection-DEBUG: 10/05/11 20:10:28.455130: conn_get_alias: handle 2 got alias 245054@voxalot.com tpsip/connection-DEBUG: 10/05/11 20:10:34.694667: conn_get_alias: handle 2 got alias 245054@voxalot.com tpsip/media-channel-DEBUG: 10/05/11 20:10:34.980357: _tpsip_media_channel_add_member: mixin->self_handle=1, handle=1 tpsip/media-channel-DEBUG: 10/05/11 20:10:34.980412: _tpsip_media_channel_add_member: accepting an incoming invite tpsip/media-channel-DEBUG: 10/05/11 20:10:34.980453: tpsip_media_stream_apply_pending_direction: set direction 3, pending send flags 0 tpsip/media-channel-DEBUG: 10/05/11 20:10:34.980520: tpsip_media_stream_apply_pending_direction: remote end ready to receive tpsip/media-channel-DEBUG: 10/05/11 20:10:34.980556: tpsip_media_stream_set_sending: set sending to TRUE tpsip/media-channel-DEBUG: 10/05/11 20:10:34.980591: priv_request_response_step: there are local streams not ready, postponed tpsip/connection-DEBUG: 10/05/11 20:10:35.91824: conn_get_alias: handle 1 got alias 344782@eu.voxalot.com tpsip/media-channel-DEBUG: 10/05/11 20:10:35.93118: tpsip_media_channel_get_session_handlers: enter tpsip/media-channel-DEBUG: 10/05/11 20:10:35.112498: tpsip_media_session_ready: enter tpsip/media-channel-DEBUG: 10/05/11 20:10:35.210074: tpsip_media_stream_ready: enter tpsip/media-channel-DEBUG: 10/05/11 20:10:35.210207: push_remote_candidates: enter tpsip/media-channel-DEBUG: 10/05/11 20:10:35.210273: push_remote_candidates: remote RTP address=<192.168.1.2>, port=<5008> tpsip/media-channel-DEBUG: 10/05/11 20:10:35.210329: push_remote_candidates: remote RTCP address=<192.168.1.2>, port=<5009> tpsip/media-channel-DEBUG: 10/05/11 20:10:35.210396: push_remote_candidates: emitting SetRemoteCandidateList with L1 tpsip/media-channel-DEBUG: 10/05/11 20:10:35.210545: push_remote_codecs: enter tpsip/media-channel-DEBUG: 10/05/11 20:10:35.210968: push_active_candidate_pair: enter tpsip/media-channel-DEBUG: 10/05/11 20:10:35.217602: tpsip_media_stream_supported_codecs: got codec intersection containing 3 codecs from stream-engine tpsip/media-channel-DEBUG: 10/05/11 20:10:35.217653: priv_request_response_step: there are local streams not ready, postponed tpsip/media-channel-DEBUG: 10/05/11 20:10:35.376472: tpsip_media_stream_new_active_candidate_pair: stream engine reported new active candidate pair L1-L1 tpsip/media-channel-DEBUG: 10/05/11 20:10:35.376667: tpsip_media_stream_stream_state: changing stream state from 0 to 2 tpsip/media-channel-DEBUG: 10/05/11 20:10:35.377182: tpsip_media_stream_native_candidates_prepared: enter tpsip/media-channel-DEBUG: 10/05/11 20:10:35.383375: priv_stream_ready_cb: enter tpsip/media-channel-DEBUG: 10/05/11 20:10:35.383498: tpsip_media_stream_set_playing: set playing to TRUE tpsip/media-channel-DEBUG: 10/05/11 20:10:35.383654: tpsip_media_stream_apply_pending_direction: remote end ready to receive tpsip/media-channel-DEBUG: 10/05/11 20:10:35.383755: priv_session_state_changed_cb: enter tpsip/media-channel-DEBUG: 10/05/11 20:10:35.384315: push_active_candidate_pair: enter tpsip/media-channel-DEBUG: 10/05/11 20:10:35.384409: push_active_candidate_pair: emitting SetActiveCandidatePair for L1-L1 tpsip/media-channel-DEBUG: 10/05/11 20:10:35.395736: tpsip_media_stream_new_active_candidate_pair: stream engine reported new active candidate pair L1-L1 tpsip/events-DEBUG: 10/05/11 20:10:35.396457: tpsip_connection_sofia_callback: event nua_i_state: 200 OK tpsip/events-DEBUG: 10/05/11 20:10:35.400356: tpsip_connection_sofia_callback: connection 0xbf6000, refcount 2 tpsip/events-DEBUG: 10/05/11 20:10:35.400499: tpsip_connection_sofia_callback: dispatching to target 0xbc58e0 (handle 0xc04cb0) tpsip/media-channel-DEBUG: 10/05/11 20:10:35.400626: priv_nua_i_state_cb: call with handle 0xc04cb0 is completed tpsip/events-DEBUG: 10/05/11 20:10:35.400865: tpsip_connection_sofia_callback: exit tpsip/events-DEBUG: 10/05/11 20:10:35.696815: tpsip_connection_sofia_callback: event nua_i_ack: 200 OK tpsip/events-DEBUG: 10/05/11 20:10:35.696979: tpsip_connection_sofia_callback: connection 0xbf6000, refcount 2 tpsip/events-DEBUG: 10/05/11 20:10:35.697074: tpsip_connection_sofia_callback: dispatching to target 0xbc58e0 (handle 0xc04cb0) tpsip/events-DEBUG: 10/05/11 20:10:35.697182: tpsip_connection_sofia_callback: event nua_i_ack for target 0xbc58e0 was not consumed tpsip/events-DEBUG: 10/05/11 20:10:35.703558: tpsip_connection_sofia_callback: exit tpsip/events-DEBUG: 10/05/11 20:10:35.703671: tpsip_connection_sofia_callback: event nua_i_state: 200 OK tpsip/events-DEBUG: 10/05/11 20:10:35.703767: tpsip_connection_sofia_callback: connection 0xbf6000, refcount 2 tpsip/events-DEBUG: 10/05/11 20:10:35.703859: tpsip_connection_sofia_callback: dispatching to target 0xbc58e0 (handle 0xc04cb0) tpsip/media-channel-DEBUG: 10/05/11 20:10:35.703967: priv_nua_i_state_cb: call with handle 0xc04cb0 is ready tpsip/events-DEBUG: 10/05/11 20:10:35.704118: tpsip_connection_sofia_callback: exit tpsip/events-DEBUG: 10/05/11 20:10:35.704216: tpsip_connection_sofia_callback: event nua_i_active: 200 Call active tpsip/events-DEBUG: 10/05/11 20:10:35.704305: tpsip_connection_sofia_callback: connection 0xbf6000, refcount 2 tpsip/events-DEBUG: 10/05/11 20:10:35.704396: tpsip_connection_sofia_callback: dispatching to target 0xbc58e0 (handle 0xc04cb0) tpsip/events-DEBUG: 10/05/11 20:10:35.704495: tpsip_connection_sofia_callback: event nua_i_active for target 0xbc58e0 was not consumed tpsip/events-DEBUG: 10/05/11 20:10:35.704586: tpsip_connection_sofia_callback: exit