00:28:37 T:4286056464 M:122073088 NOTICE: Mapping drive Q to /usr/local/share/xbmc 00:28:37 T:4286056464 M:122073088 NOTICE: Mapping drive U to /home/wilson/.xbmc 00:28:37 T:4286056464 M:122073088 NOTICE: Mapping drive T to /home/wilson/.xbmc/userdata 00:28:37 T:4286056464 M:122073088 WARNING: CopyFile, cant open file . trying to use lowercase 00:28:37 T:4286056464 M:122073088 ERROR: CopyFile - cant open source file 00:28:37 T:4286056464 M:122073088 NOTICE: ----------------------------------------------------------------------- 00:28:37 T:4286056464 M:122073088 NOTICE: Starting XBMC, Platform: GNU/Linux. Built on Jan 21 2009 (SVN:17268) 00:28:37 T:4286056464 M:122073088 NOTICE: Q is mapped to: /usr/local/share/xbmc 00:28:37 T:4286056464 M:121933824 NOTICE: The executable running is: /usr/local/share/xbmc/xbmc.bin 00:28:37 T:4286056464 M:121933824 NOTICE: Log File is located: /var/tmp/wilson-xbmc.log 00:28:37 T:4286056464 M:121933824 NOTICE: ----------------------------------------------------------------------- 00:28:37 T:4286056464 M:121724928 NOTICE: Setup SDL 00:28:37 T:4286056464 M:120610816 INFO: Available videomodes (xrandr): 00:28:37 T:4286056464 M:120610816 INFO: Number of connected outputs: 1 00:28:37 T:4286056464 M:120610816 INFO: Output 'default' has 10 modes 00:28:37 T:4286056464 M:120610816 INFO: ID:0x91 Name:1280x720 Refresh:60.000000 Width:1280 Height:720 00:28:37 T:4286056464 M:120610816 INFO: Pixel Ratio: 1.000000 00:28:37 T:4286056464 M:120610816 INFO: ID:0x92 Name:1152x648 Refresh:60.000000 Width:1152 Height:648 00:28:37 T:4286056464 M:120610816 INFO: Pixel Ratio: 1.000000 00:28:37 T:4286056464 M:120610816 INFO: ID:0x93 Name:800x600 Refresh:60.000000 Width:800 Height:600 00:28:37 T:4286056464 M:120610816 INFO: Pixel Ratio: 1.000000 00:28:37 T:4286056464 M:120610816 INFO: ID:0x94 Name:720x480 Refresh:60.000000 Width:720 Height:480 00:28:37 T:4286056464 M:120610816 INFO: Pixel Ratio: 1.000000 00:28:37 T:4286056464 M:120610816 INFO: ID:0x95 Name:640x480 Refresh:60.000000 Width:640 Height:480 00:28:37 T:4286056464 M:120610816 INFO: Pixel Ratio: 1.000000 00:28:37 T:4286056464 M:120610816 INFO: ID:0x96 Name:640x400 Refresh:60.000000 Width:640 Height:400 00:28:37 T:4286056464 M:120610816 INFO: Pixel Ratio: 1.000000 00:28:37 T:4286056464 M:120610816 INFO: ID:0x97 Name:512x384 Refresh:60.000000 Width:512 Height:384 00:28:37 T:4286056464 M:120610816 INFO: Pixel Ratio: 1.000000 00:28:37 T:4286056464 M:120610816 INFO: ID:0x98 Name:400x300 Refresh:60.000000 Width:400 Height:300 00:28:37 T:4286056464 M:120610816 INFO: Pixel Ratio: 1.000000 00:28:37 T:4286056464 M:120610816 INFO: ID:0x99 Name:320x240 Refresh:60.000000 Width:320 Height:240 00:28:37 T:4286056464 M:120610816 INFO: Pixel Ratio: 1.000000 00:28:37 T:4286056464 M:120610816 INFO: ID:0x9a Name:320x200 Refresh:60.000000 Width:320 Height:200 00:28:37 T:4286056464 M:120610816 INFO: Pixel Ratio: 1.000000 00:28:37 T:4286056464 M:120057856 DEBUG: CLowLevelKeyboard::Initialize - XKb symbols pc_us_inet(evdev) 00:28:37 T:4286056464 M:120057856 INFO: Drives are mapped 00:28:37 T:4286056464 M:120057856 NOTICE: load settings... 00:28:37 T:4286056464 M:120057856 NOTICE: Mapping drive P to /home/wilson/.xbmc/userdata 00:28:37 T:4286056464 M:120057856 NOTICE: loading /home/wilson/.xbmc/userdata/guisettings.xml 00:28:37 T:4286056464 M:120057856 NOTICE: Getting hardware information now... 00:28:37 T:4286056464 M:120057856 INFO: Using digital output 00:28:37 T:4286056464 M:120057856 INFO: AC3 pass through is enabled 00:28:37 T:4286056464 M:120057856 INFO: DTS pass through is enabled 00:28:37 T:4286056464 M:120057856 NOTICE: Checking resolution 1 00:28:37 T:4286056464 M:120057856 NOTICE: No advancedsettings.xml to load (/home/wilson/.xbmc/userdata/advancedsettings.xml) 00:28:37 T:4286056464 M:120057856 NOTICE: Default Video Player: dvdplayer 00:28:37 T:4286056464 M:120057856 NOTICE: Default Audio Player: paplayer 00:28:37 T:4286056464 M:120057856 NOTICE: /home/wilson/.xbmc/userdata/sources.xml 00:28:37 T:4286056464 M:120057856 DEBUG: tag is missing or sources.xml is malformed 00:28:37 T:4286056464 M:120057856 INFO: Checking skinpath existence, and existence of keymap.xml:Q:\skin... 00:28:37 T:4286056464 M:116506624 DEBUG: Constructing surface 1280x720, shared=(nil), fullscreen=0 00:28:37 T:4286056464 M:116506624 INFO: GLX Info: NOT Using destination window 00:28:37 T:4286056464 M:116436992 WARNING: GLX: No Multisample buffers available, FSAA disabled 00:28:37 T:4286056464 M:116436992 INFO: GLX Info: Using parent window 00:28:37 T:4286056464 M:116436992 INFO: GLX Info: Creating unshared context 00:28:37 T:4286056464 M:116436992 INFO: GL_VENDOR = ATI Technologies Inc. 00:28:37 T:4286056464 M:116436992 INFO: GL_RENDERER = ATI Radeon HD 3450 00:28:37 T:4286056464 M:116436992 INFO: GL_VERSION = 1.4 (2.1.8591) 00:28:37 T:4286056464 M:116436992 INFO: GL_EXTENSIONS = GL_ARB_depth_texture GL_ARB_draw_buffers GL_ARB_fragment_program GL_ARB_fragment_program_shadow GL_ARB_multisample GL_ARB_multitexture GL_ARB_occlusion_query GL_ARB_point_parameters GL_ARB_point_sprite GL_ARB_shadow GL_ARB_shadow_ambient 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_non_power_of_two GL_ARB_texture_rectangle GL_ARB_transpose_matrix 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_copy_texture GL_EXT_draw_range_elements GL_EXT_fog_coord GL_EXT_framebuffer_object GL_EXT_multi_draw_arrays GL_EXT_packed_pixels GL_EXT_point_parameters 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_texture3D 00:28:37 T:4286056464 M:116436992 DEBUG: Asking to resize surface to 1280 x 720 00:28:37 T:4286056464 M:116436992 INFO: GL: Maximum texture width: 8192 00:28:37 T:4286056464 M:116436992 INFO: load language info file: /usr/local/share/xbmc/language/English/langinfo.xml 00:28:37 T:4286056464 M:116436992 DEBUG: SECTION:LoadDLL(Q:\system\ImageLib-x86_64-linux.so) 00:28:37 T:4286056464 M:116436992 DEBUG: Loading: /usr/local/share/xbmc/system/ImageLib-x86_64-linux.so 00:28:37 T:4286056464 M:116436992 WARNING: CreateFile, successfuly opened instead of 00:28:37 T:4286056464 M:114417664 DEBUG: PICTURE: loaded image and created texture. height: 401, width: 721 00:28:37 T:4286056464 M:113860608 DEBUG: Load /usr/local/share/xbmc/media/splash.png: 42.9ms 00:28:37 T:4286056464 M:115884032 INFO: load language file:/usr/local/share/xbmc/language/English/strings.xml 00:28:37 T:4286056464 M:114769920 INFO: load keymapping 00:28:37 T:4286056464 M:114769920 INFO: Loading /usr/local/share/xbmc/system/Keymap.xml 00:28:37 T:4286056464 M:114630656 DEBUG: CButtonTranslator::Load - no userdata keymap found, skipping 00:28:37 T:4286056464 M:114630656 INFO: Loading /usr/local/share/xbmc/system/Lircmap.xml 00:28:37 T:4286056464 M:114630656 INFO: Loading /home/wilson/.xbmc/userdata/Lircmap.xml 00:28:37 T:4286056464 M:114630656 INFO: Checking skin version of: PM3.HD 00:28:37 T:4286056464 M:114630656 INFO: Skin version is: 2.1 00:28:37 T:4286056464 M:114630656 INFO: GUI format 1280x720 720p 16:9 00:28:37 T:4286056464 M:114630656 INFO: install unhandled exception filter 00:28:37 T:4286056464 M:114630656 INFO: creating subdirectories 00:28:37 T:4286056464 M:114630656 INFO: userdata folder: /home/wilson/.xbmc/userdata/ 00:28:37 T:4286056464 M:114630656 INFO: recording folder: 00:28:37 T:4286056464 M:114630656 INFO: screenshots folder: 00:28:37 T:4286056464 M:114630656 INFO: thumbnails folder:/home/wilson/.xbmc/userdata/Thumbnails 00:28:37 T:4286056464 M:114630656 NOTICE: start dvd mediatype detection 00:28:37 T:4082366800 M:114630656 DEBUG: Running thread 4082366800 00:28:37 T:4082366800 M:114630656 DEBUG: thread start, auto delete: 0 00:28:37 T:4082366800 M:114630656 DEBUG: Compiled with libcdio Version 0.80 00:28:37 T:4286056464 M:114630656 NOTICE: initializing playlistplayer 00:28:37 T:4286056464 M:114630656 NOTICE: DONE initializing playlistplayer 00:28:37 T:4286056464 M:114630656 NOTICE: load default skin:[PM3.HD] 00:28:37 T:4082366800 M:114630656 DEBUG: staticThread, deleting thread graphic context 00:28:37 T:4082366800 M:114630656 DEBUG: Thread 4082366800 terminating 00:28:37 T:4286056464 M:114630656 INFO: load skin from:/usr/local/share/xbmc/skin/PM3.HD 00:28:37 T:4286056464 M:114630656 INFO: delete old skin... 00:28:37 T:4286056464 M:114630656 DEBUG: ------------------- GUI_MSG_WINDOW_DEINIT 00:28:37 T:4286056464 M:114630656 DEBUG: Sort by: Size 00:28:37 T:4286056464 M:114630656 DEBUG: ------------------- 00:28:37 T:4286056464 M:114630656 DEBUG: ------------------- GUI_MSG_WINDOW_DEINIT 00:28:37 T:4286056464 M:114630656 DEBUG: 00:28:37 T:4286056464 M:114630656 DEBUG: ------------------- 00:28:37 T:4286056464 M:114630656 INFO: Default 4:3 resolution directory is /usr/local/share/xbmc/skin/PM3.HD/720p 00:28:37 T:4286056464 M:114630656 INFO: Default 16:9 resolution directory is /usr/local/share/xbmc/skin/PM3.HD/720p 00:28:37 T:4286056464 M:114630656 INFO: Skin version is: 2.1 00:28:37 T:4286056464 M:114630656 INFO: Loading skin includes from /usr/local/share/xbmc/skin/PM3.HD/720p/includes.xml 00:28:37 T:4286056464 M:112889856 INFO: load fonts for skin... 00:28:37 T:4286056464 M:112889856 INFO: Loading fonts from /usr/local/share/xbmc/skin/PM3.HD/720p/Font.xml 00:28:37 T:4286056464 M:112820224 INFO: load new skin... 00:28:37 T:4286056464 M:112820224 INFO: Skin version is: 2.1 00:28:37 T:4286056464 M:112820224 INFO: Loading skin file: Home.xml 00:28:37 T:4073318736 M:112820224 DEBUG: Running thread 4073318736 00:28:37 T:4073318736 M:112820224 DEBUG: thread start, auto delete: 1 00:28:37 T:4073318736 M:112820224 INFO: WEATHER: Downloading weather 00:28:37 T:4073318736 M:112820224 INFO: Get URL: http://xoap.weather.com/weather/local/USNY0996?cc=*&unit=m&dayf=4&prod=xoap&link=xoap&par=1004124588&key=079f24145f208494 00:28:37 T:4286056464 M:112541696 DEBUG: Load Home.xml: 16.80ms 00:28:37 T:4286056464 M:112541696 INFO: Loading user windows, path /usr/local/share/xbmc/skin/PM3.HD/720p 00:28:37 T:4286056464 M:112541696 INFO: Loading skin file: /usr/local/share/xbmc/skin/PM3.HD/720p/custom_SkinSetting_1111.xml 00:28:37 T:4286056464 M:112472064 INFO: Loading user windows, path /usr/local/share/xbmc/skin/PM3.HD/720p 00:28:37 T:4286056464 M:112472064 INFO: Loading skin file: /usr/local/share/xbmc/skin/PM3.HD/720p/custom_SkinSetting_1111.xml 00:28:37 T:4286056464 M:112472064 INFO: Loading user windows, path /usr/local/share/xbmc/skin/PM3.HD/720p 00:28:37 T:4286056464 M:112472064 INFO: Loading skin file: /usr/local/share/xbmc/skin/PM3.HD/720p/custom_SkinSetting_1111.xml 00:28:37 T:4286056464 M:112472064 DEBUG: Load Skin XML: 28.95ms 00:28:37 T:4286056464 M:112472064 INFO: initialize new skin... 00:28:37 T:4286056464 M:112472064 INFO: Loading skin file: Pointer.xml 00:28:37 T:4286056464 M:112472064 DEBUG: Load Pointer.xml: 0.65ms 00:28:37 T:4286056464 M:112472064 DEBUG: Load pointer-nofocus.png: 0.0ms (bundled) 00:28:37 T:4286056464 M:112472064 DEBUG: Load pointer-focus.png: 0.0ms (bundled) 00:28:37 T:4286056464 M:112472064 DEBUG: Load pointer-focus-drag.png: 0.0ms (bundled) 00:28:37 T:4286056464 M:112472064 DEBUG: Load pointer-focus-click.png: 0.0ms (bundled) 00:28:37 T:4286056464 M:112472064 DEBUG: Alloc resources: 2.15ms (0.69 ms skin load, 1.21 ms preload) 00:28:37 T:4286056464 M:112472064 INFO: Loading skin file: DialogVolumeBar.xml 00:28:37 T:4286056464 M:112472064 DEBUG: Load DialogVolumeBar.xml: 1.02ms 00:28:37 T:4286056464 M:112472064 DEBUG: Load ProgressBack.png: 0.0ms (bundled) 00:28:37 T:4286056464 M:112472064 DEBUG: Load ProgressFront.png: 0.0ms (bundled) 00:28:37 T:4286056464 M:112472064 DEBUG: Alloc resources: 1.23ms (1.07 ms skin load, 0.04 ms preload) 00:28:37 T:4286056464 M:112472064 INFO: Loading skin file: DialogSeekBar.xml 00:28:37 T:4286056464 M:112472064 DEBUG: Load DialogSeekBar.xml: 3.65ms 00:28:37 T:4286056464 M:112472064 DEBUG: Load seekslider.png: 0.0ms (bundled) 00:28:37 T:4286056464 M:112472064 DEBUG: Load slider_nibFO.png: 0.0ms (bundled) 00:28:37 T:4286056464 M:112472064 DEBUG: Alloc resources: 3.88ms (3.70 ms skin load, 0.05 ms preload) 00:28:37 T:4286056464 M:112472064 INFO: Loading skin file: DialogKaiToast.xml 00:28:37 T:4286056464 M:112472064 DEBUG: Load DialogKaiToast.xml: 0.74ms 00:28:37 T:4286056464 M:112472064 DEBUG: Alloc resources: 0.77ms (0.77 ms skin load, 0.00 ms preload) 00:28:37 T:4286056464 M:112472064 INFO: Loading skin file: DialogMuteBug.xml 00:28:37 T:4286056464 M:112472064 DEBUG: Load DialogMuteBug.xml: 0.55ms 00:28:37 T:4286056464 M:112472064 DEBUG: Alloc resources: 0.58ms (0.58 ms skin load, 0.00 ms preload) 00:28:37 T:4286056464 M:112332800 INFO: Loading /usr/local/share/xbmc/skin/PM3.HD/sounds/sounds.xml 00:28:37 T:4286056464 M:112332800 INFO: skin loaded... 00:28:37 T:4047923536 M:112332800 DEBUG: Running thread 4047923536 00:28:37 T:4047923536 M:112332800 DEBUG: thread start, auto delete: 0 00:28:37 T:4047923536 M:112332800 DEBUG: staticThread, deleting thread graphic context 00:28:37 T:4047923536 M:112332800 DEBUG: Thread 4047923536 terminating 00:28:37 T:4286056464 M:112054272 DEBUG: Activating window ID: 10000 00:28:37 T:4286056464 M:112054272 DEBUG: Checking if window ID 10000 is locked. 00:28:37 T:4286056464 M:112054272 DEBUG: ------------------- GUI_MSG_WINDOW_INIT 00:28:37 T:4286056464 M:112054272 DEBUG: Home 00:28:37 T:4286056464 M:112054272 DEBUG: ------------------- 00:28:37 T:4286056464 M:112054272 DEBUG: Load home-button.png: 0.1ms (bundled) 00:28:37 T:4286056464 M:111984640 DEBUG: Load home-playmedia.png: 0.2ms (bundled) 00:28:37 T:4286056464 M:111984640 DEBUG: Load home-favourites.png: 0.2ms (bundled) 00:28:37 T:4286056464 M:111845376 DEBUG: Load home-power.png: 0.2ms (bundled) 00:28:37 T:4286056464 M:111845376 DEBUG: Alloc resources: 1.16ms (0.01 ms skin load, 0.12 ms preload) 00:28:37 T:4039530832 M:111845376 DEBUG: Running thread 4039530832 00:28:37 T:4039530832 M:111845376 DEBUG: thread start, auto delete: 1 00:28:37 T:4286056464 M:111845376 INFO: removing tempfiles 00:28:37 T:4286056464 M:111845376 INFO: HAL: Starting initializing 00:28:37 T:4286056464 M:111632384 DEBUG: HAL: Clearing old global device list, if any 00:28:37 T:4286056464 M:111632384 NOTICE: HAL: Generating global device list 00:28:37 T:4286056464 M:111632384 DEBUG: HAL: Added - disk | HotPlugged NO | Type 1 |Approved NO 00:28:37 T:4286056464 M:111632384 NOTICE: LFS: Added - disk | Volume 00:28:37 T:4286056464 M:111632384 DEBUG: HAL: Added - disk | UUID 8dc19e7a-7df8-4559-8405-f845c2d967b0 | FileSystem ext4 | Mounted on /vol1 | HotPlugged NO | Type 1 |Approved NO 00:28:37 T:4286056464 M:111632384 NOTICE: LFS: Added - disk | Volume (ext4) 00:28:37 T:4286056464 M:111632384 DEBUG: HAL: Added - disk | UUID 97336879-bf54-4a50-92fa-c6ff740dbb2f | FileSystem ext3 | Mounted on /vol0 | HotPlugged NO | Type 1 |Approved YES 00:28:37 T:4286056464 M:111632384 NOTICE: LFS: Added - disk | Volume (ext3) 00:28:37 T:4286056464 M:111632384 DEBUG: HAL: Added - disk | UUID fa07bf72-478f-4636-9ddd-1a30dd332816 | FileSystem xfs | Mounted on /var/lib | HotPlugged NO | Type 1 |Approved YES 00:28:37 T:4286056464 M:111632384 NOTICE: LFS: Added - disk | Volume (xfs) 00:28:37 T:4286056464 M:111632384 DEBUG: HAL: Added - disk | UUID 76d1e66a-f551-4992-b8e5-4825a972ea57 | FileSystem swap | HotPlugged NO | Type 1 |Approved NO 00:28:37 T:4286056464 M:111632384 NOTICE: LFS: Added - disk | Volume (swap) 00:28:37 T:4286056464 M:111632384 DEBUG: HAL: Added - disk | UUID afb331dd-4557-4a1e-8847-e9ae6d17e8d2 | FileSystem ext3 | Mounted on / | HotPlugged NO | Type 1 |Approved NO 00:28:37 T:4286056464 M:111632384 NOTICE: LFS: Added - disk | Volume (ext3) 00:28:37 T:4286056464 M:111632384 INFO: HAL: Generated global device list, found 128 00:28:37 T:4286056464 M:111632384 INFO: HAL: Sucessfully initialized 00:28:37 T:4286056464 M:111632384 NOTICE: initialize done 00:28:37 T:4286056464 M:111632384 NOTICE: Running the application... 00:28:37 T:4286056464 M:111632384 INFO: initializing python engine. 00:28:37 T:4286056464 M:111632384 DEBUG: Loading: /usr/local/share/xbmc/system/python/python24-x86_64-linux.so 00:28:37 T:4039530832 M:106975232 DEBUG: staticThread, deleting thread object 00:28:37 T:4039530832 M:106975232 DEBUG: staticThread, deleting thread graphic context 00:28:37 T:4039530832 M:106975232 DEBUG: Thread 4039530832 terminating 00:28:38 T:4073318736 M:106905600 INFO: WEATHER: Weather download successful 00:28:38 T:4286056464 M:102412288 DEBUG: new python thread created. id=1 00:28:38 T:3955222864 M:102133760 DEBUG: Running thread 3955222864 00:28:38 T:3955222864 M:102133760 DEBUG: thread start, auto delete: 0 00:28:38 T:3955222864 M:102133760 DEBUG: Python thread: start processing 00:28:38 T:4286056464 M:102133760 DEBUG: NetworkMessage - Starting network services 00:28:38 T:4286056464 M:101855232 NOTICE: Webserver: Starting... 00:28:38 T:4286056464 M:101855232 DEBUG: xbmcHttpShim starts 00:28:38 T:3946830160 M:101855232 DEBUG: Running thread 3946830160 00:28:38 T:3946830160 M:101855232 DEBUG: thread start, auto delete: 0 00:28:38 T:3946830160 M:101855232 INFO: WebServer: Server starting using /usr/local/share/xbmc/web on 192.168.80.31:8080 00:28:38 T:3946830160 M:101855232 DEBUG: DB: Registering database table 00:28:38 T:3946830160 M:101855232 DEBUG: DB: Registering database table 00:28:38 T:3946830160 M:101855232 DEBUG: DB: Registering database table 00:28:38 T:3946830160 M:101855232 DEBUG: UM: Loading User Configuration from file 00:28:38 T:3946830160 M:101855232 DEBUG: DB: About to read data file 00:28:38 T:3946830160 M:101855232 DEBUG: DB: Failed to stat persistent data file. 00:28:38 T:3946830160 M:101855232 DEBUG: webs: Listening for HTTP requests at address 192.168.80.31:8080 00:28:38 T:3946830160 M:101855232 NOTICE: Webserver: Started 00:28:38 T:3955222864 M:101052416 NOTICE: -->Python Interpreter Initialized<-- 00:28:38 T:3955222864 M:101052416 NOTICE: 00:28:38 T:3955222864 M:101052416 INFO: Scriptresult: Succes 00:28:38 T:4286056464 M:101048320 DEBUG: UM: Writing User Configuration to file 00:28:38 T:4286056464 M:101048320 DEBUG: DB: About to save database to file 00:28:38 T:4286056464 M:101048320 DEBUG: WARNING: Failed to open file /usr/local/share/xbmc/web/data.tmp 00:28:38 T:4286056464 M:101048320 NOTICE: ES: Starting event server 00:28:38 T:3938437456 M:101048320 DEBUG: Running thread 3938437456 00:28:38 T:3938437456 M:101048320 DEBUG: thread start, auto delete: 0 00:28:38 T:3930044752 M:100978688 DEBUG: Running thread 3930044752 00:28:38 T:3938437456 M:100978688 NOTICE: ES: Starting UDP Event server on 127.0.0.1:9777 00:28:38 T:3938437456 M:100978688 NOTICE: UDP: Listening on port 9777 00:28:38 T:4286056464 M: 98643968 DEBUG: Load background-videos.jpg: 19.1ms (bundled) 00:28:38 T:4286056464 M: 95916032 DEBUG: Load Background-Home-2.png: 33.4ms (bundled) 00:28:38 T:4073318736 M: 95707136 DEBUG: staticThread, deleting thread object 00:28:38 T:4073318736 M: 95567872 DEBUG: staticThread, deleting thread graphic context 00:28:38 T:4073318736 M: 95567872 DEBUG: Thread 4073318736 terminating 00:28:38 T:4286056464 M: 97751040 DEBUG: Load Home-Menu-Back.png: 3.7ms (bundled) 00:28:38 T:4286056464 M: 98705408 DEBUG: Load home-button-focus.gif: 4.2ms (bundled) 00:28:38 T:4286056464 M: 96546816 DEBUG: Load Header.png: 5.1ms (bundled) 00:28:38 T:4286056464 M: 94449664 DEBUG: Load xbmc-logo.png: 1.2ms (bundled) 00:28:38 T:4286056464 M: 94543872 DEBUG: Load Footer.png: 3.8ms (bundled) 00:28:38 T:3921652048 M: 93208576 DEBUG: Running thread 3921652048 00:28:38 T:3921652048 M: 93208576 DEBUG: thread start, auto delete: 0 00:28:38 T:3921652048 M: 93208576 INFO: Get URL: http://feeds.feedburner.com/xbmc 00:28:38 T:3955222864 M: 93278208 DEBUG: xbp_dlopen loading python lib /usr/local/share/xbmc/system/python/python24.zip/time.so. flags: 2 00:28:38 T:3955222864 M: 93278208 DEBUG: Loading: /tmp/xbmc-wilson/time.so 00:28:38 T:3955222864 M: 93278208 DEBUG: RegisterExtensionLib, adding Z:/time.so (0x7fb1ec0a2850) 00:28:38 T:3955222864 M: 93278208 DEBUG: xbp_dlsym - load symbol inittime 00:28:38 T:3955222864 M: 93278208 DEBUG: xbp_dlopen loading python lib /usr/local/share/xbmc/system/python/python24.zip/collections.so. flags: 2 00:28:38 T:3955222864 M: 93278208 DEBUG: Loading: /tmp/xbmc-wilson/collections.so 00:28:38 T:3955222864 M: 93278208 DEBUG: RegisterExtensionLib, adding Z:/collections.so (0x7fb1ec0be710) 00:28:38 T:3955222864 M: 93278208 DEBUG: xbp_dlsym - load symbol initcollections 00:28:38 T:3955222864 M: 93208576 INFO: Python script stopped 00:28:38 T:3955222864 M: 93208576 DEBUG: staticThread, deleting thread graphic context 00:28:38 T:3955222864 M: 93208576 DEBUG: Thread 3955222864 terminating 00:28:38 T:4286056464 M: 93208576 DEBUG: python thread 1 destructed 00:28:38 T:4286056464 M: 93208576 INFO: Python, unloading python24.dll because no scripts are running anymore 00:28:38 T:4286056464 M: 93208576 DEBUG: UnloadExtensionLibs, clearing python extension libraries 00:28:38 T:4286056464 M: 93208576 DEBUG: Unloading: Z:/time.so 00:28:38 T:4286056464 M: 93208576 DEBUG: Unloading: Z:/collections.so 00:28:38 T:4286056464 M: 93208576 DEBUG: Unloading: python24-x86_64-linux.so 00:28:38 T:3921652048 M: 93069312 DEBUG: Got rss feed: http://feeds.feedburner.com/xbmc 00:28:38 T:3921652048 M: 93069312 DEBUG: RSS feed encoding: ISO-8859-1 00:28:38 T:3921652048 M: 93069312 DEBUG: Parsed rss feed: http://feeds.feedburner.com/xbmc 00:28:38 T:3921652048 M: 93069312 DEBUG: staticThread, deleting thread graphic context 00:28:38 T:3921652048 M: 93069312 DEBUG: Thread 3921652048 terminating 00:28:39 T:4286056464 M: 92205056 DEBUG: Update - NEW at 2247:000000037ff07be1 00 Up mceusb 00:28:39 T:4286056464 M: 92205056 DEBUG: OnKey: 166 pressed, action is 3 00:28:39 T:4286056464 M: 90116096 DEBUG: Load background-settings.jpg: 16.9ms (bundled) 00:28:39 T:4286056464 M: 91754496 DEBUG: Load gradient.png: 0.1ms (bundled) 00:28:39 T:4286056464 M: 91754496 DEBUG: Load homeinfo-system.png: 0.8ms (bundled) 00:28:39 T:4286056464 M: 91873280 DEBUG: Load home-button-focus.gif: 4.0ms (bundled) 00:28:40 T:4286056464 M: 91635712 DEBUG: Update - NEW at 2760:000000037ff07bdd 00 OK mceusb 00:28:40 T:4286056464 M: 91635712 DEBUG: OnKey: 11 pressed, action is 7 00:28:40 T:4286056464 M: 91533312 DEBUG: OnMessage : Translating ActivateWindow(Settings) 00:28:40 T:4286056464 M: 91533312 DEBUG: OnMessage : To ActivateWindow(Settings) 00:28:40 T:4286056464 M: 91533312 DEBUG: Activating window ID: 10004 00:28:40 T:4286056464 M: 91533312 DEBUG: Checking if window ID 10004 is locked. 00:28:40 T:4286056464 M: 91533312 DEBUG: ------------------- GUI_MSG_WINDOW_DEINIT 00:28:40 T:4286056464 M: 91533312 DEBUG: Home 00:28:40 T:4286056464 M: 91533312 DEBUG: ------------------- 00:28:40 T:4286056464 M: 90935296 DEBUG: ------------------- GUI_MSG_WINDOW_INIT 00:28:40 T:4286056464 M: 90935296 DEBUG: Settings 00:28:40 T:4286056464 M: 90935296 DEBUG: ------------------- 00:28:40 T:4286056464 M: 90935296 INFO: Loading skin file: Settings.xml 00:28:40 T:4286056464 M: 90832896 DEBUG: Load Settings.xml: 9.86ms 00:28:40 T:4286056464 M: 90832896 DEBUG: Load PlayerControls-PrevFO.png: 0.0ms (bundled) 00:28:40 T:4286056464 M: 90832896 DEBUG: Load PlayerControls-PrevNF.png: 0.0ms (bundled) 00:28:40 T:4286056464 M: 90832896 DEBUG: Load PlayerControls-StopFO.png: 0.0ms (bundled) 00:28:40 T:4286056464 M: 90832896 DEBUG: Load PlayerControls-StopNF.png: 0.0ms (bundled) 00:28:40 T:4286056464 M: 90832896 DEBUG: Load PlayerControls-PauseFO.png: 0.0ms (bundled) 00:28:40 T:4286056464 M: 90832896 DEBUG: Load PlayerControls-PauseNF.png: 0.0ms (bundled) 00:28:40 T:4286056464 M: 90832896 DEBUG: Load PlayerControls-PlayFO.png: 0.0ms (bundled) 00:28:40 T:4286056464 M: 90832896 DEBUG: Load PlayerControls-PlayNF.png: 0.0ms (bundled) 00:28:40 T:4286056464 M: 90832896 DEBUG: Load PlayerControls-NextFO.png: 0.0ms (bundled) 00:28:40 T:4286056464 M: 90832896 DEBUG: Load PlayerControls-NextNF.png: 0.0ms (bundled) 00:28:40 T:4286056464 M: 90832896 DEBUG: Load PlayerControls-FullScreenFO.png: 0.0ms (bundled) 00:28:40 T:4286056464 M: 90832896 DEBUG: Load PlayerControls-FullScreenNF.png: 0.0ms (bundled) 00:28:40 T:4286056464 M: 90832896 DEBUG: Load button-focus.png: 0.1ms (bundled) 00:28:40 T:4286056464 M: 90832896 DEBUG: Load Button_Side_Focus.png: 0.1ms (bundled) 00:28:40 T:4286056464 M: 90832896 DEBUG: Load Button_Side_NoFocus.png: 0.1ms (bundled) 00:28:40 T:4286056464 M: 90832896 DEBUG: Alloc resources: 11.73ms (10.01 ms skin load, 0.24 ms preload) 00:28:40 T:4286056464 M: 79876096 DEBUG: Load Background.png: 28.8ms (bundled) 00:28:40 T:4286056464 M: 94756864 DEBUG: Load Panel.png: 0.7ms (bundled) 00:28:40 T:4286056464 M: 94523392 DEBUG: Load icon_video.png: 0.9ms (bundled) 00:28:40 T:4286056464 M: 94523392 DEBUG: Load icon_music.png: 1.0ms (bundled) 00:28:40 T:4286056464 M: 94523392 DEBUG: Load icon_pics.png: 0.9ms (bundled) 00:28:40 T:4286056464 M: 94523392 DEBUG: Load unknown-user.png: 0.7ms (bundled) 00:28:40 T:4286056464 M: 94523392 DEBUG: Load icon_weather.png: 1.0ms (bundled) 00:28:40 T:4286056464 M: 94523392 DEBUG: Load icon_network.png: 0.8ms (bundled) 00:28:40 T:4286056464 M: 94687232 DEBUG: Load icon_system.png: 0.9ms (bundled) 00:28:40 T:4286056464 M: 94605312 DEBUG: Load icon_appearence.png: 0.8ms (bundled) 00:28:40 T:4286056464 M: 93212672 DEBUG: Load Header.png: 4.9ms (bundled) 00:28:41 T:4286056464 M: 88956928 DEBUG: Update - NEW at 4585:000000037ff07be1 00 Up mceusb 00:28:41 T:4286056464 M: 88956928 DEBUG: OnKey: 166 pressed, action is 3 00:28:41 T:4286056464 M: 88956928 DEBUG: Load button-focus.png: 0.1ms (bundled) 00:28:42 T:4286056464 M: 88137728 DEBUG: Update - NEW at 5001:000000037ff07bdf 00 Left mceusb 00:28:42 T:4286056464 M: 88137728 DEBUG: OnKey: 169 pressed, action is 1 00:28:42 T:4286056464 M: 88137728 DEBUG: Load Button_Side_Focus.png: 0.2ms (bundled) 00:28:43 T:4286056464 M: 86360064 DEBUG: Update - NEW at 5902:000000037ff07bdf 00 Left mceusb 00:28:43 T:4286056464 M: 86360064 DEBUG: OnKey: 169 pressed, action is 1 00:28:43 T:4286056464 M: 86360064 DEBUG: Load button-focus.png: 0.1ms (bundled) 00:28:43 T:4286056464 M: 85377024 DEBUG: Update - NEW at 6481:000000037ff07be0 00 Down mceusb 00:28:43 T:4286056464 M: 85377024 DEBUG: OnKey: 167 pressed, action is 4 00:28:43 T:4286056464 M: 85377024 DEBUG: Load button-focus.png: 0.1ms (bundled) 00:28:44 T:4286056464 M: 84762624 DEBUG: Update - NEW at 6898:000000037ff07bdf 00 Left mceusb 00:28:44 T:4286056464 M: 84762624 DEBUG: OnKey: 169 pressed, action is 1 00:28:44 T:4286056464 M: 84221952 DEBUG: Update - NEW at 7240:000000037ff07bdd 00 OK mceusb 00:28:44 T:4286056464 M: 84221952 DEBUG: OnKey: 11 pressed, action is 7 00:28:44 T:4286056464 M: 84221952 DEBUG: OnMessage : Translating ActivateWindow(SystemSettings) 00:28:44 T:4286056464 M: 84221952 DEBUG: OnMessage : To ActivateWindow(SystemSettings) 00:28:44 T:4286056464 M: 84221952 DEBUG: Activating window ID: 10016 00:28:44 T:4286056464 M: 84221952 DEBUG: Checking if window ID 10016 is locked. 00:28:44 T:4286056464 M: 84221952 DEBUG: ------------------- GUI_MSG_WINDOW_DEINIT 00:28:44 T:4286056464 M: 84221952 DEBUG: Settings 00:28:44 T:4286056464 M: 84221952 DEBUG: ------------------- 00:28:44 T:4286056464 M: 83521536 DEBUG: ------------------- GUI_MSG_WINDOW_INIT 00:28:44 T:4286056464 M: 83521536 DEBUG: Settings - System 00:28:44 T:4286056464 M: 83521536 DEBUG: ------------------- 00:28:44 T:4286056464 M: 83521536 INFO: Loading skin file: SettingsCategory.xml 00:28:44 T:4286056464 M: 83521536 DEBUG: Load SettingsCategory.xml: 5.93ms 00:28:44 T:4286056464 M: 83521536 DEBUG: Load PlayerControls-PrevFO.png: 0.0ms (bundled) 00:28:44 T:4286056464 M: 83521536 DEBUG: Load PlayerControls-PrevNF.png: 0.0ms (bundled) 00:28:44 T:4286056464 M: 83521536 DEBUG: Load PlayerControls-StopFO.png: 0.0ms (bundled) 00:28:44 T:4286056464 M: 83521536 DEBUG: Load PlayerControls-StopNF.png: 0.0ms (bundled) 00:28:44 T:4286056464 M: 83521536 DEBUG: Load PlayerControls-PauseFO.png: 0.0ms (bundled) 00:28:44 T:4286056464 M: 83521536 DEBUG: Load PlayerControls-PauseNF.png: 0.0ms (bundled) 00:28:44 T:4286056464 M: 83521536 DEBUG: Load PlayerControls-PlayFO.png: 0.0ms (bundled) 00:28:44 T:4286056464 M: 83521536 DEBUG: Load PlayerControls-PlayNF.png: 0.0ms (bundled) 00:28:44 T:4286056464 M: 83521536 DEBUG: Load PlayerControls-NextFO.png: 0.0ms (bundled) 00:28:44 T:4286056464 M: 83521536 DEBUG: Load PlayerControls-NextNF.png: 0.0ms (bundled) 00:28:44 T:4286056464 M: 83521536 DEBUG: Load PlayerControls-FullScreenFO.png: 0.0ms (bundled) 00:28:44 T:4286056464 M: 83521536 DEBUG: Load PlayerControls-FullScreenNF.png: 0.0ms (bundled) 00:28:44 T:4286056464 M: 83521536 DEBUG: Load Button_Side_Focus.png: 0.1ms (bundled) 00:28:44 T:4286056464 M: 83521536 DEBUG: Load Button_Side_NoFocus.png: 0.1ms (bundled) 00:28:44 T:4286056464 M: 83521536 DEBUG: Load list-focus.png: 0.0ms (bundled) 00:28:44 T:4286056464 M: 83521536 DEBUG: Load radiobutton-focus-2.png: 0.1ms (bundled) 00:28:44 T:4286056464 M: 83521536 DEBUG: Load radiobutton-nofocus.png: 0.0ms (bundled) 00:28:44 T:4286056464 M: 83521536 DEBUG: Load scroll-up-2.png: 0.1ms (bundled) 00:28:44 T:4286056464 M: 83521536 DEBUG: Load scroll-up-focus-2.png: 0.1ms (bundled) 00:28:44 T:4286056464 M: 83521536 DEBUG: Load scroll-down-2.png: 0.1ms (bundled) 00:28:44 T:4286056464 M: 83521536 DEBUG: Load scroll-down-focus-2.png: 0.1ms (bundled) 00:28:44 T:4286056464 M: 83521536 DEBUG: Alloc resources: 8.14ms (6.05 ms skin load, 0.23 ms preload) 00:28:45 T:4286056464 M: 72462336 DEBUG: Load Background.png: 29.7ms (bundled) 00:28:45 T:4286056464 M: 86622208 DEBUG: Load Panel.png: 0.7ms (bundled) 00:28:45 T:4286056464 M: 84742144 DEBUG: Load Header.png: 5.0ms (bundled) 00:28:46 T:4286056464 M: 81027072 DEBUG: Update - NEW at 8841:000000037ff07bde 00 Right mceusb 00:28:46 T:4286056464 M: 81027072 DEBUG: OnKey: 168 pressed, action is 2 00:28:46 T:4286056464 M: 80429056 DEBUG: Update - NEW at 9264:000000037ff07bdd 00 OK mceusb 00:28:46 T:4286056464 M: 80429056 DEBUG: OnKey: 11 pressed, action is 7 00:28:46 T:4286056464 M: 80429056 NOTICE: Enabled debug logging due to GUI setting 00:28:47 T:4286056464 M: 78778368 DEBUG: Update - NEW at 10246:000000037ff07bf2 00 Home mceusb 00:28:47 T:4286056464 M: 78778368 DEBUG: OnKey: 37 pressed, action is 10 00:28:47 T:4286056464 M: 78778368 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 00:28:47 T:4286056464 M: 78778368 DEBUG: ------------------- GUI_MSG_WINDOW_DEINIT 00:28:47 T:4286056464 M: 78778368 DEBUG: Settings - System 00:28:47 T:4286056464 M: 78778368 DEBUG: ------------------- 00:28:47 T:4286056464 M: 78057472 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 00:28:47 T:4286056464 M: 78057472 DEBUG: ------------------- GUI_MSG_WINDOW_INIT 00:28:47 T:4286056464 M: 78057472 DEBUG: Settings 00:28:47 T:4286056464 M: 78057472 DEBUG: ------------------- 00:28:47 T:4286056464 M: 78057472 INFO: Loading skin file: Settings.xml 00:28:48 T:4286056464 M: 78057472 DEBUG: Load Settings.xml: 8.89ms 00:28:48 T:4286056464 M: 78057472 DEBUG: Load PlayerControls-PrevFO.png: 0.0ms (bundled) 00:28:48 T:4286056464 M: 78057472 DEBUG: Load PlayerControls-PrevNF.png: 0.0ms (bundled) 00:28:48 T:4286056464 M: 78057472 DEBUG: Load PlayerControls-StopFO.png: 0.0ms (bundled) 00:28:48 T:4286056464 M: 78057472 DEBUG: Load PlayerControls-StopNF.png: 0.0ms (bundled) 00:28:48 T:4286056464 M: 78057472 DEBUG: Load PlayerControls-PauseFO.png: 0.0ms (bundled) 00:28:48 T:4286056464 M: 78057472 DEBUG: Load PlayerControls-PauseNF.png: 0.0ms (bundled) 00:28:48 T:4286056464 M: 78057472 DEBUG: Load PlayerControls-PlayFO.png: 0.0ms (bundled) 00:28:48 T:4286056464 M: 78057472 DEBUG: Load PlayerControls-PlayNF.png: 0.0ms (bundled) 00:28:48 T:4286056464 M: 78057472 DEBUG: Load PlayerControls-NextFO.png: 0.0ms (bundled) 00:28:48 T:4286056464 M: 78057472 DEBUG: Load PlayerControls-NextNF.png: 0.0ms (bundled) 00:28:48 T:4286056464 M: 78057472 DEBUG: Load PlayerControls-FullScreenFO.png: 0.0ms (bundled) 00:28:48 T:4286056464 M: 78057472 DEBUG: Load PlayerControls-FullScreenNF.png: 0.0ms (bundled) 00:28:48 T:4286056464 M: 78057472 DEBUG: Load button-focus.png: 0.1ms (bundled) 00:28:48 T:4286056464 M: 78057472 DEBUG: Load Button_Side_Focus.png: 0.1ms (bundled) 00:28:48 T:4286056464 M: 78057472 DEBUG: Load Button_Side_NoFocus.png: 0.1ms (bundled) 00:28:48 T:4286056464 M: 78057472 DEBUG: Alloc resources: 10.71ms (9.03 ms skin load, 0.25 ms preload) 00:28:48 T:4286056464 M: 66588672 DEBUG: Load Background.png: 28.0ms (bundled) 00:28:48 T:4286056464 M: 81920000 DEBUG: Load Panel.png: 0.7ms (bundled) 00:28:48 T:4286056464 M: 82026496 DEBUG: Load icon_video.png: 1.0ms (bundled) 00:28:48 T:4286056464 M: 82104320 DEBUG: Load icon_music.png: 1.0ms (bundled) 00:28:48 T:4286056464 M: 82104320 DEBUG: Load icon_pics.png: 0.9ms (bundled) 00:28:48 T:4286056464 M: 82104320 DEBUG: Load unknown-user.png: 0.7ms (bundled) 00:28:48 T:4286056464 M: 82104320 DEBUG: Load icon_weather.png: 1.0ms (bundled) 00:28:48 T:4286056464 M: 82104320 DEBUG: Load icon_network.png: 0.9ms (bundled) 00:28:48 T:4286056464 M: 82022400 DEBUG: Load icon_system.png: 1.0ms (bundled) 00:28:48 T:4286056464 M: 82022400 DEBUG: Load icon_appearence.png: 0.8ms (bundled) 00:28:48 T:4286056464 M: 80699392 DEBUG: Load Header.png: 4.9ms (bundled) 00:28:49 T:4286056464 M: 76808192 DEBUG: Update - NEW at 11924:000000037ff07bf2 00 Home mceusb 00:28:49 T:4286056464 M: 76808192 DEBUG: OnKey: 37 pressed, action is 10 00:28:49 T:4286056464 M: 76808192 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 00:28:49 T:4286056464 M: 76808192 DEBUG: ------------------- GUI_MSG_WINDOW_DEINIT 00:28:49 T:4286056464 M: 76808192 DEBUG: Settings 00:28:49 T:4286056464 M: 76808192 DEBUG: ------------------- 00:28:49 T:4286056464 M: 76054528 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 00:28:49 T:4286056464 M: 76054528 DEBUG: ------------------- GUI_MSG_WINDOW_INIT 00:28:49 T:4286056464 M: 76054528 DEBUG: Home 00:28:49 T:4286056464 M: 76054528 DEBUG: ------------------- 00:28:49 T:4286056464 M: 76054528 INFO: Loading skin file: Home.xml 00:28:49 T:4286056464 M: 76054528 DEBUG: Load Home.xml: 14.33ms 00:28:49 T:4286056464 M: 76054528 DEBUG: Load home-button.png: 0.1ms (bundled) 00:28:49 T:4286056464 M: 76054528 DEBUG: Load home-playmedia.png: 0.2ms (bundled) 00:28:49 T:4286056464 M: 76054528 DEBUG: Load home-favourites.png: 0.2ms (bundled) 00:28:49 T:4286056464 M: 76054528 DEBUG: Load home-power.png: 0.2ms (bundled) 00:28:49 T:4286056464 M: 76054528 DEBUG: Alloc resources: 15.58ms (14.52 ms skin load, 0.12 ms preload) 00:28:49 T:4286056464 M: 75952128 DEBUG: Load background-settings.jpg: 12.9ms (bundled) 00:28:49 T:4286056464 M: 64688128 DEBUG: Load Background-Home-2.png: 26.5ms (bundled) 00:28:49 T:4286056464 M: 79364096 DEBUG: Load gradient.png: 0.1ms (bundled) 00:28:49 T:4286056464 M: 79364096 DEBUG: Load homeinfo-system.png: 0.6ms (bundled) 00:28:49 T:4286056464 M: 78876672 DEBUG: Load Home-Menu-Back.png: 3.0ms (bundled) 00:28:49 T:4286056464 M: 78807040 DEBUG: Load home-button-focus.gif: 4.0ms (bundled) 00:28:49 T:4286056464 M: 76857344 DEBUG: Load Header.png: 5.0ms (bundled) 00:28:49 T:4286056464 M: 75169792 DEBUG: Load xbmc-logo.png: 1.2ms (bundled) 00:28:49 T:4286056464 M: 75169792 DEBUG: Load Footer.png: 3.7ms (bundled) 00:28:50 T:4286056464 M: 73588736 DEBUG: Update - NEW at 13510:000000037ff07be0 00 Down mceusb 00:28:50 T:4286056464 M: 73588736 DEBUG: OnKey: 167 pressed, action is 4 00:28:50 T:4286056464 M: 73588736 DEBUG: Load background-videos.jpg: 9.2ms (bundled) 00:28:51 T:4286056464 M: 72937472 DEBUG: Update - NEW at 13954:000000037ff07bdd 00 OK mceusb 00:28:51 T:4286056464 M: 72937472 DEBUG: OnKey: 11 pressed, action is 7 00:28:51 T:4286056464 M: 72937472 DEBUG: OnMessage : Translating ActivateWindow(Videos) 00:28:51 T:4286056464 M: 72937472 DEBUG: OnMessage : To ActivateWindow(Videos) 00:28:51 T:4286056464 M: 72937472 DEBUG: Activating window ID: 10024 00:28:51 T:4286056464 M: 72937472 DEBUG: Checking if window ID 10024 is locked. 00:28:51 T:4286056464 M: 72937472 DEBUG: ------------------- GUI_MSG_WINDOW_DEINIT 00:28:51 T:4286056464 M: 72937472 DEBUG: Home 00:28:51 T:4286056464 M: 72937472 DEBUG: ------------------- 00:28:51 T:4286056464 M: 72237056 INFO: Attempting to default to: 00:28:51 T:4286056464 M: 72237056 DEBUG: ------------------- GUI_MSG_WINDOW_INIT 00:28:51 T:4286056464 M: 72237056 DEBUG: 00:28:51 T:4286056464 M: 72237056 DEBUG: ------------------- 00:28:51 T:4286056464 M: 72237056 INFO: Loading skin file: MyVideo.xml 00:28:51 T:4286056464 M: 72134656 DEBUG: Load MyVideo.xml: 29.16ms 00:28:51 T:4286056464 M: 72134656 DEBUG: Load scrollbar_bar_back2.png: 0.0ms (bundled) 00:28:51 T:4286056464 M: 72134656 DEBUG: Load scrollbar_bar-vertical.png: 0.0ms (bundled) 00:28:51 T:4286056464 M: 72134656 DEBUG: Load scrollbar_bar_focus-vertical.png: 0.0ms (bundled) 00:28:51 T:4286056464 M: 72134656 DEBUG: Load scrollbar_nib-vertical.png: 0.0ms (bundled) 00:28:51 T:4286056464 M: 72134656 DEBUG: Load PlayerControls-PrevFO.png: 0.0ms (bundled) 00:28:51 T:4286056464 M: 72134656 DEBUG: Load PlayerControls-PrevNF.png: 0.0ms (bundled) 00:28:51 T:4286056464 M: 72134656 DEBUG: Load PlayerControls-StopFO.png: 0.0ms (bundled) 00:28:51 T:4286056464 M: 72134656 DEBUG: Load PlayerControls-StopNF.png: 0.0ms (bundled) 00:28:51 T:4286056464 M: 72134656 DEBUG: Load PlayerControls-PauseFO.png: 0.0ms (bundled) 00:28:51 T:4286056464 M: 72134656 DEBUG: Load PlayerControls-PauseNF.png: 0.0ms (bundled) 00:28:51 T:4286056464 M: 72134656 DEBUG: Load PlayerControls-PlayFO.png: 0.0ms (bundled) 00:28:51 T:4286056464 M: 72134656 DEBUG: Load PlayerControls-PlayNF.png: 0.0ms (bundled) 00:28:51 T:4286056464 M: 72134656 DEBUG: Load PlayerControls-NextFO.png: 0.0ms (bundled) 00:28:51 T:4286056464 M: 72134656 DEBUG: Load PlayerControls-NextNF.png: 0.0ms (bundled) 00:28:51 T:4286056464 M: 72134656 DEBUG: Load PlayerControls-FullScreenFO.png: 0.0ms (bundled) 00:28:51 T:4286056464 M: 72134656 DEBUG: Load PlayerControls-FullScreenNF.png: 0.0ms (bundled) 00:28:51 T:4286056464 M: 72134656 DEBUG: Load scrollbar_bar_back.png: 0.0ms (bundled) 00:28:51 T:4286056464 M: 72134656 DEBUG: Load scrollbar_bar.png: 0.0ms (bundled) 00:28:51 T:4286056464 M: 72134656 DEBUG: Load scrollbar_bar_focus.png: 0.0ms (bundled) 00:28:51 T:4286056464 M: 72134656 DEBUG: Load scrollbar_nib.png: 0.0ms (bundled) 00:28:51 T:4286056464 M: 72134656 DEBUG: Load Button_Side_Focus.png: 0.1ms (bundled) 00:28:51 T:4286056464 M: 72134656 DEBUG: Load Button_Side_NoFocus.png: 0.1ms (bundled) 00:28:51 T:4286056464 M: 72134656 DEBUG: Load scroll-up-focus.png: 0.0ms (bundled) 00:28:51 T:4286056464 M: 72134656 DEBUG: Load scroll-up.png: 0.0ms (bundled) 00:28:51 T:4286056464 M: 72134656 DEBUG: Load scroll-down-focus.png: 0.0ms (bundled) 00:28:51 T:4286056464 M: 72134656 DEBUG: Load scroll-down.png: 0.0ms (bundled) 00:28:51 T:4286056464 M: 72134656 DEBUG: Load radiobutton-focus.png: 0.0ms (bundled) 00:28:51 T:4286056464 M: 72134656 DEBUG: Load radiobutton-nofocus.png: 0.0ms (bundled) 00:28:51 T:4286056464 M: 72134656 DEBUG: Alloc resources: 32.01ms (29.45 ms skin load, 0.34 ms preload) 00:28:51 T:4286056464 M: 72134656 DEBUG: CGUIMediaWindow::GetDirectory () 00:28:51 T:4286056464 M: 72134656 DEBUG: ParentPath = [] 00:28:51 T:4286056464 M: 72134656 DEBUG: Sort, sorting took 0 millis 00:28:51 T:3955222864 M: 72134656 DEBUG: Running thread 3955222864 00:28:51 T:3955222864 M: 72134656 DEBUG: thread start, auto delete: 0 00:28:51 T:3955222864 M: 72134656 DEBUG: staticThread, deleting thread graphic context 00:28:51 T:3955222864 M: 72134656 DEBUG: Thread 3955222864 terminating 00:28:51 T:4286056464 M: 55545856 DEBUG: Load Background.png: 30.3ms (bundled) 00:28:51 T:4286056464 M: 71409664 DEBUG: Load Panel.png: 0.7ms (bundled) 00:28:51 T:4286056464 M: 71307264 DEBUG: Load defaultHardDiskBig.png: 0.9ms (bundled) 00:28:51 T:4286056464 M: 71307264 DEBUG: Load defaultNetworkBig.png: 1.0ms (bundled) 00:28:51 T:4286056464 M: 71307264 DEBUG: Load DefaultAddSource.png: 0.9ms (bundled) 00:28:51 T:4286056464 M: 71307264 DEBUG: Load list-focus.png: 0.0ms (bundled) 00:28:51 T:4286056464 M: 68538368 DEBUG: Load Header.png: 5.3ms (bundled) 00:28:53 T:4286056464 M: 68517888 DEBUG: Update - NEW at 16250:000000037ff07bdd 00 OK mceusb 00:28:53 T:4286056464 M: 68517888 DEBUG: OnKey: 11 pressed, action is 7 00:28:53 T:4286056464 M: 68517888 DEBUG: Clearing cached fileitems [/mnt/ch/vol0/] 00:28:53 T:4286056464 M: 68517888 DEBUG: CGUIMediaWindow::GetDirectory (/mnt/ch/vol0/) 00:28:53 T:4286056464 M: 68517888 DEBUG: ParentPath = [] 00:28:53 T:4286056464 M: 68517888 DEBUG: Sort, sorting took 0 millis 00:28:53 T:3955222864 M: 68517888 DEBUG: Running thread 3955222864 00:28:53 T:3955222864 M: 68517888 DEBUG: thread start, auto delete: 0 00:28:53 T:4286056464 M: 68108288 DEBUG: Load defaultFolderBig.png: 0.9ms (bundled) 00:28:53 T:4286056464 M: 68005888 DEBUG: Load list-focus.png: 0.0ms (bundled) 00:28:53 T:4286056464 M: 68005888 DEBUG: Load defaultFolderBackBig.png: 0.8ms (bundled) 00:28:53 T:3955222864 M: 67792896 DEBUG: staticThread, deleting thread graphic context 00:28:53 T:3955222864 M: 67792896 DEBUG: Thread 3955222864 terminating 00:28:54 T:4286056464 M: 66666496 DEBUG: Update - NEW at 17374:000000037ff07be0 00 Down mceusb 00:28:54 T:4286056464 M: 66666496 DEBUG: OnKey: 167 pressed, action is 4 00:28:55 T:4286056464 M: 65937408 DEBUG: Update - NEW at 17844:000000037ff07bdd 00 OK mceusb 00:28:55 T:4286056464 M: 65937408 DEBUG: OnKey: 11 pressed, action is 7 00:28:55 T:4286056464 M: 65937408 DEBUG: Clearing cached fileitems [/mnt/ch/vol0/Incoming/] 00:28:55 T:4286056464 M: 65937408 DEBUG: CGUIMediaWindow::GetDirectory (/mnt/ch/vol0/Incoming/) 00:28:55 T:4286056464 M: 65937408 DEBUG: ParentPath = [/mnt/ch/vol0/] 00:28:55 T:4286056464 M: 65937408 DEBUG: Sort, sorting took 0 millis 00:28:55 T:3955222864 M: 65937408 DEBUG: Running thread 3955222864 00:28:55 T:3955222864 M: 65937408 DEBUG: thread start, auto delete: 0 00:28:55 T:3913259344 M: 65937408 DEBUG: Running thread 3913259344 00:28:55 T:3913259344 M: 65937408 DEBUG: thread start, auto delete: 0 00:28:55 T:3904866640 M: 65937408 DEBUG: Running thread 3904866640 00:28:55 T:3904866640 M: 65937408 DEBUG: thread start, auto delete: 0 00:28:55 T:3825203536 M: 65835008 DEBUG: Running thread 3825203536 00:28:55 T:3825203536 M: 65835008 DEBUG: thread start, auto delete: 0 00:28:55 T:3816810832 M: 65835008 DEBUG: Running thread 3816810832 00:28:55 T:3816810832 M: 65835008 DEBUG: thread start, auto delete: 0 00:28:55 T:4286056464 M: 65425408 DEBUG: Load defaultFolderBig.png: 15.3ms (bundled) 00:28:55 T:3955222864 M: 65323008 DEBUG: ZipManager: unable to open file /mnt/ch/vol0/Incoming/stress_test.zip.tbn! 00:28:55 T:4286056464 M: 65425408 DEBUG: Load /home/wilson/.xbmc/userdata/Thumbnails/Video/c/c0a27249.tbn: 2.1ms 00:28:55 T:4286056464 M: 65314816 DEBUG: Load list-focus.png: 0.0ms (bundled) 00:28:55 T:4286056464 M: 65314816 DEBUG: Load defaultFolderBackBig.png: 0.8ms (bundled) 00:28:55 T:3913259344 M: 65355776 DEBUG: staticThread, deleting thread graphic context 00:28:55 T:3913259344 M: 65355776 DEBUG: Thread 3913259344 terminating 00:28:55 T:3825203536 M: 65253376 DEBUG: staticThread, deleting thread graphic context 00:28:55 T:3825203536 M: 65253376 DEBUG: Thread 3825203536 terminating 00:28:55 T:3955222864 M: 65253376 DEBUG: staticThread, deleting thread graphic context 00:28:55 T:3955222864 M: 65253376 DEBUG: Thread 3955222864 terminating 00:28:55 T:3904866640 M: 65253376 DEBUG: staticThread, deleting thread graphic context 00:28:55 T:3904866640 M: 65253376 DEBUG: Thread 3904866640 terminating 00:28:55 T:3816810832 M: 65253376 DEBUG: staticThread, deleting thread graphic context 00:28:55 T:3816810832 M: 65253376 DEBUG: Thread 3816810832 terminating 00:29:03 T:4286056464 M: 52641792 DEBUG: Update - NEW at 25783:000000037ff07be1 00 Up mceusb 00:29:03 T:4286056464 M: 52641792 DEBUG: OnKey: 166 pressed, action is 3 00:29:03 T:4286056464 M: 52436992 DEBUG: Load /home/wilson/.xbmc/userdata/Thumbnails/Video/1/12cac3a1.tbn: 2.0ms 00:29:03 T:4286056464 M: 52117504 DEBUG: Load defaultVideoBig.png: 1.2ms (bundled) 00:29:03 T:4286056464 M: 51810304 DEBUG: Load list-focus.png: 0.0ms (bundled) 00:29:04 T:4286056464 M: 49995776 DEBUG: Update - NEW at 26978:000000037ff07bdd 00 OK mceusb 00:29:04 T:4286056464 M: 49995776 DEBUG: OnKey: 11 pressed, action is 7 00:29:04 T:4286056464 M: 49995776 DEBUG: new file set audiostream:0 00:29:04 T:4286056464 M: 49995776 DEBUG: CPlayerCoreFactor::GetPlayers(/mnt/ch/vol0/Incoming/Man.vs.Wild.S05.Will.Ferrell.Special.HDTV.XviD-GNARLY.avi) 00:29:04 T:3808418128 M: 49995776 DEBUG: Running thread 3808418128 00:29:04 T:3808418128 M: 49995776 DEBUG: thread start, auto delete: 1 00:29:04 T:4286056464 M: 49995776 NOTICE: DVDPlayer: Opening: /mnt/ch/vol0/Incoming/Man.vs.Wild.S05.Will.Ferrell.Special.HDTV.XviD-GNARLY.avi 00:29:04 T:4286056464 M: 49995776 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED 00:29:04 T:3800025424 M: 49995776 DEBUG: Running thread 3800025424 00:29:04 T:3800025424 M: 49995776 DEBUG: thread start, auto delete: 0 00:29:04 T:3800025424 M: 49995776 NOTICE: Creating InputStream 00:29:04 T:3800025424 M: 49893376 NOTICE: Creating Demuxer 00:29:04 T:3800025424 M: 49893376 DEBUG: SECTION:LoadDLL(Q:\system\players\dvdplayer\avutil-49-x86_64-linux.so) 00:29:04 T:3800025424 M: 49893376 DEBUG: Loading: /usr/local/share/xbmc/system/players/dvdplayer/avutil-49-x86_64-linux.so 00:29:04 T:3800025424 M: 49893376 DEBUG: SECTION:LoadDLL(Q:\system\players\dvdplayer\avcodec-52-x86_64-linux.so) 00:29:04 T:3800025424 M: 49893376 DEBUG: Loading: /usr/local/share/xbmc/system/players/dvdplayer/avcodec-52-x86_64-linux.so 00:29:04 T:3800025424 M: 49893376 DEBUG: SECTION:LoadDLL(Q:\system\players\dvdplayer\avformat-52-x86_64-linux.so) 00:29:04 T:3800025424 M: 49893376 DEBUG: Loading: /usr/local/share/xbmc/system/players/dvdplayer/avformat-52-x86_64-linux.so 00:29:04 T:3800025424 M: 49483776 DEBUG: Open - av_find_stream_info starting 00:29:04 T:3800025424 M: 49483776 INFO: ffmpeg: [NULL] Invalid and inefficient vfw-avi packed B frames detected 00:29:04 T:3800025424 M: 48971776 DEBUG: Open - av_find_stream_info finished 00:29:04 T:3800025424 M: 48971776 INFO: ffmpeg: Input #0, avi, from '/mnt/ch/vol0/Incoming/Man.vs.Wild.S05.Will.Ferrell.Special.HDTV.XviD-GNARLY.avi': 00:29:04 T:3800025424 M: 48971776 INFO: ffmpeg: Duration: 00:43:33.31, start: 0.000000, bitrate: 1115 kb/s 00:29:04 T:3800025424 M: 48971776 INFO: ffmpeg: Stream #0.0: Video: mpeg4, yuv420p, 624x352 [PAR 1:1 DAR 39:22], 29.97 tb(r) 00:29:04 T:3800025424 M: 48971776 INFO: ffmpeg: Stream #0.1: Audio: mp3, 48000 Hz, stereo, s16, 128 kb/s 00:29:04 T:3800025424 M: 48971776 NOTICE: Opening video stream: 0 source: 256 00:29:04 T:3800025424 M: 48971776 NOTICE: Creating video codec with codec id: 13 00:29:04 T:3800025424 M: 48971776 DEBUG: FactoryCodec - Video: FFmpeg - Opening 00:29:04 T:3800025424 M: 48971776 DEBUG: SECTION:LoadDLL(Q:\system\players\dvdplayer\swscale-0.6.1-x86_64-linux.so) 00:29:04 T:3800025424 M: 48971776 DEBUG: Loading: /usr/local/share/xbmc/system/players/dvdplayer/swscale-0.6.1-x86_64-linux.so 00:29:04 T:3800025424 M: 48971776 DEBUG: FactoryCodec - Video: FFmpeg - Opened 00:29:04 T:3800025424 M: 48971776 NOTICE: Creating video thread 00:29:04 T:3766585680 M: 48971776 DEBUG: Running thread 3766585680 00:29:04 T:3766585680 M: 48971776 DEBUG: thread start, auto delete: 0 00:29:04 T:3800025424 M: 48971776 NOTICE: Opening audio stream: 1 source: 256 00:29:04 T:3800025424 M: 48971776 NOTICE: Finding audio codec for: 86017 00:29:04 T:3800025424 M: 48971776 DEBUG: FactoryCodec - Audio: passthrough - Opening 00:29:04 T:3766585680 M: 48971776 NOTICE: running thread: video_thread 00:29:04 T:3800025424 M: 48971776 DEBUG: FactoryCodec - Audio: passthrough - Failed 00:29:04 T:3800025424 M: 48971776 DEBUG: FactoryCodec - Audio: libmad - Opening 00:29:04 T:3800025424 M: 48971776 DEBUG: SECTION:LoadDLL(Q:\system\players\dvdplayer\libmad-x86_64-linux.so) 00:29:04 T:3800025424 M: 48971776 DEBUG: Loading: /usr/local/share/xbmc/system/players/dvdplayer/libmad-x86_64-linux.so 00:29:04 T:3800025424 M: 48971776 DEBUG: FactoryCodec - Audio: libmad - Opened 00:29:04 T:3800025424 M: 48971776 NOTICE: Creating audio thread 00:29:04 T:3755964752 M: 48971776 DEBUG: Running thread 3755964752 00:29:04 T:3755964752 M: 48971776 DEBUG: thread start, auto delete: 0 00:29:04 T:3755964752 M: 48971776 NOTICE: running thread: CDVDPlayerAudio::Process() 00:29:04 T:3800025424 M: 48971776 DEBUG: Playback has started 00:29:04 T:3800025424 M: 48971776 INFO: Loading skin file: DialogProgress.xml 00:29:04 T:3800025424 M: 48971776 DEBUG: Load DialogProgress.xml: 2.10ms 00:29:04 T:3800025424 M: 48971776 WARNING: CDVDPlayer::CheckContinuity - stream wrapback detected (2) 00:29:04 T:3800025424 M: 48971776 WARNING: CDVDPlayer::CheckContinuity - resyncing due to stream wrapback (2) 00:29:04 T:3766585680 M: 45633536 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE 00:29:04 T:3766585680 M: 45633536 INFO: ffmpeg: [mpeg4] Invalid and inefficient vfw-avi packed B frames detected 00:29:04 T:3766585680 M: 45633536 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC(66733.400067, 1) 00:29:04 T:3766585680 M: 45633536 NOTICE: fps: 29.969999, pwidth: 624, pheight: 352, dwidth: 624, dheight: 352 00:29:04 T:3766585680 M: 45633536 DEBUG: OutputPicture - change configuration. 624x352. framerate: 29.97 00:29:04 T:3766585680 M: 45633536 NOTICE: Display resolution AUTO : 720p 16:9 (1) 00:29:04 T:3766585680 M: 45633536 WARNING: Upscale: possible given resolution increase. 00:29:04 T:3766585680 M: 45633536 WARNING: Upscale: selected algorithm 7 00:29:04 T:3755964752 M: 45633536 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(24000.000000, 1) 00:29:04 T:3755964752 M: 45633536 NOTICE: Creating audio device with codec id: 86017, channels: 2, sample rate: 48000, no pass-through 00:29:04 T:3755964752 M: 45633536 DEBUG: PulseAudio: Opening Channels: 2 - SampleRate: 48000 - SampleBit: 16 - Resample false - Codec PCM - IsMusic false - IsPassthrough false - audioHost: default - audioDevice: hdmi 00:29:04 T:3808418128 M: 45633536 DEBUG: staticThread, deleting thread object 00:29:04 T:3808418128 M: 45633536 DEBUG: staticThread, deleting thread graphic context 00:29:04 T:3808418128 M: 45633536 DEBUG: Thread 3808418128 terminating 00:29:04 T:4286056464 M: 45428736 DEBUG: Activating window ID: 12005 00:29:04 T:4286056464 M: 45428736 DEBUG: Checking if window ID 12005 is locked. 00:29:04 T:4286056464 M: 45121536 DEBUG: ------------------- GUI_MSG_WINDOW_DEINIT 00:29:04 T:4286056464 M: 45121536 DEBUG: 00:29:04 T:4286056464 M: 45121536 DEBUG: ------------------- 00:29:04 T:3755964752 M: 44507136 DEBUG: PulseAudio: Context failed 00:29:04 T:3755964752 M: 44507136 ERROR: PulseAudio: Waited for the Context but it failed 00:29:04 T:3755964752 M: 44130304 DEBUG: CALSADirectSound::CALSADirectSound - opening alsa device 00:29:04 T:4286056464 M: 44130304 DEBUG: ------------------- GUI_MSG_WINDOW_INIT 00:29:04 T:4286056464 M: 44130304 DEBUG: Fullscreen video 00:29:04 T:4286056464 M: 44130304 DEBUG: ------------------- 00:29:04 T:4286056464 M: 44130304 INFO: Loading skin file: VideoFullScreen.xml 00:29:04 T:4286056464 M: 44130304 DEBUG: Load VideoFullScreen.xml: 0.94ms 00:29:04 T:4286056464 M: 44130304 DEBUG: Alloc resources: 0.99ms (0.99 ms skin load, 0.00 ms preload) 00:29:04 T:4286056464 M: 44130304 INFO: Loading skin file: VideoOSD.xml 00:29:04 T:4286056464 M: 44130304 DEBUG: Load VideoOSD.xml: 3.73ms 00:29:04 T:4286056464 M: 44130304 DEBUG: Load black-back2.png: 0.4ms (bundled) 00:29:04 T:4286056464 M: 44130304 DEBUG: Load PlayerControls-FullScreenFO.png: 0.0ms (bundled) 00:29:04 T:4286056464 M: 44130304 DEBUG: Load PlayerControls-FullScreenNF.png: 0.0ms (bundled) 00:29:04 T:4286056464 M: 44130304 DEBUG: Load osd_button_rec.png: 0.2ms (bundled) 00:29:04 T:4286056464 M: 44130304 DEBUG: Load osd_button_recNF.png: 0.2ms (bundled) 00:29:04 T:4286056464 M: 44130304 DEBUG: Load osd_button_rec2.png: 0.1ms (bundled) 00:29:04 T:4286056464 M: 44130304 DEBUG: Load osd_button_dvdmenu.png: 0.2ms (bundled) 00:29:04 T:4286056464 M: 44130304 DEBUG: Load osd_button_dvdmenuNF.png: 0.2ms (bundled) 00:29:04 T:4286056464 M: 44027904 DEBUG: Load osd_button_dvdmenu2.png: 0.2ms (bundled) 00:29:04 T:4286056464 M: 41877504 DEBUG: Load osd_panel.png: 3.6ms (bundled) 00:29:04 T:4286056464 M: 41775104 DEBUG: Load osd_button_skip_minusFO.png: 0.2ms (bundled) 00:29:04 T:4286056464 M: 41775104 DEBUG: Load osd_button_rewFO.png: 0.2ms (bundled) 00:29:04 T:4286056464 M: 41775104 DEBUG: Load osd_button_rewSELNF.png: 0.2ms (bundled) 00:29:04 T:4286056464 M: 41775104 DEBUG: Load osd_button_pauseFO.png: 0.3ms (bundled) 00:29:04 T:4286056464 M: 41775104 DEBUG: Load osd_button_pauseNF.png: 0.2ms (bundled) 00:29:04 T:4286056464 M: 41775104 DEBUG: Load osd_button_playFO.png: 0.2ms (bundled) 00:29:04 T:4286056464 M: 41775104 DEBUG: Load osd_button_playNF.png: 0.2ms (bundled) 00:29:04 T:4286056464 M: 41775104 DEBUG: Load osd_button_ffFO.png: 0.1ms (bundled) 00:29:04 T:4286056464 M: 41775104 DEBUG: Load osd_button_ffSELNF.png: 0.1ms (bundled) 00:29:04 T:4286056464 M: 41775104 DEBUG: Load osd_button_skip_plusFO.png: 0.1ms (bundled) 00:29:04 T:4286056464 M: 41775104 DEBUG: Load osd_button_audioFO.png: 0.1ms (bundled) 00:29:04 T:4286056464 M: 41775104 DEBUG: Load osd_button_audioSELNF.png: 0.1ms (bundled) 00:29:04 T:4286056464 M: 41775104 DEBUG: Load osd_button_videoFO.png: 0.1ms (bundled) 00:29:04 T:4286056464 M: 41775104 DEBUG: Load osd_button_videoSELNF.png: 0.1ms (bundled) 00:29:04 T:4286056464 M: 41775104 DEBUG: Load osd_button_stopFO.png: 0.1ms (bundled) 00:29:04 T:4286056464 M: 41775104 DEBUG: Load osd_button_bookmarkFO.png: 0.2ms (bundled) 00:29:04 T:4286056464 M: 41775104 DEBUG: Load osd_button_bookmarkSELNF.png: 0.2ms (bundled) 00:29:04 T:4286056464 M: 41775104 DEBUG: Alloc resources: 9.34ms (0.00 ms skin load, 0.33 ms preload) 00:29:04 T:4286056464 M: 41775104 INFO: Loading skin file: VideoOSDSettings.xml 00:29:04 T:4286056464 M: 41775104 DEBUG: Load VideoOSDSettings.xml: 2.02ms 00:29:04 T:4286056464 M: 40034304 DEBUG: Load DialogBack.png: 3.5ms (bundled) 00:29:04 T:4286056464 M: 38907904 DEBUG: Load DialogFront.png: 3.2ms (bundled) 00:29:04 T:4286056464 M: 38907904 DEBUG: Load close-windowFO.png: 0.1ms (bundled) 00:29:04 T:4286056464 M: 38907904 DEBUG: Load close-window.png: 0.0ms (bundled) 00:29:04 T:4286056464 M: 38907904 DEBUG: Load separator.png: 0.1ms (bundled) 00:29:04 T:4286056464 M: 38907904 DEBUG: Load osd_slider_bg.png: 0.1ms (bundled) 00:29:04 T:4286056464 M: 38907904 DEBUG: Load osd_slider_nibNF.png: 0.0ms (bundled) 00:29:04 T:4286056464 M: 38907904 DEBUG: Load osd_slider_nib.png: 0.0ms (bundled) 00:29:04 T:4286056464 M: 38907904 DEBUG: Load button-focus.png: 0.1ms (bundled) 00:29:04 T:4286056464 M: 38907904 DEBUG: Load button-nofocus.png: 0.1ms (bundled) 00:29:04 T:4286056464 M: 38907904 DEBUG: Load radiobutton-focus.png: 0.1ms (bundled) 00:29:04 T:4286056464 M: 38907904 DEBUG: Load radiobutton-nofocus.png: 0.0ms (bundled) 00:29:04 T:4286056464 M: 38907904 DEBUG: Load scroll-up-2.png: 0.1ms (bundled) 00:29:04 T:4286056464 M: 38907904 DEBUG: Load scroll-up-focus-2.png: 0.1ms (bundled) 00:29:04 T:4286056464 M: 38907904 DEBUG: Load scroll-down-2.png: 0.1ms (bundled) 00:29:04 T:4286056464 M: 38907904 DEBUG: Load scroll-down-focus-2.png: 0.1ms (bundled) 00:29:04 T:4286056464 M: 38907904 DEBUG: Alloc resources: 8.46ms (0.00 ms skin load, 0.18 ms preload) 00:29:04 T:4286056464 M: 38907904 INFO: Loading skin file: VideoOSDSettings.xml 00:29:04 T:4286056464 M: 38907904 DEBUG: Load VideoOSDSettings.xml: 1.98ms 00:29:04 T:4286056464 M: 38907904 DEBUG: Alloc resources: 0.19ms (0.00 ms skin load, 0.03 ms preload) 00:29:04 T:3755964752 M: 38805504 DEBUG: Initialize - using alsa device hdmi 00:29:05 T:3755964752 M: 38805504 DEBUG: CDVDPlayerAudio:: Discontinuty - was:616986.783000, should be:24000.000000, error:-592986.783000 00:29:05 T:4286056464 M: 38805504 DEBUG: GL: Requested render method: 2 00:29:05 T:4286056464 M: 38805504 NOTICE: GL: Shaders support not present, falling back to SW mode 00:29:05 T:4286056464 M: 38805504 NOTICE: GL: NPOT texture support detected 00:29:05 T:4286056464 M: 38805504 DEBUG: GL: Creating RGB NPOT texture of size 624 x 352 00:29:05 T:4286056464 M: 38801408 DEBUG: GL: Creating RGB NPOT texture of size 624 x 352 00:29:05 T:4286056464 M: 38686720 DEBUG: GL: Creating RGB NPOT texture of size 624 x 352 00:29:05 T:4286056464 M: 38686720 DEBUG: GL: Creating RGB NPOT texture of size 624 x 352 00:29:05 T:4286056464 M: 38686720 DEBUG: GL: Creating RGB NPOT texture of size 624 x 352 00:29:05 T:4286056464 M: 38686720 DEBUG: GL: Creating RGB NPOT texture of size 624 x 352 00:29:05 T:4286056464 M: 38686720 DEBUG: CGUIInfoManager::SetCurrentMovie(/mnt/ch/vol0/Incoming/Man.vs.Wild.S05.Will.Ferrell.Special.HDTV.XviD-GNARLY.avi) 00:29:05 T:4286056464 M: 38584320 DEBUG: GetMovieId (/mnt/ch/vol0/Incoming/Man.vs.Wild.S05.Will.Ferrell.Special.HDTV.XviD-GNARLY.avi), query = select idMovie from movie where idFile=8 00:29:05 T:4286056464 M: 38584320 DEBUG: GetEpisodeId (/mnt/ch/vol0/Incoming/Man.vs.Wild.S05.Will.Ferrell.Special.HDTV.XviD-GNARLY.avi), query = select idEpisode from episode where idFile=8 00:29:05 T:4286056464 M: 38584320 DEBUG: GetMusicVideoId (/mnt/ch/vol0/Incoming/Man.vs.Wild.S05.Will.Ferrell.Special.HDTV.XviD-GNARLY.avi), query = select idMVideo from musicvideo where idFile=8 00:29:05 T:3755964752 M: 37052416 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_DELAY(509266.599933) 00:29:05 T:3755964752 M: 36532224 ERROR: GetDelay - snd_pcm_delay, alsa error: -32 - Broken pipe 00:29:05 T:3755964752 M: 36532224 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(576000.000000, 0) 00:29:05 T:3755964752 M: 36532224 DEBUG: CDVDPlayerAudio:: Discontinuty - was:756044.527000, should be:552000.000000, error:-204044.527000 00:29:07 T:4286056464 M: 32735232 DEBUG: SECTION:UnloadDelayed(DLL: Q:\system\ImageLib-x86_64-linux.so) 00:29:07 T:4286056464 M: 32735232 DEBUG: Unloading: ImageLib-x86_64-linux.so 00:29:12 T:4286056464 M: 34340864 DEBUG: Update - NEW at 34678:000000037ff07bde 00 Right mceusb 00:29:12 T:4286056464 M: 34340864 DEBUG: OnKey: 168 pressed, action is 20 00:29:12 T:3800025424 M: 34340864 DEBUG: demuxer seek to: 36685 00:29:12 T:3800025424 M: 34340864 DEBUG: SeekTime - unknown position after seek 00:29:12 T:3800025424 M: 34340864 DEBUG: demuxer seek to: 36685, success 00:29:12 T:3800025424 M: 34340864 INFO: ffmpeg: [NULL] Invalid and inefficient vfw-avi packed B frames detected 00:29:12 T:4286056464 M: 39985152 DEBUG: ------------------- GUI_MSG_WINDOW_INIT 00:29:12 T:4286056464 M: 39985152 DEBUG: 00:29:12 T:4286056464 M: 39985152 DEBUG: ------------------- 00:29:12 T:4286056464 M: 39985152 DEBUG: Load seekslider.png: 0.0ms (bundled) 00:29:12 T:4286056464 M: 39985152 DEBUG: Load slider_nibFO.png: 0.0ms (bundled) 00:29:12 T:4286056464 M: 39985152 DEBUG: Alloc resources: 0.74ms (0.00 ms skin load, 0.56 ms preload) 00:29:12 T:4286056464 M: 39985152 DEBUG: Load NoCover_1.png: 0.5ms (bundled) 00:29:12 T:4286056464 M: 39985152 DEBUG: Load NoCover_1.png: 0.4ms (bundled) 00:29:12 T:4286056464 M: 39985152 DEBUG: Load black-back.png: 0.0ms (bundled) 00:29:12 T:3766585680 M: 39985152 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE 00:29:12 T:3766585680 M: 39985152 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC(37137137.137137, 1) 00:29:12 T:3755964752 M: 39985152 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE 00:29:12 T:3755964752 M: 39985152 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_DELAY(518862.862863) 00:29:12 T:3755964752 M: 39280640 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(37656000.000000, 0) 00:29:12 T:3755964752 M: 39280640 DEBUG: CDVDPlayerAudio:: Discontinuty - was:37623801.702137, should be:37648305.912620, error:24504.210483 00:29:12 T:3755964752 M: 38748160 DEBUG: CDVDPlayerAudio:: Discontinuty - was:37990172.451620, should be:38013704.095218, error:23531.643598 00:29:13 T:4286056464 M: 38252544 WARNING: QueryPerformanceCounter moving backwords by 184 ticks with freq of 1000000000 00:29:14 T:4286056464 M: 34947072 DEBUG: ------------------- GUI_MSG_WINDOW_DEINIT 00:29:14 T:4286056464 M: 34947072 DEBUG: 00:29:14 T:4286056464 M: 34947072 DEBUG: ------------------- 00:29:17 T:4286056464 M: 34734080 WARNING: QueryPerformanceCounter moving backwords by 236 ticks with freq of 1000000000 00:29:17 T:3800025424 M: 34734080 WARNING: QueryPerformanceCounter moving backwords by 211385 ticks with freq of 1000000000 00:29:18 T:4286056464 M: 32468992 DEBUG: Update - NEW at 41098:000000037ff07be7 00 Pause mceusb 00:29:18 T:4286056464 M: 32468992 DEBUG: OnKey: 230 pressed, action is 12 00:29:18 T:4286056464 M: 32468992 DEBUG: ------------------- GUI_MSG_WINDOW_INIT 00:29:18 T:4286056464 M: 32468992 DEBUG: 00:29:18 T:4286056464 M: 32468992 DEBUG: ------------------- 00:29:18 T:4286056464 M: 32468992 DEBUG: Load seekslider.png: 0.0ms (bundled) 00:29:18 T:4286056464 M: 32468992 DEBUG: Load slider_nibFO.png: 0.0ms (bundled) 00:29:18 T:4286056464 M: 32468992 DEBUG: Alloc resources: 0.23ms (0.00 ms skin load, 0.08 ms preload) 00:29:18 T:4286056464 M: 32468992 DEBUG: Load NoCover_1.png: 0.4ms (bundled) 00:29:18 T:4286056464 M: 32468992 DEBUG: Load NoCover_1.png: 0.4ms (bundled) 00:29:18 T:4286056464 M: 32468992 DEBUG: Load black-back.png: 0.0ms (bundled) 00:29:20 T:4286056464 M: 32878592 DEBUG: Update - NEW at 43563:000000037ff07be7 00 Pause mceusb 00:29:20 T:4286056464 M: 32878592 DEBUG: OnKey: 230 pressed, action is 12 00:29:20 T:3755964752 M: 32878592 DEBUG: CDVDPlayerAudio:: Discontinuty - was:43536055.403218, should be:43566821.848437, error:30766.445219 00:29:21 T:4286056464 M: 32366592 DEBUG: ------------------- GUI_MSG_WINDOW_DEINIT 00:29:21 T:4286056464 M: 32366592 DEBUG: 00:29:21 T:4286056464 M: 32366592 DEBUG: ------------------- 00:29:22 T:4286056464 M: 34746368 DEBUG: Update - NEW at 45139:000000037ff07be9 00 Play mceusb 00:29:22 T:4286056464 M: 34746368 DEBUG: OnKey: 229 pressed, action is 27