TEEing the video
Ian Davidson
id012c3076 at blueyonder.co.uk
Tue Nov 4 08:00:37 PST 2014
I have a program (written in C and using GStreamer 1.0) which works. I
take input from v4l2src and alsasrc and mux them together and save an
mp4 file. I also tee off the audio early on and save it as a wav file.
However, I have no confirmation that I actually have a video signal to
record. So, I decided to enhance the program by teeing the video off,
right after the v4l2src and send it to an autovideosink to act as a
monitor. The result was not 100% successful. The monitor window appears
with a picture in it -- but then everything seems to freeze up. Looking
at a trace (--gst-debug-level=4) appears to loop for ever setting a
timestamp to 99:99:99.999999999.
I have copied part of my program below. The elements I have added are
defined in the line GstElement *videotee, *queue5, *monscale,
*moncapsfilter, *videosink;
I have also included the beginning of the Trace output. To my untrained
eye, everything seems to link together OK, but then it gets stuck with
the timestamps. Any pointers as to where I am going wrong would be
appreciated.
void videoPressed( GtkWidget *widget,
gpointer data )
{
char lszFileName[260], lszVidFileName[260], szBuffer[20];
GMainLoop *loop;
GstElement *vsource, *vcapsfilter, *vidrate, *vidscale, *queue1, *videnc;
GstElement *asource, *lameenc, *audrate, *acapsfilter, *queue2, *queue3;
GstElement *tee, *aconv2, *queue4, *wavenc, *asink;
GstElement *mux, *sink;
*GstElement *videotee, *queue5, *monscale, *moncapsfilter, *videosink;*
GstBus *bus;
guint bus_watch_id;
GstCaps *caps;
FILE *list;
gtk_widget_set_sensitive(normalbutton, TRUE);
gtk_widget_set_sensitive(kidsbutton, TRUE);
gtk_widget_set_sensitive(colbutton, TRUE);
gtk_widget_set_sensitive(intvwbutton, TRUE);
gtk_widget_set_sensitive(readbutton, TRUE);
gtk_widget_set_sensitive(sermonbutton, TRUE);
gtk_widget_set_sensitive(breadbutton, TRUE);
gtk_widget_set_sensitive(winebutton, TRUE);
gtk_widget_set_sensitive(prerecbutton, TRUE);
gtk_widget_set_sensitive(silencebutton, TRUE);
gtk_widget_set_sensitive(audiobutton, FALSE);
gtk_widget_set_sensitive(videobutton, FALSE);
gtk_widget_set_sensitive(stopbutton, TRUE);
gtk_widget_set_sensitive(startsnapbutton, FALSE);
time( &mtimeStartTime );
gtk_widget_grab_focus(normalbutton);
time_t rawtime;
struct tm * timeinfo;
time(&rawtime);
timeinfo = localtime (&rawtime);
mbRecording = TRUE;
strftime(mszFileName, 11, "%a%d-%H%M", timeinfo);
sprintf(mszTextFileName, "%s/%s.Times", mszFullPath, mszFileName);
sprintf(szBuffer, "Filename: %s", mszFileName);
gtk_label_set_text(GTK_LABEL(fileNameLabel), szBuffer);
list = fopen(mszTextFileName, "a");
fprintf(list, "%s%s\n", mszFullPath, mszFolder);
fclose(list);
loop = g_main_loop_new (NULL, FALSE);
/* Create gstreamer elements */
pipeline = gst_pipeline_new ("av-recorder");
vsource = gst_element_factory_make ("v4l2src", "vid-source");
vidrate = gst_element_factory_make ("videorate", "vidrate");
vidscale = gst_element_factory_make ("videoscale", "vidscale");
vcapsfilter = gst_element_factory_make ("capsfilter", "vid-caps");
queue1 = gst_element_factory_make ("queue", "queue1");
videnc = gst_element_factory_make ("x264enc", "videnc");
asource = gst_element_factory_make ("alsasrc", "alsa-source");
acapsfilter = gst_element_factory_make ("capsfilter", "audio-caps");
queue2 = gst_element_factory_make ("queue", "queue2");
audrate = gst_element_factory_make ("audiorate", "audrate");
queue3 = gst_element_factory_make ("queue", "queue3");
lameenc = gst_element_factory_make ("lamemp3enc", "lameenc");
mux = gst_element_factory_make ("mp4mux", "mp4-mux");
sink = gst_element_factory_make ("filesink", "file-output");
tee = gst_element_factory_make ("tee", "tee");
aconv2 = gst_element_factory_make ("audioconvert", "audio2-conv");
queue4 = gst_element_factory_make ("queue", "queue4");
wavenc = gst_element_factory_make ("wavenc", "wav-encoder");
asink = gst_element_factory_make ("filesink", "wav-output");
*videotee = gst_element_factory_make ("tee", "videotee");*
*queue5 = gst_element_factory_make ("queue", "queue5");*
*monscale = gst_element_factory_make ("videoscale", "monscale");*
*moncapsfilter = gst_element_factory_make ("capsfilter", "mon-caps");*
*videosink = gst_element_factory_make ("autovideosink", "videosink");*
/ if (!pipeline || !vsource || !vidrate || !vcapsfilter || !queue1 ||
!videnc || !asource || !acapsfilter || !queue2 || !audrate || !queue3 ||
!lameenc || !mux || !sink || !tee || !aconv2 || !queue4 || !wavenc ||
!asink || *!videotee || !queue5 || !monscale || !moncapsfilter ||
!videosink*) {
g_printerr ("One element could not be created. Exiting.\n");
return;
}
/* Set up the pipeline */
sprintf(lszFileName, "%s%s.wav", mszFullPath, mszFileName);
g_object_set (G_OBJECT (asink), "location", lszFileName, NULL);
sprintf(lszVidFileName, "%s%s.mp4", mszFullPath, mszFileName);
g_object_set (G_OBJECT (sink), "location", lszVidFileName, NULL);
/* we set the video capabilities on the vidcaps element */
/* SET THE VIDEO CAPS */
caps =
gst_caps_from_string("video/x-raw,format=(string)I420,width=480,height=384,framerate=(fraction)25/1");
g_object_set (G_OBJECT (vcapsfilter), "caps", caps, NULL);
gst_caps_unref (caps);
/* we set the audio capabilities on the audiocaps element */
caps = gst_caps_from_string("audio/x-raw,rate=44100,channels=1");
g_object_set (G_OBJECT (acapsfilter), "caps", caps, NULL);
gst_caps_unref (caps);
*/* set the caps for the monitor video */*
*caps =
gst_caps_from_string("video/x-raw,format=(string)I420,width=320,height=240,framerate=(fraction)25/1");*
*g_object_set (G_OBJECT (moncapsfilter), "caps", caps, NULL);*
*gst_caps_unref (caps); *
/* we add a message handler */
bus = gst_pipeline_get_bus (GST_PIPELINE (pipeline));
bus_watch_id = gst_bus_add_watch (bus, bus_call, loop);
gst_object_unref (bus);
/* we add all elements into the pipeline */
gst_bin_add_many (GST_BIN (pipeline),
vsource, vidrate, vidscale, vcapsfilter, queue1, videnc,
asource, acapsfilter, queue2, audrate, queue3, lameenc,
mux, sink,
tee, aconv2, queue4, wavenc, asink, *videotee, queue5, monscale,
moncapsfilter, videosink, *NULL);
/* we link the elements together */
/* vsource -> vcapsfilter -> vidrate -> queue1 -> avimux
asource -> aconv -> acapsfilter -> queue2 -> avimux
mux -> sink */
if (!gst_element_link_many (vsource, *videotee*, vidrate, vidscale,
vcapsfilter, queue1, videnc, mux, NULL)) {
g_printerr ("Failed to link vsource, videotee, vidrate, vidscale,
vcapsfilter, queue1, videnc, mux. Exiting.\n");
return;
}
if (!gst_element_link_many (asource, acapsfilter, queue2, tee, audrate,
queue3, lameenc, mux, NULL)) {
g_printerr ("Failed to link asource, acapsfilter, queue2, audrate, tee,
queue3, lameenc, mux. Exiting.\n");
return;
}
if (!gst_element_link_many (mux, sink, NULL)) {
g_printerr ("Failed to link mux to sink. Exiting.\n");
return;
}
if (!gst_element_link_many (tee, aconv2, queue4, wavenc, asink, NULL)) {
g_printerr ("Failed to link tee, queue4, wavenc, asink. Exiting.\n");
return;
}
*if (!gst_element_link_many (videotee, queue5, monscale, moncapsfilter,
videosink, NULL)) {*
*g_printerr ("Failed to link videotee, queue5, monscale, moncapsfilter,
videosink. Exiting.\n");*
*return;*
*}*
/* Set the pipeline to "playing" state*/
gst_element_set_state (pipeline, GST_STATE_PLAYING);
/* Iterate */
g_main_loop_run (loop);
/* Out of the main loop, clean up nicely */
g_print ("Returned, stopping recording\n");
gst_element_set_state (pipeline, GST_STATE_NULL);
gst_object_unref (GST_OBJECT (pipeline));
g_source_remove (bus_watch_id);
g_main_loop_unref (loop);
mbRecording = FALSE;
if (mbShutdown && !mbCameraActive) {
gtk_main_quit();
}
return;
}
0:00:00.000625191 2690 0xfaa060 INFO GST_INIT
gstmessage.c:121:_priv_gst_message_initialize: init messages
0:00:00.000952104 2690 0xfaa060 INFO GST_PLUGIN_LOADING
gstplugin.c:317:_priv_gst_plugin_initialize: registering 0 static plugins
0:00:00.001108137 2690 0xfaa060 INFO GST_PLUGIN_LOADING
gstplugin.c:225:gst_plugin_register_static: registered static plugin
"staticelements"
0:00:00.001131809 2690 0xfaa060 INFO GST_PLUGIN_LOADING
gstplugin.c:227:gst_plugin_register_static: added static plugin
"staticelements", result: 1
0:00:00.001156800 2690 0xfaa060 INFO GST_REGISTRY
gstregistry.c:1680:ensure_current_registry: reading registry cache:
/home/ian/.cache/gstreamer-1.0/registry.x86_64.bin
0:00:00.018961421 2690 0xfaa060 INFO GST_REGISTRY
gstregistrybinary.c:617:priv_gst_registry_binary_read_cache: loaded
/home/ian/.cache/gstreamer-1.0/registry.x86_64.bin in 0.017782 seconds
0:00:00.019041313 2690 0xfaa060 INFO GST_REGISTRY
gstregistry.c:1539:scan_and_update_registry: Validating plugins from
registry cache: /home/ian/.cache/gstreamer-1.0/registry.x86_64.bin
0:00:00.020025758 2690 0xfaa060 INFO GST_REGISTRY
gstregistry.c:1638:scan_and_update_registry: Registry cache has not changed
0:00:00.020043728 2690 0xfaa060 INFO GST_REGISTRY
gstregistry.c:1715:ensure_current_registry: registry reading and
updating done, result = 1
0:00:00.020058536 2690 0xfaa060 INFO GST_INIT gst.c:769:init_post: GLib
runtime version: 2.34.2
0:00:00.020073859 2690 0xfaa060 INFO GST_INIT gst.c:771:init_post: GLib
headers version: 2.34.2
0:00:00.020092662 2690 0xfaa060 INFO GST_INIT gst.c:419:gst_init_check:
initialized GStreamer successfully
0:00:03.148883134 2690 0xfaa060 INFO GST_ELEMENT_FACTORY
gstelementfactory.c:363:gst_element_factory_create: creating element
"pipeline" named "av-recorder"
0:00:03.152033131 2690 0xfaa060 INFO GST_PLUGIN_LOADING
gstplugin.c:830:gst_plugin_load_file: plugin
"/usr/lib64/gstreamer-1.0/libgstvideo4linux2.so" loaded
0:00:03.152053059 2690 0xfaa060 INFO GST_ELEMENT_FACTORY
gstelementfactory.c:363:gst_element_factory_create: creating element
"v4l2src" named "vid-source"
0:00:03.152434269 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstelement.c:643:gst_element_add_pad:<GstBaseSrc at 0x12f6230> adding pad 'src'
0:00:03.152851563 2690 0xfaa060 INFO GST_PLUGIN_LOADING
gstplugin.c:830:gst_plugin_load_file: plugin
"/usr/lib64/gstreamer-1.0/libgstvideorate.so" loaded
0:00:03.152872164 2690 0xfaa060 INFO GST_ELEMENT_FACTORY
gstelementfactory.c:363:gst_element_factory_create: creating element
"videorate" named "vidrate"
0:00:03.152996974 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstelement.c:643:gst_element_add_pad:<GstBaseTransform at 0x12fa400> adding
pad 'sink'
0:00:03.153030182 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstelement.c:643:gst_element_add_pad:<GstBaseTransform at 0x12fa400> adding
pad 'src'
0:00:03.153468660 2690 0xfaa060 INFO GST_PLUGIN_LOADING
gstplugin.c:830:gst_plugin_load_file: plugin
"/usr/lib64/gstreamer-1.0/libgstvideoscale.so" loaded
0:00:03.153486555 2690 0xfaa060 INFO GST_ELEMENT_FACTORY
gstelementfactory.c:363:gst_element_factory_create: creating element
"videoscale" named "vidscale"
0:00:03.153635016 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstelement.c:643:gst_element_add_pad:<GstBaseTransform at 0x12fd700> adding
pad 'sink'
0:00:03.153671674 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstelement.c:643:gst_element_add_pad:<GstBaseTransform at 0x12fd700> adding
pad 'src'
0:00:03.154217504 2690 0xfaa060 INFO GST_PLUGIN_LOADING
gstplugin.c:830:gst_plugin_load_file: plugin
"/usr/lib64/gstreamer-1.0/libgstcoreelements.so" loaded
0:00:03.154235468 2690 0xfaa060 INFO GST_ELEMENT_FACTORY
gstelementfactory.c:363:gst_element_factory_create: creating element
"capsfilter" named "vid-caps"
0:00:03.154333461 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstelement.c:643:gst_element_add_pad:<GstBaseTransform at 0x1302030> adding
pad 'sink'
0:00:03.154365737 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstelement.c:643:gst_element_add_pad:<GstBaseTransform at 0x1302030> adding
pad 'src'
0:00:03.154387930 2690 0xfaa060 INFO GST_ELEMENT_FACTORY
gstelementfactory.c:363:gst_element_factory_create: creating element
"queue" named "queue1"
0:00:03.154534803 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstelement.c:643:gst_element_add_pad:<GstQueue at 0x1306010> adding pad 'sink'
0:00:03.154579234 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstelement.c:643:gst_element_add_pad:<GstQueue at 0x1306010> adding pad 'src'
0:00:03.155981973 2690 0xfaa060 INFO x264enc
gstx264enc.c:2185:plugin_init: x264 build: 128
0:00:03.156019079 2690 0xfaa060 INFO GST_PLUGIN_LOADING
gstplugin.c:830:gst_plugin_load_file: plugin
"/usr/lib64/gstreamer-1.0/libgstx264.so" loaded
0:00:03.156034946 2690 0xfaa060 INFO GST_ELEMENT_FACTORY
gstelementfactory.c:363:gst_element_factory_create: creating element
"x264enc" named "videnc"
0:00:03.156334092 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstelement.c:643:gst_element_add_pad:<GstVideoEncoder at 0x130f000> adding
pad 'sink'
0:00:03.156367974 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstelement.c:643:gst_element_add_pad:<GstVideoEncoder at 0x130f000> adding
pad 'src'
0:00:03.158780420 2690 0xfaa060 INFO GST_PLUGIN_LOADING
gstplugin.c:830:gst_plugin_load_file: plugin
"/usr/lib64/gstreamer-1.0/libgstalsa.so" loaded
0:00:03.158800968 2690 0xfaa060 INFO GST_ELEMENT_FACTORY
gstelementfactory.c:363:gst_element_factory_create: creating element
"alsasrc" named "alsa-source"
0:00:03.158935770 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstelement.c:643:gst_element_add_pad:<GstBaseSrc at 0x1314600> adding pad 'src'
0:00:03.159083465 2690 0xfaa060 INFO GST_ELEMENT_FACTORY
gstelementfactory.c:363:gst_element_factory_create: creating element
"capsfilter" named "audio-caps"
0:00:03.159126052 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstelement.c:643:gst_element_add_pad:<GstBaseTransform at 0x1302350> adding
pad 'sink'
0:00:03.159155786 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstelement.c:643:gst_element_add_pad:<GstBaseTransform at 0x1302350> adding
pad 'src'
0:00:03.159177874 2690 0xfaa060 INFO GST_ELEMENT_FACTORY
gstelementfactory.c:363:gst_element_factory_create: creating element
"queue" named "queue2"
0:00:03.159217886 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstelement.c:643:gst_element_add_pad:<GstQueue at 0x13062f0> adding pad 'sink'
0:00:03.159255687 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstelement.c:643:gst_element_add_pad:<GstQueue at 0x13062f0> adding pad 'src'
0:00:03.159464149 2690 0xfaa060 INFO GST_PLUGIN_LOADING
gstplugin.c:830:gst_plugin_load_file: plugin
"/usr/lib64/gstreamer-1.0/libgstaudiorate.so" loaded
0:00:03.159483181 2690 0xfaa060 INFO GST_ELEMENT_FACTORY
gstelementfactory.c:363:gst_element_factory_create: creating element
"audiorate" named "audrate"
0:00:03.159599226 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstelement.c:643:gst_element_add_pad:<GstAudioRate at 0x131c0c0> adding pad
'sink'
0:00:03.159638155 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstelement.c:643:gst_element_add_pad:<GstAudioRate at 0x131c0c0> adding pad
'src'
0:00:03.159659563 2690 0xfaa060 INFO GST_ELEMENT_FACTORY
gstelementfactory.c:363:gst_element_factory_create: creating element
"queue" named "queue3"
0:00:03.159700414 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstelement.c:643:gst_element_add_pad:<GstQueue at 0x13065d0> adding pad 'sink'
0:00:03.159748725 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstelement.c:643:gst_element_add_pad:<GstQueue at 0x13065d0> adding pad 'src'
0:00:03.160552605 2690 0xfaa060 INFO GST_PLUGIN_LOADING
gstplugin.c:830:gst_plugin_load_file: plugin
"/usr/lib64/gstreamer-1.0/libgstlame.so" loaded
0:00:03.160572617 2690 0xfaa060 INFO GST_ELEMENT_FACTORY
gstelementfactory.c:363:gst_element_factory_create: creating element
"lamemp3enc" named "lameenc"
0:00:03.160713291 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstelement.c:643:gst_element_add_pad:<GstAudioEncoder at 0x1323400> adding
pad 'sink'
0:00:03.160753592 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstelement.c:643:gst_element_add_pad:<GstAudioEncoder at 0x1323400> adding
pad 'src'
0:00:03.161850078 2690 0xfaa060 INFO GST_PLUGIN_LOADING
gstplugin.c:830:gst_plugin_load_file: plugin
"/usr/lib64/gstreamer-1.0/libgstisomp4.so" loaded
0:00:03.161870512 2690 0xfaa060 INFO GST_ELEMENT_FACTORY
gstelementfactory.c:363:gst_element_factory_create: creating element
"mp4mux" named "mp4-mux"
0:00:03.162000113 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstelement.c:643:gst_element_add_pad:<GstMP4Mux at 0x132e000> adding pad 'src'
0:00:03.162104424 2690 0xfaa060 INFO GST_ELEMENT_FACTORY
gstelementfactory.c:363:gst_element_factory_create: creating element
"filesink" named "file-output"
0:00:03.162204457 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstelement.c:643:gst_element_add_pad:<GstBaseSink at 0x1332800> adding pad
'sink'
0:00:03.162227447 2690 0xfaa060 INFO GST_ELEMENT_FACTORY
gstelementfactory.c:363:gst_element_factory_create: creating element
"tee" named "tee"
0:00:03.162313569 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstelement.c:643:gst_element_add_pad:<GstTee at 0x1333000> adding pad 'sink'
0:00:03.162586666 2690 0xfaa060 INFO GST_PLUGIN_LOADING
gstplugin.c:830:gst_plugin_load_file: plugin
"/usr/lib64/gstreamer-1.0/libgstaudioconvert.so" loaded
0:00:03.162605201 2690 0xfaa060 INFO GST_ELEMENT_FACTORY
gstelementfactory.c:363:gst_element_factory_create: creating element
"audioconvert" named "audio2-conv"
0:00:03.162714409 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstelement.c:643:gst_element_add_pad:<GstBaseTransform at 0x1336aa0> adding
pad 'sink'
0:00:03.162751127 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstelement.c:643:gst_element_add_pad:<GstBaseTransform at 0x1336aa0> adding
pad 'src'
0:00:03.162773419 2690 0xfaa060 INFO GST_ELEMENT_FACTORY
gstelementfactory.c:363:gst_element_factory_create: creating element
"queue" named "queue4"
0:00:03.162812860 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstelement.c:643:gst_element_add_pad:<GstQueue at 0x13068b0> adding pad 'sink'
0:00:03.162858939 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstelement.c:643:gst_element_add_pad:<GstQueue at 0x13068b0> adding pad 'src'
0:00:03.163083398 2690 0xfaa060 INFO GST_PLUGIN_LOADING
gstplugin.c:830:gst_plugin_load_file: plugin
"/usr/lib64/gstreamer-1.0/libgstwavenc.so" loaded
0:00:03.163102246 2690 0xfaa060 INFO GST_ELEMENT_FACTORY
gstelementfactory.c:363:gst_element_factory_create: creating element
"wavenc" named "wav-encoder"
0:00:03.163217539 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstelement.c:643:gst_element_add_pad:<GstWavEnc at 0x133d060> adding pad 'sink'
0:00:03.163256979 2690 0xfaa060 INFO GST_EVENT
gstevent.c:628:gst_event_new_caps: creating caps event audio/x-wav
0:00:03.163287835 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstelement.c:643:gst_element_add_pad:<GstWavEnc at 0x133d060> adding pad 'src'
0:00:03.163308521 2690 0xfaa060 INFO GST_ELEMENT_FACTORY
gstelementfactory.c:363:gst_element_factory_create: creating element
"filesink" named "wav-output"
0:00:03.163340968 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstelement.c:643:gst_element_add_pad:<GstBaseSink at 0x133c930> adding pad
'sink'
0:00:03.163362385 2690 0xfaa060 INFO GST_ELEMENT_FACTORY
gstelementfactory.c:363:gst_element_factory_create: creating element
"tee" named "videotee"
0:00:03.163403558 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstelement.c:643:gst_element_add_pad:<GstTee at 0x1333150> adding pad 'sink'
0:00:03.163426665 2690 0xfaa060 INFO GST_ELEMENT_FACTORY
gstelementfactory.c:363:gst_element_factory_create: creating element
"queue" named "queue5"
0:00:03.163466783 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstelement.c:643:gst_element_add_pad:<GstQueue at 0x1306b90> adding pad 'sink'
0:00:03.163504034 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstelement.c:643:gst_element_add_pad:<GstQueue at 0x1306b90> adding pad 'src'
0:00:03.163529030 2690 0xfaa060 INFO GST_ELEMENT_FACTORY
gstelementfactory.c:363:gst_element_factory_create: creating element
"videoscale" named "monscale"
0:00:03.163567367 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstelement.c:643:gst_element_add_pad:<GstBaseTransform at 0x133fa00> adding
pad 'sink'
0:00:03.163596869 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstelement.c:643:gst_element_add_pad:<GstBaseTransform at 0x133fa00> adding
pad 'src'
0:00:03.163621859 2690 0xfaa060 INFO GST_ELEMENT_FACTORY
gstelementfactory.c:363:gst_element_factory_create: creating element
"capsfilter" named "mon-caps"
0:00:03.163653130 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstelement.c:643:gst_element_add_pad:<GstBaseTransform at 0x1302670> adding
pad 'sink'
0:00:03.163681351 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstelement.c:643:gst_element_add_pad:<GstBaseTransform at 0x1302670> adding
pad 'src'
0:00:03.171280307 2690 0xfaa060 INFO GST_PLUGIN_LOADING
gstplugin.c:830:gst_plugin_load_file: plugin
"/usr/lib64/gstreamer-1.0/libgstautodetect.so" loaded
0:00:03.171310995 2690 0xfaa060 INFO GST_ELEMENT_FACTORY
gstelementfactory.c:363:gst_element_factory_create: creating element
"autovideosink" named "videosink"
0:00:03.171473501 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstelement.c:643:gst_element_add_pad:<GstAutoVideoSink at 0x132e1c0> adding
pad 'sink'
0:00:03.171501941 2690 0xfaa060 INFO GST_ELEMENT_FACTORY
gstelementfactory.c:363:gst_element_factory_create: creating element
"fakesink" named "tempsink"
0:00:03.171619520 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstelement.c:643:gst_element_add_pad:<GstBaseSink at 0x1304000> adding pad
'sink'
0:00:03.171670075 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstelement.c:894:gst_element_get_static_pad: found pad tempsink:sink
0:00:03.171694819 2690 0xfaa060 INFO GST_PADS
gstpad.c:2062:gst_pad_link_prepare: trying to link sink:proxypad0 and
tempsink:sink
0:00:03.171720402 2690 0xfaa060 INFO GST_PADS
gstpad.c:2264:gst_pad_link_full: linked sink:proxypad0 and
tempsink:sink, successful
0:00:03.171753174 2690 0xfaa060 INFO GST_EVENT
gstevent.c:1313:gst_event_new_reconfigure: creating reconfigure event
0:00:03.171812699 2690 0xfaa060 INFO filesink
gstfilesink.c:283:gst_file_sink_set_location: filename :
/home/ian/Recordings/2014/11(Nov)/Mon03PM/Mon03-1214.wav
0:00:03.171834834 2690 0xfaa060 INFO filesink
gstfilesink.c:284:gst_file_sink_set_location: uri :
file:///home/ian/Recordings/2014/11(Nov)/Mon03PM/Mon03-1214.wav
0:00:03.171863597 2690 0xfaa060 INFO filesink
gstfilesink.c:283:gst_file_sink_set_location: filename :
/home/ian/Recordings/2014/11(Nov)/Mon03PM/Mon03-1214.mp4
0:00:03.171883542 2690 0xfaa060 INFO filesink
gstfilesink.c:284:gst_file_sink_set_location: uri :
file:///home/ian/Recordings/2014/11(Nov)/Mon03PM/Mon03-1214.mp4
0:00:03.171931105 2690 0xfaa060 INFO GST_EVENT
gstevent.c:1313:gst_event_new_reconfigure: creating reconfigure event
0:00:03.171965889 2690 0xfaa060 INFO GST_EVENT
gstevent.c:1313:gst_event_new_reconfigure: creating reconfigure event
0:00:03.172000739 2690 0xfaa060 INFO GST_EVENT
gstevent.c:1313:gst_event_new_reconfigure: creating reconfigure event
0:00:03.172208943 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstutils.c:1543:gst_element_link_pads_full: trying to link element
vid-source:(any) to element videotee:(any)
0:00:03.172239937 2690 0xfaa060 INFO GST_PADS
gstutils.c:936:gst_pad_check_link: trying to link vid-source:src and
videotee:sink
0:00:03.172293356 2690 0xfaa060 INFO GST_PADS
gstutils.c:1443:prepare_link_maybe_ghosting: vid-source and videotee in
same bin, no need for ghost pads
0:00:03.172325640 2690 0xfaa060 INFO GST_PADS
gstpad.c:2062:gst_pad_link_prepare: trying to link vid-source:src and
videotee:sink
0:00:03.172366669 2690 0xfaa060 INFO GST_PADS
gstpad.c:2264:gst_pad_link_full: linked vid-source:src and
videotee:sink, successful
0:00:03.172389852 2690 0xfaa060 INFO GST_EVENT
gstevent.c:1313:gst_event_new_reconfigure: creating reconfigure event
0:00:03.172410426 2690 0xfaa060 INFO GST_EVENT
gstpad.c:4874:gst_pad_send_event_unchecked:<vid-source:src> Received
event on flushing pad. Discarding
0:00:03.172442362 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstutils.c:1543:gst_element_link_pads_full: trying to link element
videotee:(any) to element vidrate:(any)
0:00:03.172475594 2690 0xfaa060 INFO GST_PADS
gstpad.c:3583:gst_pad_peer_query:<vidrate:src> pad has no peer
0:00:03.172562140 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstelement.c:643:gst_element_add_pad:<videotee> adding pad 'src_0'
0:00:03.172592105 2690 0xfaa060 INFO GST_PADS
gstutils.c:1443:prepare_link_maybe_ghosting: videotee and vidrate in
same bin, no need for ghost pads
0:00:03.172619436 2690 0xfaa060 INFO GST_PADS
gstpad.c:2062:gst_pad_link_prepare: trying to link videotee:src_0 and
vidrate:sink
0:00:03.172654433 2690 0xfaa060 INFO GST_PADS
gstpad.c:3583:gst_pad_peer_query:<vidrate:src> pad has no peer
0:00:03.172688890 2690 0xfaa060 INFO GST_PADS
gstpad.c:2264:gst_pad_link_full: linked videotee:src_0 and vidrate:sink,
successful
0:00:03.172710881 2690 0xfaa060 INFO GST_EVENT
gstevent.c:1313:gst_event_new_reconfigure: creating reconfigure event
0:00:03.172741054 2690 0xfaa060 INFO GST_EVENT
gstpad.c:4874:gst_pad_send_event_unchecked:<videotee:src_0> Received
event on flushing pad. Discarding
0:00:03.172768610 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstutils.c:1543:gst_element_link_pads_full: trying to link element
vidrate:(any) to element vidscale:(any)
0:00:03.172792503 2690 0xfaa060 INFO GST_PADS
gstutils.c:936:gst_pad_check_link: trying to link vidrate:src and
vidscale:sink
0:00:03.174040414 2690 0xfaa060 INFO GST_PADS
gstpad.c:3583:gst_pad_peer_query:<vidscale:src> pad has no peer
0:00:03.174318132 2690 0xfaa060 INFO GST_PADS
gstutils.c:1443:prepare_link_maybe_ghosting: vidrate and vidscale in
same bin, no need for ghost pads
0:00:03.174348013 2690 0xfaa060 INFO GST_PADS
gstpad.c:2062:gst_pad_link_prepare: trying to link vidrate:src and
vidscale:sink
0:00:03.175560436 2690 0xfaa060 INFO GST_PADS
gstpad.c:3583:gst_pad_peer_query:<vidscale:src> pad has no peer
0:00:03.175833585 2690 0xfaa060 INFO GST_PADS
gstpad.c:2264:gst_pad_link_full: linked vidrate:src and vidscale:sink,
successful
0:00:03.175857510 2690 0xfaa060 INFO GST_EVENT
gstevent.c:1313:gst_event_new_reconfigure: creating reconfigure event
0:00:03.175878446 2690 0xfaa060 INFO GST_EVENT
gstpad.c:4874:gst_pad_send_event_unchecked:<vidrate:src> Received event
on flushing pad. Discarding
0:00:03.175905822 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstutils.c:1543:gst_element_link_pads_full: trying to link element
vidscale:(any) to element vid-caps:(any)
0:00:03.175930024 2690 0xfaa060 INFO GST_PADS
gstutils.c:936:gst_pad_check_link: trying to link vidscale:src and
vid-caps:sink
0:00:03.178972848 2690 0xfaa060 INFO GST_PADS
gstpad.c:3583:gst_pad_peer_query:<vid-caps:src> pad has no peer
0:00:03.179024666 2690 0xfaa060 INFO GST_PADS
gstutils.c:1443:prepare_link_maybe_ghosting: vidscale and vid-caps in
same bin, no need for ghost pads
0:00:03.179052809 2690 0xfaa060 INFO GST_PADS
gstpad.c:2062:gst_pad_link_prepare: trying to link vidscale:src and
vid-caps:sink
0:00:03.182086233 2690 0xfaa060 INFO GST_PADS
gstpad.c:3583:gst_pad_peer_query:<vid-caps:src> pad has no peer
0:00:03.182139074 2690 0xfaa060 INFO GST_PADS
gstpad.c:2264:gst_pad_link_full: linked vidscale:src and vid-caps:sink,
successful
0:00:03.182161823 2690 0xfaa060 INFO GST_EVENT
gstevent.c:1313:gst_event_new_reconfigure: creating reconfigure event
0:00:03.182182909 2690 0xfaa060 INFO GST_EVENT
gstpad.c:4874:gst_pad_send_event_unchecked:<vidscale:src> Received event
on flushing pad. Discarding
0:00:03.182209942 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstutils.c:1543:gst_element_link_pads_full: trying to link element
vid-caps:(any) to element queue1:(any)
0:00:03.182233945 2690 0xfaa060 INFO GST_PADS
gstutils.c:936:gst_pad_check_link: trying to link vid-caps:src and
queue1:sink
0:00:03.206579782 2690 0xfaa060 INFO GST_PADS
gstpad.c:3583:gst_pad_peer_query:<queue1:src> pad has no peer
0:00:03.206614352 2690 0xfaa060 INFO GST_PADS
gstutils.c:1443:prepare_link_maybe_ghosting: vid-caps and queue1 in same
bin, no need for ghost pads
0:00:03.206646372 2690 0xfaa060 INFO GST_PADS
gstpad.c:2062:gst_pad_link_prepare: trying to link vid-caps:src and
queue1:sink
0:00:03.209803659 2690 0xfaa060 INFO GST_PADS
gstpad.c:3583:gst_pad_peer_query:<queue1:src> pad has no peer
0:00:03.209849380 2690 0xfaa060 INFO GST_PADS
gstpad.c:2264:gst_pad_link_full: linked vid-caps:src and queue1:sink,
successful
0:00:03.209877688 2690 0xfaa060 INFO GST_EVENT
gstevent.c:1313:gst_event_new_reconfigure: creating reconfigure event
0:00:03.209901439 2690 0xfaa060 INFO GST_EVENT
gstpad.c:4874:gst_pad_send_event_unchecked:<vid-caps:src> Received event
on flushing pad. Discarding
0:00:03.209931931 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstutils.c:1543:gst_element_link_pads_full: trying to link element
queue1:(any) to element videnc:(any)
0:00:03.209963888 2690 0xfaa060 INFO GST_PADS
gstutils.c:936:gst_pad_check_link: trying to link queue1:src and videnc:sink
0:00:03.213070132 2690 0xfaa060 INFO GST_PADS
gstutils.c:1443:prepare_link_maybe_ghosting: queue1 and videnc in same
bin, no need for ghost pads
0:00:03.213112993 2690 0xfaa060 INFO GST_PADS
gstpad.c:2062:gst_pad_link_prepare: trying to link queue1:src and
videnc:sink
0:00:03.216219820 2690 0xfaa060 INFO GST_PADS
gstpad.c:2264:gst_pad_link_full: linked queue1:src and videnc:sink,
successful
0:00:03.216258169 2690 0xfaa060 INFO GST_EVENT
gstevent.c:1313:gst_event_new_reconfigure: creating reconfigure event
0:00:03.216280714 2690 0xfaa060 INFO GST_EVENT
gstpad.c:4874:gst_pad_send_event_unchecked:<queue1:src> Received event
on flushing pad. Discarding
0:00:03.216308920 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstutils.c:1543:gst_element_link_pads_full: trying to link element
videnc:(any) to element mp4-mux:(any)
0:00:03.216436467 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstelement.c:643:gst_element_add_pad:<mp4-mux> adding pad 'video_0'
0:00:03.216466222 2690 0xfaa060 INFO GST_PADS
gstutils.c:1443:prepare_link_maybe_ghosting: videnc and mp4-mux in same
bin, no need for ghost pads
0:00:03.216494626 2690 0xfaa060 INFO GST_PADS
gstpad.c:2062:gst_pad_link_prepare: trying to link videnc:src and
mp4-mux:video_0
0:00:03.216528427 2690 0xfaa060 INFO GST_PADS
gstpad.c:2264:gst_pad_link_full: linked videnc:src and mp4-mux:video_0,
successful
0:00:03.216551005 2690 0xfaa060 INFO GST_EVENT
gstevent.c:1313:gst_event_new_reconfigure: creating reconfigure event
0:00:03.216572617 2690 0xfaa060 INFO GST_EVENT
gstpad.c:4874:gst_pad_send_event_unchecked:<videnc:src> Received event
on flushing pad. Discarding
0:00:03.216600309 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstutils.c:1543:gst_element_link_pads_full: trying to link element
alsa-source:(any) to element audio-caps:(any)
0:00:03.216626132 2690 0xfaa060 INFO GST_PADS
gstutils.c:936:gst_pad_check_link: trying to link alsa-source:src and
audio-caps:sink
0:00:03.216663013 2690 0xfaa060 INFO GST_PADS
gstpad.c:3583:gst_pad_peer_query:<audio-caps:src> pad has no peer
0:00:03.216689366 2690 0xfaa060 INFO GST_PADS
gstutils.c:1443:prepare_link_maybe_ghosting: alsa-source and audio-caps
in same bin, no need for ghost pads
0:00:03.216716504 2690 0xfaa060 INFO GST_PADS
gstpad.c:2062:gst_pad_link_prepare: trying to link alsa-source:src and
audio-caps:sink
0:00:03.216752422 2690 0xfaa060 INFO GST_PADS
gstpad.c:3583:gst_pad_peer_query:<audio-caps:src> pad has no peer
0:00:03.216778441 2690 0xfaa060 INFO GST_PADS
gstpad.c:2264:gst_pad_link_full: linked alsa-source:src and
audio-caps:sink, successful
0:00:03.216800378 2690 0xfaa060 INFO GST_EVENT
gstevent.c:1313:gst_event_new_reconfigure: creating reconfigure event
0:00:03.216821564 2690 0xfaa060 INFO GST_EVENT
gstpad.c:4874:gst_pad_send_event_unchecked:<alsa-source:src> Received
event on flushing pad. Discarding
0:00:03.216848049 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstutils.c:1543:gst_element_link_pads_full: trying to link element
audio-caps:(any) to element queue2:(any)
0:00:03.216872783 2690 0xfaa060 INFO GST_PADS
gstutils.c:936:gst_pad_check_link: trying to link audio-caps:src and
queue2:sink
0:00:03.216922385 2690 0xfaa060 INFO GST_PADS
gstpad.c:3583:gst_pad_peer_query:<queue2:src> pad has no peer
0:00:03.216951587 2690 0xfaa060 INFO GST_PADS
gstutils.c:1443:prepare_link_maybe_ghosting: audio-caps and queue2 in
same bin, no need for ghost pads
0:00:03.216978195 2690 0xfaa060 INFO GST_PADS
gstpad.c:2062:gst_pad_link_prepare: trying to link audio-caps:src and
queue2:sink
0:00:03.217025399 2690 0xfaa060 INFO GST_PADS
gstpad.c:3583:gst_pad_peer_query:<queue2:src> pad has no peer
0:00:03.217053674 2690 0xfaa060 INFO GST_PADS
gstpad.c:2264:gst_pad_link_full: linked audio-caps:src and queue2:sink,
successful
0:00:03.217074962 2690 0xfaa060 INFO GST_EVENT
gstevent.c:1313:gst_event_new_reconfigure: creating reconfigure event
0:00:03.217095666 2690 0xfaa060 INFO GST_EVENT
gstpad.c:4874:gst_pad_send_event_unchecked:<audio-caps:src> Received
event on flushing pad. Discarding
0:00:03.217121225 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstutils.c:1543:gst_element_link_pads_full: trying to link element
queue2:(any) to element tee:(any)
0:00:03.217145388 2690 0xfaa060 INFO GST_PADS
gstutils.c:936:gst_pad_check_link: trying to link queue2:src and tee:sink
0:00:03.217198430 2690 0xfaa060 INFO GST_PADS
gstutils.c:1443:prepare_link_maybe_ghosting: queue2 and tee in same bin,
no need for ghost pads
0:00:03.217225397 2690 0xfaa060 INFO GST_PADS
gstpad.c:2062:gst_pad_link_prepare: trying to link queue2:src and tee:sink
0:00:03.217278825 2690 0xfaa060 INFO GST_PADS
gstpad.c:2264:gst_pad_link_full: linked queue2:src and tee:sink, successful
0:00:03.217301105 2690 0xfaa060 INFO GST_EVENT
gstevent.c:1313:gst_event_new_reconfigure: creating reconfigure event
0:00:03.217321478 2690 0xfaa060 INFO GST_EVENT
gstpad.c:4874:gst_pad_send_event_unchecked:<queue2:src> Received event
on flushing pad. Discarding
0:00:03.217347485 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstutils.c:1543:gst_element_link_pads_full: trying to link element
tee:(any) to element audrate:(any)
0:00:03.217376476 2690 0xfaa060 INFO GST_PADS
gstpad.c:3583:gst_pad_peer_query:<audrate:src> pad has no peer
0:00:03.217437502 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstelement.c:643:gst_element_add_pad:<tee> adding pad 'src_0'
0:00:03.217462799 2690 0xfaa060 INFO GST_PADS
gstutils.c:1443:prepare_link_maybe_ghosting: tee and audrate in same
bin, no need for ghost pads
0:00:03.217489392 2690 0xfaa060 INFO GST_PADS
gstpad.c:2062:gst_pad_link_prepare: trying to link tee:src_0 and
audrate:sink
0:00:03.217543334 2690 0xfaa060 INFO GST_PADS
gstpad.c:3583:gst_pad_peer_query:<audrate:src> pad has no peer
0:00:03.217576939 2690 0xfaa060 INFO GST_PADS
gstpad.c:2264:gst_pad_link_full: linked tee:src_0 and audrate:sink,
successful
0:00:03.217598946 2690 0xfaa060 INFO GST_EVENT
gstevent.c:1313:gst_event_new_reconfigure: creating reconfigure event
0:00:03.217619451 2690 0xfaa060 INFO GST_EVENT
gstpad.c:4874:gst_pad_send_event_unchecked:<tee:src_0> Received event on
flushing pad. Discarding
0:00:03.217645488 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstutils.c:1543:gst_element_link_pads_full: trying to link element
audrate:(any) to element queue3:(any)
0:00:03.217669609 2690 0xfaa060 INFO GST_PADS
gstutils.c:936:gst_pad_check_link: trying to link audrate:src and
queue3:sink
0:00:03.217924948 2690 0xfaa060 INFO GST_PADS
gstpad.c:3583:gst_pad_peer_query:<queue3:src> pad has no peer
0:00:03.217953517 2690 0xfaa060 INFO GST_PADS
gstutils.c:1443:prepare_link_maybe_ghosting: audrate and queue3 in same
bin, no need for ghost pads
0:00:03.217979509 2690 0xfaa060 INFO GST_PADS
gstpad.c:2062:gst_pad_link_prepare: trying to link audrate:src and
queue3:sink
0:00:03.218226233 2690 0xfaa060 INFO GST_PADS
gstpad.c:3583:gst_pad_peer_query:<queue3:src> pad has no peer
0:00:03.218255097 2690 0xfaa060 INFO GST_PADS
gstpad.c:2264:gst_pad_link_full: linked audrate:src and queue3:sink,
successful
0:00:03.218276866 2690 0xfaa060 INFO GST_EVENT
gstevent.c:1313:gst_event_new_reconfigure: creating reconfigure event
0:00:03.218297023 2690 0xfaa060 INFO GST_EVENT
gstpad.c:4874:gst_pad_send_event_unchecked:<audrate:src> Received event
on flushing pad. Discarding
0:00:03.218323282 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstutils.c:1543:gst_element_link_pads_full: trying to link element
queue3:(any) to element lameenc:(any)
0:00:03.247028857 2690 0xfaa060 INFO GST_PADS
gstutils.c:936:gst_pad_check_link: trying to link queue3:src and
lameenc:sink
0:00:03.247240811 2690 0xfaa060 INFO GST_PADS
gstutils.c:1443:prepare_link_maybe_ghosting: queue3 and lameenc in same
bin, no need for ghost pads
0:00:03.247266033 2690 0xfaa060 INFO GST_PADS
gstpad.c:2062:gst_pad_link_prepare: trying to link queue3:src and
lameenc:sink
0:00:03.247460198 2690 0xfaa060 INFO GST_PADS
gstpad.c:2264:gst_pad_link_full: linked queue3:src and lameenc:sink,
successful
0:00:03.247478878 2690 0xfaa060 INFO GST_EVENT
gstevent.c:1313:gst_event_new_reconfigure: creating reconfigure event
0:00:03.247496023 2690 0xfaa060 INFO GST_EVENT
gstpad.c:4874:gst_pad_send_event_unchecked:<queue3:src> Received event
on flushing pad. Discarding
0:00:03.247517211 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstutils.c:1543:gst_element_link_pads_full: trying to link element
lameenc:(any) to element mp4-mux:(any)
0:00:03.247597019 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstelement.c:643:gst_element_add_pad:<mp4-mux> adding pad 'audio_0'
0:00:03.247618451 2690 0xfaa060 INFO GST_PADS
gstutils.c:1443:prepare_link_maybe_ghosting: lameenc and mp4-mux in same
bin, no need for ghost pads
0:00:03.247639660 2690 0xfaa060 INFO GST_PADS
gstpad.c:2062:gst_pad_link_prepare: trying to link lameenc:src and
mp4-mux:audio_0
0:00:03.247663886 2690 0xfaa060 INFO GST_PADS
gstpad.c:2264:gst_pad_link_full: linked lameenc:src and mp4-mux:audio_0,
successful
0:00:03.247680800 2690 0xfaa060 INFO GST_EVENT
gstevent.c:1313:gst_event_new_reconfigure: creating reconfigure event
0:00:03.247697043 2690 0xfaa060 INFO GST_EVENT
gstpad.c:4874:gst_pad_send_event_unchecked:<lameenc:src> Received event
on flushing pad. Discarding
0:00:03.247718989 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstutils.c:1543:gst_element_link_pads_full: trying to link element
mp4-mux:(any) to element file-output:(any)
0:00:03.247767033 2690 0xfaa060 INFO GST_PADS
gstutils.c:936:gst_pad_check_link: trying to link mp4-mux:src and
file-output:sink
0:00:03.247798984 2690 0xfaa060 INFO GST_PADS
gstutils.c:1443:prepare_link_maybe_ghosting: mp4-mux and file-output in
same bin, no need for ghost pads
0:00:03.247825860 2690 0xfaa060 INFO GST_PADS
gstpad.c:2062:gst_pad_link_prepare: trying to link mp4-mux:src and
file-output:sink
0:00:03.247854869 2690 0xfaa060 INFO GST_PADS
gstpad.c:2264:gst_pad_link_full: linked mp4-mux:src and
file-output:sink, successful
0:00:03.247876538 2690 0xfaa060 INFO GST_EVENT
gstevent.c:1313:gst_event_new_reconfigure: creating reconfigure event
0:00:03.247897751 2690 0xfaa060 INFO GST_EVENT
gstpad.c:4874:gst_pad_send_event_unchecked:<mp4-mux:src> Received event
on flushing pad. Discarding
0:00:03.247924621 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstutils.c:1543:gst_element_link_pads_full: trying to link element
tee:(any) to element audio2-conv:(any)
0:00:03.247955654 2690 0xfaa060 INFO GST_PADS
gstpad.c:3583:gst_pad_peer_query:<audio2-conv:src> pad has no peer
0:00:03.248000720 2690 0xfaa060 INFO structure
gststructure.c:2798:gst_structure_get_valist: Expected field
'channel-mask' in structure: audio/x-raw, rate=(int)[ 1, 2147483647 ],
channels=(int)[ 1, 2147483647 ], layout=(string)interleaved;
0:00:03.248108827 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstelement.c:643:gst_element_add_pad:<tee> adding pad 'src_1'
0:00:03.248139084 2690 0xfaa060 INFO GST_PADS
gstutils.c:1443:prepare_link_maybe_ghosting: tee and audio2-conv in same
bin, no need for ghost pads
0:00:03.248165786 2690 0xfaa060 INFO GST_PADS
gstpad.c:2062:gst_pad_link_prepare: trying to link tee:src_1 and
audio2-conv:sink
0:00:03.248220793 2690 0xfaa060 INFO GST_PADS
gstpad.c:3583:gst_pad_peer_query:<audio2-conv:src> pad has no peer
0:00:03.248257385 2690 0xfaa060 INFO structure
gststructure.c:2798:gst_structure_get_valist: Expected field
'channel-mask' in structure: audio/x-raw, rate=(int)[ 1, 2147483647 ],
channels=(int)[ 1, 2147483647 ], layout=(string)interleaved;
0:00:03.248331953 2690 0xfaa060 INFO GST_PADS
gstpad.c:2264:gst_pad_link_full: linked tee:src_1 and audio2-conv:sink,
successful
0:00:03.248355099 2690 0xfaa060 INFO GST_EVENT
gstevent.c:1313:gst_event_new_reconfigure: creating reconfigure event
0:00:03.248375953 2690 0xfaa060 INFO GST_EVENT
gstpad.c:4874:gst_pad_send_event_unchecked:<tee:src_1> Received event on
flushing pad. Discarding
0:00:03.248402983 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstutils.c:1543:gst_element_link_pads_full: trying to link element
audio2-conv:(any) to element queue4:(any)
0:00:03.248427784 2690 0xfaa060 INFO GST_PADS
gstutils.c:936:gst_pad_check_link: trying to link audio2-conv:src and
queue4:sink
0:00:03.248677885 2690 0xfaa060 INFO structure
gststructure.c:2798:gst_structure_get_valist: Expected field
'channel-mask' in structure: audio/x-raw, rate=(int)44100,
channels=(int)1, layout=(string)interleaved;
0:00:03.248942981 2690 0xfaa060 INFO GST_PADS
gstpad.c:3583:gst_pad_peer_query:<queue4:src> pad has no peer
0:00:03.248974872 2690 0xfaa060 INFO GST_PADS
gstutils.c:1443:prepare_link_maybe_ghosting: audio2-conv and queue4 in
same bin, no need for ghost pads
0:00:03.249001375 2690 0xfaa060 INFO GST_PADS
gstpad.c:2062:gst_pad_link_prepare: trying to link audio2-conv:src and
queue4:sink
0:00:03.249250159 2690 0xfaa060 INFO structure
gststructure.c:2798:gst_structure_get_valist: Expected field
'channel-mask' in structure: audio/x-raw, rate=(int)44100,
channels=(int)1, layout=(string)interleaved;
0:00:03.249497199 2690 0xfaa060 INFO GST_PADS
gstpad.c:3583:gst_pad_peer_query:<queue4:src> pad has no peer
0:00:03.249529402 2690 0xfaa060 INFO GST_PADS
gstpad.c:2264:gst_pad_link_full: linked audio2-conv:src and queue4:sink,
successful
0:00:03.249550948 2690 0xfaa060 INFO GST_EVENT
gstevent.c:1313:gst_event_new_reconfigure: creating reconfigure event
0:00:03.249571800 2690 0xfaa060 INFO GST_EVENT
gstpad.c:4874:gst_pad_send_event_unchecked:<audio2-conv:src> Received
event on flushing pad. Discarding
0:00:03.249598204 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstutils.c:1543:gst_element_link_pads_full: trying to link element
queue4:(any) to element wav-encoder:(any)
0:00:03.249622210 2690 0xfaa060 INFO GST_PADS
gstutils.c:936:gst_pad_check_link: trying to link queue4:src and
wav-encoder:sink
0:00:03.249881014 2690 0xfaa060 INFO structure
gststructure.c:2798:gst_structure_get_valist: Expected field
'channel-mask' in structure: audio/x-raw, rate=(int)44100,
channels=(int)1, layout=(string)interleaved;
0:00:03.250143000 2690 0xfaa060 INFO GST_PADS
gstutils.c:1443:prepare_link_maybe_ghosting: queue4 and wav-encoder in
same bin, no need for ghost pads
0:00:03.250171323 2690 0xfaa060 INFO GST_PADS
gstpad.c:2062:gst_pad_link_prepare: trying to link queue4:src and
wav-encoder:sink
0:00:03.250422955 2690 0xfaa060 INFO structure
gststructure.c:2798:gst_structure_get_valist: Expected field
'channel-mask' in structure: audio/x-raw, rate=(int)44100,
channels=(int)1, layout=(string)interleaved;
0:00:03.250681997 2690 0xfaa060 INFO GST_PADS
gstpad.c:2264:gst_pad_link_full: linked queue4:src and wav-encoder:sink,
successful
0:00:03.250705320 2690 0xfaa060 INFO GST_EVENT
gstevent.c:1313:gst_event_new_reconfigure: creating reconfigure event
0:00:03.250731694 2690 0xfaa060 INFO GST_EVENT
gstpad.c:4874:gst_pad_send_event_unchecked:<queue4:src> Received event
on flushing pad. Discarding
0:00:03.250759314 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstutils.c:1543:gst_element_link_pads_full: trying to link element
wav-encoder:(any) to element wav-output:(any)
0:00:03.279132115 2690 0xfaa060 INFO GST_PADS
gstutils.c:936:gst_pad_check_link: trying to link wav-encoder:src and
wav-output:sink
0:00:03.279160586 2690 0xfaa060 INFO GST_PADS
gstutils.c:1443:prepare_link_maybe_ghosting: wav-encoder and wav-output
in same bin, no need for ghost pads
0:00:03.279182240 2690 0xfaa060 INFO GST_PADS
gstpad.c:2062:gst_pad_link_prepare: trying to link wav-encoder:src and
wav-output:sink
0:00:03.279204960 2690 0xfaa060 INFO GST_PADS
gstpad.c:2264:gst_pad_link_full: linked wav-encoder:src and
wav-output:sink, successful
0:00:03.279220045 2690 0xfaa060 INFO GST_EVENT
gstevent.c:1313:gst_event_new_reconfigure: creating reconfigure event
0:00:03.279233842 2690 0xfaa060 INFO GST_EVENT
gstpad.c:4874:gst_pad_send_event_unchecked:<wav-encoder:src> Received
event on flushing pad. Discarding
0:00:03.279253930 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstutils.c:1543:gst_element_link_pads_full: trying to link element
videotee:(any) to element queue5:(any)
0:00:03.279279203 2690 0xfaa060 INFO GST_PADS
gstpad.c:3583:gst_pad_peer_query:<queue5:src> pad has no peer
0:00:03.279336445 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstelement.c:643:gst_element_add_pad:<videotee> adding pad 'src_1'
0:00:03.279355930 2690 0xfaa060 INFO GST_PADS
gstutils.c:1443:prepare_link_maybe_ghosting: videotee and queue5 in same
bin, no need for ghost pads
0:00:03.279375876 2690 0xfaa060 INFO GST_PADS
gstpad.c:2062:gst_pad_link_prepare: trying to link videotee:src_1 and
queue5:sink
0:00:03.279404497 2690 0xfaa060 INFO GST_PADS
gstpad.c:3583:gst_pad_peer_query:<queue5:src> pad has no peer
0:00:03.279421471 2690 0xfaa060 INFO GST_PADS
gstpad.c:2264:gst_pad_link_full: linked videotee:src_1 and queue5:sink,
successful
0:00:03.279435930 2690 0xfaa060 INFO GST_EVENT
gstevent.c:1313:gst_event_new_reconfigure: creating reconfigure event
0:00:03.279449584 2690 0xfaa060 INFO GST_EVENT
gstpad.c:4874:gst_pad_send_event_unchecked:<videotee:src_1> Received
event on flushing pad. Discarding
0:00:03.279468898 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstutils.c:1543:gst_element_link_pads_full: trying to link element
queue5:(any) to element monscale:(any)
0:00:03.279486239 2690 0xfaa060 INFO GST_PADS
gstutils.c:936:gst_pad_check_link: trying to link queue5:src and
monscale:sink
0:00:03.279515479 2690 0xfaa060 INFO GST_PADS
gstpad.c:3583:gst_pad_peer_query:<monscale:src> pad has no peer
0:00:03.279765578 2690 0xfaa060 INFO GST_PADS
gstutils.c:1443:prepare_link_maybe_ghosting: queue5 and monscale in same
bin, no need for ghost pads
0:00:03.279787211 2690 0xfaa060 INFO GST_PADS
gstpad.c:2062:gst_pad_link_prepare: trying to link queue5:src and
monscale:sink
0:00:03.279817562 2690 0xfaa060 INFO GST_PADS
gstpad.c:3583:gst_pad_peer_query:<monscale:src> pad has no peer
0:00:03.280047961 2690 0xfaa060 INFO GST_PADS
gstpad.c:2264:gst_pad_link_full: linked queue5:src and monscale:sink,
successful
0:00:03.280064201 2690 0xfaa060 INFO GST_EVENT
gstevent.c:1313:gst_event_new_reconfigure: creating reconfigure event
0:00:03.280077923 2690 0xfaa060 INFO GST_EVENT
gstpad.c:4874:gst_pad_send_event_unchecked:<queue5:src> Received event
on flushing pad. Discarding
0:00:03.280097430 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstutils.c:1543:gst_element_link_pads_full: trying to link element
monscale:(any) to element mon-caps:(any)
0:00:03.280115289 2690 0xfaa060 INFO GST_PADS
gstutils.c:936:gst_pad_check_link: trying to link monscale:src and
mon-caps:sink
0:00:03.280778166 2690 0xfaa060 INFO GST_PADS
gstpad.c:3583:gst_pad_peer_query:<mon-caps:src> pad has no peer
0:00:03.280810604 2690 0xfaa060 INFO GST_PADS
gstutils.c:1443:prepare_link_maybe_ghosting: monscale and mon-caps in
same bin, no need for ghost pads
0:00:03.280831146 2690 0xfaa060 INFO GST_PADS
gstpad.c:2062:gst_pad_link_prepare: trying to link monscale:src and
mon-caps:sink
0:00:03.281469337 2690 0xfaa060 INFO GST_PADS
gstpad.c:3583:gst_pad_peer_query:<mon-caps:src> pad has no peer
0:00:03.281500971 2690 0xfaa060 INFO GST_PADS
gstpad.c:2264:gst_pad_link_full: linked monscale:src and mon-caps:sink,
successful
0:00:03.281545604 2690 0xfaa060 INFO GST_EVENT
gstevent.c:1313:gst_event_new_reconfigure: creating reconfigure event
0:00:03.281568615 2690 0xfaa060 INFO GST_EVENT
gstpad.c:4874:gst_pad_send_event_unchecked:<monscale:src> Received event
on flushing pad. Discarding
0:00:03.281596291 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstutils.c:1543:gst_element_link_pads_full: trying to link element
mon-caps:(any) to element videosink:(any)
0:00:03.281621802 2690 0xfaa060 INFO GST_PADS
gstutils.c:936:gst_pad_check_link: trying to link mon-caps:src and
videosink:sink
0:00:03.282308181 2690 0xfaa060 INFO GST_PADS
gstutils.c:1443:prepare_link_maybe_ghosting: mon-caps and videosink in
same bin, no need for ghost pads
0:00:03.282338685 2690 0xfaa060 INFO GST_PADS
gstpad.c:2062:gst_pad_link_prepare: trying to link mon-caps:src and
videosink:sink
0:00:03.283026188 2690 0xfaa060 INFO GST_PADS
gstpad.c:2264:gst_pad_link_full: linked mon-caps:src and videosink:sink,
successful
0:00:03.283051043 2690 0xfaa060 INFO GST_EVENT
gstevent.c:1313:gst_event_new_reconfigure: creating reconfigure event
0:00:03.283072938 2690 0xfaa060 INFO GST_EVENT
gstpad.c:4874:gst_pad_send_event_unchecked:<mon-caps:src> Received event
on flushing pad. Discarding
0:00:03.283163638 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<videosink> current NULL pending
VOID_PENDING, desired next READY
0:00:03.283198964 2690 0xfaa060 INFO GST_STATES
gstelement.c:2321:gst_element_continue_state:<tempsink> completed state
change to NULL
0:00:03.283227464 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstpad.c:1819:gst_pad_unlink: unlinking sink:proxypad0(0x1346040) and
tempsink:sink(0x1339900)
0:00:03.283252220 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstpad.c:1873:gst_pad_unlink: unlinked sink:proxypad0 and tempsink:sink
0:00:03.283276419 2690 0xfaa060 INFO GST_PARENTAGE
gstbin.c:1523:gst_bin_remove_func:<videosink> removed child "tempsink"
0:00:03.283304769 2690 0xfaa060 INFO GST_REFCOUNTING
gstelement.c:2865:gst_element_dispose:<tempsink> dispose
0:00:03.283326207 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstelement.c:763:gst_element_remove_pad:<tempsink> removing pad 'sink'
0:00:03.283362805 2690 0xfaa060 INFO GST_REFCOUNTING
gstelement.c:2909:gst_element_dispose:<tempsink> parent class dispose
0:00:03.283389757 2690 0xfaa060 INFO GST_REFCOUNTING
gstelement.c:2940:gst_element_finalize:<tempsink> finalize
0:00:03.283411023 2690 0xfaa060 INFO GST_REFCOUNTING
gstelement.c:2945:gst_element_finalize:<tempsink> finalize parent
0:00:03.285469913 2690 0xfaa060 INFO GST_PLUGIN_LOADING
gstplugin.c:830:gst_plugin_load_file: plugin
"/usr/lib64/gstreamer-1.0/libgstxvimagesink.so" loaded
0:00:03.285498167 2690 0xfaa060 INFO GST_ELEMENT_FACTORY
gstelementfactory.c:363:gst_element_factory_create: creating element
"xvimagesink" named "videosink-actual-sink-xvimage"
0:00:03.285766584 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstelement.c:643:gst_element_add_pad:<GstBaseSink at 0x135a400> adding pad
'sink'
0:00:03.285802902 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstelement.c:894:gst_element_get_static_pad: found pad
videosink-actual-sink-xvimage:sink
0:00:03.287380398 2690 0xfaa060 INFO GST_STATES
gstelement.c:2321:gst_element_continue_state:<videosink-actual-sink-xvimage>
completed state change to READY
0:00:03.287410252 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<videosink-actual-sink-xvimage>
notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:03.287481999 2690 0xfaa060 INFO GST_ELEMENT_PADS
gstelement.c:894:gst_element_get_static_pad: found pad
videosink-actual-sink-xvimage:sink
0:00:03.287507738 2690 0xfaa060 INFO GST_PADS
gstpad.c:2062:gst_pad_link_prepare: trying to link sink:proxypad0 and
videosink-actual-sink-xvimage:sink
0:00:03.287530253 2690 0xfaa060 INFO GST_PADS
gstpad.c:2264:gst_pad_link_full: linked sink:proxypad0 and
videosink-actual-sink-xvimage:sink, successful
0:00:03.287550644 2690 0xfaa060 INFO GST_EVENT
gstevent.c:1313:gst_event_new_reconfigure: creating reconfigure event
0:00:03.287582889 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<videosink-actual-sink-xvimage>
current READY pending VOID_PENDING, desired next READY
0:00:03.287604538 2690 0xfaa060 INFO GST_STATES
gstbin.c:2311:gst_bin_element_set_state:<videosink-actual-sink-xvimage>
skipping transition from READY to READY
0:00:03.287624658 2690 0xfaa060 INFO GST_STATES
gstbin.c:2602:gst_bin_change_state_func:<videosink> child
'videosink-actual-sink-xvimage' changed state to 2(READY) successfully
0:00:03.287650064 2690 0xfaa060 INFO GST_STATES
gstelement.c:2321:gst_element_continue_state:<videosink> completed state
change to READY
0:00:03.287670016 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<videosink> notifying
about state-changed NULL to READY (VOID_PENDING pending)
0:00:03.287702742 2690 0xfaa060 INFO GST_STATES
gstbin.c:2602:gst_bin_change_state_func:<av-recorder> child 'videosink'
changed state to 2(READY) successfully
0:00:03.287737334 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<wav-output> current NULL
pending VOID_PENDING, desired next READY
0:00:03.287948362 2690 0xfaa060 INFO GST_STATES
gstelement.c:2321:gst_element_continue_state:<wav-output> completed
state change to READY
0:00:03.287971496 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<wav-output> notifying
about state-changed NULL to READY (VOID_PENDING pending)
0:00:03.287997109 2690 0xfaa060 INFO GST_STATES
gstbin.c:2602:gst_bin_change_state_func:<av-recorder> child 'wav-output'
changed state to 2(READY) successfully
0:00:03.288022626 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<file-output> current NULL
pending VOID_PENDING, desired next READY
0:00:03.288129875 2690 0xfaa060 INFO GST_STATES
gstelement.c:2321:gst_element_continue_state:<file-output> completed
state change to READY
0:00:03.288152577 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<file-output>
notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:03.288177768 2690 0xfaa060 INFO GST_STATES
gstbin.c:2602:gst_bin_change_state_func:<av-recorder> child
'file-output' changed state to 2(READY) successfully
0:00:03.288203291 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<mon-caps> current NULL pending
VOID_PENDING, desired next READY
0:00:03.288225367 2690 0xfaa060 INFO GST_STATES
gstelement.c:2321:gst_element_continue_state:<mon-caps> completed state
change to READY
0:00:03.288245138 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<mon-caps> notifying
about state-changed NULL to READY (VOID_PENDING pending)
0:00:03.288270348 2690 0xfaa060 INFO GST_STATES
gstbin.c:2602:gst_bin_change_state_func:<av-recorder> child 'mon-caps'
changed state to 2(READY) successfully
0:00:03.288295546 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<wav-encoder> current NULL
pending VOID_PENDING, desired next READY
0:00:03.288317841 2690 0xfaa060 INFO GST_STATES
gstelement.c:2321:gst_element_continue_state:<wav-encoder> completed
state change to READY
0:00:03.288337679 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<wav-encoder>
notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:03.288362290 2690 0xfaa060 INFO GST_STATES
gstbin.c:2602:gst_bin_change_state_func:<av-recorder> child
'wav-encoder' changed state to 2(READY) successfully
0:00:03.288388026 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<mp4-mux> current NULL pending
VOID_PENDING, desired next READY
0:00:03.310072580 2690 0xfaa060 INFO GST_STATES
gstelement.c:2321:gst_element_continue_state:<mp4-mux> completed state
change to READY
0:00:03.310171729 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<mp4-mux> notifying
about state-changed NULL to READY (VOID_PENDING pending)
0:00:03.310281373 2690 0xfaa060 INFO GST_STATES
gstbin.c:2602:gst_bin_change_state_func:<av-recorder> child 'mp4-mux'
changed state to 2(READY) successfully
0:00:03.310379712 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<monscale> current NULL pending
VOID_PENDING, desired next READY
0:00:03.310469113 2690 0xfaa060 INFO GST_STATES
gstelement.c:2321:gst_element_continue_state:<monscale> completed state
change to READY
0:00:03.310555415 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<monscale> notifying
about state-changed NULL to READY (VOID_PENDING pending)
0:00:03.310646586 2690 0xfaa060 INFO GST_STATES
gstbin.c:2602:gst_bin_change_state_func:<av-recorder> child 'monscale'
changed state to 2(READY) successfully
0:00:03.310713448 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<queue4> current NULL pending
VOID_PENDING, desired next READY
0:00:03.310752356 2690 0xfaa060 INFO GST_STATES
gstelement.c:2321:gst_element_continue_state:<queue4> completed state
change to READY
0:00:03.310773649 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<queue4> notifying
about state-changed NULL to READY (VOID_PENDING pending)
0:00:03.310807561 2690 0xfaa060 INFO GST_STATES
gstbin.c:2602:gst_bin_change_state_func:<av-recorder> child 'queue4'
changed state to 2(READY) successfully
0:00:03.310835190 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<videnc> current NULL pending
VOID_PENDING, desired next READY
0:00:03.310864042 2690 0xfaa060 INFO GST_STATES
gstelement.c:2321:gst_element_continue_state:<videnc> completed state
change to READY
0:00:03.310885429 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<videnc> notifying
about state-changed NULL to READY (VOID_PENDING pending)
0:00:03.310910864 2690 0xfaa060 INFO GST_STATES
gstbin.c:2602:gst_bin_change_state_func:<av-recorder> child 'videnc'
changed state to 2(READY) successfully
0:00:03.310937329 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<lameenc> current NULL pending
VOID_PENDING, desired next READY
0:00:03.310961420 2690 0xfaa060 INFO GST_STATES
gstelement.c:2321:gst_element_continue_state:<lameenc> completed state
change to READY
0:00:03.310981835 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<lameenc> notifying
about state-changed NULL to READY (VOID_PENDING pending)
0:00:03.311006870 2690 0xfaa060 INFO GST_STATES
gstbin.c:2602:gst_bin_change_state_func:<av-recorder> child 'lameenc'
changed state to 2(READY) successfully
0:00:03.311034140 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<queue5> current NULL pending
VOID_PENDING, desired next READY
0:00:03.311056757 2690 0xfaa060 INFO GST_STATES
gstelement.c:2321:gst_element_continue_state:<queue5> completed state
change to READY
0:00:03.311077437 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<queue5> notifying
about state-changed NULL to READY (VOID_PENDING pending)
0:00:03.311102364 2690 0xfaa060 INFO GST_STATES
gstbin.c:2602:gst_bin_change_state_func:<av-recorder> child 'queue5'
changed state to 2(READY) successfully
0:00:03.311128008 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<audio2-conv> current NULL
pending VOID_PENDING, desired next READY
0:00:03.311150444 2690 0xfaa060 INFO GST_STATES
gstelement.c:2321:gst_element_continue_state:<audio2-conv> completed
state change to READY
0:00:03.311170808 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<audio2-conv>
notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:03.311196325 2690 0xfaa060 INFO GST_STATES
gstbin.c:2602:gst_bin_change_state_func:<av-recorder> child
'audio2-conv' changed state to 2(READY) successfully
0:00:03.311221826 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<queue1> current NULL pending
VOID_PENDING, desired next READY
0:00:03.311243243 2690 0xfaa060 INFO GST_STATES
gstelement.c:2321:gst_element_continue_state:<queue1> completed state
change to READY
0:00:03.311262738 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<queue1> notifying
about state-changed NULL to READY (VOID_PENDING pending)
0:00:03.311287361 2690 0xfaa060 INFO GST_STATES
gstbin.c:2602:gst_bin_change_state_func:<av-recorder> child 'queue1'
changed state to 2(READY) successfully
0:00:03.311312688 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<queue3> current NULL pending
VOID_PENDING, desired next READY
0:00:03.311334060 2690 0xfaa060 INFO GST_STATES
gstelement.c:2321:gst_element_continue_state:<queue3> completed state
change to READY
0:00:03.311353383 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<queue3> notifying
about state-changed NULL to READY (VOID_PENDING pending)
0:00:03.311377059 2690 0xfaa060 INFO GST_STATES
gstbin.c:2602:gst_bin_change_state_func:<av-recorder> child 'queue3'
changed state to 2(READY) successfully
0:00:03.311401884 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<vid-caps> current NULL pending
VOID_PENDING, desired next READY
0:00:03.311423508 2690 0xfaa060 INFO GST_STATES
gstelement.c:2321:gst_element_continue_state:<vid-caps> completed state
change to READY
0:00:03.311442720 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<vid-caps> notifying
about state-changed NULL to READY (VOID_PENDING pending)
0:00:03.311466375 2690 0xfaa060 INFO GST_STATES
gstbin.c:2602:gst_bin_change_state_func:<av-recorder> child 'vid-caps'
changed state to 2(READY) successfully
0:00:03.311490628 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<audrate> current NULL pending
VOID_PENDING, desired next READY
0:00:03.311512848 2690 0xfaa060 INFO GST_STATES
gstelement.c:2321:gst_element_continue_state:<audrate> completed state
change to READY
0:00:03.311532111 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<audrate> notifying
about state-changed NULL to READY (VOID_PENDING pending)
0:00:03.311555953 2690 0xfaa060 INFO GST_STATES
gstbin.c:2602:gst_bin_change_state_func:<av-recorder> child 'audrate'
changed state to 2(READY) successfully
0:00:03.311580396 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<vidscale> current NULL pending
VOID_PENDING, desired next READY
0:00:03.311601653 2690 0xfaa060 INFO GST_STATES
gstelement.c:2321:gst_element_continue_state:<vidscale> completed state
change to READY
0:00:03.311621006 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<vidscale> notifying
about state-changed NULL to READY (VOID_PENDING pending)
0:00:03.311644968 2690 0xfaa060 INFO GST_STATES
gstbin.c:2602:gst_bin_change_state_func:<av-recorder> child 'vidscale'
changed state to 2(READY) successfully
0:00:03.311669573 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<tee> current NULL pending
VOID_PENDING, desired next READY
0:00:03.311691077 2690 0xfaa060 INFO GST_STATES
gstelement.c:2321:gst_element_continue_state:<tee> completed state
change to READY
0:00:03.311710476 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<tee> notifying about
state-changed NULL to READY (VOID_PENDING pending)
0:00:03.311742186 2690 0xfaa060 INFO GST_STATES
gstbin.c:2602:gst_bin_change_state_func:<av-recorder> child 'tee'
changed state to 2(READY) successfully
0:00:03.311767639 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<vidrate> current NULL pending
VOID_PENDING, desired next READY
0:00:03.311789922 2690 0xfaa060 INFO GST_STATES
gstelement.c:2321:gst_element_continue_state:<vidrate> completed state
change to READY
0:00:03.311809158 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<vidrate> notifying
about state-changed NULL to READY (VOID_PENDING pending)
0:00:03.311833045 2690 0xfaa060 INFO GST_STATES
gstbin.c:2602:gst_bin_change_state_func:<av-recorder> child 'vidrate'
changed state to 2(READY) successfully
0:00:03.311857960 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<queue2> current NULL pending
VOID_PENDING, desired next READY
0:00:03.311879861 2690 0xfaa060 INFO GST_STATES
gstelement.c:2321:gst_element_continue_state:<queue2> completed state
change to READY
0:00:03.311899166 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<queue2> notifying
about state-changed NULL to READY (VOID_PENDING pending)
0:00:03.338188696 2690 0xfaa060 INFO GST_STATES
gstbin.c:2602:gst_bin_change_state_func:<av-recorder> child 'queue2'
changed state to 2(READY) successfully
0:00:03.338214230 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<videotee> current NULL pending
VOID_PENDING, desired next READY
0:00:03.338230479 2690 0xfaa060 INFO GST_STATES
gstelement.c:2321:gst_element_continue_state:<videotee> completed state
change to READY
0:00:03.338243687 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<videotee> notifying
about state-changed NULL to READY (VOID_PENDING pending)
0:00:03.338261889 2690 0xfaa060 INFO GST_STATES
gstbin.c:2602:gst_bin_change_state_func:<av-recorder> child 'videotee'
changed state to 2(READY) successfully
0:00:03.338280791 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<audio-caps> current NULL
pending VOID_PENDING, desired next READY
0:00:03.338296017 2690 0xfaa060 INFO GST_STATES
gstelement.c:2321:gst_element_continue_state:<audio-caps> completed
state change to READY
0:00:03.338309081 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<audio-caps> notifying
about state-changed NULL to READY (VOID_PENDING pending)
0:00:03.338327306 2690 0xfaa060 INFO GST_STATES
gstbin.c:2602:gst_bin_change_state_func:<av-recorder> child 'audio-caps'
changed state to 2(READY) successfully
0:00:03.338344280 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<vid-source> current NULL
pending VOID_PENDING, desired next READY
0:00:03.340172732 2690 0xfaa060 INFO v4l2
v4l2_calls.c:479:gst_v4l2_open:<vid-source> Opened device 'BT878 video
(Pinnacle PCTV Stud' (/dev/video0) successfully
0:00:03.340204517 2690 0xfaa060 INFO GST_STATES
gstelement.c:2321:gst_element_continue_state:<vid-source> completed
state change to READY
0:00:03.340219605 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<vid-source> notifying
about state-changed NULL to READY (VOID_PENDING pending)
0:00:03.340238700 2690 0xfaa060 INFO GST_STATES
gstbin.c:2602:gst_bin_change_state_func:<av-recorder> child 'vid-source'
changed state to 2(READY) successfully
0:00:03.340256453 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<alsa-source> current NULL
pending VOID_PENDING, desired next READY
0:00:03.351338210 2690 0xfaa060 INFO GST_STATES
gstelement.c:2321:gst_element_continue_state:<alsa-source> completed
state change to READY
0:00:03.351376129 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<alsa-source>
notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:03.351409767 2690 0xfaa060 INFO GST_STATES
gstbin.c:2602:gst_bin_change_state_func:<av-recorder> child
'alsa-source' changed state to 2(READY) successfully
0:00:03.351439606 2690 0xfaa060 INFO GST_STATES
gstelement.c:2296:gst_element_continue_state:<av-recorder> committing
state from NULL to READY, pending PLAYING, next PAUSED
0:00:03.351456806 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<av-recorder>
notifying about state-changed NULL to READY (PLAYING pending)
0:00:03.351474715 2690 0xfaa060 INFO GST_STATES
gstelement.c:2303:gst_element_continue_state:<av-recorder> continue
state change READY to PAUSED, final PLAYING
0:00:03.351544572 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<videosink> current READY
pending VOID_PENDING, desired next PAUSED
0:00:03.351569848 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<videosink-actual-sink-xvimage>
current READY pending VOID_PENDING, desired next PAUSED
0:00:03.351603111 2690 0xfaa060 INFO GST_STATES
gstbin.c:2608:gst_bin_change_state_func:<videosink> child
'videosink-actual-sink-xvimage' is changing state asynchronously to PAUSED
0:00:03.351627250 2690 0xfaa060 INFO GST_STATES
gstbin.c:2608:gst_bin_change_state_func:<av-recorder> child 'videosink'
is changing state asynchronously to PAUSED
0:00:03.351646278 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<wav-output> current READY
pending VOID_PENDING, desired next PAUSED
0:00:03.351667490 2690 0xfaa060 INFO GST_STATES
gstbin.c:2608:gst_bin_change_state_func:<av-recorder> child 'wav-output'
is changing state asynchronously to PAUSED
0:00:03.351686245 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<file-output> current READY
pending VOID_PENDING, desired next PAUSED
0:00:03.351707220 2690 0xfaa060 INFO GST_STATES
gstbin.c:2608:gst_bin_change_state_func:<av-recorder> child
'file-output' is changing state asynchronously to PAUSED
0:00:03.351731591 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<mon-caps> current READY pending
VOID_PENDING, desired next PAUSED
0:00:03.351756328 2690 0xfaa060 INFO GST_STATES
gstelement.c:2321:gst_element_continue_state:<mon-caps> completed state
change to PAUSED
0:00:03.351771807 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<mon-caps> notifying
about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:03.351790523 2690 0xfaa060 INFO GST_STATES
gstbin.c:2602:gst_bin_change_state_func:<av-recorder> child 'mon-caps'
changed state to 3(PAUSED) successfully
0:00:03.351809323 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<wav-encoder> current READY
pending VOID_PENDING, desired next PAUSED
0:00:03.351829888 2690 0xfaa060 INFO GST_STATES
gstelement.c:2321:gst_element_continue_state:<wav-encoder> completed
state change to PAUSED
0:00:03.351845394 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<wav-encoder>
notifying about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:03.351863839 2690 0xfaa060 INFO GST_STATES
gstbin.c:2602:gst_bin_change_state_func:<av-recorder> child
'wav-encoder' changed state to 3(PAUSED) successfully
0:00:03.351883223 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<mp4-mux> current READY pending
VOID_PENDING, desired next PAUSED
0:00:03.351909073 2690 0xfaa060 INFO GST_STATES
gstelement.c:2321:gst_element_continue_state:<mp4-mux> completed state
change to PAUSED
0:00:03.351924456 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<mp4-mux> notifying
about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:03.351950325 2690 0xfaa060 INFO GST_STATES
gstbin.c:2602:gst_bin_change_state_func:<av-recorder> child 'mp4-mux'
changed state to 3(PAUSED) successfully
0:00:03.351969714 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<monscale> current READY pending
VOID_PENDING, desired next PAUSED
0:00:03.351990818 2690 0xfaa060 INFO GST_STATES
gstelement.c:2321:gst_element_continue_state:<monscale> completed state
change to PAUSED
0:00:03.352006321 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<monscale> notifying
about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:03.352025581 2690 0xfaa060 INFO GST_STATES
gstbin.c:2602:gst_bin_change_state_func:<av-recorder> child 'monscale'
changed state to 3(PAUSED) successfully
0:00:03.352044866 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<queue4> current READY pending
VOID_PENDING, desired next PAUSED
0:00:03.352089369 2690 0xfaa060 INFO task
gsttask.c:431:gst_task_set_lock: setting stream lock 0x1338160 on task
0x12ac7e0
0:00:03.352106821 2690 0xfaa060 INFO GST_PADS
gstpad.c:5204:gst_pad_start_task:<queue4:src> created task 0x12ac7e0
0:00:03.353117108 2690 0xfaa060 INFO GST_STATES
gstelement.c:2321:gst_element_continue_state:<queue4> completed state
change to PAUSED
0:00:03.353137887 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<queue4> notifying
about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:03.369698002 2690 0xfaa060 INFO GST_STATES
gstbin.c:2602:gst_bin_change_state_func:<av-recorder> child 'queue4'
changed state to 3(PAUSED) successfully
0:00:03.369732169 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<videnc> current READY pending
VOID_PENDING, desired next PAUSED
0:00:03.369759518 2690 0xfaa060 INFO GST_STATES
gstelement.c:2321:gst_element_continue_state:<videnc> completed state
change to PAUSED
0:00:03.369771944 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<videnc> notifying
about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:03.369789387 2690 0xfaa060 INFO GST_STATES
gstbin.c:2602:gst_bin_change_state_func:<av-recorder> child 'videnc'
changed state to 3(PAUSED) successfully
0:00:03.369806253 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<lameenc> current READY pending
VOID_PENDING, desired next PAUSED
0:00:03.369831628 2690 0xfaa060 INFO GST_STATES
gstelement.c:2321:gst_element_continue_state:<lameenc> completed state
change to PAUSED
0:00:03.369843889 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<lameenc> notifying
about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:03.369859211 2690 0xfaa060 INFO GST_STATES
gstbin.c:2602:gst_bin_change_state_func:<av-recorder> child 'lameenc'
changed state to 3(PAUSED) successfully
0:00:03.369874841 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<queue5> current READY pending
VOID_PENDING, desired next PAUSED
0:00:03.369905041 2690 0xfaa060 INFO task
gsttask.c:431:gst_task_set_lock: setting stream lock 0x1338e80 on task
0x12ac900
0:00:03.369918387 2690 0xfaa060 INFO GST_PADS
gstpad.c:5204:gst_pad_start_task:<queue5:src> created task 0x12ac900
0:00:03.369977572 2690 0xfaa060 INFO GST_STATES
gstelement.c:2321:gst_element_continue_state:<queue5> completed state
change to PAUSED
0:00:03.369990678 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<queue5> notifying
about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:03.370007171 2690 0xfaa060 INFO GST_STATES
gstbin.c:2602:gst_bin_change_state_func:<av-recorder> child 'queue5'
changed state to 3(PAUSED) successfully
0:00:03.370023964 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<audio2-conv> current READY
pending VOID_PENDING, desired next PAUSED
0:00:03.370044620 2690 0xfaa060 INFO GST_STATES
gstelement.c:2321:gst_element_continue_state:<audio2-conv> completed
state change to PAUSED
0:00:03.370056517 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<audio2-conv>
notifying about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:03.370072252 2690 0xfaa060 INFO GST_STATES
gstbin.c:2602:gst_bin_change_state_func:<av-recorder> child
'audio2-conv' changed state to 3(PAUSED) successfully
0:00:03.370090020 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<queue1> current READY pending
VOID_PENDING, desired next PAUSED
0:00:03.370113888 2690 0xfaa060 INFO task
gsttask.c:431:gst_task_set_lock: setting stream lock 0x12f9230 on task
0x12aca20
0:00:03.370126082 2690 0xfaa060 INFO GST_PADS
gstpad.c:5204:gst_pad_start_task:<queue1:src> created task 0x12aca20
0:00:03.370172276 2690 0xfaa060 INFO GST_STATES
gstelement.c:2321:gst_element_continue_state:<queue1> completed state
change to PAUSED
0:00:03.370189352 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<queue1> notifying
about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:03.370205896 2690 0xfaa060 INFO GST_STATES
gstbin.c:2602:gst_bin_change_state_func:<av-recorder> child 'queue1'
changed state to 3(PAUSED) successfully
0:00:03.370222515 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<queue3> current READY pending
VOID_PENDING, desired next PAUSED
0:00:03.370245767 2690 0xfaa060 INFO task
gsttask.c:431:gst_task_set_lock: setting stream lock 0x1318c40 on task
0x12acb40
0:00:03.370257880 2690 0xfaa060 INFO GST_PADS
gstpad.c:5204:gst_pad_start_task:<queue3:src> created task 0x12acb40
0:00:03.370308225 2690 0xfaa060 INFO GST_STATES
gstelement.c:2321:gst_element_continue_state:<queue3> completed state
change to PAUSED
0:00:03.370322124 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<queue3> notifying
about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:03.370346321 2690 0xfaa060 INFO GST_STATES
gstbin.c:2602:gst_bin_change_state_func:<av-recorder> child 'queue3'
changed state to 3(PAUSED) successfully
0:00:03.370377252 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<vid-caps> current READY pending
VOID_PENDING, desired next PAUSED
0:00:03.370396319 2690 0xfaa060 INFO GST_STATES
gstelement.c:2321:gst_element_continue_state:<vid-caps> completed state
change to PAUSED
0:00:03.370408071 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<vid-caps> notifying
about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:03.370423331 2690 0xfaa060 INFO GST_STATES
gstbin.c:2602:gst_bin_change_state_func:<av-recorder> child 'vid-caps'
changed state to 3(PAUSED) successfully
0:00:03.370439508 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<audrate> current READY pending
VOID_PENDING, desired next PAUSED
0:00:03.370458714 2690 0xfaa060 INFO GST_STATES
gstelement.c:2321:gst_element_continue_state:<audrate> completed state
change to PAUSED
0:00:03.370470270 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<audrate> notifying
about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:03.370485882 2690 0xfaa060 INFO GST_STATES
gstbin.c:2602:gst_bin_change_state_func:<av-recorder> child 'audrate'
changed state to 3(PAUSED) successfully
0:00:03.370502513 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<vidscale> current READY pending
VOID_PENDING, desired next PAUSED
0:00:03.370520362 2690 0xfaa060 INFO GST_STATES
gstelement.c:2321:gst_element_continue_state:<vidscale> completed state
change to PAUSED
0:00:03.370532024 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<vidscale> notifying
about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:03.370546866 2690 0xfaa060 INFO GST_STATES
gstbin.c:2602:gst_bin_change_state_func:<av-recorder> child 'vidscale'
changed state to 3(PAUSED) successfully
0:00:03.370562390 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<tee> current READY pending
VOID_PENDING, desired next PAUSED
0:00:03.370581090 2690 0xfaa060 INFO GST_STATES
gstelement.c:2321:gst_element_continue_state:<tee> completed state
change to PAUSED
0:00:03.370592701 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<tee> notifying about
state-changed READY to PAUSED (VOID_PENDING pending)
0:00:03.370608132 2690 0xfaa060 INFO GST_STATES
gstbin.c:2602:gst_bin_change_state_func:<av-recorder> child 'tee'
changed state to 3(PAUSED) successfully
0:00:03.370623885 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<vidrate> current READY pending
VOID_PENDING, desired next PAUSED
0:00:03.370647248 2690 0xfaa060 INFO GST_STATES
gstelement.c:2321:gst_element_continue_state:<vidrate> completed state
change to PAUSED
0:00:03.370658868 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<vidrate> notifying
about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:03.370674127 2690 0xfaa060 INFO GST_STATES
gstbin.c:2602:gst_bin_change_state_func:<av-recorder> child 'vidrate'
changed state to 3(PAUSED) successfully
0:00:03.385831032 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<queue2> current READY pending
VOID_PENDING, desired next PAUSED
0:00:03.385887615 2690 0xfaa060 INFO task
gsttask.c:431:gst_task_set_lock: setting stream lock 0x1318380 on task
0x12acc60
0:00:03.385904110 2690 0xfaa060 INFO GST_PADS
gstpad.c:5204:gst_pad_start_task:<queue2:src> created task 0x12acc60
0:00:03.385978669 2690 0xfaa060 INFO GST_STATES
gstelement.c:2321:gst_element_continue_state:<queue2> completed state
change to PAUSED
0:00:03.385994290 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<queue2> notifying
about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:03.386012936 2690 0xfaa060 INFO GST_STATES
gstbin.c:2602:gst_bin_change_state_func:<av-recorder> child 'queue2'
changed state to 3(PAUSED) successfully
0:00:03.386033348 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<videotee> current READY pending
VOID_PENDING, desired next PAUSED
0:00:03.386054416 2690 0xfaa060 INFO GST_STATES
gstelement.c:2321:gst_element_continue_state:<videotee> completed state
change to PAUSED
0:00:03.386067958 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<videotee> notifying
about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:03.386085227 2690 0xfaa060 INFO GST_STATES
gstbin.c:2602:gst_bin_change_state_func:<av-recorder> child 'videotee'
changed state to 3(PAUSED) successfully
0:00:03.386104758 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<audio-caps> current READY
pending VOID_PENDING, desired next PAUSED
0:00:03.386128130 2690 0xfaa060 INFO GST_STATES
gstelement.c:2321:gst_element_continue_state:<audio-caps> completed
state change to PAUSED
0:00:03.386141951 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<audio-caps> notifying
about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:03.386159611 2690 0xfaa060 INFO GST_STATES
gstbin.c:2602:gst_bin_change_state_func:<av-recorder> child 'audio-caps'
changed state to 3(PAUSED) successfully
0:00:03.386176531 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<vid-source> current READY
pending VOID_PENDING, desired next PAUSED
0:00:03.386242842 2690 0xfaa060 INFO task
gsttask.c:431:gst_task_set_lock: setting stream lock 0x12f80b0 on task
0x12acd80
0:00:03.386258294 2690 0xfaa060 INFO GST_PADS
gstpad.c:5204:gst_pad_start_task:<vid-source:src> created task 0x12acd80
0:00:03.386312158 2690 0xfaa060 INFO GST_STATES
gstelement.c:2321:gst_element_continue_state:<vid-source> completed
state change to PAUSED
0:00:03.386327237 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<vid-source> notifying
about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:03.386345546 2690 0xfaa060 INFO GST_STATES
gstbin.c:2645:gst_bin_change_state_func:<av-recorder> child 'vid-source'
changed state to 3(PAUSED) successfully without preroll
0:00:03.386362370 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<alsa-source> current READY
pending VOID_PENDING, desired next PAUSED
0:00:03.386414847 2690 0xfaa060 INFO task
gsttask.c:431:gst_task_set_lock: setting stream lock 0x12f98c0 on task
0x12acea0
0:00:03.386429800 2690 0xfaa060 INFO GST_PADS
gstpad.c:5204:gst_pad_start_task:<alsa-source:src> created task 0x12acea0
0:00:03.386488013 2690 0xfaa060 INFO GST_STATES
gstelement.c:2321:gst_element_continue_state:<alsa-source> completed
state change to PAUSED
0:00:03.386503544 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<alsa-source>
notifying about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:03.386522614 2690 0xfaa060 INFO GST_STATES
gstbin.c:2645:gst_bin_change_state_func:<av-recorder> child
'alsa-source' changed state to 3(PAUSED) successfully without preroll
0:00:03.386549304 2690 0xfaa060 INFO GST_STATES
gstelement.c:2296:gst_element_continue_state:<av-recorder> committing
state from READY to PAUSED, pending PLAYING, next PLAYING
0:00:03.386563992 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<av-recorder>
notifying about state-changed READY to PAUSED (PLAYING pending)
0:00:03.386581032 2690 0xfaa060 INFO GST_STATES
gstelement.c:2303:gst_element_continue_state:<av-recorder> continue
state change PAUSED to PLAYING, final PLAYING
0:00:03.386829019 2690 0xfaa060 WARN bin
gstbin.c:2474:gst_bin_do_latency_func:<av-recorder> failed to query latency
0:00:03.386879418 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<videosink> current READY
pending PAUSED, desired next PLAYING
0:00:03.386914163 2690 0xfaa060 INFO GST_STATES
gstbin.c:2608:gst_bin_change_state_func:<av-recorder> child 'videosink'
is changing state asynchronously to PLAYING
0:00:03.386939577 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<wav-output> current READY
pending PAUSED, desired next PLAYING
0:00:03.386961036 2690 0xfaa060 INFO GST_STATES
gstbin.c:2608:gst_bin_change_state_func:<av-recorder> child 'wav-output'
is changing state asynchronously to PLAYING
0:00:03.386984893 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<file-output> current READY
pending PAUSED, desired next PLAYING
0:00:03.387006099 2690 0xfaa060 INFO GST_STATES
gstbin.c:2608:gst_bin_change_state_func:<av-recorder> child
'file-output' is changing state asynchronously to PLAYING
0:00:03.387029856 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<mon-caps> current PAUSED
pending VOID_PENDING, desired next PLAYING
0:00:03.387052265 2690 0xfaa060 INFO GST_STATES
gstelement.c:2321:gst_element_continue_state:<mon-caps> completed state
change to PLAYING
0:00:03.387072395 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<mon-caps> notifying
about state-changed PAUSED to PLAYING (VOID_PENDING pending)
0:00:03.387097412 2690 0xfaa060 INFO GST_STATES
gstbin.c:2602:gst_bin_change_state_func:<av-recorder> child 'mon-caps'
changed state to 4(PLAYING) successfully
0:00:03.387122162 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<wav-encoder> current PAUSED
pending VOID_PENDING, desired next PLAYING
0:00:03.387144794 2690 0xfaa060 INFO GST_STATES
gstelement.c:2321:gst_element_continue_state:<wav-encoder> completed
state change to PLAYING
0:00:03.387164758 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<wav-encoder>
notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending)
0:00:03.387189297 2690 0xfaa060 INFO GST_STATES
gstbin.c:2602:gst_bin_change_state_func:<av-recorder> child
'wav-encoder' changed state to 4(PLAYING) successfully
0:00:03.387214862 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<mp4-mux> current PAUSED pending
VOID_PENDING, desired next PLAYING
0:00:03.387237169 2690 0xfaa060 INFO GST_STATES
gstelement.c:2321:gst_element_continue_state:<mp4-mux> completed state
change to PLAYING
0:00:03.387256928 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<mp4-mux> notifying
about state-changed PAUSED to PLAYING (VOID_PENDING pending)
0:00:03.387280875 2690 0xfaa060 INFO GST_STATES
gstbin.c:2602:gst_bin_change_state_func:<av-recorder> child 'mp4-mux'
changed state to 4(PLAYING) successfully
0:00:03.387305363 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<monscale> current PAUSED
pending VOID_PENDING, desired next PLAYING
0:00:03.387327168 2690 0xfaa060 INFO GST_STATES
gstelement.c:2321:gst_element_continue_state:<monscale> completed state
change to PLAYING
0:00:03.387346906 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<monscale> notifying
about state-changed PAUSED to PLAYING (VOID_PENDING pending)
0:00:03.416013885 2690 0xfaa060 INFO GST_STATES
gstbin.c:2602:gst_bin_change_state_func:<av-recorder> child 'monscale'
changed state to 4(PLAYING) successfully
0:00:03.416047337 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<queue4> current PAUSED pending
VOID_PENDING, desired next PLAYING
0:00:03.416064648 2690 0xfaa060 INFO GST_STATES
gstelement.c:2321:gst_element_continue_state:<queue4> completed state
change to PLAYING
0:00:03.416078238 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<queue4> notifying
about state-changed PAUSED to PLAYING (VOID_PENDING pending)
0:00:03.416096210 2690 0xfaa060 INFO GST_STATES
gstbin.c:2602:gst_bin_change_state_func:<av-recorder> child 'queue4'
changed state to 4(PLAYING) successfully
0:00:03.416115251 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<videnc> current PAUSED pending
VOID_PENDING, desired next PLAYING
0:00:03.416131575 2690 0xfaa060 INFO GST_STATES
gstelement.c:2321:gst_element_continue_state:<videnc> completed state
change to PLAYING
0:00:03.416144798 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<videnc> notifying
about state-changed PAUSED to PLAYING (VOID_PENDING pending)
0:00:03.416162043 2690 0xfaa060 INFO GST_STATES
gstbin.c:2602:gst_bin_change_state_func:<av-recorder> child 'videnc'
changed state to 4(PLAYING) successfully
0:00:03.416181090 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<lameenc> current PAUSED pending
VOID_PENDING, desired next PLAYING
0:00:03.416197360 2690 0xfaa060 INFO GST_STATES
gstelement.c:2321:gst_element_continue_state:<lameenc> completed state
change to PLAYING
0:00:03.416210315 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<lameenc> notifying
about state-changed PAUSED to PLAYING (VOID_PENDING pending)
0:00:03.416227873 2690 0xfaa060 INFO GST_STATES
gstbin.c:2602:gst_bin_change_state_func:<av-recorder> child 'lameenc'
changed state to 4(PLAYING) successfully
0:00:03.416245818 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<queue5> current PAUSED pending
VOID_PENDING, desired next PLAYING
0:00:03.416261042 2690 0xfaa060 INFO GST_STATES
gstelement.c:2321:gst_element_continue_state:<queue5> completed state
change to PLAYING
0:00:03.416273985 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<queue5> notifying
about state-changed PAUSED to PLAYING (VOID_PENDING pending)
0:00:03.416299640 2690 0xfaa060 INFO GST_STATES
gstbin.c:2602:gst_bin_change_state_func:<av-recorder> child 'queue5'
changed state to 4(PLAYING) successfully
0:00:03.416318924 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<audio2-conv> current PAUSED
pending VOID_PENDING, desired next PLAYING
0:00:03.416335131 2690 0xfaa060 INFO GST_STATES
gstelement.c:2321:gst_element_continue_state:<audio2-conv> completed
state change to PLAYING
0:00:03.416348246 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<audio2-conv>
notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending)
0:00:03.416375507 2690 0xfaa060 INFO GST_STATES
gstbin.c:2602:gst_bin_change_state_func:<av-recorder> child
'audio2-conv' changed state to 4(PLAYING) successfully
0:00:03.416394680 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<queue1> current PAUSED pending
VOID_PENDING, desired next PLAYING
0:00:03.416409946 2690 0xfaa060 INFO GST_STATES
gstelement.c:2321:gst_element_continue_state:<queue1> completed state
change to PLAYING
0:00:03.416423232 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<queue1> notifying
about state-changed PAUSED to PLAYING (VOID_PENDING pending)
0:00:03.416440645 2690 0xfaa060 INFO GST_STATES
gstbin.c:2602:gst_bin_change_state_func:<av-recorder> child 'queue1'
changed state to 4(PLAYING) successfully
0:00:03.416458446 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<queue3> current PAUSED pending
VOID_PENDING, desired next PLAYING
0:00:03.416473149 2690 0xfaa060 INFO GST_STATES
gstelement.c:2321:gst_element_continue_state:<queue3> completed state
change to PLAYING
0:00:03.416485972 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<queue3> notifying
about state-changed PAUSED to PLAYING (VOID_PENDING pending)
0:00:03.416503202 2690 0xfaa060 INFO GST_STATES
gstbin.c:2602:gst_bin_change_state_func:<av-recorder> child 'queue3'
changed state to 4(PLAYING) successfully
0:00:03.416521379 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<vid-caps> current PAUSED
pending VOID_PENDING, desired next PLAYING
0:00:03.416537096 2690 0xfaa060 INFO GST_STATES
gstelement.c:2321:gst_element_continue_state:<vid-caps> completed state
change to PLAYING
0:00:03.416565831 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<vid-caps> notifying
about state-changed PAUSED to PLAYING (VOID_PENDING pending)
0:00:03.416590794 2690 0xfaa060 INFO GST_STATES
gstbin.c:2602:gst_bin_change_state_func:<av-recorder> child 'vid-caps'
changed state to 4(PLAYING) successfully
0:00:03.416615746 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<audrate> current PAUSED pending
VOID_PENDING, desired next PLAYING
0:00:03.416638233 2690 0xfaa060 INFO GST_STATES
gstelement.c:2321:gst_element_continue_state:<audrate> completed state
change to PLAYING
0:00:03.416658053 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<audrate> notifying
about state-changed PAUSED to PLAYING (VOID_PENDING pending)
0:00:03.416682050 2690 0xfaa060 INFO GST_STATES
gstbin.c:2602:gst_bin_change_state_func:<av-recorder> child 'audrate'
changed state to 4(PLAYING) successfully
0:00:03.416707537 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<vidscale> current PAUSED
pending VOID_PENDING, desired next PLAYING
0:00:03.387494459 2690 0x1366370 INFO GST_ELEMENT_PADS
gstelement.c:891:gst_element_get_static_pad: no such pad 'sink' in
element "vid-source"
0:00:03.387875254 2690 0x1366450 INFO GST_ELEMENT_PADS
gstelement.c:891:gst_element_get_static_pad: no such pad 'sink' in
element "alsa-source"
0:00:03.416824150 2690 0x1366450 FIXME default
gstutils.c:3636:gst_pad_create_stream_id_printf_valist:<alsa-source:src>
Creating random stream-id, consider implementing a deterministic way of
creating a stream-id
0:00:03.416954958 2690 0x1366370 INFO v4l2
gstv4l2object.c:1153:gst_v4l2_object_fill_format_list:<vid-source> got
18 format(s):
0:00:03.417754669 2690 0x1366370 INFO v4l2
gstv4l2object.c:1159:gst_v4l2_object_fill_format_list:<vid-source> YUYV
0:00:03.417780204 2690 0x1366370 INFO v4l2
gstv4l2object.c:1159:gst_v4l2_object_fill_format_list:<vid-source> UYVY
0:00:03.417799446 2690 0x1366370 INFO v4l2
gstv4l2object.c:1159:gst_v4l2_object_fill_format_list:<vid-source> 422P
0:00:03.417818276 2690 0x1366370 INFO v4l2
gstv4l2object.c:1159:gst_v4l2_object_fill_format_list:<vid-source> YU12
0:00:03.417836880 2690 0x1366370 INFO v4l2
gstv4l2object.c:1159:gst_v4l2_object_fill_format_list:<vid-source> YV12
0:00:03.417855406 2690 0x1366370 INFO v4l2
gstv4l2object.c:1159:gst_v4l2_object_fill_format_list:<vid-source> 411P
0:00:03.417874047 2690 0x1366370 INFO v4l2
gstv4l2object.c:1159:gst_v4l2_object_fill_format_list:<vid-source> YVU9
0:00:03.417892795 2690 0x1366370 INFO v4l2
gstv4l2object.c:1159:gst_v4l2_object_fill_format_list:<vid-source> YUV9
0:00:03.417911312 2690 0x1366370 INFO v4l2
gstv4l2object.c:1159:gst_v4l2_object_fill_format_list:<vid-source> RGB4
0:00:03.446287355 2690 0x1366370 INFO v4l2
gstv4l2object.c:1159:gst_v4l2_object_fill_format_list:<vid-source> BGR4
0:00:03.446315299 2690 0x1366370 INFO v4l2
gstv4l2object.c:1159:gst_v4l2_object_fill_format_list:<vid-source> BGR3
0:00:03.446335882 2690 0x1366370 INFO v4l2
gstv4l2object.c:1159:gst_v4l2_object_fill_format_list:<vid-source> HI24
0:00:03.446355395 2690 0x1366370 INFO v4l2
gstv4l2object.c:1159:gst_v4l2_object_fill_format_list:<vid-source> RGBR
0:00:03.446374700 2690 0x1366370 INFO v4l2
gstv4l2object.c:1159:gst_v4l2_object_fill_format_list:<vid-source> RGBP
0:00:03.446394195 2690 0x1366370 INFO v4l2
gstv4l2object.c:1159:gst_v4l2_object_fill_format_list:<vid-source> RGBQ
0:00:03.446413482 2690 0x1366370 INFO v4l2
gstv4l2object.c:1159:gst_v4l2_object_fill_format_list:<vid-source> RGBO
0:00:03.446432610 2690 0x1366370 INFO v4l2
gstv4l2object.c:1159:gst_v4l2_object_fill_format_list:<vid-source> GREY
0:00:03.446451867 2690 0x1366370 INFO v4l2
gstv4l2object.c:1159:gst_v4l2_object_fill_format_list:<vid-source> RGB3
(emulated)
0:00:03.446485993 2690 0x1366370 WARN v4l2
gstv4l2object.c:2127:gst_v4l2_object_get_nearest_size:<vid-source>
Unsupported field type for YUYV at 48x32
0:00:03.446526643 2690 0x1366370 WARN v4l2
gstv4l2object.c:1976:gst_v4l2_object_probe_caps_for_format:<vid-source>
Could not probe minimum capture size for pixelformat YUYV
0:00:03.446578665 2690 0x1366370 WARN v4l2
gstv4l2object.c:2127:gst_v4l2_object_get_nearest_size:<vid-source>
Unsupported field type for UYVY at 48x32
0:00:03.446611492 2690 0x1366370 WARN v4l2
gstv4l2object.c:1976:gst_v4l2_object_probe_caps_for_format:<vid-source>
Could not probe minimum capture size for pixelformat UYVY
0:00:03.446656010 2690 0x1366370 WARN v4l2
gstv4l2object.c:2127:gst_v4l2_object_get_nearest_size:<vid-source>
Unsupported field type for 422P at 48x32
0:00:03.446688348 2690 0x1366370 WARN v4l2
gstv4l2object.c:1976:gst_v4l2_object_probe_caps_for_format:<vid-source>
Could not probe minimum capture size for pixelformat 422P
0:00:03.446759274 2690 0x1366370 WARN v4l2
gstv4l2object.c:2127:gst_v4l2_object_get_nearest_size:<vid-source>
Unsupported field type for YU12 at 48x32
0:00:03.446792265 2690 0x1366370 WARN v4l2
gstv4l2object.c:1976:gst_v4l2_object_probe_caps_for_format:<vid-source>
Could not probe minimum capture size for pixelformat YU12
0:00:03.446861617 2690 0x1366370 WARN v4l2
gstv4l2object.c:2127:gst_v4l2_object_get_nearest_size:<vid-source>
Unsupported field type for YV12 at 48x32
0:00:03.446894347 2690 0x1366370 WARN v4l2
gstv4l2object.c:1976:gst_v4l2_object_probe_caps_for_format:<vid-source>
Could not probe minimum capture size for pixelformat YV12
0:00:03.446950632 2690 0x1366370 WARN v4l2
gstv4l2object.c:2127:gst_v4l2_object_get_nearest_size:<vid-source>
Unsupported field type for 411P at 48x32
0:00:03.446983100 2690 0x1366370 WARN v4l2
gstv4l2object.c:1976:gst_v4l2_object_probe_caps_for_format:<vid-source>
Could not probe minimum capture size for pixelformat 411P
0:00:03.447025254 2690 0x1366370 WARN v4l2
gstv4l2object.c:2127:gst_v4l2_object_get_nearest_size:<vid-source>
Unsupported field type for YVU9 at 48x32
0:00:03.447056567 2690 0x1366370 WARN v4l2
gstv4l2object.c:1976:gst_v4l2_object_probe_caps_for_format:<vid-source>
Could not probe minimum capture size for pixelformat YVU9
0:00:03.447102902 2690 0x1366370 WARN v4l2
gstv4l2object.c:2127:gst_v4l2_object_get_nearest_size:<vid-source>
Unsupported field type for YUV9 at 48x32
0:00:03.447134504 2690 0x1366370 WARN v4l2
gstv4l2object.c:1976:gst_v4l2_object_probe_caps_for_format:<vid-source>
Could not probe minimum capture size for pixelformat YUV9
0:00:03.447176588 2690 0x1366370 WARN v4l2
gstv4l2object.c:2127:gst_v4l2_object_get_nearest_size:<vid-source>
Unsupported field type for RGB4 at 48x32
0:00:03.447207953 2690 0x1366370 WARN v4l2
gstv4l2object.c:1976:gst_v4l2_object_probe_caps_for_format:<vid-source>
Could not probe minimum capture size for pixelformat RGB4
0:00:03.447249523 2690 0x1366370 WARN v4l2
gstv4l2object.c:2127:gst_v4l2_object_get_nearest_size:<vid-source>
Unsupported field type for BGR4 at 48x32
0:00:03.447280827 2690 0x1366370 WARN v4l2
gstv4l2object.c:1976:gst_v4l2_object_probe_caps_for_format:<vid-source>
Could not probe minimum capture size for pixelformat BGR4
0:00:03.447336047 2690 0x1366370 WARN v4l2
gstv4l2object.c:2127:gst_v4l2_object_get_nearest_size:<vid-source>
Unsupported field type for BGR3 at 48x32
0:00:03.447367721 2690 0x1366370 WARN v4l2
gstv4l2object.c:1976:gst_v4l2_object_probe_caps_for_format:<vid-source>
Could not probe minimum capture size for pixelformat BGR3
0:00:03.447423685 2690 0x1366370 WARN v4l2
gstv4l2object.c:2127:gst_v4l2_object_get_nearest_size:<vid-source>
Unsupported field type for RGBP at 48x32
0:00:03.447460367 2690 0x1366370 WARN v4l2
gstv4l2object.c:1976:gst_v4l2_object_probe_caps_for_format:<vid-source>
Could not probe minimum capture size for pixelformat RGBP
0:00:03.447507367 2690 0x1366370 WARN v4l2
gstv4l2object.c:2127:gst_v4l2_object_get_nearest_size:<vid-source>
Unsupported field type for RGBO at 48x32
0:00:03.447542876 2690 0x1366370 WARN v4l2
gstv4l2object.c:1976:gst_v4l2_object_probe_caps_for_format:<vid-source>
Could not probe minimum capture size for pixelformat RGBO
0:00:03.447589033 2690 0x1366370 WARN v4l2
gstv4l2object.c:2127:gst_v4l2_object_get_nearest_size:<vid-source>
Unsupported field type for GREY at 48x32
0:00:03.447624308 2690 0x1366370 WARN v4l2
gstv4l2object.c:1976:gst_v4l2_object_probe_caps_for_format:<vid-source>
Could not probe minimum capture size for pixelformat GREY
0:00:03.447683589 2690 0x1366370 WARN v4l2
gstv4l2object.c:2127:gst_v4l2_object_get_nearest_size:<vid-source>
Unsupported field type for RGB3 at 48x32
0:00:03.447719053 2690 0x1366370 WARN v4l2
gstv4l2object.c:1976:gst_v4l2_object_probe_caps_for_format:<vid-source>
Could not probe minimum capture size for pixelformat RGB3
0:00:03.447780449 2690 0x1366370 INFO v4l2src
gstv4l2src.c:487:gst_v4l2src_get_caps:<vid-source> probed caps:
video/x-raw, format=(string)YUY2, framerate=(fraction)25/1, width=(int)[
48, 924 ], height=(int)[ 32, 576 ], interlace-mode=(string)mixed,
pixel-aspect-ratio=(fraction)1/1; video/x-raw, format=(string)UYVY,
framerate=(fraction)25/1, width=(int)[ 48, 924 ], height=(int)[ 32, 576
], interlace-mode=(string)mixed, pixel-aspect-ratio=(fraction)1/1;
video/x-raw, format=(string)Y42B, framerate=(fraction)25/1, width=(int)[
48, 924 ], height=(int)[ 32, 576 ], interlace-mode=(string)mixed,
pixel-aspect-ratio=(fraction)1/1; video/x-raw, format=(string)I420,
framerate=(fraction)25/1, width=(int)[ 48, 920 ], height=(int)[ 32, 576
], interlace-mode=(string)mixed, pixel-aspect-ratio=(fraction)1/1;
video/x-raw, format=(string)YV12, framerate=(fraction)25/1, width=(int)[
48, 920 ], height=(int)[ 32, 576 ], interlace-mode=(string)mixed,
pixel-aspect-ratio=(fraction)1/1; video/x-raw, format=(string)Y41B,
framerate=(fraction)25/1, width=(int)[ 48, 924 ], height=(int)[ 32, 576
], interlace-mode=(string)mixed, pixel-aspect-ratio=(fraction)1/1;
video/x-raw, format=(string)YVU9, framerate=(fraction)25/1, width=(int)[
48, 924 ], height=(int)[ 32, 576 ], interlace-mode=(string)mixed,
pixel-aspect-ratio=(fraction)1/1; video/x-raw, format=(string)YUV9,
framerate=(fraction)25/1, width=(int)[ 48, 924 ], height=(int)[ 32, 576
], interlace-mode=(string)mixed, pixel-aspect-ratio=(fraction)1/1;
video/x-raw, format=(string)RGBx, framerate=(fraction)25/1, width=(int)[
48, 924 ], height=(int)[ 32, 576 ], interlace-mode=(string)mixed,
pixel-aspect-ratio=(fraction)1/1; video/x-raw, format=(string)BGRx,
framerate=(fraction)25/1, width=(int)[ 48, 924 ], height=(int)[ 32, 576
], interlace-mode=(string)mixed, pixel-aspect-ratio=(fraction)1/1;
video/x-raw, format=(string)BGR, framerate=(fraction)25/1, width=(int)[
48, 920 ], height=(int)[ 32, 576 ], interlace-mode=(string)mixed,
pixel-aspect-ratio=(fraction)1/1; video/x-raw, format=(string)RGB16,
framerate=(fraction)25/1, width=(int)[ 48, 924 ], height=(int)[ 32, 576
], interlace-mode=(string)mixed, pixel-aspect-ratio=(fraction)1/1;
video/x-raw, format=(string)RGB15, framerate=(fraction)25/1,
width=(int)[ 48, 924 ], height=(int)[ 32, 576 ],
interlace-mode=(string)mixed, pixel-aspect-ratio=(fraction)1/1;
video/x-raw, format=(string)GRAY8, framerate=(fraction)25/1,
width=(int)[ 48, 924 ], height=(int)[ 32, 576 ],
interlace-mode=(string)mixed, pixel-aspect-ratio=(fraction)1/1;
video/x-raw, format=(string)RGB, framerate=(fraction)25/1, width=(int)[
48, 920 ], height=(int)[ 32, 576 ], interlace-mode=(string)mixed,
pixel-aspect-ratio=(fraction)1/1
0:00:03.416741383 2690 0xfaa060 INFO GST_STATES
gstelement.c:2321:gst_element_continue_state:<vidscale> completed state
change to PLAYING
0:00:03.448859565 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<vidscale> notifying
about state-changed PAUSED to PLAYING (VOID_PENDING pending)
0:00:03.476687425 2690 0xfaa060 INFO GST_STATES
gstbin.c:2602:gst_bin_change_state_func:<av-recorder> child 'vidscale'
changed state to 4(PLAYING) successfully
0:00:03.476720239 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<tee> current PAUSED pending
VOID_PENDING, desired next PLAYING
0:00:03.476757993 2690 0xfaa060 INFO GST_STATES
gstelement.c:2321:gst_element_continue_state:<tee> completed state
change to PLAYING
0:00:03.476779939 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<tee> notifying about
state-changed PAUSED to PLAYING (VOID_PENDING pending)
0:00:03.476806190 2690 0xfaa060 INFO GST_STATES
gstbin.c:2602:gst_bin_change_state_func:<av-recorder> child 'tee'
changed state to 4(PLAYING) successfully
0:00:03.476833397 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<vidrate> current PAUSED pending
VOID_PENDING, desired next PLAYING
0:00:03.476856645 2690 0xfaa060 INFO GST_STATES
gstelement.c:2321:gst_element_continue_state:<vidrate> completed state
change to PLAYING
0:00:03.476878170 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<vidrate> notifying
about state-changed PAUSED to PLAYING (VOID_PENDING pending)
0:00:03.476903826 2690 0xfaa060 INFO GST_STATES
gstbin.c:2602:gst_bin_change_state_func:<av-recorder> child 'vidrate'
changed state to 4(PLAYING) successfully
0:00:03.476930061 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<queue2> current PAUSED pending
VOID_PENDING, desired next PLAYING
0:00:03.476953412 2690 0xfaa060 INFO GST_STATES
gstelement.c:2321:gst_element_continue_state:<queue2> completed state
change to PLAYING
0:00:03.476974345 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<queue2> notifying
about state-changed PAUSED to PLAYING (VOID_PENDING pending)
0:00:03.476999296 2690 0xfaa060 INFO GST_STATES
gstbin.c:2602:gst_bin_change_state_func:<av-recorder> child 'queue2'
changed state to 4(PLAYING) successfully
0:00:03.477025579 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<videotee> current PAUSED
pending VOID_PENDING, desired next PLAYING
0:00:03.477048413 2690 0xfaa060 INFO GST_STATES
gstelement.c:2321:gst_element_continue_state:<videotee> completed state
change to PLAYING
0:00:03.477069165 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<videotee> notifying
about state-changed PAUSED to PLAYING (VOID_PENDING pending)
0:00:03.477094372 2690 0xfaa060 INFO GST_STATES
gstbin.c:2602:gst_bin_change_state_func:<av-recorder> child 'videotee'
changed state to 4(PLAYING) successfully
0:00:03.477119952 2690 0xfaa060 INFO GST_STATES
gstbin.c:2194:gst_bin_element_set_state:<audio-caps> current PAUSED
pending VOID_PENDING, desired next PLAYING
0:00:03.477142809 2690 0xfaa060 INFO GST_STATES
gstelement.c:2321:gst_element_continue_state:<audio-caps> completed
state change to PLAYING
0:00:03.477163859 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<audio-caps> notifying
about state-changed PAUSED to PLAYING (VOID_PENDING pending)
0:00:03.477188847 2690 0xfaa060 INFO GST_STATES
gstbin.c:2602:gst_bin_change_state_func:<av-recorder> child 'audio-caps'
changed state to 4(PLAYING) successfully
0:00:03.477215855 2690 0xfaa060 INFO GST_STATES
gstelement.c:2321:gst_element_continue_state:<vid-source> completed
state change to PLAYING
0:00:03.477236198 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<vid-source> notifying
about state-changed PAUSED to PLAYING (VOID_PENDING pending)
0:00:03.477260743 2690 0xfaa060 INFO GST_STATES
gstbin.c:2602:gst_bin_change_state_func:<av-recorder> child 'vid-source'
changed state to 4(PLAYING) successfully
0:00:03.477294141 2690 0xfaa060 INFO GST_STATES
gstelement.c:2321:gst_element_continue_state:<alsa-source> completed
state change to PLAYING
0:00:03.477315194 2690 0xfaa060 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<alsa-source>
notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending)
0:00:03.477351389 2690 0xfaa060 INFO GST_STATES
gstbin.c:2602:gst_bin_change_state_func:<av-recorder> child
'alsa-source' changed state to 4(PLAYING) successfully
0:00:03.417077822 2690 0x1366450 INFO alsa
gstalsasrc.c:306:gst_alsasrc_getcaps:<alsa-source> template caps
audio/x-raw, format=(string){ S8, U8, S16LE, S16BE, U16LE, U16BE,
S24_32LE, S24_32BE, U24_32LE, U24_32BE, S32LE, S32BE, U32LE, U32BE,
S24LE, S24BE, U24LE, U24BE, S20LE, S20BE, U20LE, U20BE, S18LE, S18BE,
U18LE, U18BE, F32LE, F32BE, F64LE, F64BE }, layout=(string)interleaved,
rate=(int)[ 1, 2147483647 ], channels=(int)[ 1, 2147483647 ]
0:00:03.481170250 2690 0x1366450 INFO alsa
gstalsasrc.c:316:gst_alsasrc_getcaps:<alsa-source> returning caps
audio/x-raw, format=(string){ S16LE, S32LE },
layout=(string)interleaved, rate=(int)[ 4000, 192000 ], channels=(int)2,
channel-mask=(bitmask)0x0000000000000003; audio/x-raw, format=(string){
S16LE, S32LE }, layout=(string)interleaved, rate=(int)[ 4000, 192000 ],
channels=(int)1; audio/x-raw, format=(string){ S16LE, S32LE },
layout=(string)interleaved, rate=(int)[ 4000, 192000 ], channels=(int)3,
channel-mask=(bitmask)0x000000000000000b; audio/x-raw, format=(string){
S16LE, S32LE }, layout=(string)interleaved, rate=(int)[ 4000, 192000 ],
channels=(int)4, channel-mask=(bitmask)0x0000000000000033; audio/x-raw,
format=(string){ S16LE, S32LE }, layout=(string)interleaved, rate=(int)[
4000, 192000 ], channels=(int)6,
channel-mask=(bitmask)0x000000000000003f; audio/x-raw, format=(string){
S16LE, S32LE }, layout=(string)interleaved, rate=(int)[ 4000, 192000 ],
channels=(int)8, channel-mask=(bitmask)0x0000000000000c3f
0:00:03.481464355 2690 0x1366450 INFO structure
gststructure.c:2798:gst_structure_get_valist: Expected field
'channel-mask' in structure: audio/x-raw, rate=(int)44100,
channels=(int)1, layout=(string)interleaved;
0:00:03.481823833 2690 0x1366450 INFO structure
gststructure.c:2798:gst_structure_get_valist: Expected field
'channel-mask' in structure: audio/x-raw, rate=(int)44100,
layout=(string)interleaved, channels=(int)1;
0:00:03.481968974 2690 0x1366450 INFO structure
gststructure.c:2798:gst_structure_get_valist: Expected field
'channel-mask' in structure: audio/x-raw, format=(string)S16LE,
layout=(string)interleaved, rate=(int)44100, channels=(int)1;
0:00:03.450414768 2690 0x1366370 INFO v4l2
gstv4l2object.c:2170:gst_v4l2_object_setup_pool:<vid-source> accessing
buffers via mode 2
0:00:03.483232924 2690 0x1366370 INFO GST_EVENT
gstevent.c:628:gst_event_new_caps: creating caps event video/x-raw,
format=(string)I420, framerate=(fraction)25/1, width=(int)320,
height=(int)240, interlace-mode=(string)mixed,
pixel-aspect-ratio=(fraction)1/1
0:00:03.485383680 2690 0x1366370 INFO basetransform
gstbasetransform.c:1316:gst_base_transform_setcaps:<vidrate> reuse caps
0:00:03.485409474 2690 0x1366370 INFO GST_EVENT
gstevent.c:628:gst_event_new_caps: creating caps event video/x-raw,
format=(string)I420, framerate=(fraction)25/1, width=(int)320,
height=(int)240, interlace-mode=(string)mixed,
pixel-aspect-ratio=(fraction)1/1
0:00:03.485646758 2690 0x1366370 INFO GST_EVENT
gstevent.c:628:gst_event_new_caps: creating caps event video/x-raw,
format=(string)I420, framerate=(fraction)25/1, width=(int)480,
height=(int)384, interlace-mode=(string)mixed,
pixel-aspect-ratio=(fraction)16/15
0:00:03.486511333 2690 0x1366370 INFO basetransform
gstbasetransform.c:1316:gst_base_transform_setcaps:<vid-caps> reuse caps
0:00:03.486543100 2690 0x1366370 INFO GST_EVENT
gstevent.c:628:gst_event_new_caps: creating caps event video/x-raw,
format=(string)I420, framerate=(fraction)25/1, width=(int)480,
height=(int)384, interlace-mode=(string)mixed,
pixel-aspect-ratio=(fraction)16/15
0:00:03.488570746 2690 0x1366450 INFO ringbuffer
gstaudioringbuffer.c:552:gst_audio_ring_buffer_acquire:<audiosrcringbuffer0>
Allocating an array for 20 timestamps
0:00:03.488602351 2690 0x1366280 INFO basetransform
gstbasetransform.c:1316:gst_base_transform_setcaps:<monscale> reuse caps
0:00:03.488599550 2690 0x1366450 INFO GST_EVENT
gstevent.c:628:gst_event_new_caps: creating caps event audio/x-raw,
format=(string)S16LE, layout=(string)interleaved, rate=(int)44100,
channels=(int)1
0:00:03.494560409 2690 0x1366450 INFO structure
gststructure.c:2798:gst_structure_get_valist: Expected field
'channel-mask' in structure: audio/x-raw, rate=(int)[ 1, 2147483647 ],
channels=(int)1, layout=(string)interleaved;
0:00:03.488642477 2690 0x1366280 INFO GST_EVENT
gstevent.c:628:gst_event_new_caps: creating caps event video/x-raw,
format=(string)I420, framerate=(fraction)25/1, width=(int)320,
height=(int)240, interlace-mode=(string)mixed,
pixel-aspect-ratio=(fraction)1/1
0:00:03.494833711 2690 0x1366280 INFO basetransform
gstbasetransform.c:1316:gst_base_transform_setcaps:<mon-caps> reuse caps
0:00:03.494858635 2690 0x1366280 INFO GST_EVENT
gstevent.c:628:gst_event_new_caps: creating caps event video/x-raw,
format=(string)I420, framerate=(fraction)25/1, width=(int)320,
height=(int)240, interlace-mode=(string)mixed,
pixel-aspect-ratio=(fraction)1/1
0:00:03.495160573 2690 0x1366450 INFO structure
gststructure.c:2798:gst_structure_get_valist: Expected field
'channel-mask' in structure: audio/x-raw, rate=(int)[ 1, 2147483647 ],
channels=(int)1, layout=(string)interleaved;
0:00:03.495320871 2690 0x1366450 INFO basetransform
gstbasetransform.c:1316:gst_base_transform_setcaps:<audio-caps> reuse caps
0:00:03.495343783 2690 0x1366450 INFO GST_EVENT
gstevent.c:628:gst_event_new_caps: creating caps event audio/x-raw,
format=(string)S16LE, layout=(string)interleaved, rate=(int)44100,
channels=(int)1
0:00:03.495586353 2690 0x1366450 INFO structure
gststructure.c:2798:gst_structure_get_valist: Expected field
'channel-mask' in structure: audio/x-raw, rate=(int)[ 1, 2147483647 ],
channels=(int)1, layout=(string)interleaved;
0:00:03.496049945 2690 0x1366400 INFO structure
gststructure.c:2798:gst_structure_get_valist: Expected field
'channel-mask' in structure: audio/x-raw, rate=(int)[ 1, 2147483647 ],
channels=(int)1, layout=(string)interleaved;
0:00:03.496943992 2690 0x1366400 INFO structure
gststructure.c:2798:gst_structure_get_valist: Expected field
'channel-mask' in structure: audio/x-raw, format=(string)S16LE,
layout=(string)interleaved, rate=(int)44100, channels=(int)1;
0:00:03.497203710 2690 0x1366400 INFO structure
gststructure.c:2798:gst_structure_get_valist: Expected field
'channel-mask' in structure: audio/x-raw, rate=(int)[ 1, 2147483647 ],
channels=(int)1, layout=(string)interleaved;
0:00:03.497514753 2690 0x1366400 INFO structure
gststructure.c:2798:gst_structure_get_valist: Expected field
'channel-mask' in structure: audio/x-raw, layout=(string)interleaved,
rate=(int)44100, channels=(int)1;
0:00:03.497966528 2690 0x1366400 INFO basetransform
gstbasetransform.c:1316:gst_base_transform_setcaps:<audio2-conv> reuse caps
0:00:03.497994646 2690 0x1366400 INFO structure
gststructure.c:2798:gst_structure_get_valist: Expected field
'channel-mask' in structure: audio/x-raw, format=(string)S16LE,
layout=(string)interleaved, rate=(int)44100, channels=(int)1;
0:00:03.498027677 2690 0x1366400 INFO structure
gststructure.c:2798:gst_structure_get_valist: Expected field
'channel-mask' in structure: audio/x-raw, format=(string)S16LE,
layout=(string)interleaved, rate=(int)44100, channels=(int)1;
0:00:03.498066371 2690 0x1366400 INFO audioconvert
audioconvert.c:620:audio_convert_prepare_context: depth in 16, out 16
0:00:03.498086838 2690 0x1366400 INFO audioconvert
audioconvert.c:630:audio_convert_prepare_context: using dither 2 and
noise shaping 0
0:00:03.498139676 2690 0x1366400 INFO audioconvert
audioconvert.c:650:audio_convert_prepare_context: func index in 5, out 5
0:00:03.498157838 2690 0x1366400 INFO audioconvert
audioconvert.c:655:audio_convert_prepare_context: use int mixing
0:00:03.498174981 2690 0x1366400 INFO audioconvert
audioconvert.c:661:audio_convert_prepare_context: unitsizes: 2 -> 2
0:00:03.498192538 2690 0x1366400 INFO audioconvert
audioconvert.c:671:audio_convert_prepare_context: in default 0, mix
passthrough 1, out default 0
0:00:03.498210562 2690 0x1366400 INFO audioconvert
audioconvert.c:678:audio_convert_prepare_context: scale in 16, out 16
0:00:03.498228826 2690 0x1366400 INFO GST_EVENT
gstevent.c:628:gst_event_new_caps: creating caps event audio/x-raw,
format=(string)S16LE, layout=(string)interleaved, rate=(int)44100,
channels=(int)1
0:00:03.498327070 2690 0x13661e0 INFO structure
gststructure.c:2798:gst_structure_get_valist: Expected field
'channel-mask' in structure: audio/x-raw, format=(string)S16LE,
layout=(string)interleaved, rate=(int)44100, channels=(int)1;
0:00:03.500158138 2690 0x7fdc00002ed0 INFO ringbuffer
gstaudioringbuffer.c:1966:gst_audio_ring_buffer_set_timestamp:<audiosrcringbuffer0>
Storing timestamp 99:99:99.999999999 @ 0
0:00:03.500198331 2690 0x1366450 INFO ringbuffer
gstaudioringbuffer.c:1761:gst_audio_ring_buffer_read:<audiosrcringbuffer0>
Retrieved timestamp 99:99:99.999999999 @ 0
0:00:03.500292754 2690 0x1366450 INFO GST_EVENT
gstevent.c:709:gst_event_new_segment: creating segment event time
segment start=0:00:00.000000000, stop=99:99:99.999999999, rate=1.000000,
applied_rate=1.000000, flags=0x00, time=0:00:00.000000000,
base=0:00:00.000000000, position 0:00:00.000000000, duration
99:99:99.999999999
0:00:03.500350977 2690 0x1366450 INFO basesrc
gstbasesrc.c:2719:gst_base_src_loop:<alsa-source> marking pending DISCONT
0:00:03.500431952 2690 0x13661e0 INFO GST_EVENT
gstevent.c:709:gst_event_new_segment: creating segment event bytes
segment start=0, stop=-1, rate=1.000000, applied_rate=1.000000,
flags=0x00, time=0, base=0, position 0, duration -1
0:00:03.500431913 2690 0x1366320 INFO structure
gststructure.c:2798:gst_structure_get_valist: Expected field
'channel-mask' in structure: audio/x-raw, format=(string)S16LE,
layout=(string)interleaved, rate=(int)44100, channels=(int)1;
0:00:03.512723825 2690 0x7fdc00002ed0 INFO ringbuffer
gstaudioringbuffer.c:1966:gst_audio_ring_buffer_set_timestamp:<audiosrcringbuffer0>
Storing timestamp 99:99:99.999999999 @ 1
0:00:03.523565004 2690 0x7fdc00002ed0 INFO ringbuffer
gstaudioringbuffer.c:1966:gst_audio_ring_buffer_set_timestamp:<audiosrcringbuffer0>
Storing timestamp 99:99:99.999999999 @ 2
0:00:03.523976246 2690 0x1366450 INFO ringbuffer
gstaudioringbuffer.c:1761:gst_audio_ring_buffer_read:<audiosrcringbuffer0>
Retrieved timestamp 99:99:99.999999999 @ 1
0:00:03.524020902 2690 0x1366450 INFO ringbuffer
gstaudioringbuffer.c:1761:gst_audio_ring_buffer_read:<audiosrcringbuffer0>
Retrieved timestamp 99:99:99.999999999 @ 2
0:00:03.528374285 2690 0x1366320 INFO lamemp3enc
gstlamemp3enc.c:911:gst_lamemp3enc_setup: lame encoder setup (target
quality, quality 4.000000, bitrate 128, 44100 Hz, 1 channels)
0:00:03.534693234 2690 0x7fdc00002ed0 INFO ringbuffer
gstaudioringbuffer.c:1966:gst_audio_ring_buffer_set_timestamp:<audiosrcringbuffer0>
Storing timestamp 99:99:99.999999999 @ 3
0:00:03.534902349 2690 0x1366450 INFO ringbuffer
gstaudioringbuffer.c:1761:gst_audio_ring_buffer_read:<audiosrcringbuffer0>
Retrieved timestamp 99:99:99.999999999 @ 3
0:00:03.546111193 2690 0x7fdc00002ed0 INFO ringbuffer
gstaudioringbuffer.c:1966:gst_audio_ring_buffer_set_timestamp:<audiosrcringbuffer0>
Storing timestamp 99:99:99.999999999 @ 4
0:00:03.546249022 2690 0x1366450 INFO ringbuffer
gstaudioringbuffer.c:1761:gst_audio_ring_buffer_read:<audiosrcringbuffer0>
Retrieved timestamp 99:99:99.999999999 @ 4
0:00:03.556152394 2690 0x7fdc00002ed0 INFO ringbuffer
gstaudioringbuffer.c:1966:gst_audio_ring_buffer_set_timestamp:<audiosrcringbuffer0>
Storing timestamp 99:99:99.999999999 @ 5
0:00:03.556182077 2690 0x1366450 INFO ringbuffer
gstaudioringbuffer.c:1761:gst_audio_ring_buffer_read:<audiosrcringbuffer0>
Retrieved timestamp 99:99:99.999999999 @ 5
0:00:03.556189371 2690 0x7fdc00002ed0 INFO ringbuffer
gstaudioringbuffer.c:1966:gst_audio_ring_buffer_set_timestamp:<audiosrcringbuffer0>
Storing timestamp 99:99:99.999999999 @ 6
0:00:03.556244943 2690 0x1366450 INFO ringbuffer
gstaudioringbuffer.c:1761:gst_audio_ring_buffer_read:<audiosrcringbuffer0>
Retrieved timestamp 99:99:99.999999999 @ 6
0:00:03.566353378 2690 0x7fdc00002ed0 INFO ringbuffer
gstaudioringbuffer.c:1966:gst_audio_ring_buffer_set_timestamp:<audiosrcringbuffer0>
Storing timestamp 99:99:99.999999999 @ 7
0:00:03.566497668 2690 0x1366450 INFO ringbuffer
gstaudioringbuffer.c:1761:gst_audio_ring_buffer_read:<audiosrcringbuffer0>
Retrieved timestamp 99:99:99.999999999 @ 7
0:00:03.576864233 2690 0x7fdc00002ed0 INFO ringbuffer
gstaudioringbuffer.c:1966:gst_audio_ring_buffer_set_timestamp:<audiosrcringbuffer0>
Storing timestamp 99:99:99.999999999 @ 8
0:00:03.577096578 2690 0x1366450 INFO ringbuffer
gstaudioringbuffer.c:1761:gst_audio_ring_buffer_read:<audiosrcringbuffer0>
Retrieved timestamp 99:99:99.999999999 @ 8
0:00:03.578095354 2690 0x1366320 INFO GST_EVENT
gstevent.c:628:gst_event_new_caps: creating caps event audio/mpeg,
mpegversion=(int)1, mpegaudioversion=(int)1, layer=(int)3,
channels=(int)1, rate=(int)44100
0:00:03.591551742 2690 0x7fdc00002ed0 INFO ringbuffer
gstaudioringbuffer.c:1966:gst_audio_ring_buffer_set_timestamp:<audiosrcringbuffer0>
Storing timestamp 99:99:99.999999999 @ 9
0:00:03.591647164 2690 0x1366450 INFO ringbuffer
gstaudioringbuffer.c:1761:gst_audio_ring_buffer_read:<audiosrcringbuffer0>
Retrieved timestamp 99:99:99.999999999 @ 9
0:00:03.601734775 2690 0x7fdc00002ed0 INFO ringbuffer
gstaudioringbuffer.c:1966:gst_audio_ring_buffer_set_timestamp:<audiosrcringbuffer0>
Storing timestamp 99:99:99.999999999 @ 10
0:00:03.601858554 2690 0x1366450 INFO ringbuffer
gstaudioringbuffer.c:1761:gst_audio_ring_buffer_read:<audiosrcringbuffer0>
Retrieved timestamp 99:99:99.999999999 @ 10
0:00:03.611788913 2690 0x1366370 INFO v4l2src
gstv4l2src.c:860:gst_v4l2src_fill:<vid-source> sync to 0:00:00.040000000
out ts 0:00:00.120011133
0:00:03.611818256 2690 0x1366370 INFO GST_EVENT
gstevent.c:709:gst_event_new_segment: creating segment event time
segment start=0:00:00.000000000, stop=99:99:99.999999999, rate=1.000000,
applied_rate=1.000000, flags=0x00, time=0:00:00.000000000,
base=0:00:00.000000000, position 0:00:00.000000000, duration
99:99:99.999999999
0:00:03.611868351 2690 0x7fdc00002ed0 INFO ringbuffer
gstaudioringbuffer.c:1966:gst_audio_ring_buffer_set_timestamp:<audiosrcringbuffer0>
Storing timestamp 99:99:99.999999999 @ 11
0:00:03.611925277 2690 0x1366370 INFO basesrc
gstbasesrc.c:2719:gst_base_src_loop:<vid-source> marking pending DISCONT
0:00:03.611978798 2690 0x1366450 INFO ringbuffer
gstaudioringbuffer.c:1761:gst_audio_ring_buffer_read:<audiosrcringbuffer0>
Retrieved timestamp 99:99:99.999999999 @ 11
0:00:03.621996503 2690 0x7fdc00002ed0 INFO ringbuffer
gstaudioringbuffer.c:1966:gst_audio_ring_buffer_set_timestamp:<audiosrcringbuffer0>
Storing timestamp 99:99:99.999999999 @ 12
0:00:03.622036519 2690 0x1366450 INFO ringbuffer
gstaudioringbuffer.c:1761:gst_audio_ring_buffer_read:<audiosrcringbuffer0>
Retrieved timestamp 99:99:99.999999999 @ 12
0:00:03.632175208 2690 0x7fdc00002ed0 INFO ringbuffer
gstaudioringbuffer.c:1966:gst_audio_ring_buffer_set_timestamp:<audiosrcringbuffer0>
Storing timestamp 99:99:99.999999999 @ 13
0:00:03.632239732 2690 0x1366450 INFO ringbuffer
gstaudioringbuffer.c:1761:gst_audio_ring_buffer_read:<audiosrcringbuffer0>
Retrieved timestamp 99:99:99.999999999 @ 13
0:00:03.634111826 2690 0x1366280 INFO GST_STATES
gstbin.c:3019:bin_handle_async_done:<videosink> committing state from
READY to PAUSED, old pending PAUSED
0:00:03.634228749 2690 0x1366280 INFO GST_STATES
gstbin.c:3039:bin_handle_async_done:<videosink> completed state change,
pending VOID
0:00:03.634252302 2690 0x1366280 INFO GST_STATES
gstelement.c:2226:_priv_gst_element_state_changed:<videosink> notifying
about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:03.642308381 2690 0x7fdc00002ed0 INFO ringbuffer
gstaudioringbuffer.c:1966:gst_audio_ring_buffer_set_timestamp:<audiosrcringbuffer0>
Storing timestamp 99:99:99.999999999 @ 14
0:00:03.642347141 2690 0x1366450 INFO ringbuffer
gstaudioringbuffer.c:1761:gst_audio_ring_buffer_read:<audiosrcringbuffer0>
Retrieved timestamp 99:99:99.999999999 @ 14
0:00:03.651760899 2690 0x1366370 INFO v4l2src
gstv4l2src.c:860:gst_v4l2src_fill:<vid-source> sync to 0:00:00.080000000
out ts 0:00:00.159377362
0:00:03.652494999 2690 0x7fdc00002ed0 INFO ringbuffer
gstaudioringbuffer.c:1966:gst_audio_ring_buffer_set_timestamp:<audiosrcringbuffer0>
Storing timestamp 99:99:99.999999999 @ 15
0:00:03.652552458 2690 0x1366450 INFO ringbuffer
gstaudioringbuffer.c:1761:gst_audio_ring_buffer_read:<audiosrcringbuffer0>
Retrieved timestamp 99:99:99.999999999 @ 15
0:00:03.655598112 2690 0x13662d0 INFO x264enc :0::<videnc> using SAR=16/15
0:00:03.656850361 2690 0x13662d0 INFO x264enc :0::<videnc> using cpu
capabilities: MMX2 SSE2Fast SSSE3 FastShuffle SSE4.1 Cache64
0:00:03.665562357 2690 0x13662d0 INFO x264enc :0::<videnc> profile High,
level 2.1
0:00:03.665804285 2690 0x13662d0 INFO x264enc
gstx264enc.c:1446:gst_x264_enc_set_latency:<videnc> Updating latency to
0:00:01.880000000 (47 frames)
0:00:03.669648149 2690 0x7fdc00002ed0 INFO ringbuffer
gstaudioringbuffer.c:1966:gst_audio_ring_buffer_set_timestamp:<audiosrcringbuffer0>
Storing timestamp 99:99:99.999999999 @ 16
0:00:03.669918657 2690 0x1366450 INFO ringbuffer
gstaudioringbuffer.c:1761:gst_audio_ring_buffer_read:<audiosrcringbuffer0>
Retrieved timestamp 99:99:99.999999999 @ 16
0:00:03.673105993 2690 0x7fdc00002ed0 INFO ringbuffer
gstaudioringbuffer.c:1966:gst_audio_ring_buffer_set_timestamp:<audiosrcringbuffer0>
Storing timestamp 99:99:99.999999999 @ 17
0:00:03.673183391 2690 0x1366450 INFO ringbuffer
gstaudioringbuffer.c:1761:gst_audio_ring_buffer_read:<audiosrcringbuffer0>
Retrieved timestamp 99:99:99.999999999 @ 17
0:00:03.683030559 2690 0x7fdc00002ed0 INFO ringbuffer
gstaudioringbuffer.c:1966:gst_audio_ring_buffer_set_timestamp:<audiosrcringbuffer0>
Storing timestamp 99:99:99.999999999 @ 18
0:00:03.683117445 2690 0x1366450 INFO ringbuffer
gstaudioringbuffer.c:1761:gst_audio_ring_buffer_read:<audiosrcringbuffer0>
Retrieved timestamp 99:99:99.999999999 @ 18
0:00:03.691926965 2690 0x1366370 INFO v4l2src
gstv4l2src.c:860:gst_v4l2src_fill:<vid-source> sync to 0:00:00.120000000
out ts 0:00:00.198579179
0:00:03.698242404 2690 0x7fdc00002ed0 INFO ringbuffer
gstaudioringbuffer.c:1966:gst_audio_ring_buffer_set_timestamp:<audiosrcringbuffer0>
Storing timestamp 99:99:99.999999999 @ 19
0:00:03.698286071 2690 0x1366450 INFO ringbuffer
gstaudioringbuffer.c:1761:gst_audio_ring_buffer_read:<audiosrcringbuffer0>
Retrieved timestamp 99:99:99.999999999 @ 19
0:00:03.698294722 2690 0x7fdc00002ed0 INFO ringbuffer
gstaudioringbuffer.c:1966:gst_audio_ring_buffer_set_timestamp:<audiosrcringbuffer0>
Storing timestamp 99:99:99.999999999 @ 0
0:00:03.698381184 2690 0x1366450 INFO ringbuffer
gstaudioringbuffer.c:1761:gst_audio_ring_buffer_read:<audiosrcringbuffer0>
Retrieved timestamp 99:99:99.999999999 @ 0
0:00:03.713213951 2690 0x7fdc00002ed0 INFO ringbuffer
gstaudioringbuffer.c:1966:gst_audio_ring_buffer_set_timestamp:<audiosrcringbuffer0>
Storing timestamp 99:99:99.999999999 @ 1
0:00:03.713292655 2690 0x1366450 INFO ringbuffer
gstaudioringbuffer.c:1761:gst_audio_ring_buffer_read:<audiosrcringbuffer0>
Retrieved timestamp 99:99:99.999999999 @ 1
0:00:03.723372475 2690 0x7fdc00002ed0 INFO ringbuffer
gstaudioringbuffer.c:1966:gst_audio_ring_buffer_set_timestamp:<audiosrcringbuffer0>
Storing timestamp 99:99:99.999999999 @ 2
0:00:03.723527497 2690 0x1366450 INFO ringbuffer
gstaudioringbuffer.c:1761:gst_audio_ring_buffer_read:<audiosrcringbuffer0>
Retrieved timestamp 99:99:99.999999999 @ 2
0:00:03.731889142 2690 0x1366370 INFO v4l2src
gstv4l2src.c:860:gst_v4l2src_fill:<vid-source> sync to 0:00:00.160000000
out ts 0:00:00.238343618
0:00:03.733595009 2690 0x7fdc00002ed0 INFO ringbuffer
gstaudioringbuffer.c:1966:gst_audio_ring_buffer_set_timestamp:<audiosrcringbuffer0>
Storing timestamp 99:99:99.999999999 @ 3
0:00:03.733690723 2690 0x1366450 INFO ringbuffer
gstaudioringbuffer.c:1761:gst_audio_ring_buffer_read:<audiosrcringbuffer0>
Retrieved timestamp 99:99:99.999999999 @ 3
0:00:03.743674775 2690 0x7fdc00002ed0 INFO ringbuffer
gstaudioringbuffer.c:1966:gst_audio_ring_buffer_set_timestamp:<audiosrcringbuffer0>
Storing timestamp 99:99:99.999999999 @ 4
0:00:03.743757639 2690 0x1366450 INFO ringbuffer
gstaudioringbuffer.c:1761:gst_audio_ring_buffer_read:<audiosrcringbuffer0>
Retrieved timestamp 99:99:99.999999999 @ 4
0:00:03.753846363 2690 0x7fdc00002ed0 INFO ringbuffer
gstaudioringbuffer.c:1966:gst_audio_ring_buffer_set_timestamp:<audiosrcringbuffer0>
Storing timestamp 99:99:99.999999999 @ 5
0:00:03.753928541 2690 0x1366450 INFO ringbuffer
gstaudioringbuffer.c:1761:gst_audio_ring_buffer_read:<audiosrcringbuffer0>
Retrieved timestamp 99:99:99.999999999 @ 5
0:00:03.763973534 2690 0x7fdc00002ed0 INFO ringbuffer
gstaudioringbuffer.c:1966:gst_audio_ring_buffer_set_timestamp:<audiosrcringbuffer0>
Storing timestamp 99:99:99.999999999 @ 6
0:00:03.764011516 2690 0x1366450 INFO ringbuffer
gstaudioringbuffer.c:1761:gst_audio_ring_buffer_read:<audiosrcringbuffer0>
Retrieved timestamp 99:99:99.999999999 @ 6
0:00:03.771924941 2690 0x1366370 INFO v4l2src
gstv4l2src.c:860:gst_v4l2src_fill:<vid-source> sync to 0:00:00.200000000
out ts 0:00:00.277760171
0:00:03.774168717 2690 0x7fdc00002ed0 INFO ringbuffer
gstaudioringbuffer.c:1966:gst_audio_ring_buffer_set_timestamp:<audiosrcringbuffer0>
Storing timestamp 99:99:99.999999999 @ 7
0:00:03.774212025 2690 0x1366450 INFO ringbuffer
gstaudioringbuffer.c:1761:gst_audio_ring_buffer_read:<audiosrcringbuffer0>
Retrieved timestamp 99:99:99.999999999 @ 7
0:00:03.784278298 2690 0x7fdc00002ed0 INFO ringbuffer
gstaudioringbuffer.c:1966:gst_audio_ring_buffer_set_timestamp:<audiosrcringbuffer0>
Storing timestamp 99:99:99.999999999 @ 8
0:00:03.784313972 2690 0x1366450 INFO ringbuffer
gstaudioringbuffer.c:1761:gst_audio_ring_buffer_read:<audiosrcringbuffer0>
Retrieved timestamp 99:99:99.999999999 @ 8
0:00:03.794417534 2690 0x7fdc00002ed0 INFO ringbuffer
gstaudioringbuffer.c:1966:gst_audio_ring_buffer_set_timestamp:<audiosrcringbuffer0>
Storing timestamp 99:99:99.999999999 @ 9
0:00:03.794449254 2690 0x1366450 INFO ringbuffer
gstaudioringbuffer.c:1761:gst_audio_ring_buffer_read:<audiosrcringbuffer0>
Retrieved timestamp 99:99:99.999999999 @ 9
0:00:03.804557827 2690 0x7fdc00002ed0 INFO ringbuffer
gstaudioringbuffer.c:1966:gst_audio_ring_buffer_set_timestamp:<audiosrcringbuffer0>
Storing timestamp 99:99:99.999999999 @ 10
0:00:03.804586908 2690 0x1366450 INFO ringbuffer
gstaudioringbuffer.c:1761:gst_audio_ring_buffer_read:<audiosrcringbuffer0>
Retrieved timestamp 99:99:99.999999999 @ 10
0:00:03.811964531 2690 0x1366370 INFO v4l2src
gstv4l2src.c:860:gst_v4l2src_fill:<vid-source> sync to 0:00:00.240000000
out ts 0:00:00.317201380
0:00:03.818148272 2690 0x7fdc00002ed0 INFO ringbuffer
gstaudioringbuffer.c:1966:gst_audio_ring_buffer_set_timestamp:<audiosrcringbuffer0>
Storing timestamp 99:99:99.999999999 @ 11
0:00:03.818208269 2690 0x7fdc00002ed0 INFO ringbuffer
gstaudioringbuffer.c:1966:gst_audio_ring_buffer_set_timestamp:<audiosrcringbuffer0>
Storing timestamp 99:99:99.999999999 @ 12
0:00:03.818374950 2690 0x1366450 INFO ringbuffer
gstaudioringbuffer.c:1761:gst_audio_ring_buffer_read:<audiosrcringbuffer0>
Retrieved timestamp 99:99:99.999999999 @ 11
0:00:03.818439646 2690 0x1366450 INFO ringbuffer
gstaudioringbuffer.c:1761:gst_audio_ring_buffer_read:<audiosrcringbuffer0>
Retrieved timestamp 99:99:99.999999999 @ 12
0:00:03.828147770 2690 0x7fdc00002ed0 INFO ringbuffer
gstaudioringbuffer.c:1966:gst_audio_ring_buffer_set_timestamp:<audiosrcringbuffer0>
Storing timestamp 99:99:99.999999999 @ 13
0:00:03.828179682 2690 0x1366450 INFO ringbuffer
gstaudioringbuffer.c:1761:gst_audio_ring_buffer_read:<audiosrcringbuffer0>
Retrieved timestamp 99:99:99.999999999 @ 13
0:00:03.843191178 2690 0x7fdc00002ed0 INFO ringbuffer
gstaudioringbuffer.c:1966:gst_audio_ring_buffer_set_timestamp:<audiosrcringbuffer0>
Storing timestamp 99:99:99.999999999 @ 14
0:00:03.843236520 2690 0x1366450 INFO ringbuffer
gstaudioringbuffer.c:1761:gst_audio_ring_buffer_read:<audiosrcringbuffer0>
Retrieved timestamp 99:99:99.999999999 @ 14
0:00:03.851871950 2690 0x1366370 INFO v4l2src
gstv4l2src.c:860:gst_v4l2src_fill:<vid-source> sync to 0:00:00.280000000
out ts 0:00:00.358787457
0:00:03.858229754 2690 0x7fdc00002ed0 INFO ringbuffer
gstaudioringbuffer.c:1966:gst_audio_ring_buffer_set_timestamp:<audiosrcringbuffer0>
Storing timestamp 99:99:99.999999999 @ 15
0:00:03.858265308 2690 0x1366450 INFO ringbuffer
gstaudioringbuffer.c:1761:gst_audio_ring_buffer_read:<audiosrcringbuffer0>
Retrieved timestamp 99:99:99.999999999 @ 15
0:00:03.858276366 2690 0x7fdc00002ed0 INFO ringbuffer
gstaudioringbuffer.c:1966:gst_audio_ring_buffer_set_timestamp:<audiosrcringbuffer0>
Storing timestamp 99:99:99.999999999 @ 16
0:00:03.858319353 2690 0x1366450 INFO ringbuffer
gstaudioringbuffer.c:1761:gst_audio_ring_buffer_read:<audiosrcringbuffer0>
Retrieved timestamp 99:99:99.999999999 @ 16
0:00:03.873262002 2690 0x7fdc00002ed0 INFO ringbuffer
gstaudioringbuffer.c:1966:gst_audio_ring_buffer_set_timestamp:<audiosrcringbuffer0>
Storing timestamp 99:99:99.999999999 @ 17
0:00:03.873299905 2690 0x1366450 INFO ringbuffer
gstaudioringbuffer.c:1761:gst_audio_ring_buffer_read:<audiosrcringbuffer0>
Retrieved timestamp 99:99:99.999999999 @ 17
0:00:03.883408840 2690 0x7fdc00002ed0 INFO ringbuffer
gstaudioringbuffer.c:1966:gst_audio_ring_buffer_set_timestamp:<audiosrcringbuffer0>
Storing timestamp 99:99:99.999999999 @ 18
0:00:03.883442619 2690 0x1366450 INFO ringbuffer
gstaudioringbuffer.c:1761:gst_audio_ring_buffer_read:<audiosrcringbuffer0>
Retrieved timestamp 99:99:99.999999999 @ 18
0:00:03.891869086 2690 0x1366370 INFO v4l2src
gstv4l2src.c:860:gst_v4l2src_fill:<vid-source> sync to 0:00:00.320000000
out ts 0:00:00.398519273
0:00:03.893609199 2690 0x7fdc00002ed0 INFO ringbuffer
gstaudioringbuffer.c:1966:gst_audio_ring_buffer_set_timestamp:<audiosrcringbuffer0>
Storing timestamp 99:99:99.999999999 @ 19
0:00:03.893648041 2690 0x1366450 INFO ringbuffer
gstaudioringbuffer.c:1761:gst_audio_ring_buffer_read:<audiosrcringbuffer0>
Retrieved timestamp 99:99:99.999999999 @ 19
0:00:03.903724814 2690 0x7fdc00002ed0 INFO ringbuffer
gstaudioringbuffer.c:1966:gst_audio_ring_buffer_set_timestamp:<audiosrcringbuffer0>
Storing timestamp 99:99:99.999999999 @ 0
0:00:03.903768306 2690 0x1366450 INFO ringbuffer
gstaudioringbuffer.c:1761:gst_audio_ring_buffer_read:<audiosrcringbuffer0>
Retrieved timestamp 99:99:99.999999999 @ 0
0:00:03.913866713 2690 0x7fdc00002ed0 INFO ringbuffer
gstaudioringbuffer.c:1966:gst_audio_ring_buffer_set_timestamp:<audiosrcringbuffer0>
Storing timestamp 99:99:99.999999999 @ 1
0:00:03.913898444 2690 0x1366450 INFO ringbuffer
gstaudioringbuffer.c:1761:gst_audio_ring_buffer_read:<audiosrcringbuffer0>
Retrieved timestamp 99:99:99.999999999 @ 1
0:00:03.924001263 2690 0x7fdc00002ed0 INFO ringbuffer
gstaudioringbuffer.c:1966:gst_audio_ring_buffer_set_timestamp:<audiosrcringbuffer0>
Storing timestamp 99:99:99.999999999 @ 2
0:00:03.924030937 2690 0x1366450 INFO ringbuffer
gstaudioringbuffer.c:1761:gst_audio_ring_buffer_read:<audiosrcringbuffer0>
Retrieved timestamp 99:99:99.999999999 @ 2
0:00:03.931862100 2690 0x1366370 INFO v4l2src
gstv4l2src.c:860:gst_v4l2src_fill:<vid-source> sync to 0:00:00.360000000
out ts 0:00:00.437846848
0:00:03.934296963 2690 0x7fdc00002ed0 INFO ringbuffer
gstaudioringbuffer.c:1966:gst_audio_ring_buffer_set_timestamp:<audiosrcringbuffer0>
Storing timestamp 99:99:99.999999999 @ 3
0:00:03.934458458 2690 0x1366450 INFO ringbuffer
gstaudioringbuffer.c:1761:gst_audio_ring_buffer_read:<audiosrcringbuffer0>
Retrieved timestamp 99:99:99.999999999 @ 3
0:00:03.944343783 2690 0x7fdc00002ed0 INFO ringbuffer
gstaudioringbuffer.c:1966:gst_audio_ring_buffer_set_timestamp:<audiosrcringbuffer0>
Storing timestamp 99:99:99.999999999 @ 4
0:00:03.944385227 2690 0x1366450 INFO ringbuffer
gstaudioringbuffer.c:1761:gst_audio_ring_buffer_read:<audiosrcringbuffer0>
Retrieved timestamp 99:99:99.999999999 @ 4
0:00:03.954483844 2690 0x7fdc00002ed0 INFO ringbuffer
gstaudioringbuffer.c:1966:gst_audio_ring_buffer_set_timestamp:<audiosrcringbuffer0>
Storing timestamp 99:99:99.999999999 @ 5
0:00:03.954531896 2690 0x1366450 INFO ringbuffer
gstaudioringbuffer.c:1761:gst_audio_ring_buffer_read:<audiosrcringbuffer0>
Retrieved timestamp 99:99:99.999999999 @ 5
0:00:03.964618337 2690 0x7fdc00002ed0 INFO ringbuffer
gstaudioringbuffer.c:1966:gst_audio_ring_buffer_set_timestamp:<audiosrcringbuffer0>
Storing timestamp 99:99:99.999999999 @ 6
0:00:03.964663739 2690 0x1366450 INFO ringbuffer
gstaudioringbuffer.c:1761:gst_audio_ring_buffer_read:<audiosrcringbuffer0>
Retrieved timestamp 99:99:99.999999999 @ 6
0:00:03.971972034 2690 0x1366370 INFO v4l2src
gstv4l2src.c:860:gst_v4l2src_fill:<vid-source> sync to 0:00:00.400000000
out ts 0:00:00.477153687
0:00:03.974840952 2690 0x7fdc00002ed0 INFO ringbuffer
gstaudioringbuffer.c:1966:gst_audio_ring_buffer_set_timestamp:<audiosrcringbuffer0>
Storing timestamp 99:99:99.999999999 @ 7
0:00:03.974886357 2690 0x1366450 INFO ringbuffer
gstaudioringbuffer.c:1761:gst_audio_ring_buffer_read:<audiosrcringbuffer0>
Retrieved timestamp 99:99:99.999999999 @ 7
0:00:03.984945805 2690 0x7fdc00002ed0 INFO ringbuffer
gstaudioringbuffer.c:1966:gst_audio_ring_buffer_set_timestamp:<audiosrcringbuffer0>
Storing timestamp 99:99:99.999999999 @ 8
0:00:03.984982688 2690 0x1366450 INFO ringbuffer
gstaudioringbuffer.c:1761:gst_audio_ring_buffer_read:<audiosrcringbuffer0>
Retrieved timestamp 99:99:99.999999999 @ 8
0:00:03.995084067 2690 0x7fdc00002ed0 INFO ringbuffer
gstaudioringbuffer.c:1966:gst_audio_ring_buffer_set_timestamp:<audiosrcringbuffer0>
Storing timestamp 99:99:99.999999999 @ 9
0:00:03.995130991 2690 0x1366450 INFO ringbuffer
gstaudioringbuffer.c:1761:gst_audio_ring_buffer_read:<audiosrcringbuffer0>
Retrieved timestamp 99:99:99.999999999 @ 9
0:00:04.005262182 2690 0x7fdc00002ed0 INFO ringbuffer
gstaudioringbuffer.c:1966:gst_audio_ring_buffer_set_timestamp:<audiosrcringbuffer0>
Storing timestamp 99:99:99.999999999 @ 10
0:00:04.005311185 2690 0x1366450 INFO ringbuffer
gstaudioringbuffer.c:1761:gst_audio_ring_buffer_read:<audiosrcringbuffer0>
Retrieved timestamp 99:99:99.999999999 @ 10
0:00:04.012034121 2690 0x1366370 INFO v4l2src
gstv4l2src.c:860:gst_v4l2src_fill:<vid-source> sync to 0:00:00.440000000
out ts 0:00:00.516416160
0:00:04.015409871 2690 0x7fdc00002ed0 INFO ringbuffer
gstaudioringbuffer.c:1966:gst_audio_ring_buffer_set_timestamp:<audiosrcringbuffer0>
Storing timestamp 99:99:99.999999999 @ 11
0:00:04.015448479 2690 0x1366450 INFO ringbuffer
gstaudioringbuffer.c:1761:gst_audio_ring_buffer_read:<audiosrcringbuffer0>
Retrieved timestamp 99:99:99.999999999 @ 11
0:00:04.025535710 2690 0x7fdc00002ed0 INFO ringbuffer
gstaudioringbuffer.c:1966:gst_audio_ring_buffer_set_timestamp:<audiosrcringbuffer0>
Storing timestamp 99:99:99.999999999 @ 12
0:00:04.025578830 2690 0x1366450 INFO ringbuffer
gstaudioringbuffer.c:1761:gst_audio_ring_buffer_read:<audiosrcringbuffer0>
Retrieved timestamp 99:99:99.999999999 @ 12
0:00:04.035688375 2690 0x7fdc00002ed0 INFO ringbuffer
gstaudioringbuffer.c:1966:gst_audio_ring_buffer_set_timestamp:<audiosrcringbuffer0>
Storing timestamp 99:99:99.999999999 @ 13
0:00:04.035733052 2690 0x1366450 INFO ringbuffer
gstaudioringbuffer.c:1761:gst_audio_ring_buffer_read:<audiosrcringbuffer0>
Retrieved timestamp 99:99:99.999999999 @ 13
--
--
Ian Davidson
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.freedesktop.org/archives/gstreamer-devel/attachments/20141104/ae15021f/attachment-0001.html>
More information about the gstreamer-devel
mailing list