[MPlayer-dev-eng] [PATCH] further dvr-ms playback improvements

Fri Oct 13 20:04:41 CEST 2006

> easy: in mpeg2 (but more generally in almost all video formats)
> video frames are divided in I, B and P types.
> I frames are indipendent, while P depend on I and B depend on I and P.
> In order to be decoded correctly I and P frames surrounding enclosed B
> frames
> must be stored in decoding order, that is different from display order:
>
> display: I1 B2 B3 P4 B5 B6 P7
> decode: I1 P4 B2 B3 P7 B5 B6
>
> where n (in this case 1..4) indicates the display order.
> In your case you can consider n=pts (your variable time).
> When you see  pts(n-1) > pts(n)  (e.g. 4 > 2) you have actually found a
> B frame,
> so you have to increase the frame count but you have to wait until P7 to
> calculate the average framerate on the interval I1 to P4

Nico

Unfortunately the pts values in a dvr-ms file always increase. I've
attached a file containg output from my development version of the asf
parser that attempts to show what is going on. It contains some intial
video frames followed by a segment of 15 frames (look for the first
frame where "key=1"). Each line that starts with
"demux_asf.read_packet" is actually a segment (ie payload or
subpacket). Each segment of a packet has a different time - usually
1ms after the previous but sometimes it jumps (eg line 197 it jumps
from .233 to .270).

Until my last patch, the parser used the timestamp of the first
segment in the frame for the frame pts. The last patch now uses the
average frame time from the container which is sometimes completely
wrong.  So I've written code that uses the first segment's timestamp
value as the basis for calculating an average frame time.

Each line in the attached log file that starts with 'FRAME END' shows
the file pts, the pts I actually apply, the difference and the current
average frametime. Since the file pts is always increasing I dont see
a way to identify the B frames or apply appropriate pts values.

as it stands for these frames:
display: I1 B2 B3 P4 B5 B6 P7
decode: I1 P4 B2 B3 P7 B5 B6

if the first pts is zero and the avg frame time is 0.33 then I'd apply
the pts values

I1=0.000 P4=0.033 B2=0.066 B3=0.099 P7=0.133  B5=0.166 B6=0.199

ie in display order:
I1=0.000 B2=0.066 B3=0.099 P4=0.033 B5=0.166 B6=0.199 P7=0.133

Yet the file seems to play ok even when I provide these timestamps
which I cant understand. Are you saying that applying these pts values
is incorrect, or does the mpeg decoder somehow  handle this
appropriately?

Whatever is going on, the playback looks fine despite the fact that B
frames are not considered when applying pts values. Unless you have
any other suggestions I'll submit a patch that effectively ignores the
fact that P frames could appear in the file out of display order.

On the subject of I-frames, the container again lets us down - becasue
the key flag is always '1'. So I've written some prototype code that
attemps to identfy key frames based on the number of segments... if
the num. segs in the frame is > twice the current average num. segs
they I mark it as a key frame. Not always correctly I think but it
mostly works and itmakes seeking work a lot better. I will submit this
as a patch shortly unless anyone objects to the methodology

John
-------------- next part --------------
MPlayer dev-SVN-r19837-3.4.4 (C) 2000-2006 MPlayer Team
CPU: Intel(R) Pentium(R) 4 CPU 2.80GHz (Family: 15, Model: 2, Stepping: 9)
CPUflags:  MMX: 1 MMX2: 1 3DNow: 0 3DNow2: 0 SSE: 0 SSE2: 0
Compiled for x86 CPU with extensions: MMX MMX2 SSE SSE2
getch2: 6 can't get number of input events  [disabling console input]

Playing dc.dvr-ms.
ASF file format detected.
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=2 len=2025 time=0.002
demux_asf.read_packet: id=1 seq=3 len=2025 time=0.003
demux_asf.read_packet: id=1 seq=4 len=1194 time=0.004
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=4 len=48 time=0.004

FRAME END: filepts=0.000, newpts=0.003, diff=0.003, avg=0.003, segct=5, avgsegct=5, key=0

demux_asf.read_packet: id=1 seq=5 len=778 time=0.005
demux_asf.read_packet: id=1 seq=6 len=2025 time=0.006
demux_asf.read_packet: id=1 seq=7 len=2025 time=0.054
demux_asf.read_packet: id=1 seq=8 len=22 time=0.055
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=8 len=2003 time=0.055
demux_asf.read_packet: id=1 seq=9 len=2025 time=0.057
demux_asf.read_packet: id=1 seq=10 len=2025 time=0.058
demux_asf.read_packet: id=1 seq=11 len=1216 time=0.059
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=11 len=809 time=0.059
demux_asf.read_packet: id=1 seq=12 len=2025 time=0.060
demux_asf.read_packet: id=1 seq=13 len=2025 time=0.063
demux_asf.read_packet: id=1 seq=14 len=1266 time=0.064

FRAME END: filepts=0.005, newpts=0.023, diff=0.018, avg=0.018, segct=12, avgsegct=6, key=0

demux_asf.read_packet: id=1 seq=15 len=749 time=0.065
demux_asf.read_packet: id=1 seq=16 len=194 time=0.066
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=16 len=1831 time=0.066
demux_asf.read_packet: id=1 seq=17 len=2025 time=0.067
demux_asf.read_packet: id=1 seq=18 len=2025 time=0.068
demux_asf.read_packet: id=1 seq=19 len=1557 time=0.069
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=19 len=468 time=0.069
demux_asf.read_packet: id=1 seq=20 len=2025 time=0.070
demux_asf.read_packet: id=1 seq=21 len=2025 time=0.071
demux_asf.read_packet: id=1 seq=22 len=2025 time=0.072
demux_asf.read_packet: id=1 seq=23 len=710 time=0.073
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=23 len=1315 time=0.073
demux_asf.read_packet: id=1 seq=24 len=2025 time=0.074
demux_asf.read_packet: id=1 seq=25 len=2025 time=0.075
demux_asf.read_packet: id=1 seq=26 len=2025 time=0.076
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=27 len=2025 time=0.077
demux_asf.read_packet: id=1 seq=28 len=2025 time=0.078
demux_asf.read_packet: id=1 seq=29 len=2025 time=0.079
demux_asf.read_packet: id=1 seq=30 len=1001 time=0.080

FRAME END: filepts=0.065, newpts=0.050, diff=-0.016, avg=0.022, segct=19, avgsegct=10, key=0

demux_asf.read_packet: id=1 seq=31 len=177 time=0.081
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=31 len=842 time=0.081
demux_asf.read_packet: id=1 seq=32 len=2025 time=0.082
demux_asf.read_packet: id=1 seq=33 len=2025 time=0.119
demux_asf.read_packet: id=1 seq=34 len=2025 time=0.120
VIDEO:  [DVR ]  720x480  0bpp  1000.000 fps    0.0 kbps ( 0.0 kbyte/s)
Clip info:
 name: This Is Daniel Cook
==========================================================================
Opening video decoder: [libmpeg2] MPEG 1/2 Video decoder libmpeg2-v0.4.0b
Selected video codec: [mpeg12] vfm: libmpeg2 (MPEG-1 or 2 (libmpeg2))
==========================================================================
==========================================================================
Opening audio decoder: [mp3lib] MPEG layer-2, layer-3
AUDIO: 48000 Hz, 2 ch, s16le, 224.0 kbit/14.58% (ratio: 28000->192000)
Selected audio codec: [mp3] afm: mp3lib (mp3lib MPEG layer-2, layer-3)
==========================================================================
AO: [dsound] 48000Hz 2ch s16le (2 bytes per sample)
Starting playback...
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=35 len=2025 time=0.122
demux_asf.read_packet: id=1 seq=36 len=2025 time=0.123
demux_asf.read_packet: id=1 seq=37 len=1571 time=0.124
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=37 len=454 time=0.124
demux_asf.read_packet: id=1 seq=38 len=2025 time=0.126
demux_asf.read_packet: id=1 seq=39 len=2025 time=0.127
demux_asf.read_packet: id=1 seq=40 len=609 time=0.128

FRAME END: filepts=0.081, newpts=0.082, diff=0.001, avg=0.027, segct=12, avgsegct=10, key=0

demux_asf.read_packet: id=1 seq=41 len=1411 time=0.129
demux_asf.read_packet: id=1 seq=42 len=375 time=0.130
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=42 len=1650 time=0.130
demux_asf.read_packet: id=1 seq=43 len=2025 time=0.131
demux_asf.read_packet: id=1 seq=44 len=2025 time=0.132
demux_asf.read_packet: id=1 seq=45 len=1738 time=0.133
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=45 len=287 time=0.133
demux_asf.read_packet: id=1 seq=46 len=2025 time=0.134
demux_asf.read_packet: id=1 seq=47 len=2025 time=0.135
demux_asf.read_packet: id=1 seq=48 len=2025 time=0.136
demux_asf.read_packet: id=1 seq=49 len=891 time=0.137
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=49 len=815 time=0.137

FRAME END: filepts=0.129, newpts=0.109, diff=-0.020, avg=0.027, segct=12, avgsegct=11, key=0

demux_asf.read_packet: id=1 seq=50 len=309 time=0.138
demux_asf.read_packet: id=1 seq=51 len=2025 time=0.139
demux_asf.read_packet: id=1 seq=52 len=1764 time=0.188
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=52 len=261 time=0.188
demux_asf.read_packet: id=1 seq=53 len=2025 time=0.189
demux_asf.read_packet: id=1 seq=54 len=2025 time=0.190
demux_asf.read_packet: id=1 seq=55 len=2025 time=0.191
demux_asf.read_packet: id=1 seq=56 len=917 time=0.192
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=56 len=1108 time=0.192
demux_asf.read_packet: id=1 seq=57 len=2025 time=0.193
demux_asf.read_packet: id=1 seq=58 len=2025 time=0.194
demux_asf.read_packet: id=1 seq=59 len=2025 time=0.195
demux_asf.read_packet: id=1 seq=60 len=70 time=0.196
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=60 len=1955 time=0.196
demux_asf.read_packet: id=1 seq=61 len=2025 time=0.197
demux_asf.read_packet: id=1 seq=62 len=2025 time=0.198
demux_asf.read_packet: id=1 seq=63 len=1433 time=0.199
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=63 len=592 time=0.199
demux_asf.read_packet: id=1 seq=64 len=2025 time=0.200
demux_asf.read_packet: id=1 seq=65 len=2025 time=0.201
demux_asf.read_packet: id=1 seq=66 len=2025 time=0.202
demux_asf.read_packet: id=1 seq=67 len=586 time=0.203
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=67 len=1439 time=0.203
demux_asf.read_packet: id=1 seq=68 len=2025 time=0.204
demux_asf.read_packet: id=1 seq=69 len=2025 time=0.205
demux_asf.read_packet: id=1 seq=70 len=1949 time=0.206
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=70 len=76 time=0.206
demux_asf.read_packet: id=1 seq=71 len=2025 time=0.207
demux_asf.read_packet: id=1 seq=72 len=2025 time=0.208
demux_asf.read_packet: id=1 seq=73 len=2025 time=0.209
demux_asf.read_packet: id=1 seq=74 len=1102 time=0.210
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=74 len=923 time=0.210
demux_asf.read_packet: id=1 seq=75 len=2025 time=0.211
demux_asf.read_packet: id=1 seq=76 len=2025 time=0.212
demux_asf.read_packet: id=1 seq=77 len=2025 time=0.213
demux_asf.read_packet: id=1 seq=78 len=255 time=0.214
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=78 len=1770 time=0.214
demux_asf.read_packet: id=1 seq=79 len=2025 time=0.215
demux_asf.read_packet: id=1 seq=80 len=2025 time=0.216
demux_asf.read_packet: id=1 seq=81 len=1618 time=0.217
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=81 len=407 time=0.217
demux_asf.read_packet: id=1 seq=82 len=2025 time=0.218
demux_asf.read_packet: id=1 seq=83 len=2025 time=0.219
demux_asf.read_packet: id=1 seq=84 len=1566 time=0.220

FRAME END: filepts=0.138, newpts=0.146, diff=0.008, avg=0.032, segct=44, avgsegct=16, key=1

demux_asf.read_packet: id=1 seq=85 len=454 time=0.221
demux_asf.read_packet: id=1 seq=86 len=591 time=0.222
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=86 len=1434 time=0.222
demux_asf.read_packet: id=1 seq=87 len=2025 time=0.223
demux_asf.read_packet: id=1 seq=88 len=2025 time=0.224
demux_asf.read_packet: id=1 seq=89 len=1954 time=0.225
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=89 len=71 time=0.225
demux_asf.read_packet: id=1 seq=90 len=2025 time=0.226
demux_asf.read_packet: id=1 seq=91 len=2025 time=0.227
demux_asf.read_packet: id=1 seq=92 len=2025 time=0.228
demux_asf.read_packet: id=1 seq=93 len=1107 time=0.229
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=93 len=918 time=0.229
demux_asf.read_packet: id=1 seq=94 len=2025 time=0.230
demux_asf.read_packet: id=1 seq=95 len=29 time=0.231

FRAME END: filepts=0.221, newpts=0.179, diff=-0.042, avg=0.033, segct=14, avgsegct=16, key=0

demux_asf.read_packet: id=1 seq=96 len=1991 time=0.232
demux_asf.read_packet: id=1 seq=97 len=2025 time=0.233
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=98 len=2025 time=0.270
demux_asf.read_packet: id=1 seq=99 len=2025 time=0.271
demux_asf.read_packet: id=1 seq=100 len=1217 time=0.272
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=100 len=808 time=0.272
demux_asf.read_packet: id=1 seq=101 len=2025 time=0.273
demux_asf.read_packet: id=1 seq=102 len=2025 time=0.274
demux_asf.read_packet: id=1 seq=103 len=2025 time=0.275
demux_asf.read_packet: id=1 seq=104 len=370 time=0.276
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=104 len=1655 time=0.276
demux_asf.read_packet: id=1 seq=105 len=1541 time=0.277

FRAME END: filepts=0.232, newpts=0.214, diff=-0.018, avg=0.034, segct=12, avgsegct=15, key=0

demux_asf.read_packet: id=1 seq=106 len=474 time=0.278
demux_asf.read_packet: id=1 seq=107 len=2025 time=0.279
demux_asf.read_packet: id=1 seq=108 len=1558 time=0.280
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=108 len=467 time=0.280
demux_asf.read_packet: id=1 seq=109 len=2025 time=0.281
demux_asf.read_packet: id=1 seq=110 len=2025 time=0.282
demux_asf.read_packet: id=1 seq=111 len=2025 time=0.283
demux_asf.read_packet: id=1 seq=112 len=711 time=0.284
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=112 len=1314 time=0.284
demux_asf.read_packet: id=1 seq=113 len=2025 time=0.285
demux_asf.read_packet: id=1 seq=114 len=2025 time=0.286
demux_asf.read_packet: id=1 seq=115 len=2025 time=0.287
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=116 len=2025 time=0.288
demux_asf.read_packet: id=1 seq=117 len=2025 time=0.289
demux_asf.read_packet: id=1 seq=118 len=2025 time=0.290
demux_asf.read_packet: id=1 seq=119 len=1363 time=0.291
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=119 len=662 time=0.291
demux_asf.read_packet: id=1 seq=120 len=2025 time=0.292
demux_asf.read_packet: id=1 seq=121 len=844 time=0.293

FRAME END: filepts=0.278, newpts=0.247, diff=-0.031, avg=0.033, segct=19, avgsegct=16, key=0

demux_asf.read_packet: id=1 seq=122 len=1176 time=0.294
demux_asf.read_packet: id=1 seq=123 len=2025 time=0.295
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=124 len=2025 time=0.322
demux_asf.read_packet: id=1 seq=125 len=2025 time=0.323
demux_asf.read_packet: id=1 seq=126 len=2025 time=0.324
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=127 len=2025 time=0.326
demux_asf.read_packet: id=1 seq=128 len=2025 time=0.327
demux_asf.read_packet: id=1 seq=129 len=2025 time=0.328
demux_asf.read_packet: id=1 seq=130 len=557 time=0.329
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=130 len=1468 time=0.329
demux_asf.read_packet: id=1 seq=131 len=1884 time=0.330

FRAME END: filepts=0.294, newpts=0.280, diff=-0.014, avg=0.033, segct=11, avgsegct=15, key=0

demux_asf.read_packet: id=1 seq=132 len=136 time=0.331
demux_asf.read_packet: id=1 seq=133 len=2025 time=0.332
demux_asf.read_packet: id=1 seq=134 len=1740 time=0.333
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=134 len=285 time=0.333
demux_asf.read_packet: id=1 seq=135 len=2025 time=0.334
demux_asf.read_packet: id=1 seq=136 len=2025 time=0.335
demux_asf.read_packet: id=1 seq=137 len=2025 time=0.336
demux_asf.read_packet: id=1 seq=138 len=893 time=0.337
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=138 len=1132 time=0.337
demux_asf.read_packet: id=1 seq=139 len=2025 time=0.338
demux_asf.read_packet: id=1 seq=140 len=2025 time=0.339
demux_asf.read_packet: id=1 seq=141 len=2025 time=0.340
demux_asf.read_packet: id=1 seq=142 len=47 time=0.341
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=142 len=44 time=0.341

FRAME END: filepts=0.331, newpts=0.311, diff=-0.020, avg=0.032, segct=14, avgsegct=15, key=0

demux_asf.read_packet: id=1 seq=143 len=1924 time=0.342
demux_asf.read_packet: id=1 seq=144 len=2025 time=0.343
demux_asf.read_packet: id=1 seq=145 len=920 time=0.404
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=145 len=1105 time=0.404
demux_asf.read_packet: id=1 seq=146 len=2025 time=0.405
demux_asf.read_packet: id=1 seq=147 len=2025 time=0.406
demux_asf.read_packet: id=1 seq=148 len=2025 time=0.407
demux_asf.read_packet: id=1 seq=149 len=73 time=0.408
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=149 len=1952 time=0.408
demux_asf.read_packet: id=1 seq=150 len=2025 time=0.409
demux_asf.read_packet: id=1 seq=151 len=2025 time=0.410
demux_asf.read_packet: id=1 seq=152 len=1436 time=0.411
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=152 len=589 time=0.411
demux_asf.read_packet: id=1 seq=153 len=2025 time=0.412
demux_asf.read_packet: id=1 seq=154 len=2025 time=0.413
demux_asf.read_packet: id=1 seq=155 len=2025 time=0.414
demux_asf.read_packet: id=1 seq=156 len=589 time=0.415
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=156 len=1436 time=0.415
demux_asf.read_packet: id=1 seq=157 len=2025 time=0.416
demux_asf.read_packet: id=1 seq=158 len=450 time=0.417

FRAME END: filepts=0.342, newpts=0.346, diff=0.004, avg=0.033, segct=20, avgsegct=15, key=0

demux_asf.read_packet: id=1 seq=159 len=1570 time=0.418
demux_asf.read_packet: id=1 seq=160 len=1772 time=0.419
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=160 len=253 time=0.419
demux_asf.read_packet: id=1 seq=161 len=2025 time=0.420
demux_asf.read_packet: id=1 seq=162 len=2025 time=0.421
demux_asf.read_packet: id=1 seq=163 len=2025 time=0.422
demux_asf.read_packet: id=1 seq=164 len=925 time=0.423
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=164 len=1100 time=0.423
demux_asf.read_packet: id=1 seq=165 len=2025 time=0.424
demux_asf.read_packet: id=1 seq=166 len=2025 time=0.425
demux_asf.read_packet: id=1 seq=167 len=2025 time=0.426
demux_asf.read_packet: id=1 seq=168 len=78 time=0.427
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=168 len=172 time=0.427

FRAME END: filepts=0.418, newpts=0.379, diff=-0.039, avg=0.033, segct=13, avgsegct=15, key=0

demux_asf.read_packet: id=1 seq=169 len=1770 time=0.428
demux_asf.read_packet: id=1 seq=170 len=2025 time=0.429
demux_asf.read_packet: id=1 seq=171 len=2025 time=0.430
demux_asf.read_packet: id=1 seq=172 len=1261 time=0.431
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=172 len=764 time=0.431
demux_asf.read_packet: id=1 seq=173 len=2025 time=0.432
demux_asf.read_packet: id=1 seq=174 len=2025 time=0.433
demux_asf.read_packet: id=1 seq=175 len=2025 time=0.434
demux_asf.read_packet: id=1 seq=176 len=414 time=0.435
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=176 len=1611 time=0.435
demux_asf.read_packet: id=1 seq=177 len=2025 time=0.437
demux_asf.read_packet: id=1 seq=178 len=530 time=0.438

FRAME END: filepts=0.428, newpts=0.410, diff=-0.018, avg=0.032, segct=12, avgsegct=15, key=0

demux_asf.read_packet: id=1 seq=179 len=1485 time=0.439
demux_asf.read_packet: id=1 seq=180 len=1433 time=0.440
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=180 len=592 time=0.440
demux_asf.read_packet: id=1 seq=181 len=2025 time=0.474
demux_asf.read_packet: id=1 seq=182 len=2025 time=0.475
demux_asf.read_packet: id=1 seq=183 len=440 time=0.477

NEW ASFPACKET
demux_asf.read_packet: id=1 seq=183 len=1585 time=0.477
demux_asf.read_packet: id=1 seq=184 len=2025 time=0.479
demux_asf.read_packet: id=1 seq=185 len=2025 time=0.480
demux_asf.read_packet: id=1 seq=186 len=1803 time=0.481
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=186 len=222 time=0.481
demux_asf.read_packet: id=1 seq=187 len=2025 time=0.482
demux_asf.read_packet: id=1 seq=188 len=2025 time=0.483
demux_asf.read_packet: id=1 seq=189 len=2025 time=0.484
demux_asf.read_packet: id=1 seq=190 len=956 time=0.485
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=190 len=1069 time=0.485
demux_asf.read_packet: id=1 seq=191 len=2025 time=0.486
demux_asf.read_packet: id=1 seq=192 len=2025 time=0.487
demux_asf.read_packet: id=1 seq=193 len=2025 time=0.488
demux_asf.read_packet: id=1 seq=194 len=109 time=0.489
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=194 len=1340 time=0.489

FRAME END: filepts=0.439, newpts=0.443, diff=0.004, avg=0.033, segct=21, avgsegct=15, key=0

demux_asf.read_packet: id=1 seq=195 len=571 time=0.491
demux_asf.read_packet: id=1 seq=196 len=2025 time=0.492
demux_asf.read_packet: id=1 seq=197 len=2025 time=0.493
demux_asf.read_packet: id=1 seq=198 len=1123 time=0.494
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=198 len=902 time=0.494
demux_asf.read_packet: id=1 seq=199 len=2025 time=0.495
demux_asf.read_packet: id=1 seq=200 len=2025 time=0.496
demux_asf.read_packet: id=1 seq=201 len=2025 time=0.497
demux_asf.read_packet: id=1 seq=202 len=276 time=0.498
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=202 len=1749 time=0.498
demux_asf.read_packet: id=1 seq=203 len=2025 time=0.499
demux_asf.read_packet: id=1 seq=204 len=1705 time=0.500

FRAME END: filepts=0.491, newpts=0.474, diff=-0.017, avg=0.032, segct=12, avgsegct=15, key=0

demux_asf.read_packet: id=1 seq=205 len=315 time=0.501
demux_asf.read_packet: id=1 seq=206 len=1459 time=0.502
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=206 len=566 time=0.502
demux_asf.read_packet: id=1 seq=207 len=2025 time=0.553
demux_asf.read_packet: id=1 seq=208 len=2025 time=0.556
demux_asf.read_packet: id=1 seq=209 len=297 time=0.557
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=209 len=1728 time=0.557
demux_asf.read_packet: id=1 seq=210 len=2025 time=0.558
demux_asf.read_packet: id=1 seq=211 len=2025 time=0.559
demux_asf.read_packet: id=1 seq=212 len=1660 time=0.560
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=212 len=365 time=0.560
demux_asf.read_packet: id=1 seq=213 len=2025 time=0.561
demux_asf.read_packet: id=1 seq=214 len=2025 time=0.562
demux_asf.read_packet: id=1 seq=215 len=216 time=0.563

FRAME END: filepts=0.501, newpts=0.507, diff=0.006, avg=0.033, segct=14, avgsegct=15, key=0

demux_asf.read_packet: id=1 seq=216 len=1799 time=0.564
demux_asf.read_packet: id=1 seq=217 len=638 time=0.565
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=217 len=1387 time=0.565
demux_asf.read_packet: id=1 seq=218 len=2025 time=0.566
demux_asf.read_packet: id=1 seq=219 len=2025 time=0.567
demux_asf.read_packet: id=1 seq=220 len=2001 time=0.568
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=220 len=24 time=0.568
demux_asf.read_packet: id=1 seq=221 len=2025 time=0.569
demux_asf.read_packet: id=1 seq=222 len=2025 time=0.570
demux_asf.read_packet: id=1 seq=223 len=2025 time=0.571
demux_asf.read_packet: id=1 seq=224 len=1154 time=0.572
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=224 len=871 time=0.572
demux_asf.read_packet: id=1 seq=225 len=2025 time=0.573
demux_asf.read_packet: id=1 seq=226 len=2025 time=0.574
demux_asf.read_packet: id=1 seq=227 len=2025 time=0.575
demux_asf.read_packet: id=1 seq=228 len=307 time=0.576
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=228 len=1718 time=0.576
demux_asf.read_packet: id=1 seq=229 len=2025 time=0.577
demux_asf.read_packet: id=1 seq=230 len=2025 time=0.578
demux_asf.read_packet: id=1 seq=231 len=1311 time=0.579

FRAME END: filepts=0.564, newpts=0.539, diff=-0.025, avg=0.032, segct=20, avgsegct=15, key=0

demux_asf.read_packet: id=1 seq=232 len=174 time=0.580
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=232 len=535 time=0.580
demux_asf.read_packet: id=1 seq=233 len=2025 time=0.581
demux_asf.read_packet: id=1 seq=234 len=2025 time=0.622
demux_asf.read_packet: id=1 seq=235 len=328 time=0.623
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=235 len=1697 time=0.623
demux_asf.read_packet: id=1 seq=236 len=2025 time=0.624
demux_asf.read_packet: id=1 seq=237 len=2025 time=0.625
demux_asf.read_packet: id=1 seq=238 len=1691 time=0.626
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=238 len=334 time=0.626
demux_asf.read_packet: id=1 seq=239 len=2025 time=0.627
demux_asf.read_packet: id=1 seq=240 len=2025 time=0.628
demux_asf.read_packet: id=1 seq=241 len=1703 time=0.629

FRAME END: filepts=0.580, newpts=0.573, diff=-0.007, avg=0.033, segct=13, avgsegct=15, key=0

demux_asf.read_packet: id=1 seq=242 len=317 time=0.630
demux_asf.read_packet: id=1 seq=243 len=664 time=0.631
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=243 len=1361 time=0.631
demux_asf.read_packet: id=1 seq=244 len=2025 time=0.632
demux_asf.read_packet: id=1 seq=245 len=2025 time=0.633
demux_asf.read_packet: id=1 seq=246 len=2025 time=0.634
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=247 len=2025 time=0.635
demux_asf.read_packet: id=1 seq=248 len=2025 time=0.636
demux_asf.read_packet: id=1 seq=249 len=2025 time=0.637
demux_asf.read_packet: id=1 seq=250 len=1363 time=0.638
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=250 len=662 time=0.638

FRAME END: filepts=0.630, newpts=0.605, diff=-0.025, avg=0.032, segct=11, avgsegct=15, key=0

demux_asf.read_packet: id=1 seq=251 len=48 time=0.639
demux_asf.read_packet: id=1 seq=252 len=40 time=0.640
demux_asf.read_packet: id=1 seq=253 len=1985 time=0.641
demux_asf.read_packet: id=1 seq=254 len=27 time=0.688
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=254 len=1998 time=0.688
demux_asf.read_packet: id=1 seq=255 len=2025 time=0.689
demux_asf.read_packet: id=1 seq=0 len=2025 time=0.690
demux_asf.read_packet: id=1 seq=1 len=1390 time=0.691
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=1 len=635 time=0.691
demux_asf.read_packet: id=1 seq=2 len=2025 time=0.692
demux_asf.read_packet: id=1 seq=3 len=2025 time=0.693
demux_asf.read_packet: id=1 seq=4 len=2025 time=0.694
demux_asf.read_packet: id=1 seq=5 len=543 time=0.695
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=5 len=1482 time=0.695
demux_asf.read_packet: id=1 seq=6 len=2025 time=0.696
demux_asf.read_packet: id=1 seq=7 len=2025 time=0.697
demux_asf.read_packet: id=1 seq=8 len=1906 time=0.698
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=8 len=119 time=0.698
demux_asf.read_packet: id=1 seq=9 len=2025 time=0.699
demux_asf.read_packet: id=1 seq=10 len=2025 time=0.700
demux_asf.read_packet: id=1 seq=11 len=2025 time=0.701
demux_asf.read_packet: id=1 seq=12 len=1059 time=0.702
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=12 len=966 time=0.702
demux_asf.read_packet: id=1 seq=13 len=2025 time=0.703
demux_asf.read_packet: id=1 seq=14 len=2025 time=0.704
demux_asf.read_packet: id=1 seq=15 len=2025 time=0.705
demux_asf.read_packet: id=1 seq=16 len=212 time=0.706
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=16 len=1813 time=0.706
demux_asf.read_packet: id=1 seq=17 len=2025 time=0.707
demux_asf.read_packet: id=1 seq=18 len=2025 time=0.708
demux_asf.read_packet: id=1 seq=19 len=1575 time=0.709
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=19 len=450 time=0.709
demux_asf.read_packet: id=1 seq=20 len=2025 time=0.710
demux_asf.read_packet: id=1 seq=21 len=2025 time=0.711
demux_asf.read_packet: id=1 seq=22 len=2025 time=0.712
demux_asf.read_packet: id=1 seq=23 len=728 time=0.713
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=23 len=1297 time=0.713
demux_asf.read_packet: id=1 seq=24 len=2025 time=0.714
demux_asf.read_packet: id=1 seq=25 len=2025 time=0.715
demux_asf.read_packet: id=1 seq=26 len=2025 time=0.716
NEW ASFPACKET
demux_asf.read_packet: id=1 seq=27 len=1518 time=0.717

FRAME END: filepts=0.639, newpts=0.639, diff=-0.000, avg=0.033, segct=41, avgsegct=16, key=1