19:55:27 T:3288  NOTICE: -----------------------------------------------------------------------
19:55:27 T:3288  NOTICE: Starting XBMC (11.0-HD-Audio Git:HD-audio-20120325), Platform: Windows 7, 64-bit (WoW) Service Pack 1 build 7601. Built on Mar 25 2012 (compiler 1600)
19:55:27 T:3288  NOTICE: AMD E-350 Processor
19:55:27 T:3288  NOTICE: Desktop Resolution: 1280x720 32Bit at 50Hz
19:55:27 T:3288  NOTICE: Running with restricted rights
19:55:27 T:3288  NOTICE: Aero is enabled
19:55:27 T:3288  NOTICE: special://xbmc/ is mapped to: C:\Program Files (x86)\XBMC
19:55:27 T:3288  NOTICE: special://xbmcbin/ is mapped to: C:\Program Files (x86)\XBMC
19:55:27 T:3288  NOTICE: special://masterprofile/ is mapped to: C:\Users\Stefan David\AppData\Roaming\XBMC\userdata
19:55:27 T:3288  NOTICE: special://home/ is mapped to: C:\Users\Stefan David\AppData\Roaming\XBMC\
19:55:27 T:3288  NOTICE: special://temp/ is mapped to: C:\Users\Stefan David\AppData\Roaming\XBMC\cache
19:55:27 T:3288  NOTICE: The executable running is: C:\Program Files (x86)\XBMC\XBMC.exe
19:55:27 T:3288  NOTICE: Local hostname: HTPC
19:55:27 T:3288  NOTICE: Log File is located: C:\Users\Stefan David\AppData\Roaming\XBMC\xbmc.log
19:55:27 T:3288  NOTICE: -----------------------------------------------------------------------
19:55:27 T:3288  NOTICE: Setup SDL
19:55:27 T:3288  NOTICE: Found screen: PnP-Monitor (Standard) on AMD Radeon HD 6310 Graphics, adapter 0.
19:55:27 T:3288  NOTICE: Primary mode: 1280x720 @ 50.00 - Full Screen
19:55:27 T:3288  NOTICE: Additional mode: 640x480 @ 60.00 - Full Screen
19:55:27 T:3288  NOTICE: Additional mode: 640x480 @ 59.94 - Full Screen
19:55:27 T:3288  NOTICE: Additional mode: 720x480 @ 59.94 - Full Screen
19:55:27 T:3288  NOTICE: Additional mode: 720x480 @ 60.00 - Full Screen
19:55:27 T:3288  NOTICE: Additional mode: 720x576 @ 50.00 - Full Screen
19:55:27 T:3288  NOTICE: Additional mode: 720x576 @ 60.00 - Full Screen
19:55:27 T:3288  NOTICE: Previous line repeats 2 times.
19:55:27 T:3288  NOTICE: Additional mode: 800x480 @ 60.00 - Full Screen
19:55:27 T:3288  NOTICE: Previous line repeats 2 times.
19:55:27 T:3288  NOTICE: Additional mode: 800x600 @ 60.00 - Full Screen
19:55:27 T:3288  NOTICE: Additional mode: 1024x600 @ 60.00 - Full Screen
19:55:27 T:3288  NOTICE: Previous line repeats 2 times.
19:55:27 T:3288  NOTICE: Additional mode: 1024x768 @ 60.00 - Full Screen
19:55:27 T:3288  NOTICE: Additional mode: 1152x648 @ 50.00 - Full Screen
19:55:27 T:3288  NOTICE: Additional mode: 1280x720 @ 50.00 - Full Screen
19:55:27 T:3288  NOTICE: Additional mode: 1280x720 @ 60.00 - Full Screen
19:55:27 T:3288  NOTICE: Additional mode: 1280x720 @ 59.94 - Full Screen
19:55:27 T:3288  NOTICE: Additional mode: 1280x768 @ 25.00i - Full Screen
19:55:27 T:3288  NOTICE: Previous line repeats 2 times.
19:55:27 T:3288  NOTICE: Additional mode: 1280x1024 @ 25.00i - Full Screen
19:55:27 T:3288  NOTICE: Previous line repeats 2 times.
19:55:27 T:3288  NOTICE: Additional mode: 1400x1050 @ 25.00i - Full Screen
19:55:27 T:3288  NOTICE: Previous line repeats 2 times.
19:55:27 T:3288  NOTICE: Additional mode: 1680x1050 @ 25.00i - Full Screen
19:55:27 T:3288  NOTICE: Previous line repeats 2 times.
19:55:27 T:3288  NOTICE: Additional mode: 1776x1000 @ 25.00i - Full Screen
19:55:27 T:3288  NOTICE: Additional mode: 1920x1080 @ 25.00i - Full Screen
19:55:27 T:3288  NOTICE: load settings...
19:55:27 T:3288  NOTICE: special://profile/ is mapped to: special://masterprofile/
19:55:27 T:3288  NOTICE: loading special://masterprofile/guisettings.xml
19:55:27 T:3288  NOTICE: Getting hardware information now...
19:55:27 T:3288  NOTICE: Checking resolution 12
19:55:27 T:3288  NOTICE: Loading player core factory settings from special://xbmc/system/playercorefactory.xml.
19:55:27 T:3288  NOTICE: Loaded playercorefactory configuration
19:55:27 T:3288  NOTICE: Loading player core factory settings from special://masterprofile/playercorefactory.xml.
19:55:27 T:3288  NOTICE: special://masterprofile/playercorefactory.xml does not exist. Skipping.
19:55:27 T:3288  NOTICE: Loaded settings file from special://xbmc/system/advancedsettings.xml
19:55:27 T:3288  NOTICE: Contents of special://xbmc/system/advancedsettings.xml are...
                                            <advancedsettings>
                                              <!-- Turn on debug logging without any visual signs on XBMC GUI            -->
                                              <!-- This is useful if you are experiencing problems and want to report it -->
                                              <!-- <loglevel>1</loglevel> -->
                                              <audio>
                                                <!-- Fix DTS stutter in MKV patch                    -->
                                                <!--   <enablealtsync> true = enable patch (default) -->
                                                <!--                   false = disable patch         -->
                                                <enablealtsync>true</enablealtsync>
                                              </audio>
                                              <video>
                                                <!-- DXVA Pixel Shader based HQ scalers patch                                          -->
                                                <!--   <preferdxvahqscalers> true = use PS based scaling when scaling set to Automatic -->
                                                <!--                         false = always use DXVA scaling (default)                 -->
                                                <preferdxvahqscalers>true</preferdxvahqscalers>
                                                <!-- Global AV delay patch                    -->
                                                <!-- Delay in msecs, range between -600 - 600 -->
                                                <globalavdelay>
                                                  <!-- Global default AV delay -->
                                                  <!-- <delay>0</delay> -->
                                                  <!-- Override global AV delay for given display refresh rates -->
                                                  <!-- You can specify multiple <refresh> entries               -->
                                                  <!--   <refresh>                                              -->
                                                  <!--     <min>, <max> refresh rate range, OR                  -->
                                                  <!--     <rate> exact refresh rate                            -->
                                                  <!--     <delay> delay                                        -->
                                                  <!--   </refresh>                                             -->
                                                  <!-- Example below: apply -125 msec delay for 24p playback    -->
                                                </globalavdelay>
                                              </video>
                                              <gui>
                                                <algorithmdirtyregions>3</algorithmdirtyregions>
                                                <nofliptimeout>0</nofliptimeout>
                                              </gui>
                                            </advancedsettings>
19:55:27 T:3288  NOTICE: Getting hardware information now...
19:55:27 T:3288  NOTICE: Checking resolution 12
19:55:27 T:3288  NOTICE: Loaded settings file from special://profile/advancedsettings.xml
19:55:27 T:3288  NOTICE: Contents of special://profile/advancedsettings.xml are...
                                            <advancedsettings>
                                              <videodatabase>
                                                <type>mysql</type>
                                                <host>192.168.220.50</host>
                                                <port>3306</port>
                                                <user>xbmc</user>
                                                <pass>xbmc</pass>
                                                <name>xbmc_video</name>
                                              </videodatabase>
                                              <musicdatabase>
                                                <type>mysql</type>
                                                <host>192.168.220.50</host>
                                                <port>3306</port>
                                                <user>xbmc</user>
                                                <pass>xbmc</pass>
                                                <name>xbmc_music</name>
                                              </musicdatabase>
                                              <pathsubstitution>
                                                <substitute>
                                                  <from>special://masterprofile/Thumbnails</from>
                                                  <to>smb://Administrator:*****@192.168.220.50/Thumbnails/</to>
                                                </substitute>
                                              </pathsubstitution>
                                              <musicextensions>
                                                <add>.mp4</add>
                                              </musicextensions>
                                            </advancedsettings>
19:55:27 T:3288 WARNING: VIDEO database configuration is experimental.
19:55:27 T:3288  NOTICE: Getting hardware information now...
19:55:27 T:3288  NOTICE: Checking resolution 12
19:55:27 T:3288  NOTICE: Default DVD Player: dvdplayer
19:55:27 T:3288  NOTICE: Default Video Player: dvdplayer
19:55:27 T:3288  NOTICE: Default Audio Player: paplayer
19:55:27 T:3288  NOTICE: Enabled debug logging due to GUI setting (2)
19:55:27 T:3288  NOTICE: Log level changed to 2
19:55:27 T:3288  NOTICE: Loading media sources from special://masterprofile/sources.xml
19:55:27 T:3288    INFO: creating subdirectories
19:55:27 T:3288    INFO: userdata folder: special://masterprofile/
19:55:27 T:3288    INFO: recording folder:
19:55:27 T:3288    INFO: screenshots folder:
19:55:27 T:3288    INFO: thumbnails folder: special://masterprofile/Thumbnails
19:55:27 T:3288    INFO: load language info file: special://xbmc/language/German/langinfo.xml
19:55:27 T:3288   DEBUG: trying to set locale to deu_deu
19:55:28 T:3288    INFO: global locale set to German_Germany.1252
19:55:28 T:3288    INFO: load language file:special://xbmc/language/German/strings.xml
19:55:28 T:3288   DEBUG: SECTION:LoadDLL(special://xbmcbin/system/cpluff.dll)
19:55:28 T:3288   DEBUG: ADDON: cpluff: 'Plug-in xbmc.json has been installed.'
19:55:28 T:3288   DEBUG: ADDON: cpluff: 'Plug-in metadata.albums.allmusic.com has been installed.'
19:55:28 T:3288   DEBUG: ADDON: cpluff: 'Plug-in webinterface.default has been installed.'
19:55:28 T:3288   DEBUG: ADDON: cpluff: 'Plug-in repository.xbmc.org has been installed.'
19:55:28 T:3288   DEBUG: ADDON: cpluff: 'Plug-in pvr.fortherecord.argus has been installed.'
19:55:28 T:3288   DEBUG: ADDON: cpluff: 'Plug-in screensaver.xbmc.builtin.black has been installed.'
19:55:28 T:3288   DEBUG: ADDON: cpluff: 'Plug-in screensaver.rsxs.euphoria has been installed.'
19:55:28 T:3288   DEBUG: ADDON: cpluff: 'Plug-in pvr.vdr.vnsi has been installed.'
19:55:28 T:3288   DEBUG: ADDON: cpluff: 'Plug-in visualization.projectm has been installed.'
19:55:28 T:3288   DEBUG: ADDON: cpluff: 'Plug-in weather.wunderground has been installed.'
19:55:28 T:3288   DEBUG: ADDON: cpluff: 'Plug-in script.module.simplejson has been installed.'
19:55:28 T:3288   DEBUG: ADDON: cpluff: 'Plug-in screensaver.xbmc.builtin.dim has been installed.'
19:55:28 T:3288   DEBUG: ADDON: cpluff: 'Plug-in metadata.themoviedb.org has been installed.'
19:55:28 T:3288   DEBUG: ADDON: cpluff: 'Plug-in metadata.artists.allmusic.com has been installed.'
19:55:28 T:3288   DEBUG: ADDON: cpluff: 'Plug-in xbmc.metadata has been installed.'
19:55:28 T:3288   DEBUG: ADDON: cpluff: 'Plug-in skin.confluence has been installed.'
19:55:28 T:3288   DEBUG: ADDON: cpluff: 'Plug-in visualization.glspectrum has been installed.'
19:55:28 T:3288   DEBUG: ADDON: cpluff: 'Plug-in xbmc.gui has been installed.'
19:55:28 T:3288   DEBUG: ADDON: cpluff: 'Plug-in visualization.milkdrop has been installed.'
19:55:28 T:3288   DEBUG: ADDON: cpluff: 'Plug-in script.module.pil has been installed.'
19:55:28 T:3288   DEBUG: ADDON: cpluff: 'Plug-in pvr.fortherecord.argus-rtsp has been installed.'
19:55:28 T:3288   DEBUG: ADDON: cpluff: 'Plug-in script.common.plugin.cache has been installed.'
19:55:28 T:3288   DEBUG: ADDON: cpluff: 'Plug-in visualization.dxspectrum has been installed.'
19:55:28 T:3288   DEBUG: ADDON: cpluff: 'Plug-in pvr.mythtv has been installed.'
19:55:28 T:3288   DEBUG: ADDON: cpluff: 'Plug-in script.module.simple.downloader has been installed.'
19:55:28 T:3288   DEBUG: ADDON: cpluff: 'Plug-in xbmc.core has been installed.'
19:55:28 T:3288   DEBUG: ADDON: cpluff: 'Plug-in plugin.video.youtube has been installed.'
19:55:28 T:3288   DEBUG: ADDON: cpluff: 'Plug-in screensaver.xbmc.builtin.slideshow has been installed.'
19:55:28 T:3288   DEBUG: ADDON: cpluff: 'Plug-in pvr.team-mediaportal.tvserver-tsreader has been installed.'
19:55:28 T:3288   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.htbackdrops.com has been installed.'
19:55:28 T:3288   DEBUG: ADDON: cpluff: 'Plug-in pvr.team-mediaportal.tvserver has been installed.'
19:55:28 T:3288   DEBUG: ADDON: cpluff: 'Plug-in service.xbmc-fritzbox has been installed.'
19:55:28 T:3288   DEBUG: ADDON: cpluff: 'Plug-in metadata.yahoomusic.com has been installed.'
19:55:28 T:3288   DEBUG: ADDON: cpluff: 'Plug-in webinterface.awxi has been installed.'
19:55:28 T:3288   DEBUG: ADDON: cpluff: 'Plug-in metadata.tvdb.com has been installed.'
19:55:28 T:3288   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.allmusic.com has been installed.'
19:55:28 T:3288   DEBUG: ADDON: cpluff: 'Plug-in weather.xbmc.builtin has been installed.'
19:55:28 T:3288   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.last.fm has been installed.'
19:55:28 T:3288   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.themoviedb.org has been installed.'
19:55:28 T:3288   DEBUG: ADDON: cpluff: 'Plug-in script.module.parsedom has been installed.'
19:55:28 T:3288   DEBUG: ADDON: cpluff: 'Plug-in xbmc.python has been installed.'
19:55:28 T:3288   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.imdb.com has been installed.'
19:55:28 T:3288   DEBUG: ADDON: cpluff: 'Plug-in xbmc.addon has been installed.'
19:55:28 T:3288   DEBUG: ADDON: cpluff: 'Plug-in visualization.waveform has been installed.'
19:55:28 T:3288   DEBUG: ADDON: cpluff: 'Plug-in screensaver.rsxs.plasma has been installed.'
19:55:28 T:3288   DEBUG: ADDON: cpluff: 'Plug-in pvr.hts has been installed.'
19:55:28 T:3288   DEBUG: ADDON: cpluff: 'Plug-in script.module.pysqlite has been installed.'
19:55:28 T:3288   DEBUG: ADDON: cpluff: 'Plug-in visualization.itunes has been installed.'
19:55:28 T:3288   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.hdtrailers.net has been installed.'
19:55:28 T:3288   DEBUG: ADDON: cpluff: 'Not all directories were successfully scanned.'
19:55:28 T:3288   DEBUG: PERIPHERALS::CPeripherals::LoadMappings - loaded node "Motorola Nyxboard Hybrid"
19:55:28 T:3288   DEBUG: PERIPHERALS::CPeripherals::LoadMappings - loaded node "Pulse-Eight CEC Adaptor"
19:55:28 T:3248   DEBUG: Thread XBMC Peripherals start, auto delete: 0
19:55:28 T:2388   DEBUG: Thread CRemoteControl start, auto delete: 0
19:55:28 T:2388   DEBUG: CRemoteControl::Connect - connecting to: ::1:24000 ...
19:55:28 T:3288   DEBUG: CWinEventsWin32::WndProc: window resize event
19:55:28 T:3288   DEBUG: CWinEventsWin32::WndProc: window move event
19:55:28 T:3288   DEBUG: CWinSystemWin32::ResizeInternal - resizing due to size change (0,0,1280,720 fullscreen)->(0,0,1280,720 fullscreen)
19:55:28 T:3288   DEBUG: CWinEventsWin32::WndProcWindow is active
19:55:28 T:3288   DEBUG: CRenderSystemDX::InitRenderSystem - trying D3D9Ex...
19:55:28 T:3288   DEBUG: CRenderSystemDX::InitRenderSystem - using D3D9Ex
19:55:28 T:3288   DEBUG: CRenderSystemDX::CreateDevice on adapter 0
19:55:28 T:3288   DEBUG: CRenderSystemDX::CreateDevice - using hardware vertex processing
19:55:28 T:3288   DEBUG: CRenderSystemDX::CreateDevice - adapter 0: aticfx32.dll, AMD Radeon HD 6310 Graphics, VendorId 4098, DeviceId 38914
19:55:28 T:3288   DEBUG: CRenderSystemDX::CreateDevice - using D3DCAPS2_DYNAMICTEXTURES
19:55:28 T:3288   DEBUG: CRenderSystemDX::CreateDevice - texture caps: 0x0001EC45
19:55:28 T:3288   DEBUG: CRenderSystemDX::CreateDevice - RENDER_CAPS_DXT
19:55:28 T:3288   DEBUG: CRenderSystemDX::CreateDevice - RENDER_CAPS_NPOT
19:55:28 T:3288   DEBUG: CRenderSystemDX::CreateDevice - RENDER_CAPS_DXT_NPOT
19:55:28 T:3288   DEBUG: CWinSystemWin32::SetFullScreen (windowed fullscreen) on screen 0 with size 1280x720, refresh 50.000000
19:55:28 T:3288   DEBUG: CRenderManager::UpdateDisplayLatency - Latency set to 0 msec
19:55:28 T:3288    INFO: load default splash image: C:\Program Files (x86)\XBMC\media\Splash.png
19:55:28 T:3288   DEBUG: SECTION:LoadDLL(special://xbmcbin/system/ImageLib.dll)
19:55:28 T:3288    INFO: load keymapping
19:55:28 T:3288    INFO: Loading special://xbmc/system/keymaps/appcommand.xml
19:55:28 T:3288    INFO: Loading special://xbmc/system/keymaps/gamepad.xml
19:55:28 T:3288    INFO: Loading special://xbmc/system/keymaps/joystick.Alienware.Dual.Compatible.Controller.xml
19:55:28 T:3288    INFO: Loading special://xbmc/system/keymaps/joystick.AppleRemote.xml
19:55:28 T:3288    INFO: Loading special://xbmc/system/keymaps/joystick.Harmony.xml
19:55:28 T:3288    INFO: Loading special://xbmc/system/keymaps/joystick.Interact.AxisPad.xml
19:55:28 T:3288    INFO: Loading special://xbmc/system/keymaps/joystick.Logitech.RumblePad.2.xml
19:55:28 T:3288    INFO: Loading special://xbmc/system/keymaps/joystick.Microsoft.Xbox.360.Controller.xml
19:55:28 T:3288    INFO: Loading special://xbmc/system/keymaps/joystick.Microsoft.Xbox.Controller.S.xml
19:55:28 T:3288    INFO: Loading special://xbmc/system/keymaps/joystick.PS3.Remote.Keyboard.xml
19:55:28 T:3288    INFO: Loading special://xbmc/system/keymaps/joystick.WiiRemote.xml
19:55:28 T:3288    INFO: Loading special://xbmc/system/keymaps/keyboard.nyxboard.xml
19:55:28 T:3288    INFO: Loading special://xbmc/system/keymaps/keyboard.xml
19:55:28 T:3288    INFO: Loading special://xbmc/system/keymaps/mouse.xml
19:55:28 T:3288    INFO: Loading special://xbmc/system/keymaps/remote.xml
19:55:28 T:3288    INFO: Loading special://masterprofile/keymaps/keyboard.xml
19:55:29 T:3288    INFO: Loading special://profile/keymaps/keyboard.xml
19:55:29 T:3288    INFO: Loading special://xbmc/system/IRSSmap.xml
19:55:29 T:3288    INFO: * Adding remote mapping for device 'Microsoft MCE'
19:55:29 T:3288    INFO: * Adding remote mapping for device 'Abstract'
19:55:29 T:3288   DEBUG: CButtonTranslator::Load - no userdata IRSSmap.xml found, skipping
19:55:29 T:3288    INFO: GUI format 1280x720 1280x720 @ 50.00 - Full Screen
19:55:29 T:3288   DEBUG: guilib: Fill viewport on change for solving rendering passes
19:55:29 T:3288   DEBUG: SECTION:LoadDLL(special://xbmcbin/system/libcurl.dll)
19:55:29 T:2388   DEBUG: CRemoteControl::Connect - connecting to: 127.0.0.1:24000 ...
19:55:30 T:2388   ERROR: CRemoteControl::Connect - failed to connect
19:55:30 T:2388    INFO: CRemoteControl::Process - failed to connect to irss, will keep retrying every 5 seconds
19:55:31 T:3288  NOTICE: initializing playlistplayer
19:55:31 T:3288  NOTICE: DONE initializing playlistplayer
19:55:31 T:3288   DEBUG: DPMS: supported power-saving modes: OFF STANDBY
19:55:31 T:3288    INFO: Unloading old skin ...
19:55:31 T:3288    INFO:   load skin from:C:\Program Files (x86)\XBMC\addons\skin.confluence
19:55:31 T:3288    INFO:   load fonts for skin...
19:55:31 T:3288    INFO: Loading fonts from C:\Program Files (x86)\XBMC\addons\skin.confluence\720p\Font.xml
19:55:31 T:3288    INFO: Loading skin includes from C:\Program Files (x86)\XBMC\addons\skin.confluence\720p\includes.xml
19:55:31 T:3288    INFO:   load new skin...
19:55:31 T:3288    INFO: Loading skin file: Home.xml
19:55:31 T:3288    INFO: Loading user windows, path C:\Program Files (x86)\XBMC\addons\skin.confluence\720p
19:55:31 T:3288   DEBUG: Load Skin XML: 100.33ms
19:55:31 T:3288    INFO:   initialize new skin...
19:55:31 T:3288   DEBUG: guilib: Fill viewport on change for solving rendering passes
19:55:31 T:3288    INFO: Loading skin file: Pointer.xml
19:55:31 T:3288    INFO: Loading skin file: DialogVolumeBar.xml
19:55:31 T:3288    INFO: Loading skin file: DialogKaiToast.xml
19:55:31 T:3288    INFO: Loading skin file: DialogMuteBug.xml
19:55:31 T:3288    INFO: Loading skin file: DialogSeekBar.xml
19:55:31 T:3288    INFO: Loading skin file: DialogBusy.xml
19:55:31 T:3288   DEBUG: CGUIAudioManager::Initialize
19:55:31 T:3288   DEBUG: CAudioContext::SetActiveDevice - SetActiveDevice from 1 to 2
19:55:31 T:3288   DEBUG: CAudioContext::RemoveActiveDevice - Removing device 1
19:55:31 T:3288   DEBUG: CWDSound::direct_sound_enumerator_member_callback - found Device: Prim�rer Soundtreiber
19:55:31 T:3288   DEBUG: CWDSound::direct_sound_enumerator_member_callback - found Device: AMD HDMI Output (2- AMD High Definition Audio Device)
19:55:31 T:3288   DEBUG: CAudioContext::SetActiveDevice - selecting AMD HDMI Output (2- AMD High Definition Audio Device) as output devices
19:55:31 T:3288    INFO: Loading C:\Program Files (x86)\XBMC\addons\skin.confluence\sounds\sounds.xml
19:55:31 T:3288    INFO:   skin loaded...
19:55:31 T:3288    INFO: JSONRPC: Sucessfully initialized
19:55:31 T:3288   DEBUG: ADDON: Starting service addons.
19:55:31 T:3288    INFO: initializing python engine.
19:55:31 T:3288   DEBUG: new python thread created. id=1
19:55:31 T:3288   DEBUG: Activating window ID: 12999
19:55:31 T:3288   DEBUG: ------ Window Init (Startup.xml) ------
19:55:31 T:3288    INFO: Loading skin file: Startup.xml
19:55:31 T:4052   DEBUG: Thread XBPyThread start, auto delete: 0
19:55:31 T:4052   DEBUG: Python thread: start processing
19:55:31 T:3288    INFO: removing tempfiles
19:55:31 T:3288   DEBUG: ADDON: Starting service addons.
19:55:31 T:3288    INFO: initializing python engine.
19:55:31 T:3288   DEBUG: new python thread created. id=2
19:55:31 T:3288  NOTICE: initialize done
19:55:31 T:3288  NOTICE: Running the application...
19:55:31 T:3288   DEBUG: CApplication::ExecuteXBMCAction : Translating ReplaceWindow(Home)
19:55:31 T:3288   DEBUG: CApplication::ExecuteXBMCAction : To ReplaceWindow(Home)
19:55:31 T:3288   DEBUG: Activating window ID: 10000
19:55:31 T:3288   DEBUG: CTextureBundleXBT::OpenBundle - Opened bundle C:\Program Files (x86)\XBMC\addons\skin.confluence\media\Textures.xbt
19:55:31 T:3288   DEBUG: ------ Window Init () ------
19:55:31 T:2696   DEBUG: Thread Jobworker start, auto delete: 1
19:55:31 T:1364   DEBUG: Thread XBPyThread start, auto delete: 0
19:55:31 T:1364   DEBUG: Python thread: start processing
19:55:31 T:3288   DEBUG: ------ Window Init (Pointer.xml) ------
19:55:31 T:3288   DEBUG: ------ Window Deinit (Startup.xml) ------
19:55:31 T:3288   DEBUG: ------ Window Init (Home.xml) ------
19:55:32 T:3288   DEBUG: XBPython::Process - no profile autoexec.py (C:\Users\Stefan David\AppData\Roaming\XBMC\userdata\autoexec.py) found, skipping
19:55:32 T:3288   DEBUG: CNetwork::NetworkMessage - Starting network services
19:55:32 T:3288  NOTICE: Webserver: Starting...
19:55:32 T:3288  NOTICE: WebServer: Started the webserver
19:55:32 T:3288  NOTICE: ES: Starting event server
19:55:32 T:3288    INFO: JSONRPC Server: Unable to get bluetooth socket
19:55:32 T:3288    INFO: JSONRPC Server: Successfully initialized
19:55:32 T:3288   DEBUG: CLastfmScrobbler: Clearing session.
19:55:32 T:3288   DEBUG: CLibrefmScrobbler: Clearing session.
19:55:32 T:3412   DEBUG: Thread JSONRPC::CTCPServer start, auto delete: 0
19:55:32 T:2772   DEBUG: Thread Jobworker start, auto delete: 1
19:55:32 T:2284   DEBUG: Thread CEventServer start, auto delete: 0
19:55:32 T:2284  NOTICE: ES: Starting UDP Event server on 0.0.0.0:9777
19:55:32 T:2284  NOTICE: UDP: Listening on port 9777
19:55:32 T:3844   DEBUG: Thread CRssReader start, auto delete: 0
19:55:32 T:3844   DEBUG: FileCurl::Open(0B7DFA44) http://feeds.feedburner.com/xbmc
19:55:32 T:3844    INFO: XCURL::DllLibCurlGlobal::easy_aquire - Created session to http://feeds.feedburner.com
19:55:32 T:2696   DEBUG: CImageLoader::DoWork - took 623 ms to load special://skin/backgrounds/videos.jpg
19:55:32 T:2772   DEBUG: CRecentlyAddedJob::UpdateMusic() - Running RecentlyAdded home screen update
19:55:32 T:4052  NOTICE: -->Python Interpreter Initialized<--
19:55:32 T:4052   DEBUG: XBPyThread::Process - The source file to load is C:\Users\Stefan David\AppData\Roaming\XBMC\addons\script.module.simple.downloader\default.py
19:55:32 T:1364  NOTICE: -->Python Interpreter Initialized<--
19:55:32 T:1364   DEBUG: XBPyThread::Process - The source file to load is C:\Users\Stefan David\AppData\Roaming\XBMC\addons\script.common.plugin.cache\default.py
19:55:32 T:4052   DEBUG: XBPyThread::Process - Setting the Python path to C:\Users\Stefan David\AppData\Roaming\XBMC\addons\script.module.simple.downloader;C:\Users\Stefan David\AppData\Roaming\XBMC\addons\script.module.simplejson\lib;C:\Program Files (x86)\XBMC\addons\script.module.pil\lib;C:\Users\Stefan David\AppData\Roaming\XBMC\addons\script.common.plugin.cache\lib;C:\Users\Stefan David\AppData\Roaming\XBMC\addons\script.module.simple.downloader\lib;C:\Users\Stefan David\AppData\Roaming\XBMC\addons\script.module.parsedom\lib;C:\Program Files (x86)\XBMC\addons\script.module.pysqlite\lib;C:\Program Files (x86)\XBMC\system\python\DLLs;C:\Program Files (x86)\XBMC\system\python\Lib;C:\Program Files (x86)\XBMC\python26.zip;C:\Program Files (x86)\XBMC\system\python\lib\plat-win;C:\Program Files (x86)\XBMC\system\python\lib\lib-tk;C:\Program Files (x86)\XBMC;C:\Program Files (x86)\XBMC\system\python;C:\Program Files (x86)\XBMC\system\python\lib\site-packages;
19:55:32 T:4052   DEBUG: XBPyThread::Process - Entering source directory C:\Users\Stefan David\AppData\Roaming\XBMC\addons\script.module.simple.downloader
19:55:32 T:1364   DEBUG: XBPyThread::Process - Setting the Python path to C:\Users\Stefan David\AppData\Roaming\XBMC\addons\script.common.plugin.cache;C:\Users\Stefan David\AppData\Roaming\XBMC\addons\script.module.simplejson\lib;C:\Program Files (x86)\XBMC\addons\script.module.pil\lib;C:\Users\Stefan David\AppData\Roaming\XBMC\addons\script.common.plugin.cache\lib;C:\Users\Stefan David\AppData\Roaming\XBMC\addons\script.module.simple.downloader\lib;C:\Users\Stefan David\AppData\Roaming\XBMC\addons\script.module.parsedom\lib;C:\Program Files (x86)\XBMC\addons\script.module.pysqlite\lib;C:\Program Files (x86)\XBMC\system\python\DLLs;C:\Program Files (x86)\XBMC\system\python\Lib;C:\Program Files (x86)\XBMC\python26.zip;C:\Program Files (x86)\XBMC\system\python\lib\plat-win;C:\Program Files (x86)\XBMC\system\python\lib\lib-tk;C:\Program Files (x86)\XBMC;C:\Program Files (x86)\XBMC\system\python;C:\Program Files (x86)\XBMC\system\python\lib\site-packages;
19:55:32 T:1364   DEBUG: XBPyThread::Process - Entering source directory C:\Users\Stefan David\AppData\Roaming\XBMC\addons\script.common.plugin.cache
19:55:32 T:4052   DEBUG: Instantiating addon using automatically obtained id of "script.module.simple.downloader" dependent on version 2.0 of the xbmc.python api
19:55:32 T:2772   DEBUG: GetRecentlyAddedAlbumSongs() query: SELECT songview.* FROM (SELECT idAlbum FROM albumview ORDER BY idAlbum DESC LIMIT 10) AS recentalbums JOIN songview ON songview.idAlbum=recentalbums.idAlbum
19:55:32 T:1364   DEBUG: Instantiating addon using automatically obtained id of "script.common.plugin.cache" dependent on version 2.0 of the xbmc.python api
19:55:32 T:3844   DEBUG: Got rss feed: http://feeds.feedburner.com/xbmc
19:55:32 T:3844   DEBUG: RSS feed encoding: UTF-8
19:55:32 T:3844   DEBUG: Parsed rss feed: http://feeds.feedburner.com/xbmc
19:55:32 T:3844   DEBUG: Thread CRssReader 3844 terminating
19:55:32 T:3288   DEBUG: SDLKeyboard: scancode: 4d, sym: 0113, unicode: 0000, modifier: 0
19:55:32 T:3288   DEBUG: CApplication::OnKey: right (f083) pressed, action is Right
19:55:32 T:2696   DEBUG: CImageLoader::DoWork - took 506 ms to load special://skin/backgrounds/videos.jpg
19:55:32 T:2696    INFO: WEATHER: Downloading weather
19:55:32 T:2696    INFO: initializing python engine.
19:55:32 T:2696   DEBUG: new python thread created. id=3
19:55:32 T:3676   DEBUG: Thread XBPyThread start, auto delete: 0
19:55:32 T:3676   DEBUG: Python thread: start processing
19:55:33 T:3288   DEBUG: ------ Window Deinit (Pointer.xml) ------
19:55:33 T:2772   DEBUG: CMusicDatabase::GetRecentlyAddedAlbums query: select * from albumview order by idAlbum desc limit 10
19:55:33 T:4052    INFO: Scriptresult: Success
19:55:33 T:4052    INFO: Python script stopped
19:55:33 T:4052   DEBUG: Thread XBPyThread 4052 terminating
19:55:33 T:3288   DEBUG: waiting for python thread 1 to stop
19:55:33 T:3288   DEBUG: python thread 1 destructed
19:55:33 T:2772   DEBUG: CRecentlyAddedJob::UpdateVideos() - Running RecentlyAdded home screen update
19:55:33 T:1364  NOTICE:  StorageServer Module loaded RUN
19:55:33 T:1364  NOTICE: StorageClient-1.0.0 Starting server
19:55:33 T:1364  NOTICE: StorageServer-1.0.0 Storage Server starting C:\Users\Stefan David\AppData\Roaming\XBMC\userdata\Database\commoncache.db
19:55:33 T:2772   DEBUG: CVideoDatabase::RunQuery took 274 ms for 10 items query: select * from movieview  order by idMovie desc limit 10
19:55:33 T:2772   DEBUG: CVideoDatabase::RunQuery took 1 ms for 10 items query: select * from episodeview order by idEpisode desc limit 10
19:55:33 T:3288   DEBUG: SDLKeyboard: scancode: 4d, sym: 0113, unicode: 0000, modifier: 0
19:55:33 T:3288   DEBUG: CApplication::OnKey: right (f083) pressed, action is Right
19:55:33 T:2016   DEBUG: Thread Jobworker start, auto delete: 1
19:55:33 T:3676  NOTICE: -->Python Interpreter Initialized<--
19:55:33 T:3676   DEBUG: XBPyThread::Process - The source file to load is C:\Program Files (x86)\XBMC\addons\weather.wunderground\default.py
19:55:33 T:3676   DEBUG: XBPyThread::Process - Setting the Python path to C:\Program Files (x86)\XBMC\addons\weather.wunderground;C:\Users\Stefan David\AppData\Roaming\XBMC\addons\script.module.simplejson\lib;C:\Program Files (x86)\XBMC\addons\script.module.pil\lib;C:\Users\Stefan David\AppData\Roaming\XBMC\addons\script.common.plugin.cache\lib;C:\Users\Stefan David\AppData\Roaming\XBMC\addons\script.module.simple.downloader\lib;C:\Users\Stefan David\AppData\Roaming\XBMC\addons\script.module.parsedom\lib;C:\Program Files (x86)\XBMC\addons\script.module.pysqlite\lib;C:\Program Files (x86)\XBMC\system\python\DLLs;C:\Program Files (x86)\XBMC\system\python\Lib;C:\Program Files (x86)\XBMC\python26.zip;C:\Program Files (x86)\XBMC\system\python\lib\plat-win;C:\Program Files (x86)\XBMC\system\python\lib\lib-tk;C:\Program Files (x86)\XBMC;C:\Program Files (x86)\XBMC\system\python;C:\Program Files (x86)\XBMC\system\python\lib\site-packages;
19:55:33 T:3676   DEBUG: XBPyThread::Process - Entering source directory C:\Program Files (x86)\XBMC\addons\weather.wunderground
19:55:33 T:3676   DEBUG: Instantiating addon using automatically obtained id of "weather.wunderground" dependent on version 2.0 of the xbmc.python api
19:55:34 T:2016   DEBUG: CImageLoader::DoWork - took 426 ms to load special://skin/backgrounds/music.jpg
19:55:34 T:3288   DEBUG: SDLKeyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0
19:55:34 T:3288   DEBUG: CApplication::OnKey: down (f081) pressed, action is Down
19:55:34 T:3288   DEBUG: SDLKeyboard: scancode: 4d, sym: 0113, unicode: 0000, modifier: 0
19:55:34 T:3288   DEBUG: CApplication::OnKey: right (f083) pressed, action is Right
19:55:34 T:3288   DEBUG: SDLKeyboard: scancode: 4d, sym: 0113, unicode: 0000, modifier: 0
19:55:34 T:3288   DEBUG: CApplication::OnKey: right (f083) pressed, action is Right
19:55:35 T:3288   DEBUG: SDLKeyboard: scancode: 4d, sym: 0113, unicode: 0000, modifier: 0
19:55:35 T:3288   DEBUG: CApplication::OnKey: right (f083) pressed, action is Right
19:55:35 T:2772   DEBUG: CVideoDatabase::GetMusicVideosByWhere query = select * from musicvideoview order by idMVideo desc limit 10
19:55:35 T:2772   DEBUG: CVideoDatabase::GetMusicVideosByWhere time for actual SQL query = 5
19:55:35 T:2772   DEBUG: CRecentlyAddedJob::UpdateTotal() - Running RecentlyAdded home screen update
19:55:35 T:3288   DEBUG: SDLKeyboard: scancode: 1c, sym: 000d, unicode: 000d, modifier: 0
19:55:35 T:3288   DEBUG: CApplication::OnKey: return (f00d) pressed, action is Select
19:55:35 T:3288   DEBUG: CApplication::ExecuteXBMCAction : Translating ActivateWindow(MusicFiles)
19:55:35 T:3288   DEBUG: CApplication::ExecuteXBMCAction : To ActivateWindow(MusicFiles)
19:55:35 T:3288   DEBUG: Activating window ID: 10501
19:55:35 T:3288   DEBUG: ------ Window Deinit (Home.xml) ------
19:55:36 T:3288   DEBUG: ------ Window Init (MyMusicSongs.xml) ------
19:55:36 T:3288    INFO: Loading skin file: MyMusicSongs.xml
19:55:36 T:3288   DEBUG: CGUIMediaWindow::GetDirectory ()
19:55:36 T:3288   DEBUG:   ParentPath = []
19:55:36 T:3288   DEBUG: RetrieveMusicInfo() took 0 msec
19:55:36 T:3452   DEBUG: Thread Background Loader start, auto delete: 0
19:55:36 T:3452   DEBUG: Thread Background Loader 3452 terminating
19:55:36 T:3944   DEBUG: Thread Background Loader start, auto delete: 0
19:55:36 T:3944   DEBUG: Thread Background Loader 3944 terminating
19:55:36 T:3288   DEBUG: SDLKeyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0
19:55:36 T:3288   DEBUG: CApplication::OnKey: down (f081) pressed, action is Down
19:55:36 T:3288   DEBUG: SDLKeyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0
19:55:36 T:3288   DEBUG: CApplication::OnKey: down (f081) pressed, action is Down
19:55:37 T:3288   DEBUG: SDLKeyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0
19:55:37 T:3288   DEBUG: CApplication::OnKey: down (f081) pressed, action is Down
19:55:37 T:3288   DEBUG: SDLKeyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0
19:55:37 T:3288   DEBUG: CApplication::OnKey: down (f081) pressed, action is Down
19:55:37 T:3676    INFO: Scriptresult: Success
19:55:37 T:3676    INFO: Python script stopped
19:55:37 T:3676   DEBUG: Thread XBPyThread 3676 terminating
19:55:37 T:2696   DEBUG: CZipManager::GetZipList - Processing zip://special%3a%2f%2fxbmc%2fmedia%2fweather%2ezip/
19:55:37 T:3288   DEBUG: waiting for python thread 3 to stop
19:55:37 T:3288   DEBUG: python thread 3 destructed
19:55:37 T:3288   DEBUG: SDLKeyboard: scancode: 1c, sym: 000d, unicode: 000d, modifier: 0
19:55:37 T:3288   DEBUG: CApplication::OnKey: return (f00d) pressed, action is Select
19:55:37 T:3288   DEBUG: CGUIMediaWindow::GetDirectory (smb://WHS2011/Elements_500/)
19:55:37 T:3288   DEBUG:   ParentPath = []
19:55:37 T:3288   DEBUG: RetrieveMusicInfo() took 0 msec
19:55:37 T:3384   DEBUG: Thread Background Loader start, auto delete: 0
19:55:38 T:3384   DEBUG: Thread Background Loader 3384 terminating
19:55:38 T:3288   DEBUG: SDLKeyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0
19:55:38 T:3288   DEBUG: CApplication::OnKey: down (f081) pressed, action is Down
19:55:38 T:3288   DEBUG: SDLKeyboard: scancode: 48, sym: 0111, unicode: 0000, modifier: 0
19:55:38 T:3288   DEBUG: CApplication::OnKey: up (f080) pressed, action is Up
19:55:39 T:3288   DEBUG: SDLKeyboard: scancode: 1c, sym: 000d, unicode: 000d, modifier: 0
19:55:39 T:3288   DEBUG: CApplication::OnKey: return (f00d) pressed, action is Select
19:55:39 T:3288   DEBUG: CGUIMediaWindow::GetDirectory (smb://WHS2011/Elements_500/Audio Tests/)
19:55:39 T:3288   DEBUG:   ParentPath = [smb://WHS2011/Elements_500/]
19:55:39 T:1068   DEBUG: Thread Background Loader start, auto delete: 0
19:55:39 T:1068    INFO: Creating album thumb from memory: special://masterprofile/Thumbnails/Music/b/b57eaf00.tbn
19:55:39 T:1068    INFO: Creating album thumb from memory: special://masterprofile/Thumbnails/Music/e/e23ddac4.tbn
19:55:39 T:1068   DEBUG: CFileCache::Open - opening <Elements_500/Audio Tests/DTS-CD 6.1 Rip.wav> using cache
19:55:39 T:3916   DEBUG: Thread XFILE::CFileCache start, auto delete: 0
19:55:39 T:1068    INFO: WAVCodec::Init - Sample Rate: 44100, Bits Per Sample: 16, Channels: 2
19:55:39 T:1068    INFO: WAVCodec::Init - WAVE_FORMAT_PCM detected
19:55:39 T:3916   DEBUG: XFILE::CFileCache::Process, request seek on source to 188748044
19:55:39 T:3916    INFO: CFileCache::Process - Hit eof.
19:55:39 T:3916   DEBUG: XFILE::CFileCache::Process, request seek on source to 44
19:55:39 T:3916   DEBUG: Thread XFILE::CFileCache 3916 terminating
19:55:39 T:1068   DEBUG: CFileCache::Open - opening <Elements_500/Audio Tests/DTS-CD 6.1 Rip_BC.wav> using cache
19:55:39 T:3604   DEBUG: Thread XFILE::CFileCache start, auto delete: 0
19:55:39 T:1068    INFO: WAVCodec::Init - Sample Rate: 44100, Bits Per Sample: 24, Channels: 1
19:55:39 T:1068    INFO: WAVCodec::Init - WAVE_FORMAT_PCM detected
19:55:39 T:3604   DEBUG: XFILE::CFileCache::Process, request seek on source to 141557804
19:55:39 T:3604    INFO: CFileCache::Process - Hit eof.
19:55:39 T:3604   DEBUG: XFILE::CFileCache::Process, request seek on source to 44
19:55:39 T:3604   DEBUG: Thread XFILE::CFileCache 3604 terminating
19:55:39 T:1068   DEBUG: CFileCache::Open - opening <Elements_500/Audio Tests/DTS-CD 6.1 Rip_BL.wav> using cache
19:55:39 T:1048   DEBUG: Thread XFILE::CFileCache start, auto delete: 0
19:55:39 T:1068    INFO: WAVCodec::Init - Sample Rate: 44100, Bits Per Sample: 24, Channels: 1
19:55:39 T:1068    INFO: WAVCodec::Init - WAVE_FORMAT_PCM detected
19:55:39 T:1048   DEBUG: XFILE::CFileCache::Process, request seek on source to 141557804
19:55:39 T:1048    INFO: CFileCache::Process - Hit eof.
19:55:39 T:1048   DEBUG: XFILE::CFileCache::Process, request seek on source to 44
19:55:39 T:1048   DEBUG: Thread XFILE::CFileCache 1048 terminating
19:55:39 T:1068   DEBUG: CFileCache::Open - opening <Elements_500/Audio Tests/DTS-CD 6.1 Rip_BR.wav> using cache
19:55:39 T:3600   DEBUG: Thread XFILE::CFileCache start, auto delete: 0
19:55:39 T:1068    INFO: WAVCodec::Init - Sample Rate: 44100, Bits Per Sample: 24, Channels: 1
19:55:39 T:1068    INFO: WAVCodec::Init - WAVE_FORMAT_PCM detected
19:55:39 T:3600   DEBUG: XFILE::CFileCache::Process, request seek on source to 141557804
19:55:39 T:3600    INFO: CFileCache::Process - Hit eof.
19:55:39 T:3600   DEBUG: XFILE::CFileCache::Process, request seek on source to 44
19:55:39 T:3600   DEBUG: Thread XFILE::CFileCache 3600 terminating
19:55:39 T:1068   DEBUG: CFileCache::Open - opening <Elements_500/Audio Tests/DTS-CD 6.1 Rip_Cs2.wav> using cache
19:55:39 T:1352   DEBUG: Thread XFILE::CFileCache start, auto delete: 0
19:55:39 T:1068    INFO: WAVCodec::Init - Sample Rate: 44100, Bits Per Sample: 24, Channels: 1
19:55:39 T:1068    INFO: WAVCodec::Init - WAVE_FORMAT_PCM detected
19:55:39 T:1352   DEBUG: XFILE::CFileCache::Process, request seek on source to 141557804
19:55:39 T:1352    INFO: CFileCache::Process - Hit eof.
19:55:39 T:1352   DEBUG: XFILE::CFileCache::Process, request seek on source to 44
19:55:39 T:1352   DEBUG: Thread XFILE::CFileCache 1352 terminating
19:55:39 T:1068   DEBUG: CFileCache::Open - opening <Elements_500/Audio Tests/DTS-CD 6.1 Rip_FC.wav> using cache
19:55:39 T:1984   DEBUG: Thread XFILE::CFileCache start, auto delete: 0
19:55:39 T:1068    INFO: WAVCodec::Init - Sample Rate: 44100, Bits Per Sample: 24, Channels: 1
19:55:39 T:1068    INFO: WAVCodec::Init - WAVE_FORMAT_PCM detected
19:55:39 T:1984   DEBUG: XFILE::CFileCache::Process, request seek on source to 141557804
19:55:39 T:1984    INFO: CFileCache::Process - Hit eof.
19:55:39 T:1984   DEBUG: XFILE::CFileCache::Process, request seek on source to 44
19:55:39 T:1984   DEBUG: Thread XFILE::CFileCache 1984 terminating
19:55:39 T:1068   DEBUG: CFileCache::Open - opening <Elements_500/Audio Tests/DTS-CD 6.1 Rip_FL.wav> using cache
19:55:39 T:2312   DEBUG: Thread XFILE::CFileCache start, auto delete: 0
19:55:39 T:1068    INFO: WAVCodec::Init - Sample Rate: 44100, Bits Per Sample: 24, Channels: 1
19:55:39 T:1068    INFO: WAVCodec::Init - WAVE_FORMAT_PCM detected
19:55:39 T:2312   DEBUG: XFILE::CFileCache::Process, request seek on source to 141557804
19:55:39 T:2312    INFO: CFileCache::Process - Hit eof.
19:55:39 T:2312   DEBUG: XFILE::CFileCache::Process, request seek on source to 44
19:55:39 T:2312   DEBUG: Thread XFILE::CFileCache 2312 terminating
19:55:39 T:1068   DEBUG: CFileCache::Open - opening <Elements_500/Audio Tests/DTS-CD 6.1 Rip_FR.wav> using cache
19:55:39 T:4004   DEBUG: Thread XFILE::CFileCache start, auto delete: 0
19:55:39 T:1068    INFO: WAVCodec::Init - Sample Rate: 44100, Bits Per Sample: 24, Channels: 1
19:55:39 T:1068    INFO: WAVCodec::Init - WAVE_FORMAT_PCM detected
19:55:39 T:4004   DEBUG: XFILE::CFileCache::Process, request seek on source to 141557804
19:55:39 T:4004    INFO: CFileCache::Process - Hit eof.
19:55:39 T:4004   DEBUG: XFILE::CFileCache::Process, request seek on source to 44
19:55:39 T:4004   DEBUG: Thread XFILE::CFileCache 4004 terminating
19:55:39 T:1068   DEBUG: CFileCache::Open - opening <Elements_500/Audio Tests/DTS-CD 6.1 Rip_LF.wav> using cache
19:55:39 T:3992   DEBUG: Thread XFILE::CFileCache start, auto delete: 0
19:55:39 T:1068    INFO: WAVCodec::Init - Sample Rate: 44100, Bits Per Sample: 24, Channels: 1
19:55:39 T:1068    INFO: WAVCodec::Init - WAVE_FORMAT_PCM detected
19:55:39 T:3992   DEBUG: XFILE::CFileCache::Process, request seek on source to 141557804
19:55:39 T:3992    INFO: CFileCache::Process - Hit eof.
19:55:39 T:3992   DEBUG: XFILE::CFileCache::Process, request seek on source to 44
19:55:39 T:3992   DEBUG: Thread XFILE::CFileCache 3992 terminating
19:55:40 T:1068    INFO: Creating album thumb from memory: special://masterprofile/Thumbnails/Music/f/f3df24de.tbn
19:55:40 T:1068    INFO: Creating album thumb from memory: special://masterprofile/Thumbnails/Music/c/c9ed824b.tbn
19:55:40 T:1068   DEBUG: Saving fileitems [smb://WHS2011/Elements_500/Audio Tests/]
19:55:40 T:1068   DEBUG:   -- items: 48, sort method: 0, ascending: false
19:55:40 T:1068   DEBUG: Thread Background Loader 1068 terminating
19:55:40 T:3288   DEBUG: RetrieveMusicInfo() took 1198 msec
19:55:40 T:3380   DEBUG: Thread Background Loader start, auto delete: 0
19:55:41 T:2672   DEBUG: Previous line repeats 4 times.
19:55:41 T:2672   DEBUG: Thread Background Loader 2672 terminating
19:55:41 T:3076   DEBUG: Thread Background Loader 3076 terminating
19:55:41 T:3892   DEBUG: Thread Background Loader 3892 terminating
19:55:41 T:4068   DEBUG: Thread Background Loader 4068 terminating
19:55:41 T:3380   DEBUG: Thread Background Loader 3380 terminating
19:55:43 T:3288   DEBUG: SDLKeyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0
19:55:43 T:3288   DEBUG: CApplication::OnKey: down (f081) pressed, action is Down
19:55:44 T:3288   DEBUG: SDLKeyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0
19:55:44 T:3288   DEBUG: CApplication::OnKey: down (f081) pressed, action is Down
19:55:44 T:3288   DEBUG: SDLKeyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0
19:55:44 T:3288   DEBUG: CApplication::OnKey: down (f081) pressed, action is Down
19:55:44 T:3288   DEBUG: SDLKeyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0
19:55:44 T:3288   DEBUG: CApplication::OnKey: down (f081) pressed, action is Down
19:55:44 T:3288   DEBUG: SDLKeyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0
19:55:44 T:3288   DEBUG: CApplication::OnKey: down (f081) pressed, action is Down
19:55:44 T:3288   DEBUG: SDLKeyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0
19:55:44 T:3288   DEBUG: CApplication::OnKey: down (f081) pressed, action is Down
19:55:44 T:3288   DEBUG: SDLKeyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0
19:55:44 T:3288   DEBUG: CApplication::OnKey: down (f081) pressed, action is Down
19:55:44 T:3288   DEBUG: SDLKeyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0
19:55:44 T:3288   DEBUG: CApplication::OnKey: down (f081) pressed, action is Down
19:55:44 T:3288   DEBUG: SDLKeyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0
19:55:44 T:3288   DEBUG: CApplication::OnKey: down (f081) pressed, action is Down
19:55:44 T:3288   DEBUG: SDLKeyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0
19:55:44 T:3288   DEBUG: CApplication::OnKey: down (f081) pressed, action is Down
19:55:44 T:3288   DEBUG: SDLKeyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0
19:55:44 T:3288   DEBUG: CApplication::OnKey: down (f081) pressed, action is Down
19:55:44 T:3288   DEBUG: SDLKeyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0
19:55:44 T:3288   DEBUG: CApplication::OnKey: down (f081) pressed, action is Down
19:55:44 T:3288   DEBUG: SDLKeyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0
19:55:44 T:3288   DEBUG: CApplication::OnKey: down (f081) pressed, action is Down
19:55:44 T:3288   DEBUG: SDLKeyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0
19:55:44 T:3288   DEBUG: CApplication::OnKey: down (f081) pressed, action is Down
19:55:44 T:3288   DEBUG: SDLKeyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0
19:55:44 T:3288   DEBUG: CApplication::OnKey: down (f081) pressed, action is Down
19:55:44 T:3288   DEBUG: SDLKeyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0
19:55:44 T:3288   DEBUG: CApplication::OnKey: down (f081) pressed, action is Down
19:55:44 T:3288   DEBUG: SDLKeyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0
19:55:44 T:3288   DEBUG: CApplication::OnKey: down (f081) pressed, action is Down
19:55:44 T:3288   DEBUG: SDLKeyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0
19:55:44 T:3288   DEBUG: CApplication::OnKey: down (f081) pressed, action is Down
19:55:44 T:3288   DEBUG: SDLKeyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0
19:55:44 T:3288   DEBUG: CApplication::OnKey: down (f081) pressed, action is Down
19:55:44 T:3288   DEBUG: SDLKeyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0
19:55:44 T:3288   DEBUG: CApplication::OnKey: down (f081) pressed, action is Down
19:55:44 T:3288   DEBUG: SDLKeyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0
19:55:44 T:3288   DEBUG: CApplication::OnKey: down (f081) pressed, action is Down
19:55:44 T:3288   DEBUG: SDLKeyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0
19:55:44 T:3288   DEBUG: CApplication::OnKey: down (f081) pressed, action is Down
19:55:44 T:3288   DEBUG: SDLKeyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0
19:55:44 T:3288   DEBUG: CApplication::OnKey: down (f081) pressed, action is Down
19:55:45 T:3288   DEBUG: SDLKeyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0
19:55:45 T:3288   DEBUG: CApplication::OnKey: down (f081) pressed, action is Down
19:55:45 T:3288   DEBUG: SDLKeyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0
19:55:45 T:3288   DEBUG: CApplication::OnKey: down (f081) pressed, action is Down
19:55:45 T:3288   DEBUG: SDLKeyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0
19:55:45 T:3288   DEBUG: CApplication::OnKey: down (f081) pressed, action is Down
19:55:46 T:3288   DEBUG: SDLKeyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0
19:55:46 T:3288   DEBUG: CApplication::OnKey: down (f081) pressed, action is Down
19:55:46 T:3288   DEBUG: SDLKeyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0
19:55:46 T:3288   DEBUG: CApplication::OnKey: down (f081) pressed, action is Down
19:55:46 T:3288   DEBUG: SDLKeyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0
19:55:46 T:3288   DEBUG: CApplication::OnKey: down (f081) pressed, action is Down
19:55:46 T:3288   DEBUG: SDLKeyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0
19:55:46 T:3288   DEBUG: CApplication::OnKey: down (f081) pressed, action is Down
19:55:47 T:3288   DEBUG: SDLKeyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0
19:55:47 T:3288   DEBUG: CApplication::OnKey: down (f081) pressed, action is Down
19:55:47 T:3288   DEBUG: SDLKeyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0
19:55:47 T:3288   DEBUG: CApplication::OnKey: down (f081) pressed, action is Down
19:55:47 T:3288   DEBUG: SDLKeyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0
19:55:47 T:3288   DEBUG: CApplication::OnKey: down (f081) pressed, action is Down
19:55:47 T:3288   DEBUG: SDLKeyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0
19:55:47 T:3288   DEBUG: CApplication::OnKey: down (f081) pressed, action is Down
19:55:47 T:3288   DEBUG: SDLKeyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0
19:55:47 T:3288   DEBUG: CApplication::OnKey: down (f081) pressed, action is Down
19:55:47 T:3288   DEBUG: SDLKeyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0
19:55:47 T:3288   DEBUG: CApplication::OnKey: down (f081) pressed, action is Down
19:55:47 T:3288   DEBUG: SDLKeyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0
19:55:47 T:3288   DEBUG: CApplication::OnKey: down (f081) pressed, action is Down
19:55:47 T:3288   DEBUG: SDLKeyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0
19:55:47 T:3288   DEBUG: CApplication::OnKey: down (f081) pressed, action is Down
19:55:48 T:3288   DEBUG: SDLKeyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0
19:55:48 T:3288   DEBUG: CApplication::OnKey: down (f081) pressed, action is Down
19:55:48 T:3288   DEBUG: SDLKeyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0
19:55:48 T:3288   DEBUG: CApplication::OnKey: down (f081) pressed, action is Down
19:55:48 T:3288   DEBUG: SDLKeyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0
19:55:48 T:3288   DEBUG: CApplication::OnKey: down (f081) pressed, action is Down
19:55:48 T:2772   DEBUG: CImageLoader::DoWork - took 243 ms to load special://masterprofile/Thumbnails/Music/f/f3df24de.tbn
19:55:48 T:3288   DEBUG: SDLKeyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0
19:55:48 T:3288   DEBUG: CApplication::OnKey: down (f081) pressed, action is Down
19:55:49 T:2016   DEBUG: CImageLoader::DoWork - took 287 ms to load special://masterprofile/Thumbnails/Music/0/05129f5e.tbn
19:55:49 T:3288   DEBUG: SDLKeyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0
19:55:49 T:3288   DEBUG: CApplication::OnKey: down (f081) pressed, action is Down
19:55:49 T:3288   DEBUG: SDLKeyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0
19:55:49 T:3288   DEBUG: CApplication::OnKey: down (f081) pressed, action is Down
19:55:49 T:2772   DEBUG: CImageLoader::DoWork - took 420 ms to load special://masterprofile/Thumbnails/Music/c/c9ed824b.tbn
19:55:49 T:3288   DEBUG: SDLKeyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0
19:55:49 T:3288   DEBUG: CApplication::OnKey: down (f081) pressed, action is Down
19:55:50 T:3288   DEBUG: SDLKeyboard: scancode: 48, sym: 0111, unicode: 0000, modifier: 0
19:55:50 T:3288   DEBUG: CApplication::OnKey: up (f080) pressed, action is Up
19:55:50 T:3288   DEBUG: SDLKeyboard: scancode: 48, sym: 0111, unicode: 0000, modifier: 0
19:55:50 T:3288   DEBUG: CApplication::OnKey: up (f080) pressed, action is Up
19:55:50 T:3288   DEBUG: SDLKeyboard: scancode: 1c, sym: 000d, unicode: 000d, modifier: 0
19:55:50 T:3288   DEBUG: CApplication::OnKey: return (f00d) pressed, action is Select
19:55:50 T:3288   DEBUG: PLAYLIST::CPlayList::Shuffle shuffling at pos:0
19:55:50 T:3288   DEBUG: CPlayerCoreFactory::GetPlayers(smb://WHS2011/Elements_500/Audio Tests/Rush - Fly By Night.ac3)
19:55:50 T:3288   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules
19:55:50 T:3288   DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules
19:55:50 T:3288   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtv
19:55:50 T:3288   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: hdhomerun/myth/rtmp/mms/udp
19:55:50 T:3288   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout
19:55:50 T:3288   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp
19:55:50 T:3288   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams
19:55:50 T:3288   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd
19:55:50 T:3288   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdfile
19:55:50 T:3288   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage
19:55:50 T:3288   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf
19:55:50 T:3288   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv
19:55:50 T:3288   DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players
19:55:50 T:3288   DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (1)
19:55:50 T:3288   DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0
19:55:50 T:3288   DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1
19:55:50 T:3288   DEBUG: CPlayerCoreFactory::GetPlayers: adding player: DVDPlayer (1)
19:55:50 T:3288   DEBUG: CPlayerCoreFactory::GetPlayers: adding audiodefaultplayer (3)
19:55:50 T:3288   DEBUG: CPlayerCoreFactory::GetPlayers: for video=0, audio=1
19:55:50 T:3288   DEBUG: CPlayerCoreFactory::GetPlayers: adding player: PAPlayer (3)
19:55:50 T:3288   DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1
19:55:50 T:3288   DEBUG: CPlayerCoreFactory::GetPlayers: adding player: DVDPlayer (1)
19:55:50 T:3288   DEBUG: CPlayerCoreFactory::GetPlayers: added 2 players
19:55:50 T:3288  NOTICE: DVDPlayer: Opening: smb://WHS2011/Elements_500/Audio Tests/Rush - Fly By Night.ac3
19:55:50 T:3288 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED
19:55:50 T:3288   DEBUG: CRenderManager::UpdateDisplayLatency - Latency set to 0 msec
19:55:50 T:3288   DEBUG: DXVA - cheking samples array size using 842094158 render target
19:55:50 T:3288   DEBUG: DXVA - updated maximum samples count to 2
19:55:50 T:3288   DEBUG: DXVA - cheking samples array size using 842094169 render target
19:55:50 T:2504   DEBUG: Thread CDVDPlayer start, auto delete: 0
19:55:50 T:2504  NOTICE: Creating InputStream
19:55:50 T:2504   DEBUG: CUtil::ScanForExternalSubtitles: Searching for subtitles...
19:55:50 T:2504   DEBUG: CUtil::ScanForExternalSubtitles: END (total time: 50 ms)
19:55:50 T:2504  NOTICE: Creating Demuxer
19:55:50 T:2504   DEBUG: SECTION:LoadDLL(special://xbmcbin/system/players/dvdplayer/avutil-50.dll)
19:55:50 T:2504   DEBUG: SECTION:LoadDLL(special://xbmcbin/system/players/dvdplayer/avcore-0.dll)
19:55:50 T:2504   DEBUG: SECTION:LoadDLL(special://xbmcbin/system/players/dvdplayer/avcodec-52.dll)
19:55:50 T:3288   DEBUG: ------ Window Init (DialogBusy.xml) ------
19:55:50 T:2504   DEBUG: SECTION:LoadDLL(special://xbmcbin/system/players/dvdplayer/avformat-52.dll)
19:55:50 T:2504   DEBUG: CDVDDemuxFFmpeg::Open - probing detected format [ac3]
19:55:50 T:2504   DEBUG: CDVDDemuxFFmpeg::Open - av_find_stream_info starting
19:55:50 T:2504   DEBUG: ffmpeg[9C8]: [ac3] max_analyze_duration reached
19:55:50 T:2504   DEBUG: ffmpeg[9C8]: [ac3] Estimating duration from bitrate, this may be inaccurate
19:55:50 T:2504   DEBUG: CDVDDemuxFFmpeg::Open - av_find_stream_info finished
19:55:50 T:2504    INFO: ffmpeg[9C8]: Input #0, ac3, from 'smb://WHS2011/Elements_500/Audio Tests/Rush - Fly By Night.ac3':
19:55:50 T:2504    INFO: ffmpeg[9C8]:   Duration: 00:37:51.45, bitrate: 448 kb/s
19:55:50 T:2504    INFO: ffmpeg[9C8]:     Stream #0.0: Audio: ac3, 48000 Hz, 5.1, s16, 448 kb/s
19:55:50 T:2504  NOTICE: Opening audio stream: 0 source: 256
19:55:50 T:2504  NOTICE: Finding audio codec for: 86019/-99
19:55:50 T:2504   DEBUG: FactoryCodec - Audio: PassthroughFFmpeg - Opening
19:55:50 T:2504    INFO: CDVDAudioCodecPassthroughFFmpeg::SetupMuxer - Trying to setup spdif muxer for codec 86019/-99
19:55:50 T:2504    INFO: CDVDAudioCodecPassthroughFFmpeg::SetupMuxer - spdif muxer ready
19:55:50 T:2504   DEBUG: FactoryCodec - Audio: PassthroughFFmpeg - Opened
19:55:50 T:2504  NOTICE: Creating audio thread
19:55:50 T:2504   DEBUG: CDVDPlayer::SetCaching - caching state 2
19:55:50 T:2504 WARNING: CDVDMessageQueue(video)::Put MSGQ_NOT_INITIALIZED
19:55:50 T:2356   DEBUG: Thread CDVDPlayerAudio start, auto delete: 0
19:55:50 T:2356  NOTICE: running thread: CDVDPlayerAudio::Process()
19:55:50 T:2356    INFO: CDVDAudioCodecPassthroughFFmpeg::SyncAC3 - AC3 stream detected (48000Hz)
19:55:50 T:2356  NOTICE: Creating audio device with codec id: 86019, channels: 6, sample rate: 48000, pass-through
19:55:50 T:2356   DEBUG: CWin32WASAPI::Initialize: endpoint device AMD HDMI Output (2- AMD High Definition Audio Device)
19:55:50 T:2356   DEBUG: CAudioContext::SetActiveDevice - SetActiveDevice from 2 to 0
19:55:50 T:2356   DEBUG: CAudioContext::RemoveActiveDevice - Removing device 2
19:55:50 T:2356   DEBUG: CGUIAudioManager::DeInitialize
19:55:51 T:3288   DEBUG: ------ Window Deinit (DialogBusy.xml) ------
19:55:51 T:3288   DEBUG: CGUIInfoManager::SetCurrentSong(smb://WHS2011/Elements_500/Audio Tests/Rush - Fly By Night.ac3)
19:55:51 T:3288   DEBUG: CFileItem::LoadMusicTag: loading tag information for file: smb://WHS2011/Elements_500/Audio Tests/Rush - Fly By Night.ac3
19:55:51 T:2356   DEBUG: CWin32WASAPI::Initialize: Packet Size = 2048. Avg Bytes Per Second = 192000.
19:55:51 T:2356   DEBUG: CWin32WASAPI::Initialize - Channels: 6 - SampleRate: 48000 - SampleBit: 16 - Resample false - IsMusic false - IsPassthrough 1 - audioDevice: AMD HDMI Output (2- AMD High Definition Audio Device)
19:55:51 T:2356   DEBUG: CDVDPlayerAudio:: synctype set to 0: clock feedback
19:55:51 T:2504   DEBUG: CDVDPlayer::HandleMessages - player started 1
19:55:51 T:2504   DEBUG: CDVDPlayer::SetCaching - caching state 0
19:55:51 T:2356   DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(32000.000000, 1)
19:55:51 T:2356   DEBUG: CDVDPlayerAudio:: Discontinuity - was:-6173.306820, should be:-6170.106900, error:3.199920
19:55:51 T:3288   DEBUG: Loading additional tag info for file smb://WHS2011/Elements_500/Audio Tests/Rush - Fly By Night.ac3
19:55:51 T:3288   DEBUG: CAnnouncementManager - Announcement: OnPlay from xbmc
19:55:51 T:3288   DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPlay
19:55:52 T:2356   DEBUG: CDVDPlayerAudio:: Discontinuity - was:1007580.589883, should be:966600.353071, error:-40980.236812
19:56:02 T:3288    INFO: XCURL::DllLibCurlGlobal::CheckIdle - Closing session to http://feeds.feedburner.com (easy=02EC5098, multi=02ECF7F0)
19:56:03 T:3288   DEBUG: SDLKeyboard: scancode: 2d, sym: 0078, unicode: 0078, modifier: 0
19:56:03 T:3288   DEBUG: CApplication::OnKey: x (f058) pressed, action is Stop
19:56:03 T:3288  NOTICE: CDVDPlayer::CloseFile()
19:56:03 T:3288  NOTICE: DVDPlayer: waiting for threads to exit
19:56:03 T:2504  NOTICE: CDVDPlayer::OnExit()
19:56:03 T:2504  NOTICE: DVDPlayer: closing audio stream
19:56:03 T:2504  NOTICE: Closing audio stream
19:56:03 T:2504  NOTICE: Waiting for audio thread to exit
19:56:03 T:2356  NOTICE: thread end: CDVDPlayerAudio::OnExit()
19:56:03 T:2356   DEBUG: Thread CDVDPlayerAudio 2356 terminating
19:56:03 T:2504  NOTICE: Closing audio device
19:56:03 T:2504   DEBUG: CWin32WASAPI::Deinitialize: Cleaning up
19:56:03 T:2504   DEBUG: CAudioContext::SetActiveDevice - SetActiveDevice from 0 to 2
19:56:03 T:2504   DEBUG: CAudioContext::RemoveActiveDevice - Removing device 0
19:56:03 T:2504   DEBUG: CWDSound::direct_sound_enumerator_member_callback - found Device: Prim�rer Soundtreiber
19:56:03 T:2504   DEBUG: CWDSound::direct_sound_enumerator_member_callback - found Device: AMD HDMI Output (2- AMD High Definition Audio Device)
19:56:03 T:2504   DEBUG: CAudioContext::SetActiveDevice - selecting AMD HDMI Output (2- AMD High Definition Audio Device) as output devices
19:56:03 T:2504  NOTICE: Deleting audio codec
19:56:03 T:2504  NOTICE: CDVDPlayer::OnExit() deleting demuxer
19:56:03 T:2504  NOTICE: CDVDPlayer::OnExit() deleting input stream
19:56:03 T:2504   DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc
19:56:03 T:2504   DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop
19:56:03 T:2504   DEBUG: Thread CDVDPlayer 2504 terminating
19:56:03 T:3288  NOTICE: DVDPlayer: finished waiting
19:56:03 T:3288  NOTICE: CDVDPlayer::CloseFile()
19:56:03 T:3288 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED
19:56:03 T:3288  NOTICE: DVDPlayer: waiting for threads to exit
19:56:03 T:3288  NOTICE: DVDPlayer: finished waiting
19:56:03 T:3288   DEBUG: CGUIAudioManager::Initialize
19:56:03 T:2696   DEBUG: CSaveFileStateJob::DoWork - Saving file state for video item smb://WHS2011/Elements_500/Audio Tests/Rush - Fly By Night.ac3
19:56:03 T:2696   DEBUG: Mysql execute: insert into files (idFile,idPath,strFileName) values(NULL, 786, 'Rush - Fly By Night.ac3')
19:56:03 T:2696   DEBUG: Mysql execute: update files set playCount=NULL,lastPlayed='2012-06-27 19:56:03' where idFile=4689
19:56:03 T:2696   DEBUG: Mysql execute: INSERT INTO settings (idFile,Deinterlace,ViewMode,ZoomAmount,PixelRatio, VerticalShift, AudioStream,SubtitleStream,SubtitleDelay,SubtitlesOn,Brightness,Contrast,Gamma,VolumeAmplification,AudioDelay,OutputToAllSpeakers,ResumeTime,Crop,CropLeft,CropRight,CropTop,CropBottom,Sharpness,NoiseReduction,NonLinStretch,PostProcess,ScalingMethod,DeinterlaceMode) VALUES (4689,1,0,1.000000,1.000000,0.000000,-1,-1,0.000000,1,50.000000,50.000000,20.000000,0.000000,0.000000,0,0,0,0,0,0,0,0.000000,0.000000,0,0,1,1)
19:56:03 T:2696   DEBUG: CSaveFileStateJob::DoWork - Saving file state for audio item smb://WHS2011/Elements_500/Audio Tests/Rush - Fly By Night.ac3
19:56:03 T:3288   DEBUG: SDLKeyboard: scancode: 38, sym: 0134, unicode: 0000, modifier: 100
19:56:03 T:3288   DEBUG: CApplication::OnKey: alt-leftalt (4f0d4) pressed, action is
19:56:04 T:3288   DEBUG: CWinEventsWin32::WndProcWindow is active
19:56:04 T:3288   DEBUG: CAnnouncementManager - Announcement: OnQuit from xbmc
19:56:04 T:3288   DEBUG: GOT ANNOUNCEMENT, type: 4, from xbmc, message OnQuit
19:56:04 T:2696   DEBUG: Thread Jobworker 2696 terminating (autodelete)
19:56:04 T:2772   DEBUG: Thread Jobworker 2772 terminating (autodelete)
19:56:04 T:2016   DEBUG: Thread Jobworker 2016 terminating (autodelete)
19:56:04 T:3288  NOTICE: Storing total System Uptime
19:56:04 T:3288  NOTICE: Saving settings
19:56:04 T:3288  NOTICE: stop all
19:56:04 T:3288   DEBUG: CNetwork::NetworkMessage - Signaling network services to stop
19:56:04 T:3288  NOTICE: ES: Stopping event server
19:56:04 T:3288   DEBUG: CNetwork::NetworkMessage - Waiting for network services to stop
19:56:04 T:3288  NOTICE: stopping zeroconf publishing
19:56:04 T:3288  NOTICE: Webserver: Stopping...
19:56:04 T:3288  NOTICE: WebServer: Stopped the webserver
19:56:04 T:3288  NOTICE: Webserver: Stopped...
19:56:05 T:3412   DEBUG: Thread JSONRPC::CTCPServer 3412 terminating
19:56:05 T:2284  NOTICE: ES: UDP Event server stopped
19:56:05 T:2284   DEBUG: Thread CEventServer 2284 terminating
19:56:05 T:3248   DEBUG: Thread XBMC Peripherals 3248 terminating
19:56:05 T:3288  NOTICE: stop sap announcement listener
19:56:05 T:3288  NOTICE: clean cached files!
19:56:05 T:3288  NOTICE: unload skin
19:56:05 T:3288    INFO: Unloading old skin ...
19:56:05 T:3288   DEBUG: CGUIAudioManager::DeInitialize
19:56:05 T:3288   DEBUG: ------ Window Deinit () ------
19:56:05 T:3288   DEBUG: ------ Window Deinit (MyMusicSongs.xml) ------
19:56:05 T:3288   DEBUG: CTextureBundleXBT::Cleanup - Closed bundle
19:56:05 T:3288   DEBUG: ADDON: Stopping service addons.
19:56:05 T:3288    INFO: Stopping script with id: 2
19:56:05 T:1364  NOTICE: StorageServer-1.0.0 Closed down
19:56:05 T:1364    INFO: Scriptresult: Success
19:56:05 T:3288  NOTICE: stop python
19:56:05 T:3288   DEBUG: waiting for python thread 2 to stop
19:56:05 T:1364    INFO: Python script interrupted by user
19:56:05 T:1364   DEBUG: Thread XBPyThread 1364 terminating
19:56:05 T:3288   DEBUG: python thread 2 destructed
19:56:05 T:3288  NOTICE: stopped
19:56:05 T:3288  NOTICE: destroy
19:56:05 T:3288   DEBUG: ADDON: cpluff: 'Plug-in xbmc.json has been uninstalled.'
19:56:05 T:3288   DEBUG: ADDON: cpluff: 'Plug-in metadata.albums.allmusic.com has been uninstalled.'
19:56:05 T:3288   DEBUG: ADDON: cpluff: 'Plug-in pvr.fortherecord.argus has been uninstalled.'
19:56:05 T:3288   DEBUG: ADDON: cpluff: 'Plug-in repository.xbmc.org has been uninstalled.'
19:56:05 T:3288   DEBUG: ADDON: cpluff: 'Plug-in webinterface.default has been uninstalled.'
19:56:05 T:3288   DEBUG: ADDON: cpluff: 'Plug-in pvr.vdr.vnsi has been uninstalled.'
19:56:05 T:3288   DEBUG: ADDON: cpluff: 'Plug-in screensaver.rsxs.euphoria has been uninstalled.'
19:56:05 T:3288   DEBUG: ADDON: cpluff: 'Plug-in screensaver.xbmc.builtin.black has been uninstalled.'
19:56:05 T:3288   DEBUG: ADDON: cpluff: 'Plug-in visualization.projectm has been uninstalled.'
19:56:05 T:3288   DEBUG: ADDON: cpluff: 'Plug-in script.module.simplejson has been uninstalled.'
19:56:05 T:3288   DEBUG: ADDON: cpluff: 'Plug-in weather.wunderground has been uninstalled.'
19:56:05 T:3288   DEBUG: ADDON: cpluff: 'Plug-in screensaver.xbmc.builtin.dim has been uninstalled.'
19:56:05 T:3288   DEBUG: ADDON: cpluff: 'Plug-in metadata.artists.allmusic.com has been uninstalled.'
19:56:05 T:3288   DEBUG: ADDON: cpluff: 'Plug-in metadata.themoviedb.org has been uninstalled.'
19:56:05 T:3288   DEBUG: ADDON: cpluff: 'Plug-in xbmc.metadata has been uninstalled.'
19:56:05 T:3288   DEBUG: ADDON: cpluff: 'Plug-in skin.confluence has been uninstalled.'
19:56:05 T:3288   DEBUG: ADDON: cpluff: 'Plug-in visualization.glspectrum has been uninstalled.'
19:56:05 T:3288   DEBUG: ADDON: cpluff: 'Plug-in script.common.plugin.cache has been uninstalled.'
19:56:05 T:3288   DEBUG: ADDON: cpluff: 'Plug-in pvr.fortherecord.argus-rtsp has been uninstalled.'
19:56:05 T:3288   DEBUG: ADDON: cpluff: 'Plug-in script.module.pil has been uninstalled.'
19:56:05 T:3288   DEBUG: ADDON: cpluff: 'Plug-in visualization.milkdrop has been uninstalled.'
19:56:05 T:3288   DEBUG: ADDON: cpluff: 'Plug-in xbmc.gui has been uninstalled.'
19:56:05 T:3288   DEBUG: ADDON: cpluff: 'Plug-in visualization.dxspectrum has been uninstalled.'
19:56:05 T:3288   DEBUG: ADDON: cpluff: 'Plug-in script.module.simple.downloader has been uninstalled.'
19:56:05 T:3288   DEBUG: ADDON: cpluff: 'Plug-in pvr.mythtv has been uninstalled.'
19:56:05 T:3288   DEBUG: ADDON: cpluff: 'Plug-in xbmc.core has been uninstalled.'
19:56:05 T:3288   DEBUG: ADDON: cpluff: 'Plug-in plugin.video.youtube has been uninstalled.'
19:56:05 T:3288   DEBUG: ADDON: cpluff: 'Plug-in screensaver.xbmc.builtin.slideshow has been uninstalled.'
19:56:05 T:3288   DEBUG: ADDON: cpluff: 'Plug-in pvr.team-mediaportal.tvserver-tsreader has been uninstalled.'
19:56:05 T:3288   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.htbackdrops.com has been uninstalled.'
19:56:05 T:3288   DEBUG: ADDON: cpluff: 'Plug-in pvr.team-mediaportal.tvserver has been uninstalled.'
19:56:05 T:3288   DEBUG: ADDON: cpluff: 'Plug-in service.xbmc-fritzbox has been uninstalled.'
19:56:05 T:3288   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.allmusic.com has been uninstalled.'
19:56:05 T:3288   DEBUG: ADDON: cpluff: 'Plug-in metadata.tvdb.com has been uninstalled.'
19:56:05 T:3288   DEBUG: ADDON: cpluff: 'Plug-in webinterface.awxi has been uninstalled.'
19:56:05 T:3288   DEBUG: ADDON: cpluff: 'Plug-in metadata.yahoomusic.com has been uninstalled.'
19:56:05 T:3288   DEBUG: ADDON: cpluff: 'Plug-in weather.xbmc.builtin has been uninstalled.'
19:56:05 T:3288   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.last.fm has been uninstalled.'
19:56:05 T:3288   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.themoviedb.org has been uninstalled.'
19:56:05 T:3288   DEBUG: ADDON: cpluff: 'Plug-in script.module.parsedom has been uninstalled.'
19:56:05 T:3288   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.imdb.com has been uninstalled.'
19:56:05 T:3288   DEBUG: ADDON: cpluff: 'Plug-in xbmc.python has been uninstalled.'
19:56:05 T:3288   DEBUG: ADDON: cpluff: 'Plug-in pvr.hts has been uninstalled.'
19:56:05 T:3288   DEBUG: ADDON: cpluff: 'Plug-in screensaver.rsxs.plasma has been uninstalled.'
19:56:05 T:3288   DEBUG: ADDON: cpluff: 'Plug-in visualization.waveform has been uninstalled.'
19:56:05 T:3288   DEBUG: ADDON: cpluff: 'Plug-in xbmc.addon has been uninstalled.'
19:56:05 T:3288   DEBUG: ADDON: cpluff: 'Plug-in script.module.pysqlite has been uninstalled.'
19:56:05 T:3288   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.hdtrailers.net has been uninstalled.'
19:56:05 T:3288   DEBUG: ADDON: cpluff: 'Plug-in visualization.itunes has been uninstalled.'
19:56:05 T:3288    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 03CAAA00 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
19:56:05 T:3288    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 03CCB308 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
19:56:05 T:3288    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 03CAAEC8 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
19:56:05 T:3288    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 03CAB150 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
19:56:05 T:3288    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 03CAAD18 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
19:56:05 T:3288    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 03CAAAD8 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
19:56:05 T:3288    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 03CAAFA0 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
19:56:05 T:3288    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 03CAA928 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
19:56:05 T:3288    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 03CAA970 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
19:56:05 T:3288    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 03CAAE38 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
19:56:05 T:3288    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 03CAABF8 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
19:56:05 T:3288  NOTICE: closing down remote control service
19:56:05 T:2388   DEBUG: Thread CRemoteControl 2388 terminating
19:56:05 T:3288  NOTICE: unload sections
19:56:05 T:3288    INFO: lastfm destroyed
19:56:05 T:3288  NOTICE: destroy
19:56:05 T:3288 WARNING: Attempted to remove window 10013 from the window manager when it didn't exist
19:56:05 T:3288 WARNING: Attempted to remove window 10014 from the window manager when it didn't exist
19:56:05 T:3288 WARNING: Attempted to remove window 10015 from the window manager when it didn't exist
19:56:05 T:3288 WARNING: Attempted to remove window 10016 from the window manager when it didn't exist
19:56:05 T:3288 WARNING: Attempted to remove window 10017 from the window manager when it didn't exist
19:56:05 T:3288 WARNING: Attempted to remove window 10018 from the window manager when it didn't exist
19:56:05 T:3288 WARNING: Attempted to remove window 10019 from the window manager when it didn't exist
19:56:05 T:3288 WARNING: Attempted to remove window 10107 from the window manager when it didn't exist
19:56:05 T:3288 WARNING: Attempted to remove window 10115 from the window manager when it didn't exist
19:56:05 T:3288 WARNING: Attempted to remove window 10104 from the window manager when it didn't exist
19:56:05 T:3288  NOTICE: closing down remote control service
19:56:05 T:3288  NOTICE: unload sections
19:56:05 T:3288  NOTICE: application stopped...
19:56:05 T:3288   DEBUG: SECTION:UnloadDll(special://xbmcbin/system/libcurl.dll)
19:56:05 T:3288   DEBUG: SECTION:UnloadAll(DLL: special://xbmcbin/system/cpluff.dll)
19:56:05 T:3288   DEBUG: SECTION:UnloadAll(DLL: special://xbmcbin/system/ImageLib.dll)
19:56:05 T:3288   DEBUG: SECTION:UnloadAll(DLL: special://xbmcbin/system/players/dvdplayer/avutil-50.dll)
19:56:05 T:3288   DEBUG: SECTION:UnloadAll(DLL: special://xbmcbin/system/players/dvdplayer/avcore-0.dll)
19:56:05 T:3288   DEBUG: SECTION:UnloadAll(DLL: special://xbmcbin/system/players/dvdplayer/avcodec-52.dll)
19:56:05 T:3288   DEBUG: SECTION:UnloadAll(DLL: special://xbmcbin/system/players/dvdplayer/avformat-52.dll)