0:00:50.918967131  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:992:gst_ffmpegdec_get_buffer:<ffdec_h2640> data 0 3220197032 3220310136
0:00:50.925394606  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:3007:gst_ts_handler_consume:<ffdec_h2640> Stepping over 982 bytes @ index 153 has 7637 bytes
0:00:50.925453554  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1738:gst_ffmpegdec_video_frame:<ffdec_h2640> after decode: len 982, have_data 296
0:00:50.925502514  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1633:opaque_find:<ffdec_h2640> Found opaque 0x17a0600 - ts:99:99:99.999999999, duration:99:99:99.999999999, offset:-1
0:00:50.925519626  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1769:gst_ffmpegdec_video_frame:<ffdec_h2640> Found opaque values, current ts:0:04:55.504000000, offset: -1
0:00:50.925529474  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1774:gst_ffmpegdec_video_frame:<ffdec_h2640> ts-handler: pts 18446744073709551615 duration 18446744073709551615
0:00:50.925539112  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1776:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: pts 295462000000
0:00:50.925547982  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1778:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: num 1219
0:00:50.925557202  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1780:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: ref 0
0:00:50.925566421  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1782:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: display 0
0:00:50.925574802  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1784:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: opaque (nil)
0:00:50.925585767  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1786:gst_ffmpegdec_video_frame:<ffdec_h2640> repeat_pict:0
0:00:50.925594638  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1788:gst_ffmpegdec_video_frame:<ffdec_h2640> interlaced_frame:0
0:00:50.925603647  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1494:check_keyframe:<ffdec_h2640> current picture: type: 3, is_keyframe:0, is_itype:0, is_reference:0
0:00:50.925645414  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1520:get_output_buffer:<ffdec_h2640> get output buffer
0:00:50.925660151  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1535:get_output_buffer:<ffdec_h2640> clip width 848/height 480
0:00:50.925669929  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:900:alloc_output_buffer:<ffdec_h2640> alloc output buffer
0:00:50.925680126  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:912:alloc_output_buffer:<ffdec_h2640> calling pad_alloc
0:00:50.925761214  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1549:get_output_buffer:<ffdec_h2640> linsize 880 440 440
0:00:50.925779373  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1552:get_output_buffer:<ffdec_h2640> data 0 36289368 36991048
0:00:50.926277496  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1871:gst_ffmpegdec_video_frame:<ffdec_h2640> using next timestamp 0:04:54.377416664
0:00:50.926318285  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1890:gst_ffmpegdec_video_frame:<ffdec_h2640> Using offset converted from timestamp
0:00:50.926398325  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1937:gst_ffmpegdec_video_frame:<ffdec_h2640> using in_duration
0:00:50.926422002  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1420:clip_video_buffer:<ffdec_h2640> timestamp:0:04:54.377416664 , duration:0:00:00.041708332
0:00:50.926435063  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1457:clip_video_buffer:<ffdec_h2640> dropping
0:00:50.926444282  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1987:gst_ffmpegdec_video_frame:<ffdec_h2640> buffer clipped
0:00:50.926459857  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1970:gst_ffmpegdec_video_frame:<ffdec_h2640> return flow 0, out (nil), len 982
0:00:50.926472708  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:2271:gst_ffmpegdec_frame:<ffdec_h2640> We didn't get a decoded buffer
0:00:50.926482137  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2672:gst_ffmpegdec_chain:<ffdec_h2640> Before (while bsize>0).  bsize:0 , bdata:0x7f96440994c9
0:00:50.926517129  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2978:gst_ts_handler_append:<ffdec_h2640> store timestamp @ index [B8] buf_count: 31 ts: 0:04:55.545000000 duration: 0:00:00.041708332, offset: 18446744073709551615, size: 937
0:00:50.926536405  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2518:gst_ffmpegdec_chain:<ffdec_h2640> Received new data of size 937, offset:18446744073709551615, ts:0:04:55.545000000, dur:0:00:00.041708332
0:00:50.926551701  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2195:gst_ffmpegdec_frame:<ffdec_h2640> data:0x1cdfb80, size:937, offset:-1, ts:0:04:55.545000000, dur:0:00:00.041708332
0:00:50.926564832  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1345:gst_ffmpegdec_do_qos:<ffdec_h2640> QOS: qostime 0:00:47.203000000, earliest 0:00:45.433646000
0:00:50.926575588  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1715:gst_ffmpegdec_video_frame:<ffdec_h2640> Going to store opaque values, current ts:0:04:55.545000000, offset: -1
0:00:50.926585924  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:3049:gst_ts_handler_get_ts:<ffdec_h2640> Index 153 yielded ts: 99:99:99.999999999, duration: 99:99:99.999999999, offset: -1
0:00:50.926636142  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1612:opaque_store:<ffdec_h2640> Stored ts:99:99:99.999999999, duration:99:99:99.999999999, offset:18446744073709551615 as opaque 0x27bc000
0:00:50.926668689  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1074:gst_ffmpegdec_release_buffer:<ffdec_h2640> default release buffer
0:00:50.926686499  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:966:gst_ffmpegdec_get_buffer:<ffdec_h2640> getting buffer, apply pts 295545000000
0:00:50.926728894  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:983:gst_ffmpegdec_get_buffer:<ffdec_h2640> dimension 848x480, coded 848x480
0:00:50.926742513  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:985:gst_ffmpegdec_get_buffer:<ffdec_h2640> direct rendering disabled, fallback alloc
0:00:50.926753828  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:989:gst_ffmpegdec_get_buffer:<ffdec_h2640> linsize 880 440 440
0:00:50.926763466  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:992:gst_ffmpegdec_get_buffer:<ffdec_h2640> data 0 36289368 36991048
0:00:50.933201069  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:3007:gst_ts_handler_consume:<ffdec_h2640> Stepping over 937 bytes @ index 153 has 6655 bytes
0:00:50.933256106  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1738:gst_ffmpegdec_video_frame:<ffdec_h2640> after decode: len 937, have_data 296
0:00:50.933298082  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1633:opaque_find:<ffdec_h2640> Found opaque 0x27521a0 - ts:99:99:99.999999999, duration:99:99:99.999999999, offset:-1
0:00:50.933313098  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1769:gst_ffmpegdec_video_frame:<ffdec_h2640> Found opaque values, current ts:0:04:55.545000000, offset: -1
0:00:50.933322387  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1774:gst_ffmpegdec_video_frame:<ffdec_h2640> ts-handler: pts 18446744073709551615 duration 18446744073709551615
0:00:50.933331676  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1776:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: pts 295504000000
0:00:50.933340407  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1778:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: num 1220
0:00:50.933349277  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1780:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: ref 0
0:00:50.933357867  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1782:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: display 0
0:00:50.933367227  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1784:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: opaque (nil)
0:00:50.933377913  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1786:gst_ffmpegdec_video_frame:<ffdec_h2640> repeat_pict:0
0:00:50.933386573  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1788:gst_ffmpegdec_video_frame:<ffdec_h2640> interlaced_frame:0
0:00:50.933395304  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1494:check_keyframe:<ffdec_h2640> current picture: type: 3, is_keyframe:0, is_itype:0, is_reference:0
0:00:50.933404593  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1520:get_output_buffer:<ffdec_h2640> get output buffer
0:00:50.933413114  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1535:get_output_buffer:<ffdec_h2640> clip width 848/height 480
0:00:50.933421634  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:900:alloc_output_buffer:<ffdec_h2640> alloc output buffer
0:00:50.933431622  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:912:alloc_output_buffer:<ffdec_h2640> calling pad_alloc
0:00:50.933503491  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1549:get_output_buffer:<ffdec_h2640> linsize 880 440 440
0:00:50.933516272  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1552:get_output_buffer:<ffdec_h2640> data 0 3220197032 3220310136
0:00:50.933917033  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1871:gst_ffmpegdec_video_frame:<ffdec_h2640> using next timestamp 0:04:54.419124996
0:00:50.933951327  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1890:gst_ffmpegdec_video_frame:<ffdec_h2640> Using offset converted from timestamp
0:00:50.934019494  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1937:gst_ffmpegdec_video_frame:<ffdec_h2640> using in_duration
0:00:50.934061609  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1420:clip_video_buffer:<ffdec_h2640> timestamp:0:04:54.419124996 , duration:0:00:00.041708332
0:00:50.934074949  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1457:clip_video_buffer:<ffdec_h2640> dropping
0:00:50.934084448  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1987:gst_ffmpegdec_video_frame:<ffdec_h2640> buffer clipped
0:00:50.934097579  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1970:gst_ffmpegdec_video_frame:<ffdec_h2640> return flow 0, out (nil), len 937
0:00:50.934110849  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:2271:gst_ffmpegdec_frame:<ffdec_h2640> We didn't get a decoded buffer
0:00:50.934120208  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2672:gst_ffmpegdec_chain:<ffdec_h2640> Before (while bsize>0).  bsize:0 , bdata:0x7f9644099879
0:00:50.934157993  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:2341:gst_ffmpegdec_sink_event:<ffdec_h2640> Handling newsegment event
0:00:50.934172520  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2296:gst_ffmpegdec_drain:<ffdec_h2640> codec has delay capabilities, calling until ffmpeg has drained everything
0:00:50.934182578  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2195:gst_ffmpegdec_frame:<ffdec_h2640> data:(nil), size:0, offset:-1, ts:99:99:99.999999999, dur:99:99:99.999999999
0:00:50.934195639  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1715:gst_ffmpegdec_video_frame:<ffdec_h2640> Going to store opaque values, current ts:99:99:99.999999999, offset: -1
0:00:50.934205417  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:3049:gst_ts_handler_get_ts:<ffdec_h2640> Index 153 yielded ts: 99:99:99.999999999, duration: 99:99:99.999999999, offset: -1
0:00:50.934241246  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1612:opaque_store:<ffdec_h2640> Stored ts:99:99:99.999999999, duration:99:99:99.999999999, offset:18446744073709551615 as opaque 0x280e340
0:00:50.934255844  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1738:gst_ffmpegdec_video_frame:<ffdec_h2640> after decode: len 0, have_data 296
0:00:50.934269184  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1633:opaque_find:<ffdec_h2640> Found opaque 0x27bc000 - ts:99:99:99.999999999, duration:99:99:99.999999999, offset:-1
0:00:50.934281755  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1769:gst_ffmpegdec_video_frame:<ffdec_h2640> Found opaque values, current ts:99:99:99.999999999, offset: -1
0:00:50.934290975  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1774:gst_ffmpegdec_video_frame:<ffdec_h2640> ts-handler: pts 18446744073709551615 duration 18446744073709551615
0:00:50.934299985  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1776:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: pts 295545000000
0:00:50.934308505  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1778:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: num 1221
0:00:50.934317376  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1780:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: ref 4
0:00:50.934325827  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1782:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: display 0
0:00:50.934333928  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1784:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: opaque (nil)
0:00:50.934342729  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1786:gst_ffmpegdec_video_frame:<ffdec_h2640> repeat_pict:0
0:00:50.934351110  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1788:gst_ffmpegdec_video_frame:<ffdec_h2640> interlaced_frame:0
0:00:50.934359421  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1494:check_keyframe:<ffdec_h2640> current picture: type: 3, is_keyframe:0, is_itype:0, is_reference:0
0:00:50.934377441  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1833:gst_ffmpegdec_video_frame:<ffdec_h2640> DTS as timestamps, interpolate
0:00:50.934387498  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1520:get_output_buffer:<ffdec_h2640> get output buffer
0:00:50.934396019  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1535:get_output_buffer:<ffdec_h2640> clip width 848/height 480
0:00:50.934404610  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:900:alloc_output_buffer:<ffdec_h2640> alloc output buffer
0:00:50.934413899  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:912:alloc_output_buffer:<ffdec_h2640> calling pad_alloc
0:00:50.934476199  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1549:get_output_buffer:<ffdec_h2640> linsize 880 440 440
0:00:50.934488352  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1552:get_output_buffer:<ffdec_h2640> data 0 36289368 36991048
0:00:50.934868929  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1871:gst_ffmpegdec_video_frame:<ffdec_h2640> using next timestamp 0:04:54.460833328
0:00:50.934906854  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1890:gst_ffmpegdec_video_frame:<ffdec_h2640> Using offset converted from timestamp
0:00:50.934970132  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1918:gst_ffmpegdec_video_frame:<ffdec_h2640> using input framerate for duration
0:00:50.934987034  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1420:clip_video_buffer:<ffdec_h2640> timestamp:0:04:54.460833328 , duration:0:00:00.041708332
0:00:50.934997929  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1457:clip_video_buffer:<ffdec_h2640> dropping
0:00:50.935006660  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1987:gst_ffmpegdec_video_frame:<ffdec_h2640> buffer clipped
0:00:50.935018882  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1970:gst_ffmpegdec_video_frame:<ffdec_h2640> return flow 0, out (nil), len 0
0:00:50.935031524  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:2422:gst_ffmpegdec_sink_event:<ffdec_h2640> NEWSEGMENT in time start 0:04:55.563999999 -- stop 99:99:99.999999999
0:00:50.935123158  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:2341:gst_ffmpegdec_sink_event:<ffdec_h2640> Handling newsegment event
0:00:50.935140689  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2296:gst_ffmpegdec_drain:<ffdec_h2640> codec has delay capabilities, calling until ffmpeg has drained everything
0:00:50.935151026  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2195:gst_ffmpegdec_frame:<ffdec_h2640> data:(nil), size:0, offset:-1, ts:99:99:99.999999999, dur:99:99:99.999999999
0:00:50.935163877  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1715:gst_ffmpegdec_video_frame:<ffdec_h2640> Going to store opaque values, current ts:99:99:99.999999999, offset: -1
0:00:50.935173725  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:3049:gst_ts_handler_get_ts:<ffdec_h2640> Index 153 yielded ts: 99:99:99.999999999, duration: 99:99:99.999999999, offset: -1
0:00:50.935216469  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1612:opaque_store:<ffdec_h2640> Stored ts:99:99:99.999999999, duration:99:99:99.999999999, offset:18446744073709551615 as opaque 0x7f9644004760
0:00:50.935233581  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1738:gst_ffmpegdec_video_frame:<ffdec_h2640> after decode: len 0, have_data 296
0:00:50.935247689  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1633:opaque_find:<ffdec_h2640> Found opaque 0x27f54e0 - ts:99:99:99.999999999, duration:99:99:99.999999999, offset:-1
0:00:50.935260610  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1769:gst_ffmpegdec_video_frame:<ffdec_h2640> Found opaque values, current ts:99:99:99.999999999, offset: -1
0:00:50.935291062  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1774:gst_ffmpegdec_video_frame:<ffdec_h2640> ts-handler: pts 18446744073709551615 duration 18446744073709551615
0:00:50.935302097  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1776:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: pts 295587000000
0:00:50.935310897  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1778:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: num 1207
0:00:50.935319907  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1780:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: ref 3
0:00:50.935328568  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1782:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: display 0
0:00:50.935336879  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1784:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: opaque (nil)
0:00:50.935345889  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1786:gst_ffmpegdec_video_frame:<ffdec_h2640> repeat_pict:0
0:00:50.935354061  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1788:gst_ffmpegdec_video_frame:<ffdec_h2640> interlaced_frame:0
0:00:50.935362512  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1494:check_keyframe:<ffdec_h2640> current picture: type: 2, is_keyframe:0, is_itype:0, is_reference:0
0:00:50.935371591  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1833:gst_ffmpegdec_video_frame:<ffdec_h2640> DTS as timestamps, interpolate
0:00:50.935379763  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1520:get_output_buffer:<ffdec_h2640> get output buffer
0:00:50.935388004  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1535:get_output_buffer:<ffdec_h2640> clip width 848/height 480
0:00:50.935396525  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:900:alloc_output_buffer:<ffdec_h2640> alloc output buffer
0:00:50.935405814  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:912:alloc_output_buffer:<ffdec_h2640> calling pad_alloc
0:00:50.935453098  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1549:get_output_buffer:<ffdec_h2640> linsize 880 440 440
0:00:50.935465950  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1552:get_output_buffer:<ffdec_h2640> data 0 3211342952 3211456056
0:00:50.935849320  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1871:gst_ffmpegdec_video_frame:<ffdec_h2640> using next timestamp 0:04:54.502541660
0:00:50.935883194  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1890:gst_ffmpegdec_video_frame:<ffdec_h2640> Using offset converted from timestamp
0:00:50.935949475  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1918:gst_ffmpegdec_video_frame:<ffdec_h2640> using input framerate for duration
0:00:50.935966447  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1420:clip_video_buffer:<ffdec_h2640> timestamp:0:04:54.502541660 , duration:0:00:00.041708332
0:00:50.935978740  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1457:clip_video_buffer:<ffdec_h2640> dropping
0:00:50.935987191  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1987:gst_ffmpegdec_video_frame:<ffdec_h2640> buffer clipped
0:00:50.936001229  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1970:gst_ffmpegdec_video_frame:<ffdec_h2640> return flow 0, out (nil), len 0
0:00:50.936014010  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:2422:gst_ffmpegdec_sink_event:<ffdec_h2640> NEWSEGMENT in time start 0:04:55.585333332 -- stop 99:99:99.999999999
0:00:50.936105854  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:2341:gst_ffmpegdec_sink_event:<ffdec_h2640> Handling newsegment event
0:00:50.936124223  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2296:gst_ffmpegdec_drain:<ffdec_h2640> codec has delay capabilities, calling until ffmpeg has drained everything
0:00:50.936134770  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2195:gst_ffmpegdec_frame:<ffdec_h2640> data:(nil), size:0, offset:-1, ts:99:99:99.999999999, dur:99:99:99.999999999
0:00:50.936175139  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1715:gst_ffmpegdec_video_frame:<ffdec_h2640> Going to store opaque values, current ts:99:99:99.999999999, offset: -1
0:00:50.936188200  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:3049:gst_ts_handler_get_ts:<ffdec_h2640> Index 153 yielded ts: 99:99:99.999999999, duration: 99:99:99.999999999, offset: -1
0:00:50.936229966  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1612:opaque_store:<ffdec_h2640> Stored ts:99:99:99.999999999, duration:99:99:99.999999999, offset:18446744073709551615 as opaque 0x26ac6e0
0:00:50.936245751  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1738:gst_ffmpegdec_video_frame:<ffdec_h2640> after decode: len 0, have_data 0
0:00:50.936255249  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1970:gst_ffmpegdec_video_frame:<ffdec_h2640> return flow 0, out (nil), len 0
0:00:50.936265377  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:2422:gst_ffmpegdec_sink_event:<ffdec_h2640> NEWSEGMENT in time start 0:04:55.606666665 -- stop 99:99:99.999999999
0:00:50.936318178  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:2341:gst_ffmpegdec_sink_event:<ffdec_h2640> Handling newsegment event
0:00:50.936334172  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2296:gst_ffmpegdec_drain:<ffdec_h2640> codec has delay capabilities, calling until ffmpeg has drained everything
0:00:50.936343811  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2195:gst_ffmpegdec_frame:<ffdec_h2640> data:(nil), size:0, offset:-1, ts:99:99:99.999999999, dur:99:99:99.999999999
0:00:50.936355265  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1715:gst_ffmpegdec_video_frame:<ffdec_h2640> Going to store opaque values, current ts:99:99:99.999999999, offset: -1
0:00:50.936364694  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:3049:gst_ts_handler_get_ts:<ffdec_h2640> Index 153 yielded ts: 99:99:99.999999999, duration: 99:99:99.999999999, offset: -1
0:00:50.936383901  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1612:opaque_store:<ffdec_h2640> Stored ts:99:99:99.999999999, duration:99:99:99.999999999, offset:18446744073709551615 as opaque 0x27b14e0
0:00:50.936396822  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1738:gst_ffmpegdec_video_frame:<ffdec_h2640> after decode: len 0, have_data 0
0:00:50.936406111  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1970:gst_ffmpegdec_video_frame:<ffdec_h2640> return flow 0, out (nil), len 0
0:00:50.936415610  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:2422:gst_ffmpegdec_sink_event:<ffdec_h2640> NEWSEGMENT in time start 0:04:55.627999998 -- stop 99:99:99.999999999
0:00:50.936464291  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:2341:gst_ffmpegdec_sink_event:<ffdec_h2640> Handling newsegment event
0:00:50.936479307  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2296:gst_ffmpegdec_drain:<ffdec_h2640> codec has delay capabilities, calling until ffmpeg has drained everything
0:00:50.936489295  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2195:gst_ffmpegdec_frame:<ffdec_h2640> data:(nil), size:0, offset:-1, ts:99:99:99.999999999, dur:99:99:99.999999999
0:00:50.936501028  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1715:gst_ffmpegdec_video_frame:<ffdec_h2640> Going to store opaque values, current ts:99:99:99.999999999, offset: -1
0:00:50.936510317  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:3049:gst_ts_handler_get_ts:<ffdec_h2640> Index 153 yielded ts: 99:99:99.999999999, duration: 99:99:99.999999999, offset: -1
0:00:50.936527708  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1612:opaque_store:<ffdec_h2640> Stored ts:99:99:99.999999999, duration:99:99:99.999999999, offset:18446744073709551615 as opaque 0x27f54e0
0:00:50.936550827  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1738:gst_ffmpegdec_video_frame:<ffdec_h2640> after decode: len 0, have_data 0
0:00:50.936561862  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1970:gst_ffmpegdec_video_frame:<ffdec_h2640> return flow 0, out (nil), len 0
0:00:50.936571500  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:2422:gst_ffmpegdec_sink_event:<ffdec_h2640> NEWSEGMENT in time start 0:04:55.649333331 -- stop 99:99:99.999999999
0:00:50.936621229  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2978:gst_ts_handler_append:<ffdec_h2640> store timestamp @ index [B9] buf_count: 32 ts: 0:04:56.004000000 duration: 0:00:00.041708332, offset: 18446744073709551615, size: 12117
0:00:50.936639109  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2518:gst_ffmpegdec_chain:<ffdec_h2640> Received new data of size 12117, offset:18446744073709551615, ts:0:04:56.004000000, dur:0:00:00.041708332
0:00:50.936659782  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2195:gst_ffmpegdec_frame:<ffdec_h2640> data:0x1cdfb80, size:12117, offset:-1, ts:0:04:56.004000000, dur:0:00:00.041708332
0:00:50.936672913  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1345:gst_ffmpegdec_do_qos:<ffdec_h2640> QOS: qostime 0:00:47.662000000, earliest 0:00:45.433646000
0:00:50.936683319  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1715:gst_ffmpegdec_video_frame:<ffdec_h2640> Going to store opaque values, current ts:0:04:56.004000000, offset: -1
0:00:50.936693447  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:3049:gst_ts_handler_get_ts:<ffdec_h2640> Index 153 yielded ts: 99:99:99.999999999, duration: 99:99:99.999999999, offset: -1
0:00:50.936711746  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1612:opaque_store:<ffdec_h2640> Stored ts:99:99:99.999999999, duration:99:99:99.999999999, offset:18446744073709551615 as opaque 0x27f5420
0:00:50.936746178  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1074:gst_ffmpegdec_release_buffer:<ffdec_h2640> default release buffer
0:00:50.936760636  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:966:gst_ffmpegdec_get_buffer:<ffdec_h2640> getting buffer, apply pts 296004000000
0:00:50.936770204  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:983:gst_ffmpegdec_get_buffer:<ffdec_h2640> dimension 848x480, coded 848x480
0:00:50.936779354  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:985:gst_ffmpegdec_get_buffer:<ffdec_h2640> direct rendering disabled, fallback alloc
0:00:50.936788573  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:989:gst_ffmpegdec_get_buffer:<ffdec_h2640> linsize 880 440 440
0:00:50.936797304  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:992:gst_ffmpegdec_get_buffer:<ffdec_h2640> data 0 3220197032 3220310136
0:00:50.951022651  6075      0x12be620 DEBUG                 ffmpeg :0:: no picture
0:00:50.951064907  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:3007:gst_ts_handler_consume:<ffdec_h2640> Stepping over 12117 bytes @ index 153 has 5718 bytes
0:00:50.951081460  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:3007:gst_ts_handler_consume:<ffdec_h2640> Stepping over 6399 bytes @ index 154 has 47551 bytes
0:00:50.951091028  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1738:gst_ffmpegdec_video_frame:<ffdec_h2640> after decode: len 12117, have_data 0
0:00:50.951100317  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1970:gst_ffmpegdec_video_frame:<ffdec_h2640> return flow 0, out (nil), len 12117
0:00:50.951111492  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:2271:gst_ffmpegdec_frame:<ffdec_h2640> We didn't get a decoded buffer
0:00:50.951120362  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2672:gst_ffmpegdec_chain:<ffdec_h2640> Before (while bsize>0).  bsize:0 , bdata:0x7f964415cf15
0:00:50.951178402  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2978:gst_ts_handler_append:<ffdec_h2640> store timestamp @ index [BA] buf_count: 32 ts: 0:04:55.796000000 duration: 0:00:00.041708332, offset: 18446744073709551615, size: 2068
0:00:50.951195095  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2518:gst_ffmpegdec_chain:<ffdec_h2640> Received new data of size 2068, offset:18446744073709551615, ts:0:04:55.796000000, dur:0:00:00.041708332
0:00:50.951208994  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2195:gst_ffmpegdec_frame:<ffdec_h2640> data:0x1cdfb80, size:2068, offset:-1, ts:0:04:55.796000000, dur:0:00:00.041708332
0:00:50.951222543  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1345:gst_ffmpegdec_do_qos:<ffdec_h2640> QOS: qostime 0:00:47.454000000, earliest 0:00:45.433646000
0:00:50.951233229  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1715:gst_ffmpegdec_video_frame:<ffdec_h2640> Going to store opaque values, current ts:0:04:55.796000000, offset: -1
0:00:50.951243706  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:3049:gst_ts_handler_get_ts:<ffdec_h2640> Index 154 yielded ts: 0:04:54.336000000, duration: 0:00:00.041708332, offset: -1
0:00:50.951284634  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1612:opaque_store:<ffdec_h2640> Stored ts:0:04:54.336000000, duration:0:00:00.041708332, offset:18446744073709551615 as opaque 0x27b3560
0:00:50.951310616  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:966:gst_ffmpegdec_get_buffer:<ffdec_h2640> getting buffer, apply pts 295796000000
0:00:50.951320883  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:983:gst_ffmpegdec_get_buffer:<ffdec_h2640> dimension 848x480, coded 848x480
0:00:50.951329823  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:985:gst_ffmpegdec_get_buffer:<ffdec_h2640> direct rendering disabled, fallback alloc
0:00:50.951339112  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:989:gst_ffmpegdec_get_buffer:<ffdec_h2640> linsize 880 440 440
0:00:50.951348261  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:992:gst_ffmpegdec_get_buffer:<ffdec_h2640> data 0 33178488 33291592
0:00:50.953055582  6075      0x1312030 LOG                   ffmpeg gstffmpegdec.c:2672:gst_ffmpegdec_chain:<ffdec_aac0> Before (while bsize>0).  bsize:0 , bdata:0x7f96440b0fce
0:00:50.953144912  6075      0x1312030 LOG                   ffmpeg gstffmpegdec.c:2978:gst_ts_handler_append:<ffdec_aac0> store timestamp @ index [47] buf_count: 2374 ts: 0:04:54.336000000 duration: 0:00:00.021333333, offset: 18446744073709551615, size: 519
0:00:50.953169706  6075      0x1312030 LOG                   ffmpeg gstffmpegdec.c:2518:gst_ffmpegdec_chain:<ffdec_aac0> Received new data of size 519, offset:18446744073709551615, ts:0:04:54.336000000, dur:0:00:00.021333333
0:00:50.953183884  6075      0x1312030 LOG                   ffmpeg gstffmpegdec.c:2195:gst_ffmpegdec_frame:<ffdec_aac0> data:0x7f964414a8f0, size:519, offset:-1, ts:0:04:54.336000000, dur:0:00:00.021333333
0:00:50.953195339  6075      0x1312030 DEBUG                 ffmpeg gstffmpegdec.c:2077:gst_ffmpegdec_audio_frame:<ffdec_aac0> size:519, offset:-1, ts:0:04:54.336000000, dur:0:00:00.021333333, ffmpegdec->next_ts:0:04:54.335666664
0:00:50.953417720  6075      0x1312030 DEBUG                 ffmpeg gstffmpegdec.c:2086:gst_ffmpegdec_audio_frame:<ffdec_aac0> Decode audio: len=519, have_data=4096
0:00:50.953440489  6075      0x1312030 DEBUG                 ffmpeg gstffmpegdec.c:2089:gst_ffmpegdec_audio_frame:<ffdec_aac0> Creating output buffer
0:00:50.953453550  6075      0x1312030 DEBUG                 ffmpeg gstffmpegdec.c:2123:gst_ffmpegdec_audio_frame:<ffdec_aac0> Buffer created. Size:4096 , timestamp:0:04:54.336000000 , duration:0:00:00.021333333
0:00:50.953464166  6075      0x1312030 LOG                   ffmpeg gstffmpegdec.c:2007:clip_audio_buffer:<ffdec_aac0> timestamp:0:04:54.336000000, duration:0:00:00.021333333, size 4096
0:00:50.953497202  6075      0x1312030 LOG                   ffmpeg gstffmpegdec.c:2053:clip_audio_buffer:<ffdec_aac0> not dropping
0:00:50.953510123  6075      0x1312030 DEBUG                 ffmpeg gstffmpegdec.c:2152:gst_ffmpegdec_audio_frame:<ffdec_aac0> return flow 0, out 0x17a28c0, len 519
0:00:50.953519831  6075      0x1312030 LOG                   ffmpeg gstffmpegdec.c:2250:gst_ffmpegdec_frame:<ffdec_aac0> Decoded data, now pushing buffer 0x17a28c0 with offset -1, timestamp 0:04:54.336000000 and duration 0:00:00.021333333
0:00:50.953655956  6075      0x1312030 LOG                   ffmpeg gstffmpegdec.c:2672:gst_ffmpegdec_chain:<ffdec_aac0> Before (while bsize>0).  bsize:0 , bdata:0x7f96440da3da
0:00:50.953697582  6075      0x1312030 LOG                   ffmpeg gstffmpegdec.c:2978:gst_ts_handler_append:<ffdec_aac0> store timestamp @ index [48] buf_count: 2375 ts: 0:04:54.357333333 duration: 0:00:00.021333333, offset: 18446744073709551615, size: 495
0:00:50.953716161  6075      0x1312030 LOG                   ffmpeg gstffmpegdec.c:2518:gst_ffmpegdec_chain:<ffdec_aac0> Received new data of size 495, offset:18446744073709551615, ts:0:04:54.357333333, dur:0:00:00.021333333
0:00:50.953728243  6075      0x1312030 LOG                   ffmpeg gstffmpegdec.c:2195:gst_ffmpegdec_frame:<ffdec_aac0> data:0x7f964414a8f0, size:495, offset:-1, ts:0:04:54.357333333, dur:0:00:00.021333333
0:00:50.953740117  6075      0x1312030 DEBUG                 ffmpeg gstffmpegdec.c:2077:gst_ffmpegdec_audio_frame:<ffdec_aac0> size:495, offset:-1, ts:0:04:54.357333333, dur:0:00:00.021333333, ffmpegdec->next_ts:0:04:54.357333333
0:00:50.953952091  6075      0x1312030 DEBUG                 ffmpeg gstffmpegdec.c:2086:gst_ffmpegdec_audio_frame:<ffdec_aac0> Decode audio: len=495, have_data=4096
0:00:50.953974581  6075      0x1312030 DEBUG                 ffmpeg gstffmpegdec.c:2089:gst_ffmpegdec_audio_frame:<ffdec_aac0> Creating output buffer
0:00:50.953984499  6075      0x1312030 DEBUG                 ffmpeg gstffmpegdec.c:2123:gst_ffmpegdec_audio_frame:<ffdec_aac0> Buffer created. Size:4096 , timestamp:0:04:54.357333333 , duration:0:00:00.021333333
0:00:50.953996582  6075      0x1312030 LOG                   ffmpeg gstffmpegdec.c:2007:clip_audio_buffer:<ffdec_aac0> timestamp:0:04:54.357333333, duration:0:00:00.021333333, size 4096
0:00:50.954006639  6075      0x1312030 LOG                   ffmpeg gstffmpegdec.c:2053:clip_audio_buffer:<ffdec_aac0> not dropping
0:00:50.954015649  6075      0x1312030 DEBUG                 ffmpeg gstffmpegdec.c:2152:gst_ffmpegdec_audio_frame:<ffdec_aac0> return flow 0, out 0x7f9644089ca0, len 495
0:00:50.954025636  6075      0x1312030 LOG                   ffmpeg gstffmpegdec.c:2250:gst_ffmpegdec_frame:<ffdec_aac0> Decoded data, now pushing buffer 0x7f9644089ca0 with offset -1, timestamp 0:04:54.357333333 and duration 0:00:00.021333333
0:00:50.958170072  6075      0x12be620 DEBUG                 ffmpeg :0:: no picture
0:00:50.958216797  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:3007:gst_ts_handler_consume:<ffdec_h2640> Stepping over 2068 bytes @ index 154 has 41152 bytes
0:00:50.958232232  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1738:gst_ffmpegdec_video_frame:<ffdec_h2640> after decode: len 2068, have_data 0
0:00:50.958241940  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1970:gst_ffmpegdec_video_frame:<ffdec_h2640> return flow 0, out (nil), len 2068
0:00:50.958253674  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:2271:gst_ffmpegdec_frame:<ffdec_h2640> We didn't get a decoded buffer
0:00:50.958262893  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2672:gst_ffmpegdec_chain:<ffdec_h2640> Before (while bsize>0).  bsize:0 , bdata:0x7f964415d730
0:00:50.958311225  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:2341:gst_ffmpegdec_sink_event:<ffdec_h2640> Handling newsegment event
0:00:50.958334413  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2296:gst_ffmpegdec_drain:<ffdec_h2640> codec has delay capabilities, calling until ffmpeg has drained everything
0:00:50.958369335  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2195:gst_ffmpegdec_frame:<ffdec_h2640> data:(nil), size:0, offset:-1, ts:99:99:99.999999999, dur:99:99:99.999999999
0:00:50.958385957  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1715:gst_ffmpegdec_video_frame:<ffdec_h2640> Going to store opaque values, current ts:99:99:99.999999999, offset: -1
0:00:50.958396364  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:3049:gst_ts_handler_get_ts:<ffdec_h2640> Index 154 yielded ts: 99:99:99.999999999, duration: 99:99:99.999999999, offset: -1
0:00:50.958444556  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1612:opaque_store:<ffdec_h2640> Stored ts:99:99:99.999999999, duration:99:99:99.999999999, offset:18446744073709551615 as opaque 0x2815ce0
0:00:50.958460969  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1738:gst_ffmpegdec_video_frame:<ffdec_h2640> after decode: len 0, have_data 296
0:00:50.958477033  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1633:opaque_find:<ffdec_h2640> Found opaque 0x27b3560 - ts:0:04:54.336000000, duration:0:00:00.041708332, offset:-1
0:00:50.958489116  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1769:gst_ffmpegdec_video_frame:<ffdec_h2640> Found opaque values, current ts:99:99:99.999999999, offset: -1
0:00:50.958498685  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1774:gst_ffmpegdec_video_frame:<ffdec_h2640> ts-handler: pts 294336000000 duration 41708332
0:00:50.958507694  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1776:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: pts 295796000000
0:00:50.958516425  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1778:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: num 1223
0:00:50.958525225  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1780:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: ref 3
0:00:50.958560356  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1782:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: display 0
0:00:50.958574325  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1784:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: opaque (nil)
0:00:50.958585640  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1786:gst_ffmpegdec_video_frame:<ffdec_h2640> repeat_pict:0
0:00:50.958594161  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1788:gst_ffmpegdec_video_frame:<ffdec_h2640> interlaced_frame:0
0:00:50.958603380  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1494:check_keyframe:<ffdec_h2640> current picture: type: 3, is_keyframe:0, is_itype:0, is_reference:0
0:00:50.958613856  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1833:gst_ffmpegdec_video_frame:<ffdec_h2640> DTS as timestamps, interpolate
0:00:50.958622517  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1520:get_output_buffer:<ffdec_h2640> get output buffer
0:00:50.958631247  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1535:get_output_buffer:<ffdec_h2640> clip width 848/height 480
0:00:50.958639978  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:900:alloc_output_buffer:<ffdec_h2640> alloc output buffer
0:00:50.958649826  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:912:alloc_output_buffer:<ffdec_h2640> calling pad_alloc
0:00:50.958742368  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1549:get_output_buffer:<ffdec_h2640> linsize 880 440 440
0:00:50.958763950  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1552:get_output_buffer:<ffdec_h2640> data 0 33178488 33291592
0:00:50.959137542  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1871:gst_ffmpegdec_video_frame:<ffdec_h2640> using next timestamp 0:04:54.544249992
0:00:50.959197677  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1890:gst_ffmpegdec_video_frame:<ffdec_h2640> Using offset converted from timestamp
0:00:50.959273737  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1912:gst_ffmpegdec_video_frame:<ffdec_h2640> We have a valid (reordered) duration
0:00:50.959287496  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1420:clip_video_buffer:<ffdec_h2640> timestamp:0:04:54.544249992 , duration:0:00:00.041708332
0:00:50.959298671  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1457:clip_video_buffer:<ffdec_h2640> dropping
0:00:50.959307331  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1987:gst_ffmpegdec_video_frame:<ffdec_h2640> buffer clipped
0:00:50.959320811  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1970:gst_ffmpegdec_video_frame:<ffdec_h2640> return flow 0, out (nil), len 0
0:00:50.959333732  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:2422:gst_ffmpegdec_sink_event:<ffdec_h2640> NEWSEGMENT in time start 0:04:55.649333331 -- stop 99:99:99.999999999
0:00:50.959430814  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2978:gst_ts_handler_append:<ffdec_h2640> store timestamp @ index [BB] buf_count: 33 ts: 0:04:55.629000000 duration: 0:00:00.041708332, offset: 18446744073709551615, size: 842
0:00:50.959450929  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2518:gst_ffmpegdec_chain:<ffdec_h2640> Received new data of size 842, offset:18446744073709551615, ts:0:04:55.629000000, dur:0:00:00.041708332
0:00:50.959468390  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2195:gst_ffmpegdec_frame:<ffdec_h2640> data:0x1cdfb80, size:842, offset:-1, ts:0:04:55.629000000, dur:0:00:00.041708332
0:00:50.959481381  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1715:gst_ffmpegdec_video_frame:<ffdec_h2640> Going to store opaque values, current ts:0:04:55.629000000, offset: -1
0:00:50.959491788  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:3049:gst_ts_handler_get_ts:<ffdec_h2640> Index 154 yielded ts: 99:99:99.999999999, duration: 99:99:99.999999999, offset: -1
0:00:50.959537465  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1612:opaque_store:<ffdec_h2640> Stored ts:99:99:99.999999999, duration:99:99:99.999999999, offset:18446744073709551615 as opaque 0x1cf9540
0:00:50.959569453  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:966:gst_ffmpegdec_get_buffer:<ffdec_h2640> getting buffer, apply pts 295629000000
0:00:50.959583282  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:983:gst_ffmpegdec_get_buffer:<ffdec_h2640> dimension 848x480, coded 848x480
0:00:50.959592711  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:985:gst_ffmpegdec_get_buffer:<ffdec_h2640> direct rendering disabled, fallback alloc
0:00:50.959602699  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:989:gst_ffmpegdec_get_buffer:<ffdec_h2640> linsize 880 440 440
0:00:50.959613664  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:992:gst_ffmpegdec_get_buffer:<ffdec_h2640> data 0 45889848 46002952
0:00:50.966003633  6075      0x12be620 DEBUG                 ffmpeg :0:: no picture
0:00:50.966045120  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:3007:gst_ts_handler_consume:<ffdec_h2640> Stepping over 842 bytes @ index 154 has 39084 bytes
0:00:50.966062791  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1738:gst_ffmpegdec_video_frame:<ffdec_h2640> after decode: len 842, have_data 0
0:00:50.966072499  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1970:gst_ffmpegdec_video_frame:<ffdec_h2640> return flow 0, out (nil), len 842
0:00:50.966084582  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:2271:gst_ffmpegdec_frame:<ffdec_h2640> We didn't get a decoded buffer
0:00:50.966093522  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2672:gst_ffmpegdec_chain:<ffdec_h2640> Before (while bsize>0).  bsize:0 , bdata:0x7f964415da81
0:00:50.966153587  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2978:gst_ts_handler_append:<ffdec_h2640> store timestamp @ index [BC] buf_count: 34 ts: 0:04:55.670000000 duration: 0:00:00.041708332, offset: 18446744073709551615, size: 724
0:00:50.966170350  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2518:gst_ffmpegdec_chain:<ffdec_h2640> Received new data of size 724, offset:18446744073709551615, ts:0:04:55.670000000, dur:0:00:00.041708332
0:00:50.966183969  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2195:gst_ffmpegdec_frame:<ffdec_h2640> data:0x1cdfb80, size:724, offset:-1, ts:0:04:55.670000000, dur:0:00:00.041708332
0:00:50.966195912  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1345:gst_ffmpegdec_do_qos:<ffdec_h2640> QOS: qostime 0:00:47.328000000, earliest 0:00:45.433646000
0:00:50.966206878  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1715:gst_ffmpegdec_video_frame:<ffdec_h2640> Going to store opaque values, current ts:0:04:55.670000000, offset: -1
0:00:50.966217354  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:3049:gst_ts_handler_get_ts:<ffdec_h2640> Index 154 yielded ts: 99:99:99.999999999, duration: 99:99:99.999999999, offset: -1
0:00:50.966258143  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1612:opaque_store:<ffdec_h2640> Stored ts:99:99:99.999999999, duration:99:99:99.999999999, offset:18446744073709551615 as opaque 0x26f3060
0:00:50.966281540  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:966:gst_ffmpegdec_get_buffer:<ffdec_h2640> getting buffer, apply pts 295670000000
0:00:50.966293064  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:983:gst_ffmpegdec_get_buffer:<ffdec_h2640> dimension 848x480, coded 848x480
0:00:50.966302004  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:985:gst_ffmpegdec_get_buffer:<ffdec_h2640> direct rendering disabled, fallback alloc
0:00:50.966311293  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:989:gst_ffmpegdec_get_buffer:<ffdec_h2640> linsize 880 440 440
0:00:50.966320513  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:992:gst_ffmpegdec_get_buffer:<ffdec_h2640> data 0 34063896 34177000
0:00:50.972493758  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:3007:gst_ts_handler_consume:<ffdec_h2640> Stepping over 724 bytes @ index 154 has 38242 bytes
0:00:50.972552357  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1738:gst_ffmpegdec_video_frame:<ffdec_h2640> after decode: len 724, have_data 296
0:00:50.972604670  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1633:opaque_find:<ffdec_h2640> Found opaque 0x1cf9540 - ts:99:99:99.999999999, duration:99:99:99.999999999, offset:-1
0:00:50.972620314  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1769:gst_ffmpegdec_video_frame:<ffdec_h2640> Found opaque values, current ts:0:04:55.670000000, offset: -1
0:00:50.972630232  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1774:gst_ffmpegdec_video_frame:<ffdec_h2640> ts-handler: pts 18446744073709551615 duration 18446744073709551615
0:00:50.972639591  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1776:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: pts 295629000000
0:00:50.972649788  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1778:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: num 1224
0:00:50.972658938  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1780:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: ref 0
0:00:50.972667598  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1782:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: display 0
0:00:50.972676259  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1784:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: opaque (nil)
0:00:50.972687993  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1786:gst_ffmpegdec_video_frame:<ffdec_h2640> repeat_pict:0
0:00:50.972723683  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1788:gst_ffmpegdec_video_frame:<ffdec_h2640> interlaced_frame:0
0:00:50.972737581  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1494:check_keyframe:<ffdec_h2640> current picture: type: 3, is_keyframe:0, is_itype:0, is_reference:0
0:00:50.972747779  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1520:get_output_buffer:<ffdec_h2640> get output buffer
0:00:50.972756369  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1535:get_output_buffer:<ffdec_h2640> clip width 848/height 480
0:00:50.972766636  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:900:alloc_output_buffer:<ffdec_h2640> alloc output buffer
0:00:50.972777183  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:912:alloc_output_buffer:<ffdec_h2640> calling pad_alloc
0:00:50.972869376  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1549:get_output_buffer:<ffdec_h2640> linsize 880 440 440
0:00:50.972891516  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1552:get_output_buffer:<ffdec_h2640> data 0 45889848 46002952
0:00:50.973285363  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1871:gst_ffmpegdec_video_frame:<ffdec_h2640> using next timestamp 0:04:54.585958324
0:00:50.973322450  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1890:gst_ffmpegdec_video_frame:<ffdec_h2640> Using offset converted from timestamp
0:00:50.973391036  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1937:gst_ffmpegdec_video_frame:<ffdec_h2640> using in_duration
0:00:50.973408497  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1420:clip_video_buffer:<ffdec_h2640> timestamp:0:04:54.585958324 , duration:0:00:00.041708332
0:00:50.973420161  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1457:clip_video_buffer:<ffdec_h2640> dropping
0:00:50.973428961  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1987:gst_ffmpegdec_video_frame:<ffdec_h2640> buffer clipped
0:00:50.973441742  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1970:gst_ffmpegdec_video_frame:<ffdec_h2640> return flow 0, out (nil), len 724
0:00:50.973453476  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:2271:gst_ffmpegdec_frame:<ffdec_h2640> We didn't get a decoded buffer
0:00:50.973462486  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2672:gst_ffmpegdec_chain:<ffdec_h2640> Before (while bsize>0).  bsize:0 , bdata:0x7f964415dd5c
0:00:50.973494125  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2978:gst_ts_handler_append:<ffdec_h2640> store timestamp @ index [BD] buf_count: 35 ts: 0:04:55.712000000 duration: 0:00:00.041708332, offset: 18446744073709551615, size: 797
0:00:50.973510049  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2518:gst_ffmpegdec_chain:<ffdec_h2640> Received new data of size 797, offset:18446744073709551615, ts:0:04:55.712000000, dur:0:00:00.041708332
0:00:50.973524297  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2195:gst_ffmpegdec_frame:<ffdec_h2640> data:0x1cdfb80, size:797, offset:-1, ts:0:04:55.712000000, dur:0:00:00.041708332
0:00:50.973536520  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1345:gst_ffmpegdec_do_qos:<ffdec_h2640> QOS: qostime 0:00:47.370000000, earliest 0:00:45.433646000
0:00:50.973546577  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1715:gst_ffmpegdec_video_frame:<ffdec_h2640> Going to store opaque values, current ts:0:04:55.712000000, offset: -1
0:00:50.973557054  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:3049:gst_ts_handler_get_ts:<ffdec_h2640> Index 154 yielded ts: 99:99:99.999999999, duration: 99:99:99.999999999, offset: -1
0:00:50.973596306  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1612:opaque_store:<ffdec_h2640> Stored ts:99:99:99.999999999, duration:99:99:99.999999999, offset:18446744073709551615 as opaque 0x26bf6c0
0:00:50.973642123  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1074:gst_ffmpegdec_release_buffer:<ffdec_h2640> default release buffer
0:00:50.973658746  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:966:gst_ffmpegdec_get_buffer:<ffdec_h2640> getting buffer, apply pts 295712000000
0:00:50.973668524  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:983:gst_ffmpegdec_get_buffer:<ffdec_h2640> dimension 848x480, coded 848x480
0:00:50.973677184  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:985:gst_ffmpegdec_get_buffer:<ffdec_h2640> direct rendering disabled, fallback alloc
0:00:50.973686264  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:989:gst_ffmpegdec_get_buffer:<ffdec_h2640> linsize 880 440 440
0:00:50.973695483  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:992:gst_ffmpegdec_get_buffer:<ffdec_h2640> data 0 45889848 46002952
0:00:50.979881371  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:3007:gst_ts_handler_consume:<ffdec_h2640> Stepping over 797 bytes @ index 154 has 37518 bytes
0:00:50.979940738  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1738:gst_ffmpegdec_video_frame:<ffdec_h2640> after decode: len 797, have_data 296
0:00:50.979995146  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1633:opaque_find:<ffdec_h2640> Found opaque 0x26f3060 - ts:99:99:99.999999999, duration:99:99:99.999999999, offset:-1
0:00:50.980013235  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1769:gst_ffmpegdec_video_frame:<ffdec_h2640> Found opaque values, current ts:0:04:55.712000000, offset: -1
0:00:50.980023293  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1774:gst_ffmpegdec_video_frame:<ffdec_h2640> ts-handler: pts 18446744073709551615 duration 18446744073709551615
0:00:50.980033141  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1776:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: pts 295670000000
0:00:50.980042220  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1778:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: num 1225
0:00:50.980050951  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1780:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: ref 0
0:00:50.980059541  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1782:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: display 0
0:00:50.980067992  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1784:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: opaque (nil)
0:00:50.980079097  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1786:gst_ffmpegdec_video_frame:<ffdec_h2640> repeat_pict:0
0:00:50.980088247  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1788:gst_ffmpegdec_video_frame:<ffdec_h2640> interlaced_frame:0
0:00:50.980097815  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1494:check_keyframe:<ffdec_h2640> current picture: type: 3, is_keyframe:0, is_itype:0, is_reference:0
0:00:50.980108013  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1520:get_output_buffer:<ffdec_h2640> get output buffer
0:00:50.980117162  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1535:get_output_buffer:<ffdec_h2640> clip width 848/height 480
0:00:50.980126172  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:900:alloc_output_buffer:<ffdec_h2640> alloc output buffer
0:00:50.980136579  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:912:alloc_output_buffer:<ffdec_h2640> calling pad_alloc
0:00:50.980220880  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1549:get_output_buffer:<ffdec_h2640> linsize 880 440 440
0:00:50.980240366  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1552:get_output_buffer:<ffdec_h2640> data 0 34063896 34177000
0:00:50.980596916  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1871:gst_ffmpegdec_video_frame:<ffdec_h2640> using next timestamp 0:04:54.627666656
0:00:50.980657540  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1890:gst_ffmpegdec_video_frame:<ffdec_h2640> Using offset converted from timestamp
0:00:50.980734577  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1937:gst_ffmpegdec_video_frame:<ffdec_h2640> using in_duration
0:00:50.980748057  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1420:clip_video_buffer:<ffdec_h2640> timestamp:0:04:54.627666656 , duration:0:00:00.041708332
0:00:50.980759581  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1457:clip_video_buffer:<ffdec_h2640> dropping
0:00:50.980768172  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1987:gst_ffmpegdec_video_frame:<ffdec_h2640> buffer clipped
0:00:50.980780953  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1970:gst_ffmpegdec_video_frame:<ffdec_h2640> return flow 0, out (nil), len 797
0:00:50.980793455  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:2271:gst_ffmpegdec_frame:<ffdec_h2640> We didn't get a decoded buffer
0:00:50.980802605  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2672:gst_ffmpegdec_chain:<ffdec_h2640> Before (while bsize>0).  bsize:0 , bdata:0x7f964415e080
0:00:50.980833126  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2978:gst_ts_handler_append:<ffdec_h2640> store timestamp @ index [BE] buf_count: 36 ts: 0:04:55.754000000 duration: 0:00:00.041708332, offset: 18446744073709551615, size: 781
0:00:50.980848981  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2518:gst_ffmpegdec_chain:<ffdec_h2640> Received new data of size 781, offset:18446744073709551615, ts:0:04:55.754000000, dur:0:00:00.041708332
0:00:50.980862950  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2195:gst_ffmpegdec_frame:<ffdec_h2640> data:0x1cdfb80, size:781, offset:-1, ts:0:04:55.754000000, dur:0:00:00.041708332
0:00:50.980875382  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1345:gst_ffmpegdec_do_qos:<ffdec_h2640> QOS: qostime 0:00:47.412000000, earliest 0:00:45.433646000
0:00:50.980885788  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1715:gst_ffmpegdec_video_frame:<ffdec_h2640> Going to store opaque values, current ts:0:04:55.754000000, offset: -1
0:00:50.980907789  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:3049:gst_ts_handler_get_ts:<ffdec_h2640> Index 154 yielded ts: 99:99:99.999999999, duration: 99:99:99.999999999, offset: -1
0:00:50.980960660  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1612:opaque_store:<ffdec_h2640> Stored ts:99:99:99.999999999, duration:99:99:99.999999999, offset:18446744073709551615 as opaque 0x26883a0
0:00:50.980991741  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1074:gst_ffmpegdec_release_buffer:<ffdec_h2640> default release buffer
0:00:50.981007455  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:966:gst_ffmpegdec_get_buffer:<ffdec_h2640> getting buffer, apply pts 295754000000
0:00:50.981016954  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:983:gst_ffmpegdec_get_buffer:<ffdec_h2640> dimension 848x480, coded 848x480
0:00:50.981026383  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:985:gst_ffmpegdec_get_buffer:<ffdec_h2640> direct rendering disabled, fallback alloc
0:00:50.981035742  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:989:gst_ffmpegdec_get_buffer:<ffdec_h2640> linsize 880 440 440
0:00:50.981045450  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:992:gst_ffmpegdec_get_buffer:<ffdec_h2640> data 0 34063896 34177000
0:00:50.987291053  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:3007:gst_ts_handler_consume:<ffdec_h2640> Stepping over 781 bytes @ index 154 has 36721 bytes
0:00:50.987351189  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1738:gst_ffmpegdec_video_frame:<ffdec_h2640> after decode: len 781, have_data 296
0:00:50.987428226  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1633:opaque_find:<ffdec_h2640> Found opaque 0x26bf6c0 - ts:99:99:99.999999999, duration:99:99:99.999999999, offset:-1
0:00:50.987446664  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1769:gst_ffmpegdec_video_frame:<ffdec_h2640> Found opaque values, current ts:0:04:55.754000000, offset: -1
0:00:50.987456512  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1774:gst_ffmpegdec_video_frame:<ffdec_h2640> ts-handler: pts 18446744073709551615 duration 18446744073709551615
0:00:50.987466221  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1776:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: pts 295712000000
0:00:50.987477116  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1778:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: num 1226
0:00:50.987486126  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1780:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: ref 0
0:00:50.987494298  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1782:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: display 0
0:00:50.987502399  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1784:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: opaque (nil)
0:00:50.987512806  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1786:gst_ffmpegdec_video_frame:<ffdec_h2640> repeat_pict:0
0:00:50.987521257  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1788:gst_ffmpegdec_video_frame:<ffdec_h2640> interlaced_frame:0
0:00:50.987530127  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1494:check_keyframe:<ffdec_h2640> current picture: type: 3, is_keyframe:0, is_itype:0, is_reference:0
0:00:50.987539277  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1520:get_output_buffer:<ffdec_h2640> get output buffer
0:00:50.987547937  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1535:get_output_buffer:<ffdec_h2640> clip width 848/height 480
0:00:50.987556458  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:900:alloc_output_buffer:<ffdec_h2640> alloc output buffer
0:00:50.987565887  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:912:alloc_output_buffer:<ffdec_h2640> calling pad_alloc
0:00:50.987638315  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1549:get_output_buffer:<ffdec_h2640> linsize 880 440 440
0:00:50.987650747  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1552:get_output_buffer:<ffdec_h2640> data 0 45889848 46002952
0:00:50.988027412  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1871:gst_ffmpegdec_video_frame:<ffdec_h2640> using next timestamp 0:04:54.669374988
0:00:50.988064429  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1890:gst_ffmpegdec_video_frame:<ffdec_h2640> Using offset converted from timestamp
0:00:50.988131269  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1937:gst_ffmpegdec_video_frame:<ffdec_h2640> using in_duration
0:00:50.988149568  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1420:clip_video_buffer:<ffdec_h2640> timestamp:0:04:54.669374988 , duration:0:00:00.041708332
0:00:50.988160813  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1457:clip_video_buffer:<ffdec_h2640> dropping
0:00:50.988169473  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1987:gst_ffmpegdec_video_frame:<ffdec_h2640> buffer clipped
0:00:50.988182464  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1970:gst_ffmpegdec_video_frame:<ffdec_h2640> return flow 0, out (nil), len 781
0:00:50.988193779  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:2271:gst_ffmpegdec_frame:<ffdec_h2640> We didn't get a decoded buffer
0:00:50.988204116  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2672:gst_ffmpegdec_chain:<ffdec_h2640> Before (while bsize>0).  bsize:0 , bdata:0x7f964415e394
0:00:50.988235336  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2978:gst_ts_handler_append:<ffdec_h2640> store timestamp @ index [BF] buf_count: 37 ts: 0:04:55.837000000 duration: 0:00:00.041708332, offset: 18446744073709551615, size: 736
0:00:50.988274727  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2518:gst_ffmpegdec_chain:<ffdec_h2640> Received new data of size 736, offset:18446744073709551615, ts:0:04:55.837000000, dur:0:00:00.041708332
0:00:50.988293445  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2195:gst_ffmpegdec_frame:<ffdec_h2640> data:0x1cdfb80, size:736, offset:-1, ts:0:04:55.837000000, dur:0:00:00.041708332
0:00:50.988306017  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1345:gst_ffmpegdec_do_qos:<ffdec_h2640> QOS: qostime 0:00:47.495000000, earliest 0:00:45.433646000
0:00:50.988316284  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1715:gst_ffmpegdec_video_frame:<ffdec_h2640> Going to store opaque values, current ts:0:04:55.837000000, offset: -1
0:00:50.988326691  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:3049:gst_ts_handler_get_ts:<ffdec_h2640> Index 154 yielded ts: 99:99:99.999999999, duration: 99:99:99.999999999, offset: -1
0:00:50.988374394  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1612:opaque_store:<ffdec_h2640> Stored ts:99:99:99.999999999, duration:99:99:99.999999999, offset:18446744073709551615 as opaque 0x2742b00
0:00:50.988404426  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1074:gst_ffmpegdec_release_buffer:<ffdec_h2640> default release buffer
0:00:50.988420979  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:966:gst_ffmpegdec_get_buffer:<ffdec_h2640> getting buffer, apply pts 295837000000
0:00:50.988430618  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:983:gst_ffmpegdec_get_buffer:<ffdec_h2640> dimension 848x480, coded 848x480
0:00:50.988439558  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:985:gst_ffmpegdec_get_buffer:<ffdec_h2640> direct rendering disabled, fallback alloc
0:00:50.988449266  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:989:gst_ffmpegdec_get_buffer:<ffdec_h2640> linsize 880 440 440
0:00:50.988458485  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:992:gst_ffmpegdec_get_buffer:<ffdec_h2640> data 0 45889848 46002952
0:00:50.995091021  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:3007:gst_ts_handler_consume:<ffdec_h2640> Stepping over 736 bytes @ index 154 has 35940 bytes
0:00:50.995147315  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1738:gst_ffmpegdec_video_frame:<ffdec_h2640> after decode: len 736, have_data 296
0:00:50.995197393  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1633:opaque_find:<ffdec_h2640> Found opaque 0x26883a0 - ts:99:99:99.999999999, duration:99:99:99.999999999, offset:-1
0:00:50.995212619  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1769:gst_ffmpegdec_video_frame:<ffdec_h2640> Found opaque values, current ts:0:04:55.837000000, offset: -1
0:00:50.995223095  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1774:gst_ffmpegdec_video_frame:<ffdec_h2640> ts-handler: pts 18446744073709551615 duration 18446744073709551615
0:00:50.995232384  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1776:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: pts 295754000000
0:00:50.995241534  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1778:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: num 1227
0:00:50.995250404  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1780:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: ref 0
0:00:50.995259204  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1782:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: display 0
0:00:50.995268004  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1784:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: opaque (nil)
0:00:50.995278551  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1786:gst_ffmpegdec_video_frame:<ffdec_h2640> repeat_pict:0
0:00:50.995310749  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1788:gst_ffmpegdec_video_frame:<ffdec_h2640> interlaced_frame:0
0:00:50.995322901  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1494:check_keyframe:<ffdec_h2640> current picture: type: 3, is_keyframe:0, is_itype:0, is_reference:0
0:00:50.995332819  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1520:get_output_buffer:<ffdec_h2640> get output buffer
0:00:50.995341619  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1535:get_output_buffer:<ffdec_h2640> clip width 848/height 480
0:00:50.995350489  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:900:alloc_output_buffer:<ffdec_h2640> alloc output buffer
0:00:50.995360477  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:912:alloc_output_buffer:<ffdec_h2640> calling pad_alloc
0:00:50.995432555  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1549:get_output_buffer:<ffdec_h2640> linsize 880 440 440
0:00:50.995446175  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1552:get_output_buffer:<ffdec_h2640> data 0 34063896 34177000
0:00:50.995804122  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1871:gst_ffmpegdec_video_frame:<ffdec_h2640> using next timestamp 0:04:54.711083320
0:00:50.995840580  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1890:gst_ffmpegdec_video_frame:<ffdec_h2640> Using offset converted from timestamp
0:00:50.995911471  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1937:gst_ffmpegdec_video_frame:<ffdec_h2640> using in_duration
0:00:50.995929281  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1420:clip_video_buffer:<ffdec_h2640> timestamp:0:04:54.711083320 , duration:0:00:00.041708332
0:00:50.995940456  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1457:clip_video_buffer:<ffdec_h2640> dropping
0:00:50.995948977  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1987:gst_ffmpegdec_video_frame:<ffdec_h2640> buffer clipped
0:00:50.995961898  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1970:gst_ffmpegdec_video_frame:<ffdec_h2640> return flow 0, out (nil), len 736
0:00:50.995973632  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:2271:gst_ffmpegdec_frame:<ffdec_h2640> We didn't get a decoded buffer
0:00:50.995982642  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2672:gst_ffmpegdec_chain:<ffdec_h2640> Before (while bsize>0).  bsize:0 , bdata:0x7f964415e67b
0:00:50.996014281  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2978:gst_ts_handler_append:<ffdec_h2640> store timestamp @ index [C0] buf_count: 38 ts: 0:04:55.879000000 duration: 0:00:00.041708332, offset: 18446744073709551615, size: 805
0:00:50.996029926  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2518:gst_ffmpegdec_chain:<ffdec_h2640> Received new data of size 805, offset:18446744073709551615, ts:0:04:55.879000000, dur:0:00:00.041708332
0:00:50.996045780  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2195:gst_ffmpegdec_frame:<ffdec_h2640> data:0x1cdfb80, size:805, offset:-1, ts:0:04:55.879000000, dur:0:00:00.041708332
0:00:50.996060587  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1345:gst_ffmpegdec_do_qos:<ffdec_h2640> QOS: qostime 0:00:47.537000000, earliest 0:00:45.433646000
0:00:50.996071273  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1715:gst_ffmpegdec_video_frame:<ffdec_h2640> Going to store opaque values, current ts:0:04:55.879000000, offset: -1
0:00:50.996083007  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:3049:gst_ts_handler_get_ts:<ffdec_h2640> Index 154 yielded ts: 99:99:99.999999999, duration: 99:99:99.999999999, offset: -1
0:00:50.996131548  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1612:opaque_store:<ffdec_h2640> Stored ts:99:99:99.999999999, duration:99:99:99.999999999, offset:18446744073709551615 as opaque 0x281aea0
0:00:50.996190077  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1074:gst_ffmpegdec_release_buffer:<ffdec_h2640> default release buffer
0:00:50.996210401  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:966:gst_ffmpegdec_get_buffer:<ffdec_h2640> getting buffer, apply pts 295879000000
0:00:50.996220528  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:983:gst_ffmpegdec_get_buffer:<ffdec_h2640> dimension 848x480, coded 848x480
0:00:50.996230586  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:985:gst_ffmpegdec_get_buffer:<ffdec_h2640> direct rendering disabled, fallback alloc
0:00:50.996240783  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:989:gst_ffmpegdec_get_buffer:<ffdec_h2640> linsize 880 440 440
0:00:50.996249653  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:992:gst_ffmpegdec_get_buffer:<ffdec_h2640> data 0 34063896 34177000
0:00:51.002804244  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:3007:gst_ts_handler_consume:<ffdec_h2640> Stepping over 805 bytes @ index 154 has 35204 bytes
0:00:51.002864658  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1738:gst_ffmpegdec_video_frame:<ffdec_h2640> after decode: len 805, have_data 296
0:00:51.002922419  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1633:opaque_find:<ffdec_h2640> Found opaque 0x2742b00 - ts:99:99:99.999999999, duration:99:99:99.999999999, offset:-1
0:00:51.002941276  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1769:gst_ffmpegdec_video_frame:<ffdec_h2640> Found opaque values, current ts:0:04:55.879000000, offset: -1
0:00:51.002951543  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1774:gst_ffmpegdec_video_frame:<ffdec_h2640> ts-handler: pts 18446744073709551615 duration 18446744073709551615
0:00:51.002961321  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1776:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: pts 295837000000
0:00:51.002970471  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1778:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: num 1228
0:00:51.003078938  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1780:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: ref 0
0:00:51.003093116  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1782:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: display 0
0:00:51.003102824  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1784:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: opaque (nil)
0:00:51.003113580  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1786:gst_ffmpegdec_video_frame:<ffdec_h2640> repeat_pict:0
0:00:51.003122171  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1788:gst_ffmpegdec_video_frame:<ffdec_h2640> interlaced_frame:0
0:00:51.003131599  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1494:check_keyframe:<ffdec_h2640> current picture: type: 3, is_keyframe:0, is_itype:0, is_reference:0
0:00:51.003140889  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1520:get_output_buffer:<ffdec_h2640> get output buffer
0:00:51.003149410  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1535:get_output_buffer:<ffdec_h2640> clip width 848/height 480
0:00:51.003158280  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:900:alloc_output_buffer:<ffdec_h2640> alloc output buffer
0:00:51.003168547  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:912:alloc_output_buffer:<ffdec_h2640> calling pad_alloc
0:00:51.003241673  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1549:get_output_buffer:<ffdec_h2640> linsize 880 440 440
0:00:51.003255781  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1552:get_output_buffer:<ffdec_h2640> data 0 45889848 46002952
0:00:51.003629094  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1871:gst_ffmpegdec_video_frame:<ffdec_h2640> using next timestamp 0:04:54.752791652
0:00:51.003688391  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1890:gst_ffmpegdec_video_frame:<ffdec_h2640> Using offset converted from timestamp
0:00:51.003758513  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1937:gst_ffmpegdec_video_frame:<ffdec_h2640> using in_duration
0:00:51.003774438  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1420:clip_video_buffer:<ffdec_h2640> timestamp:0:04:54.752791652 , duration:0:00:00.041708332
0:00:51.003785822  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1457:clip_video_buffer:<ffdec_h2640> dropping
0:00:51.003794762  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1987:gst_ffmpegdec_video_frame:<ffdec_h2640> buffer clipped
0:00:51.003807753  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1970:gst_ffmpegdec_video_frame:<ffdec_h2640> return flow 0, out (nil), len 805
0:00:51.003819207  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:2271:gst_ffmpegdec_frame:<ffdec_h2640> We didn't get a decoded buffer
0:00:51.003828287  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2672:gst_ffmpegdec_chain:<ffdec_h2640> Before (while bsize>0).  bsize:0 , bdata:0x7f964415e9a7
0:00:51.003859647  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2978:gst_ts_handler_append:<ffdec_h2640> store timestamp @ index [C1] buf_count: 39 ts: 0:04:55.921000000 duration: 0:00:00.041708332, offset: 18446744073709551615, size: 586
0:00:51.003874663  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2518:gst_ffmpegdec_chain:<ffdec_h2640> Received new data of size 586, offset:18446744073709551615, ts:0:04:55.921000000, dur:0:00:00.041708332
0:00:51.003888632  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2195:gst_ffmpegdec_frame:<ffdec_h2640> data:0x1cdfb80, size:586, offset:-1, ts:0:04:55.921000000, dur:0:00:00.041708332
0:00:51.003900994  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1345:gst_ffmpegdec_do_qos:<ffdec_h2640> QOS: qostime 0:00:47.579000000, earliest 0:00:45.433646000
0:00:51.003912239  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1715:gst_ffmpegdec_video_frame:<ffdec_h2640> Going to store opaque values, current ts:0:04:55.921000000, offset: -1
0:00:51.003921947  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:3049:gst_ts_handler_get_ts:<ffdec_h2640> Index 154 yielded ts: 99:99:99.999999999, duration: 99:99:99.999999999, offset: -1
0:00:51.003960570  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1612:opaque_store:<ffdec_h2640> Stored ts:99:99:99.999999999, duration:99:99:99.999999999, offset:18446744073709551615 as opaque 0x1d37a00
0:00:51.003985295  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1074:gst_ffmpegdec_release_buffer:<ffdec_h2640> default release buffer
0:00:51.003999892  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:966:gst_ffmpegdec_get_buffer:<ffdec_h2640> getting buffer, apply pts 295921000000
0:00:51.004009181  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:983:gst_ffmpegdec_get_buffer:<ffdec_h2640> dimension 848x480, coded 848x480
0:00:51.004018470  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:985:gst_ffmpegdec_get_buffer:<ffdec_h2640> direct rendering disabled, fallback alloc
0:00:51.004027620  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:989:gst_ffmpegdec_get_buffer:<ffdec_h2640> linsize 880 440 440
0:00:51.004036560  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:992:gst_ffmpegdec_get_buffer:<ffdec_h2640> data 0 45889848 46002952
0:00:51.006563074  6075      0x1312030 LOG                   ffmpeg gstffmpegdec.c:2672:gst_ffmpegdec_chain:<ffdec_aac0> Before (while bsize>0).  bsize:0 , bdata:0x7f96440da5c9
0:00:51.006640111  6075      0x1312030 LOG                   ffmpeg gstffmpegdec.c:2978:gst_ts_handler_append:<ffdec_aac0> store timestamp @ index [49] buf_count: 2376 ts: 0:04:54.378666666 duration: 0:00:00.021333333, offset: 18446744073709551615, size: 515
0:00:51.006678665  6075      0x1312030 LOG                   ffmpeg gstffmpegdec.c:2518:gst_ffmpegdec_chain:<ffdec_aac0> Received new data of size 515, offset:18446744073709551615, ts:0:04:54.378666666, dur:0:00:00.021333333
0:00:51.006695637  6075      0x1312030 LOG                   ffmpeg gstffmpegdec.c:2195:gst_ffmpegdec_frame:<ffdec_aac0> data:0x7f964414a8f0, size:515, offset:-1, ts:0:04:54.378666666, dur:0:00:00.021333333
0:00:51.006707929  6075      0x1312030 DEBUG                 ffmpeg gstffmpegdec.c:2077:gst_ffmpegdec_audio_frame:<ffdec_aac0> size:515, offset:-1, ts:0:04:54.378666666, dur:0:00:00.021333333, ffmpegdec->next_ts:0:04:54.378666666
0:00:51.007525306  6075      0x1312030 DEBUG                 ffmpeg gstffmpegdec.c:2086:gst_ffmpegdec_audio_frame:<ffdec_aac0> Decode audio: len=515, have_data=4096
0:00:51.007570564  6075      0x1312030 DEBUG                 ffmpeg gstffmpegdec.c:2089:gst_ffmpegdec_audio_frame:<ffdec_aac0> Creating output buffer
0:00:51.007583904  6075      0x1312030 DEBUG                 ffmpeg gstffmpegdec.c:2123:gst_ffmpegdec_audio_frame:<ffdec_aac0> Buffer created. Size:4096 , timestamp:0:04:54.378666666 , duration:0:00:00.021333333
0:00:51.007594660  6075      0x1312030 LOG                   ffmpeg gstffmpegdec.c:2007:clip_audio_buffer:<ffdec_aac0> timestamp:0:04:54.378666666, duration:0:00:00.021333333, size 4096
0:00:51.007606254  6075      0x1312030 LOG                   ffmpeg gstffmpegdec.c:2053:clip_audio_buffer:<ffdec_aac0> not dropping
0:00:51.007615543  6075      0x1312030 DEBUG                 ffmpeg gstffmpegdec.c:2152:gst_ffmpegdec_audio_frame:<ffdec_aac0> return flow 0, out 0x17a28c0, len 515
0:00:51.007624833  6075      0x1312030 LOG                   ffmpeg gstffmpegdec.c:2250:gst_ffmpegdec_frame:<ffdec_aac0> Decoded data, now pushing buffer 0x17a28c0 with offset -1, timestamp 0:04:54.378666666 and duration 0:00:00.021333333
0:00:51.007787498  6075      0x1312030 LOG                   ffmpeg gstffmpegdec.c:2672:gst_ffmpegdec_chain:<ffdec_aac0> Before (while bsize>0).  bsize:0 , bdata:0x7f96440da7cc
0:00:51.007830172  6075      0x1312030 LOG                   ffmpeg gstffmpegdec.c:2978:gst_ts_handler_append:<ffdec_aac0> store timestamp @ index [4A] buf_count: 2377 ts: 0:04:54.399999999 duration: 0:00:00.021333333, offset: 18446744073709551615, size: 483
0:00:51.007846585  6075      0x1312030 LOG                   ffmpeg gstffmpegdec.c:2518:gst_ffmpegdec_chain:<ffdec_aac0> Received new data of size 483, offset:18446744073709551615, ts:0:04:54.399999999, dur:0:00:00.021333333
0:00:51.007860414  6075      0x1312030 LOG                   ffmpeg gstffmpegdec.c:2195:gst_ffmpegdec_frame:<ffdec_aac0> data:0x7f964414a8f0, size:483, offset:-1, ts:0:04:54.399999999, dur:0:00:00.021333333
0:00:51.007871869  6075      0x1312030 DEBUG                 ffmpeg gstffmpegdec.c:2077:gst_ffmpegdec_audio_frame:<ffdec_aac0> size:483, offset:-1, ts:0:04:54.399999999, dur:0:00:00.021333333, ffmpegdec->next_ts:0:04:54.399999999
0:00:51.008083354  6075      0x1312030 DEBUG                 ffmpeg gstffmpegdec.c:2086:gst_ffmpegdec_audio_frame:<ffdec_aac0> Decode audio: len=483, have_data=4096
0:00:51.008105634  6075      0x1312030 DEBUG                 ffmpeg gstffmpegdec.c:2089:gst_ffmpegdec_audio_frame:<ffdec_aac0> Creating output buffer
0:00:51.008117089  6075      0x1312030 DEBUG                 ffmpeg gstffmpegdec.c:2123:gst_ffmpegdec_audio_frame:<ffdec_aac0> Buffer created. Size:4096 , timestamp:0:04:54.399999999 , duration:0:00:00.021333333
0:00:51.008127565  6075      0x1312030 LOG                   ffmpeg gstffmpegdec.c:2007:clip_audio_buffer:<ffdec_aac0> timestamp:0:04:54.399999999, duration:0:00:00.021333333, size 4096
0:00:51.008137692  6075      0x1312030 LOG                   ffmpeg gstffmpegdec.c:2053:clip_audio_buffer:<ffdec_aac0> not dropping
0:00:51.008146702  6075      0x1312030 DEBUG                 ffmpeg gstffmpegdec.c:2152:gst_ffmpegdec_audio_frame:<ffdec_aac0> return flow 0, out 0x7f964417b980, len 483
0:00:51.008173033  6075      0x1312030 LOG                   ffmpeg gstffmpegdec.c:2250:gst_ffmpegdec_frame:<ffdec_aac0> Decoded data, now pushing buffer 0x7f964417b980 with offset -1, timestamp 0:04:54.399999999 and duration 0:00:00.021333333
0:00:51.008263411  6075      0x1312030 LOG                   ffmpeg gstffmpegdec.c:2672:gst_ffmpegdec_chain:<ffdec_aac0> Before (while bsize>0).  bsize:0 , bdata:0x7f96440da9af
0:00:51.008300777  6075      0x1312030 LOG                   ffmpeg gstffmpegdec.c:2978:gst_ts_handler_append:<ffdec_aac0> store timestamp @ index [4B] buf_count: 2378 ts: 0:04:54.421333332 duration: 0:00:00.021333333, offset: 18446744073709551615, size: 503
0:00:51.008317609  6075      0x1312030 LOG                   ffmpeg gstffmpegdec.c:2518:gst_ffmpegdec_chain:<ffdec_aac0> Received new data of size 503, offset:18446744073709551615, ts:0:04:54.421333332, dur:0:00:00.021333333
0:00:51.008329552  6075      0x1312030 LOG                   ffmpeg gstffmpegdec.c:2195:gst_ffmpegdec_frame:<ffdec_aac0> data:0x7f964414a8f0, size:503, offset:-1, ts:0:04:54.421333332, dur:0:00:00.021333333
0:00:51.008340378  6075      0x1312030 DEBUG                 ffmpeg gstffmpegdec.c:2077:gst_ffmpegdec_audio_frame:<ffdec_aac0> size:503, offset:-1, ts:0:04:54.421333332, dur:0:00:00.021333333, ffmpegdec->next_ts:0:04:54.421333332
0:00:51.008528676  6075      0x1312030 DEBUG                 ffmpeg gstffmpegdec.c:2086:gst_ffmpegdec_audio_frame:<ffdec_aac0> Decode audio: len=503, have_data=4096
0:00:51.008547254  6075      0x1312030 DEBUG                 ffmpeg gstffmpegdec.c:2089:gst_ffmpegdec_audio_frame:<ffdec_aac0> Creating output buffer
0:00:51.008557452  6075      0x1312030 DEBUG                 ffmpeg gstffmpegdec.c:2123:gst_ffmpegdec_audio_frame:<ffdec_aac0> Buffer created. Size:4096 , timestamp:0:04:54.421333332 , duration:0:00:00.021333333
0:00:51.008568277  6075      0x1312030 LOG                   ffmpeg gstffmpegdec.c:2007:clip_audio_buffer:<ffdec_aac0> timestamp:0:04:54.421333332, duration:0:00:00.021333333, size 4096
0:00:51.008578335  6075      0x1312030 LOG                   ffmpeg gstffmpegdec.c:2053:clip_audio_buffer:<ffdec_aac0> not dropping
0:00:51.008586925  6075      0x1312030 DEBUG                 ffmpeg gstffmpegdec.c:2152:gst_ffmpegdec_audio_frame:<ffdec_aac0> return flow 0, out 0x7f964408a330, len 503
0:00:51.008596284  6075      0x1312030 LOG                   ffmpeg gstffmpegdec.c:2250:gst_ffmpegdec_frame:<ffdec_aac0> Decoded data, now pushing buffer 0x7f964408a330 with offset -1, timestamp 0:04:54.421333332 and duration 0:00:00.021333333
0:00:51.010597995  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:3007:gst_ts_handler_consume:<ffdec_h2640> Stepping over 586 bytes @ index 154 has 34399 bytes
0:00:51.010649959  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1738:gst_ffmpegdec_video_frame:<ffdec_h2640> after decode: len 586, have_data 296
0:00:51.010692284  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1633:opaque_find:<ffdec_h2640> Found opaque 0x281aea0 - ts:99:99:99.999999999, duration:99:99:99.999999999, offset:-1
0:00:51.010707160  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1769:gst_ffmpegdec_video_frame:<ffdec_h2640> Found opaque values, current ts:0:04:55.921000000, offset: -1
0:00:51.010716659  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1774:gst_ffmpegdec_video_frame:<ffdec_h2640> ts-handler: pts 18446744073709551615 duration 18446744073709551615
0:00:51.010727694  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1776:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: pts 295879000000
0:00:51.010736215  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1778:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: num 1229
0:00:51.010745016  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1780:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: ref 0
0:00:51.010753606  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1782:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: display 0
0:00:51.010778890  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1784:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: opaque (nil)
0:00:51.010791112  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1786:gst_ffmpegdec_video_frame:<ffdec_h2640> repeat_pict:0
0:00:51.010799703  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1788:gst_ffmpegdec_video_frame:<ffdec_h2640> interlaced_frame:0
0:00:51.010808433  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1494:check_keyframe:<ffdec_h2640> current picture: type: 3, is_keyframe:0, is_itype:0, is_reference:0
0:00:51.010817443  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1520:get_output_buffer:<ffdec_h2640> get output buffer
0:00:51.010825964  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1535:get_output_buffer:<ffdec_h2640> clip width 848/height 480
0:00:51.010834415  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:900:alloc_output_buffer:<ffdec_h2640> alloc output buffer
0:00:51.010843844  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:912:alloc_output_buffer:<ffdec_h2640> calling pad_alloc
0:00:51.010914944  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1549:get_output_buffer:<ffdec_h2640> linsize 880 440 440
0:00:51.010926818  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1552:get_output_buffer:<ffdec_h2640> data 0 34063896 34177000
0:00:51.011395397  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1871:gst_ffmpegdec_video_frame:<ffdec_h2640> using next timestamp 0:04:54.794499984
0:00:51.011444078  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1890:gst_ffmpegdec_video_frame:<ffdec_h2640> Using offset converted from timestamp
0:00:51.011529496  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1937:gst_ffmpegdec_video_frame:<ffdec_h2640> using in_duration
0:00:51.011550449  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1420:clip_video_buffer:<ffdec_h2640> timestamp:0:04:54.794499984 , duration:0:00:00.041708332
0:00:51.011562532  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1457:clip_video_buffer:<ffdec_h2640> dropping
0:00:51.011571612  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1987:gst_ffmpegdec_video_frame:<ffdec_h2640> buffer clipped
0:00:51.011587536  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1970:gst_ffmpegdec_video_frame:<ffdec_h2640> return flow 0, out (nil), len 586
0:00:51.011601575  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:2271:gst_ffmpegdec_frame:<ffdec_h2640> We didn't get a decoded buffer
0:00:51.011612470  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2672:gst_ffmpegdec_chain:<ffdec_h2640> Before (while bsize>0).  bsize:0 , bdata:0x7f964415ebf8
0:00:51.011650186  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2978:gst_ts_handler_append:<ffdec_h2640> store timestamp @ index [C2] buf_count: 40 ts: 0:04:55.962000000 duration: 0:00:00.041708332, offset: 18446744073709551615, size: 684
0:00:51.011671139  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2518:gst_ffmpegdec_chain:<ffdec_h2640> Received new data of size 684, offset:18446744073709551615, ts:0:04:55.962000000, dur:0:00:00.041708332
0:00:51.011686295  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2195:gst_ffmpegdec_frame:<ffdec_h2640> data:0x1cdfb80, size:684, offset:-1, ts:0:04:55.962000000, dur:0:00:00.041708332
0:00:51.011700612  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1345:gst_ffmpegdec_do_qos:<ffdec_h2640> QOS: qostime 0:00:47.620000000, earliest 0:00:45.433646000
0:00:51.011711159  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1715:gst_ffmpegdec_video_frame:<ffdec_h2640> Going to store opaque values, current ts:0:04:55.962000000, offset: -1
0:00:51.011748315  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:3049:gst_ts_handler_get_ts:<ffdec_h2640> Index 154 yielded ts: 99:99:99.999999999, duration: 99:99:99.999999999, offset: -1
0:00:51.011803981  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1612:opaque_store:<ffdec_h2640> Stored ts:99:99:99.999999999, duration:99:99:99.999999999, offset:18446744073709551615 as opaque 0x281d900
0:00:51.011834642  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1074:gst_ffmpegdec_release_buffer:<ffdec_h2640> default release buffer
0:00:51.011853360  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:966:gst_ffmpegdec_get_buffer:<ffdec_h2640> getting buffer, apply pts 295962000000
0:00:51.011862998  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:983:gst_ffmpegdec_get_buffer:<ffdec_h2640> dimension 848x480, coded 848x480
0:00:51.011871938  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:985:gst_ffmpegdec_get_buffer:<ffdec_h2640> direct rendering disabled, fallback alloc
0:00:51.011881507  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:989:gst_ffmpegdec_get_buffer:<ffdec_h2640> linsize 880 440 440
0:00:51.011891215  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:992:gst_ffmpegdec_get_buffer:<ffdec_h2640> data 0 34063896 34177000
0:00:51.018040784  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:3007:gst_ts_handler_consume:<ffdec_h2640> Stepping over 684 bytes @ index 154 has 33813 bytes
0:00:51.018088626  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1738:gst_ffmpegdec_video_frame:<ffdec_h2640> after decode: len 684, have_data 296
0:00:51.018130882  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1633:opaque_find:<ffdec_h2640> Found opaque 0x1d37a00 - ts:99:99:99.999999999, duration:99:99:99.999999999, offset:-1
0:00:51.018146177  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1769:gst_ffmpegdec_video_frame:<ffdec_h2640> Found opaque values, current ts:0:04:55.962000000, offset: -1
0:00:51.018155885  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1774:gst_ffmpegdec_video_frame:<ffdec_h2640> ts-handler: pts 18446744073709551615 duration 18446744073709551615
0:00:51.018165105  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1776:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: pts 295921000000
0:00:51.018173835  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1778:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: num 1230
0:00:51.018182775  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1780:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: ref 0
0:00:51.018191296  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1782:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: display 0
0:00:51.018199747  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1784:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: opaque (nil)
0:00:51.018210154  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1786:gst_ffmpegdec_video_frame:<ffdec_h2640> repeat_pict:0
0:00:51.018219024  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1788:gst_ffmpegdec_video_frame:<ffdec_h2640> interlaced_frame:0
0:00:51.018227754  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1494:check_keyframe:<ffdec_h2640> current picture: type: 3, is_keyframe:0, is_itype:0, is_reference:0
0:00:51.018237183  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1520:get_output_buffer:<ffdec_h2640> get output buffer
0:00:51.018245774  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1535:get_output_buffer:<ffdec_h2640> clip width 848/height 480
0:00:51.018254504  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:900:alloc_output_buffer:<ffdec_h2640> alloc output buffer
0:00:51.018264422  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:912:alloc_output_buffer:<ffdec_h2640> calling pad_alloc
0:00:51.018335802  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1549:get_output_buffer:<ffdec_h2640> linsize 880 440 440
0:00:51.018366812  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1552:get_output_buffer:<ffdec_h2640> data 0 45889848 46002952
0:00:51.018780635  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1871:gst_ffmpegdec_video_frame:<ffdec_h2640> using next timestamp 0:04:54.836208316
0:00:51.018823589  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1890:gst_ffmpegdec_video_frame:<ffdec_h2640> Using offset converted from timestamp
0:00:51.018887356  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1937:gst_ffmpegdec_video_frame:<ffdec_h2640> using in_duration
0:00:51.018901673  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1420:clip_video_buffer:<ffdec_h2640> timestamp:0:04:54.836208316 , duration:0:00:00.041708332
0:00:51.018912918  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1457:clip_video_buffer:<ffdec_h2640> dropping
0:00:51.018922487  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1987:gst_ffmpegdec_video_frame:<ffdec_h2640> buffer clipped
0:00:51.018935757  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1970:gst_ffmpegdec_video_frame:<ffdec_h2640> return flow 0, out (nil), len 684
0:00:51.018947700  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:2271:gst_ffmpegdec_frame:<ffdec_h2640> We didn't get a decoded buffer
0:00:51.018956989  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2672:gst_ffmpegdec_chain:<ffdec_h2640> Before (while bsize>0).  bsize:0 , bdata:0x7f964415eeab
0:00:51.018987930  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2978:gst_ts_handler_append:<ffdec_h2640> store timestamp @ index [C3] buf_count: 41 ts: 0:04:56.171000000 duration: 0:00:00.041708332, offset: 18446744073709551615, size: 10517
0:00:51.019002807  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2518:gst_ffmpegdec_chain:<ffdec_h2640> Received new data of size 10517, offset:18446744073709551615, ts:0:04:56.171000000, dur:0:00:00.041708332
0:00:51.019022363  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2195:gst_ffmpegdec_frame:<ffdec_h2640> data:0x1cdfb80, size:10517, offset:-1, ts:0:04:56.171000000, dur:0:00:00.041708332
0:00:51.019036820  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1345:gst_ffmpegdec_do_qos:<ffdec_h2640> QOS: qostime 0:00:47.829000000, earliest 0:00:45.433646000
0:00:51.019047157  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1715:gst_ffmpegdec_video_frame:<ffdec_h2640> Going to store opaque values, current ts:0:04:56.171000000, offset: -1
0:00:51.019057145  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:3049:gst_ts_handler_get_ts:<ffdec_h2640> Index 154 yielded ts: 99:99:99.999999999, duration: 99:99:99.999999999, offset: -1
0:00:51.019094930  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1612:opaque_store:<ffdec_h2640> Stored ts:99:99:99.999999999, duration:99:99:99.999999999, offset:18446744073709551615 as opaque 0x26bf6c0
0:00:51.019128385  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1074:gst_ffmpegdec_release_buffer:<ffdec_h2640> default release buffer
0:00:51.019142424  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:966:gst_ffmpegdec_get_buffer:<ffdec_h2640> getting buffer, apply pts 296171000000
0:00:51.019151922  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:983:gst_ffmpegdec_get_buffer:<ffdec_h2640> dimension 848x480, coded 848x480
0:00:51.019161072  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:985:gst_ffmpegdec_get_buffer:<ffdec_h2640> direct rendering disabled, fallback alloc
0:00:51.019170501  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:989:gst_ffmpegdec_get_buffer:<ffdec_h2640> linsize 880 440 440
0:00:51.019180418  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:992:gst_ffmpegdec_get_buffer:<ffdec_h2640> data 0 45889848 46002952
0:00:51.032183926  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:3007:gst_ts_handler_consume:<ffdec_h2640> Stepping over 10517 bytes @ index 154 has 33129 bytes
0:00:51.032233166  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1738:gst_ffmpegdec_video_frame:<ffdec_h2640> after decode: len 10517, have_data 296
0:00:51.032275770  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1633:opaque_find:<ffdec_h2640> Found opaque 0x281d900 - ts:99:99:99.999999999, duration:99:99:99.999999999, offset:-1
0:00:51.032288761  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1769:gst_ffmpegdec_video_frame:<ffdec_h2640> Found opaque values, current ts:0:04:56.171000000, offset: -1
0:00:51.032298400  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1774:gst_ffmpegdec_video_frame:<ffdec_h2640> ts-handler: pts 18446744073709551615 duration 18446744073709551615
0:00:51.032307479  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1776:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: pts 295962000000
0:00:51.032316279  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1778:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: num 1231
0:00:51.032325150  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1780:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: ref 0
0:00:51.032333810  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1782:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: display 0
0:00:51.032342191  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1784:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: opaque (nil)
0:00:51.032352598  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1786:gst_ffmpegdec_video_frame:<ffdec_h2640> repeat_pict:0
0:00:51.032361189  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1788:gst_ffmpegdec_video_frame:<ffdec_h2640> interlaced_frame:0
0:00:51.032369710  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1494:check_keyframe:<ffdec_h2640> current picture: type: 3, is_keyframe:0, is_itype:0, is_reference:0
0:00:51.032378719  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1520:get_output_buffer:<ffdec_h2640> get output buffer
0:00:51.032388218  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1535:get_output_buffer:<ffdec_h2640> clip width 848/height 480
0:00:51.032396599  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:900:alloc_output_buffer:<ffdec_h2640> alloc output buffer
0:00:51.032406168  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:912:alloc_output_buffer:<ffdec_h2640> calling pad_alloc
0:00:51.032476989  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1549:get_output_buffer:<ffdec_h2640> linsize 880 440 440
0:00:51.032488793  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1552:get_output_buffer:<ffdec_h2640> data 0 34063896 34177000
0:00:51.032864271  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1871:gst_ffmpegdec_video_frame:<ffdec_h2640> using next timestamp 0:04:54.877916648
0:00:51.032900729  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1890:gst_ffmpegdec_video_frame:<ffdec_h2640> Using offset converted from timestamp
0:00:51.032970851  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1937:gst_ffmpegdec_video_frame:<ffdec_h2640> using in_duration
0:00:51.032990198  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1420:clip_video_buffer:<ffdec_h2640> timestamp:0:04:54.877916648 , duration:0:00:00.041708332
0:00:51.033001932  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1457:clip_video_buffer:<ffdec_h2640> dropping
0:00:51.033010383  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1987:gst_ffmpegdec_video_frame:<ffdec_h2640> buffer clipped
0:00:51.033022885  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1970:gst_ffmpegdec_video_frame:<ffdec_h2640> return flow 0, out (nil), len 10517
0:00:51.033058435  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:2271:gst_ffmpegdec_frame:<ffdec_h2640> We didn't get a decoded buffer
0:00:51.033069680  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2672:gst_ffmpegdec_chain:<ffdec_h2640> Before (while bsize>0).  bsize:0 , bdata:0x7f96441617c7
0:00:51.033102925  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2978:gst_ts_handler_append:<ffdec_h2640> store timestamp @ index [C4] buf_count: 42 ts: 0:04:56.087000000 duration: 0:00:00.041708332, offset: 18446744073709551615, size: 1618
0:00:51.033118081  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2518:gst_ffmpegdec_chain:<ffdec_h2640> Received new data of size 1618, offset:18446744073709551615, ts:0:04:56.087000000, dur:0:00:00.041708332
0:00:51.033132469  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2195:gst_ffmpegdec_frame:<ffdec_h2640> data:0x1cdfb80, size:1618, offset:-1, ts:0:04:56.087000000, dur:0:00:00.041708332
0:00:51.033145111  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1345:gst_ffmpegdec_do_qos:<ffdec_h2640> QOS: qostime 0:00:47.745000000, earliest 0:00:45.433646000
0:00:51.033155238  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1715:gst_ffmpegdec_video_frame:<ffdec_h2640> Going to store opaque values, current ts:0:04:56.087000000, offset: -1
0:00:51.033165505  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:3049:gst_ts_handler_get_ts:<ffdec_h2640> Index 154 yielded ts: 99:99:99.999999999, duration: 99:99:99.999999999, offset: -1
0:00:51.033202452  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1612:opaque_store:<ffdec_h2640> Stored ts:99:99:99.999999999, duration:99:99:99.999999999, offset:18446744073709551615 as opaque 0x27f56a0
0:00:51.033231088  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1074:gst_ffmpegdec_release_buffer:<ffdec_h2640> default release buffer
0:00:51.033246593  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:966:gst_ffmpegdec_get_buffer:<ffdec_h2640> getting buffer, apply pts 296087000000
0:00:51.033256790  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:983:gst_ffmpegdec_get_buffer:<ffdec_h2640> dimension 848x480, coded 848x480
0:00:51.033265730  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:985:gst_ffmpegdec_get_buffer:<ffdec_h2640> direct rendering disabled, fallback alloc
0:00:51.033274740  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:989:gst_ffmpegdec_get_buffer:<ffdec_h2640> linsize 880 440 440
0:00:51.033284099  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:992:gst_ffmpegdec_get_buffer:<ffdec_h2640> data 0 34063896 34177000
0:00:51.039794758  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:3007:gst_ts_handler_consume:<ffdec_h2640> Stepping over 1618 bytes @ index 154 has 22612 bytes
0:00:51.039851820  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1738:gst_ffmpegdec_video_frame:<ffdec_h2640> after decode: len 1618, have_data 296
0:00:51.039895263  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1633:opaque_find:<ffdec_h2640> Found opaque 0x27f5420 - ts:99:99:99.999999999, duration:99:99:99.999999999, offset:-1
0:00:51.039908812  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1769:gst_ffmpegdec_video_frame:<ffdec_h2640> Found opaque values, current ts:0:04:56.087000000, offset: -1
0:00:51.039918660  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1774:gst_ffmpegdec_video_frame:<ffdec_h2640> ts-handler: pts 18446744073709551615 duration 18446744073709551615
0:00:51.039927880  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1776:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: pts 296004000000
0:00:51.039936470  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1778:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: num 1222
0:00:51.039945480  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1780:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: ref 3
0:00:51.039972579  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1782:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: display 0
0:00:51.039982567  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1784:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: opaque (nil)
0:00:51.039993672  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1786:gst_ffmpegdec_video_frame:<ffdec_h2640> repeat_pict:0
0:00:51.040002263  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1788:gst_ffmpegdec_video_frame:<ffdec_h2640> interlaced_frame:0
0:00:51.040010923  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1494:check_keyframe:<ffdec_h2640> current picture: type: 2, is_keyframe:0, is_itype:0, is_reference:0
0:00:51.040020073  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1833:gst_ffmpegdec_video_frame:<ffdec_h2640> DTS as timestamps, interpolate
0:00:51.040028384  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1520:get_output_buffer:<ffdec_h2640> get output buffer
0:00:51.040036905  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1535:get_output_buffer:<ffdec_h2640> clip width 848/height 480
0:00:51.040045636  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:900:alloc_output_buffer:<ffdec_h2640> alloc output buffer
0:00:51.040055414  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:912:alloc_output_buffer:<ffdec_h2640> calling pad_alloc
0:00:51.040128679  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1549:get_output_buffer:<ffdec_h2640> linsize 880 440 440
0:00:51.040140134  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1552:get_output_buffer:<ffdec_h2640> data 0 3220197032 3220310136
0:00:51.040532933  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1871:gst_ffmpegdec_video_frame:<ffdec_h2640> using next timestamp 0:04:54.919624980
0:00:51.040568064  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1890:gst_ffmpegdec_video_frame:<ffdec_h2640> Using offset converted from timestamp
0:00:51.040638606  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1937:gst_ffmpegdec_video_frame:<ffdec_h2640> using in_duration
0:00:51.040655997  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1420:clip_video_buffer:<ffdec_h2640> timestamp:0:04:54.919624980 , duration:0:00:00.041708332
0:00:51.040667311  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1457:clip_video_buffer:<ffdec_h2640> dropping
0:00:51.040675972  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1987:gst_ffmpegdec_video_frame:<ffdec_h2640> buffer clipped
0:00:51.040689242  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1970:gst_ffmpegdec_video_frame:<ffdec_h2640> return flow 0, out (nil), len 1618
0:00:51.040702093  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:2271:gst_ffmpegdec_frame:<ffdec_h2640> We didn't get a decoded buffer
0:00:51.040711383  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2672:gst_ffmpegdec_chain:<ffdec_h2640> Before (while bsize>0).  bsize:0 , bdata:0x7f9644161e20
0:00:51.040743091  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2978:gst_ts_handler_append:<ffdec_h2640> store timestamp @ index [C5] buf_count: 43 ts: 0:04:56.046000000 duration: 0:00:00.041708332, offset: 18446744073709551615, size: 904
0:00:51.040758946  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2518:gst_ffmpegdec_chain:<ffdec_h2640> Received new data of size 904, offset:18446744073709551615, ts:0:04:56.046000000, dur:0:00:00.041708332
0:00:51.040772915  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2195:gst_ffmpegdec_frame:<ffdec_h2640> data:0x1cdfb80, size:904, offset:-1, ts:0:04:56.046000000, dur:0:00:00.041708332
0:00:51.040785417  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1345:gst_ffmpegdec_do_qos:<ffdec_h2640> QOS: qostime 0:00:47.704000000, earliest 0:00:45.433646000
0:00:51.040819151  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1715:gst_ffmpegdec_video_frame:<ffdec_h2640> Going to store opaque values, current ts:0:04:56.046000000, offset: -1
0:00:51.040831304  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:3049:gst_ts_handler_get_ts:<ffdec_h2640> Index 154 yielded ts: 99:99:99.999999999, duration: 99:99:99.999999999, offset: -1
0:00:51.040868879  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1612:opaque_store:<ffdec_h2640> Stored ts:99:99:99.999999999, duration:99:99:99.999999999, offset:18446744073709551615 as opaque 0x27f5a80
0:00:51.040898493  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:966:gst_ffmpegdec_get_buffer:<ffdec_h2640> getting buffer, apply pts 296046000000
0:00:51.040908900  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:983:gst_ffmpegdec_get_buffer:<ffdec_h2640> dimension 848x480, coded 848x480
0:00:51.040917700  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:985:gst_ffmpegdec_get_buffer:<ffdec_h2640> direct rendering disabled, fallback alloc
0:00:51.041344583  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:989:gst_ffmpegdec_get_buffer:<ffdec_h2640> linsize 880 440 440
0:00:51.041374895  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:992:gst_ffmpegdec_get_buffer:<ffdec_h2640> data 0 3231484600 3229771080
0:00:51.047181393  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:3007:gst_ts_handler_consume:<ffdec_h2640> Stepping over 904 bytes @ index 154 has 20994 bytes
0:00:51.047232588  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1738:gst_ffmpegdec_video_frame:<ffdec_h2640> after decode: len 904, have_data 296
0:00:51.047275122  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1633:opaque_find:<ffdec_h2640> Found opaque 0x27f5a80 - ts:99:99:99.999999999, duration:99:99:99.999999999, offset:-1
0:00:51.047289999  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1769:gst_ffmpegdec_video_frame:<ffdec_h2640> Found opaque values, current ts:0:04:56.046000000, offset: -1
0:00:51.047300126  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1774:gst_ffmpegdec_video_frame:<ffdec_h2640> ts-handler: pts 18446744073709551615 duration 18446744073709551615
0:00:51.047309415  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1776:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: pts 296046000000
0:00:51.047318146  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1778:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: num 1234
0:00:51.047327295  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1780:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: ref 0
0:00:51.047335607  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1782:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: display 0
0:00:51.047344197  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1784:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: opaque (nil)
0:00:51.047354744  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1786:gst_ffmpegdec_video_frame:<ffdec_h2640> repeat_pict:0
0:00:51.047363055  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1788:gst_ffmpegdec_video_frame:<ffdec_h2640> interlaced_frame:0
0:00:51.047371855  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1494:check_keyframe:<ffdec_h2640> current picture: type: 3, is_keyframe:0, is_itype:0, is_reference:0
0:00:51.047381214  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1520:get_output_buffer:<ffdec_h2640> get output buffer
0:00:51.047398605  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1535:get_output_buffer:<ffdec_h2640> clip width 848/height 480
0:00:51.047407336  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:900:alloc_output_buffer:<ffdec_h2640> alloc output buffer
0:00:51.047417673  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:912:alloc_output_buffer:<ffdec_h2640> calling pad_alloc
0:00:51.047529562  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1549:get_output_buffer:<ffdec_h2640> linsize 880 440 440
0:00:51.047548559  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1552:get_output_buffer:<ffdec_h2640> data 0 3231484600 3229771080
0:00:51.047935072  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1871:gst_ffmpegdec_video_frame:<ffdec_h2640> using next timestamp 0:04:54.961333312
0:00:51.047972788  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1890:gst_ffmpegdec_video_frame:<ffdec_h2640> Using offset converted from timestamp
0:00:51.048042910  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1937:gst_ffmpegdec_video_frame:<ffdec_h2640> using in_duration
0:00:51.048061628  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1420:clip_video_buffer:<ffdec_h2640> timestamp:0:04:54.961333312 , duration:0:00:00.041708332
0:00:51.048073292  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1457:clip_video_buffer:<ffdec_h2640> dropping
0:00:51.048082162  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1987:gst_ffmpegdec_video_frame:<ffdec_h2640> buffer clipped
0:00:51.048097179  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1970:gst_ffmpegdec_video_frame:<ffdec_h2640> return flow 0, out (nil), len 904
0:00:51.048109122  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:2271:gst_ffmpegdec_frame:<ffdec_h2640> We didn't get a decoded buffer
0:00:51.048119179  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2672:gst_ffmpegdec_chain:<ffdec_h2640> Before (while bsize>0).  bsize:0 , bdata:0x7f96441621af
0:00:51.048155707  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2978:gst_ts_handler_append:<ffdec_h2640> store timestamp @ index [C6] buf_count: 44 ts: 0:04:56.129000000 duration: 0:00:00.041708332, offset: 18446744073709551615, size: 869
0:00:51.048172121  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2518:gst_ffmpegdec_chain:<ffdec_h2640> Received new data of size 869, offset:18446744073709551615, ts:0:04:56.129000000, dur:0:00:00.041708332
0:00:51.048186299  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2195:gst_ffmpegdec_frame:<ffdec_h2640> data:0x1cdfb80, size:869, offset:-1, ts:0:04:56.129000000, dur:0:00:00.041708332
0:00:51.048198521  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1345:gst_ffmpegdec_do_qos:<ffdec_h2640> QOS: qostime 0:00:47.787000000, earliest 0:00:45.433646000
0:00:51.048208928  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1715:gst_ffmpegdec_video_frame:<ffdec_h2640> Going to store opaque values, current ts:0:04:56.129000000, offset: -1
0:00:51.048218846  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:3049:gst_ts_handler_get_ts:<ffdec_h2640> Index 154 yielded ts: 99:99:99.999999999, duration: 99:99:99.999999999, offset: -1
0:00:51.048258028  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1612:opaque_store:<ffdec_h2640> Stored ts:99:99:99.999999999, duration:99:99:99.999999999, offset:18446744073709551615 as opaque 0x281da60
0:00:51.048283381  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1074:gst_ffmpegdec_release_buffer:<ffdec_h2640> default release buffer
0:00:51.048298677  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:966:gst_ffmpegdec_get_buffer:<ffdec_h2640> getting buffer, apply pts 296129000000
0:00:51.048308106  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:983:gst_ffmpegdec_get_buffer:<ffdec_h2640> dimension 848x480, coded 848x480
0:00:51.048317185  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:985:gst_ffmpegdec_get_buffer:<ffdec_h2640> direct rendering disabled, fallback alloc
0:00:51.048326265  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:989:gst_ffmpegdec_get_buffer:<ffdec_h2640> linsize 880 440 440
0:00:51.048335484  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:992:gst_ffmpegdec_get_buffer:<ffdec_h2640> data 0 3231484600 3229771080
0:00:51.053740313  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:3007:gst_ts_handler_consume:<ffdec_h2640> Stepping over 869 bytes @ index 154 has 20090 bytes
0:00:51.053791509  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1738:gst_ffmpegdec_video_frame:<ffdec_h2640> after decode: len 869, have_data 296
0:00:51.053834183  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1633:opaque_find:<ffdec_h2640> Found opaque 0x27f56a0 - ts:99:99:99.999999999, duration:99:99:99.999999999, offset:-1
0:00:51.053848291  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1769:gst_ffmpegdec_video_frame:<ffdec_h2640> Found opaque values, current ts:0:04:56.129000000, offset: -1
0:00:51.053857650  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1774:gst_ffmpegdec_video_frame:<ffdec_h2640> ts-handler: pts 18446744073709551615 duration 18446744073709551615
0:00:51.053867079  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1776:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: pts 296087000000
0:00:51.053875600  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1778:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: num 1233
0:00:51.053884400  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1780:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: ref 3
0:00:51.053893201  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1782:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: display 0
0:00:51.053901582  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1784:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: opaque (nil)
0:00:51.053911779  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1786:gst_ffmpegdec_video_frame:<ffdec_h2640> repeat_pict:0
0:00:51.053920509  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1788:gst_ffmpegdec_video_frame:<ffdec_h2640> interlaced_frame:0
0:00:51.053929170  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1494:check_keyframe:<ffdec_h2640> current picture: type: 3, is_keyframe:0, is_itype:0, is_reference:0
0:00:51.053938110  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1833:gst_ffmpegdec_video_frame:<ffdec_h2640> DTS as timestamps, interpolate
0:00:51.053946421  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1520:get_output_buffer:<ffdec_h2640> get output buffer
0:00:51.053954802  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1535:get_output_buffer:<ffdec_h2640> clip width 848/height 480
0:00:51.053963323  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:900:alloc_output_buffer:<ffdec_h2640> alloc output buffer
0:00:51.053972822  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:912:alloc_output_buffer:<ffdec_h2640> calling pad_alloc
0:00:51.054043643  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1549:get_output_buffer:<ffdec_h2640> linsize 880 440 440
0:00:51.054055796  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1552:get_output_buffer:<ffdec_h2640> data 0 34063896 34177000
0:00:51.054421147  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1871:gst_ffmpegdec_video_frame:<ffdec_h2640> using next timestamp 0:04:55.003041644
0:00:51.054456976  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1890:gst_ffmpegdec_video_frame:<ffdec_h2640> Using offset converted from timestamp
0:00:51.054527099  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1937:gst_ffmpegdec_video_frame:<ffdec_h2640> using in_duration
0:00:51.054545468  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1420:clip_video_buffer:<ffdec_h2640> timestamp:0:04:55.003041644 , duration:0:00:00.041708332
0:00:51.054557062  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1457:clip_video_buffer:<ffdec_h2640> dropping
0:00:51.054565513  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1987:gst_ffmpegdec_video_frame:<ffdec_h2640> buffer clipped
0:00:51.054605603  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1970:gst_ffmpegdec_video_frame:<ffdec_h2640> return flow 0, out (nil), len 869
0:00:51.054621667  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:2271:gst_ffmpegdec_frame:<ffdec_h2640> We didn't get a decoded buffer
0:00:51.054631166  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2672:gst_ffmpegdec_chain:<ffdec_h2640> Before (while bsize>0).  bsize:0 , bdata:0x7f964416251b
0:00:51.054663363  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2978:gst_ts_handler_append:<ffdec_h2640> store timestamp @ index [C7] buf_count: 45 ts: 0:04:56.296000000 duration: 0:00:00.041708332, offset: 18446744073709551615, size: 9626
0:00:51.054678170  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2518:gst_ffmpegdec_chain:<ffdec_h2640> Received new data of size 9626, offset:18446744073709551615, ts:0:04:56.296000000, dur:0:00:00.041708332
0:00:51.054700869  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2195:gst_ffmpegdec_frame:<ffdec_h2640> data:0x1cdfb80, size:9626, offset:-1, ts:0:04:56.296000000, dur:0:00:00.041708332
0:00:51.054716444  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1345:gst_ffmpegdec_do_qos:<ffdec_h2640> QOS: qostime 0:00:47.954000000, earliest 0:00:45.433646000
0:00:51.054727340  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1715:gst_ffmpegdec_video_frame:<ffdec_h2640> Going to store opaque values, current ts:0:04:56.296000000, offset: -1
0:00:51.054737956  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:3049:gst_ts_handler_get_ts:<ffdec_h2640> Index 154 yielded ts: 99:99:99.999999999, duration: 99:99:99.999999999, offset: -1
0:00:51.054785589  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1612:opaque_store:<ffdec_h2640> Stored ts:99:99:99.999999999, duration:99:99:99.999999999, offset:18446744073709551615 as opaque 0x2751da0
0:00:51.054826867  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:966:gst_ffmpegdec_get_buffer:<ffdec_h2640> getting buffer, apply pts 296296000000
0:00:51.054839718  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:983:gst_ffmpegdec_get_buffer:<ffdec_h2640> dimension 848x480, coded 848x480
0:00:51.054850125  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:985:gst_ffmpegdec_get_buffer:<ffdec_h2640> direct rendering disabled, fallback alloc
0:00:51.055336793  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:989:gst_ffmpegdec_get_buffer:<ffdec_h2640> linsize 880 440 440
0:00:51.055378350  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:992:gst_ffmpegdec_get_buffer:<ffdec_h2640> data 0 3232074920 3232188024
0:00:51.060674293  6075      0x1312030 LOG                   ffmpeg gstffmpegdec.c:2672:gst_ffmpegdec_chain:<ffdec_aac0> Before (while bsize>0).  bsize:0 , bdata:0x7f96440daba6
0:00:51.060749864  6075      0x1312030 LOG                   ffmpeg gstffmpegdec.c:2978:gst_ts_handler_append:<ffdec_aac0> store timestamp @ index [4C] buf_count: 2379 ts: 0:04:54.442666665 duration: 0:00:00.021333333, offset: 18446744073709551615, size: 505
0:00:51.060769699  6075      0x1312030 LOG                   ffmpeg gstffmpegdec.c:2518:gst_ffmpegdec_chain:<ffdec_aac0> Received new data of size 505, offset:18446744073709551615, ts:0:04:54.442666665, dur:0:00:00.021333333
0:00:51.060784506  6075      0x1312030 LOG                   ffmpeg gstffmpegdec.c:2195:gst_ffmpegdec_frame:<ffdec_aac0> data:0x7f964414a8f0, size:505, offset:-1, ts:0:04:54.442666665, dur:0:00:00.021333333
0:00:51.060796519  6075      0x1312030 DEBUG                 ffmpeg gstffmpegdec.c:2077:gst_ffmpegdec_audio_frame:<ffdec_aac0> size:505, offset:-1, ts:0:04:54.442666665, dur:0:00:00.021333333, ffmpegdec->next_ts:0:04:54.442666665
0:00:51.061030564  6075      0x1312030 DEBUG                 ffmpeg gstffmpegdec.c:2086:gst_ffmpegdec_audio_frame:<ffdec_aac0> Decode audio: len=505, have_data=4096
0:00:51.061071353  6075      0x1312030 DEBUG                 ffmpeg gstffmpegdec.c:2089:gst_ffmpegdec_audio_frame:<ffdec_aac0> Creating output buffer
0:00:51.061085671  6075      0x1312030 DEBUG                 ffmpeg gstffmpegdec.c:2123:gst_ffmpegdec_audio_frame:<ffdec_aac0> Buffer created. Size:4096 , timestamp:0:04:54.442666665 , duration:0:00:00.021333333
0:00:51.061096007  6075      0x1312030 LOG                   ffmpeg gstffmpegdec.c:2007:clip_audio_buffer:<ffdec_aac0> timestamp:0:04:54.442666665, duration:0:00:00.021333333, size 4096
0:00:51.061106484  6075      0x1312030 LOG                   ffmpeg gstffmpegdec.c:2053:clip_audio_buffer:<ffdec_aac0> not dropping
0:00:51.061115284  6075      0x1312030 DEBUG                 ffmpeg gstffmpegdec.c:2152:gst_ffmpegdec_audio_frame:<ffdec_aac0> return flow 0, out 0x7f964417b980, len 505
0:00:51.061124783  6075      0x1312030 LOG                   ffmpeg gstffmpegdec.c:2250:gst_ffmpegdec_frame:<ffdec_aac0> Decoded data, now pushing buffer 0x7f964417b980 with offset -1, timestamp 0:04:54.442666665 and duration 0:00:00.021333333
0:00:51.061227942  6075      0x1312030 LOG                   ffmpeg gstffmpegdec.c:2672:gst_ffmpegdec_chain:<ffdec_aac0> Before (while bsize>0).  bsize:0 , bdata:0x7f96440dad9f
0:00:51.061266425  6075      0x1312030 LOG                   ffmpeg gstffmpegdec.c:2978:gst_ts_handler_append:<ffdec_aac0> store timestamp @ index [4D] buf_count: 2380 ts: 0:04:54.463999998 duration: 0:00:00.021333333, offset: 18446744073709551615, size: 505
0:00:51.061283816  6075      0x1312030 LOG                   ffmpeg gstffmpegdec.c:2518:gst_ffmpegdec_chain:<ffdec_aac0> Received new data of size 505, offset:18446744073709551615, ts:0:04:54.463999998, dur:0:00:00.021333333
0:00:51.061296667  6075      0x1312030 LOG                   ffmpeg gstffmpegdec.c:2195:gst_ffmpegdec_frame:<ffdec_aac0> data:0x7f964414a8f0, size:505, offset:-1, ts:0:04:54.463999998, dur:0:00:00.021333333
0:00:51.061307423  6075      0x1312030 DEBUG                 ffmpeg gstffmpegdec.c:2077:gst_ffmpegdec_audio_frame:<ffdec_aac0> size:505, offset:-1, ts:0:04:54.463999998, dur:0:00:00.021333333, ffmpegdec->next_ts:0:04:54.463999998
0:00:51.061504382  6075      0x1312030 DEBUG                 ffmpeg gstffmpegdec.c:2086:gst_ffmpegdec_audio_frame:<ffdec_aac0> Decode audio: len=505, have_data=4096
0:00:51.061524008  6075      0x1312030 DEBUG                 ffmpeg gstffmpegdec.c:2089:gst_ffmpegdec_audio_frame:<ffdec_aac0> Creating output buffer
0:00:51.061534065  6075      0x1312030 DEBUG                 ffmpeg gstffmpegdec.c:2123:gst_ffmpegdec_audio_frame:<ffdec_aac0> Buffer created. Size:4096 , timestamp:0:04:54.463999998 , duration:0:00:00.021333333
0:00:51.061544402  6075      0x1312030 LOG                   ffmpeg gstffmpegdec.c:2007:clip_audio_buffer:<ffdec_aac0> timestamp:0:04:54.463999998, duration:0:00:00.021333333, size 4096
0:00:51.061554459  6075      0x1312030 LOG                   ffmpeg gstffmpegdec.c:2053:clip_audio_buffer:<ffdec_aac0> not dropping
0:00:51.061563050  6075      0x1312030 DEBUG                 ffmpeg gstffmpegdec.c:2152:gst_ffmpegdec_audio_frame:<ffdec_aac0> return flow 0, out 0x7f964400e4a0, len 505
0:00:51.061571850  6075      0x1312030 LOG                   ffmpeg gstffmpegdec.c:2250:gst_ffmpegdec_frame:<ffdec_aac0> Decoded data, now pushing buffer 0x7f964400e4a0 with offset -1, timestamp 0:04:54.463999998 and duration 0:00:00.021333333
0:00:51.067966569  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:3007:gst_ts_handler_consume:<ffdec_h2640> Stepping over 9626 bytes @ index 154 has 19221 bytes
0:00:51.068022374  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1738:gst_ffmpegdec_video_frame:<ffdec_h2640> after decode: len 9626, have_data 296
0:00:51.068065607  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1633:opaque_find:<ffdec_h2640> Found opaque 0x281da60 - ts:99:99:99.999999999, duration:99:99:99.999999999, offset:-1
0:00:51.068079017  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1769:gst_ffmpegdec_video_frame:<ffdec_h2640> Found opaque values, current ts:0:04:56.296000000, offset: -1
0:00:51.068109608  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1774:gst_ffmpegdec_video_frame:<ffdec_h2640> ts-handler: pts 18446744073709551615 duration 18446744073709551615
0:00:51.068121831  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1776:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: pts 296129000000
0:00:51.068130771  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1778:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: num 1235
0:00:51.068139781  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1780:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: ref 0
0:00:51.068148371  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1782:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: display 0
0:00:51.068156683  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1784:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: opaque (nil)
0:00:51.068167439  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1786:gst_ffmpegdec_video_frame:<ffdec_h2640> repeat_pict:0
0:00:51.068176029  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1788:gst_ffmpegdec_video_frame:<ffdec_h2640> interlaced_frame:0
0:00:51.068184830  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1494:check_keyframe:<ffdec_h2640> current picture: type: 3, is_keyframe:0, is_itype:0, is_reference:0
0:00:51.068193909  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1520:get_output_buffer:<ffdec_h2640> get output buffer
0:00:51.068203129  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1535:get_output_buffer:<ffdec_h2640> clip width 848/height 480
0:00:51.068212138  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:900:alloc_output_buffer:<ffdec_h2640> alloc output buffer
0:00:51.068221777  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:912:alloc_output_buffer:<ffdec_h2640> calling pad_alloc
0:00:51.068293506  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1549:get_output_buffer:<ffdec_h2640> linsize 880 440 440
0:00:51.068305728  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1552:get_output_buffer:<ffdec_h2640> data 0 3231484600 3229771080
0:00:51.068891715  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1871:gst_ffmpegdec_video_frame:<ffdec_h2640> using next timestamp 0:04:55.044749976
0:00:51.068946263  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1890:gst_ffmpegdec_video_frame:<ffdec_h2640> Using offset converted from timestamp
0:00:51.069014569  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1937:gst_ffmpegdec_video_frame:<ffdec_h2640> using in_duration
0:00:51.069027560  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1420:clip_video_buffer:<ffdec_h2640> timestamp:0:04:55.044749976 , duration:0:00:00.041708332
0:00:51.069040342  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1457:clip_video_buffer:<ffdec_h2640> dropping
0:00:51.069049072  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1987:gst_ffmpegdec_video_frame:<ffdec_h2640> buffer clipped
0:00:51.069062831  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1970:gst_ffmpegdec_video_frame:<ffdec_h2640> return flow 0, out (nil), len 9626
0:00:51.069075403  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:2271:gst_ffmpegdec_frame:<ffdec_h2640> We didn't get a decoded buffer
0:00:51.069084552  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2672:gst_ffmpegdec_chain:<ffdec_h2640> Before (while bsize>0).  bsize:0 , bdata:0x7f9644165a7a
0:00:51.069114655  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2978:gst_ts_handler_append:<ffdec_h2640> store timestamp @ index [C8] buf_count: 46 ts: 0:04:56.254000000 duration: 0:00:00.041708332, offset: 18446744073709551615, size: 1028
0:00:51.069147900  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2518:gst_ffmpegdec_chain:<ffdec_h2640> Received new data of size 1028, offset:18446744073709551615, ts:0:04:56.254000000, dur:0:00:00.041708332
0:00:51.069163755  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2195:gst_ffmpegdec_frame:<ffdec_h2640> data:0x1cdfb80, size:1028, offset:-1, ts:0:04:56.254000000, dur:0:00:00.041708332
0:00:51.069176047  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1345:gst_ffmpegdec_do_qos:<ffdec_h2640> QOS: qostime 0:00:47.912000000, earliest 0:00:45.433646000
0:00:51.069186524  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1715:gst_ffmpegdec_video_frame:<ffdec_h2640> Going to store opaque values, current ts:0:04:56.254000000, offset: -1
0:00:51.069196581  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:3049:gst_ts_handler_get_ts:<ffdec_h2640> Index 154 yielded ts: 99:99:99.999999999, duration: 99:99:99.999999999, offset: -1
0:00:51.069235414  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1612:opaque_store:<ffdec_h2640> Stored ts:99:99:99.999999999, duration:99:99:99.999999999, offset:18446744073709551615 as opaque 0x281dac0
0:00:51.069261675  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1074:gst_ffmpegdec_release_buffer:<ffdec_h2640> default release buffer
0:00:51.069275993  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:966:gst_ffmpegdec_get_buffer:<ffdec_h2640> getting buffer, apply pts 296254000000
0:00:51.069285422  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:983:gst_ffmpegdec_get_buffer:<ffdec_h2640> dimension 848x480, coded 848x480
0:00:51.069294292  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:985:gst_ffmpegdec_get_buffer:<ffdec_h2640> direct rendering disabled, fallback alloc
0:00:51.069303372  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:989:gst_ffmpegdec_get_buffer:<ffdec_h2640> linsize 880 440 440
0:00:51.069312381  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:992:gst_ffmpegdec_get_buffer:<ffdec_h2640> data 0 3231484600 3229771080
0:00:51.075830863  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:3007:gst_ts_handler_consume:<ffdec_h2640> Stepping over 1028 bytes @ index 154 has 9595 bytes
0:00:51.075888414  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1738:gst_ffmpegdec_video_frame:<ffdec_h2640> after decode: len 1028, have_data 296
0:00:51.075937793  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1633:opaque_find:<ffdec_h2640> Found opaque 0x26bf6c0 - ts:99:99:99.999999999, duration:99:99:99.999999999, offset:-1
0:00:51.075952460  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1769:gst_ffmpegdec_video_frame:<ffdec_h2640> Found opaque values, current ts:0:04:56.254000000, offset: -1
0:00:51.075962238  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1774:gst_ffmpegdec_video_frame:<ffdec_h2640> ts-handler: pts 18446744073709551615 duration 18446744073709551615
0:00:51.075972575  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1776:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: pts 296171000000
0:00:51.075981375  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1778:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: num 1232
0:00:51.075990664  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1780:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: ref 3
0:00:51.076000652  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1782:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: display 0
0:00:51.076009312  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1784:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: opaque (nil)
0:00:51.076021326  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1786:gst_ffmpegdec_video_frame:<ffdec_h2640> repeat_pict:0
0:00:51.076030196  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1788:gst_ffmpegdec_video_frame:<ffdec_h2640> interlaced_frame:0
0:00:51.076066863  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1494:check_keyframe:<ffdec_h2640> current picture: type: 2, is_keyframe:0, is_itype:0, is_reference:0
0:00:51.076081950  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1833:gst_ffmpegdec_video_frame:<ffdec_h2640> DTS as timestamps, interpolate
0:00:51.076091518  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1520:get_output_buffer:<ffdec_h2640> get output buffer
0:00:51.076100528  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1535:get_output_buffer:<ffdec_h2640> clip width 848/height 480
0:00:51.076110446  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:900:alloc_output_buffer:<ffdec_h2640> alloc output buffer
0:00:51.076120643  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:912:alloc_output_buffer:<ffdec_h2640> calling pad_alloc
0:00:51.076214931  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1549:get_output_buffer:<ffdec_h2640> linsize 880 440 440
0:00:51.076236583  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1552:get_output_buffer:<ffdec_h2640> data 0 45889848 46002952
0:00:51.076614156  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1871:gst_ffmpegdec_video_frame:<ffdec_h2640> using next timestamp 0:04:55.086458308
0:00:51.076653059  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1890:gst_ffmpegdec_video_frame:<ffdec_h2640> Using offset converted from timestamp
0:00:51.076720248  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1937:gst_ffmpegdec_video_frame:<ffdec_h2640> using in_duration
0:00:51.076739385  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1420:clip_video_buffer:<ffdec_h2640> timestamp:0:04:55.086458308 , duration:0:00:00.041708332
0:00:51.076750979  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1457:clip_video_buffer:<ffdec_h2640> dropping
0:00:51.076759570  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1987:gst_ffmpegdec_video_frame:<ffdec_h2640> buffer clipped
0:00:51.076773469  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1970:gst_ffmpegdec_video_frame:<ffdec_h2640> return flow 0, out (nil), len 1028
0:00:51.076785342  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:2271:gst_ffmpegdec_frame:<ffdec_h2640> We didn't get a decoded buffer
0:00:51.076795190  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2672:gst_ffmpegdec_chain:<ffdec_h2640> Before (while bsize>0).  bsize:0 , bdata:0x7f9644165e85
0:00:51.076826200  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2978:gst_ts_handler_append:<ffdec_h2640> store timestamp @ index [C9] buf_count: 47 ts: 0:04:56.213000000 duration: 0:00:00.041708332, offset: 18446744073709551615, size: 1008
0:00:51.076840658  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2518:gst_ffmpegdec_chain:<ffdec_h2640> Received new data of size 1008, offset:18446744073709551615, ts:0:04:56.213000000, dur:0:00:00.041708332
0:00:51.076855395  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2195:gst_ffmpegdec_frame:<ffdec_h2640> data:0x1cdfb80, size:1008, offset:-1, ts:0:04:56.213000000, dur:0:00:00.041708332
0:00:51.076868037  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1345:gst_ffmpegdec_do_qos:<ffdec_h2640> QOS: qostime 0:00:47.871000000, earliest 0:00:45.433646000
0:00:51.076878304  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1715:gst_ffmpegdec_video_frame:<ffdec_h2640> Going to store opaque values, current ts:0:04:56.213000000, offset: -1
0:00:51.076888501  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:3049:gst_ts_handler_get_ts:<ffdec_h2640> Index 154 yielded ts: 99:99:99.999999999, duration: 99:99:99.999999999, offset: -1
0:00:51.076927613  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1612:opaque_store:<ffdec_h2640> Stored ts:99:99:99.999999999, duration:99:99:99.999999999, offset:18446744073709551615 as opaque 0x27b7a00
0:00:51.076977481  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:966:gst_ffmpegdec_get_buffer:<ffdec_h2640> getting buffer, apply pts 296213000000
0:00:51.076991310  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:983:gst_ffmpegdec_get_buffer:<ffdec_h2640> dimension 848x480, coded 848x480
0:00:51.077002625  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:985:gst_ffmpegdec_get_buffer:<ffdec_h2640> direct rendering disabled, fallback alloc
0:00:51.077622764  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:989:gst_ffmpegdec_get_buffer:<ffdec_h2640> linsize 880 440 440
0:00:51.077663553  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:992:gst_ffmpegdec_get_buffer:<ffdec_h2640> data 0 3232960328 3233073432
0:00:51.083626011  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:3007:gst_ts_handler_consume:<ffdec_h2640> Stepping over 1008 bytes @ index 154 has 8567 bytes
0:00:51.083682864  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1738:gst_ffmpegdec_video_frame:<ffdec_h2640> after decode: len 1008, have_data 296
0:00:51.083725747  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1633:opaque_find:<ffdec_h2640> Found opaque 0x27b7a00 - ts:99:99:99.999999999, duration:99:99:99.999999999, offset:-1
0:00:51.083740065  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1769:gst_ffmpegdec_video_frame:<ffdec_h2640> Found opaque values, current ts:0:04:56.213000000, offset: -1
0:00:51.083749634  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1774:gst_ffmpegdec_video_frame:<ffdec_h2640> ts-handler: pts 18446744073709551615 duration 18446744073709551615
0:00:51.083758783  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1776:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: pts 296213000000
0:00:51.083767584  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1778:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: num 1238
0:00:51.083776454  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1780:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: ref 0
0:00:51.083785044  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1782:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: display 0
0:00:51.083793426  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1784:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: opaque (nil)
0:00:51.083803693  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1786:gst_ffmpegdec_video_frame:<ffdec_h2640> repeat_pict:0
0:00:51.083812144  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1788:gst_ffmpegdec_video_frame:<ffdec_h2640> interlaced_frame:0
0:00:51.083820734  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1494:check_keyframe:<ffdec_h2640> current picture: type: 3, is_keyframe:0, is_itype:0, is_reference:0
0:00:51.083829744  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1520:get_output_buffer:<ffdec_h2640> get output buffer
0:00:51.083838405  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1535:get_output_buffer:<ffdec_h2640> clip width 848/height 480
0:00:51.083846995  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:900:alloc_output_buffer:<ffdec_h2640> alloc output buffer
0:00:51.083856424  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:912:alloc_output_buffer:<ffdec_h2640> calling pad_alloc
0:00:51.083930668  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1549:get_output_buffer:<ffdec_h2640> linsize 880 440 440
0:00:51.083942890  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1552:get_output_buffer:<ffdec_h2640> data 0 3232960328 3233073432
0:00:51.084319765  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1871:gst_ffmpegdec_video_frame:<ffdec_h2640> using next timestamp 0:04:55.128166640
0:00:51.084354058  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1890:gst_ffmpegdec_video_frame:<ffdec_h2640> Using offset converted from timestamp
0:00:51.084478449  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1937:gst_ffmpegdec_video_frame:<ffdec_h2640> using in_duration
0:00:51.084500101  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1420:clip_video_buffer:<ffdec_h2640> timestamp:0:04:55.128166640 , duration:0:00:00.041708332
0:00:51.084514000  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1457:clip_video_buffer:<ffdec_h2640> dropping
0:00:51.084524127  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1987:gst_ffmpegdec_video_frame:<ffdec_h2640> buffer clipped
0:00:51.084540261  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1970:gst_ffmpegdec_video_frame:<ffdec_h2640> return flow 0, out (nil), len 1008
0:00:51.084552623  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:2271:gst_ffmpegdec_frame:<ffdec_h2640> We didn't get a decoded buffer
0:00:51.084564636  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2672:gst_ffmpegdec_chain:<ffdec_h2640> Before (while bsize>0).  bsize:0 , bdata:0x7f964416627c
0:00:51.085248891  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2978:gst_ts_handler_append:<ffdec_h2640> store timestamp @ index [CA] buf_count: 48 ts: 0:04:56.630000000 duration: 0:00:00.041708332, offset: 18446744073709551615, size: 7480
0:00:51.085286886  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2518:gst_ffmpegdec_chain:<ffdec_h2640> Received new data of size 7480, offset:18446744073709551615, ts:0:04:56.630000000, dur:0:00:00.041708332
0:00:51.085305465  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2195:gst_ffmpegdec_frame:<ffdec_h2640> data:0x1cdfb80, size:7480, offset:-1, ts:0:04:56.630000000, dur:0:00:00.041708332
0:00:51.085319782  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1345:gst_ffmpegdec_do_qos:<ffdec_h2640> QOS: qostime 0:00:48.288000000, earliest 0:00:45.433646000
0:00:51.085331376  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1715:gst_ffmpegdec_video_frame:<ffdec_h2640> Going to store opaque values, current ts:0:04:56.630000000, offset: -1
0:00:51.085342551  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:3049:gst_ts_handler_get_ts:<ffdec_h2640> Index 154 yielded ts: 99:99:99.999999999, duration: 99:99:99.999999999, offset: -1
0:00:51.085382642  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1612:opaque_store:<ffdec_h2640> Stored ts:99:99:99.999999999, duration:99:99:99.999999999, offset:18446744073709551615 as opaque 0x281d4c0
0:00:51.085416376  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1074:gst_ffmpegdec_release_buffer:<ffdec_h2640> default release buffer
0:00:51.085432370  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:966:gst_ffmpegdec_get_buffer:<ffdec_h2640> getting buffer, apply pts 296630000000
0:00:51.085443266  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:983:gst_ffmpegdec_get_buffer:<ffdec_h2640> dimension 848x480, coded 848x480
0:00:51.085452415  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:985:gst_ffmpegdec_get_buffer:<ffdec_h2640> direct rendering disabled, fallback alloc
0:00:51.085461774  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:989:gst_ffmpegdec_get_buffer:<ffdec_h2640> linsize 880 440 440
0:00:51.085471343  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:992:gst_ffmpegdec_get_buffer:<ffdec_h2640> data 0 3232960328 3233073432
0:00:51.096908893  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:3007:gst_ts_handler_consume:<ffdec_h2640> Stepping over 7480 bytes @ index 154 has 7559 bytes
0:00:51.096963021  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1738:gst_ffmpegdec_video_frame:<ffdec_h2640> after decode: len 7480, have_data 296
0:00:51.097013099  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1633:opaque_find:<ffdec_h2640> Found opaque 0x281dac0 - ts:99:99:99.999999999, duration:99:99:99.999999999, offset:-1
0:00:51.097054097  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1769:gst_ffmpegdec_video_frame:<ffdec_h2640> Found opaque values, current ts:0:04:56.630000000, offset: -1
0:00:51.097067786  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1774:gst_ffmpegdec_video_frame:<ffdec_h2640> ts-handler: pts 18446744073709551615 duration 18446744073709551615
0:00:51.097077564  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1776:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: pts 296254000000
0:00:51.097086644  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1778:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: num 1237
0:00:51.097095793  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1780:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: ref 3
0:00:51.097104943  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1782:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: display 0
0:00:51.097113534  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1784:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: opaque (nil)
0:00:51.097124988  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1786:gst_ffmpegdec_video_frame:<ffdec_h2640> repeat_pict:0
0:00:51.097133998  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1788:gst_ffmpegdec_video_frame:<ffdec_h2640> interlaced_frame:0
0:00:51.097143916  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1494:check_keyframe:<ffdec_h2640> current picture: type: 3, is_keyframe:0, is_itype:0, is_reference:0
0:00:51.097153414  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1833:gst_ffmpegdec_video_frame:<ffdec_h2640> DTS as timestamps, interpolate
0:00:51.097162494  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1520:get_output_buffer:<ffdec_h2640> get output buffer
0:00:51.097172272  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1535:get_output_buffer:<ffdec_h2640> clip width 848/height 480
0:00:51.097181002  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:900:alloc_output_buffer:<ffdec_h2640> alloc output buffer
0:00:51.097190850  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:912:alloc_output_buffer:<ffdec_h2640> calling pad_alloc
0:00:51.097285279  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1549:get_output_buffer:<ffdec_h2640> linsize 880 440 440
0:00:51.097306301  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1552:get_output_buffer:<ffdec_h2640> data 0 3231484600 3229771080
0:00:51.097810990  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1871:gst_ffmpegdec_video_frame:<ffdec_h2640> using next timestamp 0:04:55.169874972
0:00:51.097845422  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1890:gst_ffmpegdec_video_frame:<ffdec_h2640> Using offset converted from timestamp
0:00:51.097913380  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1937:gst_ffmpegdec_video_frame:<ffdec_h2640> using in_duration
0:00:51.097931958  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1420:clip_video_buffer:<ffdec_h2640> timestamp:0:04:55.169874972 , duration:0:00:00.041708332
0:00:51.097944809  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1457:clip_video_buffer:<ffdec_h2640> dropping
0:00:51.097953610  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1987:gst_ffmpegdec_video_frame:<ffdec_h2640> buffer clipped
0:00:51.097967089  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1970:gst_ffmpegdec_video_frame:<ffdec_h2640> return flow 0, out (nil), len 7480
0:00:51.097979103  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:2271:gst_ffmpegdec_frame:<ffdec_h2640> We didn't get a decoded buffer
0:00:51.097988322  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2672:gst_ffmpegdec_chain:<ffdec_h2640> Before (while bsize>0).  bsize:0 , bdata:0x7f96440af504
0:00:51.098040984  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2978:gst_ts_handler_append:<ffdec_h2640> store timestamp @ index [CB] buf_count: 49 ts: 0:04:56.463000000 duration: 0:00:00.041708332, offset: 18446744073709551615, size: 2366
0:00:51.098059772  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2518:gst_ffmpegdec_chain:<ffdec_h2640> Received new data of size 2366, offset:18446744073709551615, ts:0:04:56.463000000, dur:0:00:00.041708332
0:00:51.098076394  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2195:gst_ffmpegdec_frame:<ffdec_h2640> data:0x1cdfb80, size:2366, offset:-1, ts:0:04:56.463000000, dur:0:00:00.041708332
0:00:51.098089944  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1345:gst_ffmpegdec_do_qos:<ffdec_h2640> QOS: qostime 0:00:48.121000000, earliest 0:00:45.433646000
0:00:51.098100420  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1715:gst_ffmpegdec_video_frame:<ffdec_h2640> Going to store opaque values, current ts:0:04:56.463000000, offset: -1
0:00:51.098112154  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:3049:gst_ts_handler_get_ts:<ffdec_h2640> Index 154 yielded ts: 99:99:99.999999999, duration: 99:99:99.999999999, offset: -1
0:00:51.098162511  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1612:opaque_store:<ffdec_h2640> Stored ts:99:99:99.999999999, duration:99:99:99.999999999, offset:18446744073709551615 as opaque 0x27f5a80
0:00:51.098199808  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:966:gst_ffmpegdec_get_buffer:<ffdec_h2640> getting buffer, apply pts 296463000000
0:00:51.098212310  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:983:gst_ffmpegdec_get_buffer:<ffdec_h2640> dimension 848x480, coded 848x480
0:00:51.098221599  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:985:gst_ffmpegdec_get_buffer:<ffdec_h2640> direct rendering disabled, fallback alloc
0:00:51.098789915  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:989:gst_ffmpegdec_get_buffer:<ffdec_h2640> linsize 880 440 440
0:00:51.098834545  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:992:gst_ffmpegdec_get_buffer:<ffdec_h2640> data 0 3233845736 3233958840
0:00:51.106152523  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:3007:gst_ts_handler_consume:<ffdec_h2640> Stepping over 2366 bytes @ index 154 has 79 bytes
0:00:51.106205534  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:3007:gst_ts_handler_consume:<ffdec_h2640> Stepping over 2287 bytes @ index 155 has 6243 bytes
0:00:51.106216080  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1738:gst_ffmpegdec_video_frame:<ffdec_h2640> after decode: len 2366, have_data 296
0:00:51.106258964  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1633:opaque_find:<ffdec_h2640> Found opaque 0x2751da0 - ts:99:99:99.999999999, duration:99:99:99.999999999, offset:-1
0:00:51.106272304  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1769:gst_ffmpegdec_video_frame:<ffdec_h2640> Found opaque values, current ts:0:04:56.463000000, offset: -1
0:00:51.106291232  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1774:gst_ffmpegdec_video_frame:<ffdec_h2640> ts-handler: pts 18446744073709551615 duration 18446744073709551615
0:00:51.106300591  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1776:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: pts 296296000000
0:00:51.106310090  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1778:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: num 1236
0:00:51.106319728  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1780:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: ref 3
0:00:51.106328528  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1782:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: display 0
0:00:51.106338725  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1784:gst_ffmpegdec_video_frame:<ffdec_h2640> picture: opaque (nil)
0:00:51.106373926  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1786:gst_ffmpegdec_video_frame:<ffdec_h2640> repeat_pict:0
0:00:51.106386847  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1788:gst_ffmpegdec_video_frame:<ffdec_h2640> interlaced_frame:0
0:00:51.106396975  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1494:check_keyframe:<ffdec_h2640> current picture: type: 2, is_keyframe:0, is_itype:0, is_reference:0
0:00:51.106406473  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1833:gst_ffmpegdec_video_frame:<ffdec_h2640> DTS as timestamps, interpolate
0:00:51.106415483  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1520:get_output_buffer:<ffdec_h2640> get output buffer
0:00:51.106425122  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1535:get_output_buffer:<ffdec_h2640> clip width 848/height 480
0:00:51.106433852  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:900:alloc_output_buffer:<ffdec_h2640> alloc output buffer
0:00:51.106444887  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:912:alloc_output_buffer:<ffdec_h2640> calling pad_alloc
0:00:51.106536941  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1549:get_output_buffer:<ffdec_h2640> linsize 880 440 440
0:00:51.106555519  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1552:get_output_buffer:<ffdec_h2640> data 0 3232074920 3232188024
0:00:51.106966687  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1871:gst_ffmpegdec_video_frame:<ffdec_h2640> using next timestamp 0:04:55.211583304
0:00:51.107001748  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1890:gst_ffmpegdec_video_frame:<ffdec_h2640> Using offset converted from timestamp
0:00:51.107071033  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1937:gst_ffmpegdec_video_frame:<ffdec_h2640> using in_duration
0:00:51.107090729  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1420:clip_video_buffer:<ffdec_h2640> timestamp:0:04:55.211583304 , duration:0:00:00.041708332
0:00:51.107102323  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:1457:clip_video_buffer:<ffdec_h2640> dropping
0:00:51.107111123  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1987:gst_ffmpegdec_video_frame:<ffdec_h2640> buffer clipped
0:00:51.107124952  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1970:gst_ffmpegdec_video_frame:<ffdec_h2640> return flow 0, out (nil), len 2366
0:00:51.107137524  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:2271:gst_ffmpegdec_frame:<ffdec_h2640> We didn't get a decoded buffer
0:00:51.107146813  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2672:gst_ffmpegdec_chain:<ffdec_h2640> Before (while bsize>0).  bsize:0 , bdata:0x7f96440afe49
0:00:51.107179709  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2978:gst_ts_handler_append:<ffdec_h2640> store timestamp @ index [CC] buf_count: 49 ts: 0:04:56.338000000 duration: 0:00:00.041708332, offset: 18446744073709551615, size: 730
0:00:51.107195145  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2518:gst_ffmpegdec_chain:<ffdec_h2640> Received new data of size 730, offset:18446744073709551615, ts:0:04:56.338000000, dur:0:00:00.041708332
0:00:51.107209463  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:2195:gst_ffmpegdec_frame:<ffdec_h2640> data:0x1cdfb80, size:730, offset:-1, ts:0:04:56.338000000, dur:0:00:00.041708332
0:00:51.107221546  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1345:gst_ffmpegdec_do_qos:<ffdec_h2640> QOS: qostime 0:00:47.996000000, earliest 0:00:45.433646000
0:00:51.107231533  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1715:gst_ffmpegdec_video_frame:<ffdec_h2640> Going to store opaque values, current ts:0:04:56.338000000, offset: -1
0:00:51.107241451  6075      0x12be620 LOG                   ffmpeg gstffmpegdec.c:3049:gst_ts_handler_get_ts:<ffdec_h2640> Index 155 yielded ts: 0:04:54.503000000, duration: 0:00:00.041708332, offset: -1
0:00:51.107301097  6075      0x12be620 DEBUG                 ffmpeg gstffmpegdec.c:1612:opaque_store:<ffdec_h2640> Stored ts:0:04:54.503000000, duration:0:00:00.041708332, offset:18446744073709551615 as opaque 0x27bc000
0:00:51.107333714  6075      0x12be620 INFO                  ffmpeg :0:: Internal error, picture buffer overflow
