Still getting episode not found

[the-lazy-fox]

Still getting episode not found

[the-lazy-fox]

Hello,
Can you confirm that your shows are correctly linked with iMDB or TVDB TV Scrapers?
Can you provide a full log?
Thanks

[hugoduraes]

Yes, the TV Shows library is linked to the TVDB TV Scrapers.

Here's the full log:

22:43:23.113 T:18446744072158181664  NOTICE: special://profile/ is mapped to: special://masterprofile/
22:43:23.114 T:18446744072158181664  NOTICE: -----------------------------------------------------------------------
22:43:23.114 T:18446744072158181664  NOTICE: Starting Kodi (17.6 Git:20171114-a9a7a20). Platform: Android ARM 32-bit
22:43:23.114 T:18446744072158181664  NOTICE: Using Release Kodi x32 build
22:43:23.115 T:18446744072158181664  NOTICE: Kodi compiled Nov 14 2017 by GCC 4.9.0 for Android ARM 32-bit API level 21 (API level 21)
22:43:23.115 T:18446744072158181664  NOTICE: Running on Sony BRAVIA 4K GB ATV3 with Android 7.0.0 API level 24, kernel: Linux ARM 32-bit version 3.10.79
22:43:23.121 T:18446744072158181664  NOTICE: FFmpeg version/source: ffmpeg-3.1-kodi
22:43:23.121 T:18446744072158181664  NOTICE: Host CPU: ARMv7 Processor rev 2 (v7l), 4 cores available
22:43:23.122 T:18446744072158181664  NOTICE: Product: BRAVIA_ATV3_4K_EU, Device: BRAVIA_ATV3_4K, Board: BRAVIA_ATV2 - Manufacturer: Sony, Brand: Sony, Model: BRAVIA 4K GB ATV3, Hardware: mt5891
22:43:23.133 T:18446744072158181664  NOTICE: External storage path = /storage/emulated/0; status = ok
22:43:23.134 T:18446744072158181664  NOTICE: ARM Features: Neon enabled
22:43:23.134 T:18446744072158181664  NOTICE: special://xbmc/ is mapped to: /data/user/0/org.xbmc.kodi/cache/apk/assets
22:43:23.134 T:18446744072158181664  NOTICE: special://xbmcbin/ is mapped to: /data/user/0/org.xbmc.kodi/cache/apk/assets
22:43:23.134 T:18446744072158181664  NOTICE: special://xbmcbinaddons/ is mapped to: /data/app/org.xbmc.kodi-1/lib/arm
22:43:23.134 T:18446744072158181664  NOTICE: special://masterprofile/ is mapped to: /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/userdata
22:43:23.134 T:18446744072158181664  NOTICE: special://envhome/ is mapped to: /storage/emulated/0/Android/data/org.xbmc.kodi/files
22:43:23.134 T:18446744072158181664  NOTICE: special://home/ is mapped to: /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi
22:43:23.134 T:18446744072158181664  NOTICE: special://temp/ is mapped to: /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/temp
22:43:23.135 T:18446744072158181664  NOTICE: special://logpath/ is mapped to: /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/temp
22:43:23.135 T:18446744072158181664  NOTICE: The executable running is: /data/app/org.xbmc.kodi-1/lib/arm/libkodi.so
22:43:23.135 T:18446744072158181664  NOTICE: Local hostname: localhost
22:43:23.138 T:18446744072158181664  NOTICE: Log File is located: /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/temp//kodi.log
22:43:23.143 T:18446744072158181664  NOTICE: -----------------------------------------------------------------------
22:43:23.185 T:18446744072158181664  NOTICE: load settings...
22:43:23.226 T:18446744072158181664   DEBUG: CSettings: loaded settings definition from special://xbmc/system/settings/settings.xml
22:43:23.236 T:18446744072158181664 WARNING: CSettingInt: unknown options filler "audiocdactions" of "audiocds.autoaction"
22:43:23.262 T:18446744072158181664   DEBUG: CSettings: loaded settings definition from special://xbmc/system/settings/android.xml
22:43:23.282 T:18446744072158181664  NOTICE: Float is supported
22:43:23.283 T:18446744072158181664   DEBUG: AESinkAUDIOTRACK - 32000 supported
22:43:23.283 T:18446744072158181664   DEBUG: AESinkAUDIOTRACK - 44100 supported
22:43:23.284 T:18446744072158181664   DEBUG: AESinkAUDIOTRACK - 48000 supported
22:43:23.284 T:18446744072158181664   DEBUG: AESinkAUDIOTRACK - 88200 supported
22:43:23.285 T:18446744072158181664   DEBUG: AESinkAUDIOTRACK - 96000 supported
22:43:23.286 T:18446744072158181664   DEBUG: AESinkAUDIOTRACK - 176400 supported
22:43:23.286 T:18446744072158181664   DEBUG: AESinkAUDIOTRACK - 192000 supported
22:43:23.306 T:18446744072158181664   DEBUG: Firmware implements AC3 RAW
22:43:23.321 T:18446744072158181664   DEBUG: Firmware implements EAC3 RAW
22:43:23.347 T:18446744072158181664  NOTICE: Found 1 Lists of Devices
22:43:23.347 T:18446744072158181664  NOTICE: Enumerated AUDIOTRACK devices:
22:43:23.347 T:18446744072158181664  NOTICE:     Device 1
22:43:23.348 T:18446744072158181664  NOTICE:         m_deviceName      : AudioTrack
22:43:23.348 T:18446744072158181664  NOTICE:         m_displayName     : android
22:43:23.348 T:18446744072158181664  NOTICE:         m_displayNameExtra: audiotrack
22:43:23.348 T:18446744072158181664  NOTICE:         m_deviceType      : AE_DEVTYPE_HDMI
22:43:23.348 T:18446744072158181664  NOTICE:         m_channels        : FL,FR,FC,LFE,SL,SR,BL,BR,BC,BLOC,BROC
22:43:23.348 T:18446744072158181664  NOTICE:         m_sampleRates     : 32000,44100,48000,88200,96000,176400,192000
22:43:23.349 T:18446744072158181664  NOTICE:         m_dataFormats     : AE_FMT_S16LE,AE_FMT_FLOAT,AE_FMT_RAW
22:43:23.349 T:18446744072158181664  NOTICE:         m_streamTypes     : STREAM_TYPE_AC3,STREAM_TYPE_EAC3
22:43:23.374 T:18446744072158181664   DEBUG: CSkinSettings: no <skinsettings> tag found
22:43:23.375 T:18446744072158181664  NOTICE: No settings file to load (special://xbmc/system/advancedsettings.xml)
22:43:23.376 T:18446744072158181664  NOTICE: No settings file to load (special://masterprofile/advancedsettings.xml)
22:43:23.376 T:18446744072158181664  NOTICE: Default Video Player: VideoPlayer
22:43:23.376 T:18446744072158181664  NOTICE: Default Audio Player: paplayer
22:43:23.376 T:18446744072158181664  NOTICE: Disabled debug logging due to GUI setting. Level 0.
22:43:23.376 T:18446744072158181664  NOTICE: Log level changed to "LOG_LEVEL_NORMAL"
22:43:23.383 T:18446744072158181664  NOTICE: CMediaSourceSettings: loading media sources from special://masterprofile/sources.xml
22:43:23.386 T:18446744072158181664  NOTICE: Loading player core factory settings from special://xbmc/system/playercorefactory.xml.
22:43:23.388 T:18446744072158181664  NOTICE: Loaded playercorefactory configuration
22:43:23.390 T:18446744072158181664  NOTICE: Loading player core factory settings from special://masterprofile/playercorefactory.xml.
22:43:23.391 T:18446744072158181664  NOTICE: special://masterprofile/playercorefactory.xml does not exist. Skipping.
22:43:23.448 T:18446744072158181664  NOTICE: Running database version Addons27
22:43:23.828 T:18446744072158181664  NOTICE: ADDONS: Using repository repository.xbmc.org
22:43:24.008 T:18446744071750637856  NOTICE: Trying to open: 44100 samplerate 12 channelMask 4 encoding
22:43:24.013 T:18446744071750637856  NOTICE: CAESinkAUDIOTRACK::Initializing with: m_sampleRate: 44100 format: AE_FMT_FLOAT (AE) method: PCM stream-type: PCM-STREAM min_buffer_size: 30208 m_frames: 1888 m_frameSize: 8 channels: 2
22:43:24.106 T:18446744072158181664  NOTICE: InitWindowSystem: Using EGL Implementation: android
22:43:24.136 T:18446744072158181664  NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 60.000004 Hz
22:43:24.137 T:18446744072158181664  NOTICE: Found ([email protected]) at 16, setting to RES_DESKTOP at 16
22:43:24.137 T:18446744072158181664  NOTICE: Checking resolution 16
22:43:24.186 T:18446744072158181664  NOTICE: GL_VENDOR = ARM
22:43:24.186 T:18446744072158181664  NOTICE: GL_RENDERER = Mali-T860
22:43:24.186 T:18446744072158181664  NOTICE: GL_VERSION = OpenGL ES 3.2 v1.r14p0-01rel0.2d12c056913f44cb69721b6d77c31aa9
22:43:24.187 T:18446744072158181664  NOTICE: GL_SHADING_LANGUAGE_VERSION = OpenGL ES GLSL ES 3.20
22:43:24.187 T:18446744072158181664  NOTICE: GL_EXTENSIONS = GL_EXT_debug_marker GL_ARM_rgba8 GL_ARM_mali_shader_binary GL_OES_depth24 GL_OES_depth_texture GL_OES_depth_texture_cube_map GL_OES_packed_depth_stencil GL_OES_rgb8_rgba8 GL_EXT_read_format_bgra GL_OES_compressed_paletted_texture GL_OES_compressed_ETC1_RGB8_texture GL_OES_standard_derivatives GL_OES_EGL_image GL_OES_EGL_image_external GL_OES_EGL_image_external_essl3 GL_OES_EGL_sync GL_OES_texture_npot GL_OES_vertex_half_float GL_OES_required_internalformat GL_OES_vertex_array_object GL_OES_mapbuffer GL_EXT_texture_format_BGRA8888 GL_EXT_texture_rg GL_EXT_texture_type_2_10_10_10_REV GL_OES_fbo_render_mipmap GL_OES_element_index_uint GL_EXT_shadow_samplers GL_OES_texture_compression_astc GL_KHR_texture_compression_astc_ldr GL_KHR_texture_compression_astc_hdr GL_KHR_texture_compression_astc_sliced_3d GL_KHR_debug GL_EXT_occlusion_query_boolean GL_EXT_disjoint_timer_query GL_EXT_blend_minmax GL_EXT_discard_framebuffer GL_OES_get_program_binary GL_OES_texture_3D GL_EXT_texture_storage GL_EXT_multisampled_render_to_texture GL_OES_surfaceless_context GL_OES_texture_stencil8 GL_EXT_shader_pixel_local_storage GL_ARM_shader_framebuffer_fetch GL_ARM_shader_framebuffer_fetch_depth_stencil GL_ARM_mali_program_binary GL_EXT_sRGB GL_EXT_sRGB_write_control GL_EXT_texture_sRGB_decode GL_KHR_blend_equation_advanced GL_KHR_blend_equation_advanced_coherent GL_OES_texture_storage_multisample_2d_array GL_OES_shader_image_atomic GL_EXT_robustness GL_EXT_draw_buffers_indexed GL_OES_draw_buffers_indexed GL_EXT_texture_border_clamp GL_OES_texture_border_clamp GL_EXT_texture_cube_map_array GL_OES_texture_cube_map_array GL_OES_sample_variables GL_OES_sample_shading GL_OES_shader_multisample_interpolation GL_EXT_shader_io_blocks GL_OES_shader_io_blocks GL_EXT_tessellation_shader GL_OES_tessellation_shader GL_EXT_primitive_bounding_box GL_OES_primitive_bounding_box GL_EXT_geometry_shader GL_OES_geometry_shader GL_ANDROID_extension_pack_es31a GL_EXT_gpu_shader5 GL_OES_gpu_shader5 GL_EXT_texture_buffer GL_OES_texture_buffer GL_EXT_copy_image GL_OES_copy_image GL_EXT_color_buffer_half_float GL_EXT_color_buffer_float GL_EXT_YUV_target GL_OVR_multiview GL_OVR_multiview2 GL_OVR_multiview_multisampled_render_to_texture GL_KHR_robustness GL_KHR_robust_buffer_access_behavior GL_EXT_draw_elements_base_vertex GL_OES_draw_elements_base_vertex
22:43:25.305 T:18446744072158181664   ERROR: AddOnLog: Joystick Support: Device "Sony Interactive Entertainment Wireless Controller": can't find <controller> tag
22:43:25.572 T:18446744072158181664  NOTICE: Register - new joystick device registered on android->android/inputdevice/6: virtual-search (0000:0000)
22:43:25.574 T:18446744072158181664 WARNING: CAndroidJoystickState: ignoring unknown axis 32 on input device "SONY TV RC MIC 001" with ID 10
22:43:25.784 T:18446744072158181664  NOTICE: Register - new joystick device registered on android->android/inputdevice/10: SONY TV RC MIC 001 (054C:0BE8)
22:43:25.819 T:18446744071752726816  NOTICE: Running database version Addons27
22:43:25.824 T:18446744071752726816  NOTICE: Running database version ViewModes6
22:43:25.831 T:18446744071752726816  NOTICE: Running database version Textures13
22:43:25.847 T:18446744071752726816  NOTICE: Running database version MyMusic60
22:43:25.871 T:18446744071752726816  NOTICE: Running database version MyVideos107
22:43:25.882 T:18446744071752726816  NOTICE: Running database version TV29
22:43:25.887 T:18446744071752726816  NOTICE: Running database version Epg11
22:43:26.532 T:18446744072158181664 WARNING: JSONRPC: Could not parse type "Setting.Details.SettingList"
22:43:27.221 T:18446744072158181664  NOTICE: UpdateLibraries: Starting video library startup scan
22:43:27.397 T:18446744072158181664  NOTICE: initialize done
22:43:27.397 T:18446744072158181664  NOTICE: Running the application...
22:43:27.401 T:18446744072158181664  NOTICE: starting upnp client
22:43:27.419 T:18446744071644956960  NOTICE: ES: Starting UDP Event server on port 9777
22:43:27.420 T:18446744071644956960  NOTICE: UDP: Listening on port 9777 (ipv6 : false)
22:43:27.446 T:18446744072158181664  NOTICE: GL_VENDOR = ARM
22:43:27.448 T:18446744072158181664  NOTICE: GL_RENDERER = Mali-T860
22:43:27.451 T:18446744072158181664  NOTICE: GL_VERSION = OpenGL ES 3.2 v1.r14p0-01rel0.2d12c056913f44cb69721b6d77c31aa9
22:43:27.451 T:18446744072158181664  NOTICE: GL_SHADING_LANGUAGE_VERSION = OpenGL ES GLSL ES 3.20
22:43:27.451 T:18446744072158181664  NOTICE: GL_EXTENSIONS = GL_EXT_debug_marker GL_ARM_rgba8 GL_ARM_mali_shader_binary GL_OES_depth24 GL_OES_depth_texture GL_OES_depth_texture_cube_map GL_OES_packed_depth_stencil GL_OES_rgb8_rgba8 GL_EXT_read_format_bgra GL_OES_compressed_paletted_texture GL_OES_compressed_ETC1_RGB8_texture GL_OES_standard_derivatives GL_OES_EGL_image GL_OES_EGL_image_external GL_OES_EGL_image_external_essl3 GL_OES_EGL_sync GL_OES_texture_npot GL_OES_vertex_half_float GL_OES_required_internalformat GL_OES_vertex_array_object GL_OES_mapbuffer GL_EXT_texture_format_BGRA8888 GL_EXT_texture_rg GL_EXT_texture_type_2_10_10_10_REV GL_OES_fbo_render_mipmap GL_OES_element_index_uint GL_EXT_shadow_samplers GL_OES_texture_compression_astc GL_KHR_texture_compression_astc_ldr GL_KHR_texture_compression_astc_hdr GL_KHR_texture_compression_astc_sliced_3d GL_KHR_debug GL_EXT_occlusion_query_boolean GL_EXT_disjoint_timer_query GL_EXT_blend_minmax GL_EXT_discard_framebuffer GL_OES_get_program_binary GL_OES_texture_3D GL_EXT_texture_storage GL_EXT_multisampled_render_to_texture GL_OES_surfaceless_context GL_OES_texture_stencil8 GL_EXT_shader_pixel_local_storage GL_ARM_shader_framebuffer_fetch GL_ARM_shader_framebuffer_fetch_depth_stencil GL_ARM_mali_program_binary GL_EXT_sRGB GL_EXT_sRGB_write_control GL_EXT_texture_sRGB_decode GL_KHR_blend_equation_advanced GL_KHR_blend_equation_advanced_coherent GL_OES_texture_storage_multisample_2d_array GL_OES_shader_image_atomic GL_EXT_robustness GL_EXT_draw_buffers_indexed GL_OES_draw_buffers_indexed GL_EXT_texture_border_clamp GL_OES_texture_border_clamp GL_EXT_texture_cube_map_array GL_OES_texture_cube_map_array GL_OES_sample_variables GL_OES_sample_shading GL_OES_shader_multisample_interpolation GL_EXT_shader_io_blocks GL_OES_shader_io_blocks GL_EXT_tessellation_shader GL_OES_tessellation_shader GL_EXT_primitive_bounding_box GL_OES_primitive_bounding_box GL_EXT_geometry_shader GL_OES_geometry_shader GL_ANDROID_extension_pack_es31a GL_EXT_gpu_shader5 GL_OES_gpu_shader5 GL_EXT_texture_buffer GL_OES_texture_buffer GL_EXT_copy_image GL_OES_copy_image GL_EXT_color_buffer_half_float GL_EXT_color_buffer_float GL_EXT_YUV_target GL_OVR_multiview GL_OVR_multiview2 GL_OVR_multiview_multisampled_render_to_texture GL_KHR_robustness GL_KHR_robust_buffer_access_behavior GL_EXT_draw_elements_base_vertex GL_OES_draw_elements_base_vertex
22:43:28.318 T:18446744071750637856  NOTICE: Trying to open: 44100 samplerate 12 channelMask 4 encoding
22:43:28.338 T:18446744071750637856  NOTICE: CAESinkAUDIOTRACK::Initializing with: m_sampleRate: 44100 format: AE_FMT_FLOAT (AE) method: PCM stream-type: PCM-STREAM min_buffer_size: 30208 m_frames: 1888 m_frameSize: 8 channels: 2
22:43:28.353 T:18446744072158181664  NOTICE: GL_VENDOR = ARM
22:43:28.354 T:18446744072158181664  NOTICE: GL_RENDERER = Mali-T860
22:43:28.355 T:18446744072158181664  NOTICE: GL_VERSION = OpenGL ES 3.2 v1.r14p0-01rel0.2d12c056913f44cb69721b6d77c31aa9
22:43:28.356 T:18446744072158181664  NOTICE: GL_SHADING_LANGUAGE_VERSION = OpenGL ES GLSL ES 3.20
22:43:28.356 T:18446744072158181664  NOTICE: GL_EXTENSIONS = GL_EXT_debug_marker GL_ARM_rgba8 GL_ARM_mali_shader_binary GL_OES_depth24 GL_OES_depth_texture GL_OES_depth_texture_cube_map GL_OES_packed_depth_stencil GL_OES_rgb8_rgba8 GL_EXT_read_format_bgra GL_OES_compressed_paletted_texture GL_OES_compressed_ETC1_RGB8_texture GL_OES_standard_derivatives GL_OES_EGL_image GL_OES_EGL_image_external GL_OES_EGL_image_external_essl3 GL_OES_EGL_sync GL_OES_texture_npot GL_OES_vertex_half_float GL_OES_required_internalformat GL_OES_vertex_array_object GL_OES_mapbuffer GL_EXT_texture_format_BGRA8888 GL_EXT_texture_rg GL_EXT_texture_type_2_10_10_10_REV GL_OES_fbo_render_mipmap GL_OES_element_index_uint GL_EXT_shadow_samplers GL_OES_texture_compression_astc GL_KHR_texture_compression_astc_ldr GL_KHR_texture_compression_astc_hdr GL_KHR_texture_compression_astc_sliced_3d GL_KHR_debug GL_EXT_occlusion_query_boolean GL_EXT_disjoint_timer_query GL_EXT_blend_minmax GL_EXT_discard_framebuffer GL_OES_get_program_binary GL_OES_texture_3D GL_EXT_texture_storage GL_EXT_multisampled_render_to_texture GL_OES_surfaceless_context GL_OES_texture_stencil8 GL_EXT_shader_pixel_local_storage GL_ARM_shader_framebuffer_fetch GL_ARM_shader_framebuffer_fetch_depth_stencil GL_ARM_mali_program_binary GL_EXT_sRGB GL_EXT_sRGB_write_control GL_EXT_texture_sRGB_decode GL_KHR_blend_equation_advanced GL_KHR_blend_equation_advanced_coherent GL_OES_texture_storage_multisample_2d_array GL_OES_shader_image_atomic GL_EXT_robustness GL_EXT_draw_buffers_indexed GL_OES_draw_buffers_indexed GL_EXT_texture_border_clamp GL_OES_texture_border_clamp GL_EXT_texture_cube_map_array GL_OES_texture_cube_map_array GL_OES_sample_variables GL_OES_sample_shading GL_OES_shader_multisample_interpolation GL_EXT_shader_io_blocks GL_OES_shader_io_blocks GL_EXT_tessellation_shader GL_OES_tessellation_shader GL_EXT_primitive_bounding_box GL_OES_primitive_bounding_box GL_EXT_geometry_shader GL_OES_geometry_shader GL_ANDROID_extension_pack_es31a GL_EXT_gpu_shader5 GL_OES_gpu_shader5 GL_EXT_texture_buffer GL_OES_texture_buffer GL_EXT_copy_image GL_OES_copy_image GL_EXT_color_buffer_half_float GL_EXT_color_buffer_float GL_EXT_YUV_target GL_OVR_multiview GL_OVR_multiview2 GL_OVR_multiview_multisampled_render_to_texture GL_KHR_robustness GL_KHR_robust_buffer_access_behavior GL_EXT_draw_elements_base_vertex GL_OES_draw_elements_base_vertex
22:43:29.258 T:18446744071662209312  NOTICE: VideoInfoScanner: Starting scan ..
22:43:30.856 T:18446744071750637856  NOTICE: Trying to open: 44100 samplerate 12 channelMask 4 encoding
22:43:30.863 T:18446744071750637856  NOTICE: CAESinkAUDIOTRACK::Initializing with: m_sampleRate: 44100 format: AE_FMT_FLOAT (AE) method: PCM stream-type: PCM-STREAM min_buffer_size: 30208 m_frames: 1888 m_frameSize: 8 channels: 2
22:43:31.523 T:18446744071668508960  NOTICE: service.libraryautoupdate-1.0.2 : Update Library Service starting...
22:43:31.558 T:18446744071668508960  NOTICE: service.libraryautoupdate-1.0.2 : update timers
22:43:31.563 T:18446744071668508960  NOTICE: service.libraryautoupdate-1.0.2 : Creating timer for Video Library
22:43:31.629 T:18446744071668508960  NOTICE: service.libraryautoupdate-1.0.2 : Skipping scan, only run when idle
22:43:35.813 T:18446744071662209312  NOTICE: VideoInfoScanner: Finished scan. Scanning for video info took 00:06
22:43:35.833 T:18446744071668508960  NOTICE: service.libraryautoupdate-1.0.2 : Cleaning Database
22:43:35.966 T:18446744072158181664  NOTICE: CleanDatabase: Starting videodatabase cleanup ..
22:43:38.622 T:18446744072158181664  NOTICE: CleanDatabase: Cleaning videodatabase done. Operation took 00:02
22:43:52.736 T:18446744071663253792   ERROR: GetDirectory - Error getting
22:44:00.257 T:18446744071668508960   ERROR: Previous line repeats 2 times.
22:44:00.257 T:18446744071668508960  NOTICE: service.libraryautoupdate-1.0.2 : Skipping scan, only run when idle
22:45:04.739 T:18446744072333022516  NOTICE: Previous line repeats 1 times.
22:45:04.739 T:18446744072333022516  NOTICE: UnregisterRemovedDevices - device removed from joystick/android/inputdevice/10: SONY TV RC MIC 001 (054C:0BE8)
22:45:17.434 T:18446744072158181664  NOTICE: Samba is idle. Closing the remaining connections
22:46:00.291 T:18446744071668508960  NOTICE: service.libraryautoupdate-1.0.2 : Skipping scan, only run when idle
22:46:51.313 T:18446744072333022516 WARNING: CAndroidJoystickState: ignoring unknown axis 32 on input device "SONY TV RC MIC 001" with ID 11
22:46:51.511 T:18446744072333022516  NOTICE: Register - new joystick device registered on android->android/inputdevice/11: SONY TV RC MIC 001 (054C:0BE8)
22:47:00.315 T:18446744071668508960  NOTICE: service.libraryautoupdate-1.0.2 : Skipping scan, only run when idle
22:47:11.755 T:18446744072158181664  NOTICE: Log level changed to "LOG_LEVEL_DEBUG_FREEMEM"
22:47:11.756 T:18446744072158181664  NOTICE: Enabled debug logging due to GUI setting. Level 2.
22:47:11.756 T:18446744072158181664   DEBUG: Keyboard: scancode: 0x17, sym: 0x000d, unicode: 0x0000, modifier: 0x0
22:47:11.757 T:18446744072158181664   DEBUG: ------ Window Init () ------
22:47:22.624 T:18446744072158181664   DEBUG: Keyboard: scancode: 0x04, sym: 0x0008, unicode: 0x0000, modifier: 0x0
22:47:22.624 T:18446744072158181664   DEBUG: OnKey: backspace (0xf008) pressed, action is Back
22:47:22.640 T:18446744072158181664   DEBUG: CGUIWindowManager::PreviousWindow: Deactivate
22:47:22.939 T:18446744072158181664   DEBUG: ------ Window Deinit (SettingsCategory.xml) ------
22:47:22.941 T:18446744072158181664   DEBUG: CGUIWindowManager::PreviousWindow: Activate new
22:47:22.941 T:18446744072158181664   DEBUG: ------ Window Init (Custom_1100_AddonLauncher.xml) ------
22:47:22.965 T:18446744072158181664   DEBUG: Keyboard: scancode: 0x04, sym: 0x0008, unicode: 0x0000, modifier: 0x0
22:47:24.014 T:18446744072158181664   DEBUG: Keyboard: scancode: 0x13, sym: 0x0111, unicode: 0x0000, modifier: 0x0
22:47:24.014 T:18446744072158181664   DEBUG: OnKey: up (0xf080) pressed, action is Up
22:47:24.248 T:18446744072158181664   DEBUG: Keyboard: scancode: 0x13, sym: 0x0111, unicode: 0x0000, modifier: 0x0
22:47:25.155 T:18446744071663253792   DEBUG: Thread JobWorker 18446744071663253792 terminating (autodelete)
22:47:25.253 T:18446744071662209312   DEBUG: Thread JobWorker 18446744071662209312 terminating (autodelete)
22:47:25.262 T:18446744071752907040   DEBUG: Thread JobWorker 18446744071752907040 terminating (autodelete)
22:47:25.725 T:18446744072158181664   DEBUG: Keyboard: scancode: 0x04, sym: 0x0008, unicode: 0x0000, modifier: 0x0
22:47:25.725 T:18446744072158181664   DEBUG: OnKey: backspace (0xf008) pressed, action is Back
22:47:25.726 T:18446744072158181664   DEBUG: CGUIWindowManager::PreviousWindow: Deactivate
22:47:26.038 T:18446744072158181664   DEBUG: ------ Window Deinit (Custom_1100_AddonLauncher.xml) ------
22:47:26.040 T:18446744072158181664   DEBUG: CGUIWindowManager::PreviousWindow: Activate new
22:47:26.040 T:18446744072158181664   DEBUG: ------ Window Init (Home.xml) ------
22:47:26.054 T:18446744072158181664   DEBUG: CDirectoryProvider[addons://sources/video/]: refreshing..
22:47:26.054 T:18446744072158181664   DEBUG: CDirectoryProvider[addons://sources/audio/]: refreshing..
22:47:26.055 T:18446744071752907040   DEBUG: Thread JobWorker start, auto delete: true
22:47:26.055 T:18446744072158181664   DEBUG: CDirectoryProvider[addons://sources/executable/]: refreshing..
22:47:26.055 T:18446744072158181664   DEBUG: CDirectoryProvider[addons://sources/image/]: refreshing..
22:47:26.055 T:18446744071663253792   DEBUG: Thread JobWorker start, auto delete: true
22:47:26.085 T:18446744072158181664   DEBUG: Keyboard: scancode: 0x04, sym: 0x0008, unicode: 0x0000, modifier: 0x0
22:47:26.740 T:18446744072158181664   DEBUG: Keyboard: scancode: 0x13, sym: 0x0111, unicode: 0x0000, modifier: 0x0
22:47:26.741 T:18446744072158181664   DEBUG: OnKey: up (0xf080) pressed, action is Up
22:47:26.942 T:18446744072158181664   DEBUG: Keyboard: scancode: 0x13, sym: 0x0111, unicode: 0x0000, modifier: 0x0
22:47:27.039 T:18446744072158181664   DEBUG: Previous line repeats 1 times.
22:47:27.039 T:18446744072158181664   DEBUG: OnKey: up (0xf080) pressed, action is Up
22:47:27.261 T:18446744072158181664   DEBUG: Keyboard: scancode: 0x13, sym: 0x0111, unicode: 0x0000, modifier: 0x0
22:47:27.326 T:18446744072158181664   DEBUG: Previous line repeats 1 times.
22:47:27.328 T:18446744072158181664   DEBUG: OnKey: up (0xf080) pressed, action is Up
22:47:27.337 T:18446744071662209312   DEBUG: Thread JobWorker start, auto delete: true
22:47:27.361 T:18446744071752907040   DEBUG: Previous line repeats 1 times.
22:47:27.362 T:18446744071752907040   DEBUG: ffmpeg[8B5FF920]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra.
22:47:27.375 T:18446744071663253792   DEBUG: ffmpeg[8607F920]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra.
22:47:27.377 T:18446744071662209312   DEBUG: ffmpeg[85F80920]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra.
22:47:27.393 T:18446744071640779040   DEBUG: ffmpeg[84B10920]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra.
22:47:27.411 T:18446744071663253792   DEBUG: ffmpeg[8607F920]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra.
22:47:27.417 T:18446744071752907040   DEBUG: ffmpeg[8B5FF920]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra.
22:47:27.553 T:18446744072158181664   DEBUG: Keyboard: scancode: 0x13, sym: 0x0111, unicode: 0x0000, modifier: 0x0
22:47:27.859 T:18446744072158181664   DEBUG: Previous line repeats 1 times.
22:47:27.859 T:18446744072158181664   DEBUG: OnKey: up (0xf080) pressed, action is Up
22:47:28.075 T:18446744072158181664   DEBUG: Keyboard: scancode: 0x13, sym: 0x0111, unicode: 0x0000, modifier: 0x0
22:47:34.769 T:18446744072158181664   DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0
22:47:34.769 T:18446744072158181664   DEBUG: OnKey: down (0xf081) pressed, action is Down
22:47:35.008 T:18446744072158181664   DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0
22:47:35.492 T:18446744072158181664   DEBUG: Previous line repeats 1 times.
22:47:35.493 T:18446744072158181664   DEBUG: OnKey: down (0xf081) pressed, action is Down
22:47:35.716 T:18446744072158181664   DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0
22:47:37.562 T:18446744072158181664   DEBUG: Keyboard: scancode: 0x16, sym: 0x0113, unicode: 0x0000, modifier: 0x0
22:47:37.562 T:18446744072158181664   DEBUG: OnKey: right (0xf083) pressed, action is Right
22:47:37.829 T:18446744072158181664   DEBUG: Keyboard: scancode: 0x16, sym: 0x0113, unicode: 0x0000, modifier: 0x0
22:47:38.167 T:18446744072158181664   DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0
22:47:38.167 T:18446744072158181664   DEBUG: OnKey: down (0xf081) pressed, action is Down
22:47:38.296 T:18446744071662209312   DEBUG: ffmpeg[85F80920]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra.
22:47:38.315 T:18446744071662209312   DEBUG: DoWork - took 142 ms to load special://masterprofile/Thumbnails/6/64acf7aa.jpg
22:47:38.401 T:18446744072158181664   DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0
22:47:39.213 T:18446744072158181664   DEBUG: Keyboard: scancode: 0x17, sym: 0x000d, unicode: 0x0000, modifier: 0x0
22:47:39.478 T:18446744072158181664   DEBUG: OnKey: return (0xf00d) pressed, action is Select
22:47:39.479 T:18446744072158181664   DEBUG: Activating window ID: 10025
22:47:39.814 T:18446744072158181664   DEBUG: ------ Window Deinit (Home.xml) ------
22:47:39.868 T:18446744072158181664   DEBUG: ------ Window Init (MyVideoNav.xml) ------
22:47:39.869 T:18446744072158181664    INFO: Loading skin file: MyVideoNav.xml, load type: KEEP_IN_MEMORY
22:47:40.228 T:18446744072158181664   DEBUG: CDirectoryProvider[]: refreshing..
22:47:40.228 T:18446744071752907040   DEBUG: Previous line repeats 5 times.
22:47:40.228 T:18446744071752907040   ERROR: GetDirectory - Error getting
22:47:40.229 T:18446744072158181664   ERROR: Previous line repeats 1 times.
22:47:40.229 T:18446744072158181664   DEBUG: CDirectoryProvider[]: refreshing..
22:47:40.231 T:18446744071663253792   ERROR: GetDirectory - Error getting
22:47:40.232 T:18446744072158181664   ERROR: Previous line repeats 4 times.
22:47:40.233 T:18446744072158181664   DEBUG: CGUIMediaWindow::GetDirectory (videodb://inprogresstvshows/5/)
22:47:40.233 T:18446744072158181664   DEBUG:   ParentPath = [videodb://inprogresstvshows/5/]
22:47:40.262 T:18446744072158181664   DEBUG: RunQuery took 11 ms for 2 items query: SELECT * FROM season_view  WHERE season_view.idShow = 5
22:47:40.274 T:18446744072158181664   DEBUG: RunQuery took 10 ms for 0 items query: select * from movie_view join movielinktvshow on movielinktvshow.idMovie=movie_view.idMovie WHERE movielinktvshow.idShow = 5
22:47:40.300 T:18446744072158181664   DEBUG: WindowVideoNav::GetDirectory
22:47:40.347 T:18446744071627077920   DEBUG: Thread BackgroundLoader start, auto delete: false
22:47:40.380 T:18446744071627077920   DEBUG: Thread BackgroundLoader 18446744071627077920 terminating
22:47:40.401 T:18446744072158181664   DEBUG: Keyboard: scancode: 0x17, sym: 0x000d, unicode: 0x0000, modifier: 0x0
22:47:41.288 T:18446744072158181664   DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0
22:47:41.288 T:18446744072158181664   DEBUG: OnKey: down (0xf081) pressed, action is Down
22:47:41.495 T:18446744072158181664   DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0
22:47:41.656 T:18446744072158181664   DEBUG: Previous line repeats 1 times.
22:47:41.657 T:18446744072158181664   DEBUG: OnKey: down (0xf081) pressed, action is Down
22:47:41.690 T:18446744071662209312   DEBUG: ffmpeg[85F80920]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra.
22:47:41.875 T:18446744072158181664   DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0
22:47:42.231 T:18446744072158181664   DEBUG: Previous line repeats 1 times.
22:47:42.232 T:18446744072158181664   DEBUG: OnKey: down (0xf081) pressed, action is Down
22:47:42.273 T:18446744071663253792   DEBUG: ffmpeg[8607F920]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra.
22:47:42.449 T:18446744072158181664   DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0
22:47:42.977 T:18446744072158181664   DEBUG: Keyboard: scancode: 0x17, sym: 0x000d, unicode: 0x0000, modifier: 0x0
22:47:43.190 T:18446744072158181664   DEBUG: OnKey: return (0xf00d) pressed, action is Select
22:47:43.192 T:18446744072158181664   DEBUG: CGUIMediaWindow::GetDirectory (videodb://inprogresstvshows/5/12/?tvshowid=5)
22:47:43.193 T:18446744072158181664   DEBUG:   ParentPath = [videodb://inprogresstvshows/5/]
22:47:43.218 T:18446744071752907040   DEBUG: RunQuery took 7 ms for 7 items query: select * from episode_view  WHERE (episode_view.idShow = 5) AND ((episode_view.c12 = 12 or (episode_view.c12 = 0 and (episode_view.c15 = 0 or episode_view.c15 = 12))))
22:47:43.246 T:18446744072158181664   DEBUG: WindowVideoNav::GetDirectory
22:47:43.257 T:18446744071627077920   DEBUG: Thread BackgroundLoader start, auto delete: false
22:47:43.288 T:18446744072158181664   DEBUG: Keyboard: scancode: 0x17, sym: 0x000d, unicode: 0x0000, modifier: 0x0
22:47:43.307 T:18446744071627077920   DEBUG: Thread BackgroundLoader 18446744071627077920 terminating
22:47:44.387 T:18446744072158181664   DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0
22:47:44.388 T:18446744072158181664   DEBUG: OnKey: down (0xf081) pressed, action is Down
22:47:44.574 T:18446744072158181664   DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0
22:47:44.859 T:18446744072158181664   DEBUG: Keyboard: scancode: 0x17, sym: 0x000d, unicode: 0x0000, modifier: 0x0
22:47:45.078 T:18446744072158181664   DEBUG: OnKey: return (0xf00d) pressed, action is Select
22:47:45.103 T:18446744072158181664   DEBUG: OnPlayMedia smb://Diskstation/tvshows/The Big Bang Theory/Season 12/The.Big.Bang.Theory.S12E01.iNTERNAL.1080p.WEB.H264-METCON.mkv
22:47:45.104 T:18446744072157137184   DEBUG: CAnnouncementManager - Announcement: OnAdd from xbmc
22:47:45.104 T:18446744072157137184   DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnAdd
22:47:45.125 T:18446744072158181664   DEBUG: Loading settings for smb://Diskstation/tvshows/The Big Bang Theory/Season 12/The.Big.Bang.Theory.S12E01.iNTERNAL.1080p.WEB.H264-METCON.mkv
22:47:45.145 T:18446744072158181664   DEBUG: CPlayerCoreFactory::GetPlayers(smb://Diskstation/tvshows/The Big Bang Theory/Season 12/The.Big.Bang.Theory.S12E01.iNTERNAL.1080p.WEB.H264-METCON.mkv)
22:47:45.146 T:18446744072158181664   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules
22:47:45.147 T:18446744072158181664   DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules
22:47:45.147 T:18446744072158181664   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mms/udp
22:47:45.147 T:18446744072158181664   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout
22:47:45.147 T:18446744072158181664   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp
22:47:45.147 T:18446744072158181664   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp
22:47:45.147 T:18446744072158181664   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams
22:47:45.148 T:18446744072158181664   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd
22:47:45.148 T:18446744072158181664   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage
22:47:45.148 T:18446744072158181664   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf
22:47:45.148 T:18446744072158181664   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv
22:47:45.148 T:18446744072158181664   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio
22:47:45.148 T:18446744072158181664   DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players
22:47:45.148 T:18446744072158181664   DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (VideoPlayer)
22:47:45.148 T:18446744072158181664   DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0
22:47:45.149 T:18446744072158181664   DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1
22:47:45.149 T:18446744072158181664   DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players
22:47:45.158 T:18446744072158181664   DEBUG: Radio UECP (RDS) Processor - new CDVDRadioRDSData
22:47:45.160 T:18446744072158181664  NOTICE: VideoPlayer: Opening: smb://Diskstation/tvshows/The Big Bang Theory/Season 12/The.Big.Bang.Theory.S12E01.iNTERNAL.1080p.WEB.H264-METCON.mkv
22:47:45.160 T:18446744072158181664 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED
22:47:45.160 T:18446744072158181664   DEBUG: LinuxRendererGL: Cleaning up GL resources
22:47:45.160 T:18446744071627077920   DEBUG: Thread VideoPlayer start, auto delete: false
22:47:45.162 T:18446744071627077920  NOTICE: Creating InputStream
22:47:45.199 T:18446744071669553440   DEBUG: ### [TV Time] - onNotification
22:47:45.199 T:18446744071669553440   DEBUG: ### [TV Time] - method=Playlist.OnAdd
22:47:45.365 T:18446744071627077920   DEBUG: CSMBFile::Open - opened smb://Diskstation/tvshows/The Big Bang Theory/Season 12/The.Big.Bang.Theory.S12E01.iNTERNAL.1080p.WEB.H264-METCON.mkv, fd=10000
22:47:45.368 T:18446744071627077920   DEBUG: ScanForExternalSubtitles: Searching for subtitles...
22:47:45.381 T:18446744071627077920   DEBUG: ScanForExternalSubtitles: END (total time: 13 ms)
22:47:45.381 T:18446744071627077920  NOTICE: Creating Demuxer
22:47:45.432 T:18446744071627077920   DEBUG: Open - probing detected format [matroska,webm]
22:47:45.472 T:18446744071627077920   DEBUG: Open - avformat_find_stream_info starting
22:47:45.660 T:18446744072158181664   DEBUG: ------ Window Init (DialogBusy.xml) ------
22:47:46.298 T:18446744071627077920   DEBUG: Open - av_find_stream_info finished
22:47:46.299 T:18446744071627077920    INFO: ffmpeg[83DFF920]: Input #0, matroska,webm, smb://Diskstation/tvshows/The Big Bang Theory/Season 12/The.Big.Bang.Theory.S12E01.iNTERNAL.1080p.WEB.H264-METCON.mk':
22:47:46.299 T:18446744071627077920    INFO: ffmpeg[83DFF920]:   Metadata:
22:47:46.299 T:18446744071627077920    INFO: ffmpeg[83DFF920]:     encoder         : libebml v1.3.6 + libmatroska v1.4.9
22:47:46.299 T:18446744071627077920    INFO: ffmpeg[83DFF920]:     creation_time   : 2018-11-01 19:34:14
22:47:46.299 T:18446744071627077920    INFO: ffmpeg[83DFF920]:   Duration: 00:20:37.89, start: 0.000000, bitrate: 11674 kb/s
22:47:46.300 T:18446744071627077920    INFO: ffmpeg[83DFF920]:     Stream #0:0: Video: h264 (High), yuv420p(tv, bt709), 1920x1080 [SAR 1:1 DAR 16:9], 24 fps, 24 tbr, 1k tbn, 48 tbc (default)
22:47:46.300 T:18446744071627077920    INFO: ffmpeg[83DFF920]:     Metadata:
22:47:46.300 T:18446744071627077920    INFO: ffmpeg[83DFF920]:       BPS-eng         : 11032462
22:47:46.300 T:18446744071627077920    INFO: ffmpeg[83DFF920]:       DURATION-eng    : 00:20:37.834000000
22:47:46.300 T:18446744071627077920    INFO: ffmpeg[83DFF920]:       NUMBER_OF_FRAMES-eng: 29708
22:47:46.301 T:18446744071627077920    INFO: ffmpeg[83DFF920]:       NUMBER_OF_BYTES-eng: 1707044672
22:47:46.302 T:18446744071627077920    INFO: ffmpeg[83DFF920]:       _STATISTICS_WRITING_APP-eng: mkvmerge v26.0.0 ('In The Game') 64-bit
22:47:46.302 T:18446744071627077920    INFO: ffmpeg[83DFF920]:       _STATISTICS_WRITING_DATE_UTC-eng: 2018-11-01 19:34:14
22:47:46.302 T:18446744071627077920    INFO: ffmpeg[83DFF920]:       _STATISTICS_TAGS-eng: BPS DURATION NUMBER_OF_FRAMES NUMBER_OF_BYTES
22:47:46.303 T:18446744071627077920    INFO: ffmpeg[83DFF920]:     Stream #0:1(eng): Audio: eac3, 48000 Hz, 5.1(side), fltp, 640 kb/s (default)
22:47:46.303 T:18446744071627077920    INFO: ffmpeg[83DFF920]:     Metadata:
22:47:46.303 T:18446744071627077920    INFO: ffmpeg[83DFF920]:       BPS-eng         : 640000
22:47:46.303 T:18446744071627077920    INFO: ffmpeg[83DFF920]:       DURATION-eng    : 00:20:37.888000000
22:47:46.303 T:18446744071627077920    INFO: ffmpeg[83DFF920]:       NUMBER_OF_FRAMES-eng: 38684
22:47:46.304 T:18446744071627077920    INFO: ffmpeg[83DFF920]:       NUMBER_OF_BYTES-eng: 99031040
22:47:46.304 T:18446744071627077920    INFO: ffmpeg[83DFF920]:       _STATISTICS_WRITING_APP-eng: mkvmerge v26.0.0 ('In The Game') 64-bit
22:47:46.304 T:18446744071627077920    INFO: ffmpeg[83DFF920]:       _STATISTICS_WRITING_DATE_UTC-eng: 2018-11-01 19:34:14
22:47:46.304 T:18446744071627077920    INFO: ffmpeg[83DFF920]:       _STATISTICS_TAGS-eng: BPS DURATION NUMBER_OF_FRAMES NUMBER_OF_BYTES
22:47:46.304 T:18446744071627077920    INFO: ffmpeg[83DFF920]:     Stream #0:2(eng): Subtitle: subrip
22:47:46.304 T:18446744071627077920    INFO: ffmpeg[83DFF920]:     Metadata:
22:47:46.305 T:18446744071627077920    INFO: ffmpeg[83DFF920]:       title           : English SDH
22:47:46.305 T:18446744071627077920    INFO: ffmpeg[83DFF920]:       BPS-eng         : 93
22:47:46.305 T:18446744071627077920    INFO: ffmpeg[83DFF920]:       DURATION-eng    : 00:20:13.734000000
22:47:46.305 T:18446744071627077920    INFO: ffmpeg[83DFF920]:       NUMBER_OF_FRAMES-eng: 405
22:47:46.305 T:18446744071627077920    INFO: ffmpeg[83DFF920]:       NUMBER_OF_BYTES-eng: 14134
22:47:46.305 T:18446744071627077920    INFO: ffmpeg[83DFF920]:       _STATISTICS_WRITING_APP-eng: mkvmerge v26.0.0 ('In The Game') 64-bit
22:47:46.305 T:18446744071627077920    INFO: ffmpeg[83DFF920]:       _STATISTICS_WRITING_DATE_UTC-eng: 2018-11-01 19:34:14
22:47:46.306 T:18446744071627077920    INFO: ffmpeg[83DFF920]:       _STATISTICS_TAGS-eng: BPS DURATION NUMBER_OF_FRAMES NUMBER_OF_BYTES
22:47:46.306 T:18446744071627077920   DEBUG: CDVDDemuxFFmpeg::AddStream ID: 0
22:47:46.306 T:18446744071627077920   DEBUG: CDVDDemuxFFmpeg::AddStream ID: 1
22:47:46.306 T:18446744071627077920   DEBUG: CDVDDemuxFFmpeg::AddStream ID: 2
22:47:46.308 T:18446744071627077920  NOTICE: Opening stream: 0 source: 256
22:47:46.308 T:18446744071627077920  NOTICE: Creating video codec with codec id: 28
22:47:46.308 T:18446744071627077920   DEBUG: FactoryCodec - Video: mediacodec - Opening
22:47:46.309 T:18446744071627077920    INFO: CBitstreamConverter::Open bitstream to annexb init
22:47:46.707 T:18446744071627077920   DEBUG: CDVDVideoCodecAndroidMediaCodec::Open m_codecname(OMX.MTK.VIDEO.DECODER.AVC), colorFormat(2135033992)
22:47:46.707 T:18446744071627077920   DEBUG: CDVDVideoCodecAndroidMediaCodec::Open m_codecname(OMX.MTK.VIDEO.DECODER.AVC), colorFormat(259)
22:47:46.708 T:18446744071627077920   DEBUG: CDVDVideoCodecAndroidMediaCodec::Open m_codecname(OMX.MTK.VIDEO.DECODER.AVC), colorFormat(21)
22:47:46.708 T:18446744071627077920   DEBUG: CDVDVideoCodecAndroidMediaCodec::Open m_codecname(OMX.MTK.VIDEO.DECODER.AVC), colorFormat(258)
22:47:46.772 T:18446744071627077920   DEBUG: CDVDVideoCodecAndroidMediaCodec:: width(1920), height(1080), stride(0), slice-height(0), color-format(0)
22:47:46.773 T:18446744071627077920   DEBUG: CDVDVideoCodecAndroidMediaCodec:: crop-left(0), crop-top(0), crop-right(0), crop-bottom(0)
22:47:46.773 T:18446744071627077920   DEBUG: CDVDVideoCodecAndroidMediaCodec:: Multi-Surface Rendering
22:47:46.773 T:18446744071627077920    INFO: CDVDVideoCodecAndroidMediaCodec:: Open Android MediaCodec OMX.MTK.VIDEO.DECODER.AVC
22:47:46.773 T:18446744071627077920   DEBUG: FactoryCodec - Video: amc-h264 - Opened
22:47:46.773 T:18446744071627077920   DEBUG: CVideoPlayerVideo::OpenStream - open stream with codec id: 28
22:47:46.773 T:18446744071627077920  NOTICE: Creating video thread
22:47:46.774 T:18446744071627077920  NOTICE: Opening stream: 1 source: 256
22:47:46.774 T:2136512800   DEBUG: Thread VideoPlayerVideo start, auto delete: false
22:47:46.774 T:18446744071627077920  NOTICE: Finding audio codec for: 86057
22:47:46.774 T:2136512800  NOTICE: running thread: video_thread
22:47:46.774 T:18446744071627077920   DEBUG: FactoryCodec - Audio: passthrough - Opening
22:47:46.775 T:18446744071627077920   DEBUG: FactoryCodec - Audio: passthrough - Opened
22:47:46.775 T:18446744071627077920  NOTICE: Creating audio thread
22:47:46.776 T:18446744071627077920  NOTICE: Opening stream: 2 source: 256
22:47:46.776 T:2134374688   DEBUG: Thread VideoPlayerAudio start, auto delete: false
22:47:46.776 T:18446744071627077920   DEBUG: FactoryCodec - Overlay: Text Subtitle Decoder - Opening
22:47:46.776 T:2134374688  NOTICE: running thread: CVideoPlayerAudio::Process()
22:47:46.776 T:18446744071627077920   DEBUG: FactoryCodec - Overlay: Text Subtitle Decoder - Opened
22:47:46.777 T:18446744071627077920   DEBUG: ReadEditDecisionLists - Checking for edit decision lists (EDL) on local drive or remote share for: smb://Diskstation/tvshows/The Big Bang Theory/Season 12/The.Big.Bang.Theory.S12E01.iNTERNAL.1080p.WEB.H264-METCON.mkv
22:47:46.778 T:18446744071627077920   DEBUG: OnPlayBackStarted: play state was 1, starting 1
22:47:46.778 T:18446744071627077920   DEBUG: CVideoPlayer::SetCaching - caching state 2
22:47:46.778 T:18446744071627077920   DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000
22:47:46.779 T:2136512800    INFO: CVideoPlayerVideo - Stillframe left, switching to normal playback
22:47:46.780 T:2136512800   DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0
22:47:46.780 T:2136512800   DEBUG: CDVDVideoCodecAndroidMediaCodec::virtual void CDVDVideoCodecAndroidMediaCodec::SetCodecControl(int) 0->4000000
22:47:46.781 T:2136512800   DEBUG: CDVDVideoCodecAndroidMediaCodec::Decode current state (2)
22:47:46.784 T:18446744072158181664   DEBUG: PlayFile: OpenFile succeed, play state 2
22:47:46.784 T:18446744072158181664   DEBUG: OnPlayBackStarted: play state was 2, starting 0
22:47:46.786 T:2134374688   DEBUG: CDVDAudio::Pause - pausing audio stream
22:47:46.787 T:2134374688    INFO: CAEStreamParser::SyncAC3 - E-AC3 stream detected (6 channels, 48000Hz)
22:47:46.787 T:2134374688  NOTICE: Creating audio stream (codec id: 86057, channels: 6, sample rate: 48000, pass-through)
22:47:46.788 T:2134374688   DEBUG: CVideoPlayerAudio:: synctype set to 0: clock feedback
22:47:46.789 T:18446744071750637856    INFO: CActiveAESink::OpenSink - initialize sink
22:47:46.789 T:18446744071750637856   DEBUG: CActiveAESink::OpenSink - trying to open device AUDIOTRACK:AudioTrack
22:47:46.790 T:18446744071750637856   DEBUG: CAESinkAUDIOTRACK::Initialize requested: sampleRate 48000; format: AE_FMT_RAW; channels: 6
22:47:46.790 T:18446744071750637856   DEBUG: Updated SampleRate: 32000 Distance: 144000
22:47:46.790 T:18446744071750637856   DEBUG: Updated SampleRate: 44100 Distance: 35100
22:47:46.790 T:18446744071750637856   DEBUG: Updated SampleRate: 48000 Distance: 0
22:47:46.790 T:18446744071750637856  NOTICE: Trying to open: 48000 samplerate 12 channelMask 6 encoding
22:47:46.792 T:18446744071750637856   DEBUG: Minimum size we need for stream: 2052
22:47:46.793 T:18446744071750637856   DEBUG: Opening Passthrough RAW Format: STREAM_TYPE_EAC3 Sink SampleRate: 48000
22:47:46.793 T:18446744071750637856   DEBUG: Created Audiotrackbuffer with playing time of 128.000000 ms min buffer size: 10752 bytes
22:47:46.799 T:2136512800   DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0
22:47:46.809 T:18446744072158181664   DEBUG: Keyboard: scancode: 0x17, sym: 0x000d, unicode: 0x0000, modifier: 0x0
22:47:46.812 T:2136512800   DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0
22:47:46.822 T:18446744071750637856  NOTICE: CAESinkAUDIOTRACK::Initializing with: m_sampleRate: 48000 format: AE_FMT_RAW (AE) method: RAW (PT) stream-type: STREAM_TYPE_EAC3 min_buffer_size: 10752 m_frames: 10752 m_frameSize: 1 channels: 2
22:47:46.823 T:18446744071750637856   DEBUG: CActiveAESink::OpenSink - AUDIOTRACK Initialized:
22:47:46.823 T:18446744071750637856   DEBUG:   Output Device : android
22:47:46.823 T:18446744071750637856   DEBUG:   Sample Rate   : 48000
22:47:46.824 T:18446744071750637856   DEBUG:   Sample Format : AE_FMT_RAW
22:47:46.824 T:18446744071750637856   DEBUG:   Channel Count : 2
22:47:46.824 T:18446744071750637856   DEBUG:   Channel Layout: FL,FR
22:47:46.824 T:18446744071750637856   DEBUG:   Frames        : 10752
22:47:46.824 T:18446744071750637856   DEBUG:   Frame Size    : 1
22:47:46.824 T:2136512800   DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0
22:47:46.831 T:18446744071751682336   DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted
22:47:46.834 T:18446744071627077920   DEBUG: Previous line repeats 1 times.
22:47:46.835 T:18446744071627077920   DEBUG: CVideoPlayer::HandleMessages - player started 1
22:47:46.837 T:2136512800   DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0
22:47:46.838 T:18446744071663253792   DEBUG: CGUIInfoManager::SetCurrentMovie(smb://Diskstation/tvshows/The Big Bang Theory/Season 12/The.Big.Bang.Theory.S12E01.iNTERNAL.1080p.WEB.H264-METCON.mkv)
22:47:46.841 T:18446744072157137184   DEBUG: CAnnouncementManager - Announcement: OnPlay from xbmc
22:47:46.841 T:18446744072157137184   DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPlay
22:47:46.852 T:2136512800   DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0
22:47:46.867 T:18446744071663253792   DEBUG: Previous line repeats 1 times.
22:47:46.867 T:18446744071663253792   DEBUG: GetMovieId (smb://Diskstation/tvshows/The Big Bang Theory/Season 12/The.Big.Bang.Theory.S12E01.iNTERNAL.1080p.WEB.H264-METCON.mkv), query = select idMovie from movie where idFile=127
22:47:46.872 T:2136512800   DEBUG: CDVDVideoCodecAndroidMediaCodec:: width(1920), height(1080), stride(1920), slice-height(1080), color-format(259)
22:47:46.874 T:2136512800   DEBUG: CDVDVideoCodecAndroidMediaCodec:: crop-left(0), crop-top(0), crop-right(1919), crop-bottom(1079)
22:47:46.874 T:2136512800   DEBUG: CDVDVideoCodecAndroidMediaCodec:: Multi-Surface Rendering
22:47:46.875 T:2136512800   DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0
22:47:46.878 T:18446744071663253792   DEBUG: GetEpisodeId (smb://Diskstation/tvshows/The Big Bang Theory/Season 12/The.Big.Bang.Theory.S12E01.iNTERNAL.1080p.WEB.H264-METCON.mkv), query = select idEpisode from episode where idFile=127
22:47:46.880 T:2136512800   DEBUG: CRenderManager::Configure - change configuration. 1920x1080. display: 1920x1080. framerate: 24.00. format: MEDIACODECSURFACE
22:47:46.904 T:18446744071669553440   DEBUG: ### [TV Time] - onNotification
22:47:46.905 T:18446744071669553440   DEBUG: ### [TV Time] - method=Player.OnPlay
22:47:46.907 T:2128120096   DEBUG: ### [TV Time] - Inside Player. Tracker time = 0.12800000608
22:47:46.907 T:18446744071669553440   DEBUG: ### [TV Time] - Player.OnPlay
22:47:46.908 T:18446744071669553440   DEBUG: ### [TV Time] - {u'item': {u'type': u'episode', u'id': 69}, u'player': {u'playerid': 1, u'speed': 1}}
22:47:46.910 T:18446744072158181664   DEBUG: DeleteRenderer - deleting renderer
22:47:46.916 T:18446744072158181664   DEBUG: LinuxRendererGL: Cleaning up GL resources
22:47:46.916 T:18446744072158181664   DEBUG: Previous line repeats 1 times.
22:47:46.919 T:18446744072158181664  NOTICE: Using GL_TEXTURE_2D
22:47:46.920 T:18446744072158181664  NOTICE: GL: Using MediaCodec (Surface) render method
22:47:46.921 T:18446744072158181664  NOTICE: GL: NPOT texture support detected
22:47:46.922 T:18446744072158181664   DEBUG: CLinuxRendererGLES: Reorder drawpoints due to method change from 1 to 2048
22:47:46.922 T:18446744072158181664   DEBUG: CRenderManager::Configure - 3
22:47:46.925 T:18446744071627077920   DEBUG: CVideoPlayer::HandleMessages - player started 2
22:47:46.926 T:18446744071627077920   DEBUG: CVideoPlayer::SetCaching - caching state 3
22:47:46.927 T:18446744071627077920   DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000
22:47:46.927 T:18446744071627077920   DEBUG: CVideoPlayer::SetCaching - caching state 0
22:47:46.927 T:18446744071627077920   DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000
22:47:46.928 T:18446744071627077920   DEBUG: VideoPlayer::Sync - Audio - pts: 96000.000000, cache: 287631.386325, totalcache: 527999.997139
22:47:46.928 T:18446744072158181664   DEBUG: RenderUpdate: Dest - 0.000000+0.000000-1920.000000x1080.000000
22:47:46.928 T:18446744071627077920   DEBUG: VideoPlayer::Sync - Video - pts: 0.000000, cache: 50000.000000, totalcache: 100000.000000
22:47:46.928 T:18446744072158181664   DEBUG: RenderUpdate: Adj  - 0.000000+0.000000-1920.000000x1080.000000
22:47:46.928 T:2134374688   DEBUG: CVideoPlayerAudio - CDVDMsg::GENERAL_RESYNC(-191631.386325)
22:47:46.928 T:2134374688   DEBUG: CDVDAudio::Resume - resume audio stream
22:47:46.929 T:2136512800   DEBUG: CVideoPlayerVideo - CDVDMsg::GENERAL_RESYNC(-191631.386325)
22:47:46.929 T:18446744071751682336   DEBUG: ActiveAE - start sync of audio stream
22:47:46.929 T:2136512800   DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0
22:47:46.931 T:2136512800   DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 1
22:47:46.933 T:2136512800   DEBUG: CDVDVideoCodecAndroidMediaCodec::virtual void CDVDVideoCodecAndroidMediaCodec::SetCodecControl(int) 4000000->0
22:47:46.950 T:18446744072158181664   DEBUG: Activating window ID: 12005
22:47:46.953 T:18446744072158181664   DEBUG: ------ Window Deinit (MyVideoNav.xml) ------
22:47:46.955 T:18446744072158181664   DEBUG: ------ Window Init (VideoFullScreen.xml) ------
22:47:46.955 T:18446744072158181664    INFO: Loading skin file: VideoFullScreen.xml, load type: KEEP_IN_MEMORY
22:47:46.996 T:18446744071669553440   DEBUG: ### [TV Time] - result={u'jsonrpc': u'2.0', u'id': 1, u'result': {u'episodedetails': {u'tvshowid': 5, u'episode': 1, u'season': 12, u'episodeid': 69, u'label': u'The Conjugal Configuration', u'uniqueid': {u'unknown': u''}, u'showtitle': u'The Big Bang Theory'}}}
22:47:46.997 T:18446744071669553440   DEBUG: ### [TV Time] - episode_id=
22:47:46.997 T:18446744071669553440   DEBUG: ### [TV Time] - showtitle=The Big Bang Theory
22:47:46.998 T:18446744071669553440   DEBUG: ### [TV Time] - season=12
22:47:46.998 T:18446744071669553440   DEBUG: ### [TV Time] - episode=1
22:47:46.998 T:18446744071669553440   DEBUG: ### [TV Time] - episode_id=
22:47:47.004 T:18446744071669553440   DEBUG: ### [TV Time] - tvshowtitle=The.Big.Bang.Theory.S12E01
22:47:47.033 T:18446744071751682336   DEBUG: ActiveAE::SyncStream - average error of 45.861580, start adjusting
22:47:47.033 T:18446744071751682336   DEBUG: ActiveAE::SyncStream - average error 13.861580 below threshold of 30.000000
22:47:47.037 T:18446744072158181664   DEBUG: ------ Window Deinit (DialogBusy.xml) ------
22:47:47.159 T:2128120096   DEBUG: ### [TV Time] - Inside Player. Tracker time = 0.0360000021756
22:47:47.359 T:2136512800   DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 1
22:47:47.359 T:2136512800   DEBUG: CDVDVideoCodecAndroidMediaCodec::virtual void CDVDVideoCodecAndroidMediaCodec::SetCodecControl(int) 0->4000000
22:47:47.371 T:2136512800   DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 1
22:47:47.397 T:2136512800   DEBUG: Previous line repeats 2 times.
22:47:47.400 T:2136512800   DEBUG: CDVDVideoCodecAndroidMediaCodec::virtual void CDVDVideoCodecAndroidMediaCodec::SetCodecControl(int) 4000000->0
22:47:47.409 T:2128120096   DEBUG: ### [TV Time] - Inside Player. Tracker time = 0.28900000453
22:47:47.437 T:18446744071669553440   DEBUG: ### [TV Time] - episode.is_found=False
22:47:47.441 T:18446744072158181664   DEBUG: ------ Window Init (DialogNotification.xml) ------
22:47:47.661 T:2128120096   DEBUG: ### [TV Time] - Inside Player. Tracker time = 0.540000021458
22:47:47.736 T:2136512800   DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 1
22:47:47.736 T:2136512800   DEBUG: CDVDVideoCodecAndroidMediaCodec::virtual void CDVDVideoCodecAndroidMediaCodec::SetCodecControl(int) 0->4000000
22:47:47.748 T:2136512800   DEBUG: CDVDVideoCodecAndroidMediaCodec::virtual void CDVDVideoCodecAndroidMediaCodec::SetCodecControl(int) 4000000->0
22:47:47.829 T:18446744071670597920   DEBUG: GetMovieId (smb://Diskstation/tvshows/The Big Bang Theory/Season 12/The.Big.Bang.Theory.S12E01.iNTERNAL.1080p.WEB.H264-METCON.mkv), query = select idMovie from movie where idFile=127
22:47:47.832 T:18446744071670597920   DEBUG: GetEpisodeId (smb://Diskstation/tvshows/The Big Bang Theory/Season 12/The.Big.Bang.Theory.S12E01.iNTERNAL.1080p.WEB.H264-METCON.mkv), query = select idEpisode from episode where idFile=127
22:47:47.912 T:2128120096   DEBUG: ### [TV Time] - Inside Player. Tracker time = 0.790000021458
22:47:48.001 T:18446744071670597920   DEBUG: RunQuery took 11 ms for 7 items query: select * from episode_view  WHERE (episode_view.idShow = 5) AND ((episode_view.c12 = 12 or (episode_view.c12 = 0 and (episode_view.c15 = 0 or episode_view.c15 = 12))))
22:47:48.001 T:18446744071670597920   DEBUG: DatabaseUtils::GetSortFieldList: unknown field 30
22:47:48.068 T:18446744071751682336   DEBUG: ActiveAE::SyncStream - average error -164.734875 above threshold of 100.000000
22:47:48.165 T:2128120096   DEBUG: ### [TV Time] - Inside Player. Tracker time = 1.04400002956
22:47:48.174 T:18446744071751682336   DEBUG: ActiveAE::SyncStream - average error -4.734875 below threshold of 30.000000
22:47:48.416 T:2128120096   DEBUG: ### [TV Time] - Inside Player. Tracker time = 1.29500007629
22:47:48.666 T:2128120096   DEBUG: ### [TV Time] - Inside Player. Tracker time = 1.54600012302
22:47:48.917 T:2128120096   DEBUG: ### [TV Time] - Inside Player. Tracker time = 1.79600012302
22:47:48.977 T:2136512800   DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 1
22:47:48.977 T:2136512800   DEBUG: CDVDVideoCodecAndroidMediaCodec::virtual void CDVDVideoCodecAndroidMediaCodec::SetCodecControl(int) 0->4000000
22:47:48.988 T:2136512800   DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 1
22:47:49.059 T:2136512800   DEBUG: CDVDVideoCodecAndroidMediaCodec::virtual void CDVDVideoCodecAndroidMediaCodec::SetCodecControl(int) 4000000->0
22:47:49.168 T:2128120096   DEBUG: ### [TV Time] - Inside Player. Tracker time = 2.04700016975
22:47:49.217 T:18446744071751682336   DEBUG: ActiveAE::SyncStream - average error -182.779819 above threshold of 100.000000
22:47:49.331 T:18446744071751682336   DEBUG: ActiveAE::SyncStream - average error -22.779819 below threshold of 30.000000
22:47:49.419 T:2128120096   DEBUG: ### [TV Time] - Inside Player. Tracker time = 2.2990000248
22:47:49.672 T:2128120096   DEBUG: ### [TV Time] - Inside Player. Tracker time = 2.55100011826
22:47:49.923 T:2128120096   DEBUG: ### [TV Time] - Inside Player. Tracker time = 2.80200004578
22:47:50.174 T:2128120096   DEBUG: ### [TV Time] - Inside Player. Tracker time = 3.05300021172
22:47:50.382 T:2134374688   DEBUG: CDVDClock::ErrorAdjust - CVideoPlayerAudio::OutputPacket - error:-23044.019864, adjusted:-23044.019864
22:47:50.424 T:2128120096   DEBUG: ### [TV Time] - Inside Player. Tracker time = 3.30300021172
22:47:50.575 T:18446744072158181664   DEBUG: Keyboard: scancode: 0x17, sym: 0x000d, unicode: 0x0000, modifier: 0x0
22:47:50.676 T:2128120096   DEBUG: ### [TV Time] - Inside Player. Tracker time = 3.53300023079
22:47:50.842 T:18446744072158181664   DEBUG: OnKey: return (0xf00d) pressed, action is OSD
22:47:50.842 T:18446744072158181664   DEBUG: ------ Window Init (VideoOSD.xml) ------
22:47:50.842 T:18446744072158181664    INFO: Loading skin file: VideoOSD.xml, load type: KEEP_IN_MEMORY
22:47:50.887 T:18446744072158181664   DEBUG: ------ Window Init (DialogSeekBar.xml) ------
22:47:50.891 T:18446744072158181664   DEBUG: ------ Window Init (Custom_1109_TopBarOverlay.xml) ------
22:47:50.891 T:18446744072158181664    INFO: Loading skin file: Custom_1109_TopBarOverlay.xml, load type: KEEP_IN_MEMORY
22:47:50.926 T:2128120096   DEBUG: ### [TV Time] - Inside Player. Tracker time = 3.78300023079
22:47:51.176 T:2128120096   DEBUG: ### [TV Time] - Inside Player. Tracker time = 4.03299999237
22:47:51.428 T:2128120096   DEBUG: ### [TV Time] - Inside Player. Tracker time = 4.28400039673
22:47:51.436 T:2134374688   DEBUG: CDVDClock::ErrorAdjust - CVideoPlayerAudio::OutputPacket - error:-33055.540608, adjusted:-33055.540608
22:47:51.678 T:2128120096   DEBUG: ### [TV Time] - Inside Player. Tracker time = 4.50200033188
22:47:51.930 T:2128120096   DEBUG: ### [TV Time] - Inside Player. Tracker time = 4.7530002594
22:47:52.040 T:2136512800   DEBUG: CPullupCorrection: detected pattern of length 1: 41666.67, frameduration: 41666.666667
22:47:52.083 T:18446744072158181664   DEBUG: Keyboard: scancode: 0x16, sym: 0x0113, unicode: 0x0000, modifier: 0x0
22:47:52.084 T:18446744072158181664   DEBUG: OnKey: right (0xf083) pressed, action is Right
22:47:52.181 T:2128120096   DEBUG: ### [TV Time] - Inside Player. Tracker time = 5.00400018692
22:47:52.295 T:18446744072158181664   DEBUG: Keyboard: scancode: 0x16, sym: 0x0113, unicode: 0x0000, modifier: 0x0
22:47:52.434 T:2128120096   DEBUG: ### [TV Time] - Inside Player. Tracker time = 5.25800037384
22:47:52.479 T:18446744072158181664   DEBUG: Keyboard: scancode: 0x17, sym: 0x000d, unicode: 0x0000, modifier: 0x0
22:47:52.685 T:2128120096   DEBUG: ### [TV Time] - Inside Player. Tracker time = 5.50900030136
22:47:52.698 T:18446744072158181664   DEBUG: OnKey: return (0xf00d) pressed, action is Select
22:47:52.702 T:18446744072158181664  NOTICE: CVideoPlayer::CloseFile()
22:47:52.702 T:18446744072158181664  NOTICE: VideoPlayer: waiting for threads to exit
22:47:52.705 T:18446744071627077920  NOTICE: CVideoPlayer::OnExit()
22:47:52.707 T:18446744071627077920  NOTICE: Closing stream player 1
22:47:52.709 T:18446744071627077920  NOTICE: Waiting for audio thread to exit
22:47:52.773 T:2134374688  NOTICE: thread end: CVideoPlayerAudio::OnExit()
22:47:52.773 T:2134374688   DEBUG: Thread VideoPlayerAudio 2134374688 terminating
22:47:52.773 T:18446744071627077920  NOTICE: Closing audio device
22:47:52.781 T:18446744071627077920   DEBUG: CDVDAudio::Flush - flush audio stream
22:47:52.781 T:18446744071751682336   DEBUG: CActiveAE::DiscardStream - audio stream deleted
22:47:52.781 T:18446744071751682336   DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted
22:47:52.783 T:18446744071627077920   DEBUG: Previous line repeats 2 times.
22:47:52.783 T:18446744071627077920  NOTICE: Deleting audio codec
22:47:52.783 T:18446744071627077920  NOTICE: Closing stream player 2
22:47:52.783 T:18446744071627077920  NOTICE: waiting for video thread to exit
22:47:52.783 T:18446744071750637856    INFO: CActiveAESink::OpenSink - initialize sink
22:47:52.784 T:18446744071750637856   DEBUG: Draining Audio
22:47:52.786 T:18446744071750637856   DEBUG: CActiveAESink::OpenSink - trying to open device AUDIOTRACK:AudioTrack
22:47:52.786 T:18446744071750637856   DEBUG: CAESinkAUDIOTRACK::Initialize requested: sampleRate 44100; format: AE_FMT_FLOAT; channels: 2
22:47:52.786 T:18446744071750637856   DEBUG: Updated SampleRate: 32000 Distance: 108900
22:47:52.787 T:18446744071750637856   DEBUG: Updated SampleRate: 44100 Distance: 0
22:47:52.787 T:18446744071750637856  NOTICE: Trying to open: 44100 samplerate 12 channelMask 4 encoding
22:47:52.788 T:18446744071750637856   DEBUG: Minimum size we need for stream: 15104
22:47:52.788 T:18446744071750637856   DEBUG: Created Audiotrackbuffer with playing time of 85.623583 ms min buffer size: 30208 bytes
22:47:52.793 T:2136512800  NOTICE: thread end: video_thread
22:47:52.793 T:2136512800   DEBUG: Thread VideoPlayerVideo 2136512800 terminating
22:47:52.793 T:18446744071750637856  NOTICE: CAESinkAUDIOTRACK::Initializing with: m_sampleRate: 44100 format: AE_FMT_FLOAT (AE) method: PCM stream-type: PCM-STREAM min_buffer_size: 30208 m_frames: 1888 m_frameSize: 8 channels: 2
22:47:52.794 T:18446744071750637856   DEBUG: CActiveAESink::OpenSink - AUDIOTRACK Initialized:
22:47:52.794 T:18446744071750637856   DEBUG:   Output Device : android
22:47:52.794 T:18446744071750637856   DEBUG:   Sample Rate   : 44100
22:47:52.794 T:18446744071750637856   DEBUG:   Sample Format : AE_FMT_FLOAT
22:47:52.794 T:18446744071750637856   DEBUG:   Channel Count : 2
22:47:52.795 T:18446744071750637856   DEBUG:   Channel Layout: FL,FR
22:47:52.795 T:18446744071750637856   DEBUG:   Frames        : 1888
22:47:52.795 T:18446744071627077920  NOTICE: deleting video codec
22:47:52.795 T:18446744071750637856   DEBUG:   Frame Size    : 8
22:47:52.798 T:18446744071751682336   DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted
22:47:52.874 T:18446744071627077920   DEBUG: Previous line repeats 1 times.
22:47:52.874 T:18446744071627077920  NOTICE: Closing stream player 3
22:47:52.875 T:18446744071627077920   DEBUG: CSMBFile::Close closing fd 10000
22:47:52.894 T:18446744071627077920   DEBUG: OnPlayBackStopped: play state was 2, starting 0
22:47:52.904 T:18446744071627077920   DEBUG: Thread VideoPlayer 18446744071627077920 terminating
22:47:52.906 T:18446744072157137184   DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc
22:47:52.906 T:18446744072157137184   DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop
22:47:52.908 T:18446744072158181664  NOTICE: VideoPlayer: finished waiting
22:47:52.908 T:18446744072158181664   DEBUG: DeleteRenderer - deleting renderer
22:47:52.908 T:18446744072158181664   DEBUG: LinuxRendererGL: Cleaning up GL resources
22:47:52.908 T:18446744072158181664   DEBUG: CGUIWindowManager::PreviousWindow: Deactivate
22:47:52.909 T:18446744072158181664   DEBUG: ------ Window Deinit (VideoOSD.xml) ------
22:47:52.909 T:18446744072158181664   DEBUG: ------ Window Deinit (VideoFullScreen.xml) ------
22:47:52.928 T:18446744072158181664   DEBUG: CGUIWindowManager::PreviousWindow: Activate new
22:47:52.946 T:2128120096   ERROR: EXCEPTION: XBMC is not playing any media file
22:47:52.947 T:2128120096   DEBUG: ### [TV Time] - Inside Player. Tracker time = 5.50900030136
22:47:52.951 T:18446744072158181664   DEBUG: ------ Window Init (MyVideoNav.xml) ------
22:47:52.955 T:18446744071669553440   DEBUG: ### [TV Time] - onNotification
22:47:52.956 T:18446744072158181664   DEBUG: CGUIMediaWindow::GetDirectory (videodb://inprogresstvshows/5/12/?tvshowid=5)
22:47:52.956 T:18446744071669553440   DEBUG: ### [TV Time] - method=Player.OnStop
22:47:52.956 T:18446744072158181664   DEBUG:   ParentPath = [videodb://inprogresstvshows/5/12/?tvshowid=5]
22:47:52.987 T:18446744072158181664   DEBUG: RunQuery took 8 ms for 7 items query: select * from episode_view  WHERE (episode_view.idShow = 5) AND ((episode_view.c12 = 12 or (episode_view.c12 = 0 and (episode_view.c15 = 0 or episode_view.c15 = 12))))
22:47:53.015 T:18446744072158181664   DEBUG: WindowVideoNav::GetDirectory
22:47:53.029 T:18446744071627077920   DEBUG: Thread BackgroundLoader start, auto delete: false
22:47:53.072 T:18446744072158181664   DEBUG: Keyboard: scancode: 0x17, sym: 0x000d, unicode: 0x0000, modifier: 0x0
22:47:53.101 T:18446744071627077920   DEBUG: Thread BackgroundLoader 18446744071627077920 terminating
22:47:53.198 T:2128120096   DEBUG: ### [TV Time] - Position tracker ending with last_pos = 5.50900030136
22:47:53.200 T:18446744071669553440   DEBUG: ### [TV Time] - last_pos / total_time : 5.50900030136 / 1237.88806152 = 0.445032186075 %
22:47:53.200 T:18446744071669553440   DEBUG: ### [TV Time] - Player.OnStop
22:47:53.201 T:18446744071669553440   DEBUG: ### [TV Time] - {u'item': {u'type': u'episode', u'id': 69}, u'end': False}
22:47:53.263 T:18446744071669553440   DEBUG: ### [TV Time] - result={u'jsonrpc': u'2.0', u'id': 1, u'result': {u'episodedetails': {u'tvshowid': 5, u'episode': 1, u'season': 12, u'episodeid': 69, u'label': u'The Conjugal Configuration', u'uniqueid': {u'unknown': u''}, u'showtitle': u'The Big Bang Theory'}}}
22:47:53.264 T:18446744071669553440   DEBUG: ### [TV Time] - episode_id=
22:47:53.265 T:18446744071669553440   DEBUG: ### [TV Time] - showtitle=The Big Bang Theory
22:47:53.265 T:18446744071669553440   DEBUG: ### [TV Time] - season=12
22:47:53.265 T:18446744071669553440   DEBUG: ### [TV Time] - episode=1
22:47:53.265 T:18446744071669553440   DEBUG: ### [TV Time] - episode_id=
22:47:53.266 T:18446744071669553440   DEBUG: ### [TV Time] - tvshowtitle=The.Big.Bang.Theory.S12E01
22:47:53.266 T:18446744071669553440   DEBUG: ### [TV Time] - progress=5.50900030136
22:47:53.657 T:18446744072158181664   DEBUG: Keyboard: scancode: 0x17, sym: 0x000d, unicode: 0x0000, modifier: 0x0
22:47:53.659 T:18446744071669553440   DEBUG: ### [TV Time] - progress.is_set:=False
22:47:53.673 T:18446744072158181664   DEBUG: ------ Window Deinit (DialogSeekBar.xml) ------
22:47:53.674 T:18446744072158181664   DEBUG: ------ Window Deinit (Custom_1109_TopBarOverlay.xml) ------
22:47:53.678 T:18446744072158181664  NOTICE: CVideoPlayer::CloseFile()
22:47:53.679 T:18446744072158181664  NOTICE: VideoPlayer: waiting for threads to exit
22:47:53.679 T:18446744072158181664  NOTICE: VideoPlayer: finished waiting
22:47:53.682 T:18446744072158181664  NOTICE: CVideoPlayer::CloseFile()
22:47:53.684 T:18446744072158181664  NOTICE: VideoPlayer: waiting for threads to exit
22:47:53.684 T:18446744072158181664  NOTICE: VideoPlayer: finished waiting
22:47:53.686 T:18446744072158181664   DEBUG: Radio UECP (RDS) Processor - delete ~CDVDRadioRDSData
22:47:53.689 T:18446744071640779040   DEBUG: DoWork - Saving file state for video item smb://Diskstation/tvshows/The Big Bang Theory/Season 12/The.Big.Bang.Theory.S12E01.iNTERNAL.1080p.WEB.H264-METCON.mkv
22:47:53.718 T:18446744071752907040   DEBUG: ffmpeg[8B5FF920]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra.
22:47:53.743 T:18446744071752907040   DEBUG: DoWork - took 139 ms to load special://masterprofile/Thumbnails/6/64acf7aa.jpg
22:47:53.750 T:18446744072157137184   DEBUG: CAnnouncementManager - Announcement: OnUpdate from xbmc
22:47:53.750 T:18446744072157137184   DEBUG: GOT ANNOUNCEMENT, type: 16, from xbmc, message OnUpdate
22:47:53.762 T:18446744071669553440   DEBUG: ### [TV Time] - onNotification
22:47:53.763 T:18446744071669553440   DEBUG: ### [TV Time] - method=VideoLibrary.OnUpdate
22:47:53.763 T:18446744071669553440   DEBUG: ### [TV Time] - VideoLibrary.OnUpdate
22:47:53.764 T:18446744071669553440   DEBUG: ### [TV Time] - {u'item': {u'type': u'episode', u'id': 69}}
22:47:53.766 T:18446744071669553440   DEBUG: ### [TV Time] - playcount=None
22:47:53.936 T:18446744071669553440   DEBUG: ### [TV Time] - result={u'jsonrpc': u'2.0', u'id': 1, u'result': {u'episodedetails': {u'tvshowid': 5, u'episode': 1, u'season': 12, u'episodeid': 69, u'label': u'The Conjugal Configuration', u'uniqueid': {u'unknown': u''}, u'showtitle': u'The Big Bang Theory'}}}
22:47:53.937 T:18446744071669553440   DEBUG: ### [TV Time] - episode_id=
22:47:53.938 T:18446744071669553440   DEBUG: ### [TV Time] - showtitle=The Big Bang Theory
22:47:53.938 T:18446744071669553440   DEBUG: ### [TV Time] - season=12
22:47:53.938 T:18446744071669553440   DEBUG: ### [TV Time] - episode=1
22:47:53.938 T:18446744071669553440   DEBUG: ### [TV Time] - episode_id=
22:47:53.938 T:18446744071669553440   DEBUG: ### [TV Time] - playcount=None
22:47:53.939 T:18446744071669553440   DEBUG: ### [TV Time] - tvshowtitle=The.Big.Bang.Theory.S12E01
22:47:54.310 T:18446744071669553440   DEBUG: ### [TV Time] - episode.is_found=False
22:47:54.800 T:18446744072158181664   DEBUG: Keyboard: scancode: 0x04, sym: 0x0008, unicode: 0x0000, modifier: 0x0
22:47:55.069 T:18446744072158181664   DEBUG: OnKey: backspace (0xf008) pressed, action is Back
22:47:55.070 T:18446744072158181664   DEBUG: CGUIMediaWindow::GetDirectory (videodb://inprogresstvshows/5/)
22:47:55.070 T:18446744072158181664   DEBUG:   ParentPath = [videodb://inprogresstvshows/]
22:47:55.105 T:18446744071752907040   DEBUG: RunQuery took 10 ms for 2 items query: SELECT * FROM season_view  WHERE season_view.idShow = 5
22:47:55.116 T:18446744071752907040   DEBUG: RunQuery took 8 ms for 0 items query: select * from movie_view join movielinktvshow on movielinktvshow.idMovie=movie_view.idMovie WHERE movielinktvshow.idShow = 5
22:47:55.144 T:18446744072158181664   DEBUG: WindowVideoNav::GetDirectory
22:47:55.181 T:18446744071627077920   DEBUG: Thread BackgroundLoader start, auto delete: false
22:47:55.211 T:18446744072158181664   DEBUG: Keyboard: scancode: 0x04, sym: 0x0008, unicode: 0x0000, modifier: 0x0
22:47:55.213 T:18446744071627077920   DEBUG: Thread BackgroundLoader 18446744071627077920 terminating
22:47:55.245 T:18446744071640779040   DEBUG: ffmpeg[84B10920]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra.
22:47:56.109 T:18446744072158181664   DEBUG: Keyboard: scancode: 0x04, sym: 0x0008, unicode: 0x0000, modifier: 0x0
22:47:56.366 T:18446744072158181664   DEBUG: OnKey: backspace (0xf008) pressed, action is Back
22:47:56.367 T:18446744072158181664   DEBUG: CGUIWindowManager::PreviousWindow: Deactivate
22:47:56.680 T:18446744072158181664   DEBUG: ------ Window Deinit (MyVideoNav.xml) ------
22:47:56.683 T:18446744072158181664   DEBUG: CGUIWindowManager::PreviousWindow: Activate new
22:47:56.684 T:18446744072158181664   DEBUG: ------ Window Init (Home.xml) ------
22:47:56.684 T:18446744072158181664   DEBUG: CDirectoryProvider[special://skin/playlists/inprogress_movies.xsp]: refreshing..
22:47:56.684 T:18446744072158181664   DEBUG: CDirectoryProvider[special://skin/playlists/recent_unwatched_movies.xsp]: refreshing..
22:47:56.687 T:18446744072158181664   DEBUG: CDirectoryProvider[special://skin/playlists/unwatched_movies.xsp]: refreshing..
22:47:56.688 T:18446744072158181664   DEBUG: CDirectoryProvider[special://skin/playlists/random_movies.xsp]: refreshing..
22:47:56.690 T:18446744072158181664   DEBUG: CDirectoryProvider[videodb://movies/genres/]: refreshing..
22:47:56.691 T:18446744072158181664   DEBUG: CDirectoryProvider[videodb://movies/sets/]: refreshing..
22:47:56.691 T:18446744072158181664   DEBUG: CDirectoryProvider[videodb://inprogresstvshows]: refreshing..
22:47:56.692 T:18446744072158181664   DEBUG: CDirectoryProvider[special://skin/playlists/recent_unwatched_episodes.xsp]: refreshing..
22:47:56.693 T:18446744072158181664   DEBUG: CDirectoryProvider[special://skin/playlists/unwatched_tvshows.xsp]: refreshing..
22:47:56.693 T:18446744072158181664   DEBUG: CDirectoryProvider[videodb://tvshows/genres/]: refreshing..
22:47:56.694 T:18446744072158181664   DEBUG: CDirectoryProvider[videodb://tvshows/studios/]: refreshing..
22:47:56.695 T:18446744072158181664   DEBUG: CDirectoryProvider[addons://sources/video/]: refreshing..
22:47:56.695 T:18446744072158181664   DEBUG: CDirectoryProvider[addons://sources/audio/]: refreshing..
22:47:56.696 T:18446744072158181664   DEBUG: CDirectoryProvider[addons://sources/executable/]: refreshing..
22:47:56.697 T:18446744072158181664   DEBUG: CDirectoryProvider[androidapp://sources/apps/]: refreshing..
22:47:56.699 T:18446744072158181664   DEBUG: CDirectoryProvider[addons://sources/image/]: refreshing..
22:47:56.709 T:18446744072158181664   DEBUG: Keyboard: scancode: 0x04, sym: 0x0008, unicode: 0x0000, modifier: 0x0
22:47:56.743 T:18446744071752907040   DEBUG: RunQuery took 12 ms for 1 items query: select * from movie_view  WHERE (movie_view.idFile  IN (SELECT DISTINCT idFile FROM bookmark WHERE type = 1))
22:47:56.774 T:18446744071662209312   DEBUG: RunQuery took 41 ms for 38 items query: select * from movie_view  WHERE ((movie_view.dateAdded > '1900-01-01')) AND ((movie_view.playCount IS NULL OR movie_view.playCount < 1))
22:47:56.775 T:18446744071640779040   DEBUG: RunQuery took 37 ms for 38 items query: select * from movie_view  WHERE ((movie_view.playCount IS NULL OR movie_view.playCount = 0))
22:47:56.876 T:18446744071752907040   DEBUG: RunQuery took 45 ms for 56 items query: select * from movie_view
22:47:57.071 T:18446744071662209312   DEBUG: RunQuery took 31 ms for 18 items query: SELECT genre.genre_id, genre.name, count(1), count(files.playCount) FROM genre JOIN genre_link ON genre.genre_id = genre_link.genre_id JOIN movie_view ON genre_link.media_id = movie_view.idMovie AND genre_link.media_type='movie' JOIN files ON files.idFile = movie_view.idFile GROUP BY genre.genre_id
22:47:57.076 T:18446744071640779040   DEBUG: RunQuery took 31 ms for 22 items query: select * from movie_view  JOIN sets ON movie_view.idSet = sets.idSet ORDER BY sets.idSet
22:47:57.157 T:18446744071752907040   DEBUG: RunQuery took 24 ms for 2 items query: SELECT * FROM tvshow_view  WHERE watchedCount != 0 AND totalCount != watchedCount ORDER BY c00
22:47:57.237 T:18446744071662209312   DEBUG: RunQuery took 16 ms for 31 items query: select * from episode_view  WHERE ((episode_view.dateAdded > '1900-01-01')) AND ((episode_view.playCount IS NULL OR episode_view.playCount < 1))
22:47:57.251 T:18446744071752907040   DEBUG: RunQuery took 6 ms for 10 items query: SELECT genre.genre_id, genre.name FROM genre JOIN genre_link ON genre.genre_id = genre_link.genre_id JOIN tvshow_view ON genre_link.media_id = tvshow_view.idShow AND genre_link.media_type='tvshow' GROUP BY genre.genre_id
22:47:57.257 T:18446744071640779040   DEBUG: RunQuery took 11 ms for 1 items query: SELECT * FROM tvshow_view  WHERE ((tvshow_view.watchedcount = 0)) AND ((tvshow_view.totalCount > 0))
22:47:57.375 T:18446744071640779040   DEBUG: RunQuery took 15 ms for 5 items query: SELECT studio.studio_id, studio.name FROM studio JOIN studio_link ON studio.studio_id = studio_link.studio_id JOIN tvshow_view ON studio_link.media_id = tvshow_view.idShow AND studio_link.media_type='tvshow' GROUP BY studio.studio_id
22:47:57.497 T:18446744071752907040   DEBUG: CAndroidAppDirectory::GetDirectory: apps
22:47:57.713 T:18446744072158181664   DEBUG: [Warning] CGUITextureManager::GetTexturePath: could not find texture 'DefaultStudio.png'
22:47:59.366 T:18446744072158181664   DEBUG: Previous line repeats 4 times.
22:47:59.367 T:18446744072158181664   DEBUG: ------ Window Deinit (DialogNotification.xml) ------
22:48:00.355 T:18446744071668508960  NOTICE: service.libraryautoupdate-1.0.2 : Skipping scan, only run when idle
22:48:00.491 T:18446744072158181664   DEBUG: Keyboard: scancode: 0x15, sym: 0x0114, unicode: 0x0000, modifier: 0x0
22:48:00.492 T:18446744072158181664   DEBUG: OnKey: left (0xf082) pressed, action is Left
22:48:00.704 T:18446744072158181664   DEBUG: Keyboard: scancode: 0x15, sym: 0x0114, unicode: 0x0000, modifier: 0x0
22:48:01.084 T:18446744072158181664   DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0
22:48:01.084 T:18446744072158181664   DEBUG: OnKey: down (0xf081) pressed, action is Down
22:48:01.251 T:18446744072158181664   DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0
22:48:01.351 T:18446744072158181664   DEBUG: Previous line repeats 1 times.
22:48:01.351 T:18446744072158181664   DEBUG: OnKey: down (0xf081) pressed, action is Down
22:48:01.564 T:18446744072158181664   DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0
22:48:02.562 T:18446744072158181664   DEBUG: Keyboard: scancode: 0x16, sym: 0x0113, unicode: 0x0000, modifier: 0x0
22:48:02.562 T:18446744072158181664   DEBUG: OnKey: right (0xf083) pressed, action is Right
22:48:02.698 T:18446744072158181664   DEBUG: Keyboard: scancode: 0x16, sym: 0x0113, unicode: 0x0000, modifier: 0x0
22:48:02.944 T:18446744072158181664   DEBUG: Previous line repeats 1 times.
22:48:02.944 T:18446744072158181664   DEBUG: OnKey: right (0xf083) pressed, action is Right
22:48:03.149 T:18446744072158181664   DEBUG: Keyboard: scancode: 0x16, sym: 0x0113, unicode: 0x0000, modifier: 0x0
22:48:03.515 T:18446744072158181664   DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0
22:48:03.515 T:18446744072158181664   DEBUG: OnKey: down (0xf081) pressed, action is Down
22:48:03.618 T:18446744071663253792   DEBUG: ffmpeg[8607F920]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra.
22:48:03.639 T:18446744071663253792   DEBUG: DoWork - took 120 ms to load special://masterprofile/Thumbnails/f/fb385316.jpg
22:48:03.733 T:18446744072158181664   DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0
22:48:03.947 T:18446744072158181664   DEBUG: Keyboard: scancode: 0x16, sym: 0x0113, unicode: 0x0000, modifier: 0x0
22:48:03.947 T:18446744072158181664   DEBUG: OnKey: right (0xf083) pressed, action is Right
22:48:04.167 T:18446744072158181664   DEBUG: Keyboard: scancode: 0x16, sym: 0x0113, unicode: 0x0000, modifier: 0x0
22:48:04.454 T:18446744072158181664   DEBUG: Previous line repeats 1 times.
22:48:04.456 T:18446744072158181664   DEBUG: OnKey: right (0xf083) pressed, action is Right
22:48:04.651 T:18446744072158181664   DEBUG: Keyboard: scancode: 0x16, sym: 0x0113, unicode: 0x0000, modifier: 0x0
22:48:05.031 T:18446744072158181664   DEBUG: Keyboard: scancode: 0x17, sym: 0x000d, unicode: 0x0000, modifier: 0x0
22:48:05.250 T:18446744072158181664   DEBUG: OnKey: return (0xf00d) pressed, action is Select
22:48:05.251 T:2140666144   DEBUG: Thread LanguageInvoker start, auto delete: false
22:48:05.252 T:18446744072158181664   DEBUG: Keyboard: scancode: 0x17, sym: 0x000d, unicode: 0x0000, modifier: 0x0
22:48:05.252 T:2140666144    INFO: initializing python engine.
22:48:05.253 T:2140666144   DEBUG: CPythonInvoker(5, /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/script.kodi.loguploader/default.py): start processing
22:48:05.338 T:2140666144   DEBUG: -->Python Interpreter Initialized<--
22:48:05.339 T:2140666144   DEBUG: CPythonInvoker(5, /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/script.kodi.loguploader/default.py): the source file to load is "/storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/script.kodi.loguploader/default.py"
22:48:05.344 T:2140666144   DEBUG: CPythonInvoker(5, /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/script.kodi.loguploader/default.py): setting the Python path to /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/script.kodi.loguploader:/storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/script.module.certifi/lib:/storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/script.module.chardet/lib:/storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/script.module.idna/lib:/storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/script.module.pyqrcode/lib:/storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/script.module.requests/lib:/storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/script.module.urllib3/lib:/:/data/app/org.xbmc.kodi-1/base.apk/assets/python2.7/lib/python27.zip:/data/app/org.xbmc.kodi-1/base.apk/assets/python2.7/lib/python2.7:/data/app/org.xbmc.kodi-1/base.apk/assets/python2.7/lib/python2.7/plat-linux2:/data/app/org.xbmc.kodi-1/base.apk/assets/python2.7/lib/python2.7/lib-tk:/data/app/org.xbmc.kodi-1/base.apk/assets/python2.7/lib/python2.7/lib-old:/data/app/org.xbmc.kodi-1/base.apk/assets/python2.7/lib/python2.7/lib-dynload
22:48:05.344 T:2140666144   DEBUG: CPythonInvoker(5, /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/script.kodi.loguploader/default.py): entering source directory /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/script.kodi.loguploader
22:48:05.345 T:2140666144   DEBUG: CPythonInvoker(5, /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/script.kodi.loguploader/default.py): instantiating addon using automatically obtained id of "script.kodi.loguploader" dependent on version 2.24.0 of the xbmc.python api
22:48:06.972 T:2140666144   DEBUG: script.kodi.loguploader: script version 0.3.2 started

[hugoduraes]

I've tried rebuilding the TV Shows library and i still get the same "episode not found" error!

@alxlaxv can you help me debugging this? Is there a way for me to debug it locally, using my library data?

[the-lazy-fox]

Could check in Kodi database if the value is correctly set and where?
May be a mapping has changed.

[hugoduraes]

Can you help me on how to do that?

[EienFr]

Hi,

Same issue here with your new version:

21:58:51.681 T:158099993840 ERROR: EXCEPTION Thrown (PythonToCppException) : -->Python callback/script returned the following error<--
- NOTE: IGNORING THIS CAN LEAD TO MEMORY LEAKS!
Error Type: <type 'exceptions.AttributeError'>
Error Contents: 'NoneType' object has no attribute 'get'
Traceback (most recent call last):
File "/storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/script.tvtime/default.py", line 198, in onNotification
if response.get('item').get('type') == 'episode':
AttributeError: 'NoneType' object has no attribute 'get'
-->End of Python script error report<--

[endlessblockade]

I was having the same issue but was able fix it by removing the following completely from default.py:

elif 'imdb' in result['result']['episodedetails']['uniqueid']:
episode_id = result['result']['episodedetails']['uniqueid']['imdb']

I had some episodes that would sync fine but then others where i would get the episode not found error.
The episodes that gave me the error had two uniqueid tags in the nfo for tvdb and imbd.

Episodes that worked fine just had the tvdb uniqueid. After removing the imdb uniqueid from an nfo, everything was working correctly. But since i wasn't about to go through thousands of nfo files to remove one line, i just removed lines 271 and 272 from default.py. Since then everything has been working correctly.

[the-lazy-fox]

Please retry with the last fix provided in #8
Release available --> https://github.com/alxlaxv/script.tvtime/releases/tag/1.2.4