Skip to content

Instantly share code, notes, and snippets.

/XBMC Log Secret

Created November 27, 2013 04:35
Show Gist options
  • Star 0 You must be signed in to star a gist
  • Fork 0 You must be signed in to fork a gist
  • Save anonymous/ba084a2b53ecc42a23e9 to your computer and use it in GitHub Desktop.
Save anonymous/ba084a2b53ecc42a23e9 to your computer and use it in GitHub Desktop.
Download ZIP
XBMC Log
Raw
XBMC Log
21:19:24 T:2124 NOTICE: -----------------------------------------------------------------------
21:19:24 T:2124 NOTICE: Starting XBMC (12.2 Git:20130502-32b1a5e), Platform: Windows 8 64-bit, build 9200. Built on May 2 2013 (compiler 1600)
21:19:24 T:2124 NOTICE: Intel(R) Pentium(R) D CPU 3.20GHz
21:19:24 T:2124 NOTICE: Desktop Resolution: 1920x1080 32Bit at 60Hz
21:19:24 T:2124 NOTICE: Running with restricted rights
21:19:24 T:2124 NOTICE: Aero is enabled
21:19:24 T:2124 NOTICE: special://xbmc/ is mapped to: C:\Program Files (x86)\XBMC
21:19:24 T:2124 NOTICE: special://xbmcbin/ is mapped to: C:\Program Files (x86)\XBMC
21:19:24 T:2124 NOTICE: special://masterprofile/ is mapped to: C:\Users\TVUser\AppData\Roaming\XBMC\userdata
21:19:24 T:2124 NOTICE: special://home/ is mapped to: C:\Users\TVUser\AppData\Roaming\XBMC\
21:19:24 T:2124 NOTICE: special://temp/ is mapped to: C:\Users\TVUser\AppData\Roaming\XBMC\cache
21:19:24 T:2124 NOTICE: The executable running is: C:\Program Files (x86)\XBMC\XBMC.exe
21:19:24 T:2124 NOTICE: Local hostname: TV
21:19:24 T:2124 NOTICE: Log File is located: C:\Users\TVUser\AppData\Roaming\XBMC\xbmc.log
21:19:24 T:2124 NOTICE: -----------------------------------------------------------------------
21:19:24 T:2124 NOTICE: Found 2 Lists of Devices
21:19:24 T:2124 NOTICE: Enumerated DirectSound devices:
21:19:24 T:2124 NOTICE: Device 1
21:19:24 T:2124 NOTICE: m_deviceName : {C7682C8C-D5C0-4B52-B9A8-BD752D1A3593}
21:19:24 T:2124 NOTICE: m_displayName : Speakers - Speakers (2- High Definition Audio Device)
21:19:24 T:2124 NOTICE: m_displayNameExtra: DirectSound: Speakers (2- High Definition Audio Device)
21:19:24 T:2124 NOTICE: m_deviceType : AE_DEVTYPE_PCM
21:19:24 T:2124 NOTICE: m_channels : FL,FR
21:19:24 T:2124 NOTICE: m_sampleRates : 192000
21:19:24 T:2124 NOTICE: m_dataFormats : AE_FMT_FLOAT,AE_FMT_AC3
21:19:24 T:2124 NOTICE: Device 2
21:19:24 T:2124 NOTICE: m_deviceName : {3606B832-0F1E-45FA-B022-BBA76098976C}
21:19:24 T:2124 NOTICE: m_displayName : HDMI - LG TV-1 (NVIDIA High Definition Audio)
21:19:24 T:2124 NOTICE: m_displayNameExtra: DirectSound: LG TV-1 (NVIDIA High Definition Audio)
21:19:24 T:2124 NOTICE: m_deviceType : AE_DEVTYPE_HDMI
21:19:24 T:2124 NOTICE: m_channels : FL,FR
21:19:24 T:2124 NOTICE: m_sampleRates : 48000
21:19:24 T:2124 NOTICE: m_dataFormats : AE_FMT_FLOAT,AE_FMT_AC3
21:19:24 T:2124 NOTICE: Enumerated WASAPI devices:
21:19:24 T:2124 NOTICE: Device 1
21:19:24 T:2124 NOTICE: m_deviceName : {3606B832-0F1E-45FA-B022-BBA76098976C}
21:19:24 T:2124 NOTICE: m_displayName : HDMI - LG TV-1 (NVIDIA High Definition Audio)
21:19:24 T:2124 NOTICE: m_displayNameExtra: WASAPI: LG TV-1 (NVIDIA High Definition Audio)
21:19:24 T:2124 NOTICE: m_deviceType : AE_DEVTYPE_HDMI
21:19:24 T:2124 NOTICE: m_channels : FL,FR
21:19:24 T:2124 NOTICE: m_sampleRates : 192000,96000,48000,44100
21:19:24 T:2124 NOTICE: m_dataFormats : AE_FMT_S24NE4,AE_FMT_S24LE4,AE_FMT_S24BE4,AE_FMT_S16NE,AE_FMT_S16LE,AE_FMT_S16BE
21:19:24 T:2124 NOTICE: Device 2
21:19:24 T:2124 NOTICE: m_deviceName : {C7682C8C-D5C0-4B52-B9A8-BD752D1A3593}
21:19:24 T:2124 NOTICE: m_displayName : Speakers - Speakers (2- High Definition Audio Device)
21:19:24 T:2124 NOTICE: m_displayNameExtra: WASAPI: Speakers (2- High Definition Audio Device)
21:19:24 T:2124 NOTICE: m_deviceType : AE_DEVTYPE_PCM
21:19:24 T:2124 NOTICE: m_channels : FL,FR
21:19:24 T:2124 NOTICE: m_sampleRates : 192000,176400,96000,88200,48000,44100
21:19:24 T:2124 NOTICE: m_dataFormats : AE_FMT_S24NE4,AE_FMT_S24LE4,AE_FMT_S24BE4,AE_FMT_S16NE,AE_FMT_S16LE,AE_FMT_S16BE
21:19:24 T:2124 NOTICE: load settings...
21:19:25 T:2124 NOTICE: special://profile/ is mapped to: special://masterprofile/
21:19:25 T:2124 NOTICE: loading special://masterprofile/guisettings.xml
21:19:25 T:2124 NOTICE: Getting hardware information now...
21:19:25 T:2124 NOTICE: Loading player core factory settings from special://xbmc/system/playercorefactory.xml.
21:19:25 T:2124 NOTICE: Loaded playercorefactory configuration
21:19:25 T:2124 NOTICE: Loading player core factory settings from special://masterprofile/playercorefactory.xml.
21:19:25 T:2124 NOTICE: special://masterprofile/playercorefactory.xml does not exist. Skipping.
21:19:25 T:2124 NOTICE: No settings file to load (special://xbmc/system/advancedsettings.xml)
21:19:25 T:2124 NOTICE: No settings file to load (special://masterprofile/advancedsettings.xml)
21:19:25 T:2124 NOTICE: Default DVD Player: dvdplayer
21:19:25 T:2124 NOTICE: Default Video Player: dvdplayer
21:19:25 T:2124 NOTICE: Default Audio Player: paplayer
21:19:25 T:2124 NOTICE: Enabled debug logging due to GUI setting (2)
21:19:25 T:2124 NOTICE: Log level changed to 2
21:19:25 T:2124 NOTICE: Loading media sources from special://masterprofile/sources.xml
21:19:25 T:2124 INFO: creating subdirectories
21:19:25 T:2124 INFO: userdata folder: special://masterprofile/
21:19:25 T:2124 INFO: recording folder:
21:19:25 T:2124 INFO: screenshots folder:
21:19:25 T:2124 INFO: thumbnails folder: special://masterprofile/Thumbnails
21:19:25 T:2124 INFO: load language info file: special://xbmc/language/English/langinfo.xml
21:19:25 T:2124 DEBUG: trying to set locale to eng_aus
21:19:25 T:2124 INFO: global locale set to English_Australia.1252
21:19:25 T:2124 INFO: load English language file, from path: special://xbmc/language/
21:19:25 T:2124 DEBUG: POParser: PO file has Win Style Line Endings. Converted in memory to Linux LF for file: C:\Program Files (x86)\XBMC\language\English\strings.po
21:19:25 T:2124 DEBUG: POParser: loaded 2686 strings from file C:\Program Files (x86)\XBMC\language\English\strings.po
21:19:25 T:2124 INFO: CSoftAE::InternalOpenSink - sink incompatible, re-starting
21:19:25 T:2124 DEBUG: CAESinkDirectSound::Initialize: Using Window handle: 65552
21:19:25 T:2124 DEBUG: CAESinkDirectSound::Initialize: secondary buffer created
21:19:25 T:2124 DEBUG: CAESinkDirectSound::Initialize: Initializing DirectSound with the following parameters:
21:19:25 T:2124 DEBUG: Audio Device : Speakers (2- High Definition Audio Device)
21:19:25 T:2124 DEBUG: Sample Rate : 44100
21:19:25 T:2124 DEBUG: Sample Format : AE_FMT_FLOAT
21:19:25 T:2124 DEBUG: Bits Per Sample : 32
21:19:25 T:2124 DEBUG: Valid Bits/Samp : 32
21:19:25 T:2124 DEBUG: Channel Count : 2
21:19:25 T:2124 DEBUG: Block Align : 8
21:19:25 T:2124 DEBUG: Avg. Bytes Sec : 352800
21:19:25 T:2124 DEBUG: Samples/Block : 32
21:19:25 T:2124 DEBUG: Format cBSize : 22
21:19:25 T:2124 DEBUG: Channel Layout : FL,FR
21:19:25 T:2124 DEBUG: Channel Mask : 3
21:19:25 T:2124 DEBUG: Frames : 441
21:19:25 T:2124 DEBUG: Frame Samples : 882
21:19:25 T:2124 DEBUG: Frame Size : 8
21:19:25 T:2124 DEBUG: CSoftAE::InternalOpenSink - DirectSound Initialized:
21:19:25 T:2124 DEBUG: Output Device : Speakers - Speakers (2- High Definition Audio Device)
21:19:25 T:2124 DEBUG: Sample Rate : 44100
21:19:25 T:2124 DEBUG: Sample Format : AE_FMT_FLOAT
21:19:25 T:2124 DEBUG: Channel Count : 2
21:19:25 T:2124 DEBUG: Channel Layout: FL,FR
21:19:25 T:2124 DEBUG: Frames : 441
21:19:25 T:2124 DEBUG: Frame Samples : 882
21:19:25 T:2124 DEBUG: Frame Size : 8
21:19:25 T:2124 DEBUG: CSoftAE::InternalOpenSink - Using speaker layout: 2.1
21:19:25 T:2124 DEBUG: CSoftAE::InternalOpenSink - Internal Buffer Size: 3528
21:19:25 T:2980 NOTICE: Thread CSoftAE start, auto delete: false
21:19:25 T:2980 INFO: CSoftAE::Run - Thread Started
21:19:25 T:2124 NOTICE: Running database version Addons15
21:19:25 T:2124 DEBUG: SECTION:LoadDLL(special://xbmcbin/system/cpluff.dll)
21:19:26 T:2980 DEBUG: CAESinkDirectSound::CheckPlayStatus: Resuming Playback
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in script.module.xbmcswift has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in xbmc.json has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in script.facebook.media has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in plugin.audio.soundcloud has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.fanart.tv has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in script.module.bigpictures has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in skin.confluence-vertical has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in plugin.video.redditmusic has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in metadata.albums.allmusic.com has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in webinterface.default has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in repository.xbmc.org has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in skin.slik has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in screensaver.xbmc.builtin.black has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in screensaver.rsxs.euphoria has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in pvr.vdr.vnsi has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in pvr.argustv has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in repository.pvr-osx32.xbmc.org has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in pvr.mediaportal.tvserver has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in plugin.video.ted.talks has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in metadata.artists.yoyo.pl has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in metadata.albums.theaudiodb.com has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in script.randomitems has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in visualization.projectm has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in weather.wunderground has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in script.module.simplejson has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in script.image.bigpictures has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in screensaver.xbmc.builtin.dim has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in skin.quartz has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in script.tvguide has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in script.favourites has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in script.module.beautifulsoup4 has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in metadata.themoviedb.org has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in script.module.brightcove has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in metadata.artists.allmusic.com has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in xbmc.metadata has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in repository.pvr-ios.xbmc.org has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in script.watchlist has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in plugin.audio.radio_de has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in plugin.program.akinator_com has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in skin.confluence has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in script.module.myconnpy has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in plugin.video.funny.or.die has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in script.globalsearch has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in plugin.video.railscasts has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in plugin.video.fox.news has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in visualization.glspectrum has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in script.module.beautifulsoup has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in repository.googlecode.sparetime has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in xbmc.gui has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in visualization.milkdrop has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in script.module.pil has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in service.skin.widgets has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in script.common.plugin.cache has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in plugin.video.pyvideo has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.amazon.de has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in plugin.video.engadget has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in visualization.dxspectrum has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in plugin.video.hgtv has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in pvr.vuplus has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in metadata.musicvideos.theaudiodb.com has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in script.module.simple.downloader has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in plugin.video.vimeo has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in plugin.video.liveleak has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in xbmc.core has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in plugin.video.itunes_podcasts has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in plugin.video.hdtrailers_net has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in plugin.video.youtube has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in plugin.audio.mixcloud has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in metadata.albums.last.fm has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in metadata.albums.freebase.com has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in screensaver.rsxs.solarwinds has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in pvr.demo has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in script.module.requests has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in script.artistslideshow has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in script.artwork.downloader has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in plugin.video.newyorktimes has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in screensaver.xbmc.builtin.slideshow has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in xbmc.pvr has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in pvr.njoy has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in pvr.nextpvr has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in plugin.video.khanacademy has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in repository.pvr-android.xbmc.org has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in plugin.video.nasa has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in plugin.audio.groove has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in metadata.album.universal has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in service.qlock has been installed.'
21:19:27 T:2124 DEBUG: ADDON: cpluff: 'Plug-in script.game.whatthemovie has been installed.'
21:19:28 T:2124 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.htbackdrops.com has been installed.'
21:19:28 T:2124 DEBUG: ADDON: cpluff: 'Plug-in repository.pvr-win32.xbmc.org has been installed.'
21:19:28 T:2124 DEBUG: ADDON: cpluff: 'Plug-in pvr.dvbviewer has been installed.'
21:19:28 T:2124 DEBUG: ADDON: cpluff: 'Plug-in script.hululibraryautoupdate has been installed.'
21:19:28 T:2124 DEBUG: ADDON: cpluff: 'Plug-in script.SuperTV has been installed.'
21:19:28 T:2124 DEBUG: ADDON: cpluff: 'Plug-in plugin.image.500px has been installed.'
21:19:28 T:2124 DEBUG: ADDON: cpluff: 'Plug-in script.pseudotv has been installed.'
21:19:28 T:2124 DEBUG: ADDON: cpluff: 'Plug-in script.moviequiz has been installed.'
21:19:28 T:2124 DEBUG: ADDON: cpluff: 'Plug-in repository.pvr-osx64.xbmc.org has been installed.'
21:19:28 T:2124 DEBUG: ADDON: cpluff: 'Plug-in pvr.mythtv.cmyth has been installed.'
21:19:28 T:2124 DEBUG: ADDON: cpluff: 'Plug-in metadata.yahoomusic.com has been installed.'
21:19:28 T:2124 DEBUG: ADDON: cpluff: 'Plug-in metadata.tvdb.com has been installed.'
21:19:28 T:2124 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.musicbrainz.org has been installed.'
21:19:28 T:2124 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.allmusic.com has been installed.'
21:19:28 T:2124 DEBUG: ADDON: cpluff: 'Plug-in script.module.buggalo has been installed.'
21:19:28 T:2124 DEBUG: ADDON: cpluff: 'Plug-in plugin.video.academicearth has been installed.'
21:19:28 T:2124 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.last.fm has been installed.'
21:19:28 T:2124 DEBUG: ADDON: cpluff: 'Plug-in plugin.audio.mp3search has been installed.'
21:19:28 T:2124 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.themoviedb.org has been installed.'
21:19:28 T:2124 DEBUG: ADDON: cpluff: 'Plug-in metadata.artists.theaudiodb.com has been installed.'
21:19:28 T:2124 DEBUG: ADDON: cpluff: 'Plug-in script.module.parsedom has been installed.'
21:19:28 T:2124 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.theaudiodb.com has been installed.'
21:19:28 T:2124 DEBUG: ADDON: cpluff: 'Plug-in metadata.artists.universal has been installed.'
21:19:28 T:2124 DEBUG: ADDON: cpluff: 'Plug-in metadata.artists.metal-archives.com has been installed.'
21:19:28 T:2124 DEBUG: ADDON: cpluff: 'Plug-in xbmc.python has been installed.'
21:19:28 T:2124 DEBUG: ADDON: cpluff: 'Plug-in script.tv.show.next.aired has been installed.'
21:19:28 T:2124 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.imdb.com has been installed.'
21:19:28 T:2124 DEBUG: ADDON: cpluff: 'Plug-in script.module.xbmcswift2 has been installed.'
21:19:28 T:2124 DEBUG: ADDON: cpluff: 'Plug-in script.web.viewer has been installed.'
21:19:28 T:2124 DEBUG: ADDON: cpluff: 'Plug-in script.module.elementtree has been installed.'
21:19:28 T:2124 DEBUG: ADDON: cpluff: 'Plug-in xbmc.addon has been installed.'
21:19:28 T:2124 DEBUG: ADDON: cpluff: 'Plug-in visualization.waveform has been installed.'
21:19:28 T:2124 DEBUG: ADDON: cpluff: 'Plug-in screensaver.rsxs.plasma has been installed.'
21:19:28 T:2124 DEBUG: ADDON: cpluff: 'Plug-in pvr.hts has been installed.'
21:19:28 T:2124 DEBUG: ADDON: cpluff: 'Plug-in skin.transparency has been installed.'
21:19:28 T:2124 DEBUG: ADDON: cpluff: 'Plug-in script.module.feedparser has been installed.'
21:19:28 T:2124 DEBUG: ADDON: cpluff: 'Plug-in plugin.video.foodnetwork has been installed.'
21:19:28 T:2124 DEBUG: ADDON: cpluff: 'Plug-in script.module.pysqlite has been installed.'
21:19:28 T:2124 DEBUG: ADDON: cpluff: 'Plug-in script.categories has been installed.'
21:19:28 T:2124 DEBUG: ADDON: cpluff: 'Plug-in visualization.itunes has been installed.'
21:19:28 T:2124 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.hdtrailers.net has been installed.'
21:19:28 T:2124 DEBUG: ADDON: cpluff: 'Not all directories were successfully scanned.'
21:19:28 T:2124 DEBUG: PERIPHERALS::CPeripherals::LoadMappings - loaded node "Motorola Nyxboard Hybrid"
21:19:28 T:2124 DEBUG: PERIPHERALS::CPeripherals::LoadMappings - loaded node "CEC Adapter"
21:19:28 T:2124 DEBUG: PERIPHERALS::CPeripherals::LoadMappings - loaded node "Pulse-Eight CEC Adapter"
21:19:28 T:2124 DEBUG: PERIPHERALS::CPeripherals::LoadMappings - loaded node "iMON HID device"
21:19:28 T:2124 DEBUG: SECTION:LoadDLL(special://xbmcbin/system/libcec.dll)
21:19:28 T:2412 NOTICE: Thread XBMC Peripherals start, auto delete: false
21:19:28 T:2408 NOTICE: Previous line repeats 1 times.
21:19:28 T:2408 NOTICE: Thread CRemoteControl start, auto delete: false
21:19:28 T:2124 DEBUG: CWIN32Util::GetDriveStatus: Requesting status for drive \\.\D:.
21:19:28 T:2124 DEBUG: CWIN32Util::GetDriveStatus: Requesting media status for drive \\.\D:.
21:19:28 T:2124 NOTICE: Found screen: Generic PnP Monitor on NVIDIA GeForce 210 , adapter 0.
21:19:28 T:2124 NOTICE: Primary mode: 1920x1080 @ 60.00 - Full Screen
21:19:28 T:2124 NOTICE: Additional mode: 640x480 @ 59.94 - Full Screen
21:19:28 T:2124 NOTICE: Additional mode: 640x480 @ 60.00 - Full Screen
21:19:28 T:2124 NOTICE: Additional mode: 720x480 @ 59.94 - Full Screen
21:19:28 T:2124 NOTICE: Additional mode: 720x480 @ 60.00 - Full Screen
21:19:28 T:2124 NOTICE: Additional mode: 720x576 @ 60.00 - Full Screen
21:19:28 T:2124 NOTICE: Previous line repeats 2 times.
21:19:28 T:2124 NOTICE: Additional mode: 800x600 @ 60.00 - Full Screen
21:19:28 T:2124 NOTICE: Additional mode: 1024x768 @ 60.00 - Full Screen
21:19:28 T:2124 NOTICE: Additional mode: 1152x864 @ 60.00 - Full Screen
21:19:28 T:2124 NOTICE: Additional mode: 1176x664 @ 59.94 - Full Screen
21:19:28 T:2124 NOTICE: Previous line repeats 2 times.
21:19:28 T:2124 NOTICE: Additional mode: 1176x664 @ 60.00 - Full Screen
21:19:28 T:2124 NOTICE: Previous line repeats 2 times.
21:19:28 T:2124 NOTICE: Additional mode: 1280x720 @ 59.94 - Full Screen
21:19:28 T:2124 NOTICE: Additional mode: 1280x720 @ 60.00 - Full Screen
21:19:28 T:2124 NOTICE: Additional mode: 1280x768 @ 60.00 - Full Screen
21:19:28 T:2124 NOTICE: Previous line repeats 2 times.
21:19:28 T:2124 NOTICE: Additional mode: 1280x800 @ 60.00 - Full Screen
21:19:28 T:2124 NOTICE: Previous line repeats 2 times.
21:19:28 T:2124 NOTICE: Additional mode: 1280x960 @ 60.00 - Full Screen
21:19:28 T:2124 NOTICE: Previous line repeats 2 times.
21:19:28 T:2124 NOTICE: Additional mode: 1280x1024 @ 60.00 - Full Screen
21:19:28 T:2124 NOTICE: Additional mode: 1360x768 @ 60.00 - Full Screen
21:19:28 T:2124 NOTICE: Additional mode: 1366x768 @ 59.94 - Full Screen
21:19:28 T:2124 NOTICE: Previous line repeats 2 times.
21:19:28 T:2124 NOTICE: Additional mode: 1366x768 @ 29.97i - Full Screen
21:19:28 T:2124 NOTICE: Previous line repeats 2 times.
21:19:28 T:2124 NOTICE: Additional mode: 1366x768 @ 60.00 - Full Screen
21:19:28 T:2124 NOTICE: Previous line repeats 2 times.
21:19:28 T:2124 NOTICE: Additional mode: 1366x768 @ 29.97 - Full Screen
21:19:28 T:2124 NOTICE: Additional mode: 1366x768 @ 30.00 - Full Screen
21:19:28 T:2124 NOTICE: Additional mode: 1366x768 @ 29.97 - Full Screen
21:19:28 T:2124 NOTICE: Additional mode: 1366x768 @ 30.00 - Full Screen
21:19:28 T:2124 NOTICE: Additional mode: 1366x768 @ 29.97 - Full Screen
21:19:28 T:2124 NOTICE: Additional mode: 1366x768 @ 30.00 - Full Screen
21:19:28 T:2124 NOTICE: Additional mode: 1366x768 @ 23.98 - Full Screen
21:19:28 T:2124 NOTICE: Additional mode: 1366x768 @ 24.00 - Full Screen
21:19:28 T:2408 DEBUG: CRemoteControl::Connect - connecting to: ::1:24000 ...
21:19:28 T:2124 NOTICE: Additional mode: 1366x768 @ 23.98 - Full Screen
21:19:28 T:2124 NOTICE: Additional mode: 1366x768 @ 24.00 - Full Screen
21:19:28 T:2124 NOTICE: Additional mode: 1366x768 @ 23.98 - Full Screen
21:19:28 T:2124 NOTICE: Additional mode: 1366x768 @ 24.00 - Full Screen
21:19:28 T:2124 NOTICE: Additional mode: 1366x768 @ 30.00i - Full Screen
21:19:28 T:2124 NOTICE: Previous line repeats 2 times.
21:19:28 T:2124 NOTICE: Additional mode: 1600x900 @ 59.94 - Full Screen
21:19:28 T:2124 NOTICE: Previous line repeats 2 times.
21:19:28 T:2124 NOTICE: Additional mode: 1600x900 @ 29.97i - Full Screen
21:19:28 T:2124 NOTICE: Previous line repeats 2 times.
21:19:28 T:2124 NOTICE: Additional mode: 1600x900 @ 60.00 - Full Screen
21:19:28 T:2124 NOTICE: Previous line repeats 2 times.
21:19:28 T:2124 NOTICE: Additional mode: 1600x900 @ 29.97 - Full Screen
21:19:28 T:2124 NOTICE: Additional mode: 1600x900 @ 30.00 - Full Screen
21:19:28 T:2124 NOTICE: Additional mode: 1600x900 @ 29.97 - Full Screen
21:19:28 T:2124 NOTICE: Additional mode: 1600x900 @ 30.00 - Full Screen
21:19:28 T:2124 NOTICE: Additional mode: 1600x900 @ 29.97 - Full Screen
21:19:28 T:2124 NOTICE: Additional mode: 1600x900 @ 30.00 - Full Screen
21:19:28 T:2124 NOTICE: Additional mode: 1600x900 @ 23.98 - Full Screen
21:19:28 T:2124 NOTICE: Additional mode: 1600x900 @ 24.00 - Full Screen
21:19:28 T:2124 NOTICE: Additional mode: 1600x900 @ 23.98 - Full Screen
21:19:28 T:2124 NOTICE: Additional mode: 1600x900 @ 24.00 - Full Screen
21:19:28 T:2124 NOTICE: Additional mode: 1600x900 @ 23.98 - Full Screen
21:19:28 T:2124 NOTICE: Additional mode: 1600x900 @ 24.00 - Full Screen
21:19:28 T:2124 NOTICE: Additional mode: 1600x900 @ 30.00i - Full Screen
21:19:28 T:2124 NOTICE: Previous line repeats 2 times.
21:19:28 T:2124 NOTICE: Additional mode: 1600x1024 @ 59.94 - Full Screen
21:19:28 T:2124 NOTICE: Previous line repeats 2 times.
21:19:28 T:2124 NOTICE: Additional mode: 1600x1024 @ 29.97i - Full Screen
21:19:28 T:2124 NOTICE: Previous line repeats 2 times.
21:19:28 T:2124 NOTICE: Additional mode: 1600x1024 @ 60.00 - Full Screen
21:19:28 T:2124 NOTICE: Previous line repeats 2 times.
21:19:28 T:2124 NOTICE: Additional mode: 1600x1024 @ 29.97 - Full Screen
21:19:28 T:2124 NOTICE: Additional mode: 1600x1024 @ 30.00 - Full Screen
21:19:28 T:2124 NOTICE: Additional mode: 1600x1024 @ 29.97 - Full Screen
21:19:28 T:2124 NOTICE: Additional mode: 1600x1024 @ 30.00 - Full Screen
21:19:28 T:2124 NOTICE: Additional mode: 1600x1024 @ 29.97 - Full Screen
21:19:28 T:2124 NOTICE: Additional mode: 1600x1024 @ 30.00 - Full Screen
21:19:28 T:2124 NOTICE: Additional mode: 1600x1024 @ 23.98 - Full Screen
21:19:28 T:2124 NOTICE: Additional mode: 1600x1024 @ 24.00 - Full Screen
21:19:28 T:2124 NOTICE: Additional mode: 1600x1024 @ 23.98 - Full Screen
21:19:28 T:2124 NOTICE: Additional mode: 1600x1024 @ 24.00 - Full Screen
21:19:28 T:2124 NOTICE: Additional mode: 1600x1024 @ 23.98 - Full Screen
21:19:28 T:2124 NOTICE: Additional mode: 1600x1024 @ 24.00 - Full Screen
21:19:28 T:2124 NOTICE: Additional mode: 1600x1024 @ 30.00i - Full Screen
21:19:28 T:2124 NOTICE: Previous line repeats 2 times.
21:19:28 T:2124 NOTICE: Additional mode: 1680x1050 @ 59.94 - Full Screen
21:19:28 T:2124 NOTICE: Previous line repeats 2 times.
21:19:28 T:2124 NOTICE: Additional mode: 1680x1050 @ 29.97i - Full Screen
21:19:28 T:2124 NOTICE: Previous line repeats 2 times.
21:19:28 T:2124 NOTICE: Additional mode: 1680x1050 @ 60.00 - Full Screen
21:19:28 T:2124 NOTICE: Previous line repeats 2 times.
21:19:28 T:2124 NOTICE: Additional mode: 1680x1050 @ 29.97 - Full Screen
21:19:28 T:2124 NOTICE: Additional mode: 1680x1050 @ 30.00 - Full Screen
21:19:28 T:2124 NOTICE: Additional mode: 1680x1050 @ 29.97 - Full Screen
21:19:28 T:2124 NOTICE: Additional mode: 1680x1050 @ 30.00 - Full Screen
21:19:28 T:2124 NOTICE: Additional mode: 1680x1050 @ 29.97 - Full Screen
21:19:28 T:2124 NOTICE: Additional mode: 1680x1050 @ 30.00 - Full Screen
21:19:28 T:2124 NOTICE: Additional mode: 1680x1050 @ 23.98 - Full Screen
21:19:28 T:2124 NOTICE: Additional mode: 1680x1050 @ 24.00 - Full Screen
21:19:28 T:2124 NOTICE: Additional mode: 1680x1050 @ 23.98 - Full Screen
21:19:28 T:2124 NOTICE: Additional mode: 1680x1050 @ 24.00 - Full Screen
21:19:28 T:2124 NOTICE: Additional mode: 1680x1050 @ 23.98 - Full Screen
21:19:28 T:2124 NOTICE: Additional mode: 1680x1050 @ 24.00 - Full Screen
21:19:28 T:2124 NOTICE: Additional mode: 1680x1050 @ 30.00i - Full Screen
21:19:28 T:2124 NOTICE: Previous line repeats 2 times.
21:19:28 T:2124 NOTICE: Additional mode: 1768x992 @ 29.97i - Full Screen
21:19:28 T:2124 NOTICE: Previous line repeats 2 times.
21:19:28 T:2124 NOTICE: Additional mode: 1768x992 @ 30.00i - Full Screen
21:19:28 T:2124 NOTICE: Previous line repeats 2 times.
21:19:28 T:2124 NOTICE: Additional mode: 1920x1080 @ 59.94 - Full Screen
21:19:28 T:2124 NOTICE: Additional mode: 1920x1080 @ 29.97i - Full Screen
21:19:28 T:2124 NOTICE: Additional mode: 1920x1080 @ 60.00 - Full Screen
21:19:28 T:2124 NOTICE: Additional mode: 1920x1080 @ 29.97 - Full Screen
21:19:28 T:2124 NOTICE: Additional mode: 1920x1080 @ 30.00 - Full Screen
21:19:28 T:2124 NOTICE: Additional mode: 1920x1080 @ 23.98 - Full Screen
21:19:28 T:2124 NOTICE: Additional mode: 1920x1080 @ 24.00 - Full Screen
21:19:28 T:2124 NOTICE: Additional mode: 1920x1080 @ 30.00i - Full Screen
21:19:28 T:2124 NOTICE: Checking resolution 16
21:19:28 T:2124 DEBUG: CWinEventsWin32::WndProc: window resize event
21:19:28 T:2124 DEBUG: CWinEventsWin32::WndProc: window move event
21:19:28 T:2124 DEBUG: CWinSystemWin32::ResizeInternal - resizing due to size change (0,0,1920,1080 fullscreen)->(0,0,1920,1080 fullscreen)
21:19:28 T:2124 DEBUG: CWinEventsWin32::WndProcWindow is active
21:19:28 T:2124 DEBUG: CRenderSystemDX::InitRenderSystem - trying D3D9Ex...
21:19:28 T:2124 DEBUG: CRenderSystemDX::InitRenderSystem - using D3D9Ex
21:19:28 T:2124 DEBUG: CRenderSystemDX::CreateDevice on adapter 0
21:19:28 T:2124 DEBUG: CRenderSystemDX::CreateDevice - using hardware vertex processing
21:19:28 T:2124 DEBUG: CRenderSystemDX::CreateDevice - adapter 0: nvd3dum.dll, NVIDIA GeForce 210 , VendorId 4318, DeviceId 2661
21:19:28 T:2124 DEBUG: CRenderSystemDX::CreateDevice - using D3DCAPS2_DYNAMICTEXTURES
21:19:28 T:2124 DEBUG: CRenderSystemDX::CreateDevice - texture caps: 0x0001ECC5
21:19:28 T:2124 DEBUG: CRenderSystemDX::CreateDevice - RENDER_CAPS_DXT
21:19:28 T:2124 DEBUG: CRenderSystemDX::CreateDevice - RENDER_CAPS_NPOT
21:19:28 T:2124 DEBUG: CRenderSystemDX::CreateDevice - RENDER_CAPS_DXT_NPOT
21:19:28 T:2124 DEBUG: CRenderSystemDX::CreateDevice - nVidia workaround - disabling RENDER_CAPS_DXT_NPOT
21:19:28 T:2124 DEBUG: CWinSystemWin32::SetFullScreen (windowed fullscreen) on screen 0 with size 1920x1080, refresh 60.000000
21:19:28 T:2124 DEBUG: CRenderManager::UpdateDisplayLatency - Latency set to 0 msec
21:19:28 T:2124 INFO: load default splash image: C:\Program Files (x86)\XBMC\media\Splash.png
21:19:28 T:2124 DEBUG: SECTION:LoadDLL(special://xbmcbin/system/ImageLib.dll)
21:19:28 T:2124 INFO: load keymapping
21:19:28 T:2124 INFO: Loading special://xbmc/system/keymaps/appcommand.xml
21:19:28 T:2124 INFO: Loading special://xbmc/system/keymaps/gamepad.xml
21:19:28 T:2124 INFO: Loading special://xbmc/system/keymaps/joystick.Alienware.Dual.Compatible.Controller.xml
21:19:28 T:2124 INFO: Loading special://xbmc/system/keymaps/joystick.AppleRemote.xml
21:19:28 T:2124 INFO: Loading special://xbmc/system/keymaps/joystick.Harmony.xml
21:19:28 T:2124 INFO: Loading special://xbmc/system/keymaps/joystick.Interact.AxisPad.xml
21:19:28 T:2124 INFO: Loading special://xbmc/system/keymaps/joystick.Logitech.RumblePad.2.xml
21:19:28 T:2124 INFO: Loading special://xbmc/system/keymaps/joystick.Microsoft.Xbox.360.Controller.xml
21:19:28 T:2124 INFO: Loading special://xbmc/system/keymaps/joystick.Microsoft.Xbox.Controller.S.xml
21:19:28 T:2124 INFO: Loading special://xbmc/system/keymaps/joystick.PS3.Remote.Keyboard.xml
21:19:28 T:2124 INFO: Loading special://xbmc/system/keymaps/joystick.Sony.PLAYSTATION(R)3.Controller.xml
21:19:28 T:2124 INFO: Loading special://xbmc/system/keymaps/joystick.WiiRemote.xml
21:19:28 T:2124 INFO: Loading special://xbmc/system/keymaps/keyboard.xml
21:19:28 T:2124 INFO: Loading special://xbmc/system/keymaps/mouse.xml
21:19:28 T:2124 INFO: Loading special://xbmc/system/keymaps/remote.xml
21:19:28 T:2124 INFO: Loading special://xbmc/system/IRSSmap.xml
21:19:28 T:2124 INFO: * Adding remote mapping for device 'Microsoft MCE'
21:19:28 T:2124 INFO: * Adding remote mapping for device 'Abstract'
21:19:28 T:2124 DEBUG: CButtonTranslator::Load - no userdata IRSSmap.xml found, skipping
21:19:28 T:2124 INFO: GUI format 1920x1080, Display 1920x1080 @ 60.00 - Full Screen
21:19:28 T:2124 DEBUG: guilib: Fill viewport on change for solving rendering passes
21:19:28 T:2124 DEBUG: SECTION:LoadDLL(special://xbmcbin/system/libcurl.dll)
21:19:29 T:2124 NOTICE: Running database version Addons15
21:19:29 T:2124 DEBUG: CDatabaseManager::Initialize, updating databases...
21:19:29 T:2124 NOTICE: Running database version ViewModes4
21:19:29 T:2124 NOTICE: Running database version Textures13
21:19:29 T:2124 NOTICE: Running database version MyMusic32
21:19:29 T:2124 NOTICE: Running database version MyVideos75
21:19:29 T:2124 NOTICE: Running database version TV22
21:19:29 T:2124 NOTICE: Running database version Epg7
21:19:29 T:2124 DEBUG: CDatabaseManager::Initialize, updating databases... DONE
21:19:29 T:2124 NOTICE: initializing playlistplayer
21:19:29 T:2124 NOTICE: DONE initializing playlistplayer
21:19:29 T:2124 DEBUG: DPMS: supported power-saving modes: OFF STANDBY
21:19:29 T:2124 DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc
21:19:29 T:2124 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnClear
21:19:29 T:2124 INFO: Unloading old skin ...
21:19:29 T:2124 INFO: load skin from: C:\Program Files (x86)\XBMC\addons\skin.confluence (version: 2.1.5)
21:19:29 T:2124 INFO: load fonts for skin...
21:19:29 T:2124 INFO: Loading fonts from C:\Program Files (x86)\XBMC\addons\skin.confluence\720p\Font.xml
21:19:29 T:2124 DEBUG: POParser: PO file has Win Style Line Endings. Converted in memory to Linux LF for file: C:\Program Files (x86)\XBMC\addons\skin.confluence\language\english\strings.po
21:19:29 T:2124 DEBUG: POParser: loaded 131 strings from file C:\Program Files (x86)\XBMC\addons\skin.confluence\language\english\strings.po
21:19:29 T:2124 INFO: Loading skin includes from C:\Program Files (x86)\XBMC\addons\skin.confluence\720p\includes.xml
21:19:29 T:2408 DEBUG: CRemoteControl::Connect - connecting to: 127.0.0.1:24000 ...
21:19:29 T:2124 INFO: load new skin...
21:19:29 T:2124 INFO: Loading user windows, path C:\Program Files (x86)\XBMC\addons\skin.confluence\720p
21:19:29 T:2124 DEBUG: Load Skin XML: 32.86ms
21:19:29 T:2124 INFO: initialize new skin...
21:19:29 T:2124 DEBUG: guilib: Fill viewport on change for solving rendering passes
21:19:29 T:2124 INFO: Loading skin file: Pointer.xml, load type: LOAD_ON_GUI_INIT
21:19:29 T:2124 DEBUG: CTextureBundleXBT::OpenBundle - Opened bundle C:\Program Files (x86)\XBMC\addons\skin.confluence\media\Textures.xbt
21:19:29 T:2124 INFO: Loading skin file: DialogVolumeBar.xml, load type: LOAD_ON_GUI_INIT
21:19:29 T:2124 INFO: Loading skin file: DialogKaiToast.xml, load type: LOAD_ON_GUI_INIT
21:19:29 T:2124 INFO: Loading skin file: DialogMuteBug.xml, load type: LOAD_ON_GUI_INIT
21:19:29 T:2124 INFO: Loading skin file: DialogSeekBar.xml, load type: LOAD_ON_GUI_INIT
21:19:29 T:2124 INFO: Loading skin file: DialogBusy.xml, load type: LOAD_ON_GUI_INIT
21:19:29 T:2124 INFO: Loading skin file: DialogExtendedProgressBar.xml, load type: LOAD_ON_GUI_INIT
21:19:29 T:2124 INFO: Loading C:\Program Files (x86)\XBMC\addons\skin.confluence\sounds\sounds.xml
21:19:29 T:2124 INFO: CAEWAVLoader::Initialize - Sound Loaded: C:\Program Files (x86)\XBMC\addons\skin.confluence\sounds\cursor.wav
21:19:29 T:2124 INFO: CAEWAVLoader::Initialize - Sound Loaded: C:\Program Files (x86)\XBMC\addons\skin.confluence\sounds\click.wav
21:19:29 T:2124 INFO: CAEWAVLoader::Initialize - Sound Loaded: C:\Program Files (x86)\XBMC\addons\skin.confluence\sounds\back.wav
21:19:29 T:2124 DEBUG: AERemap: Downmix normalization is disabled
21:19:29 T:2124 INFO: CAEWAVLoader::Initialize - Sound Loaded: C:\Program Files (x86)\XBMC\addons\skin.confluence\sounds\shutter.wav
21:19:29 T:2124 INFO: CAEWAVLoader::Initialize - Sound Loaded: C:\Program Files (x86)\XBMC\addons\skin.confluence\sounds\notify.wav
21:19:29 T:2124 DEBUG: AERemap: Downmix normalization is disabled
21:19:29 T:2124 INFO: CAEWAVLoader::Initialize - Sound Loaded: C:\Program Files (x86)\XBMC\addons\skin.confluence\sounds\out.wav
21:19:29 T:2124 DEBUG: AERemap: Downmix normalization is disabled
21:19:29 T:2124 INFO: skin loaded...
21:19:29 T:2124 INFO: JSONRPC v6.0.3: Successfully initialized
21:19:29 T:2124 DEBUG: ADDON: Starting service addons.
21:19:29 T:2124 INFO: initializing python engine.
21:19:30 T:2124 DEBUG: new python thread created. id=1
21:19:30 T:2124 INFO: initializing python engine.
21:19:30 T:2124 DEBUG: new python thread created. id=2
21:19:30 T:2124 INFO: initializing python engine.
21:19:30 T:2124 DEBUG: new python thread created. id=3
21:19:30 T:2692 NOTICE: Thread XBPyThread start, auto delete: false
21:19:30 T:2692 DEBUG: Python thread: start processing
21:19:30 T:2124 INFO: initializing python engine.
21:19:30 T:2124 DEBUG: new python thread created. id=4
21:19:30 T:2124 INFO: initializing python engine.
21:19:30 T:2124 DEBUG: new python thread created. id=5
21:19:30 T:2124 DEBUG: Activating window ID: 12999
21:19:30 T:2124 DEBUG: ------ Window Init (Startup.xml) ------
21:19:30 T:2124 INFO: Loading skin file: Startup.xml, load type: LOAD_EVERY_TIME
21:19:30 T:2124 INFO: removing tempfiles
21:19:30 T:2124 NOTICE: CApplication::UpdateLibraries - Starting video library startup scan
21:19:30 T:2124 DEBUG: ADDON: Starting service addons.
21:19:30 T:2124 INFO: initializing python engine.
21:19:30 T:2124 DEBUG: new python thread created. id=6
21:19:30 T:2124 NOTICE: initialize done
21:19:30 T:2124 DEBUG: CJoystick::Initialize : No Joystick found
21:19:30 T:2124 NOTICE: Running the application...
21:19:30 T:2124 DEBUG: CApplication::ExecuteXBMCAction : Translating ReplaceWindow(Home)
21:19:30 T:2124 DEBUG: CApplication::ExecuteXBMCAction : To ReplaceWindow(Home)
21:19:30 T:2124 DEBUG: Activating window ID: 10000
21:19:30 T:2684 NOTICE: Thread XBPyThread start, auto delete: false
21:19:30 T:2684 DEBUG: Python thread: start processing
21:19:30 T:2704 NOTICE: Thread XBPyThread start, auto delete: false
21:19:30 T:2704 DEBUG: Python thread: start processing
21:19:30 T:1168 NOTICE: Thread CVideoInfoScanner start, auto delete: false
21:19:30 T:2664 NOTICE: Thread XBPyThread start, auto delete: false
21:19:30 T:2664 DEBUG: Python thread: start processing
21:19:30 T:2708 NOTICE: Thread XBPyThread start, auto delete: false
21:19:30 T:2708 DEBUG: Python thread: start processing
21:19:30 T:2756 NOTICE: Thread XBPyThread start, auto delete: false
21:19:30 T:2756 DEBUG: Python thread: start processing
21:19:30 T:2124 DEBUG: ------ Window Init () ------
21:19:30 T:2124 DEBUG: ------ Window Init (Pointer.xml) ------
21:19:30 T:2408 DEBUG: CRemoteControl::Connect - failed to connect
21:19:30 T:2408 INFO: CRemoteControl::Process - failed to connect to irss, will keep retrying every 5 seconds
21:19:30 T:2124 DEBUG: ------ Window Deinit (Startup.xml) ------
21:19:30 T:2124 DEBUG: ------ Window Init (Home.xml) ------
21:19:30 T:2124 INFO: Loading skin file: Home.xml, load type: KEEP_IN_MEMORY
21:19:30 T:2692 NOTICE: -->Python Interpreter Initialized<--
21:19:30 T:2692 DEBUG: XBPyThread::Process - The source file to load is C:\Users\TVUser\AppData\Roaming\XBMC\addons\service.skin.widgets\default.py
21:19:30 T:2692 DEBUG: XBPyThread::Process - Setting the Python path to C:\Users\TVUser\AppData\Roaming\XBMC\addons\service.skin.widgets;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.xbmcswift\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.bigpictures\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.simplejson\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.beautifulsoup4\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.brightcove\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.myconnpy\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.beautifulsoup\lib;C:\Program Files (x86)\XBMC\addons\script.module.pil\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.common.plugin.cache\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.simple.downloader\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.requests\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\plugin.image.500px\resources\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.buggalo\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.parsedom\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.xbmcswift2\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.web.viewer\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.elementtree\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.feedparser\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;
21:19:30 T:2692 DEBUG: XBPyThread::Process - Entering source directory C:\Users\TVUser\AppData\Roaming\XBMC\addons\service.skin.widgets
21:19:30 T:2692 DEBUG: Instantiating addon using automatically obtained id of "service.skin.widgets" dependent on version 2.1.0 of the xbmc.python api
21:19:30 T:2124 DEBUG: XBPython::Process - no profile autoexec.py (C:\Users\TVUser\AppData\Roaming\XBMC\userdata\autoexec.py) found, skipping
21:19:30 T:2124 DEBUG: CNetwork::NetworkMessage - Starting network services
21:19:30 T:2112 NOTICE: Thread Jobworker start, auto delete: true
21:19:30 T:2124 NOTICE: Webserver: Starting...
21:19:31 T:2124 NOTICE: WebServer: Started the webserver
21:19:31 T:2124 NOTICE: starting upnp server
21:19:31 T:2124 NOTICE: starting upnp renderer
21:19:31 T:2124 NOTICE: ES: Starting event server
21:19:31 T:2124 INFO: JSONRPC Server: Unable to get bluetooth socket
21:19:31 T:2124 INFO: JSONRPC Server: Successfully initialized
21:19:31 T:2124 NOTICE: starting zeroconf publishing
21:19:31 T:2700 NOTICE: Thread CEventServer start, auto delete: false
21:19:31 T:2700 NOTICE: ES: Starting UDP Event server on 0.0.0.0:9777
21:19:31 T:2700 NOTICE: UDP: Listening on port 9777
21:19:31 T:1016 NOTICE: Thread CTCPServer start, auto delete: false
21:19:31 T:2124 DEBUG: ZeroconfWIN:Bonjour version is 333.10
21:19:31 T:2124 INFO: AIRPLAY Server: Successfully initialized
21:19:31 T:2124 DEBUG: SECTION:LoadDLL(special://xbmcbin/system/airplay/libshairplay-1.dll)
21:19:31 T:2124 DEBUG: CLastfmScrobbler: Clearing session.
21:19:31 T:2124 DEBUG: CLibrefmScrobbler: Clearing session.
21:19:31 T:2124 DEBUG: ------ Window Init (DialogExtendedProgressBar.xml) ------
21:19:31 T:1168 NOTICE: VideoInfoScanner: Starting scan ..
21:19:31 T:1168 DEBUG: CAnnouncementManager - Announcement: OnScanStarted from xbmc
21:19:31 T:1168 DEBUG: GOT ANNOUNCEMENT, type: 16, from xbmc, message OnScanStarted
21:19:31 T:116 NOTICE: Thread AirPlayServer start, auto delete: false
21:19:31 T:2220 NOTICE: Thread CRssReader start, auto delete: false
21:19:31 T:2220 DEBUG: CurlFile::Open(0CFBF7C8) http://feeds.feedburner.com/xbmc
21:19:31 T:2220 INFO: XCURL::DllLibCurlGlobal::easy_aquire - Created session to http://feeds.feedburner.com
21:19:31 T:2112 DEBUG: CRecentlyAddedJob::UpdateMusic() - Running RecentlyAdded home screen update
21:19:31 T:2684 NOTICE: -->Python Interpreter Initialized<--
21:19:31 T:2684 DEBUG: XBPyThread::Process - The source file to load is C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.tvguide\service.py
21:19:31 T:2704 NOTICE: -->Python Interpreter Initialized<--
21:19:31 T:2704 DEBUG: XBPyThread::Process - The source file to load is C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.artwork.downloader\service.py
21:19:31 T:2664 NOTICE: -->Python Interpreter Initialized<--
21:19:31 T:2664 DEBUG: XBPyThread::Process - The source file to load is C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.simple.downloader\default.py
21:19:31 T:2708 NOTICE: -->Python Interpreter Initialized<--
21:19:31 T:2708 DEBUG: XBPyThread::Process - The source file to load is C:\Users\TVUser\AppData\Roaming\XBMC\addons\service.qlock\default.py
21:19:31 T:2756 NOTICE: -->Python Interpreter Initialized<--
21:19:31 T:2756 DEBUG: XBPyThread::Process - The source file to load is C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.common.plugin.cache\default.py
21:19:31 T:2684 DEBUG: XBPyThread::Process - Setting the Python path to C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.tvguide;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.xbmcswift\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.bigpictures\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.simplejson\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.beautifulsoup4\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.brightcove\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.myconnpy\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.beautifulsoup\lib;C:\Program Files (x86)\XBMC\addons\script.module.pil\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.common.plugin.cache\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.simple.downloader\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.requests\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\plugin.image.500px\resources\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.buggalo\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.parsedom\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.xbmcswift2\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.web.viewer\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.elementtree\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.feedparser\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;
21:19:31 T:2684 DEBUG: XBPyThread::Process - Entering source directory C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.tvguide
21:19:31 T:2704 DEBUG: XBPyThread::Process - Setting the Python path to C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.artwork.downloader;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.xbmcswift\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.bigpictures\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.simplejson\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.beautifulsoup4\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.brightcove\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.myconnpy\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.beautifulsoup\lib;C:\Program Files (x86)\XBMC\addons\script.module.pil\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.common.plugin.cache\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.simple.downloader\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.requests\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\plugin.image.500px\resources\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.buggalo\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.parsedom\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.xbmcswift2\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.web.viewer\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.elementtree\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.feedparser\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;
21:19:31 T:2704 DEBUG: XBPyThread::Process - Entering source directory C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.artwork.downloader
21:19:31 T:2664 DEBUG: XBPyThread::Process - Setting the Python path to C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.simple.downloader;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.xbmcswift\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.bigpictures\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.simplejson\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.beautifulsoup4\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.brightcove\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.myconnpy\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.beautifulsoup\lib;C:\Program Files (x86)\XBMC\addons\script.module.pil\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.common.plugin.cache\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.simple.downloader\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.requests\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\plugin.image.500px\resources\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.buggalo\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.parsedom\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.xbmcswift2\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.web.viewer\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.elementtree\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.feedparser\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;
21:19:31 T:2664 DEBUG: XBPyThread::Process - Entering source directory C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.simple.downloader
21:19:31 T:2708 DEBUG: XBPyThread::Process - Setting the Python path to C:\Users\TVUser\AppData\Roaming\XBMC\addons\service.qlock;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.xbmcswift\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.bigpictures\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.simplejson\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.beautifulsoup4\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.brightcove\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.myconnpy\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.beautifulsoup\lib;C:\Program Files (x86)\XBMC\addons\script.module.pil\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.common.plugin.cache\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.simple.downloader\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.requests\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\plugin.image.500px\resources\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.buggalo\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.parsedom\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.xbmcswift2\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.web.viewer\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.elementtree\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.feedparser\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;
21:19:31 T:2708 DEBUG: XBPyThread::Process - Entering source directory C:\Users\TVUser\AppData\Roaming\XBMC\addons\service.qlock
21:19:31 T:2684 DEBUG: Instantiating addon using automatically obtained id of "script.tvguide" dependent on version 2.1.0 of the xbmc.python api
21:19:31 T:2708 DEBUG: Instantiating addon using automatically obtained id of "service.qlock" dependent on version 2.1.0 of the xbmc.python api
21:19:31 T:2704 DEBUG: Instantiating addon using automatically obtained id of "script.artwork.downloader" dependent on version 2.1.0 of the xbmc.python api
21:19:31 T:2664 DEBUG: Instantiating addon using automatically obtained id of "script.module.simple.downloader" dependent on version 2.1.0 of the xbmc.python api
21:19:31 T:2756 DEBUG: XBPyThread::Process - Setting the Python path to C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.common.plugin.cache;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.xbmcswift\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.bigpictures\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.simplejson\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.beautifulsoup4\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.brightcove\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.myconnpy\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.beautifulsoup\lib;C:\Program Files (x86)\XBMC\addons\script.module.pil\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.common.plugin.cache\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.simple.downloader\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.requests\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\plugin.image.500px\resources\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.buggalo\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.parsedom\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.xbmcswift2\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.web.viewer\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.elementtree\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.feedparser\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;
21:19:31 T:2756 DEBUG: XBPyThread::Process - Entering source directory C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.common.plugin.cache
21:19:31 T:2112 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
21:19:31 T:2220 DEBUG: Got rss feed: http://feeds.feedburner.com/xbmc
21:19:31 T:2220 DEBUG: RSS feed encoding: UTF-8
21:19:31 T:2220 DEBUG: Parsed rss feed: http://feeds.feedburner.com/xbmc
21:19:31 T:2220 DEBUG: Thread CRssReader 2220 terminating
21:19:31 T:2112 DEBUG: CMusicDatabase::GetRecentlyAddedAlbums query: select * from albumview where strAlbum != '' order by idAlbum desc limit 10
21:19:31 T:2756 DEBUG: Instantiating addon using automatically obtained id of "script.common.plugin.cache" dependent on version 2.1.0 of the xbmc.python api
21:19:32 T:2112 DEBUG: CRecentlyAddedJob::UpdateVideos() - Running RecentlyAdded home screen update
21:19:32 T:2112 DEBUG: CVideoDatabase::RunQuery took 19 ms for 10 items query: select * from movieview ORDER BY dateAdded desc, idMovie desc LIMIT 10
21:19:32 T:2112 DEBUG: CVideoDatabase::RunQuery took 152 ms for 10 items query: select * from episodeview ORDER BY dateAdded desc, idEpisode desc LIMIT 10
21:19:32 T:1572 NOTICE: Thread Jobworker start, auto delete: true
21:19:32 T:1572 DEBUG: ZeroconfWIN: identifier: servers.jsonrpc-http type: _xbmc-jsonrpc-h._tcp name:XBMCDesktop port:80
21:19:32 T:1572 DEBUG: ZeroconfWIN: identifier: servers.jsonrpc-tpc type: _xbmc-jsonrpc._tcp name:XBMCDesktop port:9090
21:19:32 T:1572 DEBUG: ZeroconfWIN: identifier: servers.webserver type: _http._tcp name:XBMCDesktop port:80
21:19:32 T:1572 DEBUG: ZeroconfWIN: identifier: servers.eventserver type: _xbmc-events._udp name:XBMCDesktop port:9777
21:19:32 T:1572 DEBUG: ZeroconfWIN: identifier: servers.airplay type: _airplay._tcp name:XBMCDesktop port:36667
21:19:32 T:1572 DEBUG: ZeroconfWIN: key:deviceid, value:00:13:72:22:27:35
21:19:32 T:1572 DEBUG: ZeroconfWIN: key:features, value:0x77
21:19:32 T:1572 DEBUG: ZeroconfWIN: key:model, value:Xbmc,1
21:19:32 T:1572 DEBUG: ZeroconfWIN: key:srcvers, value:101.28
21:19:32 T:1572 DEBUG: ZeroconfWIN: identifier: servers.airtunes type: _raop._tcp name:001372222735@XBMCDesktop port:36666
21:19:32 T:1572 DEBUG: ZeroconfWIN: key:txtvers, value:1
21:19:32 T:1572 DEBUG: ZeroconfWIN: key:cn, value:0,1
21:19:32 T:1572 DEBUG: ZeroconfWIN: key:ch, value:2
21:19:32 T:1572 DEBUG: ZeroconfWIN: key:ek, value:1
21:19:32 T:1572 DEBUG: ZeroconfWIN: key:et, value:0,1
21:19:32 T:1572 DEBUG: ZeroconfWIN: key:sv, value:false
21:19:32 T:1572 DEBUG: ZeroconfWIN: key:tp, value:UDP
21:19:32 T:1572 DEBUG: ZeroconfWIN: key:sm, value:false
21:19:32 T:1572 DEBUG: ZeroconfWIN: key:ss, value:16
21:19:32 T:1572 DEBUG: ZeroconfWIN: key:sr, value:44100
21:19:32 T:1572 DEBUG: ZeroconfWIN: key:pw, value:false
21:19:32 T:1572 DEBUG: ZeroconfWIN: key:vn, value:3
21:19:32 T:1572 DEBUG: ZeroconfWIN: key:da, value:true
21:19:32 T:1572 DEBUG: ZeroconfWIN: key:vs, value:130.14
21:19:32 T:1572 DEBUG: ZeroconfWIN: key:md, value:0,1,2
21:19:32 T:1572 DEBUG: ZeroconfWIN: key:am, value:Xbmc,1
21:19:32 T:1572 DEBUG: CThumbExtractor::DoWork - trying to extract filestream details from video file E:\Video\TVSHOWS\MODERN FAMILY\Season4\Modern.Family.S04E21.HDTV.x264-LOL.mp4
21:19:32 T:2112 DEBUG: CVideoDatabase::RunQuery took 2 ms for 0 items query: select * from musicvideoview ORDER BY dateAdded desc, idMVideo desc LIMIT 10
21:19:32 T:2112 DEBUG: CRecentlyAddedJob::UpdateTotal() - Running RecentlyAdded home screen update
21:19:32 T:1572 DEBUG: SECTION:LoadDLL(special://xbmcbin/system/players/dvdplayer/avutil-51.dll)
21:19:33 T:1572 DEBUG: SECTION:LoadDLL(special://xbmcbin/system/players/dvdplayer/avcodec-53.dll)
21:19:33 T:1572 DEBUG: SECTION:LoadDLL(special://xbmcbin/system/players/dvdplayer/avformat-53.dll)
21:19:33 T:2124 DEBUG: ZeroconfWIN: XBMCDesktop._xbmc-jsonrpc-h._tcp.local. now registered and active
21:19:33 T:2124 DEBUG: ZeroconfWIN: XBMCDesktop._xbmc-jsonrpc._tcp.local. now registered and active
21:19:33 T:1572 DEBUG: CDVDDemuxFFmpeg::Open - probing detected format [mov,mp4,m4a,3gp,3g2,mj2]
21:19:33 T:1572 DEBUG: CDVDDemuxFFmpeg::Open - avformat_find_stream_info starting
21:19:33 T:1572 DEBUG: CDVDDemuxFFmpeg::Open - av_find_stream_info finished
21:19:33 T:1572 INFO: ffmpeg[624]: Input #0, mov,mp4,m4a,3gp,3g2,mj2, from 'E:\Video\TVSHOWS\MODERN FAMILY\Season4\Modern.Family.S04E21.HDTV.x264-LOL.mp4':
21:19:33 T:1572 INFO: ffmpeg[624]: Metadata:
21:19:33 T:1572 INFO: ffmpeg[624]: major_brand : isom
21:19:33 T:1572 INFO: ffmpeg[624]: minor_version : 1
21:19:33 T:1572 INFO: ffmpeg[624]: compatible_brands: isom
21:19:33 T:1572 INFO: ffmpeg[624]: creation_time : 2013-04-30 15:13:57
21:19:33 T:1572 INFO: ffmpeg[624]: Duration: 00:21:46.41, start: 0.000000, bitrate: 1092 kb/s
21:19:33 T:1572 INFO: ffmpeg[624]: Stream #0:0(und): Video: h264 (High) (avc1 / 0x31637661), yuv420p, 720x404, 991 kb/s, 23.98 fps, 23.98 tbr, 24k tbn, 47.95 tbc
21:19:33 T:1572 INFO: ffmpeg[624]: Metadata:
21:19:33 T:1572 INFO: ffmpeg[624]: creation_time : 2013-05-01 06:56:53
21:19:33 T:1572 INFO: ffmpeg[624]: handler_name : GPAC ISO Video Handler
21:19:33 T:1572 INFO: ffmpeg[624]: Stream #0:1(und): Audio: aac (mp4a / 0x6134706D), 48000 Hz, stereo, s16, 96 kb/s
21:19:33 T:1572 INFO: ffmpeg[624]: Metadata:
21:19:33 T:1572 INFO: ffmpeg[624]: creation_time : 2013-04-30 15:14:01
21:19:33 T:1572 INFO: ffmpeg[624]: handler_name : GPAC ISO Audio Handler
21:19:33 T:2124 DEBUG: ZeroconfWIN: XBMCDesktop._http._tcp.local. now registered and active
21:19:33 T:2124 DEBUG: ZeroconfWIN: XBMCDesktop._xbmc-events._udp.local. now registered and active
21:19:33 T:2124 DEBUG: ZeroconfWIN: XBMCDesktop._airplay._tcp.local. now registered and active
21:19:33 T:2124 DEBUG: ZeroconfWIN: 001372222735@XBMCDesktop._raop._tcp.local. now registered and active
21:19:33 T:1168 DEBUG: VideoInfoScanner: Skipping dir 'E:\Video\MOVIES\' due to no change
21:19:33 T:1168 DEBUG: VideoInfoScanner: Skipping dir 'E:\Video\MOVIES\3 Idiots 2009 Hindi\' due to no change (fasthash)
21:19:33 T:1168 DEBUG: VideoInfoScanner: Skipping dir 'E:\Video\MOVIES\Abraham Lincoln Vampire Hunter\' due to no change (fasthash)
21:19:33 T:1168 DEBUG: VideoInfoScanner: Skipping dir 'E:\Video\MOVIES\Agneepath\' due to no change (fasthash)
21:19:33 T:1168 DEBUG: VideoInfoScanner: Skipping dir 'E:\Video\MOVIES\Arbitrage (2012)\' due to no change (fasthash)
21:19:33 T:1168 DEBUG: VideoInfoScanner: Skipping dir 'E:\Video\MOVIES\Barfi! (2012) - Blu-Ray - x264 - 720p - mHD - [DDR]\' due to no change (fasthash)
21:19:33 T:1168 DEBUG: VideoInfoScanner: Skipping dir 'E:\Video\MOVIES\Bol Bachchan (2012) - Blu-Ray - x264 - 720p - AC3 - [DDR]\' due to no change (fasthash)
21:19:33 T:1168 DEBUG: VideoInfoScanner: Skipping dir 'E:\Video\MOVIES\Chasing Maveric\' due to no change (fasthash)
21:19:33 T:1168 DEBUG: VideoInfoScanner: Skipping dir 'E:\Video\MOVIES\Cloud Atlas (2012) [1080p]\' due to no change (fasthash)
21:19:33 T:1168 DEBUG: VideoInfoScanner: Skipping dir 'E:\Video\MOVIES\Contagion.2011\' due to no change (fasthash)
21:19:33 T:1168 DEBUG: VideoInfoScanner: Skipping dir 'E:\Video\MOVIES\Devdas\' due to no change (fasthash)
21:19:33 T:1168 DEBUG: VideoInfoScanner: Skipping dir 'E:\Video\MOVIES\Django Unchained (2012) [1080p]\' due to no change (fasthash)
21:19:33 T:1168 DEBUG: VideoInfoScanner: Skipping dir 'E:\Video\MOVIES\Eclipse.2010\' due to no change (fasthash)
21:19:33 T:1168 DEBUG: VideoInfoScanner: Skipping dir 'E:\Video\MOVIES\Ferrari Ki Sawaari - Blu-Ray - 720p - x264 - DTS - [DDR]\' due to no change
21:19:33 T:1168 DEBUG: VideoInfoScanner: Skipping dir 'E:\Video\MOVIES\Ferrari Ki Sawaari - Blu-Ray - 720p - x264 - DTS - [DDR]\Ferrari Ki Sawaari (Screens) - Blu-Ray - 720p - x264 - DTS - [DDR]\' due to no change (fasthash)
21:19:33 T:1168 DEBUG: VideoInfoScanner: Skipping dir 'E:\Video\MOVIES\Forrest Gump (1994)\' due to no change (fasthash)
21:19:33 T:1168 DEBUG: VideoInfoScanner: Skipping dir 'E:\Video\MOVIES\Frankenweenie\' due to no change (fasthash)
21:19:33 T:1168 DEBUG: VideoInfoScanner: Skipping dir 'E:\Video\MOVIES\Funny People\' due to no change (fasthash)
21:19:33 T:1168 DEBUG: VideoInfoScanner: Skipping dir 'E:\Video\MOVIES\G.I.Joe.Retaliation.2013.DVDRip.XviD-PTpOWeR\' due to no change (fasthash)
21:19:33 T:1168 DEBUG: VideoInfoScanner: Skipping dir 'E:\Video\MOVIES\Gangster Squad (2013) [1080p]\' due to no change (fasthash)
21:19:33 T:1168 DEBUG: VideoInfoScanner: Skipping dir 'E:\Video\MOVIES\Guru\' due to no change (fasthash)
21:19:33 T:1168 DEBUG: VideoInfoScanner: Skipping dir 'E:\Video\MOVIES\I Now Pronounce You Chuck and Larry\' due to no change (fasthash)
21:19:33 T:1168 DEBUG: VideoInfoScanner: Skipping dir 'E:\Video\MOVIES\Indiana Jones And The Kingdom Of The Crystal Skull\' due to no change (fasthash)
21:19:34 T:1168 DEBUG: VideoInfoScanner: Skipping dir 'E:\Video\MOVIES\Jab Tak Hai Jaan\' due to no change
21:19:34 T:1168 DEBUG: VideoInfoScanner: Skipping dir 'E:\Video\MOVIES\Jab Tak Hai Jaan\Jab Tak Hai Jaan (Screens) - Blu-Ray - 1080p - x264 - DTS - [DDR]\' due to no change (fasthash)
21:19:34 T:1168 DEBUG: VideoInfoScanner: Skipping dir 'E:\Video\MOVIES\Kal Ho Naa Ho 2003 Hindi 720P BRRip x264 E-SuB xRG\' due to no change
21:19:34 T:1168 DEBUG: VideoInfoScanner: Skipping dir 'E:\Video\MOVIES\Kal Ho Naa Ho 2003 Hindi 720P BRRip x264 E-SuB xRG\Team xRG\' due to no change (fasthash)
21:19:34 T:1168 DEBUG: VideoInfoScanner: Skipping dir 'E:\Video\MOVIES\Kung.Fu.Panda.2.2011.TS.AC3.XViD-EP1C\' due to no change (fasthash)
21:19:34 T:1168 DEBUG: VideoInfoScanner: Skipping dir 'E:\Video\MOVIES\Never.Let.Me.Go\' due to no change (fasthash)
21:19:34 T:1168 DEBUG: VideoInfoScanner: Skipping dir 'E:\Video\MOVIES\New Moon 2009\' due to no change (fasthash)
21:19:34 T:1168 DEBUG: VideoInfoScanner: Skipping dir 'E:\Video\MOVIES\Pinjar [2003]\' due to no change (fasthash)
21:19:34 T:1168 DEBUG: VideoInfoScanner: Skipping dir 'E:\Video\MOVIES\Pirates of the Caribbean On Stranger Tides\' due to no change (fasthash)
21:19:34 T:1168 DEBUG: VideoInfoScanner: Skipping dir 'E:\Video\MOVIES\Pitch.Perfect.2012\' due to no change
21:19:34 T:1168 DEBUG: CUtil::ExcludeFileOrFolder: File 'E:\Video\MOVIES\Pitch.Perfect.2012\Sample\' excluded. (Matches exclude rule RegExp:'[!-._ \\/]sample[-._ \\/]')
21:19:34 T:1168 DEBUG: VideoInfoScanner: Skipping dir 'E:\Video\MOVIES\Pitch.Perfect.2012\Subs\' due to no change (fasthash)
21:19:34 T:1168 DEBUG: VideoInfoScanner: Skipping dir 'E:\Video\MOVIES\Prometheus\' due to no change (fasthash)
21:19:34 T:1168 DEBUG: VideoInfoScanner: Skipping dir 'E:\Video\MOVIES\Silver Linings Playbook (2012)\' due to no change (fasthash)
21:19:34 T:1168 DEBUG: VideoInfoScanner: Skipping dir 'E:\Video\MOVIES\Skyfall\' due to no change (fasthash)
21:19:34 T:1168 DEBUG: VideoInfoScanner: Skipping dir 'E:\Video\MOVIES\Snow White and the Huntsman\' due to no change
21:19:34 T:1168 DEBUG: CUtil::ExcludeFileOrFolder: File 'E:\Video\MOVIES\Snow White and the Huntsman\Sample\' excluded. (Matches exclude rule RegExp:'[!-._ \\/]sample[-._ \\/]')
21:19:34 T:1168 DEBUG: VideoInfoScanner: Skipping dir 'E:\Video\MOVIES\Snow White and the Huntsman\Subs\' due to no change (fasthash)
21:19:34 T:1168 DEBUG: VideoInfoScanner: Skipping dir 'E:\Video\MOVIES\Special 26 2013 Hindi 720p DvDRip CharmeLeon SilverRG\' due to no change (fasthash)
21:19:34 T:1168 DEBUG: VideoInfoScanner: Skipping dir 'E:\Video\MOVIES\Student of the Year\' due to no change (fasthash)
21:19:34 T:1168 DEBUG: VideoInfoScanner: Skipping dir 'E:\Video\MOVIES\Talaash\' due to no change (fasthash)
21:19:34 T:1168 DEBUG: VideoInfoScanner: Skipping dir 'E:\Video\MOVIES\The Avengers (2012) [1080p]\' due to no change (fasthash)
21:19:34 T:1168 DEBUG: VideoInfoScanner: Skipping dir 'E:\Video\MOVIES\The Best Exotic Marigold Hotel 2011\' due to no change
21:19:34 T:1168 DEBUG: CUtil::ExcludeFileOrFolder: File 'E:\Video\MOVIES\The Best Exotic Marigold Hotel 2011\Sample\' excluded. (Matches exclude rule RegExp:'[!-._ \\/]sample[-._ \\/]')
21:19:34 T:1168 DEBUG: VideoInfoScanner: Skipping dir 'E:\Video\MOVIES\The Best Exotic Marigold Hotel 2011\Subs\' due to no change (fasthash)
21:19:34 T:1168 DEBUG: VideoInfoScanner: Skipping dir 'E:\Video\MOVIES\The Hobbit An Unexpected Journey (2012) [1080p]\' due to no change (fasthash)
21:19:34 T:1168 DEBUG: VideoInfoScanner: Skipping dir 'E:\Video\MOVIES\The Hunger Games\' due to no change (fasthash)
21:19:34 T:1168 DEBUG: VideoInfoScanner: Scanning dir 'E:\Video\MOVIES\The Prestige 2006\' as not in the database
21:19:34 T:1168 DEBUG: CVideoDatabase::GetMovieId (E:\Video\MOVIES\The Prestige 2006\The Prestige.mp4), query = select idMovie from movie where idFile=369
21:19:34 T:1168 DEBUG: VideoInfoScanner: No NFO file found. Using title search for 'E:\Video\MOVIES\The Prestige 2006\The Prestige.mp4'
21:19:34 T:1168 DEBUG: ADDON::CScraper::FindMovie: Searching for 'The Prestige 2006' using The Movie Database scraper (path: 'C:\Program Files (x86)\XBMC\addons\metadata.themoviedb.org', content: 'movies', version: '3.7.3')
21:19:34 T:2692 DEBUG: Skin Widgets: script version 0.0.27 started
21:19:34 T:1168 DEBUG: scraper: CreateSearchUrl returned <url>http://api.themoviedb.org/3/search/movie?api_key=57983e31fb435df4df77afb854740ea9&amp;query=the%20prestige%202006&amp;year=&amp;language=en</url>
21:19:34 T:1168 DEBUG: CurlFile::Open(08C44DE0) http://api.themoviedb.org/3/search/movie?api_key=57983e31fb435df4df77afb854740ea9&query=the%20prestige%202006&year=&language=en
21:19:34 T:1168 INFO: XCURL::DllLibCurlGlobal::easy_aquire - Created session to http://api.themoviedb.org
21:19:34 T:2692 DEBUG: JSONRPC: Incoming request: {"jsonrpc": "2.0", "id": 1, "method": "VideoLibrary.GetMovies", "params": {"properties": ["title", "originaltitle", "playcount", "year", "genre", "studio", "country", "tagline", "plot", "runtime", "file", "plotoutline", "lastplayed", "trailer", "rating", "resume", "art", "streamdetails", "mpaa", "director"], "limits": {"end": 20}, "sort": {"method": "random" }, "filter": {"field": "playcount", "operator": "lessthan", "value": "1"}}}
21:19:34 T:2692 DEBUG: JSONRPC: Calling videolibrary.getmovies
21:19:34 T:2692 DEBUG: CVideoDatabase::RunQuery took 8 ms for 76 items query: select * from movieview WHERE ((movieview.playCount IS NULL OR movieview.playCount < 1))
21:19:34 T:1168 DEBUG: scraper: GetSearchResults returned <results></results>
21:19:34 T:1168 DEBUG: ADDON::CScraper::FindMovie: Searching for 'The Prestige 2006' using The Movie Database scraper (path: 'C:\Program Files (x86)\XBMC\addons\metadata.themoviedb.org', content: 'movies', version: '3.7.3')
21:19:34 T:1168 DEBUG: scraper: CreateSearchUrl returned <url>http://api.themoviedb.org/3/search/movie?api_key=57983e31fb435df4df77afb854740ea9&amp;query=the%20prestige%202006&amp;year=&amp;language=en</url>
21:19:34 T:1168 DEBUG: CurlFile::Open(08C44DE0) http://api.themoviedb.org/3/search/movie?api_key=57983e31fb435df4df77afb854740ea9&query=the%20prestige%202006&year=&language=en
21:19:34 T:2756 NOTICE: StorageServer Module loaded RUN
21:19:34 T:2756 NOTICE: StorageClient-2.5.2 Starting server
21:19:34 T:2756 NOTICE: StorageServer-2.5.2 Storage Server starting C:\Users\TVUser\AppData\Roaming\XBMC\cache\commoncache.db
21:19:35 T:1168 DEBUG: scraper: GetSearchResults returned <results></results>
21:19:35 T:1168 WARNING: No information found for item 'E:\Video\MOVIES\The Prestige 2006\The Prestige.mp4', it won't be added to the library.
21:19:35 T:1168 DEBUG: VideoInfoScanner: No (new) information was found in dir E:\Video\MOVIES\The Prestige 2006\
21:19:35 T:1168 DEBUG: VideoInfoScanner: Skipping dir 'E:\Video\MOVIES\The Prestige 2006\Cover\' due to no change (fasthash)
21:19:35 T:1168 DEBUG: VideoInfoScanner: Skipping dir 'E:\Video\MOVIES\The Prestige 2006\Subs\' due to no change (fasthash)
21:19:35 T:1168 DEBUG: VideoInfoScanner: Skipping dir 'E:\Video\MOVIES\The Time Traveller's Wife\' due to no change (fasthash)
21:19:35 T:1168 DEBUG: VideoInfoScanner: Skipping dir 'E:\Video\MOVIES\The.Guilt.Trip.2012.720p.BRRiP.XViD.AC3-LEGi0N\' due to no change (fasthash)
21:19:35 T:1168 DEBUG: VideoInfoScanner: Skipping dir 'E:\Video\MOVIES\The.Hangover.Part.II.2011.DVDRip.XviD-LTW\' due to no change (fasthash)
21:19:35 T:1168 DEBUG: VideoInfoScanner: Skipping dir 'E:\Video\MOVIES\The.Twilight.Saga.Breaking.Dawn.Part1\' due to no change
21:19:35 T:1168 DEBUG: VideoInfoScanner: Skipping dir 'E:\Video\MOVIES\The.Twilight.Saga.Breaking.Dawn.Part1\Subs\' due to no change (fasthash)
21:19:35 T:1168 DEBUG: VideoInfoScanner: Skipping dir 'E:\Video\MOVIES\The.Twilight.Saga.Breaking.Dawn.Part2\' due to no change (fasthash)
21:19:35 T:1168 DEBUG: VideoInfoScanner: Skipping dir 'E:\Video\MOVIES\Titanic (1997)\' due to no change
21:19:35 T:1168 DEBUG: VideoInfoScanner: Skipping dir 'E:\Video\MOVIES\Titanic (1997)\Other\' due to no change (fasthash)
21:19:35 T:1168 DEBUG: VideoInfoScanner: Skipping dir 'E:\Video\MOVIES\Twilight\' due to no change (fasthash)
21:19:35 T:1168 DEBUG: VideoInfoScanner: Skipping dir 'E:\Video\MOVIES\Wreck-It Ralph\' due to no change (fasthash)
21:19:35 T:1168 DEBUG: VideoInfoScanner: Skipping dir 'E:\Video\MOVIES\Zero Dark Thirty (2012) [1080p]\' due to no change (fasthash)
21:19:35 T:1168 DEBUG: VideoInfoScanner: No (new) information was found in dir E:\Video\TVSHOWS\Big Bang Theory\
21:19:35 T:1168 DEBUG: VideoInfoScanner: No (new) information was found in dir E:\Video\TVSHOWS\Breaking Bad\
21:19:35 T:2124 DEBUG: ------ Window Deinit (Pointer.xml) ------
21:19:35 T:1168 DEBUG: VideoInfoScanner: No (new) information was found in dir E:\Video\TVSHOWS\Game of Thrones\
21:19:35 T:2980 DEBUG: CAESinkDirectSound::Deinitialize: Cleaning up
21:19:35 T:2980 DEBUG: Suspended the Sink
21:19:35 T:1168 DEBUG: VideoInfoScanner: No (new) information was found in dir E:\Video\TVSHOWS\MODERN FAMILY\
21:19:35 T:2704 DEBUG: POParser: loaded 100 strings from file C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.artwork.downloader\resources\language\english\strings.po
21:19:36 T:2952 NOTICE: Database.eventLoop() >>>>>>>>>> starting...
21:19:36 T:2684 INFO: Scriptresult: Success
21:19:36 T:2684 INFO: Scriptresult: Waiting on thread 2952
21:19:36 T:2952 NOTICE: Database.eventLoop() >>>>>>>>>> processing command: _initialize
21:19:36 T:2704 NOTICE: Artwork Downloader: ## Service - Run at startup: False
21:19:36 T:2704 NOTICE: Artwork Downloader: ## Service - Delayed startup: minutes
21:19:36 T:2704 NOTICE: Artwork Downloader: ## Service - Run as service: False
21:19:36 T:2704 NOTICE: Artwork Downloader: ## Service - Time: :00
21:19:36 T:2704 INFO: Scriptresult: Success
21:19:36 T:2692 DEBUG: JSONRPC: Incoming request: {"jsonrpc": "2.0", "id": 1, "method": "VideoLibrary.GetEpisodes", "params": { "properties": ["title", "playcount", "season", "episode", "showtitle", "plot", "file", "rating", "resume", "tvshowid", "art", "streamdetails", "firstaired", "runtime"], "limits": {"end": 20}, "sort": {"method": "random" }, "filter": {"field": "playcount", "operator": "lessthan", "value": "1"}}}
21:19:36 T:2692 DEBUG: JSONRPC: Calling videolibrary.getepisodes
21:19:36 T:2692 DEBUG: CVideoDatabase::RunQuery took 8 ms for 126 items query: select * from episodeview WHERE ((episodeview.playCount IS NULL OR episodeview.playCount < 1))
21:19:36 T:2952 NOTICE: Settings changed: False
21:19:36 T:2952 NOTICE: Database.eventLoop() >>>>>>>>>> processing command: _updateChannelAndProgramListCaches
21:19:36 T:2952 DEBUG: [script.tvguide] Updating caches...
21:19:36 T:2692 DEBUG: JSONRPC: Incoming request: {"jsonrpc": "2.0", "id": 1, "method": "VideoLibrary.GetMusicVideos", "params": {"properties": ["title", "artist", "playcount", "year", "plot", "genre", "runtime", "fanart", "thumbnail", "file", "streamdetails", "resume"], "limits": {"end": 20}, "sort": {"method": "random"}}}
21:19:36 T:2692 DEBUG: JSONRPC: Calling videolibrary.getmusicvideos
21:19:36 T:2692 DEBUG: CVideoDatabase::RunQuery took 1 ms for 0 items query: select * from musicvideoview
21:19:36 T:1168 DEBUG: VideoInfoScanner: No (new) information was found in dir E:\Video\TVSHOWS\MadMen\
21:19:36 T:2692 DEBUG: JSONRPC: Incoming request: {"jsonrpc": "2.0", "id": 1, "method": "AudioLibrary.GetAlbums", "params": {"properties": ["title", "description", "albumlabel", "theme", "mood", "style", "type", "artist", "genre", "year", "thumbnail", "fanart", "rating", "playcount"], "limits": {"end": 20}, "sort": {"method": "random"}}}
21:19:36 T:2692 DEBUG: JSONRPC: Calling audiolibrary.getalbums
21:19:36 T:2692 DEBUG: CMusicDatabase::GetAlbumsByWhere query: SELECT albumview.* FROM albumview WHERE albumview.strAlbum <> ''
21:19:36 T:2692 DEBUG: CMusicDatabase::GetAlbumsByWhere - query took 15 ms
21:19:37 T:2704 INFO: Python script stopped
21:19:37 T:2704 DEBUG: Thread XBPyThread 2704 terminating
21:19:37 T:2124 DEBUG: waiting for python thread 4 (C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.artwork.downloader\service.py) to stop
21:19:37 T:2124 DEBUG: python thread 4 (C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.artwork.downloader\service.py) destructed
21:19:37 T:2952 NOTICE: Invoking URL: http://api.yousee.tv/rest/tvguide/channels/format/json
21:19:37 T:2708 DEBUG: ### [Qlock] - Set new Language - [English]
21:19:37 T:2664 INFO: Scriptresult: Success
21:19:37 T:2664 INFO: Python script stopped
21:19:37 T:2664 DEBUG: Thread XBPyThread 2664 terminating
21:19:37 T:2124 DEBUG: waiting for python thread 3 (C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.simple.downloader\default.py) to stop
21:19:37 T:2124 DEBUG: python thread 3 (C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.simple.downloader\default.py) destructed
21:19:37 T:2708 DEBUG: ### [Qlock] - Startup
21:19:37 T:2708 DEBUG: ### [Qlock] - Delaying 3 secs
21:19:37 T:1168 DEBUG: VideoInfoScanner: No (new) information was found in dir E:\Video\TVSHOWS\Suits\
21:19:37 T:2692 DEBUG: JSONRPC: Incoming request: {"jsonrpc": "2.0", "method": "AudioLibrary.GetArtists", "params": {"properties": ["genre", "description", "mood", "style", "born", "died", "formed", "disbanded", "yearsactive", "instrument", "fanart", "thumbnail"], "sort": {"method": "random"}, "limits": {"end": 20}}, "id": 1}
21:19:37 T:2692 DEBUG: JSONRPC: Calling audiolibrary.getartists
21:19:37 T:2692 DEBUG: CMusicDatabase::GetArtistsByWhere query: SELECT artistview.* FROM artistview WHERE (artistview.idArtist IN (SELECT song_artist.idArtist FROM song_artist) OR artistview.idArtist IN (SELECT album_artist.idArtist FROM album_artist)) and artistview.strArtist != '' and artistview.idArtist <> 1
21:19:37 T:2692 DEBUG: Time to retrieve artists from dataset = 85
21:19:37 T:2692 DEBUG: JSONRPC: Incoming request: {"jsonrpc": "2.0", "id": 1, "method": "AudioLibrary.GetSongs", "params": {"properties": ["title", "playcount", "artist", "album", "year", "file", "thumbnail", "fanart", "rating"], "filter": {"field": "playcount", "operator": "lessthan", "value": "1"}, "limits": {"end": 20}, "sort": {"method": "random"}}}
21:19:37 T:2692 DEBUG: JSONRPC: Calling audiolibrary.getsongs
21:19:37 T:2692 DEBUG: CMusicDatabase::GetSongsByWhere query = SELECT songview.* FROM songview WHERE ((CAST(songview.iTimesPlayed as DECIMAL(5,1)) < 1))
21:19:37 T:2692 DEBUG: CMusicDatabase::GetSongsByWhere() - took 170 ms
21:19:37 T:1168 NOTICE: VideoInfoScanner: Finished scan. Scanning for video info took 00:07
21:19:37 T:1168 DEBUG: CAnnouncementManager - Announcement: OnScanFinished from xbmc
21:19:37 T:1168 DEBUG: GOT ANNOUNCEMENT, type: 16, from xbmc, message OnScanFinished
21:19:37 T:1572 DEBUG: CRecentlyAddedJob::UpdateVideos() - Running RecentlyAdded home screen update
21:19:37 T:2692 DEBUG: JSONRPC: Incoming request: {"jsonrpc": "2.0", "method": "Addons.GetAddons", "params": {"properties": ["name", "author", "summary", "version", "fanart", "thumbnail"]}, "id": 1}
21:19:37 T:2692 DEBUG: JSONRPC: Calling addons.getaddons
21:19:38 T:1572 DEBUG: CVideoDatabase::RunQuery took 17 ms for 10 items query: select * from movieview ORDER BY dateAdded desc, idMovie desc LIMIT 10
21:19:38 T:1168 DEBUG: Thread CVideoInfoScanner 1168 terminating
21:19:38 T:1572 DEBUG: CVideoDatabase::RunQuery took 32 ms for 10 items query: select * from episodeview ORDER BY dateAdded desc, idEpisode desc LIMIT 10
21:19:38 T:2112 DEBUG: CThumbExtractor::DoWork - trying to extract filestream details from video file E:\Video\TVSHOWS\MODERN FAMILY\Season4\Modern.Family.S04E21.HDTV.x264-LOL.mp4
21:19:38 T:2692 DEBUG: Skin Widgets: Total time needed to request random queries: 0:00:03.595000
21:19:38 T:2692 DEBUG: JSONRPC: Incoming request: {"jsonrpc": "2.0", "id": 1, "method": "VideoLibrary.GetMovies", "params": {"properties": ["title", "originaltitle", "playcount", "year", "genre", "studio", "country", "tagline", "plot", "runtime", "file", "plotoutline", "lastplayed", "trailer", "rating", "resume", "art", "streamdetails", "mpaa", "director"], "limits": {"end": 20}, "sort": {"order": "descending", "method": "lastplayed"}, "filter": {"field": "inprogress", "operator": "true", "value": ""}}}
21:19:38 T:2692 DEBUG: JSONRPC: Calling videolibrary.getmovies
21:19:38 T:2112 DEBUG: CDVDDemuxFFmpeg::Open - probing detected format [mov,mp4,m4a,3gp,3g2,mj2]
21:19:38 T:2692 DEBUG: CVideoDatabase::RunQuery took 4 ms for 33 items query: select * from movieview WHERE (movieview.idFile IN (select idFile from bookmark where type = 1))
21:19:38 T:2112 DEBUG: CDVDDemuxFFmpeg::Open - avformat_find_stream_info starting
21:19:38 T:2112 DEBUG: CDVDDemuxFFmpeg::Open - av_find_stream_info finished
21:19:38 T:2112 INFO: ffmpeg[840]: Input #0, mov,mp4,m4a,3gp,3g2,mj2, from 'E:\Video\TVSHOWS\MODERN FAMILY\Season4\Modern.Family.S04E21.HDTV.x264-LOL.mp4':
21:19:38 T:2112 INFO: ffmpeg[840]: Metadata:
21:19:38 T:2112 INFO: ffmpeg[840]: major_brand : isom
21:19:38 T:2112 INFO: ffmpeg[840]: minor_version : 1
21:19:38 T:2112 INFO: ffmpeg[840]: compatible_brands: isom
21:19:38 T:2112 INFO: ffmpeg[840]: creation_time : 2013-04-30 15:13:57
21:19:38 T:2112 INFO: ffmpeg[840]: Duration: 00:21:46.41, start: 0.000000, bitrate: 1092 kb/s
21:19:38 T:2112 INFO: ffmpeg[840]: Stream #0:0(und): Video: h264 (High) (avc1 / 0x31637661), yuv420p, 720x404, 991 kb/s, 23.98 fps, 23.98 tbr, 24k tbn, 47.95 tbc
21:19:38 T:2112 INFO: ffmpeg[840]: Metadata:
21:19:38 T:2112 INFO: ffmpeg[840]: creation_time : 2013-05-01 06:56:53
21:19:38 T:2112 INFO: ffmpeg[840]: handler_name : GPAC ISO Video Handler
21:19:38 T:2112 INFO: ffmpeg[840]: Stream #0:1(und): Audio: aac (mp4a / 0x6134706D), 48000 Hz, stereo, s16, 96 kb/s
21:19:38 T:2112 INFO: ffmpeg[840]: Metadata:
21:19:38 T:2112 INFO: ffmpeg[840]: creation_time : 2013-04-30 15:14:01
21:19:38 T:2112 INFO: ffmpeg[840]: handler_name : GPAC ISO Audio Handler
21:19:38 T:2112 DEBUG: CThumbExtractor::DoWork - trying to extract filestream details from video file E:\Video\TVSHOWS\Game of Thrones\Season3\Game of Thrones S03E04 HDTV x264-EVOLVE[ettv]\Game.of.Thrones.S03E04.HDTV.x264-EVOLVE.mp4
21:19:38 T:1572 DEBUG: CVideoDatabase::RunQuery took 1 ms for 0 items query: select * from musicvideoview ORDER BY dateAdded desc, idMVideo desc LIMIT 10
21:19:38 T:1572 DEBUG: CRecentlyAddedJob::UpdateTotal() - Running RecentlyAdded home screen update
21:19:38 T:2112 DEBUG: CDVDDemuxFFmpeg::Open - probing detected format [mov,mp4,m4a,3gp,3g2,mj2]
21:19:38 T:2692 DEBUG: JSONRPC: Incoming request: {"jsonrpc": "2.0", "method": "VideoLibrary.GetTVShows", "params": {"properties": ["title", "studio", "mpaa", "file", "art"], "sort": {"order": "descending", "method": "lastplayed"}, "filter": {"field": "inprogress", "operator": "true", "value": ""}, "limits": {"end": 20}}, "id": 1}
21:19:38 T:2692 DEBUG: JSONRPC: Calling videolibrary.gettvshows
21:19:38 T:2692 DEBUG: CVideoDatabase::RunQuery took 5 ms for 4 items query: SELECT * FROM tvshowview WHERE (tvshowview.idShow IN (select tvshowview.idShow from tvshowview where (watchedcount > 0 AND watchedcount < totalCount) OR (watchedcount = 0 AND tvshowview.idShow IN (select episodeview.idShow from episodeview WHERE episodeview.idShow = tvshowview.idShow AND episodeview.resumeTimeInSeconds > 0))))
21:19:38 T:2112 DEBUG: CDVDDemuxFFmpeg::Open - avformat_find_stream_info starting
21:19:38 T:2692 DEBUG: JSONRPC: Incoming request: {"jsonrpc": "2.0", "method": "VideoLibrary.GetEpisodes", "params": {"tvshowid": 3, "properties": ["title", "playcount", "plot", "season", "episode", "showtitle", "file", "lastplayed", "rating", "resume", "art", "streamdetails", "firstaired", "runtime"], "sort": {"method": "episode"}, "filter": {"field": "playcount", "operator": "is", "value": "0"}, "limits": {"end": 1}}, "id": 1}
21:19:38 T:2692 DEBUG: JSONRPC: Calling videolibrary.getepisodes
21:19:38 T:2112 DEBUG: CDVDDemuxFFmpeg::Open - av_find_stream_info finished
21:19:38 T:2112 INFO: ffmpeg[840]: Input #0, mov,mp4,m4a,3gp,3g2,mj2, from 'E:\Video\TVSHOWS\Game of Thrones\Season3\Game of Thrones S03E04 HDTV x264-EVOLVE[ettv]\Game.of.Thrones.S03E04.HDTV.x264-EVOLVE.mp4':
21:19:38 T:2112 INFO: ffmpeg[840]: Metadata:
21:19:38 T:2112 INFO: ffmpeg[840]: major_brand : isom
21:19:38 T:2112 INFO: ffmpeg[840]: minor_version : 1
21:19:38 T:2112 INFO: ffmpeg[840]: compatible_brands: isom
21:19:38 T:2112 INFO: ffmpeg[840]: creation_time : 2013-04-22 01:57:29
21:19:38 T:2112 INFO: ffmpeg[840]: Duration: 00:54:51.79, start: 0.000000, bitrate: 997 kb/s
21:19:38 T:2112 INFO: ffmpeg[840]: Stream #0:0(und): Audio: aac (mp4a / 0x6134706D), 48000 Hz, stereo, s16, 116 kb/s
21:19:38 T:2112 INFO: ffmpeg[840]: Metadata:
21:19:38 T:2112 INFO: ffmpeg[840]: creation_time : 2013-04-22 01:57:29
21:19:38 T:2112 INFO: ffmpeg[840]: handler_name : GPAC ISO Audio Handler
21:19:38 T:2112 INFO: ffmpeg[840]: Stream #0:1(und): Video: h264 (High) (avc1 / 0x31637661), yuv420p, 720x404, 876 kb/s, 23.98 fps, 23.98 tbr, 24k tbn, 47.95 tbc
21:19:38 T:2112 INFO: ffmpeg[840]: Metadata:
21:19:38 T:2112 INFO: ffmpeg[840]: creation_time : 2013-04-22 01:14:46
21:19:38 T:2112 INFO: ffmpeg[840]: handler_name : GPAC ISO Video Handler
21:19:38 T:2692 DEBUG: CVideoDatabase::GetStackedTvShowList query: select idShow from tvshow where c00 like (select c00 from tvshow where idShow=3) order by idShow
21:19:38 T:2692 DEBUG: CVideoDatabase::RunQuery took 2 ms for 20 items query: select * from episodeview WHERE (episodeview.idShow = 3) AND (((episodeview.playCount IS NULL OR episodeview.playCount = 0)))
21:19:38 T:2692 DEBUG: DatabaseUtils::GetSortFieldList: unknown field 23
21:19:38 T:2692 DEBUG: JSONRPC: Incoming request: {"jsonrpc": "2.0", "method": "VideoLibrary.GetEpisodes", "params": {"tvshowid": 4, "properties": ["title", "playcount", "plot", "season", "episode", "showtitle", "file", "lastplayed", "rating", "resume", "art", "streamdetails", "firstaired", "runtime"], "sort": {"method": "episode"}, "filter": {"field": "playcount", "operator": "is", "value": "0"}, "limits": {"end": 1}}, "id": 1}
21:19:38 T:2692 DEBUG: JSONRPC: Calling videolibrary.getepisodes
21:19:38 T:2692 DEBUG: CVideoDatabase::GetStackedTvShowList query: select idShow from tvshow where c00 like (select c00 from tvshow where idShow=4) order by idShow
21:19:38 T:2692 DEBUG: CVideoDatabase::RunQuery took 2 ms for 23 items query: select * from episodeview WHERE (episodeview.idShow = 4) AND (((episodeview.playCount IS NULL OR episodeview.playCount = 0)))
21:19:38 T:2692 DEBUG: DatabaseUtils::GetSortFieldList: unknown field 23
21:19:38 T:2692 DEBUG: JSONRPC: Incoming request: {"jsonrpc": "2.0", "method": "VideoLibrary.GetEpisodes", "params": {"tvshowid": 1, "properties": ["title", "playcount", "plot", "season", "episode", "showtitle", "file", "lastplayed", "rating", "resume", "art", "streamdetails", "firstaired", "runtime"], "sort": {"method": "episode"}, "filter": {"field": "playcount", "operator": "is", "value": "0"}, "limits": {"end": 1}}, "id": 1}
21:19:38 T:2692 DEBUG: JSONRPC: Calling videolibrary.getepisodes
21:19:38 T:2692 DEBUG: CVideoDatabase::GetStackedTvShowList query: select idShow from tvshow where c00 like (select c00 from tvshow where idShow=1) order by idShow
21:19:38 T:2692 DEBUG: CVideoDatabase::RunQuery took 2 ms for 24 items query: select * from episodeview WHERE (episodeview.idShow = 1) AND (((episodeview.playCount IS NULL OR episodeview.playCount = 0)))
21:19:38 T:2692 DEBUG: DatabaseUtils::GetSortFieldList: unknown field 23
21:19:38 T:2692 DEBUG: JSONRPC: Incoming request: {"jsonrpc": "2.0", "method": "VideoLibrary.GetEpisodes", "params": {"tvshowid": 2, "properties": ["title", "playcount", "plot", "season", "episode", "showtitle", "file", "lastplayed", "rating", "resume", "art", "streamdetails", "firstaired", "runtime"], "sort": {"method": "episode"}, "filter": {"field": "playcount", "operator": "is", "value": "0"}, "limits": {"end": 1}}, "id": 1}
21:19:38 T:2692 DEBUG: JSONRPC: Calling videolibrary.getepisodes
21:19:38 T:2692 DEBUG: CVideoDatabase::GetStackedTvShowList query: select idShow from tvshow where c00 like (select c00 from tvshow where idShow=2) order by idShow
21:19:38 T:2692 DEBUG: CVideoDatabase::RunQuery took 3 ms for 52 items query: select * from episodeview WHERE (episodeview.idShow = 2) AND (((episodeview.playCount IS NULL OR episodeview.playCount = 0)))
21:19:38 T:2692 DEBUG: DatabaseUtils::GetSortFieldList: unknown field 23
21:19:38 T:2692 DEBUG: JSONRPC: Incoming request: {"jsonrpc": "2.0", "id": 1, "method": "AudioLibrary.GetAlbums", "params": {"properties": ["title", "description", "albumlabel", "theme", "mood", "style", "type", "artist", "genre", "year", "thumbnail", "fanart", "rating", "playcount"], "limits": {"end": 20}, "sort": {"order": "descending", "method": "playcount" }}}
21:19:38 T:2692 DEBUG: JSONRPC: Calling audiolibrary.getalbums
21:19:38 T:2692 DEBUG: CMusicDatabase::GetAlbumsByWhere query: SELECT albumview.* FROM albumview WHERE albumview.strAlbum <> ''
21:19:38 T:2692 DEBUG: CMusicDatabase::GetAlbumsByWhere - query took 15 ms
21:19:38 T:2124 DEBUG: ------ Window Deinit (DialogExtendedProgressBar.xml) ------
21:19:38 T:2692 DEBUG: JSONRPC: Incoming request: {"jsonrpc": "2.0", "id": 1, "method": "VideoLibrary.GetMusicVideos", "params": {"properties": ["title", "artist", "playcount", "year", "plot", "genre", "runtime", "fanart", "thumbnail", "file", "streamdetails", "resume"], "limits": {"end": 20}, "sort": {"order": "descending", "method": "playcount" }}}
21:19:38 T:2692 DEBUG: JSONRPC: Calling videolibrary.getmusicvideos
21:19:38 T:2692 DEBUG: CVideoDatabase::RunQuery took 1 ms for 0 items query: select * from musicvideoview
21:19:38 T:2692 DEBUG: Skin Widgets: Total time needed to request recommended queries: 0:00:00.423000
21:19:38 T:2692 DEBUG: JSONRPC: Incoming request: {"jsonrpc": "2.0", "id": 1, "method": "VideoLibrary.GetMovies", "params": {"properties": ["title", "originaltitle", "playcount", "year", "genre", "studio", "country", "tagline", "plot", "runtime", "file", "plotoutline", "lastplayed", "trailer", "rating", "resume", "art", "streamdetails", "mpaa", "director"], "limits": {"end": 20}, "sort": {"order": "descending", "method": "dateadded"}, "filter": {"field": "playcount", "operator": "is", "value": "0"}}}
21:19:38 T:2692 DEBUG: JSONRPC: Calling videolibrary.getmovies
21:19:38 T:2692 DEBUG: CVideoDatabase::RunQuery took 7 ms for 76 items query: select * from movieview WHERE ((movieview.playCount IS NULL OR movieview.playCount = 0))
21:19:38 T:2692 DEBUG: JSONRPC: Incoming request: {"jsonrpc": "2.0", "id": 1, "method": "VideoLibrary.GetEpisodes", "params": { "properties": ["title", "playcount", "season", "episode", "showtitle", "plot", "file", "rating", "resume", "tvshowid", "art", "streamdetails", "firstaired", "runtime"], "limits": {"end": 20}, "sort": {"order": "descending", "method": "dateadded"}, "filter": {"field": "playcount", "operator": "lessthan", "value": "1"}}}
21:19:38 T:2692 DEBUG: JSONRPC: Calling videolibrary.getepisodes
21:19:38 T:2692 DEBUG: CVideoDatabase::RunQuery took 9 ms for 126 items query: select * from episodeview WHERE ((episodeview.playCount IS NULL OR episodeview.playCount < 1))
21:19:38 T:2692 DEBUG: JSONRPC: Incoming request: {"jsonrpc": "2.0", "id": 1, "method": "VideoLibrary.GetMusicVideos", "params": {"properties": ["title", "artist", "playcount", "year", "plot", "genre", "runtime", "fanart", "thumbnail", "file", "streamdetails", "resume"], "limits": {"end": 20}, "sort": {"order": "descending", "method": "dateadded"}}}
21:19:38 T:2692 DEBUG: JSONRPC: Calling videolibrary.getmusicvideos
21:19:38 T:2692 DEBUG: CVideoDatabase::RunQuery took 1 ms for 0 items query: select * from musicvideoview
21:19:38 T:2692 DEBUG: JSONRPC: Incoming request: {"jsonrpc": "2.0", "id": 1, "method": "AudioLibrary.GetAlbums", "params": {"properties": ["title", "description", "albumlabel", "theme", "mood", "style", "type", "artist", "genre", "year", "thumbnail", "fanart", "rating", "playcount"], "limits": {"end": 20}, "sort": {"order": "descending", "method": "dateadded" }}}
21:19:38 T:2692 DEBUG: JSONRPC: Calling audiolibrary.getalbums
21:19:38 T:2692 DEBUG: CMusicDatabase::GetAlbumsByWhere query: SELECT albumview.* FROM albumview WHERE albumview.strAlbum <> ''
21:19:38 T:2692 DEBUG: CMusicDatabase::GetAlbumsByWhere - query took 16 ms
21:19:38 T:2692 DEBUG: DatabaseUtils::GetSortFieldList: unknown field 34
21:19:38 T:2692 DEBUG: Skin Widgets: Total time needed to request recent items queries: 0:00:00.475000
21:19:38 T:2692 DEBUG: Skin Widgets: Total time needed for all queries: 0:00:04.494000
21:19:39 T:2708 DEBUG: ### [Qlock] - Delaying 3 secs
21:19:39 T:2952 NOTICE: Invoking URL: http://api.yousee.tv/rest/tvguide/programs/tvdate/2013-11-26/channel_id/1/format/json
21:19:40 T:2692 DEBUG: JSONRPC: Incoming request: {"jsonrpc": "2.0", "id": 1, "method": "VideoLibrary.GetMovies", "params": {"properties": ["title", "originaltitle", "playcount", "year", "genre", "studio", "country", "tagline", "plot", "runtime", "file", "plotoutline", "lastplayed", "trailer", "rating", "resume", "art", "streamdetails", "mpaa", "director"], "limits": {"end": 20}, "sort": {"order": "descending", "method": "lastplayed"}, "filter": {"field": "inprogress", "operator": "true", "value": ""}}}
21:19:40 T:2692 DEBUG: JSONRPC: Calling videolibrary.getmovies
21:19:40 T:2692 DEBUG: CVideoDatabase::RunQuery took 4 ms for 33 items query: select * from movieview WHERE (movieview.idFile IN (select idFile from bookmark where type = 1))
21:19:40 T:2692 DEBUG: JSONRPC: Incoming request: {"jsonrpc": "2.0", "method": "VideoLibrary.GetTVShows", "params": {"properties": ["title", "studio", "mpaa", "file", "art"], "sort": {"order": "descending", "method": "lastplayed"}, "filter": {"field": "inprogress", "operator": "true", "value": ""}, "limits": {"end": 20}}, "id": 1}
21:19:40 T:2692 DEBUG: JSONRPC: Calling videolibrary.gettvshows
21:19:40 T:2692 DEBUG: CVideoDatabase::RunQuery took 8 ms for 4 items query: SELECT * FROM tvshowview WHERE (tvshowview.idShow IN (select tvshowview.idShow from tvshowview where (watchedcount > 0 AND watchedcount < totalCount) OR (watchedcount = 0 AND tvshowview.idShow IN (select episodeview.idShow from episodeview WHERE episodeview.idShow = tvshowview.idShow AND episodeview.resumeTimeInSeconds > 0))))
21:19:40 T:2692 DEBUG: JSONRPC: Incoming request: {"jsonrpc": "2.0", "method": "VideoLibrary.GetEpisodes", "params": {"tvshowid": 3, "properties": ["title", "playcount", "plot", "season", "episode", "showtitle", "file", "lastplayed", "rating", "resume", "art", "streamdetails", "firstaired", "runtime"], "sort": {"method": "episode"}, "filter": {"field": "playcount", "operator": "is", "value": "0"}, "limits": {"end": 1}}, "id": 1}
21:19:40 T:2692 DEBUG: JSONRPC: Calling videolibrary.getepisodes
21:19:40 T:2692 DEBUG: CVideoDatabase::GetStackedTvShowList query: select idShow from tvshow where c00 like (select c00 from tvshow where idShow=3) order by idShow
21:19:40 T:2692 DEBUG: CVideoDatabase::RunQuery took 2 ms for 20 items query: select * from episodeview WHERE (episodeview.idShow = 3) AND (((episodeview.playCount IS NULL OR episodeview.playCount = 0)))
21:19:40 T:2692 DEBUG: DatabaseUtils::GetSortFieldList: unknown field 23
21:19:40 T:2692 DEBUG: JSONRPC: Incoming request: {"jsonrpc": "2.0", "method": "VideoLibrary.GetEpisodes", "params": {"tvshowid": 4, "properties": ["title", "playcount", "plot", "season", "episode", "showtitle", "file", "lastplayed", "rating", "resume", "art", "streamdetails", "firstaired", "runtime"], "sort": {"method": "episode"}, "filter": {"field": "playcount", "operator": "is", "value": "0"}, "limits": {"end": 1}}, "id": 1}
21:19:40 T:2692 DEBUG: JSONRPC: Calling videolibrary.getepisodes
21:19:40 T:2692 DEBUG: CVideoDatabase::GetStackedTvShowList query: select idShow from tvshow where c00 like (select c00 from tvshow where idShow=4) order by idShow
21:19:40 T:2692 DEBUG: CVideoDatabase::RunQuery took 2 ms for 23 items query: select * from episodeview WHERE (episodeview.idShow = 4) AND (((episodeview.playCount IS NULL OR episodeview.playCount = 0)))
21:19:40 T:2692 DEBUG: DatabaseUtils::GetSortFieldList: unknown field 23
21:19:40 T:2692 DEBUG: JSONRPC: Incoming request: {"jsonrpc": "2.0", "method": "VideoLibrary.GetEpisodes", "params": {"tvshowid": 1, "properties": ["title", "playcount", "plot", "season", "episode", "showtitle", "file", "lastplayed", "rating", "resume", "art", "streamdetails", "firstaired", "runtime"], "sort": {"method": "episode"}, "filter": {"field": "playcount", "operator": "is", "value": "0"}, "limits": {"end": 1}}, "id": 1}
21:19:40 T:2692 DEBUG: JSONRPC: Calling videolibrary.getepisodes
21:19:40 T:2692 DEBUG: CVideoDatabase::GetStackedTvShowList query: select idShow from tvshow where c00 like (select c00 from tvshow where idShow=1) order by idShow
21:19:40 T:2692 DEBUG: CVideoDatabase::RunQuery took 2 ms for 24 items query: select * from episodeview WHERE (episodeview.idShow = 1) AND (((episodeview.playCount IS NULL OR episodeview.playCount = 0)))
21:19:40 T:2692 DEBUG: DatabaseUtils::GetSortFieldList: unknown field 23
21:19:40 T:2692 DEBUG: JSONRPC: Incoming request: {"jsonrpc": "2.0", "method": "VideoLibrary.GetEpisodes", "params": {"tvshowid": 2, "properties": ["title", "playcount", "plot", "season", "episode", "showtitle", "file", "lastplayed", "rating", "resume", "art", "streamdetails", "firstaired", "runtime"], "sort": {"method": "episode"}, "filter": {"field": "playcount", "operator": "is", "value": "0"}, "limits": {"end": 1}}, "id": 1}
21:19:40 T:2692 DEBUG: JSONRPC: Calling videolibrary.getepisodes
21:19:40 T:2692 DEBUG: CVideoDatabase::GetStackedTvShowList query: select idShow from tvshow where c00 like (select c00 from tvshow where idShow=2) order by idShow
21:19:40 T:2692 DEBUG: CVideoDatabase::RunQuery took 3 ms for 52 items query: select * from episodeview WHERE (episodeview.idShow = 2) AND (((episodeview.playCount IS NULL OR episodeview.playCount = 0)))
21:19:40 T:2692 DEBUG: DatabaseUtils::GetSortFieldList: unknown field 23
21:19:40 T:2692 DEBUG: JSONRPC: Incoming request: {"jsonrpc": "2.0", "id": 1, "method": "VideoLibrary.GetMovies", "params": {"properties": ["title", "originaltitle", "playcount", "year", "genre", "studio", "country", "tagline", "plot", "runtime", "file", "plotoutline", "lastplayed", "trailer", "rating", "resume", "art", "streamdetails", "mpaa", "director"], "limits": {"end": 20}, "sort": {"order": "descending", "method": "dateadded"}, "filter": {"field": "playcount", "operator": "is", "value": "0"}}}
21:19:40 T:2692 DEBUG: JSONRPC: Calling videolibrary.getmovies
21:19:40 T:2692 DEBUG: CVideoDatabase::RunQuery took 10 ms for 76 items query: select * from movieview WHERE ((movieview.playCount IS NULL OR movieview.playCount = 0))
21:19:40 T:2692 DEBUG: JSONRPC: Incoming request: {"jsonrpc": "2.0", "id": 1, "method": "VideoLibrary.GetEpisodes", "params": { "properties": ["title", "playcount", "season", "episode", "showtitle", "plot", "file", "rating", "resume", "tvshowid", "art", "streamdetails", "firstaired", "runtime"], "limits": {"end": 20}, "sort": {"order": "descending", "method": "dateadded"}, "filter": {"field": "playcount", "operator": "lessthan", "value": "1"}}}
21:19:40 T:2692 DEBUG: JSONRPC: Calling videolibrary.getepisodes
21:19:40 T:2692 DEBUG: CVideoDatabase::RunQuery took 6 ms for 126 items query: select * from episodeview WHERE ((episodeview.playCount IS NULL OR episodeview.playCount < 1))
21:19:40 T:2692 DEBUG: JSONRPC: Incoming request: {"jsonrpc": "2.0", "id": 1, "method": "VideoLibrary.GetMusicVideos", "params": {"properties": ["title", "artist", "playcount", "year", "plot", "genre", "runtime", "fanart", "thumbnail", "file", "streamdetails", "resume"], "limits": {"end": 20}, "sort": {"order": "descending", "method": "dateadded"}}}
21:19:40 T:2692 DEBUG: JSONRPC: Calling videolibrary.getmusicvideos
21:19:40 T:2692 DEBUG: CVideoDatabase::RunQuery took 3 ms for 0 items query: select * from musicvideoview
21:19:41 T:2708 DEBUG: ### [Qlock] - Delaying 3 secs
21:19:41 T:2952 NOTICE: Invoking URL: http://api.yousee.tv/rest/tvguide/programs/tvdate/2013-11-26/channel_id/2/format/json
21:19:43 T:2708 DEBUG: ### [Qlock] - Delaying 3 secs
21:19:43 T:2952 NOTICE: Invoking URL: http://api.yousee.tv/rest/tvguide/programs/tvdate/2013-11-26/channel_id/504/format/json
21:19:44 T:2952 NOTICE: Invoking URL: http://api.yousee.tv/rest/tvguide/programs/tvdate/2013-11-26/channel_id/3/format/json
21:19:45 T:2708 DEBUG: ### [Qlock] - Delaying 3 secs
21:19:46 T:2952 NOTICE: Invoking URL: http://api.yousee.tv/rest/tvguide/programs/tvdate/2013-11-26/channel_id/4/format/json
21:19:47 T:2708 DEBUG: ### [Qlock] - Delaying 3 secs
21:19:48 T:2952 NOTICE: Invoking URL: http://api.yousee.tv/rest/tvguide/programs/tvdate/2013-11-26/channel_id/5/format/json
21:19:49 T:2708 DEBUG: ### [Qlock] - Delaying 3 secs
21:19:49 T:2952 NOTICE: Invoking URL: http://api.yousee.tv/rest/tvguide/programs/tvdate/2013-11-26/channel_id/38/format/json
21:19:50 T:2952 NOTICE: Invoking URL: http://api.yousee.tv/rest/tvguide/programs/tvdate/2013-11-26/channel_id/7/format/json
21:19:51 T:2708 DEBUG: ### [Qlock] - Delaying 3 secs
21:19:52 T:2952 NOTICE: Invoking URL: http://api.yousee.tv/rest/tvguide/programs/tvdate/2013-11-26/channel_id/8/format/json
21:19:53 T:2708 DEBUG: ### [Qlock] - Delaying 3 secs
21:19:54 T:2952 NOTICE: Invoking URL: http://api.yousee.tv/rest/tvguide/programs/tvdate/2013-11-26/channel_id/12/format/json
21:19:55 T:2708 DEBUG: ### [Qlock] - Delaying 3 secs
21:19:55 T:2952 NOTICE: Invoking URL: http://api.yousee.tv/rest/tvguide/programs/tvdate/2013-11-26/channel_id/9/format/json
21:19:57 T:2708 DEBUG: ### [Qlock] - Delaying 3 secs
21:19:57 T:2952 NOTICE: Invoking URL: http://api.yousee.tv/rest/tvguide/programs/tvdate/2013-11-26/channel_id/10/format/json
21:19:58 T:2124 DEBUG: SECTION:UnloadDelayed(DLL: special://xbmcbin/system/ImageLib.dll)
21:19:59 T:2708 DEBUG: ### [Qlock] - Delaying 3 secs
21:20:01 T:2708 DEBUG: ### [Qlock] - Delaying 240 secs
21:20:02 T:2952 NOTICE: Invoking URL: http://api.yousee.tv/rest/tvguide/programs/tvdate/2013-11-26/channel_id/17/format/json
21:20:02 T:2124 INFO: XCURL::DllLibCurlGlobal::CheckIdle - Closing session to http://feeds.feedburner.com (easy=0498DEA8, multi=045458E8)
21:20:03 T:2952 NOTICE: Invoking URL: http://api.yousee.tv/rest/tvguide/programs/tvdate/2013-11-26/channel_id/99/format/json
21:20:05 T:2952 NOTICE: Invoking URL: http://api.yousee.tv/rest/tvguide/programs/tvdate/2013-11-26/channel_id/16/format/json
21:20:05 T:2124 INFO: XCURL::DllLibCurlGlobal::CheckIdle - Closing session to http://api.themoviedb.org (easy=049B2FE8, multi=04545D28)
21:20:06 T:2952 NOTICE: Invoking URL: http://api.yousee.tv/rest/tvguide/programs/tvdate/2013-11-26/channel_id/72/format/json
21:20:08 T:2124 DEBUG: SECTION:UnloadDelayed(DLL: special://xbmcbin/system/players/dvdplayer/avutil-51.dll)
21:20:08 T:2952 NOTICE: Invoking URL: http://api.yousee.tv/rest/tvguide/programs/tvdate/2013-11-26/channel_id/70/format/json
21:20:08 T:1572 DEBUG: Thread Jobworker 1572 terminating (autodelete)
21:20:08 T:2112 DEBUG: Thread Jobworker 2112 terminating (autodelete)
21:20:08 T:2124 DEBUG: SECTION:UnloadDelayed(DLL: special://xbmcbin/system/players/dvdplayer/avcodec-53.dll)
21:20:09 T:2124 DEBUG: SECTION:UnloadDelayed(DLL: special://xbmcbin/system/players/dvdplayer/avformat-53.dll)
21:20:10 T:2952 NOTICE: Invoking URL: http://api.yousee.tv/rest/tvguide/programs/tvdate/2013-11-26/channel_id/30/format/json
21:20:12 T:2952 NOTICE: Invoking URL: http://api.yousee.tv/rest/tvguide/programs/tvdate/2013-11-26/channel_id/36/format/json
21:20:13 T:2952 NOTICE: Invoking URL: http://api.yousee.tv/rest/tvguide/programs/tvdate/2013-11-26/channel_id/13/format/json
21:20:18 T:2952 NOTICE: Invoking URL: http://api.yousee.tv/rest/tvguide/programs/tvdate/2013-11-26/channel_id/67/format/json
21:20:18 T:2952 NOTICE: Invoking URL: http://api.yousee.tv/rest/tvguide/programs/tvdate/2013-11-26/channel_id/98/format/json
21:20:20 T:2952 NOTICE: Invoking URL: http://api.yousee.tv/rest/tvguide/programs/tvdate/2013-11-26/channel_id/152/format/json
21:20:20 T:2124 DEBUG: Activating window ID: 12006
21:20:20 T:2124 DEBUG: ------ Window Deinit (Home.xml) ------
21:20:20 T:2124 DEBUG: ------ Window Init (MusicVisualisation.xml) ------
21:20:20 T:2124 INFO: Loading skin file: MusicVisualisation.xml, load type: KEEP_IN_MEMORY
21:20:20 T:3236 DEBUG: CAnnouncementManager - Announcement: OnVolumeChanged from xbmc
21:20:20 T:3236 DEBUG: GOT ANNOUNCEMENT, type: 64, from xbmc, message OnVolumeChanged
21:20:20 T:2124 DEBUG: CPlayerCoreFactory::GetPlayers(pipe://1/)
21:20:20 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules
21:20:20 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules
21:20:20 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtv
21:20:20 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: hdhomerun/myth/mms/udp
21:20:20 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout
21:20:20 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp
21:20:20 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp
21:20:20 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams
21:20:20 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd
21:20:20 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage
21:20:20 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf
21:20:20 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv
21:20:20 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio
21:20:20 T:2124 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players
21:20:20 T:2124 DEBUG: CPlayerCoreFactory::GetPlayers: adding audiodefaultplayer (3)
21:20:20 T:2124 DEBUG: CPlayerCoreFactory::GetPlayers: for video=0, audio=1
21:20:20 T:2124 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: PAPlayer (3)
21:20:20 T:2124 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1
21:20:20 T:2124 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: DVDPlayer (1)
21:20:20 T:2124 DEBUG: CPlayerCoreFactory::GetPlayers: added 2 players
21:20:20 T:2124 DEBUG: FactoryCodec - Audio: pcm - Opening
21:20:20 T:2124 DEBUG: FactoryCodec - Audio: pcm - Opened
21:20:20 T:2124 INFO: PAPlayer::QueueNextFileEx - Error reading samples
21:20:20 T:2124 DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc
21:20:20 T:2124 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop
21:20:20 T:2124 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate
21:20:20 T:2124 DEBUG: ------ Window Deinit (MusicVisualisation.xml) ------
21:20:20 T:2124 DEBUG: CGUIWindowManager::PreviousWindow: Activate new
21:20:20 T:2124 DEBUG: ------ Window Init (Home.xml) ------
21:20:20 T:3236 DEBUG: AIRTUNES: AirPlay not running - stopping player
21:20:21 T:2124 DEBUG: Activating window ID: 12006
21:20:21 T:2952 NOTICE: Invoking URL: http://api.yousee.tv/rest/tvguide/programs/tvdate/2013-11-26/channel_id/151/format/json
21:20:21 T:2124 DEBUG: ------ Window Deinit (Home.xml) ------
21:20:21 T:2124 DEBUG: CApplication::ExecuteXBMCAction : Translating ClearProperty(VideosDirectLink)
21:20:21 T:2124 DEBUG: CApplication::ExecuteXBMCAction : To ClearProperty(VideosDirectLink)
21:20:21 T:2124 DEBUG: ------ Window Init (MusicVisualisation.xml) ------
21:20:21 T:2124 DEBUG: CPlayerCoreFactory::GetPlayers(pipe://2/)
21:20:21 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules
21:20:21 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules
21:20:21 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtv
21:20:21 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: hdhomerun/myth/mms/udp
21:20:21 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout
21:20:21 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp
21:20:21 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp
21:20:21 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams
21:20:21 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd
21:20:21 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage
21:20:21 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf
21:20:21 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv
21:20:21 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio
21:20:21 T:2124 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players
21:20:21 T:2124 DEBUG: CPlayerCoreFactory::GetPlayers: adding audiodefaultplayer (3)
21:20:21 T:2124 DEBUG: CPlayerCoreFactory::GetPlayers: for video=0, audio=1
21:20:21 T:2124 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: PAPlayer (3)
21:20:21 T:2124 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1
21:20:21 T:2124 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: DVDPlayer (1)
21:20:21 T:2124 DEBUG: CPlayerCoreFactory::GetPlayers: added 2 players
21:20:21 T:2124 ERROR: DVDPlayerCodec::Init: Error opening file pipe://2/
21:20:21 T:2124 ERROR: CAudioDecoder: Unable to Init Codec while loading file pipe://2/
21:20:21 T:2124 WARNING: PAPlayer::QueueNextFileEx - Failed to create the decoder
21:20:21 T:2124 DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc
21:20:21 T:2124 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop
21:20:21 T:2124 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate
21:20:21 T:2124 DEBUG: ------ Window Deinit (MusicVisualisation.xml) ------
21:20:21 T:2124 DEBUG: CGUIWindowManager::PreviousWindow: Activate new
21:20:21 T:2124 DEBUG: ------ Window Init (Home.xml) ------
21:20:21 T:3240 DEBUG: AIRTUNES: AirPlay not running - stopping player
21:20:21 T:2124 DEBUG: Activating window ID: 12006
21:20:22 T:2124 DEBUG: ------ Window Deinit (Home.xml) ------
21:20:22 T:2124 DEBUG: CApplication::ExecuteXBMCAction : Translating ClearProperty(VideosDirectLink)
21:20:22 T:2124 DEBUG: CApplication::ExecuteXBMCAction : To ClearProperty(VideosDirectLink)
21:20:22 T:2124 DEBUG: ------ Window Init (MusicVisualisation.xml) ------
21:20:22 T:3244 DEBUG: CAnnouncementManager - Announcement: OnVolumeChanged from xbmc
21:20:22 T:3244 DEBUG: GOT ANNOUNCEMENT, type: 64, from xbmc, message OnVolumeChanged
21:20:22 T:2124 DEBUG: CPlayerCoreFactory::GetPlayers(pipe://3/)
21:20:22 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules
21:20:22 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules
21:20:22 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtv
21:20:22 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: hdhomerun/myth/mms/udp
21:20:22 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout
21:20:22 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp
21:20:22 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp
21:20:22 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams
21:20:22 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd
21:20:22 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage
21:20:22 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf
21:20:22 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv
21:20:22 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio
21:20:22 T:2124 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players
21:20:22 T:2124 DEBUG: CPlayerCoreFactory::GetPlayers: adding audiodefaultplayer (3)
21:20:22 T:2124 DEBUG: CPlayerCoreFactory::GetPlayers: for video=0, audio=1
21:20:22 T:2124 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: PAPlayer (3)
21:20:22 T:2124 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1
21:20:22 T:2124 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: DVDPlayer (1)
21:20:22 T:2124 DEBUG: CPlayerCoreFactory::GetPlayers: added 2 players
21:20:22 T:2124 ERROR: DVDPlayerCodec::Init: Error creating demuxer
21:20:22 T:2124 ERROR: CAudioDecoder: Unable to Init Codec while loading file pipe://3/
21:20:22 T:2124 WARNING: PAPlayer::QueueNextFileEx - Failed to create the decoder
21:20:22 T:2124 DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc
21:20:22 T:2124 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop
21:20:22 T:2124 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate
21:20:22 T:2124 DEBUG: ------ Window Deinit (MusicVisualisation.xml) ------
21:20:22 T:2124 DEBUG: CGUIWindowManager::PreviousWindow: Activate new
21:20:22 T:2124 DEBUG: ------ Window Init (Home.xml) ------
21:20:22 T:2952 NOTICE: Invoking URL: http://api.yousee.tv/rest/tvguide/programs/tvdate/2013-11-26/channel_id/505/format/json
21:20:24 T:2952 NOTICE: Invoking URL: http://api.yousee.tv/rest/tvguide/programs/tvdate/2013-11-26/channel_id/19/format/json
21:20:26 T:2952 NOTICE: Invoking URL: http://api.yousee.tv/rest/tvguide/programs/tvdate/2013-11-26/channel_id/21/format/json
21:20:29 T:2952 NOTICE: Invoking URL: http://api.yousee.tv/rest/tvguide/programs/tvdate/2013-11-26/channel_id/20/format/json
21:20:31 T:2952 NOTICE: Invoking URL: http://api.yousee.tv/rest/tvguide/programs/tvdate/2013-11-26/channel_id/18/format/json
21:20:32 T:2952 NOTICE: Invoking URL: http://api.yousee.tv/rest/tvguide/programs/tvdate/2013-11-26/channel_id/174/format/json
21:20:35 T:2952 NOTICE: Invoking URL: http://api.yousee.tv/rest/tvguide/programs/tvdate/2013-11-26/channel_id/25/format/json
21:20:35 T:2952 NOTICE: Invoking URL: http://api.yousee.tv/rest/tvguide/programs/tvdate/2013-11-26/channel_id/26/format/json
21:20:36 T:2952 NOTICE: Invoking URL: http://api.yousee.tv/rest/tvguide/programs/tvdate/2013-11-26/channel_id/24/format/json
21:20:38 T:2952 NOTICE: Invoking URL: http://api.yousee.tv/rest/tvguide/programs/tvdate/2013-11-26/channel_id/140/format/json
21:20:39 T:2952 NOTICE: Invoking URL: http://api.yousee.tv/rest/tvguide/programs/tvdate/2013-11-26/channel_id/37/format/json
21:20:39 T:2952 NOTICE: Invoking URL: http://api.yousee.tv/rest/tvguide/programs/tvdate/2013-11-26/channel_id/35/format/json
21:20:41 T:2952 NOTICE: Invoking URL: http://api.yousee.tv/rest/tvguide/programs/tvdate/2013-11-26/channel_id/160/format/json
21:20:41 T:2124 DEBUG: ------ Window Init (Pointer.xml) ------
21:20:42 T:2952 NOTICE: Invoking URL: http://api.yousee.tv/rest/tvguide/programs/tvdate/2013-11-26/channel_id/93/format/json
21:20:43 T:3312 NOTICE: Thread Jobworker start, auto delete: true
21:20:44 T:2952 NOTICE: Previous line repeats 1 times.
21:20:44 T:2952 NOTICE: Invoking URL: http://api.yousee.tv/rest/tvguide/programs/tvdate/2013-11-26/channel_id/138/format/json
21:20:45 T:2952 NOTICE: Invoking URL: http://api.yousee.tv/rest/tvguide/programs/tvdate/2013-11-26/channel_id/95/format/json
21:20:46 T:2952 NOTICE: Invoking URL: http://api.yousee.tv/rest/tvguide/programs/tvdate/2013-11-26/channel_id/130/format/json
21:20:48 T:2952 NOTICE: Invoking URL: http://api.yousee.tv/rest/tvguide/programs/tvdate/2013-11-26/channel_id/131/format/json
21:20:48 T:2124 DEBUG: CApplication::ProcessMouse: trying mouse action leftclick
21:20:48 T:2124 DEBUG: CApplication::ExecuteXBMCAction : Translating ActivateWindow(Settings)
21:20:48 T:2124 DEBUG: CApplication::ExecuteXBMCAction : To ActivateWindow(Settings)
21:20:48 T:2124 DEBUG: Activating window ID: 10004
21:20:48 T:2124 DEBUG: ------ Window Deinit (Home.xml) ------
21:20:48 T:2124 DEBUG: ------ Window Init (Settings.xml) ------
21:20:48 T:2124 INFO: Loading skin file: Settings.xml, load type: KEEP_IN_MEMORY
21:20:49 T:2952 NOTICE: Invoking URL: http://api.yousee.tv/rest/tvguide/programs/tvdate/2013-11-26/channel_id/119/format/json
21:20:50 T:2124 DEBUG: CApplication::ProcessMouse: trying mouse action leftclick
21:20:50 T:2124 DEBUG: CApplication::ExecuteXBMCAction : Translating ActivateWindow(ServiceSettings)
21:20:50 T:2124 DEBUG: CApplication::ExecuteXBMCAction : To ActivateWindow(ServiceSettings)
21:20:50 T:2124 DEBUG: Activating window ID: 10018
21:20:50 T:2124 DEBUG: ------ Window Deinit (Settings.xml) ------
21:20:50 T:2124 DEBUG: ------ Window Init (SettingsCategory.xml) ------
21:20:50 T:2124 INFO: Loading skin file: SettingsCategory.xml, load type: KEEP_IN_MEMORY
21:20:50 T:3328 NOTICE: [script.tvguide] Scheduling notifications
21:20:50 T:2952 NOTICE: Database.eventLoop() >>>>>>>>>> processing command: _getNotifications
21:20:50 T:2684 INFO: Scriptresult: Waiting on thread 3328
21:20:50 T:2952 NOTICE: Database.eventLoop() >>>>>>>>>> processing command: _close
21:20:50 T:2952 NOTICE: Database.eventLoop() >>>>>>>>>> exiting...
21:20:50 T:2684 INFO: Python script stopped
21:20:50 T:2684 DEBUG: Thread XBPyThread 2684 terminating
21:20:50 T:2124 DEBUG: waiting for python thread 1 (C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.tvguide\service.py) to stop
21:20:50 T:2124 DEBUG: python thread 1 (C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.tvguide\service.py) destructed
21:21:01 T:2124 DEBUG: CApplication::ProcessMouse: trying mouse action leftclick
21:21:04 T:2124 DEBUG: Keyboard: scancode: 01, sym: 001b, unicode: 001b, modifier: 0
21:21:04 T:2124 DEBUG: CApplication::OnKey: escape (f01b) pressed, action is PreviousMenu
21:21:04 T:2980 DEBUG: Resumed the Sink
21:21:04 T:2980 DEBUG: CSoftAE::Run - Sink restart flagged
21:21:04 T:2980 INFO: CSoftAE::InternalOpenSink - sink incompatible, re-starting
21:21:04 T:2124 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate
21:21:04 T:2124 DEBUG: ------ Window Deinit (Pointer.xml) ------
21:21:04 T:2980 DEBUG: CAESinkDirectSound::Initialize: Using Window handle: 262182
21:21:04 T:2980 DEBUG: CAESinkDirectSound::Initialize: secondary buffer created
21:21:04 T:2980 DEBUG: CAESinkDirectSound::Initialize: Initializing DirectSound with the following parameters:
21:21:04 T:2980 DEBUG: Audio Device : Speakers (2- High Definition Audio Device)
21:21:04 T:2980 DEBUG: Sample Rate : 44100
21:21:04 T:2980 DEBUG: Sample Format : AE_FMT_FLOAT
21:21:04 T:2980 DEBUG: Bits Per Sample : 32
21:21:04 T:2980 DEBUG: Valid Bits/Samp : 32
21:21:04 T:2980 DEBUG: Channel Count : 2
21:21:04 T:2980 DEBUG: Block Align : 8
21:21:04 T:2980 DEBUG: Avg. Bytes Sec : 352800
21:21:04 T:2980 DEBUG: Samples/Block : 32
21:21:04 T:2980 DEBUG: Format cBSize : 22
21:21:04 T:2980 DEBUG: Channel Layout : FL,FR
21:21:04 T:2980 DEBUG: Channel Mask : 3
21:21:04 T:2980 DEBUG: Frames : 441
21:21:04 T:2980 DEBUG: Frame Samples : 882
21:21:04 T:2980 DEBUG: Frame Size : 8
21:21:04 T:2980 DEBUG: CSoftAE::InternalOpenSink - DirectSound Initialized:
21:21:04 T:2980 DEBUG: Output Device : Speakers - Speakers (2- High Definition Audio Device)
21:21:04 T:2980 DEBUG: Sample Rate : 44100
21:21:04 T:2980 DEBUG: Sample Format : AE_FMT_FLOAT
21:21:04 T:2980 DEBUG: Channel Count : 2
21:21:04 T:2980 DEBUG: Channel Layout: FL,FR
21:21:04 T:2980 DEBUG: Frames : 441
21:21:04 T:2980 DEBUG: Frame Samples : 882
21:21:04 T:2980 DEBUG: Frame Size : 8
21:21:04 T:2980 DEBUG: CSoftAE::InternalOpenSink - Using speaker layout: 2.1
21:21:04 T:2980 DEBUG: CSoftAE::InternalOpenSink - Internal Buffer Size: 3528
21:21:05 T:2980 DEBUG: CAESinkDirectSound::CheckPlayStatus: Resuming Playback
21:21:05 T:2124 DEBUG: ------ Window Deinit (SettingsCategory.xml) ------
21:21:05 T:2124 DEBUG: CGUIWindowManager::PreviousWindow: Activate new
21:21:05 T:2124 DEBUG: ------ Window Init (Settings.xml) ------
21:21:06 T:2124 DEBUG: ------ Window Init (Pointer.xml) ------
21:21:14 T:2124 DEBUG: CApplication::ProcessMouse: trying mouse action leftclick
21:21:14 T:2124 DEBUG: CApplication::ExecuteXBMCAction : Translating ActivateWindow(ServiceSettings)
21:21:14 T:2124 DEBUG: CApplication::ExecuteXBMCAction : To ActivateWindow(ServiceSettings)
21:21:14 T:2124 DEBUG: Activating window ID: 10018
21:21:14 T:2124 DEBUG: ------ Window Deinit (Settings.xml) ------
21:21:14 T:2124 DEBUG: ------ Window Init (SettingsCategory.xml) ------
21:21:15 T:2980 DEBUG: CAESinkDirectSound::Deinitialize: Cleaning up
21:21:15 T:2980 DEBUG: Suspended the Sink
21:21:19 T:2124 DEBUG: CApplication::ProcessMouse: trying mouse action leftclick
21:21:25 T:2124 DEBUG: Keyboard: scancode: 01, sym: 001b, unicode: 001b, modifier: 0
21:21:25 T:2124 DEBUG: CApplication::OnKey: escape (f01b) pressed, action is PreviousMenu
21:21:25 T:2980 DEBUG: Resumed the Sink
21:21:25 T:2980 DEBUG: CSoftAE::Run - Sink restart flagged
21:21:25 T:2980 INFO: CSoftAE::InternalOpenSink - sink incompatible, re-starting
21:21:25 T:2124 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate
21:21:25 T:2980 DEBUG: CAESinkDirectSound::Initialize: Using Window handle: 262182
21:21:25 T:2124 DEBUG: ------ Window Deinit (Pointer.xml) ------
21:21:25 T:2980 DEBUG: CAESinkDirectSound::Initialize: secondary buffer created
21:21:25 T:2980 DEBUG: CAESinkDirectSound::Initialize: Initializing DirectSound with the following parameters:
21:21:25 T:2980 DEBUG: Audio Device : Speakers (2- High Definition Audio Device)
21:21:25 T:2980 DEBUG: Sample Rate : 44100
21:21:25 T:2980 DEBUG: Sample Format : AE_FMT_FLOAT
21:21:25 T:2980 DEBUG: Bits Per Sample : 32
21:21:25 T:2980 DEBUG: Valid Bits/Samp : 32
21:21:25 T:2980 DEBUG: Channel Count : 2
21:21:25 T:2980 DEBUG: Block Align : 8
21:21:25 T:2980 DEBUG: Avg. Bytes Sec : 352800
21:21:25 T:2980 DEBUG: Samples/Block : 32
21:21:25 T:2980 DEBUG: Format cBSize : 22
21:21:25 T:2980 DEBUG: Channel Layout : FL,FR
21:21:25 T:2980 DEBUG: Channel Mask : 3
21:21:25 T:2980 DEBUG: Frames : 441
21:21:25 T:2980 DEBUG: Frame Samples : 882
21:21:25 T:2980 DEBUG: Frame Size : 8
21:21:25 T:2980 DEBUG: CSoftAE::InternalOpenSink - DirectSound Initialized:
21:21:25 T:2980 DEBUG: Output Device : Speakers - Speakers (2- High Definition Audio Device)
21:21:25 T:2980 DEBUG: Sample Rate : 44100
21:21:25 T:2980 DEBUG: Sample Format : AE_FMT_FLOAT
21:21:25 T:2980 DEBUG: Channel Count : 2
21:21:25 T:2980 DEBUG: Channel Layout: FL,FR
21:21:25 T:2980 DEBUG: Frames : 441
21:21:25 T:2980 DEBUG: Frame Samples : 882
21:21:25 T:2980 DEBUG: Frame Size : 8
21:21:25 T:2980 DEBUG: CSoftAE::InternalOpenSink - Using speaker layout: 2.1
21:21:25 T:2980 DEBUG: CSoftAE::InternalOpenSink - Internal Buffer Size: 3528
21:21:25 T:2980 DEBUG: CAESinkDirectSound::CheckPlayStatus: Resuming Playback
21:21:25 T:2124 DEBUG: ------ Window Deinit (SettingsCategory.xml) ------
21:21:25 T:2124 DEBUG: CGUIWindowManager::PreviousWindow: Activate new
21:21:25 T:2124 DEBUG: ------ Window Init (Settings.xml) ------
21:21:26 T:2124 DEBUG: ------ Window Init (Pointer.xml) ------
21:21:27 T:2124 DEBUG: Keyboard: scancode: 01, sym: 001b, unicode: 001b, modifier: 0
21:21:27 T:2124 DEBUG: CApplication::OnKey: escape (f01b) pressed, action is PreviousMenu
21:21:27 T:2124 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate
21:21:27 T:2124 DEBUG: ------ Window Deinit (Pointer.xml) ------
21:21:27 T:2124 DEBUG: ------ Window Deinit (Settings.xml) ------
21:21:27 T:2124 DEBUG: CGUIWindowManager::PreviousWindow: Activate new
21:21:27 T:2124 DEBUG: ------ Window Init (Home.xml) ------
21:21:28 T:2124 DEBUG: Keyboard: scancode: 48, sym: 0111, unicode: 0000, modifier: 0
21:21:28 T:2124 DEBUG: CApplication::OnKey: up (f080) pressed, action is Up
21:21:28 T:2124 DEBUG: Keyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0
21:21:28 T:2124 DEBUG: CApplication::OnKey: down (f081) pressed, action is Down
21:21:29 T:2124 DEBUG: Keyboard: scancode: 4b, sym: 0114, unicode: 0000, modifier: 0
21:21:29 T:2124 DEBUG: CApplication::OnKey: left (f082) pressed, action is Left
21:21:29 T:2124 DEBUG: Keyboard: scancode: 4b, sym: 0114, unicode: 0000, modifier: 0
21:21:29 T:2124 DEBUG: CApplication::OnKey: left (f082) pressed, action is Left
21:21:29 T:2124 DEBUG: Keyboard: scancode: 4b, sym: 0114, unicode: 0000, modifier: 0
21:21:29 T:2124 DEBUG: CApplication::OnKey: left (f082) pressed, action is Left
21:21:29 T:2124 DEBUG: Keyboard: scancode: 4b, sym: 0114, unicode: 0000, modifier: 0
21:21:29 T:2124 DEBUG: CApplication::OnKey: left (f082) pressed, action is Left
21:21:30 T:2124 DEBUG: Keyboard: scancode: 4d, sym: 0113, unicode: 0000, modifier: 0
21:21:30 T:2124 DEBUG: CApplication::OnKey: right (f083) pressed, action is Right
21:21:32 T:2124 DEBUG: Keyboard: scancode: 4d, sym: 0113, unicode: 0000, modifier: 0
21:21:32 T:2124 DEBUG: CApplication::OnKey: right (f083) pressed, action is Right
21:21:33 T:2124 DEBUG: Keyboard: scancode: 4d, sym: 0113, unicode: 0000, modifier: 0
21:21:33 T:2124 DEBUG: CApplication::OnKey: right (f083) pressed, action is Right
21:21:33 T:2124 DEBUG: Keyboard: scancode: 4d, sym: 0113, unicode: 0000, modifier: 0
21:21:33 T:2124 DEBUG: CApplication::OnKey: right (f083) pressed, action is Right
21:21:34 T:2124 DEBUG: Keyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0
21:21:34 T:2124 DEBUG: CApplication::OnKey: down (f081) pressed, action is Down
21:21:35 T:2124 DEBUG: Keyboard: scancode: 4d, sym: 0113, unicode: 0000, modifier: 0
21:21:35 T:2124 DEBUG: CApplication::OnKey: right (f083) pressed, action is Right
21:21:36 T:2124 DEBUG: Keyboard: scancode: 1c, sym: 000d, unicode: 000d, modifier: 0
21:21:36 T:2124 DEBUG: CApplication::OnKey: return (f00d) pressed, action is Select
21:21:36 T:2124 DEBUG: CApplication::ExecuteXBMCAction : Translating ActivateWindow(FileManager)
21:21:36 T:2124 DEBUG: CApplication::ExecuteXBMCAction : To ActivateWindow(FileManager)
21:21:36 T:2124 DEBUG: Activating window ID: 10003
21:21:37 T:2124 DEBUG: ------ Window Deinit (Home.xml) ------
21:21:37 T:2124 INFO: Attempting to default to:
21:21:37 T:2124 DEBUG: ------ Window Init (FileManager.xml) ------
21:21:37 T:2124 INFO: Loading skin file: FileManager.xml, load type: KEEP_IN_MEMORY
21:21:39 T:2124 DEBUG: Keyboard: scancode: 01, sym: 001b, unicode: 001b, modifier: 0
21:21:39 T:2124 DEBUG: CApplication::OnKey: escape (f01b) pressed, action is PreviousMenu
21:21:39 T:2124 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate
21:21:40 T:2124 DEBUG: ------ Window Deinit (FileManager.xml) ------
21:21:40 T:2124 DEBUG: CGUIWindowManager::PreviousWindow: Activate new
21:21:40 T:2124 DEBUG: ------ Window Init (Home.xml) ------
21:21:41 T:2124 DEBUG: Keyboard: scancode: 4d, sym: 0113, unicode: 0000, modifier: 0
21:21:41 T:2124 DEBUG: CApplication::OnKey: right (f083) pressed, action is Right
21:21:41 T:2124 DEBUG: Keyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0
21:21:41 T:2124 DEBUG: CApplication::OnKey: down (f081) pressed, action is Down
21:21:42 T:2124 DEBUG: ------ Window Init (Pointer.xml) ------
21:21:51 T:2980 DEBUG: CAESinkDirectSound::Deinitialize: Cleaning up
21:21:51 T:2980 DEBUG: Suspended the Sink
21:21:52 T:2124 DEBUG: CApplication::ProcessMouse: trying mouse action leftclick
21:21:52 T:2124 DEBUG: CApplication::ExecuteXBMCAction : Translating ActivateWindow(Pictures,Addons,return)
21:21:52 T:2124 DEBUG: CApplication::ExecuteXBMCAction : To ActivateWindow(Pictures,Addons,return)
21:21:52 T:2124 DEBUG: Activating window ID: 10002
21:21:52 T:2124 DEBUG: ------ Window Deinit (Home.xml) ------
21:21:52 T:2124 DEBUG: SECTION:LoadDLL(special://xbmcbin/system/ImageLib.dll)
21:21:52 T:2124 DEBUG: ------ Window Init (MyPics.xml) ------
21:21:52 T:2124 INFO: Loading skin file: MyPics.xml, load type: KEEP_IN_MEMORY
21:21:52 T:2124 DEBUG: CGUIMediaWindow::GetDirectory (addons://sources/image/)
21:21:52 T:2124 DEBUG: ParentPath = [addons://sources/image/]
21:21:52 T:3960 NOTICE: Thread Background Loader start, auto delete: false
21:21:52 T:3960 DEBUG: Thread Background Loader 3960 terminating
21:21:52 T:3964 NOTICE: Thread Background Loader start, auto delete: false
21:21:52 T:3964 DEBUG: Thread Background Loader 3964 terminating
21:21:55 T:3312 DEBUG: Thread Jobworker 3312 terminating (autodelete)
21:21:55 T:3968 NOTICE: Thread Jobworker start, auto delete: true
21:21:55 T:3316 DEBUG: Caching image 'C:\Users\TVUser\AppData\Roaming\XBMC\addons\plugin.image.500px\fanart.jpg' to '5/5eaeb7cd.jpg':
21:21:55 T:3316 DEBUG: cached image 'special://masterprofile/Thumbnails/5/5eaeb7cd.jpg' size 1920x1080
21:21:55 T:3968 DEBUG: Caching image 'C:\Users\TVUser\AppData\Roaming\XBMC\addons\plugin.image.500px\icon.png' to '9/937a2140.jpg':
21:21:55 T:3968 DEBUG: cached image 'special://masterprofile/Thumbnails/9/937a2140.jpg' size 256x256
21:21:56 T:2124 DEBUG: CApplication::ProcessMouse: trying mouse action leftclick
21:21:56 T:2124 DEBUG: CGUIMediaWindow::GetDirectory (plugin://plugin.image.500px/)
21:21:56 T:2124 DEBUG: ParentPath = [addons://sources/image/]
21:21:56 T:3968 DEBUG: XFILE::CPluginDirectory::StartScript - calling plugin 500px('plugin://plugin.image.500px/','1','')
21:21:56 T:3968 INFO: initializing python engine.
21:21:56 T:3968 DEBUG: new python thread created. id=7
21:21:56 T:3972 NOTICE: Thread XBPyThread start, auto delete: false
21:21:56 T:3972 DEBUG: Python thread: start processing
21:21:56 T:3968 DEBUG: XFILE::CPluginDirectory::WaitOnScriptResult - waiting on the 500px (id=7) plugin...
21:21:56 T:3972 NOTICE: -->Python Interpreter Initialized<--
21:21:56 T:3972 DEBUG: XBPyThread::Process - The source file to load is C:\Users\TVUser\AppData\Roaming\XBMC\addons\plugin.image.500px\default.py
21:21:56 T:3972 DEBUG: XBPyThread::Process - Setting the Python path to C:\Users\TVUser\AppData\Roaming\XBMC\addons\plugin.image.500px;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.xbmcswift\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.bigpictures\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.simplejson\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.beautifulsoup4\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.brightcove\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.myconnpy\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.beautifulsoup\lib;C:\Program Files (x86)\XBMC\addons\script.module.pil\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.common.plugin.cache\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.simple.downloader\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.requests\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\plugin.image.500px\resources\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.buggalo\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.parsedom\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.xbmcswift2\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.web.viewer\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.elementtree\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.feedparser\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;
21:21:56 T:3972 DEBUG: XBPyThread::Process - Entering source directory C:\Users\TVUser\AppData\Roaming\XBMC\addons\plugin.image.500px
21:21:56 T:3972 DEBUG: Instantiating addon using automatically obtained id of "plugin.image.500px" dependent on version 2.1.0 of the xbmc.python api
21:21:57 T:2124 DEBUG: ------ Window Init (DialogBusy.xml) ------
21:21:57 T:3972 INFO: Scriptresult: Success
21:21:57 T:3972 INFO: Python script stopped
21:21:57 T:3972 DEBUG: Thread XBPyThread 3972 terminating
21:21:57 T:3968 DEBUG: XFILE::CPluginDirectory::WaitOnScriptResult- plugin returned successfully
21:21:57 T:2124 DEBUG: Saving fileitems [plugin://plugin.image.500px/]
21:21:57 T:2124 DEBUG: -- items: 6, sort method: 0, ascending: false
21:21:57 T:3976 NOTICE: Thread Background Loader start, auto delete: false
21:21:57 T:2124 DEBUG: waiting for python thread 7 (C:\Users\TVUser\AppData\Roaming\XBMC\addons\plugin.image.500px\default.py) to stop
21:21:57 T:2124 DEBUG: python thread 7 (C:\Users\TVUser\AppData\Roaming\XBMC\addons\plugin.image.500px\default.py) destructed
21:21:57 T:3976 DEBUG: Thread Background Loader 3976 terminating
21:21:58 T:2124 DEBUG: ------ Window Deinit (DialogBusy.xml) ------
21:22:01 T:2124 DEBUG: CApplication::ProcessMouse: trying mouse action leftclick
21:22:01 T:2124 DEBUG: CGUIMediaWindow::GetDirectory (plugin://plugin.image.500px/?feature=fresh_today&mode=categories)
21:22:01 T:2124 DEBUG: ParentPath = [plugin://plugin.image.500px/]
21:22:01 T:3316 DEBUG: XFILE::CPluginDirectory::StartScript - calling plugin 500px('plugin://plugin.image.500px/','2','?feature=fresh_today&mode=categories')
21:22:01 T:3316 INFO: initializing python engine.
21:22:01 T:3316 DEBUG: new python thread created. id=8
21:22:01 T:3980 NOTICE: Thread XBPyThread start, auto delete: false
21:22:01 T:3980 DEBUG: Python thread: start processing
21:22:01 T:3316 DEBUG: XFILE::CPluginDirectory::WaitOnScriptResult - waiting on the 500px (id=8) plugin...
21:22:01 T:3980 NOTICE: -->Python Interpreter Initialized<--
21:22:01 T:3980 DEBUG: XBPyThread::Process - The source file to load is C:\Users\TVUser\AppData\Roaming\XBMC\addons\plugin.image.500px\default.py
21:22:01 T:3980 DEBUG: XBPyThread::Process - Setting the Python path to C:\Users\TVUser\AppData\Roaming\XBMC\addons\plugin.image.500px;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.xbmcswift\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.bigpictures\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.simplejson\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.beautifulsoup4\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.brightcove\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.myconnpy\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.beautifulsoup\lib;C:\Program Files (x86)\XBMC\addons\script.module.pil\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.common.plugin.cache\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.simple.downloader\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.requests\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\plugin.image.500px\resources\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.buggalo\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.parsedom\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.xbmcswift2\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.web.viewer\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.elementtree\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.feedparser\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;
21:22:01 T:3980 DEBUG: XBPyThread::Process - Entering source directory C:\Users\TVUser\AppData\Roaming\XBMC\addons\plugin.image.500px
21:22:01 T:3980 DEBUG: Instantiating addon using automatically obtained id of "plugin.image.500px" dependent on version 2.1.0 of the xbmc.python api
21:22:02 T:2124 DEBUG: ------ Window Init (DialogBusy.xml) ------
21:22:02 T:3980 INFO: Scriptresult: Success
21:22:02 T:3980 INFO: Python script stopped
21:22:02 T:3980 DEBUG: Thread XBPyThread 3980 terminating
21:22:02 T:3316 DEBUG: XFILE::CPluginDirectory::WaitOnScriptResult- plugin returned successfully
21:22:02 T:3984 NOTICE: Thread Background Loader start, auto delete: false
21:22:02 T:2124 DEBUG: waiting for python thread 8 (C:\Users\TVUser\AppData\Roaming\XBMC\addons\plugin.image.500px\default.py) to stop
21:22:02 T:2124 DEBUG: python thread 8 (C:\Users\TVUser\AppData\Roaming\XBMC\addons\plugin.image.500px\default.py) destructed
21:22:02 T:2124 DEBUG: ------ Window Deinit (DialogBusy.xml) ------
21:22:02 T:3984 DEBUG: Thread Background Loader 3984 terminating
21:22:03 T:2124 DEBUG: CApplication::ProcessMouse: trying mouse action leftclick
21:22:03 T:2124 DEBUG: CGUIMediaWindow::GetDirectory (plugin://plugin.image.500px/?feature=fresh_today&mode=feature)
21:22:03 T:2124 DEBUG: ParentPath = [plugin://plugin.image.500px/?feature=fresh_today&mode=categories]
21:22:03 T:3316 DEBUG: XFILE::CPluginDirectory::StartScript - calling plugin 500px('plugin://plugin.image.500px/','3','?feature=fresh_today&mode=feature')
21:22:03 T:3316 INFO: initializing python engine.
21:22:03 T:3316 DEBUG: new python thread created. id=9
21:22:03 T:3316 DEBUG: XFILE::CPluginDirectory::WaitOnScriptResult - waiting on the 500px (id=9) plugin...
21:22:03 T:3988 NOTICE: Thread XBPyThread start, auto delete: false
21:22:03 T:3988 DEBUG: Python thread: start processing
21:22:04 T:3988 NOTICE: -->Python Interpreter Initialized<--
21:22:04 T:3988 DEBUG: XBPyThread::Process - The source file to load is C:\Users\TVUser\AppData\Roaming\XBMC\addons\plugin.image.500px\default.py
21:22:04 T:3988 DEBUG: XBPyThread::Process - Setting the Python path to C:\Users\TVUser\AppData\Roaming\XBMC\addons\plugin.image.500px;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.xbmcswift\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.bigpictures\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.simplejson\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.beautifulsoup4\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.brightcove\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.myconnpy\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.beautifulsoup\lib;C:\Program Files (x86)\XBMC\addons\script.module.pil\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.common.plugin.cache\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.simple.downloader\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.requests\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\plugin.image.500px\resources\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.buggalo\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.parsedom\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.xbmcswift2\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.web.viewer\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.elementtree\lib;C:\Users\TVUser\AppData\Roaming\XBMC\addons\script.module.feedparser\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;
21:22:04 T:3988 DEBUG: XBPyThread::Process - Entering source directory C:\Users\TVUser\AppData\Roaming\XBMC\addons\plugin.image.500px
21:22:04 T:3988 DEBUG: Instantiating addon using automatically obtained id of "plugin.image.500px" dependent on version 2.1.0 of the xbmc.python api
21:22:04 T:2124 DEBUG: ------ Window Init (DialogBusy.xml) ------
21:22:09 T:2124 DEBUG: ------ Window Deinit (Pointer.xml) ------
21:22:10 T:3988 INFO: Scriptresult: Success
21:22:10 T:3988 INFO: Python script stopped
21:22:10 T:3988 DEBUG: Thread XBPyThread 3988 terminating
21:22:10 T:2124 DEBUG: waiting for python thread 9 (C:\Users\TVUser\AppData\Roaming\XBMC\addons\plugin.image.500px\default.py) to stop
21:22:10 T:2124 DEBUG: python thread 9 (C:\Users\TVUser\AppData\Roaming\XBMC\addons\plugin.image.500px\default.py) destructed
21:22:10 T:3316 DEBUG: XFILE::CPluginDirectory::WaitOnScriptResult- plugin returned successfully
21:22:10 T:2124 DEBUG: Saving fileitems [plugin://plugin.image.500px/?feature=fresh_today&mode=feature]
21:22:10 T:2124 DEBUG: -- items: 41, sort method: 0, ascending: false
21:22:10 T:3992 NOTICE: Thread Background Loader start, auto delete: false
21:22:10 T:3996 NOTICE: Previous line repeats 1 times.
21:22:10 T:3996 DEBUG: Thread Background Loader 3996 terminating
21:22:10 T:4004 NOTICE: Thread Background Loader start, auto delete: false
21:22:10 T:4004 DEBUG: Thread Background Loader 4004 terminating
21:22:10 T:3992 DEBUG: Thread Background Loader 3992 terminating
21:22:10 T:4000 NOTICE: Thread Background Loader start, auto delete: false
21:22:10 T:4000 DEBUG: Thread Background Loader 4000 terminating
21:22:10 T:4008 NOTICE: Thread Background Loader start, auto delete: false
21:22:10 T:4008 DEBUG: Thread Background Loader 4008 terminating
21:22:10 T:4012 NOTICE: Thread Background Loader start, auto delete: false
21:22:10 T:4012 INFO: XCURL::DllLibCurlGlobal::easy_aquire - Created session to http://ppcdn.500px.org
21:22:10 T:2124 DEBUG: ------ Window Deinit (DialogBusy.xml) ------
21:22:10 T:4012 DEBUG: CCurlFile::GetMimeType - http://ppcdn.500px.org/53314056/abe251b15c6516ef45cdcff4353c0203c1e357ae/4.jpg -> image/jpeg
21:22:10 T:3968 INFO: XCURL::DllLibCurlGlobal::easy_aquire - Created session to http://ppcdn.500px.org
21:22:10 T:4012 DEBUG: CCurlFile::GetMimeType - http://ppcdn.500px.org/53314058/5b9ada39f00429c294b4578816ed8ffae96eaba6/4.jpg -> image/jpeg
21:22:10 T:4012 DEBUG: CCurlFile::GetMimeType - http://ppcdn.500px.org/53314054/a8e6a7430b500a53c9e7391c940fa37a3bb2a2de/4.jpg -> image/jpeg
21:22:10 T:3968 DEBUG: CurlFile::Open(0E85AC50) http://ppcdn.500px.org/53314056/abe251b15c6516ef45cdcff4353c0203c1e357ae/2.jpg
21:22:11 T:4012 DEBUG: CCurlFile::GetMimeType - http://ppcdn.500px.org/53314052/670ca0edda6db03d16e668c6453148361420c547/4.jpg -> image/jpeg
21:22:11 T:4012 DEBUG: CCurlFile::GetMimeType - http://ppcdn.500px.org/53314014/5b1494d48870acc31892b90cf50ceffa8ad2ad19/4.jpg -> image/jpeg
21:22:11 T:3968 DEBUG: Caching image 'http://ppcdn.500px.org/53314056/abe251b15c6516ef45cdcff4353c0203c1e357ae/2.jpg' to '5/520d02b1.jpg':
21:22:11 T:3968 DEBUG: cached image 'special://masterprofile/Thumbnails/5/520d02b1.jpg' size 140x140
21:22:11 T:4012 DEBUG: CCurlFile::GetMimeType - http://ppcdn.500px.org/53314044/5a9afb955fcdf5ed888520d7487826a13cec5054/4.jpg -> image/jpeg
21:22:11 T:2124 DEBUG: ------ Window Init (Pointer.xml) ------
21:22:11 T:3968 DEBUG: CurlFile::Open(0E85AC50) http://ppcdn.500px.org/53314058/5b9ada39f00429c294b4578816ed8ffae96eaba6/2.jpg
21:22:11 T:4012 DEBUG: CCurlFile::GetMimeType - http://ppcdn.500px.org/53314022/85e174f8d0647de40f8442cd1f98a1046fa886a3/4.jpg -> image/jpeg
21:22:11 T:4012 DEBUG: CCurlFile::GetMimeType - http://ppcdn.500px.org/53314018/e65c769628c8ed13b27f4475532de4ed94f4a980/4.jpg -> image/jpeg
21:22:12 T:3968 DEBUG: Caching image 'http://ppcdn.500px.org/53314058/5b9ada39f00429c294b4578816ed8ffae96eaba6/2.jpg' to '7/729b0802.jpg':
21:22:12 T:3968 DEBUG: cached image 'special://masterprofile/Thumbnails/7/729b0802.jpg' size 140x140
21:22:12 T:4012 DEBUG: CCurlFile::GetMimeType - http://ppcdn.500px.org/53314016/a7cb7a1c335e6cf1505ad7ed3cdee9ff3c42f005/4.jpg -> image/jpeg
21:22:12 T:4012 DEBUG: CCurlFile::GetMimeType - http://ppcdn.500px.org/53314012/0bda74fb644694a9b3afac2f352d1f5d01ebc000/4.jpg -> image/jpeg
21:22:12 T:4012 DEBUG: CCurlFile::GetMimeType - http://ppcdn.500px.org/53314008/d4b0577d622c200f80407a209559675be4fc22b0/4.jpg -> image/jpeg
21:22:12 T:3968 DEBUG: CurlFile::Open(0E85AC50) http://ppcdn.500px.org/53314054/a8e6a7430b500a53c9e7391c940fa37a3bb2a2de/2.jpg
21:22:12 T:4012 DEBUG: CCurlFile::GetMimeType - http://ppcdn.500px.org/53313934/2d36c9c2bc0fc3e5974f0c981cd836560f10b2aa/4.jpg -> image/jpeg
21:22:13 T:4012 DEBUG: CCurlFile::GetMimeType - http://ppcdn.500px.org/53313930/d80bf34be19622d80219548bbf2eb9dc57ee7d02/4.jpg -> image/jpeg
21:22:13 T:3968 DEBUG: Caching image 'http://ppcdn.500px.org/53314054/a8e6a7430b500a53c9e7391c940fa37a3bb2a2de/2.jpg' to 'e/e841b826.jpg':
21:22:13 T:3968 DEBUG: cached image 'special://masterprofile/Thumbnails/e/e841b826.jpg' size 140x140
21:22:13 T:4012 DEBUG: CCurlFile::GetMimeType - http://ppcdn.500px.org/53313932/fb701c5886e7e2e1824aa6a42f22c6cbea682bda/4.jpg -> image/jpeg
21:22:13 T:4036 NOTICE: Thread Jobworker start, auto delete: true
21:22:13 T:3316 NOTICE: Previous line repeats 1 times.
21:22:13 T:3316 INFO: XCURL::DllLibCurlGlobal::easy_aquire - Created session to http://ppcdn.500px.org
21:22:13 T:4012 DEBUG: CCurlFile::GetMimeType - http://ppcdn.500px.org/53313914/78f5c12f7fb318743529500d1cd923a9b3330fe0/4.jpg -> image/jpeg
21:22:13 T:4012 DEBUG: CCurlFile::GetMimeType - http://ppcdn.500px.org/53313924/88ec782e0ab33c8aaa505a49b772d66ddcc489f1/4.jpg -> image/jpeg
21:22:13 T:4040 INFO: XCURL::DllLibCurlGlobal::easy_aquire - Created session to http://ppcdn.500px.org
21:22:13 T:4036 DEBUG: CurlFile::Open(0E85AC50) http://ppcdn.500px.org/53314052/670ca0edda6db03d16e668c6453148361420c547/2.jpg
21:22:13 T:3316 DEBUG: CurlFile::Open(09243580) http://ppcdn.500px.org/53314014/5b1494d48870acc31892b90cf50ceffa8ad2ad19/2.jpg
21:22:13 T:4012 DEBUG: CCurlFile::GetMimeType - http://ppcdn.500px.org/53313896/e95a2becb1fcc4d1b21809f5a4dfe738e9885394/4.jpg -> image/jpeg
21:22:13 T:4040 DEBUG: CurlFile::Open(092A8B90) http://ppcdn.500px.org/53314044/5a9afb955fcdf5ed888520d7487826a13cec5054/2.jpg
21:22:13 T:4012 DEBUG: CCurlFile::GetMimeType - http://ppcdn.500px.org/53313918/7867deccf5df51d1d6da6500db318485ec46f70b/4.jpg -> image/jpeg
21:22:13 T:4036 DEBUG: Caching image 'http://ppcdn.500px.org/53314052/670ca0edda6db03d16e668c6453148361420c547/2.jpg' to '8/8ff132dc.jpg':
21:22:13 T:4036 DEBUG: cached image 'special://masterprofile/Thumbnails/8/8ff132dc.jpg' size 140x140
21:22:13 T:3316 DEBUG: Caching image 'http://ppcdn.500px.org/53314014/5b1494d48870acc31892b90cf50ceffa8ad2ad19/2.jpg' to '1/11572ce1.jpg':
21:22:13 T:3316 DEBUG: cached image 'special://masterprofile/Thumbnails/1/11572ce1.jpg' size 140x140
21:22:14 T:4012 DEBUG: CCurlFile::GetMimeType - http://ppcdn.500px.org/53313894/4c870039b421d5b02a41df7421901718342ed991/4.jpg -> image/jpeg
21:22:14 T:4040 DEBUG: Caching image 'http://ppcdn.500px.org/53314044/5a9afb955fcdf5ed888520d7487826a13cec5054/2.jpg' to '5/5e2ec7ac.jpg':
21:22:14 T:4040 DEBUG: cached image 'special://masterprofile/Thumbnails/5/5e2ec7ac.jpg' size 140x140
21:22:14 T:4012 DEBUG: CCurlFile::GetMimeType - http://ppcdn.500px.org/53313898/f6317f897062bd4bbdfc330c408698f7b5b9e7dc/4.jpg -> image/jpeg
21:22:14 T:4012 DEBUG: CCurlFile::GetMimeType - http://ppcdn.500px.org/53313904/f82b60fc84ac80aa04fd228eda6ae8ae67e483a7/4.jpg -> image/jpeg
21:22:14 T:2124 DEBUG: Keyboard: scancode: 01, sym: 001b, unicode: 001b, modifier: 0
21:22:14 T:2124 DEBUG: CApplication::OnKey: escape (f01b) pressed, action is PreviousMenu
21:22:14 T:2124 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate
21:22:14 T:2124 DEBUG: ------ Window Deinit (Pointer.xml) ------
21:22:14 T:2980 DEBUG: Resumed the Sink
21:22:14 T:2980 DEBUG: CSoftAE::Run - Sink restart flagged
21:22:14 T:2980 INFO: CSoftAE::InternalOpenSink - sink incompatible, re-starting
21:22:14 T:2980 DEBUG: CAESinkDirectSound::Initialize: Using Window handle: 262182
21:22:14 T:2980 DEBUG: CAESinkDirectSound::Initialize: secondary buffer created
21:22:14 T:2980 DEBUG: CAESinkDirectSound::Initialize: Initializing DirectSound with the following parameters:
21:22:14 T:2980 DEBUG: Audio Device : Speakers (2- High Definition Audio Device)
21:22:14 T:2980 DEBUG: Sample Rate : 44100
21:22:14 T:2980 DEBUG: Sample Format : AE_FMT_FLOAT
21:22:14 T:2980 DEBUG: Bits Per Sample : 32
21:22:14 T:2980 DEBUG: Valid Bits/Samp : 32
21:22:14 T:2980 DEBUG: Channel Count : 2
21:22:14 T:2980 DEBUG: Block Align : 8
21:22:14 T:2980 DEBUG: Avg. Bytes Sec : 352800
21:22:14 T:2980 DEBUG: Samples/Block : 32
21:22:14 T:2980 DEBUG: Format cBSize : 22
21:22:14 T:2980 DEBUG: Channel Layout : FL,FR
21:22:14 T:2980 DEBUG: Channel Mask : 3
21:22:14 T:2980 DEBUG: Frames : 441
21:22:14 T:2980 DEBUG: Frame Samples : 882
21:22:14 T:2980 DEBUG: Frame Size : 8
21:22:14 T:2980 DEBUG: CSoftAE::InternalOpenSink - DirectSound Initialized:
21:22:14 T:2980 DEBUG: Output Device : Speakers - Speakers (2- High Definition Audio Device)
21:22:14 T:2980 DEBUG: Sample Rate : 44100
21:22:14 T:2980 DEBUG: Sample Format : AE_FMT_FLOAT
21:22:14 T:2980 DEBUG: Channel Count : 2
21:22:14 T:2980 DEBUG: Channel Layout: FL,FR
21:22:14 T:2980 DEBUG: Frames : 441
21:22:14 T:2980 DEBUG: Frame Samples : 882
21:22:14 T:2980 DEBUG: Frame Size : 8
21:22:14 T:2980 DEBUG: CSoftAE::InternalOpenSink - Using speaker layout: 2.1
21:22:14 T:2980 DEBUG: CSoftAE::InternalOpenSink - Internal Buffer Size: 3528
21:22:14 T:2980 DEBUG: CAESinkDirectSound::CheckPlayStatus: Resuming Playback
21:22:15 T:4040 DEBUG: CurlFile::Open(0E85AC50) http://ppcdn.500px.org/53314022/85e174f8d0647de40f8442cd1f98a1046fa886a3/2.jpg
21:22:15 T:4012 DEBUG: CCurlFile::GetMimeType - http://ppcdn.500px.org/53313906/541e6ec6cc84eea55930af0b79cfda2805dbb2c3/4.jpg -> image/jpeg
21:22:15 T:4012 DEBUG: Thread Background Loader 4012 terminating
21:22:15 T:2124 DEBUG: ------ Window Deinit (MyPics.xml) ------
21:22:15 T:2124 DEBUG: CGUIWindowManager::PreviousWindow: Activate new
21:22:15 T:2124 DEBUG: ------ Window Init (Home.xml) ------
21:22:15 T:2124 DEBUG: Keyboard: scancode: 01, sym: 001b, unicode: 001b, modifier: 0
21:22:15 T:2124 DEBUG: CApplication::OnKey: escape (f01b) pressed, action is PreviousMenu
21:22:15 T:2124 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate
21:22:15 T:2124 DEBUG: Keyboard: scancode: 01, sym: 001b, unicode: 001b, modifier: 0
21:22:15 T:2124 DEBUG: CApplication::OnKey: escape (f01b) pressed, action is PreviousMenu
21:22:15 T:2124 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate
21:22:15 T:4040 DEBUG: Caching image 'http://ppcdn.500px.org/53314022/85e174f8d0647de40f8442cd1f98a1046fa886a3/2.jpg' to '9/9d69ea49.jpg':
21:22:15 T:4040 DEBUG: cached image 'special://masterprofile/Thumbnails/9/9d69ea49.jpg' size 140x140
21:22:15 T:2124 DEBUG: Keyboard: scancode: 01, sym: 001b, unicode: 001b, modifier: 0
21:22:15 T:2124 DEBUG: CApplication::OnKey: escape (f01b) pressed, action is PreviousMenu
21:22:15 T:2124 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate
21:22:15 T:2124 DEBUG: Keyboard: scancode: 01, sym: 001b, unicode: 001b, modifier: 0
21:22:15 T:2124 DEBUG: CApplication::OnKey: escape (f01b) pressed, action is PreviousMenu
21:22:15 T:2124 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate
21:22:15 T:3968 DEBUG: CurlFile::Open(0E85AC50) http://ppcdn.500px.org/53314018/e65c769628c8ed13b27f4475532de4ed94f4a980/2.jpg
21:22:15 T:2124 DEBUG: Keyboard: scancode: 01, sym: 001b, unicode: 001b, modifier: 0
21:22:15 T:2124 DEBUG: CApplication::OnKey: escape (f01b) pressed, action is PreviousMenu
21:22:15 T:2124 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate
21:22:16 T:3968 DEBUG: Caching image 'http://ppcdn.500px.org/53314018/e65c769628c8ed13b27f4475532de4ed94f4a980/2.jpg' to '7/73246050.jpg':
21:22:16 T:3968 DEBUG: cached image 'special://masterprofile/Thumbnails/7/73246050.jpg' size 140x140
21:22:17 T:3968 DEBUG: CurlFile::Open(0E85AC50) http://ppcdn.500px.org/53314016/a7cb7a1c335e6cf1505ad7ed3cdee9ff3c42f005/2.jpg
21:22:17 T:3968 DEBUG: Caching image 'http://ppcdn.500px.org/53314016/a7cb7a1c335e6cf1505ad7ed3cdee9ff3c42f005/2.jpg' to 'a/a0b07524.jpg':
21:22:17 T:3968 DEBUG: cached image 'special://masterprofile/Thumbnails/a/a0b07524.jpg' size 140x140
21:22:18 T:3968 DEBUG: CurlFile::Open(0E85AC50) http://ppcdn.500px.org/53314012/0bda74fb644694a9b3afac2f352d1f5d01ebc000/2.jpg
21:22:18 T:3968 DEBUG: Caching image 'http://ppcdn.500px.org/53314012/0bda74fb644694a9b3afac2f352d1f5d01ebc000/2.jpg' to '0/0893a93a.jpg':
21:22:18 T:3968 DEBUG: cached image 'special://masterprofile/Thumbnails/0/0893a93a.jpg' size 140x140
21:22:19 T:3316 DEBUG: CurlFile::Open(0E85AC50) http://ppcdn.500px.org/53314008/d4b0577d622c200f80407a209559675be4fc22b0/2.jpg
21:22:19 T:3316 DEBUG: Caching image 'http://ppcdn.500px.org/53314008/d4b0577d622c200f80407a209559675be4fc22b0/2.jpg' to '1/12211e2f.jpg':
21:22:19 T:3316 DEBUG: cached image 'special://masterprofile/Thumbnails/1/12211e2f.jpg' size 140x140
21:22:19 T:3316 DEBUG: CurlFile::Open(0E85AC50) http://ppcdn.500px.org/53313934/2d36c9c2bc0fc3e5974f0c981cd836560f10b2aa/2.jpg
21:22:20 T:3316 DEBUG: Caching image 'http://ppcdn.500px.org/53313934/2d36c9c2bc0fc3e5974f0c981cd836560f10b2aa/2.jpg' to '6/63741a63.jpg':
21:22:20 T:3316 DEBUG: cached image 'special://masterprofile/Thumbnails/6/63741a63.jpg' size 140x140
21:22:20 T:3316 DEBUG: CurlFile::Open(0E85AC50) http://ppcdn.500px.org/53313930/d80bf34be19622d80219548bbf2eb9dc57ee7d02/2.jpg
21:22:21 T:3316 DEBUG: Caching image 'http://ppcdn.500px.org/53313930/d80bf34be19622d80219548bbf2eb9dc57ee7d02/2.jpg' to 'c/cf858666.jpg':
21:22:21 T:3316 DEBUG: cached image 'special://masterprofile/Thumbnails/c/cf858666.jpg' size 140x140
21:22:21 T:3316 DEBUG: CurlFile::Open(0E85AC50) http://ppcdn.500px.org/53313932/fb701c5886e7e2e1824aa6a42f22c6cbea682bda/2.jpg
21:22:21 T:3316 DEBUG: Caching image 'http://ppcdn.500px.org/53313932/fb701c5886e7e2e1824aa6a42f22c6cbea682bda/2.jpg' to 'c/c03eee1d.jpg':
21:22:21 T:3316 DEBUG: cached image 'special://masterprofile/Thumbnails/c/c03eee1d.jpg' size 140x140
21:22:22 T:3968 DEBUG: CurlFile::Open(0E85AC50) http://ppcdn.500px.org/53313914/78f5c12f7fb318743529500d1cd923a9b3330fe0/2.jpg
21:22:22 T:3968 DEBUG: Caching image 'http://ppcdn.500px.org/53313914/78f5c12f7fb318743529500d1cd923a9b3330fe0/2.jpg' to '6/671e40df.jpg':
21:22:22 T:3968 DEBUG: cached image 'special://masterprofile/Thumbnails/6/671e40df.jpg' size 140x140
21:22:23 T:3968 DEBUG: CurlFile::Open(0E85AC50) http://ppcdn.500px.org/53313924/88ec782e0ab33c8aaa505a49b772d66ddcc489f1/2.jpg
21:22:23 T:3968 DEBUG: Caching image 'http://ppcdn.500px.org/53313924/88ec782e0ab33c8aaa505a49b772d66ddcc489f1/2.jpg' to 'e/e72ce36b.jpg':
21:22:23 T:3968 DEBUG: cached image 'special://masterprofile/Thumbnails/e/e72ce36b.jpg' size 140x140
21:22:24 T:3316 DEBUG: CurlFile::Open(0E85AC50) http://ppcdn.500px.org/53313896/e95a2becb1fcc4d1b21809f5a4dfe738e9885394/2.jpg
21:22:24 T:3316 DEBUG: Caching image 'http://ppcdn.500px.org/53313896/e95a2becb1fcc4d1b21809f5a4dfe738e9885394/2.jpg' to 'e/ed60aee5.jpg':
21:22:24 T:3316 DEBUG: cached image 'special://masterprofile/Thumbnails/e/ed60aee5.jpg' size 140x140
21:22:25 T:3316 DEBUG: CurlFile::Open(0E85AC50) http://ppcdn.500px.org/53313918/7867deccf5df51d1d6da6500db318485ec46f70b/2.jpg
21:22:25 T:3316 DEBUG: Caching image 'http://ppcdn.500px.org/53313918/7867deccf5df51d1d6da6500db318485ec46f70b/2.jpg' to '2/2f636d14.jpg':
21:22:25 T:3316 DEBUG: cached image 'special://masterprofile/Thumbnails/2/2f636d14.jpg' size 140x140
21:22:26 T:2980 DEBUG: CAESinkDirectSound::Deinitialize: Cleaning up
21:22:26 T:2980 DEBUG: Suspended the Sink
21:22:26 T:3244 DEBUG: AIRTUNES: AirPlay not running - stopping player
21:22:26 T:3316 DEBUG: CurlFile::Open(0E85AC50) http://ppcdn.500px.org/53313894/4c870039b421d5b02a41df7421901718342ed991/2.jpg
21:22:26 T:3316 DEBUG: Caching image 'http://ppcdn.500px.org/53313894/4c870039b421d5b02a41df7421901718342ed991/2.jpg' to 'b/b9a19adb.jpg':
21:22:26 T:3316 DEBUG: cached image 'special://masterprofile/Thumbnails/b/b9a19adb.jpg' size 140x140
21:22:27 T:2124 DEBUG: ------ Window Init (Pointer.xml) ------
21:22:27 T:3316 DEBUG: CurlFile::Open(0E85AC50) http://ppcdn.500px.org/53313898/f6317f897062bd4bbdfc330c408698f7b5b9e7dc/2.jpg
21:22:27 T:2124 DEBUG: Activating window ID: 12006
21:22:27 T:3316 DEBUG: Caching image 'http://ppcdn.500px.org/53313898/f6317f897062bd4bbdfc330c408698f7b5b9e7dc/2.jpg' to 'd/d15bc95a.jpg':
21:22:27 T:3316 DEBUG: cached image 'special://masterprofile/Thumbnails/d/d15bc95a.jpg' size 140x140
21:22:28 T:2124 DEBUG: ------ Window Deinit (Home.xml) ------
21:22:28 T:2124 DEBUG: ------ Window Init (MusicVisualisation.xml) ------
21:22:28 T:2124 DEBUG: CPlayerCoreFactory::GetPlayers(pipe://4/)
21:22:28 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules
21:22:28 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules
21:22:28 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtv
21:22:28 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: hdhomerun/myth/mms/udp
21:22:28 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout
21:22:28 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp
21:22:28 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp
21:22:28 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams
21:22:28 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd
21:22:28 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage
21:22:28 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf
21:22:28 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv
21:22:28 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio
21:22:28 T:2124 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players
21:22:28 T:2124 DEBUG: CPlayerCoreFactory::GetPlayers: adding audiodefaultplayer (3)
21:22:28 T:2124 DEBUG: CPlayerCoreFactory::GetPlayers: for video=0, audio=1
21:22:28 T:2124 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: PAPlayer (3)
21:22:28 T:2124 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1
21:22:28 T:2124 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: DVDPlayer (1)
21:22:28 T:2124 DEBUG: CPlayerCoreFactory::GetPlayers: added 2 players
21:22:28 T:2124 ERROR: DVDPlayerCodec::Init: Error opening file pipe://4/
21:22:28 T:2124 ERROR: CAudioDecoder: Unable to Init Codec while loading file pipe://4/
21:22:28 T:2124 WARNING: PAPlayer::QueueNextFileEx - Failed to create the decoder
21:22:28 T:2124 DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc
21:22:28 T:2124 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop
21:22:28 T:2124 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate
21:22:28 T:2124 DEBUG: ------ Window Deinit (MusicVisualisation.xml) ------
21:22:28 T:2124 DEBUG: CGUIWindowManager::PreviousWindow: Activate new
21:22:28 T:2124 DEBUG: ------ Window Init (Home.xml) ------
21:22:28 T:272 DEBUG: AIRTUNES: AirPlay not running - stopping player
21:22:28 T:2124 DEBUG: Activating window ID: 12006
21:22:28 T:2124 DEBUG: ------ Window Deinit (Home.xml) ------
21:22:28 T:2124 DEBUG: ------ Window Init (MusicVisualisation.xml) ------
21:22:28 T:1864 DEBUG: CAnnouncementManager - Announcement: OnVolumeChanged from xbmc
21:22:28 T:1864 DEBUG: GOT ANNOUNCEMENT, type: 64, from xbmc, message OnVolumeChanged
21:22:28 T:2124 DEBUG: ------ Window Init (MusicOSD.xml) ------
21:22:28 T:2124 INFO: Loading skin file: MusicOSD.xml, load type: KEEP_IN_MEMORY
21:22:28 T:2124 DEBUG: CPlayerCoreFactory::GetPlayers(pipe://5/)
21:22:28 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules
21:22:28 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules
21:22:28 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtv
21:22:28 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: hdhomerun/myth/mms/udp
21:22:28 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout
21:22:28 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp
21:22:28 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp
21:22:28 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams
21:22:28 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd
21:22:28 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage
21:22:28 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf
21:22:28 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv
21:22:28 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio
21:22:28 T:2124 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players
21:22:28 T:2124 DEBUG: CPlayerCoreFactory::GetPlayers: adding audiodefaultplayer (3)
21:22:28 T:2124 DEBUG: CPlayerCoreFactory::GetPlayers: for video=0, audio=1
21:22:28 T:2124 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: PAPlayer (3)
21:22:28 T:2124 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1
21:22:28 T:2124 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: DVDPlayer (1)
21:22:28 T:2124 DEBUG: CPlayerCoreFactory::GetPlayers: added 2 players
21:22:28 T:2124 ERROR: DVDPlayerCodec::Init: Error creating demuxer
21:22:28 T:2124 ERROR: CAudioDecoder: Unable to Init Codec while loading file pipe://5/
21:22:28 T:2124 WARNING: PAPlayer::QueueNextFileEx - Failed to create the decoder
21:22:28 T:2124 DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc
21:22:28 T:2124 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop
21:22:28 T:3316 DEBUG: CurlFile::Open(0E85AC50) http://ppcdn.500px.org/53313904/f82b60fc84ac80aa04fd228eda6ae8ae67e483a7/2.jpg
21:22:28 T:2124 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate
21:22:28 T:2124 DEBUG: ------ Window Deinit (MusicOSD.xml) ------
21:22:28 T:2124 DEBUG: ------ Window Deinit (MusicVisualisation.xml) ------
21:22:28 T:2124 DEBUG: CGUIWindowManager::PreviousWindow: Activate new
21:22:28 T:2124 DEBUG: ------ Window Init (Home.xml) ------
21:22:29 T:3316 DEBUG: Caching image 'http://ppcdn.500px.org/53313904/f82b60fc84ac80aa04fd228eda6ae8ae67e483a7/2.jpg' to 'd/d3078aaa.jpg':
21:22:29 T:3316 DEBUG: cached image 'special://masterprofile/Thumbnails/d/d3078aaa.jpg' size 140x140
21:22:29 T:3316 DEBUG: CurlFile::Open(0E85AC50) http://ppcdn.500px.org/53313906/541e6ec6cc84eea55930af0b79cfda2805dbb2c3/2.jpg
21:22:29 T:3316 DEBUG: Caching image 'http://ppcdn.500px.org/53313906/541e6ec6cc84eea55930af0b79cfda2805dbb2c3/2.jpg' to '7/750e0649.jpg':
21:22:29 T:3316 DEBUG: cached image 'special://masterprofile/Thumbnails/7/750e0649.jpg' size 140x140
21:22:33 T:2124 DEBUG: ------ Window Deinit (Pointer.xml) ------
21:22:38 T:1864 DEBUG: AIRTUNES: AirPlay not running - stopping player
21:22:41 T:2124 DEBUG: Activating window ID: 12006
21:22:42 T:2124 DEBUG: ------ Window Deinit (Home.xml) ------
21:22:42 T:2124 DEBUG: ------ Window Init (MusicVisualisation.xml) ------
21:22:42 T:2124 DEBUG: CPlayerCoreFactory::GetPlayers(pipe://6/)
21:22:42 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules
21:22:42 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules
21:22:42 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtv
21:22:42 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: hdhomerun/myth/mms/udp
21:22:42 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout
21:22:42 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp
21:22:42 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp
21:22:42 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams
21:22:42 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd
21:22:42 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage
21:22:42 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf
21:22:42 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv
21:22:42 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio
21:22:42 T:2124 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players
21:22:42 T:2124 DEBUG: CPlayerCoreFactory::GetPlayers: adding audiodefaultplayer (3)
21:22:42 T:2124 DEBUG: CPlayerCoreFactory::GetPlayers: for video=0, audio=1
21:22:42 T:2124 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: PAPlayer (3)
21:22:42 T:2124 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1
21:22:42 T:2124 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: DVDPlayer (1)
21:22:42 T:2124 DEBUG: CPlayerCoreFactory::GetPlayers: added 2 players
21:22:42 T:2124 ERROR: DVDPlayerCodec::Init: Error opening file pipe://6/
21:22:42 T:2124 ERROR: CAudioDecoder: Unable to Init Codec while loading file pipe://6/
21:22:42 T:2124 WARNING: PAPlayer::QueueNextFileEx - Failed to create the decoder
21:22:42 T:2124 DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc
21:22:42 T:2124 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop
21:22:42 T:2124 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate
21:22:42 T:2124 DEBUG: ------ Window Deinit (MusicVisualisation.xml) ------
21:22:42 T:2124 DEBUG: CGUIWindowManager::PreviousWindow: Activate new
21:22:42 T:2124 DEBUG: ------ Window Init (Home.xml) ------
21:22:42 T:1856 DEBUG: AIRTUNES: AirPlay not running - stopping player
21:22:42 T:2124 DEBUG: Activating window ID: 12006
21:22:42 T:2124 DEBUG: ------ Window Deinit (Home.xml) ------
21:22:42 T:2124 DEBUG: ------ Window Init (MusicVisualisation.xml) ------
21:22:42 T:1456 DEBUG: CAnnouncementManager - Announcement: OnVolumeChanged from xbmc
21:22:42 T:1456 DEBUG: GOT ANNOUNCEMENT, type: 64, from xbmc, message OnVolumeChanged
21:22:42 T:2124 DEBUG: CPlayerCoreFactory::GetPlayers(pipe://7/)
21:22:42 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules
21:22:42 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules
21:22:42 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtv
21:22:42 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: hdhomerun/myth/mms/udp
21:22:42 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout
21:22:42 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp
21:22:42 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp
21:22:42 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams
21:22:42 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd
21:22:42 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage
21:22:42 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf
21:22:42 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv
21:22:42 T:2124 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio
21:22:42 T:2124 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players
21:22:42 T:2124 DEBUG: CPlayerCoreFactory::GetPlayers: adding audiodefaultplayer (3)
21:22:42 T:2124 DEBUG: CPlayerCoreFactory::GetPlayers: for video=0, audio=1
21:22:42 T:2124 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: PAPlayer (3)
21:22:42 T:2124 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1
21:22:42 T:2124 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: DVDPlayer (1)
21:22:42 T:2124 DEBUG: CPlayerCoreFactory::GetPlayers: added 2 players
21:22:42 T:2124 ERROR: DVDPlayerCodec::Init: Error creating demuxer
21:22:42 T:2124 ERROR: CAudioDecoder: Unable to Init Codec while loading file pipe://7/
21:22:42 T:2124 WARNING: PAPlayer::QueueNextFileEx - Failed to create the decoder
21:22:42 T:2124 DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc
21:22:42 T:2124 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop
21:22:42 T:2124 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate
21:22:42 T:2124 DEBUG: ------ Window Deinit (MusicVisualisation.xml) ------
21:22:42 T:2124 DEBUG: CGUIWindowManager::PreviousWindow: Activate new
21:22:42 T:2124 DEBUG: ------ Window Init (Home.xml) ------
21:22:44 T:2124 INFO: XCURL::DllLibCurlGlobal::CheckIdle - Closing session to http://ppcdn.500px.org (easy=04929D30, multi=04546630)
21:22:44 T:2124 INFO: XCURL::DllLibCurlGlobal::CheckIdle - Closing session to http://ppcdn.500px.org (easy=04904F08, multi=045466B8)
21:22:45 T:2124 DEBUG: SECTION:UnloadDelayed(DLL: special://xbmcbin/system/ImageLib.dll)
21:22:45 T:2124 INFO: XCURL::DllLibCurlGlobal::CheckIdle - Closing session to http://ppcdn.500px.org (easy=0B570008, multi=04546520)
21:22:45 T:1456 DEBUG: AIRTUNES: AirPlay not running - stopping player
21:22:58 T:2124 DEBUG: ------ Window Init (Pointer.xml) ------
21:22:59 T:3968 DEBUG: Thread Jobworker 3968 terminating (autodelete)
21:22:59 T:4036 DEBUG: Thread Jobworker 4036 terminating (autodelete)
21:22:59 T:4040 DEBUG: Thread Jobworker 4040 terminating (autodelete)
21:23:00 T:2124 INFO: XCURL::DllLibCurlGlobal::CheckIdle - Closing session to http://ppcdn.500px.org (easy=04460FE8, multi=04545F48)
21:23:00 T:3316 DEBUG: Thread Jobworker 3316 terminating (autodelete)
21:23:13 T:2124 DEBUG: ------ Window Deinit (Pointer.xml) ------
21:24:00 T:2708 DEBUG: ### [Qlock] - Delaying 240 secs
21:24:33 T:2408 DEBUG: Thread CRemoteControl 2408 terminating
21:26:08 T:2124 DEBUG: CAnnouncementManager - Announcement: OnScreensaverActivated from xbmc
21:26:08 T:2124 DEBUG: GOT ANNOUNCEMENT, type: 4, from xbmc, message OnScreensaverActivated
21:26:08 T:2124 DEBUG: ------ Window Init () ------
21:27:59 T:2708 DEBUG: ### [Qlock] - Delaying 240 secs
21:28:08 T:2124 INFO: DPMS: enabled power-saving mode OFF
21:28:10 T:2124 DEBUG: ------ Window Deinit () ------
21:29:43 T:2692 DEBUG: JSONRPC: Incoming request: {"jsonrpc": "2.0", "id": 1, "method": "VideoLibrary.GetMovies", "params": {"properties": ["title", "originaltitle", "playcount", "year", "genre", "studio", "country", "tagline", "plot", "runtime", "file", "plotoutline", "lastplayed", "trailer", "rating", "resume", "art", "streamdetails", "mpaa", "director"], "limits": {"end": 20}, "sort": {"method": "random" }, "filter": {"field": "playcount", "operator": "lessthan", "value": "1"}}}
21:29:43 T:2692 DEBUG: JSONRPC: Calling videolibrary.getmovies
21:29:43 T:2692 DEBUG: CVideoDatabase::RunQuery took 7 ms for 76 items query: select * from movieview WHERE ((movieview.playCount IS NULL OR movieview.playCount < 1))
21:29:43 T:2692 DEBUG: JSONRPC: Incoming request: {"jsonrpc": "2.0", "id": 1, "method": "VideoLibrary.GetEpisodes", "params": { "properties": ["title", "playcount", "season", "episode", "showtitle", "plot", "file", "rating", "resume", "tvshowid", "art", "streamdetails", "firstaired", "runtime"], "limits": {"end": 20}, "sort": {"method": "random" }, "filter": {"field": "playcount", "operator": "lessthan", "value": "1"}}}
21:29:43 T:2692 DEBUG: JSONRPC: Calling videolibrary.getepisodes
21:29:43 T:2692 DEBUG: CVideoDatabase::RunQuery took 7 ms for 126 items query: select * from episodeview WHERE ((episodeview.playCount IS NULL OR episodeview.playCount < 1))
21:29:44 T:2692 DEBUG: JSONRPC: Incoming request: {"jsonrpc": "2.0", "id": 1, "method": "VideoLibrary.GetMusicVideos", "params": {"properties": ["title", "artist", "playcount", "year", "plot", "genre", "runtime", "fanart", "thumbnail", "file", "streamdetails", "resume"], "limits": {"end": 20}, "sort": {"method": "random"}}}
21:29:44 T:2692 DEBUG: JSONRPC: Calling videolibrary.getmusicvideos
21:29:44 T:2692 DEBUG: CVideoDatabase::RunQuery took 1 ms for 0 items query: select * from musicvideoview
21:29:44 T:2692 DEBUG: JSONRPC: Incoming request: {"jsonrpc": "2.0", "id": 1, "method": "AudioLibrary.GetAlbums", "params": {"properties": ["title", "description", "albumlabel", "theme", "mood", "style", "type", "artist", "genre", "year", "thumbnail", "fanart", "rating", "playcount"], "limits": {"end": 20}, "sort": {"method": "random"}}}
21:29:44 T:2692 DEBUG: JSONRPC: Calling audiolibrary.getalbums
21:29:44 T:2692 DEBUG: CMusicDatabase::GetAlbumsByWhere query: SELECT albumview.* FROM albumview WHERE albumview.strAlbum <> ''
21:29:44 T:2692 DEBUG: CMusicDatabase::GetAlbumsByWhere - query took 14 ms
21:29:44 T:2692 DEBUG: JSONRPC: Incoming request: {"jsonrpc": "2.0", "method": "AudioLibrary.GetArtists", "params": {"properties": ["genre", "description", "mood", "style", "born", "died", "formed", "disbanded", "yearsactive", "instrument", "fanart", "thumbnail"], "sort": {"method": "random"}, "limits": {"end": 20}}, "id": 1}
21:29:44 T:2692 DEBUG: JSONRPC: Calling audiolibrary.getartists
21:29:44 T:2692 DEBUG: CMusicDatabase::GetArtistsByWhere query: SELECT artistview.* FROM artistview WHERE (artistview.idArtist IN (SELECT song_artist.idArtist FROM song_artist) OR artistview.idArtist IN (SELECT album_artist.idArtist FROM album_artist)) and artistview.strArtist != '' and artistview.idArtist <> 1
21:29:44 T:2692 DEBUG: Time to retrieve artists from dataset = 58
21:29:44 T:2692 DEBUG: JSONRPC: Incoming request: {"jsonrpc": "2.0", "id": 1, "method": "AudioLibrary.GetSongs", "params": {"properties": ["title", "playcount", "artist", "album", "year", "file", "thumbnail", "fanart", "rating"], "filter": {"field": "playcount", "operator": "lessthan", "value": "1"}, "limits": {"end": 20}, "sort": {"method": "random"}}}
21:29:44 T:2692 DEBUG: JSONRPC: Calling audiolibrary.getsongs
21:29:44 T:2692 DEBUG: CMusicDatabase::GetSongsByWhere query = SELECT songview.* FROM songview WHERE ((CAST(songview.iTimesPlayed as DECIMAL(5,1)) < 1))
21:29:44 T:2692 DEBUG: CMusicDatabase::GetSongsByWhere() - took 152 ms
21:29:44 T:2692 DEBUG: JSONRPC: Incoming request: {"jsonrpc": "2.0", "method": "Addons.GetAddons", "params": {"properties": ["name", "author", "summary", "version", "fanart", "thumbnail"]}, "id": 1}
21:29:44 T:2692 DEBUG: JSONRPC: Calling addons.getaddons
21:29:44 T:2692 DEBUG: Skin Widgets: Total time needed to request random queries: 0:00:00.855000
21:29:49 T:2124 DEBUG: CWinEventsWin32::WndProcWindow is active
21:29:51 T:2124 DEBUG: CJoystick::Initialize : No Joystick found
21:29:51 T:2124 DEBUG: CWinEventsWin32::WndProcWindow is active
21:29:51 T:2124 INFO: DPMS: disabled power-saving
21:29:51 T:2124 DEBUG: CAnnouncementManager - Announcement: OnScreensaverDeactivated from xbmc
21:29:51 T:2124 DEBUG: GOT ANNOUNCEMENT, type: 4, from xbmc, message OnScreensaverDeactivated
21:29:51 T:2124 DEBUG: ------ Window Init (Pointer.xml) ------
21:29:51 T:2124 DEBUG: Keyboard: scancode: 45, sym: 012c, unicode: 0000, modifier: 0
21:29:51 T:2124 DEBUG: CApplication::OnKey: numlock (f0da) pressed, action is
21:29:51 T:2124 DEBUG: ------ Window Deinit (Pointer.xml) ------
21:29:53 T:2124 DEBUG: Keyboard: scancode: 1d, sym: 0132, unicode: 0000, modifier: 40
21:29:53 T:2124 DEBUG: CApplication::OnKey: ctrl-leftctrl (1f0d0) pressed, action is
21:29:54 T:2124 DEBUG: Keyboard: scancode: 1d, sym: 0132, unicode: 0000, modifier: 40
21:29:54 T:2124 DEBUG: CApplication::OnKey: ctrl-leftctrl (1f0d0) pressed, action is
21:29:54 T:2124 DEBUG: Keyboard: scancode: 1d, sym: 0132, unicode: 0000, modifier: 40
21:29:54 T:2124 DEBUG: CApplication::OnKey: ctrl-leftctrl (1f0d0) pressed, action is
21:29:54 T:2124 DEBUG: Keyboard: scancode: 1d, sym: 0132, unicode: 0000, modifier: 40
21:29:54 T:2124 DEBUG: CApplication::OnKey: ctrl-leftctrl (1f0d0) pressed, action is
21:29:54 T:2124 DEBUG: Keyboard: scancode: 1d, sym: 0132, unicode: 0000, modifier: 40
21:29:54 T:2124 DEBUG: CApplication::OnKey: ctrl-leftctrl (1f0d0) pressed, action is
21:29:54 T:2124 DEBUG: Keyboard: scancode: 1d, sym: 0132, unicode: 0000, modifier: 40
21:29:54 T:2124 DEBUG: CApplication::OnKey: ctrl-leftctrl (1f0d0) pressed, action is
21:29:54 T:2124 DEBUG: Keyboard: scancode: 1d, sym: 0132, unicode: 0000, modifier: 40
21:29:54 T:2124 DEBUG: CApplication::OnKey: ctrl-leftctrl (1f0d0) pressed, action is
21:29:54 T:2124 DEBUG: Keyboard: scancode: 1d, sym: 0132, unicode: 0000, modifier: 40
21:29:54 T:2124 DEBUG: CApplication::OnKey: ctrl-leftctrl (1f0d0) pressed, action is
21:29:54 T:2124 DEBUG: Keyboard: scancode: 38, sym: 0134, unicode: 0000, modifier: 140
21:29:54 T:2124 DEBUG: CApplication::OnKey: ctrl-alt-leftalt (5f0d4) pressed, action is
21:29:54 T:2124 DEBUG: Keyboard: scancode: 1d, sym: 0132, unicode: 0000, modifier: 40
21:29:54 T:2124 DEBUG: CApplication::OnKey: ctrl-leftctrl (1f0d0) pressed, action is
21:29:54 T:2124 DEBUG: Keyboard: scancode: 38, sym: 0134, unicode: 0000, modifier: 140
21:29:54 T:2124 DEBUG: CApplication::OnKey: ctrl-alt-leftalt (5f0d4) pressed, action is
21:29:57 T:2124 DEBUG: Keyboard: scancode: 1d, sym: 0132, unicode: 0000, modifier: 40
21:29:57 T:2124 DEBUG: CApplication::OnKey: ctrl-leftctrl (1f0d0) pressed, action is
21:29:57 T:2124 DEBUG: Keyboard: scancode: 38, sym: 0134, unicode: 0000, modifier: 140
21:29:57 T:2124 DEBUG: CApplication::OnKey: ctrl-alt-leftalt (5f0d4) pressed, action is
21:29:57 T:2124 DEBUG: ------ Window Init (Pointer.xml) ------
21:30:03 T:2124 DEBUG: ------ Window Deinit (Pointer.xml) ------
21:30:04 T:2124 DEBUG: ------ Window Init (Pointer.xml) ------
21:30:04 T:2124 DEBUG: Keyboard: scancode: 5b, sym: 0137, unicode: 0000, modifier: 10
21:30:04 T:2124 DEBUG: CApplication::OnKey: win-leftwindows (10f0d6) pressed, action is
21:30:04 T:2124 DEBUG: Keyboard: scancode: 1d, sym: 0132, unicode: 0000, modifier: 50
21:30:04 T:2124 DEBUG: CApplication::OnKey: ctrl-win-leftctrl (11f0d0) pressed, action is
21:30:04 T:2124 DEBUG: Keyboard: scancode: 6e, sym: 0000, unicode: 0000, modifier: 50
21:30:04 T:2124 DEBUG: CApplication::OnKey: ctrl-win-162 (11f0a2) pressed, action is
21:30:04 T:2124 DEBUG: ------ Window Deinit (Pointer.xml) ------
21:30:05 T:2124 DEBUG: ------ Window Init (Pointer.xml) ------
21:30:07 T:2124 DEBUG: Keyboard: scancode: 5b, sym: 0137, unicode: 0000, modifier: 10
21:30:07 T:2124 DEBUG: CApplication::OnKey: win-leftwindows (10f0d6) pressed, action is
21:30:07 T:2124 DEBUG: ------ Window Deinit (Pointer.xml) ------
21:30:09 T:2124 DEBUG: ------ Window Init (Pointer.xml) ------
21:30:13 T:2124 DEBUG: Keyboard: scancode: 5b, sym: 0137, unicode: 0000, modifier: 10
21:30:13 T:2124 DEBUG: CApplication::OnKey: win-leftwindows (10f0d6) pressed, action is
21:30:13 T:2124 DEBUG: Keyboard: scancode: 38, sym: 0134, unicode: 0000, modifier: 110
21:30:13 T:2124 DEBUG: CApplication::OnKey: alt-win-leftalt (14f0d4) pressed, action is
21:30:13 T:2124 DEBUG: Keyboard: scancode: 6e, sym: 0000, unicode: 0000, modifier: 110
21:30:13 T:2124 DEBUG: CApplication::OnKey: alt-win-164 (14f0a4) pressed, action is
21:30:13 T:2124 DEBUG: ------ Window Deinit (Pointer.xml) ------
21:30:15 T:2124 DEBUG: ------ Window Init (Pointer.xml) ------
21:30:19 T:2124 DEBUG: CApplication::ProcessMouse: trying mouse action wheelup
21:30:20 T:2124 DEBUG: Previous line repeats 3 times.
21:30:20 T:2124 DEBUG: CApplication::ProcessMouse: trying mouse action leftclick
21:30:21 T:2124 DEBUG: CApplication::ProcessMouse: trying mouse action rightclick
21:30:21 T:2124 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate
21:30:23 T:2124 DEBUG: Keyboard: scancode: 1d, sym: 0132, unicode: 0000, modifier: 40
21:30:23 T:2124 DEBUG: CApplication::OnKey: ctrl-leftctrl (1f0d0) pressed, action is
21:30:23 T:2124 DEBUG: ------ Window Deinit (Pointer.xml) ------
21:30:23 T:2124 DEBUG: Keyboard: scancode: 38, sym: 0134, unicode: 0000, modifier: 140
21:30:23 T:2124 DEBUG: CApplication::OnKey: ctrl-alt-leftalt (5f0d4) pressed, action is
21:30:24 T:2124 DEBUG: Keyboard: scancode: 38, sym: 0134, unicode: 0000, modifier: 140
21:30:24 T:2124 DEBUG: CApplication::OnKey: ctrl-alt-leftalt (5f0d4) pressed, action is
21:30:24 T:2124 DEBUG: Keyboard: scancode: 1d, sym: 0132, unicode: 0000, modifier: 40
21:30:24 T:2124 DEBUG: CApplication::OnKey: ctrl-leftctrl (1f0d0) pressed, action is
21:30:24 T:2124 DEBUG: Keyboard: scancode: 38, sym: 0134, unicode: 0000, modifier: 140
21:30:24 T:2124 DEBUG: CApplication::OnKey: ctrl-alt-leftalt (5f0d4) pressed, action is
21:30:24 T:2124 DEBUG: Keyboard: scancode: 1d, sym: 0132, unicode: 0000, modifier: 40
21:30:24 T:2124 DEBUG: CApplication::OnKey: ctrl-leftctrl (1f0d0) pressed, action is
21:30:24 T:2124 DEBUG: Keyboard: scancode: 38, sym: 0134, unicode: 0000, modifier: 140
21:30:24 T:2124 DEBUG: CApplication::OnKey: ctrl-alt-leftalt (5f0d4) pressed, action is
21:30:27 T:2124 DEBUG: Keyboard: scancode: 1d, sym: 0132, unicode: 0000, modifier: 40
21:30:27 T:2124 DEBUG: CApplication::OnKey: ctrl-leftctrl (1f0d0) pressed, action is
21:30:27 T:2124 DEBUG: Keyboard: scancode: 38, sym: 0134, unicode: 0000, modifier: 140
21:30:27 T:2124 DEBUG: CApplication::OnKey: ctrl-alt-leftalt (5f0d4) pressed, action is
21:30:27 T:2124 DEBUG: ------ Window Init (Pointer.xml) ------
21:30:32 T:2124 DEBUG: CApplication::ProcessMouse: trying mouse action wheelup
21:30:34 T:2124 DEBUG: Previous line repeats 1 times.
21:30:34 T:2124 DEBUG: CApplication::ProcessMouse: trying mouse action rightclick
21:30:34 T:2124 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate
21:30:40 T:2124 DEBUG: CWinEventsWin32::WndProcWindow is active
21:30:44 T:2124 DEBUG: ------ Window Deinit (Pointer.xml) ------
21:31:45 T:2764 DEBUG: webserver: request received for /C$
21:31:58 T:2708 DEBUG: ### [Qlock] - Delaying 240 secs
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment