21:37:53 T:3055097728 M:648294400 NOTICE: ----------------------------------------------------------------------- 21:37:53 T:3055097728 M:648183808 NOTICE: Starting XBMC, Platform: Linux (Ubuntu 10.04.1 LTS, 2.6.32-24-generic i686). Built on Sep 19 2010 (SVN:33927M) 21:37:53 T:3055097728 M:648183808 NOTICE: special://xbmc/ is mapped to: /usr/share/xbmc 21:37:53 T:3055097728 M:648183808 NOTICE: special://xbmcbin/ is mapped to: /usr/lib/xbmc 21:37:53 T:3055097728 M:648183808 NOTICE: special://masterprofile/ is mapped to: /home/xbmc104/.xbmc/userdata 21:37:53 T:3055097728 M:648183808 NOTICE: special://home/ is mapped to: /home/xbmc104/.xbmc 21:37:53 T:3055097728 M:648183808 NOTICE: special://temp/ is mapped to: /home/xbmc104/.xbmc/temp 21:37:53 T:3055097728 M:648183808 NOTICE: The executable running is: /usr/lib/xbmc/xbmc.bin 21:37:53 T:3055097728 M:648183808 NOTICE: Log File is located: /home/xbmc104/.xbmc/temp/xbmc.log 21:37:53 T:3055097728 M:648183808 NOTICE: ----------------------------------------------------------------------- 21:37:53 T:3055097728 M:648437760 NOTICE: Setup SDL 21:37:53 T:3055097728 M:648105984 INFO: Available videomodes (xrandr): 21:37:53 T:3055097728 M:648105984 INFO: Number of connected outputs: 1 21:37:53 T:3055097728 M:648105984 INFO: Output 'default' has 61 modes 21:37:53 T:3055097728 M:648105984 INFO: ID:0x12b Name:1360x768 Refresh:60.000000 Width:1360 Height:768 21:37:53 T:3055097728 M:648105984 INFO: Pixel Ratio: 1.000000 21:37:53 T:3055097728 M:648105984 INFO: ID:0x12c Name:1280x720 Refresh:60.000000 Width:1280 Height:720 21:37:53 T:3055097728 M:648105984 INFO: Pixel Ratio: 1.000000 21:37:53 T:3055097728 M:648105984 INFO: ID:0x12d Name:1024x768 Refresh:75.000000 Width:1024 Height:768 21:37:53 T:3055097728 M:648105984 INFO: Pixel Ratio: 1.000000 21:37:53 T:3055097728 M:648105984 INFO: ID:0x12e Name:1024x768 Refresh:70.000000 Width:1024 Height:768 21:37:53 T:3055097728 M:648105984 INFO: Pixel Ratio: 1.000000 21:37:53 T:3055097728 M:648105984 INFO: ID:0x12f Name:1024x768 Refresh:60.000000 Width:1024 Height:768 21:37:53 T:3055097728 M:648105984 INFO: Pixel Ratio: 1.000000 21:37:53 T:3055097728 M:648105984 INFO: ID:0x130 Name:960x600 Refresh:60.000000 Width:960 Height:600 21:37:53 T:3055097728 M:648105984 INFO: Pixel Ratio: 1.000000 21:37:53 T:3055097728 M:648105984 INFO: ID:0x131 Name:960x540 Refresh:60.000000 Width:960 Height:540 21:37:53 T:3055097728 M:648105984 INFO: Pixel Ratio: 1.000000 21:37:53 T:3055097728 M:648105984 INFO: ID:0x132 Name:840x525 Refresh:70.000000 Width:840 Height:525 21:37:53 T:3055097728 M:648105984 INFO: Pixel Ratio: 1.000000 21:37:53 T:3055097728 M:648105984 INFO: ID:0x133 Name:840x525 Refresh:60.000000 Width:840 Height:525 21:37:53 T:3055097728 M:648105984 INFO: Pixel Ratio: 1.000000 21:37:53 T:3055097728 M:648105984 INFO: ID:0x134 Name:832x624 Refresh:75.000000 Width:832 Height:624 21:37:53 T:3055097728 M:648105984 INFO: Pixel Ratio: 1.000000 21:37:53 T:3055097728 M:648105984 INFO: ID:0x135 Name:800x600 Refresh:85.000000 Width:800 Height:600 21:37:53 T:3055097728 M:648105984 INFO: Pixel Ratio: 1.000000 21:37:53 T:3055097728 M:648105984 INFO: ID:0x136 Name:800x600 Refresh:75.000000 Width:800 Height:600 21:37:53 T:3055097728 M:648105984 INFO: Pixel Ratio: 1.000000 21:37:53 T:3055097728 M:648105984 INFO: ID:0x137 Name:800x600 Refresh:72.000000 Width:800 Height:600 21:37:53 T:3055097728 M:648105984 INFO: Pixel Ratio: 1.000000 21:37:53 T:3055097728 M:648105984 INFO: ID:0x138 Name:800x600 Refresh:60.000000 Width:800 Height:600 21:37:53 T:3055097728 M:648105984 INFO: Pixel Ratio: 1.000000 21:37:53 T:3055097728 M:648105984 INFO: ID:0x139 Name:800x600 Refresh:56.000000 Width:800 Height:600 21:37:53 T:3055097728 M:648105984 INFO: Pixel Ratio: 1.000000 21:37:53 T:3055097728 M:648105984 INFO: ID:0x13a Name:800x600 Refresh:65.000000 Width:800 Height:600 21:37:53 T:3055097728 M:648105984 INFO: Pixel Ratio: 1.000000 21:37:53 T:3055097728 M:648105984 INFO: ID:0x13b Name:800x512 Refresh:60.000000 Width:800 Height:512 21:37:53 T:3055097728 M:648105984 INFO: Pixel Ratio: 1.000000 21:37:53 T:3055097728 M:648105984 INFO: ID:0x13c Name:720x480 Refresh:60.000000 Width:720 Height:480 21:37:53 T:3055097728 M:648105984 INFO: Pixel Ratio: 1.000000 21:37:53 T:3055097728 M:648105984 INFO: ID:0x13d Name:720x450 Refresh:60.000000 Width:720 Height:450 21:37:53 T:3055097728 M:648105984 INFO: Pixel Ratio: 1.000000 21:37:53 T:3055097728 M:648105984 INFO: ID:0x13e Name:720x400 Refresh:85.000000 Width:720 Height:400 21:37:53 T:3055097728 M:648105984 INFO: Pixel Ratio: 1.000000 21:37:53 T:3055097728 M:648105984 INFO: ID:0x13f Name:700x525 Refresh:85.000000 Width:700 Height:525 21:37:53 T:3055097728 M:648105984 INFO: Pixel Ratio: 1.000000 21:37:53 T:3055097728 M:648105984 INFO: ID:0x140 Name:700x525 Refresh:75.000000 Width:700 Height:525 21:37:53 T:3055097728 M:648105984 INFO: Pixel Ratio: 1.000000 21:37:53 T:3055097728 M:648105984 INFO: ID:0x141 Name:700x525 Refresh:70.000000 Width:700 Height:525 21:37:53 T:3055097728 M:648105984 INFO: Pixel Ratio: 1.000000 21:37:53 T:3055097728 M:648105984 INFO: ID:0x142 Name:700x525 Refresh:60.000000 Width:700 Height:525 21:37:53 T:3055097728 M:648105984 INFO: Pixel Ratio: 1.000000 21:37:53 T:3055097728 M:648105984 INFO: ID:0x143 Name:680x384 Refresh:60.000000 Width:680 Height:384 21:37:53 T:3055097728 M:648105984 INFO: Pixel Ratio: 1.000000 21:37:53 T:3055097728 M:648105984 INFO: ID:0x144 Name:640x512 Refresh:85.000000 Width:640 Height:512 21:37:53 T:3055097728 M:648105984 INFO: Pixel Ratio: 1.000000 21:37:53 T:3055097728 M:648105984 INFO: ID:0x145 Name:640x512 Refresh:75.000000 Width:640 Height:512 21:37:53 T:3055097728 M:648105984 INFO: Pixel Ratio: 1.000000 21:37:53 T:3055097728 M:648105984 INFO: ID:0x146 Name:640x512 Refresh:60.000000 Width:640 Height:512 21:37:53 T:3055097728 M:648105984 INFO: Pixel Ratio: 1.000000 21:37:53 T:3055097728 M:648105984 INFO: ID:0x147 Name:640x480 Refresh:85.000000 Width:640 Height:480 21:37:53 T:3055097728 M:648105984 INFO: Pixel Ratio: 1.000000 21:37:53 T:3055097728 M:648105984 INFO: ID:0x148 Name:640x480 Refresh:75.000000 Width:640 Height:480 21:37:53 T:3055097728 M:648105984 INFO: Pixel Ratio: 1.000000 21:37:53 T:3055097728 M:648105984 INFO: ID:0x149 Name:640x480 Refresh:73.000000 Width:640 Height:480 21:37:53 T:3055097728 M:648105984 INFO: Pixel Ratio: 1.000000 21:37:53 T:3055097728 M:648105984 INFO: ID:0x14a Name:640x480 Refresh:60.000000 Width:640 Height:480 21:37:53 T:3055097728 M:648105984 INFO: Pixel Ratio: 1.000000 21:37:53 T:3055097728 M:648105984 INFO: ID:0x14b Name:640x400 Refresh:85.000000 Width:640 Height:400 21:37:53 T:3055097728 M:648105984 INFO: Pixel Ratio: 1.000000 21:37:53 T:3055097728 M:648105984 INFO: ID:0x14c Name:640x350 Refresh:85.000000 Width:640 Height:350 21:37:53 T:3055097728 M:648105984 INFO: Pixel Ratio: 1.000000 21:37:53 T:3055097728 M:648105984 INFO: ID:0x14d Name:576x480 Refresh:60.000000 Width:576 Height:480 21:37:53 T:3055097728 M:648105984 INFO: Pixel Ratio: 1.000000 21:37:53 T:3055097728 M:648105984 INFO: ID:0x14e Name:576x432 Refresh:100.000000 Width:576 Height:432 21:37:53 T:3055097728 M:648105984 INFO: Pixel Ratio: 1.000000 21:37:53 T:3055097728 M:648105984 INFO: ID:0x14f Name:576x432 Refresh:85.000000 Width:576 Height:432 21:37:53 T:3055097728 M:648105984 INFO: Pixel Ratio: 1.000000 21:37:53 T:3055097728 M:648105984 INFO: ID:0x150 Name:576x432 Refresh:75.000000 Width:576 Height:432 21:37:53 T:3055097728 M:648105984 INFO: Pixel Ratio: 1.000000 21:37:53 T:3055097728 M:648105984 INFO: ID:0x151 Name:576x432 Refresh:70.000000 Width:576 Height:432 21:37:53 T:3055097728 M:648105984 INFO: Pixel Ratio: 1.000000 21:37:53 T:3055097728 M:648105984 INFO: ID:0x152 Name:576x432 Refresh:60.000000 Width:576 Height:432 21:37:53 T:3055097728 M:648105984 INFO: Pixel Ratio: 1.000000 21:37:53 T:3055097728 M:648105984 INFO: ID:0x153 Name:512x384 Refresh:85.000000 Width:512 Height:384 21:37:53 T:3055097728 M:648105984 INFO: Pixel Ratio: 1.000000 21:37:53 T:3055097728 M:648105984 INFO: ID:0x154 Name:512x384 Refresh:75.000000 Width:512 Height:384 21:37:53 T:3055097728 M:648105984 INFO: Pixel Ratio: 1.000000 21:37:53 T:3055097728 M:648105984 INFO: ID:0x155 Name:512x384 Refresh:70.000000 Width:512 Height:384 21:37:53 T:3055097728 M:648105984 INFO: Pixel Ratio: 1.000000 21:37:53 T:3055097728 M:648105984 INFO: ID:0x156 Name:512x384 Refresh:60.000000 Width:512 Height:384 21:37:53 T:3055097728 M:648105984 INFO: Pixel Ratio: 1.000000 21:37:53 T:3055097728 M:648105984 INFO: ID:0x157 Name:512x384 Refresh:87.000000 Width:512 Height:384 21:37:53 T:3055097728 M:648105984 INFO: Pixel Ratio: 1.000000 21:37:53 T:3055097728 M:648105984 INFO: ID:0x158 Name:416x312 Refresh:75.000000 Width:416 Height:312 21:37:53 T:3055097728 M:648105984 INFO: Pixel Ratio: 1.000000 21:37:53 T:3055097728 M:648105984 INFO: ID:0x159 Name:411x480 Refresh:60.000000 Width:411 Height:480 21:37:53 T:3055097728 M:648105984 INFO: Pixel Ratio: 1.000000 21:37:53 T:3055097728 M:648105984 INFO: ID:0x15a Name:400x300 Refresh:85.000000 Width:400 Height:300 21:37:53 T:3055097728 M:648105984 INFO: Pixel Ratio: 1.000000 21:37:53 T:3055097728 M:648105984 INFO: ID:0x15b Name:400x300 Refresh:75.000000 Width:400 Height:300 21:37:53 T:3055097728 M:648105984 INFO: Pixel Ratio: 1.000000 21:37:53 T:3055097728 M:648105984 INFO: ID:0x15c Name:400x300 Refresh:72.000000 Width:400 Height:300 21:37:53 T:3055097728 M:648105984 INFO: Pixel Ratio: 1.000000 21:37:53 T:3055097728 M:648105984 INFO: ID:0x15d Name:400x300 Refresh:60.000000 Width:400 Height:300 21:37:53 T:3055097728 M:648105984 INFO: Pixel Ratio: 1.000000 21:37:53 T:3055097728 M:648105984 INFO: ID:0x15e Name:400x300 Refresh:56.000000 Width:400 Height:300 21:37:53 T:3055097728 M:648105984 INFO: Pixel Ratio: 1.000000 21:37:53 T:3055097728 M:648105984 INFO: ID:0x15f Name:360x480 Refresh:60.000000 Width:360 Height:480 21:37:53 T:3055097728 M:648105984 INFO: Pixel Ratio: 1.000000 21:37:53 T:3055097728 M:648105984 INFO: ID:0x160 Name:360x200 Refresh:85.000000 Width:360 Height:200 21:37:53 T:3055097728 M:648105984 INFO: Pixel Ratio: 1.000000 21:37:53 T:3055097728 M:648105984 INFO: ID:0x161 Name:320x240 Refresh:85.000000 Width:320 Height:240 21:37:53 T:3055097728 M:648105984 INFO: Pixel Ratio: 1.000000 21:37:53 T:3055097728 M:648105984 INFO: ID:0x162 Name:320x240 Refresh:75.000000 Width:320 Height:240 21:37:53 T:3055097728 M:648105984 INFO: Pixel Ratio: 1.000000 21:37:53 T:3055097728 M:648105984 INFO: ID:0x163 Name:320x240 Refresh:73.000000 Width:320 Height:240 21:37:53 T:3055097728 M:648105984 INFO: Pixel Ratio: 1.000000 21:37:53 T:3055097728 M:648105984 INFO: ID:0x164 Name:320x240 Refresh:60.000000 Width:320 Height:240 21:37:53 T:3055097728 M:648105984 INFO: Pixel Ratio: 1.000000 21:37:53 T:3055097728 M:648105984 INFO: ID:0x165 Name:320x200 Refresh:85.000000 Width:320 Height:200 21:37:53 T:3055097728 M:648105984 INFO: Pixel Ratio: 1.000000 21:37:53 T:3055097728 M:648105984 INFO: ID:0x166 Name:320x175 Refresh:85.000000 Width:320 Height:175 21:37:53 T:3055097728 M:648105984 INFO: Pixel Ratio: 1.000000 21:37:53 T:3055097728 M:648105984 INFO: ID:0x167 Name:288x480 Refresh:60.000000 Width:288 Height:480 21:37:53 T:3055097728 M:648105984 INFO: Pixel Ratio: 1.000000 21:37:53 T:3055097728 M:648105984 DEBUG: DBus: Creating message to org.freedesktop.ConsoleKit on /org/freedesktop/ConsoleKit/Manager with interface org.freedesktop.ConsoleKit.Manager and method CanStop 21:37:53 T:3055097728 M:648105984 DEBUG: DBus: Creating message to org.freedesktop.UPower on /org/freedesktop/UPower with interface org.freedesktop.UPower and method EnumerateDevices 21:37:53 T:3055097728 M:648105984 INFO: Selected UPower and ConsoleKit as PowerSyscall 21:37:53 T:3055097728 M:648105984 DEBUG: DBus: Creating message to org.freedesktop.ConsoleKit on /org/freedesktop/ConsoleKit/Manager with interface org.freedesktop.ConsoleKit.Manager and method CanStop 21:37:53 T:3055097728 M:648105984 DEBUG: DBus: Creating message to org.freedesktop.ConsoleKit on /org/freedesktop/ConsoleKit/Manager with interface org.freedesktop.ConsoleKit.Manager and method CanRestart 21:37:53 T:3055097728 M:648105984 DEBUG: DBus: Creating message to org.freedesktop.UPower on /org/freedesktop/UPower with interface org.freedesktop.DBus.Properties and method Get 21:37:53 T:3055097728 M:648105984 DEBUG: Previous line repeats 1 times. 21:37:53 T:3055097728 M:648105984 NOTICE: load settings... 21:37:53 T:3055097728 M:648105984 DEBUG: SECTION:LoadDLL(libcrystalhd.so.3) 21:37:53 T:3055097728 M:648105984 DEBUG: Loading: libcrystalhd.so.3 21:37:53 T:3055097728 M:648105984 DEBUG: CrystalHD: device open failed , returning(0xffffffff) 21:37:53 T:3055097728 M:648105984 DEBUG: CrystalHD: broadcom crystal hd not found 21:37:53 T:3055097728 M:648105984 NOTICE: special://profile/ is mapped to: special://masterprofile/ 21:37:53 T:3055097728 M:648105984 NOTICE: loading special://masterprofile/guisettings.xml 21:37:53 T:3055097728 M:648105984 NOTICE: Getting hardware information now... 21:37:53 T:3055097728 M:648105984 INFO: Using digital output 21:37:53 T:3055097728 M:648105984 INFO: AC3 pass through is enabled 21:37:53 T:3055097728 M:648105984 INFO: DTS pass through is enabled 21:37:53 T:3055097728 M:648105984 INFO: AAC pass through is disabled 21:37:53 T:3055097728 M:648105984 INFO: MP1 pass through is disabled 21:37:53 T:3055097728 M:648105984 INFO: MP2 pass through is disabled 21:37:53 T:3055097728 M:648105984 INFO: MP3 pass through is disabled 21:37:53 T:3055097728 M:648105984 NOTICE: Checking resolution 12 21:37:53 T:3055097728 M:648105984 NOTICE: Loading player core factory settings from special://xbmc/system/playercorefactory.xml. 21:37:53 T:3055097728 M:648105984 DEBUG: CPlayerCoreConfig::: created player DVDPlayer for core 1 21:37:53 T:3055097728 M:648105984 DEBUG: CPlayerCoreConfig::: created player oldmplayercore for core 1 21:37:53 T:3055097728 M:648105984 DEBUG: CPlayerCoreConfig::: created player PAPlayer for core 3 21:37:53 T:3055097728 M:648105984 DEBUG: CPlayerSelectionRule::Initialize: creating rule: system rules 21:37:53 T:3055097728 M:648105984 DEBUG: CPlayerSelectionRule::Initialize: creating rule: rtv 21:37:53 T:3055097728 M:648105984 DEBUG: CPlayerSelectionRule::Initialize: creating rule: hdhomerun/myth/rtmp/mms/udp 21:37:53 T:3055097728 M:648105984 DEBUG: CPlayerSelectionRule::Initialize: creating rule: lastfm/shout 21:37:53 T:3055097728 M:648105984 DEBUG: CPlayerSelectionRule::Initialize: creating rule: rtsp 21:37:53 T:3055097728 M:648105984 DEBUG: CPlayerSelectionRule::Initialize: creating rule: streams 21:37:53 T:3055097728 M:648105984 DEBUG: CPlayerSelectionRule::Initialize: creating rule: flv/aacp/sdp 21:37:53 T:3055097728 M:648105984 DEBUG: CPlayerSelectionRule::Initialize: creating rule: mp2 21:37:53 T:3055097728 M:648105984 DEBUG: CPlayerSelectionRule::Initialize: creating rule: dvd 21:37:53 T:3055097728 M:648105984 DEBUG: CPlayerSelectionRule::Initialize: creating rule: dvdfile 21:37:53 T:3055097728 M:648105984 DEBUG: CPlayerSelectionRule::Initialize: creating rule: dvdimage 21:37:53 T:3055097728 M:648105984 DEBUG: CPlayerSelectionRule::Initialize: creating rule: sdp/asf 21:37:53 T:3055097728 M:648105984 DEBUG: CPlayerSelectionRule::Initialize: creating rule: nsv 21:37:53 T:3055097728 M:648105984 NOTICE: Loaded playercorefactory configuration 21:37:53 T:3055097728 M:648105984 NOTICE: Loading player core factory settings from special://masterprofile/playercorefactory.xml. 21:37:53 T:3055097728 M:648105984 NOTICE: special://masterprofile/playercorefactory.xml does not exist. Skipping. 21:37:53 T:3055097728 M:648105984 NOTICE: No advancedsettings.xml to load (special://masterprofile/advancedsettings.xml) 21:37:53 T:3055097728 M:648105984 NOTICE: Default DVD Player: dvdplayer 21:37:53 T:3055097728 M:648105984 NOTICE: Default Video Player: dvdplayer 21:37:53 T:3055097728 M:648105984 NOTICE: Default Audio Player: paplayer 21:37:53 T:3055097728 M:648105984 NOTICE: Loading media sources from special://masterprofile/sources.xml 21:37:53 T:3055097728 M:648105984 DEBUG: SECTION:LoadDLL(special://xbmcbin/system/players/dvdplayer/avutil-50-i486-linux.so) 21:37:53 T:3055097728 M:648105984 DEBUG: Loading: /usr/lib/xbmc/system/players/dvdplayer/avutil-50-i486-linux.so 21:37:53 T:3055097728 M:648105984 DEBUG: CSoftAE::Initialize - Using speaker layout: 2.0 21:37:53 T:3055097728 M:648105984 INFO: CAESinkALSA::InitializeHW - Your hardware does not support AE_FMT_FLOAT, trying other formats 21:37:53 T:3055097728 M:648105984 INFO: CAESinkALSA::InitializeHW - Using data format AE_FMT_S32NE 21:37:53 T:3055097728 M:648105984 INFO: CSoftAE::Initialize - ALSA Initialized: 21:37:53 T:3055097728 M:648105984 INFO: Output Device : plug:hdmi 21:37:53 T:3055097728 M:648105984 INFO: Sample Rate : 44100 21:37:53 T:3055097728 M:648105984 INFO: Sample Format : AE_FMT_S32NE 21:37:53 T:3055097728 M:648105984 INFO: Channel Count : 2 21:37:53 T:3055097728 M:648105984 INFO: Channel Layout: FL,FR 21:37:53 T:3055097728 M:648105984 INFO: Frames : 44 21:37:53 T:3055097728 M:648105984 INFO: Frame Samples : 88 21:37:53 T:3055097728 M:648105984 INFO: Frame Size : 8 21:37:53 T:3055097728 M:648105984 INFO: creating subdirectories 21:37:53 T:3055097728 M:648105984 INFO: userdata folder: special://masterprofile/ 21:37:53 T:3052358512 M:648105984 DEBUG: thread start, auto delete: 0 21:37:53 T:3055097728 M:648105984 INFO: recording folder: 21:37:53 T:3052358512 M:648105984 INFO: CSoftAE::Run - Thread Started 21:37:53 T:3055097728 M:648105984 INFO: screenshots folder: 21:37:53 T:3055097728 M:648105984 INFO: thumbnails folder: special://masterprofile/Thumbnails 21:37:53 T:3055097728 M:648105984 INFO: load language info file: special://xbmc/language/English/langinfo.xml 21:37:53 T:3055097728 M:648105984 INFO: load language file:special://xbmc/language/English/strings.xml 21:37:53 T:3055097728 M:647208960 DEBUG: SECTION:LoadDLL(special://xbmcbin/system/libcpluff-i486-linux.so) 21:37:53 T:3055097728 M:647208960 DEBUG: Loading: /usr/lib/xbmc/system/libcpluff-i486-linux.so 21:37:53 T:3055097728 M:647208960 DEBUG: ADDON: cpluff: 'Plug-in metadata.albums.allmusic.com has been installed.' 21:37:53 T:3055097728 M:647208960 DEBUG: ADDON: cpluff: 'Plug-in repository.xbmc.org has been installed.' 21:37:53 T:3055097728 M:647208960 DEBUG: ADDON: cpluff: 'Plug-in webinterface.default has been installed.' 21:37:53 T:3055097728 M:647208960 DEBUG: ADDON: cpluff: 'Plug-in screensaver.rsxs.euphoria has been installed.' 21:37:53 T:3055097728 M:647208960 DEBUG: ADDON: cpluff: 'Plug-in screensaver.xbmc.builtin.black has been installed.' 21:37:53 T:3055097728 M:647208960 DEBUG: ADDON: cpluff: 'Plug-in plugin.video.ted.talks has been installed.' 21:37:53 T:3055097728 M:647208960 DEBUG: ADDON: cpluff: 'Plug-in visualization.projectm has been installed.' 21:37:53 T:3055097728 M:647208960 DEBUG: ADDON: cpluff: 'Plug-in script.module.simplejson has been installed.' 21:37:53 T:3055097728 M:647208960 DEBUG: ADDON: cpluff: 'Plug-in screensaver.xbmc.builtin.dim has been installed.' 21:37:53 T:3055097728 M:647208960 DEBUG: ADDON: cpluff: 'Plug-in metadata.themoviedb.org has been installed.' 21:37:53 T:3055097728 M:647208960 DEBUG: ADDON: cpluff: 'Plug-in metadata.artists.allmusic.com has been installed.' 21:37:53 T:3055097728 M:647208960 DEBUG: ADDON: cpluff: 'Plug-in xbmc.metadata has been installed.' 21:37:53 T:3055097728 M:647208960 DEBUG: ADDON: cpluff: 'Plug-in skin.confluence has been installed.' 21:37:53 T:3055097728 M:647208960 DEBUG: ADDON: cpluff: 'Plug-in visualization.glspectrum has been installed.' 21:37:53 T:3055097728 M:647208960 DEBUG: ADDON: cpluff: 'Plug-in script.module.beautifulsoup has been installed.' 21:37:53 T:3055097728 M:647208960 DEBUG: ADDON: cpluff: 'Plug-in script.module.pil has been installed.' 21:37:53 T:3055097728 M:647208960 DEBUG: ADDON: cpluff: 'Plug-in visualization.milkdrop has been installed.' 21:37:53 T:3055097728 M:647208960 DEBUG: ADDON: cpluff: 'Plug-in xbmc.gui has been installed.' 21:37:53 T:3055097728 M:647208960 DEBUG: ADDON: cpluff: 'Plug-in visualization.dxspectrum has been installed.' 21:37:53 T:3055097728 M:647208960 DEBUG: ADDON: cpluff: 'Plug-in xbmc.core has been installed.' 21:37:53 T:3055097728 M:647208960 DEBUG: ADDON: cpluff: 'Plug-in script.recentlyadded has been installed.' 21:37:53 T:3055097728 M:647208960 DEBUG: ADDON: cpluff: 'Plug-in screensaver.rsxs.solarwinds has been installed.' 21:37:53 T:3055097728 M:647208960 DEBUG: ADDON: cpluff: 'Plug-in screensaver.xbmc.builtin.slideshow has been installed.' 21:37:53 T:3055097728 M:647208960 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.htbackdrops.com has been installed.' 21:37:53 T:3055097728 M:647208960 DEBUG: ADDON: cpluff: 'Plug-in metadata.tvdb.com has been installed.' 21:37:53 T:3055097728 M:647208960 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.allmusic.com has been installed.' 21:37:53 T:3055097728 M:647208960 DEBUG: ADDON: cpluff: 'Plug-in weather.xbmc.builtin has been installed.' 21:37:53 T:3055097728 M:647208960 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.last.fm has been installed.' 21:37:53 T:3055097728 M:647208960 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.themoviedb.org has been installed.' 21:37:53 T:3055097728 M:647208960 DEBUG: ADDON: cpluff: 'Plug-in xbmc.python has been installed.' 21:37:53 T:3055097728 M:647208960 DEBUG: ADDON: cpluff: 'Plug-in xbmc.addon has been installed.' 21:37:53 T:3055097728 M:647208960 DEBUG: ADDON: cpluff: 'Plug-in screensaver.rsxs.plasma has been installed.' 21:37:53 T:3055097728 M:647208960 DEBUG: ADDON: cpluff: 'Plug-in visualization.waveform has been installed.' 21:37:53 T:3055097728 M:647208960 DEBUG: ADDON: cpluff: 'Plug-in script.module.pysqlite has been installed.' 21:37:53 T:3055097728 M:647208960 DEBUG: ADDON: cpluff: 'Plug-in metadata.mtv.com has been installed.' 21:37:53 T:3055097728 M:647208960 DEBUG: ADDON: cpluff: 'Plug-in visualization.itunes has been installed.' 21:37:53 T:3055097728 M:647208960 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.hdtrailers.net has been installed.' 21:37:53 T:3055097728 M:647208960 DEBUG: ADDON: cpluff: 'Not all directories were successfully scanned.' 21:37:53 T:3055097728 M:647208960 DEBUG: CKeyboardStat::Initialize - XKb symbols pc_us_inet(evdev)_terminate(ctrl_alt_bksp) 21:37:53 T:3055097728 M:647208960 INFO: LIRC Initialize: using: /dev/lircd 21:37:53 T:3055097728 M:647208960 INFO: LIRC Initialize: sucessfully started 21:37:54 T:3055097728 M:647208960 NOTICE: Enabled Joystick: Xbox Gamepad (userspace driver) 21:37:54 T:3055097728 M:647208960 NOTICE: Details: Total Axis: 5 Total Hats: 0 Total Buttons: 15 21:37:54 T:3055097728 M:647208960 INFO: XRANDR: /usr/lib/xbmc/xbmc-xrandr --output default --mode 0x12b 21:37:54 T:3055097728 M:642400256 NOTICE: Using visual 0x42 21:37:54 T:3055097728 M:641875968 INFO: GL: Maximum texture width: 8192 21:37:54 T:3055097728 M:641875968 DEBUG: SECTION:LoadDLL(special://xbmcbin/system/ImageLib-i486-linux.so) 21:37:54 T:3055097728 M:641875968 DEBUG: Loading: /usr/lib/xbmc/system/ImageLib-i486-linux.so 21:37:54 T:3055097728 M:641064960 DEBUG: GLX_EXTENSIONS: GLX_EXT_visual_info GLX_EXT_visual_rating GLX_SGIX_fbconfig GLX_SGIX_pbuffer GLX_SGI_video_sync GLX_SGI_swap_control GLX_EXT_swap_control GLX_EXT_texture_from_pixmap GLX_ARB_create_context GLX_ARB_create_context_profile GLX_ARB_multisample GLX_NV_float_buffer GLX_ARB_fbconfig_float GLX_EXT_framebuffer_sRGB GLX_ARB_get_proc_address 21:37:54 T:3055097728 M:641064960 NOTICE: GL_VENDOR = NVIDIA Corporation 21:37:54 T:3055097728 M:641064960 NOTICE: GL_RENDERER = GeForce 8200/PCI/SSE2/3DNOW! 21:37:54 T:3055097728 M:641064960 NOTICE: GL_VERSION = 3.2.0 NVIDIA 195.36.24 21:37:54 T:3055097728 M:641064960 NOTICE: GL_SHADING_LANGUAGE_VERSION = 1.50 NVIDIA via Cg compiler 21:37:54 T:3055097728 M:641064960 NOTICE: GL_EXTENSIONS = GL_ARB_color_buffer_float GL_ARB_compatibility GL_ARB_copy_buffer GL_ARB_depth_buffer_float GL_ARB_depth_clamp GL_ARB_depth_texture GL_ARB_draw_buffers GL_ARB_draw_elements_base_vertex GL_ARB_draw_instanced GL_ARB_fragment_coord_conventions GL_ARB_fragment_program GL_ARB_fragment_program_shadow GL_ARB_fragment_shader GL_ARB_framebuffer_object GL_ARB_framebuffer_sRGB GL_ARB_geometry_shader4 GL_ARB_half_float_pixel GL_ARB_half_float_vertex GL_ARB_imaging GL_ARB_map_buffer_range GL_ARB_multisample GL_ARB_multitexture GL_ARB_occlusion_query GL_ARB_pixel_buffer_object GL_ARB_point_parameters GL_ARB_point_sprite GL_ARB_provoking_vertex GL_ARB_seamless_cube_map GL_ARB_shader_objects GL_ARB_shading_language_100 GL_ARB_shadow GL_ARB_sync GL_ARB_texture_border_clamp GL_ARB_texture_buffer_object GL_ARB_texture_compression GL_ARB_texture_compression_rgtc GL_ARB_texture_cube_map GL_ARB_texture_env_add GL_ARB_texture_env_combine GL_ARB_texture_env_crossbar GL_ARB_texture_env_dot3 GL_ARB_texture_float GL_ARB_texture_mirrored_repeat GL_ARB_texture_multisample GL_ARB_texture_non_power_of_two GL_ARB_texture_rectangle GL_ARB_texture_rg GL_ARB_transpose_matrix GL_ARB_uniform_buffer_object GL_ARB_vertex_array_bgra GL_ARB_vertex_array_object GL_ARB_vertex_buffer_object GL_ARB_vertex_program GL_ARB_vertex_shader GL_ARB_window_pos GL_ATI_draw_buffers GL_ATI_texture_float GL_ATI_texture_mirror_once GL_S3_s3tc GL_EXT_texture_env_add GL_EXT_abgr GL_EXT_bgra GL_EXT_bindable_uniform GL_EXT_blend_color GL_EXT_blend_equation_separate GL_EXT_blend_func_separate GL_EXT_blend_minmax GL_EXT_blend_subtract GL_EXT_compiled_vertex_array GL_EXT_Cg_shader GL_EXT_depth_bounds_test GL_EXT_direct_state_access GL_EXT_draw_buffers2 GL_EXT_draw_instanced GL_EXT_draw_range_elements GL_EXT_fog_coord GL_EXT_framebuffer_blit GL_EXT_framebuffer_multisample GL_EXTX_framebuffer_mixed_formats GL_EXT_framebuffer_object GL_EXT_framebuffer_sRGB GL_EXT_geometry_shader4 GL_EXT_gpu_program_parameters GL_EXT_gpu_shader4 GL_EXT_multi_draw_arrays GL_EXT_packed_depth_stencil GL_EXT_packed_float GL_EXT_packed_pixels GL_EXT_pixel_buffer_object GL_EXT_point_parameters GL_EXT_provoking_vertex GL_EXT_rescale_normal GL_EXT_secondary_color GL_EXT_separate_shader_objects GL_EXT_separate_specular_color GL_EXT_shadow_funcs GL_EXT_stencil_two_side GL_EXT_stencil_wrap GL_EXT_texture3D GL_EXT_texture_array GL_EXT_texture_buffer_object GL_EXT_texture_compression_latc GL_EXT_texture_compression_rgtc GL_EXT_texture_compression_s3tc GL_EXT_texture_cube_map GL_EXT_texture_edge_clamp GL_EXT_texture_env_combine GL_EXT_texture_env_dot3 GL_EXT_texture_filter_anisotropic GL_EXT_texture_integer GL_EXT_texture_lod GL_EXT_texture_lod_bias GL_EXT_texture_mirror_clamp GL_EXT_texture_object GL_EXT_texture_shared_exponent GL_EXT_texture_sRGB GL_EXT_texture_swizzle GL_EXT_timer_query GL_EXT_transform_feedback2 GL_EXT_vertex_array GL_EXT_vertex_array_bgra GL_IBM_rasterpos_clip GL_IBM_texture_mirrored_repeat GL_KTX_buffer_region GL_NV_blend_square GL_NV_conditional_render GL_NV_copy_depth_to_color GL_NV_copy_image GL_NV_depth_buffer_float GL_NV_depth_clamp GL_NV_explicit_multisample GL_NV_fence GL_NV_float_buffer GL_NV_fog_distance GL_NV_fragment_program GL_NV_fragment_program_option GL_NV_fragment_program2 GL_NV_framebuffer_multisample_coverage GL_NV_geometry_shader4 GL_NV_gpu_program4 GL_NV_half_float GL_NV_light_max_exponent GL_NV_multisample_coverage GL_NV_multisample_filter_hint GL_NV_occlusion_query GL_NV_packed_depth_stencil GL_NV_parameter_buffer_object GL_NV_parameter_buffer_object2 GL_NV_pixel_data_range GL_NV_point_sprite GL_NV_primitive_restart GL_NV_register_combiners GL_NV_register_combiners2 GL_NV_shader_buffer_load GL_NV_texgen_reflection GL_NV_texture_barrier GL_NV_texture_compression_vtc GL_NV_texture_env_combine4 GL_NV_texture_expand_normal GL_NV_texture_rectangle GL_NV_texture_shader GL_NV_texture_shader2 GL_NV_texture_shader3 GL_NV_transform_feedback GL_NV_transform_feedback2 GL_NV_vertex_array_range GL_NV_vertex_array_range2 GL_NV_vertex_buffer_unified_memory GL_NV_vertex_program GL_NV_vertex_program1_1 GL_NV_vertex_program2 GL_NV_vertex_program2_option GL_NV_vertex_program3 GL_NVX_conditional_render GL_NVX_gpu_memory_info GL_SGIS_generate_mipmap GL_SGIS_texture_lod GL_SGIX_depth_texture GL_SGIX_shadow GL_SUN_slice_accum 21:37:54 T:3055097728 M:641064960 ERROR: GLX: Same window as before, refreshing context 21:37:54 T:3055097728 M:641064960 INFO: GL: Maximum texture width: 8192 21:37:54 T:3055097728 M:641064960 INFO: load default splash image: /usr/share/xbmc/media/Splash.png 21:37:54 T:3055097728 M:639827968 INFO: load keymapping 21:37:54 T:3055097728 M:639827968 INFO: Loading special://xbmc/system/keymaps/gamepad.xml 21:37:54 T:3055097728 M:639827968 INFO: Loading special://xbmc/system/keymaps/joystick.Alienware.Dual.Compatible.Controller.xml 21:37:54 T:3055097728 M:639827968 INFO: Loading special://xbmc/system/keymaps/joystick.AppleRemote.xml 21:37:54 T:3055097728 M:639827968 INFO: Loading special://xbmc/system/keymaps/joystick.Harmony.xml 21:37:54 T:3055097728 M:639827968 INFO: Loading special://xbmc/system/keymaps/joystick.Interact.AxisPad.xml 21:37:54 T:3055097728 M:639827968 INFO: Loading special://xbmc/system/keymaps/joystick.Logitech.RumblePad.2.xml 21:37:54 T:3055097728 M:639827968 INFO: Loading special://xbmc/system/keymaps/joystick.Microsoft.Xbox.360.Controller.xml 21:37:54 T:3055097728 M:639827968 INFO: Loading special://xbmc/system/keymaps/joystick.Microsoft.Xbox.Controller.S.xml 21:37:54 T:3055097728 M:639827968 INFO: Loading special://xbmc/system/keymaps/joystick.PS3.Remote.Keyboard.xml 21:37:54 T:3055097728 M:639827968 INFO: Loading special://xbmc/system/keymaps/joystick.Sony.PLAYSTATION(R)3.Controller.xml 21:37:54 T:3055097728 M:639827968 INFO: Loading special://xbmc/system/keymaps/joystick.WiiRemote.xml 21:37:54 T:3055097728 M:639827968 INFO: Loading special://xbmc/system/keymaps/keyboard.xml 21:37:54 T:3055097728 M:639827968 INFO: Loading special://xbmc/system/keymaps/remote.xml 21:37:54 T:3055097728 M:639827968 INFO: Loading special://xbmc/system/Lircmap.xml 21:37:54 T:3055097728 M:639827968 INFO: * Adding remote mapping for device 'mceusb' 21:37:54 T:3055097728 M:639827968 INFO: * Adding remote mapping for device 'XboxDVDDongle' 21:37:54 T:3055097728 M:639827968 INFO: * Adding remote mapping for device 'Microsoft_Xbox' 21:37:54 T:3055097728 M:639827968 INFO: * Adding remote mapping for device 'PinnacleSysPCTVRemote' 21:37:54 T:3055097728 M:639827968 INFO: * Adding remote mapping for device 'anysee' 21:37:54 T:3055097728 M:639827968 INFO: * Adding remote mapping for device 'iMON-PAD' 21:37:54 T:3055097728 M:639827968 INFO: * Adding remote mapping for device 'Antec_Veris_RM200' 21:37:54 T:3055097728 M:639827968 INFO: * Adding remote mapping for device 'MCE_via_iMON' 21:37:54 T:3055097728 M:639827968 INFO: * Adding remote mapping for device 'TwinHanRemote' 21:37:54 T:3055097728 M:639827968 INFO: * Adding remote mapping for device 'linux-input-layer' 21:37:54 T:3055097728 M:639827968 DEBUG: CButtonTranslator::Load - no userdata Lircmap.xml found, skipping 21:37:54 T:3055097728 M:639827968 INFO: GUI format 1360x768 1360x768 @ 60.00 - Full Screen 21:37:54 T:3055097728 M:639827968 DEBUG: Selected UDisks as storage provider 21:37:54 T:3055097728 M:639827968 DEBUG: DBus: Creating message to org.freedesktop.UDisks on /org/freedesktop/UDisks with interface org.freedesktop.DBus.Properties and method Get 21:37:54 T:3055097728 M:639827968 DEBUG: UDisks: DaemonVersion 1 21:37:54 T:3055097728 M:639827968 DEBUG: UDisks: Querying available devices 21:37:54 T:3055097728 M:639827968 DEBUG: DBus: Creating message to org.freedesktop.UDisks on /org/freedesktop/UDisks with interface org.freedesktop.UDisks and method EnumerateDevices 21:37:54 T:3055097728 M:639827968 DEBUG: UDisks: DeviceAdded (/org/freedesktop/UDisks/devices/sda5) 21:37:54 T:3055097728 M:639827968 DEBUG: DBus: Creating message to org.freedesktop.UDisks on /org/freedesktop/UDisks/devices/sda5 with interface org.freedesktop.DBus.Properties and method GetAll 21:37:54 T:3055097728 M:639827968 DEBUG: DBus: Creating message to org.freedesktop.UDisks on /org/freedesktop/UDisks/devices/sda with interface org.freedesktop.DBus.Properties and method Get 21:37:54 T:3055097728 M:639827968 DEBUG: UDisks: Is not able to mount DeviceUDI /org/freedesktop/UDisks/devices/sda5: IsFileSystem false HasFileSystem IsSystemInternal true IsMounted false IsRemovable false IsPartition true IsOptical false 21:37:54 T:3055097728 M:639827968 DEBUG: UDisks: DeviceAdded - DeviceUDI /org/freedesktop/UDisks/devices/sda5: IsFileSystem false HasFileSystem IsSystemInternal true IsMounted false IsRemovable false IsPartition true IsOptical false 21:37:54 T:3055097728 M:639827968 DEBUG: UDisks: DeviceAdded (/org/freedesktop/UDisks/devices/sda6) 21:37:54 T:3055097728 M:639827968 DEBUG: DBus: Creating message to org.freedesktop.UDisks on /org/freedesktop/UDisks/devices/sda6 with interface org.freedesktop.DBus.Properties and method GetAll 21:37:54 T:3055097728 M:639827968 DEBUG: DBus: Creating message to org.freedesktop.UDisks on /org/freedesktop/UDisks/devices/sda with interface org.freedesktop.DBus.Properties and method Get 21:37:54 T:3055097728 M:639827968 DEBUG: UDisks: Is not able to mount DeviceUDI /org/freedesktop/UDisks/devices/sda6: IsFileSystem true HasFileSystem ext4 IsSystemInternal true IsMounted true IsRemovable false IsPartition true IsOptical false 21:37:54 T:3055097728 M:639827968 DEBUG: UDisks: DeviceAdded - DeviceUDI /org/freedesktop/UDisks/devices/sda6: IsFileSystem true HasFileSystem ext4 IsSystemInternal true IsMounted true IsRemovable false IsPartition true IsOptical false 21:37:54 T:3055097728 M:639827968 NOTICE: UDisks: Added /home 21:37:54 T:3055097728 M:639827968 DEBUG: UDisks: DeviceAdded (/org/freedesktop/UDisks/devices/sda) 21:37:54 T:3055097728 M:639827968 DEBUG: DBus: Creating message to org.freedesktop.UDisks on /org/freedesktop/UDisks/devices/sda with interface org.freedesktop.DBus.Properties and method GetAll 21:37:54 T:3055097728 M:639827968 DEBUG: UDisks: Is not able to mount DeviceUDI /org/freedesktop/UDisks/devices/sda: IsFileSystem false HasFileSystem IsSystemInternal true IsMounted false IsRemovable false IsPartition false IsOptical false 21:37:54 T:3055097728 M:639827968 DEBUG: UDisks: DeviceAdded - DeviceUDI /org/freedesktop/UDisks/devices/sda: IsFileSystem false HasFileSystem IsSystemInternal true IsMounted false IsRemovable false IsPartition false IsOptical false 21:37:54 T:3055097728 M:639827968 DEBUG: UDisks: DeviceAdded (/org/freedesktop/UDisks/devices/sda1) 21:37:54 T:3055097728 M:639827968 DEBUG: DBus: Creating message to org.freedesktop.UDisks on /org/freedesktop/UDisks/devices/sda1 with interface org.freedesktop.DBus.Properties and method GetAll 21:37:54 T:3055097728 M:639827968 DEBUG: DBus: Creating message to org.freedesktop.UDisks on /org/freedesktop/UDisks/devices/sda with interface org.freedesktop.DBus.Properties and method Get 21:37:54 T:3055097728 M:639827968 DEBUG: UDisks: Is not able to mount DeviceUDI /org/freedesktop/UDisks/devices/sda1: IsFileSystem true HasFileSystem ext4 IsSystemInternal true IsMounted true IsRemovable false IsPartition true IsOptical false 21:37:54 T:3055097728 M:639827968 DEBUG: UDisks: DeviceAdded - DeviceUDI /org/freedesktop/UDisks/devices/sda1: IsFileSystem true HasFileSystem ext4 IsSystemInternal true IsMounted true IsRemovable false IsPartition true IsOptical false 21:37:54 T:3055097728 M:639827968 DEBUG: UDisks: DeviceAdded (/org/freedesktop/UDisks/devices/sda2) 21:37:54 T:3055097728 M:639827968 DEBUG: DBus: Creating message to org.freedesktop.UDisks on /org/freedesktop/UDisks/devices/sda2 with interface org.freedesktop.DBus.Properties and method GetAll 21:37:54 T:3055097728 M:639827968 DEBUG: DBus: Creating message to org.freedesktop.UDisks on /org/freedesktop/UDisks/devices/sda with interface org.freedesktop.DBus.Properties and method Get 21:37:54 T:3055097728 M:639827968 DEBUG: UDisks: Is not able to mount DeviceUDI /org/freedesktop/UDisks/devices/sda2: IsFileSystem true HasFileSystem ext4 IsSystemInternal true IsMounted false IsRemovable false IsPartition true IsOptical false 21:37:54 T:3055097728 M:639827968 DEBUG: UDisks: DeviceAdded - DeviceUDI /org/freedesktop/UDisks/devices/sda2: IsFileSystem true HasFileSystem ext4 IsSystemInternal true IsMounted false IsRemovable false IsPartition true IsOptical false 21:37:54 T:3055097728 M:639827968 DEBUG: UDisks: DeviceAdded (/org/freedesktop/UDisks/devices/sda3) 21:37:54 T:3055097728 M:639827968 DEBUG: DBus: Creating message to org.freedesktop.UDisks on /org/freedesktop/UDisks/devices/sda3 with interface org.freedesktop.DBus.Properties and method GetAll 21:37:54 T:3055097728 M:639827968 DEBUG: DBus: Creating message to org.freedesktop.UDisks on /org/freedesktop/UDisks/devices/sda with interface org.freedesktop.DBus.Properties and method Get 21:37:54 T:3055097728 M:639827968 DEBUG: UDisks: Is not able to mount DeviceUDI /org/freedesktop/UDisks/devices/sda3: IsFileSystem false HasFileSystem IsSystemInternal true IsMounted false IsRemovable false IsPartition true IsOptical false 21:37:54 T:3055097728 M:639827968 DEBUG: UDisks: DeviceAdded - DeviceUDI /org/freedesktop/UDisks/devices/sda3: IsFileSystem false HasFileSystem IsSystemInternal true IsMounted false IsRemovable false IsPartition true IsOptical false 21:37:54 T:3055097728 M:639827968 DEBUG: UDisks: DeviceAdded (/org/freedesktop/UDisks/devices/sda4) 21:37:54 T:3055097728 M:639827968 DEBUG: DBus: Creating message to org.freedesktop.UDisks on /org/freedesktop/UDisks/devices/sda4 with interface org.freedesktop.DBus.Properties and method GetAll 21:37:54 T:3055097728 M:639827968 DEBUG: DBus: Creating message to org.freedesktop.UDisks on /org/freedesktop/UDisks/devices/sda with interface org.freedesktop.DBus.Properties and method Get 21:37:54 T:3055097728 M:639827968 DEBUG: UDisks: Is not able to mount DeviceUDI /org/freedesktop/UDisks/devices/sda4: IsFileSystem true HasFileSystem ext4 IsSystemInternal true IsMounted false IsRemovable false IsPartition true IsOptical false 21:37:54 T:3055097728 M:639827968 DEBUG: UDisks: DeviceAdded - DeviceUDI /org/freedesktop/UDisks/devices/sda4: IsFileSystem true HasFileSystem ext4 IsSystemInternal true IsMounted false IsRemovable false IsPartition true IsOptical false 21:37:54 T:3055097728 M:639827968 DEBUG: UDisks: DeviceAdded (/org/freedesktop/UDisks/devices/sr0) 21:37:54 T:3055097728 M:639827968 DEBUG: DBus: Creating message to org.freedesktop.UDisks on /org/freedesktop/UDisks/devices/sr0 with interface org.freedesktop.DBus.Properties and method GetAll 21:37:54 T:3055097728 M:639791104 DEBUG: UDisks: Is not able to mount DeviceUDI /org/freedesktop/UDisks/devices/sr0: IsFileSystem false HasFileSystem IsSystemInternal false IsMounted false IsRemovable true IsPartition false IsOptical false 21:37:54 T:3055097728 M:639791104 DEBUG: UDisks: DeviceAdded - DeviceUDI /org/freedesktop/UDisks/devices/sr0: IsFileSystem false HasFileSystem IsSystemInternal false IsMounted false IsRemovable true IsPartition false IsOptical false 21:37:54 T:3055097728 M:639791104 NOTICE: start dvd mediatype detection 21:37:54 T:3055097728 M:639791104 NOTICE: initializing playlistplayer 21:37:54 T:3055097728 M:639791104 NOTICE: DONE initializing playlistplayer 21:37:54 T:3031890800 M:639791104 DEBUG: thread start, auto delete: 0 21:37:54 T:3031890800 M:639655936 DEBUG: Compiled with libcdio Version 0.81 21:37:54 T:3055097728 M:639655936 DEBUG: DPMS: supported power-saving modes: SUSPEND OFF STANDBY 21:37:54 T:3055097728 M:639688704 INFO: delete old skin... 21:37:55 T:3055097728 M:639688704 DEBUG: ------ Window Deinit (Pointer.xml) ------ 21:37:55 T:3055097728 M:639688704 DEBUG: ------ Window Deinit (DialogMuteBug.xml) ------ 21:37:55 T:3055097728 M:639688704 INFO: load skin from:/usr/share/xbmc/addons/skin.confluence 21:37:55 T:3055097728 M:639688704 INFO: Default 4:3 resolution directory is /usr/share/xbmc/addons/skin.confluence/720p 21:37:55 T:3055097728 M:639688704 INFO: Default 16:9 resolution directory is /usr/share/xbmc/addons/skin.confluence/720p 21:37:55 T:3055097728 M:639688704 INFO: Loading skin includes from /usr/share/xbmc/addons/skin.confluence/720p/includes.xml 21:37:55 T:3055097728 M:638799872 INFO: load fonts for skin... 21:37:55 T:3055097728 M:638799872 INFO: Loading fonts from /usr/share/xbmc/addons/skin.confluence/720p/Font.xml 21:37:55 T:3055097728 M:636133376 INFO: load new skin... 21:37:55 T:3055097728 M:636133376 INFO: Loading skin file: Home.xml 21:37:55 T:3055097728 M:634863616 DEBUG: Load Home.xml: 52.93ms 21:37:55 T:3055097728 M:634863616 INFO: Loading user windows, path /usr/share/xbmc/addons/skin.confluence/720p 21:37:55 T:3055097728 M:634863616 DEBUG: Load Skin XML: 75.67ms 21:37:55 T:3055097728 M:634863616 INFO: initialize new skin... 21:37:55 T:3055097728 M:634863616 INFO: Loading skin file: Pointer.xml 21:37:55 T:3055097728 M:634863616 DEBUG: Load Pointer.xml: 0.88ms 21:37:55 T:3055097728 M:634863616 DEBUG: Alloc resources: 3.68ms (1.03 ms skin load) 21:37:55 T:3055097728 M:634863616 INFO: Loading skin file: DialogVolumeBar.xml 21:37:55 T:3055097728 M:634863616 DEBUG: Load DialogVolumeBar.xml: 2.46ms 21:37:55 T:3055097728 M:634863616 DEBUG: Alloc resources: 2.79ms (2.64 ms skin load) 21:37:55 T:3055097728 M:634863616 INFO: Loading skin file: DialogSeekBar.xml 21:37:55 T:3055097728 M:634863616 DEBUG: Load DialogSeekBar.xml: 7.25ms 21:37:55 T:3055097728 M:634863616 DEBUG: Alloc resources: 7.81ms (7.64 ms skin load) 21:37:55 T:3055097728 M:634863616 INFO: Loading skin file: DialogKaiToast.xml 21:37:55 T:3055097728 M:634863616 DEBUG: Load DialogKaiToast.xml: 1.80ms 21:37:55 T:3055097728 M:634863616 DEBUG: Alloc resources: 1.97ms (1.97 ms skin load) 21:37:55 T:3055097728 M:634863616 INFO: Loading skin file: DialogMuteBug.xml 21:37:55 T:3055097728 M:634863616 DEBUG: Load DialogMuteBug.xml: 0.81ms 21:37:55 T:3055097728 M:634863616 DEBUG: Alloc resources: 0.98ms (0.98 ms skin load) 21:37:55 T:3055097728 M:634863616 INFO: Loading skin file: DialogVolumeBar.xml 21:37:55 T:3055097728 M:634863616 DEBUG: Load DialogVolumeBar.xml: 1.61ms 21:37:55 T:3055097728 M:634863616 INFO: Loading skin file: DialogKaiToast.xml 21:37:55 T:3055097728 M:634863616 DEBUG: Load DialogKaiToast.xml: 2.16ms 21:37:55 T:3055097728 M:634863616 INFO: Loading skin file: DialogSeekBar.xml 21:37:55 T:3055097728 M:634863616 DEBUG: Load DialogSeekBar.xml: 6.23ms 21:37:55 T:3055097728 M:634863616 INFO: Loading skin file: DialogBusy.xml 21:37:55 T:3055097728 M:634863616 DEBUG: Load DialogBusy.xml: 1.59ms 21:37:55 T:3055097728 M:634863616 INFO: Loading /usr/share/xbmc/addons/skin.confluence/sounds/sounds.xml 21:37:55 T:3055097728 M:634863616 INFO: skin loaded... 21:37:55 T:3055097728 M:634863616 DEBUG: Activating window ID: 12999 21:37:55 T:3055097728 M:634863616 DEBUG: Checking if window ID 12999 is locked. 21:37:55 T:3055097728 M:634863616 DEBUG: ------ Window Init (Startup.xml) ------ 21:37:55 T:3055097728 M:634863616 INFO: Loading skin file: Startup.xml 21:37:55 T:3055097728 M:634863616 DEBUG: Load Startup.xml: 2.45ms 21:37:55 T:3055097728 M:634863616 DEBUG: Alloc resources: 2.64ms (2.63 ms skin load) 21:37:55 T:3055097728 M:634863616 INFO: removing tempfiles 21:37:55 T:3055097728 M:634863616 NOTICE: initialize done 21:37:55 T:3055097728 M:634863616 NOTICE: Running the application... 21:37:55 T:3055097728 M:634863616 DEBUG: ExecuteXBMCAction : Translating SetFocus(10) 21:37:55 T:3055097728 M:634863616 DEBUG: ExecuteXBMCAction : To SetFocus(10) 21:37:55 T:3055097728 M:634863616 DEBUG: Process - no profile autoexec.py (/home/xbmc104/.xbmc/userdata/autoexec.py) found, skipping 21:37:55 T:3055097728 M:634863616 DEBUG: NetworkMessage - Starting network services 21:37:55 T:3055097728 M:634863616 NOTICE: ES: Starting event server 21:37:55 T:3055097728 M:634863616 NOTICE: DS: Starting dbus server 21:37:55 T:3043965808 M:634863616 DEBUG: thread start, auto delete: 0 21:37:55 T:3043965808 M:634863616 NOTICE: ES: Starting UDP Event server on 127.0.0.1:9777 21:37:55 T:3043965808 M:634863616 NOTICE: UDP: Listening on port 9777 21:37:55 T:3002067824 M:634728448 DEBUG: thread start, auto delete: 0 21:37:55 T:3002067824 M:634728448 INFO: JSONRPC Server: Successfully initialized 21:37:55 T:3043965808 M:634728448 DEBUG: CZeroconfAvahi::clientCallback: client is up and running 21:37:55 T:3010460528 M:634728448 DEBUG: thread start, auto delete: 0 21:37:55 T:3010460528 M:634728448 NOTICE: DS: Starting DBUS server in Run Application aka thread 21:37:55 T:3055097728 M:634728448 NOTICE: starting zeroconf publishing 21:37:55 T:3055097728 M:634728448 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.eventserver type: _xbmc-events._udp name:XBMC Event Server port:9777 21:37:55 T:3055097728 M:634728448 DEBUG: CZeroconfAvahi::addService() named: XBMC Event Server type: _xbmc-events._udp port:9777 21:37:55 T:3055097728 M:634728448 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.jsonrpc type: _xbmc-jsonrpc._tcp name:XBMC JSONRPC port:9090 21:37:55 T:3055097728 M:634728448 DEBUG: CZeroconfAvahi::addService() named: XBMC JSONRPC type: _xbmc-jsonrpc._tcp port:9090 21:37:55 T:3055097728 M:634728448 DEBUG: CLastfmScrobbler: Clearing session. 21:37:55 T:3055097728 M:634728448 DEBUG: CLibrefmScrobbler: Clearing session. 21:37:55 T:3055097728 M:634728448 DEBUG: new file set audiostream:0 21:37:55 T:3055097728 M:634728448 DEBUG: CPlayerCoreFactory::GetPlayers("") 21:37:55 T:3055097728 M:634728448 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules 21:37:55 T:3055097728 M:634728448 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules 21:37:55 T:3055097728 M:634728448 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtv 21:37:55 T:3055097728 M:634728448 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: hdhomerun/myth/rtmp/mms/udp 21:37:55 T:3055097728 M:634728448 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout 21:37:55 T:3055097728 M:634728448 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp 21:37:55 T:3055097728 M:634728448 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams 21:37:55 T:3055097728 M:634728448 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd 21:37:55 T:3055097728 M:634728448 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdfile 21:37:55 T:3055097728 M:634728448 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage 21:37:55 T:3055097728 M:634728448 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf 21:37:55 T:3055097728 M:634728448 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv 21:37:55 T:3055097728 M:634728448 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players 21:37:55 T:3055097728 M:634728448 DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (1) 21:37:55 T:3055097728 M:634728448 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0 21:37:55 T:3055097728 M:634728448 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1 21:37:55 T:3055097728 M:634728448 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: DVDPlayer (1) 21:37:55 T:3055097728 M:634728448 DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players 21:37:55 T:3055097728 M:633942016 NOTICE: DVDPlayer: Opening: "" 21:37:55 T:3055097728 M:633942016 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED 21:37:55 T:2984041328 M:633942016 DEBUG: thread start, auto delete: 0 21:37:55 T:2984041328 M:633942016 NOTICE: Creating InputStream 21:37:55 T:2984041328 M:633942016 ERROR: CDVDPlayer::OpenInputStream - error opening [""] 21:37:55 T:2984041328 M:633942016 NOTICE: CDVDPlayer::OnExit() 21:37:55 T:2984041328 M:633942016 NOTICE: CDVDPlayer::OnExit() deleting input stream 21:37:55 T:2984041328 M:633942016 DEBUG: Thread 2984041328 terminating 21:37:55 T:3055097728 M:633942016 DEBUG: CAnnouncementManager - Announcement: PlaybackStopped from xbmc 21:37:55 T:3055097728 M:633942016 ERROR: Playlist Player: skipping unplayable item: 0, path [""] 21:37:55 T:3055097728 M:633942016 DEBUG: Playlist Player: no more playable items... aborting playback 21:37:55 T:3055097728 M:633942016 INFO: GL: Enabling VSYNC 21:37:55 T:3055097728 M:633942016 INFO: GL: Selected vsync mode 2 21:37:55 T:2975648624 M:633839616 DEBUG: thread start, auto delete: 1 21:37:55 T:3055097728 M:634306560 DEBUG: ExecuteXBMCAction : Translating ReplaceWindow(Home) 21:37:55 T:3055097728 M:634306560 DEBUG: ExecuteXBMCAction : To ReplaceWindow(Home) 21:37:55 T:3055097728 M:634306560 DEBUG: Activating window ID: 10000 21:37:55 T:3055097728 M:634306560 DEBUG: Checking if window ID 10000 is locked. 21:37:55 T:3055097728 M:634306560 DEBUG: ------ Window Deinit (Startup.xml) ------ 21:37:55 T:3055097728 M:634306560 DEBUG: ------ Window Init (Home.xml) ------ 21:37:55 T:3055097728 M:634306560 DEBUG: Alloc resources: 1.76ms (0.00 ms skin load) 21:37:55 T:2964487024 M:634179584 DEBUG: thread start, auto delete: 1 21:37:55 T:2964487024 M:634179584 INFO: WEATHER: Downloading weather 21:37:55 T:2964487024 M:634179584 DEBUG: SECTION:LoadDLL(libcurl-gnutls.so.4) 21:37:55 T:2964487024 M:634179584 DEBUG: Loading: libcurl-gnutls.so.4 21:37:55 T:2964487024 M:634060800 DEBUG: FileCurl::Open(0xb0b260ec) http://xoap.weather.com/weather/local/USNY0996?cc=*&unit=m&dayf=4&prod=xoap&link=xoap&par=1004124588&key=079f24145f208494 21:37:55 T:2964487024 M:634060800 INFO: easy_aquire - Created session to http://xoap.weather.com 21:37:55 T:3055097728 M:633290752 NOTICE: CDVDPlayer::CloseFile() 21:37:55 T:3055097728 M:633290752 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED 21:37:55 T:3055097728 M:633290752 NOTICE: DVDPlayer: waiting for threads to exit 21:37:55 T:3055097728 M:633290752 NOTICE: DVDPlayer: finished waiting 21:37:55 T:2984041328 M:633282560 DEBUG: thread start, auto delete: 1 21:37:55 T:3028634480 M:631250944 DEBUG: thread start, auto delete: 0 21:37:55 T:3055097728 M:631250944 DEBUG: ExecuteXBMCAction : Translating SetFocus(9000) 21:37:55 T:3055097728 M:631250944 DEBUG: ExecuteXBMCAction : To SetFocus(9000) 21:37:55 T:3028634480 M:631250944 DEBUG: FileCurl::Open(0xb485311c) http://feeds.feedburner.com/xbmc 21:37:55 T:3028634480 M:631250944 INFO: easy_aquire - Created session to http://feeds.feedburner.com 21:37:55 T:2964487024 M:628076544 DEBUG: FileCurl::Close(0xb0b260ec) http://xoap.weather.com/weather/local/USNY0996?cc=*&unit=m&dayf=4&prod=xoap&link=xoap&par=1004124588&key=079f24145f208494 21:37:55 T:2964487024 M:627949568 INFO: WEATHER: Weather download successful 21:37:55 T:2964487024 M:627949568 DEBUG: GetZipList - Processing zip://special%3a%2f%2fxbmc%2fmedia%2fweather%2ezip/ 21:37:55 T:2975648624 M:627068928 DEBUG: DoWork - took 263 ms to load special://skin/backgrounds/videos.jpg 21:37:55 T:2984041328 M:629100544 DEBUG: DoWork - took 266 ms to load special://skin/backgrounds/videos.jpg 21:37:55 T:3028634480 M:626941952 DEBUG: FileCurl::Close(0xb485311c) http://feeds.feedburner.com/xbmc 21:37:55 T:3028634480 M:626941952 DEBUG: Got rss feed: http://feeds.feedburner.com/xbmc 21:37:55 T:3028634480 M:626941952 DEBUG: RSS feed encoding: UTF-8 21:37:55 T:3028634480 M:626941952 DEBUG: Parsed rss feed: http://feeds.feedburner.com/xbmc 21:37:55 T:3028634480 M:626941952 DEBUG: Thread 3028634480 terminating 21:37:55 T:3055097728 M:626941952 DEBUG: UPower: Recieved an unknown signal NameAcquired 21:37:56 T:2993675120 M:626941952 DEBUG: CZeroconfAvahi::groupCallback: Service successfully established 21:38:23 T:3055097728 M:626724864 DEBUG: Previous line repeats 1 times. 21:38:23 T:3055097728 M:626724864 DEBUG: SECTION:UnloadDelayed(DLL: libcrystalhd.so.3) 21:38:23 T:3055097728 M:626724864 DEBUG: Unloading: libcrystalhd.so.3 21:38:25 T:2975648624 M:626724864 DEBUG: Thread 2975648624 terminating (autodelete) 21:38:25 T:2984041328 M:626724864 DEBUG: Thread 2984041328 terminating (autodelete) 21:38:25 T:2964487024 M:626724864 DEBUG: Thread 2964487024 terminating (autodelete) 21:38:26 T:3055097728 M:626724864 DEBUG: SECTION:UnloadDelayed(DLL: special://xbmcbin/system/ImageLib-i486-linux.so) 21:38:26 T:3055097728 M:626724864 DEBUG: Unloading: ImageLib-i486-linux.so 21:38:26 T:3055097728 M:626724864 INFO: CheckIdle - Closing session to http://xoap.weather.com (easy=0x9691a98, multi=0x968c4a8) 21:38:26 T:3055097728 M:626724864 INFO: CheckIdle - Closing session to http://feeds.feedburner.com (easy=0x96423f8, multi=0x925c850) 21:38:27 T:3055097728 M:626753536 DEBUG: LIRC: Update - NEW at 33805:0200005200000000 00 KEY_UP MCE_via_iMON (KEY_UP) 21:38:27 T:3055097728 M:626753536 DEBUG: OnKey: 166 pressed, action is Up 21:38:27 T:3055097728 M:626753536 DEBUG: AERemap: Downmix normalization is enabled 21:38:27 T:3055097728 M:626753536 INFO: ==[Downmix Matrix]== 21:38:27 T:3055097728 M:626753536 INFO: FL = FL(1.0000) 21:38:27 T:3055097728 M:626753536 INFO: FR = FR(1.0000) 21:38:27 T:3055097728 M:626753536 INFO: ==================== 21:38:27 T:3055097728 M:626753536 INFO: CSoftAESound::Initialize - Sound Loaded: /usr/share/xbmc/addons/skin.confluence/sounds/cursor.wav 21:38:27 T:2964487024 M:626753536 DEBUG: thread start, auto delete: 1 21:38:27 T:2964487024 M:626753536 DEBUG: SECTION:LoadDLL(special://xbmcbin/system/ImageLib-i486-linux.so) 21:38:27 T:2964487024 M:626753536 DEBUG: Loading: /usr/lib/xbmc/system/ImageLib-i486-linux.so 21:38:27 T:2964487024 M:622813184 DEBUG: DoWork - took 171 ms to load special://skin/backgrounds/music.jpg 21:38:28 T:3055097728 M:622305280 DEBUG: LIRC: Update - NEW at 34543:0200004f00000000 00 KEY_RIGHT MCE_via_iMON (KEY_RIGHT) 21:38:28 T:3055097728 M:622305280 DEBUG: OnKey: 168 pressed, action is Right 21:38:29 T:3055097728 M:622301184 DEBUG: LIRC: Update - NEW at 35822:0200005100000000 00 KEY_DOWN MCE_via_iMON (KEY_DOWN) 21:38:29 T:3055097728 M:622301184 DEBUG: OnKey: 167 pressed, action is Down 21:38:31 T:3055097728 M:625991680 DEBUG: LIRC: Update - NEW at 38037:0200002800000000 00 #KEY_OK MCE_via_iMON (#KEY_OK) 21:38:31 T:3055097728 M:625991680 DEBUG: OnKey: 11 pressed, action is Select 21:38:31 T:3055097728 M:625991680 DEBUG: AERemap: Downmix normalization is enabled 21:38:31 T:3055097728 M:625991680 INFO: ==[Downmix Matrix]== 21:38:31 T:3055097728 M:625991680 INFO: FL = FL(1.0000) 21:38:31 T:3055097728 M:625991680 INFO: FR = FR(1.0000) 21:38:31 T:3055097728 M:625991680 INFO: ==================== 21:38:31 T:3055097728 M:625991680 INFO: CSoftAESound::Initialize - Sound Loaded: /usr/share/xbmc/addons/skin.confluence/sounds/click.wav 21:38:31 T:3055097728 M:625991680 DEBUG: ExecuteXBMCAction : Translating ActivateWindow(MusicLibrary,Albums,return) 21:38:31 T:3055097728 M:625991680 DEBUG: ExecuteXBMCAction : To ActivateWindow(MusicLibrary,Albums,return) 21:38:31 T:3055097728 M:625991680 DEBUG: Activating window ID: 10502 21:38:31 T:3055097728 M:625991680 DEBUG: Checking if window ID 10501 is locked. 21:38:31 T:3055097728 M:625991680 DEBUG: ------ Window Deinit (Home.xml) ------ 21:38:32 T:3055097728 M:625991680 DEBUG: ------ Window Init (MyMusicNav.xml) ------ 21:38:32 T:3055097728 M:625991680 INFO: Loading skin file: MyMusicNav.xml 21:38:32 T:3055097728 M:625102848 DEBUG: Load MyMusicNav.xml: 59.47ms 21:38:32 T:3055097728 M:625102848 DEBUG: Alloc resources: 63.77ms (60.95 ms skin load) 21:38:32 T:3055097728 M:625102848 DEBUG: CGUIMediaWindow::GetDirectory (musicdb://3/) 21:38:32 T:3055097728 M:625102848 DEBUG: ParentPath = [musicdb://3/] 21:38:32 T:3055097728 M:625102848 DEBUG: GetAlbumsByWhere query: select * from albumview where albumview.strAlbum <> '' 21:38:32 T:3055097728 M:624975872 DEBUG: Album format left = [%B] 21:38:32 T:3055097728 M:624975872 DEBUG: Album format right = [%A] 21:38:32 T:3055097728 M:624975872 DEBUG: Album format left = [%B] 21:38:32 T:3055097728 M:624975872 DEBUG: Album format right = [%A] 21:38:32 T:3055097728 M:624975872 DEBUG: Album format left = [%B] 21:38:32 T:3055097728 M:624975872 DEBUG: Album format right = [%A] 21:38:33 T:3055097728 M:620281856 DEBUG: LIRC: Update - NEW at 39841:0200005100000000 00 KEY_DOWN MCE_via_iMON (KEY_DOWN) 21:38:33 T:3055097728 M:620281856 DEBUG: OnKey: 167 pressed, action is Down 21:38:37 T:3055097728 M:620544000 DEBUG: Previous line repeats 5 times. 21:38:37 T:3055097728 M:620544000 DEBUG: LIRC: Update - NEW at 43607:0200005200000000 00 KEY_UP MCE_via_iMON (KEY_UP) 21:38:37 T:3055097728 M:620544000 DEBUG: OnKey: 166 pressed, action is Up 21:38:37 T:3055097728 M:620544000 DEBUG: LIRC: Update - NEW at 44089:0200005200000000 00 KEY_UP MCE_via_iMON (KEY_UP) 21:38:37 T:3055097728 M:620544000 DEBUG: OnKey: 166 pressed, action is Up 21:38:38 T:3055097728 M:620544000 DEBUG: LIRC: Update - NEW at 44607:0200002800000000 00 #KEY_OK MCE_via_iMON (#KEY_OK) 21:38:38 T:3055097728 M:620544000 DEBUG: OnKey: 11 pressed, action is Select 21:38:38 T:3055097728 M:620544000 DEBUG: CGUIMediaWindow::GetDirectory (musicdb://3/42/) 21:38:38 T:3055097728 M:620544000 DEBUG: ParentPath = [musicdb://3/] 21:38:38 T:2964487024 M:620544000 DEBUG: GetSongsByWhere query = select * from songview where (idAlbum=42) 21:38:38 T:2964487024 M:620544000 DEBUG: GetSongsByWhere(where (idAlbum=42) ) - took 7 ms 21:38:38 T:3055097728 M:620544000 DEBUG: Album format left = [%B] 21:38:38 T:3055097728 M:620544000 DEBUG: Album format right = [%A] 21:38:38 T:3055097728 M:620544000 DEBUG: Album format left = [%B] 21:38:38 T:3055097728 M:620544000 DEBUG: Album format right = [%A] 21:38:38 T:3055097728 M:620544000 DEBUG: Album format left = [%B] 21:38:38 T:3055097728 M:620544000 DEBUG: Album format right = [%A] 21:38:40 T:3055097728 M:620548096 DEBUG: LIRC: Update - NEW at 47022:0200005100000000 00 KEY_DOWN MCE_via_iMON (KEY_DOWN) 21:38:40 T:3055097728 M:620548096 DEBUG: OnKey: 167 pressed, action is Down 21:38:41 T:3055097728 M:620548096 DEBUG: LIRC: Update - NEW at 47606:0200005100000000 00 KEY_DOWN MCE_via_iMON (KEY_DOWN) 21:38:41 T:3055097728 M:620548096 DEBUG: OnKey: 167 pressed, action is Down 21:38:41 T:3055097728 M:620552192 DEBUG: LIRC: Update - NEW at 48088:0200005100000000 00 KEY_DOWN MCE_via_iMON (KEY_DOWN) 21:38:41 T:3055097728 M:620552192 DEBUG: OnKey: 167 pressed, action is Down 21:38:42 T:3055097728 M:620552192 DEBUG: LIRC: Update - NEW at 48589:0200002800000000 00 #KEY_OK MCE_via_iMON (#KEY_OK) 21:38:42 T:3055097728 M:620552192 DEBUG: OnKey: 11 pressed, action is Select 21:38:42 T:3055097728 M:620552192 DEBUG: SECTION:LoadDLL(libvorbisfile.so.3) 21:38:42 T:3055097728 M:620552192 DEBUG: Loading: libvorbisfile.so.3 21:38:49 T:3055097728 M:620576768 DEBUG: CFileSMB::Open - opened raid/Music/A Perfect Circle - Mer de Noms/A Perfect Circle - Judith.ogg, fd=10000 21:38:49 T:3055097728 M:620576768 DEBUG: CFileSMB::Close closing fd 10000 21:38:49 T:3055097728 M:620576768 DEBUG: new file set audiostream:0 21:38:49 T:3055097728 M:620576768 DEBUG: CPlayerCoreFactory::GetPlayers(musicdb://3/42/107.ogg) 21:38:49 T:3055097728 M:620576768 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules 21:38:49 T:3055097728 M:620576768 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules 21:38:49 T:3055097728 M:620576768 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtv 21:38:49 T:3055097728 M:620576768 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: hdhomerun/myth/rtmp/mms/udp 21:38:49 T:3055097728 M:620576768 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout 21:38:49 T:3055097728 M:620576768 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp 21:38:49 T:3055097728 M:620576768 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams 21:38:49 T:3055097728 M:620576768 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd 21:38:49 T:3055097728 M:620576768 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdfile 21:38:49 T:3055097728 M:620576768 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage 21:38:49 T:3055097728 M:620576768 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf 21:38:49 T:3055097728 M:620576768 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv 21:38:49 T:3055097728 M:620576768 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players 21:38:49 T:3055097728 M:620576768 DEBUG: CPlayerCoreFactory::GetPlayers: adding audiodefaultplayer (3) 21:38:49 T:3055097728 M:620576768 DEBUG: CPlayerCoreFactory::GetPlayers: for video=0, audio=1 21:38:49 T:3055097728 M:620576768 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: PAPlayer (3) 21:38:49 T:3055097728 M:620576768 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1 21:38:49 T:3055097728 M:620576768 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: DVDPlayer (1) 21:38:49 T:3055097728 M:620576768 DEBUG: CPlayerCoreFactory::GetPlayers: added 2 players 21:38:49 T:3055097728 M:620449792 DEBUG: CFileCache::Open - opening <3/42/107.ogg> using cache 21:38:49 T:3055097728 M:620449792 DEBUG: CFileSMB::Open - opened raid/Music/A Perfect Circle - Mer de Noms/A Perfect Circle - Judith.ogg, fd=10000 21:38:49 T:2984041328 M:620449792 DEBUG: thread start, auto delete: 0 21:38:50 T:2984041328 M:620314624 DEBUG: Process, request seek on source to 5853120 21:38:50 T:2984041328 M:620314624 INFO: CFileCache::Process - Hit eof. 21:38:50 T:2984041328 M:620314624 DEBUG: Process, request seek on source to 5787584 21:38:50 T:2984041328 M:620314624 INFO: CFileCache::Process - Hit eof. 21:38:50 T:2984041328 M:620314624 DEBUG: Process, request seek on source to 4294 21:38:50 T:2984041328 M:620314624 DEBUG: Thread 2984041328 terminating 21:38:50 T:3055097728 M:620314624 DEBUG: CFileSMB::Close closing fd 10000 21:38:50 T:3055097728 M:620314624 DEBUG: CFileCache::Open - opening <3/42/107.ogg> using cache 21:38:50 T:3055097728 M:620314624 DEBUG: CFileSMB::Open - opened raid/Music/A Perfect Circle - Mer de Noms/A Perfect Circle - Judith.ogg, fd=10000 21:38:50 T:2984041328 M:620314624 DEBUG: thread start, auto delete: 0 21:38:50 T:2984041328 M:620314624 DEBUG: Process, request seek on source to 5853120 21:38:50 T:2984041328 M:620314624 INFO: CFileCache::Process - Hit eof. 21:38:50 T:2984041328 M:620314624 DEBUG: Process, request seek on source to 5787584 21:38:50 T:2984041328 M:620314624 INFO: CFileCache::Process - Hit eof. 21:38:50 T:2984041328 M:620285952 DEBUG: Process, request seek on source to 4294 21:38:50 T:3055097728 M:620285952 INFO: CSoftAE::GetStream - AE_FMT_S16NE, 44100, 2, NULL 21:38:50 T:3055097728 M:620285952 WARNING: CAEUtil::GuessChLayout - This method should really never be used, please fix the code that called this 21:38:50 T:3055097728 M:620285952 DEBUG: AERemap: Downmix normalization is enabled 21:38:50 T:3055097728 M:620285952 INFO: ==[Downmix Matrix]== 21:38:50 T:3055097728 M:620285952 INFO: FL = FL(1.0000) 21:38:50 T:3055097728 M:620285952 INFO: FR = FR(1.0000) 21:38:50 T:3055097728 M:620285952 INFO: ==================== 21:38:50 T:3055097728 M:620285952 INFO: ==[Downmix Matrix]== 21:38:50 T:3055097728 M:620285952 INFO: FL = FL(1.0000) 21:38:50 T:3055097728 M:620285952 INFO: FR = FR(1.0000) 21:38:50 T:3055097728 M:620285952 INFO: ==================== 21:38:50 T:3055097728 M:620285952 DEBUG: CSoftAEStream::CSoftAEStream - Converting from AE_FMT_S16NE to AE_FMT_FLOAT 21:38:50 T:3055097728 M:620285952 DEBUG: CAnnouncementManager - Announcement: PlaybackStarted from xbmc 21:38:50 T:3055097728 M:620285952 DEBUG: ADDON: Dll Initializing - projectM 21:38:50 T:3055097728 M:620285952 DEBUG: SECTION:LoadDLL(/usr/lib/xbmc/addons/visualization.projectm/projectM.vis) 21:38:50 T:3055097728 M:620285952 DEBUG: Loading: /usr/lib/xbmc/addons/visualization.projectm/projectM.vis 21:38:50 T:3052358512 M:619524096 INFO: AudioDecoder: File is queued 21:38:50 T:3055097728 M:619778048 DEBUG: GetZipList - Processing zip://special%3a%2f%2fxbmc%2faddons%2fvisualization%2eprojectm%2fresources%2fpresets%2ezip/ 21:38:50 T:3055097728 M:619270144 DEBUG: Calling TransferSettings for: projectM 21:38:50 T:3055097728 M:619270144 DEBUG: Visualisation::Start() 21:38:50 T:3055097728 M:619270144 DEBUG: OnInitialize() started 21:38:50 T:3055097728 M:619270144 DEBUG: OnInitialize() done 21:38:50 T:3055097728 M:617865216 DEBUG: CGUIInfoManager::SetCurrentSong(musicdb://3/42/107.ogg) 21:38:50 T:3055097728 M:617738240 DEBUG: Loading additional tag info for file smb://bobb-files/raid/Music/A Perfect Circle - Mer de Noms/A Perfect Circle - Judith.ogg 21:38:50 T:3055097728 M:617611264 DEBUG: CFileSMB::Open - opened raid/Music/A Perfect Circle - Mer de Noms/A Perfect Circle - Judith.ogg, fd=10001 21:38:51 T:3055097728 M:617103360 DEBUG: CFileSMB::Close closing fd 10001 21:38:54 T:3055097728 M:613425152 DEBUG: LIRC: Update - NEW at 60392:800f845a000002ae 00 Teletext MCE_via_iMON (Teletext) 21:38:54 T:3055097728 M:613425152 DEBUG: OnKey: 213 pressed, action is FullScreen 21:38:54 T:3055097728 M:613425152 DEBUG: Activating window ID: 12006 21:38:54 T:3055097728 M:613425152 DEBUG: Checking if window ID 12006 is locked. 21:38:54 T:3055097728 M:613425152 DEBUG: ------ Window Deinit (MyMusicNav.xml) ------ 21:38:54 T:3055097728 M:613425152 DEBUG: FreeVisualisation() started 21:38:54 T:3055097728 M:613425152 INFO: ADDON: Dll Stopped - projectM 21:38:54 T:3055097728 M:613425152 INFO: ADDON: Dll Destroyed - projectM 21:38:54 T:3055097728 M:613425152 DEBUG: FreeVisualisation() done 21:38:54 T:3055097728 M:613425152 DEBUG: ------ Window Init (MusicVisualisation.xml) ------ 21:38:54 T:3055097728 M:613425152 INFO: Loading skin file: MusicVisualisation.xml 21:38:54 T:3055097728 M:613425152 DEBUG: Load MusicVisualisation.xml: 6.45ms 21:38:54 T:3055097728 M:613425152 DEBUG: Alloc resources: 6.74ms (6.63 ms skin load) 21:38:54 T:3055097728 M:613425152 DEBUG: ADDON: Dll Initializing - projectM 21:38:54 T:3055097728 M:612663296 DEBUG: Calling TransferSettings for: projectM 21:38:54 T:3055097728 M:612663296 DEBUG: Visualisation::Start() 21:38:54 T:3055097728 M:612663296 DEBUG: OnInitialize() started 21:38:54 T:3055097728 M:612663296 DEBUG: OnInitialize() done 21:38:55 T:3055097728 M:615337984 DEBUG: LIRC: Update - NEW at 62267:800f0426000002ae 00 Guide MCE_via_iMON (Guide) 21:38:55 T:3055097728 M:615337984 DEBUG: OnKey: 229 pressed, action is CodecInfo 21:38:56 T:3055097728 M:615337984 DEBUG: SECTION:UnloadDll(libcurl-gnutls.so.4) 21:38:56 T:3055097728 M:615337984 DEBUG: Unloading: libcurl-gnutls.so.4 21:38:58 T:3055097728 M:618893312 DEBUG: LIRC: Update - NEW at 64802:800f0426000002ae 00 Guide MCE_via_iMON (Guide) 21:38:58 T:3055097728 M:618893312 DEBUG: OnKey: 229 pressed, action is CodecInfo 21:39:00 T:3055097728 M:618766336 DEBUG: LIRC: Update - NEW at 66600:800f845a000002ae 00 Teletext MCE_via_iMON (Teletext) 21:39:00 T:3055097728 M:618766336 DEBUG: OnKey: 213 pressed, action is FullScreen 21:39:00 T:3055097728 M:618893312 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 21:39:00 T:3055097728 M:618893312 DEBUG: ------ Window Deinit (MusicVisualisation.xml) ------ 21:39:00 T:3055097728 M:618901504 DEBUG: FreeVisualisation() started 21:39:00 T:3055097728 M:618901504 INFO: ADDON: Dll Stopped - projectM 21:39:00 T:3055097728 M:618901504 INFO: ADDON: Dll Destroyed - projectM 21:39:00 T:3055097728 M:618901504 DEBUG: FreeVisualisation() done 21:39:00 T:3055097728 M:618901504 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 21:39:00 T:3055097728 M:618901504 DEBUG: ------ Window Init (MyMusicNav.xml) ------ 21:39:00 T:3055097728 M:618901504 INFO: Loading skin file: MyMusicNav.xml 21:39:00 T:3055097728 M:618147840 DEBUG: Load MyMusicNav.xml: 184.40ms 21:39:00 T:3055097728 M:618147840 DEBUG: Alloc resources: 187.64ms (185.76 ms skin load) 21:39:00 T:3055097728 M:618147840 DEBUG: CGUIMediaWindow::GetDirectory (musicdb://3/42/) 21:39:00 T:3055097728 M:618147840 DEBUG: ParentPath = [musicdb://3/42/] 21:39:00 T:3055097728 M:618147840 DEBUG: GetSongsByWhere query = select * from songview where (idAlbum=42) 21:39:00 T:3055097728 M:618147840 DEBUG: GetSongsByWhere(where (idAlbum=42) ) - took 5 ms 21:39:00 T:3055097728 M:618147840 DEBUG: Album format left = [%B] 21:39:00 T:3055097728 M:618147840 DEBUG: Album format right = [%A] 21:39:00 T:3055097728 M:618147840 DEBUG: Album format left = [%B] 21:39:00 T:3055097728 M:618147840 DEBUG: Album format right = [%A] 21:39:00 T:3055097728 M:618147840 DEBUG: Album format left = [%B] 21:39:00 T:3055097728 M:618147840 DEBUG: Album format right = [%A] 21:39:00 T:3055097728 M:618147840 DEBUG: ADDON: Dll Initializing - projectM 21:39:00 T:2964487024 M:613068800 DEBUG: DoWork - took 110 ms to load special://skin/backgrounds/music.jpg 21:39:00 T:3055097728 M:613068800 DEBUG: Calling TransferSettings for: projectM 21:39:00 T:3055097728 M:613068800 DEBUG: Visualisation::Start() 21:39:00 T:3055097728 M:613068800 DEBUG: OnInitialize() started 21:39:00 T:3055097728 M:613068800 DEBUG: OnInitialize() done 21:39:03 T:3055097728 M:608755712 DEBUG: LIRC: Update - NEW at 70173:800f8419000002ae 00 KEY_STOP MCE_via_iMON (KEY_STOP) 21:39:03 T:3055097728 M:608755712 DEBUG: OnKey: 224 pressed, action is Stop 21:39:03 T:2984041328 M:609771520 DEBUG: Thread 2984041328 terminating 21:39:03 T:3055097728 M:609771520 DEBUG: CFileSMB::Close closing fd 10000 21:39:03 T:3055097728 M:615358464 DEBUG: CAnnouncementManager - Announcement: PlaybackStopped from xbmc 21:39:03 T:3055097728 M:615358464 DEBUG: FreeVisualisation() started 21:39:03 T:3052358512 M:615358464 DEBUG: CSoftAEStream::~CSoftAEStream - Destructed 21:39:03 T:3055097728 M:615358464 INFO: ADDON: Dll Stopped - projectM 21:39:03 T:3055097728 M:615358464 INFO: ADDON: Dll Destroyed - projectM 21:39:03 T:3055097728 M:615358464 DEBUG: FreeVisualisation() done 21:39:03 T:3055097728 M:615747584 DEBUG: CAnnouncementManager - Announcement: PlaybackStopped from xbmc 21:39:04 T:2964487024 M:615747584 DEBUG: DoWork - Saving file state for audio item musicdb://3/42/107.ogg 21:39:09 T:3055097728 M:615763968 DEBUG: LIRC: Update - NEW at 75798:800f845b000002ae 00 Red MCE_via_iMON (Red) 21:39:09 T:3055097728 M:615763968 DEBUG: OnKey: 251 pressed, action is XBMC.ActivateWindow(Home) 21:39:09 T:3055097728 M:615763968 DEBUG: Activating window ID: 10000 21:39:09 T:3055097728 M:615763968 DEBUG: Checking if window ID 10000 is locked. 21:39:09 T:3055097728 M:615763968 DEBUG: ------ Window Deinit (MyMusicNav.xml) ------ 21:39:09 T:3055097728 M:615763968 DEBUG: ------ Window Init (Home.xml) ------ 21:39:09 T:3055097728 M:615763968 INFO: Loading skin file: Home.xml 21:39:09 T:3055097728 M:615763968 DEBUG: Load Home.xml: 213.04ms 21:39:09 T:3055097728 M:615763968 DEBUG: Alloc resources: 215.19ms (213.93 ms skin load) 21:39:10 T:3055097728 M:617160704 DEBUG: ExecuteXBMCAction : Translating SetFocus(9000) 21:39:10 T:3055097728 M:617160704 DEBUG: ExecuteXBMCAction : To SetFocus(9000) 21:39:11 T:3055097728 M:617164800 DEBUG: LIRC: Update - NEW at 78026:0200005000000000 00 KEY_LEFT MCE_via_iMON (KEY_LEFT) 21:39:11 T:3055097728 M:617164800 DEBUG: OnKey: 169 pressed, action is Left 21:39:13 T:3055097728 M:617168896 DEBUG: LIRC: Update - NEW at 80359:0200002800000000 00 #KEY_OK MCE_via_iMON (#KEY_OK) 21:39:13 T:3055097728 M:617168896 DEBUG: OnKey: 11 pressed, action is Select 21:39:14 T:3055097728 M:617168896 DEBUG: ExecuteXBMCAction : Translating ActivateWindow(ShutdownMenu) 21:39:14 T:3055097728 M:617168896 DEBUG: ExecuteXBMCAction : To ActivateWindow(ShutdownMenu) 21:39:14 T:3055097728 M:617168896 DEBUG: Activating window ID: 10111 21:39:14 T:3055097728 M:617168896 DEBUG: Checking if window ID 10111 is locked. 21:39:14 T:3055097728 M:617168896 DEBUG: ------ Window Init (DialogButtonMenu.xml) ------ 21:39:14 T:3055097728 M:617168896 INFO: Loading skin file: DialogButtonMenu.xml 21:39:14 T:3055097728 M:617168896 DEBUG: Load DialogButtonMenu.xml: 5.57ms 21:39:14 T:3055097728 M:617168896 DEBUG: Alloc resources: 11.56ms (6.11 ms skin load) 21:39:15 T:3055097728 M:617177088 DEBUG: LIRC: Update - NEW at 81465:0200005000000000 00 KEY_LEFT MCE_via_iMON (KEY_LEFT) 21:39:15 T:3055097728 M:617177088 DEBUG: OnKey: 169 pressed, action is Left 21:39:34 T:2964487024 M:616660992 DEBUG: Thread 2964487024 terminating (autodelete) 21:39:34 T:3055097728 M:616660992 DEBUG: SECTION:UnloadDelayed(DLL: libvorbisfile.so.3) 21:39:34 T:3055097728 M:616660992 DEBUG: Unloading: libvorbisfile.so.3 21:39:40 T:3055097728 M:616685568 DEBUG: SECTION:UnloadDelayed(DLL: special://xbmcbin/system/ImageLib-i486-linux.so) 21:39:40 T:3055097728 M:616685568 DEBUG: Unloading: ImageLib-i486-linux.so 21:39:45 T:3055097728 M:616685568 INFO: CSoftAESound::Deinitialize - Sound Unloaded: /usr/share/xbmc/addons/skin.confluence/sounds/click.wav