Gstreamer video capture

Joel_A_Fernandes · July 27, 2011, 4:53am

Hi,

I've been trying get Gstreamer to encode video ouput from an early
version of Vaibhav's mt9v113 camera driver.

It seems that gstreamer-ti doesn't have any elements for capture? This
seems rather odd because there is some functionality in DMAI for
capture.

The main gstreamer framework instead has its own 'v4l2src' element,
which can do capture, but I feel it is difficult to get to work, for
example
here is a pipeline that I've been trying to construct:

root@beagleboard:~# gst-launch -v v4l2src device=/dev/video2 !
ffmpegcolorspace ! TIVidenc1 codecName=mpeg4enc engineName=codecServer
! filesink location=output.m4v

And here's the output I get
[..]
ERROR: from element /GstPipeline:pipeline0/GstV4l2Src:v4l2src0: Device
'/dev/video2' cannot capture in the specified format

Additional debug info:

gstv4l2object.c(2113): gst_v4l2_object_set_format ():
/GstPipeline:pipeline0/GstV4l2Src:v4l2src0:

Tried to capture in YU12, but device returned format YUYV
[end]

As you can see from the command line, v42lsrc's "device" properly has
to be set as it defaults to /dev/video0. This is correctly set to
/dev/video2 in DMAI for omap3530. And even after this, it appears that
many color formats are not available in v4l2src (?) as apparent from
the above logs and a "gst-inspect v4l2src".

Could anyone familiar with this share their thoughts? If it helps, I
have verified the camera driver output in YUYV format using yavta.

Thanks,
Joel

Vladimir_Pantelic · July 27, 2011, 6:54am

Joel A Fernandes wrote:

root@beagleboard:~# gst-launch -v v4l2src device=/dev/video2 !
ffmpegcolorspace ! TIVidenc1 codecName=mpeg4enc engineName=codecServer

you have ffmpegcolorspace in your pipeline which is doing color conversion
in pure unoptimized C and is slooooooow.

Tried to capture in YU12, but device returned format YUYV

which is exactly the right format for the DSP encoder and would
allow you to drop ffmpegcolorspace...

Could anyone familiar with this share their thoughts? If it helps, I
have verified the camera driver output in YUYV format using yavta.

and there is no way to tell GST to capture in YUYV?

Koen_Kooi · July 27, 2011, 7:02am

Joel A Fernandes wrote:

root@beagleboard:~# gst-launch -v v4l2src device=/dev/video2 !
ffmpegcolorspace ! TIVidenc1 codecName=mpeg4enc engineName=codecServer

you have ffmpegcolorspace in your pipeline which is doing color conversion
in pure unoptimized C and is slooooooow.

There is a slightly more optimized cogcolorspace element and you could also use TIC6xColorspace, but iirc that only does rgb->yuv.

Tried to capture in YU12, but device returned format YUYV

which is exactly the right format for the DSP encoder and would
allow you to drop ffmpegcolorspace...

Could anyone familiar with this share their thoughts? If it helps, I
have verified the camera driver output in YUYV format using yavta.

and there is no way to tell GST to capture in YUYV?

Untested, but something like this should work:

gst-launch -v v4l2src device=/dev/video2 ! 'video/x-raw-yuv,format=(fourcc)YUYV' ! TIVidenc1 codecName=mpeg4enc engineName=codecServer

Koen_Kooi · July 27, 2011, 9:54am

Are your patches available so others can try to reproduce these issues?

Joel_A_Fernandes · July 27, 2011, 2:23pm

Hi Koen,

I did try this out and this is what I get:

~# gst-launch --gst-debug=3 -v v4l2src device=/dev/video2 !
'video/x-raw-yuv,format=(fourcc)YUYV' ! TIVidenc1 codecName=mpeg4enc
engineName=codecServer

0:00:00.020507813 e[331m 762e[00m 0x14be050 e[32;01mINFO e[00m
e[00;01;31m GST_INIT
gstquery.c:108:_gst_query_initialize:e[00m init queries
0:00:00.028106690 e[331m 762e[00m 0x14be050 e[32;01mINFO e[00m
e[00;01;31m GST_INIT
gstmessage.c:73:_gst_message_initialize:e[00m init messages
0:00:00.029815674 e[331m 762e[00m 0x14be050 e[32;01mINFO e[00m
e[00;01;36m GST_PLUGIN_LOADING
gstplugin.c:350:_gst_plugin_initialize:e[00m registering 0 static
plugins
0:00:00.031188965 e[331m 762e[00m 0x14be050 e[32;01mINFO e[00m
e[00;01;36m GST_PLUGIN_LOADING
gstplugin.c:255:gst_plugin_register_static:e[00m registered static
plugin "staticelements"
0:00:00.031341553 e[331m 762e[00m 0x14be050 e[32;01mINFO e[00m
e[00;01;36m GST_PLUGIN_LOADING
gstplugin.c:257:gst_plugin_register_static:e[00m added static plugin
"staticelements", result: 1
0:00:00.042846680 e[331m 762e[00m 0x14be050 e[32;01mINFO e[00m
e[00m GST_REGISTRY
gstregistry.c:1599:ensure_current_registry:e[00m reading registry
cache: /home/root/.gstreamer-0.10/registry.arm.bin
0:00:00.210601807 e[331m 762e[00m 0x14be050 e[32;01mINFO e[00m
e[00m GST_REGISTRY
gstregistrybinary.c:614:gst_registry_binary_read_cache:e[00m loaded
/home/root/.gstreamer-0.10/registry.arm.bin in 0.167420 seconds
0:00:00.211181641 e[331m 762e[00m 0x14be050 e[32;01mINFO e[00m
e[00m GST_REGISTRY
gstregistry.c:1469:scan_and_update_registry:e[00m Validating plugins
from registry cache: /home/root/.gstreamer-0.10/registry.arm.bin
0:00:00.221893311 e[331m 762e[00m 0x14be050 e[32;01mINFO e[00m
e[00m GST_REGISTRY
gstregistry.c:1561:scan_and_update_registry:e[00m Registry cache has
not changed
0:00:00.222045899 e[331m 762e[00m 0x14be050 e[32;01mINFO e[00m
e[00m GST_REGISTRY
gstregistry.c:1628:ensure_current_registry:e[00m registry reading and
updating done, result = 1
0:00:00.222137451 e[331m 762e[00m 0x14be050 e[32;01mINFO e[00m
e[00;01;31m GST_INIT gst.c:792:init_post:e[00m GLib runtime
version: 2.28.5
0:00:00.222229004 e[331m 762e[00m 0x14be050 e[32;01mINFO e[00m
e[00;01;31m GST_INIT gst.c:794:init_post:e[00m GLib headers
version: 2.26.1
0:00:00.222473145 e[331m 762e[00m 0x14be050 e[32;01mINFO e[00m
e[00;01;37;41m GST_PIPELINE
gstparse.c:299:gst_parse_launch_full:e[00m parsing pipeline
description 'v4l2src device=/dev/video2 !
video/x-raw-yuv,format=(fourcc)YUYV ! TIVidenc1 codecName=mpeg4enc
engineName=codecServer '
0:00:00.270263672 e[331m 762e[00m 0x14be050 e[32;01mINFO e[00m
e[00;01;36m GST_PLUGIN_LOADING
gstplugin.c:859:gst_plugin_load_file:e[00m plugin
"/usr/lib/gstreamer-0.10/libgstvideo4linux2.so" loaded
0:00:00.270477295 e[331m 762e[00m 0x14be050 e[32;01mINFO e[00m
e[00;01;37;41m GST_ELEMENT_FACTORY
gstelementfactory.c:371:gst_element_factory_create:e[00m creating
element "v4l2src"
0:00:00.274505616 e[331m 762e[00m 0x14be050 e[32;01mINFO e[00m
e[00;01;37;41m GST_ELEMENT_PADS
gstelement.c:716:gst_element_add_pad:<GstBaseSrc@0x15fc050>e[00m
adding pad 'src'
0:00:00.286773682 e[331m 762e[00m 0x14be050 e[32;01mINFO e[00m
e[00;01;36m GST_PLUGIN_LOADING
gstplugin.c:859:gst_plugin_load_file:e[00m plugin
"/usr/lib/gstreamer-0.10/libgstticodecplugin.so" loaded
0:00:00.287017823 e[331m 762e[00m 0x14be050 e[32;01mINFO e[00m
e[00;01;37;41m GST_ELEMENT_FACTORY
gstelementfactory.c:371:gst_element_factory_create:e[00m creating
element "TIVidenc1"
0:00:00.289978028 e[331m 762e[00m 0x14be050 e[32;01mINFO e[00m
e[00;01;37;41m GST_ELEMENT_PADS
gstelement.c:716:gst_element_add_pad:<GstTIVidenc1@0x1601038>e[00m
adding pad 'sink'
0:00:00.290161133 e[331m 762e[00m 0x14be050 e[32;01mINFO e[00m
e[00;01;37;41m GST_ELEMENT_PADS
gstelement.c:716:gst_element_add_pad:<GstTIVidenc1@0x1601038>e[00m
adding pad 'src'
0:00:00.290649414 e[331m 762e[00m 0x14be050 e[32;01mINFO e[00m
e[00;01;37;41m GST_ELEMENT_FACTORY
gstelementfactory.c:371:gst_element_factory_create:e[00m creating
element "pipeline"
0:00:00.291442871 e[331m 762e[00m 0x14be050 e[32;01mINFO e[00m
e[00;01;37;41m GST_PIPELINE
./grammar.y:568:gst_parse_perform_link:e[00m linking v4l2src0:(any) to
tividenc10:(any) (0/0) with caps "video/x-raw-yuv,
format=(fourcc)YUYV"
0:00:00.297332764 e[331m 762e[00m 0x14be050 e[32;01mINFO e[00m
e[00;01;36m GST_PLUGIN_LOADING
gstplugin.c:859:gst_plugin_load_file:e[00m plugin
"/usr/lib/gstreamer-0.10/libgstcoreelements.so" loaded
0:00:00.297546387 e[331m 762e[00m 0x14be050 e[32;01mINFO e[00m
e[00;01;37;41m GST_ELEMENT_FACTORY
gstelementfactory.c:371:gst_element_factory_create:e[00m creating
element "capsfilter"
0:00:00.298553467 e[331m 762e[00m 0x14be050 e[32;01mINFO e[00m
e[00;01;37;41m GST_ELEMENT_PADS
gstelement.c:716:gst_element_add_pad:<GstBaseTransform@0x1606040>e[00m
adding pad 'sink'
0:00:00.298889160 e[331m 762e[00m 0x14be050 e[32;01mINFO e[00m
e[00;01;37;41m GST_ELEMENT_PADS
gstelement.c:716:gst_element_add_pad:<GstBaseTransform@0x1606040>e[00m
adding pad 'src'
0:00:00.299133301 e[331m 762e[00m 0x14be050 e[32;01mINFO e[00m
e[00;01;31m GST_STATES
gstbin.c:1759:gst_bin_get_state_func:<pipeline0>e[00m getting state
0:00:00.299407959 e[331m 762e[00m 0x14be050 e[32;01mINFO e[00m
e[00;01;31m GST_STATES
gstelement.c:2341:gst_element_continue_state:<capsfilter0>e[00m
completed state change to NULL
0:00:00.299652100 e[331m 762e[00m 0x14be050 e[32;01mINFO e[00m
e[00;01;37;41m GST_ELEMENT_PADS
gstutils.c:1568:gst_element_link_pads_full:e[00m trying to link
element v4l2src0:(any) to element capsfilter0:sink
0:00:00.299774170 e[331m 762e[00m 0x14be050 e[32;01mINFO e[00m
e[00;01;37;41m GST_ELEMENT_PADS
gstelement.c:963:gst_element_get_static_pad:e[00m found pad
capsfilter0:sink
0:00:00.299865723 e[331m 762e[00m 0x14be050 e[32;01mINFO e[00m
e[00;01;31;41m GST_PADS
gstutils.c:1468:prepare_link_maybe_ghosting:e[00m v4l2src0 and
capsfilter0 in same bin, no need for ghost pads
0:00:00.300140381 e[331m 762e[00m 0x14be050 e[32;01mINFO e[00m
e[00;01;31;41m GST_PADS
gstpad.c:1941:gst_pad_link_prepare:e[00m trying to link v4l2src0:src
and capsfilter0:sink
0:00:00.300933838 e[331m 762e[00m 0x14be050 e[32;01mINFO e[00m
e[00;01;31;41m GST_PADS
gstpad.c:2124:gst_pad_link_full:e[00m linked v4l2src0:src and
capsfilter0:sink, successful
0:00:00.301361084 e[331m 762e[00m 0x14be050 e[32;01mINFO e[00m
e[00;01;37;41m GST_ELEMENT_PADS
gstutils.c:1568:gst_element_link_pads_full:e[00m trying to link
element capsfilter0:src to element tividenc10:(any)
0:00:00.301483155 e[331m 762e[00m 0x14be050 e[32;01mINFO e[00m
e[00;01;37;41m GST_ELEMENT_PADS
gstelement.c:963:gst_element_get_static_pad:e[00m found pad
capsfilter0:src
0:00:00.301605225 e[331m 762e[00m 0x14be050 e[32;01mINFO e[00m
e[00;01;31;41m GST_PADS
gstutils.c:1028:gst_pad_check_link:e[00m trying to link
capsfilter0:src and tividenc10:sink
0:00:00.305694580 e[331m 762e[00m 0x14be050 e[32;01mINFO e[00m
e[00;01;37;41m GST_ELEMENT_PADS
gstutils.c:1203:gst_element_get_compatible_pad:<tividenc10>e[00m Could
not find a compatible pad to link to capsfilter0:src
0:00:00.305847168 e[331m 762e[00m 0x14be050 e[32;01mINFO e[00m
e[00;04m default
gstutils.c:1892:gst_element_link_pads_filtered:e[00m Could not link
pads: capsfilter:src - tividenc10:(null)
0:00:00.305969239 e[331m 762e[00m 0x14be050 e[32;01mINFO e[00m
e[00;01;31m GST_STATES
gstelement.c:2341:gst_element_continue_state:<capsfilter0>e[00m
completed state change to NULL
0:00:00.306091309 e[331m 762e[00m 0x14be050 e[32;01mINFO e[00m
e[00;01;37;41m GST_ELEMENT_PADS gstpad.c:1713:gst_pad_unlink:e[00m
unlinking v4l2src0:src(0x15fe008) and capsfilter0:sink(0x15fe260)
0:00:00.306274414 e[331m 762e[00m 0x14be050 e[32;01mINFO e[00m
e[00;01;37;41m GST_ELEMENT_PADS gstpad.c:1758:gst_pad_unlink:e[00m
unlinked v4l2src0:src and capsfilter0:sink
0:00:00.306457520 e[331m 762e[00m 0x14be050 e[32;01mINFO e[00m
e[00;01;37;41m GST_PARENTAGE
gstbin.c:1440:gst_bin_remove_func:<pipeline0>e[00m removed child
"capsfilter0"
0:00:00.306610108 e[331m 762e[00m 0x14be050 e[32;01mINFO e[00m
e[00;01;31;44m GST_REFCOUNTING
gstelement.c:2955:gst_element_dispose:<capsfilter0>e[00m dispose
0:00:00.306762696 e[331m 762e[00m 0x14be050 e[32;01mINFO e[00m
e[00;01;37;41m GST_ELEMENT_PADS
gstelement.c:835:gst_element_remove_pad:<capsfilter0>e[00m removing
pad 'src'
0:00:00.306945801 e[331m 762e[00m 0x14be050 e[32;01mINFO e[00m
e[00;01;37;41m GST_ELEMENT_PADS
gstelement.c:835:gst_element_remove_pad:<capsfilter0>e[00m removing
pad 'sink'
0:00:00.307067871 e[331m 762e[00m 0x14be050 e[32;01mINFO e[00m
e[00;01;31;44m GST_REFCOUNTING
gstelement.c:2979:gst_element_dispose:<capsfilter0>e[00m parent class
dispose
0:00:00.307159424 e[331m 762e[00m 0x14be050 e[32;01mINFO e[00m
e[00;01;31;44m GST_REFCOUNTING
gstelement.c:3010:gst_element_finalize:<capsfilter0>e[00m finalize
0:00:00.307250977 e[331m 762e[00m 0x14be050 e[32;01mINFO e[00m
e[00;01;31;44m GST_REFCOUNTING
gstelement.c:3021:gst_element_finalize:<capsfilter0>e[00m finalize
parent
0:00:00.307373047 e[331m 762e[00m 0x14be050 e[31;01mERROR e[00m
e[00;01;37;41m GST_PIPELINE
./grammar.y:614:gst_parse_perform_link:e[00m could not link v4l2src0
to tividenc10
WARNING: erroneous pipeline: could not link v4l2src0 to tividenc10

Here is a list of src capabilities for v4l2src I obtained from gst-inspect:

     video/x-raw-yuv
                 format: YV12
                  width: [ 1, 32768 ]
                 height: [ 1, 32768 ]
              framerate: [ 0/1, 100/1 ]
      video/x-raw-yuv
                 format: YUY2
                  width: [ 1, 32768 ]
                 height: [ 1, 32768 ]
              framerate: [ 0/1, 100/1 ]
      video/x-raw-yuv
                 format: UYVY
                  width: [ 1, 32768 ]
                 height: [ 1, 32768 ]
              framerate: [ 0/1, 100/1 ]
      video/x-raw-yuv
                 format: Y42B
                  width: [ 1, 32768 ]
                 height: [ 1, 32768 ]
              framerate: [ 0/1, 100/1 ]
      video/x-raw-yuv
                 format: Y41B
                  width: [ 1, 32768 ]
                 height: [ 1, 32768 ]
              framerate: [ 0/1, 100/1 ]
      video/x-raw-yuv
                 format: Y41P
                  width: [ 1, 32768 ]
                 height: [ 1, 32768 ]
              framerate: [ 0/1, 100/1 ]
      video/x-raw-yuv
                 format: NV12
                  width: [ 1, 32768 ]
                 height: [ 1, 32768 ]
              framerate: [ 0/1, 100/1 ]
      video/x-raw-yuv
                 format: NV21
                  width: [ 1, 32768 ]
                 height: [ 1, 32768 ]
              framerate: [ 0/1, 100/1 ]
      video/x-raw-yuv
                 format: YUV9
                  width: [ 1, 32768 ]
                 height: [ 1, 32768 ]
              framerate: [ 0/1, 100/1 ]
      video/x-raw-yuv
                 format: I420
                  width: [ 1, 32768 ]
                 height: [ 1, 32768 ]
              framerate: [ 0/1, 100/1 ]

So, 'YUYV' does not appear in this list. Any suggestions?

Regards,
Joel

Joel_A_Fernandes · July 27, 2011, 2:33pm

Actually the patches are the same from what I posted a few weeks back
[1] (but its early and Vaibhav is working on a newer one)

Thanks,
Joel

[1] http://groups.google.com/group/beagleboard/msg/66d19531f65e8a88

Koen_Kooi · July 27, 2011, 2:35pm

[..]

So, 'YUYV' does not appear in this list. Any suggestions?

Pick one that is close

Vladimir_Pantelic · July 27, 2011, 2:36pm

Joel A Fernandes wrote:

WARNING: erroneous pipeline: could not link v4l2src0 to tividenc10

Here is a list of src capabilities for v4l2src I obtained from gst-inspect:

       video/x-raw-yuv
                  format: UYVY
                   width: [ 1, 32768 ]
                  height: [ 1, 32768 ]
               framerate: [ 0/1, 100/1 ]

So, 'YUYV' does not appear in this list. Any suggestions?

UYVY?

Joel_A_Fernandes · July 27, 2011, 2:48pm

With this I get the following:

root@beagleboard:~# gst-launch -v v4l2src device=/dev/video2 !
'video/x-raw-yuv,format=(fourcc)UYVY' ! TIVidenc1 codecName=mpeg4enc
engineName=codecServer

Setting pipeline to PAUSED ...
ERROR: Pipeline doesn't want to pause.
ERROR: from element /GstPipeline:pipeline0/GstV4l2Src:v4l2src0: Could
not negotiate format
Additional debug info:
gstbasesrc.c(2778): gst_base_src_start ():
/GstPipeline:pipeline0/GstV4l2Src:v4l2src0:
Check your filtered caps, if any
Setting pipeline to NULL ...Freeing pipeline ...

I can see a lot of ioctl(9, VIDIOC_TRY_FMT, 0xbee3d104) = 0 in
strace which I'm guess is gstreaming trying different formats.

Here is the complete --gst-debug=3 output:

0:00:00.022735596 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31m GST_INIT
gstquery.c:108:_gst_query_initialize:e[00m init queries
0:00:00.030395508 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31m GST_INIT
gstmessage.c:73:_gst_message_initialize:e[00m init messages
0:00:00.032104493 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;36m GST_PLUGIN_LOADING
gstplugin.c:350:_gst_plugin_initialize:e[00m registering 0 static
plugins
0:00:00.033477784 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;36m GST_PLUGIN_LOADING
gstplugin.c:255:gst_plugin_register_static:e[00m registered static
plugin "staticelements"
0:00:00.033630371 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;36m GST_PLUGIN_LOADING
gstplugin.c:257:gst_plugin_register_static:e[00m added static plugin
"staticelements", result: 1
0:00:00.046844483 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00m GST_REGISTRY
gstregistry.c:1599:ensure_current_registry:e[00m reading registry
cache: /home/root/.gstreamer-0.10/registry.arm.bin
0:00:00.215484619 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00m GST_REGISTRY
gstregistrybinary.c:614:gst_registry_binary_read_cache:e[00m loaded
/home/root/.gstreamer-0.10/registry.arm.bin in 0.168335 seconds
0:00:00.216064453 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00m GST_REGISTRY
gstregistry.c:1469:scan_and_update_registry:e[00m Validating plugins
from registry cache: /home/root/.gstreamer-0.10/registry.arm.bin
0:00:00.226867676 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00m GST_REGISTRY
gstregistry.c:1561:scan_and_update_registry:e[00m Registry cache has
not changed
0:00:00.227020264 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00m GST_REGISTRY
gstregistry.c:1628:ensure_current_registry:e[00m registry reading and
updating done, result = 1
0:00:00.227111817 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31m GST_INIT gst.c:792:init_post:e[00m GLib runtime
version: 2.28.5
0:00:00.227172852 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31m GST_INIT gst.c:794:init_post:e[00m GLib headers
version: 2.26.1
0:00:00.227447510 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;37;41m GST_PIPELINE
gstparse.c:299:gst_parse_launch_full:e[00m parsing pipeline
description 'v4l2src device=/dev/video2 !
video/x-raw-yuv,format=(fourcc)UYVY ! TIVidenc1 codecName=mpeg4enc
engineName=codecServer '
0:00:00.275970459 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;36m GST_PLUGIN_LOADING
gstplugin.c:859:gst_plugin_load_file:e[00m plugin
"/usr/lib/gstreamer-0.10/libgstvideo4linux2.so" loaded
0:00:00.276184082 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;37;41m GST_ELEMENT_FACTORY
gstelementfactory.c:371:gst_element_factory_create:e[00m creating
element "v4l2src"
0:00:00.280395508 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;37;41m GST_ELEMENT_PADS
gstelement.c:716:gst_element_add_pad:<GstBaseSrc@0x1e08050>e[00m
adding pad 'src'
0:00:00.292816162 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;36m GST_PLUGIN_LOADING
gstplugin.c:859:gst_plugin_load_file:e[00m plugin
"/usr/lib/gstreamer-0.10/libgstticodecplugin.so" loaded
0:00:00.293029785 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;37;41m GST_ELEMENT_FACTORY
gstelementfactory.c:371:gst_element_factory_create:e[00m creating
element "TIVidenc1"
0:00:00.296356202 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;37;41m GST_ELEMENT_PADS
gstelement.c:716:gst_element_add_pad:<GstTIVidenc1@0x1e0d038>e[00m
adding pad 'sink'
0:00:00.296569825 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;37;41m GST_ELEMENT_PADS
gstelement.c:716:gst_element_add_pad:<GstTIVidenc1@0x1e0d038>e[00m
adding pad 'src'
0:00:00.297058106 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;37;41m GST_ELEMENT_FACTORY
gstelementfactory.c:371:gst_element_factory_create:e[00m creating
element "pipeline"
0:00:00.297821045 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;37;41m GST_PIPELINE
./grammar.y:568:gst_parse_perform_link:e[00m linking v4l2src0:(any) to
tividenc10:(any) (0/0) with caps "video/x-raw-yuv,
format=(fourcc)UYVY"
0:00:00.303680420 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;36m GST_PLUGIN_LOADING
gstplugin.c:859:gst_plugin_load_file:e[00m plugin
"/usr/lib/gstreamer-0.10/libgstcoreelements.so" loaded
0:00:00.303894043 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;37;41m GST_ELEMENT_FACTORY
gstelementfactory.c:371:gst_element_factory_create:e[00m creating
element "capsfilter"
0:00:00.304870606 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;37;41m GST_ELEMENT_PADS
gstelement.c:716:gst_element_add_pad:<GstBaseTransform@0x1e12040>e[00m
adding pad 'sink'
0:00:00.305206299 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;37;41m GST_ELEMENT_PADS
gstelement.c:716:gst_element_add_pad:<GstBaseTransform@0x1e12040>e[00m
adding pad 'src'
0:00:00.305450440 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31m GST_STATES
gstbin.c:1759:gst_bin_get_state_func:<pipeline0>e[00m getting state
0:00:00.305725098 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31m GST_STATES
gstelement.c:2341:gst_element_continue_state:<capsfilter0>e[00m
completed state change to NULL
0:00:00.305969239 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;37;41m GST_ELEMENT_PADS
gstutils.c:1568:gst_element_link_pads_full:e[00m trying to link
element v4l2src0:(any) to element capsfilter0:sink
0:00:00.306091309 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;37;41m GST_ELEMENT_PADS
gstelement.c:963:gst_element_get_static_pad:e[00m found pad
capsfilter0:sink
0:00:00.306182862 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31;41m GST_PADS
gstutils.c:1468:prepare_link_maybe_ghosting:e[00m v4l2src0 and
capsfilter0 in same bin, no need for ghost pads
0:00:00.306427002 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31;41m GST_PADS
gstpad.c:1941:gst_pad_link_prepare:e[00m trying to link v4l2src0:src
and capsfilter0:sink
0:00:00.307220459 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31;41m GST_PADS
gstpad.c:2124:gst_pad_link_full:e[00m linked v4l2src0:src and
capsfilter0:sink, successful
0:00:00.307464600 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;37;41m GST_ELEMENT_PADS
gstutils.c:1568:gst_element_link_pads_full:e[00m trying to link
element capsfilter0:src to element tividenc10:(any)
0:00:00.307586670 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;37;41m GST_ELEMENT_PADS
gstelement.c:963:gst_element_get_static_pad:e[00m found pad
capsfilter0:src
0:00:00.307678223 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31;41m GST_PADS
gstutils.c:1028:gst_pad_check_link:e[00m trying to link
capsfilter0:src and tividenc10:sink
0:00:00.309783936 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31;41m GST_PADS
gstutils.c:1468:prepare_link_maybe_ghosting:e[00m capsfilter0 and
tividenc10 in same bin, no need for ghost pads
0:00:00.309997559 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31;41m GST_PADS
gstpad.c:1941:gst_pad_link_prepare:e[00m trying to link
capsfilter0:src and tividenc10:sink
0:00:00.312103272 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31;41m GST_PADS
gstpad.c:2124:gst_pad_link_full:e[00m linked capsfilter0:src and
tividenc10:sink, successful
Setting pipeline to PAUSED ...
0:00:00.320373536 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31m GST_STATES
gstelement.c:2341:gst_element_continue_state:<tividenc10>e[00m
completed state change to READY
0:00:00.320526124 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31m GST_STATES
gstelement.c:2354:gst_element_continue_state:<tividenc10>e[00m posting
state-changed NULL to READY
0:00:00.320831299 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31m GST_STATES
gstbin.c:2492:gst_bin_change_state_func:<pipeline0>e[00m child
'tividenc10' changed state to 2(READY) successfully
0:00:00.321044922 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31m GST_STATES
gstelement.c:2341:gst_element_continue_state:<capsfilter0>e[00m
completed state change to READY
0:00:00.321136475 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31m GST_STATES
gstelement.c:2354:gst_element_continue_state:<capsfilter0>e[00m
posting state-changed NULL to READY
0:00:00.321258545 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31m GST_STATES
gstbin.c:2492:gst_bin_change_state_func:<pipeline0>e[00m child
'capsfilter0' changed state to 2(READY) successfully
0:00:02.452545167 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00m v4l2
v4l2_calls.c:480:gst_v4l2_open:<v4l2src0>e[00m Opened device 'OMAP3
ISP CCDC output' (/dev/video2) successfully
0:00:02.452972413 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31m GST_STATES
gstelement.c:2341:gst_element_continue_state:<v4l2src0>e[00m completed
state change to READY
0:00:02.453094483 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31m GST_STATES
gstelement.c:2354:gst_element_continue_state:<v4l2src0>e[00m posting
state-changed NULL to READY
0:00:02.453277588 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31m GST_STATES
gstbin.c:2492:gst_bin_change_state_func:<pipeline0>e[00m child
'v4l2src0' changed state to 2(READY) successfully
0:00:02.453430176 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31m GST_STATES
gstelement.c:2314:gst_element_continue_state:<pipeline0>e[00m
committing state from NULL to READY, pending PAUSED, next PAUSED
0:00:02.453857422 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31m GST_STATES
gstelement.c:2323:gst_element_continue_state:<pipeline0>e[00m continue
state change READY to PAUSED, final PAUSED
0:00:02.454162598 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31m GST_STATES
gstelement.c:2341:gst_element_continue_state:<tividenc10>e[00m
completed state change to PAUSED
0:00:02.454284668 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31m GST_STATES
gstelement.c:2354:gst_element_continue_state:<tividenc10>e[00m posting
state-changed READY to PAUSED
0:00:02.454437256 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31m GST_STATES
gstbin.c:2492:gst_bin_change_state_func:<pipeline0>e[00m child
'tividenc10' changed state to 3(PAUSED) successfully
0:00:02.454589844 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31m GST_STATES
gstelement.c:2341:gst_element_continue_state:<capsfilter0>e[00m
completed state change to PAUSED
0:00:02.454681397 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31m GST_STATES
gstelement.c:2354:gst_element_continue_state:<capsfilter0>e[00m
posting state-changed READY to PAUSED
0:00:02.454803467 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31m GST_STATES
gstbin.c:2492:gst_bin_change_state_func:<pipeline0>e[00m child
'capsfilter0' changed state to 3(PAUSED) successfully
0:00:02.455017090 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00m v4l2
gstv4l2object.c:1032:gst_v4l2_object_fill_format_list:<v4l2src0>e[00m
got 4 format(s):
0:00:02.455108643 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00m v4l2
gstv4l2object.c:1038:gst_v4l2_object_fill_format_list:<v4l2src0>e[00m
YU12 (emulated)
0:00:02.455169678 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00m v4l2
gstv4l2object.c:1038:gst_v4l2_object_fill_format_list:<v4l2src0>e[00m
YV12 (emulated)
0:00:02.455261231 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00m v4l2
gstv4l2object.c:1038:gst_v4l2_object_fill_format_list:<v4l2src0>e[00m
BGR3 (emulated)
0:00:02.455322266 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00m v4l2
gstv4l2object.c:1038:gst_v4l2_object_fill_format_list:<v4l2src0>e[00m
RGB3 (emulated)
0:00:03.491699219 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00m v4l2src
gstv4l2src.c:607:gst_v4l2src_get_caps:<v4l2src0>e[00m probed caps:
video/x-raw-yuv, format=(fourcc)I420, framerate=(fraction)[ 0/1, 100/1
], width=(int)320, height=(int)240, interlaced=(boolean)false;
video/x-raw-yuv, format=(fourcc)YV12, framerate=(fraction)[ 0/1, 100/1
], width=(int)320, height=(int)240, interlaced=(boolean)false;
video/x-raw-rgb, bpp=(int)24, depth=(int)24, red_mask=(int)255,
green_mask=(int)65280, blue_mask=(int)16711680, endianness=(int)4321,
framerate=(fraction)[ 0/1, 100/1 ], width=(int)320, height=(int)240,
interlaced=(boolean)false; video/x-raw-rgb, bpp=(int)24,
depth=(int)24, red_mask=(int)16711680, green_mask=(int)65280,
blue_mask=(int)255, endianness=(int)4321, framerate=(fraction)[ 0/1,
100/1 ], width=(int)320, height=(int)240, interlaced=(boolean)false
0:00:03.493011475 e[331m 792e[00m 0x1cca050 e[33;01mWARN e[00m
e[00m basesrc
gstbasesrc.c:2778:gst_base_src_start:<v4l2src0>e[00m error: Could not
negotiate format
0:00:03.493164063 e[331m 792e[00m 0x1cca050 e[33;01mWARN e[00m
e[00m basesrc
gstbasesrc.c:2778:gst_base_src_start:<v4l2src0>e[00m error: Check your
filtered caps, if any
0:00:03.493347168 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31;47m GST_ERROR_SYSTEM
gstelement.c:1865:gst_element_message_full:<v4l2src0>e[00m posting
message: Could not negotiate format
0:00:03.493560791 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31;47m GST_ERROR_SYSTEM
gstelement.c:1888:gst_element_message_full:<v4l2src0>e[00m posted
error message: Could not negotiate format
0:00:03.493652344 e[331m 792e[00m 0x1cca050 e[33;01mWARN e[00m
e[00m basesrc
gstbasesrc.c:2974:gst_base_src_activate_push:<v4l2src0>e[00m Failed to
start in push mode
0:00:03.493743897 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31;41m GST_PADS
gstpad.c:983:gst_pad_activate_push:<v4l2src0:src>e[00m failed to
activate in push mode
0:00:03.493835450 e[331m 792e[00m 0x1cca050 e[33;01mWARN e[00m
e[00;01;31;41m GST_PADS
gstpad.c:734:gst_pad_set_active:<v4l2src0:src>e[00m Failed to activate
pad
0:00:03.493957520 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31m GST_STATES
gstelement.c:2658:gst_element_change_state:<v4l2src0>e[00m have
FAILURE change_state return
0:00:03.494049073 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31m GST_STATES
gstelement.c:2235:gst_element_abort_state:<v4l2src0>e[00m aborting
state from READY to PAUSED
0:00:03.494110108 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31m GST_STATES
gstbin.c:2508:gst_bin_change_state_func:<pipeline0>e[00m child
'v4l2src0' failed to go to state 3(PAUSED)
0:00:03.494232178 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31m GST_STATES
gstelement.c:2658:gst_element_change_state:<pipeline0>e[00m have
FAILURE change_state return
ERROR: Pipeline doesn't want to pause.
ERROR: from element /GstPipeline:pipeline0/GstV4l2Src:v4l2src0: Could
not negotiate format
Additional debug info:
gstbasesrc.c(2778): gst_base_src_start ():
/GstPipeline:pipeline0/GstV4l2Src:v4l2src0:
Check your filtered caps, if any
Setting pipeline to NULL ...
0:00:03.496612549 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31m GST_STATES
gstelement.c:2314:gst_element_continue_state:<tividenc10>e[00m
committing state from PAUSED to READY, pending NULL, next NULL
0:00:03.496795655 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31m GST_STATES
gstelement.c:2323:gst_element_continue_state:<tividenc10>e[00m
continue state change READY to NULL, final NULL
0:00:03.496948242 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31m GST_STATES
gstelement.c:2341:gst_element_continue_state:<tividenc10>e[00m
completed state change to NULL
0:00:03.497039795 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31m GST_STATES
gstelement.c:2354:gst_element_continue_state:<tividenc10>e[00m posting
state-changed READY to NULL
0:00:03.497161865 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31m GST_STATES
gstbin.c:2492:gst_bin_change_state_func:<pipeline0>e[00m child
'tividenc10' changed state to 1(NULL) successfully
0:00:03.497406006 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31m GST_STATES
gstelement.c:2314:gst_element_continue_state:<capsfilter0>e[00m
committing state from PAUSED to READY, pending NULL, next NULL
0:00:03.497589112 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31m GST_STATES
gstelement.c:2323:gst_element_continue_state:<capsfilter0>e[00m
continue state change READY to NULL, final NULL
0:00:03.497711182 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31m GST_STATES
gstelement.c:2341:gst_element_continue_state:<capsfilter0>e[00m
completed state change to NULL
0:00:03.497802735 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31m GST_STATES
gstelement.c:2354:gst_element_continue_state:<capsfilter0>e[00m
posting state-changed READY to NULL
0:00:03.497924805 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31m GST_STATES
gstbin.c:2492:gst_bin_change_state_func:<pipeline0>e[00m child
'capsfilter0' changed state to 1(NULL) successfully
0:00:03.509460450 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31m GST_STATES
gstelement.c:2341:gst_element_continue_state:<v4l2src0>e[00m completed
state change to NULL
0:00:03.509613037 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31m GST_STATES
gstelement.c:2354:gst_element_continue_state:<v4l2src0>e[00m posting
state-changed READY to NULL
0:00:03.509796143 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31m GST_STATES
gstbin.c:2492:gst_bin_change_state_func:<pipeline0>e[00m child
'v4l2src0' changed state to 1(NULL) successfully
0:00:03.510040284 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31m GST_STATES
gstelement.c:2341:gst_element_continue_state:<pipeline0>e[00m
completed state change to NULL
0:00:03.510131836 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31m GST_STATES
gstelement.c:2354:gst_element_continue_state:<pipeline0>e[00m posting
state-changed READY to NULL
0:00:03.510284424 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31m GST_STATES
gstbin.c:1759:gst_bin_get_state_func:<pipeline0>e[00m getting state
Freeing pipeline ...
0:00:03.510528565 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;37;41m GST_ELEMENT_PADS gstpad.c:1713:gst_pad_unlink:e[00m
unlinking capsfilter0:src(0x1e0a328) and tividenc10:sink(0x1e0a0d0)
0:00:03.510711670 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;37;41m GST_ELEMENT_PADS gstpad.c:1758:gst_pad_unlink:e[00m
unlinked capsfilter0:src and tividenc10:sink
0:00:03.510894776 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;37;41m GST_ELEMENT_PADS gstpad.c:1713:gst_pad_unlink:e[00m
unlinking v4l2src0:src(0x1e0a008) and capsfilter0:sink(0x1e0a260)
0:00:03.511016846 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;37;41m GST_ELEMENT_PADS gstpad.c:1758:gst_pad_unlink:e[00m
unlinked v4l2src0:src and capsfilter0:sink
0:00:03.511169434 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;37;41m GST_PARENTAGE
gstbin.c:1440:gst_bin_remove_func:<pipeline0>e[00m removed child
"capsfilter0"
0:00:03.511352539 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31;44m GST_REFCOUNTING
gstelement.c:2955:gst_element_dispose:<capsfilter0>e[00m dispose
0:00:03.511444092 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;37;41m GST_ELEMENT_PADS
gstelement.c:835:gst_element_remove_pad:<capsfilter0>e[00m removing
pad 'src'
0:00:03.511627198 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;37;41m GST_ELEMENT_PADS
gstelement.c:835:gst_element_remove_pad:<capsfilter0>e[00m removing
pad 'sink'
0:00:03.511779785 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31;44m GST_REFCOUNTING
gstelement.c:2979:gst_element_dispose:<capsfilter0>e[00m parent class
dispose
0:00:03.511871338 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31;44m GST_REFCOUNTING
gstelement.c:3010:gst_element_finalize:<capsfilter0>e[00m finalize
0:00:03.511993408 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31;44m GST_REFCOUNTING
gstelement.c:3021:gst_element_finalize:<capsfilter0>e[00m finalize
parent
0:00:03.512115479 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;37;41m GST_PARENTAGE
gstbin.c:1440:gst_bin_remove_func:<pipeline0>e[00m removed child
"tividenc10"
0:00:03.512268067 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31;44m GST_REFCOUNTING
gstelement.c:2955:gst_element_dispose:<tividenc10>e[00m dispose
0:00:03.512329102 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;37;41m GST_ELEMENT_PADS
gstelement.c:835:gst_element_remove_pad:<tividenc10>e[00m removing pad
'src'
0:00:03.512481690 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;37;41m GST_ELEMENT_PADS
gstelement.c:835:gst_element_remove_pad:<tividenc10>e[00m removing pad
'sink'
0:00:03.512634278 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31;44m GST_REFCOUNTING
gstelement.c:2979:gst_element_dispose:<tividenc10>e[00m parent class
dispose
0:00:03.512725830 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31;44m GST_REFCOUNTING
gstelement.c:3010:gst_element_finalize:<tividenc10>e[00m finalize
0:00:03.512817383 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31;44m GST_REFCOUNTING
gstelement.c:3021:gst_element_finalize:<tividenc10>e[00m finalize
parent
0:00:03.512939453 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;37;41m GST_PARENTAGE
gstbin.c:1440:gst_bin_remove_func:<pipeline0>e[00m removed child
"v4l2src0"
0:00:03.513061524 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31;44m GST_REFCOUNTING
gstelement.c:2955:gst_element_dispose:<v4l2src0>e[00m dispose
0:00:03.513183594 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;37;41m GST_ELEMENT_PADS
gstelement.c:835:gst_element_remove_pad:<v4l2src0>e[00m removing pad
'src'
0:00:03.513305664 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31;44m GST_REFCOUNTING
gstelement.c:2979:gst_element_dispose:<v4l2src0>e[00m parent class
dispose
0:00:03.513488770 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31;44m GST_REFCOUNTING
gstelement.c:3010:gst_element_finalize:<v4l2src0>e[00m finalize
0:00:03.513610840 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31;44m GST_REFCOUNTING
gstelement.c:3021:gst_element_finalize:<v4l2src0>e[00m finalize parent
0:00:03.513702393 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31;44m GST_REFCOUNTING
gstelement.c:2955:gst_element_dispose:<pipeline0>e[00m dispose
0:00:03.513824463 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31;44m GST_REFCOUNTING
gstelement.c:2979:gst_element_dispose:<pipeline0>e[00m parent class
dispose
0:00:03.513916016 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31;44m GST_REFCOUNTING
gstelement.c:3010:gst_element_finalize:<pipeline0>e[00m finalize
0:00:03.514007569 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31;44m GST_REFCOUNTING
gstelement.c:3021:gst_element_finalize:<pipeline0>e[00m finalize
parent
0:00:03.514099121 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31m GST_INIT gst.c:1010:gst_deinit:e[00m
deinitializing GStreamer
0:00:03.538970948 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m
e[00;01;31m GST_INIT gst.c:1113:gst_deinit:e[00m
deinitialized GStreamer

Thanks,

Joel

Joel_A_Fernandes · July 27, 2011, 2:52pm

Sorry for the line wrapping, here’s the unwrapped version:

0:00:00.022735596 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31m GST_INIT gstquery.c:108:_gst_query_initialize:e[00m init queries
0:00:00.030395508 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31m GST_INIT gstmessage.c:73:_gst_message_initialize:e[00m init messages
0:00:00.032104493 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;36m GST_PLUGIN_LOADING gstplugin.c:350:_gst_plugin_initialize:e[00m registering 0 static plugins
0:00:00.033477784 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;36m GST_PLUGIN_LOADING gstplugin.c:255:gst_plugin_register_static:e[00m registered static plugin “staticelements”
0:00:00.033630371 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;36m GST_PLUGIN_LOADING gstplugin.c:257:gst_plugin_register_static:e[00m added static plugin “staticelements”, result: 1
0:00:00.046844483 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00m GST_REGISTRY gstregistry.c:1599:ensure_current_registry:e[00m reading registry cache: /home/root/.gstreamer-0.10/registry.arm.bin
0:00:00.215484619 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00m GST_REGISTRY gstregistrybinary.c:614:gst_registry_binary_read_cache:e[00m loaded /home/root/.gstreamer-0.10/registry.arm.bin in 0.168335 seconds
0:00:00.216064453 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00m GST_REGISTRY gstregistry.c:1469:scan_and_update_registry:e[00m Validating plugins from registry cache: /home/root/.gstreamer-0.10/registry.arm.bin
0:00:00.226867676 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00m GST_REGISTRY gstregistry.c:1561:scan_and_update_registry:e[00m Registry cache has not changed
0:00:00.227020264 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00m GST_REGISTRY gstregistry.c:1628:ensure_current_registry:e[00m registry reading and updating done, result = 1
0:00:00.227111817 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31m GST_INIT gst.c:792:init_post:e[00m GLib runtime version: 2.28.5
0:00:00.227172852 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31m GST_INIT gst.c:794:init_post:e[00m GLib headers version: 2.26.1
0:00:00.227447510 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;37;41m GST_PIPELINE gstparse.c:299:gst_parse_launch_full:e[00m parsing pipeline description 'v4l2src device=/dev/video2 ! video/x-raw-yuv,format=(fourcc)UYVY ! TIVidenc1 codecName=mpeg4enc engineName=codecServer ’
0:00:00.275970459 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;36m GST_PLUGIN_LOADING gstplugin.c:859:gst_plugin_load_file:e[00m plugin “/usr/lib/gstreamer-0.10/libgstvideo4linux2.so” loaded
0:00:00.276184082 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;37;41m GST_ELEMENT_FACTORY gstelementfactory.c:371:gst_element_factory_create:e[00m creating element “v4l2src”
0:00:00.280395508 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;37;41m GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:GstBaseSrc@0x1e08050e[00m adding pad ‘src’
0:00:00.292816162 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;36m GST_PLUGIN_LOADING gstplugin.c:859:gst_plugin_load_file:e[00m plugin “/usr/lib/gstreamer-0.10/libgstticodecplugin.so” loaded
0:00:00.293029785 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;37;41m GST_ELEMENT_FACTORY gstelementfactory.c:371:gst_element_factory_create:e[00m creating element “TIVidenc1”
0:00:00.296356202 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;37;41m GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:GstTIVidenc1@0x1e0d038e[00m adding pad ‘sink’
0:00:00.296569825 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;37;41m GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:GstTIVidenc1@0x1e0d038e[00m adding pad ‘src’
0:00:00.297058106 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;37;41m GST_ELEMENT_FACTORY gstelementfactory.c:371:gst_element_factory_create:e[00m creating element “pipeline”
0:00:00.297821045 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;37;41m GST_PIPELINE ./grammar.y:568:gst_parse_perform_link:e[00m linking v4l2src0:(any) to tividenc10:(any) (0/0) with caps “video/x-raw-yuv, format=(fourcc)UYVY”
0:00:00.303680420 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;36m GST_PLUGIN_LOADING gstplugin.c:859:gst_plugin_load_file:e[00m plugin “/usr/lib/gstreamer-0.10/libgstcoreelements.so” loaded
0:00:00.303894043 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;37;41m GST_ELEMENT_FACTORY gstelementfactory.c:371:gst_element_factory_create:e[00m creating element “capsfilter”
0:00:00.304870606 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;37;41m GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:GstBaseTransform@0x1e12040e[00m adding pad ‘sink’
0:00:00.305206299 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;37;41m GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:GstBaseTransform@0x1e12040e[00m adding pad ‘src’
0:00:00.305450440 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31m GST_STATES gstbin.c:1759:gst_bin_get_state_func:e[00m getting state
0:00:00.305725098 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31m GST_STATES gstelement.c:2341:gst_element_continue_state:e[00m completed state change to NULL
0:00:00.305969239 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;37;41m GST_ELEMENT_PADS gstutils.c:1568:gst_element_link_pads_full:e[00m trying to link element v4l2src0:(any) to element capsfilter0:sink
0:00:00.306091309 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;37;41m GST_ELEMENT_PADS gstelement.c:963:gst_element_get_static_pad:e[00m found pad capsfilter0:sink
0:00:00.306182862 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31;41m GST_PADS gstutils.c:1468:prepare_link_maybe_ghosting:e[00m v4l2src0 and capsfilter0 in same bin, no need for ghost pads
0:00:00.306427002 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31;41m GST_PADS gstpad.c:1941:gst_pad_link_prepare:e[00m trying to link v4l2src0:src and capsfilter0:sink
0:00:00.307220459 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31;41m GST_PADS gstpad.c:2124:gst_pad_link_full:e[00m linked v4l2src0:src and capsfilter0:sink, successful
0:00:00.307464600 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;37;41m GST_ELEMENT_PADS gstutils.c:1568:gst_element_link_pads_full:e[00m trying to link element capsfilter0:src to element tividenc10:(any)
0:00:00.307586670 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;37;41m GST_ELEMENT_PADS gstelement.c:963:gst_element_get_static_pad:e[00m found pad capsfilter0:src
0:00:00.307678223 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31;41m GST_PADS gstutils.c:1028:gst_pad_check_link:e[00m trying to link capsfilter0:src and tividenc10:sink
0:00:00.309783936 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31;41m GST_PADS gstutils.c:1468:prepare_link_maybe_ghosting:e[00m capsfilter0 and tividenc10 in same bin, no need for ghost pads
0:00:00.309997559 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31;41m GST_PADS gstpad.c:1941:gst_pad_link_prepare:e[00m trying to link capsfilter0:src and tividenc10:sink
0:00:00.312103272 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31;41m GST_PADS gstpad.c:2124:gst_pad_link_full:e[00m linked capsfilter0:src and tividenc10:sink, successful
Setting pipeline to PAUSED …
0:00:00.320373536 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31m GST_STATES gstelement.c:2341:gst_element_continue_state:e[00m completed state change to READY
0:00:00.320526124 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31m GST_STATES gstelement.c:2354:gst_element_continue_state:e[00m posting state-changed NULL to READY
0:00:00.320831299 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31m GST_STATES gstbin.c:2492:gst_bin_change_state_func:e[00m child ‘tividenc10’ changed state to 2(READY) successfully
0:00:00.321044922 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31m GST_STATES gstelement.c:2341:gst_element_continue_state:e[00m completed state change to READY
0:00:00.321136475 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31m GST_STATES gstelement.c:2354:gst_element_continue_state:e[00m posting state-changed NULL to READY
0:00:00.321258545 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31m GST_STATES gstbin.c:2492:gst_bin_change_state_func:e[00m child ‘capsfilter0’ changed state to 2(READY) successfully
0:00:02.452545167 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00m v4l2 v4l2_calls.c:480:gst_v4l2_open:e[00m Opened device ‘OMAP3 ISP CCDC output’ (/dev/video2) successfully
0:00:02.452972413 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31m GST_STATES gstelement.c:2341:gst_element_continue_state:e[00m completed state change to READY
0:00:02.453094483 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31m GST_STATES gstelement.c:2354:gst_element_continue_state:e[00m posting state-changed NULL to READY
0:00:02.453277588 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31m GST_STATES gstbin.c:2492:gst_bin_change_state_func:e[00m child ‘v4l2src0’ changed state to 2(READY) successfully
0:00:02.453430176 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31m GST_STATES gstelement.c:2314:gst_element_continue_state:e[00m committing state from NULL to READY, pending PAUSED, next PAUSED
0:00:02.453857422 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31m GST_STATES gstelement.c:2323:gst_element_continue_state:e[00m continue state change READY to PAUSED, final PAUSED
0:00:02.454162598 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31m GST_STATES gstelement.c:2341:gst_element_continue_state:e[00m completed state change to PAUSED
0:00:02.454284668 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31m GST_STATES gstelement.c:2354:gst_element_continue_state:e[00m posting state-changed READY to PAUSED
0:00:02.454437256 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31m GST_STATES gstbin.c:2492:gst_bin_change_state_func:e[00m child ‘tividenc10’ changed state to 3(PAUSED) successfully
0:00:02.454589844 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31m GST_STATES gstelement.c:2341:gst_element_continue_state:e[00m completed state change to PAUSED
0:00:02.454681397 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31m GST_STATES gstelement.c:2354:gst_element_continue_state:e[00m posting state-changed READY to PAUSED
0:00:02.454803467 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31m GST_STATES gstbin.c:2492:gst_bin_change_state_func:e[00m child ‘capsfilter0’ changed state to 3(PAUSED) successfully
0:00:02.455017090 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00m v4l2 gstv4l2object.c:1032:gst_v4l2_object_fill_format_list:e[00m got 4 format(s):
0:00:02.455108643 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00m v4l2 gstv4l2object.c:1038:gst_v4l2_object_fill_format_list:e[00m YU12 (emulated)
0:00:02.455169678 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00m v4l2 gstv4l2object.c:1038:gst_v4l2_object_fill_format_list:e[00m YV12 (emulated)
0:00:02.455261231 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00m v4l2 gstv4l2object.c:1038:gst_v4l2_object_fill_format_list:e[00m BGR3 (emulated)
0:00:02.455322266 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00m v4l2 gstv4l2object.c:1038:gst_v4l2_object_fill_format_list:e[00m RGB3 (emulated)
0:00:03.491699219 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00m v4l2src gstv4l2src.c:607:gst_v4l2src_get_caps:e[00m probed caps: video/x-raw-yuv, format=(fourcc)I420, framerate=(fraction)[ 0/1, 100/1 ], width=(int)320, height=(int)240, interlaced=(boolean)false; video/x-raw-yuv, format=(fourcc)YV12, framerate=(fraction)[ 0/1, 100/1 ], width=(int)320, height=(int)240, interlaced=(boolean)false; video/x-raw-rgb, bpp=(int)24, depth=(int)24, red_mask=(int)255, green_mask=(int)65280, blue_mask=(int)16711680, endianness=(int)4321, framerate=(fraction)[ 0/1, 100/1 ], width=(int)320, height=(int)240, interlaced=(boolean)false; video/x-raw-rgb, bpp=(int)24, depth=(int)24, red_mask=(int)16711680, green_mask=(int)65280, blue_mask=(int)255, endianness=(int)4321, framerate=(fraction)[ 0/1, 100/1 ], width=(int)320, height=(int)240, interlaced=(boolean)false
0:00:03.493011475 e[331m 792e[00m 0x1cca050 e[33;01mWARN e[00m e[00m basesrc gstbasesrc.c:2778:gst_base_src_start:e[00m error: Could not negotiate format
0:00:03.493164063 e[331m 792e[00m 0x1cca050 e[33;01mWARN e[00m e[00m basesrc gstbasesrc.c:2778:gst_base_src_start:e[00m error: Check your filtered caps, if any
0:00:03.493347168 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31;47m GST_ERROR_SYSTEM gstelement.c:1865:gst_element_message_full:e[00m posting message: Could not negotiate format
0:00:03.493560791 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31;47m GST_ERROR_SYSTEM gstelement.c:1888:gst_element_message_full:e[00m posted error message: Could not negotiate format
0:00:03.493652344 e[331m 792e[00m 0x1cca050 e[33;01mWARN e[00m e[00m basesrc gstbasesrc.c:2974:gst_base_src_activate_push:e[00m Failed to start in push mode
0:00:03.493743897 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31;41m GST_PADS gstpad.c:983:gst_pad_activate_push:v4l2src0:srce[00m failed to activate in push mode
0:00:03.493835450 e[331m 792e[00m 0x1cca050 e[33;01mWARN e[00m e[00;01;31;41m GST_PADS gstpad.c:734:gst_pad_set_active:v4l2src0:srce[00m Failed to activate pad
0:00:03.493957520 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31m GST_STATES gstelement.c:2658:gst_element_change_state:e[00m have FAILURE change_state return
0:00:03.494049073 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31m GST_STATES gstelement.c:2235:gst_element_abort_state:e[00m aborting state from READY to PAUSED
0:00:03.494110108 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31m GST_STATES gstbin.c:2508:gst_bin_change_state_func:e[00m child ‘v4l2src0’ failed to go to state 3(PAUSED)
0:00:03.494232178 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31m GST_STATES gstelement.c:2658:gst_element_change_state:e[00m have FAILURE change_state return
ERROR: Pipeline doesn’t want to pause.
ERROR: from element /GstPipeline:pipeline0/GstV4l2Src:v4l2src0: Could not negotiate format
Additional debug info:
gstbasesrc.c(2778): gst_base_src_start (): /GstPipeline:pipeline0/GstV4l2Src:v4l2src0:
Check your filtered caps, if any
Setting pipeline to NULL …
0:00:03.496612549 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31m GST_STATES gstelement.c:2314:gst_element_continue_state:e[00m committing state from PAUSED to READY, pending NULL, next NULL
0:00:03.496795655 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31m GST_STATES gstelement.c:2323:gst_element_continue_state:e[00m continue state change READY to NULL, final NULL
0:00:03.496948242 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31m GST_STATES gstelement.c:2341:gst_element_continue_state:e[00m completed state change to NULL
0:00:03.497039795 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31m GST_STATES gstelement.c:2354:gst_element_continue_state:e[00m posting state-changed READY to NULL
0:00:03.497161865 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31m GST_STATES gstbin.c:2492:gst_bin_change_state_func:e[00m child ‘tividenc10’ changed state to 1(NULL) successfully
0:00:03.497406006 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31m GST_STATES gstelement.c:2314:gst_element_continue_state:e[00m committing state from PAUSED to READY, pending NULL, next NULL
0:00:03.497589112 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31m GST_STATES gstelement.c:2323:gst_element_continue_state:e[00m continue state change READY to NULL, final NULL
0:00:03.497711182 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31m GST_STATES gstelement.c:2341:gst_element_continue_state:e[00m completed state change to NULL
0:00:03.497802735 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31m GST_STATES gstelement.c:2354:gst_element_continue_state:e[00m posting state-changed READY to NULL
0:00:03.497924805 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31m GST_STATES gstbin.c:2492:gst_bin_change_state_func:e[00m child ‘capsfilter0’ changed state to 1(NULL) successfully
0:00:03.509460450 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31m GST_STATES gstelement.c:2341:gst_element_continue_state:e[00m completed state change to NULL
0:00:03.509613037 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31m GST_STATES gstelement.c:2354:gst_element_continue_state:e[00m posting state-changed READY to NULL
0:00:03.509796143 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31m GST_STATES gstbin.c:2492:gst_bin_change_state_func:e[00m child ‘v4l2src0’ changed state to 1(NULL) successfully
0:00:03.510040284 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31m GST_STATES gstelement.c:2341:gst_element_continue_state:e[00m completed state change to NULL
0:00:03.510131836 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31m GST_STATES gstelement.c:2354:gst_element_continue_state:e[00m posting state-changed READY to NULL
0:00:03.510284424 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31m GST_STATES gstbin.c:1759:gst_bin_get_state_func:e[00m getting state
Freeing pipeline …
0:00:03.510528565 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;37;41m GST_ELEMENT_PADS gstpad.c:1713:gst_pad_unlink:e[00m unlinking capsfilter0:src(0x1e0a328) and tividenc10:sink(0x1e0a0d0)
0:00:03.510711670 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;37;41m GST_ELEMENT_PADS gstpad.c:1758:gst_pad_unlink:e[00m unlinked capsfilter0:src and tividenc10:sink
0:00:03.510894776 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;37;41m GST_ELEMENT_PADS gstpad.c:1713:gst_pad_unlink:e[00m unlinking v4l2src0:src(0x1e0a008) and capsfilter0:sink(0x1e0a260)
0:00:03.511016846 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;37;41m GST_ELEMENT_PADS gstpad.c:1758:gst_pad_unlink:e[00m unlinked v4l2src0:src and capsfilter0:sink
0:00:03.511169434 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;37;41m GST_PARENTAGE gstbin.c:1440:gst_bin_remove_func:e[00m removed child “capsfilter0”
0:00:03.511352539 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31;44m GST_REFCOUNTING gstelement.c:2955:gst_element_dispose:e[00m dispose
0:00:03.511444092 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;37;41m GST_ELEMENT_PADS gstelement.c:835:gst_element_remove_pad:e[00m removing pad ‘src’
0:00:03.511627198 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;37;41m GST_ELEMENT_PADS gstelement.c:835:gst_element_remove_pad:e[00m removing pad ‘sink’
0:00:03.511779785 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31;44m GST_REFCOUNTING gstelement.c:2979:gst_element_dispose:e[00m parent class dispose
0:00:03.511871338 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31;44m GST_REFCOUNTING gstelement.c:3010:gst_element_finalize:e[00m finalize
0:00:03.511993408 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31;44m GST_REFCOUNTING gstelement.c:3021:gst_element_finalize:e[00m finalize parent
0:00:03.512115479 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;37;41m GST_PARENTAGE gstbin.c:1440:gst_bin_remove_func:e[00m removed child “tividenc10”
0:00:03.512268067 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31;44m GST_REFCOUNTING gstelement.c:2955:gst_element_dispose:e[00m dispose
0:00:03.512329102 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;37;41m GST_ELEMENT_PADS gstelement.c:835:gst_element_remove_pad:e[00m removing pad ‘src’
0:00:03.512481690 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;37;41m GST_ELEMENT_PADS gstelement.c:835:gst_element_remove_pad:e[00m removing pad ‘sink’
0:00:03.512634278 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31;44m GST_REFCOUNTING gstelement.c:2979:gst_element_dispose:e[00m parent class dispose
0:00:03.512725830 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31;44m GST_REFCOUNTING gstelement.c:3010:gst_element_finalize:e[00m finalize
0:00:03.512817383 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31;44m GST_REFCOUNTING gstelement.c:3021:gst_element_finalize:e[00m finalize parent
0:00:03.512939453 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;37;41m GST_PARENTAGE gstbin.c:1440:gst_bin_remove_func:e[00m removed child “v4l2src0”
0:00:03.513061524 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31;44m GST_REFCOUNTING gstelement.c:2955:gst_element_dispose:e[00m dispose
0:00:03.513183594 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;37;41m GST_ELEMENT_PADS gstelement.c:835:gst_element_remove_pad:e[00m removing pad ‘src’
0:00:03.513305664 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31;44m GST_REFCOUNTING gstelement.c:2979:gst_element_dispose:e[00m parent class dispose
0:00:03.513488770 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31;44m GST_REFCOUNTING gstelement.c:3010:gst_element_finalize:e[00m finalize
0:00:03.513610840 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31;44m GST_REFCOUNTING gstelement.c:3021:gst_element_finalize:e[00m finalize parent
0:00:03.513702393 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31;44m GST_REFCOUNTING gstelement.c:2955:gst_element_dispose:e[00m dispose
0:00:03.513824463 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31;44m GST_REFCOUNTING gstelement.c:2979:gst_element_dispose:e[00m parent class dispose
0:00:03.513916016 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31;44m GST_REFCOUNTING gstelement.c:3010:gst_element_finalize:e[00m finalize
0:00:03.514007569 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31;44m GST_REFCOUNTING gstelement.c:3021:gst_element_finalize:e[00m finalize parent
0:00:03.514099121 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31m GST_INIT gst.c:1010:gst_deinit:e[00m deinitializing GStreamer
0:00:03.538970948 e[331m 792e[00m 0x1cca050 e[32;01mINFO e[00m e[00;01;31m GST_INIT gst.c:1113:gst_deinit:e[00m deinitialized GStreamer

Thanks,
Joel

Vladimir_Pantelic · July 27, 2011, 4:06pm

Joel A Fernandes wrote:

    With this I get the following:

    root@beagleboard:~# gst-launch -v v4l2src device=/dev/video2 !
    'video/x-raw-yuv,format=(fourcc)UYVY' ! TIVidenc1 codecName=mpeg4enc
    engineName=codecServer

    Setting pipeline to PAUSED ...
    ERROR: Pipeline doesn't want to pause.
    ERROR: from element /GstPipeline:pipeline0/GstV4l2Src:v4l2src0: Could
    not negotiate format
    Additional debug info:
    gstbasesrc.c(2778): gst_base_src_start ():
    /GstPipeline:pipeline0/GstV4l2Src:v4l2src0:
    Check your filtered caps, if any
    Setting pipeline to NULL ...Freeing pipeline ...

    I can see a lot of ioctl(9, VIDIOC_TRY_FMT, 0xbee3d104) = 0 in
    strace which I'm guess is gstreaming trying different formats.

    Here is the complete --gst-debug=3 output:

Sorry for the line wrapping, here's the unwrapped version:

is there also one without the ESCAPE codes?

Andrey_Nechypurenko · July 27, 2011, 5:00pm

Here is a list of src capabilities for v4l2src I obtained from
gst-inspect:
  video/x\-raw\-yuv
             format: UYVY
              width: \[ 1, 32768 \]
             height: \[ 1, 32768 \]
          framerate: \[ 0/1, 100/1 \]
So, 'YUYV' does not appear in this list. Any suggestions?

UYVY?

UYVY is the only format supported by TIVidenc1 on BB. It seams like
your camera supports this format. In this case I would suggest to
specify more information explicitly for the caps filter. Something
along this line: v4l2src always-copy=FALSE !
video/x-raw-yuv,width=320,height=240,format=(fourcc)UYVY ! TIVidenc1
... Please note that width and height are also provided in addition to
the color space format.

You can also take a look on some other pipelines here:
https://www.gitorious.org/veter/veter/blobs/master/misc/car.config#line56
. Just search for TIVidenc1 there.

HTH,
Andrey.

Joel_A_Fernandes · July 28, 2011, 12:08am

Hi Andrey,

Thanks for your suggestions.

Here is a list of src capabilities for v4l2src I obtained from
gst-inspect:
  video/x\-raw\-yuv
             format: UYVY
              width: \[ 1, 32768 \]
             height: \[ 1, 32768 \]
          framerate: \[ 0/1, 100/1 \]
So, 'YUYV' does not appear in this list. Any suggestions?

UYVY?
UYVY is the only format supported by TIVidenc1 on BB. It seams like
your camera supports this format. In this case I would suggest to
specify more information explicitly for the caps filter. Something
along this line: v4l2src always-copy=FALSE !
video/x-raw-yuv,width=320,height=240,format=(fourcc)UYVY ! TIVidenc1
... Please note that width and height are also provided in addition to
the color space format.

Even with the additional caps filter, I get a "could not negotiate
format" error. It seems that v4l2src enumerates over a set of formats
with ISP and gives up. The sensor driver code doesn't execute AFAIK at
this stage yet.

Here is a list of IOCTLs that Gstreamer calls on the video node.

ioctl(9, VIDIOC_QUERYCAP or VT_OPENQRY, 0xbe8e0328) = 0
ioctl(9, VIDIOC_G_FMT or VT_SENDSIG, 0xbe8e025c) = 0
ioctl(9, VIDIOC_ENUM_FMT or VT_SETMODE, 0xbe8e015c) = -1 EINVAL
(Invalid argument)
ioctl(9, VIDIOC_QUERYCAP or VT_OPENQRY, 0xbe8e01c8) = 0
ioctl(9, VIDIOC_G_INPUT, 0xbe8dfae8) = 0
ioctl(9, VIDIOC_ENUMINPUT, 0xbe8dfae8) = 0
ioctl(9, VIDIOC_QUERYCTRL, 0xbe8dfb5c) = -1 EINVAL (Invalid argument)
ioctl(9, VIDIOC_QUERYCTRL, 0xbe8dfb5c) = -1 EINVAL (Invalid argument)
ioctl(9, VIDIOC_QUERYCTRL, 0xbe8dfb5c) = -1 EINVAL (Invalid argument)
ioctl(9, VIDIOC_QUERYCTRL, 0xbe8dfb5c) = -1 EINVAL (Invalid argument)
ioctl(9, VIDIOC_QUERYCTRL, 0xbe8dfb5c) = -1 EINVAL (Invalid argument)
ioctl(9, VIDIOC_QUERYCAP or VT_OPENQRY, 0xbe8dfba0) = 0
ioctl(9, VIDIOC_QUERYCAP or VT_OPENQRY, 0x75b94) = 0
ioctl(9, VIDIOC_ENUMINPUT, 0xbe8e0498) = 0

It seems that, no where does it call VIDIOC_S_FMT to set the format, I
would expect it to do so as I've specified the format in the caps
filter element. As you can see, ENUM_FMT is not implemented by the ISP
driver and so it fails and soon after I see these IOCTLs, before
Gstreamer throws a "Could not negotiate format":

ioctl(9, VIDIOC_QUERYCTRL, 0xbe8e0534) = -1 EINVAL (Invalid argument)
ioctl(9, VIDIOC_QUERYCTRL, 0xbe8e0534) = -1 EINVAL (Invalid argument)
ioctl(9, VIDIOC_G_STD, 0xbe8e0580) = -1 EINVAL (Invalid argument)
ioctl(9, VIDIOC_G_INPUT, 0xbe8e0564) = 0
ioctl(9, VIDIOC_TRY_FMT, 0xbe8e00f4) = 0
ioctl(9, VIDIOC_TRY_FMT, 0xbe8e00f4) = 0
ioctl(9, VIDIOC_TRY_FMT, 0xbe8e00f4) = 0
ioctl(9, VIDIOC_TRY_FMT, 0xbe8e00f4) = 0
ioctl(9, VIDIOC_TRY_FMT, 0xbe8e00f4) = 0
ioctl(9, VIDIOC_TRY_FMT, 0xbe8e00f4) = 0
ioctl(9, VIDIOC_TRY_FMT, 0xbe8e00f4) = 0
ioctl(9, VIDIOC_TRY_FMT, 0xbe8e00f4) = 0

I saw atleast 1 patch that tried to define ENUM_FMT for isp but was
not accepted [1]

A look at the Gstreamer v4l2src sources show that S_FMT IOCTL would be
called from gst_v4l2src_set_caps, but Gstreamer debug logs don't show
this being called.

My Gstreamer command line looks like:
gst-launch -v v4l2src device=/dev/video2 !
'video/x-raw-yuv,width=640,height=480,format=(fourcc)UYVY' ! TIVidenc1
codecName=mpeg4enc engineName=codecServer ! filesink
location=output.m4v

Here's the complete debug(=3) log, I've also pasted the logs at [2]
incase its not very readable here. Thanks for any suggestions.

0:00:00.022033691 898 0x324050 INFO GST_INIT
gstquery.c:108:_gst_query_initialize: init queries
0:00:00.029510498 898 0x324050 INFO GST_INIT
gstmessage.c:73:_gst_message_initialize: init messages
0:00:00.031219482 898 0x324050 INFO GST_PLUGIN_LOADING
gstplugin.c:350:_gst_plugin_initialize: registering 0 static plugins
0:00:00.032623291 898 0x324050 INFO GST_PLUGIN_LOADING
gstplugin.c:255:gst_plugin_register_static: registered static plugin
"staticelements"
0:00:00.032745361 898 0x324050 INFO GST_PLUGIN_LOADING
gstplugin.c:257:gst_plugin_register_static: added static plugin
"staticelements", result: 1
0:00:00.056152343 898 0x324050 INFO GST_REGISTRY
gstregistry.c:1599:ensure_current_registry: reading registry cache:
/home/root/.gstreamer-0.10/registry.arm.bin
0:00:00.226959228 898 0x324050 INFO GST_REGISTRY
gstregistrybinary.c:614:gst_registry_binary_read_cache: loaded
/home/root/.gstreamer-0.10/registry.arm.bin in 0.170380 seconds
0:00:00.227569580 898 0x324050 INFO GST_REGISTRY
gstregistry.c:1469:scan_and_update_registry: Validating plugins from
registry cache: /home/root/.gstreamer-0.10/registry.arm.bin
0:00:00.405212402 898 0x324050 INFO GST_REGISTRY
gstregistry.c:1561:scan_and_update_registry: Registry cache has not
changed
0:00:00.405395507 898 0x324050 INFO GST_REGISTRY
gstregistry.c:1628:ensure_current_registry: registry reading and
updating done, result = 1
0:00:00.405456543 898 0x324050 INFO GST_INIT
gst.c:792:init_post: GLib runtime version: 2.28.5
0:00:00.405517578 898 0x324050 INFO GST_INIT
gst.c:794:init_post: GLib headers version: 2.26.1
0:00:00.405792236 898 0x324050 INFO GST_PIPELINE
gstparse.c:299:gst_parse_launch_full: parsing pipeline description
'v4l2src device=/dev/video2 ! video/x-raw-yuv,format=(fourcc)UYVY !
TIVidenc1 codecName=mpeg4enc engineName=codecServer ! filesink
location=output.m4v '
0:00:00.482940673 898 0x324050 INFO GST_PLUGIN_LOADING
gstplugin.c:859:gst_plugin_load_file: plugin
"/usr/lib/gstreamer-0.10/libgstvideo4linux2.so" loaded
0:00:00.483123779 898 0x324050 INFO GST_ELEMENT_FACTORY
gstelementfactory.c:371:gst_element_factory_create: creating element
"v4l2src"
0:00:00.487335205 898 0x324050 INFO GST_ELEMENT_PADS
gstelement.c:716:gst_element_add_pad:<GstBaseSrc@0x462050> adding pad
'src'
CMEM Error: init: Failed to open /dev/cmem: 'No such file or directory'
0:00:00.502593994 898 0x324050 INFO GST_PLUGIN_LOADING
gstplugin.c:859:gst_plugin_load_file: plugin
"/usr/lib/gstreamer-0.10/libgstticodecplugin.so" loaded
0:00:00.502746582 898 0x324050 INFO GST_ELEMENT_FACTORY
gstelementfactory.c:371:gst_element_factory_create: creating element
"TIVidenc1"
0:00:00.505645752 898 0x324050 INFO GST_ELEMENT_PADS
gstelement.c:716:gst_element_add_pad:<GstTIVidenc1@0x467038> adding
pad 'sink'
0:00:00.505828857 898 0x324050 INFO GST_ELEMENT_PADS
gstelement.c:716:gst_element_add_pad:<GstTIVidenc1@0x467038> adding
pad 'src'
0:00:00.512603759 898 0x324050 INFO GST_PLUGIN_LOADING
gstplugin.c:859:gst_plugin_load_file: plugin
"/usr/lib/gstreamer-0.10/libgstcoreelements.so" loaded
0:00:00.512786865 898 0x324050 INFO GST_ELEMENT_FACTORY
gstelementfactory.c:371:gst_element_factory_create: creating element
"filesink"
0:00:00.514221191 898 0x324050 INFO GST_ELEMENT_PADS
gstelement.c:716:gst_element_add_pad:<GstBaseSink@0x46c008> adding pad
'sink'
0:00:00.514801025 898 0x324050 INFO GST_ELEMENT_FACTORY
gstelementfactory.c:371:gst_element_factory_create: creating element
"pipeline"
0:00:00.515625000 898 0x324050 INFO GST_PIPELINE
./grammar.y:568:gst_parse_perform_link: linking v4l2src0:(any) to
tividenc10:(any) (0/0) with caps "video/x-raw-yuv,
format=(fourcc)UYVY"
0:00:00.515899658 898 0x324050 INFO GST_ELEMENT_FACTORY
gstelementfactory.c:371:gst_element_factory_create: creating element
"capsfilter"
0:00:00.516876220 898 0x324050 INFO GST_ELEMENT_PADS
gstelement.c:716:gst_element_add_pad:<GstBaseTransform@0x470078>
adding pad 'sink'
0:00:00.517242431 898 0x324050 INFO GST_ELEMENT_PADS
gstelement.c:716:gst_element_add_pad:<GstBaseTransform@0x470078>
adding pad 'src'
0:00:00.517639160 898 0x324050 INFO GST_STATES
gstbin.c:1759:gst_bin_get_state_func:<pipeline0> getting state
0:00:00.517883301 898 0x324050 INFO GST_STATES
gstelement.c:2341:gst_element_continue_state:<capsfilter0> completed
state change to NULL
0:00:00.518096924 898 0x324050 INFO GST_ELEMENT_PADS
gstutils.c:1568:gst_element_link_pads_full: trying to link element
v4l2src0:(any) to element capsfilter0:sink
0:00:00.518188476 898 0x324050 INFO GST_ELEMENT_PADS
gstelement.c:963:gst_element_get_static_pad: found pad
capsfilter0:sink
0:00:00.518280029 898 0x324050 INFO GST_PADS
gstutils.c:1468:prepare_link_maybe_ghosting: v4l2src0 and capsfilter0
in same bin, no need for ghost pads
0:00:00.518493652 898 0x324050 INFO GST_PADS
gstpad.c:1941:gst_pad_link_prepare: trying to link v4l2src0:src and
capsfilter0:sink
0:00:00.519256592 898 0x324050 INFO GST_PADS
gstpad.c:2124:gst_pad_link_full: linked v4l2src0:src and
capsfilter0:sink, successful
0:00:00.519470215 898 0x324050 INFO GST_ELEMENT_PADS
gstutils.c:1568:gst_element_link_pads_full: trying to link element
capsfilter0:src to element tividenc10:(any)
0:00:00.519561767 898 0x324050 INFO GST_ELEMENT_PADS
gstelement.c:963:gst_element_get_static_pad: found pad capsfilter0:src
0:00:00.519622802 898 0x324050 INFO GST_PADS
gstutils.c:1028:gst_pad_check_link: trying to link capsfilter0:src and
tividenc10:sink
0:00:00.521728515 898 0x324050 INFO GST_PADS
gstutils.c:1468:prepare_link_maybe_ghosting: capsfilter0 and
tividenc10 in same bin, no need for ghost pads
0:00:00.521911621 898 0x324050 INFO GST_PADS
gstpad.c:1941:gst_pad_link_prepare: trying to link capsfilter0:src and
tividenc10:sink
0:00:00.523834228 898 0x324050 INFO GST_PADS
gstpad.c:2124:gst_pad_link_full: linked capsfilter0:src and
tividenc10:sink, successful
0:00:00.524078369 898 0x324050 INFO GST_PIPELINE
./grammar.y:568:gst_parse_perform_link: linking tividenc10:(any) to
filesink0:(any) (0/0) with caps "(NULL)"
0:00:00.524169921 898 0x324050 INFO GST_ELEMENT_PADS
gstutils.c:1568:gst_element_link_pads_full: trying to link element
tividenc10:(any) to element filesink0:(any)
0:00:00.524261474 898 0x324050 INFO GST_PADS
gstutils.c:1028:gst_pad_check_link: trying to link tividenc10:src and
filesink0:sink
0:00:00.524353027 898 0x324050 INFO GST_PADS
gstutils.c:1468:prepare_link_maybe_ghosting: tividenc10 and filesink0
in same bin, no need for ghost pads
0:00:00.524475097 898 0x324050 INFO GST_PADS
gstpad.c:1941:gst_pad_link_prepare: trying to link tividenc10:src and
filesink0:sink
0:00:00.524566650 898 0x324050 INFO GST_PADS
gstpad.c:2124:gst_pad_link_full: linked tividenc10:src and
filesink0:sink, successful
Setting pipeline to PAUSED ...
0:00:00.608276368 898 0x324050 INFO GST_STATES
gstelement.c:2341:gst_element_continue_state:<filesink0> completed
state change to READY
0:00:00.608428956 898 0x324050 INFO GST_STATES
gstelement.c:2354:gst_element_continue_state:<filesink0> posting
state-changed NULL to READY
0:00:00.608764649 898 0x324050 INFO GST_STATES
gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'filesink0'
changed state to 2(READY) successfully
0:00:00.608917237 898 0x324050 INFO GST_STATES
gstelement.c:2341:gst_element_continue_state:<tividenc10> completed
state change to READY
0:00:00.609008790 898 0x324050 INFO GST_STATES
gstelement.c:2354:gst_element_continue_state:<tividenc10> posting
state-changed NULL to READY
0:00:00.609130860 898 0x324050 INFO GST_STATES
gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'tividenc10'
changed state to 2(READY) successfully
0:00:00.609283448 898 0x324050 INFO GST_STATES
gstelement.c:2341:gst_element_continue_state:<capsfilter0> completed
state change to READY
0:00:00.609344483 898 0x324050 INFO GST_STATES
gstelement.c:2354:gst_element_continue_state:<capsfilter0> posting
state-changed NULL to READY
0:00:00.609466553 898 0x324050 INFO GST_STATES
gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child
'capsfilter0' changed state to 2(READY) successfully
0:00:01.583831788 898 0x324050 INFO v4l2
v4l2_calls.c:480:gst_v4l2_open:<v4l2src0> Opened device 'OMAP3 ISP
CCDC output' (/dev/video2) successfully
0:00:01.584228516 898 0x324050 INFO GST_STATES
gstelement.c:2341:gst_element_continue_state:<v4l2src0> completed
state change to READY
0:00:01.584320069 898 0x324050 INFO GST_STATES
gstelement.c:2354:gst_element_continue_state:<v4l2src0> posting
state-changed NULL to READY
0:00:01.584503174 898 0x324050 INFO GST_STATES
gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'v4l2src0'
changed state to 2(READY) successfully
0:00:01.584625245 898 0x324050 INFO GST_STATES
gstelement.c:2314:gst_element_continue_state:<pipeline0> committing
state from NULL to READY, pending PAUSED, next PAUSED
0:00:01.586975098 898 0x324050 INFO GST_STATES
gstelement.c:2323:gst_element_continue_state:<pipeline0> continue
state change READY to PAUSED, final PAUSED
0:00:01.587432862 898 0x324050 INFO GST_STATES
gstbin.c:2498:gst_bin_change_state_func:<pipeline0> child 'filesink0'
is changing state asynchronously to PAUSED
0:00:01.587646485 898 0x324050 INFO GST_STATES
gstelement.c:2341:gst_element_continue_state:<tividenc10> completed
state change to PAUSED
0:00:01.587860108 898 0x324050 INFO GST_STATES
gstelement.c:2354:gst_element_continue_state:<tividenc10> posting
state-changed READY to PAUSED
0:00:01.587982178 898 0x324050 INFO GST_STATES
gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'tividenc10'
changed state to 3(PAUSED) successfully
0:00:01.588134766 898 0x324050 INFO GST_STATES
gstelement.c:2341:gst_element_continue_state:<capsfilter0> completed
state change to PAUSED
0:00:01.588226319 898 0x324050 INFO GST_STATES
gstelement.c:2354:gst_element_continue_state:<capsfilter0> posting
state-changed READY to PAUSED
0:00:01.588317872 898 0x324050 INFO GST_STATES
gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child
'capsfilter0' changed state to 3(PAUSED) successfully
0:00:01.588531495 898 0x324050 INFO v4l2
gstv4l2object.c:1032:gst_v4l2_object_fill_format_list:<v4l2src0> got 4
format(s):
0:00:01.588623047 898 0x324050 INFO v4l2
gstv4l2object.c:1038:gst_v4l2_object_fill_format_list:<v4l2src0>
YU12 (emulated)
0:00:01.588684083 898 0x324050 INFO v4l2
gstv4l2object.c:1038:gst_v4l2_object_fill_format_list:<v4l2src0>
YV12 (emulated)
0:00:01.588745118 898 0x324050 INFO v4l2
gstv4l2object.c:1038:gst_v4l2_object_fill_format_list:<v4l2src0>
BGR3 (emulated)
0:00:01.588806153 898 0x324050 INFO v4l2
gstv4l2object.c:1038:gst_v4l2_object_fill_format_list:<v4l2src0>
RGB3 (emulated)
0:00:05.126037598 898 0x324050 INFO v4l2src
gstv4l2src.c:607:gst_v4l2src_get_caps:<v4l2src0> probed caps:
video/x-raw-yuv, format=(fourcc)I420, framerate=(fraction)[ 0/1, 100/1
], width=(int)640, height=(int)480, interlaced=(boolean)false;
video/x-raw-yuv, format=(fourcc)YV12, framerate=(fraction)[ 0/1, 100/1
], width=(int)640, height=(int)480, interlaced=(boolean)false;
video/x-raw-rgb, bpp=(int)24, depth=(int)24, red_mask=(int)255,
green_mask=(int)65280, blue_mask=(int)16711680, endianness=(int)4321,
framerate=(fraction)[ 0/1, 100/1 ], width=(int)640, height=(int)480,
interlaced=(boolean)false; video/x-raw-rgb, bpp=(int)24,
depth=(int)24, red_mask=(int)16711680, green_mask=(int)65280,
blue_mask=(int)255, endianness=(int)4321, framerate=(fraction)[ 0/1,
100/1 ], width=(int)640, height=(int)480, interlaced=(boolean)false
0:00:05.127746583 898 0x324050 WARN basesrc
gstbasesrc.c:2778:gst_base_src_start:<v4l2src0> error: Could not
negotiate format
0:00:05.127899170 898 0x324050 WARN basesrc
gstbasesrc.c:2778:gst_base_src_start:<v4l2src0> error: Check your
filtered caps, if any
0:00:05.128082276 898 0x324050 INFO GST_ERROR_SYSTEM
gstelement.c:1865:gst_element_message_full:<v4l2src0> posting message:
Could not negotiate format
0:00:05.128234864 898 0x324050 INFO GST_ERROR_SYSTEM
gstelement.c:1888:gst_element_message_full:<v4l2src0> posted error
message: Could not negotiate format
0:00:05.128326417 898 0x324050 WARN basesrc
gstbasesrc.c:2974:gst_base_src_activate_push:<v4l2src0> Failed to
start in push mode
0:00:05.128387452 898 0x324050 INFO GST_PADS
gstpad.c:983:gst_pad_activate_push:<v4l2src0:src> failed to activate
in push mode
0:00:05.128479004 898 0x324050 WARN GST_PADS
gstpad.c:734:gst_pad_set_active:<v4l2src0:src> Failed to activate pad
0:00:05.128570557 898 0x324050 INFO GST_STATES
gstelement.c:2658:gst_element_change_state:<v4l2src0> have FAILURE
change_state return
0:00:05.128631592 898 0x324050 INFO GST_STATES
gstelement.c:2235:gst_element_abort_state:<v4l2src0> aborting state
from READY to PAUSED
0:00:05.128692627 898 0x324050 INFO GST_STATES
gstbin.c:2508:gst_bin_change_state_func:<pipeline0> child 'v4l2src0'
failed to go to state 3(PAUSED)
0:00:05.128784180 898 0x324050 INFO GST_STATES
gstelement.c:2658:gst_element_change_state:<pipeline0> have FAILURE
change_state return
ERROR: Pipeline doesn't want to pause.
ERROR: from element /GstPipeline:pipeline0/GstV4l2Src:v4l2src0: Could
not negotiate format
Additional debug info:
gstbasesrc.c(2778): gst_base_src_start ():
/GstPipeline:pipeline0/GstV4l2Src:v4l2src0:
Check your filtered caps, if any
Setting pipeline to NULL ...
0:00:05.131439209 898 0x324050 INFO GST_STATES
gstelement.c:2314:gst_element_continue_state:<filesink0> committing
state from READY to READY, pending NULL, next NULL
0:00:05.131591797 898 0x324050 INFO GST_STATES
gstelement.c:2323:gst_element_continue_state:<filesink0> continue
state change READY to NULL, final NULL
0:00:05.133789063 898 0x324050 INFO GST_STATES
gstelement.c:2341:gst_element_continue_state:<filesink0> completed
state change to NULL
0:00:05.133941650 898 0x324050 INFO GST_STATES
gstelement.c:2354:gst_element_continue_state:<filesink0> posting
state-changed READY to NULL
0:00:05.134124756 898 0x324050 INFO GST_STATES
gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'filesink0'
changed state to 1(NULL) successfully
0:00:05.134368897 898 0x324050 INFO GST_STATES
gstelement.c:2314:gst_element_continue_state:<tividenc10> committing
state from PAUSED to READY, pending NULL, next NULL
0:00:05.134521484 898 0x324050 INFO GST_STATES
gstelement.c:2323:gst_element_continue_state:<tividenc10> continue
state change READY to NULL, final NULL
0:00:05.134735108 898 0x324050 INFO GST_STATES
gstelement.c:2341:gst_element_continue_state:<tividenc10> completed
state change to NULL
0:00:05.134796143 898 0x324050 INFO GST_STATES
gstelement.c:2354:gst_element_continue_state:<tividenc10> posting
state-changed READY to NULL
0:00:05.134918214 898 0x324050 INFO GST_STATES
gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'tividenc10'
changed state to 1(NULL) successfully
0:00:05.135101319 898 0x324050 INFO GST_STATES
gstelement.c:2314:gst_element_continue_state:<capsfilter0> committing
state from PAUSED to READY, pending NULL, next NULL
0:00:05.135284424 898 0x324050 INFO GST_STATES
gstelement.c:2323:gst_element_continue_state:<capsfilter0> continue
state change READY to NULL, final NULL
0:00:05.135375977 898 0x324050 INFO GST_STATES
gstelement.c:2341:gst_element_continue_state:<capsfilter0> completed
state change to NULL
0:00:05.135437012 898 0x324050 INFO GST_STATES
gstelement.c:2354:gst_element_continue_state:<capsfilter0> posting
state-changed READY to NULL
0:00:05.135528565 898 0x324050 INFO GST_STATES
gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child
'capsfilter0' changed state to 1(NULL) successfully
0:00:05.140869141 898 0x324050 INFO GST_STATES
gstelement.c:2341:gst_element_continue_state:<v4l2src0> completed
state change to NULL
0:00:05.141021729 898 0x324050 INFO GST_STATES
gstelement.c:2354:gst_element_continue_state:<v4l2src0> posting
state-changed READY to NULL
0:00:05.141174317 898 0x324050 INFO GST_STATES
gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'v4l2src0'
changed state to 1(NULL) successfully
0:00:05.141448975 898 0x324050 INFO GST_STATES
gstelement.c:2341:gst_element_continue_state:<pipeline0> completed
state change to NULL
0:00:05.141510010 898 0x324050 INFO GST_STATES
gstelement.c:2354:gst_element_continue_state:<pipeline0> posting
state-changed READY to NULL
0:00:05.141662598 898 0x324050 INFO GST_STATES
gstbin.c:1759:gst_bin_get_state_func:<pipeline0> getting state
Freeing pipeline ...
0:00:05.141906738 898 0x324050 INFO GST_ELEMENT_PADS
gstpad.c:1713:gst_pad_unlink: unlinking capsfilter0:src(0x4643f0) and
tividenc10:sink(0x4640d0)
0:00:05.142120361 898 0x324050 INFO GST_ELEMENT_PADS
gstpad.c:1758:gst_pad_unlink: unlinked capsfilter0:src and
tividenc10:sink
0:00:05.144714356 898 0x324050 INFO GST_ELEMENT_PADS
gstpad.c:1713:gst_pad_unlink: unlinking v4l2src0:src(0x464008) and
capsfilter0:sink(0x464328)
0:00:05.144958497 898 0x324050 INFO GST_ELEMENT_PADS
gstpad.c:1758:gst_pad_unlink: unlinked v4l2src0:src and
capsfilter0:sink
0:00:05.145141602 898 0x324050 INFO GST_PARENTAGE
gstbin.c:1440:gst_bin_remove_func:<pipeline0> removed child
"capsfilter0"
0:00:05.145294190 898 0x324050 INFO GST_REFCOUNTING
gstelement.c:2955:gst_element_dispose:<capsfilter0> dispose
0:00:05.145355225 898 0x324050 INFO GST_ELEMENT_PADS
gstelement.c:835:gst_element_remove_pad:<capsfilter0> removing pad
'src'
0:00:05.145568848 898 0x324050 INFO GST_ELEMENT_PADS
gstelement.c:835:gst_element_remove_pad:<capsfilter0> removing pad
'sink'
0:00:05.145690918 898 0x324050 INFO GST_REFCOUNTING
gstelement.c:2979:gst_element_dispose:<capsfilter0> parent class
dispose
0:00:05.145751953 898 0x324050 INFO GST_REFCOUNTING
gstelement.c:3010:gst_element_finalize:<capsfilter0> finalize
0:00:05.145812989 898 0x324050 INFO GST_REFCOUNTING
gstelement.c:3021:gst_element_finalize:<capsfilter0> finalize parent
0:00:05.145904541 898 0x324050 INFO GST_ELEMENT_PADS
gstpad.c:1713:gst_pad_unlink: unlinking tividenc10:src(0x464198) and
filesink0:sink(0x464260)
0:00:05.146057129 898 0x324050 INFO GST_ELEMENT_PADS
gstpad.c:1758:gst_pad_unlink: unlinked tividenc10:src and
filesink0:sink
0:00:05.146209717 898 0x324050 INFO GST_PARENTAGE
gstbin.c:1440:gst_bin_remove_func:<pipeline0> removed child
"filesink0"
0:00:05.146331787 898 0x324050 INFO GST_REFCOUNTING
gstelement.c:2955:gst_element_dispose:<filesink0> dispose
0:00:05.146392823 898 0x324050 INFO GST_ELEMENT_PADS
gstelement.c:835:gst_element_remove_pad:<filesink0> removing pad
'sink'
0:00:05.146484375 898 0x324050 INFO GST_REFCOUNTING
gstelement.c:2979:gst_element_dispose:<filesink0> parent class dispose
0:00:05.146575928 898 0x324050 INFO GST_REFCOUNTING
gstelement.c:3010:gst_element_finalize:<filesink0> finalize
0:00:05.146667481 898 0x324050 INFO GST_REFCOUNTING
gstelement.c:3021:gst_element_finalize:<filesink0> finalize parent
0:00:05.146789551 898 0x324050 INFO GST_PARENTAGE
gstbin.c:1440:gst_bin_remove_func:<pipeline0> removed child
"tividenc10"
0:00:05.146881104 898 0x324050 INFO GST_REFCOUNTING
gstelement.c:2955:gst_element_dispose:<tividenc10> dispose
0:00:05.146942139 898 0x324050 INFO GST_ELEMENT_PADS
gstelement.c:835:gst_element_remove_pad:<tividenc10> removing pad
'src'
0:00:05.147064209 898 0x324050 INFO GST_ELEMENT_PADS
gstelement.c:835:gst_element_remove_pad:<tividenc10> removing pad
'sink'
0:00:05.147216797 898 0x324050 INFO GST_REFCOUNTING
gstelement.c:2979:gst_element_dispose:<tividenc10> parent class
dispose
0:00:05.147277832 898 0x324050 INFO GST_REFCOUNTING
gstelement.c:3010:gst_element_finalize:<tividenc10> finalize
0:00:05.147338867 898 0x324050 INFO GST_REFCOUNTING
gstelement.c:3021:gst_element_finalize:<tividenc10> finalize parent
0:00:05.147430420 898 0x324050 INFO GST_PARENTAGE
gstbin.c:1440:gst_bin_remove_func:<pipeline0> removed child "v4l2src0"
0:00:05.147552490 898 0x324050 INFO GST_REFCOUNTING
gstelement.c:2955:gst_element_dispose:<v4l2src0> dispose
0:00:05.147613526 898 0x324050 INFO GST_ELEMENT_PADS
gstelement.c:835:gst_element_remove_pad:<v4l2src0> removing pad 'src'
0:00:05.147705078 898 0x324050 INFO GST_REFCOUNTING
gstelement.c:2979:gst_element_dispose:<v4l2src0> parent class dispose
0:00:05.147888184 898 0x324050 INFO GST_REFCOUNTING
gstelement.c:3010:gst_element_finalize:<v4l2src0> finalize
0:00:05.147949219 898 0x324050 INFO GST_REFCOUNTING
gstelement.c:3021:gst_element_finalize:<v4l2src0> finalize parent
0:00:05.148040772 898 0x324050 INFO GST_REFCOUNTING
gstelement.c:2955:gst_element_dispose:<pipeline0> dispose
0:00:05.148132324 898 0x324050 INFO GST_REFCOUNTING
gstelement.c:2979:gst_element_dispose:<pipeline0> parent class dispose
0:00:05.148223877 898 0x324050 INFO GST_REFCOUNTING
gstelement.c:3010:gst_element_finalize:<pipeline0> finalize
0:00:05.148284912 898 0x324050 INFO GST_REFCOUNTING
gstelement.c:3021:gst_element_finalize:<pipeline0> finalize parent
0:00:05.148345947 898 0x324050 INFO GST_INIT
gst.c:1010:gst_deinit: deinitializing GStreamer
0:00:05.173309326 898 0x324050 INFO GST_INIT
gst.c:1113:gst_deinit: deinitialized GStreamer

Thanks,
Joel

[1] [PATCH] omap3isp: implement ENUM_FMT
[2] http://pastebin.com/raw.php?i=wGMKQc15