Solved [SOLVED] Airtunes on XBMC

woodsb02

woodsb02

Is anyone using XBMC on FreeBSD and has the built-in XBMC AirTunes working to allow music to be streamed from an iPhone to XBMC?

I have XBMC showing up as an available AirTunes speaker on my iPhone (the Avahi auto-discover is working), but when I start streaming music it tries for approx 4 seconds and then stops, without any sound or graphic change on XBMC (no response at all).

Any suggestions on how to debug this / get it working?

Cheers,
Ben
 
Re: Airtunes on XBMC

I should point out a little bit about my setup:
  • Zbox ID80 with NVIDIA GeForce GT 520M (512MB) http://www.zotacusa.com/zbox-id80.html
  • Sound output via fibre optic /dev/dsp1
  • Wifi network iwn0 Intel Centrino Wireless-N 130 class=0x028000 card=0x50058086 chip=0x08968086 rev=0x34 hdr=0x00
  • FreeBSD 10.0-RELEASE
  • FreeBSD binary package repository used for all packages http://pkg.freebsd.org/freebsd:10:x86:64/latest/
  • multimedia/xbmc 13.0.a11_4 from ports (tried compiling with and without AirTunes option turned on, always with AirPlay option on).
  • net/avahi 0.6.31 from packages
  • No firewall between iPhone and FreeBSD

XBMC Log:
Code: 
21:03:15 T:34611422208  NOTICE: special://profile/ is mapped to: special://masterprofile/
21:03:15 T:34611422208  NOTICE: -----------------------------------------------------------------------
21:03:15 T:34611422208  NOTICE: Starting XBMC (13.0-ALPHA11 Git:Unknown). Platform: x86 FreeBSD 64-bit
21:03:15 T:34611422208  NOTICE: Using Release XBMC x64 build, compiled Mar 10 2014 by Clang 3.3.0 for x86 FreeBSD 64-bit version 1000510
21:03:15 T:34611422208  NOTICE: Running on FreeBSD 64-bit 10.0-RELEASE amd64
21:03:15 T:34611422208  NOTICE: Host CPU: Intel(R) Atom(TM) CPU D2700 @ 2.13GHz, 4 cores available
21:03:15 T:34611422208  NOTICE: special://xbmc/ is mapped to: /usr/local/share/xbmc
21:03:15 T:34611422208  NOTICE: special://xbmcbin/ is mapped to: /usr/local/lib/xbmc
21:03:15 T:34611422208  NOTICE: special://masterprofile/ is mapped to: /home/xbmc/.xbmc/userdata
21:03:15 T:34611422208  NOTICE: special://home/ is mapped to: /home/xbmc/.xbmc
21:03:15 T:34611422208  NOTICE: special://temp/ is mapped to: /home/xbmc/.xbmc/temp
21:03:15 T:34611422208  NOTICE: The executable running is: /usr/local/lib/xbmc/xbmc.bin
21:03:15 T:34611422208  NOTICE: Local hostname: zbox.local
21:03:15 T:34611422208  NOTICE: Log File is located: /home/xbmc/.xbmc/temp/xbmc.log
21:03:15 T:34611422208  NOTICE: -----------------------------------------------------------------------
21:03:15 T:34611422208  NOTICE: load settings...
21:03:15 T:34611422208  NOTICE: Found 1 Lists of Devices
21:03:15 T:34611422208  NOTICE: Enumerated OSS devices:
21:03:15 T:34611422208  NOTICE:     Device 1
21:03:15 T:34611422208  NOTICE:         m_deviceName      : /dev/dsp0
21:03:15 T:34611422208  NOTICE:         m_displayName     : pcm0 Realtek ALC892 (Rear Analog)
21:03:15 T:34611422208  NOTICE:         m_displayNameExtra:
21:03:15 T:34611422208  NOTICE:         m_deviceType      : AE_DEVTYPE_PCM
21:03:15 T:34611422208  NOTICE:         m_channels        : FL,FR
21:03:15 T:34611422208  NOTICE:         m_sampleRates     : 44100,48000,64000,88200,96000,176400,192000
21:03:15 T:34611422208  NOTICE:         m_dataFormats     :
21:03:15 T:34611422208  NOTICE:     Device 2
21:03:15 T:34611422208  NOTICE:         m_deviceName      : /dev/dsp1
21:03:15 T:34611422208  NOTICE:         m_displayName     : pcm1 Realtek ALC892 (Rear Digital)
21:03:15 T:34611422208  NOTICE:         m_displayNameExtra:
21:03:15 T:34611422208  NOTICE:         m_deviceType      : AE_DEVTYPE_IEC958
21:03:15 T:34611422208  NOTICE:         m_channels        : FL,FR
21:03:15 T:34611422208  NOTICE:         m_sampleRates     : 48000
21:03:15 T:34611422208  NOTICE:         m_dataFormats     :
21:03:15 T:34611422208  NOTICE:     Device 3
21:03:15 T:34611422208  NOTICE:         m_deviceName      : /dev/dsp2
21:03:15 T:34611422208  NOTICE:         m_displayName     : pcm2 NVIDIA (0x001c) (HDMI/DP 8ch)
21:03:15 T:34611422208  NOTICE:         m_displayNameExtra:
21:03:15 T:34611422208  NOTICE:         m_deviceType      : AE_DEVTYPE_HDMI
21:03:15 T:34611422208  NOTICE:         m_channels        : FL,FR
21:03:15 T:34611422208  NOTICE:         m_sampleRates     : 44100,48000,64000,88200,96000,176400,192000
21:03:15 T:34611422208  NOTICE:         m_dataFormats     :
21:03:15 T:34611422208  NOTICE:     Device 4
21:03:15 T:34611422208  NOTICE:         m_deviceName      : /dev/dsp3
21:03:15 T:34611422208  NOTICE:         m_displayName     : pcm3 NVIDIA (0x001c) (HDMI/DP 8ch)
21:03:15 T:34611422208  NOTICE:         m_displayNameExtra:
21:03:15 T:34611422208  NOTICE:         m_deviceType      : AE_DEVTYPE_HDMI
21:03:15 T:34611422208  NOTICE:         m_channels        : FL,FR
21:03:15 T:34611422208  NOTICE:         m_sampleRates     : 48000
21:03:15 T:34611422208  NOTICE:         m_dataFormats     :
21:03:15 T:34611422208  NOTICE: No settings file to load (special://xbmc/system/advancedsettings.xml)
21:03:15 T:34611422208  NOTICE: No settings file to load (special://masterprofile/advancedsettings.xml)
21:03:15 T:34611422208  NOTICE: Default DVD Player: dvdplayer
21:03:15 T:34611422208  NOTICE: Default Video Player: dvdplayer
21:03:15 T:34611422208  NOTICE: Default Audio Player: paplayer
21:03:15 T:34611422208  NOTICE: Disabled debug logging due to GUI setting. Level 0.
21:03:15 T:34611422208  NOTICE: Log level changed to 0
21:03:15 T:34611422208  NOTICE: CMediaSourceSettings: loading media sources from special://masterprofile/sources.xml
21:03:15 T:34611422208  NOTICE: Loading player core factory settings from special://xbmc/system/playercorefactory.xml.
21:03:15 T:34611422208  NOTICE: Loaded playercorefactory configuration
21:03:15 T:34611422208  NOTICE: Loading player core factory settings from special://masterprofile/playercorefactory.xml.
21:03:15 T:34611422208  NOTICE: special://masterprofile/playercorefactory.xml does not exist. Skipping.
21:03:15 T:34611422208  NOTICE: LoadFromXML - unable to load:/home/xbmc/.xbmc/userdata/wakeonlan.xml
21:03:15 T:34611426304  NOTICE: Thread ActiveAE start, auto delete: false
21:03:15 T:34653590528  NOTICE: Thread AESink start, auto delete: false
21:03:15 T:34611422208  NOTICE: Running database version Addons16
21:03:15 T:34611422208  NOTICE: ADDONS: Using repository repository.xbmc.org
21:03:15 T:34611429376  NOTICE: Thread PeripBusCEC start, auto delete: false
21:03:15 T:34611430400  NOTICE: Thread PeripBusUSB start, auto delete: false
21:03:15 T:34611422208   ERROR: HAL: Failed to initialize hal context: (null)
21:03:15 T:34611422208   ERROR: HAL: no Hal context
21:03:15 T:34611422208  NOTICE: Setup SDL
21:03:15 T:34611422208  NOTICE: Checking resolution 16
21:03:16 T:34611422208  NOTICE: Using visual 0x73
21:03:16 T:34611422208  NOTICE: GL_VENDOR = NVIDIA Corporation
21:03:16 T:34611422208  NOTICE: GL_RENDERER = GeForce GT 520M/PCIe/SSE2
21:03:16 T:34611422208  NOTICE: GL_VERSION = 4.4.0 NVIDIA 331.49
21:03:16 T:34611422208  NOTICE: GL_SHADING_LANGUAGE_VERSION = 4.40 NVIDIA via Cg compiler
21:03:16 T:34611422208  NOTICE: GL_GPU_MEMORY_INFO_TOTAL_AVAILABLE_MEMORY_NVX = 524288
21:03:16 T:34611422208  NOTICE: GL_GPU_MEMORY_INFO_DEDICATED_VIDMEM_NVX = 524288
21:03:16 T:34611422208  NOTICE: GL_EXTENSIONS = GL_AMD_multi_draw_indirect GL_ARB_arrays_of_arrays GL_ARB_base_instance GL_ARB_blend_func_extended GL_ARB_buffer_storage GL_ARB_clear_buffer_object GL_ARB_clear_texture GL_ARB_color_buffer_float GL_ARB_compatibility GL_ARB_compressed_texture_pixel_storage GL_ARB_conservative_depth GL_ARB_compute_shader GL_ARB_compute_variable_group_size GL_ARB_copy_buffer GL_ARB_copy_image GL_ARB_debug_output GL_ARB_depth_buffer_float GL_ARB_depth_clamp GL_ARB_depth_texture GL_ARB_draw_buffers GL_ARB_draw_buffers_blend GL_ARB_draw_indirect GL_ARB_draw_elements_base_vertex GL_ARB_draw_instanced GL_ARB_enhanced_layouts GL_ARB_ES2_compatibility GL_ARB_ES3_compatibility GL_ARB_explicit_attrib_location GL_ARB_explicit_uniform_location GL_ARB_fragment_coord_conventions GL_ARB_fragment_layer_viewport GL_ARB_fragment_program GL_ARB_fragment_program_shadow GL_ARB_fragment_shader GL_ARB_framebuffer_no_attachments GL_ARB_framebuffer_object GL_ARB_framebuffer_sRGB GL_ARB_geometry_shader4 GL_ARB_get_program_binary GL_ARB_gpu_shader5 GL_ARB_gpu_shader_fp64 GL_ARB_half_float_pixel GL_ARB_half_float_vertex GL_ARB_imaging GL_ARB_indirect_parameters GL_ARB_instanced_arrays GL_ARB_internalformat_query GL_ARB_internalformat_query2 GL_ARB_invalidate_subdata GL_ARB_map_buffer_alignment GL_ARB_map_buffer_range GL_ARB_multi_bind GL_ARB_multi_draw_indirect GL_ARB_multisample GL_ARB_multitexture GL_ARB_occlusion_query GL_ARB_occlusion_query2 GL_ARB_pixel_buffer_object GL_ARB_point_parameters GL_ARB_point_sprite GL_ARB_program_interface_query GL_ARB_provoking_vertex GL_ARB_robust_buffer_access_behavior GL_ARB_robustness GL_ARB_sample_shading GL_ARB_sampler_objects GL_ARB_seamless_cube_map GL_ARB_separate_shader_objects GL_ARB_shader_atomic_counters GL_ARB_shader_bit_encoding GL_ARB_shader_draw_parameters GL_ARB_shader_group_vote GL_ARB_shader_image_load_store GL_ARB_shader_image_size GL_ARB_shader_objects GL_ARB_shader_precision GL_ARB_query_buffer_object GL_ARB_shader_storage_buffer_object GL_ARB_shader_subroutine GL_ARB_shader_texture_lod GL_ARB_shading_language_100 GL_ARB_shading_language_420pack GL_ARB_shading_language_include GL_ARB_shading_language_packing GL_ARB_shadow GL_ARB_stencil_texturing GL_ARB_sync GL_ARB_tessellation_shader GL_ARB_texture_border_clamp GL_ARB_texture_buffer_object GL_ARB_texture_buffer_object_rgb32 GL_ARB_texture_buffer_range GL_ARB_texture_compression GL_ARB_texture_compression_bptc GL_ARB_texture_compression_rgtc GL_ARB_texture_cube_map GL_ARB_texture_cube_map_array 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_gather GL_ARB_texture_mirror_clamp_to_edge GL_ARB_texture_mirrored_repeat GL_ARB_texture_multisample GL_ARB_texture_non_power_of_two GL_ARB_texture_query_levels GL_ARB_texture_query_lod GL_ARB_texture_rectangle GL_ARB_texture_rg GL_ARB_texture_rgb10_a2ui GL_ARB_texture_stencil8 GL_ARB_texture_storage GL_ARB_texture_storage_multisample GL_ARB_texture_swizzle GL_ARB_texture_view GL_ARB_timer_query GL_ARB_transform_feedback2 GL_ARB_transform_feedback3 GL_ARB_transform_feedback_instanced GL_ARB_transpose_matrix GL_ARB_uniform_buffer_object GL_ARB_vertex_array_bgra GL_ARB_vertex_array_object GL_ARB_vertex_attrib_64bit GL_ARB_vertex_attrib_binding GL_ARB_vertex_buffer_object GL_ARB_vertex_program GL_ARB_vertex_shader GL_ARB_vertex_type_10f_11f_11f_rev GL_ARB_vertex_type_2_10_10_10_rev GL_ARB_viewport_array GL_ARB_window_pos GL_ATI_draw_buffers GL_ATI_texture_float GL_ATI_texture_mirror_once GL_S3_s3tc GL_EXT_texture_env_add GL_EXT_abgr GL_EXT_bgra GL_EXT_bindable_uniform GL_EXT_blend_color GL_EXT_blend_equation_separate GL_EXT_blend_func_separate GL_EXT_blend_minmax GL_EXT_blend_subtract GL_EXT_compiled_vertex_array GL_EXT_Cg_shader GL_EXT_depth_bounds_test GL_EXT_direct_state_access GL_EXT_draw_buffers2 GL_EXT_draw_instanced GL_EXT_draw_range_elements GL_EXT_fog_coord GL_EXT_framebuffer_blit GL_EXT_framebuffer_multisample GL_EXTX_framebuffer_mixed_formats GL_EXT_framebuffer_multisample_blit_scaled GL_EXT_framebuffer_object GL_EXT_framebuffer_sRGB GL_EXT_geometry_shader4 GL_EXT_gpu_program_parameters GL_EXT_gpu_shader4 GL_EXT_multi_draw_arrays GL_EXT_packed_depth_stencil GL_EXT_packed_float GL_EXT_packed_pixels GL_EXT_pixel_buffer_object GL_EXT_point_parameters GL_EXT_provoking_vertex GL_EXT_rescale_normal GL_EXT_secondary_color GL_EXT_separate_shader_objects GL_EXT_separate_specular_color GL_EXT_shader_image_load_store GL_EXT_shadow_funcs GL_EXT_stencil_two_side GL_EXT_stencil_wrap GL_EXT_texture3D GL_EXT_texture_array GL_EXT_texture_buffer_object GL_EXT_texture_compression_dxt1 GL_EXT_texture_compression_latc GL_EXT_texture_compression_rgtc GL_EXT_texture_compression_s3tc GL_EXT_texture_cube_map GL_EXT_texture_edge_clamp GL_EXT_texture_env_combine GL_EXT_texture_env_dot3 GL_EXT_texture_filter_anisotropic GL_EXT_texture_integer GL_EXT_texture_lod GL_EXT_texture_lod_bias GL_EXT_texture_mirror_clamp GL_EXT_texture_object GL_EXT_texture_shared_exponent GL_EXT_texture_sRGB GL_EXT_texture_sRGB_decode GL_EXT_texture_storage GL_EXT_texture_swizzle GL_EXT_timer_query GL_EXT_transform_feedback2 GL_EXT_vertex_array GL_EXT_vertex_array_bgra GL_EXT_vertex_attrib_64bit GL_EXT_x11_sync_object GL_EXT_import_sync_object GL_IBM_rasterpos_clip GL_IBM_texture_mirrored_repeat GL_KHR_debug GL_KTX_buffer_region GL_NV_bindless_multi_draw_indirect GL_NV_blend_equation_advanced GL_NV_blend_square GL_NV_compute_program5 GL_NV_conditional_render GL_NV_copy_depth_to_color GL_NV_copy_image GL_NV_depth_buffer_float GL_NV_depth_clamp GL_NV_draw_texture GL_NV_ES1_1_compatibility GL_NV_explicit_multisample GL_NV_fence GL_NV_float_buffer GL_NV_fog_distance GL_NV_fragment_program GL_NV_fragment_program_option GL_NV_fragment_program2 GL_NV_framebuffer_multisample_coverage GL_NV_geometry_shader4 GL_NV_gpu_program4 GL_NV_gpu_program4_1 GL_NV_gpu_program5 GL_NV_gpu_program5_mem_extended GL_NV_gpu_program_fp64 GL_NV_gpu_shader5 GL_NV_half_float GL_NV_light_max_exponent GL_NV_multisample_coverage GL_NV_multisample_filter_hint GL_NV_occlusion_query GL_NV_packed_depth_stencil GL_NV_parameter_buffer_object GL_NV_parameter_buffer_object2 GL_NV_path_rendering GL_NV_pixel_data_range GL_NV_point_sprite GL_NV_primitive_restart GL_NV_register_combiners GL_NV_register_combiners2 GL_NV_shader_atomic_counters GL_NV_shader_atomic_float GL_NV_shader_buffer_load GL_NV_shader_storage_buffer_object GL_ARB_sparse_texture GL_NV_texgen_reflection GL_NV_texture_barrier GL_NV_texture_compression_vtc GL_NV_texture_env_combine4 GL_NV_texture_expand_normal GL_NV_texture_multisample GL_NV_texture_rectangle GL_NV_texture_shader GL_NV_texture_shader2 GL_NV_texture_shader3 GL_NV_transform_feedback GL_NV_transform_feedback2 GL_NV_vdpau_interop GL_NV_vertex_array_range GL_NV_vertex_array_range2 GL_NV_vertex_attrib_integer_64bit GL_NV_vertex_buffer_unified_memory GL_NV_vertex_program GL_NV_vertex_program1_1 GL_NV_vertex_program2 GL_NV_vertex_program2_option GL_NV_vertex_program3 GL_NVX_conditional_render GL_NVX_gpu_memory_info GL_SGIS_generate_mipmap GL_SGIS_texture_lod GL_SGIX_depth_texture GL_SGIX_shadow GL_SUN_slice_accum
21:03:16 T:34611422208   ERROR: GLX: Same window as before, refreshing context
21:03:16 T:34611422208  NOTICE: No Joystick name specified, loading default map
21:03:16 T:34611422208  NOTICE: Previous line repeats 35 times.
21:03:16 T:34611422208  NOTICE: Running database version Addons16
21:03:16 T:34611422208  NOTICE: Running database version ViewModes6
21:03:16 T:34611422208  NOTICE: Running database version Textures13
21:03:16 T:34611422208  NOTICE: Running database version MyMusic43
21:03:16 T:34611422208  NOTICE: Running database version MyVideos77
21:03:16 T:34611422208  NOTICE: Running database version TV22
21:03:16 T:34611422208  NOTICE: Running database version Epg7
21:03:16 T:34611422208  NOTICE: start dvd mediatype detection
21:03:16 T:34611422208  NOTICE: initializing playlistplayer
21:03:16 T:34611422208  NOTICE: DONE initializing playlistplayer
21:03:16 T:34691158016  NOTICE: Thread DetectDVDMedia start, auto delete: false
21:03:16 T:34611422208 WARNING: CreateFile, successfuly opened </home/xbmc/.xbmc/addons/skin.quartzV3.plexbmc/1080i/DialogSeekbar.xml> instead of </home/xbmc/.xbmc/addons/skin.quartzv3.plexbmc/1080i/dialogseekbar.xml>
21:03:17 T:34611422208   ERROR: JSONRPC: Could not parse type "GUI.Property.Value"
21:03:17 T:34611422208   ERROR: JSONRPC: Could not parse type "Setting.Details.SettingList"
21:03:17 T:34691186688  NOTICE: Thread LanguageInvoker start, auto delete: false
21:03:17 T:34611422208  NOTICE: initialize done
21:03:17 T:34691187712  NOTICE: Thread LanguageInvoker start, auto delete: false
21:03:17 T:34611422208  NOTICE: Running the application...
21:03:17 T:34611422208 WARNING: Label Formating: $VAR[WatchlistParameters] is not defined
21:03:17 T:34691186688  NOTICE: -->Python Interpreter Initialized<--
21:03:17 T:34761695232  NOTICE: Thread JobWorker start, auto delete: true
21:03:17 T:34611422208  NOTICE: starting zeroconf publishing
21:03:17 T:34611422208  NOTICE: Webserver: Starting...
21:03:17 T:34611422208  NOTICE: WebServer: Started the webserver
21:03:17 T:34611422208  NOTICE: starting upnp renderer
21:03:17 T:34761697280  NOTICE: Thread LanguageInvoker start, auto delete: false
21:03:17 T:34761703424  NOTICE: Previous line repeats 2 times.
21:03:17 T:34761703424  NOTICE: Thread JobWorker start, auto delete: true
21:03:17 T:34611422208  NOTICE: ES: Starting event server
21:03:17 T:34761710592  NOTICE: Thread TCPServer start, auto delete: false
21:03:17 T:34761012224  NOTICE: Thread AirPlayServer start, auto delete: false
21:03:17 T:34761709568  NOTICE: Thread EventServer start, auto delete: false
21:03:17 T:34761709568  NOTICE: ES: Starting UDP Event server on 0.0.0.0:9777
21:03:17 T:34761709568  NOTICE: UDP: Listening on port 9777
21:03:17 T:34761014272  NOTICE: Thread JobWorker start, auto delete: true
21:03:17 T:34761697280  NOTICE: -->Python Interpreter Initialized<--
21:03:17 T:34761015296  NOTICE: Thread AlarmClock start, auto delete: false
21:03:17 T:34761013248  NOTICE: Thread AirTunesServer start, auto delete: false
21:03:17 T:34761699328  NOTICE: -->Python Interpreter Initialized<--
21:03:18 T:34761697280  NOTICE: ===== PLEXBMC START =====
21:03:18 T:34761697280  NOTICE: PleXBMC -> running Python: sys.version_info(major=2, minor=7, micro=6, releaselevel='final', serial=0)
21:03:18 T:34761697280  NOTICE: PleXBMC -> running PleXBMC: 3.1.5
21:03:18 T:34691187712  NOTICE: -->Python Interpreter Initialized<--
21:03:18 T:34761697280  NOTICE: PleXBMC -> Running with cElementTree on Python 2.5+
21:03:18 T:34761697280  NOTICE: PleXBMC -> Platform: Linux/RPi
21:03:18 T:34761697280  NOTICE: PleXBMC -> Debug is turned off.  Running silent
21:03:18 T:34761701376  NOTICE: -->Python Interpreter Initialized<--
21:03:18 T:34761699328  NOTICE: ===== PLEXBMC START =====
21:03:18 T:34761699328  NOTICE: PleXBMC -> running Python: sys.version_info(major=2, minor=7, micro=6, releaselevel='final', serial=0)
21:03:18 T:34761699328  NOTICE: PleXBMC -> running PleXBMC: 3.1.5
21:03:18 T:34761699328  NOTICE: PleXBMC -> Running with cElementTree on Python 2.5+
21:03:18 T:34761699328  NOTICE: PleXBMC -> Platform: Linux/RPi
21:03:18 T:34761699328  NOTICE: PleXBMC -> Debug is turned off.  Running silent
21:03:19 T:34691187712  NOTICE: ===== PLEXBMC HELPER START =====
21:03:19 T:34691187712  NOTICE: PleXBMC Helper -> running Python: sys.version_info(major=2, minor=7, micro=6, releaselevel='final', serial=0)
21:03:19 T:34691187712  NOTICE: PleXBMC Helper -> running Version: 3.1.3
21:03:19 T:34761701376  NOTICE: ===== PLEXBMC START =====
21:03:19 T:34761701376  NOTICE: PleXBMC -> running Python: sys.version_info(major=2, minor=7, micro=6, releaselevel='final', serial=0)
21:03:19 T:34761701376  NOTICE: PleXBMC -> running PleXBMC: 3.1.5
21:03:19 T:34761701376  NOTICE: PleXBMC -> Running with cElementTree on Python 2.5+
21:03:19 T:34761701376  NOTICE: PleXBMC -> Platform: Linux/RPi
21:03:19 T:34761701376  NOTICE: PleXBMC -> Debug is turned off.  Running silent
21:03:20 T:34691187712  NOTICE: PleXBMC Helper -> Platform: Linux/RPi
21:03:20 T:34691187712  NOTICE: PleXBMC Helper -> UUID: 367ef96d-ef46-49c3-8627-6a9e8ad0d773
21:03:20 T:34691187712  NOTICE: PleXBMC Helper -> XBMC Web Port: 8080
21:03:20 T:34691187712  NOTICE: PleXBMC Helper -> XBMC Web User: xbmc
21:03:25 T:34761697280  NOTICE: ===== PLEXBMC STOP =====
21:03:25 T:34761701376  NOTICE: ===== PLEXBMC STOP =====
21:03:25 T:34761699328  NOTICE: ===== PLEXBMC STOP =====
21:03:30 T:34691187712  NOTICE: PleXBMC Helper -> PleXBMC Helper has started
21:03:47 T:34761699328  NOTICE: Thread LanguageInvoker start, auto delete: false
21:03:47 T:34761699328  NOTICE: -->Python Interpreter Initialized<--
22:23:19 T:34779464704  NOTICE: Thread JobWorker start, auto delete: true
22:23:20 T:34691186688  NOTICE: Thread FileCache start, auto delete: false
04:23:32 T:34784229376  NOTICE: Previous line repeats 1 times.
04:23:32 T:34784229376  NOTICE: Thread JobWorker start, auto delete: true
04:23:33 T:34761703424  NOTICE: Thread FileCache start, auto delete: false
 
Re: Airtunes on XBMC

I managed to find what the problem was: airtunes was listening on ipv6 only, but I had only assigned a static ipv4 ip address for the computer. I discovered this by enabling debug logging for XBMC and AirTunes by adding a new file to the xbmc directory ~/.xbmc/userdata/advancedsettings.xml with the following lines:
Code: 
<advancedsettings>
  <loglevel>1</loglevel>
  <enableairtunesdebuglog>1</enableairtunesdebuglog>
</advancedsettings>

After doing this, my ~/.xbmc/temp/xbmc.log file looks like this:
Code: 
08:42:33 T:34611422208  NOTICE: special://profile/ is mapped to: special://masterprofile/
08:42:33 T:34611422208  NOTICE: -----------------------------------------------------------------------
08:42:33 T:34611422208  NOTICE: Starting XBMC (13.0-BETA1 Git:Unknown). Platform: x86 FreeBSD 64-bit
08:42:33 T:34611422208  NOTICE: Using Release XBMC x64 build, compiled Mar 11 2014 by Clang 3.3.0 for x86 FreeBSD 64-bit version 1000510
08:42:33 T:34611422208  NOTICE: Running on FreeBSD 64-bit 10.0-RELEASE amd64
08:42:33 T:34611422208  NOTICE: Host CPU: Intel(R) Atom(TM) CPU D2700 @ 2.13GHz, 4 cores available
08:42:33 T:34611422208  NOTICE: special://xbmc/ is mapped to: /usr/local/share/xbmc
08:42:33 T:34611422208  NOTICE: special://xbmcbin/ is mapped to: /usr/local/lib/xbmc
08:42:33 T:34611422208  NOTICE: special://masterprofile/ is mapped to: /home/xbmc/.xbmc/userdata
08:42:33 T:34611422208  NOTICE: special://home/ is mapped to: /home/xbmc/.xbmc
08:42:33 T:34611422208  NOTICE: special://temp/ is mapped to: /home/xbmc/.xbmc/temp
08:42:33 T:34611422208  NOTICE: The executable running is: /usr/local/lib/xbmc/xbmc.bin
08:42:33 T:34611422208  NOTICE: Local hostname: zbox.local
08:42:33 T:34611422208  NOTICE: Log File is located: /home/xbmc/.xbmc/temp/xbmc.log
08:42:33 T:34611422208  NOTICE: -----------------------------------------------------------------------
08:42:33 T:34611422208  NOTICE: load settings...
08:42:33 T:34611422208  NOTICE: Found 1 Lists of Devices
08:42:33 T:34611422208  NOTICE: Enumerated OSS devices:
08:42:33 T:34611422208  NOTICE:     Device 1
08:42:33 T:34611422208  NOTICE:         m_deviceName      : /dev/dsp0
08:42:33 T:34611422208  NOTICE:         m_displayName     : pcm0 Realtek ALC892 (Rear Analog)
08:42:33 T:34611422208  NOTICE:         m_displayNameExtra:
08:42:33 T:34611422208  NOTICE:         m_deviceType      : AE_DEVTYPE_PCM
08:42:33 T:34611422208  NOTICE:         m_channels        : FL,FR
08:42:33 T:34611422208  NOTICE:         m_sampleRates     : 44100,48000,64000,88200,96000,176400,192000
08:42:33 T:34611422208  NOTICE:         m_dataFormats     :
08:42:33 T:34611422208  NOTICE:     Device 2
08:42:33 T:34611422208  NOTICE:         m_deviceName      : /dev/dsp1
08:42:33 T:34611422208  NOTICE:         m_displayName     : pcm1 Realtek ALC892 (Rear Digital)
08:42:33 T:34611422208  NOTICE:         m_displayNameExtra:
08:42:33 T:34611422208  NOTICE:         m_deviceType      : AE_DEVTYPE_IEC958
08:42:33 T:34611422208  NOTICE:         m_channels        : FL,FR
08:42:33 T:34611422208  NOTICE:         m_sampleRates     : 48000
08:42:33 T:34611422208  NOTICE:         m_dataFormats     :
08:42:33 T:34611422208  NOTICE:     Device 3
08:42:33 T:34611422208  NOTICE:         m_deviceName      : /dev/dsp2
08:42:33 T:34611422208  NOTICE:         m_displayName     : pcm2 NVIDIA (0x001c) (HDMI/DP 8ch)
08:42:33 T:34611422208  NOTICE:         m_displayNameExtra:
08:42:33 T:34611422208  NOTICE:         m_deviceType      : AE_DEVTYPE_HDMI
08:42:33 T:34611422208  NOTICE:         m_channels        : FL,FR
08:42:33 T:34611422208  NOTICE:         m_sampleRates     : 44100,48000,64000,88200,96000,176400,192000
08:42:33 T:34611422208  NOTICE:         m_dataFormats     :
08:42:33 T:34611422208  NOTICE:     Device 4
08:42:33 T:34611422208  NOTICE:         m_deviceName      : /dev/dsp3
08:42:33 T:34611422208  NOTICE:         m_displayName     : pcm3 NVIDIA (0x001c) (HDMI/DP 8ch)
08:42:33 T:34611422208  NOTICE:         m_displayNameExtra:
08:42:33 T:34611422208  NOTICE:         m_deviceType      : AE_DEVTYPE_HDMI
08:42:33 T:34611422208  NOTICE:         m_channels        : FL,FR
08:42:33 T:34611422208  NOTICE:         m_sampleRates     : 48000
08:42:33 T:34611422208  NOTICE:         m_dataFormats     :
08:42:33 T:34611422208  NOTICE: No settings file to load (special://xbmc/system/advancedsettings.xml)
08:42:33 T:34611422208  NOTICE: Loaded settings file from special://profile/advancedsettings.xml
08:42:33 T:34611422208  NOTICE: Contents of special://profile/advancedsettings.xml are...
                                            <advancedsettings>
                                              <loglevel>1</loglevel>
                                              <enableairtunesdebuglog>1</enableairtunesdebuglog>
                                            </advancedsettings>
08:42:33 T:34611422208  NOTICE: Log level changed to 1
08:42:33 T:34611422208  NOTICE: Default DVD Player: dvdplayer
08:42:33 T:34611422208  NOTICE: Default Video Player: dvdplayer
08:42:33 T:34611422208  NOTICE: Default Audio Player: paplayer
08:42:33 T:34611422208  NOTICE: Disabled debug logging due to GUI setting. Level 1.
08:42:33 T:34611422208  NOTICE: Log level changed to 1
08:42:33 T:34611422208  NOTICE: CMediaSourceSettings: loading media sources from special://masterprofile/sources.xml
08:42:33 T:34611422208  NOTICE: Loading player core factory settings from special://xbmc/system/playercorefactory.xml.
08:42:33 T:34611422208   DEBUG: CPlayerCoreConfig::<ctor>: created player DVDPlayer for core 1
08:42:33 T:34611422208   DEBUG: CPlayerCoreConfig::<ctor>: created player oldmplayercore for core 1
08:42:33 T:34611422208   DEBUG: CPlayerCoreConfig::<ctor>: created player PAPlayer for core 3
08:42:33 T:34611422208   DEBUG: CPlayerSelectionRule::Initialize: creating rule: system rules
08:42:33 T:34611422208   DEBUG: CPlayerSelectionRule::Initialize: creating rule: rtv
08:42:33 T:34611422208   DEBUG: CPlayerSelectionRule::Initialize: creating rule: hdhomerun/myth/mms/udp
08:42:33 T:34611422208   DEBUG: CPlayerSelectionRule::Initialize: creating rule: lastfm/shout
08:42:33 T:34611422208   DEBUG: CPlayerSelectionRule::Initialize: creating rule: rtmp
08:42:33 T:34611422208   DEBUG: CPlayerSelectionRule::Initialize: creating rule: rtsp
08:42:33 T:34611422208   DEBUG: CPlayerSelectionRule::Initialize: creating rule: streams
08:42:33 T:34611422208   DEBUG: CPlayerSelectionRule::Initialize: creating rule: aacp/sdp
08:42:33 T:34611422208   DEBUG: CPlayerSelectionRule::Initialize: creating rule: mp2
08:42:33 T:34611422208   DEBUG: CPlayerSelectionRule::Initialize: creating rule: dvd
08:42:33 T:34611422208   DEBUG: CPlayerSelectionRule::Initialize: creating rule: dvdimage
08:42:33 T:34611422208   DEBUG: CPlayerSelectionRule::Initialize: creating rule: sdp/asf
08:42:33 T:34611422208   DEBUG: CPlayerSelectionRule::Initialize: creating rule: nsv
08:42:33 T:34611422208   DEBUG: CPlayerSelectionRule::Initialize: creating rule: radio
08:42:33 T:34611422208  NOTICE: Loaded playercorefactory configuration
08:42:33 T:34611422208  NOTICE: Loading player core factory settings from special://masterprofile/playercorefactory.xml.
08:42:33 T:34611422208  NOTICE: special://masterprofile/playercorefactory.xml does not exist. Skipping.
08:42:33 T:34611422208  NOTICE: LoadFromXML - unable to load:/home/xbmc/.xbmc/userdata/wakeonlan.xml
08:42:33 T:34611422208    INFO: creating subdirectories
08:42:33 T:34611422208    INFO: userdata folder: special://masterprofile/
08:42:33 T:34611422208    INFO: recording folder:
08:42:33 T:34611422208    INFO: screenshots folder:
08:42:33 T:34611422208    INFO: load language info file: special://xbmc/language/English/langinfo.xml
08:42:33 T:34611422208   DEBUG: trying to set locale to en_AU.UTF-8
08:42:33 T:34611422208    INFO: global locale set to en_AU.UTF-8
08:42:33 T:34611422208    INFO: load English language file, from path: special://xbmc/language/
08:42:33 T:34611422208   DEBUG: POParser: loaded 3165 strings from file /usr/local/share/xbmc/language/English/strings.po
08:42:33 T:34611422208   DEBUG: SECTION:LoadDLL(special://xbmcbin/system/players/dvdplayer/avutil-52-x86_64-freebsd.so)
08:42:33 T:34611422208   DEBUG: Loading: /usr/local/lib/xbmc/system/players/dvdplayer/avutil-52-x86_64-freebsd.so
08:42:33 T:34611422208   DEBUG: SECTION:LoadDLL(special://xbmcbin/system/players/dvdplayer/avcodec-54-x86_64-freebsd.so)
08:42:33 T:34611422208   DEBUG: Loading: /usr/local/lib/xbmc/system/players/dvdplayer/avcodec-54-x86_64-freebsd.so
08:42:33 T:34611422208   DEBUG: SECTION:LoadDLL(special://xbmcbin/system/players/dvdplayer/avformat-54-x86_64-freebsd.so)
08:42:33 T:34611422208   DEBUG: Loading: /usr/local/lib/xbmc/system/players/dvdplayer/avformat-54-x86_64-freebsd.so
08:42:33 T:34611426304  NOTICE: Thread ActiveAE start, auto delete: false
08:42:33 T:34653590528  NOTICE: Thread AESink start, auto delete: false
08:42:33 T:34653590528    INFO: CActiveAESink::OpenSink - initialize sink
08:42:33 T:34653590528   DEBUG: CActiveAESink::OpenSink - trying to open device OSS:/dev/dsp1
08:42:33 T:34653590528    INFO: CAESinkOSS::Initialize - Your hardware does not support AE_FMT_FLOAT, trying other formats
08:42:33 T:34653590528   DEBUG: CActiveAESink::OpenSink - OSS Initialized:
08:42:33 T:34653590528   DEBUG:   Output Device : pcm1 Realtek ALC892 (Rear Digital)
08:42:33 T:34653590528   DEBUG:   Sample Rate   : 44100
08:42:33 T:34653590528   DEBUG:   Sample Format : AE_FMT_S32NE
08:42:33 T:34653590528   DEBUG:   Channel Count : 2
08:42:33 T:34653590528   DEBUG:   Channel Layout: FL,FR
08:42:33 T:34653590528   DEBUG:   Frames        : 256
08:42:33 T:34653590528   DEBUG:   Frame Samples : 512
08:42:33 T:34653590528   DEBUG:   Frame Size    : 8
08:42:33 T:34611426304   DEBUG: SECTION:LoadDLL(special://xbmcbin/system/players/dvdplayer/swresample-0-x86_64-freebsd.so)
08:42:33 T:34611426304   DEBUG: Loading: /usr/local/lib/xbmc/system/players/dvdplayer/swresample-0-x86_64-freebsd.so
08:42:33 T:34611422208  NOTICE: Running database version Addons16
08:42:33 T:34611422208   DEBUG: SECTION:LoadDLL(special://xbmcbin/system/libcpluff-x86_64-freebsd.so)
08:42:33 T:34611422208   DEBUG: Loading: /usr/local/lib/xbmc/system/libcpluff-x86_64-freebsd.so
08:42:33 T:34611422208    INFO: ADDON: cpluff: 'Could not read plug-in directory /usr/local/lib/xbmc/addons: No such file or directory'
08:42:33 T:34611422208   DEBUG: ADDON: cpluff: 'Plug-in xbmc.json has been installed.'
08:42:33 T:34611422208   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.fanart.tv has been installed.'
08:42:33 T:34611422208   DEBUG: ADDON: cpluff: 'Plug-in repository.xbmc.org has been installed.'
08:42:33 T:34611422208   DEBUG: ADDON: cpluff: 'Plug-in visualization.fishbmc has been installed.'
08:42:33 T:34611422208   DEBUG: ADDON: cpluff: 'Plug-in webinterface.default has been installed.'
08:42:33 T:34611422208   DEBUG: ADDON: cpluff: 'Plug-in screensaver.xbmc.builtin.black has been installed.'
08:42:33 T:34611422208   DEBUG: ADDON: cpluff: 'Plug-in visualization.vortex has been installed.'
08:42:33 T:34611422208   DEBUG: ADDON: cpluff: 'Plug-in screensaver.rsxs.euphoria has been installed.'
08:42:33 T:34611422208   DEBUG: ADDON: cpluff: 'Plug-in script.plexbmc.helper has been installed.'
08:42:33 T:34611422208   DEBUG: ADDON: cpluff: 'Plug-in visualization.projectm has been installed.'
08:42:33 T:34611422208   DEBUG: ADDON: cpluff: 'Plug-in script.module.simplejson has been installed.'
08:42:33 T:34611422208   DEBUG: ADDON: cpluff: 'Plug-in weather.wunderground has been installed.'
08:42:33 T:34611422208   DEBUG: ADDON: cpluff: 'Plug-in screensaver.xbmc.builtin.dim has been installed.'
08:42:33 T:34611422208   DEBUG: ADDON: cpluff: 'Plug-in script.favourites has been installed.'
08:42:33 T:34611422208   DEBUG: ADDON: cpluff: 'Plug-in metadata.themoviedb.org has been installed.'
08:42:33 T:34611422208   DEBUG: ADDON: cpluff: 'Plug-in xbmc.metadata has been installed.'
08:42:33 T:34611422208   DEBUG: ADDON: cpluff: 'Plug-in service.xbmc.versioncheck has been installed.'
08:42:33 T:34611422208   DEBUG: ADDON: cpluff: 'Plug-in skin.confluence has been installed.'
08:42:33 T:34611422208   DEBUG: ADDON: cpluff: 'Plug-in visualization.glspectrum has been installed.'
08:42:33 T:34611422208   DEBUG: ADDON: cpluff: 'Plug-in script.module.pil has been installed.'
08:42:33 T:34611422208   DEBUG: ADDON: cpluff: 'Plug-in xbmc.gui has been installed.'
08:42:33 T:34611422208   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.amazon.de has been installed.'
08:42:33 T:34611422208   DEBUG: ADDON: cpluff: 'Plug-in metadata.musicvideos.theaudiodb.com has been installed.'
08:42:33 T:34611422208   DEBUG: ADDON: cpluff: 'Plug-in xbmc.core has been installed.'
08:42:33 T:34611422208   DEBUG: ADDON: cpluff: 'Plug-in screensaver.rsxs.solarwinds has been installed.'
08:42:33 T:34611422208   DEBUG: ADDON: cpluff: 'Plug-in xbmc.pvr has been installed.'
08:42:33 T:34611422208   DEBUG: ADDON: cpluff: 'Plug-in skin.quartz3.plexbmc has been installed.'
08:42:33 T:34611422208   DEBUG: ADDON: cpluff: 'Plug-in metadata.album.universal has been installed.'
08:42:33 T:34611422208   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.htbackdrops.com has been installed.'
08:42:33 T:34611422208   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.allmusic.com has been installed.'
08:42:33 T:34611422208   DEBUG: ADDON: cpluff: 'Plug-in plugin.video.plexbmc has been installed.'
08:42:33 T:34611422208   DEBUG: ADDON: cpluff: 'Plug-in metadata.tvdb.com has been installed.'
08:42:33 T:34611422208   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.musicbrainz.org has been installed.'
08:42:33 T:34611422208   DEBUG: ADDON: cpluff: 'Plug-in metadata.local has been installed.'
08:42:33 T:34611422208   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.last.fm has been installed.'
08:42:33 T:34611422208   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.themoviedb.org has been installed.'
08:42:33 T:34611422208   DEBUG: ADDON: cpluff: 'Plug-in xbmc.debug has been installed.'
08:42:33 T:34611422208   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.theaudiodb.com has been installed.'
08:42:33 T:34611422208   DEBUG: ADDON: cpluff: 'Plug-in metadata.artists.universal has been installed.'
08:42:33 T:34611422208   DEBUG: ADDON: cpluff: 'Plug-in xbmc.python has been installed.'
08:42:33 T:34611422208   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.imdb.com has been installed.'
08:42:33 T:34611422208   DEBUG: ADDON: cpluff: 'Plug-in visualization.waveform has been installed.'
08:42:33 T:34611422208   DEBUG: ADDON: cpluff: 'Plug-in screensaver.rsxs.plasma has been installed.'
08:42:33 T:34611422208   DEBUG: ADDON: cpluff: 'Plug-in xbmc.addon has been installed.'
08:42:33 T:34611422208   DEBUG: ADDON: cpluff: 'Plug-in xbmc.codec has been installed.'
08:42:33 T:34611422208   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.hdtrailers.net has been installed.'
08:42:33 T:34611422208   DEBUG: ADDON: cpluff: 'Not all directories were successfully scanned.'
08:42:33 T:34611422208  NOTICE: ADDONS: Using repository repository.xbmc.org
08:42:33 T:34611422208    INFO: LIRC Initialize: using: /dev/lircd
08:42:33 T:34611422208    INFO: LIRC Initialize: connect failed: No such file or directory
08:42:33 T:34611422208   DEBUG: Failed to connect to LIRC. Retry in 10s.
08:42:33 T:34611422208   DEBUG: LoadMappings - loaded node "Motorola Nyxboard Hybrid"
08:42:33 T:34611422208   DEBUG: LoadMappings - loaded node "CEC Adapter"
08:42:33 T:34611422208   DEBUG: LoadMappings - loaded node "Pulse-Eight CEC Adapter"
08:42:33 T:34611422208   DEBUG: LoadMappings - loaded node "iMON HID device"
08:42:33 T:34611422208   DEBUG: CPeripheralBusUSB - using libusb peripheral scanning
08:42:33 T:34611422208   DEBUG: SECTION:LoadDLL(libcec.so.2)
08:42:33 T:34611422208   DEBUG: Loading: libcec.so.2
08:42:33 T:34611429376  NOTICE: Thread PeripBusCEC start, auto delete: false
08:42:33 T:34611430400  NOTICE: Thread PeripBusUSB start, auto delete: false
08:42:33 T:34611422208   DEBUG: UDisks: org.freedesktop.DBus.Error.ServiceUnknown - The name org.freedesktop.UDisks was not provided by any .service files
08:42:33 T:34611422208   DEBUG: DeviceKit.Disks: org.freedesktop.DBus.Error.ServiceUnknown - The name org.freedesktop.DeviceKit.Disks was not provided by any .service files
08:42:33 T:34611422208   DEBUG: Selected HAL as storage provider
08:42:33 T:34611422208    INFO: HAL: Starting initializing
08:42:33 T:34611422208   ERROR: HAL: Failed to initialize hal context: (null)
08:42:33 T:34611422208   ERROR: HAL: no Hal context
08:42:33 T:34611422208  NOTICE: Setup SDL
08:42:34 T:34611422208    INFO: Available videomodes (xrandr):
08:42:34 T:34611422208    INFO: Number of connected outputs: 1
08:42:34 T:34611422208    INFO: Output 'HDMI-0' has 15 modes
08:42:34 T:34611422208    INFO: ID:0x27d Name:1920x1080 Refresh:25.022240 Width:1920 Height:1080
08:42:34 T:34611422208    INFO: Pixel Ratio: 0.999067
08:42:34 T:34611422208    INFO: ID:0x27e Name:1920x1080 Refresh:30.026690 Width:1920 Height:1080
08:42:34 T:34611422208    INFO: Pixel Ratio: 0.999067
08:42:34 T:34611422208    INFO: ID:0x27f Name:1920x1080 Refresh:29.998381 Width:1920 Height:1080
08:42:34 T:34611422208    INFO: Pixel Ratio: 0.999067
08:42:34 T:34611422208    INFO: ID:0x280 Name:1280x720 Refresh:60.000000 Width:1280 Height:720
08:42:34 T:34611422208    INFO: Pixel Ratio: 0.999067
08:42:34 T:34611422208    INFO: ID:0x281 Name:1280x720 Refresh:59.943432 Width:1280 Height:720
08:42:34 T:34611422208    INFO: Pixel Ratio: 0.999067
08:42:34 T:34611422208    INFO: ID:0x282 Name:1280x720 Refresh:50.000000 Width:1280 Height:720
08:42:34 T:34611422208    INFO: Pixel Ratio: 0.999067
08:42:34 T:34611422208    INFO: ID:0x283 Name:800x600 Refresh:60.316540 Width:800 Height:600
08:42:34 T:34611422208    INFO: Pixel Ratio: 1.332090
08:42:34 T:34611422208    INFO: ID:0x284 Name:800x600 Refresh:56.250000 Width:800 Height:600
08:42:34 T:34611422208    INFO: Pixel Ratio: 1.332090
08:42:34 T:34611422208    INFO: ID:0x285 Name:720x576 Refresh:50.000000 Width:720 Height:576
08:42:34 T:34611422208    INFO: Pixel Ratio: 1.420895
08:42:34 T:34611422208    INFO: ID:0x286 Name:720x576 Refresh:25.040060 Width:720 Height:576
08:42:34 T:34611422208    INFO: Pixel Ratio: 1.420895
08:42:34 T:34611422208    INFO: ID:0x287 Name:720x480 Refresh:59.940060 Width:720 Height:480
08:42:34 T:34611422208    INFO: Pixel Ratio: 1.184080
08:42:34 T:34611422208    INFO: ID:0x288 Name:720x480 Refresh:30.027220 Width:720 Height:480
08:42:34 T:34611422208    INFO: Pixel Ratio: 1.184080
08:42:34 T:34611422208    INFO: ID:0x289 Name:640x480 Refresh:59.928570 Width:640 Height:480
08:42:34 T:34611422208    INFO: Pixel Ratio: 1.332090
08:42:34 T:34611422208    INFO: ID:0x28a Name:640x480 Refresh:59.940479 Width:640 Height:480
08:42:34 T:34611422208    INFO: Pixel Ratio: 1.332090
08:42:34 T:34611422208    INFO: ID:0x28b Name:320x240 Refresh:120.104958 Width:320 Height:240
08:42:34 T:34611422208    INFO: Pixel Ratio: 1.332090
08:42:34 T:34611422208  NOTICE: Checking resolution 16
08:42:34 T:34611422208   DEBUG: OnLostDevice - notify display change event
08:42:34 T:34611422208    INFO: XRANDR: /usr/local/lib/xbmc/xbmc-xrandr --output HDMI-0 --mode 0x280
08:42:34 T:34611422208  NOTICE: Using visual 0x73
08:42:34 T:34611422208    INFO: GL: Maximum texture width: 16384
08:42:34 T:34611422208   DEBUG: SECTION:LoadDLL(special://xbmcbin/system/ImageLib-x86_64-freebsd.so)
08:42:34 T:34611422208   DEBUG: Loading: /usr/local/lib/xbmc/system/ImageLib-x86_64-freebsd.so
08:42:34 T:34611422208   DEBUG: GLX_EXTENSIONS: GLX_EXT_visual_info GLX_EXT_visual_rating GLX_SGIX_fbconfig GLX_SGIX_pbuffer GLX_SGI_video_sync GLX_SGI_swap_control GLX_EXT_swap_control GLX_EXT_swap_control_tear GLX_EXT_texture_from_pixmap GLX_EXT_buffer_age GLX_ARB_create_context GLX_ARB_create_context_profile GLX_EXT_create_context_es_profile GLX_EXT_create_context_es2_profile GLX_ARB_create_context_robustness GLX_ARB_multisample GLX_NV_float_buffer GLX_ARB_fbconfig_float GLX_EXT_framebuffer_sRGB GLX_NV_multisample_coverage GLX_ARB_get_proc_address
08:42:34 T:34611422208  NOTICE: GL_VENDOR = NVIDIA Corporation
08:42:34 T:34611422208  NOTICE: GL_RENDERER = GeForce GT 520M/PCIe/SSE2
08:42:34 T:34611422208  NOTICE: GL_VERSION = 4.4.0 NVIDIA 331.49
08:42:34 T:34611422208  NOTICE: GL_SHADING_LANGUAGE_VERSION = 4.40 NVIDIA via Cg compiler
08:42:34 T:34611422208  NOTICE: GL_GPU_MEMORY_INFO_TOTAL_AVAILABLE_MEMORY_NVX = 524288
08:42:34 T:34611422208  NOTICE: GL_GPU_MEMORY_INFO_DEDICATED_VIDMEM_NVX = 524288
08:42:34 T:34611422208  NOTICE: GL_EXTENSIONS = GL_AMD_multi_draw_indirect GL_ARB_arrays_of_arrays GL_ARB_base_instance GL_ARB_blend_func_extended GL_ARB_buffer_storage GL_ARB_clear_buffer_object GL_ARB_clear_texture GL_ARB_color_buffer_float GL_ARB_compatibility GL_ARB_compressed_texture_pixel_storage GL_ARB_conservative_depth GL_ARB_compute_shader GL_ARB_compute_variable_group_size GL_ARB_copy_buffer GL_ARB_copy_image GL_ARB_debug_output GL_ARB_depth_buffer_float GL_ARB_depth_clamp GL_ARB_depth_texture GL_ARB_draw_buffers GL_ARB_draw_buffers_blend GL_ARB_draw_indirect GL_ARB_draw_elements_base_vertex GL_ARB_draw_instanced GL_ARB_enhanced_layouts GL_ARB_ES2_compatibility GL_ARB_ES3_compatibility GL_ARB_explicit_attrib_location GL_ARB_explicit_uniform_location GL_ARB_fragment_coord_conventions GL_ARB_fragment_layer_viewport GL_ARB_fragment_program GL_ARB_fragment_program_shadow GL_ARB_fragment_shader GL_ARB_framebuffer_no_attachments GL_ARB_framebuffer_object GL_ARB_framebuffer_sRGB GL_ARB_geometry_shader4 GL_ARB_get_program_binary GL_ARB_gpu_shader5 GL_ARB_gpu_shader_fp64 GL_ARB_half_float_pixel GL_ARB_half_float_vertex GL_ARB_imaging GL_ARB_indirect_parameters GL_ARB_instanced_arrays GL_ARB_internalformat_query GL_ARB_internalformat_query2 GL_ARB_invalidate_subdata GL_ARB_map_buffer_alignment GL_ARB_map_buffer_range GL_ARB_multi_bind GL_ARB_multi_draw_indirect GL_ARB_multisample GL_ARB_multitexture GL_ARB_occlusion_query GL_ARB_occlusion_query2 GL_ARB_pixel_buffer_object GL_ARB_point_parameters GL_ARB_point_sprite GL_ARB_program_interface_query GL_ARB_provoking_vertex GL_ARB_robust_buffer_access_behavior GL_ARB_robustness GL_ARB_sample_shading GL_ARB_sampler_objects GL_ARB_seamless_cube_map GL_ARB_separate_shader_objects GL_ARB_shader_atomic_counters GL_ARB_shader_bit_encoding GL_ARB_shader_draw_parameters GL_ARB_shader_group_vote GL_ARB_shader_image_load_store GL_ARB_shader_image_size GL_ARB_shader_objects GL_ARB_shader_precision GL_ARB_query_buffer_object GL_ARB_shader_storage_buffer_object GL_ARB_shader_subroutine GL_ARB_shader_texture_lod GL_ARB_shading_language_100 GL_ARB_shading_language_420pack GL_ARB_shading_language_include GL_ARB_shading_language_packing GL_ARB_shadow GL_ARB_stencil_texturing GL_ARB_sync GL_ARB_tessellation_shader GL_ARB_texture_border_clamp GL_ARB_texture_buffer_object GL_ARB_texture_buffer_object_rgb32 GL_ARB_texture_buffer_range GL_ARB_texture_compression GL_ARB_texture_compression_bptc GL_ARB_texture_compression_rgtc GL_ARB_texture_cube_map GL_ARB_texture_cube_map_array 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_gather GL_ARB_texture_mirror_clamp_to_edge GL_ARB_texture_mirrored_repeat GL_ARB_texture_multisample GL_ARB_texture_non_power_of_two GL_ARB_texture_query_levels GL_ARB_texture_query_lod GL_ARB_texture_rectangle GL_ARB_texture_rg GL_ARB_texture_rgb10_a2ui GL_ARB_texture_stencil8 GL_ARB_texture_storage GL_ARB_texture_storage_multisample GL_ARB_texture_swizzle GL_ARB_texture_view GL_ARB_timer_query GL_ARB_transform_feedback2 GL_ARB_transform_feedback3 GL_ARB_transform_feedback_instanced GL_ARB_transpose_matrix GL_ARB_uniform_buffer_object GL_ARB_vertex_array_bgra GL_ARB_vertex_array_object GL_ARB_vertex_attrib_64bit GL_ARB_vertex_attrib_binding GL_ARB_vertex_buffer_object GL_ARB_vertex_program GL_ARB_vertex_shader GL_ARB_vertex_type_10f_11f_11f_rev GL_ARB_vertex_type_2_10_10_10_rev GL_ARB_viewport_array GL_ARB_window_pos GL_ATI_draw_buffers GL_ATI_texture_float GL_ATI_texture_mirror_once GL_S3_s3tc GL_EXT_texture_env_add GL_EXT_abgr GL_EXT_bgra GL_EXT_bindable_uniform GL_EXT_blend_color GL_EXT_blend_equation_separate GL_EXT_blend_func_separate GL_EXT_blend_minmax GL_EXT_blend_subtract GL_EXT_compiled_vertex_array GL_EXT_Cg_shader GL_EXT_depth_bounds_test GL_EXT_direct_state_access GL_EXT_draw_buffers2 GL_EXT_draw_instanced GL_EXT_draw_range_elements GL_EXT_fog_coord GL_EXT_framebuffer_blit GL_EXT_framebuffer_multisample GL_EXTX_framebuffer_mixed_formats GL_EXT_framebuffer_multisample_blit_scaled GL_EXT_framebuffer_object GL_EXT_framebuffer_sRGB GL_EXT_geometry_shader4 GL_EXT_gpu_program_parameters GL_EXT_gpu_shader4 GL_EXT_multi_draw_arrays GL_EXT_packed_depth_stencil GL_EXT_packed_float GL_EXT_packed_pixels GL_EXT_pixel_buffer_object GL_EXT_point_parameters GL_EXT_provoking_vertex GL_EXT_rescale_normal GL_EXT_secondary_color GL_EXT_separate_shader_objects GL_EXT_separate_specular_color GL_EXT_shader_image_load_store GL_EXT_shadow_funcs GL_EXT_stencil_two_side GL_EXT_stencil_wrap GL_EXT_texture3D GL_EXT_texture_array GL_EXT_texture_buffer_object GL_EXT_texture_compression_dxt1 GL_EXT_texture_compression_latc GL_EXT_texture_compression_rgtc GL_EXT_texture_compression_s3tc GL_EXT_texture_cube_map GL_EXT_texture_edge_clamp GL_EXT_texture_env_combine GL_EXT_texture_env_dot3 GL_EXT_texture_filter_anisotropic GL_EXT_texture_integer GL_EXT_texture_lod GL_EXT_texture_lod_bias GL_EXT_texture_mirror_clamp GL_EXT_texture_object GL_EXT_texture_shared_exponent GL_EXT_texture_sRGB GL_EXT_texture_sRGB_decode GL_EXT_texture_storage GL_EXT_texture_swizzle GL_EXT_timer_query GL_EXT_transform_feedback2 GL_EXT_vertex_array GL_EXT_vertex_array_bgra GL_EXT_vertex_attrib_64bit GL_EXT_x11_sync_object GL_EXT_import_sync_object GL_IBM_rasterpos_clip GL_IBM_texture_mirrored_repeat GL_KHR_debug GL_KTX_buffer_region GL_NV_bindless_multi_draw_indirect GL_NV_blend_equation_advanced GL_NV_blend_square GL_NV_compute_program5 GL_NV_conditional_render GL_NV_copy_depth_to_color GL_NV_copy_image GL_NV_depth_buffer_float GL_NV_depth_clamp GL_NV_draw_texture GL_NV_ES1_1_compatibility GL_NV_explicit_multisample GL_NV_fence GL_NV_float_buffer GL_NV_fog_distance GL_NV_fragment_program GL_NV_fragment_program_option GL_NV_fragment_program2 GL_NV_framebuffer_multisample_coverage GL_NV_geometry_shader4 GL_NV_gpu_program4 GL_NV_gpu_program4_1 GL_NV_gpu_program5 GL_NV_gpu_program5_mem_extended GL_NV_gpu_program_fp64 GL_NV_gpu_shader5 GL_NV_half_float GL_NV_light_max_exponent GL_NV_multisample_coverage GL_NV_multisample_filter_hint GL_NV_occlusion_query GL_NV_packed_depth_stencil GL_NV_parameter_buffer_object GL_NV_parameter_buffer_object2 GL_NV_path_rendering GL_NV_pixel_data_range GL_NV_point_sprite GL_NV_primitive_restart GL_NV_register_combiners GL_NV_register_combiners2 GL_NV_shader_atomic_counters GL_NV_shader_atomic_float GL_NV_shader_buffer_load GL_NV_shader_storage_buffer_object GL_ARB_sparse_texture GL_NV_texgen_reflection GL_NV_texture_barrier GL_NV_texture_compression_vtc GL_NV_texture_env_combine4 GL_NV_texture_expand_normal GL_NV_texture_multisample GL_NV_texture_rectangle GL_NV_texture_shader GL_NV_texture_shader2 GL_NV_texture_shader3 GL_NV_transform_feedback GL_NV_transform_feedback2 GL_NV_vdpau_interop GL_NV_vertex_array_range GL_NV_vertex_array_range2 GL_NV_vertex_attrib_integer_64bit GL_NV_vertex_buffer_unified_memory GL_NV_vertex_program GL_NV_vertex_program1_1 GL_NV_vertex_program2 GL_NV_vertex_program2_option GL_NV_vertex_program3 GL_NVX_conditional_render GL_NVX_gpu_memory_info GL_SGIS_generate_mipmap GL_SGIS_texture_lod GL_SGIX_depth_texture GL_SGIX_shadow GL_SUN_slice_accum
08:42:34 T:34611422208   DEBUG: OnLostDevice - notify display change event
08:42:34 T:34611422208   ERROR: GLX: Same window as before, refreshing context
08:42:34 T:34611422208    INFO: GL: Maximum texture width: 16384
08:42:34 T:34611422208   DEBUG: CRenderManager::UpdateDisplayLatency - Latency set to 0 msec
08:42:34 T:34611422208    INFO: load default splash image: /usr/local/share/xbmc/media/Splash.png
08:42:34 T:34611422208   DEBUG: CheckDisplayEvents: Received RandR event 122
08:42:34 T:34611422208   DEBUG: CheckDisplayEvents - notify display reset event
08:42:34 T:34611422208    INFO: load keymapping
08:42:34 T:34611422208    INFO: Loading special://xbmc/system/keymaps/appcommand.xml
08:42:34 T:34611422208    INFO: Loading special://xbmc/system/keymaps/gamepad.xml
08:42:34 T:34611422208    INFO: Loading special://xbmc/system/keymaps/joystick.Alienware.Dual.Compatible.Controller.xml
08:42:34 T:34611422208    INFO: Loading special://xbmc/system/keymaps/joystick.AppleRemote.xml
08:42:34 T:34611422208    INFO: Loading special://xbmc/system/keymaps/joystick.Harmony.xml
08:42:34 T:34611422208    INFO: Loading special://xbmc/system/keymaps/joystick.Interact.AxisPad.xml
08:42:34 T:34611422208    INFO: Loading special://xbmc/system/keymaps/joystick.Logitech.RumblePad.2.xml
08:42:34 T:34611422208    INFO: Loading special://xbmc/system/keymaps/joystick.Microsoft.Xbox.360.Controller.xml
08:42:34 T:34611422208    INFO: Loading special://xbmc/system/keymaps/joystick.Microsoft.Xbox.Controller.S.xml
08:42:34 T:34611422208    INFO: Loading special://xbmc/system/keymaps/joystick.PS3.Remote.Keyboard.xml
08:42:34 T:34611422208    INFO: Loading special://xbmc/system/keymaps/joystick.Sony.PLAYSTATION(R)3.Controller.xml
08:42:34 T:34611422208    INFO: Loading special://xbmc/system/keymaps/joystick.WiiRemote.xml
08:42:34 T:34611422208    INFO: Loading special://xbmc/system/keymaps/joystick.xml
08:42:34 T:34611422208  NOTICE: No Joystick name specified, loading default map
08:42:34 T:34611422208  NOTICE: Previous line repeats 35 times.
08:42:34 T:34611422208    INFO: Loading special://xbmc/system/keymaps/keyboard.xml
08:42:34 T:34611422208    INFO: Loading special://xbmc/system/keymaps/mouse.xml
08:42:34 T:34611422208    INFO: Loading special://xbmc/system/keymaps/remote.xml
08:42:34 T:34611422208    INFO: Loading special://xbmc/system/keymaps/touchscreen.xml
08:42:34 T:34611422208    INFO: Loading special://xbmc/system/Lircmap.xml
08:42:34 T:34611422208    INFO: * Adding remote mapping for device 'mceusb'
08:42:34 T:34611422208    INFO: * Adding remote mapping for device 'XboxDVDDongle'
08:42:34 T:34611422208    INFO: * Adding remote mapping for device 'Microsoft_Xbox'
08:42:34 T:34611422208    INFO: * Adding remote mapping for device 'PinnacleSysPCTVRemote'
08:42:34 T:34611422208    INFO: * Adding remote mapping for device 'anysee'
08:42:34 T:34611422208    INFO: * Adding remote mapping for device 'iMON-PAD'
08:42:34 T:34611422208    INFO: * Adding remote mapping for device 'Antec_Veris_RM200'
08:42:34 T:34611422208    INFO: * Adding remote mapping for device 'MCE_via_iMON'
08:42:34 T:34611422208    INFO: * Adding remote mapping for device 'TwinHanRemote'
08:42:34 T:34611422208    INFO: * Adding remote mapping for device 'linux-input-layer'
08:42:34 T:34611422208    INFO: * Linking remote mapping for 'linux-input-layer' to 'cx23885_remote'
08:42:34 T:34611422208    INFO: * Adding remote mapping for device 'mediacenter'
08:42:34 T:34611422208    INFO: * Adding remote mapping for device 'devinput'
08:42:34 T:34611422208   DEBUG: CButtonTranslator::Load - no userdata Lircmap.xml found, skipping
08:42:34 T:34611422208    INFO: GUI format 1280x720, Display 1280x720@ 60.00 - Full Screen
08:42:34 T:34611422208   DEBUG: guilib: Fill viewport on change for solving rendering passes
08:42:34 T:34611422208   DEBUG: SECTION:LoadDLL(libcurl.so.7)
08:42:34 T:34611422208   DEBUG: Loading: libcurl.so.7
08:42:34 T:34611422208  NOTICE: Running database version Addons16
08:42:34 T:34611422208   DEBUG: Initialize, updating databases...
08:42:34 T:34611422208  NOTICE: Running database version ViewModes6
08:42:34 T:34611422208  NOTICE: Running database version Textures13
08:42:34 T:34611422208  NOTICE: Running database version MyMusic46
08:42:34 T:34611422208  NOTICE: Running database version MyVideos78
08:42:34 T:34611422208  NOTICE: Running database version TV22
08:42:34 T:34611422208  NOTICE: Running database version Epg7
08:42:34 T:34611422208   DEBUG: Initialize, updating databases... DONE
08:42:34 T:34611422208  NOTICE: start dvd mediatype detection
08:42:34 T:34611422208  NOTICE: initializing playlistplayer
08:42:34 T:34611422208  NOTICE: DONE initializing playlistplayer
08:42:34 T:34674125824  NOTICE: Thread DetectDVDMedia start, auto delete: false
08:42:34 T:34674125824   DEBUG: Compiled with libcdio Version 0.83
08:42:34 T:34611422208   DEBUG: DPMS: supported power-saving modes: SUSPEND OFF STANDBY
08:42:34 T:34674125824   DEBUG: Thread DetectDVDMedia 34674125824 terminating
08:42:34 T:34611422208   DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc
08:42:34 T:34611422208   DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnClear
08:42:34 T:34611422208    INFO: Unloading old skin ...
08:42:34 T:34611422208    INFO:   load skin from: /home/xbmc/.xbmc/addons/skin.quartzV3.plexbmc (version: 0.7.5)
08:42:34 T:34611422208    INFO:   load fonts for skin...
08:42:34 T:34611422208    INFO: Loading fonts from /home/xbmc/.xbmc/addons/skin.quartzV3.plexbmc/1080i/Font.xml
08:42:34 T:34611422208   DEBUG: LocalizeStrings: no strings.po file exist at /home/xbmc/.xbmc/addons/skin.quartzV3.plexbmc/language/English, fallback to strings.xml
08:42:34 T:34611422208    INFO: Loading skin includes from /home/xbmc/.xbmc/addons/skin.quartzV3.plexbmc/1080i/Includes.xml
08:42:34 T:34611422208    INFO:   load new skin...
08:42:34 T:34611422208    INFO: Loading user windows, path /home/xbmc/.xbmc/addons/skin.quartzV3.plexbmc/1080i
08:42:35 T:34611422208   DEBUG: Load Skin XML: 42.90ms
08:42:35 T:34611422208    INFO:   initialize new skin...
08:42:35 T:34611422208   DEBUG: guilib: Fill viewport on change for solving rendering passes
08:42:35 T:34611422208    INFO: Loading skin file: Pointer.xml, load type: LOAD_ON_GUI_INIT
08:42:35 T:34611422208    INFO: Loading skin file: DialogVolumeBar.xml, load type: LOAD_ON_GUI_INIT
08:42:35 T:34611422208    INFO: Loading skin file: DialogKaiToast.xml, load type: LOAD_ON_GUI_INIT
08:42:35 T:34611422208    INFO: Loading skin file: DialogMuteBug.xml, load type: LOAD_ON_GUI_INIT
08:42:35 T:34611422208    INFO: Loading skin file: DialogSeekBar.xml, load type: LOAD_ON_GUI_INIT
08:42:35 T:34611422208 WARNING: CreateFile, successfuly opened </home/xbmc/.xbmc/addons/skin.quartzV3.plexbmc/1080i/DialogSeekbar.xml> instead of </home/xbmc/.xbmc/addons/skin.quartzv3.plexbmc/1080i/dialogseekbar.xml>
08:42:35 T:34611422208    INFO: Loading skin file: DialogBusy.xml, load type: LOAD_ON_GUI_INIT
08:42:35 T:34611422208    INFO: Loading skin file: DialogExtendedProgressBar.xml, load type: LOAD_ON_GUI_INIT
08:42:35 T:34611422208    INFO: Loading /home/xbmc/.xbmc/addons/skin.quartzV3.plexbmc/sounds/sounds.xml
08:42:35 T:34611422208    INFO:   skin loaded...
08:42:35 T:34611422208   DEBUG: JSONRPC: JSON schema type stereoscopicmode references an unknown type GUI.Stereoscopy.Mode
08:42:35 T:34611422208   ERROR: JSONRPC: Could not parse type "GUI.Property.Value"
08:42:35 T:34611422208    INFO: JSONRPC: Adding type "GUI.Property.Value" to list of incomplete definitions (waiting for "GUI.Stereoscopy.Mode")
08:42:35 T:34611422208    INFO: JSONRPC: Resolving incomplete types/methods referencing GUI.Stereoscopy.Mode
08:42:35 T:34611422208   DEBUG: JSONRPC: JSON schema type definition references an unknown type Setting.Details.Setting
08:42:35 T:34611422208   ERROR: JSONRPC: Could not parse type "Setting.Details.SettingList"
08:42:35 T:34611422208    INFO: JSONRPC: Adding type "Setting.Details.SettingList" to list of incomplete definitions (waiting for "Setting.Details.Setting")
08:42:35 T:34611422208    INFO: JSONRPC: Resolving incomplete types/methods referencing Setting.Details.Setting
08:42:35 T:34611422208    INFO: JSONRPC v6.14.0: Successfully initialized
08:42:35 T:34611422208   DEBUG: ADDON: Starting service addons.
08:42:35 T:34674155520  NOTICE: Thread LanguageInvoker start, auto delete: false
08:42:35 T:34611422208   DEBUG: Activating window ID: 12999
08:42:35 T:34674155520    INFO: initializing python engine.
08:42:35 T:34611422208   DEBUG: ------ Window Init (Startup.xml) ------
08:42:35 T:34611422208    INFO: Loading skin file: Startup.xml, load type: LOAD_EVERY_TIME
08:42:35 T:34611422208    INFO: removing tempfiles
08:42:35 T:34611422208   DEBUG: ADDON: Starting service addons.
08:42:35 T:34611422208  NOTICE: initialize done
08:42:35 T:34674156544  NOTICE: Thread LanguageInvoker start, auto delete: false
08:42:35 T:34674156544    INFO: initializing python engine.
08:42:35 T:34611422208  NOTICE: Running the application...
08:42:35 T:34611422208   DEBUG: ExecuteXBMCAction : Translating action string
08:42:35 T:34611422208 WARNING: Label Formating: $VAR[WatchlistParameters] is not defined
08:42:35 T:34611422208   DEBUG: ExecuteXBMCAction : Translating action string
08:42:35 T:34611422208   DEBUG: Previous line repeats 1 times.
08:42:35 T:34611422208   DEBUG: Activating window ID: 10000
08:42:35 T:34611422208   DEBUG: ------ Window Deinit (Startup.xml) ------
08:42:35 T:34611422208   DEBUG: ------ Window Init (Home.xml) ------
08:42:35 T:34611422208    INFO: Loading skin file: Home.xml, load type: KEEP_IN_MEMORY
08:42:35 T:34674155520   DEBUG: CPythonInvoker(0, /home/xbmc/.xbmc/addons/service.xbmc.versioncheck/service.py): start processing
08:42:35 T:34674156544   DEBUG: CPythonInvoker(1, /home/xbmc/.xbmc/addons/script.plexbmc.helper/default.py): start processing
08:42:35 T:34674155520  NOTICE: -->Python Interpreter Initialized<--
08:42:35 T:34674155520   DEBUG: CPythonInvoker(0, /home/xbmc/.xbmc/addons/service.xbmc.versioncheck/service.py): the source file to load is /home/xbmc/.xbmc/addons/service.xbmc.versioncheck/service.py
08:42:35 T:34674155520   DEBUG: CPythonInvoker(0, /home/xbmc/.xbmc/addons/service.xbmc.versioncheck/service.py): setting the Python path to /home/xbmc/.xbmc/addons/service.xbmc.versioncheck:/home/xbmc/.xbmc/addons/script.module.simplejson/lib:/usr/local/share/xbmc/addons/script.module.pil/lib:/usr/local/share/xbmc/addons/xbmc.debug/:/usr/local/lib/python27.zip:/usr/local/lib/python2.7:/usr/local/lib/python2.7/plat-freebsd10:/usr/local/lib/python2.7/lib-tk:/usr/local/lib/python2.7/lib-old:/usr/local/lib/python2.7/lib-dynload:/usr/local/lib/python2.7/site-packages:/usr/local/lib/python2.7/site-packages/PIL
08:42:35 T:34674155520   DEBUG: CPythonInvoker(0, /home/xbmc/.xbmc/addons/service.xbmc.versioncheck/service.py): entering source directory /home/xbmc/.xbmc/addons/service.xbmc.versioncheck
08:42:35 T:34674155520   DEBUG: CPythonInvoker(0, /home/xbmc/.xbmc/addons/service.xbmc.versioncheck/service.py): instantiating addon using automatically obtained id of "service.xbmc.versioncheck" dependent on version 2.1.0 of the xbmc.python api
08:42:35 T:34674155520   DEBUG: XBMC Version Check: Version 0.1.19 started
08:42:35 T:34761986048  NOTICE: Thread JobWorker start, auto delete: true
08:42:35 T:34761986048   DEBUG: CRecentlyAddedJob::UpdateMusic() - Running RecentlyAdded home screen update
08:42:35 T:34611422208   DEBUG: ExecuteXBMCAction : Translating action string
08:42:35 T:34761988096   DEBUG: Previous line repeats 1 times.
08:42:35 T:34761988096  NOTICE: Thread LanguageInvoker start, auto delete: false
08:42:35 T:34761988096    INFO: initializing python engine.
08:42:35 T:34761988096   DEBUG: CPythonInvoker(2, /home/xbmc/.xbmc/addons/plugin.video.plexbmc/default.py): start processing
08:42:35 T:34611422208   DEBUG: ExecuteXBMCAction : Translating action string
08:42:35 T:34761990144  NOTICE: Thread LanguageInvoker start, auto delete: false
08:42:35 T:34761990144    INFO: initializing python engine.
08:42:35 T:34761990144   DEBUG: CPythonInvoker(3, /home/xbmc/.xbmc/addons/plugin.video.plexbmc/default.py): start processing
08:42:35 T:34611422208   DEBUG: no profile autoexec.py (/home/xbmc/.xbmc/userdata/autoexec.py) found, skipping
08:42:35 T:34611422208   DEBUG: NetworkMessage - Starting network services
08:42:35 T:34674155520    INFO: CPythonInvoker(0, /home/xbmc/.xbmc/addons/service.xbmc.versioncheck/service.py): script successfully run
08:42:35 T:34761992192  NOTICE: Thread LanguageInvoker start, auto delete: false
08:42:35 T:34761992192    INFO: initializing python engine.
08:42:35 T:34761992192   DEBUG: CPythonInvoker(4, /home/xbmc/.xbmc/addons/plugin.video.plexbmc/default.py): start processing
08:42:35 T:34611422208    INFO: CZeroconfAvahi::clientCallback: avahi server not available. But may become later...
08:42:35 T:34611422208  NOTICE: starting zeroconf publishing
08:42:35 T:34611422208  NOTICE: Webserver: Starting...
08:42:35 T:34611422208  NOTICE: WebServer: Started the webserver
08:42:35 T:34611422208  NOTICE: starting upnp renderer
08:42:35 T:34674155520    INFO: Python script stopped
08:42:35 T:34674155520   DEBUG: Thread LanguageInvoker 34674155520 terminating
08:42:35 T:34761986048   DEBUG: GetRecentlyAddedAlbumSongs() query: SELECT songview.* FROM (SELECT idAlbum FROM albumview ORDER BY idAlbum DESC LIMIT 10) AS recentalbums JOIN songview ON songview.idAlbum=recentalbums.idAlbum
08:42:35 T:34761994240  NOTICE: Thread JobWorker start, auto delete: true
08:42:35 T:34761994240   DEBUG: CZeroconfAvahi::doPublishService identifier: servers.webserver type: _http._tcp name:XBMC (zbox.local) port:8080
08:42:35 T:34761994240   DEBUG: CZeroconfAvahi::doPublishService: client not running, queued for publishing
08:42:35 T:34761994240   DEBUG: CZeroconfAvahi::doPublishService identifier: servers.jsonrpc-http type: _xbmc-jsonrpc-h._tcp name:XBMC (zbox.local) port:8080
08:42:35 T:34761994240   DEBUG: CZeroconfAvahi::doPublishService: client not running, queued for publishing
08:42:35 T:34761986048   DEBUG: GetRecentlyAddedAlbums query: select * from albumview where strAlbum != '' order by idAlbum desc limit 10
08:42:35 T:34761986048   DEBUG: CRecentlyAddedJob::UpdateVideos() - Running RecentlyAdded home screen update
08:42:35 T:34611422208  NOTICE: ES: Starting event server
08:42:35 T:34611422208    INFO: JSONRPC Server: Successfully initialized
08:42:35 T:34611422208    INFO: AIRPLAY Server: Successfully initialized
08:42:35 T:34611422208   DEBUG: SECTION:LoadDLL(libshairport.so.0)
08:42:35 T:34762001408  NOTICE: Thread TCPServer start, auto delete: false
08:42:35 T:34760258560  NOTICE: Thread AirPlayServer start, auto delete: false
08:42:35 T:34611422208   DEBUG: Loading: libshairport.so.0
08:42:35 T:34762000384  NOTICE: Thread EventServer start, auto delete: false
08:42:35 T:34762000384  NOTICE: ES: Starting UDP Event server on 0.0.0.0:9777
08:42:35 T:34762000384  NOTICE: UDP: Listening on port 9777
08:42:35 T:34761994240   DEBUG: CZeroconfAvahi::doPublishService identifier: servers.jsonrpc-tpc type: _xbmc-jsonrpc._tcp name:XBMC (zbox.local) port:9090
08:42:35 T:34761994240   DEBUG: CZeroconfAvahi::doPublishService: client not running, queued for publishing
08:42:35 T:34761994240   DEBUG: CZeroconfAvahi::doPublishService identifier: servers.airplay type: _airplay._tcp name:XBMC (zbox.local) port:36667
08:42:35 T:34611422208   DEBUG: AIRTUNES: initializing shairport
08:42:35 T:34611422208   DEBUG: AIRTUNES: LogLevel: 5
08:42:35 T:34611422208   DEBUG: AIRTUNES: AirName: ShairPort
08:42:35 T:34611422208   DEBUG: AIRTUNES: HWID: ݮ7
08:42:35 T:34611422208   DEBUG: AIRTUNES: HWID_Hex(12): B80305DDAE37
08:42:35 T:34611422208   DEBUG: AIRTUNES: Starting connection server: specified server port: 36666
08:42:35 T:34611422208   DEBUG: AIRTUNES: Listening on IPv6 Socket
08:42:35 T:34611422208   DEBUG: started alarm with name: checkatboot
08:42:35 T:34611422208   DEBUG: started alarm with name: checkwhilerunning
08:42:35 T:34760260608  NOTICE: Thread JobWorker start, auto delete: true
08:42:35 T:34760260608   DEBUG: CZeroconfAvahi::doPublishService identifier: servers.eventserver type: _xbmc-events._udp name:XBMC (zbox.local) port:9777
08:42:35 T:34761994240   DEBUG: CZeroconfAvahi::doPublishService: client not running, queued for publishing
08:42:35 T:34761994240   DEBUG: CZeroconfAvahi::doPublishService identifier: servers.airtunes type: _raop._tcp name:B80305DDAE37@XBMC (zbox.local) port:36666
08:42:35 T:34761994240   DEBUG: CZeroconfAvahi::doPublishService: client not running, queued for publishing
08:42:35 T:34760261632   DEBUG: Previous line repeats 1 times.
08:42:35 T:34760261632  NOTICE: Thread AlarmClock start, auto delete: false
08:42:35 T:34760259584  NOTICE: Thread AirTunesServer start, auto delete: false
08:42:35 T:34760259584   DEBUG: AIRTUNES: Waiting for clients to connect
08:42:35 T:34761986048   DEBUG: RunQuery took 2 ms for 0 items query: select * from movieview  ORDER BY dateAdded desc, idMovie desc LIMIT 10
08:42:35 T:34761986048   DEBUG: RunQuery took 2 ms for 0 items query: select * from episodeview  ORDER BY dateAdded desc, idEpisode desc LIMIT 10
08:42:35 T:34761986048   DEBUG: RunQuery took 2 ms for 0 items query: select * from musicvideoview  ORDER BY dateAdded desc, idMVideo desc LIMIT 10
08:42:35 T:34761986048   DEBUG: CRecentlyAddedJob::UpdateTotal() - Running RecentlyAdded home screen update
08:42:35 T:34761990144  NOTICE: -->Python Interpreter Initialized<--
08:42:35 T:34761990144   DEBUG: CPythonInvoker(3, /home/xbmc/.xbmc/addons/plugin.video.plexbmc/default.py): the source file to load is /home/xbmc/.xbmc/addons/plugin.video.plexbmc/default.py
08:42:35 T:34761990144   DEBUG: CPythonInvoker(3, /home/xbmc/.xbmc/addons/plugin.video.plexbmc/default.py): setting the Python path to /home/xbmc/.xbmc/addons/plugin.video.plexbmc:/home/xbmc/.xbmc/addons/script.module.simplejson/lib:/usr/local/share/xbmc/addons/script.module.pil/lib:/usr/local/share/xbmc/addons/xbmc.debug/:/usr/local/lib/python27.zip:/usr/local/lib/python2.7:/usr/local/lib/python2.7/plat-freebsd10:/usr/local/lib/python2.7/lib-tk:/usr/local/lib/python2.7/lib-old:/usr/local/lib/python2.7/lib-dynload:/usr/local/lib/python2.7/site-packages:/usr/local/lib/python2.7/site-packages/PIL
08:42:35 T:34761990144   DEBUG: CPythonInvoker(3, /home/xbmc/.xbmc/addons/plugin.video.plexbmc/default.py): entering source directory /home/xbmc/.xbmc/addons/plugin.video.plexbmc
08:42:35 T:34761990144   DEBUG: CPythonInvoker(3, /home/xbmc/.xbmc/addons/plugin.video.plexbmc/default.py): instantiating addon using automatically obtained id of "plugin.video.plexbmc" dependent on version 2.1.0 of the xbmc.python api
08:42:35 T:34611422208   DEBUG: ------ Window Init (Pointer.xml) ------
08:42:35 T:34611422208   DEBUG: ExecuteXBMCAction : Translating action string
08:42:36 T:34674156544  NOTICE: -->Python Interpreter Initialized<--
08:42:36 T:34674156544   DEBUG: CPythonInvoker(1, /home/xbmc/.xbmc/addons/script.plexbmc.helper/default.py): the source file to load is /home/xbmc/.xbmc/addons/script.plexbmc.helper/default.py
08:42:36 T:34761990144  NOTICE: ===== PLEXBMC START =====
08:42:36 T:34761990144  NOTICE: PleXBMC -> running Python: sys.version_info(major=2, minor=7, micro=6, releaselevel='final', serial=0)
08:42:36 T:34761990144  NOTICE: PleXBMC -> running PleXBMC: 3.1.5
08:42:36 T:34761992192  NOTICE: -->Python Interpreter Initialized<--
08:42:36 T:34761992192   DEBUG: CPythonInvoker(4, /home/xbmc/.xbmc/addons/plugin.video.plexbmc/default.py): the source file to load is /home/xbmc/.xbmc/addons/plugin.video.plexbmc/default.py
08:42:36 T:34674156544   DEBUG: CPythonInvoker(1, /home/xbmc/.xbmc/addons/script.plexbmc.helper/default.py): setting the Python path to /home/xbmc/.xbmc/addons/script.plexbmc.helper:/home/xbmc/.xbmc/addons/script.module.simplejson/lib:/usr/local/share/xbmc/addons/script.module.pil/lib:/usr/local/share/xbmc/addons/xbmc.debug/:/usr/local/lib/python27.zip:/usr/local/lib/python2.7:/usr/local/lib/python2.7/plat-freebsd10:/usr/local/lib/python2.7/lib-tk:/usr/local/lib/python2.7/lib-old:/usr/local/lib/python2.7/lib-dynload:/usr/local/lib/python2.7/site-packages:/usr/local/lib/python2.7/site-packages/PIL
08:42:36 T:34674156544   DEBUG: CPythonInvoker(1, /home/xbmc/.xbmc/addons/script.plexbmc.helper/default.py): entering source directory /home/xbmc/.xbmc/addons/script.plexbmc.helper
08:42:36 T:34674156544   DEBUG: CPythonInvoker(1, /home/xbmc/.xbmc/addons/script.plexbmc.helper/default.py): instantiating addon using automatically obtained id of "script.plexbmc.helper" dependent on version 2.1.0 of the xbmc.python api
08:42:36 T:34761988096  NOTICE: -->Python Interpreter Initialized<--
08:42:36 T:34761988096   DEBUG: CPythonInvoker(2, /home/xbmc/.xbmc/addons/plugin.video.plexbmc/default.py): the source file to load is /home/xbmc/.xbmc/addons/plugin.video.plexbmc/default.py
08:42:36 T:34761990144  NOTICE: PleXBMC -> Running with cElementTree on Python 2.5+
08:42:36 T:34761990144  NOTICE: PleXBMC -> Platform: Linux/RPi
08:42:36 T:34761990144  NOTICE: PleXBMC -> Debug is turned off.  Running silent
08:42:36 T:34761992192   DEBUG: CPythonInvoker(4, /home/xbmc/.xbmc/addons/plugin.video.plexbmc/default.py): setting the Python path to /home/xbmc/.xbmc/addons/plugin.video.plexbmc:/home/xbmc/.xbmc/addons/script.module.simplejson/lib:/usr/local/share/xbmc/addons/script.module.pil/lib:/usr/local/share/xbmc/addons/xbmc.debug/:/usr/local/lib/python27.zip:/usr/local/lib/python2.7:/usr/local/lib/python2.7/plat-freebsd10:/usr/local/lib/python2.7/lib-tk:/usr/local/lib/python2.7/lib-old:/usr/local/lib/python2.7/lib-dynload:/usr/local/lib/python2.7/site-packages:/usr/local/lib/python2.7/site-packages/PIL
08:42:36 T:34761992192   DEBUG: CPythonInvoker(4, /home/xbmc/.xbmc/addons/plugin.video.plexbmc/default.py): entering source directory /home/xbmc/.xbmc/addons/plugin.video.plexbmc
08:42:36 T:34761992192   DEBUG: CPythonInvoker(4, /home/xbmc/.xbmc/addons/plugin.video.plexbmc/default.py): instantiating addon using automatically obtained id of "plugin.video.plexbmc" dependent on version 2.1.0 of the xbmc.python api
08:42:36 T:34761988096   DEBUG: CPythonInvoker(2, /home/xbmc/.xbmc/addons/plugin.video.plexbmc/default.py): setting the Python path to /home/xbmc/.xbmc/addons/plugin.video.plexbmc:/home/xbmc/.xbmc/addons/script.module.simplejson/lib:/usr/local/share/xbmc/addons/script.module.pil/lib:/usr/local/share/xbmc/addons/xbmc.debug/:/usr/local/lib/python27.zip:/usr/local/lib/python2.7:/usr/local/lib/python2.7/plat-freebsd10:/usr/local/lib/python2.7/lib-tk:/usr/local/lib/python2.7/lib-old:/usr/local/lib/python2.7/lib-dynload:/usr/local/lib/python2.7/site-packages:/usr/local/lib/python2.7/site-packages/PIL
08:42:36 T:34761988096   DEBUG: CPythonInvoker(2, /home/xbmc/.xbmc/addons/plugin.video.plexbmc/default.py): entering source directory /home/xbmc/.xbmc/addons/plugin.video.plexbmc
08:42:36 T:34761988096   DEBUG: CPythonInvoker(2, /home/xbmc/.xbmc/addons/plugin.video.plexbmc/default.py): instantiating addon using automatically obtained id of "plugin.video.plexbmc" dependent on version 2.1.0 of the xbmc.python api
08:42:36 T:34761992192  NOTICE: ===== PLEXBMC START =====
08:42:36 T:34761992192  NOTICE: PleXBMC -> running Python: sys.version_info(major=2, minor=7, micro=6, releaselevel='final', serial=0)
08:42:36 T:34761992192  NOTICE: PleXBMC -> running PleXBMC: 3.1.5
08:42:36 T:34761992192  NOTICE: PleXBMC -> Running with cElementTree on Python 2.5+
08:42:36 T:34761992192  NOTICE: PleXBMC -> Platform: Linux/RPi
08:42:36 T:34761992192  NOTICE: PleXBMC -> Debug is turned off.  Running silent
08:42:36 T:34674156544  NOTICE: ===== PLEXBMC HELPER START =====
08:42:36 T:34674156544  NOTICE: PleXBMC Helper -> running Python: sys.version_info(major=2, minor=7, micro=6, releaselevel='final', serial=0)
08:42:36 T:34674156544  NOTICE: PleXBMC Helper -> running Version: 3.1.3
08:42:36 T:34761988096  NOTICE: ===== PLEXBMC START =====
08:42:36 T:34761988096  NOTICE: PleXBMC -> running Python: sys.version_info(major=2, minor=7, micro=6, releaselevel='final', serial=0)
08:42:36 T:34761988096  NOTICE: PleXBMC -> running PleXBMC: 3.1.5
08:42:37 T:34761988096  NOTICE: PleXBMC -> Running with cElementTree on Python 2.5+
08:42:37 T:34761988096  NOTICE: PleXBMC -> Platform: Linux/RPi
08:42:37 T:34761988096  NOTICE: PleXBMC -> Debug is turned off.  Running silent
08:42:37 T:34674156544  NOTICE: PleXBMC Helper -> Platform: Linux/RPi
08:42:37 T:34674156544  NOTICE: PleXBMC Helper -> UUID: 367ef96d-ef46-49c3-8627-6a9e8ad0d773
08:42:37 T:34674156544  NOTICE: PleXBMC Helper -> XBMC Web Port: 8080
08:42:37 T:34674156544  NOTICE: PleXBMC Helper -> XBMC Web User: xbmc
08:42:37 T:34674156544   DEBUG: JSONRPC: Incoming request: {"params": {"properties": ["version"], "addonid": "plugin.video.plexbmc"}, "jsonrpc": "2.0", "id": "1", "method": "Addons.GetAddonDetails"}
08:42:37 T:34611422208   DEBUG: ------ Window Deinit (Pointer.xml) ------
08:42:38 T:34761993216   DEBUG: CZeroconfAvahi::clientCallback: uiuui; coll or reg, anyways, resetting groups
08:42:39 T:34761993216   DEBUG: CZeroconfAvahi::clientCallback: client is up and running
08:42:39 T:34761993216   DEBUG: CZeroconfAvahi::addService() named: XBMC (zbox.local) type: _airplay._tcp port:36667
08:42:39 T:34761993216   DEBUG: CZeroconfAvahi::addService() named: B80305DDAE37@XBMC (zbox.local) type: _raop._tcp port:36666
08:42:39 T:34761993216   DEBUG: CZeroconfAvahi::addService() named: XBMC (zbox.local) type: _xbmc-events._udp port:9777
08:42:39 T:34761993216   DEBUG: CZeroconfAvahi::addService() named: XBMC (zbox.local) type: _xbmc-jsonrpc-h._tcp port:8080
08:42:39 T:34761993216   DEBUG: CZeroconfAvahi::addService() named: XBMC (zbox.local) type: _xbmc-jsonrpc._tcp port:9090
08:42:39 T:34761993216   DEBUG: CZeroconfAvahi::addService() named: XBMC (zbox.local) type: _http._tcp port:8080
08:42:40 T:34761993216   DEBUG: CZeroconfAvahi::groupCallback: Service successfully established
08:42:42 T:34761988096   DEBUG: Previous line repeats 5 times.
08:42:42 T:34761988096  NOTICE: ===== PLEXBMC STOP =====
08:42:42 T:34761988096    INFO: CPythonInvoker(2, /home/xbmc/.xbmc/addons/plugin.video.plexbmc/default.py): script successfully run
08:42:42 T:34761988096    INFO: Python script stopped
08:42:42 T:34761988096   DEBUG: Thread LanguageInvoker 34761988096 terminating
08:42:42 T:34761992192  NOTICE: ===== PLEXBMC STOP =====
08:42:42 T:34761992192    INFO: CPythonInvoker(4, /home/xbmc/.xbmc/addons/plugin.video.plexbmc/default.py): script successfully run
08:42:42 T:34761992192    INFO: Python script stopped
08:42:42 T:34761992192   DEBUG: Thread LanguageInvoker 34761992192 terminating
08:42:43 T:34761990144  NOTICE: ===== PLEXBMC STOP =====
08:42:43 T:34761990144    INFO: CPythonInvoker(3, /home/xbmc/.xbmc/addons/plugin.video.plexbmc/default.py): script successfully run
08:42:43 T:34761990144    INFO: Python script stopped
08:42:43 T:34761990144   DEBUG: Thread LanguageInvoker 34761990144 terminating
08:42:43 T:34611422208    INFO: LIRC Initialize: using: /dev/lircd
08:42:43 T:34611422208   DEBUG: Failed to connect to LIRC. Retry in 20s.
08:42:47 T:34674156544  NOTICE: PleXBMC Helper -> PleXBMC Helper has started
08:42:47 T:34611422208   DEBUG: ------ Window Init (DialogKaiToast.xml) ------
08:42:53 T:34611422208   DEBUG: ------ Window Deinit (DialogKaiToast.xml) ------
08:43:03 T:34611422208    INFO: LIRC Initialize: using: /dev/lircd
08:43:03 T:34611422208   DEBUG: Failed to connect to LIRC. Retry in 40s.
08:43:05 T:34761990144  NOTICE: Thread LanguageInvoker start, auto delete: false
08:43:05 T:34761990144    INFO: initializing python engine.
08:43:05 T:34761990144   DEBUG: CPythonInvoker(5, /home/xbmc/.xbmc/addons/service.xbmc.versioncheck/service.py): start processing
08:43:05 T:34761990144  NOTICE: -->Python Interpreter Initialized<--
08:43:05 T:34761990144   DEBUG: CPythonInvoker(5, /home/xbmc/.xbmc/addons/service.xbmc.versioncheck/service.py): the source file to load is /home/xbmc/.xbmc/addons/service.xbmc.versioncheck/service.py
08:43:05 T:34761990144   DEBUG: CPythonInvoker(5, /home/xbmc/.xbmc/addons/service.xbmc.versioncheck/service.py): setting the Python path to /home/xbmc/.xbmc/addons/service.xbmc.versioncheck:/home/xbmc/.xbmc/addons/script.module.simplejson/lib:/usr/local/share/xbmc/addons/script.module.pil/lib:/usr/local/share/xbmc/addons/xbmc.debug/:/usr/local/lib/python27.zip:/usr/local/lib/python2.7:/usr/local/lib/python2.7/plat-freebsd10:/usr/local/lib/python2.7/lib-tk:/usr/local/lib/python2.7/lib-old:/usr/local/lib/python2.7/lib-dynload:/usr/local/lib/python2.7/site-packages:/usr/local/lib/python2.7/site-packages/PIL
08:43:05 T:34761990144   DEBUG: CPythonInvoker(5, /home/xbmc/.xbmc/addons/service.xbmc.versioncheck/service.py): entering source directory /home/xbmc/.xbmc/addons/service.xbmc.versioncheck
08:43:05 T:34761990144   DEBUG: CPythonInvoker(5, /home/xbmc/.xbmc/addons/service.xbmc.versioncheck/service.py): instantiating addon using automatically obtained id of "service.xbmc.versioncheck" dependent on version 2.1.0 of the xbmc.python api
08:43:05 T:34761990144   DEBUG: XBMC Version Check: Version 0.1.19 started
08:43:05 T:34761990144   DEBUG: JSONRPC: Incoming request: { "jsonrpc": "2.0", "method": "Application.GetProperties", "params": {"properties": ["version", "name"]}, "id": 1 }
08:43:05 T:34761990144   DEBUG: XBMC Version Check: Version installed {u'major': 13, u'tag': u'beta', u'minor': 0, u'revision': u'Unknown'}
08:43:05 T:34761990144   DEBUG: XBMC Version Check: Nothing to see here, move along. Running a latest non stable release
08:43:05 T:34761990144    INFO: CPythonInvoker(5, /home/xbmc/.xbmc/addons/service.xbmc.versioncheck/service.py): script successfully run
08:43:05 T:34761990144    INFO: Python script stopped
08:43:05 T:34761990144   DEBUG: Thread LanguageInvoker 34761990144 terminating
08:43:05 T:34761994240   DEBUG: Thread JobWorker 34761994240 terminating (autodelete)
08:43:05 T:34760260608   DEBUG: Thread JobWorker 34760260608 terminating (autodelete)
08:43:05 T:34761986048   DEBUG: Thread JobWorker 34761986048 terminating (autodelete)

I could see AirTunes was listening on TCP port 36666 and AirPlay was listening on TCP port 36667. A quick look at what ports my computer was listening on showed AirPlay was listening on both IPv4 and IPv6, but AirTunes was listening on IPv6 only:
Code: 
# sockstat -l | grep 3666
xbmc     xbmc.bin   1746  43 tcp4 6 *:36667               *:*
xbmc     xbmc.bin   1746  46 tcp6   *:36666               *:*

I fixed this by setting
Code: 
# sysctl net.inet6.ip6.v6only=0

Do this permanently by adding the following line to /etc/rc.conf
Code: 
ipv6_ipv4mapping="YES"

For further details on this, refer to the FreeBSD Handbook http://www.freebsd.org/doc/handbook/network-ipv6.html. Please be aware that there are security implications with the above changes, namely the need for any firewalls to include specific IPv6 rules - more on that here: http://freebsd.1045724.n5.nabble.com/Making-net-inet6-ip6-v6only-0-default-td5824350.html.
 
You must log in or register to reply here.
Back
Top