Project

General

Profile

Bug #338 » pastexbmc.log

Debug log - Gasman, 11/01/2015 01:25 PM

 
11:37:35 M: 56782848 NOTICE: -----------------------------------------------------------------------
11:37:35 M: 56762368 NOTICE: Starting XBMC4Xbox 3.5-r32977 (SVN:32977, compiler 1310). Built on Oct 14 2014
11:37:35 M: 56762368 NOTICE: special://xbmc/ is mapped to: Q:\
11:37:35 M: 56762368 NOTICE: special://masterprofile/ is mapped to: Q:\UserData
11:37:35 M: 56762368 NOTICE: special://home/ is mapped to: Q:\
11:37:35 M: 56762368 NOTICE: special://temp/ is mapped to: Z:\
11:37:35 M: 56762368 NOTICE: The executable running is: E:\Apps\XBMC4XBOX-3.5\default.xbe
11:37:35 M: 56762368 NOTICE: Log File is located: Q:\xbmc.log
11:37:35 M: 56762368 NOTICE: -----------------------------------------------------------------------
11:37:35 M: 56762368 NOTICE: Unmapped drive T
11:37:35 M: 56762368 NOTICE: Mapping drive T to Harddisk0\Partition1\Apps\XBMC4XBOX-3.5\UserData\
11:37:35 M: 56762368 NOTICE: Setup DirectX
11:37:35 M: 56733696 NOTICE: Mapping drive C to Harddisk0\Partition2
11:37:35 M: 56733696 NOTICE: Mapping drive E to Harddisk0\Partition1
11:37:35 M: 56733696 NOTICE: Unmapped drive D
11:37:35 M: 56733696 NOTICE: Mapping drive D to Cdrom0
11:37:35 M: 56733696 NOTICE: map extended drive F:
11:37:35 M: 56733696 NOTICE: Mapping drive F to Harddisk0\Partition6
11:37:35 M: 56733696 NOTICE: map extended drive R:
11:37:35 M: 56733696 NOTICE: Mapping drive R to Harddisk0\Partition8
11:37:35 M: 56733696 NOTICE: Mapping drive X to Harddisk0\Partition3
11:37:35 M: 56733696 NOTICE: Mapping drive Y to Harddisk0\Partition4
11:37:35 M: 56733696 NOTICE: Unmapped drive Z
11:37:35 M: 56733696 NOTICE: Mapping drive Z to Harddisk0\Partition5
11:37:35 M: 56733696 NOTICE: load settings...
11:37:35 M: 56733696 NOTICE: Mapping drive P to Harddisk0\Partition1\Apps\XBMC4XBOX-3.5\UserData\
11:37:35 M: 56733696 NOTICE: special://profile/ is mapped to: special://masterprofile/
11:37:35 M: 56733696 NOTICE: loading special://masterprofile/guisettings.xml
11:37:35 M: 56553472 NOTICE: Getting hardware information now...
11:37:35 M: 56553472 NOTICE: Checking resolution 10
11:37:35 M: 56553472 NOTICE: Setting autoresolution mode 6
11:37:35 M: 56553472 NOTICE: Loading player core factory settings from special://xbmc/system/playercorefactory.xml.
11:37:35 M: 56553472 NOTICE: Loaded playercorefactory configuration
11:37:35 M: 56532992 NOTICE: Loading player core factory settings from special://masterprofile/playercorefactory.xml.
11:37:35 M: 56532992 NOTICE: special://masterprofile/playercorefactory.xml does not exist. Skipping.
11:37:35 M: 56532992 NOTICE: Loaded advancedsettings.xml from special://profile/advancedsettings.xml
11:37:35 M: 56532992 NOTICE: Contents of special://profile/advancedsettings.xml are...
<advancedsettings>
<network>
<!-- Initially 5242880 -->
<cachemembuffersize>0</cachemembuffersize>
</network>
</advancedsettings>
11:37:35 M: 56532992 NOTICE: Getting hardware information now...
11:37:35 M: 56532992 NOTICE: Checking resolution 10
11:37:35 M: 56532992 NOTICE: Setting autoresolution mode 6
11:37:35 M: 56532992 NOTICE: Default Video Player: dvdplayer
11:37:35 M: 56532992 NOTICE: Default Audio Player: paplayer
11:37:35 M: 56532992 NOTICE: Log level changed to 2
11:37:35 M: 56532992 NOTICE: Enabled debug logging due to GUI setting (2)
11:37:35 M: 56532992 NOTICE: Per AV pack settings are off
11:37:35 M: 56672256 NOTICE: special://masterprofile/sources.xml
11:37:35 M: 56684544 INFO: load language info file:special://xbmc/language/English/langinfo.xml
11:37:35 M: 56684544 INFO: load keyboard layout configuration info file: Q:\language\english\keyboardmap.xml
11:37:35 M: 56684544 INFO: unable to load Q:\language\english\keyboardmap.xml: Failed to open file at line 0
11:37:35 M: 56684544 INFO: load English language file, from path: special://xbmc/language/
11:37:35 M: 56373248 DEBUG: POParser: loaded 2069 strings from file Q:\language\English\strings.po
11:37:35 M: 56463360 INFO: load keymapping
11:37:35 M: 56463360 DEBUG: CFileItemList::Sort, sorting took 0 millis
11:37:35 M: 56459264 INFO: Loading special://xbmc/system/keymaps/gamepad.xml
11:37:35 M: 56401920 INFO: Loading special://xbmc/system/keymaps/keyboard.xml
11:37:35 M: 56385536 INFO: Loading special://xbmc/system/keymaps/remote.xml
11:37:35 M: 56369152 INFO: Checking skin version of: Project Mayhem III
11:37:35 M: 56389632 INFO: Default 4:3 resolution directory is special://xbmc/skin/Project Mayhem III/PAL
11:37:35 M: 56369152 INFO: Default 16:9 resolution directory is special://xbmc/skin/Project Mayhem III/PAL16x9
11:37:35 M: 49168384 INFO: GUI format 720x576 PAL 4:3
11:37:36 M: 49176576 INFO: install unhandled exception filter
11:37:36 M: 49176576 INFO: creating subdirectories
11:37:36 M: 49176576 INFO: userdata folder: special://masterprofile/
11:37:36 M: 49176576 INFO: recording folder:
11:37:36 M: 49176576 INFO: screenshots folder: E:\Apps\XBMC4XBOX-3.5\web\
11:37:36 M: 49176576 INFO: thumbnails folder: special://masterprofile/Thumbnails
11:37:36 M: 49094656 ERROR: XFILE::CFile::Delete - Error deleting file Z:\dynamicxbox.umd
11:37:36 M: 49094656 ERROR: XFILE::CFile::Delete - Error deleting file Z:\controller_back.tga
11:37:36 M: 49094656 ERROR: XFILE::CFile::Delete - Error deleting file Z:\English\Music_Common.LS2
11:37:36 M: 49094656 ERROR: XFILE::CFile::Delete - Error deleting file Z:\English\Music_USA.LS2
11:37:36 M: 49094656 ERROR: XFILE::CFile::Delete - Error deleting file Z:\Music_Common.SS2
11:37:36 M: 49094656 ERROR: XFILE::CFile::Delete - Error deleting file Z:\Music_USA.SS2
11:37:36 M: 49094656 ERROR: XFILE::CFile::Delete - Error deleting file Z:\1_3_3.SS2
11:37:36 M: 49180672 ERROR: XFILE::CDirectory::Remove - Error removing Z:\English\
11:37:36 M: 49160192 DEBUG: CNetwork::SetupNetwork - Setting up network...
11:37:36 M: 49160192 NOTICE: Network: Using static IP settings
11:37:36 M: 48840704 NOTICE: Using idle thread with HLT (power saving)
11:37:36 M: 48828416 NOTICE: Checking the Date!
11:37:36 M: 48828416 INFO: Current Date is: 11-1-2015
11:37:36 M: 48828416 NOTICE: start dvd mediatype detection
11:37:36 M: 48762880 NOTICE: initializing playlistplayer
11:37:36 M: 48762880 DEBUG: Compiled with libcdio Version 0.72
11:37:36 M: 48762880 NOTICE: DONE initializing playlistplayer
11:37:36 M: 48762880 INFO: lcd not used
11:37:36 M: 48754688 NOTICE: load default skin:[Project Mayhem III]
11:37:36 M: 48754688 INFO: load skin from:Q:\skin\Project Mayhem III
11:37:36 M: 48754688 INFO: delete old skin...
11:37:36 M: 48754688 DEBUG: ------ Window Deinit (Pointer.xml) ------
11:37:36 M: 48754688 DEBUG: ------ Window Deinit (DialogMuteBug.xml) ------
11:37:36 M: 48754688 INFO: Default 4:3 resolution directory is Q:\skin\Project Mayhem III\PAL
11:37:36 M: 48754688 INFO: Default 16:9 resolution directory is Q:\skin\Project Mayhem III\PAL16x9
11:37:36 M: 48754688 INFO: Loading skin includes from Q:\skin\Project Mayhem III\PAL\includes.xml
11:37:36 M: 47325184 INFO: load fonts for skin...
11:37:36 M: 47357952 INFO: Loading fonts from Q:\skin\Project Mayhem III\PAL\Font.xml
11:37:36 M: 46911488 DEBUG: LocalizeStrings: no translation available in currently set gui language, at path Q:\skin\Project Mayhem III\language\english
11:37:36 M: 46911488 INFO: load new skin...
11:37:36 M: 46911488 INFO: Default 4:3 resolution directory is Q:\skin\Project Mayhem III\PAL
11:37:36 M: 46911488 INFO: Default 16:9 resolution directory is Q:\skin\Project Mayhem III\PAL16x9
11:37:36 M: 46911488 INFO: Loading skin file: Home.xml
11:37:37 M: 45977600 INFO: Loading user windows, path Q:\skin\Project Mayhem III\PAL
11:37:37 M: 45977600 INFO: Loading skin file: Q:\skin\Project Mayhem III\PAL\custom2_SkinSettings.xml
11:37:37 M: 45977600 DEBUG: Load Skin XML: 98.79ms
11:37:37 M: 45977600 INFO: initialize new skin...
11:37:37 M: 45977600 INFO: Loading skin file: Pointer.xml
11:37:37 M: 45944832 INFO: Loading skin file: DialogVolumeBar.xml
11:37:37 M: 45936640 INFO: Loading skin file: DialogSeekBar.xml
11:37:37 M: 45899776 INFO: Loading skin file: DialogKaiToast.xml
11:37:37 M: 45899776 INFO: Loading skin file: DialogMuteBug.xml
11:37:37 M: 45502464 INFO: Loading special://home/skin/Project Mayhem III/sounds/sounds.xml
11:37:37 M: 45502464 INFO: skin loaded...
11:37:37 M: 44535808 DEBUG: kernel32.dll fake function DisableThreadLibraryCalls called
11:37:37 M: 44462080 INFO: Loading skin file: DialogBusy.xml
11:37:37 M: 45060096 DEBUG: Activating window ID: 12999
11:37:37 M: 45060096 DEBUG: Checking if window ID 12999 is locked.
11:37:37 M: 44630016 DEBUG: ------ Window Init (Startup.xml) ------
11:37:37 M: 44630016 INFO: Loading skin file: Startup.xml
11:37:37 M: 44630016 INFO: removing tempfiles
11:37:37 M: 44630016 NOTICE: initialize done
11:37:37 M: 44609536 NOTICE: Running the application...
11:37:37 M: 44630016 DEBUG: XBPython::Process - no system autoexec.py (Q:\scripts\autoexec.py) found, skipping
11:37:37 M: 41615360 DEBUG: CApplication::ExecuteXBMCAction : Translating ReplaceWindow(Home)
11:37:37 M: 41615360 DEBUG: CApplication::ExecuteXBMCAction : To ReplaceWindow(Home)
11:37:37 M: 41615360 DEBUG: Activating window ID: 10000
11:37:37 M: 41615360 DEBUG: Checking if window ID 10000 is locked.
11:37:37 M: 41615360 DEBUG: ------ Window Deinit (Startup.xml) ------
11:37:38 M: 44621824 DEBUG: ------ Window Init (Home.xml) ------
11:37:38 M: 44408832 DEBUG: CNetwork::NetworkUp - Network service is up
11:37:38 M: 44408832 DEBUG: CRecentlyAddedJob::UpdateMusic() - Running RecentlyAdded home screen update
11:37:38 M: 44408832 INFO: CNetwork::LogState - Link: full duplex
11:37:38 M: 44388352 INFO: CNetwork::LogState - Link: 100 mbps
11:37:38 M: 44388352 INFO: CNetwork::LogState - State: dns
11:37:38 M: 44388352 INFO: CNetwork::LogState - State: static
11:37:38 M: 44388352 INFO: CNetwork::LogState - ip: 192.168.2.102
11:37:38 M: 44388352 INFO: CNetwork::LogState - subnet: 255.255.255.0
11:37:38 M: 44388352 INFO: CNetwork::LogState - gateway: 192.168.2.1
11:37:38 M: 44388352 INFO: CNetwork::LogState - dns: 194.168.4.100, 0.0.0.0
11:37:38 M: 40964096 DEBUG: GetRecentlyAddedAlbumSongs() query: SELECT songview.* FROM (SELECT idAlbum FROM albumview ORDER BY idAlbum DESC LIMIT 10) AS recentalbums JOIN songview ON songview.idAlbum=recentalbums.idAlbum
11:37:38 M: 41136128 DEBUG: CNetwork::NetworkMessage - Starting network services
11:37:38 M: 41115648 DEBUG: SECTION:Section SNTP loaded count:1 size:7036
11:37:38 M: 41115648 NOTICE: start timeserver client
11:37:38 M: 41050112 NOTICE: XBFileZilla: Starting...
11:37:38 M: 40984576 NOTICE: ES: Starting event server
11:37:38 M: 40448000 DEBUG: CLastfmScrobbler: Clearing session.
11:37:38 M: 40448000 NOTICE: ES: Starting UDP Event server on 0.0.0.0:9777
11:37:38 M: 40435712 DEBUG: CLibrefmScrobbler: Clearing session.
11:37:38 M: 39841792 NOTICE: UDP: Listening on port 9777
11:37:38 M: 39821312 DEBUG: CurlFile::Open(D03F189C) http://feeds.feedburner.com/xbmc4xbox
11:37:38 M: 39714816 INFO: XCURL::DllLibCurlGlobal::easy_aquire - Created session to http://feeds.feedburner.com
11:37:38 M: 39555072 INFO: WEATHER: Downloading weather
11:37:38 M: 39522304 DEBUG: CurlFile::Open(D03E0934) http://xml.weather.com/weather/local/UKXX0146?cc=*&unit=m&dayf=7&prod=xoap&link=xoap&par=1004124588&key=079f24145f208494
11:37:38 M: 39395328 INFO: XCURL::DllLibCurlGlobal::easy_aquire - Created session to http://xml.weather.com
11:37:38 M: 39206912 DEBUG: CMusicDatabase::GetRecentlyAddedAlbums query: select * from albumview order by idAlbum desc limit 10
11:37:38 M: 39260160 DEBUG: CRecentlyAddedJob::UpdateVideos() - Running RecentlyAdded home screen update
11:37:38 M: 39194624 DEBUG: Got rss feed: http://feeds.feedburner.com/xbmc4xbox
11:37:38 M: 39182336 DEBUG: RSS feed encoding: UTF-8
11:37:38 M: 39161856 DEBUG: Parsed rss feed: http://feeds.feedburner.com/xbmc4xbox
11:37:38 M: 39194624 DEBUG: CVideoDatabase::RunQuery took 1 ms for 0 items query: select * from movieview order by idMovie desc limit 10
11:37:38 M: 39161856 INFO: WEATHER: Weather download successful
11:37:38 M: 38522880 NOTICE: XBFileZilla: Started
11:37:38 M: 38477824 DEBUG: CVideoDatabase::RunQuery took 173 ms for 0 items query: select * from episodeview order by idEpisode desc limit 10
11:37:38 M: 38473728 DEBUG: CVideoDatabase::GetMusicVideosByWhere query = select * from musicvideoview order by idMVideo desc limit 10
11:37:38 M: 34148352 DEBUG: CVideoDatabase::GetMusicVideosByWhere time for actual SQL query = 7
11:37:38 M: 33927168 DEBUG: CRecentlyAddedJob::UpdateTotal() - Running RecentlyAdded home screen update
11:37:42 M: 38817792 DEBUG: POParser: loaded 51 weather tokens
11:37:42 M: 39026688 DEBUG: CApplication::OnKey: 167 pressed, action is Down
Previous line repeats 1 times.
11:37:44 M: 39030784 DEBUG: CApplication::OnKey: 11 pressed, action is Select
11:37:44 M: 39018496 DEBUG: CApplication::ExecuteXBMCAction : Translating ActivateWindow(MyMusic)
11:37:44 M: 39018496 DEBUG: CApplication::ExecuteXBMCAction : To ActivateWindow(MyMusic)
11:37:44 M: 39018496 DEBUG: Activating window ID: 10501
11:37:44 M: 39018496 DEBUG: Checking if window ID 10501 is locked.
11:37:44 M: 39018496 DEBUG: ------ Window Deinit (Home.xml) ------
11:37:44 M: 42434560 DEBUG: ------ Window Init (MyMusicSongs.xml) ------
11:37:44 M: 42438656 INFO: Loading skin file: MyMusicSongs.xml
11:37:45 M: 41545728 DEBUG: CGUIMediaWindow::GetDirectory ()
11:37:45 M: 41603072 DEBUG: ParentPath = []
11:37:45 M: 41603072 DEBUG: RetrieveMusicInfo() took 1 msec
11:37:45 M: 41607168 DEBUG: CFileItemList::Sort, sorting took 0 millis
11:37:46 M: 40161280 DEBUG: CApplication::OnKey: 167 pressed, action is Down
11:37:47 M: 40161280 DEBUG: CApplication::OnKey: 11 pressed, action is Select
11:37:47 M: 40148992 DEBUG: CGUIMediaWindow::GetDirectory (smb://DLINK323/Volume_1/Music/Music_Collection/)
11:37:47 M: 40148992 DEBUG: ParentPath = []
11:37:47 M: 39817216 DEBUG: XFILE::CSMBDirectory::OpenDir - Using authentication url smb://DLINK323/Volume%5f1/Music/Music%5fCollection
11:37:49 M: 39518208 DEBUG: ------ Window Init (DialogBusy.xml) ------
11:37:49 M: 39518208 INFO: Loading skin file: DialogBusy.xml
11:37:57 M: 39190528 DEBUG: CSmbFile::Open - opened Volume_1/Music/Music_Collection/WA-RP.pls, fd=10000
11:37:57 M: 39190528 DEBUG: CSmbFile::Close closing fd 10000
11:37:57 M: 39190528 DEBUG: CSmbFile::Open - opened Volume_1/Music/Music_Collection/radio.m3u, fd=10000
11:37:57 M: 39190528 DEBUG: CSmbFile::Close closing fd 10000
11:37:57 M: 39190528 DEBUG: CSmbFile::Open - opened Volume_1/Music/Music_Collection/Radio Paradise.pls, fd=10000
11:37:57 M: 39170048 DEBUG: CSmbFile::Close closing fd 10000
11:37:57 M: 39170048 DEBUG: Saving fileitems [smb://DLINK323/Volume_1/Music/Music_Collection/]
11:37:57 M: 39170048 DEBUG: -- items: 463, sort method: 0, ascending: false
11:37:57 M: 39174144 DEBUG: RetrieveMusicInfo() took 0 msec
11:37:58 M: 39075840 DEBUG: CFileItemList::Sort, sorting took 2 millis
11:37:58 M: 38494208 INFO: XCURL::DllLibCurlGlobal::CheckIdle - Closing session to http://feeds.feedburner.com (easy=00BCC010, multi=009F2980)
11:37:58 M: 38703104 INFO: XCURL::DllLibCurlGlobal::CheckIdle - Closing session to http://xml.weather.com (easy=00C1F010, multi=009F28E0)
11:37:58 M: 38989824 DEBUG: ------ Window Deinit (DialogBusy.xml) ------
11:38:00 M: 39129088 DEBUG: CApplication::OnKey: 167 pressed, action is Down
Previous line repeats 2 times.
11:38:01 M: 39129088 DEBUG: CApplication::OnKey: 11 pressed, action is Select
11:38:01 M: 39641088 DEBUG: CGUIMediaWindow::GetDirectory (smb://DLINK323/Volume_1/Music/Music_Collection/_Playlists/)
11:38:01 M: 39641088 DEBUG: ParentPath = [smb://DLINK323/Volume_1/Music/Music_Collection/]
11:38:01 M: 39641088 DEBUG: XFILE::CSMBDirectory::OpenDir - Using authentication url smb://DLINK323/Volume%5f1/Music/Music%5fCollection/%5fPlaylists
11:38:01 M: 39641088 DEBUG: CSmbFile::Open - opened Volume_1/Music/Music_Collection/_Playlists/Winamp.m3u, fd=10000
11:38:02 M: 39641088 DEBUG: CSmbFile::Close closing fd 10000
11:38:02 M: 39641088 DEBUG: CSmbFile::Open - opened Volume_1/Music/Music_Collection/_Playlists/Andy Radio Paradise.pls, fd=10000
11:38:02 M: 39641088 DEBUG: CSmbFile::Close closing fd 10000
11:38:02 M: 39641088 DEBUG: CSmbFile::Open - opened Volume_1/Music/Music_Collection/_Playlists/Groove Salad.pls, fd=10000
11:38:02 M: 39641088 DEBUG: CSmbFile::Close closing fd 10000
11:38:02 M: 39641088 DEBUG: CSmbFile::Open - opened Volume_1/Music/Music_Collection/_Playlists/Radio Paradise.m3u, fd=10000
11:38:02 M: 39641088 DEBUG: CSmbFile::Close closing fd 10000
11:38:02 M: 39641088 DEBUG: CSmbFile::Open - opened Volume_1/Music/Music_Collection/_Playlists/181.fm - The Eagle.m3u, fd=10000
11:38:02 M: 39641088 DEBUG: CSmbFile::Close closing fd 10000
11:38:02 M: 39641088 DEBUG: CSmbFile::Open - opened Volume_1/Music/Music_Collection/_Playlists/Live365.m3u, fd=10000
11:38:02 M: 39641088 DEBUG: CSmbFile::Close closing fd 10000
11:38:02 M: 39641088 DEBUG: CSmbFile::Open - opened Volume_1/Music/Music_Collection/_Playlists/Absolute 70s.pls, fd=10000
11:38:02 M: 39641088 DEBUG: CSmbFile::Close closing fd 10000
11:38:02 M: 39641088 DEBUG: CSmbFile::Open - opened Volume_1/Music/Music_Collection/_Playlists/Planet Rock.m3u, fd=10000
11:38:02 M: 39641088 DEBUG: CSmbFile::Close closing fd 10000
11:38:02 M: 39641088 DEBUG: CSmbFile::Open - opened Volume_1/Music/Music_Collection/_Playlists/Radio Paradise.strm, fd=10000
11:38:02 M: 39641088 DEBUG: CSmbFile::Close closing fd 10000
11:38:02 M: 39641088 DEBUG: CSmbFile::Open - opened Volume_1/Music/Music_Collection/_Playlists/WA-RP.pls, fd=10000
11:38:03 M: 39641088 DEBUG: CSmbFile::Close closing fd 10000
11:38:03 M: 39641088 DEBUG: CSmbFile::Open - opened Volume_1/Music/Music_Collection/_Playlists/Winamp.pls, fd=10000
11:38:03 M: 39641088 DEBUG: CSmbFile::Close closing fd 10000
11:38:03 M: 39641088 DEBUG: CSmbFile::Open - opened Volume_1/Music/Music_Collection/_Playlists/Radio Paradise All.m3u, fd=10000
11:38:03 M: 39641088 DEBUG: CSmbFile::Close closing fd 10000
11:38:03 M: 39641088 DEBUG: CSmbFile::Open - opened Volume_1/Music/Music_Collection/_Playlists/Absolute 80s.pls, fd=10000
11:38:03 M: 39624704 DEBUG: ------ Window Init (DialogBusy.xml) ------
11:38:03 M: 39624704 INFO: Loading skin file: DialogBusy.xml
11:38:04 M: 39485440 DEBUG: CSmbFile::Close closing fd 10000
11:38:04 M: 39485440 DEBUG: CSmbFile::Open - opened Volume_1/Music/Music_Collection/_Playlists/Absolute 90s.pls, fd=10000
11:38:04 M: 39485440 DEBUG: CSmbFile::Close closing fd 10000
11:38:04 M: 39485440 DEBUG: CSmbFile::Open - opened Volume_1/Music/Music_Collection/_Playlists/Absolute 60s.pls, fd=10000
11:38:04 M: 39485440 DEBUG: CSmbFile::Close closing fd 10000
11:38:04 M: 39485440 DEBUG: CSmbFile::Open - opened Volume_1/Music/Music_Collection/_Playlists/Absolute 70s LQ.pls, fd=10000
11:38:04 M: 39485440 DEBUG: CSmbFile::Close closing fd 10000
11:38:04 M: 39485440 DEBUG: Saving fileitems [smb://DLINK323/Volume_1/Music/Music_Collection/_Playlists/]
11:38:04 M: 39477248 DEBUG: -- items: 24, sort method: 0, ascending: false
11:38:04 M: 39936000 DEBUG: RetrieveMusicInfo() took 0 msec
11:38:04 M: 39940096 DEBUG: CFileItemList::Sort, sorting took 0 millis
11:38:05 M: 39186432 DEBUG: ------ Window Deinit (DialogBusy.xml) ------
11:38:06 M: 39325696 DEBUG: CApplication::OnKey: 167 pressed, action is Down
Previous line repeats 13 times.
11:38:13 M: 40919040 DEBUG: CApplication::OnKey: 195 pressed, action is Info
11:38:13 M: 40919040 DEBUG: CFileItem::LoadMusicTag: loading tag information for file: smb://DLINK323/Volume_1/Music/Music_Collection/_Playlists/Absolute 70s.pls
11:38:15 M: 40919040 DEBUG: CApplication::OnKey: 195 pressed, action is Info
11:38:15 M: 40919040 DEBUG: CFileItem::LoadMusicTag: loading tag information for file: smb://DLINK323/Volume_1/Music/Music_Collection/_Playlists/Absolute 70s.pls
11:38:21 M: 40919040 DEBUG: CApplication::OnKey: 229 pressed, action is ContextMenu
11:38:21 M: 40919040 DEBUG: CPlayerCoreFactory::GetPlayers(smb://DLINK323/Volume_1/Music/Music_Collection/_Playlists/Absolute 70s.pls)
11:38:21 M: 40919040 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: un-named
11:38:21 M: 40919040 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: un-named
11:38:21 M: 40919040 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtv
11:38:21 M: 40919040 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: hdhomerun/myth/rtmp/mms/udp
11:38:21 M: 40919040 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout
11:38:21 M: 40919040 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp
11:38:21 M: 40919040 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams
11:38:21 M: 40919040 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd
11:38:21 M: 40919040 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdfile
11:38:21 M: 40919040 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage
11:38:21 M: 40919040 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: ogv/flv/mov
11:38:21 M: 40919040 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv
11:38:21 M: 40919040 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players
11:38:21 M: 40919040 DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (1)
11:38:21 M: 40919040 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0
11:38:21 M: 40919040 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1
11:38:21 M: 40919040 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: DVDPlayer (1)
11:38:21 M: 40919040 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: MPlayer (2)
11:38:21 M: 40919040 DEBUG: CPlayerCoreFactory::GetPlayers: adding audiodefaultplayer (3)
11:38:21 M: 40919040 DEBUG: CPlayerCoreFactory::GetPlayers: for video=0, audio=1
11:38:21 M: 40919040 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: PAPlayer (3)
11:38:21 M: 40919040 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: MODPlayer (4)
11:38:21 M: 40919040 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1
11:38:21 M: 40919040 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: DVDPlayer (1)
11:38:21 M: 40919040 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: MPlayer (2)
11:38:21 M: 40919040 DEBUG: CPlayerCoreFactory::GetPlayers: added 4 players
11:38:21 M: 40919040 DEBUG: CFavourites::Load - no system favourites found, skipping
11:38:21 M: 40919040 INFO: Loading skin file: DialogContextMenu.xml
11:38:21 M: 40919040 DEBUG: ------ Window Init (DialogContextMenu.xml) ------
11:38:24 M: 40804352 DEBUG: CApplication::OnKey: 167 pressed, action is Down
11:38:25 M: 40804352 DEBUG: CApplication::OnKey: 11 pressed, action is Select
11:38:25 M: 40792064 DEBUG: ------ Window Deinit (DialogContextMenu.xml) ------
11:38:25 M: 40906752 DEBUG: CPlayerCoreFactory::GetPlayers(smb://DLINK323/Volume_1/Music/Music_Collection/_Playlists/Absolute 70s.pls)
11:38:25 M: 40906752 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: un-named
11:38:25 M: 40906752 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: un-named
11:38:25 M: 40906752 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtv
11:38:25 M: 40906752 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: hdhomerun/myth/rtmp/mms/udp
11:38:25 M: 40906752 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout
11:38:25 M: 40906752 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp
11:38:25 M: 40906752 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams
11:38:25 M: 40906752 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd
11:38:25 M: 40906752 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdfile
11:38:25 M: 40906752 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage
11:38:25 M: 40906752 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: ogv/flv/mov
11:38:25 M: 40906752 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv
11:38:25 M: 40906752 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players
11:38:25 M: 40906752 DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (1)
11:38:25 M: 40906752 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0
11:38:25 M: 40906752 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1
11:38:25 M: 40906752 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: DVDPlayer (1)
11:38:25 M: 40906752 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: MPlayer (2)
11:38:25 M: 40906752 DEBUG: CPlayerCoreFactory::GetPlayers: adding audiodefaultplayer (3)
11:38:25 M: 40906752 DEBUG: CPlayerCoreFactory::GetPlayers: for video=0, audio=1
11:38:25 M: 40906752 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: PAPlayer (3)
11:38:25 M: 40906752 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: MODPlayer (4)
11:38:25 M: 40906752 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1
11:38:25 M: 40906752 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: DVDPlayer (1)
11:38:25 M: 40906752 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: MPlayer (2)
11:38:25 M: 40906752 DEBUG: CPlayerCoreFactory::GetPlayers: added 4 players
11:38:25 M: 40906752 INFO: Loading skin file: DialogContextMenu.xml
11:38:25 M: 40906752 DEBUG: ------ Window Init (DialogContextMenu.xml) ------
11:38:31 M: 40804352 DEBUG: CApplication::OnKey: 11 pressed, action is Select
11:38:31 M: 40792064 DEBUG: ------ Window Deinit (DialogContextMenu.xml) ------
11:38:31 M: 40906752 DEBUG: CSmbFile::Open - opened Volume_1/Music/Music_Collection/_Playlists/Absolute 70s.pls, fd=10000
11:38:31 M: 40906752 DEBUG: CSmbFile::Close closing fd 10000
11:38:31 M: 40906752 DEBUG: CSmbFile::Open - opened Volume_1/Music/Music_Collection/_Playlists/Absolute 70s.pls, fd=10000
11:38:31 M: 40906752 DEBUG: CSmbFile::Close closing fd 10000
11:38:31 M: 40906752 DEBUG: CApplication::ProcessAndStartPlaylist(smb://DLINK323/Volume_1/Music/Music_Collection/_Playlists/Absolute 70s.pls, 0)
11:38:31 M: 40869888 INFO: XCURL::DllLibCurlGlobal::easy_aquire - Created session to http://mp3-a7-128.timlradio.co.uk
11:38:32 M: 40751104 DEBUG: CCurlFile::GetMimeType - http://mp3-a7-128.timlradio.co.uk/ -> audio/mpeg
11:38:32 M: 40751104 NOTICE: DVDPlayer: Opening: http://mp3-a7-128.timlradio.co.uk/
11:38:32 M: 40751104 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED
11:38:32 M: 40226816 NOTICE: Creating InputStream
11:38:32 M: 40226816 DEBUG: CFileCache::Open - opening <> using cache
11:38:32 M: 40226816 DEBUG: CurlFile::Open(01156EA0) http://mp3-a7-128.timlradio.co.uk/
11:38:33 M: 39923712 DEBUG: CCurlFile::Open - File <http://mp3-a7-128.timlradio.co.uk/> is a shoutcast stream. Re-opening
11:38:33 M: 39657472 DEBUG: File::Open - redirecting implementation for http://mp3-a7-128.timlradio.co.uk/
11:38:33 M: 40103936 ERROR: XFILE::CFileCache::Open - failed to open source <http://mp3-a7-128.timlradio.co.uk/>
11:38:33 M: 40103936 ERROR: CDVDPlayer::OpenInputStream - error opening [http://mp3-a7-128.timlradio.co.uk/]
11:38:33 M: 40103936 NOTICE: CDVDPlayer::OnExit()
11:38:33 M: 40103936 NOTICE: CDVDPlayer::OnExit() deleting input stream
11:38:33 M: 40103936 DEBUG: CApplication::OnPlayBackStopped - Playback was stopped
11:38:33 M: 40628224 ERROR: Playlist Player: skipping unplayable item: 0, path [http://mp3-a7-128.timlradio.co.uk/]
11:38:33 M: 40628224 DEBUG: Playlist Player: no more playable items... aborting playback
11:38:33 M: 40628224 NOTICE: CDVDPlayer::CloseFile()
11:38:33 M: 40628224 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED
11:38:33 M: 40628224 NOTICE: DVDPlayer: waiting for threads to exit
11:38:33 M: 40628224 NOTICE: DVDPlayer: finished waiting
11:38:43 M: 40640512 INFO: XCURL::DllLibCurlGlobal::CheckIdle - Closing session to http://mp3-a7-128.timlradio.co.uk (easy=00BCC010, multi=0112BA10)
(1-1/2)