Ticket #12079: fe-log

File fe-log, 98.1 KB (added by warpme@…, 11 years ago)
Line 
1root@FE-Devel:~ # mythfrontend.sh
22014-02-28 16:57:46.508074 I  Setup Interrupt handler
32014-02-28 16:57:46.508224 I  Setup Terminated handler
42014-02-28 16:57:46.508253 I  Setup Segmentation fault handler
52014-02-28 16:57:46.508282 I  Setup Aborted handler
62014-02-28 16:57:46.508309 I  Setup Bus error handler
72014-02-28 16:57:46.508338 I  Setup Floating point exception handler
82014-02-28 16:57:46.508366 I  Setup Illegal instruction handler
92014-02-28 16:57:46.508398 I  Setup Real-time signal 0 handler
102014-02-28 16:57:46.508434 I  Setup User defined signal 1 handler
112014-02-28 16:57:46.508462 I  Setup User defined signal 2 handler
122014-02-28 16:57:46.509094 C  mythfrontend version: master [v0.27-beta-1078-gea4bfde-v7.0] www.mythtv.org
132014-02-28 16:57:46.509131 C  Qt version: compile: 4.8.5, runtime: 4.8.5
142014-02-28 16:57:46.509147 N  Enabled verbose msgs:  general file playback audio
152014-02-28 16:57:46.509785 N  Setting Log Level to LOG_DEBUG
162014-02-28 16:57:46.526440 I  Added logging to the console
172014-02-28 16:57:46.526564 N  Using runtime prefix = /usr
182014-02-28 16:57:46.526593 N  Using configuration directory = /home/minimyth/.mythtv
192014-02-28 16:57:46.526612 D  appbindir      = /usr/bin/
202014-02-28 16:57:46.526626 D  sharedir       = /usr/share/mythtv/
212014-02-28 16:57:46.526644 D  libdir         = /usr/lib/mythtv/
222014-02-28 16:57:46.526657 D  themedir       = /usr/share/mythtv/themes/
232014-02-28 16:57:46.526675 D  pluginsdir     = /usr/lib/mythtv/plugins/
242014-02-28 16:57:46.526688 D  translationsdir= /usr/share/mythtv/i18n/
252014-02-28 16:57:46.526706 D  filtersdir     = /usr/lib/mythtv/filters/
262014-02-28 16:57:46.526992 I  Assumed character encoding: en_US.UTF-8
272014-02-28 16:57:46.528835 E  (old)Settings::ReadSettings(settings.txt) - No such file settings.txt
282014-02-28 16:57:46.529697 N  Empty LocalHostName.
292014-02-28 16:57:46.529747 I  Using localhost value of FE-Devel
302014-02-28 16:57:46.529907 I  Testing network connectivity to '192.168.1.254'
312014-02-28 16:57:46.530731 I  Starting process signal handler
322014-02-28 16:57:46.530804 I  Starting IO manager (read)
332014-02-28 16:57:46.530580 I  Starting process manager
342014-02-28 16:57:46.530981 I  Starting IO manager (write)
352014-02-28 16:57:46.634727 I  New Client:  (#1)
362014-02-28 16:57:46.634849 I  Added logging to /tmp/mythfrontend.20140228155746.8128.log
372014-02-28 16:57:46.700275 D  FindDatabase() - Success!
382014-02-28 16:57:46.707197 N  Setting QT default locale to pl_US
392014-02-28 16:57:46.707272 I  Current locale pl_US
402014-02-28 16:57:46.707480 E  No locale defaults file for pl_US, skipping
412014-02-28 16:57:46.746457 I  ScreenSaverX11Private: XScreenSaver support enabled
422014-02-28 16:57:46.747807 I  ScreenSaverX11Private: DPMS is disabled.
432014-02-28 16:57:46.773820 N  Desktop video mode: 1280x1024 60.020 Hz
442014-02-28 16:57:46.886367 D  CustomRate Found, set 1280x1024@50 as 60.0197Hz
452014-02-28 16:57:46.886423 D  CustomRate Found, set 1280x1024@52 as 75.0247Hz
462014-02-28 16:57:46.886547 D  CustomRate Found, set 1400x1050@51 as 59.9756Hz
472014-02-28 16:57:46.886592 D  CustomRate Found, set 1280x960@54 as 60Hz
482014-02-28 16:57:46.886634 D  CustomRate Found, set 1152x864@55 as 75Hz
492014-02-28 16:57:46.886668 D  CustomRate Found, set 1152x864@56 as 70.0014Hz
502014-02-28 16:57:46.886714 D  CustomRate Found, set 1024x768@57 as 84.9967Hz
512014-02-28 16:57:46.886749 D  CustomRate Found, set 1024x768@58 as 75.0286Hz
522014-02-28 16:57:46.886784 D  CustomRate Found, set 1024x768@59 as 70.0694Hz
532014-02-28 16:57:46.886818 D  CustomRate Found, set 1024x768@60 as 60.0038Hz
542014-02-28 16:57:46.886867 D  CustomRate Found, set 832x624@61 as 74.5513Hz
552014-02-28 16:57:46.886910 D  CustomRate Found, set 800x600@62 as 85.1369Hz
562014-02-28 16:57:46.886942 D  CustomRate Found, set 800x600@63 as 75Hz
572014-02-28 16:57:46.886976 D  CustomRate Found, set 800x600@64 as 72.1876Hz
582014-02-28 16:57:46.887008 D  CustomRate Found, set 800x600@65 as 60.3165Hz
592014-02-28 16:57:46.887042 D  CustomRate Found, set 800x600@66 as 56.25Hz
602014-02-28 16:57:46.887091 D  CustomRate Found, set 720x400@67 as 85.0389Hz
612014-02-28 16:57:46.887132 D  CustomRate Found, set 700x525@68 as 149.514Hz
622014-02-28 16:57:46.887166 D  CustomRate Found, set 700x525@69 as 119.951Hz
632014-02-28 16:57:46.887211 D  CustomRate Found, set 640x480@70 as 85.0083Hz
642014-02-28 16:57:46.887242 D  CustomRate Found, set 640x480@71 as 75Hz
652014-02-28 16:57:46.887276 D  CustomRate Found, set 640x480@72 as 72.8088Hz
662014-02-28 16:57:46.887309 D  CustomRate Found, set 640x480@74 as 59.9405Hz
672014-02-28 16:57:46.887355 D  CustomRate Found, set 640x400@75 as 85.0799Hz
682014-02-28 16:57:46.887396 D  CustomRate Found, set 640x350@76 as 85.0799Hz
692014-02-28 16:57:46.887436 D  CustomRate Found, set 512x384@77 as 140.139Hz
702014-02-28 16:57:46.887469 D  CustomRate Found, set 512x384@78 as 120.008Hz
712014-02-28 16:57:46.887512 D  CustomRate Found, set 400x300@79 as 144.375Hz
722014-02-28 16:57:46.887553 D  CustomRate Found, set 320x240@80 as 145.618Hz
732014-02-28 16:57:46.887594 D  CustomRate Found, set 320x240@81 as 120.105Hz
742014-02-28 16:57:46.887637 D  CustomRate Found, set 320x175@82 as 170.543Hz
752014-02-28 16:57:46.888279 I  max_width: 1400 max_height: 1050
762014-02-28 16:57:46.903498 D  Adding IPv4 loopback to address list.
772014-02-28 16:57:46.903767 D  Adding '192.168.1.130' to address list.
782014-02-28 16:57:46.904487 I  Listening on TCP 127.0.0.1:6547
792014-02-28 16:57:46.905055 I  Listening on TCP 192.168.1.130:6547
802014-02-28 16:57:47.756697 D  MMulticastSocketDevice(:22): setsockopt - IP_MULTICAST_IF
81                        eno: Cannot assign requested address (99)
822014-02-28 16:57:47.782839 D  MMulticastSocketDevice(:22): setsockopt - IP_MULTICAST_IF
83                        eno: Cannot assign requested address (99)
842014-02-28 16:57:47.818666 I  Loading pl translation for module mythfrontend
852014-02-28 16:57:47.823081 E  (old)Settings::ReadSettings(settings.txt) - No such file settings.txt
862014-02-28 16:57:47.833009 D  (old)Settings::ReadSettings(/usr/share/mythtv/themes/Default/qtlook.txt) - 'BackgroundColor' = '#A1A1A1'.
872014-02-28 16:57:47.833061 D  (old)Settings::ReadSettings(/usr/share/mythtv/themes/Default/qtlook.txt) - 'ForegroundColor' = '#1a1a1a'.
882014-02-28 16:57:47.833118 D  (old)Settings::ReadSettings(/usr/share/mythtv/themes/Default/qtlook.txt) - 'BackgroundPixmap' = 'images/backgrounds/default.png'.
892014-02-28 16:57:47.833144 D  (old)Settings::ReadSettings(/usr/share/mythtv/themes/Default/qtlook.txt) - 'Font' = 'Fluid Title Caps'.
902014-02-28 16:57:47.833172 D  (old)Settings::ReadSettings(/usr/share/mythtv/themes/Default/qtlook.txt) - 'ActiveForeground' = '#FFFFFF'.
912014-02-28 16:57:47.833200 D  (old)Settings::ReadSettings(/usr/share/mythtv/themes/Default/qtlook.txt) - 'ActiveButton' = '#1a1a1a'.
922014-02-28 16:57:47.833223 D  (old)Settings::ReadSettings(/usr/share/mythtv/themes/Default/qtlook.txt) - 'ActiveLight' = '#808080'.
932014-02-28 16:57:47.833247 D  (old)Settings::ReadSettings(/usr/share/mythtv/themes/Default/qtlook.txt) - 'ActiveText' = '#FFFFFF'.
942014-02-28 16:57:47.833270 D  (old)Settings::ReadSettings(/usr/share/mythtv/themes/Default/qtlook.txt) - 'ActiveBrightText' = '#FFFFFF'.
952014-02-28 16:57:47.833293 D  (old)Settings::ReadSettings(/usr/share/mythtv/themes/Default/qtlook.txt) - 'ActiveButtonText' = '#FFFFFF'.
962014-02-28 16:57:47.833316 D  (old)Settings::ReadSettings(/usr/share/mythtv/themes/Default/qtlook.txt) - 'ActiveBase' = '#1a1a1a'.
972014-02-28 16:57:47.833339 D  (old)Settings::ReadSettings(/usr/share/mythtv/themes/Default/qtlook.txt) - 'ActiveBackground' = '#1a1a1a'.
982014-02-28 16:57:47.833363 D  (old)Settings::ReadSettings(/usr/share/mythtv/themes/Default/qtlook.txt) - 'ActiveShadow' = '#000000'.
992014-02-28 16:57:47.833386 D  (old)Settings::ReadSettings(/usr/share/mythtv/themes/Default/qtlook.txt) - 'ActiveHighlight' = '#333333'.
1002014-02-28 16:57:47.833410 D  (old)Settings::ReadSettings(/usr/share/mythtv/themes/Default/qtlook.txt) - 'ActiveHighlightedText' = '#FFFFFF'.
1012014-02-28 16:57:47.833435 D  (old)Settings::ReadSettings(/usr/share/mythtv/themes/Default/qtlook.txt) - 'InactiveForeground' = '#FFFFFF'.
1022014-02-28 16:57:47.833458 D  (old)Settings::ReadSettings(/usr/share/mythtv/themes/Default/qtlook.txt) - 'InactiveButton' = '#1a1a1a'.
1032014-02-28 16:57:47.833482 D  (old)Settings::ReadSettings(/usr/share/mythtv/themes/Default/qtlook.txt) - 'InactiveLight' = '#808080'.
1042014-02-28 16:57:47.833505 D  (old)Settings::ReadSettings(/usr/share/mythtv/themes/Default/qtlook.txt) - 'InactiveText' = '#FFFFFF'.
1052014-02-28 16:57:47.833528 D  (old)Settings::ReadSettings(/usr/share/mythtv/themes/Default/qtlook.txt) - 'InactiveBrightText' = '#FFFFFF'.
1062014-02-28 16:57:47.833555 D  (old)Settings::ReadSettings(/usr/share/mythtv/themes/Default/qtlook.txt) - 'InactiveButtonText' = '#FFFFFF'.
1072014-02-28 16:57:47.833578 D  (old)Settings::ReadSettings(/usr/share/mythtv/themes/Default/qtlook.txt) - 'InactiveBase' = '#1a1a1a'.
1082014-02-28 16:57:47.833602 D  (old)Settings::ReadSettings(/usr/share/mythtv/themes/Default/qtlook.txt) - 'InactiveBackground' = '#1a1a1a'.
1092014-02-28 16:57:47.833625 D  (old)Settings::ReadSettings(/usr/share/mythtv/themes/Default/qtlook.txt) - 'InactiveShadow' = '#000000'.
1102014-02-28 16:57:47.833647 D  (old)Settings::ReadSettings(/usr/share/mythtv/themes/Default/qtlook.txt) - 'InactiveHighlight' = '#333333'.
1112014-02-28 16:57:47.833671 D  (old)Settings::ReadSettings(/usr/share/mythtv/themes/Default/qtlook.txt) - 'InactiveHighlightedText' = '#FFFFFF'.
1122014-02-28 16:57:47.833696 D  (old)Settings::ReadSettings(/usr/share/mythtv/themes/Default/qtlook.txt) - 'DisabledForeground' = '#FFFFFF'.
1132014-02-28 16:57:47.833719 D  (old)Settings::ReadSettings(/usr/share/mythtv/themes/Default/qtlook.txt) - 'DisabledButton' = '#666666'.
1142014-02-28 16:57:47.833741 D  (old)Settings::ReadSettings(/usr/share/mythtv/themes/Default/qtlook.txt) - 'DisabledLight' = '#808080'.
1152014-02-28 16:57:47.833765 D  (old)Settings::ReadSettings(/usr/share/mythtv/themes/Default/qtlook.txt) - 'DisabledText' = '#4F535B'.
1162014-02-28 16:57:47.833789 D  (old)Settings::ReadSettings(/usr/share/mythtv/themes/Default/qtlook.txt) - 'DisabledBrightText' = '#71757E'.
1172014-02-28 16:57:47.833812 D  (old)Settings::ReadSettings(/usr/share/mythtv/themes/Default/qtlook.txt) - 'DisabledButtonText' = '#4F535B'.
1182014-02-28 16:57:47.833836 D  (old)Settings::ReadSettings(/usr/share/mythtv/themes/Default/qtlook.txt) - 'DisabledBase' = '#000000'.
1192014-02-28 16:57:47.833859 D  (old)Settings::ReadSettings(/usr/share/mythtv/themes/Default/qtlook.txt) - 'DisabledBackground' = '#000000'.
1202014-02-28 16:57:47.833883 D  (old)Settings::ReadSettings(/usr/share/mythtv/themes/Default/qtlook.txt) - 'DisabledShadow' = '#000000'.
1212014-02-28 16:57:47.833906 D  (old)Settings::ReadSettings(/usr/share/mythtv/themes/Default/qtlook.txt) - 'DisabledHighlight' = '#274E57'.
1222014-02-28 16:57:47.833930 D  (old)Settings::ReadSettings(/usr/share/mythtv/themes/Default/qtlook.txt) - 'DisabledHighlightedText' = '#ffffff'.
1232014-02-28 16:57:47.833955 D  (old)Settings::ReadSettings(/usr/share/mythtv/themes/Default/qtlook.txt) - 'curTimeChan_bgColor' = '#8f2813'.
1242014-02-28 16:57:47.833978 D  (old)Settings::ReadSettings(/usr/share/mythtv/themes/Default/qtlook.txt) - 'curTimeChan_fgColor' = '#ffffff'.
1252014-02-28 16:57:47.834001 D  (old)Settings::ReadSettings(/usr/share/mythtv/themes/Default/qtlook.txt) - 'date_bgColor' = '#0f2e8f'.
1262014-02-28 16:57:47.834024 D  (old)Settings::ReadSettings(/usr/share/mythtv/themes/Default/qtlook.txt) - 'date_dsColor' = '#000000'.
1272014-02-28 16:57:47.834046 D  (old)Settings::ReadSettings(/usr/share/mythtv/themes/Default/qtlook.txt) - 'date_fgColor' = '#ffffff'.
1282014-02-28 16:57:47.834068 D  (old)Settings::ReadSettings(/usr/share/mythtv/themes/Default/qtlook.txt) - 'chan_bgColor' = '#0f2f5a'.
1292014-02-28 16:57:47.834091 D  (old)Settings::ReadSettings(/usr/share/mythtv/themes/Default/qtlook.txt) - 'chan_dsColor' = '#000000'.
1302014-02-28 16:57:47.834114 D  (old)Settings::ReadSettings(/usr/share/mythtv/themes/Default/qtlook.txt) - 'chan_fgColor' = '#ffffff'.
1312014-02-28 16:57:47.834136 D  (old)Settings::ReadSettings(/usr/share/mythtv/themes/Default/qtlook.txt) - 'time_bgColor' = '#0f2e8f'.
1322014-02-28 16:57:47.834158 D  (old)Settings::ReadSettings(/usr/share/mythtv/themes/Default/qtlook.txt) - 'time_dsColor' = '#000000'.
1332014-02-28 16:57:47.834180 D  (old)Settings::ReadSettings(/usr/share/mythtv/themes/Default/qtlook.txt) - 'time_fgColor' = '#ffffff'.
1342014-02-28 16:57:47.834203 D  (old)Settings::ReadSettings(/usr/share/mythtv/themes/Default/qtlook.txt) - 'prog_bgColor' = '#2d587b'.
1352014-02-28 16:57:47.834227 D  (old)Settings::ReadSettings(/usr/share/mythtv/themes/Default/qtlook.txt) - 'prog_fgColor' = '#ffffff'.
1362014-02-28 16:57:47.834250 D  (old)Settings::ReadSettings(/usr/share/mythtv/themes/Default/qtlook.txt) - 'progLine_Color' = '#104064'.
1372014-02-28 16:57:47.834280 D  (old)Settings::ReadSettings(/usr/share/mythtv/themes/Default/qtlook.txt) - 'progArrow_Color' = '#ffffff'.
1382014-02-28 16:57:47.834304 D  (old)Settings::ReadSettings(/usr/share/mythtv/themes/Default/qtlook.txt) - 'progArrow_Type' = '0'.
1392014-02-28 16:57:47.834331 D  (old)Settings::ReadSettings(/usr/share/mythtv/themes/Default/qtlook.txt) - 'curProg_bgColor' = '#85a5bc'.
1402014-02-28 16:57:47.834355 D  (old)Settings::ReadSettings(/usr/share/mythtv/themes/Default/qtlook.txt) - 'curRecProg_bgColor' = '#bc4c32'.
1412014-02-28 16:57:47.834381 D  (old)Settings::ReadSettings(/usr/share/mythtv/themes/Default/qtlook.txt) - 'curProg_dsColor' = '#000000'.
1422014-02-28 16:57:47.834405 D  (old)Settings::ReadSettings(/usr/share/mythtv/themes/Default/qtlook.txt) - 'curProg_fgColor' = '#eefb92'.
1432014-02-28 16:57:47.834431 D  (old)Settings::ReadSettings(/usr/share/mythtv/themes/Default/qtlook.txt) - 'misChanIcon_bgColor' = '#000000'.
1442014-02-28 16:57:47.834454 D  (old)Settings::ReadSettings(/usr/share/mythtv/themes/Default/qtlook.txt) - 'misChanIcon_fgColor' = '#ffffff'.
1452014-02-28 16:57:47.838211 I  LIRC: Successfully initialized '/dev/lircd' using '/home/minimyth/.mythtv/lircrc' config
1462014-02-28 16:57:47.838338 I  UDPListener: Enabling
1472014-02-28 16:57:47.840059 I  Binding to UDP 127.0.0.1:6948
1482014-02-28 16:57:47.840238 I  Binding to UDP 192.168.1.130:6948
1492014-02-28 16:57:47.840362 I  Binding to UDP 192.168.1.255:6948
1502014-02-28 16:57:47.913600 I  Using Frameless Window
1512014-02-28 16:57:47.914250 I  Using Full Screen Window
1522014-02-28 16:57:47.927401 I  UI Screen Resolution: 1280 x 1024
1532014-02-28 16:57:48.039555 I  Trying the OpenGL painter
1542014-02-28 16:57:48.045371 I  OpenGL: Sync to VBlank is enabled (good!)
1552014-02-28 16:57:48.147570 D  OpenGL: Extension not found: glGenFencesAPPLE
1562014-02-28 16:57:48.148375 D  OpenGL: Extension not found: glDeleteFencesAPPLE
1572014-02-28 16:57:48.149158 D  OpenGL: Extension not found: glSetFenceAPPLE
1582014-02-28 16:57:48.150342 D  OpenGL: Extension not found: glFinishFenceAPPLE
1592014-02-28 16:57:48.153640 I  OpenGL1: Fragment program support available
1602014-02-28 16:57:48.153861 I  OpenGL: OpenGL vendor  : NVIDIA Corporation
1612014-02-28 16:57:48.153888 I  OpenGL: OpenGL renderer: ION/integrated/SSE2
1622014-02-28 16:57:48.153914 I  OpenGL: OpenGL version : 3.3.0 NVIDIA 331.49
1632014-02-28 16:57:48.153943 I  OpenGL: Max texture size: 8192 x 8192
1642014-02-28 16:57:48.153966 I  OpenGL: Max texture units: 4
1652014-02-28 16:57:48.154085 I  OpenGL: Direct rendering: Yes
1662014-02-28 16:57:48.154105 I  OpenGL: PixelBufferObject support available
1672014-02-28 16:57:48.154124 I  OpenGL: Initialised MythRenderOpenGL
1682014-02-28 16:57:48.157678 D  MythFontManager: Scanning directory '/usr/share/mythtv/fonts/' for font files.
1692014-02-28 16:57:49.777008 D  MythFontManager: Scanning directory '/usr/share/mythtv/themes/Default/' for font files.
1702014-02-28 16:57:49.780779 D  MythFontManager: Scanning directory '/usr/share/mythtv/themes/Default/fonts' for font files.
1712014-02-28 16:57:49.929159 D  MythFontManager: Scanning directory '/usr/share/mythtv/themes/Default/images' for font files.
1722014-02-28 16:57:49.929906 D  MythFontManager: Scanning directory '/usr/share/mythtv/themes/Default/images/backgrounds' for font files.
1732014-02-28 16:57:49.931187 D  MythFontManager: Scanning directory '/usr/share/mythtv/themes/Default/images/flags' for font files.
1742014-02-28 16:57:49.934342 D  MythFontManager: Scanning directory '/usr/share/mythtv/themes/Default/images/icons' for font files.
1752014-02-28 16:57:49.936153 D  MythFontManager: Scanning directory '/usr/share/mythtv/themes/Default/images/mediaflags' for font files.
1762014-02-28 16:57:49.936592 D  MythFontManager: Scanning directory '/usr/share/mythtv/themes/Default/images/mediaflags/AspectRatio' for font files.
1772014-02-28 16:57:49.937126 D  MythFontManager: Scanning directory '/usr/share/mythtv/themes/Default/images/mediaflags/Audio' for font files.
1782014-02-28 16:57:49.938587 D  MythFontManager: Scanning directory '/usr/share/mythtv/themes/Default/images/mediaflags/Ratings' for font files.
1792014-02-28 16:57:49.939152 D  MythFontManager: Scanning directory '/usr/share/mythtv/themes/Default/images/mediaflags/Video' for font files.
1802014-02-28 16:57:49.940327 D  MythFontManager: Scanning directory '/usr/share/mythtv/themes/Default/images/music' for font files.
1812014-02-28 16:57:49.942026 D  MythFontManager: Scanning directory '/usr/share/mythtv/themes/Default/images/music/progressbar' for font files.
1822014-02-28 16:57:49.943720 D  MythFontManager: Scanning directory '/usr/share/mythtv/themes/Default/images/music/rating' for font files.
1832014-02-28 16:57:49.944564 D  MythFontManager: Scanning directory '/usr/share/mythtv/themes/Default/images/mythnotify' for font files.
1842014-02-28 16:57:49.945391 D  MythFontManager: Scanning directory '/usr/share/mythtv/themes/Default/images/osd' for font files.
1852014-02-28 16:57:49.945859 D  MythFontManager: Scanning directory '/usr/share/mythtv/themes/Default/images/osd/audio' for font files.
1862014-02-28 16:57:49.946758 D  MythFontManager: Scanning directory '/usr/share/mythtv/themes/Default/images/osd/audio_codec' for font files.
1872014-02-28 16:57:49.947478 D  MythFontManager: Scanning directory '/usr/share/mythtv/themes/Default/images/osd/resolution' for font files.
1882014-02-28 16:57:49.947867 D  MythFontManager: Scanning directory '/usr/share/mythtv/themes/Default/images/osd/video_codec' for font files.
1892014-02-28 16:57:49.948410 D  MythFontManager: Scanning directory '/usr/share/mythtv/themes/Default/images/shared' for font files.
1902014-02-28 16:57:49.955493 D  MythFontManager: Scanning directory '/usr/share/mythtv/themes/Default/images/shared/busy' for font files.
1912014-02-28 16:57:49.957257 D  MythFontManager: Scanning directory '/usr/share/mythtv/themes/Default/images/shared/parental-level' for font files.
1922014-02-28 16:57:49.957768 D  MythFontManager: Scanning directory '/usr/share/mythtv/themes/Default/images/shared/progressbar' for font files.
1932014-02-28 16:57:49.958371 D  MythFontManager: Scanning directory '/usr/share/mythtv/themes/Default/images/shared/rating' for font files.
1942014-02-28 16:57:49.959624 D  MythFontManager: Scanning directory '/usr/share/mythtv/themes/Default/images/studios' for font files.
1952014-02-28 16:57:49.970973 D  MythFontManager: Scanning directory '/usr/share/mythtv/themes/Default/images/tv-recordings' for font files.
1962014-02-28 16:57:49.972241 D  MythFontManager: Scanning directory '/usr/share/mythtv/themes/Default/images/tv-recordings/audio' for font files.
1972014-02-28 16:57:49.973007 D  MythFontManager: Scanning directory '/usr/share/mythtv/themes/Default/images/tv-recordings/processing' for font files.
1982014-02-28 16:57:49.974571 D  MythFontManager: Scanning directory '/usr/share/mythtv/themes/Default/images/tv-recordings/processing/filmreel' for font files.
1992014-02-28 16:57:49.975248 D  MythFontManager: Scanning directory '/usr/share/mythtv/themes/Default/images/tv-recordings/schedule' for font files.
2002014-02-28 16:57:49.975929 D  MythFontManager: Scanning directory '/usr/share/mythtv/themes/Default/images/tv-recordings/schedule/archive' for font files.
2012014-02-28 16:57:49.976553 D  MythFontManager: Scanning directory '/usr/share/mythtv/themes/Default/images/tv-recordings/scheduled-status' for font files.
2022014-02-28 16:57:49.977167 D  MythFontManager: Scanning directory '/usr/share/mythtv/themes/Default/images/tv-recordings/subtitles' for font files.
2032014-02-28 16:57:49.977575 D  MythFontManager: Scanning directory '/usr/share/mythtv/themes/Default/images/tv-recordings/video' for font files.
2042014-02-28 16:57:49.978321 D  MythFontManager: Scanning directory '/usr/share/mythtv/themes/Default/keyboard' for font files.
2052014-02-28 16:57:50.318149 I  MythCoreContext: Connecting to backend server: 192.168.1.254:6543 (try 1 of 1)
2062014-02-28 16:57:50.334292 I  Using protocol version 79
2072014-02-28 16:57:50.633164 D  Copying DLManager's Cookie Jar
2082014-02-28 16:57:50.699468 D  MythCookieJar: loading cookies from: /home/minimyth/.mythtv/MythBrowser/cookiejar.txt
2092014-02-28 16:57:50.747183 I  MythUIWebBrowser: Loading css from - file:///usr/share/mythtv/themes/default/htmls/mythbrowser.css
2102014-02-28 16:57:50.748387 E  MythUIWebBrowser: failed to find our parent screen
2112014-02-28 16:57:50.750240 I  MythUIWebBrowser: enabling plugins
2122014-02-28 16:57:50.814451 I  AirPlay: Created airplay objects.
2132014-02-28 16:57:50.814821 I  Listening on TCP 127.0.0.1:5100
2142014-02-28 16:57:50.815060 I  Listening on TCP 192.168.1.130:5100
2152014-02-28 16:57:50.850885 D  RAOP Conn: Loaded RSA private key (1)
2162014-02-28 16:57:50.851259 I  RAOP Device: Created RAOP device objects.
2172014-02-28 16:57:50.851655 I  Listening on TCP 127.0.0.1:5000
2182014-02-28 16:57:50.851845 I  Listening on TCP 192.168.1.130:5000
2192014-02-28 16:57:50.851868 I  RAOP Device: Listening for connections on port 5000
2202014-02-28 16:57:50.854799 I  Registering service 3a4b52674d6b@MythTV on FE-Devel._raop._tcp port 5000 TXT tp=UDsm=falssv=falseek=1et=0,1cn=0,1ch=2ss=1sr=4410pw=falsevn=3      txtvers=md=0,1,vs=115.2da=true
2212014-02-28 16:57:50.858477 I  Current MythTV Schema Version (DBSchemaVer): 1323
2222014-02-28 16:57:50.861769 I  VDP: decoder<->render support: ffmpeg      null xlib xshm xv-blit opengl opengl-lite vdpau nullvdpau
2232014-02-28 16:57:50.861813 I  VDP: decoder<->render support: vdpau       vdpau nullvdpau
2242014-02-28 16:57:50.869497 N  VDP: Ignoring profile item 712 (renderer quartz-blit is not supported w/decoder ffmpeg (supported: null,xlib,xshm,xv-blit,opengl,opengl-lite,vdpau,nullvdpau))
2252014-02-28 16:57:50.869652 N  VDP: Ignoring profile item 713 (renderer quartz-blit is not supported w/decoder ffmpeg (supported: null,xlib,xshm,xv-blit,opengl,opengl-lite,vdpau,nullvdpau))
2262014-02-28 16:57:50.873913 N  VDP: Ignoring profile item 716 (renderer quartz-blit is not supported w/decoder ffmpeg (supported: null,xlib,xshm,xv-blit,opengl,opengl-lite,vdpau,nullvdpau))
2272014-02-28 16:57:50.874042 N  VDP: Ignoring profile item 717 (renderer quartz-blit is not supported w/decoder ffmpeg (supported: null,xlib,xshm,xv-blit,opengl,opengl-lite,vdpau,nullvdpau))
2282014-02-28 16:57:50.881318 N  VDP: Ignoring profile item 720 (renderer quartz-blit is not supported w/decoder ffmpeg (supported: null,xlib,xshm,xv-blit,opengl,opengl-lite,vdpau,nullvdpau))
2292014-02-28 16:57:50.881463 N  VDP: Ignoring profile item 721 (renderer quartz-blit is not supported w/decoder ffmpeg (supported: null,xlib,xshm,xv-blit,opengl,opengl-lite,vdpau,nullvdpau))
2302014-02-28 16:57:50.883363 N  VDP: Ignoring profile item 907 (decoder vaapi is not supported (supported: ffmpeg,vdpau))
2312014-02-28 16:57:51.137194 W  Key Alt+V is already bound to a jump point.
2322014-02-28 16:57:51.298284 N  Registering Internal as a media playback plugin.
2332014-02-28 16:57:51.368916 N  Registering WebBrowser as a media playback plugin.
2342014-02-28 16:57:51.369093 I  Loading pl translation for module mythbrowser
2352014-02-28 16:57:51.404739 D  MonitorRegisterExtensions(0x100, bmp,gif,ico,jpeg,jpg,mng,pbm,pgm,png,ppm,svg,svgz,tga,tif,tiff,xbm,xpm)
2362014-02-28 16:57:51.404973 I  Loading pl translation for module mythgallery
2372014-02-28 16:57:51.416868 I  Loading pl translation for module mythgame
2382014-02-28 16:57:51.431575 I  Current MythMusic Schema Version (MusicDBSchemaVer): 1022
2392014-02-28 16:57:51.461121 D  MonitorRegisterExtensions(0x40, mp3,mp2,ogg,oga,flac,wma,wav,ac3,oma,omg,atp,ra,dts,aac,m4a,aa3,tta,mka,aiff,swa,wv)
2402014-02-28 16:57:51.466429 I  Loading pl translation for module mythmusic
2412014-02-28 16:57:51.471326 I  Loading pl translation for module mythnetvision
2422014-02-28 16:57:51.478897 I  Loading pl translation for module mythnews
2432014-02-28 16:57:51.488458 I  Loading pl translation for module mythweather
2442014-02-28 16:57:51.494194 I  Loading pl translation for module mythzoneminder
2452014-02-28 16:57:51.497185 I  Listening on TCP 127.0.0.1:6546
2462014-02-28 16:57:51.497394 I  Listening on TCP 192.168.1.130:6546
2472014-02-28 16:57:51.625545 I  Bonjour: Service registration complete: name 'MythTV on FE-Devel' type '_airplay._tcp.' domain: 'local.'
2482014-02-28 16:57:51.658897 D  No menu file /home/minimyth/.mythtv/mainmenu.xml
2492014-02-28 16:57:51.662263 D  No menu file /home/minimyth/.mythtv/mythmusic
2502014-02-28 16:57:51.662463 D  No menu file /usr/share/mythtv/themes/Default//mythmusic
2512014-02-28 16:57:51.662514 D  No menu file /usr/share/mythtv/themes/Default//mythmusic
2522014-02-28 16:57:51.663005 D  No menu file /home/minimyth/.mythtv/mythmusic
2532014-02-28 16:57:51.663055 D  No menu file /usr/share/mythtv/themes/Default//mythmusic
2542014-02-28 16:57:51.663219 D  No menu file /usr/share/mythtv/themes/Default//mythmusic
2552014-02-28 16:57:51.663781 D  No menu file /home/minimyth/.mythtv/mythgallery
2562014-02-28 16:57:51.663963 D  No menu file /usr/share/mythtv/themes/Default//mythgallery
2572014-02-28 16:57:51.664007 D  No menu file /usr/share/mythtv/themes/Default//mythgallery
2582014-02-28 16:57:51.664146 D  No menu file /usr/share/mythtv/mythgallery
2592014-02-28 16:57:51.664185 D  No menu file ../mythfrontend/mythgallery
2602014-02-28 16:57:51.664309 D  No menu file /usr/share/mythtv/themes/defaultmenu/mythgallery
2612014-02-28 16:57:51.664566 D  No menu file /home/minimyth/.mythtv/mythweather
2622014-02-28 16:57:51.664613 D  No menu file /usr/share/mythtv/themes/Default//mythweather
2632014-02-28 16:57:51.664718 D  No menu file /usr/share/mythtv/themes/Default//mythweather
2642014-02-28 16:57:51.664909 D  No menu file /home/minimyth/.mythtv/mythgame
2652014-02-28 16:57:51.665080 D  No menu file /usr/share/mythtv/themes/Default//mythgame
2662014-02-28 16:57:51.665233 D  No menu file /usr/share/mythtv/themes/Default//mythgame
2672014-02-28 16:57:51.665271 D  No menu file /usr/share/mythtv/mythgame
2682014-02-28 16:57:51.665364 D  No menu file ../mythfrontend/mythgame
2692014-02-28 16:57:51.665406 D  No menu file /usr/share/mythtv/themes/defaultmenu/mythgame
2702014-02-28 16:57:51.665943 D  No menu file /home/minimyth/.mythtv/mythzoneminder
2712014-02-28 16:57:51.665995 D  No menu file /usr/share/mythtv/themes/Default//mythzoneminder
2722014-02-28 16:57:51.666143 D  No menu file /usr/share/mythtv/themes/Default//mythzoneminder
2732014-02-28 16:57:51.666199 D  No menu file /usr/share/mythtv/mythzoneminder
2742014-02-28 16:57:51.666345 D  No menu file ../mythfrontend/mythzoneminder
2752014-02-28 16:57:51.666405 D  No menu file /usr/share/mythtv/themes/defaultmenu/mythzoneminder
2762014-02-28 16:57:51.666807 D  No menu file /home/minimyth/.mythtv/mythbrowser
2772014-02-28 16:57:51.666940 D  No menu file /usr/share/mythtv/themes/Default//mythbrowser
2782014-02-28 16:57:51.666990 D  No menu file /usr/share/mythtv/themes/Default//mythbrowser
2792014-02-28 16:57:51.667160 D  No menu file /usr/share/mythtv/mythbrowser
2802014-02-28 16:57:51.667211 D  No menu file ../mythfrontend/mythbrowser
2812014-02-28 16:57:51.667542 D  No menu file /usr/share/mythtv/themes/defaultmenu/mythbrowser
2822014-02-28 16:57:51.667623 I  Bonjour: Service registration complete: name '3a4b52674d6b@MythTV on FE-Devel' type '_raop._tcp.' domain: 'local.'
2832014-02-28 16:57:51.667966 N  Found mainmenu.xml for theme 'Default'
2842014-02-28 16:57:51.671499 I  Registering HouseKeeperTask 'HardwareProfiler'.
2852014-02-28 16:57:51.682955 I  Starting HouseKeeper.
2862014-02-28 16:57:51.974987 I  Bonjour: Service registration complete: name 'Mythfrontend on FE-Devel' type '_mythfrontend._tcp.' domain: 'local.'
2872014-02-28 16:57:54.303660 I  ScreenSaverX11Private: Calling xscreensaver-command -deactivate
2882014-02-28 16:57:54.346277 D  SendReceiveStringList(QUERY_HOSTNAME) called from UI thread
2892014-02-28 16:57:56.514439 I  PreviewQueue: Requesting preview for '13111_20140228153001.mpg_0x0_-1s'
2902014-02-28 16:57:56.514591 I  PreviewQueue: Requested preview for '13111_20140228153001.mpg_0x0_-1s'
2912014-02-28 16:57:56.580308 I  PreviewQueue: Not requesting preview for "Malanowski i partnerzy",as it is already being generated
2922014-02-28 16:57:56.595279 I  PreviewQueue: Requesting preview for '23806_20140228100000.mpg_0x0_-1s'
2932014-02-28 16:57:56.595360 I  PreviewQueue: Requested preview for '23806_20140228100000.mpg_0x0_-1s'
2942014-02-28 16:57:56.597483 I  PreviewQueue: Not requesting preview for "Malanowski i partnerzy",as it is already being generated
2952014-02-28 16:57:56.678344 I  PreviewQueue: Not requesting preview for "Malanowski i partnerzy",as it is already being generated
2962014-02-28 16:57:56.703169 I  PreviewQueue: Not requesting preview for "Serwis informacyjny, Prognoza pogody, Biała jazda - pogoda dla narciarzy",as it is already being generated
2972014-02-28 16:57:56.704438 I  PreviewQueue: Not requesting preview for "Malanowski i partnerzy",as it is already being generated
2982014-02-28 16:57:56.715162 I  PreviewQueue: Not requesting preview for "Serwis informacyjny, Prognoza pogody, Biała jazda - pogoda dla narciarzy",as it is already being generated
2992014-02-28 16:57:56.733970 I  PreviewQueue: Not requesting preview for "Serwis informacyjny, Prognoza pogody, Biała jazda - pogoda dla narciarzy",as it is already being generated
3002014-02-28 16:57:56.735246 I  PreviewQueue: Not requesting preview for "Malanowski i partnerzy",as it is already being generated
3012014-02-28 16:57:57.702328 E  Preview: 13111_2014-02-28T15:30:01Z:
3022014-02-28 16:57:57.802528 E  Preview: 23806_2014-02-28T10:00:00Z:
3032014-02-28 16:58:02.526068 I  TV: Creating TV object
3042014-02-28 16:58:02.564296 I  TV: Finished creating TV object
3052014-02-28 16:58:02.564326 I  TV: StartTV() -- begin
3062014-02-28 16:58:02.564375 N  Suspending idle timer
3072014-02-28 16:58:02.564431 I  TV: Init -- begin
3082014-02-28 16:58:02.567279 I  TV: Created TvPlayWindow.
3092014-02-28 16:58:02.568373 I  TV: DrawUnusedRects() -- begin
3102014-02-28 16:58:02.568411 I  TV: DrawUnusedRects() -- end
3112014-02-28 16:58:02.580307 I  TV: Init -- end
3122014-02-28 16:58:02.580437 I  TV: tv->Playback() -- begin
3132014-02-28 16:58:02.588476 I  TV: HandleStateChange(0) -- begin
3142014-02-28 16:58:02.588538 I  TV: Attempting to change from None to WatchingRecording
3152014-02-28 16:58:02.589725 D  SendReceiveStringList(QUERY_CHECKFILE,0...) called from UI thread
3162014-02-28 16:58:02.590695 I  ProgramInfo(13111_20140228153001.mpg): GetPlaybackURL: Found @ 'myth://192.168.1.254:6543/13111_20140228153001.mpg'
3172014-02-28 16:58:02.590801 I  RemoteFile::Exists(): looking for remote file: myth://192.168.1.254:6543/13111_20140228153001.mpg
3182014-02-28 16:58:02.590923 D  SendReceiveStringList(QUERY_FILE_EXISTS,13111_20140228153001.mpg) called from UI thread
3192014-02-28 16:58:02.591891 I  FileRingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): OpenFile(myth://192.168.1.254:6543/13111_20140228153001.mpg, 2000 ms)
3202014-02-28 16:58:02.611340 D  RemoteFile(myth://192.168.1.254:6543/13111_20140228153001.mpg)
3212014-02-28 16:58:02.611421 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): CalcReadAheadThresh(8000 Kb)
322                         -> threshhold(3584 KB) min read(128 KB) blk size(128 KB)
3232014-02-28 16:58:02.611543 D  SendReceiveStringList(GET_RECORDER_NUM,Malanowski i partnerzy...) called from UI thread
3242014-02-28 16:58:02.612214 E  TV: Couldn't find recorder for in-progress recording
3252014-02-28 16:58:02.612267 I  TV: StartPlayer(0, WatchingPreRecorded, main) -- begin
3262014-02-28 16:58:02.612350 I  TV: Elapsed time since TV constructor was called: 86 ms
3272014-02-28 16:58:02.614921 I  FilterManager: Loading filter '/usr/lib/mythtv/filters/libadjust.so'
3282014-02-28 16:58:02.617458 D  FilterManager: filters[adjust] = 0x7f67486378b0
3292014-02-28 16:58:02.617498 I  FilterManager: Loading filter '/usr/lib/mythtv/filters/libbobdeint.so'
3302014-02-28 16:58:02.618920 D  FilterManager: filters[bobdeint] = 0x7f6748425710
3312014-02-28 16:58:02.618958 I  FilterManager: Loading filter '/usr/lib/mythtv/filters/libcrop.so'
3322014-02-28 16:58:02.620469 D  FilterManager: filters[crop] = 0x7f674842c560
3332014-02-28 16:58:02.620506 I  FilterManager: Loading filter '/usr/lib/mythtv/filters/libdenoise3d.so'
3342014-02-28 16:58:02.622291 D  FilterManager: filters[denoise3d] = 0x7f67484b9170
3352014-02-28 16:58:02.622330 I  FilterManager: Loading filter '/usr/lib/mythtv/filters/libfieldorder.so'
3362014-02-28 16:58:02.623799 D  FilterManager: filters[fieldorderdoubleprocessdeint] = 0x7f674842c6e0
3372014-02-28 16:58:02.623837 I  FilterManager: Loading filter '/usr/lib/mythtv/filters/libforce.so'
3382014-02-28 16:58:02.624910 D  FilterManager: filters[forceyv12] = 0x7f67481b74d0
3392014-02-28 16:58:02.624968 D  FilterManager: filters[forceyuv422p] = 0x7f674803ada0
3402014-02-28 16:58:02.624992 D  FilterManager: filters[forcergb24] = 0x7f67488180b0
3412014-02-28 16:58:02.625016 D  FilterManager: filters[forceargb32] = 0x7f67489c4ef0
3422014-02-28 16:58:02.625046 I  FilterManager: Loading filter '/usr/lib/mythtv/filters/libgreedyhdeint.so'
3432014-02-28 16:58:02.627549 D  FilterManager: filters[greedyhdeint] = 0x7f674885ab50
3442014-02-28 16:58:02.627580 D  FilterManager: filters[greedyhdoubleprocessdeint] = 0x7f6748891a80
3452014-02-28 16:58:02.627610 I  FilterManager: Loading filter '/usr/lib/mythtv/filters/libinvert.so'
3462014-02-28 16:58:02.628777 D  FilterManager: filters[invert] = 0x7f67488d3160
3472014-02-28 16:58:02.628815 I  FilterManager: Loading filter '/usr/lib/mythtv/filters/libivtc.so'
3482014-02-28 16:58:02.631381 D  FilterManager: filters[ivtc] = 0x7f67489295c0
3492014-02-28 16:58:02.631421 I  FilterManager: Loading filter '/usr/lib/mythtv/filters/libkerneldeint.so'
3502014-02-28 16:58:02.634385 D  FilterManager: filters[kerneldeint] = 0x7f6748966d50
3512014-02-28 16:58:02.634430 D  FilterManager: filters[kerneldoubleprocessdeint] = 0x7f674897d430
3522014-02-28 16:58:02.634463 I  FilterManager: Loading filter '/usr/lib/mythtv/filters/liblinearblend.so'
3532014-02-28 16:58:02.636109 D  FilterManager: filters[linearblend] = 0x7f67489d83a0
3542014-02-28 16:58:02.636349 I  FilterManager: Loading filter '/usr/lib/mythtv/filters/libonefield.so'
3552014-02-28 16:58:02.637864 D  FilterManager: filters[onefield] = 0x7f6748b61b70
3562014-02-28 16:58:02.637903 I  FilterManager: Loading filter '/usr/lib/mythtv/filters/libpostprocess.so'
3572014-02-28 16:58:02.639814 D  FilterManager: filters[postprocess] = 0x7f6748a83c60
3582014-02-28 16:58:02.639863 I  FilterManager: Loading filter '/usr/lib/mythtv/filters/libquickdnr.so'
3592014-02-28 16:58:02.641496 D  FilterManager: filters[quickdnr] = 0x7f6748bc1970
3602014-02-28 16:58:02.641543 I  FilterManager: Loading filter '/usr/lib/mythtv/filters/libvflip.so'
3612014-02-28 16:58:02.642865 D  FilterManager: filters[vflip] = 0x7f6748c394c0
3622014-02-28 16:58:02.642904 I  FilterManager: Loading filter '/usr/lib/mythtv/filters/libyadif.so'
3632014-02-28 16:58:02.645329 D  FilterManager: filters[yadifdeint] = 0x7f6748c7de00
3642014-02-28 16:58:02.645363 D  FilterManager: filters[yadifdoubleprocessdeint] = 0x7f6748679350
3652014-02-28 16:58:02.840934 I  ALSA: OpenDevice sysdefault:CARD=NVidia
3662014-02-28 16:58:02.970711 I  AOS: Sample rate 48000 is supported
3672014-02-28 16:58:02.970801 I  AOS: Format signed 24 bit MSB is supported
3682014-02-28 16:58:02.970835 I  AOS: Format signed 32 bit is supported
3692014-02-28 16:58:02.970895 I  AOS: 2 channel(s) are supported
3702014-02-28 16:58:03.034783 N  AudioPlayer: Enabling Audio
3712014-02-28 16:58:03.034848 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): StartReads()
3722014-02-28 16:58:03.035011 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): Unpause()
3732014-02-28 16:58:03.035029 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): StartReads()
3742014-02-28 16:58:03.035146 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..2048, peek) @0 -- begin
3752014-02-28 16:58:03.035328 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): CalcReadAheadThresh(8000 Kb)
376                         -> threshhold(7168 KB) min read(128 KB) blk size(128 KB)
3772014-02-28 16:58:03.035379 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): Created readAheadBuffer: 8Mb
3782014-02-28 16:58:03.036626 I  FileRingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): Seek(0,SEEK_SET,locked)
3792014-02-28 16:58:03.036672 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): StopReads()
3802014-02-28 16:58:03.036712 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): StartReads()
3812014-02-28 16:58:03.036767 I  FileRingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): Seek(): Offset from end: 133215672
3822014-02-28 16:58:03.106109 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..2048, peek): ReadDirect checksum 34205
3832014-02-28 16:58:03.106263 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ResetReadAhead(internalreadpos = 0->0)
3842014-02-28 16:58:03.106300 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): CalcReadAheadThresh(8000 Kb)
385                         -> threshhold(7168 KB) min read(128 KB) blk size(128 KB)
3862014-02-28 16:58:03.106341 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): Initial readblocksize 128K & fill_min 128K
3872014-02-28 16:58:03.106387 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): Reading enough data to start playback
3882014-02-28 16:58:03.106409 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@0, 131072) -- begin
3892014-02-28 16:58:03.135550 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@0, 131072) -> 131072, took 29 ms (36.1578Mbps) avg 300 ms
3902014-02-28 16:58:03.135588 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): rbwpos += 128K requested 128K in read
3912014-02-28 16:58:03.135610 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): total read so far: 131072 bytes
3922014-02-28 16:58:03.135629 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): @ end of read ahead loop
3932014-02-28 16:58:03.142629 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@131072, 131072) -- begin
3942014-02-28 16:58:03.162313 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@131072, 131072) -> 131072, took 19 ms (55.1882Mbps) avg 273 ms
3952014-02-28 16:58:03.162372 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): rbwpos += 128K requested 128K in read
3962014-02-28 16:58:03.162412 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): total read so far: 262144 bytes
3972014-02-28 16:58:03.162454 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): @ end of read ahead loop
3982014-02-28 16:58:03.172684 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@262144, 131072) -- begin
3992014-02-28 16:58:03.192087 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@262144, 131072) -> 131072, took 19 ms (55.1882Mbps) avg 248 ms
4002014-02-28 16:58:03.192120 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): rbwpos += 128K requested 128K in read
4012014-02-28 16:58:03.192147 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): total read so far: 393216 bytes
4022014-02-28 16:58:03.192170 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): @ end of read ahead loop
4032014-02-28 16:58:03.199301 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@393216, 131072) -- begin
4042014-02-28 16:58:03.220174 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@393216, 131072) -> 131072, took 20 ms (52.4288Mbps) avg 225 ms
4052014-02-28 16:58:03.220216 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): rbwpos += 128K requested 128K in read
4062014-02-28 16:58:03.220240 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): total read so far: 524288 bytes
4072014-02-28 16:58:03.220263 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): @ end of read ahead loop
4082014-02-28 16:58:03.229289 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@524288, 131072) -- begin
4092014-02-28 16:58:03.231765 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@524288, 131072) -> 131072, took 2 ms (524.288Mbps) avg 205 ms
4102014-02-28 16:58:03.231809 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): rbwpos += 128K requested 128K in read
4112014-02-28 16:58:03.231833 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): total read so far: 655360 bytes
4122014-02-28 16:58:03.231851 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): @ end of read ahead loop
4132014-02-28 16:58:03.239293 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@655360, 131072) -- begin
4142014-02-28 16:58:03.242357 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@655360, 131072) -> 131072, took 2 ms (524.288Mbps) avg 185 ms
4152014-02-28 16:58:03.242404 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): rbwpos += 128K requested 128K in read
4162014-02-28 16:58:03.242428 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): total read so far: 786432 bytes
4172014-02-28 16:58:03.242446 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): @ end of read ahead loop
4182014-02-28 16:58:03.252628 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@786432, 131072) -- begin
4192014-02-28 16:58:03.255663 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@786432, 131072) -> 131072, took 2 ms (524.288Mbps) avg 167 ms
4202014-02-28 16:58:03.255706 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): rbwpos += 128K requested 128K in read
4212014-02-28 16:58:03.255730 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): total read so far: 917504 bytes
4222014-02-28 16:58:03.255751 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): @ end of read ahead loop
4232014-02-28 16:58:03.265951 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@917504, 131072) -- begin
4242014-02-28 16:58:03.269132 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@917504, 131072) -> 131072, took 3 ms (349.525Mbps) avg 151 ms
4252014-02-28 16:58:03.269167 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): rbwpos += 128K requested 128K in read
4262014-02-28 16:58:03.269192 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): total read so far: 1048576 bytes
4272014-02-28 16:58:03.269211 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): @ end of read ahead loop
4282014-02-28 16:58:03.279372 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): Avg read interval was 137 msec. 128K -> 192K block size
4292014-02-28 16:58:03.279423 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@1048576, 131072) -- begin
4302014-02-28 16:58:03.282742 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@1048576, 131072) -> 131072, took 3 ms (349.525Mbps) avg 225 ms
4312014-02-28 16:58:03.282796 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): rbwpos += 128K requested 128K in read
4322014-02-28 16:58:03.282824 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): total read so far: 1179648 bytes
4332014-02-28 16:58:03.282850 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): @ end of read ahead loop
4342014-02-28 16:58:03.292747 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@1179648, 196608) -- begin
4352014-02-28 16:58:03.297419 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@1179648, 196608) -> 196608, took 4 ms (393.216Mbps) avg 225 ms
4362014-02-28 16:58:03.297457 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): rbwpos += 192K requested 192K in read
4372014-02-28 16:58:03.297483 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): total read so far: 1376256 bytes
4382014-02-28 16:58:03.297507 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): @ end of read ahead loop
4392014-02-28 16:58:03.306005 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@1376256, 196608) -- begin
4402014-02-28 16:58:03.310067 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@1376256, 196608) -> 196608, took 3 ms (524.288Mbps) avg 203 ms
4412014-02-28 16:58:03.310103 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): rbwpos += 192K requested 192K in read
4422014-02-28 16:58:03.310129 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): total read so far: 1572864 bytes
4432014-02-28 16:58:03.310153 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): @ end of read ahead loop
4442014-02-28 16:58:03.319303 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@1572864, 196608) -- begin
4452014-02-28 16:58:03.340326 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@1572864, 196608) -> 196608, took 20 ms (78.6432Mbps) avg 184 ms
4462014-02-28 16:58:03.340352 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): rbwpos += 192K requested 192K in read
4472014-02-28 16:58:03.340369 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): total read so far: 1769472 bytes
4482014-02-28 16:58:03.340385 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): @ end of read ahead loop
4492014-02-28 16:58:03.349281 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@1769472, 196608) -- begin
4502014-02-28 16:58:03.355832 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@1769472, 196608) -> 196608, took 6 ms (262.144Mbps) avg 168 ms
4512014-02-28 16:58:03.355899 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): rbwpos += 192K requested 192K in read
4522014-02-28 16:58:03.355923 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): total read so far: 1966080 bytes
4532014-02-28 16:58:03.355957 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): @ end of read ahead loop
4542014-02-28 16:58:03.365964 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@1966080, 196608) -- begin
4552014-02-28 16:58:03.369774 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@1966080, 196608) -> 196608, took 3 ms (524.288Mbps) avg 152 ms
4562014-02-28 16:58:03.369806 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): rbwpos += 192K requested 192K in read
4572014-02-28 16:58:03.369827 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): total read so far: 2162688 bytes
4582014-02-28 16:58:03.369846 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): @ end of read ahead loop
4592014-02-28 16:58:03.379286 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): Avg read interval was 138 msec. 192K -> 288K block size
4602014-02-28 16:58:03.379310 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@2162688, 196608) -- begin
4612014-02-28 16:58:03.384095 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@2162688, 196608) -> 196608, took 4 ms (393.216Mbps) avg 225 ms
4622014-02-28 16:58:03.384125 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): rbwpos += 192K requested 192K in read
4632014-02-28 16:58:03.384145 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): total read so far: 2359296 bytes
4642014-02-28 16:58:03.384164 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): @ end of read ahead loop
4652014-02-28 16:58:03.387541 D  AFD: PlayerFlags: 0xc0
4662014-02-28 16:58:03.387596 I  Player(0): Stretch Factor 1, allow passthru
4672014-02-28 16:58:03.389763 I  AFD: Buffer size: 32768, streamed 0
4682014-02-28 16:58:03.389960 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal) @0 -- begin
4692014-02-28 16:58:03.390006 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal) -- copying data
4702014-02-28 16:58:03.390276 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal) -- checksum 45957
4712014-02-28 16:58:03.392641 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@2359296, 294912) -- begin
4722014-02-28 16:58:03.421425 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@2359296, 294912) -> 294912, took 28 ms (84.2606Mbps) avg 225 ms
4732014-02-28 16:58:03.421457 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): rbwpos += 288K requested 288K in read
4742014-02-28 16:58:03.421478 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): total read so far: 2654208 bytes
4752014-02-28 16:58:03.421496 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): @ end of read ahead loop
4762014-02-28 16:58:03.429354 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@2654208, 294912) -- begin
4772014-02-28 16:58:03.469560 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@2654208, 294912) -> 294912, took 40 ms (58.9824Mbps) avg 206 ms
4782014-02-28 16:58:03.469603 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): rbwpos += 288K requested 288K in read
4792014-02-28 16:58:03.469630 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): total read so far: 2949120 bytes
4802014-02-28 16:58:03.469654 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): @ end of read ahead loop
4812014-02-28 16:58:03.479349 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@2949120, 294912) -- begin
4822014-02-28 16:58:03.492454 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@2949120, 294912) -> 294912, took 13 ms (181.484Mbps) avg 190 ms
4832014-02-28 16:58:03.492498 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): rbwpos += 288K requested 288K in read
4842014-02-28 16:58:03.492526 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): total read so far: 3244032 bytes
4852014-02-28 16:58:03.492552 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): @ end of read ahead loop
4862014-02-28 16:58:03.502638 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@3244032, 294912) -- begin
4872014-02-28 16:58:03.527951 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@3244032, 294912) -> 294912, took 25 ms (94.3718Mbps) avg 173 ms
4882014-02-28 16:58:03.527987 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): rbwpos += 288K requested 288K in read
4892014-02-28 16:58:03.528009 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): total read so far: 3538944 bytes
4902014-02-28 16:58:03.528029 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): @ end of read ahead loop
4912014-02-28 16:58:03.535961 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@3538944, 294912) -- begin
4922014-02-28 16:58:03.544339 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@3538944, 294912) -> 294912, took 8 ms (294.912Mbps) avg 159 ms
4932014-02-28 16:58:03.544368 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): rbwpos += 288K requested 288K in read
4942014-02-28 16:58:03.544389 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): total read so far: 3833856 bytes
4952014-02-28 16:58:03.544407 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): @ end of read ahead loop
4962014-02-28 16:58:03.552621 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): Avg read interval was 144 msec. 288K -> 448K block size
4972014-02-28 16:58:03.552644 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@3833856, 294912) -- begin
4982014-02-28 16:58:03.560553 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@3833856, 294912) -> 294912, took 7 ms (337.042Mbps) avg 225 ms
4992014-02-28 16:58:03.560584 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): rbwpos += 288K requested 288K in read
5002014-02-28 16:58:03.560603 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): total read so far: 4128768 bytes
5012014-02-28 16:58:03.560620 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): @ end of read ahead loop
5022014-02-28 16:58:03.569301 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@4128768, 458752) -- begin
5032014-02-28 16:58:03.595324 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@4128768, 458752) -> 458752, took 25 ms (146.801Mbps) avg 225 ms
5042014-02-28 16:58:03.595375 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): rbwpos += 448K requested 448K in read
5052014-02-28 16:58:03.595403 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): total read so far: 4587520 bytes
5062014-02-28 16:58:03.595427 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): @ end of read ahead loop
5072014-02-28 16:58:03.602683 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@4587520, 458752) -- begin
5082014-02-28 16:58:03.617581 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@4587520, 458752) -> 458752, took 14 ms (262.144Mbps) avg 205 ms
5092014-02-28 16:58:03.617626 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): rbwpos += 448K requested 448K in read
5102014-02-28 16:58:03.617654 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): total read so far: 5046272 bytes
5112014-02-28 16:58:03.617682 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): @ end of read ahead loop
5122014-02-28 16:58:03.625968 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@5046272, 458752) -- begin
5132014-02-28 16:58:03.643192 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@5046272, 458752) -> 458752, took 17 ms (215.883Mbps) avg 186 ms
5142014-02-28 16:58:03.643226 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): rbwpos += 448K requested 448K in read
5152014-02-28 16:58:03.643246 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): total read so far: 5505024 bytes
5162014-02-28 16:58:03.643265 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): @ end of read ahead loop
5172014-02-28 16:58:03.652613 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@5505024, 458752) -- begin
5182014-02-28 16:58:03.663043 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@5505024, 458752) -> 458752, took 10 ms (367.002Mbps) avg 170 ms
5192014-02-28 16:58:03.663073 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): rbwpos += 448K requested 448K in read
5202014-02-28 16:58:03.663093 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): total read so far: 5963776 bytes
5212014-02-28 16:58:03.663115 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): @ end of read ahead loop
5222014-02-28 16:58:03.672616 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@5963776, 458752) -- begin
5232014-02-28 16:58:03.682009 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@5963776, 458752) -> 458752, took 9 ms (407.78Mbps) avg 155 ms
5242014-02-28 16:58:03.682044 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): rbwpos += 448K requested 448K in read
5252014-02-28 16:58:03.682065 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): total read so far: 6422528 bytes
5262014-02-28 16:58:03.682084 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): @ end of read ahead loop
5272014-02-28 16:58:03.689297 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): Avg read interval was 141 msec. 448K -> 512K block size
5282014-02-28 16:58:03.689321 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@6422528, 458752) -- begin
5292014-02-28 16:58:03.698058 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@6422528, 458752) -> 458752, took 9 ms (407.78Mbps) avg 225 ms
5302014-02-28 16:58:03.698093 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): rbwpos += 448K requested 448K in read
5312014-02-28 16:58:03.698113 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): total read so far: 6881280 bytes
5322014-02-28 16:58:03.698131 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): @ end of read ahead loop
5332014-02-28 16:58:03.705960 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@6881280, 524288) -- begin
5342014-02-28 16:58:03.711774 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal) @32768 -- begin
5352014-02-28 16:58:03.711825 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal) -- copying data
5362014-02-28 16:58:03.712159 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal) -- checksum 7618
5372014-02-28 16:58:03.712892 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal) @65536 -- begin
5382014-02-28 16:58:03.712936 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal) -- copying data
5392014-02-28 16:58:03.713264 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal) -- checksum 2228
5402014-02-28 16:58:03.713834 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal) @98304 -- begin
5412014-02-28 16:58:03.713867 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal) -- copying data
5422014-02-28 16:58:03.714164 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal) -- checksum 59756
5432014-02-28 16:58:03.715248 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal) @131072 -- begin
5442014-02-28 16:58:03.715308 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal) -- copying data
5452014-02-28 16:58:03.715641 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal) -- checksum 31772
5462014-02-28 16:58:03.716908 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@6881280, 524288) -> 524288, took 10 ms (419.43Mbps) avg 225 ms
5472014-02-28 16:58:03.716943 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): rbwpos += 512K requested 512K in read
5482014-02-28 16:58:03.716963 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): total read so far: 7405568 bytes
5492014-02-28 16:58:03.716982 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): @ end of read ahead loop
5502014-02-28 16:58:03.717905 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal) @163840 -- begin
5512014-02-28 16:58:03.717945 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal) -- copying data
5522014-02-28 16:58:03.718216 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal) -- checksum 31011
5532014-02-28 16:58:03.718973 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal) @196608 -- begin
5542014-02-28 16:58:03.718999 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal) -- copying data
5552014-02-28 16:58:03.719294 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal) -- checksum 19715
5562014-02-28 16:58:03.719650 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal) @229376 -- begin
5572014-02-28 16:58:03.719681 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal) -- copying data
5582014-02-28 16:58:03.719944 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal) -- checksum 11265
5592014-02-28 16:58:03.720324 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal) @262144 -- begin
5602014-02-28 16:58:03.720358 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal) -- copying data
5612014-02-28 16:58:03.720620 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal) -- checksum 10143
5622014-02-28 16:58:03.721986 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal) @294912 -- begin
5632014-02-28 16:58:03.722018 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal) -- copying data
5642014-02-28 16:58:03.722285 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal) -- checksum 57957
5652014-02-28 16:58:03.723259 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal) @327680 -- begin
5662014-02-28 16:58:03.723286 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal) -- copying data
5672014-02-28 16:58:03.723556 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal) -- checksum 53285
5682014-02-28 16:58:03.723694 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal) @360448 -- begin
5692014-02-28 16:58:03.723718 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal) -- copying data
5702014-02-28 16:58:03.723978 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal) -- checksum 31484
5712014-02-28 16:58:03.725167 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal) @393216 -- begin
5722014-02-28 16:58:03.725198 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal) -- copying data
5732014-02-28 16:58:03.725472 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal) -- checksum 18027
5742014-02-28 16:58:03.725991 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@7405568, 524288) -- begin
5752014-02-28 16:58:03.726390 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal) @425984 -- begin
5762014-02-28 16:58:03.726428 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal) -- copying data
5772014-02-28 16:58:03.726696 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal) -- checksum 61757
5782014-02-28 16:58:03.727556 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal) @458752 -- begin
5792014-02-28 16:58:03.727605 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal) -- copying data
5802014-02-28 16:58:03.727922 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal) -- checksum 13164
5812014-02-28 16:58:03.728292 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal) @491520 -- begin
5822014-02-28 16:58:03.728336 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal) -- copying data
5832014-02-28 16:58:03.728654 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal) -- checksum 23557
5842014-02-28 16:58:03.729566 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal) @524288 -- begin
5852014-02-28 16:58:03.729604 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal) -- copying data
5862014-02-28 16:58:03.729932 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal) -- checksum 37137
5872014-02-28 16:58:03.730319 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal) @557056 -- begin
5882014-02-28 16:58:03.730376 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal) -- copying data
5892014-02-28 16:58:03.730686 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal) -- checksum 50715
5902014-02-28 16:58:03.738549 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@7405568, 524288) -> 524288, took 12 ms (349.525Mbps) avg 204 ms
5912014-02-28 16:58:03.738597 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): rbwpos += 512K requested 512K in read
5922014-02-28 16:58:03.738627 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): total read so far: 7929856 bytes
5932014-02-28 16:58:03.738654 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): @ end of read ahead loop
5942014-02-28 16:58:03.788806 I  FileRingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): Seek(132965672,SEEK_SET,unlocked)
5952014-02-28 16:58:03.788832 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): StopReads()
5962014-02-28 16:58:03.788869 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): StartReads()
5972014-02-28 16:58:03.788909 I  FileRingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): Seek(): rbrpos: 589824 rbwpos: 7929856
598                        readpos: 589824 internalreadpos: 7929856
5992014-02-28 16:58:03.788932 I  FileRingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): Seek(): Offset from end: 250000
6002014-02-28 16:58:03.788951 I  FileRingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): Seek(): offset from end: 250000
601                         -- ignoring read ahead thread until next seek.
6022014-02-28 16:58:03.856079 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal) @589824 -- begin
6032014-02-28 16:58:03.857661 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal): ReadDirect checksum 56027
6042014-02-28 16:58:03.857853 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal) @589824 -- begin
6052014-02-28 16:58:03.859351 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal): ReadDirect checksum 27295
6062014-02-28 16:58:03.859533 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal) @589824 -- begin
6072014-02-28 16:58:03.860915 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal): ReadDirect checksum 52680
6082014-02-28 16:58:03.861083 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal) @589824 -- begin
6092014-02-28 16:58:03.862348 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal): ReadDirect checksum 19573
6102014-02-28 16:58:03.862525 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal) @589824 -- begin
6112014-02-28 16:58:03.863779 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal): ReadDirect checksum 5927
6122014-02-28 16:58:03.863956 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal) @589824 -- begin
6132014-02-28 16:58:03.865209 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal): ReadDirect checksum 36178
6142014-02-28 16:58:03.865381 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal) @589824 -- begin
6152014-02-28 16:58:03.866642 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal): ReadDirect checksum 42034
6162014-02-28 16:58:03.866811 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal) @589824 -- begin
6172014-02-28 16:58:03.883119 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..32768, normal): ReadDirect checksum 713
6182014-02-28 16:58:03.883279 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..12144, normal) @589824 -- begin
6192014-02-28 16:58:03.896264 I  FileRingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(RemoteFile* ...): at EOF
6202014-02-28 16:58:03.896386 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..12144, normal): ReadDirect checksum 53228
6212014-02-28 16:58:03.896423 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..12144, normal) @589824 -- begin
6222014-02-28 16:58:03.909619 I  FileRingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(RemoteFile* ...): at EOF
6232014-02-28 16:58:03.909742 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..12144, normal): ReadDirect checksum 53228
6242014-02-28 16:58:03.909789 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..12144, normal) @589824 -- begin
6252014-02-28 16:58:03.922931 I  FileRingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(RemoteFile* ...): at EOF
6262014-02-28 16:58:03.923047 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..12144, normal): ReadDirect checksum 53228
6272014-02-28 16:58:03.923096 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..12144, normal) @589824 -- begin
6282014-02-28 16:58:03.936163 I  FileRingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(RemoteFile* ...): at EOF
6292014-02-28 16:58:03.936281 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ReadPriv(..12144, normal): ReadDirect checksum 53228
6302014-02-28 16:58:03.936370 I  FileRingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): Seek(0,SEEK_SET,unlocked)
6312014-02-28 16:58:03.936386 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): StopReads()
6322014-02-28 16:58:03.936415 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): StartReads()
6332014-02-28 16:58:03.936445 I  FileRingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): Seek(): rbrpos: 589824 rbwpos: 7929856
634                        readpos: 839824 internalreadpos: 7929856
6352014-02-28 16:58:03.936465 I  FileRingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): Seek(): internal_backbuf: 524288 sba: 839824
6362014-02-28 16:58:04.002731 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): ResetReadAhead(internalreadpos = 7929856->0)
6372014-02-28 16:58:04.002783 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): CalcReadAheadThresh(8000 Kb)
638                         -> threshhold(7168 KB) min read(128 KB) blk size(512 KB)
6392014-02-28 16:58:04.002952 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): run: Not reading continuing: totfree(1048575) readsallowed(0) ignorereadpos(-1) commserror(0) stopreads(0)
6402014-02-28 16:58:04.002994 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): Reading enough data to start playback
6412014-02-28 16:58:04.003026 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@0, 524288) -- begin
6422014-02-28 16:58:04.003031 I  AFD: Stream #0, has id 0x108 codec id DVB_TELETEXT, type Subtitle, bitrate 0 at 0x1fe26e0
6432014-02-28 16:58:04.015702 I  AFD: Teletext stream #0 (Caption) is in the Polish language on page 7 78.
6442014-02-28 16:58:04.015750 I  AFD: Teletext stream #1 (Menu) is in the Polish language on page 1 0.
6452014-02-28 16:58:04.015797 I  AFD: subtitle codec (Subtitle)
6462014-02-28 16:58:04.015889 I  AFD: Stream #1, has id 0x259 codec id H264, type Video, bitrate 0 at 0x37cdfe0
6472014-02-28 16:58:04.016081 I  AFD: Stream #2, has id 0x266 codec id MP2, type Audio, bitrate 192000 at 0x1fe3160
6482014-02-28 16:58:04.016180 I  AFD: codec MP2 has 2 channels
6492014-02-28 16:58:04.016203 I  AFD: Looking for decoder for MP2
6502014-02-28 16:58:04.016660 I  AFD: Opened codec 0x37cd5e0, id(MP2) type(Audio)
6512014-02-28 16:58:04.016964 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@0, 524288) -> 524288, took 13 ms (322.639Mbps) avg 204 ms
6522014-02-28 16:58:04.017009 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): rbwpos += 512K requested 512K in read
6532014-02-28 16:58:04.017030 I  AFD: Audio Track #1, of type (Normalny) is A/V stream #2 (id=0x266) and has 2 channels in the Polish language(7368556).
6542014-02-28 16:58:04.017040 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): total read so far: 524288 bytes
6552014-02-28 16:58:04.017060 I  AFD: Trying to select best video track
6562014-02-28 16:58:04.017069 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): @ end of read ahead loop
6572014-02-28 16:58:04.017163 I  AFD: Selected track #1 (id 0x259 codec id H264, type Video, bitrate 500000 at 0x37cdfe0)
6582014-02-28 16:58:04.022399 I  VDP: Accepting: cmp(>= 0 720) dec(vdpau) cpus(1) skiploop(enabled) rend(vdpau) osd(vdpau) osdfade(enabled) deint(vdpaubasic,vdpaubasic) filt(vdpaucolorspace=auto,vdpausharpen=0.5,vdpaudenoise=1,0)
6592014-02-28 16:58:04.022492 I  VDP: Accepting: cmp(> 0 0) dec(vdpau) cpus(1) skiploop(enabled) rend(vdpau) osd(vdpau) osdfade(enabled) deint(vdpauadvanceddoublerate,vdpauadvanced) filt(vdpaucolorspace=auto,vdpausharpen=1.0,vdpaudenoise=1.0)
6602014-02-28 16:58:04.022553 I  VDP: LoadBestPreferences(2048x2048, 0)
6612014-02-28 16:58:04.022666 I  VDP: LoadBestPreferences(2048x2048, 60)
6622014-02-28 16:58:04.022721 I  VDP: LoadBestPreferences(1920x1080, 60)
6632014-02-28 16:58:04.022946 I  AFD: Using 1 CPUs for decoding
6642014-02-28 16:58:04.022985 I  AFD: InitVideoCodec() 0x37cd180 id(H264) type (Video).
6652014-02-28 16:58:04.023072 I  AFD: Selected FPS is 25 (avg 0 codec 25 container 90000 estimated 50)
6662014-02-28 16:58:04.023146 I  Player(0): SetFrameInterval ps:1 scan:3
6672014-02-28 16:58:04.023200 I  Player(0): detectInterlace(Detect Scan, Interlaced Scan, 25, 1080) ->Interlaced Scan
6682014-02-28 16:58:04.023299 I  AFD: Using vdpau for video decoding
6692014-02-28 16:58:04.024164 I  AFD: Opened codec 0x37cd180, id(H264) type(Video)
6702014-02-28 16:58:04.024224 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): UpdateRawBitrate(5467Kb)
6712014-02-28 16:58:04.024261 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): CalcReadAheadThresh(5467 Kb)
672                         -> threshhold(7168 KB) min read(96 KB) blk size(512 KB)
6732014-02-28 16:58:04.035624 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): CalcReadAheadThresh(5467 Kb)
674                         -> threshhold(14336 KB) min read(96 KB) blk size(512 KB)
6752014-02-28 16:58:04.035677 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): Created readAheadBuffer: 16Mb
6762014-02-28 16:58:04.035708 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@8388608, 524288) -- begin
6772014-02-28 16:58:04.035765 I  AFD: Selected track 1: Polish MP2 2ch (A/V Stream #2)
6782014-02-28 16:58:04.035974 I  AFD: Audio data is planar
6792014-02-28 16:58:04.036112 I  AFD: Initializing audio parms from audio track #1
6802014-02-28 16:58:04.036194 I  AFD: Audio format changed
681                        from id(NONE)     -1Hz -1ch -1bps     (profile 0) to id( MP2)  48000Hz  2ch 16bps     (profile 0)
6822014-02-28 16:58:04.036278 I  AOBase: Killing AudioOutputDSP
6832014-02-28 16:58:04.036353 I  AOBase: Original codec was MP2, signed 16 bit, 48 kHz, 2 channels
6842014-02-28 16:58:04.036404 I  AOBase: enc(0), passthru(0), features () configured_channels(2), 2 channels supported(1) max_channels(2)
6852014-02-28 16:58:04.036433 I  AOBase: Audio processing enabled
6862014-02-28 16:58:04.036481 I  AOBase: Opening audio device 'sysdefault:CARD=NVidia' ch 2(2) sr 48000 sf signed 32 bit reenc 0
6872014-02-28 16:58:04.036499 I  ALSA: OpenDevice sysdefault:CARD=NVidia
6882014-02-28 16:58:04.046638 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@8388608, 524288) -> 524288, took 10 ms (419.43Mbps) avg 186 ms
6892014-02-28 16:58:04.046683 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): rbwpos += 512K requested 512K in read
6902014-02-28 16:58:04.046713 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): total read so far: 1048576 bytes
6912014-02-28 16:58:04.046744 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): @ end of read ahead loop
6922014-02-28 16:58:04.049675 I  ALSA: SetParameters(format=10, channels=2, rate=48000, buffer_time=500000, period_time=4)
6932014-02-28 16:58:04.050419 I  ALSA: Buffer size range from 2048 to 16384
6942014-02-28 16:58:04.050445 I  ALSA: Period size range from 1024 to 1024
6952014-02-28 16:58:04.050562 E  ALSA: Requested 500000us got 341333 buffer time
6962014-02-28 16:58:04.050852 I  ALSA: Hardware audio buffer cur: 512 need: 768 max allowed: 32768
6972014-02-28 16:58:04.050930 E  ALSA: Try to manually increase audio buffer with: echo 768 | sudo tee /proc/asound/card0/pcm0p/sub0/prealloc
6982014-02-28 16:58:04.050959 I  ALSA: Buffer time = 341333 us
6992014-02-28 16:58:04.051013 I  ALSA: Period time = 16 periods
7002014-02-28 16:58:04.051287 I  ALSA: Buffer size = 16384 | Period size = 1024
7012014-02-28 16:58:04.053917 I  ALSA: found playback control PCM on mixer device default
7022014-02-28 16:58:04.053997 I  ALSA: mixer volume range on mixer device default/PCM - min 0, max 255, range 255
7032014-02-28 16:58:04.054015 I  ALSA: mixer device default/PCM set up successfully
7042014-02-28 16:58:04.055383 I  ALSA: channel 0 volume set 65 => 166
7052014-02-28 16:58:04.055420 I  ALSA: channel 1 volume set 65 => 166
7062014-02-28 16:58:04.055441 I  AOBase: Audio fragment size: 4096
7072014-02-28 16:58:04.055538 I  ALSA: get volume channel 0: 65
7082014-02-28 16:58:04.055574 I  ALSA: channel 0 volume set 65 => 166
7092014-02-28 16:58:04.055594 I  ALSA: channel 1 volume set 65 => 166
7102014-02-28 16:58:04.055619 I  AOBase: Audio Stretch Factor: 1
7112014-02-28 16:58:04.055757 I  AOBase: Ending Reconfigure()
7122014-02-28 16:58:04.055823 I  Dec: Selected track #1 (type 2) in the Unknown language(0)
7132014-02-28 16:58:04.055870 I  Dec: Selected track #1 (type 6) in the Polish language(7368556)
7142014-02-28 16:58:04.055897 I  Dec: Selected track #1 (type 7) in the Polish language(7368556)
7152014-02-28 16:58:04.055997 I  Dec: Resyncing position map. posmapStarted = 0 livetv(0) watchingRec(0)
7162014-02-28 16:58:04.056077 I  AOBase: kickoffOutputAudioLoop: pid = 8128
7172014-02-28 16:58:04.055997 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@8912896, 524288) -- begin
7182014-02-28 16:58:04.056149 I  AOBase: OutputAudioLoop: Play Event
7192014-02-28 16:58:04.063710 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@8912896, 524288) -> 524288, took 7 ms (599.186Mbps) avg 169 ms
7202014-02-28 16:58:04.063742 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): rbwpos += 512K requested 512K in read
7212014-02-28 16:58:04.063764 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): total read so far: 1572864 bytes
7222014-02-28 16:58:04.063785 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): @ end of read ahead loop
7232014-02-28 16:58:04.063782 I  Dec: Position map filled from DB to: 4836
7242014-02-28 16:58:04.063965 I  Dec: Duration map filled from DB to: 4836
7252014-02-28 16:58:04.064080 I  Dec: SyncPositionMap prerecorded, from DB: 159 entries
7262014-02-28 16:58:04.064117 I  Dec: SyncPositionMap, new totframes: 4836, new length: 193, posMap size: 159
7272014-02-28 16:58:04.065664 I  AFD: Position map found
7282014-02-28 16:58:04.065697 I  AFD: Successfully opened decoder for file: "myth://192.168.1.254:6543/13111_20140228153001.mpg". novideo(0)
7292014-02-28 16:58:04.072630 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@9437184, 524288) -- begin
7302014-02-28 16:58:04.079200 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@9437184, 524288) -> 524288, took 6 ms (699.051Mbps) avg 153 ms
7312014-02-28 16:58:04.079228 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): rbwpos += 512K requested 512K in read
7322014-02-28 16:58:04.079259 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): total read so far: 2097152 bytes
7332014-02-28 16:58:04.079280 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): @ end of read ahead loop
7342014-02-28 16:58:04.089280 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): Avg read interval was 139 msec. 512K -> 512K block size
7352014-02-28 16:58:04.089303 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@9961472, 524288) -- begin
7362014-02-28 16:58:04.097245 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@9961472, 524288) -> 524288, took 7 ms (599.186Mbps) avg 225 ms
7372014-02-28 16:58:04.097271 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): rbwpos += 512K requested 512K in read
7382014-02-28 16:58:04.097289 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): total read so far: 2621440 bytes
7392014-02-28 16:58:04.097306 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): @ end of read ahead loop
7402014-02-28 16:58:04.105942 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@10485760, 524288) -- begin
7412014-02-28 16:58:04.113754 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@10485760, 524288) -> 524288, took 7 ms (599.186Mbps) avg 204 ms
7422014-02-28 16:58:04.113780 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): rbwpos += 512K requested 512K in read
7432014-02-28 16:58:04.113798 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): total read so far: 3145728 bytes
7442014-02-28 16:58:04.113814 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): @ end of read ahead loop
7452014-02-28 16:58:04.122653 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@11010048, 524288) -- begin
7462014-02-28 16:58:04.130584 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@11010048, 524288) -> 524288, took 7 ms (599.186Mbps) avg 185 ms
7472014-02-28 16:58:04.130627 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): rbwpos += 512K requested 512K in read
7482014-02-28 16:58:04.130657 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): total read so far: 3670016 bytes
7492014-02-28 16:58:04.130683 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): @ end of read ahead loop
7502014-02-28 16:58:04.139320 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@11534336, 524288) -- begin
7512014-02-28 16:58:04.147124 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@11534336, 524288) -> 524288, took 7 ms (599.186Mbps) avg 168 ms
7522014-02-28 16:58:04.147162 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): rbwpos += 512K requested 512K in read
7532014-02-28 16:58:04.147188 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): total read so far: 4194304 bytes
7542014-02-28 16:58:04.147212 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): @ end of read ahead loop
7552014-02-28 16:58:04.156022 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@12058624, 524288) -- begin
7562014-02-28 16:58:04.164114 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@12058624, 524288) -> 524288, took 7 ms (599.186Mbps) avg 152 ms
7572014-02-28 16:58:04.164151 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): rbwpos += 512K requested 512K in read
7582014-02-28 16:58:04.164177 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): total read so far: 4718592 bytes
7592014-02-28 16:58:04.164200 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): @ end of read ahead loop
7602014-02-28 16:58:04.172669 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): Avg read interval was 138 msec. 512K -> 512K block size
7612014-02-28 16:58:04.172708 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@12582912, 524288) -- begin
7622014-02-28 16:58:04.180446 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@12582912, 524288) -> 524288, took 7 ms (599.186Mbps) avg 225 ms
7632014-02-28 16:58:04.180487 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): rbwpos += 512K requested 512K in read
7642014-02-28 16:58:04.180516 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): total read so far: 5242880 bytes
7652014-02-28 16:58:04.180540 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): @ end of read ahead loop
7662014-02-28 16:58:04.189334 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@13107200, 524288) -- begin
7672014-02-28 16:58:04.196951 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@13107200, 524288) -> 524288, took 7 ms (599.186Mbps) avg 204 ms
7682014-02-28 16:58:04.196991 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): rbwpos += 512K requested 512K in read
7692014-02-28 16:58:04.197017 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): total read so far: 5767168 bytes
7702014-02-28 16:58:04.197043 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): @ end of read ahead loop
7712014-02-28 16:58:04.205984 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@13631488, 524288) -- begin
7722014-02-28 16:58:04.213436 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@13631488, 524288) -> 524288, took 7 ms (599.186Mbps) avg 185 ms
7732014-02-28 16:58:04.213476 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): rbwpos += 512K requested 512K in read
7742014-02-28 16:58:04.213504 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): total read so far: 6291456 bytes
7752014-02-28 16:58:04.213530 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): @ end of read ahead loop
7762014-02-28 16:58:04.222697 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@14155776, 524288) -- begin
7772014-02-28 16:58:04.230211 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@14155776, 524288) -> 524288, took 7 ms (599.186Mbps) avg 168 ms
7782014-02-28 16:58:04.230256 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): rbwpos += 512K requested 512K in read
7792014-02-28 16:58:04.230284 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): total read so far: 6815744 bytes
7802014-02-28 16:58:04.230316 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): @ end of read ahead loop
7812014-02-28 16:58:04.239324 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@14680064, 524288) -- begin
7822014-02-28 16:58:04.246520 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@14680064, 524288) -> 524288, took 7 ms (599.186Mbps) avg 152 ms
7832014-02-28 16:58:04.246558 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): rbwpos += 512K requested 512K in read
7842014-02-28 16:58:04.246590 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): total read so far: 7340032 bytes
7852014-02-28 16:58:04.246617 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): @ end of read ahead loop
7862014-02-28 16:58:04.255993 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): Avg read interval was 138 msec. 512K -> 512K block size
7872014-02-28 16:58:04.256037 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@15204352, 524288) -- begin
7882014-02-28 16:58:04.263335 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@15204352, 524288) -> 524288, took 7 ms (599.186Mbps) avg 225 ms
7892014-02-28 16:58:04.263369 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): rbwpos += 512K requested 512K in read
7902014-02-28 16:58:04.263393 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): total read so far: 7864320 bytes
7912014-02-28 16:58:04.263415 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): @ end of read ahead loop
7922014-02-28 16:58:04.272626 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@15728640, 524288) -- begin
7932014-02-28 16:58:04.279810 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@15728640, 524288) -> 524288, took 7 ms (599.186Mbps) avg 204 ms
7942014-02-28 16:58:04.279838 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): rbwpos += 512K requested 512K in read
7952014-02-28 16:58:04.279857 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): total read so far: 8388608 bytes
7962014-02-28 16:58:04.279873 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): @ end of read ahead loop
7972014-02-28 16:58:04.289277 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@16252928, 524288) -- begin
7982014-02-28 16:58:04.296527 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@16252928, 524288) -> 524288, took 7 ms (599.186Mbps) avg 185 ms
7992014-02-28 16:58:04.296564 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): rbwpos += 512K requested 512K in read
8002014-02-28 16:58:04.296609 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): total read so far: 8912896 bytes
8012014-02-28 16:58:04.296632 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): @ end of read ahead loop
8022014-02-28 16:58:04.305991 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@0, 524288) -- begin
8032014-02-28 16:58:04.312978 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@0, 524288) -> 524288, took 6 ms (699.051Mbps) avg 168 ms
8042014-02-28 16:58:04.313019 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): rbwpos += 512K requested 512K in read
8052014-02-28 16:58:04.313038 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): total read so far: 9437184 bytes
8062014-02-28 16:58:04.313056 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): @ end of read ahead loop
8072014-02-28 16:58:04.322645 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@524288, 524288) -- begin
8082014-02-28 16:58:04.329593 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@524288, 524288) -> 524288, took 6 ms (699.051Mbps) avg 152 ms
8092014-02-28 16:58:04.329628 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): rbwpos += 512K requested 512K in read
8102014-02-28 16:58:04.329652 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): total read so far: 9961472 bytes
8112014-02-28 16:58:04.329670 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): @ end of read ahead loop
8122014-02-28 16:58:04.339287 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): Avg read interval was 138 msec. 512K -> 512K block size
8132014-02-28 16:58:04.339310 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@1048576, 524288) -- begin
8142014-02-28 16:58:04.346015 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@1048576, 524288) -> 524288, took 6 ms (699.051Mbps) avg 225 ms
8152014-02-28 16:58:04.346047 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): rbwpos += 512K requested 512K in read
8162014-02-28 16:58:04.346064 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): total read so far: 10485760 bytes
8172014-02-28 16:58:04.346081 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): @ end of read ahead loop
8182014-02-28 16:58:04.355937 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@1572864, 524288) -- begin
8192014-02-28 16:58:04.362786 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@1572864, 524288) -> 524288, took 6 ms (699.051Mbps) avg 204 ms
8202014-02-28 16:58:04.362817 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): rbwpos += 512K requested 512K in read
8212014-02-28 16:58:04.362835 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): total read so far: 11010048 bytes
8222014-02-28 16:58:04.362852 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): @ end of read ahead loop
8232014-02-28 16:58:04.372606 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@2097152, 524288) -- begin
8242014-02-28 16:58:04.379481 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@2097152, 524288) -> 524288, took 6 ms (699.051Mbps) avg 185 ms
8252014-02-28 16:58:04.379512 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): rbwpos += 512K requested 512K in read
8262014-02-28 16:58:04.379537 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): total read so far: 11534336 bytes
8272014-02-28 16:58:04.379556 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): @ end of read ahead loop
8282014-02-28 16:58:04.389289 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@2621440, 524288) -- begin
8292014-02-28 16:58:04.395860 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@2621440, 524288) -> 524288, took 6 ms (699.051Mbps) avg 168 ms
8302014-02-28 16:58:04.395893 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): rbwpos += 512K requested 512K in read
8312014-02-28 16:58:04.395953 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): total read so far: 12058624 bytes
8322014-02-28 16:58:04.395972 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): @ end of read ahead loop
8332014-02-28 16:58:04.405937 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@3145728, 524288) -- begin
8342014-02-28 16:58:04.412522 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@3145728, 524288) -> 524288, took 6 ms (699.051Mbps) avg 152 ms
8352014-02-28 16:58:04.412554 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): rbwpos += 512K requested 512K in read
8362014-02-28 16:58:04.412577 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): total read so far: 12582912 bytes
8372014-02-28 16:58:04.412610 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): @ end of read ahead loop
8382014-02-28 16:58:04.422617 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): Avg read interval was 138 msec. 512K -> 512K block size
8392014-02-28 16:58:04.422639 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@3670016, 524288) -- begin
8402014-02-28 16:58:04.429499 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@3670016, 524288) -> 524288, took 6 ms (699.051Mbps) avg 225 ms
8412014-02-28 16:58:04.429534 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): rbwpos += 512K requested 512K in read
8422014-02-28 16:58:04.429563 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): total read so far: 13107200 bytes
8432014-02-28 16:58:04.429581 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): @ end of read ahead loop
8442014-02-28 16:58:04.439342 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@4194304, 524288) -- begin
8452014-02-28 16:58:04.446225 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@4194304, 524288) -> 524288, took 6 ms (699.051Mbps) avg 204 ms
8462014-02-28 16:58:04.446258 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): rbwpos += 512K requested 512K in read
8472014-02-28 16:58:04.446279 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): total read so far: 13631488 bytes
8482014-02-28 16:58:04.446296 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): @ end of read ahead loop
8492014-02-28 16:58:04.455975 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@4718592, 524288) -- begin
8502014-02-28 16:58:04.462947 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@4718592, 524288) -> 524288, took 6 ms (699.051Mbps) avg 185 ms
8512014-02-28 16:58:04.462982 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): rbwpos += 512K requested 512K in read
8522014-02-28 16:58:04.463003 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): total read so far: 14155776 bytes
8532014-02-28 16:58:04.463021 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): @ end of read ahead loop
8542014-02-28 16:58:04.472615 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@5242880, 524288) -- begin
8552014-02-28 16:58:04.479056 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@5242880, 524288) -> 524288, took 6 ms (699.051Mbps) avg 168 ms
8562014-02-28 16:58:04.479088 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): rbwpos += 512K requested 512K in read
8572014-02-28 16:58:04.479106 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): total read so far: 14680064 bytes
8582014-02-28 16:58:04.479124 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): @ end of read ahead loop
8592014-02-28 16:58:04.532611 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@5767168, 524288) -- begin
8602014-02-28 16:58:04.539187 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@5767168, 524288) -> 524288, took 6 ms (699.051Mbps) avg 157 ms
8612014-02-28 16:58:04.539222 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): rbwpos += 512K requested 512K in read
8622014-02-28 16:58:04.539258 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): total read so far: 15204352 bytes
8632014-02-28 16:58:04.539278 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): @ end of read ahead loop
8642014-02-28 16:58:04.592646 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): Avg read interval was 147 msec. 512K -> 512K block size
8652014-02-28 16:58:04.592673 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@6291456, 524288) -- begin
8662014-02-28 16:58:04.599374 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@6291456, 524288) -> 524288, took 6 ms (699.051Mbps) avg 225 ms
8672014-02-28 16:58:04.599406 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): rbwpos += 512K requested 512K in read
8682014-02-28 16:58:04.599433 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): total read so far: 15728640 bytes
8692014-02-28 16:58:04.599451 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): @ end of read ahead loop
8702014-02-28 16:58:04.652622 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@6815744, 524288) -- begin
8712014-02-28 16:58:04.659290 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@6815744, 524288) -> 524288, took 6 ms (699.051Mbps) avg 208 ms
8722014-02-28 16:58:04.659323 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): rbwpos += 512K requested 512K in read
8732014-02-28 16:58:04.659342 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): total read so far: 16252928 bytes
8742014-02-28 16:58:04.659364 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): @ end of read ahead loop
8752014-02-28 16:58:04.712651 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@7340032, 491520) -- begin
8762014-02-28 16:58:04.718880 I  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): safe_read(...@7340032, 491520) -> 491520, took 6 ms (655.36Mbps) avg 193 ms
8772014-02-28 16:58:04.718913 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): rbwpos += 480K requested 480K in read
8782014-02-28 16:58:04.718932 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): total read so far: 16744448 bytes
8792014-02-28 16:58:04.718949 D  RingBuf(myth://192.168.1.254:6543/13111_20140228153001.mpg): @ end of read ahead loop
880Handling Segmentation fault
881Segmentation fault