22:20:00 T:3016337152 NOTICE: ----------------------------------------------------------------------- 22:20:00 T:3016337152 NOTICE: Starting XBMC (12.0-RC3 Git:c47e925), Platform: Linux (OpenELEC - Version: 2.99.1, 3.6.11 i686). Built on Jan 3 2013 22:20:00 T:3016337152 NOTICE: special://xbmc/ is mapped to: /usr/share/xbmc 22:20:00 T:3016337152 NOTICE: special://xbmcbin/ is mapped to: /usr/lib/xbmc 22:20:00 T:3016337152 NOTICE: special://masterprofile/ is mapped to: /storage/.xbmc/userdata 22:20:00 T:3016337152 NOTICE: special://home/ is mapped to: /storage/.xbmc 22:20:00 T:3016337152 NOTICE: special://temp/ is mapped to: /storage/.xbmc/temp 22:20:00 T:3016337152 NOTICE: The executable running is: /usr/lib/xbmc/xbmc.bin 22:20:00 T:3016337152 NOTICE: Local hostname: openelec 22:20:00 T:3016337152 NOTICE: Log File is located: /storage/.xbmc/temp/xbmc.log 22:20:00 T:3016337152 NOTICE: ----------------------------------------------------------------------- 22:20:01 T:3016337152 ERROR: CAESinkOSS::EnumerateDevicesEx - Failed to open mixer: /dev/mixer 22:20:01 T:3016337152 NOTICE: Enumerated ALSA devices: 22:20:01 T:3016337152 NOTICE: Device 1 22:20:01 T:3016337152 NOTICE: m_deviceName : @ 22:20:01 T:3016337152 NOTICE: m_displayName : Default (HDA NVidia ALC889A Analog) 22:20:01 T:3016337152 NOTICE: m_displayNameExtra: 22:20:01 T:3016337152 NOTICE: m_deviceType : AE_DEVTYPE_PCM 22:20:01 T:3016337152 NOTICE: m_channels : FL,FR,BL,BR,FC,LFE 22:20:01 T:3016337152 NOTICE: m_sampleRates : 44100,48000,96000,192000 22:20:01 T:3016337152 NOTICE: m_dataFormats : AE_FMT_S32NE,AE_FMT_S16NE,AE_FMT_S16LE 22:20:01 T:3016337152 NOTICE: Device 2 22:20:01 T:3016337152 NOTICE: m_deviceName : @:CARD=NVidia,DEV=0 22:20:01 T:3016337152 NOTICE: m_displayName : HDA NVidia 22:20:01 T:3016337152 NOTICE: m_displayNameExtra: ALC889A Analog 22:20:01 T:3016337152 NOTICE: m_deviceType : AE_DEVTYPE_PCM 22:20:01 T:3016337152 NOTICE: m_channels : FL,FR,BL,BR,FC,LFE 22:20:01 T:3016337152 NOTICE: m_sampleRates : 44100,48000,96000,192000 22:20:01 T:3016337152 NOTICE: m_dataFormats : AE_FMT_S32NE,AE_FMT_S16NE,AE_FMT_S16LE 22:20:01 T:3016337152 NOTICE: Device 3 22:20:01 T:3016337152 NOTICE: m_deviceName : iec958:CARD=NVidia,DEV=0 22:20:01 T:3016337152 NOTICE: m_displayName : HDA NVidia 22:20:01 T:3016337152 NOTICE: m_displayNameExtra: ALC889A Digital S/PDIF 22:20:01 T:3016337152 NOTICE: m_deviceType : AE_DEVTYPE_IEC958 22:20:01 T:3016337152 NOTICE: m_channels : FL,FR 22:20:01 T:3016337152 NOTICE: m_sampleRates : 44100,48000,88200,96000,192000 22:20:01 T:3016337152 NOTICE: m_dataFormats : AE_FMT_S32NE,AE_FMT_S16NE,AE_FMT_S16LE 22:20:01 T:3016337152 NOTICE: Device 4 22:20:01 T:3016337152 NOTICE: m_deviceName : hdmi:CARD=NVidia,DEV=0 22:20:01 T:3016337152 NOTICE: m_displayName : HDA NVidia 22:20:01 T:3016337152 NOTICE: m_displayNameExtra: HDMI 22:20:01 T:3016337152 NOTICE: m_deviceType : AE_DEVTYPE_HDMI 22:20:01 T:3016337152 NOTICE: m_channels : FL,FR,BL,BR,FC,LFE,SL,SR 22:20:01 T:3016337152 NOTICE: m_sampleRates : 32000,44100,48000,88200,96000,176400,192000 22:20:01 T:3016337152 NOTICE: m_dataFormats : AE_FMT_S32NE,AE_FMT_S16NE,AE_FMT_S16LE 22:20:01 T:3016337152 NOTICE: load settings... 22:20:01 T:3016337152 NOTICE: special://profile/ is mapped to: special://masterprofile/ 22:20:01 T:3016337152 NOTICE: loading special://masterprofile/guisettings.xml 22:20:01 T:3016337152 NOTICE: Getting hardware information now... 22:20:01 T:3016337152 NOTICE: Loading player core factory settings from special://xbmc/system/playercorefactory.xml. 22:20:01 T:3016337152 NOTICE: Loaded playercorefactory configuration 22:20:01 T:3016337152 NOTICE: Loading player core factory settings from special://masterprofile/playercorefactory.xml. 22:20:01 T:3016337152 NOTICE: special://masterprofile/playercorefactory.xml does not exist. Skipping. 22:20:01 T:3016337152 NOTICE: Loaded settings file from special://xbmc/system/advancedsettings.xml 22:20:01 T:3016337152 NOTICE: Contents of special://xbmc/system/advancedsettings.xml are... false false cputemp gputemp 30 22:20:01 T:3016337152 NOTICE: Getting hardware information now... 22:20:01 T:3016337152 NOTICE: No settings file to load (special://masterprofile/advancedsettings.xml) 22:20:01 T:3016337152 NOTICE: Default DVD Player: dvdplayer 22:20:01 T:3016337152 NOTICE: Default Video Player: dvdplayer 22:20:01 T:3016337152 NOTICE: Default Audio Player: paplayer 22:20:01 T:3016337152 NOTICE: Enabled debug logging due to GUI setting (2) 22:20:01 T:3016337152 NOTICE: Log level changed to 2 22:20:01 T:3016337152 NOTICE: Loading media sources from special://masterprofile/sources.xml 22:20:01 T:3016337152 DEBUG: tag is missing or sources.xml is malformed 22:20:01 T:3016337152 DEBUG: tag is missing or sources.xml is malformed 22:20:01 T:3016337152 INFO: creating subdirectories 22:20:01 T:3016337152 INFO: userdata folder: special://masterprofile/ 22:20:01 T:3016337152 INFO: recording folder: 22:20:01 T:3016337152 INFO: screenshots folder: /storage/screenshots/ 22:20:01 T:3016337152 INFO: thumbnails folder: special://masterprofile/Thumbnails 22:20:01 T:3016337152 INFO: load language info file: special://xbmc/language/English/langinfo.xml 22:20:01 T:3016337152 DEBUG: trying to set locale to en_US.UTF-8 22:20:01 T:3016337152 INFO: global locale set to C 22:20:01 T:3016337152 INFO: load English language file, from path: special://xbmc/language/ 22:20:01 T:3016337152 DEBUG: POParser: loaded 2690 strings from file /usr/share/xbmc/language/English/strings.po 22:20:01 T:3016337152 INFO: CSoftAE::LoadSettings - Stereo upmix is enabled 22:20:01 T:3016337152 INFO: CSoftAE::InternalOpenSink - sink incompatible, re-starting 22:20:01 T:3016337152 INFO: CAESinkALSA::Initialize - Attempting to open device "hdmi:CARD=NVidia,DEV=0" 22:20:01 T:3016337152 INFO: CAESinkALSA::Initialize - Opened device "hdmi:CARD=NVidia,DEV=0,AES0=0x04,AES1=0x82,AES2=0x00,AES3=0x00" 22:20:01 T:3016337152 INFO: CAESinkALSA::InitializeHW - Your hardware does not support AE_FMT_FLOAT, trying other formats 22:20:01 T:3016337152 INFO: CAESinkALSA::InitializeHW - Using data format AE_FMT_S32NE 22:20:01 T:3016337152 DEBUG: CAESinkALSA::InitializeHW - Request: periodSize 512, periods 16, bufferSize 8192 22:20:01 T:3016337152 DEBUG: CAESinkALSA::InitializeHW - Got: periodSize 512, periods 16, bufferSize 8192 22:20:01 T:3016337152 DEBUG: CAESinkALSA::InitializeHW - Setting timeout to 186 ms 22:20:01 T:3016337152 DEBUG: CSoftAE::InternalOpenSink - ALSA Initialized: 22:20:01 T:3016337152 DEBUG: Output Device : HDA NVidia 22:20:01 T:3016337152 DEBUG: Sample Rate : 44100 22:20:01 T:3016337152 DEBUG: Sample Format : AE_FMT_S32NE 22:20:01 T:3016337152 DEBUG: Channel Count : 2 22:20:01 T:3016337152 DEBUG: Channel Layout: FL,FR 22:20:01 T:3016337152 DEBUG: Frames : 512 22:20:01 T:3016337152 DEBUG: Frame Samples : 1024 22:20:01 T:3016337152 DEBUG: Frame Size : 8 22:20:01 T:3016337152 DEBUG: CSoftAE::InternalOpenSink - Using speaker layout: 2.0 22:20:01 T:3016337152 DEBUG: CSoftAE::InternalOpenSink - Internal Buffer Size: 4096 22:20:01 T:3016051520 NOTICE: Thread CSoftAE start, auto delete: false 22:20:01 T:3016051520 INFO: CSoftAE::Run - Thread Started 22:20:01 T:3016337152 NOTICE: Running database version Addons15 22:20:01 T:3016337152 DEBUG: SECTION:LoadDLL(special://xbmcbin/system/libcpluff-i486-linux.so) 22:20:01 T:3016337152 DEBUG: Loading: /usr/lib/xbmc/system/libcpluff-i486-linux.so 22:20:01 T:3016337152 INFO: ADDON: cpluff: 'Could not read plug-in directory /usr/lib/xbmc/addons: No such file or directory' 22:20:01 T:3016337152 DEBUG: ADDON: cpluff: 'Plug-in xbmc.json has been installed.' 22:20:01 T:3016337152 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.fanart.tv has been installed.' 22:20:01 T:3016337152 DEBUG: ADDON: cpluff: 'Plug-in webinterface.default has been installed.' 22:20:01 T:3016337152 DEBUG: ADDON: cpluff: 'Plug-in repository.xbmc.org has been installed.' 22:20:01 T:3016337152 DEBUG: ADDON: cpluff: 'Plug-in screensaver.xbmc.builtin.black has been installed.' 22:20:01 T:3016337152 DEBUG: ADDON: cpluff: 'Plug-in screensaver.rsxs.euphoria has been installed.' 22:20:01 T:3016337152 DEBUG: ADDON: cpluff: 'Plug-in pvr.vdr.vnsi has been installed.' 22:20:01 T:3016337152 DEBUG: ADDON: cpluff: 'Plug-in pvr.argustv has been installed.' 22:20:01 T:3016337152 DEBUG: ADDON: cpluff: 'Plug-in repository.pvr-osx32.xbmc.org has been installed.' 22:20:01 T:3016337152 DEBUG: ADDON: cpluff: 'Plug-in pvr.mediaportal.tvserver has been installed.' 22:20:01 T:3016337152 DEBUG: ADDON: cpluff: 'Plug-in visualization.projectm has been installed.' 22:20:01 T:3016337152 DEBUG: ADDON: cpluff: 'Plug-in weather.wunderground has been installed.' 22:20:01 T:3016337152 DEBUG: ADDON: cpluff: 'Plug-in screensaver.xbmc.builtin.dim has been installed.' 22:20:01 T:3016337152 DEBUG: ADDON: cpluff: 'Plug-in metadata.themoviedb.org has been installed.' 22:20:01 T:3016337152 DEBUG: ADDON: cpluff: 'Plug-in xbmc.metadata has been installed.' 22:20:01 T:3016337152 DEBUG: ADDON: cpluff: 'Plug-in repository.pvr-ios.xbmc.org has been installed.' 22:20:01 T:3016337152 DEBUG: ADDON: cpluff: 'Plug-in skin.confluence has been installed.' 22:20:01 T:3016337152 DEBUG: ADDON: cpluff: 'Plug-in visualization.glspectrum has been installed.' 22:20:01 T:3016337152 DEBUG: ADDON: cpluff: 'Plug-in xbmc.gui has been installed.' 22:20:01 T:3016337152 DEBUG: ADDON: cpluff: 'Plug-in script.module.pil has been installed.' 22:20:01 T:3016337152 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.amazon.de has been installed.' 22:20:01 T:3016337152 DEBUG: ADDON: cpluff: 'Plug-in lib.multimedia.makemkv has been installed.' 22:20:01 T:3016337152 DEBUG: ADDON: cpluff: 'Plug-in repository.openelec.tv has been installed.' 22:20:01 T:3016337152 DEBUG: ADDON: cpluff: 'Plug-in os.openelec.tv has been installed.' 22:20:01 T:3016337152 DEBUG: ADDON: cpluff: 'Plug-in metadata.musicvideos.last.fm has been installed.' 22:20:01 T:3016337152 DEBUG: ADDON: cpluff: 'Plug-in pvr.vuplus has been installed.' 22:20:01 T:3016337152 DEBUG: ADDON: cpluff: 'Plug-in xbmc.core has been installed.' 22:20:01 T:3016337152 DEBUG: ADDON: cpluff: 'Plug-in os.openelec.settings has been installed.' 22:20:01 T:3016337152 DEBUG: ADDON: cpluff: 'Plug-in screensaver.rsxs.solarwinds has been installed.' 22:20:01 T:3016337152 DEBUG: ADDON: cpluff: 'Plug-in pvr.demo has been installed.' 22:20:01 T:3016337152 DEBUG: ADDON: cpluff: 'Plug-in plugin.makemkvbluray has been installed.' 22:20:01 T:3016337152 DEBUG: ADDON: cpluff: 'Plug-in xbmc.pvr has been installed.' 22:20:01 T:3016337152 DEBUG: ADDON: cpluff: 'Plug-in pvr.vdr.xvdr has been installed.' 22:20:01 T:3016337152 DEBUG: ADDON: cpluff: 'Plug-in pvr.njoy has been installed.' 22:20:01 T:3016337152 DEBUG: ADDON: cpluff: 'Plug-in pvr.nextpvr has been installed.' 22:20:01 T:3016337152 DEBUG: ADDON: cpluff: 'Plug-in repository.pvr-android.xbmc.org has been installed.' 22:20:01 T:3016337152 DEBUG: ADDON: cpluff: 'Plug-in metadata.album.universal has been installed.' 22:20:01 T:3016337152 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.htbackdrops.com has been installed.' 22:20:01 T:3016337152 DEBUG: ADDON: cpluff: 'Plug-in repository.pvr-win32.xbmc.org has been installed.' 22:20:01 T:3016337152 DEBUG: ADDON: cpluff: 'Plug-in pvr.dvbviewer has been installed.' 22:20:01 T:3016337152 DEBUG: ADDON: cpluff: 'Plug-in repository.pvr-osx64.xbmc.org has been installed.' 22:20:01 T:3016337152 DEBUG: ADDON: cpluff: 'Plug-in pvr.mythtv.cmyth has been installed.' 22:20:01 T:3016337152 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.musicbrainz.org has been installed.' 22:20:01 T:3016337152 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.allmusic.com has been installed.' 22:20:01 T:3016337152 DEBUG: ADDON: cpluff: 'Plug-in metadata.tvdb.com has been installed.' 22:20:01 T:3016337152 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.last.fm has been installed.' 22:20:01 T:3016337152 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.themoviedb.org has been installed.' 22:20:01 T:3016337152 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.theaudiodb.com has been installed.' 22:20:01 T:3016337152 DEBUG: ADDON: cpluff: 'Plug-in metadata.artists.universal has been installed.' 22:20:01 T:3016337152 DEBUG: ADDON: cpluff: 'Plug-in xbmc.python has been installed.' 22:20:01 T:3016337152 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.imdb.com has been installed.' 22:20:01 T:3016337152 DEBUG: ADDON: cpluff: 'Plug-in xbmc.addon has been installed.' 22:20:01 T:3016337152 DEBUG: ADDON: cpluff: 'Plug-in visualization.waveform has been installed.' 22:20:01 T:3016337152 DEBUG: ADDON: cpluff: 'Plug-in screensaver.rsxs.plasma has been installed.' 22:20:01 T:3016337152 DEBUG: ADDON: cpluff: 'Plug-in pvr.hts has been installed.' 22:20:01 T:3016337152 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.hdtrailers.net has been installed.' 22:20:01 T:3016337152 DEBUG: ADDON: cpluff: 'Not all directories were successfully scanned.' 22:20:01 T:3016337152 DEBUG: LoadMappings - loaded node "Motorola Nyxboard Hybrid" 22:20:01 T:3016337152 DEBUG: LoadMappings - loaded node "Raspberry Pi CEC Adapter" 22:20:01 T:3016337152 DEBUG: LoadMappings - loaded node "Pulse-Eight CEC Adapter" 22:20:01 T:3016337152 DEBUG: LoadMappings - loaded node "iMON HID device" 22:20:01 T:3016337152 DEBUG: CPeripheralBusUSB - initialised udev monitor 22:20:01 T:3006266176 NOTICE: Thread XBMC Peripherals start, auto delete: false 22:20:01 T:3016337152 INFO: LIRC Initialize: using: /var/run/lirc/lircd 22:20:01 T:3016337152 INFO: LIRC Initialize: sucessfully started 22:20:01 T:3016337152 DEBUG: Selected UDisks as storage provider 22:20:01 T:3016337152 DEBUG: UDisks: DaemonVersion 1 22:20:01 T:3016337152 DEBUG: UDisks: Querying available devices 22:20:02 T:3016337152 DEBUG: UDisks: Is not able to mount DeviceUDI /org/freedesktop/UDisks/devices/sda: IsFileSystem false HasFileSystem IsSystemInternal true IsMounted false IsRemovable false IsPartition false IsOptical false 22:20:02 T:3016337152 DEBUG: UDisks: Is not able to mount DeviceUDI /org/freedesktop/UDisks/devices/nbd11: IsFileSystem false HasFileSystem IsSystemInternal true IsMounted false IsRemovable false IsPartition false IsOptical false 22:20:02 T:3016337152 DEBUG: UDisks: Is not able to mount DeviceUDI /org/freedesktop/UDisks/devices/nbd12: IsFileSystem false HasFileSystem IsSystemInternal true IsMounted false IsRemovable false IsPartition false IsOptical false 22:20:02 T:3016337152 DEBUG: UDisks: Is not able to mount DeviceUDI /org/freedesktop/UDisks/devices/nbd0: IsFileSystem false HasFileSystem IsSystemInternal true IsMounted false IsRemovable false IsPartition false IsOptical false 22:20:02 T:3016337152 DEBUG: UDisks: Is not able to mount DeviceUDI /org/freedesktop/UDisks/devices/sr0: IsFileSystem false HasFileSystem IsSystemInternal false IsMounted false IsRemovable true IsPartition false IsOptical false 22:20:02 T:3016337152 DEBUG: UDisks: Is not able to mount DeviceUDI /org/freedesktop/UDisks/devices/nbd1: IsFileSystem false HasFileSystem IsSystemInternal true IsMounted false IsRemovable false IsPartition false IsOptical false 22:20:02 T:3016337152 DEBUG: UDisks: Is not able to mount DeviceUDI /org/freedesktop/UDisks/devices/nbd14: IsFileSystem false HasFileSystem IsSystemInternal true IsMounted false IsRemovable false IsPartition false IsOptical false 22:20:02 T:3016337152 DEBUG: UDisks: Is not able to mount DeviceUDI /org/freedesktop/UDisks/devices/nbd15: IsFileSystem false HasFileSystem IsSystemInternal true IsMounted false IsRemovable false IsPartition false IsOptical false 22:20:02 T:3016337152 DEBUG: UDisks: Is not able to mount DeviceUDI /org/freedesktop/UDisks/devices/nbd13: IsFileSystem false HasFileSystem IsSystemInternal true IsMounted false IsRemovable false IsPartition false IsOptical false 22:20:02 T:3016337152 DEBUG: UDisks: Is not able to mount DeviceUDI /org/freedesktop/UDisks/devices/nbd3: IsFileSystem false HasFileSystem IsSystemInternal true IsMounted false IsRemovable false IsPartition false IsOptical false 22:20:02 T:3016337152 DEBUG: UDisks: Is not able to mount DeviceUDI /org/freedesktop/UDisks/devices/nbd4: IsFileSystem false HasFileSystem IsSystemInternal true IsMounted false IsRemovable false IsPartition false IsOptical false 22:20:02 T:3016337152 DEBUG: UDisks: Is not able to mount DeviceUDI /org/freedesktop/UDisks/devices/nbd2: IsFileSystem false HasFileSystem IsSystemInternal true IsMounted false IsRemovable false IsPartition false IsOptical false 22:20:02 T:3016337152 DEBUG: UDisks: Is not able to mount DeviceUDI /org/freedesktop/UDisks/devices/nbd6: IsFileSystem false HasFileSystem IsSystemInternal true IsMounted false IsRemovable false IsPartition false IsOptical false 22:20:02 T:3016337152 DEBUG: UDisks: Is not able to mount DeviceUDI /org/freedesktop/UDisks/devices/nbd7: IsFileSystem false HasFileSystem IsSystemInternal true IsMounted false IsRemovable false IsPartition false IsOptical false 22:20:02 T:3016337152 DEBUG: UDisks: Is not able to mount DeviceUDI /org/freedesktop/UDisks/devices/nbd5: IsFileSystem false HasFileSystem IsSystemInternal true IsMounted false IsRemovable false IsPartition false IsOptical false 22:20:02 T:3016337152 DEBUG: UDisks: Is not able to mount DeviceUDI /org/freedesktop/UDisks/devices/nbd9: IsFileSystem false HasFileSystem IsSystemInternal true IsMounted false IsRemovable false IsPartition false IsOptical false 22:20:02 T:3016337152 DEBUG: UDisks: Is not able to mount DeviceUDI /org/freedesktop/UDisks/devices/nbd8: IsFileSystem false HasFileSystem IsSystemInternal true IsMounted false IsRemovable false IsPartition false IsOptical false 22:20:02 T:3016337152 DEBUG: UDisks: Is not able to mount DeviceUDI /org/freedesktop/UDisks/devices/loop0: IsFileSystem true HasFileSystem squashfs IsSystemInternal true IsMounted true IsRemovable false IsPartition false IsOptical false 22:20:02 T:3016337152 DEBUG: UDisks: Is not able to mount DeviceUDI /org/freedesktop/UDisks/devices/sda1: IsFileSystem true HasFileSystem ext4 IsSystemInternal true IsMounted true IsRemovable false IsPartition true IsOptical false 22:20:02 T:3016337152 INFO: UDisks: Added /flash 22:20:02 T:3016337152 DEBUG: UDisks: Is not able to mount DeviceUDI /org/freedesktop/UDisks/devices/sda2: IsFileSystem true HasFileSystem ext4 IsSystemInternal true IsMounted true IsRemovable false IsPartition true IsOptical false 22:20:02 T:3016337152 INFO: UDisks: Added /storage 22:20:02 T:3016337152 DEBUG: UDisks: Is not able to mount DeviceUDI /org/freedesktop/UDisks/devices/nbd10: IsFileSystem false HasFileSystem IsSystemInternal true IsMounted false IsRemovable false IsPartition false IsOptical false 22:20:02 T:3016337152 NOTICE: Setup SDL 22:20:02 T:3016337152 INFO: Available videomodes (xrandr): 22:20:02 T:3016337152 INFO: Output 'HDMI-0' has 33 modes 22:20:02 T:3016337152 INFO: ID:0x1c5 Name:1920x1080 Refresh:60.000000 Width:1920 Height:1080 22:20:02 T:3016337152 INFO: Pixel Ratio: 1.000000 22:20:02 T:3016337152 INFO: ID:0x1c6 Name:1920x1080 Refresh:59.939388 Width:1920 Height:1080 22:20:02 T:3016337152 INFO: Pixel Ratio: 1.000000 22:20:02 T:3016337152 INFO: ID:0x1c7 Name:1920x1080 Refresh:50.000000 Width:1920 Height:1080 22:20:02 T:3016337152 INFO: Pixel Ratio: 1.000000 22:20:02 T:3016337152 INFO: ID:0x1c8 Name:1920x1080 Refresh:29.971720 Width:1920 Height:1080 22:20:02 T:3016337152 INFO: Pixel Ratio: 1.000000 22:20:02 T:3016337152 INFO: ID:0x1c9 Name:1920x1080 Refresh:25.000000 Width:1920 Height:1080 22:20:02 T:3016337152 INFO: Pixel Ratio: 1.000000 22:20:02 T:3016337152 INFO: ID:0x1ca Name:1920x1080 Refresh:23.970909 Width:1920 Height:1080 22:20:02 T:3016337152 INFO: Pixel Ratio: 1.000000 22:20:02 T:3016337152 INFO: ID:0x1cb Name:1920x1080 Refresh:30.026690 Width:1920 Height:1080 22:20:02 T:3016337152 INFO: Pixel Ratio: 1.000000 22:20:02 T:3016337152 INFO: ID:0x1cc Name:1920x1080 Refresh:29.998381 Width:1920 Height:1080 22:20:02 T:3016337152 INFO: Pixel Ratio: 1.000000 22:20:02 T:3016337152 INFO: ID:0x1cd Name:1920x1080 Refresh:25.022240 Width:1920 Height:1080 22:20:02 T:3016337152 INFO: Pixel Ratio: 1.000000 22:20:02 T:3016337152 INFO: ID:0x1ce Name:1680x1050 Refresh:59.954250 Width:1680 Height:1050 22:20:02 T:3016337152 INFO: Pixel Ratio: 1.111111 22:20:02 T:3016337152 INFO: ID:0x1cf Name:1600x900 Refresh:60.000000 Width:1600 Height:900 22:20:02 T:3016337152 INFO: Pixel Ratio: 1.000000 22:20:02 T:3016337152 INFO: ID:0x1d0 Name:1440x900 Refresh:59.887451 Width:1440 Height:900 22:20:02 T:3016337152 INFO: Pixel Ratio: 1.111111 22:20:02 T:3016337152 INFO: ID:0x1d1 Name:1366x768 Refresh:59.789539 Width:1366 Height:768 22:20:02 T:3016337152 INFO: Pixel Ratio: 0.999512 22:20:02 T:3016337152 INFO: ID:0x1d2 Name:1280x1024 Refresh:75.024673 Width:1280 Height:1024 22:20:02 T:3016337152 INFO: Pixel Ratio: 1.422222 22:20:02 T:3016337152 INFO: ID:0x1d3 Name:1280x1024 Refresh:60.019741 Width:1280 Height:1024 22:20:02 T:3016337152 INFO: Pixel Ratio: 1.422222 22:20:02 T:3016337152 INFO: ID:0x1d4 Name:1280x800 Refresh:59.810329 Width:1280 Height:800 22:20:02 T:3016337152 INFO: Pixel Ratio: 1.111111 22:20:02 T:3016337152 INFO: ID:0x1d5 Name:1280x720 Refresh:60.000000 Width:1280 Height:720 22:20:02 T:3016337152 INFO: Pixel Ratio: 1.000000 22:20:02 T:3016337152 INFO: ID:0x1d6 Name:1280x720 Refresh:59.943432 Width:1280 Height:720 22:20:02 T:3016337152 INFO: Pixel Ratio: 1.000000 22:20:02 T:3016337152 INFO: ID:0x1d7 Name:1280x720 Refresh:50.000000 Width:1280 Height:720 22:20:02 T:3016337152 INFO: Pixel Ratio: 1.000000 22:20:02 T:3016337152 INFO: ID:0x1d8 Name:1152x864 Refresh:75.000000 Width:1152 Height:864 22:20:02 T:3016337152 INFO: Pixel Ratio: 1.333333 22:20:02 T:3016337152 INFO: ID:0x1d9 Name:1024x768 Refresh:75.028580 Width:1024 Height:768 22:20:02 T:3016337152 INFO: Pixel Ratio: 1.333333 22:20:02 T:3016337152 INFO: ID:0x1da Name:1024x768 Refresh:70.069359 Width:1024 Height:768 22:20:02 T:3016337152 INFO: Pixel Ratio: 1.333333 22:20:02 T:3016337152 INFO: ID:0x1db Name:1024x768 Refresh:60.003841 Width:1024 Height:768 22:20:02 T:3016337152 INFO: Pixel Ratio: 1.333333 22:20:02 T:3016337152 INFO: ID:0x1dc Name:800x600 Refresh:75.000000 Width:800 Height:600 22:20:02 T:3016337152 INFO: Pixel Ratio: 1.333333 22:20:02 T:3016337152 INFO: ID:0x1dd Name:800x600 Refresh:72.187569 Width:800 Height:600 22:20:02 T:3016337152 INFO: Pixel Ratio: 1.333333 22:20:02 T:3016337152 INFO: ID:0x1de Name:800x600 Refresh:60.316540 Width:800 Height:600 22:20:02 T:3016337152 INFO: Pixel Ratio: 1.333333 22:20:02 T:3016337152 INFO: ID:0x1df Name:720x576 Refresh:50.000000 Width:720 Height:576 22:20:02 T:3016337152 INFO: Pixel Ratio: 1.422222 22:20:02 T:3016337152 INFO: ID:0x1e0 Name:720x576 Refresh:25.040060 Width:720 Height:576 22:20:02 T:3016337152 INFO: Pixel Ratio: 1.422222 22:20:02 T:3016337152 INFO: ID:0x1e1 Name:720x480 Refresh:59.940060 Width:720 Height:480 22:20:02 T:3016337152 INFO: Pixel Ratio: 1.185185 22:20:02 T:3016337152 INFO: ID:0x1e2 Name:720x480 Refresh:30.027220 Width:720 Height:480 22:20:02 T:3016337152 INFO: Pixel Ratio: 1.185185 22:20:02 T:3016337152 INFO: ID:0x1e3 Name:640x480 Refresh:75.000000 Width:640 Height:480 22:20:02 T:3016337152 INFO: Pixel Ratio: 1.333333 22:20:02 T:3016337152 INFO: ID:0x1e4 Name:640x480 Refresh:72.808800 Width:640 Height:480 22:20:02 T:3016337152 INFO: Pixel Ratio: 1.333333 22:20:02 T:3016337152 INFO: ID:0x1e5 Name:640x480 Refresh:59.940479 Width:640 Height:480 22:20:02 T:3016337152 INFO: Pixel Ratio: 1.333333 22:20:02 T:3016337152 NOTICE: Checking resolution 16 22:20:02 T:3016337152 WARNING: CWinEventsX11::Init - no input method found 22:20:02 T:3016337152 NOTICE: Using visual 0x27 22:20:02 T:3016337152 INFO: GL: Maximum texture width: 8192 22:20:02 T:3016337152 DEBUG: GLX_EXTENSIONS: GLX_EXT_visual_info GLX_EXT_visual_rating GLX_SGIX_fbconfig GLX_SGIX_pbuffer GLX_SGI_video_sync GLX_SGI_swap_control GLX_EXT_swap_control GLX_EXT_swap_control_tear GLX_EXT_texture_from_pixmap GLX_ARB_create_context GLX_ARB_create_context_profile GLX_EXT_create_context_es2_profile GLX_ARB_create_context_robustness GLX_ARB_multisample GLX_NV_float_buffer GLX_ARB_fbconfig_float GLX_EXT_framebuffer_sRGB GLX_NV_multisample_coverage GLX_ARB_get_proc_address 22:20:02 T:3016337152 NOTICE: GL_VENDOR = NVIDIA Corporation 22:20:02 T:3016337152 NOTICE: GL_RENDERER = ION/integrated/SSE2 22:20:02 T:3016337152 NOTICE: GL_VERSION = 3.3.0 NVIDIA 304.64 22:20:02 T:3016337152 NOTICE: GL_SHADING_LANGUAGE_VERSION = 3.30 NVIDIA via Cg compiler 22:20:02 T:3016337152 NOTICE: GL_GPU_MEMORY_INFO_TOTAL_AVAILABLE_MEMORY_NVX = 524288 22:20:02 T:3016337152 NOTICE: GL_GPU_MEMORY_INFO_DEDICATED_VIDMEM_NVX = 524288 22:20:02 T:3016337152 NOTICE: GL_EXTENSIONS = GL_ARB_base_instance GL_ARB_blend_func_extended GL_ARB_color_buffer_float GL_ARB_compatibility GL_ARB_compressed_texture_pixel_storage GL_ARB_conservative_depth GL_ARB_copy_buffer GL_ARB_depth_buffer_float GL_ARB_depth_clamp GL_ARB_depth_texture GL_ARB_draw_buffers GL_ARB_draw_elements_base_vertex GL_ARB_draw_instanced GL_ARB_ES2_compatibility GL_ARB_explicit_attrib_location GL_ARB_fragment_coord_conventions GL_ARB_fragment_program GL_ARB_fragment_program_shadow GL_ARB_fragment_shader GL_ARB_framebuffer_object GL_ARB_framebuffer_sRGB GL_ARB_geometry_shader4 GL_ARB_get_program_binary GL_ARB_half_float_pixel GL_ARB_half_float_vertex GL_ARB_imaging GL_ARB_instanced_arrays GL_ARB_internalformat_query GL_ARB_map_buffer_alignment GL_ARB_map_buffer_range GL_ARB_multisample GL_ARB_multitexture GL_ARB_occlusion_query GL_ARB_occlusion_query2 GL_ARB_pixel_buffer_object GL_ARB_point_parameters GL_ARB_point_sprite GL_ARB_provoking_vertex GL_ARB_robustness GL_ARB_sampler_objects GL_ARB_seamless_cube_map GL_ARB_separate_shader_objects GL_ARB_shader_bit_encoding GL_ARB_shader_objects GL_ARB_shader_texture_lod GL_ARB_shading_language_100 GL_ARB_shading_language_420pack GL_ARB_shading_language_include GL_ARB_shading_language_packing GL_ARB_shadow GL_ARB_sync GL_ARB_texture_border_clamp GL_ARB_texture_buffer_object GL_ARB_texture_compression GL_ARB_texture_compression_rgtc GL_ARB_texture_cube_map GL_ARB_texture_env_add GL_ARB_texture_env_combine GL_ARB_texture_env_crossbar GL_ARB_texture_env_dot3 GL_ARB_texture_float GL_ARB_texture_mirrored_repeat GL_ARB_texture_multisample GL_ARB_texture_non_power_of_two GL_ARB_texture_rectangle GL_ARB_texture_rg GL_ARB_texture_rgb10_a2ui GL_ARB_texture_storage GL_ARB_texture_swizzle GL_ARB_timer_query GL_ARB_transform_feedback2 GL_ARB_transform_feedback_instanced GL_ARB_transpose_matrix GL_ARB_uniform_buffer_object GL_ARB_vertex_array_bgra GL_ARB_vertex_array_object GL_ARB_vertex_buffer_object GL_ARB_vertex_program GL_ARB_vertex_shader GL_ARB_vertex_type_2_10_10_10_rev GL_ARB_viewport_array GL_ARB_window_pos GL_ATI_draw_buffers GL_ATI_texture_float GL_ATI_texture_mirror_once GL_S3_s3tc GL_EXT_texture_env_add GL_EXT_abgr GL_EXT_bgra GL_EXT_bindable_uniform GL_EXT_blend_color GL_EXT_blend_equation_separate GL_EXT_blend_func_separate GL_EXT_blend_minmax GL_EXT_blend_subtract GL_EXT_compiled_vertex_array GL_EXT_Cg_shader GL_EXT_depth_bounds_test GL_EXT_direct_state_access GL_EXT_draw_buffers2 GL_EXT_draw_instanced GL_EXT_draw_range_elements GL_EXT_fog_coord GL_EXT_framebuffer_blit GL_EXT_framebuffer_multisample GL_EXTX_framebuffer_mixed_formats GL_EXT_framebuffer_object GL_EXT_framebuffer_sRGB GL_EXT_geometry_shader4 GL_EXT_gpu_program_parameters GL_EXT_gpu_shader4 GL_EXT_multi_draw_arrays GL_EXT_packed_depth_stencil GL_EXT_packed_float GL_EXT_packed_pixels GL_EXT_pixel_buffer_object GL_EXT_point_parameters GL_EXT_provoking_vertex GL_EXT_rescale_normal GL_EXT_secondary_color GL_EXT_separate_shader_objects GL_EXT_separate_specular_color GL_EXT_shadow_funcs GL_EXT_stencil_two_side GL_EXT_stencil_wrap GL_EXT_texture3D GL_EXT_texture_array GL_EXT_texture_buffer_object GL_EXT_texture_compression_dxt1 GL_EXT_texture_compression_latc GL_EXT_texture_compression_rgtc GL_EXT_texture_compression_s3tc GL_EXT_texture_cube_map GL_EXT_texture_edge_clamp GL_EXT_texture_env_combine GL_EXT_texture_env_dot3 GL_EXT_texture_filter_anisotropic GL_EXT_texture_format_BGRA8888 GL_EXT_texture_integer GL_EXT_texture_lod GL_EXT_texture_lod_bias GL_EXT_texture_mirror_clamp GL_EXT_texture_object GL_EXT_texture_shared_exponent GL_EXT_texture_sRGB GL_EXT_texture_sRGB_decode GL_EXT_texture_storage GL_EXT_texture_swizzle GL_EXT_texture_type_2_10_10_10_REV GL_EXT_timer_query GL_EXT_transform_feedback2 GL_EXT_vertex_array GL_EXT_vertex_array_bgra GL_EXT_x11_sync_object GL_EXT_import_sync_object GL_IBM_rasterpos_clip GL_IBM_texture_mirrored_repeat GL_KTX_buffer_region GL_NV_alpha_test GL_NV_blend_minmax GL_NV_blend_square GL_NV_complex_primitives GL_NV_conditional_render GL_NV_copy_depth_to_color GL_NV_copy_image GL_NV_depth_buffer_float GL_NV_depth_clamp GL_NV_ES1_1_compatibility GL_NV_explicit_multisample GL_NV_fbo_color_attachments GL_NV_fence GL_NV_float_buffer GL_NV_fog_distance GL_NV_fragdepth GL_NV_fragment_program GL_NV_fragment_program_option GL_NV_fragment_program2 GL_NV_framebuffer_multisample_coverage GL_NV_geometry_shader4 GL_NV_gpu_program4 GL_NV_half_float GL_NV_light_max_exponent GL_NV_multisample_coverage GL_NV_multisample_filter_hint GL_NV_occlusion_query GL_NV_packed_depth_stencil GL_NV_parameter_buffer_object GL_NV_parameter_buffer_object2 GL_NV_path_rendering GL_NV_pixel_data_range GL_NV_point_sprite GL_NV_primitive_restart GL_NV_register_combiners GL_NV_register_combiners2 GL_NV_shader_buffer_load GL_NV_texgen_reflection GL_NV_texture_barrier GL_NV_texture_compression_vtc GL_NV_texture_env_combine4 GL_NV_texture_expand_normal GL_NV_texture_lod_clamp GL_NV_texture_multisample GL_NV_texture_rectangle GL_NV_texture_shader GL_NV_texture_shader2 GL_NV_texture_shader3 GL_NV_transform_feedback GL_NV_transform_feedback2 GL_NV_vdpau_interop GL_NV_vertex_array_range GL_NV_vertex_array_range2 GL_NV_vertex_buffer_unified_memory GL_NV_vertex_program GL_NV_vertex_program1_1 GL_NV_vertex_program2 GL_NV_vertex_program2_option GL_NV_vertex_program3 GL_NVX_conditional_render GL_NVX_gpu_memory_info GL_OES_compressed_paletted_texture GL_OES_depth24 GL_OES_depth32 GL_OES_depth_texture GL_OES_element_index_uint GL_OES_fbo_render_mipmap GL_OES_get_program_binary GL_OES_mapbuffer GL_OES_packed_depth_stencil GL_OES_point_size_array GL_OES_point_sprite GL_OES_rgb8_rgba8 GL_OES_read_format GL_OES_standard_derivatives GL_OES_texture_3D GL_OES_texture_float GL_OES_texture_float_linear GL_OES_texture_half_float GL_OES_texture_half_float_linear GL_OES_texture_npot GL_OES_vertex_array_object GL_OES_vertex_half_float GL_SGIS_generate_mipmap GL_SGIS_texture_lod GL_SGIX_depth_texture GL_SGIX_shadow GL_SUN_slice_accum 22:20:02 T:3016337152 INFO: GL: Maximum texture width: 8192 22:20:02 T:3016337152 DEBUG: CRenderManager::UpdateDisplayLatency - Latency set to 0 msec 22:20:02 T:3016337152 INFO: load keymapping 22:20:02 T:3016337152 INFO: Loading special://xbmc/system/keymaps/appcommand.xml 22:20:02 T:3016337152 INFO: Loading special://xbmc/system/keymaps/gamepad.xml 22:20:02 T:3016337152 INFO: Loading special://xbmc/system/keymaps/joystick.Alienware.Dual.Compatible.Controller.xml 22:20:02 T:3016337152 INFO: Loading special://xbmc/system/keymaps/joystick.AppleRemote.xml 22:20:02 T:3016337152 INFO: Loading special://xbmc/system/keymaps/joystick.Harmony.xml 22:20:02 T:3016337152 INFO: Loading special://xbmc/system/keymaps/joystick.Interact.AxisPad.xml 22:20:02 T:3016337152 INFO: Loading special://xbmc/system/keymaps/joystick.Logitech.RumblePad.2.xml 22:20:02 T:3016337152 INFO: Loading special://xbmc/system/keymaps/joystick.Microsoft.Xbox.360.Controller.xml 22:20:02 T:3016337152 INFO: Loading special://xbmc/system/keymaps/joystick.Microsoft.Xbox.Controller.S.xml 22:20:02 T:3016337152 INFO: Loading special://xbmc/system/keymaps/joystick.PS3.Remote.Keyboard.xml 22:20:02 T:3016337152 INFO: Loading special://xbmc/system/keymaps/joystick.Sony.PLAYSTATION(R)3.Controller.xml 22:20:02 T:3016337152 INFO: Loading special://xbmc/system/keymaps/joystick.WiiRemote.xml 22:20:02 T:3016337152 INFO: Loading special://xbmc/system/keymaps/keyboard.xml 22:20:02 T:3016337152 INFO: Loading special://xbmc/system/keymaps/mouse.xml 22:20:02 T:3016337152 INFO: Loading special://xbmc/system/keymaps/remote.xml 22:20:02 T:3016337152 INFO: Loading special://xbmc/system/Lircmap.xml 22:20:02 T:3016337152 INFO: * Adding remote mapping for device 'mceusb' 22:20:02 T:3016337152 INFO: * Adding remote mapping for device 'XboxDVDDongle' 22:20:02 T:3016337152 INFO: * Adding remote mapping for device 'Microsoft_Xbox' 22:20:02 T:3016337152 INFO: * Adding remote mapping for device 'PinnacleSysPCTVRemote' 22:20:02 T:3016337152 INFO: * Adding remote mapping for device 'anysee' 22:20:02 T:3016337152 INFO: * Adding remote mapping for device 'iMON-PAD' 22:20:02 T:3016337152 INFO: * Adding remote mapping for device 'Antec_Veris_RM200' 22:20:02 T:3016337152 INFO: * Adding remote mapping for device 'MCE_via_iMON' 22:20:02 T:3016337152 INFO: * Adding remote mapping for device 'TwinHanRemote' 22:20:02 T:3016337152 INFO: * Adding remote mapping for device 'linux-input-layer' 22:20:02 T:3016337152 INFO: * Linking remote mapping for 'linux-input-layer' to 'cx23885_remote' 22:20:02 T:3016337152 INFO: * Adding remote mapping for device 'mediacenter' 22:20:02 T:3016337152 INFO: * Adding remote mapping for device 'devinput' 22:20:02 T:3016337152 DEBUG: CButtonTranslator::Load - no userdata Lircmap.xml found, skipping 22:20:02 T:3016337152 INFO: GUI format 1920x1080, Display 1920x1080 @ 60.00 - Full Screen 22:20:02 T:3016337152 DEBUG: guilib: Fill viewport on change for solving rendering passes 22:20:02 T:3016337152 DEBUG: SECTION:LoadDLL(libcurl.so.4) 22:20:02 T:3016337152 DEBUG: Loading: libcurl.so.4 22:20:03 T:3016337152 NOTICE: Running database version Addons15 22:20:03 T:3016337152 DEBUG: Initialize, updating databases... 22:20:03 T:3016337152 NOTICE: Running database version ViewModes4 22:20:03 T:3016337152 NOTICE: Running database version Textures13 22:20:03 T:3016337152 NOTICE: Running database version MyMusic32 22:20:03 T:3016337152 NOTICE: Running database version MyVideos75 22:20:03 T:3016337152 NOTICE: Running database version TV22 22:20:03 T:3016337152 NOTICE: Running database version Epg7 22:20:03 T:3016337152 DEBUG: Initialize, updating databases... DONE 22:20:03 T:3016337152 NOTICE: start dvd mediatype detection 22:20:03 T:3016337152 NOTICE: initializing playlistplayer 22:20:03 T:3016337152 NOTICE: DONE initializing playlistplayer 22:20:03 T:2989747008 NOTICE: Thread CDetectDVDMedia start, auto delete: false 22:20:03 T:2989747008 DEBUG: Compiled with libcdio Version 0.90 22:20:03 T:3016337152 DEBUG: DPMS: supported power-saving modes: SUSPEND OFF STANDBY 22:20:03 T:3016337152 DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc 22:20:03 T:3016337152 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnClear 22:20:03 T:3016337152 INFO: Unloading old skin ... 22:20:03 T:3016337152 INFO: load skin from: /usr/share/xbmc/addons/skin.confluence (version: 2.1.3) 22:20:03 T:3016337152 INFO: load fonts for skin... 22:20:03 T:3016337152 INFO: Loading fonts from /usr/share/xbmc/addons/skin.confluence/720p/Font.xml 22:20:03 T:3016337152 DEBUG: POParser: loaded 131 strings from file /usr/share/xbmc/addons/skin.confluence/language/English/strings.po 22:20:03 T:3016337152 INFO: Loading skin includes from /usr/share/xbmc/addons/skin.confluence/720p/includes.xml 22:20:03 T:3016337152 INFO: load new skin... 22:20:03 T:3016337152 INFO: Loading user windows, path /usr/share/xbmc/addons/skin.confluence/720p 22:20:03 T:3016337152 DEBUG: Load Skin XML: 16.78ms 22:20:03 T:3016337152 INFO: initialize new skin... 22:20:03 T:3016337152 DEBUG: guilib: Fill viewport on change for solving rendering passes 22:20:03 T:3016337152 INFO: Loading skin file: Pointer.xml, load type: LOAD_ON_GUI_INIT 22:20:03 T:3016337152 DEBUG: OpenBundle - Opened bundle /usr/share/xbmc/addons/skin.confluence/media/Textures.xbt 22:20:03 T:3016337152 INFO: Loading skin file: DialogVolumeBar.xml, load type: LOAD_ON_GUI_INIT 22:20:03 T:3016337152 INFO: Loading skin file: DialogKaiToast.xml, load type: LOAD_ON_GUI_INIT 22:20:03 T:3016337152 INFO: Loading skin file: DialogMuteBug.xml, load type: LOAD_ON_GUI_INIT 22:20:03 T:3016337152 INFO: Loading skin file: DialogSeekBar.xml, load type: LOAD_ON_GUI_INIT 22:20:03 T:3016337152 INFO: Loading skin file: DialogBusy.xml, load type: LOAD_ON_GUI_INIT 22:20:03 T:3016337152 INFO: Loading skin file: DialogExtendedProgressBar.xml, load type: LOAD_ON_GUI_INIT 22:20:03 T:3016337152 INFO: Loading /usr/share/xbmc/addons/skin.confluence/sounds/sounds.xml 22:20:03 T:3016337152 INFO: CAEWAVLoader::Initialize - Sound Loaded: /usr/share/xbmc/addons/skin.confluence/sounds/cursor.wav 22:20:03 T:3016337152 INFO: CAEWAVLoader::Initialize - Sound Loaded: /usr/share/xbmc/addons/skin.confluence/sounds/click.wav 22:20:03 T:3016337152 INFO: CAEWAVLoader::Initialize - Sound Loaded: /usr/share/xbmc/addons/skin.confluence/sounds/back.wav 22:20:03 T:3016337152 DEBUG: AERemap: Downmix normalization is disabled 22:20:03 T:3016337152 INFO: CAEWAVLoader::Initialize - Sound Loaded: /usr/share/xbmc/addons/skin.confluence/sounds/shutter.wav 22:20:03 T:3016337152 INFO: CAEWAVLoader::Initialize - Sound Loaded: /usr/share/xbmc/addons/skin.confluence/sounds/notify.wav 22:20:04 T:3016337152 DEBUG: AERemap: Downmix normalization is disabled 22:20:04 T:3016337152 INFO: CAEWAVLoader::Initialize - Sound Loaded: /usr/share/xbmc/addons/skin.confluence/sounds/out.wav 22:20:04 T:3016337152 DEBUG: AERemap: Downmix normalization is disabled 22:20:04 T:3016337152 INFO: skin loaded... 22:20:04 T:3016337152 INFO: JSONRPC v6.0.0: Successfully initialized 22:20:04 T:3016337152 DEBUG: ADDON: Starting service addons. 22:20:04 T:3016337152 DEBUG: Activating window ID: 12999 22:20:04 T:3016337152 DEBUG: ------ Window Init (Startup.xml) ------ 22:20:04 T:3016337152 INFO: Loading skin file: Startup.xml, load type: LOAD_EVERY_TIME 22:20:04 T:3016337152 INFO: removing tempfiles 22:20:04 T:3016337152 DEBUG: ADDON: Starting service addons. 22:20:04 T:3016337152 NOTICE: initialize done 22:20:04 T:3016337152 NOTICE: Running the application... 22:20:04 T:3016337152 DEBUG: ExecuteXBMCAction : Translating ReplaceWindow(Home) 22:20:04 T:3016337152 DEBUG: ExecuteXBMCAction : To ReplaceWindow(Home) 22:20:04 T:3016337152 DEBUG: Activating window ID: 10000 22:20:04 T:3016337152 DEBUG: ------ Window Init () ------ 22:20:04 T:3016337152 DEBUG: ------ Window Init (Pointer.xml) ------ 22:20:04 T:3016337152 INFO: GL: Enabling VSYNC 22:20:04 T:3016337152 INFO: GL: Selected vsync mode 2 22:20:04 T:3016337152 DEBUG: ------ Window Deinit (Startup.xml) ------ 22:20:04 T:3016337152 DEBUG: ------ Window Init (Home.xml) ------ 22:20:04 T:3016337152 INFO: Loading skin file: Home.xml, load type: KEEP_IN_MEMORY 22:20:05 T:2981096256 NOTICE: Thread Jobworker start, auto delete: true 22:20:05 T:2981096256 DEBUG: CRecentlyAddedJob::UpdateMusic() - Running RecentlyAdded home screen update 22:20:05 T:3016337152 DEBUG: Process - no profile autoexec.py (/storage/.xbmc/userdata/autoexec.py) found, skipping 22:20:05 T:3016337152 DEBUG: NetworkMessage - Starting network services 22:20:05 T:3016337152 NOTICE: Webserver: Starting... 22:20:05 T:3016337152 NOTICE: WebServer: Started the webserver 22:20:05 T:3016337152 INFO: CZeroconfAvahi::clientCallback: avahi server not available. But may become later... 22:20:05 T:3016337152 NOTICE: ES: Starting event server 22:20:05 T:2926574400 NOTICE: Thread CEventServer start, auto delete: false 22:20:05 T:3016337152 INFO: JSONRPC Server: Successfully initialized 22:20:05 T:2926574400 NOTICE: ES: Starting UDP Event server on 0.0.0.0:9777 22:20:05 T:2926574400 NOTICE: UDP: Listening on port 9777 22:20:05 T:3016337152 NOTICE: starting zeroconf publishing 22:20:05 T:2916088640 NOTICE: Thread CTCPServer start, auto delete: false 22:20:05 T:2905602880 NOTICE: Thread Jobworker start, auto delete: true 22:20:05 T:3016337152 DEBUG: CLastfmScrobbler: Clearing session. 22:20:05 T:2905602880 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.eventserver type: _xbmc-events._udp name:XBMC (openelec) port:9777 22:20:05 T:3016337152 DEBUG: CLibrefmScrobbler: Clearing session. 22:20:05 T:2905602880 DEBUG: CZeroconfAvahi::doPublishService: client not running, queued for publishing 22:20:05 T:2905602880 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.jsonrpc-http type: _xbmc-jsonrpc-h._tcp name:XBMC (openelec) port:80 22:20:05 T:2905602880 DEBUG: CZeroconfAvahi::doPublishService: client not running, queued for publishing 22:20:05 T:2905602880 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.jsonrpc-tpc type: _xbmc-jsonrpc._tcp name:XBMC (openelec) port:9090 22:20:05 T:3016337152 DEBUG: UPower: Recieved an unknown signal NameAcquired 22:20:05 T:2905602880 DEBUG: CZeroconfAvahi::doPublishService: client not running, queued for publishing 22:20:05 T:2905602880 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.webserver type: _http._tcp name:XBMC (openelec) port:80 22:20:05 T:2905602880 DEBUG: CZeroconfAvahi::doPublishService: client not running, queued for publishing 22:20:05 T:2981096256 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 22:20:05 T:2981096256 DEBUG: GetRecentlyAddedAlbums query: select * from albumview where strAlbum != '' order by idAlbum desc limit 10 22:20:05 T:3016337152 DEBUG: Checking repositories for updates (triggered by XBMC.org Add-ons) 22:20:05 T:2905602880 DEBUG: CFileCache::Open - opening using cache 22:20:05 T:2905602880 DEBUG: CurlFile::Open(0xbeedaf0) http://mirrors.xbmc.org/addons/frodo/addons.xml.md5 22:20:05 T:2905602880 INFO: easy_aquire - Created session to http://mirrors.xbmc.org 22:20:05 T:2989644608 NOTICE: Thread CRssReader start, auto delete: false 22:20:05 T:2989644608 DEBUG: CurlFile::Open(0xb2325114) http://openelec.tv/news?format=feed&type=rss 22:20:05 T:2989644608 INFO: easy_aquire - Created session to http://openelec.tv 22:20:05 T:2981096256 DEBUG: CRecentlyAddedJob::UpdateVideos() - Running RecentlyAdded home screen update 22:20:05 T:2981096256 DEBUG: RunQuery took 2 ms for 0 items query: select * from movieview ORDER BY dateAdded desc, idMovie desc LIMIT 10 22:20:05 T:2981096256 DEBUG: RunQuery took 2 ms for 0 items query: select * from episodeview ORDER BY dateAdded desc, idEpisode desc LIMIT 10 22:20:05 T:2981096256 DEBUG: RunQuery took 2 ms for 0 items query: select * from musicvideoview ORDER BY dateAdded desc, idMVideo desc LIMIT 10 22:20:05 T:2981096256 DEBUG: CRecentlyAddedJob::UpdateTotal() - Running RecentlyAdded home screen update 22:20:05 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:20:05 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:20:05 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:20:05 T:2862693184 NOTICE: Thread CFileCache start, auto delete: false 22:20:05 T:2862693184 INFO: CFileCache::Process - Hit eof. 22:20:05 T:3016337152 DEBUG: ------ Window Deinit (Pointer.xml) ------ 22:20:05 T:2862693184 DEBUG: Thread CFileCache 2862693184 terminating 22:20:05 T:2905602880 DEBUG: CurlFile::Open(0xbeee048) http://mirrors.xbmc.org/addons/frodo/addons.xml 22:20:05 T:2989644608 DEBUG: Got rss feed: http://openelec.tv/news?format=feed&type=rss 22:20:05 T:2989644608 DEBUG: RSS feed encoding: utf-8 22:20:05 T:2989644608 DEBUG: Parsed rss feed: http://openelec.tv/news?format=feed&type=rss 22:20:05 T:2989644608 DEBUG: CurlFile::Open(0xb2325114) http://feeds.feedburner.com/xbmc 22:20:05 T:2989644608 INFO: easy_aquire - Created session to http://feeds.feedburner.com 22:20:06 T:2937043776 DEBUG: CZeroconfAvahi::clientCallback: uiuui; coll or reg, anyways, resetting groups 22:20:06 T:2989644608 DEBUG: Got rss feed: http://feeds.feedburner.com/xbmc 22:20:06 T:2989644608 DEBUG: RSS feed encoding: UTF-8 22:20:06 T:2989644608 DEBUG: Parsed rss feed: http://feeds.feedburner.com/xbmc 22:20:06 T:2989644608 DEBUG: Thread CRssReader 2989644608 terminating 22:20:06 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:20:06 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:20:06 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:20:06 T:3016337152 DEBUG: LIRC: Update - NEW at 5819:6a 0 KEY_RIGHT devinput (KEY_RIGHT) 22:20:06 T:3016337152 DEBUG: OnKey: 168 (a8) pressed, action is Right 22:20:06 T:3016337152 DEBUG: LIRC: Update - NEW at 6153:6a 0 KEY_RIGHT_UP devinput (KEY_RIGHT_UP) 22:20:06 T:3016337152 DEBUG: LIRC: Update - NEW at 6269:6a 0 KEY_RIGHT devinput (KEY_RIGHT) 22:20:06 T:3016337152 DEBUG: OnKey: 168 (a8) pressed, action is Right 22:20:07 T:2937043776 DEBUG: CZeroconfAvahi::clientCallback: client is up and running 22:20:07 T:2937043776 DEBUG: CZeroconfAvahi::addService() named: XBMC (openelec) type: _xbmc-events._udp port:9777 22:20:07 T:2937043776 DEBUG: CZeroconfAvahi::addService() named: XBMC (openelec) type: _xbmc-jsonrpc-h._tcp port:80 22:20:07 T:2937043776 DEBUG: CZeroconfAvahi::addService() named: XBMC (openelec) type: _xbmc-jsonrpc._tcp port:9090 22:20:07 T:2937043776 DEBUG: CZeroconfAvahi::addService() named: XBMC (openelec) type: _http._tcp port:80 22:20:07 T:3016337152 DEBUG: LIRC: Update - NEW at 6752:6a 0 KEY_RIGHT_UP devinput (KEY_RIGHT_UP) 22:20:07 T:3016337152 DEBUG: LIRC: Update - NEW at 6769:6a 0 KEY_RIGHT devinput (KEY_RIGHT) 22:20:07 T:3016337152 DEBUG: OnKey: 168 (a8) pressed, action is Right 22:20:07 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:20:07 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:20:07 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:20:07 T:3016337152 DEBUG: LIRC: Update - NEW at 7269:6a 0 KEY_RIGHT_UP devinput (KEY_RIGHT_UP) 22:20:07 T:3016337152 DEBUG: LIRC: Update - NEW at 7286:69 0 KEY_LEFT devinput (KEY_LEFT) 22:20:07 T:3016337152 DEBUG: OnKey: 169 (a9) pressed, action is Left 22:20:08 T:2937043776 DEBUG: CZeroconfAvahi::groupCallback: Service successfully established 22:20:08 T:3016337152 DEBUG: Previous line repeats 3 times. 22:20:08 T:3016337152 DEBUG: LIRC: Update - NEW at 7619:69 0 KEY_LEFT_UP devinput (KEY_LEFT_UP) 22:20:08 T:3016337152 DEBUG: LIRC: Update - NEW at 7636:69 0 KEY_LEFT devinput (KEY_LEFT) 22:20:08 T:3016337152 DEBUG: OnKey: 169 (a9) pressed, action is Left 22:20:08 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:20:08 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:20:08 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:20:08 T:3016337152 DEBUG: LIRC: Update - NEW at 7902:69 0 KEY_LEFT_UP devinput (KEY_LEFT_UP) 22:20:08 T:3016337152 DEBUG: LIRC: Update - NEW at 7908:69 0 KEY_LEFT devinput (KEY_LEFT) 22:20:08 T:3016337152 DEBUG: OnKey: 169 (a9) pressed, action is Left 22:20:08 T:2905602880 DEBUG: CFileCache::Open - opening <3.0/ION/i386/addons.xml.md5> using cache 22:20:08 T:2905602880 DEBUG: CurlFile::Open(0xbeee2b0) http://addons.openelec.tv/3.0/ION/i386/addons.xml.md5 22:20:08 T:2905602880 INFO: easy_aquire - Created session to http://addons.openelec.tv 22:20:08 T:2862693184 NOTICE: Thread CFileCache start, auto delete: false 22:20:08 T:2862693184 INFO: CFileCache::Process - Hit eof. 22:20:08 T:3016337152 DEBUG: LIRC: Update - NEW at 8319:69 0 KEY_LEFT_UP devinput (KEY_LEFT_UP) 22:20:08 T:2862693184 DEBUG: Thread CFileCache 2862693184 terminating 22:20:09 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:20:09 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:20:09 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:20:09 T:3016337152 DEBUG: LIRC: Update - NEW at 9136:6c 0 KEY_DOWN devinput (KEY_DOWN) 22:20:09 T:3016337152 DEBUG: OnKey: 167 (a7) pressed, action is Down 22:20:10 T:3016337152 DEBUG: LIRC: Update - NEW at 9570:6c 0 KEY_DOWN_UP devinput (KEY_DOWN_UP) 22:20:10 T:3016337152 DEBUG: LIRC: Update - NEW at 9770:6a 0 KEY_RIGHT devinput (KEY_RIGHT) 22:20:10 T:3016337152 DEBUG: OnKey: 168 (a8) pressed, action is Right 22:20:10 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:20:10 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:20:10 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:20:10 T:3016337152 DEBUG: LIRC: Update - NEW at 10103:6a 0 KEY_RIGHT_UP devinput (KEY_RIGHT_UP) 22:20:10 T:3016337152 DEBUG: LIRC: Update - NEW at 10203:160 0 KEY_OK devinput (KEY_OK) 22:20:10 T:3016337152 DEBUG: OnKey: 11 (0b) pressed, action is Select 22:20:10 T:3016337152 DEBUG: ExecuteXBMCAction : Translating ActivateWindow(Videos,Addons,return) 22:20:10 T:3016337152 DEBUG: ExecuteXBMCAction : To ActivateWindow(Videos,Addons,return) 22:20:10 T:3016337152 DEBUG: Activating window ID: 10025 22:20:11 T:3016337152 DEBUG: ------ Window Deinit (Home.xml) ------ 22:20:11 T:3016337152 DEBUG: ExecuteXBMCAction : Translating SetProperty(VideosDirectLink,True) 22:20:11 T:3016337152 DEBUG: ExecuteXBMCAction : To SetProperty(VideosDirectLink,True) 22:20:11 T:3016337152 DEBUG: ------ Window Init (MyVideoNav.xml) ------ 22:20:11 T:3016337152 INFO: Loading skin file: MyVideoNav.xml, load type: KEEP_IN_MEMORY 22:20:11 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:20:11 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:20:11 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:20:11 T:3016337152 DEBUG: CGUIMediaWindow::GetDirectory (addons://sources/video/) 22:20:11 T:3016337152 DEBUG: ParentPath = [addons://sources/video/] 22:20:11 T:2862693184 NOTICE: Thread Background Loader start, auto delete: false 22:20:11 T:3016337152 DEBUG: LIRC: Update - NEW at 11180:160 0 KEY_OK_UP devinput (KEY_OK_UP) 22:20:11 T:2862693184 DEBUG: Thread Background Loader 2862693184 terminating 22:20:12 T:3016337152 DEBUG: LIRC: Update - NEW at 11980:6c 0 KEY_DOWN devinput (KEY_DOWN) 22:20:12 T:3016337152 DEBUG: OnKey: 167 (a7) pressed, action is Down 22:20:12 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:20:12 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:20:12 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:20:12 T:3016337152 DEBUG: LIRC: Update - NEW at 12390:6c 0 KEY_DOWN_UP devinput (KEY_DOWN_UP) 22:20:13 T:3016337152 DEBUG: LIRC: Update - NEW at 12490:160 0 KEY_OK devinput (KEY_OK) 22:20:13 T:3016337152 DEBUG: OnKey: 11 (0b) pressed, action is Select 22:20:13 T:3016337152 DEBUG: CGUIMediaWindow::GetDirectory (plugin://plugin.makemkvbluray/) 22:20:13 T:3016337152 DEBUG: ParentPath = [addons://sources/video/] 22:20:13 T:2981096256 DEBUG: StartScript - calling plugin BluRay Player with MakeMKV('plugin://plugin.makemkvbluray/','0','') 22:20:13 T:2981096256 INFO: initializing python engine. 22:20:13 T:2981096256 DEBUG: new python thread created. id=1 22:20:13 T:2981096256 DEBUG: WaitOnScriptResult - waiting on the BluRay Player with MakeMKV (id=1) plugin... 22:20:13 T:2862693184 NOTICE: Thread XBPyThread start, auto delete: false 22:20:13 T:2862693184 DEBUG: Python thread: start processing 22:20:13 T:2862693184 NOTICE: -->Python Interpreter Initialized<-- 22:20:13 T:2862693184 DEBUG: Process - The source file to load is /storage/.xbmc/addons/plugin.makemkvbluray/default.py 22:20:13 T:2862693184 DEBUG: Process - Setting the Python path to /storage/.xbmc/addons/plugin.makemkvbluray:/usr/share/xbmc/addons/weather.wunderground/resources/lib/wunderground:/usr/share/xbmc/addons/script.module.pil/lib:/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: 22:20:13 T:2862693184 DEBUG: Process - Entering source directory /storage/.xbmc/addons/plugin.makemkvbluray 22:20:13 T:2862693184 DEBUG: Instantiating addon using automatically obtained id of "plugin.makemkvbluray" dependent on version 1.0 of the xbmc.python api 22:20:13 T:3016337152 DEBUG: ------ Window Init (DialogBusy.xml) ------ 22:20:13 T:3016337152 DEBUG: LIRC: Update - NEW at 13010:160 0 KEY_OK_UP devinput (KEY_OK_UP) 22:20:13 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:20:13 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:20:13 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:20:13 T:2862693184 NOTICE: [BR 1] Starting the BluRay script 22:20:13 T:2862693184 NOTICE: [BR 1] Staring 22:20:13 T:2862693184 NOTICE: [BR-settings 1] reading settings 22:20:13 T:2862693184 NOTICE: [BR-settings 1] raw param string: 22:20:13 T:2862693184 NOTICE: [BR 1] mode: None 22:20:13 T:2862693184 NOTICE: [BR 1] Showing categories 22:20:13 T:2862693184 DEBUG: LocalizeStrings: no strings.po file exist at /storage/.xbmc/addons/plugin.makemkvbluray/resources/language/english, fallback to strings.xml 22:20:13 T:2862693184 NOTICE: [BR 1] plugin://plugin.makemkvbluray/?mode=1&autoplay=True 22:20:13 T:2862693184 NOTICE: [BR 1] Play Disc 22:20:13 T:2862693184 NOTICE: [BR 1] plugin://plugin.makemkvbluray/?mode=1&autoplay=False 22:20:13 T:2862693184 NOTICE: [BR 1] Browse Disc 22:20:13 T:2862693184 NOTICE: [BR 1] plugin://plugin.makemkvbluray/?mode=2&autoplay=True 22:20:13 T:2862693184 NOTICE: [BR 1] Play Filelocation 22:20:13 T:2862693184 NOTICE: [BR 1] plugin://plugin.makemkvbluray/?mode=2&autoplay=False 22:20:13 T:2862693184 NOTICE: [BR 1] Browse Filelocation 22:20:13 T:2862693184 NOTICE: [BR 1] plugin://plugin.makemkvbluray/?mode=3&autoplay=True 22:20:13 T:2862693184 NOTICE: [BR 1] Play Remote location 22:20:13 T:2862693184 NOTICE: [BR 1] plugin://plugin.makemkvbluray/?mode=3&autoplay=False 22:20:13 T:2862693184 NOTICE: [BR 1] Browse Remote location 22:20:13 T:2862693184 NOTICE: [BR 1] plugin://plugin.makemkvbluray/?mode=20&autoplay=True 22:20:13 T:2862693184 NOTICE: [BR 1] Settings 22:20:13 T:2981096256 DEBUG: WaitOnScriptResult- plugin returned successfully 22:20:13 T:2862693184 NOTICE: [BR 1] Showing categories done 22:20:13 T:2862693184 ERROR: EndOfDirectory - called with an invalid handle. 22:20:13 T:2862693184 INFO: Scriptresult: Success 22:20:13 T:2862693184 INFO: Python script stopped 22:20:13 T:2862693184 DEBUG: Thread XBPyThread 2862693184 terminating 22:20:14 T:2862693184 NOTICE: Thread Background Loader start, auto delete: false 22:20:14 T:3016337152 DEBUG: waiting for python thread 1 (/storage/.xbmc/addons/plugin.makemkvbluray/default.py) to stop 22:20:14 T:3016337152 DEBUG: python thread 1 (/storage/.xbmc/addons/plugin.makemkvbluray/default.py) destructed 22:20:14 T:3016337152 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 22:20:14 T:2862693184 DEBUG: Thread Background Loader 2862693184 terminating 22:20:14 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:20:14 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:20:14 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:20:15 T:3016337152 DEBUG: LIRC: Update - NEW at 15138:6c 0 KEY_DOWN devinput (KEY_DOWN) 22:20:15 T:3016337152 DEBUG: OnKey: 167 (a7) pressed, action is Down 22:20:15 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:20:15 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:20:15 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:20:16 T:3016337152 DEBUG: LIRC: Update - NEW at 15609:6c 0 KEY_DOWN_UP devinput (KEY_DOWN_UP) 22:20:16 T:3016337152 DEBUG: LIRC: Update - NEW at 15650:160 0 KEY_OK devinput (KEY_OK) 22:20:16 T:3016337152 DEBUG: OnKey: 11 (0b) pressed, action is Select 22:20:16 T:3016337152 DEBUG: OnPlayMedia plugin://plugin.makemkvbluray/?mode=1&autoplay=True 22:20:16 T:3016337152 DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc 22:20:16 T:3016337152 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnClear 22:20:16 T:3016337152 DEBUG: CAnnouncementManager - Announcement: OnAdd from xbmc 22:20:16 T:3016337152 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnAdd 22:20:16 T:3016337152 DEBUG: StartScript - calling plugin BluRay Player with MakeMKV('plugin://plugin.makemkvbluray/','0','?mode=1&autoplay=True') 22:20:16 T:3016337152 INFO: initializing python engine. 22:20:16 T:3016337152 DEBUG: new python thread created. id=2 22:20:16 T:3016337152 DEBUG: WaitOnScriptResult - waiting on the BluRay Player with MakeMKV (id=2) plugin... 22:20:16 T:2862693184 NOTICE: Thread XBPyThread start, auto delete: false 22:20:16 T:2862693184 DEBUG: Python thread: start processing 22:20:16 T:2862693184 NOTICE: -->Python Interpreter Initialized<-- 22:20:16 T:2862693184 DEBUG: Process - The source file to load is /storage/.xbmc/addons/plugin.makemkvbluray/default.py 22:20:16 T:2862693184 DEBUG: Process - Setting the Python path to /storage/.xbmc/addons/plugin.makemkvbluray:/usr/share/xbmc/addons/weather.wunderground/resources/lib/wunderground:/usr/share/xbmc/addons/script.module.pil/lib:/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: 22:20:16 T:2862693184 DEBUG: Process - Entering source directory /storage/.xbmc/addons/plugin.makemkvbluray 22:20:16 T:2862693184 DEBUG: Instantiating addon using automatically obtained id of "plugin.makemkvbluray" dependent on version 1.0 of the xbmc.python api 22:20:16 T:2862693184 NOTICE: [BR 1] Starting the BluRay script 22:20:16 T:2862693184 NOTICE: [BR 1] Staring 22:20:16 T:2862693184 NOTICE: [BR-settings 1] reading settings 22:20:16 T:2862693184 NOTICE: [BR-settings 1] raw param string: ?mode=1&autoplay=True 22:20:16 T:2862693184 NOTICE: [BR 1] mode: 1 22:20:16 T:2862693184 NOTICE: [BR 1] Entering Disc mode 22:20:16 T:2862693184 NOTICE: [BR 1] Staring 22:20:16 T:2862693184 NOTICE: [BR-settings 1] reading settings 22:20:16 T:2862693184 NOTICE: [BR-settings 1] raw param string: ?mode=1&autoplay=True 22:20:16 T:2862693184 NOTICE: [BR 1] "makemkvcon" stream disc:0 22:20:16 T:2862693184 DEBUG: LocalizeStrings: no strings.po file exist at /storage/.xbmc/addons/plugin.makemkvbluray/resources/language/english, fallback to strings.xml 22:20:16 T:2862693184 DEBUG: DialogProgress::StartModal called 22:20:16 T:2862693184 DEBUG: ------ Window Init (DialogProgress.xml) ------ 22:20:16 T:2862693184 INFO: Loading skin file: DialogProgress.xml, load type: KEEP_IN_MEMORY 22:20:16 T:2862693184 NOTICE: [BR 1] Running makemkvcon locally 22:20:16 T:2862693184 NOTICE: [BR 1] attempting linux kill of makemkvcon 22:20:16 T:3016337152 DEBUG: LIRC: Update - NEW at 15944:160 0 KEY_OK_UP devinput (KEY_OK_UP) 22:20:16 T:2862693184 NOTICE: [BR 1] Linux call successful 22:20:16 T:2862693184 NOTICE: [BR 1] attempting windows kill of makemkvcon 22:20:16 T:2862693184 NOTICE: [BR 1] Windows call successful 22:20:16 T:2862693184 NOTICE: [BR 1] "makemkvcon" stream disc:0 22:20:16 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:20:16 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:20:16 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:20:17 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:20:17 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:20:17 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:20:18 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:20:18 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:20:18 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:20:19 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:20:19 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:20:19 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:20:20 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:20:20 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:20:20 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:20:22 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:20:22 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:20:22 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:20:23 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:20:23 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:20:23 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:20:24 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:20:24 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:20:24 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:20:25 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:20:25 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:20:25 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:20:26 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:20:26 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:20:26 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:20:27 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:20:27 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:20:27 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:20:28 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:20:28 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:20:28 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:20:29 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:20:29 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:20:29 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:20:30 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:20:30 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:20:30 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:20:31 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:20:31 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:20:31 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:20:32 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:20:32 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:20:32 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:20:33 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:20:33 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:20:33 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:20:34 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:20:34 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:20:34 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:20:35 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:20:35 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:20:35 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:20:36 T:3016337152 INFO: CheckIdle - Closing session to http://openelec.tv (easy=0xad300eb0, multi=0xad3096b0) 22:20:36 T:3016337152 INFO: CheckIdle - Closing session to http://mirrors.xbmc.org (easy=0xbe55440, multi=0xbdf7ad8) 22:20:36 T:3016337152 INFO: CheckIdle - Closing session to http://feeds.feedburner.com (easy=0xad379b28, multi=0xad300950) 22:20:36 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:20:36 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:20:36 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:20:37 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:20:37 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:20:37 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:20:38 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:20:38 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:20:38 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:20:39 T:3016337152 INFO: CheckIdle - Closing session to http://addons.openelec.tv (easy=0xbda1360, multi=0xbe5e4b0) 22:20:39 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:20:39 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:20:39 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:20:40 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:20:40 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:20:40 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:20:41 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:20:41 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:20:41 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:20:42 T:2905602880 DEBUG: Addon plugin.audio.hvsc requires script.module.pysqlite version 2.5.6 which is not available 22:20:42 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:20:42 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:20:42 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:20:43 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:20:43 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:20:43 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:20:44 T:2981096256 DEBUG: Thread Jobworker 2981096256 terminating (autodelete) 22:20:44 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:20:44 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:20:44 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:20:45 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:20:45 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:20:45 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:20:46 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:20:46 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:20:46 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:20:47 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:20:47 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:20:47 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:20:49 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:20:49 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:20:49 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:20:50 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:20:50 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:20:50 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:20:51 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:20:51 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:20:51 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:20:52 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:20:52 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:20:52 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:20:53 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:20:53 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:20:53 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:20:54 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:20:54 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:20:54 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:20:55 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:20:55 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:20:55 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:20:56 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:20:56 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:20:56 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:20:57 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:20:57 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:20:57 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:20:57 T:2905602880 INFO: ADDON: cpluff: 'Could not read plug-in directory /usr/lib/xbmc/addons: No such file or directory' 22:20:57 T:2905602880 DEBUG: ADDON: cpluff: 'Not all directories were successfully scanned.' 22:20:57 T:3016337152 DEBUG: CGUIMediaWindow::GetDirectory (plugin://plugin.makemkvbluray/) 22:20:57 T:3016337152 DEBUG: ParentPath = [plugin://plugin.makemkvbluray/] 22:20:57 T:2905602880 DEBUG: StartScript - calling plugin BluRay Player with MakeMKV('plugin://plugin.makemkvbluray/','1','') 22:20:57 T:2905602880 INFO: initializing python engine. 22:20:57 T:2905602880 DEBUG: new python thread created. id=3 22:20:57 T:2905602880 DEBUG: WaitOnScriptResult - waiting on the BluRay Player with MakeMKV (id=3) plugin... 22:20:57 T:2981096256 NOTICE: Thread XBPyThread start, auto delete: false 22:20:57 T:2981096256 DEBUG: Python thread: start processing 22:20:57 T:2981096256 NOTICE: -->Python Interpreter Initialized<-- 22:20:57 T:2981096256 DEBUG: Process - The source file to load is /storage/.xbmc/addons/plugin.makemkvbluray/default.py 22:20:57 T:2981096256 DEBUG: Process - Setting the Python path to /storage/.xbmc/addons/plugin.makemkvbluray:/usr/share/xbmc/addons/weather.wunderground/resources/lib/wunderground:/usr/share/xbmc/addons/script.module.pil/lib:/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: 22:20:57 T:2981096256 DEBUG: Process - Entering source directory /storage/.xbmc/addons/plugin.makemkvbluray 22:20:57 T:2981096256 DEBUG: Instantiating addon using automatically obtained id of "plugin.makemkvbluray" dependent on version 1.0 of the xbmc.python api 22:20:57 T:2981096256 NOTICE: [BR 1] Starting the BluRay script 22:20:57 T:2981096256 NOTICE: [BR 1] Staring 22:20:57 T:2981096256 NOTICE: [BR-settings 1] reading settings 22:20:57 T:2981096256 NOTICE: [BR-settings 1] raw param string: 22:20:57 T:2981096256 NOTICE: [BR 1] mode: None 22:20:57 T:2981096256 NOTICE: [BR 1] Showing categories 22:20:57 T:2981096256 DEBUG: LocalizeStrings: no strings.po file exist at /storage/.xbmc/addons/plugin.makemkvbluray/resources/language/english, fallback to strings.xml 22:20:57 T:2981096256 NOTICE: [BR 1] plugin://plugin.makemkvbluray/?mode=1&autoplay=True 22:20:57 T:2981096256 NOTICE: [BR 1] Play Disc 22:20:57 T:2981096256 NOTICE: [BR 1] plugin://plugin.makemkvbluray/?mode=1&autoplay=False 22:20:57 T:2981096256 NOTICE: [BR 1] Browse Disc 22:20:57 T:2981096256 NOTICE: [BR 1] plugin://plugin.makemkvbluray/?mode=2&autoplay=True 22:20:57 T:2981096256 NOTICE: [BR 1] Play Filelocation 22:20:57 T:2981096256 NOTICE: [BR 1] plugin://plugin.makemkvbluray/?mode=2&autoplay=False 22:20:57 T:2981096256 NOTICE: [BR 1] Browse Filelocation 22:20:57 T:2981096256 NOTICE: [BR 1] plugin://plugin.makemkvbluray/?mode=3&autoplay=True 22:20:57 T:2981096256 NOTICE: [BR 1] Play Remote location 22:20:57 T:2981096256 NOTICE: [BR 1] plugin://plugin.makemkvbluray/?mode=3&autoplay=False 22:20:57 T:2981096256 NOTICE: [BR 1] Browse Remote location 22:20:57 T:2981096256 NOTICE: [BR 1] plugin://plugin.makemkvbluray/?mode=20&autoplay=True 22:20:57 T:2981096256 NOTICE: [BR 1] Settings 22:20:57 T:2905602880 DEBUG: WaitOnScriptResult- plugin returned successfully 22:20:57 T:2981096256 NOTICE: [BR 1] Showing categories done 22:20:57 T:2981096256 ERROR: EndOfDirectory - called with an invalid handle. 22:20:57 T:2981096256 INFO: Scriptresult: Success 22:20:57 T:2854300480 NOTICE: Thread Background Loader start, auto delete: false 22:20:57 T:2981096256 INFO: Python script stopped 22:20:57 T:2981096256 DEBUG: Thread XBPyThread 2981096256 terminating 22:20:57 T:3016337152 DEBUG: waiting for python thread 3 (/storage/.xbmc/addons/plugin.makemkvbluray/default.py) to stop 22:20:57 T:3016337152 DEBUG: python thread 3 (/storage/.xbmc/addons/plugin.makemkvbluray/default.py) destructed 22:20:57 T:2854300480 DEBUG: Thread Background Loader 2854300480 terminating 22:20:58 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:20:58 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:20:58 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:20:59 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:20:59 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:20:59 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:21:00 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:21:00 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:21:00 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:21:01 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:21:01 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:21:01 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:21:02 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:21:02 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:21:02 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:21:03 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:21:03 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:21:03 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:21:04 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:21:04 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:21:04 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:21:05 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:21:05 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:21:05 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:21:06 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:21:06 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:21:06 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:21:07 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:21:07 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:21:07 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:21:08 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:21:08 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:21:08 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:21:09 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:21:09 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:21:09 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:21:10 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:21:10 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:21:10 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:21:11 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:21:11 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:21:11 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:21:12 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:21:12 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:21:12 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:21:14 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:21:14 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:21:14 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:21:15 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:21:15 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:21:15 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:21:16 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:21:16 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:21:16 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:21:17 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:21:17 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:21:17 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:21:18 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:21:18 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:21:18 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:21:19 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:21:19 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:21:19 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:21:20 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:21:20 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:21:20 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:21:21 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:21:21 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:21:21 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:21:22 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:21:22 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:21:22 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:21:23 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:21:23 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:21:23 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:21:24 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:21:24 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:21:24 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:21:25 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:21:25 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:21:25 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:21:26 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:21:26 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:21:26 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:21:27 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:21:27 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:21:27 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:21:27 T:2905602880 DEBUG: Thread Jobworker 2905602880 terminating (autodelete) 22:21:28 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:21:28 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:21:28 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:21:29 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:21:29 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:21:29 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:21:30 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:21:30 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:21:30 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:21:31 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:21:31 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:21:31 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:21:32 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:21:32 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:21:32 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:21:33 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:21:33 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:21:33 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:21:34 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:21:34 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:21:34 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:21:35 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:21:35 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:21:35 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:21:36 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:21:36 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:21:36 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:21:37 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:21:37 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:21:37 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:21:38 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:21:38 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:21:38 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:21:39 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:21:39 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:21:39 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:21:40 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:21:40 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:21:40 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:21:41 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:21:41 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:21:41 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:21:42 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:21:42 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:21:42 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:21:43 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:21:43 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:21:44 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:21:45 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:21:45 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:21:45 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:21:46 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:21:46 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:21:46 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:21:47 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:21:47 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:21:47 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:21:48 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:21:48 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:21:48 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:21:49 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:21:49 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:21:49 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:21:50 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:21:50 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:21:50 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:21:51 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:21:51 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:21:51 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:21:52 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:21:52 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:21:52 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:21:53 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:21:53 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:21:53 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:21:54 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:21:54 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:21:54 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:21:55 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:21:55 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:21:55 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:21:56 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:21:56 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:21:56 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:21:57 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:21:57 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:21:57 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:21:58 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:21:58 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:21:58 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:21:59 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:21:59 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:21:59 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:22:00 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:22:00 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:22:00 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:22:01 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:22:01 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:22:01 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:22:02 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:22:02 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:22:02 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:22:03 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:22:03 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:22:03 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:22:04 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:22:04 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:22:04 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:22:05 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:22:05 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:22:05 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:22:06 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:22:06 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:22:06 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:22:07 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:22:07 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:22:07 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:22:08 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:22:08 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:22:08 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:22:09 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:22:09 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:22:09 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:22:10 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:22:10 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:22:10 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:22:11 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:22:11 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:22:11 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:22:12 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:22:12 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:22:12 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:22:13 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:22:13 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:22:13 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:22:14 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:22:14 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:22:14 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:22:15 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:22:15 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:22:15 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:22:16 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:22:16 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:22:16 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:22:17 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:22:17 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:22:17 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:22:17 T:2862693184 INFO: Scriptresult: Success 22:22:17 T:2862693184 INFO: Python script stopped 22:22:17 T:2862693184 DEBUG: Thread XBPyThread 2862693184 terminating 22:22:17 T:3016337152 DEBUG: WaitOnScriptResult - plugin exited prematurely - terminating 22:22:17 T:3016337152 ERROR: Playlist Player: skipping unplayable item: 0, path [plugin://plugin.makemkvbluray/?mode=1&autoplay=True] 22:22:17 T:3016337152 DEBUG: Playlist Player: one or more items failed to play... aborting playback 22:22:17 T:3016337152 DEBUG: ------ Window Init (DialogOK.xml) ------ 22:22:17 T:3016337152 INFO: Loading skin file: DialogOK.xml, load type: KEEP_IN_MEMORY 22:22:18 T:3016337152 DEBUG: waiting for python thread 2 (/storage/.xbmc/addons/plugin.makemkvbluray/default.py) to stop 22:22:18 T:3016337152 DEBUG: python thread 2 (/storage/.xbmc/addons/plugin.makemkvbluray/default.py) destructed 22:22:18 T:3016337152 DEBUG: ------ Window Deinit (DialogProgress.xml) ------ 22:22:18 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:22:18 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:22:18 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:22:19 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:22:19 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:22:19 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:22:20 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:22:20 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:22:20 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:22:21 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:22:21 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:22:21 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:22:22 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:22:22 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:22:22 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:22:23 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:22:23 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:22:23 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:22:24 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:22:24 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:22:24 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:22:25 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:22:25 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:22:25 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:22:26 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:22:26 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:22:26 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:22:27 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:22:27 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:22:27 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:22:28 T:3016337152 INFO: Python, unloading python shared library because no scripts are running anymore 22:22:28 T:3016337152 DEBUG: UnloadExtensionLibs, clearing python extension libraries 22:22:28 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:22:28 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:22:28 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:22:29 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:22:29 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:22:30 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:22:31 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:22:31 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:22:31 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:22:32 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:22:32 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:22:32 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:22:33 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:22:33 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:22:33 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:22:34 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:22:34 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:22:34 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:22:35 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:22:35 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:22:35 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:22:36 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:22:36 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:22:36 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:22:37 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:22:37 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:22:37 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:22:38 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:22:38 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:22:38 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:22:39 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:22:39 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:22:39 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:22:40 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:22:40 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:22:40 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:22:41 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:22:41 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:22:41 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:22:42 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:22:42 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:22:42 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:22:43 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:22:43 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:22:43 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:22:44 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:22:44 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:22:44 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:22:45 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:22:45 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:22:45 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:22:47 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:22:47 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:22:47 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:22:48 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:22:48 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:22:48 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:22:49 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:22:49 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:22:49 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:22:50 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:22:50 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:22:50 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:22:51 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:22:51 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:22:51 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:22:52 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:22:52 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:22:52 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:22:53 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:22:53 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:22:53 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:22:54 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:22:54 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:22:54 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:22:55 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:22:55 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:22:55 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:22:56 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:22:56 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:22:56 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:22:57 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:22:57 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:22:57 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:22:58 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:22:58 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:22:58 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:22:59 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:22:59 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:22:59 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:23:00 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:23:00 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:23:00 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:23:01 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:23:01 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:23:01 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:23:02 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:23:02 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:23:02 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:23:03 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:23:03 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:23:03 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:23:04 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:23:04 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:23:04 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:23:05 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:23:05 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:23:05 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:23:06 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:23:06 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:23:07 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:23:08 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:23:08 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:23:08 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:23:09 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:23:09 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:23:09 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:23:10 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:23:10 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:23:10 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:23:11 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:23:11 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:23:11 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:23:12 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:23:12 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:23:12 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:23:13 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:23:13 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:23:13 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:23:14 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:23:14 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:23:14 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:23:15 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:23:15 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:23:15 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:23:16 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:23:16 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:23:16 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:23:16 T:3016337152 DEBUG: CAnnouncementManager - Announcement: OnScreensaverActivated from xbmc 22:23:16 T:3016337152 DEBUG: GOT ANNOUNCEMENT, type: 4, from xbmc, message OnScreensaverActivated 22:23:16 T:3016337152 DEBUG: ------ Window Init () ------ 22:23:17 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:23:17 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:23:17 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:23:18 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:23:18 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:23:18 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:23:19 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:23:19 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:23:19 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:23:20 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:23:20 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:23:20 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:23:21 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:23:21 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:23:21 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:23:22 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:23:22 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:23:22 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:23:23 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:23:23 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:23:23 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:23:24 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:23:24 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:23:24 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:23:25 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:23:25 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:23:25 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:23:26 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:23:26 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:23:26 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:23:27 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:23:27 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:23:27 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:23:28 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:23:28 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:23:28 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:23:29 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:23:29 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:23:29 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:23:30 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:23:30 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:23:30 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:23:31 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:23:31 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:23:31 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:23:32 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:23:32 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:23:33 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:23:34 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:23:34 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:23:34 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:23:35 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:23:35 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:23:35 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:23:36 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:23:36 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:23:36 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:23:37 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:23:37 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:23:37 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:23:38 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:23:38 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:23:38 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:23:39 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:23:39 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:23:39 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:23:40 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:23:40 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:23:40 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:23:41 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:23:41 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:23:41 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:23:42 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:23:42 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:23:42 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:23:43 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:23:43 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:23:43 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:23:44 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:23:44 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:23:44 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:23:45 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:23:45 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:23:45 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:23:46 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:23:46 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:23:46 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:23:47 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:23:47 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:23:47 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:23:48 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:23:48 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:23:48 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:23:49 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:23:49 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:23:49 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:23:50 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:23:50 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:23:50 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:23:51 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:23:51 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:23:51 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:23:52 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:23:52 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:23:52 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:23:53 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:23:53 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:23:53 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:23:54 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:23:54 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:23:54 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:23:55 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:23:55 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:23:55 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:23:56 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:23:56 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:23:56 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:23:57 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:23:57 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:23:57 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:23:58 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:23:58 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:23:58 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:23:59 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:23:59 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:23:59 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:24:00 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:24:00 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:24:00 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:24:01 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:24:01 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:24:01 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:24:02 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:24:02 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:24:02 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:24:03 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:24:03 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:24:03 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:24:04 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:24:04 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:24:04 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:24:05 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:24:05 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:24:05 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:24:06 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:24:06 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:24:06 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:24:07 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:24:07 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:24:07 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:24:08 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:24:08 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:24:08 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:24:09 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:24:09 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:24:09 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:24:10 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:24:10 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:24:10 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:24:11 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:24:11 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:24:11 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:24:12 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:24:12 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:24:12 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:24:13 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:24:13 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:24:13 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:24:14 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:24:14 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:24:14 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:24:15 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:24:15 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:24:15 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:24:16 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:24:16 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:24:16 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:24:17 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:24:17 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:24:17 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:24:18 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:24:18 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:24:18 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:24:19 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:24:19 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:24:19 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:24:20 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:24:20 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:24:20 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:24:21 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:24:21 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:24:21 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:24:22 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:24:22 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:24:22 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:24:23 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:24:23 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:24:23 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:24:24 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:24:24 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:24:24 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:24:25 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:24:25 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:24:25 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:24:26 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:24:26 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:24:26 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:24:27 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:24:27 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:24:27 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:24:28 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:24:28 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:24:29 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:24:30 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:24:30 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:24:30 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:24:31 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:24:31 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:24:31 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:24:32 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:24:32 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:24:32 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:24:33 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:24:33 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:24:33 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:24:34 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:24:34 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:24:34 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:24:35 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:24:35 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:24:35 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:24:36 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:24:36 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:24:36 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers 22:24:37 T:2953829184 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers 22:24:37 T:2953829184 DEBUG: JSONRPC: Incoming request: {"jsonrpc":"2.0","method":"Player.GetActivePlayers","id":1} 22:24:37 T:2953829184 DEBUG: JSONRPC: Calling player.getactiveplayers