caugier@minitouf:~/build/gst_17mars/farsight/tests$ ./farsight_test_rtp_4 --gst-debug=alsa*:5,rtpjitterbuffer:^M:5 192.168.18.254 7078 ** Message: looking for plugins in /home/caugier/build/gst_17mars/root//lib/farsight0.1/ opening module /home/caugier/build/gst_17mars/root//lib/farsight0.1/librtp.so succeeded protocol details: name: rtp description: Farsight RTP plugin author: Farsight Project pipeline: alawenc rtpg711pay pipeline: rtpg711depay alsasink ** (lt-farsight_test_rtp_4:1114): DEBUG: adding codec with pt 8, send_pipeline 0x80c3ba0, receive_pipeline 0x80c3bc0 pipeline: gsmenc rtpgsmpay pipeline: rtpgsmdepay gsmdec ** (lt-farsight_test_rtp_4:1114): DEBUG: adding codec with pt 3, send_pipeline 0x80c5c60, receive_pipeline 0x80c5c10 pipeline: mulawenc rtppcmupay pipeline: rtppcmudepay alsasink ** (lt-farsight_test_rtp_4:1114): DEBUG: adding codec with pt 0, send_pipeline 0x80827b0, receive_pipeline 0x80c8f30 pipeline: alawenc rtppcmapay pipeline: rtppcmadepay alsasink ** (lt-farsight_test_rtp_4:1114): DEBUG: adding codec with pt 8, send_pipeline 0x8084910, receive_pipeline 0x80c8f60 pipeline: speexenc rtpspeexpay pipeline: rtpspeexdepay speexdec ** (lt-farsight_test_rtp_4:1114): DEBUG: adding codec with pt 96, send_pipeline 0x80cac00, receive_pipeline 0x80cad70 ** Message: codec: 8: PCMA/8000 found ** Message: codec: 0: PCMU/8000 found ** Message: codec: 3: GSM/8000 found ** Message: codec: 96: speex/8000 found ** Message: codec: 8: PCMA/8000 found ** (lt-farsight_test_rtp_4:1114): DEBUG: The socket was created ** (lt-farsight_test_rtp_4:1114): DEBUG: bound to port 7078 native_candidates_prepared: preparation-complete: stream=0x8081400 ** Message: Local transport candidate: L1 1 UDP RTP 192.168.18.53:7078, pref 1.000000 ** Message: Local transport candidate: L2 1 UDP RTP 127.0.0.1:7078, pref 1.000000 DEBUG (0x804e620 - 0:00:00.316332000) alsa( 1114) gstalsaplugin.c(75):plugin_init: binding text domain gst-plugins-base-0.10 to locale dir /home/caugier/build/gst_17mars/root//share/locale DEBUG (0x804e620 - 0:00:00.317268000) alsa( 1114) gstalsasink.c(298):gst_alsasink_init: initializing alsasink ** (lt-farsight_test_rtp_4:1114): DEBUG: farsight_rtp_stream_set_source (631): setting src ** (lt-farsight_test_rtp_4:1114): DEBUG: farsight_rtp_stream_set_sink (643): setting sink ** Message: farsight_rtp_stream_start (783): creating pipeline with codec 8 0x80deb40 ** (lt-farsight_test_rtp_4:1114): DEBUG: creating send codec bin for id 8, pipeline_factory 0x8084910 ** (lt-farsight_test_rtp_4:1114): DEBUG: adding element alawenc0 ** (lt-farsight_test_rtp_4:1114): DEBUG: adding element rtppmcapay0 ** (lt-farsight_test_rtp_4:1114): DEBUG: linking src 0x80ce6e0 to codec bin 0x80e0800 DEBUG (0x804e620 - 0:00:00.487580000) rtpjitterbuffer( 1114) gstrtpjitterbuffer.c(183):gst_rtp_jitter_buffer_init: init media pipeline: rtpdemux0 send8 audiotestsrc rtpbin0 DEBUG (0x804e620 - 0:00:00.493684000) rtpjitterbuffer( 1114) gstrtpjitterbuffer.c(586):gst_rtp_jitter_buffer_start_thread: Starting queue release thread DEBUG (0x804e620 - 0:00:00.494300000) rtpjitterbuffer( 1114) gstrtpjitterbuffer.c(590):gst_rtp_jitter_buffer_start_thread: Started queue release thread DEBUG (0x804e620 - 0:00:00.495415000) rtpjitterbuffer( 1114) gstrtpjitterbuffer.c(362):gst_rtp_jitter_buffer_handle_sink_event: Upstream sent a NEWSEGMENT, handle in worker thread. DEBUG (0x8101d68 - 0:00:00.584811000) rtpjitterbuffer( 1114) gstrtpjitterbuffer.c(619):gst_rtp_jitter_buffer_wait: Not able to use pipeline clock yet state_changed: 0x8081400 playing DEBUG (0x8101d20 - 0:00:00.588492000) rtpjitterbuffer( 1114) gstrtpjitterbuffer.c(298):gst_rtp_jitter_buffer_chain: Pushing directly! DEBUG (0x8101d20 - 0:00:00.589200000) rtpjitterbuffer( 1114) gstrtpjitterbuffer.c(486):gst_rtp_jitter_buffer_set_gst_timestamp: calculating ts : timestamp : 2009994396, clockrate : 8000 DEBUG (0x8101d20 - 0:00:00.589525000) rtpjitterbuffer( 1114) gstrtpjitterbuffer.c(492):gst_rtp_jitter_buffer_set_gst_timestamp: calculated ts 69:47:29.299500000 DEBUG (0x8101d20 - 0:00:00.589888000) rtpjitterbuffer( 1114) gstrtpjitterbuffer.c(510):gst_rtp_jitter_buffer_set_gst_timestamp: Pushed newsegment event on this first buffer DEBUG (0x8101d20 - 0:00:00.590214000) rtpjitterbuffer( 1114) gstrtpjitterbuffer.c(466):gst_rtp_jitter_buffer_push: Pushing buffer size 112 ** Message: farsight_rtp_stream_create_new_pt_recv_pipeline (407): active PT change to 8 ** Message: farsight_rtp_stream_create_new_pt_recv_pipeline (419): setting up new pipeline for id=8 ** (lt-farsight_test_rtp_4:1114): DEBUG: creating recv codec bin for id 8, pipeline_factory 0x80c8f60 ** (lt-farsight_test_rtp_4:1114): DEBUG: adding element rtppcmadepay0 DEBUG (0x8101d20 - 0:00:00.592699000) alsa( 1114) gstalsasink.c(298):gst_alsasink_init: initializing alsasink ** (lt-farsight_test_rtp_4:1114): DEBUG: adding element alsasink1 DEBUG (0x8101d20 - 0:00:00.593590000) alsa( 1114) gstalsasink.c(454):gst_alsasink_getcaps: device not open, using template caps codec_changed: codec-changed: codec_id=8, stream=0x8081400 ** (lt-farsight_test_rtp_4:1114): DEBUG: farsight_rtp_stream_create_new_pt_recv_pipeline: setting state to playing ** (lt-farsight_test_rtp_4:1114): DEBUG: farsight_rtp_stream_create_new_pt_recv_pipeline: set state to playing DEBUG (0x8101d20 - 0:00:00.665536000) alsa( 1114) gstalsasink.c(580):set_hwparams: Negotiating to 1 channels @ 8000 Hz DEBUG (0x8101d20 - 0:00:00.668670000) rtpjitterbuffer( 1114) gstrtpjitterbuffer.c(468):gst_rtp_jitter_buffer_push: Pushed buffer DEBUG (0x8101d20 - 0:00:00.669126000) rtpjitterbuffer( 1114) gstrtpjitterbuffer.c(298):gst_rtp_jitter_buffer_chain: Pushing directly! DEBUG (0x8101d20 - 0:00:00.669428000) rtpjitterbuffer( 1114) gstrtpjitterbuffer.c(486):gst_rtp_jitter_buffer_set_gst_timestamp: calculating ts : timestamp : 2009994396, clockrate : 8000 DEBUG (0x8101d20 - 0:00:00.669751000) rtpjitterbuffer( 1114) gstrtpjitterbuffer.c(492):gst_rtp_jitter_buffer_set_gst_timestamp: calculated ts 69:47:29.299500000 DEBUG (0x8101d20 - 0:00:00.670077000) rtpjitterbuffer( 1114) gstrtpjitterbuffer.c(466):gst_rtp_jitter_buffer_push: Pushing buffer size 112 DEBUG (0x8101d20 - 0:00:00.670435000) rtpjitterbuffer( 1114) gstrtpjitterbuffer.c(468):gst_rtp_jitter_buffer_push: Pushed buffer DEBUG (0x8101d20 - 0:00:00.670764000) rtpjitterbuffer( 1114) gstrtpjitterbuffer.c(298):gst_rtp_jitter_buffer_chain: Pushing directly! DEBUG (0x8101d20 - 0:00:00.671066000) rtpjitterbuffer( 1114) gstrtpjitterbuffer.c(486):gst_rtp_jitter_buffer_set_gst_timestamp: calculating ts : timestamp : 2009994396, clockrate : 8000 DEBUG (0x8101d20 - 0:00:00.671383000) rtpjitterbuffer( 1114) gstrtpjitterbuffer.c(492):gst_rtp_jitter_buffer_set_gst_timestamp: calculated ts 69:47:29.299500000 DEBUG (0x8101d20 - 0:00:00.671695000) rtpjitterbuffer( 1114) gstrtpjitterbuffer.c(466):gst_rtp_jitter_buffer_push: Pushing buffer size 112 DEBUG (0x8101d20 - 0:00:00.672055000) rtpjitterbuffer( 1114) gstrtpjitterbuffer.c(468):gst_rtp_jitter_buffer_push: Pushed buffer DEBUG (0x8101d20 - 0:00:00.672381000) rtpjitterbuffer( 1114) gstrtpjitterbuffer.c(298):gst_rtp_jitter_buffer_chain: Pushing directly! DEBUG (0x8101d20 - 0:00:00.672669000) rtpjitterbuffer( 1114) gstrtpjitterbuffer.c(486):gst_rtp_jitter_buffer_set_gst_timestamp: calculating ts : timestamp : 2009994396, clockrate : 8000 DEBUG (0x8101d20 - 0:00:00.673001000) rtpjitterbuffer( 1114) gstrtpjitterbuffer.c(492):gst_rtp_jitter_buffer_set_gst_timestamp: calculated ts 69:47:29.299500000 ... ... ... DEBUG (0x8101d20 - 0:00:01.429337000) rtpjitterbuffer( 1114) gstrtpjitterbuffer.c(492):gst_rtp_jitter_buffer_set_gst_timestamp: calculated ts 69:47:29.683500000 DEBUG (0x8101d20 - 0:00:01.429664000) rtpjitterbuffer( 1114) gstrtpjitterbuffer.c(466):gst_rtp_jitter_buffer_push: Pushing buffer size 112 DEBUG (0x8101d20 - 0:00:01.430033000) rtpjitterbuffer( 1114) gstrtpjitterbuffer.c(468):gst_rtp_jitter_buffer_push: Pushed buffer DEBUG (0x8101d20 - 0:00:01.430508000) rtpjitterbuffer( 1114) gstrtpjitterbuffer.c(298):gst_rtp_jitter_buffer_chain: Pushing directly! DEBUG (0x8101d20 - 0:00:01.430811000) rtpjitterbuffer( 1114) gstrtpjitterbuffer.c(486):gst_rtp_jitter_buffer_set_gst_timestamp: calculating ts : timestamp : 2009997468, clockrate : 8000 DEBUG (0x8101d20 - 0:00:01.440614000) rtpjitterbuffer( 1114) gstrtpjitterbuffer.c(492):gst_rtp_jitter_buffer_set_gst_timestamp: calculated ts 69:47:29.683500000 DEBUG (0x8101d20 - 0:00:01.440975000) rtpjitterbuffer( 1114) gstrtpjitterbuffer.c(466):gst_rtp_jitter_buffer_push: Pushing buffer size 112 DEBUG (0x8124878 - 0:00:01.441529000) alsa( 1114) gstalsasink.c(1003):gst_alsasink_write: written 170 result 170 DEBUG (0x8124878 - 0:00:01.441714000) alsa( 1114) gstalsasink.c(1003):gst_alsasink_write: written 170 result 170 DEBUG (0x8124878 - 0:00:01.441882000) alsa( 1114) gstalsasink.c(1003):gst_alsasink_write: written 170 result 170 DEBUG (0x8124878 - 0:00:01.442042000) alsa( 1114) gstalsasink.c(1003):gst_alsasink_write: written 170 result 170 DEBUG (0x8124878 - 0:00:01.442195000) alsa( 1114) gstalsasink.c(1003):gst_alsasink_write: written 170 result 170 DEBUG (0x8124878 - 0:00:01.442354000) alsa( 1114) gstalsasink.c(1003):gst_alsasink_write: written 170 result 170 DEBUG (0x8124878 - 0:00:01.442507000) alsa( 1114) gstalsasink.c(1003):gst_alsasink_write: written 170 result 170 DEBUG (0x8124878 - 0:00:01.442668000) alsa( 1114) gstalsasink.c(1003):gst_alsasink_write: written 170 result 170 DEBUG (0x8124878 - 0:00:01.442840000) alsa( 1114) gstalsasink.c(1003):gst_alsasink_write: written 170 result 170 DEBUG (0x8124878 - 0:00:01.443000000) alsa( 1114) gstalsasink.c(1003):gst_alsasink_write: written 170 result 170 DEBUG (0x8124878 - 0:00:01.443153000) alsa( 1114) gstalsasink.c(1003):gst_alsasink_write: written 170 result 170 DEBUG (0x8124878 - 0:00:01.443311000) alsa( 1114) gstalsasink.c(1003):gst_alsasink_write: written 170 result 170 DEBUG (0x8124878 - 0:00:01.443465000) alsa( 1114) gstalsasink.c(1003):gst_alsasink_write: written 170 result 170 DEBUG (0x8124878 - 0:00:01.443624000) alsa( 1114) gstalsasink.c(1003):gst_alsasink_write: written 170 result 170 DEBUG (0x8124878 - 0:00:01.443777000) alsa( 1114) gstalsasink.c(1003):gst_alsasink_write: written 170 result 170 DEBUG (0x8124878 - 0:00:01.444824000) alsa( 1114) gstalsasink.c(1003):gst_alsasink_write: written 170 result 170 DEBUG (0x8124878 - 0:00:01.482024000) alsa( 1114) gstalsasink.c(1003):gst_alsasink_write: written 170 result 170 DEBUG (0x8124878 - 0:00:01.502493000) alsa( 1114) gstalsasink.c(1003):gst_alsasink_write: written 170 result 170 DEBUG (0x8124878 - 0:00:01.521343000) alsa( 1114) gstalsasink.c(1003):gst_alsasink_write: written 170 result 170 DEBUG (0x8124878 - 0:00:01.542653000) alsa( 1114) gstalsasink.c(1003):gst_alsasink_write: written 170 result 170 DEBUG (0x8124878 - 0:00:01.565038000) alsa( 1114) gstalsasink.c(1003):gst_alsasink_write: written 170 result 170 DEBUG (0x8124878 - 0:00:01.585323000) alsa( 1114) gstalsasink.c(1003):gst_alsasink_write: written 170 result 170 DEBUG (0x8101d68 - 0:00:01.595800000) rtpjitterbuffer( 1114) gstrtpjitterbuffer.c(619):gst_rtp_jitter_buffer_wait: Not able to use pipeline clock yet DEBUG (0x8124878 - 0:00:01.606625000) alsa( 1114) gstalsasink.c(1003):gst_alsasink_write: written 170 result 170