Getting Each h264 Frame

Tue Jan 28 15:50:00 PST 2014

Thanks for the help so far!

OS is Gentoo on kernel 3.10.17.  GStreamer version is 0.10.36.

Here's the output from additional logging:

$ GST_DEBUG=filesrc:4,filesink:4,h264parse:4 gst-launch-0.10 -v filesrc
location=in.h264 ! h264parse ! filesink location=out.h264
0:00:00.027504440 [332m 2785[00m       0x92a930 [32;01mINFO   [00m
[00m             filesrc gstfilesrc.c:374:gst_file_src_set_location:[00m
filename : in.h264
0:00:00.027580219 [332m 2785[00m       0x92a930 [32;01mINFO   [00m
[00m             filesrc gstfilesrc.c:375:gst_file_src_set_location:[00m
uri      : file:///home/tmurray/vid_notes/in.h264
0:00:00.028748686 [332m 2785[00m       0x92a930 [32;01mINFO   [00m
[00m            filesink
gstfilesink.c:301:gst_file_sink_set_location:[00m filename : out.h264
0:00:00.028763353 [332m 2785[00m       0x92a930 [32;01mINFO   [00m
[00m            filesink
gstfilesink.c:302:gst_file_sink_set_location:[00m uri      :
file:///home/tmurray/vid_notes/out.h264
Setting pipeline to PAUSED ...
0:00:00.029182339 [332m 2785[00m       0x92a930 [36mDEBUG  [00m
[00m            filesink
gstfilesink.c:517:gst_file_sink_do_seek:<filesink0>[00m Seeking to offset
0 using fseeko
0:00:00.029202873 [332m 2785[00m       0x92a930 [36mDEBUG  [00m
[00m            filesink
gstfilesink.c:419:gst_file_sink_open_file:<filesink0>[00m opened file
out.h264, seekable 1
0:00:00.029662926 [332m 2785[00m       0x92a930 [32;01mINFO   [00m
[00m             filesrc
gstfilesrc.c:969:gst_file_src_start:<filesrc0>[00m opening file in.h264
0:00:00.029696660 [332m 2785[00m       0x92a930 [32;01mINFO   [00m
[00m             filesrc
gstfilesrc.c:969:gst_file_src_start:<filesrc0>[00m opening file in.h264
0:00:00.029720127 [332m 2785[00m       0x92a930 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:230:gst_h264_parse_start:<h264parse0>[00m start
0:00:00.029733327 [332m 2785[00m       0x92a930 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:177:gst_h264_parse_reset_frame:<h264parse0>[00m reset frame
Pipeline is PREROLLING ...
0:00:00.030621656 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:337:gst_h264_parse_negotiate:<h264parse0>[00m allowed caps:
video/x-h264, parsed=(boolean)true, stream-format=(string){ avc,
byte-stream }, alignment=(string){ au, nal }
0:00:00.030730680 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:345:gst_h264_parse_negotiate:<h264parse0>[00m negotiating
with caps: video/x-h264, parsed=(boolean)true, stream-format=(string){ avc,
byte-stream }, alignment=(string){ au, nal }
0:00:00.030801570 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:294:gst_h264_parse_format_from_caps:[00m parsing caps:
video/x-h264, parsed=(boolean)true, stream-format=(string)avc,
alignment=(string)au
0:00:00.030837260 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:372:gst_h264_parse_negotiate:<h264parse0>[00m selected
format avc, alignment au
0:00:00.030857794 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:177:gst_h264_parse_reset_frame:<h264parse0>[00m reset frame
0:00:00.030878327 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:689:gst_h264_parse_check_valid_frame:<h264parse0>[00m last
parse position 0
0:00:00.030908150 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:726:gst_h264_parse_check_valid_frame:<h264parse0>[00m
complete nal (offset, size): (4, 10)
0:00:00.030946284 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:778:gst_h264_parse_check_valid_frame:<h264parse0>[00m
0x7f8774002800 complete nal found. Off: 4, Size: 10
0:00:00.030970240 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:461:gst_h264_parse_process_nal:<h264parse0>[00m processing
nal of type 7, size 10
0:00:00.031039664 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:467:gst_h264_parse_process_nal:<h264parse0>[00m triggering
src caps check
0:00:00.031058731 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:414:gst_h264_parser_store_nal:<h264parse0>[00m storing sps 0
0:00:00.031097843 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:385:gst_h264_parse_wrap_nal:<h264parse0>[00m nal length 10
0:00:00.031120332 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:606:gst_h264_parse_collect_nal:<h264parse0>[00m parsing
collected nal
0:00:00.031139888 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:814:gst_h264_parse_check_valid_frame:<h264parse0>[00m
Looking for more
0:00:00.031158466 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:726:gst_h264_parse_check_valid_frame:<h264parse0>[00m
complete nal (offset, size): (18, 6)
0:00:00.031177044 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:778:gst_h264_parse_check_valid_frame:<h264parse0>[00m
0x7f8774002800 complete nal found. Off: 18, Size: 6
0:00:00.031196600 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:461:gst_h264_parse_process_nal:<h264parse0>[00m processing
nal of type 8, size 6
0:00:00.031225934 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:484:gst_h264_parse_process_nal:<h264parse0>[00m triggering
src caps check
0:00:00.031244512 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:418:gst_h264_parser_store_nal:<h264parse0>[00m storing pps 0
0:00:00.031264557 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:385:gst_h264_parse_wrap_nal:<h264parse0>[00m nal length 6
0:00:00.031285580 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:606:gst_h264_parse_collect_nal:<h264parse0>[00m parsing
collected nal
0:00:00.031364781 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:814:gst_h264_parse_check_valid_frame:<h264parse0>[00m
Looking for more
0:00:00.031447894 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:726:gst_h264_parse_check_valid_frame:<h264parse0>[00m
complete nal (offset, size): (28, 12229)
0:00:00.031466472 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:778:gst_h264_parse_check_valid_frame:<h264parse0>[00m
0x7f8774002800 complete nal found. Off: 28, Size: 12229
0:00:00.031486028 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:461:gst_h264_parse_process_nal:<h264parse0>[00m processing
nal of type 5, size 12229
0:00:00.031505095 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:540:gst_h264_parse_process_nal:<h264parse0>[00m
first_mb_in_slice = 0
0:00:00.031522695 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:543:gst_h264_parse_process_nal:<h264parse0>[00m frame
start: 1
0:00:00.031549096 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:553:gst_h264_parse_process_nal:<h264parse0>[00m parse
result 0, first MB: 0, slice type: 2
0:00:00.031571585 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:570:gst_h264_parse_process_nal:<h264parse0>[00m marking IDR
in frame at offset 24
0:00:00.031589674 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:385:gst_h264_parse_wrap_nal:<h264parse0>[00m nal length
12229
0:00:00.031626831 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:606:gst_h264_parse_collect_nal:<h264parse0>[00m parsing
collected nal
0:00:00.031728033 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:1031:gst_h264_parse_update_src_caps:<h264parse0>[00m sps:
0x7f877d504010
0:00:00.031749055 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:874:gst_h264_parse_make_codec_data:<h264parse0>[00m
constructing codec_data: num_sps=1, num_pps=1
0:00:00.031780834 [332m 2785[00m       0x7b2630 [32;01mINFO   [00m
[00m           h264parse
gsth264parse.c:1056:gst_h264_parse_update_src_caps:<h264parse0>[00m
resolution changed 640x360
/GstPipeline:pipeline0/GstH264Parse:h264parse0.GstPad:src: caps =
video/x-h264, width=(int)640, height=(int)360, parsed=(boolean)true,
stream-format=(string)avc, alignment=(string)au,
codec_data=(buffer)0142801effe1000a6742801e8b680a02f79501000668ce01a87720
0:00:00.032037994 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:1172:gst_h264_parse_get_timestamp:<h264parse0>[00m unable
to compute timestamp: timing info not present
0:00:00.032147507 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:177:gst_h264_parse_reset_frame:<h264parse0>[00m reset frame
/GstPipeline:pipeline0/GstFileSink:filesink0.GstPad:sink: caps =
video/x-h264, width=(int)640, height=(int)360, parsed=(boolean)true,
stream-format=(string)avc, alignment=(string)au,
codec_data=(buffer)0142801effe1000a6742801e8b680a02f79501000668ce01a87720
0:00:00.032394890 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m            filesink
gstfilesink.c:589:gst_file_sink_event:<filesink0>[00m Ignored NEWSEGMENT
event of format 3 (time)
Pipeline is PREROLLED ...
Setting pipeline to PLAYING ...
0:00:00.032940500 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m            filesink
gstfilesink.c:656:gst_file_sink_render:<filesink0>[00m writing 12257 bytes
at 0
New clock: GstSystemClock
0:00:00.033078859 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:177:gst_h264_parse_reset_frame:<h264parse0>[00m reset frame
0:00:00.033102815 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:689:gst_h264_parse_check_valid_frame:<h264parse0>[00m last
parse position 0
0:00:00.033133126 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:726:gst_h264_parse_check_valid_frame:<h264parse0>[00m
complete nal (offset, size): (4, 2594)
0:00:00.033152682 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:778:gst_h264_parse_check_valid_frame:<h264parse0>[00m
0x7f8774002800 complete nal found. Off: 4, Size: 2594
0:00:00.033174194 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:461:gst_h264_parse_process_nal:<h264parse0>[00m processing
nal of type 1, size 2594
0:00:00.033193750 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:540:gst_h264_parse_process_nal:<h264parse0>[00m
first_mb_in_slice = 0
0:00:00.033211839 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:543:gst_h264_parse_process_nal:<h264parse0>[00m frame
start: 1
0:00:00.033235306 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:553:gst_h264_parse_process_nal:<h264parse0>[00m parse
result 0, first MB: 0, slice type: 0
0:00:00.033254862 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:385:gst_h264_parse_wrap_nal:<h264parse0>[00m nal length 2594
0:00:00.033280285 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:606:gst_h264_parse_collect_nal:<h264parse0>[00m parsing
collected nal
0:00:00.033311085 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:1172:gst_h264_parse_get_timestamp:<h264parse0>[00m unable
to compute timestamp: timing info not present
0:00:00.033338464 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:177:gst_h264_parse_reset_frame:<h264parse0>[00m reset frame
0:00:00.033366820 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m            filesink
gstfilesink.c:656:gst_file_sink_render:<filesink0>[00m writing 2598 bytes
at 12257
0:00:00.033460199 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:177:gst_h264_parse_reset_frame:<h264parse0>[00m reset frame
0:00:00.033488066 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:689:gst_h264_parse_check_valid_frame:<h264parse0>[00m last
parse position 0
0:00:00.033514467 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:726:gst_h264_parse_check_valid_frame:<h264parse0>[00m
complete nal (offset, size): (4, 2330)
0:00:00.033536956 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:778:gst_h264_parse_check_valid_frame:<h264parse0>[00m
0x7f8774002800 complete nal found. Off: 4, Size: 2330
0:00:00.033556512 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:461:gst_h264_parse_process_nal:<h264parse0>[00m processing
nal of type 1, size 2330
0:00:00.033575090 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:540:gst_h264_parse_process_nal:<h264parse0>[00m
first_mb_in_slice = 0
0:00:00.033592691 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:543:gst_h264_parse_process_nal:<h264parse0>[00m frame
start: 1
0:00:00.033612735 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:553:gst_h264_parse_process_nal:<h264parse0>[00m parse
result 0, first MB: 0, slice type: 0
0:00:00.033631803 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:385:gst_h264_parse_wrap_nal:<h264parse0>[00m nal length 2330
0:00:00.033654781 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:606:gst_h264_parse_collect_nal:<h264parse0>[00m parsing
collected nal
0:00:00.033692426 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:1172:gst_h264_parse_get_timestamp:<h264parse0>[00m unable
to compute timestamp: timing info not present
0:00:00.033714426 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:177:gst_h264_parse_reset_frame:<h264parse0>[00m reset frame
0:00:00.033737893 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m            filesink
gstfilesink.c:656:gst_file_sink_render:<filesink0>[00m writing 2334 bytes
at 14855
0:00:00.033813184 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:177:gst_h264_parse_reset_frame:<h264parse0>[00m reset frame
0:00:00.033831762 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:689:gst_h264_parse_check_valid_frame:<h264parse0>[00m last
parse position 0
0:00:00.033866474 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:726:gst_h264_parse_check_valid_frame:<h264parse0>[00m
complete nal (offset, size): (4, 5462)
0:00:00.033885052 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:778:gst_h264_parse_check_valid_frame:<h264parse0>[00m
0x7f8774002800 complete nal found. Off: 4, Size: 5462
0:00:00.033904608 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:461:gst_h264_parse_process_nal:<h264parse0>[00m processing
nal of type 1, size 5462
0:00:00.033945675 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:540:gst_h264_parse_process_nal:<h264parse0>[00m
first_mb_in_slice = 0
0:00:00.033963276 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:543:gst_h264_parse_process_nal:<h264parse0>[00m frame
start: 1
0:00:00.033983320 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:553:gst_h264_parse_process_nal:<h264parse0>[00m parse
result 0, first MB: 0, slice type: 0
0:00:00.034005810 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:385:gst_h264_parse_wrap_nal:<h264parse0>[00m nal length 5462
0:00:00.034038077 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:606:gst_h264_parse_collect_nal:<h264parse0>[00m parsing
collected nal
0:00:00.034066922 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:1172:gst_h264_parse_get_timestamp:<h264parse0>[00m unable
to compute timestamp: timing info not present
0:00:00.034088434 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:177:gst_h264_parse_reset_frame:<h264parse0>[00m reset frame
0:00:00.034111901 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m            filesink
gstfilesink.c:656:gst_file_sink_render:<filesink0>[00m writing 5466 bytes
at 17189
0:00:00.034208702 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:177:gst_h264_parse_reset_frame:<h264parse0>[00m reset frame
0:00:00.034228258 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:689:gst_h264_parse_check_valid_frame:<h264parse0>[00m last
parse position 0
0:00:00.034251726 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:726:gst_h264_parse_check_valid_frame:<h264parse0>[00m
complete nal (offset, size): (4, 1441)
0:00:00.034269815 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:778:gst_h264_parse_check_valid_frame:<h264parse0>[00m
0x7f8774002800 complete nal found. Off: 4, Size: 1441
0:00:00.034289371 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:461:gst_h264_parse_process_nal:<h264parse0>[00m processing
nal of type 1, size 1441
0:00:00.034307460 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:540:gst_h264_parse_process_nal:<h264parse0>[00m
first_mb_in_slice = 0
0:00:00.034325549 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:543:gst_h264_parse_process_nal:<h264parse0>[00m frame
start: 1
0:00:00.034345105 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:553:gst_h264_parse_process_nal:<h264parse0>[00m parse
result 0, first MB: 0, slice type: 0
0:00:00.034363683 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:385:gst_h264_parse_wrap_nal:<h264parse0>[00m nal length 1441
0:00:00.034386661 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:606:gst_h264_parse_collect_nal:<h264parse0>[00m parsing
collected nal
0:00:00.034416484 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:1172:gst_h264_parse_get_timestamp:<h264parse0>[00m unable
to compute timestamp: timing info not present
0:00:00.034437507 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:177:gst_h264_parse_reset_frame:<h264parse0>[00m reset frame
0:00:00.034461463 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m            filesink
gstfilesink.c:656:gst_file_sink_render:<filesink0>[00m writing 1445 bytes
at 22655
0:00:00.034541153 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:177:gst_h264_parse_reset_frame:<h264parse0>[00m reset frame
0:00:00.034559243 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:689:gst_h264_parse_check_valid_frame:<h264parse0>[00m last
parse position 0
0:00:00.034586621 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:726:gst_h264_parse_check_valid_frame:<h264parse0>[00m
complete nal (offset, size): (4, 2732)
0:00:00.034605199 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:778:gst_h264_parse_check_valid_frame:<h264parse0>[00m
0x7f8774002800 complete nal found. Off: 4, Size: 2732
0:00:00.034624266 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:461:gst_h264_parse_process_nal:<h264parse0>[00m processing
nal of type 1, size 2732
0:00:00.034651644 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:540:gst_h264_parse_process_nal:<h264parse0>[00m
first_mb_in_slice = 0
0:00:00.034669734 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:543:gst_h264_parse_process_nal:<h264parse0>[00m frame
start: 1
0:00:00.034689778 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:553:gst_h264_parse_process_nal:<h264parse0>[00m parse
result 0, first MB: 0, slice type: 0
0:00:00.034708357 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:385:gst_h264_parse_wrap_nal:<h264parse0>[00m nal length 2732
0:00:00.034731335 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:606:gst_h264_parse_collect_nal:<h264parse0>[00m parsing
collected nal
0:00:00.034761158 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:1172:gst_h264_parse_get_timestamp:<h264parse0>[00m unable
to compute timestamp: timing info not present
0:00:00.034782669 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:177:gst_h264_parse_reset_frame:<h264parse0>[00m reset frame
0:00:00.034806136 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m            filesink
gstfilesink.c:656:gst_file_sink_render:<filesink0>[00m writing 2736 bytes
at 24100
0:00:00.034874582 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:177:gst_h264_parse_reset_frame:<h264parse0>[00m reset frame
0:00:00.034893160 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:689:gst_h264_parse_check_valid_frame:<h264parse0>[00m last
parse position 0
0:00:00.034967962 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:726:gst_h264_parse_check_valid_frame:<h264parse0>[00m
complete nal (offset, size): (4, 2915)
0:00:00.034987517 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:778:gst_h264_parse_check_valid_frame:<h264parse0>[00m
0x7f8774002800 complete nal found. Off: 4, Size: 2915
0:00:00.035009029 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:461:gst_h264_parse_process_nal:<h264parse0>[00m processing
nal of type 1, size 2915
0:00:00.035028096 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:540:gst_h264_parse_process_nal:<h264parse0>[00m
first_mb_in_slice = 0
0:00:00.035045696 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:543:gst_h264_parse_process_nal:<h264parse0>[00m frame
start: 1
0:00:00.035065741 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:553:gst_h264_parse_process_nal:<h264parse0>[00m parse
result 0, first MB: 0, slice type: 0
0:00:00.035084808 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:385:gst_h264_parse_wrap_nal:<h264parse0>[00m nal length 2915
0:00:00.035107298 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:606:gst_h264_parse_collect_nal:<h264parse0>[00m parsing
collected nal
0:00:00.035139565 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:1172:gst_h264_parse_get_timestamp:<h264parse0>[00m unable
to compute timestamp: timing info not present
0:00:00.035161076 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:177:gst_h264_parse_reset_frame:<h264parse0>[00m reset frame
0:00:00.035185521 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m            filesink
gstfilesink.c:656:gst_file_sink_render:<filesink0>[00m writing 2919 bytes
at 26836
0:00:00.035279879 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:177:gst_h264_parse_reset_frame:<h264parse0>[00m reset frame
0:00:00.035306768 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:689:gst_h264_parse_check_valid_frame:<h264parse0>[00m last
parse position 0
0:00:00.035336591 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:726:gst_h264_parse_check_valid_frame:<h264parse0>[00m
complete nal (offset, size): (4, 3456)
0:00:00.035355658 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:778:gst_h264_parse_check_valid_frame:<h264parse0>[00m
0x7f8774002800 complete nal found. Off: 4, Size: 3456
0:00:00.035375214 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:461:gst_h264_parse_process_nal:<h264parse0>[00m processing
nal of type 1, size 3456
0:00:00.035393792 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:540:gst_h264_parse_process_nal:<h264parse0>[00m
first_mb_in_slice = 0
0:00:00.035411881 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:543:gst_h264_parse_process_nal:<h264parse0>[00m frame
start: 1
0:00:00.035431926 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:553:gst_h264_parse_process_nal:<h264parse0>[00m parse
result 0, first MB: 0, slice type: 0
0:00:00.035451482 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:385:gst_h264_parse_wrap_nal:<h264parse0>[00m nal length 3456
0:00:00.035474460 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:606:gst_h264_parse_collect_nal:<h264parse0>[00m parsing
collected nal
0:00:00.035505750 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:1172:gst_h264_parse_get_timestamp:<h264parse0>[00m unable
to compute timestamp: timing info not present
0:00:00.035527261 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:177:gst_h264_parse_reset_frame:<h264parse0>[00m reset frame
0:00:00.035550728 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m            filesink
gstfilesink.c:656:gst_file_sink_render:<filesink0>[00m writing 3460 bytes
at 29755
0:00:00.035619174 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:177:gst_h264_parse_reset_frame:<h264parse0>[00m reset frame
0:00:00.035638241 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:689:gst_h264_parse_check_valid_frame:<h264parse0>[00m last
parse position 0
0:00:00.035666597 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:726:gst_h264_parse_check_valid_frame:<h264parse0>[00m
complete nal (offset, size): (4, 3306)
0:00:00.035685175 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:778:gst_h264_parse_check_valid_frame:<h264parse0>[00m
0x7f8774002800 complete nal found. Off: 4, Size: 3306
0:00:00.035704242 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:461:gst_h264_parse_process_nal:<h264parse0>[00m processing
nal of type 1, size 3306
0:00:00.035722821 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:540:gst_h264_parse_process_nal:<h264parse0>[00m
first_mb_in_slice = 0
0:00:00.035740421 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:543:gst_h264_parse_process_nal:<h264parse0>[00m frame
start: 1
0:00:00.035759977 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:553:gst_h264_parse_process_nal:<h264parse0>[00m parse
result 0, first MB: 0, slice type: 0
0:00:00.035778555 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:385:gst_h264_parse_wrap_nal:<h264parse0>[00m nal length 3306
0:00:00.035801044 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:606:gst_h264_parse_collect_nal:<h264parse0>[00m parsing
collected nal
0:00:00.035869490 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:1172:gst_h264_parse_get_timestamp:<h264parse0>[00m unable
to compute timestamp: timing info not present
0:00:00.035891490 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:177:gst_h264_parse_reset_frame:<h264parse0>[00m reset frame
0:00:00.035940869 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m            filesink
gstfilesink.c:656:gst_file_sink_render:<filesink0>[00m writing 3310 bytes
at 33215
0:00:00.036023493 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:177:gst_h264_parse_reset_frame:<h264parse0>[00m reset frame
0:00:00.036044027 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:689:gst_h264_parse_check_valid_frame:<h264parse0>[00m last
parse position 0
0:00:00.036072383 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:726:gst_h264_parse_check_valid_frame:<h264parse0>[00m
complete nal (offset, size): (4, 3262)
0:00:00.036090961 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:778:gst_h264_parse_check_valid_frame:<h264parse0>[00m
0x7f8774002800 complete nal found. Off: 4, Size: 3262
0:00:00.036110028 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:461:gst_h264_parse_process_nal:<h264parse0>[00m processing
nal of type 1, size 3262
0:00:00.036128606 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:540:gst_h264_parse_process_nal:<h264parse0>[00m
first_mb_in_slice = 0
0:00:00.036146206 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:543:gst_h264_parse_process_nal:<h264parse0>[00m frame
start: 1
0:00:00.036165762 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:553:gst_h264_parse_process_nal:<h264parse0>[00m parse
result 0, first MB: 0, slice type: 0
0:00:00.036184341 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:385:gst_h264_parse_wrap_nal:<h264parse0>[00m nal length 3262
0:00:00.036206830 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:606:gst_h264_parse_collect_nal:<h264parse0>[00m parsing
collected nal
0:00:00.036237630 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:1172:gst_h264_parse_get_timestamp:<h264parse0>[00m unable
to compute timestamp: timing info not present
0:00:00.036260609 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:177:gst_h264_parse_reset_frame:<h264parse0>[00m reset frame
0:00:00.036284076 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m            filesink
gstfilesink.c:656:gst_file_sink_render:<filesink0>[00m writing 3266 bytes
at 36525
0:00:00.036403856 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:177:gst_h264_parse_reset_frame:<h264parse0>[00m reset frame
0:00:00.036422923 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:689:gst_h264_parse_check_valid_frame:<h264parse0>[00m last
parse position 0
0:00:00.036451279 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:726:gst_h264_parse_check_valid_frame:<h264parse0>[00m
complete nal (offset, size): (4, 3333)
0:00:00.036469368 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:778:gst_h264_parse_check_valid_frame:<h264parse0>[00m
0x7f8774002800 complete nal found. Off: 4, Size: 3333
0:00:00.036488435 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:461:gst_h264_parse_process_nal:<h264parse0>[00m processing
nal of type 1, size 3333
0:00:00.036507013 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:540:gst_h264_parse_process_nal:<h264parse0>[00m
first_mb_in_slice = 0
0:00:00.036533414 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:543:gst_h264_parse_process_nal:<h264parse0>[00m frame
start: 1
0:00:00.036553948 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:553:gst_h264_parse_process_nal:<h264parse0>[00m parse
result 0, first MB: 0, slice type: 0
0:00:00.036573504 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:385:gst_h264_parse_wrap_nal:<h264parse0>[00m nal length 3333
0:00:00.036596482 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:606:gst_h264_parse_collect_nal:<h264parse0>[00m parsing
collected nal
0:00:00.036628749 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:1172:gst_h264_parse_get_timestamp:<h264parse0>[00m unable
to compute timestamp: timing info not present
0:00:00.036650749 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:177:gst_h264_parse_reset_frame:<h264parse0>[00m reset frame
0:00:00.036673728 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m            filesink
gstfilesink.c:656:gst_file_sink_render:<filesink0>[00m writing 3337 bytes
at 39791
0:00:00.036763685 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:177:gst_h264_parse_reset_frame:<h264parse0>[00m reset frame
0:00:00.036782263 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:689:gst_h264_parse_check_valid_frame:<h264parse0>[00m last
parse position 0
0:00:00.036812575 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:726:gst_h264_parse_check_valid_frame:<h264parse0>[00m
complete nal (offset, size): (4, 3824)
0:00:00.036830664 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:778:gst_h264_parse_check_valid_frame:<h264parse0>[00m
0x7f8774002800 complete nal found. Off: 4, Size: 3824
0:00:00.036850220 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:461:gst_h264_parse_process_nal:<h264parse0>[00m processing
nal of type 1, size 3824
0:00:00.036868798 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:540:gst_h264_parse_process_nal:<h264parse0>[00m
first_mb_in_slice = 0
0:00:00.036886887 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:543:gst_h264_parse_process_nal:<h264parse0>[00m frame
start: 1
0:00:00.036910354 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:553:gst_h264_parse_process_nal:<h264parse0>[00m parse
result 0, first MB: 0, slice type: 0
0:00:00.036951911 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:385:gst_h264_parse_wrap_nal:<h264parse0>[00m nal length 3824
0:00:00.036974400 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:606:gst_h264_parse_collect_nal:<h264parse0>[00m parsing
collected nal
0:00:00.037006179 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:1172:gst_h264_parse_get_timestamp:<h264parse0>[00m unable
to compute timestamp: timing info not present
0:00:00.037030623 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:177:gst_h264_parse_reset_frame:<h264parse0>[00m reset frame
0:00:00.037055068 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m            filesink
gstfilesink.c:656:gst_file_sink_render:<filesink0>[00m writing 3828 bytes
at 43128
0:00:00.037167515 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:177:gst_h264_parse_reset_frame:<h264parse0>[00m reset frame
0:00:00.037186093 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:689:gst_h264_parse_check_valid_frame:<h264parse0>[00m last
parse position 0
0:00:00.037223738 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:726:gst_h264_parse_check_valid_frame:<h264parse0>[00m
complete nal (offset, size): (4, 3514)
0:00:00.037242805 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:778:gst_h264_parse_check_valid_frame:<h264parse0>[00m
0x7f8774002800 complete nal found. Off: 4, Size: 3514
0:00:00.037261872 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:461:gst_h264_parse_process_nal:<h264parse0>[00m processing
nal of type 1, size 3514
0:00:00.037280450 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:540:gst_h264_parse_process_nal:<h264parse0>[00m
first_mb_in_slice = 0
0:00:00.037297562 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:543:gst_h264_parse_process_nal:<h264parse0>[00m frame
start: 1
0:00:00.037317607 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:553:gst_h264_parse_process_nal:<h264parse0>[00m parse
result 0, first MB: 0, slice type: 0
0:00:00.037336185 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:385:gst_h264_parse_wrap_nal:<h264parse0>[00m nal length 3514
0:00:00.037358185 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:606:gst_h264_parse_collect_nal:<h264parse0>[00m parsing
collected nal
0:00:00.037390941 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:1172:gst_h264_parse_get_timestamp:<h264parse0>[00m unable
to compute timestamp: timing info not present
0:00:00.037412942 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:177:gst_h264_parse_reset_frame:<h264parse0>[00m reset frame
0:00:00.037436409 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m            filesink
gstfilesink.c:656:gst_file_sink_render:<filesink0>[00m writing 3518 bytes
at 46956
0:00:00.037542500 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:177:gst_h264_parse_reset_frame:<h264parse0>[00m reset frame
0:00:00.037561567 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:689:gst_h264_parse_check_valid_frame:<h264parse0>[00m last
parse position 0
0:00:00.037591390 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:726:gst_h264_parse_check_valid_frame:<h264parse0>[00m
complete nal (offset, size): (4, 3894)
0:00:00.037609968 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:778:gst_h264_parse_check_valid_frame:<h264parse0>[00m
0x7f8774002800 complete nal found. Off: 4, Size: 3894
0:00:00.037629524 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:461:gst_h264_parse_process_nal:<h264parse0>[00m processing
nal of type 1, size 3894
0:00:00.037648102 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:540:gst_h264_parse_process_nal:<h264parse0>[00m
first_mb_in_slice = 0
0:00:00.037665213 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:543:gst_h264_parse_process_nal:<h264parse0>[00m frame
start: 1
0:00:00.037685258 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:553:gst_h264_parse_process_nal:<h264parse0>[00m parse
result 0, first MB: 0, slice type: 0
0:00:00.037704325 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:385:gst_h264_parse_wrap_nal:<h264parse0>[00m nal length 3894
0:00:00.037726326 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:606:gst_h264_parse_collect_nal:<h264parse0>[00m parsing
collected nal
0:00:00.037765438 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:1172:gst_h264_parse_get_timestamp:<h264parse0>[00m unable
to compute timestamp: timing info not present
0:00:00.037787927 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:177:gst_h264_parse_reset_frame:<h264parse0>[00m reset frame
0:00:00.037811394 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m            filesink
gstfilesink.c:656:gst_file_sink_render:<filesink0>[00m writing 3898 bytes
at 50474
0:00:00.037890596 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:177:gst_h264_parse_reset_frame:<h264parse0>[00m reset frame
0:00:00.037933130 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:689:gst_h264_parse_check_valid_frame:<h264parse0>[00m last
parse position 0
0:00:00.037962464 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:726:gst_h264_parse_check_valid_frame:<h264parse0>[00m
complete nal (offset, size): (4, 3414)
0:00:00.037981531 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:778:gst_h264_parse_check_valid_frame:<h264parse0>[00m
0x7f8774002800 complete nal found. Off: 4, Size: 3414
0:00:00.038001575 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:461:gst_h264_parse_process_nal:<h264parse0>[00m processing
nal of type 1, size 3414
0:00:00.038023087 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:540:gst_h264_parse_process_nal:<h264parse0>[00m
first_mb_in_slice = 0
0:00:00.038040687 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:543:gst_h264_parse_process_nal:<h264parse0>[00m frame
start: 1
0:00:00.038060732 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:553:gst_h264_parse_process_nal:<h264parse0>[00m parse
result 0, first MB: 0, slice type: 0
0:00:00.038079310 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:385:gst_h264_parse_wrap_nal:<h264parse0>[00m nal length 3414
0:00:00.038101800 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:606:gst_h264_parse_collect_nal:<h264parse0>[00m parsing
collected nal
0:00:00.038123311 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:1172:gst_h264_parse_get_timestamp:<h264parse0>[00m unable
to compute timestamp: timing info not present
0:00:00.038145312 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:177:gst_h264_parse_reset_frame:<h264parse0>[00m reset frame
0:00:00.038168779 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m            filesink
gstfilesink.c:656:gst_file_sink_render:<filesink0>[00m writing 3418 bytes
at 54372
0:00:00.038274870 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:177:gst_h264_parse_reset_frame:<h264parse0>[00m reset frame
0:00:00.038293448 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:689:gst_h264_parse_check_valid_frame:<h264parse0>[00m last
parse position 0
0:00:00.038313004 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:726:gst_h264_parse_check_valid_frame:<h264parse0>[00m
complete nal (offset, size): (4, 10)
0:00:00.038331582 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:778:gst_h264_parse_check_valid_frame:<h264parse0>[00m
0x7f8774002800 complete nal found. Off: 4, Size: 10
0:00:00.038350649 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:461:gst_h264_parse_process_nal:<h264parse0>[00m processing
nal of type 7, size 10
0:00:00.038374116 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:467:gst_h264_parse_process_nal:<h264parse0>[00m triggering
src caps check
0:00:00.038400516 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:414:gst_h264_parser_store_nal:<h264parse0>[00m storing sps 0
0:00:00.038422028 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:385:gst_h264_parse_wrap_nal:<h264parse0>[00m nal length 10
0:00:00.038442562 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:606:gst_h264_parse_collect_nal:<h264parse0>[00m parsing
collected nal
0:00:00.038461140 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:814:gst_h264_parse_check_valid_frame:<h264parse0>[00m
Looking for more
0:00:00.038479229 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:726:gst_h264_parse_check_valid_frame:<h264parse0>[00m
complete nal (offset, size): (18, 6)
0:00:00.038497807 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:778:gst_h264_parse_check_valid_frame:<h264parse0>[00m
0x7f8774002800 complete nal found. Off: 18, Size: 6
0:00:00.038516874 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:461:gst_h264_parse_process_nal:<h264parse0>[00m processing
nal of type 8, size 6
0:00:00.038539852 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:484:gst_h264_parse_process_nal:<h264parse0>[00m triggering
src caps check
0:00:00.038557453 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:418:gst_h264_parser_store_nal:<h264parse0>[00m storing pps 0
0:00:00.038578475 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:385:gst_h264_parse_wrap_nal:<h264parse0>[00m nal length 6
0:00:00.038599009 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:606:gst_h264_parse_collect_nal:<h264parse0>[00m parsing
collected nal
0:00:00.038674300 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:814:gst_h264_parse_check_valid_frame:<h264parse0>[00m
Looking for more
0:00:00.038754479 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:726:gst_h264_parse_check_valid_frame:<h264parse0>[00m
complete nal (offset, size): (28, 12761)
0:00:00.038773546 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:778:gst_h264_parse_check_valid_frame:<h264parse0>[00m
0x7f8774002800 complete nal found. Off: 28, Size: 12761
0:00:00.038793102 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:461:gst_h264_parse_process_nal:<h264parse0>[00m processing
nal of type 5, size 12761
0:00:00.038811680 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:540:gst_h264_parse_process_nal:<h264parse0>[00m
first_mb_in_slice = 0
0:00:00.038829280 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:543:gst_h264_parse_process_nal:<h264parse0>[00m frame
start: 1
0:00:00.038850303 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:553:gst_h264_parse_process_nal:<h264parse0>[00m parse
result 0, first MB: 0, slice type: 2
0:00:00.038869370 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:570:gst_h264_parse_process_nal:<h264parse0>[00m marking IDR
in frame at offset 24
0:00:00.038887459 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:385:gst_h264_parse_wrap_nal:<h264parse0>[00m nal length
12761
0:00:00.038940260 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:606:gst_h264_parse_collect_nal:<h264parse0>[00m parsing
collected nal
0:00:00.038977416 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:1031:gst_h264_parse_update_src_caps:<h264parse0>[00m sps:
0x7f877d504010
0:00:00.039006261 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:874:gst_h264_parse_make_codec_data:<h264parse0>[00m
constructing codec_data: num_sps=1, num_pps=1
0:00:00.039035106 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:1172:gst_h264_parse_get_timestamp:<h264parse0>[00m unable
to compute timestamp: timing info not present
0:00:00.039065907 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:177:gst_h264_parse_reset_frame:<h264parse0>[00m reset frame
0:00:00.039090841 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m            filesink
gstfilesink.c:656:gst_file_sink_render:<filesink0>[00m writing 12789 bytes
at 57790
0:00:00.039209154 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:177:gst_h264_parse_reset_frame:<h264parse0>[00m reset frame
0:00:00.039228710 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:689:gst_h264_parse_check_valid_frame:<h264parse0>[00m last
parse position 0
0:00:00.039257066 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:726:gst_h264_parse_check_valid_frame:<h264parse0>[00m
complete nal (offset, size): (4, 3137)
0:00:00.039276133 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:778:gst_h264_parse_check_valid_frame:<h264parse0>[00m
0x7f8774002800 complete nal found. Off: 4, Size: 3137
0:00:00.039295200 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:461:gst_h264_parse_process_nal:<h264parse0>[00m processing
nal of type 1, size 3137
0:00:00.039313778 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:540:gst_h264_parse_process_nal:<h264parse0>[00m
first_mb_in_slice = 0
0:00:00.039330890 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:543:gst_h264_parse_process_nal:<h264parse0>[00m frame
start: 1
0:00:00.039350935 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:553:gst_h264_parse_process_nal:<h264parse0>[00m parse
result 0, first MB: 0, slice type: 0
0:00:00.039369513 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:385:gst_h264_parse_wrap_nal:<h264parse0>[00m nal length 3137
0:00:00.039392491 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:606:gst_h264_parse_collect_nal:<h264parse0>[00m parsing
collected nal
0:00:00.039426225 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:1172:gst_h264_parse_get_timestamp:<h264parse0>[00m unable
to compute timestamp: timing info not present
0:00:00.039448714 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:177:gst_h264_parse_reset_frame:<h264parse0>[00m reset frame
0:00:00.039471693 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m            filesink
gstfilesink.c:656:gst_file_sink_render:<filesink0>[00m writing 3141 bytes
at 70579
0:00:00.039546983 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:177:gst_h264_parse_reset_frame:<h264parse0>[00m reset frame
0:00:00.039565561 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:689:gst_h264_parse_check_valid_frame:<h264parse0>[00m last
parse position 0
0:00:00.039596851 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:726:gst_h264_parse_check_valid_frame:<h264parse0>[00m
complete nal (offset, size): (4, 4301)
0:00:00.039614940 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:778:gst_h264_parse_check_valid_frame:<h264parse0>[00m
0x7f8774002800 complete nal found. Off: 4, Size: 4301
0:00:00.039634007 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:461:gst_h264_parse_process_nal:<h264parse0>[00m processing
nal of type 1, size 4301
0:00:00.039660896 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:540:gst_h264_parse_process_nal:<h264parse0>[00m
first_mb_in_slice = 0
0:00:00.039678497 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:543:gst_h264_parse_process_nal:<h264parse0>[00m frame
start: 1
0:00:00.039699030 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:553:gst_h264_parse_process_nal:<h264parse0>[00m parse
result 0, first MB: 0, slice type: 0
0:00:00.039717120 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:385:gst_h264_parse_wrap_nal:<h264parse0>[00m nal length 4301
0:00:00.039739609 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:606:gst_h264_parse_collect_nal:<h264parse0>[00m parsing
collected nal
0:00:00.039771876 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:1172:gst_h264_parse_get_timestamp:<h264parse0>[00m unable
to compute timestamp: timing info not present
0:00:00.039793877 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:177:gst_h264_parse_reset_frame:<h264parse0>[00m reset frame
0:00:00.039817344 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m            filesink
gstfilesink.c:656:gst_file_sink_render:<filesink0>[00m writing 4305 bytes
at 73720
0:00:00.039894101 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:177:gst_h264_parse_reset_frame:<h264parse0>[00m reset frame
0:00:00.039927835 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:689:gst_h264_parse_check_valid_frame:<h264parse0>[00m last
parse position 0
0:00:00.039960102 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:726:gst_h264_parse_check_valid_frame:<h264parse0>[00m
complete nal (offset, size): (4, 3768)
0:00:00.039978191 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:778:gst_h264_parse_check_valid_frame:<h264parse0>[00m
0x7f877400ba30 complete nal found. Off: 4, Size: 3768
0:00:00.039997258 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:461:gst_h264_parse_process_nal:<h264parse0>[00m processing
nal of type 1, size 3768
0:00:00.040015348 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:540:gst_h264_parse_process_nal:<h264parse0>[00m
first_mb_in_slice = 0
0:00:00.040032948 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:543:gst_h264_parse_process_nal:<h264parse0>[00m frame
start: 1
0:00:00.040052504 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:553:gst_h264_parse_process_nal:<h264parse0>[00m parse
result 0, first MB: 0, slice type: 0
0:00:00.040072060 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:385:gst_h264_parse_wrap_nal:<h264parse0>[00m nal length 3768
0:00:00.040094060 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:606:gst_h264_parse_collect_nal:<h264parse0>[00m parsing
collected nal
0:00:00.040125839 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:1172:gst_h264_parse_get_timestamp:<h264parse0>[00m unable
to compute timestamp: timing info not present
0:00:00.040147839 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:177:gst_h264_parse_reset_frame:<h264parse0>[00m reset frame
0:00:00.040171306 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m            filesink
gstfilesink.c:656:gst_file_sink_render:<filesink0>[00m writing 3772 bytes
at 78025
0:00:00.040251974 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:177:gst_h264_parse_reset_frame:<h264parse0>[00m reset frame
0:00:00.040278375 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:689:gst_h264_parse_check_valid_frame:<h264parse0>[00m last
parse position 0
0:00:00.040307220 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:726:gst_h264_parse_check_valid_frame:<h264parse0>[00m
complete nal (offset, size): (4, 3379)
0:00:00.040326287 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:778:gst_h264_parse_check_valid_frame:<h264parse0>[00m
0x7f8774002800 complete nal found. Off: 4, Size: 3379
0:00:00.040345354 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:461:gst_h264_parse_process_nal:<h264parse0>[00m processing
nal of type 1, size 3379
0:00:00.040363932 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:540:gst_h264_parse_process_nal:<h264parse0>[00m
first_mb_in_slice = 0
0:00:00.040381532 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:543:gst_h264_parse_process_nal:<h264parse0>[00m frame
start: 1
0:00:00.040401088 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:553:gst_h264_parse_process_nal:<h264parse0>[00m parse
result 0, first MB: 0, slice type: 0
0:00:00.040420155 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:385:gst_h264_parse_wrap_nal:<h264parse0>[00m nal length 3379
0:00:00.040442645 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:606:gst_h264_parse_collect_nal:<h264parse0>[00m parsing
collected nal
0:00:00.040474912 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:1172:gst_h264_parse_get_timestamp:<h264parse0>[00m unable
to compute timestamp: timing info not present
0:00:00.040496912 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:177:gst_h264_parse_reset_frame:<h264parse0>[00m reset frame
0:00:00.040520379 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m            filesink
gstfilesink.c:656:gst_file_sink_render:<filesink0>[00m writing 3383 bytes
at 81797
0:00:00.040595670 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:177:gst_h264_parse_reset_frame:<h264parse0>[00m reset frame
0:00:00.040614248 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:689:gst_h264_parse_check_valid_frame:<h264parse0>[00m last
parse position 0
0:00:00.040643582 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:726:gst_h264_parse_check_valid_frame:<h264parse0>[00m
complete nal (offset, size): (4, 3586)
0:00:00.040661671 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:778:gst_h264_parse_check_valid_frame:<h264parse0>[00m
0x7f8774002800 complete nal found. Off: 4, Size: 3586
0:00:00.040680738 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:461:gst_h264_parse_process_nal:<h264parse0>[00m processing
nal of type 1, size 3586
0:00:00.040698827 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:540:gst_h264_parse_process_nal:<h264parse0>[00m
first_mb_in_slice = 0
0:00:00.040716917 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:543:gst_h264_parse_process_nal:<h264parse0>[00m frame
start: 1
0:00:00.040736473 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:553:gst_h264_parse_process_nal:<h264parse0>[00m parse
result 0, first MB: 0, slice type: 0
0:00:00.040756028 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:385:gst_h264_parse_wrap_nal:<h264parse0>[00m nal length 3586
0:00:00.040786340 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:606:gst_h264_parse_collect_nal:<h264parse0>[00m parsing
collected nal
0:00:00.040819096 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:1172:gst_h264_parse_get_timestamp:<h264parse0>[00m unable
to compute timestamp: timing info not present
0:00:00.040841586 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:177:gst_h264_parse_reset_frame:<h264parse0>[00m reset frame
0:00:00.040864564 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m            filesink
gstfilesink.c:656:gst_file_sink_render:<filesink0>[00m writing 3590 bytes
at 85180
0:00:00.040962344 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:177:gst_h264_parse_reset_frame:<h264parse0>[00m reset frame
0:00:00.040983855 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:689:gst_h264_parse_check_valid_frame:<h264parse0>[00m last
parse position 0
0:00:00.041013678 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:726:gst_h264_parse_check_valid_frame:<h264parse0>[00m
complete nal (offset, size): (4, 3887)
0:00:00.041032256 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:778:gst_h264_parse_check_valid_frame:<h264parse0>[00m
0x7f8774002800 complete nal found. Off: 4, Size: 3887
0:00:00.041051323 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:461:gst_h264_parse_process_nal:<h264parse0>[00m processing
nal of type 1, size 3887
0:00:00.041072835 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:540:gst_h264_parse_process_nal:<h264parse0>[00m
first_mb_in_slice = 0
0:00:00.041090435 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:543:gst_h264_parse_process_nal:<h264parse0>[00m frame
start: 1
0:00:00.041109991 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:553:gst_h264_parse_process_nal:<h264parse0>[00m parse
result 0, first MB: 0, slice type: 0
0:00:00.041129547 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:385:gst_h264_parse_wrap_nal:<h264parse0>[00m nal length 3887
0:00:00.041152036 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:606:gst_h264_parse_collect_nal:<h264parse0>[00m parsing
collected nal
0:00:00.041184303 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:1172:gst_h264_parse_get_timestamp:<h264parse0>[00m unable
to compute timestamp: timing info not present
0:00:00.041209726 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:177:gst_h264_parse_reset_frame:<h264parse0>[00m reset frame
0:00:00.041243949 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m            filesink
gstfilesink.c:656:gst_file_sink_render:<filesink0>[00m writing 3891 bytes
at 88770
0:00:00.041323639 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:177:gst_h264_parse_reset_frame:<h264parse0>[00m reset frame
0:00:00.041351018 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:689:gst_h264_parse_check_valid_frame:<h264parse0>[00m last
parse position 0
0:00:00.041390130 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:726:gst_h264_parse_check_valid_frame:<h264parse0>[00m
complete nal (offset, size): (4, 3746)
0:00:00.041410174 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:778:gst_h264_parse_check_valid_frame:<h264parse0>[00m
0x7f8774002800 complete nal found. Off: 4, Size: 3746
0:00:00.041430219 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:461:gst_h264_parse_process_nal:<h264parse0>[00m processing
nal of type 1, size 3746
0:00:00.041458086 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:540:gst_h264_parse_process_nal:<h264parse0>[00m
first_mb_in_slice = 0
0:00:00.041476665 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:543:gst_h264_parse_process_nal:<h264parse0>[00m frame
start: 1
0:00:00.041497687 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:553:gst_h264_parse_process_nal:<h264parse0>[00m parse
result 0, first MB: 0, slice type: 0
0:00:00.041517732 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:385:gst_h264_parse_wrap_nal:<h264parse0>[00m nal length 3746
0:00:00.041541688 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:606:gst_h264_parse_collect_nal:<h264parse0>[00m parsing
collected nal
0:00:00.041575422 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:1172:gst_h264_parse_get_timestamp:<h264parse0>[00m unable
to compute timestamp: timing info not present
0:00:00.041597911 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:177:gst_h264_parse_reset_frame:<h264parse0>[00m reset frame
0:00:00.041622845 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m            filesink
gstfilesink.c:656:gst_file_sink_render:<filesink0>[00m writing 3750 bytes
at 92661
0:00:00.041697647 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:177:gst_h264_parse_reset_frame:<h264parse0>[00m reset frame
0:00:00.041717203 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:689:gst_h264_parse_check_valid_frame:<h264parse0>[00m last
parse position 0
0:00:00.041751425 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:730:gst_h264_parse_check_valid_frame:<h264parse0>[00m not a
complete nal found at offset 4
0:00:00.041770004 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:736:gst_h264_parse_check_valid_frame:<h264parse0>[00m
draining, accepting with size 4080
0:00:00.041788093 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:778:gst_h264_parse_check_valid_frame:<h264parse0>[00m
0x7f8774002800 complete nal found. Off: 4, Size: 4080
0:00:00.041807649 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:461:gst_h264_parse_process_nal:<h264parse0>[00m processing
nal of type 1, size 4080
0:00:00.041826227 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:540:gst_h264_parse_process_nal:<h264parse0>[00m
first_mb_in_slice = 0
0:00:00.041843827 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:543:gst_h264_parse_process_nal:<h264parse0>[00m frame
start: 1
0:00:00.041863872 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:553:gst_h264_parse_process_nal:<h264parse0>[00m parse
result 0, first MB: 0, slice type: 0
0:00:00.041883428 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:385:gst_h264_parse_wrap_nal:<h264parse0>[00m nal length 4080
0:00:00.041908851 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:1172:gst_h264_parse_get_timestamp:<h264parse0>[00m unable
to compute timestamp: timing info not present
0:00:00.041944540 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:177:gst_h264_parse_reset_frame:<h264parse0>[00m reset frame
0:00:00.041968496 [332m 2785[00m       0x7b2630 [36mDEBUG  [00m
[00m            filesink
gstfilesink.c:656:gst_file_sink_render:<filesink0>[00m writing 4084 bytes
at 96411
Got EOS from element "pipeline0".
Execution ended after 9375114 ns.
Setting pipeline to PAUSED ...
Setting pipeline to READY ...
/GstPipeline:pipeline0/GstFileSink:filesink0.GstPad:sink: caps = NULL
0:00:00.042626064 [332m 2785[00m       0x92a930 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:252:gst_h264_parse_stop:<h264parse0>[00m stop
0:00:00.042644643 [332m 2785[00m       0x92a930 [36mDEBUG  [00m
[00m           h264parse
gsth264parse.c:177:gst_h264_parse_reset_frame:<h264parse0>[00m reset frame
/GstPipeline:pipeline0/GstH264Parse:h264parse0.GstPad:src: caps = NULL
Setting pipeline to NULL ...
0:00:00.043261632 [332m 2785[00m       0x92a930 [36mDEBUG  [00m
[00m            filesink
gstfilesink.c:446:gst_file_sink_close_file:<filesink0>[00m closed file
Freeing pipeline ...

On Tue, Jan 28, 2014 at 8:31 AM, Chuck Crisler <ccrisler at mutualink.net>wrote:

> You need some detailed logging. If you are using linux, export
> GST_DEBUG=h264parse:4 (or 5). You might also need logging for
> filesrc/filesink. That would be:
> export GST_DEBUG=filesrc:4,filesink:4,h264parse:4 Refer to the
> documentation for GstInfo for more logging info.
>
> The 0x00000001 is the h264 start code prefix. I would also expect that
> h264parse would not have changed the bitstream and the output should start
> with the same prefix.
>
> What is the exact version of GStreamer and what OS are you using?
>
>
> On Tue, Jan 28, 2014 at 9:16 AM, Timm Murray <tmurray at wumpus-cave.net>wrote:
>
>> My app requires fetching each frame of an h264 stream, wrapping the frame
>> in custom headers, and then sending it over the network.
>>
>> For testing, I'm using a raw .h264 file and trying to fetch each frame in
>> a fakesink.  On the command line, it's similar to this:
>>
>> $ gst-launch-0.10 filesrc location=in.h264 ! h264parse ! filesink
>> location=out.h264
>>
>> I would have expected out.h264 to be identical to in.h264.  And they are
>> the right size, but there are slight differences between them:
>>
>> $ ls -l in.h264 out.h264
>> -rw-r--r-- 1 user group 100495 Jan 19 17:00 in.h264
>> -rw-r--r-- 1 user group 100495 Jan 28 08:00 out.h264
>> $ sha1sum in.h264 out.h264
>> 2046b04ed23d3980d35c4819a97358113beb0f6c  in.h264
>> ef8233787e025dfc8aeb4b8f1a245014bb43d528  out.h264
>>
>> Looking at them in a hex editor, in.h264 starts with 0x00000001, and
>> out.h264 starts with 0x0000000A.  There are a few other differences here
>> and there, too.  It's enough that mplayer doesn't detect the right filetype
>> and refuses to play in (in.h264 plays fine).
>>
>> _______________________________________________
>> gstreamer-devel mailing list
>> gstreamer-devel at lists.freedesktop.org
>> http://lists.freedesktop.org/mailman/listinfo/gstreamer-devel
>>
>>
>
> _______________________________________________
> gstreamer-devel mailing list
> gstreamer-devel at lists.freedesktop.org
> http://lists.freedesktop.org/mailman/listinfo/gstreamer-devel
>
>
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.freedesktop.org/archives/gstreamer-devel/attachments/20140128/d84d1e7b/attachment-0001.html>