[confirm] TV Stream Hangs - Mediaportal Responsive (1 Viewer)

Crew

Portal Pro
April 24, 2007
61
0
MediaPortal Version: 1.2 Beta (1.1.7)

On a multi-seat setup I'm having a problem with the TV Server

When a hang occurs I get the following in the TsWriter log:
Code:
08-07-2011 08:45:27.24 Recorder: TIMESHIFT Info : Program clock reference forward jump ( 85182 ).
08-07-2011 08:45:33.71 Recorder:Pid 283 , No PayLoad, Continuity Counter should be the same ! 6 ( prev f )
08-07-2011 08:45:33.165 Recorder: TIMESHIFT Info : Program clock reference forward jump ( 365487 ).
08-07-2011 08:45:45.711 Recorder: TIMESHIFT Info : Program clock reference forward jump ( 248925 ).
08-07-2011 08:45:46.102 Recorder: TIMESHIFT Info : Program clock reference forward jump ( 554318 ).
08-07-2011 08:45:49.24 Recorder: TIMESHIFT Info : Program clock reference forward jump ( 160726 ).
08-07-2011 08:45:53.524 Recorder:Pid 283 , No PayLoad, Continuity Counter should be the same ! b ( prev d )
08-07-2011 08:45:53.539 Recorder:Pid 283 , No PayLoad, Continuity Counter should be the same ! a ( prev 8 )
08-07-2011 08:45:53.602 Recorder: TIMESHIFT Info : Program clock reference forward jump ( 312081 ).
08-07-2011 08:45:57.539 Recorder: TIMESHIFT Info : Program clock reference forward jump ( 91385 ).
08-07-2011 08:46:07.852 Recorder: TIMESHIFT Info : Program clock reference forward jump ( 161089 ).
08-07-2011 08:46:08.86 Recorder:Pid 283 , No PayLoad, Continuity Counter should be the same ! 3 ( prev 8 )
08-07-2011 08:46:16.430 Recorder:Pid 283 , No PayLoad, Continuity Counter should be the same ! 9 ( prev 5 )
08-07-2011 08:46:16.461 Recorder: TIMESHIFT Info : Program clock reference forward jump ( 211245 ).
08-07-2011 08:46:22.508 Recorder: TIMESHIFT Info : Program clock reference forward jump ( 390749 ).
08-07-2011 08:46:27.586 Recorder: TIMESHIFT Info : Program clock reference forward jump ( 217459 ).
08-07-2011 08:46:27.633 Recorder:Pid 283 , No PayLoad, Continuity Counter should be the same ! a ( prev d )
08-07-2011 08:46:32.914 Recorder: TIMESHIFT Info : Program clock reference forward jump ( 252057 ).
08-07-2011 08:46:33.117 Recorder:Pid 283 , No PayLoad, Continuity Counter should be the same ! f ( prev 5 )
08-07-2011 08:46:40.695 Recorder:Pid 283 , No PayLoad, Continuity Counter should be the same ! 9 ( prev 3 )
08-07-2011 08:46:40.711 Recorder: TIMESHIFT Info : Program clock reference forward jump ( 232909 ).
08-07-2011 08:46:50.539 Recorder: TIMESHIFT Info : Program clock reference forward jump ( 38051 ).
08-07-2011 08:46:58.242 Recorder: TIMESHIFT Info : Program clock reference forward jump ( 97766 ).
08-07-2011 08:47:08.742 Recorder: TIMESHIFT Info : Program clock reference forward jump ( 53457 ).
08-07-2011 08:47:12.742 Recorder: TIMESHIFT Info : Program clock reference forward jump ( 236427 ).
08-07-2011 08:48:43.288 Recorder: TIMESHIFT Info : Program clock reference forward jump ( 277219 ).
08-07-2011 08:48:50.553 Recorder: TIMESHIFT Info : Program clock reference forward jump ( 485340 ).
08-07-2011 08:48:56.850 Recorder: TIMESHIFT Info : Program clock reference forward jump ( 327607 ).
08-07-2011 08:49:01.756 Recorder: TIMESHIFT Info : Program clock reference forward jump ( 233271 ).
08-07-2011 08:49:08.319 Recorder: TIMESHIFT Info : Program clock reference forward jump ( 464539 ).
08-07-2011 08:49:17.428 Recorder: TIMESHIFT Info : Program clock reference forward jump ( 718453 ).
08-07-2011 08:49:19.631 Recorder: TIMESHIFT Info : Program clock reference forward jump ( 44112 ).
08-07-2011 08:49:24.678 Recorder: TIMESHIFT Info : Program clock reference forward jump ( 227003 ).

In the streaming server log I get:
Code:
08-07-2011 08:45:47.102 TSBuffer::Require() - Failed to read buffer file
08-07-2011 08:45:53.524 generateSDPDescription() duration 496.398010 : a=range:npt=0-496.398


08-07-2011 08:45:55.868 TSBuffer::Require() - Failed to read buffer file
08-07-2011 08:45:56.883 TSBuffer::Require() - Failed to read buffer file
08-07-2011 08:45:56.883 ts:eof reached
08-07-2011 08:45:58.539 generateSDPDescription() duration 501.537994 : a=range:npt=0-501.538

The TV Server appears to carry on streaming however the client picture stays frozen.

Included in this post is the logs, the freeze happens at 8:45am.

Andrew
 

OnkelChris

Retired Team Member
  • Premium Supporter
  • October 17, 2007
    764
    59
    Home Country
    Germany Germany
    AW: TV Stream Hangs - Mediaportal Responsive

    try to step back... i have a multiseat with wireless lan and this sometimes occur -> just press "left" on the remote, wait for the playback, hit the "right" key
     

    mm1352000

    Retired Team Member
  • Premium Supporter
  • September 1, 2008
    21,577
    8,224
    Home Country
    New Zealand New Zealand
    Hi Crew

    Those "No PayLoad, Continuity Counter should be the same" messages could indicate signal problems.

    mm
     

    Crew

    Portal Pro
    April 24, 2007
    61
    0
    Hi

    I'm in a reasonably low signal area so possibly, however it runs fine for 1-2 hours then stops, but the stream keeps going. OnkelChris suggests going back and forward on the time stream to restart the client but why can the client not recover itself? If I join the time stream from another client its fine.

    Is it worth me grabbing the client logs so you can see if it has a panic?

    Andrew
     

    OnkelChris

    Retired Team Member
  • Premium Supporter
  • October 17, 2007
    764
    59
    Home Country
    Germany Germany
    AW: TV Stream Hangs - Mediaportal Responsive

    does going back and forward in the timeline help?
     

    mm1352000

    Retired Team Member
  • Premium Supporter
  • September 1, 2008
    21,577
    8,224
    Home Country
    New Zealand New Zealand
    I'm in a reasonably low signal area so possibly, however it runs fine for 1-2 hours then stops, but the stream keeps going...
    It sounds like what actually happens is that the picture freezes but the audio keeps going. Would that be correct? If that is the case you should definitely try what OnkelChris suggested. If that works then what is happening is that corruption in the stream from the tuner (caused by your bad/low signal) is causing the video codec to panic and give up decoding. MediaPortal has absolutely no way of detecting that because the decoding that happens inside a codec is a complete black box to MP. All that you could do if that is truly what is happening is:
    1. Try to improve your signal quality.
    2. Try different codecs (some codecs like FFDShow are more resilient to stream corruption than others).

    mm
     

    Crew

    Portal Pro
    April 24, 2007
    61
    0
    Following what OnkelChris suggested, the sound does not continue when frozen. Clicking back and forward does indeed correct the problem.

    Actually scrap that. Clicking back and forward does bring the running stream back to the fore. However the stream stutters and is breaking up constantly causing a stop with 10 seconds. Using the TV OFF button and TV ON button brings up a new stream that is fine???
     

    mm1352000

    Retired Team Member
  • Premium Supporter
  • September 1, 2008
    21,577
    8,224
    Home Country
    New Zealand New Zealand
    So is your timeshifting HDD running out of space or something then? Stopping and restarting TV would likely wipe all the timeshifting files...
     

    Crew

    Portal Pro
    April 24, 2007
    61
    0
    The server has 30gb free, I've just changed the timestamp size from 256 to 512. The client has 20gb free.
     

    Crew

    Portal Pro
    April 24, 2007
    61
    0
    Here is the client log. Stops at 11:12

    Code:
    11-07-2011 11:11:30.784 [d8]Vid/Ref : 46.921, Late B-frame(27), Compensated = 47.238 ( -4.028 A/V buffers=00/30), Clk : 51.265583, State 1
    11-07-2011 11:11:30.785 [cdc]Aud/Ref : 49.258, Late              Compensated = 49.575 ( -1.691 A/V buffers=01/29), Clk : 51.265583, State 1
    11-07-2011 11:11:30.787 [d8]Vid/Ref : 46.961, Late B-frame(28), Compensated = 47.278 ( -3.988 A/V buffers=00/29), Clk : 51.265583, State 1
    11-07-2011 11:11:30.789 [d8]Vid/Ref : 47.241, Late P-frame(05), Compensated = 47.558 ( -3.708 A/V buffers=01/28), Clk : 51.265583, State 1
    11-07-2011 11:11:30.793 [d8]Vid/Ref : 47.161, Late B-frame(03), Compensated = 47.478 ( -3.788 A/V buffers=00/29), Clk : 51.265583, State 1
    11-07-2011 11:11:30.796 [d8]Vid/Ref : 47.201, Late B-frame(04), Compensated = 47.518 ( -3.748 A/V buffers=00/28), Clk : 51.265583, State 1
    11-07-2011 11:11:30.797 [cdc]Aud/Ref : 49.402, Late              Compensated = 49.719 ( -1.547 A/V buffers=01/28), Clk : 51.265583, State 1
    11-07-2011 11:11:30.800 [d8]Vid/Ref : 47.361, Late P-frame(08), Compensated = 47.678 ( -3.588 A/V buffers=00/27), Clk : 51.265583, State 1
    11-07-2011 11:11:30.803 [d8]Vid/Ref : 47.401, Late B-frame(09), Compensated = 47.718 ( -3.548 A/V buffers=00/26), Clk : 51.265583, State 1
    11-07-2011 11:11:30.811 [d8]Vid/Ref : 47.441, Late B-frame(10), Compensated = 47.758 ( -3.508 A/V buffers=01/27), Clk : 51.265583, State 1
    11-07-2011 11:11:30.814 [d8]Vid/Ref : 47.841, Late P-frame(20), Compensated = 48.158 ( -3.108 A/V buffers=00/27), Clk : 51.265583, State 1
    11-07-2011 11:11:30.816 [d8]Vid/Ref : 47.761, Late B-frame(18), Compensated = 48.078 ( -3.188 A/V buffers=00/26), Clk : 51.265583, State 1
    11-07-2011 11:11:30.818 [cdc]Aud/Ref : 49.546, Late              Compensated = 49.863 ( -1.403 A/V buffers=01/26), Clk : 51.265583, State 1
    11-07-2011 11:11:30.820 [d8]Vid/Ref : 48.001, Late B-frame(24), Compensated = 48.318 ( -2.948 A/V buffers=00/25), Clk : 51.265583, State 1
    11-07-2011 11:11:30.823 [d8]Vid/Ref : 48.571, Late P-frame(14), Compensated = 48.888 ( -2.378 A/V buffers=00/25), Clk : 51.265583, State 1
    11-07-2011 11:11:30.827 [d8]Vid/Ref : 48.691, Late P-frame(17), Compensated = 49.008 ( -2.258 A/V buffers=00/25), Clk : 51.265583, State 1
    11-07-2011 11:11:30.841 [cdc]Aud/Ref : 49.690, Late              Compensated = 50.007 ( -1.259 A/V buffers=01/28), Clk : 51.265583, State 1
    11-07-2011 11:11:30.842 [104]CTsReaderFilter::Run(4503.97) state 1 seeking 0
    11-07-2011 11:11:30.843 [104]Elapsed time from pause to Audio/Video ( total zapping time ) : 203 mS
    11-07-2011 11:11:30.844 [104]CTsReaderFilter::Run(4503.97) state 2 -->done
    11-07-2011 11:11:30.853 [d8]Vid/Ref : 48.611, Late B-frame(15), Compensated = 48.928 ( -2.354 A/V buffers=00/31), Clk : 51.281582, State 2
    11-07-2011 11:11:30.855 [cdc]Aud/Ref : 49.834, Late              Compensated = 50.151 ( -1.131 A/V buffers=01/31), Clk : 51.281582, State 2
    11-07-2011 11:11:30.884 [d8]Vid/Ref : 48.651, Late B-frame(16), Compensated = 48.968 ( -2.345 A/V buffers=00/36), Clk : 51.312584, State 2
    11-07-2011 11:11:30.885 [cdc]Aud/Ref : 49.978, Late              Compensated = 50.295 ( -1.018 A/V buffers=01/36), Clk : 51.312584, State 2
    11-07-2011 11:11:30.888 [d8]Vid/Ref : 48.811, Late P-frame(20), Compensated = 49.128 ( -2.185 A/V buffers=00/35), Clk : 51.312584, State 2
    11-07-2011 11:11:30.906 [cdc]Aud/Ref : 50.122, Late              Compensated = 50.439 ( -0.821 A/V buffers=01/36), Clk : 51.259583, State 2
    11-07-2011 11:11:30.917 [d8]Vid/Ref : 48.731, Late B-frame(18), Compensated = 49.048 ( -2.227 A/V buffers=00/38), Clk : 51.274582, State 2
    11-07-2011 11:11:30.926 [d8]Vid/Ref : 49.011, Late B-frame(25), Compensated = 49.328 ( -1.947 A/V buffers=00/37), Clk : 51.274582, State 2
    11-07-2011 11:11:30.928 [d8]Vid/Ref : 49.171, Late P-frame(29), Compensated = 49.488 ( -1.803 A/V buffers=00/36), Clk : 51.290585, State 2
    11-07-2011 11:11:30.932 [d8]Vid/Ref : 49.131, Late B-frame(28), Compensated = 49.448 ( -1.843 A/V buffers=00/35), Clk : 51.290585, State 2
    11-07-2011 11:11:30.946 [d8]Vid/Ref : 49.291, Late P-frame(32), Compensated = 49.608 ( -1.698 A/V buffers=00/34), Clk : 51.305584, State 2
    11-07-2011 11:11:30.950 [d8]Vid/Ref : 50.611, Late P-frame(29), Compensated = 50.928 ( -0.332 A/V buffers=00/33), Clk : 51.259583, State 2
    11-07-2011 11:11:30.953 [d8]Vid/Ref : 50.531, Late B-frame(27), Compensated = 50.848 ( -0.412 A/V buffers=00/32), Clk : 51.259583, State 2
    11-07-2011 11:11:30.955 [d8]Vid/Ref : 49.691, Late B-frame(28), Compensated = 50.008 ( -1.252 A/V buffers=00/31), Clk : 51.259583, State 2
    11-07-2011 11:11:30.957 [d8]Vid/Ref : 49.851, Late P-frame(32), Compensated = 50.168 ( -1.092 A/V buffers=00/30), Clk : 51.259583, State 2
    11-07-2011 11:11:30.959 [d8]Vid/Ref : 49.771, Late B-frame(30), Compensated = 50.088 ( -1.188 A/V buffers=00/29), Clk : 51.275585, State 2
    11-07-2011 11:11:30.961 [d8]Vid/Ref : 49.811, Late B-frame(31), Compensated = 50.128 ( -1.148 A/V buffers=00/28), Clk : 51.275585, State 2
    11-07-2011 11:11:30.964 [d8]Vid/Ref : 49.971, Late P-frame(35), Compensated = 50.288 ( -0.988 A/V buffers=00/27), Clk : 51.275585, State 2
    11-07-2011 11:11:30.967 [d8]Vid/Ref : 49.891, Late B-frame(33), Compensated = 50.208 ( -1.068 A/V buffers=00/26), Clk : 51.275585, State 2
    11-07-2011 11:11:30.969 [d8]Vid/Ref : 49.931, Late B-frame(34), Compensated = 50.248 ( -1.028 A/V buffers=00/25), Clk : 51.275585, State 2
    11-07-2011 11:11:30.971 [d8]Vid/Ref : 50.091, Late I-frame(02), Compensated = 50.408 ( -0.868 A/V buffers=00/24), Clk : 51.275585, State 2
    11-07-2011 11:11:30.975 [d8]Vid/Ref : 50.011, Late B-frame(00), Compensated = 50.328 ( -0.964 A/V buffers=00/23), Clk : 51.291584, State 2
    11-07-2011 11:11:30.976 [cdc]Demux : Audio to render -0.708 Sec
    11-07-2011 11:11:30.978 [cdc]Demux : Audio to render too late= -0.708 Sec, rendering will be paused for a while
    11-07-2011 11:11:30.987 [cdc]Aud/Ref : 50.266, Late              Compensated = 50.583 ( -0.709 A/V buffers=01/23), Clk : 51.291584, State 2
    11-07-2011 11:11:30.989 [104]Pause 200mS renderer clock to match provider/RTSP clock...
    11-07-2011 11:11:30.990 [d8]Vid/Ref : 50.051, Late B-frame(01), Compensated = 50.368 ( -0.907 A/V buffers=00/23), Clk : 51.274582, State 2
    11-07-2011 11:11:30.993 [d8]Vid/Ref : 50.211, Late P-frame(05), Compensated = 50.528 ( -0.747 A/V buffers=00/23), Clk : 51.274582, State 2
    11-07-2011 11:11:30.994 [104]CTsReaderFilter::Pause() - IsTimeShifting = 1 - state = 2
    11-07-2011 11:11:30.995 [104]CTsReaderFilter::Pause() - END - state = 1
    11-07-2011 11:11:31.003 [d8]Vid/Ref : 50.131, Late B-frame(03), Compensated = 50.448 ( -0.827 A/V buffers=00/22), Clk : 51.274582, State 1
    11-07-2011 11:11:31.012 [d8]Vid/Ref : 50.171, Late B-frame(04), Compensated = 50.488 ( -0.787 A/V buffers=00/21), Clk : 51.274582, State 1
    11-07-2011 11:11:31.014 [d8]Vid/Ref : 50.331, Late P-frame(08), Compensated = 50.648 ( -0.627 A/V buffers=00/20), Clk : 51.274582, State 1
    11-07-2011 11:11:31.016 [d8]Vid/Ref : 50.251, Late B-frame(06), Compensated = 50.568 ( -0.707 A/V buffers=00/19), Clk : 51.274582, State 1
    11-07-2011 11:11:31.018 [d8]Vid/Ref : 50.291, Late B-frame(07), Compensated = 50.608 ( -0.667 A/V buffers=00/18), Clk : 51.274582, State 1
    11-07-2011 11:11:31.020 [d8]Vid/Ref : 50.451, Late P-frame(11), Compensated = 50.768 ( -0.507 A/V buffers=00/17), Clk : 51.274582, State 1
    11-07-2011 11:11:31.022 [d8]Vid/Ref : 50.371, Late B-frame(09), Compensated = 50.688 ( -0.587 A/V buffers=00/16), Clk : 51.274582, State 1
    11-07-2011 11:11:31.024 [d8]Vid/Ref : 50.411, Late B-frame(10), Compensated = 50.728 ( -0.547 A/V buffers=00/15), Clk : 51.274582, State 1
    11-07-2011 11:11:31.026 [d8]Vid/Ref : 50.571, Late P-frame(14), Compensated = 50.888 ( -0.387 A/V buffers=00/14), Clk : 51.274582, State 1
    11-07-2011 11:11:31.028 [d8]Vid/Ref : 50.491, Late B-frame(12), Compensated = 50.808 ( -0.467 A/V buffers=00/13), Clk : 51.274582, State 1
    11-07-2011 11:11:31.030 [d8]Vid/Ref : 50.531, Late B-frame(13), Compensated = 50.848 ( -0.427 A/V buffers=00/12), Clk : 51.274582, State 1
    11-07-2011 11:11:31.032 [d8]Vid/Ref : 50.691, Late P-frame(17), Compensated = 51.008 ( -0.267 A/V buffers=00/11), Clk : 51.274582, State 1
    11-07-2011 11:11:31.034 [d8]Vid/Ref : 50.611, Late B-frame(15), Compensated = 50.928 ( -0.347 A/V buffers=00/10), Clk : 51.274582, State 1
    11-07-2011 11:11:31.036 [d8]Vid/Ref : 50.651, Late B-frame(16), Compensated = 50.968 ( -0.307 A/V buffers=00/09), Clk : 51.274582, State 1
    11-07-2011 11:11:31.038 [d8]Vid/Ref : 50.811, Late P-frame(20), Compensated = 51.128 ( -0.147 A/V buffers=00/08), Clk : 51.274582, State 1
    11-07-2011 11:11:31.040 [d8]Vid/Ref : 50.731, Late B-frame(18), Compensated = 51.048 ( -0.227 A/V buffers=00/07), Clk : 51.274582, State 1
    11-07-2011 11:11:31.041 [d8]Vid/Ref : 50.771, Late B-frame(19), Compensated = 51.088 ( -0.187 A/V buffers=00/06), Clk : 51.274582, State 1
    11-07-2011 11:11:31.043 [d8]Vid/Ref : 50.931, Late P-frame(23), Compensated = 51.248 ( -0.027 A/V buffers=00/05), Clk : 51.274582, State 1
    11-07-2011 11:11:31.045 [d8]Vid/Ref : 50.851, Late B-frame(21), Compensated = 51.168 ( -0.107 A/V buffers=00/04), Clk : 51.274582, State 1
    11-07-2011 11:11:31.047 [d8]Vid/Ref : 50.891, Late B-frame(22), Compensated = 51.208 ( -0.067 A/V buffers=00/03), Clk : 51.274582, State 1
    11-07-2011 11:11:31.049 [d8]Vid/Ref : 51.051, Late P-frame(26), Compensated = 51.368 ( 0.093 A/V buffers=00/02), Clk : 51.274582, State 1
    11-07-2011 11:11:31.051 [d8]Vid/Ref : 50.971, Late B-frame(24), Compensated = 51.288 ( 0.013 A/V buffers=00/01), Clk : 51.274582, State 1
    11-07-2011 11:11:31.065 [d8]Vid/Ref : 51.011, Late B-frame(25), Compensated = 51.328 ( 0.053 A/V buffers=00/01), Clk : 51.274582, State 1
    11-07-2011 11:11:31.069 [cdc]Aud/Ref : 50.410, Late              Compensated = 50.727 ( -0.548 A/V buffers=01/01), Clk : 51.274582, State 1
    11-07-2011 11:11:31.137 [d8]Vid/Ref : 51.171, Late P-frame(29), Compensated = 51.488 ( 0.213 A/V buffers=00/01), Clk : 51.274582, State 1
    11-07-2011 11:11:31.142 [d8]Vid/Ref : 51.091, Late B-frame(27), Compensated = 51.408 ( 0.133 A/V buffers=00/02), Clk : 51.274582, State 1
    11-07-2011 11:11:31.144 [d8]Vid/Ref : 51.131, Late B-frame(28), Compensated = 51.448 ( 0.173 A/V buffers=00/01), Clk : 51.274582, State 1
    11-07-2011 11:11:31.197 [104]CTsReaderFilter::Run(4503.98) state 1 seeking 0
    11-07-2011 11:11:31.198 [104]Elapsed time from pause to Audio/Video ( total zapping time ) : 203 mS
    11-07-2011 11:11:31.199 [104]CTsReaderFilter::Run(4503.98) state 2 -->done
    11-07-2011 11:11:31.217 [cdc]Demux : Audio to render -0.404 Sec
    11-07-2011 11:11:31.218 [cdc]Demux : Audio to render too late= -0.404 Sec, rendering will be paused for a while
    11-07-2011 11:11:31.221 [d8]Vid/Ref : 51.291, Late P-frame(32), Compensated = 51.608 ( 0.332 A/V buffers=00/02), Clk : 51.275585, State 2
    11-07-2011 11:11:31.223 [d8]Vid/Ref : 51.211, Late B-frame(30), Compensated = 51.528 ( 0.252 A/V buffers=00/01), Clk : 51.275585, State 2
    11-07-2011 11:11:31.225 [cdc]Aud/Ref : 50.554, Late              Compensated = 50.871 ( -0.420 A/V buffers=01/02), Clk : 51.290585, State 2
    11-07-2011 11:11:31.227 [104]Pause 200mS renderer clock to match provider/RTSP clock...
    11-07-2011 11:11:31.230 [104]CTsReaderFilter::Pause() - IsTimeShifting = 1 - state = 2
    11-07-2011 11:11:31.231 [104]CTsReaderFilter::Pause() - END - state = 1
    11-07-2011 11:11:31.297 [d8]Vid/Ref : 51.251, Late B-frame(31), Compensated = 51.568 ( 1.686 A/V buffers=00/01), Clk : 49.881542, State 1
    11-07-2011 11:11:31.373 [d8]Vid/Ref : 51.411, Late P-frame(35), Compensated = 51.728 ( 1.846 A/V buffers=00/03), Clk : 49.881542, State 1
    11-07-2011 11:11:31.375 [d8]Vid/Ref : 51.331, Late B-frame(33), Compensated = 51.648 ( 1.766 A/V buffers=00/02), Clk : 49.881542, State 1
    11-07-2011 11:11:31.377 [d8]Vid/Ref : 51.371, Late B-frame(34), Compensated = 51.688 ( 1.806 A/V buffers=00/01), Clk : 49.881542, State 1
    11-07-2011 11:11:31.377 [cdc]Aud/Ref : 50.698, Late              Compensated = 51.015 ( 1.133 A/V buffers=01/03), Clk : 49.881542, State 1
    11-07-2011 11:11:31.433 [104]CTsReaderFilter::Run(4504.04) state 1 seeking 0
    11-07-2011 11:11:31.434 [104]Elapsed time from pause to Audio/Video ( total zapping time ) : 203 mS
    11-07-2011 11:11:31.435 [104]CTsReaderFilter::Run(4504.04) state 2 -->done
    11-07-2011 11:11:31.561 [d8]Vid/Ref : 51.531, Late I-frame(02), Compensated = 51.848 ( 1.959 A/V buffers=00/01), Clk : 49.888542, State 2
    11-07-2011 11:11:31.565 [cdc]Aud/Ref : 50.842, Late              Compensated = 51.159 ( 1.270 A/V buffers=01/01), Clk : 49.888542, State 2
    11-07-2011 11:11:31.613 [d8]Vid/Ref : 51.451, Late B-frame(00), Compensated = 51.768 ( 1.876 A/V buffers=00/02), Clk : 49.892021, State 2
    11-07-2011 11:11:31.626 [d8]Vid/Ref : 51.491, Late B-frame(01), Compensated = 51.808 ( 1.901 A/V buffers=00/01), Clk : 49.907021, State 2
    11-07-2011 11:11:31.719 [d8]Vid/Ref : 51.651, Late P-frame(05), Compensated = 51.968 ( 1.975 A/V buffers=01/03), Clk : 49.993019, State 2
    11-07-2011 11:11:31.721 [d8]Vid/Ref : 51.571, Late B-frame(03), Compensated = 51.888 ( 1.895 A/V buffers=00/02), Clk : 49.993019, State 2
    11-07-2011 11:11:31.724 [cdc]Aud/Ref : 50.986, Late              Compensated = 51.303 ( 1.295 A/V buffers=01/02), Clk : 50.008022, State 2
    11-07-2011 11:11:31.741 [d8]Vid/Ref : 51.611, Late B-frame(04), Compensated = 51.928 ( 1.905 A/V buffers=00/01), Clk : 50.023418, State 2
    11-07-2011 11:11:31.770 [d8]Vid/Ref : 51.771, Late P-frame(08), Compensated = 52.088 ( 2.020 A/V buffers=00/02), Clk : 50.068417, State 2
    11-07-2011 11:11:31.774 [cdc]Aud/Ref : 51.130, Late              Compensated = 51.447 ( 1.379 A/V buffers=01/02), Clk : 50.068417, State 2
    11-07-2011 11:11:31.776 [d8]Vid/Ref : 51.691, Late B-frame(06), Compensated = 52.008 ( 1.940 A/V buffers=00/01), Clk : 50.068417, State 2
    11-07-2011 11:11:31.870 [d8]Vid/Ref : 51.731, Late B-frame(07), Compensated = 52.048 ( 1.888 A/V buffers=00/01), Clk : 50.160023, State 2
    11-07-2011 11:11:31.918 [d8]Vid/Ref : 51.891, Late P-frame(11), Compensated = 52.208 ( 2.003 A/V buffers=00/02), Clk : 50.205021, State 2
    11-07-2011 11:11:31.930 [cdc]Aud/Ref : 51.274, Late              Compensated = 51.591 ( 1.371 A/V buffers=01/02), Clk : 50.220020, State 2
    11-07-2011 11:11:31.938 [d8]Vid/Ref : 51.811, Late B-frame(09), Compensated = 52.128 ( 1.911 A/V buffers=00/02), Clk : 50.217022, State 2
    11-07-2011 11:11:31.954 [d8]Vid/Ref : 51.851, Late B-frame(10), Compensated = 52.168 ( 1.935 A/V buffers=00/01), Clk : 50.233021, State 2
    11-07-2011 11:11:32.085 [cdc]Aud/Ref : 51.418, Late              Compensated = 51.735 ( 1.355 A/V buffers=01/04), Clk : 50.379688, State 2
    11-07-2011 11:11:32.239 [cdc]Aud/Ref : 51.562, Late              Compensated = 51.879 ( 1.345 A/V buffers=01/08), Clk : 50.533958, State 2
    11-07-2011 11:11:32.260 [d8]Vid/Ref : 52.011, Late P-frame(14), Compensated = 52.328 ( 1.781 A/V buffers=00/08), Clk : 50.547375, State 2
    11-07-2011 11:11:32.394 [cdc]Aud/Ref : 51.706, Late              Compensated = 52.023 ( 1.344 A/V buffers=01/11), Clk : 50.679375, State 2
    11-07-2011 11:11:32.547 [cdc]Aud/Ref : 51.850, Late              Compensated = 52.167 ( 1.348 A/V buffers=01/14), Clk : 50.819229, State 2
    11-07-2011 11:11:32.660 [cdc]Aud/Ref : 51.994, Late              Compensated = 52.311 ( 1.368 A/V buffers=01/17), Clk : 50.943459, State 2
    11-07-2011 11:11:32.815 [cdc]Aud/Ref : 52.138, Late              Compensated = 52.455 ( 1.352 A/V buffers=01/20), Clk : 51.103374, State 2
    11-07-2011 11:11:32.937 [cdc]Aud/Ref : 52.282, Late              Compensated = 52.599 ( 1.379 A/V buffers=01/23), Clk : 51.219772, State 2
    11-07-2011 11:11:33.096 [cdc]Aud/Ref : 52.426, Late              Compensated = 52.743 ( 1.353 A/V buffers=01/24), Clk : 51.389729, State 2
    11-07-2011 11:11:33.221 [cdc]Aud/Ref : 52.570, Late              Compensated = 52.887 ( 1.374 A/V buffers=01/27), Clk : 51.512627, State 2
    11-07-2011 11:11:33.393 [cdc]Aud/Ref : 52.714, Late              Compensated = 53.031 ( 1.351 A/V buffers=01/32), Clk : 51.679646, State 2
    11-07-2011 11:11:33.521 [cdc]Aud/Ref : 52.858, Late              Compensated = 53.175 ( 1.362 A/V buffers=01/35), Clk : 51.812603, State 2
    11-07-2011 11:11:33.616 [d8]Vid/Ref : 51.931, Late B-frame(12), Compensated = 52.248 ( 0.351 A/V buffers=00/35), Clk : 51.896626, State 2
    11-07-2011 11:11:33.640 [d8]Vid/Ref : 51.971, Late B-frame(13), Compensated = 52.288 ( 0.375 A/V buffers=00/35), Clk : 51.912624, State 2
    11-07-2011 11:11:33.676 [d8]Vid/Ref : 52.131, Late P-frame(17), Compensated = 52.448 ( 0.489 A/V buffers=00/35), Clk : 51.958626, State 2
    11-07-2011 11:11:33.679 [cdc]Aud/Ref : 53.002, Late              Compensated = 53.319 ( 1.360 A/V buffers=01/35), Clk : 51.958626, State 2
    11-07-2011 11:11:33.727 [d8]Vid/Ref : 52.051, Late B-frame(15), Compensated = 52.368 ( 0.351 A/V buffers=00/35), Clk : 52.017124, State 2
    11-07-2011 11:11:33.757 [d8]Vid/Ref : 52.091, Late B-frame(16), Compensated = 52.408 ( 0.363 A/V buffers=00/34), Clk : 52.045124, State 2
    11-07-2011 11:11:33.809 [d8]Vid/Ref : 52.251, Late P-frame(20), Compensated = 52.568 ( 0.476 A/V buffers=00/35), Clk : 52.092125, State 2
    11-07-2011 11:11:33.811 [cdc]Aud/Ref : 53.146, Late              Compensated = 53.463 ( 1.371 A/V buffers=01/35), Clk : 52.092125, State 2
    11-07-2011 11:11:33.840 [d8]Vid/Ref : 52.171, Late B-frame(18), Compensated = 52.488 ( 0.365 A/V buffers=00/34), Clk : 52.123478, State 2
    11-07-2011 11:11:33.904 [d8]Vid/Ref : 52.211, Late B-frame(19), Compensated = 52.528 ( 0.338 A/V buffers=00/35), Clk : 52.189709, State 2
    11-07-2011 11:11:33.926 [d8]Vid/Ref : 52.371, Late P-frame(23), Compensated = 52.688 ( 0.467 A/V buffers=00/34), Clk : 52.220707, State 2
    11-07-2011 11:11:33.955 [cdc]Aud/Ref : 53.290, Late              Compensated = 53.607 ( 1.358 A/V buffers=01/34), Clk : 52.248707, State 2
    11-07-2011 11:11:55.093 [cdc]Video Continuity error... c ( prev 0 )
    11-07-2011 11:11:55.095 [cdc]Audio Continuity error... 1 ( prev b )
    11-07-2011 11:11:55.100 [cdc]Demux : Audio to render 0.100 Sec
    11-07-2011 11:11:55.112 [cdc]aud:set discontinuity
     

    Users who are viewing this thread

    Top Bottom