13:11:17 T:140494268680000  NOTICE: special://profile/ is mapped to: special://masterprofile/
13:11:17 T:140494268680000  NOTICE: -----------------------------------------------------------------------
13:11:17 T:140494268680000  NOTICE: Starting XBMC (13.0-BETA1 Git:128426f). Platform: x86 Linux 64-bit
13:11:17 T:140494268680000  NOTICE: Using Release XBMC x64 build, compiled Mar  5 2014 by GCC 4.8.2 for x86 Linux 64-bit 3.13.5
13:11:17 T:140494268680000  NOTICE: Running on Linux 64-bit (OpenELEC (official) - Version: 3.95.1, 3.13.5 x86_64)
13:11:17 T:140494268680000  NOTICE: Host CPU: Intel(R) Celeron(R) CPU 847 @ 1.10GHz, 2 cores available
13:11:17 T:140494268680000  NOTICE: special://xbmc/ is mapped to: /usr/share/xbmc
13:11:17 T:140494268680000  NOTICE: special://xbmcbin/ is mapped to: /usr/lib/xbmc
13:11:17 T:140494268680000  NOTICE: special://masterprofile/ is mapped to: /storage/.xbmc/userdata
13:11:17 T:140494268680000  NOTICE: special://home/ is mapped to: /storage/.xbmc
13:11:17 T:140494268680000  NOTICE: special://temp/ is mapped to: /storage/.xbmc/temp
13:11:17 T:140494268680000  NOTICE: The executable running is: /usr/lib/xbmc/xbmc.bin
13:11:17 T:140494268680000  NOTICE: Local hostname: dmd-elec-01
13:11:17 T:140494268680000  NOTICE: Log File is located: /storage/.xbmc/temp/xbmc.log
13:11:17 T:140494268680000  NOTICE: -----------------------------------------------------------------------
13:11:17 T:140494268680000   ERROR: DBus: Error org.freedesktop.DBus.Error.ServiceUnknown - The name org.freedesktop.UPower was not provided by any .service files
13:11:17 T:140494268680000  NOTICE: load settings...
13:11:17 T:140494268680000  NOTICE: Found 1 Lists of Devices
13:11:17 T:140494268680000  NOTICE: Enumerated ALSA devices:
13:11:17 T:140494268680000  NOTICE:     Device 1
13:11:17 T:140494268680000  NOTICE:         m_deviceName      : hdmi:CARD=PCH,DEV=0
13:11:17 T:140494268680000  NOTICE:         m_displayName     : HDA Intel PCH
13:11:17 T:140494268680000  NOTICE:         m_displayNameExtra: SAM SAMSUNG on HDMI
13:11:17 T:140494268680000  NOTICE:         m_deviceType      : AE_DEVTYPE_HDMI
13:11:17 T:140494268680000  NOTICE:         m_channels        : FL,FR
13:11:17 T:140494268680000  NOTICE:         m_sampleRates     : 32000,44100,48000
13:11:17 T:140494268680000  NOTICE:         m_dataFormats     : AE_FMT_LPCM,AE_FMT_DTSHD,AE_FMT_TRUEHD,AE_FMT_EAC3,AE_FMT_DTS,AE_FMT_AC3,AE_FMT_AAC,AE_FMT_S32NE,AE_FMT_S16NE,AE_FMT_S16LE
13:11:17 T:140494268680000  NOTICE:     Device 2
13:11:17 T:140494268680000  NOTICE:         m_deviceName      : hdmi:CARD=PCH,DEV=1
13:11:17 T:140494268680000  NOTICE:         m_displayName     : HDA Intel PCH
13:11:17 T:140494268680000  NOTICE:         m_displayNameExtra: HDMI
13:11:17 T:140494268680000  NOTICE:         m_deviceType      : AE_DEVTYPE_HDMI
13:11:17 T:140494268680000  NOTICE:         m_channels        : FL,FR,BL,BR,FC,LFE,SL,SR
13:11:17 T:140494268680000  NOTICE:         m_sampleRates     : 32000,44100,48000,88200,96000,176400,192000
13:11:17 T:140494268680000  NOTICE:         m_dataFormats     : AE_FMT_LPCM,AE_FMT_DTSHD,AE_FMT_TRUEHD,AE_FMT_EAC3,AE_FMT_DTS,AE_FMT_AC3,AE_FMT_AAC,AE_FMT_S32NE,AE_FMT_S16NE,AE_FMT_S16LE
13:11:17 T:140494268680000  NOTICE: Loaded settings file from special://xbmc/system/advancedsettings.xml
13:11:17 T:140494268680000  NOTICE: Contents of special://xbmc/system/advancedsettings.xml are...
                                            <?xml version="1.0" encoding="UTF-8" ?>
                                            <advancedsettings>
                                              <showexitbutton>false</showexitbutton>
                                              <cputempcommand>cputemp</cputempcommand>
                                              <gputempcommand>gputemp</gputempcommand>
                                              <video>
                                                <latency>
                                                  <delay>0</delay>
                                                  <refresh>
                                                    <min>23</min>
                                                    <max>24</max>
                                                    <delay>175</delay>
                                                  </refresh>
                                                </latency>
                                                <busydialogdelayms>750</busydialogdelayms>
                                              </video>
                                              <samba>
                                                <clienttimeout>30</clienttimeout>
                                              </samba>
                                              <network>
                                                <readbufferfactor>4.0</readbufferfactor>
                                              </network>
                                            </advancedsettings>
13:11:17 T:140494268680000  NOTICE: Loaded settings file from special://profile/advancedsettings.xml
13:11:17 T:140494268680000  NOTICE: Contents of special://profile/advancedsettings.xml are...
                                            <advancedsettings>
                                              <videodatabase>
                                                <type>mysql</type>
                                                <host>192.168.5.145</host>
                                                <port>3306</port>
                                                <user>xbmc</user>
                                                <pass>xbmc</pass>
                                                <name>xbmcvideo</name>
                                              </videodatabase>
                                              <musicdatabase>
                                                <type>mysql</type>
                                                <host>192.168.5.145</host>
                                                <port>3306</port>
                                                <user>xbmc</user>
                                                <pass>xbmc</pass>
                                                <name>xbmcmusic</name>
                                              </musicdatabase>
                                              <network>
                                                <cachemembuffersize>524288000</cachemembuffersize>
                                                <!--<cachemembuffersize>0</cachemembuffersize>-->
                                              </network>
                                              <skiploopfilter>48</skiploopfilter>
                                              <splash>false</splash>
                                              <pvr>
                                                <minvideocachelevel>0</minvideocachelevel>
                                                <maxvideocachelevel>0</maxvideocachelevel>
                                                <cacheindvdplayer>false</cacheindvdplayer>
                                                <showepginfoonselect>false</showepginfoonselect>
                                              </pvr>
                                            </advancedsettings>
13:11:17 T:140494268680000 WARNING: VIDEO database configuration is experimental.
13:11:17 T:140494268680000  NOTICE: Default DVD Player: dvdplayer
13:11:17 T:140494268680000  NOTICE: Default Video Player: dvdplayer
13:11:17 T:140494268680000  NOTICE: Default Audio Player: paplayer
13:11:17 T:140494268680000  NOTICE: Enabled debug logging due to GUI setting (2)
13:11:17 T:140494268680000  NOTICE: Log level changed to 2
13:11:17 T:140494268680000  NOTICE: CMediaSourceSettings: loading media sources from special://masterprofile/sources.xml
13:11:17 T:140494268680000   DEBUG: CMediaSourceSettings: <programs> tag is missing or sources.xml is malformed
13:11:17 T:140494268680000   DEBUG: CMediaSourceSettings: <files> tag is missing or sources.xml is malformed
13:11:17 T:140494268680000  NOTICE: Loading player core factory settings from special://xbmc/system/playercorefactory.xml.
13:11:17 T:140494268680000   DEBUG: CPlayerCoreConfig::<ctor>: created player DVDPlayer for core 1
13:11:17 T:140494268680000   DEBUG: CPlayerCoreConfig::<ctor>: created player oldmplayercore for core 1
13:11:17 T:140494268680000   DEBUG: CPlayerCoreConfig::<ctor>: created player PAPlayer for core 3
13:11:17 T:140494268680000   DEBUG: CPlayerSelectionRule::Initialize: creating rule: system rules
13:11:17 T:140494268680000   DEBUG: CPlayerSelectionRule::Initialize: creating rule: rtv
13:11:17 T:140494268680000   DEBUG: CPlayerSelectionRule::Initialize: creating rule: hdhomerun/myth/mms/udp
13:11:17 T:140494268680000   DEBUG: CPlayerSelectionRule::Initialize: creating rule: lastfm/shout
13:11:17 T:140494268680000   DEBUG: CPlayerSelectionRule::Initialize: creating rule: rtmp
13:11:17 T:140494268680000   DEBUG: CPlayerSelectionRule::Initialize: creating rule: rtsp
13:11:17 T:140494268680000   DEBUG: CPlayerSelectionRule::Initialize: creating rule: streams
13:11:17 T:140494268680000   DEBUG: CPlayerSelectionRule::Initialize: creating rule: aacp/sdp
13:11:17 T:140494268680000   DEBUG: CPlayerSelectionRule::Initialize: creating rule: mp2
13:11:17 T:140494268680000   DEBUG: CPlayerSelectionRule::Initialize: creating rule: dvd
13:11:17 T:140494268680000   DEBUG: CPlayerSelectionRule::Initialize: creating rule: dvdimage
13:11:17 T:140494268680000   DEBUG: CPlayerSelectionRule::Initialize: creating rule: sdp/asf
13:11:17 T:140494268680000   DEBUG: CPlayerSelectionRule::Initialize: creating rule: nsv
13:11:17 T:140494268680000   DEBUG: CPlayerSelectionRule::Initialize: creating rule: radio
13:11:17 T:140494268680000  NOTICE: Loaded playercorefactory configuration
13:11:17 T:140494268680000  NOTICE: Loading player core factory settings from special://masterprofile/playercorefactory.xml.
13:11:17 T:140494268680000  NOTICE: special://masterprofile/playercorefactory.xml does not exist. Skipping.
13:11:17 T:140494268680000  NOTICE: LoadFromXML - unable to load:/storage/.xbmc/userdata/wakeonlan.xml
13:11:17 T:140494268680000    INFO: creating subdirectories
13:11:17 T:140494268680000    INFO: userdata folder: special://masterprofile/
13:11:17 T:140494268680000    INFO: recording folder:
13:11:17 T:140494268680000    INFO: screenshots folder: /storage/screenshots/
13:11:17 T:140494268680000    INFO: load language info file: special://xbmc/language/English/langinfo.xml
13:11:17 T:140494268680000   DEBUG: trying to set locale to en_GB.UTF-8
13:11:17 T:140494268680000    INFO: global locale set to C
13:11:17 T:140494268680000    INFO: load English language file, from path: special://xbmc/language/
13:11:17 T:140494268680000   DEBUG: POParser: loaded 3169 strings from file /usr/share/xbmc/language/English/strings.po
13:11:17 T:140494264313600  NOTICE: Thread ActiveAE start, auto delete: false
13:11:17 T:140494255920896  NOTICE: Thread AESink start, auto delete: false
13:11:17 T:140494255920896    INFO: CActiveAESink::OpenSink - initialize sink
13:11:17 T:140494255920896   DEBUG: CActiveAESink::OpenSink - trying to open device ALSA:hdmi:CARD=PCH,DEV=0
13:11:17 T:140494255920896   DEBUG: CAESinkALSA::GetChannelLayout - Input Channel Count: 2 Output Channel Count: 2
13:11:17 T:140494255920896   DEBUG: CAESinkALSA::GetChannelLayout - Requested Layout: FL,FR
13:11:17 T:140494255920896   DEBUG: CAESinkALSA::GetChannelLayout - Got Layout: FL,FR
13:11:17 T:140494255920896    INFO: CAESinkALSA::Initialize - Attempting to open device "hdmi:CARD=PCH,DEV=0"
13:11:17 T:140494255920896    INFO: CAESinkALSA::Initialize - Opened device "hdmi:CARD=PCH,DEV=0,AES0=0x04,AES1=0x82,AES2=0x00,AES3=0x00"
13:11:17 T:140494255920896    INFO: CAESinkALSA::InitializeHW - Your hardware does not support AE_FMT_FLOAT, trying other formats
13:11:17 T:140494255920896    INFO: CAESinkALSA::InitializeHW - Using data format AE_FMT_S32NE
13:11:17 T:140494255920896   DEBUG: CAESinkALSA::InitializeHW - Request: periodSize 2048, bufferSize 8192
13:11:18 T:140494255920896   DEBUG: CAESinkALSA::InitializeHW - Got: periodSize 2048, bufferSize 8192
13:11:18 T:140494255920896   DEBUG: CAESinkALSA::InitializeHW - Setting timeout to 186 ms
13:11:18 T:140494255920896   DEBUG: CAESinkALSA::GetChannelLayout - Input Channel Count: 2 Output Channel Count: 2
13:11:18 T:140494255920896   DEBUG: CAESinkALSA::GetChannelLayout - Requested Layout: FL,FR
13:11:18 T:140494255920896   DEBUG: CAESinkALSA::GetChannelLayout - Got Layout: FL,FR
13:11:18 T:140494255920896   DEBUG: CActiveAESink::OpenSink - ALSA Initialized:
13:11:18 T:140494255920896   DEBUG:   Output Device : HDA Intel PCH
13:11:18 T:140494255920896   DEBUG:   Sample Rate   : 44100
13:11:18 T:140494255920896   DEBUG:   Sample Format : AE_FMT_S32NE
13:11:18 T:140494255920896   DEBUG:   Channel Count : 2
13:11:18 T:140494255920896   DEBUG:   Channel Layout: FL,FR
13:11:18 T:140494255920896   DEBUG:   Frames        : 2048
13:11:18 T:140494255920896   DEBUG:   Frame Samples : 4096
13:11:18 T:140494255920896   DEBUG:   Frame Size    : 8
13:11:18 T:140494268680000  NOTICE: Running database version Addons16
13:11:18 T:140494268680000   DEBUG: SECTION:LoadDLL(special://xbmcbin/system/libcpluff-x86_64-linux.so)
13:11:18 T:140494268680000   DEBUG: Loading: /usr/lib/xbmc/system/libcpluff-x86_64-linux.so
13:11:19 T:140494268680000    INFO: ADDON: cpluff: 'Could not read plug-in directory /usr/lib/xbmc/addons: No such file or directory'
13:11:19 T:140494268680000   DEBUG: ADDON: cpluff: 'Plug-in xbmc.json has been installed.'
13:11:19 T:140494268680000   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.fanart.tv has been installed.'
13:11:19 T:140494268680000   DEBUG: ADDON: cpluff: 'Plug-in webinterface.default has been installed.'
13:11:19 T:140494268680000   DEBUG: ADDON: cpluff: 'Plug-in visualization.fishbmc has been installed.'
13:11:19 T:140494268680000   DEBUG: ADDON: cpluff: 'Plug-in repository.xbmc.org has been installed.'
13:11:19 T:140494268680000   DEBUG: ADDON: cpluff: 'Plug-in visualization.vortex has been installed.'
13:11:19 T:140494268680000   DEBUG: ADDON: cpluff: 'Plug-in service.openelec.settings has been installed.'
13:11:19 T:140494268680000   DEBUG: ADDON: cpluff: 'Plug-in screensaver.xbmc.builtin.black has been installed.'
13:11:19 T:140494268680000   DEBUG: ADDON: cpluff: 'Plug-in screensaver.rsxs.euphoria has been installed.'
13:11:19 T:140494268680000   DEBUG: ADDON: cpluff: 'Plug-in pvr.vdr.vnsi has been installed.'
13:11:19 T:140494268680000   DEBUG: ADDON: cpluff: 'Plug-in pvr.argustv has been installed.'
13:11:19 T:140494268680000   DEBUG: ADDON: cpluff: 'Plug-in pvr.mediaportal.tvserver has been installed.'
13:11:19 T:140494268680000   DEBUG: ADDON: cpluff: 'Plug-in visualization.projectm has been installed.'
13:11:19 T:140494268680000   DEBUG: ADDON: cpluff: 'Plug-in weather.wunderground has been installed.'
13:11:19 T:140494268680000   DEBUG: ADDON: cpluff: 'Plug-in script.module.simplejson has been installed.'
13:11:19 T:140494268680000   DEBUG: ADDON: cpluff: 'Plug-in screensaver.xbmc.builtin.dim has been installed.'
13:11:19 T:140494268680000   DEBUG: ADDON: cpluff: 'Plug-in metadata.themoviedb.org has been installed.'
13:11:19 T:140494268680000   DEBUG: ADDON: cpluff: 'Plug-in xbmc.metadata has been installed.'
13:11:19 T:140494268680000   DEBUG: ADDON: cpluff: 'Plug-in pvr.dvblink has been installed.'
13:11:19 T:140494268680000   DEBUG: ADDON: cpluff: 'Plug-in skin.confluence has been installed.'
13:11:19 T:140494268680000   DEBUG: ADDON: cpluff: 'Plug-in visualization.glspectrum has been installed.'
13:11:19 T:140494268680000   DEBUG: ADDON: cpluff: 'Plug-in xbmc.gui has been installed.'
13:11:19 T:140494268680000   DEBUG: ADDON: cpluff: 'Plug-in script.module.pil has been installed.'
13:11:19 T:140494268680000   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.amazon.de has been installed.'
13:11:19 T:140494268680000   DEBUG: ADDON: cpluff: 'Plug-in repository.openelec.tv has been installed.'
13:11:19 T:140494268680000   DEBUG: ADDON: cpluff: 'Plug-in os.openelec.tv has been installed.'
13:11:19 T:140494268680000   DEBUG: ADDON: cpluff: 'Plug-in pvr.vuplus has been installed.'
13:11:19 T:140494268680000   DEBUG: ADDON: cpluff: 'Plug-in metadata.musicvideos.theaudiodb.com has been installed.'
13:11:19 T:140494268680000   DEBUG: ADDON: cpluff: 'Plug-in xbmc.core has been installed.'
13:11:19 T:140494268680000   DEBUG: ADDON: cpluff: 'Plug-in screensaver.rsxs.solarwinds has been installed.'
13:11:19 T:140494268680000   DEBUG: ADDON: cpluff: 'Plug-in pvr.demo has been installed.'
13:11:19 T:140494268680000   DEBUG: ADDON: cpluff: 'Plug-in pvr.iptvsimple has been installed.'
13:11:19 T:140494268680000   DEBUG: ADDON: cpluff: 'Plug-in xbmc.pvr has been installed.'
13:11:19 T:140494268680000   DEBUG: ADDON: cpluff: 'Plug-in pvr.vdr.xvdr has been installed.'
13:11:19 T:140494268680000   DEBUG: ADDON: cpluff: 'Plug-in pvr.njoy has been installed.'
13:11:19 T:140494268680000   DEBUG: ADDON: cpluff: 'Plug-in pvr.nextpvr has been installed.'
13:11:19 T:140494268680000   DEBUG: ADDON: cpluff: 'Plug-in visualization.goom has been installed.'
13:11:19 T:140494268680000   DEBUG: ADDON: cpluff: 'Plug-in metadata.album.universal has been installed.'
13:11:19 T:140494268680000   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.htbackdrops.com has been installed.'
13:11:19 T:140494268680000   DEBUG: ADDON: cpluff: 'Plug-in pvr.dvbviewer has been installed.'
13:11:19 T:140494268680000   DEBUG: ADDON: cpluff: 'Plug-in pvr.mythtv.cmyth has been installed.'
13:11:19 T:140494268680000   DEBUG: ADDON: cpluff: 'Plug-in metadata.tvdb.com has been installed.'
13:11:19 T:140494268680000   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.musicbrainz.org has been installed.'
13:11:19 T:140494268680000   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.allmusic.com has been installed.'
13:11:19 T:140494268680000   DEBUG: ADDON: cpluff: 'Plug-in metadata.local has been installed.'
13:11:19 T:140494268680000   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.last.fm has been installed.'
13:11:19 T:140494268680000   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.themoviedb.org has been installed.'
13:11:19 T:140494268680000   DEBUG: ADDON: cpluff: 'Plug-in xbmc.debug has been installed.'
13:11:19 T:140494268680000   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.theaudiodb.com has been installed.'
13:11:19 T:140494268680000   DEBUG: ADDON: cpluff: 'Plug-in metadata.artists.universal has been installed.'
13:11:19 T:140494268680000   DEBUG: ADDON: cpluff: 'Plug-in xbmc.python has been installed.'
13:11:19 T:140494268680000   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.imdb.com has been installed.'
13:11:19 T:140494268680000   DEBUG: ADDON: cpluff: 'Plug-in pvr.wmc-linux-x86_64 has been installed.'
13:11:19 T:140494268680000   DEBUG: ADDON: cpluff: 'Plug-in xbmc.addon has been installed.'
13:11:19 T:140494268680000   DEBUG: ADDON: cpluff: 'Plug-in visualization.waveform has been installed.'
13:11:19 T:140494268680000   DEBUG: ADDON: cpluff: 'Plug-in screensaver.rsxs.plasma has been installed.'
13:11:19 T:140494268680000   DEBUG: ADDON: cpluff: 'Plug-in pvr.hts has been installed.'
13:11:19 T:140494268680000   DEBUG: ADDON: cpluff: 'Plug-in xbmc.codec has been installed.'
13:11:19 T:140494268680000   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.hdtrailers.net has been installed.'
13:11:19 T:140494268680000   DEBUG: ADDON: cpluff: 'Not all directories were successfully scanned.'
13:11:19 T:140494268680000  NOTICE: ADDONS: Using repository repository.xbmc.org
13:11:19 T:140494268680000  NOTICE: ADDONS: Using repository repository.openelec.tv
13:11:19 T:140494268680000    INFO: LIRC Initialize: using: /var/run/lirc/lircd
13:11:19 T:140494268680000    INFO: LIRC Initialize: successfully started
13:11:19 T:140494268680000   DEBUG: LoadMappings - loaded node "Motorola Nyxboard Hybrid"
13:11:19 T:140494268680000   DEBUG: LoadMappings - loaded node "CEC Adapter"
13:11:19 T:140494268680000   DEBUG: LoadMappings - loaded node "Pulse-Eight CEC Adapter"
13:11:19 T:140494268680000   DEBUG: LoadMappings - loaded node "iMON HID device"
13:11:19 T:140494268680000   DEBUG: CPeripheralBusUSB - initialised udev monitor
13:11:19 T:140494268680000   DEBUG: SECTION:LoadDLL(libcec.so.2)
13:11:19 T:140494268680000   DEBUG: Loading: libcec.so.2
13:11:19 T:140494246344448  NOTICE: Thread PeripBusCEC start, auto delete: false
13:11:19 T:140494237951744  NOTICE: Thread PeripBusUSBUdev start, auto delete: false
13:11:19 T:140494268680000   DEBUG: UDisks: org.freedesktop.DBus.Error.ServiceUnknown - The name org.freedesktop.UDisks was not provided by any .service files
13:11:19 T:140494268680000   DEBUG: DeviceKit.Disks: org.freedesktop.DBus.Error.ServiceUnknown - The name org.freedesktop.DeviceKit.Disks was not provided by any .service files
13:11:19 T:140494268680000   DEBUG: Selected UDev as storage provider
13:11:19 T:140494268680000  NOTICE: Setup SDL
13:11:19 T:140494268680000    INFO: Available videomodes (xrandr):
13:11:19 T:140494268680000    INFO: Output 'HDMI1' has 15 modes
13:11:19 T:140494268680000    INFO: ID:0x49 Name:1360x768 Refresh:60.015160 Width:1360 Height:768
13:11:19 T:140494268680000    INFO: Pixel Ratio: 1.003922
13:11:19 T:140494268680000    INFO: ID:0x9e Name:1920x1080i Refresh:30.000000 Width:1920 Height:1080
13:11:19 T:140494268680000    INFO: Pixel Ratio: 1.000000
13:11:19 T:140494268680000    INFO: ID:0x9f Name:1920x1080i Refresh:25.000000 Width:1920 Height:1080
13:11:19 T:140494268680000    INFO: Pixel Ratio: 1.000000
13:11:19 T:140494268680000    INFO: ID:0xa0 Name:1920x1080i Refresh:29.970100 Width:1920 Height:1080
13:11:19 T:140494268680000    INFO: Pixel Ratio: 1.000000
13:11:19 T:140494268680000    INFO: ID:0xa2 Name:1280x720 Refresh:50.000000 Width:1280 Height:720
13:11:19 T:140494268680000    INFO: Pixel Ratio: 1.000000
13:11:19 T:140494268680000    INFO: ID:0xa1 Name:1280x720 Refresh:60.000000 Width:1280 Height:720
13:11:19 T:140494268680000    INFO: Pixel Ratio: 1.000000
13:11:19 T:140494268680000    INFO: ID:0xa3 Name:1280x720 Refresh:59.940201 Width:1280 Height:720
13:11:19 T:140494268680000    INFO: Pixel Ratio: 1.000000
13:11:19 T:140494268680000    INFO: ID:0xa4 Name:1024x768 Refresh:60.003841 Width:1024 Height:768
13:11:19 T:140494268680000    INFO: Pixel Ratio: 1.333333
13:11:19 T:140494268680000    INFO: ID:0xa5 Name:800x600 Refresh:60.316540 Width:800 Height:600
13:11:19 T:140494268680000    INFO: Pixel Ratio: 1.333333
13:11:19 T:140494268680000    INFO: ID:0xa6 Name:720x576 Refresh:50.000000 Width:720 Height:576
13:11:19 T:140494268680000    INFO: Pixel Ratio: 1.422222
13:11:19 T:140494268680000    INFO: ID:0xa7 Name:720x480 Refresh:60.000000 Width:720 Height:480
13:11:19 T:140494268680000    INFO: Pixel Ratio: 1.185185
13:11:19 T:140494268680000    INFO: ID:0xa8 Name:720x480 Refresh:59.940060 Width:720 Height:480
13:11:19 T:140494268680000    INFO: Pixel Ratio: 1.185185
13:11:19 T:140494268680000    INFO: ID:0xa9 Name:640x480 Refresh:60.000000 Width:640 Height:480
13:11:19 T:140494268680000    INFO: Pixel Ratio: 1.333333
13:11:19 T:140494268680000    INFO: ID:0xaa Name:640x480 Refresh:59.940479 Width:640 Height:480
13:11:19 T:140494268680000    INFO: Pixel Ratio: 1.333333
13:11:19 T:140494268680000    INFO: ID:0xab Name:720x400 Refresh:70.081657 Width:720 Height:400
13:11:19 T:140494268680000    INFO: Pixel Ratio: 0.987654
13:11:19 T:140494268680000  NOTICE: Checking resolution 16
13:11:19 T:140494268680000   DEBUG: SECTION:LoadDLL(special://xbmcbin/system/ImageLib-x86_64-linux.so)
13:11:19 T:140494268680000   DEBUG: Loading: /usr/lib/xbmc/system/ImageLib-x86_64-linux.so
13:11:19 T:140494268680000  NOTICE: Using visual 0x20
13:11:19 T:140494268680000    INFO: GL: Maximum texture width: 8192
13:11:19 T:140494268680000   DEBUG: GLX_EXTENSIONS: GLX_ARB_create_context GLX_ARB_create_context_profile GLX_ARB_fbconfig_float GLX_ARB_framebuffer_sRGB GLX_ARB_get_proc_address GLX_ARB_multisample GLX_EXT_import_context GLX_EXT_visual_info GLX_EXT_visual_rating GLX_EXT_framebuffer_sRGB GLX_EXT_create_context_es2_profile GLX_MESA_copy_sub_buffer GLX_MESA_multithread_makecurrent GLX_MESA_query_renderer GLX_MESA_swap_control GLX_OML_swap_method GLX_OML_sync_control GLX_SGI_make_current_read GLX_SGI_swap_control GLX_SGI_video_sync GLX_SGIS_multisample GLX_SGIX_fbconfig GLX_SGIX_pbuffer GLX_SGIX_visual_select_group GLX_EXT_texture_from_pixmap GLX_INTEL_swap_event
13:11:19 T:140494268680000  NOTICE: GL_VENDOR = Intel Open Source Technology Center
13:11:19 T:140494268680000  NOTICE: GL_RENDERER = Mesa DRI Intel(R) Sandybridge Mobile
13:11:19 T:140494268680000  NOTICE: GL_VERSION = 3.0 Mesa 10.1.0
13:11:19 T:140494268680000  NOTICE: GL_SHADING_LANGUAGE_VERSION = 1.30
13:11:19 T:140494268680000  NOTICE: GL_EXTENSIONS = GL_ARB_multisample GL_EXT_abgr GL_EXT_bgra GL_EXT_blend_color GL_EXT_blend_minmax GL_EXT_blend_subtract GL_EXT_copy_texture GL_EXT_polygon_offset GL_EXT_subtexture GL_EXT_texture_object GL_EXT_vertex_array GL_EXT_compiled_vertex_array GL_EXT_texture GL_EXT_texture3D GL_IBM_rasterpos_clip GL_ARB_point_parameters GL_EXT_draw_range_elements GL_EXT_packed_pixels GL_EXT_point_parameters GL_EXT_rescale_normal GL_EXT_separate_specular_color GL_EXT_texture_edge_clamp GL_SGIS_generate_mipmap GL_SGIS_texture_border_clamp GL_SGIS_texture_edge_clamp GL_SGIS_texture_lod GL_ARB_framebuffer_sRGB GL_ARB_multitexture GL_EXT_framebuffer_sRGB GL_IBM_multimode_draw_arrays GL_IBM_texture_mirrored_repeat GL_3DFX_texture_compression_FXT1 GL_ARB_texture_cube_map GL_ARB_texture_env_add GL_ARB_transpose_matrix GL_EXT_blend_func_separate GL_EXT_fog_coord GL_EXT_multi_draw_arrays GL_EXT_secondary_color GL_EXT_texture_env_add GL_EXT_texture_filter_anisotropic GL_EXT_texture_lod_bias GL_INGR_blend_func_separate GL_NV_blend_square GL_NV_light_max_exponent GL_NV_texgen_reflection GL_NV_texture_env_combine4 GL_S3_s3tc GL_SUN_multi_draw_arrays GL_ARB_texture_border_clamp GL_ARB_texture_compression GL_EXT_framebuffer_object GL_EXT_texture_env_combine GL_EXT_texture_env_dot3 GL_MESA_window_pos GL_NV_packed_depth_stencil GL_NV_texture_rectangle GL_ARB_depth_texture GL_ARB_occlusion_query GL_ARB_shadow GL_ARB_texture_env_combine GL_ARB_texture_env_crossbar GL_ARB_texture_env_dot3 GL_ARB_texture_mirrored_repeat GL_ARB_window_pos GL_ATI_envmap_bumpmap GL_EXT_stencil_two_side GL_EXT_texture_cube_map GL_NV_depth_clamp GL_APPLE_packed_pixels GL_APPLE_vertex_array_object GL_ARB_draw_buffers GL_ARB_fragment_program GL_ARB_fragment_shader GL_ARB_shader_objects GL_ARB_vertex_program GL_ARB_vertex_shader GL_ATI_draw_buffers GL_ATI_texture_env_combine3 GL_ATI_texture_float GL_EXT_shadow_funcs GL_EXT_stencil_wrap GL_MESA_pack_invert GL_MESA_ycbcr_texture GL_NV_primitive_restart GL_ARB_depth_clamp GL_ARB_fragment_program_shadow GL_ARB_half_float_pixel GL_ARB_occlusion_query2 GL_ARB_point_sprite GL_ARB_shading_language_100 GL_ARB_sync GL_ARB_texture_non_power_of_two GL_ARB_vertex_buffer_object GL_ATI_blend_equation_separate GL_EXT_blend_equation_separate GL_OES_read_format GL_ARB_color_buffer_float GL_ARB_pixel_buffer_object GL_ARB_texture_compression_rgtc GL_ARB_texture_float GL_ARB_texture_rectangle GL_EXT_packed_float GL_EXT_pixel_buffer_object GL_EXT_texture_compression_dxt1 GL_EXT_texture_compression_rgtc GL_EXT_texture_rectangle GL_EXT_texture_sRGB GL_EXT_texture_shared_exponent GL_ARB_framebuffer_object GL_EXT_framebuffer_blit GL_EXT_framebuffer_multisample GL_EXT_packed_depth_stencil GL_APPLE_object_purgeable GL_ARB_vertex_array_object GL_ATI_separate_stencil GL_EXT_draw_buffers2 GL_EXT_draw_instanced GL_EXT_gpu_program_parameters GL_EXT_texture_array GL_EXT_texture_integer GL_EXT_texture_sRGB_decode GL_EXT_timer_query GL_OES_EGL_image GL_AMD_performance_monitor GL_ARB_copy_buffer GL_ARB_depth_buffer_float GL_ARB_draw_instanced GL_ARB_half_float_vertex GL_ARB_instanced_arrays GL_ARB_map_buffer_range GL_ARB_texture_rg GL_ARB_texture_swizzle GL_ARB_vertex_array_bgra GL_EXT_separate_shader_objects GL_EXT_texture_swizzle GL_EXT_vertex_array_bgra GL_NV_conditional_render GL_AMD_draw_buffers_blend GL_AMD_seamless_cubemap_per_texture GL_ARB_ES2_compatibility GL_ARB_blend_func_extended GL_ARB_debug_output GL_ARB_draw_buffers_blend GL_ARB_draw_elements_base_vertex GL_ARB_explicit_attrib_location GL_ARB_fragment_coord_conventions GL_ARB_provoking_vertex GL_ARB_sample_shading GL_ARB_sampler_objects GL_ARB_seamless_cube_map GL_ARB_shader_texture_lod GL_ARB_texture_cube_map_array GL_ARB_texture_multisample GL_ARB_texture_query_lod GL_ARB_texture_rgb10_a2ui GL_ARB_uniform_buffer_object GL_ARB_vertex_type_2_10_10_10_rev GL_EXT_provoking_vertex GL_EXT_texture_snorm GL_MESA_texture_signed_rgba GL_ARB_get_program_binary GL_ARB_robustness GL_ARB_shader_bit_encoding GL_ARB_timer_query GL_ANGLE_texture_compression_dxt3 GL_ANGLE_texture_compression_dxt5 GL_ARB_internalformat_query GL_ARB_map_buffer_alignment GL_ARB_shading_language_420pack GL_ARB_shading_language_packing GL_ARB_texture_storage GL_EXT_framebuffer_multisample_blit_scaled GL_EXT_transform_feedback GL_AMD_shader_trinary_minmax GL_ARB_ES3_compatibility GL_ARB_clear_buffer_object GL_ARB_invalidate_subdata GL_ARB_texture_query_levels GL_ARB_texture_storage_multisample GL_ARB_vertex_attrib_binding GL_KHR_debug GL_ARB_texture_mirror_clamp_to_edge GL_ARB_vertex_type_10f_11f_11f_rev GL_EXT_shader_integer_mix
13:11:19 T:140494268680000    INFO: GL: Maximum texture width: 8192
13:11:19 T:140494268680000   DEBUG: CRenderManager::UpdateDisplayLatency - Latency set to 0 msec
13:11:19 T:140494268680000    INFO: load keymapping
13:11:19 T:140494268680000    INFO: Loading special://xbmc/system/keymaps/appcommand.xml
13:11:19 T:140494268680000    INFO: Loading special://xbmc/system/keymaps/gamepad.xml
13:11:19 T:140494268680000    INFO: Loading special://xbmc/system/keymaps/joystick.Alienware.Dual.Compatible.Controller.xml
13:11:19 T:140494268680000    INFO: Loading special://xbmc/system/keymaps/joystick.AppleRemote.xml
13:11:19 T:140494268680000    INFO: Loading special://xbmc/system/keymaps/joystick.Harmony.xml
13:11:19 T:140494268680000    INFO: Loading special://xbmc/system/keymaps/joystick.Interact.AxisPad.xml
13:11:19 T:140494268680000    INFO: Loading special://xbmc/system/keymaps/joystick.Logitech.RumblePad.2.xml
13:11:19 T:140494268680000    INFO: Loading special://xbmc/system/keymaps/joystick.Microsoft.Xbox.360.Controller.xml
13:11:19 T:140494268680000    INFO: Loading special://xbmc/system/keymaps/joystick.Microsoft.Xbox.Controller.S.xml
13:11:19 T:140494268680000    INFO: Loading special://xbmc/system/keymaps/joystick.PS3.Remote.Keyboard.xml
13:11:19 T:140494268680000    INFO: Loading special://xbmc/system/keymaps/joystick.Sony.PLAYSTATION(R)3.Controller.xml
13:11:19 T:140494268680000    INFO: Loading special://xbmc/system/keymaps/joystick.WiiRemote.xml
13:11:19 T:140494268680000    INFO: Loading special://xbmc/system/keymaps/joystick.xml
13:11:19 T:140494268680000  NOTICE: No Joystick name specified, loading default map
13:11:19 T:140494268680000  NOTICE: Previous line repeats 35 times.
13:11:19 T:140494268680000    INFO: Loading special://xbmc/system/keymaps/keyboard.xml
13:11:19 T:140494268680000    INFO: Loading special://xbmc/system/keymaps/mouse.xml
13:11:19 T:140494268680000    INFO: Loading special://xbmc/system/keymaps/remote.xml
13:11:19 T:140494268680000    INFO: Loading special://xbmc/system/keymaps/touchscreen.xml
13:11:19 T:140494268680000    INFO: Loading special://xbmc/system/Lircmap.xml
13:11:19 T:140494268680000    INFO: * Adding remote mapping for device 'mceusb'
13:11:19 T:140494268680000    INFO: * Adding remote mapping for device 'XboxDVDDongle'
13:11:19 T:140494268680000    INFO: * Adding remote mapping for device 'Microsoft_Xbox'
13:11:19 T:140494268680000    INFO: * Adding remote mapping for device 'PinnacleSysPCTVRemote'
13:11:19 T:140494268680000    INFO: * Adding remote mapping for device 'anysee'
13:11:19 T:140494268680000    INFO: * Adding remote mapping for device 'iMON-PAD'
13:11:19 T:140494268680000    INFO: * Adding remote mapping for device 'Antec_Veris_RM200'
13:11:19 T:140494268680000    INFO: * Adding remote mapping for device 'MCE_via_iMON'
13:11:19 T:140494268680000    INFO: * Adding remote mapping for device 'TwinHanRemote'
13:11:19 T:140494268680000    INFO: * Adding remote mapping for device 'linux-input-layer'
13:11:19 T:140494268680000    INFO: * Linking remote mapping for 'linux-input-layer' to 'cx23885_remote'
13:11:19 T:140494268680000    INFO: * Adding remote mapping for device 'mediacenter'
13:11:19 T:140494268680000    INFO: * Adding remote mapping for device 'devinput'
13:11:19 T:140494268680000   DEBUG: CButtonTranslator::Load - no userdata Lircmap.xml found, skipping
13:11:19 T:140494268680000    INFO: GUI format 1280x720, Display 1280x720@ 50.00 - Full Screen
13:11:19 T:140494268680000   DEBUG: guilib: Fill viewport on change for solving rendering passes
13:11:19 T:140494268680000   DEBUG: SECTION:LoadDLL(libcurl.so.4)
13:11:19 T:140494268680000   DEBUG: Loading: libcurl.so.4
13:11:19 T:140494268680000  NOTICE: Running database version Addons16
13:11:19 T:140494268680000   DEBUG: Initialize, updating databases...
13:11:19 T:140494268680000  NOTICE: Running database version ViewModes6
13:11:19 T:140494268680000  NOTICE: Running database version Textures13
13:11:19 T:140494268680000  NOTICE: Running database version xbmcmusic46
13:11:19 T:140494268680000  NOTICE: Running database version xbmcvideo78
13:11:19 T:140494268680000  NOTICE: Running database version TV22
13:11:19 T:140494268680000  NOTICE: Running database version Epg7
13:11:19 T:140494268680000   DEBUG: Initialize, updating databases... DONE
13:11:19 T:140494268680000  NOTICE: start dvd mediatype detection
13:11:19 T:140494268680000  NOTICE: initializing playlistplayer
13:11:19 T:140494268680000  NOTICE: DONE initializing playlistplayer
13:11:19 T:140493994936064  NOTICE: Thread DetectDVDMedia start, auto delete: false
13:11:19 T:140493994936064   DEBUG: Compiled with libcdio Version 0.90
13:11:19 T:140494268680000   DEBUG: DPMS: supported power-saving modes: SUSPEND OFF STANDBY
13:11:19 T:140493994936064   DEBUG: Thread DetectDVDMedia 140493994936064 terminating
13:11:19 T:140494268680000   DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc
13:11:19 T:140494268680000   DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnClear
13:11:19 T:140494268680000    INFO: Unloading old skin ...
13:11:19 T:140494268680000    INFO:   load skin from: /usr/share/xbmc/addons/skin.confluence (version: 2.2.10)
13:11:19 T:140494268680000    INFO:   load fonts for skin...
13:11:19 T:140494268680000    INFO: Loading fonts from /usr/share/xbmc/addons/skin.confluence/720p/Font.xml
13:11:19 T:140494268680000   DEBUG: POParser: loaded 148 strings from file /usr/share/xbmc/addons/skin.confluence/language/English/strings.po
13:11:19 T:140494268680000    INFO: Loading skin includes from /usr/share/xbmc/addons/skin.confluence/720p/includes.xml
13:11:19 T:140494268680000    INFO:   load new skin...
13:11:19 T:140494268680000    INFO: Loading user windows, path /usr/share/xbmc/addons/skin.confluence/720p
13:11:19 T:140494268680000   DEBUG: Load Skin XML: 4.37ms
13:11:19 T:140494268680000    INFO:   initialize new skin...
13:11:19 T:140494268680000   DEBUG: guilib: Fill viewport on change for solving rendering passes
13:11:19 T:140494268680000    INFO: Loading skin file: Pointer.xml, load type: LOAD_ON_GUI_INIT
13:11:19 T:140494268680000   DEBUG: OpenBundle - Opened bundle /usr/share/xbmc/addons/skin.confluence/media/Textures.xbt
13:11:19 T:140494268680000    INFO: Loading skin file: DialogVolumeBar.xml, load type: LOAD_ON_GUI_INIT
13:11:19 T:140494268680000    INFO: Loading skin file: DialogKaiToast.xml, load type: LOAD_ON_GUI_INIT
13:11:19 T:140494268680000    INFO: Loading skin file: DialogMuteBug.xml, load type: LOAD_ON_GUI_INIT
13:11:19 T:140494268680000    INFO: Loading skin file: DialogSeekBar.xml, load type: LOAD_ON_GUI_INIT
13:11:19 T:140494268680000    INFO: Loading skin file: DialogBusy.xml, load type: LOAD_ON_GUI_INIT
13:11:19 T:140494268680000    INFO: Loading skin file: DialogExtendedProgressBar.xml, load type: LOAD_ON_GUI_INIT
13:11:19 T:140494268680000    INFO:   skin loaded...
13:11:19 T:140494268680000   DEBUG: JSONRPC: JSON schema type stereoscopicmode references an unknown type GUI.Stereoscopy.Mode
13:11:19 T:140494268680000   ERROR: JSONRPC: Could not parse type "GUI.Property.Value"
13:11:19 T:140494268680000    INFO: JSONRPC: Adding type "GUI.Property.Value" to list of incomplete definitions (waiting for "GUI.Stereoscopy.Mode")
13:11:19 T:140494268680000    INFO: JSONRPC: Resolving incomplete types/methods referencing GUI.Stereoscopy.Mode
13:11:19 T:140494268680000   DEBUG: JSONRPC: JSON schema type definition references an unknown type Setting.Details.Setting
13:11:19 T:140494268680000   ERROR: JSONRPC: Could not parse type "Setting.Details.SettingList"
13:11:19 T:140494268680000    INFO: JSONRPC: Adding type "Setting.Details.SettingList" to list of incomplete definitions (waiting for "Setting.Details.Setting")
13:11:19 T:140494268680000    INFO: JSONRPC: Resolving incomplete types/methods referencing Setting.Details.Setting
13:11:19 T:140494268680000    INFO: JSONRPC v6.14.0: Successfully initialized
13:11:19 T:140494268680000   DEBUG: ADDON: Starting service addons.
13:11:19 T:140494268680000   DEBUG: Activating window ID: 12999
13:11:19 T:140494268680000   DEBUG: ------ Window Init (Startup.xml) ------
13:11:19 T:140494268680000    INFO: Loading skin file: Startup.xml, load type: LOAD_EVERY_TIME
13:11:19 T:140493992191744  NOTICE: Thread JobWorker start, auto delete: true
13:11:19 T:140493992191744  NOTICE: PVRManager - starting up
13:11:19 T:140493983799040  NOTICE: Thread PVRManager start, auto delete: false
13:11:19 T:140493975406336  NOTICE: Thread PVRClient start, auto delete: false
13:11:19 T:140494268680000    INFO: removing tempfiles
13:11:19 T:140493975406336   DEBUG: RegisterClient - registering add-on 'Tvheadend HTSP Client'
13:11:19 T:140494268680000   DEBUG: ADDON: Starting service addons.
13:11:19 T:140493975406336   DEBUG: PVR - Create - creating PVR add-on instance 'Tvheadend HTSP Client'
13:11:19 T:140493975406336   DEBUG: ADDON: Dll Initializing - Tvheadend HTSP Client
13:11:19 T:140494268680000  NOTICE: initialize done
13:11:19 T:140494268680000  NOTICE: Running the application...
13:11:19 T:140494268680000   DEBUG: ExecuteXBMCAction : Translating action string
13:11:19 T:140493975406336   DEBUG: SECTION:LoadDLL(/usr/lib/xbmc/addons/pvr.hts/XBMC_Tvheadend.pvr)
13:11:19 T:140493975406336   DEBUG: Loading: /usr/lib/xbmc/addons/pvr.hts/XBMC_Tvheadend.pvr
13:11:19 T:140494268680000   DEBUG: Activating window ID: 10000
13:11:19 T:140493975406336   DEBUG: AddOnLog: Tvheadend HTSP Client: ADDON_Create - Creating Tvheadend PVR-Client
13:11:19 T:140493975406336   DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'Tvheadend HTSP Client' requests setting 'host'
13:11:19 T:140493966370560  NOTICE: Thread LanguageInvoker start, auto delete: false
13:11:19 T:140493966370560    INFO: initializing python engine.
13:11:19 T:140493975406336   DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'Tvheadend HTSP Client' requests setting 'user'
13:11:19 T:140493975406336   DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'Tvheadend HTSP Client' requests setting 'pass'
13:11:19 T:140493975406336   DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'Tvheadend HTSP Client' requests setting 'htsp_port'
13:11:19 T:140493975406336   DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'Tvheadend HTSP Client' requests setting 'http_port'
13:11:19 T:140493975406336   DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'Tvheadend HTSP Client' requests setting 'connect_timeout'
13:11:19 T:140493975406336   DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'Tvheadend HTSP Client' requests setting 'response_timeout'
13:11:19 T:140493975406336   DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'Tvheadend HTSP Client' requests setting 'transcode'
13:11:19 T:140493975406336   DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'Tvheadend HTSP Client' requests setting 'audio_codec_name'
13:11:19 T:140493975406336   DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'Tvheadend HTSP Client' requests setting 'video_codec_name'
13:11:19 T:140493975406336   DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'Tvheadend HTSP Client' requests setting 'resolution'
13:11:19 T:140493975406336   DEBUG: AddOnLog: Tvheadend HTSP Client: OpenSocket - connecting to '192.168.5.145', port '9982'
13:11:19 T:140493975406336   DEBUG: AddOnLog: Tvheadend HTSP Client: OpenSocket - connected to '192.168.5.145', port '9982'
13:11:19 T:140493975406336  NOTICE: AddOnLog: Tvheadend HTSP Client: CHTSPConnection - SendGreeting - connection opened to 'HTS Tvheadend 3.9.422~gc84bc2b-dirty', protocol v12 (timeshift enabled)
13:11:19 T:140493975406336   DEBUG: AddOnLog: Tvheadend HTSP Client: CHTSPConnection - Auth - no username set. not authenticating
13:11:19 T:140493966370560   DEBUG: CPythonInvoker(0, /usr/share/xbmc/addons/service.openelec.settings/service.py): start processing
13:11:19 T:140494268680000   DEBUG: ------ Window Init () ------
13:11:19 T:140494268680000   DEBUG: ------ Window Init (Pointer.xml) ------
13:11:19 T:140494268680000   DEBUG: ------ Window Init (DialogMuteBug.xml) ------
13:11:19 T:140493983799040   DEBUG: PVRManager - Load - active clients found. continue to start
13:11:19 T:140493966370560  NOTICE: -->Python Interpreter Initialized<--
13:11:19 T:140493966370560   DEBUG: CPythonInvoker(0, /usr/share/xbmc/addons/service.openelec.settings/service.py): the source file to load is /usr/share/xbmc/addons/service.openelec.settings/service.py
13:11:19 T:140493966370560   DEBUG: CPythonInvoker(0, /usr/share/xbmc/addons/service.openelec.settings/service.py): setting the Python path to /usr/share/xbmc/addons/service.openelec.settings:/storage/.xbmc/addons/script.module.simplejson/lib:/usr/share/xbmc/addons/script.module.pil/lib:/usr/share/xbmc/addons/xbmc.debug/:/usr/lib/python27.zip:/usr/lib/python2.7:/usr/lib/python2.7/plat-linux2:/usr/lib/python2.7/lib-tk:/usr/lib/python2.7/lib-old:/usr/lib/python2.7/lib-dynload:/usr/lib/python2.7/site-packages:/usr/lib/python2.7/site-packages/PIL:/usr/lib/python2.7/site-packages/gtk-2.0
13:11:19 T:140493966370560   DEBUG: CPythonInvoker(0, /usr/share/xbmc/addons/service.openelec.settings/service.py): entering source directory /usr/share/xbmc/addons/service.openelec.settings
13:11:19 T:140493966370560   DEBUG: CPythonInvoker(0, /usr/share/xbmc/addons/service.openelec.settings/service.py): instantiating addon using automatically obtained id of "service.openelec.settings" dependent on version 2.1.0 of the xbmc.python api
13:11:19 T:140494268680000   DEBUG: ------ Window Deinit (Startup.xml) ------
13:11:19 T:140494268680000   DEBUG: ------ Window Init (Home.xml) ------
13:11:19 T:140494268680000    INFO: Loading skin file: Home.xml, load type: KEEP_IN_MEMORY
13:11:20 T:140493992191744   DEBUG: CRecentlyAddedJob::UpdateMusic() - Running RecentlyAdded home screen update
13:11:20 T:140493992191744   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
13:11:20 T:140494268680000   DEBUG: no profile autoexec.py (/storage/.xbmc/userdata/autoexec.py) found, skipping
13:11:20 T:140494268680000   DEBUG: NetworkMessage - Starting network services
13:11:20 T:140493966370560  NOTICE: ## OpenELEC Addon ## 0.3.11
13:11:20 T:140494268680000    INFO: CZeroconfAvahi::clientCallback: avahi server not available. But may become later...
13:11:20 T:140494268680000  NOTICE: starting zeroconf publishing
13:11:20 T:140494268680000  NOTICE: Webserver: Starting...
13:11:20 T:140494268680000  NOTICE: WebServer: Started the webserver
13:11:20 T:140494268680000  NOTICE: ES: Starting event server
13:11:20 T:140494268680000    INFO: JSONRPC Server: Successfully initialized
13:11:20 T:140494268680000    INFO: AIRPLAY Server: Successfully initialized
13:11:20 T:140494268680000   DEBUG: SECTION:LoadDLL(libshairplay.so.0)
13:11:20 T:140494268680000   DEBUG: Loading: libshairplay.so.0
13:11:20 T:140493547632384  NOTICE: Thread TCPServer start, auto delete: false
13:11:20 T:140493539239680  NOTICE: Thread AirPlayServer start, auto delete: false
13:11:20 T:140493623199488  NOTICE: Thread EventServer start, auto delete: false
13:11:20 T:140493623199488  NOTICE: ES: Starting UDP Event server on 0.0.0.0:9777
13:11:20 T:140493623199488  NOTICE: UDP: Listening on port 9777
13:11:20 T:140493648377600  NOTICE: Thread JobWorker start, auto delete: true
13:11:20 T:140493648377600   DEBUG: CZeroconfAvahi::doPublishService identifier: servers.webserver type: _http._tcp name:XBMC (dmd-elec-01) port:80
13:11:20 T:140493648377600   DEBUG: CZeroconfAvahi::doPublishService: client not running, queued for publishing
13:11:20 T:140493648377600   DEBUG: CZeroconfAvahi::doPublishService identifier: servers.jsonrpc-http type: _xbmc-jsonrpc-h._tcp name:XBMC (dmd-elec-01) port:80
13:11:20 T:140493648377600   DEBUG: CZeroconfAvahi::doPublishService: client not running, queued for publishing
13:11:20 T:140493648377600   DEBUG: CZeroconfAvahi::doPublishService identifier: servers.jsonrpc-tpc type: _xbmc-jsonrpc._tcp name:XBMC (dmd-elec-01) port:9090
13:11:20 T:140493648377600   DEBUG: CZeroconfAvahi::doPublishService: client not running, queued for publishing
13:11:20 T:140493648377600   DEBUG: CZeroconfAvahi::doPublishService identifier: servers.airplay type: _airplay._tcp name:XBMC (dmd-elec-01) port:36667
13:11:20 T:140493648377600   DEBUG: CZeroconfAvahi::doPublishService: client not running, queued for publishing
13:11:20 T:140493648377600   DEBUG: CZeroconfAvahi::doPublishService identifier: servers.eventserver type: _xbmc-events._udp name:XBMC (dmd-elec-01) port:9777
13:11:20 T:140493648377600   DEBUG: CZeroconfAvahi::doPublishService: client not running, queued for publishing
13:11:20 T:140494268680000   DEBUG: ------ Window Init (DialogExtendedProgressBar.xml) ------
13:11:20 T:140493983799040   DEBUG: PVR - Load - loading all radio channel groups
13:11:20 T:140493983799040    INFO: PVRChannelGroupInternal - LoadFromDb - no channels in the database
13:11:20 T:140493983799040   DEBUG: PVRChannelGroup - Load - 0 channels loaded from the database for group 'All radio channels'
13:11:20 T:140493983799040   DEBUG: PVR - LoadUserDefinedChannelGroups - 0 user defined radio channel groups fetched from the database
13:11:20 T:140493983799040   DEBUG: PVR - LoadUserDefinedChannelGroups - 0 new user defined radio channel groups fetched from clients
13:11:20 T:140493983799040   DEBUG: PVR - PersistAll - persisting all changes in channel groups
13:11:20 T:140493983799040   DEBUG: PVR - Load - 1 radio channel groups loaded
13:11:20 T:140493983799040   DEBUG: PVR - Load - loading all TV channel groups
13:11:20 T:140493648377600   DEBUG: CZeroconfAvahi::doPublishService identifier: servers.airtunes type: _raop._tcp name:ECA86BF60512@XBMC (dmd-elec-01) port:36666
13:11:20 T:140493648377600   DEBUG: CZeroconfAvahi::doPublishService: client not running, queued for publishing
13:11:20 T:140493648377600    INFO: WEATHER: Downloading weather
13:11:20 T:140493522454272  NOTICE: Thread LanguageInvoker start, auto delete: false
13:11:20 T:140493522454272    INFO: initializing python engine.
13:11:20 T:140493522454272   DEBUG: CPythonInvoker(1, /storage/.xbmc/addons/weather.wunderground/default.py): start processing
13:11:20 T:140493983799040   DEBUG: PVRChannelGroup - Load - 99 channels loaded from the database for group 'All TV channels'
13:11:20 T:140493983799040   DEBUG: PVR - Get - group 'All TV channels' loaded from the database
13:11:20 T:140493983799040   DEBUG: PVR - Get - group 'Sat. TV (HD)' loaded from the database
13:11:20 T:140493983799040   DEBUG: PVR - LoadUserDefinedChannelGroups - 1 user defined TV channel groups fetched from the database
13:11:20 T:140493983799040   DEBUG: PVR - LoadUserDefinedChannelGroups - 0 new user defined TV channel groups fetched from clients
13:11:20 T:140493983799040   DEBUG: PVRChannelGroup - Load - 36 channels loaded from the database for group 'Sat. TV (HD)'
13:11:20 T:140493983799040   DEBUG: PVR - GetChannelGroupMembers - get group members for group 'Sat. TV (HD)' from add-on 'HTS Tvheadend:192.168.5.145:9982'
13:11:20 T:140493983799040   DEBUG: AddOnLog: Tvheadend HTSP Client: GetChannelGroupMembers - group 'Sat. TV (HD)'
13:11:20 T:140493983799040   DEBUG: PVR - PersistAll - persisting all changes in channel groups
13:11:20 T:140493983799040   DEBUG: PVR - Load - 2 TV channel groups loaded
13:11:20 T:140493983799040   DEBUG: CPVRTimers - Update - updating timers
13:11:20 T:140493983799040   DEBUG: CPVRRecordings - Update - updating recordings
13:11:20 T:140493514061568  NOTICE: Thread PVRGUIInfo start, auto delete: false
13:11:20 T:140493983799040   DEBUG: PVRManager - Process - entering main loop
13:11:20 T:140493505668864  NOTICE: Thread EPGUpdater start, auto delete: false
13:11:20 T:140493983799040  NOTICE: Start - EPG thread started
13:11:20 T:140493983799040  NOTICE: PVRManager - ContinueLastChannel - continue playback on channel 'Battlestar Galactica (HD)'
13:11:20 T:140494268680000   DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc
13:11:20 T:140494268680000   DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnClear
13:11:20 T:140494268680000   DEBUG: CPlayerCoreFactory::GetPlayers(pvr://channels/tv/All TV channels/62.pvr)
13:11:20 T:140494268680000   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules
13:11:20 T:140494268680000   DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules
13:11:20 T:140494268680000   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtv
13:11:20 T:140494268680000   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: hdhomerun/myth/mms/udp
13:11:20 T:140494268680000   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout
13:11:20 T:140494268680000   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp
13:11:20 T:140494268680000   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp
13:11:20 T:140494268680000   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams
13:11:20 T:140494268680000   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd
13:11:20 T:140494268680000   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage
13:11:20 T:140494268680000   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf
13:11:20 T:140494268680000   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv
13:11:20 T:140494268680000   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio
13:11:20 T:140494268680000   DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players
13:11:20 T:140494268680000   DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (1)
13:11:20 T:140494268680000   DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0
13:11:20 T:140494268680000   DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1
13:11:20 T:140494268680000   DEBUG: CPlayerCoreFactory::GetPlayers: adding player: DVDPlayer (1)
13:11:20 T:140494268680000   DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players
13:11:20 T:140494268680000  NOTICE: DVDPlayer: Opening: pvr://channels/tv/All TV channels/62.pvr
13:11:20 T:140494268680000 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED
13:11:20 T:140494268680000   DEBUG: CRenderManager::UpdateDisplayLatency - Latency set to 0 msec
13:11:20 T:140494268680000   DEBUG: LinuxRendererGL: Cleaning up GL resources
13:11:20 T:140494268680000   DEBUG: CLinuxRendererGL::PreInit - precision of luminance 16 is 16
13:11:20 T:140493497276160  NOTICE: Thread DVDPlayer start, auto delete: false
13:11:20 T:140493497276160  NOTICE: Creating InputStream
13:11:20 T:140493497276160   DEBUG: PVRManager - OpenLiveStream - opening live stream on channel 'Battlestar Galactica (HD)'
13:11:20 T:140493497276160   DEBUG: opening live stream for channel 'Battlestar Galactica (HD)'
13:11:20 T:140493497276160    INFO: AddOnLog: Tvheadend HTSP Client: SendSubscribe - subscribe to channel '1589712349', subscription 1
13:11:20 T:140493673551616   DEBUG: AddOnLog: Tvheadend HTSP Client: ParseSubscriptionStart - id: 1, type: AC3, codec: 86019
13:11:20 T:140493673551616   DEBUG: AddOnLog: Tvheadend HTSP Client: ParseSubscriptionStart - id: 2, type: MPEG2VIDEO, codec: 2
13:11:20 T:140493673551616    INFO: AddOnLog: Tvheadend HTSP Client: ParseSubscriptionStart - subscription started on adapter IPTV, mux udp://239.255.3.106:1234, network IPTV Network, provider , service Battlestar Galactica (HD)
13:11:20 T:140493497276160   DEBUG: AddOnLog: Tvheadend HTSP Client: SendSubscribe - new subscription for channel 1589712349 (1)
13:11:20 T:140493497276160   DEBUG: PVRFile - Open - playback has started on filename pvr://channels/tv/All TV channels/62.pvr
13:11:20 T:140493497276160   DEBUG: CDVDInputStreamPVRManager::Open - stream opened: pvr://channels/tv/All TV channels/62.pvr
13:11:20 T:140493497276160  NOTICE: Creating Demuxer
13:11:20 T:140493497276160   DEBUG: CDVDDemuxPVRClient::RequestStreams(): added/updated stream 0:2 with codec_id 2
13:11:20 T:140493497276160   DEBUG: CDVDDemuxPVRClient::RequestStreams(): added/updated stream 1:1 with codec_id 86019
13:11:20 T:140493497276160  NOTICE: Opening video stream: 0 source: 256
13:11:20 T:140493497276160  NOTICE: Creating video codec with codec id: 2
13:11:20 T:140493497276160   DEBUG: CDVDFactoryCodec: compiled in hardware support: CrystalHD:yes AMCodec:no MediaCodec:no OpenMax:no libstagefright:no VDPAU:yes VAAPI:yes
13:11:20 T:140493497276160   DEBUG: FactoryCodec - Video:  - Opening
13:11:20 T:140493497276160   DEBUG: DllPostProc: Using libpostproc system library
13:11:20 T:140493497276160   DEBUG: DllAvFilter: Using libavfilter system library
13:11:20 T:140493497276160  NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: MPEG-2 video
13:11:20 T:140493497276160   DEBUG: FactoryCodec - Video: ff-mpeg2video - Opened
13:11:20 T:140493497276160  NOTICE: Creating video thread
13:11:20 T:140493077870336  NOTICE: Thread DVDPlayerVideo start, auto delete: false
13:11:20 T:140493077870336  NOTICE: running thread: video_thread
13:11:20 T:140493497276160  NOTICE: Opening audio stream: 1 source: 256
13:11:20 T:140493497276160  NOTICE: Finding audio codec for: 86019
13:11:20 T:140493077870336   DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE
13:11:20 T:140493497276160   DEBUG: FactoryCodec - Audio: passthrough - Opening
13:11:20 T:140493497276160   DEBUG: FactoryCodec - Audio: passthrough - Failed
13:11:20 T:140493497276160   DEBUG: FactoryCodec - Audio: FFmpeg - Opening
13:11:20 T:140493497276160   DEBUG: FactoryCodec - Audio: FFmpeg - Opened
13:11:20 T:140493497276160  NOTICE: Creating audio thread
13:11:20 T:140493069477632  NOTICE: Thread DVDPlayerAudio start, auto delete: false
13:11:20 T:140493069477632  NOTICE: running thread: CDVDPlayerAudio::Process()
13:11:20 T:140493497276160   DEBUG: OnPlayBackStarted : play state was 1, starting 1
13:11:20 T:140494268680000   DEBUG: PlayFile : OpenFile succeed, play state 2
13:11:20 T:140494268680000   DEBUG: OnPlayBackStarted : play state was 2, starting 0
13:11:20 T:140494268680000   DEBUG: LogindUPowerSyscall - Received unknown signal NameAcquired
13:11:20 T:140493983799040  NOTICE: PVRManager - StartPlayback - started playback on channel 'Battlestar Galactica (HD)'
13:11:20 T:140493497276160   DEBUG: CDVDPlayer::SetCaching - caching state 3
13:11:20 T:140493497276160   DEBUG: ParsePacket - {0} level changed from 0 to -99
13:11:20 T:140493497276160  NOTICE: Opening video stream: 0 source: 256
13:11:20 T:140493497276160  NOTICE: Creating video codec with codec id: 2
13:11:20 T:140493497276160   DEBUG: CDVDFactoryCodec: compiled in hardware support: CrystalHD:yes AMCodec:no MediaCodec:no OpenMax:no libstagefright:no VDPAU:yes VAAPI:yes
13:11:20 T:140493497276160   DEBUG: FactoryCodec - Video:  - Opening
13:11:20 T:140493497276160   DEBUG: DllPostProc: Using libpostproc system library
13:11:20 T:140493497276160   DEBUG: DllAvFilter: Using libavfilter system library
13:11:20 T:140493497276160  NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: MPEG-2 video
13:11:20 T:140493497276160   DEBUG: FactoryCodec - Video: ff-mpeg2video - Opened
13:11:20 T:140493077870336   DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC(0.000000, 1)
13:11:20 T:140493077870336   DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 0
13:11:20 T:140493077870336  NOTICE: CDVDVideoCodecFFmpeg::GetFormat - Creating VDPAU(1920x1080)
13:11:20 T:140493077870336  NOTICE:  (VDPAU) Close
13:11:20 T:140493497276160   DEBUG: ParsePacket - {1} level changed from 0 to -99
13:11:20 T:140493497276160   DEBUG: ParsePacket - {1} iChannels changed from 0 to 6
13:11:20 T:140493497276160   DEBUG: ParsePacket - {1} iSampleRate changed from 0 to 48000
13:11:20 T:140493497276160  NOTICE: Opening audio stream: 1 source: 256
13:11:20 T:140493497276160  NOTICE: Finding audio codec for: 86019
13:11:20 T:140493497276160   DEBUG: FactoryCodec - Audio: passthrough - Opening
13:11:20 T:140493497276160   DEBUG: FactoryCodec - Audio: passthrough - Failed
13:11:20 T:140493497276160   DEBUG: FactoryCodec - Audio: FFmpeg - Opening
13:11:20 T:140493497276160   DEBUG: FactoryCodec - Audio: FFmpeg - Opened
13:11:20 T:140493069477632   DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(24000.000000, 0)
13:11:20 T:140493069477632  NOTICE: Creating audio stream (codec id: 86019, channels: 6, sample rate: 48000, no pass-through)
13:11:20 T:140493069477632   DEBUG: CDVDPlayerAudio:: synctype set to 0: clock feedback
13:11:20 T:140494255920896    INFO: CActiveAESink::OpenSink - initialize sink
13:11:20 T:140493077870336   DEBUG: VAAPI - attempting to open codec 2 with profile 4 at level 4 with 1 reference frames
13:11:20 T:140493077870336   DEBUG: VAAPI - initialize version 0.34
13:11:20 T:140493077870336   DEBUG: VAAPI - vendor: Intel i965 driver - 1.2.2
13:11:20 T:140493077870336   DEBUG: VAAPI - attrib 0 (get/set) min -100 max 100 value 0x0
13:11:20 T:140493077870336   DEBUG: VAAPI - attrib 1 (get/set) min 0 max 100 value 0x32
13:11:20 T:140493077870336   DEBUG: VAAPI - attrib 2 (get/set) min -180 max 180 value 0x0
13:11:20 T:140493077870336   DEBUG: VAAPI - attrib 3 (get/set) min 0 max 100 value 0x32
13:11:20 T:140493077870336   DEBUG: VAAPI - attrib 6 (get/set) min 0 max 3 value 0x0
13:11:20 T:140493077870336   DEBUG: VAAPI - profile 0
13:11:20 T:140493077870336   DEBUG: VAAPI - profile 1
13:11:20 T:140493077870336   DEBUG: VAAPI - profile 13
13:11:20 T:140493077870336   DEBUG: VAAPI - profile 6
13:11:20 T:140493077870336   DEBUG: VAAPI - profile 7
13:11:20 T:140493077870336   DEBUG: VAAPI - profile 8
13:11:20 T:140493077870336   DEBUG: VAAPI - profile 9
13:11:20 T:140493077870336   DEBUG: VAAPI - profile 10
13:11:20 T:140493077870336   DEBUG: VAAPI - profile -1
13:11:20 T:140493077870336   DEBUG: VAAPI - making sure 7 surfaces are allocated for given 1 references
13:11:20 T:140493983799040   DEBUG: CPVRTimers - Update - updating timers
13:11:20 T:140493077870336   DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 0
13:11:20 T:140493077870336  NOTICE:  fps: 25.000000, pwidth: 1920, pheight: 1080, dwidth: 1920, dheight: 1080
13:11:20 T:140493077870336   DEBUG: OutputPicture - change configuration. 1920x1080. framerate: 25.00. format: VAAPI
13:11:20 T:140493077870336  NOTICE: Display resolution ADJUST : 1280x720@ 50.00 - Full Screen (16) (weight: 0.000)
13:11:20 T:140493077870336   DEBUG: CXBMCRenderManager::Configure - 5
13:11:20 T:140494268680000  NOTICE: Using GL_TEXTURE_2D
13:11:20 T:140494268680000  NOTICE: GL: Using VAAPI render method
13:11:20 T:140494268680000  NOTICE: GL: NPOT texture support detected
13:11:20 T:140494268680000  NOTICE: GL: Using GL_ARB_pixel_buffer_object
13:11:20 T:140494268680000   DEBUG: CGUIInfoManager::SetCurrentMovie(pvr://channels/tv/All TV channels/62.pvr)
13:11:20 T:140494268680000   DEBUG: CAnnouncementManager - Announcement: OnPlay from xbmc
13:11:20 T:140494268680000   DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPlay
13:11:20 T:140494268680000   DEBUG: Activating window ID: 12005
13:11:20 T:140494268680000   DEBUG: ------ Window Deinit (Home.xml) ------
13:11:20 T:140494268680000   DEBUG: ExecuteXBMCAction : Translating action string
13:11:20 T:140493497276160   DEBUG: CDVDPlayer::HandleMessages - player started 2
13:11:20 T:140494268680000   DEBUG: ------ Window Init (VideoFullScreen.xml) ------
13:11:20 T:140494268680000    INFO: Loading skin file: VideoFullScreen.xml, load type: KEEP_IN_MEMORY
13:11:20 T:140493522454272  NOTICE: -->Python Interpreter Initialized<--
13:11:20 T:140493522454272   DEBUG: CPythonInvoker(1, /storage/.xbmc/addons/weather.wunderground/default.py): the source file to load is /storage/.xbmc/addons/weather.wunderground/default.py
13:11:20 T:140493522454272   DEBUG: CPythonInvoker(1, /storage/.xbmc/addons/weather.wunderground/default.py): setting the Python path to /storage/.xbmc/addons/weather.wunderground:/storage/.xbmc/addons/script.module.simplejson/lib:/usr/share/xbmc/addons/script.module.pil/lib:/usr/share/xbmc/addons/xbmc.debug/:/usr/lib/python27.zip:/usr/lib/python2.7:/usr/lib/python2.7/plat-linux2:/usr/lib/python2.7/lib-tk:/usr/lib/python2.7/lib-old:/usr/lib/python2.7/lib-dynload:/usr/lib/python2.7/site-packages:/usr/lib/python2.7/site-packages/PIL:/usr/lib/python2.7/site-packages/gtk-2.0
13:11:20 T:140493522454272   DEBUG: CPythonInvoker(1, /storage/.xbmc/addons/weather.wunderground/default.py): entering source directory /storage/.xbmc/addons/weather.wunderground
13:11:20 T:140493522454272   DEBUG: CPythonInvoker(1, /storage/.xbmc/addons/weather.wunderground/default.py): instantiating addon using automatically obtained id of "weather.wunderground" dependent on version 2.12.0 of the xbmc.python api
13:11:20 T:140494268680000   DEBUG: CLinuxRendererGL::UploadVAAPITexture - creating vaapi surface for texture 1
13:11:20 T:140493992191744   DEBUG: GetRecentlyAddedAlbums query: select * from albumview where strAlbum != '' order by idAlbum desc limit 10
13:11:20 T:140494268680000   DEBUG: GL: Vertex Shader compilation log:
13:11:20 T:140494268680000   DEBUG: GL: Vertex Shader compiled successfully
13:11:20 T:140494268680000   DEBUG: GL: Pixel Shader compilation log:
13:11:20 T:140494268680000   DEBUG: GL: Fragment Shader compiled successfully
13:11:20 T:140494255920896   DEBUG: CActiveAESink::OpenSink - trying to open device ALSA:hdmi:CARD=PCH,DEV=0
13:11:20 T:140494255920896   DEBUG: CAESinkALSA::GetChannelLayout - Input Channel Count: 2 Output Channel Count: 2
13:11:20 T:140494255920896   DEBUG: CAESinkALSA::GetChannelLayout - Requested Layout: FL,FR
13:11:20 T:140494255920896   DEBUG: CAESinkALSA::GetChannelLayout - Got Layout: FL,FR
13:11:20 T:140494255920896    INFO: CAESinkALSA::Initialize - Attempting to open device "hdmi:CARD=PCH,DEV=0"
13:11:20 T:140494255920896    INFO: CAESinkALSA::Initialize - Opened device "hdmi:CARD=PCH,DEV=0,AES0=0x04,AES1=0x82,AES2=0x00,AES3=0x02"
13:11:20 T:140494255920896    INFO: CAESinkALSA::InitializeHW - Your hardware does not support AE_FMT_FLOAT, trying other formats
13:11:20 T:140494255920896    INFO: CAESinkALSA::InitializeHW - Using data format AE_FMT_S32NE
13:11:20 T:140494255920896   DEBUG: CAESinkALSA::InitializeHW - Request: periodSize 2048, bufferSize 8192
13:11:20 T:140493069477632 WARNING: CActiveAEStream::AddData - timeout waiting for buffer, paused: 0, cache time: 0.000000, free buffers: 0
13:11:20 T:140494255920896   DEBUG: CAESinkALSA::InitializeHW - Got: periodSize 2048, bufferSize 8192
13:11:20 T:140494255920896   DEBUG: CAESinkALSA::InitializeHW - Setting timeout to 171 ms
13:11:20 T:140494255920896   DEBUG: CAESinkALSA::GetChannelLayout - Input Channel Count: 2 Output Channel Count: 2
13:11:20 T:140494255920896   DEBUG: CAESinkALSA::GetChannelLayout - Requested Layout: FL,FR
13:11:20 T:140494255920896   DEBUG: CAESinkALSA::GetChannelLayout - Got Layout: FL,FR
13:11:20 T:140494255920896   DEBUG: CActiveAESink::OpenSink - ALSA Initialized:
13:11:20 T:140494255920896   DEBUG:   Output Device : HDA Intel PCH
13:11:20 T:140494255920896   DEBUG:   Sample Rate   : 48000
13:11:20 T:140494255920896   DEBUG:   Sample Format : AE_FMT_S32NE
13:11:20 T:140494255920896   DEBUG:   Channel Count : 2
13:11:20 T:140494255920896   DEBUG:   Channel Layout: FL,FR
13:11:20 T:140494255920896   DEBUG:   Frames        : 2048
13:11:20 T:140494255920896   DEBUG:   Frame Samples : 4096
13:11:20 T:140494255920896   DEBUG:   Frame Size    : 8
13:11:20 T:140494264313600   DEBUG: ffmpeg[5EB7A700]: 0.414214 0.000000 0.292893 0.000000 0.292893 0.000000
13:11:20 T:140494264313600   DEBUG: ffmpeg[5EB7A700]: 0.000000 0.414214 0.292893 0.000000 0.000000 0.292893
13:11:20 T:140494264313600   DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted
13:11:20 T:140493522454272   DEBUG: Previous line repeats 1 times.
13:11:20 T:140493522454272   DEBUG: POParser: loaded 40 strings from file /storage/.xbmc/addons/weather.wunderground/resources/language/English/strings.po
13:11:20 T:140493497276160   DEBUG: CDVDPlayer::HandleMessages - player started 1
13:11:20 T:140493497276160   DEBUG: CDVDPlayer::SetCaching - caching state 0
13:11:20 T:140493069477632   DEBUG: CDVDPlayerAudio:: Discontinuity1 - was:520.887000, should be:45036.750480, error:44515.863480
13:11:20 T:140493069477632 WARNING: CDVDMessageQueue(audio)::Get - asked for new data packet, with nothing available
13:11:20 T:140493077870336   DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 0
13:11:20 T:140493077870336   DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 1
13:11:20 T:140494268680000   DEBUG: CLinuxRendererGL::UploadVAAPITexture - creating vaapi surface for texture 2
13:11:20 T:140493077870336   DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 1
13:11:20 T:140494268680000   DEBUG: ------ Window Deinit (DialogExtendedProgressBar.xml) ------
13:11:20 T:140494268680000   DEBUG: CLinuxRendererGL::UploadVAAPITexture - creating vaapi surface for texture 3
13:11:20 T:140493077870336 WARNING: CDVDMessageQueue(video)::Get - asked for new data packet, with nothing available
13:11:20 T:140494268680000   DEBUG: CLinuxRendererGL::UploadVAAPITexture - creating vaapi surface for texture 4
13:11:20 T:140494268680000   DEBUG: CLinuxRendererGL::UploadVAAPITexture - creating vaapi surface for texture 0
13:11:20 T:140493069477632   DEBUG: CDVDPlayerAudio:: Discontinuity1 - was:168789.038480, should be:56000.000000, error:-112789.038480
13:11:21 T:140493069477632   DEBUG: CDVDPlayerAudio:: Discontinuity1 - was:389142.123000, should be:285038.499647, error:-104103.623353
13:11:21 T:140494268680000   DEBUG: ------ Window Init (DialogExtendedProgressBar.xml) ------
13:11:21 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Two and a Half Men' from client '1'
13:11:21 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'How I Met Your Mother' from client '1'
13:11:21 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'The Big Bang Theory' from client '1'
13:11:21 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'The Golden Girls' from client '1'
13:11:21 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Cougar Town' from client '1'
13:11:21 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel '30 Rock' from client '1'
13:11:21 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Mad About You' from client '1'
13:11:21 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'The Nanny' from client '1'
13:11:21 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Family Ties' from client '1'
13:11:21 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Spin City' from client '1'
13:11:21 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Night Court' from client '1'
13:11:21 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Seinfeld' from client '1'
13:11:21 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Friends' from client '1'
13:11:21 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Cheers' from client '1'
13:11:21 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Frasier' from client '1'
13:11:21 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Will & Grace' from client '1'
13:11:21 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Dharma & Greg' from client '1'
13:11:21 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Edel & Starck' from client '1'
13:11:21 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Bewitched' from client '1'
13:11:21 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Sex and the City' from client '1'
13:11:21 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Lipstick Jungle' from client '1'
13:11:21 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Northern Exposure' from client '1'
13:11:21 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'The O.C.' from client '1'
13:11:21 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'The Persuaders (Die Zwei)' from client '1'
13:11:21 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'M*A*S*H' from client '1'
13:11:21 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Gillagan's Island' from client '1'
13:11:21 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Land of the Lost' from client '1'
13:11:21 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Married...with Children' from client '1'
13:11:21 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Doctor Who (Original)' from client '1'
13:11:21 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Babylon 5' from client '1'
13:11:21 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Battlestar Galactica (1978)' from client '1'
13:11:21 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Star Trek: The Animated Series' from client '1'
13:11:21 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Star Trek: The Next Generation' from client '1'
13:11:21 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Star Trek: Deep Space Nine' from client '1'
13:11:21 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Star Trek: Voyager' from client '1'
13:11:21 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Star Trek: Enterprise' from client '1'
13:11:21 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Stargate: SG-1' from client '1'
13:11:21 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Stargate: Atlantis' from client '1'
13:11:21 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Andromeda' from client '1'
13:11:21 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Lexx: The Dark Zone' from client '1'
13:11:21 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Space: 1999' from client '1'
13:11:21 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Scooby Doo, Where Are You!' from client '1'
13:11:21 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Dungeons & Dragons' from client '1'
13:11:21 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Ghost in the Shell' from client '1'
13:11:21 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'The X-Files' from client '1'
13:11:21 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Fringe' from client '1'
13:11:21 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel '24' from client '1'
13:11:21 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Buffy: Vampire Slayer' from client '1'
13:11:21 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Angel' from client '1'
13:11:21 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Deadwood' from client '1'
13:11:21 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'The Sopranos' from client '1'
13:11:21 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Rome' from client '1'
13:11:21 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Terminator: S.C.C.' from client '1'
13:11:21 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Cleopatra 2525' from client '1'
13:11:21 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Dark Angel' from client '1'
13:11:22 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Alias' from client '1'
13:11:22 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'La Femme Nikita' from client '1'
13:11:22 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Supernatural (HD)' from client '1'
13:11:22 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Lost (HD)' from client '1'
13:11:22 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Star Trek (HD)' from client '1'
13:11:22 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Sanctuary (HD)' from client '1'
13:11:22 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Farscape (HD)' from client '1'
13:11:22 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Battlestar Galactica (HD)' from client '1'
13:11:22 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Das Erste (HD)' from client '1'
13:11:22 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'ZDF (HD)' from client '1'
13:11:22 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Bayern 3 (HD)' from client '1'
13:11:22 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'N24 (HD)' from client '1'
13:11:22 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Sat. 1 (HD)' from client '1'
13:11:22 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'RTL (HD)' from client '1'
13:11:22 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'ProSieben (HD)' from client '1'
13:11:22 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Kabel Eins (HD)' from client '1'
13:11:22 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Vox (HD)' from client '1'
13:11:22 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'RTL 2 (HD)' from client '1'
13:11:22 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Super RTL (HD)' from client '1'
13:11:22 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Tele 5 (HD)' from client '1'
13:11:22 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Sixx (HD)' from client '1'
13:11:22 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'DMAX (HD)' from client '1'
13:11:22 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Deluxe Music (HD)' from client '1'
13:11:22 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Sport1 (HD)' from client '1'
13:11:22 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Anixe (HD)' from client '1'
13:11:22 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'ServusTV (HD)' from client '1'
13:11:22 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'tagesschau24 (HD)' from client '1'
13:11:22 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'EinsPlus (HD)' from client '1'
13:11:22 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Einsfestival (HD)' from client '1'
13:11:22 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'ZDF_neo (HD)' from client '1'
13:11:22 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'ZDFinfo(HD)' from client '1'
13:11:22 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'zdf.kultur (HD)' from client '1'
13:11:22 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel '3sat (HD)' from client '1'
13:11:22 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'arte (HD)' from client '1'
13:11:22 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Nickelodean/Comedy Central (HD)' from client '1'
13:11:22 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Phoenix (HD)' from client '1'
13:11:22 T:140494268680000   DEBUG: ------ Window Deinit (Pointer.xml) ------
13:11:22 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Kika (HD)' from client '1'
13:11:22 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'HR Fernsehen (HD)' from client '1'
13:11:22 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'NDR (HD)' from client '1'
13:11:22 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'SWR (HD)' from client '1'
13:11:22 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'WDR (HD)' from client '1'
13:11:22 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'rbb Berlin (HD)' from client '1'
13:11:23 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'MDR (HD)' from client '1'
13:11:23 T:140493505668864   DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Disney Channel (HD)' from client '1'
13:11:23 T:140493983799040   DEBUG: CPVRTimers - Update - updating timers
13:11:23 T:140494268680000   DEBUG: ------ Window Deinit (DialogExtendedProgressBar.xml) ------
13:11:23 T:140493522454272    INFO: CPythonInvoker(1, /storage/.xbmc/addons/weather.wunderground/default.py): script successfully run
13:11:23 T:140493522454272    INFO: Python script stopped
13:11:23 T:140493522454272   DEBUG: Thread LanguageInvoker 140493522454272 terminating
13:11:24 T:140493648377600   DEBUG: GetZipList - Processing zip://special%3a%2f%2fxbmc%2fmedia%2fweather.zip/
13:11:24 T:140493648377600   DEBUG: POParser: loaded 109 weather tokens
13:11:24 T:140493992191744   DEBUG: CRecentlyAddedJob::UpdateVideos() - Running RecentlyAdded home screen update
13:11:24 T:140493992191744   DEBUG: RunQuery took 74 ms for 10 items query: select * from movieview  ORDER BY dateAdded desc, idMovie desc LIMIT 10
13:11:24 T:140493992191744   DEBUG: RunQuery took 372 ms for 10 items query: select * from episodeview  ORDER BY dateAdded desc, idEpisode desc LIMIT 10
13:11:24 T:140493992191744   DEBUG: RunQuery took 3 ms for 0 items query: select * from musicvideoview  ORDER BY dateAdded desc, idMVideo desc LIMIT 10
13:11:24 T:140493992191744   DEBUG: CRecentlyAddedJob::UpdateTotal() - Running RecentlyAdded home screen update
13:11:25 T:140493077870336   DEBUG: CPullupCorrection: detected pattern of length 1: 40000.00, frameduration: 40000.000000
13:11:37 T:140494268680000   DEBUG: LIRC: Update - NEW at 19634:193 0 KEY_CHANNELDOWN devinput (KEY_CHANNELDOWN)
13:11:37 T:140494268680000   DEBUG: OnKey: rightshift (0xd3) pressed, action is SkipPrevious
13:11:37 T:140494268680000   DEBUG: ------ Window Init (DialogSeekBar.xml) ------
13:11:37 T:140493497276160   DEBUG: CGUIInfoManager::SetCurrentMovie(pvr://channels/tv/All TV channels/61.pvr)
13:11:37 T:140494268680000   DEBUG: LIRC: Update - NEW at 19675:193 0 KEY_CHANNELDOWN_UP devinput (KEY_CHANNELDOWN_UP)
13:11:38 T:140493069477632   DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE
13:11:38 T:140493497276160   DEBUG: CDVDPlayer::SetCaching - caching state 3
13:11:38 T:140493077870336   DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE
13:11:38 T:140493497276160   DEBUG: PVRManager - PerformChannelSwitch - switching to channel 'Farscape (HD)'
13:11:38 T:140493497276160    INFO: AddOnLog: Tvheadend HTSP Client: SwitchChannel - changing to channel 'Farscape (HD)'
13:11:38 T:140493497276160    INFO: AddOnLog: Tvheadend HTSP Client: SendUnsubscribe - unsubscribe from subscription 1
13:11:38 T:140493497276160    INFO: AddOnLog: Tvheadend HTSP Client: SendSubscribe - subscribe to channel '1826846605', subscription 2
13:11:38 T:140493497276160   DEBUG: AddOnLog: Tvheadend HTSP Client: SendSubscribe - new subscription for channel 1589712349 (2)
13:11:38 T:140493497276160  NOTICE: PVRManager - PerformChannelSwitch - switched to channel 'Farscape (HD)'
13:11:38 T:140493497276160  NOTICE: Creating Demuxer
13:11:38 T:140493983799040   DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc
13:11:38 T:140493983799040   DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop
13:11:38 T:140493983799040   DEBUG: CAnnouncementManager - Announcement: OnPlay from xbmc
13:11:38 T:140493983799040   DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPlay
13:11:38 T:140493673551616   DEBUG: AddOnLog: Tvheadend HTSP Client: ParseSubscriptionStart - id: 1, type: MPEG2VIDEO, codec: 2
13:11:38 T:140493673551616   DEBUG: AddOnLog: Tvheadend HTSP Client: ParseSubscriptionStart - id: 2, type: AC3, codec: 86019
13:11:38 T:140493673551616    INFO: AddOnLog: Tvheadend HTSP Client: ParseSubscriptionStart - subscription started on adapter IPTV, mux udp://239.255.3.105:1234, network IPTV Network, provider , service Farscape (HD)
13:11:38 T:140493497276160   DEBUG: CDVDDemuxPVRClient::RequestStreams(): added/updated stream 0:1 with codec_id 2
13:11:38 T:140493497276160   DEBUG: CDVDDemuxPVRClient::RequestStreams(): added/updated stream 1:2 with codec_id 86019
13:11:38 T:140493497276160  NOTICE: Opening video stream: 0 source: 256
13:11:38 T:140493497276160  NOTICE: Creating video codec with codec id: 2
13:11:38 T:140493497276160   DEBUG: CDVDFactoryCodec: compiled in hardware support: CrystalHD:yes AMCodec:no MediaCodec:no OpenMax:no libstagefright:no VDPAU:yes VAAPI:yes
13:11:38 T:140493497276160   DEBUG: FactoryCodec - Video:  - Opening
13:11:38 T:140493497276160   DEBUG: DllPostProc: Using libpostproc system library
13:11:38 T:140493497276160   DEBUG: DllAvFilter: Using libavfilter system library
13:11:38 T:140493497276160  NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: MPEG-2 video
13:11:38 T:140493497276160   DEBUG: FactoryCodec - Video: ff-mpeg2video - Opened
13:11:38 T:140493497276160  NOTICE: Opening audio stream: 1 source: 256
13:11:38 T:140493497276160  NOTICE: Finding audio codec for: 86019
13:11:38 T:140493497276160   DEBUG: FactoryCodec - Audio: passthrough - Opening
13:11:38 T:140493497276160   DEBUG: FactoryCodec - Audio: passthrough - Failed
13:11:38 T:140493497276160   DEBUG: FactoryCodec - Audio: FFmpeg - Opening
13:11:38 T:140493077870336   DEBUG: VAAPI - destroying surface 0x4000004
13:11:38 T:140493077870336   DEBUG: VAAPI - destroying surface 0x4000005
13:11:38 T:140493077870336   DEBUG: VAAPI - destroying surface 0x4000006
13:11:38 T:140493077870336   DEBUG: VAAPI - destroying surface 0x4000000
13:11:38 T:140493077870336   DEBUG: VAAPI - destroying surface 0x4000003
13:11:38 T:140493497276160   DEBUG: FactoryCodec - Audio: FFmpeg - Opened
13:11:38 T:140493497276160   DEBUG: CDVDDemuxPVRClient::RequestStreams(): added/updated stream 0:1 with codec_id 2
13:11:38 T:140493497276160   DEBUG: CDVDDemuxPVRClient::RequestStreams(): added/updated stream 1:2 with codec_id 86019
13:11:38 T:140493497276160  NOTICE: Opening video stream: 0 source: 256
13:11:38 T:140493497276160  NOTICE: Opening audio stream: 1 source: 256
13:11:38 T:140493497276160   DEBUG: ParsePacket - {0} level changed from 0 to -99
13:11:38 T:140493077870336   DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC(0.000000, 1)
13:11:38 T:140493077870336    INFO: CDVDPlayerVideo - Stillframe left, switching to normal playback
13:11:38 T:140493077870336   DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 1
13:11:38 T:140493077870336  NOTICE: CDVDVideoCodecFFmpeg::GetFormat - Creating VDPAU(1920x1080)
13:11:38 T:140493077870336  NOTICE:  (VDPAU) Close
13:11:38 T:140493497276160   DEBUG: ParsePacket - {1} level changed from 0 to -99
13:11:38 T:140493497276160   DEBUG: ParsePacket - {1} iChannels changed from 0 to 6
13:11:38 T:140493497276160   DEBUG: ParsePacket - {1} iSampleRate changed from 0 to 48000
13:11:38 T:140493497276160  NOTICE: Opening audio stream: 1 source: 256
13:11:38 T:140493497276160  NOTICE: Finding audio codec for: 86019
13:11:38 T:140493497276160   DEBUG: FactoryCodec - Audio: passthrough - Opening
13:11:38 T:140493497276160   DEBUG: FactoryCodec - Audio: passthrough - Failed
13:11:38 T:140493497276160   DEBUG: FactoryCodec - Audio: FFmpeg - Opening
13:11:38 T:140493497276160   DEBUG: FactoryCodec - Audio: FFmpeg - Opened
13:11:38 T:140493069477632   DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(32000.000000, 0)
13:11:38 T:140493069477632   DEBUG: CDVDPlayerAudio:: synctype set to 0: clock feedback
13:11:38 T:140493077870336   DEBUG: VAAPI - attempting to open codec 2 with profile 4 at level 4 with 1 reference frames
13:11:38 T:140493077870336   DEBUG: VAAPI - attrib 0 (get/set) min -100 max 100 value 0x0
13:11:38 T:140493077870336   DEBUG: VAAPI - attrib 1 (get/set) min 0 max 100 value 0x32
13:11:38 T:140493077870336   DEBUG: VAAPI - attrib 2 (get/set) min -180 max 180 value 0x0
13:11:38 T:140493077870336   DEBUG: VAAPI - attrib 3 (get/set) min 0 max 100 value 0x32
13:11:38 T:140493077870336   DEBUG: VAAPI - attrib 6 (get/set) min 0 max 3 value 0x0
13:11:38 T:140493077870336   DEBUG: VAAPI - profile 0
13:11:38 T:140493077870336   DEBUG: VAAPI - profile 1
13:11:38 T:140493077870336   DEBUG: VAAPI - profile 13
13:11:38 T:140493077870336   DEBUG: VAAPI - profile 6
13:11:38 T:140493077870336   DEBUG: VAAPI - profile 7
13:11:38 T:140493077870336   DEBUG: VAAPI - profile 8
13:11:38 T:140493077870336   DEBUG: VAAPI - profile 9
13:11:38 T:140493077870336   DEBUG: VAAPI - profile 10
13:11:38 T:140493077870336   DEBUG: VAAPI - profile -1
13:11:38 T:140493077870336   DEBUG: VAAPI - making sure 7 surfaces are allocated for given 1 references
13:11:38 T:140494268680000   DEBUG: VAAPI - destroying surface 0x4000001
13:11:38 T:140493497276160   DEBUG: CDVDPlayer::HandleMessages - player started 1
13:11:38 T:140493077870336   DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 0
13:11:38 T:140493497276160   DEBUG: CDVDPlayer::HandleMessages - player started 2
13:11:38 T:140493497276160   DEBUG: CDVDPlayer::SetCaching - caching state 0
13:11:38 T:140493069477632   DEBUG: CDVDPlayerAudio:: Discontinuity1 - was:-39302.742000, should be:-96079.904450, error:-56777.162450
13:11:38 T:140494268680000   DEBUG: VAAPI - destroying surface 0x4000002
13:11:38 T:140493077870336   DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 0
13:11:38 T:140493077870336   DEBUG: Previous line repeats 1 times.
13:11:38 T:140493077870336   DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 1
13:11:40 T:140494268680000   DEBUG: ------ Window Deinit (DialogSeekBar.xml) ------
13:11:40 T:140493069477632   DEBUG: CDVDPlayerAudio:: Discontinuity2 - was:1921004.571550, should be:1843875.471920, error:-77129.099630
13:11:41 T:140494268680000   DEBUG: LIRC: Update - NEW at 23357:192 0 KEY_CHANNELUP devinput (KEY_CHANNELUP)
13:11:41 T:140494268680000   DEBUG: OnKey: leftshift (0xd2) pressed, action is SkipNext
13:11:41 T:140494268680000   DEBUG: ------ Window Init (DialogSeekBar.xml) ------
13:11:41 T:140493497276160   DEBUG: CGUIInfoManager::SetCurrentMovie(pvr://channels/tv/All TV channels/62.pvr)
13:11:41 T:140494268680000   DEBUG: LIRC: Update - NEW at 23397:192 0 KEY_CHANNELUP_UP devinput (KEY_CHANNELUP_UP)
13:11:42 T:140493077870336   DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE
13:11:42 T:140493069477632   DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE
13:11:42 T:140493497276160   DEBUG: CDVDPlayer::SetCaching - caching state 3
13:11:42 T:140493497276160   DEBUG: PVRManager - PerformChannelSwitch - switching to channel 'Battlestar Galactica (HD)'
13:11:42 T:140493497276160    INFO: AddOnLog: Tvheadend HTSP Client: SwitchChannel - changing to channel 'Battlestar Galactica (HD)'
13:11:42 T:140493497276160    INFO: AddOnLog: Tvheadend HTSP Client: SendUnsubscribe - unsubscribe from subscription 2
13:11:42 T:140493497276160    INFO: AddOnLog: Tvheadend HTSP Client: SendSubscribe - subscribe to channel '1589712349', subscription 3
13:11:42 T:140493673551616   DEBUG: AddOnLog: Tvheadend HTSP Client: ParseSubscriptionStart - id: 1, type: AC3, codec: 86019
13:11:42 T:140493673551616   DEBUG: AddOnLog: Tvheadend HTSP Client: ParseSubscriptionStart - id: 2, type: MPEG2VIDEO, codec: 2
13:11:42 T:140493497276160   DEBUG: AddOnLog: Tvheadend HTSP Client: SendSubscribe - new subscription for channel 1826846605 (3)
13:11:42 T:140493673551616    INFO: AddOnLog: Tvheadend HTSP Client: ParseSubscriptionStart - subscription started on adapter IPTV, mux udp://239.255.3.106:1234, network IPTV Network, provider , service Battlestar Galactica (HD)
13:11:42 T:140493497276160  NOTICE: PVRManager - PerformChannelSwitch - switched to channel 'Battlestar Galactica (HD)'
13:11:42 T:140493497276160  NOTICE: Creating Demuxer
13:11:42 T:140493983799040   DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc
13:11:42 T:140493497276160  NOTICE: Closing video stream
13:11:42 T:140493497276160   DEBUG: CDVDPlayer::SetCaching - caching state 0
13:11:42 T:140493983799040   DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop
13:11:42 T:140493077870336   ERROR: Got MSGQ_ABORT or MSGO_IS_ERROR return true
13:11:42 T:140493077870336  NOTICE: thread end: video_thread
13:11:42 T:140493077870336   DEBUG: Thread DVDPlayerVideo 140493077870336 terminating
13:11:42 T:140493983799040   DEBUG: CAnnouncementManager - Announcement: OnPlay from xbmc
13:11:42 T:140493983799040   DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPlay
13:11:42 T:140493497276160  NOTICE: waiting for video thread to exit
13:11:42 T:140493497276160  NOTICE: deleting video codec
13:11:42 T:140493497276160   DEBUG: VAAPI - destroying surface 0x4000008
13:11:42 T:140493497276160   DEBUG: VAAPI - destroying surface 0x4000007
13:11:42 T:140493497276160  NOTICE: Closing audio stream
13:11:42 T:140493497276160  NOTICE: CDVDMessageQueue(audio)::WaitUntilEmpty
13:11:42 T:140493069477632   DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE
13:11:42 T:140493497276160  NOTICE: Waiting for audio thread to exit
13:11:42 T:140493069477632   DEBUG: CDVDPlayerAudio::Process - Abort received, exiting thread
13:11:42 T:140493069477632  NOTICE: thread end: CDVDPlayerAudio::OnExit()
13:11:42 T:140493069477632   DEBUG: Thread DVDPlayerAudio 140493069477632 terminating
13:11:42 T:140493497276160  NOTICE: Closing audio device
13:11:42 T:140493497276160  NOTICE: Deleting audio codec
13:11:42 T:140494264313600   DEBUG: CActiveAE::DiscardStream - audio stream deleted
13:11:42 T:140493497276160   ERROR: Get - failed to get stream
13:11:42 T:140494264313600   DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted
13:11:42 T:140494255920896   DEBUG: Previous line repeats 1 times.
13:11:42 T:140494255920896    INFO: CActiveAESink::OpenSink - initialize sink
13:11:42 T:140493497276160   ERROR: Get - failed to get stream
13:11:42 T:140494268680000   DEBUG: VAAPI - destroying surface 0x4000003
13:11:42 T:140494268680000   DEBUG: VAAPI - destroying surface 0x4000000
13:11:42 T:140494268680000   DEBUG: VAAPI - destroying surface 0x4000006
13:11:42 T:140494268680000   DEBUG: VAAPI - destroying surface 0x4000005
13:11:42 T:140494255920896   DEBUG: CActiveAESink::OpenSink - trying to open device ALSA:hdmi:CARD=PCH,DEV=0
13:11:42 T:140494255920896   DEBUG: CAESinkALSA::GetChannelLayout - Input Channel Count: 2 Output Channel Count: 2
13:11:42 T:140494255920896   DEBUG: CAESinkALSA::GetChannelLayout - Requested Layout: FL,FR
13:11:42 T:140494255920896   DEBUG: CAESinkALSA::GetChannelLayout - Got Layout: FL,FR
13:11:42 T:140494255920896    INFO: CAESinkALSA::Initialize - Attempting to open device "hdmi:CARD=PCH,DEV=0"
13:11:42 T:140494255920896    INFO: CAESinkALSA::Initialize - Opened device "hdmi:CARD=PCH,DEV=0,AES0=0x04,AES1=0x82,AES2=0x00,AES3=0x00"
13:11:42 T:140494255920896    INFO: CAESinkALSA::InitializeHW - Your hardware does not support AE_FMT_FLOAT, trying other formats
13:11:42 T:140494255920896    INFO: CAESinkALSA::InitializeHW - Using data format AE_FMT_S32NE
13:11:42 T:140494255920896   DEBUG: CAESinkALSA::InitializeHW - Request: periodSize 2048, bufferSize 8192
13:11:42 T:140494255920896   DEBUG: CAESinkALSA::InitializeHW - Got: periodSize 2048, bufferSize 8192
13:11:42 T:140494255920896   DEBUG: CAESinkALSA::InitializeHW - Setting timeout to 186 ms
13:11:42 T:140494255920896   DEBUG: CAESinkALSA::GetChannelLayout - Input Channel Count: 2 Output Channel Count: 2
13:11:42 T:140494255920896   DEBUG: CAESinkALSA::GetChannelLayout - Requested Layout: FL,FR
13:11:42 T:140494255920896   DEBUG: CAESinkALSA::GetChannelLayout - Got Layout: FL,FR
13:11:42 T:140494255920896   DEBUG: CActiveAESink::OpenSink - ALSA Initialized:
13:11:42 T:140494255920896   DEBUG:   Output Device : HDA Intel PCH
13:11:42 T:140494255920896   DEBUG:   Sample Rate   : 44100
13:11:42 T:140494255920896   DEBUG:   Sample Format : AE_FMT_S32NE
13:11:42 T:140494255920896   DEBUG:   Channel Count : 2
13:11:42 T:140494255920896   DEBUG:   Channel Layout: FL,FR
13:11:42 T:140494255920896   DEBUG:   Frames        : 2048
13:11:42 T:140494255920896   DEBUG:   Frame Samples : 4096
13:11:42 T:140494255920896   DEBUG:   Frame Size    : 8
13:11:42 T:140494264313600   DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted
13:11:43 T:140494268680000   DEBUG: Previous line repeats 1 times.
13:11:43 T:140494268680000   DEBUG: ------ Window Deinit (DialogSeekBar.xml) ------
13:11:47 T:140494264313600   DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted
13:11:48 T:140494268680000   DEBUG: LIRC: Update - NEW at 30349:80 0 KEY_STOP devinput (KEY_STOP)
13:11:48 T:140494268680000   DEBUG: OnKey: 224 (0xe0) pressed, action is Stop
13:11:48 T:140494268680000  NOTICE: CDVDPlayer::CloseFile()
13:11:48 T:140494268680000  NOTICE: DVDPlayer: waiting for threads to exit
13:11:48 T:140493497276160  NOTICE: CDVDPlayer::OnExit()
13:11:48 T:140493497276160  NOTICE: CDVDPlayer::OnExit() deleting demuxer
13:11:48 T:140493497276160  NOTICE: CDVDPlayer::OnExit() deleting input stream
13:11:48 T:140493497276160    INFO: AddOnLog: Tvheadend HTSP Client: SendUnsubscribe - unsubscribe from subscription 3
13:11:48 T:140493497276160   DEBUG: CDVDInputStreamPVRManager::Close - stream closed
13:11:48 T:140493497276160   DEBUG: OnPlayBackStopped : play state was 2, starting 0
13:11:48 T:140493497276160   DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc
13:11:48 T:140493497276160   DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop
13:11:48 T:140493497276160   DEBUG: Thread DVDPlayer 140493497276160 terminating
13:11:48 T:140494268680000  NOTICE: DVDPlayer: finished waiting
13:11:48 T:140494268680000   DEBUG: LinuxRendererGL: Cleaning up GL resources
13:11:48 T:140494268680000   DEBUG: VAAPI - destroying surface 0x4000004
13:11:48 T:140494268680000   DEBUG: VAAPI - destroying glx surface 0x682d480
13:11:48 T:140494268680000   DEBUG: VAAPI - destroying glx surface 0x4cc59f0
13:11:48 T:140494268680000   DEBUG: VAAPI - destroying glx surface 0x55a9840
13:11:48 T:140494268680000   DEBUG: VAAPI - destroying glx surface 0x5bd56c0
13:11:48 T:140494268680000   DEBUG: VAAPI - destroying glx surface 0x6201530
13:11:48 T:140494268680000   DEBUG: VAAPI - destroying display 0x7fc7180008c0
13:11:48 T:140494268680000   DEBUG: CGUIWindowManager::PreviousWindow: Deactivate
13:11:48 T:140494268680000   DEBUG: ------ Window Deinit (VideoFullScreen.xml) ------
13:11:48 T:140494268680000   DEBUG: CGUIWindowManager::PreviousWindow: Activate new
13:11:48 T:140494268680000   DEBUG: ------ Window Init (Home.xml) ------
13:11:48 T:140493648377600   DEBUG: CRecentlyAddedJob::UpdateMusic() - Running RecentlyAdded home screen update
13:11:48 T:140493648377600   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
13:11:48 T:140494268680000  NOTICE: CDVDPlayer::CloseFile()
13:11:48 T:140494268680000  NOTICE: DVDPlayer: waiting for threads to exit
13:11:48 T:140494268680000  NOTICE: DVDPlayer: finished waiting
13:11:48 T:140494268680000   DEBUG: LinuxRendererGL: Cleaning up GL resources
13:11:48 T:140494268680000  NOTICE: CDVDPlayer::CloseFile()
13:11:48 T:140494268680000  NOTICE: DVDPlayer: waiting for threads to exit
13:11:48 T:140494268680000  NOTICE: DVDPlayer: finished waiting
13:11:48 T:140494268680000   DEBUG: LinuxRendererGL: Cleaning up GL resources
13:11:48 T:140494268680000   DEBUG: LIRC: Update - NEW at 30490:80 0 KEY_STOP_UP devinput (KEY_STOP_UP)
13:11:48 T:140494268680000   DEBUG: SECTION:UnloadDelayed(DLL: libcrystalhd.so.3)
13:11:48 T:140494268680000   DEBUG: Unloading: libcrystalhd.so.3
13:11:48 T:140493648377600   DEBUG: GetRecentlyAddedAlbums query: select * from albumview where strAlbum != '' order by idAlbum desc limit 10
13:11:48 T:140493497276160  NOTICE: Thread JobWorker start, auto delete: true
13:11:53 T:140493648377600   DEBUG: CRecentlyAddedJob::UpdateVideos() - Running RecentlyAdded home screen update
13:11:53 T:140493648377600   DEBUG: RunQuery took 75 ms for 10 items query: select * from movieview  ORDER BY dateAdded desc, idMovie desc LIMIT 10
13:11:53 T:140493648377600   DEBUG: RunQuery took 326 ms for 10 items query: select * from episodeview  ORDER BY dateAdded desc, idEpisode desc LIMIT 10
13:11:53 T:140493648377600   DEBUG: RunQuery took 3 ms for 0 items query: select * from musicvideoview  ORDER BY dateAdded desc, idMVideo desc LIMIT 10
13:11:53 T:140493648377600   DEBUG: CRecentlyAddedJob::UpdateTotal() - Running RecentlyAdded home screen update
13:12:18 T:140494268680000   DEBUG: SECTION:UnloadDelayed(DLL: special://xbmcbin/system/ImageLib-x86_64-linux.so)
13:12:18 T:140494268680000   DEBUG: Unloading: ImageLib-x86_64-linux.so
13:12:23 T:140493992191744   DEBUG: Thread JobWorker 140493992191744 terminating (autodelete)
13:12:23 T:140493497276160   DEBUG: Thread JobWorker 140493497276160 terminating (autodelete)
13:12:24 T:140493648377600   DEBUG: Thread JobWorker 140493648377600 terminating (autodelete)
13:12:42 T:140494268680000   DEBUG: LIRC: Update - NEW at 85234:69 0 KEY_LEFT devinput (KEY_LEFT)
13:12:42 T:140494268680000   DEBUG: OnKey: 169 (0xa9) pressed, action is Left
13:12:43 T:140494268680000   DEBUG: LIRC: Update - NEW at 85454:69 0 KEY_LEFT_UP devinput (KEY_LEFT_UP)
13:12:43 T:140494268680000   DEBUG: LIRC: Update - NEW at 85593:69 0 KEY_LEFT devinput (KEY_LEFT)
13:12:43 T:140494268680000   DEBUG: OnKey: 169 (0xa9) pressed, action is Left
13:12:43 T:140494268680000   DEBUG: LIRC: Update - NEW at 85812:69 0 KEY_LEFT_UP devinput (KEY_LEFT_UP)