Login at Kodi Home

danmandle · (This post was last modified: 2014-03-31, 01:06 by danmandle.)

I have a MySQL shared database set up and it was working just fine until all of the sudden it wasn't... XBMC isn't trying to connect to my database any more: on my XBMCuntu box or either of my macbooks. I have tried a new install on a new computer, still the same symptoms.

Below are the logs that are perplexing me. It clearly loads in the advancedsettings.xml file, but never says that it had trouble connecting to the database. I have also connected from the same computer using the same credentials to the database successfully via Sequel Pro.

22:02:02 T:140735315735312 NOTICE: -----------------------------------------------------------------------
22:02:02 T:140735315735312 NOTICE: Starting XBMC (12.3 Git:20131212-9ed3e58), Platform: Darwin OSX (13.1.0 x86_64, Version 10.9.2 (Build 13C64)). Built on Dec 23 2013
22:02:02 T:140735315735312 NOTICE: special://xbmc/ is mapped to: /Applications/XBMC.app/Contents/Resources/XBMC
22:02:02 T:140735315735312 NOTICE: special://xbmcbin/ is mapped to: /Applications/XBMC.app/Contents/Resources/XBMC
22:02:02 T:140735315735312 NOTICE: special://masterprofile/ is mapped to: /Users/danmandle/Library/Application Support/XBMC/userdata
22:02:02 T:140735315735312 NOTICE: special://home/ is mapped to: /Users/danmandle/Library/Application Support/XBMC
22:02:02 T:140735315735312 NOTICE: special://temp/ is mapped to: /Users/danmandle/.xbmc/temp
22:02:02 T:140735315735312 NOTICE: special://frameworks/ is mapped to: /Applications/XBMC.app/Contents/Frameworks
22:02:02 T:140735315735312 NOTICE: The executable running is: /Applications/XBMC.app/Contents/MacOS/./XBMC
22:02:02 T:140735315735312 NOTICE: Local hostname: dm-macbook.local
22:02:02 T:140735315735312 NOTICE: Log File is located: /Users/danmandle/Library/Logs/xbmc.log
22:02:02 T:140735315735312 NOTICE: -----------------------------------------------------------------------
22:02:02 T:140735315735312 NOTICE: load settings...
22:02:02 T:140735315735312 ERROR: Unable to load libcrystalhd.dylib, reason: dlopen(libcrystalhd.dylib, 1): image not found
22:02:02 T:140735315735312 NOTICE: special://profile/ is mapped to: special://masterprofile/
22:02:02 T:140735315735312 NOTICE: loading special://masterprofile/guisettings.xml
22:02:02 T:140735315735312 NOTICE: Getting hardware information now...
22:02:02 T:140735315735312 NOTICE: Loading player core factory settings from special://xbmc/system/playercorefactory.xml.
22:02:02 T:140735315735312 NOTICE: Loaded playercorefactory configuration
22:02:02 T:140735315735312 NOTICE: Loading player core factory settings from special://masterprofile/playercorefactory.xml.
22:02:02 T:140735315735312 NOTICE: special://masterprofile/playercorefactory.xml does not exist. Skipping.
22:02:02 T:140735315735312 NOTICE: No settings file to load (special://xbmc/system/advancedsettings.xml)
22:02:02 T:140735315735312 NOTICE: Loaded settings file from special://profile/advancedsettings.xml
22:02:02 T:140735315735312 NOTICE: Contents of special://profile/advancedsettings.xml are...
<advancedsettings>
<videodatabase>
<type>mysql</type>
<host>192.168.4.55</host>
<port>3306</port>
<user>xbmc_user</user>
<pass>XXXXXXXXX</pass>(real password removed for safety)
</videodatabase>
<videolibrary>
<dateadded>0</dateadded>
</videolibrary>
</advancedsettings>
22:02:02 T:140735315735312 WARNING: VIDEO database configuration is experimental.
22:02:02 T:140735315735312 NOTICE: Getting hardware information now...
22:02:02 T:140735315735312 NOTICE: Default DVD Player: dvdplayer
22:02:02 T:140735315735312 NOTICE: Default Video Player: dvdplayer
22:02:02 T:140735315735312 NOTICE: Default Audio Player: paplayer
22:02:02 T:140735315735312 NOTICE: Disabled debug logging due to GUI setting. Level 0.
22:02:02 T:140735315735312 NOTICE: Log level changed to 0
22:02:02 T:140735315735312 NOTICE: Loading media sources from special://masterprofile/sources.xml
22:02:02 T:140735315735312 ERROR: CCoreAudioDevice::SupportsMixing: Device mixing support : 'No'.
22:02:02 T:140735315735312 NOTICE: Running database version Addons15
22:02:03 T:4478713856 NOTICE: Thread XBMC Peripherals start, auto delete: false
22:02:03 T:140735315735312 NOTICE: Setup SDL
22:02:05 T:140735315735312 NOTICE: Display 0 has name Thunderbolt Display
22:02:05 T:140735315735312 NOTICE: Found possible resolution for display 0 with 2560 x 1440 @ 60.000000 Hz
22:02:05 T:140735315735312 NOTICE: Found possible resolution for display 0 with 1280 x 720 @ 60.000000 Hz
22:02:05 T:140735315735312 NOTICE: Found possible resolution for display 0 with 640 x 480 @ 60.000000 Hz
22:02:05 T:140735315735312 NOTICE: Found possible resolution for display 0 with 800 x 600 @ 60.000000 Hz
22:02:05 T:140735315735312 NOTICE: Found possible resolution for display 0 with 1024 x 768 @ 60.000000 Hz
22:02:05 T:140735315735312 NOTICE: Found possible resolution for display 0 with 1024 x 576 @ 60.000000 Hz
22:02:05 T:140735315735312 NOTICE: Found possible resolution for display 0 with 1280 x 960 @ 60.000000 Hz
22:02:05 T:140735315735312 NOTICE: Found possible resolution for display 0 with 1344 x 1008 @ 60.000000 Hz
22:02:05 T:140735315735312 NOTICE: Found possible resolution for display 0 with 1344 x 756 @ 60.000000 Hz
22:02:05 T:140735315735312 NOTICE: Found possible resolution for display 0 with 1600 x 1200 @ 60.000000 Hz
22:02:05 T:140735315735312 NOTICE: Found possible resolution for display 0 with 1600 x 900 @ 60.000000 Hz
22:02:05 T:140735315735312 NOTICE: Found possible resolution for display 0 with 1920 x 1440 @ 60.000000 Hz
22:02:05 T:140735315735312 NOTICE: Found possible resolution for display 0 with 2048 x 1152 @ 60.000000 Hz
22:02:05 T:140735315735312 NOTICE: Display 1 has name Color LCD
22:02:05 T:140735315735312 NOTICE: Found possible resolution for display 1 with 1280 x 800 @ 60.000000 Hz
22:02:05 T:140735315735312 NOTICE: Found possible resolution for display 1 with 1680 x 1050 @ 60.000000 Hz
22:02:05 T:140735315735312 NOTICE: Found possible resolution for display 1 with 1440 x 900 @ 60.000000 Hz
22:02:05 T:140735315735312 NOTICE: Found possible resolution for display 1 with 1024 x 640 @ 60.000000 Hz
22:02:05 T:140735315735312 NOTICE: Found possible resolution for display 1 with 825 x 525 @ 60.000000 Hz
22:02:05 T:140735315735312 NOTICE: Found possible resolution for display 1 with 720 x 450 @ 60.000000 Hz
22:02:05 T:140735315735312 NOTICE: Found possible resolution for display 1 with 2560 x 1600 @ 60.000000 Hz
22:02:05 T:140735315735312 NOTICE: Found possible resolution for display 1 with 1280 x 800 @ 60.000000 Hz
22:02:05 T:140735315735312 NOTICE: Found possible resolution for display 1 with 2048 x 1280 @ 60.000000 Hz
22:02:05 T:140735315735312 NOTICE: Found possible resolution for display 1 with 1650 x 1050 @ 60.000000 Hz
22:02:05 T:140735315735312 NOTICE: Found possible resolution for display 1 with 1440 x 900 @ 60.000000 Hz
22:02:05 T:140735315735312 NOTICE: Found possible resolution for display 1 with 1152 x 720 @ 60.000000 Hz
22:02:05 T:140735315735312 NOTICE: Found possible resolution for display 1 with 840 x 524 @ 60.000000 Hz
22:02:05 T:140735315735312 NOTICE: Found possible resolution for display 1 with 1024 x 768 @ 60.000000 Hz
22:02:05 T:140735315735312 NOTICE: Found possible resolution for display 1 with 800 x 600 @ 60.000000 Hz
22:02:05 T:140735315735312 NOTICE: Found possible resolution for display 1 with 640 x 480 @ 60.000000 Hz
22:02:05 T:140735315735312 NOTICE: Checking resolution 15
22:02:05 T:140735315735312 NOTICE: GL_VENDOR = Intel Inc.
22:02:05 T:140735315735312 NOTICE: GL_RENDERER = Intel HD Graphics 4000 OpenGL Engine
22:02:05 T:140735315735312 NOTICE: GL_VERSION = 2.1 INTEL-8.24.11
22:02:05 T:140735315735312 NOTICE: GL_SHADING_LANGUAGE_VERSION = 1.20
22:02:05 T:140735315735312 NOTICE: GL_EXTENSIONS = GL_ARB_color_buffer_float GL_ARB_depth_buffer_float GL_ARB_depth_clamp GL_ARB_depth_texture GL_ARB_draw_buffers GL_ARB_draw_elements_base_vertex GL_ARB_draw_instanced GL_ARB_fragment_program GL_ARB_fragment_program_shadow GL_ARB_fragment_shader GL_ARB_framebuffer_object GL_ARB_framebuffer_sRGB GL_ARB_half_float_pixel GL_ARB_half_float_vertex GL_ARB_instanced_arrays GL_ARB_multisample GL_ARB_multitexture GL_ARB_occlusion_query GL_ARB_pixel_buffer_object GL_ARB_point_parameters GL_ARB_point_sprite GL_ARB_provoking_vertex GL_ARB_seamless_cube_map GL_ARB_shader_objects GL_ARB_shader_texture_lod GL_ARB_shading_language_100 GL_ARB_shadow GL_ARB_sync GL_ARB_texture_border_clamp GL_ARB_texture_compression GL_ARB_texture_compression_rgtc GL_ARB_texture_cube_map GL_ARB_texture_env_add GL_ARB_texture_env_combine GL_ARB_texture_env_crossbar GL_ARB_texture_env_dot3 GL_ARB_texture_float GL_ARB_texture_mirrored_repeat GL_ARB_texture_non_power_of_two GL_ARB_texture_rectangle GL_ARB_texture_rg GL_ARB_transpose_matrix GL_ARB_vertex_array_bgra GL_ARB_vertex_blend GL_ARB_vertex_buffer_object GL_ARB_vertex_program GL_ARB_vertex_shader GL_ARB_window_pos GL_EXT_abgr GL_EXT_bgra GL_EXT_blend_color GL_EXT_blend_equation_separate GL_EXT_blend_func_separate GL_EXT_blend_minmax GL_EXT_blend_subtract GL_EXT_clip_volume_hint GL_EXT_debug_label GL_EXT_debug_marker GL_EXT_draw_buffers2 GL_EXT_draw_range_elements GL_EXT_fog_coord GL_EXT_framebuffer_blit GL_EXT_framebuffer_multisample GL_EXT_framebuffer_object GL_EXT_framebuffer_sRGB GL_EXT_geometry_shader4 GL_EXT_gpu_program_parameters GL_EXT_gpu_shader4 GL_EXT_multi_draw_arrays GL_EXT_packed_depth_stencil GL_EXT_packed_float GL_EXT_provoking_vertex GL_EXT_rescale_normal GL_EXT_secondary_color GL_EXT_separate_specular_color GL_EXT_shadow_funcs GL_EXT_stencil_two_side GL_EXT_stencil_wrap GL_EXT_texture_array GL_EXT_texture_compression_dxt1 GL_EXT_texture_compression_s3tc GL_EXT_texture_env_add GL_EXT_texture_filter_anisotropic GL_EXT_texture_integer GL_EXT_texture_lod_bias GL_EXT_texture_rectangle GL_EXT_texture_shared_exponent GL_EXT_texture_sRGB GL_EXT_texture_sRGB_decode GL_EXT_timer_query GL_EXT_transform_feedback GL_EXT_vertex_array_bgra GL_APPLE_aux_depth_stencil GL_APPLE_client_storage GL_APPLE_element_array GL_APPLE_fence GL_APPLE_float_pixels GL_APPLE_flush_buffer_range GL_APPLE_flush_render GL_APPLE_object_purgeable GL_APPLE_packed_pixels GL_APPLE_pixel_buffer GL_APPLE_rgb_422 GL_APPLE_row_bytes GL_APPLE_specular_vector GL_APPLE_texture_range GL_APPLE_transform_hint GL_APPLE_vertex_array_object GL_APPLE_vertex_array_range GL_APPLE_vertex_point_size GL_APPLE_vertex_program_evaluators GL_APPLE_ycbcr_422 GL_ATI_separate_stencil GL_ATI_texture_env_combine3 GL_ATI_texture_float GL_ATI_texture_mirror_once GL_IBM_rasterpos_clip GL_NV_blend_square GL_NV_conditional_render GL_NV_depth_clamp GL_NV_fog_distance GL_NV_light_max_exponent GL_NV_texgen_reflection GL_NV_texture_barrier GL_SGIS_generate_mipmap GL_SGIS_texture_edge_clamp GL_SGIS_texture_lod
22:02:06 T:140735315735312 NOTICE: Running database version Addons15
22:02:06 T:140735315735312 NOTICE: Running database version ViewModes4
22:02:06 T:140735315735312 NOTICE: Running database version Textures13
22:02:06 T:140735315735312 NOTICE: Running database version MyMusic32
22:02:06 T:140735315735312 NOTICE: Running database version MyVideos75
22:02:06 T:140735315735312 NOTICE: Running database version TV22
22:02:06 T:140735315735312 NOTICE: Running database version Epg7
22:02:06 T:140735315735312 NOTICE: start dvd mediatype detection
22:02:06 T:140735315735312 NOTICE: initializing playlistplayer
22:02:06 T:4496265216 NOTICE: Thread CDetectDVDMedia start, auto delete: false
22:02:06 T:140735315735312 NOTICE: DONE initializing playlistplayer
22:02:06 T:4566159360 NOTICE: Thread XBPyThread start, auto delete: false
22:02:06 T:4566159360 NOTICE: Previous line repeats 5 times.
22:02:06 T:4566159360 NOTICE: -->Python Interpreter Initialized<--
22:02:06 T:4572581888 NOTICE: Thread XBPyThread start, auto delete: false
22:02:06 T:140735315735312 NOTICE: Previous line repeats 1 times.
22:02:06 T:140735315735312 NOTICE: initialize done
22:02:06 T:140735315735312 NOTICE: Running the application...
22:02:06 T:140735315735312 NOTICE: Webserver: Starting...
22:02:06 T:140735315735312 NOTICE: WebServer: Started the webserver
22:02:06 T:140735315735312 NOTICE: ES: Starting event server
22:02:06 T:4576538624 NOTICE: Thread CEventServer start, auto delete: false
22:02:06 T:4576538624 NOTICE: ES: Starting UDP Event server on 0.0.0.0:9777
22:02:06 T:4577075200 NOTICE: Thread CTCPServer start, auto delete: false
22:02:06 T:4576538624 NOTICE: UDP: Listening on port 9777
22:02:06 T:140735315735312 NOTICE: starting zeroconf publishing
22:02:06 T:4577611776 NOTICE: Thread Jobworker start, auto delete: true
22:02:06 T:4569198592 NOTICE: -->Python Interpreter Initialized<--
22:02:06 T:4566159360 NOTICE: service.libraryautoupdate: Update Library Service starting...
22:02:06 T:4566159360 NOTICE: service.libraryautoupdate: update timers
22:02:07 T:4569735168 NOTICE: -->Python Interpreter Initialized<--
22:02:07 T:4568125440 NOTICE: -->Python Interpreter Initialized<--
22:02:07 T:4570271744 NOTICE: -->Python Interpreter Initialized<--
22:02:07 T:4568662016 NOTICE: -->Python Interpreter Initialized<--
22:02:07 T:4569735168 NOTICE: RCB Service: Start
22:02:07 T:4569735168 NOTICE: RCB Service: launch RCB on startup =
22:02:07 T:4569735168 NOTICE: RCB Service: scrape games on startup = false
22:02:07 T:4569735168 NOTICE: RCB Service: Done
22:02:07 T:4572581888 NOTICE: -->Python Interpreter Initialized<--
22:02:07 T:4573556736 NOTICE: -->Python Interpreter Initialized<--
22:02:07 T:4569198592 NOTICE: Artwork Downloader: ## Service - Run at startup: False
22:02:07 T:4569198592 NOTICE: Artwork Downloader: ## Service - Delayed startup: minutes
22:02:07 T:4569198592 NOTICE: Artwork Downloader: ## Service - Run as service: False
22:02:07 T:4569198592 NOTICE: Artwork Downloader: ## Service - Time: :00
22:02:07 T:4573556736 NOTICE: StorageServer Module loaded RUN
22:02:07 T:4573556736 NOTICE: StorageClient-2.5.4 Starting server
22:02:07 T:4573556736 NOTICE: StorageServer-2.5.4 Storage Server starting /Users/danmandle/.xbmc/temp/commoncache.db
22:02:10 T:4572581888 NOTICE: Thread XBPyThread start, auto delete: false
22:02:10 T:4572581888 NOTICE: -->Python Interpreter Initialized<--
22:02:11 T:4604825600 NOTICE: Thread Jobworker start, auto delete: true
22:02:11 T:4605362176 NOTICE: Thread CAlarmClock start, auto delete: false
22:02:11 T:4605898752 NOTICE: Thread Jobworker start, auto delete: true
22:02:16 T:140735315735312 NOTICE: Previous line repeats 1 times.
22:02:16 T:140735315735312 NOTICE: Storing total System Uptime
22:02:16 T:140735315735312 NOTICE: Saving settings
22:02:16 T:140735315735312 NOTICE: stop all
22:02:16 T:140735315735312 NOTICE: ES: Stopping event server
22:02:16 T:140735315735312 NOTICE: stopping zeroconf publishing
22:02:16 T:140735315735312 NOTICE: Webserver: Stopping...
22:02:16 T:140735315735312 NOTICE: WebServer: Stopped the webserver
22:02:16 T:140735315735312 NOTICE: Webserver: Stopped...
22:02:16 T:4576538624 NOTICE: ES: UDP Event server stopped
22:02:16 T:140735315735312 NOTICE: stop dvd detect media
22:02:16 T:140735315735312 NOTICE: stop sap announcement listener
22:02:16 T:140735315735312 NOTICE: clean cached files!
22:02:16 T:140735315735312 NOTICE: unload skin
22:02:17 T:4568125440 WARNING: The python script "/Users/danmandle/Library/Application Support/XBMC/addons/service.skin.widgets/default.py" has left several classes in memory that we couldn't clean up. The classes include: Monitor,Player,Window
22:02:17 T:4573556736 NOTICE: StorageServer-2.5.4 Closed down
22:02:17 T:140735315735312 NOTICE: stop python
22:02:17 T:140735315735312 NOTICE: stopped
22:02:17 T:140735315735312 NOTICE: destroy
22:02:17 T:140735315735312 NOTICE: unload sections
22:02:17 T:140735315735312 NOTICE: destroy
22:02:17 T:140735315735312 WARNING: Attempted to remove window 10013 from the window manager when it didn't exist
22:02:17 T:140735315735312 WARNING: Attempted to remove window 10014 from the window manager when it didn't exist
22:02:17 T:140735315735312 WARNING: Attempted to remove window 10015 from the window manager when it didn't exist
22:02:17 T:140735315735312 WARNING: Attempted to remove window 10016 from the window manager when it didn't exist
22:02:17 T:140735315735312 WARNING: Attempted to remove window 10017 from the window manager when it didn't exist
22:02:17 T:140735315735312 WARNING: Attempted to remove window 10018 from the window manager when it didn't exist
22:02:17 T:140735315735312 WARNING: Attempted to remove window 10019 from the window manager when it didn't exist
22:02:17 T:140735315735312 WARNING: Attempted to remove window 10021 from the window manager when it didn't exist
22:02:17 T:140735315735312 WARNING: Attempted to remove window 10107 from the window manager when it didn't exist
22:02:17 T:140735315735312 WARNING: Attempted to remove window 10115 from the window manager when it didn't exist
22:02:17 T:140735315735312 WARNING: Attempted to remove window 10104 from the window manager when it didn't exist
22:02:17 T:140735315735312 NOTICE: unload sections
22:02:17 T:140735315735312 NOTICE: application stopped...

~~Ned Scott~~ · 2014-03-28, 06:52

Please repost debug log via pastebin site and with debugging turned on, as described on Log file/Easy (wiki)

nickr · 2014-03-28, 21:23

What Ned said, plus is it possible xbmc is starting before networking is up?

avenzel · 2014-03-28, 22:23

This happened to me just yesterday, because my router DHCP settings were incorrectly configured.
I had some computers with manually assigned IP addresses and some others through DHCP. I then connected a new device to the LAN that acquired the same IP I was using on the XBMC computer. This was enough to further prevent the XBMC computer from connecting to MySQL on my home server, even after turning off the new device. The IP was still assigned (leased) to that device so I unplugged the LAN cable and plugged it back again and restarted my router. And I could reach the MySQL library again! Of course, I changed my router settings so this wouldn't happen again.
I'm just posting this because it might be your case.

P.S. After re-reading your post, it doesn't look like this is your case. Anyway, here it goes.

danmandle · 2014-03-29, 02:33

Thanks guys. Networking, at least on the system level, is definitely up.

Here's the log file: http://xbmclogs.com/show.php?id=160875

nickr · 2014-03-29, 03:03

Anything showing up in your mysql log?

~~Ned Scott~~ · 2014-03-29, 03:05

Not sure. XBMC seems to think the connection went just fine. hmm...

danmandle · 2014-03-29, 04:22

Here's a pastebin of using another database server (my VPS). I normally have my XBMC database running on my Synology NAS.

http://pastebin.com/YrX3msZk

danmandle · 2014-03-29, 18:43

I have good news and bad news....

The good news is that it's not XBMC, my NAS, or my network. The bad news is that somehow, my database got wiped out and the last backup I have is from November.