koying / SPMC

fork of xbmc/kodi
Other
632 stars 257 forks source link

Helix shows video at 1/4 size in the top left corner on Amlogic 805 #41

Closed mapfde closed 8 years ago

mapfde commented 9 years ago

Hi,

I use SPMC on the "MK808B plus" Android TV stick. It is using an Amlogic 805 core, with 1 GB Ram and 8 GB Flash. The latest firmware is installed (109K4).

SPMC 13.x works fine, SPMC 14.x shows HW accelerated video in 1/4 size in the top left corner. I checked for possible device permission problems, but all the devices (/dev/am*) and system files that I found mentioned in some forum threads at freaktab are mode 666.

Is there anything I can do to help debug the issue?

joannmark commented 9 years ago

I too have the exact same problem with driodbox. Only work around is to disable hardware decoding, resulting in stutters on playback.

mapfde commented 9 years ago

The same error is present in the android nightly builds.

OskarW85 commented 9 years ago

I'm using S802 based TV box (Tronsmart Vega) and experience this too. This error however was fixed in Helix 14.1 (not in 15.0 nightly) and specifically mentioned in changelog. Perhaps some rebasing problem on SPMC side?

rpgsoftware commented 9 years ago

I think I'm experiencing this too. I'm using SPMC on a Minix X8-H plus. 13.4 works well.

mapfde commented 9 years ago

Hello,

this issue persists with all newer Kodi builds for android. I re-checked the permissions on my device but could not find any that are restricted. Could you please guide me to a complete list of neccessary permissions? Or is there an app to check/reset permissions on amlogic devices?

koying commented 9 years ago

Permissions are: system("su -c chmod 666 /dev/amvideo"); system("su -c chmod 666 /dev/amstream*"); system("su -c chmod 666 /sys/class/video/axis"); system("su -c chmod 666 /sys/class/video/screen_mode"); system("su -c chmod 666 /sys/class/video/disable_video"); system("su -c chmod 666 /sys/class/tsync/pts_pcrscr"); system("su -c chmod 666 /sys/class/audiodsp/digital_raw"); system("su -c chmod 666 /sys/class/ppmgr/ppmgr_3d_mode");

Note that the Minix boxes I use as reference, so if you're using the stock firmware, it should just work.

prahjister commented 9 years ago

So running a script once or every boot will fix the 1/4 screen issue?

mapfde commented 9 years ago

Thank you for responding, koying.

Today I checked the permissions again on my MK808B+ with stock rom. The only differences from the permissions you listed were /sys/class/audiodsp/digital_raw (664 instead of 666) /sys/class/ppmgr/ppmgr_3d_mode (file does not exist).

Changing the wrong permissions of digital_raw to 666 did not help with the problem.

A few more things that I have noticed:

koying commented 9 years ago

Could you do an "adb shell cat /sys/class/ppmgr/ppscaler" during playback and report the result, please. A debug log would also be useful.

mapfde commented 9 years ago

Hello,

playing back a 720p MP4 h264 video downloaded from youtube using a chrome plugin. (https://www.youtube.com/watch?v=_qStuflPUF8). I connected using a local ssh server instead of adb.

on SPMC 13.4 (video plays perfectly) u0_a82@m201:/ $ cat /sys/class/ppmgr/ppscaler current ppscaler mode is disabled

on Kodi 14.2 (video plays perfectly) u0_a82@m201:/ $ cat /sys/class/ppmgr/ppscaler current ppscaler mode is disabled

on SPMC 14.2 (small video) u0_a82@m201:/ $ cat /sys/class/ppmgr/ppscaler current ppscaler mode is disabled

All three versions request and get SU privileges.

Log outputs in seperate comments.

EDIT: Kodi 14.2 locks the resolution to 720p and does not allow to change resolution. So the video is fine, but one cannot use 1080p :(

mapfde commented 9 years ago

Log output from SPMC 14.2 (small video)

19:12:27 T:1723522200 NOTICE: special://profile/ is mapped to: special://masterprofile/ 19:12:27 T:1723522200 NOTICE: ----------------------------------------------------------------------- 19:12:27 T:1723522200 NOTICE: Starting spmc (14.2 Git:2015-04-03-0e5bbc5). Platform: Android ARM 32-bit 19:12:27 T:1723522200 NOTICE: Using Release spmc x32 build 19:12:27 T:1723522200 NOTICE: spmc compiled Apr 3 2015 by GCC 4.8.0 for Android ARM 32-bit API level 14 (API level 14) 19:12:27 T:1723522200 NOTICE: Running on MBX MK808B Plus with Android 4.4.2 API level 19, kernel: Linux ARM 32-bit version 3.10.33 19:12:27 T:1723522200 NOTICE: FFmpeg version: 14.2-Helix-213-g9d4aeb5-xbmc-2.4.6-Helix 19:12:27 T:1723522200 NOTICE: Host CPU: ARMv7 Processor rev 1 (v7l), 2 cores available 19:12:27 T:1723522200 NOTICE: Product: m201, Device: m201, Board: m201 - Manufacturer: MBX, Brand: MBX, Model: MK808B Plus, Hardware: amlogic 19:12:27 T:1723522200 NOTICE: ARM Features: Neon enabled 19:12:27 T:1723522200 NOTICE: special://xbmc/ is mapped to: /data/data/com.semperpax.spmc/cache/apk/assets 19:12:27 T:1723522200 NOTICE: special://xbmcbin/ is mapped to: /data/data/com.semperpax.spmc/cache/apk/assets 19:12:27 T:1723522200 NOTICE: special://masterprofile/ is mapped to: /storage/emulated/0/Android/data/com.semperpax.spmc/files/.spmc/userdata 19:12:27 T:1723522200 NOTICE: special://home/ is mapped to: /storage/emulated/0/Android/data/com.semperpax.spmc/files/.spmc 19:12:27 T:1723522200 NOTICE: special://temp/ is mapped to: /storage/emulated/0/Android/data/com.semperpax.spmc/files/.spmc/temp 19:12:27 T:1723522200 NOTICE: The executable running is: 19:12:27 T:1723522200 NOTICE: Local hostname: localhost 19:12:27 T:1723522200 NOTICE: Log File is located: /storage/emulated/0/Android/data/com.semperpax.spmc/files/.spmc/temp/spmc.log 19:12:27 T:1723522200 NOTICE: ----------------------------------------------------------------------- 19:12:27 T:1723522200 NOTICE: load settings... 19:12:27 T:1723522200 DEBUG: static int CAndroidFeatures::GetVersion(): android.os.Build.VERSION 19 19:12:27 T:1723522200 NOTICE: AML device detected 19:12:27 T:1723522200 DEBUG: CSettings: loaded settings definition from special://xbmc/system/settings/settings.xml 19:12:27 T:1723522200 WARNING: CSettingInt: unknown options filler "audiocdactions" of "audiocds.autoaction" 19:12:27 T:1723522200 DEBUG: CSettings: loaded settings definition from special://xbmc/system/settings/android.xml 19:12:27 T:1723522200 ERROR: CSettingGroup: unable to read setting type of "input.remoteaskeyboard" 19:12:27 T:1723522200 WARNING: CSettingCategory: unable to read group "2" 19:12:27 T:1723522200 NOTICE: Found 1 Lists of Devices 19:12:27 T:1723522200 NOTICE: Enumerated AUDIOTRACK devices: 19:12:27 T:1723522200 NOTICE: Device 1 19:12:27 T:1723522200 NOTICE: m_deviceName : AudioTrack 19:12:27 T:1723522200 NOTICE: m_displayName : android 19:12:27 T:1723522200 NOTICE: m_displayNameExtra: audiotrack 19:12:27 T:1723522200 NOTICE: m_deviceType : AE_DEVTYPE_HDMI 19:12:27 T:1723522200 NOTICE: m_channels : FL,FR,FC,LFE,BL,BR 19:12:27 T:1723522200 NOTICE: m_sampleRates : 48000,48000 19:12:27 T:1723522200 NOTICE: m_dataFormats : AE_FMT_S16LE,AE_FMT_AC3,AE_FMT_DTS 19:12:27 T:1723522200 NOTICE: No settings file to load (special://xbmc/system/advancedsettings.xml) 19:12:27 T:1723522200 NOTICE: No settings file to load (special://masterprofile/advancedsettings.xml) 19:12:27 T:1723522200 NOTICE: Default DVD Player: dvdplayer 19:12:27 T:1723522200 NOTICE: Default Video Player: dvdplayer 19:12:27 T:1723522200 NOTICE: Default Audio Player: paplayer 19:12:27 T:1723522200 NOTICE: Disabled debug logging due to GUI setting. Level 0. 19:12:27 T:1723522200 NOTICE: Log level changed to "LOG_LEVEL_NORMAL" 19:12:27 T:1723522200 NOTICE: CMediaSourceSettings: loading media sources from special://masterprofile/sources.xml 19:12:27 T:1723522200 NOTICE: Loading player core factory settings from special://xbmc/system/playercorefactory.xml. 19:12:27 T:1723522200 NOTICE: Loaded playercorefactory configuration 19:12:27 T:1723522200 NOTICE: Loading player core factory settings from special://masterprofile/playercorefactory.xml. 19:12:27 T:1723522200 NOTICE: special://masterprofile/playercorefactory.xml does not exist. Skipping. 19:12:27 T:1805598832 NOTICE: Thread ActiveAE start, auto delete: false 19:12:27 T:1805599416 NOTICE: Thread AESink start, auto delete: false 19:12:27 T:1805599416 ERROR: SetInt: error writing /sys/class/audiodsp/digital_raw 19:12:27 T:1723522200 NOTICE: Running database version Addons16 19:12:27 T:1723522200 NOTICE: ADDONS: Using repository repository.xbmc.org 19:12:27 T:1723522200 ERROR: Unable to load libcec.so, reason: (null) 19:12:27 T:1723522200 ERROR: virtual void PERIPHERALS::CPeripherals::Initialise() - failed to initialise bus cec 19:12:27 T:1813235072 NOTICE: Thread PeripBusUSB start, auto delete: false 19:12:30 T:1723522200 ERROR: GetString: error reading /sys/class/net/eth0/operstate 19:12:30 T:1723522200 NOTICE: virtual bool CWinSystemEGL::InitWindowSystem(): Using EGL Implementation: amlandroid 19:12:30 T:1723522200 NOTICE: Current resolution: 1280x720 @ 60.00 - Full Screen 19:12:30 T:1723522200 NOTICE: Previous line repeats 1 times. 19:12:30 T:1723522200 NOTICE: Desktop resolution 1280 x 720 for display 0 with 1920 x 1080 @ 50.000000 Hz 19:12:30 T:1723522200 NOTICE: Found resolution 1280 x 720 for display 0 with 1280 x 720 @ 60.000000 Hz 19:12:30 T:1723522200 NOTICE: Found resolution 1280 x 720 for display 0 with 1920 x 1080i @ 60.000000 Hz 19:12:30 T:1723522200 NOTICE: Found resolution 1280 x 720 for display 0 with 1920 x 1080 @ 60.000000 Hz 19:12:30 T:1723522200 NOTICE: Found resolution 1280 x 720 for display 0 with 1280 x 720 @ 50.000000 Hz 19:12:30 T:1723522200 NOTICE: Found resolution 1280 x 720 for display 0 with 1920 x 1080i @ 50.000000 Hz 19:12:30 T:1723522200 NOTICE: Found resolution 1280 x 720 for display 0 with 1920 x 1080 @ 50.000000 Hz 19:12:30 T:1723522200 NOTICE: Found resolution 1280 x 720 for display 0 with 1920 x 1080 @ 47.900002 Hz 19:12:30 T:1723522200 NOTICE: Found (1280x720@50.000000) at 21, setting to RES_DESKTOP at 16 19:12:30 T:1723522200 NOTICE: Checking resolution 16 19:12:31 T:1723522200 NOTICE: GL_VENDOR = ARM 19:12:31 T:1723522200 NOTICE: GL_RENDERER = Mali-450 MP 19:12:31 T:1723522200 NOTICE: GL_VERSION = OpenGL ES 2.0 19:12:31 T:1723522200 NOTICE: GL_SHADING_LANGUAGE_VERSION = OpenGL ES GLSL ES 1.00 19:12:31 T:1723522200 NOTICE: GL_EXTENSIONS = GL_EXT_debug_marker GL_OES_texture_npot GL_OES_compressed_ETC1_RGB8_texture GL_OES_standard_derivatives GL_OES_EGL_image GL_OES_depth24 GL_ARM_rgba8 GL_ARM_mali_shader_binary GL_OES_depth_texture GL_OES_packed_depth_stencil GL_EXT_texture_format_BGRA8888 GL_OES_vertex_half_float GL_EXT_blend_minmax GL_OES_EGL_image_external GL_OES_EGL_sync GL_OES_rgb8_rgba8 GL_EXT_multisampled_render_to_texture GL_EXT_discard_framebuffer GL_OES_get_program_binary GL_ARM_mali_program_binary GL_EXT_shader_texture_lod GL_EXT_robustness GL_OES_depth_texture_cube_map GL_KHR_debug 19:12:31 T:1723522200 NOTICE: Current resolution: 1280x720 @ 60.00 - Full Screen 19:12:31 T:1723522200 NOTICE: No Joystick name specified, loading default map 19:12:31 T:1723522200 NOTICE: Previous line repeats 36 times. 19:12:31 T:1723522200 NOTICE: Running database version Addons16 19:12:31 T:1723522200 NOTICE: Running database version ViewModes6 19:12:31 T:1723522200 NOTICE: Running database version Textures13 19:12:31 T:1723522200 NOTICE: Running database version MyMusic48 19:12:31 T:1723522200 NOTICE: Running database version MyVideos90 19:12:31 T:1723522200 NOTICE: Running database version TV26 19:12:31 T:1723522200 NOTICE: Running database version Epg8 19:12:32 T:1723522200 WARNING: JSONRPC: Could not parse type "PVR.Details.Channel" 19:12:32 T:1723522200 WARNING: JSONRPC: Could not parse type "PVR.Details.ChannelGroup.Extended" 19:12:32 T:1723522200 WARNING: JSONRPC: Could not parse type "GUI.Property.Value" 19:12:32 T:1723522200 WARNING: JSONRPC: Could not parse type "Setting.Details.SettingList" 19:12:32 T:1723522200 NOTICE: initialize done 19:12:32 T:1723522200 NOTICE: Running the application... 19:12:32 T:1837350760 NOTICE: Thread JobWorker start, auto delete: true 19:12:32 T:1723522200 NOTICE: starting zeroconf publishing 19:12:32 T:1840609592 NOTICE: Thread ZerocconfEmbedded start, auto delete: false 19:12:32 T:1723522200 NOTICE: ES: Starting event server 19:12:32 T:1840829000 NOTICE: Thread JobWorker start, auto delete: true 19:12:32 T:1840851976 NOTICE: Thread EventServer start, auto delete: false 19:12:32 T:1840851976 NOTICE: ES: Starting UDP Event server on 0.0.0.0:9777 19:12:32 T:1840758400 NOTICE: Thread TCPServer start, auto delete: false 19:12:32 T:1840851976 NOTICE: UDP: Listening on port 9777 19:12:32 T:1723522200 NOTICE: Current resolution: 1280x720 @ 60.00 - Full Screen 19:12:32 T:1723522200 NOTICE: GL_VENDOR = ARM 19:12:32 T:1723522200 NOTICE: GL_RENDERER = Mali-450 MP 19:12:32 T:1723522200 NOTICE: GL_VERSION = OpenGL ES 2.0 19:12:32 T:1723522200 NOTICE: GL_SHADING_LANGUAGE_VERSION = OpenGL ES GLSL ES 1.00 19:12:32 T:1723522200 NOTICE: GL_EXTENSIONS = GL_EXT_debug_marker GL_OES_texture_npot GL_OES_compressed_ETC1_RGB8_texture GL_OES_standard_derivatives GL_OES_EGL_image GL_OES_depth24 GL_ARM_rgba8 GL_ARM_mali_shader_binary GL_OES_depth_texture GL_OES_packed_depth_stencil GL_EXT_texture_format_BGRA8888 GL_OES_vertex_half_float GL_EXT_blend_minmax GL_OES_EGL_image_external GL_OES_EGL_sync GL_OES_rgb8_rgba8 GL_EXT_multisampled_render_to_texture GL_EXT_discard_framebuffer GL_OES_get_program_binary GL_ARM_mali_program_binary GL_EXT_shader_texture_lod GL_EXT_robustness GL_OES_depth_texture_cube_map GL_KHR_debug 19:12:32 T:1842577608 NOTICE: Thread RSSReader start, auto delete: false 19:12:46 T:1871049104 NOTICE: Thread BackgroundLoader start, auto delete: false 19:12:51 T:1723522200 NOTICE: Previous line repeats 1 times. 19:12:51 T:1723522200 NOTICE: DVDPlayer: Opening: /sdcard/Lego Hampocalypse [720p].mp4 19:12:51 T:1723522200 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED 19:12:51 T:1845982944 NOTICE: Thread DVDPlayer start, auto delete: false 19:12:51 T:1845982944 NOTICE: Creating InputStream 19:12:51 T:1845982944 NOTICE: Creating Demuxer 19:12:51 T:1845982944 NOTICE: Opening stream: 0 source: 256 19:12:51 T:1845982944 NOTICE: Creating video codec with codec id: 28 19:12:51 T:1845982944 NOTICE: Creating video thread 19:12:51 T:1846460232 NOTICE: Thread DVDPlayerVideo start, auto delete: false 19:12:51 T:1845982944 NOTICE: Opening stream: 1 source: 256 19:12:51 T:1846460232 NOTICE: running thread: video_thread 19:12:51 T:1845982944 NOTICE: Finding audio codec for: 86018 19:12:51 T:1845982944 NOTICE: Creating audio thread 19:12:51 T:1860820224 NOTICE: Thread DVDPlayerAudio start, auto delete: false 19:12:51 T:1860820224 NOTICE: running thread: CDVDPlayerAudio::Process() 19:12:51 T:1860820224 NOTICE: Creating audio stream (codec id: 86018, channels: 2, sample rate: 44100, no pass-through) 19:12:51 T:1846460232 ERROR: SetInt: error writing /sys/class/tsync/enable 19:12:51 T:1860871056 NOTICE: Thread CAMLCodec start, auto delete: false 19:12:51 T:1846460232 NOTICE: fps: 29.970030, pwidth: 1280, pheight: 720, dwidth: 1280, dheight: 720 19:12:51 T:1846460232 NOTICE: Display resolution DESKTOP : 1920x1080 @ 50.00 - Full Screen (16) 19:12:51 T:1723522200 NOTICE: Using GL_TEXTURE_2D 19:12:51 T:1723522200 NOTICE: GL: Using BYPASS render method 19:12:51 T:1723522200 NOTICE: GL: NPOT texture support detected 19:12:51 T:1723522200 ERROR: SetInt: error writing /sys/class/video/contrast 19:12:51 T:1723522200 ERROR: SetInt: error writing /sys/class/video/brightness 19:13:41 T:1723522200 NOTICE: GL_VENDOR = ARM 19:13:41 T:1723522200 NOTICE: GL_RENDERER = Mali-450 MP 19:13:41 T:1723522200 NOTICE: GL_VERSION = OpenGL ES 2.0 19:13:41 T:1723522200 NOTICE: GL_SHADING_LANGUAGE_VERSION = OpenGL ES GLSL ES 1.00 19:13:41 T:1723522200 NOTICE: GL_EXTENSIONS = GL_EXT_debug_marker GL_OES_texture_npot GL_OES_compressed_ETC1_RGB8_texture GL_OES_standard_derivatives GL_OES_EGL_image GL_OES_depth24 GL_ARM_rgba8 GL_ARM_mali_shader_binary GL_OES_depth_texture GL_OES_packed_depth_stencil GL_EXT_texture_format_BGRA8888 GL_OES_vertex_half_float GL_EXT_blend_minmax GL_OES_EGL_image_external GL_OES_EGL_sync GL_OES_rgb8_rgba8 GL_EXT_multisampled_render_to_texture GL_EXT_discard_framebuffer GL_OES_get_program_binary GL_ARM_mali_program_binary GL_EXT_shader_texture_lod GL_EXT_robustness GL_OES_depth_texture_cube_map GL_KHR_debug 19:15:21 T:1723522200 NOTICE: CDVDPlayer::CloseFile() 19:15:21 T:1723522200 NOTICE: DVDPlayer: waiting for threads to exit 19:15:21 T:1845982944 NOTICE: CDVDPlayer::OnExit() 19:15:21 T:1845982944 NOTICE: Closing stream player 1 19:15:21 T:1845982944 NOTICE: Waiting for audio thread to exit 19:15:21 T:1860820224 NOTICE: thread end: CDVDPlayerAudio::OnExit() 19:15:21 T:1845982944 NOTICE: Closing audio device 19:15:21 T:1845982944 NOTICE: Deleting audio codec 19:15:21 T:1845982944 NOTICE: Closing stream player 2 19:15:21 T:1845982944 NOTICE: waiting for video thread to exit 19:15:21 T:1846460232 NOTICE: thread end: video_thread 19:15:21 T:1845982944 NOTICE: deleting video codec 19:15:21 T:1845982944 ERROR: SetInt: error writing /sys/class/tsync/enable 19:15:21 T:1723522200 NOTICE: DVDPlayer: finished waiting 19:15:22 T:1838020856 NOTICE: Thread BackgroundLoader start, auto delete: false 19:15:22 T:1723522200 NOTICE: CDVDPlayer::CloseFile() 19:15:22 T:1723522200 NOTICE: DVDPlayer: waiting for threads to exit 19:15:22 T:1723522200 NOTICE: DVDPlayer: finished waiting 19:15:22 T:1723522200 NOTICE: CDVDPlayer::CloseFile() 19:15:22 T:1723522200 NOTICE: DVDPlayer: waiting for threads to exit 19:15:22 T:1723522200 NOTICE: DVDPlayer: finished waiting 19:15:22 T:1859989000 NOTICE: Thread JobWorker start, auto delete: true 19:15:23 T:1840493624 NOTICE: Thread BackgroundLoader start, auto delete: false 19:15:38 T:1723522200 NOTICE: Log level changed to "LOG_LEVEL_DEBUG_FREEMEM" 19:15:38 T:1723522200 NOTICE: Enabled debug logging due to GUI setting. Level 2. 19:15:38 T:1723522200 DEBUG: ------ Window Init () ------ 19:15:40 T:1723522200 DEBUG: Keyboard: scancode: 0x04, sym: 0x0008, unicode: 0x0000, modifier: 0x0 19:15:40 T:1723522200 DEBUG: bool CApplication::OnKey(const CKey&): backspace (0xf008) pressed, action is Back 19:15:40 T:1723522200 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 19:15:40 T:1723522200 DEBUG: ------ Window Deinit (SettingsCategory.xml) ------ 19:15:40 T:1723522200 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 19:15:40 T:1723522200 DEBUG: ------ Window Init (Settings.xml) ------ 19:15:41 T:1723522200 DEBUG: Keyboard: scancode: 0x04, sym: 0x0008, unicode: 0x0000, modifier: 0x0 19:15:41 T:1723522200 DEBUG: bool CApplication::OnKey(const CKey&): backspace (0xf008) pressed, action is Back 19:15:41 T:1723522200 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 19:15:41 T:1723522200 DEBUG: ------ Window Deinit (Settings.xml) ------ 19:15:41 T:1723522200 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 19:15:41 T:1723522200 DEBUG: ------ Window Init (Home.xml) ------ 19:15:43 T:1723522200 DEBUG: Keyboard: scancode: 0x15, sym: 0x0114, unicode: 0x0000, modifier: 0x0 19:15:43 T:1723522200 DEBUG: bool CApplication::OnKey(const CKey&): left (0xf082) pressed, action is Left 19:15:43 T:1723522200 DEBUG: Keyboard: scancode: 0x15, sym: 0x0114, unicode: 0x0000, modifier: 0x0 19:15:43 T:1723522200 DEBUG: bool CApplication::OnKey(const CKey&): left (0xf082) pressed, action is Left 19:15:43 T:1723522200 DEBUG: Keyboard: scancode: 0x15, sym: 0x0114, unicode: 0x0000, modifier: 0x0 19:15:43 T:1723522200 DEBUG: bool CApplication::OnKey(const CKey&): left (0xf082) pressed, action is Left 19:15:45 T:1723522200 DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0 19:15:45 T:1723522200 DEBUG: bool CApplication::OnKey(const CKey&): down (0xf081) pressed, action is Down 19:15:46 T:1723522200 DEBUG: Keyboard: scancode: 0x42, sym: 0x000d, unicode: 0x000a, modifier: 0x0 19:15:46 T:1723522200 DEBUG: bool CApplication::OnKey(const CKey&): return (0xf00d) pressed, action is Select 19:15:46 T:1723522200 DEBUG: Activating window ID: 10025 19:15:46 T:1723522200 DEBUG: ------ Window Deinit (Home.xml) ------ 19:15:46 T:1723522200 DEBUG: ------ Window Init (MyVideoNav.xml) ------ 19:15:46 T:1723522200 DEBUG: CGUIMediaWindow::GetDirectory (sources://video/) 19:15:46 T:1723522200 DEBUG: ParentPath = [sources://video/] 19:15:46 T:1810776728 NOTICE: Thread BackgroundLoader start, auto delete: false 19:15:46 T:1810776728 DEBUG: Thread BackgroundLoader 1810776728 terminating 19:15:48 T:1723522200 DEBUG: Keyboard: scancode: 0x42, sym: 0x000d, unicode: 0x000a, modifier: 0x0 19:15:48 T:1723522200 DEBUG: bool CApplication::OnKey(const CKey&): return (0xf00d) pressed, action is Select 19:15:48 T:1723522200 DEBUG: CGUIMediaWindow::GetDirectory (/sdcard/) 19:15:48 T:1723522200 DEBUG: ParentPath = [sources://video/] 19:15:48 T:1723522200 DEBUG: int CVideoDatabase::RunQuery(const string&) took 1 ms for 1 items query: SELECT files.strFilename, files.playCount, bookmark.timeInSeconds, bookmark.totalTimeInSeconds FROM files LEFT JOIN bookmark ON files.idFile = bookmark.idFile AND bookmark.type = 1 WHERE files.idPath=1 19:15:48 T:1840857608 NOTICE: Thread BackgroundLoader start, auto delete: false 19:15:48 T:1840857608 DEBUG: Thread BackgroundLoader 1840857608 terminating 19:15:49 T:1723522200 DEBUG: Keyboard: scancode: 0x42, sym: 0x000d, unicode: 0x000a, modifier: 0x0 19:15:49 T:1723522200 DEBUG: bool CApplication::OnKey(const CKey&): return (0xf00d) pressed, action is Select 19:15:50 T:1723522200 DEBUG: virtual bool CGUIWindowVideoBase::OnPlayMedia(int) /sdcard/Lego Hampocalypse [720p].mp4 19:15:50 T:1723522200 DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc 19:15:50 T:1723522200 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnClear 19:15:50 T:1723522200 DEBUG: int CVideoDatabase::GetMovieId(const string&) (/sdcard/Lego Hampocalypse [720p].mp4), query = select idMovie from movie where idFile=1 19:15:50 T:1723522200 DEBUG: int CVideoDatabase::GetEpisodeId(const string&, int, int) (/sdcard/Lego Hampocalypse [720p].mp4), query = select idEpisode from episode where idFile=1 19:15:50 T:1723522200 DEBUG: int CVideoDatabase::GetMusicVideoId(const string&) (/sdcard/Lego Hampocalypse [720p].mp4), query = select idMVideo from musicvideo where idFile=1 19:15:50 T:1723522200 DEBUG: CAnnouncementManager - Announcement: OnAdd from xbmc 19:15:50 T:1723522200 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnAdd 19:15:50 T:1723522200 DEBUG: Loading settings for /sdcard/Lego Hampocalypse [720p].mp4 19:15:50 T:1723522200 DEBUG: CPlayerCoreFactory::GetPlayers(/sdcard/Lego Hampocalypse [720p].mp4) 19:15:50 T:1723522200 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules 19:15:50 T:1723522200 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules 19:15:50 T:1723522200 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtv 19:15:50 T:1723522200 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: hdhomerun/myth/mms/udp 19:15:50 T:1723522200 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout 19:15:50 T:1723522200 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp 19:15:50 T:1723522200 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp 19:15:50 T:1723522200 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams 19:15:50 T:1723522200 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd 19:15:50 T:1723522200 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage 19:15:50 T:1723522200 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf 19:15:50 T:1723522200 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv 19:15:50 T:1723522200 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio 19:15:50 T:1723522200 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players 19:15:50 T:1723522200 DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (1) 19:15:50 T:1723522200 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0 19:15:50 T:1723522200 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1 19:15:50 T:1723522200 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: DVDPlayer (1) 19:15:50 T:1723522200 DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players 19:15:50 T:1723522200 NOTICE: DVDPlayer: Opening: /sdcard/Lego Hampocalypse [720p].mp4 19:15:50 T:1723522200 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED 19:15:50 T:1723522200 DEBUG: CRenderManager::UpdateDisplayLatency - Latency set to 0 msec 19:15:50 T:1723522200 DEBUG: LinuxRendererGL: Cleaning up GL resources 19:15:50 T:1840857608 NOTICE: Thread DVDPlayer start, auto delete: false 19:15:50 T:1840857608 NOTICE: Creating InputStream 19:15:50 T:1840857608 DEBUG: static void CUtil::ScanForExternalSubtitles(const string&, std::vectorstd::basic_string&): Searching for subtitles... 19:15:50 T:1840857608 DEBUG: static void CUtil::ScanForExternalSubtitles(const string&, std::vectorstd::basicstring&): END (total time: 8 ms) 19:15:50 T:1840857608 NOTICE: Creating Demuxer 19:15:50 T:1840857608 DEBUG: bool CDVDDemuxFFmpeg::Open(CDVDInputStream, bool, bool) - probing detected format [mov,mp4,m4a,3gp,3g2,mj2] 19:15:50 T:1840857608 DEBUG: bool CDVDDemuxFFmpeg::Open(CDVDInputStream_, bool, bool) - avformat_find_streaminfo starting 19:15:50 T:1840857608 DEBUG: bool CDVDDemuxFFmpeg::Open(CDVDInputStream, bool, bool) - av_find_stream_info finished 19:15:50 T:1840857608 INFO: ffmpeg[6DB94208]: Input #0, mov,mp4,m4a,3gp,3g2,mj2, from '/sdcard/Lego Hampocalypse [720p].mp4': 19:15:50 T:1840857608 INFO: ffmpeg[6DB94208]: Metadata: 19:15:50 T:1840857608 INFO: ffmpeg[6DB94208]: major_brand : mp42 19:15:50 T:1840857608 INFO: ffmpeg[6DB94208]: minor_version : 0 19:15:50 T:1840857608 INFO: ffmpeg[6DB94208]: compatible_brands: isommp42 19:15:50 T:1840857608 INFO: ffmpeg[6DB94208]: creation_time : 2015-03-29 03:29:15 19:15:50 T:1840857608 INFO: ffmpeg[6DB94208]: Duration: 00:02:17.97, start: 0.000000, bitrate: 2130 kb/s 19:15:50 T:1840857608 INFO: ffmpeg[6DB94208]: Stream #0:0(und): Video: h264 (High) (avc1 / 0x31637661), yuv420p, 1280x720 [SAR 1:1 DAR 16:9], 1935 kb/s, 29.97 fps, 29.97 tbr, 30k tbn, 59.94 tbc (default) 19:15:50 T:1840857608 INFO: ffmpeg[6DB94208]: Metadata: 19:15:50 T:1840857608 INFO: ffmpeg[6DB94208]: creation_time : 1970-01-01 00:00:00 19:15:50 T:1840857608 INFO: ffmpeg[6DB94208]: handler_name : VideoHandler 19:15:50 T:1840857608 INFO: ffmpeg[6DB94208]: Stream #0:1(eng): Audio: aac (mp4a / 0x6134706D), 44100 Hz, stereo, fltp, 192 kb/s (default) 19:15:50 T:1840857608 INFO: ffmpeg[6DB94208]: Metadata: 19:15:50 T:1840857608 INFO: ffmpeg[6DB94208]: creation_time : 2015-03-29 03:29:15 19:15:50 T:1840857608 INFO: ffmpeg[6DB94208]: handler_name : IsoMedia File Produced by Google, 5-11-2011 19:15:50 T:1840857608 DEBUG: CDVDDemuxFFmpeg::AddStream(0, ...) -> 0 19:15:50 T:1840857608 DEBUG: CDVDDemuxFFmpeg::AddStream(1, ...) -> 1 19:15:50 T:1840857608 NOTICE: Opening stream: 0 source: 256 19:15:50 T:1840857608 NOTICE: Creating video codec with codec id: 28 19:15:50 T:1840857608 DEBUG: CDVDFactoryCodec: compiled in hardware support: AMCodec:yes MediaCodec:yes OpenMax:no libstagefright:yes RKlibstagefright:yes VDPAU:no VAAPI:no iMXVPU:no 19:15:50 T:1840857608 DEBUG: FactoryCodec - Video: amcodec - Opening 19:15:50 T:1840857608 INFO: CBitstreamConverter::Open bitstream to annexb init 19:15:50 T:1840857608 INFO: DVDVideoCodecAmlogic: Opened Amlogic Codec 19:15:50 T:1840857608 DEBUG: FactoryCodec - Video: am-h264 - Opened 19:15:50 T:1840857608 NOTICE: Creating video thread 19:15:50 T:1840857608 NOTICE: Opening stream: 1 source: 256 19:15:50 T:1860628168 NOTICE: Thread DVDPlayerVideo start, auto delete: false 19:15:50 T:1840857608 NOTICE: Finding audio codec for: 86018 19:15:50 T:1860628168 NOTICE: running thread: video_thread 19:15:50 T:1840857608 DEBUG: FactoryCodec - Audio: passthrough - Opening 19:15:50 T:1840857608 DEBUG: FactoryCodec - Audio: passthrough - Failed 19:15:50 T:1840857608 DEBUG: FactoryCodec - Audio: FFmpeg - Opening 19:15:50 T:1840857608 DEBUG: FactoryCodec - Audio: FFmpeg - Opened 19:15:50 T:1840857608 NOTICE: Creating audio thread 19:15:50 T:1860628168 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE 19:15:50 T:1820203512 NOTICE: Thread DVDPlayerAudio start, auto delete: false 19:15:50 T:1840857608 DEBUG: bool CEdl::ReadEditDecisionLists(const string&, float, int) - Checking for edit decision lists (EDL) on local drive or remote share for: /sdcard/Lego Hampocalypse [720p].mp4 19:15:50 T:1820203512 NOTICE: running thread: CDVDPlayerAudio::Process() 19:15:50 T:1820203512 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE 19:15:50 T:1840857608 DEBUG: virtual void CApplication::OnPlayBackStarted(): play state was 1, starting 1 19:15:50 T:1723522200 DEBUG: PlayBackRet CApplication::PlayFile(const CFileItem&, bool): OpenFile succeed, play state 2 19:15:50 T:1723522200 DEBUG: virtual void CApplication::OnPlayBackStarted(): play state was 2, starting 0 19:15:50 T:1840857608 DEBUG: CDVDPlayer::SetCaching - caching state 3 19:15:50 T:1860628168 DEBUG: CAMLCodec::SetSpeed, speed(0) 19:15:50 T:1860628168 INFO: CDVDPlayerVideo - Stillframe left, switching to normal playback 19:15:50 T:1860628168 DEBUG: CAMLCodec::OpenDecoder, android version 19 19:15:50 T:1860628168 DEBUG: codecid_to_vformat, id(28) -> vformat(2) 19:15:50 T:1860628168 DEBUG: codec_tag_to_vdec_type, codec_tag(828601953) -> vdec_type(4) 19:15:50 T:1860628168 DEBUG: CAMLCodec::OpenDecoder hints.width(1280), hints.height(720), hints.codec(28), hints.codec_tag(828601953), hints.pid(1) 19:15:50 T:1860628168 DEBUG: CAMLCodec::OpenDecoder hints.fpsrate(30000), hints.fpsscale(1001), hints.rfpsrate(30000), hints.rfpsscale(1001), video_rate(3203) 19:15:50 T:1860628168 DEBUG: CAMLCodec::OpenDecoder hints.aspect(1.777778), video_ratio.num(1), video_ratio.den(1) 19:15:50 T:1860628168 DEBUG: CAMLCodec::OpenDecoder hints.orientation(0), hints.forced_aspect(0), hints.extrasize(35) 19:15:50 T:1820203512 NOTICE: Creating audio stream (codec id: 86018, channels: 2, sample rate: 44100, no pass-through) 19:15:50 T:1820203512 DEBUG: CDVDPlayerAudio:: synctype set to 0: clock feedback 19:15:50 T:1805599416 INFO: CActiveAESink::OpenSink - initialize sink 19:15:50 T:1805599416 DEBUG: CActiveAESink::OpenSink - trying to open device AUDIOTRACK:AudioTrack 19:15:50 T:1860628168 ERROR: SetInt: error writing /sys/class/tsync/enable 19:15:50 T:1860628168 DEBUG: CAMLCodec::SetSpeed, speed(1000) 19:15:50 T:1860628168 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC(33366.666667, 1) 19:15:50 T:1837923488 NOTICE: Thread CAMLCodec start, auto delete: false 19:15:50 T:1837923488 DEBUG: CAMLCodec::Process Started 19:15:50 T:1805599416 DEBUG: CActiveAESink::OpenSink - AUDIOTRACK Initialized: 19:15:50 T:1805599416 DEBUG: Output Device : android 19:15:50 T:1805599416 DEBUG: Sample Rate : 44100 19:15:50 T:1805599416 DEBUG: Sample Format : AE_FMT_S16NE 19:15:50 T:1805599416 DEBUG: Channel Count : 2 19:15:50 T:1805599416 DEBUG: Channel Layout: FL,FR 19:15:50 T:1805599416 DEBUG: Frames : 1411 19:15:50 T:1805599416 DEBUG: Frame Samples : 2822 19:15:50 T:1805599416 DEBUG: Frame Size : 4 19:15:50 T:1860628168 DEBUG: DVDVideoCodecAmlogic: detected new framerate(29.970030), videorate(3203) 19:15:50 T:1805598832 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 19:15:50 T:1840857608 DEBUG: CDVDPlayer::HandleMessages - player started 1 19:15:50 T:1860628168 NOTICE: fps: 29.970030, pwidth: 1280, pheight: 720, dwidth: 1280, dheight: 720 19:15:50 T:1860628168 DEBUG: int CDVDPlayerVideo::OutputPicture(const DVDVideoPicture, double) - change configuration. 1280x720. framerate: 29.97. format: BYPASS 19:15:50 T:1860628168 NOTICE: Display resolution DESKTOP : 1920x1080 @ 50.00 - Full Screen (16) 19:15:50 T:1860628168 DEBUG: CXBMCRenderManager::Configure - 3 19:15:50 T:1723522200 NOTICE: Using GL_TEXTURE_2D 19:15:50 T:1723522200 DEBUG: GL: Requested render method: 0 19:15:50 T:1723522200 NOTICE: GL: Using BYPASS render method 19:15:50 T:1723522200 NOTICE: GL: NPOT texture support detected 19:15:50 T:1840857608 DEBUG: CDVDPlayer::HandleMessages - player started 2 19:15:50 T:1840857608 DEBUG: CDVDPlayer::SetCaching - caching state 0 19:15:50 T:1820203512 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(23219.954649, 1) 19:15:50 T:1820203512 DEBUG: CDVDClock::Discontinuity - CDVDPlayerAudio::HandleSyncError1 - was:-38820.088009, should be:-38816.088009, error:4.000000 19:15:50 T:1860628168 DEBUG: CAMLCodec::SetSpeed, speed(1000) 19:15:50 T:1723522200 DEBUG: CGUIInfoManager::SetCurrentMovie(/sdcard/Lego Hampocalypse [720p].mp4) 19:15:50 T:1723522200 DEBUG: int CVideoDatabase::GetMovieId(const string&) (/sdcard/Lego Hampocalypse [720p].mp4), query = select idMovie from movie where idFile=1 19:15:50 T:1723522200 DEBUG: int CVideoDatabase::GetEpisodeId(const string&, int, int) (/sdcard/Lego Hampocalypse [720p].mp4), query = select idEpisode from episode where idFile=1 19:15:50 T:1723522200 DEBUG: int CVideoDatabase::GetMusicVideoId(const string&) (/sdcard/Lego Hampocalypse [720p].mp4), query = select idMVideo from musicvideo where idFile=1 19:15:50 T:1723522200 DEBUG: CAnnouncementManager - Announcement: OnPlay from xbmc 19:15:50 T:1723522200 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPlay 19:15:50 T:1723522200 DEBUG: Activating window ID: 12005 19:15:50 T:1723522200 DEBUG: ------ Window Deinit (MyVideoNav.xml) ------ 19:15:50 T:1723522200 DEBUG: ------ Window Init (VideoFullScreen.xml) ------ 19:15:50 T:1723522200 ERROR: SetInt: error writing /sys/class/video/contrast 19:15:50 T:1723522200 ERROR: SetInt: error writing /sys/class/video/brightness 19:15:50 T:1723522200 DEBUG: CAMLCodec::SetVideoRect:display(0,0,1280,720) 19:15:50 T:1723522200 DEBUG: CAMLCodec::SetVideoRect:gui(0,0,1280,720) 19:15:50 T:1723522200 DEBUG: CAMLCodec::SetVideoRect:m_dst_rect(0,0,1280,720) 19:15:50 T:1723522200 DEBUG: CAMLCodec::SetVideoRect:dst_rect(0,0,1280,720) 19:15:50 T:1723522200 DEBUG: CAMLCodec::SetVideoRect:m_stereo_mode(0) 19:15:50 T:1723522200 DEBUG: CAMLCodec::SetVideoRect:m_stereo_view(0) 19:15:52 T:1820203512 DEBUG: CDVDClock::Discontinuity - CDVDPlayerAudio::HandleSyncError2 - was:1967130.911991, should be:1945163.440617, error:-21967.471374 19:15:54 T:1820203512 DEBUG: CDVDClock::Discontinuity - CDVDPlayerAudio::HandleSyncError2 - was:3944883.440617, should be:3931367.641996, error:-13515.798620 19:16:18 T:1859989000 DEBUG: Thread JobWorker 1859989000 terminating (autodelete) 19:17:13 T:1723522200 DEBUG: Keyboard: scancode: 0x42, sym: 0x000d, unicode: 0x000a, modifier: 0x0 19:17:13 T:1723522200 DEBUG: bool CApplication::OnKey(const CKey&): return (0xf00d) pressed, action is OSD 19:17:13 T:1723522200 DEBUG: ------ Window Init (VideoOSD.xml) ------ 19:17:14 T:1723522200 DEBUG: Keyboard: scancode: 0x16, sym: 0x0113, unicode: 0x0000, modifier: 0x0 19:17:14 T:1723522200 DEBUG: bool CApplication::OnKey(const CKey&): right (0xf083) pressed, action is Right 19:17:15 T:1723522200 DEBUG: Keyboard: scancode: 0x42, sym: 0x000d, unicode: 0x000a, modifier: 0x0 19:17:15 T:1723522200 DEBUG: bool CApplication::OnKey(const CKey&): return (0xf00d) pressed, action is Select 19:17:15 T:1723522200 NOTICE: CDVDPlayer::CloseFile() 19:17:15 T:1723522200 NOTICE: DVDPlayer: waiting for threads to exit 19:17:15 T:1840857608 NOTICE: CDVDPlayer::OnExit() 19:17:15 T:1840857608 NOTICE: Closing stream player 1 19:17:15 T:1840857608 NOTICE: Waiting for audio thread to exit 19:17:15 T:1820203512 NOTICE: thread end: CDVDPlayerAudio::OnExit() 19:17:15 T:1820203512 DEBUG: Thread DVDPlayerAudio 1820203512 terminating 19:17:15 T:1840857608 NOTICE: Closing audio device 19:17:15 T:1805598832 DEBUG: CActiveAE::DiscardStream - audio stream deleted 19:17:15 T:1805598832 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 19:17:15 T:1840857608 NOTICE: Deleting audio codec 19:17:15 T:1840857608 NOTICE: Closing stream player 2 19:17:15 T:1840857608 NOTICE: waiting for video thread to exit 19:17:15 T:1805598832 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 19:17:15 T:1805599416 INFO: CActiveAESink::OpenSink - initialize sink 19:17:15 T:1805599416 DEBUG: CActiveAESink::OpenSink - trying to open device AUDIOTRACK:AudioTrack 19:17:15 T:1805599416 DEBUG: CActiveAESink::OpenSink - AUDIOTRACK Initialized: 19:17:15 T:1805599416 DEBUG: Output Device : android 19:17:15 T:1805599416 DEBUG: Sample Rate : 44100 19:17:15 T:1805599416 DEBUG: Sample Format : AE_FMT_S16NE 19:17:15 T:1805599416 DEBUG: Channel Count : 2 19:17:15 T:1805599416 DEBUG: Channel Layout: FL,FR 19:17:15 T:1805599416 DEBUG: Frames : 1411 19:17:15 T:1805599416 DEBUG: Frame Samples : 2822 19:17:15 T:1805599416 DEBUG: Frame Size : 4 19:17:15 T:1860628168 NOTICE: thread end: video_thread 19:17:15 T:1860628168 DEBUG: Thread DVDPlayerVideo 1860628168 terminating 19:17:15 T:1840857608 NOTICE: deleting video codec 19:17:15 T:1840857608 DEBUG: CAMLCodec::CloseDecoder 19:17:15 T:1837923488 DEBUG: CAMLCodec::Process Stopped 19:17:15 T:1837923488 DEBUG: Thread CAMLCodec 1837923488 terminating 19:17:15 T:1840857608 ERROR: SetInt: error writing /sys/class/tsync/enable 19:17:15 T:1840857608 DEBUG: virtual void CApplication::OnPlayBackStopped(): play state was 2, starting 0 19:17:15 T:1840857608 DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc 19:17:15 T:1840857608 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop 19:17:15 T:1723522200 NOTICE: DVDPlayer: finished waiting 19:17:15 T:1840857608 DEBUG: Thread DVDPlayer 1840857608 terminating 19:17:15 T:1723522200 DEBUG: LinuxRendererGL: Cleaning up GL resources 19:17:15 T:1723522200 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 19:17:15 T:1723522200 DEBUG: ------ Window Deinit (VideoOSD.xml) ------ 19:17:15 T:1723522200 DEBUG: ------ Window Deinit (VideoFullScreen.xml) ------ 19:17:15 T:1723522200 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 19:17:15 T:1723522200 DEBUG: ------ Window Init (MyVideoNav.xml) ------ 19:17:15 T:1723522200 DEBUG: CGUIMediaWindow::GetDirectory (/sdcard/) 19:17:15 T:1723522200 DEBUG: ParentPath = [/sdcard/] 19:17:15 T:1723522200 DEBUG: int CVideoDatabase::RunQuery(const string&) took 2 ms for 1 items query: SELECT files.strFilename, files.playCount, bookmark.timeInSeconds, bookmark.totalTimeInSeconds FROM files LEFT JOIN bookmark ON files.idFile = bookmark.idFile AND bookmark.type = 1 WHERE files.idPath=1 19:17:15 T:1899168704 NOTICE: Thread BackgroundLoader start, auto delete: false 19:17:16 T:1899168704 DEBUG: Thread BackgroundLoader 1899168704 terminating 19:17:16 T:1723522200 NOTICE: CDVDPlayer::CloseFile() 19:17:16 T:1723522200 NOTICE: DVDPlayer: waiting for threads to exit 19:17:16 T:1723522200 NOTICE: DVDPlayer: finished waiting 19:17:16 T:1723522200 DEBUG: LinuxRendererGL: Cleaning up GL resources 19:17:16 T:1723522200 NOTICE: CDVDPlayer::CloseFile() 19:17:16 T:1723522200 NOTICE: DVDPlayer: waiting for threads to exit 19:17:16 T:1723522200 NOTICE: DVDPlayer: finished waiting 19:17:16 T:1723522200 DEBUG: LinuxRendererGL: Cleaning up GL resources 19:17:16 T:1901643600 NOTICE: Thread JobWorker start, auto delete: true 19:17:16 T:1901643600 DEBUG: virtual bool CSaveFileStateJob::DoWork() - Saving file state for video item /sdcard/Lego Hampocalypse [720p].mp4 19:17:20 T:1723522200 DEBUG: Keyboard: scancode: 0x04, sym: 0x0008, unicode: 0x0000, modifier: 0x0 19:17:20 T:1723522200 DEBUG: bool CApplication::OnKey(const CKey&): backspace (0xf008) pressed, action is Back 19:17:20 T:1723522200 DEBUG: CGUIMediaWindow::GetDirectory (sources://video/) 19:17:20 T:1723522200 DEBUG: ParentPath = [] 19:17:20 T:1807758208 NOTICE: Thread BackgroundLoader start, auto delete: false 19:17:20 T:1807758208 DEBUG: Thread BackgroundLoader 1807758208 terminating 19:17:21 T:1723522200 DEBUG: Keyboard: scancode: 0x04, sym: 0x0008, unicode: 0x0000, modifier: 0x0 19:17:21 T:1723522200 DEBUG: bool CApplication::OnKey(const CKey&): backspace (0xf008) pressed, action is Back 19:17:21 T:1723522200 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 19:17:21 T:1723522200 DEBUG: ------ Window Deinit (MyVideoNav.xml) ------ 19:17:21 T:1723522200 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 19:17:21 T:1723522200 DEBUG: ------ Window Init (Home.xml) ------ 19:17:23 T:1723522200 DEBUG: Keyboard: scancode: 0x16, sym: 0x0113, unicode: 0x0000, modifier: 0x0 19:17:23 T:1723522200 DEBUG: bool CApplication::OnKey(const CKey&): right (0xf083) pressed, action is Right 19:17:23 T:1723522200 DEBUG: Keyboard: scancode: 0x16, sym: 0x0113, unicode: 0x0000, modifier: 0x0 19:17:23 T:1723522200 DEBUG: bool CApplication::OnKey(const CKey&): right (0xf083) pressed, action is Right 19:17:23 T:1723522200 DEBUG: Keyboard: scancode: 0x16, sym: 0x0113, unicode: 0x0000, modifier: 0x0 19:17:23 T:1723522200 DEBUG: bool CApplication::OnKey(const CKey&): right (0xf083) pressed, action is Right 19:17:24 T:1723522200 DEBUG: Keyboard: scancode: 0x16, sym: 0x0113, unicode: 0x0000, modifier: 0x0 19:17:24 T:1723522200 DEBUG: bool CApplication::OnKey(const CKey&): right (0xf083) pressed, action is Right 19:17:25 T:1723522200 DEBUG: Keyboard: scancode: 0x15, sym: 0x0114, unicode: 0x0000, modifier: 0x0 19:17:25 T:1723522200 DEBUG: bool CApplication::OnKey(const CKey&): left (0xf082) pressed, action is Left 19:17:27 T:1723522200 DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0 19:17:27 T:1723522200 DEBUG: bool CApplication::OnKey(const CKey&): down (0xf081) pressed, action is Down 19:17:27 T:1723522200 DEBUG: Keyboard: scancode: 0x42, sym: 0x000d, unicode: 0x000a, modifier: 0x0 19:17:27 T:1723522200 DEBUG: bool CApplication::OnKey(const CKey&): return (0xf00d) pressed, action is Select 19:17:27 T:1723522200 DEBUG: Activating window ID: 10004 19:17:27 T:1723522200 DEBUG: ------ Window Deinit (Home.xml) ------ 19:17:27 T:1723522200 DEBUG: ------ Window Init (Settings.xml) ------ 19:17:29 T:1723522200 DEBUG: Keyboard: scancode: 0x42, sym: 0x000d, unicode: 0x000a, modifier: 0x0 19:17:29 T:1723522200 DEBUG: bool CApplication::OnKey(const CKey&): return (0xf00d) pressed, action is Select 19:17:29 T:1723522200 DEBUG: Activating window ID: 10016 19:17:30 T:1723522200 DEBUG: ------ Window Deinit (Settings.xml) ------ 19:17:30 T:1723522200 DEBUG: ------ Window Init (SettingsCategory.xml) ------ 19:17:31 T:1723522200 DEBUG: Keyboard: scancode: 0x13, sym: 0x0111, unicode: 0x0000, modifier: 0x0 19:17:31 T:1723522200 DEBUG: bool CApplication::OnKey(const CKey&): up (0xf080) pressed, action is Up 19:17:33 T:1723522200 DEBUG: Keyboard: scancode: 0x16, sym: 0x0113, unicode: 0x0000, modifier: 0x0 19:17:33 T:1723522200 DEBUG: bool CApplication::OnKey(const CKey&): right (0xf083) pressed, action is Right 19:17:34 T:1723522200 DEBUG: Keyboard: scancode: 0x42, sym: 0x000d, unicode: 0x000a, modifier: 0x0 19:17:34 T:1723522200 DEBUG: bool CApplication::OnKey(const CKey&): return (0xf00d) pressed, action is Select 19:17:34 T:1723522200 NOTICE: Disabled debug logging due to GUI setting. Level 0. 19:17:34 T:1723522200 NOTICE: Log level changed to "LOG_LEVEL_NORMAL"

mapfde commented 9 years ago

Kodi 14.2 (locked at 720p resolution)

19:24:52 T:1781298408 NOTICE: special://profile/ is mapped to: special://masterprofile/ 19:24:52 T:1781298408 NOTICE: ----------------------------------------------------------------------- 19:24:52 T:1781298408 NOTICE: Starting Kodi (14.2 Git:2015-03-26-7cc53a9-dirty). Platform: Android ARM 32-bit 19:24:52 T:1781298408 NOTICE: Using Release Kodi x32 build 19:24:52 T:1781298408 NOTICE: Kodi compiled Mar 26 2015 by GCC 4.8.0 for Android ARM 32-bit API level 14 (API level 14) 19:24:52 T:1781298408 NOTICE: Running on MBX MK808B Plus with Android 4.4.2 API level 19, kernel: Linux ARM 32-bit version 3.10.33 19:24:52 T:1781298408 NOTICE: FFmpeg version: 14.2rc1-Helix-5-g7cc53a9-xbmc-2.4.6-Helix 19:24:52 T:1781298408 NOTICE: Host CPU: ARMv7 Processor rev 1 (v7l), 2 cores available 19:24:52 T:1781298408 NOTICE: Product: m201, Device: m201, Board: m201 - Manufacturer: MBX, Brand: MBX, Model: MK808B Plus, Hardware: amlogic 19:24:52 T:1781298408 NOTICE: ARM Features: Neon enabled 19:24:52 T:1781298408 NOTICE: special://xbmc/ is mapped to: /data/data/org.xbmc.kodi/cache/apk/assets 19:24:52 T:1781298408 NOTICE: special://xbmcbin/ is mapped to: /data/data/org.xbmc.kodi/cache/apk/assets 19:24:52 T:1781298408 NOTICE: special://masterprofile/ is mapped to: /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/userdata 19:24:52 T:1781298408 NOTICE: special://home/ is mapped to: /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi 19:24:52 T:1781298408 NOTICE: special://temp/ is mapped to: /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/temp 19:24:52 T:1781298408 NOTICE: The executable running is: 19:24:52 T:1781298408 NOTICE: Local hostname: localhost 19:24:52 T:1781298408 NOTICE: Log File is located: /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/temp/kodi.log 19:24:52 T:1781298408 NOTICE: ----------------------------------------------------------------------- 19:24:52 T:1781298408 NOTICE: load settings... 19:24:52 T:1781298408 DEBUG: static int CAndroidFeatures::GetVersion(): android.os.Build.VERSION 19 19:24:52 T:1781298408 NOTICE: aml_present, rtn(0) 19:24:52 T:1781298408 DEBUG: CSettings: loaded settings definition from special://xbmc/system/settings/settings.xml 19:24:52 T:1781298408 WARNING: CSettingInt: unknown options filler "audiocdactions" of "audiocds.autoaction" 19:24:52 T:1781298408 DEBUG: CSettings: loaded settings definition from special://xbmc/system/settings/android.xml 19:24:52 T:1781298408 NOTICE: Found 1 Lists of Devices 19:24:52 T:1781298408 NOTICE: Enumerated AUDIOTRACK devices: 19:24:52 T:1781298408 NOTICE: Device 1 19:24:52 T:1781298408 NOTICE: m_deviceName : AudioTrack 19:24:52 T:1781298408 NOTICE: m_displayName : android 19:24:52 T:1781298408 NOTICE: m_displayNameExtra: audiotrack 19:24:52 T:1781298408 NOTICE: m_deviceType : AE_DEVTYPE_HDMI 19:24:52 T:1781298408 NOTICE: m_channels : FL,FR,FC,LFE,BL,BR 19:24:52 T:1781298408 NOTICE: m_sampleRates : 48000 19:24:52 T:1781298408 NOTICE: m_dataFormats : AE_FMT_S16LE,AE_FMT_AC3,AE_FMT_DTS 19:24:52 T:1781298408 NOTICE: No settings file to load (special://xbmc/system/advancedsettings.xml) 19:24:52 T:1781298408 NOTICE: No settings file to load (special://masterprofile/advancedsettings.xml) 19:24:52 T:1781298408 NOTICE: Default DVD Player: dvdplayer 19:24:52 T:1781298408 NOTICE: Default Video Player: dvdplayer 19:24:52 T:1781298408 NOTICE: Default Audio Player: paplayer 19:24:52 T:1781298408 NOTICE: Enabled debug logging due to GUI setting (2) 19:24:52 T:1781298408 NOTICE: Log level changed to "LOG_LEVEL_DEBUG_FREEMEM" 19:24:52 T:1781298408 NOTICE: CMediaSourceSettings: loading media sources from special://masterprofile/sources.xml 19:24:52 T:1781298408 NOTICE: Loading player core factory settings from special://xbmc/system/playercorefactory.xml. 19:24:52 T:1781298408 DEBUG: CPlayerCoreConfig::: created player DVDPlayer for core 1 19:24:52 T:1781298408 DEBUG: CPlayerCoreConfig::: created player oldmplayercore for core 1 19:24:52 T:1781298408 DEBUG: CPlayerCoreConfig::: created player PAPlayer for core 3 19:24:52 T:1781298408 DEBUG: CPlayerSelectionRule::Initialize: creating rule: system rules 19:24:52 T:1781298408 DEBUG: CPlayerSelectionRule::Initialize: creating rule: rtv 19:24:52 T:1781298408 DEBUG: CPlayerSelectionRule::Initialize: creating rule: hdhomerun/myth/mms/udp 19:24:52 T:1781298408 DEBUG: CPlayerSelectionRule::Initialize: creating rule: lastfm/shout 19:24:52 T:1781298408 DEBUG: CPlayerSelectionRule::Initialize: creating rule: rtmp 19:24:52 T:1781298408 DEBUG: CPlayerSelectionRule::Initialize: creating rule: rtsp 19:24:52 T:1781298408 DEBUG: CPlayerSelectionRule::Initialize: creating rule: streams 19:24:52 T:1781298408 DEBUG: CPlayerSelectionRule::Initialize: creating rule: aacp/sdp 19:24:52 T:1781298408 DEBUG: CPlayerSelectionRule::Initialize: creating rule: mp2 19:24:52 T:1781298408 DEBUG: CPlayerSelectionRule::Initialize: creating rule: dvd 19:24:52 T:1781298408 DEBUG: CPlayerSelectionRule::Initialize: creating rule: dvdimage 19:24:52 T:1781298408 DEBUG: CPlayerSelectionRule::Initialize: creating rule: sdp/asf 19:24:52 T:1781298408 DEBUG: CPlayerSelectionRule::Initialize: creating rule: nsv 19:24:52 T:1781298408 DEBUG: CPlayerSelectionRule::Initialize: creating rule: radio 19:24:52 T:1781298408 NOTICE: Loaded playercorefactory configuration 19:24:52 T:1781298408 NOTICE: Loading player core factory settings from special://masterprofile/playercorefactory.xml. 19:24:52 T:1781298408 NOTICE: special://masterprofile/playercorefactory.xml does not exist. Skipping. 19:24:52 T:1781298408 INFO: creating subdirectories 19:24:52 T:1781298408 INFO: userdata folder: special://masterprofile/ 19:24:52 T:1781298408 INFO: recording folder: 19:24:52 T:1781298408 INFO: screenshots folder: 19:24:52 T:1781298408 INFO: load language info file: special://xbmc/language/English/langinfo.xml 19:24:52 T:1781298408 DEBUG: trying to set locale to en_US.UTF-8 19:24:52 T:1781298408 INFO: global locale set to C 19:24:52 T:1781298408 INFO: load English language file, from path: special://xbmc/language/ 19:24:53 T:1781298408 DEBUG: POParser: loaded 3267 strings from file /data/data/org.xbmc.kodi/cache/apk/assets/language/English/strings.po 19:24:53 T:1801897496 NOTICE: Thread ActiveAE start, auto delete: false 19:24:53 T:1801950592 NOTICE: Thread AESink start, auto delete: false 19:24:53 T:1801950592 INFO: CActiveAESink::OpenSink - initialize sink 19:24:53 T:1801950592 DEBUG: CActiveAESink::OpenSink - trying to open device AUDIOTRACK:AudioTrack 19:24:53 T:1801950592 DEBUG: CActiveAESink::OpenSink - AUDIOTRACK Initialized: 19:24:53 T:1801950592 DEBUG: Output Device : android 19:24:53 T:1801950592 DEBUG: Sample Rate : 48000 19:24:53 T:1801950592 DEBUG: Sample Format : AE_FMTS16NE 19:24:53 T:1801950592 DEBUG: Channel Count : 2 19:24:53 T:1801950592 DEBUG: Channel Layout: FL,FR 19:24:53 T:1801950592 DEBUG: Frames : 1536 19:24:53 T:1801950592 DEBUG: Frame Samples : 3072 19:24:53 T:1801950592 DEBUG: Frame Size : 4 19:24:53 T:1781298408 NOTICE: Running database version Addons16 19:24:53 T:1781298408 DEBUG: SECTION:LoadDLL(libcpluff-arm.so) 19:24:53 T:1781298408 DEBUG: Loading: /data/app-lib/org.xbmc.kodi-1/libcpluff-arm.so 19:24:53 T:1781298408 DEBUG: ADDON: cpluff: 'Plug-in xbmc.json has been installed.' 19:24:53 T:1781298408 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.fanart.tv has been installed.' 19:24:53 T:1781298408 DEBUG: ADDON: cpluff: 'Plug-in webinterface.default has been installed.' 19:24:53 T:1781298408 DEBUG: ADDON: cpluff: 'Plug-in repository.xbmc.org has been installed.' 19:24:53 T:1781298408 DEBUG: ADDON: cpluff: 'Plug-in pvr.vdr.vnsi has been installed.' 19:24:53 T:1781298408 DEBUG: ADDON: cpluff: 'Plug-in screensaver.xbmc.builtin.black has been installed.' 19:24:53 T:1781298408 DEBUG: ADDON: cpluff: 'Plug-in pvr.argustv has been installed.' 19:24:53 T:1781298408 DEBUG: ADDON: cpluff: 'Plug-in visualization.vortex has been installed.' 19:24:53 T:1781298408 DEBUG: ADDON: cpluff: 'Plug-in audioencoder.xbmc.builtin.wma has been installed.' 19:24:53 T:1781298408 DEBUG: ADDON: cpluff: 'Plug-in pvr.mediaportal.tvserver has been installed.' 19:24:53 T:1781298408 DEBUG: ADDON: cpluff: 'Plug-in audioencoder.vorbis has been installed.' 19:24:53 T:1781298408 DEBUG: ADDON: cpluff: 'Plug-in audioencoder.wav has been installed.' 19:24:53 T:1781298408 DEBUG: ADDON: cpluff: 'Plug-in screensaver.xbmc.builtin.dim has been installed.' 19:24:53 T:1781298408 DEBUG: ADDON: cpluff: 'Plug-in metadata.themoviedb.org has been installed.' 19:24:53 T:1781298408 DEBUG: ADDON: cpluff: 'Plug-in service.xbmc.versioncheck has been installed.' 19:24:53 T:1781298408 DEBUG: ADDON: cpluff: 'Plug-in xbmc.metadata has been installed.' 19:24:53 T:1781298408 DEBUG: ADDON: cpluff: 'Plug-in pvr.wmc has been installed.' 19:24:53 T:1781298408 DEBUG: ADDON: cpluff: 'Plug-in pvr.dvblink has been installed.' 19:24:53 T:1781298408 DEBUG: ADDON: cpluff: 'Plug-in audioencoder.flac has been installed.' 19:24:53 T:1781298408 DEBUG: ADDON: cpluff: 'Plug-in skin.confluence has been installed.' 19:24:53 T:1781298408 DEBUG: ADDON: cpluff: 'Plug-in visualization.glspectrum has been installed.' 19:24:53 T:1781298408 DEBUG: ADDON: cpluff: 'Plug-in script.module.pil has been installed.' 19:24:53 T:1781298408 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.amazon.de has been installed.' 19:24:53 T:1781298408 DEBUG: ADDON: cpluff: 'Plug-in xbmc.gui has been installed.' 19:24:53 T:1781298408 DEBUG: ADDON: cpluff: 'Plug-in pvr.vuplus has been installed.' 19:24:53 T:1781298408 DEBUG: ADDON: cpluff: 'Plug-in pvr.mythtv has been installed.' 19:24:53 T:1781298408 DEBUG: ADDON: cpluff: 'Plug-in metadata.musicvideos.theaudiodb.com has been installed.' 19:24:53 T:1781298408 DEBUG: ADDON: cpluff: 'Plug-in xbmc.core has been installed.' 19:24:53 T:1781298408 DEBUG: ADDON: cpluff: 'Plug-in pvr.demo has been installed.' 19:24:53 T:1781298408 DEBUG: ADDON: cpluff: 'Plug-in skin.re-touched has been installed.' 19:24:53 T:1781298408 DEBUG: ADDON: cpluff: 'Plug-in pvr.iptvsimple has been installed.' 19:24:53 T:1781298408 DEBUG: ADDON: cpluff: 'Plug-in xbmc.pvr has been installed.' 19:24:53 T:1781298408 DEBUG: ADDON: cpluff: 'Plug-in pvr.njoy has been installed.' 19:24:53 T:1781298408 DEBUG: ADDON: cpluff: 'Plug-in pvr.nextpvr has been installed.' 19:24:53 T:1781298408 DEBUG: ADDON: cpluff: 'Plug-in audioencoder.xbmc.builtin.aac has been installed.' 19:24:53 T:1781298408 DEBUG: ADDON: cpluff: 'Plug-in metadata.album.universal has been installed.' 19:24:53 T:1781298408 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.htbackdrops.com has been installed.' 19:24:53 T:1781298408 DEBUG: ADDON: cpluff: 'Plug-in pvr.dvbviewer has been installed.' 19:24:53 T:1781298408 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.allmusic.com has been installed.' 19:24:53 T:1781298408 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.musicbrainz.org has been installed.' 19:24:53 T:1781298408 DEBUG: ADDON: cpluff: 'Plug-in metadata.tvdb.com has been installed.' 19:24:53 T:1781298408 DEBUG: ADDON: cpluff: 'Plug-in metadata.local has been installed.' 19:24:53 T:1781298408 DEBUG: ADDON: cpluff: 'Plug-in audioencoder.lame has been installed.' 19:24:53 T:1781298408 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.last.fm has been installed.' 19:24:53 T:1781298408 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.themoviedb.org has been installed.' 19:24:53 T:1781298408 DEBUG: ADDON: cpluff: 'Plug-in metadata.artists.universal has been installed.' 19:24:53 T:1781298408 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.theaudiodb.com has been installed.' 19:24:53 T:1781298408 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.imdb.com has been installed.' 19:24:53 T:1781298408 DEBUG: ADDON: cpluff: 'Plug-in xbmc.python has been installed.' 19:24:53 T:1781298408 DEBUG: ADDON: cpluff: 'Plug-in pvr.hts has been installed.' 19:24:53 T:1781298408 DEBUG: ADDON: cpluff: 'Plug-in xbmc.addon has been installed.' 19:24:53 T:1781298408 DEBUG: ADDON: cpluff: 'Plug-in visualization.waveform has been installed.' 19:24:53 T:1781298408 DEBUG: ADDON: cpluff: 'Plug-in xbmc.codec has been installed.' 19:24:53 T:1781298408 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.hdtrailers.net has been installed.' 19:24:53 T:1781298408 DEBUG: ADDON: cpluff: 'Not all directories were successfully scanned.' 19:24:53 T:1781298408 NOTICE: ADDONS: Using repository repository.xbmc.org 19:24:53 T:1781298408 DEBUG: bool PERIPHERALS::CPeripherals::LoadMappings() - loaded node "Motorola Nyxboard Hybrid" 19:24:53 T:1781298408 DEBUG: bool PERIPHERALS::CPeripherals::LoadMappings() - loaded node "CEC Adapter" 19:24:53 T:1781298408 DEBUG: bool PERIPHERALS::CPeripherals::LoadMappings() - loaded node "Pulse-Eight CEC Adapter" 19:24:53 T:1781298408 DEBUG: bool PERIPHERALS::CPeripherals::LoadMappings() - loaded node "iMON HID device" 19:24:53 T:1781298408 DEBUG: PERIPHERALS::CPeripheralBusUSB::CPeripheralBusUSB(PERIPHERALS::CPeripherals) - using libusb peripheral scanning 19:24:53 T:1781298408 DEBUG: SECTION:LoadDLL(libcec.so) 19:24:53 T:1781298408 DEBUG: Loading: libcec.so 19:24:53 T:1781298408 ERROR: Unable to load libcec.so, reason: (null) 19:24:53 T:1781298408 DEBUG: Dll libcec.so was not found in path 19:24:53 T:1781298408 ERROR: virtual void PERIPHERALS::CPeripherals::Initialise() - failed to initialise bus cec 19:24:53 T:1807418536 NOTICE: Thread PeripBusUSB start, auto delete: false 19:24:56 T:1781298408 INFO: aml_permissions: permissions changed 19:24:56 T:1781298408 NOTICE: virtual bool CWinSystemEGL::InitWindowSystem(): Using EGL Implementation: android 19:24:56 T:1781298408 DEBUG: bool CWinSystemEGL::CreateWindow(RESOLUTION_INFO&): Created surface of size 1280x720 19:24:56 T:1781298408 NOTICE: Current resolution: 1280x720 @ 60.00 - Full Screen 19:24:56 T:1781298408 NOTICE: Previous line repeats 1 times. 19:24:56 T:1781298408 NOTICE: Found resolution 1280 x 720 for display 0 with 1280 x 720 @ 60.000000 Hz 19:24:56 T:1781298408 NOTICE: Found (1280x720@60.000000) at 16, setting to RES_DESKTOP at 16 19:24:56 T:1781298408 NOTICE: Checking resolution 16 19:24:56 T:1781298408 NOTICE: Current resolution: 1280x720 @ 60.00 - Full Screen 19:24:56 T:1781298408 DEBUG: bool CWinSystemEGL::CreateWindow(RESOLUTION_INFO&): Created surface of size 1280x720 19:24:56 T:1781298408 NOTICE: GL_VENDOR = ARM 19:24:56 T:1781298408 NOTICE: GL_RENDERER = Mali-450 MP 19:24:56 T:1781298408 NOTICE: GL_VERSION = OpenGL ES 2.0 19:24:56 T:1781298408 NOTICE: GL_SHADING_LANGUAGE_VERSION = OpenGL ES GLSL ES 1.00 19:24:56 T:1781298408 DEBUG: GLES: Extension Support Test - GL_NVX_gpu_memory_info NO 19:24:56 T:1781298408 NOTICE: GL_EXTENSIONS = GL_EXT_debug_marker GL_OES_texture_npot GL_OES_compressed_ETC1_RGB8_texture GL_OES_standard_derivatives GL_OES_EGL_image GL_OES_depth24 GL_ARM_rgba8 GL_ARM_mali_shader_binary GL_OES_depth_texture GL_OES_packed_depth_stencil GL_EXT_texture_format_BGRA8888 GL_OES_vertex_half_float GL_EXT_blend_minmax GL_OES_EGL_image_external GL_OES_EGL_sync GL_OES_rgb8_rgba8 GL_EXT_multisampled_render_to_texture GL_EXT_discard_framebuffer GL_OES_get_program_binary GL_ARM_mali_program_binary GL_EXT_shader_texture_lod GL_EXT_robustness GL_OES_depth_texture_cube_map GL_KHR_debug 19:24:56 T:1781298408 DEBUG: GLES: Extension Support Test - GL_EXT_texture_format_BGRA8888 YES 19:24:56 T:1781298408 DEBUG: GLES: Extension Support Test - GL_IMG_texture_format_BGRA8888 NO 19:24:56 T:1781298408 DEBUG: GLES: Extension Support Test - GL_APPLE_texture_format_BGRA8888 NO 19:24:56 T:1781298408 DEBUG: GL: Vertex Shader compilation log: 19:24:56 T:1781298408 DEBUG: GL: Vertex Shader compiled successfully 19:24:56 T:1781298408 DEBUG: GL: Pixel Shader compilation log: 19:24:56 T:1781298408 DEBUG: GL: Fragment Shader compiled successfully 19:24:56 T:1781298408 DEBUG: GUI Shader [guishader_frag_default.glsl]- Initialise successful : 0x6b5e8df0 19:24:56 T:1781298408 DEBUG: GL: Vertex Shader compilation log: 19:24:56 T:1781298408 DEBUG: GL: Vertex Shader compiled successfully 19:24:56 T:1781298408 DEBUG: GL: Pixel Shader compilation log: 19:24:56 T:1781298408 DEBUG: GL: Fragment Shader compiled successfully 19:24:56 T:1781298408 DEBUG: GUI Shader [guishader_frag_texture.glsl]- Initialise successful : 0x6c31e150 19:24:56 T:1781298408 DEBUG: GL: Vertex Shader compilation log: 19:24:56 T:1781298408 DEBUG: GL: Vertex Shader compiled successfully 19:24:56 T:1781298408 DEBUG: GL: Pixel Shader compilation log: 19:24:56 T:1781298408 DEBUG: GL: Fragment Shader compiled successfully 19:24:56 T:1781298408 DEBUG: GUI Shader [guishader_frag_multi.glsl]- Initialise successful : 0x6c327718 19:24:56 T:1781298408 DEBUG: GL: Vertex Shader compilation log: 19:24:56 T:1781298408 DEBUG: GL: Vertex Shader compiled successfully 19:24:56 T:1781298408 DEBUG: GL: Pixel Shader compilation log: 19:24:56 T:1781298408 DEBUG: GL: Fragment Shader compiled successfully 19:24:56 T:1781298408 DEBUG: GUI Shader [guishader_frag_fonts.glsl]- Initialise successful : 0x6c32cdb8 19:24:56 T:1781298408 DEBUG: GL: Vertex Shader compilation log: 19:24:56 T:1781298408 DEBUG: GL: Vertex Shader compiled successfully 19:24:56 T:1781298408 DEBUG: GL: Pixel Shader compilation log: 19:24:56 T:1781298408 DEBUG: GL: Fragment Shader compiled successfully 19:24:56 T:1781298408 DEBUG: GUI Shader [guishader_frag_texture_noblend.glsl]- Initialise successful : 0x6c332280 19:24:56 T:1781298408 DEBUG: GL: Vertex Shader compilation log: 19:24:56 T:1781298408 DEBUG: GL: Vertex Shader compiled successfully 19:24:56 T:1781298408 DEBUG: GL: Pixel Shader compilation log: 19:24:56 T:1781298408 DEBUG: GL: Fragment Shader compiled successfully 19:24:56 T:1781298408 DEBUG: GUI Shader [guishader_frag_multi_blendcolor.glsl]- Initialise successful : 0x6c337620 19:24:56 T:1781298408 DEBUG: GL: Vertex Shader compilation log: 19:24:56 T:1781298408 DEBUG: GL: Vertex Shader compiled successfully 19:24:56 T:1781298408 DEBUG: GL: Pixel Shader compilation log: 19:24:56 T:1781298408 DEBUG: GL: Fragment Shader compiled successfully 19:24:56 T:1781298408 DEBUG: GUI Shader [guishader_frag_rgba.glsl]- Initialise successful : 0x6c33cea0 19:24:56 T:1781298408 DEBUG: GLES: Extension Support Test - GL_OES_EGL_image_external YES 19:24:56 T:1781298408 DEBUG: GL: Vertex Shader compilation log: 19:24:56 T:1781298408 DEBUG: GL: Vertex Shader compiled successfully 19:24:56 T:1781298408 DEBUG: GL: Pixel Shader compilation log: 19:24:56 T:1781298408 DEBUG: GL: Fragment Shader compiled successfully 19:24:56 T:1781298408 DEBUG: GUI Shader [guishader_frag_rgba_oes.glsl]- Initialise successful : 0x6c3422e8 19:24:56 T:1781298408 DEBUG: GL: Vertex Shader compilation log: 19:24:56 T:1781298408 DEBUG: GL: Vertex Shader compiled successfully 19:24:56 T:1781298408 DEBUG: GL: Pixel Shader compilation log: 19:24:56 T:1781298408 DEBUG: GL: Fragment Shader compiled successfully 19:24:56 T:1781298408 DEBUG: GUI Shader [guishader_frag_rgba_blendcolor.glsl]- Initialise successful : 0x6c347a70 19:24:56 T:1781298408 NOTICE: Current resolution: 1280x720 @ 60.00 - Full Screen 19:24:56 T:1781298408 DEBUG: CWinSystemEGL::CreateNewWindow: No need to create a new window 19:24:56 T:1781298408 INFO: GLES: Maximum texture width: 4096 19:24:56 T:1781298408 DEBUG: CRenderManager::UpdateDisplayLatency - Latency set to 0 msec 19:24:56 T:1781298408 INFO: load default splash image: /data/data/org.xbmc.kodi/cache/apk/assets/media/Splash.png 19:24:56 T:1781298408 DEBUG: SECTION:LoadDLL(libImageLib-arm.so) 19:24:56 T:1781298408 DEBUG: Loading: /data/app-lib/org.xbmc.kodi-1/libImageLib-arm.so 19:24:56 T:1781298408 INFO: load keymapping 19:24:56 T:1781298408 INFO: Loading special://xbmc/system/keymaps/appcommand.xml 19:24:56 T:1781298408 INFO: Loading special://xbmc/system/keymaps/gamepad.xml 19:24:56 T:1781298408 INFO: Loading special://xbmc/system/keymaps/joystick.xml 19:24:56 T:1781298408 NOTICE: No Joystick name specified, loading default map 19:24:56 T:1781298408 NOTICE: Previous line repeats 36 times. 19:24:56 T:1781298408 INFO: Loading special://xbmc/system/keymaps/keyboard.xml 19:24:56 T:1781298408 INFO: Loading special://xbmc/system/keymaps/mouse.xml 19:24:56 T:1781298408 INFO: Loading special://xbmc/system/keymaps/remote.xml 19:24:57 T:1781298408 INFO: Loading special://xbmc/system/keymaps/touchscreen.xml 19:24:57 T:1781298408 INFO: GUI format 1280x720, Display 1280x720 @ 60.00 - Full Screen 19:24:57 T:1781298408 DEBUG: guilib: Fill viewport on change for solving rendering passes 19:24:57 T:1781298408 DEBUG: SECTION:LoadDLL(libcurl.so) 19:24:57 T:1781298408 DEBUG: Loading: /data/app-lib/org.xbmc.kodi-1/libcurl.so 19:24:57 T:1781298408 NOTICE: Running database version Addons16 19:24:57 T:1781298408 DEBUG: void CDatabaseManager::Initialize(bool), updating databases... 19:24:57 T:1781298408 NOTICE: Running database version ViewModes6 19:24:57 T:1781298408 NOTICE: Running database version Textures13 19:24:57 T:1781298408 NOTICE: Running database version MyMusic48 19:24:57 T:1781298408 NOTICE: Running database version MyVideos90 19:24:57 T:1781298408 NOTICE: Running database version TV26 19:24:57 T:1781298408 NOTICE: Running database version Epg8 19:24:57 T:1781298408 DEBUG: void CDatabaseManager::Initialize(bool), updating databases... DONE 19:24:57 T:1781298408 INFO: DPMS: not supported on this platform 19:24:57 T:1781298408 DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc 19:24:57 T:1781298408 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnClear 19:24:57 T:1781298408 INFO: Unloading old skin ... 19:24:57 T:1781298408 INFO: load skin from: /data/data/org.xbmc.kodi/cache/apk/assets/addons/skin.confluence (version: 2.5.12) 19:24:57 T:1781298408 INFO: load fonts for skin... 19:24:57 T:1781298408 INFO: Loading fonts from /data/data/org.xbmc.kodi/cache/apk/assets/addons/skin.confluence/720p/Font.xml 19:24:57 T:1781298408 DEBUG: POParser: loaded 149 strings from file /data/data/org.xbmc.kodi/cache/apk/assets/addons/skin.confluence/language/English/strings.po 19:24:57 T:1781298408 INFO: Loading skin includes from /data/data/org.xbmc.kodi/cache/apk/assets/addons/skin.confluence/720p/includes.xml 19:24:57 T:1781298408 INFO: load new skin... 19:24:57 T:1781298408 INFO: Loading user windows, path /data/data/org.xbmc.kodi/cache/apk/assets/addons/skin.confluence/720p 19:24:57 T:1781298408 DEBUG: Load Skin XML: 51.06ms 19:24:57 T:1781298408 INFO: initialize new skin... 19:24:57 T:1781298408 DEBUG: guilib: Fill viewport on change for solving rendering passes 19:24:57 T:1781298408 INFO: Loading skin file: Pointer.xml, load type: LOAD_ON_GUI_INIT 19:24:57 T:1781298408 DEBUG: bool CTextureBundleXBT::OpenBundle() - Opened bundle /data/data/org.xbmc.kodi/cache/apk/assets/addons/skin.confluence/media/Textures.xbt 19:24:57 T:1781298408 INFO: Loading skin file: DialogVolumeBar.xml, load type: LOAD_ON_GUI_INIT 19:24:57 T:1781298408 INFO: Loading skin file: DialogKaiToast.xml, load type: LOAD_ON_GUI_INIT 19:24:57 T:1781298408 INFO: Loading skin file: DialogMuteBug.xml, load type: LOAD_ON_GUI_INIT 19:24:57 T:1781298408 INFO: Loading skin file: DialogSeekBar.xml, load type: LOAD_ON_GUI_INIT 19:24:57 T:1781298408 INFO: Loading skin file: DialogBusy.xml, load type: LOAD_ON_GUI_INIT 19:24:57 T:1781298408 INFO: Loading skin file: DialogExtendedProgressBar.xml, load type: LOAD_ON_GUI_INIT 19:24:57 T:1781298408 INFO: Loading /data/data/org.xbmc.kodi/cache/apk/assets/addons/skin.confluence/sounds/sounds.xml 19:24:58 T:1781298408 INFO: skin loaded... 19:24:58 T:1781298408 DEBUG: JSONRPC: JSON schema type broadcastnext references an unknown type PVR.Details.Broadcast 19:24:58 T:1781298408 WARNING: JSONRPC: Could not parse type "PVR.Details.Channel" 19:24:58 T:1781298408 INFO: JSONRPC: Adding type "PVR.Details.Channel" to list of incomplete definitions (waiting for "PVR.Details.Broadcast") 19:24:58 T:1781298408 DEBUG: JSONRPC: JSON schema type references an unknown type PVR.Details.Channel 19:24:58 T:1781298408 DEBUG: Invalid item definition in "items" for type channels 19:24:58 T:1781298408 WARNING: JSONRPC: Could not parse type "PVR.Details.ChannelGroup.Extended" 19:24:58 T:1781298408 INFO: JSONRPC: Adding type "PVR.Details.ChannelGroup.Extended" to list of incomplete definitions (waiting for "PVR.Details.Channel") 19:24:58 T:1781298408 INFO: JSONRPC: Resolving incomplete types/methods referencing PVR.Details.Broadcast 19:24:58 T:1781298408 INFO: JSONRPC: Resolving incomplete types/methods referencing PVR.Details.Channel 19:24:58 T:1781298408 DEBUG: JSONRPC: JSON schema type stereoscopicmode references an unknown type GUI.Stereoscopy.Mode 19:24:58 T:1781298408 WARNING: JSONRPC: Could not parse type "GUI.Property.Value" 19:24:58 T:1781298408 INFO: JSONRPC: Adding type "GUI.Property.Value" to list of incomplete definitions (waiting for "GUI.Stereoscopy.Mode") 19:24:58 T:1781298408 INFO: JSONRPC: Resolving incomplete types/methods referencing GUI.Stereoscopy.Mode 19:24:58 T:1781298408 DEBUG: JSONRPC: JSON schema type definition references an unknown type Setting.Details.Setting 19:24:58 T:1781298408 WARNING: JSONRPC: Could not parse type "Setting.Details.SettingList" 19:24:58 T:1781298408 INFO: JSONRPC: Adding type "Setting.Details.SettingList" to list of incomplete definitions (waiting for "Setting.Details.Setting") 19:24:58 T:1781298408 INFO: JSONRPC: Resolving incomplete types/methods referencing Setting.Details.Setting 19:24:58 T:1781298408 INFO: JSONRPC v6.21.2: Successfully initialized 19:24:58 T:1781298408 DEBUG: ADDON: Starting service addons. 19:24:58 T:1833913184 NOTICE: Thread LanguageInvoker start, auto delete: false 19:24:58 T:1781298408 DEBUG: Activating window ID: 12999 19:24:58 T:1833913184 INFO: initializing python engine. 19:24:58 T:1781298408 DEBUG: ------ Window Init (Startup.xml) ------ 19:24:58 T:1781298408 INFO: Loading skin file: Startup.xml, load type: LOAD_EVERY_TIME 19:24:58 T:1781298408 INFO: removing tempfiles 19:24:58 T:1781298408 DEBUG: ADDON: Starting service addons. 19:24:58 T:1781298408 NOTICE: initialize done 19:24:58 T:1781298408 NOTICE: Running the application... 19:24:58 T:1781298408 DEBUG: Activating window ID: 10000 19:24:58 T:1781298408 DEBUG: ------ Window Init () ------ 19:24:58 T:1781298408 INFO: GLES: Enabling VSYNC 19:24:58 T:1781298408 INFO: GLES: Selected vsync mode 10 19:24:58 T:1781298408 DEBUG: ------ Window Deinit (Startup.xml) ------ 19:24:58 T:1781298408 DEBUG: ------ Window Init (Home.xml) ------ 19:24:58 T:1781298408 INFO: Loading skin file: Home.xml, load type: KEEP_INMEMORY 19:24:58 T:1833913184 DEBUG: CPythonInvoker(0, /data/data/org.xbmc.kodi/cache/apk/assets/addons/service.xbmc.versioncheck/service.py): start processing 19:24:58 T:1833913184 NOTICE: -->Python Interpreter Initialized<-- 19:24:58 T:1833913184 DEBUG: CPythonInvoker(0, /data/data/org.xbmc.kodi/cache/apk/assets/addons/service.xbmc.versioncheck/service.py): the source file to load is "/data/data/org.xbmc.kodi/cache/apk/assets/addons/service.xbmc.versioncheck/service.py" 19:24:58 T:1833913184 DEBUG: CPythonInvoker(0, /data/data/org.xbmc.kodi/cache/apk/assets/addons/service.xbmc.versioncheck/service.py): setting the Python path to /data/data/org.xbmc.kodi/cache/apk/assets/addons/service.xbmc.versioncheck:/:/data/app/org.xbmc.kodi-1.apk/assets/python2.6/lib/python26.zip:/data/app/org.xbmc.kodi-1.apk/assets/python2.6/lib/python2.6:/data/app/org.xbmc.kodi-1.apk/assets/python2.6/lib/python2.6/plat-linux3:/data/app/org.xbmc.kodi-1.apk/assets/python2.6/lib/python2.6/lib-tk:/data/app/org.xbmc.kodi-1.apk/assets/python2.6/lib/python2.6/lib-old:/data/app/org.xbmc.kodi-1.apk/assets/python2.6/lib/python2.6/lib-dynload 19:24:58 T:1833913184 DEBUG: CPythonInvoker(0, /data/data/org.xbmc.kodi/cache/apk/assets/addons/service.xbmc.versioncheck/service.py): entering source directory /data/data/org.xbmc.kodi/cache/apk/assets/addons/service.xbmc.versioncheck 19:24:58 T:1833913184 DEBUG: CPythonInvoker(0, /data/data/org.xbmc.kodi/cache/apk/assets/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 19:24:58 T:1833913184 DEBUG: Version Check: Version 0.3.2 started 19:24:58 T:1836767664 NOTICE: Thread JobWorker start, auto delete: true 19:24:58 T:1836767664 DEBUG: CRecentlyAddedJob::UpdateMusic() - Running RecentlyAdded home screen update 19:24:58 T:1836767664 DEBUG: GetRecentlyAddedAlbumSongs() query: SELECT songview. FROM (SELECT idAlbum FROM albumview ORDER BY idAlbum DESC LIMIT 10) AS recentalbums JOIN songview ON songview.idAlbum=recentalbums.idAlbum 19:24:58 T:1836767664 DEBUG: bool CMusicDatabase::GetRecentlyAddedAlbums(VECALBUMS&, unsigned int) query: select * from albumview where strAlbum != '' order by idAlbum desc limit 10 19:24:58 T:1836767664 DEBUG: CRecentlyAddedJob::UpdateVideos() - Running RecentlyAdded home screen update 19:24:58 T:1781298408 DEBUG: no profile autoexec.py (/storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/userdata/autoexec.py) found, skipping 19:24:58 T:1781298408 DEBUG: void CNetwork::NetworkMessage(CNetwork::EMESSAGE, int) - Starting network services 19:24:58 T:1781298408 NOTICE: starting zeroconf publishing 19:24:58 T:1837292960 NOTICE: Thread ZerocconfEmbedded start, auto delete: false 19:24:58 T:1837292960 DEBUG: ZeroconfEmbedded - processing... 19:24:58 T:1837211216 NOTICE: Thread JobWorker start, auto delete: true 19:24:58 T:1781298408 NOTICE: ES: Starting event server 19:24:58 T:1836508584 NOTICE: Thread EventServer start, auto delete: false 19:24:58 T:1836508584 NOTICE: ES: Starting UDP Event server on 0.0.0.0:9777 19:24:58 T:1781298408 INFO: JSONRPC Server: Successfully initialized 19:24:58 T:1836508584 NOTICE: UDP: Listening on port 9777 19:24:58 T:1837041040 NOTICE: Thread TCPServer start, auto delete: false 19:24:58 T:1837211216 DEBUG: ZeroconfMDNS: identifier: servers.jsonrpc-tpc type: _xbmc-jsonrpc._tcp name:Kodi (localhost) port:9090 19:24:58 T:1781298408 NOTICE: Current resolution: 1280x720 @ 60.00 - Full Screen 19:24:58 T:1781298408 DEBUG: CWinSystemEGL::CreateNewWindow: No need to create a new window 19:24:58 T:1837211216 DEBUG: ZeroconfMDNS: identifier: servers.eventserver type: _xbmc-events._udp name:Kodi (localhost) port:9777 19:24:58 T:1836698512 NOTICE: Thread JobWorker start, auto delete: true 19:24:58 T:1781298408 NOTICE: GL_VENDOR = ARM 19:24:58 T:1781298408 NOTICE: GL_RENDERER = Mali-450 MP 19:24:58 T:1781298408 NOTICE: GL_VERSION = OpenGL ES 2.0 19:24:58 T:1781298408 NOTICE: GL_SHADING_LANGUAGE_VERSION = OpenGL ES GLSL ES 1.00 19:24:58 T:1781298408 DEBUG: GLES: Extension Support Test - GL_NVX_gpu_memory_info NO 19:24:58 T:1781298408 NOTICE: GL_EXTENSIONS = GL_EXT_debug_marker GL_OES_texture_npot GL_OES_compressed_ETC1_RGB8_texture GL_OES_standard_derivatives GL_OES_EGL_image GL_OES_depth24 GL_ARM_rgba8 GL_ARM_mali_shader_binary GL_OES_depth_texture GL_OES_packed_depth_stencil GL_EXT_texture_format_BGRA8888 GL_OES_vertex_half_float GL_EXT_blend_minmax GL_OES_EGL_image_external GL_OES_EGL_sync GL_OES_rgb8_rgba8 GL_EXT_multisampled_render_to_texture GL_EXT_discard_framebuffer GL_OES_get_program_binary GL_ARM_mali_program_binary GL_EXT_shader_texture_lod GL_EXT_robustness GL_OES_depth_texture_cube_map GL_KHR_debug 19:24:58 T:1781298408 DEBUG: GLES: Extension Support Test - GL_EXT_texture_format_BGRA8888 YES 19:24:58 T:1781298408 DEBUG: GLES: Extension Support Test - GL_IMG_texture_format_BGRA8888 NO 19:24:58 T:1781298408 DEBUG: GLES: Extension Support Test - GL_APPLE_texture_format_BGRA8888 NO 19:24:58 T:1781298408 DEBUG: GUI Shader - Tried to Initialise again. Was this intentional? 19:24:58 T:1836767664 DEBUG: int CVideoDatabase::RunQuery(const CStdString&) took 2 ms for 0 items query: select * from movieview ORDER BY dateAdded desc, idMovie desc LIMIT 10 19:24:58 T:1836767664 DEBUG: int CVideoDatabase::RunQuery(const CStdString&) took 3 ms for 0 items query: select * from episodeview ORDER BY dateAdded desc, idEpisode desc LIMIT 10 19:24:58 T:1836767664 DEBUG: int CVideoDatabase::RunQuery(const CStdString&) took 3 ms for 0 items query: select * from musicvideoview ORDER BY dateAdded desc, idMVideo desc LIMIT 10 19:24:58 T:1836767664 DEBUG: CRecentlyAddedJob::UpdateTotal() - Running RecentlyAdded home screen update 19:24:58 T:1836225112 NOTICE: Thread RSSReader start, auto delete: false 19:24:58 T:1836225112 DEBUG: CurlFile::Open(0x6f09cc80) http://feeds.xbmc.org/xbmc 19:24:58 T:1836225112 INFO: void XCURL::DllLibCurlGlobal::easyaquire(const char, const char_, XCURL::CURL_HANDLE, XCURL::CURLM) - Created session to http://feeds.xbmc.org 19:24:58 T:1781298408 INFO: GLES: Enabling VSYNC 19:24:58 T:1781298408 INFO: GLES: Selected vsync mode 10 19:24:59 T:1836225112 DEBUG: Got rss feed: http://feeds.xbmc.org/xbmc 19:24:59 T:1836225112 DEBUG: RSS feed encoding: UTF-8 19:24:59 T:1836225112 DEBUG: Parsed rss feed: http://feeds.xbmc.org/xbmc 19:24:59 T:1836225112 DEBUG: CurlFile::Open(0x6f09cc80) http://feeds.xbmc.org/latest_xbmc_addons 19:24:59 T:1836225112 DEBUG: Got rss feed: http://feeds.xbmc.org/latest_xbmc_addons 19:24:59 T:1836225112 DEBUG: RSS feed encoding: UTF-8 19:24:59 T:1836225112 DEBUG: Parsed rss feed: http://feeds.xbmc.org/latest_xbmc_addons 19:24:59 T:1836225112 DEBUG: CurlFile::Open(0x6f09cc80) http://feeds.xbmc.org/updated_xbmc_addons 19:24:59 T:1836225112 DEBUG: Got rss feed: http://feeds.xbmc.org/updated_xbmc_addons 19:24:59 T:1836225112 DEBUG: RSS feed encoding: UTF-8 19:24:59 T:1836225112 DEBUG: Parsed rss feed: http://feeds.xbmc.org/updated_xbmc_addons 19:24:59 T:1836225112 DEBUG: Thread RSSReader 1836225112 terminating 19:24:59 T:1837292960 DEBUG: ZeroconfMDNS: Kodi (localhost)._xbmc-jsonrpc._tcp.local. registration removed 19:24:59 T:1837292960 DEBUG: ZeroconfMDNS: Kodi (localhost)._xbmc-events._udp.local. registration removed 19:25:01 T:1781298408 DEBUG: Keyboard: scancode: 0x15, sym: 0x0114, unicode: 0x0000, modifier: 0x0 19:25:01 T:1781298408 DEBUG: bool CApplication::OnKey(const CKey&): left (0xf082) pressed, action is Left 19:25:03 T:1781298408 DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0 19:25:03 T:1781298408 DEBUG: bool CApplication::OnKey(const CKey&): down (0xf081) pressed, action is Down 19:25:04 T:1833913184 DEBUG: Version Check: Version installed {u'major': 14, u'tag': u'stable', u'minor': 2, u'revision': u'2015-03-26-7cc53a9-dirty'} 19:25:04 T:1833913184 DEBUG: Version Check: Version available {u'major': u'14', u'extrainfo': u'final', u'tagversion': u'', u'tag': u'stable', u'addon_support': u'yes', u'minor': u'0', u'revision': u'20141223-ad747d9'} 19:25:04 T:1833913184 DEBUG: Version Check: There is no newer stable available 19:25:04 T:1833913184 INFO: CPythonInvoker(0, /data/data/org.xbmc.kodi/cache/apk/assets/addons/service.xbmc.versioncheck/service.py): script successfully run 19:25:04 T:1833913184 INFO: Python script stopped 19:25:04 T:1833913184 DEBUG: Thread LanguageInvoker 1833913184 terminating 19:25:04 T:1781298408 DEBUG: Keyboard: scancode: 0x42, sym: 0x000d, unicode: 0x000a, modifier: 0x0 19:25:04 T:1781298408 DEBUG: bool CApplication::OnKey(const CKey&): return (0xf00d) pressed, action is Select 19:25:04 T:1781298408 DEBUG: Activating window ID: 10025 19:25:04 T:1781298408 DEBUG: ------ Window Deinit (Home.xml) ------ 19:25:04 T:1781298408 DEBUG: ------ Window Init (MyVideoNav.xml) ------ 19:25:04 T:1781298408 INFO: Loading skin file: MyVideoNav.xml, load type: KEEP_IN_MEMORY 19:25:04 T:1781298408 DEBUG: CGUIMediaWindow::GetDirectory (sources://video/) 19:25:04 T:1781298408 DEBUG: ParentPath = [sources://video/] 19:25:04 T:1841304408 NOTICE: Thread BackgroundLoader start, auto delete: false 19:25:04 T:1841304408 DEBUG: Thread BackgroundLoader 1841304408 terminating 19:25:06 T:1781298408 DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0 19:25:06 T:1781298408 DEBUG: bool CApplication::OnKey(const CKey&): down (0xf081) pressed, action is Down 19:25:07 T:1781298408 DEBUG: Keyboard: scancode: 0x42, sym: 0x000d, unicode: 0x000a, modifier: 0x0 19:25:07 T:1781298408 DEBUG: bool CApplication::OnKey(const CKey&): return (0xf00d) pressed, action is Select 19:25:07 T:1781298408 DEBUG: CGUIMediaWindow::GetDirectory (/sdcard/) 19:25:07 T:1781298408 DEBUG: ParentPath = [sources://video/] 19:25:07 T:1781298408 DEBUG: int CVideoDatabase::RunQuery(const CStdString&) took 1 ms for 1 items query: SELECT files.strFilename, files.playCount, bookmark.timeInSeconds, bookmark.totalTimeInSeconds FROM files LEFT JOIN bookmark ON files.idFile = bookmark.idFile AND bookmark.type = 1 WHERE files.idPath=1 19:25:07 T:1841304408 NOTICE: Thread BackgroundLoader start, auto delete: false 19:25:07 T:1841304408 DEBUG: Thread BackgroundLoader 1841304408 terminating 19:25:08 T:1781298408 DEBUG: Keyboard: scancode: 0x13, sym: 0x0111, unicode: 0x0000, modifier: 0x0 19:25:08 T:1781298408 DEBUG: bool CApplication::OnKey(const CKey&): up (0xf080) pressed, action is Up 19:25:09 T:1781298408 DEBUG: Keyboard: scancode: 0x42, sym: 0x000d, unicode: 0x000a, modifier: 0x0 19:25:09 T:1781298408 DEBUG: bool CApplication::OnKey(const CKey&): return (0xf00d) pressed, action is Select 19:25:09 T:1781298408 DEBUG: virtual bool CGUIWindowVideoBase::OnPlayMedia(int) /sdcard/Lego Hampocalypse [720p].mp4 19:25:10 T:1781298408 DEBUG: int CVideoDatabase::GetMovieId(const CStdString&) (/sdcard/Lego Hampocalypse [720p].mp4), query = select idMovie from movie where idFile=1 19:25:10 T:1781298408 DEBUG: int CVideoDatabase::GetEpisodeId(const CStdString&, int, int) (/sdcard/Lego Hampocalypse [720p].mp4), query = select idEpisode from episode where idFile=1 19:25:10 T:1781298408 DEBUG: int CVideoDatabase::GetMusicVideoId(const CStdString&) (/sdcard/Lego Hampocalypse [720p].mp4), query = select idMVideo from musicvideo where idFile=1 19:25:10 T:1781298408 DEBUG: CAnnouncementManager - Announcement: OnAdd from xbmc 19:25:10 T:1781298408 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnAdd 19:25:10 T:1781298408 DEBUG: Loading settings for /sdcard/Lego Hampocalypse [720p].mp4 19:25:10 T:1781298408 DEBUG: CPlayerCoreFactory::GetPlayers(/sdcard/Lego Hampocalypse [720p].mp4) 19:25:10 T:1781298408 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules 19:25:10 T:1781298408 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules 19:25:10 T:1781298408 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtv 19:25:10 T:1781298408 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: hdhomerun/myth/mms/udp 19:25:10 T:1781298408 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout 19:25:10 T:1781298408 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp 19:25:10 T:1781298408 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp 19:25:10 T:1781298408 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams 19:25:10 T:1781298408 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd 19:25:10 T:1781298408 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage 19:25:10 T:1781298408 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf 19:25:10 T:1781298408 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv 19:25:10 T:1781298408 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio 19:25:10 T:1781298408 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players 19:25:10 T:1781298408 DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (1) 19:25:10 T:1781298408 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0 19:25:10 T:1781298408 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1 19:25:10 T:1781298408 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: DVDPlayer (1) 19:25:10 T:1781298408 DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players 19:25:10 T:1781298408 NOTICE: DVDPlayer: Opening: /sdcard/Lego Hampocalypse [720p].mp4 19:25:10 T:1781298408 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED 19:25:10 T:1781298408 DEBUG: CRenderManager::UpdateDisplayLatency - Latency set to 0 msec 19:25:10 T:1781298408 DEBUG: LinuxRendererGL: Cleaning up GL resources 19:25:10 T:1836631776 NOTICE: Thread DVDPlayer start, auto delete: false 19:25:10 T:1836631776 NOTICE: Creating InputStream 19:25:10 T:1836631776 DEBUG: static void CUtil::ScanForExternalSubtitles(const string&, std::vectorstd::basic_string&): Searching for subtitles... 19:25:10 T:1836631776 DEBUG: static void CUtil::ScanForExternalSubtitles(const string&, std::vectorstd::basicstring&): END (total time: 7 ms) 19:25:10 T:1836631776 NOTICE: Creating Demuxer 19:25:10 T:1836631776 DEBUG: bool CDVDDemuxFFmpeg::Open(CDVDInputStream, bool, bool) - probing detected format [mov,mp4,m4a,3gp,3g2,mj2] 19:25:10 T:1836631776 DEBUG: bool CDVDDemuxFFmpeg::Open(CDVDInputStream_, bool, bool) - avformat_find_streaminfo starting 19:25:10 T:1836631776 DEBUG: bool CDVDDemuxFFmpeg::Open(CDVDInputStream, bool, bool) - av_find_stream_info finished 19:25:10 T:1836631776 INFO: ffmpeg[6D78C6E0]: Input #0, mov,mp4,m4a,3gp,3g2,mj2, from '/sdcard/Lego Hampocalypse [720p].mp4': 19:25:10 T:1836631776 INFO: ffmpeg[6D78C6E0]: Metadata: 19:25:10 T:1836631776 INFO: ffmpeg[6D78C6E0]: major_brand : mp42 19:25:10 T:1836631776 INFO: ffmpeg[6D78C6E0]: minor_version : 0 19:25:10 T:1836631776 INFO: ffmpeg[6D78C6E0]: compatible_brands: isommp42 19:25:10 T:1836631776 INFO: ffmpeg[6D78C6E0]: creation_time : 2015-03-29 03:29:15 19:25:10 T:1836631776 INFO: ffmpeg[6D78C6E0]: Duration: 00:02:17.97, start: 0.000000, bitrate: 2130 kb/s 19:25:10 T:1836631776 INFO: ffmpeg[6D78C6E0]: Stream #0:0(und): Video: h264 (High) (avc1 / 0x31637661), yuv420p, 1280x720 [SAR 1:1 DAR 16:9], 1935 kb/s, 29.97 fps, 29.97 tbr, 30k tbn, 59.94 tbc (default) 19:25:10 T:1836631776 INFO: ffmpeg[6D78C6E0]: Metadata: 19:25:10 T:1836631776 INFO: ffmpeg[6D78C6E0]: creation_time : 1970-01-01 00:00:00 19:25:10 T:1836631776 INFO: ffmpeg[6D78C6E0]: handler_name : VideoHandler 19:25:10 T:1836631776 INFO: ffmpeg[6D78C6E0]: Stream #0:1(eng): Audio: aac (mp4a / 0x6134706D), 44100 Hz, stereo, fltp, 192 kb/s (default) 19:25:10 T:1836631776 INFO: ffmpeg[6D78C6E0]: Metadata: 19:25:10 T:1836631776 INFO: ffmpeg[6D78C6E0]: creation_time : 2015-03-29 03:29:15 19:25:10 T:1836631776 INFO: ffmpeg[6D78C6E0]: handler_name : IsoMedia File Produced by Google, 5-11-2011 19:25:10 T:1836631776 DEBUG: CDVDDemuxFFmpeg::AddStream(0, ...) -> 0 19:25:10 T:1836631776 DEBUG: CDVDDemuxFFmpeg::AddStream(1, ...) -> 1 19:25:10 T:1836631776 NOTICE: Opening stream: 0 source: 256 19:25:10 T:1836631776 NOTICE: Creating video codec with codec id: 28 19:25:10 T:1836631776 DEBUG: CDVDFactoryCodec: compiled in hardware support: AMCodec:yes MediaCodec:yes OpenMax:no libstagefright:yes VDPAU:no VAAPI:no iMXVPU:no 19:25:10 T:1836631776 DEBUG: FactoryCodec - Video: amcodec - Opening 19:25:10 T:1836631776 INFO: CBitstreamConverter::Open bitstream to annexb init 19:25:10 T:1836631776 DEBUG: SECTION:LoadDLL(libamplayer.so) 19:25:10 T:1836631776 DEBUG: Loading: /system/lib/libamplayer.so 19:25:10 T:1836631776 INFO: DVDVideoCodecAmlogic: Opened Amlogic Codec 19:25:10 T:1836631776 DEBUG: FactoryCodec - Video: am-h264 - Opened 19:25:10 T:1836631776 NOTICE: Creating video thread 19:25:10 T:1836954152 NOTICE: Thread DVDPlayerVideo start, auto delete: false 19:25:10 T:1836631776 NOTICE: Opening stream: 1 source: 256 19:25:10 T:1836954152 NOTICE: running thread: video_thread 19:25:10 T:1836631776 NOTICE: Finding audio codec for: 86018 19:25:10 T:1836631776 DEBUG: FactoryCodec - Audio: passthrough - Opening 19:25:10 T:1836631776 DEBUG: FactoryCodec - Audio: passthrough - Failed 19:25:10 T:1836631776 DEBUG: FactoryCodec - Audio: FFmpeg - Opening 19:25:10 T:1836631776 DEBUG: FactoryCodec - Audio: FFmpeg - Opened 19:25:10 T:1836631776 NOTICE: Creating audio thread 19:25:10 T:1836954152 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE 19:25:10 T:1836631776 DEBUG: bool CEdl::ReadEditDecisionLists(const string&, float, int) - Checking for edit decision lists (EDL) on local drive or remote share for: /sdcard/Lego Hampocalypse [720p].mp4 19:25:10 T:1841496896 NOTICE: Thread DVDPlayerAudio start, auto delete: false 19:25:10 T:1841496896 NOTICE: running thread: CDVDPlayerAudio::Process() 19:25:10 T:1841496896 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE 19:25:10 T:1836631776 DEBUG: virtual void CApplication::OnPlayBackStarted(): play state was 1, starting 1 19:25:10 T:1781298408 DEBUG: PlayBackRet CApplication::PlayFile(const CFileItem&, bool): OpenFile succeed, play state 2 19:25:10 T:1781298408 DEBUG: virtual void CApplication::OnPlayBackStarted(): play state was 2, starting 0 19:25:10 T:1836631776 DEBUG: CDVDPlayer::SetCaching - caching state 3 19:25:10 T:1836954152 DEBUG: CAMLCodec::SetSpeed, speed(0) 19:25:10 T:1836954152 INFO: CDVDPlayerVideo - Stillframe left, switching to normal playback 19:25:10 T:1836954152 DEBUG: CAMLCodec::OpenDecoder, android version 19 19:25:10 T:1841496896 NOTICE: Creating audio stream (codec id: 86018, channels: 2, sample rate: 44100, no pass-through) 19:25:10 T:1841496896 DEBUG: CDVDPlayerAudio:: synctype set to 0: clock feedback 19:25:10 T:1801950592 INFO: CActiveAESink::OpenSink - initialize sink 19:25:10 T:1801950592 DEBUG: CActiveAESink::OpenSink - trying to open device AUDIOTRACK:AudioTrack 19:25:10 T:1801950592 DEBUG: CActiveAESink::OpenSink - AUDIOTRACK Initialized: 19:25:10 T:1801950592 DEBUG: Output Device : android 19:25:10 T:1801950592 DEBUG: Sample Rate : 48000 19:25:10 T:1801950592 DEBUG: Sample Format : AE_FMT_S16NE 19:25:10 T:1801950592 DEBUG: Channel Count : 2 19:25:10 T:1801950592 DEBUG: Channel Layout: FL,FR 19:25:10 T:1801950592 DEBUG: Frames : 1536 19:25:10 T:1801950592 DEBUG: Frame Samples : 3072 19:25:10 T:1801950592 DEBUG: Frame Size : 4 19:25:10 T:1836954152 DEBUG: codecid_to_vformat, id(28) -> vformat(2) 19:25:10 T:1836954152 DEBUG: codec_tag_to_vdec_type, codec_tag(828601953) -> vdec_type(4) 19:25:10 T:1836954152 DEBUG: CAMLCodec::OpenDecoder hints.width(1280), hints.height(720), hints.codec(28), hints.codec_tag(828601953), hints.pid(1) 19:25:10 T:1836954152 DEBUG: CAMLCodec::OpenDecoder hints.fpsrate(30000), hints.fpsscale(1001), hints.rfpsrate(30000), hints.rfpsscale(1001), video_rate(3203) 19:25:10 T:1836954152 DEBUG: CAMLCodec::OpenDecoder hints.aspect(1.777778), video_ratio.num(1), video_ratio.den(1) 19:25:10 T:1836954152 DEBUG: CAMLCodec::OpenDecoder hints.orientation(0), hints.forced_aspect(0), hints.extrasize(35) 19:25:10 T:1801897496 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 19:25:10 T:1781298408 DEBUG: CGUIInfoManager::SetCurrentMovie(/sdcard/Lego Hampocalypse [720p].mp4) 19:25:10 T:1781298408 DEBUG: int CVideoDatabase::GetMovieId(const CStdString&) (/sdcard/Lego Hampocalypse [720p].mp4), query = select idMovie from movie where idFile=1 19:25:10 T:1781298408 DEBUG: int CVideoDatabase::GetEpisodeId(const CStdString&, int, int) (/sdcard/Lego Hampocalypse [720p].mp4), query = select idEpisode from episode where idFile=1 19:25:10 T:1781298408 DEBUG: int CVideoDatabase::GetMusicVideoId(const CStdString&) (/sdcard/Lego Hampocalypse [720p].mp4), query = select idMVideo from musicvideo where idFile=1 19:25:10 T:1781298408 DEBUG: CAnnouncementManager - Announcement: OnPlay from xbmc 19:25:10 T:1781298408 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPlay 19:25:10 T:1836631776 DEBUG: CDVDPlayer::HandleMessages - player started 1 19:25:10 T:1836954152 DEBUG: add four byte NAL 264 header in stream before header len=35 19:25:10 T:1836954152 DEBUG: ppscaler not enabled 19:25:10 T:1836954152 DEBUG: CAMLCodec::SetSpeed, speed(1000) 19:25:10 T:1836954152 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC(33366.666667, 1) 19:25:10 T:1836631776 DEBUG: CDVDPlayer::SetCaching - caching state 0 19:25:10 T:1841496896 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(23219.954649, 1) 19:25:10 T:1841496896 DEBUG: CDVDClock::Discontinuity - CDVDPlayerAudio::HandleSyncError1 - was:-275665.999574, should be:-275661.999574, error:4.000000 19:25:10 T:1836954152 DEBUG: DVDVideoCodecAmlogic: detected new framerate(29.970030), videorate(3203) 19:25:10 T:1836954152 DEBUG: CAMLCodec::SetSpeed, speed(1000) 19:25:10 T:1898863744 NOTICE: Thread CAMLCodec start, auto delete: false 19:25:10 T:1898863744 DEBUG: CAMLCodec::Process Started 19:25:10 T:1836954152 NOTICE: fps: 29.970030, pwidth: 1280, pheight: 720, dwidth: 1280, dheight: 720 19:25:10 T:1836954152 DEBUG: int CDVDPlayerVideo::OutputPicture(const DVDVideoPicture, double) - change configuration. 1280x720. framerate: 29.97. format: BYPASS 19:25:10 T:1836954152 NOTICE: Display resolution DESKTOP : 1280x720 @ 60.00 - Full Screen (16) 19:25:10 T:1836954152 DEBUG: CXBMCRenderManager::Configure - 3 19:25:10 T:1781298408 NOTICE: Using GL_TEXTURE_2D 19:25:10 T:1781298408 DEBUG: GL: Requested render method: 0 19:25:10 T:1781298408 NOTICE: GL: Using BYPASS render method 19:25:10 T:1781298408 NOTICE: GL: NPOT texture support detected 19:25:10 T:1781298408 DEBUG: CLinuxRendererGLES: Reorder drawpoints due to method change from 1 to 256 19:25:10 T:1781298408 DEBUG: Activating window ID: 12005 19:25:10 T:1781298408 DEBUG: ------ Window Deinit (MyVideoNav.xml) ------ 19:25:10 T:1836631776 DEBUG: CDVDPlayer::HandleMessages - player started 2 19:25:10 T:1781298408 DEBUG: ------ Window Init (VideoFullScreen.xml) ------ 19:25:10 T:1781298408 INFO: Loading skin file: VideoFullScreen.xml, load type: KEEP_IN_MEMORY 19:25:10 T:1781298408 DEBUG: CAMLCodec::SetVideo3dMode:mode3d(0x0) 19:25:10 T:1781298408 DEBUG: CAMLCodec::SetVideoRect:display(0,0,1920,1080) 19:25:10 T:1781298408 DEBUG: CAMLCodec::SetVideoRect:gui(0,0,1280,720) 19:25:10 T:1781298408 DEBUG: CAMLCodec::SetVideoRect:m_dst_rect(0,0,1280,720) 19:25:10 T:1781298408 DEBUG: CAMLCodec::SetVideoRect:dst_rect(0,0,1920,1080) 19:25:10 T:1781298408 DEBUG: CAMLCodec::SetVideoRect:m_stereo_mode(0) 19:25:10 T:1781298408 DEBUG: CAMLCodec::SetVideoRect:m_stereo_view(0) 19:25:12 T:1841496896 DEBUG: CDVDClock::Discontinuity - CDVDPlayerAudio::HandleSyncError2 - was:1739900.000426, should be:1703437.599051, error:-36462.401376 19:25:14 T:1781298408 INFO: Python, unloading python shared library because no scripts are running anymore 19:25:14 T:1781298408 DEBUG: void XBPython::UnloadExtensionLibs(), clearing python extension libraries 19:25:14 T:1841496896 DEBUG: CDVDClock::Discontinuity - CDVDPlayerAudio::HandleSyncError2 - was:3781055.599051, should be:3749332.541126, error:-31723.057925 19:25:29 T:1781298408 INFO: void XCURL::DllLibCurlGlobal::CheckIdle() - Closing session to http://feeds.xbmc.org (easy=0x6dec0010, multi=0x6d794c88) 19:25:38 T:1837211216 DEBUG: Thread JobWorker 1837211216 terminating (autodelete) 19:25:38 T:1836698512 DEBUG: Thread JobWorker 1836698512 terminating (autodelete) 19:25:38 T:1836767664 DEBUG: Thread JobWorker 1836767664 terminating (autodelete) 19:25:42 T:1781298408 DEBUG: Keyboard: scancode: 0x42, sym: 0x000d, unicode: 0x000a, modifier: 0x0 19:25:42 T:1781298408 DEBUG: bool CApplication::OnKey(const CKey&): return (0xf00d) pressed, action is OSD 19:25:42 T:1781298408 DEBUG: ------ Window Init (VideoOSD.xml) ------ 19:25:42 T:1781298408 INFO: Loading skin file: VideoOSD.xml, load type: KEEP_IN_MEMORY 19:25:44 T:1781298408 DEBUG: Keyboard: scancode: 0x16, sym: 0x0113, unicode: 0x0000, modifier: 0x0 19:25:44 T:1781298408 DEBUG: bool CApplication::OnKey(const CKey&): right (0xf083) pressed, action is Right 19:25:45 T:1781298408 DEBUG: Keyboard: scancode: 0x42, sym: 0x000d, unicode: 0x000a, modifier: 0x0 19:25:45 T:1781298408 DEBUG: bool CApplication::OnKey(const CKey&): return (0xf00d) pressed, action is Select 19:25:45 T:1781298408 NOTICE: CDVDPlayer::CloseFile() 19:25:45 T:1781298408 NOTICE: DVDPlayer: waiting for threads to exit 19:25:45 T:1836631776 NOTICE: CDVDPlayer::OnExit() 19:25:45 T:1836631776 NOTICE: Closing stream player 1 19:25:45 T:1836631776 NOTICE: Waiting for audio thread to exit 19:25:45 T:1841496896 NOTICE: thread end: CDVDPlayerAudio::OnExit() 19:25:45 T:1836631776 NOTICE: Closing audio device 19:25:45 T:1841496896 DEBUG: Thread DVDPlayerAudio 1841496896 terminating 19:25:45 T:1836631776 NOTICE: Deleting audio codec 19:25:45 T:1836631776 NOTICE: Closing stream player 2 19:25:45 T:1836631776 NOTICE: waiting for video thread to exit 19:25:45 T:1801897496 DEBUG: CActiveAE::DiscardStream - audio stream deleted 19:25:45 T:1801897496 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 19:25:45 T:1801950592 DEBUG: Previous line repeats 1 times. 19:25:45 T:1801950592 INFO: CActiveAESink::OpenSink - initialize sink 19:25:45 T:1801950592 DEBUG: CActiveAESink::OpenSink - trying to open device AUDIOTRACK:AudioTrack 19:25:45 T:1801950592 DEBUG: CActiveAESink::OpenSink - AUDIOTRACK Initialized: 19:25:45 T:1801950592 DEBUG: Output Device : android 19:25:45 T:1801950592 DEBUG: Sample Rate : 48000 19:25:45 T:1801950592 DEBUG: Sample Format : AE_FMT_S16NE 19:25:45 T:1801950592 DEBUG: Channel Count : 2 19:25:45 T:1801950592 DEBUG: Channel Layout: FL,FR 19:25:45 T:1801950592 DEBUG: Frames : 1536 19:25:45 T:1801950592 DEBUG: Frame Samples : 3072 19:25:45 T:1801950592 DEBUG: Frame Size : 4 19:25:45 T:1836954152 NOTICE: thread end: video_thread 19:25:45 T:1836954152 DEBUG: Thread DVDPlayerVideo 1836954152 terminating 19:25:45 T:1836631776 NOTICE: deleting video codec 19:25:45 T:1836631776 DEBUG: CAMLCodec::CloseDecoder 19:25:45 T:1898863744 DEBUG: CAMLCodec::Process Stopped 19:25:45 T:1898863744 DEBUG: Thread CAMLCodec 1898863744 terminating 19:25:45 T:1836631776 DEBUG: virtual void CApplication::OnPlayBackStopped(): play state was 2, starting 0 19:25:45 T:1836631776 DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc 19:25:45 T:1836631776 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop 19:25:45 T:1781298408 NOTICE: DVDPlayer: finished waiting 19:25:45 T:1836631776 DEBUG: Thread DVDPlayer 1836631776 terminating 19:25:45 T:1781298408 DEBUG: LinuxRendererGL: Cleaning up GL resources 19:25:45 T:1781298408 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 19:25:45 T:1781298408 DEBUG: ------ Window Deinit (VideoOSD.xml) ------ 19:25:45 T:1781298408 DEBUG: ------ Window Deinit (VideoFullScreen.xml) ------ 19:25:45 T:1781298408 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 19:25:45 T:1781298408 DEBUG: ------ Window Init (MyVideoNav.xml) ------ 19:25:45 T:1781298408 DEBUG: CGUIMediaWindow::GetDirectory (/sdcard/) 19:25:45 T:1781298408 DEBUG: ParentPath = [/sdcard/] 19:25:45 T:1781298408 DEBUG: int CVideoDatabase::RunQuery(const CStdString&) took 1 ms for 1 items query: SELECT files.strFilename, files.playCount, bookmark.timeInSeconds, bookmark.totalTimeInSeconds FROM files LEFT JOIN bookmark ON files.idFile = bookmark.idFile AND bookmark.type = 1 WHERE files.idPath=1 19:25:45 T:1834527880 NOTICE: Thread BackgroundLoader start, auto delete: false 19:25:45 T:1834527880 DEBUG: Thread BackgroundLoader 1834527880 terminating 19:25:45 T:1781298408 NOTICE: CDVDPlayer::CloseFile() 19:25:45 T:1781298408 NOTICE: DVDPlayer: waiting for threads to exit 19:25:45 T:1781298408 NOTICE: DVDPlayer: finished waiting 19:25:45 T:1781298408 DEBUG: LinuxRendererGL: Cleaning up GL resources 19:25:45 T:1781298408 NOTICE: CDVDPlayer::CloseFile() 19:25:45 T:1781298408 NOTICE: DVDPlayer: waiting for threads to exit 19:25:45 T:1781298408 NOTICE: DVDPlayer: finished waiting 19:25:45 T:1781298408 DEBUG: LinuxRendererGL: Cleaning up GL resources 19:25:45 T:1842929040 NOTICE: Thread JobWorker start, auto delete: true 19:25:45 T:1781298408 DEBUG: SECTION:UnloadDelayed(DLL: libImageLib-arm.so) 19:25:45 T:1842929040 DEBUG: virtual bool CSaveFileStateJob::DoWork() - Saving file state for video item /sdcard/Lego Hampocalypse [720p].mp4 19:25:45 T:1781298408 DEBUG: Unloading: /libImageLib-arm.so 19:25:47 T:1781298408 DEBUG: Keyboard: scancode: 0x04, sym: 0x0008, unicode: 0x0000, modifier: 0x0 19:25:47 T:1781298408 DEBUG: bool CApplication::OnKey(const CKey&): backspace (0xf008) pressed, action is Back 19:25:47 T:1781298408 DEBUG: CGUIMediaWindow::GetDirectory (sources://video/) 19:25:47 T:1781298408 DEBUG: ParentPath = [] 19:25:47 T:1840983816 NOTICE: Thread BackgroundLoader start, auto delete: false 19:25:47 T:1840983816 DEBUG: Thread BackgroundLoader 1840983816 terminating 19:25:48 T:1781298408 DEBUG: Keyboard: scancode: 0x04, sym: 0x0008, unicode: 0x0000, modifier: 0x0 19:25:48 T:1781298408 DEBUG: bool CApplication::OnKey(const CKey&): backspace (0xf008) pressed, action is Back 19:25:48 T:1781298408 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 19:25:48 T:1781298408 DEBUG: ------ Window Deinit (MyVideoNav.xml) ------ 19:25:48 T:1781298408 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 19:25:48 T:1781298408 DEBUG: ------ Window Init (Home.xml) ------ 19:25:49 T:1781298408 DEBUG: Keyboard: scancode: 0x16, sym: 0x0113, unicode: 0x0000, modifier: 0x0 19:25:49 T:1781298408 DEBUG: bool CApplication::OnKey(const CKey&): right (0xf083) pressed, action is Right 19:25:50 T:1781298408 DEBUG: Keyboard: scancode: 0x16, sym: 0x0113, unicode: 0x0000, modifier: 0x0 19:25:50 T:1781298408 DEBUG: bool CApplication::OnKey(const CKey&): right (0xf083) pressed, action is Right 19:25:52 T:1781298408 DEBUG: Keyboard: scancode: 0x16, sym: 0x0113, unicode: 0x0000, modifier: 0x0 19:25:52 T:1781298408 DEBUG: bool CApplication::OnKey(const CKey&): right (0xf083) pressed, action is Right 19:25:52 T:1781298408 DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0 19:25:52 T:1781298408 DEBUG: bool CApplication::OnKey(const CKey&): down (0xf081) pressed, action is Down 19:25:53 T:1781298408 DEBUG: Keyboard: scancode: 0x42, sym: 0x000d, unicode: 0x000a, modifier: 0x0 19:25:53 T:1781298408 DEBUG: bool CApplication::OnKey(const CKey&): return (0xf00d) pressed, action is Select 19:25:53 T:1781298408 DEBUG: Activating window ID: 10004 19:25:54 T:1781298408 DEBUG: ------ Window Deinit (Home.xml) ------ 19:25:54 T:1781298408 DEBUG: ------ Window Init (Settings.xml) ------ 19:25:54 T:1781298408 INFO: Loading skin file: Settings.xml, load type: KEEP_IN_MEMORY 19:25:55 T:1781298408 DEBUG: Keyboard: scancode: 0x13, sym: 0x0111, unicode: 0x0000, modifier: 0x0 19:25:55 T:1781298408 DEBUG: bool CApplication::OnKey(const CKey&): up (0xf080) pressed, action is Up 19:25:57 T:1781298408 DEBUG: Keyboard: scancode: 0x42, sym: 0x000d, unicode: 0x000a, modifier: 0x0 19:25:57 T:1781298408 DEBUG: bool CApplication::OnKey(const CKey&): return (0xf00d) pressed, action is Select 19:25:57 T:1781298408 DEBUG: Activating window ID: 10016 19:25:58 T:1781298408 DEBUG: ------ Window Deinit (Settings.xml) ------ 19:25:58 T:1781298408 DEBUG: ------ Window Init (SettingsCategory.xml) ------ 19:25:58 T:1781298408 INFO: Loading skin file: SettingsCategory.xml, load type: KEEP_IN_MEMORY 19:25:59 T:1781298408 DEBUG: Keyboard: scancode: 0x13, sym: 0x0111, unicode: 0x0000, modifier: 0x0 19:25:59 T:1781298408 DEBUG: bool CApplication::OnKey(const CKey&): up (0xf080) pressed, action is Up 19:25:59 T:1781298408 DEBUG: Keyboard: scancode: 0x13, sym: 0x0111, unicode: 0x0000, modifier: 0x0 19:25:59 T:1781298408 DEBUG: bool CApplication::OnKey(const CKey&): up (0xf080) pressed, action is Up 19:26:00 T:1781298408 DEBUG: Keyboard: scancode: 0x42, sym: 0x000d, unicode: 0x000a, modifier: 0x0 19:26:00 T:1781298408 DEBUG: bool CApplication::OnKey(const CKey&): return (0xf00d) pressed, action is Select 19:26:03 T:1781298408 DEBUG: Keyboard: scancode: 0x16, sym: 0x0113, unicode: 0x0000, modifier: 0x0 19:26:03 T:1781298408 DEBUG: bool CApplication::OnKey(const CKey&): right (0xf083) pressed, action is Right 19:26:05 T:1781298408 DEBUG: Keyboard: scancode: 0x42, sym: 0x000d, unicode: 0x000a, modifier: 0x0 19:26:05 T:1781298408 DEBUG: bool CApplication::OnKey(const CKey&): return (0xf00d) pressed, action is Select 19:26:05 T:1781298408 NOTICE: Disabled debug logging due to GUI setting. Level 0. 19:26:05 T:1781298408 NOTICE: Log level changed to "LOG_LEVEL_NORMAL" 19:26:19 T:1781298408 NOTICE: Storing total System Uptime 19:26:19 T:1781298408 NOTICE: Saving settings 19:26:19 T:1781298408 NOTICE: stop all 19:26:19 T:1781298408 NOTICE: stop player 19:26:19 T:1781298408 NOTICE: ES: Stopping event server 19:26:19 T:1781298408 NOTICE: stopping zeroconf publishing 19:26:20 T:1836508584 NOTICE: ES: UDP Event server stopped 19:26:20 T:1781298408 NOTICE: stop sap announcement listener 19:26:20 T:1781298408 NOTICE: clean cached files! 19:26:20 T:1781298408 NOTICE: unload skin 19:26:20 T:1781298408 NOTICE: stopped 19:26:20 T:1781298408 NOTICE: destroy 19:26:20 T:1781298408 NOTICE: unload sections 19:26:20 T:1781298408 NOTICE: special://profile/ is mapped to: special://masterprofile/ 19:26:20 T:1781298408 NOTICE: destroy 19:26:20 T:1781298408 WARNING: Attempted to remove window 10013 from the window manager when it didn't exist 19:26:20 T:1781298408 WARNING: Attempted to remove window 10014 from the window manager when it didn't exist 19:26:20 T:1781298408 WARNING: Attempted to remove window 10015 from the window manager when it didn't exist 19:26:20 T:1781298408 WARNING: Attempted to remove window 10016 from the window manager when it didn't exist 19:26:20 T:1781298408 WARNING: Attempted to remove window 10017 from the window manager when it didn't exist 19:26:20 T:1781298408 WARNING: Attempted to remove window 10018 from the window manager when it didn't exist 19:26:20 T:1781298408 WARNING: Attempted to remove window 10019 from the window manager when it didn't exist 19:26:20 T:1781298408 WARNING: Attempted to remove window 10021 from the window manager when it didn't exist 19:26:20 T:1781298408 WARNING: Attempted to remove window 10107 from the window manager when it didn't exist 19:26:20 T:1781298408 WARNING: Attempted to remove window 10115 from the window manager when it didn't exist 19:26:20 T:1781298408 WARNING: Attempted to remove window 10104 from the window manager when it didn't exist 19:26:20 T:1781298408 NOTICE: unload sections 19:26:20 T:1781298408 NOTICE: application stopped...

mapfde commented 9 years ago

SPMC 13.4 (all ok)

19:51:10 T:1780955728 NOTICE: special://profile/ is mapped to: special://masterprofile/ 19:51:10 T:1780955728 NOTICE: ----------------------------------------------------------------------- 19:51:10 T:1780955728 NOTICE: Starting XBMC (13.4-SPMC(0) Git:20141214-db065ea). Platform: ARM Android 32-bit 19:51:10 T:1780955728 NOTICE: Using Debug XBMC x32 build, compiled Dec 14 2014 by GCC 4.8.0 for ARM Android 32-bit API level 14 19:51:10 T:1780955728 NOTICE: Running on Android 32-bit API level 19 (Android, 3.10.33 armv7l) 19:51:10 T:1780955728 NOTICE: Host CPU: ARMv7 Processor rev 1 (v7l), 3 cores available 19:51:10 T:1780955728 NOTICE: Product: m201, Device: m201, Board: m201 - Manufacturer: MBX, Brand: MBX, Model: MK808B Plus, Hardware: amlogic 19:51:10 T:1780955728 NOTICE: ARM Features: Neon enabled 19:51:10 T:1780955728 NOTICE: special://xbmc/ is mapped to: /data/data/com.semperpax.spmc/cache/apk/assets 19:51:10 T:1780955728 NOTICE: special://xbmcbin/ is mapped to: /data/data/com.semperpax.spmc/cache/apk/assets 19:51:10 T:1780955728 NOTICE: special://masterprofile/ is mapped to: /storage/emulated/0/Android/data/com.semperpax.spmc/files/.xbmc/userdata 19:51:10 T:1780955728 NOTICE: special://home/ is mapped to: /storage/emulated/0/Android/data/com.semperpax.spmc/files/.xbmc 19:51:10 T:1780955728 NOTICE: special://temp/ is mapped to: /storage/emulated/0/Android/data/com.semperpax.spmc/files/.xbmc/temp 19:51:10 T:1780955728 NOTICE: The executable running is: 19:51:10 T:1780955728 NOTICE: Local hostname: localhost 19:51:10 T:1780955728 NOTICE: Log File is located: /storage/emulated/0/Android/data/com.semperpax.spmc/files/.xbmc/temp/xbmc.log 19:51:10 T:1780955728 NOTICE: ----------------------------------------------------------------------- 19:51:10 T:1780955728 NOTICE: load settings... 19:51:10 T:1780955728 DEBUG: static int CAndroidFeatures::GetVersion(): android.os.Build.VERSION 19 19:51:10 T:1780955728 NOTICE: aml_present, rtn(0) 19:51:11 T:1780955728 DEBUG: CSettings: loaded settings definition from special://xbmc/system/settings/settings.xml 19:51:11 T:1780955728 DEBUG: CSettings: loaded settings definition from special://xbmc/system/settings/android.xml 19:51:11 T:1780955728 NOTICE: Found 1 Lists of Devices 19:51:11 T:1780955728 NOTICE: Enumerated AUDIOTRACK devices: 19:51:11 T:1780955728 NOTICE: Device 1 19:51:11 T:1780955728 NOTICE: m_deviceName : AudioTrack 19:51:11 T:1780955728 NOTICE: m_displayName : android 19:51:11 T:1780955728 NOTICE: m_displayNameExtra: audiotrack 19:51:11 T:1780955728 NOTICE: m_deviceType : AE_DEVTYPE_HDMI 19:51:11 T:1780955728 NOTICE: m_channels : FL,FR 19:51:11 T:1780955728 NOTICE: m_sampleRates : 48000,48000 19:51:11 T:1780955728 NOTICE: m_dataFormats : AE_FMT_S16LE,AE_FMT_AC3,AE_FMT_DTS 19:51:11 T:1780955728 DEBUG: CSettingsManager: requested setting (has_fakeaudiodevices) was not found. 19:51:11 T:1780955728 NOTICE: No settings file to load (special://xbmc/system/advancedsettings.xml) 19:51:11 T:1780955728 NOTICE: No settings file to load (special://masterprofile/advancedsettings.xml) 19:51:11 T:1780955728 NOTICE: Default DVD Player: dvdplayer 19:51:11 T:1780955728 NOTICE: Default Video Player: dvdplayer 19:51:11 T:1780955728 NOTICE: Default Audio Player: paplayer 19:51:11 T:1780955728 NOTICE: Disabled debug logging due to GUI setting. Level 0. 19:51:11 T:1780955728 NOTICE: Log level changed to 0 19:51:11 T:1780955728 NOTICE: CMediaSourceSettings: loading media sources from special://masterprofile/sources.xml 19:51:11 T:1780955728 NOTICE: Loading player core factory settings from special://xbmc/system/playercorefactory.xml. 19:51:11 T:1780955728 DEBUG: CPlayerCoreConfig::: created player DVDPlayer for core 1 19:51:11 T:1780955728 DEBUG: CPlayerCoreConfig::: created player oldmplayercore for core 1 19:51:11 T:1780955728 DEBUG: CPlayerCoreConfig::: created player PAPlayer for core 3 19:51:11 T:1780955728 DEBUG: CPlayerSelectionRule::Initialize: creating rule: system rules 19:51:11 T:1780955728 DEBUG: CPlayerSelectionRule::Initialize: creating rule: rtv 19:51:11 T:1780955728 DEBUG: CPlayerSelectionRule::Initialize: creating rule: hdhomerun/myth/mms/udp 19:51:11 T:1780955728 DEBUG: CPlayerSelectionRule::Initialize: creating rule: lastfm/shout 19:51:11 T:1780955728 DEBUG: CPlayerSelectionRule::Initialize: creating rule: rtmp 19:51:11 T:1780955728 DEBUG: CPlayerSelectionRule::Initialize: creating rule: rtsp 19:51:11 T:1780955728 DEBUG: CPlayerSelectionRule::Initialize: creating rule: streams 19:51:11 T:1780955728 DEBUG: CPlayerSelectionRule::Initialize: creating rule: aacp/sdp 19:51:11 T:1780955728 DEBUG: CPlayerSelectionRule::Initialize: creating rule: mp2 19:51:11 T:1780955728 DEBUG: CPlayerSelectionRule::Initialize: creating rule: dvd 19:51:11 T:1780955728 DEBUG: CPlayerSelectionRule::Initialize: creating rule: dvdimage 19:51:11 T:1780955728 DEBUG: CPlayerSelectionRule::Initialize: creating rule: sdp/asf 19:51:11 T:1780955728 DEBUG: CPlayerSelectionRule::Initialize: creating rule: nsv 19:51:11 T:1780955728 DEBUG: CPlayerSelectionRule::Initialize: creating rule: radio 19:51:11 T:1780955728 NOTICE: Loaded playercorefactory configuration 19:51:11 T:1780955728 NOTICE: Loading player core factory settings from special://masterprofile/playercorefactory.xml. 19:51:11 T:1780955728 NOTICE: special://masterprofile/playercorefactory.xml does not exist. Skipping. 19:51:11 T:1780955728 INFO: creating subdirectories 19:51:11 T:1780955728 INFO: userdata folder: special://masterprofile/ 19:51:11 T:1780955728 INFO: recording folder: 19:51:11 T:1780955728 INFO: screenshots folder: 19:51:11 T:1780955728 INFO: load language info file: special://xbmc/language/German/langinfo.xml 19:51:11 T:1780955728 DEBUG: trying to set locale to de_DE.UTF-8 19:51:11 T:1780955728 INFO: global locale set to C 19:51:11 T:1780955728 INFO: load German language file, from path: special://xbmc/language/ 19:51:11 T:1780955728 DEBUG: POParser: loaded 3162 strings from file /data/data/com.semperpax.spmc/cache/apk/assets/language/German/strings.po 19:51:11 T:1780955728 DEBUG: POParser: loaded 4 strings from file /data/data/com.semperpax.spmc/cache/apk/assets/language/English/strings.po 19:51:11 T:1802503752 NOTICE: Thread ActiveAE start, auto delete: false 19:51:11 T:1802409440 NOTICE: Thread AESink start, auto delete: false 19:51:11 T:1802409440 INFO: CActiveAESink::OpenSink - initialize sink 19:51:11 T:1802409440 DEBUG: CActiveAESink::OpenSink - trying to open device AUDIOTRACK:AudioTrack 19:51:11 T:1802409440 DEBUG: CActiveAESink::OpenSink - AUDIOTRACK Initialized: 19:51:11 T:1802409440 DEBUG: Output Device : android 19:51:11 T:1802409440 DEBUG: Sample Rate : 44100 19:51:11 T:1802409440 DEBUG: Sample Format : AE_FMTS16NE 19:51:11 T:1802409440 DEBUG: Channel Count : 2 19:51:11 T:1802409440 DEBUG: Channel Layout: FL,FR 19:51:11 T:1802409440 DEBUG: Frames : 1411 19:51:11 T:1802409440 DEBUG: Frame Samples : 2822 19:51:11 T:1802409440 DEBUG: Frame Size : 4 19:51:11 T:1780955728 NOTICE: Running database version Addons16 19:51:11 T:1780955728 DEBUG: SECTION:LoadDLL(libcpluff-arm.so) 19:51:11 T:1780955728 DEBUG: Loading: /data/app-lib/com.semperpax.spmc-1/libcpluff-arm.so 19:51:11 T:1780955728 NOTICE: ADDONS: Using repository repository.xbmc.org 19:51:11 T:1780955728 NOTICE: ADDONS: Using repository repository.pvr-android.xbmc.org 19:51:11 T:1780955728 DEBUG: bool PERIPHERALS::CPeripherals::LoadMappings() - loaded node "Motorola Nyxboard Hybrid" 19:51:11 T:1780955728 DEBUG: bool PERIPHERALS::CPeripherals::LoadMappings() - loaded node "CEC Adapter" 19:51:11 T:1780955728 DEBUG: bool PERIPHERALS::CPeripherals::LoadMappings() - loaded node "Pulse-Eight CEC Adapter" 19:51:11 T:1780955728 DEBUG: bool PERIPHERALS::CPeripherals::LoadMappings() - loaded node "iMON HID device" 19:51:11 T:1780955728 DEBUG: PERIPHERALS::CPeripheralBusUSB::CPeripheralBusUSB(PERIPHERALS::CPeripherals) - using libusb peripheral scanning 19:51:11 T:1780955728 DEBUG: SECTION:LoadDLL(libcec.so) 19:51:11 T:1780955728 DEBUG: Loading: libcec.so 19:51:11 T:1780955728 ERROR: Unable to load libcec.so, reason: (null) 19:51:11 T:1780955728 DEBUG: Dll libcec.so was not found in path 19:51:11 T:1780955728 ERROR: virtual void PERIPHERALS::CPeripherals::Initialise() - failed to initialise bus cec 19:51:11 T:1808296656 NOTICE: Thread PeripBusUSB start, auto delete: false 19:51:11 T:1780955728 NOTICE: virtual bool CWinSystemEGL::InitWindowSystem(): Using EGL Implementation: amlandroid 19:51:11 T:1780955728 NOTICE: Current resolution: 1280x720 @ 60.00 - Full Screen 19:51:11 T:1780955728 NOTICE: aml_get_sysfs_str k=/sys/class/amhdmitx/amhdmitx0/dispcap v=480i 480p 576i 576p 720p 1080i 1080p 720p50hz 1080i50hz 1080p50hz 1080p24hz 19:51:11 T:1780955728 NOTICE: Current resolution: 1280x720 @ 60.00 - Full Screen 19:51:11 T:1780955728 NOTICE: aml_get_sysfs_str k=/sys/class/display/mode v=1080p50hz 19:51:11 T:1780955728 NOTICE: Desktop resolution 1280 x 720 for display 0 with 1920 x 1080 @ 50.000000 Hz 19:51:11 T:1780955728 NOTICE: Found resolution 1280 x 720 for display 0 with 1280 x 720 @ 60.000000 Hz 19:51:11 T:1780955728 NOTICE: Found resolution 1280 x 720 for display 0 with 1920 x 1080i @ 60.000000 Hz 19:51:11 T:1780955728 NOTICE: Found resolution 1280 x 720 for display 0 with 1920 x 1080 @ 60.000000 Hz 19:51:11 T:1780955728 NOTICE: Found resolution 1280 x 720 for display 0 with 1280 x 720 @ 50.000000 Hz 19:51:11 T:1780955728 NOTICE: Found resolution 1280 x 720 for display 0 with 1920 x 1080i @ 50.000000 Hz 19:51:11 T:1780955728 NOTICE: Found resolution 1280 x 720 for display 0 with 1920 x 1080 @ 50.000000 Hz 19:51:11 T:1780955728 NOTICE: Found resolution 1280 x 720 for display 0 with 1920 x 1080 @ 47.900002 Hz 19:51:11 T:1780955728 NOTICE: Found (1280x720@50.000000) at 21, setting to RES_DESKTOP at 16 19:51:11 T:1780955728 NOTICE: Checking resolution 16 19:51:11 T:1780955728 NOTICE: aml_set_sysfs_str k=/sys/class/display/mode v=1080p50hz 19:51:11 T:1780955728 DEBUG: bool CWinSystemEGL::CreateWindow(RESOLUTION_INFO&): Created surface of size 1280x720 19:51:11 T:1780955728 NOTICE: GL_VENDOR = ARM 19:51:11 T:1780955728 NOTICE: GL_RENDERER = Mali-450 MP 19:51:11 T:1780955728 NOTICE: GL_VERSION = OpenGL ES 2.0 19:51:11 T:1780955728 NOTICE: GL_SHADING_LANGUAGE_VERSION = OpenGL ES GLSL ES 1.00 19:51:11 T:1780955728 DEBUG: GLES: Extension Support Test - GL_NVX_gpu_memory_info NO 19:51:11 T:1780955728 NOTICE: GL_EXTENSIONS = GL_EXT_debug_marker GL_OES_texture_npot GL_OES_compressed_ETC1_RGB8_texture GL_OES_standard_derivatives GL_OES_EGL_image GL_OES_depth24 GL_ARM_rgba8 GL_ARM_mali_shader_binary GL_OES_depth_texture GL_OES_packed_depth_stencil GL_EXT_texture_format_BGRA8888 GL_OES_vertex_half_float GL_EXT_blend_minmax GL_OES_EGL_image_external GL_OES_EGL_sync GL_OES_rgb8_rgba8 GL_EXT_multisampled_render_to_texture GL_EXT_discard_framebuffer GL_OES_get_program_binary GL_ARM_mali_program_binary GL_EXT_shader_texture_lod GL_EXT_robustness GL_OES_depth_texture_cube_map GL_KHR_debug 19:51:11 T:1780955728 DEBUG: GLES: Extension Support Test - GL_EXT_texture_format_BGRA8888 YES 19:51:11 T:1780955728 DEBUG: GLES: Extension Support Test - GL_IMG_texture_format_BGRA8888 NO 19:51:11 T:1780955728 DEBUG: GLES: Extension Support Test - GL_APPLE_texture_format_BGRA8888 NO 19:51:11 T:1780955728 DEBUG: GL: Vertex Shader compilation log: 19:51:11 T:1780955728 DEBUG: GL: Vertex Shader compiled successfully 19:51:11 T:1780955728 DEBUG: GL: Pixel Shader compilation log: 19:51:11 T:1780955728 DEBUG: GL: Fragment Shader compiled successfully 19:51:11 T:1780955728 DEBUG: GUI Shader [guishader_frag_default.glsl]- Initialise successful : 0x6bd90d30 19:51:11 T:1780955728 DEBUG: GL: Vertex Shader compilation log: 19:51:11 T:1780955728 DEBUG: GL: Vertex Shader compiled successfully 19:51:11 T:1780955728 DEBUG: GL: Pixel Shader compilation log: 19:51:11 T:1780955728 DEBUG: GL: Fragment Shader compiled successfully 19:51:11 T:1780955728 DEBUG: GUI Shader [guishader_frag_texture.glsl]- Initialise successful : 0x6c1e3780 19:51:11 T:1780955728 DEBUG: GL: Vertex Shader compilation log: 19:51:11 T:1780955728 DEBUG: GL: Vertex Shader compiled successfully 19:51:11 T:1780955728 DEBUG: GL: Pixel Shader compilation log: 19:51:11 T:1780955728 DEBUG: GL: Fragment Shader compiled successfully 19:51:11 T:1780955728 DEBUG: GUI Shader [guishader_frag_multi.glsl]- Initialise successful : 0x6c1e8d20 19:51:11 T:1780955728 DEBUG: GL: Vertex Shader compilation log: 19:51:11 T:1780955728 DEBUG: GL: Vertex Shader compiled successfully 19:51:11 T:1780955728 DEBUG: GL: Pixel Shader compilation log: 19:51:11 T:1780955728 DEBUG: GL: Fragment Shader compiled successfully 19:51:11 T:1780955728 DEBUG: GUI Shader [guishader_frag_fonts.glsl]- Initialise successful : 0x6c1ee3b0 19:51:11 T:1780955728 DEBUG: GL: Vertex Shader compilation log: 19:51:11 T:1780955728 DEBUG: GL: Vertex Shader compiled successfully 19:51:11 T:1780955728 DEBUG: GL: Pixel Shader compilation log: 19:51:11 T:1780955728 DEBUG: GL: Fragment Shader compiled successfully 19:51:11 T:1780955728 DEBUG: GUI Shader [guishader_frag_texture_noblend.glsl]- Initialise successful : 0x6c1f3878 19:51:11 T:1780955728 DEBUG: GL: Vertex Shader compilation log: 19:51:11 T:1780955728 DEBUG: GL: Vertex Shader compiled successfully 19:51:11 T:1780955728 DEBUG: GL: Pixel Shader compilation log: 19:51:11 T:1780955728 DEBUG: GL: Fragment Shader compiled successfully 19:51:11 T:1780955728 DEBUG: GUI Shader [guishader_frag_multi_blendcolor.glsl]- Initialise successful : 0x6c1f8c18 19:51:11 T:1780955728 DEBUG: GL: Vertex Shader compilation log: 19:51:11 T:1780955728 DEBUG: GL: Vertex Shader compiled successfully 19:51:11 T:1780955728 DEBUG: GL: Pixel Shader compilation log: 19:51:11 T:1780955728 DEBUG: GL: Fragment Shader compiled successfully 19:51:11 T:1780955728 DEBUG: GUI Shader [guishader_frag_rgba.glsl]- Initialise successful : 0x6c1fe4c8 19:51:11 T:1780955728 DEBUG: GLES: Extension Support Test - GL_OES_EGL_image_external YES 19:51:11 T:1780955728 DEBUG: GL: Vertex Shader compilation log: 19:51:11 T:1780955728 DEBUG: GL: Vertex Shader compiled successfully 19:51:11 T:1780955728 DEBUG: GL: Pixel Shader compilation log: 19:51:11 T:1780955728 DEBUG: GL: Fragment Shader compiled successfully 19:51:11 T:1780955728 DEBUG: GUI Shader [guishader_frag_rgba_oes.glsl]- Initialise successful : 0x6c203910 19:51:11 T:1780955728 DEBUG: GL: Vertex Shader compilation log: 19:51:11 T:1780955728 DEBUG: GL: Vertex Shader compiled successfully 19:51:11 T:1780955728 DEBUG: GL: Pixel Shader compilation log: 19:51:11 T:1780955728 DEBUG: GL: Fragment Shader compiled successfully 19:51:11 T:1780955728 DEBUG: GUI Shader [guishader_frag_rgba_blendcolor.glsl]- Initialise successful : 0x6c209098 19:51:11 T:1780955728 NOTICE: Current resolution: 1280x720 @ 60.00 - Full Screen 19:51:11 T:1780955728 NOTICE: aml_get_sysfs_str k=/sys/class/display/mode v=1080p50hz 19:51:11 T:1780955728 DEBUG: CWinSystemEGL::CreateNewWindow: No need to create a new window 19:51:11 T:1780955728 INFO: GLES: Maximum texture width: 4096 19:51:11 T:1780955728 DEBUG: CRenderManager::UpdateDisplayLatency - Latency set to 0 msec 19:51:11 T:1780955728 INFO: load default splash image: /data/data/com.semperpax.spmc/cache/apk/assets/media/Splash.png 19:51:11 T:1780955728 DEBUG: SECTION:LoadDLL(libImageLib-arm.so) 19:51:11 T:1780955728 DEBUG: Loading: /data/app-lib/com.semperpax.spmc-1/libImageLib-arm.so 19:51:11 T:1780955728 INFO: load keymapping 19:51:11 T:1780955728 INFO: Loading special://xbmc/system/keymaps/appcommand.xml 19:51:11 T:1780955728 INFO: Loading special://xbmc/system/keymaps/gamepad.xml 19:51:11 T:1780955728 INFO: Loading special://xbmc/system/keymaps/joystick.xml 19:51:11 T:1780955728 NOTICE: No Joystick name specified, loading default map 19:51:11 T:1780955728 NOTICE: Previous line repeats 35 times. 19:51:11 T:1780955728 INFO: Loading special://xbmc/system/keymaps/keyboard.xml 19:51:11 T:1780955728 INFO: Loading special://xbmc/system/keymaps/mouse.xml 19:51:11 T:1780955728 INFO: Loading special://xbmc/system/keymaps/remote.xml 19:51:11 T:1780955728 INFO: Loading special://xbmc/system/keymaps/touchscreen.xml 19:51:11 T:1780955728 INFO: GUI format 1280x720, Display 1920x1080 @ 50.00 - Full Screen 19:51:11 T:1780955728 DEBUG: guilib: Fill viewport on change for solving rendering passes 19:51:11 T:1780955728 DEBUG: SECTION:LoadDLL(libxbcurl.so) 19:51:11 T:1780955728 DEBUG: Loading: /data/app-lib/com.semperpax.spmc-1/libxbcurl.so 19:51:11 T:1780955728 NOTICE: Running database version Addons16 19:51:11 T:1780955728 DEBUG: void CDatabaseManager::Initialize(bool), updating databases... 19:51:11 T:1780955728 NOTICE: Running database version ViewModes6 19:51:11 T:1780955728 NOTICE: Running database version Textures13 19:51:11 T:1780955728 NOTICE: Running database version MyMusic46 19:51:11 T:1780955728 NOTICE: Running database version MyVideos78 19:51:11 T:1780955728 NOTICE: Running database version TV22 19:51:11 T:1780955728 NOTICE: Running database version Epg7 19:51:11 T:1780955728 DEBUG: void CDatabaseManager::Initialize(bool), updating databases... DONE 19:51:11 T:1780955728 INFO: DPMS: not supported on this platform 19:51:11 T:1780955728 DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc 19:51:11 T:1780955728 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnClear 19:51:11 T:1780955728 INFO: Unloading old skin ... 19:51:11 T:1780955728 INFO: load skin from: /data/data/com.semperpax.spmc/cache/apk/assets/addons/skin.confluence (version: 2.2.20) 19:51:11 T:1780955728 INFO: load fonts for skin... 19:51:11 T:1780955728 INFO: Loading fonts from /data/data/com.semperpax.spmc/cache/apk/assets/addons/skin.confluence/720p/Font.xml 19:51:11 T:1780955728 DEBUG: POParser: loaded 148 strings from file /data/data/com.semperpax.spmc/cache/apk/assets/addons/skin.confluence/language/German/strings.po 19:51:11 T:1780955728 DEBUG: POParser: loaded 0 strings from file /data/data/com.semperpax.spmc/cache/apk/assets/addons/skin.confluence/language/English/strings.po 19:51:11 T:1780955728 INFO: Loading skin includes from /data/data/com.semperpax.spmc/cache/apk/assets/addons/skin.confluence/720p/includes.xml 19:51:12 T:1780955728 INFO: load new skin... 19:51:12 T:1780955728 INFO: Loading user windows, path /data/data/com.semperpax.spmc/cache/apk/assets/addons/skin.confluence/720p 19:51:12 T:1780955728 DEBUG: Load Skin XML: 46.31ms 19:51:12 T:1780955728 INFO: initialize new skin... 19:51:12 T:1780955728 DEBUG: guilib: Fill viewport on change for solving rendering passes 19:51:12 T:1780955728 INFO: Loading skin file: Pointer.xml, load type: LOAD_ON_GUI_INIT 19:51:12 T:1780955728 DEBUG: Load Pointer.xml: 2.05ms 19:51:12 T:1780955728 DEBUG: bool CTextureBundleXBT::OpenBundle() - Opened bundle /data/data/com.semperpax.spmc/cache/apk/assets/addons/skin.confluence/media/Textures.xbt 19:51:12 T:1780955728 DEBUG: Alloc resources: 7.49ms (2.29 ms skin load) 19:51:12 T:1780955728 INFO: Loading skin file: DialogVolumeBar.xml, load type: LOAD_ON_GUI_INIT 19:51:12 T:1780955728 DEBUG: Load DialogVolumeBar.xml: 3.65ms 19:51:12 T:1780955728 DEBUG: Alloc resources: 4.18ms (3.97 ms skin load) 19:51:12 T:1780955728 INFO: Loading skin file: DialogKaiToast.xml, load type: LOAD_ON_GUI_INIT 19:51:12 T:1780955728 DEBUG: Load DialogKaiToast.xml: 4.49ms 19:51:12 T:1780955728 DEBUG: Alloc resources: 4.84ms (4.83 ms skin load) 19:51:12 T:1780955728 INFO: Loading skin file: DialogMuteBug.xml, load type: LOAD_ON_GUI_INIT 19:51:12 T:1780955728 DEBUG: Load DialogMuteBug.xml: 1.14ms 19:51:12 T:1780955728 DEBUG: Alloc resources: 1.36ms (1.36 ms skin load) 19:51:12 T:1780955728 INFO: Loading skin file: DialogSeekBar.xml, load type: LOAD_ON_GUI_INIT 19:51:12 T:1780955728 DEBUG: Load DialogSeekBar.xml: 15.97ms 19:51:12 T:1780955728 DEBUG: Alloc resources: 16.86ms (16.26 ms skin load) 19:51:12 T:1780955728 INFO: Loading skin file: DialogBusy.xml, load type: LOAD_ON_GUI_INIT 19:51:12 T:1780955728 DEBUG: Load DialogBusy.xml: 2.64ms 19:51:12 T:1780955728 DEBUG: Alloc resources: 2.93ms (2.90 ms skin load) 19:51:12 T:1780955728 INFO: Loading skin file: DialogExtendedProgressBar.xml, load type: LOAD_ON_GUI_INIT 19:51:12 T:1780955728 DEBUG: Load DialogExtendedProgressBar.xml: 2.88ms 19:51:12 T:1780955728 DEBUG: Alloc resources: 3.25ms (3.22 ms skin load) 19:51:12 T:1780955728 INFO: Loading /data/data/com.semperpax.spmc/cache/apk/assets/addons/skin.confluence/sounds/sounds.xml 19:51:12 T:1780955728 INFO: skin loaded... 19:51:12 T:1780955728 DEBUG: JSONRPC: JSON schema type stereoscopicmode references an unknown type GUI.Stereoscopy.Mode 19:51:12 T:1780955728 WARNING: JSONRPC: Could not parse type "GUI.Property.Value" 19:51:12 T:1780955728 INFO: JSONRPC: Adding type "GUI.Property.Value" to list of incomplete definitions (waiting for "GUI.Stereoscopy.Mode") 19:51:12 T:1780955728 INFO: JSONRPC: Resolving incomplete types/methods referencing GUI.Stereoscopy.Mode 19:51:12 T:1780955728 DEBUG: JSONRPC: JSON schema type definition references an unknown type Setting.Details.Setting 19:51:12 T:1780955728 WARNING: JSONRPC: Could not parse type "Setting.Details.SettingList" 19:51:12 T:1780955728 INFO: JSONRPC: Adding type "Setting.Details.SettingList" to list of incomplete definitions (waiting for "Setting.Details.Setting") 19:51:12 T:1780955728 INFO: JSONRPC: Resolving incomplete types/methods referencing Setting.Details.Setting 19:51:12 T:1780955728 INFO: JSONRPC v6.14.3: Successfully initialized 19:51:12 T:1780955728 DEBUG: ADDON: Starting service addons. 19:51:12 T:1780955728 DEBUG: Activating window ID: 12999 19:51:12 T:1780955728 DEBUG: ------ Window Init (Startup.xml) ------ 19:51:12 T:1780955728 INFO: Loading skin file: Startup.xml, load type: LOAD_EVERY_TIME 19:51:12 T:1780955728 DEBUG: Load Startup.xml: 5.44ms 19:51:12 T:1831405352 NOTICE: Thread JobWorker start, auto delete: true 19:51:12 T:1780955728 DEBUG: Alloc resources: 5.85ms (5.84 ms skin load) 19:51:12 T:1780955728 INFO: removing tempfiles 19:51:12 T:1831405352 NOTICE: PVRManager - starting up 19:51:12 T:1831417144 NOTICE: Thread PVRManager start, auto delete: false 19:51:12 T:1780955728 DEBUG: ADDON: Starting service addons. 19:51:12 T:1780955728 NOTICE: initialize done 19:51:12 T:1780955728 NOTICE: Running the application... 19:51:12 T:1780955728 DEBUG: Activating window ID: 10000 19:51:12 T:1832613912 NOTICE: Thread PVRClient start, auto delete: false 19:51:12 T:1832613912 DEBUG: int PVR::CPVRClients::RegisterClient(ADDON::AddonPtr) - registering add-on 'Tvheadend HTSP Client' 19:51:12 T:1832613912 DEBUG: PVR - ADDON_STATUS PVR::CPVRClient::Create(int) - creating PVR add-on instance 'Tvheadend HTSP Client' 19:51:12 T:1832613912 DEBUG: ADDON: Dll Initializing - Tvheadend HTSP Client 19:51:12 T:1832613912 DEBUG: SECTION:LoadDLL(/data/app-lib/com.semperpax.spmc-1/libXBMC_Tvheadend.so) 19:51:12 T:1832613912 DEBUG: Loading: /data/app-lib/com.semperpax.spmc-1/libXBMC_Tvheadend.so 19:51:12 T:1832613912 DEBUG: AddOnLog: Tvheadend HTSP Client: ADDONCreate - Creating Tvheadend PVR-Client 19:51:12 T:1832613912 DEBUG: CAddonCallbacksAddon - static bool ADDON::CAddonCallbacksAddon::GetAddonSetting(void, const char, void) - add-on 'Tvheadend HTSP Client' requests setting 'host' 19:51:12 T:1832613912 DEBUG: CAddonCallbacksAddon - static bool ADDON::CAddonCallbacksAddon::GetAddonSetting(void, const char, void) - add-on 'Tvheadend HTSP Client' requests setting 'user' 19:51:12 T:1832613912 DEBUG: CAddonCallbacksAddon - static bool ADDON::CAddonCallbacksAddon::GetAddonSetting(void, const char, void) - add-on 'Tvheadend HTSP Client' requests setting 'pass' 19:51:12 T:1832613912 DEBUG: CAddonCallbacksAddon - static bool ADDON::CAddonCallbacksAddon::GetAddonSetting(void, const char, void_) - add-on 'Tvheadend HTSP Client' requests setting 'htspport' 19:51:12 T:1832613912 DEBUG: CAddonCallbacksAddon - static bool ADDON::CAddonCallbacksAddon::GetAddonSetting(void, const char, void) - add-on 'Tvheadend HTSP Client' requests setting 'httpport' 19:51:12 T:1832613912 DEBUG: CAddonCallbacksAddon - static bool ADDON::CAddonCallbacksAddon::GetAddonSetting(void, const char, void) - add-on 'Tvheadend HTSP Client' requests setting 'connecttimeout' 19:51:12 T:1832613912 DEBUG: CAddonCallbacksAddon - static bool ADDON::CAddonCallbacksAddon::GetAddonSetting(void, const char, void) - add-on 'Tvheadend HTSP Client' requests setting 'responsetimeout' 19:51:12 T:1832613912 DEBUG: CAddonCallbacksAddon - static bool ADDON::CAddonCallbacksAddon::GetAddonSetting(void, const char, void) - add-on 'Tvheadend HTSP Client' requests setting 'transcode' 19:51:12 T:1832613912 DEBUG: CAddonCallbacksAddon - static bool ADDON::CAddonCallbacksAddon::GetAddonSetting(void, const char, void_) - add-on 'Tvheadend HTSP Client' requests setting 'audio_codecname' 19:51:12 T:1832613912 DEBUG: CAddonCallbacksAddon - static bool ADDON::CAddonCallbacksAddon::GetAddonSetting(void, const char, void) - add-on 'Tvheadend HTSP Client' requests setting 'video_codecname' 19:51:12 T:1832613912 DEBUG: CAddonCallbacksAddon - static bool ADDON::CAddonCallbacksAddon::GetAddonSetting(void, const char, void) - add-on 'Tvheadend HTSP Client' requests setting 'resolution' 19:51:12 T:1832613912 DEBUG: AddOnLog: Tvheadend HTSP Client: OpenSocket - connecting to '192.168.1.34', port '9982' 19:51:12 T:1832613912 DEBUG: AddOnLog: Tvheadend HTSP Client: OpenSocket - connected to '192.168.1.34', port '9982' 19:51:12 T:1832613912 NOTICE: AddOnLog: Tvheadend HTSP Client: CHTSPConnection - SendGreeting - connection opened to 'HTS Tvheadend 3.2.18~g40a8920', protocol v6 19:51:12 T:1832613912 DEBUG: AddOnLog: Tvheadend HTSP Client: CHTSPConnection - Auth - no username set. not authenticating 19:51:12 T:1780955728 INFO: GLES: Enabling VSYNC 19:51:12 T:1780955728 INFO: GLES: Selected vsync mode 10 19:51:12 T:1831417144 DEBUG: PVRManager - bool PVR::CPVRManager::Load() - active clients found. continue to start 19:51:12 T:1780955728 DEBUG: ------ Window Deinit (Startup.xml) ------ 19:51:12 T:1780955728 DEBUG: ------ Window Init (Home.xml) ------ 19:51:12 T:1780955728 INFO: Loading skin file: Home.xml, load type: KEEP_IN_MEMORY 19:51:12 T:1780955728 DEBUG: Load Home.xml: 220.20ms 19:51:12 T:1780955728 DEBUG: Alloc resources: 225.52ms (220.54 ms skin load) 19:51:12 T:1831405352 DEBUG: CRecentlyAddedJob::UpdateMusic() - Running RecentlyAdded home screen update 19:51:12 T:1780955728 DEBUG: no profile autoexec.py (/storage/emulated/0/Android/data/com.semperpax.spmc/files/.xbmc/userdata/autoexec.py) found, skipping 19:51:12 T:1780955728 DEBUG: void CNetwork::NetworkMessage(CNetwork::EMESSAGE, int) - Starting network services 19:51:12 T:1780955728 NOTICE: starting zeroconf publishing 19:51:12 T:1780955728 NOTICE: Webserver: Starting... 19:51:12 T:1780955728 NOTICE: WebServer: Started the webserver 19:51:12 T:1780955728 NOTICE: ES: Starting event server 19:51:12 T:1780955728 INFO: JSONRPC Server: Successfully initialized 19:51:12 T:1780955728 NOTICE: Current resolution: 1280x720 @ 60.00 - Full Screen 19:51:12 T:1780955728 NOTICE: aml_get_sysfs_str k=/sys/class/display/mode v=1080p50hz 19:51:12 T:1780955728 DEBUG: CWinSystemEGL::CreateNewWindow: No need to create a new window 19:51:12 T:1780955728 NOTICE: GL_VENDOR = ARM 19:51:12 T:1780955728 NOTICE: GL_RENDERER = Mali-450 MP 19:51:12 T:1780955728 NOTICE: GL_VERSION = OpenGL ES 2.0 19:51:12 T:1780955728 NOTICE: GL_SHADING_LANGUAGE_VERSION = OpenGL ES GLSL ES 1.00 19:51:12 T:1780955728 DEBUG: GLES: Extension Support Test - GL_NVX_gpu_memory_info NO 19:51:12 T:1780955728 NOTICE: GL_EXTENSIONS = GL_EXT_debug_marker GL_OES_texture_npot GL_OES_compressed_ETC1_RGB8_texture GL_OES_standard_derivatives GL_OES_EGL_image GL_OES_depth24 GL_ARM_rgba8 GL_ARM_mali_shader_binary GL_OES_depth_texture GL_OES_packed_depth_stencil GL_EXT_texture_format_BGRA8888 GL_OES_vertex_half_float GL_EXT_blend_minmax GL_OES_EGL_image_external GL_OES_EGL_sync GL_OES_rgb8_rgba8 GL_EXT_multisampled_render_to_texture GL_EXT_discard_framebuffer GL_OES_get_program_binary GL_ARM_mali_program_binary GL_EXT_shader_texture_lod GL_EXT_robustness GL_OES_depth_texture_cube_map GL_KHR_debug 19:51:12 T:1836276584 NOTICE: Thread ZerocconfEmbedded start, auto delete: false 19:51:12 T:1836276584 DEBUG: ZeroconfEmbedded - processing... 19:51:12 T:1835923920 NOTICE: Thread EventServer start, auto delete: false 19:51:12 T:1835923920 NOTICE: ES: Starting UDP Event server on 0.0.0.0:9777 19:51:12 T:1835923920 NOTICE: UDP: Listening on port 9777 19:51:12 T:1780955728 DEBUG: GLES: Extension Support Test - GL_EXT_texture_format_BGRA8888 YES 19:51:12 T:1780955728 DEBUG: GLES: Extension Support Test - GL_IMG_texture_format_BGRA8888 NO 19:51:12 T:1780955728 DEBUG: GLES: Extension Support Test - GL_APPLE_texture_format_BGRA8888 NO 19:51:12 T:1780955728 DEBUG: GUI Shader - Tried to Initialise again. Was this intentional? 19:51:12 T:1844743200 NOTICE: Thread JobWorker start, auto delete: true 19:51:12 T:1835924504 NOTICE: Thread TCPServer start, auto delete: false 19:51:12 T:1844743200 DEBUG: ZeroconfMDNS: identifier: servers.webserver type: _http._tcp name:XBMC (localhost) port:8080 19:51:12 T:1844743200 DEBUG: ZeroconfMDNS: identifier: servers.jsonrpc-http type: _xbmc-jsonrpc-h._tcp name:XBMC (localhost) port:8080 19:51:12 T:1844743200 DEBUG: ZeroconfMDNS: identifier: servers.jsonrpc-tpc type: _xbmc-jsonrpc._tcp name:XBMC (localhost) port:9090 19:51:12 T:1844743200 DEBUG: ZeroconfMDNS: identifier: servers.eventserver type: _xbmc-events._udp name:XBMC (localhost) port:9777 19:51:12 T:1780955728 DEBUG: ------ Window Init (DialogExtendedProgressBar.xml) ------ 19:51:12 T:1780955728 DEBUG: Window DialogExtendedProgressBar.xml was already loaded 19:51:12 T:1780955728 DEBUG: Alloc resources: 0.01m 19:51:12 T:1831417144 DEBUG: PVR - bool PVR::CPVRChannelGroups::Load() - loading all radio channel groups 19:51:12 T:1831417144 INFO: PVRChannelGroupInternal - virtual int PVR::CPVRChannelGroupInternal::LoadFromDb(bool) - no channels in the database 19:51:12 T:1831417144 DEBUG: PVRChannelGroup - virtual bool PVR::CPVRChannelGroup::Load() - 0 channels loaded from the database for group 'Alle Radio-Kanäle' 19:51:12 T:1831417144 DEBUG: PVR - bool PVR::CPVRChannelGroups::LoadUserDefinedChannelGroups() - 0 user defined radio channel groups fetched from the database 19:51:12 T:1831417144 DEBUG: PVR - bool PVR::CPVRChannelGroups::LoadUserDefinedChannelGroups() - 0 new user defined radio channel groups fetched from clients 19:51:12 T:1831417144 DEBUG: PVR - bool PVR::CPVRChannelGroups::PersistAll() - persisting all changes in channel groups 19:51:12 T:1831417144 DEBUG: PVR - bool PVR::CPVRChannelGroups::Load() - 1 radio channel groups loaded 19:51:12 T:1831417144 DEBUG: PVR - bool PVR::CPVRChannelGroups::Load() - loading all TV channel groups 19:51:12 T:1836124312 NOTICE: Thread RSSReader start, auto delete: false 19:51:12 T:1836124312 DEBUG: CurlFile::Open(0x6f1b5c80) http://feeds.xbmc.org/xbmc 19:51:12 T:1836124312 INFO: void XCURL::DllLibCurlGlobal::easyaquire(const char, const char_, XCURL::CURLHANDLE, XCURL::CURLM) - Created session to http://feeds.xbmc.org 19:51:12 T:1831405352 DEBUG: GetRecentlyAddedAlbumSongs() query: SELECT songview. FROM (SELECT idAlbum FROM albumview ORDER BY idAlbum DESC LIMIT 10) AS recentalbums JOIN songview ON songview.idAlbum=recentalbums.idAlbum 19:51:12 T:1831405352 DEBUG: bool CMusicDatabase::GetRecentlyAddedAlbums(VECALBUMS&, unsigned int) query: select * from albumview where strAlbum != '' order by idAlbum desc limit 10 19:51:12 T:1831405352 DEBUG: CRecentlyAddedJob::UpdateVideos() - Running RecentlyAdded home screen update 19:51:12 T:1780955728 INFO: GLES: Enabling VSYNC 19:51:12 T:1780955728 INFO: GLES: Selected vsync mode 10 19:51:12 T:1831417144 DEBUG: PVRChannelGroup - virtual bool PVR::CPVRChannelGroup::Load() - 50 channels loaded from the database for group 'Alle TV-Kanäle' 19:51:12 T:1831417144 DEBUG: PVR - bool PVR::CPVRDatabase::Get(PVR::CPVRChannelGroups&) - group 'Alle TV-Kanäle' loaded from the database 19:51:12 T:1831417144 DEBUG: PVR - bool PVR::CPVRChannelGroups::LoadUserDefinedChannelGroups() - 0 user defined TV channel groups fetched from the database 19:51:12 T:1831417144 DEBUG: PVR - bool PVR::CPVRChannelGroups::LoadUserDefinedChannelGroups() - 0 new user defined TV channel groups fetched from clients 19:51:12 T:1831417144 DEBUG: PVR - bool PVR::CPVRChannelGroups::PersistAll() - persisting all changes in channel groups 19:51:12 T:1831417144 DEBUG: PVR - bool PVR::CPVRChannelGroups::Load() - 1 TV channel groups loaded 19:51:12 T:1831417144 DEBUG: CPVRTimers - bool PVR::CPVRTimers::Update() - updating timers 19:51:12 T:1831417144 DEBUG: PVRTimers - bool PVR::CPVRTimers::UpdateEntries(const PVR::CPVRTimers&) - added timer 761 on client 1 19:51:12 T:1831417144 DEBUG: PVRTimers - bool PVR::CPVRTimers::UpdateEntries(const PVR::CPVRTimers&) - added timer 762 on client 1 19:51:12 T:1831417144 DEBUG: PVRTimers - bool PVR::CPVRTimers::UpdateEntries(const PVR::CPVRTimers&) - added timer 763 on client 1 19:51:12 T:1831417144 DEBUG: PVRTimers - bool PVR::CPVRTimers::UpdateEntries(const PVR::CPVRTimers&) - added timer 764 on client 1 19:51:12 T:1831417144 DEBUG: CPVRRecordings - void PVR::CPVRRecordings::Update() - updating recordings 19:51:13 T:1831405352 DEBUG: int CVideoDatabase::RunQuery(const CStdString&) took 7 ms for 0 items query: select * from movieview ORDER BY dateAdded desc, idMovie desc LIMIT 10 19:51:13 T:1842226056 NOTICE: Thread PVRGUIInfo start, auto delete: false 19:51:13 T:1831417144 DEBUG: PVRManager - virtual void PVR::CPVRManager::Process() - entering main loop 19:51:13 T:1780955728 DEBUG: ------ Window Init (DialogExtendedProgressBar.xml) ------ 19:51:13 T:1831405352 DEBUG: int CVideoDatabase::RunQuery(const CStdString&) took 14 ms for 0 items query: select * from episodeview ORDER BY dateAdded desc, idEpisode desc LIMIT 10 19:51:13 T:1780955728 DEBUG: Window DialogExtendedProgressBar.xml was already loaded 19:51:13 T:1780955728 DEBUG: Alloc resources: 8.83m 19:51:13 T:1831405352 DEBUG: int CVideoDatabase::RunQuery(const CStdString&) took 11 ms for 0 items query: select * from musicvideoview ORDER BY dateAdded desc, idMVideo desc LIMIT 10 19:51:13 T:1836124312 DEBUG: Got rss feed: http://feeds.xbmc.org/xbmc 19:51:13 T:1836124312 DEBUG: RSS feed encoding: UTF-8 19:51:13 T:1831405352 DEBUG: CRecentlyAddedJob::UpdateTotal() - Running RecentlyAdded home screen update 19:51:13 T:1836124312 DEBUG: Parsed rss feed: http://feeds.xbmc.org/xbmc 19:51:13 T:1836124312 DEBUG: CurlFile::Open(0x6f1b5c80) http://feeds.xbmc.org/latest_xbmc_addons 19:51:13 T:1836124312 DEBUG: Got rss feed: http://feeds.xbmc.org/latest_xbmc_addons 19:51:13 T:1836124312 DEBUG: RSS feed encoding: UTF-8 19:51:13 T:1836124312 DEBUG: Parsed rss feed: http://feeds.xbmc.org/latest_xbmc_addons 19:51:13 T:1836124312 DEBUG: CurlFile::Open(0x6f1b5c80) http://feeds.xbmc.org/updated_xbmc_addons 19:51:13 T:1836124312 DEBUG: Got rss feed: http://feeds.xbmc.org/updated_xbmc_addons 19:51:13 T:1836124312 DEBUG: RSS feed encoding: UTF-8 19:51:13 T:1836124312 DEBUG: Parsed rss feed: http://feeds.xbmc.org/updated_xbmc_addons 19:51:13 T:1836124312 DEBUG: Thread RSSReader 1836124312 terminating 19:51:13 T:1836276584 DEBUG: ZeroconfMDNS: XBMC (localhost)._http._tcp.local. registration removed 19:51:13 T:1836276584 DEBUG: ZeroconfMDNS: XBMC (localhost)._xbmc-jsonrpc-h._tcp.local. registration removed 19:51:13 T:1836276584 DEBUG: ZeroconfMDNS: XBMC (localhost)._xbmc-jsonrpc._tcp.local. registration removed 19:51:13 T:1836276584 DEBUG: ZeroconfMDNS: XBMC (localhost)._xbmc-events._udp.local. registration removed 19:51:16 T:1831417144 DEBUG: EPG - bool EPG::CEpg::Load() - no database entries found for table 'CCTV4'. 19:51:16 T:1831417144 DEBUG: EPG - bool EPG::CEpg::Load() - no database entries found for table 'MAC TV'. 19:51:16 T:1831417144 DEBUG: EPG - bool EPG::CEpg::Load() - no database entries found for table 'CCTV News'. 19:51:16 T:1831417144 DEBUG: EPG - bool EPG::CEpg::Load() - no database entries found for table 'Arirang World'. 19:51:16 T:1831417144 DEBUG: EPG - bool EPG::CEpg::Load() - no database entries found for table 'CCTV 9'. 19:51:17 T:1831417144 DEBUG: EPG - bool EPG::CEpg::Load() - no database entries found for table 'Einsfestival HD'. 19:51:19 T:1780955728 DEBUG: Keyboard: scancode: 0x16, sym: 0x0113, unicode: 0x0000, modifier: 0x0 19:51:19 T:1780955728 DEBUG: bool CApplication::OnKey(const CKey&): right (0xf083) pressed, action is Right 19:51:20 T:1880169240 NOTICE: Thread EPGUpdater start, auto delete: false 19:51:20 T:1831417144 NOTICE: virtual void EPG::CEpgContainer::Start() - EPG thread started 19:51:20 T:1780955728 DEBUG: ------ Window Init (DialogExtendedProgressBar.xml) ------ 19:51:20 T:1780955728 DEBUG: Window DialogExtendedProgressBar.xml was already loaded 19:51:20 T:1780955728 DEBUG: Alloc resources: 0.02m 19:51:20 T:1780955728 DEBUG: Keyboard: scancode: 0x16, sym: 0x0113, unicode: 0x0000, modifier: 0x0 19:51:20 T:1780955728 DEBUG: bool CApplication::OnKey(const CKey&): right (0xf083) pressed, action is Right 19:51:20 T:1880169240 DEBUG: EPG - bool EPG::CEpg::UpdateFromScraper(time_t, time_t) - updating EPG for channel 'CCTV4' from client '1' 19:51:20 T:1880169240 DEBUG: EPG - bool EPG::CEpg::UpdateFromScraper(time_t, time_t) - updating EPG for channel 'MAC TV' from client '1' 19:51:20 T:1880169240 DEBUG: EPG - bool EPG::CEpg::UpdateFromScraper(time_t, time_t) - updating EPG for channel 'CCTV News' from client '1' 19:51:20 T:1880169240 DEBUG: EPG - bool EPG::CEpg::UpdateFromScraper(time_t, time_t) - updating EPG for channel 'Arirang World' from client '1' 19:51:20 T:1880169240 DEBUG: EPG - bool EPG::CEpg::UpdateFromScraper(time_t, time_t) - updating EPG for channel 'CCTV 9' from client '1' 19:51:20 T:1880169240 DEBUG: EPG - bool EPG::CEpg::UpdateFromScraper(time_t, time_t) - updating EPG for channel 'Einsfestival HD' from client '1' 19:51:20 T:1780955728 DEBUG: Keyboard: scancode: 0x16, sym: 0x0113, unicode: 0x0000, modifier: 0x0 19:51:20 T:1780955728 DEBUG: bool CApplication::OnKey(const CKey&): right (0xf083) pressed, action is Right 19:51:20 T:1831417144 DEBUG: CPVRTimers - bool PVR::CPVRTimers::Update() - updating timers 19:51:20 T:1831417144 DEBUG: PVRTimers - bool PVR::CPVRTimers::UpdateEntries(const PVR::CPVRTimers&) - updated timer 761 on client 1 19:51:20 T:1831417144 DEBUG: PVRTimers - bool PVR::CPVRTimers::UpdateEntries(const PVR::CPVRTimers&) - updated timer 762 on client 1 19:51:20 T:1831417144 DEBUG: PVRTimers - bool PVR::CPVRTimers::UpdateEntries(const PVR::CPVRTimers&) - updated timer 763 on client 1 19:51:20 T:1831417144 DEBUG: PVRTimers - bool PVR::CPVRTimers::UpdateEntries(const PVR::CPVRTimers&) - updated timer 764 on client 1 19:51:21 T:1780955728 DEBUG: ------ Window Deinit (DialogExtendedProgressBar.xml) ------ 19:51:22 T:1780955728 DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0 19:51:22 T:1780955728 DEBUG: bool CApplication::OnKey(const CKey&): down (0xf081) pressed, action is Down 19:51:22 T:1780955728 DEBUG: Keyboard: scancode: 0x42, sym: 0x000d, unicode: 0x000a, modifier: 0x0 19:51:22 T:1780955728 DEBUG: bool CApplication::OnKey(const CKey&): return (0xf00d) pressed, action is Select 19:51:22 T:1780955728 DEBUG: Activating window ID: 10004 19:51:23 T:1780955728 DEBUG: ------ Window Deinit (Home.xml) ------ 19:51:23 T:1780955728 DEBUG: ------ Window Init (Settings.xml) ------ 19:51:23 T:1780955728 INFO: Loading skin file: Settings.xml, load type: KEEP_IN_MEMORY 19:51:23 T:1780955728 DEBUG: Load Settings.xml: 38.58ms 19:51:23 T:1780955728 DEBUG: Alloc resources: 39.80ms (39.00 ms skin load) 19:51:26 T:1780955728 DEBUG: Keyboard: scancode: 0x13, sym: 0x0111, unicode: 0x0000, modifier: 0x0 19:51:26 T:1780955728 DEBUG: bool CApplication::OnKey(const CKey&): up (0xf080) pressed, action is Up 19:51:27 T:1780955728 DEBUG: Keyboard: scancode: 0x42, sym: 0x000d, unicode: 0x000a, modifier: 0x0 19:51:27 T:1780955728 DEBUG: bool CApplication::OnKey(const CKey&): return (0xf00d) pressed, action is Select 19:51:27 T:1780955728 DEBUG: Activating window ID: 10016 19:51:27 T:1780955728 DEBUG: ------ Window Deinit (Settings.xml) ------ 19:51:27 T:1780955728 DEBUG: ------ Window Init (SettingsCategory.xml) ------ 19:51:27 T:1780955728 INFO: Loading skin file: SettingsCategory.xml, load type: KEEP_IN_MEMORY 19:51:27 T:1780955728 DEBUG: Load SettingsCategory.xml: 31.77ms 19:51:27 T:1780955728 DEBUG: Alloc resources: 92.43ms (32.11 ms skin load) 19:51:29 T:1780955728 DEBUG: Keyboard: scancode: 0x13, sym: 0x0111, unicode: 0x0000, modifier: 0x0 19:51:29 T:1780955728 DEBUG: bool CApplication::OnKey(const CKey&): up (0xf080) pressed, action is Up 19:51:29 T:1780955728 DEBUG: Keyboard: scancode: 0x13, sym: 0x0111, unicode: 0x0000, modifier: 0x0 19:51:29 T:1780955728 DEBUG: bool CApplication::OnKey(const CKey&): up (0xf080) pressed, action is Up 19:51:31 T:1780955728 DEBUG: Keyboard: scancode: 0x16, sym: 0x0113, unicode: 0x0000, modifier: 0x0 19:51:31 T:1780955728 DEBUG: bool CApplication::OnKey(const CKey&): right (0xf083) pressed, action is Right 19:51:32 T:1780955728 DEBUG: Keyboard: scancode: 0x42, sym: 0x000d, unicode: 0x000a, modifier: 0x0 19:51:32 T:1780955728 DEBUG: bool CApplication::OnKey(const CKey&): return (0xf00d) pressed, action is Select 19:51:32 T:1780955728 NOTICE: Log level changed to 2 19:51:32 T:1780955728 NOTICE: Enabled debug logging due to GUI setting. Level 2. 19:51:32 T:1780955728 DEBUG: ------ Window Init () ------ 19:51:32 T:1780955728 DEBUG: Alloc resources: 0.01ms (0.01 ms skin load) 19:51:34 T:1780955728 DEBUG: Keyboard: scancode: 0x04, sym: 0x0008, unicode: 0x0000, modifier: 0x0 19:51:34 T:1780955728 DEBUG: bool CApplication::OnKey(const CKey&): backspace (0xf008) pressed, action is Back 19:51:34 T:1780955728 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 19:51:34 T:1780955728 DEBUG: ------ Window Deinit (SettingsCategory.xml) ------ 19:51:34 T:1780955728 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 19:51:34 T:1780955728 DEBUG: ------ Window Init (Settings.xml) ------ 19:51:34 T:1780955728 DEBUG: Window Settings.xml was already loaded 19:51:34 T:1780955728 DEBUG: Alloc resources: 0.43m 19:51:35 T:1780955728 DEBUG: Keyboard: scancode: 0x04, sym: 0x0008, unicode: 0x0000, modifier: 0x0 19:51:35 T:1780955728 DEBUG: bool CApplication::OnKey(const CKey&): backspace (0xf008) pressed, action is Back 19:51:35 T:1780955728 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 19:51:35 T:1780955728 DEBUG: ------ Window Deinit (Settings.xml) ------ 19:51:35 T:1780955728 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 19:51:35 T:1780955728 DEBUG: ------ Window Init (Home.xml) ------ 19:51:35 T:1780955728 DEBUG: Window Home.xml was already loaded 19:51:35 T:1780955728 DEBUG: Alloc resources: 9.09m 19:51:36 T:1780955728 DEBUG: Keyboard: scancode: 0x16, sym: 0x0113, unicode: 0x0000, modifier: 0x0 19:51:36 T:1780955728 DEBUG: bool CApplication::OnKey(const CKey&): right (0xf083) pressed, action is Right 19:51:38 T:1780955728 DEBUG: Keyboard: scancode: 0x16, sym: 0x0113, unicode: 0x0000, modifier: 0x0 19:51:38 T:1780955728 DEBUG: bool CApplication::OnKey(const CKey&): right (0xf083) pressed, action is Right 19:51:38 T:1780955728 DEBUG: Keyboard: scancode: 0x16, sym: 0x0113, unicode: 0x0000, modifier: 0x0 19:51:38 T:1780955728 DEBUG: bool CApplication::OnKey(const CKey&): right (0xf083) pressed, action is Right 19:51:40 T:1780955728 DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0 19:51:40 T:1780955728 DEBUG: bool CApplication::OnKey(const CKey&): down (0xf081) pressed, action is Down 19:51:40 T:1780955728 DEBUG: Keyboard: scancode: 0x42, sym: 0x000d, unicode: 0x000a, modifier: 0x0 19:51:40 T:1780955728 DEBUG: bool CApplication::OnKey(const CKey&): return (0xf00d) pressed, action is Select 19:51:40 T:1780955728 DEBUG: Activating window ID: 10025 19:51:40 T:1780955728 DEBUG: ------ Window Deinit (Home.xml) ------ 19:51:40 T:1780955728 DEBUG: ------ Window Init (MyVideoNav.xml) ------ 19:51:40 T:1780955728 INFO: Loading skin file: MyVideoNav.xml, load type: KEEP_IN_MEMORY 19:51:40 T:1780955728 DEBUG: Load MyVideoNav.xml: 257.63ms 19:51:40 T:1780955728 DEBUG: Alloc resources: 267.18ms (258.00 ms skin load) 19:51:40 T:1780955728 DEBUG: CGUIMediaWindow::GetDirectory (sources://video/) 19:51:40 T:1780955728 DEBUG: ParentPath = [sources://video/] 19:51:40 T:1883024544 NOTICE: Thread BackgroundLoader start, auto delete: false 19:51:40 T:1883024544 DEBUG: Thread BackgroundLoader 1883024544 terminating 19:51:42 T:1780955728 DEBUG: SECTION:UnloadDelayed(DLL: libImageLib-arm.so) 19:51:42 T:1780955728 DEBUG: Unloading: libImageLib-arm.so 19:51:43 T:1780955728 INFO: void XCURL::DllLibCurlGlobal::CheckIdle() - Closing session to http://feeds.xbmc.org (easy=0x6dc30008, multi=0x6d751f60) 19:51:45 T:1780955728 DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0 19:51:45 T:1780955728 DEBUG: bool CApplication::OnKey(const CKey&): down (0xf081) pressed, action is Down 19:51:45 T:1780955728 DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0 19:51:45 T:1780955728 DEBUG: bool CApplication::OnKey(const CKey&): down (0xf081) pressed, action is Down 19:51:45 T:1780955728 DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0 19:51:45 T:1780955728 DEBUG: bool CApplication::OnKey(const CKey&): down (0xf081) pressed, action is Down 19:51:46 T:1780955728 DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0 19:51:46 T:1780955728 DEBUG: bool CApplication::OnKey(const CKey&): down (0xf081) pressed, action is Down 19:51:46 T:1780955728 DEBUG: Keyboard: scancode: 0x42, sym: 0x000d, unicode: 0x000a, modifier: 0x0 19:51:46 T:1780955728 DEBUG: bool CApplication::OnKey(const CKey&): return (0xf00d) pressed, action is Select 19:51:46 T:1780955728 INFO: Loading skin file: DialogMediaSource.xml, load type: KEEP_IN_MEMORY 19:51:46 T:1780955728 DEBUG: Load DialogMediaSource.xml: 18.28ms 19:51:46 T:1780955728 DEBUG: Alloc resources: 22.31ms (18.57 ms skin load) 19:51:46 T:1780955728 DEBUG: ------ Window Init (DialogMediaSource.xml) ------ 19:51:46 T:1780955728 DEBUG: Window DialogMediaSource.xml was already loaded 19:51:46 T:1780955728 DEBUG: Alloc resources: 0.01m 19:51:48 T:1780955728 DEBUG: Keyboard: scancode: 0x16, sym: 0x0113, unicode: 0x0000, modifier: 0x0 19:51:48 T:1780955728 DEBUG: bool CApplication::OnKey(const CKey&): right (0xf083) pressed, action is Right 19:51:48 T:1780955728 DEBUG: Keyboard: scancode: 0x42, sym: 0x000d, unicode: 0x000a, modifier: 0x0 19:51:48 T:1780955728 DEBUG: bool CApplication::OnKey(const CKey&): return (0xf00d) pressed, action is Select 19:51:48 T:1780955728 INFO: Loading skin file: FileBrowser.xml, load type: KEEP_IN_MEMORY 19:51:48 T:1780955728 DEBUG: Load FileBrowser.xml: 69.79ms 19:51:48 T:1780955728 DEBUG: Alloc resources: 70.80ms (70.24 ms skin load) 19:51:48 T:1780955728 DEBUG: ------ Window Init (FileBrowser.xml) ------ 19:51:48 T:1780955728 DEBUG: Window FileBrowser.xml was already loaded 19:51:48 T:1780955728 DEBUG: Alloc resources: 0.04m 19:51:50 T:1780955728 DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0 19:51:50 T:1780955728 DEBUG: bool CApplication::OnKey(const CKey&): down (0xf081) pressed, action is Down 19:51:51 T:1780955728 DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0 19:51:51 T:1780955728 DEBUG: bool CApplication::OnKey(const CKey&): down (0xf081) pressed, action is Down 19:51:51 T:1780955728 DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0 19:51:51 T:1780955728 DEBUG: bool CApplication::OnKey(const CKey&): down (0xf081) pressed, action is Down 19:51:51 T:1780955728 DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0 19:51:51 T:1780955728 DEBUG: bool CApplication::OnKey(const CKey&): down (0xf081) pressed, action is Down 19:51:51 T:1780955728 DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0 19:51:51 T:1780955728 DEBUG: bool CApplication::OnKey(const CKey&): down (0xf081) pressed, action is Down 19:51:52 T:1780955728 DEBUG: Keyboard: scancode: 0x42, sym: 0x000d, unicode: 0x000a, modifier: 0x0 19:51:52 T:1780955728 DEBUG: bool CApplication::OnKey(const CKey&): return (0xf00d) pressed, action is Select 19:51:53 T:1780955728 DEBUG: Keyboard: scancode: 0x13, sym: 0x0111, unicode: 0x0000, modifier: 0x0 19:51:53 T:1780955728 DEBUG: bool CApplication::OnKey(const CKey&): up (0xf080) pressed, action is Up 19:51:53 T:1780955728 DEBUG: Keyboard: scancode: 0x13, sym: 0x0111, unicode: 0x0000, modifier: 0x0 19:51:53 T:1780955728 DEBUG: bool CApplication::OnKey(const CKey&): up (0xf080) pressed, action is Up 19:51:53 T:1780955728 DEBUG: Keyboard: scancode: 0x13, sym: 0x0111, unicode: 0x0000, modifier: 0x0 19:51:53 T:1780955728 DEBUG: bool CApplication::OnKey(const CKey&): up (0xf080) pressed, action is Up 19:51:54 T:1780955728 DEBUG: Keyboard: scancode: 0x13, sym: 0x0111, unicode: 0x0000, modifier: 0x0 19:51:54 T:1780955728 DEBUG: bool CApplication::OnKey(const CKey&): up (0xf080) pressed, action is Up 19:51:54 T:1780955728 DEBUG: Keyboard: scancode: 0x13, sym: 0x0111, unicode: 0x0000, modifier: 0x0 19:51:54 T:1780955728 DEBUG: bool CApplication::OnKey(const CKey&): up (0xf080) pressed, action is Up 19:51:54 T:1780955728 DEBUG: Keyboard: scancode: 0x13, sym: 0x0111, unicode: 0x0000, modifier: 0x0 19:51:54 T:1780955728 DEBUG: bool CApplication::OnKey(const CKey&): up (0xf080) pressed, action is Up 19:51:54 T:1780955728 DEBUG: Keyboard: scancode: 0x13, sym: 0x0111, unicode: 0x0000, modifier: 0x0 19:51:54 T:1780955728 DEBUG: bool CApplication::OnKey(const CKey&): up (0xf080) pressed, action is Up 19:51:56 T:1780955728 DEBUG: Keyboard: scancode: 0x16, sym: 0x0113, unicode: 0x0000, modifier: 0x0 19:51:56 T:1780955728 DEBUG: bool CApplication::OnKey(const CKey&): right (0xf083) pressed, action is Right 19:51:58 T:1780955728 DEBUG: Keyboard: scancode: 0x15, sym: 0x0114, unicode: 0x0000, modifier: 0x0 19:51:58 T:1780955728 DEBUG: bool CApplication::OnKey(const CKey&): left (0xf082) pressed, action is Left 19:51:59 T:1780955728 DEBUG: Keyboard: scancode: 0x42, sym: 0x000d, unicode: 0x000a, modifier: 0x0 19:51:59 T:1780955728 DEBUG: bool CApplication::OnKey(const CKey&): return (0xf00d) pressed, action is Select 19:52:01 T:1780955728 DEBUG: Keyboard: scancode: 0x16, sym: 0x0113, unicode: 0x0000, modifier: 0x0 19:52:01 T:1780955728 DEBUG: bool CApplication::OnKey(const CKey&): right (0xf083) pressed, action is Right 19:52:01 T:1780955728 DEBUG: Keyboard: scancode: 0x42, sym: 0x000d, unicode: 0x000a, modifier: 0x0 19:52:01 T:1780955728 DEBUG: bool CApplication::OnKey(const CKey&): return (0xf00d) pressed, action is Select 19:52:02 T:1780955728 DEBUG: ------ Window Deinit (FileBrowser.xml) ------ 19:52:03 T:1780955728 DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0 19:52:03 T:1780955728 DEBUG: bool CApplication::OnKey(const CKey&): down (0xf081) pressed, action is Down 19:52:03 T:1780955728 DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0 19:52:03 T:1780955728 DEBUG: bool CApplication::OnKey(const CKey&): down (0xf081) pressed, action is Down 19:52:04 T:1780955728 DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0 19:52:04 T:1780955728 DEBUG: bool CApplication::OnKey(const CKey&): down (0xf081) pressed, trying keyboard action 4 19:52:04 T:1780955728 DEBUG: Keyboard: scancode: 0x42, sym: 0x000d, unicode: 0x000a, modifier: 0x0 19:52:04 T:1780955728 DEBUG: bool CApplication::OnKey(const CKey&): return (0xf00d) pressed, action is Select 19:52:05 T:1780955728 DEBUG: ------ Window Init (DialogContentSettings.xml) ------ 19:52:05 T:1780955728 INFO: Loading skin file: DialogContentSettings.xml, load type: KEEP_INMEMORY 19:52:05 T:1780955728 DEBUG: Load DialogContentSettings.xml: 22.54ms 19:52:05 T:1780955728 DEBUG: Alloc resources: 24.53ms (23.20 ms skin load) 19:52:05 T:1780955728 DEBUG: ------ Window Deinit (DialogMediaSource.xml) ------ 19:52:06 T:1780955728 DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0 19:52:06 T:1780955728 DEBUG: bool CApplication::OnKey(const CKey&): down (0xf081) pressed, action is Down 19:52:06 T:1780955728 DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0 19:52:06 T:1780955728 DEBUG: bool CApplication::OnKey(const CKey&): down (0xf081) pressed, action is Down 19:52:07 T:1780955728 DEBUG: Keyboard: scancode: 0x42, sym: 0x000d, unicode: 0x000a, modifier: 0x0 19:52:07 T:1780955728 DEBUG: bool CApplication::OnKey(const CKey&): return (0xf00d) pressed, action is Select 19:52:07 T:1780955728 DEBUG: ------ Window Deinit (DialogContentSettings.xml) ------ 19:52:08 T:1780955728 DEBUG: Previous line repeats 1 times. 19:52:08 T:1780955728 DEBUG: CGUIMediaWindow::GetDirectory (sources://video/) 19:52:08 T:1780955728 DEBUG: ParentPath = [sources://video/] 19:52:08 T:1883118976 NOTICE: Thread BackgroundLoader start, auto delete: false 19:52:08 T:1883118976 DEBUG: Thread BackgroundLoader 1883118976 terminating 19:52:09 T:1780955728 DEBUG: Keyboard: scancode: 0x04, sym: 0x0008, unicode: 0x0000, modifier: 0x0 19:52:09 T:1780955728 DEBUG: bool CApplication::OnKey(const CKey&): backspace (0xf008) pressed, action is Back 19:52:09 T:1780955728 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 19:52:09 T:1780955728 DEBUG: ------ Window Deinit (MyVideoNav.xml) ------ 19:52:09 T:1780955728 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 19:52:09 T:1780955728 DEBUG: ------ Window Init (Home.xml) ------ 19:52:09 T:1780955728 DEBUG: Window Home.xml was already loaded 19:52:09 T:1780955728 DEBUG: Alloc resources: 6.28m 19:52:11 T:1780955728 DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0 19:52:11 T:1780955728 DEBUG: bool CApplication::OnKey(const CKey&): down (0xf081) pressed, action is Down 19:52:11 T:1780955728 DEBUG: Keyboard: scancode: 0x42, sym: 0x000d, unicode: 0x000a, modifier: 0x0 19:52:11 T:1780955728 DEBUG: bool CApplication::OnKey(const CKey&): return (0xf00d) pressed, action is Select 19:52:11 T:1780955728 DEBUG: Activating window ID: 10025 19:52:11 T:1780955728 DEBUG: ------ Window Deinit (Home.xml) ------ 19:52:11 T:1780955728 DEBUG: ------ Window Init (MyVideoNav.xml) ------ 19:52:11 T:1780955728 DEBUG: Window MyVideoNav.xml was already loaded 19:52:11 T:1780955728 DEBUG: Alloc resources: 2.06m 19:52:11 T:1780955728 DEBUG: CGUIMediaWindow::GetDirectory (sources://video/) 19:52:11 T:1780955728 DEBUG: ParentPath = [sources://video/] 19:52:11 T:1836789480 NOTICE: Thread BackgroundLoader start, auto delete: false 19:52:11 T:1836789480 DEBUG: Thread BackgroundLoader 1836789480 terminating 19:52:14 T:1780955728 DEBUG: Keyboard: scancode: 0x13, sym: 0x0111, unicode: 0x0000, modifier: 0x0 19:52:14 T:1780955728 DEBUG: bool CApplication::OnKey(const CKey&): up (0xf080) pressed, action is Up 19:52:14 T:1780955728 DEBUG: Keyboard: scancode: 0x42, sym: 0x000d, unicode: 0x000a, modifier: 0x0 19:52:14 T:1780955728 DEBUG: bool CApplication::OnKey(const CKey&): return (0xf00d) pressed, action is Select 19:52:14 T:1780955728 DEBUG: CGUIMediaWindow::GetDirectory (/sdcard/) 19:52:14 T:1780955728 DEBUG: ParentPath = [sources://video/] 19:52:14 T:1780955728 DEBUG: int CVideoDatabase::RunQuery(const CStdString&) took 2 ms for 0 items query: SELECT files.strFilename, files.playCount, bookmark.timeInSeconds, bookmark.totalTimeInSeconds FROM files LEFT JOIN bookmark ON files.idFile = bookmark.idFile AND bookmark.type = 1 WHERE files.idPath=123 19:52:14 T:1884069720 NOTICE: Thread BackgroundLoader start, auto delete: false 19:52:14 T:1831405352 DEBUG: virtual bool CThumbExtractor::DoWork() - trying to extract thumb from video file /sdcard/Lego Hampocalypse [720p].mp4 19:52:14 T:1831405352 DEBUG: bool CDVDDemuxFFmpeg::Open(CDVDInputStream) - probing detected format [mov,mp4,m4a,3gp,3g2,mj2] 19:52:14 T:1884069720 DEBUG: Thread BackgroundLoader 1884069720 terminating 19:52:14 T:1831405352 DEBUG: bool CDVDDemuxFFmpeg::Open(CDVDInputStream_) - avformat_find_streaminfo starting 19:52:14 T:1831405352 DEBUG: bool CDVDDemuxFFmpeg::Open(CDVDInputStream) - av_find_stream_info finished 19:52:14 T:1831405352 INFO: ffmpeg[6D290728]: Input #0, mov,mp4,m4a,3gp,3g2,mj2, from '/sdcard/Lego Hampocalypse [720p].mp4': 19:52:14 T:1831405352 INFO: ffmpeg[6D290728]: Metadata: 19:52:14 T:1831405352 INFO: ffmpeg[6D290728]: major_brand : mp42 19:52:14 T:1831405352 INFO: ffmpeg[6D290728]: minor_version : 0 19:52:14 T:1831405352 INFO: ffmpeg[6D290728]: compatible_brands: isommp42 19:52:14 T:1831405352 INFO: ffmpeg[6D290728]: creation_time : 2015-03-29 03:29:15 19:52:14 T:1831405352 INFO: ffmpeg[6D290728]: Duration: 00:02:17.97, start: 0.000000, bitrate: 2130 kb/s 19:52:14 T:1831405352 INFO: ffmpeg[6D290728]: Stream #0:0(und): Video: h264 (High) (avc1 / 0x31637661), yuv420p, 1280x720 [SAR 1:1 DAR 16:9], 1935 kb/s, 29.97 fps, 29.97 tbr, 30k tbn, 59.94 tbc (default) 19:52:14 T:1831405352 INFO: ffmpeg[6D290728]: Metadata: 19:52:14 T:1831405352 INFO: ffmpeg[6D290728]: creation_time : 1970-01-01 00:00:00 19:52:14 T:1831405352 INFO: ffmpeg[6D290728]: handler_name : VideoHandler 19:52:14 T:1831405352 INFO: ffmpeg[6D290728]: Stream #0:1(eng): Audio: aac (mp4a / 0x6134706D), 44100 Hz, stereo, fltp, 192 kb/s (default) 19:52:14 T:1831405352 INFO: ffmpeg[6D290728]: Metadata: 19:52:14 T:1831405352 INFO: ffmpeg[6D290728]: creation_time : 2015-03-29 03:29:15 19:52:14 T:1831405352 INFO: ffmpeg[6D290728]: handlername : IsoMedia File Produced by Google, 5-11-2011 19:52:14 T:1831405352 DEBUG: CDVDDemuxFFmpeg::AddStream(0, ...) -> 0 19:52:14 T:1831405352 DEBUG: CDVDDemuxFFmpeg::AddStream(1, ...) -> 1 19:52:14 T:1831405352 DEBUG: static void CUtil::ScanForExternalSubtitles(const CStdString&, std::vector<CStdStr >&): Searching for subtitles... 19:52:14 T:1831405352 DEBUG: static void CUtil::ScanForExternalSubtitles(const CStdString&, std::vector<CStdStr >&): END (total time: 10 ms) 19:52:14 T:1831405352 DEBUG: CDVDFactoryCodec: compiled in hardware support: CrystalHD:no AMCodec:yes MediaCodec:yes OpenMax:no libstagefright:yes RKlibstagefright:yes VDPAU:no VAAPI:no iMXVPU:no 19:52:14 T:1831405352 DEBUG: FactoryCodec - Video: - Opening 19:52:14 T:1831405352 NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10 19:52:14 T:1831405352 DEBUG: CDVDVideoCodecFFmpeg::Open() Keep default threading 3 by videoplayer.useframemtdec 19:52:14 T:1831405352 DEBUG: FactoryCodec - Video: ff-h264 - Opened 19:52:14 T:1831405352 DEBUG: static bool CDVDFileInfo::ExtractThumb(const CStdString&, CTextureDetails&, CStreamDetails) - seeking to pos 45990ms (total: 137971ms) in /sdcard/Lego Hampocalypse [720p].mp4 19:52:14 T:1831405352 DEBUG: virtual bool CDVDDemuxFFmpeg::SeekTime(int, bool, double) - unknown position after seek 19:52:15 T:1831405352 DEBUG: cached image 'special://masterprofile/Thumbnails/a/a6f8756e.jpg' size 360x202 19:52:15 T:1831405352 DEBUG: static bool CDVDFileInfo::ExtractThumb(const CStdString&, CTextureDetails&, CStreamDetails) - measured 484 ms to extract thumb from file </sdcard/Lego Hampocalypse [720p].mp4> in 16 packets. 19:52:15 T:1780955728 DEBUG: Keyboard: scancode: 0x13, sym: 0x0111, unicode: 0x0000, modifier: 0x0 19:52:15 T:1780955728 DEBUG: bool CApplication::OnKey(const CKey&): up (0xf080) pressed, action is Up 19:52:17 T:1780955728 DEBUG: Keyboard: scancode: 0x42, sym: 0x000d, unicode: 0x000a, modifier: 0x0 19:52:17 T:1780955728 DEBUG: bool CApplication::OnKey(const CKey&): return (0xf00d) pressed, action is Select 19:52:17 T:1780955728 DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc 19:52:17 T:1780955728 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnClear 19:52:17 T:1780955728 DEBUG: int CVideoDatabase::GetMovieId(const CStdString&) (/sdcard/Lego Hampocalypse [720p].mp4), query = select idMovie from movie where idFile=1639 19:52:17 T:1780955728 DEBUG: int CVideoDatabase::GetEpisodeId(const CStdString&, int, int) (/sdcard/Lego Hampocalypse [720p].mp4), query = select idEpisode from episode where idFile=1639 19:52:17 T:1780955728 DEBUG: int CVideoDatabase::GetMusicVideoId(const CStdString&) (/sdcard/Lego Hampocalypse [720p].mp4), query = select idMVideo from musicvideo where idFile=1639 19:52:17 T:1780955728 DEBUG: CAnnouncementManager - Announcement: OnAdd from xbmc 19:52:17 T:1780955728 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnAdd 19:52:17 T:1780955728 DEBUG: CPlayerCoreFactory::GetPlayers(/sdcard/Lego Hampocalypse [720p].mp4) 19:52:17 T:1780955728 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules 19:52:17 T:1780955728 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules 19:52:17 T:1780955728 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtv 19:52:17 T:1780955728 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: hdhomerun/myth/mms/udp 19:52:17 T:1780955728 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout 19:52:17 T:1780955728 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp 19:52:17 T:1780955728 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp 19:52:17 T:1780955728 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams 19:52:17 T:1780955728 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd 19:52:17 T:1780955728 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage 19:52:17 T:1780955728 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf 19:52:17 T:1780955728 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv 19:52:17 T:1780955728 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio 19:52:17 T:1780955728 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players 19:52:17 T:1780955728 DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (1) 19:52:17 T:1780955728 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0 19:52:17 T:1780955728 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1 19:52:17 T:1780955728 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: DVDPlayer (1) 19:52:17 T:1780955728 DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players 19:52:17 T:1780955728 NOTICE: DVDPlayer: Opening: /sdcard/Lego Hampocalypse [720p].mp4 19:52:17 T:1780955728 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOTINITIALIZED 19:52:17 T:1780955728 DEBUG: CRenderManager::UpdateDisplayLatency - Latency set to 0 msec 19:52:17 T:1780955728 DEBUG: LinuxRendererGL: Cleaning up GL resources 19:52:17 T:1841487240 NOTICE: Thread DVDPlayer start, auto delete: false 19:52:17 T:1841487240 NOTICE: Creating InputStream 19:52:17 T:1841487240 DEBUG: static void CUtil::ScanForExternalSubtitles(const CStdString&, std::vector<CStdStr >&): Searching for subtitles... 19:52:17 T:1841487240 DEBUG: static void CUtil::ScanForExternalSubtitles(const CStdString&, std::vector<CStdStr >&): END (total time: 9 ms) 19:52:17 T:1841487240 NOTICE: Creating Demuxer 19:52:17 T:1841487240 DEBUG: bool CDVDDemuxFFmpeg::Open(CDVDInputStream) - probing detected format [mov,mp4,m4a,3gp,3g2,mj2] 19:52:17 T:1841487240 DEBUG: bool CDVDDemuxFFmpeg::Open(CDVDInputStream_) - avformat_find_streaminfo starting 19:52:17 T:1841487240 DEBUG: bool CDVDDemuxFFmpeg::Open(CDVDInputStream) - av_find_stream_info finished 19:52:17 T:1841487240 INFO: ffmpeg[6DC2DD88]: Input #0, mov,mp4,m4a,3gp,3g2,mj2, from '/sdcard/Lego Hampocalypse [720p].mp4': 19:52:17 T:1841487240 INFO: ffmpeg[6DC2DD88]: Metadata: 19:52:17 T:1841487240 INFO: ffmpeg[6DC2DD88]: major_brand : mp42 19:52:17 T:1841487240 INFO: ffmpeg[6DC2DD88]: minor_version : 0 19:52:17 T:1841487240 INFO: ffmpeg[6DC2DD88]: compatible_brands: isommp42 19:52:17 T:1841487240 INFO: ffmpeg[6DC2DD88]: creation_time : 2015-03-29 03:29:15 19:52:17 T:1841487240 INFO: ffmpeg[6DC2DD88]: Duration: 00:02:17.97, start: 0.000000, bitrate: 2130 kb/s 19:52:17 T:1841487240 INFO: ffmpeg[6DC2DD88]: Stream #0:0(und): Video: h264 (High) (avc1 / 0x31637661), yuv420p, 1280x720 [SAR 1:1 DAR 16:9], 1935 kb/s, 29.97 fps, 29.97 tbr, 30k tbn, 59.94 tbc (default) 19:52:17 T:1841487240 INFO: ffmpeg[6DC2DD88]: Metadata: 19:52:17 T:1841487240 INFO: ffmpeg[6DC2DD88]: creation_time : 1970-01-01 00:00:00 19:52:17 T:1841487240 INFO: ffmpeg[6DC2DD88]: handler_name : VideoHandler 19:52:17 T:1841487240 INFO: ffmpeg[6DC2DD88]: Stream #0:1(eng): Audio: aac (mp4a / 0x6134706D), 44100 Hz, stereo, fltp, 192 kb/s (default) 19:52:17 T:1841487240 INFO: ffmpeg[6DC2DD88]: Metadata: 19:52:17 T:1841487240 INFO: ffmpeg[6DC2DD88]: creation_time : 2015-03-29 03:29:15 19:52:17 T:1841487240 INFO: ffmpeg[6DC2DD88]: handler_name : IsoMedia File Produced by Google, 5-11-2011 19:52:17 T:1841487240 DEBUG: CDVDDemuxFFmpeg::AddStream(0, ...) -> 0 19:52:17 T:1841487240 DEBUG: CDVDDemuxFFmpeg::AddStream(1, ...) -> 1 19:52:17 T:1841487240 NOTICE: Opening video stream: 0 source: 256 19:52:17 T:1841487240 NOTICE: Creating video codec with codec id: 28 19:52:17 T:1841487240 DEBUG: CDVDFactoryCodec: compiled in hardware support: CrystalHD:no AMCodec:yes MediaCodec:yes OpenMax:no libstagefright:yes RKlibstagefright:yes VDPAU:no VAAPI:no iMXVPU:no 19:52:17 T:1841487240 DEBUG: FactoryCodec - Video: amcodec - Opening 19:52:17 T:1841487240 INFO: CBitstreamConverter::Open bitstream to annexb init 19:52:17 T:1841487240 DEBUG: SECTION:LoadDLL(libamplayer.so) 19:52:17 T:1841487240 DEBUG: Loading: /system/lib/libamplayer.so 19:52:17 T:1841487240 INFO: DVDVideoCodecAmlogic: Opened Amlogic Codec 19:52:17 T:1841487240 DEBUG: FactoryCodec - Video: am-h264 - Opened 19:52:17 T:1841487240 NOTICE: Creating video thread 19:52:17 T:1836789480 NOTICE: Thread DVDPlayerVideo start, auto delete: false 19:52:17 T:1836789480 NOTICE: running thread: video_thread 19:52:17 T:1841487240 NOTICE: Opening audio stream: 1 source: 256 19:52:17 T:1841487240 NOTICE: Finding audio codec for: 86018 19:52:17 T:1836789480 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE 19:52:17 T:1841487240 DEBUG: FactoryCodec - Audio: passthrough - Opening 19:52:17 T:1841487240 DEBUG: FactoryCodec - Audio: passthrough - Failed 19:52:17 T:1841487240 DEBUG: FactoryCodec - Audio: FFmpeg - Opening 19:52:17 T:1841487240 DEBUG: FactoryCodec - Audio: FFmpeg - Opened 19:52:17 T:1841487240 NOTICE: Creating audio thread 19:52:17 T:1883712680 NOTICE: Thread DVDPlayerAudio start, auto delete: false 19:52:17 T:1883712680 NOTICE: running thread: CDVDPlayerAudio::Process() 19:52:17 T:1841487240 DEBUG: bool CEdl::ReadEditDecisionLists(const CStdString&, float, int) - Checking for edit decision lists (EDL) on local drive or remote share for: /sdcard/Lego Hampocalypse [720p].mp4 19:52:17 T:1841487240 DEBUG: virtual void CApplication::OnPlayBackStarted() : play state was 1, starting 1 19:52:17 T:1780955728 DEBUG: PlayBackRet CApplication::PlayFile(const CFileItem&, bool) : OpenFile succeed, play state 2 19:52:17 T:1780955728 DEBUG: virtual void CApplication::OnPlayBackStarted() : play state was 2, starting 0 19:52:17 T:1841487240 DEBUG: CDVDPlayer::SetCaching - caching state 3 19:52:17 T:1836789480 DEBUG: CAMLCodec::SetSpeed, speed(0) 19:52:17 T:1836789480 INFO: CDVDPlayerVideo - Stillframe left, switching to normal playback 19:52:17 T:1836789480 DEBUG: CAMLCodec::OpenDecoder, android version 19 19:52:17 T:1836789480 DEBUG: codecid_to_vformat, id(28) -> vformat(2) 19:52:17 T:1836789480 DEBUG: codec_tag_to_vdec_type, codec_tag(828601953) -> vdec_type(4) 19:52:17 T:1836789480 DEBUG: CAMLCodec::OpenDecoder hints.width(1280), hints.height(720), hints.codec(28), hints.codec_tag(828601953), hints.pid(1) 19:52:17 T:1836789480 DEBUG: CAMLCodec::OpenDecoder hints.fpsrate(30000), hints.fpsscale(1001), hints.rfpsrate(30000), hints.rfpsscale(1001), video_rate(3203) 19:52:17 T:1836789480 DEBUG: CAMLCodec::OpenDecoder hints.aspect(1.777778), video_ratio.num(1), video_ratio.den(1) 19:52:17 T:1836789480 DEBUG: CAMLCodec::OpenDecoder hints.orientation(0), hints.forced_aspect(0), hints.extrasize(35) 19:52:17 T:1883712680 NOTICE: Creating audio stream (codec id: 86018, channels: 2, sample rate: 44100, no pass-through) 19:52:17 T:1883712680 DEBUG: CDVDPlayerAudio:: synctype set to 0: clock feedback 19:52:17 T:1802503752 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 19:52:17 T:1841487240 DEBUG: CDVDPlayer::HandleMessages - player started 1 19:52:17 T:1836789480 DEBUG: add four byte NAL 264 header in stream before header len=35 19:52:17 T:1836789480 NOTICE: aml_get_sysfs_str k=/sys/class/display/mode v=1080p50hz 19:52:17 T:1836789480 DEBUG: CAMLCodec::SetSpeed, speed(1000) 19:52:17 T:1836789480 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC(33366.666667, 1) 19:52:17 T:1921845104 NOTICE: Thread CAMLCodec start, auto delete: false 19:52:17 T:1921845104 DEBUG: CAMLCodec::Process Started 19:52:17 T:1836789480 DEBUG: DVDVideoCodecAmlogic: detected new framerate(29.970030), videorate(3203) 19:52:17 T:1780955728 DEBUG: CGUIInfoManager::SetCurrentMovie(/sdcard/Lego Hampocalypse [720p].mp4) 19:52:17 T:1780955728 DEBUG: int CVideoDatabase::GetMovieId(const CStdString&) (/sdcard/Lego Hampocalypse [720p].mp4), query = select idMovie from movie where idFile=1639 19:52:17 T:1780955728 DEBUG: int CVideoDatabase::GetEpisodeId(const CStdString&, int, int) (/sdcard/Lego Hampocalypse [720p].mp4), query = select idEpisode from episode where idFile=1639 19:52:17 T:1836789480 NOTICE: fps: 29.970030, pwidth: 1280, pheight: 720, dwidth: 1280, dheight: 720 19:52:17 T:1836789480 DEBUG: int CDVDPlayerVideo::OutputPicture(const DVDVideoPicture, double) - change configuration. 1280x720. framerate: 29.97. format: BYPASS 19:52:17 T:1836789480 NOTICE: Display resolution ADJUST : 1920x1080 @ 60.00 - Full Screen (18) (fps: 29.970; weight: 0.001) 19:52:17 T:1836789480 DEBUG: CXBMCRenderManager::Configure - 3 19:52:17 T:1780955728 DEBUG: int CVideoDatabase::GetMusicVideoId(const CStdString&) (/sdcard/Lego Hampocalypse [720p].mp4), query = select idMVideo from musicvideo where idFile=1639 19:52:17 T:1780955728 DEBUG: CAnnouncementManager - Announcement: OnPlay from xbmc 19:52:17 T:1780955728 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPlay 19:52:17 T:1780955728 DEBUG: Activating window ID: 12005 19:52:17 T:1780955728 DEBUG: ------ Window Deinit (MyVideoNav.xml) ------ 19:52:17 T:1780955728 DEBUG: CAnnouncementManager - Announcement: OnPause from xbmc 19:52:17 T:1780955728 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPause 19:52:17 T:1885209528 NOTICE: Thread DelayedMessage start, auto delete: true 19:52:17 T:1780955728 NOTICE: Current resolution: 1280x720 @ 60.00 - Full Screen 19:52:17 T:1780955728 NOTICE: aml_get_sysfs_str k=/sys/class/display/mode v=1080p50hz 19:52:18 T:1780955728 NOTICE: aml_set_sysfs_str k=/sys/class/display/mode v=1080p 19:52:18 T:1780955728 DEBUG: bool CWinSystemEGL::CreateWindow(RESOLUTION_INFO&): Created surface of size 1280x720 19:52:18 T:1780955728 INFO: GLES: Maximum texture width: 4096 19:52:18 T:1780955728 DEBUG: CRenderManager::UpdateDisplayLatency - Latency set to 0 msec 19:52:18 T:1780955728 DEBUG: ------ Window Init (VideoFullScreen.xml) ------ 19:52:18 T:1780955728 INFO: Loading skin file: VideoFullScreen.xml, load type: KEEP_IN_MEMORY 19:52:18 T:1885209528 DEBUG: Thread DelayedMessage 1885209528 terminating (autodelete) 19:52:18 T:1780955728 DEBUG: Load VideoFullScreen.xml: 94.13ms 19:52:18 T:1780955728 DEBUG: Alloc resources: 102.94ms (94.78 ms skin load) 19:52:18 T:1883712680 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(23219.954649, 0) 19:52:18 T:1883712680 DEBUG: CDVDPlayerAudio:: Discontinuity1 - was:33366.666667, should be:-253658.766825, error:-287025.433492 19:52:18 T:1780955728 DEBUG: CAnnouncementManager - Announcement: OnPlay from xbmc 19:52:18 T:1780955728 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPlay 19:52:18 T:1780955728 NOTICE: Using GL_TEXTURE_2D 19:52:18 T:1780955728 DEBUG: GL: Requested render method: 0 19:52:18 T:1780955728 NOTICE: GL: Using BYPASS render method 19:52:18 T:1780955728 NOTICE: GL: NPOT texture support detected 19:52:18 T:1780955728 DEBUG: CLinuxRendererGLES: Reorder drawpoints due to method change from 1 to 256 19:52:18 T:1836789480 DEBUG: CAMLCodec::SetSpeed, speed(0) 19:52:18 T:1836789480 DEBUG: Previous line repeats 1 times. 19:52:18 T:1836789480 DEBUG: CAMLCodec::SetSpeed, speed(1000) 19:52:18 T:1841487240 DEBUG: CDVDPlayer::HandleMessages - player started 2 19:52:18 T:1836789480 DEBUG: CAMLCodec::SetSpeed, speed(1000) 19:52:18 T:1780955728 DEBUG: CAMLCodec::SetVideoRect:display(0,0,1920,1080) 19:52:18 T:1780955728 DEBUG: CAMLCodec::SetVideoRect:gui(0,0,1280,720) 19:52:18 T:1780955728 DEBUG: CAMLCodec::SetVideoRect:m_dst_rect(0,0,1280,720) 19:52:18 T:1780955728 DEBUG: CAMLCodec::SetVideoRect:dst_rect(0,0,1920,1080) 19:52:18 T:1780955728 DEBUG: CAMLCodec::SetVideoRect:m_stereo_mode(0) 19:52:18 T:1780955728 DEBUG: CAMLCodec::SetVideoRect:m_stereo_view(0) 19:52:18 T:1780955728 NOTICE: aml_set_sysfs_str k=/sys/class/video/axis v=0 0 1919 1079 19:52:20 T:1883712680 DEBUG: CDVDPlayerAudio:: Discontinuity2 - was:1780718.233175, should be:1761737.880396, error:-18980.352779 19:52:22 T:1883712680 DEBUG: CDVDPlayerAudio:: Discontinuity2 - was:3797125.880396, should be:3775257.781960, error:-21868.098436 19:52:41 T:1780955728 DEBUG: Keyboard: scancode: 0x42, sym: 0x000d, unicode: 0x000a, modifier: 0x0 19:52:41 T:1780955728 DEBUG: bool CApplication::OnKey(const CKey&): return (0xf00d) pressed, action is OSD 19:52:41 T:1780955728 DEBUG: ------ Window Init (VideoOSD.xml) ------ 19:52:41 T:1780955728 INFO: Loading skin file: VideoOSD.xml, load type: KEEP_IN_MEMORY 19:52:41 T:1780955728 DEBUG: Load VideoOSD.xml: 119.90ms 19:52:41 T:1780955728 DEBUG: Alloc resources: 145.51ms (120.39 ms skin load) 19:52:43 T:1780955728 DEBUG: Keyboard: scancode: 0x16, sym: 0x0113, unicode: 0x0000, modifier: 0x0 19:52:43 T:1780955728 DEBUG: bool CApplication::OnKey(const CKey&): right (0xf083) pressed, action is Right 19:52:43 T:1780955728 DEBUG: Keyboard: scancode: 0x42, sym: 0x000d, unicode: 0x000a, modifier: 0x0 19:52:43 T:1780955728 DEBUG: bool CApplication::OnKey(const CKey&): return (0xf00d) pressed, action is Select 19:52:43 T:1780955728 NOTICE: CDVDPlayer::CloseFile() 19:52:43 T:1780955728 NOTICE: DVDPlayer: waiting for threads to exit 19:52:43 T:1841487240 NOTICE: CDVDPlayer::OnExit() 19:52:43 T:1841487240 NOTICE: DVDPlayer: closing audio stream 19:52:43 T:1841487240 NOTICE: Closing audio stream 19:52:43 T:1841487240 NOTICE: Waiting for audio thread to exit 19:52:43 T:1883712680 NOTICE: thread end: CDVDPlayerAudio::OnExit() 19:52:43 T:1883712680 DEBUG: Thread DVDPlayerAudio 1883712680 terminating 19:52:43 T:1841487240 NOTICE: Closing audio device 19:52:43 T:1841487240 NOTICE: Deleting audio codec 19:52:43 T:1841487240 NOTICE: DVDPlayer: closing video stream 19:52:43 T:1841487240 NOTICE: Closing video stream 19:52:43 T:1802503752 DEBUG: CActiveAE::DiscardStream - audio stream deleted 19:52:43 T:1802503752 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 19:52:43 T:1841487240 NOTICE: waiting for video thread to exit 19:52:43 T:1802503752 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 19:52:43 T:1836789480 DEBUG: Previous line repeats 2 times. 19:52:43 T:1836789480 NOTICE: thread end: video_thread 19:52:43 T:1836789480 DEBUG: Thread DVDPlayerVideo 1836789480 terminating 19:52:43 T:1841487240 NOTICE: deleting video codec 19:52:43 T:1841487240 DEBUG: CAMLCodec::CloseDecoder 19:52:43 T:1921845104 DEBUG: CAMLCodec::Process Stopped 19:52:43 T:1921845104 DEBUG: Thread CAMLCodec 1921845104 terminating 19:52:44 T:1841487240 NOTICE: CDVDPlayer::OnExit() deleting demuxer 19:52:44 T:1841487240 NOTICE: CDVDPlayer::OnExit() deleting input stream 19:52:44 T:1841487240 DEBUG: virtual void CApplication::OnPlayBackStopped() : play state was 2, starting 0 19:52:44 T:1841487240 DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc 19:52:44 T:1841487240 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop 19:52:44 T:1841487240 DEBUG: Thread DVDPlayer 1841487240 terminating 19:52:44 T:1780955728 NOTICE: DVDPlayer: finished waiting 19:52:44 T:1780955728 DEBUG: LinuxRendererGL: Cleaning up GL resources 19:52:44 T:1780955728 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 19:52:44 T:1780955728 DEBUG: ------ Window Deinit (VideoOSD.xml) ------ 19:52:44 T:1780955728 DEBUG: ------ Window Deinit (VideoFullScreen.xml) ------ 19:52:44 T:1780955728 NOTICE: Current resolution: 1280x720 @ 60.00 - Full Screen 19:52:44 T:1780955728 NOTICE: aml_get_sysfs_str k=/sys/class/display/mode v=1080p 19:52:44 T:1780955728 NOTICE: aml_set_sysfs_str k=/sys/class/display/mode v=1080p50hz 19:52:44 T:1780955728 DEBUG: bool CWinSystemEGL::CreateWindow(RESOLUTION_INFO&): Created surface of size 1280x720 19:52:44 T:1780955728 INFO: GLES: Maximum texture width: 4096 19:52:44 T:1780955728 DEBUG: CRenderManager::UpdateDisplayLatency - Latency set to 0 msec 19:52:44 T:1780955728 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 19:52:44 T:1780955728 DEBUG: ------ Window Init (MyVideoNav.xml) ------ 19:52:44 T:1780955728 DEBUG: Window MyVideoNav.xml was already loaded 19:52:44 T:1780955728 DEBUG: Alloc resources: 8.80m 19:52:44 T:1780955728 DEBUG: CGUIMediaWindow::GetDirectory (/sdcard/) 19:52:44 T:1780955728 DEBUG: ParentPath = [/sdcard/] 19:52:44 T:1780955728 DEBUG: int CVideoDatabase::RunQuery(const CStdString&) took 4 ms for 1 items query: SELECT files.strFilename, files.playCount, bookmark.timeInSeconds, bookmark.totalTimeInSeconds FROM files LEFT JOIN bookmark ON files.idFile = bookmark.idFile AND bookmark.type = 1 WHERE files.idPath=123 19:52:45 T:1884104248 NOTICE: Thread BackgroundLoader start, auto delete: false 19:52:45 T:1884104248 DEBUG: Thread BackgroundLoader 1884104248 terminating 19:52:45 T:1780955728 NOTICE: CDVDPlayer::CloseFile() 19:52:45 T:1780955728 NOTICE: DVDPlayer: waiting for threads to exit 19:52:45 T:1780955728 NOTICE: DVDPlayer: finished waiting 19:52:45 T:1780955728 DEBUG: LinuxRendererGL: Cleaning up GL resources 19:52:45 T:1780955728 NOTICE: CDVDPlayer::CloseFile() 19:52:45 T:1780955728 NOTICE: DVDPlayer: waiting for threads to exit 19:52:45 T:1780955728 NOTICE: DVDPlayer: finished waiting 19:52:45 T:1780955728 DEBUG: LinuxRendererGL: Cleaning up GL resources 19:52:45 T:1831405352 DEBUG: virtual bool CSaveFileStateJob::DoWork() - Saving file state for video item /sdcard/Lego Hampocalypse [720p].mp4

koying commented 9 years ago

Thanks already.

Could you also give the value of "/sys/class/video/axis" while playing

koying commented 9 years ago

Please try this Kodi 15 alpha to confirm it solves the issue: http://mirrors.xbmc.org/test-builds/android/arm/kodi-20150411-0500be8-addamlrkegl-armeabi-v7a.apk

mapfde commented 9 years ago

Hello,

the issue is fixed in the alpha. Thank you very much for looking into it.

prahjister commented 9 years ago

Thank you

sudoeste commented 9 years ago

Any chance the 14.2 version will include this fix or only the 15 when it comes?

konnerbllb commented 8 years ago

I'm having this issue with SPMC 15.0 using the new Minix Neo U1. Are there any additional steps required other than using version 15? Everything is fine on my 1080P display but it's 1/4 and oversized in the top left on my 720P display. Minix is set to 720P, overscan is applied correctly and looks fine in menu. It's only when playing video that it's enlarged.