22:16:19 T:3065481024 M:744333312 NOTICE: ----------------------------------------------------------------------- 22:16:19 T:3065481024 M:744333312 NOTICE: Starting XBMC, Platform: GNU/Linux. Built on May 25 2009 (SVN:20654) 22:16:19 T:3065481024 M:744333312 NOTICE: special://xbmc/ is mapped to: /usr/share/xbmc 22:16:19 T:3065481024 M:744333312 NOTICE: special://masterprofile/ is mapped to: /home/jochem/.xbmc/userdata 22:16:19 T:3065481024 M:744333312 NOTICE: special://home/ is mapped to: /home/jochem/.xbmc 22:16:19 T:3065481024 M:744333312 NOTICE: special://temp/ is mapped to: /home/jochem/.xbmc/temp 22:16:19 T:3065481024 M:744333312 NOTICE: The executable running is: /usr/share/xbmc/xbmc.bin 22:16:19 T:3065481024 M:744333312 NOTICE: Log File is located: /home/jochem/.xbmc/temp/xbmc.log 22:16:19 T:3065481024 M:744333312 NOTICE: ----------------------------------------------------------------------- 22:16:33 T:3065481024 M:743624704 NOTICE: Setup SDL 22:16:33 T:3065481024 M:742699008 INFO: Available videomodes (xrandr): 22:16:33 T:3065481024 M:742699008 INFO: Number of connected outputs: 2 22:16:33 T:3065481024 M:742699008 INFO: Output 'LVDS' has 20 modes 22:16:33 T:3065481024 M:742699008 INFO: ID:0x4f Name:1024x768 Refresh:60.003841 Width:1024 Height:768 22:16:33 T:3065481024 M:742699008 INFO: Pixel Ratio: 1.000000 22:16:33 T:3065481024 M:742699008 INFO: ID:0x50 Name:1024x768 Refresh:84.996689 Width:1024 Height:768 22:16:33 T:3065481024 M:742699008 INFO: Pixel Ratio: 1.000000 22:16:33 T:3065481024 M:742699008 INFO: ID:0x51 Name:1024x768 Refresh:75.028580 Width:1024 Height:768 22:16:33 T:3065481024 M:742699008 INFO: Pixel Ratio: 1.000000 22:16:33 T:3065481024 M:742699008 INFO: ID:0x52 Name:1024x768 Refresh:70.069359 Width:1024 Height:768 22:16:33 T:3065481024 M:742699008 INFO: Pixel Ratio: 1.000000 22:16:33 T:3065481024 M:742699008 INFO: ID:0x53 Name:1024x768 Refresh:60.003841 Width:1024 Height:768 22:16:33 T:3065481024 M:742699008 INFO: Pixel Ratio: 1.000000 22:16:33 T:3065481024 M:742699008 INFO: ID:0x54 Name:832x624 Refresh:74.551270 Width:832 Height:624 22:16:33 T:3065481024 M:742699008 INFO: Pixel Ratio: 1.000000 22:16:33 T:3065481024 M:742699008 INFO: ID:0x55 Name:800x600 Refresh:85.136879 Width:800 Height:600 22:16:33 T:3065481024 M:742699008 INFO: Pixel Ratio: 1.000000 22:16:33 T:3065481024 M:742699008 INFO: ID:0x56 Name:800x600 Refresh:72.187569 Width:800 Height:600 22:16:33 T:3065481024 M:742699008 INFO: Pixel Ratio: 1.000000 22:16:33 T:3065481024 M:742699008 INFO: ID:0x57 Name:800x600 Refresh:75.000000 Width:800 Height:600 22:16:33 T:3065481024 M:742699008 INFO: Pixel Ratio: 1.000000 22:16:33 T:3065481024 M:742699008 INFO: ID:0x58 Name:800x600 Refresh:60.316540 Width:800 Height:600 22:16:33 T:3065481024 M:742699008 INFO: Pixel Ratio: 1.000000 22:16:33 T:3065481024 M:742699008 INFO: ID:0x59 Name:800x600 Refresh:56.250000 Width:800 Height:600 22:16:33 T:3065481024 M:742699008 INFO: Pixel Ratio: 1.000000 22:16:33 T:3065481024 M:742699008 INFO: ID:0x5a Name:640x480 Refresh:85.008308 Width:640 Height:480 22:16:33 T:3065481024 M:742699008 INFO: Pixel Ratio: 1.000000 22:16:33 T:3065481024 M:742699008 INFO: ID:0x5b Name:640x480 Refresh:72.808800 Width:640 Height:480 22:16:33 T:3065481024 M:742699008 INFO: Pixel Ratio: 1.000000 22:16:33 T:3065481024 M:742699008 INFO: ID:0x5c Name:640x480 Refresh:75.000000 Width:640 Height:480 22:16:33 T:3065481024 M:742699008 INFO: Pixel Ratio: 1.000000 22:16:33 T:3065481024 M:742699008 INFO: ID:0x5d Name:640x480 Refresh:59.940479 Width:640 Height:480 22:16:33 T:3065481024 M:742699008 INFO: Pixel Ratio: 1.000000 22:16:33 T:3065481024 M:742699008 INFO: ID:0x5e Name:720x400 Refresh:85.038902 Width:720 Height:400 22:16:33 T:3065481024 M:742699008 INFO: Pixel Ratio: 1.000000 22:16:33 T:3065481024 M:742699008 INFO: ID:0x5f Name:640x400 Refresh:85.079948 Width:640 Height:400 22:16:33 T:3065481024 M:742699008 INFO: Pixel Ratio: 1.000000 22:16:33 T:3065481024 M:742699008 INFO: ID:0x60 Name:640x350 Refresh:85.079948 Width:640 Height:350 22:16:33 T:3065481024 M:742699008 INFO: Pixel Ratio: 1.000000 22:16:33 T:3065481024 M:742699008 INFO: ID:0x91 Name:480i/60 Refresh:30.000000 Width:640 Height:480 22:16:33 T:3065481024 M:742699008 INFO: Pixel Ratio: 1.000000 22:16:33 T:3065481024 M:742699008 INFO: ID:0x92 Name:480p/60 Refresh:60.000000 Width:640 Height:480 22:16:33 T:3065481024 M:742699008 INFO: Pixel Ratio: 1.000000 22:16:33 T:3065481024 M:742699008 INFO: Output 'TMDS-1' has 36 modes 22:16:33 T:3065481024 M:742699008 INFO: ID:0x61 Name:1920x1200 Refresh:59.950169 Width:1920 Height:1200 22:16:33 T:3065481024 M:742699008 INFO: Pixel Ratio: 0.999228 22:16:33 T:3065481024 M:742699008 INFO: ID:0x62 Name:1600x1200 Refresh:60.000000 Width:1600 Height:1200 22:16:33 T:3065481024 M:742699008 INFO: Pixel Ratio: 1.199074 22:16:33 T:3065481024 M:742699008 INFO: ID:0x63 Name:1600x1200 Refresh:59.869110 Width:1600 Height:1200 22:16:33 T:3065481024 M:742699008 INFO: Pixel Ratio: 1.199074 22:16:33 T:3065481024 M:742699008 INFO: ID:0x64 Name:1680x1050 Refresh:60.001499 Width:1680 Height:1050 22:16:33 T:3065481024 M:742699008 INFO: Pixel Ratio: 0.999228 22:16:33 T:3065481024 M:742699008 INFO: ID:0x65 Name:1600x1024 Refresh:59.998089 Width:1600 Height:1024 22:16:33 T:3065481024 M:742699008 INFO: Pixel Ratio: 1.023210 22:16:33 T:3065481024 M:742699008 INFO: ID:0x66 Name:1400x1050 Refresh:70.037109 Width:1400 Height:1050 22:16:33 T:3065481024 M:742699008 INFO: Pixel Ratio: 1.199074 22:16:33 T:3065481024 M:742699008 INFO: ID:0x67 Name:1400x1050 Refresh:59.975620 Width:1400 Height:1050 22:16:33 T:3065481024 M:742699008 INFO: Pixel Ratio: 1.199074 22:16:33 T:3065481024 M:742699008 INFO: ID:0x68 Name:1280x1024 Refresh:75.024673 Width:1280 Height:1024 22:16:33 T:3065481024 M:742699008 INFO: Pixel Ratio: 1.279012 22:16:33 T:3065481024 M:742699008 INFO: ID:0x69 Name:1280x1024 Refresh:59.894852 Width:1280 Height:1024 22:16:33 T:3065481024 M:742699008 INFO: Pixel Ratio: 1.279012 22:16:33 T:3065481024 M:742699008 INFO: ID:0x6a Name:1280x1024 Refresh:60.019741 Width:1280 Height:1024 22:16:33 T:3065481024 M:742699008 INFO: Pixel Ratio: 1.279012 22:16:33 T:3065481024 M:742699008 INFO: ID:0x6b Name:1440x900 Refresh:60.174091 Width:1440 Height:900 22:16:33 T:3065481024 M:742699008 INFO: Pixel Ratio: 0.999228 22:16:33 T:3065481024 M:742699008 INFO: ID:0x6c Name:1280x960 Refresh:60.000000 Width:1280 Height:960 22:16:33 T:3065481024 M:742699008 INFO: Pixel Ratio: 1.199074 22:16:33 T:3065481024 M:742699008 INFO: ID:0x6d Name:1280x960 Refresh:59.939049 Width:1280 Height:960 22:16:33 T:3065481024 M:742699008 INFO: Pixel Ratio: 1.199074 22:16:33 T:3065481024 M:742699008 INFO: ID:0x6e Name:1280x800 Refresh:59.998268 Width:1280 Height:800 22:16:33 T:3065481024 M:742699008 INFO: Pixel Ratio: 0.999228 22:16:33 T:3065481024 M:742699008 INFO: ID:0x6f Name:1152x864 Refresh:75.000000 Width:1152 Height:864 22:16:33 T:3065481024 M:742699008 INFO: Pixel Ratio: 1.199074 22:16:33 T:3065481024 M:742699008 INFO: ID:0x70 Name:1152x864 Refresh:74.815842 Width:1152 Height:864 22:16:33 T:3065481024 M:742699008 INFO: Pixel Ratio: 1.199074 22:16:33 T:3065481024 M:742699008 INFO: ID:0x71 Name:1280x768 Refresh:60.002991 Width:1280 Height:768 22:16:33 T:3065481024 M:742699008 INFO: Pixel Ratio: 0.959259 22:16:33 T:3065481024 M:742699008 INFO: ID:0x72 Name:1024x768 Refresh:75.076218 Width:1024 Height:768 22:16:33 T:3065481024 M:742699008 INFO: Pixel Ratio: 1.199074 22:16:33 T:3065481024 M:742699008 INFO: ID:0x52 Name:1024x768 Refresh:70.069359 Width:1024 Height:768 22:16:33 T:3065481024 M:742699008 INFO: Pixel Ratio: 1.199074 22:16:33 T:3065481024 M:742699008 INFO: ID:0x53 Name:1024x768 Refresh:60.003841 Width:1024 Height:768 22:16:33 T:3065481024 M:742699008 INFO: Pixel Ratio: 1.199074 22:16:33 T:3065481024 M:742699008 INFO: ID:0x54 Name:832x624 Refresh:74.551270 Width:832 Height:624 22:16:33 T:3065481024 M:742699008 INFO: Pixel Ratio: 1.199074 22:16:33 T:3065481024 M:742699008 INFO: ID:0x56 Name:800x600 Refresh:72.187569 Width:800 Height:600 22:16:33 T:3065481024 M:742699008 INFO: Pixel Ratio: 1.199074 22:16:33 T:3065481024 M:742699008 INFO: ID:0x57 Name:800x600 Refresh:75.000000 Width:800 Height:600 22:16:33 T:3065481024 M:742699008 INFO: Pixel Ratio: 1.199074 22:16:33 T:3065481024 M:742699008 INFO: ID:0x58 Name:800x600 Refresh:60.316540 Width:800 Height:600 22:16:33 T:3065481024 M:742699008 INFO: Pixel Ratio: 1.199074 22:16:33 T:3065481024 M:742699008 INFO: ID:0x59 Name:800x600 Refresh:56.250000 Width:800 Height:600 22:16:33 T:3065481024 M:742699008 INFO: Pixel Ratio: 1.199074 22:16:33 T:3065481024 M:742699008 INFO: ID:0x5c Name:640x480 Refresh:75.000000 Width:640 Height:480 22:16:33 T:3065481024 M:742699008 INFO: Pixel Ratio: 1.199074 22:16:33 T:3065481024 M:742699008 INFO: ID:0x73 Name:640x480 Refresh:72.808800 Width:640 Height:480 22:16:33 T:3065481024 M:742699008 INFO: Pixel Ratio: 1.199074 22:16:33 T:3065481024 M:742699008 INFO: ID:0x5b Name:640x480 Refresh:72.808800 Width:640 Height:480 22:16:33 T:3065481024 M:742699008 INFO: Pixel Ratio: 1.199074 22:16:33 T:3065481024 M:742699008 INFO: ID:0x5c Name:640x480 Refresh:75.000000 Width:640 Height:480 22:16:33 T:3065481024 M:742699008 INFO: Pixel Ratio: 1.199074 22:16:33 T:3065481024 M:742699008 INFO: ID:0x74 Name:640x480 Refresh:66.666672 Width:640 Height:480 22:16:33 T:3065481024 M:742699008 INFO: Pixel Ratio: 1.199074 22:16:33 T:3065481024 M:742699008 INFO: ID:0x75 Name:640x480 Refresh:60.000000 Width:640 Height:480 22:16:33 T:3065481024 M:742699008 INFO: Pixel Ratio: 1.199074 22:16:33 T:3065481024 M:742699008 INFO: ID:0x5d Name:640x480 Refresh:59.940479 Width:640 Height:480 22:16:33 T:3065481024 M:742699008 INFO: Pixel Ratio: 1.199074 22:16:33 T:3065481024 M:742699008 INFO: ID:0x76 Name:720x400 Refresh:70.081657 Width:720 Height:400 22:16:33 T:3065481024 M:742699008 INFO: Pixel Ratio: 0.888203 22:16:33 T:3065481024 M:742699008 INFO: ID:0x93 Name:720p/60 Refresh:60.000000 Width:1280 Height:720 22:16:33 T:3065481024 M:742699008 INFO: Pixel Ratio: 0.899306 22:16:33 T:3065481024 M:742699008 INFO: ID:0x94 Name:1080i/60 Refresh:30.000000 Width:1920 Height:1080 22:16:33 T:3065481024 M:742699008 INFO: Pixel Ratio: 0.899306 22:16:33 T:3065481024 M:742699008 INFO: ID:0x95 Name:1080p/60 Refresh:60.000000 Width:1920 Height:1080 22:16:33 T:3065481024 M:742699008 INFO: Pixel Ratio: 0.899306 22:16:33 T:3065481024 M:742281216 INFO: LIRC Initialize: connect failed: No such file or directory 22:16:33 T:3065481024 M:742281216 INFO: Drives are mapped 22:16:33 T:3065481024 M:742281216 NOTICE: load settings... 22:16:33 T:3065481024 M:742281216 NOTICE: special://profile/ is mapped to: special://home/userdata/ 22:16:33 T:3065481024 M:742281216 NOTICE: loading special://masterprofile/guisettings.xml 22:16:33 T:3065481024 M:742281216 NOTICE: Getting hardware information now... 22:16:33 T:3065481024 M:742281216 INFO: Using analog output 22:16:33 T:3065481024 M:742281216 INFO: AC3 pass through is enabled 22:16:33 T:3065481024 M:742281216 INFO: DTS pass through is enabled 22:16:33 T:3065481024 M:742281216 NOTICE: Checking resolution 44 22:16:33 T:3065481024 M:742281216 NOTICE: No advancedsettings.xml to load (special://masterprofile/advancedsettings.xml) 22:16:33 T:3065481024 M:742281216 NOTICE: Default DVD Player: dvdplayer 22:16:33 T:3065481024 M:742281216 NOTICE: Default Video Player: dvdplayer 22:16:33 T:3065481024 M:742281216 NOTICE: Default Audio Player: paplayer 22:16:33 T:3065481024 M:742281216 NOTICE: special://home/userdata/sources.xml 22:16:33 T:3065481024 M:742281216 DEBUG: Setting source to : videos 22:16:33 T:3065481024 M:742281216 WARNING: CXRandR::SetMode: found alternative mode (same hz): TMDS-1 mode: 0x6c. 22:16:33 T:3065481024 M:742281216 INFO: XRANDR: /usr/share/xbmc/xbmc-xrandr --output TMDS-1 --mode 0x6c 22:16:34 T:3065481024 M:742014976 DEBUG: Constructing surface 1280x960, shared=(nil), fullscreen=0 22:16:34 T:3065481024 M:742014976 INFO: GLX Info: NOT Using destination window 22:16:35 T:3065481024 M:742014976 WARNING: GLX: No Multisample buffers available, FSAA disabled 22:16:35 T:3065481024 M:742014976 NOTICE: Using fbConfig[0] 22:16:35 T:3065481024 M:742014976 INFO: GLX Info: Using parent window 22:16:35 T:3065481024 M:742014976 INFO: GLX Info: Creating unshared context 22:16:35 T:3065481024 M:740622336 NOTICE: GL_VENDOR = Tungsten Graphics, Inc 22:16:35 T:3065481024 M:740622336 NOTICE: GL_RENDERER = Mesa DRI Intel(R) 945GME 20061017 x86/MMX/SSE2 22:16:35 T:3065481024 M:740622336 NOTICE: GL_VERSION = 1.3 Mesa 7.0.4 22:16:35 T:3065481024 M:740622336 NOTICE: GL_EXTENSIONS = GL_ARB_depth_texture GL_ARB_fragment_program GL_ARB_imaging GL_ARB_multisample GL_ARB_multitexture GL_ARB_point_parameters GL_ARB_shadow GL_ARB_texture_border_clamp GL_ARB_texture_compression 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_mirrored_repeat GL_ARB_texture_rectangle GL_ARB_transpose_matrix GL_ARB_vertex_buffer_object GL_ARB_vertex_program 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_cull_vertex GL_EXT_compiled_vertex_array GL_EXT_convolution GL_EXT_copy_texture GL_EXT_draw_range_elements GL_EXT_fog_coord GL_EXT_histogram GL_EXT_multi_draw_arrays GL_EXT_packed_pixels GL_EXT_point_parameters GL_EXT_polygon_offset GL_EXT_rescale_normal GL_EXT_secondary_color GL_EXT_separate_specular_color GL_EXT_shadow_funcs GL_EXT_stencil_wrap GL_EXT_subtexture GL_EXT_texture GL_EXT_texture3D GL_EXT_texture_edge_clamp GL_EXT_texture_env_add GL_EXT_texture_env_combine GL_EXT_texture_env_dot3 GL_EXT_texture_filter_anisotropic GL_EXT_texture_lod_bias GL_EXT_texture_object GL_EXT_texture_rectangle GL_EXT_vertex_array GL_3DFX_texture_compression_FXT1 GL_APPLE_client_storage GL_APPLE_packed_pixels GL_ATI_blend_equation_separate GL_IBM_rasterpos_clip GL_IBM_texture_mirrored_repeat GL_INGR_blend_func_separate GL_MESA_pack_invert GL_MESA_ycbcr_texture GL_MESA_window_pos GL_NV_blend_square GL_NV_light_max_exponent GL_NV_texture_rectangle GL_NV_texgen_reflection GL_NV_vertex_program GL_NV_vertex_program1_1 GL_OES_read_format GL_SGI_color_matrix GL_SGI_color_table GL_SGIS_generate_mipmap GL_SGIS_texture_border_clamp GL_SGIS_texture_edge_clamp GL_SGIS_texture_lod GL_SGIX_depth_texture GL_SUN_multi_draw_arrays 22:16:35 T:3065481024 M:740622336 INFO: GL: Enabling VSYNC 22:16:35 T:3065481024 M:740622336 WARNING: EnableVSync - glXGetSyncValuesOML failed 22:16:35 T:3065481024 M:740622336 INFO: GL: Selected vsync mode 3 22:16:35 T:3065481024 M:740622336 INFO: GL: ReleaseContext 22:16:35 T:3065481024 M:740622336 DEBUG: Asking to resize surface to 1280 x 960 22:16:35 T:3065481024 M:740622336 INFO: GL: Maximum texture width: 2048 22:16:35 T:3065481024 M:740622336 INFO: load language info file: special://xbmc/language/Dutch/langinfo.xml 22:16:35 T:3065481024 M:740483072 WARNING: Trying to access old style dir: D:\media\media\Textures.xpr 22:16:35 T:3065481024 M:737837056 DEBUG: Load special://xbmc/media/Splash.png: 58.3ms 22:16:35 T:3065481024 M:739926016 INFO: GL: retrace count didn't change after buffer swap, switching to vsync mode 4 22:16:35 T:3065481024 M:739926016 INFO: load language file:special://xbmc/language/Dutch/strings.xml 22:16:35 T:3065481024 M:739717120 INFO: load keymapping 22:16:35 T:3065481024 M:739717120 INFO: Loading special://xbmc/system/Keymap.xml 22:16:35 T:3065481024 M:739717120 INFO: Loading special://profile/Keymap.xml 22:16:35 T:3065481024 M:739717120 ERROR: Keyboard Translator: Can't find button volume-up 22:16:35 T:3065481024 M:739717120 ERROR: Keyboard Translator: Can't find button volume-mute 22:16:35 T:3065481024 M:739717120 ERROR: Keyboard Translator: Can't find button volume-down 22:16:35 T:3065481024 M:739717120 INFO: Loading special://xbmc/system/Lircmap.xml 22:16:35 T:3065481024 M:739717120 INFO: Loading special://masterprofile/Lircmap.xml 22:16:35 T:3065481024 M:739717120 INFO: Checking skin version of: PM3.HD 22:16:35 T:3065481024 M:739717120 INFO: Skin version is: 2.1 22:16:35 T:3065481024 M:739717120 INFO: GUI format 1280x960 TMDS-1: 1280x960 @ 60.00Hz 22:16:35 T:3065481024 M:739717120 INFO: install unhandled exception filter 22:16:35 T:3065481024 M:739717120 INFO: creating subdirectories 22:16:35 T:3065481024 M:739717120 INFO: userdata folder: special://home/userdata/ 22:16:35 T:3065481024 M:739717120 INFO: recording folder: 22:16:35 T:3065481024 M:739717120 INFO: screenshots folder: 22:16:35 T:3065481024 M:739717120 INFO: thumbnails folder:special://home/userdata/Thumbnails 22:16:35 T:3065481024 M:739717120 NOTICE: start dvd mediatype detection 22:16:35 T:2944707472 M:739717120 DEBUG: Running thread 2944707472 22:16:35 T:2944707472 M:739717120 DEBUG: thread start, auto delete: 0 22:16:35 T:2944707472 M:739717120 DEBUG: Compiled with libcdio Version 0.80 22:16:35 T:3065481024 M:739717120 NOTICE: initializing playlistplayer 22:16:35 T:3065481024 M:739717120 NOTICE: DONE initializing playlistplayer 22:16:35 T:2944707472 M:739717120 DEBUG: Thread 2944707472 terminating 22:16:35 T:3065481024 M:739717120 NOTICE: load default skin:[PM3.HD] 22:16:35 T:3065481024 M:739717120 INFO: load skin from:special://xbmc/skin/PM3.HD 22:16:35 T:3065481024 M:739717120 INFO: delete old skin... 22:16:35 T:3065481024 M:739717120 DEBUG: ------------------- GUI_MSG_WINDOW_DEINIT 22:16:35 T:3065481024 M:739717120 DEBUG: Sorteer op: Formaat 22:16:35 T:3065481024 M:739717120 DEBUG: ------------------- 22:16:35 T:3065481024 M:739717120 DEBUG: ------------------- GUI_MSG_WINDOW_DEINIT 22:16:35 T:3065481024 M:739717120 DEBUG: 22:16:35 T:3065481024 M:739717120 DEBUG: ------------------- 22:16:35 T:3065481024 M:739717120 INFO: Default 4:3 resolution directory is special://xbmc/skin/PM3.HD/720p 22:16:35 T:3065481024 M:739717120 INFO: Default 16:9 resolution directory is special://xbmc/skin/PM3.HD/720p 22:16:35 T:3065481024 M:739717120 INFO: Skin version is: 2.1 22:16:35 T:3065481024 M:739717120 INFO: Loading skin includes from /usr/share/xbmc/skin/PM3.HD/720p/includes.xml 22:16:35 T:3065481024 M:738672640 INFO: load fonts for skin... 22:16:35 T:3065481024 M:738672640 INFO: Loading fonts from special://xbmc/skin/PM3.HD/720p/Font.xml 22:16:35 T:3065481024 M:738045952 INFO: load new skin... 22:16:35 T:3065481024 M:738045952 INFO: Skin version is: 2.1 22:16:35 T:3065481024 M:738045952 INFO: Loading skin file: Home.xml 22:16:35 T:2934717328 M:738045952 DEBUG: Running thread 2934717328 22:16:35 T:2934717328 M:738045952 DEBUG: thread start, auto delete: 1 22:16:35 T:2934717328 M:738045952 INFO: WEATHER: Downloading weather 22:16:35 T:2934717328 M:738045952 DEBUG: SECTION:LoadDLL(/usr/lib/libcurl.so) 22:16:35 T:2934717328 M:738045952 DEBUG: Loading: /usr/lib/libcurl.so 22:16:35 T:2934717328 M:738045952 DEBUG: FileCurl::Open(0xaeec209c) http://xoap.weather.com/weather/local/NLXX0002?cc=*&unit=m&dayf=4&prod=xoap&link=xoap&par=1004124588&key=079f24145f208494 22:16:35 T:2934717328 M:738045952 INFO: easy_aquire - Created session to http://xoap.weather.com 22:16:35 T:3065481024 M:737488896 DEBUG: Load Home.xml: 44.37ms 22:16:35 T:3065481024 M:737349632 INFO: Loading user windows, path special://xbmc/skin/PM3.HD/720p 22:16:35 T:3065481024 M:737210368 INFO: Loading skin file: special://xbmc/skin/PM3.HD/720p/custom_SkinSetting_1111.xml 22:16:35 T:3065481024 M:736792576 INFO: Loading skin file: special://xbmc/skin/PM3.HD/720p/custom_Credits_1112.xml 22:16:35 T:3065481024 M:736722944 INFO: Loading user windows, path special://xbmc/skin/PM3.HD/720p 22:16:35 T:3065481024 M:736583680 INFO: Loading skin file: special://xbmc/skin/PM3.HD/720p/custom_SkinSetting_1111.xml 22:16:35 T:3065481024 M:736305152 INFO: Loading skin file: special://xbmc/skin/PM3.HD/720p/custom_Credits_1112.xml 22:16:35 T:3065481024 M:736305152 INFO: Loading user windows, path special://xbmc/skin/PM3.HD/720p 22:16:35 T:3065481024 M:736305152 INFO: Loading skin file: special://xbmc/skin/PM3.HD/720p/custom_SkinSetting_1111.xml 22:16:35 T:3065481024 M:736305152 INFO: Loading skin file: special://xbmc/skin/PM3.HD/720p/custom_Credits_1112.xml 22:16:35 T:3065481024 M:736305152 DEBUG: Load Skin XML: 111.87ms 22:16:35 T:3065481024 M:736305152 INFO: initialize new skin... 22:16:35 T:3065481024 M:736305152 INFO: Loading skin file: Pointer.xml 22:16:35 T:3065481024 M:736305152 DEBUG: Load Pointer.xml: 3.28ms 22:16:35 T:3065481024 M:736165888 DEBUG: Load pointer-nofocus.png: 0.1ms (bundled) 22:16:35 T:3065481024 M:736165888 DEBUG: Load pointer-focus.png: 0.1ms (bundled) 22:16:35 T:3065481024 M:736165888 DEBUG: Load pointer-focus-drag.png: 0.1ms (bundled) 22:16:35 T:3065481024 M:736165888 DEBUG: Load pointer-focus-click.png: 0.1ms (bundled) 22:16:35 T:3065481024 M:736165888 DEBUG: Alloc resources: 10.32ms (3.78 ms skin load, 4.15 ms preload) 22:16:35 T:3065481024 M:736165888 INFO: Loading skin file: DialogVolumeBar.xml 22:16:35 T:3065481024 M:736165888 DEBUG: Load DialogVolumeBar.xml: 4.45ms 22:16:35 T:3065481024 M:736165888 DEBUG: Load ProgressBack.png: 0.1ms (bundled) 22:16:35 T:3065481024 M:736165888 DEBUG: Load ProgressFront.png: 0.1ms (bundled) 22:16:35 T:3065481024 M:736165888 DEBUG: Alloc resources: 6.20ms (4.99 ms skin load, 0.17 ms preload) 22:16:35 T:3065481024 M:736165888 INFO: Loading skin file: DialogSeekBar.xml 22:16:35 T:3065481024 M:735608832 DEBUG: Load DialogSeekBar.xml: 16.39ms 22:16:35 T:3065481024 M:735608832 DEBUG: Load ProgressBuffer.png: 0.1ms (bundled) 22:16:35 T:3065481024 M:735608832 DEBUG: Load seekslider.png: 0.1ms (bundled) 22:16:35 T:3065481024 M:735608832 DEBUG: Load slider_nibFO.png: 0.1ms (bundled) 22:16:35 T:3065481024 M:735608832 DEBUG: Alloc resources: 18.79ms (17.33 ms skin load, 0.25 ms preload) 22:16:35 T:3065481024 M:735608832 INFO: Loading skin file: DialogKaiToast.xml 22:16:35 T:3065481024 M:735608832 DEBUG: Load DialogKaiToast.xml: 2.50ms 22:16:35 T:3065481024 M:735608832 DEBUG: Alloc resources: 2.90ms (2.89 ms skin load, 0.00 ms preload) 22:16:35 T:3065481024 M:735608832 INFO: Loading skin file: DialogMuteBug.xml 22:16:35 T:3065481024 M:735608832 DEBUG: Load DialogMuteBug.xml: 2.23ms 22:16:35 T:3065481024 M:735608832 DEBUG: Alloc resources: 2.79ms (2.78 ms skin load, 0.01 ms preload) 22:16:35 T:3065481024 M:719392768 INFO: skin loaded... 22:16:35 T:3065481024 M:709709824 DEBUG: Activating window ID: 12999 22:16:35 T:3065481024 M:709709824 DEBUG: Checking if window ID 12999 is locked. 22:16:35 T:3065481024 M:709709824 DEBUG: ------------------- GUI_MSG_WINDOW_INIT 22:16:35 T:3065481024 M:709709824 DEBUG: 22:16:35 T:3065481024 M:709709824 DEBUG: ------------------- 22:16:35 T:3065481024 M:709709824 INFO: Loading skin file: Startup.xml 22:16:35 T:3065481024 M:709709824 DEBUG: Load Startup.xml: 3.75ms 22:16:35 T:3065481024 M:709709824 DEBUG: Alloc resources: 4.38ms (4.27 ms skin load, 0.10 ms preload) 22:16:35 T:2907691920 M:709709824 DEBUG: Running thread 2907691920 22:16:35 T:2907691920 M:709709824 DEBUG: thread start, auto delete: 1 22:16:35 T:2907691920 M:709709824 INFO: easy_aquire - Created session to http://www.google.com 22:16:35 T:3065481024 M:709361664 INFO: removing tempfiles 22:16:35 T:3065481024 M:709013504 NOTICE: Updating video library on startup 22:16:35 T:3065481024 M:709013504 DEBUG: ------------------- GUI_MSG_WINDOW_INIT 22:16:35 T:3065481024 M:709013504 DEBUG: 22:16:35 T:3065481024 M:709013504 DEBUG: ------------------- 22:16:35 T:3065481024 M:709013504 INFO: Loading skin file: DialogVideoScan.xml 22:16:35 T:3065481024 M:708595712 DEBUG: Load DialogVideoScan.xml: 6.59ms 22:16:35 T:3065481024 M:708595712 DEBUG: Alloc resources: 7.41ms (7.19 ms skin load, 0.16 ms preload) 22:16:35 T:3065481024 M:708595712 ERROR: Control 402 in window 10133 has been asked to focus, but it can't 22:16:35 T:2916084624 M:708177920 DEBUG: Running thread 2916084624 22:16:35 T:2916084624 M:708177920 DEBUG: thread start, auto delete: 0 22:16:35 T:3065481024 M:708038656 INFO: HAL: Starting initializing 22:16:35 T:3065481024 M:707969024 DEBUG: HAL: Clearing old global device list, if any 22:16:35 T:3065481024 M:707969024 NOTICE: HAL: Generating global device list 22:16:35 T:2916084624 M:707969024 DEBUG: Process - Starting scan 22:16:35 T:2899299216 M:707969024 DEBUG: Running thread 2899299216 22:16:35 T:2899299216 M:707969024 DEBUG: thread start, auto delete: 0 22:16:35 T:2899299216 M:707969024 DEBUG: Thread 2899299216 terminating 22:16:35 T:3065481024 M:707969024 DEBUG: HAL: Added - disk | FileSystem swap | HotPlugged NO | Type 1 |Approved NO 22:16:35 T:3065481024 M:707969024 NOTICE: LFS: Added - disk | Volume (swap) 22:16:35 T:3065481024 M:707969024 DEBUG: HAL: Added - disk | HotPlugged NO | Type 1 |Approved NO 22:16:35 T:3065481024 M:707969024 NOTICE: LFS: Updated - disk | Volume 22:16:35 T:2916084624 M:707411968 DEBUG: Hash[,/home/videos/]:DB=[],Computed=[] 22:16:35 T:2916084624 M:707411968 DEBUG: DoScan - Finished dir: /home/videos/ 22:16:35 T:3065481024 M:707411968 DEBUG: HAL: Added - disk | UUID 80ff6a74-ecf0-4513-864b-07f565f2890f | FileSystem ext3 | Mounted on / | HotPlugged NO | Type 1 |Approved NO 22:16:35 T:3065481024 M:707411968 NOTICE: LFS: Added - disk | Volume (ext3) 22:16:35 T:2916084624 M:707444736 DEBUG: Process - Finished scan 22:16:35 T:2916084624 M:707444736 NOTICE: My Videos: Scanning for video info using worker thread, operation took 00:00 22:16:35 T:2916084624 M:707444736 INFO: Video scan was stopped or finished ... restoring FindRemoteThumbs 22:16:35 T:2916084624 M:707444736 DEBUG: Thread 2916084624 terminating 22:16:35 T:3065481024 M:735088640 INFO: HAL: Generated global device list, found 111 22:16:35 T:3065481024 M:735088640 INFO: HAL: Sucessfully initialized 22:16:35 T:3065481024 M:735088640 NOTICE: initialize done 22:16:35 T:3065481024 M:735088640 NOTICE: Running the application... 22:16:35 T:3065481024 M:735088640 DEBUG: OnMessage : Translating ReplaceWindow(Home) 22:16:35 T:3065481024 M:735088640 DEBUG: OnMessage : To ReplaceWindow(Home) 22:16:35 T:3065481024 M:735088640 DEBUG: Activating window ID: 10000 22:16:35 T:3065481024 M:735088640 DEBUG: Checking if window ID 10000 is locked. 22:16:35 T:3065481024 M:735088640 DEBUG: ------------------- GUI_MSG_WINDOW_DEINIT 22:16:35 T:3065481024 M:735088640 DEBUG: 22:16:35 T:3065481024 M:735088640 DEBUG: ------------------- 22:16:35 T:3065481024 M:735088640 DEBUG: ------------------- GUI_MSG_WINDOW_INIT 22:16:35 T:3065481024 M:735088640 DEBUG: Home 22:16:35 T:3065481024 M:735088640 DEBUG: ------------------- 22:16:35 T:3065481024 M:735088640 DEBUG: Load home-button.png: 0.2ms (bundled) 22:16:35 T:3065481024 M:735088640 DEBUG: Load home-playmedia.png: 0.8ms (bundled) 22:16:35 T:3065481024 M:734949376 DEBUG: Load home-favourites.png: 0.8ms (bundled) 22:16:35 T:3065481024 M:734949376 DEBUG: Load home-power.png: 0.7ms (bundled) 22:16:35 T:3065481024 M:734949376 DEBUG: Alloc resources: 5.41ms (0.03 ms skin load, 0.41 ms preload) 22:16:35 T:3065481024 M:734949376 INFO: initializing python engine. 22:16:35 T:3065481024 M:734949376 DEBUG: Loading: /usr/share/xbmc/system/python/python24-i486-linux.so 22:16:36 T:2907691920 M:736206848 DEBUG: FileCurl::Close(0xad4fc03c) http://www.google.com/ 22:16:36 T:2907691920 M:736206848 DEBUG: Thread 2907691920 terminating (autodelete) 22:16:36 T:2934717328 M:736206848 DEBUG: FileCurl::Close(0xaeec209c) http://xoap.weather.com/weather/local/NLXX0002?cc=*&unit=m&dayf=4&prod=xoap&link=xoap&par=1004124588&key=079f24145f208494 22:16:36 T:2934717328 M:736206848 INFO: WEATHER: Weather download successful 22:16:36 T:2934717328 M:734232576 DEBUG: Thread 2934717328 terminating (autodelete) 22:16:37 T:3065481024 M:734162944 DEBUG: new python thread created. id=1 22:16:37 T:2899299216 M:734162944 DEBUG: Running thread 2899299216 22:16:37 T:2899299216 M:734162944 DEBUG: thread start, auto delete: 0 22:16:37 T:2899299216 M:734162944 DEBUG: Python thread: start processing 22:16:37 T:3065481024 M:734162944 DEBUG: NetworkMessage - Starting network services 22:16:37 T:3065481024 M:734162944 NOTICE: Webserver: Starting... 22:16:37 T:3065481024 M:734162944 DEBUG: xbmcHttpShim starts 22:16:37 T:2889309072 M:734162944 DEBUG: Running thread 2889309072 22:16:37 T:2889309072 M:734162944 DEBUG: thread start, auto delete: 0 22:16:37 T:2889309072 M:734162944 INFO: WebServer: Server starting using /usr/share/xbmc/web on 83.86.236.94:8080 22:16:37 T:2889309072 M:734162944 DEBUG: DB: Registering database table 22:16:37 T:2889309072 M:734162944 DEBUG: DB: Registering database table 22:16:37 T:2889309072 M:734162944 DEBUG: DB: Registering database table 22:16:37 T:2889309072 M:734162944 DEBUG: UM: Loading User Configuration from file 22:16:37 T:2889309072 M:734162944 DEBUG: DB: About to read data file 22:16:37 T:2889309072 M:734162944 DEBUG: DB: Failed to stat persistent data file. 22:16:37 T:2889309072 M:734162944 DEBUG: webs: Listening for HTTP requests at address 83.86.236.94:8080 22:16:37 T:2889309072 M:734162944 NOTICE: Webserver: Started 22:16:37 T:3065481024 M:734162944 DEBUG: UM: Writing User Configuration to file 22:16:37 T:3065481024 M:734162944 DEBUG: DB: About to save database to file 22:16:37 T:3065481024 M:734162944 DEBUG: WARNING: Failed to open file /usr/share/xbmc/web/data.tmp 22:16:37 T:3065481024 M:734023680 DEBUG: CZeroconfAvahi::clientCallback: client is up and running 22:16:37 T:3065481024 M:734093312 NOTICE: DS: Starting dbus server 22:16:37 T:2872523664 M:734093312 DEBUG: Running thread 2872523664 22:16:37 T:2872523664 M:734093312 DEBUG: thread start, auto delete: 0 22:16:37 T:2872523664 M:734093312 NOTICE: DS: Starting DBUS server in Run Application aka thread 22:16:37 T:3065481024 M:734093312 NOTICE: starting zeroconf publishing 22:16:37 T:3065481024 M:734093312 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.webapi type: _xbmc-web._tcp name:XBMC HTTP API port:8080 22:16:37 T:3065481024 M:734093312 DEBUG: CZeroconfAvahi::addService() named: XBMC HTTP API type: _xbmc-web._tcp port:8080 22:16:37 T:3065481024 M:734093312 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.webserver type: _http._tcp name:XBMC Web Server port:8080 22:16:37 T:3065481024 M:734093312 DEBUG: CZeroconfAvahi::addService() named: XBMC Web Server type: _http._tcp port:8080 22:16:37 T:2864130960 M:734093312 DEBUG: Running thread 2864130960 22:16:37 T:2864130960 M:734093312 DEBUG: thread start, auto delete: 0 22:16:37 T:2864130960 M:734093312 DEBUG: Audioscrobbler worker thread starting 22:16:37 T:3065481024 M:731934720 DEBUG: Load background-videos.jpg: 35.1ms (bundled) 22:16:37 T:3065481024 M:723578880 DEBUG: Load Background-Home-2.png: 65.5ms (bundled) 22:16:37 T:3065481024 M:722395136 DEBUG: Load Home-Menu-Back.png: 11.4ms (bundled) 22:16:37 T:3065481024 M:722186240 DEBUG: Load home-button-focus.gif: 8.0ms (bundled) 22:16:37 T:3065481024 M:719749120 DEBUG: Load Header.png: 13.1ms (bundled) 22:16:37 T:3065481024 M:719470592 DEBUG: Load xbmc-logo.png: 5.4ms (bundled) 22:16:37 T:2899299216 M:719470592 NOTICE: -->Python Interpreter Initialized<-- 22:16:37 T:2899299216 M:719470592 NOTICE: 22:16:37 T:2899299216 M:719470592 DEBUG: Process - The source file to load is special://xbmc/scripts/autoexec.py 22:16:37 T:2899299216 M:719470592 DEBUG: Process - Setting the Python path to /usr/share/xbmc/scripts;/usr/share/xbmc/system/python/python24.zip;/usr/share/xbmc/system/python/lib/python24.zip;/usr/share/xbmc/system/python/lib/python2.4/;/usr/share/xbmc/system/python/lib/python2.4/plat-linux2;/usr/share/xbmc/system/python/lib/python2.4/lib-tk;/usr/share/xbmc/system/python/lib/python2.4/lib-dynload 22:16:37 T:2899299216 M:719470592 DEBUG: Process - Entering source directory /usr/share/xbmc/scripts 22:16:37 T:2899299216 M:719331328 INFO: Scriptresult: Succes 22:16:37 T:3065481024 M:716963840 DEBUG: Load Footer.png: 10.1ms (bundled) 22:16:37 T:3065481024 M:716963840 DEBUG: Load NoCover_1.png: 1.0ms (bundled) 22:16:37 T:3065481024 M:716963840 DEBUG: Load black-back.png: 0.1ms (bundled) 22:16:37 T:3065481024 M:716963840 DEBUG: ------------------- GUI_MSG_WINDOW_DEINIT 22:16:37 T:3065481024 M:716963840 DEBUG: 22:16:37 T:3065481024 M:716963840 DEBUG: ------------------- 22:16:38 T:2899299216 M:716681216 DEBUG: xbp_dlopen loading python lib /usr/share/xbmc/system/python/python24.zip/time.so. flags: 2 22:16:38 T:2899299216 M:716681216 DEBUG: Loading: /home/jochem/.xbmc/temp/time.so 22:16:38 T:2899299216 M:716681216 DEBUG: RegisterExtensionLib, adding time.so (0xae5daa28) 22:16:38 T:2899299216 M:716681216 DEBUG: xbp_dlsym - load symbol inittime 22:16:38 T:2899299216 M:716611584 DEBUG: xbp_dlopen loading python lib /usr/share/xbmc/system/python/python24.zip/collections.so. flags: 2 22:16:38 T:2899299216 M:716611584 DEBUG: Loading: /home/jochem/.xbmc/temp/collections.so 22:16:38 T:2899299216 M:716611584 DEBUG: RegisterExtensionLib, adding collections.so (0xae5dd1a8) 22:16:38 T:2899299216 M:716611584 DEBUG: xbp_dlsym - load symbol initcollections 22:16:38 T:2880916368 M:716611584 DEBUG: CZeroconfAvahi::groupCallback: Service successfully established 22:16:38 T:2880916368 M:716611584 DEBUG: CZeroconfAvahi::groupCallback: Service successfully established 22:16:38 T:2899299216 M:716611584 INFO: Python script stopped 22:16:38 T:2899299216 M:716611584 DEBUG: Thread 2899299216 terminating 22:16:38 T:3065481024 M:716611584 DEBUG: python thread 1 destructed 22:16:38 T:3065481024 M:716611584 INFO: Python, unloading python24.dll because no scripts are running anymore 22:16:38 T:3065481024 M:716611584 DEBUG: UnloadExtensionLibs, clearing python extension libraries 22:16:38 T:3065481024 M:716611584 DEBUG: Unloading: time.so 22:16:38 T:3065481024 M:716611584 DEBUG: Unloading: collections.so 22:16:38 T:3065481024 M:716611584 DEBUG: Unloading: python24-i486-linux.so 22:16:53 T:3065481024 M:717037568 DEBUG: SDLKeyboard: scancode: 104, sym: 274, unicode: 0, modifier: 1000 22:16:53 T:3065481024 M:717037568 DEBUG: OnKey: 61480 pressed, action is 4 22:16:53 T:3065481024 M:714878976 DEBUG: Load background-music.jpg: 40.5ms (bundled) 22:16:53 T:3065481024 M:714878976 DEBUG: Load home-button-focus.gif: 5.5ms (bundled) 22:16:54 T:3065481024 M:714928128 DEBUG: SDLKeyboard: scancode: 36, sym: 13, unicode: 13, modifier: 1000 22:16:54 T:3065481024 M:714928128 DEBUG: OnKey: 61453 pressed, action is 7 22:16:54 T:3065481024 M:714928128 DEBUG: OnMessage : Translating ActivateWindow(Music) 22:16:54 T:3065481024 M:714928128 DEBUG: OnMessage : To ActivateWindow(Music) 22:16:54 T:3065481024 M:714928128 DEBUG: Activating window ID: 10502 22:16:54 T:3065481024 M:714928128 DEBUG: Checking if window ID 10501 is locked. 22:16:54 T:3065481024 M:714928128 DEBUG: ------------------- GUI_MSG_WINDOW_DEINIT 22:16:54 T:3065481024 M:714928128 DEBUG: Home 22:16:54 T:3065481024 M:714928128 DEBUG: ------------------- 22:16:54 T:3065481024 M:733310976 INFO: Attempting to default to: 22:16:54 T:3065481024 M:733310976 DEBUG: ------------------- GUI_MSG_WINDOW_INIT 22:16:54 T:3065481024 M:733310976 DEBUG: Muziek/Bibliotheek 22:16:54 T:3065481024 M:733310976 DEBUG: ------------------- 22:16:54 T:3065481024 M:733310976 INFO: Loading skin file: MyMusicNav.xml 22:16:54 T:3065481024 M:733339648 DEBUG: Load MyMusicNav.xml: 84.35ms 22:16:54 T:3065481024 M:733339648 DEBUG: Load scrollbar_bar_back2.png: 0.0ms (bundled) 22:16:54 T:3065481024 M:733339648 DEBUG: Load scrollbar_bar-vertical.png: 0.0ms (bundled) 22:16:54 T:3065481024 M:733339648 DEBUG: Load scrollbar_bar_focus-vertical.png: 0.0ms (bundled) 22:16:54 T:3065481024 M:733339648 DEBUG: Load scrollbar_nib-vertical.png: 0.0ms (bundled) 22:16:54 T:3065481024 M:733339648 DEBUG: Load scrollbar_bar_back.png: 0.1ms (bundled) 22:16:54 T:3065481024 M:733339648 DEBUG: Load scrollbar_bar.png: 0.1ms (bundled) 22:16:54 T:3065481024 M:733339648 DEBUG: Load scrollbar_bar_focus.png: 0.1ms (bundled) 22:16:54 T:3065481024 M:733339648 DEBUG: Load scrollbar_nib.png: 0.1ms (bundled) 22:16:54 T:3065481024 M:733339648 DEBUG: Load Button_Side_Focus.png: 0.3ms (bundled) 22:16:54 T:3065481024 M:733339648 DEBUG: Load Button_Side_NoFocus.png: 0.3ms (bundled) 22:16:54 T:3065481024 M:733339648 DEBUG: Load scroll-up-focus.png: 0.1ms (bundled) 22:16:54 T:3065481024 M:733339648 DEBUG: Load scroll-up.png: 0.1ms (bundled) 22:16:54 T:3065481024 M:733339648 DEBUG: Load scroll-down-focus.png: 0.1ms (bundled) 22:16:54 T:3065481024 M:733339648 DEBUG: Load scroll-down.png: 0.1ms (bundled) 22:16:54 T:3065481024 M:733339648 DEBUG: Load radiobutton-focus.png: 0.1ms (bundled) 22:16:54 T:3065481024 M:733339648 DEBUG: Load radiobutton-nofocus.png: 0.1ms (bundled) 22:16:54 T:3065481024 M:733339648 DEBUG: Load button-focus.png: 0.1ms (bundled) 22:16:54 T:3065481024 M:733339648 DEBUG: Load button-nofocus.png: 0.2ms (bundled) 22:16:54 T:3065481024 M:733339648 DEBUG: Load PlayerControls-PrevFO.png: 0.1ms (bundled) 22:16:54 T:3065481024 M:733339648 DEBUG: Load PlayerControls-PrevNF.png: 0.1ms (bundled) 22:16:54 T:3065481024 M:733339648 DEBUG: Load PlayerControls-StopFO.png: 0.1ms (bundled) 22:16:54 T:3065481024 M:733339648 DEBUG: Load PlayerControls-StopNF.png: 0.1ms (bundled) 22:16:54 T:3065481024 M:733339648 DEBUG: Load PlayerControls-PauseFO.png: 0.1ms (bundled) 22:16:54 T:3065481024 M:733339648 DEBUG: Load PlayerControls-PauseNF.png: 0.1ms (bundled) 22:16:54 T:3065481024 M:733339648 DEBUG: Load PlayerControls-PlayFO.png: 0.1ms (bundled) 22:16:54 T:3065481024 M:733339648 DEBUG: Load PlayerControls-PlayNF.png: 0.1ms (bundled) 22:16:54 T:3065481024 M:733339648 DEBUG: Load PlayerControls-NextFO.png: 0.1ms (bundled) 22:16:54 T:3065481024 M:733339648 DEBUG: Load PlayerControls-NextNF.png: 0.1ms (bundled) 22:16:54 T:3065481024 M:733339648 DEBUG: Load PlayerControls-RandomFO_2.png: 0.1ms (bundled) 22:16:54 T:3065481024 M:733339648 DEBUG: Load PlayerControls-RandomNF_2.png: 0.1ms (bundled) 22:16:54 T:3065481024 M:733339648 DEBUG: Load PlayerControls-RandomOnFO_2.png: 0.1ms (bundled) 22:16:54 T:3065481024 M:733339648 DEBUG: Load PlayerControls-RandomOnNF_2.png: 0.1ms (bundled) 22:16:54 T:3065481024 M:733339648 DEBUG: Load PlayerControls-FullScreenFO.png: 0.1ms (bundled) 22:16:54 T:3065481024 M:733339648 DEBUG: Load PlayerControls-FullScreenNF.png: 0.1ms (bundled) 22:16:54 T:3065481024 M:733339648 DEBUG: Load lastfm-love-focus.png: 0.2ms (bundled) 22:16:54 T:3065481024 M:733339648 DEBUG: Load lastfm-love-nofocus.png: 0.2ms (bundled) 22:16:54 T:3065481024 M:733339648 DEBUG: Load lastfm-hate-focus.png: 0.2ms (bundled) 22:16:54 T:3065481024 M:733339648 DEBUG: Load lastfm-hate-nofocus.png: 0.2ms (bundled) 22:16:54 T:3065481024 M:733339648 DEBUG: Alloc resources: 105.90ms (87.69 ms skin load, 0.96 ms preload) 22:16:54 T:3065481024 M:733339648 DEBUG: CGUIMediaWindow::GetDirectory () 22:16:54 T:3065481024 M:733339648 DEBUG: ParentPath = [] 22:16:54 T:2899299216 M:733339648 DEBUG: Running thread 2899299216 22:16:54 T:2899299216 M:733339648 DEBUG: thread start, auto delete: 0 22:16:54 T:2850028432 M:733339648 DEBUG: Running thread 2850028432 22:16:54 T:2850028432 M:733339648 DEBUG: thread start, auto delete: 0 22:16:54 T:2899299216 M:733339648 DEBUG: Thread 2899299216 terminating 22:16:54 T:2850028432 M:733339648 DEBUG: Thread 2850028432 terminating 22:16:54 T:3065481024 M:733339648 WARNING: GetLabel - Unknown nodetype requested 2 22:16:54 T:3065481024 M:719622144 DEBUG: Load Background.png: 52.8ms (bundled) 22:16:54 T:3065481024 M:719622144 DEBUG: Load Panel.png: 2.2ms (bundled) 22:16:54 T:3065481024 M:719622144 DEBUG: Load list-focus.png: 0.1ms (bundled) 22:16:54 T:3065481024 M:719134720 DEBUG: Load DefaultMusicGenres.png: 2.6ms (bundled) 22:16:54 T:3065481024 M:716419072 DEBUG: Load Header.png: 9.7ms (bundled) 22:16:56 T:3065481024 M:716460032 DEBUG: SDLKeyboard: scancode: 36, sym: 13, unicode: 13, modifier: 1000 22:16:56 T:3065481024 M:716460032 DEBUG: OnKey: 61453 pressed, action is 7 22:16:56 T:3065481024 M:716460032 DEBUG: Clearing cached fileitems [musicdb://1/] 22:16:56 T:3065481024 M:716460032 DEBUG: CGUIMediaWindow::GetDirectory (musicdb://1/) 22:16:56 T:3065481024 M:716460032 DEBUG: ParentPath = [] 22:16:56 T:3065481024 M:716460032 DEBUG: GetGenresNav query: select * from genre where (idGenre IN (select song.idGenre from song) or idGenre IN (select exgenresong.idGenre from exgenresong)) and genre.strGenre != "" 22:16:56 T:3065481024 M:716320768 DEBUG: Album format left = [%B] 22:16:56 T:3065481024 M:716320768 DEBUG: Album format right = [%A] 22:16:56 T:3065481024 M:716320768 DEBUG: Album format left = [%B] 22:16:56 T:3065481024 M:716320768 DEBUG: Album format right = [%A] 22:16:56 T:3065481024 M:716320768 DEBUG: Album format left = [%B] 22:16:56 T:3065481024 M:716320768 DEBUG: Album format right = [%A] 22:16:56 T:3065481024 M:716320768 DEBUG: Sort, sorting took 0 millis 22:16:56 T:3065481024 M:716320768 DEBUG: Load list-focus.png: 0.1ms (bundled) 22:16:56 T:3065481024 M:716320768 DEBUG: Load defaultFolderBackBig.png: 1.8ms (bundled) 22:16:56 T:3065481024 M:716341248 DEBUG: SDLKeyboard: scancode: 104, sym: 274, unicode: 0, modifier: 1000 22:16:56 T:3065481024 M:716341248 DEBUG: OnKey: 61480 pressed, action is 4 22:16:56 T:3065481024 M:716341248 DEBUG: Load DefaultMusicArtists.png: 1.8ms (bundled) 22:16:57 T:3065481024 M:716341248 DEBUG: SDLKeyboard: scancode: 36, sym: 13, unicode: 13, modifier: 1000 22:16:57 T:3065481024 M:716341248 DEBUG: OnKey: 61453 pressed, action is 7 22:16:57 T:3065481024 M:716341248 DEBUG: Clearing cached fileitems [musicdb://1/3/] 22:16:57 T:3065481024 M:716341248 DEBUG: CGUIMediaWindow::GetDirectory (musicdb://1/3/) 22:16:57 T:3065481024 M:716341248 DEBUG: ParentPath = [musicdb://1/] 22:16:57 T:3065481024 M:716341248 DEBUG: GetArtistsNav query: select * from artist where (idArtist IN (select album.idArtist from album where album.idGenre=3) or idArtist IN (select album.idArtist from album join exgenrealbum on album.idAlbum=exgenrealbum.idAlbum where exgenrealbum.idGenre=3)or idArtist IN (select exartistalbum.idArtist from exartistalbum join album on exartistalbum.idAlbum=album.idAlbum join exgenrealbum on album.idAlbum=exgenrealbum.idAlbum where exgenrealbum.idGenre=3) or idArtist IN (select exartistalbum.idArtist from exartistalbum join album on exartistalbum.idAlbum=album.idAlbum where album.idGenre=3) ) and artist.strArtist != "" 22:16:57 T:3065481024 M:716341248 DEBUG: Time to retrieve artists from dataset = 98 22:16:57 T:3065481024 M:716341248 DEBUG: Album format left = [%B] 22:16:57 T:3065481024 M:716341248 DEBUG: Album format right = [%A] 22:16:57 T:3065481024 M:716341248 DEBUG: Album format left = [%B] 22:16:57 T:3065481024 M:716341248 DEBUG: Album format right = [%A] 22:16:57 T:3065481024 M:716341248 DEBUG: Album format left = [%B] 22:16:57 T:3065481024 M:716341248 DEBUG: Album format right = [%A] 22:16:57 T:3065481024 M:716341248 DEBUG: Sort, sorting took 1 millis 22:16:57 T:3065481024 M:716341248 DEBUG: Load list-focus.png: 0.1ms (bundled) 22:16:57 T:3065481024 M:716374016 DEBUG: SDLKeyboard: scancode: 104, sym: 274, unicode: 0, modifier: 1000 22:16:57 T:3065481024 M:716374016 DEBUG: OnKey: 61480 pressed, action is 4 22:16:57 T:3065481024 M:716304384 DEBUG: Load DefaultMusicAlbums.png: 1.9ms (bundled) 22:16:58 T:3065481024 M:716304384 DEBUG: SDLKeyboard: scancode: 104, sym: 274, unicode: 0, modifier: 1000 22:16:58 T:3065481024 M:716304384 DEBUG: OnKey: 61480 pressed, action is 4 22:16:58 T:3065481024 M:716025856 DEBUG: Load DefaultArtistBig.png: 2.0ms (bundled) 22:16:58 T:3065481024 M:716234752 DEBUG: SDLKeyboard: scancode: 104, sym: 274, unicode: 0, modifier: 1000 22:16:58 T:3065481024 M:716234752 DEBUG: OnKey: 61480 pressed, action is 4 22:16:58 T:3065481024 M:716234752 DEBUG: Load special://home/userdata/Thumbnails/Music/Artists/f34696f9.tbn: 10.9ms 22:16:59 T:3065481024 M:716251136 DEBUG: SDLKeyboard: scancode: 104, sym: 274, unicode: 0, modifier: 1000 22:16:59 T:3065481024 M:716251136 DEBUG: OnKey: 61480 pressed, action is 4 22:16:59 T:3065481024 M:716251136 DEBUG: Load special://home/userdata/Thumbnails/Music/Artists/684688fb.tbn: 10.9ms 22:17:02 T:3065481024 M:716140544 DEBUG: SDLKeyboard: scancode: 104, sym: 274, unicode: 0, modifier: 1000 22:17:02 T:3065481024 M:716140544 DEBUG: OnKey: 61480 pressed, action is 4 22:17:02 T:3065481024 M:716140544 DEBUG: Load DefaultArtistBig.png: 1.9ms (bundled) 22:17:03 T:3065481024 M:716140544 DEBUG: SDLKeyboard: scancode: 98, sym: 273, unicode: 0, modifier: 1000 22:17:03 T:3065481024 M:716140544 DEBUG: OnKey: 61478 pressed, action is 3 22:17:03 T:3065481024 M:716140544 DEBUG: Load special://home/userdata/Thumbnails/Music/Artists/684688fb.tbn: 10.4ms 22:17:03 T:3065481024 M:716140544 DEBUG: SDLKeyboard: scancode: 36, sym: 13, unicode: 13, modifier: 1000 22:17:03 T:3065481024 M:716140544 DEBUG: OnKey: 61453 pressed, action is 7 22:17:03 T:3065481024 M:716140544 DEBUG: Clearing cached fileitems [musicdb://1/3/7/] 22:17:03 T:3065481024 M:716140544 DEBUG: CGUIMediaWindow::GetDirectory (musicdb://1/3/7/) 22:17:03 T:3065481024 M:716140544 DEBUG: ParentPath = [musicdb://1/3/] 22:17:03 T:3065481024 M:716140544 DEBUG: GetAlbumsByWhere query: select * from albumview where (idAlbum IN (select song.idAlbum from song where song.idGenre=3) or idAlbum IN (select song.idAlbum from song join exgenresong on song.idSong=exgenresong.idSong where exgenresong.idGenre=3)) and (idAlbum IN (select song.idAlbum from song where song.idArtist=7) or idAlbum IN (select song.idAlbum from song join exartistsong on song.idSong=exartistsong.idSong where exartistsong.idArtist=7) or idAlbum IN (select album.idAlbum from album where album.idArtist=7) or idAlbum IN (select exartistalbum.idAlbum from exartistalbum where exartistalbum.idArtist=7)) and albumview.strAlbum != "" 22:17:03 T:3065481024 M:716001280 DEBUG: Album format left = [%B] 22:17:03 T:3065481024 M:716001280 DEBUG: Album format right = [%A] 22:17:03 T:3065481024 M:716001280 DEBUG: Album format left = [%B] 22:17:03 T:3065481024 M:716001280 DEBUG: Album format right = [%A] 22:17:03 T:3065481024 M:716001280 DEBUG: Album format left = [%B] 22:17:03 T:3065481024 M:716001280 DEBUG: Album format right = [%A] 22:17:03 T:3065481024 M:716001280 DEBUG: Sort, sorting took 0 millis 22:17:03 T:3065481024 M:716001280 DEBUG: Load DefaultMusicSongs.png: 1.8ms (bundled) 22:17:03 T:3065481024 M:716001280 DEBUG: Load folder-focus.png: 0.3ms (bundled) 22:17:03 T:3065481024 M:716001280 DEBUG: Load defaultFolderBackBig.png: 1.3ms (bundled) 22:17:04 T:3065481024 M:716001280 DEBUG: SDLKeyboard: scancode: 102, sym: 275, unicode: 0, modifier: 1000 22:17:04 T:3065481024 M:716001280 DEBUG: OnKey: 61479 pressed, action is 2 22:17:04 T:3065481024 M:716013568 DEBUG: SDLKeyboard: scancode: 36, sym: 13, unicode: 13, modifier: 1000 22:17:04 T:3065481024 M:716013568 DEBUG: OnKey: 61453 pressed, action is 7 22:17:04 T:3065481024 M:716013568 DEBUG: Clearing cached fileitems [musicdb://1/3/7/18/] 22:17:04 T:3065481024 M:716013568 DEBUG: CGUIMediaWindow::GetDirectory (musicdb://1/3/7/18/) 22:17:04 T:3065481024 M:716013568 DEBUG: ParentPath = [musicdb://1/3/7/] 22:17:04 T:3065481024 M:716013568 DEBUG: GetSongsByWhere query = select * from songview where (idAlbum=18) and (idGenre=3 or idSong IN (select exgenresong.idSong from exgenresong where exgenresong.idGenre=3)) and (idArtist=7 or idSong IN (select exartistsong.idSong from exartistsong where exartistsong.idArtist=7)or idSong IN (select song.idSong from song join album on song.idAlbum=album.idAlbum where album.idArtist=7)or idSong IN (select song.idSong from song join exartistalbum on song.idAlbum=exartistalbum.idAlbum join album on song.idAlbum=album.idAlbum where exartistalbum.idArtist=7 and album.strExtraArtists != '')) 22:17:04 T:3065481024 M:713158656 DEBUG: GetSongsByWhere(where (idAlbum=18) and (idGenre=3 or idSong IN (select exgenresong.idSong from exgenresong where exgenresong.idGenre=3)) and (idArtist=7 or idSong IN (select exartistsong.idSong from exartistsong where exartistsong.idArtist=7)or idSong IN (select song.idSong from song join album on song.idAlbum=album.idAlbum where album.idArtist=7)or idSong IN (select song.idSong from song join exartistalbum on song.idAlbum=exartistalbum.idAlbum join album on song.idAlbum=album.idAlbum where exartistalbum.idArtist=7 and album.strExtraArtists != '')) ) - took 39 ms 22:17:04 T:3065481024 M:715665408 DEBUG: Album format left = [%B] 22:17:04 T:3065481024 M:715665408 DEBUG: Album format right = [%A] 22:17:04 T:3065481024 M:715665408 DEBUG: Album format left = [%B] 22:17:04 T:3065481024 M:715665408 DEBUG: Album format right = [%A] 22:17:04 T:3065481024 M:715665408 DEBUG: Album format left = [%B] 22:17:04 T:3065481024 M:715665408 DEBUG: Album format right = [%A] 22:17:04 T:3065481024 M:715665408 DEBUG: Sort, sorting took 0 millis 22:17:04 T:3065481024 M:715665408 DEBUG: Load list-focus.png: 0.1ms (bundled) 22:17:04 T:3065481024 M:715665408 DEBUG: Load defaultFolderBackBig.png: 1.4ms (bundled) 22:17:04 T:3065481024 M:715665408 DEBUG: Load diffuse_mirror2.png: 1.0ms (bundled) 22:17:04 T:3065481024 M:715665408 DEBUG: Load separator.png: 0.1ms (bundled) 22:17:05 T:3065481024 M:715665408 DEBUG: SDLKeyboard: scancode: 104, sym: 274, unicode: 0, modifier: 1000 22:17:05 T:3065481024 M:715665408 DEBUG: OnKey: 61480 pressed, action is 4 22:17:05 T:3065481024 M:715665408 DEBUG: Load defaultAudioBig.png: 29.1ms (bundled) 22:17:05 T:3065481024 M:715665408 DEBUG: Load rating0.png: 0.2ms (bundled) 22:17:05 T:3065481024 M:715673600 DEBUG: SDLKeyboard: scancode: 36, sym: 13, unicode: 13, modifier: 1000 22:17:05 T:3065481024 M:715673600 DEBUG: OnKey: 61453 pressed, action is 7 22:17:05 T:3065481024 M:715673600 DEBUG: new file set audiostream:0 22:17:05 T:3065481024 M:715673600 DEBUG: CPlayerCoreFactory::GetPlayers(musicdb://1/3/7/18/215.mp3) 22:17:05 T:3065481024 M:715464704 DEBUG: SECTION:LoadDLL(special://xbmc/system/players/paplayer/MADCodec-i486-linux.so) 22:17:05 T:3065481024 M:715464704 DEBUG: Loading: /usr/share/xbmc/system/players/paplayer/MADCodec-i486-linux.so 22:17:05 T:3065481024 M:715464704 INFO: MP3Codec: Loaded decoder at 0xad37c08 22:17:05 T:3065481024 M:715464704 DEBUG: SECTION:LoadDLL(special://xbmc/system/players/paplayer/MACDll-i486-linux.so) 22:17:05 T:3065481024 M:715464704 DEBUG: Loading: /usr/share/xbmc/system/players/paplayer/MACDll-i486-linux.so 22:17:05 T:3065481024 M:715489280 DEBUG: SECTION:LoadDLL(special://xbmc/system/libid3tag-i486-linux.so) 22:17:05 T:3065481024 M:715489280 DEBUG: Loading: /usr/share/xbmc/system/libid3tag-i486-linux.so 22:17:05 T:3065481024 M:699752448 DEBUG: CFileCache::Open - opening <1/3/7/18/215.mp3> using cache 22:17:05 T:2804882320 M:699752448 DEBUG: Running thread 2804882320 22:17:05 T:2804882320 M:699752448 DEBUG: thread start, auto delete: 0 22:17:05 T:3065481024 M:700002304 INFO: PAPlayer: Playing musicdb://1/3/7/18/215.mp3 22:17:05 T:3065481024 M:700002304 DEBUG: PulseAudio: Opening Channels: 2 - SampleRate: 44100 - SampleBit: 16 - Resample false - Codec - IsMusic true - IsPassthrough false - audioHost: default - audioDevice: default 22:17:05 T:2804882320 M:700018688 INFO: CFileCache::Process - Hit eof. 22:17:10 T:3065481024 M:699957248 DEBUG: PulseAudio: Context failed 22:17:10 T:3065481024 M:699957248 ERROR: PulseAudio: Waited for the Context but it failed 22:17:11 T:3065481024 M:699990016 DEBUG: CALSADirectSound::CALSADirectSound - Channels: 2 - SampleRate: 44100 - SampleBit: 16 - Resample false - Codec - IsMusic true - IsPassthrough false - audioDevice: default 22:17:11 T:3065481024 M:699990016 DEBUG: Initialize - using alsa device default 22:17:11 T:3065481024 M:699990016 DEBUG: CALSADirectSound::Initialize - packet size:3760, packet count:8, buffer size:7526 22:17:11 T:2796489616 M:699990016 DEBUG: Running thread 2796489616 22:17:11 T:2796489616 M:699990016 DEBUG: thread start, auto delete: 0 22:17:11 T:2796489616 M:699990016 DEBUG: PAPlayer: Thread started 22:17:11 T:2796489616 M:699990016 DEBUG: Playback has started 22:17:11 T:3065481024 M:699990016 DEBUG: Playback has started 22:17:11 T:3065481024 M:699850752 DEBUG: Load black-back2.png: 1.3ms (bundled) 22:17:11 T:3065481024 M:699502592 DEBUG: Load defaultAlbumCover.png: 3.4ms (bundled) 22:17:11 T:3065481024 M:699363328 DEBUG: Load PlayerControls-RepeatNF.png: 0.2ms (bundled) 22:17:11 T:3065481024 M:699363328 DEBUG: CGUIInfoManager::SetCurrentSong(musicdb://1/3/7/18/215.mp3) 22:17:11 T:3065481024 M:699363328 DEBUG: Loading additional tag info for file /home/music/Alternative/Amy Winehouse - Back to Black/101-amy_winehouse-rehab-ukp.mp3 22:17:11 T:3065481024 M:699363328 DEBUG: CGUIInfoManager::SetCurrentSong(musicdb://1/3/7/18/215.mp3) 22:17:11 T:2796489616 M:699363328 INFO: AudioDecoder: File is queued 22:17:11 T:3065481024 M:699363328 DEBUG: Loading additional tag info for file /home/music/Alternative/Amy Winehouse - Back to Black/101-amy_winehouse-rehab-ukp.mp3 22:17:11 T:3065481024 M:699363328 INFO: CheckIdle - Closing session to http://xoap.weather.com (easy=0xae505558, multi=0xae500960) 22:17:11 T:3065481024 M:699363328 INFO: CheckIdle - Closing session to http://www.google.com (easy=0xac0f4e0, multi=(nil)) 22:17:11 T:3065481024 M:699363328 DEBUG: SDLKeyboard: scancode: 104, sym: 274, unicode: 0, modifier: 1000 22:17:11 T:3065481024 M:699363328 DEBUG: OnKey: 61480 pressed, action is 4 22:17:11 T:3065481024 M:699465728 DEBUG: SDLKeyboard: scancode: 104, sym: 274, unicode: 0, modifier: 1000 22:17:11 T:3065481024 M:699465728 DEBUG: OnKey: 61480 pressed, action is 4 22:17:11 T:3065481024 M:699465728 DEBUG: SDLKeyboard: scancode: 104, sym: 274, unicode: 0, modifier: 1000 22:17:11 T:3065481024 M:699465728 DEBUG: OnKey: 61480 pressed, action is 4 22:17:35 T:3065481024 M:699162624 DEBUG: SECTION:UnloadDelayed(DLL: special://xbmc/system/players/paplayer/MACDll-i486-linux.so) 22:17:35 T:3065481024 M:699162624 DEBUG: Unloading: MACDll-i486-linux.so 22:17:41 T:3065481024 M:698949632 DEBUG: SECTION:UnloadDelayed(DLL: special://xbmc/system/libid3tag-i486-linux.so) 22:17:41 T:3065481024 M:698949632 DEBUG: Unloading: libid3tag-i486-linux.so 22:20:41 T:2796489616 M:698417152 DEBUG: Player has asked for the next item 22:20:41 T:3065481024 M:698347520 INFO: MP3Codec: Loaded decoder at 0xae266a0 22:20:41 T:3065481024 M:698347520 DEBUG: SECTION:LoadDLL(special://xbmc/system/players/paplayer/MACDll-i486-linux.so) 22:20:41 T:3065481024 M:698347520 DEBUG: Loading: /usr/share/xbmc/system/players/paplayer/MACDll-i486-linux.so 22:20:41 T:3065481024 M:698347520 DEBUG: SECTION:LoadDLL(special://xbmc/system/libid3tag-i486-linux.so) 22:20:41 T:3065481024 M:698347520 DEBUG: Loading: /usr/share/xbmc/system/libid3tag-i486-linux.so 22:20:41 T:3065481024 M:682471424 DEBUG: CFileCache::Open - opening <1/3/7/18/216.mp3> using cache 22:20:41 T:2788096912 M:682446848 DEBUG: Running thread 2788096912 22:20:41 T:2788096912 M:682446848 DEBUG: thread start, auto delete: 0 22:20:41 T:3065481024 M:682479616 INFO: PAPlayer: Queuing next file musicdb://1/3/7/18/216.mp3 22:20:41 T:2788096912 M:682385408 INFO: CFileCache::Process - Hit eof. 22:20:41 T:2796489616 M:682385408 INFO: AudioDecoder: File is queued 22:20:46 T:2796489616 M:682242048 INFO: CAudioDecoder::GetData() ending track - only have 2136 samples left 22:20:46 T:2796489616 M:682242048 DEBUG: PAPlayer: Swapping tracks 0 to 1 22:20:46 T:2796489616 M:682242048 DEBUG: PAPlayer::Prefixing 2136 samples of old data to new track for gapless playback 22:20:46 T:2796489616 M:682242048 INFO: PAPlayer: Starting new track 22:20:46 T:2804882320 M:682450944 DEBUG: Thread 2804882320 terminating 22:20:46 T:2796489616 M:698187776 DEBUG: Playback has started 22:20:46 T:3065481024 M:698187776 DEBUG: CGUIInfoManager::SetCurrentSong(musicdb://1/3/7/18/216.mp3) 22:20:46 T:3065481024 M:698187776 DEBUG: Loading additional tag info for file /home/music/Alternative/Amy Winehouse - Back to Black/102-amy_winehouse-you_know_im_no_good-ukp.mp3 22:21:11 T:3065481024 M:698142720 DEBUG: SECTION:UnloadDelayed(DLL: special://xbmc/system/players/paplayer/MACDll-i486-linux.so) 22:21:11 T:3065481024 M:698142720 DEBUG: Unloading: MACDll-i486-linux.so 22:21:16 T:3065481024 M:698142720 DEBUG: SECTION:UnloadDelayed(DLL: special://xbmc/system/libid3tag-i486-linux.so) 22:21:16 T:3065481024 M:698142720 DEBUG: Unloading: libid3tag-i486-linux.so 22:22:44 T:3065481024 M:698195968 DEBUG: SDLKeyboard: scancode: 9, sym: 27, unicode: 27, modifier: 1000 22:22:44 T:3065481024 M:698195968 DEBUG: OnKey: 61467 pressed, action is 10 22:22:44 T:3065481024 M:698195968 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 22:22:44 T:3065481024 M:698195968 DEBUG: ------------------- GUI_MSG_WINDOW_DEINIT 22:22:44 T:3065481024 M:698195968 DEBUG: Muziek/Bibliotheek 22:22:44 T:3065481024 M:698195968 DEBUG: ------------------- 22:22:44 T:3065481024 M:708849664 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 22:22:44 T:3065481024 M:708849664 DEBUG: ------------------- GUI_MSG_WINDOW_INIT 22:22:44 T:3065481024 M:708849664 DEBUG: Home 22:22:44 T:3065481024 M:708849664 DEBUG: ------------------- 22:22:44 T:3065481024 M:708849664 INFO: Loading skin file: Home.xml 22:22:44 T:3065481024 M:708849664 DEBUG: Load Home.xml: 31.14ms 22:22:44 T:3065481024 M:708849664 DEBUG: Load home-button.png: 0.1ms (bundled) 22:22:44 T:3065481024 M:708849664 DEBUG: Load home-playmedia.png: 0.5ms (bundled) 22:22:44 T:3065481024 M:708849664 DEBUG: Load home-favourites.png: 0.6ms (bundled) 22:22:44 T:3065481024 M:708849664 DEBUG: Load home-power.png: 0.6ms (bundled) 22:22:44 T:3065481024 M:708849664 DEBUG: Alloc resources: 36.77ms (32.45 ms skin load, 0.29 ms preload) 22:22:44 T:3065481024 M:700424192 DEBUG: Load Background-Home-2.png: 51.2ms (bundled) 22:22:44 T:3065481024 M:700424192 DEBUG: Load gradient.png: 0.2ms (bundled) 22:22:44 T:3065481024 M:700424192 DEBUG: Load defaultAlbumCover.png: 2.8ms (bundled) 22:22:44 T:3065481024 M:699797504 DEBUG: Load Home-Menu-Back.png: 11.8ms (bundled) 22:22:44 T:3065481024 M:699797504 DEBUG: Load home-button-focus.gif: 5.7ms (bundled) 22:22:44 T:3065481024 M:697778176 DEBUG: Load Header.png: 9.6ms (bundled) 22:22:44 T:3065481024 M:697778176 DEBUG: Load xbmc-logo.png: 3.4ms (bundled) 22:22:44 T:3065481024 M:695132160 DEBUG: Load Footer.png: 9.7ms (bundled) 22:22:45 T:3065481024 M:695132160 DEBUG: SDLKeyboard: scancode: 9, sym: 27, unicode: 27, modifier: 1000 22:22:45 T:3065481024 M:695132160 DEBUG: OnKey: 61467 pressed, action is 10 22:22:46 T:3065481024 M:695148544 DEBUG: SDLKeyboard: scancode: 9, sym: 27, unicode: 27, modifier: 1000 22:22:46 T:3065481024 M:695148544 DEBUG: OnKey: 61467 pressed, action is 10 22:22:50 T:3065481024 M:694456320 DEBUG: Load home-power-focus.gif: 53.5ms (bundled) 22:22:50 T:3065481024 M:692506624 DEBUG: Load home-favourites-focus.gif: 57.0ms (bundled) 22:22:50 T:3065481024 M:692506624 DEBUG: Load home-power.png: 0.6ms (bundled) 22:22:50 T:3065481024 M:692506624 DEBUG: Load home-favourites.png: 0.6ms (bundled) 22:22:51 T:3065481024 M:694460416 DEBUG: Load home-power-focus.gif: 51.4ms (bundled) 22:22:51 T:3065481024 M:694394880 DEBUG: OnMessage : Translating ActivateWindow(ShutdownMenu) 22:22:51 T:3065481024 M:694394880 DEBUG: OnMessage : To ActivateWindow(ShutdownMenu) 22:22:51 T:3065481024 M:694394880 DEBUG: Activating window ID: 10111 22:22:51 T:3065481024 M:694394880 DEBUG: Checking if window ID 10111 is locked. 22:22:51 T:3065481024 M:694394880 DEBUG: ------------------- GUI_MSG_WINDOW_INIT 22:22:51 T:3065481024 M:694394880 DEBUG: 22:22:51 T:3065481024 M:694394880 DEBUG: ------------------- 22:22:51 T:3065481024 M:694394880 INFO: Loading skin file: DialogButtonMenu.xml 22:22:51 T:3065481024 M:694394880 DEBUG: Load DialogButtonMenu.xml: 15.69ms 22:22:51 T:3065481024 M:692514816 DEBUG: Load sub-master-focus.gif: 56.0ms (bundled) 22:22:51 T:3065481024 M:692514816 DEBUG: Load sub-master-nofocus.png: 0.4ms (bundled) 22:22:51 T:3065481024 M:690634752 DEBUG: Load sub-nomaster-focus.gif: 54.8ms (bundled) 22:22:51 T:3065481024 M:690634752 DEBUG: Load sub-nomaster-nofocus.png: 0.5ms (bundled) 22:22:52 T:3065481024 M:688685056 DEBUG: Load sub-info-focus.gif: 56.6ms (bundled) 22:22:52 T:3065481024 M:688685056 DEBUG: Load sub-info-nofocus.png: 0.3ms (bundled) 22:22:52 T:3065481024 M:686804992 DEBUG: Load sub-logoff-focus.gif: 56.4ms (bundled) 22:22:52 T:3065481024 M:686804992 DEBUG: Load sub-logoff-nofocus.png: 0.3ms (bundled) 22:22:52 T:3065481024 M:684924928 DEBUG: Load sub-exit-focus.gif: 61.5ms (bundled) 22:22:52 T:3065481024 M:684924928 DEBUG: Load sub-exit-nofocus.png: 0.3ms (bundled) 22:22:52 T:3065481024 M:684924928 DEBUG: Load sub-shutdown-nofocus.png: 0.4ms (bundled) 22:22:52 T:3065481024 M:682905600 DEBUG: Load sub-suspend-focus.gif: 56.7ms (bundled) 22:22:52 T:3065481024 M:682905600 DEBUG: Load sub-suspend-nofocus.png: 0.3ms (bundled) 22:22:52 T:3065481024 M:681095168 DEBUG: Load sub-favs-focus.gif: 55.5ms (bundled) 22:22:52 T:3065481024 M:681095168 DEBUG: Load sub-favs-nofocus.png: 0.4ms (bundled) 22:22:52 T:3065481024 M:679075840 DEBUG: Load sub-reboot-focus.gif: 56.2ms (bundled) 22:22:52 T:3065481024 M:679075840 DEBUG: Load sub-reboot-nofocus.png: 0.4ms (bundled) 22:22:52 T:3065481024 M:677265408 DEBUG: Load sub-eject-focus.gif: 55.3ms (bundled) 22:22:52 T:3065481024 M:677265408 DEBUG: Load sub-eject-nofocus.png: 0.4ms (bundled) 22:22:52 T:3065481024 M:675246080 DEBUG: Load sub-shutdown-focus.gif: 55.1ms (bundled) 22:22:52 T:3065481024 M:675246080 DEBUG: Alloc resources: 596.19ms (16.56 ms skin load, 0.69 ms preload) 22:22:52 T:3065481024 M:675246080 DEBUG: Load sub-background.png: 0.4ms (bundled) 22:22:52 T:3065481024 M:675246080 DEBUG: Load sub-background-label.png: 0.1ms (bundled) 22:22:53 T:3065481024 M:675225600 DEBUG: Load sub-info-focus.gif: 54.7ms (bundled) 22:22:54 T:3065481024 M:675225600 DEBUG: Load sub-info-nofocus.png: 0.3ms (bundled) 22:22:54 T:3065481024 M:675225600 DEBUG: OnMessage : Translating dialog.close(all,true) 22:22:54 T:3065481024 M:675225600 DEBUG: OnMessage : To dialog.close(all,true) 22:22:54 T:3065481024 M:675225600 DEBUG: ------------------- GUI_MSG_WINDOW_DEINIT 22:22:54 T:3065481024 M:675225600 DEBUG: 22:22:54 T:3065481024 M:675225600 DEBUG: ------------------- 22:22:54 T:3065481024 M:684486656 DEBUG: OnMessage : Translating XBMC.Quit() 22:22:54 T:3065481024 M:684486656 DEBUG: OnMessage : To XBMC.Quit() 22:22:54 T:3065481024 M:684494848 NOTICE: Storing total System Uptime 22:22:54 T:3065481024 M:684494848 NOTICE: Saving settings 22:22:54 T:3065481024 M:684494848 NOTICE: stop all 22:22:54 T:3065481024 M:684494848 DEBUG: NetworkMessage - Stopping network services 22:22:54 T:3065481024 M:684494848 NOTICE: Webserver: Stopping... 22:22:54 T:2889309072 M:684494848 DEBUG: WebServer:Exiting thread sockReady=0, sockSelect=0. 22:22:54 T:2889309072 M:684494848 DEBUG: WebServer:OnExit - Exit web server. 22:22:54 T:2889309072 M:684494848 DEBUG: Thread 2889309072 terminating 22:22:54 T:3065481024 M:684494848 DEBUG: xbmcHttpShim ends 22:22:54 T:3065481024 M:684494848 DEBUG: xbmcHttp ends 22:22:54 T:3065481024 M:684494848 NOTICE: Webserver: Stopped... 22:22:54 T:3065481024 M:684494848 DEBUG: CZeroconfAvahi::doRemoveService named: servers.webserver 22:22:54 T:3065481024 M:684494848 DEBUG: CZeroconfAvahi::doRemoveService named: servers.webapi 22:22:54 T:3065481024 M:684494848 NOTICE: ES: Stopping event server 22:22:54 T:2872523664 M:684494848 NOTICE: DS: DBUS server stopped 22:22:54 T:2872523664 M:684494848 DEBUG: Thread 2872523664 terminating 22:22:54 T:3065481024 M:684494848 NOTICE: stopping zeroconf publishing 22:22:54 T:3065481024 M:684494848 NOTICE: stop dvd detect media 22:22:54 T:3065481024 M:684494848 NOTICE: stop player 22:22:54 T:2796489616 M:684494848 INFO: PAPlayer: End of playback reached 22:22:54 T:2796489616 M:684494848 DEBUG: Playback was stopped 22:22:54 T:2796489616 M:684494848 DEBUG: PAPlayer: Thread end 22:22:54 T:2796489616 M:684494848 DEBUG: Thread 2796489616 terminating 22:22:54 T:2788096912 M:685191168 DEBUG: Thread 2788096912 terminating 22:22:55 T:3065481024 M:700968960 NOTICE: clean cached files! 22:22:55 T:3065481024 M:700968960 NOTICE: unload skin 22:22:55 T:3065481024 M:700968960 DEBUG: ------------------- GUI_MSG_WINDOW_DEINIT 22:22:55 T:3065481024 M:700968960 DEBUG: Home 22:22:55 T:3065481024 M:700968960 DEBUG: ------------------- 22:22:55 T:3065481024 M:716984320 DEBUG: ------------------- GUI_MSG_WINDOW_DEINIT 22:22:55 T:3065481024 M:716984320 DEBUG: Sorteer op: Formaat 22:22:55 T:3065481024 M:716984320 DEBUG: ------------------- 22:22:55 T:3065481024 M:725479424 DEBUG: ------------------- GUI_MSG_WINDOW_DEINIT 22:22:55 T:3065481024 M:725479424 DEBUG: 22:22:55 T:3065481024 M:725479424 DEBUG: ------------------- 22:22:55 T:3065481024 M:725479424 NOTICE: stop python 22:22:55 T:3065481024 M:725479424 NOTICE: stopped 22:22:55 T:3065481024 M:725479424 NOTICE: destroy 22:22:55 T:3065481024 M:726872064 NOTICE: unload sections 22:22:55 T:3065481024 M:726872064 DEBUG: SECTION:UnloadAll(SECTION: LIBHTTP) 22:22:55 T:3065481024 M:726872064 DEBUG: SECTION:UnloadAll(DLL: /usr/lib/libcurl.so) 22:22:55 T:3065481024 M:726872064 DEBUG: Unloading: libcurl.so 22:22:55 T:3065481024 M:726872064 DEBUG: SECTION:UnloadAll(DLL: special://xbmc/system/players/paplayer/MADCodec-i486-linux.so) 22:22:55 T:3065481024 M:726872064 DEBUG: Unloading: MADCodec-i486-linux.so 22:22:55 T:3065481024 M:726872064 NOTICE: performance statistics 22:22:55 T:3065481024 M:726933504 INFO: DumpStats - estimated error: 0.000003 22:22:55 T:3065481024 M:726933504 INFO: DumpStats - ignore user/sys values when sample count is low 22:22:55 T:3065481024 M:726933504 INFO: DumpStats - counter . avg duration: <0.001246 sec>, avg user: <0.000000>, avg sys: <0.000000> (10886 samples) 22:22:55 T:3065481024 M:726933504 INFO: DumpStats - counter . avg duration: <0.000308 sec>, avg user: <0.000104>, avg sys: <0.000053> (10886 samples) 22:22:55 T:3065481024 M:726933504 INFO: DumpStats - counter . avg duration: <0.000664 sec>, avg user: <0.000000>, avg sys: <0.000000> (10886 samples) 22:22:55 T:3065481024 M:726933504 INFO: DumpStats - counter . avg duration: <0.000262 sec>, avg user: <0.000000>, avg sys: <0.000000> (10886 samples) 22:22:55 T:3065481024 M:726933504 INFO: DumpStats - counter . avg duration: <0.000258 sec>, avg user: <0.000000>, avg sys: <0.000000> (10886 samples) 22:22:55 T:3065481024 M:726933504 INFO: DumpStats - counter . avg duration: <0.033344 sec>, avg user: <0.000034>, avg sys: <0.000009> (10919 samples) 22:22:55 T:3065481024 M:726933504 INFO: DumpStats - counter . avg duration: <0.000024 sec>, avg user: <0.000000>, avg sys: <0.000000> (10919 samples) 22:22:55 T:3065481024 M:726933504 INFO: DumpStats - counter . avg duration: <0.028040 sec>, avg user: <0.000033>, avg sys: <0.000009> (10919 samples) 22:22:55 T:3065481024 M:726933504 INFO: DumpStats - counter . avg duration: <0.016537 sec>, avg user: <0.020001>, avg sys: <0.000000> (1 samples) 22:22:55 T:3065481024 M:726933504 INFO: DumpStats - counter . avg duration: <0.002870 sec>, avg user: <0.004000>, avg sys: <0.000000> (1 samples) 22:22:55 T:3065481024 M:726933504 INFO: DumpStats - counter . avg duration: <0.002754 sec>, avg user: <0.004000>, avg sys: <0.000000> (1 samples) 22:22:55 T:3065481024 M:726933504 INFO: DumpStats - counter . avg duration: <0.017295 sec>, avg user: <0.016001>, avg sys: <0.000000> (1 samples) 22:22:55 T:3065481024 M:726933504 INFO: DumpStats - counter . avg duration: <0.007148 sec>, avg user: <0.004000>, avg sys: <0.004000> (1 samples) 22:22:55 T:3065481024 M:726724608 INFO: DumpStats - counter . avg duration: <0.004962 sec>, avg user: <0.004000>, avg sys: <0.000000> (1 samples) 22:22:55 T:3065481024 M:726794240 INFO: DumpStats - counter . avg duration: <0.026249 sec>, avg user: <0.016001>, avg sys: <0.000000> (3 samples) 22:22:55 T:3065481024 M:726794240 INFO: DumpStats - counter . avg duration: <0.087658 sec>, avg user: <0.092005>, avg sys: <0.004000> (1 samples) 22:22:55 T:3065481024 M:726794240 INFO: DumpStats - counter . avg duration: <0.003749 sec>, avg user: <0.004001>, avg sys: <0.000000> (1 samples) 22:22:55 T:3065481024 M:726794240 INFO: DumpStats - counter . avg duration: <0.004229 sec>, avg user: <0.004000>, avg sys: <0.000000> (1 samples) 22:22:55 T:3065481024 M:726794240 INFO: DumpStats - counter . avg duration: <0.034975 sec>, avg user: <0.000139>, avg sys: <0.000062> (10822 samples) 22:22:56 T:2864130960 M:726880256 DEBUG: Audioscrobbler worker thread stopping 22:22:56 T:2864130960 M:726880256 DEBUG: Thread 2864130960 terminating 22:22:56 T:3065481024 M:726880256 INFO: lastfm destroyed 22:22:56 T:3065481024 M:726880256 DEBUG: object 0 --> 0 instances 22:22:56 T:3065481024 M:726880256 DEBUG: object 1 --> 0 instances 22:22:56 T:3065481024 M:726880256 DEBUG: object 2 --> 9 instances 22:22:56 T:3065481024 M:726880256 DEBUG: object 3 --> 0 instances 22:22:56 T:3065481024 M:726880256 DEBUG: object 4 --> 0 instances 22:22:56 T:3065481024 M:726880256 DEBUG: object 5 --> 0 instances 22:22:56 T:3065481024 M:726880256 DEBUG: object 6 --> 0 instances 22:22:56 T:3065481024 M:726880256 DEBUG: object 7 --> 0 instances 22:22:56 T:3065481024 M:726880256 DEBUG: object 8 --> 0 instances 22:22:56 T:3065481024 M:726880256 DEBUG: object 9 --> 0 instances