rendered paste bodytelepathy-voip-engine[2501]: GLIB MESSAGE default - socket state changed to 1
telepathy-voip-engine[2501]: GLIB MESSAGE default - new_active_candidate_pair: new-active-candidate-pair: stream=0x81750
telepathy-voip-engine[2501]: GLIB MESSAGE default - state_changed: 0x81750 connected
telepathy-voip-engine[2501]: GLIB MESSAGE default - check_start_stream: calling start on farsight stream 0x81750
telepathy-voip-engine[2501]: GLIB MESSAGE default - farsight_rtp_stream_start (1134): creating pipeline with codec 102
DEBUG (0x1dd00 - 0:00:26.909058000) GST_BUS( 2501) gstbus.c(219):gst_bus_init:<GstBus@0xbc408> created
DEBUG (0x1dd00 - 0:00:26.910187000) GST_BUS( 2501) gstbus.c(291):gst_bus_new:<bus0> created new bus
DEBUG (0x1dd00 - 0:00:26.910950000) GST_BUS( 2501) gstbus.c(219):gst_bus_init:<GstBus@0xbc460> created
DEBUG (0x1dd00 - 0:00:26.911835000) GST_BUS( 2501) gstbus.c(291):gst_bus_new:<bus1> created new bus
DEBUG (0x1dd00 - 0:00:26.913239000) GST_BUS( 2501) gstbus.c(718):gst_bus_add_watch_full:<bus1> New source 0xb0100
DEBUG (0x1dd00 - 0:00:27.145539000) GST_BUS( 2501) gstbus.c(219):gst_bus_init:<GstBus@0xbc4b8> created
DEBUG (0x1dd00 - 0:00:27.146302000) GST_BUS( 2501) gstbus.c(291):gst_bus_new:<bus2> created new bus
DEBUG (0x1dd00 - 0:00:27.153839000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus1> [msg 0x29048] posting on bus, type clock-provide
DEBUG (0x1dd00 - 0:00:27.154327000) GST_BUS( 2501) gstbus.c(350):gst_bus_post:<bus1> [msg 0x29048] pushing on async queue
DEBUG (0x1dd00 - 0:00:27.154816000) GST_BUS( 2501) gstbus.c(354):gst_bus_post:<bus1> [msg 0x29048] pushed on async queue
telepathy-voip-engine[2501]: GLIB MESSAGE default - added icesink 0xc8148 icesrc 0xc6018 to pipeline 0xbd048
telepathy-voip-engine[2501]: GLIB DEBUG default - creating send codec bin for id 102, pipeline_factory 0x9ead0
DEBUG (0x1dd00 - 0:00:27.226136000) GST_BUS( 2501) gstbus.c(219):gst_bus_init:<GstBus@0xbc510> created
DEBUG (0x1dd00 - 0:00:27.226899000) GST_BUS( 2501) gstbus.c(291):gst_bus_new:<bus3> created new bus
telepathy-voip-engine[2501]: GLIB DEBUG default - setting frame size to 30ms on dspilbcsrc
telepathy-voip-engine[2511]: GLIB MESSAGE default - uPnP event handler called
DEBUG (0x1dd00 - 0:00:27.518891000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus1> [msg 0x29108] posting on bus, type clock-provide
DEBUG (0x1dd00 - 0:00:27.521424000) GST_BUS( 2501) gstbus.c(350):gst_bus_post:<bus1> [msg 0x29108] pushing on async queue
DEBUG (0x1dd00 - 0:00:27.523591000) GST_BUS( 2501) gstbus.c(354):gst_bus_post:<bus1> [msg 0x29108] pushed on async queue
DEBUG (0x1dd00 - 0:00:27.640320000) GST_BUS( 2501) gstbus.c(463):gst_bus_set_flushing:<bus1> unset bus flushing
DEBUG (0x1dd00 - 0:00:27.647645000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus0> [msg 0x29188] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:27.649903000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus1> [msg 0x29188] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:27.652222000) GST_BUS( 2501) gstbus.c(350):gst_bus_post:<bus1> [msg 0x29188] pushing on async queue
DEBUG (0x1dd00 - 0:00:27.654388000) GST_BUS( 2501) gstbus.c(354):gst_bus_post:<bus1> [msg 0x29188] pushed on async queue
DEBUG (0x1dd00 - 0:00:27.655945000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus0> [msg 0x29188] dropped
DEBUG (0x1dd00 - 0:00:27.663544000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus0> [msg 0x291c8] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:27.667328000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus1> [msg 0x291c8] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:27.669800000) GST_BUS( 2501) gstbus.c(350):gst_bus_post:<bus1> [msg 0x291c8] pushing on async queue
DEBUG (0x1dd00 - 0:00:27.672485000) GST_BUS( 2501) gstbus.c(354):gst_bus_post:<bus1> [msg 0x291c8] pushed on async queue
DEBUG (0x1dd00 - 0:00:27.674683000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus0> [msg 0x291c8] dropped
DEBUG (0x1dd00 - 0:00:27.679200000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus2> [msg 0x29208] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:27.680817000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus0> [msg 0x29208] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:27.682922000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus1> [msg 0x29208] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:27.684265000) GST_BUS( 2501) gstbus.c(350):gst_bus_post:<bus1> [msg 0x29208] pushing on async queue
DEBUG (0x1dd00 - 0:00:27.697418000) GST_BUS( 2501) gstbus.c(354):gst_bus_post:<bus1> [msg 0x29208] pushed on async queue
DEBUG (0x1dd00 - 0:00:27.699860000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus0> [msg 0x29208] dropped
DEBUG (0x1dd00 - 0:00:27.704102000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus2> [msg 0x29208] dropped
DEBUG (0x1dd00 - 0:00:27.706849000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus2> [msg 0x29248] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:27.708252000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus0> [msg 0x29248] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:27.710022000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus1> [msg 0x29248] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:27.718903000) GST_BUS( 2501) gstbus.c(350):gst_bus_post:<bus1> [msg 0x29248] pushing on async queue
DEBUG (0x1dd00 - 0:00:27.720826000) GST_BUS( 2501) gstbus.c(354):gst_bus_post:<bus1> [msg 0x29248] pushed on async queue
DEBUG (0x1dd00 - 0:00:27.722168000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus0> [msg 0x29248] dropped
DEBUG (0x1dd00 - 0:00:27.723511000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus2> [msg 0x29248] dropped
DEBUG (0x1dd00 - 0:00:27.725312000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus2> [msg 0x29288] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:27.728394000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus0> [msg 0x29288] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:27.729919000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus1> [msg 0x29288] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:27.731323000) GST_BUS( 2501) gstbus.c(350):gst_bus_post:<bus1> [msg 0x29288] pushing on async queue
DEBUG (0x1dd00 - 0:00:27.732666000) GST_BUS( 2501) gstbus.c(354):gst_bus_post:<bus1> [msg 0x29288] pushed on async queue
DEBUG (0x1dd00 - 0:00:27.734009000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus0> [msg 0x29288] dropped
DEBUG (0x1dd00 - 0:00:27.735382000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus2> [msg 0x29288] dropped
DEBUG (0x1dd00 - 0:00:27.739747000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus0> [msg 0x292c8] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:27.741211000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus1> [msg 0x292c8] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:27.742554000) GST_BUS( 2501) gstbus.c(350):gst_bus_post:<bus1> [msg 0x292c8] pushing on async queue
DEBUG (0x1dd00 - 0:00:27.743927000) GST_BUS( 2501) gstbus.c(354):gst_bus_post:<bus1> [msg 0x292c8] pushed on async queue
DEBUG (0x1dd00 - 0:00:27.745361000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus0> [msg 0x292c8] dropped
DEBUG (0x1dd00 - 0:00:27.748871000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus0> [msg 0x29308] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:27.750397000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus1> [msg 0x29308] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:27.751770000) GST_BUS( 2501) gstbus.c(350):gst_bus_post:<bus1> [msg 0x29308] pushing on async queue
DEBUG (0x1dd00 - 0:00:27.755738000) GST_BUS( 2501) gstbus.c(354):gst_bus_post:<bus1> [msg 0x29308] pushed on async queue
DEBUG (0x1dd00 - 0:00:27.757142000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus0> [msg 0x29308] dropped
DEBUG (0x1dd00 - 0:00:27.759217000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus3> [msg 0x29348] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:27.761169000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus0> [msg 0x29348] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:27.763000000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus1> [msg 0x29348] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:27.764374000) GST_BUS( 2501) gstbus.c(350):gst_bus_post:<bus1> [msg 0x29348] pushing on async queue
DEBUG (0x1dd00 - 0:00:27.765717000) GST_BUS( 2501) gstbus.c(354):gst_bus_post:<bus1> [msg 0x29348] pushed on async queue
DEBUG (0x1dd00 - 0:00:27.767090000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus0> [msg 0x29348] dropped
DEBUG (0x1dd00 - 0:00:27.768921000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus3> [msg 0x29348] dropped
DEBUG (0x1dd00 - 0:00:27.770722000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus3> [msg 0x29388] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:27.773774000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus0> [msg 0x29388] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:27.775239000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus1> [msg 0x29388] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:27.776672000) GST_BUS( 2501) gstbus.c(350):gst_bus_post:<bus1> [msg 0x29388] pushing on async queue
DEBUG (0x1dd00 - 0:00:27.778015000) GST_BUS( 2501) gstbus.c(354):gst_bus_post:<bus1> [msg 0x29388] pushed on async queue
DEBUG (0x1dd00 - 0:00:27.779785000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus0> [msg 0x29388] dropped
DEBUG (0x1dd00 - 0:00:27.781128000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus3> [msg 0x29388] dropped
DEBUG (0x1dd00 - 0:00:27.782898000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus0> [msg 0x29410] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:27.786377000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus1> [msg 0x29410] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:27.787720000) GST_BUS( 2501) gstbus.c(350):gst_bus_post:<bus1> [msg 0x29410] pushing on async queue
DEBUG (0x1dd00 - 0:00:27.789063000) GST_BUS( 2501) gstbus.c(354):gst_bus_post:<bus1> [msg 0x29410] pushed on async queue
DEBUG (0x1dd00 - 0:00:27.790467000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus0> [msg 0x29410] dropped
DEBUG (0x1dd00 - 0:00:27.793579000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus1> [msg 0x29450] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:27.794952000) GST_BUS( 2501) gstbus.c(350):gst_bus_post:<bus1> [msg 0x29450] pushing on async queue
DEBUG (0x1dd00 - 0:00:27.796326000) GST_BUS( 2501) gstbus.c(354):gst_bus_post:<bus1> [msg 0x29450] pushed on async queue
DEBUG (0x1dd00 - 0:00:27.800507000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus0> [msg 0x29490] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:27.804596000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus1> [msg 0x29490] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:27.806397000) GST_BUS( 2501) gstbus.c(350):gst_bus_post:<bus1> [msg 0x29490] pushing on async queue
DEBUG (0x1dd00 - 0:00:27.808166000) GST_BUS( 2501) gstbus.c(354):gst_bus_post:<bus1> [msg 0x29490] pushed on async queue
DEBUG (0x1dd00 - 0:00:27.809540000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus0> [msg 0x29490] dropped
DEBUG (0x1dd00 - 0:00:27.811981000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus2> [msg 0x294d0] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:27.813416000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus0> [msg 0x294d0] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:27.814911000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus1> [msg 0x294d0] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:27.816346000) GST_BUS( 2501) gstbus.c(350):gst_bus_post:<bus1> [msg 0x294d0] pushing on async queue
DEBUG (0x1dd00 - 0:00:27.819367000) GST_BUS( 2501) gstbus.c(354):gst_bus_post:<bus1> [msg 0x294d0] pushed on async queue
DEBUG (0x1dd00 - 0:00:27.820771000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus0> [msg 0x294d0] dropped
DEBUG (0x1dd00 - 0:00:27.822114000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus2> [msg 0x294d0] dropped
DEBUG (0x1dd00 - 0:00:27.824249000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus2> [msg 0x29510] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:27.825714000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus0> [msg 0x29510] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:27.827148000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus1> [msg 0x29510] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:27.828522000) GST_BUS( 2501) gstbus.c(350):gst_bus_post:<bus1> [msg 0x29510] pushing on async queue
DEBUG (0x1dd00 - 0:00:27.829864000) GST_BUS( 2501) gstbus.c(354):gst_bus_post:<bus1> [msg 0x29510] pushed on async queue
DEBUG (0x1dd00 - 0:00:27.831391000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus0> [msg 0x29510] dropped
DEBUG (0x1dd00 - 0:00:27.832734000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus2> [msg 0x29510] dropped
DEBUG (0x1dd00 - 0:00:27.834778000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus2> [msg 0x29550] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:27.836243000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus0> [msg 0x29550] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:27.837677000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus1> [msg 0x29550] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:27.839478000) GST_BUS( 2501) gstbus.c(350):gst_bus_post:<bus1> [msg 0x29550] pushing on async queue
DEBUG (0x1dd00 - 0:00:27.840851000) GST_BUS( 2501) gstbus.c(354):gst_bus_post:<bus1> [msg 0x29550] pushed on async queue
DEBUG (0x1dd00 - 0:00:27.850251000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus0> [msg 0x29550] dropped
DEBUG (0x1dd00 - 0:00:27.851593000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus2> [msg 0x29550] dropped
DEBUG (0x1dd00 - 0:00:27.853912000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus0> [msg 0x29590] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:27.855347000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus1> [msg 0x29590] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:27.856720000) GST_BUS( 2501) gstbus.c(350):gst_bus_post:<bus1> [msg 0x29590] pushing on async queue
DEBUG (0x1dd00 - 0:00:27.858063000) GST_BUS( 2501) gstbus.c(354):gst_bus_post:<bus1> [msg 0x29590] pushed on async queue
DEBUG (0x1dd00 - 0:00:27.859802000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus0> [msg 0x29590] dropped
DEBUG (0x1dd00 - 0:00:27.866578000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus0> [msg 0x295d0] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:27.868348000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus1> [msg 0x295d0] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:27.869843000) GST_BUS( 2501) gstbus.c(350):gst_bus_post:<bus1> [msg 0x295d0] pushing on async queue
DEBUG (0x1dd00 - 0:00:27.871216000) GST_BUS( 2501) gstbus.c(354):gst_bus_post:<bus1> [msg 0x295d0] pushed on async queue
DEBUG (0x1dd00 - 0:00:27.872589000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus0> [msg 0x295d0] dropped
DEBUG (0x1dd00 - 0:00:27.875214000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus3> [msg 0x29610] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:27.876648000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus0> [msg 0x29610] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:27.878174000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus1> [msg 0x29610] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:27.879517000) GST_BUS( 2501) gstbus.c(350):gst_bus_post:<bus1> [msg 0x29610] pushing on async queue
DEBUG (0x1dd00 - 0:00:27.880890000) GST_BUS( 2501) gstbus.c(354):gst_bus_post:<bus1> [msg 0x29610] pushed on async queue
DEBUG (0x1dd00 - 0:00:27.882264000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus0> [msg 0x29610] dropped
DEBUG (0x1dd00 - 0:00:27.883606000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus3> [msg 0x29610] dropped
telepathy-voip-engine[2511]: GLIB MESSAGE default - uPnP event handler called
DEBUG (0x1dd00 - 0:00:30.896332000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus3> [msg 0x29650] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:30.896851000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus0> [msg 0x29650] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:30.897309000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus1> [msg 0x29650] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:30.897675000) GST_BUS( 2501) gstbus.c(350):gst_bus_post:<bus1> [msg 0x29650] pushing on async queue
DEBUG (0x1dd00 - 0:00:30.898041000) GST_BUS( 2501) gstbus.c(354):gst_bus_post:<bus1> [msg 0x29650] pushed on async queue
DEBUG (0x1dd00 - 0:00:30.898407000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus0> [msg 0x29650] dropped
DEBUG (0x1dd00 - 0:00:30.898774000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus3> [msg 0x29650] dropped
DEBUG (0x1dd00 - 0:00:30.899811000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus0> [msg 0x29690] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:30.900300000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus1> [msg 0x29690] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:30.904449000) GST_BUS( 2501) gstbus.c(350):gst_bus_post:<bus1> [msg 0x29690] pushing on async queue
DEBUG (0x1dd00 - 0:00:30.905243000) GST_BUS( 2501) gstbus.c(354):gst_bus_post:<bus1> [msg 0x29690] pushed on async queue
DEBUG (0x1dd00 - 0:00:30.905731000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus0> [msg 0x29690] dropped
DEBUG (0x1dd00 - 0:00:30.907349000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus1> [msg 0x296d0] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:30.907776000) GST_BUS( 2501) gstbus.c(350):gst_bus_post:<bus1> [msg 0x296d0] pushing on async queue
DEBUG (0x1dd00 - 0:00:30.911591000) GST_BUS( 2501) gstbus.c(354):gst_bus_post:<bus1> [msg 0x296d0] pushed on async queue
DEBUG (0x1dd00 - 0:00:30.914490000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus1> [msg 0x29710] posting on bus, type new-clock
DEBUG (0x1dd00 - 0:00:30.914948000) GST_BUS( 2501) gstbus.c(350):gst_bus_post:<bus1> [msg 0x29710] pushing on async queue
DEBUG (0x1dd00 - 0:00:30.915345000) GST_BUS( 2501) gstbus.c(354):gst_bus_post:<bus1> [msg 0x29710] pushed on async queue
DEBUG (0x1dd00 - 0:00:30.919891000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus0> [msg 0x29750] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:30.920990000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus1> [msg 0x29750] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:30.921387000) GST_BUS( 2501) gstbus.c(350):gst_bus_post:<bus1> [msg 0x29750] pushing on async queue
DEBUG (0x1dd00 - 0:00:30.921783000) GST_BUS( 2501) gstbus.c(354):gst_bus_post:<bus1> [msg 0x29750] pushed on async queue
DEBUG (0x1dd00 - 0:00:30.922180000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus0> [msg 0x29750] dropped
DEBUG (0x1dd00 - 0:00:30.923614000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus2> [msg 0x29790] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:30.927369000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus0> [msg 0x29790] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:30.928437000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus1> [msg 0x29790] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:30.928925000) GST_BUS( 2501) gstbus.c(350):gst_bus_post:<bus1> [msg 0x29790] pushing on async queue
DEBUG (0x1dd00 - 0:00:30.929322000) GST_BUS( 2501) gstbus.c(354):gst_bus_post:<bus1> [msg 0x29790] pushed on async queue
DEBUG (0x1dd00 - 0:00:30.929718000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus0> [msg 0x29790] dropped
DEBUG (0x1dd00 - 0:00:30.930115000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus2> [msg 0x29790] dropped
DEBUG (0x1dd00 - 0:00:30.930970000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus2> [msg 0xec818] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:30.931458000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus0> [msg 0xec818] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:30.936340000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus1> [msg 0xec818] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:30.937195000) GST_BUS( 2501) gstbus.c(350):gst_bus_post:<bus1> [msg 0xec818] pushing on async queue
DEBUG (0x1dd00 - 0:00:30.938080000) GST_BUS( 2501) gstbus.c(354):gst_bus_post:<bus1> [msg 0xec818] pushed on async queue
DEBUG (0x1dd00 - 0:00:30.938538000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus0> [msg 0xec818] dropped
DEBUG (0x1dd00 - 0:00:30.938934000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus2> [msg 0xec818] dropped
DEBUG (0x1dd00 - 0:00:30.939850000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus2> [msg 0xec858] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:30.940339000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus0> [msg 0xec858] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:30.940766000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus1> [msg 0xec858] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:30.941132000) GST_BUS( 2501) gstbus.c(350):gst_bus_post:<bus1> [msg 0xec858] pushing on async queue
DEBUG (0x1dd00 - 0:00:30.941498000) GST_BUS( 2501) gstbus.c(354):gst_bus_post:<bus1> [msg 0xec858] pushed on async queue
DEBUG (0x1dd00 - 0:00:30.941864000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus0> [msg 0xec858] dropped
DEBUG (0x1dd00 - 0:00:30.942231000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus2> [msg 0xec858] dropped
DEBUG (0x1dd00 - 0:00:30.942994000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus0> [msg 0xec898] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:30.943421000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus1> [msg 0xec898] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:30.943818000) GST_BUS( 2501) gstbus.c(350):gst_bus_post:<bus1> [msg 0xec898] pushing on async queue
DEBUG (0x1dd00 - 0:00:30.944153000) GST_BUS( 2501) gstbus.c(354):gst_bus_post:<bus1> [msg 0xec898] pushed on async queue
DEBUG (0x1dd00 - 0:00:30.944520000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus0> [msg 0xec898] dropped
telepathy-voip-engine[2501]: GLIB MESSAGE default - Connected to ReadPacket
telepathy-voip-engine[2501]: GLIB MESSAGE default - mutex is 0xeafb8
DEBUG (0x1dd00 - 0:00:30.957154000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus0> [msg 0xec8d8] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:30.957673000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus1> [msg 0xec8d8] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:30.958069000) GST_BUS( 2501) gstbus.c(350):gst_bus_post:<bus1> [msg 0xec8d8] pushing on async queue
DEBUG (0x1dd00 - 0:00:30.958436000) GST_BUS( 2501) gstbus.c(354):gst_bus_post:<bus1> [msg 0xec8d8] pushed on async queue
DEBUG (0x1dd00 - 0:00:30.959351000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus0> [msg 0xec8d8] dropped
DEBUG (0x1dd00 - 0:00:30.960572000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus3> [msg 0xec918] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:30.961030000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus0> [msg 0xec918] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:30.961457000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus1> [msg 0xec918] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:30.961823000) GST_BUS( 2501) gstbus.c(350):gst_bus_post:<bus1> [msg 0xec918] pushing on async queue
DEBUG (0x1dd00 - 0:00:30.962189000) GST_BUS( 2501) gstbus.c(354):gst_bus_post:<bus1> [msg 0xec918] pushed on async queue
DEBUG (0x1dd00 - 0:00:30.962555000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus0> [msg 0xec918] dropped
DEBUG (0x1dd00 - 0:00:30.963013000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus3> [msg 0xec918] dropped
DEBUG (0x1dd00 - 0:00:30.963837000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus3> [msg 0xec958] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:30.964294000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus0> [msg 0xec958] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:30.964722000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus1> [msg 0xec958] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:30.965088000) GST_BUS( 2501) gstbus.c(350):gst_bus_post:<bus1> [msg 0xec958] pushing on async queue
DEBUG (0x1dd00 - 0:00:30.965454000) GST_BUS( 2501) gstbus.c(354):gst_bus_post:<bus1> [msg 0xec958] pushed on async queue
DEBUG (0x1dd00 - 0:00:30.965820000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus0> [msg 0xec958] dropped
DEBUG (0x1dd00 - 0:00:30.966217000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus3> [msg 0xec958] dropped
DEBUG (0x1dd00 - 0:00:30.966980000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus0> [msg 0xec998] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:30.967438000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus1> [msg 0xec998] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:30.967804000) GST_BUS( 2501) gstbus.c(350):gst_bus_post:<bus1> [msg 0xec998] pushing on async queue
DEBUG (0x1dd00 - 0:00:30.968170000) GST_BUS( 2501) gstbus.c(354):gst_bus_post:<bus1> [msg 0xec998] pushed on async queue
DEBUG (0x1dd00 - 0:00:30.968536000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus0> [msg 0xec998] dropped
telepathy-voip-engine[2501]: GLIB MESSAGE default - state_changed: 0x81750 playing
DEBUG (0x1dd00 - 0:00:30.991974000) GST_BUS( 2501) gstbus.c(493):gst_bus_pop:<bus1> pop from bus, have 33 messages, got message 0x29048, clock-provide
DEBUG (0x1dd00 - 0:00:30.992432000) GST_BUS( 2501) gstbus.c(620):gst_bus_source_dispatch:<bus1> source 0xb0100 calling dispatch with 0x29048
DEBUG (0x1dd00 - 0:00:30.992981000) GST_BUS( 2501) gstbus.c(625):gst_bus_source_dispatch:<bus1> source 0xb0100 handler returns 1
DEBUG (0x1dd00 - 0:00:30.993775000) GST_BUS( 2501) gstbus.c(493):gst_bus_pop:<bus1> pop from bus, have 32 messages, got message 0x29108, clock-provide
DEBUG (0x1dd00 - 0:00:31.003052000) GST_BUS( 2501) gstbus.c(620):gst_bus_source_dispatch:<bus1> source 0xb0100 calling dispatch with 0x29108
DEBUG (0x1dd00 - 0:00:31.003998000) GST_BUS( 2501) gstbus.c(625):gst_bus_source_dispatch:<bus1> source 0xb0100 handler returns 1
DEBUG (0x1dd00 - 0:00:31.007203000) GST_BUS( 2501) gstbus.c(493):gst_bus_pop:<bus1> pop from bus, have 31 messages, got message 0x29188, state-changed
DEBUG (0x1dd00 - 0:00:31.007660000) GST_BUS( 2501) gstbus.c(620):gst_bus_source_dispatch:<bus1> source 0xb0100 calling dispatch with 0x29188
DEBUG (0x1dd00 - 0:00:31.008149000) GST_BUS( 2501) gstbus.c(625):gst_bus_source_dispatch:<bus1> source 0xb0100 handler returns 1
DEBUG (0x1dd00 - 0:00:31.009217000) GST_BUS( 2501) gstbus.c(493):gst_bus_pop:<bus1> pop from bus, have 30 messages, got message 0x291c8, state-changed
DEBUG (0x1dd00 - 0:00:31.009644000) GST_BUS( 2501) gstbus.c(620):gst_bus_source_dispatch:<bus1> source 0xb0100 calling dispatch with 0x291c8
DEBUG (0x1dd00 - 0:00:31.013947000) GST_BUS( 2501) gstbus.c(625):gst_bus_source_dispatch:<bus1> source 0xb0100 handler returns 1
telepathy-voip-engine[2501]: GLIB MESSAGE default - Channel closed, cleaning up
DEBUG (0xbf0e8 - 0:00:31.025269000) GST_BUS( 2519) gstbus.c(320):gst_bus_post:<bus0> [msg 0xecd60] posting on bus, type state-changed
DEBUG (0xbf0e8 - 0:00:31.027740000) GST_BUS( 2519) gstbus.c(320):gst_bus_post:<bus1> [msg 0xecd60] posting on bus, type state-changed
DEBUG (0xbf0e8 - 0:00:31.031097000) GST_BUS( 2519) gstbus.c(350):gst_bus_post:<bus1> [msg 0xecd60] pushing on async queue
DEBUG (0xbf0e8 - 0:00:31.033814000) GST_BUS( 2519) gstbus.c(354):gst_bus_post:<bus1> [msg 0xecd60] pushed on async queue
DEBUG (0xbf0e8 - 0:00:31.036377000) GST_BUS( 2519) gstbus.c(346):gst_bus_post:<bus0> [msg 0xecd60] dropped
DEBUG (0xbf0e8 - 0:00:31.041260000) GST_BUS( 2519) gstbus.c(320):gst_bus_post:<bus0> [msg 0xecda0] posting on bus, type state-changed
DEBUG (0xbf0e8 - 0:00:31.044434000) GST_BUS( 2519) gstbus.c(320):gst_bus_post:<bus1> [msg 0xecda0] posting on bus, type state-changed
DEBUG (0xbf0e8 - 0:00:31.046997000) GST_BUS( 2519) gstbus.c(350):gst_bus_post:<bus1> [msg 0xecda0] pushing on async queue
DEBUG (0xbf0e8 - 0:00:31.049561000) GST_BUS( 2519) gstbus.c(354):gst_bus_post:<bus1> [msg 0xecda0] pushed on async queue
DEBUG (0xbf0e8 - 0:00:31.052369000) GST_BUS( 2519) gstbus.c(346):gst_bus_post:<bus0> [msg 0xecda0] dropped
DEBUG (0xbf0e8 - 0:00:31.053833000) GST_BUS( 2519) gstbus.c(320):gst_bus_post:<bus0> [msg 0xecde0] posting on bus, type state-dirty
DEBUG (0xbf0e8 - 0:00:31.056061000) GST_BUS( 2519) gstbus.c(346):gst_bus_post:<bus0> [msg 0xecde0] dropped
DEBUG (0xeda00 - 0:00:31.070160000) GST_BUS( 2520) gstbus.c(320):gst_bus_post:<bus1> [msg 0xf1810] posting on bus, type state-changed
DEBUG (0xeda00 - 0:00:31.071625000) GST_BUS( 2520) gstbus.c(350):gst_bus_post:<bus1> [msg 0xf1810] pushing on async queue
DEBUG (0xeda00 - 0:00:31.073151000) GST_BUS( 2520) gstbus.c(354):gst_bus_post:<bus1> [msg 0xf1810] pushed on async queue
telepathy-voip-engine[2501]: GLIB MESSAGE default - farsight_rtp_stream_stop (1283): stopping media pipeline
DEBUG (0x1dd00 - 0:00:37.022583000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus0> [msg 0xec9d8] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.023102000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus1> [msg 0xec9d8] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.023530000) GST_BUS( 2501) gstbus.c(350):gst_bus_post:<bus1> [msg 0xec9d8] pushing on async queue
DEBUG (0x1dd00 - 0:00:37.023896000) GST_BUS( 2501) gstbus.c(354):gst_bus_post:<bus1> [msg 0xec9d8] pushed on async queue
DEBUG (0x1dd00 - 0:00:37.024292000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus0> [msg 0xec9d8] dropped
DEBUG (0x1dd00 - 0:00:37.025269000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus0> [msg 0xeca18] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.028839000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus1> [msg 0xeca18] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.029663000) GST_BUS( 2501) gstbus.c(350):gst_bus_post:<bus1> [msg 0xeca18] pushing on async queue
DEBUG (0x1dd00 - 0:00:37.030121000) GST_BUS( 2501) gstbus.c(354):gst_bus_post:<bus1> [msg 0xeca18] pushed on async queue
DEBUG (0x1dd00 - 0:00:37.032410000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus0> [msg 0xeca18] dropped
DEBUG (0x1dd00 - 0:00:37.037476000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus2> [msg 0xeca58] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.038025000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus0> [msg 0xeca58] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.038483000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus1> [msg 0xeca58] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.038849000) GST_BUS( 2501) gstbus.c(350):gst_bus_post:<bus1> [msg 0xeca58] pushing on async queue
DEBUG (0x1dd00 - 0:00:37.039246000) GST_BUS( 2501) gstbus.c(354):gst_bus_post:<bus1> [msg 0xeca58] pushed on async queue
DEBUG (0x1dd00 - 0:00:37.039643000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus0> [msg 0xeca58] dropped
DEBUG (0x1dd00 - 0:00:37.040040000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus2> [msg 0xeca58] dropped
DEBUG (0x1dd00 - 0:00:37.040894000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus2> [msg 0xeca98] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.041595000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus0> [msg 0xeca98] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.042053000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus1> [msg 0xeca98] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.042419000) GST_BUS( 2501) gstbus.c(350):gst_bus_post:<bus1> [msg 0xeca98] pushing on async queue
DEBUG (0x1dd00 - 0:00:37.042816000) GST_BUS( 2501) gstbus.c(354):gst_bus_post:<bus1> [msg 0xeca98] pushed on async queue
DEBUG (0x1dd00 - 0:00:37.043213000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus0> [msg 0xeca98] dropped
DEBUG (0x1dd00 - 0:00:37.043610000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus2> [msg 0xeca98] dropped
DEBUG (0x1dd00 - 0:00:37.044464000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus2> [msg 0xecad8] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.044952000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus0> [msg 0xecad8] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.045410000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus1> [msg 0xecad8] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.045807000) GST_BUS( 2501) gstbus.c(350):gst_bus_post:<bus1> [msg 0xecad8] pushing on async queue
DEBUG (0x1dd00 - 0:00:37.046173000) GST_BUS( 2501) gstbus.c(354):gst_bus_post:<bus1> [msg 0xecad8] pushed on async queue
DEBUG (0x1dd00 - 0:00:37.046600000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus0> [msg 0xecad8] dropped
DEBUG (0x1dd00 - 0:00:37.046997000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus2> [msg 0xecad8] dropped
DEBUG (0x1dd00 - 0:00:37.047791000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus0> [msg 0xecb18] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.048279000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus1> [msg 0xecb18] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.049073000) GST_BUS( 2501) gstbus.c(350):gst_bus_post:<bus1> [msg 0xecb18] pushing on async queue
DEBUG (0x1dd00 - 0:00:37.059570000) GST_BUS( 2501) gstbus.c(354):gst_bus_post:<bus1> [msg 0xecb18] pushed on async queue
DEBUG (0x1dd00 - 0:00:37.060608000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus0> [msg 0xecb18] dropped
DEBUG (0x1dd00 - 0:00:37.061493000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus0> [msg 0xecb58] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.062012000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus1> [msg 0xecb58] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.062408000) GST_BUS( 2501) gstbus.c(350):gst_bus_post:<bus1> [msg 0xecb58] pushing on async queue
DEBUG (0x1dd00 - 0:00:37.062775000) GST_BUS( 2501) gstbus.c(354):gst_bus_post:<bus1> [msg 0xecb58] pushed on async queue
DEBUG (0x1dd00 - 0:00:37.063171000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus0> [msg 0xecb58] dropped
DEBUG (0x1dd00 - 0:00:37.064331000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus3> [msg 0xecb98] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.068757000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus0> [msg 0xecb98] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.069214000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus1> [msg 0xecb98] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.069611000) GST_BUS( 2501) gstbus.c(350):gst_bus_post:<bus1> [msg 0xecb98] pushing on async queue
DEBUG (0x1dd00 - 0:00:37.069977000) GST_BUS( 2501) gstbus.c(354):gst_bus_post:<bus1> [msg 0xecb98] pushed on async queue
DEBUG (0x1dd00 - 0:00:37.070374000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus0> [msg 0xecb98] dropped
DEBUG (0x1dd00 - 0:00:37.070740000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus3> [msg 0xecb98] dropped
DEBUG (0x1dd00 - 0:00:37.071564000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus3> [msg 0xecc20] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.072022000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus0> [msg 0xecc20] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.078155000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus1> [msg 0xecc20] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.078918000) GST_BUS( 2501) gstbus.c(350):gst_bus_post:<bus1> [msg 0xecc20] pushing on async queue
DEBUG (0x1dd00 - 0:00:37.079315000) GST_BUS( 2501) gstbus.c(354):gst_bus_post:<bus1> [msg 0xecc20] pushed on async queue
DEBUG (0x1dd00 - 0:00:37.083008000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus0> [msg 0xecc20] dropped
DEBUG (0x1dd00 - 0:00:37.083497000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus3> [msg 0xecc20] dropped
DEBUG (0x1dd00 - 0:00:37.084290000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus0> [msg 0xecc60] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.084778000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus1> [msg 0xecc60] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.085175000) GST_BUS( 2501) gstbus.c(350):gst_bus_post:<bus1> [msg 0xecc60] pushing on async queue
DEBUG (0x1dd00 - 0:00:37.085572000) GST_BUS( 2501) gstbus.c(354):gst_bus_post:<bus1> [msg 0xecc60] pushed on async queue
DEBUG (0x1dd00 - 0:00:37.085968000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus0> [msg 0xecc60] dropped
DEBUG (0x1dd00 - 0:00:37.086915000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus1> [msg 0xecca0] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.087342000) GST_BUS( 2501) gstbus.c(350):gst_bus_post:<bus1> [msg 0xecca0] pushing on async queue
DEBUG (0x1dd00 - 0:00:37.087739000) GST_BUS( 2501) gstbus.c(354):gst_bus_post:<bus1> [msg 0xecca0] pushed on async queue
DEBUG (0x1dd00 - 0:00:37.093140000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus0> [msg 0xecce0] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.093658000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus1> [msg 0xecce0] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.094055000) GST_BUS( 2501) gstbus.c(350):gst_bus_post:<bus1> [msg 0xecce0] pushing on async queue
DEBUG (0x1dd00 - 0:00:37.094421000) GST_BUS( 2501) gstbus.c(354):gst_bus_post:<bus1> [msg 0xecce0] pushed on async queue
DEBUG (0x1dd00 - 0:00:37.094818000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus0> [msg 0xecce0] dropped
DEBUG (0x1dd00 - 0:00:37.100281000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus0> [msg 0xecd20] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.100800000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus1> [msg 0xecd20] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.101197000) GST_BUS( 2501) gstbus.c(350):gst_bus_post:<bus1> [msg 0xecd20] pushing on async queue
DEBUG (0x1dd00 - 0:00:37.101593000) GST_BUS( 2501) gstbus.c(354):gst_bus_post:<bus1> [msg 0xecd20] pushed on async queue
DEBUG (0x1dd00 - 0:00:37.101960000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus0> [msg 0xecd20] dropped
DEBUG (0x1dd00 - 0:00:37.108307000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus2> [msg 0x291c8] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.109619000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus0> [msg 0x291c8] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.110107000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus1> [msg 0x291c8] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.110504000) GST_BUS( 2501) gstbus.c(350):gst_bus_post:<bus1> [msg 0x291c8] pushing on async queue
DEBUG (0x1dd00 - 0:00:37.110901000) GST_BUS( 2501) gstbus.c(354):gst_bus_post:<bus1> [msg 0x291c8] pushed on async queue
DEBUG (0x1dd00 - 0:00:37.114136000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus0> [msg 0x291c8] dropped
DEBUG (0x1dd00 - 0:00:37.114686000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus2> [msg 0x291c8] dropped
DEBUG (0x1dd00 - 0:00:37.115937000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus2> [msg 0x29188] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.116456000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus0> [msg 0x29188] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.116883000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus1> [msg 0x29188] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.117280000) GST_BUS( 2501) gstbus.c(350):gst_bus_post:<bus1> [msg 0x29188] pushing on async queue
DEBUG (0x1dd00 - 0:00:37.117646000) GST_BUS( 2501) gstbus.c(354):gst_bus_post:<bus1> [msg 0x29188] pushed on async queue
DEBUG (0x1dd00 - 0:00:37.118409000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus0> [msg 0x29188] dropped
DEBUG (0x1dd00 - 0:00:37.118897000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus2> [msg 0x29188] dropped
DEBUG (0x1dd00 - 0:00:37.125183000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus2> [msg 0x29108] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.125702000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus0> [msg 0x29108] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.126160000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus1> [msg 0x29108] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.126556000) GST_BUS( 2501) gstbus.c(350):gst_bus_post:<bus1> [msg 0x29108] pushing on async queue
DEBUG (0x1dd00 - 0:00:37.130768000) GST_BUS( 2501) gstbus.c(354):gst_bus_post:<bus1> [msg 0x29108] pushed on async queue
DEBUG (0x1dd00 - 0:00:37.131287000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus0> [msg 0x29108] dropped
DEBUG (0x1dd00 - 0:00:37.132142000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus2> [msg 0x29108] dropped
DEBUG (0x1dd00 - 0:00:37.133912000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus0> [msg 0x29048] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.134400000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus1> [msg 0x29048] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.137695000) GST_BUS( 2501) gstbus.c(350):gst_bus_post:<bus1> [msg 0x29048] pushing on async queue
DEBUG (0x1dd00 - 0:00:37.138855000) GST_BUS( 2501) gstbus.c(354):gst_bus_post:<bus1> [msg 0x29048] pushed on async queue
DEBUG (0x1dd00 - 0:00:37.139893000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus0> [msg 0x29048] dropped
DEBUG (0x1dd00 - 0:00:37.144684000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus0> [msg 0xf1850] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.145234000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus1> [msg 0xf1850] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.145630000) GST_BUS( 2501) gstbus.c(350):gst_bus_post:<bus1> [msg 0xf1850] pushing on async queue
DEBUG (0x1dd00 - 0:00:37.146027000) GST_BUS( 2501) gstbus.c(354):gst_bus_post:<bus1> [msg 0xf1850] pushed on async queue
DEBUG (0x1dd00 - 0:00:37.146424000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus0> [msg 0xf1850] dropped
DEBUG (0x1dd00 - 0:00:37.148591000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus3> [msg 0xf1890] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.149079000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus0> [msg 0xf1890] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.149506000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus1> [msg 0xf1890] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.149903000) GST_BUS( 2501) gstbus.c(350):gst_bus_post:<bus1> [msg 0xf1890] pushing on async queue
DEBUG (0x1dd00 - 0:00:37.150269000) GST_BUS( 2501) gstbus.c(354):gst_bus_post:<bus1> [msg 0xf1890] pushed on async queue
DEBUG (0x1dd00 - 0:00:37.156311000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus0> [msg 0xf1890] dropped
DEBUG (0x1dd00 - 0:00:37.158020000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus3> [msg 0xf1890] dropped
DEBUG (0x1dd00 - 0:00:37.252991000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus3> [msg 0xf18d0] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.255616000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus0> [msg 0xf18d0] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.258088000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus1> [msg 0xf18d0] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.260498000) GST_BUS( 2501) gstbus.c(350):gst_bus_post:<bus1> [msg 0xf18d0] pushing on async queue
DEBUG (0x1dd00 - 0:00:37.262909000) GST_BUS( 2501) gstbus.c(354):gst_bus_post:<bus1> [msg 0xf18d0] pushed on async queue
DEBUG (0x1dd00 - 0:00:37.265350000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus0> [msg 0xf18d0] dropped
DEBUG (0x1dd00 - 0:00:37.269715000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus3> [msg 0xf18d0] dropped
DEBUG (0x1dd00 - 0:00:37.272065000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus0> [msg 0xf1910] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.273530000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus1> [msg 0xf1910] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.274872000) GST_BUS( 2501) gstbus.c(350):gst_bus_post:<bus1> [msg 0xf1910] pushing on async queue
DEBUG (0x1dd00 - 0:00:37.276367000) GST_BUS( 2501) gstbus.c(354):gst_bus_post:<bus1> [msg 0xf1910] pushed on async queue
DEBUG (0x1dd00 - 0:00:37.277710000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus0> [msg 0xf1910] dropped
DEBUG (0x1dd00 - 0:00:37.279633000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus1> [msg 0xf1950] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.281036000) GST_BUS( 2501) gstbus.c(350):gst_bus_post:<bus1> [msg 0xf1950] pushing on async queue
DEBUG (0x1dd00 - 0:00:37.282349000) GST_BUS( 2501) gstbus.c(354):gst_bus_post:<bus1> [msg 0xf1950] pushed on async queue
DEBUG (0x1dd00 - 0:00:37.284852000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus0> [msg 0xf1990] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.286286000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus1> [msg 0xf1990] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.287629000) GST_BUS( 2501) gstbus.c(350):gst_bus_post:<bus1> [msg 0xf1990] pushing on async queue
DEBUG (0x1dd00 - 0:00:37.288971000) GST_BUS( 2501) gstbus.c(354):gst_bus_post:<bus1> [msg 0xf1990] pushed on async queue
DEBUG (0x1dd00 - 0:00:37.290314000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus0> [msg 0xf1990] dropped
DEBUG (0x1dd00 - 0:00:37.293426000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus0> [msg 0xf19d0] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.294830000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus1> [msg 0xf19d0] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.296173000) GST_BUS( 2501) gstbus.c(350):gst_bus_post:<bus1> [msg 0xf19d0] pushing on async queue
DEBUG (0x1dd00 - 0:00:37.297516000) GST_BUS( 2501) gstbus.c(354):gst_bus_post:<bus1> [msg 0xf19d0] pushed on async queue
DEBUG (0x1dd00 - 0:00:37.301819000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus0> [msg 0xf19d0] dropped
DEBUG (0x1dd00 - 0:00:37.308502000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus2> [msg 0xf1a10] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.309906000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus0> [msg 0xf1a10] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.311340000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus1> [msg 0xf1a10] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.312683000) GST_BUS( 2501) gstbus.c(350):gst_bus_post:<bus1> [msg 0xf1a10] pushing on async queue
DEBUG (0x1dd00 - 0:00:37.314026000) GST_BUS( 2501) gstbus.c(354):gst_bus_post:<bus1> [msg 0xf1a10] pushed on async queue
DEBUG (0x1dd00 - 0:00:37.315461000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus0> [msg 0xf1a10] dropped
DEBUG (0x1dd00 - 0:00:37.316773000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus2> [msg 0xf1a10] dropped
DEBUG (0x1dd00 - 0:00:37.318818000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus2> [msg 0xf1a50] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.320221000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus0> [msg 0xf1a50] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.322906000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus1> [msg 0xf1a50] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.324280000) GST_BUS( 2501) gstbus.c(350):gst_bus_post:<bus1> [msg 0xf1a50] pushing on async queue
DEBUG (0x1dd00 - 0:00:37.325958000) GST_BUS( 2501) gstbus.c(354):gst_bus_post:<bus1> [msg 0xf1a50] pushed on async queue
DEBUG (0x1dd00 - 0:00:37.327667000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus0> [msg 0xf1a50] dropped
DEBUG (0x1dd00 - 0:00:37.329010000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus2> [msg 0xf1a50] dropped
DEBUG (0x1dd00 - 0:00:37.331116000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus2> [msg 0xf1a90] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.332856000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus0> [msg 0xf1a90] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.334290000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus1> [msg 0xf1a90] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.335663000) GST_BUS( 2501) gstbus.c(350):gst_bus_post:<bus1> [msg 0xf1a90] pushing on async queue
DEBUG (0x1dd00 - 0:00:37.337403000) GST_BUS( 2501) gstbus.c(354):gst_bus_post:<bus1> [msg 0xf1a90] pushed on async queue
DEBUG (0x1dd00 - 0:00:37.338806000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus0> [msg 0xf1a90] dropped
DEBUG (0x1dd00 - 0:00:37.340149000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus2> [msg 0xf1a90] dropped
DEBUG (0x1dd00 - 0:00:37.343201000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus0> [msg 0xf1ad0] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.344604000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus1> [msg 0xf1ad0] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.346985000) GST_BUS( 2501) gstbus.c(350):gst_bus_post:<bus1> [msg 0xf1ad0] pushing on async queue
DEBUG (0x1dd00 - 0:00:37.351685000) GST_BUS( 2501) gstbus.c(354):gst_bus_post:<bus1> [msg 0xf1ad0] pushed on async queue
DEBUG (0x1dd00 - 0:00:37.353546000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus0> [msg 0xf1ad0] dropped
DEBUG (0x1dd00 - 0:00:37.355469000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus0> [msg 0xf1b10] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.357239000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus1> [msg 0xf1b10] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.358582000) GST_BUS( 2501) gstbus.c(350):gst_bus_post:<bus1> [msg 0xf1b10] pushing on async queue
DEBUG (0x1dd00 - 0:00:37.359924000) GST_BUS( 2501) gstbus.c(354):gst_bus_post:<bus1> [msg 0xf1b10] pushed on async queue
DEBUG (0x1dd00 - 0:00:37.361390000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus0> [msg 0xf1b10] dropped
DEBUG (0x1dd00 - 0:00:37.363648000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus3> [msg 0xf1b50] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.365479000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus0> [msg 0xf1b50] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.366883000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus1> [msg 0xf1b50] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.368226000) GST_BUS( 2501) gstbus.c(350):gst_bus_post:<bus1> [msg 0xf1b50] pushing on async queue
DEBUG (0x1dd00 - 0:00:37.369629000) GST_BUS( 2501) gstbus.c(354):gst_bus_post:<bus1> [msg 0xf1b50] pushed on async queue
DEBUG (0x1dd00 - 0:00:37.371033000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus0> [msg 0xf1b50] dropped
DEBUG (0x1dd00 - 0:00:37.372345000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus3> [msg 0xf1b50] dropped
DEBUG (0x1dd00 - 0:00:37.374268000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus3> [msg 0xf1b90] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.375671000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus0> [msg 0xf1b90] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.377137000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus1> [msg 0xf1b90] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.381226000) GST_BUS( 2501) gstbus.c(350):gst_bus_post:<bus1> [msg 0xf1b90] pushing on async queue
DEBUG (0x1dd00 - 0:00:37.382569000) GST_BUS( 2501) gstbus.c(354):gst_bus_post:<bus1> [msg 0xf1b90] pushed on async queue
DEBUG (0x1dd00 - 0:00:37.383942000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus0> [msg 0xf1b90] dropped
DEBUG (0x1dd00 - 0:00:37.385345000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus3> [msg 0xf1b90] dropped
DEBUG (0x1dd00 - 0:00:37.387238000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus0> [msg 0xf1c18] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.388641000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus1> [msg 0xf1c18] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.389984000) GST_BUS( 2501) gstbus.c(350):gst_bus_post:<bus1> [msg 0xf1c18] pushing on async queue
DEBUG (0x1dd00 - 0:00:37.391327000) GST_BUS( 2501) gstbus.c(354):gst_bus_post:<bus1> [msg 0xf1c18] pushed on async queue
DEBUG (0x1dd00 - 0:00:37.392792000) GST_BUS( 2501) gstbus.c(346):gst_bus_post:<bus0> [msg 0xf1c18] dropped
DEBUG (0x1dd00 - 0:00:37.394837000) GST_BUS( 2501) gstbus.c(458):gst_bus_set_flushing:<bus1> set bus flushing
DEBUG (0x1dd00 - 0:00:37.396210000) GST_BUS( 2501) gstbus.c(493):gst_bus_pop:<bus1> pop from bus, have 64 messages, got message 0x29208, state-changed
DEBUG (0x1dd00 - 0:00:37.397706000) GST_BUS( 2501) gstbus.c(493):gst_bus_pop:<bus1> pop from bus, have 63 messages, got message 0x29248, state-changed
DEBUG (0x1dd00 - 0:00:37.399170000) GST_BUS( 2501) gstbus.c(493):gst_bus_pop:<bus1> pop from bus, have 62 messages, got message 0x29288, state-changed
DEBUG (0x1dd00 - 0:00:37.402801000) GST_BUS( 2501) gstbus.c(493):gst_bus_pop:<bus1> pop from bus, have 61 messages, got message 0x292c8, state-changed
DEBUG (0x1dd00 - 0:00:37.404297000) GST_BUS( 2501) gstbus.c(493):gst_bus_pop:<bus1> pop from bus, have 60 messages, got message 0x29308, state-changed
DEBUG (0x1dd00 - 0:00:37.405823000) GST_BUS( 2501) gstbus.c(493):gst_bus_pop:<bus1> pop from bus, have 59 messages, got message 0x29348, state-changed
DEBUG (0x1dd00 - 0:00:37.407318000) GST_BUS( 2501) gstbus.c(493):gst_bus_pop:<bus1> pop from bus, have 58 messages, got message 0x29388, state-changed
DEBUG (0x1dd00 - 0:00:37.408906000) GST_BUS( 2501) gstbus.c(493):gst_bus_pop:<bus1> pop from bus, have 57 messages, got message 0x29410, state-changed
DEBUG (0x1dd00 - 0:00:37.410401000) GST_BUS( 2501) gstbus.c(493):gst_bus_pop:<bus1> pop from bus, have 56 messages, got message 0x29450, state-changed
DEBUG (0x1dd00 - 0:00:37.411896000) GST_BUS( 2501) gstbus.c(493):gst_bus_pop:<bus1> pop from bus, have 55 messages, got message 0x29490, state-changed
DEBUG (0x1dd00 - 0:00:37.414185000) GST_BUS( 2501) gstbus.c(493):gst_bus_pop:<bus1> pop from bus, have 54 messages, got message 0x294d0, state-changed
DEBUG (0x1dd00 - 0:00:37.416138000) GST_BUS( 2501) gstbus.c(493):gst_bus_pop:<bus1> pop from bus, have 53 messages, got message 0x29510, state-changed
DEBUG (0x1dd00 - 0:00:37.418426000) GST_BUS( 2501) gstbus.c(493):gst_bus_pop:<bus1> pop from bus, have 52 messages, got message 0x29550, state-changed
DEBUG (0x1dd00 - 0:00:37.419922000) GST_BUS( 2501) gstbus.c(493):gst_bus_pop:<bus1> pop from bus, have 51 messages, got message 0x29590, state-changed
DEBUG (0x1dd00 - 0:00:37.421417000) GST_BUS( 2501) gstbus.c(493):gst_bus_pop:<bus1> pop from bus, have 50 messages, got message 0x295d0, state-changed
DEBUG (0x1dd00 - 0:00:37.425080000) GST_BUS( 2501) gstbus.c(493):gst_bus_pop:<bus1> pop from bus, have 49 messages, got message 0x29610, state-changed
DEBUG (0x1dd00 - 0:00:37.426850000) GST_BUS( 2501) gstbus.c(493):gst_bus_pop:<bus1> pop from bus, have 48 messages, got message 0x29650, state-changed
DEBUG (0x1dd00 - 0:00:37.428345000) GST_BUS( 2501) gstbus.c(493):gst_bus_pop:<bus1> pop from bus, have 47 messages, got message 0x29690, state-changed
DEBUG (0x1dd00 - 0:00:37.429871000) GST_BUS( 2501) gstbus.c(493):gst_bus_pop:<bus1> pop from bus, have 46 messages, got message 0x296d0, state-changed
DEBUG (0x1dd00 - 0:00:37.431854000) GST_BUS( 2501) gstbus.c(493):gst_bus_pop:<bus1> pop from bus, have 45 messages, got message 0x29710, new-clock
DEBUG (0x1dd00 - 0:00:37.433380000) GST_BUS( 2501) gstbus.c(493):gst_bus_pop:<bus1> pop from bus, have 44 messages, got message 0x29750, state-changed
DEBUG (0x1dd00 - 0:00:37.434845000) GST_BUS( 2501) gstbus.c(493):gst_bus_pop:<bus1> pop from bus, have 43 messages, got message 0x29790, state-changed
DEBUG (0x1dd00 - 0:00:37.436371000) GST_BUS( 2501) gstbus.c(493):gst_bus_pop:<bus1> pop from bus, have 42 messages, got message 0xec818, state-changed
DEBUG (0x1dd00 - 0:00:37.437866000) GST_BUS( 2501) gstbus.c(493):gst_bus_pop:<bus1> pop from bus, have 41 messages, got message 0xec858, state-changed
DEBUG (0x1dd00 - 0:00:37.439392000) GST_BUS( 2501) gstbus.c(493):gst_bus_pop:<bus1> pop from bus, have 40 messages, got message 0xec898, state-changed
DEBUG (0x1dd00 - 0:00:37.442109000) GST_BUS( 2501) gstbus.c(493):gst_bus_pop:<bus1> pop from bus, have 39 messages, got message 0xec8d8, state-changed
DEBUG (0x1dd00 - 0:00:37.444031000) GST_BUS( 2501) gstbus.c(493):gst_bus_pop:<bus1> pop from bus, have 38 messages, got message 0xec918, state-changed
DEBUG (0x1dd00 - 0:00:37.445923000) GST_BUS( 2501) gstbus.c(493):gst_bus_pop:<bus1> pop from bus, have 37 messages, got message 0xec958, state-changed
DEBUG (0x1dd00 - 0:00:37.447510000) GST_BUS( 2501) gstbus.c(493):gst_bus_pop:<bus1> pop from bus, have 36 messages, got message 0xec998, state-changed
DEBUG (0x1dd00 - 0:00:37.448975000) GST_BUS( 2501) gstbus.c(493):gst_bus_pop:<bus1> pop from bus, have 35 messages, got message 0xecd60, state-changed
DEBUG (0x1dd00 - 0:00:37.453033000) GST_BUS( 2501) gstbus.c(493):gst_bus_pop:<bus1> pop from bus, have 34 messages, got message 0xecda0, state-changed
DEBUG (0x1dd00 - 0:00:37.454529000) GST_BUS( 2501) gstbus.c(493):gst_bus_pop:<bus1> pop from bus, have 33 messages, got message 0xf1810, state-changed
DEBUG (0x1dd00 - 0:00:37.462464000) GST_BUS( 2501) gstbus.c(493):gst_bus_pop:<bus1> pop from bus, have 32 messages, got message 0xec9d8, state-changed
DEBUG (0x1dd00 - 0:00:37.464050000) GST_BUS( 2501) gstbus.c(493):gst_bus_pop:<bus1> pop from bus, have 31 messages, got message 0xeca18, state-changed
DEBUG (0x1dd00 - 0:00:37.465546000) GST_BUS( 2501) gstbus.c(493):gst_bus_pop:<bus1> pop from bus, have 30 messages, got message 0xeca58, state-changed
DEBUG (0x1dd00 - 0:00:37.467468000) GST_BUS( 2501) gstbus.c(493):gst_bus_pop:<bus1> pop from bus, have 29 messages, got message 0xeca98, state-changed
DEBUG (0x1dd00 - 0:00:37.468994000) GST_BUS( 2501) gstbus.c(493):gst_bus_pop:<bus1> pop from bus, have 28 messages, got message 0xecad8, state-changed
DEBUG (0x1dd00 - 0:00:37.470520000) GST_BUS( 2501) gstbus.c(493):gst_bus_pop:<bus1> pop from bus, have 27 messages, got message 0xecb18, state-changed
DEBUG (0x1dd00 - 0:00:37.472291000) GST_BUS( 2501) gstbus.c(493):gst_bus_pop:<bus1> pop from bus, have 26 messages, got message 0xecb58, state-changed
DEBUG (0x1dd00 - 0:00:37.473816000) GST_BUS( 2501) gstbus.c(493):gst_bus_pop:<bus1> pop from bus, have 25 messages, got message 0xecb98, state-changed
DEBUG (0x1dd00 - 0:00:37.475312000) GST_BUS( 2501) gstbus.c(493):gst_bus_pop:<bus1> pop from bus, have 24 messages, got message 0xecc20, state-changed
DEBUG (0x1dd00 - 0:00:37.477204000) GST_BUS( 2501) gstbus.c(493):gst_bus_pop:<bus1> pop from bus, have 23 messages, got message 0xecc60, state-changed
DEBUG (0x1dd00 - 0:00:37.479126000) GST_BUS( 2501) gstbus.c(493):gst_bus_pop:<bus1> pop from bus, have 22 messages, got message 0xecca0, state-changed
DEBUG (0x1dd00 - 0:00:37.480621000) GST_BUS( 2501) gstbus.c(493):gst_bus_pop:<bus1> pop from bus, have 21 messages, got message 0xecce0, state-changed
DEBUG (0x1dd00 - 0:00:37.482117000) GST_BUS( 2501) gstbus.c(493):gst_bus_pop:<bus1> pop from bus, have 20 messages, got message 0xecd20, state-changed
DEBUG (0x1dd00 - 0:00:37.483582000) GST_BUS( 2501) gstbus.c(493):gst_bus_pop:<bus1> pop from bus, have 19 messages, got message 0x291c8, state-changed
DEBUG (0x1dd00 - 0:00:37.485077000) GST_BUS( 2501) gstbus.c(493):gst_bus_pop:<bus1> pop from bus, have 18 messages, got message 0x29188, state-changed
DEBUG (0x1dd00 - 0:00:37.487458000) GST_BUS( 2501) gstbus.c(493):gst_bus_pop:<bus1> pop from bus, have 17 messages, got message 0x29108, state-changed
DEBUG (0x1dd00 - 0:00:37.490174000) GST_BUS( 2501) gstbus.c(493):gst_bus_pop:<bus1> pop from bus, have 16 messages, got message 0x29048, state-changed
DEBUG (0x1dd00 - 0:00:37.493073000) GST_BUS( 2501) gstbus.c(493):gst_bus_pop:<bus1> pop from bus, have 15 messages, got message 0xf1850, state-changed
DEBUG (0x1dd00 - 0:00:37.496277000) GST_BUS( 2501) gstbus.c(493):gst_bus_pop:<bus1> pop from bus, have 14 messages, got message 0xf1890, state-changed
DEBUG (0x1dd00 - 0:00:37.499023000) GST_BUS( 2501) gstbus.c(493):gst_bus_pop:<bus1> pop from bus, have 13 messages, got message 0xf18d0, state-changed
DEBUG (0x1dd00 - 0:00:37.502594000) GST_BUS( 2501) gstbus.c(493):gst_bus_pop:<bus1> pop from bus, have 12 messages, got message 0xf1910, state-changed
DEBUG (0x1dd00 - 0:00:37.505555000) GST_BUS( 2501) gstbus.c(493):gst_bus_pop:<bus1> pop from bus, have 11 messages, got message 0xf1950, state-changed
DEBUG (0x1dd00 - 0:00:37.508515000) GST_BUS( 2501) gstbus.c(493):gst_bus_pop:<bus1> pop from bus, have 10 messages, got message 0xf1990, state-changed
DEBUG (0x1dd00 - 0:00:37.513153000) GST_BUS( 2501) gstbus.c(493):gst_bus_pop:<bus1> pop from bus, have 9 messages, got message 0xf19d0, state-changed
DEBUG (0x1dd00 - 0:00:37.515350000) GST_BUS( 2501) gstbus.c(493):gst_bus_pop:<bus1> pop from bus, have 8 messages, got message 0xf1a10, state-changed
DEBUG (0x1dd00 - 0:00:37.516724000) GST_BUS( 2501) gstbus.c(493):gst_bus_pop:<bus1> pop from bus, have 7 messages, got message 0xf1a50, state-changed
DEBUG (0x1dd00 - 0:00:37.523865000) GST_BUS( 2501) gstbus.c(493):gst_bus_pop:<bus1> pop from bus, have 6 messages, got message 0xf1a90, state-changed
DEBUG (0x1dd00 - 0:00:37.533906000) GST_BUS( 2501) gstbus.c(493):gst_bus_pop:<bus1> pop from bus, have 5 messages, got message 0xf1ad0, state-changed
DEBUG (0x1dd00 - 0:00:37.535798000) GST_BUS( 2501) gstbus.c(493):gst_bus_pop:<bus1> pop from bus, have 4 messages, got message 0xf1b10, state-changed
DEBUG (0x1dd00 - 0:00:37.537140000) GST_BUS( 2501) gstbus.c(493):gst_bus_pop:<bus1> pop from bus, have 3 messages, got message 0xf1b50, state-changed
DEBUG (0x1dd00 - 0:00:37.539307000) GST_BUS( 2501) gstbus.c(493):gst_bus_pop:<bus1> pop from bus, have 2 messages, got message 0xf1b90, state-changed
DEBUG (0x1dd00 - 0:00:37.548981000) GST_BUS( 2501) gstbus.c(493):gst_bus_pop:<bus1> pop from bus, have 1 messages, got message 0xf1c18, state-changed
DEBUG (0x1dd00 - 0:00:37.550843000) GST_BUS( 2501) gstbus.c(495):gst_bus_pop:<bus1> pop from bus, no messages
DEBUG (0x1dd00 - 0:00:37.552430000) GST_BUS( 2501) gstbus.c(320):gst_bus_post:<bus1> [msg 0xecc20] posting on bus, type state-changed
DEBUG (0x1dd00 - 0:00:37.553803000) GST_BUS( 2501) gstbus.c(402):gst_bus_post:<bus1> bus is flushing
telepathy-voip-engine[2501]: GLIB MESSAGE default - farsight_rtp_stream_stop (1311): destroying socket client
telepathy-voip-engine[2501]: GLIB DEBUG default - Found derived ip 67.68.27.24
telepathy-voip-engine[2501]: GLIB MESSAGE default - Found IGD: urn:schemas-upnp-org:device:WANConnectionDevice:1, nat:0, external IP:
telepathy-voip-engine[2501]: GLIB MESSAGE default - closing port 1118
telepathy-voip-engine[2501]: GLIB MESSAGE default - upnp: deleting port mapping from port 1118 (UDP)
telepathy-voip-engine[2501]: GLIB MESSAGE default - upnp: Deleted port mapping (714): protocol UDP, port 1118.
telepathy-voip-engine[2501]: GLIB MESSAGE default - upnp: upnp_close_port: port was not mapped.
telepathy-voip-engine[2501]: GLIB MESSAGE default - state_changed: 0x81750 stopped
telepathy-voip-engine[2501]: GLIB DEBUG default - priv->chan->ref_count before any unrefs == 4
telepathy-voip-engine[2501]: GLIB DEBUG default - priv->streamed_proxy->ref_count before unref == 1
telepathy-voip-engine[2501]: GLIB DEBUG default - priv->session_proxy->ref_count before unref == 1
telepathy-voip-engine[2501]: GLIB DEBUG default - priv->stream_proxy->ref_count before unref == 1
telepathy-voip-engine[2501]: GLIB DEBUG default - priv->media_engine_proxy->ref_count before unref == 1
telepathy-voip-engine[2501]: GLIB DEBUG default - priv->chan->ref_count before unref == 4
DEBUG (0x1dd00 - 0:00:37.818573000) GST_BUS( 2501) gstbus.c(495):gst_bus_pop:<bus1> pop from bus, no messages
telepathy-voip-engine[2501]: GLIB CRITICAL ** GStreamer - gst_bus_source_dispatch: assertion `message != NULL' failed