JustPaste.it - Share Text & Images the Easy Way

15:07:55 T:1689332336 NOTICE: special://profile/ is mapped to: special://masterprofile/
15:07:55 T:1689332336 NOTICE: -----------------------------------------------------------------------
15:07:55 T:1689332336 NOTICE: Starting XBMC (13.1-BETA1 Git:20140511-692cfba). Platform: ARM Android 32-bit
15:07:55 T:1689332336 NOTICE: Using Debug XBMC x32 build, compiled May 11 2014 by GCC 4.8.0 for ARM Android 32-bit API level 14
15:07:55 T:1689332336 NOTICE: Running on Android 32-bit API level 16 (Android, 3.1.10-g64212a6 armv7l)
15:07:55 T:1689332336 NOTICE: Host CPU: ARMv7 Processor rev 9 (v7l), 4 cores available
15:07:55 T:1689332336 NOTICE: Product: ouya_1_1, Device: ouya_1_1, Board: unknown - Manufacturer: OUYA, Brand: OUYA, Model: OUYA Console, Hardware: cardhu
15:07:55 T:1689332336 NOTICE: ARM Features: Neon enabled
15:07:55 T:1689332336 NOTICE: special://xbmc/ is mapped to: /data/data/org.xbmc.xbmc/cache/apk/assets
15:07:55 T:1689332336 NOTICE: special://xbmcbin/ is mapped to: /data/data/org.xbmc.xbmc/cache/apk/assets
15:07:55 T:1689332336 NOTICE: special://masterprofile/ is mapped to: /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/userdata
15:07:55 T:1689332336 NOTICE: special://home/ is mapped to: /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc
15:07:55 T:1689332336 NOTICE: special://temp/ is mapped to: /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/temp
15:07:55 T:1689332336 NOTICE: The executable running is: /system/bin/app_process
15:07:55 T:1689332336 NOTICE: Local hostname: localhost
15:07:55 T:1689332336 NOTICE: Log File is located: /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/temp/xbmc.log
15:07:55 T:1689332336 NOTICE: -----------------------------------------------------------------------
15:07:55 T:1689332336 NOTICE: load settings...
15:07:55 T:1689332336 DEBUG: static int CAndroidFeatures::GetVersion(): android.os.Build.VERSION 16
15:07:55 T:1689332336 DEBUG: CSettings: loaded settings definition from special://xbmc/system/settings/settings.xml
15:07:56 T:1689332336 DEBUG: CSettings: loaded settings definition from special://xbmc/system/settings/android.xml
15:07:56 T:1689332336 NOTICE: Found 1 Lists of Devices
15:07:56 T:1689332336 NOTICE: Enumerated AUDIOTRACK devices:
15:07:56 T:1689332336 NOTICE: Device 1
15:07:56 T:1689332336 NOTICE: m_deviceName : AudioTrack
15:07:56 T:1689332336 NOTICE: m_displayName : android
15:07:56 T:1689332336 NOTICE: m_displayNameExtra: audiotrack
15:07:56 T:1689332336 NOTICE: m_deviceType : AE_DEVTYPE_HDMI
15:07:56 T:1689332336 NOTICE: m_channels : FL,FR
15:07:56 T:1689332336 NOTICE: m_sampleRates : 48000
15:07:56 T:1689332336 NOTICE: m_dataFormats : AE_FMT_S16LE,AE_FMT_AC3,AE_FMT_DTS
15:07:56 T:1689332336 NOTICE: No settings file to load (special://xbmc/system/advancedsettings.xml)
15:07:56 T:1689332336 NOTICE: No settings file to load (special://masterprofile/advancedsettings.xml)
15:07:56 T:1689332336 NOTICE: Default DVD Player: dvdplayer
15:07:56 T:1689332336 NOTICE: Default Video Player: dvdplayer
15:07:56 T:1689332336 NOTICE: Default Audio Player: paplayer
15:07:56 T:1689332336 NOTICE: Disabled debug logging due to GUI setting. Level 0.
15:07:56 T:1689332336 NOTICE: Log level changed to 0
15:07:56 T:1689332336 NOTICE: CMediaSourceSettings: loading media sources from special://masterprofile/sources.xml
15:07:56 T:1689332336 NOTICE: Loading player core factory settings from special://xbmc/system/playercorefactory.xml.
15:07:56 T:1689332336 DEBUG: CPlayerCoreConfig::<ctor>: created player DVDPlayer for core 1
15:07:56 T:1689332336 DEBUG: CPlayerCoreConfig::<ctor>: created player oldmplayercore for core 1
15:07:56 T:1689332336 DEBUG: CPlayerCoreConfig::<ctor>: created player PAPlayer for core 3
15:07:56 T:1689332336 DEBUG: CPlayerSelectionRule::Initialize: creating rule: system rules
15:07:56 T:1689332336 DEBUG: CPlayerSelectionRule::Initialize: creating rule: rtv
15:07:56 T:1689332336 DEBUG: CPlayerSelectionRule::Initialize: creating rule: hdhomerun/myth/mms/udp
15:07:56 T:1689332336 DEBUG: CPlayerSelectionRule::Initialize: creating rule: lastfm/shout
15:07:56 T:1689332336 DEBUG: CPlayerSelectionRule::Initialize: creating rule: rtmp
15:07:56 T:1689332336 DEBUG: CPlayerSelectionRule::Initialize: creating rule: rtsp
15:07:56 T:1689332336 DEBUG: CPlayerSelectionRule::Initialize: creating rule: streams
15:07:56 T:1689332336 DEBUG: CPlayerSelectionRule::Initialize: creating rule: aacp/sdp
15:07:56 T:1689332336 DEBUG: CPlayerSelectionRule::Initialize: creating rule: mp2
15:07:56 T:1689332336 DEBUG: CPlayerSelectionRule::Initialize: creating rule: dvd
15:07:56 T:1689332336 DEBUG: CPlayerSelectionRule::Initialize: creating rule: dvdimage
15:07:56 T:1689332336 DEBUG: CPlayerSelectionRule::Initialize: creating rule: sdp/asf
15:07:56 T:1689332336 DEBUG: CPlayerSelectionRule::Initialize: creating rule: nsv
15:07:56 T:1689332336 DEBUG: CPlayerSelectionRule::Initialize: creating rule: radio
15:07:56 T:1689332336 NOTICE: Loaded playercorefactory configuration
15:07:56 T:1689332336 NOTICE: Loading player core factory settings from special://masterprofile/playercorefactory.xml.
15:07:56 T:1689332336 NOTICE: special://masterprofile/playercorefactory.xml does not exist. Skipping.
15:07:56 T:1689332336 INFO: creating subdirectories
15:07:56 T:1689332336 INFO: userdata folder: special://masterprofile/
15:07:56 T:1689332336 INFO: recording folder:
15:07:56 T:1689332336 INFO: screenshots folder:
15:07:56 T:1689332336 INFO: load language info file: special://xbmc/language/English/langinfo.xml
15:07:56 T:1689332336 DEBUG: trying to set locale to en_US.UTF-8
15:07:56 T:1689332336 INFO: global locale set to C
15:07:56 T:1689332336 INFO: load English language file, from path: special://xbmc/language/
15:07:56 T:1689332336 DEBUG: POParser: loaded 3162 strings from file /data/data/org.xbmc.xbmc/cache/apk/assets/language/English/strings.po
15:07:56 T:1689332336 DEBUG: SECTION:LoadDLL(libavutil-52-arm.so)
15:07:56 T:1689332336 DEBUG: Loading: /data/data/org.xbmc.xbmc/lib/libavutil-52-arm.so
15:07:56 T:1689332336 DEBUG: SECTION:LoadDLL(libavcodec-54-arm.so)
15:07:56 T:1689332336 DEBUG: Loading: /data/data/org.xbmc.xbmc/lib/libavcodec-54-arm.so
15:07:56 T:1689332336 DEBUG: SECTION:LoadDLL(libavformat-54-arm.so)
15:07:56 T:1689332336 DEBUG: Loading: /data/data/org.xbmc.xbmc/lib/libavformat-54-arm.so
15:07:56 T:1691606544 NOTICE: Thread ActiveAE start, auto delete: false
15:07:56 T:1691927880 NOTICE: Thread AESink start, auto delete: false
15:07:56 T:1691927880 INFO: CActiveAESink::OpenSink - initialize sink
15:07:56 T:1691927880 DEBUG: CActiveAESink::OpenSink - trying to open device AUDIOTRACK:AudioTrack
15:07:56 T:1691927880 DEBUG: CActiveAESink::OpenSink - AUDIOTRACK Initialized:
15:07:56 T:1691927880 DEBUG: Output Device : android
15:07:56 T:1691927880 DEBUG: Sample Rate : 48000
15:07:56 T:1691927880 DEBUG: Sample Format : AE_FMT_S16NE
15:07:56 T:1691927880 DEBUG: Channel Count : 2
15:07:56 T:1691927880 DEBUG: Channel Layout: FL,FR
15:07:56 T:1691927880 DEBUG: Frames : 2048
15:07:56 T:1691927880 DEBUG: Frame Samples : 4096
15:07:56 T:1691927880 DEBUG: Frame Size : 4
15:07:56 T:1691606544 DEBUG: SECTION:LoadDLL(libswresample-0-arm.so)
15:07:56 T:1691606544 DEBUG: Loading: /data/data/org.xbmc.xbmc/lib/libswresample-0-arm.so
15:07:56 T:1689332336 NOTICE: Running database version Addons16
15:07:56 T:1689332336 DEBUG: SECTION:LoadDLL(libcpluff-arm.so)
15:07:56 T:1689332336 DEBUG: Loading: /data/data/org.xbmc.xbmc/lib/libcpluff-arm.so
15:07:56 T:1689332336 NOTICE: ADDONS: Using repository repository.xbmc.org
15:07:56 T:1689332336 NOTICE: ADDONS: Using repository repository.pvr-android.xbmc.org
15:07:56 T:1689332336 DEBUG: bool PERIPHERALS::CPeripherals::LoadMappings() - loaded node "Motorola Nyxboard Hybrid"
15:07:56 T:1689332336 DEBUG: bool PERIPHERALS::CPeripherals::LoadMappings() - loaded node "CEC Adapter"
15:07:56 T:1689332336 DEBUG: bool PERIPHERALS::CPeripherals::LoadMappings() - loaded node "Pulse-Eight CEC Adapter"
15:07:56 T:1689332336 DEBUG: bool PERIPHERALS::CPeripherals::LoadMappings() - loaded node "iMON HID device"
15:07:56 T:1689332336 DEBUG: PERIPHERALS::CPeripheralBusUSB::CPeripheralBusUSB(PERIPHERALS::CPeripherals*) - using libusb peripheral scanning
15:07:56 T:1689332336 DEBUG: SECTION:LoadDLL(libcec.so)
15:07:56 T:1689332336 DEBUG: Loading: libcec.so
15:07:56 T:1689332336 ERROR: Unable to load libcec.so, reason: Symbol not found:
15:07:56 T:1689332336 DEBUG: Dll libcec.so was not found in path
15:07:56 T:1689332336 ERROR: virtual void PERIPHERALS::CPeripherals::Initialise() - failed to initialise bus cec
15:07:56 T:1695545368 NOTICE: Thread PeripBusUSB start, auto delete: false
15:07:56 T:1689332336 NOTICE: virtual bool CWinSystemEGL::InitWindowSystem(): Using EGL Implementation: android
15:07:56 T:1689332336 DEBUG: bool CWinSystemEGL::CreateWindow(RESOLUTION_INFO&): Created surface of size 1920x1080
15:07:56 T:1689332336 NOTICE: Current resolution: 1920x1080 @ 60.00 - Full Screen
15:07:56 T:1689332336 NOTICE: Previous line repeats 1 times.
15:07:56 T:1689332336 NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 60.000000 Hz
15:07:56 T:1689332336 NOTICE: Found (1920x1080@60.000000) at 16, setting to RES_DESKTOP at 16
15:07:56 T:1689332336 NOTICE: Checking resolution 16
15:07:56 T:1689332336 NOTICE: Current resolution: 1920x1080 @ 60.00 - Full Screen
15:07:56 T:1689332336 DEBUG: bool CWinSystemEGL::CreateWindow(RESOLUTION_INFO&): Created surface of size 1920x1080
15:07:56 T:1689332336 NOTICE: GL_VENDOR = NVIDIA Corporation
15:07:56 T:1689332336 NOTICE: GL_RENDERER = NVIDIA Tegra 3
15:07:56 T:1689332336 NOTICE: GL_VERSION = OpenGL ES 2.0 16.05001
15:07:56 T:1689332336 NOTICE: GL_SHADING_LANGUAGE_VERSION = OpenGL ES GLSL 1.00
15:07:56 T:1689332336 DEBUG: GLES: Extension Support Test - GL_NVX_gpu_memory_info NO
15:07:56 T:1689332336 NOTICE: GL_EXTENSIONS = GL_OES_rgb8_rgba8 GL_OES_EGL_sync GL_OES_surfaceless_context GL_OES_fbo_render_mipmap GL_NV_depth_nonlinear GL_NV_draw_path GL_NV_draw_texture GL_NV_texture_npot_2D_mipmap GL_OES_EGL_image GL_OES_EGL_image_external GL_OES_vertex_half_float GL_OES_mapbuffer GL_NV_draw_buffers GL_NV_multiview_draw_buffers GL_EXT_Cg_shader GL_EXT_packed_float GL_OES_texture_half_float GL_EXT_texture_array GL_OES_compressed_ETC1_RGB8_texture GL_EXT_texture_compression_latc GL_NV_texture_compression_latc GL_EXT_texture_compression_dxt1 GL_EXT_texture_compression_s3tc GL_NV_texture_compression_s3tc GL_EXT_texture_filter_anisotropic GL_NV_get_tex_image GL_NV_read_buffer GL_NV_shader_framebuffer_fetch GL_NV_copy_image GL_NV_fbo_color_attachments GL_EXT_bgra GL_EXT_texture_format_BGRA8888 GL_EXT_read_format_bgra GL_EXT_unpack_subimage GL_NV_pack_subimage GL_NV_texture_compression_s3tc_update GL_NV_read_depth GL_NV_read_stencil GL_NV_uniform_buffer_object GL_NV_map_buffer_range GL_EXT_robustness GL_OES_standard_derivatives GL_NV_EGL_stream_consumer_external GL_EXT_separate_shader_objects GL_NV_copy_buffer GL_NV_3dvision_settings GL_EXT_debug_marker GL_EXT_debug_label GL_KHR_debug GL_EXT_texture_storage GL_NV_pixel_buffer_object GL_NV_framebuffer_blit GL_NV_non_square_matrices GL_NV_explicit_attrib_location GL_OES_vertex_array_object GL_NV_smooth_points_lines GL_NV_coverage_sample GL_EXT_occlusion_query_boolean GL_NV_occlusion_query_samples GL_NV_timer_query
15:07:56 T:1689332336 DEBUG: GLES: Extension Support Test - GL_EXT_texture_format_BGRA8888 YES
15:07:56 T:1689332336 DEBUG: GLES: Extension Support Test - GL_IMG_texture_format_BGRA8888 NO
15:07:56 T:1689332336 DEBUG: GLES: Extension Support Test - GL_APPLE_texture_format_BGRA8888 NO
15:07:56 T:1689332336 DEBUG: GL: Vertex Shader compilation log:
15:07:56 T:1689332336 DEBUG: GL: Vertex Shader compiled successfully
15:07:56 T:1689332336 DEBUG: GL: Pixel Shader compilation log:
15:07:56 T:1689332336 DEBUG: GL: Fragment Shader compiled successfully
15:07:56 T:1689332336 DEBUG: GUI Shader [guishader_frag_default.glsl]- Initialise successful : 0x64d9f690
15:07:56 T:1689332336 DEBUG: GL: Vertex Shader compilation log:
15:07:56 T:1689332336 DEBUG: GL: Vertex Shader compiled successfully
15:07:56 T:1689332336 DEBUG: GL: Pixel Shader compilation log:
15:07:56 T:1689332336 DEBUG: GL: Fragment Shader compiled successfully
15:07:56 T:1689332336 DEBUG: GUI Shader [guishader_frag_texture.glsl]- Initialise successful : 0x650fe0b8
15:07:56 T:1689332336 DEBUG: GL: Vertex Shader compilation log:
15:07:56 T:1689332336 DEBUG: GL: Vertex Shader compiled successfully
15:07:56 T:1689332336 DEBUG: GL: Pixel Shader compilation log:
15:07:56 T:1689332336 DEBUG: GL: Fragment Shader compiled successfully
15:07:56 T:1689332336 DEBUG: GUI Shader [guishader_frag_multi.glsl]- Initialise successful : 0x66c68728
15:07:56 T:1689332336 DEBUG: GL: Vertex Shader compilation log:
15:07:56 T:1689332336 DEBUG: GL: Vertex Shader compiled successfully
15:07:56 T:1689332336 DEBUG: GL: Pixel Shader compilation log:
15:07:56 T:1689332336 DEBUG: GL: Fragment Shader compiled successfully
15:07:56 T:1689332336 DEBUG: GUI Shader [guishader_frag_fonts.glsl]- Initialise successful : 0x64da0060
15:07:56 T:1689332336 DEBUG: GL: Vertex Shader compilation log:
15:07:56 T:1689332336 DEBUG: GL: Vertex Shader compiled successfully
15:07:56 T:1689332336 DEBUG: GL: Pixel Shader compilation log:
15:07:56 T:1689332336 DEBUG: GL: Fragment Shader compiled successfully
15:07:56 T:1689332336 DEBUG: GUI Shader [guishader_frag_texture_noblend.glsl]- Initialise successful : 0x66c69e98
15:07:56 T:1689332336 DEBUG: GL: Vertex Shader compilation log:
15:07:56 T:1689332336 DEBUG: GL: Vertex Shader compiled successfully
15:07:56 T:1689332336 DEBUG: GL: Pixel Shader compilation log:
15:07:56 T:1689332336 DEBUG: GL: Fragment Shader compiled successfully
15:07:56 T:1689332336 DEBUG: GUI Shader [guishader_frag_multi_blendcolor.glsl]- Initialise successful : 0x66c69d60
15:07:56 T:1689332336 DEBUG: GL: Vertex Shader compilation log:
15:07:56 T:1689332336 DEBUG: GL: Vertex Shader compiled successfully
15:07:56 T:1689332336 DEBUG: GL: Pixel Shader compilation log:
15:07:56 T:1689332336 DEBUG: GL: Fragment Shader compiled successfully
15:07:56 T:1689332336 DEBUG: GUI Shader [guishader_frag_rgba.glsl]- Initialise successful : 0x66ce9938
15:07:56 T:1689332336 DEBUG: GLES: Extension Support Test - GL_OES_EGL_image_external YES
15:07:56 T:1689332336 DEBUG: GL: Vertex Shader compilation log:
15:07:56 T:1689332336 DEBUG: GL: Vertex Shader compiled successfully
15:07:56 T:1689332336 DEBUG: GL: Pixel Shader compilation log:
15:07:56 T:1689332336 DEBUG: GL: Fragment Shader compiled successfully
15:07:56 T:1689332336 DEBUG: GUI Shader [guishader_frag_rgba_oes.glsl]- Initialise successful : 0x66d01900
15:07:56 T:1689332336 DEBUG: GL: Vertex Shader compilation log:
15:07:56 T:1689332336 DEBUG: GL: Vertex Shader compiled successfully
15:07:56 T:1689332336 DEBUG: GL: Pixel Shader compilation log:
15:07:56 T:1689332336 DEBUG: GL: Fragment Shader compiled successfully
15:07:56 T:1689332336 DEBUG: GUI Shader [guishader_frag_rgba_blendcolor.glsl]- Initialise successful : 0x66d036a0
15:07:56 T:1689332336 NOTICE: Current resolution: 1920x1080 @ 60.00 - Full Screen
15:07:56 T:1689332336 DEBUG: CWinSystemEGL::CreateNewWindow: No need to create a new window
15:07:56 T:1689332336 INFO: GLES: Maximum texture width: 2048
15:07:56 T:1689332336 DEBUG: CRenderManager::UpdateDisplayLatency - Latency set to 0 msec
15:07:56 T:1689332336 INFO: load default splash image: /data/data/org.xbmc.xbmc/cache/apk/assets/media/Splash.png
15:07:56 T:1689332336 DEBUG: SECTION:LoadDLL(libImageLib-arm.so)
15:07:56 T:1689332336 DEBUG: Loading: /data/data/org.xbmc.xbmc/lib/libImageLib-arm.so
15:07:56 T:1689332336 INFO: load keymapping
15:07:56 T:1689332336 INFO: Loading special://xbmc/system/keymaps/appcommand.xml
15:07:56 T:1689332336 INFO: Loading special://xbmc/system/keymaps/gamepad.xml
15:07:56 T:1689332336 INFO: Loading special://xbmc/system/keymaps/joystick.xml
15:07:56 T:1689332336 NOTICE: No Joystick name specified, loading default map
15:07:56 T:1689332336 NOTICE: Previous line repeats 35 times.
15:07:56 T:1689332336 INFO: Loading special://xbmc/system/keymaps/keyboard.xml
15:07:56 T:1689332336 INFO: Loading special://xbmc/system/keymaps/mouse.xml
15:07:56 T:1689332336 INFO: Loading special://xbmc/system/keymaps/remote.xml
15:07:56 T:1689332336 INFO: Loading special://xbmc/system/keymaps/touchscreen.xml
15:07:56 T:1689332336 INFO: GUI format 1920x1080, Display 1920x1080 @ 60.00 - Full Screen
15:07:56 T:1689332336 DEBUG: guilib: Fill viewport on change for solving rendering passes
15:07:56 T:1689332336 DEBUG: SECTION:LoadDLL(libcurl.so)
15:07:56 T:1689332336 DEBUG: Loading: /data/data/org.xbmc.xbmc/lib/libcurl.so
15:07:56 T:1689332336 NOTICE: Running database version Addons16
15:07:56 T:1689332336 DEBUG: void CDatabaseManager::Initialize(bool), updating databases...
15:07:56 T:1689332336 NOTICE: Running database version ViewModes6
15:07:56 T:1689332336 NOTICE: Running database version Textures13
15:07:56 T:1689332336 NOTICE: Running database version MyMusic46
15:07:56 T:1689332336 NOTICE: Running database version MyVideos78
15:07:56 T:1689332336 NOTICE: Running database version TV22
15:07:56 T:1689332336 NOTICE: Running database version Epg7
15:07:56 T:1689332336 DEBUG: void CDatabaseManager::Initialize(bool), updating databases... DONE
15:07:56 T:1689332336 NOTICE: initializing playlistplayer
15:07:56 T:1689332336 NOTICE: DONE initializing playlistplayer
15:07:56 T:1689332336 INFO: DPMS: not supported on this platform
15:07:56 T:1689332336 DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc
15:07:56 T:1689332336 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnClear
15:07:56 T:1689332336 INFO: Unloading old skin ...
15:07:56 T:1689332336 INFO: load skin from: /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/skin.transparency (version: 6.0.6)
15:07:56 T:1689332336 INFO: load fonts for skin...
15:07:56 T:1689332336 INFO: Loading fonts from /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/skin.transparency/720p/Font.xml
15:07:56 T:1689332336 DEBUG: POParser: loaded 151 strings from file /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/skin.transparency/language/English/strings.po
15:07:56 T:1689332336 INFO: Loading skin includes from /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/skin.transparency/720p/includes.xml
15:07:57 T:1689332336 INFO: load new skin...
15:07:57 T:1689332336 INFO: Loading user windows, path /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/skin.transparency/720p
15:07:57 T:1689332336 DEBUG: Load Skin XML: 68.63ms
15:07:57 T:1689332336 INFO: initialize new skin...
15:07:57 T:1689332336 DEBUG: guilib: Fill viewport on change for solving rendering passes
15:07:57 T:1689332336 INFO: Loading skin file: Pointer.xml, load type: LOAD_ON_GUI_INIT
15:07:57 T:1689332336 DEBUG: Load Pointer.xml: 2.79ms
15:07:57 T:1689332336 DEBUG: bool CTextureBundleXBT::OpenBundle() - Opened bundle /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/skin.transparency/media/Textures.xbt
15:07:57 T:1689332336 DEBUG: Alloc resources: 72.04ms (3.01 ms skin load)
15:07:57 T:1689332336 INFO: Loading skin file: DialogVolumeBar.xml, load type: LOAD_ON_GUI_INIT
15:07:57 T:1689332336 DEBUG: Load DialogVolumeBar.xml: 4.30ms
15:07:57 T:1689332336 DEBUG: Alloc resources: 5.05ms (4.55 ms skin load)
15:07:57 T:1689332336 INFO: Loading skin file: DialogKaiToast.xml, load type: LOAD_ON_GUI_INIT
15:07:57 T:1689332336 DEBUG: Load DialogKaiToast.xml: 3.13ms
15:07:57 T:1689332336 DEBUG: Alloc resources: 3.41ms (3.41 ms skin load)
15:07:57 T:1689332336 INFO: Loading skin file: DialogMuteBug.xml, load type: LOAD_ON_GUI_INIT
15:07:57 T:1689332336 DEBUG: Load DialogMuteBug.xml: 3.31ms
15:07:57 T:1689332336 DEBUG: Alloc resources: 3.53ms (3.51 ms skin load)
15:07:57 T:1689332336 INFO: Loading skin file: DialogSeekBar.xml, load type: LOAD_ON_GUI_INIT
15:07:57 T:1689332336 DEBUG: Load DialogSeekBar.xml: 12.56ms
15:07:57 T:1689332336 DEBUG: Alloc resources: 14.51ms (12.86 ms skin load)
15:07:57 T:1689332336 INFO: Loading skin file: DialogBusy.xml, load type: LOAD_ON_GUI_INIT
15:07:57 T:1689332336 DEBUG: Load DialogBusy.xml: 3.15ms
15:07:57 T:1689332336 DEBUG: Alloc resources: 3.47ms (3.43 ms skin load)
15:07:57 T:1689332336 INFO: Loading skin file: DialogExtendedProgressBar.xml, load type: LOAD_ON_GUI_INIT
15:07:57 T:1689332336 DEBUG: Load DialogExtendedProgressBar.xml: 3.23ms
15:07:57 T:1689332336 DEBUG: Alloc resources: 3.50ms (3.47 ms skin load)
15:07:57 T:1689332336 INFO: Loading /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/skin.transparency/sounds/sounds.xml
15:07:57 T:1689332336 INFO: skin loaded...
15:07:57 T:1689332336 DEBUG: JSONRPC: JSON schema type stereoscopicmode references an unknown type GUI.Stereoscopy.Mode
15:07:57 T:1689332336 WARNING: JSONRPC: Could not parse type "GUI.Property.Value"
15:07:57 T:1689332336 INFO: JSONRPC: Adding type "GUI.Property.Value" to list of incomplete definitions (waiting for "GUI.Stereoscopy.Mode")
15:07:57 T:1689332336 INFO: JSONRPC: Resolving incomplete types/methods referencing GUI.Stereoscopy.Mode
15:07:57 T:1689332336 DEBUG: JSONRPC: JSON schema type definition references an unknown type Setting.Details.Setting
15:07:57 T:1689332336 WARNING: JSONRPC: Could not parse type "Setting.Details.SettingList"
15:07:57 T:1689332336 INFO: JSONRPC: Adding type "Setting.Details.SettingList" to list of incomplete definitions (waiting for "Setting.Details.Setting")
15:07:57 T:1689332336 INFO: JSONRPC: Resolving incomplete types/methods referencing Setting.Details.Setting
15:07:57 T:1689332336 INFO: JSONRPC v6.14.3: Successfully initialized
15:07:57 T:1689332336 DEBUG: ADDON: Starting service addons.
15:07:57 T:1817989464 NOTICE: Thread LanguageInvoker start, auto delete: false
15:07:57 T:1817989464 NOTICE: Previous line repeats 1 times.
15:07:57 T:1817989464 INFO: initializing python engine.
15:07:57 T:1817993752 INFO: Previous line repeats 1 times.
15:07:57 T:1817993752 NOTICE: Thread LanguageInvoker start, auto delete: false
15:07:57 T:1817993752 NOTICE: Previous line repeats 1 times.
15:07:57 T:1817993752 INFO: initializing python engine.
15:07:57 T:1823566264 INFO: Previous line repeats 1 times.
15:07:57 T:1823566264 NOTICE: Thread LanguageInvoker start, auto delete: false
15:07:57 T:1823566264 INFO: initializing python engine.
15:07:57 T:1817995128 NOTICE: Thread LanguageInvoker start, auto delete: false
15:07:57 T:1689332336 DEBUG: Activating window ID: 12999
15:07:57 T:1689332336 DEBUG: ------ Window Init (Startup.xml) ------
15:07:57 T:1817995128 INFO: initializing python engine.
15:07:57 T:1817995064 NOTICE: Thread LanguageInvoker start, auto delete: false
15:07:57 T:1820102664 NOTICE: Previous line repeats 1 times.
15:07:57 T:1820102664 INFO: initializing python engine.
15:07:57 T:1689332336 INFO: Previous line repeats 1 times.
15:07:57 T:1689332336 INFO: Loading skin file: Startup.xml, load type: LOAD_EVERY_TIME
15:07:57 T:1689332336 DEBUG: Load Startup.xml: 3.65ms
15:07:57 T:1689332336 DEBUG: Alloc resources: 3.90ms (3.89 ms skin load)
15:07:57 T:1689332336 DEBUG: Activating window ID: 10000
15:07:57 T:1689332336 DEBUG: ------ Window Deinit (Startup.xml) ------
15:07:57 T:1689332336 DEBUG: ------ Window Init (Home.xml) ------
15:07:57 T:1689332336 INFO: Loading skin file: Home.xml, load type: KEEP_IN_MEMORY
15:07:58 T:1817989464 DEBUG: CPythonInvoker(1, /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/service.xbmc.versioncheck/service.py): start processing
15:07:58 T:1817988848 DEBUG: CPythonInvoker(0, /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.cu.lrclyrics/default.py): start processing
15:07:58 T:1817993752 DEBUG: CPythonInvoker(3, /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.simple.downloader/default.py): start processing
15:07:58 T:1817992136 DEBUG: CPythonInvoker(2, /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/service.skin.widgets/default.py): start processing
15:07:58 T:1823566264 DEBUG: CPythonInvoker(5, /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/service.rom.collection.browser/default.py): start processing
15:07:58 T:1817995128 DEBUG: CPythonInvoker(6, /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.cinema.experience/service.py): start processing
15:07:58 T:1817995064 DEBUG: CPythonInvoker(4, /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/service.qlock/default.py): start processing
15:07:58 T:1820102664 DEBUG: CPythonInvoker(7, /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.tv.show.next.aired/service.py): start processing
15:07:58 T:1817989464 NOTICE: -->Python Interpreter Initialized<--
15:07:58 T:1817989464 DEBUG: CPythonInvoker(1, /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/service.xbmc.versioncheck/service.py): the source file to load is /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/service.xbmc.versioncheck/service.py
15:07:58 T:1689332336 DEBUG: Load Home.xml: 255.61ms
15:07:58 T:1689332336 DEBUG: Alloc resources: 258.13ms (256.33 ms skin load)
15:07:58 T:1831374776 NOTICE: Thread JobWorker start, auto delete: true
15:07:58 T:1831374776 DEBUG: CRecentlyAddedJob::UpdateMusic() - Running RecentlyAdded home screen update
15:07:58 T:1689332336 INFO: removing tempfiles
15:07:58 T:1689332336 DEBUG: ADDON: Starting service addons.
15:07:58 T:1814283840 NOTICE: Thread LanguageInvoker start, auto delete: false
15:07:58 T:1689332336 NOTICE: initialize done
15:07:58 T:1689332336 NOTICE: Running the application...
15:07:58 T:1814283840 INFO: initializing python engine.
15:07:58 T:1814283840 DEBUG: CPythonInvoker(8, /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.common.plugin.cache/default.py): start processing
15:07:58 T:1689332336 DEBUG: no profile autoexec.py (/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/userdata/autoexec.py) found, skipping
15:07:58 T:1689332336 DEBUG: void CNetwork::NetworkMessage(CNetwork::EMESSAGE, int) - Starting network services
15:07:58 T:1689332336 NOTICE: starting zeroconf publishing
15:07:58 T:1828503336 NOTICE: Thread ZerocconfEmbedded start, auto delete: false
15:07:58 T:1828503336 DEBUG: ZeroconfEmbedded - processing...
15:07:58 T:1828207136 NOTICE: Thread JobWorker start, auto delete: true
15:07:58 T:1689332336 NOTICE: Webserver: Starting...
15:07:58 T:1689332336 NOTICE: WebServer: Started the webserver
15:07:58 T:1689332336 NOTICE: starting upnp renderer
15:07:58 T:1828207136 DEBUG: ZeroconfMDNS: identifier: servers.webserver type: _http._tcp name:XBMC (localhost) port:8080
15:07:58 T:1828207136 DEBUG: ZeroconfMDNS: identifier: servers.jsonrpc-http type: _xbmc-jsonrpc-h._tcp name:XBMC (localhost) port:8080
15:07:58 T:1831374776 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
15:07:58 T:1831374776 DEBUG: bool CMusicDatabase::GetRecentlyAddedAlbums(VECALBUMS&, unsigned int) query: select * from albumview where strAlbum != '' order by idAlbum desc limit 10
15:07:58 T:1831374776 DEBUG: CRecentlyAddedJob::UpdateVideos() - Running RecentlyAdded home screen update
15:07:58 T:1689332336 NOTICE: ES: Starting event server
15:07:58 T:1827436744 NOTICE: Thread EventServer start, auto delete: false
15:07:58 T:1689332336 INFO: JSONRPC Server: Successfully initialized
15:07:58 T:1828668440 NOTICE: Thread TCPServer start, auto delete: false
15:07:58 T:1689332336 NOTICE: Current resolution: 1920x1080 @ 60.00 - Full Screen
15:07:58 T:1689332336 DEBUG: CWinSystemEGL::CreateNewWindow: No need to create a new window
15:07:58 T:1689332336 NOTICE: GL_VENDOR = NVIDIA Corporation
15:07:58 T:1689332336 NOTICE: GL_RENDERER = NVIDIA Tegra 3
15:07:58 T:1689332336 NOTICE: GL_VERSION = OpenGL ES 2.0 16.05001
15:07:58 T:1689332336 NOTICE: GL_SHADING_LANGUAGE_VERSION = OpenGL ES GLSL 1.00
15:07:58 T:1689332336 DEBUG: GLES: Extension Support Test - GL_NVX_gpu_memory_info NO
15:07:58 T:1689332336 NOTICE: GL_EXTENSIONS = GL_OES_rgb8_rgba8 GL_OES_EGL_sync GL_OES_surfaceless_context GL_OES_fbo_render_mipmap GL_NV_depth_nonlinear GL_NV_draw_path GL_NV_draw_texture GL_NV_texture_npot_2D_mipmap GL_OES_EGL_image GL_OES_EGL_image_external GL_OES_vertex_half_float GL_OES_mapbuffer GL_NV_draw_buffers GL_NV_multiview_draw_buffers GL_EXT_Cg_shader GL_EXT_packed_float GL_OES_texture_half_float GL_EXT_texture_array GL_OES_compressed_ETC1_RGB8_texture GL_EXT_texture_compression_latc GL_NV_texture_compression_latc GL_EXT_texture_compression_dxt1 GL_EXT_texture_compression_s3tc GL_NV_texture_compression_s3tc GL_EXT_texture_filter_anisotropic GL_NV_get_tex_image GL_NV_read_buffer GL_NV_shader_framebuffer_fetch GL_NV_copy_image GL_NV_fbo_color_attachments GL_EXT_bgra GL_EXT_texture_format_BGRA8888 GL_EXT_read_format_bgra GL_EXT_unpack_subimage GL_NV_pack_subimage GL_NV_texture_compression_s3tc_update GL_NV_read_depth GL_NV_read_stencil GL_NV_uniform_buffer_object GL_NV_map_buffer_range GL_EXT_robustness GL_OES_standard_derivatives GL_NV_EGL_stream_consumer_external GL_EXT_separate_shader_objects GL_NV_copy_buffer GL_NV_3dvision_settings GL_EXT_debug_marker GL_EXT_debug_label GL_KHR_debug GL_EXT_texture_storage GL_NV_pixel_buffer_object GL_NV_framebuffer_blit GL_NV_non_square_matrices GL_NV_explicit_attrib_location GL_OES_vertex_array_object GL_NV_smooth_points_lines GL_NV_coverage_sample GL_EXT_occlusion_query_boolean GL_NV_occlusion_query_samples GL_NV_timer_query
15:07:58 T:1689332336 DEBUG: GLES: Extension Support Test - GL_EXT_texture_format_BGRA8888 YES
15:07:58 T:1828207136 DEBUG: ZeroconfMDNS: identifier: servers.jsonrpc-tpc type: _xbmc-jsonrpc._tcp name:XBMC (localhost) port:9090
15:07:58 T:1827436744 NOTICE: ES: Starting UDP Event server on 0.0.0.0:9777
15:07:58 T:1689332336 DEBUG: GLES: Extension Support Test - GL_IMG_texture_format_BGRA8888 NO
15:07:58 T:1827436744 NOTICE: UDP: Listening on port 9777
15:07:58 T:1689332336 DEBUG: GLES: Extension Support Test - GL_APPLE_texture_format_BGRA8888 NO
15:07:58 T:1828207136 DEBUG: ZeroconfMDNS: identifier: servers.eventserver type: _xbmc-events._udp name:XBMC (localhost) port:9777
15:07:58 T:1689332336 DEBUG: GUI Shader - Tried to Initialise again. Was this intentional?
15:07:58 T:1823566264 NOTICE: -->Python Interpreter Initialized<--
15:07:58 T:1823566264 DEBUG: CPythonInvoker(5, /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/service.rom.collection.browser/default.py): the source file to load is /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/service.rom.collection.browser/default.py
15:07:58 T:1817995128 NOTICE: -->Python Interpreter Initialized<--
15:07:58 T:1817995128 DEBUG: CPythonInvoker(6, /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.cinema.experience/service.py): the source file to load is /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.cinema.experience/service.py
15:07:58 T:1817989464 DEBUG: CPythonInvoker(1, /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/service.xbmc.versioncheck/service.py): setting the Python path to /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/service.xbmc.versioncheck:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.chardet/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.simplejson/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.beautifulsoup/lib:/data/data/org.xbmc.xbmc/cache/apk/assets/addons/script.module.pil/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.common.plugin.cache/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.simple.downloader/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.requests/lib:/data/data/org.xbmc.xbmc/cache/apk/assets/addons/xbmc.debug/:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.parsedom/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.requests2/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.elementtree/lib:/:/data/app/org.xbmc.xbmc-1.apk/assets/python2.6/lib/python26.zip:/data/app/org.xbmc.xbmc-1.apk/assets/python2.6/lib/python2.6:/data/app/org.xbmc.xbmc-1.apk/assets/python2.6/lib/python2.6/plat-linux3:/data/app/org.xbmc.xbmc-1.apk/assets/python2.6/lib/python2.6/lib-tk:/data/app/org.xbmc.xbmc-1.apk/assets/python2.6/lib/python2.6/lib-old:/data/app/org.xbmc.xbmc-1.apk/assets/python2.6/lib/python2.6/lib-dynload
15:07:58 T:1817989464 DEBUG: CPythonInvoker(1, /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/service.xbmc.versioncheck/service.py): entering source directory /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/service.xbmc.versioncheck
15:07:58 T:1817988848 NOTICE: -->Python Interpreter Initialized<--
15:07:58 T:1817988848 DEBUG: CPythonInvoker(0, /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.cu.lrclyrics/default.py): the source file to load is /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.cu.lrclyrics/default.py
15:07:58 T:1823566264 DEBUG: CPythonInvoker(5, /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/service.rom.collection.browser/default.py): setting the Python path to /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/service.rom.collection.browser:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.chardet/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.simplejson/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.beautifulsoup/lib:/data/data/org.xbmc.xbmc/cache/apk/assets/addons/script.module.pil/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.common.plugin.cache/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.simple.downloader/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.requests/lib:/data/data/org.xbmc.xbmc/cache/apk/assets/addons/xbmc.debug/:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.parsedom/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.requests2/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.elementtree/lib:/:/data/app/org.xbmc.xbmc-1.apk/assets/python2.6/lib/python26.zip:/data/app/org.xbmc.xbmc-1.apk/assets/python2.6/lib/python2.6:/data/app/org.xbmc.xbmc-1.apk/assets/python2.6/lib/python2.6/plat-linux3:/data/app/org.xbmc.xbmc-1.apk/assets/python2.6/lib/python2.6/lib-tk:/data/app/org.xbmc.xbmc-1.apk/assets/python2.6/lib/python2.6/lib-old:/data/app/org.xbmc.xbmc-1.apk/assets/python2.6/lib/python2.6/lib-dynload
15:07:58 T:1823566264 DEBUG: CPythonInvoker(5, /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/service.rom.collection.browser/default.py): entering source directory /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/service.rom.collection.browser
15:07:58 T:1817993752 NOTICE: -->Python Interpreter Initialized<--
15:07:58 T:1817993752 DEBUG: CPythonInvoker(3, /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.simple.downloader/default.py): the source file to load is /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.simple.downloader/default.py
15:07:58 T:1817989464 DEBUG: CPythonInvoker(1, /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/service.xbmc.versioncheck/service.py): instantiating addon using automatically obtained id of "service.xbmc.versioncheck" dependent on version 2.1.0 of the xbmc.python api
15:07:58 T:1823566264 DEBUG: CPythonInvoker(5, /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/service.rom.collection.browser/default.py): instantiating addon using automatically obtained id of "service.rom.collection.browser" dependent on version 2.1.0 of the xbmc.python api
15:07:58 T:1817995064 NOTICE: -->Python Interpreter Initialized<--
15:07:58 T:1817995064 DEBUG: CPythonInvoker(4, /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/service.qlock/default.py): the source file to load is /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/service.qlock/default.py
15:07:58 T:1817993752 DEBUG: CPythonInvoker(3, /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.simple.downloader/default.py): setting the Python path to /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.simple.downloader:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.chardet/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.simplejson/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.beautifulsoup/lib:/data/data/org.xbmc.xbmc/cache/apk/assets/addons/script.module.pil/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.common.plugin.cache/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.simple.downloader/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.requests/lib:/data/data/org.xbmc.xbmc/cache/apk/assets/addons/xbmc.debug/:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.parsedom/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.requests2/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.elementtree/lib:/:/data/app/org.xbmc.xbmc-1.apk/assets/python2.6/lib/python26.zip:/data/app/org.xbmc.xbmc-1.apk/assets/python2.6/lib/python2.6:/data/app/org.xbmc.xbmc-1.apk/assets/python2.6/lib/python2.6/plat-linux3:/data/app/org.xbmc.xbmc-1.apk/assets/python2.6/lib/python2.6/lib-tk:/data/app/org.xbmc.xbmc-1.apk/assets/python2.6/lib/python2.6/lib-old:/data/app/org.xbmc.xbmc-1.apk/assets/python2.6/lib/python2.6/lib-dynload
15:07:58 T:1817993752 DEBUG: CPythonInvoker(3, /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.simple.downloader/default.py): entering source directory /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.simple.downloader
15:07:58 T:1817993752 DEBUG: CPythonInvoker(3, /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.simple.downloader/default.py): instantiating addon using automatically obtained id of "script.module.simple.downloader" dependent on version 2.1.0 of the xbmc.python api
15:07:58 T:1814283840 NOTICE: -->Python Interpreter Initialized<--
15:07:58 T:1814283840 DEBUG: CPythonInvoker(8, /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.common.plugin.cache/default.py): the source file to load is /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.common.plugin.cache/default.py
15:07:58 T:1689332336 INFO: GLES: Enabling VSYNC
15:07:58 T:1689332336 INFO: GLES: Selected vsync mode 10
15:07:59 T:1828503336 DEBUG: ZeroconfMDNS: XBMC (localhost)._http._tcp.local. registration removed
15:07:59 T:1828503336 DEBUG: ZeroconfMDNS: XBMC (localhost)._xbmc-jsonrpc-h._tcp.local. registration removed
15:07:59 T:1828503336 DEBUG: ZeroconfMDNS: XBMC (localhost)._xbmc-jsonrpc._tcp.local. registration removed
15:07:59 T:1828503336 DEBUG: ZeroconfMDNS: XBMC (localhost)._xbmc-events._udp.local. registration removed
15:08:01 T:1831374776 DEBUG: int CVideoDatabase::RunQuery(const CStdString&) took 2875 ms for 10 items query: select * from movieview ORDER BY dateAdded desc, idMovie desc LIMIT 10
15:08:01 T:1817988848 DEBUG: CPythonInvoker(0, /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.cu.lrclyrics/default.py): setting the Python path to /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.cu.lrclyrics:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.chardet/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.simplejson/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.beautifulsoup/lib:/data/data/org.xbmc.xbmc/cache/apk/assets/addons/script.module.pil/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.common.plugin.cache/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.simple.downloader/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.requests/lib:/data/data/org.xbmc.xbmc/cache/apk/assets/addons/xbmc.debug/:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.parsedom/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.requests2/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.elementtree/lib:/:/data/app/org.xbmc.xbmc-1.apk/assets/python2.6/lib/python26.zip:/data/app/org.xbmc.xbmc-1.apk/assets/python2.6/lib/python2.6:/data/app/org.xbmc.xbmc-1.apk/assets/python2.6/lib/python2.6/plat-linux3:/data/app/org.xbmc.xbmc-1.apk/assets/python2.6/lib/python2.6/lib-tk:/data/app/org.xbmc.xbmc-1.apk/assets/python2.6/lib/python2.6/lib-old:/data/app/org.xbmc.xbmc-1.apk/assets/python2.6/lib/python2.6/lib-dynload
15:08:01 T:1817988848 DEBUG: CPythonInvoker(0, /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.cu.lrclyrics/default.py): entering source directory /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.cu.lrclyrics
15:08:01 T:1823566264 NOTICE: RCB Service: Start
15:08:01 T:1823566264 NOTICE: RCB Service: launch RCB on startup =
15:08:01 T:1823566264 NOTICE: RCB Service: scrape games on startup = false
15:08:01 T:1823566264 NOTICE: RCB Service: Done
15:08:01 T:1823566264 INFO: CPythonInvoker(5, /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/service.rom.collection.browser/default.py): script successfully run
15:08:01 T:1817988848 DEBUG: CPythonInvoker(0, /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.cu.lrclyrics/default.py): instantiating addon using automatically obtained id of "script.cu.lrclyrics" dependent on version 2.12.0 of the xbmc.python api
15:08:01 T:1823566264 INFO: Python script stopped
15:08:01 T:1823566264 DEBUG: Thread LanguageInvoker 1823566264 terminating
15:08:01 T:1817995128 DEBUG: CPythonInvoker(6, /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.cinema.experience/service.py): setting the Python path to /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.cinema.experience:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.chardet/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.simplejson/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.beautifulsoup/lib:/data/data/org.xbmc.xbmc/cache/apk/assets/addons/script.module.pil/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.common.plugin.cache/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.simple.downloader/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.requests/lib:/data/data/org.xbmc.xbmc/cache/apk/assets/addons/xbmc.debug/:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.parsedom/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.requests2/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.elementtree/lib:/:/data/app/org.xbmc.xbmc-1.apk/assets/python2.6/lib/python26.zip:/data/app/org.xbmc.xbmc-1.apk/assets/python2.6/lib/python2.6:/data/app/org.xbmc.xbmc-1.apk/assets/python2.6/lib/python2.6/plat-linux3:/data/app/org.xbmc.xbmc-1.apk/assets/python2.6/lib/python2.6/lib-tk:/data/app/org.xbmc.xbmc-1.apk/assets/python2.6/lib/python2.6/lib-old:/data/app/org.xbmc.xbmc-1.apk/assets/python2.6/lib/python2.6/lib-dynload
15:08:01 T:1817995128 DEBUG: CPythonInvoker(6, /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.cinema.experience/service.py): entering source directory /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.cinema.experience
15:08:01 T:1814283840 DEBUG: CPythonInvoker(8, /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.common.plugin.cache/default.py): setting the Python path to /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.common.plugin.cache:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.chardet/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.simplejson/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.beautifulsoup/lib:/data/data/org.xbmc.xbmc/cache/apk/assets/addons/script.module.pil/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.common.plugin.cache/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.simple.downloader/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.requests/lib:/data/data/org.xbmc.xbmc/cache/apk/assets/addons/xbmc.debug/:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.parsedom/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.requests2/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.elementtree/lib:/:/data/app/org.xbmc.xbmc-1.apk/assets/python2.6/lib/python26.zip:/data/app/org.xbmc.xbmc-1.apk/assets/python2.6/lib/python2.6:/data/app/org.xbmc.xbmc-1.apk/assets/python2.6/lib/python2.6/plat-linux3:/data/app/org.xbmc.xbmc-1.apk/assets/python2.6/lib/python2.6/lib-tk:/data/app/org.xbmc.xbmc-1.apk/assets/python2.6/lib/python2.6/lib-old:/data/app/org.xbmc.xbmc-1.apk/assets/python2.6/lib/python2.6/lib-dynload
15:08:01 T:1814283840 DEBUG: CPythonInvoker(8, /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.common.plugin.cache/default.py): entering source directory /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.common.plugin.cache
15:08:01 T:1817995128 DEBUG: CPythonInvoker(6, /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.cinema.experience/service.py): instantiating addon using automatically obtained id of "script.cinema.experience" dependent on version 2.12.0 of the xbmc.python api
15:08:01 T:1814283840 DEBUG: CPythonInvoker(8, /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.common.plugin.cache/default.py): instantiating addon using automatically obtained id of "script.common.plugin.cache" dependent on version 2.1.0 of the xbmc.python api
15:08:01 T:1817995064 DEBUG: CPythonInvoker(4, /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/service.qlock/default.py): setting the Python path to /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/service.qlock:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.chardet/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.simplejson/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.beautifulsoup/lib:/data/data/org.xbmc.xbmc/cache/apk/assets/addons/script.module.pil/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.common.plugin.cache/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.simple.downloader/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.requests/lib:/data/data/org.xbmc.xbmc/cache/apk/assets/addons/xbmc.debug/:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.parsedom/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.requests2/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.elementtree/lib:/:/data/app/org.xbmc.xbmc-1.apk/assets/python2.6/lib/python26.zip:/data/app/org.xbmc.xbmc-1.apk/assets/python2.6/lib/python2.6:/data/app/org.xbmc.xbmc-1.apk/assets/python2.6/lib/python2.6/plat-linux3:/data/app/org.xbmc.xbmc-1.apk/assets/python2.6/lib/python2.6/lib-tk:/data/app/org.xbmc.xbmc-1.apk/assets/python2.6/lib/python2.6/lib-old:/data/app/org.xbmc.xbmc-1.apk/assets/python2.6/lib/python2.6/lib-dynload
15:08:01 T:1817995064 DEBUG: CPythonInvoker(4, /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/service.qlock/default.py): entering source directory /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/service.qlock
15:08:01 T:1817992136 NOTICE: -->Python Interpreter Initialized<--
15:08:01 T:1817992136 DEBUG: CPythonInvoker(2, /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/service.skin.widgets/default.py): the source file to load is /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/service.skin.widgets/default.py
15:08:01 T:1817989464 DEBUG: XBMC Version Check: Version 0.1.20 started
15:08:01 T:1817989464 INFO: CPythonInvoker(1, /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/service.xbmc.versioncheck/service.py): script successfully run
15:08:01 T:1817995064 DEBUG: CPythonInvoker(4, /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/service.qlock/default.py): instantiating addon using automatically obtained id of "service.qlock" dependent on version 2.1.0 of the xbmc.python api
15:08:01 T:1814162464 NOTICE: Thread AlarmClock start, auto delete: false
15:08:01 T:1689332336 DEBUG: started alarm with name: checkatboot
15:08:01 T:1689332336 DEBUG: started alarm with name: checkwhilerunning
15:08:01 T:1817989464 INFO: Python script stopped
15:08:01 T:1817989464 DEBUG: Thread LanguageInvoker 1817989464 terminating
15:08:02 T:1831374776 DEBUG: int CVideoDatabase::RunQuery(const CStdString&) took 1046 ms for 10 items query: select * from episodeview ORDER BY dateAdded desc, idEpisode desc LIMIT 10
15:08:02 T:1828207136 DEBUG: virtual bool CThumbExtractor::DoWork() - trying to extract filestream details from video file /usbdrive/TV Shows2/Game of thrones/Game.Of.Thrones.S04.Season.4.COMPLETE.720p.HDTV.x264-PublicHD/Game.of.Thrones.S04E02.HDTV.x264-2HD.mp4
15:08:02 T:1817992136 DEBUG: CPythonInvoker(2, /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/service.skin.widgets/default.py): setting the Python path to /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/service.skin.widgets:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.chardet/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.simplejson/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.beautifulsoup/lib:/data/data/org.xbmc.xbmc/cache/apk/assets/addons/script.module.pil/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.common.plugin.cache/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.simple.downloader/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.requests/lib:/data/data/org.xbmc.xbmc/cache/apk/assets/addons/xbmc.debug/:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.parsedom/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.requests2/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.elementtree/lib:/:/data/app/org.xbmc.xbmc-1.apk/assets/python2.6/lib/python26.zip:/data/app/org.xbmc.xbmc-1.apk/assets/python2.6/lib/python2.6:/data/app/org.xbmc.xbmc-1.apk/assets/python2.6/lib/python2.6/plat-linux3:/data/app/org.xbmc.xbmc-1.apk/assets/python2.6/lib/python2.6/lib-tk:/data/app/org.xbmc.xbmc-1.apk/assets/python2.6/lib/python2.6/lib-old:/data/app/org.xbmc.xbmc-1.apk/assets/python2.6/lib/python2.6/lib-dynload
15:08:02 T:1817992136 DEBUG: CPythonInvoker(2, /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/service.skin.widgets/default.py): entering source directory /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/service.skin.widgets
15:08:02 T:1828207136 DEBUG: bool CDVDDemuxFFmpeg::Open(CDVDInputStream*) - probing detected format [mov,mp4,m4a,3gp,3g2,mj2]
15:08:02 T:1817992136 DEBUG: CPythonInvoker(2, /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/service.skin.widgets/default.py): instantiating addon using automatically obtained id of "service.skin.widgets" dependent on version 2.1.0 of the xbmc.python api
15:08:02 T:1828207136 DEBUG: bool CDVDDemuxFFmpeg::Open(CDVDInputStream*) - avformat_find_stream_info starting
15:08:02 T:1828207136 WARNING: could not find codec parameters for /usbdrive/TV Shows2/Game of thrones/Game.Of.Thrones.S04.Season.4.COMPLETE.720p.HDTV.x264-PublicHD/Game.of.Thrones.S04E02.HDTV.x264-2HD.mp4
15:08:02 T:1831374776 DEBUG: int CVideoDatabase::RunQuery(const CStdString&) took 36 ms for 10 items query: select * from musicvideoview ORDER BY dateAdded desc, idMVideo desc LIMIT 10
15:08:02 T:1831374776 DEBUG: CRecentlyAddedJob::UpdateTotal() - Running RecentlyAdded home screen update
15:08:03 T:1820102664 NOTICE: -->Python Interpreter Initialized<--
15:08:03 T:1820102664 DEBUG: CPythonInvoker(7, /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.tv.show.next.aired/service.py): the source file to load is /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.tv.show.next.aired/service.py
15:08:03 T:1814283840 NOTICE: StorageServer Module loaded RUN
15:08:03 T:1814283840 NOTICE: StorageClient-2.5.4 Starting server
15:08:03 T:1814283840 NOTICE: StorageServer-2.5.4 Storage Server starting /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/temp/commoncache.db
15:08:03 T:1820102664 DEBUG: CPythonInvoker(7, /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.tv.show.next.aired/service.py): setting the Python path to /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.tv.show.next.aired:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.chardet/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.simplejson/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.beautifulsoup/lib:/data/data/org.xbmc.xbmc/cache/apk/assets/addons/script.module.pil/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.common.plugin.cache/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.simple.downloader/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.requests/lib:/data/data/org.xbmc.xbmc/cache/apk/assets/addons/xbmc.debug/:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.parsedom/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.requests2/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.elementtree/lib:/:/data/app/org.xbmc.xbmc-1.apk/assets/python2.6/lib/python26.zip:/data/app/org.xbmc.xbmc-1.apk/assets/python2.6/lib/python2.6:/data/app/org.xbmc.xbmc-1.apk/assets/python2.6/lib/python2.6/plat-linux3:/data/app/org.xbmc.xbmc-1.apk/assets/python2.6/lib/python2.6/lib-tk:/data/app/org.xbmc.xbmc-1.apk/assets/python2.6/lib/python2.6/lib-old:/data/app/org.xbmc.xbmc-1.apk/assets/python2.6/lib/python2.6/lib-dynload
15:08:03 T:1820102664 DEBUG: CPythonInvoker(7, /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.tv.show.next.aired/service.py): entering source directory /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.tv.show.next.aired
15:08:03 T:1820102664 DEBUG: CPythonInvoker(7, /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.tv.show.next.aired/service.py): instantiating addon using automatically obtained id of "script.tv.show.next.aired" dependent on version 2.1.0 of the xbmc.python api
15:08:05 T:1817993752 INFO: CPythonInvoker(3, /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.simple.downloader/default.py): script successfully run
15:08:05 T:1817993752 INFO: Python script stopped
15:08:05 T:1817993752 DEBUG: Thread LanguageInvoker 1817993752 terminating
15:08:07 T:1820102664 DEBUG: POParser: loaded 38 strings from file /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.tv.show.next.aired/resources/language/English/strings.po
15:08:07 T:1817995128 DEBUG: [Cinema Experience] - settings() - __init__
15:08:07 T:1817995128 DEBUG: [Cinema Experience] - settings() - start
15:08:07 T:1817995128 DEBUG: [Cinema Experience] - Reading settings.xml
15:08:07 T:1820102664 DEBUG: script.tv.show.next.aired: ### params: {'service': 'true'}
15:08:07 T:1820102664 NOTICE: script.tv.show.next.aired: ### TV Show - Next Aired starting background proc (6.0.10)
15:08:07 T:1817995128 DEBUG: [Cinema Experience] - Reading settings.xml
15:08:08 T:1820102664 DEBUG: int CVideoDatabase::RunQuery(const CStdString&) took 696 ms for 52 items query: SELECT * FROM tvshowview
15:08:08 T:1817995128 DEBUG: [Cinema Experience] - Cinema Experience service script version 4.0.10 started
15:08:08 T:1817995128 DEBUG: [Cinema Experience] - Reading settings.xml
15:08:08 T:1817988848 DEBUG: CU LRC Lyrics: script version 2.0.9 started
15:08:08 T:1817988848 DEBUG: CU LRC Lyrics: mode is service
15:08:08 T:1817995128 DEBUG: [Cinema Experience] - settings() - start
15:08:08 T:1817995128 DEBUG: [Cinema Experience] - Reading settings.xml
15:08:08 T:1817992136 DEBUG: Skin Widgets: script version 0.0.29 started
15:08:08 T:1817995064 DEBUG: ### [Qlock] - Set new Language - [English]
15:08:09 T:1817992136 DEBUG: int CVideoDatabase::RunQuery(const CStdString&) took 495 ms for 890 items query: select * from movieview WHERE ((movieview.playCount IS NULL OR movieview.playCount < 1))
15:08:09 T:1817995064 DEBUG: ### [Qlock] - Startup
15:08:09 T:1817995064 DEBUG: ### [Qlock] - Delaying 60 secs
15:08:11 T:1817992136 DEBUG: int CVideoDatabase::RunQuery(const CStdString&) took 660 ms for 3053 items query: select * from episodeview WHERE ((episodeview.playCount IS NULL OR episodeview.playCount < 1))
15:08:12 T:1817992136 DEBUG: int CVideoDatabase::RunQuery(const CStdString&) took 44 ms for 302 items query: select * from musicvideoview
15:08:13 T:1817992136 DEBUG: bool CMusicDatabase::GetAlbumsByWhere(const CStdString&, const CDatabase::Filter&, CFileItemList&, const SortDescription&, bool) query: SELECT albumview.* FROM albumview WHERE albumview.strAlbum <> ''
15:08:13 T:1817992136 DEBUG: bool CMusicDatabase::GetAlbumsByWhere(const CStdString&, const CDatabase::Filter&, CFileItemList&, const SortDescription&, bool) - query took 6 ms
15:08:13 T:1817992136 DEBUG: bool CMusicDatabase::GetArtistsByWhere(const CStdString&, const CDatabase::Filter&, CFileItemList&, const SortDescription&, bool) query: SELECT artistview.* FROM artistview WHERE (artistview.idArtist IN (SELECT song_artist.idArtist FROM song_artist) OR artistview.idArtist IN (SELECT album_artist.idArtist FROM album_artist)) and artistview.strArtist != '' and artistview.strArtist <> 'Various artists'
15:08:13 T:1817992136 DEBUG: Time to retrieve artists from dataset = 16
15:08:13 T:1817992136 DEBUG: bool CMusicDatabase::GetSongsByWhere(const CStdString&, const CDatabase::Filter&, CFileItemList&, const SortDescription&) query = SELECT songview.* FROM songview WHERE ((CAST(songview.iTimesPlayed as DECIMAL(5,1)) < 1))
15:08:14 T:1817992136 DEBUG: Skin Widgets: Total time needed to request random queries: 0:00:05.772339
15:08:14 T:1817992136 DEBUG: int CVideoDatabase::RunQuery(const CStdString&) took 31 ms for 12 items query: select * from movieview WHERE (movieview.idFile IN (SELECT DISTINCT idFile FROM bookmark WHERE type = 1))
15:08:15 T:1817992136 DEBUG: int CVideoDatabase::RunQuery(const CStdString&) took 607 ms for 13 items query: SELECT * FROM tvshowview WHERE ( ((tvshowview.watchedcount > 0 AND tvshowview.watchedcount < tvshowview.totalCount) OR (tvshowview.watchedcount = 0 AND EXISTS (SELECT 1 FROM episodeview WHERE episodeview.idShow = tvshowview.idShow AND episodeview.resumeTimeInSeconds > 0))))
15:08:16 T:1817992136 DEBUG: bool CVideoDatabase::GetStackedTvShowList(int, CStdString&) const query: select idShow from tvshow where c00 like (select c00 from tvshow where idShow=12) order by idShow
15:08:16 T:1817992136 DEBUG: int CVideoDatabase::RunQuery(const CStdString&) took 43 ms for 173 items query: select * from episodeview WHERE (episodeview.idShow = 12) AND (((episodeview.playCount IS NULL OR episodeview.playCount = 0)))
15:08:16 T:1817992136 DEBUG: DatabaseUtils::GetSortFieldList: unknown field 25
15:08:16 T:1817992136 DEBUG: bool CVideoDatabase::GetStackedTvShowList(int, CStdString&) const query: select idShow from tvshow where c00 like (select c00 from tvshow where idShow=5) order by idShow
15:08:16 T:1817992136 DEBUG: int CVideoDatabase::RunQuery(const CStdString&) took 41 ms for 152 items query: select * from episodeview WHERE (episodeview.idShow = 5) AND (((episodeview.playCount IS NULL OR episodeview.playCount = 0)))
15:08:16 T:1817992136 DEBUG: DatabaseUtils::GetSortFieldList: unknown field 25
15:08:16 T:1817992136 DEBUG: bool CVideoDatabase::GetStackedTvShowList(int, CStdString&) const query: select idShow from tvshow where c00 like (select c00 from tvshow where idShow=1) order by idShow
15:08:16 T:1817992136 DEBUG: int CVideoDatabase::RunQuery(const CStdString&) took 18 ms for 50 items query: select * from episodeview WHERE (episodeview.idShow = 1) AND (((episodeview.playCount IS NULL OR episodeview.playCount = 0)))
15:08:16 T:1817992136 DEBUG: DatabaseUtils::GetSortFieldList: unknown field 25
15:08:16 T:1817992136 DEBUG: bool CVideoDatabase::GetStackedTvShowList(int, CStdString&) const query: select idShow from tvshow where c00 like (select c00 from tvshow where idShow=23) order by idShow
15:08:16 T:1817992136 DEBUG: int CVideoDatabase::RunQuery(const CStdString&) took 37 ms for 101 items query: select * from episodeview WHERE (episodeview.idShow = 23) AND (((episodeview.playCount IS NULL OR episodeview.playCount = 0)))
15:08:16 T:1817992136 DEBUG: DatabaseUtils::GetSortFieldList: unknown field 25
15:08:16 T:1817992136 DEBUG: bool CVideoDatabase::GetStackedTvShowList(int, CStdString&) const query: select idShow from tvshow where c00 like (select c00 from tvshow where idShow=50) order by idShow
15:08:16 T:1817992136 DEBUG: int CVideoDatabase::RunQuery(const CStdString&) took 12 ms for 10 items query: select * from episodeview WHERE (episodeview.idShow = 50) AND (((episodeview.playCount IS NULL OR episodeview.playCount = 0)))
15:08:16 T:1817992136 DEBUG: DatabaseUtils::GetSortFieldList: unknown field 25
15:08:16 T:1817992136 DEBUG: bool CVideoDatabase::GetStackedTvShowList(int, CStdString&) const query: select idShow from tvshow where c00 like (select c00 from tvshow where idShow=22) order by idShow
15:08:17 T:1817992136 DEBUG: int CVideoDatabase::RunQuery(const CStdString&) took 36 ms for 13 items query: select * from episodeview WHERE (episodeview.idShow = 22) AND (((episodeview.playCount IS NULL OR episodeview.playCount = 0)))
15:08:17 T:1817992136 DEBUG: DatabaseUtils::GetSortFieldList: unknown field 25
15:08:17 T:1817992136 DEBUG: bool CVideoDatabase::GetStackedTvShowList(int, CStdString&) const query: select idShow from tvshow where c00 like (select c00 from tvshow where idShow=39) order by idShow
15:08:17 T:1817992136 DEBUG: int CVideoDatabase::RunQuery(const CStdString&) took 33 ms for 120 items query: select * from episodeview WHERE (episodeview.idShow = 39) AND (((episodeview.playCount IS NULL OR episodeview.playCount = 0)))
15:08:17 T:1817992136 DEBUG: DatabaseUtils::GetSortFieldList: unknown field 25
15:08:17 T:1817992136 DEBUG: bool CVideoDatabase::GetStackedTvShowList(int, CStdString&) const query: select idShow from tvshow where c00 like (select c00 from tvshow where idShow=19) order by idShow
15:08:17 T:1817992136 DEBUG: int CVideoDatabase::RunQuery(const CStdString&) took 34 ms for 97 items query: select * from episodeview WHERE (episodeview.idShow = 19) AND (((episodeview.playCount IS NULL OR episodeview.playCount = 0)))
15:08:17 T:1817992136 DEBUG: DatabaseUtils::GetSortFieldList: unknown field 25
15:08:17 T:1817992136 DEBUG: bool CVideoDatabase::GetStackedTvShowList(int, CStdString&) const query: select idShow from tvshow where c00 like (select c00 from tvshow where idShow=37) order by idShow
15:08:17 T:1817992136 DEBUG: int CVideoDatabase::RunQuery(const CStdString&) took 47 ms for 151 items query: select * from episodeview WHERE (episodeview.idShow = 37) AND (((episodeview.playCount IS NULL OR episodeview.playCount = 0)))
15:08:17 T:1817992136 DEBUG: DatabaseUtils::GetSortFieldList: unknown field 25
15:08:17 T:1817992136 DEBUG: bool CVideoDatabase::GetStackedTvShowList(int, CStdString&) const query: select idShow from tvshow where c00 like (select c00 from tvshow where idShow=34) order by idShow
15:08:17 T:1817992136 DEBUG: int CVideoDatabase::RunQuery(const CStdString&) took 16 ms for 4 items query: select * from episodeview WHERE (episodeview.idShow = 34) AND (((episodeview.playCount IS NULL OR episodeview.playCount = 0)))
15:08:17 T:1817992136 DEBUG: DatabaseUtils::GetSortFieldList: unknown field 25
15:08:17 T:1817992136 DEBUG: bool CVideoDatabase::GetStackedTvShowList(int, CStdString&) const query: select idShow from tvshow where c00 like (select c00 from tvshow where idShow=36) order by idShow
15:08:17 T:1817992136 DEBUG: int CVideoDatabase::RunQuery(const CStdString&) took 24 ms for 45 items query: select * from episodeview WHERE (episodeview.idShow = 36) AND (((episodeview.playCount IS NULL OR episodeview.playCount = 0)))
15:08:17 T:1817992136 DEBUG: DatabaseUtils::GetSortFieldList: unknown field 25
15:08:18 T:1817992136 DEBUG: bool CVideoDatabase::GetStackedTvShowList(int, CStdString&) const query: select idShow from tvshow where c00 like (select c00 from tvshow where idShow=51) order by idShow
15:08:18 T:1817992136 DEBUG: int CVideoDatabase::RunQuery(const CStdString&) took 44 ms for 115 items query: select * from episodeview WHERE (episodeview.idShow = 51) AND (((episodeview.playCount IS NULL OR episodeview.playCount = 0)))
15:08:18 T:1817992136 DEBUG: DatabaseUtils::GetSortFieldList: unknown field 25
15:08:18 T:1817992136 DEBUG: bool CVideoDatabase::GetStackedTvShowList(int, CStdString&) const query: select idShow from tvshow where c00 like (select c00 from tvshow where idShow=7) order by idShow
15:08:18 T:1817992136 DEBUG: int CVideoDatabase::RunQuery(const CStdString&) took 11 ms for 15 items query: select * from episodeview WHERE (episodeview.idShow = 7) AND (((episodeview.playCount IS NULL OR episodeview.playCount = 0)))
15:08:18 T:1817992136 DEBUG: DatabaseUtils::GetSortFieldList: unknown field 25
15:08:18 T:1817992136 DEBUG: bool CMusicDatabase::GetAlbumsByWhere(const CStdString&, const CDatabase::Filter&, CFileItemList&, const SortDescription&, bool) query: SELECT albumview.* FROM albumview WHERE albumview.strAlbum <> ''
15:08:18 T:1817992136 DEBUG: bool CMusicDatabase::GetAlbumsByWhere(const CStdString&, const CDatabase::Filter&, CFileItemList&, const SortDescription&, bool) - query took 2 ms
15:08:18 T:1817992136 DEBUG: int CVideoDatabase::RunQuery(const CStdString&) took 27 ms for 302 items query: select * from musicvideoview
15:08:18 T:1817992136 DEBUG: Skin Widgets: Total time needed to request recommended queries: 0:00:04.230611
15:08:19 T:1817992136 DEBUG: int CVideoDatabase::RunQuery(const CStdString&) took 308 ms for 890 items query: select * from movieview WHERE ((movieview.playCount IS NULL OR movieview.playCount = 0))
15:08:20 T:1817992136 DEBUG: int CVideoDatabase::RunQuery(const CStdString&) took 473 ms for 3053 items query: select * from episodeview WHERE ((episodeview.playCount IS NULL OR episodeview.playCount < 1))
15:08:20 T:1689331264 DEBUG: SetupJoySticks:caching id(2), sources(16786707), device(OUYA Game Controller)
15:08:20 T:1689332336 DEBUG: CWinEventsAndroid::MessagePump:caching id(2), device(OUYA Game Controller)
15:08:20 T:1828207136 DEBUG: virtual bool CImageLoader::DoWork() - took 120 ms to load special://skin/backgrounds/movies.jpg
15:08:21 T:1689332336 DEBUG: Activating window ID: 10025
15:08:22 T:1689332336 DEBUG: ------ Window Deinit (Home.xml) ------
15:08:22 T:1689332336 DEBUG: ------ Window Init (MyVideoNav.xml) ------
15:08:22 T:1689332336 INFO: Loading skin file: MyVideoNav.xml, load type: KEEP_IN_MEMORY
15:08:22 T:1689332336 DEBUG: Load MyVideoNav.xml: 529.42ms
15:08:22 T:1689332336 DEBUG: Alloc resources: 554.66ms (529.71 ms skin load)
15:08:22 T:1689332336 DEBUG: CGUIMediaWindow::GetDirectory (videodb://tvshows/titles/)
15:08:22 T:1689332336 DEBUG: ParentPath = [videodb://tvshows/titles/]
15:08:23 T:1689332336 DEBUG: int CVideoDatabase::RunQuery(const CStdString&) took 209 ms for 52 items query: SELECT * FROM tvshowview
15:08:23 T:1867324800 NOTICE: Thread BackgroundLoader start, auto delete: false
15:08:23 T:1867324800 DEBUG: Thread BackgroundLoader 1867324800 terminating
15:08:23 T:1817992136 DEBUG: int CVideoDatabase::RunQuery(const CStdString&) took 24 ms for 302 items query: select * from musicvideoview
15:08:24 T:1817992136 DEBUG: bool CMusicDatabase::GetAlbumsByWhere(const CStdString&, const CDatabase::Filter&, CFileItemList&, const SortDescription&, bool) query: SELECT albumview.* FROM albumview WHERE albumview.strAlbum <> ''
15:08:24 T:1817992136 DEBUG: bool CMusicDatabase::GetAlbumsByWhere(const CStdString&, const CDatabase::Filter&, CFileItemList&, const SortDescription&, bool) - query took 5 ms
15:08:24 T:1817992136 DEBUG: Skin Widgets: Total time needed to request recent items queries: 0:00:05.513839
15:08:24 T:1817992136 DEBUG: Skin Widgets: Total time needed for all queries: 0:00:15.521099
15:08:25 T:1828207136 DEBUG: virtual bool CImageLoader::DoWork() - took 184 ms to load special://masterprofile/Thumbnails/5/53a062be.jpg
15:08:25 T:1831374776 DEBUG: virtual bool CImageLoader::DoWork() - took 373 ms to load special://masterprofile/Thumbnails/6/61ec3b1b.jpg
15:08:25 T:1831374776 DEBUG: virtual bool CImageLoader::DoWork() - took 276 ms to load special://masterprofile/Thumbnails/4/44672717.jpg
15:08:26 T:1693855920 DEBUG: hold ->repeat, size(0), repeatDuration(500)
15:08:26 T:1851131944 NOTICE: Thread JobWorker start, auto delete: true
15:08:26 T:1689332336 DEBUG: SECTION:UnloadDelayed(DLL: libImageLib-arm.so)
15:08:26 T:1689332336 DEBUG: Unloading: libImageLib-arm.so
15:08:27 T:1865016160 NOTICE: Thread JobWorker start, auto delete: true
15:08:27 T:1831374776 DEBUG: virtual bool CImageLoader::DoWork() - took 259 ms to load special://masterprofile/Thumbnails/4/4fde5a82.jpg
15:08:27 T:1851131944 DEBUG: virtual bool CImageLoader::DoWork() - took 108 ms to load special://masterprofile/Thumbnails/a/a02246b0.jpg
15:08:27 T:1828207136 DEBUG: virtual bool CImageLoader::DoWork() - took 237 ms to load special://masterprofile/Thumbnails/4/462a8ccf.jpg
15:08:27 T:1865016160 DEBUG: virtual bool CImageLoader::DoWork() - took 222 ms to load special://masterprofile/Thumbnails/1/1c4035a8.jpg
15:08:27 T:1828207136 DEBUG: virtual bool CImageLoader::DoWork() - took 194 ms to load special://masterprofile/Thumbnails/3/3ec2824d.jpg
15:08:28 T:1828207136 DEBUG: virtual bool CImageLoader::DoWork() - took 184 ms to load special://masterprofile/Thumbnails/3/3ec2824d.jpg
15:08:28 T:1693855920 DEBUG: hold ->repeat, size(0), repeatDuration(500)
15:08:28 T:1831374776 DEBUG: virtual bool CImageLoader::DoWork() - took 215 ms to load special://masterprofile/Thumbnails/1/1c4035a8.jpg
15:08:28 T:1865016160 DEBUG: virtual bool CImageLoader::DoWork() - took 176 ms to load special://masterprofile/Thumbnails/4/462a8ccf.jpg
15:08:29 T:1828207136 DEBUG: virtual bool CImageLoader::DoWork() - took 211 ms to load special://masterprofile/Thumbnails/4/4fde5a82.jpg
15:08:29 T:1828207136 DEBUG: virtual bool CImageLoader::DoWork() - took 104 ms to load special://masterprofile/Thumbnails/e/e7ac5ccb.jpg
15:08:29 T:1831374776 DEBUG: virtual bool CImageLoader::DoWork() - took 281 ms to load special://masterprofile/Thumbnails/4/44672717.jpg
15:08:29 T:1865016160 DEBUG: virtual bool CImageLoader::DoWork() - took 174 ms to load special://masterprofile/Thumbnails/3/3d364b1a.jpg
15:08:30 T:1851131944 DEBUG: virtual bool CImageLoader::DoWork() - took 192 ms to load special://masterprofile/Thumbnails/e/e5f14ab1.jpg
15:08:30 T:1865016160 DEBUG: virtual bool CImageLoader::DoWork() - took 101 ms to load special://masterprofile/Thumbnails/e/ed78de89.jpg
15:08:31 T:1853514824 NOTICE: Thread LanguageInvoker start, auto delete: false
15:08:31 T:1853514824 INFO: initializing python engine.
15:08:31 T:1853514824 DEBUG: CPythonInvoker(9, /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/service.xbmc.versioncheck/service.py): start processing
15:08:31 T:1853514824 NOTICE: -->Python Interpreter Initialized<--
15:08:31 T:1853514824 DEBUG: CPythonInvoker(9, /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/service.xbmc.versioncheck/service.py): the source file to load is /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/service.xbmc.versioncheck/service.py
15:08:31 T:1853514824 DEBUG: CPythonInvoker(9, /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/service.xbmc.versioncheck/service.py): setting the Python path to /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/service.xbmc.versioncheck:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.chardet/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.simplejson/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.beautifulsoup/lib:/data/data/org.xbmc.xbmc/cache/apk/assets/addons/script.module.pil/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.common.plugin.cache/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.simple.downloader/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.requests/lib:/data/data/org.xbmc.xbmc/cache/apk/assets/addons/xbmc.debug/:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.parsedom/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.requests2/lib:/storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/script.module.elementtree/lib:/:/data/app/org.xbmc.xbmc-1.apk/assets/python2.6/lib/python26.zip:/data/app/org.xbmc.xbmc-1.apk/assets/python2.6/lib/python2.6:/data/app/org.xbmc.xbmc-1.apk/assets/python2.6/lib/python2.6/plat-linux3:/data/app/org.xbmc.xbmc-1.apk/assets/python2.6/lib/python2.6/lib-tk:/data/app/org.xbmc.xbmc-1.apk/assets/python2.6/lib/python2.6/lib-old:/data/app/org.xbmc.xbmc-1.apk/assets/python2.6/lib/python2.6/lib-dynload
15:08:31 T:1853514824 DEBUG: CPythonInvoker(9, /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/service.xbmc.versioncheck/service.py): entering source directory /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/service.xbmc.versioncheck
15:08:31 T:1853514824 DEBUG: CPythonInvoker(9, /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/service.xbmc.versioncheck/service.py): instantiating addon using automatically obtained id of "service.xbmc.versioncheck" dependent on version 2.1.0 of the xbmc.python api
15:08:31 T:1828207136 DEBUG: virtual bool CImageLoader::DoWork() - took 371 ms to load special://masterprofile/Thumbnails/1/189e22d1.jpg
15:08:32 T:1831374776 DEBUG: virtual bool CImageLoader::DoWork() - took 146 ms to load special://masterprofile/Thumbnails/b/b562cc7d.jpg
15:08:32 T:1853514824 DEBUG: XBMC Version Check: Version 0.1.20 started
15:08:32 T:1853514824 DEBUG: XBMC Version Check: Version installed {u'major': 13, u'tag': u'beta', u'minor': 1, u'revision': u'20140511-692cfba'}
15:08:32 T:1853514824 DEBUG: XBMC Version Check: Nothing to see here, move along. Running a latest non stable release
15:08:32 T:1853514824 INFO: CPythonInvoker(9, /storage/sdcard0/Android/data/org.xbmc.xbmc/files/.xbmc/addons/service.xbmc.versioncheck/service.py): script successfully run
15:08:32 T:1831374776 DEBUG: virtual bool CImageLoader::DoWork() - took 172 ms to load special://masterprofile/Thumbnails/6/61ec3b1b.jpg
15:08:32 T:1853514824 INFO: Python script stopped
15:08:32 T:1853514824 DEBUG: Thread LanguageInvoker 1853514824 terminating
15:08:33 T:1865016160 DEBUG: virtual bool CImageLoader::DoWork() - took 216 ms to load special://masterprofile/Thumbnails/1/1e42dcca.jpg
15:08:33 T:1828207136 DEBUG: virtual bool CImageLoader::DoWork() - took 198 ms to load special://masterprofile/Thumbnails/0/014ffc89.jpg
15:08:34 T:1851131944 DEBUG: virtual bool CImageLoader::DoWork() - took 122 ms to load special://masterprofile/Thumbnails/0/07a3c72f.jpg
15:08:34 T:1831374776 DEBUG: virtual bool CImageLoader::DoWork() - took 217 ms to load special://masterprofile/Thumbnails/3/3ba05494.jpg
15:08:35 T:1865016160 DEBUG: virtual bool CImageLoader::DoWork() - took 171 ms to load special://masterprofile/Thumbnails/7/7cb97fdc.jpg
15:08:35 T:1689332336 DEBUG: CGUIMediaWindow::GetDirectory (videodb://tvshows/titles/23/)
15:08:35 T:1689332336 DEBUG: ParentPath = [videodb://tvshows/titles/]
15:08:35 T:1828207136 DEBUG: bool CVideoDatabase::GetStackedTvShowList(int, CStdString&) const query: select idShow from tvshow where c00 like (select c00 from tvshow where idShow=23) order by idShow
15:08:35 T:1828207136 DEBUG: int CVideoDatabase::RunQuery(const CStdString&) took 365 ms for 8 items query: SELECT episodeview.c12, path.strPath, tvshowview.c00, tvshowview.c01, tvshowview.c05, tvshowview.c08, tvshowview.c14, tvshowview.c13, seasons.idSeason, count(1), count(files.playCount) FROM episodeview JOIN tvshowview ON tvshowview.idShow = episodeview.idShow JOIN seasons ON (seasons.idShow = tvshowview.idShow AND seasons.season = episodeview.c12) JOIN files ON files.idFile = episodeview.idFile JOIN tvshowlinkpath ON tvshowlinkpath.idShow = tvshowview.idShow JOIN path ON path.idPath = tvshowlinkpath.idPath WHERE tvshowview.idShow = 23 GROUP BY episodeview.c12
15:08:35 T:1828207136 DEBUG: int CVideoDatabase::RunQuery(const CStdString&) took 64 ms for 0 items query: select * from movieview join movielinktvshow on movielinktvshow.idMovie=movieview.idMovie WHERE movielinktvshow.idShow = 23
15:08:36 T:1828207136 WARNING: static CStdString XFILE::CVideoDatabaseDirectory::GetIcon(const CStdString&) - Unknown nodetype requested videodb://tvshows/titles/23/1/?tvshowid=23
15:08:36 T:1828207136 WARNING: static CStdString XFILE::CVideoDatabaseDirectory::GetIcon(const CStdString&) - Unknown nodetype requested videodb://tvshows/titles/23/2/?tvshowid=23
15:08:36 T:1828207136 WARNING: static CStdString XFILE::CVideoDatabaseDirectory::GetIcon(const CStdString&) - Unknown nodetype requested videodb://tvshows/titles/23/3/?tvshowid=23
15:08:36 T:1828207136 WARNING: static CStdString XFILE::CVideoDatabaseDirectory::GetIcon(const CStdString&) - Unknown nodetype requested videodb://tvshows/titles/23/4/?tvshowid=23
15:08:36 T:1828207136 WARNING: static CStdString XFILE::CVideoDatabaseDirectory::GetIcon(const CStdString&) - Unknown nodetype requested videodb://tvshows/titles/23/5/?tvshowid=23
15:08:36 T:1828207136 WARNING: static CStdString XFILE::CVideoDatabaseDirectory::GetIcon(const CStdString&) - Unknown nodetype requested videodb://tvshows/titles/23/6/?tvshowid=23
15:08:36 T:1828207136 WARNING: static CStdString XFILE::CVideoDatabaseDirectory::GetIcon(const CStdString&) - Unknown nodetype requested videodb://tvshows/titles/23/7/?tvshowid=23
15:08:36 T:1828207136 WARNING: static CStdString XFILE::CVideoDatabaseDirectory::GetIcon(const CStdString&) - Unknown nodetype requested videodb://tvshows/titles/23/8/?tvshowid=23
15:08:36 T:1828207136 WARNING: static CStdString XFILE::CVideoDatabaseDirectory::GetIcon(const CStdString&) - Unknown nodetype requested videodb://tvshows/titles/23/-1/?tvshowid=23
15:08:36 T:1689332336 DEBUG: WindowVideoNav::GetDirectory
15:08:36 T:1836150024 NOTICE: Thread BackgroundLoader start, auto delete: false
15:08:36 T:1836150024 DEBUG: Thread BackgroundLoader 1836150024 terminating
15:08:36 T:1819227280 NOTICE: Thread BackgroundLoader start, auto delete: false
15:08:36 T:1819227280 DEBUG: Thread BackgroundLoader 1819227280 terminating
15:08:37 T:1689332336 DEBUG: CGUIMediaWindow::GetDirectory (videodb://tvshows/titles/)
15:08:37 T:1689332336 DEBUG: ParentPath = [videodb://tvshows/]
15:08:37 T:1831374776 DEBUG: int CVideoDatabase::RunQuery(const CStdString&) took 217 ms for 52 items query: SELECT * FROM tvshowview
15:08:38 T:1867757328 NOTICE: Thread BackgroundLoader start, auto delete: false
15:08:38 T:1867757328 DEBUG: Thread BackgroundLoader 1867757328 terminating
15:08:38 T:1689332336 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate
15:08:38 T:1689332336 DEBUG: ------ Window Deinit (MyVideoNav.xml) ------
15:08:38 T:1689332336 DEBUG: CGUIWindowManager::PreviousWindow: Activate new
15:08:38 T:1689332336 DEBUG: ------ Window Init (Home.xml) ------
15:08:38 T:1689332336 INFO: Loading skin file: Home.xml, load type: KEEP_IN_MEMORY
15:08:38 T:1689332336 DEBUG: Load Home.xml: 140.69ms
15:08:38 T:1689332336 DEBUG: Alloc resources: 145.30ms (144.42 ms skin load)
15:08:39 T:1831374776 DEBUG: virtual bool CImageLoader::DoWork() - took 102 ms to load special://skin/backgrounds/movies.jpg
15:08:40 T:1828207136 INFO: void XCURL::DllLibCurlGlobal::easy_aquire(const char*, const char*, XCURL::CURL_HANDLE**, XCURL::CURLM**) - Created session to http://www.google.com
15:08:40 T:1831374776 DEBUG: virtual bool CImageLoader::DoWork() - took 253 ms to load special://skin/backgrounds/settings.jpg
15:08:41 T:1851131944 DEBUG: virtual bool CImageLoader::DoWork() - took 124 ms to load special://skin/backgrounds/home-weather-conditional/weather.jpg
15:08:45 T:1689332336 DEBUG: Activating window ID: 10003
15:08:45 T:1689332336 DEBUG: ------ Window Deinit (Home.xml) ------
15:08:45 T:1689332336 INFO: Attempting to quickpath to: return
15:08:45 T:1689332336 DEBUG: CUtil::GetMatchingSource: no matching source found for [return]
15:08:45 T:1689332336 ERROR: Failed! Destination parameter (return) does not match a valid share!
15:08:45 T:1689332336 DEBUG: ------ Window Init (FileManager.xml) ------
15:08:45 T:1689332336 INFO: Loading skin file: FileManager.xml, load type: KEEP_IN_MEMORY
15:08:45 T:1689332336 DEBUG: Load FileManager.xml: 56.79ms
15:08:45 T:1689332336 DEBUG: Alloc resources: 57.74ms (57.07 ms skin load)
15:08:57 T:1689332336 DEBUG: CPlayerCoreFactory::GetPlayers(special://logpath/xbmc.old.log)
15:08:57 T:1689332336 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules
15:08:57 T:1689332336 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules
15:08:57 T:1689332336 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtv
15:08:57 T:1689332336 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: hdhomerun/myth/mms/udp
15:08:57 T:1689332336 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout
15:08:57 T:1689332336 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp
15:08:57 T:1689332336 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp
15:08:57 T:1689332336 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams
15:08:57 T:1689332336 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd
15:08:57 T:1689332336 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage
15:08:57 T:1689332336 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf
15:08:57 T:1689332336 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv
15:08:57 T:1689332336 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio
15:08:57 T:1689332336 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players
15:08:57 T:1689332336 DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (1)
15:08:57 T:1689332336 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0
15:08:57 T:1689332336 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1
15:08:57 T:1689332336 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: DVDPlayer (1)
15:08:57 T:1689332336 DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players
15:08:57 T:1689332336 DEBUG: CFavourites::Load - no system favourites found, skipping
15:08:57 T:1689332336 INFO: Loading skin file: DialogContextMenu.xml, load type: KEEP_IN_MEMORY
15:08:57 T:1689332336 DEBUG: Load DialogContextMenu.xml: 12.96ms
15:08:57 T:1689332336 DEBUG: Alloc resources: 15.01ms (13.31 ms skin load)
15:08:57 T:1689332336 DEBUG: ------ Window Init (DialogContextMenu.xml) ------
15:08:57 T:1689332336 DEBUG: Window DialogContextMenu.xml was already loaded
15:08:57 T:1689332336 DEBUG: Alloc resources: 0.17m
15:09:06 T:1689332336 DEBUG: ------ Window Deinit (DialogContextMenu.xml) ------
15:09:07 T:1689332336 DEBUG: CPlayerCoreFactory::GetPlayers(special://logpath/xbmc.log)
15:09:07 T:1689332336 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules
15:09:07 T:1689332336 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules
15:09:07 T:1689332336 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtv
15:09:07 T:1689332336 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: hdhomerun/myth/mms/udp
15:09:07 T:1689332336 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout
15:09:07 T:1689332336 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp
15:09:07 T:1689332336 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp
15:09:07 T:1689332336 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams
15:09:07 T:1689332336 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd
15:09:07 T:1689332336 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage
15:09:07 T:1689332336 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf
15:09:07 T:1689332336 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv
15:09:07 T:1689332336 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio
15:09:07 T:1689332336 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players
15:09:07 T:1689332336 DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (1)
15:09:07 T:1689332336 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0
15:09:07 T:1689332336 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1
15:09:07 T:1689332336 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: DVDPlayer (1)
15:09:07 T:1689332336 DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players
15:09:07 T:1689332336 DEBUG: CFavourites::Load - no system favourites found, skipping
15:09:07 T:1689332336 DEBUG: ------ Window Init (DialogContextMenu.xml) ------
15:09:07 T:1689332336 DEBUG: Window DialogContextMenu.xml was already loaded
15:09:07 T:1689332336 DEBUG: Alloc resources: 0.28m
15:09:08 T:1817995064 DEBUG: ### [Qlock] - Delaying 3 secs
15:09:09 T:1689332336 DEBUG: ------ Window Deinit (DialogContextMenu.xml) ------
15:09:10 T:1817995064 DEBUG: ### [Qlock] - Delaying 3 secs
15:09:11 T:1689332336 INFO: void XCURL::DllLibCurlGlobal::CheckIdle() - Closing session to http://www.google.com (easy=0x6cc0cc60, multi=0x0)
15:09:12 T:1817995064 DEBUG: ### [Qlock] - Delaying 3 secs
15:09:18 T:1689332336 DEBUG: Previous line repeats 3 times.
15:09:18 T:1689332336 DEBUG: CPlayerCoreFactory::GetPlayers(special://logpath/xbmc.old.log)
15:09:18 T:1689332336 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules
15:09:18 T:1689332336 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules
15:09:18 T:1689332336 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtv
15:09:18 T:1689332336 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: hdhomerun/myth/mms/udp
15:09:18 T:1689332336 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout
15:09:18 T:1689332336 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp
15:09:18 T:1689332336 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp
15:09:18 T:1689332336 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams
15:09:18 T:1689332336 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd
15:09:18 T:1689332336 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage
15:09:18 T:1689332336 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf
15:09:18 T:1689332336 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv
15:09:18 T:1689332336 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio
15:09:18 T:1689332336 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players
15:09:18 T:1689332336 DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (1)
15:09:18 T:1689332336 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0
15:09:18 T:1689332336 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1
15:09:18 T:1689332336 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: DVDPlayer (1)
15:09:18 T:1689332336 DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players
15:09:18 T:1689332336 DEBUG: CFavourites::Load - no system favourites found, skipping
15:09:18 T:1689332336 DEBUG: ------ Window Init (DialogContextMenu.xml) ------
15:09:18 T:1689332336 DEBUG: Window DialogContextMenu.xml was already loaded
15:09:18 T:1689332336 DEBUG: Alloc resources: 0.56m
15:09:20 T:1817995064 DEBUG: ### [Qlock] - Delaying 3 secs
15:09:21 T:1689332336 DEBUG: ------ Window Deinit (DialogContextMenu.xml) ------
15:09:21 T:1689332336 DEBUG: ------ Window Init (DialogYesNo.xml) ------
15:09:21 T:1689332336 INFO: Loading skin file: DialogYesNo.xml, load type: KEEP_IN_MEMORY
15:09:21 T:1689332336 DEBUG: Load DialogYesNo.xml: 11.52ms
15:09:21 T:1689332336 DEBUG: Alloc resources: 13.07ms (11.77 ms skin load)
15:09:22 T:1817995064 DEBUG: ### [Qlock] - Delaying 3 secs
15:09:24 T:1689332336 DEBUG: ------ Window Deinit (DialogYesNo.xml) ------
15:09:24 T:1689332336 DEBUG: ------ Window Init (DialogExtendedProgressBar.xml) ------
15:09:24 T:1689332336 DEBUG: Window DialogExtendedProgressBar.xml was already loaded
15:09:24 T:1689332336 DEBUG: Alloc resources: 0.02m
15:09:24 T:1831374776 DEBUG: FileManager: copy special://logpath/xbmc.old.log -> /mnt/usbdrive/x2/xbmc.old.log
15:09:24 T:1817995064 DEBUG: ### [Qlock] - Delaying 3 secs
15:09:25 T:1689332336 DEBUG: ------ Window Deinit (DialogExtendedProgressBar.xml) ------
15:09:26 T:1817995064 DEBUG: ### [Qlock] - Delaying 3 secs
15:09:28 T:1689332336 DEBUG: Previous line repeats 1 times.
15:09:28 T:1689332336 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate
15:09:29 T:1689332336 DEBUG: ------ Window Deinit (FileManager.xml) ------
15:09:29 T:1689332336 DEBUG: CGUIWindowManager::PreviousWindow: Activate new
15:09:29 T:1689332336 DEBUG: ------ Window Init (Home.xml) ------
15:09:29 T:1689332336 DEBUG: Window Home.xml was already loaded
15:09:29 T:1689332336 DEBUG: Alloc resources: 2.80m
15:09:29 T:1851131944 INFO: void XCURL::DllLibCurlGlobal::easy_aquire(const char*, const char*, XCURL::CURL_HANDLE**, XCURL::CURLM**) - Created session to http://www.google.com
15:09:30 T:1817995064 DEBUG: ### [Qlock] - Delaying 3 secs
15:09:32 T:1831374776 DEBUG: virtual bool CImageLoader::DoWork() - took 142 ms to load special://masterprofile/Thumbnails/b/b4966b71.jpg
15:09:32 T:1689332336 DEBUG: Activating window ID: 10025
15:09:32 T:1817995064 DEBUG: ### [Qlock] - Delaying 3 secs
15:09:32 T:1689332336 DEBUG: ------ Window Deinit (Home.xml) ------
15:09:32 T:1689332336 DEBUG: ------ Window Init (MyVideoNav.xml) ------
15:09:32 T:1689332336 DEBUG: Window MyVideoNav.xml was already loaded
15:09:32 T:1689332336 DEBUG: Alloc resources: 27.15m
15:09:32 T:1689332336 DEBUG: CGUIMediaWindow::GetDirectory (videodb://tvshows/titles/)
15:09:32 T:1689332336 DEBUG: ParentPath = [videodb://tvshows/titles/]
15:09:33 T:1689332336 DEBUG: int CVideoDatabase::RunQuery(const CStdString&) took 210 ms for 52 items query: SELECT * FROM tvshowview
15:09:33 T:1867121280 NOTICE: Thread BackgroundLoader start, auto delete: false
15:09:33 T:1867121280 DEBUG: Thread BackgroundLoader 1867121280 terminating
15:09:33 T:1851131944 DEBUG: virtual bool CImageLoader::DoWork() - took 144 ms to load special://masterprofile/Thumbnails/7/7cb97fdc.jpg
15:09:34 T:1689332336 DEBUG: CGUIMediaWindow::GetDirectory (videodb://tvshows/titles/23/)
15:09:34 T:1689332336 DEBUG: ParentPath = [videodb://tvshows/titles/]
15:09:34 T:1865016160 DEBUG: bool CVideoDatabase::GetStackedTvShowList(int, CStdString&) const query: select idShow from tvshow where c00 like (select c00 from tvshow where idShow=23) order by idShow
15:09:34 T:1817995064 DEBUG: ### [Qlock] - Delaying 3 secs
15:09:34 T:1865016160 DEBUG: int CVideoDatabase::RunQuery(const CStdString&) took 329 ms for 8 items query: SELECT episodeview.c12, path.strPath, tvshowview.c00, tvshowview.c01, tvshowview.c05, tvshowview.c08, tvshowview.c14, tvshowview.c13, seasons.idSeason, count(1), count(files.playCount) FROM episodeview JOIN tvshowview ON tvshowview.idShow = episodeview.idShow JOIN seasons ON (seasons.idShow = tvshowview.idShow AND seasons.season = episodeview.c12) JOIN files ON files.idFile = episodeview.idFile JOIN tvshowlinkpath ON tvshowlinkpath.idShow = tvshowview.idShow JOIN path ON path.idPath = tvshowlinkpath.idPath WHERE tvshowview.idShow = 23 GROUP BY episodeview.c12
15:09:34 T:1865016160 DEBUG: int CVideoDatabase::RunQuery(const CStdString&) took 58 ms for 0 items query: select * from movieview join movielinktvshow on movielinktvshow.idMovie=movieview.idMovie WHERE movielinktvshow.idShow = 23
15:09:34 T:1865016160 WARNING: static CStdString XFILE::CVideoDatabaseDirectory::GetIcon(const CStdString&) - Unknown nodetype requested videodb://tvshows/titles/23/1/?tvshowid=23
15:09:34 T:1865016160 WARNING: static CStdString XFILE::CVideoDatabaseDirectory::GetIcon(const CStdString&) - Unknown nodetype requested videodb://tvshows/titles/23/2/?tvshowid=23
15:09:34 T:1865016160 WARNING: static CStdString XFILE::CVideoDatabaseDirectory::GetIcon(const CStdString&) - Unknown nodetype requested videodb://tvshows/titles/23/3/?tvshowid=23
15:09:34 T:1865016160 WARNING: static CStdString XFILE::CVideoDatabaseDirectory::GetIcon(const CStdString&) - Unknown nodetype requested videodb://tvshows/titles/23/4/?tvshowid=23
15:09:34 T:1865016160 WARNING: static CStdString XFILE::CVideoDatabaseDirectory::GetIcon(const CStdString&) - Unknown nodetype requested videodb://tvshows/titles/23/5/?tvshowid=23
15:09:34 T:1865016160 WARNING: static CStdString XFILE::CVideoDatabaseDirectory::GetIcon(const CStdString&) - Unknown nodetype requested videodb://tvshows/titles/23/6/?tvshowid=23
15:09:34 T:1865016160 WARNING: static CStdString XFILE::CVideoDatabaseDirectory::GetIcon(const CStdString&) - Unknown nodetype requested videodb://tvshows/titles/23/7/?tvshowid=23
15:09:34 T:1865016160 WARNING: static CStdString XFILE::CVideoDatabaseDirectory::GetIcon(const CStdString&) - Unknown nodetype requested videodb://tvshows/titles/23/8/?tvshowid=23
15:09:34 T:1865016160 WARNING: static CStdString XFILE::CVideoDatabaseDirectory::GetIcon(const CStdString&) - Unknown nodetype requested videodb://tvshows/titles/23/-1/?tvshowid=23
15:09:34 T:1689332336 DEBUG: WindowVideoNav::GetDirectory
15:09:34 T:1865149648 NOTICE: Thread BackgroundLoader start, auto delete: false
15:09:35 T:1865149648 DEBUG: Thread BackgroundLoader 1865149648 terminating
15:09:35 T:1864879976 NOTICE: Thread BackgroundLoader start, auto delete: false
15:09:35 T:1864879976 DEBUG: Thread BackgroundLoader 1864879976 terminating
15:09:36 T:1817995064 DEBUG: ### [Qlock] - Delaying 3 secs
15:09:37 T:1689332336 DEBUG: CGUIMediaWindow::GetDirectory (videodb://tvshows/titles/23/4/?tvshowid=23)
15:09:37 T:1689332336 DEBUG: ParentPath = [videodb://tvshows/titles/23/]
15:09:37 T:1851131944 DEBUG: bool CVideoDatabase::GetStackedTvShowList(int, CStdString&) const query: select idShow from tvshow where c00 like (select c00 from tvshow where idShow=23) order by idShow
15:09:37 T:1851131944 DEBUG: Previous line repeats 1 times.
15:09:37 T:1851131944 DEBUG: int CVideoDatabase::RunQuery(const CStdString&) took 9 ms for 16 items query: select * from episodeview WHERE (episodeview.idShow = 23) AND ((episodeview.c12 = 4 or (episodeview.c12 = 0 and (episodeview.c15 = 0 or episodeview.c15 = 4))))
15:09:37 T:1689332336 DEBUG: WindowVideoNav::GetDirectory
15:09:37 T:1858109232 NOTICE: Thread BackgroundLoader start, auto delete: false
15:09:37 T:1858109232 DEBUG: Thread BackgroundLoader 1858109232 terminating
15:09:38 T:1817995064 DEBUG: ### [Qlock] - Delaying 3 secs
15:09:40 T:1689332336 DEBUG: virtual bool CGUIWindowVideoBase::OnPlayMedia(int) /usbdrive/TV Shows2/House MD/Season 4/House MD 4x05 - Mirror Mirror.mp4
15:09:40 T:1689332336 DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc
15:09:40 T:1689332336 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnClear
15:09:40 T:1689332336 DEBUG: CAnnouncementManager - Announcement: OnAdd from xbmc
15:09:40 T:1689332336 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnAdd
15:09:40 T:1689332336 DEBUG: CPlayerCoreFactory::GetPlayers(/usbdrive/TV Shows2/House MD/Season 4/House MD 4x05 - Mirror Mirror.mp4)
15:09:40 T:1689332336 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules
15:09:40 T:1689332336 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules
15:09:40 T:1689332336 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtv
15:09:40 T:1689332336 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: hdhomerun/myth/mms/udp
15:09:40 T:1689332336 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout
15:09:40 T:1689332336 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp
15:09:40 T:1689332336 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp
15:09:40 T:1689332336 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams
15:09:40 T:1689332336 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd
15:09:40 T:1689332336 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage
15:09:40 T:1689332336 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf
15:09:40 T:1689332336 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv
15:09:40 T:1689332336 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio
15:09:40 T:1689332336 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players
15:09:40 T:1689332336 DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (1)
15:09:40 T:1689332336 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0
15:09:40 T:1689332336 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1
15:09:40 T:1689332336 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: DVDPlayer (1)
15:09:40 T:1689332336 DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players
15:09:40 T:1689332336 NOTICE: DVDPlayer: Opening: /usbdrive/TV Shows2/House MD/Season 4/House MD 4x05 - Mirror Mirror.mp4
15:09:40 T:1689332336 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED
15:09:40 T:1689332336 DEBUG: CRenderManager::UpdateDisplayLatency - Latency set to 0 msec
15:09:40 T:1689332336 DEBUG: LinuxRendererGL: Cleaning up GL resources
15:09:40 T:1689332336 DEBUG: SECTION:LoadDLL(libswscale-2-arm.so)
15:09:40 T:1689332336 DEBUG: Loading: /data/data/org.xbmc.xbmc/lib/libswscale-2-arm.so
15:09:40 T:1853715088 NOTICE: Thread DVDPlayer start, auto delete: false
15:09:40 T:1853715088 NOTICE: Creating InputStream
15:09:40 T:1853715088 DEBUG: static void CUtil::ScanForExternalSubtitles(const CStdString&, std::vector<CStdStr<char> >&): Searching for subtitles...
15:09:40 T:1853715088 DEBUG: static void CUtil::ScanForExternalSubtitles(const CStdString&, std::vector<CStdStr<char> >&): END (total time: 160 ms)
15:09:40 T:1853715088 NOTICE: Creating Demuxer
15:09:40 T:1853715088 DEBUG: bool CDVDDemuxFFmpeg::Open(CDVDInputStream*) - probing detected format [mov,mp4,m4a,3gp,3g2,mj2]
15:09:40 T:1853715088 DEBUG: bool CDVDDemuxFFmpeg::Open(CDVDInputStream*) - avformat_find_stream_info starting
15:09:40 T:1817995064 DEBUG: ### [Qlock] - Delaying 3 secs
15:09:40 T:1689332336 DEBUG: ------ Window Init (DialogBusy.xml) ------
15:09:40 T:1689332336 DEBUG: Window DialogBusy.xml was already loaded
15:09:40 T:1689332336 DEBUG: Alloc resources: 0.06m
15:09:40 T:1853715088 DEBUG: bool CDVDDemuxFFmpeg::Open(CDVDInputStream*) - av_find_stream_info finished
15:09:40 T:1853715088 NOTICE: Opening video stream: 0 source: 256
15:09:40 T:1853715088 NOTICE: Creating video codec with codec id: 28
15:09:40 T:1853715088 DEBUG: CDVDFactoryCodec: compiled in hardware support: CrystalHD:no AMCodec:yes MediaCodec:yes OpenMax:no libstagefright:yes VDPAU:no VAAPI:no
15:09:40 T:1853715088 INFO: MediaCodec Video Decoder...
15:09:40 T:1853715088 DEBUG: FactoryCodec - Video: mediacodec - Opening
15:09:40 T:1853715088 INFO: CBitstreamConverter::Open bitstream to annexb init
15:09:40 T:1853715088 DEBUG: CDVDVideoCodecAndroidMediaCodec::Open m_codecname(OMX.Nvidia.h264.decode), colorFormat(19)
15:09:41 T:1853715088 DEBUG: CDVDVideoCodecAndroidMediaCodec:: width(1280), height(720), stride(0), slice-height(0), color-format(0)
15:09:41 T:1853715088 DEBUG: CDVDVideoCodecAndroidMediaCodec:: crop-left(0), crop-top(0), crop-right(0), crop-bottom(0)
15:09:41 T:1853715088 DEBUG: CDVDVideoCodecAndroidMediaCodec:: Direct Surface Rendering
15:09:41 T:1853715088 INFO: CDVDVideoCodecAndroidMediaCodec:: Open Android MediaCodec OMX.Nvidia.h264.decode
15:09:41 T:1853715088 DEBUG: FactoryCodec - Video: amc-h264 - Opened
15:09:41 T:1853715088 NOTICE: Creating video thread
15:09:41 T:1819937656 NOTICE: Thread DVDPlayerVideo start, auto delete: false
15:09:41 T:1853715088 NOTICE: Opening audio stream: 1 source: 256
15:09:41 T:1853715088 NOTICE: Finding audio codec for: 86018
15:09:41 T:1819937656 NOTICE: running thread: video_thread
15:09:41 T:1853715088 DEBUG: FactoryCodec - Audio: passthrough - Opening
15:09:41 T:1819937656 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE
15:09:41 T:1853715088 DEBUG: FactoryCodec - Audio: passthrough - Failed
15:09:41 T:1853715088 DEBUG: FactoryCodec - Audio: FFmpeg - Opening
15:09:41 T:1853715088 DEBUG: FactoryCodec - Audio: FFmpeg - Opened
15:09:41 T:1853715088 NOTICE: Creating audio thread
15:09:41 T:1854955288 NOTICE: Thread DVDPlayerAudio start, auto delete: false
15:09:41 T:1854955288 NOTICE: running thread: CDVDPlayerAudio::Process()
15:09:41 T:1853715088 DEBUG: bool CEdl::ReadEditDecisionLists(const CStdString&, float, int) - Checking for edit decision lists (EDL) on local drive or remote share for: /usbdrive/TV Shows2/House MD/Season 4/House MD 4x05 - Mirror Mirror.mp4
15:09:41 T:1853715088 DEBUG: virtual void CApplication::OnPlayBackStarted() : play state was 1, starting 1
15:09:41 T:1853715088 DEBUG: CDVDPlayer::SetCaching - caching state 3
15:09:41 T:1819937656 INFO: CDVDPlayerVideo - Stillframe left, switching to normal playback
15:09:41 T:1854955288 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(21333.333333, 1)
15:09:41 T:1854955288 NOTICE: Creating audio stream (codec id: 86018, channels: 2, sample rate: 48000, no pass-through)
15:09:41 T:1854955288 DEBUG: CDVDPlayerAudio:: synctype set to 0: clock feedback
15:09:41 T:1691927880 INFO: CActiveAESink::OpenSink - initialize sink
15:09:41 T:1691927880 DEBUG: CActiveAESink::OpenSink - trying to open device AUDIOTRACK:AudioTrack
15:09:41 T:1819937656 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC(42000.000000, 0)
15:09:41 T:1691927880 DEBUG: CActiveAESink::OpenSink - AUDIOTRACK Initialized:
15:09:41 T:1691927880 DEBUG: Output Device : android
15:09:41 T:1691927880 DEBUG: Sample Rate : 48000
15:09:41 T:1691927880 DEBUG: Sample Format : AE_FMT_S16NE
15:09:41 T:1691927880 DEBUG: Channel Count : 2
15:09:41 T:1691927880 DEBUG: Channel Layout: FL,FR
15:09:41 T:1691927880 DEBUG: Frames : 2048
15:09:41 T:1691927880 DEBUG: Frame Samples : 4096
15:09:41 T:1691927880 DEBUG: Frame Size : 4
15:09:41 T:1689332336 DEBUG: PlayBackRet CApplication::PlayFile(const CFileItem&, bool) : OpenFile succeed, play state 2
15:09:41 T:1689332336 DEBUG: virtual void CApplication::OnPlayBackStarted() : play state was 2, starting 0
15:09:41 T:1691606544 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted
15:09:41 T:1853715088 DEBUG: CDVDPlayer::HandleMessages - player started 1
15:09:41 T:1689332336 DEBUG: CGUIInfoManager::SetCurrentMovie(/usbdrive/TV Shows2/House MD/Season 4/House MD 4x05 - Mirror Mirror.mp4)
15:09:41 T:1689332336 DEBUG: int CVideoDatabase::GetMovieId(const CStdString&) (/usbdrive/TV Shows2/House MD/Season 4/House MD 4x05 - Mirror Mirror.mp4), query = select idMovie from movie where idFile=4260
15:09:41 T:1689332336 DEBUG: int CVideoDatabase::GetEpisodeId(const CStdString&, int, int) (/usbdrive/TV Shows2/House MD/Season 4/House MD 4x05 - Mirror Mirror.mp4), query = select idEpisode from episode where idFile=4260
15:09:41 T:1819937656 DEBUG: CDVDVideoCodecAndroidMediaCodec:: width(1280), height(720), stride(1280), slice-height(0), color-format(256)
15:09:41 T:1819937656 DEBUG: CDVDVideoCodecAndroidMediaCodec:: crop-left(0), crop-top(0), crop-right(1279), crop-bottom(719)
15:09:41 T:1819937656 DEBUG: CDVDVideoCodecAndroidMediaCodec:: Direct Surface Rendering
15:09:41 T:1819937656 DEBUG: CDVDVideoCodecAndroidMediaCodec:: BUFFER_FLAG_CODEC_CONFIG
15:09:41 T:1819937656 NOTICE: fps: 23.976024, pwidth: 1280, pheight: 720, dwidth: 1280, dheight: 720
15:09:41 T:1819937656 DEBUG: int CDVDPlayerVideo::OutputPicture(const DVDVideoPicture*, double) - change configuration. 1280x720. framerate: 23.98. format: MEDIACODEC
15:09:41 T:1819937656 NOTICE: Display resolution DESKTOP : 1920x1080 @ 60.00 - Full Screen (16)
15:09:41 T:1819937656 DEBUG: CXBMCRenderManager::Configure - 3
15:09:41 T:1853715088 DEBUG: CDVDPlayer::SetCaching - caching state 0
15:09:41 T:1854955288 DEBUG: CDVDPlayerAudio:: Discontinuity1 - was:22163.333333, should be:42666.666667, error:20503.333333
15:09:41 T:1689332336 DEBUG: CAnnouncementManager - Announcement: OnPlay from xbmc
15:09:41 T:1689332336 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPlay
15:09:41 T:1689332336 DEBUG: UPnP: Building didl for object '/usbdrive/TV Shows2/House MD/Season 4/House MD 4x05 - Mirror Mirror.mp4'
15:09:41 T:1689332336 DEBUG: Activating window ID: 12005
15:09:41 T:1689332336 DEBUG: ------ Window Deinit (MyVideoNav.xml) ------
15:09:41 T:1689332336 DEBUG: ------ Window Init (VideoFullScreen.xml) ------
15:09:41 T:1689332336 INFO: Loading skin file: VideoFullScreen.xml, load type: KEEP_IN_MEMORY
15:09:41 T:1689332336 DEBUG: Load VideoFullScreen.xml: 35.74ms
15:09:41 T:1689332336 DEBUG: Alloc resources: 36.39ms (36.32 ms skin load)
15:09:41 T:1689332336 NOTICE: Using GL_TEXTURE_2D
15:09:41 T:1689332336 DEBUG: GL: Requested render method: 0
15:09:41 T:1689332336 NOTICE: GL: Using MediaCodec render method
15:09:41 T:1689332336 NOTICE: GL: NPOT texture support detected
15:09:41 T:1689332336 DEBUG: CLinuxRendererGLES: Reorder drawpoints due to method change from 1 to 1024
15:09:41 T:1853715088 DEBUG: CDVDPlayer::HandleMessages - player started 2
15:09:41 T:1689332336 DEBUG: ------ Window Deinit (DialogBusy.xml) ------
15:09:42 T:1853715088 DEBUG: CDVDPlayer::SetCaching - caching state 3
15:09:42 T:1853715088 DEBUG: demuxer seek to: 30879
15:09:42 T:1853715088 DEBUG: virtual bool CDVDDemuxFFmpeg::SeekTime(int, bool, double*) - unknown position after seek
15:09:42 T:1853715088 DEBUG: demuxer seek to: 30879, success
15:09:42 T:1689332336 DEBUG: CAnnouncementManager - Announcement: OnSeek from xbmc
15:09:42 T:1689332336 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnSeek
15:09:42 T:1689332336 DEBUG: ------ Window Init (DialogSeekBar.xml) ------
15:09:42 T:1689332336 DEBUG: Window DialogSeekBar.xml was already loaded
15:09:42 T:1689332336 DEBUG: Alloc resources: 0.05m
15:09:42 T:1819937656 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE
15:09:42 T:1854955288 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE
15:09:42 T:1819937656 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC(31615000.000000, 1)
15:09:42 T:1819937656 INFO: CDVDPlayerVideo - Stillframe left, switching to normal playback
15:09:42 T:1854955288 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(31616000.000000, 0)
15:09:42 T:1853715088 DEBUG: CDVDPlayer::HandleMessages - player started 1
15:09:42 T:1853715088 DEBUG: CDVDPlayer::HandleMessages - player started 2
15:09:42 T:1853715088 DEBUG: CDVDPlayer::SetCaching - caching state 0
15:09:42 T:1854955288 DEBUG: CDVDPlayerAudio:: Discontinuity1 - was:31615655.000000, should be:31590492.669041, error:-25162.330959
15:09:42 T:1817995064 DEBUG: ### [Qlock] - Delaying 3 secs
15:09:42 T:1853715088 DEBUG: CDVDPlayer::SetCaching - caching state 3
15:09:42 T:1853715088 DEBUG: demuxer seek to: 62076
15:09:42 T:1853715088 DEBUG: virtual bool CDVDDemuxFFmpeg::SeekTime(int, bool, double*) - unknown position after seek
15:09:42 T:1853715088 DEBUG: demuxer seek to: 62076, success
15:09:42 T:1689332336 DEBUG: CAnnouncementManager - Announcement: OnSeek from xbmc
15:09:42 T:1689332336 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnSeek
15:09:42 T:1819937656 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE
15:09:42 T:1854955288 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE
15:09:42 T:1854955288 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(64000000.000000, 0)
15:09:42 T:1819937656 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC(63981000.000000, 1)
15:09:42 T:1819937656 INFO: CDVDPlayerVideo - Stillframe left, switching to normal playback
15:09:42 T:1853715088 DEBUG: CDVDPlayer::HandleMessages - player started 1
15:09:43 T:1853715088 DEBUG: CDVDPlayer::HandleMessages - player started 2
15:09:43 T:1853715088 DEBUG: CDVDPlayer::SetCaching - caching state 0
15:09:43 T:1854955288 DEBUG: CDVDPlayerAudio:: Discontinuity1 - was:63981726.000000, should be:63979546.668713, error:-2179.331287
15:09:43 T:1853715088 DEBUG: CDVDPlayer::SetCaching - caching state 3
15:09:43 T:1853715088 DEBUG: demuxer seek to: 94439
15:09:43 T:1853715088 DEBUG: virtual bool CDVDDemuxFFmpeg::SeekTime(int, bool, double*) - unknown position after seek
15:09:43 T:1853715088 DEBUG: demuxer seek to: 94439, success
15:09:43 T:1689332336 DEBUG: CAnnouncementManager - Announcement: OnSeek from xbmc
15:09:43 T:1689332336 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnSeek
15:09:43 T:1819937656 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE
15:09:43 T:1854955288 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE
15:09:43 T:1819937656 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC(94678000.000000, 1)
15:09:43 T:1819937656 INFO: CDVDPlayerVideo - Stillframe left, switching to normal playback
15:09:43 T:1854955288 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(94698666.666667, 0)
15:09:43 T:1853715088 DEBUG: CDVDPlayer::HandleMessages - player started 1
15:09:43 T:1853715088 DEBUG: CDVDPlayer::HandleMessages - player started 2
15:09:43 T:1853715088 DEBUG: CDVDPlayer::SetCaching - caching state 0
15:09:43 T:1854955288 DEBUG: CDVDPlayerAudio:: Discontinuity1 - was:94678607.335380, should be:94690714.333621, error:12106.998242
15:09:44 T:1853715088 DEBUG: CDVDPlayer::SetCaching - caching state 3
15:09:44 T:1853715088 DEBUG: demuxer seek to: 125179
15:09:44 T:1853715088 DEBUG: virtual bool CDVDDemuxFFmpeg::SeekTime(int, bool, double*) - unknown position after seek
15:09:44 T:1853715088 DEBUG: demuxer seek to: 125179, success
15:09:44 T:1689332336 DEBUG: CAnnouncementManager - Announcement: OnSeek from xbmc
15:09:44 T:1689332336 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnSeek
15:09:44 T:1819937656 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE
15:09:44 T:1854955288 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE
15:09:44 T:1819937656 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC(127878000.000000, 1)
15:09:44 T:1819937656 INFO: CDVDPlayerVideo - Stillframe left, switching to normal playback
15:09:44 T:1854955288 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(127893333.333333, 0)
15:09:44 T:1853715088 DEBUG: CDVDPlayer::HandleMessages - player started 1
15:09:44 T:1853715088 DEBUG: CDVDPlayer::HandleMessages - player started 2
15:09:44 T:1853715088 DEBUG: CDVDPlayer::SetCaching - caching state 0
15:09:44 T:1854955288 DEBUG: CDVDPlayerAudio:: Discontinuity1 - was:127879020.000000, should be:127852394.001510, error:-26625.998490
15:09:44 T:1854955288 WARNING: CDVDMessageQueue(audio)::Get - asked for new data packet, with nothing available
15:09:44 T:1817995064 DEBUG: ### [Qlock] - Delaying 3 secs
15:09:44 T:1853715088 DEBUG: CDVDPlayer::SetCaching - caching state 3
15:09:44 T:1853715088 DEBUG: demuxer seek to: 158210
15:09:44 T:1853715088 DEBUG: virtual bool CDVDDemuxFFmpeg::SeekTime(int, bool, double*) - unknown position after seek
15:09:44 T:1853715088 DEBUG: demuxer seek to: 158210, success
15:09:44 T:1689332336 DEBUG: CAnnouncementManager - Announcement: OnSeek from xbmc
15:09:44 T:1689332336 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnSeek
15:09:44 T:1819937656 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE
15:09:44 T:1854955288 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE
15:09:44 T:1819937656 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC(159618000.000000, 1)
15:09:44 T:1819937656 INFO: CDVDPlayerVideo - Stillframe left, switching to normal playback
15:09:44 T:1854955288 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(159637333.333333, 0)
15:09:44 T:1853715088 DEBUG: CDVDPlayer::HandleMessages - player started 1
15:09:44 T:1853715088 DEBUG: CDVDPlayer::HandleMessages - player started 2
15:09:44 T:1853715088 DEBUG: CDVDPlayer::SetCaching - caching state 0
15:09:44 T:1854955288 DEBUG: CDVDPlayerAudio:: Discontinuity1 - was:159618631.000000, should be:159610211.331545, error:-8419.668455
15:09:45 T:1853715088 DEBUG: CDVDPlayer::SetCaching - caching state 3
15:09:45 T:1853715088 DEBUG: demuxer seek to: 190536
15:09:45 T:1853715088 DEBUG: virtual bool CDVDDemuxFFmpeg::SeekTime(int, bool, double*) - unknown position after seek
15:09:45 T:1853715088 DEBUG: demuxer seek to: 190536, success
15:09:45 T:1689332336 DEBUG: CAnnouncementManager - Announcement: OnSeek from xbmc
15:09:45 T:1689332336 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnSeek
15:09:46 T:1819937656 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE
15:09:46 T:1854955288 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE
15:09:46 T:1819937656 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC(191316000.000000, 1)
15:09:46 T:1819937656 INFO: CDVDPlayerVideo - Stillframe left, switching to normal playback
15:09:46 T:1854955288 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(191317333.333333, 0)
15:09:46 T:1853715088 DEBUG: CDVDPlayer::HandleMessages - player started 1
15:09:46 T:1853715088 DEBUG: CDVDPlayer::HandleMessages - player started 2
15:09:46 T:1853715088 DEBUG: CDVDPlayer::SetCaching - caching state 0
15:09:46 T:1854955288 DEBUG: CDVDPlayerAudio:: Discontinuity1 - was:191316784.000000, should be:191317333.333333, error:549.333333
15:09:46 T:1817995064 DEBUG: ### [Qlock] - Delaying 3 secs
15:09:46 T:1853715088 DEBUG: CDVDPlayer::SetCaching - caching state 3
15:09:46 T:1853715088 DEBUG: demuxer seek to: 221983
15:09:46 T:1853715088 DEBUG: virtual bool CDVDDemuxFFmpeg::SeekTime(int, bool, double*) - unknown position after seek
15:09:46 T:1853715088 DEBUG: demuxer seek to: 221983, success
15:09:46 T:1689332336 DEBUG: CAnnouncementManager - Announcement: OnSeek from xbmc
15:09:46 T:1689332336 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnSeek
15:09:46 T:1819937656 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE
15:09:46 T:1854955288 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE
15:09:46 T:1819937656 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC(222389000.000000, 1)
15:09:46 T:1819937656 INFO: CDVDPlayerVideo - Stillframe left, switching to normal playback
15:09:46 T:1854955288 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(222400000.000000, 0)
15:09:46 T:1853715088 DEBUG: CDVDPlayer::HandleMessages - player started 1
15:09:46 T:1853715088 DEBUG: CDVDPlayer::HandleMessages - player started 2
15:09:46 T:1853715088 DEBUG: CDVDPlayer::SetCaching - caching state 0
15:09:46 T:1854955288 DEBUG: CDVDPlayerAudio:: Discontinuity1 - was:222391221.000000, should be:222373314.667730, error:-17906.332270
15:09:47 T:1853715088 DEBUG: CDVDPlayer::SetCaching - caching state 3
15:09:47 T:1853715088 DEBUG: demuxer seek to: 252972
15:09:47 T:1853715088 DEBUG: virtual bool CDVDDemuxFFmpeg::SeekTime(int, bool, double*) - unknown position after seek
15:09:47 T:1853715088 DEBUG: demuxer seek to: 252972, success
15:09:47 T:1689332336 DEBUG: CAnnouncementManager - Announcement: OnSeek from xbmc
15:09:47 T:1689332336 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnSeek
15:09:47 T:1819937656 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE
15:09:47 T:1854955288 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE
15:09:47 T:1819937656 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC(256339000.000000, 1)
15:09:47 T:1819937656 INFO: CDVDPlayerVideo - Stillframe left, switching to normal playback
15:09:47 T:1854955288 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(256341333.333333, 0)
15:09:47 T:1853715088 DEBUG: CDVDPlayer::HandleMessages - player started 1
15:09:47 T:1853715088 DEBUG: CDVDPlayer::HandleMessages - player started 2
15:09:47 T:1853715088 DEBUG: CDVDPlayer::SetCaching - caching state 0
15:09:47 T:1854955288 DEBUG: CDVDPlayerAudio:: Discontinuity1 - was:256339908.000000, should be:256276410.002941, error:-63497.997059
15:09:48 T:1817995064 DEBUG: ### [Qlock] - Delaying 3 secs
15:09:49 T:1854955288 DEBUG: CDVDPlayerAudio:: Discontinuity2 - was:258304341.002941, should be:258283361.096725, error:-20979.906215
15:09:50 T:1689332336 DEBUG: ------ Window Deinit (DialogSeekBar.xml) ------
15:09:50 T:1817995064 DEBUG: ### [Qlock] - Delaying 3 secs
15:09:51 T:1854955288 DEBUG: CDVDPlayerAudio:: Discontinuity2 - was:260310506.096725, should be:260289028.642679, error:-21477.454047
15:09:52 T:1817995064 DEBUG: ### [Qlock] - Delaying 3 secs
15:09:52 T:1819937656 DEBUG: CPullupCorrection: detected pattern of length 1: 41708.34, frameduration: 41708.333333
15:09:54 T:1817995064 DEBUG: ### [Qlock] - Delaying 3 secs
15:10:00 T:1689332336 DEBUG: Previous line repeats 2 times.
15:10:00 T:1689332336 INFO: void XCURL::DllLibCurlGlobal::CheckIdle() - Closing session to http://www.google.com (easy=0x6cc0cc60, multi=0x0)
15:10:00 T:1817995064 DEBUG: ### [Qlock] - Delaying 240 secs
15:10:09 T:1831374776 DEBUG: Thread JobWorker 1831374776 terminating (autodelete)
15:10:09 T:1828207136 DEBUG: Thread JobWorker 1828207136 terminating (autodelete)
15:10:09 T:1865016160 DEBUG: Thread JobWorker 1865016160 terminating (autodelete)
15:10:09 T:1851131944 DEBUG: Thread JobWorker 1851131944 terminating (autodelete)
15:12:03 T:1854955288 ERROR: CDVDAudio::AddPacketsRenderer - timeout adding data to renderer
15:12:03 T:1854955288 DEBUG: CDVDPlayerAudio:: Discontinuity1 - was:391830581.642679, should be:390656000.000000, error:-1174581.642679
15:12:04 T:1819937656 WARNING: CDVDMessageQueue(video)::Get - asked for new data packet, with nothing available
15:12:04 T:1819937656 INFO: CDVDPlayerVideo - Stillframe detected, switching to forced 23.976024 fps
15:12:04 T:1819937656 DEBUG: CPullupCorrection: pattern lost on diff 208541.666667
15:12:04 T:1819937656 ERROR: CDVDMediaCodecInfo::ReleaseOutputBuffer ExceptionOccurred render(1)
15:12:04 T:1854955288 ERROR: Previous line repeats 5 times.
15:12:04 T:1854955288 ERROR: CDVDAudio::AddPacketsRenderer - timeout adding data to renderer
15:12:04 T:1854955288 ERROR: unsigned int CDVDAudio::AddPackets(const DVDAudioFrame&) - failed to add leftover bytes to render
15:12:04 T:1854955288 DEBUG: CDVDPlayerAudio:: Discontinuity1 - was:392066199.000000, should be:390677333.333333, error:-1388865.666667
15:12:04 T:1819937656 ERROR: CDVDMediaCodecInfo::ReleaseOutputBuffer ExceptionOccurred render(1)
15:12:06 T:1854955288 ERROR: Previous line repeats 24 times.
15:12:06 T:1854955288 ERROR: CDVDAudio::AddPacketsRenderer - timeout adding data to renderer
15:12:06 T:1854955288 DEBUG: CDVDPlayerAudio:: Discontinuity1 - was:392086833.333333, should be:390677333.333333, error:-1409500.000000
15:12:06 T:1819937656 ERROR: CDVDMediaCodecInfo::ReleaseOutputBuffer ExceptionOccurred render(1)
15:12:06 T:1819937656 INFO: CDVDPlayerVideo - Stillframe left, switching to normal playback
15:12:06 T:1819937656 INFO: CDVDPlayerVideo - Stillframe detected, switching to forced 23.976024 fps
15:12:06 T:1819937656 ERROR: CDVDMediaCodecInfo::ReleaseOutputBuffer ExceptionOccurred render(1)
15:12:07 T:1854955288 ERROR: Previous line repeats 16 times.
15:12:07 T:1854955288 ERROR: CDVDAudio::AddPacketsRenderer - timeout adding data to renderer
15:12:07 T:1854955288 ERROR: unsigned int CDVDAudio::AddPackets(const DVDAudioFrame&) - failed to add leftover bytes to render
15:12:07 T:1854955288 DEBUG: CDVDPlayerAudio:: Discontinuity1 - was:392087363.333333, should be:390720000.000000, error:-1367363.333333
15:12:07 T:1819937656 ERROR: CDVDMediaCodecInfo::ReleaseOutputBuffer ExceptionOccurred render(1)
15:12:08 T:1854955288 ERROR: Previous line repeats 8 times.
15:12:08 T:1854955288 DEBUG: CDVDPlayerAudio:: Discontinuity1 - was:391213135.001000, should be:390720000.000000, error:-493135.001000
15:12:08 T:1819937656 ERROR: CDVDMediaCodecInfo::ReleaseOutputBuffer ExceptionOccurred render(1)
15:12:08 T:1819937656 INFO: CDVDPlayerVideo - Stillframe left, switching to normal playback
15:12:08 T:1819937656 WARNING: CDVDMessageQueue(video)::Get - asked for new data packet, with nothing available
15:12:08 T:1854955288 DEBUG: CDVDPlayerAudio:: Discontinuity1 - was:391188620.000000, should be:390761981.316008, error:-426638.683992
15:12:08 T:1819937656 WARNING: CDVDMessageQueue(video)::Get - asked for new data packet, with nothing available
15:12:08 T:1854955288 DEBUG: CDVDPlayerAudio:: Discontinuity1 - was:391146216.316008, should be:391040000.000000, error:-106216.316008
15:12:09 T:1819937656 WARNING: CDVDMessageQueue(video)::Get - asked for new data packet, with nothing available
15:12:09 T:1854955288 DEBUG: CDVDPlayerAudio:: Discontinuity1 - was:391167706.000000, should be:391061953.339373, error:-105752.660627
15:12:09 T:1819937656 WARNING: CDVDMessageQueue(video)::Get - asked for new data packet, with nothing available
15:12:09 T:1854955288 DEBUG: CDVDPlayerAudio:: Discontinuity1 - was:391386615.339373, should be:391210666.666667, error:-175948.672707
15:12:09 T:1819937656 WARNING: CDVDMessageQueue(video)::Get - asked for new data packet, with nothing available
15:12:09 T:1854955288 DEBUG: CDVDPlayerAudio:: Discontinuity1 - was:391531148.666667, should be:391381333.333333, error:-149815.333333
15:12:09 T:1854955288 DEBUG: CDVDPlayerAudio:: Discontinuity1 - was:391531006.333333, should be:391404386.316565, error:-126620.016769
15:12:11 T:1819937656 WARNING: CDVDMessageQueue(video)::Get - asked for new data packet, with nothing available
15:12:13 T:1689332336 WARNING: Previous line repeats 9 times.
15:12:13 T:1689332336 DEBUG: Keyboard: scancode: 0x52, sym: 0x013f, unicode: 0x0000, modifier: 0x0
15:12:13 T:1689332336 DEBUG: bool CApplication::OnKey(const CKey&): menu (0xf0d8) pressed, action is ContextMenu
15:12:14 T:1819937656 WARNING: CDVDMessageQueue(video)::Get - asked for new data packet, with nothing available
15:12:16 T:1689332336 WARNING: Previous line repeats 6 times.
15:12:16 T:1689332336 DEBUG: CAnnouncementManager - Announcement: OnPause from xbmc
15:12:16 T:1689332336 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPause
15:12:16 T:1689332336 DEBUG: ------ Window Init (DialogSeekBar.xml) ------
15:12:16 T:1689332336 DEBUG: Window DialogSeekBar.xml was already loaded
15:12:16 T:1689332336 DEBUG: Alloc resources: 59.83m
15:12:17 T:1854955288 DEBUG: CDVDPlayerAudio:: Discontinuity1 - was:398187647.316565, should be:398634673.660587, error:447026.344022
15:12:17 T:1689332336 DEBUG: CAnnouncementManager - Announcement: OnPlay from xbmc
15:12:17 T:1689332336 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPlay
15:12:17 T:1689332336 DEBUG: UPnP: Building didl for object '/usbdrive/TV Shows2/House MD/Season 4/House MD 4x05 - Mirror Mirror.mp4'
15:12:17 T:1819937656 WARNING: CDVDMessageQueue(video)::Get - asked for new data packet, with nothing available
15:12:17 T:1689332336 DEBUG: ------ Window Deinit (DialogSeekBar.xml) ------
15:12:17 T:1853715088 DEBUG: CDVDPlayer::SetCaching - caching state 3
15:12:17 T:1853715088 DEBUG: demuxer seek to: 428942
15:12:17 T:1853715088 DEBUG: virtual bool CDVDDemuxFFmpeg::SeekTime(int, bool, double*) - unknown position after seek
15:12:17 T:1853715088 DEBUG: demuxer seek to: 428942, success
15:12:17 T:1689332336 DEBUG: CAnnouncementManager - Announcement: OnSeek from xbmc
15:12:17 T:1689332336 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnSeek
15:12:17 T:1689332336 DEBUG: ------ Window Init (DialogSeekBar.xml) ------
15:12:17 T:1689332336 DEBUG: Window DialogSeekBar.xml was already loaded
15:12:17 T:1689332336 DEBUG: Alloc resources: 0.94m
15:12:18 T:1689332336 DEBUG: Keyboard: scancode: 0x52, sym: 0x013f, unicode: 0x0000, modifier: 0x0
15:12:18 T:1689332336 DEBUG: bool CApplication::OnKey(const CKey&): menu (0xf0d8) pressed, action is ContextMenu
15:12:18 T:1853715088 DEBUG: CDVDPlayer::SetCaching - caching state 0
15:12:18 T:1854955288 ERROR: CDVDAudio::AddPacketsRenderer - timeout adding data to renderer
15:12:18 T:1854955288 DEBUG: CDVDPlayerAudio:: Discontinuity1 - was:428977314.000000, should be:399274666.666667, error:-29702647.333333
15:12:18 T:1853715088 DEBUG: CDVDPlayer::HandleMessages - player started 1
15:12:19 T:1854955288 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE
15:12:19 T:1854955288 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(429888000.000000, 0)
15:12:20 T:1691606544 ERROR: ActiveAE::void ActiveAE::CActiveAE::FlushEngine() - failed to flush
15:12:21 T:1854955288 ERROR: CDVDAudio::AddPacketsRenderer - timeout adding data to renderer
15:12:21 T:1854955288 DEBUG: CDVDPlayerAudio:: Discontinuity1 - was:401895747.666667, should be:429888000.000000, error:27992252.333333
15:12:21 T:1853715088 DEBUG: CDVDPlayer::HandleMessages - player started 1
15:12:21 T:1689332336 DEBUG: ------ Window Deinit (DialogSeekBar.xml) ------
15:12:22 T:1854955288 ERROR: CDVDAudio::AddPacketsRenderer - timeout adding data to renderer
15:12:22 T:1854955288 ERROR: unsigned int CDVDAudio::AddPackets(const DVDAudioFrame&) - failed to add leftover bytes to render
15:12:22 T:1854955288 DEBUG: CDVDPlayerAudio:: Discontinuity1 - was:431096151.000000, should be:429888000.000000, error:-1208151.000000
15:12:22 T:1691606544 ERROR: ActiveAE::void ActiveAE::CActiveAE::FlushEngine() - failed to flush
15:12:23 T:1854955288 DEBUG: CDVDPlayerAudio:: Discontinuity1 - was:430781407.000000, should be:429888000.000000, error:-893407.000000
15:12:24 T:1854955288 DEBUG: CDVDPlayerAudio:: Discontinuity1 - was:430553390.000000, should be:429888000.000000, error:-665390.000000
15:12:24 T:1689332336 DEBUG: CAnnouncementManager - Announcement: OnPause from xbmc
15:12:24 T:1689332336 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPause
15:12:24 T:1689332336 DEBUG: Keyboard: scancode: 0x52, sym: 0x013f, unicode: 0x0000, modifier: 0x0
15:12:24 T:1689332336 DEBUG: bool CApplication::OnKey(const CKey&): menu (0xf0d8) pressed, action is ContextMenu
15:12:24 T:1689332336 DEBUG: Keyboard: scancode: 0x52, sym: 0x013f, unicode: 0x0000, modifier: 0x0
15:12:24 T:1689332336 DEBUG: bool CApplication::OnKey(const CKey&): menu (0xf0d8) pressed, action is ContextMenu
15:12:24 T:1689332336 DEBUG: bool CWinSystemEGL::CreateWindow(RESOLUTION_INFO&): Created surface of size 1920x1080
15:12:24 T:1689332336 NOTICE: GL_VENDOR = NVIDIA Corporation
15:12:24 T:1689332336 NOTICE: GL_RENDERER = NVIDIA Tegra 3
15:12:24 T:1689332336 NOTICE: GL_VERSION = OpenGL ES 2.0 16.05001
15:12:24 T:1689332336 NOTICE: GL_SHADING_LANGUAGE_VERSION = OpenGL ES GLSL 1.00
15:12:24 T:1689332336 DEBUG: GLES: Extension Support Test - GL_NVX_gpu_memory_info NO
15:12:24 T:1689332336 NOTICE: GL_EXTENSIONS = GL_OES_rgb8_rgba8 GL_OES_EGL_sync GL_OES_surfaceless_context GL_OES_fbo_render_mipmap GL_NV_depth_nonlinear GL_NV_draw_path GL_NV_draw_texture GL_NV_texture_npot_2D_mipmap GL_OES_EGL_image GL_OES_EGL_image_external GL_OES_vertex_half_float GL_OES_mapbuffer GL_NV_draw_buffers GL_NV_multiview_draw_buffers GL_EXT_Cg_shader GL_EXT_packed_float GL_OES_texture_half_float GL_EXT_texture_array GL_OES_compressed_ETC1_RGB8_texture GL_EXT_texture_compression_latc GL_NV_texture_compression_latc GL_EXT_texture_compression_dxt1 GL_EXT_texture_compression_s3tc GL_NV_texture_compression_s3tc GL_EXT_texture_filter_anisotropic GL_NV_get_tex_image GL_NV_read_buffer GL_NV_shader_framebuffer_fetch GL_NV_copy_image GL_NV_fbo_color_attachments GL_EXT_bgra GL_EXT_texture_format_BGRA8888 GL_EXT_read_format_bgra GL_EXT_unpack_subimage GL_NV_pack_subimage GL_NV_texture_compression_s3tc_update GL_NV_read_depth GL_NV_read_stencil GL_NV_uniform_buffer_object GL_NV_map_buffer_range GL_EXT_robustness GL_OES_standard_derivatives GL_NV_EGL_stream_consumer_external GL_EXT_separate_shader_objects GL_NV_copy_buffer GL_NV_3dvision_settings GL_EXT_debug_marker GL_EXT_debug_label GL_KHR_debug GL_EXT_texture_storage GL_NV_pixel_buffer_object GL_NV_framebuffer_blit GL_NV_non_square_matrices GL_NV_explicit_attrib_location GL_OES_vertex_array_object GL_NV_smooth_points_lines GL_NV_coverage_sample GL_EXT_occlusion_query_boolean GL_NV_occlusion_query_samples GL_NV_timer_query
15:12:24 T:1689332336 DEBUG: GLES: Extension Support Test - GL_EXT_texture_format_BGRA8888 YES
15:12:24 T:1689332336 DEBUG: GLES: Extension Support Test - GL_IMG_texture_format_BGRA8888 NO
15:12:24 T:1689332336 DEBUG: GLES: Extension Support Test - GL_APPLE_texture_format_BGRA8888 NO
15:12:24 T:1689332336 DEBUG: GUI Shader - Tried to Initialise again. Was this intentional?
15:12:24 T:1689332336 DEBUG: ------ Window Init (DialogSeekBar.xml) ------
15:12:24 T:1689332336 DEBUG: Window DialogSeekBar.xml was already loaded
15:12:24 T:1689332336 DEBUG: Alloc resources: 0.26m
15:12:24 T:1689332336 INFO: GLES: Enabling VSYNC
15:12:24 T:1689332336 INFO: GLES: Selected vsync mode 10
15:12:26 T:1689332336 DEBUG: Keyboard: scancode: 0x52, sym: 0x013f, unicode: 0x0000, modifier: 0x0
15:12:26 T:1689332336 DEBUG: bool CApplication::OnKey(const CKey&): menu (0xf0d8) pressed, action is ContextMenu